Changes between Version 9 and Version 10 of GENIRacksHome/CiscoGENIRacks/AcceptanceTestStatus/CG-EXP-4


Ignore:
Timestamp:
01/09/15 15:39:09 (9 years ago)
Author:
lnevers@bbn.com
Comment:

--

Legend:

Unmodified
Added
Removed
Modified
  • GENIRacksHome/CiscoGENIRacks/AcceptanceTestStatus/CG-EXP-4

    v9 v10  
    230230{{{
    231231$ stitcher createsliver CG-CT-4x ./stitch-eg-ncsu2-ig-chic.rspec
     23215:14:21 INFO    : Configured logging from file /home/lnevers/gcf-2.7/src/gcf/stitcher_logging.conf
     23315:14:21 INFO    : Reading slice CG-CT-4z credential...
     23415:14:21 INFO    : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+CG-CT-4z expires on 2015-01-16 20:14:20 UTC
     23515:14:21 INFO    : Using SCS at http://nutshell.maxgigapop.net:8081/geni/xmlrpc
     23615:14:21 INFO    : Calling SCS...
     23715:14:22 INFO    : Multi-AM reservation will include resources from these aggregates:
     23815:14:22 INFO    :      <Aggregate ncsu2-eg>
     23915:14:22 INFO    :      <Aggregate chicago-ig>
     24015:14:22 INFO    :      <Aggregate oess>
     24115:14:22 INFO    : Stitcher doing createsliver at <Aggregate ncsu2-eg>...
     24215:14:27 INFO    : ... Allocation at <Aggregate ncsu2-eg> complete.
     24315:14:27 INFO    : Stitcher doing createsliver at <Aggregate chicago-ig>...
     24415:14:46 INFO    : ... Allocation at <Aggregate chicago-ig> complete.
     24515:14:46 INFO    : Stitcher doing createsliver at <Aggregate oess>...
     24615:14:49 ERROR   :  {'output': 'Exception: requested VLAN unavailable: sdn-sw.star.net.internet2.edu,eth7/1 VLAN=3076', 'code': {'geni_code': 24}}
     24715:14:49 WARNING : Stitching failed but will retry: Circuit reservation failed at <Aggregate oess>. Try again from the SCS. (Error: Topology too complex for local redo - ask Stitching Service to find a VLAN tag (AMAPIError: Error from Aggregate: code 24: Exception: requested VLAN unavailable: sdn-sw.star.net.internet2.edu,eth7/1 VLAN=3076.))
     24815:14:49 INFO    : Deleting existing reservations...
     24915:14:49 INFO    : Doing deletesliver at <Aggregate ncsu2-eg>...
     25015:14:50 INFO    : Deleted reservation at <Aggregate ncsu2-eg>.
     25115:14:50 INFO    : Doing deletesliver at <Aggregate chicago-ig>...
     25215:16:20 ERROR   :  {'output': 'start/restart in progress; try again later', 'code': {'protogeni_error_log': 'urn:publicid:IDN+geni.uchicago.edu+log+d1498aed6f901cd5bbe792a8c9dde5b6', 'am_type': 'protogeni', 'geni_code': 14, 'am_code': 14, 'protogeni_error_url': 'https://www.geni.uchicago.edu/spewlogfile.php3?logfile=d1498aed6f901cd5bbe792a8c9dde5b6'}, 'value': 0}
     25315:18:00 INFO    : Deleted reservation at <Aggregate chicago-ig>.
     25415:18:00 INFO    : Calling SCS for the 2nd time...
     25515:18:00 INFO    : Pausing for 30 seconds for Aggregates to free up resources...
     256
     257
     25815:18:30 INFO    : Multi-AM reservation will include resources from these aggregates:
     25915:18:30 INFO    :      <Aggregate ncsu2-eg>
     26015:18:30 INFO    :      <Aggregate chicago-ig>
     26115:18:30 INFO    :      <Aggregate oess>
     26215:18:30 INFO    : Stitcher doing createsliver at <Aggregate ncsu2-eg>...
     26315:18:35 INFO    : ... Allocation at <Aggregate ncsu2-eg> complete.
     26415:18:35 INFO    : Stitcher doing createsliver at <Aggregate chicago-ig>...
     26515:19:14 INFO    : ... Allocation at <Aggregate chicago-ig> complete.
     26615:19:14 INFO    : Stitcher doing createsliver at <Aggregate oess>...
     26715:19:19 INFO    : ... Allocation at <Aggregate oess> complete.
     26815:19:19 INFO    : All aggregates are complete.
     26915:19:19 INFO    : Your resources expire at 2015-01-15T20:08:30 (UTC).
     27015:19:19 INFO    : Saved combined reservation RSpec at 3 AMs to file '/home/lnevers/gcf-test/cisco/CG-CT-4z-manifest-rspec-multiam-combined.xml'
     271Success: Reserved resources in slice CG-CT-4z at 3 Aggregates (including 1 intermediate aggregate(s) not in the original request), creating 1 stitched link(s).
    232272}}}
    233273Determine login:
    234274{{{
     275$ readyToLogin CG-CT-4z -a chicago-ig
     276...
     277ig-chic's geni_status is: ready
     278User lnevers logs in to ig-chic using:
     279        ssh -p 30266  -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@pc3.geni.uchicago.edu
     280
     281$ readyToLogin CG-CT-4z -a ncsu2-eg
     282...
     283eg-ncsu2's geni_status is: ready
     284User lnevers logs in to eg-ncsu2 using:
     285        ssh -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@152.48.13.191
    235286}}}
    236287
    237288==== Measurements ====
    238289
    239 '''Iperf GPO IG VM to  NCSU2 CG (TCP) - TCP window size: XX.5 KByte (default)'''
    240 
    241 ''Collected: 2015-XX-XX''
     290'''Iperf Chicago IG VM to  NCSU2 CG (TCP) - TCP window size: 23.5 KByte (default)'''
     291
     292''Collected: 2015-01-09''
    242293
    243294__One Client__
    244295{{{
    245 
     296[ ID] Interval       Transfer     Bandwidth
     297[  3]  0.0-60.0 sec   680 MBytes  95.1 Mbits/sec
    246298}}}
    247299
    248300__Five Clients__
    249301{{{
    250 
     302[ ID] Interval       Transfer     Bandwidth
     303[  4]  0.0-60.0 sec   158 MBytes  22.1 Mbits/sec
     304[  6]  0.0-60.1 sec   151 MBytes  21.1 Mbits/sec
     305[  3]  0.0-60.1 sec   145 MBytes  20.2 Mbits/sec
     306[  7]  0.0-60.4 sec   133 MBytes  18.5 Mbits/sec
     307[  5]  0.0-60.5 sec   120 MBytes  16.6 Mbits/sec
     308[SUM]  0.0-60.5 sec   707 MBytes  98.0 Mbits/sec
    251309}}}
    252310
    253311__Ten Clients__
    254312{{{
    255 
    256 }}}
    257 
    258 '''Iperf GPO IG VM to  NCSU2 CG (UDP) - UDP buffer size:  XX KByte (default) '''
    259 {{{
    260 
    261 }}}
    262 
    263 '''Ping from GPO IG VM to the  NCSU2 CG '''
    264 {{{
    265 
    266 }}}
    267 
    268 '''Iperf  NCSU2 CG to GPO IG (TCP) - TCP window size: XX.5 KByte (default)'''
    269 
    270 ''Collected: 2015-XX-XX''
     313[ ID] Interval       Transfer     Bandwidth
     314[  4]  0.0-60.1 sec  71.2 MBytes  9.95 Mbits/sec
     315[ 10]  0.0-60.1 sec  62.9 MBytes  8.78 Mbits/sec
     316[ 12]  0.0-60.1 sec  67.2 MBytes  9.39 Mbits/sec
     317[  6]  0.0-60.1 sec  91.9 MBytes  12.8 Mbits/sec
     318[  9]  0.0-60.2 sec  85.1 MBytes  11.9 Mbits/sec
     319[  8]  0.0-60.2 sec  59.4 MBytes  8.28 Mbits/sec
     320[ 11]  0.0-60.2 sec  67.4 MBytes  9.39 Mbits/sec
     321[  3]  0.0-60.3 sec  65.6 MBytes  9.13 Mbits/sec
     322[  7]  0.0-60.3 sec  83.5 MBytes  11.6 Mbits/sec
     323[  5]  0.0-60.4 sec  65.2 MBytes  9.06 Mbits/sec
     324[SUM]  0.0-60.4 sec   720 MBytes  99.9 Mbits/sec
     325}}}
     326
     327'''Iperf Chicago IG VM to  NCSU2 CG (UDP) - UDP buffer size:  224 KByte (default) '''
     328{{{
     329[ ID] Interval       Transfer     Bandwidth
     330[  3]  0.0-60.0 sec   719 MBytes   101 Mbits/sec
     331[  3] Sent 512778 datagrams
     332[  3] Server Report:
     333[  3]  0.0-60.0 sec   693 MBytes  96.9 Mbits/sec   0.138 ms 18523/512777 (3.6%)
     334[  3]  0.0-60.0 sec  1 datagrams received out-of-order
     335}}}
     336
     337'''Ping from Chicago IG VM to the  NCSU2 CG '''
     338{{{
     33960 packets transmitted, 60 received, 0% packet loss, time 59091ms
     340rtt min/avg/max/mdev = 25.204/25.391/25.798/0.228 ms
     341}}}
     342
     343'''Iperf NCSU2 CG to Chicago IG (TCP) - TCP window size: 85.0 KByte (default)'''
     344
     345''Collected: 2015-01-09''
    271346
    272347__One Client_
    273348{{{
    274 
     349[ ID] Interval       Transfer     Bandwidth
     350[  3]  0.0-60.7 sec  21.9 MBytes  3.02 Mbits/sec
    275351}}}
    276352
    277353__Five Clients__
    278354{{{
    279 
     355[ ID] Interval       Transfer     Bandwidth
     356[  3]  0.0-60.0 sec  27.1 MBytes  3.79 Mbits/sec
     357[  4]  0.0-60.5 sec  26.2 MBytes  3.64 Mbits/sec
     358[  6]  0.0-60.5 sec  28.6 MBytes  3.97 Mbits/sec
     359[  5]  0.0-60.6 sec  27.0 MBytes  3.74 Mbits/sec
     360[  7]  0.0-60.6 sec  28.8 MBytes  3.98 Mbits/sec
     361[SUM]  0.0-60.6 sec   138 MBytes  19.1 Mbits/sec
    280362}}}
    281363
    282364__Ten Clients__
    283365{{{
    284 
    285 }}}
    286 
    287 '''Iperf  NCSU2 CG to GPO IG (UDP) - UDP buffer size:  XX KByte (default) '''
    288 {{{
    289 
    290 }}}
    291 
    292 '''Ping from GPO IG VM to the  NCSU2 CG '''
    293 {{{
    294 
    295 }}}
    296 === NCSU2 to ION site ===
     366[ ID] Interval       Transfer     Bandwidth
     367[  5]  0.0-60.2 sec  27.5 MBytes  3.83 Mbits/sec
     368[ 10]  0.0-60.2 sec  25.1 MBytes  3.50 Mbits/sec
     369[  3]  0.0-60.2 sec  27.2 MBytes  3.80 Mbits/sec
     370[  7]  0.0-60.2 sec  28.5 MBytes  3.97 Mbits/sec
     371[ 12]  0.0-60.3 sec  26.2 MBytes  3.65 Mbits/sec
     372[  6]  0.0-60.4 sec  26.6 MBytes  3.70 Mbits/sec
     373[  8]  0.0-60.4 sec  25.0 MBytes  3.47 Mbits/sec
     374[  4]  0.0-60.5 sec  26.6 MBytes  3.69 Mbits/sec
     375[  9]  0.0-60.5 sec  26.6 MBytes  3.69 Mbits/sec
     376[ 11]  0.0-60.5 sec  25.6 MBytes  3.55 Mbits/sec
     377[SUM]  0.0-60.5 sec   265 MBytes  36.7 Mbits/sec
     378}}}
     379
     380'''Iperf  NCSU2 CG to Chicago IG (UDP) - UDP buffer size:  208 KByte (default) '''
     381{{{
     382[ ID] Interval       Transfer     Bandwidth
     383[  3]  0.0-60.0 sec   719 MBytes   101 Mbits/sec
     384[  3] Sent 512821 datagrams
     385[  3] Server Report:
     386[  3]  0.0-60.1 sec   681 MBytes  95.0 Mbits/sec   0.072 ms 26950/512820 (5.3%)
     387[  3]  0.0-60.1 sec  1 datagrams received out-of-order
     388}}}
     389
     390'''Ping from Chicago IG VM to the  NCSU2 CG '''
     391{{{
     39260 packets transmitted, 60 received, 0% packet loss, time 59091ms
     393rtt min/avg/max/mdev = 25.283/25.482/25.966/0.147 ms
     394}}}
    297395
    298396=== NCSU2 Multiple Stitched links ===
    299397
    300 NYSERNet IG<ION-AL2S->NCSU2<-AL2S->Stanford-IG
    301 
     398Using the RSpec [XX] requested the following topology:
     399
     400 NYSERNet IG<ION-AL2S->NCSU2<-AL2S->Stanford-IG
     401
     402The create sliver:
     403{{{
     404$ stitcher createsliver 3linear ./stitch-3linear.rspec
     40515:27:46 INFO    : Configured logging from file /home/lnevers/gcf-2.7/src/gcf/stitcher_logging.conf
     40615:27:46 INFO    : Reading slice 3linear credential...
     40715:27:46 INFO    : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+3linear expires on 2015-01-12 20:21:43 UTC
     40815:27:46 INFO    : Using SCS at http://nutshell.maxgigapop.net:8081/geni/xmlrpc
     40915:27:46 INFO    : Calling SCS...
     41015:27:48 INFO    : Multi-AM reservation will include resources from these aggregates:
     41115:27:48 INFO    :      <Aggregate ncsu2-eg>
     41215:27:48 INFO    :      <Aggregate gpo-ig>
     41315:27:48 INFO    :      <Aggregate chicago-ig>
     41415:27:48 INFO    :      <Aggregate oess>
     41515:27:48 INFO    :      <Aggregate ion>
     41615:27:48 INFO    : Stitcher doing createsliver at <Aggregate ncsu2-eg>...
     41715:27:51 ERROR   :  {'output': 'Invalid slice urn urn:publicid:IDN+ch.geni.net:ln-test+slice+3linear', 'code': {'geni_code': 2}}
     41815:27:51 INFO    : Got an error reserving resources in 3linear at <Aggregate ncsu2-eg>
     41915:27:52 WARNING : Failed to delete sliver urn:publicid:IDN+ch.geni.net:ln-test+slice+3linear at ncsu2-eg (got result 'False'). (no reason given)
     42015:27:52 WARNING : Stitching failed but will retry: Circuit reservation failed at <Aggregate ncsu2-eg> (AMAPIError: Error from Aggregate: code 2: Invalid slice urn urn:publicid:IDN+ch.geni.net:ln-test+slice+3linear.). Try again from the SCS
     421}}}
     422