@16:38:46.98PDT19-Jul-19
>BREAK< ESP3 Gateway v0.99 for core bus @16:38:47.04 >BREAK< ESP3 Gateway v0.99 for cartridge bus @16:38:53.97 Configuration for honu by brent@mbari.org 4/4/19 /home/esp/esp2/type/auv/honu/configure.rb @16:38:57.42 Polling Can every 5:00 @16:38:57.81 Clients may connect on TCP port 9999 @16:38:57.82 Connecting to 10.89.5.2:9999 @16:38:57.87 Waiting for espclients... @16:38:58.31 Session Begun @16:39:00.66 -> showStatus @16:39:02.27 -> Cmd.loadCartridge -9 @16:39:02.48 Gate.power :main,:ON,limit to 5000mA @16:39:02.50 Gate.power :analytic1,:ON,limit to 5000mA @16:39:02.53 Gate.power :analytic2,:ON,limit to 5000mA @16:39:02.57 Gate.power :analytic3,:ON,limit to 5000mA @16:39:02.77 Powering core bus @16:39:05.01 SPR Module 1, FW Rev. B, FPGA Rev. C @16:39:05.24 Archive.configure :default @16:39:05.78 Air.configure :default @16:39:05.93 Lysis1.configure :default @16:39:06.07 Lysis2.configure :default @16:39:06.26 Plunge.configure :default @16:39:06.45 SamplePump.configure :default @16:39:06.64 ExtraPump.configure :default @16:39:06.82 Toroid.configure :default @16:39:06.99 Carousel.configure :default @16:39:07.18 Pressure.configure :default @16:39:07.35 PinPort.configure :default @16:39:07.44 All elf controllers running firmware version 4.58 @16:39:07.48 Gate.power :motor,:ON,limit to 5000mA @16:39:07.85 Archive.reconfigure :default @16:39:08.16 Archive.home.jog 0 @16:39:08.44 PinPort.reconfigure :default @16:39:08.47 Toroid.reconfigure :default @16:39:08.51 Plunge.reconfigure :default @16:39:08.57 Lysis2.reconfigure :default @16:39:08.65 Air.reconfigure :default @16:39:08.75 Lysis1.reconfigure :default @16:39:09.15 Air.home.jog 0 @16:39:09.23 PinPort.home.jog 0 @16:39:09.44 Toroid.home.jog 0 @16:39:09.60 Lysis1.home.jog 0 @16:39:09.76 Lysis2.home.jog 0 @16:39:09.98 Plunge.home.jog 0 @16:39:10.81 Archive.reconfigure :homing @16:39:11.38 Archive.jog 1348 @16:39:11.83 PinPort.reconfigure :homing @16:39:11.95 Toroid.reconfigure :homing @16:39:12.07 Lysis2.reconfigure :homing @16:39:12.19 Air.reconfigure :homing @16:39:12.31 Lysis1.reconfigure :homing @16:39:12.45 Plunge.reconfigure :homing @16:39:13.20 Plunge.jog 1543 @16:39:13.38 Lysis1.jog 1403 @16:39:13.54 Air.jog 1403 @16:39:13.72 Lysis2.jog 162 @16:39:13.93 PinPort.jog -109 @16:39:14.17 Toroid.jog 634 @16:39:14.53 Plunge.setRawPosition! 50 @16:39:14.63 Lysis2.setRawPosition! 50 @16:39:14.71 Archive.setRawPosition! 50 @16:39:14.81 PinPort.setRawPosition! 0 @16:39:15.19 Plunge.seek :home @16:39:15.35 Lysis2.seek :home @16:39:15.43 Archive.seek :home @16:39:15.53 PinPort.seek :home @16:39:16.10 Lysis2.reconfigure :default @16:39:16.19 Air.setRawPosition! 50 @16:39:16.25 PinPort.reconfigure :default @16:39:16.28 Lysis1.setRawPosition! 50 @16:39:16.51 Air.seek :home @16:39:16.58 Lysis1.seek :home @16:39:16.82 Toroid.setRawPosition! 0 @16:39:16.87 Plunge.reconfigure :default @16:39:16.91 Archive.reconfigure :default @16:39:17.11 Toroid.seek :home @16:39:17.34 Lysis1.reconfigure :default @16:39:17.40 Air.reconfigure :default @16:39:17.44 Toroid.reconfigure :default @16:39:18.05 Toroid.seek :clear @16:39:19.78 Carousel.reconfigure :default @16:39:20.05 Carousel.home.jog 0 @16:39:20.82 Carousel.seek 40 @16:39:21.37 Selecting Cartridge 45 @16:39:22.07 Carousel.seek 45 @16:39:23.68 Lysis1.seek :locked @16:39:21.32 Plunge.seek :locked @16:39:21.52 Air.seek :locked @16:39:25.69 Powering cartridge bus @16:39:27.84 Gate.setIR 1750,5000,0,6 @16:39:27.97 Gate.setIR 0,5000,0,6 @16:39:28.06 Loaded Lyse-n-Go Cartridge @16:39:28.07 PuckHeater.configure HeatConfig @16:39:28.15 Gate.power :heat,:ON,limit to 5000mA @16:39:34.23 -> Cmd.startFiltering @16:39:34.60 Duration of filtering limited to 2:05:00 @16:39:34.99 Priming sample loop w/100ml, bypass w/10ml @16:39:35.02 SamplePump.setPosition! 0ml @16:39:35.10 Bypass.open @16:39:36.72 Intake.open @16:39:37.12 Waiting up to 20 seconds for sea pressure to stabilize +/-0.50psi @16:39:40.16 Vacuum tare is 52% of full scale @16:39:40.36 Pressure.reconfigure :default @16:39:40.45 Pressure.hold @16:39:40.72 SamplePump.reconfigure :prime @16:39:40.83 SamplePump.seek 10ml,1:10 @16:39:49.82 Pressure.coast @16:39:49.89 SamplePump.setPosition! 0ml @16:39:49.96 Exhaust.open @16:39:51.46 Bypass.close @16:39:53.06 Pressure.reconfigure :default @16:39:53.15 Pressure.hold @16:39:54.03 SamplePump.reconfigure :prime @16:39:54.15 SamplePump.seek 100ml,7:10 @16:41:36.93 Pressure.coast @16:41:37.02 Bypass.open @16:41:37.81 Intake.close @16:41:38.70 Toroid.reconfigure :hold @16:41:38.80 Toroid.seek :crack @16:41:39.63 Toroid.reconfigure :default @16:41:39.74 Toroid.seek :clear @16:41:41.37 Toroid.reconfigure :hold @16:41:41.48 Toroid.seek :cartridge @16:41:43.32 Toroid.reconfigure :default @16:41:43.43 Toroid.seek :clear @16:41:45.53 Pressurizing cartridge to 14psi above 12.8psia @16:41:45.54 SamplePump.setPosition! 0ml @16:41:45.61 Intake.open @16:41:45.87 Bypass.close @16:41:46.63 Exhaust.close @16:41:47.53 Pressure.reconfigure :default @16:41:47.62 Pressure.hold @16:41:47.88 SamplePump.reconfigure :charge @16:41:48.00 SamplePump.seek 2.3ml,41 seconds @16:42:00.19 Pressure.coast @16:42:00.27 Intake.close @16:42:01.11 Pressurized cartridge with 0.692ml to 14.2psi @16:42:01.12 Isolated @26.7psia (13.9psi) @16:42:01.14 Checking for cartridge leaks from 26.7psia @16:42:01.19 Waiting up to 20 seconds for cartridge pressure to stabilize +/-0.75psi @16:42:06.62 Sampling 1000.0ml @16:42:06.64 SamplePump.setPosition! 0ml @16:42:06.73 Exhaust.open @16:42:07.47 Intake.open @16:42:07.86 Pressure.reconfigure :default @16:42:07.95 Pressure.hold @16:42:08.29 SamplePump.reconfigure :sample @16:42:08.40 SamplePump.seek 1000ml,1:07:09 @16:42:10.90 Cartridge 45 sampling 1/1000ml at 0.42ml/s with 10.3psi vacuum @16:43:10.91 Cartridge 45 sampling 26/1000ml at 0.41ml/s with 13.5psi vacuum @16:44:10.91 Cartridge 45 sampling 50/1000ml at 0.41ml/s with 11.2psi vacuum @16:45:10.91 Cartridge 45 sampling 73/1000ml at 0.39ml/s with 13.5psi vacuum @16:46:10.91 Cartridge 45 sampling 96/1000ml at 0.34ml/s with 13.5psi vacuum @16:47:10.92 Cartridge 45 sampling 117/1000ml at 0.35ml/s with 14.0psi vacuum @16:48:10.92 Cartridge 45 sampling 138/1000ml at 0.34ml/s with 14.1psi vacuum @16:49:10.91 Cartridge 45 sampling 158/1000ml at 0.32ml/s with 14.1psi vacuum @16:50:10.92 Cartridge 45 sampling 177/1000ml at 0.33ml/s with 14.5psi vacuum @16:51:10.93 Cartridge 45 sampling 196/1000ml at 0.29ml/s with 13.4psi vacuum @16:52:10.92 Cartridge 45 sampling 214/1000ml at 0.28ml/s with 13.8psi vacuum @16:53:10.92 Cartridge 45 sampling 231/1000ml at 0.29ml/s with 13.8psi vacuum @16:54:10.90 Cartridge 45 sampling 248/1000ml at 0.27ml/s with 14.1psi vacuum @16:55:10.92 Cartridge 45 sampling 264/1000ml at 0.25ml/s with 11.0psi vacuum @16:56:10.92 Cartridge 45 sampling 280/1000ml at 0.25ml/s with 13.1psi vacuum @16:57:10.92 Cartridge 45 sampling 295/1000ml at 0.25ml/s with 14.1psi vacuum @16:58:10.90 Cartridge 45 sampling 311/1000ml at 0.25ml/s with 15.6psi vacuum @16:58:51.88 Flow averaged 0.32ml/s over 16:41 @16:58:51.94 Waiting up to 7 seconds for vacuum to reduce from 14.5 to 10.0psi @16:58:52.74 Relieved excess vacuum in 4.1 seconds @16:58:52.78 SamplePump.seek 1000ml,45:46 @16:59:02.73 Flow estimate reduced to 0.26ml/s @16:59:02.80 Waiting up to 8 seconds for vacuum to reduce from 15.0 to 10.0psi @16:59:03.56 Relieved excess vacuum in 7.7 seconds @16:59:03.61 SamplePump.seek 1000ml,45:36 @16:59:10.89 Cartridge 45 sampling 325/1000ml at 0.25ml/s with 14.4psi vacuum @17:00:02.32 Flow averaged 0.26ml/s over 58 seconds @17:00:02.36 Waiting up to 7 seconds for vacuum to reduce from 14.8 to 10.0psi @17:00:03.18 Relieved excess vacuum in 2.1 seconds @17:00:03.22 SamplePump.seek 1000ml,44:37 @17:00:08.54 Flow estimate reduced to 0.21ml/s @17:00:08.56 Intake.close @17:00:08.65 Exhaust.close @17:00:08.92 Toroid.reconfigure :hold @17:00:09.02 Toroid.seek :bypass @17:00:10.68 Toroid.reconfigure :default @17:00:10.78 Toroid.seek :clear @17:00:11.01 Cartridge 45 sampling 340/1000ml at 0.00ml/s with 4.0psi vacuum @17:00:12.44 Cartridge::Sampler::Clogged in FILTERING -- Cartridge clogged @17:00:12.46 Pressure.coast @17:00:12.75 Sampled 339.5ml @17:00:14.65 -> Cmd.startProcessing @17:00:17.20 SPR.command "read_sequences" @17:00:17.80 SPR.command "stats_on" @17:00:17.86 SPR.command "start 0 1" @17:00:19.86 Begun log /var/log/esp/spr19jul1917h.spr @17:00:20.65 Handoff.select :waste @17:00:20.84 Archive.seek :empty @17:00:28.48 Syringe tare is 19% of full scale @17:00:38.67 PinPort.seek :cartridge @17:00:43.26 Lysis1.seek 1350ul @17:00:45.79 Lysis2.seek 1700ul @17:00:48.91 Plunge.seek :reagent @17:00:49.81 Evacuating puck with filter bubble point of 30psi @17:00:49.83 PinPort.seek :cartridge @17:00:49.96 Handoff.select :waste @17:00:57.71 Air pumping 1 strokes to reach 4psi @17:00:57.73 Air.reconfigure :gulp @17:00:57.85 Air.seek :tVent @17:00:59.70 0.1psi after gulp @17:00:59.71 Air stroke #1 of 1 @17:00:59.75 Air.reconfigure :pressurize @17:00:59.89 Air.seek :pressurized @17:01:12.79 0.1psi after pressurize @17:01:12.81 Air.reconfigure :compress @17:01:12.93 Air.seek :evac @17:01:15.66 0.2psi after compress @17:01:30.29 0.2psi after compress (stable) @17:01:30.48 at 0.2psi Opened to waste @17:01:30.49 Handoff.select :blocked @17:01:30.72 Air pumping 10 strokes to reach 30psi @17:01:30.75 Air.reconfigure :gulp @17:01:30.86 Air.seek :tVent @17:01:40.81 1.9psi after gulp @17:01:40.82 Air stroke #1 of 10 @17:01:40.87 Air.reconfigure :pressurize @17:01:40.98 Air.seek :pressurized @17:01:53.91 3.3psi after pressurize @17:01:53.94 Air.reconfigure :compress @17:01:54.05 Air.seek :evac @17:01:56.79 3.6psi after compress @17:03:14.90 25.2psi after compress (stable) @17:03:14.93 Air.reconfigure :gulp @17:03:15.05 Air.seek :tVent @17:03:25.03 27.2psi after gulp @17:03:25.04 Air stroke #2 of 10 @17:03:25.08 Air.reconfigure :pressurize @17:03:25.19 Air.seek :pressurized @17:03:38.09 26.9psi after pressurize @17:03:38.12 Air.reconfigure :compress @17:03:38.23 Air.seek :evac @17:03:40.97 26.1psi after compress @17:03:52.14 Reached 30.3 of 30.0psi after pumping 4672ul (3.00 strokes) @17:03:52.15 Handoff.select :waste @17:04:00.54 delay 1:00 @17:05:00.59 Handoff.select :blocked @17:05:06.10 Pressure too High, open to waste again (4.3psi) @17:05:06.12 Handoff.select :waste @17:05:06.29 delay 1:00 @17:06:06.32 Handoff.select :blocked @17:06:35.63 Handoff.select :waste @17:06:35.80 PSI at @3.68psi at evacEnd @17:06:35.81 Handoff.select :blocked @17:06:35.98 Air.reconfigure :gulp @17:06:36.09 Air.seek :tVent @17:06:53.60 Stable @2.9psi after Handoff blocked @17:06:53.74 Air pumping 10 strokes to reach 28psi @17:06:53.76 Air stroke #1 of 10 @17:06:53.79 Air.reconfigure :pressurize @17:06:53.90 Air.seek :pressurized @17:07:07.35 3.5psi after pressurize @17:07:07.39 Air.reconfigure :compress @17:07:07.50 Air.seek :evac @17:07:10.22 4.1psi after compress @17:07:44.51 13.9psi after compress (stable) @17:07:44.54 Air.reconfigure :gulp @17:07:44.65 Air.seek :tVent @17:07:54.63 14.8psi after gulp @17:07:54.64 Air stroke #2 of 10 @17:07:54.69 Air.reconfigure :pressurize @17:07:54.80 Air.seek :pressurized @17:08:07.68 14.8psi after pressurize @17:08:07.71 Air.reconfigure :compress @17:08:07.82 Air.seek :evac @17:08:10.55 15.2psi after compress @17:08:43.25 24.1psi after compress (stable) @17:08:43.29 Air.reconfigure :gulp @17:08:43.42 Air.seek :tVent @17:08:53.39 24.9psi after gulp @17:08:53.40 Air stroke #3 of 10 @17:08:53.44 Air.reconfigure :pressurize @17:08:53.55 Air.seek :pressurized @17:09:06.45 24.8psi after pressurize @17:09:06.48 Air.reconfigure :compress @17:09:06.60 Air.seek :evac @17:09:09.31 25.0psi after compress @17:09:14.80 Reached 28.0 of 27.9psi after pumping 6230ul (4.00 strokes) @17:09:14.81 Handoff.select :waste @17:09:22.63 delay 1:00 @17:10:22.66 Handoff.select :blocked @17:10:49.06 Handoff.select :waste @17:10:49.21 PSI at @2.22psi at evacEnd @17:10:49.23 Air.reconfigure :default @17:10:49.34 Air.seek :fVent @17:10:50.81 delay 5 seconds @17:10:55.83 Seawater evacuated, Presure above/below filter released. Lysis begins @17:10:55.94 Lysis1.reconfigure :slow @17:10:56.05 Lysis1.seek 1050ul @17:11:26.13 delay 5 seconds @17:11:31.15 Handoff.select :blocked @17:11:31.37 Lysis1.seek 450ul @17:12:31.40 delay 3 seconds @17:12:34.51 Air.reconfigure to mix into 1.37806 parts Lysis1 @17:12:35.12 Air.seek :evac @17:12:35.23 Lysis1.seek 300ul @17:12:50.35 Air.reconfigure :default @17:12:50.45 Air.seek :full @17:13:04.69 Lysis1.seek :empty @17:13:34.86 Lysis Delivered. Syringe pressure @49.7psi @17:13:34.95 PuckHeater.seek 84.4C @17:14:29.96 PuckHeater.hold 15:00,84.4C @17:29:27.64 Lysis complete. Syringe pressure @58.6psi @17:29:27.65 Handoff.select :blocked @17:29:27.82 Lysis1.reconfigure :halfSpeed @17:29:27.92 Lysis1.seek 200ul @17:29:31.73 delay 1 second @17:29:32.77 Lysis1.seek :empty @17:29:36.69 Initial AirS pressure @59.5psi @17:29:36.78 Lysis1.reconfigure :extract @17:29:36.91 Lysis1.seek 875ul,10:00 @17:29:38.29 Air pumping 10 strokes to reach 21psi @17:29:38.30 Air stroke #1 of 10 @17:29:38.35 Air.reconfigure :pressurize @17:29:38.56 Air.seek :pressurized @17:29:51.45 15.6psi after pressurize @17:29:51.49 Air.reconfigure :compress @17:29:51.60 Air.seek :evac @17:29:54.33 17.3psi after compress @17:30:08.91 15.9psi after compress (stable) @17:30:08.95 Air.reconfigure :gulp @17:30:09.07 Air.seek :tVent @17:30:19.02 15.8psi after gulp @17:30:19.04 Air stroke #2 of 10 @17:30:19.08 Air.reconfigure :pressurize @17:30:19.21 Air.seek :pressurized @17:30:32.10 15.8psi after pressurize @17:30:32.13 Air.reconfigure :compress @17:30:32.25 Air.seek :evac @17:30:34.98 16.3psi after compress @17:30:49.63 15.8psi after compress (stable) @17:30:49.65 Air.reconfigure :gulp @17:30:49.77 Air.seek :tVent @17:30:59.72 15.5psi after gulp @17:30:59.74 Air stroke #3 of 10 @17:30:59.79 Air.reconfigure :pressurize @17:30:59.93 Air.seek :pressurized @17:31:12.82 15.7psi after pressurize @17:31:12.85 Air.reconfigure :compress @17:31:12.96 Air.seek :evac @17:31:15.66 16.4psi after compress @17:31:30.86 15.7psi after compress (stable) @17:31:30.89 Air.reconfigure :gulp @17:31:31.02 Air.seek :tVent @17:31:40.98 16.3psi after gulp @17:31:41.00 Air stroke #4 of 10 @17:31:41.04 Air.reconfigure :pressurize @17:31:41.15 Air.seek :pressurized @17:31:54.05 15.7psi after pressurize @17:31:54.07 Air.reconfigure :compress @17:31:54.19 Air.seek :evac @17:31:56.92 16.2psi after compress @17:32:08.68 Air.reconfigure :default @17:32:08.75 Air.hold @17:32:09.06 Lysis1 at 875ul pressure @15.8psi @17:32:09.10 Lysis1.reconfigure :default @17:32:09.20 Lysis1.seek 900ul @17:32:10.05 Lysis1 at 900ul pressure(finPSI) @10.6psi @17:32:10.07 delay 1 second @17:32:11.24 Lysis1 at 900ul pressure @12.1psi @17:32:11.26 Air.reconfigure :halfSpeed @17:32:11.40 Air.seek :fVent @17:32:13.71 Puck Top Vented. Syringe pressure @2.0psi @17:32:13.72 Handoff.select :waste @17:32:13.90 delay 5 seconds @17:32:18.93 Lysate Recovered in LyS1 @17:32:18.95 Lysis1.reconfigure :DAmix @17:32:19.11 Lysis2.reconfigure :DAmix @17:32:19.77 Lysis1.seek 650ul @17:32:19.89 Lysis2.seek 1450ul @17:32:54.96 delay 5 seconds @17:32:59.98 Handoff.select SPR @17:33:00.13 SPR.command "start 2 14" @17:33:01.52 delay 10 seconds @17:33:11.55 SPR.command "start 1 0" @17:33:14.71 Waiting up to 4:00 for SPR to enter state 1 @17:35:47.37 SPR.command "hold_on" @17:35:48.78 SPR Dilution 1 of 1 -- Running Experiment 1 @17:35:49.42 Lysis1.seek 350ul @17:35:49.46 Lysis2.seek 1150ul @17:36:31.56 volL1 = 300.0 and volL2 = 300.0 @17:36:31.58 delay 15 seconds @17:36:46.61 SPR.command "hold_off" @17:36:49.42 Waiting up to 25:00 for SPR to enter state 7 @17:57:03.31 SPR Analysis has Completed @17:57:03.32 Handoff.select :waste @17:57:04.23 Ended log /var/log/esp/spr19jul1917h.spr @17:57:04.25 SPR.command "stats_off" @17:57:05.71 -> Cmd.stop @17:57:05.85 Handoff.select :close @17:57:06.02 Gate.power :heat,:OFF @17:57:06.05 Gate.power :cartridge,:OFF @17:57:06.16 Carousel.seek 45 @17:57:06.44 Plunge.seek :locked @17:57:07.30 PinPort.seek :clear @17:57:11.99 Archive.seek :clear @17:57:12.18 Air.reconfigure :default @17:57:12.39 Lysis1.reconfigure :default @17:57:12.58 Lysis1.seek :clear @17:57:12.66 Air.seek :clear @17:57:12.80 Lysis2.reconfigure :default @17:57:12.90 Lysis2.seek :clear @17:57:29.85 Archive.coast @17:57:29.93 Air.coast @17:57:30.01 Lysis1.coast @17:57:30.08 Lysis2.coast @17:57:30.15 Plunge.coast @17:57:30.23 SamplePump.coast @17:57:30.31 Toroid.coast @17:57:30.40 Carousel.coast @17:57:30.48 PinPort.coast @17:57:30.71 Gate.power :motor,:OFF @17:57:30.73 Gate.power :core,:OFF @17:57:30.76 Gate.power :analytic1,:OFF @17:57:30.80 Gate.power :analytic2,:OFF @17:57:30.83 Gate.power :analytic3,:OFF @17:57:30.86 Gate.power :main,:OFF @17:57:30.90 Safely stopped and ready to power off