2025-02-20T19:03:52.026Z,1740078232.026 [Default] Stopped
2025-02-20T19:03:52.026Z,1740078232.026 [Default](DEBUG): Aggregate::uninitialize Default
2025-02-20T19:03:52.026Z,1740078232.026 [Default:B.GoToSurface] Stopped
2025-02-20T19:03:52.026Z,1740078232.026 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-20T19:03:52.026Z,1740078232.026 [Default:CheckIn] Stopped
2025-02-20T19:03:52.026Z,1740078232.026 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-02-20T19:03:52.026Z,1740078232.026 [Default:CheckIn:C.Wait] Stopped
2025-02-20T19:03:52.026Z,1740078232.026 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-02-20T19:03:52.026Z,1740078232.026 [MissionManager](IMPORTANT): Started mission transit
2025-02-20T19:03:52.027Z,1740078232.027 [transit] Running Loop=1
2025-02-20T19:03:52.027Z,1740078232.027 [transit](DEBUG): Aggregate::initialize transit
2025-02-20T19:03:52.027Z,1740078232.027 [transit:StandardEnvelopes] Running Loop=1
2025-02-20T19:03:52.030Z,1740078232.030 [CommandExec](IMPORTANT): Running 
2025-02-20T19:03:52.035Z,1740078232.035 [transit:StandardEnvelopes](DEBUG): Aggregate::initialize transit:StandardEnvelopes
2025-02-20T19:03:52.035Z,1740078232.035 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-02-20T19:03:52.035Z,1740078232.035 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-02-20T19:03:52.036Z,1740078232.036 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-02-20T19:03:52.036Z,1740078232.036 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-02-20T19:03:52.036Z,1740078232.036 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-02-20T19:03:52.036Z,1740078232.036 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-02-20T19:03:52.036Z,1740078232.036 [transit:BackseatDriver] Running Loop=1
2025-02-20T19:03:52.036Z,1740078232.036 [transit:BackseatDriver](DEBUG): Aggregate::initialize transit:BackseatDriver
2025-02-20T19:03:52.036Z,1740078232.036 [transit:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-02-20T19:03:52.036Z,1740078232.036 [transit:PowerOnly] Running Loop=1
2025-02-20T19:03:52.036Z,1740078232.036 [transit:PowerOnly](DEBUG): Aggregate::initialize transit:PowerOnly
2025-02-20T19:03:52.036Z,1740078232.036 [transit:PowerOnly:A] Running Loop=1
2025-02-20T19:03:52.037Z,1740078232.037 [transit:PowerOnly:B] Running Loop=1
2025-02-20T19:03:52.037Z,1740078232.037 [transit:PowerOnly:C] Running Loop=1
2025-02-20T19:03:52.038Z,1740078232.038 [transit:PowerOnly:D] Running Loop=1
2025-02-20T19:03:52.038Z,1740078232.038 [transit:PowerOnly:E.Wait] Running Loop=1
2025-02-20T19:03:52.038Z,1740078232.038 [transit:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-02-20T19:03:52.042Z,1740078232.042 [CommandExec](IMPORTANT): got command restart logs
2025-02-20T19:03:52.047Z,1740078232.047 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2025-02-20T19:03:52.047Z,1740078232.047 [transit:BuoyancyHold.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-02-20T19:03:52.047Z,1740078232.047 [transit:MassHold.Pitch] Running Loop=1
2025-02-20T19:03:52.047Z,1740078232.047 [transit:MassHold.Pitch](DEBUG): Initialize.
2025-02-20T19:03:52.048Z,1740078232.048 [transit:B] Running Loop=1
2025-02-20T19:03:52.048Z,1740078232.048 [transit:MassHold.Pitch] Running Loop=1
2025-02-20T19:03:52.049Z,1740078232.049 [transit:BuoyancyHold.Buoyancy] Running Loop=1
2025-02-20T19:03:52.049Z,1740078232.049 [transit:PowerOnly] Running Loop=1
2025-02-20T19:03:52.049Z,1740078232.049 [transit:PowerOnly:D] Stopped
2025-02-20T19:03:52.049Z,1740078232.049 [transit:PowerOnly:C] Stopped
2025-02-20T19:03:52.049Z,1740078232.049 [transit:PowerOnly:B] Stopped
2025-02-20T19:03:52.049Z,1740078232.049 [transit:PowerOnly:A] Stopped
2025-02-20T19:03:52.049Z,1740078232.049 [transit:BackseatDriver] Running Loop=1
2025-02-20T19:03:52.050Z,1740078232.050 [transit:StandardEnvelopes] Running Loop=1
2025-02-20T19:03:52.050Z,1740078232.050 [transit:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-02-20T19:03:52.050Z,1740078232.050 [transit:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-02-20T19:03:52.050Z,1740078232.050 [transit:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-02-20T19:03:52.056Z,1740078232.056 [transit:B] Stopped
2025-02-20T19:03:52.056Z,1740078232.056 [transit:C] Running Loop=1
2025-02-20T19:03:52.414Z,1740078232.414 [transit:C] Stopped
2025-02-20T19:03:52.414Z,1740078232.414 [transit:E] Running Loop=1
2025-02-20T19:03:52.818Z,1740078232.818 [transit:E] Stopped
2025-02-20T19:03:52.818Z,1740078232.818 [transit:F] Running Loop=1
2025-02-20T19:03:53.223Z,1740078233.223 [transit:F] Stopped
2025-02-20T19:03:53.223Z,1740078233.223 [transit:G] Running Loop=1
2025-02-20T19:03:53.630Z,1740078233.630 [transit:G] Stopped
2025-02-20T19:03:53.630Z,1740078233.630 [transit:Transit] Running Loop=1
2025-02-20T19:03:53.630Z,1740078233.630 [transit:Transit](DEBUG): Aggregate::initialize transit:Transit
2025-02-20T19:03:53.630Z,1740078233.630 [transit:Transit:A.Pitch] Running Loop=1
2025-02-20T19:03:53.630Z,1740078233.630 [transit:Transit:A.Pitch](DEBUG): Initialize.
2025-02-20T19:03:53.631Z,1740078233.631 [transit:Transit:B.SetSpeed] Running Loop=1
2025-02-20T19:03:53.631Z,1740078233.631 [transit:Transit:B.SetSpeed](DEBUG): Initialize.
2025-02-20T19:03:53.636Z,1740078233.636 [transit:Transit:Wpt1.Waypoint] Running Loop=1
2025-02-20T19:03:53.636Z,1740078233.636 [transit:Transit:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent.
2025-02-20T19:03:53.644Z,1740078233.644 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000
2025-02-20T19:03:54.033Z,1740078234.033 [transit:Transit:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000
2025-02-20T19:03:54.034Z,1740078234.034 [transit:Transit:B.SetSpeed] Running Loop=1
2025-02-20T19:03:54.039Z,1740078234.039 [transit:Transit:A.Pitch] Running Loop=1
2025-02-20T19:05:01.944Z,1740078301.944 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-20T19:05:18.259Z,1740078318.259 [Radio_Surface](INFO): Powering down
2025-02-20T19:05:33.080Z,1740078333.080 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-20T19:05:34.084Z,1740078334.084 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-02-20T19:07:11.512Z,1740078431.512 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.770996
2025-02-20T19:19:04.659Z,1740079144.659 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-20T19:19:17.183Z,1740079157.183 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-20T19:19:30.515Z,1740079170.515 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-20T19:19:43.848Z,1740079183.848 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-20T19:19:56.774Z,1740079196.774 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-20T19:20:09.706Z,1740079209.706 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-20T19:20:22.634Z,1740079222.634 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-02-20T19:25:28.211Z,1740079528.211 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7).
2025-02-20T19:25:30.643Z,1740079530.643 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0.
2025-02-20T19:25:30.643Z,1740079530.643 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 6.
2025-02-20T19:25:30.646Z,1740079530.646 [BPC1](INFO): Received data from all battery sticks.
2025-02-20T19:30:24.756Z,1740079824.756 [transit:Transit:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.797001,-121.847000
2025-02-20T19:30:24.756Z,1740079824.756 [transit:Transit:Wpt1.Waypoint] Stopped
2025-02-20T19:30:24.756Z,1740079824.756 [transit:Transit:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent.
2025-02-20T19:30:24.757Z,1740079824.757 [transit:Transit:PhoneHome] Running Loop=1
2025-02-20T19:30:24.757Z,1740079824.757 [transit:Transit:PhoneHome](DEBUG): Aggregate::initialize transit:Transit:PhoneHome
2025-02-20T19:30:25.161Z,1740079825.161 [transit:NeedComms] Running Loop=1
2025-02-20T19:30:25.162Z,1740079825.162 [transit:NeedComms](DEBUG): Aggregate::initialize transit:NeedComms
2025-02-20T19:30:25.162Z,1740079825.162 [transit:NeedComms:B.GoToSurface] Running Loop=1
2025-02-20T19:30:25.162Z,1740079825.162 [transit:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-20T19:30:25.162Z,1740079825.162 [transit:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-02-20T19:30:25.163Z,1740079825.163 [transit:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-02-20T19:30:25.163Z,1740079825.163 [transit:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-02-20T19:30:25.163Z,1740079825.163 [transit:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-02-20T19:30:25.164Z,1740079825.164 [transit:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-20T19:30:25.164Z,1740079825.164 [transit:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-20T19:30:25.164Z,1740079825.164 [transit:NeedComms:A] Running Loop=1
2025-02-20T19:30:25.166Z,1740079825.166 [transit:NeedComms:A](INFO): last time_fix was:  1740078054.000000 second since 1970/01/01T00:00:00Z 
2025-02-20T19:30:25.166Z,1740079825.166 [transit:NeedComms:A] Stopped
2025-02-20T19:32:01.396Z,1740079921.396 [transit:NeedComms:C] Running Loop=1
2025-02-20T19:32:01.783Z,1740079921.783 [transit:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-02-20T19:32:01.839Z,1740079921.839 [Radio_Surface](INFO): Powering up
2025-02-20T19:32:07.792Z,1740079927.792 [DataOverHttps](INFO): Radio surface powered ON.
2025-02-20T19:32:23.610Z,1740079943.610 [NAL9602](INFO): SBD MO Status=0, MOMSN=12917, MT Status=0, MTMSN=0
2025-02-20T19:32:23.610Z,1740079943.610 [NAL9602](INFO): No messages in MT queue
2025-02-20T19:32:24.815Z,1740079944.815 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193224.00,A,3647.75621,N,12150.74388,W,1.108,183.23,200225,,,A*71
2025-02-20T19:32:24.817Z,1740079944.817 [NAL9602](INFO): GPS fix at 20250220T193224: (36.795937, -121.845731)
2025-02-20T19:32:24.831Z,1740079944.831 [UniversalFixResidualReporter](INFO): Fix residual: 6.1 %DT, over the last 1568.6 m. Residual distance 96.5 m at bearing -19.5 degrees. Fix at (36.7959, -121.8457) with 1508.9 m made good.
2025-02-20T19:32:24.834Z,1740079944.834 [transit:NeedComms:C] Stopped
2025-02-20T19:32:24.834Z,1740079944.834 [transit:NeedComms:D] Running Loop=1
2025-02-20T19:32:25.251Z,1740079945.251 [transit:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-02-20T19:32:37.911Z,1740079957.911 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-20T19:32:47.129Z,1740079967.129 [NAL9602](INFO): SBD MO Status=2, MOMSN=12918, MT Status=2, MTMSN=0
2025-02-20T19:32:47.129Z,1740079967.129 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-20T19:33:07.462Z,1740079987.462 [NAL9602](INFO): SBD MO Status=1, MOMSN=12918, MT Status=0, MTMSN=0
2025-02-20T19:33:07.527Z,1740079987.527 [NAL9602](INFO): Sent 39 bytes from file Logs/20250220T174543/Courier0042.lzma
2025-02-20T19:33:07.528Z,1740079987.528 [NAL9602](INFO): Packets left to send: 0
2025-02-20T19:33:09.047Z,1740079989.047 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-20T19:33:32.633Z,1740080012.633 [NAL9602](INFO): SBD MO Status=1, MOMSN=12919, MT Status=0, MTMSN=0
2025-02-20T19:33:32.693Z,1740080012.693 [NAL9602](INFO): Sent 332 bytes from file Logs/20250220T190352/Courier0000.lzma
2025-02-20T19:33:32.694Z,1740080012.694 [NAL9602](INFO): Packets left to send: 1
2025-02-20T19:33:40.172Z,1740080020.172 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-20T19:33:49.258Z,1740080029.258 [NAL9602](INFO): SBD MO Status=2, MOMSN=12920, MT Status=2, MTMSN=0
2025-02-20T19:33:49.258Z,1740080029.258 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-20T19:34:11.295Z,1740080051.295 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-02-20T19:34:13.634Z,1740080053.634 [NAL9602](INFO): SBD MO Status=1, MOMSN=12920, MT Status=0, MTMSN=0
2025-02-20T19:34:13.684Z,1740080053.684 [NAL9602](INFO): Sent 32 bytes from file Logs/20250220T190352/Courier0000.lzma
2025-02-20T19:34:13.684Z,1740080053.684 [NAL9602](INFO): Packets left to send: 0
2025-02-20T19:34:22.944Z,1740080062.944 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003159
2025-02-20T19:34:28.418Z,1740080068.418 [NAL9602](INFO): SBD MO Status=2, MOMSN=12921, MT Status=2, MTMSN=0
2025-02-20T19:34:28.418Z,1740080068.418 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-20T19:34:30.531Z,1740080070.531 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250220T190352/Courier0003.lzma
2025-02-20T19:34:31.533Z,1740080071.533 [DataOverHttps](INFO): Moved sent file to Logs/20250220T190352/Courier0003.lzma.bak
2025-02-20T19:34:31.533Z,1740080071.533 [DataOverHttps](INFO): SBD MOMSN=23968807
2025-02-20T19:34:50.243Z,1740080090.243 [DataOverHttps](INFO): Sending 322 bytes from file Logs/20250220T174543/Express0043.lzma
2025-02-20T19:34:51.245Z,1740080091.245 [DataOverHttps](INFO): Moved sent file to Logs/20250220T174543/Express0043.lzma.bak
2025-02-20T19:34:51.245Z,1740080091.245 [DataOverHttps](INFO): SBD MOMSN=23968812
2025-02-20T19:34:59.164Z,1740080099.164 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-20T19:35:10.488Z,1740080110.488 [DataOverHttps](INFO): Sending 493 bytes from file Logs/20250220T190352/Express0001.lzma
2025-02-20T19:35:11.489Z,1740080111.489 [DataOverHttps](INFO): Moved sent file to Logs/20250220T190352/Express0001.lzma.bak
2025-02-20T19:35:11.489Z,1740080111.489 [DataOverHttps](INFO): SBD MOMSN=23968825
2025-02-20T19:35:31.655Z,1740080131.655 [DataOverHttps](INFO): Sending 70 bytes from file Logs/20250220T190352/Express0004.lzma
2025-02-20T19:35:32.660Z,1740080132.660 [DataOverHttps](INFO): Moved sent file to Logs/20250220T190352/Express0004.lzma.bak
2025-02-20T19:35:32.660Z,1740080132.660 [DataOverHttps](INFO): SBD MOMSN=23968832
2025-02-20T19:35:33.991Z,1740080133.991 [transit:NeedComms:D] Stopped
2025-02-20T19:35:33.991Z,1740080133.991 [transit:NeedComms:E] Running Loop=1
2025-02-20T19:35:34.382Z,1740080134.382 [transit:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-02-20T19:35:35.982Z,1740080135.982 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193535.00,A,3647.73659,N,12150.72818,W,0.525,175.70,200225,,,A*7E
2025-02-20T19:35:35.984Z,1740080135.984 [NAL9602](INFO): GPS fix at 20250220T193535: (36.795610, -121.845470)
2025-02-20T19:35:36.042Z,1740080136.042 [transit:NeedComms:E] Stopped
2025-02-20T19:35:36.043Z,1740080136.043 [transit:NeedComms](INFO): Completed transit:NeedComms
2025-02-20T19:35:36.047Z,1740080136.047 [transit:NeedComms] Stopped
2025-02-20T19:35:36.047Z,1740080136.047 [transit:NeedComms](DEBUG): Aggregate::uninitialize transit:NeedComms
2025-02-20T19:35:36.047Z,1740080136.047 [transit:NeedComms:B.GoToSurface] Stopped
2025-02-20T19:35:36.047Z,1740080136.047 [transit:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-02-20T19:35:36.448Z,1740080136.448 [transit:Transit:PhoneHome](INFO): Completed transit:Transit:PhoneHome
2025-02-20T19:35:36.448Z,1740080136.448 [transit:Transit:PhoneHome] Stopped
2025-02-20T19:35:36.448Z,1740080136.448 [transit:Transit:PhoneHome](DEBUG): Aggregate::uninitialize transit:Transit:PhoneHome
2025-02-20T19:35:36.449Z,1740080136.449 [transit:Transit](INFO): Completed transit:Transit
2025-02-20T19:35:36.449Z,1740080136.449 [transit:Transit] Stopped
2025-02-20T19:35:36.449Z,1740080136.449 [transit:Transit](DEBUG): Aggregate::uninitialize transit:Transit
2025-02-20T19:35:36.449Z,1740080136.449 [transit:Transit:A.Pitch] Stopped
2025-02-20T19:35:36.449Z,1740080136.449 [transit:Transit:B.SetSpeed] Stopped
2025-02-20T19:35:36.449Z,1740080136.449 [transit:Transit:B.SetSpeed](DEBUG): Uninitialize.
2025-02-20T19:35:36.455Z,1740080136.455 [transit](INFO): Completed transit
2025-02-20T19:35:36.455Z,1740080136.455 [MissionManager](INFO): transit is completed.
2025-02-20T19:35:36.455Z,1740080136.455 [MissionManager](INFO): Uninitializing Mission transit
2025-02-20T19:35:36.456Z,1740080136.456 [transit] Stopped
2025-02-20T19:35:36.456Z,1740080136.456 [transit](DEBUG): Aggregate::uninitialize transit
2025-02-20T19:35:36.456Z,1740080136.456 [transit:StandardEnvelopes] Stopped
2025-02-20T19:35:36.456Z,1740080136.456 [transit:StandardEnvelopes](DEBUG): Aggregate::uninitialize transit:StandardEnvelopes
2025-02-20T19:35:36.456Z,1740080136.456 [transit:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-02-20T19:35:36.456Z,1740080136.456 [transit:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-02-20T19:35:36.456Z,1740080136.456 [transit:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-02-20T19:35:36.456Z,1740080136.456 [transit:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-02-20T19:35:36.456Z,1740080136.456 [transit:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-02-20T19:35:36.456Z,1740080136.456 [transit:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-02-20T19:35:36.456Z,1740080136.456 [transit:BackseatDriver] Stopped
2025-02-20T19:35:36.456Z,1740080136.456 [transit:BackseatDriver](DEBUG): Aggregate::uninitialize transit:BackseatDriver
2025-02-20T19:35:36.457Z,1740080136.457 [transit:BackseatDriver:A.BackseatDriver] Stopped
2025-02-20T19:35:36.457Z,1740080136.457 [transit:PowerOnly] Stopped
2025-02-20T19:35:36.457Z,1740080136.457 [transit:PowerOnly](DEBUG): Aggregate::uninitialize transit:PowerOnly
2025-02-20T19:35:36.457Z,1740080136.457 [transit:PowerOnly:E.Wait] Stopped
2025-02-20T19:35:36.457Z,1740080136.457 [transit:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-02-20T19:35:36.457Z,1740080136.457 [transit:BuoyancyHold.Buoyancy] Stopped
2025-02-20T19:35:36.457Z,1740080136.457 [transit:BuoyancyHold.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-02-20T19:35:36.457Z,1740080136.457 [transit:MassHold.Pitch] Stopped
2025-02-20T19:35:36.816Z,1740080136.816 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch 20.00 deg, mass-position 11.65 mm.
2025-02-20T19:35:36.830Z,1740080136.829 [MissionManager](IMPORTANT): Started mission Default
2025-02-20T19:35:36.830Z,1740080136.830 [Default] Running Loop=1
2025-02-20T19:35:36.830Z,1740080136.830 [Default](DEBUG): Aggregate::initialize Default
2025-02-20T19:35:36.830Z,1740080136.830 [Default:B.GoToSurface] Running Loop=1
2025-02-20T19:35:36.830Z,1740080136.830 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-02-20T19:35:36.830Z,1740080136.830 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-02-20T19:35:36.831Z,1740080136.831 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-02-20T19:35:36.839Z,1740080136.839 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-02-20T19:35:36.840Z,1740080136.840 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-02-20T19:35:36.840Z,1740080136.840 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-02-20T19:35:36.840Z,1740080136.840 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-02-20T19:35:36.841Z,1740080136.841 [Default:A.Wait] Running Loop=1
2025-02-20T19:35:36.841Z,1740080136.841 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-02-20T19:35:50.222Z,1740080150.222 [Default:A.Wait](INFO): Done Waiting.
2025-02-20T19:35:50.222Z,1740080150.222 [Default:A.Wait] Stopped
2025-02-20T19:35:50.222Z,1740080150.222 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-02-20T19:35:50.619Z,1740080150.619 [Default:CheckIn] Running Loop=1
2025-02-20T19:35:50.619Z,1740080150.619 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-02-20T19:35:50.619Z,1740080150.619 [Default:CheckIn:Read_GPS] Running Loop=1
2025-02-20T19:35:58.686Z,1740080158.686 [NAL9602](INFO): SBD MO Status=2, MOMSN=12921, MT Status=2, MTMSN=0
2025-02-20T19:35:58.686Z,1740080158.686 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-02-20T19:36:16.866Z,1740080176.866 [NAL9602](INFO): SBD MO Status=1, MOMSN=12921, MT Status=0, MTMSN=0
2025-02-20T19:36:16.866Z,1740080176.866 [NAL9602](INFO): No messages in MT queue
2025-02-20T19:36:18.077Z,1740080178.077 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193617.00,A,3647.73331,N,12150.72593,W,0.661,134.86,200225,,,A*77
2025-02-20T19:36:18.079Z,1740080178.079 [NAL9602](INFO): GPS fix at 20250220T193617: (36.795555, -121.845432)
2025-02-20T19:36:18.090Z,1740080178.090 [Default:CheckIn:Read_GPS] Stopped
2025-02-20T19:36:18.091Z,1740080178.091 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-02-20T19:36:25.863Z,1740080185.863 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20250220T190352/Courier0006.lzma
2025-02-20T19:36:26.865Z,1740080186.865 [DataOverHttps](INFO): Moved sent file to Logs/20250220T190352/Courier0006.lzma.bak
2025-02-20T19:36:26.865Z,1740080186.865 [DataOverHttps](INFO): SBD MOMSN=23968834
2025-02-20T19:36:50.051Z,1740080210.051 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20250220T190352/Express0007.lzma
2025-02-20T19:36:50.440Z,1740080210.440 [NAL9602](INFO): Not Powering down - fast GPS
2025-02-20T19:36:51.512Z,1740080211.512 [DataOverHttps](INFO): Moved sent file to Logs/20250220T190352/Express0007.lzma.bak
2025-02-20T19:36:51.512Z,1740080211.512 [DataOverHttps](IMPORTANT): SBD MOMSN=23968840, MTMSN=20250220T193650
2025-02-20T19:36:52.899Z,1740080212.899 [Default:CheckIn:Read_Iridium] Stopped
2025-02-20T19:36:52.900Z,1740080212.900 [Default:CheckIn:C.Wait] Running Loop=1
2025-02-20T19:36:52.900Z,1740080212.900 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-02-20T19:37:04.061Z,1740080224.061 [DataOverHttps](INFO): Received command: configset verticalcontrol.kpdepthbuoy 20 ratio persist
2025-02-20T19:37:05.060Z,1740080225.060 [DataOverHttps](IMPORTANT): SBD MTMSN=20250220T193704
2025-02-20T19:37:05.588Z,1740080225.588 [CommandExec](IMPORTANT): got command configSet VerticalControl.kpDepthBuoy 20 ratio persist