2025-03-12T15:50:42.225Z,1741794642.225 [CommandExec](IMPORTANT): got command restart logs 2025-03-12T15:50:56.701Z,1741794656.701 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-03-12T15:51:07.990Z,1741794667.990 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.99,+9999.99 2025-03-12T15:51:25.587Z,1741794685.587 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005246 2025-03-12T15:51:31.054Z,1741794691.054 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155126.00,A,3648.42632,N,12150.72206,W,1.011,0.00,120325,,,A*70 2025-03-12T15:51:31.060Z,1741794691.060 [NAL9602](INFO): GPS fix at 20250312T155126: (36.807105, -121.845368) 2025-03-12T15:51:31.112Z,1741794691.112 [UniversalFixResidualReporter](INFO): Fix residual: 80.5 %DT, over the last 21341.6 m. Residual distance 17181.8 m at bearing -77.3 degrees. Fix at (36.8071, -121.8454) with 1243.8 m made good. 2025-03-12T15:51:31.115Z,1741794691.115 [keepstation:NeedComms:C] Stopped 2025-03-12T15:51:31.115Z,1741794691.115 [keepstation:NeedComms:D] Running Loop=1 2025-03-12T15:51:31.529Z,1741794691.529 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-03-12T15:51:34.791Z,1741794694.791 [DataOverHttps](INFO): Sending 91 bytes from file Logs/20250312T053549/Courier0033.lzma 2025-03-12T15:51:35.694Z,1741794695.694 [DataOverHttps](INFO): Moved sent file to Logs/20250312T053549/Courier0033.lzma.bak 2025-03-12T15:51:35.694Z,1741794695.694 [DataOverHttps](INFO): SBD MOMSN=24183826 2025-03-12T15:51:53.021Z,1741794713.021 [DataOverHttps](INFO): Sending 328 bytes from file Logs/20250312T155042/Courier0000.lzma 2025-03-12T15:51:54.022Z,1741794714.022 [DataOverHttps](INFO): Moved sent file to Logs/20250312T155042/Courier0000.lzma.bak 2025-03-12T15:51:54.022Z,1741794714.022 [DataOverHttps](INFO): SBD MOMSN=24183829 2025-03-12T15:52:03.547Z,1741794723.547 [NAL9602](INFO): Not Powering down - fast GPS 2025-03-12T15:52:10.517Z,1741794730.517 [DataOverHttps](INFO): Sending 2173 bytes from file Logs/20250312T053549/Express0034.lzma 2025-03-12T15:52:11.515Z,1741794731.515 [DataOverHttps](INFO): Moved sent file to Logs/20250312T053549/Express0034.lzma.bak 2025-03-12T15:52:11.515Z,1741794731.515 [DataOverHttps](INFO): SBD MOMSN=24183833 2025-03-12T15:52:28.110Z,1741794748.110 [DataOverHttps](INFO): Sending 448 bytes from file Logs/20250312T155042/Express0001.lzma 2025-03-12T15:52:29.110Z,1741794749.110 [DataOverHttps](INFO): Moved sent file to Logs/20250312T155042/Express0001.lzma.bak 2025-03-12T15:52:29.110Z,1741794749.110 [DataOverHttps](INFO): SBD MOMSN=24183857 2025-03-12T15:52:29.818Z,1741794749.818 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](IMPORTANT): Altitude envelope ACTIVE 2025-03-12T15:52:30.664Z,1741794750.664 [keepstation:NeedComms:D] Stopped 2025-03-12T15:52:30.665Z,1741794750.665 [keepstation:NeedComms:E] Running Loop=1 2025-03-12T15:52:31.026Z,1741794751.026 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-03-12T15:52:32.644Z,1741794752.644 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155227.00,A,3648.43960,N,12150.73187,W,1.147,3.48,120325,,,A*7D 2025-03-12T15:52:32.647Z,1741794752.647 [NAL9602](INFO): GPS fix at 20250312T155227: (36.807327, -121.845531) 2025-03-12T15:52:32.691Z,1741794752.691 [keepstation:NeedComms:E] Stopped 2025-03-12T15:52:32.701Z,1741794752.701 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2025-03-12T15:52:32.701Z,1741794752.701 [keepstation:NeedComms] Stopped 2025-03-12T15:52:32.701Z,1741794752.701 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2025-03-12T15:52:32.701Z,1741794752.701 [keepstation:NeedComms:B.GoToSurface] Stopped 2025-03-12T15:52:32.701Z,1741794752.701 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-12T15:52:33.068Z,1741794753.068 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission 2025-03-12T15:52:33.068Z,1741794753.068 [keepstation:StartingMission] Stopped 2025-03-12T15:52:33.068Z,1741794753.068 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission 2025-03-12T15:52:33.068Z,1741794753.068 [keepstation:TransitToStation] Running Loop=1 2025-03-12T15:52:33.069Z,1741794753.069 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation 2025-03-12T15:52:33.069Z,1741794753.069 [keepstation:TransitToStation:A.Buoyancy] Running Loop=1 2025-03-12T15:52:33.069Z,1741794753.069 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Initialize Buoyancy Component. 2025-03-12T15:52:33.069Z,1741794753.069 [keepstation:TransitToStation:B.Pitch] Running Loop=1 2025-03-12T15:52:33.069Z,1741794753.069 [keepstation:TransitToStation:B.Pitch](DEBUG): Initialize. 2025-03-12T15:52:33.069Z,1741794753.069 [keepstation:TransitToStation:C.SetSpeed] Running Loop=1 2025-03-12T15:52:33.069Z,1741794753.069 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Initialize. 2025-03-12T15:52:33.069Z,1741794753.069 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1 2025-03-12T15:52:33.069Z,1741794753.069 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2025-03-12T15:52:33.070Z,1741794753.070 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000 2025-03-12T15:52:33.473Z,1741794753.473 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000 2025-03-12T15:52:33.474Z,1741794753.474 [keepstation:TransitToStation:C.SetSpeed] Running Loop=1 2025-03-12T15:52:33.475Z,1741794753.475 [keepstation:TransitToStation:B.Pitch] Running Loop=1 2025-03-12T15:52:33.475Z,1741794753.475 [keepstation:TransitToStation:A.Buoyancy] Running Loop=1 2025-03-12T15:52:39.680Z,1741794759.680 [DVL_micro](ERROR): only read 3 of 4 data items for beam range. Device response is::RD,+0000.32,+0000.13,+00000.39 2025-03-12T15:52:39.680Z,1741794759.680 [DVL_micro](ERROR): Failed to parse: :RD,+0000.32,+0000.13,+00000.39 2025-03-12T15:52:48.553Z,1741794768.553 [NAL9602](INFO): SBD MO Status=0, MOMSN=18966, MT Status=0, MTMSN=0 2025-03-12T15:52:48.554Z,1741794768.554 [NAL9602](INFO): No messages in MT queue 2025-03-12T15:53:19.094Z,1741794799.094 [NAL9602](INFO): Not Powering down - fast GPS 2025-03-12T15:53:26.381Z,1741794806.381 [DVL_micro](ERROR): only read 0 of 4 data items for bottom velocity. Device response is::BI0 2025-03-12T15:53:26.381Z,1741794806.381 [DVL_micro](ERROR): Failed to parse: :BI0 2025-03-12T15:53:31.604Z,1741794811.604 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-03-12T15:54:02.736Z,1741794842.736 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-03-12T15:54:33.860Z,1741794873.860 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-03-12T15:55:01.196Z,1741794901.196 [Radio_Surface](INFO): Powering down 2025-03-12T15:55:04.986Z,1741794904.986 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-03-12T15:55:05.989Z,1741794905.989 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-03-12T15:55:40.128Z,1741794940.128 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.735260 2025-03-12T16:01:24.407Z,1741795284.407 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,00000000000000,35.0,+11.5,0000.0,1489.9999.99,000.00 2025-03-12T16:01:24.408Z,1741795284.408 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+11.5,0000.0,1489.9999.99,000.00 2025-03-12T16:06:52.563Z,1741795612.563 [DVL_micro](ERROR): Failed to parse: :SA,+02.81,+04.15,183.1 2025-03-12T16:08:42.916Z,1741795722.916 [DVL_micro](ERROR): Failed to parse: :SA,+05.65,+03.13,183.0 2025-03-12T16:08:50.587Z,1741795730.587 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.99,+9999.99 2025-03-12T16:19:22.482Z,1741796362.482 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.797001,-121.847000 2025-03-12T16:19:22.483Z,1741796362.483 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped 2025-03-12T16:19:22.483Z,1741796362.483 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2025-03-12T16:19:22.484Z,1741796362.484 [keepstation:TransitToStation](INFO): Completed keepstation:TransitToStation 2025-03-12T16:19:22.484Z,1741796362.484 [keepstation:TransitToStation] Stopped 2025-03-12T16:19:22.484Z,1741796362.484 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation 2025-03-12T16:19:22.484Z,1741796362.484 [keepstation:TransitToStation:A.Buoyancy] Stopped 2025-03-12T16:19:22.484Z,1741796362.484 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2025-03-12T16:19:22.485Z,1741796362.485 [keepstation:TransitToStation:B.Pitch] Stopped 2025-03-12T16:19:22.485Z,1741796362.485 [keepstation:TransitToStation:C.SetSpeed] Stopped 2025-03-12T16:19:22.485Z,1741796362.485 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Uninitialize. 2025-03-12T16:19:22.485Z,1741796362.485 [keepstation:OnStation] Running Loop=1 2025-03-12T16:19:22.485Z,1741796362.485 [keepstation:OnStation](DEBUG): Aggregate::initialize keepstation:OnStation 2025-03-12T16:19:22.904Z,1741796362.904 [keepstation:NeedComms] Running Loop=1 2025-03-12T16:19:22.904Z,1741796362.904 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2025-03-12T16:19:22.904Z,1741796362.904 [keepstation:NeedComms:B.GoToSurface] Running Loop=1 2025-03-12T16:19:22.904Z,1741796362.904 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-03-12T16:19:22.904Z,1741796362.904 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2025-03-12T16:19:22.905Z,1741796362.905 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2025-03-12T16:19:22.905Z,1741796362.905 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2025-03-12T16:19:22.906Z,1741796362.906 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2025-03-12T16:19:22.906Z,1741796362.906 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-03-12T16:19:22.906Z,1741796362.906 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-03-12T16:19:22.906Z,1741796362.906 [keepstation:NeedComms:A] Running Loop=1 2025-03-12T16:19:22.908Z,1741796362.908 [keepstation:NeedComms:A](INFO): last time_fix was: 1741794747.000000 second since 1970/01/01T00:00:00Z 2025-03-12T16:19:22.908Z,1741796362.908 [keepstation:NeedComms:A] Stopped 2025-03-12T16:19:47.666Z,1741796387.666 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,0000000000000.00,+00000000.00,9999.99,000.00 2025-03-12T16:19:47.666Z,1741796387.666 [DVL_micro](ERROR): Failed to parse: :TS,0000000000000.00,+00000000.00,9999.99,000.00 2025-03-12T16:20:11.943Z,1741796411.943 [keepstation:NeedComms:C] Running Loop=1 2025-03-12T16:20:12.340Z,1741796412.340 [Radio_Surface](INFO): Powering up 2025-03-12T16:20:18.233Z,1741796418.233 [DataOverHttps](INFO): Radio surface powered ON. 2025-03-12T16:20:34.654Z,1741796434.654 [DVL_micro](ERROR): Failed to parse: :WI,-00274,+00351,+00110,+00000,A 2025-03-12T16:20:35.854Z,1741796435.854 [DVL_micro](ERROR): Failed to parse: :RD,+0000.30,+9999.99,+0000.34,+0000.68 2025-03-12T16:20:38.277Z,1741796438.277 [NAL9602](INFO): SBD MO Status=2, MOMSN=18967, MT Status=2, MTMSN=0 2025-03-12T16:20:38.277Z,1741796438.277 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-03-12T16:20:48.357Z,1741796448.357 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-03-12T16:20:53.238Z,1741796453.238 [DVL_micro](ERROR): Failed to parse: :BD,+00000000.00,+00000000.00,+00000000.00,9999.99,000.00 2025-03-12T16:20:54.439Z,1741796454.439 [DVL_micro](ERROR): Failed to parse: :RD,+0000.30,+0000.34,+0000.34,+0000.12 2025-03-12T16:21:04.134Z,1741796464.134 [NAL9602](INFO): SBD MO Status=2, MOMSN=18967, MT Status=2, MTMSN=0 2025-03-12T16:21:04.134Z,1741796464.134 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-03-12T16:21:19.480Z,1741796479.480 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-03-12T16:21:50.604Z,1741796510.604 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-03-12T16:22:21.728Z,1741796541.728 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-03-12T16:22:22.111Z,1741796542.111 [NAL9602](INFO): SBD MO Status=2, MOMSN=18967, MT Status=2, MTMSN=0 2025-03-12T16:22:22.111Z,1741796542.111 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-03-12T16:22:30.889Z,1741796550.889 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003659 2025-03-12T16:22:33.012Z,1741796553.012 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=18967, MT Status=1, MTMSN=4251 2025-03-12T16:22:33.012Z,1741796553.012 [NAL9602](INFO): Data available in MT queue 2025-03-12T16:22:33.565Z,1741796553.565 [NAL9602](INFO): Received command: restart sys 2025-03-12T16:22:33.622Z,1741796553.622 [CommandExec](IMPORTANT): got command restart system 2025-03-12T16:22:34.665Z,1741796554.665 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,162229.00,A,3648.07450,N,12150.81506,W,1.127,345.43,120325,,,A*75 2025-03-12T16:22:34.685Z,1741796554.685 [NAL9602](INFO): GPS fix at 20250312T162229: (36.801242, -121.846918) 2025-03-12T16:22:34.744Z,1741796554.744 [UniversalFixResidualReporter](INFO): Fix residual: 40.1 %DT, over the last 1309.2 m. Residual distance 524.7 m at bearing 179.9 degrees. Fix at (36.8012, -121.8469) with 687.8 m made good. 2025-03-12T16:22:34.756Z,1741796554.756 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](IMPORTANT): Altitude envelope ACTIVE 2025-03-12T16:22:34.757Z,1741796554.757 [keepstation:NeedComms:C] Stopped 2025-03-12T16:22:34.758Z,1741796554.758 [keepstation:NeedComms:D] Running Loop=1 2025-03-12T16:22:35.796Z,1741796555.796 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2025-03-12T16:22:35.796Z,1741796555.796 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:35.797Z,1741796555.797 [CommandExec](INFO): Uninitializing the command executive. 2025-03-12T16:22:35.797Z,1741796555.797 [CommandExec](INFO): Uninitializing the command scheduler. 2025-03-12T16:22:35.797Z,1741796555.797 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:35.952Z,1741796555.952 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-03-12T16:22:35.952Z,1741796555.952 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-03-12T16:22:35.952Z,1741796555.952 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:35.953Z,1741796555.953 [NavChartDb](INFO): Join timeout helper Thread ID is 3433 2025-03-12T16:22:36.061Z,1741796556.061 [MissionManager](INFO): MissionManager is completed. 2025-03-12T16:22:36.062Z,1741796556.062 [MissionManager](INFO): Uninitializing Mission keepstation 2025-03-12T16:22:36.062Z,1741796556.062 [keepstation] Stopped 2025-03-12T16:22:36.062Z,1741796556.062 [keepstation](DEBUG): Aggregate::uninitialize keepstation 2025-03-12T16:22:36.062Z,1741796556.062 [keepstation:NeedComms] Stopped 2025-03-12T16:22:36.062Z,1741796556.062 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2025-03-12T16:22:36.062Z,1741796556.062 [keepstation:NeedComms:B.GoToSurface] Stopped 2025-03-12T16:22:36.062Z,1741796556.062 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-12T16:22:36.062Z,1741796556.062 [keepstation:NeedComms:D] Stopped 2025-03-12T16:22:36.062Z,1741796556.062 [keepstation:StandardEnvelopes] Stopped 2025-03-12T16:22:36.062Z,1741796556.062 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes 2025-03-12T16:22:36.063Z,1741796556.063 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2025-03-12T16:22:36.063Z,1741796556.063 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2025-03-12T16:22:36.063Z,1741796556.063 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped 2025-03-12T16:22:36.063Z,1741796556.063 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2025-03-12T16:22:36.063Z,1741796556.063 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2025-03-12T16:22:36.063Z,1741796556.063 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2025-03-12T16:22:36.063Z,1741796556.063 [keepstation:BackseatDriver] Stopped 2025-03-12T16:22:36.063Z,1741796556.063 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver 2025-03-12T16:22:36.063Z,1741796556.063 [keepstation:BackseatDriver:A.BackseatDriver] Stopped 2025-03-12T16:22:36.076Z,1741796556.076 [keepstation:PowerOnly] Stopped 2025-03-12T16:22:36.076Z,1741796556.076 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly 2025-03-12T16:22:36.076Z,1741796556.076 [keepstation:PowerOnly:B] Stopped 2025-03-12T16:22:36.076Z,1741796556.076 [keepstation:PowerOnly:E.Wait] Stopped 2025-03-12T16:22:36.076Z,1741796556.076 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2025-03-12T16:22:36.076Z,1741796556.076 [keepstation:H.Pitch] Stopped 2025-03-12T16:22:36.077Z,1741796556.077 [keepstation:OnStation] Stopped 2025-03-12T16:22:36.077Z,1741796556.077 [keepstation:OnStation](DEBUG): Aggregate::uninitialize keepstation:OnStation 2025-03-12T16:22:36.084Z,1741796556.084 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:36.084Z,1741796556.084 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:36.100Z,1741796556.100 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-03-12T16:22:36.100Z,1741796556.100 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:36.101Z,1741796556.101 [Radio_Surface](INFO): Join timeout helper Thread ID is 3434 2025-03-12T16:22:36.164Z,1741796556.164 [Radio_Surface](INFO): Powering down 2025-03-12T16:22:36.166Z,1741796556.166 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:36.166Z,1741796556.166 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:36.180Z,1741796556.180 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2025-03-12T16:22:36.180Z,1741796556.180 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:36.181Z,1741796556.181 [Onboard](INFO): Join timeout helper Thread ID is 3435 2025-03-12T16:22:36.186Z,1741796556.186 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-03-12T16:22:36.471Z,1741796556.471 [MissionManager](IMPORTANT): Started mission Default 2025-03-12T16:22:36.471Z,1741796556.471 [Default] Running Loop=1 2025-03-12T16:22:36.471Z,1741796556.471 [Default](DEBUG): Aggregate::initialize Default 2025-03-12T16:22:36.471Z,1741796556.471 [Default:B.GoToSurface] Running Loop=1 2025-03-12T16:22:36.471Z,1741796556.471 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-03-12T16:22:36.488Z,1741796556.488 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-03-12T16:22:36.489Z,1741796556.489 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-03-12T16:22:36.489Z,1741796556.489 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-03-12T16:22:36.489Z,1741796556.489 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-03-12T16:22:36.490Z,1741796556.490 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-03-12T16:22:36.490Z,1741796556.490 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-03-12T16:22:36.491Z,1741796556.491 [Default:A.Wait] Running Loop=1 2025-03-12T16:22:36.491Z,1741796556.491 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-03-12T16:22:38.484Z,1741796558.484 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:38.484Z,1741796558.484 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:38.500Z,1741796558.500 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2025-03-12T16:22:38.500Z,1741796558.500 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:38.500Z,1741796558.500 [DataOverHttps](INFO): Join timeout helper Thread ID is 3438 2025-03-12T16:22:38.916Z,1741796558.916 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:38.917Z,1741796558.917 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:38.920Z,1741796558.920 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2025-03-12T16:22:38.920Z,1741796558.920 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:38.920Z,1741796558.920 [DAT](INFO): Join timeout helper Thread ID is 3439 2025-03-12T16:22:39.124Z,1741796559.124 [DAT](INFO): Powering down 2025-03-12T16:22:39.205Z,1741796559.205 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:39.205Z,1741796559.205 [DAT](INFO): Powering down 2025-03-12T16:22:39.206Z,1741796559.206 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:39.222Z,1741796559.222 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2025-03-12T16:22:39.223Z,1741796559.223 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:39.223Z,1741796559.223 [BackseatComponent](INFO): Join timeout helper Thread ID is 3440 2025-03-12T16:22:39.332Z,1741796559.332 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:39.333Z,1741796559.333 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:39.351Z,1741796559.351 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-03-12T16:22:39.351Z,1741796559.351 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:39.351Z,1741796559.351 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3441 2025-03-12T16:22:39.384Z,1741796559.384 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:39.384Z,1741796559.384 [WetLabsBB2FL](INFO): Powering down 2025-03-12T16:22:39.385Z,1741796559.385 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:39.409Z,1741796559.409 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-03-12T16:22:39.409Z,1741796559.409 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:39.410Z,1741796559.410 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3442 2025-03-12T16:22:39.852Z,1741796559.852 [CTD_Seabird](INFO): Powering down 2025-03-12T16:22:39.864Z,1741796559.864 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:39.864Z,1741796559.864 [CTD_Seabird](INFO): Powering down 2025-03-12T16:22:39.876Z,1741796559.876 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:39.885Z,1741796559.885 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2025-03-12T16:22:39.885Z,1741796559.885 [logger ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:39.885Z,1741796559.885 [logger](INFO): Join timeout helper Thread ID is 3443 2025-03-12T16:22:39.908Z,1741796559.908 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:39.908Z,1741796559.908 [logger ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:39.924Z,1741796559.924 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2025-03-12T16:22:39.925Z,1741796559.925 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:39.925Z,1741796559.925 [CommandLine](INFO): Join timeout helper Thread ID is 3444 2025-03-12T16:22:40.012Z,1741796560.012 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:40.012Z,1741796560.012 [CommandLine ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.025Z,1741796560.025 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2025-03-12T16:22:40.025Z,1741796560.025 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.025Z,1741796560.025 [CommandExec](INFO): Join timeout helper Thread ID is 3445 2025-03-12T16:22:40.026Z,1741796560.026 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2025-03-12T16:22:40.026Z,1741796560.026 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.027Z,1741796560.027 [controlThread](INFO): Join timeout helper Thread ID is 3446 2025-03-12T16:22:40.050Z,1741796560.050 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2025-03-12T16:22:40.050Z,1741796560.050 [controlThread](DEBUG): Uninitializing ControlThread 2025-03-12T16:22:40.052Z,1741796560.052 [AHRS_M2](INFO): Powering down 2025-03-12T16:22:40.220Z,1741796560.220 [DVL_micro](INFO): Powering down 2025-03-12T16:22:40.221Z,1741796560.221 [NAL9602](INFO): Powering down 2025-03-12T16:22:40.222Z,1741796560.222 [Sonardyne_Nano](INFO): Powering down 2025-03-12T16:22:40.341Z,1741796560.341 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2025-03-12T16:22:40.341Z,1741796560.341 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2025-03-12T16:22:40.342Z,1741796560.342 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2025-03-12T16:22:40.342Z,1741796560.342 [MissionManager](INFO): Uninitializing Mission Default 2025-03-12T16:22:40.342Z,1741796560.342 [Default] Stopped 2025-03-12T16:22:40.343Z,1741796560.343 [Default](DEBUG): Aggregate::uninitialize Default 2025-03-12T16:22:40.343Z,1741796560.343 [Default:A.Wait] Stopped 2025-03-12T16:22:40.343Z,1741796560.343 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-03-12T16:22:40.343Z,1741796560.343 [Default:B.GoToSurface] Stopped 2025-03-12T16:22:40.343Z,1741796560.343 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-03-12T16:22:40.346Z,1741796560.346 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2025-03-12T16:22:40.347Z,1741796560.347 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2025-03-12T16:22:40.347Z,1741796560.347 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2025-03-12T16:22:40.347Z,1741796560.347 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2025-03-12T16:22:40.348Z,1741796560.348 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2025-03-12T16:22:40.348Z,1741796560.348 [BuoyancyServo](INFO): Powering down 2025-03-12T16:22:40.480Z,1741796560.480 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2025-03-12T16:22:40.480Z,1741796560.480 [ElevatorServo](INFO): Powering down 2025-03-12T16:22:40.481Z,1741796560.481 [MassServo](DEBUG): Uninitialize Mass Servo. 2025-03-12T16:22:40.481Z,1741796560.481 [MassServo](INFO): Powering down 2025-03-12T16:22:40.482Z,1741796560.482 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2025-03-12T16:22:40.482Z,1741796560.482 [RudderServo](INFO): Powering down 2025-03-12T16:22:40.483Z,1741796560.483 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2025-03-12T16:22:40.483Z,1741796560.483 [ThrusterHE](INFO): Powering down 2025-03-12T16:22:40.484Z,1741796560.484 [SBIT](DEBUG): Uninitialize SBIT Component. 2025-03-12T16:22:40.485Z,1741796560.485 [IBIT](DEBUG): Uninitialize IBIT Component. 2025-03-12T16:22:40.485Z,1741796560.485 [CBIT](DEBUG): Uninitialize CBIT Component. 2025-03-12T16:22:40.485Z,1741796560.485 [CBIT](DEBUG): Powering off loads. 2025-03-12T16:22:40.500Z,1741796560.500 [CBIT](DEBUG): Disabling WDT. 2025-03-12T16:22:40.512Z,1741796560.512 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-03-12T16:22:40.513Z,1741796560.513 [controlThread ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.573Z,1741796560.573 [GFScanner](DEBUG): Uninitialize GFScanner component. 2025-03-12T16:22:40.606Z,1741796560.606 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.613Z,1741796560.613 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.690Z,1741796560.690 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.693Z,1741796560.693 [Onboard ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.702Z,1741796560.702 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.709Z,1741796560.709 [DAT ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.750Z,1741796560.750 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.816Z,1741796560.816 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-03-12T16:22:40.899Z,1741796560.899 [logger ThreadHandler](INFO): Thread cancelled.