2025-04-21T20:45:42.161Z,1745268342.161 [OnDock:L.Execute](INFO): Executing command restart logs
2025-04-21T20:45:42.161Z,1745268342.161 [OnDock:L.Execute] Stopped
2025-04-21T20:45:42.161Z,1745268342.161 [OnDock:N.Docked] Running Loop=1
2025-04-21T20:45:42.161Z,1745268342.161 [OnDock:N.Docked](DEBUG): Initialize.
2025-04-21T20:45:42.161Z,1745268342.161 [OnDock:N.Docked](DEBUG): Initializing internal variables to default values.
2025-04-21T20:45:42.262Z,1745268342.262 [CommandExec](IMPORTANT): got command restart logs
2025-04-21T20:45:42.389Z,1745268342.389 [DockingStepper](INFO): Changing to mode: 1
2025-04-21T20:45:42.390Z,1745268342.390 [DockingStepper](INFO): Standby mode.
2025-04-21T20:45:42.753Z,1745268342.753 [OnDock:N.Docked](INFO): Found local IP address 10.89.10.2 for eth0
2025-04-21T20:45:42.753Z,1745268342.753 [OnDock:N.Docked](IMPORTANT): No IP address on dock subnet, restarting DHCP
2025-04-21T20:45:42.989Z,1745268342.989 [DAT](IMPORTANT): Requesting device enable set for address 0.
2025-04-21T20:45:43.242Z,1745268343.242 [DAT](INFO): DAT read: user:6>
2025-04-21T20:45:43.245Z,1745268343.245 [DAT](INFO): DAT read: Tx time:20:45:42.6162
2025-04-21T20:45:43.246Z,1745268343.246 [DAT](INFO): Ping request sent.
2025-04-21T20:45:43.246Z,1745268343.246 [DAT](INFO): transmitted an acoustic signal
2025-04-21T20:45:43.247Z,1745268343.247 [DAT](INFO): publishing transmit ping time
2025-04-21T20:45:43.250Z,1745268343.250 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.003786
2025-04-21T20:45:43.251Z,1745268343.251 [DAT](IMPORTANT): Requesting device enable set for address 0.
2025-04-21T20:45:43.493Z,1745268343.493 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.246847
2025-04-21T20:45:43.493Z,1745268343.493 [DAT](IMPORTANT): Requesting device enable set for address 0.
2025-04-21T20:45:43.745Z,1745268343.745 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.498944
2025-04-21T20:45:43.997Z,1745268343.997 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.751104
2025-04-21T20:45:44.251Z,1745268344.251 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.004943
2025-04-21T20:45:44.501Z,1745268344.501 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.254835
2025-04-21T20:45:44.753Z,1745268344.753 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.506705
2025-04-21T20:45:45.005Z,1745268345.005 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.759245
2025-04-21T20:45:45.259Z,1745268345.259 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.013038
2025-04-21T20:45:45.509Z,1745268345.509 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.262826
2025-04-21T20:45:45.761Z,1745268345.761 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.514815
2025-04-21T20:45:46.014Z,1745268346.014 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.767637
2025-04-21T20:45:46.080Z,1745268346.080 [DockingStepper](INFO): Commanding positive:54192
2025-04-21T20:45:46.267Z,1745268346.267 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.020097
2025-04-21T20:45:46.517Z,1745268346.517 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.270867
2025-04-21T20:45:46.769Z,1745268346.769 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.522880
2025-04-21T20:45:47.021Z,1745268347.021 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.774825
2025-04-21T20:45:47.276Z,1745268347.276 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.029246
2025-04-21T20:45:47.525Z,1745268347.525 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.278869
2025-04-21T20:45:47.777Z,1745268347.777 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.530768
2025-04-21T20:45:48.030Z,1745268348.030 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.784383
2025-04-21T20:45:48.284Z,1745268348.284 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.037210
2025-04-21T20:45:48.537Z,1745268348.537 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.291173
2025-04-21T20:45:48.789Z,1745268348.789 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.542949
2025-04-21T20:45:49.041Z,1745268349.041 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.794852
2025-04-21T20:45:49.296Z,1745268349.296 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.049274
2025-04-21T20:45:49.545Z,1745268349.545 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.298871
2025-04-21T20:45:49.797Z,1745268349.797 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.550789
2025-04-21T20:45:49.975Z,1745268349.975 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T20:45:50.049Z,1745268350.049 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.802714
2025-04-21T20:45:50.303Z,1745268350.303 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.056582
2025-04-21T20:45:50.554Z,1745268350.554 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.307476
2025-04-21T20:45:50.805Z,1745268350.805 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.558589
2025-04-21T20:45:51.057Z,1745268351.057 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.810999
2025-04-21T20:45:51.312Z,1745268351.312 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.065489
2025-04-21T20:45:51.561Z,1745268351.561 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.314809
2025-04-21T20:45:51.813Z,1745268351.813 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.567120
2025-04-21T20:45:52.066Z,1745268352.066 [DAT](INFO): DAT read: Response Not Received
2025-04-21T20:45:52.066Z,1745268352.066 [DAT](INFO): response not received
2025-04-21T20:45:52.066Z,1745268352.066 [DAT](INFO): DAT read: user:7>
2025-04-21T20:45:52.067Z,1745268352.067 [DAT](INFO): DAT read: Tx time:20:45:51.5661
2025-04-21T20:45:52.068Z,1745268352.068 [DAT](INFO): Ping request sent.
2025-04-21T20:45:52.068Z,1745268352.068 [DAT](INFO): transmitted an acoustic signal
2025-04-21T20:45:52.068Z,1745268352.068 [DAT](INFO): publishing transmit ping time
2025-04-21T20:45:52.069Z,1745268352.069 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.001020
2025-04-21T20:45:52.318Z,1745268352.318 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250244
2025-04-21T20:45:52.569Z,1745268352.569 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.500882
2025-04-21T20:45:52.821Z,1745268352.821 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.752795
2025-04-21T20:45:53.073Z,1745268353.073 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.004738
2025-04-21T20:45:53.325Z,1745268353.325 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.257206
2025-04-21T20:45:53.577Z,1745268353.577 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.508855
2025-04-21T20:45:53.829Z,1745268353.829 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.760788
2025-04-21T20:45:54.082Z,1745268354.082 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014065
2025-04-21T20:45:54.335Z,1745268354.335 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266590
2025-04-21T20:45:54.585Z,1745268354.585 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.516747
2025-04-21T20:45:54.837Z,1745268354.837 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.768917
2025-04-21T20:45:55.089Z,1745268355.089 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.021028
2025-04-21T20:45:55.341Z,1745268355.341 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.272860
2025-04-21T20:45:55.593Z,1745268355.593 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.524756
2025-04-21T20:45:55.845Z,1745268355.845 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.776818
2025-04-21T20:45:56.097Z,1745268356.097 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.028800
2025-04-21T20:45:56.349Z,1745268356.349 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.280889
2025-04-21T20:45:56.601Z,1745268356.601 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.532763
2025-04-21T20:45:56.854Z,1745268356.854 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.786293
2025-04-21T20:45:57.105Z,1745268357.105 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.036841
2025-04-21T20:45:57.357Z,1745268357.357 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.288704
2025-04-21T20:45:57.609Z,1745268357.609 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.540727
2025-04-21T20:45:57.861Z,1745268357.861 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.793069
2025-04-21T20:45:58.113Z,1745268358.113 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.044846
2025-04-21T20:45:58.365Z,1745268358.365 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.296788
2025-04-21T20:45:58.617Z,1745268358.617 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.548922
2025-04-21T20:45:58.648Z,1745268358.648 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250421T201950/Courier0049.lzma
2025-04-21T20:45:58.829Z,1745268358.829 [CommandExec](IMPORTANT): got command ! /mnt/mmc/LRAUV/Tools/dhcp.sh
2025-04-21T20:45:58.870Z,1745268358.870 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.801636
2025-04-21T20:45:59.121Z,1745268359.121 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.053342
2025-04-21T20:45:59.373Z,1745268359.373 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.304735
2025-04-21T20:45:59.625Z,1745268359.625 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.556940
2025-04-21T20:45:59.650Z,1745268359.650 [DataOverHttps](INFO): Moved sent file to Logs/20250421T201950/Courier0049.lzma.bak
2025-04-21T20:45:59.652Z,1745268359.652 [DataOverHttps](INFO): SBD MOMSN=24701533
2025-04-21T20:45:59.712Z,1745268359.712 [CommandExec](IMPORTANT): /mnt/mmc/started/2025-04-21UTC204559_sh
2025-04-21T20:45:59.714Z,1745268359.714 [CommandExec](IMPORTANT): got command stop
2025-04-21T20:45:59.714Z,1745268359.714 [CommandExec](IMPORTANT): Scheduling is paused for 2 commands
2025-04-21T20:45:59.714Z,1745268359.714 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2025-04-21T20:45:59.715Z,1745268359.715 [CommandExec](IMPORTANT): got command docking slide
2025-04-21T20:45:59.716Z,1745268359.716 [CommandExec](IMPORTANT): Switching docking module to SLIDE.
2025-04-21T20:45:59.877Z,1745268359.877 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.808921
2025-04-21T20:45:59.899Z,1745268359.899 [MissionManager](INFO): MissionManager is completed.
2025-04-21T20:45:59.899Z,1745268359.899 [MissionManager](INFO): Uninitializing Mission OnDock
2025-04-21T20:45:59.899Z,1745268359.899 [OnDock] Stopped
2025-04-21T20:45:59.899Z,1745268359.899 [OnDock](DEBUG): Aggregate::uninitialize OnDock
2025-04-21T20:45:59.899Z,1745268359.899 [OnDock:StandardEnvelopes] Stopped
2025-04-21T20:45:59.920Z,1745268359.920 [OnDock:StandardEnvelopes](DEBUG): Aggregate::uninitialize OnDock:StandardEnvelopes
2025-04-21T20:45:59.920Z,1745268359.920 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:BackseatDriver] Stopped
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:BackseatDriver](DEBUG): Aggregate::uninitialize OnDock:BackseatDriver
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:BackseatDriver:A.BackseatDriver] Stopped
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:PowerOnly] Stopped
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:PowerOnly](DEBUG): Aggregate::uninitialize OnDock:PowerOnly
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:PowerOnly:E.Wait] Stopped
2025-04-21T20:45:59.921Z,1745268359.921 [OnDock:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T20:45:59.922Z,1745268359.922 [OnDock:dataRead] Stopped
2025-04-21T20:45:59.922Z,1745268359.922 [OnDock:dataRead](DEBUG): Aggregate::uninitialize OnDock:dataRead
2025-04-21T20:45:59.922Z,1745268359.922 [OnDock:dataRead:A] Stopped
2025-04-21T20:45:59.922Z,1745268359.922 [OnDock:J.] Stopped
2025-04-21T20:45:59.922Z,1745268359.922 [OnDock:J.](DEBUG): Uninitializing TrackAcousticContact.
2025-04-21T20:45:59.922Z,1745268359.922 [OnDock:PeriodicCheck] Stopped
2025-04-21T20:45:59.922Z,1745268359.922 [OnDock:PeriodicCheck](DEBUG): Aggregate::uninitialize OnDock:PeriodicCheck
2025-04-21T20:45:59.922Z,1745268359.922 [OnDock:PeriodicCheck:CheckIP] Stopped
2025-04-21T20:45:59.922Z,1745268359.922 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::uninitialize OnDock:PeriodicCheck:CheckIP
2025-04-21T20:45:59.923Z,1745268359.923 [OnDock:PeriodicCheck:CheckIP:B.Wait] Stopped
2025-04-21T20:45:59.923Z,1745268359.923 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T20:45:59.923Z,1745268359.923 [OnDock:N.Docked] Stopped
2025-04-21T20:46:00.129Z,1745268360.129 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.060925
2025-04-21T20:46:00.129Z,1745268360.129 [DAT](IMPORTANT): Requesting device enable clr for address 0.
2025-04-21T20:46:00.381Z,1745268360.381 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.312831
2025-04-21T20:46:00.381Z,1745268360.381 [DAT](IMPORTANT): Requesting device enable clr for address 0.
2025-04-21T20:46:00.576Z,1745268360.576 [MissionManager](IMPORTANT): Started mission DefaultTankUndock
2025-04-21T20:46:00.577Z,1745268360.577 [DefaultTankUndock] Running Loop=1
2025-04-21T20:46:00.577Z,1745268360.577 [DefaultTankUndock](DEBUG): Aggregate::initialize DefaultTankUndock
2025-04-21T20:46:00.577Z,1745268360.577 [DefaultTankUndock:B.GoToSurface] Running Loop=1
2025-04-21T20:46:00.577Z,1745268360.577 [DefaultTankUndock:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-21T20:46:00.577Z,1745268360.577 [DefaultTankUndock:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-21T20:46:00.577Z,1745268360.577 [DefaultTankUndock:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-21T20:46:00.578Z,1745268360.578 [DefaultTankUndock:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-21T20:46:00.578Z,1745268360.578 [DefaultTankUndock:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-21T20:46:00.578Z,1745268360.578 [DefaultTankUndock:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-21T20:46:00.579Z,1745268360.579 [DefaultTankUndock:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-21T20:46:00.579Z,1745268360.579 [DefaultTankUndock:A.Wait] Running Loop=1
2025-04-21T20:46:00.579Z,1745268360.579 [DefaultTankUndock:A.Wait](DEBUG): Initialize Wait Component.
2025-04-21T20:46:00.633Z,1745268360.633 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.565013
2025-04-21T20:46:00.633Z,1745268360.633 [DAT](IMPORTANT): Requesting device enable clr for address 0.
2025-04-21T20:46:00.885Z,1745268360.885 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.817153
2025-04-21T20:46:01.137Z,1745268361.137 [DAT](INFO): DAT read: Response Not Received
2025-04-21T20:46:01.137Z,1745268361.137 [DAT](INFO): response not received
2025-04-21T20:46:01.138Z,1745268361.138 [DAT](INFO): DAT read: user:8>
2025-04-21T20:46:01.138Z,1745268361.138 [DAT](INFO): DAT read: Tx time:20:46:00.5162
2025-04-21T20:46:01.139Z,1745268361.139 [DAT](INFO): Ping request sent.
2025-04-21T20:46:01.139Z,1745268361.139 [DAT](INFO): transmitted an acoustic signal
2025-04-21T20:46:01.139Z,1745268361.139 [DAT](INFO): publishing transmit ping time
2025-04-21T20:46:01.140Z,1745268361.140 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000786
2025-04-21T20:46:01.389Z,1745268361.389 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250202
2025-04-21T20:46:01.641Z,1745268361.641 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502077
2025-04-21T20:46:01.893Z,1745268361.893 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754337
2025-04-21T20:46:02.145Z,1745268362.145 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006125
2025-04-21T20:46:02.397Z,1745268362.397 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258094
2025-04-21T20:46:02.649Z,1745268362.649 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510098
2025-04-21T20:46:02.901Z,1745268362.901 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762060
2025-04-21T20:46:03.156Z,1745268363.156 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.016816
2025-04-21T20:46:03.405Z,1745268363.405 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266608
2025-04-21T20:46:03.642Z,1745268363.642 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T20:46:03.657Z,1745268363.657 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518078
2025-04-21T20:46:03.909Z,1745268363.909 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770003
2025-04-21T20:46:04.161Z,1745268364.161 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022131
2025-04-21T20:46:04.413Z,1745268364.413 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.274185
2025-04-21T20:46:04.665Z,1745268364.665 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.526336
2025-04-21T20:46:04.917Z,1745268364.917 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.778262
2025-04-21T20:46:05.169Z,1745268365.169 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.029978
2025-04-21T20:46:05.421Z,1745268365.421 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.282211
2025-04-21T20:46:05.673Z,1745268365.673 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.533905
2025-04-21T20:46:05.937Z,1745268365.937 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.797912
2025-04-21T20:46:06.193Z,1745268366.193 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.054037
2025-04-21T20:46:06.445Z,1745268366.445 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.306127
2025-04-21T20:46:06.697Z,1745268366.697 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.558198
2025-04-21T20:46:06.949Z,1745268366.949 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.809953
2025-04-21T20:46:07.201Z,1745268367.201 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.062033
2025-04-21T20:46:07.454Z,1745268367.454 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.314795
2025-04-21T20:46:07.705Z,1745268367.705 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.565939
2025-04-21T20:46:07.957Z,1745268367.957 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.818006
2025-04-21T20:46:08.209Z,1745268368.209 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.069932
2025-04-21T20:46:08.461Z,1745268368.461 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.321938
2025-04-21T20:46:08.713Z,1745268368.713 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.574022
2025-04-21T20:46:08.965Z,1745268368.965 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.825836
2025-04-21T20:46:09.218Z,1745268369.218 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.078800
2025-04-21T20:46:09.484Z,1745268369.484 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.345140
2025-04-21T20:46:09.721Z,1745268369.721 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.582008
2025-04-21T20:46:09.974Z,1745268369.974 [DAT](INFO): DAT read: Response Not Received
2025-04-21T20:46:09.974Z,1745268369.974 [DAT](INFO): response not received
2025-04-21T20:46:09.975Z,1745268369.975 [DAT](INFO): DAT read: user:9>
2025-04-21T20:46:09.975Z,1745268369.975 [DAT](INFO): DAT read: Tx time:20:46:09.4665
2025-04-21T20:46:09.976Z,1745268369.976 [DAT](INFO): Ping request sent.
2025-04-21T20:46:09.976Z,1745268369.976 [DAT](INFO): transmitted an acoustic signal
2025-04-21T20:46:09.976Z,1745268369.976 [DAT](INFO): publishing transmit ping time
2025-04-21T20:46:09.977Z,1745268369.977 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.001091
2025-04-21T20:46:10.225Z,1745268370.225 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.248590
2025-04-21T20:46:10.477Z,1745268370.477 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.500583
2025-04-21T20:46:10.733Z,1745268370.733 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.756876
2025-04-21T20:46:10.993Z,1745268370.993 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.016663
2025-04-21T20:46:11.245Z,1745268371.245 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.268603
2025-04-21T20:46:11.497Z,1745268371.497 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.520837
2025-04-21T20:46:11.749Z,1745268371.749 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.772668
2025-04-21T20:46:12.002Z,1745268372.002 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.025305
2025-04-21T20:46:12.253Z,1745268372.253 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.276432
2025-04-21T20:46:12.505Z,1745268372.505 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.528596
2025-04-21T20:46:12.757Z,1745268372.757 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.780517
2025-04-21T20:46:13.009Z,1745268373.009 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.032881
2025-04-21T20:46:13.261Z,1745268373.261 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.285039
2025-04-21T20:46:13.513Z,1745268373.513 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.536754
2025-04-21T20:46:13.765Z,1745268373.765 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.788754
2025-04-21T20:46:13.951Z,1745268373.951 [DefaultTankUndock:A.Wait](INFO): Done Waiting.
2025-04-21T20:46:13.951Z,1745268373.951 [DefaultTankUndock:A.Wait] Stopped
2025-04-21T20:46:13.951Z,1745268373.951 [DefaultTankUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T20:46:14.017Z,1745268374.017 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.040943
2025-04-21T20:46:14.253Z,1745268374.253 [DefaultTankUndock:C.Execute] Running Loop=1
2025-04-21T20:46:14.269Z,1745268374.269 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.292709
2025-04-21T20:46:14.521Z,1745268374.521 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.544730
2025-04-21T20:46:14.643Z,1745268374.643 [DefaultTankUndock:C.Execute](INFO): Executing command dock arm
2025-04-21T20:46:14.644Z,1745268374.644 [DefaultTankUndock:C.Execute] Stopped
2025-04-21T20:46:14.701Z,1745268374.701 [DefaultTankUndock:CheckIn] Running Loop=1
2025-04-21T20:46:14.702Z,1745268374.702 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::initialize DefaultTankUndock:CheckIn
2025-04-21T20:46:14.702Z,1745268374.702 [DefaultTankUndock:CheckIn:Read_GPS] Running Loop=1
2025-04-21T20:46:14.742Z,1745268374.742 [CommandExec](IMPORTANT): got command docking arm
2025-04-21T20:46:14.742Z,1745268374.742 [CommandExec](IMPORTANT): Switching docking module to ARM.
2025-04-21T20:46:14.765Z,1745268374.765 [DockingStepper](INFO): Changing to mode: 2
2025-04-21T20:46:14.765Z,1745268374.765 [DockingStepper](INFO): Armed mode.
2025-04-21T20:46:14.773Z,1745268374.773 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.796653
2025-04-21T20:46:14.824Z,1745268374.824 [DockingStepper](INFO): Commanding negative:54112
2025-04-21T20:46:15.025Z,1745268375.025 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.048582
2025-04-21T20:46:15.277Z,1745268375.277 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.301027
2025-04-21T20:46:15.531Z,1745268375.531 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.554284
2025-04-21T20:46:15.781Z,1745268375.781 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.804643
2025-04-21T20:46:16.033Z,1745268376.033 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.056662
2025-04-21T20:46:16.286Z,1745268376.286 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.309756
2025-04-21T20:46:16.345Z,1745268376.345 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:46:16.537Z,1745268376.537 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.560891
2025-04-21T20:46:16.789Z,1745268376.789 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.813033
2025-04-21T20:46:17.041Z,1745268377.041 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.064795
2025-04-21T20:46:17.293Z,1745268377.293 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.316663
2025-04-21T20:46:17.443Z,1745268377.443 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T20:46:17.545Z,1745268377.545 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.569211
2025-04-21T20:46:17.797Z,1745268377.797 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.820821
2025-04-21T20:46:18.049Z,1745268378.049 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.072619
2025-04-21T20:46:18.301Z,1745268378.301 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.324621
2025-04-21T20:46:18.404Z,1745268378.404 [DockingStepper](ERROR): getADC uart error serial timeout
2025-04-21T20:46:18.405Z,1745268378.405 [DockingStepper](FAULT): uart error - getPosition..serial timeout
2025-04-21T20:46:18.405Z,1745268378.405 [DockingStepper] Communications Fault, FailCount= 1
2025-04-21T20:46:18.405Z,1745268378.405 [DockingStepper](ERROR): Communications Fault
2025-04-21T20:46:18.414Z,1745268378.414 [CBIT](ERROR): Communications Fault in component: DockingStepper
2025-04-21T20:46:18.553Z,1745268378.553 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.577061
2025-04-21T20:46:18.790Z,1745268378.790 [DockingStepper](INFO): Stop
2025-04-21T20:46:18.790Z,1745268378.790 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2025-04-21T20:46:18.790Z,1745268378.790 [DockingStepper](INFO): Powering down
2025-04-21T20:46:18.809Z,1745268378.809 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.832465
2025-04-21T20:46:19.061Z,1745268379.061 [DAT](INFO): DAT read: Response Not Received
2025-04-21T20:46:19.061Z,1745268379.061 [DAT](INFO): response not received
2025-04-21T20:46:19.061Z,1745268379.061 [DAT](INFO): DAT read: user:10>
2025-04-21T20:46:19.062Z,1745268379.062 [DAT](INFO): DAT read: Tx time:20:46:18.4164
2025-04-21T20:46:19.062Z,1745268379.062 [DAT](INFO): Ping request sent.
2025-04-21T20:46:19.062Z,1745268379.062 [DAT](INFO): transmitted an acoustic signal
2025-04-21T20:46:19.063Z,1745268379.063 [DAT](INFO): publishing transmit ping time
2025-04-21T20:46:19.063Z,1745268379.063 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000768
2025-04-21T20:46:19.313Z,1745268379.313 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250279
2025-04-21T20:46:19.387Z,1745268379.387 [DockingStepper](INFO): Stopping
2025-04-21T20:46:19.542Z,1745268379.542 [DockingStepper](INFO): Stopping
2025-04-21T20:46:19.565Z,1745268379.565 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502188
2025-04-21T20:46:19.817Z,1745268379.817 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754287
2025-04-21T20:46:19.997Z,1745268379.997 [DockingStepper](INFO): Stopping
2025-04-21T20:46:20.069Z,1745268380.069 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006405
2025-04-21T20:46:20.321Z,1745268380.321 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258195
2025-04-21T20:46:20.338Z,1745268380.338 [DockingStepper](INFO): Stopping
2025-04-21T20:46:20.573Z,1745268380.573 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510643
2025-04-21T20:46:20.713Z,1745268380.713 [DockingStepper](INFO): Stopping
2025-04-21T20:46:20.825Z,1745268380.825 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762349
2025-04-21T20:46:21.077Z,1745268381.077 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014274
2025-04-21T20:46:21.181Z,1745268381.181 [DockingStepper](INFO): Stopping
2025-04-21T20:46:21.329Z,1745268381.329 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266390
2025-04-21T20:46:21.545Z,1745268381.545 [DockingStepper](INFO): Stopping
2025-04-21T20:46:21.581Z,1745268381.581 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518510
2025-04-21T20:46:21.836Z,1745268381.836 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.772716
2025-04-21T20:46:22.002Z,1745268382.002 [DockingStepper](INFO): Stopping
2025-04-21T20:46:22.085Z,1745268382.085 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022264
2025-04-21T20:46:22.334Z,1745268382.334 [DockingStepper](INFO): Stopping
2025-04-21T20:46:22.353Z,1745268382.353 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.290293
2025-04-21T20:46:22.605Z,1745268382.605 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.542237
2025-04-21T20:46:22.743Z,1745268382.743 [DockingStepper](INFO): Stopping
2025-04-21T20:46:22.857Z,1745268382.857 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.794795
2025-04-21T20:46:23.109Z,1745268383.109 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.046206
2025-04-21T20:46:23.206Z,1745268383.206 [DockingStepper](INFO): Stopping
2025-04-21T20:46:23.361Z,1745268383.361 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.298239
2025-04-21T20:46:23.562Z,1745268383.562 [DockingStepper](INFO): Stopping
2025-04-21T20:46:23.613Z,1745268383.613 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.550259
2025-04-21T20:46:23.867Z,1745268383.867 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.804496
2025-04-21T20:46:23.934Z,1745268383.934 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,25042112473534,35.0, +19.0, 0.0,151
2025-04-21T20:46:23.987Z,1745268383.987 [DockingStepper](INFO): Stopping
2025-04-21T20:46:24.117Z,1745268384.117 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.054221
2025-04-21T20:46:24.346Z,1745268384.346 [DockingStepper](INFO): Stopping
2025-04-21T20:46:24.369Z,1745268384.369 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.306281
2025-04-21T20:46:24.621Z,1745268384.621 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.558228
2025-04-21T20:46:24.758Z,1745268384.758 [DockingStepper](INFO): Stopping
2025-04-21T20:46:24.873Z,1745268384.873 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.810438
2025-04-21T20:46:25.129Z,1745268385.129 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.066648
2025-04-21T20:46:25.208Z,1745268385.208 [DockingStepper](INFO): Stopping
2025-04-21T20:46:25.382Z,1745268385.382 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.319781
2025-04-21T20:46:25.575Z,1745268385.575 [DockingStepper](INFO): Stopping
2025-04-21T20:46:25.633Z,1745268385.633 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.570211
2025-04-21T20:46:25.887Z,1745268385.887 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.824219
2025-04-21T20:46:25.998Z,1745268385.998 [DockingStepper](INFO): Stopping
2025-04-21T20:46:26.046Z,1745268386.046 [DataOverHttps](IMPORTANT): SBD MTMSN=20250421T204626
2025-04-21T20:46:26.137Z,1745268386.137 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.074264
2025-04-21T20:46:26.391Z,1745268386.391 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.328038
2025-04-21T20:46:26.422Z,1745268386.422 [DockingStepper](INFO): Stopping
2025-04-21T20:46:26.641Z,1745268386.641 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.578188
2025-04-21T20:46:26.795Z,1745268386.795 [DockingStepper](INFO): Stopping
2025-04-21T20:46:26.896Z,1745268386.896 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.832853
2025-04-21T20:46:27.149Z,1745268387.149 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.086308
2025-04-21T20:46:27.205Z,1745268387.205 [DockingStepper](INFO): Stopping
2025-04-21T20:46:27.401Z,1745268387.401 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.338217
2025-04-21T20:46:27.597Z,1745268387.597 [DockingStepper](INFO): Stopping
2025-04-21T20:46:27.653Z,1745268387.653 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.590238
2025-04-21T20:46:27.907Z,1745268387.907 [DAT](INFO): DAT read: Response Not Received
2025-04-21T20:46:27.908Z,1745268387.908 [DAT](INFO): response not received
2025-04-21T20:46:27.909Z,1745268387.909 [DAT](INFO): DAT read: user:11>
2025-04-21T20:46:27.911Z,1745268387.911 [DAT](INFO): DAT read: Tx time:20:46:27.3664
2025-04-21T20:46:27.912Z,1745268387.912 [DAT](INFO): Ping request sent.
2025-04-21T20:46:27.912Z,1745268387.912 [DAT](INFO): transmitted an acoustic signal
2025-04-21T20:46:27.913Z,1745268387.913 [DAT](INFO): publishing transmit ping time
2025-04-21T20:46:27.915Z,1745268387.915 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.002250
2025-04-21T20:46:28.091Z,1745268388.091 [DockingStepper](INFO): Stopping
2025-04-21T20:46:28.157Z,1745268388.157 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.244653
2025-04-21T20:46:28.397Z,1745268388.397 [DockingStepper](INFO): Stopping
2025-04-21T20:46:28.409Z,1745268388.409 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.496752
2025-04-21T20:46:28.661Z,1745268388.661 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.748561
2025-04-21T20:46:28.794Z,1745268388.794 [DockingStepper](INFO): Stopping
2025-04-21T20:46:28.916Z,1745268388.916 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.003320
2025-04-21T20:46:29.165Z,1745268389.165 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.252755
2025-04-21T20:46:29.269Z,1745268389.269 [DockingStepper](INFO): Stopping
2025-04-21T20:46:29.417Z,1745268389.417 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.504652
2025-04-21T20:46:29.627Z,1745268389.627 [DockingStepper](INFO): Stopping
2025-04-21T20:46:29.669Z,1745268389.669 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.756792
2025-04-21T20:46:29.923Z,1745268389.923 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.010732
2025-04-21T20:46:30.089Z,1745268390.089 [DockingStepper](INFO): Stopping
2025-04-21T20:46:30.173Z,1745268390.173 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.260771
2025-04-21T20:46:30.425Z,1745268390.425 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.512626
2025-04-21T20:46:30.449Z,1745268390.449 [DockingStepper](INFO): Stopping
2025-04-21T20:46:30.677Z,1745268390.677 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.764729
2025-04-21T20:46:30.842Z,1745268390.842 [DockingStepper](INFO): Stopping
2025-04-21T20:46:30.931Z,1745268390.931 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.018428
2025-04-21T20:46:31.186Z,1745268391.186 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.273918
2025-04-21T20:46:31.395Z,1745268391.395 [DockingStepper](INFO): Stopping
2025-04-21T20:46:31.433Z,1745268391.433 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.520792
2025-04-21T20:46:31.603Z,1745268391.603 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T20:46:31.685Z,1745268391.685 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.773138
2025-04-21T20:46:31.695Z,1745268391.695 [DockingStepper](INFO): Stopping
2025-04-21T20:46:31.939Z,1745268391.939 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.026640
2025-04-21T20:46:32.095Z,1745268392.095 [DockingStepper](INFO): Stopping
2025-04-21T20:46:32.189Z,1745268392.189 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.276753
2025-04-21T20:46:32.441Z,1745268392.441 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.528662
2025-04-21T20:46:32.464Z,1745268392.464 [DockingStepper](INFO): Stopping
2025-04-21T20:46:32.693Z,1745268392.693 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.780926
2025-04-21T20:46:32.875Z,1745268392.875 [DockingStepper](INFO): Stopping
2025-04-21T20:46:32.948Z,1745268392.948 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.035192
2025-04-21T20:46:33.197Z,1745268393.197 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.284626
2025-04-21T20:46:33.308Z,1745268393.308 [DockingStepper](INFO): Stopping
2025-04-21T20:46:33.449Z,1745268393.449 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.536608
2025-04-21T20:46:33.652Z,1745268393.652 [DockingStepper](INFO): Stopping
2025-04-21T20:46:33.701Z,1745268393.701 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.788775
2025-04-21T20:46:33.955Z,1745268393.955 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.042165
2025-04-21T20:46:34.080Z,1745268394.080 [DockingStepper](INFO): Stopping
2025-04-21T20:46:34.205Z,1745268394.205 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.292567
2025-04-21T20:46:34.447Z,1745268394.447 [DataOverHttps](INFO): Received command: sched asap "load Engineering/sink.tl;set sink.SinkDuration 30 min;set sink.Depth 1 m;set sink.DepthDeadband .25 m;set sink.SurfaceThreshold 0.1 m;set sink.MinAltitude 0.01 m;set sink.MaxDepth 3 m;set sink.MinOffshore 0.00001 km" 54xp9 1 2
2025-04-21T20:46:34.457Z,1745268394.457 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.544796
2025-04-21T20:46:34.515Z,1745268394.515 [DockingStepper](INFO): Stopping
2025-04-21T20:46:34.537Z,1745268394.537 [CommandExec](IMPORTANT): got command schedule asap "load Engineering/sink.tl;set sink.SinkDuration 30 min;set sink.Depth 1 m;set sink.DepthDeadband .25 m;set sink.SurfaceThreshold 0.1 m;set sink.MinAltitude 0.01 m;set sink.MaxDepth 3 m;set sink.MinOffshore 0.00001 km" 54xp9 1 2.000000
2025-04-21T20:46:34.537Z,1745268394.537 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=54xp9
2025-04-21T20:46:34.538Z,1745268394.538 [CommandExec](IMPORTANT): Scheduled #9 (#1 of 2 with id='54xp9'): "load Engineering/sink.tl;set sink.SinkDuration 30 min;set sink.Depth 1 m;set sink.DepthDeadband .25 m;set sink.SurfaceThreshold 0.1 m;set sink.MinAltitude 0.01 m;set sink.MaxDepth 3 m;set sink.MinOffshore 0.00001 km", ASAP
2025-04-21T20:46:34.709Z,1745268394.709 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.796569
2025-04-21T20:46:34.874Z,1745268394.874 [DockingStepper](INFO): Stopping
2025-04-21T20:46:34.963Z,1745268394.963 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.050331
2025-04-21T20:46:35.213Z,1745268395.213 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.300653
2025-04-21T20:46:35.293Z,1745268395.293 [DockingStepper](INFO): Stopping
2025-04-21T20:46:35.445Z,1745268395.445 [DataOverHttps](IMPORTANT): SBD MTMSN=20250421T204635
2025-04-21T20:46:35.465Z,1745268395.465 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.552596
2025-04-21T20:46:35.665Z,1745268395.665 [DockingStepper](INFO): Stopping
2025-04-21T20:46:35.717Z,1745268395.717 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.804615
2025-04-21T20:46:35.969Z,1745268395.969 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.056716
2025-04-21T20:46:36.119Z,1745268396.119 [DockingStepper](INFO): Stopping
2025-04-21T20:46:36.221Z,1745268396.221 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.308582
2025-04-21T20:46:36.473Z,1745268396.473 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.560843
2025-04-21T20:46:36.494Z,1745268396.494 [DockingStepper](INFO): Stopping
2025-04-21T20:46:36.725Z,1745268396.725 [DAT](INFO): DAT read: Response Not Received
2025-04-21T20:46:36.725Z,1745268396.725 [DAT](INFO): response not received
2025-04-21T20:46:36.725Z,1745268396.725 [DAT](ERROR): No response from remote modem.
2025-04-21T20:46:36.726Z,1745268396.726 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.813572
2025-04-21T20:46:36.896Z,1745268396.896 [DockingStepper](INFO): Stopping
2025-04-21T20:46:36.977Z,1745268396.977 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.064597
2025-04-21T20:46:37.229Z,1745268397.229 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.316837
2025-04-21T20:46:37.316Z,1745268397.316 [DockingStepper](INFO): Stopping
2025-04-21T20:46:37.481Z,1745268397.481 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.568679
2025-04-21T20:46:37.685Z,1745268397.685 [DockingStepper](INFO): Stopping
2025-04-21T20:46:37.733Z,1745268397.733 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.820710
2025-04-21T20:46:38.122Z,1745268398.122 [DockingStepper](INFO): Stopping
2025-04-21T20:46:38.534Z,1745268398.534 [DockingStepper](INFO): Stopping
2025-04-21T20:46:38.925Z,1745268398.925 [DockingStepper](INFO): Stopping
2025-04-21T20:46:39.366Z,1745268399.366 [DockingStepper](INFO): Stopped
2025-04-21T20:46:39.374Z,1745268399.374 [CBIT](INFO): Clearing failed state for component DockingStepper
2025-04-21T20:46:39.374Z,1745268399.374 [DockingStepper] No Fault, FailCount= 1
2025-04-21T20:46:39.725Z,1745268399.725 [DockingStepper](INFO): Start
2025-04-21T20:46:39.725Z,1745268399.725 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-04-21T20:46:39.726Z,1745268399.726 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-04-21T20:46:40.202Z,1745268400.202 [DockingStepper](INFO): Starting
2025-04-21T20:46:40.518Z,1745268400.518 [DockingStepper](INFO): Starting
2025-04-21T20:46:40.935Z,1745268400.935 [DockingStepper](INFO): Starting
2025-04-21T20:46:40.984Z,1745268400.984 [DockingStepper](INFO): Init string: /1z10031aE13561N3m50
2025-04-21T20:46:41.393Z,1745268401.393 [DockingStepper](INFO): Starting
2025-04-21T20:46:41.765Z,1745268401.765 [DockingStepper](INFO): Starting
2025-04-21T20:46:42.387Z,1745268402.387 [DockingStepper](INFO): Starting
2025-04-21T20:46:42.562Z,1745268402.562 [DockingStepper](INFO): Starting
2025-04-21T20:46:42.596Z,1745268402.596 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2025-04-21T20:46:42.945Z,1745268402.945 [DockingStepper](INFO): Starting
2025-04-21T20:46:43.371Z,1745268403.371 [DockingStepper](INFO): Changing to mode: 2
2025-04-21T20:46:43.372Z,1745268403.372 [DockingStepper](INFO): Armed mode.
2025-04-21T20:46:43.436Z,1745268403.436 [DockingStepper](INFO): Commanding negative:15583
2025-04-21T20:46:43.792Z,1745268403.792 [DataOverHttps](INFO): Received command: sched asap "set sink.SkipComms 1 bool;run" 54xp9 2 2
2025-04-21T20:46:43.835Z,1745268403.835 [CommandExec](IMPORTANT): got command schedule asap "set sink.SkipComms 1 bool;run" 54xp9 2 2.000000
2025-04-21T20:46:43.835Z,1745268403.835 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=54xp9
2025-04-21T20:46:43.836Z,1745268403.836 [CommandExec](IMPORTANT): Scheduled #10 (#2 of 2 with id='54xp9'): "set sink.SkipComms 1 bool;run", ASAP
2025-04-21T20:46:43.957Z,1745268403.957 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/sink.tl
2025-04-21T20:46:43.958Z,1745268403.958 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/sink.tl
2025-04-21T20:46:43.958Z,1745268403.958 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/sink.tl
2025-04-21T20:46:43.961Z,1745268403.961 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/sink.tl
2025-04-21T20:46:45.338Z,1745268405.338 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T20:46:45.796Z,1745268405.796 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:46:47.902Z,1745268407.902 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/sink.tl translated into:
2
20
20
1
2.5
20
10
45
10
0.5
25
98
5
30
2
2025-04-21T20:46:47.911Z,1745268407.911 [MissionManager](INFO): DefineArg sink.SinkDuration = 2.000000 h
2025-04-21T20:46:47.918Z,1745268407.918 [MissionManager](INFO): DefineArg sink.WaitToFloat = 20.000000 min
2025-04-21T20:46:47.926Z,1745268407.926 [MissionManager](INFO): DefineArg sink.Depth = 20.000000 m
2025-04-21T20:46:47.932Z,1745268407.932 [MissionManager](INFO): DefineArg sink.DepthDeadband = 1.000000 m
2025-04-21T20:46:47.934Z,1745268407.934 [MissionManager](INFO): DefineArg sink.SurfaceThreshold = 2.500000 m
2025-04-21T20:46:47.940Z,1745268407.940 [MissionManager](INFO): DefineArg sink.TargetDepthTimeout = 20.000000 min
2025-04-21T20:46:47.942Z,1745268407.942 [MissionManager](INFO): DefineArg sink.DoBallastAndTrim = 0 bool
2025-04-21T20:46:48.010Z,1745268408.010 [MissionManager](INFO): DefineArg sink.BTSettleTime = 10.000000 min
2025-04-21T20:46:48.021Z,1745268408.021 [MissionManager](INFO): DefineArg sink.EstimationTimeout = 45.000000 min
2025-04-21T20:46:48.023Z,1745268408.023 [MissionManager](INFO): DefineArg sink.MinEstimationTime = 10.000000 min
2025-04-21T20:46:48.095Z,1745268408.095 [MissionManager](INFO): DefineArg sink.MassEstimationErrorBound = 0.500000 mm
2025-04-21T20:46:48.105Z,1745268408.105 [MissionManager](INFO): DefineArg sink.BuoyEstimationErrorBound = 25.000000 cc
2025-04-21T20:46:48.116Z,1745268408.116 [MissionManager](INFO): DefineArg sink.EstimationConfidence = 98.000000 %
2025-04-21T20:46:48.118Z,1745268408.118 [MissionManager](INFO): DefineArg sink.MinAltitude = 5.000000 m
2025-04-21T20:46:48.137Z,1745268408.137 [MissionManager](INFO): DefineArg sink.MaxDepth = 30.000000 m
2025-04-21T20:46:48.139Z,1745268408.139 [MissionManager](INFO): DefineArg sink.MinOffshore = 2.000000 km
2025-04-21T20:46:48.187Z,1745268408.187 [MissionManager](INFO): DefineArg sink.SkipComms = 0 bool
2025-04-21T20:46:48.223Z,1745268408.223 [MissionManager](INFO): DefineOutput sink.MissionTimeout = 2.000000 h
2025-04-21T20:46:48.246Z,1745268408.246 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl
2025-04-21T20:46:48.246Z,1745268408.246 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl
2025-04-21T20:46:48.269Z,1745268408.269 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl
2025-04-21T20:46:52.835Z,1745268412.835 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into:
NaN
3
100
80
20
5
NaN
NaN
2.0
NaN
NaN
5
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
_.planktivore_LM_AvgRois
_.planktivore_HM_AvgRois
_.planktivore_diatoms
_.planktivore_dinoflagellates
Triggered. PeakChl values on
consecutive yo-yo profiles fall in [
] (NaN bound is ignored).
2025-04-21T20:46:52.881Z,1745268412.881 [MissionManager](INFO): DefineArg sink:Science.PeakDetectChlActive = 0 bool
2025-04-21T20:46:52.883Z,1745268412.883 [MissionManager](INFO): DefineArg sink:Science.TimeWindowPeakReport = nan min
2025-04-21T20:46:52.889Z,1745268412.889 [MissionManager](INFO): DefineArg sink:Science.HighestChlPeakReportActive = 0 bool
2025-04-21T20:46:52.891Z,1745268412.891 [MissionManager](INFO): DefineArg sink:Science.HighestSaltPeakReportActive = 0 bool
2025-04-21T20:46:52.905Z,1745268412.905 [MissionManager](INFO): DefineArg sink:Science.HighestOilPeakReportActive = 0 bool
2025-04-21T20:46:52.907Z,1745268412.907 [MissionManager](INFO): DefineArg sink:Science.PatchTracking = 0 bool
2025-04-21T20:46:52.914Z,1745268412.914 [MissionManager](INFO): DefineArg sink:Science.FilterWidthHorizontal = 3.000000 count
2025-04-21T20:46:52.970Z,1745268412.970 [MissionManager](INFO): DefineArg sink:Science.NumProfilesSlidingwindow = 100.000000 count
2025-04-21T20:46:52.980Z,1745268412.980 [MissionManager](INFO): DefineArg sink:Science.OffPeakFractionHorizontal = 80.000000 %
2025-04-21T20:46:52.982Z,1745268412.982 [MissionManager](INFO): DefineArg sink:Science.PeakDetectNO3Active = 0 bool
2025-04-21T20:46:52.996Z,1745268412.996 [MissionManager](INFO): DefineArg sink:Science.PeakDetectOilActive = 0 bool
2025-04-21T20:46:52.998Z,1745268412.998 [MissionManager](INFO): DefineArg sink:Science.PeakDetectFDOMActive = 0 bool
2025-04-21T20:46:52.999Z,1745268412.999 [MissionManager](INFO): DefineArg sink:Science.PeakDetectSalinityActive = 0 bool
2025-04-21T20:46:53.025Z,1745268413.026 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreLMavgROIActive = 0 bool
2025-04-21T20:46:53.027Z,1745268413.027 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreHMavgROIActive = 0 bool
2025-04-21T20:46:53.057Z,1745268413.057 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreDiatomsActive = 0 bool
2025-04-21T20:46:53.059Z,1745268413.059 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreDinoflagellatesActive = 0 bool
2025-04-21T20:46:53.081Z,1745268413.081 [MissionManager](INFO): DefineArg sink:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2025-04-21T20:46:53.104Z,1745268413.104 [MissionManager](INFO): DefineArg sink:Science.EnabledAanderaaO2 = 0 bool
2025-04-21T20:46:53.107Z,1745268413.107 [MissionManager](INFO): DefineArg sink:Science.EnabledNeilBrown = 0 bool
2025-04-21T20:46:53.148Z,1745268413.148 [MissionManager](INFO): DefineArg sink:Science.EnabledSeabird = 1 bool
2025-04-21T20:46:53.160Z,1745268413.160 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsBB2FL = 1 bool
2025-04-21T20:46:53.163Z,1745268413.163 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool
2025-04-21T20:46:53.190Z,1745268413.190 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsUBAT = 1 bool
2025-04-21T20:46:53.197Z,1745268413.197 [MissionManager](INFO): DefineArg sink:Science.LowPassWindowLength = 20.000000 count
2025-04-21T20:46:53.199Z,1745268413.199 [MissionManager](INFO): DefineArg sink:Science.MedianFilterLen = 5.000000 count
2025-04-21T20:46:53.209Z,1745268413.209 [MissionManager](INFO): DefineArg sink:Science.PeakShallowBound = nan m
2025-04-21T20:46:53.211Z,1745268413.211 [MissionManager](INFO): DefineArg sink:Science.PeakDeepBound = nan m
2025-04-21T20:46:53.233Z,1745268413.233 [MissionManager](INFO): DefineArg sink:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2025-04-21T20:46:53.280Z,1745268413.280 [MissionManager](INFO): DefineArg sink:Science.ChlThreshTriggerActive = 0 bool
2025-04-21T20:46:53.293Z,1745268413.293 [MissionManager](INFO): DefineArg sink:Science.ChlLowerThresh = nan ug/l
2025-04-21T20:46:53.312Z,1745268413.312 [MissionManager](INFO): DefineArg sink:Science.ChlUpperThresh = nan ug/l
2025-04-21T20:46:53.314Z,1745268413.314 [MissionManager](INFO): DefineArg sink:Science.NumProfilesThresh = 5.000000 count
2025-04-21T20:46:53.337Z,1745268413.337 [MissionManager](INFO): DefineOutput sink:Science.PeakChl = nan ug/l
2025-04-21T20:46:53.339Z,1745268413.339 [MissionManager](INFO): DefineOutput sink:Science.PeakChlDepth = nan m
2025-04-21T20:46:53.354Z,1745268413.354 [MissionManager](INFO): DefineOutput sink:Science.PeakChlTemperature = nan degC
2025-04-21T20:46:53.364Z,1745268413.364 [MissionManager](INFO): DefineOutput sink:Science.PeakChlLatitude = nan arcdeg
2025-04-21T20:46:53.367Z,1745268413.367 [MissionManager](INFO): DefineOutput sink:Science.PeakChlLongitude = nan arcdeg
2025-04-21T20:46:53.381Z,1745268413.381 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3 = nan umol/l
2025-04-21T20:46:53.383Z,1745268413.383 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Depth = nan m
2025-04-21T20:46:53.398Z,1745268413.398 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Latitude = nan arcdeg
2025-04-21T20:46:53.436Z,1745268413.436 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Longitude = nan arcdeg
2025-04-21T20:46:53.438Z,1745268413.438 [MissionManager](INFO): DefineOutput sink:Science.PeakOil = nan kg/m3
2025-04-21T20:46:53.460Z,1745268413.460 [MissionManager](INFO): DefineOutput sink:Science.PeakOilDepth = nan m
2025-04-21T20:46:53.463Z,1745268413.463 [MissionManager](INFO): DefineOutput sink:Science.PeakOilLatitude = nan arcdeg
2025-04-21T20:46:53.473Z,1745268413.473 [MissionManager](INFO): DefineOutput sink:Science.PeakOilLongitude = nan arcdeg
2025-04-21T20:46:53.475Z,1745268413.475 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOM = nan ppb
2025-04-21T20:46:53.497Z,1745268413.497 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMDepth = nan m
2025-04-21T20:46:53.516Z,1745268413.516 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMTemperature = nan degC
2025-04-21T20:46:53.518Z,1745268413.518 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMLatitude = nan arcdeg
2025-04-21T20:46:53.536Z,1745268413.536 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMLongitude = nan arcdeg
2025-04-21T20:46:53.538Z,1745268413.538 [MissionManager](INFO): DefineOutput sink:Science.PeakSalt = nan psu
2025-04-21T20:46:53.566Z,1745268413.566 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltDepth = nan m
2025-04-21T20:46:53.573Z,1745268413.573 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltTemperature = nan degC
2025-04-21T20:46:53.575Z,1745268413.575 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltLatitude = nan arcdeg
2025-04-21T20:46:53.594Z,1745268413.594 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltLongitude = nan arcdeg
2025-04-21T20:46:53.612Z,1745268413.612 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROI = nan count/s
2025-04-21T20:46:53.615Z,1745268413.615 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROIDepth = nan m
2025-04-21T20:46:53.630Z,1745268413.630 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROITemperature = nan degC
2025-04-21T20:46:53.648Z,1745268413.648 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROILatitude = nan arcdeg
2025-04-21T20:46:53.651Z,1745268413.651 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROILongitude = nan arcdeg
2025-04-21T20:46:53.662Z,1745268413.662 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROI = nan count/s
2025-04-21T20:46:53.681Z,1745268413.681 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROIDepth = nan m
2025-04-21T20:46:53.683Z,1745268413.683 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROITemperature = nan degC
2025-04-21T20:46:53.698Z,1745268413.698 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROILatitude = nan arcdeg
2025-04-21T20:46:53.713Z,1745268413.713 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROILongitude = nan arcdeg
2025-04-21T20:46:53.715Z,1745268413.715 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatoms = nan count/ml
2025-04-21T20:46:53.738Z,1745268413.738 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsDepth = nan m
2025-04-21T20:46:53.752Z,1745268413.752 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsTemperature = nan degC
2025-04-21T20:46:53.754Z,1745268413.754 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsLatitude = nan arcdeg
2025-04-21T20:46:53.769Z,1745268413.769 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsLongitude = nan arcdeg
2025-04-21T20:46:53.771Z,1745268413.771 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellates = nan count/ml
2025-04-21T20:46:53.802Z,1745268413.802 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesDepth = nan m
2025-04-21T20:46:53.849Z,1745268413.849 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesTemperature = nan degC
2025-04-21T20:46:53.861Z,1745268413.861 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesLatitude = nan arcdeg
2025-04-21T20:46:53.863Z,1745268413.863 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesLongitude = nan arcdeg
2025-04-21T20:46:53.894Z,1745268413.894 [MissionManager](INFO): DefineOutput sink:Science.PatchChl = nan ug/l
2025-04-21T20:46:53.912Z,1745268413.912 [MissionManager](INFO): DefineOutput sink:Science.PatchChlDepth = nan m
2025-04-21T20:46:53.914Z,1745268413.914 [MissionManager](INFO): DefineOutput sink:Science.PatchChlLatitude = nan arcdeg
2025-04-21T20:46:53.937Z,1745268413.937 [MissionManager](INFO): DefineOutput sink:Science.PatchChlLongitude = nan arcdeg
2025-04-21T20:46:53.939Z,1745268413.939 [MissionManager](INFO): DefineOutput sink:Science.PatchChlDistance = nan m
2025-04-21T20:46:53.966Z,1745268413.966 [MissionManager](INFO): DefineOutput sink:Science.PatchSalt = nan psu
2025-04-21T20:46:53.978Z,1745268413.978 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltDepth = nan m
2025-04-21T20:46:54.006Z,1745268414.006 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltLatitude = nan arcdeg
2025-04-21T20:46:54.013Z,1745268414.013 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltLongitude = nan arcdeg
2025-04-21T20:46:54.015Z,1745268414.015 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltDistance = nan m
2025-04-21T20:46:54.033Z,1745268414.033 [MissionManager](INFO): DefineOutput sink:Science.PatchOil = nan psu
2025-04-21T20:46:54.035Z,1745268414.035 [MissionManager](INFO): DefineOutput sink:Science.PatchOilDepth = nan m
2025-04-21T20:46:54.054Z,1745268414.054 [MissionManager](INFO): DefineOutput sink:Science.PatchOilLatitude = nan arcdeg
2025-04-21T20:46:54.064Z,1745268414.064 [MissionManager](INFO): DefineOutput sink:Science.PatchOilLongitude = nan arcdeg
2025-04-21T20:46:54.066Z,1745268414.066 [MissionManager](INFO): DefineOutput sink:Science.PatchOilDistance = nan m
2025-04-21T20:46:54.076Z,1745268414.076 [MissionManager](INFO): DefineOutput sink:Science.TriggeredOnChl = 0 bool
2025-04-21T20:46:54.095Z,1745268414.095 [MissionManager](INFO): DefineOutput sink:Science.ChlTriggering = nan ug/l
2025-04-21T20:46:54.189Z,1745268414.189 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T20:46:54.321Z,1745268414.321 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-21T20:46:54.403Z,1745268414.403 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T20:46:54.466Z,1745268414.466 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T20:46:54.508Z,1745268414.508 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-21T20:46:54.552Z,1745268414.552 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T20:46:54.591Z,1745268414.591 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T20:46:54.642Z,1745268414.642 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-21T20:46:54.714Z,1745268414.714 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T20:46:54.778Z,1745268414.778 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T20:46:54.849Z,1745268414.849 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T20:46:54.948Z,1745268414.948 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T20:46:54.979Z,1745268414.979 [sink:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect.
2025-04-21T20:46:55.069Z,1745268415.069 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2025-04-21T20:46:55.069Z,1745268415.069 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2025-04-21T20:46:55.070Z,1745268415.070 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2025-04-21T20:46:55.735Z,1745268415.735 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/NeedComms.tl translated into:
1
10
20
NaN
1
1000
7
30
0
last time_fix was:
first GPS update timeout
Comms timed out after
minutes
second GPS update timeout
2025-04-21T20:46:55.748Z,1745268415.748 [MissionManager](INFO): DefineArg sink:NeedComms.DiveInterval = 1.000000 h
2025-04-21T20:46:55.750Z,1745268415.750 [MissionManager](INFO): DefineArg sink:NeedComms.WaitForPitchUp = 10.000000 min
2025-04-21T20:46:55.756Z,1745268415.756 [MissionManager](INFO): DefineArg sink:NeedComms.SurfacePitch = 20.000000 arcdeg
2025-04-21T20:46:55.758Z,1745268415.758 [MissionManager](INFO): DefineArg sink:NeedComms.SurfaceDepthRate = nan m/s
2025-04-21T20:46:55.764Z,1745268415.764 [MissionManager](INFO): DefineArg sink:NeedComms.SurfaceSpeed = 1.000000 m/s
2025-04-21T20:46:55.766Z,1745268415.766 [MissionManager](INFO): DefineArg sink:NeedComms.SurfacingTimeout = 1000.000000 s
2025-04-21T20:46:55.813Z,1745268415.813 [MissionManager](INFO): DefineArg sink:NeedComms.GPSTimeout = 7.000000 min
2025-04-21T20:46:55.815Z,1745268415.815 [MissionManager](INFO): DefineArg sink:NeedComms.CommsTimeout = 30.000000 min
2025-04-21T20:46:55.890Z,1745268415.890 [sink:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-21T20:46:55.989Z,1745268415.989 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-04-21T20:46:55.989Z,1745268415.989 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-04-21T20:46:55.990Z,1745268415.990 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-04-21T20:46:56.135Z,1745268416.135 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
5
0
200
2000
2025-04-21T20:46:56.148Z,1745268416.148 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MinAltitude = 5.000000 m
2025-04-21T20:46:56.150Z,1745268416.150 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MaxDepthIgnore = 0.000000 m
2025-04-21T20:46:56.157Z,1745268416.157 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MaxDepth = 200.000000 m
2025-04-21T20:46:56.159Z,1745268416.159 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-04-21T20:46:56.164Z,1745268416.164 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-04-21T20:46:56.173Z,1745268416.173 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-04-21T20:46:56.183Z,1745268416.183 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-04-21T20:46:56.323Z,1745268416.323 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-04-21T20:46:56.328Z,1745268416.328 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-04-21T20:46:56.331Z,1745268416.331 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-04-21T20:46:56.446Z,1745268416.446 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-04-21T20:46:56.457Z,1745268416.457 [MissionManager](INFO): DefineArg sink:BackseatDriver.EnableBackseat = 0 bool
2025-04-21T20:46:56.459Z,1745268416.459 [sink:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-04-21T20:46:56.470Z,1745268416.470 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-04-21T20:46:56.471Z,1745268416.471 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-04-21T20:46:56.488Z,1745268416.488 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-04-21T20:46:56.736Z,1745268416.736 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2025-04-21T20:46:56.739Z,1745268416.739 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleAll = 0 bool
2025-04-21T20:46:56.773Z,1745268416.773 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad1 = 0 bool
2025-04-21T20:46:56.775Z,1745268416.775 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad2 = 0 bool
2025-04-21T20:46:56.785Z,1745268416.785 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad3 = 0 bool
2025-04-21T20:46:56.793Z,1745268416.793 [MissionManager](INFO): DefineArg sink:PowerOnly.EnabledPowerOnly = 0 bool
2025-04-21T20:46:56.885Z,1745268416.885 [sink:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-04-21T20:46:56.898Z,1745268416.898 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BallastAndTrim.tl
2025-04-21T20:46:56.898Z,1745268416.898 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BallastAndTrim.tl
2025-04-21T20:46:56.914Z,1745268416.914 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BallastAndTrim.tl
2025-04-21T20:46:57.802Z,1745268417.802 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BallastAndTrim.tl translated into:
25
0
0.4
20
0
20
10
45
10
0.25
15
99.9
1
0.25
0.005
0.00075
0
Going to target depth. Speed set to
0
13
0
Waiting for
while pumping down to neutral.
Moving to
Timed out trying to reach the target depth. Stopping mission at current depth of
stop
0
Waiting for the vehicle to settle. Depth =
gfscan
Running ballast and trim. Depth =
2025-04-21T20:46:57.808Z,1745268417.808 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertDepth = 25.000000 m
2025-04-21T20:46:57.810Z,1745268417.810 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachSpeed = 0.000000 m/s
2025-04-21T20:46:57.813Z,1745268417.813 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthRate = 0.400000 m/s
2025-04-21T20:46:57.815Z,1745268417.815 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachPitchLimit = 20.000000 arcdeg
2025-04-21T20:46:57.817Z,1745268417.817 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachSettleTimePreDive = 0.000000 min
2025-04-21T20:46:57.819Z,1745268417.819 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthTimeout = 20.000000 min
2025-04-21T20:46:57.821Z,1745268417.821 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertSettleTime = 10.000000 min
2025-04-21T20:46:57.823Z,1745268417.823 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.EstTimeout = 45.000000 min
2025-04-21T20:46:57.826Z,1745268417.826 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.MinEstTime = 10.000000 min
2025-04-21T20:46:57.828Z,1745268417.828 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.MassEstErrorBound = 0.250000 mm
2025-04-21T20:46:57.830Z,1745268417.830 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.BuoyEstErrorBound = 15.000000 cc
2025-04-21T20:46:57.833Z,1745268417.833 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.EstConfidence = 99.900002 %
2025-04-21T20:46:57.835Z,1745268417.835 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertDepthDeadband = 1.000000 m
2025-04-21T20:46:57.837Z,1745268417.837 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertMassDeadband = 0.250000 mm
2025-04-21T20:46:57.949Z,1745268417.949 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Construct.
2025-04-21T20:46:58.002Z,1745268418.002 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Construct Buoyancy.
2025-04-21T20:46:58.006Z,1745268418.006 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Construct.
2025-04-21T20:46:58.054Z,1745268418.054 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Construct Wait.
2025-04-21T20:46:58.065Z,1745268418.065 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Construct.
2025-04-21T20:46:58.072Z,1745268418.072 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Construct.
2025-04-21T20:46:58.087Z,1745268418.087 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch:A_Timeout:B.Execute](DEBUG): Construct Execute.
2025-04-21T20:46:58.094Z,1745268418.094 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Construct.
2025-04-21T20:46:58.107Z,1745268418.107 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch](DEBUG): Construct.
2025-04-21T20:46:58.137Z,1745268418.137 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Construct Wait.
2025-04-21T20:46:58.138Z,1745268418.138 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:E.Execute](DEBUG): Construct Execute.
2025-04-21T20:46:58.146Z,1745268418.146 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:G.](DEBUG): Construct BallastAndTrim.
2025-04-21T20:46:58.160Z,1745268418.160 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertDepthDeadband = reader:sink.DepthDeadband
2025-04-21T20:46:58.162Z,1745268418.162 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthTimeout = reader:sink.TargetDepthTimeout
2025-04-21T20:46:58.163Z,1745268418.163 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertSettleTime = reader:sink.BTSettleTime
2025-04-21T20:46:58.169Z,1745268418.169 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.EstTimeout = reader:sink.EstimationTimeout
2025-04-21T20:46:58.170Z,1745268418.170 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.MinEstTime = reader:sink.MinEstimationTime
2025-04-21T20:46:58.171Z,1745268418.171 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.MassEstErrorBound = reader:sink.MassEstimationErrorBound
2025-04-21T20:46:58.181Z,1745268418.181 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.BuoyEstErrorBound = reader:sink.BuoyEstimationErrorBound
2025-04-21T20:46:58.183Z,1745268418.183 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.EstConfidence = reader:sink.EstimationConfidence
2025-04-21T20:46:58.205Z,1745268418.205 [sink:FloatUp:A.Buoyancy](DEBUG): Construct Buoyancy.
2025-04-21T20:46:58.220Z,1745268418.220 [sink:FloatUp:B.Wait](DEBUG): Construct Wait.
2025-04-21T20:46:58.462Z,1745268418.462 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission sink {
arguments {
SinkDuration = 2 hour
"""
Overall B&T timeout, or time to sink before ascending if not running B&T.
Mission timeout will be SinkDuration + WaitToFloat.
"""
WaitToFloat = 20 minute
"""
Timeout for reaching surface threshold on float ascent, vehicle will drive up when
reached
"""
Depth = 20 meter
"""
Target depth
"""
DepthDeadband = 1 meter
"""
How much vertical drift from the specified depth is allowed during the
mission.
"""
SurfaceThreshold = 2.5 meter
"""
Surface threshold depth, relevant only to the ascent.
"""
TargetDepthTimeout = 20 minute
"""
Maximum wait time for the vehicle to reach the target depth.
"""
DoBallastAndTrim = false
"""
If true, run B&T, if false, just sit at depth.
"""
BTSettleTime = 10 minute
"""
If running B&T, how long to wait after reaching target depth before starting
"""
EstimationTimeout = 45 minute
"""
If running B&T, timeout for estimation.
"""
MinEstimationTime = 10 minute
"""
If running B&T, minimum time to run estimation before determining convergence
(must be shorter than timeout).
"""
MassEstimationErrorBound = 0.5 millimeter
"""
If running B&T, desired range of the estimated sample mean from the true
mean statistic (smaller values take longer to converge).
"""
BuoyEstimationErrorBound = 25 cubic_centimeter
"""
If running B&T, desired range of the estimated sample mean from the true
mean statistic (smaller values take longer to converge).
"""
EstimationConfidence = 98 percent
"""
If running B&T, confidence level that the estimator has reached the desired
error range (larger values take longer to converge).
"""
MinAltitude = 5 meter
"""
Minimum height above the sea floor for the entire mission.
"""
MaxDepth = 30 meter
"""
Maximum depth for the entire mission.
"""
MinOffshore = 2 kilometer
"""
Minimum offshore distance for the entire mission.
"""
SkipComms = false
"""
Skip start-of-mission GPS fix and comms if true
"""
}
output {
MissionTimeout = SinkDuration
}
timeout duration=MissionTimeout
assign in sequence MissionTimeout = SinkDuration + WaitToFloat
insert Insert/Science.tl
insert id="NeedComms" Insert/NeedComms.tl
assign in sequence NeedComms:DiveInterval = MissionTimeout
insert Insert/StandardEnvelopes.tl
assign in sequence StandardEnvelopes:MinAltitude = MinAltitude
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
insert Insert/BackseatDriver.tl
insert Insert/PowerOnly.tl
aggregate startComms {
run in sequence
break if ( SkipComms )
call id="StartingMission" refId="NeedComms"
}
aggregate RunSink {
run in sequence
timeout duration=SinkDuration
insert Insert/BallastAndTrim.tl {
redefineArg InsertDepthDeadband = DepthDeadband
redefineArg InsertApproachDepthTimeout = TargetDepthTimeout
redefineArg InsertSettleTime = BTSettleTime
redefineArg EstTimeout = EstimationTimeout
redefineArg MinEstTime = MinEstimationTime
redefineArg MassEstErrorBound = MassEstimationErrorBound
redefineArg BuoyEstErrorBound = BuoyEstimationErrorBound
redefineArg EstConfidence = EstimationConfidence
}
aggregate RunBallastAndTrim {
run in sequence
break if (
isNaN ( Depth )
or not DoBallastAndTrim
)
assign in sequence BallastAndTrim:InsertDepth = Depth
call refId="BallastAndTrim"
}
aggregate JustSink {
run in sequence
break if (
isNaN ( Depth )
or DoBallastAndTrim
)
assign in sequence BallastAndTrim:InsertDepth = Depth
# The B&T insert will never actually invoke the B&T behavior here.
# This is a little bit of a hack to avoid duplicating the ApproachDepth etc.
# logic the B&T insert uses.
assign in sequence BTSettleTime = SinkDuration
call refId="BallastAndTrim"
}
}
aggregate FloatUp {
"""
Float to surface instead of driving.
"""
run in sequence
break if ( Universal:depth < SurfaceThreshold )
behavior Guidance:Buoyancy {
run in parallel
set position = Control:VerticalControl.buoyancyDefault
}
behavior Guidance:Wait {
run in sequence
set duration = WaitToFloat
}
}
call id="EndingMission" refId="NeedComms"
}
2025-04-21T20:46:58.462Z,1745268418.462 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/sink.tl id=sink
2025-04-21T20:46:58.717Z,1745268418.717 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T20:47:00.781Z,1745268420.781 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:47:07.723Z,1745268427.723 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-04-21T20:47:12.430Z,1745268432.430 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T20:47:12.869Z,1745268432.869 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 111.90, 90.24, 97:BS, +11, +0, +4,A
2025-04-21T20:47:13.876Z,1745268433.876 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:47:16.418Z,1745268436.418 [CommandExec](IMPORTANT): got command set sink.SinkDuration 30 minute
2025-04-21T20:47:16.419Z,1745268436.419 [CommandExec](IMPORTANT): got command set sink.Depth 1 meter
2025-04-21T20:47:16.419Z,1745268436.419 [CommandExec](IMPORTANT): got command set sink.DepthDeadband .25 meter
2025-04-21T20:47:16.424Z,1745268436.424 [CommandExec](IMPORTANT): got command set sink.SurfaceThreshold 0.1 meter
2025-04-21T20:47:16.425Z,1745268436.425 [CommandExec](IMPORTANT): got command set sink.MinAltitude 0.01 meter
2025-04-21T20:47:16.425Z,1745268436.425 [CommandExec](IMPORTANT): got command set sink.MaxDepth 3 meter
2025-04-21T20:47:16.426Z,1745268436.426 [CommandExec](IMPORTANT): got command set sink.MinOffshore 0.00001 kilometer
2025-04-21T20:47:20.021Z,1745268440.021 [CommandExec](IMPORTANT): got command set sink.SkipComms 1 bool
2025-04-21T20:47:20.021Z,1745268440.021 [CommandExec](IMPORTANT): got command run
2025-04-21T20:47:20.023Z,1745268440.023 [CommandExec](IMPORTANT): Running
2025-04-21T20:47:20.159Z,1745268440.159 [DefaultTankUndock] Stopped
2025-04-21T20:47:20.159Z,1745268440.159 [DefaultTankUndock](DEBUG): Aggregate::uninitialize DefaultTankUndock
2025-04-21T20:47:20.159Z,1745268440.159 [DefaultTankUndock:B.GoToSurface] Stopped
2025-04-21T20:47:20.164Z,1745268440.164 [DefaultTankUndock:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-21T20:47:20.164Z,1745268440.164 [DefaultTankUndock:CheckIn] Stopped
2025-04-21T20:47:20.164Z,1745268440.164 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultTankUndock:CheckIn
2025-04-21T20:47:20.164Z,1745268440.164 [DefaultTankUndock:CheckIn:Read_GPS] Stopped
2025-04-21T20:47:20.164Z,1745268440.164 [MissionManager](IMPORTANT): Started mission sink
2025-04-21T20:47:20.164Z,1745268440.164 [sink] Running Loop=1
2025-04-21T20:47:20.165Z,1745268440.165 [sink](DEBUG): Aggregate::initialize sink
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science] Running Loop=1
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science](DEBUG): Aggregate::initialize sink:Science
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science:A] Running Loop=1
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science:B] Running Loop=1
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science:C] Running Loop=1
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science:D] Running Loop=1
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science:E] Running Loop=1
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science:F] Running Loop=1
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science:Read_Oil] Running Loop=1
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science:PeakDetectChl] Running Loop=1
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science:PeakDetectChl](DEBUG): Aggregate::initialize sink:Science:PeakDetectChl
2025-04-21T20:47:20.165Z,1745268440.165 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T20:47:20.166Z,1745268440.166 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T20:47:20.167Z,1745268440.167 [sink:Science:HighestChlPeakReport] Running Loop=1
2025-04-21T20:47:20.167Z,1745268440.167 [sink:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestChlPeakReport
2025-04-21T20:47:20.167Z,1745268440.167 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-21T20:47:20.167Z,1745268440.167 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-21T20:47:20.167Z,1745268440.167 [sink:Science:PeakDetectNO3] Running Loop=1
2025-04-21T20:47:20.172Z,1745268440.172 [sink:Science:PeakDetectNO3](DEBUG): Aggregate::initialize sink:Science:PeakDetectNO3
2025-04-21T20:47:20.172Z,1745268440.172 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T20:47:20.172Z,1745268440.172 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T20:47:20.173Z,1745268440.173 [sink:Science:PeakDetectOil] Running Loop=1
2025-04-21T20:47:20.174Z,1745268440.174 [sink:Science:PeakDetectOil](DEBUG): Aggregate::initialize sink:Science:PeakDetectOil
2025-04-21T20:47:20.174Z,1745268440.174 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T20:47:20.174Z,1745268440.174 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T20:47:20.175Z,1745268440.175 [sink:Science:HighestOilPeakReport] Running Loop=1
2025-04-21T20:47:20.175Z,1745268440.175 [sink:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestOilPeakReport
2025-04-21T20:47:20.175Z,1745268440.175 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-21T20:47:20.175Z,1745268440.175 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-21T20:47:20.180Z,1745268440.180 [sink:Science:PeakDetectFDOM] Running Loop=1
2025-04-21T20:47:20.180Z,1745268440.180 [sink:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize sink:Science:PeakDetectFDOM
2025-04-21T20:47:20.180Z,1745268440.180 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T20:47:20.180Z,1745268440.180 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T20:47:20.181Z,1745268440.181 [sink:Science:PeakDetectSalinity] Running Loop=1
2025-04-21T20:47:20.181Z,1745268440.181 [sink:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize sink:Science:PeakDetectSalinity
2025-04-21T20:47:20.182Z,1745268440.182 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T20:47:20.182Z,1745268440.182 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T20:47:20.183Z,1745268440.183 [sink:Science:HighestSaltPeakReport] Running Loop=1
2025-04-21T20:47:20.183Z,1745268440.183 [sink:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestSaltPeakReport
2025-04-21T20:47:20.183Z,1745268440.183 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-21T20:47:20.183Z,1745268440.183 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-21T20:47:20.183Z,1745268440.183 [sink:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1
2025-04-21T20:47:20.188Z,1745268440.188 [sink:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreLMavgROI
2025-04-21T20:47:20.188Z,1745268440.188 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T20:47:20.188Z,1745268440.188 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T20:47:20.188Z,1745268440.188 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_LM_AvgRois , but backseat URI detected. Waiting for presence.
2025-04-21T20:47:20.189Z,1745268440.189 [sink:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1
2025-04-21T20:47:20.189Z,1745268440.189 [sink:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreHMavgROI
2025-04-21T20:47:20.189Z,1745268440.189 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T20:47:20.189Z,1745268440.189 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T20:47:20.190Z,1745268440.190 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_HM_AvgRois , but backseat URI detected. Waiting for presence.
2025-04-21T20:47:20.191Z,1745268440.191 [sink:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1
2025-04-21T20:47:20.191Z,1745268440.191 [sink:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreDiatoms
2025-04-21T20:47:20.191Z,1745268440.191 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T20:47:20.191Z,1745268440.191 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T20:47:20.191Z,1745268440.191 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_diatoms , but backseat URI detected. Waiting for presence.
2025-04-21T20:47:20.216Z,1745268440.216 [sink:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1
2025-04-21T20:47:20.216Z,1745268440.216 [sink:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreDinoflagellates
2025-04-21T20:47:20.216Z,1745268440.216 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T20:47:20.217Z,1745268440.217 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T20:47:20.217Z,1745268440.217 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_dinoflagellates , but backseat URI detected. Waiting for presence.
2025-04-21T20:47:20.218Z,1745268440.218 [sink:Science:ChlThreshTrigger] Running Loop=1
2025-04-21T20:47:20.218Z,1745268440.218 [sink:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize sink:Science:ChlThreshTrigger
2025-04-21T20:47:20.218Z,1745268440.218 [sink:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1
2025-04-21T20:47:20.218Z,1745268440.218 [sink:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize.
2025-04-21T20:47:20.219Z,1745268440.219 [sink:Science:OceanCurrent] Running Loop=1
2025-04-21T20:47:20.219Z,1745268440.219 [sink:Science:OceanCurrent](DEBUG): Aggregate::initialize sink:Science:OceanCurrent
2025-04-21T20:47:20.219Z,1745268440.219 [sink:Science:OceanCurrent:A.] Running Loop=1
2025-04-21T20:47:20.219Z,1745268440.219 [sink:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2025-04-21T20:47:20.219Z,1745268440.219 [sink:StandardEnvelopes] Running Loop=1
2025-04-21T20:47:20.219Z,1745268440.219 [sink:StandardEnvelopes](DEBUG): Aggregate::initialize sink:StandardEnvelopes
2025-04-21T20:47:20.219Z,1745268440.219 [sink:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-04-21T20:47:20.219Z,1745268440.219 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-04-21T20:47:20.224Z,1745268440.224 [sink:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-04-21T20:47:20.224Z,1745268440.224 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-04-21T20:47:20.224Z,1745268440.224 [sink:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-04-21T20:47:20.224Z,1745268440.224 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-04-21T20:47:20.224Z,1745268440.224 [sink:BackseatDriver] Running Loop=1
2025-04-21T20:47:20.224Z,1745268440.224 [sink:BackseatDriver](DEBUG): Aggregate::initialize sink:BackseatDriver
2025-04-21T20:47:20.224Z,1745268440.224 [sink:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-04-21T20:47:20.225Z,1745268440.225 [sink:PowerOnly] Running Loop=1
2025-04-21T20:47:20.225Z,1745268440.225 [sink:PowerOnly](DEBUG): Aggregate::initialize sink:PowerOnly
2025-04-21T20:47:20.225Z,1745268440.225 [sink:PowerOnly:A] Running Loop=1
2025-04-21T20:47:20.225Z,1745268440.225 [sink:PowerOnly:B] Running Loop=1
2025-04-21T20:47:20.225Z,1745268440.225 [sink:PowerOnly:C] Running Loop=1
2025-04-21T20:47:20.225Z,1745268440.225 [sink:PowerOnly:D] Running Loop=1
2025-04-21T20:47:20.225Z,1745268440.225 [sink:PowerOnly:E.Wait] Running Loop=1
2025-04-21T20:47:20.225Z,1745268440.225 [sink:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-04-21T20:47:20.225Z,1745268440.225 [sink:A] Running Loop=1
2025-04-21T20:47:20.226Z,1745268440.226 [sink:PowerOnly] Running Loop=1
2025-04-21T20:47:20.226Z,1745268440.226 [sink:PowerOnly:D] Stopped
2025-04-21T20:47:20.226Z,1745268440.226 [sink:PowerOnly:C] Stopped
2025-04-21T20:47:20.226Z,1745268440.226 [sink:PowerOnly:B] Stopped
2025-04-21T20:47:20.226Z,1745268440.226 [sink:PowerOnly:A] Stopped
2025-04-21T20:47:20.226Z,1745268440.226 [sink:BackseatDriver] Running Loop=1
2025-04-21T20:47:20.227Z,1745268440.227 [sink:StandardEnvelopes] Running Loop=1
2025-04-21T20:47:20.227Z,1745268440.227 [sink:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-04-21T20:47:20.227Z,1745268440.227 [sink:StandardEnvelopes:C.OffshoreEnvelope](IMPORTANT): Offshore envelope ACTIVE
2025-04-21T20:47:20.255Z,1745268440.255 [sink:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-04-21T20:47:20.264Z,1745268440.264 [sink:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-04-21T20:47:20.264Z,1745268440.264 [sink:Science] Running Loop=1
2025-04-21T20:47:20.265Z,1745268440.265 [sink:Science:ChlThreshTrigger] Stopped
2025-04-21T20:47:20.265Z,1745268440.265 [sink:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize sink:Science:ChlThreshTrigger
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:ChlThreshTrigger:A.ValueDetect] Stopped
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize.
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreDinoflagellates] Stopped
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreDinoflagellates
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth] Stopped
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreDiatoms] Stopped
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreDiatoms
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth] Stopped
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreHMavgROI] Stopped
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreHMavgROI
2025-04-21T20:47:20.266Z,1745268440.266 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth] Stopped
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:PeakDetectPlanktivoreLMavgROI] Stopped
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreLMavgROI
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth] Stopped
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:HighestSaltPeakReport] Stopped
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestSaltPeakReport
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:PeakDetectSalinity] Stopped
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectSalinity
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T20:47:20.267Z,1745268440.267 [sink:Science:PeakDetectFDOM] Stopped
2025-04-21T20:47:20.276Z,1745268440.276 [sink:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectFDOM
2025-04-21T20:47:20.276Z,1745268440.276 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2025-04-21T20:47:20.276Z,1745268440.276 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T20:47:20.276Z,1745268440.276 [sink:Science:HighestOilPeakReport] Stopped
2025-04-21T20:47:20.276Z,1745268440.276 [sink:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestOilPeakReport
2025-04-21T20:47:20.276Z,1745268440.276 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-21T20:47:20.276Z,1745268440.276 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-21T20:47:20.276Z,1745268440.276 [sink:Science:PeakDetectOil] Stopped
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectOil
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:PeakDetectNO3] Stopped
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectNO3
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:HighestChlPeakReport] Stopped
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestChlPeakReport
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:PeakDetectChl] Stopped
2025-04-21T20:47:20.277Z,1745268440.277 [sink:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectChl
2025-04-21T20:47:20.278Z,1745268440.278 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2025-04-21T20:47:20.278Z,1745268440.278 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T20:47:20.278Z,1745268440.278 [sink:Science:OceanCurrent:A.] Running Loop=1
2025-04-21T20:47:20.279Z,1745268440.279 [sink:Science:Read_Oil] Stopped
2025-04-21T20:47:20.279Z,1745268440.279 [sink:Science:F] Running Loop=1
2025-04-21T20:47:20.279Z,1745268440.279 [sink:Science:F](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.average_bioluminescence
2025-04-21T20:47:20.279Z,1745268440.279 [sink:Science:E] Running Loop=1
2025-04-21T20:47:20.288Z,1745268440.288 [sink:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2025-04-21T20:47:20.288Z,1745268440.288 [sink:Science:D] Stopped
2025-04-21T20:47:20.288Z,1745268440.288 [sink:Science:C] Running Loop=1
2025-04-21T20:47:20.289Z,1745268440.289 [sink:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2025-04-21T20:47:20.289Z,1745268440.289 [sink:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2025-04-21T20:47:20.289Z,1745268440.289 [sink:Science:B] Running Loop=1
2025-04-21T20:47:20.290Z,1745268440.290 [sink:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2025-04-21T20:47:20.290Z,1745268440.290 [sink:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2025-04-21T20:47:20.290Z,1745268440.290 [sink:Science:A] Stopped
2025-04-21T20:47:20.291Z,1745268440.291 [sink:A] Stopped
2025-04-21T20:47:20.291Z,1745268440.291 [sink:D] Running Loop=1
2025-04-21T20:47:20.456Z,1745268440.456 [WetLabsBB2FL](INFO): Powering up
2025-04-21T20:47:20.701Z,1745268440.701 [WetLabsUBAT](INFO): Powering up
2025-04-21T20:47:21.119Z,1745268441.119 [sink:D] Stopped
2025-04-21T20:47:21.119Z,1745268441.119 [sink:F] Running Loop=1
2025-04-21T20:47:21.338Z,1745268441.338 [sink:F] Stopped
2025-04-21T20:47:21.338Z,1745268441.338 [sink:G] Running Loop=1
2025-04-21T20:47:21.736Z,1745268441.736 [sink:G] Stopped
2025-04-21T20:47:21.737Z,1745268441.737 [sink:H] Running Loop=1
2025-04-21T20:47:22.120Z,1745268442.120 [sink:H] Stopped
2025-04-21T20:47:22.121Z,1745268442.121 [sink:startComms] Running Loop=1
2025-04-21T20:47:22.121Z,1745268442.121 [sink:startComms](DEBUG): Aggregate::initialize sink:startComms
2025-04-21T20:47:22.121Z,1745268442.121 [sink:startComms:StartingMission] Running Loop=1
2025-04-21T20:47:22.121Z,1745268442.121 [sink:startComms:StartingMission](DEBUG): Aggregate::initialize sink:startComms:StartingMission
2025-04-21T20:47:22.465Z,1745268442.465 [sink:startComms] Stopped
2025-04-21T20:47:22.465Z,1745268442.465 [sink:startComms](DEBUG): Aggregate::uninitialize sink:startComms
2025-04-21T20:47:22.465Z,1745268442.465 [sink:startComms:StartingMission] Stopped
2025-04-21T20:47:22.465Z,1745268442.465 [sink:startComms:StartingMission](DEBUG): Aggregate::uninitialize sink:startComms:StartingMission
2025-04-21T20:47:22.465Z,1745268442.465 [sink:RunSink] Running Loop=1
2025-04-21T20:47:22.465Z,1745268442.465 [sink:RunSink](DEBUG): Aggregate::initialize sink:RunSink
2025-04-21T20:47:22.465Z,1745268442.465 [sink:RunSink:RunBallastAndTrim] Running Loop=1
2025-04-21T20:47:22.465Z,1745268442.465 [sink:RunSink:RunBallastAndTrim](DEBUG): Aggregate::initialize sink:RunSink:RunBallastAndTrim
2025-04-21T20:47:22.466Z,1745268442.466 [sink:RunSink:RunBallastAndTrim:A] Running Loop=1
2025-04-21T20:47:22.467Z,1745268442.467 [sink:NeedComms] Running Loop=1
2025-04-21T20:47:22.467Z,1745268442.467 [sink:NeedComms](DEBUG): Aggregate::initialize sink:NeedComms
2025-04-21T20:47:22.467Z,1745268442.467 [sink:NeedComms:B.GoToSurface] Running Loop=1
2025-04-21T20:47:22.467Z,1745268442.467 [sink:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-21T20:47:22.467Z,1745268442.467 [sink:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-04-21T20:47:22.472Z,1745268442.472 [sink:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-04-21T20:47:22.473Z,1745268442.473 [sink:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-04-21T20:47:22.473Z,1745268442.473 [sink:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-04-21T20:47:22.473Z,1745268442.473 [sink:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-21T20:47:22.474Z,1745268442.474 [sink:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-21T20:47:22.474Z,1745268442.474 [sink:NeedComms:A] Running Loop=1
2025-04-21T20:47:22.475Z,1745268442.475 [sink:NeedComms:A](INFO): last time_fix was: 1745268332.000000 second since 1970/01/01T00:00:00Z
2025-04-21T20:47:22.475Z,1745268442.475 [sink:NeedComms:A] Stopped
2025-04-21T20:47:22.935Z,1745268442.935 [sink:RunSink:RunBallastAndTrim] Stopped
2025-04-21T20:47:22.935Z,1745268442.935 [sink:RunSink:RunBallastAndTrim](DEBUG): Aggregate::uninitialize sink:RunSink:RunBallastAndTrim
2025-04-21T20:47:22.941Z,1745268442.941 [sink:RunSink:RunBallastAndTrim:A] Stopped
2025-04-21T20:47:22.941Z,1745268442.941 [sink:RunSink:JustSink] Running Loop=1
2025-04-21T20:47:22.942Z,1745268442.942 [sink:RunSink:JustSink](DEBUG): Aggregate::initialize sink:RunSink:JustSink
2025-04-21T20:47:22.942Z,1745268442.942 [sink:RunSink:JustSink:A] Running Loop=1
2025-04-21T20:47:22.948Z,1745268442.948 [sink:NeedComms:C] Running Loop=1
2025-04-21T20:47:23.307Z,1745268443.307 [sink:RunSink:JustSink:A] Stopped
2025-04-21T20:47:23.307Z,1745268443.307 [sink:RunSink:JustSink:B] Running Loop=1
2025-04-21T20:47:23.314Z,1745268443.314 [sink:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-21T20:47:23.743Z,1745268443.743 [sink:RunSink:JustSink:B] Stopped
2025-04-21T20:47:23.743Z,1745268443.743 [sink:RunSink:JustSink:C] Running Loop=1
2025-04-21T20:47:23.743Z,1745268443.743 [sink:RunSink:JustSink:C](DEBUG): Aggregate::initialize sink:RunSink:JustSink:C
2025-04-21T20:47:23.822Z,1745268443.822 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-21T20:47:24.118Z,1745268444.118 [sink:RunSink:BallastAndTrim] Running Loop=1
2025-04-21T20:47:24.118Z,1745268444.118 [sink:RunSink:BallastAndTrim](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim
2025-04-21T20:47:24.118Z,1745268444.118 [sink:RunSink:BallastAndTrim:A] Running Loop=1
2025-04-21T20:47:24.118Z,1745268444.118 [sink:RunSink:BallastAndTrim:B] Running Loop=1
2025-04-21T20:47:24.118Z,1745268444.118 [sink:RunSink:BallastAndTrim:C] Running Loop=1
2025-04-21T20:47:24.118Z,1745268444.118 [sink:RunSink:BallastAndTrim:D] Running Loop=1
2025-04-21T20:47:24.118Z,1745268444.118 [sink:RunSink:BallastAndTrim:E] Running Loop=1
2025-04-21T20:47:24.118Z,1745268444.118 [sink:RunSink:BallastAndTrim:F] Running Loop=1
2025-04-21T20:47:24.121Z,1745268444.121 [sink:RunSink:BallastAndTrim:F](INFO): Going to target depth. Speed set to 0.000000 m/s
2025-04-21T20:47:24.121Z,1745268444.121 [sink:RunSink:BallastAndTrim:F] Stopped
2025-04-21T20:47:24.121Z,1745268444.121 [sink:RunSink:BallastAndTrim:GoToTargetDepth] Running Loop=1
2025-04-21T20:47:24.121Z,1745268444.121 [sink:RunSink:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth
2025-04-21T20:47:24.121Z,1745268444.121 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Running Loop=1
2025-04-21T20:47:24.121Z,1745268444.121 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold] Running Loop=1
2025-04-21T20:47:24.121Z,1745268444.121 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold
2025-04-21T20:47:24.121Z,1745268444.121 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Running Loop=1
2025-04-21T20:47:24.121Z,1745268444.121 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Initialize.
2025-04-21T20:47:24.121Z,1745268444.121 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Running Loop=1
2025-04-21T20:47:24.122Z,1745268444.122 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-04-21T20:47:24.122Z,1745268444.122 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Running Loop=1
2025-04-21T20:47:24.122Z,1745268444.122 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Initialize.
2025-04-21T20:47:24.122Z,1745268444.122 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive] Running Loop=1
2025-04-21T20:47:24.122Z,1745268444.122 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive
2025-04-21T20:47:24.122Z,1745268444.122 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Running Loop=1
2025-04-21T20:47:24.122Z,1745268444.122 [sink:RunSink:BallastAndTrim:E] Running Loop=1
2025-04-21T20:47:24.122Z,1745268444.122 [sink:RunSink:BallastAndTrim:D] Running Loop=1
2025-04-21T20:47:24.123Z,1745268444.123 [sink:RunSink:BallastAndTrim:C] Running Loop=1
2025-04-21T20:47:24.123Z,1745268444.123 [sink:RunSink:BallastAndTrim:B] Running Loop=1
2025-04-21T20:47:24.123Z,1745268444.123 [sink:RunSink:BallastAndTrim:A] Running Loop=1
2025-04-21T20:47:24.491Z,1745268444.491 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A](INFO): Waiting for 0.000000 min while pumping down to neutral.
2025-04-21T20:47:24.491Z,1745268444.491 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Stopped
2025-04-21T20:47:24.491Z,1745268444.491 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait] Running Loop=1
2025-04-21T20:47:24.491Z,1745268444.491 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Initialize Wait Component.
2025-04-21T20:47:24.492Z,1745268444.492 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold] Stopped
2025-04-21T20:47:24.492Z,1745268444.492 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold
2025-04-21T20:47:24.492Z,1745268444.492 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Stopped
2025-04-21T20:47:24.492Z,1745268444.492 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Stopped
2025-04-21T20:47:24.492Z,1745268444.492 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-04-21T20:47:24.492Z,1745268444.492 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Stopped
2025-04-21T20:47:24.492Z,1745268444.492 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Running Loop=1
2025-04-21T20:47:24.905Z,1745268444.905 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](INFO): Done Waiting.
2025-04-21T20:47:24.906Z,1745268444.906 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait] Stopped
2025-04-21T20:47:24.906Z,1745268444.906 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T20:47:24.906Z,1745268444.906 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](INFO): Completed sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive
2025-04-21T20:47:24.906Z,1745268444.906 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive] Stopped
2025-04-21T20:47:24.906Z,1745268444.906 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive
2025-04-21T20:47:24.906Z,1745268444.906 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth] Running Loop=1
2025-04-21T20:47:24.906Z,1745268444.906 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth
2025-04-21T20:47:24.906Z,1745268444.906 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1
2025-04-21T20:47:24.906Z,1745268444.906 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Initialize.
2025-04-21T20:47:24.906Z,1745268444.906 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Running Loop=1
2025-04-21T20:47:25.288Z,1745268445.288 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1
2025-04-21T20:47:25.289Z,1745268445.289 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A](INFO): Moving to 1.000000 m
2025-04-21T20:47:25.289Z,1745268445.289 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Stopped
2025-04-21T20:47:25.289Z,1745268445.289 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Running Loop=1
2025-04-21T20:47:25.289Z,1745268445.289 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Initialize.
2025-04-21T20:47:26.088Z,1745268446.088 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T20:47:26.488Z,1745268446.488 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:47:36.660Z,1745268456.660 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:47:39.812Z,1745268459.812 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-21T20:47:46.708Z,1745268466.708 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:47:47.140Z,1745268467.140 [WetLabsUBAT](ERROR): Failed to parse incomplete device message.
2025-04-21T20:47:57.112Z,1745268477.112 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:48:07.394Z,1745268487.394 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:48:23.716Z,1745268503.716 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:48:25.974Z,1745268505.974 [CommandExec](IMPORTANT): got command get platform_buoyancy_position
2025-04-21T20:48:25.975Z,1745268505.975 [CommandExec](IMPORTANT): platform_buoyancy_position 990.301025 cc
2025-04-21T20:48:34.572Z,1745268514.572 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:48:38.521Z,1745268518.521 [CommandExec](IMPORTANT): got command report mod platform_buoyancy_position
2025-04-21T20:48:38.831Z,1745268518.831 [Reporter](INFO): platform_buoyancy_position 990.301025 cc
2025-04-21T20:48:43.313Z,1745268523.313 [CommandExec](IMPORTANT): got command schedule resume
2025-04-21T20:48:43.313Z,1745268523.313 [CommandExec](IMPORTANT): Scheduling is resumed
2025-04-21T20:48:46.468Z,1745268526.468 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:48:49.177Z,1745268529.177 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,25042112500047,35.0, +18.9, 8.6, 0
2025-04-21T20:48:49.465Z,1745268529.465 [CommandExec](IMPORTANT): got command show stack
2025-04-21T20:48:49.465Z,1745268529.465 [CommandExec](IMPORTANT): Behavior Stack:
2025-04-21T20:48:49.467Z,1745268529.467 [sink:Science](IMPORTANT): Priority 0: sink:Science:B
2025-04-21T20:48:49.467Z,1745268529.467 [sink:Science](IMPORTANT): Priority 1: sink:Science:C
2025-04-21T20:48:49.467Z,1745268529.467 [sink:Science](IMPORTANT): Priority 2: sink:Science:E
2025-04-21T20:48:49.498Z,1745268529.498 [sink:Science](IMPORTANT): Priority 3: sink:Science:F
2025-04-21T20:48:49.498Z,1745268529.498 [sink:Science:OceanCurrent](IMPORTANT): Priority 4: sink:Science:OceanCurrent:A.
2025-04-21T20:48:49.499Z,1745268529.499 [sink:NeedComms](IMPORTANT): Priority 5: sink:NeedComms:B.GoToSurface
2025-04-21T20:48:49.499Z,1745268529.499 [sink:NeedComms](IMPORTANT): Priority 6: sink:NeedComms:C
2025-04-21T20:48:49.499Z,1745268529.499 [sink:StandardEnvelopes](IMPORTANT): Priority 7: sink:StandardEnvelopes:A.AltitudeEnvelope
2025-04-21T20:48:49.508Z,1745268529.508 [sink:StandardEnvelopes](IMPORTANT): Priority 8: sink:StandardEnvelopes:B.DepthEnvelope
2025-04-21T20:48:49.508Z,1745268529.508 [sink:StandardEnvelopes](IMPORTANT): Priority 9: sink:StandardEnvelopes:C.OffshoreEnvelope
2025-04-21T20:48:49.509Z,1745268529.509 [sink:BackseatDriver](IMPORTANT): Priority 10: sink:BackseatDriver:A.BackseatDriver
2025-04-21T20:48:49.509Z,1745268529.509 [sink:PowerOnly](IMPORTANT): Priority 11: sink:PowerOnly:E.Wait
2025-04-21T20:48:49.509Z,1745268529.509 [sink:RunSink:BallastAndTrim](IMPORTANT): Priority 12: sink:RunSink:BallastAndTrim:A
2025-04-21T20:48:49.510Z,1745268529.510 [sink:RunSink:BallastAndTrim](IMPORTANT): Priority 13: sink:RunSink:BallastAndTrim:B
2025-04-21T20:48:49.510Z,1745268529.510 [sink:RunSink:BallastAndTrim](IMPORTANT): Priority 14: sink:RunSink:BallastAndTrim:C
2025-04-21T20:48:49.510Z,1745268529.510 [sink:RunSink:BallastAndTrim](IMPORTANT): Priority 15: sink:RunSink:BallastAndTrim:D
2025-04-21T20:48:49.510Z,1745268529.510 [sink:RunSink:BallastAndTrim](IMPORTANT): Priority 16: sink:RunSink:BallastAndTrim:E
2025-04-21T20:48:49.511Z,1745268529.511 [sink:RunSink:BallastAndTrim:GoToTargetDepth](IMPORTANT): Priority 17: sink:RunSink:BallastAndTrim:GoToTargetDepth:A
2025-04-21T20:48:49.511Z,1745268529.511 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](IMPORTANT): Priority 18: sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed
2025-04-21T20:48:49.511Z,1745268529.511 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](IMPORTANT): Priority 19: sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch
2025-04-21T20:48:56.862Z,1745268536.862 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:49:07.052Z,1745268547.052 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:49:17.168Z,1745268557.168 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:49:27.596Z,1745268567.596 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:49:37.869Z,1745268577.869 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:49:47.814Z,1745268587.814 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:49:57.876Z,1745268597.876 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:50:03.926Z,1745268603.926 [NAL9602](INFO): SBD MO Status=2, MOMSN=47965, MT Status=2, MTMSN=0
2025-04-21T20:50:03.926Z,1745268603.926 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-04-21T20:50:09.473Z,1745268609.473 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:50:28.557Z,1745268628.557 [CommandExec](IMPORTANT): got command set platform_communications 1 bool
2025-04-21T20:50:31.085Z,1745268631.085 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:50:34.373Z,1745268634.373 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-21T20:50:38.799Z,1745268638.799 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205039.00,A,3648.16332,N,12147.28431,W,0.136,0.00,210425,,,D*71
2025-04-21T20:50:38.802Z,1745268638.802 [NAL9602](INFO): GPS fix at 20250421T205039: (36.802722, -121.788072)
2025-04-21T20:50:38.947Z,1745268638.947 [sink:NeedComms:C] Stopped
2025-04-21T20:50:38.947Z,1745268638.947 [sink:NeedComms:D] Running Loop=1
2025-04-21T20:50:39.294Z,1745268639.294 [sink:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-21T20:50:46.115Z,1745268646.115 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250421T201950/Courier0052.lzma
2025-04-21T20:50:47.131Z,1745268647.131 [DataOverHttps](INFO): Moved sent file to Logs/20250421T201950/Courier0052.lzma.bak
2025-04-21T20:50:47.131Z,1745268647.131 [DataOverHttps](INFO): SBD MOMSN=24701552
2025-04-21T20:50:49.962Z,1745268649.962 [CommandExec](IMPORTANT): got command set platform_communications 1 bool
2025-04-21T20:50:59.208Z,1745268659.208 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 89.73, 97.98, 103.14
2025-04-21T20:51:03.303Z,1745268663.303 [BPC1](INFO): Calculating totals. Valid battery stick count: 48. Valid reserve battery stick count: 5.
2025-04-21T20:51:03.308Z,1745268663.308 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle.
2025-04-21T20:51:11.389Z,1745268671.389 [NAL9602](INFO): Not Powering down - fast GPS
2025-04-21T20:51:14.040Z,1745268674.040 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20250421T204542/Courier0000.lzma
2025-04-21T20:51:15.046Z,1745268675.046 [DataOverHttps](INFO): Moved sent file to Logs/20250421T204542/Courier0000.lzma.bak
2025-04-21T20:51:15.046Z,1745268675.046 [DataOverHttps](INFO): SBD MOMSN=24701554
2025-04-21T20:51:27.560Z,1745268687.560 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 110.86, 89.72, 93.13
2025-04-21T20:51:41.014Z,1745268701.014 [DataOverHttps](INFO): Sending 261 bytes from file Logs/20250416T201445/Express0038.lzma
2025-04-21T20:51:42.010Z,1745268702.010 [DataOverHttps](INFO): Moved sent file to Logs/20250416T201445/Express0038.lzma.bak
2025-04-21T20:51:42.010Z,1745268702.010 [DataOverHttps](INFO): SBD MOMSN=24701558
2025-04-21T20:51:43.190Z,1745268703.190 [CommandExec](IMPORTANT): got command get
2025-04-21T20:51:43.190Z,1745268703.190 [CommandExec](FAULT): Incomplete syntax. Try: help get
2025-04-21T20:51:52.065Z,1745268712.065 [CommandExec](IMPORTANT): got command get VerticalControl.depthCmd
2025-04-21T20:51:52.066Z,1745268712.066 [CommandExec](IMPORTANT): VerticalControl.depthCmd 1.000000 m
2025-04-21T20:52:09.516Z,1745268729.516 [WetLabsUBAT](ERROR): Failed to parse incomplete device message.
2025-04-21T20:52:21.922Z,1745268741.922 [DataOverHttps](INFO): Sending 486 bytes from file Logs/20250416T201445/Express0041.lzma
2025-04-21T20:52:22.910Z,1745268742.910 [DataOverHttps](INFO): Moved sent file to Logs/20250416T201445/Express0041.lzma.bak
2025-04-21T20:52:22.910Z,1745268742.910 [DataOverHttps](INFO): SBD MOMSN=24701566
2025-04-21T20:52:40.034Z,1745268760.034 [WetLabsUBAT](ERROR): Failed to parse incomplete device message.
2025-04-21T20:52:49.127Z,1745268769.127 [CommandExec](IMPORTANT): got command set sink:NeedComms.CommsTimeout .5 minute
2025-04-21T20:52:49.388Z,1745268769.388 [sink:NeedComms:D](INFO): Timed out from 2025-04-21T20:50:38.9Z
2025-04-21T20:52:49.388Z,1745268769.388 [sink:NeedComms:D:A_Timeout] Running Loop=1
2025-04-21T20:52:49.388Z,1745268769.388 [sink:NeedComms:D:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:D:A_Timeout
2025-04-21T20:52:49.388Z,1745268769.388 [sink:NeedComms:D:A_Timeout:A] Running Loop=1
2025-04-21T20:52:49.389Z,1745268769.389 [sink:NeedComms:D:A_Timeout:A](IMPORTANT): Comms timed out after 0.500000 min minutes
2025-04-21T20:52:49.389Z,1745268769.389 [sink:NeedComms:D:A_Timeout:A] Stopped
2025-04-21T20:52:49.389Z,1745268769.389 [sink:NeedComms:D:A_Timeout](INFO): Completed sink:NeedComms:D:A_Timeout
2025-04-21T20:52:49.389Z,1745268769.389 [sink:NeedComms:D] Stopped
2025-04-21T20:52:49.389Z,1745268769.389 [sink:NeedComms:E] Running Loop=1
2025-04-21T20:52:49.783Z,1745268769.783 [sink:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-21T20:52:51.327Z,1745268771.327 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,205251.00,A,3648.16270,N,12147.28121,W,0.136,0.00,210425,,,D*7E
2025-04-21T20:52:51.330Z,1745268771.330 [NAL9602](INFO): GPS fix at 20250421T205251: (36.802712, -121.788020)
2025-04-21T20:52:51.350Z,1745268771.350 [sink:NeedComms:E] Stopped
2025-04-21T20:52:51.351Z,1745268771.351 [sink:NeedComms](INFO): Completed sink:NeedComms
2025-04-21T20:52:51.351Z,1745268771.351 [sink:NeedComms] Stopped
2025-04-21T20:52:51.353Z,1745268771.353 [sink:NeedComms](DEBUG): Aggregate::uninitialize sink:NeedComms
2025-04-21T20:52:51.353Z,1745268771.353 [sink:NeedComms:B.GoToSurface] Stopped
2025-04-21T20:52:51.353Z,1745268771.353 [sink:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-21T20:52:53.839Z,1745268773.839 [Reporter](INFO): platform_buoyancy_position 990.435242 cc
2025-04-21T20:52:54.579Z,1745268774.579 [Reporter](INFO): platform_buoyancy_position 988.286438 cc
2025-04-21T20:52:55.254Z,1745268775.254 [Reporter](INFO): platform_buoyancy_position 977.676697 cc
2025-04-21T20:52:55.661Z,1745268775.661 [Reporter](INFO): platform_buoyancy_position 975.393677 cc
2025-04-21T20:52:56.002Z,1745268776.002 [Reporter](INFO): platform_buoyancy_position 973.110596 cc
2025-04-21T20:52:56.779Z,1745268776.779 [Reporter](INFO): platform_buoyancy_position 968.812988 cc
2025-04-21T20:52:57.235Z,1745268777.235 [Reporter](INFO): platform_buoyancy_position 964.515381 cc
2025-04-21T20:52:57.525Z,1745268777.525 [Reporter](INFO): platform_buoyancy_position 960.755005 cc
2025-04-21T20:52:58.109Z,1745268778.109 [Reporter](INFO): platform_buoyancy_position 958.068970 cc
2025-04-21T20:52:58.460Z,1745268778.460 [Reporter](INFO): platform_buoyancy_position 953.771362 cc
2025-04-21T20:52:58.942Z,1745268778.942 [Reporter](INFO): platform_buoyancy_position 949.608032 cc
2025-04-21T20:52:59.431Z,1745268779.431 [Reporter](INFO): platform_buoyancy_position 945.310425 cc
2025-04-21T20:53:00.109Z,1745268780.109 [Reporter](INFO): platform_buoyancy_position 941.147217 cc
2025-04-21T20:53:00.869Z,1745268780.869 [Reporter](INFO): platform_buoyancy_position 936.715332 cc
2025-04-21T20:53:01.538Z,1745268781.538 [Reporter](INFO): platform_buoyancy_position 932.417725 cc
2025-04-21T20:53:02.609Z,1745268782.609 [Reporter](INFO): platform_buoyancy_position 925.702637 cc
2025-04-21T20:53:02.975Z,1745268782.975 [Reporter](INFO): platform_buoyancy_position 923.688232 cc
2025-04-21T20:53:03.446Z,1745268783.446 [Reporter](INFO): platform_buoyancy_position 919.256226 cc
2025-04-21T20:53:03.842Z,1745268783.842 [Reporter](INFO): platform_buoyancy_position 914.958740 cc
2025-04-21T20:53:04.470Z,1745268784.470 [Reporter](INFO): platform_buoyancy_position 908.646606 cc
2025-04-21T20:53:04.842Z,1745268784.842 [Reporter](INFO): platform_buoyancy_position 904.348999 cc
2025-04-21T20:53:05.279Z,1745268785.279 [Reporter](INFO): platform_buoyancy_position 899.917114 cc
2025-04-21T20:53:05.653Z,1745268785.653 [Reporter](INFO): platform_buoyancy_position 895.888062 cc
2025-04-21T20:53:06.146Z,1745268786.146 [Reporter](INFO): platform_buoyancy_position 893.470703 cc
2025-04-21T20:53:06.575Z,1745268786.575 [Reporter](INFO): platform_buoyancy_position 889.710327 cc
2025-04-21T20:53:07.114Z,1745268787.114 [Reporter](INFO): platform_buoyancy_position 887.292847 cc
2025-04-21T20:53:07.542Z,1745268787.542 [Reporter](INFO): platform_buoyancy_position 882.995239 cc
2025-04-21T20:53:07.850Z,1745268787.850 [Reporter](INFO): platform_buoyancy_position 880.712158 cc
2025-04-21T20:53:08.130Z,1745268788.130 [Reporter](INFO): platform_buoyancy_position 877.489014 cc
2025-04-21T20:53:08.366Z,1745268788.366 [DataOverHttps](INFO): Sending 584 bytes from file Logs/20250416T201445/Express0044.lzma
2025-04-21T20:53:08.543Z,1745268788.543 [Reporter](INFO): platform_buoyancy_position 873.997192 cc
2025-04-21T20:53:08.962Z,1745268788.962 [Reporter](INFO): platform_buoyancy_position 867.819336 cc
2025-04-21T20:53:09.367Z,1745268789.367 [DataOverHttps](INFO): Moved sent file to Logs/20250416T201445/Express0044.lzma.bak
2025-04-21T20:53:09.367Z,1745268789.367 [DataOverHttps](INFO): SBD MOMSN=24701582
2025-04-21T20:53:09.399Z,1745268789.399 [Reporter](INFO): platform_buoyancy_position 863.521729 cc
2025-04-21T20:53:09.720Z,1745268789.720 [Reporter](INFO): platform_buoyancy_position 859.224121 cc
2025-04-21T20:53:10.147Z,1745268790.147 [Reporter](INFO): platform_buoyancy_position 853.852173 cc
2025-04-21T20:53:10.368Z,1745268790.368 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:53:10.506Z,1745268790.506 [Reporter](INFO): platform_buoyancy_position 848.614502 cc
2025-04-21T20:53:11.099Z,1745268791.099 [Reporter](INFO): platform_buoyancy_position 843.108154 cc
2025-04-21T20:53:11.459Z,1745268791.459 [Reporter](INFO): platform_buoyancy_position 837.736206 cc
2025-04-21T20:53:11.738Z,1745268791.738 [Reporter](INFO): platform_buoyancy_position 835.587402 cc
2025-04-21T20:53:12.151Z,1745268792.151 [Reporter](INFO): platform_buoyancy_position 831.155518 cc
2025-04-21T20:53:12.718Z,1745268792.718 [Reporter](INFO): platform_buoyancy_position 825.111938 cc
2025-04-21T20:53:13.147Z,1745268793.147 [Reporter](INFO): platform_buoyancy_position 820.680054 cc
2025-04-21T20:53:13.451Z,1745268793.451 [Reporter](INFO): platform_buoyancy_position 818.128357 cc
2025-04-21T20:53:13.933Z,1745268793.933 [Reporter](INFO): platform_buoyancy_position 814.099365 cc
2025-04-21T20:53:14.380Z,1745268794.380 [Reporter](INFO): platform_buoyancy_position 809.801758 cc
2025-04-21T20:53:14.625Z,1745268794.625 [Reporter](INFO): platform_buoyancy_position 805.504150 cc
2025-04-21T20:53:15.080Z,1745268795.080 [Reporter](INFO): platform_buoyancy_position 799.057800 cc
2025-04-21T20:53:15.559Z,1745268795.559 [Reporter](INFO): platform_buoyancy_position 794.760193 cc
2025-04-21T20:53:15.818Z,1745268795.818 [Reporter](INFO): platform_buoyancy_position 790.462585 cc
2025-04-21T20:53:16.254Z,1745268796.254 [Reporter](INFO): platform_buoyancy_position 784.016174 cc
2025-04-21T20:53:16.631Z,1745268796.631 [Reporter](INFO): platform_buoyancy_position 779.852844 cc
2025-04-21T20:53:17.102Z,1745268797.102 [Reporter](INFO): platform_buoyancy_position 773.406494 cc
2025-04-21T20:53:17.462Z,1745268797.462 [Reporter](INFO): platform_buoyancy_position 768.974548 cc
2025-04-21T20:53:17.863Z,1745268797.863 [Reporter](INFO): platform_buoyancy_position 764.005493 cc
2025-04-21T20:53:18.263Z,1745268798.263 [Reporter](INFO): platform_buoyancy_position 758.364868 cc
2025-04-21T20:53:18.584Z,1745268798.584 [Reporter](INFO): platform_buoyancy_position 754.067261 cc
2025-04-21T20:53:19.002Z,1745268799.002 [Reporter](INFO): platform_buoyancy_position 747.620850 cc
2025-04-21T20:53:19.412Z,1745268799.412 [Reporter](INFO): platform_buoyancy_position 743.323242 cc
2025-04-21T20:53:19.824Z,1745268799.824 [Reporter](INFO): platform_buoyancy_position 736.876892 cc
2025-04-21T20:53:20.243Z,1745268800.243 [Reporter](INFO): platform_buoyancy_position 732.444946 cc
2025-04-21T20:53:20.615Z,1745268800.615 [Reporter](INFO): platform_buoyancy_position 728.013062 cc
2025-04-21T20:53:21.026Z,1745268801.026 [Reporter](INFO): platform_buoyancy_position 721.700989 cc
2025-04-21T20:53:21.196Z,1745268801.196 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:53:21.550Z,1745268801.550 [Reporter](INFO): platform_buoyancy_position 715.523193 cc
2025-04-21T20:53:21.954Z,1745268801.954 [Reporter](INFO): platform_buoyancy_position 711.091248 cc
2025-04-21T20:53:22.113Z,1745268802.113 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-04-21T20:53:22.196Z,1745268802.196 [NAL9602](ERROR): received:
+CSQ:0
OK965, 2, 0, 0, 0
OK
2025-04-21T20:53:22.534Z,1745268802.534 [Reporter](INFO): platform_buoyancy_position 702.764648 cc
2025-04-21T20:53:22.958Z,1745268802.958 [Reporter](INFO): platform_buoyancy_position 700.212952 cc
2025-04-21T20:53:23.183Z,1745268803.183 [Reporter](INFO): platform_buoyancy_position 695.781067 cc
2025-04-21T20:53:23.579Z,1745268803.579 [Reporter](INFO): platform_buoyancy_position 691.617737 cc
2025-04-21T20:53:23.954Z,1745268803.954 [Reporter](INFO): platform_buoyancy_position 685.574280 cc
2025-04-21T20:53:24.418Z,1745268804.418 [Reporter](INFO): platform_buoyancy_position 680.873779 cc
2025-04-21T20:53:24.746Z,1745268804.746 [Reporter](INFO): platform_buoyancy_position 676.576172 cc
2025-04-21T20:53:25.206Z,1745268805.206 [Reporter](INFO): platform_buoyancy_position 670.264038 cc
2025-04-21T20:53:25.625Z,1745268805.625 [Reporter](INFO): platform_buoyancy_position 665.832153 cc
2025-04-21T20:53:26.072Z,1745268806.072 [Reporter](INFO): platform_buoyancy_position 659.520081 cc
2025-04-21T20:53:26.479Z,1745268806.479 [Reporter](INFO): platform_buoyancy_position 654.416687 cc
2025-04-21T20:53:26.767Z,1745268806.767 [Reporter](INFO): platform_buoyancy_position 650.790588 cc
2025-04-21T20:53:27.235Z,1745268807.235 [Reporter](INFO): platform_buoyancy_position 644.344177 cc
2025-04-21T20:53:27.647Z,1745268807.647 [Reporter](INFO): platform_buoyancy_position 638.166382 cc
2025-04-21T20:53:28.003Z,1745268808.003 [Reporter](INFO): platform_buoyancy_position 633.600159 cc
2025-04-21T20:53:28.454Z,1745268808.454 [Reporter](INFO): platform_buoyancy_position 629.302551 cc
2025-04-21T20:53:28.822Z,1745268808.822 [Reporter](INFO): platform_buoyancy_position 624.064880 cc
2025-04-21T20:53:29.260Z,1745268809.260 [Reporter](INFO): platform_buoyancy_position 618.558533 cc
2025-04-21T20:53:29.604Z,1745268809.604 [Reporter](INFO): platform_buoyancy_position 614.260986 cc
2025-04-21T20:53:29.974Z,1745268809.974 [Reporter](INFO): platform_buoyancy_position 607.948853 cc
2025-04-21T20:53:30.517Z,1745268810.517 [Reporter](INFO): platform_buoyancy_position 603.382629 cc
2025-04-21T20:53:30.926Z,1745268810.926 [Reporter](INFO): platform_buoyancy_position 597.339172 cc
2025-04-21T20:53:31.286Z,1745268811.286 [Reporter](INFO): platform_buoyancy_position 591.295654 cc
2025-04-21T20:53:31.758Z,1745268811.758 [Reporter](INFO): platform_buoyancy_position 586.460876 cc
2025-04-21T20:53:31.820Z,1745268811.820 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:53:32.006Z,1745268812.006 [Reporter](INFO): platform_buoyancy_position 582.028931 cc
2025-04-21T20:53:32.442Z,1745268812.442 [Reporter](INFO): platform_buoyancy_position 575.582581 cc
2025-04-21T20:53:32.838Z,1745268812.838 [Reporter](INFO): platform_buoyancy_position 571.284973 cc
2025-04-21T20:53:33.279Z,1745268813.279 [Reporter](INFO): platform_buoyancy_position 564.972839 cc
2025-04-21T20:53:33.654Z,1745268813.654 [Reporter](INFO): platform_buoyancy_position 560.540955 cc
2025-04-21T20:53:34.042Z,1745268814.042 [Reporter](INFO): platform_buoyancy_position 555.437561 cc
2025-04-21T20:53:34.463Z,1745268814.463 [Reporter](INFO): platform_buoyancy_position 549.931274 cc
2025-04-21T20:53:34.858Z,1745268814.858 [Reporter](INFO): platform_buoyancy_position 543.484863 cc
2025-04-21T20:53:35.326Z,1745268815.326 [Reporter](INFO): platform_buoyancy_position 538.247131 cc
2025-04-21T20:53:35.711Z,1745268815.711 [Reporter](INFO): platform_buoyancy_position 532.740845 cc
2025-04-21T20:53:36.075Z,1745268816.075 [Reporter](INFO): platform_buoyancy_position 528.443237 cc
2025-04-21T20:53:36.515Z,1745268816.515 [Reporter](INFO): platform_buoyancy_position 522.131165 cc
2025-04-21T20:53:36.871Z,1745268816.871 [Reporter](INFO): platform_buoyancy_position 517.699280 cc
2025-04-21T20:53:37.355Z,1745268817.355 [Reporter](INFO): platform_buoyancy_position 511.387115 cc
2025-04-21T20:53:37.747Z,1745268817.747 [Reporter](INFO): platform_buoyancy_position 506.686615 cc
2025-04-21T20:53:38.072Z,1745268818.072 [Reporter](INFO): platform_buoyancy_position 502.523376 cc
2025-04-21T20:53:38.541Z,1745268818.541 [Reporter](INFO): platform_buoyancy_position 496.076935 cc
2025-04-21T20:53:38.887Z,1745268818.887 [Reporter](INFO): platform_buoyancy_position 491.913635 cc
2025-04-21T20:53:39.374Z,1745268819.374 [Reporter](INFO): platform_buoyancy_position 485.332947 cc
2025-04-21T20:53:39.723Z,1745268819.723 [Reporter](INFO): platform_buoyancy_position 481.035339 cc
2025-04-21T20:53:40.108Z,1745268820.108 [Reporter](INFO): platform_buoyancy_position 476.603455 cc
2025-04-21T20:53:40.505Z,1745268820.505 [Reporter](INFO): platform_buoyancy_position 470.291321 cc
2025-04-21T20:53:40.883Z,1745268820.883 [Reporter](INFO): platform_buoyancy_position 465.859436 cc
2025-04-21T20:53:41.326Z,1745268821.326 [Reporter](INFO): platform_buoyancy_position 459.681641 cc
2025-04-21T20:53:41.726Z,1745268821.726 [Reporter](INFO): platform_buoyancy_position 454.175354 cc
2025-04-21T20:53:42.052Z,1745268822.052 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:53:42.103Z,1745268822.103 [Reporter](INFO): platform_buoyancy_position 448.937622 cc
2025-04-21T20:53:42.502Z,1745268822.502 [Reporter](INFO): platform_buoyancy_position 444.371460 cc
2025-04-21T20:53:43.017Z,1745268823.017 [Reporter](INFO): platform_buoyancy_position 438.059326 cc
2025-04-21T20:53:43.474Z,1745268823.474 [Reporter](INFO): platform_buoyancy_position 433.761719 cc
2025-04-21T20:53:43.789Z,1745268823.789 [Reporter](INFO): platform_buoyancy_position 427.449646 cc
2025-04-21T20:53:44.250Z,1745268824.250 [Reporter](INFO): platform_buoyancy_position 423.017761 cc
2025-04-21T20:53:44.602Z,1745268824.602 [Reporter](INFO): platform_buoyancy_position 416.571350 cc
2025-04-21T20:53:44.967Z,1745268824.967 [Reporter](INFO): platform_buoyancy_position 412.273743 cc
2025-04-21T20:53:45.377Z,1745268825.377 [Reporter](INFO): platform_buoyancy_position 405.961670 cc
2025-04-21T20:53:45.818Z,1745268825.818 [Reporter](INFO): platform_buoyancy_position 399.515259 cc
2025-04-21T20:53:46.159Z,1745268826.159 [Reporter](INFO): platform_buoyancy_position 395.351929 cc
2025-04-21T20:53:46.616Z,1745268826.616 [Reporter](INFO): platform_buoyancy_position 390.517151 cc
2025-04-21T20:53:46.982Z,1745268826.982 [Reporter](INFO): platform_buoyancy_position 384.473633 cc
2025-04-21T20:53:47.407Z,1745268827.407 [Reporter](INFO): platform_buoyancy_position 380.176025 cc
2025-04-21T20:53:47.847Z,1745268827.847 [Reporter](INFO): platform_buoyancy_position 373.595337 cc
2025-04-21T20:53:48.195Z,1745268828.195 [Reporter](INFO): platform_buoyancy_position 369.432068 cc
2025-04-21T20:53:48.693Z,1745268828.693 [Reporter](INFO): platform_buoyancy_position 362.851318 cc
2025-04-21T20:53:49.024Z,1745268829.024 [Reporter](INFO): platform_buoyancy_position 358.688049 cc
2025-04-21T20:53:49.490Z,1745268829.490 [Reporter](INFO): platform_buoyancy_position 352.241638 cc
2025-04-21T20:53:49.838Z,1745268829.838 [Reporter](INFO): platform_buoyancy_position 347.944031 cc
2025-04-21T20:53:50.180Z,1745268830.180 [Reporter](INFO): platform_buoyancy_position 343.512146 cc
2025-04-21T20:53:50.619Z,1745268830.619 [Reporter](INFO): platform_buoyancy_position 337.200012 cc
2025-04-21T20:53:50.970Z,1745268830.970 [Reporter](INFO): platform_buoyancy_position 332.902466 cc
2025-04-21T20:53:51.406Z,1745268831.406 [Reporter](INFO): platform_buoyancy_position 327.261841 cc
2025-04-21T20:53:51.826Z,1745268831.826 [Reporter](INFO): platform_buoyancy_position 322.158447 cc
2025-04-21T20:53:52.180Z,1745268832.180 [Reporter](INFO): platform_buoyancy_position 317.726562 cc
2025-04-21T20:53:52.655Z,1745268832.655 [Reporter](INFO): platform_buoyancy_position 311.280151 cc
2025-04-21T20:53:52.856Z,1745268832.856 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:53:53.019Z,1745268833.019 [Reporter](INFO): platform_buoyancy_position 306.176727 cc
2025-04-21T20:53:53.415Z,1745268833.415 [Reporter](INFO): platform_buoyancy_position 300.670441 cc
2025-04-21T20:53:53.969Z,1745268833.969 [Reporter](INFO): platform_buoyancy_position 296.238525 cc
2025-04-21T20:53:54.362Z,1745268834.362 [Reporter](INFO): platform_buoyancy_position 289.792145 cc
2025-04-21T20:53:54.813Z,1745268834.813 [Reporter](INFO): platform_buoyancy_position 283.480042 cc
2025-04-21T20:53:55.129Z,1745268835.129 [Reporter](INFO): platform_buoyancy_position 279.048126 cc
2025-04-21T20:53:55.529Z,1745268835.529 [Reporter](INFO): platform_buoyancy_position 272.870331 cc
2025-04-21T20:53:56.005Z,1745268836.005 [Reporter](INFO): platform_buoyancy_position 268.304138 cc
2025-04-21T20:53:56.250Z,1745268836.250 [Reporter](INFO): platform_buoyancy_position 264.006531 cc
2025-04-21T20:53:56.779Z,1745268836.779 [Reporter](INFO): platform_buoyancy_position 256.217133 cc
2025-04-21T20:53:57.095Z,1745268837.095 [Reporter](INFO): platform_buoyancy_position 253.262558 cc
2025-04-21T20:53:57.555Z,1745268837.555 [Reporter](INFO): platform_buoyancy_position 246.950424 cc
2025-04-21T20:53:58.046Z,1745268838.046 [Reporter](INFO): platform_buoyancy_position 240.906921 cc
2025-04-21T20:53:58.428Z,1745268838.428 [Reporter](INFO): platform_buoyancy_position 236.206421 cc
2025-04-21T20:53:59.086Z,1745268839.086 [Reporter](INFO): platform_buoyancy_position 229.760040 cc
2025-04-21T20:53:59.389Z,1745268839.389 [Reporter](INFO): platform_buoyancy_position 224.388031 cc
2025-04-21T20:53:59.760Z,1745268839.760 [Reporter](INFO): platform_buoyancy_position 220.896240 cc
2025-04-21T20:54:00.447Z,1745268840.447 [Reporter](INFO): platform_buoyancy_position 214.987030 cc
2025-04-21T20:54:00.825Z,1745268840.825 [Reporter](INFO): platform_buoyancy_position 210.420837 cc
2025-04-21T20:54:01.002Z,1745268841.002 [Reporter](INFO): platform_buoyancy_position 208.272034 cc
2025-04-21T20:54:01.423Z,1745268841.423 [Reporter](INFO): platform_buoyancy_position 206.123230 cc
2025-04-21T20:54:01.721Z,1745268841.721 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for beam range. Device response is::RA, 0.00, 76.32, 88.10
2025-04-21T20:54:01.842Z,1745268841.842 [Reporter](INFO): platform_buoyancy_position 201.691315 cc
2025-04-21T20:54:02.341Z,1745268842.341 [Reporter](INFO): platform_buoyancy_position 195.513519 cc
2025-04-21T20:54:02.770Z,1745268842.770 [Reporter](INFO): platform_buoyancy_position 190.947327 cc
2025-04-21T20:54:03.069Z,1745268843.069 [Reporter](INFO): platform_buoyancy_position 186.381134 cc
2025-04-21T20:54:03.436Z,1745268843.436 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:54:03.530Z,1745268843.530 [Reporter](INFO): platform_buoyancy_position 181.143433 cc
2025-04-21T20:54:03.881Z,1745268843.881 [Reporter](INFO): platform_buoyancy_position 175.905731 cc
2025-04-21T20:54:04.246Z,1745268844.246 [Reporter](INFO): platform_buoyancy_position 169.459320 cc
2025-04-21T20:54:04.666Z,1745268844.666 [Reporter](INFO): platform_buoyancy_position 165.296021 cc
2025-04-21T20:54:05.067Z,1745268845.067 [Reporter](INFO): platform_buoyancy_position 158.849640 cc
2025-04-21T20:54:05.442Z,1745268845.442 [Reporter](INFO): platform_buoyancy_position 154.686340 cc
2025-04-21T20:54:05.906Z,1745268845.906 [Reporter](INFO): platform_buoyancy_position 147.971313 cc
2025-04-21T20:54:06.294Z,1745268846.294 [Reporter](INFO): platform_buoyancy_position 143.808014 cc
2025-04-21T20:54:06.718Z,1745268846.718 [Reporter](INFO): platform_buoyancy_position 137.630219 cc
2025-04-21T20:54:07.247Z,1745268847.247 [Reporter](INFO): platform_buoyancy_position 132.929718 cc
2025-04-21T20:54:07.707Z,1745268847.707 [Reporter](INFO): platform_buoyancy_position 126.617615 cc
2025-04-21T20:54:08.170Z,1745268848.170 [Reporter](INFO): platform_buoyancy_position 120.977020 cc
2025-04-21T20:54:08.741Z,1745268848.741 [Reporter](INFO): platform_buoyancy_position 116.007935 cc
2025-04-21T20:54:09.241Z,1745268849.241 [Reporter](INFO): platform_buoyancy_position 109.427216 cc
2025-04-21T20:54:09.687Z,1745268849.687 [Reporter](INFO): platform_buoyancy_position 104.995331 cc
2025-04-21T20:54:10.228Z,1745268850.228 [Reporter](INFO): platform_buoyancy_position 100.832031 cc
2025-04-21T20:54:10.615Z,1745268850.615 [Reporter](INFO): platform_buoyancy_position 98.548920 cc
2025-04-21T20:54:11.212Z,1745268851.212 [Reporter](INFO): platform_buoyancy_position 93.714111 cc
2025-04-21T20:54:11.570Z,1745268851.570 [Reporter](INFO): platform_buoyancy_position 89.953735 cc
2025-04-21T20:54:12.175Z,1745268852.175 [Reporter](INFO): platform_buoyancy_position 85.924713 cc
2025-04-21T20:54:16.669Z,1745268856.669 [Reporter](INFO): platform_buoyancy_position 79.209717 cc
2025-04-21T20:54:21.654Z,1745268861.654 [Reporter](INFO): platform_buoyancy_position 79.344025 cc
2025-04-21T20:54:22.014Z,1745268862.014 [Reporter](INFO): platform_buoyancy_position 83.641632 cc
2025-04-21T20:54:22.422Z,1745268862.422 [Reporter](INFO): platform_buoyancy_position 85.790436 cc
2025-04-21T20:54:22.767Z,1745268862.767 [Reporter](INFO): platform_buoyancy_position 88.073517 cc
2025-04-21T20:54:23.186Z,1745268863.186 [Reporter](INFO): platform_buoyancy_position 92.236816 cc
2025-04-21T20:54:23.458Z,1745268863.458 [Reporter](INFO): platform_buoyancy_position 96.265808 cc
2025-04-21T20:54:23.861Z,1745268863.861 [Reporter](INFO): platform_buoyancy_position 98.683228 cc
2025-04-21T20:54:24.234Z,1745268864.234 [Reporter](INFO): platform_buoyancy_position 102.980835 cc
2025-04-21T20:54:24.849Z,1745268864.849 [Reporter](INFO): platform_buoyancy_position 111.173126 cc
2025-04-21T20:54:25.223Z,1745268865.223 [Reporter](INFO): platform_buoyancy_position 113.590515 cc
2025-04-21T20:54:25.464Z,1745268865.464 [Reporter](INFO): platform_buoyancy_position 116.007935 cc
2025-04-21T20:54:25.978Z,1745268865.978 [Reporter](INFO): platform_buoyancy_position 120.171234 cc
2025-04-21T20:54:26.267Z,1745268866.267 [Reporter](INFO): platform_buoyancy_position 122.185722 cc
2025-04-21T20:54:26.786Z,1745268866.786 [Reporter](INFO): platform_buoyancy_position 125.274628 cc
2025-04-21T20:54:27.222Z,1745268867.222 [Reporter](INFO): platform_buoyancy_position 128.900726 cc
2025-04-21T20:54:27.479Z,1745268867.479 [Reporter](INFO): platform_buoyancy_position 130.780914 cc
2025-04-21T20:54:30.586Z,1745268870.586 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Stopped
2025-04-21T20:54:30.587Z,1745268870.587 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](INFO): Completed sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth
2025-04-21T20:54:30.587Z,1745268870.587 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth] Stopped
2025-04-21T20:54:30.587Z,1745268870.587 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth
2025-04-21T20:54:30.587Z,1745268870.587 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Stopped
2025-04-21T20:54:30.587Z,1745268870.587 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Uninitialize.
2025-04-21T20:54:30.587Z,1745268870.587 [sink:RunSink:BallastAndTrim:GoToTargetDepth](INFO): Completed sink:RunSink:BallastAndTrim:GoToTargetDepth
2025-04-21T20:54:30.592Z,1745268870.592 [sink:RunSink:BallastAndTrim:GoToTargetDepth] Stopped
2025-04-21T20:54:30.592Z,1745268870.592 [sink:RunSink:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth
2025-04-21T20:54:30.592Z,1745268870.592 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Stopped
2025-04-21T20:54:30.592Z,1745268870.592 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth] Running Loop=1
2025-04-21T20:54:30.592Z,1745268870.592 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth
2025-04-21T20:54:30.592Z,1745268870.592 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed] Running Loop=1
2025-04-21T20:54:30.592Z,1745268870.592 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Initialize.
2025-04-21T20:54:30.592Z,1745268870.592 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch] Running Loop=1
2025-04-21T20:54:30.593Z,1745268870.593 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch](DEBUG): Initialize.
2025-04-21T20:54:30.593Z,1745268870.593 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:C] Running Loop=1
2025-04-21T20:54:30.990Z,1745268870.990 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:C](INFO): Waiting for the vehicle to settle. Depth = 1.025834 m
2025-04-21T20:54:30.990Z,1745268870.990 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:C] Stopped
2025-04-21T20:54:30.990Z,1745268870.990 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait] Running Loop=1
2025-04-21T20:54:30.990Z,1745268870.990 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Initialize Wait Component.
2025-04-21T20:54:30.990Z,1745268870.990 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch] Running Loop=1
2025-04-21T20:54:30.990Z,1745268870.990 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed] Running Loop=1
2025-04-21T20:54:31.628Z,1745268871.628 [Reporter](INFO): platform_buoyancy_position 137.361633 cc
2025-04-21T20:54:32.051Z,1745268872.051 [Reporter](INFO): platform_buoyancy_position 138.436035 cc
2025-04-21T20:54:32.198Z,1745268872.198 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,32768,-32768,V
2025-04-21T20:54:32.606Z,1745268872.606 [Reporter](INFO): platform_buoyancy_position 139.510437 cc
2025-04-21T20:54:32.890Z,1745268872.890 [Reporter](INFO): platform_buoyancy_position 141.659210 cc
2025-04-21T20:54:33.242Z,1745268873.242 [Reporter](INFO): platform_buoyancy_position 145.956818 cc
2025-04-21T20:54:33.703Z,1745268873.703 [Reporter](INFO): platform_buoyancy_position 148.105621 cc
2025-04-21T20:54:34.133Z,1745268874.133 [Reporter](INFO): platform_buoyancy_position 152.403229 cc
2025-04-21T20:54:34.646Z,1745268874.646 [Reporter](INFO): platform_buoyancy_position 154.552032 cc
2025-04-21T20:54:35.256Z,1745268875.256 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:54:43.834Z,1745268883.834 [Reporter](INFO): platform_buoyancy_position 160.729828 cc
2025-04-21T20:54:44.219Z,1745268884.219 [Reporter](INFO): platform_buoyancy_position 160.998413 cc
2025-04-21T20:54:44.647Z,1745268884.647 [Reporter](INFO): platform_buoyancy_position 158.849640 cc
2025-04-21T20:54:44.950Z,1745268884.950 [Reporter](INFO): platform_buoyancy_position 156.566528 cc
2025-04-21T20:54:45.494Z,1745268885.494 [Reporter](INFO): platform_buoyancy_position 154.552032 cc
2025-04-21T20:54:45.850Z,1745268885.850 [Reporter](INFO): platform_buoyancy_position 150.254425 cc
2025-04-21T20:54:46.119Z,1745268886.119 [Reporter](INFO): platform_buoyancy_position 147.971313 cc
2025-04-21T20:54:46.834Z,1745268886.834 [Reporter](INFO): platform_buoyancy_position 141.659210 cc
2025-04-21T20:54:51.170Z,1745268891.170 [Reporter](INFO): platform_buoyancy_position 135.212830 cc
2025-04-21T20:55:02.065Z,1745268902.065 [Reporter](INFO): platform_buoyancy_position 135.078522 cc
2025-04-21T20:55:02.565Z,1745268902.565 [Reporter](INFO): platform_buoyancy_position 135.347137 cc
2025-04-21T20:55:02.758Z,1745268902.758 [Reporter](INFO): platform_buoyancy_position 137.361633 cc
2025-04-21T20:55:03.267Z,1745268903.267 [Reporter](INFO): platform_buoyancy_position 139.510437 cc
2025-04-21T20:55:03.378Z,1745268903.378 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.942589
2025-04-21T20:55:04.380Z,1745268904.380 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:55:07.730Z,1745268907.730 [Reporter](INFO): platform_buoyancy_position 145.822540 cc
2025-04-21T20:55:20.247Z,1745268920.247 [Reporter](INFO): platform_buoyancy_position 146.225433 cc
2025-04-21T20:55:24.677Z,1745268924.677 [Reporter](INFO): platform_buoyancy_position 143.673737 cc
2025-04-21T20:55:34.526Z,1745268934.526 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-21T20:55:35.528Z,1745268935.528 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:55:50.138Z,1745268950.138 [Reporter](INFO): platform_buoyancy_position 145.822540 cc
2025-04-21T20:55:55.254Z,1745268955.254 [WetLabsUBAT](ERROR): Failed to parse incomplete device message.
2025-04-21T20:55:59.607Z,1745268959.607 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD, +0.00, +0. +0.00, 20.00,2146.56
2025-04-21T20:56:05.652Z,1745268965.652 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-21T20:56:06.656Z,1745268966.656 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:56:15.010Z,1745268975.010 [Reporter](INFO): platform_buoyancy_position 139.376129 cc
2025-04-21T20:56:36.782Z,1745268996.782 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-21T20:56:37.788Z,1745268997.788 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:56:43.328Z,1745269003.328 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS-32768,V
2025-04-21T20:56:56.261Z,1745269016.261 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-2768,-32768,V
2025-04-21T20:57:07.927Z,1745269027.927 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-21T20:57:08.928Z,1745269028.928 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:57:16.871Z,1745269036.871 [Reporter](INFO): platform_buoyancy_position 139.510437 cc
2025-04-21T20:57:39.048Z,1745269059.048 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-21T20:57:40.052Z,1745269060.052 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:57:45.149Z,1745269065.149 [Reporter](INFO): platform_buoyancy_position 138.301727 cc
2025-04-21T20:57:45.343Z,1745269065.343 [Reporter](INFO): platform_buoyancy_position 139.107513 cc
2025-04-21T20:57:45.711Z,1745269065.711 [Reporter](INFO): platform_buoyancy_position 137.764526 cc
2025-04-21T20:57:46.245Z,1745269066.245 [Reporter](INFO): platform_buoyancy_position 133.064026 cc
2025-04-21T20:57:53.658Z,1745269073.658 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-21T20:58:00.885Z,1745269080.885 [Reporter](INFO): platform_buoyancy_position 130.780914 cc
2025-04-21T20:58:01.578Z,1745269081.578 [Reporter](INFO): platform_buoyancy_position 130.915222 cc
2025-04-21T20:58:01.990Z,1745269081.990 [Reporter](INFO): platform_buoyancy_position 132.929718 cc
2025-04-21T20:58:02.422Z,1745269082.422 [Reporter](INFO): platform_buoyancy_position 137.227325 cc
2025-04-21T20:58:10.172Z,1745269090.172 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-21T20:58:11.176Z,1745269091.176 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:58:12.918Z,1745269092.918 [Reporter](INFO): platform_buoyancy_position 141.390625 cc
2025-04-21T20:58:13.295Z,1745269093.295 [Reporter](INFO): platform_buoyancy_position 141.659210 cc
2025-04-21T20:58:13.705Z,1745269093.705 [Reporter](INFO): platform_buoyancy_position 141.524933 cc
2025-04-21T20:58:13.954Z,1745269093.954 [Reporter](INFO): platform_buoyancy_position 139.241821 cc
2025-04-21T20:58:14.653Z,1745269094.653 [Reporter](INFO): platform_buoyancy_position 135.212830 cc
2025-04-21T20:58:19.114Z,1745269099.114 [Reporter](INFO): platform_buoyancy_position 126.483337 cc
2025-04-21T20:58:24.382Z,1745269104.382 [NAL9602](INFO): Not Powering down - fast GPS
2025-04-21T20:58:24.806Z,1745269104.806 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for water velocity. Device response is::WS,-32768,-32768,-3
2025-04-21T20:58:26.355Z,1745269106.355 [Reporter](INFO): platform_buoyancy_position 128.632111 cc
2025-04-21T20:58:26.958Z,1745269106.958 [Reporter](INFO): platform_buoyancy_position 130.780914 cc
2025-04-21T20:58:27.434Z,1745269107.434 [Reporter](INFO): platform_buoyancy_position 132.526825 cc
2025-04-21T20:58:41.300Z,1745269121.300 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-21T20:58:42.304Z,1745269122.304 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:58:43.619Z,1745269123.619 [Reporter](INFO): platform_buoyancy_position 139.644714 cc
2025-04-21T20:58:44.070Z,1745269124.070 [Reporter](INFO): platform_buoyancy_position 139.376129 cc
2025-04-21T20:58:44.546Z,1745269124.546 [Reporter](INFO): platform_buoyancy_position 139.510437 cc
2025-04-21T20:58:44.970Z,1745269124.970 [Reporter](INFO): platform_buoyancy_position 135.212830 cc
2025-04-21T20:58:45.303Z,1745269125.303 [Reporter](INFO): platform_buoyancy_position 132.929718 cc
2025-04-21T20:58:45.546Z,1745269125.546 [Reporter](INFO): platform_buoyancy_position 130.915222 cc
2025-04-21T20:58:46.257Z,1745269126.257 [Reporter](INFO): platform_buoyancy_position 126.617615 cc
2025-04-21T20:58:55.846Z,1745269135.846 [Reporter](INFO): platform_buoyancy_position 124.334534 cc
2025-04-21T20:58:56.527Z,1745269136.527 [Reporter](INFO): platform_buoyancy_position 124.468819 cc
2025-04-21T20:58:56.913Z,1745269136.913 [Reporter](INFO): platform_buoyancy_position 128.766418 cc
2025-04-21T20:58:57.448Z,1745269137.448 [Reporter](INFO): platform_buoyancy_position 132.929718 cc
2025-04-21T20:59:10.534Z,1745269150.534 [Reporter](INFO): platform_buoyancy_position 139.376129 cc
2025-04-21T20:59:11.725Z,1745269151.725 [Reporter](INFO): platform_buoyancy_position 133.064026 cc
2025-04-21T20:59:12.047Z,1745269152.047 [Reporter](INFO): platform_buoyancy_position 130.512329 cc
2025-04-21T20:59:12.428Z,1745269152.428 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-21T20:59:12.450Z,1745269152.450 [Reporter](INFO): platform_buoyancy_position 126.617615 cc
2025-04-21T20:59:13.432Z,1745269153.432 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:59:16.599Z,1745269156.599 [Reporter](INFO): platform_buoyancy_position 120.305511 cc
2025-04-21T20:59:23.770Z,1745269163.770 [Reporter](INFO): platform_buoyancy_position 122.320038 cc
2025-04-21T20:59:24.246Z,1745269164.246 [Reporter](INFO): platform_buoyancy_position 122.185722 cc
2025-04-21T20:59:24.867Z,1745269164.867 [Reporter](INFO): platform_buoyancy_position 122.454308 cc
2025-04-21T20:59:25.333Z,1745269165.333 [Reporter](INFO): platform_buoyancy_position 126.483337 cc
2025-04-21T20:59:25.865Z,1745269165.865 [Reporter](INFO): platform_buoyancy_position 130.780914 cc
2025-04-21T20:59:26.307Z,1745269166.307 [Reporter](INFO): platform_buoyancy_position 133.064026 cc
2025-04-21T20:59:34.830Z,1745269174.830 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, -3.11, ,1.48, 8.00, 0.00
2025-04-21T20:59:38.394Z,1745269178.394 [Reporter](INFO): platform_buoyancy_position 139.376129 cc
2025-04-21T20:59:38.681Z,1745269178.681 [Reporter](INFO): platform_buoyancy_position 139.510437 cc
2025-04-21T20:59:39.382Z,1745269179.382 [Reporter](INFO): platform_buoyancy_position 133.332611 cc
2025-04-21T20:59:39.919Z,1745269179.919 [Reporter](INFO): platform_buoyancy_position 128.900726 cc
2025-04-21T20:59:40.315Z,1745269180.315 [Reporter](INFO): platform_buoyancy_position 124.468819 cc
2025-04-21T20:59:43.552Z,1745269183.552 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-21T20:59:44.556Z,1745269184.556 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T20:59:52.446Z,1745269192.446 [Reporter](INFO): platform_buoyancy_position 119.768311 cc
2025-04-21T20:59:53.131Z,1745269193.131 [Reporter](INFO): platform_buoyancy_position 120.036926 cc
2025-04-21T20:59:53.554Z,1745269193.554 [Reporter](INFO): platform_buoyancy_position 123.125824 cc
2025-04-21T20:59:54.090Z,1745269194.090 [Reporter](INFO): platform_buoyancy_position 128.632111 cc
2025-04-21T20:59:54.446Z,1745269194.446 [Reporter](INFO): platform_buoyancy_position 130.915222 cc
2025-04-21T20:59:58.514Z,1745269198.514 [Reporter](INFO): platform_buoyancy_position 137.361633 cc
2025-04-21T21:00:00.001Z,1745269200.001 [CommandExec](IMPORTANT): got command docking standby
2025-04-21T21:00:00.002Z,1745269200.002 [CommandExec](IMPORTANT): Switching docking module to STANDBY.
2025-04-21T21:00:00.135Z,1745269200.135 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/OnDock.tl
2025-04-21T21:00:00.135Z,1745269200.135 [MissionManager](INFO): Uninitializing Mission sink
2025-04-21T21:00:00.135Z,1745269200.135 [sink] Stopped
2025-04-21T21:00:00.135Z,1745269200.135 [sink](DEBUG): Aggregate::uninitialize sink
2025-04-21T21:00:00.135Z,1745269200.135 [sink:Science] Stopped
2025-04-21T21:00:00.135Z,1745269200.135 [sink:Science](DEBUG): Aggregate::uninitialize sink:Science
2025-04-21T21:00:00.135Z,1745269200.135 [sink:Science:B] Stopped
2025-04-21T21:00:00.135Z,1745269200.135 [sink:Science:C] Stopped
2025-04-21T21:00:00.135Z,1745269200.135 [sink:Science:E] Stopped
2025-04-21T21:00:00.135Z,1745269200.135 [sink:Science:F] Stopped
2025-04-21T21:00:00.135Z,1745269200.135 [sink:Science:OceanCurrent] Stopped
2025-04-21T21:00:00.136Z,1745269200.136 [sink:Science:OceanCurrent](DEBUG): Aggregate::uninitialize sink:Science:OceanCurrent
2025-04-21T21:00:00.136Z,1745269200.136 [sink:Science:OceanCurrent:A.] Stopped
2025-04-21T21:00:00.136Z,1745269200.136 [sink:StandardEnvelopes] Stopped
2025-04-21T21:00:00.136Z,1745269200.136 [sink:StandardEnvelopes](DEBUG): Aggregate::uninitialize sink:StandardEnvelopes
2025-04-21T21:00:00.136Z,1745269200.136 [sink:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-04-21T21:00:00.136Z,1745269200.136 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-04-21T21:00:00.136Z,1745269200.136 [sink:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-04-21T21:00:00.136Z,1745269200.136 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-04-21T21:00:00.136Z,1745269200.136 [sink:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-04-21T21:00:00.136Z,1745269200.136 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-04-21T21:00:00.137Z,1745269200.137 [sink:BackseatDriver] Stopped
2025-04-21T21:00:00.137Z,1745269200.137 [sink:BackseatDriver](DEBUG): Aggregate::uninitialize sink:BackseatDriver
2025-04-21T21:00:00.137Z,1745269200.137 [sink:BackseatDriver:A.BackseatDriver] Stopped
2025-04-21T21:00:00.137Z,1745269200.137 [sink:PowerOnly] Stopped
2025-04-21T21:00:00.137Z,1745269200.137 [sink:PowerOnly](DEBUG): Aggregate::uninitialize sink:PowerOnly
2025-04-21T21:00:00.137Z,1745269200.137 [sink:PowerOnly:E.Wait] Stopped
2025-04-21T21:00:00.137Z,1745269200.137 [sink:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T21:00:00.137Z,1745269200.137 [sink:RunSink] Stopped
2025-04-21T21:00:00.137Z,1745269200.137 [sink:RunSink](DEBUG): Aggregate::uninitialize sink:RunSink
2025-04-21T21:00:00.137Z,1745269200.137 [sink:RunSink:BallastAndTrim] Stopped
2025-04-21T21:00:00.137Z,1745269200.137 [sink:RunSink:BallastAndTrim](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim
2025-04-21T21:00:00.137Z,1745269200.137 [sink:RunSink:BallastAndTrim:A] Stopped
2025-04-21T21:00:00.137Z,1745269200.137 [sink:RunSink:BallastAndTrim:B] Stopped
2025-04-21T21:00:00.137Z,1745269200.137 [sink:RunSink:BallastAndTrim:C] Stopped
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:BallastAndTrim:D] Stopped
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:BallastAndTrim:E] Stopped
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth] Stopped
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed] Stopped
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Uninitialize.
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch] Stopped
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait] Stopped
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:JustSink] Stopped
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:JustSink](DEBUG): Aggregate::uninitialize sink:RunSink:JustSink
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:JustSink:C] Stopped
2025-04-21T21:00:00.138Z,1745269200.138 [sink:RunSink:JustSink:C](DEBUG): Aggregate::uninitialize sink:RunSink:JustSink:C
2025-04-21T21:00:00.281Z,1745269200.281 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/OnDock.tl
2025-04-21T21:00:00.282Z,1745269200.282 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/OnDock.tl
2025-04-21T21:00:00.304Z,1745269200.304 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/OnDock.tl
2025-04-21T21:00:00.409Z,1745269200.409 [DockingStepper](INFO): Changing to mode: 1
2025-04-21T21:00:00.409Z,1745269200.409 [DockingStepper](INFO): Standby mode.
2025-04-21T21:00:00.468Z,1745269200.468 [DockingStepper](INFO): Commanding positive:55467
2025-04-21T21:00:00.477Z,1745269200.477 [WetLabsUBAT](INFO): Powering down
2025-04-21T21:00:00.560Z,1745269200.560 [WetLabsBB2FL](INFO): Powering down
2025-04-21T21:00:03.303Z,1745269203.303 [Reporter](INFO): platform_buoyancy_position 139.510437 cc
2025-04-21T21:00:03.342Z,1745269203.342 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/OnDock.tl translated into:
8
2
1
5
2
2
5
5
Restarting logs
restart logs
! ifconfig
Mission ending, breaking off. Range:
.
2025-04-21T21:00:03.362Z,1745269203.362 [MissionManager](INFO): DefineArg OnDock.DockedTime = 8.000000 h
2025-04-21T21:00:03.365Z,1745269203.365 [MissionManager](INFO): DefineArg OnDock.DetachedTimeout = 30.000000 s
2025-04-21T21:00:03.367Z,1745269203.367 [MissionManager](INFO): DefineArg OnDock.RangeTimeout = 600.000000 s
2025-04-21T21:00:03.369Z,1745269203.369 [MissionManager](INFO): DefineArg OnDock.TrackingUpdatePeriod = 2.000000 min
2025-04-21T21:00:03.371Z,1745269203.371 [MissionManager](INFO): DefineArg OnDock.NumberOfPings = 1.000000 count
2025-04-21T21:00:03.374Z,1745269203.374 [MissionManager](INFO): DefineArg OnDock.TransponderCode = 50 count
2025-04-21T21:00:03.376Z,1745269203.376 [MissionManager](INFO): DefineArg OnDock.MaxDepth = 215.000000 m
2025-04-21T21:00:03.378Z,1745269203.378 [MissionManager](INFO): DefineArg OnDock.MinAltitude = 5.000000 m
2025-04-21T21:00:03.381Z,1745269203.381 [MissionManager](INFO): DefineArg OnDock.MinOffshore = 2.000000 km
2025-04-21T21:00:03.383Z,1745269203.383 [MissionManager](INFO): DefineArg OnDock.StayOnDock = 0 bool
2025-04-21T21:00:03.385Z,1745269203.385 [MissionManager](INFO): DefineArg OnDock.IfconfigInterval = 2.000000 h
2025-04-21T21:00:03.387Z,1745269203.387 [MissionManager](INFO): DefineArg OnDock.RunScience = 0 bool
2025-04-21T21:00:03.389Z,1745269203.389 [MissionManager](INFO): DefineArg OnDock.MissionTimeout = 8.000000 h
2025-04-21T21:00:03.389Z,1745269203.389 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-04-21T21:00:03.389Z,1745269203.389 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-04-21T21:00:03.391Z,1745269203.391 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-04-21T21:00:03.630Z,1745269203.630 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
5
0
200
2000
2025-04-21T21:00:03.641Z,1745269203.641 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MinAltitude = 5.000000 m
2025-04-21T21:00:03.644Z,1745269203.644 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MaxDepthIgnore = 0.000000 m
2025-04-21T21:00:03.647Z,1745269203.647 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MaxDepth = 200.000000 m
2025-04-21T21:00:03.650Z,1745269203.650 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-04-21T21:00:03.651Z,1745269203.651 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-04-21T21:00:03.660Z,1745269203.660 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-04-21T21:00:03.673Z,1745269203.673 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-04-21T21:00:03.702Z,1745269203.702 [Reporter](INFO): platform_buoyancy_position 141.659210 cc
2025-04-21T21:00:03.732Z,1745269203.732 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-04-21T21:00:03.733Z,1745269203.733 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-04-21T21:00:03.734Z,1745269203.734 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-04-21T21:00:03.776Z,1745269203.776 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-04-21T21:00:03.779Z,1745269203.779 [MissionManager](INFO): DefineArg OnDock:BackseatDriver.EnableBackseat = 0 bool
2025-04-21T21:00:03.781Z,1745269203.781 [OnDock:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-04-21T21:00:03.783Z,1745269203.783 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-04-21T21:00:03.784Z,1745269203.784 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-04-21T21:00:03.785Z,1745269203.785 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-04-21T21:00:03.902Z,1745269203.902 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2025-04-21T21:00:03.906Z,1745269203.906 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleAll = 0 bool
2025-04-21T21:00:03.907Z,1745269203.907 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad1 = 0 bool
2025-04-21T21:00:03.915Z,1745269203.915 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad2 = 0 bool
2025-04-21T21:00:03.995Z,1745269203.995 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad3 = 0 bool
2025-04-21T21:00:04.005Z,1745269204.005 [MissionManager](INFO): DefineArg OnDock:PowerOnly.EnabledPowerOnly = 0 bool
2025-04-21T21:00:04.032Z,1745269204.032 [OnDock:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-04-21T21:00:04.035Z,1745269204.035 [OnDock:dataRead:B.Wait](DEBUG): Construct Wait.
2025-04-21T21:00:04.054Z,1745269204.054 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl
2025-04-21T21:00:04.054Z,1745269204.054 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl
2025-04-21T21:00:04.066Z,1745269204.066 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl
2025-04-21T21:00:04.243Z,1745269204.243 [Reporter](INFO): platform_buoyancy_position 147.971313 cc
2025-04-21T21:00:04.509Z,1745269204.509 [Reporter](INFO): platform_buoyancy_position 150.254425 cc
2025-04-21T21:00:04.903Z,1745269204.903 [Reporter](INFO): platform_buoyancy_position 155.357819 cc
2025-04-21T21:00:05.351Z,1745269205.351 [Reporter](INFO): platform_buoyancy_position 160.998413 cc
2025-04-21T21:00:05.709Z,1745269205.709 [Reporter](INFO): platform_buoyancy_position 165.296021 cc
2025-04-21T21:00:06.233Z,1745269206.233 [Reporter](INFO): platform_buoyancy_position 173.756927 cc
2025-04-21T21:00:06.541Z,1745269206.541 [Reporter](INFO): platform_buoyancy_position 177.920227 cc
2025-04-21T21:00:06.705Z,1745269206.705 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into:
NaN
3
100
80
20
5
NaN
NaN
2.0
NaN
NaN
5
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
_.planktivore_LM_AvgRois
_.planktivore_HM_AvgRois
_.planktivore_diatoms
_.planktivore_dinoflagellates
Triggered. PeakChl values on
consecutive yo-yo profiles fall in [
] (NaN bound is ignored).
2025-04-21T21:00:06.731Z,1745269206.731 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectChlActive = 0 bool
2025-04-21T21:00:06.734Z,1745269206.734 [MissionManager](INFO): DefineArg OnDock:science:Science.TimeWindowPeakReport = nan min
2025-04-21T21:00:06.735Z,1745269206.735 [MissionManager](INFO): DefineArg OnDock:science:Science.HighestChlPeakReportActive = 0 bool
2025-04-21T21:00:06.737Z,1745269206.737 [MissionManager](INFO): DefineArg OnDock:science:Science.HighestSaltPeakReportActive = 0 bool
2025-04-21T21:00:06.739Z,1745269206.739 [MissionManager](INFO): DefineArg OnDock:science:Science.HighestOilPeakReportActive = 0 bool
2025-04-21T21:00:06.741Z,1745269206.741 [MissionManager](INFO): DefineArg OnDock:science:Science.PatchTracking = 0 bool
2025-04-21T21:00:06.743Z,1745269206.743 [MissionManager](INFO): DefineArg OnDock:science:Science.FilterWidthHorizontal = 3.000000 count
2025-04-21T21:00:06.745Z,1745269206.745 [MissionManager](INFO): DefineArg OnDock:science:Science.NumProfilesSlidingwindow = 100.000000 count
2025-04-21T21:00:06.747Z,1745269206.747 [MissionManager](INFO): DefineArg OnDock:science:Science.OffPeakFractionHorizontal = 80.000000 %
2025-04-21T21:00:06.817Z,1745269206.817 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectNO3Active = 0 bool
2025-04-21T21:00:06.819Z,1745269206.819 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectOilActive = 0 bool
2025-04-21T21:00:06.838Z,1745269206.838 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectFDOMActive = 0 bool
2025-04-21T21:00:06.839Z,1745269206.839 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectSalinityActive = 0 bool
2025-04-21T21:00:06.852Z,1745269206.852 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreLMavgROIActive = 0 bool
2025-04-21T21:00:06.854Z,1745269206.854 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreHMavgROIActive = 0 bool
2025-04-21T21:00:06.864Z,1745269206.864 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreDiatomsActive = 0 bool
2025-04-21T21:00:06.866Z,1745269206.866 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreDinoflagellatesActive = 0 bool
2025-04-21T21:00:06.876Z,1745269206.876 [MissionManager](INFO): DefineArg OnDock:science:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2025-04-21T21:00:06.888Z,1745269206.888 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledAanderaaO2 = 0 bool
2025-04-21T21:00:06.896Z,1745269206.896 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledNeilBrown = 0 bool
2025-04-21T21:00:06.899Z,1745269206.899 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledSeabird = 1 bool
2025-04-21T21:00:06.902Z,1745269206.902 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledWetLabsBB2FL = 1 bool
2025-04-21T21:00:06.914Z,1745269206.914 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool
2025-04-21T21:00:06.918Z,1745269206.918 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledWetLabsUBAT = 1 bool
2025-04-21T21:00:06.950Z,1745269206.950 [MissionManager](INFO): DefineArg OnDock:science:Science.LowPassWindowLength = 20.000000 count
2025-04-21T21:00:06.977Z,1745269206.977 [Reporter](INFO): platform_buoyancy_position 182.486420 cc
2025-04-21T21:00:06.989Z,1745269206.989 [MissionManager](INFO): DefineArg OnDock:science:Science.MedianFilterLen = 5.000000 count
2025-04-21T21:00:07.011Z,1745269207.011 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakShallowBound = nan m
2025-04-21T21:00:07.019Z,1745269207.019 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDeepBound = nan m
2025-04-21T21:00:07.021Z,1745269207.021 [MissionManager](INFO): DefineArg OnDock:science:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2025-04-21T21:00:07.023Z,1745269207.023 [MissionManager](INFO): DefineArg OnDock:science:Science.ChlThreshTriggerActive = 0 bool
2025-04-21T21:00:07.033Z,1745269207.033 [MissionManager](INFO): DefineArg OnDock:science:Science.ChlLowerThresh = nan ug/l
2025-04-21T21:00:07.035Z,1745269207.035 [MissionManager](INFO): DefineArg OnDock:science:Science.ChlUpperThresh = nan ug/l
2025-04-21T21:00:07.037Z,1745269207.037 [MissionManager](INFO): DefineArg OnDock:science:Science.NumProfilesThresh = 5.000000 count
2025-04-21T21:00:07.039Z,1745269207.039 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChl = nan ug/l
2025-04-21T21:00:07.050Z,1745269207.050 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlDepth = nan m
2025-04-21T21:00:07.060Z,1745269207.060 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlTemperature = nan degC
2025-04-21T21:00:07.062Z,1745269207.062 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlLatitude = nan arcdeg
2025-04-21T21:00:07.067Z,1745269207.067 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlLongitude = nan arcdeg
2025-04-21T21:00:07.085Z,1745269207.085 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3 = nan umol/l
2025-04-21T21:00:07.087Z,1745269207.087 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3Depth = nan m
2025-04-21T21:00:07.102Z,1745269207.102 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3Latitude = nan arcdeg
2025-04-21T21:00:07.116Z,1745269207.116 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3Longitude = nan arcdeg
2025-04-21T21:00:07.118Z,1745269207.118 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOil = nan kg/m3
2025-04-21T21:00:07.129Z,1745269207.129 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOilDepth = nan m
2025-04-21T21:00:07.131Z,1745269207.131 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOilLatitude = nan arcdeg
2025-04-21T21:00:07.145Z,1745269207.145 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOilLongitude = nan arcdeg
2025-04-21T21:00:07.147Z,1745269207.147 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOM = nan ppb
2025-04-21T21:00:07.182Z,1745269207.182 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMDepth = nan m
2025-04-21T21:00:07.208Z,1745269207.208 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMTemperature = nan degC
2025-04-21T21:00:07.210Z,1745269207.210 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMLatitude = nan arcdeg
2025-04-21T21:00:07.221Z,1745269207.221 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMLongitude = nan arcdeg
2025-04-21T21:00:07.223Z,1745269207.223 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSalt = nan psu
2025-04-21T21:00:07.239Z,1745269207.239 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltDepth = nan m
2025-04-21T21:00:07.258Z,1745269207.258 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltTemperature = nan degC
2025-04-21T21:00:07.280Z,1745269207.280 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltLatitude = nan arcdeg
2025-04-21T21:00:07.282Z,1745269207.282 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltLongitude = nan arcdeg
2025-04-21T21:00:07.297Z,1745269207.297 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROI = nan count/s
2025-04-21T21:00:07.299Z,1745269207.299 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROIDepth = nan m
2025-04-21T21:00:07.318Z,1745269207.318 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROITemperature = nan degC
2025-04-21T21:00:07.333Z,1745269207.333 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROILatitude = nan arcdeg
2025-04-21T21:00:07.335Z,1745269207.335 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROILongitude = nan arcdeg
2025-04-21T21:00:07.354Z,1745269207.354 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROI = nan count/s
2025-04-21T21:00:07.364Z,1745269207.364 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROIDepth = nan m
2025-04-21T21:00:07.367Z,1745269207.367 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROITemperature = nan degC
2025-04-21T21:00:07.379Z,1745269207.379 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROILatitude = nan arcdeg
2025-04-21T21:00:07.400Z,1745269207.400 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROILongitude = nan arcdeg
2025-04-21T21:00:07.402Z,1745269207.402 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatoms = nan count/ml
2025-04-21T21:00:07.417Z,1745269207.417 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsDepth = nan m
2025-04-21T21:00:07.426Z,1745269207.426 [Reporter](INFO): platform_buoyancy_position 188.798523 cc
2025-04-21T21:00:07.428Z,1745269207.428 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsTemperature = nan degC
2025-04-21T21:00:07.430Z,1745269207.430 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsLatitude = nan arcdeg
2025-04-21T21:00:07.445Z,1745269207.445 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsLongitude = nan arcdeg
2025-04-21T21:00:07.448Z,1745269207.448 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellates = nan count/ml
2025-04-21T21:00:07.450Z,1745269207.450 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesDepth = nan m
2025-04-21T21:00:07.460Z,1745269207.460 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesTemperature = nan degC
2025-04-21T21:00:07.463Z,1745269207.463 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesLatitude = nan arcdeg
2025-04-21T21:00:07.474Z,1745269207.474 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesLongitude = nan arcdeg
2025-04-21T21:00:07.504Z,1745269207.504 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChl = nan ug/l
2025-04-21T21:00:07.511Z,1745269207.511 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlDepth = nan m
2025-04-21T21:00:07.523Z,1745269207.523 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlLatitude = nan arcdeg
2025-04-21T21:00:07.537Z,1745269207.537 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlLongitude = nan arcdeg
2025-04-21T21:00:07.539Z,1745269207.539 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlDistance = nan m
2025-04-21T21:00:07.581Z,1745269207.581 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSalt = nan psu
2025-04-21T21:00:07.583Z,1745269207.583 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltDepth = nan m
2025-04-21T21:00:07.594Z,1745269207.594 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltLatitude = nan arcdeg
2025-04-21T21:00:07.608Z,1745269207.608 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltLongitude = nan arcdeg
2025-04-21T21:00:07.610Z,1745269207.610 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltDistance = nan m
2025-04-21T21:00:07.644Z,1745269207.644 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOil = nan psu
2025-04-21T21:00:07.646Z,1745269207.646 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilDepth = nan m
2025-04-21T21:00:07.659Z,1745269207.659 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilLatitude = nan arcdeg
2025-04-21T21:00:07.674Z,1745269207.674 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilLongitude = nan arcdeg
2025-04-21T21:00:07.701Z,1745269207.701 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilDistance = nan m
2025-04-21T21:00:07.703Z,1745269207.703 [MissionManager](INFO): DefineOutput OnDock:science:Science.TriggeredOnChl = 0 bool
2025-04-21T21:00:07.715Z,1745269207.715 [MissionManager](INFO): DefineOutput OnDock:science:Science.ChlTriggering = nan ug/l
2025-04-21T21:00:07.766Z,1745269207.766 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T21:00:07.775Z,1745269207.775 [Reporter](INFO): platform_buoyancy_position 193.230438 cc
2025-04-21T21:00:07.829Z,1745269207.829 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-21T21:00:07.865Z,1745269207.865 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T21:00:07.895Z,1745269207.895 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T21:00:07.924Z,1745269207.924 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-21T21:00:08.007Z,1745269208.007 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T21:00:08.073Z,1745269208.073 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T21:00:08.121Z,1745269208.121 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-21T21:00:08.176Z,1745269208.176 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T21:00:08.234Z,1745269208.234 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T21:00:08.313Z,1745269208.313 [Reporter](INFO): platform_buoyancy_position 199.811127 cc
2025-04-21T21:00:08.315Z,1745269208.315 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T21:00:08.343Z,1745269208.343 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-21T21:00:08.407Z,1745269208.407 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect.
2025-04-21T21:00:08.517Z,1745269208.517 [OnDock:L.Execute](DEBUG): Construct Execute.
2025-04-21T21:00:08.531Z,1745269208.531 [OnDock:PeriodicCheck:CheckIP:A.Execute](DEBUG): Construct Execute.
2025-04-21T21:00:08.538Z,1745269208.538 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Construct Wait.
2025-04-21T21:00:08.539Z,1745269208.539 [OnDock:N.Docked](DEBUG): Construct.
2025-04-21T21:00:08.539Z,1745269208.539 [OnDock:N.Docked](DEBUG): Initializing internal variables to default values.
2025-04-21T21:00:08.586Z,1745269208.586 [OnDock:Detach:B.Undock](DEBUG): Construct.
2025-04-21T21:00:08.587Z,1745269208.587 [OnDock:Detach:B.Undock](DEBUG): Initializing internal variables to default values.
2025-04-21T21:00:08.670Z,1745269208.670 [Reporter](INFO): platform_buoyancy_position 203.840118 cc
2025-04-21T21:00:08.677Z,1745269208.677 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission {
"""
Wait on dock, communicating when possible
"""
arguments {
DockedTime = 8 hour
"""
Time to stay on dock. Mission timeout will be five minutes longer.
"""
DetachedTimeout = Dock:Docked.detachTimeout
"""
Time duration limit for determining if the vehicle is detached from the
dock.
"""
RangeTimeout = Dock:Docked.rangeTimeout
"""
Maximum allowed time without acoustic range.
"""
TrackingUpdatePeriod = 2 minute
"""
How long to wait between acoustic queries.
"""
NumberOfPings = 1 count
"""
Number of pings requested each time.
"""
TransponderCode = Dock:Dock.transponderCode
"""
Transponder Address.
"""
MaxDepth = BIT:CBIT.stopDepth
"""
Maximum depth while docked.
"""
MinAltitude = 5 meter
"""
Minimum altitude
"""
MinOffshore = 2 km
"""
Minimum offshore
"""
StayOnDock = false
"""
If true, don't detach from dock at end of mission
"""
IfconfigInterval = 2 hour
"""
How long to wait between ifconfig runs
"""
RunScience = false
"""
If true, run Science while on the dock.
"""
# Mission variables (do not change)
MissionTimeout = DockedTime
"""
Mission timeout (local variable, do not change)
"""
}
timeout duration=MissionTimeout
insert Insert/StandardEnvelopes.tl
assign in sequence StandardEnvelopes:MinAltitude = MinAltitude
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
# End docking 5 minutes before end of mission to allow clean undock
assign in sequence MissionTimeout = DockedTime + 5 minute
insert Insert/BackseatDriver.tl
insert Insert/PowerOnly.tl
# Send data when connection exists
aggregate dataRead {
run while ( true )
readDatum {
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
}
aggregate science {
run in parallel
break if ( not RunScience )
insert Insert/Science.tl
}
behavior Estimation:TrackAcousticContact {
run in parallel
set contactLabelSetting = TransponderCode
set numberOfSamplesSetting = NumberOfPings
set updatePeriodSetting = TrackingUpdatePeriod
}
syslog important "Restarting logs"
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
aggregate PeriodicCheck {
run in parallel
aggregate CheckIP {
run in sequence
behavior Guidance:Execute {
run in sequence
set command = "! ifconfig"
}
behavior Guidance:Wait {
run in sequence
set duration = IfconfigInterval
}
}
}
behavior Dock:Docked {
run in sequence
timeout duration=DockedTime
set detachTimeout = DetachedTimeout
set rangeTimeout = RangeTimeout
}
# Undock cleanly, instead of relying on DefaultWithUndock to come next
aggregate Detach {
run in sequence
break if ( StayOnDock == true )
syslog important "Mission ending, breaking off. Range: "
+ Estimation:TrackAcousticContact.range_to_contact~meter + "."
behavior Dock:Undock {
run in sequence
}
}
}
2025-04-21T21:00:08.677Z,1745269208.677 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/OnDock.tl id=OnDock
2025-04-21T21:00:08.820Z,1745269208.820 [MissionManager](IMPORTANT): Started mission DefaultTankUndock
2025-04-21T21:00:08.820Z,1745269208.820 [DefaultTankUndock] Running Loop=1
2025-04-21T21:00:08.820Z,1745269208.820 [DefaultTankUndock](DEBUG): Aggregate::initialize DefaultTankUndock
2025-04-21T21:00:08.820Z,1745269208.820 [DefaultTankUndock:B.GoToSurface] Running Loop=1
2025-04-21T21:00:08.820Z,1745269208.820 [DefaultTankUndock:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-21T21:00:08.821Z,1745269208.821 [DefaultTankUndock:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-21T21:00:08.821Z,1745269208.821 [DefaultTankUndock:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-21T21:00:08.821Z,1745269208.821 [DefaultTankUndock:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-21T21:00:08.822Z,1745269208.822 [DefaultTankUndock:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-21T21:00:08.822Z,1745269208.822 [DefaultTankUndock:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-21T21:00:08.822Z,1745269208.822 [DefaultTankUndock:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-21T21:00:08.822Z,1745269208.822 [DefaultTankUndock:A.Wait] Running Loop=1
2025-04-21T21:00:08.823Z,1745269208.823 [DefaultTankUndock:A.Wait](DEBUG): Initialize Wait Component.
2025-04-21T21:00:08.926Z,1745269208.926 [Reporter](INFO): platform_buoyancy_position 209.615021 cc
2025-04-21T21:00:09.373Z,1745269209.373 [Reporter](INFO): platform_buoyancy_position 214.584137 cc
2025-04-21T21:00:09.730Z,1745269209.730 [Reporter](INFO): platform_buoyancy_position 219.016022 cc
2025-04-21T21:00:10.373Z,1745269210.373 [Reporter](INFO): platform_buoyancy_position 225.328125 cc
2025-04-21T21:00:10.585Z,1745269210.585 [Reporter](INFO): platform_buoyancy_position 229.625732 cc
2025-04-21T21:00:10.947Z,1745269210.947 [Reporter](INFO): platform_buoyancy_position 234.057617 cc
2025-04-21T21:00:11.513Z,1745269211.513 [Reporter](INFO): platform_buoyancy_position 240.369720 cc
2025-04-21T21:00:11.877Z,1745269211.877 [Reporter](INFO): platform_buoyancy_position 246.816147 cc
2025-04-21T21:00:12.190Z,1745269212.190 [Reporter](INFO): platform_buoyancy_position 251.248047 cc
2025-04-21T21:00:12.574Z,1745269212.574 [Reporter](INFO): platform_buoyancy_position 256.754333 cc
2025-04-21T21:00:12.948Z,1745269212.948 [Reporter](INFO): platform_buoyancy_position 261.992035 cc
2025-04-21T21:00:13.374Z,1745269213.374 [Reporter](INFO): platform_buoyancy_position 266.289642 cc
2025-04-21T21:00:13.758Z,1745269213.758 [Reporter](INFO): platform_buoyancy_position 272.601746 cc
2025-04-21T21:00:14.218Z,1745269214.218 [Reporter](INFO): platform_buoyancy_position 279.048126 cc
2025-04-21T21:00:14.622Z,1745269214.622 [Reporter](INFO): platform_buoyancy_position 283.480042 cc
2025-04-21T21:00:14.676Z,1745269214.676 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-21T21:00:14.986Z,1745269214.986 [Reporter](INFO): platform_buoyancy_position 287.643341 cc
2025-04-21T21:00:15.422Z,1745269215.422 [Reporter](INFO): platform_buoyancy_position 294.089722 cc
2025-04-21T21:00:15.680Z,1745269215.680 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off
2025-04-21T21:00:15.774Z,1745269215.774 [Reporter](INFO): platform_buoyancy_position 298.387329 cc
2025-04-21T21:00:16.242Z,1745269216.242 [Reporter](INFO): platform_buoyancy_position 304.968048 cc
2025-04-21T21:00:16.614Z,1745269216.614 [Reporter](INFO): platform_buoyancy_position 309.131348 cc
2025-04-21T21:00:17.006Z,1745269217.006 [Reporter](INFO): platform_buoyancy_position 315.577759 cc
2025-04-21T21:00:17.443Z,1745269217.443 [Reporter](INFO): platform_buoyancy_position 320.009644 cc
2025-04-21T21:00:17.802Z,1745269217.802 [Reporter](INFO): platform_buoyancy_position 326.053162 cc
2025-04-21T21:00:18.266Z,1745269218.266 [Reporter](INFO): platform_buoyancy_position 330.619324 cc
2025-04-21T21:00:18.646Z,1745269218.646 [Reporter](INFO): platform_buoyancy_position 335.319824 cc
2025-04-21T21:00:19.010Z,1745269219.010 [Reporter](INFO): platform_buoyancy_position 341.497620 cc
2025-04-21T21:00:19.434Z,1745269219.434 [Reporter](INFO): platform_buoyancy_position 345.929565 cc
2025-04-21T21:00:19.830Z,1745269219.830 [Reporter](INFO): platform_buoyancy_position 352.241638 cc
2025-04-21T21:00:20.258Z,1745269220.258 [Reporter](INFO): platform_buoyancy_position 356.673523 cc
2025-04-21T21:00:20.670Z,1745269220.670 [Reporter](INFO): platform_buoyancy_position 362.851318 cc
2025-04-21T21:00:21.026Z,1745269221.026 [Reporter](INFO): platform_buoyancy_position 367.148926 cc
2025-04-21T21:00:21.494Z,1745269221.494 [Reporter](INFO): platform_buoyancy_position 373.595337 cc
2025-04-21T21:00:21.826Z,1745269221.826 [Reporter](INFO): platform_buoyancy_position 378.027222 cc
2025-04-21T21:00:22.141Z,1745269222.141 [DefaultTankUndock:A.Wait](INFO): Done Waiting.
2025-04-21T21:00:22.141Z,1745269222.141 [DefaultTankUndock:A.Wait] Stopped
2025-04-21T21:00:22.141Z,1745269222.141 [DefaultTankUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-21T21:00:22.250Z,1745269222.250 [Reporter](INFO): platform_buoyancy_position 384.339355 cc
2025-04-21T21:00:22.594Z,1745269222.594 [DefaultTankUndock:C.Execute] Running Loop=1
2025-04-21T21:00:22.694Z,1745269222.694 [Reporter](INFO): platform_buoyancy_position 388.771240 cc
2025-04-21T21:00:22.973Z,1745269222.973 [DefaultTankUndock:C.Execute](INFO): Executing command dock arm
2025-04-21T21:00:22.974Z,1745269222.974 [DefaultTankUndock:C.Execute] Stopped
2025-04-21T21:00:22.974Z,1745269222.974 [DefaultTankUndock:CheckIn] Running Loop=1
2025-04-21T21:00:22.974Z,1745269222.974 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::initialize DefaultTankUndock:CheckIn
2025-04-21T21:00:22.974Z,1745269222.974 [DefaultTankUndock:CheckIn:Read_GPS] Running Loop=1
2025-04-21T21:00:23.082Z,1745269223.082 [Reporter](INFO): platform_buoyancy_position 393.203125 cc
2025-04-21T21:00:23.482Z,1745269223.482 [Reporter](INFO): platform_buoyancy_position 399.515259 cc
2025-04-21T21:00:23.566Z,1745269223.566 [CommandExec](IMPORTANT): got command set OnDock.DockedTime .5 hour
2025-04-21T21:00:23.567Z,1745269223.567 [CommandExec](IMPORTANT): got command set OnDock.DetachedTimeout 1 hour
2025-04-21T21:00:23.568Z,1745269223.568 [CommandExec](IMPORTANT): got command set OnDock.RangeTimeout 1 hour
2025-04-21T21:00:23.569Z,1745269223.569 [CommandExec](IMPORTANT): got command set OnDock.MinAltitude 0.1 meter
2025-04-21T21:00:23.569Z,1745269223.569 [CommandExec](IMPORTANT): got command set OnDock.MinOffshore 0.0001 kilometer
2025-04-21T21:00:23.570Z,1745269223.570 [CommandExec](IMPORTANT): got command set OnDock.IfconfigInterval 2 minute
2025-04-21T21:00:23.570Z,1745269223.570 [CommandExec](IMPORTANT): got command run
2025-04-21T21:00:23.572Z,1745269223.572 [CommandExec](IMPORTANT): Running
2025-04-21T21:00:23.574Z,1745269223.574 [CommandExec](IMPORTANT): got command docking arm
2025-04-21T21:00:23.574Z,1745269223.574 [CommandExec](IMPORTANT): Switching docking module to ARM.
2025-04-21T21:00:23.759Z,1745269223.759 [DefaultTankUndock] Stopped
2025-04-21T21:00:23.764Z,1745269223.764 [DefaultTankUndock](DEBUG): Aggregate::uninitialize DefaultTankUndock
2025-04-21T21:00:23.764Z,1745269223.764 [DefaultTankUndock:B.GoToSurface] Stopped
2025-04-21T21:00:23.764Z,1745269223.764 [DefaultTankUndock:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-21T21:00:23.764Z,1745269223.764 [DefaultTankUndock:CheckIn] Stopped
2025-04-21T21:00:23.764Z,1745269223.764 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultTankUndock:CheckIn
2025-04-21T21:00:23.764Z,1745269223.764 [DefaultTankUndock:CheckIn:Read_GPS] Stopped
2025-04-21T21:00:23.764Z,1745269223.764 [MissionManager](IMPORTANT): Started mission OnDock
2025-04-21T21:00:23.765Z,1745269223.765 [OnDock] Running Loop=1
2025-04-21T21:00:23.765Z,1745269223.765 [OnDock](DEBUG): Aggregate::initialize OnDock
2025-04-21T21:00:23.765Z,1745269223.765 [OnDock:StandardEnvelopes] Running Loop=1
2025-04-21T21:00:23.765Z,1745269223.765 [OnDock:StandardEnvelopes](DEBUG): Aggregate::initialize OnDock:StandardEnvelopes
2025-04-21T21:00:23.765Z,1745269223.765 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-04-21T21:00:23.765Z,1745269223.765 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-04-21T21:00:23.765Z,1745269223.765 [OnDock:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-04-21T21:00:23.765Z,1745269223.765 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:BackseatDriver] Running Loop=1
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:BackseatDriver](DEBUG): Aggregate::initialize OnDock:BackseatDriver
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:PowerOnly] Running Loop=1
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:PowerOnly](DEBUG): Aggregate::initialize OnDock:PowerOnly
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:PowerOnly:A] Running Loop=1
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:PowerOnly:B] Running Loop=1
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:PowerOnly:C] Running Loop=1
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:PowerOnly:D] Running Loop=1
2025-04-21T21:00:23.766Z,1745269223.766 [OnDock:PowerOnly:E.Wait] Running Loop=1
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:dataRead] Running Loop=1
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:dataRead](DEBUG): Aggregate::initialize OnDock:dataRead
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:dataRead:A] Running Loop=1
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:science] Running Loop=1
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:science](DEBUG): Aggregate::initialize OnDock:science
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:science:Science] Running Loop=1
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:science:Science](DEBUG): Aggregate::initialize OnDock:science:Science
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:science:Science:A] Running Loop=1
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:science:Science:B] Running Loop=1
2025-04-21T21:00:23.767Z,1745269223.767 [OnDock:science:Science:C] Running Loop=1
2025-04-21T21:00:23.769Z,1745269223.769 [OnDock:science:Science:D] Running Loop=1
2025-04-21T21:00:23.769Z,1745269223.769 [OnDock:science:Science:E] Running Loop=1
2025-04-21T21:00:23.769Z,1745269223.769 [OnDock:science:Science:F] Running Loop=1
2025-04-21T21:00:23.769Z,1745269223.769 [OnDock:science:Science:Read_Oil] Running Loop=1
2025-04-21T21:00:23.769Z,1745269223.769 [OnDock:science:Science:PeakDetectChl] Running Loop=1
2025-04-21T21:00:23.769Z,1745269223.769 [OnDock:science:Science:PeakDetectChl](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectChl
2025-04-21T21:00:23.770Z,1745269223.770 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T21:00:23.770Z,1745269223.770 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T21:00:23.771Z,1745269223.771 [OnDock:science:Science:HighestChlPeakReport] Running Loop=1
2025-04-21T21:00:23.771Z,1745269223.771 [OnDock:science:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize OnDock:science:Science:HighestChlPeakReport
2025-04-21T21:00:23.771Z,1745269223.771 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-21T21:00:23.771Z,1745269223.771 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-21T21:00:23.780Z,1745269223.780 [OnDock:science:Science:PeakDetectNO3] Running Loop=1
2025-04-21T21:00:23.780Z,1745269223.780 [OnDock:science:Science:PeakDetectNO3](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectNO3
2025-04-21T21:00:23.781Z,1745269223.781 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T21:00:23.781Z,1745269223.781 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T21:00:23.782Z,1745269223.782 [OnDock:science:Science:PeakDetectOil] Running Loop=1
2025-04-21T21:00:23.782Z,1745269223.782 [OnDock:science:Science:PeakDetectOil](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectOil
2025-04-21T21:00:23.782Z,1745269223.782 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T21:00:23.782Z,1745269223.782 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T21:00:23.785Z,1745269223.785 [OnDock:science:Science:HighestOilPeakReport] Running Loop=1
2025-04-21T21:00:23.785Z,1745269223.785 [OnDock:science:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize OnDock:science:Science:HighestOilPeakReport
2025-04-21T21:00:23.786Z,1745269223.786 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-21T21:00:23.786Z,1745269223.786 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-21T21:00:23.786Z,1745269223.786 [OnDock:science:Science:PeakDetectFDOM] Running Loop=1
2025-04-21T21:00:23.786Z,1745269223.786 [OnDock:science:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectFDOM
2025-04-21T21:00:23.786Z,1745269223.786 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T21:00:23.786Z,1745269223.786 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T21:00:23.787Z,1745269223.787 [OnDock:science:Science:PeakDetectSalinity] Running Loop=1
2025-04-21T21:00:23.787Z,1745269223.787 [OnDock:science:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectSalinity
2025-04-21T21:00:23.796Z,1745269223.796 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T21:00:23.796Z,1745269223.796 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T21:00:23.803Z,1745269223.803 [OnDock:science:Science:HighestSaltPeakReport] Running Loop=1
2025-04-21T21:00:23.803Z,1745269223.803 [OnDock:science:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize OnDock:science:Science:HighestSaltPeakReport
2025-04-21T21:00:23.803Z,1745269223.803 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-21T21:00:23.803Z,1745269223.803 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-21T21:00:23.812Z,1745269223.812 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1
2025-04-21T21:00:23.812Z,1745269223.812 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreLMavgROI
2025-04-21T21:00:23.812Z,1745269223.812 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T21:00:23.812Z,1745269223.812 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T21:00:23.813Z,1745269223.813 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_LM_AvgRois , but backseat URI detected. Waiting for presence.
2025-04-21T21:00:23.814Z,1745269223.814 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1
2025-04-21T21:00:23.814Z,1745269223.814 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreHMavgROI
2025-04-21T21:00:23.814Z,1745269223.814 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T21:00:23.814Z,1745269223.814 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T21:00:23.814Z,1745269223.814 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_HM_AvgRois , but backseat URI detected. Waiting for presence.
2025-04-21T21:00:23.815Z,1745269223.815 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1
2025-04-21T21:00:23.815Z,1745269223.815 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreDiatoms
2025-04-21T21:00:23.815Z,1745269223.815 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T21:00:23.815Z,1745269223.815 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T21:00:23.820Z,1745269223.820 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_diatoms , but backseat URI detected. Waiting for presence.
2025-04-21T21:00:23.824Z,1745269223.824 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1
2025-04-21T21:00:23.824Z,1745269223.824 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates
2025-04-21T21:00:23.824Z,1745269223.824 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth] Running Loop=1
2025-04-21T21:00:23.824Z,1745269223.824 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Initialize.
2025-04-21T21:00:23.825Z,1745269223.825 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_dinoflagellates , but backseat URI detected. Waiting for presence.
2025-04-21T21:00:23.826Z,1745269223.826 [OnDock:science:Science:ChlThreshTrigger] Running Loop=1
2025-04-21T21:00:23.826Z,1745269223.826 [OnDock:science:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize OnDock:science:Science:ChlThreshTrigger
2025-04-21T21:00:23.826Z,1745269223.826 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1
2025-04-21T21:00:23.826Z,1745269223.826 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize.
2025-04-21T21:00:23.826Z,1745269223.826 [OnDock:science:Science:OceanCurrent] Running Loop=1
2025-04-21T21:00:23.826Z,1745269223.826 [OnDock:science:Science:OceanCurrent](DEBUG): Aggregate::initialize OnDock:science:Science:OceanCurrent
2025-04-21T21:00:23.827Z,1745269223.827 [OnDock:science:Science:OceanCurrent:A.] Running Loop=1
2025-04-21T21:00:23.827Z,1745269223.827 [OnDock:science:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2025-04-21T21:00:23.827Z,1745269223.827 [OnDock:J.] Running Loop=1
2025-04-21T21:00:23.827Z,1745269223.827 [OnDock:J.](INFO): Initializing TrackAcousticContact.
2025-04-21T21:00:23.827Z,1745269223.827 [OnDock:PeriodicCheck] Running Loop=1
2025-04-21T21:00:23.827Z,1745269223.827 [OnDock:PeriodicCheck](DEBUG): Aggregate::initialize OnDock:PeriodicCheck
2025-04-21T21:00:23.827Z,1745269223.827 [OnDock:PeriodicCheck:CheckIP] Running Loop=1
2025-04-21T21:00:23.827Z,1745269223.827 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::initialize OnDock:PeriodicCheck:CheckIP
2025-04-21T21:00:23.827Z,1745269223.827 [OnDock:PeriodicCheck:CheckIP:A.Execute] Running Loop=1
2025-04-21T21:00:23.828Z,1745269223.828 [OnDock:B] Running Loop=1
2025-04-21T21:00:23.828Z,1745269223.828 [OnDock:PeriodicCheck] Running Loop=1
2025-04-21T21:00:23.828Z,1745269223.828 [OnDock:PeriodicCheck:CheckIP:A.Execute](INFO): Executing command ! ifconfig
2025-04-21T21:00:23.829Z,1745269223.829 [OnDock:PeriodicCheck:CheckIP:A.Execute] Stopped
2025-04-21T21:00:23.829Z,1745269223.829 [OnDock:PeriodicCheck:CheckIP:B.Wait] Running Loop=1
2025-04-21T21:00:23.829Z,1745269223.829 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Initialize Wait Component.
2025-04-21T21:00:23.829Z,1745269223.829 [OnDock:J.] Running Loop=1
2025-04-21T21:00:23.829Z,1745269223.829 [OnDock:science] Stopped
2025-04-21T21:00:23.829Z,1745269223.829 [OnDock:science](DEBUG): Aggregate::uninitialize OnDock:science
2025-04-21T21:00:23.829Z,1745269223.829 [OnDock:science:Science] Stopped
2025-04-21T21:00:23.829Z,1745269223.829 [OnDock:science:Science](DEBUG): Aggregate::uninitialize OnDock:science:Science
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:A] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:B] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:C] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:D] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:E] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:F] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:Read_Oil] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:OceanCurrent] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:OceanCurrent](DEBUG): Aggregate::uninitialize OnDock:science:Science:OceanCurrent
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:OceanCurrent:A.] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:PeakDetectChl] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectChl
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T21:00:23.830Z,1745269223.830 [OnDock:science:Science:HighestChlPeakReport] Stopped
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize OnDock:science:Science:HighestChlPeakReport
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:PeakDetectNO3] Stopped
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectNO3
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:PeakDetectOil] Stopped
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectOil
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:HighestOilPeakReport] Stopped
2025-04-21T21:00:23.831Z,1745269223.831 [OnDock:science:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize OnDock:science:Science:HighestOilPeakReport
2025-04-21T21:00:23.832Z,1745269223.832 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-21T21:00:23.832Z,1745269223.832 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:PeakDetectFDOM] Stopped
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectFDOM
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:PeakDetectSalinity] Stopped
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectSalinity
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:HighestSaltPeakReport] Stopped
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize OnDock:science:Science:HighestSaltPeakReport
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-21T21:00:23.833Z,1745269223.833 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI] Stopped
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreLMavgROI
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth] Stopped
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI] Stopped
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreHMavgROI
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth] Stopped
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms] Stopped
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreDiatoms
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth] Stopped
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T21:00:23.834Z,1745269223.834 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates] Stopped
2025-04-21T21:00:23.835Z,1745269223.835 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates
2025-04-21T21:00:23.835Z,1745269223.835 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth] Stopped
2025-04-21T21:00:23.835Z,1745269223.835 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2025-04-21T21:00:23.835Z,1745269223.835 [OnDock:science:Science:ChlThreshTrigger] Stopped
2025-04-21T21:00:23.835Z,1745269223.835 [OnDock:science:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize OnDock:science:Science:ChlThreshTrigger
2025-04-21T21:00:23.835Z,1745269223.835 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect] Stopped
2025-04-21T21:00:23.835Z,1745269223.835 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize.
2025-04-21T21:00:23.835Z,1745269223.835 [OnDock:dataRead] Running Loop=1
2025-04-21T21:00:23.844Z,1745269223.844 [OnDock:dataRead:A](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-21T21:00:23.844Z,1745269223.844 [OnDock:PowerOnly] Running Loop=1
2025-04-21T21:00:23.845Z,1745269223.845 [OnDock:PowerOnly:D] Stopped
2025-04-21T21:00:23.845Z,1745269223.845 [OnDock:PowerOnly:C] Stopped
2025-04-21T21:00:23.845Z,1745269223.845 [OnDock:PowerOnly:B] Stopped
2025-04-21T21:00:23.845Z,1745269223.845 [OnDock:PowerOnly:A] Stopped
2025-04-21T21:00:23.845Z,1745269223.845 [OnDock:BackseatDriver] Running Loop=1
2025-04-21T21:00:23.845Z,1745269223.845 [OnDock:B] Stopped
2025-04-21T21:00:23.845Z,1745269223.845 [OnDock:C] Running Loop=1
2025-04-21T21:00:23.845Z,1745269223.845 [OnDock:StandardEnvelopes] Running Loop=1
2025-04-21T21:00:23.845Z,1745269223.845 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-04-21T21:00:23.846Z,1745269223.846 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](IMPORTANT): Offshore envelope ACTIVE
2025-04-21T21:00:23.862Z,1745269223.862 [OnDock:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-04-21T21:00:23.862Z,1745269223.862 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-04-21T21:00:23.886Z,1745269223.886 [CommandExec](IMPORTANT): got command ! ifconfig
2025-04-21T21:00:24.006Z,1745269224.006 [DockingStepper](INFO): Changing to mode: 2
2025-04-21T21:00:24.006Z,1745269224.006 [DockingStepper](INFO): Armed mode.
2025-04-21T21:00:24.042Z,1745269224.042 [CommandExec](IMPORTANT): eth0 Link encap:Ethernet HWaddr 50:2D:F4:07:45:4B
inet addr:10.89.10.2 Bcast:10.89.255.255 Mask:255.255.0.0
UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
RX packets:7625 errors:0 dropped:0 overruns:0 frame:0
TX packets:8651 errors:0 dropped:0 overruns:0 carrier:0
collisions:85 txqueuelen:1000
RX bytes:1604913 (1.5 Mb) TX bytes:1526379 (1.4 Mb)
Interrupt:29
lo Link encap:Local Loopback
inet addr:127.0.0.1 Mask:255.0.0.0
UP LOOPBACK RUNNING MULTICAST MTU:16436 Metric:1
RX packets:352 errors:0 dropped:0 overruns:0 frame:0
TX packets:352 errors:0 dropped:0 overruns:0 carrier:0
collisions:0 txqueuelen:0
RX bytes:26048 (25.4 Kb) TX bytes:26048 (25.4 Kb)
2025-04-21T21:00:24.068Z,1745269224.068 [DockingStepper](INFO): Commanding negative:54303
2025-04-21T21:00:24.102Z,1745269224.102 [Reporter](INFO): platform_buoyancy_position 405.961670 cc
2025-04-21T21:00:24.725Z,1745269224.725 [OnDock:C] Stopped
2025-04-21T21:00:24.726Z,1745269224.726 [OnDock:D] Running Loop=1
2025-04-21T21:00:24.977Z,1745269224.977 [Reporter](INFO): platform_buoyancy_position 414.422546 cc
2025-04-21T21:00:25.087Z,1745269225.087 [OnDock:D] Stopped
2025-04-21T21:00:25.087Z,1745269225.087 [OnDock:E] Running Loop=1
2025-04-21T21:00:25.272Z,1745269225.272 [ThrusterServo](ERROR): Thruster uart error: serial timeout
2025-04-21T21:00:25.273Z,1745269225.273 [ThrusterServo] Communications Fault, FailCount= 1
2025-04-21T21:00:25.273Z,1745269225.273 [ThrusterServo](ERROR): Communications Fault
2025-04-21T21:00:25.290Z,1745269225.290 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2025-04-21T21:00:25.291Z,1745269225.291 [Reporter](INFO): platform_buoyancy_position 416.705627 cc
2025-04-21T21:00:27.357Z,1745269227.357 [OnDock:E] Stopped
2025-04-21T21:00:27.357Z,1745269227.357 [OnDock:K] Running Loop=1
2025-04-21T21:00:27.612Z,1745269227.612 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2025-04-21T21:00:27.613Z,1745269227.613 [ThrusterServo](INFO): Powering down
2025-04-21T21:00:27.618Z,1745269227.618 [Reporter](INFO): platform_buoyancy_position 440.208130 cc
2025-04-21T21:00:27.672Z,1745269227.672 [OnDock:K](IMPORTANT): Restarting logs
2025-04-21T21:00:27.672Z,1745269227.672 [OnDock:K] Stopped
2025-04-21T21:00:27.673Z,1745269227.673 [OnDock:L.Execute] Running Loop=1
2025-04-21T21:00:27.809Z,1745269227.809 [Reporter](INFO): platform_buoyancy_position 443.968567 cc
2025-04-21T21:00:28.062Z,1745269228.062 [OnDock:L.Execute](INFO): Executing command restart logs