X-Git-Url: https://osm.etsi.org/gitweb/?a=blobdiff_plain;f=lcm%2Fosm_lcm%2Flcm.py;h=2b62c1f4fd5bf4ef0016b756b900a40ff7837a0e;hb=54d9e2152d39930d6a7e43d25816671e56c91523;hp=ceabda5b80fef69b53699e4189a4e83f8b230a5a;hpb=1cf93af988c854bc7ac566f6961acbedbb849a96;p=osm%2FRO.git diff --git a/lcm/osm_lcm/lcm.py b/lcm/osm_lcm/lcm.py index ceabda5b..2b62c1f4 100644 --- a/lcm/osm_lcm/lcm.py +++ b/lcm/osm_lcm/lcm.py @@ -11,18 +11,20 @@ import msglocal import msgkafka import logging import functools +import sys from dbbase import DbException from fsbase import FsException from msgbase import MsgException from os import environ # from vca import DeployApplication, RemoveApplication from n2vc.vnf import N2VC -import os.path -import time +# import os.path +# import time from copy import deepcopy from http import HTTPStatus + class LcmException(Exception): pass @@ -35,8 +37,15 @@ class Lcm: :param config: two level dictionary with configuration. Top level should contain 'database', 'storage', :return: None """ + + self.db = None + self.msg = None + self.fs = None # contains created tasks/futures to be able to cancel - self.lcm_tasks = {} + + self.lcm_ns_tasks = {} + self.lcm_vim_tasks = {} + self.lcm_sdn_tasks = {} # logging self.logger = logging.getLogger('lcm') # load configuration @@ -127,11 +136,320 @@ class Lcm: self.logger.critical(str(e), exc_info=True) raise LcmException(str(e)) - def update_nsr_db(self, nsr_id, nsr_desc): + def update_db(self, item, _id, _desc): try: - self.db.replace("nsrs", nsr_id, nsr_desc) + self.db.replace(item, _id, _desc) except DbException as e: - self.logger.error("Updating nsr_id={}: {}".format(nsr_id, e)) + self.logger.error("Updating {} _id={}: {}".format(item, _id, e)) + + async def create_vim(self, vim_content, order_id): + vim_id = vim_content["_id"] + logging_text = "Task create_vim={} ".format(vim_id) + self.logger.debug(logging_text + "Enter") + db_vim = None + exc = None + try: + step = "Getting vim from db" + db_vim = self.db.get_one("vims", {"_id": vim_id}) + if "_admin" not in db_vim: + db_vim["_admin"] = {} + if "deploy" not in db_vim["_admin"]: + db_vim["_admin"]["deploy"] = {} + db_vim["_admin"]["deploy"]["RO"] = None + + step = "Creating vim at RO" + RO = ROclient.ROClient(self.loop, **self.ro_config) + vim_RO = deepcopy(vim_content) + vim_RO.pop("_id", None) + vim_RO.pop("_admin", None) + vim_RO.pop("schema_version", None) + vim_RO.pop("schema_type", None) + vim_RO.pop("vim_tenant_name", None) + vim_RO["type"] = vim_RO.pop("vim_type") + vim_RO.pop("vim_user", None) + vim_RO.pop("vim_password", None) + desc = await RO.create("vim", descriptor=vim_RO) + RO_vim_id = desc["uuid"] + db_vim["_admin"]["deploy"]["RO"] = RO_vim_id + self.update_db("vims", vim_id, db_vim) + + step = "Attach vim to RO tenant" + vim_RO = {"vim_tenant_name": vim_content["vim_tenant_name"], + "vim_username": vim_content["vim_user"], + "vim_password": vim_content["vim_password"], + "config": vim_content["config"] + } + desc = await RO.attach_datacenter(RO_vim_id , descriptor=vim_RO) + db_vim["_admin"]["operationalState"] = "ENABLED" + self.update_db("vims", vim_id, db_vim) + + self.logger.debug(logging_text + "Exit Ok RO_vim_id".format(RO_vim_id)) + return RO_vim_id + + except (ROclient.ROClientException, DbException) as e: + self.logger.error(logging_text + "Exit Exception {}".format(e)) + exc = e + except Exception as e: + self.logger.critical(logging_text + "Exit Exception {}".format(e), exc_info=True) + exc = e + finally: + if exc and db_vim: + db_vim["_admin"]["operationalState"] = "ERROR" + db_vim["_admin"]["detailed-status"] = "ERROR {}: {}".format(step , exc) + self.update_db("vims", vim_id, db_vim) + + async def edit_vim(self, vim_content, order_id): + vim_id = vim_content["_id"] + logging_text = "Task edit_vim={} ".format(vim_id) + self.logger.debug(logging_text + "Enter") + db_vim = None + exc = None + step = "Getting vim from db" + try: + db_vim = self.db.get_one("vims", {"_id": vim_id}) + if db_vim.get("_admin") and db_vim["_admin"].get("deploy") and db_vim["_admin"]["deploy"].get("RO"): + RO_vim_id = db_vim["_admin"]["deploy"]["RO"] + step = "Editing vim at RO" + RO = ROclient.ROClient(self.loop, **self.ro_config) + vim_RO = deepcopy(vim_content) + vim_RO.pop("_id", None) + vim_RO.pop("_admin", None) + vim_RO.pop("schema_version", None) + vim_RO.pop("schema_type", None) + vim_RO.pop("vim_tenant_name", None) + vim_RO["type"] = vim_RO.pop("vim_type") + vim_RO.pop("vim_user", None) + vim_RO.pop("vim_password", None) + if vim_RO: + desc = await RO.edit("vim", RO_vim_id, descriptor=vim_RO) + + step = "Editing vim-account at RO tenant" + vim_RO = {} + for k in ("vim_tenant_name", "vim_password", "config"): + if k in vim_content: + vim_RO[k] = vim_content[k] + if "vim_user" in vim_content: + vim_content["vim_username"] = vim_content["vim_user"] + if vim_RO: + desc = await RO.edit("vim_account", RO_vim_id, descriptor=vim_RO) + db_vim["_admin"]["operationalState"] = "ENABLED" + self.update_db("vims", vim_id, db_vim) + + self.logger.debug(logging_text + "Exit Ok RO_vim_id".format(RO_vim_id)) + return RO_vim_id + + except (ROclient.ROClientException, DbException) as e: + self.logger.error(logging_text + "Exit Exception {}".format(e)) + exc = e + except Exception as e: + self.logger.critical(logging_text + "Exit Exception {}".format(e), exc_info=True) + exc = e + finally: + if exc and db_vim: + db_vim["_admin"]["operationalState"] = "ERROR" + db_vim["_admin"]["detailed-status"] = "ERROR {}: {}".format(step , exc) + self.update_db("vims", vim_id, db_vim) + + async def delete_vim(self, vim_id, order_id): + logging_text = "Task delete_vim={} ".format(vim_id) + self.logger.debug(logging_text + "Enter") + db_vim = None + exc = None + step = "Getting vim from db" + try: + db_vim = self.db.get_one("vims", {"_id": vim_id}) + if db_vim.get("_admin") and db_vim["_admin"].get("deploy") and db_vim["_admin"]["deploy"].get("RO"): + RO_vim_id = db_vim["_admin"]["deploy"]["RO"] + RO = ROclient.ROClient(self.loop, **self.ro_config) + step = "Detaching vim from RO tenant" + try: + await RO.detach_datacenter(RO_vim_id) + except ROclient.ROClientException as e: + if e.http_code == 404: # not found + self.logger.debug(logging_text + "RO_vim_id={} already detached".format(RO_vim_id)) + else: + raise + + step = "Deleting vim from RO" + try: + await RO.delete("vim", RO_vim_id) + except ROclient.ROClientException as e: + if e.http_code == 404: # not found + self.logger.debug(logging_text + "RO_vim_id={} already deleted".format(RO_vim_id)) + else: + raise + else: + # nothing to delete + self.logger.error(logging_text + "Skipping. There is not RO information at database") + self.db.del_one("vims", {"_id": vim_id}) + self.logger.debug("delete_vim task vim_id={} Exit Ok".format(vim_id)) + return None + + except (ROclient.ROClientException, DbException) as e: + self.logger.error(logging_text + "Exit Exception {}".format(e)) + exc = e + except Exception as e: + self.logger.critical(logging_text + "Exit Exception {}".format(e), exc_info=True) + exc = e + finally: + if exc and db_vim: + db_vim["_admin"]["operationalState"] = "ERROR" + db_vim["_admin"]["detailed-status"] = "ERROR {}: {}".format(step , exc) + self.update_db("vims", vim_id, db_vim) + + async def create_sdn(self, sdn_content, order_id): + sdn_id = sdn_content["_id"] + logging_text = "Task create_sdn={} ".format(sdn_id) + self.logger.debug(logging_text + "Enter") + db_sdn = None + exc = None + try: + step = "Getting sdn from db" + db_sdn = self.db.get_one("sdns", {"_id": sdn_id}) + if "_admin" not in db_sdn: + db_sdn["_admin"] = {} + if "deploy" not in db_sdn["_admin"]: + db_sdn["_admin"]["deploy"] = {} + db_sdn["_admin"]["deploy"]["RO"] = None + + step = "Creating sdn at RO" + RO = ROclient.ROClient(self.loop, **self.ro_config) + sdn_RO = deepcopy(sdn_content) + sdn_RO.pop("_id", None) + sdn_RO.pop("_admin", None) + sdn_RO.pop("schema_version", None) + sdn_RO.pop("schema_type", None) + desc = await RO.create("sdn", descriptor=sdn_RO) + RO_sdn_id = desc["uuid"] + db_sdn["_admin"]["deploy"]["RO"] = RO_sdn_id + db_sdn["_admin"]["operationalState"] = "ENABLED" + self.update_db("sdns", sdn_id, db_sdn) + self.logger.debug(logging_text + "Exit Ok RO_sdn_id".format(RO_sdn_id)) + return RO_sdn_id + + except (ROclient.ROClientException, DbException) as e: + self.logger.error(logging_text + "Exit Exception {}".format(e)) + exc = e + except Exception as e: + self.logger.critical(logging_text + "Exit Exception {}".format(e), exc_info=True) + exc = e + finally: + if exc and db_sdn: + db_sdn["_admin"]["operationalState"] = "ERROR" + db_sdn["_admin"]["detailed-status"] = "ERROR {}: {}".format(step , exc) + self.update_db("sdns", sdn_id, db_sdn) + + async def edit_sdn(self, sdn_content, order_id): + sdn_id = sdn_content["_id"] + logging_text = "Task edit_sdn={} ".format(sdn_id) + self.logger.debug(logging_text + "Enter") + db_sdn = None + exc = None + step = "Getting sdn from db" + try: + db_sdn = self.db.get_one("sdns", {"_id": sdn_id}) + if db_sdn.get("_admin") and db_sdn["_admin"].get("deploy") and db_sdn["_admin"]["deploy"].get("RO"): + RO_sdn_id = db_sdn["_admin"]["deploy"]["RO"] + RO = ROclient.ROClient(self.loop, **self.ro_config) + step = "Editing sdn at RO" + sdn_RO = deepcopy(sdn_content) + sdn_RO.pop("_id", None) + sdn_RO.pop("_admin", None) + sdn_RO.pop("schema_version", None) + sdn_RO.pop("schema_type", None) + if sdn_RO: + desc = await RO.edit("sdn", RO_sdn_id, descriptor=sdn_RO) + db_sdn["_admin"]["operationalState"] = "ENABLED" + self.update_db("sdns", sdn_id, db_sdn) + + self.logger.debug(logging_text + "Exit Ok RO_sdn_id".format(RO_sdn_id)) + return RO_sdn_id + + except (ROclient.ROClientException, DbException) as e: + self.logger.error(logging_text + "Exit Exception {}".format(e)) + exc = e + except Exception as e: + self.logger.critical(logging_text + "Exit Exception {}".format(e), exc_info=True) + exc = e + finally: + if exc and db_sdn: + db_sdn["_admin"]["operationalState"] = "ERROR" + db_sdn["_admin"]["detailed-status"] = "ERROR {}: {}".format(step , exc) + self.update_db("sdns", sdn_id, db_sdn) + + async def delete_sdn(self, sdn_id, order_id): + logging_text = "Task delete_sdn={} ".format(sdn_id) + self.logger.debug(logging_text + "Enter") + db_sdn = None + exc = None + step = "Getting sdn from db" + try: + db_sdn = self.db.get_one("sdns", {"_id": sdn_id}) + if db_sdn.get("_admin") and db_sdn["_admin"].get("deploy") and db_sdn["_admin"]["deploy"].get("RO"): + RO_sdn_id = db_sdn["_admin"]["deploy"]["RO"] + RO = ROclient.ROClient(self.loop, **self.ro_config) + step = "Deleting sdn from RO" + try: + await RO.delete("sdn", RO_sdn_id) + except ROclient.ROClientException as e: + if e.http_code == 404: # not found + self.logger.debug(logging_text + "RO_sdn_id={} already deleted".format(RO_sdn_id)) + else: + raise + else: + # nothing to delete + self.logger.error(logging_text + "Skipping. There is not RO information at database") + self.db.del_one("sdns", {"_id": sdn_id}) + self.logger.debug("delete_sdn task sdn_id={} Exit Ok".format(sdn_id)) + return None + + except (ROclient.ROClientException, DbException) as e: + self.logger.error(logging_text + "Exit Exception {}".format(e)) + exc = e + except Exception as e: + self.logger.critical(logging_text + "Exit Exception {}".format(e), exc_info=True) + exc = e + finally: + if exc and db_sdn: + db_sdn["_admin"]["operationalState"] = "ERROR" + db_sdn["_admin"]["detailed-status"] = "ERROR {}: {}".format(step , exc) + self.update_db("sdns", sdn_id, db_sdn) + + def vnfd2RO(self, vnfd, new_id=None): + """ + Converts creates a new vnfd descriptor for RO base on input OSM IM vnfd + :param vnfd: input vnfd + :param new_id: overrides vnf id if provided + :return: copy of vnfd + """ + ci_file = None + try: + vnfd_RO = deepcopy(vnfd) + vnfd_RO.pop("_id", None) + vnfd_RO.pop("_admin", None) + if new_id: + vnfd_RO["id"] = new_id + for vdu in vnfd_RO["vdu"]: + if "cloud-init-file" in vdu: + base_folder = vnfd["_admin"]["storage"] + clout_init_file = "{}/{}/cloud_init/{}".format( + base_folder["folder"], + base_folder["pkg-dir"], + vdu["cloud-init-file"] + ) + ci_file = self.fs.file_open(clout_init_file, "r") + # TODO: detect if binary or text. Propose to read as binary and try to decode to utf8. If fails convert to base 64 or similar + clout_init_content = ci_file.read() + ci_file.close() + ci_file = None + vdu.pop("cloud-init-file", None) + vdu["cloud-init"] = clout_init_content + return vnfd_RO + except FsException as e: + raise LcmException("Error reading file at vnfd {}: {} ".format(vnfd["_id"], e)) + finally: + if ci_file: + ci_file.close() def n2vc_callback(self, model_name, application_name, workload_status, db_nsr, vnf_member_index, task=None): """Update the lcm database with the status of the charm. @@ -143,87 +461,80 @@ class Lcm: - active: The unit is deployed, configured, and ready - error: The charm has failed and needs attention. - terminated: The charm has been destroyed + - removing, + - removed Updates the network service's config-status to reflect the state of all charms. """ - - if not workload_status and not task: - self.logger.error("Task create_ns={} n2vc_callback Enter with bad parameters") - return - - if not workload_status: - self.logger.error("Task create_ns={} n2vc_callback Enter with bad parameters, no workload_status") - return - + nsr_id = None try: - self.logger.debug("[n2vc_callback] Workload status \"{}\"".format(workload_status)) nsr_id = db_nsr["_id"] nsr_lcm = db_nsr["_admin"]["deploy"] - nsr_lcm["VCA"][vnf_member_index]['operational-status'] = workload_status - if task: if task.cancelled(): + self.logger.debug("[n2vc_callback] create_ns={} vnf_index={} task Cancelled".format(nsr_id, vnf_member_index)) return if task.done(): exc = task.exception() if exc: - nsr_lcm = db_nsr["_admin"]["deploy"] - nsr_lcm["VCA"][vnf_member_index]['operational-status'] = "failed" - db_nsr["detailed-status"] = "fail configuring vnf_index={} {}".format(vnf_member_index, exc) - db_nsr["config-status"] = "failed" - self.update_nsr_db(nsr_id, db_nsr) + self.logger.error( + "[n2vc_callback] create_ns={} vnf_index={} task Exception={}".format(nsr_id, vnf_member_index, exc)) + nsr_lcm["VCA"][vnf_member_index]['operational-status'] = "error" + nsr_lcm["VCA"][vnf_member_index]['detailed-status'] = str(exc) + else: + self.logger.debug("[n2vc_callback] create_ns={} vnf_index={} task Done".format(nsr_id, vnf_member_index)) + # TODO it seams that task Done, but callback is still ongoing. For the moment comment this two lines + # nsr_lcm["VCA"][vnf_member_index]['operational-status'] = "active" + # nsr_lcm["VCA"][vnf_member_index]['detailed-status'] = "" + elif workload_status: + self.logger.debug("[n2vc_callback] create_ns={} vnf_index={} Enter workload_status={}".format(nsr_id, vnf_member_index, workload_status)) + if nsr_lcm["VCA"][vnf_member_index]['operational-status'] == workload_status: + return # same status, ignore + nsr_lcm["VCA"][vnf_member_index]['operational-status'] = workload_status + # TODO N2VC some error message in case of error should be obtained from N2VC + nsr_lcm["VCA"][vnf_member_index]['detailed-status'] = "" else: - vca_status = nsr_lcm["VCA"][vnf_member_index]['operational-status'] - - units = len(nsr_lcm["VCA"]) - active = 0 - statusmap = {} - for vnf_index in nsr_lcm["VCA"]: - if vca_status not in statusmap: - # Initialize it - statusmap[vca_status] = 0 - - statusmap[vca_status] += 1 + self.logger.critical("[n2vc_callback] create_ns={} vnf_index={} Enter with bad parameters".format(nsr_id, vnf_member_index), exc_info=True) + return - if vca_status == "active": - active += 1 + some_failed = False + all_active = True + status_map = {} + for vnf_index, vca_info in nsr_lcm["VCA"].items(): + vca_status = vca_info["operational-status"] + if vca_status not in status_map: + # Initialize it + status_map[vca_status] = 0 + status_map[vca_status] += 1 + + if vca_status != "active": + all_active = False + if vca_status == "error": + some_failed = True + db_nsr["config-status"] = "failed" + db_nsr["detailed-status"] = "fail configuring vnf_index={} {}".format(vnf_member_index, + vca_info["detailed-status"]) + break - cs = "" - for status in statusmap: - cs += "{} ({}) ".format(status, statusmap[status]) + if all_active: + self.logger.debug("[n2vc_callback] create_ns={} vnf_index={} All active".format(nsr_id, vnf_member_index)) + db_nsr["config-status"] = "configured" + db_nsr["detailed-status"] = "done" + elif some_failed: + pass + else: + cs = "configuring: " + separator = "" + for status, num in status_map.items(): + cs += separator + "{}: {}".format(status, num) + separator = ", " db_nsr["config-status"] = cs - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) except Exception as e: - # self.logger.critical("Task create_ns={} n2vc_callback Exception {}".format(nsr_id, e), exc_info=True) - self.logger.critical("Task create_ns n2vc_callback Exception {}".format(e), exc_info=True) - pass - - def vca_deploy_callback(self, db_nsr, vnf_index, status, task): - # TODO study using this callback when VCA.DeployApplication success from VCAMonitor - # By the moment this callback is used only to capture exception conditions from VCA DeployApplication - nsr_id = db_nsr["_id"] - self.logger.debug("Task create_ns={} vca_deploy_callback Enter".format(nsr_id)) - try: - if task.cancelled(): - return - if task.done(): - exc = task.exception() - if exc: - nsr_lcm = db_nsr["_admin"]["deploy"] - nsr_lcm["VCA"][vnf_index]['operational-status'] = "failed" - db_nsr["detailed-status"] = "fail configuring vnf_index={} {}".format(vnf_index, exc) - db_nsr["config-status"] = "failed" - self.update_nsr_db(nsr_id, db_nsr) - else: - # TODO may be used to be called when VCA monitor status changes - pass - # except DbException as e: - # self.logger.error("Task create_ns={} vca_deploy_callback Exception {}".format(nsr_id, e)) - except Exception as e: - self.logger.critical("Task create_ns={} vca_deploy_callback Exception {}".format(nsr_id, e), exc_info=True) + self.logger.critical("[n2vc_callback] create_ns={} vnf_index={} Exception {}".format(nsr_id, vnf_member_index, e), exc_info=True) async def create_ns(self, nsr_id, order_id): logging_text = "Task create_ns={} ".format(nsr_id) @@ -235,6 +546,7 @@ class Lcm: try: db_nsr = self.db.get_one("nsrs", {"_id": nsr_id}) nsd = db_nsr["nsd"] + nsr_name = db_nsr["name"] # TODO short-name?? needed_vnfd = {} for c_vnf in nsd["constituent-vnfd"]: vnfd_id = c_vnf["vnfd-id-ref"] @@ -269,13 +581,10 @@ class Lcm: self.logger.debug(logging_text + "RO vnfd={} exist. Using RO_id={}".format( vnfd_id, vnfd_list[0]["uuid"])) else: - vnfd_RO = deepcopy(vnfd) - vnfd_RO.pop("_id", None) - vnfd_RO.pop("_admin", None) - vnfd_RO["id"] = vnfd_id_RO + vnfd_RO = self.vnfd2RO(vnfd, vnfd_id_RO) desc = await RO.create("vnfd", descriptor=vnfd_RO) nsr_lcm["RO"]["vnfd_id"][vnfd_id] = desc["uuid"] - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) # create nsd at RO nsd_id = nsd["id"] @@ -298,7 +607,7 @@ class Lcm: c_vnf["vnfd-id-ref"] = nsr_id + "." + vnfd_id[:200] desc = await RO.create("nsd", descriptor=nsd_RO) nsr_lcm["RO"]["nsd_id"] = desc["uuid"] - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) # Crate ns at RO # if present use it unless in error status @@ -329,7 +638,7 @@ class Lcm: scenario=nsr_lcm["RO"]["nsd_id"]) RO_nsr_id = nsr_lcm["RO"]["nsr_id"] = desc["uuid"] nsr_lcm["RO"]["nsr_status"] = "BUILD" - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) # wait until NS is ready step = ns_status_detailed = "Waiting ns ready at RO" @@ -344,7 +653,7 @@ class Lcm: raise ROclient.ROClientException(ns_status_info) elif ns_status == "BUILD": db_nsr["detailed-status"] = ns_status_detailed + "; {}".format(ns_status_info) - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) elif ns_status == "ACTIVE": nsr_lcm["nsr_ip"] = RO.get_ns_vnf_ip(desc) break @@ -356,77 +665,124 @@ class Lcm: if deloyment_timeout <= 0: raise ROclient.ROClientException("Timeout waiting ns to be ready") db_nsr["detailed-status"] = "Configuring vnfr" - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) + + # The parameters we'll need to deploy a charm + number_to_configure = 0 + + def deploy(): + """An inner function to deploy the charm from either vnf or vdu + """ + + # Login to the VCA. + # if number_to_configure == 0: + # self.logger.debug("Logging into N2VC...") + # task = asyncio.ensure_future(self.n2vc.login()) + # yield from asyncio.wait_for(task, 30.0) + # self.logger.debug("Logged into N2VC!") + + ## await self.n2vc.login() + + # Note: The charm needs to exist on disk at the location + # specified by charm_path. + base_folder = vnfd["_admin"]["storage"] + storage_params = self.fs.get_params() + charm_path = "{}{}/{}/charms/{}".format( + storage_params["path"], + base_folder["folder"], + base_folder["pkg-dir"], + proxy_charm + ) + + # Setup the runtime parameters for this VNF + params['rw_mgmt_ip'] = nsr_lcm['nsr_ip'][vnf_index] + + # ns_name will be ignored in the current version of N2VC + # but will be implemented for the next point release. + model_name = 'default' + application_name = self.n2vc.FormatApplicationName( + nsr_name, + vnf_index, + vnfd['name'], + ) + + nsr_lcm["VCA"][vnf_index] = { + "model": model_name, + "application": application_name, + "operational-status": "init", + "detailed-status": "", + "vnfd_id": vnfd_id, + } + + self.logger.debug("Task create_ns={} Passing artifacts path '{}' for {}".format(nsr_id, charm_path, proxy_charm)) + task = asyncio.ensure_future( + self.n2vc.DeployCharms( + model_name, # The network service name + application_name, # The application name + vnfd, # The vnf descriptor + charm_path, # Path to charm + params, # Runtime params, like mgmt ip + {}, # for native charms only + self.n2vc_callback, # Callback for status changes + db_nsr, # Callback parameter + vnf_index, # Callback parameter + None, # Callback parameter (task) + ) + ) + task.add_done_callback(functools.partial(self.n2vc_callback, model_name, application_name, None, db_nsr, vnf_index)) + self.lcm_ns_tasks[nsr_id][order_id]["create_charm:" + vnf_index] = task + + # TODO: Make this call inside deploy() + # Login to the VCA. If there are multiple calls to login(), + # subsequent calls will be a nop and return immediately. + await self.n2vc.login() - vnfd_to_config = 0 step = "Looking for needed vnfd to configure" self.logger.debug(logging_text + step) for c_vnf in nsd["constituent-vnfd"]: vnfd_id = c_vnf["vnfd-id-ref"] vnf_index = str(c_vnf["member-vnf-index"]) vnfd = needed_vnfd[vnfd_id] - if vnfd.get("vnf-configuration") and vnfd["vnf-configuration"].get("juju"): - vnfd_to_config += 1 - proxy_charm = vnfd["vnf-configuration"]["juju"]["charm"] - # Note: The charm needs to exist on disk at the location - # specified by charm_path. - base_folder = vnfd["_admin"]["storage"] - charm_path = "{}{}/{}/charms/{}".format( - base_folder["path"], - base_folder["folder"], - base_folder["file"], - proxy_charm - ) + # Check if this VNF has a charm configuration + vnf_config = vnfd.get("vnf-configuration") - # Setup the runtime parameters for this VNF - params = { - 'rw_mgmt_ip': nsr_lcm['nsr_ip'][vnf_index], - } - - # ns_name will be ignored in the current version of N2VC - # but will be implemented for the next point release. - ns_name = 'default' - application_name = self.n2vc.FormatApplicationName( - 'default', - vnfd['name'], - vnf_index, - ) + if vnf_config and vnf_config.get("juju"): + proxy_charm = vnf_config["juju"]["charm"] + params = {} - nsr_lcm["VCA"][vnf_index] = { - "model": ns_name, - "application": application_name, - "operational-status": "init", - "vnfd_id": vnfd_id, - } - - self.logger.debug("Passing artifacts path '{}' for {}".format(charm_path, proxy_charm)) - task = asyncio.ensure_future( - self.n2vc.DeployCharms( - ns_name, # The network service name - application_name, # The application name - vnfd, # The vnf descriptor - charm_path, # Path to charm - params, # Runtime params, like mgmt ip - {}, # for native charms only - self.n2vc_callback, # Callback for status changes - db_nsr, # Callback parameter - vnf_index, # Callback parameter - None, # Callback parameter (task) - ) - ) - task.add_done_callback(functools.partial(self.n2vc_callback, None, None, None, None, db_nsr)) + if proxy_charm: + if 'initial-config-primitive' in vnf_config: + params['initial-config-primitive'] = vnf_config['initial-config-primitive'] + + deploy() + number_to_configure += 1 - self.lcm_tasks[nsr_id][order_id]["create_charm:" + vnf_index] = task - db_nsr["config-status"] = "configuring" if vnfd_to_config else "configured" - db_nsr["detailed-status"] = "Configuring 1/{}".format(vnfd_to_config) if vnfd_to_config else "done" + # Deploy charms for each VDU that supports one. + for vdu in vnfd['vdu']: + vdu_config = vdu.get('vdu-configuration') + proxy_charm = None + params = {} + + if vdu_config and vdu_config.get("juju"): + proxy_charm = vdu_config["juju"]["charm"] + + if 'initial-config-primitive' in vdu_config: + params['initial-config-primitive'] = vdu_config['initial-config-primitive'] + + if proxy_charm: + deploy() + number_to_configure += 1 + + db_nsr["config-status"] = "configuring" if number_to_configure else "configured" + db_nsr["detailed-status"] = "configuring: init: {}".format(number_to_configure) if number_to_configure else "done" db_nsr["operational-status"] = "running" - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) - self.logger.debug("create_ns task nsr_id={} Exit Ok".format(nsr_id)) + self.logger.debug("Task create_ns={} Exit Ok".format(nsr_id)) return nsr_lcm - except (ROclient.ROClientException, DbException) as e: + except (ROclient.ROClientException, DbException, LcmException) as e: self.logger.error(logging_text + "Exit Exception {}".format(e)) exc = e except Exception as e: @@ -436,7 +792,7 @@ class Lcm: if exc and db_nsr: db_nsr["detailed-status"] = "ERROR {}: {}".format(step , exc) db_nsr["operational-status"] = "failed" - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) async def delete_ns(self, nsr_id, order_id): logging_text = "Task delete_ns={} ".format(nsr_id) @@ -449,13 +805,12 @@ class Lcm: nsd = db_nsr["nsd"] nsr_lcm = db_nsr["_admin"]["deploy"] - db_nsr["operational-status"] = "terminate" - db_nsr["config-status"] = "terminate" + db_nsr["operational-status"] = "terminating" + db_nsr["config-status"] = "terminating" db_nsr["detailed-status"] = "Deleting charms" - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) try: - step = db_nsr["detailed-status"] = "Deleting charms" self.logger.debug(logging_text + step) for vnf_index, deploy_info in nsr_lcm["VCA"].items(): if deploy_info and deploy_info.get("application"): @@ -471,8 +826,9 @@ class Lcm: vnf_index, ) ) - - self.lcm_tasks[nsr_id][order_id]["delete_charm:" + vnf_index] = task + # task.add_done_callback(functools.partial(self.n2vc_callback, deploy_info['model'], + # deploy_info['application'],None, db_nsr, vnf_index)) + self.lcm_ns_tasks[nsr_id][order_id]["delete_charm:" + vnf_index] = task except Exception as e: self.logger.debug(logging_text + "Failed while deleting charms: {}".format(e)) # remove from RO @@ -496,7 +852,7 @@ class Lcm: self.logger.debug(logging_text + "RO_ns_id={} delete conflict: {}".format(RO_nsr_id, e)) else: self.logger.error(logging_text + "RO_ns_id={} delete error: {}".format(RO_nsr_id, e)) - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) # Delete nsd RO_nsd_id = nsr_lcm["RO"]["nsd_id"] @@ -514,7 +870,7 @@ class Lcm: self.logger.debug(logging_text + "RO_nsd_id={} delete conflict: {}".format(RO_nsd_id, e)) else: self.logger.error(logging_text + "RO_nsd_id={} delete error: {}".format(RO_nsd_id, e)) - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) for vnf_id, RO_vnfd_id in nsr_lcm["RO"]["vnfd_id"].items(): if not RO_vnfd_id: @@ -532,7 +888,7 @@ class Lcm: self.logger.debug(logging_text + "RO_vnfd_id={} delete conflict: {}".format(RO_vnfd_id, e)) else: self.logger.error(logging_text + "RO_vnfd_id={} delete error: {}".format(RO_vnfd_id, e)) - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) # TODO delete from database or mark as deleted??? db_nsr["operational-status"] = "terminated" @@ -549,83 +905,167 @@ class Lcm: if exc and db_nsr: db_nsr["detailed-status"] = "ERROR {}: {}".format(step , exc) db_nsr["operational-status"] = "failed" - self.update_nsr_db(nsr_id, db_nsr) + self.update_db("nsrs", nsr_id, db_nsr) async def test(self, param=None): self.logger.debug("Starting/Ending test task: {}".format(param)) - def cancel_tasks(self, nsr_id): + def cancel_tasks(self, topic, _id): """ - Cancel all active tasks of a concrete nsr identified for nsr_id - :param nsr_id: nsr identity + Cancel all active tasks of a concrete nsr or vim identified for _id + :param topic: can be ns or vim_account + :param _id: nsr or vim identity :return: None, or raises an exception if not possible """ - if not self.lcm_tasks.get(nsr_id): + if topic == "ns": + lcm_tasks = self.lcm_ns_tasks + elif topic== "vim_account": + lcm_tasks = self.lcm_vim_tasks + elif topic== "sdn": + lcm_tasks = self.lcm_sdn_tasks + + if not lcm_tasks.get(_id): return - for order_id, tasks_set in self.lcm_tasks[nsr_id].items(): + for order_id, tasks_set in lcm_tasks[_id].items(): for task_name, task in tasks_set.items(): result = task.cancel() if result: - self.logger.debug("nsr_id={} order_id={} task={} cancelled".format(nsr_id, order_id, task_name)) - self.lcm_tasks[nsr_id] = {} + self.logger.debug("{} _id={} order_id={} task={} cancelled".format(topic, _id, order_id, task_name)) + lcm_tasks[_id] = {} async def read_kafka(self): - self.logger.debug("kafka task Enter") + self.logger.debug("Task Kafka Enter") order_id = 1 # future = asyncio.Future() + consecutive_errors = 0 + while consecutive_errors < 10: + try: + topic, command, params = await self.msg.aioread(("ns", "vim_account", "sdn"), self.loop) + self.logger.debug("Task Kafka receives {} {}: {}".format(topic, command, params)) + consecutive_errors = 0 + order_id += 1 + if command == "exit": + print("Bye!") + break + elif command.startswith("#"): + continue + elif command == "echo": + # just for test + print(params) + sys.stdout.flush() + continue + elif command == "test": + asyncio.Task(self.test(params), loop=self.loop) + continue - while True: - command, params = await self.msg.aioread("ns", self.loop) - order_id += 1 - if command == "exit": - print("Bye!") - break - elif command.startswith("#"): - continue - elif command == "echo": - # just for test - print(params) - elif command == "test": - asyncio.Task(self.test(params), loop=self.loop) - elif command == "break": - print("put a break in this line of code") - elif command == "create": - nsr_id = params.strip() - self.logger.debug("Deploying NS {}".format(nsr_id)) - task = asyncio.ensure_future(self.create_ns(nsr_id, order_id)) - if nsr_id not in self.lcm_tasks: - self.lcm_tasks[nsr_id] = {} - self.lcm_tasks[nsr_id][order_id] = {"create_ns": task} - elif command == "delete": - nsr_id = params.strip() - self.logger.debug("Deleting NS {}".format(nsr_id)) - self.cancel_tasks(nsr_id) - task = asyncio.ensure_future(self.delete_ns(nsr_id, order_id)) - if nsr_id not in self.lcm_tasks: - self.lcm_tasks[nsr_id] = {} - self.lcm_tasks[nsr_id][order_id] = {"delete_ns": task} - elif command == "show": - # just for test - nsr_id = params.strip() - try: - db_nsr = self.db.get_one("nsrs", {"_id": nsr_id}) - print("nsr:\n _id={}\n operational-status: {}\n config-status: {}\n detailed-status: " - "{}\n deploy: {}\n tasks: {}".format( + if topic == "ns": + nsr_id = params.strip() + if command == "create": + # self.logger.debug("Deploying NS {}".format(nsr_id)) + task = asyncio.ensure_future(self.create_ns(nsr_id, order_id)) + if nsr_id not in self.lcm_ns_tasks: + self.lcm_ns_tasks[nsr_id] = {} + self.lcm_ns_tasks[nsr_id][order_id] = {"create_ns": task} + continue + elif command == "delete": + # self.logger.debug("Deleting NS {}".format(nsr_id)) + self.cancel_tasks(topic, nsr_id) + task = asyncio.ensure_future(self.delete_ns(nsr_id, order_id)) + if nsr_id not in self.lcm_ns_tasks: + self.lcm_ns_tasks[nsr_id] = {} + self.lcm_ns_tasks[nsr_id][order_id] = {"delete_ns": task} + continue + elif command == "show": + try: + db_nsr = self.db.get_one("nsrs", {"_id": nsr_id}) + print( + "nsr:\n _id={}\n operational-status: {}\n config-status: {}\n detailed-status: " + "{}\n deploy: {}\n tasks: {}".format( nsr_id, db_nsr["operational-status"], db_nsr["config-status"], db_nsr["detailed-status"], - db_nsr["_admin"]["deploy"], self.lcm_tasks.get(nsr_id))) - except Exception as e: - print("nsr {} not found: {}".format(nsr_id, e)) - else: - self.logger.critical("unknown command '{}'".format(command)) - self.logger.debug("kafka task Exit") - + db_nsr["_admin"]["deploy"], self.lcm_ns_tasks.get(nsr_id))) + except Exception as e: + print("nsr {} not found: {}".format(nsr_id, e)) + sys.stdout.flush() + continue + elif topic == "vim_account": + vim_id = params["_id"] + if command == "create": + task = asyncio.ensure_future(self.create_vim(params, order_id)) + if vim_id not in self.lcm_vim_tasks: + self.lcm_vim_tasks[vim_id] = {} + self.lcm_vim_tasks[vim_id][order_id] = {"create_vim": task} + continue + elif command == "delete": + self.cancel_tasks(topic, vim_id) + task = asyncio.ensure_future(self.delete_vim(vim_id, order_id)) + if vim_id not in self.lcm_vim_tasks: + self.lcm_vim_tasks[vim_id] = {} + self.lcm_vim_tasks[vim_id][order_id] = {"delete_vim": task} + continue + elif command == "show": + print("not implemented show with vim_account") + sys.stdout.flush() + continue + elif command == "edit": + task = asyncio.ensure_future(self.edit_vim(vim_id, order_id)) + if vim_id not in self.lcm_vim_tasks: + self.lcm_vim_tasks[vim_id] = {} + self.lcm_vim_tasks[vim_id][order_id] = {"edit_vim": task} + continue + elif topic == "sdn": + _sdn_id = params["_id"] + if command == "create": + task = asyncio.ensure_future(self.create_sdn(params, order_id)) + if _sdn_id not in self.lcm_sdn_tasks: + self.lcm_sdn_tasks[_sdn_id] = {} + self.lcm_sdn_tasks[_sdn_id][order_id] = {"create_sdn": task} + continue + elif command == "delete": + self.cancel_tasks(topic, _sdn_id) + task = asyncio.ensure_future(self.delete_sdn(_sdn_id, order_id)) + if _sdn_id not in self.lcm_sdn_tasks: + self.lcm_sdn_tasks[_sdn_id] = {} + self.lcm_sdn_tasks[_sdn_id][order_id] = {"delete_sdn": task} + continue + elif command == "edit": + task = asyncio.ensure_future(self.edit_sdn(_sdn_id, order_id)) + if _sdn_id not in self.lcm_sdn_tasks: + self.lcm_sdn_tasks[_sdn_id] = {} + self.lcm_sdn_tasks[_sdn_id][order_id] = {"edit_sdn": task} + continue + self.logger.critical("unknown topic {} and command '{}'".format(topic, command)) + except Exception as e: + if consecutive_errors == 5: + self.logger.error("Task Kafka task exit error too many errors. Exception: {}".format(e)) + break + else: + consecutive_errors += 1 + self.logger.error("Task Kafka Exception {}".format(e)) + await asyncio.sleep(1, loop=self.loop) + self.logger.debug("Task Kafka terminating") + # TODO + # self.cancel_tasks("ALL", "create") + # timeout = 200 + # while self.is_pending_tasks(): + # self.logger.debug("Task Kafka terminating. Waiting for tasks termination") + # await asyncio.sleep(2, loop=self.loop) + # timeout -= 2 + # if not timeout: + # self.cancel_tasks("ALL", "ALL") + self.logger.debug("Task Kafka exit") def start(self): self.loop = asyncio.get_event_loop() self.loop.run_until_complete(self.read_kafka()) self.loop.close() self.loop = None + if self.db: + self.db.db_disconnect() + if self.msg: + self.msg.disconnect() + if self.fs: + self.fs.fs_disconnect() def read_config_file(self, config_file): @@ -656,6 +1096,7 @@ class Lcm: return conf except Exception as e: self.logger.critical("At config file '{}': {}".format(config_file, e)) + exit(1) if __name__ == '__main__':