blob: 77a6c7ef6d8e542f646f92cdd8fad5265407c241 [file] [log] [blame]
YPZhang38fb1192016-08-11 11:03:38 -07001'''
2 Wrapper function for SCPFswitchLat test
3 Assign switch and capture openflow package
4 remove switch and caputer openflow package
5 calculate latency
6'''
7
8
9import time
10import json
11def processPackage( package ):
12 '''
13 split package information to dictionary
14 Args:
15 package: Package String
16
17 Returns:
18
19 '''
20 pacakge = package.split(" ")
21 dic = {}
22 for s in pacakge:
23 try:
24 [key, value] = s.split("=")
25 dic[key] = value
26 except:
27 continue
28 return dic
29
30def findSeqBySeqAck( seq, packageList):
31 '''
32 Find specific Seq of package in packageList
33 Args:
34 seq: seq from last TCP package
35 packageList: find package in packageList
36
37 Returns:
38
39 '''
40 for l in packageList:
41 temp = processPackage(l)
42 tA = temp['Ack']
43 if int(seq) + 1 == int(tA):
44 return temp['Seq']
45
46def captureOfPack( main, deviceName, ofPack, switchStatus, resultDict, warmup ):
47 '''
48
49 Args:
50 main: TestON class
51 deviceName: device name
52 ofPack: openflow package key word
53 switchStatus: Up -- assign, down -- remove
54 resultDict: dictionary to contain result
55 warmup: warm up boolean
56
57 Returns:
58
59 '''
60 for d in ofPack[switchStatus]:
61 main.log.info("Clean up Tshark")
62 with open(main.tsharkResultPath[switchStatus][d], "w") as tshark:
63 tshark.write("")
64 main.log.info( "Starting tshark capture" )
65 main.ONOSbench.tsharkGrep(ofPack[switchStatus][d], main.tsharkResultPath[switchStatus][d])
66 if switchStatus == 'up':
67 # if up, assign switch to controller
68 time.sleep(main.measurementSleep)
69 main.log.info('Assigning {} to controller'.format(deviceName))
70 main.Mininet1.assignSwController(sw=deviceName, ip=main.ONOSip[0])
71 time.sleep(main.measurementSleep)
72 if switchStatus == 'down':
73 # if down, remove switch from topology
74 time.sleep(main.measurementSleep)
75 main.step('Remove switch from controller')
76 main.Mininet1.deleteSwController(deviceName)
77 time.sleep(10)
78 main.log.info( "Stopping all Tshark processes" )
79 main.ONOSbench.tsharkStop()
YPZhang38fb1192016-08-11 11:03:38 -070080 tempResultDict = {}
81 if switchStatus == 'up':
82 for d in main.tsharkResultPath['up']:
83 with open(main.tsharkResultPath[switchStatus][d], "r") as resultFile:
84 # grep tshark result timestamp
85 resultText = resultFile.readlines()
YPZhang21adb602016-08-18 16:00:11 -070086 if d == "TCP":
87 # if TCP package, we should use the latest one package
YPZhang347b8ae2016-08-19 09:43:24 -070088 resultText = resultText[len(resultText) - 1]
YPZhang21adb602016-08-18 16:00:11 -070089 else:
90 resultText = resultText[0]
YPZhang38fb1192016-08-11 11:03:38 -070091 main.log.info("Capture result:" + resultText)
92 resultText = resultText.strip()
93 resultText = resultText.split( " " )
94 if len(resultText) > 1:
95 tempResultDict[d]= int( ( float(resultText[1]) * 1000 ) )
96 resultFile.close()
97 elif switchStatus == 'down':
98 # if state is down, we should capture Fin/Ack and ACK package
99 # Use seq number in FIN/ACK package to located ACK package
100 with open(main.tsharkResultPath['down']['FA']) as resultFile:
101 resultText = resultFile.readlines()
102 FinAckText = resultText.pop(0)
103 resultFile.close()
104 FinAckSeq = processPackage(FinAckText)['Seq']
105 FinAckOFseq = findSeqBySeqAck(FinAckSeq, resultText)
106
107 with open(main.tsharkResultPath['down']['ACK']) as resultFile:
108 ACKlines = resultFile.readlines()
109 resultFile.close()
110
YPZhang3943fbe2016-08-18 14:33:29 -0700111 AckPackage = ""
YPZhang38fb1192016-08-11 11:03:38 -0700112 for l in ACKlines:
113 temp = processPackage(l)
114 if temp['Seq'] == findSeqBySeqAck(FinAckOFseq, ACKlines):
115 AckPackage = l
YPZhang3943fbe2016-08-18 14:33:29 -0700116 if len(AckPackage) > 0:
117 FinAckText = FinAckText.strip()
118 FinAckText = FinAckText.split(" ")
119 AckPackage = AckPackage.strip()
120 AckPackage = AckPackage.split(" ")
121 tempResultDict['ACK'] = float("%.2f" % (float(AckPackage[1]) * 1000) )
122 tempResultDict['FA'] = float("%.2f" % (float(FinAckText[1]) * 1000) )
123 else:
124 return
YPZhang38fb1192016-08-11 11:03:38 -0700125 # calculate latency
126 if switchStatus == "up":
127 # up Latency
128 for d in resultDict[switchStatus]:
129 T_Ftemp = 0
130 F_Rtemp = 0
131 RQ_RRtemp = 0
132 try:
133 T_Ftemp = tempResultDict['Feature'] - tempResultDict['TCP']
134 F_Rtemp = tempResultDict['RQ'] - tempResultDict['Feature']
135 RQ_RRtemp = tempResultDict['RR'] - tempResultDict['RQ']
136 except KeyError:
137 main.log.warn("Tshark Result was incorrect!")
138 main.log.warn(tempResultDict)
139 return
140 if not warmup:
141 resultDict[switchStatus][d][ 'T_F' ].append( T_Ftemp )
142 resultDict[switchStatus][d][ 'F_R' ].append( F_Rtemp )
143 resultDict[switchStatus][d][ 'RQ_RR' ].append( RQ_RRtemp )
144
145 main.log.info("{} TCP to Feature: {}".format(d, str( T_Ftemp ) ) )
146 main.log.info("{} Feature to Role Request: {}".format(d, str(F_Rtemp)))
147 main.log.info("{} Role Request to Role Reply: {}".format(d, str(RQ_RRtemp)))
148
149 for i in range(1, main.numCtrls + 1):
150 RR_Dtemp = 0
151 D_Gtemp = 0
152 E_Etemp = 0
153 main.log.info("================================================")
154 # get onos metrics timestamps
155 try:
156 response = json.loads(main.CLIs[i - 1].topologyEventsMetrics())
157 DeviceTime = int( response.get("topologyDeviceEventTimestamp").get("value") )
158 main.log.info("ONOS{} device Event timestamp: {}".format(i, "%.2f" % DeviceTime))
159 GraphTime = int( response.get("topologyGraphEventTimestamp").get("value") )
160 main.log.info("ONOS{} Graph Event timestamp: {}".format(i, GraphTime))
161 except TypeError:
162 main.log.warn("TypeError")
163 break
164 except ValueError:
165 main.log.warn("Error to decode Json object!")
166 break
167 try:
168 RR_Dtemp = DeviceTime - tempResultDict['RR']
169 D_Gtemp = GraphTime - DeviceTime
170 E_Etemp = GraphTime - tempResultDict['TCP']
171 main.log.info("Role reply to Device:{}".format(RR_Dtemp))
172 main.log.info("Device to Graph:{}".format(D_Gtemp))
173 main.log.info("End to End:{}".format(E_Etemp))
174 main.log.info("================================================")
175 except KeyError:
176 main.log.warn("Tshark Result was incorrect!")
177 main.log.warn(tempResultDict)
178 return
179 except TypeError:
180 main.log.warn("TypeError")
181 break
182 except ValueError:
183 main.log.warn("Error to decode Json object!")
184 break
185 if not warmup:
186 resultDict[switchStatus]['node' + str(i)][ 'RR_D' ].append( RR_Dtemp )
187 resultDict[switchStatus]['node' + str(i)][ 'D_G' ].append( D_Gtemp )
188 resultDict[switchStatus]['node' + str(i)][ 'E_E' ].append( E_Etemp )
189
YPZhang841262e2016-08-23 17:20:39 -0700190 main.log.info( "Node {} Role Reply to Device: {}".format(str(i), str(RR_Dtemp) ) )
191 main.log.info( "Node {} Device to Graph: {}".format(str(i), str(D_Gtemp) ) )
192 main.log.info( "Node {} End to End: {}".format(str(i), str(E_Etemp) ) )
YPZhang38fb1192016-08-11 11:03:38 -0700193
194 if switchStatus == "down":
195 # down Latency
196 for d in resultDict[switchStatus]:
197 FA_Atemp = 0
198 try:
199 FA_Atemp = float("%.2f" % (tempResultDict['ACK'] - tempResultDict['FA']) )
200 except KeyError:
201 main.log.warn("Tshark Result was incorrect!")
202 main.log.warn(tempResultDict)
203 return
YPZhang841262e2016-08-23 17:20:39 -0700204
YPZhang38fb1192016-08-11 11:03:38 -0700205 if not warmup:
206 resultDict[switchStatus][d][ 'FA_A' ].append( FA_Atemp )
207 main.log.info( "{} FIN/ACK TO ACK {}:".format(d , FA_Atemp) )
208 for i in range(1, main.numCtrls + 1):
209 A_Dtemp = 0
210 D_Gtemp = 0
211 E_Etemp = 0
212
213 main.log.info("================================================")
214 # get onos metrics timestamps
215 try:
216 response = json.loads(main.CLIs[i - 1].topologyEventsMetrics())
217 DeviceTime = int( response.get("topologyDeviceEventTimestamp").get("value") )
218 main.log.info("ONOS{} device Event timestamp: {}".format(i, DeviceTime))
219 GraphTime = int( response.get("topologyGraphEventTimestamp").get("value") )
220 main.log.info("ONOS{} Graph Event timestamp: {}".format(i, GraphTime))
221 except TypeError:
222 main.log.warn("TypeError")
223 break
224 except ValueError:
225 main.log.warn("Error to decode Json object!")
226 break
227 main.log.info("================================================")
228 try:
229 A_Dtemp = float("%.2f" % (DeviceTime - tempResultDict['ACK']) )
230 D_Gtemp = GraphTime - DeviceTime
231 E_Etemp = float("%.2f" % (GraphTime - tempResultDict['FA']) )
232 main.log.info("ACK to device: {}".format(A_Dtemp))
233 main.log.info("Device ot Graph: {}".format(D_Gtemp))
234 main.log.info("End to End: {}".format(E_Etemp))
235 main.log.info("================================================")
236 except KeyError:
237 main.log.warn("Tshark Result was incorrect!")
238 main.log.warn(tempResultDict)
239 return
240 except TypeError:
241 main.log.warn("TypeError")
242 break
243 except ValueError:
244 main.log.warn("Error to decode Json object!")
245 break
246 if not warmup:
247 resultDict[switchStatus]['node' + str(i)][ 'A_D' ].append( A_Dtemp )
248 resultDict[switchStatus]['node' + str(i)][ 'D_G' ].append( D_Gtemp )
249 resultDict[switchStatus]['node' + str(i)][ 'E_E' ].append( E_Etemp )
YPZhang347b8ae2016-08-19 09:43:24 -0700250 main.CLIs[0].removeDevice( "of:0000000000000001" )
YPZhang38fb1192016-08-11 11:03:38 -0700251