Changes between Version 7 and Version 8 of GeniNetworkStitchingConfirmationTestStatus/Clemson


Ignore:
Timestamp:
03/11/15 13:22:07 (4 years ago)
Author:
lnevers@bbn.com
Comment:

--

Legend:

Unmodified
Added
Removed
Modified
  • GeniNetworkStitchingConfirmationTestStatus/Clemson

    v7 v8  
    275275Create a slice and then create the stitched slivers with the RSpec [http://groups.geni.net/geni/browser/trunk/stitch-examples/Clemson/IG-ST-3.rspec IG-ST-3.rspec]:
    276276{{{
    277 omni.py createslice IG-ST-3
    278 stitcher.py createsliver IG-ST-3 IG-ST-3.rspec -o
     277$ stitcher.py createsliver IG-ST-3 IG-ST-3.rspec -o
     27812:25:34 INFO    : Configured logging from file /home/lnevers/gcf-2.9-pre1/src/gcf/stitcher_logging.conf
     27912:25:35 INFO    : Reading slice IG-ST-3 credential...
     28012:25:35 INFO    : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+IG-ST-3 expires on 2015-03-18 16:25:32 UTC
     28112:25:35 INFO    : Calling SCS...
     28212:25:41 INFO    : Multi-AM reservation will include resources from these aggregates:
     28312:25:41 INFO    :      <Aggregate ukypks2-ig>
     28412:25:41 INFO    :      <Aggregate gpo-ig>
     28512:25:41 INFO    :      <Aggregate clemson-ig>
     28612:25:41 INFO    :      <Aggregate al2s>
     28712:25:41 INFO    :      <Aggregate ion>
     28812:25:41 INFO    : Stitcher doing createsliver at <Aggregate ukypks2-ig>...
     28912:25:58 INFO    : ... Allocation at <Aggregate ukypks2-ig> complete.
     29012:25:58 INFO    : Stitcher doing createsliver at <Aggregate gpo-ig>...
     29112:26:18 INFO    : ... Allocation at <Aggregate gpo-ig> complete.
     29212:26:18 INFO    : Stitcher doing createsliver at <Aggregate clemson-ig>...
     29312:26:33 INFO    : ... Allocation at <Aggregate clemson-ig> complete.
     29412:26:34 INFO    : Stitcher doing createsliver at <Aggregate al2s>...
     29512:26:36 ERROR   :  {'output': 'Exception: requested VLAN unavailable: sdn-sw.atla.net.internet2.edu,eth15/1 VLAN=3995', 'code': {'geni_code': 24}}
     29612:26:36 INFO    : Will put <Aggregate al2s> back in the pool to allocate. Got: VLAN was unavailable. Retry <Aggregate al2s> 2nd time with <Hop u'urn:publicid:IDN+al2s.internet2.edu+interface+sdn-sw.atla.net.internet2.edu:eth15/1:*' on path u'link1'> new suggested 3962 (not 3995)
     29712:26:36 INFO    : Pausing for 30 seconds for Aggregates to free up resources...
     298
     299
     30012:27:06 INFO    : Stitcher doing createsliver at <Aggregate al2s>...
     30112:27:11 INFO    : ... Allocation at <Aggregate al2s> complete.
     30212:27:11 INFO    : Stitcher doing createsliver at <Aggregate ion>...
     30312:27:57 INFO    : DCN AM <Aggregate ion>: must wait for status ready....
     30412:27:57 INFO    : Pausing 30 seconds to let circuit become ready...
     30512:28:34 INFO    : Pausing 30 seconds to let circuit become ready...
     30612:29:12 WARNING : sliverstatus: 156111 is (still) failed at <Aggregate ion>. Delete and retry.
     30712:29:12 WARNING : sliverstatus: 156121 is (still) failed at <Aggregate ion>. Delete and retry.
     30812:29:12 WARNING :   Status had error message: VLAN cancelled by rollback from contingent failure
     30912:29:12 INFO    : Doing deletesliver at <Aggregate ion>...
     31012:29:17 WARNING : <Aggregate ion> says requested VLAN was unavailable at <Hop u'urn:publicid:IDN+ion.internet2.edu+interface+rtr.atla:xe-0/3/0:al2s' on path u'link'>
     31112:29:17 INFO    : Will put <Aggregate ion> back in the pool to allocate. Got: VLAN was unavailable. Retry <Aggregate ion> 2nd time with <Hop u'urn:publicid:IDN+ion.internet2.edu+interface+rtr.atla:xe-0/3/0:al2s' on path u'link'> new suggested 3988 (not 3940)
     31212:29:17 INFO    : Pausing for 600 seconds for Aggregates to free up resources...
     313
     314
     31512:39:17 INFO    : Stitcher doing createsliver at <Aggregate ion>...
     31612:40:03 INFO    : DCN AM <Aggregate ion>: must wait for status ready....
     31712:40:03 INFO    : Pausing 30 seconds to let circuit become ready...
     31812:40:40 INFO    : Pausing 30 seconds to let circuit become ready...
     31912:41:17 WARNING : sliverstatus: 156131 is (still) failed at <Aggregate ion>. Delete and retry.
     32012:41:17 WARNING : sliverstatus: 156141 is (still) failed at <Aggregate ion>. Delete and retry.
     32112:41:17 WARNING :   Status had error message: VLAN cancelled by rollback from contingent failure
     32212:41:17 INFO    : Doing deletesliver at <Aggregate ion>...
     32312:41:23 WARNING : <Aggregate ion> says requested VLAN was unavailable at <Hop u'urn:publicid:IDN+ion.internet2.edu+interface+rtr.atla:xe-0/3/0:al2s' on path u'link'>
     32412:41:23 INFO    : Will put <Aggregate ion> back in the pool to allocate. Got: VLAN was unavailable. Retry <Aggregate ion> 3rd time with <Hop u'urn:publicid:IDN+ion.internet2.edu+interface+rtr.atla:xe-0/3/0:al2s' on path u'link'> new suggested 3974 (not 3988)
     32512:41:23 INFO    : Pausing for 600 seconds for Aggregates to free up resources...
     326
     327
     32812:51:23 INFO    : Stitcher doing createsliver at <Aggregate ion>...
     32912:52:25 INFO    : DCN AM <Aggregate ion>: must wait for status ready....
     33012:52:25 INFO    : Pausing 30 seconds to let circuit become ready...
     33112:53:02 INFO    : Pausing 30 seconds to let circuit become ready...
     33212:53:39 WARNING : sliverstatus: 156171 is (still) failed at <Aggregate ion>. Delete and retry.
     33312:53:39 WARNING : sliverstatus: 156181 is (still) failed at <Aggregate ion>. Delete and retry.
     33412:53:39 WARNING :   Status had error message: VLAN cancelled by rollback from contingent failure
     33512:53:39 INFO    : Doing deletesliver at <Aggregate ion>...
     33612:53:45 WARNING : <Aggregate ion> says requested VLAN was unavailable at <Hop u'urn:publicid:IDN+ion.internet2.edu+interface+rtr.atla:xe-0/3/0:al2s' on path u'link'>
     33712:53:45 WARNING : Stitching failed but will retry: Circuit reservation failed at <Aggregate ion>. Try again from the SCS. (Error: Too many failures to find a VLAN tag (<Aggregate ion> reports selected VLAN is unavailable for <Hop u'urn:publicid:IDN+ion.internet2.edu+interface+rtr.atla:xe-0/3/0:al2s' on path u'link'>: Sliver status for circuit 156171 was (still): failed: VLAN PCE(PCE_CREATE_FAILED): 'There are no VLANs available on link ion.internet2.edu:rtr.atla:xe-0/3/0:al2s  on reservation ion.internet2.edu-156171 in VLAN PCE'.
     338Sliver status for circuit 156181 was (still): failed: VLAN cancelled by rollback from contingent failure))
     33912:53:45 INFO    : Deleting existing reservations...
     34012:53:45 INFO    : Doing deletesliver at <Aggregate ukypks2-ig>...
     34112:53:50 INFO    : Deleted reservation at <Aggregate ukypks2-ig>.
     34212:53:50 INFO    : Doing deletesliver at <Aggregate gpo-ig>...
     34312:53:52 INFO    : Deleted reservation at <Aggregate gpo-ig>.
     34412:53:52 INFO    : Doing deletesliver at <Aggregate clemson-ig>...
     34512:53:54 INFO    : Deleted reservation at <Aggregate clemson-ig>.
     34612:53:54 INFO    : Doing deletesliver at <Aggregate al2s>...
     34712:55:28 INFO    : Deleted reservation at <Aggregate al2s>.
     34812:55:28 INFO    : Calling SCS for the 2nd time...
     34912:55:32 INFO    : Pausing for 600 seconds for Aggregates to free up resources...
     350
     351
     35213:05:32 INFO    : Multi-AM reservation will include resources from these aggregates:
     35313:05:32 INFO    :      <Aggregate ukypks2-ig>
     35413:05:32 INFO    :      <Aggregate gpo-ig>
     35513:05:32 INFO    :      <Aggregate clemson-ig>
     35613:05:32 INFO    :      <Aggregate al2s>
     35713:05:32 INFO    :      <Aggregate ion>
     35813:05:32 INFO    : Stitcher doing createsliver at <Aggregate ukypks2-ig>...
     35913:05:49 INFO    : ... Allocation at <Aggregate ukypks2-ig> complete.
     36013:05:49 INFO    : Stitcher doing createsliver at <Aggregate gpo-ig>...
     36113:06:04 INFO    : ... Allocation at <Aggregate gpo-ig> complete.
     36213:06:04 INFO    : Stitcher doing createsliver at <Aggregate clemson-ig>...
     36313:06:21 INFO    : ... Allocation at <Aggregate clemson-ig> complete.
     36413:06:21 INFO    : Stitcher doing createsliver at <Aggregate al2s>...
     36513:06:26 INFO    : ... Allocation at <Aggregate al2s> complete.
     36613:06:26 INFO    : Stitcher doing createsliver at <Aggregate ion>...
     36713:07:11 INFO    : DCN AM <Aggregate ion>: must wait for status ready....
     36813:07:11 INFO    : Pausing 30 seconds to let circuit become ready...
     36913:07:48 INFO    : Pausing 30 seconds to let circuit become ready...
     37013:08:27 INFO    : DCN circuit 156201 is ready at <Aggregate ion>
     37113:08:27 INFO    : DCN circuit 156191 is ready at <Aggregate ion>
     37213:08:34 INFO    : ... Allocation at <Aggregate ion> complete.
     37313:08:34 INFO    : All aggregates are complete.
     37413:08:34 INFO    : Your resources expire at 2015-03-17T16:55:32 (UTC).
     37513:08:34 INFO    : Saved combined reservation RSpec at 5 AMs to file '/home/lnevers/gcf-test/stitch-test/Clemson/IG-ST-3-manifest-rspec-multiam-combined.xml'
     376Success: Reserved resources in slice IG-ST-3 at 5 Aggregates (including 2 intermediate aggregate(s) not in the original request), creating 2 stitched link(s).
    279377}}}
    280378
     
    283381$ readyToLogin.py IG-ST-3 -a clemson-ig
    284382  ....
     383ig-clem's geni_status is: ready
     384User lnevers logs in to ig-clem using:
     385        ssh -p 36154  -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@pc3.instageni.clemson.edu
     386
    285387}}}
    286388Login to the Clemson host and ping each remote:
    287389{{{
    288390#ping GPO IG
    289 ping 192.168.2.1 -c 60 -q
     391lnevers@ig-clem:~$ ping 192.168.2.1 -c 60 -q
     392PING 192.168.2.1 (192.168.2.1) 56(84) bytes of data.
     393
     394--- 192.168.2.1 ping statistics ---
     39560 packets transmitted, 60 received, 0% packet loss, time 59109ms
     396rtt min/avg/max/mdev = 26.360/26.877/35.646/1.166 ms
     397
    290398# UKYPKS2 IG
    291 ping 192.168.4.1 -c 60 -q
     399lnevers@ig-clem:~$ ping 192.168.4.1 -c 60 -q
     400PING 192.168.4.1 (192.168.4.1) 56(84) bytes of data.
     401
     402--- 192.168.4.1 ping statistics ---
     40360 packets transmitted, 60 received, 0% packet loss, time 59102ms
     404rtt min/avg/max/mdev = 16.292/16.564/16.848/0.143 ms
    292405}}}
    293406