Trace collected at: 2010-10-13 11:55:40.061000
----------------------------------------------------------------------
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[13]:     log('========================================', color=BLUE, attr=BOLD )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[14]:     log('BKG_1 - VERIFY BASIC TIMING            ', color=BLUE, attr=BOLD )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[15]:     log('========================================', color=BLUE, attr=BOLD )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[16]:     PF=("FAIL","PASS")
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[18]:     log('1. Increasing TM Rate, Clear Start ', color=BLUE, attr=BOLD )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[19]:     cmd.EFW_TMPKTRATE( 4, 1 )                   #Set APID 267 to 1Hz
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[20]:     cmd.EFW_DISARM(3)                           #Disarm SRAM scanning
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[21]:     SET_TESTVALUE0( 0 )
../../GSEOS_scripts\util.py[112]:     POKE( 0XDDF9, byte )
../../GSEOS_scripts\util.py[102]:     cmd.EFW_ADRH( (addr >> 8  )& 0xff )
../../GSEOS_scripts\util.py[103]:     cmd.EFW_ADRL( addr & 0xff )
../../GSEOS_scripts\util.py[104]:     cmd.EFW_LOAD( byte )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[22]:     SET_TESTVALUE1( 0 )
../../GSEOS_scripts\util.py[115]:     POKE( 0XDDFa, byte )
../../GSEOS_scripts\util.py[102]:     cmd.EFW_ADRH( (addr >> 8  )& 0xff )
../../GSEOS_scripts\util.py[103]:     cmd.EFW_ADRL( addr & 0xff )
../../GSEOS_scripts\util.py[104]:     cmd.EFW_LOAD( byte )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[23]:     wait(APID_267, lambda: APID_267.TESTVALUE == 0 , flTimeout=10)
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[23]:     wait(APID_267, lambda: APID_267.TESTVALUE == 0 , flTimeout=10)
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[25]:     log('2.  Verifying BKG ISR Duration @BKG[111]', color=BLUE, attr=BOLD )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[26]:     cmd.EFW_SRMWRTCTL(0)                        # Allow SRAM writes
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[27]:     POKE( 0x111, 0xEF )                         #BKG[addr] = RST 5
../../GSEOS_scripts\util.py[102]:     cmd.EFW_ADRH( (addr >> 8  )& 0xff )
../../GSEOS_scripts\util.py[103]:     cmd.EFW_ADRL( addr & 0xff )
../../GSEOS_scripts\util.py[104]:     cmd.EFW_LOAD( byte )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[28]:     sleep(8)
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[29]:     wait(APID_267, lambda: True , flTimeout=10)
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[29]:     wait(APID_267, lambda: True , flTimeout=10)
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[30]:     intnum = APID_267.TESTVALUE / 256
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[31]:     inttime= APID_267.TESTVALUE & 255
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[32]:     fmsec = (1000.0/65536.0) * inttime
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[33]:     log('Maximum Interrupt Service Time is %2.3f msec' % fmsec)
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[34]:     log('Percent of Interrupt at 256 Hz is %2.3f percent' % (fmsec*100.0/3.90625) )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[35]:     log('Maximum Interrupt Service Routine= %x hex' %intnum)
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[36]:     log('Requirement for ISR Duration < 2 msec : %s' % PF[fmsec < 2.0] )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[38]:     log('3.0 Restoring No Op at BKG[111]     ', color=BLUE, attr=BOLD )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[39]:     POKE( 0x111, 0 )                            #BKG[addr] = NOP
../../GSEOS_scripts\util.py[102]:     cmd.EFW_ADRH( (addr >> 8  )& 0xff )
../../GSEOS_scripts\util.py[103]:     cmd.EFW_ADRL( addr & 0xff )
../../GSEOS_scripts\util.py[104]:     cmd.EFW_LOAD( byte )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[40]:     cmd.EFW_SRMWRTCTL(1)                        # Protect SRAM
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[41]:     log('================END=====================', color=BLUE, attr=BOLD )
../../GSEOS_scripts/FSW_scripts\TEST_BKG_1.py[42]:     return(0)