@04:12:24.54EDT30-Aug-18
>BREAK< ESP3 Gateway v0.99 for core bus @04:12:24.56 >BREAK< ESP3 Gateway v0.99 for cartridge bus @04:12:25.80 Configuration for honu by brent@mbari.org /home/esp/esp2/type/auv/honu/configure.rb @04:12:27.09 Polling Can every 5:00 @04:12:27.39 Clients may connect on TCP port 9999 @04:12:27.40 Connecting to 10.89.5.2:9999 @04:12:27.43 Waiting for espclients... @04:12:27.84 Session Begun @04:12:29.80 -> showStatus @04:12:31.79 -> Cmd.loadCartridge @04:12:31.92 Gate.power :main,:ON,limit to 5000mA @04:12:31.93 Gate.power :analytic1,:ON,limit to 5000mA @04:12:31.95 Gate.power :analytic2,:ON,limit to 5000mA @04:12:31.98 Gate.power :analytic3,:ON,limit to 5000mA @04:12:32.12 Powering core bus @04:12:34.42 SPR Module 1, FW Rev. B, FPGA Rev. C @04:12:34.52 ArS.configure ArSconfig @04:12:34.62 LyS1.configure LyS1config @04:12:34.74 LyS2.configure LyS2config @04:12:34.84 AirS.configure AirSconfig @04:12:34.96 TV.configure TVconfig @04:12:35.08 SP.configure SPconfig @04:12:35.19 SC.configure SCconfig @04:12:35.31 PV.configure PVconfig @04:12:35.44 PinPort.configure PPconfig @04:12:35.56 Sea.configure SPconfig @04:12:35.61 All elf controllers running firmware version 4.5 @04:12:35.63 Gate.power :motor,:ON,limit to 5000mA @04:12:35.76 ArS.reconfigure ArSconfig @04:12:36.00 ArS.home.jog 0 @04:12:36.19 PV.reconfigure PVconfig @04:12:36.26 TV.reconfigure TVconfig @04:12:36.29 LyS2.reconfigure LyS2config @04:12:36.33 LyS1.reconfigure LyS1config @04:12:36.36 PinPort.reconfigure PPconfig @04:12:36.40 AirS.reconfigure AirSconfig @04:12:36.62 PV.home.jog 0 @04:12:36.67 TV.home.jog 0 @04:12:36.69 LyS1.home.jog 0 @04:12:36.73 PinPort.home.jog 0 @04:12:36.75 AirS.home.jog 0 @04:12:36.78 LyS2.home.jog 0 @04:12:37.23 ArS.reconfigure HomeMagSyringe @04:12:37.40 PV.reconfigure HomePV @04:12:37.44 TV.reconfigure HomeTV @04:12:37.50 ArS.jog -244 @04:12:37.56 LyS1.reconfigure HomeSyringe @04:12:37.58 PinPort.reconfigure HomePP @04:12:37.77 PV.jog -1477 @04:12:37.81 TV.jog -542 @04:12:37.84 LyS1.jog -262 @04:12:37.87 PinPort.jog -111 @04:12:38.07 LyS2.reconfigure HomeSyringe @04:12:38.08 AirS.reconfigure HomeMagSyringe @04:12:38.19 AirS.jog -314 @04:12:38.21 LyS2.jog -260 @04:12:38.33 PinPort.setRawPosition! 0 @04:12:38.34 ArS.setRawPosition! -50 @04:12:38.41 PinPort.seek :home @04:12:38.44 ArS.seek :home @04:12:38.85 AirS.setRawPosition! -50 @04:12:38.88 PinPort.reconfigure PPconfig @04:12:38.90 LyS1.setRawPosition! -50 @04:12:38.95 LyS2.setRawPosition! -50 @04:12:39.05 AirS.seek :home @04:12:39.13 LyS1.seek :home @04:12:39.18 LyS2.seek :home @04:12:39.39 PV.setRawPosition! -50 @04:12:39.40 ArS.reconfigure ArSconfig @04:12:39.48 PV.seek :home @04:12:39.63 LyS2.reconfigure LyS2config @04:12:39.65 LyS1.reconfigure LyS1config @04:12:39.68 AirS.reconfigure AirSconfig @04:12:39.90 TV.setRawPosition! 0 @04:12:39.92 PV.reconfigure PVconfig @04:12:40.00 TV.seek :home @04:12:40.11 TV.reconfigure TVconfig @04:12:40.34 TV.seek :clear @04:12:41.95 TV.coast @04:12:42.00 SC.reconfigure HomeSC @04:12:42.06 SC.home.jog 0 @04:12:42.81 SC.reconfigure SCconfig @04:12:42.87 SC.seek 24 @04:12:42.96 Selecting Cartridge 23 @04:12:43.26 SC.seek 23 @04:12:43.76 LyS2.seek :locked @04:12:43.88 PV.seek :locked @04:12:44.01 AirS.seek :locked @04:12:48.09 Powering cartridge bus @04:12:50.22 Gate.setIR 1750,5000,0,6 @04:12:50.35 Gate.setIR 0,5000,0,6 @04:12:50.40 Loaded Lyse-n-Go Cartridge @04:12:50.41 PuckHeater.configure HeatConfig @04:12:50.46 Gate.power :heat,:ON,limit to 5000mA @04:13:10.54 -> Cmd.startFiltering @04:13:10.78 Duration of filtering limited to 1:05:00 @04:13:11.02 Priming sample loop w/100ml, bypass w/10ml @04:13:11.10 SP.setPosition! 0ml @04:13:11.14 Intake.open @04:13:11.16 Exhaust.open @04:13:11.99 Sea @-42.9psia @04:13:12.01 Waiting 4 - 300s for filter pressure to stabilize +/-0.5psi @04:13:17.79 Vacuum tare is 24% of full scale @04:13:17.81 PB.open @04:13:17.85 Exhaust.close @04:13:18.66 Sea @-42.9psia @04:13:18.75 SP.reconfigure SPprime @04:13:18.81 SP.seek 10ml,1:21 @04:13:29.66 SP.setPosition! 0ml @04:13:29.71 PB.close @04:13:29.73 Exhaust.open @04:13:30.54 Sea @-42.9psia @04:13:30.62 SP.reconfigure SPprime @04:13:30.69 SP.seek 100ml,8:51 @04:15:24.58 Intake.close @04:15:25.33 Pressurizing cartridge to 26psi (try #1 of 3) @04:15:25.35 SP.setPosition! 0ml @04:15:25.40 PB.open @04:15:26.19 TV.seek :crack @04:15:26.99 TV.seek :clear @04:15:27.78 Intake.open @04:15:29.24 PB.close @04:15:29.99 Exhaust.close @04:15:30.73 Sea @-42.9psia @04:15:30.82 SP.reconfigure SPcharge @04:15:30.88 SP.seek 2.3ml,42 seconds @04:15:43.11 Cartridge pressurized with 0.702ml to 27.1psi @04:15:43.49 delay 3 seconds @04:15:46.56 Cartridge at 21.5psi 3 seconds later @04:15:46.64 TV.seek :cartridge @04:15:48.47 TV.seek :clear @04:15:50.29 Sampling 1000.0ml @04:15:50.30 SP.setPosition! 0ml @04:15:50.34 Exhaust.open @04:15:51.09 Sea @-42.9psia @04:15:51.18 SP.reconfigure SPsample @04:15:51.25 SP.seek 1000ml,1:23:53 @04:15:52.20 Cartridge 23 sampling 0/1000ml at 0.17ml/s with 4.9psi vacuum @04:16:52.21 Cartridge 23 sampling 33/1000ml at 0.55ml/s with 23.1psi vacuum @04:17:52.21 Cartridge 23 sampling 65/1000ml at 0.55ml/s with 24.1psi vacuum @04:18:52.21 Cartridge 23 sampling 97/1000ml at 0.53ml/s with 23.9psi vacuum @04:19:52.22 Cartridge 23 sampling 129/1000ml at 0.52ml/s with 25.8psi vacuum @04:20:52.21 Cartridge 23 sampling 160/1000ml at 0.50ml/s with 23.4psi vacuum @04:21:52.21 Cartridge 23 sampling 190/1000ml at 0.52ml/s with 22.3psi vacuum @04:22:52.21 Cartridge 23 sampling 220/1000ml at 0.50ml/s with 22.4psi vacuum @04:23:52.21 Cartridge 23 sampling 249/1000ml at 0.49ml/s with 22.3psi vacuum @04:24:52.21 Cartridge 23 sampling 276/1000ml at 0.42ml/s with 23.8psi vacuum @04:25:52.21 Cartridge 23 sampling 302/1000ml at 0.41ml/s with 20.1psi vacuum @04:26:52.21 Cartridge 23 sampling 326/1000ml at 0.37ml/s with 19.9psi vacuum @04:27:52.21 Cartridge 23 sampling 347/1000ml at 0.36ml/s with 24.4psi vacuum @04:28:52.21 Cartridge 23 sampling 365/1000ml at 0.25ml/s with 25.6psi vacuum @04:29:52.47 Cartridge 23 sampling 382/1000ml at 0.23ml/s with 25.7psi vacuum @04:30:52.22 Cartridge 23 sampling 397/1000ml at 0.22ml/s with 21.8psi vacuum @04:31:52.22 Cartridge 23 sampling 410/1000ml at 0.20ml/s with 24.1psi vacuum @04:32:52.22 Cartridge 23 sampling 423/1000ml at 0.20ml/s with 24.7psi vacuum @04:33:52.22 Cartridge 23 sampling 435/1000ml at 0.20ml/s with 25.3psi vacuum @04:34:47.98 Flow averaged 0.39ml/s over 18:52 @04:34:48.01 Waiting up to 10 seconds for vacuum to reduce from 26.7 to 18.0psi @04:34:48.63 Relieved excess vacuum in 6.2 seconds @04:34:48.66 SP.seek 1000ml,46:40 @04:34:52.20 Cartridge 23 sampling 447/1000ml at 0.20ml/s with 28.1psi vacuum @04:35:04.99 Flow averaged 0.23ml/s over 14 seconds @04:35:05.02 Waiting up to 13 seconds for vacuum to reduce from 28.0 to 18.0psi @04:35:05.64 Relieved excess vacuum in 3.3 seconds @04:35:05.67 SP.seek 1000ml,46:25 @04:35:15.76 Flow estimate reduced to 0.19ml/s @04:35:15.78 Intake.close @04:35:15.83 Exhaust.close @04:35:16.60 Cartridge::Sampler::Clogged in FILTERING -- Cartridge clogged @04:35:16.69 Sampled 451.4ml @04:35:16.77 TV.seek :bypass @04:35:18.39 TV.seek :clear @04:35:20.52 -> Cmd.startProcessing @04:35:22.31 SPR.command "read_sequences" @04:35:22.94 SPR.command "stats_on" @04:35:22.98 SPR.command "start 0 1" @04:35:24.98 Begun log /var/log/esp/spr18aug3004h.spr @04:35:25.81 Handoff.select :waste @04:35:25.93 ArS.seek empty @04:35:43.65 PinPort.seek :cartridge @04:35:49.36 LyS1.seek 1350ul @04:35:55.30 PV.seek :reagent @04:35:56.13 AirS.seek :tVent @04:35:58.19 delay 2 seconds @04:36:00.22 AirS.reconfigure EvacAirS @04:36:00.27 AirS.seek :evac @04:36:22.58 delay 15 seconds @04:36:37.61 AirS.reconfigure AirSconfig @04:36:37.67 AirS.seek :tVent @04:36:51.88 delay 2 seconds @04:36:53.91 AirS.reconfigure EvacAirS @04:36:53.96 AirS.seek :evac @04:37:16.25 delay 15 seconds @04:37:31.28 AirS.reconfigure AirSconfig @04:37:31.34 AirS.seek :tVent @04:37:45.54 delay 2 seconds @04:37:47.57 AirS.reconfigure EvacAirS @04:37:47.63 AirS.seek :evac @04:38:09.92 delay 15 seconds @04:38:24.95 AirS.reconfigure AirSconfig @04:38:25.01 AirS.seek :tVent @04:38:39.24 delay 2 seconds @04:38:41.27 AirS.reconfigure EvacAirS @04:38:41.32 AirS.seek :evac @04:39:03.60 delay 15 seconds @04:39:18.63 AirS.reconfigure AirSconfig @04:39:18.69 AirS.seek :tVent @04:39:32.89 delay 2 seconds @04:39:34.92 AirS.reconfigure EvacAirS @04:39:34.97 AirS.seek :evac @04:39:57.26 delay 15 seconds @04:40:12.29 delay 1:30 @04:41:42.31 AirS.reconfigure AirSconfig @04:41:42.37 AirS.seek :fVent @04:41:43.80 delay 15 seconds @04:41:58.83 LyS1.reconfigure SlowLyS1 @04:41:58.93 LyS1.seek 1050ul @04:42:28.94 delay 5 seconds @04:42:33.96 Handoff.select :blocked @04:42:34.13 LyS1.seek 450ul @04:43:34.07 delay 10 seconds @04:43:44.10 AirS.reconfigure SlowAirS @04:43:44.44 AirS.reconfigure to mix into 1.37806 parts LyS1 @04:43:44.77 AirS.seek evac @04:43:44.80 LyS1.seek 300ul @04:43:59.89 AirS.reconfigure AirSconfig @04:43:59.95 AirS.seek :full @04:44:14.16 LyS1.seek :empty @04:44:44.22 PuckHeater.seek 84.1C @04:45:42.18 PuckHeater.hold 15:00,84.1C @05:00:43.30 LyS1.reconfigure LyS1config @05:00:43.37 LyS1.seek 900ul @05:00:51.72 AirS.seek :tVent @05:00:51.80 delay 2 seconds @05:00:53.82 AirS.reconfigure HalfSpeedAirS @05:00:53.87 AirS.seek :evac @05:01:21.59 delay 15 seconds @05:01:36.82 AirS.reconfigure AirSconfig @05:01:36.93 AirS.seek :tVent @05:01:51.12 delay 2 seconds @05:01:53.15 AirS.reconfigure HalfSpeedAirS @05:01:53.23 AirS.seek :evac @05:02:20.94 delay 15 seconds @05:02:35.97 AirS.reconfigure AirSconfig @05:02:36.03 AirS.seek :tVent @05:02:50.23 delay 2 seconds @05:02:52.26 AirS.reconfigure HalfSpeedAirS @05:02:52.32 AirS.seek :evac @05:03:20.03 delay 15 seconds @05:03:35.06 delay 1:00 @05:04:35.09 Handoff.select :waste @05:04:35.22 delay 15 seconds @05:04:50.25 AirS.seek :fVent @05:04:52.44 delay 10 seconds @05:05:02.47 AirS.reconfigure AirSconfig @05:05:02.53 AirS.seek :evac @05:05:03.97 Lysis Recovered in LyS1 @05:05:03.98 Lysis Complete @05:05:04.00 Handoff.select :waste @05:05:04.02 LyS2.seek :full @05:05:04.11 LyS1.reconfigure DAmixLyS1 @05:05:04.16 LyS2.reconfigure DAmixLyS2 @05:05:04.55 LyS1.seek 650ul @05:05:04.60 LyS2.seek 1480ul @05:05:51.89 delay 5 seconds @05:05:56.91 Handoff.select :SPR @05:05:57.04 SPR.command "start 2 14" @05:05:57.87 Running Experiment 2 @05:05:57.88 delay 10 seconds @05:06:07.89 SPR.command "start 2 0" @05:06:11.73 Waiting up to 11:00 for SPR to enter state 1 @05:13:30.45 SPR.command "hold_on" @05:13:32.16 LyS1.seek 300ul @05:13:32.20 LyS2.seek 1130ul @05:14:38.34 delay 15 seconds @05:14:53.36 SPR.command "hold_off" @05:14:56.16 Waiting up to 25:00 for SPR to enter state 7 @05:26:32.65 Handoff.select :waste @05:26:32.78 LyS1.reconfigure LyS1config @05:26:32.84 LyS2.reconfigure LyS2config @05:26:32.90 Rep #1 SPR Analysis has Completed @05:26:33.59 Ended log /var/log/esp/spr18aug3004h.spr @05:26:33.61 SPR.command "stats_off" @05:26:35.88 -> Cmd.stop @05:26:35.97 Handoff.select :close @05:26:36.15 Gate.power :heat,:OFF @05:26:36.16 Gate.power :cartridge,:OFF @05:26:36.19 PV.seek :locked @05:26:37.09 PinPort.seek :clear @05:26:42.86 ArS.seek :clear @05:26:43.22 LyS1.seek :clear @05:26:43.35 LyS2.seek :clear @05:26:43.50 AirS.seek :clear @05:27:00.84 ArS.coast @05:27:00.89 LyS1.coast @05:27:00.94 LyS2.coast @05:27:00.99 AirS.coast @05:27:01.04 TV.coast @05:27:01.09 SP.coast @05:27:01.14 SC.coast @05:27:01.19 PV.coast @05:27:01.24 PinPort.coast @05:27:01.43 Gate.power :motor,:OFF @05:27:01.44 Gate.power :main,:OFF @05:27:01.46 Gate.power :core,:OFF @05:27:01.48 Gate.power :analytic1,:OFF @05:27:01.50 Gate.power :analytic2,:OFF @05:27:01.53 Gate.power :analytic3,:OFF @05:27:01.54 Safely stopped and ready to power off