@03:29:13.24PDT06-Aug-18 <MAIN> >BREAK< ESP3 Gateway v0.99 for core bus
@03:29:13.26 >BREAK< ESP3 Gateway v0.99 for cartridge bus
@03:29:14.50 
Configuration for honu by brent@mbari.org
/home/esp/esp2/type/auv/honu/configure.rb
@03:29:15.71 Polling Can every 5:00
@03:29:16.01 Clients may connect on TCP port 9999
@03:29:16.02 Connecting to 10.89.5.2:9999
@03:29:16.06 Waiting for espclients...
@03:29:16.13 <LRAUV> Session Begun
@03:29:18.07 -> showStatus
@03:29:20.06 -> Cmd.loadCartridge
@03:29:20.19 Gate.power :main,:ON,limit to 5000mA
@03:29:20.20 Gate.power :analytic1,:ON,limit to 5000mA
@03:29:20.22 Gate.power :analytic2,:ON,limit to 5000mA
@03:29:20.24 Gate.power :analytic3,:ON,limit to 5000mA
@03:29:20.39 Powering core bus
@03:29:22.69 <Probe-AMspr> SPR Module 1, FW Rev. B, FPGA Rev. C
@03:29:22.79 <LRAUV> ArS.configure ArSconfig
@03:29:22.89 LyS1.configure LyS1config
@03:29:23.01 LyS2.configure LyS2config
@03:29:23.12 AirS.configure AirSconfig
@03:29:23.24 TV.configure TVconfig
@03:29:23.36 SP.configure SPconfig
@03:29:23.47 SC.configure SCconfig
@03:29:23.60 PV.configure PVconfig
@03:29:23.72 PinPort.configure PPconfig
@03:29:23.83 Sea.configure SPconfig
@03:29:23.89 All elf controllers running firmware version 4.46
@03:29:23.91 Gate.power :motor,:ON,limit to 5000mA
@03:29:24.06 <ArS_home> ArS.reconfigure ArSconfig
@03:29:24.29 ArS.home.jog 0
@03:29:24.50 <PV_home> PV.reconfigure PVconfig
@03:29:24.56 <TV_home> TV.reconfigure TVconfig
@03:29:24.60 <LyS2_home> LyS2.reconfigure LyS2config
@03:29:24.66 <AirS_home> AirS.reconfigure AirSconfig
@03:29:24.70 <PinPort_home> PinPort.reconfigure PPconfig
@03:29:24.78 <LyS1_home> LyS1.reconfigure LyS1config
@03:29:24.87 <PV_home> PV.home.jog 0
@03:29:24.94 <LyS2_home> LyS2.home.jog 0
@03:29:25.02 <PinPort_home> PinPort.home.jog 0
@03:29:25.05 <AirS_home> AirS.home.jog 0
@03:29:25.08 <TV_home> TV.home.jog 0
@03:29:25.12 <LyS1_home> LyS1.home.jog 0
@03:29:25.54 <ArS_home> ArS.reconfigure HomeMagSyringe
@03:29:25.75 <AirS_home> AirS.reconfigure HomeMagSyringe
@03:29:25.78 <LyS2_home> LyS2.reconfigure HomeSyringe
@03:29:25.82 <ArS_home> ArS.jog -253
@03:29:25.85 <PinPort_home> PinPort.reconfigure HomePP
@03:29:25.88 <PV_home> PV.reconfigure HomePV
@03:29:25.92 <TV_home> TV.reconfigure HomeTV
@03:29:25.97 <LyS1_home> LyS1.reconfigure HomeSyringe
@03:29:26.14 <AirS_home> AirS.jog -339
@03:29:26.21 <PinPort_home> PinPort.jog -108
@03:29:26.25 <LyS2_home> LyS2.jog -275
@03:29:26.28 <PV_home> PV.jog -1501
@03:29:26.31 <TV_home> TV.jog -540
@03:29:26.35 <LyS1_home> LyS1.jog -283
@03:29:26.61 <ArS_home> ArS.setRawPosition! -50
@03:29:26.66 ArS.seek :home
@03:29:26.74 <PinPort_home> PinPort.setRawPosition! 0
@03:29:26.79 PinPort.seek :home
@03:29:27.22 <AirS_home> AirS.setRawPosition! -50
@03:29:27.25 <LyS2_home> LyS2.setRawPosition! -50
@03:29:27.28 <LyS1_home> LyS1.setRawPosition! -50
@03:29:27.30 <ArS_home> ArS.reconfigure ArSconfig
@03:29:27.33 <PinPort_home> PinPort.reconfigure PPconfig
@03:29:27.49 <AirS_home> AirS.seek :home
@03:29:27.51 <LyS2_home> LyS2.seek :home
@03:29:27.54 <LyS1_home> LyS1.seek :home
@03:29:27.79 <PV_home> PV.setRawPosition! -50
@03:29:27.84 PV.seek :home
@03:29:27.94 <LyS2_home> LyS2.reconfigure LyS2config
@03:29:28.03 <AirS_home> AirS.reconfigure AirSconfig
@03:29:28.06 <LyS1_home> LyS1.reconfigure LyS1config
@03:29:28.20 <PV_home> PV.reconfigure PVconfig
@03:29:28.33 <TV_home> TV.setRawPosition! 0
@03:29:28.38 TV.seek :home
@03:29:28.48 TV.reconfigure TVconfig
@03:29:28.65 <LRAUV> TV.seek :clear
@03:29:30.27 TV.coast
@03:29:30.33 SC.reconfigure HomeSC
@03:29:30.39 SC.home.jog 0
@03:29:31.14 SC.reconfigure SCconfig
@03:29:31.20 SC.seek 37
@03:29:31.29 Selecting Cartridge 36
@03:29:31.61 SC.seek 36
@03:29:32.11 <LyS2> LyS2.seek :locked
@03:29:32.24 <PV> PV.seek :locked
@03:29:32.37 <AirS> AirS.seek :locked
@03:29:36.45 <LRAUV> Powering cartridge bus
@03:29:38.57 Gate.setIR 1750,5000,0,6
@03:29:38.69 Gate.setIR 0,5000,0,6
@03:29:38.74 Loaded Lyse-n-Go Cartridge
@03:29:38.75 PuckHeater.configure HeatConfig
@03:29:38.81 Gate.power :heat,:ON,limit to 5000mA
@03:29:58.82 -> Cmd.startFiltering
@03:29:59.05 <FILTERING> Duration of filtering limited to 1:05:00
@03:29:59.29 Priming sample loop w/100ml, bypass w/10ml
@03:29:59.37 SP.setPosition! 0ml
@03:29:59.42 <openIntake> Intake.open
@03:29:59.44 <FILTERING> Exhaust.open
@03:30:00.28 Sea @-42.9psia
@03:30:00.30 Waiting 4 - 300s for filter pressure to stabilize +/-0.5psi
@03:30:06.07 Vacuum tare is 23% of full scale
@03:30:06.08 <openPB> PB.open
@03:30:06.13 <FILTERING> Exhaust.close
@03:30:06.91 Sea @-42.9psia
@03:30:06.99 SP.reconfigure SPprime
@03:30:07.06 SP.seek 10ml,1:21
@03:30:17.94 SP.setPosition! 0ml
@03:30:17.99 <closePB> PB.close
@03:30:18.01 <FILTERING> Exhaust.open
@03:30:18.79 Sea @-42.9psia
@03:30:18.87 SP.reconfigure SPprime
@03:30:18.94 SP.seek 100ml,8:51
@03:32:14.05 Pressurizing cartridge to 26psi
@03:32:14.06 Intake.close
@03:32:14.82 SP.setPosition! 0ml
@03:32:14.86 PB.open
@03:32:15.60 TV.seek :crack
@03:32:16.39 TV.seek :clear
@03:32:17.19 Intake.open
@03:32:18.68 PB.close
@03:32:19.38 Exhaust.close
@03:32:20.12 Sea @-42.9psia
@03:32:20.21 SP.reconfigure SPcharge
@03:32:20.27 SP.seek 7.5ml,1:08
@03:32:24.91 Cartridge pressurized with 0.097ml to 26.4psi
@03:32:25.13 Pressure peaked at 26.8psi
@03:32:25.15 delay 3 seconds
@03:32:28.23 Cartridge at 23.9psi 3 seconds later
@03:32:28.31 TV.seek :cartridge
@03:32:30.12 TV.seek :clear
@03:32:31.94 Sampling 1000.0ml
@03:32:31.96 SP.setPosition! 0ml
@03:32:32.00 Exhaust.open
@03:32:32.73 Sea @-42.9psia
@03:32:32.82 SP.reconfigure SPsample
@03:32:32.89 SP.seek 1000ml,1:23:53
@03:32:33.84 <sampling> Cartridge 36 sampling 0/1000ml at 0.17ml/s with 3.7psi vacuum
@03:33:33.85 Cartridge 36 sampling 31/1000ml at 0.51ml/s with 27.8psi vacuum
@03:34:33.85 Cartridge 36 sampling 62/1000ml at 0.54ml/s with 24.5psi vacuum
@03:35:33.85 Cartridge 36 sampling 93/1000ml at 0.52ml/s with 17.5psi vacuum
@03:36:33.85 Cartridge 36 sampling 124/1000ml at 0.52ml/s with 25.3psi vacuum
@03:37:33.85 Cartridge 36 sampling 156/1000ml at 0.49ml/s with 21.8psi vacuum
@03:38:33.85 Cartridge 36 sampling 186/1000ml at 0.50ml/s with 16.8psi vacuum
@03:39:33.85 Cartridge 36 sampling 217/1000ml at 0.49ml/s with 21.7psi vacuum
@03:40:33.85 Cartridge 36 sampling 248/1000ml at 0.50ml/s with 28.0psi vacuum
@03:41:33.85 Cartridge 36 sampling 279/1000ml at 0.54ml/s with 25.2psi vacuum
@03:42:33.85 Cartridge 36 sampling 310/1000ml at 0.51ml/s with 17.6psi vacuum
@03:43:33.85 Cartridge 36 sampling 341/1000ml at 0.49ml/s with 28.2psi vacuum
@03:44:33.85 Cartridge 36 sampling 372/1000ml at 0.53ml/s with 22.1psi vacuum
@03:45:33.85 Cartridge 36 sampling 402/1000ml at 0.51ml/s with 25.5psi vacuum
@03:46:33.85 Cartridge 36 sampling 433/1000ml at 0.51ml/s with 17.5psi vacuum
@03:47:33.85 Cartridge 36 sampling 464/1000ml at 0.55ml/s with 24.4psi vacuum
@03:48:33.85 Cartridge 36 sampling 495/1000ml at 0.50ml/s with 27.3psi vacuum
@03:49:33.85 Cartridge 36 sampling 525/1000ml at 0.49ml/s with 19.1psi vacuum
@03:50:33.85 Cartridge 36 sampling 556/1000ml at 0.53ml/s with 22.5psi vacuum
@03:51:33.85 Cartridge 36 sampling 587/1000ml at 0.54ml/s with 25.4psi vacuum
@03:52:33.85 Cartridge 36 sampling 618/1000ml at 0.52ml/s with 25.1psi vacuum
@03:53:33.85 Cartridge 36 sampling 648/1000ml at 0.51ml/s with 24.6psi vacuum
@03:54:33.85 Cartridge 36 sampling 679/1000ml at 0.50ml/s with 27.4psi vacuum
@03:55:33.85 Cartridge 36 sampling 710/1000ml at 0.48ml/s with 27.0psi vacuum
@03:56:33.85 Cartridge 36 sampling 740/1000ml at 0.48ml/s with 23.0psi vacuum
@03:57:33.85 Cartridge 36 sampling 771/1000ml at 0.48ml/s with 23.4psi vacuum
@03:58:33.85 Cartridge 36 sampling 801/1000ml at 0.48ml/s with 21.0psi vacuum
@03:59:33.85 Cartridge 36 sampling 832/1000ml at 0.48ml/s with 26.3psi vacuum
@04:00:33.85 Cartridge 36 sampling 863/1000ml at 0.48ml/s with 26.3psi vacuum
@04:01:33.85 Cartridge 36 sampling 893/1000ml at 0.51ml/s with 26.3psi vacuum
@04:02:33.85 Cartridge 36 sampling 924/1000ml at 0.53ml/s with 25.3psi vacuum
@04:03:33.85 Cartridge 36 sampling 954/1000ml at 0.54ml/s with 21.8psi vacuum
@04:04:33.85 Cartridge 36 sampling 985/1000ml at 0.52ml/s with 18.8psi vacuum
@04:05:07.88 <closeIntake> Intake.close
@04:05:07.91 <closeExhaust> Exhaust.close
@04:05:08.69 <FILTERING> Sampled  1000.0ml
@04:05:08.78 TV.seek :bypass
@04:05:10.39 TV.seek :clear
@04:05:12.80 <LRAUV> -> Cmd.startProcessing
@04:05:14.59 <PROCESSING> SPR.command "read_sequences"
@04:05:15.29 SPR.command "stats_on"
@04:05:15.33 SPR.command "start 2 0"
@04:05:17.34 <SPRlogger> Begun log /var/log/esp/spr18aug0604h.spr
@04:05:18.14 <PROCESSING> Handoff.select :waste
@04:05:18.26 ArS.seek empty
@04:05:36.01 PinPort.seek :cartridge
@04:05:41.73 LyS1.seek 1350ul
@04:05:47.67 PV.seek :reagent
@04:05:48.51 AirS.seek :tVent
@04:05:50.58 delay 2 seconds
@04:05:52.61 AirS.reconfigure EvacAirS
@04:05:52.69 AirS.seek :evac
@04:06:15.01 delay 15 seconds
@04:06:30.04 AirS.reconfigure AirSconfig
@04:06:30.10 AirS.seek :tVent
@04:06:44.33 delay 2 seconds
@04:06:46.36 AirS.reconfigure EvacAirS
@04:06:46.42 AirS.seek :evac
@04:07:08.77 delay 15 seconds
@04:07:23.79 AirS.reconfigure AirSconfig
@04:07:23.85 AirS.seek :tVent
@04:07:38.08 delay 2 seconds
@04:07:40.11 AirS.reconfigure EvacAirS
@04:07:40.16 AirS.seek :evac
@04:08:02.48 delay 15 seconds
@04:08:17.51 AirS.reconfigure AirSconfig
@04:08:17.57 AirS.seek :tVent
@04:08:31.79 delay 2 seconds
@04:08:33.82 AirS.reconfigure EvacAirS
@04:08:33.87 AirS.seek :evac
@04:08:56.19 delay 15 seconds
@04:09:11.22 AirS.reconfigure AirSconfig
@04:09:11.29 AirS.seek :tVent
@04:09:25.51 delay 2 seconds
@04:09:27.54 AirS.reconfigure EvacAirS
@04:09:27.59 AirS.seek :evac
@04:09:49.92 delay 15 seconds
@04:10:04.94 delay 1:30
@04:11:34.96 AirS.reconfigure AirSconfig
@04:11:35.01 AirS.seek :fVent
@04:11:36.47 delay 15 seconds
@04:11:51.50 LyS1.reconfigure SlowLyS1
@04:11:51.59 LyS1.seek 1050ul
@04:12:21.65 delay 5 seconds
@04:12:26.67 Handoff.select :blocked
@04:12:26.83 LyS1.seek 450ul
@04:13:26.91 delay 10 seconds
@04:13:36.93 AirS.reconfigure SlowAirS
@04:13:37.05 AirS.reconfigure to mix into 1.37806 parts LyS1
@04:13:37.40 <AirSmixer> AirS.seek evac
@04:13:37.43 <PROCESSING> LyS1.seek 300ul
@04:13:52.54 AirS.reconfigure AirSconfig
@04:13:52.60 AirS.seek :full
@04:14:06.83 LyS1.seek :empty
@04:14:36.93 PuckHeater.seek 86.6C
@04:16:09.62 PuckHeater.hold 15:00,86.6C
@04:31:11.15 LyS1.reconfigure LyS1config
@04:31:11.21 LyS1.seek 900ul
@04:31:19.55 AirS.seek :tVent
@04:31:19.63 delay 2 seconds
@04:31:21.65 AirS.reconfigure HalfSpeedAirS
@04:31:21.72 AirS.seek :evac
@04:31:49.47 delay 15 seconds
@04:32:04.50 AirS.reconfigure AirSconfig
@04:32:04.56 AirS.seek :tVent
@04:32:18.80 delay 2 seconds
@04:32:20.83 AirS.reconfigure HalfSpeedAirS
@04:32:20.88 AirS.seek :evac
@04:32:48.63 delay 15 seconds
@04:33:03.66 AirS.reconfigure AirSconfig
@04:33:03.71 AirS.seek :tVent
@04:33:17.93 delay 2 seconds
@04:33:19.96 AirS.reconfigure HalfSpeedAirS
@04:33:20.01 AirS.seek :evac
@04:33:47.76 delay 15 seconds
@04:34:02.79 delay 1:00
@04:35:02.80 Handoff.select :waste
@04:35:02.92 delay 15 seconds
@04:35:17.94 AirS.seek :fVent
@04:35:20.13 delay 10 seconds
@04:35:30.16 AirS.reconfigure AirSconfig
@04:35:30.21 AirS.seek :evac
@04:35:31.65 Lysis Recovered in LyS1
@04:35:31.66 Lysis Complete
@04:35:31.68 Handoff.select :waste
@04:35:31.71 LyS2.seek :full
@04:35:31.80 LyS1.reconfigure DAmixLyS1
@04:35:31.86 LyS2.reconfigure DAmixLyS2
@04:35:32.42 <LyS2mixer> LyS2.seek 1480ul
@04:35:32.45 <PROCESSING> LyS1.seek 650ul
@04:36:19.80 delay 5 seconds
@04:36:24.81 Handoff.select :SPR
@04:36:24.94 SPR.command "start 1 14"
@04:36:26.14 Running Experiment-Rep #1
@04:36:26.15 delay 10 seconds
@04:36:36.17 SPR.command "start 1 0"
@04:36:39.51 Waiting up to 4:00 for SPR to enter state 1
@04:38:43.76 SPR.command "hold_on"
@04:38:45.50 <LyS2mixer> LyS2.seek 1130ul
@04:38:45.53 <PROCESSING> LyS1.seek 300ul
@04:39:51.76 delay 15 seconds
@04:40:06.77 SPR.command "hold_off"
@04:40:09.97 Waiting up to 25:00 for SPR to enter state 7
@05:00:14.81 Handoff.select :waste
@05:00:14.94 LyS1.reconfigure LyS1config
@05:00:15.00 LyS2.reconfigure LyS2config
@05:00:15.06 Rep #1 SPR Analysis has Completed
@05:00:15.97 <SPRlogger> Ended log /var/log/esp/spr18aug0604h.spr
@05:00:15.99 <PROCESSING> SPR.command "stats_off"
@05:00:17.77 <LRAUV> -> Cmd.stop
@05:00:17.86 <closeHandoff> Handoff.select :close
@05:00:18.04 <LRAUV> Gate.power :heat,:OFF
@05:00:18.06 Gate.power :cartridge,:OFF
@05:00:18.09 PV.seek :locked
@05:00:19.00 PinPort.seek :clear
@05:00:24.79 <ArS> ArS.seek :clear
@05:00:24.92 <LyS1> LyS1.seek :clear
@05:00:25.05 <LyS2> LyS2.seek :clear
@05:00:25.20 <AirS> AirS.seek :clear
@05:00:42.56 <LRAUV> ArS.coast
@05:00:42.61 LyS1.coast
@05:00:42.66 LyS2.coast
@05:00:42.71 AirS.coast
@05:00:42.76 TV.coast
@05:00:42.81 SP.coast
@05:00:42.86 SC.coast
@05:00:42.91 PV.coast
@05:00:42.96 PinPort.coast
@05:00:43.14 Gate.power :motor,:OFF
@05:00:43.16 Gate.power :main,:OFF
@05:00:43.18 Gate.power :core,:OFF
@05:00:43.20 Gate.power :analytic1,:OFF
@05:00:43.22 Gate.power :analytic2,:OFF
@05:00:43.24 Gate.power :analytic3,:OFF
@05:00:43.26 Safely stopped and ready to power off