2025-08-11T14:33:19.080Z,1754922799.080 [OnDock:E] Stopped
2025-08-11T14:33:19.080Z,1754922799.080 [OnDock:K] Running Loop=1
2025-08-11T14:33:19.492Z,1754922799.492 [OnDock:K](IMPORTANT): Restarting logs
2025-08-11T14:33:19.493Z,1754922799.493 [OnDock:K] Stopped
2025-08-11T14:33:19.493Z,1754922799.493 [OnDock:L.Execute] Running Loop=1
2025-08-11T14:33:19.894Z,1754922799.894 [OnDock:L.Execute](INFO): Executing command restart logs
2025-08-11T14:33:19.894Z,1754922799.894 [OnDock:L.Execute] Stopped
2025-08-11T14:33:19.894Z,1754922799.894 [OnDock:N.Docked] Running Loop=1
2025-08-11T14:33:19.894Z,1754922799.894 [OnDock:N.Docked](DEBUG): Initialize.
2025-08-11T14:33:19.894Z,1754922799.894 [OnDock:N.Docked](DEBUG): Initializing internal variables to default values.
2025-08-11T14:33:19.905Z,1754922799.905 [CommandExec](IMPORTANT): got command restart logs
2025-08-11T14:33:20.314Z,1754922800.314 [OnDock:N.Docked](FAULT): Off dock, depth 0.147919 above surface threshold
2025-08-11T14:33:20.314Z,1754922800.314 [OnDock:N.Docked](IMPORTANT): State switched to DETACHED. Waiting for state timeout to act...
2025-08-11T14:33:20.316Z,1754922800.316 [OnDock:N.Docked](INFO): Found local IP address 10.89.11.2 for eth0
2025-08-11T14:33:20.316Z,1754922800.316 [OnDock:N.Docked](IMPORTANT): No IP address on dock subnet, restarting DHCP
2025-08-11T14:33:20.380Z,1754922800.380 [DAT](IMPORTANT): Requesting device enable set for address 0.
2025-08-11T14:33:20.632Z,1754922800.632 [DAT](INFO): DAT read: user:7>
2025-08-11T14:33:20.633Z,1754922800.633 [DAT](INFO): DAT read: Tx time:14:33:21.8687
2025-08-11T14:33:20.633Z,1754922800.633 [DAT](INFO): Ping request sent.
2025-08-11T14:33:20.633Z,1754922800.633 [DAT](INFO): transmitted an acoustic signal
2025-08-11T14:33:20.634Z,1754922800.634 [DAT](INFO): publishing transmit ping time
2025-08-11T14:33:20.634Z,1754922800.634 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.001005
2025-08-11T14:33:20.635Z,1754922800.635 [DAT](IMPORTANT): Requesting device enable set for address 0.
2025-08-11T14:33:20.884Z,1754922800.884 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251153
2025-08-11T14:33:20.885Z,1754922800.885 [DAT](IMPORTANT): Requesting device enable set for address 0.
2025-08-11T14:33:21.136Z,1754922801.136 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502825
2025-08-11T14:33:21.137Z,1754922801.137 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-08-11T14:33:21.256Z,1754922801.256 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-08-11T14:33:21.388Z,1754922801.388 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754862
2025-08-11T14:33:21.640Z,1754922801.640 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.007147
2025-08-11T14:33:21.892Z,1754922801.892 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258877
2025-08-11T14:33:22.144Z,1754922802.144 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510856
2025-08-11T14:33:22.397Z,1754922802.397 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763598
2025-08-11T14:33:22.648Z,1754922802.648 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014968
2025-08-11T14:33:22.900Z,1754922802.900 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266841
2025-08-11T14:33:23.152Z,1754922803.152 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518817
2025-08-11T14:33:23.404Z,1754922803.404 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770934
2025-08-11T14:33:23.656Z,1754922803.656 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022859
2025-08-11T14:33:23.908Z,1754922803.908 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.274812
2025-08-11T14:33:24.160Z,1754922804.160 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.526923
2025-08-11T14:33:24.412Z,1754922804.412 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.778906
2025-08-11T14:33:24.664Z,1754922804.664 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.031003
2025-08-11T14:33:24.905Z,1754922804.905 [DockingStepper](INFO): Changing to mode: 1
2025-08-11T14:33:24.916Z,1754922804.916 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.282839
2025-08-11T14:33:25.168Z,1754922805.168 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.534815
2025-08-11T14:33:25.420Z,1754922805.420 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.787098
2025-08-11T14:33:25.672Z,1754922805.672 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.038958
2025-08-11T14:33:25.924Z,1754922805.924 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.290792
2025-08-11T14:33:26.176Z,1754922806.176 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.543136
2025-08-11T14:33:26.429Z,1754922806.429 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.795424
2025-08-11T14:33:26.680Z,1754922806.680 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.046843
2025-08-11T14:33:26.933Z,1754922806.933 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.299204
2025-08-11T14:33:27.184Z,1754922807.184 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.550970
2025-08-11T14:33:27.436Z,1754922807.436 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.802900
2025-08-11T14:33:27.688Z,1754922807.688 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.054929
2025-08-11T14:33:27.875Z,1754922807.875 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250811T142458/Courier0004.lzma
2025-08-11T14:33:27.877Z,1754922807.877 [DataOverHttps](INFO): Received command: sched asap "set lineCaptureHoming.MaxDepth 70 m;set lineCaptureHoming.CorrectForSoundSpeed 1 bool;run" lhqt 2 2
2025-08-11T14:33:27.940Z,1754922807.940 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.306926
2025-08-11T14:33:28.192Z,1754922808.192 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.558924
2025-08-11T14:33:28.450Z,1754922808.450 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.816357
2025-08-11T14:33:28.700Z,1754922808.700 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.066897
2025-08-11T14:33:28.952Z,1754922808.952 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.318910
2025-08-11T14:33:29.204Z,1754922809.204 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.570793
2025-08-11T14:33:29.346Z,1754922809.346 [DataOverHttps](INFO): Moved sent file to Logs/20250811T142458/Courier0004.lzma.bak
2025-08-11T14:33:29.346Z,1754922809.346 [DataOverHttps](IMPORTANT): SBD MOMSN=25837473, MTMSN=20250811T143327
2025-08-11T14:33:29.456Z,1754922809.456 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.822894
2025-08-11T14:33:29.708Z,1754922809.708 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.074753
2025-08-11T14:33:29.960Z,1754922809.960 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.326889
2025-08-11T14:33:30.212Z,1754922810.212 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.578925
2025-08-11T14:33:30.464Z,1754922810.464 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.831028
2025-08-11T14:33:30.968Z,1754922810.968 [DAT](INFO): DAT read: Response Not Received
2025-08-11T14:33:30.969Z,1754922810.969 [DAT](INFO): response not received
2025-08-11T14:33:30.969Z,1754922810.969 [DAT](INFO): DAT read: user:8>
2025-08-11T14:33:30.970Z,1754922810.970 [DAT](INFO): DAT read: Tx time:14:33:32.3187
2025-08-11T14:33:30.970Z,1754922810.970 [DAT](INFO): Ping request sent.
2025-08-11T14:33:30.970Z,1754922810.970 [DAT](INFO): transmitted an acoustic signal
2025-08-11T14:33:30.970Z,1754922810.970 [DAT](INFO): publishing transmit ping time
2025-08-11T14:33:30.971Z,1754922810.971 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000752
2025-08-11T14:33:31.221Z,1754922811.221 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250534
2025-08-11T14:33:31.473Z,1754922811.473 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502430
2025-08-11T14:33:31.721Z,1754922811.721 [CommandExec](IMPORTANT): got command ! /mnt/mmc/LRAUV/Tools/dhcp.sh
2025-08-11T14:33:31.775Z,1754922811.775 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.803669
2025-08-11T14:33:31.976Z,1754922811.976 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006167
2025-08-11T14:33:32.229Z,1754922812.229 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258569
2025-08-11T14:33:32.481Z,1754922812.481 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510517
2025-08-11T14:33:32.605Z,1754922812.605 [CommandExec](IMPORTANT): /mnt/mmc/started/2025-08-11UTC143332_sh
2025-08-11T14:33:32.610Z,1754922812.610 [CommandExec](IMPORTANT): got command schedule asap "set lineCaptureHoming.MaxDepth 70 m;set lineCaptureHoming.CorrectForSoundSpeed 1 bool;run" lhqt 2 2.000000
2025-08-11T14:33:32.610Z,1754922812.610 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=lhqt
2025-08-11T14:33:32.612Z,1754922812.612 [CommandExec](IMPORTANT): Scheduled #3 (#2 of 2 with id='lhqt'): "set lineCaptureHoming.MaxDepth 70 m;set lineCaptureHoming.CorrectForSoundSpeed 1 bool;run", ASAP
2025-08-11T14:33:32.732Z,1754922812.732 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762170
2025-08-11T14:33:32.866Z,1754922812.866 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/lineCaptureHoming.tl
2025-08-11T14:33:32.866Z,1754922812.866 [MissionManager](INFO): Uninitializing Mission OnDock
2025-08-11T14:33:32.866Z,1754922812.866 [OnDock] Stopped
2025-08-11T14:33:32.866Z,1754922812.866 [OnDock](DEBUG): Aggregate::uninitialize OnDock
2025-08-11T14:33:32.866Z,1754922812.866 [OnDock:StandardEnvelopes] Stopped
2025-08-11T14:33:32.866Z,1754922812.866 [OnDock:StandardEnvelopes](DEBUG): Aggregate::uninitialize OnDock:StandardEnvelopes
2025-08-11T14:33:32.866Z,1754922812.866 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-08-11T14:33:32.867Z,1754922812.867 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-08-11T14:33:32.867Z,1754922812.867 [OnDock:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-08-11T14:33:32.867Z,1754922812.867 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-08-11T14:33:32.867Z,1754922812.867 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-08-11T14:33:32.867Z,1754922812.867 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-08-11T14:33:32.883Z,1754922812.883 [OnDock:BackseatDriver] Stopped
2025-08-11T14:33:32.883Z,1754922812.883 [OnDock:BackseatDriver](DEBUG): Aggregate::uninitialize OnDock:BackseatDriver
2025-08-11T14:33:32.883Z,1754922812.883 [OnDock:BackseatDriver:A.BackseatDriver] Stopped
2025-08-11T14:33:32.884Z,1754922812.884 [OnDock:PowerOnly] Stopped
2025-08-11T14:33:32.884Z,1754922812.884 [OnDock:PowerOnly](DEBUG): Aggregate::uninitialize OnDock:PowerOnly
2025-08-11T14:33:32.884Z,1754922812.884 [OnDock:PowerOnly:E.Wait] Stopped
2025-08-11T14:33:32.884Z,1754922812.884 [OnDock:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-08-11T14:33:32.884Z,1754922812.884 [OnDock:dataRead] Stopped
2025-08-11T14:33:32.884Z,1754922812.884 [OnDock:dataRead](DEBUG): Aggregate::uninitialize OnDock:dataRead
2025-08-11T14:33:32.884Z,1754922812.884 [OnDock:dataRead:A] Stopped
2025-08-11T14:33:32.884Z,1754922812.884 [OnDock:J.] Stopped
2025-08-11T14:33:32.884Z,1754922812.884 [OnDock:J.](DEBUG): Uninitializing TrackAcousticContact.
2025-08-11T14:33:32.885Z,1754922812.885 [OnDock:PeriodicCheck] Stopped
2025-08-11T14:33:32.885Z,1754922812.885 [OnDock:PeriodicCheck](DEBUG): Aggregate::uninitialize OnDock:PeriodicCheck
2025-08-11T14:33:32.885Z,1754922812.885 [OnDock:PeriodicCheck:CheckIP] Stopped
2025-08-11T14:33:32.885Z,1754922812.885 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::uninitialize OnDock:PeriodicCheck:CheckIP
2025-08-11T14:33:32.885Z,1754922812.885 [OnDock:PeriodicCheck:CheckIP:B.Wait] Stopped
2025-08-11T14:33:32.885Z,1754922812.885 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Uninitialize Wait Component.
2025-08-11T14:33:32.885Z,1754922812.885 [OnDock:N.Docked] Stopped
2025-08-11T14:33:32.984Z,1754922812.984 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014179
2025-08-11T14:33:32.985Z,1754922812.985 [DAT](IMPORTANT): Requesting device enable clr for address 0.
2025-08-11T14:33:33.236Z,1754922813.236 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266193
2025-08-11T14:33:33.237Z,1754922813.237 [DAT](IMPORTANT): Requesting device enable clr for address 0.
2025-08-11T14:33:33.373Z,1754922813.373 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/lineCaptureHoming.tl
2025-08-11T14:33:33.373Z,1754922813.373 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/lineCaptureHoming.tl
2025-08-11T14:33:33.381Z,1754922813.381 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/lineCaptureHoming.tl
2025-08-11T14:33:33.488Z,1754922813.488 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518122
2025-08-11T14:33:33.488Z,1754922813.488 [DAT](IMPORTANT): Requesting device enable clr for address 0.
2025-08-11T14:33:33.744Z,1754922813.744 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.772767
2025-08-11T14:33:33.992Z,1754922813.992 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022007
2025-08-11T14:33:34.244Z,1754922814.244 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.274074
2025-08-11T14:33:34.496Z,1754922814.496 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.526012
2025-08-11T14:33:34.749Z,1754922814.749 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.778431
2025-08-11T14:33:35.000Z,1754922815.000 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.030108
2025-08-11T14:33:35.252Z,1754922815.252 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.282017
2025-08-11T14:33:35.504Z,1754922815.504 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.534299
2025-08-11T14:33:35.758Z,1754922815.758 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.788036
2025-08-11T14:33:36.008Z,1754922816.008 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.037882
2025-08-11T14:33:36.260Z,1754922816.260 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.290330
2025-08-11T14:33:36.513Z,1754922816.513 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.542408
2025-08-11T14:33:36.764Z,1754922816.764 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.794020
2025-08-11T14:33:37.016Z,1754922817.016 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.046046
2025-08-11T14:33:37.268Z,1754922817.268 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.298161
2025-08-11T14:33:37.520Z,1754922817.520 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.550111
2025-08-11T14:33:37.775Z,1754922817.775 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.803941
2025-08-11T14:33:38.025Z,1754922818.025 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.054908
2025-08-11T14:33:38.276Z,1754922818.276 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.306015
2025-08-11T14:33:38.528Z,1754922818.528 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.558062
2025-08-11T14:33:38.780Z,1754922818.780 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.810094
2025-08-11T14:33:39.032Z,1754922819.032 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.062023
2025-08-11T14:33:39.284Z,1754922819.284 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.314350
2025-08-11T14:33:39.536Z,1754922819.536 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.566193
2025-08-11T14:33:39.788Z,1754922819.788 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.818104
2025-08-11T14:33:40.040Z,1754922820.040 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.070378
2025-08-11T14:33:40.292Z,1754922820.292 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.322193
2025-08-11T14:33:40.544Z,1754922820.544 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.574053
2025-08-11T14:33:40.797Z,1754922820.797 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.826416
2025-08-11T14:33:41.300Z,1754922821.300 [DAT](INFO): DAT read: Response Not Received
2025-08-11T14:33:41.301Z,1754922821.301 [DAT](INFO): response not received
2025-08-11T14:33:41.301Z,1754922821.301 [DAT](INFO): DAT read: user:9>
2025-08-11T14:33:41.301Z,1754922821.301 [DAT](ERROR): No response from remote modem.
2025-08-11T14:33:41.552Z,1754922821.552 [DAT](INFO): DAT read: Tx time:14:33:42.7688
2025-08-11T14:33:41.553Z,1754922821.553 [DAT](INFO): Ping request sent.
2025-08-11T14:33:41.553Z,1754922821.553 [DAT](INFO): transmitted an acoustic signal
2025-08-11T14:33:41.553Z,1754922821.553 [DAT](INFO): publishing transmit ping time
2025-08-11T14:33:41.553Z,1754922821.553 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000809
2025-08-11T14:33:41.804Z,1754922821.804 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251715
2025-08-11T14:33:42.056Z,1754922822.056 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.503536
2025-08-11T14:33:42.309Z,1754922822.309 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.756256
2025-08-11T14:33:42.560Z,1754922822.560 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.007491
2025-08-11T14:33:42.812Z,1754922822.812 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.259488
2025-08-11T14:33:43.064Z,1754922823.064 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.511674
2025-08-11T14:33:43.179Z,1754922823.179 [DataOverHttps](INFO): Received command: schedule resume
2025-08-11T14:33:43.316Z,1754922823.316 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763450
2025-08-11T14:33:43.568Z,1754922823.568 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.015462
2025-08-11T14:33:43.821Z,1754922823.821 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.268083
2025-08-11T14:33:44.072Z,1754922824.072 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.519550
2025-08-11T14:33:44.324Z,1754922824.324 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.771504
2025-08-11T14:33:44.576Z,1754922824.576 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.023475
2025-08-11T14:33:44.831Z,1754922824.831 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.278778
2025-08-11T14:33:45.080Z,1754922825.080 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.527479
2025-08-11T14:33:45.332Z,1754922825.332 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.779418
2025-08-11T14:33:45.584Z,1754922825.584 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.031482
2025-08-11T14:33:45.836Z,1754922825.836 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.283486
2025-08-11T14:33:46.074Z,1754922826.074 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/lineCaptureHoming.tl translated into:
3
180
3
1
5
4
1.5
1.5
60
2
2
5
1
120
40
5
NaN
10
NaN
4
205
2
20
0.05
NaN
NaN
NaN
60
-1
1
1
0
0
0
No longer in Terminal. Resuming normal ranging with
pings.
5
Entering USBL mode with
pings at
(mode
).
5
Resuming normal ranging with
pings
(mode
).
5
Entering Midcourse tracking update period
sec at
(mode
).
5
0
Entering Terminal tracking update period
sec at
(mode
).
Restarting DHCP...
! /mnt/mmc/LRAUV/Tools/dhcp.sh
Restarting logs
restart logs
Timed out trying to reach the target depth. Stopping mission at current depth of
stop
1
-99
Mode
0
Waiting on dock for
Retrying incomplete docking attempt
1
Breaking off. Range:
.
Driving to post-undock waypoint
,
No post-undock waypoint, drifting for
minutes
0
0
0
2025-08-11T14:33:46.089Z,1754922826.089 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.535821
2025-08-11T14:33:46.138Z,1754922826.138 [MissionManager](INFO): DefineArg lineCaptureHoming.MissionTimeout = 3.000000 h
2025-08-11T14:33:46.145Z,1754922826.145 [MissionManager](INFO): DefineArg lineCaptureHoming.NeedCommsTime = 180.000000 min
2025-08-11T14:33:46.152Z,1754922826.152 [MissionManager](INFO): DefineArg lineCaptureHoming.MicromodemCommsInterval = 3.000000 h
2025-08-11T14:33:46.156Z,1754922826.156 [MissionManager](INFO): DefineArg lineCaptureHoming.Repeat = 1.000000 count
2025-08-11T14:33:46.159Z,1754922826.159 [MissionManager](INFO): DefineArg lineCaptureHoming.WaitOnDockTimeout = 5.000000 min
2025-08-11T14:33:46.186Z,1754922826.186 [MissionManager](INFO): DefineArg lineCaptureHoming.StayOnDock = 0 bool
2025-08-11T14:33:46.193Z,1754922826.193 [MissionManager](INFO): DefineArg lineCaptureHoming.TrySlide = 0 bool
2025-08-11T14:33:46.208Z,1754922826.208 [MissionManager](INFO): DefineArg lineCaptureHoming.RetryIncompleteDock = 0 bool
2025-08-11T14:33:46.219Z,1754922826.219 [MissionManager](INFO): DefineArg lineCaptureHoming.SlideRetries = 4.000000 count
2025-08-11T14:33:46.225Z,1754922826.225 [MissionManager](INFO): DefineArg lineCaptureHoming.SlideSinkDuration = 1.500000 min
2025-08-11T14:33:46.232Z,1754922826.232 [MissionManager](INFO): DefineArg lineCaptureHoming.SlideCloseDuration = 1.500000 min
2025-08-11T14:33:46.240Z,1754922826.240 [MissionManager](INFO): DefineArg lineCaptureHoming.TransponderCode = 50 count
2025-08-11T14:33:46.256Z,1754922826.256 [MissionManager](INFO): DefineArg lineCaptureHoming.TrackingUpdatePeriodMidcourse = 60.000000 s
2025-08-11T14:33:46.263Z,1754922826.263 [MissionManager](INFO): DefineArg lineCaptureHoming.TrackingUpdatePeriodTerminal = 2.000000 s
2025-08-11T14:33:46.266Z,1754922826.266 [MissionManager](INFO): DefineArg lineCaptureHoming.TrackingUpdatePeriodDocked = 2.000000 min
2025-08-11T14:33:46.282Z,1754922826.282 [MissionManager](INFO): DefineArg lineCaptureHoming.TrackingNumFixesLowPassFilter = 5.000000 count
2025-08-11T14:33:46.294Z,1754922826.294 [MissionManager](INFO): DefineArg lineCaptureHoming.NumberOfPings = 1.000000 count
2025-08-11T14:33:46.308Z,1754922826.308 [MissionManager](INFO): DefineArg lineCaptureHoming.NumPingsUSBL = 120.000000 count
2025-08-11T14:33:46.311Z,1754922826.311 [MissionManager](INFO): DefineArg lineCaptureHoming.RangeUSBL = 40.000000 m
2025-08-11T14:33:46.318Z,1754922826.318 [MissionManager](INFO): DefineArg lineCaptureHoming.TrackingNumFixesLowPassFilterUSBL = 5.000000 count
2025-08-11T14:33:46.326Z,1754922826.326 [MissionManager](INFO): DefineArg lineCaptureHoming.DockingAltitude = nan m
2025-08-11T14:33:46.337Z,1754922826.337 [MissionManager](INFO): DefineArg lineCaptureHoming.InvalidAltitudeTimeout = 10.000000 min
2025-08-11T14:33:46.340Z,1754922826.340 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.787616
2025-08-11T14:33:46.342Z,1754922826.342 [MissionManager](INFO): DefineArg lineCaptureHoming.AltitudeDepthLimit = nan m
2025-08-11T14:33:46.358Z,1754922826.358 [MissionManager](INFO): DefineArg lineCaptureHoming.MinAltitude = 4.000000 m
2025-08-11T14:33:46.363Z,1754922826.363 [MissionManager](INFO): DefineArg lineCaptureHoming.MaxDepth = 205.000000 m
2025-08-11T14:33:46.378Z,1754922826.378 [MissionManager](INFO): DefineArg lineCaptureHoming.MinOffshore = 2.000000 km
2025-08-11T14:33:46.382Z,1754922826.382 [MissionManager](INFO): DefineArg lineCaptureHoming.ApproachDepthTimeout = 20.000000 min
2025-08-11T14:33:46.393Z,1754922826.393 [MissionManager](INFO): DefineArg lineCaptureHoming.ApproachDepthRate = 0.050000 m/s
2025-08-11T14:33:46.398Z,1754922826.398 [MissionManager](INFO): DefineArg lineCaptureHoming.Lat1 = nan arcdeg
2025-08-11T14:33:46.410Z,1754922826.410 [MissionManager](INFO): DefineArg lineCaptureHoming.Lon1 = nan arcdeg
2025-08-11T14:33:46.421Z,1754922826.421 [MissionManager](INFO): DefineArg lineCaptureHoming.CaptureRadius = nan m
2025-08-11T14:33:46.425Z,1754922826.425 [MissionManager](INFO): DefineArg lineCaptureHoming.CorrectForSoundSpeed = 0 bool
2025-08-11T14:33:46.437Z,1754922826.437 [MissionManager](INFO): DefineArg lineCaptureHoming.MidcourseDepth = 50.000000 m
2025-08-11T14:33:46.445Z,1754922826.445 [MissionManager](INFO): DefineArg lineCaptureHoming.MidcourseSpeed = 0.800000 m/s
2025-08-11T14:33:46.451Z,1754922826.451 [MissionManager](INFO): DefineArg lineCaptureHoming.TrackingPeriod = 60.000000 s
2025-08-11T14:33:46.466Z,1754922826.466 [MissionManager](INFO): DefineOutput lineCaptureHoming.Mode = -1.000000 count
2025-08-11T14:33:46.474Z,1754922826.474 [MissionManager](INFO): DefineOutput lineCaptureHoming.NumPings = 1.000000 count
2025-08-11T14:33:46.488Z,1754922826.488 [MissionManager](INFO): DefineOutput lineCaptureHoming.LowPassFilterWinSize = 1.000000 count
2025-08-11T14:33:46.491Z,1754922826.491 [MissionManager](INFO): DefineOutput lineCaptureHoming.LowPassFilterWinOverlap = 1 bool
2025-08-11T14:33:46.530Z,1754922826.530 [MissionManager](INFO): DefineOutput lineCaptureHoming.EndDockingSequence = 0 bool
2025-08-11T14:33:46.538Z,1754922826.538 [MissionManager](INFO): DefineOutput lineCaptureHoming.LastDockSuccessful = 0 bool
2025-08-11T14:33:46.557Z,1754922826.557 [MissionManager](INFO): DefineOutput lineCaptureHoming.DockSuccessfulCount = 0.000000 count
2025-08-11T14:33:46.565Z,1754922826.565 [MissionManager](INFO): DefineOutput lineCaptureHoming.RepeatArg = 1.000000 count
2025-08-11T14:33:46.565Z,1754922826.565 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl
2025-08-11T14:33:46.566Z,1754922826.566 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl
2025-08-11T14:33:46.583Z,1754922826.583 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl
2025-08-11T14:33:46.592Z,1754922826.592 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.039525
2025-08-11T14:33:46.844Z,1754922826.844 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.291703
2025-08-11T14:33:47.096Z,1754922827.096 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.543582
2025-08-11T14:33:47.348Z,1754922827.348 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.795364
2025-08-11T14:33:47.600Z,1754922827.600 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.047787
2025-08-11T14:33:47.852Z,1754922827.852 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.299468
2025-08-11T14:33:48.104Z,1754922828.104 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.551482
2025-08-11T14:33:48.356Z,1754922828.356 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.803790
2025-08-11T14:33:48.608Z,1754922828.608 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.055552
2025-08-11T14:33:48.860Z,1754922828.860 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.307491
2025-08-11T14:33:49.112Z,1754922829.112 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.559504
2025-08-11T14:33:49.364Z,1754922829.364 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.811474
2025-08-11T14:33:49.616Z,1754922829.616 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.063486
2025-08-11T14:33:49.868Z,1754922829.868 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.315765
2025-08-11T14:33:50.120Z,1754922830.120 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.567561
2025-08-11T14:33:50.372Z,1754922830.372 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.819619
2025-08-11T14:33:50.624Z,1754922830.624 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.071705
2025-08-11T14:33:50.877Z,1754922830.877 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.323967
2025-08-11T14:33:51.128Z,1754922831.128 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.575481
2025-08-11T14:33:51.384Z,1754922831.384 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.831741
2025-08-11T14:33:51.892Z,1754922831.892 [DAT](INFO): DAT read: Response Not Received
2025-08-11T14:33:51.892Z,1754922831.892 [DAT](INFO): response not received
2025-08-11T14:33:51.893Z,1754922831.893 [DAT](INFO): DAT read: user:10>
2025-08-11T14:33:51.894Z,1754922831.894 [DAT](INFO): DAT read: Tx time:14:33:53.2202
2025-08-11T14:33:51.894Z,1754922831.894 [DAT](INFO): Ping request sent.
2025-08-11T14:33:51.894Z,1754922831.894 [DAT](INFO): transmitted an acoustic signal
2025-08-11T14:33:51.894Z,1754922831.894 [DAT](INFO): publishing transmit ping time
2025-08-11T14:33:51.895Z,1754922831.895 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000734
2025-08-11T14:33:52.144Z,1754922832.144 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250420
2025-08-11T14:33:52.396Z,1754922832.396 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502218
2025-08-11T14:33:52.648Z,1754922832.648 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754183
2025-08-11T14:33:52.900Z,1754922832.900 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006158
2025-08-11T14:33:53.152Z,1754922833.152 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258207
2025-08-11T14:33:53.404Z,1754922833.404 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510115
2025-08-11T14:33:53.656Z,1754922833.656 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762123
2025-08-11T14:33:53.908Z,1754922833.908 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014044
2025-08-11T14:33:54.087Z,1754922834.087 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into:
NaN
3
100
80
20
5
NaN
NaN
2.0
NaN
NaN
0
1
NaN
NaN
5
0
0
0
0
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
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
PeakDetectVsDepth
EdgeDetectVsDepth
GoDown, ChlPeakThresh, PeakChl, PeakChlDepth, EdgeChl, EdgeChlDepth =
,
,
,
,
,
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
_.planktivore_LM_AvgRois
EdgeDetectVsDepth
_.planktivore_LM_AvgRois
GoDown, PlanktivoreLMavgROIPeakThresh, PeakPlanktivoreLMavgROI, PeakPlanktivoreLMavgROIDepth, EdgePlanktivoreLMavgROI, EdgePlanktivoreLMavgROIDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_HM_AvgRois
EdgeDetectVsDepth
_.planktivore_HM_AvgRois
GoDown, PlanktivoreHMavgROIPeakThresh, PeakPlanktivoreHMavgROI, PeakPlanktivoreHMavgROIDepth, EdgePlanktivoreHMavgROI, EdgePlanktivoreHMavgROIDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_diatoms
EdgeDetectVsDepth
_.planktivore_diatoms
GoDown, PlanktivoreDiatomsPeakThresh, PeakPlanktivoreDiatoms, PeakPlanktivoreDiatomsDepth, EdgePlanktivoreDiatoms, EdgePlanktivoreDiatomsDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_dinoflagellates
EdgeDetectVsDepth
_.planktivore_dinoflagellates
GoDown, PlanktivoreDinoflagellatesPeakThresh, PeakPlanktivoreDinoflagellates, PeakPlanktivoreDinoflagellatesDepth, EdgePlanktivoreDinoflagellates, EdgePlanktivoreDinoflagellatesDepth =
,
,
,
,
,
Triggered. PeakChl values on
consecutive yo-yo profiles fall in [
] (NaN bound is ignored).
2025-08-11T14:33:54.160Z,1754922834.160 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266158
2025-08-11T14:33:54.162Z,1754922834.162 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectChlActive = 0 bool
2025-08-11T14:33:54.201Z,1754922834.201 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EdgeDetectChlActive = 0 bool
2025-08-11T14:33:54.240Z,1754922834.240 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.TimeWindowPeakReport = nan min
2025-08-11T14:33:54.259Z,1754922834.259 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.HighestChlPeakReportActive = 0 bool
2025-08-11T14:33:54.262Z,1754922834.262 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.HighestSaltPeakReportActive = 0 bool
2025-08-11T14:33:54.284Z,1754922834.284 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.HighestOilPeakReportActive = 0 bool
2025-08-11T14:33:54.296Z,1754922834.296 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PatchTracking = 0 bool
2025-08-11T14:33:54.299Z,1754922834.299 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.FilterWidthHorizontal = 3.000000 count
2025-08-11T14:33:54.314Z,1754922834.314 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.NumProfilesSlidingwindow = 100.000000 count
2025-08-11T14:33:54.325Z,1754922834.325 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.OffPeakFractionHorizontal = 80.000000 %
2025-08-11T14:33:54.333Z,1754922834.333 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectNO3Active = 0 bool
2025-08-11T14:33:54.352Z,1754922834.352 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectOilActive = 0 bool
2025-08-11T14:33:54.354Z,1754922834.354 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectFDOMActive = 0 bool
2025-08-11T14:33:54.366Z,1754922834.366 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectSalinityActive = 0 bool
2025-08-11T14:33:54.375Z,1754922834.375 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectPlanktivoreLMavgROIActive = 0 bool
2025-08-11T14:33:54.390Z,1754922834.390 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EdgeDetectPlanktivoreLMavgROIActive = 0 bool
2025-08-11T14:33:54.413Z,1754922834.413 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518498
2025-08-11T14:33:54.399Z,1754922834.399 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectPlanktivoreHMavgROIActive = 0 bool
2025-08-11T14:33:54.418Z,1754922834.418 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EdgeDetectPlanktivoreHMavgROIActive = 0 bool
2025-08-11T14:33:54.429Z,1754922834.429 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectPlanktivoreDiatomsActive = 0 bool
2025-08-11T14:33:54.456Z,1754922834.456 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EdgeDetectPlanktivoreDiatomsActive = 0 bool
2025-08-11T14:33:54.458Z,1754922834.458 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectPlanktivoreDinoflagellatesActive = 0 bool
2025-08-11T14:33:54.470Z,1754922834.470 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EdgeDetectPlanktivoreDinoflagellatesActive = 0 bool
2025-08-11T14:33:54.495Z,1754922834.495 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2025-08-11T14:33:54.499Z,1754922834.499 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledAanderaaO2 = 0 bool
2025-08-11T14:33:54.511Z,1754922834.511 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledNeilBrown = 0 bool
2025-08-11T14:33:54.522Z,1754922834.522 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledRBRTridente = 0 bool
2025-08-11T14:33:54.558Z,1754922834.558 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledSeabird = 1 bool
2025-08-11T14:33:54.566Z,1754922834.566 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledWetLabsBB2FL = 1 bool
2025-08-11T14:33:54.594Z,1754922834.594 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool
2025-08-11T14:33:54.623Z,1754922834.623 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledWetLabsUBAT = 0 bool
2025-08-11T14:33:54.626Z,1754922834.626 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.LowPassWindowLength = 20.000000 count
2025-08-11T14:33:54.642Z,1754922834.642 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.MedianFilterLen = 5.000000 count
2025-08-11T14:33:54.668Z,1754922834.668 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.774066
2025-08-11T14:33:54.677Z,1754922834.677 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.ShallowBound = nan m
2025-08-11T14:33:54.684Z,1754922834.684 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.DeepBound = nan m
2025-08-11T14:33:54.702Z,1754922834.702 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2025-08-11T14:33:54.714Z,1754922834.714 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.OffPeakFractionVerticalAscent = nan %
2025-08-11T14:33:54.722Z,1754922834.722 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.OffPeakFractionVerticalDescent = nan %
2025-08-11T14:33:54.737Z,1754922834.737 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.ChlPeakThresh = 0.000000 ug/l
2025-08-11T14:33:54.764Z,1754922834.764 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.NumberOfLayers = 1.000000 count
2025-08-11T14:33:54.775Z,1754922834.775 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.ChlThreshTriggerActive = 0 bool
2025-08-11T14:33:54.779Z,1754922834.779 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.ChlLowerThresh = nan ug/l
2025-08-11T14:33:54.790Z,1754922834.790 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.ChlUpperThresh = nan ug/l
2025-08-11T14:33:54.813Z,1754922834.813 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.NumProfilesThresh = 5.000000 count
2025-08-11T14:33:54.820Z,1754922834.820 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PlanktivoreLMavgROIPeakThresh = 0.000000 count/s
2025-08-11T14:33:54.827Z,1754922834.827 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PlanktivoreHMavgROIPeakThresh = 0.000000 count/s
2025-08-11T14:33:54.830Z,1754922834.830 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PlanktivoreDiatomsPeakThresh = 0.000000 count/ml
2025-08-11T14:33:54.849Z,1754922834.849 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PlanktivoreDinoflagellatesPeakThresh = 0.000000 count/ml
2025-08-11T14:33:54.856Z,1754922834.856 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.GoDown = 1 bool
2025-08-11T14:33:54.860Z,1754922834.860 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakChl = nan ug/l
2025-08-11T14:33:54.871Z,1754922834.871 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakChlDepth = nan m
2025-08-11T14:33:54.875Z,1754922834.875 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakChlTemperature = nan degC
2025-08-11T14:33:54.897Z,1754922834.897 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakChlLatitude = nan arcdeg
2025-08-11T14:33:54.905Z,1754922834.905 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakChlLongitude = nan arcdeg
2025-08-11T14:33:54.908Z,1754922834.908 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgeChl = nan ug/l
2025-08-11T14:33:54.916Z,1754922834.916 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022175
2025-08-11T14:33:54.920Z,1754922834.920 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgeChlDepth = nan m
2025-08-11T14:33:54.931Z,1754922834.931 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgeChlTemperature = nan degC
2025-08-11T14:33:54.935Z,1754922834.935 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgeChlLatitude = nan arcdeg
2025-08-11T14:33:54.942Z,1754922834.942 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgeChlLongitude = nan arcdeg
2025-08-11T14:33:54.955Z,1754922834.955 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakNO3 = nan umol/l
2025-08-11T14:33:54.958Z,1754922834.958 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakNO3Depth = nan m
2025-08-11T14:33:54.966Z,1754922834.966 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakNO3Latitude = nan arcdeg
2025-08-11T14:33:55.017Z,1754922835.017 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakNO3Longitude = nan arcdeg
2025-08-11T14:33:55.040Z,1754922835.040 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakOil = nan kg/m3
2025-08-11T14:33:55.047Z,1754922835.047 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakOilDepth = nan m
2025-08-11T14:33:55.050Z,1754922835.050 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakOilLatitude = nan arcdeg
2025-08-11T14:33:55.062Z,1754922835.062 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakOilLongitude = nan arcdeg
2025-08-11T14:33:55.094Z,1754922835.094 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakFDOM = nan ppb
2025-08-11T14:33:55.097Z,1754922835.097 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakFDOMDepth = nan m
2025-08-11T14:33:55.113Z,1754922835.113 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakFDOMTemperature = nan degC
2025-08-11T14:33:55.121Z,1754922835.121 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakFDOMLatitude = nan arcdeg
2025-08-11T14:33:55.136Z,1754922835.136 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakFDOMLongitude = nan arcdeg
2025-08-11T14:33:55.148Z,1754922835.148 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakSalt = nan psu
2025-08-11T14:33:55.159Z,1754922835.159 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakSaltDepth = nan m
2025-08-11T14:33:55.162Z,1754922835.162 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakSaltTemperature = nan degC
2025-08-11T14:33:55.169Z,1754922835.169 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.274702
2025-08-11T14:33:55.172Z,1754922835.172 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakSaltLatitude = nan arcdeg
2025-08-11T14:33:55.175Z,1754922835.175 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakSaltLongitude = nan arcdeg
2025-08-11T14:33:55.179Z,1754922835.179 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreLMavgROI = nan count/s
2025-08-11T14:33:55.182Z,1754922835.182 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreLMavgROIDepth = nan m
2025-08-11T14:33:55.201Z,1754922835.201 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreLMavgROITemperature = nan degC
2025-08-11T14:33:55.205Z,1754922835.205 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreLMavgROILatitude = nan arcdeg
2025-08-11T14:33:55.208Z,1754922835.208 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreLMavgROILongitude = nan arcdeg
2025-08-11T14:33:55.224Z,1754922835.224 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreLMavgROI = nan count/s
2025-08-11T14:33:55.227Z,1754922835.227 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreLMavgROIDepth = nan m
2025-08-11T14:33:55.231Z,1754922835.231 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreLMavgROITemperature = nan degC
2025-08-11T14:33:55.249Z,1754922835.249 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreLMavgROILatitude = nan arcdeg
2025-08-11T14:33:55.253Z,1754922835.253 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreLMavgROILongitude = nan arcdeg
2025-08-11T14:33:55.264Z,1754922835.264 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreHMavgROI = nan count/s
2025-08-11T14:33:55.267Z,1754922835.267 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreHMavgROIDepth = nan m
2025-08-11T14:33:55.270Z,1754922835.270 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreHMavgROITemperature = nan degC
2025-08-11T14:33:55.303Z,1754922835.303 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreHMavgROILatitude = nan arcdeg
2025-08-11T14:33:55.307Z,1754922835.307 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreHMavgROILongitude = nan arcdeg
2025-08-11T14:33:55.310Z,1754922835.310 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreHMavgROI = nan count/s
2025-08-11T14:33:55.327Z,1754922835.327 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreHMavgROIDepth = nan m
2025-08-11T14:33:55.331Z,1754922835.331 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreHMavgROITemperature = nan degC
2025-08-11T14:33:55.334Z,1754922835.334 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreHMavgROILatitude = nan arcdeg
2025-08-11T14:33:55.346Z,1754922835.346 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreHMavgROILongitude = nan arcdeg
2025-08-11T14:33:55.350Z,1754922835.350 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreDiatoms = nan count/ml
2025-08-11T14:33:55.353Z,1754922835.353 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreDiatomsDepth = nan m
2025-08-11T14:33:55.374Z,1754922835.374 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreDiatomsTemperature = nan degC
2025-08-11T14:33:55.378Z,1754922835.378 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreDiatomsLatitude = nan arcdeg
2025-08-11T14:33:55.415Z,1754922835.415 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreDiatomsLongitude = nan arcdeg
2025-08-11T14:33:55.420Z,1754922835.420 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.526150
2025-08-11T14:33:55.430Z,1754922835.430 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreDiatoms = nan count/ml
2025-08-11T14:33:55.450Z,1754922835.450 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreDiatomsDepth = nan m
2025-08-11T14:33:55.457Z,1754922835.457 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreDiatomsTemperature = nan degC
2025-08-11T14:33:55.477Z,1754922835.477 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreDiatomsLatitude = nan arcdeg
2025-08-11T14:33:55.485Z,1754922835.485 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreDiatomsLongitude = nan arcdeg
2025-08-11T14:33:55.488Z,1754922835.488 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreDinoflagellates = nan count/ml
2025-08-11T14:33:55.500Z,1754922835.500 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreDinoflagellatesDepth = nan m
2025-08-11T14:33:55.507Z,1754922835.507 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreDinoflagellatesTemperature = nan degC
2025-08-11T14:33:55.511Z,1754922835.511 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreDinoflagellatesLatitude = nan arcdeg
2025-08-11T14:33:55.518Z,1754922835.518 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakPlanktivoreDinoflagellatesLongitude = nan arcdeg
2025-08-11T14:33:55.526Z,1754922835.526 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreDinoflagellates = nan count/ml
2025-08-11T14:33:55.530Z,1754922835.530 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreDinoflagellatesDepth = nan m
2025-08-11T14:33:55.542Z,1754922835.542 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreDinoflagellatesTemperature = nan degC
2025-08-11T14:33:55.546Z,1754922835.546 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreDinoflagellatesLatitude = nan arcdeg
2025-08-11T14:33:55.562Z,1754922835.562 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.EdgePlanktivoreDinoflagellatesLongitude = nan arcdeg
2025-08-11T14:33:55.567Z,1754922835.567 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchChl = nan ug/l
2025-08-11T14:33:55.583Z,1754922835.583 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchChlDepth = nan m
2025-08-11T14:33:55.587Z,1754922835.587 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchChlLatitude = nan arcdeg
2025-08-11T14:33:55.594Z,1754922835.594 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchChlLongitude = nan arcdeg
2025-08-11T14:33:55.598Z,1754922835.598 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchChlDistance = nan m
2025-08-11T14:33:55.610Z,1754922835.610 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchSalt = nan psu
2025-08-11T14:33:55.615Z,1754922835.615 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchSaltDepth = nan m
2025-08-11T14:33:55.630Z,1754922835.630 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchSaltLatitude = nan arcdeg
2025-08-11T14:33:55.646Z,1754922835.646 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchSaltLongitude = nan arcdeg
2025-08-11T14:33:55.650Z,1754922835.650 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchSaltDistance = nan m
2025-08-11T14:33:55.662Z,1754922835.662 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchOil = nan psu
2025-08-11T14:33:55.670Z,1754922835.670 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchOilDepth = nan m
2025-08-11T14:33:55.673Z,1754922835.673 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.778587
2025-08-11T14:33:55.681Z,1754922835.681 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchOilLatitude = nan arcdeg
2025-08-11T14:33:55.689Z,1754922835.689 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchOilLongitude = nan arcdeg
2025-08-11T14:33:55.704Z,1754922835.704 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchOilDistance = nan m
2025-08-11T14:33:55.711Z,1754922835.711 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.TriggeredOnChl = 0 bool
2025-08-11T14:33:55.733Z,1754922835.733 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.ChlTriggering = nan ug/l
2025-08-11T14:33:55.807Z,1754922835.807 [DataOverHttps](INFO): Sending 272 bytes from file Logs/20250811T142458/Express0005.lzma
2025-08-11T14:33:55.896Z,1754922835.896 [lineCaptureHoming:Science:PeakDetectChl:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-08-11T14:33:55.924Z,1754922835.924 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.030154
2025-08-11T14:33:55.934Z,1754922835.934 [lineCaptureHoming:Science:EdgeDetectChl:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-08-11T14:33:55.993Z,1754922835.993 [lineCaptureHoming:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-08-11T14:33:56.025Z,1754922836.025 [lineCaptureHoming:Science:PeakDetectNO3:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-08-11T14:33:56.069Z,1754922836.069 [lineCaptureHoming:Science:PeakDetectOil:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-08-11T14:33:56.094Z,1754922836.094 [lineCaptureHoming:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-08-11T14:33:56.134Z,1754922836.134 [lineCaptureHoming:Science:PeakDetectFDOM:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-08-11T14:33:56.167Z,1754922836.167 [lineCaptureHoming:Science:PeakDetectSalinity:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-08-11T14:33:56.176Z,1754922836.176 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.282237
2025-08-11T14:33:56.235Z,1754922836.235 [lineCaptureHoming:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-08-11T14:33:56.287Z,1754922836.287 [lineCaptureHoming:Science:PeakDetectPlanktivoreLMavgROI:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-08-11T14:33:56.317Z,1754922836.317 [lineCaptureHoming:Science:EdgeDetectPlanktivoreLMavgROI:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-08-11T14:33:56.370Z,1754922836.370 [lineCaptureHoming:Science:PeakDetectPlanktivoreHMavgROI:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-08-11T14:33:56.402Z,1754922836.402 [lineCaptureHoming:Science:EdgeDetectPlanktivoreHMavgROI:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-08-11T14:33:56.428Z,1754922836.428 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.534226
2025-08-11T14:33:56.470Z,1754922836.470 [lineCaptureHoming:Science:PeakDetectPlanktivoreDiatoms:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-08-11T14:33:56.506Z,1754922836.506 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDiatoms:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-08-11T14:33:56.563Z,1754922836.563 [lineCaptureHoming:Science:PeakDetectPlanktivoreDinoflagellates:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-08-11T14:33:56.626Z,1754922836.626 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDinoflagellates:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-08-11T14:33:56.680Z,1754922836.680 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.786409
2025-08-11T14:33:56.703Z,1754922836.703 [lineCaptureHoming:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect.
2025-08-11T14:33:56.719Z,1754922836.719 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-08-11T14:33:56.720Z,1754922836.720 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-08-11T14:33:56.721Z,1754922836.721 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-08-11T14:33:56.809Z,1754922836.809 [DataOverHttps](INFO): Moved sent file to Logs/20250811T142458/Express0005.lzma.bak
2025-08-11T14:33:56.809Z,1754922836.809 [DataOverHttps](INFO): SBD MOMSN=25837477
2025-08-11T14:33:56.920Z,1754922836.920 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
5
1.5
200
2000
2025-08-11T14:33:56.932Z,1754922836.932 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.038174
2025-08-11T14:33:56.948Z,1754922836.948 [MissionManager](INFO): DefineArg lineCaptureHoming:StandardEnvelopes.MinAltitude = 5.000000 m
2025-08-11T14:33:56.960Z,1754922836.960 [MissionManager](INFO): DefineArg lineCaptureHoming:StandardEnvelopes.MaxDepthIgnore = 1.500000 m
2025-08-11T14:33:56.971Z,1754922836.971 [MissionManager](INFO): DefineArg lineCaptureHoming:StandardEnvelopes.MaxDepth = 200.000000 m
2025-08-11T14:33:56.974Z,1754922836.974 [MissionManager](INFO): DefineArg lineCaptureHoming:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-08-11T14:33:56.984Z,1754922836.984 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-08-11T14:33:57.025Z,1754922837.025 [lineCaptureHoming:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-08-11T14:33:57.088Z,1754922837.088 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-08-11T14:33:57.117Z,1754922837.117 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2025-08-11T14:33:57.118Z,1754922837.118 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2025-08-11T14:33:57.119Z,1754922837.119 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2025-08-11T14:33:57.184Z,1754922837.184 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.290210
2025-08-11T14:33:57.436Z,1754922837.436 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.542047
2025-08-11T14:33:57.648Z,1754922837.648 [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-08-11T14:33:57.658Z,1754922837.658 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.DiveInterval = 1.000000 h
2025-08-11T14:33:57.661Z,1754922837.661 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.WaitForPitchUp = 10.000000 min
2025-08-11T14:33:57.664Z,1754922837.664 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.SurfacePitch = 20.000000 arcdeg
2025-08-11T14:33:57.681Z,1754922837.681 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.SurfaceDepthRate = nan m/s
2025-08-11T14:33:57.684Z,1754922837.684 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.SurfaceSpeed = 1.000000 m/s
2025-08-11T14:33:57.687Z,1754922837.687 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.SurfacingTimeout = 1000.000000 s
2025-08-11T14:33:57.688Z,1754922837.688 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.794232
2025-08-11T14:33:57.704Z,1754922837.704 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.GPSTimeout = 7.000000 min
2025-08-11T14:33:57.710Z,1754922837.710 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.CommsTimeout = 30.000000 min
2025-08-11T14:33:57.767Z,1754922837.767 [lineCaptureHoming:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-08-11T14:33:57.865Z,1754922837.865 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/MicromodemComms.tl
2025-08-11T14:33:57.865Z,1754922837.865 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/MicromodemComms.tl
2025-08-11T14:33:57.866Z,1754922837.866 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/MicromodemComms.tl
2025-08-11T14:33:57.940Z,1754922837.940 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.046069
2025-08-11T14:33:57.985Z,1754922837.985 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/MicromodemComms.tl translated into:
10
5
2025-08-11T14:33:57.994Z,1754922837.994 [MissionManager](INFO): DefineArg lineCaptureHoming:MicromodemComms.Timeout = 10.000000 min
2025-08-11T14:33:58.005Z,1754922838.005 [MissionManager](INFO): DefineArg lineCaptureHoming:MicromodemComms.CommsInterval = 5.000000 min
2025-08-11T14:33:58.015Z,1754922838.015 [MissionManager](INFO): RedefineArg lineCaptureHoming:MicromodemComms.CommsInterval = reader:lineCaptureHoming.MicromodemCommsInterval
2025-08-11T14:33:58.018Z,1754922838.018 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/LineCapture.tl
2025-08-11T14:33:58.019Z,1754922838.019 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/LineCapture.tl
2025-08-11T14:33:58.025Z,1754922838.025 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/LineCapture.tl
2025-08-11T14:33:58.192Z,1754922838.192 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.298425
2025-08-11T14:33:58.447Z,1754922838.447 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.552494
2025-08-11T14:33:58.696Z,1754922838.696 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.802075
2025-08-11T14:33:58.948Z,1754922838.948 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.054329
2025-08-11T14:33:59.200Z,1754922839.200 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.306208
2025-08-11T14:33:59.452Z,1754922839.452 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.557931
2025-08-11T14:33:59.705Z,1754922839.705 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.810492
2025-08-11T14:33:59.956Z,1754922839.956 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.062108
2025-08-11T14:33:59.973Z,1754922839.973 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/LineCapture.tl translated into:
30
0.0
1
0.01
0.001
2
8
1
NaN
NaN
NaN
0.0
0
NaN
-1
0
1
2
3
1
5
0
0
Timed out while trying to detach from dock at current depth of
.
Transitioning to midcourse guidance.
Navigating to dock waypoint (
,
)
Transitioning to terminal guidance at range
Terminating homing sequence: timed out while navigating to the dock waypoint.
Executing search pattern.
Timed out while executing search pattern around dock waypoint.
Homing sequence timed out prior to docking.
Terminal guidance.
Transitioning to midcourse guidance. Received last range of
ago.
Docked. Homing sequence complete.
3
GuidanceMode
2025-08-11T14:33:59.985Z,1754922839.985 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.DockLat = 36.905698 arcdeg
2025-08-11T14:33:59.989Z,1754922839.989 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.DockLon = -122.116120 arcdeg
2025-08-11T14:33:59.992Z,1754922839.992 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.DetachTimeout = 30.000000 min
2025-08-11T14:34:00.008Z,1754922840.008 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MidcourseDepth = 50.000000 m
2025-08-11T14:34:00.016Z,1754922840.016 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MidcourseSpeed = 0.800000 m/s
2025-08-11T14:34:00.022Z,1754922840.022 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MidcourseTimeout = 6.000000 h
2025-08-11T14:34:00.026Z,1754922840.026 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.TerminalRange = 650.000000 m
2025-08-11T14:34:00.044Z,1754922840.044 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.AcousticTimeout = 5.000000 min
2025-08-11T14:34:00.054Z,1754922840.054 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.losRateIIRFilterDecay = 0.000000 n/a
2025-08-11T14:34:00.062Z,1754922840.062 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.SearchTimeout = 5.000000 min
2025-08-11T14:34:00.070Z,1754922840.070 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.CircleRadius = 1000.000000 m
2025-08-11T14:34:00.074Z,1754922840.074 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.CircleMaxError = 1.000000 m
2025-08-11T14:34:00.085Z,1754922840.085 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.CircleTurnToPort = 0 bool
2025-08-11T14:34:00.089Z,1754922840.089 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.DepthDeadband = 0.010000 m
2025-08-11T14:34:00.105Z,1754922840.105 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.RudderDeadband = 0.001000 arcdeg
2025-08-11T14:34:00.113Z,1754922840.113 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MinAltitude = 2.000000 m
2025-08-11T14:34:00.129Z,1754922840.129 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MaxDepth = 8.000000 m
2025-08-11T14:34:00.135Z,1754922840.135 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MinOffshore = 1.000000 m
2025-08-11T14:34:00.146Z,1754922840.146 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.DockingAltitude = nan m
2025-08-11T14:34:00.158Z,1754922840.158 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.InvalidAltitudeTimeout = nan min
2025-08-11T14:34:00.162Z,1754922840.162 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.AltitudeDepthLimit = nan m
2025-08-11T14:34:00.174Z,1754922840.174 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.AltitudeIIRFilterDecay = 0.000000 n/a
2025-08-11T14:34:00.178Z,1754922840.178 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.ElapsedRange = 0.000000 min
2025-08-11T14:34:00.193Z,1754922840.193 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.Range = nan m
2025-08-11T14:34:00.197Z,1754922840.197 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.DoneTimeout = -1.000000 count
2025-08-11T14:34:00.208Z,1754922840.208 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.314186
2025-08-11T14:34:00.210Z,1754922840.210 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.Done = 0.000000 count
2025-08-11T14:34:00.214Z,1754922840.214 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.DetachFromDock = 1.000000 count
2025-08-11T14:34:00.261Z,1754922840.261 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.Midcourse = 2.000000 count
2025-08-11T14:34:00.292Z,1754922840.292 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.Terminal = 3.000000 count
2025-08-11T14:34:00.303Z,1754922840.303 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.GuidanceMode = 1.000000 count
2025-08-11T14:34:00.307Z,1754922840.307 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.DockingDepth = 1.000000 m
2025-08-11T14:34:00.318Z,1754922840.318 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.LineCapRollout = 5.000000 count
2025-08-11T14:34:00.333Z,1754922840.333 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-08-11T14:34:00.333Z,1754922840.333 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-08-11T14:34:00.334Z,1754922840.334 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-08-11T14:34:00.460Z,1754922840.460 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.566409
2025-08-11T14:34:00.479Z,1754922840.479 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
5
1.5
200
2000
2025-08-11T14:34:00.489Z,1754922840.489 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture:StandardEnvelopes.MinAltitude = 5.000000 m
2025-08-11T14:34:00.497Z,1754922840.497 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture:StandardEnvelopes.MaxDepthIgnore = 1.500000 m
2025-08-11T14:34:00.501Z,1754922840.501 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture:StandardEnvelopes.MaxDepth = 200.000000 m
2025-08-11T14:34:00.513Z,1754922840.513 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-08-11T14:34:00.514Z,1754922840.514 [lineCaptureHoming:LineCapture:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-08-11T14:34:00.530Z,1754922840.530 [lineCaptureHoming:LineCapture:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-08-11T14:34:00.552Z,1754922840.552 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-08-11T14:34:00.602Z,1754922840.602 [lineCaptureHoming:LineCapture:HoldMass:B.Mass](DEBUG): Construct.
2025-08-11T14:34:00.616Z,1754922840.616 [lineCaptureHoming:LineCapture:HoldBuoyancy:A.Buoyancy](DEBUG): Construct Buoyancy.
2025-08-11T14:34:00.668Z,1754922840.668 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](DEBUG): Construct.
2025-08-11T14:34:00.668Z,1754922840.668 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](DEBUG): Initializing internal variables to default values.
2025-08-11T14:34:00.712Z,1754922840.712 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.818387
2025-08-11T14:34:00.742Z,1754922840.742 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:C.SetSpeed](DEBUG): Construct.
2025-08-11T14:34:00.756Z,1754922840.756 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:D.Pitch](DEBUG): Construct.
2025-08-11T14:34:00.771Z,1754922840.771 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Construct Waypoint.
2025-08-11T14:34:00.807Z,1754922840.807 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:SearchPattern:A.Circle](DEBUG): Construct.
2025-08-11T14:34:00.827Z,1754922840.827 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:SearchPattern:B.Wait](DEBUG): Construct Wait.
2025-08-11T14:34:00.895Z,1754922840.895 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl:A.AltitudeServo](DEBUG): Construct.
2025-08-11T14:34:00.912Z,1754922840.912 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl:A.Pitch](DEBUG): Construct.
2025-08-11T14:34:00.930Z,1754922840.930 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:G.LineCapture](DEBUG): Construct.
2025-08-11T14:34:00.966Z,1754922840.966 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.071773
2025-08-11T14:34:00.998Z,1754922840.998 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:G.LineCapture](DEBUG): Initializing internal variables to default values.
2025-08-11T14:34:00.998Z,1754922840.998 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:G.LineCapture](INFO): Transitioning guidance mode to: UNINITIALIZED
2025-08-11T14:34:01.016Z,1754922841.016 [lineCaptureHoming:LineCapture:L.Wait](DEBUG): Construct Wait.
2025-08-11T14:34:01.216Z,1754922841.216 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.322196
2025-08-11T14:34:01.270Z,1754922841.270 [lineCaptureHoming:restartDHCP:B.Execute](DEBUG): Construct Execute.
2025-08-11T14:34:01.277Z,1754922841.277 [lineCaptureHoming:BA.Execute](DEBUG): Construct Execute.
2025-08-11T14:34:01.284Z,1754922841.284 [lineCaptureHoming:InitialDive:A.SetSpeed](DEBUG): Construct.
2025-08-11T14:34:01.292Z,1754922841.292 [lineCaptureHoming:InitialDive:B.Mass](DEBUG): Construct.
2025-08-11T14:34:01.300Z,1754922841.300 [lineCaptureHoming:InitialDive:C.Pitch](DEBUG): Construct.
2025-08-11T14:34:01.318Z,1754922841.318 [lineCaptureHoming:InitialDive:C.Pitch:A_Timeout:B.Execute](DEBUG): Construct Execute.
2025-08-11T14:34:01.366Z,1754922841.366 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/SetNavAcoustic.tl
2025-08-11T14:34:01.366Z,1754922841.366 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/SetNavAcoustic.tl
2025-08-11T14:34:01.367Z,1754922841.367 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/SetNavAcoustic.tl
2025-08-11T14:34:01.468Z,1754922841.468 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.574180
2025-08-11T14:34:01.588Z,1754922841.588 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/SetNavAcoustic.tl translated into:
Reseting nav to dock location at range
2025-08-11T14:34:01.598Z,1754922841.598 [MissionManager](INFO): DefineArg lineCaptureHoming:Lap:Docked:SetNavAcoustic.DockLat = 36.905698 arcdeg
2025-08-11T14:34:01.606Z,1754922841.606 [MissionManager](INFO): DefineArg lineCaptureHoming:Lap:Docked:SetNavAcoustic.DockLon = -122.116120 arcdeg
2025-08-11T14:34:01.614Z,1754922841.614 [MissionManager](INFO): DefineArg lineCaptureHoming:Lap:Docked:SetNavAcoustic.DockRange = 0.000000 m
2025-08-11T14:34:01.622Z,1754922841.622 [MissionManager](INFO): DefineArg lineCaptureHoming:Lap:Docked:SetNavAcoustic.RangeTimeout = 5.000000 min
2025-08-11T14:34:01.638Z,1754922841.638 [lineCaptureHoming:Lap:Docked:SetNavAcoustic:UpdateNav:B.SetNav](DEBUG): Construct SetNav.
2025-08-11T14:34:01.658Z,1754922841.658 [lineCaptureHoming:Lap:Docked:Docked.Docked](DEBUG): Construct.
2025-08-11T14:34:01.658Z,1754922841.658 [lineCaptureHoming:Lap:Docked:Docked.Docked](DEBUG): Initializing internal variables to default values.
2025-08-11T14:34:01.722Z,1754922841.722 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.827521
2025-08-11T14:34:01.776Z,1754922841.776 [lineCaptureHoming:Lap:Docked:Detach:Undock.Undock](DEBUG): Construct.
2025-08-11T14:34:01.776Z,1754922841.776 [lineCaptureHoming:Lap:Docked:Detach:Undock.Undock](DEBUG): Initializing internal variables to default values.
2025-08-11T14:34:01.811Z,1754922841.811 [lineCaptureHoming:Lap:Docked:Wpt1:B.Pitch](DEBUG): Construct.
2025-08-11T14:34:01.822Z,1754922841.822 [lineCaptureHoming:Lap:Docked:Wpt1:C.SetSpeed](DEBUG): Construct.
2025-08-11T14:34:01.833Z,1754922841.833 [lineCaptureHoming:Lap:Docked:Wpt1:D.Waypoint](DEBUG): Construct Waypoint.
2025-08-11T14:34:01.918Z,1754922841.918 [lineCaptureHoming:Lap:Docked:Drift:B.Buoyancy](DEBUG): Construct Buoyancy.
2025-08-11T14:34:01.931Z,1754922841.931 [lineCaptureHoming:Lap:Docked:Drift:C.Pitch](DEBUG): Construct.
2025-08-11T14:34:01.963Z,1754922841.963 [lineCaptureHoming:Lap:Docked:Drift:D.Point](DEBUG): Construct.
2025-08-11T14:34:02.010Z,1754922842.010 [lineCaptureHoming:Lap:Docked:Drift:E.SetSpeed](DEBUG): Construct.
2025-08-11T14:34:02.018Z,1754922842.018 [lineCaptureHoming:Lap:Docked:Drift:F.Wait](DEBUG): Construct Wait.
2025-08-11T14:34:02.224Z,1754922842.224 [DAT](INFO): DAT read: Response Not Received
2025-08-11T14:34:02.224Z,1754922842.224 [DAT](INFO): response not received
2025-08-11T14:34:02.225Z,1754922842.225 [DAT](INFO): DAT read: user:11>
2025-08-11T14:34:02.225Z,1754922842.225 [DAT](ERROR): No response from remote modem.
2025-08-11T14:34:02.300Z,1754922842.300 [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 lineCaptureHoming {
"""
Home to transponder while maintaining altitude or depth. Altitude gets
priority if non nan. The mission sequence: (*) Start (1) Midcourse
guidance: nav to target WP while querying transponder (2) Terminal
guidance: home to target using USBL tracking data (4) Dock: final
approach using fixed heading.
"""
# Define mission arguments
arguments {
MissionTimeout = 3 hour
"""
Maximum length of mission
"""
NeedCommsTime = 180 minute
"""
How often to surface for commumications
"""
MicromodemCommsInterval = 3 hour
"""
How often to trigger Umodem communications
"""
Repeat = 1 count
"""
Number of times the vehicle should try to cycle through the homing
sequence.
"""
WaitOnDockTimeout = 5 minute
"""
Time duration to wait on the dock after a successful line capture.
"""
StayOnDock = false
"""
If true, mission terminates after WaitOnDockTimeout following a successful
capture, without executing the undock sequence.
"""
TrySlide = false
"""
If true, once docked, try to slide down the docking rod until charging and
comms are acheived
"""
RetryIncompleteDock = false
"""
If true, restart docking sequence in event of a successful capture but
unsuccessful slide
"""
SlideRetries = 4 count
"""
If using slide mode, max number of times to try the slide sequence before
giving up
"""
SlideSinkDuration = 1.5 minute
"""
Time duration to slide down by sinking during each slide mode iteration
"""
SlideCloseDuration = 1.5 minute
"""
Time duration to close arm to check for power/comms during each slide mode
iteration
"""
TransponderCode = Dock:Dock.transponderCode
"""
Transponder Address.
"""
TrackingUpdatePeriodMidcourse = 60 second
"""
How long to wait between acoustic queries.
"""
TrackingUpdatePeriodTerminal = 2 second
"""
How long to wait between acoustic queries.
"""
TrackingUpdatePeriodDocked = 2 minute
"""
How long to wait between acoustic queries.
"""
TrackingNumFixesLowPassFilter = 5 count
"""
Median filter bin size. Filters the contact estimated lat/lon position.
Prefer odd number, set to 1 to disable filter.
"""
NumberOfPings = 1 count
"""
Number of pings requested each time.
"""
NumPingsUSBL = 120 count
"""
Number of pings requested while in USBL mode range.
"""
RangeUSBL = 40 meter
"""
USBL mode range.
"""
TrackingNumFixesLowPassFilterUSBL = 5 count
"""
Median filter bin size. Filters the contact estimated lat/lon position.
Prefer odd number, set to 1 to disable filter.
"""
DockingAltitude = NaN meter
"""
Docking altitude. Ignored when NaN and used over depth when a valid
altitude is set.
"""
InvalidAltitudeTimeout = 10 minute
"""
The mission will use the last good depth command if no valid altitude
readings are received within this specified time duration.
"""
AltitudeDepthLimit = NaN meter
"""
Vehicle will not be commanded deeper than this regardless of altitude
command.
"""
MinAltitude = 4 meter
"""
Minimum height above the sea floor for the entire mission.
"""
MaxDepth = 205 meter
"""
Maximum depth for the entire mission.
"""
MinOffshore = 2 kilometer
"""
Minimum offshore distance for the entire mission.
"""
ApproachDepthTimeout = 20 minute
"""
Maximum wait time for the vehicle to reach the target depth on initial
dive.
"""
ApproachDepthRate = 0.05 meter_per_second
"""
Descent depth rate (positive depth is down). Used only as a smoothing
parameter.
"""
Lat1 = NaN degree
"""
Latitude of rollout waypoint. If nan, waypoint is skipped.
"""
Lon1 = NaN degree
"""
Longitude of rollout waypoint. If nan, waypoint is skipped.
"""
CaptureRadius = NaN meter
"""
How close to call the waypiont behavior satisfied. Nan uses default
value.
"""
CorrectForSoundSpeed = false
"""
Whether or not to apply sound speed correction to acoustic ranges
"""
# Mission Variables (don't change)
MidcourseDepth = Dock:LineCapture.midcourseDepth
"""
Desired vehicle depth when navigating to dock WP (during midcourse
phase).
"""
MidcourseSpeed = Dock:LineCapture.midcourseSpeed
"""
Speed during initial dive and waypoint.
"""
TrackingPeriod = 60 second
"""
Mission variable (don't change). The mission sets this variable to
update the how long to wait between acoustic queries.
"""
}
output {
Mode = -1 count
"""
Mission variable (don't change). The mission sets this variable to
reflect the termination status of the LineCapture insert.
"""
NumPings = 1 count
"""
Mission variable (don't change). The mission sets this variable to
update the requested ping number and enter usbl mode.
"""
LowPassFilterWinSize = 1 count
"""
Mission variable (don't change). The mission sets this variable to
update the requested ping number and enter usbl mode.
"""
LowPassFilterWinOverlap = true
"""
Mission variable (don't change). The mission sets this variable to
update the requested ping number and enter usbl mode.
"""
EndDockingSequence = StayOnDock
"""
Mission variable (don't change). The mission sets this variable to
determine whether or not to restart the docking sequence upon
completion of the Docked behavior.
"""
LastDockSuccessful = false
"""
Mission variable (don't change). The mission sets this variable based
on the last run of the Docked behavior
"""
DockSuccessfulCount = 0 count
"""
Mission variable (don't change). The mission sets this variable to
track the number of complete docking attempts
"""
RepeatArg = Repeat
"""
Mission variable (don't change). Actual number of Lap repetitions
"""
}
# Mission timeout
timeout duration=MissionTimeout
insert Insert/Science.tl {
"""
Most missions will run the science sensors. If you don't place this
aggregate above NeedComms, science instruments get turned off on the
last upcast and while floating on the surface.
"""
}
# Safety nets and surfacing behaviors
insert Insert/StandardEnvelopes.tl
assign in sequence StandardEnvelopes:MinAltitude = MinAltitude
assign in sequence StandardEnvelopes:MaxDepth = MaxDepth
assign in sequence StandardEnvelopes:MinOffshore = MinOffshore
insert id="NeedComms" Insert/NeedComms.tl
assign in sequence NeedComms:DiveInterval = NeedCommsTime
assign in sequence NeedComms:WaitForPitchUp = 0 minute
# Micromodem comms
insert id="MicromodemComms" Insert/MicromodemComms.tl {
redefineArg CommsInterval = MicromodemCommsInterval
}
readData {
while (
Mode >= 0 count
and Sensor:DataOverHttps.connectionStatus == true
)
Universal:platform_communications
}
# Add LineCapture directives.
insert Insert/LineCapture.tl
assign in sequence LineCapture:MaxDepth = MaxDepth
assign in sequence LineCapture:MinOffshore = MinOffshore
assign in sequence LineCapture:MinAltitude = MinAltitude
assign in sequence LineCapture:DockingAltitude = DockingAltitude
assign in sequence LineCapture:InvalidAltitudeTimeout = InvalidAltitudeTimeout
assign in sequence LineCapture:AltitudeDepthLimit = AltitudeDepthLimit
# Add track acoustic contact directive.
assign in sequence NumPings = NumberOfPings
behavior Estimation:TrackAcousticContact id="TrackAC" {
run in parallel
set contactLabelSetting = TransponderCode
set numberOfSamplesSetting = NumPings
set updatePeriodSetting = TrackingPeriod
set numFixesLowPassSetting = LowPassFilterWinSize
set lowPassOverlapSetting = LowPassFilterWinOverlap
set useSoundSpeedCorrectionSetting = CorrectForSoundSpeed
}
# Add USBL mode directives.
aggregate UpdateNumPings_NotTerminal {
run while (
not ( LineCapture:GuidanceMode == LineCapture:Terminal )
and not ( NumPings == NumberOfPings )
)
syslog info "No longer in Terminal. Resuming normal ranging with " + NumberOfPings~count
+ "pings."
assign in sequence NumPings = NumberOfPings
assign in sequence LowPassFilterWinSize = TrackingNumFixesLowPassFilter
assign in sequence LowPassFilterWinOverlap = true
}
aggregate UpdateNumPings_Terminal {
run while (
LineCapture:GuidanceMode == LineCapture:Terminal
)
aggregate UpdateNumPingsUSBL {
run when (
not ( NumPings == NumPingsUSBL )
and (
( LineCapture:Range < RangeUSBL ) # don't enter USBL mode during rollout
and not ( Dock:LineCapture.guidanceMode == 5 count )
)
)
syslog info "Entering USBL mode with " + NumPingsUSBL~count + "pings at "
+ LineCapture:Range~meter + "(mode " + Dock:LineCapture.guidanceMode~count + ")."
assign in sequence NumPings = NumPingsUSBL
assign in sequence LowPassFilterWinSize = TrackingNumFixesLowPassFilterUSBL
assign in sequence LowPassFilterWinOverlap = true
}
aggregate UpdateNumPingsATR {
run when (
not ( NumPings == NumberOfPings )
and (
( LineCapture:Range >= RangeUSBL ) # do ATR mode during rollout
or Dock:LineCapture.guidanceMode == 5 count
)
)
syslog info "Resuming normal ranging with " + NumberOfPings~count + "pings "
+ LineCapture:Range~meter + "(mode " + Dock:LineCapture.guidanceMode~count + ")."
assign in sequence NumPings = NumberOfPings
assign in sequence LowPassFilterWinSize = TrackingNumFixesLowPassFilter
assign in sequence LowPassFilterWinOverlap = true
}
}
aggregate UpdatePingUpdateRate_Midcourse {
run when (
not ( TrackingPeriod == TrackingUpdatePeriodMidcourse )
and (
( LineCapture:Range > LineCapture:TerminalRange ) # do slow ping mode during rollout
or Dock:LineCapture.guidanceMode == 5 count
)
)
syslog info "Entering Midcourse tracking update period " + TrackingUpdatePeriodMidcourse~second
+ "sec at" + LineCapture:Range~meter + "(mode " + Dock:LineCapture.guidanceMode~count + ")."
assign in sequence TrackingPeriod = TrackingUpdatePeriodMidcourse
assign in sequence LowPassFilterWinSize = TrackingNumFixesLowPassFilter
assign in sequence LowPassFilterWinOverlap = true
}
aggregate UpdatePingUpdateRate_Terminal {
run when (
not ( TrackingPeriod == TrackingUpdatePeriodTerminal )
and (
( LineCapture:Range <= LineCapture:TerminalRange )
and not ( Dock:LineCapture.guidanceMode == 5 count )
and not ( LineCapture:GuidanceMode == 0 count )
) # don't enter fast ping mode during rollout or on dock
)
syslog info "Entering Terminal tracking update period " + TrackingUpdatePeriodTerminal~second
+ "sec at" + LineCapture:Range~meter + "(mode " + Dock:LineCapture.guidanceMode~count + ")."
assign in sequence TrackingPeriod = TrackingUpdatePeriodTerminal
assign in sequence LowPassFilterWinSize = TrackingNumFixesLowPassFilter
assign in sequence LowPassFilterWinOverlap = true
}
aggregate restartDHCP {
run when ( called )
syslog info "Restarting DHCP..."
behavior Guidance:Execute {
run in sequence
set command = "! /mnt/mmc/LRAUV/Tools/dhcp.sh"
}
}
# Start mission sequence.
call id="StartingMission" priorityHere=false refId="NeedComms"
syslog important "Restarting logs"
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
aggregate InitialDive {
run in sequence
behavior Guidance:SetSpeed {
run in parallel
set speed = MidcourseSpeed
}
behavior Guidance:Mass {
run in parallel
set position = Control:VerticalControl.massDefault
}
behavior Guidance:Pitch {
run in sequence
timeout duration=ApproachDepthTimeout {
syslog important "Timed out trying to reach the target depth. Stopping mission at current depth of "
+ Universal:depth~meter
behavior Guidance:Execute {
run in sequence
set command = "stop"
}
}
set depth = MidcourseDepth
set depthRate = ApproachDepthRate
}
}
# I'd like to avoid a recursive call of Lap, so "retry" is implemented by incrementing the
# required repetition count (which has just been decremented by the lap attempt).
# But that repeat check is evaluated at the beginning of the aggregate, not the end.
# In order to be able to retry an incomplete docking attempt on the last lap
# we need to make it back up to the top of the Lap aggregate somehow.
# Solve this by quietly setting the repeat count to one more than actually desired.
# The DockSuccessfulCount check will break the Lap aggregate before it runs the extra
# lap, but starting the Lap aggregate will allow us to check the repeat on each run.
aggregate RepeatHack {
run in sequence
break if ( not RetryIncompleteDock )
assign in sequence RepeatArg = Repeat + 1 count
}
aggregate Lap {
run in sequence repeat=RepeatArg
break if (
( StayOnDock
and LastDockSuccessful
)
or (
RetryIncompleteDock
# Can't trust RepeatArg with retry, it's been incremented to allow re-evaluation of the count
and ( DockSuccessfulCount == Repeat )
)
)
assign in sequence Mode = -99 count
# Execute the LineCapture sequence.
call priorityHere=false refId="LineCapture"
assign in sequence Mode = LineCapture:GuidanceMode
syslog info "Mode" + Mode~count
call priorityHere=false refId="restartDHCP"
aggregate Docked {
run in sequence
break if ( Mode < 0 count )
syslog info "Waiting on dock for " + WaitOnDockTimeout~minute
# Add SetNav directives.
insert Insert/SetNavAcoustic.tl
assign in sequence TrackingPeriod = TrackingUpdatePeriodDocked
assign in sequence EndDockingSequence = StayOnDock
behavior Dock:Docked id="Docked" {
run in sequence
timeout duration=WaitOnDockTimeout
set slideSinkTime = SlideSinkDuration
set slideCloseTime = SlideCloseDuration
set slideRetries = SlideRetries
set slideAllowed = TrySlide
outputArg LastDockSuccessful = dockSuccessful
}
# If retrying incomplete attempts require total success to skip rollout, not just StayOnDock
aggregate setCompletion {
run in sequence
break if ( not RetryIncompleteDock )
assign in sequence EndDockingSequence = ( LastDockSuccessful
and StayOnDock
)
assign in sequence DockSuccessfulCount = DockSuccessfulCount + LastDockSuccessful
aggregate setRetry {
run in sequence
break if ( LastDockSuccessful )
syslog important "Retrying incomplete docking attempt"
# This lap failed and doesn't "count", so repeat one additional time
assign in sequence RepeatArg = RepeatArg + 1 count
}
}
aggregate Detach {
run in sequence
break if ( EndDockingSequence )
syslog important "Breaking off. Range: " + Universal:acoustic_contact_range~meter + "."
behavior Dock:Undock id="Undock" {
run in sequence
}
call priorityHere=false refId="restartDHCP"
}
aggregate Wpt1 {
run in sequence
break if (
isNaN ( Lat1 )
or isNaN ( Lon1 )
or ( EndDockingSequence )
)
syslog important "Driving to post-undock waypoint " + Lat1~degree + "," + Lon1~degree
behavior Guidance:Pitch {
run in parallel
set depth = MidcourseDepth
}
behavior Guidance:SetSpeed {
run in parallel
set speed = MidcourseSpeed
}
behavior Guidance:Waypoint {
run in sequence
set latitude = Lat1
set longitude = Lon1
set captureRadius = CaptureRadius
}
}
aggregate Drift {
"""
Drift before next docking attempt
"""
run in sequence
break if (
not isNaN ( Lat1 )
and not isNaN ( Lon1 )
or ( EndDockingSequence )
)
syslog important "No post-undock waypoint, drifting for "
+ Dock:LineCapture.rolloutTimeout~minute + " minutes"
behavior Guidance:Buoyancy {
run in parallel
set position = Control:VerticalControl.buoyancyNeutral
}
behavior Guidance:Pitch {
run in parallel
set massPosition = Control:VerticalControl.massDefault
set elevatorAngle = 0 degree
}
behavior Guidance:Point {
run in parallel
set rudderAngle = 0 degree
}
behavior Guidance:SetSpeed {
run in parallel
set speed = 0 meter_per_second
}
behavior Guidance:Wait {
run in sequence
set duration = Dock:LineCapture.rolloutTimeout
}
}
}
}
}
2025-08-11T14:34:02.301Z,1754922842.301 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/lineCaptureHoming.tl id=lineCaptureHoming
2025-08-11T14:34:02.343Z,1754922842.343 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2025-08-11T14:34:02.343Z,1754922842.343 [DefaultWithUndock] Running Loop=1
2025-08-11T14:34:02.344Z,1754922842.344 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2025-08-11T14:34:02.344Z,1754922842.344 [DefaultWithUndock:A.Wait] Running Loop=1
2025-08-11T14:34:02.344Z,1754922842.344 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2025-08-11T14:34:02.476Z,1754922842.476 [DAT](INFO): DAT read: Tx time:14:34:03.6689
2025-08-11T14:34:02.477Z,1754922842.477 [DAT](INFO): Ping request sent.
2025-08-11T14:34:02.477Z,1754922842.477 [DAT](INFO): transmitted an acoustic signal
2025-08-11T14:34:02.477Z,1754922842.477 [DAT](INFO): publishing transmit ping time
2025-08-11T14:34:02.478Z,1754922842.478 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000759
2025-08-11T14:34:02.728Z,1754922842.728 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251501
2025-08-11T14:34:02.981Z,1754922842.981 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.503695
2025-08-11T14:34:03.232Z,1754922843.232 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.755363
2025-08-11T14:34:03.484Z,1754922843.484 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.007321
2025-08-11T14:34:03.738Z,1754922843.738 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.261190
2025-08-11T14:34:03.988Z,1754922843.988 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.511289
2025-08-11T14:34:04.240Z,1754922844.240 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763539
2025-08-11T14:34:04.492Z,1754922844.492 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.015383
2025-08-11T14:34:04.744Z,1754922844.744 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.267358
2025-08-11T14:34:04.996Z,1754922844.996 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.519475
2025-08-11T14:34:05.251Z,1754922845.251 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.773049
2025-08-11T14:34:05.500Z,1754922845.500 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.023294
2025-08-11T14:34:05.755Z,1754922845.755 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.277499
2025-08-11T14:34:06.004Z,1754922846.004 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.527412
2025-08-11T14:34:06.256Z,1754922846.256 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.779380
2025-08-11T14:34:06.509Z,1754922846.509 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.031737
2025-08-11T14:34:06.760Z,1754922846.760 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.283344
2025-08-11T14:34:07.012Z,1754922847.012 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.535671
2025-08-11T14:34:07.264Z,1754922847.264 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.787467
2025-08-11T14:34:07.516Z,1754922847.516 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.039326
2025-08-11T14:34:07.770Z,1754922847.770 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.293231
2025-08-11T14:34:08.020Z,1754922848.020 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.543482
2025-08-11T14:34:08.272Z,1754922848.272 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.795543
2025-08-11T14:34:08.524Z,1754922848.524 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.047288
2025-08-11T14:34:08.776Z,1754922848.776 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.299645
2025-08-11T14:34:09.028Z,1754922849.028 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.551425
2025-08-11T14:34:09.280Z,1754922849.280 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.803322
2025-08-11T14:34:09.532Z,1754922849.532 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.055595
2025-08-11T14:34:09.784Z,1754922849.784 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.307465
2025-08-11T14:34:10.036Z,1754922850.036 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.559268
2025-08-11T14:34:10.288Z,1754922850.288 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.811599
2025-08-11T14:34:10.540Z,1754922850.540 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.063317
2025-08-11T14:34:10.792Z,1754922850.792 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.315379
2025-08-11T14:34:11.044Z,1754922851.044 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.567601
2025-08-11T14:34:11.296Z,1754922851.296 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.819365
2025-08-11T14:34:11.548Z,1754922851.548 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.071358
2025-08-11T14:34:11.800Z,1754922851.800 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.323603
2025-08-11T14:34:12.052Z,1754922852.052 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.575315
2025-08-11T14:34:12.304Z,1754922852.304 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.827307
2025-08-11T14:34:12.808Z,1754922852.808 [DAT](INFO): DAT read: Response Not Received
2025-08-11T14:34:12.809Z,1754922852.809 [DAT](INFO): response not received
2025-08-11T14:34:12.809Z,1754922852.809 [DAT](INFO): DAT read: user:12>
2025-08-11T14:34:12.810Z,1754922852.810 [DAT](INFO): DAT read: Tx time:14:34:14.1189
2025-08-11T14:34:12.810Z,1754922852.810 [DAT](INFO): Ping request sent.
2025-08-11T14:34:12.810Z,1754922852.810 [DAT](INFO): transmitted an acoustic signal
2025-08-11T14:34:12.810Z,1754922852.810 [DAT](INFO): publishing transmit ping time
2025-08-11T14:34:12.811Z,1754922852.811 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000722
2025-08-11T14:34:13.060Z,1754922853.060 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250001
2025-08-11T14:34:13.312Z,1754922853.312 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502092
2025-08-11T14:34:13.564Z,1754922853.564 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754119
2025-08-11T14:34:13.816Z,1754922853.816 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.006085
2025-08-11T14:34:14.068Z,1754922854.068 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.257956
2025-08-11T14:34:14.320Z,1754922854.320 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.509997
2025-08-11T14:34:14.572Z,1754922854.572 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.762406
2025-08-11T14:34:14.824Z,1754922854.824 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.014392
2025-08-11T14:34:15.076Z,1754922855.076 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266274
2025-08-11T14:34:15.328Z,1754922855.328 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518037
2025-08-11T14:34:15.580Z,1754922855.580 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770363
2025-08-11T14:34:15.832Z,1754922855.832 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022147
2025-08-11T14:34:16.096Z,1754922856.096 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.285759
2025-08-11T14:34:16.348Z,1754922856.348 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.538105
2025-08-11T14:34:16.600Z,1754922856.600 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.790136
2025-08-11T14:34:16.852Z,1754922856.852 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.042099
2025-08-11T14:34:17.104Z,1754922857.104 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.294233
2025-08-11T14:34:17.356Z,1754922857.356 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.546124
2025-08-11T14:34:17.608Z,1754922857.608 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=4.798096
2025-08-11T14:34:17.860Z,1754922857.860 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.050397
2025-08-11T14:34:18.112Z,1754922858.112 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.302164
2025-08-11T14:34:18.364Z,1754922858.364 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.554075
2025-08-11T14:34:18.616Z,1754922858.616 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=5.806361
2025-08-11T14:34:18.869Z,1754922858.869 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.059213
2025-08-11T14:34:19.120Z,1754922859.120 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.310058
2025-08-11T14:34:19.372Z,1754922859.372 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.562111
2025-08-11T14:34:19.624Z,1754922859.624 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=6.814141
2025-08-11T14:34:19.876Z,1754922859.876 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.066071
2025-08-11T14:34:20.128Z,1754922860.128 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.318105
2025-08-11T14:34:20.380Z,1754922860.380 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.570138
2025-08-11T14:34:20.632Z,1754922860.632 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=7.822053
2025-08-11T14:34:20.884Z,1754922860.884 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.074370
2025-08-11T14:34:21.136Z,1754922861.136 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.326177
2025-08-11T14:34:21.388Z,1754922861.388 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.578070
2025-08-11T14:34:21.640Z,1754922861.640 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=8.830093
2025-08-11T14:34:21.892Z,1754922861.892 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.082159
2025-08-11T14:34:22.144Z,1754922862.144 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.334162
2025-08-11T14:34:22.396Z,1754922862.396 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.586359
2025-08-11T14:34:22.648Z,1754922862.648 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=9.838139
2025-08-11T14:34:23.152Z,1754922863.152 [DAT](INFO): DAT read: Response Not Received
2025-08-11T14:34:23.152Z,1754922863.152 [DAT](INFO): response not received
2025-08-11T14:34:23.153Z,1754922863.153 [DAT](ERROR): No response from remote modem.
2025-08-11T14:34:32.610Z,1754922872.610 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2025-08-11T14:34:32.610Z,1754922872.610 [DefaultWithUndock:A.Wait] Stopped
2025-08-11T14:34:32.610Z,1754922872.610 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2025-08-11T14:34:32.610Z,1754922872.610 [DefaultWithUndock:LeaveDock] Running Loop=1
2025-08-11T14:34:32.610Z,1754922872.610 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock
2025-08-11T14:34:32.610Z,1754922872.610 [DefaultWithUndock:LeaveDock:A.] Running Loop=1
2025-08-11T14:34:32.610Z,1754922872.610 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact.
2025-08-11T14:34:32.610Z,1754922872.610 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1
2025-08-11T14:34:32.610Z,1754922872.610 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-08-11T14:34:32.611Z,1754922872.611 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-08-11T14:34:33.004Z,1754922873.004 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2025-08-11T14:34:33.004Z,1754922873.004 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2025-08-11T14:34:33.005Z,1754922873.005 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached from dock at depth 0.117666 m.
2025-08-11T14:34:33.006Z,1754922873.006 [DefaultWithUndock:LeaveDock:A.] Stopped
2025-08-11T14:34:33.006Z,1754922873.006 [DefaultWithUndock:LeaveDock:A.](DEBUG): Uninitializing TrackAcousticContact.
2025-08-11T14:34:33.416Z,1754922873.416 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer.
2025-08-11T14:34:33.981Z,1754922873.981 [DockingStepper](DEBUG): Initializing EZServoServo.
2025-08-11T14:34:33.981Z,1754922873.981 [DockingStepper](DEBUG): Initializing DockingStepper.
2025-08-11T14:34:34.951Z,1754922874.951 [CommandExec](IMPORTANT): got command set lineCaptureHoming.StayOnDock 1 bool
2025-08-11T14:34:34.952Z,1754922874.952 [CommandExec](IMPORTANT): got command set lineCaptureHoming.TrySlide 1 bool
2025-08-11T14:34:34.953Z,1754922874.953 [CommandExec](IMPORTANT): got command set lineCaptureHoming.DockingAltitude 7.8 meter
2025-08-11T14:34:34.953Z,1754922874.953 [CommandExec](IMPORTANT): got command set lineCaptureHoming.AltitudeDepthLimit 68 meter
2025-08-11T14:34:34.957Z,1754922874.957 [CommandExec](IMPORTANT): got command schedule resume
2025-08-11T14:34:37.508Z,1754922877.508 [DockingStepper](INFO): Changing to mode: 1
2025-08-11T14:34:48.996Z,1754922888.996 [CommandExec](IMPORTANT): got command set lineCaptureHoming.MaxDepth 70 meter
2025-08-11T14:34:48.997Z,1754922888.997 [CommandExec](IMPORTANT): got command set lineCaptureHoming.CorrectForSoundSpeed 1 bool
2025-08-11T14:34:48.997Z,1754922888.997 [CommandExec](IMPORTANT): got command run
2025-08-11T14:34:49.003Z,1754922889.003 [CommandExec](IMPORTANT): Running
2025-08-11T14:34:49.163Z,1754922889.163 [DefaultWithUndock] Stopped
2025-08-11T14:34:49.163Z,1754922889.163 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2025-08-11T14:34:49.164Z,1754922889.164 [DefaultWithUndock:LeaveDock] Stopped
2025-08-11T14:34:49.164Z,1754922889.164 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock
2025-08-11T14:34:49.164Z,1754922889.164 [DefaultWithUndock:LeaveDock:B.Undock] Stopped
2025-08-11T14:34:49.164Z,1754922889.164 [MissionManager](IMPORTANT): Started mission lineCaptureHoming
2025-08-11T14:34:49.164Z,1754922889.164 [lineCaptureHoming] Running Loop=1
2025-08-11T14:34:49.164Z,1754922889.164 [lineCaptureHoming](DEBUG): Aggregate::initialize lineCaptureHoming
2025-08-11T14:34:49.164Z,1754922889.164 [lineCaptureHoming:Science] Running Loop=1
2025-08-11T14:34:49.164Z,1754922889.164 [lineCaptureHoming:Science](DEBUG): Aggregate::initialize lineCaptureHoming:Science
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:A] Running Loop=1
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:B] Running Loop=1
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:C] Running Loop=1
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:D] Running Loop=1
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:E] Running Loop=1
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:F] Running Loop=1
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:Read_Oil] Running Loop=1
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:PeakDetectChl] Running Loop=1
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:PeakDetectChl](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectChl
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:PeakDetectChl:A] Running Loop=1
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:EdgeDetectChl] Running Loop=1
2025-08-11T14:34:49.165Z,1754922889.165 [lineCaptureHoming:Science:EdgeDetectChl](DEBUG): Aggregate::initialize lineCaptureHoming:Science:EdgeDetectChl
2025-08-11T14:34:49.166Z,1754922889.166 [lineCaptureHoming:Science:EdgeDetectChl:A] Running Loop=1
2025-08-11T14:34:49.166Z,1754922889.166 [lineCaptureHoming:Science:HighestChlPeakReport] Running Loop=1
2025-08-11T14:34:49.166Z,1754922889.166 [lineCaptureHoming:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize lineCaptureHoming:Science:HighestChlPeakReport
2025-08-11T14:34:49.166Z,1754922889.166 [lineCaptureHoming:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-08-11T14:34:49.167Z,1754922889.167 [lineCaptureHoming:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-08-11T14:34:49.167Z,1754922889.167 [lineCaptureHoming:Science:PeakDetectNO3] Running Loop=1
2025-08-11T14:34:49.167Z,1754922889.167 [lineCaptureHoming:Science:PeakDetectNO3](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectNO3
2025-08-11T14:34:49.168Z,1754922889.168 [lineCaptureHoming:Science:PeakDetectNO3:A] Running Loop=1
2025-08-11T14:34:49.168Z,1754922889.168 [lineCaptureHoming:Science:PeakDetectOil] Running Loop=1
2025-08-11T14:34:49.168Z,1754922889.168 [lineCaptureHoming:Science:PeakDetectOil](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectOil
2025-08-11T14:34:49.168Z,1754922889.168 [lineCaptureHoming:Science:PeakDetectOil:A] Running Loop=1
2025-08-11T14:34:49.168Z,1754922889.168 [lineCaptureHoming:Science:HighestOilPeakReport] Running Loop=1
2025-08-11T14:34:49.168Z,1754922889.168 [lineCaptureHoming:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize lineCaptureHoming:Science:HighestOilPeakReport
2025-08-11T14:34:49.168Z,1754922889.168 [lineCaptureHoming:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-08-11T14:34:49.168Z,1754922889.168 [lineCaptureHoming:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-08-11T14:34:49.169Z,1754922889.169 [lineCaptureHoming:Science:PeakDetectFDOM] Running Loop=1
2025-08-11T14:34:49.169Z,1754922889.169 [lineCaptureHoming:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectFDOM
2025-08-11T14:34:49.169Z,1754922889.169 [lineCaptureHoming:Science:PeakDetectFDOM:A] Running Loop=1
2025-08-11T14:34:49.169Z,1754922889.169 [lineCaptureHoming:Science:PeakDetectSalinity] Running Loop=1
2025-08-11T14:34:49.169Z,1754922889.169 [lineCaptureHoming:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectSalinity
2025-08-11T14:34:49.169Z,1754922889.169 [lineCaptureHoming:Science:PeakDetectSalinity:A] Running Loop=1
2025-08-11T14:34:49.169Z,1754922889.169 [lineCaptureHoming:Science:HighestSaltPeakReport] Running Loop=1
2025-08-11T14:34:49.169Z,1754922889.169 [lineCaptureHoming:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize lineCaptureHoming:Science:HighestSaltPeakReport
2025-08-11T14:34:49.170Z,1754922889.170 [lineCaptureHoming:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-08-11T14:34:49.170Z,1754922889.170 [lineCaptureHoming:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-08-11T14:34:49.170Z,1754922889.170 [lineCaptureHoming:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1
2025-08-11T14:34:49.170Z,1754922889.170 [lineCaptureHoming:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectPlanktivoreLMavgROI
2025-08-11T14:34:49.170Z,1754922889.170 [lineCaptureHoming:Science:PeakDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-08-11T14:34:49.170Z,1754922889.170 [lineCaptureHoming:Science:EdgeDetectPlanktivoreLMavgROI] Running Loop=1
2025-08-11T14:34:49.170Z,1754922889.170 [lineCaptureHoming:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize lineCaptureHoming:Science:EdgeDetectPlanktivoreLMavgROI
2025-08-11T14:34:49.171Z,1754922889.171 [lineCaptureHoming:Science:EdgeDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-08-11T14:34:49.171Z,1754922889.171 [lineCaptureHoming:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1
2025-08-11T14:34:49.171Z,1754922889.171 [lineCaptureHoming:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectPlanktivoreHMavgROI
2025-08-11T14:34:49.171Z,1754922889.171 [lineCaptureHoming:Science:PeakDetectPlanktivoreHMavgROI:A] Running Loop=1
2025-08-11T14:34:49.171Z,1754922889.171 [lineCaptureHoming:Science:EdgeDetectPlanktivoreHMavgROI] Running Loop=1
2025-08-11T14:34:49.171Z,1754922889.171 [lineCaptureHoming:Science:EdgeDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize lineCaptureHoming:Science:EdgeDetectPlanktivoreHMavgROI
2025-08-11T14:34:49.171Z,1754922889.171 [lineCaptureHoming:Science:EdgeDetectPlanktivoreHMavgROI:A] Running Loop=1
2025-08-11T14:34:49.172Z,1754922889.172 [lineCaptureHoming:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1
2025-08-11T14:34:49.172Z,1754922889.172 [lineCaptureHoming:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectPlanktivoreDiatoms
2025-08-11T14:34:49.172Z,1754922889.172 [lineCaptureHoming:Science:PeakDetectPlanktivoreDiatoms:A] Running Loop=1
2025-08-11T14:34:49.172Z,1754922889.172 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDiatoms] Running Loop=1
2025-08-11T14:34:49.172Z,1754922889.172 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize lineCaptureHoming:Science:EdgeDetectPlanktivoreDiatoms
2025-08-11T14:34:49.172Z,1754922889.172 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDiatoms:A] Running Loop=1
2025-08-11T14:34:49.172Z,1754922889.172 [lineCaptureHoming:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1
2025-08-11T14:34:49.172Z,1754922889.172 [lineCaptureHoming:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectPlanktivoreDinoflagellates
2025-08-11T14:34:49.172Z,1754922889.172 [lineCaptureHoming:Science:PeakDetectPlanktivoreDinoflagellates:A] Running Loop=1
2025-08-11T14:34:49.172Z,1754922889.172 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDinoflagellates] Running Loop=1
2025-08-11T14:34:49.173Z,1754922889.173 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize lineCaptureHoming:Science:EdgeDetectPlanktivoreDinoflagellates
2025-08-11T14:34:49.173Z,1754922889.173 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDinoflagellates:A] Running Loop=1
2025-08-11T14:34:49.173Z,1754922889.173 [lineCaptureHoming:Science:ChlThreshTrigger] Running Loop=1
2025-08-11T14:34:49.173Z,1754922889.173 [lineCaptureHoming:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize lineCaptureHoming:Science:ChlThreshTrigger
2025-08-11T14:34:49.173Z,1754922889.173 [lineCaptureHoming:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1
2025-08-11T14:34:49.173Z,1754922889.173 [lineCaptureHoming:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize.
2025-08-11T14:34:49.174Z,1754922889.174 [lineCaptureHoming:Science:OceanCurrent] Running Loop=1
2025-08-11T14:34:49.174Z,1754922889.174 [lineCaptureHoming:Science:OceanCurrent](DEBUG): Aggregate::initialize lineCaptureHoming:Science:OceanCurrent
2025-08-11T14:34:49.174Z,1754922889.174 [lineCaptureHoming:Science:OceanCurrent:A.] Running Loop=1
2025-08-11T14:34:49.174Z,1754922889.174 [lineCaptureHoming:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2025-08-11T14:34:49.174Z,1754922889.174 [lineCaptureHoming:StandardEnvelopes] Running Loop=1
2025-08-11T14:34:49.174Z,1754922889.174 [lineCaptureHoming:StandardEnvelopes](DEBUG): Aggregate::initialize lineCaptureHoming:StandardEnvelopes
2025-08-11T14:34:49.174Z,1754922889.174 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-08-11T14:34:49.174Z,1754922889.174 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-08-11T14:34:49.175Z,1754922889.175 [lineCaptureHoming:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-08-11T14:34:49.175Z,1754922889.175 [lineCaptureHoming:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-08-11T14:34:49.175Z,1754922889.175 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-08-11T14:34:49.175Z,1754922889.175 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-08-11T14:34:49.175Z,1754922889.175 [lineCaptureHoming:MicromodemComms] Running Loop=1
2025-08-11T14:34:49.175Z,1754922889.175 [lineCaptureHoming:MicromodemComms](DEBUG): Aggregate::initialize lineCaptureHoming:MicromodemComms
2025-08-11T14:34:49.176Z,1754922889.176 [lineCaptureHoming:MicromodemComms:CheckIn] Running Loop=1
2025-08-11T14:34:49.176Z,1754922889.176 [lineCaptureHoming:MicromodemComms:CheckIn](DEBUG): Aggregate::initialize lineCaptureHoming:MicromodemComms:CheckIn
2025-08-11T14:34:49.176Z,1754922889.176 [lineCaptureHoming:MicromodemComms:CheckIn:A] Running Loop=1
2025-08-11T14:34:49.176Z,1754922889.176 [lineCaptureHoming:J] Running Loop=1
2025-08-11T14:34:49.176Z,1754922889.176 [lineCaptureHoming:TrackAC.] Running Loop=1
2025-08-11T14:34:49.176Z,1754922889.176 [lineCaptureHoming:TrackAC.](INFO): Initializing TrackAcousticContact.
2025-08-11T14:34:49.176Z,1754922889.176 [lineCaptureHoming:UpdateNumPings_NotTerminal] Running Loop=1
2025-08-11T14:34:49.176Z,1754922889.176 [lineCaptureHoming:UpdateNumPings_NotTerminal](DEBUG): Aggregate::initialize lineCaptureHoming:UpdateNumPings_NotTerminal
2025-08-11T14:34:49.176Z,1754922889.176 [lineCaptureHoming:UpdateNumPings_NotTerminal:A] Running Loop=1
2025-08-11T14:34:49.176Z,1754922889.176 [lineCaptureHoming:UpdateNumPings_Terminal] Running Loop=1
2025-08-11T14:34:49.177Z,1754922889.177 [lineCaptureHoming:UpdateNumPings_Terminal](DEBUG): Aggregate::initialize lineCaptureHoming:UpdateNumPings_Terminal
2025-08-11T14:34:49.177Z,1754922889.177 [lineCaptureHoming:C] Running Loop=1
2025-08-11T14:34:49.178Z,1754922889.178 [lineCaptureHoming:UpdateNumPings_Terminal] Stopped
2025-08-11T14:34:49.179Z,1754922889.179 [lineCaptureHoming:UpdateNumPings_Terminal](DEBUG): Aggregate::uninitialize lineCaptureHoming:UpdateNumPings_Terminal
2025-08-11T14:34:49.179Z,1754922889.179 [lineCaptureHoming:UpdateNumPings_NotTerminal] Stopped
2025-08-11T14:34:49.179Z,1754922889.179 [lineCaptureHoming:UpdateNumPings_NotTerminal](DEBUG): Aggregate::uninitialize lineCaptureHoming:UpdateNumPings_NotTerminal
2025-08-11T14:34:49.179Z,1754922889.179 [lineCaptureHoming:UpdateNumPings_NotTerminal:A] Stopped
2025-08-11T14:34:49.179Z,1754922889.179 [lineCaptureHoming:TrackAC.] Running Loop=1
2025-08-11T14:34:49.180Z,1754922889.180 [lineCaptureHoming:J] Stopped
2025-08-11T14:34:49.180Z,1754922889.180 [lineCaptureHoming:MicromodemComms] Stopped
2025-08-11T14:34:49.180Z,1754922889.180 [lineCaptureHoming:MicromodemComms](DEBUG): Aggregate::uninitialize lineCaptureHoming:MicromodemComms
2025-08-11T14:34:49.180Z,1754922889.180 [lineCaptureHoming:MicromodemComms:CheckIn] Stopped
2025-08-11T14:34:49.180Z,1754922889.180 [lineCaptureHoming:MicromodemComms:CheckIn](DEBUG): Aggregate::uninitialize lineCaptureHoming:MicromodemComms:CheckIn
2025-08-11T14:34:49.180Z,1754922889.180 [lineCaptureHoming:MicromodemComms:CheckIn:A] Stopped
2025-08-11T14:34:49.180Z,1754922889.180 [lineCaptureHoming:C] Stopped
2025-08-11T14:34:49.181Z,1754922889.181 [lineCaptureHoming:D] Running Loop=1
2025-08-11T14:34:49.181Z,1754922889.181 [lineCaptureHoming:StandardEnvelopes] Running Loop=1
2025-08-11T14:34:49.181Z,1754922889.181 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-08-11T14:34:49.181Z,1754922889.181 [lineCaptureHoming:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-08-11T14:34:49.181Z,1754922889.181 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-08-11T14:34:49.182Z,1754922889.182 [lineCaptureHoming:Science] Running Loop=1
2025-08-11T14:34:49.183Z,1754922889.183 [lineCaptureHoming:Science:ChlThreshTrigger] Stopped
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:ChlThreshTrigger
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:ChlThreshTrigger:A.ValueDetect] Stopped
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize.
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDinoflagellates] Stopped
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:EdgeDetectPlanktivoreDinoflagellates
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDinoflagellates:A] Stopped
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:PeakDetectPlanktivoreDinoflagellates] Stopped
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectPlanktivoreDinoflagellates
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:PeakDetectPlanktivoreDinoflagellates:A] Stopped
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDiatoms] Stopped
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:EdgeDetectPlanktivoreDiatoms
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:EdgeDetectPlanktivoreDiatoms:A] Stopped
2025-08-11T14:34:49.184Z,1754922889.184 [lineCaptureHoming:Science:PeakDetectPlanktivoreDiatoms] Stopped
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectPlanktivoreDiatoms
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:PeakDetectPlanktivoreDiatoms:A] Stopped
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:EdgeDetectPlanktivoreHMavgROI] Stopped
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:EdgeDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:EdgeDetectPlanktivoreHMavgROI
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:EdgeDetectPlanktivoreHMavgROI:A] Stopped
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:PeakDetectPlanktivoreHMavgROI] Stopped
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectPlanktivoreHMavgROI
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:PeakDetectPlanktivoreHMavgROI:A] Stopped
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:EdgeDetectPlanktivoreLMavgROI] Stopped
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:EdgeDetectPlanktivoreLMavgROI
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:EdgeDetectPlanktivoreLMavgROI:A] Stopped
2025-08-11T14:34:49.185Z,1754922889.185 [lineCaptureHoming:Science:PeakDetectPlanktivoreLMavgROI] Stopped
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectPlanktivoreLMavgROI
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:PeakDetectPlanktivoreLMavgROI:A] Stopped
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:HighestSaltPeakReport] Stopped
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:HighestSaltPeakReport
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:PeakDetectSalinity] Stopped
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectSalinity
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:PeakDetectSalinity:A] Stopped
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:PeakDetectFDOM] Stopped
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectFDOM
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:PeakDetectFDOM:A] Stopped
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:HighestOilPeakReport] Stopped
2025-08-11T14:34:49.186Z,1754922889.186 [lineCaptureHoming:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:HighestOilPeakReport
2025-08-11T14:34:49.187Z,1754922889.187 [lineCaptureHoming:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2025-08-11T14:34:49.187Z,1754922889.187 [lineCaptureHoming:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-08-11T14:34:49.187Z,1754922889.187 [lineCaptureHoming:Science:PeakDetectOil] Stopped
2025-08-11T14:34:49.187Z,1754922889.187 [lineCaptureHoming:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectOil
2025-08-11T14:34:49.187Z,1754922889.187 [lineCaptureHoming:Science:PeakDetectOil:A] Stopped
2025-08-11T14:34:49.187Z,1754922889.187 [lineCaptureHoming:Science:PeakDetectNO3] Stopped
2025-08-11T14:34:49.187Z,1754922889.187 [lineCaptureHoming:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectNO3
2025-08-11T14:34:49.187Z,1754922889.187 [lineCaptureHoming:Science:PeakDetectNO3:A] Stopped
2025-08-11T14:34:49.187Z,1754922889.187 [lineCaptureHoming:Science:HighestChlPeakReport] Stopped
2025-08-11T14:34:49.187Z,1754922889.187 [lineCaptureHoming:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:HighestChlPeakReport
2025-08-11T14:34:49.188Z,1754922889.188 [lineCaptureHoming:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2025-08-11T14:34:49.188Z,1754922889.188 [lineCaptureHoming:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-08-11T14:34:49.188Z,1754922889.188 [lineCaptureHoming:Science:EdgeDetectChl] Stopped
2025-08-11T14:34:49.188Z,1754922889.188 [lineCaptureHoming:Science:EdgeDetectChl](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:EdgeDetectChl
2025-08-11T14:34:49.188Z,1754922889.188 [lineCaptureHoming:Science:EdgeDetectChl:A] Stopped
2025-08-11T14:34:49.188Z,1754922889.188 [lineCaptureHoming:Science:PeakDetectChl] Stopped
2025-08-11T14:34:49.188Z,1754922889.188 [lineCaptureHoming:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectChl
2025-08-11T14:34:49.188Z,1754922889.188 [lineCaptureHoming:Science:PeakDetectChl:A] Stopped
2025-08-11T14:34:49.188Z,1754922889.188 [lineCaptureHoming:Science:OceanCurrent:A.] Running Loop=1
2025-08-11T14:34:49.190Z,1754922889.190 [lineCaptureHoming:Science:Read_Oil] Stopped
2025-08-11T14:34:49.190Z,1754922889.190 [lineCaptureHoming:Science:F] Stopped
2025-08-11T14:34:49.190Z,1754922889.190 [lineCaptureHoming:Science:E] Running Loop=1
2025-08-11T14:34:49.207Z,1754922889.207 [lineCaptureHoming:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2025-08-11T14:34:49.207Z,1754922889.207 [lineCaptureHoming:Science:D] Stopped
2025-08-11T14:34:49.207Z,1754922889.207 [lineCaptureHoming:Science:C] Running Loop=1
2025-08-11T14:34:49.208Z,1754922889.208 [lineCaptureHoming:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2025-08-11T14:34:49.209Z,1754922889.209 [lineCaptureHoming:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2025-08-11T14:34:49.209Z,1754922889.209 [lineCaptureHoming:Science:B] Running Loop=1
2025-08-11T14:34:49.210Z,1754922889.210 [lineCaptureHoming:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2025-08-11T14:34:49.213Z,1754922889.213 [lineCaptureHoming:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2025-08-11T14:34:49.213Z,1754922889.213 [lineCaptureHoming:Science:A] Stopped
2025-08-11T14:34:49.578Z,1754922889.578 [lineCaptureHoming:D] Stopped
2025-08-11T14:34:49.578Z,1754922889.578 [lineCaptureHoming:E] Running Loop=1
2025-08-11T14:34:49.857Z,1754922889.857 [WetLabsBB2FL](INFO): Powering up
2025-08-11T14:34:50.006Z,1754922890.006 [lineCaptureHoming:E] Stopped
2025-08-11T14:34:50.006Z,1754922890.006 [lineCaptureHoming:G] Running Loop=1
2025-08-11T14:34:50.379Z,1754922890.379 [lineCaptureHoming:G] Stopped
2025-08-11T14:34:50.379Z,1754922890.379 [lineCaptureHoming:H] Running Loop=1
2025-08-11T14:34:50.771Z,1754922890.771 [lineCaptureHoming:H] Stopped
2025-08-11T14:34:50.771Z,1754922890.771 [lineCaptureHoming:L] Running Loop=1
2025-08-11T14:34:51.185Z,1754922891.185 [lineCaptureHoming:L] Stopped
2025-08-11T14:34:51.185Z,1754922891.185 [lineCaptureHoming:M] Running Loop=1
2025-08-11T14:34:51.578Z,1754922891.578 [lineCaptureHoming:M] Stopped
2025-08-11T14:34:51.578Z,1754922891.578 [lineCaptureHoming:N] Running Loop=1
2025-08-11T14:34:52.021Z,1754922892.021 [lineCaptureHoming:N] Stopped
2025-08-11T14:34:52.021Z,1754922892.021 [lineCaptureHoming:O] Running Loop=1
2025-08-11T14:34:52.391Z,1754922892.391 [lineCaptureHoming:O] Stopped
2025-08-11T14:34:52.391Z,1754922892.391 [lineCaptureHoming:P] Running Loop=1
2025-08-11T14:34:52.814Z,1754922892.814 [lineCaptureHoming:P] Stopped
2025-08-11T14:34:52.815Z,1754922892.815 [lineCaptureHoming:Q] Running Loop=1
2025-08-11T14:34:52.913Z,1754922892.913 [CTD_Seabird](ERROR): Failed to parse device response:
2025-08-11T14:34:53.201Z,1754922893.201 [lineCaptureHoming:Q] Stopped
2025-08-11T14:34:53.201Z,1754922893.201 [lineCaptureHoming:U] Running Loop=1
2025-08-11T14:34:53.605Z,1754922893.605 [lineCaptureHoming:U] Stopped
2025-08-11T14:34:53.605Z,1754922893.605 [lineCaptureHoming:StartingMission] Running Loop=1
2025-08-11T14:34:53.606Z,1754922893.606 [lineCaptureHoming:StartingMission](DEBUG): Aggregate::initialize lineCaptureHoming:StartingMission
2025-08-11T14:34:54.042Z,1754922894.042 [lineCaptureHoming:NeedComms] Running Loop=1
2025-08-11T14:34:54.042Z,1754922894.042 [lineCaptureHoming:NeedComms](DEBUG): Aggregate::initialize lineCaptureHoming:NeedComms
2025-08-11T14:34:54.042Z,1754922894.042 [lineCaptureHoming:NeedComms:B.GoToSurface] Running Loop=1
2025-08-11T14:34:54.042Z,1754922894.042 [lineCaptureHoming:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-08-11T14:34:54.042Z,1754922894.042 [lineCaptureHoming:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-08-11T14:34:54.043Z,1754922894.043 [lineCaptureHoming:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-08-11T14:34:54.043Z,1754922894.043 [lineCaptureHoming:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-08-11T14:34:54.044Z,1754922894.044 [lineCaptureHoming:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-08-11T14:34:54.044Z,1754922894.044 [lineCaptureHoming:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-08-11T14:34:54.044Z,1754922894.044 [lineCaptureHoming:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-08-11T14:34:54.045Z,1754922894.045 [lineCaptureHoming:NeedComms:A] Running Loop=1
2025-08-11T14:34:54.046Z,1754922894.046 [lineCaptureHoming:NeedComms:A](INFO): last time_fix was: 1754922663.000000 second since 1970/01/01T00:00:00Z
2025-08-11T14:34:54.046Z,1754922894.046 [lineCaptureHoming:NeedComms:A] Stopped
2025-08-11T14:34:54.418Z,1754922894.418 [lineCaptureHoming:NeedComms:C] Running Loop=1
2025-08-11T14:34:54.813Z,1754922894.813 [lineCaptureHoming:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-08-11T14:34:56.442Z,1754922896.442 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,143455.00,A,3654.57267,N,12206.95069,W,0.156,342.17,110825,,,D*74
2025-08-11T14:34:56.444Z,1754922896.444 [NAL9602](INFO): GPS fix at 20250811T143455: (36.909545, -122.115845)
2025-08-11T14:34:56.474Z,1754922896.474 [lineCaptureHoming:NeedComms:C] Stopped
2025-08-11T14:34:56.474Z,1754922896.474 [lineCaptureHoming:NeedComms:D] Running Loop=1
2025-08-11T14:34:56.854Z,1754922896.854 [lineCaptureHoming:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-08-11T14:35:03.407Z,1754922903.407 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20250811T143319/Courier0003.lzma
2025-08-11T14:35:04.409Z,1754922904.409 [DataOverHttps](INFO): Moved sent file to Logs/20250811T143319/Courier0003.lzma.bak
2025-08-11T14:35:04.410Z,1754922904.410 [DataOverHttps](IMPORTANT): SBD MOMSN=25837491, MTMSN=20250811T143503
2025-08-11T14:35:06.558Z,1754922906.558 [NAL9602](INFO): SBD MO Status=0, MOMSN=710, MT Status=0, MTMSN=0
2025-08-11T14:35:06.558Z,1754922906.558 [NAL9602](INFO): No messages in MT queue
2025-08-11T14:35:12.648Z,1754922912.648 [DataOverHttps](INFO): Received command: sched "run Engineering/OnDock.tl"
2025-08-11T14:35:12.662Z,1754922912.662 [CommandExec](IMPORTANT): got command schedule "run Engineering/OnDock.tl"
2025-08-11T14:35:12.663Z,1754922912.663 [CommandExec](IMPORTANT): Scheduled #4: "run Engineering/OnDock.tl", AFTER MISSION
2025-08-11T14:35:21.671Z,1754922921.671 [DataOverHttps](INFO): Sending 236 bytes from file Logs/20250811T142458/Express0008.lzma
2025-08-11T14:35:22.673Z,1754922922.673 [DataOverHttps](INFO): Moved sent file to Logs/20250811T142458/Express0008.lzma.bak
2025-08-11T14:35:22.673Z,1754922922.673 [DataOverHttps](INFO): SBD MOMSN=25837496
2025-08-11T14:35:24.327Z,1754922924.327 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2025-08-11T14:35:37.260Z,1754922937.260 [NAL9602](INFO): Not Powering down - fast GPS
2025-08-11T14:35:40.059Z,1754922940.059 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250811T143319/Courier0009.lzma
2025-08-11T14:35:41.061Z,1754922941.061 [DataOverHttps](INFO): Moved sent file to Logs/20250811T143319/Courier0009.lzma.bak
2025-08-11T14:35:41.061Z,1754922941.061 [DataOverHttps](INFO): SBD MOMSN=25837501
2025-08-11T14:35:49.424Z,1754922949.424 [lineCaptureHoming:TrackAC.](INFO): *** querying acoustic contact ***
2025-08-11T14:35:49.648Z,1754922949.648 [DAT](DEBUG): Acoustic response timeout
2025-08-11T14:35:49.649Z,1754922949.649 [DAT](INFO): setting remote address to 0
2025-08-11T14:35:49.900Z,1754922949.900 [DAT](INFO): DAT read: user:13>
2025-08-11T14:35:49.901Z,1754922949.901 [DAT](INFO): DAT read: RemoteAddr | 0
2025-08-11T14:35:49.902Z,1754922949.902 [DAT](INFO): set remote address to 0
2025-08-11T14:35:49.902Z,1754922949.902 [DAT](DEBUG): Acoustic response timeout
2025-08-11T14:35:49.902Z,1754922949.902 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode.
2025-08-11T14:35:50.152Z,1754922950.152 [DAT](INFO): DAT read: user:14>
2025-08-11T14:35:50.153Z,1754922950.153 [DAT](INFO): DAT read: Tx time:14:35:51.4200
2025-08-11T14:35:50.153Z,1754922950.153 [DAT](INFO): Ping request sent.
2025-08-11T14:35:50.153Z,1754922950.153 [DAT](INFO): transmitted an acoustic signal
2025-08-11T14:35:50.154Z,1754922950.154 [DAT](INFO): publishing transmit ping time
2025-08-11T14:35:50.154Z,1754922950.154 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.000750
2025-08-11T14:35:50.404Z,1754922950.404 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.250904
2025-08-11T14:35:50.656Z,1754922950.656 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502559
2025-08-11T14:35:50.908Z,1754922950.908 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754704
2025-08-11T14:35:51.164Z,1754922951.164 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.010704
2025-08-11T14:35:51.412Z,1754922951.412 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.258761
2025-08-11T14:35:51.664Z,1754922951.664 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510755
2025-08-11T14:35:51.917Z,1754922951.917 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.763373
2025-08-11T14:35:52.170Z,1754922952.170 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.016862
2025-08-11T14:35:52.420Z,1754922952.420 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.266835
2025-08-11T14:35:52.672Z,1754922952.672 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518744
2025-08-11T14:35:52.924Z,1754922952.924 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.771012
2025-08-11T14:35:53.176Z,1754922953.176 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022696
2025-08-11T14:35:53.428Z,1754922953.428 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.274690
2025-08-11T14:35:53.680Z,1754922953.680 [DAT](INFO): DAT read: Rx Time:14:35:54.3629
2025-08-11T14:35:53.681Z,1754922953.681 [DAT](INFO): Rx dataTimestamp_ set to:1754922953.680356
2025-08-11T14:35:53.681Z,1754922953.681 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.527779
2025-08-11T14:35:53.933Z,1754922953.933 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.779186
2025-08-11T14:35:54.189Z,1754922954.189 [DAT](INFO): DAT read: 14:35:54.3629 LVL= 29072, 20833, 22306, 26419, AGC= 78, IDX= 378,-0.36,-1.367, 0.561, 0.092,-0.291, PHS=-0.974, 0.896, 0.339, RAW= 286.9, -3.2, CAL= 286.3, -8.3, ROT= 223.7, 8.3
2025-08-11T14:35:54.190Z,1754922954.190 [DAT](INFO): got valid direction response:
14:35:54.3629 LVL= 29072, 20833, 22306, 26419, AGC= 78, IDX= 378,-0.36,-1.367, 0.561, 0.092,-0.291, PHS=-0.974, 0.896, 0.339, RAW= 286.9, -3.2, CAL= 286.3, -8.3, ROT= 223.7, 8.3
2025-08-11T14:35:54.192Z,1754922954.192 [DAT](INFO): DAT read: Bearing 304.8, -44.6 (Local)
2025-08-11T14:35:54.192Z,1754922954.192 [DAT](INFO): Local bearing/azimuth received:
Bearing 304.8, -44.6 (Local)
2025-08-11T14:35:54.193Z,1754922954.193 [DAT](INFO): DAT read: Range 11 to 50 : 404.1 m (Round-trip 538.8 ms) speed -0.1 m/s
2025-08-11T14:35:54.194Z,1754922954.194 [DAT](INFO): #Rx 1: Read range and direction messages.
2025-08-11T14:35:54.195Z,1754922954.195 [DAT](INFO): direction in FSK: [-0.715395,-0.683646,-0.144356]
2025-08-11T14:35:54.196Z,1754922954.196 [DAT](INFO): publishing direction and range info
2025-08-11T14:35:58.619Z,1754922958.619 [DataOverHttps](INFO): Sending 228 bytes from file Logs/20250811T142458/Express0009.lzma
2025-08-11T14:35:59.621Z,1754922959.621 [DataOverHttps](INFO): Moved sent file to Logs/20250811T142458/Express0009.lzma.bak
2025-08-11T14:35:59.621Z,1754922959.621 [DataOverHttps](INFO): SBD MOMSN=25837503
2025-08-11T14:36:18.420Z,1754922978.420 [DataOverHttps](INFO): Sending 434 bytes from file Logs/20250811T142458/Express0011.lzma
2025-08-11T14:36:19.421Z,1754922979.421 [DataOverHttps](INFO): Moved sent file to Logs/20250811T142458/Express0011.lzma.bak
2025-08-11T14:36:19.421Z,1754922979.421 [DataOverHttps](INFO): SBD MOMSN=25837508
2025-08-11T14:36:37.654Z,1754922997.654 [DataOverHttps](INFO): Sending 1220 bytes from file Logs/20250811T143319/Express0004.lzma
2025-08-11T14:36:38.653Z,1754922998.653 [DataOverHttps](INFO): Moved sent file to Logs/20250811T143319/Express0004.lzma.bak
2025-08-11T14:36:38.653Z,1754922998.653 [DataOverHttps](INFO): SBD MOMSN=25837513
2025-08-11T14:36:49.630Z,1754923009.630 [lineCaptureHoming:TrackAC.](INFO): *** querying acoustic contact ***
2025-08-11T14:36:49.682Z,1754923009.682 [DAT](DEBUG): Acoustic response timeout
2025-08-11T14:36:49.682Z,1754923009.682 [DAT](INFO): Querying Benthos address 50 with one ping in standard two-way mode.
2025-08-11T14:36:49.932Z,1754923009.932 [DAT](INFO): DAT read: user:15>
2025-08-11T14:36:49.933Z,1754923009.933 [DAT](INFO): DAT read: Tx time:14:36:51.1701
2025-08-11T14:36:49.934Z,1754923009.934 [DAT](INFO): Ping request sent.
2025-08-11T14:36:49.934Z,1754923009.934 [DAT](INFO): transmitted an acoustic signal
2025-08-11T14:36:49.934Z,1754923009.934 [DAT](INFO): publishing transmit ping time
2025-08-11T14:36:49.935Z,1754923009.935 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.001024
2025-08-11T14:36:50.185Z,1754923010.185 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.251189
2025-08-11T14:36:50.436Z,1754923010.436 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.502268
2025-08-11T14:36:50.688Z,1754923010.688 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=0.754530
2025-08-11T14:36:50.942Z,1754923010.942 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.008437
2025-08-11T14:36:51.194Z,1754923011.194 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.259550
2025-08-11T14:36:51.444Z,1754923011.444 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.510359
2025-08-11T14:36:51.700Z,1754923011.700 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=1.766668
2025-08-11T14:36:51.949Z,1754923011.949 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.015083
2025-08-11T14:36:52.201Z,1754923012.201 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.267097
2025-08-11T14:36:52.452Z,1754923012.452 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.518414
2025-08-11T14:36:52.704Z,1754923012.704 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=2.770493
2025-08-11T14:36:52.956Z,1754923012.956 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.022437
2025-08-11T14:36:53.208Z,1754923013.208 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.274396
2025-08-11T14:36:53.460Z,1754923013.460 [DAT](INFO): DAT read: Rx Time:14:36:54.1166
2025-08-11T14:36:53.461Z,1754923013.461 [DAT](INFO): Rx dataTimestamp_ set to:1754923013.460439
2025-08-11T14:36:53.461Z,1754923013.461 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.527506
2025-08-11T14:36:53.714Z,1754923013.714 [DAT](INFO): checking for new query: numPingsReceived=0, elapsed TxPingTime=3.780237
2025-08-11T14:36:53.965Z,1754923013.965 [DAT](INFO): DAT read: Range 11 to 50 : 406.7 m (Round-trip 542.3 ms) speed -0.3 m/s
2025-08-11T14:36:53.966Z,1754923013.966 [DAT](ERROR): #Rx 1: Read range message, but no direction.
2025-08-11T14:36:56.460Z,1754923016.460 [DataOverHttps](INFO): Sending 400 bytes from file Logs/20250811T143319/Express0010.lzma
2025-08-11T14:36:57.461Z,1754923017.461 [DataOverHttps](INFO): Moved sent file to Logs/20250811T143319/Express0010.lzma.bak
2025-08-11T14:36:57.461Z,1754923017.461 [DataOverHttps](INFO): SBD MOMSN=25837545
2025-08-11T14:36:58.933Z,1754923018.933 [lineCaptureHoming:NeedComms:D] Stopped
2025-08-11T14:36:58.934Z,1754923018.934 [lineCaptureHoming:NeedComms:E] Running Loop=1
2025-08-11T14:36:59.339Z,1754923019.339 [lineCaptureHoming:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-08-11T14:37:00.935Z,1754923020.935 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,143700.00,A,3654.57589,N,12206.95674,W,0.622,299.74,110825,,,D*7C
2025-08-11T14:37:00.939Z,1754923020.939 [NAL9602](INFO): GPS fix at 20250811T143700: (36.909598, -122.115946)
2025-08-11T14:37:01.014Z,1754923021.014 [lineCaptureHoming:NeedComms:E] Stopped
2025-08-11T14:37:01.043Z,1754923021.043 [lineCaptureHoming:NeedComms](INFO): Completed lineCaptureHoming:NeedComms
2025-08-11T14:37:01.059Z,1754923021.059 [lineCaptureHoming:NeedComms] Stopped
2025-08-11T14:37:01.059Z,1754923021.059 [lineCaptureHoming:NeedComms](DEBUG): Aggregate::uninitialize lineCaptureHoming:NeedComms
2025-08-11T14:37:01.059Z,1754923021.059 [lineCaptureHoming:NeedComms:B.GoToSurface] Stopped
2025-08-11T14:37:01.059Z,1754923021.059 [lineCaptureHoming:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-08-11T14:37:01.381Z,1754923021.381 [lineCaptureHoming:StartingMission](INFO): Completed lineCaptureHoming:StartingMission
2025-08-11T14:37:01.381Z,1754923021.381 [lineCaptureHoming:StartingMission] Stopped
2025-08-11T14:37:01.381Z,1754923021.381 [lineCaptureHoming:StartingMission](DEBUG): Aggregate::uninitialize lineCaptureHoming:StartingMission
2025-08-11T14:37:01.381Z,1754923021.381 [lineCaptureHoming:Z] Running Loop=1
2025-08-11T14:37:01.870Z,1754923021.870 [lineCaptureHoming:Z](IMPORTANT): Restarting logs
2025-08-11T14:37:01.870Z,1754923021.870 [lineCaptureHoming:Z] Stopped
2025-08-11T14:37:01.870Z,1754923021.870 [lineCaptureHoming:BA.Execute] Running Loop=1
2025-08-11T14:37:02.188Z,1754923022.188 [lineCaptureHoming:BA.Execute](INFO): Executing command restart logs
2025-08-11T14:37:02.189Z,1754923022.189 [lineCaptureHoming:BA.Execute] Stopped
2025-08-11T14:37:02.189Z,1754923022.189 [lineCaptureHoming:InitialDive] Running Loop=1
2025-08-11T14:37:02.189Z,1754923022.189 [lineCaptureHoming:InitialDive](DEBUG): Aggregate::initialize lineCaptureHoming:InitialDive
2025-08-11T14:37:02.189Z,1754923022.189 [lineCaptureHoming:InitialDive:A.SetSpeed] Running Loop=1
2025-08-11T14:37:02.190Z,1754923022.190 [lineCaptureHoming:InitialDive:A.SetSpeed](DEBUG): Initialize.
2025-08-11T14:37:02.190Z,1754923022.190 [lineCaptureHoming:InitialDive:B.Mass] Running Loop=1
2025-08-11T14:37:02.190Z,1754923022.190 [lineCaptureHoming:InitialDive:B.Mass](DEBUG): Initialize.
2025-08-11T14:37:02.191Z,1754923022.191 [lineCaptureHoming:InitialDive:C.Pitch] Running Loop=1
2025-08-11T14:37:02.191Z,1754923022.191 [lineCaptureHoming:InitialDive:C.Pitch](DEBUG): Initialize.