Data Directory: /Users/teinturi/samdata/fmdata/2014-04-15-12.16.15-25188-SS_gc1_ega_SOL602/ Script: fei2tm.py $Revision: 1216 $ Created: 2014-04-18T13:50:37.049 UTC Hostname: vpn-128-154-255-185.gsfc.nasa.gov User: teinturi packet 2 ***Boot Loader v2.09 -- T. Nolan 08/30/2007*** Reset type: power up Load partition: 0x10000000 (1048576 bytes) ITF partition: 0x10100000 (1048576 bytes) .. . . Boot loader: table operation succeeded id name type flg start end blks bytes checksum 0 Master Record 229 00 0 0 1 -1 FFFFFFFF 0 Directory #1 228 00 1 28 28 -1 FFFFFFFF 1 tls_patch_1_6.bi 52 00 29 46 18 4392 F389C226 2 090317mtbl.dat 45 00 47 65 19 4800 ADFB07C6 3 pid100312-85.bin 50 00 66 86 21 5201 D054A34E 57 heater1344.dat 43 00 87 102 16 3952 A271580E 58 autoexec.bas 80 00 103 104 2 446 55E31880 13 safe1.32.bas 94 00 105 144 40 9938 2FDB3AB3 32 FillBlock4 227 00 145 148 4 1012 FFFFFFFF 29 FlightLim1.13.da 42 00 149 151 3 664 A6417A92 33 FillBlock1 227 00 152 152 1 253 FF00FF00 8 abort1.12.bas 95 00 153 194 42 10408 D3687FC6 34 FillBlock4 227 00 195 198 4 1012 FFFFFFFF 9 FSW_3.7.1.dat 32 00 199 1420 1222 309104 B7523A81 35 FillBlock121 227 00 1421 1541 121 30613 FF00FF00 27 samlib.bas 80 00 1542 1878 337 85141 1BAE33D0 36 FillBlock75 227 00 1879 1953 75 18975 FF00FF00 11 100316bt.dat 46 00 1954 1955 2 352 2BB4EAA3 37 FillBlock1 227 00 1956 1956 1 253 FF00FF00 15 baseline.bas 80 00 1957 2131 175 44120 DA0DB961 38 FillBlock17 227 00 2132 2148 17 4301 FF00FF00 56 samlib.bas 80 00 2149 2487 339 85657 82113099 28 LcSafe1.3.bas 93 00 2488 2488 1 116 B4099DAB 49 FillBlock1 227 00 2489 2489 1 253 FF00FF00 51 safeV0121 94 00 2490 2533 44 11102 A261E5D2 52 121104bt.dat 46 00 2534 2535 2 352 7187E398 53 130128bt.dat 46 00 2536 2537 2 352 8B0AC634 54 heater626.dat 43 00 2538 2553 16 3952 BA920E05 55 FSW_3.7.6.dat 32 00 2554 3787 1234 312098 CE438443 0 Free Blocks 226 00 3788 4067 280 -1 FFFFFFFF 0 Directory #2 228 00 4068 4095 28 -1 FFFFFFFF 450962665: SAM Flight Software Rev 3.7.6.0 -- T. Nolan May 31 2013 15:51:31 450962665: flash temperature=10.34 (57533) 450962665: watchdog_task: initialized 450962665: flash: 16 devices found 450962666: flash: 8192 blocks, 131072 pages, 67108864 bytes, 0 bad blocks 450962666: Write page: 53370, Read page: 53370, Info page: 83864 450962666: telem_task: initialized 450962666: basic_task: initialized 450962666: useq_task: AMUX table not found 450962666: useq_task: initialized 450962666: qms: loaded mass table from file 090317mtbl.dat 450962666: qms: 22 bands loaded from file 130128bt.dat 450962666: qms: initialized 450962666: qms: acquisition stopped 450962666: start_tls: channel 1 initialized on port 2 450962666: start_tls: channel 2 initialized on port 3 450962666: gc_task: initialized on port 4 450962666: alarm_task: 83 limit definitions loaded from file FlightLim1.13.da. 450962666: alarm_task: initialized 450962666: hss_receiver: initialized 450962667: malloc: 1228769 of 1310720 bytes allocated 450962667: I am SAM, SAM I am! 450962676: autoexec.bas $Revision: 1340 $ 450962677: lc: 83 channel entries, 75 enabled, 0 alarmed, alarm level=0 450962677: autoexec.bas complete (htr.max_watts=3.2) 450962679: hss_task: no op 450962679: hss_task: listening on side B 450962680: hss_task: no op 450962683: hss_task: old time=18, new time=450962683 450962689: hss_task: no op 450962690: hss_task: no op 450962691: hss_task: no op 450962713: FSW Configured EM1_CTRL=0x0000001A EM2_CTRL=0x0000001B 450962714: qms temperature compensation enabled 450962714: Loaded samlib.bas Revision: 738 450962715: qms.telem mode = 1 450962715: SS_ega_gc1_only_tls $Revision: 1448 $ 450962715: Configuration> 450962715: 450962715: cup=10 gccol=1 he_valve=34 450962715: use_ic_laser=0 use_nir_laser=0 450962715: vent_he=0 450962715: DEBUG=3 TEST_MODE=0 450962715: t_pyro_target=1150 (deg C) t_pyro_ramp=35 (deg C/min) 450962715: use_pyro_aux=-1 450962715: v_pyro_aux_start=4 v_pyro_aux_step=1 450962715: reserved_watts=1.11 450962715: t_pyro_preheat=125 (deg C) v_pyro_preheat=.7 450962715: s_pyro_slack=720 (sec) 450962715: 450962715: Number of entries in ramp action table: 4 450962715: temp .... action: 364 5 450962715: temp .... action: 500 30 450962715: temp .... action: 600 31 450962715: temp .... action: 700 32 450962715: 450962715: t_wrpstart=20 (deg C) s_wrpheat=1800 (sec) 450962716: wrp_rpm_g=100000 wrp_rpm_y=99000 (rpm) 450962716: wrp_rpm_coast=70000 wrp_rpm_err=1000 (rpm) 450962716: t_gpsheat1_g=25 t_gpsheat1_y=20 (deg C) 450962716: t_gpsheat2_g=50 t_gpsheat2_y=35 (deg C) 450962716: t_gpsheat3_g=135 t_gpsheat3_y=90 (deg C) 450962716: t_gpscool=80 t_gps_cleanup=75 (deg C) 450962716: 450962726: Number of entries in gcms action table: 2 450962726: IT elapsed .... action: 300 51 450962726: IT elapsed .... action: 980 52 450962726: s_totalgcms=2210 450962726: Number of entries in gc ramp stage table: 2 450962726: target .... ramprate: 175 15 450962726: target .... ramprate: 250 10 450962726: t_trapcool=5 t_trapinject=310 (deg C) 450962726: t_tec_floor=-10 t_tec_ceiling=20 (deg C) 450962726: 450962726: QMS> 450962726: qmsfil=1 qmsem=2 QMS_EM2_NOMINAL=164 450962726: srcpwmbus_ega=0 srcpwmbus_gcms=0 450962727: m_bgubeg=2 m_bguend=535 m_bgfbeg=1.5 m_bgfend=250 450962727: s_bguscan=120 s_bgfscan=240 450962727: n_smartbeg=6 450962727: m_stdubeg=2 m_stduend=535 s_stduscan=150 450962727: m_stdfbeg=1.5 m_stdfend=150 s_stdfscan=150 450962727: qms_num_bands=22 pyro_band_range=18 450962727: gc_band_range_lo=6 gc_band_range_hi=12 450962727: ss_thold_pct=100 450962727: qms.active_depth=22 qms.band_scans=6 450962727: qms.skip_count= 10 450962727: QMS_BA_MAXTRY=3 450962727: 450962727: GC> 450962727: t_gctcd_g(...)=0,85,50,85,85,50 450962727: t_gctcd_y(...)=0,75,45,75,65,45 450962728: T_GCTCD_LIMIT(...)=0,90,55,90,90,55 450962728: s_gcitflash=5 450962728: t_gcrampstart=-10 (deg C) 450962728: t_gccool=60 450962728: 450962728: Operating Mode (0=sci,1=test): 0 450962728: Command Origin (0=SAM,1=GSE): 0 450962728: Experiment Count: 1 450962728: Pressure Command/TCD On Delay (s): 10 450962728: TCD Therm Stabilization Time (5s): 24 450962728: Sample Travel Time (s): 60 450962728: Helium Pressure Limit (mb): 1200 450962728: Autozero Mode: 1 450962728: Autozero Method of Control: 0 450962728: Autozero Refresh Time (5s): 12 450962728: Autozero Correction Voltage: 18 450962728: Autozero PI Integral Coef: 5 450962728: Autozero Table Process Min Time (s): 10 450962728: Autozero Voltage Threshold High: 500 450962728: Autozero Voltage Threshold Low: 100 450962728: Autozero Set Point: 300 450962728: Autozero Activation Timeout: 50 450962728: Period 1 Sample Rate (smpl/s): 10 450962728: Period 2 Sample Rate (smpl/s): 100 450962728: Period 3 Sample Rate (smpl/s): 100 450962728: Period 4 Sample Rate (smpl/s): 100 450962728: Period 5 Sample Rate (smpl/s): 100 450962728: Period 6 Sample Rate (smpl/s): 100 450962728: Period 7 Sample Rate (smpl/s): 100 450962728: Period 8 Sample Rate (smpl/s): 1 450962728: s_gcstab=190 (s) 450962728: 450962728: 450962728: TLS> 450962728: tlsicnpts=1024 tlsicnavg=170 tlsicnskip=50 450962728: tlsnirnpts=1024 tlsnirnavg=40 tlsnirnskip=10 450962728: t_tls_cond=20 t_tls_ops=10 450962728: TLS_H2O_DELTA1=0 TLS_H2O_DELTA8=0 450962728: TLS_CO2_DELTA1=0 TLS_CO2_DELTA8=0 450962729: TLS_IC_DELTA=0 s_tlshphtr=300 450962729: TLS_FWASH_BOTTOM=45 TLS_FWASH_TOP=50 450962729: s_tls_acquire=3 450962729: nir_bg_scans=6 ic_bg_scans=6 450962729: nir_pyro_scans=22 ic_pyro_scans=12 450962729: cable_switch_off=0 cable_switch_on=1 450962729: s_valve_ten_time=240 s_fo_pump_out_time=120 450962729: s_cell_pump_out_time=240 pump_stages=1 450962729: s_squirt=200 450962731: Trap temp limit was: 360.0027 is now: 380 450962731: 450962731: BEGIN SS_ega_gc1_only_tls 450962731: sys.marker: id=1, txt=BEGIN 450962732: sys.marker: id=2, txt=Home valves so TM is right 450962732: valve 1 (vsw 32) closed 450962733: valve 2 (vsw 36) open 450962734: valve 3 (vsw 42) closed 450962735: valve 4 (vsw 33) closed 450962736: valve 5 (vsw 34) closed 450962737: valve 6 (vsw 39) closed 450962738: valve 7 (vsw 44) closed 450962739: valve 8 (vsw 45) closed 450962740: valve 9 (vsw 46) closed 450962741: valve 10 (vsw 47) closed 450962742: valve 11 (vsw 37) closed 450962742: hss_task: no op 450962743: valve 12 (vsw 38) closed 450962744: hss_task: no op 450962744: valve 13 (vsw 9) closed 450962745: valve 14 (vsw 10) closed 450962747: valve 15 (vsw 11) closed 450962748: valve 16 (vsw 12) closed 450962749: valve 17 (vsw 13) closed 450962750: valve 18 (vsw 14) closed 450962751: valve 19 (vsw 15) closed 450962752: valve 20 (vsw 16) closed 450962753: valve 21 (vsw 17) closed 450962754: valve 22 (vsw 18) closed 450962755: valve 23 (vsw 19) closed 450962756: valve 24 (vsw 20) closed 450962757: valve 25 (vsw 21) closed 450962758: valve 26 (vsw 22) closed 450962759: valve 27 (vsw 23) closed 450962760: valve 28 (vsw 35) closed 450962761: valve 29 (vsw 2) closed 450962762: valve 30 (vsw 3) closed 450962764: valve 31 (vsw 0) closed 450962765: valve 32 (vsw 4) closed 450962766: valve 33 (vsw 5) closed 450962767: valve 34 (vsw 43) closed 450962768: valve 35 (vsw 40) closed 450962769: valve 36 (vsw 41) closed 450962770: valve 37 (vsw 24) closed 450962771: valve 38 (vsw 25) closed 450962772: valve 39 (vsw 26) closed 450962773: valve 40 (vsw 27) closed 450962774: valve 41 (vsw 28) closed 450962775: valve 42 (vsw 29) closed 450962776: valve 43 (vsw 30) closed 450962777: valve 44 (vsw 1) closed 450962778: valve 45 (vsw 48) closed 450962779: valve 46 (vsw 49) closed 450962780: valve 47 (vsw 50) closed 450962782: valve 48 (vsw 51) closed 450962783: valve 49 (vsw 52) closed 450962784: valve 50 (vsw 8) closed 450962785: valve 51 (vsw 6) closed 450962786: valve 52 (vsw 7) closed 450962787: sys.marker: id=3, txt=MOT On 450962787: Reset MOT 450962792: Stop MISC 450962792: Load MISC code 450962792: mot_task: misc addr=0, nwords=11 450962792: mot_task: misc addr=20, nwords=16 450962792: mot_task: misc addr=40, nwords=16 450962793: mot_task: misc addr=60, nwords=16 450962793: mot_task: misc addr=80, nwords=16 450962793: mot_task: misc addr=A0, nwords=28 450962794: mot_task: misc addr=C0, nwords=28 450962795: mot_task: misc addr=E0, nwords=13 450962795: hss_task: no op 450962795: mot_task: misc addr=100, nwords=128 450962798: mot_task: misc addr=200, nwords=451 450962807: mot_task: end of program load 450962807: Set up ADC buffers 450962809: Run MISC 450962809: Initialize SMS params 450962810: INIT: Default SMS parameters set. 450962810: Set position of SCD wrt Ground, was 0, now 0 450962810: Set position of REF wrt Ground, was 0, now 2 450962815: lc: 83 channel entries, 83 enabled, 0 alarmed, alarm level=0 450962815: MOT Init Complete 450962816: Set position of REF wrt Ground, was 2, now 51 450962816: Set position of SCD wrt Ground, was 0, now 37 450962816: Hall counts: CAR: 19124, ELV: 54993 450962816: Tooth cts: Ref_1: 51, Ref_2: 51 450962816: Position of SCD: 37, REF: 51 450962816: Elevator state: Raised and loaded cup 450962816: SMS state restored 450962816: sys.aux2: on 450962817: sys.aux1: on 450962818: sys.marker: id=4, txt=Highway Heating Starts Here 450962818: T49_H46_MN2 htr#46 @ 135. pri=1 450962818: T48_H47_P41 htr#47 @ 135. pri=1 450962818: T52_H48_P46/47 htr#48 @ 135. pri=1 450962818: T38_H53_Inlet htr#53 @ 135. 450962818: T58_H55_P50 htr#55 @ 135. 450962818: T63_H59_P51 htr#59 @ 135. 450962818: Waiting 600 seconds... 450962828: Remaining wait time> 00:10:00 450962846: hss_task: no op 450962897: hss_task: no op 450962949: Remaining wait time> 00:08:00 450962949: hss_task: no op 450963000: hss_task: no op 450963051: hss_task: no op 450963069: Remaining wait time> 00:06:00 450963102: hss_task: no op 450963154: hss_task: no op 450963189: Remaining wait time> 00:04:00 450963205: hss_task: no op 450963256: hss_task: no op 450963307: hss_task: no op 450963309: Remaining wait time> 00:02:00 450963359: hss_task: no op 450963370: Remaining wait time> 00:01:00 450963400: Remaining wait time> 00:00:30 450963410: hss_task: no op 450963425: Remaining wait time> 00:00:05 450963441: sys.marker: id=5, txt=Continue Heating 450963441: WRP2 Heat htr#22 @ 20. 450963441: T53_H50_P48_MN htr#50 @ 135. 450963441: T57_H51_MN4 htr#51 @ 135. 450963441: T59_H57_MN5 htr#57 @ 135. 450963441: T61_H56_MN7 htr#56 @ 135. 450963441: T31_H27_MN15 htr#27 @ 50. 450963441: T29_H25_P30 htr#25 @ 50. 450963441: T25_H23_Sewer htr#23 @ 50. 450963441: T07_H21_P27 htr#21 @ 50. 450963441: T28_H20_P52/28 htr#20 @ 50. 450963441: Waiting 600 seconds... 450963451: Remaining wait time> 00:10:00 450963461: hss_task: no op 450963512: hss_task: no op 450963572: Remaining wait time> 00:08:00 450963692: Remaining wait time> 00:06:00 450963812: Remaining wait time> 00:04:00 450963932: Remaining wait time> 00:02:00 450963993: Remaining wait time> 00:01:00 450964023: Remaining wait time> 00:00:30 450964048: Remaining wait time> 00:00:05 450964064: sys.marker: id=6, txt=Continue Heating 450964064: WRP1 Heat htr#16 @ 20. 450964064: T33_H28_P31 htr#28 @ 50. 450964064: T34_H29_P32 htr#29 @ 50. 450964064: Waiting 300 seconds... 450964124: Remaining wait time> 00:04:00 450964244: Remaining wait time> 00:02:00 450964305: Remaining wait time> 00:01:00 450964335: Remaining wait time> 00:00:30 450964360: Remaining wait time> 00:00:05 450964375: sys.marker: id=7, txt=Complete Heating 450964375: T54_H40_MN6 htr#40 @ 50. 450964376: T35_H30_P33 htr#30 @ 50. 450964376: Waiting 300 seconds... 450964436: Remaining wait time> 00:04:00 450964556: Remaining wait time> 00:02:00 450964616: Remaining wait time> 00:01:00 450964647: Remaining wait time> 00:00:30 450964672: Remaining wait time> 00:00:05 450964687: T23_H19_MN11 htr#19 @ 25. pri=-1 450964687: T17_H14_P22 htr#14 @ 25. pri=-1 450964687: T18_H15_P23 htr#15 @ 25. pri=-1 450964687: T51_H13_P19/20 htr#13 @ 25. pri=-1 450964691: htrs.wait_temp: Tmin=128.9695 Tgreen=135+/-2 450964700: htrs.wait_temp: Tmin=129.1521 Tgreen=135+/-2 450964708: htrs.wait_temp: Tmin=129.4769 Tgreen=135+/-2 450964717: htrs.wait_temp: Tmin=129.6393 Tgreen=135+/-2 450964726: htrs.wait_temp: Tmin=129.7611 Tgreen=135+/-2 450964734: htrs.wait_temp: Tmin=129.9641 Tgreen=135+/-2 450964743: htrs.wait_temp: Tmin=130.1265 Tgreen=135+/-2 450964752: htrs.wait_temp: Tmin=130.3295 Tgreen=135+/-2 450964760: htrs.wait_temp: Tmin=130.4919 Tgreen=135+/-2 450964769: htrs.wait_temp: Tmin=130.695 Tgreen=135+/-2 450964778: htrs.wait_temp: Tmin=130.7762 Tgreen=135+/-2 450964786: htrs.wait_temp: Tmin=131.0402 Tgreen=135+/-2 450964795: htrs.wait_temp: Tmin=131.2433 Tgreen=135+/-2 450964804: htrs.wait_temp: Tmin=131.426 Tgreen=135+/-2 450964812: htrs.wait_temp: Tmin=131.6495 Tgreen=135+/-2 450964821: htrs.wait_temp: Tmin=131.751 Tgreen=135+/-2 450964830: htrs.wait_temp: Tmin=131.9135 Tgreen=135+/-2 450964838: htrs.wait_temp: Tmin=132.1573 Tgreen=135+/-2 450964847: htrs.wait_temp: Tmin=132.4214 Tgreen=135+/-2 450964856: htrs.wait_temp: Tmin=132.6042 Tgreen=135+/-2 450964864: htrs.wait_temp: Tmin=132.8277 Tgreen=135+/-2 450964873: htrs.wait_temp: Tmin=132.9903 Tgreen=135+/-2 450964882: htrs.wait_temp: Reached green temperature (135+/-2) Tmin=133.0716 450964883: htrs.wait_temp: Reached green temperature (135+/-2) Tmin=135.5922 450964883: sys.marker: id=8, txt=Start WRP2 450964884: htrs.wait_temp: Reached green temperature (20+/-2) Tmin=20.26289 450964884: valve 4 (vsw 33) open 450964895: valve 6 (vsw 39) open 450964908: Rotor align PWM=30 450964923: Rotor align PWM=20 450964953: WRP Startup mode 450964954: Waiting for 8000 rpm... 450964954: Current WRP2 RPM: 4 450964955: Current WRP2 RPM: 4 450964956: Current WRP2 RPM: 144 450964957: Current WRP2 RPM: 216 450964958: Current WRP2 RPM: 258 450964959: Current WRP2 RPM: 294 450964961: Current WRP2 RPM: 320 450964962: Current WRP2 RPM: 362 450964963: Current WRP2 RPM: 390 450964964: Current WRP2 RPM: 432 450964965: Current WRP2 RPM: 466 450964966: Current WRP2 RPM: 522 450964967: Current WRP2 RPM: 580 450964969: Current WRP2 RPM: 630 450964970: Current WRP2 RPM: 688 450964971: Current WRP2 RPM: 768 450964972: Current WRP2 RPM: 830 450964973: Current WRP2 RPM: 898 450964974: Current WRP2 RPM: 998 450964976: Current WRP2 RPM: 1102 450964977: Current WRP2 RPM: 1196 450964978: Current WRP2 RPM: 1336 450964979: Current WRP2 RPM: 1464 450964980: Current WRP2 RPM: 1600 450964981: Current WRP2 RPM: 1726 450964982: Current WRP2 RPM: 1876 450964984: Current WRP2 RPM: 2100 450964985: Current WRP2 RPM: 2288 450964986: Current WRP2 RPM: 2380 450964987: Current WRP2 RPM: 2380 450964988: Current WRP2 RPM: 2380 450964989: Current WRP2 RPM: 2380 450964990: Current WRP2 RPM: 2380 450964991: Current WRP2 RPM: 3498 450964993: Current WRP2 RPM: 3498 450964994: Current WRP2 RPM: 3498 450964995: Current WRP2 RPM: 3498 450964996: Current WRP2 RPM: 3498 450964997: Current WRP2 RPM: 3498 450964998: Current WRP2 RPM: 4534 450964999: Current WRP2 RPM: 4534 450965001: Current WRP2 RPM: 4534 450965002: Current WRP2 RPM: 4534 450965003: Current WRP2 RPM: 4534 450965004: Current WRP2 RPM: 5356 450965005: Current WRP2 RPM: 5356 450965006: Current WRP2 RPM: 5356 450965008: Current WRP2 RPM: 5356 450965009: Current WRP2 RPM: 5356 450965010: Current WRP2 RPM: 5356 450965011: Current WRP2 RPM: 6160 450965012: Current WRP2 RPM: 6160 450965013: Current WRP2 RPM: 6160 450965014: Current WRP2 RPM: 6160 450965016: Current WRP2 RPM: 6160 450965017: Current WRP2 RPM: 6698 450965018: Current WRP2 RPM: 6698 450965019: Current WRP 2 RPM: 6698 450965020: Current WRP2 RPM: 6698 450965021: Current WRP2 RPM: 6698 450965022: Current WRP2 RPM: 6698 450965024: Current WRP2 RPM: 7340 450965025: Current WRP2 RPM: 7340 450965026: Current WRP2 RPM: 7340 450965027: Current WRP2 RPM: 7340 450965028: Current WRP2 RPM: 7340 450965029: Current WRP2 RPM: 7340 450965031: Current WRP2 RPM: 8040 450965031: Switch to Back-EMF mode with target RPM: 100000 450965032: Waiting for 40,000 rpm... 450965032: Current WRP2 RPM: 7410 450965033: Current WRP2 RPM: 11826 450965035: Current WRP2 RPM: 16814 450965036: Current WRP2 RPM: 21254 450965037: Current WRP2 RPM: 25340 450965039: Current WRP2 RPM: 28984 450965040: Current WRP2 RPM: 32720 450965041: Current WRP2 RPM: 37530 450965043: Current WRP2 RPM: 41612 450965046: Waiting for 70,000 rpm... 450965046: Current WRP2 RPM: 44352 450965047: Current WRP2 RPM: 47672 450965048: Current WRP2 RPM: 52292 450965050: Current WRP2 RPM: 55830 450965051: Current WRP2 RPM: 59234 450965052: Current WRP2 RPM: 62808 450965054: Current WRP2 RPM: 65932 450965055: Current WRP2 RPM: 69042 450965056: Current WRP2 RPM: 71974 450965060: wrp.wait_rpm: WRP2 RPM=73316 Target=100000 450965065: wrp.wait_rpm: WRP2 RPM=81946 Target=100000 450965070: wrp.wait_rpm: WRP2 RPM=88174 Target=100000 450965075: wrp.wait_rpm: WRP2 RPM=93860 Target=100000 450965080: wrp.wait_rpm: final rpm 99432 450965080: Waiting 180 seconds... 450965140: Remaining wait time> 00:02:00 450965201: Remaining wait time> 00:01:00 450965231: Remaining wait time> 00:00:30 450965256: Remaining wait time> 00:00:05 450965271: sys.marker: id=9, txt=Start WRP1 450965272: htrs.wait_temp: Reached green temperature (20+/-2) Tmin=20.10011 450965273: valve 4 (vsw 33) closed 450965274: valve 1 (vsw 32) open 450965276: Rotor align PWM=30 450965292: Rotor align PWM=20 450965322: WRP Startup mode 450965322: Waiting for 8000 rpm... 450965322: Current WRP1 RPM: 4 450965323: Current WRP1 RPM: 4 450965325: Current WRP1 RPM: 144 450965326: Current WRP1 RPM: 216 450965327: Current WRP1 RPM: 258 450965328: Current WRP1 RPM: 290 450965329: Current WRP1 RPM: 324 450965330: Current WRP1 RPM: 356 450965331: Current WRP1 RPM: 390 450965333: Current WRP1 RPM: 428 450965334: Current WRP1 RPM: 466 450965335: Current WRP1 RPM: 512 450965336: Current WRP1 RPM: 572 450965337: Current WRP1 RPM: 626 450965338: Current WRP1 RPM: 684 450965340: Current WRP1 RPM: 764 450965341: Current WRP1 RPM: 822 450965342: Current WRP1 RPM: 912 450965343: Current WRP1 RPM: 992 450965344: Current WRP1 RPM: 1092 450965345: Current WRP1 RPM: 1216 450965346: Current WRP1 RPM: 1326 450965348: Current WRP1 RPM: 1462 450965349: Current WRP1 RPM: 1592 450965350: Current WRP1 RPM: 1718 450965351: Current WRP1 RPM: 1902 450965352: Current WRP1 RPM: 2088 450965353: Current WRP1 RPM: 2266 450965354: Current WRP1 RPM: 2368 450965356: Current WRP1 RPM: 2368 450965357: Current WRP1 RPM: 2368 450965358: Current WRP1 RPM: 2368 450965359: Current WRP1 RPM: 2368 450965360: Current WRP1 RPM: 3574 450965361: Current WRP1 RPM: 3574 450965362: Current WRP1 RPM: 3574 450965364: Current WRP1 RPM: 3574 450965365: Current WRP1 RPM: 3574 450965366: Current WRP1 RPM: 3574 450965367: Current WRP1 RPM: 4588 450965368: Current WRP1 RPM: 4588 450965369: Current WRP1 RPM: 4588 450965370: Current WRP1 RPM: 4588 450965372: Current WRP1 RPM: 4588 450965373: Current WRP1 RPM: 5400 450965374: Current WRP1 RPM: 5400 450965375: Current WRP1 RPM: 5400 450965376: Current WRP1 RPM: 5400 450965377: Current WRP1 RPM: 5400 450965378: Current WRP1 RPM: 5400 450965380: Current WRP1 RPM: 6190 450965381: Current WRP1 RPM: 6190 450965382: Current WRP1 RPM: 6190 450965383: Current WRP1 RPM: 6190 450965384: Current WRP1 RPM: 6190 450965385: Current WRP1 RPM: 6190 450965386: Current WRP1 RPM: 6732 450965388: Current WRP 1 RPM: 6732 450965389: Current WRP1 RPM: 6732 450965390: Current WRP1 RPM: 6732 450965391: Current WRP1 RPM: 6732 450965392: Current WRP1 RPM: 7384 450965393: Current WRP1 RPM: 7384 450965394: Current WRP1 RPM: 7384 450965396: Current WRP1 RPM: 7384 450965397: Current WRP1 RPM: 7384 450965398: Current WRP1 RPM: 7384 450965400: Current WRP1 RPM: 8034 450965400: Switch to Back-EMF mode with target RPM: 100000 450965401: Waiting for 40,000 rpm... 450965401: Current WRP1 RPM: 7776 450965402: Current WRP1 RPM: 11494 450965403: Current WRP1 RPM: 16838 450965405: Current WRP1 RPM: 22394 450965406: Current WRP1 RPM: 26568 450965407: Current WRP1 RPM: 31210 450965409: Current WRP1 RPM: 35446 450965410: Current WRP1 RPM: 39366 450965411: Current WRP1 RPM: 43338 450965414: Waiting for 70,000 rpm... 450965414: Current WRP1 RPM: 45868 450965416: Current WRP1 RPM: 49912 450965417: Current WRP1 RPM: 53890 450965418: Current WRP1 RPM: 57496 450965420: Current WRP1 RPM: 60986 450965421: Current WRP1 RPM: 64244 450965422: Current WRP1 RPM: 67398 450965424: Current WRP1 RPM: 70526 450965427: wrp.wait_rpm: WRP1 RPM=71920 Target=100000 450965432: wrp.wait_rpm: WRP1 RPM=80850 Target=100000 450965437: wrp.wait_rpm: WRP1 RPM=86956 Target=100000 450965442: wrp.wait_rpm: WRP1 RPM=93146 Target=100000 450965447: wrp.wait_rpm: WRP1 RPM=98414 Target=100000 450965452: wrp.wait_rpm: final rpm 99984 450965452: valve 4 (vsw 33) open 450965454: Waiting 180 seconds... 450965514: Remaining wait time> 00:02:00 450965574: Remaining wait time> 00:01:00 450965604: Remaining wait time> 00:00:30 450965630: Remaining wait time> 00:00:05 450965645: sys.marker: id=10, txt=Pump out GPS -- Open highway valves from 450965645: valve 20 (vsw 16) open 450965656: valve 45 (vsw 48) open 450965667: valve 43 (vsw 30) open 450965678: valve 38 (vsw 25) open 450965689: valve 41 (vsw 28) open 450965750: valve 21 (vsw 17) open 450965751: Waiting 240 seconds... 450965762: Remaining wait time> 00:04:00 450965882: Remaining wait time> 00:02:00 450965942: Remaining wait time> 00:01:00 450965972: Remaining wait time> 00:00:30 450965998: Remaining wait time> 00:00:05 450966013: sys.marker: id=11, txt=Pump out QMS 450966013: Starting HCV1 open operation... 450966013: Closing HCV before open to insure correct position 450966013: Closing HCV1... 450966015: HCV1 Hall Counts = -34 450966015: HCV1 Closed 450966016: Got buffered data 450966016: Opening HCV1 to 2000 Hall counts... 450966017: MINHALL:2000 450966017: MAXHALL:2100 450966021: HCV1 Init open to 2005 450966021: Opening HCV1 to 15000 Hall counts... 450966022: MINHALL:15000 450966022: MAXHALL:15100 450966043: HCV1 Opened to 15003 450966063: valve 2 (vsw 36) closed 450966064: sys.marker: id=12, txt=QMS/TLS BG Scans V11/V12 (leak) closed 450966064: Waiting 600 seconds... 450966074: Remaining wait time> 00:10:00 450966195: Remaining wait time> 00:08:00 450966315: Remaining wait time> 00:06:00 450966435: Remaining wait time> 00:04:00 450966555: Remaining wait time> 00:02:00 450966616: Remaining wait time> 00:01:00 450966646: Remaining wait time> 00:00:30 450966671: Remaining wait time> 00:00:05 450966687: Pyro2 primary pwm21 open-loop at 0 450966687: qms.telem mode = 4 450966689: qms: acquisition stopped 450966690: QMS Pressure Test Begin 450966690: THERM_PRESS test passed: .1443481 V 450966690: qms.telem mode = 2 450966721: Alarm task: WARNING: channel 17 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 18 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 19 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 20 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 21 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 22 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 24 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 25 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 26 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 27 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 28 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 29 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 30 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 31 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 32 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 74 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 69 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 66 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 64 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 63 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 68 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 65 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 42 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 67 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 52 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 55 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 51 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 35 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 72 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 57 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 43 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 73 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 71 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 44 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 53 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 53 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 54 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 54 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 126 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 78 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 79 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 8 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 6 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 9 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 7 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 112 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 12 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 5 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 4 has had no reading in 30 seconds 450966721: Alarm task: WARNING: channel 81 has had no reading in 30 seconds 450966753: sys.marker: id=13, txt=HK BA Emission detected 450966759: sys.marker: id=0, txt=HK 450966772: sys.marker: id=14, txt=HK BA Stable 450966773: BA_PRESS: 37188 450966778: BA_PRESS: 37164 450966783: BA_PRESS: 37117 450966788: BA_PRESS: 37083 450966793: BA_PRESS: 37044 450966798: BA_PRESS: 37012 450966803: BA_PRESS: 36986 450966808: BA_PRESS: 36961 450966813: BA_PRESS: 36937 450966818: BA_PRESS: 36913 450966824: BA_PRESS: 36897 450966829: BA_PRESS: 36883 450966834: sys.marker: id=0, txt=HK 450966834: Last BA PRES Delta: -14 450966834: useq_task: AMUX table not found 450966834: qms.telem mode = 4 450966834: QMS Pressure Test End 450966834: parallel port is: 48 450966834: parallel port was: 48 now: 2000048 450966834: HVM On 450966834: Multiplier 2 On 450966860: Filament 1 ON 450966860: THERM_PRESS check disabled for remainder of script 450966860: sys.marker: id=15, txt=QMS_UBGSCAN_BEGIN (leak closed) 450966860: qms: scan params AMU [2.0, 535.0) by step 1.0 450966861: qms: acquire scan for 120 sec 450966981: qms: acquisition stopped 450966986: sys.marker: id=0, txt=CAL QMS_UBGSCAN_END (leak closed) 450966986: sys.marker: id=16, txt=QMS_FBGSCAN_BEGIN (leak closed) 450966986: qms: scan params AMU [1.5, 250.0) by step 0.1 450966987: qms: acquire scan for 240 sec 450967227: qms: acquisition stopped 450967232: sys.marker: id=0, txt=CAL QMS_FBGSCAN_END (leak closed) 450967232: qms: acquisition stopped 450967232: Filament OFF 450967232: Multipliers Off 450967232: parallel port is: 2000048 450967233: parallel port was: 2000048 now: 48 450967233: HVM Off 450967233: sys.marker: id=17, txt=Check GPS temperatures 450967236: htrs.wait_temp: Reached green temperature (135+/-2) Tmin=134.9619 450967240: htrs.wait_temp: Reached green temperature (50+/-2) Tmin=49.90846 450967242: htrs.wait_temp: Reached green temperature (25+/-2) Tmin=25.05623 450967242: sys.marker: id=18, txt=Start of QMS Bg Scans V11 (leak) open 450967243: valve 11 (vsw 37) open 450967244: qms: acquisition stopped 450967244: QMS Pressure Test Begin 450967244: THERM_PRESS test passed: .09719849 V 450967245: qms.telem mode = 2 450967272: Alarm task: WARNING: channel 17 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 18 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 19 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 20 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 21 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 22 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 8 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 6 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 9 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 7 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 12 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 5 has had no reading in 30 seconds 450967272: Alarm task: WARNING: channel 4 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 24 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 25 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 26 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 27 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 28 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 29 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 30 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 31 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 32 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 74 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 69 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 66 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 64 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 63 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 68 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 65 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 42 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 67 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 52 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 55 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 51 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 35 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 72 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 57 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 43 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 73 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 71 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 44 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 53 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 53 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 54 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 54 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 126 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 78 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 79 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 112 has had no reading in 30 seconds 450967277: Alarm task: WARNING: channel 81 has had no reading in 30 seconds 450967307: sys.marker: id=19, txt=HK BA Emission detected 450967314: sys.marker: id=0, txt=HK 450967327: sys.marker: id=20, txt=HK BA Stable 450967327: BA_PRESS: 36729 450967332: BA_PRESS: 36772 450967337: BA_PRESS: 36772 450967342: BA_PRESS: 36766 450967347: BA_PRESS: 36757 450967352: BA_PRESS: 36745 450967358: BA_PRESS: 36736 450967363: BA_PRESS: 36729 450967368: BA_PRESS: 36716 450967373: BA_PRESS: 36705 450967378: BA_PRESS: 36695 450967383: BA_PRESS: 36683 450967388: sys.marker: id=0, txt=HK 450967388: Last BA PRES Delta: -12 450967388: useq_task: AMUX table not found 450967388: qms.telem mode = 4 450967388: QMS Pressure Test End 450967388: parallel port is: 48 450967388: parallel port was: 48 now: 2000048 450967388: HVM On 450967389: Multiplier 2 On 450967414: Filament 1 ON 450967414: sys.marker: id=21, txt=QMS_UBGSCAN_BEGIN (leak open) 450967414: qms: scan params AMU [2.0, 535.0) by step 1.0 450967415: qms: acquire scan for 120 sec 450967535: qms: acquisition stopped 450967540: sys.marker: id=0, txt=QMS_UBGSCAN_END (leak open) 450967540: sys.marker: id=22, txt=QMS_BGMARTSCAN_BEGIN (leak open) 450967540: sys.marker: id=23, txt=SCN SS baseline 450967541: qms: scan params Bands [6, 23) by step 1 450967542: qms: acquire scan for 90 sec 450967542: baseline accum started 450967632: qms: acquisition stopped 450967642: band 1 baseline=0 450967642: band 2 baseline=0 450967642: band 3 baseline=0 450967642: band 4 baseline=0 450967642: band 5 baseline=0 450967642: band 6 baseline=4743 450967642: band 7 baseline=67 450967642: band 8 baseline=32 450967642: band 9 baseline=29 450967642: band 10 baseline=18 450967642: band 11 baseline=22 450967642: band 12 baseline=8 450967642: band 13 baseline=4 450967642: band 14 baseline=2 450967642: band 15 baseline=3 450967642: band 16 baseline=0 450967642: band 17 baseline=0 450967642: band 18 baseline=0 450967642: band 19 baseline=0 450967642: band 20 baseline=0 450967642: band 21 baseline=0 450967642: band 22 baseline=0 450967642: sys.marker: id=0, txt=SCN SS baseline 450967642: Threshold 6 = 4743 450967642: Threshold 7 = 100 450967642: Threshold 8 = 100 450967642: Threshold 9 = 100 450967643: Threshold 10 = 100 450967643: Threshold 11 = 100 450967643: Threshold 12 = 100 450967643: Threshold 13 = 100 450967643: Threshold 14 = 100 450967643: Threshold 15 = 100 450967643: Threshold 16 = 100 450967644: Threshold 17 = 100 450967644: Threshold 18 = 100 450967644: Threshold 19 = 100 450967644: Threshold 20 = 100 450967644: Threshold 21 = 100 450967644: Threshold 22 = 100 450967644: Threshold 10 = 150 450967644: Threshold 12 = 150 450967645: Threshold 13 = 150 450967645: Threshold 15 = 150 450967645: Threshold 18 = 100 450967645: sys.marker: id=0, txt=QMS_BGMARTSCAN_END (leak open) 450967645: qms: acquisition stopped 450967645: Filament OFF 450967645: Multipliers Off 450967645: parallel port is: 2000048 450967645: parallel port was: 2000048 now: 48 450967645: HVM Off 450967645: valve 20 (vsw 16) closed 450967647: valve 21 (vsw 17) closed 450967648: valve 6 (vsw 39) closed 450967649: Braking WRP2... 450967680: WRP 2 full braking PWM applied 450967690: Braking complete. 450967690: valve 4 (vsw 33) closed 450967691: sys.marker: id=24, txt=Open Oven, Scan First volatiles 450967691: valve 32 (vsw 4) open 450967693: qms: acquisition stopped 450967693: QMS Pressure Test Begin 450967693: THERM_PRESS test passed: .07049561 V 450967693: qms.telem mode = 2 450967722: Alarm task: WARNING: channel 17 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 18 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 19 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 20 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 21 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 22 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 24 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 25 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 26 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 27 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 28 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 29 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 30 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 31 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 32 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 42 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 52 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 55 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 51 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 35 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 57 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 43 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 44 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 53 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 53 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 54 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 54 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 8 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 6 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 9 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 7 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 12 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 5 has had no reading in 30 seconds 450967722: Alarm task: WARNING: channel 4 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 74 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 69 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 66 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 64 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 63 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 68 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 65 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 67 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 72 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 73 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 71 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 126 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 78 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 79 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 112 has had no reading in 30 seconds 450967727: Alarm task: WARNING: channel 81 has had no reading in 30 seconds 450967754: sys.marker: id=25, txt=HK BA Emission detected 450967760: sys.marker: id=0, txt=HK 450967776: sys.marker: id=26, txt=HK BA Stable 450967776: BA_PRESS: 37196 450967781: BA_PRESS: 37248 450967786: BA_PRESS: 37258 450967791: BA_PRESS: 37258 450967796: BA_PRESS: 37252 450967801: BA_PRESS: 37245 450967806: BA_PRESS: 37242 450967812: BA_PRESS: 37234 450967817: BA_PRESS: 37227 450967822: BA_PRESS: 37221 450967827: BA_PRESS: 37216 450967832: BA_PRESS: 37210 450967837: sys.marker: id=0, txt=HK 450967837: Last BA PRES Delta: -6 450967837: useq_task: AMUX table not found 450967837: qms.telem mode = 4 450967837: QMS Pressure Test End 450967837: parallel port is: 48 450967837: parallel port was: 48 now: 2000048 450967837: HVM On 450967838: Multiplier 2 On 450967863: Filament 1 ON 450967863: sys.marker: id=27, txt=QMS_VOLATILE_BEGIN (leak open) 450967863: qms: scan params AMU [2.0, 101.0) by step 1.0 450967864: qms: acquire scan for 60 sec 450967924: qms: acquisition stopped 450967929: sys.marker: id=0, txt=QMS_VOLATILE_END (leak open) 450967929: qms: acquisition stopped 450967930: Filament OFF 450967930: Multipliers Off 450967930: parallel port is: 2000048 450967930: parallel port was: 2000048 now: 48 450967930: HVM Off 450967930: valve 11 (vsw 37) closed 450967931: sys.marker: id=28, txt=Relieve Pressure, Start Helium Flow 450967931: valve 32 (vsw 4) closed 450967942: valve 34 (vsw 43) open 450967943: valve 20 (vsw 16) open 450967944: valve 1 (vsw 32) closed 450967945: valve 5 (vsw 34) open 450967977: valve 34 (vsw 43) closed 450967988: valve 32 (vsw 4) open 450967989: valve 33 (vsw 5) open 450968000: valve 1 (vsw 32) open 450968001: valve 11 (vsw 37) open 450968002: sys.marker: id=29, txt=Start QMS Smart Scanning 450968002: qms: acquisition stopped 450968003: QMS Pressure Test Begin 450968003: THERM_PRESS test passed: .0453186 V 450968003: qms.telem mode = 2 450968032: Alarm task: WARNING: channel 17 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 18 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 19 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 20 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 21 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 22 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 24 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 25 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 26 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 27 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 28 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 29 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 30 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 31 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 32 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 74 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 69 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 66 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 64 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 63 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 68 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 65 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 42 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 67 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 52 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 55 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 51 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 35 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 72 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 57 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 43 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 73 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 71 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 44 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 53 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 53 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 54 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 54 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 78 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 79 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 8 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 6 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 9 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 7 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 12 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 5 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 4 has had no reading in 30 seconds 450968032: Alarm task: WARNING: channel 81 has had no reading in 30 seconds 450968037: Alarm task: WARNING: channel 126 has had no reading in 30 seconds 450968037: Alarm task: WARNING: channel 112 has had no reading in 30 seconds 450968063: sys.marker: id=30, txt=HK BA Emission detected 450968070: sys.marker: id=0, txt=HK 450968085: sys.marker: id=31, txt=HK BA Stable 450968085: BA_PRESS: 37428 450968091: BA_PRESS: 37506 450968096: BA_PRESS: 37515 450968101: BA_PRESS: 37517 450968106: BA_PRESS: 37521 450968111: BA_PRESS: 37514 450968116: BA_PRESS: 37514 450968121: BA_PRESS: 37509 450968126: BA_PRESS: 37502 450968131: BA_PRESS: 37495 450968136: BA_PRESS: 37493 450968142: BA_PRESS: 37492 450968147: sys.marker: id=0, txt=HK 450968147: Last BA PRES Delta: -1 450968147: useq_task: AMUX table not found 450968147: qms.telem mode = 4 450968147: QMS Pressure Test End 450968147: parallel port is: 48 450968147: parallel port was: 48 now: 2000048 450968147: HVM On 450968147: Multiplier 2 On 450968173: Filament 1 ON 450968173: sys.marker: id=32, txt=QMS_PYRO_SCAN_BEGIN 450968174: qms: acquire scan for 6000 sec 450968174: Reduce htr.max_watts from 3.2 to 2.09 450968174: Pyro2 secondary wire init 450968175: Pyrolysis1 pwm11 open-loop at 0 450968176: Pyro2 secondary pwm12 open-loop at 0 450968176: sys.marker: id=33, txt=Pyrolysis Pre Heat 450968176: sys.marker: id=34, txt=Pyrolysis Pre-Heating Begin 450968176: Pyro2 primary pwm2#1: ramp from 15.766 to 125. at 70. deg/min 450968176: Waiting 94.28571 seconds... 450968211: Remaining wait time> 00:01:00 450968241: Remaining wait time> 00:00:30 450968266: Remaining wait time> 00:00:05 450968269: pwm2 ramp done 450968285: Pyro2 primary pwm21 open-loop at 4587 450968285: Waiting 205.7143 seconds... 450968371: Remaining wait time> 00:02:00 450968431: Remaining wait time> 00:01:00 450968462: Remaining wait time> 00:00:30 450968487: Remaining wait time> 00:00:05 450968502: Pyro Temperature 67 450968502: Waiting 1500 seconds... 450968562: Remaining wait time> 00:24:00 450968683: Remaining wait time> 00:22:00 450968803: Remaining wait time> 00:20:00 450968923: Remaining wait time> 00:18:00 450969044: Remaining wait time> 00:16:00 450969164: Remaining wait time> 00:14:00 450969284: Remaining wait time> 00:12:00 450969405: Remaining wait time> 00:10:00 450969525: Remaining wait time> 00:08:00 450969645: Remaining wait time> 00:06:00 450969765: Remaining wait time> 00:04:00 450969886: Remaining wait time> 00:02:00 450969946: Remaining wait time> 00:01:00 450969976: Remaining wait time> 00:00:30 450970002: Remaining wait time> 00:00:05 450970017: sys.marker: id=35, txt=Start Pyrolysis, Heat to Target Temp 450970017: sys.marker: id=36, txt=Pyrolysis Heat Begin 450970017: Pyro2 primary pwm2#1: ramp from 66.899 to 1150. at 35. deg/min 450970018: sys.marker: id=37, txt=Execute Pyro Ramp Actions 450970048: Pyro Heating Time Left: 2545.571 450970048: Pyro Temperature: 35 450970108: Pyro Heating Time Left: 2485.571 450970108: Pyro Temperature: 78 450970168: Pyro Heating Time Left: 2425.571 450970168: Pyro Temperature: 112 450970228: Pyro Heating Time Left: 2365.571 450970228: Pyro Temperature: 144 450970288: Pyro Heating Time Left: 2305.571 450970288: Pyro Temperature: 179 450970348: Pyro Heating Time Left: 2245.571 450970348: Pyro Temperature: 215 450970408: Pyro Heating Time Left: 2185.571 450970408: Pyro Temperature: 250 450970468: Pyro Heating Time Left: 2125.571 450970468: Pyro Temperature: 286 450970528: Pyro Heating Time Left: 2065.571 450970528: Pyro Temperature: 322 450970588: Pyro Heating Time Left: 2005.571 450970588: Pyro Temperature: 357 450970601: Pyro Ramp Action ID 5: Open GC column 1 450970601: valve 13 (vsw 9) open 450970602: valve 22 (vsw 18) open 450970648: Pyro Heating Time Left: 1945.571 450970648: Pyro Temperature: 392 450970708: Pyro Heating Time Left: 1885.571 450970708: Pyro Temperature: 428 450970768: Pyro Heating Time Left: 1825.571 450970768: Pyro Temperature: 461 450970828: Pyro Heating Time Left: 1765.571 450970828: Pyro Temperature: 497 450970836: sys.marker: id=38, txt=Pyro Ramp Action: Pyro2 Wire2 V4 450970845: Pyro2 secondary pwm12 open-loop at 26214 450970888: Pyro Heating Time Left: 1705.571 450970888: Pyro Temperature: 534 450970948: Pyro Heating Time Left: 1645.571 450970948: Pyro Temperature: 570 450970999: sys.marker: id=39, txt=Pyro Ramp Action: Pyro2 Wire2 V5 450971001: Pyro2 secondary pwm12 open-loop at 32767 450971008: Pyro Heating Time Left: 1585.571 450971008: Pyro Temperature: 607 450971068: Pyro Heating Time Left: 1525.571 450971068: Pyro Temperature: 643 450971128: Pyro Heating Time Left: 1465.571 450971128: Pyro Temperature: 678 450971168: sys.marker: id=40, txt=Pyro Ramp Action: Pyro2 Wire2 V6 450971170: Pyro2 secondary pwm12 open-loop at 39321 450971188: Pyro Heating Time Left: 1405.571 450971188: Pyro Temperature: 713 450971248: Pyro Heating Time Left: 1345.571 450971248: Pyro Temperature: 749 450971308: Pyro Heating Time Left: 1285.571 450971308: Pyro Temperature: 784 450971368: Pyro Heating Time Left: 1225.571 450971368: Pyro Temperature: 817 450971428: Pyro Heating Time Left: 1165.571 450971428: Pyro Temperature: 851 450971488: Pyro Heating Time Left: 1105.571 450971488: Pyro Temperature: 884 450971548: Pyro Heating Time Left: 1045.571 450971548: Pyro Temperature: 917 450971608: Pyro Heating Time Left: 985.5714 450971608: Pyro Temperature: 945 450971668: Pyro Heating Time Left: 925.5714 450971668: Pyro Temperature: 959 450971728: Pyro Heating Time Left: 865.5714 450971728: Pyro Temperature: 970 450971788: Pyro Heating Time Left: 805.5714 450971788: Pyro Temperature: 977 450971848: Pyro Heating Time Left: 745.5714 450971848: Pyro Temperature: 983 450971873: pwm2 ramp done 450971908: Pyro Heating Time Left: 685.5714 450971908: Pyro Temperature: 987 450971968: Pyro Heating Time Left: 625.5714 450971968: Pyro Temperature: 989 450972028: Pyro Heating Time Left: 565.5714 450972028: Pyro Temperature: 991 450972088: Pyro Heating Time Left: 505.5714 450972088: Pyro Temperature: 993 450972148: Pyro Heating Time Left: 445.5714 450972148: Pyro Temperature: 994 450972208: Pyro Heating Time Left: 385.5714 450972208: Pyro Temperature: 995 450972268: Pyro Heating Time Left: 325.5714 450972268: Pyro Temperature: 995 450972328: Pyro Heating Time Left: 265.5714 450972328: Pyro Temperature: 994 450972388: Pyro Heating Time Left: 205.5714 450972388: Pyro Temperature: 995 450972448: Pyro Heating Time Left: 145.5714 450972448: Pyro Temperature: 995 450972508: Pyro Heating Time Left: 85.57143 450972508: Pyro Temperature: 995 450972568: Pyro Heating Time Left: 25.57143 450972568: Pyro Temperature: 995 450972594: valve 22 (vsw 18) closed 450972595: valve 13 (vsw 9) closed 450972596: valve 9 (vsw 46) closed 450972599: valve 1 (vsw 32) closed 450972602: valve 5 (vsw 34) open 450972605: valve 1 (vsw 32) open 450972606: TLS Hi htr#38 off 450972606: sys.marker: id=41, txt=Pyrolysis Heat Complete 450972606: Pyro Temperature 995 450972606: sys.marker: id=42, txt=Pyrolysis Heat Complete 450972607: sys.marker: id=43, txt=QMS_PYRO_SMARTSCAN_END 450972607: qms: acquisition stopped 450972607: Filament OFF 450972607: Multipliers Off 450972607: parallel port is: 200004A 450972607: parallel port was: 200004A now: 4A 450972607: HVM Off 450972608: valve 11 (vsw 37) closed 450972609: sys.marker: id=44, txt=Pyrolysis Stop 450972621: Pyro2 secondary pwm12 open-loop at 0 450972621: Restore htr.max_watts to 3.2 450972621: Pyro Temperature 988 450972641: Pyro2 primary pwm21 open-loop at 0 450972641: pwm2 heater off 450972641: qms.telem mode = 1 450972641: Waiting 300 seconds... 450972701: Remaining wait time> 00:04:00 450972822: Remaining wait time> 00:02:00 450972882: Remaining wait time> 00:01:00 450972912: Remaining wait time> 00:00:30 450972937: Remaining wait time> 00:00:05 450972953: valve 33 (vsw 5) closed 450972954: valve 32 (vsw 4) closed 450972955: valve 20 (vsw 16) closed 450972956: sys.marker: id=45, txt=Purge manifolds with helium 450972956: valve 34 (vsw 43) open 450973002: valve 34 (vsw 43) closed 450973003: valve 1 (vsw 32) closed 450973004: valve 20 (vsw 16) open 450973035: valve 20 (vsw 16) closed 450973037: valve 34 (vsw 43) open 450973048: valve 1 (vsw 32) open 450973049: sys.marker: id=46, txt=Check Temps for GC run 450973049: T48_H47_P41 htr#47 off 450973049: T49_H46_MN2 htr#46 off 450973049: T52_H48_P46/47 htr#48 off 450973049: T53_H50_P48_MN htr#50 off 450973049: T57_H51_MN4 htr#51 off 450973049: T58_H55_P50 htr#55 off 450973049: T59_H57_MN5 htr#57 off 450973049: T63_H59_P51 htr#59 off 450973049: T61_H56_MN7 htr#56 off 450973049: sys.marker: id=47, txt=Establish GC Column Thermal State 450973049: GC1 pwm1#4: ramp from 23.11 to -10. at 0. deg/min 450973095: PM3 Helium Pressure Delta Check Passed: +748.7699 mb 450973095: sys.marker: id=48, txt=Push helium through column 450973095: valve 22 (vsw 18) open 450973096: valve 13 (vsw 9) open 450973097: sys.marker: id=49, txt=Start QMS 450973097: valve 14 (vsw 10) open 450973098: T32_H33_P13_Cp htr#33 @ 135. 450973098: T27_H31_P1/2/3 htr#31 @ 135. 450973098: T54_H40_MN6 htr#40 @ 135. 450973099: qms: acquisition stopped 450973099: QMS Pressure Test Begin 450973099: THERM_PRESS test passed: .02380371 V 450973099: qms.telem mode = 2 450973127: Alarm task: WARNING: channel 126 has had no reading in 30 seconds 450973127: Alarm task: WARNING: channel 5 has had no reading in 30 seconds 450973127: Alarm task: WARNING: channel 4 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 18 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 19 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 20 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 21 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 22 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 24 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 25 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 26 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 27 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 28 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 29 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 30 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 31 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 32 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 74 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 69 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 66 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 64 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 68 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 42 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 67 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 52 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 55 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 51 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 35 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 72 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 57 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 43 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 70 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 58 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 73 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 62 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 48 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 71 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 44 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 49 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 47 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 50 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 53 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 53 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 60 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 54 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 54 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 56 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 78 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 79 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 8 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 6 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 9 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 7 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 112 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 12 has had no reading in 30 seconds 450973132: Alarm task: WARNING: channel 81 has had no reading in 30 seconds 450973160: sys.marker: id=50, txt=HK BA Emission detected 450973166: sys.marker: id=0, txt=HK 450973180: sys.marker: id=51, txt=HK BA Stable 450973180: BA_PRESS: 43751 450973185: BA_PRESS: 44413 450973190: BA_PRESS: 44853 450973195: BA_PRESS: 45193 450973200: BA_PRESS: 45482 450973205: BA_PRESS: 45718 450973210: BA_PRESS: 45920 450973216: BA_PRESS: 46085 450973221: BA_PRESS: 46213 450973226: BA_PRESS: 46342 450973231: BA_PRESS: 46437 450973236: BA_PRESS: 46527 450973241: sys.marker: id=0, txt=HK 450973241: Last BA PRES Delta: 90 450973241: useq_task: AMUX table not found 450973241: qms.telem mode = 1 450973241: QMS Pressure Test End 450973241: parallel port is: 44 450973241: parallel port was: 44 now: 2000044 450973241: HVM On 450973242: Multiplier 2 On 450973267: Filament 1 ON 450973267: sys.marker: id=52, txt=QMS_BGSMARTSCAN_BEGIN (gc run) 450973267: sys.marker: id=53, txt=SCN SS baseline 450973268: qms: scan params Bands [6, 23) by step 1 450973268: qms: acquire scan for 90 sec 450973268: baseline accum started 450973358: qms: acquisition stopped 450973368: band 1 baseline=0 450973368: band 2 baseline=0 450973368: band 3 baseline=0 450973368: band 4 baseline=0 450973368: band 5 baseline=0 450973368: band 6 baseline=6068 450973368: band 7 baseline=127 450973368: band 8 baseline=59 450973368: band 9 baseline=91 450973368: band 10 baseline=32 450973368: band 11 baseline=31 450973368: band 12 baseline=39 450973368: band 13 baseline=9 450973368: band 14 baseline=22 450973368: band 15 baseline=13 450973368: band 16 baseline=1 450973368: band 17 baseline=3 450973368: band 18 baseline=1 450973368: band 19 baseline=1 450973368: band 20 baseline=1 450973368: band 21 baseline=2 450973368: band 22 baseline=1 450973369: sys.marker: id=0, txt=SCN SS baseline 450973369: Threshold 6 = 6068 450973369: Threshold 7 = 127 450973369: Threshold 8 = 100 450973369: Threshold 9 = 100 450973369: Threshold 10 = 100 450973369: Threshold 11 = 100 450973369: Threshold 12 = 100 450973370: Threshold 13 = 100 450973370: Threshold 14 = 100 450973370: Threshold 15 = 100 450973370: Threshold 16 = 100 450973370: Threshold 17 = 100 450973370: Threshold 18 = 100 450973370: Threshold 19 = 100 450973371: Threshold 20 = 100 450973371: Threshold 21 = 100 450973371: Threshold 22 = 100 450973371: Threshold 10 = 150 450973371: Threshold 12 = 150 450973371: Threshold 13 = 150 450973371: Threshold 15 = 150 450973371: Threshold 18 = 150 450973372: sys.marker: id=0, txt=QMS_BGSMARTSCAN_END (gc run) 450973372: sys.marker: id=54, txt=Start of QMS GC Smart Scans 450973372: sys.marker: id=55, txt=QMS_GC_SMARTSCAN_BEGIN 450973373: qms: acquire scan for 6000 sec 450973373: sys.marker: id=56, txt=GC_RUN_BEGIN 450973374: Waiting 180 seconds... 450973434: Remaining wait time> 00:02:00 450973494: Remaining wait time> 00:01:00 450973524: Remaining wait time> 00:00:30 450973550: Remaining wait time> 00:00:05 450973565: T59_H57_MN5 htr#57 off 450973565: T63_H59_P51 htr#59 off 450973565: T58_H55_P50 htr#55 off 450973565: T61_H56_MN7 htr#56 off 450973565: sys.marker: id=57, txt=GC_IT_FLASH_NONE 450973565: basic timer: event=50, ticks=1500 450973595: EVT50 450973625: EVT50 450973629: Retention Time: 1 minutes 450973655: EVT50 450973685: EVT50 450973688: Retention Time: 2 minutes 450973715: EVT50 450973745: EVT50 450973749: Retention Time: 3 minutes 450973775: EVT50 450973805: EVT50 450973808: Retention Time: 4 minutes 450973835: EVT50 450973865: EVT50 450973869: Retention Time: 5 minutes 450973870: sys.marker: id=58, txt=GCMS Action ID 51: Ramp Stage 1 450973870: GC1 pwm1#4: ramp from 24.643 to 175. at 15. deg/min 450973895: EVT50 450973925: EVT50 450973928: Retention Time: 6 minutes 450973955: EVT50 450973985: EVT50 450973989: Retention Time: 7 minutes 450974015: EVT50 450974045: EVT50 450974048: Retention Time: 8 minutes 450974075: EVT50 450974105: EVT50 450974109: Retention Time: 9 minutes 450974135: EVT50 450974165: EVT50 450974168: Retention Time: 10 minutes 450974195: EVT50 450974225: EVT50 450974229: Retention Time: 11 minutes 450974255: EVT50 450974285: EVT50 450974289: Retention Time: 12 minutes 450974315: EVT50 450974345: EVT50 450974348: Retention Time: 13 minutes 450974375: EVT50 450974405: EVT50 450974409: Retention Time: 14 minutes 450974435: EVT50 450974465: EVT50 450974468: Retention Time: 15 minutes 450974471: pwm1 ramp done 450974495: EVT50 450974525: EVT50 450974529: Retention Time: 16 minutes 450974546: sys.marker: id=59, txt=GCMS Action ID 52: Ramp Stage 2 450974546: GC1 pwm1#4: ramp from 170.58 to 250. at 10. deg/min 450974555: EVT50 450974585: EVT50 450974588: Retention Time: 17 minutes 450974615: EVT50 450974645: EVT50 450974649: Retention Time: 18 minutes 450974675: EVT50 450974705: EVT50 450974708: Retention Time: 19 minutes 450974735: EVT50 450974765: EVT50 450974769: Retention Time: 20 minutes 450974795: EVT50 450974825: EVT50 450974828: Retention Time: 21 minutes 450974855: EVT50 450974885: EVT50 450974889: Retention Time: 22 minutes 450974915: EVT50 450974945: EVT50 450974948: Retention Time: 23 minutes 450974975: EVT50 450975005: EVT50 450975009: Retention Time: 24 minutes 450975023: pwm1 ramp done 450975035: EVT50 450975065: EVT50 450975068: Retention Time: 25 minutes 450975095: EVT50 450975125: EVT50 450975129: Retention Time: 26 minutes 450975155: EVT50 450975185: EVT50 450975188: Retention Time: 27 minutes 450975215: EVT50 450975245: EVT50 450975248: Retention Time: 28 minutes 450975275: EVT50 450975305: EVT50 450975309: Retention Time: 29 minutes 450975335: EVT50 450975365: EVT50 450975368: Retention Time: 30 minutes 450975395: EVT50 450975425: EVT50 450975429: Retention Time: 31 minutes 450975455: EVT50 450975485: EVT50 450975488: Retention Time: 32 minutes 450975515: EVT50 450975545: EVT50 450975549: Retention Time: 33 minutes 450975575: EVT50 450975605: EVT50 450975608: Retention Time: 34 minutes 450975635: EVT50 450975665: EVT50 450975669: Retention Time: 35 minutes 450975695: EVT50 450975725: EVT50 450975729: Retention Time: 36 minutes 450975755: EVT50 450975775: GCMS Complete 450975775: sys.marker: id=60, txt=GC run htrs off (H40,H30 still on) 450975775: T27_H31_P1/2/3 htr#31 off 450975775: T38_H53_Inlet htr#53 off 450975790: GC1 pwm14 open-loop at 0 450975790: EVT50 450975793: pwm1 heater off 450975793: sys.marker: id=61, txt=Shutdown GC and QMS 450975793: sys.marker: id=62, txt=GC_RUN END 450975793: qms: acquisition stopped 450975794: Filament OFF 450975794: Multipliers Off 450975794: parallel port is: 2000040 450975794: parallel port was: 2000040 now: 40 450975794: HVM Off 450975795: valve 14 (vsw 10) closed 450975796: sys.aux1: off 450975796: sys.marker: id=63, txt=Flush out GC with helium 450975797: htrs.wait_maxtemp: Tmax=250.0668 Tgreen=60+/-2 450975802: htrs.wait_maxtemp: Tmax=249.7296 Tgreen=60+/-2 450975808: htrs.wait_maxtemp: Tmax=249.0552 Tgreen=60+/-2 450975814: htrs.wait_maxtemp: Tmax=248.1493 Tgreen=60+/-2 450975819: htrs.wait_maxtemp: Tmax=247.6437 Tgreen=60+/-2 450975825: htrs.wait_maxtemp: Tmax=246.4855 Tgreen=60+/-2 450975831: htrs.wait_maxtemp: Tmax=245.2225 Tgreen=60+/-2 450975836: htrs.wait_maxtemp: Tmax=243.9599 Tgreen=60+/-2 450975842: htrs.wait_maxtemp: Tmax=243.3289 Tgreen=60+/-2 450975848: htrs.wait_maxtemp: Tmax=241.983 Tgreen=60+/-2 450975854: htrs.wait_maxtemp: Tmax=240.5327 Tgreen=60+/-2 450975859: htrs.wait_maxtemp: Tmax=239.146 Tgreen=60+/-2 450975865: htrs.wait_maxtemp: Tmax=238.4109 Tgreen=60+/-2 450975871: htrs.wait_maxtemp: Tmax=236.9622 Tgreen=60+/-2 450975876: htrs.wait_maxtemp: Tmax=235.5561 Tgreen=60+/-2 450975882: htrs.wait_maxtemp: Tmax=234.2555 Tgreen=60+/-2 450975888: htrs.wait_maxtemp: Tmax=233.5215 Tgreen=60+/-2 450975893: htrs.wait_maxtemp: Tmax=232.1589 Tgreen=60+/-2 450975899: htrs.wait_maxtemp: Tmax=230.6712 Tgreen=60+/-2 450975905: htrs.wait_maxtemp: Tmax=229.4145 Tgreen=60+/-2 450975910: htrs.wait_maxtemp: Tmax=228.6398 Tgreen=60+/-2 450975916: htrs.wait_maxtemp: Tmax=227.3839 Tgreen=60+/-2 450975922: htrs.wait_maxtemp: Tmax=226.0867 Tgreen=60+/-2 450975927: htrs.wait_maxtemp: Tmax=225.3128 Tgreen=60+/-2 450975933: htrs.wait_maxtemp: Tmax=224.0373 Tgreen=60+/-2 450975939: htrs.wait_maxtemp: Tmax=222.7414 Tgreen=60+/-2 450975944: htrs.wait_maxtemp: Tmax=221.5506 Tgreen=60+/-2 450975950: htrs.wait_maxtemp: Tmax=220.8195 Tgreen=60+/-2 450975956: htrs.wait_maxtemp: Tmax=219.6503 Tgreen=60+/-2 450975962: htrs.wait_maxtemp: Tmax=218.3145 Tgreen=60+/-2 450975967: htrs.wait_maxtemp: Tmax=217.1044 Tgreen=60+/-2 450975973: htrs.wait_maxtemp: Tmax=216.5412 Tgreen=60+/-2 450975979: htrs.wait_maxtemp: Tmax=215.311 Tgreen=60+/-2 450975984: htrs.wait_maxtemp: Tmax=214.0396 Tgreen=60+/-2 450975990: htrs.wait_maxtemp: Tmax=212.9353 Tgreen=60+/-2 450975996: htrs.wait_maxtemp: Tmax=212.2687 Tgreen=60+/-2 450976001: htrs.wait_maxtemp: Tmax= 211.1026 Tgreen=60+/-2 450976007: htrs.wait_maxtemp: Tmax=210.041 Tgreen=60+/-2 450976013: htrs.wait_maxtemp: Tmax=208.8757 Tgreen=60+/-2 450976018: htrs.wait_maxtemp: Tmax=208.314 Tgreen=60+/-2 450976024: htrs.wait_maxtemp: Tmax=207.1909 Tgreen=60+/-2 450976030: htrs.wait_maxtemp: Tmax=205.985 Tgreen=60+/-2 450976035: htrs.wait_maxtemp: Tmax=204.9875 Tgreen=60+/-2 450976041: htrs.wait_maxtemp: Tmax=204.4057 Tgreen=60+/-2 450976047: htrs.wait_maxtemp: Tmax=203.3463 Tgreen=60+/-2 450976053: htrs.wait_maxtemp: Tmax=202.3287 Tgreen=60+/-2 450976058: htrs.wait_maxtemp: Tmax=201.1455 Tgreen=60+/-2 450976064: htrs.wait_maxtemp: Tmax=200.7304 Tgreen=60+/-2 450976070: htrs.wait_maxtemp: Tmax=199.5478 Tgreen=60+/-2 450976075: htrs.wait_maxtemp: Tmax=198.5522 Tgreen=60+/-2 450976081: htrs.wait_maxtemp: Tmax=197.557 Tgreen=60+/-2 450976087: htrs.wait_maxtemp: Tmax=196.9973 Tgreen=60+/-2 450976092: htrs.wait_maxtemp: Tmax=196.0439 Tgreen=60+/-2 450976098: htrs.wait_maxtemp: Tmax=195.3602 Tgreen=60+/-2 450976104: htrs.wait_maxtemp: Tmax=194.6145 Tgreen=60+/-2 450976109: htrs.wait_maxtemp: Tmax=194.2624 Tgreen=60+/-2 450976115: htrs.wait_maxtemp: Tmax=193.6411 Tgreen=60+/-2 450976121: htrs.wait_maxtemp: Tmax=192.9165 Tgreen=60+/-2 450976126: htrs.wait_maxtemp: Tmax=191.7781 Tgreen=60+/-2 450976132: htrs.wait_maxtemp: Tmax=191.116 Tgreen=60+/-2 450976138: htrs.wait_maxtemp: Tmax=189.7922 Tgreen=60+/-2 450976144: htrs.wait_maxtemp: Tmax=188.6342 Tgreen=60+/-2 450976149: htrs.wait_maxtemp: Tmax=187.9934 Tgreen=60+/-2 450976155: htrs.wait_maxtemp: Tmax=186.8361 Tgreen=60+/-2 450976161: htrs.wait_maxtemp: Tmax=185.6793 Tgreen=60+/-2 450976166: htrs.wait_maxtemp: Tmax=184.7706 Tgreen=60+/-2 450976172: htrs.wait_maxtemp: Tmax=184.2338 Tgreen=60+/-2 450976178: htrs.wait_maxtemp: Tmax=183.3462 Tgreen=60+/-2 450976183: htrs.wait_maxtemp: Tmax=182.2731 Tgreen=60+/-2 450976189: htrs.wait_maxtemp: Tmax=181.4067 Tgreen=60+/-2 450976195: htrs.wait_maxtemp: Tmax=181.0148 Tgreen=60+/-2 450976200: htrs.wait_maxtemp: Tmax=180.025 Tgreen=60+/-2 450976206: htrs.wait_maxtemp: Tmax=179.1179 Tgreen=60+/-2 450976212: htrs.wait_maxtemp: Tmax=178.2317 Tgreen=60+/- 2 450976217: htrs.wait_maxtemp: Tmax=177.8402 Tgreen=60+/-2 450976223: htrs.wait_maxtemp: Tmax=176.9544 Tgreen=60+/-2 450976229: htrs.wait_maxtemp: Tmax=176.1512 Tgreen=60+/-2 450976234: htrs.wait_maxtemp: Tmax=175.2658 Tgreen=60+/-2 450976240: htrs.wait_maxtemp: Tmax=174.6894 Tgreen=60+/-2 450976246: htrs.wait_maxtemp: Tmax=173.8867 Tgreen=60+/-2 450976252: htrs.wait_maxtemp: Tmax=173.1254 Tgreen=60+/-2 450976257: htrs.wait_maxtemp: Tmax=172.3026 Tgreen=60+/-2 450976263: htrs.wait_maxtemp: Tmax=171.809 Tgreen=60+/-2 450976269: htrs.wait_maxtemp: Tmax=170.9659 Tgreen=60+/-2 450976274: htrs.wait_maxtemp: Tmax=170.1847 Tgreen=60+/-2 450976280: htrs.wait_maxtemp: Tmax=169.3421 Tgreen=60+/-2 450976286: htrs.wait_maxtemp: Tmax=168.9928 Tgreen=60+/-2 450976291: htrs.wait_maxtemp: Tmax=168.171 Tgreen=60+/-2 450976297: htrs.wait_maxtemp: Tmax=167.3084 Tgreen=60+/-2 450976303: htrs.wait_maxtemp: Tmax=166.5486 Tgreen=60+/-2 450976308: htrs.wait_maxtemp: Tmax=166.2201 Tgreen=60+/-2 450976314: htrs.wait_maxtemp: Tmax=165.4401 Tgreen=60+/-2 450976320: htrs.wait_maxtemp: Tmax=164.6397 Tgreen=60+/-2 450976325: htrs.wait_maxtemp: Tmax=163.8191 Tgreen=60+/-2 450976331: htrs.wait_maxtemp: Tmax=163.5114 Tgreen=60+/-2 450976337: htrs.wait_maxtemp: Tmax=162.7525 Tgreen=60+/-2 450976342: htrs.wait_maxtemp: Tmax=161.9528 Tgreen=60+/-2 450976348: htrs.wait_maxtemp: Tmax=161.6043 Tgreen=60+/-2 450976354: htrs.wait_maxtemp: Tmax=160.8049 Tgreen=60+/-2 450976360: htrs.wait_maxtemp: Tmax=160.0877 Tgreen=60+/-2 450976365: htrs.wait_maxtemp: Tmax=159.3501 Tgreen=60+/-2 450976371: htrs.wait_maxtemp: Tmax=159.0018 Tgreen=60+/-2 450976377: htrs.wait_maxtemp: Tmax=158.1826 Tgreen=60+/-2 450976382: htrs.wait_maxtemp: Tmax=157.5888 Tgreen=60+/-2 450976388: htrs.wait_maxtemp: Tmax=156.8109 Tgreen=60+/-2 450976394: htrs.wait_maxtemp: Tmax=156.4629 Tgreen=60+/-2 450976399: htrs.wait_maxtemp: Tmax=155.6238 Tgreen=60+/-2 450976399: htrs.wait_maxtemp: Failed to reach yellow (60+/-2) stopped at 155.6238 deg C 450976400: GC column cooldown completed 450976400: valve 34 (vsw 43) closed 450976401: valve 13 (vsw 9) closed 450976402: Waiting 120 seconds... 450976412: Remaining wait time> 00:02:00 450976472: Remaining wait time> 00:01:00 450976503: Remaining wait time> 00:00:30 450976528: Remaining wait time> 00:00:05 450976543: valve 22 (vsw 18) closed 450976544: sys.marker: id=64, txt=Cleanup and Shutdown 450976544: Closing HCV1... 450976569: HCV1 Hall Counts = 23 450976569: HCV1 Closed 450976570: Got buffered data 450976570: Braking WRP1... 450976602: WRP 1 full braking PWM applied 450976612: Braking complete. 450976612: WRP1 Heat htr#16 off 450976612: T18_H15_P23 htr#15 off 450976612: valve 1 (vsw 32) closed 450976613: valve 2 (vsw 36) open 450976614: valve 20 (vsw 16) open 450976635: valve 5 (vsw 34) closed 450976636: sys.marker: id=65, txt=Spin up WRP2 to 100k 450976636: valve 4 (vsw 33) open 450976642: valve 6 (vsw 39) open 450976645: Rotor align PWM=30 450976660: Rotor align PWM=20 450976691: WRP Startup mode 450976691: Waiting for 8000 rpm... 450976691: Current WRP2 RPM: 4 450976692: Current WRP2 RPM: 4 450976693: Current WRP2 RPM: 160 450976694: Current WRP2 RPM: 216 450976696: Current WRP2 RPM: 266 450976697: Current WRP2 RPM: 294 450976698: Current WRP2 RPM: 320 450976699: Current WRP2 RPM: 362 450976700: Current WRP2 RPM: 394 450976701: Current WRP2 RPM: 424 450976702: Current WRP2 RPM: 470 450976704: Current WRP2 RPM: 516 450976705: Current WRP2 RPM: 580 450976706: Current WRP2 RPM: 628 450976707: Current WRP2 RPM: 688 450976708: Current WRP2 RPM: 772 450976709: Current WRP2 RPM: 830 450976710: Current WRP2 RPM: 904 450976712: Current WRP2 RPM: 1002 450976713: Current WRP2 RPM: 1106 450976714: Current WRP2 RPM: 1226 450976715: Current WRP2 RPM: 1336 450976716: Current WRP2 RPM: 1464 450976717: Current WRP2 RPM: 1610 450976719: Current WRP2 RPM: 1736 450976720: Current WRP2 RPM: 1882 450976721: Current WRP2 RPM: 2110 450976722: Current WRP2 RPM: 2288 450976723: Current WRP2 RPM: 2380 450976724: Current WRP2 RPM: 2380 450976725: Current WRP2 RPM: 2786 450976727: Current WRP2 RPM: 2786 450976728: Current WRP2 RPM: 2786 450976729: Current WRP2 RPM: 2786 450976730: Current WRP2 RPM: 2786 450976731: Current WRP2 RPM: 3984 450976732: Current WRP2 RPM: 3984 450976733: Current WRP2 RPM: 3984 450976735: Current WRP2 RPM: 3984 450976736: Current WRP2 RPM: 3984 450976737: Current WRP2 RPM: 3984 450976738: Current WRP2 RPM: 4888 450976739: Current WRP2 RPM: 4888 450976740: Current WRP2 RPM: 4888 450976741: Current WRP2 RPM: 4888 450976743: Current WRP2 RPM: 4888 450976744: Current WRP2 RPM: 4888 450976745: Current WRP2 RPM: 5708 450976746: Current WRP2 RPM: 5708 450976747: Current WRP2 RPM: 5708 450976748: Current WRP2 RPM: 5708 450976749: Current WRP2 RPM: 5708 450976751: Current WRP2 RPM: 6386 450976752: Current WRP2 RPM: 6386 450976753: Current WRP2 RPM: 6386 450976754: Current WRP2 RPM: 6386 450976755: Current WRP2 RPM: 6386 450976756: Current WRP2 RPM: 6386 450976757: Current WRP2 RPM: 6970 450976759: Current WRP 2 RPM: 6970 450976760: Current WRP2 RPM: 6970 450976761: Current WRP2 RPM: 6970 450976762: Current WRP2 RPM: 6970 450976763: Current WRP2 RPM: 7662 450976764: Current WRP2 RPM: 7662 450976766: Current WRP2 RPM: 7662 450976767: Current WRP2 RPM: 7662 450976768: Current WRP2 RPM: 7662 450976769: Current WRP2 RPM: 7662 450976771: Current WRP2 RPM: 8428 450976771: Switch to Back-EMF mode with target RPM: 100000 450976772: Waiting for 40,000 rpm... 450976772: Current WRP2 RPM: 8176 450976773: Current WRP2 RPM: 11832 450976774: Current WRP2 RPM: 17760 450976776: Current WRP2 RPM: 22090 450976777: Current WRP2 RPM: 25880 450976778: Current WRP2 RPM: 29484 450976780: Current WRP2 RPM: 33116 450976781: Current WRP2 RPM: 36724 450976782: Current WRP2 RPM: 40334 450976785: Waiting for 70,000 rpm... 450976785: Current WRP2 RPM: 42468 450976787: Current WRP2 RPM: 46468 450976788: Current WRP2 RPM: 50056 450976789: Current WRP2 RPM: 54202 450976791: Current WRP2 RPM: 57502 450976792: Current WRP2 RPM: 60818 450976793: Current WRP2 RPM: 63924 450976795: Current WRP2 RPM: 66992 450976796: Current WRP2 RPM: 69810 450976797: Current WRP2 RPM: 72624 450976801: wrp.wait_rpm: WRP2 RPM=73630 Target=100000 450976806: wrp.wait_rpm: WRP2 RPM=81772 Target=100000 450976811: wrp.wait_rpm: WRP2 RPM=87536 Target=100000 450976816: wrp.wait_rpm: WRP2 RPM=92824 Target=100000 450976821: wrp.wait_rpm: WRP2 RPM=97970 Target=100000 450976826: wrp.wait_rpm: final rpm 100002 450976826: Waiting 600 seconds... 450976836: Remaining wait time> 00:10:00 450976957: Remaining wait time> 00:08:00 450977077: Remaining wait time> 00:06:00 450977197: Remaining wait time> 00:04:00 450977318: Remaining wait time> 00:02:00 450977378: Remaining wait time> 00:01:00 450977408: Remaining wait time> 00:00:30 450977434: Remaining wait time> 00:00:05 450977449: sys.marker: id=66, txt=Pump out GPS / TLS 450977449: Post Pyrolysis Pumping 450977449: Waiting 240 seconds... 450977459: Remaining wait time> 00:04:00 450977579: Remaining wait time> 00:02:00 450977640: Remaining wait time> 00:01:00 450977670: Remaining wait time> 00:00:30 450977695: Remaining wait time> 00:00:05 450977711: TLS Hi htr#38 off 450977711: valve 32 (vsw 4) open 450977742: sys.marker: id=67, txt=Condition GPS out 450977742: T32_H33_P13_Cp htr#33 @ 75. 450977742: T49_H46_MN2 htr#46 @ 75. 450977742: T52_H48_P46/47 htr#48 @ 75. 450977742: T38_H53_Inlet htr#53 @ 75. 450977742: T53_H50_P48_MN htr#50 @ 75. 450977742: T57_H51_MN4 htr#51 @ 75. 450977742: T58_H55_P50 htr#55 @ 75. 450977742: T59_H57_MN5 htr#57 @ 75. 450977742: T63_H59_P51 htr#59 @ 75. 450977742: T61_H56_MN7 htr#56 @ 75. 450977742: T35_H30_P33 htr#30 @ 75. 450977742: T54_H40_MN6 htr#40 @ 75. 450977742: T28_H20_P52/28 htr#20 @ 50. 450977742: T25_H23_Sewer htr#23 @ 50. 450977743: T29_H25_P30 htr#25 @ 50. 450977743: T33_H28_P31 htr#28 @ 50. 450977743: T34_H29_P32 htr#29 @ 50. 450977743: T31_H27_MN15 htr#27 @ 50. 450977743: T07_H21_P27 htr#21 @ 25. 450977743: T23_H19_MN11 htr#19 @ 25. pri=-1 450977743: T17_H14_P22 htr#14 @ 25. pri=-1 450977743: T51_H13_P19/20 htr#13 @ 25. pri=-1 450977748: htrs.wait_temp: Tmin=33.97706 Tgreen=75+/-2 450977759: htrs.wait_temp: Tmin=34.92371 Tgreen=75+/-2 450977769: htrs.wait_temp: Tmin=38.41678 Tgreen=75+/-2 450977780: htrs.wait_temp: Tmin=41.20201 Tgreen=75+/-2 450977790: htrs.wait_temp: Tmin=44.28624 Tgreen=75+/-2 450977800: htrs.wait_temp: Tmin=47.53172 Tgreen=75+/-2 450977811: htrs.wait_temp: Tmin=50.3642 Tgreen=75+/-2 450977821: htrs.wait_temp: Tmin=52.9016 Tgreen=75+/-2 450977832: htrs.wait_temp: Tmin=55.30202 Tgreen=75+/-2 450977842: htrs.wait_temp: Tmin=57.56516 Tgreen=75+/-2 450977852: htrs.wait_temp: Tmin=59.90933 Tgreen=75+/-2 450977863: htrs.wait_temp: Tmin=62.15572 Tgreen=75+/-2 450977873: htrs.wait_temp: Tmin=64.22454 Tgreen=75+/-2 450977884: htrs.wait_temp: Tmin=66.25483 Tgreen=75+/-2 450977894: htrs.wait_temp: Tmin=68.04729 Tgreen=75+/-2 450977905: htrs.wait_temp: Tmin=69.4421 Tgreen=75+/-2 450977915: htrs.wait_temp: Tmin=70.7378 Tgreen=75+/-2 450977925: htrs.wait_temp: Tmin=71.05682 Tgreen=75+/-2 450977936: htrs.wait_temp: Tmin=71.39581 Tgreen=75+/-2 450977946: htrs.wait_temp: Tmin=71.61518 Tgreen=75+/-2 450977957: htrs.wait_temp: Tmin=71.69495 Tgreen=75+/-2 450977967: htrs.wait_temp: Tmin=71.7149 Tgreen=75+/-2 450977978: htrs.wait_temp: Tmin=71.73484 Tgreen=75+/-2 450977988: htrs.wait_temp: Tmin=71.79467 Tgreen= 75+/-2 450977998: htrs.wait_temp: Tmin=71.85451 Tgreen=75+/-2 450978009: htrs.wait_temp: Tmin=71.95423 Tgreen=75+/-2 450978019: htrs.wait_temp: Tmin=72.09385 Tgreen=75+/-2 450978030: htrs.wait_temp: Tmin=72.13374 Tgreen=75+/-2 450978040: htrs.wait_temp: Tmin=72.23347 Tgreen=75+/-2 450978050: htrs.wait_temp: Tmin=72.27337 Tgreen=75+/-2 450978061: htrs.wait_temp: Tmin=72.31326 Tgreen=75+/-2 450978071: htrs.wait_temp: Tmin=72.413 Tgreen=75+/-2 450978082: htrs.wait_temp: Tmin=72.413 Tgreen=75+/-2 450978092: htrs.wait_temp: Tmin=72.43295 Tgreen=75+/-2 450978103: htrs.wait_temp: Tmin=72.51274 Tgreen=75+/-2 450978113: htrs.wait_temp: Tmin=72.53269 Tgreen=75+/-2 450978123: htrs.wait_temp: Tmin=72.65238 Tgreen=75+/-2 450978134: htrs.wait_temp: Tmin=72.75213 Tgreen=75+/-2 450978144: htrs.wait_temp: Tmin=72.75213 Tgreen=75+/-2 450978155: htrs.wait_temp: Tmin=72.83193 Tgreen=75+/-2 450978165: htrs.wait_temp: Tmin=72.87183 Tgreen=75+/-2 450978175: htrs.wait_temp: Tmin=72.87183 Tgreen=75+/-2 450978186: htrs.wait_temp: Tmin=72.89178 Tgreen=75+/-2 450978196: htrs.wait_temp: Tmin=72.99154 Tgreen=75+/-2 450978207: htrs.wait_temp: Tmin=72.99154 Tgreen=75+/-2 450978217: htrs.wait_temp: Reached green temperature (75+/-2) Tmin=73.03144 450978220: htrs.wait_temp: Reached green temperature (50+/-2) Tmin=49.09622 450978222: htrs.wait_temp: Reached green temperature (25+/-2) Tmin=24.62359 450978222: sys.marker: id=68, txt=Pumping highway thru V20,V21... 450978222: valve 21 (vsw 17) open 450978224: Waiting 300 seconds... 450978284: Remaining wait time> 00:04:00 450978404: Remaining wait time> 00:02:00 450978464: Remaining wait time> 00:01:00 450978495: Remaining wait time> 00:00:30 450978520: Remaining wait time> 00:00:05 450978535: sys.marker: id=69, txt=Close valves on path from pyro to GC 450978535: valve 32 (vsw 4) closed 450978551: valve 38 (vsw 25) closed 450978567: valve 43 (vsw 30) closed 450978583: valve 41 (vsw 28) closed 450978600: valve 45 (vsw 48) closed 450978616: sys.marker: id=70, txt=Cool down 450978616: GC TEC 1 htr#2 off 450978616: T08_H03_TCD_2 htr#3 off 450978616: GC TEC 2 htr#4 off 450978616: T09_H05_TCD_3 htr#5 off 450978616: GC TEC 3 htr#6 off 450978616: T10_H07_TCD_4 htr#7 off 450978616: T11_H08_TCD_5 htr#8 off 450978616: T12_H09_TCD_6 htr#9 off 450978616: T13_H10_IT_1 htr#10 off 450978616: T14_H11_IT_2 htr#11 off 450978616: T15_H12_IT_3 htr#12 off 450978616: T51_H13_P19/20 htr#13 off 450978616: T17_H14_P22 htr#14 off 450978616: T18_H15_P23 htr#15 off 450978616: WRP1 Heat htr#16 off 450978616: T19_H17_QMS_Hs htr#17 off 450978616: T22_H18_MN10 htr#18 off 450978616: T23_H19_MN11 htr#19 off 450978616: T28_H20_P52/28 htr#20 off 450978616: T07_H21_P27 htr#21 off 450978616: WRP2 Heat htr#22 off 450978616: T25_H23_Sewer htr#23 off 450978616: TLSHeatPipeKick htr#24 off 450978616: T29_H25_P30 htr#25 off 450978616: T36_H26_P34 htr#26 off 450978616: T31_H27_MN15 htr#27 off 450978616: T33_H28_P31 htr#28 off 450978616: T34_H29_P32 htr#29 off 450978616: T35_H30_P33 htr#30 off 450978616: T27_H31_P1/2/3 htr#31 off 450978616: T26_H32_P4/5/6 htr#32 off 450978616: T32_H33_P13_Cp htr#33 off 450978617: T39_H34_P14_Cp htr#34 off 450978617: T24_H35_P16_Cp htr#35 off 450978617: T30_H36_P17_Cp htr#36 off 450978617: TLS Lo htr#37 off 450978617: TLS Hi htr#38 off 450978617: T37_H39_TLS_Vt htr#39 off 450978617: T54_H40_MN6 htr#40 off 450978617: T42_H41_SSIT_L htr#41 off 450978617: T43_H42_P21 htr#42 off 450978617: T44_H43_P36 htr#43 off 450978617: T45_H44_P40_MN htr#44 off 450978617: T46_H45_Inlt_1 htr#45 off 450978617: T49_H46_MN2 htr#46 off 450978617: T48_H47_P41 htr#47 off 450978617: T52_H48_P46/47 htr#48 off 450978617: T66_H49_P15_Cp htr#49 off 450978617: T53_H50_P48_MN htr#50 off 450978617: T57_H51_MN4 htr#51 off 450978617: T55_H52_H2O htr#52 off 450978617: T38_H53_Inlet htr#53 off 450978617: T50_H54_CO2 htr#54 off 450978617: T58_H55_P50 htr#55 off 450978617: T61_H56_MN7 htr#56 off 450978617: T59_H57_MN5 htr#57 off 450978617: Trap htr#58 off 450978617: T63_H59_P51 htr#59 off 450978617: T67_H60_P18_Cp htr#60 off 450978617: WRP2 Heat htr#22 @ 20. 450978623: htrs.wait_maxtemp: Tmax=94.10757 Tgreen=80+/-2 450978633: htrs.wait_maxtemp: Tmax=93.72609 Tgreen=80+/-2 450978643: htrs.wait_maxtemp: Tmax=93.42494 Tgreen=80+/-2 450978654: htrs.wait_maxtemp: Tmax=93.16398 Tgreen=80+/-2 450978664: htrs.wait_maxtemp: Tmax=92.90303 Tgreen=80+/-2 450978675: htrs.wait_maxtemp: Tmax=92.52168 Tgreen=80+/-2 450978685: htrs.wait_maxtemp: Tmax=92.32099 Tgreen=80+/-2 450978695: htrs.wait_maxtemp: Tmax=92.01998 Tgreen=80+/-2 450978706: htrs.wait_maxtemp: Tmax=91.71899 Tgreen=80+/-2 450978716: htrs.wait_maxtemp: Tmax=91.45816 Tgreen=80+/-2 450978726: htrs.wait_maxtemp: Tmax=91.19734 Tgreen=80+/-2 450978737: htrs.wait_maxtemp: Tmax=90.89643 Tgreen=80+/-2 450978747: htrs.wait_maxtemp: Tmax=90.51532 Tgreen=80+/-2 450978757: htrs.wait_maxtemp: Tmax=90.27463 Tgreen=80+/-2 450978768: htrs.wait_maxtemp: Tmax=90.01392 Tgreen=80+/-2 450978778: htrs.wait_maxtemp: Tmax=89.77327 Tgreen=80+/-2 450978789: htrs.wait_maxtemp: Tmax=89.43239 Tgreen=80+/-2 450978799: htrs.wait_maxtemp: Tmax=89.15169 Tgreen=80+/-2 450978809: htrs.wait_maxtemp: Tmax=88.9512 Tgreen=80+/-2 450978820: htrs.wait_maxtemp: Tmax=88.59036 Tgreen=80+/-2 450978830: htrs.wait_maxtemp: Tmax=88.34981 Tgreen=80+/-2 450978840: htrs.wait_maxtemp: Tmax=88.08925 Tgreen=80+/-2 450978851: htrs.wait_maxtemp: Tmax=87.68842 Tgreen=80+/-2 450978861: htrs.wait_maxtemp: Tmax=87.46798 Tgreen=80+/-2 450978871: htrs.wait_maxtemp: Tmax=87.20748 Tgreen=80+/-2 450978882: htrs.wait_maxtemp: Tmax=86.94701 Tgreen=80+/-2 450978892: htrs.wait_maxtemp: Tmax=86.72662 Tgreen=80+/-2 450978903: htrs.wait_maxtemp: Tmax=86.38605 Tgreen=80+/-2 450978913: htrs.wait_maxtemp: Tmax=86.18573 Tgreen=80+/-2 450978923: htrs.wait_maxtemp: Tmax=85.92534 Tgreen=80+/-2 450978934: htrs.wait_maxtemp: Tmax=85.62491 Tgreen=80+/-2 450978944: htrs.wait_maxtemp: Tmax=85.44466 Tgreen=80+/-2 450978954: htrs.wait_maxtemp: Tmax=85.14428 Tgreen=80+/-2 450978965: htrs.wait_maxtemp: Tmax=84.84392 Tgreen=80+/-2 450978975: htrs.wait_maxtemp: Tmax=84.60365 Tgreen=80+/-2 450978986: htrs.wait_maxtemp: Tmax=84.2633 Tgreen=80+/-2 450978996: htrs.wait_maxtemp: Tmax=84.04309 Tgreen=80+/-2 450979006: htrs.wait_maxtemp: Tmax=83.86293 Tgreen=80+/-2 450979017: htrs.wait_maxtemp: Tmax=83.48263 Tgreen=80+/-2 450979027: htrs.wait_maxtemp: Tmax= 83.20244 Tgreen=80+/-2 450979037: htrs.wait_maxtemp: Tmax=83.02232 Tgreen=80+/-2 450979048: htrs.wait_maxtemp: Tmax=82.72216 Tgreen=80+/-2 450979058: htrs.wait_maxtemp: Tmax=82.48204 Tgreen=80+/-2 450979068: htrs.wait_maxtemp: Tmax=82.18193 Tgreen=80+/-2 450979079: htrs.wait_maxtemp: Tmax=82.02187 Tgreen=80+/-2 450979089: htrs.wait_maxtemp: Reached green temperature (80+/-2) Tmax=81.7418 450979090: htrs.wait_maxtemp: Reached green temperature (60+/-2) Tmax=41.87397 450979090: valve 6 (vsw 39) closed 450979091: valve 4 (vsw 33) closed 450979092: valve 13 (vsw 9) open 450979113: valve 22 (vsw 18) open 450979115: valve 5 (vsw 34) open 450979126: valve 5 (vsw 34) closed 450979127: valve 4 (vsw 33) open 450979128: valve 6 (vsw 39) open 450979129: Waiting 300 seconds... 450979189: Remaining wait time> 00:04:00 450979309: Remaining wait time> 00:02:00 450979370: Remaining wait time> 00:01:00 450979400: Remaining wait time> 00:00:30 450979425: Remaining wait time> 00:00:05 450979440: valve 13 (vsw 9) closed 450979442: valve 22 (vsw 18) closed 450979443: valve 20 (vsw 16) closed 450979459: valve 21 (vsw 17) closed 450979475: valve 6 (vsw 39) closed 450979476: sys.marker: id=71, txt=WRP2 off -- stop pumping 450979476: Braking WRP2... 450979507: WRP 2 full braking PWM applied 450979517: Braking complete. 450979517: valve 4 (vsw 33) closed 450979518: sys.marker: id=72, txt=Safe SAM 450979518: DpCreate: UNLOADCUP 450979518: sms.unload_and_lower_cup 450979519: Applying sensormask 0x00FFF 450979519: UNLOAD/LOWER CUP [EM]: Unload Cup... 450979519: SMS Motion: ELV CW fine, stop on: Sprg 450979520: Monitor: started 450979522: Switches: 450979522: Elv position: 54754 450979522: Car position: 19124 tooth1=51, tooth2=51 450979522: UNLOAD/LOWER CUP [EM]: Unload Cup complete. 450979522: UNLOAD/LOWER CUP [EM]: Cantilever Restoration... 450979522: SMS Motion: ELV CW coarse, stop on: Cle 450979522: Monitor: started 450979525: Switches: Cle 450979525: Elv position: 53571 450979525: Car position: 19124 tooth1=51, tooth2=51 450979525: UNLOAD/LOWER CUP [EM]: Cantilever Restoration complete. 450979525: UNLOAD/LOWER CUP [EM]: Home Elevator I... 450979525: SMS Motion: ELV CW coarse, stop on: Home 450979525: Monitor: started 450979580: Switches: Cle El_h 450979580: Elv position: -385 450979580: Car position: 19124 tooth1=51, tooth2=51 450979580: UNLOAD/LOWER CUP [EM]: Home Elevator I complete. 450979580: UNLOAD/LOWER CUP [EM]: Home Cup... 450979580: SMS Motion: ELV CW fine, stop on: 450979581: Monitor: started 450979587: MOT Fault: ELV over current 450979587: Switches: Cle El_h 450979587: Elv position: -1676 450979587: Car position: 19124 tooth1=51, tooth2=51 450979587: UNLOAD/LOWER CUP [EM]: Home Cup complete. 450979588: UNLOAD/LOWER CUP [EM]: Home Elevator II... 450979588: SMS Motion: ELV CCW fine, stop on: Home 450979588: Monitor: started 450979597: Switches: Cle 450979597: Elv position: 169 450979597: Car position: 19124 tooth1=51, tooth2=51 450979597: UNLOAD/LOWER CUP [EM]: Home Elevator II complete. 450979597: UNLOAD/LOWER CUP [EM]: REF To Traverse Position... 450979597: SMS Motion: ELV CCW coarse, stop on: Hall 450979597: Monitor: started 450979599: Switches: Cle 450979599: Elv position: 299 450979599: Car position: 19124 tooth1=51, tooth2=51 450979599: UNLOAD/LOWER CUP [EM]: REF To Traverse Position complete. 450979599: Unload and lower cup: Normal completion 450979599: DpCreate: SHIFTSCD 450979599: sms.shift_scd 2, 2, 0 450979599: Applying sensormask 0x00FFF 450979600: SHIFT SCD [EM]: REF To Toggle Cam I... 450979600: SMS Motion: CAR CW fine, stop on: Hall 450979600: Monitor: started 450979602: Switches: Ref1 Cle 450979602: Elv position: 299 450979602: Car position: 19085 tooth1=51, tooth2=51 450979602: SHIFT SCD [EM]: REF To Toggle Cam I complete 450979602: SHIFT SCD [EM]: REF To Toggle Cam II... 450979602: SMS Motion: CAR CW coarse, stop on: Tooth 450979602: Monitor: started 450979609: Switches: Ref2 Cle 450979609: Elv position: 299 450979609: Car position: 14025 tooth1=37, tooth2=37 450979609: SHIFT SCD [EM]: REF To Toggle Cam II complete 450979609: SHIFT SCD [EM]: REF To Toggle Cam III... 450979609: SMS Motion: CAR CW fine, stop on: Toggle 450979609: Monitor: started 450979612: Switches: Ref2 Cle Togl 450979612: Elv position: 299 450979612: Car position: 13910 tooth1=37, tooth2=37 450979612: SHIFT SCD [EM]: REF To Toggle Cam III complete 450979612: SHIFT SCD [EM]: REF To Toggle Cam IV... 450979612: SMS Motion: CAR CW fine, stop on: Ref2 450979612: Monitor: started 450979614: Switches: Cle Togl 450979614: Elv position: 299 450979614: Car position: 13885 tooth1=37, tooth2=37 450979614: SHIFT SCD [EM]: REF To Toggle Cam IV complete 450979614: Set position of REF wrt Ground, was 51, now 37 450979614: SHIFT SCD [EM]: Superfine position I... 450979614: SMS Motion: CAR CW fine, stop on: Hall 450979614: Monitor: started 450979616: Switches: Cle Togl 450979616: Elv position: 299 450979616: Car position: 13870 tooth1=37, tooth2=37 450979616: SHIFT SCD [EM]: Superfine position I complete 450979616: SHIFT SCD [EM]: Engage Toggle Cam... 450979616: SMS Motion: ELV CCW coarse, stop on: Toggle 450979616: Monitor: started 450979626: Switches: Cle 450979626: Elv position: 8597 450979626: Car position: 13870 tooth1=37, tooth2=37 450979626: SHIFT SCD [EM]: Engage Toggle Cam complete 450979626: SHIFT SCD [EM]: Unlock SCD From Ground... 450979626: SMS Motion: ELV CCW coarse, stop on: Hall 450979626: Monitor: started 450979632: Switches: Cle 450979632: Elv position: 13343 450979632: Car position: 13870 tooth1=37, tooth2=37 450979632: SHIFT SCD [EM]: Unlock SCD From Ground complete 450979632: SHIFT SCD [EM]: Reposition SCD I... 450979632: SMS Motion: CAR CW fine, stop on: Hall 450979633: Monitor: started 450979635: Switches: Ref1 Cle 450979635: Elv position: 13343 450979635: Car position: 13836 tooth1=37, tooth2=37 450979635: SHIFT SCD [EM]: Reposition SCD I complete 450979635: SHIFT SCD [EM]: Reposition SCD II... 450979635: SMS Motion: CAR CW coarse, stop on: Hall 450979635: Monitor: started 450979650: Switches: Ref2 Cle 450979650: Elv position: 13343 450979650: Car position: 153 tooth1=37, tooth2=37 450979650: SHIFT SCD [EM]: Reposition SCD II complete 450979650: SHIFT SCD [EM]: Reposition SCD III... 450979650: SMS Motion: CAR CW fine, stop on: Hall 450979650: Monitor: started 450979653: Switches: Cle 450979653: Elv position: 13343 450979653: Car position: 0 tooth1=37, tooth2=37 450979653: SHIFT SCD [EM]: Reposition SCD III complete 450979654: SHIFT SCD [EM]: Superfine position II... 450979654: SMS Motion: CAR CW fine, stop on: Hall 450979654: Monitor: started 450979655: Switches: Cle 450979655: Elv position: 13343 450979655: Car position: 0 tooth1=37, tooth2=37 450979655: SHIFT SCD [EM]: Superfine position II complete 450979655: Set position of SCD wrt Ground, was 37, now 0 450979655: Set position of REF wrt Ground, was 37, now 0 450979655: SHIFT SCD [EM]: Lock SCD To Ground... 450979655: SMS Motion: ELV CW coarse, stop on: Toggle 450979656: Monitor: started 450979662: Switches: Cle Togl 450979662: Elv position: 8519 450979662: Car position: 0 tooth1=0, tooth2=0 450979662: SHIFT SCD [EM]: Lock SCD To Ground complete 450979662: SHIFT SCD [EM]: Elevator To Traverse Position... 450979662: SMS Motion: ELV CW coarse, stop on: Hall 450979662: Monitor: started 450979672: Switches: Cle Togl 450979672: Elv position: 252 450979672: Car position: 0 tooth1=0, tooth2=0 450979672: SHIFT SCD [EM]: Elevator To Traverse Position complete 450979672: SHIFT SCD [EM]: REF to SCD Location I... 450979672: SMS Motion: CAR CCW fine, stop on: Toggle 450979672: Monitor: started 450979674: Switches: Ref2 Cle 450979674: Elv position: 252 450979674: Car position: 43 tooth1=0, tooth2=0 450979674: SHIFT SCD [EM]: REF to SCD Location I complete 450979674: SHIFT SCD [EM]: REF to Final SCD Location III... 450979674: SMS Motion: CAR CCW fine, stop on: Tooth 450979674: Monitor: started 450979677: Switches: Ref1 Cle 450979677: Elv position: 252 450979677: Car position: 206 tooth1=1, tooth2=1 450979677: SHIFT SCD [EM]: REF to Final SCD Location III complete 450979678: SHIFT SCD [EM]: REF to Final SCD Location IV... 450979678: SMS Motion: CAR CCW fine, stop on: Hall 450979678: Monitor: started 450979680: Switches: Ref1 Cle 450979680: Elv position: 252 450979680: Car position: 246 tooth1=1, tooth2=1 450979680: SHIFT SCD [EM]: REF to Final SCD Location IV complete 450979680: SHIFT SCD [EM]: REF to Final SCD Location V-a... 450979680: SMS Motion: CAR CCW fine, stop on: Ref2 450979681: Monitor: started 450979683: Switches: Ref2 Cle 450979683: Elv position: 252 450979683: Car position: 391 tooth1=1, tooth2=1 450979683: SHIFT SCD [EM]: REF to Final SCD Location V-a complete 450979684: SHIFT SCD [EM]: REF to Final SCD Location VI... 450979684: SMS Motion: CAR CCW fine, stop on: Hall 450979684: Monitor: started 450979686: Switches: Ref2 Cle 450979686: Elv position: 252 450979686: Car position: 431 tooth1=1, tooth2=1 450979686: SHIFT SCD [EM]: REF to Final SCD Location VI complete 450979686: SHIFT SCD [EM]: REF to Final SCD Location VII... 450979686: SMS Motion: CAR CCW fine, stop on: Tooth 450979687: Monitor: started 450979689: Switches: Ref1 Cle 450979689: Elv position: 252 450979689: Car position: 582 tooth1=2, tooth2=2 450979689: SHIFT SCD [EM]: REF to Final SCD Location VII complete 450979690: SHIFT SCD [EM]: REF to Final SCD Location VIII... 450979690: SMS Motion: CAR CCW fine, stop on: Hall 450979690: Monitor: started 450979692: Switches: Ref1 Cle 450979692: Elv position: 252 450979692: Car position: 622 tooth1=2, tooth2=2 450979692: SHIFT SCD [EM]: REF to Final SCD Location VIII complete 450979692: SHIFT SCD [EM]: REF to Final SCD Location IX... 450979692: SMS Motion: CAR CCW fine, stop on: Ref1 450979693: Monitor: started 450979695: Switches: Cle 450979695: Elv position: 252 450979695: Car position: 738 tooth1=2, tooth2=2 450979695: SHIFT SCD [EM]: REF to Final SCD Location IX complete 450979696: SHIFT SCD [EM]: REF to Final SCD Location X... 450979696: SMS Motion: CAR CCW fine, stop on: Hall 450979696: Monitor: started 450979698: Switches: Cle 450979698: Elv position: 252 450979698: Car position: 751 tooth1=2, tooth2=2 450979698: SHIFT SCD [EM]: REF to Final SCD Location X complete 450979698: Set position of REF wrt Ground, was 0, now 2 450979698: Shift SCD: Normal completion 450979698: DpCreate: RAISEPLUG 450979698: sms.raise_ssit_plug 150 450979698: Applying sensormask 0x00FFF 450979698: RAISE SSIT PLUG: REF To Plug Position I... 450979698: SMS Motion: CAR CCW fine, stop on: Cle 450979699: Monitor: started 450979702: Switches: Ref2 450979702: Elv position: 252 450979702: Car position: 866 tooth1=2, tooth2=2 450979702: RAISE SSIT PLUG: REF To Plug Position I complete. 450979702: RAISE SSIT PLUG: REF To Plug Position II... 450979702: SMS Motion: CAR CCW fine, stop on: Hall 450979702: Monitor: started 450979704: Switches: Ref2 450979704: Elv position: 252 450979704: Car position: 903 tooth1=2, tooth2=2 450979704: RAISE SSIT PLUG: REF To Plug Position II complete. 450979704: RAISE SSIT PLUG: REF To Plug Position III... 450979704: SMS Motion: CAR CCW fine, stop on: Cle 450979705: Monitor: started 450979707: Switches: Ref1 Ref2 Cle 450979707: Elv position: 252 450979707: Car position: 940 tooth1=2, tooth2=2 450979707: RAISE SSIT PLUG: REF To Plug Position III complete. 450979707: RAISE SSIT PLUG: REF To Plug Position IV... 450979707: SMS Motion: CAR CW fine, stop on: Hall 450979708: Monitor: started 450979710: Switches: Ref2 450979710: Elv position: 252 450979710: Car position: 903 tooth1=2, tooth2=2 450979710: RAISE SSIT PLUG: REF To Plug Position IV complete. 450979710: RAISE SSIT PLUG: Cantilever Deflection... 450979710: SMS Motion: ELV CCW coarse, stop on: Ref2 450979710: Monitor: started 450979721: Switches: 450979721: Elv position: 10375 450979721: Car position: 903 tooth1=2, tooth2=2 450979721: RAISE SSIT PLUG: Cantilever Deflection complete. 450979721: RAISE SSIT PLUG: Load Plug I... 450979721: SMS Motion: ELV CCW fine, stop on: Sprg 450979722: Monitor: started 450979729: Switches: Sprg 450979729: Elv position: 11928 450979729: Car position: 903 tooth1=2, tooth2=2 450979729: RAISE SSIT PLUG: Load Plug I complete. 450979729: Desired preload: 150 lb DeltaZ: 172 counts 450979730: RAISE SSIT PLUG: Load Plug II... 450979730: SMS Motion: ELV CCW fine, stop on: Hall 450979730: Monitor: started 450979732: Switches: Sprg 450979732: Elv position: 12095 450979732: Car position: 903 tooth1=2, tooth2=2 450979732: RAISE SSIT PLUG: Load Plug II complete. 450979732: Raise SSIT plug: Normal completion 450979732: sys.marker: id=73, txt=END 450979732: DONE SS_ega_gc_tls 450979735: sys.marker: id=94000, txt=SAFE BEGIN 450979735: safe.bas Revision: 121 450979735: qms: acquisition stopped 450979735: qms.telem mode = 1 450979735: parallel port is: 40 450979735: parallel port was: 40 now: 40 450979735: HVM Off 450979735: sys.aux2: off 450979735: Trap htr#58 off 450979735: TLS Hi htr#38 off 450979735: T19_H17_QMS_Hs htr#17 off 450979735: T38_H53_Inlet htr#53 off 450979735: T53_H50_P48_MN htr#50 off 450979735: T57_H51_MN4 htr#51 off 450979735: T34_H29_P32 htr#29 off 450979735: T59_H57_MN5 htr#57 off 450979735: WRP1 Heat htr#16 off 450979735: WRP2 Heat htr#22 off 450979735: T25_H23_Sewer htr#23 off 450979735: T31_H27_MN15 htr#27 off 450979735: T54_H40_MN6 htr#40 off 450979735: T61_H56_MN7 htr#56 off 450979735: pwm1 heater off 450979735: pwm2 heater off 450979735: sys.aux1: off 450979735: SSIT shaker off 450979735: valve 35 (vsw 40) closed 450979736: valve 36 (vsw 41) closed 450979737: valve 11 (vsw 37) closed 450979738: valve 12 (vsw 38) closed 450979739: valve 14 (vsw 10) closed 450979740: valve 15 (vsw 11) closed 450979741: valve 16 (vsw 12) closed 450979742: valve 17 (vsw 13) closed 450979743: valve 18 (vsw 14) closed 450979744: valve 19 (vsw 15) closed 450979745: dumping mot buffers 450979747: Got buffered data 450979748: Got buffered data 450979750: Got buffered data 450979751: Got buffered data 450979751: sys.marker: id=94001, txt=HCV1 CLOSE 450979751: Closing HCV1... 450979751: Closing HCV1... 450979752: HCV1 Hall Counts = -4 450979752: HCV1 Closed 450979753: valve 1 (vsw 32) closed 450979754: sys.marker: id=94002, txt=HCV2 CLOSE/WRP2 BRAKE 450979754: Closing HCV2... 450979754: Closing HCV2... 450979755: HCV2 Hall Counts = -28 450979755: HCV2 Closed 450979755: valve 4 (vsw 33) closed 450979756: sys.marker: id=94003, txt=CLOSE VALVES 450979756: valve 34 (vsw 43) closed 450979757: valve 44 (vsw 1) closed 450979758: valve 33 (vsw 5) closed 450979759: valve 31 (vsw 0) closed 450979760: valve 5 (vsw 34) closed 450979761: valve 7 (vsw 44) closed 450979762: valve 10 (vsw 47) closed 450979763: valve 28 (vsw 35) closed 450979764: valve 29 (vsw 2) closed 450979766: valve 30 (vsw 3) closed 450979767: valve 32 (vsw 4) closed 450979768: valve 37 (vsw 24) closed 450979769: valve 39 (vsw 26) closed 450979770: valve 38 (vsw 25) closed 450979771: valve 40 (vsw 27) closed 450979772: valve 42 (vsw 29) closed 450979773: valve 41 (vsw 28) closed 450979774: valve 43 (vsw 30) closed 450979775: valve 46 (vsw 49) closed 450979776: valve 47 (vsw 50) closed 450979777: valve 48 (vsw 51) closed 450979778: valve 49 (vsw 52) closed 450979779: valve 45 (vsw 48) closed 450979780: valve 22 (vsw 18) closed 450979781: valve 13 (vsw 9) closed 450979782: valve 23 (vsw 19) closed 450979783: valve 24 (vsw 20) closed 450979784: valve 50 (vsw 8) closed 450979785: valve 25 (vsw 21) closed 450979786: valve 26 (vsw 22) closed 450979787: valve 51 (vsw 6) closed 450979788: valve 27 (vsw 23) closed 450979789: valve 52 (vsw 7) closed 450979790: valve 20 (vsw 16) closed 450979792: valve 21 (vsw 17) closed 450979793: valve 9 (vsw 46) closed 450979794: valve 8 (vsw 45) closed 450979795: valve 6 (vsw 39) closed 450979796: valve 3 (vsw 42) closed 450979797: valve 2 (vsw 36) open 450979798: sys.marker: id=94004, txt=SMS SAFE 450979798: SMS Home Complete 450979798: qms: acquisition stopped 450979798: GC TEC 1 htr#2 off 450979798: T08_H03_TCD_2 htr#3 off 450979798: GC TEC 2 htr#4 off 450979798: T09_H05_TCD_3 htr#5 off 450979798: GC TEC 3 htr#6 off 450979798: T10_H07_TCD_4 htr#7 off 450979798: T11_H08_TCD_5 htr#8 off 450979798: T12_H09_TCD_6 htr#9 off 450979798: T13_H10_IT_1 htr#10 off 450979798: T14_H11_IT_2 htr#11 off 450979798: T15_H12_IT_3 htr#12 off 450979798: T51_H13_P19/20 htr#13 off 450979798: T17_H14_P22 htr#14 off 450979798: T18_H15_P23 htr#15 off 450979798: WRP1 Heat htr#16 off 450979798: T19_H17_QMS_Hs htr#17 off 450979798: T22_H18_MN10 htr#18 off 450979798: T23_H19_MN11 htr#19 off 450979798: T28_H20_P52/28 htr#20 off 450979798: T07_H21_P27 htr#21 off 450979798: WRP2 Heat htr#22 off 450979798: T25_H23_Sewer htr#23 off 450979798: TLSHeatPipeKick htr#24 off 450979798: T29_H25_P30 htr#25 off 450979798: T36_H26_P34 htr#26 off 450979798: T31_H27_MN15 htr#27 off 450979798: T33_H28_P31 htr#28 off 450979799: T34_H29_P32 htr#29 off 450979799: T35_H30_P33 htr#30 off 450979799: T27_H31_P1/2/3 htr#31 off 450979799: T26_H32_P4/5/6 htr#32 off 450979799: T32_H33_P13_Cp htr#33 off 450979799: T39_H34_P14_Cp htr#34 off 450979799: T24_H35_P16_Cp htr#35 off 450979799: T30_H36_P17_Cp htr#36 off 450979799: TLS Lo htr#37 off 450979799: TLS Hi htr#38 off 450979799: T37_H39_TLS_Vt htr#39 off 450979799: T54_H40_MN6 htr#40 off 450979799: T42_H41_SSIT_L htr#41 off 450979799: T43_H42_P21 htr#42 off 450979799: T44_H43_P36 htr#43 off 450979799: T45_H44_P40_MN htr#44 off 450979799: T46_H45_Inlt_1 htr#45 off 450979799: T49_H46_MN2 htr#46 off 450979799: T48_H47_P41 htr#47 off 450979799: T52_H48_P46/47 htr#48 off 450979799: T66_H49_P15_Cp htr#49 off 450979799: T53_H50_P48_MN htr#50 off 450979799: T57_H51_MN4 htr#51 off 450979799: T55_H52_H2O htr#52 off 450979799: T38_H53_Inlet htr#53 off 450979799: T50_H54_CO2 htr#54 off 450979799: T58_H55_P50 htr#55 off 450979799: T61_H56_MN7 htr#56 off 450979799: T59_H57_MN5 htr#57 off 450979799: Trap htr#58 off 450979799: T63_H59_P51 htr#59 off 450979799: T67_H60_P18_Cp htr#60 off 450979799: qms.telem mode = 0 450979799: sys.marker: id=94005, txt=SAFE DONE 450979799: SAFE Script Finished 450981237: hss_task: no op 450981289: hss_task: no op 450981340: hss_task: no op 450981391: hss_task: no op 450981424: sending 32984 bytes 450981425: sending 33421 bytes 450981426: sending 33924 bytes 450981426: sending 34022 bytes 450981427: sending 33924 bytes 450981427: sending 33593 bytes 450981428: sending 33924 bytes 450981428: sending 33348 bytes 450981429: sending 33924 bytes 450981429: sending 33593 bytes 450981430: sending 34022 bytes 450981431: sending 33924 bytes 450981431: sending 33593 bytes 450981432: sending 33265 bytes 450981432: sending 33826 bytes 450981433: sending 32803 bytes 450981433: sending 33993 bytes 450981434: sending 33924 bytes 450981435: sending 33924 bytes 450981435: sending 33691 bytes 450981436: sending 33924 bytes 450981436: sending 33221 bytes 450981437: sending 33282 bytes 450981437: sending 33129 bytes 450981438: sending 33593 bytes 450981438: sending 33342 bytes 450981439: sending 32922 bytes 450981440: sending 33421 bytes 450981440: sending 32803 bytes 450981441: sending 33222 bytes 450981441: sending 33854 bytes 450981442: sending 32803 bytes 450981442: sending 33495 bytes 450981443: sending 32877 bytes 450981444: sending 33924 bytes 450981444: sending 33691 bytes 450981445: sending 33924 bytes 450981445: sending 33924 bytes 450981446: sending 34022 bytes 450981446: sending 34382 bytes 450981447: sending 35319 bytes 450981448: sending 33139 bytes 450981448: sending 34309 bytes 450981449: sending 35970 bytes 450981449: sending 36744 bytes 450981450: sending 32973 bytes 450981450: sending 36842 bytes 450981451: sending 35752 bytes 450981452: sending 32973 bytes 450981452: sending 36744 bytes 450981453: sending 33071 bytes 450981453: sending 36842 bytes 450981454: sending 32973 bytes 450981454: sending 36744 bytes 450981455: sending 36447 bytes 450981456: sending 34397 bytes 450981456: sending 33753 bytes 450981457: sending 35344 bytes 450981457: sending 33713 bytes 450981458: sending 34922 bytes 450981458: sending 32973 bytes 450981459: sending 36842 bytes 450981460: sending 32973 bytes 450981460: sending 35850 bytes 450981461: sending 36842 bytes 450981461: sending 32875 bytes 450981462: sending 35933 bytes 450981463: sending 34729 bytes 450981463: sending 33028 bytes 450981464: sending 35098 bytes 450981464: sending 34226 bytes 450981465: sending 36637 bytes 450981465: sending 33056 bytes 450981466: sending 33234 bytes 450981467: sending 33266 bytes 450981467: sending 33057 bytes 450981468: sending 34465 bytes 450981468: sending 35472 bytes 450981469: sending 33764 bytes 450981469: sending 33495 bytes 450981470: sending 35317 bytes 450981471: sending 37075 bytes 450981471: sending 36842 bytes 450981472: sending 32875 bytes 450981472: sending 32823 bytes 450981473: sending 32973 bytes 450981473: sending 36744 bytes 450981474: sending 32973 bytes 450981475: sending 36842 bytes 450981475: sending 32973 bytes 450981476: sending 33056 bytes 450981476: sending 36842 bytes 450981477: sending 32973 bytes 450981477: sending 36744 bytes 450981478: sending 32973 bytes 450981479: sending 36842 bytes 450981479: sending 32973 bytes 450981480: sending 37173 bytes 450981480: sending 36744 bytes 450981481: sending 32973 bytes 450981482: sending 36744 bytes 450981482: sending 33071 bytes 450981483: sending 36744 bytes 450981483: sending 32973 bytes 450981484: sending 36925 bytes 450981484: sending 32792 bytes 450981485: sending 33154 bytes 450981486: sending 36842 bytes 450981486: sending 32973 bytes 450981487: sending 36744 bytes 450981487: sending 32973 bytes 450981488: sending 36744 bytes 450981489: sending 33071 bytes 450981489: sending 32808 bytes 450981490: sending 32973 bytes 450981490: sending 32973 bytes 450981491: sending 36842 bytes 450981491: sending 32973 bytes 450981492: sending 36744 bytes 450981492: sending 32973 bytes 450981493: sending 36842 bytes 450981494: sending 32973 bytes 450981494: sending 33056 bytes 450981495: sending 36744 bytes 450981495: sending 32973 bytes 450981496: sending 36842 bytes 450981497: sending 32973 bytes 450981497: sending 36842 bytes 450981498: sending 32973 bytes 450981498: sending 36827 bytes 450981499: sending 32890 bytes 450981499: sending 33056 bytes 450981500: sending 36842 bytes 450981501: sending 32973 bytes 450981501: sending 33877 bytes 450981502: sending 35125 bytes 450981502: sending 36842 bytes 450981503: sending 32973 bytes 450981503: sending 36827 bytes 450981504: sending 32973 bytes 450981505: sending 32973 bytes 450981505: sending 36842 bytes 450981506: sending 32973 bytes 450981506: sending 36842 bytes 450981507: sending 32973 bytes 450981507: sending 36744 bytes 450981508: sending 33056 bytes 450981509: sending 32973 bytes 450981509: sending 36744 bytes 450981510: sending 33071 bytes 450981510: sending 36842 bytes 450981511: sending 32973 bytes 450981511: sending 32781 bytes 450981512: sending 32973 bytes 450981513: sending 36744 bytes 450981513: sending 33056 bytes 450981514: sending 32973 bytes 450981514: sending 36842 bytes 450981515: sending 32973 bytes 450981516: sending 36574 bytes 450981516: sending 32973 bytes 450981517: sending 36744 bytes 450981517: sending 33071 bytes 450981518: sending 37075 bytes 450981518: sending 36024 bytes 450981519: sending 32973 bytes 450981520: sending 36744 bytes 450981520: sending 32973 bytes 450981521: sending 36842 bytes 450981521: sending 34447 bytes 450981522: sending 36744 bytes 450981523: sending 33154 bytes 450981523: sending 32973 bytes 450981524: sending 36842 bytes 450981524: sending 32973 bytes 450981525: sending 36744 bytes 450981525: sending 32973 bytes 450981526: sending 36842 bytes 450981527: sending 32973 bytes 450981527: sending 32808 bytes 450981528: sending 32792 bytes 450981528: sending 33154 bytes 450981529: sending 36744 bytes 450981529: sending 32973 bytes 450981530: sending 36842 bytes 450981530: sending 32973 bytes 450981531: sending 36842 bytes 450981532: sending 32973 bytes 450981532: sending 32958 bytes 450981533: sending 32823 bytes 450981533: sending 32973 bytes 450981534: sending 36744 bytes 450981535: sending 32973 bytes 450981535: sending 36842 bytes 450981536: sending 32875 bytes 450981536: sending 32823 bytes 450981537: sending 32973 bytes 450981537: sending 37173 bytes 450981538: sending 36744 bytes 450981539: sending 32973 bytes 450981539: sending 36744 bytes 450981540: sending 33071 bytes 450981540: sending 36744 bytes 450981541: sending 32973 bytes 450981542: sending 36925 bytes 450981542: sending 32890 bytes 450981543: sending 33056 bytes 450981543: sending 36842 bytes 450981544: sending 32973 bytes 450981544: sending 36744 bytes 450981545: sending 32973 bytes 450981545: sending 35236 bytes 450981546: sending 34305 bytes 450981547: sending 34128 bytes 450981547: sending 33774 bytes 450981548: sending 33841 bytes 450981548: sending 33219 bytes 450981549: sending 33139 bytes 450981549: sending 35399 bytes 450981550: sending 34708 bytes 450981551: sending 32913 bytes 450981551: sending 34043 bytes 450981552: sending 34309 bytes 450981552: sending 33613 bytes 450981553: sending 34226 bytes 450981553: sending 34309 bytes 450981554: sending 34226 bytes 450981555: sending 34074 bytes 450981555: sending 34309 bytes 450981556: sending 34324 bytes 450981556: sending 34309 bytes 450981557: sending 33978 bytes 450981557: sending 34211 bytes 450981558: sending 34226 bytes 450981559: sending 35066 bytes 450981559: sending 33978 bytes 450981560: sending 34309 bytes 450981560: sending 34226 bytes 450981561: sending 33963 bytes 450981561: sending 34226 bytes 450981562: sending 34309 bytes 450981563: sending 34226 bytes 450981563: sending 33978 bytes 450981564: sending 34211 bytes 450981564: sending 34324 bytes 450981565: sending 34309 bytes 450981565: sending 33978 bytes 450981566: sending 34309 bytes 450981566: sending 34128 bytes 450981567: sending 34309 bytes 450981568: sending 35470 bytes 450981568: sending 34309 bytes 450981569: sending 34128 bytes 450981569: sending 34309 bytes 450981570: sending 34076 bytes 450981571: sending 34309 bytes 450981571: sending 34226 bytes 450981572: sending 33880 bytes 450981572: sending 34309 bytes 450981573: sending 34226 bytes 450981573: sending 34309 bytes 450981574: sending 33978 bytes 450981574: sending 34309 bytes 450981575: sending 34226 bytes 450981576: sending 34309 bytes 450981576: sending 33880 bytes 450981577: sending 34309 bytes 450981577: sending 34226 bytes 450981578: sending 33978 bytes 450981578: sending 34309 bytes 450981579: sending 34309 bytes 450981580: sending 34226 bytes 450981580: sending 33978 bytes 450981581: sending 34211 bytes 450981581: sending 34226 bytes 450981582: sending 34309 bytes 450981582: sending 33978 bytes 450981583: sending 34309 bytes 450981583: sending 32839 bytes 450981584: sending 33924 bytes 450981585: sending 33217 bytes 450981585: sending 33841 bytes 450981586: sending 33451 bytes 450981586: sending 33924 bytes 450981587: sending 33189 bytes 450981587: sending 34022 bytes 450981588: sending 33503 bytes 450981589: sending 32937 bytes 450981589: sending 33116 bytes 450981590: sending 32868 bytes 450981590: sending 34022 bytes 450981591: sending 33495 bytes 450981592: sending 34022 bytes 450981594: sending 33924 bytes 450981595: sending 33924 bytes 450981596: sending 33186 bytes 450981597: sending 33826 bytes 450981598: sending 32831 bytes 450981599: sending 33007 bytes 450981601: sending 34022 bytes 450981602: sending 33453 bytes 450981603: sending 33593 bytes 450981604: sending 32829 bytes 450981605: sending 32901 bytes 450981606: sending 33593 bytes 450981608: sending 33826 bytes 450981609: sending 33969 bytes 450981610: sending 33118 bytes 450981611: sending 34022 bytes 450981612: sending 33924 bytes 450981613: sending 33465 bytes 450981615: sending 33915 bytes 450981616: sending 33924 bytes 450981617: sending 33924 bytes 450981617: sending 33677 bytes 450981618: sending 32940 bytes 450981619: sending 34383 bytes 450981620: sending 33756 bytes 450981621: sending 35561 bytes 450981622: sending 34742 bytes 450981623: sending 4170 bytes 450981623: sending 0 bytes 450981623: sending 0 bytes 450981623: hss_task: no op 450981624: hss_task: no op 450981626: hss_task: no op 450981627: hss_task: no op 450981641: hss_task: no op 450981644: sending 0 bytes 450981644: sending 0 bytes