1 # -*- coding: utf-8 -*-
4 # Copyright 2015 Telefónica Investigación y Desarrollo, S.A.U.
5 # This file is part of openvim
8 # Licensed under the Apache License, Version 2.0 (the "License"); you may
9 # not use this file except in compliance with the License. You may obtain
10 # a copy of the License at
12 # http://www.apache.org/licenses/LICENSE-2.0
14 # Unless required by applicable law or agreed to in writing, software
15 # distributed under the License is distributed on an "AS IS" BASIS, WITHOUT
16 # WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. See the
17 # License for the specific language governing permissions and limitations
20 # For those usages not covered by the Apache License, Version 2.0 please
21 # contact with: nfvlabs@tid.es
25 This is thread that interact with the host and the libvirt to manage VM
26 One thread will be launched per host
34 from db_base
import db_base_Exception
35 from lib_osm_openvim
.ovim
import ovimException
37 __author__
= "Alfonso Tierno, Pablo Montes"
38 __date__
= "$10-feb-2017 12:07:15$"
40 # from logging import Logger
41 # import auxiliary_functions as af
44 def is_task_id(task_id
):
45 return True if task_id
[:5] == "TASK." else False
48 class vim_thread(threading
.Thread
):
49 REFRESH_BUILD
= 5 # 5 seconds
50 REFRESH_ACTIVE
= 60 # 1 minute
52 def __init__(self
, vimconn
, task_lock
, name
=None, datacenter_name
=None, datacenter_tenant_id
=None,
53 db
=None, db_lock
=None, ovim
=None):
58 'host','user': host ip or name to manage and user
59 'db', 'db_lock': database class and lock to use it in exclusion
62 """ It will contain a dictionary with
64 status: enqueued,done,error,deleted,processing
67 threading
.Thread
.__init
__(self
)
69 self
.datacenter_name
= datacenter_name
70 self
.datacenter_tenant_id
= datacenter_tenant_id
73 self
.name
= vimconn
["id"] + "." + vimconn
["config"]["datacenter_tenant_id"]
77 self
.logger
= logging
.getLogger('openmano.vim.'+self
.name
)
79 self
.db_lock
= db_lock
81 self
.task_lock
= task_lock
82 self
.task_queue
= Queue
.Queue(2000)
83 self
.refresh_list
= []
84 """Contains time ordered task list for refreshing the status of VIM VMs and nets"""
86 def _refres_elements(self
):
87 """Call VIM to get VMs and networks status until 10 elements"""
89 vm_to_refresh_list
= []
90 net_to_refresh_list
= []
91 vm_to_refresh_dict
= {}
92 net_to_refresh_dict
= {}
94 while self
.refresh_list
:
95 task
= self
.refresh_list
[0]
97 if task
['status'] == 'deleted':
98 self
.refresh_list
.pop(0)
100 if task
['time'] > now
:
102 task
["status"] = "processing"
103 self
.refresh_list
.pop(0)
104 if task
["name"] == 'get-vm':
105 vm_to_refresh_list
.append(task
["vim_id"])
106 vm_to_refresh_dict
[task
["vim_id"]] = task
107 elif task
["name"] == 'get-net':
108 net_to_refresh_list
.append(task
["vim_id"])
109 net_to_refresh_dict
[task
["vim_id"]] = task
111 error_text
= "unknown task {}".format(task
["name"])
112 self
.logger
.error(error_text
)
113 items_to_refresh
+= 1
114 if items_to_refresh
== 10:
117 if vm_to_refresh_list
:
119 vim_dict
= self
.vim
.refresh_vms_status(vm_to_refresh_list
)
120 for vim_id
, vim_info
in vim_dict
.items():
122 task
= vm_to_refresh_dict
[vim_id
]
123 self
.logger
.debug("get-vm vm_id=%s result=%s", task
["vim_id"], str(vim_info
))
126 if vim_info
.get("error_msg"):
127 vim_info
["error_msg"] = self
._format
_vim
_error
_msg
(vim_info
["error_msg"])
128 if task
["vim_info"].get("status") != vim_info
["status"] or \
129 task
["vim_info"].get("error_msg") != vim_info
.get("error_msg") or \
130 task
["vim_info"].get("vim_info") != vim_info
["vim_info"]:
132 temp_dict
= {"status": vim_info
["status"],
133 "error_msg": vim_info
.get("error_msg"),
134 "vim_info": vim_info
["vim_info"]}
135 self
.db
.update_rows('instance_vms', UPDATE
=temp_dict
, WHERE
={"vim_vm_id": vim_id
})
136 for interface
in vim_info
["interfaces"]:
137 for task_interface
in task
["vim_info"]["interfaces"]:
138 if task_interface
["vim_net_id"] == interface
["vim_net_id"]:
141 task_interface
= {"vim_net_id": interface
["vim_net_id"]}
142 task
["vim_info"]["interfaces"].append(task_interface
)
143 if task_interface
!= interface
:
145 if task_interface
.get("sdn_port_id"):
148 self
.ovim
.delete_port(task_interface
["sdn_port_id"])
149 task_interface
["sdn_port_id"] = None
150 except ovimException
as e
:
151 self
.logger
.error("ovimException deleting external_port={} ".format(
152 task_interface
["sdn_port_id"]) + str(e
), exc_info
=True)
153 # TODO Set error_msg at instance_nets
154 vim_net_id
= interface
["vim_net_id"]
158 where_
= {'iv.vim_vm_id': vim_id
, "ine.vim_net_id": vim_net_id
,
159 'ine.datacenter_tenant_id': self
.datacenter_tenant_id
}
160 # TODO check why vim_interface_id is not present at database
161 # if interface.get("vim_interface_id"):
162 # where_["vim_interface_id"] = interface["vim_interface_id"]
163 db_ifaces
= self
.db
.get_rows(
164 FROM
="instance_interfaces as ii left join instance_nets as ine on "
165 "ii.instance_net_id=ine.uuid left join instance_vms as iv on "
166 "ii.instance_vm_id=iv.uuid",
167 SELECT
=("ii.uuid as iface_id", "ine.uuid as net_id", "iv.uuid as vm_id", "sdn_net_id", "vim_net_id"),
170 self
.logger
.critical("Refresing interfaces. "
171 "Found more than one interface at database for '{}'".format(where_
))
172 elif len(db_ifaces
)==0:
173 self
.logger
.critical("Refresing interfaces. "
174 "Not found any interface at database for '{}'".format(where_
))
177 db_iface
= db_ifaces
[0]
178 # If there is no sdn_net_id, check if it is because an already created vim network is being used
179 # in that case, the sdn_net_id will be in that entry of the instance_nets table
180 if not db_iface
.get("sdn_net_id"):
182 result
= self
.db
.get_rows(
183 SELECT
=('sdn_net_id',), FROM
='instance_nets',
184 WHERE
={'vim_net_id': db_iface
.get("vim_net_id"),
185 'instance_scenario_id': None,
186 'datacenter_tenant_id': self
.datacenter_tenant_id
})
188 db_iface
["sdn_net_id"] = result
[0]['sdn_net_id']
190 if db_iface
.get("sdn_net_id") and interface
.get("compute_node") and interface
.get("pci"):
191 sdn_net_id
= db_iface
["sdn_net_id"]
192 sdn_port_name
= sdn_net_id
+ "." + db_iface
["vm_id"]
193 sdn_port_name
= sdn_port_name
[:63]
196 sdn_port_id
= self
.ovim
.new_external_port(
197 {"compute_node": interface
["compute_node"],
198 "pci": interface
["pci"],
199 "vlan": interface
.get("vlan"),
200 "net_id": sdn_net_id
,
201 "region": self
.vim
["config"]["datacenter_id"],
202 "name": sdn_port_name
,
203 "mac": interface
.get("mac_address")})
204 interface
["sdn_port_id"] = sdn_port_id
205 except (ovimException
, Exception) as e
:
207 "ovimException creating new_external_port compute_node={} " \
208 "pci={} vlan={} ".format(
209 interface
["compute_node"],
211 interface
.get("vlan")) + str(e
),
213 # TODO Set error_msg at instance_nets
215 vim_net_id
= interface
.pop("vim_net_id")
216 self
.db
.update_rows('instance_interfaces', UPDATE
=interface
,
217 WHERE
={'uuid': db_iface
["iface_id"]})
218 interface
["vim_net_id"] = vim_net_id
219 # TODO insert instance_id
221 task
["vim_info"] = vim_info
222 if task
["vim_info"]["status"] == "BUILD":
223 self
._insert
_refresh
(task
, now
+ self
.REFRESH_BUILD
)
225 self
._insert
_refresh
(task
, now
+ self
.REFRESH_ACTIVE
)
226 except vimconn
.vimconnException
as e
:
227 self
.logger
.error("vimconnException Exception when trying to refresh vms " + str(e
))
228 self
._insert
_refresh
(task
, now
+ self
.REFRESH_ACTIVE
)
230 if net_to_refresh_list
:
232 vim_dict
= self
.vim
.refresh_nets_status(net_to_refresh_list
)
233 for vim_id
, vim_info
in vim_dict
.items():
235 task
= net_to_refresh_dict
[vim_id
]
236 self
.logger
.debug("get-net net_id=%s result=%s", task
["vim_id"], str(vim_info
))
239 where_
= {"vim_net_id": vim_id
, 'datacenter_tenant_id': self
.datacenter_tenant_id
}
241 db_nets
= self
.db
.get_rows(
242 FROM
="instance_nets",
243 SELECT
=("uuid as net_id", "sdn_net_id"),
246 self
.logger
.critical("Refresing networks. "
247 "Found more than one instance-networks at database for '{}'".format(where_
))
248 elif len(db_nets
) == 0:
249 self
.logger
.critical("Refresing networks. "
250 "Not found any instance-network at database for '{}'".format(where_
))
254 if db_net
.get("sdn_net_id"):
258 sdn_net
= self
.ovim
.show_network(db_net
["sdn_net_id"])
259 if sdn_net
["status"] == "ERROR":
260 if not vim_info
.get("error_msg"):
261 vim_info
["error_msg"] = sdn_net
["error_msg"]
263 vim_info
["error_msg"] = "VIM_ERROR: {} && SDN_ERROR: {}".format(
264 self
._format
_vim
_error
_msg
(vim_info
["error_msg"], 1024//2-14),
265 self
._format
_vim
_error
_msg
(sdn_net
["error_msg"], 1024//2-14))
266 if vim_info
["status"] == "VIM_ERROR":
267 vim_info
["status"] = "VIM_SDN_ERROR"
269 vim_info
["status"] = "SDN_ERROR"
271 except (ovimException
, Exception) as e
:
273 "ovimException getting network infor snd_net_id={}".format(db_net
["sdn_net_id"]),
275 # TODO Set error_msg at instance_nets
278 if vim_info
.get("error_msg"):
279 vim_info
["error_msg"] = self
._format
_vim
_error
_msg
(vim_info
["error_msg"])
280 if task
["vim_info"].get("status") != vim_info
["status"] or \
281 task
["vim_info"].get("error_msg") != vim_info
.get("error_msg") or \
282 task
["vim_info"].get("vim_info") != vim_info
["vim_info"]:
284 temp_dict
= {"status": vim_info
["status"],
285 "error_msg": vim_info
.get("error_msg"),
286 "vim_info": vim_info
["vim_info"]}
287 self
.db
.update_rows('instance_nets', UPDATE
=temp_dict
, WHERE
={"vim_net_id": vim_id
})
289 task
["vim_info"] = vim_info
290 if task
["vim_info"]["status"] == "BUILD":
291 self
._insert
_refresh
(task
, now
+ self
.REFRESH_BUILD
)
293 self
._insert
_refresh
(task
, now
+ self
.REFRESH_ACTIVE
)
294 except vimconn
.vimconnException
as e
:
295 self
.logger
.error("vimconnException Exception when trying to refresh nets " + str(e
))
296 self
._insert
_refresh
(task
, now
+ self
.REFRESH_ACTIVE
)
298 if not items_to_refresh
:
301 def _insert_refresh(self
, task
, threshold_time
):
302 """Insert a task at list of refreshing elements. The refreshing list is ordered by threshold_time (task['time']
303 It is assumed that this is called inside this thread
305 task
["time"] = threshold_time
306 for index
in range(0, len(self
.refresh_list
)):
307 if self
.refresh_list
[index
]["time"] > threshold_time
:
308 self
.refresh_list
.insert(index
, task
)
311 index
= len(self
.refresh_list
)
312 self
.refresh_list
.append(task
)
313 self
.logger
.debug("new refresh task={} name={}, time={} index={}".format(
314 task
["id"], task
["name"], task
["time"], index
))
316 def _remove_refresh(self
, task_name
, vim_id
):
317 """Remove a task with this name and vim_id from the list of refreshing elements.
318 It is assumed that this is called inside this thread outside _refres_elements method
319 Return True if self.refresh_list is modified, task is found
320 Return False if not found
322 index_to_delete
= None
323 for index
in range(0, len(self
.refresh_list
)):
324 if self
.refresh_list
[index
]["name"] == task_name
and self
.refresh_list
[index
]["vim_id"] == vim_id
:
325 index_to_delete
= index
329 if index_to_delete
!= None:
330 del self
.refresh_list
[index_to_delete
]
333 def insert_task(self
, task
):
335 self
.task_queue
.put(task
, False)
338 raise vimconn
.vimconnException(self
.name
+ ": timeout inserting a task")
340 def del_task(self
, task
):
342 if task
["status"] == "enqueued":
343 task
["status"] == "deleted"
345 else: # task["status"] == "processing"
346 self
.task_lock
.release()
350 self
.logger
.debug("Starting")
355 if not self
.task_queue
.empty():
356 task
= self
.task_queue
.get()
357 self
.task_lock
.acquire()
358 if task
["status"] == "deleted":
359 self
.task_lock
.release()
361 task
["status"] = "processing"
362 self
.task_lock
.release()
364 self
._refres
_elements
()
366 self
.logger
.debug("processing task id={} name={} params={}".format(task
["id"], task
["name"],
367 str(task
["params"])))
368 if task
["name"] == 'exit' or task
["name"] == 'reload':
369 result
, content
= self
.terminate(task
)
370 elif task
["name"] == 'new-vm':
371 result
, content
= self
.new_vm(task
)
372 elif task
["name"] == 'del-vm':
373 result
, content
= self
.del_vm(task
)
374 elif task
["name"] == 'new-net':
375 result
, content
= self
.new_net(task
)
376 elif task
["name"] == 'del-net':
377 result
, content
= self
.del_net(task
)
379 error_text
= "unknown task {}".format(task
["name"])
380 self
.logger
.error(error_text
)
383 self
.logger
.debug("task id={} name={} result={}:{} params={}".format(task
["id"], task
["name"],
385 str(task
["params"])))
388 task
["status"] = "done" if result
else "error"
389 task
["result"] = content
390 self
.task_queue
.task_done()
392 if task
["name"] == 'exit':
394 elif task
["name"] == 'reload':
396 except Exception as e
:
397 self
.logger
.critical("Unexpected exception at run: " + str(e
), exc_info
=True)
399 self
.logger
.debug("Finishing")
401 def terminate(self
, task
):
404 def _format_vim_error_msg(self
, error_text
, max_length
=1024):
405 if error_text
and len(error_text
) >= max_length
:
406 return error_text
[:max_length
//2-3] + " ... " + error_text
[-max_length
//2+3:]
409 def new_net(self
, task
):
412 params
= task
["params"]
413 net_id
= self
.vim
.new_network(*params
)
420 sdn_controller
= self
.vim
.config
.get('sdn-controller')
421 if sdn_controller
and (net_type
== "data" or net_type
== "ptp"):
422 network
= {"name": net_name
, "type": net_type
, "region": self
.vim
["config"]["datacenter_id"]}
424 vim_net
= self
.vim
.get_network(net_id
)
425 if vim_net
.get('encapsulation') != 'vlan':
426 raise vimconn
.vimconnException(
427 "net '{}' defined as type '{}' has not vlan encapsulation '{}'".format(
428 net_name
, net_type
, vim_net
['encapsulation']))
429 network
["vlan"] = vim_net
.get('segmentation_id')
432 sdn_net_id
= self
.ovim
.new_network(network
)
433 except (ovimException
, Exception) as e
:
434 self
.logger
.error("task=%s cannot create SDN network vim_net_id=%s input='%s' ovimException='%s'",
435 str(task_id
), net_id
, str(network
), str(e
))
437 self
.db
.update_rows("instance_nets", UPDATE
={"vim_net_id": net_id
, "sdn_net_id": sdn_net_id
},
438 WHERE
={"vim_net_id": task_id
})
439 new_refresh_task
= {"status": "enqueued",
444 self
._insert
_refresh
(new_refresh_task
, time
.time())
446 except db_base_Exception
as e
:
447 self
.logger
.error("Error updating database %s", str(e
))
449 except vimconn
.vimconnException
as e
:
450 self
.logger
.error("Error creating NET, task=%s: %s", str(task_id
), str(e
))
453 self
.db
.update_rows("instance_nets",
454 UPDATE
={"error_msg": self
._format
_vim
_error
_msg
(str(e
)), "status": "VIM_ERROR"},
455 WHERE
={"vim_net_id": task_id
})
456 except db_base_Exception
as e
:
457 self
.logger
.error("Error updating database %s", str(e
))
459 #except ovimException as e:
460 # self.logger.error("Error creating NET in ovim, task=%s: %s", str(task_id), str(e))
461 # return False, str(e)
463 def new_vm(self
, task
):
465 params
= task
["params"]
467 depends
= task
.get("depends")
471 if "net_id" in net
and is_task_id(net
["net_id"]): # change task_id into network_id
473 task_net
= depends
[net
["net_id"]]
475 if task_net
["status"] == "error":
476 error_text
= "Cannot create VM because depends on a network that cannot be created: " +\
477 str(task_net
["result"])
479 elif task_net
["status"] == "enqueued" or task_net
["status"] == "processing":
480 error_text
= "Cannot create VM because depends on a network still not created"
482 network_id
= task_net
["result"]
483 net
["net_id"] = network_id
484 except Exception as e
:
485 error_text
= "Error trying to map from task_id={} to task result: {}".format(
486 net
["net_id"],str(e
))
489 vm_id
= self
.vim
.new_vminstance(*params
)
493 update
= self
.db
.update_rows("instance_vms",
494 UPDATE
={"status": "VIM_ERROR", "error_msg": error_text
},
495 WHERE
={"vim_vm_id": task_id
})
497 update
= self
.db
.update_rows("instance_vms", UPDATE
={"vim_vm_id": vm_id
}, WHERE
={"vim_vm_id": task_id
})
499 self
.logger
.error("task id={} name={} database not updated vim_vm_id={}".format(
500 task
["id"], task
["name"], vm_id
))
501 except db_base_Exception
as e
:
502 self
.logger
.error("Error updating database %s", str(e
))
504 return False, error_text
505 new_refresh_task
= {"status": "enqueued",
509 "vim_info": {"interfaces":[]} }
510 self
._insert
_refresh
(new_refresh_task
, time
.time())
512 except vimconn
.vimconnException
as e
:
513 self
.logger
.error("Error creating VM, task=%s: %s", str(task_id
), str(e
))
516 self
.db
.update_rows("instance_vms",
517 UPDATE
={"error_msg": self
._format
_vim
_error
_msg
(str(e
)), "status": "VIM_ERROR"},
518 WHERE
={"vim_vm_id": task_id
})
519 except db_base_Exception
as edb
:
520 self
.logger
.error("Error updating database %s", str(edb
))
523 def del_vm(self
, task
):
524 vm_id
= task
["params"][0]
525 interfaces
= task
["params"][1]
526 if is_task_id(vm_id
):
528 task_create
= task
["depends"][vm_id
]
530 if task_create
["status"] == "error":
531 return True, "VM was not created. It has error: " + str(task_create
["result"])
532 elif task_create
["status"] == "enqueued" or task_create
["status"] == "processing":
533 return False, "Cannot delete VM vim_id={} because still creating".format(vm_id
)
534 vm_id
= task_create
["result"]
535 except Exception as e
:
536 return False, "Error trying to get task_id='{}':".format(vm_id
, str(e
))
538 self
._remove
_refresh
("get-vm", vm_id
)
539 for iface
in interfaces
:
540 if iface
.get("sdn_port_id"):
543 self
.ovim
.delete_port(iface
["sdn_port_id"])
544 except ovimException
as e
:
545 self
.logger
.error("ovimException deleting external_port={} at VM vim_id={} deletion ".format(
546 iface
["sdn_port_id"], vm_id
) + str(e
), exc_info
=True)
547 # TODO Set error_msg at instance_nets
549 return True, self
.vim
.delete_vminstance(vm_id
)
550 except vimconn
.vimconnException
as e
:
553 def del_net(self
, task
):
554 net_id
= task
["params"][0]
555 sdn_net_id
= task
["params"][1]
556 if is_task_id(net_id
):
558 task_create
= task
["depends"][net_id
]
560 if task_create
["status"] == "error":
561 return True, "net was not created. It has error: " + str(task_create
["result"])
562 elif task_create
["status"] == "enqueued" or task_create
["status"] == "processing":
563 return False, "Cannot delete net because still creating"
564 net_id
= task_create
["result"]
565 except Exception as e
:
566 return False, "Error trying to get task_id='{}':".format(net_id
, str(e
))
568 self
._remove
_refresh
("get-net", net_id
)
569 result
= self
.vim
.delete_network(net_id
)
571 # Delete any attached port to this sdn network
572 # At this point, there will be ports associated to this network in case it was manually done using 'openmano vim-net-sdn-attach'
575 port_list
= self
.ovim
.get_ports(columns
={'uuid'}, filter={'name': 'external_port', 'net_id': sdn_net_id
})
576 except ovimException
as e
:
577 raise vimconn
.vimconnException(
578 "ovimException obtaining external ports for net {}. ".format(sdn_net_id
) + str(e
))
580 for port
in port_list
:
583 self
.ovim
.delete_port(port
['uuid'])
584 except ovimException
as e
:
585 raise vimconn
.vimconnException(
586 "ovimException deleting port {} for net {}. ".format(port
['uuid'], sdn_net_id
) + str(e
))
588 self
.ovim
.delete_network(sdn_net_id
)
590 except vimconn
.vimconnException
as e
:
592 except ovimException
as e
:
593 logging
.error("Error deleting network from ovim. net_id: {}, sdn_net_id: {}".format(net_id
, sdn_net_id
))