fix to get logfile
[doctor.git] / doctor_tests / main.py
1 ##############################################################################
2 # Copyright (c) 2017 ZTE Corporation and others.
3 #
4 # All rights reserved. This program and the accompanying materials
5 # are made available under the terms of the Apache License, Version 2.0
6 # which accompanies this distribution, and is available at
7 # http://www.apache.org/licenses/LICENSE-2.0
8 ##############################################################################
9 import os
10 from os.path import isfile, join
11 import random
12 import sys
13 import time
14
15 from doctor_tests.alarm import Alarm
16 from doctor_tests.common.constants import Host
17 from doctor_tests.common.utils import match_rep_in_file
18 from doctor_tests import config
19 from doctor_tests.consumer import get_consumer
20 from doctor_tests.identity_auth import get_identity_auth
21 from doctor_tests.identity_auth import get_session
22 from doctor_tests.image import Image
23 from doctor_tests.instance import Instance
24 from doctor_tests.inspector import get_inspector
25 from doctor_tests.installer import get_installer
26 import doctor_tests.logger as doctor_log
27 from doctor_tests.network import Network
28 from doctor_tests.monitor import get_monitor
29 from doctor_tests.os_clients import nova_client
30 from doctor_tests.profiler_poc import main as profiler_main
31 from doctor_tests.scenario.common import calculate_notification_time
32 from doctor_tests.scenario.network_failure import NetworkFault
33 from doctor_tests.user import User
34
35
36 Logger = doctor_log.Logger('doctor')
37 LOG = Logger.getLogger()
38 LogFile = Logger.getLogFilename()
39
40
41 class DoctorTest(object):
42
43     def __init__(self, conf):
44         self.conf = conf
45         self.image = Image(self.conf, LOG)
46         self.user = User(self.conf, LOG)
47         self.network = Network(self.conf, LOG)
48         self.instance = Instance(self.conf, LOG)
49         self.alarm = Alarm(self.conf, LOG)
50         self.installer = get_installer(self.conf, LOG)
51         self.inspector = get_inspector(self.conf, LOG)
52         self.monitor = get_monitor(self.conf,
53                                    self.inspector.get_inspector_url(),
54                                    LOG)
55         self.consumer = get_consumer(self.conf, LOG)
56         self.fault = NetworkFault(self.conf, self.installer, LOG)
57         auth = get_identity_auth(project=self.conf.doctor_project)
58         self.nova = nova_client(self.conf.nova_version,
59                                 get_session(auth=auth))
60         self.down_host = None
61
62     def setup(self):
63         # prepare the cloud env
64         self.installer.setup()
65
66         # preparing VM image...
67         self.image.create()
68
69         # creating test user...
70         self.user.create()
71         self.user.update_quota()
72
73         # creating VM...
74         self.network.create()
75         self.instance.create()
76         self.instance.wait_for_vm_launch()
77
78         # creating alarm...
79         self.alarm.create()
80
81         # starting doctor sample components...
82         self.inspector.start()
83
84         self.down_host = self.get_host_info_for_random_vm()
85         self.monitor.start(self.down_host)
86
87         self.consumer.start()
88
89     def run(self):
90         """run doctor test"""
91         try:
92             LOG.info('doctor test starting.......')
93
94             # prepare test env
95             self.setup()
96
97             # wait for aodh alarms are updated in caches for event evaluator,
98             # sleep time should be larger than event_alarm_cache_ttl(default 60)
99             time.sleep(60)
100
101             # injecting host failure...
102             # NOTE (umar) add INTERFACE_NAME logic to host injection
103
104             self.fault.start(self.down_host)
105             time.sleep(10)
106
107             # verify the test results
108             # NOTE (umar) copy remote monitor.log file when monitor=collectd
109             self.check_host_status(self.down_host.name, 'down')
110
111             notification_time = calculate_notification_time(LogFile)
112             if notification_time < 1 and notification_time > 0:
113                 LOG.info('doctor test successfully, notification_time=%s' % notification_time)
114             else:
115                 LOG.error('doctor test failed, notification_time=%s' % notification_time)
116                 sys.exit(1)
117
118             if self.conf.profiler_type:
119                 LOG.info('doctor test begin to run profile.......')
120                 self.collect_logs()
121                 self.run_profiler()
122         except Exception as e:
123             LOG.error('doctor test failed, Exception=%s' % e)
124             sys.exit(1)
125         finally:
126             self.cleanup()
127
128     def get_host_info_for_random_vm(self):
129         num = random.randint(0, self.conf.instance_count - 1)
130         vm_name = "%s%d" % (self.conf.instance_basename, num)
131
132         servers = \
133             {getattr(server, 'name'): server
134              for server in self.nova.servers.list()}
135         server = servers.get(vm_name)
136         if not server:
137             raise \
138                 Exception('Can not find instance: vm_name(%s)' % vm_name)
139         host_name = server.__dict__.get('OS-EXT-SRV-ATTR:hypervisor_hostname')
140         host_ip = self.installer.get_host_ip_from_hostname(host_name)
141
142         LOG.info('Get host info(name:%s, ip:%s) which vm(%s) launched at'
143                  % (host_name, host_ip, vm_name))
144         return Host(host_name, host_ip)
145
146     def check_host_status(self, hostname, state):
147         service = self.nova.services.list(host=hostname, binary='nova-compute')
148         host_state = service[0].__dict__.get('state')
149         assert host_state == state
150
151     def unset_forced_down_hosts(self):
152         if self.down_host:
153             self.nova.services.force_down(self.down_host.name, 'nova-compute', False)
154             time.sleep(2)
155             self.check_host_status(self.down_host.name, 'up')
156
157     def collect_logs(self):
158         self.fault.get_disable_network_log()
159
160     def run_profiler(self):
161
162         net_down_log_file = self.fault.get_disable_network_log()
163         reg = '(?<=doctor set link down at )\d+.\d+'
164         linkdown = float(match_rep_in_file(reg, net_down_log_file).group(0))
165
166         reg = '(.* doctor mark vm.* error at )(\d+.\d+)'
167         vmdown = float(match_rep_in_file(reg, LogFile).group(2))
168
169         reg = '(.* doctor mark host.* down at )(\d+.\d+)'
170         hostdown = float(match_rep_in_file(reg, LogFile).group(2))
171
172         reg = '(?<=doctor monitor detected at )\d+.\d+'
173         detected = float(match_rep_in_file(reg, LogFile).group(0))
174
175         reg = '(?<=doctor consumer notified at )\d+.\d+'
176         notified = float(match_rep_in_file(reg, LogFile).group(0))
177
178         # TODO(yujunz) check the actual delay to verify time sync status
179         # expected ~1s delay from $trigger to $linkdown
180         relative_start = linkdown
181         os.environ['DOCTOR_PROFILER_T00'] = str(int((linkdown - relative_start)*1000))
182         os.environ['DOCTOR_PROFILER_T01'] = str(int((detected - relative_start) * 1000))
183         os.environ['DOCTOR_PROFILER_T03'] = str(int((vmdown - relative_start) * 1000))
184         os.environ['DOCTOR_PROFILER_T04'] = str(int((hostdown - relative_start) * 1000))
185         os.environ['DOCTOR_PROFILER_T09'] = str(int((notified - relative_start) * 1000))
186
187         profiler_main(log=LOG)
188
189     def cleanup(self):
190         self.unset_forced_down_hosts()
191         self.inspector.stop()
192         self.monitor.stop()
193         self.consumer.stop()
194         self.installer.cleanup()
195         self.alarm.delete()
196         self.instance.delete()
197         self.network.delete()
198         self.image.delete()
199         self.fault.cleanup()
200         self.user.delete()
201
202
203 def main():
204     """doctor main"""
205     test_dir = os.path.split(os.path.realpath(__file__))[0]
206     doctor_root_dir = os.path.dirname(test_dir)
207
208     config_file_dir = '{0}/{1}'.format(doctor_root_dir, 'etc/')
209     config_files = [join(config_file_dir, f) for f in os.listdir(config_file_dir)
210                     if isfile(join(config_file_dir, f))]
211
212     conf = config.prepare_conf(args=sys.argv[1:],
213                                config_files=config_files)
214
215     doctor = DoctorTest(conf)
216     doctor.run()