X-Git-Url: https://osm.etsi.org/gitweb/?a=blobdiff_plain;f=lcm%2Fosm_lcm%2Flcm.py;h=aa24caa1ecec27d77ef36c20525be0728b50f895;hb=f3a5443bfaf65f22540eff98a49be087f0479424;hp=3b4ab601acf1b00b9df6d4348f1e25533c8d48ba;hpb=ae501920e1c0e03c8571bece610dd5518e6e86b9;p=osm%2FRO.git diff --git a/lcm/osm_lcm/lcm.py b/lcm/osm_lcm/lcm.py index 3b4ab601..aa24caa1 100644 --- a/lcm/osm_lcm/lcm.py +++ b/lcm/osm_lcm/lcm.py @@ -11,14 +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 vca import DeployApplication, RemoveApplication +from n2vc.vnf import N2VC +# import os.path +# import time + from copy import deepcopy from http import HTTPStatus + class LcmException(Exception): pass @@ -31,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 @@ -44,6 +57,7 @@ class Lcm: "logger_name": "lcm.ROclient", "loglevel": "ERROR", } + self.vca = config["VCA"] # TODO VCA self.loop = None @@ -78,6 +92,19 @@ class Lcm: if "loglevel" in config[k1]: logger_module.setLevel(config[k1]["loglevel"]) + self.n2vc = N2VC( + log=self.logger, + server=config['VCA']['host'], + port=config['VCA']['port'], + user=config['VCA']['user'], + secret=config['VCA']['secret'], + # TODO: This should point to the base folder where charms are stored, + # if there is a common one (like object storage). Otherwise, leave + # it unset and pass it via DeployCharms + # artifacts=config['VCA'][''], + artifacts=None, + ) + try: if config["database"]["driver"] == "mongo": self.db = dbmongo.DbMongo() @@ -109,35 +136,405 @@ 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 - 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)) + 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: - if task.cancelled(): + 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. + + Updates the VNF's operational status with the state of the charm: + - blocked: The unit needs manual intervention + - maintenance: The unit is actively deploying/configuring + - waiting: The unit is waiting for another charm to be ready + - 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. + """ + nsr_id = None + try: + nsr_id = db_nsr["_id"] + nsr_lcm = db_nsr["_admin"]["deploy"] + 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: + 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: + self.logger.critical("[n2vc_callback] create_ns={} vnf_index={} Enter with bad parameters".format(nsr_id, vnf_member_index), exc_info=True) 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) + + 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" - self.update_nsr_db(nsr_id, db_nsr) - else: - # TODO may be used to be called when VCA monitor status changes + db_nsr["detailed-status"] = "fail configuring vnf_index={} {}".format(vnf_member_index, + vca_info["detailed-status"]) + break + + 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 - # except DbException as e: - # self.logger.error("Task create_ns={} vca_deploy_callback Exception {}".format(nsr_id, e)) + else: + cs = "configuring: " + separator = "" + for status, num in status_map.items(): + cs += separator + "{}: {}".format(status, num) + separator = ", " + db_nsr["config-status"] = cs + self.update_db("nsrs", nsr_id, db_nsr) + 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) @@ -149,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"] @@ -183,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"] @@ -212,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 @@ -243,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" @@ -258,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 @@ -270,7 +665,7 @@ 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) vnfd_to_config = 0 step = "Looking for needed vnfd to configure" @@ -280,40 +675,72 @@ class Lcm: vnf_index = str(c_vnf["member-vnf-index"]) vnfd = needed_vnfd[vnfd_id] if vnfd.get("vnf-configuration") and vnfd["vnf-configuration"].get("juju"): - nsr_lcm["VCA"][vnf_index] = {} 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"] + storage_params = self.fs.get_params() charm_path = "{}{}/{}/charms/{}".format( - base_folder["path"], + storage_params["path"], base_folder["folder"], - base_folder["file"], + base_folder["pkg-dir"], proxy_charm ) + + # Setup the runtime parameters for this VNF + params = { + 'rw_mgmt_ip': nsr_lcm['nsr_ip'][vnf_index], + } + + # model_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, # 'default', + vnf_index, + vnfd['name'], + ) + # TODO N2VC implement this inside n2vc.FormatApplicationName + application_name = application_name[:50] + + 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( - DeployApplication( - self.config['VCA'], - self.db, - db_nsr, - vnfd, - vnf_index, - charm_path, + 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.vca_deploy_callback, db_nsr, vnf_index, None)) - self.lcm_tasks[nsr_id][order_id]["create_charm:" + vnf_index] = 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 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" + db_nsr["detailed-status"] = "configuring: init: {}".format(vnfd_to_config) if vnfd_to_config 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: @@ -323,7 +750,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) @@ -336,25 +763,30 @@ 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("appliation"): + if deploy_info and deploy_info.get("application"): + # n2vc_callback(self, model_name, application_name, workload_status, db_nsr, vnf_member_index, task=None): + + # self.n2vc.RemoveCharms(model_name, application_name, self.n2vc_callback, model_name, application_name) task = asyncio.ensure_future( - RemoveApplication( - self.config['VCA'], - self.db, + self.n2vc.RemoveCharms( + deploy_info['model'], + deploy_info['application'], + self.n2vc_callback, db_nsr, 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 @@ -378,7 +810,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"] @@ -396,7 +828,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: @@ -414,7 +846,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" @@ -431,83 +863,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): @@ -538,6 +1054,7 @@ class Lcm: return conf except Exception as e: self.logger.critical("At config file '{}': {}".format(config_file, e)) + exit(1) if __name__ == '__main__':