173 | | 14:52:49 INFO : Configured logging from file /home/lnevers/gcf-2.9/src/gcf/stitcher_logging.conf |
174 | | 14:52:49 INFO : Reading slice IG-ST-1 credential... |
175 | | 14:52:50 INFO : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+IG-ST-1 expires on 2015-06-10 18:52:04 UTC |
176 | | 14:52:50 INFO : Calling SCS... |
177 | | 14:52:53 INFO : Multi-AM reservation will include resources from these aggregates: |
178 | | 14:52:53 INFO : <Aggregate utah-stitch> |
179 | | 14:52:53 INFO : <Aggregate gpo-ig> |
180 | | 14:52:53 INFO : <Aggregate al2s> |
181 | | 14:52:53 INFO : <Aggregate utahddc-ig> |
182 | | 14:52:53 INFO : Gathering currently available VLAN tags at <Aggregate utahddc-ig>... |
183 | | 14:52:57 INFO : Stitcher doing createsliver at <Aggregate utah-stitch>... |
184 | | 14:53:16 INFO : ... Allocation at <Aggregate utah-stitch> complete. |
185 | | 14:53:16 INFO : Stitcher doing createsliver at <Aggregate gpo-ig>... |
186 | | 14:53:33 INFO : ... Allocation at <Aggregate gpo-ig> complete. |
187 | | 14:53:33 INFO : Stitcher doing createsliver at <Aggregate al2s>... |
188 | | 14:53:38 INFO : ... Allocation at <Aggregate al2s> complete. |
189 | | 14:53:38 INFO : Stitcher doing createsliver at <Aggregate utahddc-ig>... |
190 | | 14:53:58 INFO : ... Allocation at <Aggregate utahddc-ig> complete. |
191 | | 14:53:58 INFO : All aggregates are complete. |
192 | | 14:53:58 INFO : Your resources expire at 2015-06-08T18:42:57 (UTC). |
193 | | 14:53:58 INFO : Saved combined reservation RSpec at 4 AM(s) to file '/home/lnevers/gcf-test/stitch-test/Utah-stitch/IG-ST-1-manifest-rspec-multiam-combined.xml' |
| 173 | 16:12:31 INFO : Configured logging from file /home/lnevers/gcf-2.9/src/gcf/stitcher_logging.conf |
| 174 | 16:12:31 INFO : Reading slice IG-ST-1 credential... |
| 175 | 16:12:32 INFO : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+IG-ST-1 expires on 2015-06-10 18:52:04 UTC |
| 176 | 16:12:32 INFO : Calling SCS... |
| 177 | 16:12:32 INFO : Multi-AM reservation will include resources from these aggregates: |
| 178 | 16:12:32 INFO : <Aggregate utc-ig> |
| 179 | 16:12:32 INFO : <Aggregate utah-stitch> |
| 180 | 16:12:32 INFO : <Aggregate al2s> |
| 181 | 16:12:32 INFO : <Aggregate utahddc-ig> |
| 182 | 16:12:32 INFO : Gathering currently available VLAN tags at <Aggregate utahddc-ig>... |
| 183 | 16:12:36 INFO : Stitcher doing createsliver at <Aggregate utc-ig>... |
| 184 | 16:12:53 INFO : ... Allocation at <Aggregate utc-ig> complete. |
| 185 | 16:12:53 INFO : Stitcher doing createsliver at <Aggregate utah-stitch>... |
| 186 | 16:13:11 INFO : ... Allocation at <Aggregate utah-stitch> complete. |
| 187 | 16:13:11 INFO : Stitcher doing createsliver at <Aggregate al2s>... |
| 188 | 16:13:16 INFO : ... Allocation at <Aggregate al2s> complete. |
| 189 | 16:13:16 INFO : Stitcher doing createsliver at <Aggregate utahddc-ig>... |
| 190 | 16:13:35 INFO : ... Allocation at <Aggregate utahddc-ig> complete. |
| 191 | 16:13:35 INFO : All aggregates are complete. |
| 192 | 16:13:35 INFO : Your resources expire at 2015-06-08T20:02:36 (UTC). |
| 193 | 16:13:35 INFO : Saved combined reservation RSpec at 4 AM(s) to file '/home/lnevers/gcf-test/stitch-test/Utah-stitch/IG-ST-1-manifest-rspec-multiam-combined.xml' |
206 | | ssh -p 33594 -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@pc11.utahddc.geniracks.net |
207 | | }}} |
208 | | Verified ICMP connectivity by pinging the GPO IG host from the Utha DDC IG host: |
209 | | {{{ |
210 | | $ remote-execute -a utahddc-ig IG-ST-1 -m "ping -c 5 192.168.1.1" |
211 | | }}} |
212 | | |
213 | | Also verified UDP and TCP connectivity with iperf: |
214 | | {{{ |
215 | | |
216 | | XXX |
217 | | |
| 206 | ssh -p 33594 -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@pc7.utahddc.geniracks.net |
| 207 | }}} |
| 208 | Verified ICMP, UDP and TCP connectivity from the Utah DDC IG to UTC IG: |
| 209 | {{{ |
| 210 | lnevers@ddc:~$ ping -c 5 -q 192.168.1.1 |
| 211 | PING 192.168.1.1 (192.168.1.1) 56(84) bytes of data. |
| 212 | |
| 213 | --- 192.168.1.1 ping statistics --- |
| 214 | 5 packets transmitted, 5 received, 0% packet loss, time 4007ms |
| 215 | rtt min/avg/max/mdev = 54.467/65.530/108.765/21.618 ms |
| 216 | lnevers@ddc:~$ iperf -c 192.168.1.1 -t 20 |
| 217 | ------------------------------------------------------------ |
| 218 | Client connecting to 192.168.1.1, TCP port 5001 |
| 219 | TCP window size: 23.5 KByte (default) |
| 220 | ------------------------------------------------------------ |
| 221 | [ 3] local 192.168.1.2 port 58644 connected with 192.168.1.1 port 5001 |
| 222 | [ ID] Interval Transfer Bandwidth |
| 223 | [ 3] 0.0-20.1 sec 47.2 MBytes 19.7 Mbits/sec |
| 224 | lnevers@ddc:~$ iperf -c 192.168.1.1 -t 20 -u -b 1M |
| 225 | ------------------------------------------------------------ |
| 226 | Client connecting to 192.168.1.1, UDP port 5001 |
| 227 | Sending 1470 byte datagrams |
| 228 | UDP buffer size: 224 KByte (default) |
| 229 | ------------------------------------------------------------ |
| 230 | [ 3] local 192.168.1.2 port 46988 connected with 192.168.1.1 port 5001 |
| 231 | [ ID] Interval Transfer Bandwidth |
| 232 | [ 3] 0.0-20.0 sec 2.39 MBytes 1000 Kbits/sec |
| 233 | [ 3] Sent 1702 datagrams |
| 234 | [ 3] Server Report: |
| 235 | [ 3] 0.0-20.0 sec 2.39 MBytes 1.00 Mbits/sec 0.138 ms 0/ 1702 (0%) |
| 236 | lnevers@ddc:~$ |
225 | | 15:06:05 INFO : Configured logging from file /home/lnevers/gcf-2.9/src/gcf/stitcher_logging.conf |
226 | | 15:06:06 INFO : Reading slice IG-ST-2 credential... |
227 | | 15:06:06 INFO : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+IG-ST-2 expires on 2015-06-10 19:05:18 UTC |
228 | | 15:06:06 INFO : Calling SCS... |
229 | | 15:06:09 INFO : Multi-AM reservation will include resources from these aggregates: |
230 | | 15:06:09 INFO : <Aggregate utah-stitch> |
231 | | 15:06:09 INFO : <Aggregate gpo-ig> |
232 | | 15:06:09 INFO : <Aggregate al2s> |
233 | | 15:06:09 INFO : <Aggregate utah-ig> |
234 | | 15:06:09 INFO : Gathering currently available VLAN tags at <Aggregate utah-ig>... |
235 | | 15:06:12 INFO : Stitcher doing createsliver at <Aggregate utah-stitch>... |
236 | | 15:06:33 INFO : ... Allocation at <Aggregate utah-stitch> complete. |
237 | | 15:06:33 INFO : Stitcher doing createsliver at <Aggregate gpo-ig>... |
238 | | 15:06:48 INFO : ... Allocation at <Aggregate gpo-ig> complete. |
239 | | 15:06:48 INFO : Stitcher doing createsliver at <Aggregate al2s>... |
240 | | 15:06:55 INFO : ... Allocation at <Aggregate al2s> complete. |
241 | | 15:06:55 INFO : Stitcher doing createsliver at <Aggregate utah-ig>... |
242 | | 15:07:11 INFO : ... Allocation at <Aggregate utah-ig> complete. |
243 | | 15:07:11 INFO : All aggregates are complete. |
244 | | 15:07:11 INFO : Your resources expire at 2015-06-08T18:56:12 (UTC). |
245 | | 15:07:11 INFO : Saved combined reservation RSpec at 4 AM(s) to file '/home/lnevers/gcf-test/stitch-test/Utah-stitch/IG-ST-2-manifest-rspec-multiam-combined.xml' |
| 244 | 16:12:35 INFO : Configured logging from file /home/lnevers/gcf-2.9/src/gcf/stitcher_logging.conf |
| 245 | 16:12:36 INFO : Reading slice IG-ST-2 credential... |
| 246 | 16:12:36 INFO : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+IG-ST-2 expires on 2015-06-10 19:05:18 UTC |
| 247 | 16:12:36 INFO : Calling SCS... |
| 248 | 16:12:37 INFO : Multi-AM reservation will include resources from these aggregates: |
| 249 | 16:12:37 INFO : <Aggregate utah-stitch> |
| 250 | 16:12:37 INFO : <Aggregate al2s> |
| 251 | 16:12:37 INFO : <Aggregate nps-ig> |
| 252 | 16:12:37 INFO : <Aggregate utah-ig> |
| 253 | 16:12:37 INFO : Gathering currently available VLAN tags at <Aggregate utah-ig>... |
| 254 | 16:12:40 INFO : Stitcher doing createsliver at <Aggregate utah-stitch>... |
| 255 | 16:13:00 INFO : ... Allocation at <Aggregate utah-stitch> complete. |
| 256 | 16:13:00 INFO : Stitcher doing createsliver at <Aggregate nps-ig>... |
| 257 | 16:13:20 INFO : ... Allocation at <Aggregate nps-ig> complete. |
| 258 | 16:13:20 INFO : Stitcher doing createsliver at <Aggregate al2s>... |
| 259 | 16:13:22 ERROR : {'output': 'Exception: requested VLAN unavailable: sdn-sw.salt.net.internet2.edu,eth7/1 VLAN=3497', 'code': {'geni_code': 24}} |
| 260 | 16:13:22 INFO : Deleting some reservations to retry, avoiding failed VLAN... |
| 261 | 16:13:22 INFO : Doing deletesliver at <Aggregate utah-stitch>... |
| 262 | 16:13:47 INFO : Will put <Aggregate al2s> back in the pool to allocate. Got: Retrying reservations at earlier AMs to avoid unavailable VLAN tag at <Aggregate al2s>.... |
| 263 | 16:13:47 INFO : Pausing for 30 seconds for Aggregates to free up resources... |
| 264 | |
| 265 | |
| 266 | 16:14:17 INFO : Checking that prior reservation at <Aggregate utah-stitch> has been cleared up.... |
| 267 | 16:14:19 ERROR : {'output': 'No slice or aggregate here', 'code': {'protogeni_error_log': 'urn:publicid:IDN+stitch.geniracks.net+log+7ffe2c0afc29a12114a26e281fbcb059', 'am_type': 'protogeni', 'geni_code': 12, 'am_code': 12, 'protogeni_error_url': 'https://www.stitch.geniracks.net/spewlogfile.php3?logfile=7ffe2c0afc29a12114a26e281fbcb059'}, 'value': 0} |
| 268 | 16:14:19 INFO : ... it is, so can try a new reservation. |
| 269 | 16:14:19 INFO : Stitcher doing createsliver at <Aggregate utah-stitch>... |
| 270 | 16:14:39 INFO : ... Allocation at <Aggregate utah-stitch> complete. |
| 271 | 16:14:39 INFO : Stitcher doing createsliver at <Aggregate al2s>... |
| 272 | 16:14:53 INFO : ... Allocation at <Aggregate al2s> complete. |
| 273 | 16:14:53 INFO : Stitcher doing createsliver at <Aggregate utah-ig>... |
| 274 | 16:15:08 INFO : ... Allocation at <Aggregate utah-ig> complete. |
| 275 | 16:15:08 INFO : All aggregates are complete. |
| 276 | 16:15:08 INFO : Your resources expire at 2015-06-08T20:02:40 (UTC). |
| 277 | 16:15:08 INFO : Saved combined reservation RSpec at 4 AM(s) to file '/home/lnevers/gcf-test/stitch-test/Utah-stitch/IG-ST-2-manifest-rspec-multiam-combined.xml' |
| 306 | 16:15:04 INFO : Configured logging from file /home/lnevers/gcf-2.9/src/gcf/stitcher_logging.conf |
| 307 | 16:15:05 INFO : Reading slice IG-ST-3 credential... |
| 308 | 16:15:05 INFO : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+IG-ST-3 expires on 2015-06-10 19:23:31 UTC |
| 309 | 16:15:05 INFO : Calling SCS... |
| 310 | 16:15:06 INFO : Multi-AM reservation will include resources from these aggregates: |
| 311 | 16:15:06 INFO : <Aggregate utah-stitch> |
| 312 | 16:15:06 INFO : <Aggregate utah-pg> |
| 313 | 16:15:06 INFO : <Aggregate utahddc-ig> |
| 314 | 16:15:06 INFO : <Aggregate utah-ig> |
| 315 | 16:15:06 INFO : Gathering currently available VLAN tags at <Aggregate utah-pg>... |
| 316 | 16:15:27 INFO : Gathering currently available VLAN tags at <Aggregate utahddc-ig>... |
| 317 | 16:15:32 INFO : Gathering currently available VLAN tags at <Aggregate utah-ig>... |
| 318 | 16:15:34 INFO : Stitcher doing createsliver at <Aggregate utah-stitch>... |
| 319 | 16:15:56 INFO : ... Allocation at <Aggregate utah-stitch> complete. |
| 320 | 16:15:56 INFO : Stitcher doing createsliver at <Aggregate utah-pg>... |
| 321 | 16:16:31 INFO : ... Allocation at <Aggregate utah-pg> complete. |
| 322 | 16:16:31 INFO : Stitcher doing createsliver at <Aggregate utahddc-ig>... |
| 323 | 16:16:54 INFO : ... Allocation at <Aggregate utahddc-ig> complete. |
| 324 | 16:16:54 INFO : Stitcher doing createsliver at <Aggregate utah-ig>... |
| 325 | 16:17:09 INFO : ... Allocation at <Aggregate utah-ig> complete. |
| 326 | 16:17:09 INFO : All aggregates are complete. |
| 327 | 16:17:09 INFO : Your resources expire at 2015-06-08T20:05:34 (UTC). |
| 328 | 16:17:09 INFO : Saved combined reservation RSpec at 4 AM(s) to file '/home/lnevers/gcf-test/stitch-test/Utah-stitch/IG-ST-3-manifest-rspec-multiam-combined.xml' |
| 329 | Success: Reserved resources in slice IG-ST-3 at 4 Aggregates (including 1 intermediate aggregate(s) not in the original request), creating 2 stitched link(s). |