@17:12:48.74PDT03-Aug-18
>BREAK< ESP3 Gateway v0.99 for core bus @17:12:48.76 >BREAK< ESP3 Gateway v0.99 for cartridge bus @17:12:50.03 Configuration for honu by brent@mbari.org /home/esp/esp2/type/auv/honu/configure.rb @17:12:51.21 Polling Can every 5:00 @17:12:51.51 Clients may connect on TCP port 9999 Connecting to 10.89.5.2:9999 @17:12:51.55 Waiting for espclients... @17:12:51.98 Session Begun @17:12:53.99 -> showStatus @17:12:55.96 -> Cmd.loadCartridge @17:12:56.09 Gate.power :main,:ON,limit to 5000mA @17:12:56.10 Gate.power :analytic1,:ON,limit to 5000mA @17:12:56.12 Gate.power :analytic2,:ON,limit to 5000mA @17:12:56.15 Gate.power :analytic3,:ON,limit to 5000mA @17:12:56.29 Powering core bus @17:12:58.58 SPR Module 1, FW Rev. B, FPGA Rev. C @17:12:58.67 ArS.configure ArSconfig @17:12:58.77 LyS1.configure LyS1config @17:12:58.88 LyS2.configure LyS2config @17:12:58.99 AirS.configure AirSconfig @17:12:59.12 TV.configure TVconfig @17:12:59.24 SP.configure SPconfig @17:12:59.35 SC.configure SCconfig @17:12:59.48 PV.configure PVconfig @17:12:59.59 PinPort.configure PPconfig @17:12:59.71 Sea.configure SPconfig @17:12:59.77 All elf controllers running firmware version 4.46 @17:12:59.79 Gate.power :motor,:ON,limit to 5000mA @17:13:00.31 TV.reconfigure TVconfig @17:13:00.36 AirS.reconfigure AirSconfig @17:13:00.41 LyS1.reconfigure LyS1config @17:13:00.45 PV.reconfigure PVconfig @17:13:00.49 PinPort.reconfigure PPconfig @17:13:00.52 ArS.reconfigure ArSconfig @17:13:00.57 LyS2.reconfigure LyS2config @17:13:00.76 TV.home.jog 0 @17:13:00.80 LyS1.home.jog 0 @17:13:00.83 PinPort.home.jog 0 @17:13:00.85 PV.home.jog 0 @17:13:00.91 AirS.home.jog 0 @17:13:00.97 LyS2.home.jog 0 @17:13:01.02 ArS.home.jog 0 @17:13:01.58 TV.reconfigure HomeTV @17:13:01.69 PV.reconfigure HomePV @17:13:01.71 AirS.reconfigure HomeMagSyringe @17:13:01.74 PinPort.reconfigure HomePP @17:13:01.79 LyS1.reconfigure HomeSyringe @17:13:01.95 TV.jog -549 @17:13:01.98 PV.jog -1503 @17:13:02.02 AirS.jog -334 @17:13:02.05 PinPort.jog -107 @17:13:02.12 LyS1.jog -284 @17:13:02.30 LyS2.reconfigure HomeSyringe @17:13:02.32 ArS.reconfigure HomeMagSyringe @17:13:02.40 LyS2.jog -275 @17:13:02.43 ArS.jog -288 @17:13:02.57 PinPort.setRawPosition! 0 @17:13:02.61 PinPort.seek :home @17:13:02.70 PinPort.reconfigure PPconfig @17:13:02.79 AirS.setRawPosition! -50 @17:13:02.82 LyS1.setRawPosition! -50 @17:13:03.09 AirS.seek :home @17:13:03.17 LyS1.seek :home @17:13:03.34 PV.setRawPosition! -50 @17:13:03.36 ArS.setRawPosition! -50 @17:13:03.40 LyS2.setRawPosition! -50 @17:13:03.45 PV.seek :home @17:13:03.53 ArS.seek :home @17:13:03.64 LyS2.seek :home @17:13:03.79 LyS1.reconfigure LyS1config @17:13:03.80 AirS.reconfigure AirSconfig @17:13:03.99 TV.setRawPosition! 0 @17:13:04.04 ArS.reconfigure ArSconfig @17:13:04.05 PV.reconfigure PVconfig @17:13:04.08 LyS2.reconfigure LyS2config @17:13:04.22 TV.seek :home @17:13:04.39 TV.reconfigure TVconfig @17:13:04.80 TV.seek :clear @17:13:06.42 TV.coast @17:13:06.47 SC.reconfigure HomeSC @17:13:06.53 SC.home.jog 0 @17:13:07.28 SC.reconfigure SCconfig @17:13:07.34 SC.seek 53 @17:13:07.41 Selecting Cartridge 52 @17:13:07.71 SC.seek 52 @17:13:08.21 LyS2.seek :locked @17:13:08.33 PV.seek :locked @17:13:08.47 AirS.seek :locked @17:13:12.55 Powering cartridge bus @17:13:14.68 Gate.setIR 1750,5000,0,6 @17:13:14.81 Gate.setIR 0,5000,0,6 @17:13:14.86 Loaded Lyse-n-Go Cartridge @17:13:14.87 PuckHeater.configure HeatConfig @17:13:14.92 Gate.power :heat,:ON,limit to 5000mA @17:13:34.68 -> Cmd.startFiltering @17:13:34.91 Duration of filtering limited to 1:05:00 @17:13:35.16 Priming sample loop w/100ml, bypass w/10ml @17:13:35.23 SP.setPosition! 0ml @17:13:35.27 Intake.open @17:13:35.29 Exhaust.open @17:13:36.10 Sea @-42.9psia @17:13:36.12 Waiting 4 - 300s for filter pressure to stabilize +/-0.5psi @17:13:41.65 Vacuum tare is 23% of full scale @17:13:41.66 PB.open @17:13:41.93 Exhaust.close @17:13:42.73 Sea @-42.9psia @17:13:42.82 SP.reconfigure SPprime @17:13:42.88 SP.seek 10ml,1:21 @17:13:53.76 SP.setPosition! 0ml @17:13:53.81 PB.close @17:13:53.83 Exhaust.open @17:13:54.62 Sea @-42.9psia @17:13:54.71 SP.reconfigure SPprime @17:13:54.78 SP.seek 100ml,8:51 @17:15:51.23 Pressurizing cartridge to 26psi @17:15:51.24 Intake.close @17:15:51.97 SP.setPosition! 0ml @17:15:52.01 PB.open @17:15:52.77 TV.seek :crack @17:15:53.57 TV.seek :clear @17:15:54.36 Intake.open @17:15:55.79 PB.close @17:15:56.50 Exhaust.close @17:15:57.24 Sea @-42.9psia @17:15:57.33 SP.reconfigure SPcharge @17:15:57.40 SP.seek 7.5ml,1:08 @17:16:05.10 Cartridge pressurized with 0.274ml to 27.0psi @17:16:05.33 delay 3 seconds @17:16:08.40 Cartridge at 21.4psi 3 seconds later @17:16:08.48 TV.seek :cartridge @17:16:10.30 TV.seek :clear @17:16:12.12 Sampling 1000.0ml @17:16:12.13 SP.setPosition! 0ml @17:16:12.18 Exhaust.open @17:16:12.94 Sea @-42.9psia @17:16:13.04 SP.reconfigure SPsample @17:16:13.10 SP.seek 1000ml,1:23:53 @17:16:14.05 Cartridge 52 sampling 0/1000ml at 0.17ml/s with 4.2psi vacuum @17:17:14.06 Cartridge 52 sampling 31/1000ml at 0.53ml/s with 24.8psi vacuum @17:18:14.05 Cartridge 52 sampling 61/1000ml at 0.50ml/s with 17.7psi vacuum @17:19:14.06 Cartridge 52 sampling 91/1000ml at 0.53ml/s with 22.2psi vacuum @17:20:14.06 Cartridge 52 sampling 121/1000ml at 0.46ml/s with 26.1psi vacuum @17:21:14.06 Cartridge 52 sampling 151/1000ml at 0.48ml/s with 26.0psi vacuum @17:22:14.06 Cartridge 52 sampling 180/1000ml at 0.50ml/s with 17.6psi vacuum @17:23:14.05 Cartridge 52 sampling 210/1000ml at 0.50ml/s with 17.7psi vacuum @17:24:14.06 Cartridge 52 sampling 239/1000ml at 0.47ml/s with 17.4psi vacuum @17:25:14.06 Cartridge 52 sampling 268/1000ml at 0.49ml/s with 25.3psi vacuum @17:26:14.06 Cartridge 52 sampling 297/1000ml at 0.45ml/s with 19.3psi vacuum @17:27:14.06 Cartridge 52 sampling 326/1000ml at 0.45ml/s with 20.2psi vacuum @17:28:14.06 Cartridge 52 sampling 355/1000ml at 0.49ml/s with 24.4psi vacuum @17:29:14.06 Cartridge 52 sampling 384/1000ml at 0.46ml/s with 20.4psi vacuum @17:30:14.06 Cartridge 52 sampling 413/1000ml at 0.49ml/s with 17.7psi vacuum @17:31:14.06 Cartridge 52 sampling 442/1000ml at 0.47ml/s with 17.1psi vacuum @17:32:14.06 Cartridge 52 sampling 470/1000ml at 0.44ml/s with 26.3psi vacuum @17:33:14.32 Cartridge 52 sampling 499/1000ml at 0.50ml/s with 21.6psi vacuum @17:34:14.07 Cartridge 52 sampling 527/1000ml at 0.47ml/s with 17.8psi vacuum @17:35:14.07 Cartridge 52 sampling 555/1000ml at 0.45ml/s with 26.9psi vacuum @17:36:14.07 Cartridge 52 sampling 582/1000ml at 0.47ml/s with 25.0psi vacuum @17:37:14.07 Cartridge 52 sampling 609/1000ml at 0.46ml/s with 25.1psi vacuum @17:38:14.07 Cartridge 52 sampling 635/1000ml at 0.46ml/s with 24.7psi vacuum @17:39:14.07 Cartridge 52 sampling 661/1000ml at 0.39ml/s with 20.6psi vacuum @17:40:14.06 Cartridge 52 sampling 686/1000ml at 0.40ml/s with 24.3psi vacuum @17:41:14.06 Cartridge 52 sampling 710/1000ml at 0.41ml/s with 24.9psi vacuum @17:42:14.06 Cartridge 52 sampling 734/1000ml at 0.37ml/s with 21.9psi vacuum @17:43:14.06 Cartridge 52 sampling 759/1000ml at 0.40ml/s with 25.1psi vacuum @17:44:14.06 Cartridge 52 sampling 783/1000ml at 0.39ml/s with 16.0psi vacuum @17:45:14.06 Cartridge 52 sampling 807/1000ml at 0.43ml/s with 23.6psi vacuum @17:46:14.06 Cartridge 52 sampling 831/1000ml at 0.43ml/s with 24.1psi vacuum @17:47:14.06 Cartridge 52 sampling 854/1000ml at 0.39ml/s with 17.3psi vacuum @17:48:14.06 Cartridge 52 sampling 878/1000ml at 0.42ml/s with 23.1psi vacuum @17:49:14.06 Cartridge 52 sampling 902/1000ml at 0.40ml/s with 18.7psi vacuum @17:50:14.06 Cartridge 52 sampling 925/1000ml at 0.37ml/s with 26.7psi vacuum @17:51:14.06 Cartridge 52 sampling 949/1000ml at 0.39ml/s with 16.3psi vacuum -39.0m deep (-42.9psia) @17:52:14.06 Cartridge 52 sampling 972/1000ml at 0.37ml/s with 21.7psi vacuum @17:53:14.06 Cartridge 52 sampling 995/1000ml at 0.39ml/s with 24.3psi vacuum @17:53:30.38 Intake.close @17:53:30.43 Exhaust.close @17:53:31.14 Sampled 1000.0ml @17:53:31.23 TV.seek :bypass @17:53:32.85 TV.seek :clear @17:53:35.16 -> Cmd.startProcessing @17:53:36.96 SPR.command "read_sequences" @17:53:37.00 SPR.command "stats_on" @17:53:37.78 SPR.command "start 2 0" @17:53:39.78 Begun log /var/log/esp/spr18aug0317h.spr @17:53:40.82 AnalyticModule::ReadTimeout in PROCESSING -- No response from SPR on AMspr (try 1 of 3) @17:53:42.51 Handoff.select :waste @17:53:42.63 ArS.seek empty @17:54:00.37 PinPort.seek :cartridge @17:54:06.08 LyS1.seek 1350ul @17:54:12.03 PV.seek :reagent @17:54:12.87 AirS.seek :tVent @17:54:14.95 delay 2 seconds @17:54:16.97 AirS.reconfigure EvacAirS @17:54:17.04 AirS.seek :evac @17:54:39.35 delay 15 seconds @17:54:54.38 AirS.reconfigure AirSconfig @17:54:54.45 AirS.seek :tVent @17:55:08.66 delay 2 seconds @17:55:10.69 AirS.reconfigure EvacAirS @17:55:10.75 AirS.seek :evac @17:55:33.06 delay 15 seconds @17:55:48.09 AirS.reconfigure AirSconfig @17:55:48.15 AirS.seek :tVent @17:56:02.38 delay 2 seconds @17:56:04.40 AirS.reconfigure EvacAirS @17:56:04.46 AirS.seek :evac @17:56:26.76 delay 15 seconds @17:56:41.79 AirS.reconfigure AirSconfig @17:56:41.85 AirS.seek :tVent @17:56:56.06 delay 2 seconds @17:56:58.09 AirS.reconfigure EvacAirS @17:56:58.15 AirS.seek :evac @17:57:20.45 delay 15 seconds @17:57:35.48 AirS.reconfigure AirSconfig @17:57:35.54 AirS.seek :tVent @17:57:49.75 delay 2 seconds @17:57:51.78 AirS.reconfigure EvacAirS @17:57:51.84 AirS.seek :evac @17:58:14.14 delay 15 seconds @17:58:29.17 delay 1:30 @17:59:59.19 AirS.reconfigure AirSconfig @17:59:59.27 AirS.seek :fVent @18:00:00.70 delay 15 seconds @18:00:15.73 LyS1.reconfigure SlowLyS1 @18:00:15.85 LyS1.seek 1050ul @18:00:45.94 delay 5 seconds @18:00:50.95 Handoff.select :blocked @18:00:51.12 LyS1.seek 450ul @18:01:51.10 delay 10 seconds @18:02:01.13 AirS.reconfigure SlowAirS @18:02:01.24 AirS.reconfigure to mix into 1.37806 parts LyS1 @18:02:01.58 AirS.seek evac @18:02:01.64 LyS1.seek 300ul @18:02:16.72 AirS.reconfigure AirSconfig @18:02:16.78 AirS.seek :full @18:02:31.00 LyS1.seek :empty @18:03:01.09 PuckHeater.seek 86.3C @18:04:06.48 PuckHeater.hold 15:00,86.3C @18:19:07.15 LyS1.reconfigure LyS1config @18:19:07.22 LyS1.seek 900ul @18:19:15.56 AirS.seek :tVent @18:19:15.64 delay 2 seconds @18:19:17.66 AirS.reconfigure HalfSpeedAirS @18:19:17.72 AirS.seek :evac @18:19:45.47 delay 15 seconds @18:20:00.75 AirS.reconfigure AirSconfig @18:20:00.81 AirS.seek :tVent @18:20:15.02 delay 2 seconds @18:20:17.05 AirS.reconfigure HalfSpeedAirS @18:20:17.13 AirS.seek :evac @18:20:44.88 delay 15 seconds @18:20:59.91 AirS.reconfigure AirSconfig @18:20:59.97 AirS.seek :tVent @18:21:14.18 delay 2 seconds @18:21:16.21 AirS.reconfigure HalfSpeedAirS @18:21:16.27 AirS.seek :evac @18:21:44.02 delay 15 seconds @18:21:59.05 delay 1:00 @18:22:59.06 Handoff.select :waste @18:22:59.18 delay 15 seconds @18:23:14.20 AirS.seek :fVent @18:23:16.40 delay 10 seconds @18:23:26.43 AirS.reconfigure AirSconfig @18:23:26.48 AirS.seek :evac @18:23:27.91 Lysis Recovered in LyS1 @18:23:27.92 Lysis Complete @18:23:27.94 Handoff.select :waste @18:23:27.97 LyS2.seek :full @18:23:28.06 LyS1.reconfigure DAmixLyS1 @18:23:28.11 LyS2.reconfigure DAmixLyS2 @18:23:28.57 LyS2.seek 1480ul @18:23:28.61 LyS1.seek 650ul @18:24:15.94 delay 5 seconds @18:24:20.96 Handoff.select :SPR @18:24:21.08 SPR.command "start 1 14" @18:24:22.62 Running Experiment-Rep #1 @18:24:22.64 delay 10 seconds @18:24:32.65 SPR.command "start 1 0" @18:24:35.51 Waiting up to 4:00 for SPR to enter state 1 @18:26:39.77 SPR.command "hold_on" @18:26:41.52 LyS2.seek 1130ul @18:26:41.56 LyS1.seek 300ul @18:27:47.76 delay 15 seconds @18:28:02.78 SPR.command "hold_off" @18:28:05.48 Waiting up to 25:00 for SPR to enter state 7 @18:48:09.86 Handoff.select :waste @18:48:09.99 LyS1.reconfigure LyS1config @18:48:10.05 LyS2.reconfigure LyS2config @18:48:10.36 Rep #1 SPR Analysis has Completed @18:48:10.80 Ended log /var/log/esp/spr18aug0317h.spr @18:48:10.82 SPR.command "stats_off" @18:48:12.75 -> Cmd.stop @18:48:12.84 Handoff.select :close @18:48:13.02 Gate.power :heat,:OFF @18:48:13.04 Gate.power :cartridge,:OFF @18:48:13.07 PV.seek :locked @18:48:13.96 PinPort.seek :clear @18:48:19.74 ArS.seek :clear @18:48:19.87 LyS1.seek :clear @18:48:20.00 LyS2.seek :clear @18:48:20.13 AirS.seek :clear @18:48:37.50 ArS.coast @18:48:37.55 LyS1.coast @18:48:37.60 LyS2.coast @18:48:37.65 AirS.coast @18:48:37.70 TV.coast @18:48:37.75 SP.coast @18:48:37.80 SC.coast @18:48:37.86 PV.coast @18:48:37.91 PinPort.coast @18:48:38.09 Gate.power :motor,:OFF @18:48:38.10 Gate.power :main,:OFF @18:48:38.12 Gate.power :core,:OFF @18:48:38.14 Gate.power :analytic1,:OFF @18:48:38.16 Gate.power :analytic2,:OFF @18:48:38.19 Gate.power :analytic3,:OFF @18:48:38.21 Safely stopped and ready to power off