Changes between Version 46 and Version 47 of GENIRacksHome/InstageniRacks/AcceptanceTestStatus/IG-EXP-1


Ignore:
Timestamp:
02/06/13 16:00:51 (7 years ago)
Author:
lnevers@bbn.com
Comment:

--

Legend:

Unmodified
Added
Removed
Modified
  • GENIRacksHome/InstageniRacks/AcceptanceTestStatus/IG-EXP-1

    v46 v47  
    615615
    616616Submited the changes and the following operations took place:
    617 ????
     617{{{
     618Doing a preswapmod on the experiment archive ...
     619Backing up old experiment state ... 15:38:33:975849
     620Running 'tbprerun  -e 13 shared-nodes-modify.ns'
     621Beginning pre run for emulab-ops/shared-nodes. 15:38:34:358577
     622Running parser ... 15:38:34:603168
     623Parser done! 15:38:36:974095
     624Setting up static routes (if requested) ...
     625*** WARNING: staticroutes:
     626***   No links or lans in experiment emulab-ops/shared-nodes!
     627Generating topomap ...
     628Verifying parse ...
     629Doing a pre-assign: '/usr/testbed/bin/vtopgen -p emulab-ops shared-nodes' ...
     630Checking for feature LibVtopTest.
     631Using test version of libvtop ...
     632Minimum nodes   = 2
     633Maximum nodes   = 2
     634Writing environment strings ...
     635Setting up additional program agent support ...
     636Setting up additional network agent support ...
     637Writing program agent info ...
     638Pre run finished. 15:38:39:943787
     639Running 'tbswap modify  -eventsys_restart -noswapout -noreconfig emulab-ops shared-nodes'
     640Beginning swap-modify for emulab-ops/shared-nodes (13). 02/06/2013 15:38:40
     641TIMESTAMP: 15:38:40:231396 tbswap modify started
     642Checking for feature SyncVlans.
     643Checking with Admission Control ...
     644Backing up physical state...
     645Stopping the event system
     646Checking for feature NewEventScheduler.
     647Freeing failed nodes.
     648TIMESTAMP: 15:38:41:60215 nfree started
     649[Interface: pc4:eth1] is still tagged! But we will fix that.
     650[Interface: pc4:eth2] is still tagged! But we will fix that.
     651[Interface: pc4:eth3] is still tagged! But we will fix that.
     652*** Turning off tagging for: pc4:eth1 pc4:eth2 pc4:eth3
     653Disabling trunking (tagging) on port pc4:1.1 ...
     654Moving [Node: pc4] to [Experiment: emulab-ops/reloadpending]
     655TIMESTAMP: 15:38:42:395301 nfree finished
     656Mapping to physical reality ...
     657TIMESTAMP: 15:38:42:591955 mapper wrapper started
     658Checking for feature OldMapper.
     659Checking for feature NewAssign.
     660Checking for feature ControlNetVlans.
     661Checking for feature LibVtopTest.
     662Using test version of libvtop ...
     663Starting the new and improved mapper wrapper.
     664Minimum nodes   = 2
     665Maximum nodes   = 2
     666Reserved pnodes   = 2
     667Clearing physical state before updating.
     668Mapper loop 1
     669ptopargs: '-p emulab-ops -e shared-nodes '
     670assign command: 'assign -P -f text emulab-ops-shared-nodes-43514.ptop emulab-ops-shared-nodes-43514.vtop'
     671Reading assign results.
     672[Node: pc1] already reserved in holding reservation.
     673[Node: pc2] already reserved in holding reservation.
     674pc1
     675pc2
     676TIMESTAMP: 15:38:46:203759 mapper wrapper finished
     677Mapped to physical reality!
     678Synchronizing VLANs.
     679getTrunksForVlan: 8: procurve2
     680mapVlansToSwitches: procurve2
     681getExperimentTrunksForVlan: 8: procurve2
     682mapStaleVlansToSwitches: procurve2
     683procurve2 -> startChildCall(FlipDebug)
     684Experiment vlans: 8
     685Trunk Ports: pc1:3.1 pc2:3.1 pc2:2.1 pc1:2.1 pc2:1.1 pc1:1.1
     686Existing vlans: 8
     687Stale vlans:
     688Existing Trunk Ports: pc2:3.1 pc2:1.1 pc1:1.1
     689snmpit_stack::findVlan( 8 )
     690snmpit_stack::findVlans( 8 )
     691procurve2 -> startChildCall(findVlans)
     692procurve2::findVlans
     693snmpit_stack::reapCall(findVlans)
     694stack::findVlans calling procurve2
     695snmpit_stack::findVlans(  )
     696procurve2 -> startChildCall(findVlans)
     697procurve2::findVlans
     698snmpit_stack::reapCall(findVlans)
     699stack::findVlans calling procurve2
     700getExperimentTrunksForVlan: 8: procurve2
     701Removing stale ports from vlan 8: pc4:3.1 pc4:2.1 pc4:1.1
     702snmpit_stack::findVlans( 8 )
     703procurve2 -> startChildCall(findVlans)
     704procurve2::findVlans
     705snmpit_stack::reapCall(findVlans)
     706stack::findVlans calling procurve2
     707procurve2 -> startChildCall(findVlans)
     708procurve2::findVlans
     709Removing ports on procurve2 from VLAN 8 (257)
     710procurve2 -> startChildCall(removeSomePortsFromVlan)
     711procurve2::updateOneVlan(0,1,257) as ifIndexes: 107
     712procurve2::updateOneVlan(0,0,1) as ifIndexes: 107
     713procurve2::updateOneVlan(0,0,257) as ifIndexes: 107
     714procurve2:set  had error number 12 and had error string (inconsistentValue) The value set is not currently \
     715 acceptable
     716procurve2:set  ... will try again
     717procurve2:set  had error number 12 and had error string (inconsistentValue) The value set is not currently \
     718 acceptable
     719procurve2:set  ... will try again
     720procurve2:set  .. giving up
     721vlists failed
     722procurve2::updateOneVlan(0,1,1) as ifIndexes: 107
     723procurve2::updateOneVlan(0,0,257) as ifIndexes: 107
     724disabling port 106  from vlan 257
     725disabling port 108  from vlan 257
     726snmpit_stack::findVlan( 8 )
     727snmpit_stack::findVlans( 8 )
     728procurve2 -> startChildCall(findVlans)
     729procurve2::findVlans
     730snmpit_stack::reapCall(findVlans)
     731stack::findVlans calling procurve2
     732snmpit_stack::findVlans(  )
     733procurve2 -> startChildCall(findVlans)
     734procurve2::findVlans
     735snmpit_stack::reapCall(findVlans)
     736stack::findVlans calling procurve2
     737getTrunksForVlan: 8: procurve2
     738RecordVLanModification: [VLan 8:257: emulab-ops/shared-nodes/sharedlan] - pc4:eth3 pc4:eth2 pc4:eth1
     739RecordVLanModification: [VLan 8:257: emulab-ops/shared-nodes/sharedlan] - pc4:eth3 pc4:eth2 pc1:eth3 pc2:eth3 \
     740 pc1:eth1 pc1:eth2 pc2:eth2 pc4:eth1 pc2:eth1
     741  pc4:eth3 pc4:eth2 pc4:eth1
     742RecordVLanModification (after): [VLan 8:257: emulab-ops/shared-nodes/sharedlan] - pc4:eth3 pc4:eth2 pc1:eth3 \
     743 pc2:eth3 pc1:eth1 pc1:eth2 pc2:eth2 pc4:eth1 pc2:eth1
     744Enabling dual mode trunking on pc1:2.1:8
     745Enabling dual trunking (tagging) on pc1:2.1 8
     746procurve2 -> startChildCall(findVlan)
     747procurve2::findVlans
     748Enable trunking: Port is pc1:2.1 native VLAN is 8
     749procurve2 -> startChildCall(enablePortTrunking2)
     750procurve2::setPortVlan(257)as ifIndexes: 98
     751portControl: enable -> (pc1:2.1)
     752checking row 98 for up ...
     753Port pc1:2.1, row 98 was down
     754Setting pc1:2.1 (r 98) to up...succeeded.
     755procurve2::updateOneVlan(0,0,1) as ifIndexes: 98
     756Enabling dual mode trunking on pc1:3.1:8
     757Enabling dual trunking (tagging) on pc1:3.1 8
     758procurve2 -> startChildCall(findVlan)
     759procurve2::findVlans
     760Enable trunking: Port is pc1:3.1 native VLAN is 8
     761procurve2 -> startChildCall(enablePortTrunking2)
     762procurve2::setPortVlan(257)as ifIndexes: 99
     763portControl: enable -> (pc1:3.1)
     764checking row 99 for up ...
     765Port pc1:3.1, row 99 was down
     766Setting pc1:3.1 (r 99) to up...succeeded.
     767procurve2::updateOneVlan(0,0,1) as ifIndexes: 99
     768Enabling dual mode trunking on pc2:2.1:8
     769Enabling dual trunking (tagging) on pc2:2.1 8
     770procurve2 -> startChildCall(findVlan)
     771procurve2::findVlans
     772Enable trunking: Port is pc2:2.1 native VLAN is 8
     773procurve2 -> startChildCall(enablePortTrunking2)
     774procurve2::setPortVlan(257)as ifIndexes: 101
     775portControl: enable -> (pc2:2.1)
     776checking row 101 for up ...
     777Port pc2:2.1, row 101 was down
     778Setting pc2:2.1 (r 101) to up...succeeded.
     779procurve2::updateOneVlan(0,0,1) as ifIndexes: 101
     780Fetching tarballs and RPMs (if any) ...
     781TIMESTAMP: 15:38:51:675558 tarfiles_setup started
     782TIMESTAMP: 15:38:52:2669 tarfiles_setup finished
     783Updating dynamic blobs.
     784Setting up mountpoints.
     785TIMESTAMP: 15:38:52:466517 mountpoints started
     786TIMESTAMP: 15:38:54:828490 mountpoints finished
     787TIMESTAMP: 15:38:54:830269 named started
     788Setting up named maps.
     789TIMESTAMP: 15:38:55:495790 named finished
     790TIMESTAMP: 15:38:55:514904 gentopofile started
     791Generating ltmap (again) ...
     792TIMESTAMP: 15:38:55:702383 gentopofile finished
     793Resetting OS and rebooting.
     794TIMESTAMP: 15:38:55:704739 launching os_setup
     795Checking for feature OldOsSetup.
     796TIMESTAMP: 15:38:56:260025 os_setup started
     797Checking for feature NewOsload.
     798Adding pc1 to type object pc
     799pc1 - [OS 10016: emulab-ops,FEDORA15-OPENVZ-STD]
     800Adding pc2 to type object pc
     801pc2 - [OS 10016: emulab-ops,FEDORA15-OPENVZ-STD]
     802Asking [pc] for volunteers
     803[pc] returns volunteers: [Node: pc1] [Node: pc2]
     804Lighting up nodes in parallel ...
     805Lighting up nodes: [Node: pc1] [Node: pc2]
     806Waiting for nodes ...
     807pc1 has reported state ISUP
     808Checking for feature OsloadFailNonfatal.
     809pc1 is alive and well
     810pc2 has reported state ISUP
     811Checking for feature OsloadFailNonfatal.
     812pc2 is alive and well
     813Asking [pc] for volunteers
     814TIMESTAMP: 15:39:02:363058 os_setup finished
     815Starting the event system.
     816TIMESTAMP: 15:39:02:378643 eventsys_control started
     817Checking for feature NewEventScheduler.
     818/usr/testbed/sbin/event-sched -d -s localhost -k /proj/emulab-ops/exp/shared-nodes/tbdata/eventkey emulab-ops \
     819 shared-nodes
     820Beginning call to experiment.metadata
     821Error occured: problem setting up certificate
     822could not get experiment metadata
     823Finished with call to experiment.metadata
     824*** eventsys.proxy:
     825    Failed to start event system for emulab-ops/shared-nodes: 48789 0!
     826*** WARNING: tbswap:
     827***   Failed to start the event system, must restart manually.
     828Successfully finished swap-modify for emulab-ops/shared-nodes. 15:39:05:219620
     829TIMESTAMP: 15:39:05:220596 tbswap modify finished (succeeded)
     830Image rendering proceeding in background mode ...
     831Running 'tbreport -b emulab-ops shared-nodes'
     832cp: utimes: /usr/testbed/expinfo/emulab-ops/shared-nodes/13/vstate.12tonR: Operation not permitted
     833cp: utimes: /usr/testbed/expinfo/emulab-ops/shared-nodes/13/pstate.DvOhzX: Operation not permitted
     834cp: utimes: /usr/testbed/expinfo/emulab-ops/shared-nodes/13/vstate.Qk8L8S: Operation not permitted
     835cp: utimes: /usr/testbed/expinfo/emulab-ops/shared-nodes/13/vstate.FdQ9Eq: Operation not permitted
     836cp: utimes: /usr/testbed/expinfo/emulab-ops/shared-nodes/13: Operation not permitted
     837Doing a commit on the previous experiment archive ...
     838Doing a savepoint on the experiment archive ...
     839Swap Success!
     840}}}
    618841
    619842f. Verify that the node is no longer part of the shared pool:
    620843
    621 
     844Used listresources to show that pc4 was no longer a shared nodes and once again a dedicated node and then set up an experiment that used 2 raw-pcs including pc4.
     845{{{
     846$ readyToLogin.py pc4pc5 -a ig-gpo ./insta-pc4-pc5.rspec
     847<...>
     848PC5's geni_status is: ready (am_status:ready)
     849User lnevers logins to PC5 using:
     850        xterm -e ssh -i /home/lnevers/.ssh/id_rsa lnevers@pc5.instageni.gpolab.bbn.com &
     851
     852PC4's geni_status is: ready (am_status:ready)
     853User lnevers logins to PC4 using:
     854        xterm -e ssh -i /home/lnevers/.ssh/id_rsa lnevers@pc4.instageni.gpolab.bbn.com &
     855}}}
     856