Changes between Version 2 and Version 3 of GeniNetworkStitchingConfirmationTestStatus/Stanford


Ignore:
Timestamp:
02/03/14 10:36:41 (6 years ago)
Author:
lnevers@bbn.com
Comment:

--

Legend:

Unmodified
Added
Removed
Modified
  • GeniNetworkStitchingConfirmationTestStatus/Stanford

    v2 v3  
    5454{{{
    5555$ omni.py createslice IG-ST-1
    56 08:39:39 INFO     omni: Downloaded latest `agg_nick_cache` from 'http://trac.gpolab.bbn.com/gcf/raw-attachment/wiki/Omni/agg_nick_cache' and copied to '/home/lnevers/.gcf/agg_nick_cache'.
    57 08:39:39 INFO     omni: Loading agg_nick_cache file '/home/lnevers/.gcf/agg_nick_cache'
    58 08:39:39 INFO     omni: Loading config file /home/lnevers/.gcf/omni_config
    59 08:39:39 INFO     omni: Using control framework portal
    60 08:39:40 INFO     omni: Created slice with Name IG-ST-1, URN urn:publicid:IDN+ch.geni.net:ln-prj+slice+IG-ST-1, Expiration 2014-02-05 19:16:27
    61 08:39:40 INFO     omni:  ------------------------------------------------------------
    62 08:39:40 INFO     omni:  Completed createslice:
     5610:12:16 INFO     omni: Loading agg_nick_cache file '/home/lnevers/.gcf/agg_nick_cache'
     5710:12:16 INFO     omni: Loading config file /home/lnevers/.gcf/omni_config
     5810:12:16 INFO     omni: Using control framework portal
     5910:12:17 INFO     omni: Created slice with Name IG-ST-1, URN urn:publicid:IDN+ch.geni.net:ln-prj+slice+IG-ST-1, Expiration 2014-02-05 19:16:27
     6010:12:17 INFO     omni:  ------------------------------------------------------
     6110:12:17 INFO     omni:  Completed createslice:
    6362Args: createslice IG-ST-1
     63
    6464  Result Summary: Created slice with Name IG-ST-1, URN urn:publicid:IDN+ch.geni.net:ln-prj+slice+IG-ST-1, Expiration 2014-02-05 19:16:27
    65 08:39:40 INFO     omni:  ============================================================
     65 
     6610:12:17 INFO     omni:  ======================================================
    6667
    6768stitcher.py createsliver IG-ST-1 IG-ST-1-ion.rspec -o
     
    8687{{{
    8788$ omni.py createslice IG-ST-2
    88 08:40:53 INFO     omni: Loading agg_nick_cache file '/home/lnevers/.gcf/agg_nick_cache'
    89 08:40:53 INFO     omni: Loading config file /home/lnevers/.gcf/omni_config
    90 08:40:53 INFO     omni: Using control framework portal
    91 08:40:53 INFO     omni: Created slice with Name IG-ST-2, URN urn:publicid:IDN+ch.geni.net:ln-prj+slice+IG-ST-2, Expiration 2014-02-05 19:19:45
    92 08:40:53 INFO     omni:  ------------------------------------------------------------
    93 08:40:53 INFO     omni:  Completed createslice:
     8910:22:07 INFO     omni: Loading agg_nick_cache file '/home/lnevers/.gcf/agg_nick_cache'
     9010:22:07 INFO     omni: Loading config file /home/lnevers/.gcf/omni_config
     9110:22:07 INFO     omni: Using control framework portal
     9210:22:08 INFO     omni: Created slice with Name IG-ST-2, URN urn:publicid:IDN+ch.geni.net:ln-prj+slice+IG-ST-2, Expiration 2014-02-05 19:19:45
     9310:22:08 INFO     omni:  ------------------------------------------------------
     9410:22:08 INFO     omni:  Completed createslice:
    9495Args: createslice IG-ST-2
    9596  Result Summary: Created slice with Name IG-ST-2, URN urn:publicid:IDN+ch.geni.net:ln-prj+slice+IG-ST-2, Expiration 2014-02-05 19:19:45
    96 08:40:53 INFO     omni:  ============================================================
     9710:22:08 INFO     omni:  ======================================================
    9798
    9899$ stitcher.py createsliver IG-ST-2 IG-ST-2.rspec -o
    99 08:41:17 INFO     stitcher: Loading agg_nick_cache file '/home/lnevers/.gcf/agg_nick_cache'
    100 08:41:17 INFO     stitcher: Loading config file /home/lnevers/.gcf/omni_config
    101 08:41:17 INFO     stitcher: Using control framework portal
    102 
    103 08:41:17 INFO     stitcher: Checking that slice IG-ST-2 is valid...
    104 08:41:18 INFO     stitcher: Slice urn:publicid:IDN+ch.geni.net:ln-prj+slice+IG-ST-2 expires on 2014-02-05 19:19:45 UTC
    105 08:41:19 INFO     stitcher: <Aggregate urn:publicid:IDN+instageni.stanford.edu+authority+cm> speaks AM API v3, but sticking with v2
    106 08:41:19 INFO     stitcher: <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm> speaks AM API v3, but sticking with v2
    107 08:41:19 INFO     stitcher: Stitched reservation will include resources from these aggregates:
    108 08:41:19 INFO     stitcher:     <Aggregate urn:publicid:IDN+instageni.stanford.edu+authority+cm>
    109 08:41:19 INFO     stitcher:     <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm>
    110 08:41:19 INFO     stitcher:     <Aggregate urn:publicid:IDN+ion.internet2.edu+authority+am>
    111 08:41:19 INFO     stitch.Aggregate: Writing to '/tmp/IG-ST-2-createsliver-request-11-instageni-stanford-edu.xml'
    112 08:41:19 INFO     stitch.Aggregate:
     10010:25:50 INFO     stitcher: Loading agg_nick_cache file '/home/lnevers/.gcf/agg_nick_cache'
     10110:25:50 INFO     stitcher: Loading config file /home/lnevers/.gcf/omni_config
     10210:25:50 INFO     stitcher: Using control framework portal
     10310:25:51 INFO     stitcher: Checking that slice IG-ST-2 is valid...
     10410:25:51 INFO     stitcher: Slice urn:publicid:IDN+ch.geni.net:ln-prj+slice+IG-ST-2 expires on 2014-02-05 19:19:45 UTC
     10510:25:52 INFO     stitcher: <Aggregate urn:publicid:IDN+instageni.stanford.edu+authority+cm> speaks AM API v3, but sticking with v2
     10610:25:53 INFO     stitcher: <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm> speaks AM API v3, but sticking with v2
     10710:25:53 INFO     stitcher: Stitched reservation will include resources from these aggregates:
     10810:25:53 INFO     stitcher:     <Aggregate urn:publicid:IDN+instageni.stanford.edu+authority+cm>
     10910:25:53 INFO     stitcher:     <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm>
     11010:25:53 INFO     stitcher:     <Aggregate urn:publicid:IDN+ion.internet2.edu+authority+am>
     11110:25:53 INFO     stitch.Aggregate: Writing to '/tmp/IG-ST-2-createsliver-request-11-instageni-stanford-edu.xml'
     11210:25:53 INFO     stitch.Aggregate:
    113113        Stitcher doing createsliver at https://www.instageni.stanford.edu:12369/protogeni/xmlrpc/am
    114 08:41:35 INFO     stitch.Aggregate: Allocation at <Aggregate urn:publicid:IDN+instageni.stanford.edu+authority+cm> complete.
    115 08:41:35 INFO     stitch.Aggregate: Writing to '/tmp/IG-ST-2-createsliver-request-11-instageni-gpolab-bbn-com.xml'
    116 08:41:35 INFO     stitch.Aggregate:
     11410:26:11 INFO     stitch.Aggregate: Allocation at <Aggregate urn:publicid:IDN+instageni.stanford.edu+authority+cm> complete.
     11510:26:11 INFO     stitch.Aggregate: Writing to '/tmp/IG-ST-2-createsliver-request-11-instageni-gpolab-bbn-com.xml'
     11610:26:11 INFO     stitch.Aggregate:
    117117        Stitcher doing createsliver at https://boss.instageni.gpolab.bbn.com:12369/protogeni/xmlrpc/am
    118 08:41:51 ERROR    omni:  {'output': "vlan tag 3748 for 'link' not available", 'code': {'protogeni_error_log': 'urn:publicid:IDN+instageni.gpolab.bbn.com+log+30639d594f838407f8b018839e931092', 'am_type': 'protogeni', 'geni_code': 1, 'am_code': 1, 'protogeni_error_url': 'https://boss.instageni.gpolab.bbn.com/spewlogfile.php3?logfile=30639d594f838407f8b018839e931092'}, 'value': 0}
    119 08:41:51 INFO     stitch.Aggregate: Got AMAPIError doing createsliver IG-ST-2 at <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm>: AMAPIError: Error from Aggregate: code 1. protogeni AM code: 1: vlan tag 3748 for 'link' not available.
    120 08:41:51 INFO     stitch.launcher: Will put <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm> back in the pool to allocate. Got Retry <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm> 2th time with <Hop u'urn:publicid:IDN+instageni.gpolab.bbn.com+interface+procurve2:5.24.ion.newy.ae0' on path u'link'> new suggested 3708 (not 3748)
    121 08:41:51 INFO     stitch.launcher: Pausing for 30 seconds for Aggregates to free up resources...
     11810:26:24 ERROR    omni:  {'output': "vlan tag 3732 for 'link1' not available", 'code': {'protogeni_error_log': 'urn:publicid:IDN+instageni.gpolab.bbn.com+log+0d50801c0811b792b7188f35fb5a91ac', 'am_type': 'protogeni', 'geni_code': 1, 'am_code': 1, 'protogeni_error_url': 'https://boss.instageni.gpolab.bbn.com/spewlogfile.php3?logfile=0d50801c0811b792b7188f35fb5a91ac'}, 'value': 0}
     11910:26:24 INFO     stitch.Aggregate: Got AMAPIError doing createsliver IG-ST-2 at <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm>: AMAPIError: Error from Aggregate: code 1. protogeni AM code: 1: vlan tag 3732 for 'link1' not available.
     12010:26:24 INFO     stitch.launcher: Will put <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm> back in the pool to allocate. Got Retry <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm> 2th time with <Hop u'urn:publicid:IDN+instageni.gpolab.bbn.com+interface+procurve2:5.24.ion.newy.ae0' on path u'link1'> new suggested 3720 (not 3732)
     12110:26:24 INFO     stitch.launcher: Pausing for 30 seconds for Aggregates to free up resources...
    122122
    123123
    124 08:42:21 INFO     stitch.Aggregate: Writing to '/tmp/IG-ST-2-createsliver-request-12-instageni-gpolab-bbn-com.xml'
    125 08:42:21 INFO     stitch.Aggregate:
     12410:26:54 INFO     stitch.Aggregate: Writing to '/tmp/IG-ST-2-createsliver-request-12-instageni-gpolab-bbn-com.xml'
     12510:26:54 INFO     stitch.Aggregate:
    126126        Stitcher doing createsliver at https://boss.instageni.gpolab.bbn.com:12369/protogeni/xmlrpc/am
    127 08:42:35 INFO     stitch.Aggregate: Allocation at <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm> complete.
    128 08:42:35 INFO     stitch.Aggregate: Writing to '/tmp/IG-ST-2-createsliver-request-11-ion-internet2-edu.xml'
    129 08:42:35 INFO     stitch.Aggregate:
     12710:27:06 ERROR    omni:  {'output': "vlan tag 3720 for 'link1' not available", 'code': {'protogeni_error_log': 'urn:publicid:IDN+instageni.gpolab.bbn.com+log+1311eea9d7985b88d6c4e61a3ca82dcd', 'am_type': 'protogeni', 'geni_code': 1, 'am_code': 1, 'protogeni_error_url': 'https://boss.instageni.gpolab.bbn.com/spewlogfile.php3?logfile=1311eea9d7985b88d6c4e61a3ca82dcd'}, 'value': 0}
     12810:27:06 INFO     stitch.Aggregate: Got AMAPIError doing createsliver IG-ST-2 at <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm>: AMAPIError: Error from Aggregate: code 1. protogeni AM code: 1: vlan tag 3720 for 'link1' not available.
     12910:27:06 INFO     stitch.launcher: Will put <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm> back in the pool to allocate. Got Retry <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm> 3th time with <Hop u'urn:publicid:IDN+instageni.gpolab.bbn.com+interface+procurve2:5.24.ion.newy.ae0' on path u'link1'> new suggested 3718 (not 3720)
     13010:27:06 INFO     stitch.launcher: Pausing for 30 seconds for Aggregates to free up resources...
     131
     132
     13310:27:36 INFO     stitch.Aggregate: Writing to '/tmp/IG-ST-2-createsliver-request-13-instageni-gpolab-bbn-com.xml'
     13410:27:36 INFO     stitch.Aggregate:
     135        Stitcher doing createsliver at https://boss.instageni.gpolab.bbn.com:12369/protogeni/xmlrpc/am
     13610:27:51 INFO     stitch.Aggregate: Allocation at <Aggregate urn:publicid:IDN+instageni.gpolab.bbn.com+authority+cm> complete.
     13710:27:51 INFO     stitch.Aggregate: Writing to '/tmp/IG-ST-2-createsliver-request-11-ion-internet2-edu.xml'
     13810:27:51 INFO     stitch.Aggregate:
    130139        Stitcher doing createsliver at http://geni-am.net.internet2.edu:12346
    131 08:43:18 INFO     stitch.Aggregate: DCN AM <Aggregate urn:publicid:IDN+ion.internet2.edu+authority+am>: must wait for status ready....
    132 08:43:18 INFO     stitch.Aggregate: Pause 30 seconds to let circuit become ready...
    133 08:43:55 INFO     stitch.Aggregate: Pause 30 seconds to let circuit become ready...
    134 08:44:32 INFO     stitch.Aggregate: DCN circuit 62031 is ready
    135 08:44:32 INFO     stitch.Aggregate: DCN circuit 62021 is ready
    136 08:44:39 INFO     stitch.Aggregate: Allocation at <Aggregate urn:publicid:IDN+ion.internet2.edu+authority+am> complete.
    137 08:44:39 INFO     stitch.launcher: All aggregates are complete.
    138 08:44:39 INFO     stitcher: Writing to 'IG-ST-2-manifest-rspec-stitching-combined.xml'
    139 08:44:39 INFO     stitcher: Saved combined reservation RSpec at 3 AMs to file IG-ST-2-manifest-rspec-stitching-combined.xml
     14010:28:34 INFO     stitch.Aggregate: DCN AM <Aggregate urn:publicid:IDN+ion.internet2.edu+authority+am>: must wait for status ready....
     14110:28:34 INFO     stitch.Aggregate: Pause 30 seconds to let circuit become ready...
     14210:29:11 INFO     stitch.Aggregate: Pause 30 seconds to let circuit become ready...
     14310:29:48 INFO     stitch.Aggregate: DCN circuit 62651 is ready
     14410:29:48 INFO     stitch.Aggregate: DCN circuit 62641 is ready
     14510:29:55 INFO     stitch.Aggregate: Allocation at <Aggregate urn:publicid:IDN+ion.internet2.edu+authority+am> complete.
     14610:29:55 INFO     stitch.launcher: All aggregates are complete.
     14710:29:55 INFO     stitcher: Writing to 'IG-ST-2-manifest-rspec-stitching-combined.xml'
     14810:29:55 INFO     stitcher: Saved combined reservation RSpec at 3 AMs to file IG-ST-2-manifest-rspec-stitching-combined.xml
    140149Stitching success: Reserved resources in slice IG-ST-2 at 3 Aggregates (including 1 intermediate aggregate(s) not in the original request), creating 2 link(s).
    141150}}}
     
    154163ig-stan's geni_status is: ready (am_status:ready)
    155164User lnevers logs in to ig-stan using:
    156         ssh -p 32314  -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@pc2.instageni.stanford.edu
     165        ssh -p 32314  -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@pc1.instageni.stanford.edu
    157166
    158167$ readyToLogin.py IG-ST-2 -a gpo-ig
     
    167176ig-gpo's geni_status is: ready (am_status:ready)
    168177User lnevers logs in to ig-gpo using:
    169         ssh -p 38202  -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@pc1.instageni.gpolab.bbn.com
    170 
     178        ssh -p 32058  -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@pc1.instageni.gpolab.bbn.com
    171179}}}
    172180
    173181Login to each host and ping the remote on each of the two interfaces.  Below is the ping output for the GPO site:
    174182{{{
    175 ping 10.10.4.2 -c 60 -q
    176 ????
     183[lnevers@ig-gpo ~]$ ping 10.10.4.2 -c 60 -q
     184PING 10.10.4.2 (10.10.4.2) 56(84) bytes of data.
    177185
     186--- 10.10.4.2 ping statistics ---
     18760 packets transmitted, 60 received, 0% packet loss, time 59069ms
     188rtt min/avg/max/mdev = 100.232/100.317/100.480/0.035 ms
    178189[lnevers@ig-gpo ~]$ ping 192.168.4.2 -c 60 -q
    179190PING 192.168.4.2 (192.168.4.2) 56(84) bytes of data.
    180191
    181192--- 192.168.4.2 ping statistics ---
    182 60 packets transmitted, 60 received, 0% packet loss, time 59057ms
    183 rtt min/avg/max/mdev = 107.076/108.947/215.236/13.843 ms
    184 
     19360 packets transmitted, 60 received, 0% packet loss, time 59077ms
     194rtt min/avg/max/mdev = 100.261/100.347/100.518/0.414 ms
    185195}}}