@15:01:39.55EDT24-Aug-18 <MAIN> >BREAK< ESP3 Gateway v0.99 for core bus
@15:01:39.57 >BREAK< ESP3 Gateway v0.99 for cartridge bus
@15:01:40.82 
Configuration for honu by brent@mbari.org
/home/esp/esp2/type/auv/honu/configure.rb
@15:01:42.00 Polling Can every 5:00
@15:01:42.31 Clients may connect on TCP port 9999
Connecting to 10.89.5.2:9999
@15:01:42.35 Waiting for espclients...
@15:01:42.59 <LRAUV> Session Begun
@15:01:44.95 -> showStatus
@15:01:46.55 -> Cmd.loadCartridge
@15:01:46.67 Gate.power :main,:ON,limit to 5000mA
@15:01:46.68 Gate.power :analytic1,:ON,limit to 5000mA
@15:01:46.70 Gate.power :analytic2,:ON,limit to 5000mA
@15:01:46.73 Gate.power :analytic3,:ON,limit to 5000mA
@15:01:46.87 Powering core bus
@15:01:49.16 <Probe-AMspr> SPR Module 1, FW Rev. B, FPGA Rev. C
@15:01:49.28 <LRAUV> ArS.configure ArSconfig
@15:01:49.38 LyS1.configure LyS1config
@15:01:49.50 LyS2.configure LyS2config
@15:01:49.60 AirS.configure AirSconfig
@15:01:49.72 TV.configure TVconfig
@15:01:49.84 SP.configure SPconfig
@15:01:49.97 SC.configure SCconfig
@15:01:50.09 PV.configure PVconfig
@15:01:50.21 PinPort.configure PPconfig
@15:01:50.33 Sea.configure SPconfig
@15:01:50.39 All elf controllers running firmware version 4.5
@15:01:50.40 Gate.power :motor,:ON,limit to 5000mA
@15:01:50.56 <ArS_home> ArS.reconfigure ArSconfig
@15:01:50.85 ArS.home.jog 0
@15:01:50.98 <PV_home> PV.reconfigure PVconfig
@15:01:51.06 <TV_home> TV.reconfigure TVconfig
@15:01:51.09 <LyS2_home> LyS2.reconfigure LyS2config
@15:01:51.13 <PinPort_home> PinPort.reconfigure PPconfig
@15:01:51.17 <LyS1_home> LyS1.reconfigure LyS1config
@15:01:51.21 <AirS_home> AirS.reconfigure AirSconfig
@15:01:51.41 <TV_home> TV.home.jog 0
@15:01:51.46 <PV_home> PV.home.jog 0
@15:01:51.48 <LyS2_home> LyS2.home.jog 0
@15:01:51.51 <PinPort_home> PinPort.home.jog 0
@15:01:51.53 <AirS_home> AirS.home.jog 0
@15:01:51.56 <LyS1_home> LyS1.home.jog 0
@15:01:52.08 <ArS_home> ArS.reconfigure HomeMagSyringe
@15:01:52.30 <PV_home> PV.reconfigure HomePV
@15:01:52.34 <TV_home> TV.reconfigure HomeTV
@15:01:52.37 <LyS1_home> LyS1.reconfigure HomeSyringe
@15:01:52.40 <PinPort_home> PinPort.reconfigure HomePP
@15:01:52.43 <AirS_home> AirS.reconfigure HomeMagSyringe
@15:01:52.47 <LyS2_home> LyS2.reconfigure HomeSyringe
@15:01:52.51 <ArS_home> ArS.jog -255
@15:01:52.75 <TV_home> TV.jog -556
@15:01:52.77 <PV_home> PV.jog -1475
@15:01:52.81 <AirS_home> AirS.jog -317
@15:01:52.84 <LyS1_home> LyS1.jog -264
@15:01:52.87 <PinPort_home> PinPort.jog -110
@15:01:52.91 <LyS2_home> LyS2.jog -269
@15:01:53.22 <ArS_home> ArS.setRawPosition! -50
@15:01:53.27 ArS.seek :home
@15:01:53.37 <PinPort_home> PinPort.setRawPosition! 0
@15:01:53.42 PinPort.seek :home
@15:01:53.51 PinPort.reconfigure PPconfig
@15:01:53.87 <AirS_home> AirS.setRawPosition! -50
@15:01:53.88 <LyS2_home> LyS2.setRawPosition! -50
@15:01:53.91 <LyS1_home> LyS1.setRawPosition! -50
@15:01:53.93 <ArS_home> ArS.reconfigure ArSconfig
@15:01:54.05 <AirS_home> AirS.seek :home
@15:01:54.11 <LyS2_home> LyS2.seek :home
@15:01:54.15 <LyS1_home> LyS1.seek :home
@15:01:54.35 <PV_home> PV.setRawPosition! -50
@15:01:54.40 PV.seek :home
@15:01:54.50 <AirS_home> AirS.reconfigure AirSconfig
@15:01:54.60 <LyS2_home> LyS2.reconfigure LyS2config
@15:01:54.63 <LyS1_home> LyS1.reconfigure LyS1config
@15:01:54.76 <PV_home> PV.reconfigure PVconfig
@15:01:54.85 <TV_home> TV.setRawPosition! 0
@15:01:54.90 TV.seek :home
@15:01:54.99 TV.reconfigure TVconfig
@15:01:55.20 <LRAUV> TV.seek :clear
@15:01:56.82 TV.coast
@15:01:56.87 SC.reconfigure HomeSC
@15:01:56.94 SC.home.jog 0
@15:01:57.69 SC.reconfigure SCconfig
@15:01:57.75 SC.seek 51
@15:01:57.83 Selecting Cartridge 50
@15:01:58.14 SC.seek 50
@15:01:58.64 <LyS2> LyS2.seek :locked
@15:01:58.77 <PV> PV.seek :locked
@15:01:58.90 <AirS> AirS.seek :locked
@15:02:02.98 <LRAUV> Powering cartridge bus
@15:02:05.10 Gate.setIR 1750,5000,0,6
@15:02:05.23 Gate.setIR 0,5000,0,6
@15:02:05.27 Loaded Archive Cartridge
Gate.power :cartridge,:OFF
@15:02:24.89 -> Cmd.startFiltering
@15:02:25.11 <FILTERING> Duration of filtering limited to 1:05:00
@15:02:25.36 Priming sample loop w/100ml, bypass w/10ml
@15:02:25.43 SP.setPosition! 0ml
@15:02:25.48 <openIntake> Intake.open
@15:02:25.50 <FILTERING> Exhaust.open
@15:02:26.33 Sea @-42.9psia
@15:02:26.34 Waiting 4 - 300s for filter pressure to stabilize +/-0.5psi
@15:02:31.87 Vacuum tare is 24% of full scale
@15:02:31.89 <openPB> PB.open
@15:02:32.19 <FILTERING> Exhaust.close
@15:02:32.97 Sea @-42.9psia
@15:02:33.05 SP.reconfigure SPprime
@15:02:33.12 SP.seek 10ml,1:21
@15:02:43.97 SP.setPosition! 0ml
@15:02:44.01 <closePB> PB.close
@15:02:44.04 <FILTERING> Exhaust.open
@15:02:44.87 Sea @-42.9psia
@15:02:44.95 SP.reconfigure SPprime
@15:02:45.02 SP.seek 100ml,8:51
@15:04:39.89 Intake.close
@15:04:40.62 Pressurizing cartridge to 26psi (try #1 of 3)
@15:04:40.63 SP.setPosition! 0ml
@15:04:40.69 PB.open
@15:04:41.48 TV.seek :crack
@15:04:42.28 TV.seek :clear
@15:04:43.08 Intake.open
@15:04:44.53 PB.close
@15:04:45.29 Exhaust.close
@15:04:46.05 Sea @-42.9psia
@15:04:46.13 SP.reconfigure SPcharge
@15:04:46.20 SP.seek 2.3ml,42 seconds
@15:04:53.09 Cartridge pressurized with 0.220ml to 26.2psi
@15:04:53.32 delay 3 seconds
@15:04:56.39 Cartridge at 19.7psi 3 seconds later
@15:04:56.47 TV.seek :cartridge
@15:04:58.29 TV.seek :clear
@15:05:00.11 Sampling 1000.0ml
@15:05:00.12 SP.setPosition! 0ml
@15:05:00.17 Exhaust.open
@15:05:00.90 Sea @-42.9psia
@15:05:00.99 SP.reconfigure SPsample
@15:05:01.06 SP.seek 1000ml,1:23:53
@15:05:02.01 <sampling> Cartridge 50 sampling 0/1000ml at 0.17ml/s with 6.8psi vacuum
@15:06:02.02 Cartridge 50 sampling 23/1000ml at 0.34ml/s with 23.0psi vacuum
@15:07:02.01 Cartridge 50 sampling 43/1000ml at 0.30ml/s with 26.2psi vacuum
@15:08:02.02 Cartridge 50 sampling 62/1000ml at 0.28ml/s with 25.7psi vacuum
@15:09:02.02 Cartridge 50 sampling 78/1000ml at 0.24ml/s with 19.9psi vacuum
@15:10:02.02 Cartridge 50 sampling 93/1000ml at 0.21ml/s with 20.5psi vacuum
@15:11:02.02 Cartridge 50 sampling 107/1000ml at 0.20ml/s with 23.7psi vacuum
@15:12:02.01 Cartridge 50 sampling 119/1000ml at 0.20ml/s with 26.4psi vacuum
@15:12:54.25 <FILTERING> Flow averaged 0.28ml/s over 7:52
@15:12:54.27 Waiting up to 16 seconds for vacuum to reduce from 29.3 to 18.0psi
@15:12:54.90 Relieved excess vacuum in 2.7 seconds
@15:12:54.92 SP.seek 1000ml,1:13:04
@15:13:02.02 <sampling> Cartridge 50 sampling 131/1000ml at 0.20ml/s with 23.9psi vacuum
@15:13:05.05 <FILTERING> Flow estimate reduced to 0.22ml/s
@15:13:05.08 Waiting up to 11 seconds for vacuum to reduce from 27.1 to 18.0psi
@15:13:05.70 Relieved excess vacuum in 3.6 seconds
@15:13:05.72 SP.seek 1000ml,1:12:54
@15:13:18.92 Flow averaged 0.20ml/s over 14 seconds
@15:13:18.93 <closeIntake> Intake.close
@15:13:18.99 <closeExhaust> Exhaust.close
@15:13:19.74 Cartridge::Sampler::Clogged in FILTERING -- Cartridge clogged
@15:13:19.84 <FILTERING> Sampled  134.2ml
@15:13:19.92 TV.seek :bypass
@15:13:21.78 TV.seek :clear
@15:13:23.92 <LRAUV> -> Cmd.startProcessing
@15:13:24.18 <PROCESSING> PV.seek :reagent
@15:13:25.03 Sample loop closed. Ready to Deliver Reagents
@15:13:25.04 ArS.seek :sealed
@15:13:29.32 ArS.seek :evac
@15:13:43.27 delay 20 seconds
@15:14:03.31 ArS.seek :clear
@15:14:21.03 RNAlater soak for 10:00
@15:24:21.06 ArS.seek :tVent
@15:24:23.63 delay 1 second
@15:24:24.66 ArS.seek :evac
@15:24:40.28 delay 10 seconds
@15:24:50.31 Sample preserved and evacuated
@15:24:51.23 <LRAUV> -> Cmd.stop
@15:24:51.37 PV.seek :locked
@15:24:52.26 PinPort.seek :clear
@15:24:52.40 <ArS> ArS.seek :clear
@15:24:52.59 <LyS2> LyS2.seek :clear
@15:24:52.73 <AirS> AirS.seek :clear
@15:25:10.16 <LRAUV> ArS.coast
@15:25:10.20 LyS1.coast
@15:25:10.25 LyS2.coast
@15:25:10.30 AirS.coast
@15:25:10.35 TV.coast
@15:25:10.41 SP.coast
@15:25:10.46 SC.coast
@15:25:10.51 PV.coast
@15:25:10.56 PinPort.coast
@15:25:10.73 Gate.power :motor,:OFF
@15:25:10.75 Gate.power :main,:OFF
@15:25:10.77 Gate.power :core,:OFF
@15:25:10.79 Gate.power :analytic1,:OFF
@15:25:10.81 Gate.power :analytic2,:OFF
@15:25:10.83 Gate.power :analytic3,:OFF
@15:25:10.85 Safely stopped and ready to power off