@14:28:27.41PDT04-Aug-18
>BREAK< ESP3 Gateway v0.99 for core bus @14:28:27.43 >BREAK< ESP3 Gateway v0.99 for cartridge bus @14:28:28.67 Configuration for honu by brent@mbari.org /home/esp/esp2/type/auv/honu/configure.rb @14:28:29.85 Polling Can every 5:00 @14:28:30.15 Clients may connect on TCP port 9999 @14:28:30.16 Connecting to 10.89.5.2:9999 @14:28:30.20 Waiting for espclients... @14:28:30.27 Session Begun @14:28:32.20 -> showStatus @14:28:34.21 -> Cmd.loadCartridge @14:28:34.33 Gate.power :main,:ON,limit to 5000mA @14:28:34.34 Gate.power :analytic1,:ON,limit to 5000mA @14:28:34.36 Gate.power :analytic2,:ON,limit to 5000mA @14:28:34.39 Gate.power :analytic3,:ON,limit to 5000mA @14:28:34.53 Powering core bus @14:28:36.82 SPR Module 1, FW Rev. B, FPGA Rev. C @14:28:36.92 ArS.configure ArSconfig @14:28:37.02 LyS1.configure LyS1config @14:28:37.14 LyS2.configure LyS2config @14:28:37.24 AirS.configure AirSconfig @14:28:37.35 TV.configure TVconfig @14:28:37.47 SP.configure SPconfig @14:28:37.59 SC.configure SCconfig @14:28:37.71 PV.configure PVconfig @14:28:37.83 PinPort.configure PPconfig @14:28:37.95 Sea.configure SPconfig @14:28:38.01 All elf controllers running firmware version 4.46 @14:28:38.03 Gate.power :motor,:ON,limit to 5000mA @14:28:38.18 ArS.reconfigure ArSconfig @14:28:38.48 ArS.home.jog 0 @14:28:38.61 PinPort.reconfigure PPconfig @14:28:38.68 PV.reconfigure PVconfig @14:28:38.72 AirS.reconfigure AirSconfig @14:28:38.75 LyS1.reconfigure LyS1config @14:28:38.78 TV.reconfigure TVconfig @14:28:38.86 LyS2.reconfigure LyS2config @14:28:39.01 PinPort.home.jog 0 @14:28:39.06 PV.home.jog 0 @14:28:39.10 LyS1.home.jog 0 @14:28:39.13 TV.home.jog 0 @14:28:39.15 LyS2.home.jog 0 @14:28:39.19 AirS.home.jog 0 @14:28:39.54 ArS.reconfigure HomeMagSyringe @14:28:39.74 PV.reconfigure HomePV @14:28:39.78 TV.reconfigure HomeTV @14:28:39.82 LyS1.reconfigure HomeSyringe @14:28:39.92 PinPort.reconfigure HomePP @14:28:40.00 ArS.jog -285 @14:28:40.16 PV.jog -1502 @14:28:40.18 TV.jog -553 @14:28:40.22 PinPort.jog -107 @14:28:40.26 LyS1.jog -282 @14:28:40.47 LyS2.reconfigure HomeSyringe @14:28:40.48 AirS.reconfigure HomeMagSyringe @14:28:40.57 LyS2.jog -272 @14:28:40.60 AirS.jog -338 @14:28:40.73 PinPort.setRawPosition! 0 @14:28:40.75 ArS.setRawPosition! -50 @14:28:40.82 PinPort.seek :home @14:28:40.86 ArS.seek :home @14:28:40.99 PinPort.reconfigure PPconfig @14:28:41.25 LyS1.setRawPosition! -50 @14:28:41.36 LyS1.seek :home @14:28:41.46 LyS2.setRawPosition! -50 @14:28:41.50 AirS.setRawPosition! -50 @14:28:41.54 ArS.reconfigure ArSconfig @14:28:41.63 LyS2.seek :home @14:28:41.71 AirS.seek :home @14:28:41.86 PV.setRawPosition! -50 @14:28:41.88 LyS1.reconfigure LyS1config @14:28:41.95 PV.seek :home @14:28:42.10 AirS.reconfigure AirSconfig @14:28:42.12 LyS2.reconfigure LyS2config @14:28:42.23 TV.setRawPosition! 0 @14:28:42.30 TV.seek :home @14:28:42.40 TV.reconfigure TVconfig @14:28:42.43 PV.reconfigure PVconfig @14:28:42.71 TV.seek :clear @14:28:44.34 TV.coast @14:28:44.39 SC.reconfigure HomeSC @14:28:44.45 SC.home.jog 0 @14:28:45.22 SC.reconfigure SCconfig @14:28:45.28 SC.seek 45 @14:28:45.38 Selecting Cartridge 44 @14:28:45.68 SC.seek 44 @14:28:46.18 LyS2.seek :locked @14:28:46.31 PV.seek :locked @14:28:46.45 AirS.seek :locked @14:28:50.52 Powering cartridge bus @14:28:52.64 Gate.setIR 1750,5000,0,6 @14:28:52.77 Gate.setIR 0,5000,0,6 @14:28:52.83 Loaded Lyse-n-Go Cartridge @14:28:52.84 PuckHeater.configure HeatConfig @14:28:52.89 Gate.power :heat,:ON,limit to 5000mA @14:29:13.01 -> Cmd.startFiltering @14:29:13.24 Duration of filtering limited to 1:05:00 @14:29:13.49 Priming sample loop w/100ml, bypass w/10ml @14:29:13.57 SP.setPosition! 0ml @14:29:13.61 Intake.open @14:29:13.63 Exhaust.open @14:29:14.47 Sea @-42.9psia @14:29:14.48 Waiting 4 - 300s for filter pressure to stabilize +/-0.5psi @14:29:20.00 Vacuum tare is 23% of full scale @14:29:20.02 PB.open @14:29:20.30 Exhaust.close @14:29:21.10 Sea @-42.9psia @14:29:21.18 SP.reconfigure SPprime @14:29:21.25 SP.seek 10ml,1:21 @14:29:32.13 SP.setPosition! 0ml @14:29:32.17 PB.close @14:29:32.20 Exhaust.open @14:29:32.99 Sea @-42.9psia @14:29:33.08 SP.reconfigure SPprime @14:29:33.15 SP.seek 100ml,8:51 @14:31:28.04 Pressurizing cartridge to 26psi @14:31:28.05 Intake.close @14:31:28.81 SP.setPosition! 0ml @14:31:28.85 PB.open @14:31:29.63 TV.seek :crack @14:31:30.42 TV.seek :clear @14:31:31.22 Intake.open @14:31:32.67 PB.close @14:31:33.40 Exhaust.close @14:31:34.15 Sea @-42.9psia @14:31:34.23 SP.reconfigure SPcharge @14:31:34.30 SP.seek 7.5ml,1:08 @14:31:39.20 Cartridge pressurized with 0.109ml to 26.1psi @14:31:39.44 delay 3 seconds @14:31:42.51 Cartridge at 22.3psi 3 seconds later @14:31:42.59 TV.seek :cartridge @14:31:44.40 TV.seek :clear @14:31:46.21 Sampling 1000.0ml @14:31:46.22 SP.setPosition! 0ml @14:31:46.27 Exhaust.open @14:31:47.03 Sea @-42.9psia @14:31:47.12 SP.reconfigure SPsample @14:31:47.18 SP.seek 1000ml,1:23:53 @14:31:48.14 Cartridge 44 sampling 0/1000ml at 0.17ml/s with 3.7psi vacuum @14:32:48.15 Cartridge 44 sampling 31/1000ml at 0.55ml/s with 25.5psi vacuum @14:33:48.15 Cartridge 44 sampling 63/1000ml at 0.49ml/s with 22.7psi vacuum @14:34:48.15 Cartridge 44 sampling 94/1000ml at 0.51ml/s with 18.1psi vacuum @14:35:48.15 Cartridge 44 sampling 125/1000ml at 0.50ml/s with 21.7psi vacuum @14:36:48.15 Cartridge 44 sampling 156/1000ml at 0.52ml/s with 26.0psi vacuum @14:37:48.15 Cartridge 44 sampling 187/1000ml at 0.52ml/s with 17.4psi vacuum -39.0m deep (-42.9psia) @14:38:48.15 Cartridge 44 sampling 219/1000ml at 0.51ml/s with 25.7psi vacuum @14:39:48.15 Cartridge 44 sampling 250/1000ml at 0.52ml/s with 17.6psi vacuum @14:40:48.15 Cartridge 44 sampling 281/1000ml at 0.53ml/s with 25.1psi vacuum @14:41:48.15 Cartridge 44 sampling 312/1000ml at 0.49ml/s with 21.6psi vacuum @14:42:48.15 Cartridge 44 sampling 343/1000ml at 0.51ml/s with 17.4psi vacuum @14:43:48.15 Cartridge 44 sampling 374/1000ml at 0.54ml/s with 23.0psi vacuum @14:44:48.15 Cartridge 44 sampling 405/1000ml at 0.54ml/s with 25.8psi vacuum @14:45:48.15 Cartridge 44 sampling 436/1000ml at 0.53ml/s with 25.4psi vacuum @14:46:48.15 Cartridge 44 sampling 467/1000ml at 0.53ml/s with 24.9psi vacuum @14:47:48.15 Cartridge 44 sampling 498/1000ml at 0.54ml/s with 25.7psi vacuum @14:48:48.41 Cartridge 44 sampling 529/1000ml at 0.49ml/s with 21.2psi vacuum @14:49:48.15 Cartridge 44 sampling 560/1000ml at 0.52ml/s with 19.1psi vacuum @14:50:48.15 Cartridge 44 sampling 590/1000ml at 0.48ml/s with 20.4psi vacuum @14:51:48.15 Cartridge 44 sampling 621/1000ml at 0.53ml/s with 25.1psi vacuum @14:52:48.15 Cartridge 44 sampling 652/1000ml at 0.51ml/s with 17.7psi vacuum @14:53:48.15 Cartridge 44 sampling 683/1000ml at 0.51ml/s with 25.2psi vacuum @14:54:48.15 Cartridge 44 sampling 714/1000ml at 0.53ml/s with 20.6psi vacuum @14:55:48.15 Cartridge 44 sampling 745/1000ml at 0.49ml/s with 20.9psi vacuum @14:56:48.15 Cartridge 44 sampling 775/1000ml at 0.54ml/s with 25.5psi vacuum @14:57:48.15 Cartridge 44 sampling 806/1000ml at 0.50ml/s with 17.9psi vacuum @14:58:48.15 Cartridge 44 sampling 837/1000ml at 0.54ml/s with 23.2psi vacuum @14:59:48.15 Cartridge 44 sampling 868/1000ml at 0.49ml/s with 20.5psi vacuum @15:00:48.15 Cartridge 44 sampling 899/1000ml at 0.55ml/s with 22.5psi vacuum @15:01:48.15 Cartridge 44 sampling 929/1000ml at 0.49ml/s with 20.5psi vacuum @15:02:48.15 Cartridge 44 sampling 960/1000ml at 0.54ml/s with 24.8psi vacuum @15:03:48.15 Cartridge 44 sampling 991/1000ml at 0.50ml/s with 18.0psi vacuum @15:04:10.07 Intake.close @15:04:10.12 Exhaust.close @15:04:10.85 Sampled 1000.0ml @15:04:10.94 TV.seek :bypass @15:04:12.55 TV.seek :clear @15:04:14.71 -> Cmd.startProcessing @15:04:16.49 SPR.command "read_sequences" @15:04:17.14 SPR.command "stats_on" @15:04:17.18 SPR.command "start 2 0" @15:04:19.18 Begun log /var/log/esp/spr18aug0415h.spr @15:04:20.21 AnalyticModule::ReadTimeout in PROCESSING -- No response from SPR on AMspr (try 1 of 3) @15:04:21.88 Handoff.select :waste @15:04:22.00 ArS.seek empty @15:04:39.72 PinPort.seek :cartridge @15:04:45.45 LyS1.seek 1350ul @15:04:51.39 PV.seek :reagent @15:04:52.23 AirS.seek :tVent @15:04:54.30 delay 2 seconds @15:04:56.33 AirS.reconfigure EvacAirS @15:04:56.39 AirS.seek :evac @15:05:18.70 delay 15 seconds @15:05:33.73 AirS.reconfigure AirSconfig @15:05:33.78 AirS.seek :tVent @15:05:48.00 delay 2 seconds @15:05:50.03 AirS.reconfigure EvacAirS @15:05:50.08 AirS.seek :evac @15:06:12.40 delay 15 seconds @15:06:27.43 AirS.reconfigure AirSconfig @15:06:27.48 AirS.seek :tVent @15:06:41.70 delay 2 seconds @15:06:43.73 AirS.reconfigure EvacAirS @15:06:43.78 AirS.seek :evac @15:07:06.09 delay 15 seconds @15:07:21.11 AirS.reconfigure AirSconfig @15:07:21.17 AirS.seek :tVent @15:07:35.39 delay 2 seconds @15:07:37.42 AirS.reconfigure EvacAirS @15:07:37.47 AirS.seek :evac @15:07:59.78 delay 15 seconds @15:08:14.81 AirS.reconfigure AirSconfig @15:08:14.87 AirS.seek :tVent @15:08:29.09 delay 2 seconds @15:08:31.11 AirS.reconfigure EvacAirS @15:08:31.17 AirS.seek :evac @15:08:53.48 delay 15 seconds @15:09:08.50 delay 1:30 @15:10:38.53 AirS.reconfigure AirSconfig @15:10:38.58 AirS.seek :fVent @15:10:40.01 delay 15 seconds @15:10:55.03 LyS1.reconfigure SlowLyS1 @15:10:55.13 LyS1.seek 1050ul @15:11:25.17 delay 5 seconds @15:11:30.19 Handoff.select :blocked @15:11:30.35 LyS1.seek 450ul @15:12:30.37 delay 10 seconds @15:12:40.39 AirS.reconfigure SlowAirS @15:12:40.50 AirS.reconfigure to mix into 1.37806 parts LyS1 @15:12:40.83 AirS.seek evac @15:12:40.87 LyS1.seek 300ul @15:12:55.97 AirS.reconfigure AirSconfig @15:12:56.03 AirS.seek :full @15:13:10.24 LyS1.seek :empty @15:13:40.33 PuckHeater.seek 86.5C @15:14:53.04 PuckHeater.hold 15:00,86.5C @15:29:51.96 LyS1.reconfigure LyS1config @15:29:52.02 LyS1.seek 900ul @15:30:00.37 AirS.seek :tVent @15:30:00.45 delay 2 seconds @15:30:02.48 AirS.reconfigure HalfSpeedAirS @15:30:02.58 AirS.seek :evac @15:30:30.34 delay 15 seconds @15:30:45.37 AirS.reconfigure AirSconfig @15:30:45.42 AirS.seek :tVent @15:30:59.65 delay 2 seconds @15:31:01.68 AirS.reconfigure HalfSpeedAirS @15:31:01.74 AirS.seek :evac @15:31:29.51 delay 15 seconds @15:31:44.54 AirS.reconfigure AirSconfig @15:31:44.59 AirS.seek :tVent @15:31:58.81 delay 2 seconds @15:32:00.84 AirS.reconfigure HalfSpeedAirS @15:32:00.90 AirS.seek :evac @15:32:28.65 delay 15 seconds @15:32:43.67 delay 1:00 @15:33:43.69 Handoff.select :waste @15:33:43.80 delay 15 seconds @15:33:58.83 AirS.seek :fVent @15:34:01.02 delay 10 seconds @15:34:11.05 AirS.reconfigure AirSconfig @15:34:11.10 AirS.seek :evac @15:34:12.54 Lysis Recovered in LyS1 @15:34:12.55 Lysis Complete @15:34:12.56 Handoff.select :waste @15:34:12.59 LyS2.seek :full @15:34:12.67 LyS1.reconfigure DAmixLyS1 @15:34:12.73 LyS2.reconfigure DAmixLyS2 @15:34:13.14 LyS2.seek 1480ul @15:34:13.18 LyS1.seek 650ul @15:35:00.51 delay 5 seconds @15:35:05.53 Handoff.select :SPR @15:35:05.64 SPR.command "start 1 14" @15:35:06.72 Running Experiment-Rep #1 @15:35:06.73 delay 10 seconds @15:35:16.75 SPR.command "start 1 0" @15:35:19.61 Waiting up to 4:00 for SPR to enter state 1 @15:37:23.85 SPR.command "hold_on" @15:37:25.59 LyS2.seek 1130ul @15:37:25.62 LyS1.seek 300ul @15:38:31.83 delay 15 seconds @15:38:46.85 SPR.command "hold_off" @15:38:49.58 Waiting up to 25:00 for SPR to enter state 7 @15:58:53.96 Handoff.select :waste @15:58:54.08 LyS1.reconfigure LyS1config @15:58:54.15 LyS2.reconfigure LyS2config @15:58:54.44 Rep #1 SPR Analysis has Completed @15:58:54.89 Ended log /var/log/esp/spr18aug0415h.spr @15:58:54.90 SPR.command "stats_off" @15:58:57.04 -> Cmd.stop @15:58:57.13 Handoff.select :close @15:58:57.31 Gate.power :heat,:OFF @15:58:57.33 Gate.power :cartridge,:OFF @15:58:57.36 PV.seek :locked @15:58:58.25 PinPort.seek :clear @15:59:04.03 ArS.seek :clear @15:59:04.16 LyS1.seek :clear @15:59:04.29 LyS2.seek :clear @15:59:04.42 AirS.seek :clear @15:59:21.81 ArS.coast @15:59:21.86 LyS1.coast @15:59:21.91 LyS2.coast @15:59:21.96 AirS.coast @15:59:22.01 TV.coast @15:59:22.05 SP.coast @15:59:22.10 SC.coast @15:59:22.15 PV.coast @15:59:22.20 PinPort.coast @15:59:22.38 Gate.power :motor,:OFF @15:59:22.40 Gate.power :main,:OFF @15:59:22.42 Gate.power :core,:OFF @15:59:22.44 Gate.power :analytic1,:OFF @15:59:22.46 Gate.power :analytic2,:OFF @15:59:22.48 Gate.power :analytic3,:OFF @15:59:22.50 Safely stopped and ready to power off