@22:51:38.25PDT03-Jun-22
>BREAK< ESP3 Gateway v1.12 for core bus @22:51:38.28 >BREAK< ESP3 Gateway v1.12 for cartridge bus @22:51:40.93 Configuration for honu by methane@mbari.org 3/16/22 /home/esp/esp2/type/auv/honu/configure.rb @22:51:52.96 Polling Can every 2:00 @22:51:53.47 Clients may connect on TCP port 9999 @22:51:53.50 Connecting to 10.89.5.2:9999 @22:51:53.54 Waiting for espclients... @22:51:53.96 Session Begun @22:51:55.89 -> showStatus true @22:51:57.92 -> Cmd.loadCartridge -10 @22:51:57.98 Gate.power :main,:ON,limit to 5000mA @22:51:58.00 Gate.power :analytic1,:ON,limit to 5000mA @22:51:58.02 Gate.power :analytic2,:ON,limit to 5000mA @22:51:58.04 Gate.power :analytic3,:ON,limit to 5000mA @22:51:58.20 Powering core bus @22:52:00.46 SPR Module 1, FW Rev. B, FPGA Rev. C @22:52:01.14 Archive.configure :default @22:52:01.43 Air.configure :default @22:52:01.70 Lysis1.configure :default @22:52:01.84 Lysis2.configure :default @22:52:01.96 Plunge.configure :default @22:52:02.09 SamplePump.configure :default @22:52:02.22 Toroid.configure :default @22:52:02.34 Carousel.configure :default @22:52:02.47 Pressure.configure :default @22:52:02.59 ExtraPump.configure :default @22:52:02.70 PinPort.configure :default @22:52:02.76 All elf controllers running firmware version 4.79 @22:52:02.78 Gate.power :motor,:ON,limit to 5000mA @22:52:03.00 Archive.in :default @22:52:03.26 Archive.home.jog 0 @22:52:03.42 Toroid.in :default @22:52:03.50 Plunge.in :default @22:52:03.53 Lysis1.in :default @22:52:03.63 PinPort.in :default @22:52:03.69 Air.in :default @22:52:03.73 Lysis2.in :default @22:52:03.91 Toroid.home.jog 0 @22:52:03.95 Plunge.home.jog 0 @22:52:03.97 Lysis1.home.jog 0 @22:52:04.00 PinPort.home.jog 0 @22:52:04.02 Air.home.jog 0 @22:52:04.06 Lysis2.home.jog 0 @22:52:04.45 Archive.in :homing @22:52:04.63 Toroid.in :homing @22:52:04.67 Plunge.in :homing @22:52:04.73 Archive.jog 1387 @22:52:04.80 PinPort.in :homing @22:52:04.84 Lysis1.in :homing @22:52:04.97 Plunge.jog 1552 @22:52:05.05 Toroid.jog 624 @22:52:05.14 PinPort.jog -108 @22:52:05.17 Lysis1.jog 1381 @22:52:05.34 Air.in :homing @22:52:05.36 Lysis2.in :homing @22:52:05.46 Lysis2.jog 1389 @22:52:05.50 Air.jog 1387 @22:52:05.60 PinPort.setRawPosition! 0 @22:52:05.64 PinPort.seek :home @22:52:05.73 PinPort.in :default @22:52:06.08 Archive.setRawPosition! 50 @22:52:06.13 Archive.seek :home @22:52:06.25 Plunge.setRawPosition! 50 @22:52:06.30 Plunge.seek :home @22:52:06.41 Lysis1.setRawPosition! 50 @22:52:06.43 Archive.in :default @22:52:06.50 Lysis1.seek :home @22:52:06.64 Plunge.in :default @22:52:06.74 Lysis2.setRawPosition! 50 @22:52:06.76 Air.setRawPosition! 50 @22:52:06.85 Air.seek :home @22:52:06.88 Lysis2.seek :home @22:52:07.02 Lysis1.in :default @22:52:07.17 Air.in :default @22:52:07.26 Lysis2.in :default @22:52:07.34 Toroid.setRawPosition! 0 @22:52:07.39 Toroid.seek :home @22:52:07.48 Toroid.in :default @22:52:07.65 Toroid.seek :clear @22:52:09.27 Carousel.in :default @22:52:09.33 Carousel.home.jog 0 @22:52:09.81 Carousel.in :default @22:52:09.87 Carousel.seek 28 @22:52:10.03 Selecting Cartridge 27 @22:52:10.68 Carousel.seek 27 @22:52:11.16 Lysis1.in :fast @22:52:11.22 Lysis1.seek :locked @22:52:13.83 Plunge.seek :locked @22:52:13.96 Air.in :fast @22:52:14.02 Air.seek :locked @22:52:16.48 Powering cartridge bus @22:52:19.07 Gate.setIR 1750,5000,0,6 @22:52:19.19 Gate.setIR 0,5000,0,6 @22:52:19.25 PuckHeater.configure :default @22:52:19.31 Gate.power :heat,:ON,limit to 5000mA @22:52:19.98 Mounted lysis Cartridge board#Q05054 @22:52:20.01 Using default puck heat loss curve for HeatingAccelInCarousel 27 @22:52:38.34 -> Cmd.startFiltering @22:52:38.58 92.07Preparing to filter cartridge 27 @22:52:38.58 92.07Preparing to filter cartridge 27 @22:52:38.85 Priming sample loop w/100ml, bypass w/10ml @22:52:38.86 SamplePump.setPosition! 0ml @22:52:38.91 Bypass.open @22:52:40.34 Intake.open @22:52:41.10 Sea 8.3m deep (26.9psia) @22:52:41.12 Waiting up to 20 seconds for sea pressure to stabilize +/-0.50psi @22:52:43.69 Vacuum tare is 54% of full scale @22:52:43.83 Pressure.in :default @22:52:43.89 Pressure.hold @22:52:44.06 SamplePump.in :prime @22:52:44.13 SamplePump.seek 10ml,59 seconds @22:52:52.74 Pressure.stop @22:52:52.79 SamplePump.setPosition! 0ml @22:52:52.85 Exhaust.open @22:52:54.29 Bypass.close @22:52:55.78 Pressure.in :default @22:52:55.84 Pressure.hold @22:52:55.95 Sea 8.4m deep (27.2psia) @22:52:56.14 SamplePump.in :prime @22:52:56.20 SamplePump.seek 100ml,5:16 @22:54:29.15 Pressure.stop @22:54:29.21 Bypass.open @22:54:29.89 Intake.close @22:54:30.65 Toroid.in :hold @22:54:30.71 Toroid.seek :crack @22:54:32.22 Toroid.seek :cartridge @22:54:33.31 Toroid.in :default @22:54:33.37 Toroid.seek :clear @22:54:35.33 Pressurizing cartridge to 26psi above 26.9psia @22:54:35.35 SamplePump.setPosition! 0ml @22:54:35.40 Intake.open @22:54:36.08 Bypass.close @22:54:36.80 Exhaust.close @22:54:37.61 Pressure.in :default @22:54:37.67 Pressure.hold @22:54:37.85 SamplePump.in :charge @22:54:37.92 SamplePump.seek 2.3ml,42 seconds @22:54:47.08 Pressure.stop @22:54:47.14 Intake.close @22:54:47.88 Pressurized cartridge with 0.403ml to 26.3psi @22:54:47.89 Isolated @50.6psia (23.8psi) @22:54:47.91 Verifying cartridge holds at least 0.65..0.85 of 50.6psia @22:54:47.94 Waiting up to 20 seconds for cartridge pressure to stabilize +/-1.50psi @22:54:52.58 Sampling 1000.0ml @22:54:52.59 SamplePump.setPosition! 0ml @22:54:52.66 Exhaust.open @22:54:53.36 Intake.open @22:54:54.18 Pressure.in :default @22:54:54.24 Pressure.hold @22:54:54.36 Sea 8.4m deep (27.1psia) @22:54:54.50 SamplePump.in :sample @22:54:54.57 SamplePump.seek 1000ml,1:23:48 @22:54:57.21 Cartridge 27 filtering 1/1000ml at 0.41ml/s with 22.7psi vacuum 6.1m deep (23.7psia) @22:55:57.21 Cartridge 27 filtering 26/1000ml at 0.41ml/s with 24.2psi vacuum 7.5m deep (25.7psia) @22:56:57.22 Cartridge 27 filtering 49/1000ml at 0.39ml/s with 24.3psi vacuum 7.0m deep (25.1psia) @22:57:57.21 Cartridge 27 filtering 71/1000ml at 0.37ml/s with 25.0psi vacuum 7.6m deep (26.0psia) @22:58:57.22 Cartridge 27 filtering 91/1000ml at 0.30ml/s with 24.6psi vacuum 6.5m deep (24.3psia) @22:59:57.22 Cartridge 27 filtering 111/1000ml at 0.33ml/s with 26.4psi vacuum 5.8m deep (23.2psia) @23:00:57.22 Cartridge 27 filtering 129/1000ml at 0.31ml/s with 26.4psi vacuum 7.7m deep (26.1psia) @23:01:57.21 Cartridge 27 filtering 146/1000ml at 0.26ml/s with 22.5psi vacuum 6.8m deep (24.8psia) @23:02:57.22 Cartridge 27 filtering 161/1000ml at 0.25ml/s with 22.8psi vacuum 7.6m deep (25.9psia) @23:03:57.22 Cartridge 27 filtering 176/1000ml at 0.22ml/s with 22.9psi vacuum 7.3m deep (25.6psia) @23:04:57.22 Cartridge 27 filtering 190/1000ml at 0.22ml/s with 25.6psi vacuum 7.3m deep (25.4psia) @23:05:57.21 Cartridge 27 filtering 203/1000ml at 0.21ml/s with 25.5psi vacuum 7.4m deep (25.7psia) @23:06:57.22 Cartridge 27 filtering 215/1000ml at 0.20ml/s with 27.9psi vacuum 6.4m deep (24.2psia) @23:07:10.17 Flow averaged 0.30ml/s over 12:16 @23:07:10.20 Waiting up to 12 seconds for vacuum to reduce from 27.7 to 18.0psi @23:07:10.77 Relieved excess vacuum in .6 seconds @23:07:10.80 SamplePump.seek 1000ml,1:05:41 @23:07:33.74 Flow averaged 0.20ml/s over 23 seconds @23:07:33.78 Waiting up to 10 seconds for vacuum to reduce from 26.8 to 18.0psi @23:07:34.35 Relieved excess vacuum in .6 seconds @23:07:34.38 SamplePump.seek 1000ml,1:05:18 @23:07:36.16 Flow estimate reduced to 0.16ml/s @23:07:36.17 Intake.close @23:07:36.29 Exhaust.close @23:07:36.47 Toroid.in :hold @23:07:36.53 Toroid.seek :bypass @23:07:38.15 Toroid.in :default @23:07:38.22 Toroid.seek :clear @23:07:39.83 Cartridge::Sampler::Clogged in FILTERING -- Cartridge clogged @23:07:39.85 Pressure.stop @23:07:40.03 Sampled 222.4ml @23:07:42.09 -> Cmd.startProcessing 120.0 @23:07:43.51 SPR.command "read_sequences" @23:07:44.26 SPR.command "stats_on" @23:07:44.36 SPR.command "start 0 1" @23:07:45.11 SPR.start /var/log/esp/spr22jun0323h.spr.bz2 @23:07:47.59 Handoff.select :waste @23:07:54.27 Syringe tare is 19% of full scale @23:07:54.29 PinPort.in :locking @23:07:54.36 PinPort.seek :locked @23:07:54.84 Archive.in :fast @23:07:54.88 Lysis2.in :fast @23:07:55.00 Lysis1.seek 1350uL @23:07:55.06 Archive.seek :full @23:07:55.08 Lysis2.seek :full @23:07:57.11 Plunge.seek :reagent @23:07:58.01 Evacuating puck with filter bubble point of 50psi @23:07:58.03 PinPort.seek :locked @23:07:58.13 Handoff.select :waste @23:08:04.70 Air syringe pumping up to 1 stroke to reach 8psi @23:08:04.72 Air stroke #1 of 1 @23:08:04.81 Air.in :pressurize @23:08:04.87 Air.seek :pressurized @23:08:16.45 0.3psi after pressurize @23:08:16.47 Air.in :compress @23:08:16.54 Air.seek :evac @23:08:20.63 0.7psi after compress @23:08:33.21 0.0psi after compress (stable) @23:08:33.23 Air.in :default @23:08:33.30 Air.hold @23:08:33.47 at -0.0psi Opened to waste @23:08:33.48 Handoff.select :blocked @23:08:33.61 Archive syringe pumping up to 8 strokes to reach 50psi @23:08:33.63 Archive stroke #1 of 8 @23:08:33.71 Archive.in :pressurize @23:08:33.78 Archive.seek :pressurized @23:08:46.64 11.4psi after pressurize @23:08:46.66 Archive.in :compress @23:08:46.73 Archive.seek :empty @23:09:01.44 33.2psi after compress @23:09:15.01 36.8psi after compress (stable) @23:09:15.02 Archive.in :gulp @23:09:15.10 Archive.seek :topVent @23:09:22.26 36.9psi after gulp @23:09:34.82 36.8psi after gulp (stable) @23:09:34.83 Archive stroke #2 of 8 @23:09:34.92 Archive.in :pressurize @23:09:34.99 Archive.seek :pressurized @23:09:47.84 36.7psi after pressurize @23:09:47.85 Archive.in :compress @23:09:47.93 Archive.seek :empty @23:10:00.82 Reached 50.1 of 50.0psi after pumping 3422uL (1.98 strokes) @23:10:00.83 Archive.in :default @23:10:00.90 Archive.hold @23:10:01.00 Handoff.select :waste @23:10:08.67 delay 1:00 @23:11:08.69 Handoff.select :blocked @23:11:43.87 Handoff.select :waste @23:11:43.98 4.6psi at evacEnd @23:11:43.99 Handoff.select :blocked @23:11:44.16 Archive.in :fast @23:11:44.23 Archive.seek :topVent @23:11:59.75 Stable @4.9psi after Handoff blocked @23:11:59.77 Archive syringe pumping up to 8 strokes to reach 35psi @23:11:59.78 Archive stroke #1 of 8 @23:11:59.88 Archive.in :pressurize @23:11:59.95 Archive.seek :pressurized @23:12:12.78 6.4psi after pressurize @23:12:12.80 Archive.in :compress @23:12:12.88 Archive.seek :empty @23:12:27.58 9.5psi after compress @23:13:19.15 28.0psi after compress (stable) @23:13:19.16 Archive.in :gulp @23:13:19.24 Archive.seek :topVent @23:13:26.39 29.1psi after gulp @23:13:38.96 29.9psi after gulp (stable) @23:13:38.97 Archive stroke #2 of 8 @23:13:39.06 Archive.in :pressurize @23:13:39.13 Archive.seek :pressurized @23:13:51.97 30.9psi after pressurize @23:13:51.98 Archive.in :compress @23:13:52.06 Archive.seek :empty @23:14:06.73 33.4psi after compress @23:14:10.19 Reached 34.9 of 34.9psi after pumping 3460uL (2.00 strokes) @23:14:10.21 Archive.in :default @23:14:10.28 Archive.hold @23:14:10.35 Handoff.select :waste @23:14:25.03 delay 1:00 @23:15:25.04 Handoff.select :blocked @23:15:47.71 Handoff.select :waste @23:15:47.83 1.4psi at evacEnd @23:15:47.84 Air.seek :fullVent @23:15:49.26 Archive.in :fast @23:15:49.33 Archive.seek :topVent @23:15:56.42 Seawater evacuated, Presure above/below filter released. Lysis begins @23:15:56.52 Lysis1.in :slow @23:15:56.61 Lysis1.seek 1050uL @23:16:26.62 delay 5 seconds @23:16:31.63 Handoff.select :blocked @23:16:31.81 Lysis1.seek 450uL @23:17:31.72 delay 3 seconds @23:17:34.79 Air.in mix with 1.40048 parts Lysis1 @23:17:35.25 Air.seek :evac @23:17:35.29 Lysis1.seek 300uL @23:17:50.38 Lysis1.seek :empty @23:18:20.44 Lysis buffer delivered @18.1psi @23:18:20.45 Polling Can every 2:00 @23:18:20.99 PuckHeater.configure :default #ambient 16.8C @23:18:21.04 PuckHeater.seek 80C @23:19:23.08 PuckHeater.hold 2:00,80C @23:21:22.99 Polling Can every 2:00 @23:21:23.53 PuckHeater.configure :default #ambient 16.8C @23:21:23.59 PuckHeater.hold 30 seconds,79C @23:21:53.73 Polling Can every 2:00 @23:21:54.27 PuckHeater.configure :default #ambient 16.8C @23:21:54.32 PuckHeater.hold 30 seconds,78.5C @23:22:24.46 Polling Can every 2:00 @23:22:24.99 PuckHeater.configure :default #ambient 16.8C @23:22:25.05 PuckHeater.hold 10:00,77.9C @23:32:24.23 Lysis complete. Syringe pressure @20.9psi @23:32:24.24 Handoff.select :blocked @23:32:24.29 Archive syringe pumping up to 5 strokes to reach 40psi @23:32:24.30 Archive stroke #1 of 5 @23:32:24.39 Archive.in :pressurize @23:32:24.45 Archive.seek :pressurized @23:32:37.34 20.5psi after pressurize @23:32:37.35 Archive.in :compress @23:32:37.43 Archive.seek :empty @23:32:45.38 Reached 40.5 of 40.0psi after pumping 1585uL (0.92 strokes) @23:32:45.39 Archive.in :default @23:32:45.46 Archive.hold @23:32:45.54 delay 2 seconds @23:32:47.56 Archive.in :fast @23:32:47.62 Archive.seek :full @23:32:54.60 Lysis1.seek 138uL @23:33:08.47 delay 1 second @23:33:09.51 Archive.seek :full @23:33:09.56 Lysis1.seek :empty @23:33:23.53 Initial air pressure @43.6psi @23:33:23.59 Lysis1.in :extract @23:33:23.76 Lysis1.seek 600uL,nil @23:33:27.12 Archive syringe pumping up to 6 strokes to reach 25psi @23:33:27.13 Archive stroke #1 of 6 @23:33:27.23 Archive.in :pressurize @23:33:27.29 Archive.seek :pressurized @23:33:40.19 16.0psi after pressurize @23:33:40.20 Archive.in :compress @23:33:40.28 Archive.seek :empty @23:33:50.84 Archive.in :default @23:33:50.89 Archive.hold @23:33:51.06 Initial 600uL lysate @18.3psi @23:33:51.07 Handoff.select :blocked @23:33:51.18 Initial air pressure @19.8psi @23:33:51.26 Lysis1.seek 825uL,nil @23:33:53.01 Archive syringe pumping up to 6 strokes to reach 17psi @23:33:53.02 Archive stroke #1 of 6 @23:33:53.16 Archive.in :compress @23:33:53.22 Archive.seek :empty @23:33:57.36 15.5psi after compress @23:33:57.50 Archive.in :default @23:33:57.55 Archive.hold @23:33:57.77 Recovered 825uL lysate @15.3psi @23:33:57.79 Air.in :halfSpeed @23:33:57.87 Air.seek :fullVent @23:34:00.07 Puck Top Vented, bottom @13.9psi @23:34:00.08 Handoff.select :waste @23:34:00.20 delay 5 seconds @23:34:05.28 Handoff open to waste, bottom @-0.2psi @23:34:05.30 Air.in :default @23:34:05.37 Air.seek :evac @23:34:06.78 Lysis2.in :DAmix @23:34:06.90 Lysis1.in :DAmix @23:34:07.28 Lysis2.seek 1480uL @23:34:07.36 Lysis1.seek 575uL @23:34:42.38 delay 5 seconds @23:34:47.39 Handoff.select SPR @23:34:47.52 SPR.command "start 2 14" @23:34:48.26 SPR stabilized @23:34:48.40 delay 10 seconds @23:34:58.41 SPR.command "start 1 0" @23:35:01.62 Waiting up to 4:00 for SPR to enter state 1 @23:37:03.99 SPR.command "hold_on" @23:37:05.41 SPR Dilution 1 of 1 -- Experiment 1 with 300.0uL L1 + 300.0uL L2 @23:37:05.87 Lysis2.seek 1180uL @23:37:05.91 Lysis1.seek 275uL @23:37:47.93 delay 15 seconds @23:38:02.94 SPR.command "hold_off" @23:38:06.06 Waiting up to 38:00 for SPR to enter state 7 @23:58:55.89 SPRsummary:-25.248,190.485,197.243,251.24 after 3219s @00:05:33.16PDT04-Jun-22 SPR analysis completed @00:05:39.23 Ended log spr22jun0323h.spr.bz2 @00:05:39.25 SPR.command "stats_off" @00:05:40.60 -> Cmd.stop @00:05:40.70 Handoff.select :close @00:05:40.84 Gate.power :heat,:OFF @00:05:40.85 Gate.power :cartridge,:OFF @00:05:40.94 Carousel.seek 27 @00:05:41.12 Plunge.seek :locked @00:05:41.97 PinPort.in :unlocking @00:05:42.03 PinPort.seek :clear @00:05:42.57 Archive.in :unlocking @00:05:42.69 Archive.seek :clear @00:05:42.79 Air.in :unlocking @00:05:42.91 Air.seek :clear @00:05:42.95 Lysis1.in :unlocking @00:05:43.11 Lysis1.seek :clear @00:05:43.18 Lysis2.in :unlocking @00:05:43.26 Lysis2.seek :clear @00:05:46.81 Gate.power :motor,:OFF @00:05:46.83 Gate.power :core,:OFF @00:05:46.85 Gate.power :analytic1,:OFF @00:05:46.88 Gate.power :analytic2,:OFF @00:05:46.90 Gate.power :analytic3,:OFF @00:05:46.92 Gate.power :main,:OFF @00:05:46.94 Safely stopped and ready to power off :STOPPED