Changes between Version 13 and Version 14 of GENIRacksHome/CiscoGENIRacks/AcceptanceTestStatus/CG-EXP-4


Ignore:
Timestamp:
01/19/15 08:55:47 (9 years ago)
Author:
lnevers@bbn.com
Comment:

--

Legend:

Unmodified
Added
Removed
Modified

  • GENIRacksHome/CiscoGENIRacks/AcceptanceTestStatus/CG-EXP-4

    v13 v14  
    229229Using the RSpec [http://groups.geni.net/geni/browser/trunk/GENIRacks/CiscoGENI/RSpecs/AcceptanceTests/stitch-eg-ncsu2-ig-chic.rspec stitch-eg-ncsu2-ig-chic.rspec] created a stitched sliver to a remote AL2S site:
    230230{{{
    231 $ stitcher createsliver CG-CT-4z ./stitch-eg-ncsu2-ig-chic.rspec
    232 15:14:21 INFO    : Configured logging from file /home/lnevers/gcf-2.7/src/gcf/stitcher_logging.conf
    233 15:14:21 INFO    : Reading slice CG-CT-4z credential...
    234 15: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
    235 15:14:21 INFO    : Using SCS at http://nutshell.maxgigapop.net:8081/geni/xmlrpc
    236 15:14:21 INFO    : Calling SCS...
    237 15:14:22 INFO    : Multi-AM reservation will include resources from these aggregates:
    238 15:14:22 INFO    :      <Aggregate ncsu2-eg>
    239 15:14:22 INFO    :      <Aggregate chicago-ig>
    240 15:14:22 INFO    :      <Aggregate oess>
    241 15:14:22 INFO    : Stitcher doing createsliver at <Aggregate ncsu2-eg>...
    242 15:14:27 INFO    : ... Allocation at <Aggregate ncsu2-eg> complete.
    243 15:14:27 INFO    : Stitcher doing createsliver at <Aggregate chicago-ig>...
    244 15:14:46 INFO    : ... Allocation at <Aggregate chicago-ig> complete.
    245 15:14:46 INFO    : Stitcher doing createsliver at <Aggregate oess>...
    246 15:14:49 ERROR   :  {'output': 'Exception: requested VLAN unavailable: sdn-sw.star.net.internet2.edu,eth7/1 VLAN=3076', 'code': {'geni_code': 24}}
    247 15: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.))
    248 15:14:49 INFO    : Deleting existing reservations...
    249 15:14:49 INFO    : Doing deletesliver at <Aggregate ncsu2-eg>...
    250 15:14:50 INFO    : Deleted reservation at <Aggregate ncsu2-eg>.
    251 15:14:50 INFO    : Doing deletesliver at <Aggregate chicago-ig>...
    252 15: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}
    253 15:18:00 INFO    : Deleted reservation at <Aggregate chicago-ig>.
    254 15:18:00 INFO    : Calling SCS for the 2nd time...
    255 15:18:00 INFO    : Pausing for 30 seconds for Aggregates to free up resources...
    256 
    257 
    258 15:18:30 INFO    : Multi-AM reservation will include resources from these aggregates:
    259 15:18:30 INFO    :      <Aggregate ncsu2-eg>
    260 15:18:30 INFO    :      <Aggregate chicago-ig>
    261 15:18:30 INFO    :      <Aggregate oess>
    262 15:18:30 INFO    : Stitcher doing createsliver at <Aggregate ncsu2-eg>...
    263 15:18:35 INFO    : ... Allocation at <Aggregate ncsu2-eg> complete.
    264 15:18:35 INFO    : Stitcher doing createsliver at <Aggregate chicago-ig>...
    265 15:19:14 INFO    : ... Allocation at <Aggregate chicago-ig> complete.
    266 15:19:14 INFO    : Stitcher doing createsliver at <Aggregate oess>...
    267 15:19:19 INFO    : ... Allocation at <Aggregate oess> complete.
    268 15:19:19 INFO    : All aggregates are complete.
    269 15:19:19 INFO    : Your resources expire at 2015-01-15T20:08:30 (UTC).
    270 15: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'
    271 Success: 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).
     231$ stitcher deletesliver CG-CT-4x;stitcher createsliver CG-CT-4x ./stitch-eg-ncsu2-ig-chic.rspec --defaultCapacity=100000
     23208:36:00 INFO    : Configured logging from file /home/lnevers/gcf-2.8-pre1/src/gcf/stitcher_logging.conf
     23308:36:00 INFO    : Reading slice CG-CT-4x aggregates from file /home/lnevers/.gcf/ch-geni-net-ln-test-CG-CT-4x-amlist.txt
     23408:36:00 INFO    : Loading agg_nick_cache file '/home/lnevers/.gcf/agg_nick_cache'
     23508:36:00 INFO    : Loading config file '/home/lnevers/.gcf/omni_config'
     23608:36:00 INFO    : Using control framework portal
     23708:36:00 INFO    : Member Authority is https://ch.geni.net/MA (from config)
     23808:36:00 INFO    : Slice Authority is https://ch.geni.net/SA (from config)
     23908:36:01 INFO    : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+CG-CT-4x expires on 2015-01-26 13:16:54 UTC
     24008:36:02 INFO    : Deleted sliver urn:publicid:IDN+ch.geni.net:ln-test+slice+CG-CT-4x at ncsu2-eg
     24108:36:04 INFO    :  (PG log url - look here for details on any failures: https://www.geni.uchicago.edu/spewlogfile.php3?logfile=1516bd8dbdc510ae2e78bad62af8117f)
     24208:36:05 INFO    : Deleted sliver urn:publicid:IDN+ch.geni.net:ln-test+slice+CG-CT-4x at chicago-ig
     24308:36:29 INFO    : Deleted sliver urn:publicid:IDN+ch.geni.net:ln-test+slice+CG-CT-4x at oess
     244Deleted slivers on 3 out of a possible 3 aggregates
     24508:36:29 INFO    : Configured logging from file /home/lnevers/gcf-2.8-pre1/src/gcf/stitcher_logging.conf
     24608:36:30 INFO    : Reading slice CG-CT-4x credential...
     24708:36:30 INFO    : Slice urn:publicid:IDN+ch.geni.net:ln-test+slice+CG-CT-4x expires on 2015-01-26 13:16:54 UTC
     24808:36:30 INFO    : Using SCS at https://nutshell.maxgigapop.net:8443/geni/xmlrpc
     24908:36:30 INFO    : Calling SCS...
     25008:37:31 INFO    : Multi-AM reservation will include resources from these aggregates:
     25108:37:31 INFO    :      <Aggregate ncsu2-eg>
     25208:37:31 INFO    :      <Aggregate chicago-ig>
     25308:37:31 INFO    :      <Aggregate oess>
     25408:37:31 INFO    : Stitcher doing createsliver at <Aggregate ncsu2-eg>...
     25508:37:36 INFO    : ... Allocation at <Aggregate ncsu2-eg> complete.
     25608:37:36 INFO    : Stitcher doing createsliver at <Aggregate chicago-ig>...
     25708:37:56 INFO    : ... Allocation at <Aggregate chicago-ig> complete.
     25808:37:56 INFO    : Stitcher doing createsliver at <Aggregate oess>...
     25908:38:01 INFO    : ... Allocation at <Aggregate oess> complete.
     26008:38:01 INFO    : All aggregates are complete.
     26108:38:02 INFO    : Your resources expire at 2015-01-25T13:27:31 (UTC).
     26208:38:02 INFO    : Saved combined reservation RSpec at 3 AMs to file '/home/lnevers/gcf-test/cisco/CG-CT-4x-manifest-rspec-multiam-combined.xml'
    272263}}}
    273264Determine login:
    274265{{{
    275 $ readyToLogin CG-CT-4z -a chicago-ig
     266$ readyToLogin CG-CT-4x -a chicago-ig
    276267...
    277268ig-chic's geni_status is: ready
    … …  
    279270        ssh -p 30266  -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@pc3.geni.uchicago.edu
    280271
    281 $ readyToLogin CG-CT-4z -a ncsu2-eg
     272$ readyToLogin CG-CT-4x -a ncsu2-eg
    282273...
    283274eg-ncsu2's geni_status is: ready
    284275User lnevers logs in to eg-ncsu2 using:
    285         ssh -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@152.48.13.191
     276        ssh -i /home/lnevers/.ssh/geni_cert_portal_key lnevers@152.48.13.194
    286277}}}
    287278
    … …  
    290281'''Iperf Chicago IG VM to  NCSU2 CG (TCP) - TCP window size: 23.5 KByte (default)'''
    291282
    292 ''Collected: 2015-01-09''
     283''Collected: 2015-01-19''
    293284
    294285__One Client__
    295286{{{
    296287[ ID] Interval       Transfer     Bandwidth
    297 [  3]  0.0-60.0 sec   680 MBytes  95.1 Mbits/sec
     288[  3]  0.0-60.0 sec   697 MBytes  97.4 Mbits/sec
    298289}}}
    299290
    … …  
    301292{{{
    302293[ 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
     294[  5]  0.0-60.1 sec   142 MBytes  19.9 Mbits/sec
     295[  6]  0.0-60.1 sec   113 MBytes  15.8 Mbits/sec
     296[  3]  0.0-60.1 sec   121 MBytes  16.9 Mbits/sec
     297[  4]  0.0-60.2 sec   133 MBytes  18.5 Mbits/sec
     298[  7]  0.0-60.3 sec   188 MBytes  26.1 Mbits/sec
     299[SUM]  0.0-60.3 sec   698 MBytes  97.1 Mbits/sec
    309300}}}
    310301
    … …  
    312303{{{
    313304[ 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
     305[ 12]  0.0-60.0 sec  59.0 MBytes  8.25 Mbits/sec
     306[  7]  0.0-60.1 sec  46.5 MBytes  6.50 Mbits/sec
     307[ 11]  0.0-60.1 sec  67.9 MBytes  9.48 Mbits/sec
     308[  6]  0.0-60.1 sec  62.6 MBytes  8.74 Mbits/sec
     309[  3]  0.0-60.1 sec  68.6 MBytes  9.58 Mbits/sec
     310[  8]  0.0-60.2 sec  94.4 MBytes  13.1 Mbits/sec
     311[  5]  0.0-60.3 sec  92.1 MBytes  12.8 Mbits/sec
     312[ 10]  0.0-60.4 sec  75.9 MBytes  10.5 Mbits/sec
     313[  4]  0.0-60.5 sec  95.5 MBytes  13.2 Mbits/sec
     314[  9]  0.0-60.7 sec  52.9 MBytes  7.31 Mbits/sec
     315[SUM]  0.0-60.7 sec   715 MBytes  98.9 Mbits/sec
    325316}}}
    326317
    … …  
    343334'''Iperf NCSU2 CG to Chicago IG (TCP) - TCP window size: 85.0 KByte (default)'''
    344335
    345 ''Collected: 2015-01-09''
    346 
    347 __One Client_
    348 {{{
    349 [ ID] Interval       Transfer     Bandwidth
    350 [  3]  0.0-60.7 sec  21.9 MBytes  3.02 Mbits/sec
     336''Collected: 2015-01-19''
     337
     338__One Client__
     339{{{
     340[ ID] Interval       Transfer     Bandwidth
     341[  3]  0.0-60.2 sec  66.0 MBytes  9.19 Mbits/sec
    351342}}}
    352343
    … …  
    354345{{{
    355346[ 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
     347[  7]  0.0-60.1 sec  76.5 MBytes  10.7 Mbits/sec
     348[  4]  0.0-60.1 sec  77.5 MBytes  10.8 Mbits/sec
     349[  5]  0.0-60.2 sec  81.4 MBytes  11.3 Mbits/sec
     350[  6]  0.0-60.3 sec  67.4 MBytes  9.38 Mbits/sec
     351[  3]  0.0-60.3 sec  82.9 MBytes  11.5 Mbits/sec
     352[SUM]  0.0-60.3 sec   386 MBytes  53.7 Mbits/sec
    362353}}}
    363354
    … …  
    365356{{{
    366357[ 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
     358[ 12]  0.0-60.2 sec  67.9 MBytes  9.47 Mbits/sec
     359[ 13]  0.0-60.2 sec  59.0 MBytes  8.23 Mbits/sec
     360[  7]  0.0-60.2 sec  62.6 MBytes  8.73 Mbits/sec
     361[  8]  0.0-60.2 sec  46.5 MBytes  6.48 Mbits/sec
     362[  4]  0.0-60.3 sec  68.6 MBytes  9.54 Mbits/sec
     363[  9]  0.0-60.5 sec  94.4 MBytes  13.1 Mbits/sec
     364[  6]  0.0-60.5 sec  92.1 MBytes  12.8 Mbits/sec
     365[  5]  0.0-60.8 sec  95.5 MBytes  13.2 Mbits/sec
     366[ 11]  0.0-60.8 sec  75.9 MBytes  10.5 Mbits/sec
     367[ 10]  0.0-60.8 sec  52.9 MBytes  7.29 Mbits/sec
     368[SUM]  0.0-60.8 sec   715 MBytes  98.6 Mbits/sec
    378369}}}
    379370