2025-02-21T23:27:28.375Z,1740180448.375 [CommandExec](IMPORTANT): got command stop 2025-02-21T23:27:28.375Z,1740180448.375 [CommandExec](IMPORTANT): Scheduling is paused 2025-02-21T23:27:28.375Z,1740180448.375 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2025-02-21T23:27:28.375Z,1740180448.375 [CommandExec](IMPORTANT): got command restart logs 2025-02-21T23:27:28.613Z,1740180448.613 [MissionManager](INFO): MissionManager is completed. 2025-02-21T23:27:28.613Z,1740180448.613 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface 2025-02-21T23:27:28.613Z,1740180448.613 [run_backseat_on_surface] Stopped 2025-02-21T23:27:28.613Z,1740180448.613 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface 2025-02-21T23:27:28.613Z,1740180448.613 [run_backseat_on_surface:Science] Stopped 2025-02-21T23:27:28.613Z,1740180448.613 [run_backseat_on_surface:Science](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science 2025-02-21T23:27:28.613Z,1740180448.613 [run_backseat_on_surface:Science:B] Stopped 2025-02-21T23:27:28.613Z,1740180448.613 [run_backseat_on_surface:Science:C] Stopped 2025-02-21T23:27:28.613Z,1740180448.613 [run_backseat_on_surface:Science:E] Stopped 2025-02-21T23:27:28.613Z,1740180448.613 [run_backseat_on_surface:Science:OceanCurrent] Stopped 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:OceanCurrent 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:Science:OceanCurrent:A.] Stopped 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:BackseatDriver] Stopped 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:PowerOnly] Stopped 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:E.GoToSurface] Stopped 2025-02-21T23:27:28.614Z,1740180448.614 [run_backseat_on_surface:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-21T23:27:28.615Z,1740180448.615 [run_backseat_on_surface:CheckIn] Stopped 2025-02-21T23:27:28.615Z,1740180448.615 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn 2025-02-21T23:27:28.615Z,1740180448.615 [run_backseat_on_surface:CheckIn:C.Wait] Stopped 2025-02-21T23:27:28.615Z,1740180448.615 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-02-21T23:27:28.888Z,1740180448.888 [WetLabsBB2FL](INFO): Powering down 2025-02-21T23:27:29.008Z,1740180449.008 [MissionManager](IMPORTANT): Started mission Default 2025-02-21T23:27:29.008Z,1740180449.008 [Default] Running Loop=1 2025-02-21T23:27:29.008Z,1740180449.008 [Default](DEBUG): Aggregate::initialize Default 2025-02-21T23:27:29.009Z,1740180449.009 [Default:B.GoToSurface] Running Loop=1 2025-02-21T23:27:29.009Z,1740180449.009 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-21T23:27:29.009Z,1740180449.009 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-02-21T23:27:29.009Z,1740180449.009 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-02-21T23:27:29.009Z,1740180449.009 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-02-21T23:27:29.010Z,1740180449.010 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-02-21T23:27:29.010Z,1740180449.010 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-21T23:27:29.010Z,1740180449.010 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-21T23:27:29.015Z,1740180449.015 [Default:A.Wait] Running Loop=1 2025-02-21T23:27:29.016Z,1740180449.016 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-02-21T23:27:29.765Z,1740180449.765 [BackseatComponent](INFO): Sent LCM shutdown request. 2025-02-21T23:27:29.765Z,1740180449.765 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2025-02-21T23:27:40.327Z,1740180460.327 [CommandExec](IMPORTANT): got command schedule resume 2025-02-21T23:27:40.327Z,1740180460.327 [CommandExec](IMPORTANT): Scheduling is resumed 2025-02-21T23:27:42.331Z,1740180462.331 [Default:A.Wait](INFO): Done Waiting. 2025-02-21T23:27:42.331Z,1740180462.331 [Default:A.Wait] Stopped 2025-02-21T23:27:42.332Z,1740180462.332 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-02-21T23:27:42.733Z,1740180462.733 [Default:CheckIn] Running Loop=1 2025-02-21T23:27:42.734Z,1740180462.734 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-21T23:27:42.734Z,1740180462.734 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-21T23:27:44.742Z,1740180464.742 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232744.00,A,3647.54953,N,12150.90587,W,0.641,198.85,210225,,,A*7C 2025-02-21T23:27:44.752Z,1740180464.752 [NAL9602](INFO): GPS fix at 20250221T232744: (36.792492, -121.848431) 2025-02-21T23:27:44.763Z,1740180464.763 [Default:CheckIn:Read_GPS] Stopped 2025-02-21T23:27:44.763Z,1740180464.763 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-21T23:27:47.928Z,1740180467.928 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2025-02-21T23:27:47.928Z,1740180467.928 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2025-02-21T23:27:47.929Z,1740180467.929 [LcmUniversalReporter](INFO): Deactivating messaging. 2025-02-21T23:27:52.447Z,1740180472.447 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250221T223318/Courier0024.lzma 2025-02-21T23:27:53.449Z,1740180473.449 [DataOverHttps](INFO): Moved sent file to Logs/20250221T223318/Courier0024.lzma.bak 2025-02-21T23:27:53.449Z,1740180473.449 [DataOverHttps](INFO): SBD MOMSN=23971492 2025-02-21T23:28:01.717Z,1740180481.717 [NAL9602](INFO): SBD MO Status=1, MOMSN=13090, MT Status=0, MTMSN=0 2025-02-21T23:28:01.717Z,1740180481.717 [NAL9602](INFO): No messages in MT queue 2025-02-21T23:28:13.691Z,1740180493.691 [DataOverHttps](INFO): Sending 267 bytes from file Logs/20250221T232728/Courier0000.lzma 2025-02-21T23:28:14.693Z,1740180494.693 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Courier0000.lzma.bak 2025-02-21T23:28:14.693Z,1740180494.693 [DataOverHttps](INFO): SBD MOMSN=23971494 2025-02-21T23:28:32.452Z,1740180512.452 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-21T23:28:40.464Z,1740180520.464 [DataOverHttps](INFO): Sending 448 bytes from file Logs/20250221T223318/Express0025.lzma 2025-02-21T23:28:41.465Z,1740180521.465 [DataOverHttps](INFO): Moved sent file to Logs/20250221T223318/Express0025.lzma.bak 2025-02-21T23:28:41.465Z,1740180521.465 [DataOverHttps](INFO): SBD MOMSN=23971500 2025-02-21T23:29:09.709Z,1740180549.709 [DataOverHttps](INFO): Sending 352 bytes from file Logs/20250221T232728/Express0001.lzma 2025-02-21T23:29:10.721Z,1740180550.721 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Express0001.lzma.bak 2025-02-21T23:29:10.721Z,1740180550.721 [DataOverHttps](INFO): SBD MOMSN=23971504 2025-02-21T23:29:12.542Z,1740180552.542 [Default:CheckIn:Read_Iridium] Stopped 2025-02-21T23:29:12.543Z,1740180552.543 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-21T23:29:12.547Z,1740180552.547 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-21T23:30:21.329Z,1740180621.329 [DataOverHttps](IMPORTANT): SBD MTMSN=20250221T233020 2025-02-21T23:30:29.031Z,1740180629.031 [DataOverHttps](INFO): Received command: configset list 2025-02-21T23:30:29.107Z,1740180629.107 [CommandExec](IMPORTANT): got command configSet list 2025-02-21T23:30:29.107Z,1740180629.107 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-02-21T23:30:29.126Z,1740180629.126 [CommandExec](IMPORTANT): BioacousticsDataBridge.loadAtStartup=0 bool; 2025-02-21T23:30:29.127Z,1740180629.127 [CommandExec](IMPORTANT): CBIT.runNavErrorCritical=0 bool; 2025-02-21T23:30:29.127Z,1740180629.127 [CommandExec](IMPORTANT): DAT.loadAtStartup=1 bool; 2025-02-21T23:30:29.128Z,1740180629.128 [CommandExec](IMPORTANT): DATMMP.loadAtStartup=0 bool; 2025-02-21T23:30:29.130Z,1740180629.130 [CommandExec](IMPORTANT): DATMMP.simulateHardware=0 bool; 2025-02-21T23:30:29.131Z,1740180629.131 [CommandExec](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2025-02-21T23:30:29.132Z,1740180629.132 [CommandExec](IMPORTANT): ESPComponent.sampleTimeout=5 minute; 2025-02-21T23:30:29.132Z,1740180629.132 [CommandExec](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2025-02-21T23:30:29.133Z,1740180629.133 [CommandExec](IMPORTANT): Express none PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water; 2025-02-21T23:30:29.134Z,1740180629.134 [CommandExec](IMPORTANT): SpeedControl.rollOptimum=0.950000 m/s; 2025-02-21T23:30:29.134Z,1740180629.134 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=305.318315 cubic_centimeter; 2025-02-21T23:30:29.135Z,1740180629.135 [CommandExec](IMPORTANT): VerticalControl.elevDeadband=0.5 degree; 2025-02-21T23:30:29.136Z,1740180629.136 [CommandExec](IMPORTANT): VerticalControl.kdPitchMass=0.1 second; 2025-02-21T23:30:29.137Z,1740180629.137 [CommandExec](IMPORTANT): VerticalControl.kiPitchMass=0.001 reciprocal_second; 2025-02-21T23:30:29.138Z,1740180629.138 [CommandExec](IMPORTANT): VerticalControl.kpDepthBuoy=40 ratio; 2025-02-21T23:30:29.138Z,1740180629.138 [CommandExec](IMPORTANT): VerticalControl.kpPitchMass=0.1 none; 2025-02-21T23:30:29.177Z,1740180629.177 [CommandExec](IMPORTANT): VerticalControl.massDeadband=0 millimeter; 2025-02-21T23:30:29.198Z,1740180629.198 [CommandExec](IMPORTANT): VerticalControl.massDefault=11.647778 millimeter; 2025-02-21T23:30:29.203Z,1740180629.203 [CommandExec](IMPORTANT): VerticalControl.massOnlyForceInt=1 bool; 2025-02-21T23:34:13.100Z,1740180853.100 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-02-21T23:34:13.100Z,1740180853.100 [Default:CheckIn:C.Wait] Stopped 2025-02-21T23:34:13.100Z,1740180853.100 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-02-21T23:34:13.101Z,1740180853.101 [Default:CheckIn:D] Running Loop=1 2025-02-21T23:34:13.505Z,1740180853.505 [Default:CheckIn:D] Stopped 2025-02-21T23:34:13.505Z,1740180853.505 [Default:CheckIn:E] Running Loop=1 2025-02-21T23:34:13.913Z,1740180853.913 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 6.741605 min 2025-02-21T23:34:13.913Z,1740180853.913 [Default:CheckIn:E] Stopped 2025-02-21T23:34:13.914Z,1740180853.914 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-02-21T23:34:13.914Z,1740180853.914 [Default:CheckIn] Stopped 2025-02-21T23:34:13.914Z,1740180853.914 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-02-21T23:34:13.914Z,1740180853.914 [Default:CheckIn](INFO): Running loop #2 2025-02-21T23:34:13.914Z,1740180853.914 [Default:CheckIn] Running Loop=2 2025-02-21T23:34:13.914Z,1740180853.914 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-21T23:34:13.914Z,1740180853.914 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-21T23:34:15.910Z,1740180855.910 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233415.00,A,3647.49183,N,12150.89124,W,0.700,158.33,210225,,,A*73 2025-02-21T23:34:15.912Z,1740180855.912 [NAL9602](INFO): GPS fix at 20250221T233415: (36.791531, -121.848187) 2025-02-21T23:34:15.924Z,1740180855.924 [Default:CheckIn:Read_GPS] Stopped 2025-02-21T23:34:15.924Z,1740180855.924 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-21T23:34:23.999Z,1740180863.999 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250221T232728/Courier0003.lzma 2025-02-21T23:34:25.001Z,1740180865.001 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Courier0003.lzma.bak 2025-02-21T23:34:25.001Z,1740180865.001 [DataOverHttps](INFO): SBD MOMSN=23971514 2025-02-21T23:34:34.914Z,1740180874.914 [NAL9602](INFO): SBD MO Status=2, MOMSN=13091, MT Status=2, MTMSN=0 2025-02-21T23:34:34.914Z,1740180874.914 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-21T23:34:41.784Z,1740180881.784 [DataOverHttps](INFO): Sending 803 bytes from file Logs/20250221T232728/Express0005.lzma 2025-02-21T23:34:42.785Z,1740180882.785 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Express0005.lzma.bak 2025-02-21T23:34:42.785Z,1740180882.785 [DataOverHttps](INFO): SBD MOMSN=23971517 2025-02-21T23:34:55.514Z,1740180895.514 [NAL9602](INFO): SBD MO Status=2, MOMSN=13091, MT Status=2, MTMSN=0 2025-02-21T23:34:55.514Z,1740180895.514 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-21T23:34:59.453Z,1740180899.453 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20250221T232728/Express0010.lzma 2025-02-21T23:35:00.453Z,1740180900.453 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Express0010.lzma.bak 2025-02-21T23:35:00.453Z,1740180900.453 [DataOverHttps](INFO): SBD MOMSN=23971542 2025-02-21T23:35:02.440Z,1740180902.440 [Default:CheckIn:Read_Iridium] Stopped 2025-02-21T23:35:02.441Z,1740180902.441 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-21T23:35:02.441Z,1740180902.441 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-21T23:35:50.521Z,1740180950.521 [NAL9602](INFO): SBD MO Status=2, MOMSN=13091, MT Status=2, MTMSN=0 2025-02-21T23:35:50.521Z,1740180950.521 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-21T23:36:12.746Z,1740180972.746 [NAL9602](INFO): SBD MO Status=1, MOMSN=13091, MT Status=0, MTMSN=0 2025-02-21T23:36:12.746Z,1740180972.746 [NAL9602](INFO): No messages in MT queue 2025-02-21T23:36:43.446Z,1740181003.446 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-21T23:37:14.653Z,1740181034.653 [DataOverHttps](IMPORTANT): SBD MTMSN=20250221T233713 2025-02-21T23:37:22.439Z,1740181042.439 [DataOverHttps](INFO): Received command: sched asap "load Transport/keepstation.tl;set keepstation.MissionTimeout 45 min;set keepstation.NeedCommsTime 60 min;set keepstation.Latitude 36.797 degree;set keepstation.Longitude -121.847 degree;set keepstation.Depth 3 m" 23w9m 1 2 2025-02-21T23:37:22.536Z,1740181042.536 [CommandExec](IMPORTANT): got command schedule asap "load Transport/keepstation.tl;set keepstation.MissionTimeout 45 min;set keepstation.NeedCommsTime 60 min;set keepstation.Latitude 36.797 degree;set keepstation.Longitude -121.847 degree;set keepstation.Depth 3 m" 23w9m 1 2.000000 2025-02-21T23:37:22.536Z,1740181042.536 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=23w9m 2025-02-21T23:37:22.537Z,1740181042.537 [CommandExec](IMPORTANT): Scheduled #49 (#1 of 2 with id='23w9m'): "load Transport/keepstation.tl;set keepstation.MissionTimeout 45 min;set keepstation.NeedCommsTime 60 min;set keepstation.Latitude 36.797 degree;set keepstation.Longitude -121.847 degree;set keepstation.Depth 3 m", ASAP 2025-02-21T23:37:23.441Z,1740181043.441 [DataOverHttps](IMPORTANT): SBD MTMSN=20250221T233722 2025-02-21T23:37:31.143Z,1740181051.143 [DataOverHttps](INFO): Received command: sched asap "set keepstation.DepthDeadband 1 m;set keepstation:BackseatDriver.EnableBackseat 1 bool;run" 23w9m 2 2 2025-02-21T23:37:31.177Z,1740181051.177 [CommandExec](IMPORTANT): got command schedule asap "set keepstation.DepthDeadband 1 m;set keepstation:BackseatDriver.EnableBackseat 1 bool;run" 23w9m 2 2.000000 2025-02-21T23:37:31.178Z,1740181051.178 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=23w9m 2025-02-21T23:37:31.179Z,1740181051.179 [CommandExec](IMPORTANT): Scheduled #50 (#2 of 2 with id='23w9m'): "set keepstation.DepthDeadband 1 m;set keepstation:BackseatDriver.EnableBackseat 1 bool;run", ASAP 2025-02-21T23:37:31.289Z,1740181051.289 [CommandExec](IMPORTANT): got command load ./Missions/Transport/keepstation.tl 2025-02-21T23:37:31.290Z,1740181051.290 [MissionManager](INFO): Loading Mission from file: ./Missions/Transport/keepstation.tl 2025-02-21T23:37:31.290Z,1740181051.290 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Transport/keepstation.tl 2025-02-21T23:37:31.292Z,1740181051.292 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Transport/keepstation.tl 2025-02-21T23:37:32.112Z,1740181052.112 [MissionManager](DEBUG): TethyslAPI: ./Missions/Transport/keepstation.tl translated into: 4 45 NaN NaN 30 15 4 0.75 200 45 2 2025-02-21T23:37:32.117Z,1740181052.117 [MissionManager](INFO): DefineArg keepstation.MissionTimeout = 4.000000 h 2025-02-21T23:37:32.150Z,1740181052.150 [MissionManager](INFO): DefineArg keepstation.NeedCommsTime = 45.000000 min 2025-02-21T23:37:32.158Z,1740181052.158 [MissionManager](INFO): DefineArg keepstation.Latitude = nan arcdeg 2025-02-21T23:37:32.161Z,1740181052.161 [MissionManager](INFO): DefineArg keepstation.Longitude = nan arcdeg 2025-02-21T23:37:32.163Z,1740181052.163 [MissionManager](INFO): DefineArg keepstation.Depth = 30.000000 m 2025-02-21T23:37:32.165Z,1740181052.165 [MissionManager](INFO): DefineArg keepstation.ApproachDepth = 15.000000 m 2025-02-21T23:37:32.167Z,1740181052.167 [MissionManager](INFO): DefineArg keepstation.DepthDeadband = 4.000000 m 2025-02-21T23:37:32.170Z,1740181052.170 [MissionManager](INFO): DefineArg keepstation.Speed = 0.750000 m/s 2025-02-21T23:37:32.200Z,1740181052.200 [MissionManager](INFO): DefineArg keepstation.Radius = 200.000000 m 2025-02-21T23:37:32.202Z,1740181052.202 [MissionManager](INFO): DefineArg keepstation.MaxDepth = 45.000000 m 2025-02-21T23:37:32.205Z,1740181052.205 [MissionManager](INFO): DefineArg keepstation.MinOffshore = 2.000000 km 2025-02-21T23:37:32.206Z,1740181052.206 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl 2025-02-21T23:37:32.206Z,1740181052.206 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl 2025-02-21T23:37:32.235Z,1740181052.235 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl 2025-02-21T23:37:32.558Z,1740181052.558 [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-02-21T23:37:32.562Z,1740181052.562 [MissionManager](INFO): DefineArg keepstation:NeedComms.DiveInterval = 1.000000 h 2025-02-21T23:37:32.565Z,1740181052.565 [MissionManager](INFO): DefineArg keepstation:NeedComms.WaitForPitchUp = 10.000000 min 2025-02-21T23:37:32.567Z,1740181052.567 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacePitch = 20.000000 arcdeg 2025-02-21T23:37:32.569Z,1740181052.569 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceDepthRate = nan m/s 2025-02-21T23:37:32.572Z,1740181052.572 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfaceSpeed = 1.000000 m/s 2025-02-21T23:37:32.574Z,1740181052.574 [MissionManager](INFO): DefineArg keepstation:NeedComms.SurfacingTimeout = 1000.000000 s 2025-02-21T23:37:32.576Z,1740181052.576 [MissionManager](INFO): DefineArg keepstation:NeedComms.GPSTimeout = 7.000000 min 2025-02-21T23:37:32.578Z,1740181052.578 [MissionManager](INFO): DefineArg keepstation:NeedComms.CommsTimeout = 30.000000 min 2025-02-21T23:37:32.584Z,1740181052.584 [keepstation:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-02-21T23:37:32.657Z,1740181052.657 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2025-02-21T23:37:32.657Z,1740181052.657 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2025-02-21T23:37:32.658Z,1740181052.658 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2025-02-21T23:37:32.857Z,1740181052.857 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 0 200 2000 2025-02-21T23:37:32.861Z,1740181052.861 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinAltitude = 5.000000 m 2025-02-21T23:37:32.864Z,1740181052.864 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepthIgnore = 0.000000 m 2025-02-21T23:37:32.866Z,1740181052.866 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MaxDepth = 200.000000 m 2025-02-21T23:37:32.868Z,1740181052.868 [MissionManager](INFO): DefineArg keepstation:StandardEnvelopes.MinOffshore = 2000.000000 m 2025-02-21T23:37:32.869Z,1740181052.869 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2025-02-21T23:37:32.919Z,1740181052.919 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2025-02-21T23:37:32.937Z,1740181052.937 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2025-02-21T23:37:32.952Z,1740181052.952 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2025-02-21T23:37:32.952Z,1740181052.952 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2025-02-21T23:37:32.953Z,1740181052.953 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2025-02-21T23:37:32.992Z,1740181052.992 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2025-02-21T23:37:32.994Z,1740181052.994 [MissionManager](INFO): DefineArg keepstation:BackseatDriver.EnableBackseat = 0 bool 2025-02-21T23:37:32.997Z,1740181052.997 [keepstation:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2025-02-21T23:37:32.000Z,1740181053.000 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2025-02-21T23:37:32.000Z,1740181053.000 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2025-02-21T23:37:33.001Z,1740181053.001 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2025-02-21T23:37:33.148Z,1740181053.148 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2025-02-21T23:37:33.177Z,1740181053.177 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleAll = 0 bool 2025-02-21T23:37:33.178Z,1740181053.178 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad1 = 0 bool 2025-02-21T23:37:33.213Z,1740181053.213 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad2 = 0 bool 2025-02-21T23:37:33.215Z,1740181053.215 [MissionManager](INFO): DefineArg keepstation:PowerOnly.SampleLoad3 = 0 bool 2025-02-21T23:37:33.267Z,1740181053.267 [MissionManager](INFO): DefineArg keepstation:PowerOnly.EnabledPowerOnly = 0 bool 2025-02-21T23:37:33.283Z,1740181053.283 [keepstation:PowerOnly:E.Wait](DEBUG): Construct Wait. 2025-02-21T23:37:33.285Z,1740181053.285 [keepstation:H.Pitch](DEBUG): Construct. 2025-02-21T23:37:33.300Z,1740181053.300 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Construct Buoyancy. 2025-02-21T23:37:33.315Z,1740181053.315 [keepstation:TransitToStation:B.Pitch](DEBUG): Construct. 2025-02-21T23:37:33.324Z,1740181053.324 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Construct. 2025-02-21T23:37:33.330Z,1740181053.330 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Construct Waypoint. 2025-02-21T23:37:33.338Z,1740181053.338 [keepstation:KeepStation:B.Pitch](DEBUG): Construct. 2025-02-21T23:37:33.342Z,1740181053.342 [keepstation:KeepStation:C.KeepStation](DEBUG): Construct KeepStation. 2025-02-21T23:37:33.353Z,1740181053.353 [keepstation:KeepStation:D.Wait](DEBUG): Construct Wait. 2025-02-21T23:37:33.376Z,1740181053.376 [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 keepstation { """ Vehicle transits to desired waypoint (or stays put if none is commanded) and stays within the specified radius. """ arguments { MissionTimeout = 4 hour """ Maximum duration of mission """ NeedCommsTime = 45 minute """ How often to surface for communications """ Latitude = NaN degree """ Latitude of waypoint to hold. If NaN, hold the latitude at start of mission. """ Longitude = NaN degree """ Longitude of waypoint to hold. If NaN, hold the longitude at start of mission. """ Depth = 30 meter """ Depth held during drift mode """ ApproachDepth = 15 meter """ Depth for initial approach to station. """ DepthDeadband = 4 meter """ How much vertical drift from the specified depth is allowed in drift mode """ Speed = 0.75 meter_per_second """ Vehicle transit speed. """ Radius = 200 meter """ Radius of circle around waypoint to hold. """ MaxDepth = 45 meter """ Maximum allowable depth during the mission. """ MinOffshore = 2 kilometer """ Minimum distance from the shoreline to maintain """ } timeout duration=MissionTimeout insert id="NeedComms" Insert/NeedComms.tl assign in sequence NeedComms:DiveInterval = NeedCommsTime insert Insert/StandardEnvelopes.tl assign in sequence StandardEnvelopes:MaxDepth = MaxDepth assign in sequence StandardEnvelopes:MinOffshore = MinOffshore insert Insert/BackseatDriver.tl insert Insert/PowerOnly.tl behavior Guidance:Pitch { run in parallel set massPosition = Control:VerticalControl.massDefault } call id="StartingMission" refId="NeedComms" aggregate TransitToStation { """ Need a separate aggregate for transit if we want to specify a different depth for the approach. """ run in sequence behavior Guidance:Buoyancy { run in parallel set position = Control:VerticalControl.buoyancyNeutral } behavior Guidance:Pitch { run in parallel set depth = ApproachDepth } behavior Guidance:SetSpeed { run in parallel set speed = Speed } behavior Guidance:Waypoint id="Wpt1" { run in sequence set latitude = Latitude set longitude = Longitude } } call id="OnStation" refId="NeedComms" aggregate KeepStation { run in sequence assign in parallel Control:VerticalControl.depthDeadband = DepthDeadband behavior Guidance:Pitch { run in parallel set depth = Depth } behavior Guidance:KeepStation { run in parallel set latitude = Latitude set longitude = Longitude set radius = Radius set speed = Speed } behavior Guidance:Wait { """ Due to the way the KeepStation behavior is currently implemented, we must run it in parallel and use a Wait to keep from completing the mission before the timeout expires. However, this new version of the mission uses a top-level timeout so that the entire mission will not run for longer then MissionTimeout. """ run in sequence set duration = MissionTimeout } } } 2025-02-21T23:37:33.377Z,1740181053.377 [CommandExec](IMPORTANT): Loaded ./Missions/Transport/keepstation.tl id=keepstation 2025-02-21T23:38:02.604Z,1740181082.604 [CommandExec](IMPORTANT): got command set keepstation.MissionTimeout 45 minute 2025-02-21T23:38:02.605Z,1740181082.605 [CommandExec](IMPORTANT): got command set keepstation.NeedCommsTime 60 minute 2025-02-21T23:38:02.606Z,1740181082.606 [CommandExec](IMPORTANT): got command set keepstation.Latitude 36.797 degree 2025-02-21T23:38:02.606Z,1740181082.606 [CommandExec](IMPORTANT): got command set keepstation.Longitude -121.847 degree 2025-02-21T23:38:02.607Z,1740181082.607 [CommandExec](IMPORTANT): got command set keepstation.Depth 3 meter 2025-02-21T23:38:18.820Z,1740181098.820 [CommandExec](IMPORTANT): got command set keepstation.DepthDeadband 1 meter 2025-02-21T23:38:18.821Z,1740181098.821 [CommandExec](IMPORTANT): got command set keepstation:BackseatDriver.EnableBackseat 1 bool 2025-02-21T23:38:18.822Z,1740181098.822 [CommandExec](IMPORTANT): got command run 2025-02-21T23:38:18.848Z,1740181098.848 [CommandExec](IMPORTANT): Running 2025-02-21T23:38:18.915Z,1740181098.915 [Default] Stopped 2025-02-21T23:38:18.915Z,1740181098.915 [Default](DEBUG): Aggregate::uninitialize Default 2025-02-21T23:38:18.915Z,1740181098.915 [Default:B.GoToSurface] Stopped 2025-02-21T23:38:18.915Z,1740181098.915 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-21T23:38:18.916Z,1740181098.916 [Default:CheckIn] Stopped 2025-02-21T23:38:18.916Z,1740181098.916 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-02-21T23:38:18.916Z,1740181098.916 [Default:CheckIn:C.Wait] Stopped 2025-02-21T23:38:18.916Z,1740181098.916 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-02-21T23:38:18.916Z,1740181098.916 [MissionManager](IMPORTANT): Started mission keepstation 2025-02-21T23:38:18.916Z,1740181098.916 [keepstation] Running Loop=1 2025-02-21T23:38:18.916Z,1740181098.916 [keepstation](DEBUG): Aggregate::initialize keepstation 2025-02-21T23:38:18.916Z,1740181098.916 [keepstation:StandardEnvelopes] Running Loop=1 2025-02-21T23:38:18.917Z,1740181098.917 [keepstation:StandardEnvelopes](DEBUG): Aggregate::initialize keepstation:StandardEnvelopes 2025-02-21T23:38:18.917Z,1740181098.917 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-02-21T23:38:18.917Z,1740181098.917 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2025-02-21T23:38:18.917Z,1740181098.917 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-02-21T23:38:18.917Z,1740181098.917 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2025-02-21T23:38:18.917Z,1740181098.917 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-02-21T23:38:18.917Z,1740181098.917 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2025-02-21T23:38:18.917Z,1740181098.917 [keepstation:BackseatDriver] Running Loop=1 2025-02-21T23:38:18.917Z,1740181098.917 [keepstation:BackseatDriver](DEBUG): Aggregate::initialize keepstation:BackseatDriver 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:BackseatDriver:A.BackseatDriver] Running Loop=1 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:PowerOnly] Running Loop=1 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:PowerOnly](DEBUG): Aggregate::initialize keepstation:PowerOnly 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:PowerOnly:A] Running Loop=1 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:PowerOnly:B] Running Loop=1 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:PowerOnly:C] Running Loop=1 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:PowerOnly:D] Running Loop=1 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:PowerOnly:E.Wait] Running Loop=1 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:H.Pitch] Running Loop=1 2025-02-21T23:38:18.918Z,1740181098.918 [keepstation:H.Pitch](DEBUG): Initialize. 2025-02-21T23:38:18.919Z,1740181098.919 [keepstation:B] Running Loop=1 2025-02-21T23:38:18.919Z,1740181098.919 [keepstation:H.Pitch] Running Loop=1 2025-02-21T23:38:18.920Z,1740181098.920 [keepstation:PowerOnly] Running Loop=1 2025-02-21T23:38:18.920Z,1740181098.920 [keepstation:PowerOnly:D] Stopped 2025-02-21T23:38:18.920Z,1740181098.920 [keepstation:PowerOnly:C] Stopped 2025-02-21T23:38:18.920Z,1740181098.920 [keepstation:PowerOnly:B] Stopped 2025-02-21T23:38:18.920Z,1740181098.920 [keepstation:PowerOnly:A] Stopped 2025-02-21T23:38:18.920Z,1740181098.920 [keepstation:BackseatDriver] Running Loop=1 2025-02-21T23:38:18.921Z,1740181098.921 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat 2025-02-21T23:38:18.938Z,1740181098.938 [keepstation:StandardEnvelopes] Running Loop=1 2025-02-21T23:38:18.938Z,1740181098.938 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-02-21T23:38:18.939Z,1740181098.939 [keepstation:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-02-21T23:38:18.939Z,1740181098.939 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-02-21T23:38:18.940Z,1740181098.940 [keepstation:B] Stopped 2025-02-21T23:38:18.940Z,1740181098.940 [keepstation:D] Running Loop=1 2025-02-21T23:38:18.994Z,1740181098.994 [BackseatComponent](INFO): Powering up 2025-02-21T23:38:18.994Z,1740181098.994 [BackseatComponent](INFO): Subscribing to LCM channels. 2025-02-21T23:38:19.263Z,1740181099.263 [keepstation:D] Stopped 2025-02-21T23:38:19.264Z,1740181099.264 [keepstation:E] Running Loop=1 2025-02-21T23:38:19.667Z,1740181099.667 [keepstation:E] Stopped 2025-02-21T23:38:19.667Z,1740181099.667 [keepstation:StartingMission] Running Loop=1 2025-02-21T23:38:19.668Z,1740181099.668 [keepstation:StartingMission](DEBUG): Aggregate::initialize keepstation:StartingMission 2025-02-21T23:38:20.072Z,1740181100.072 [keepstation:NeedComms] Running Loop=1 2025-02-21T23:38:20.072Z,1740181100.072 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2025-02-21T23:38:20.072Z,1740181100.072 [keepstation:NeedComms:B.GoToSurface] Running Loop=1 2025-02-21T23:38:20.072Z,1740181100.072 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-21T23:38:20.073Z,1740181100.073 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2025-02-21T23:38:20.073Z,1740181100.073 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2025-02-21T23:38:20.073Z,1740181100.073 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2025-02-21T23:38:20.074Z,1740181100.074 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2025-02-21T23:38:20.074Z,1740181100.074 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-21T23:38:20.074Z,1740181100.074 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-21T23:38:20.075Z,1740181100.075 [keepstation:NeedComms:A] Running Loop=1 2025-02-21T23:38:20.076Z,1740181100.076 [keepstation:NeedComms:A](INFO): last time_fix was: 1740180855.000000 second since 1970/01/01T00:00:00Z 2025-02-21T23:38:20.076Z,1740181100.076 [keepstation:NeedComms:A] Stopped 2025-02-21T23:38:20.468Z,1740181100.468 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active. 2025-02-21T23:38:20.469Z,1740181100.469 [keepstation:NeedComms:C] Running Loop=1 2025-02-21T23:38:20.876Z,1740181100.876 [keepstation:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-02-21T23:38:22.478Z,1740181102.478 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233821.00,A,3647.45367,N,12150.88069,W,0.136,141.16,210225,,,A*79 2025-02-21T23:38:22.480Z,1740181102.480 [NAL9602](INFO): GPS fix at 20250221T233821: (36.790895, -121.848011) 2025-02-21T23:38:22.527Z,1740181102.527 [keepstation:NeedComms:C] Stopped 2025-02-21T23:38:22.527Z,1740181102.527 [keepstation:NeedComms:D] Running Loop=1 2025-02-21T23:38:22.925Z,1740181102.925 [keepstation:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-02-21T23:38:30.219Z,1740181110.219 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250221T232728/Courier0012.lzma 2025-02-21T23:38:31.221Z,1740181111.221 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Courier0012.lzma.bak 2025-02-21T23:38:31.221Z,1740181111.221 [DataOverHttps](INFO): SBD MOMSN=23971549 2025-02-21T23:38:31.797Z,1740181111.797 [NAL9602](INFO): SBD MO Status=1, MOMSN=13092, MT Status=0, MTMSN=0 2025-02-21T23:38:31.797Z,1740181111.797 [NAL9602](INFO): No messages in MT queue 2025-02-21T23:38:48.248Z,1740181128.248 [DataOverHttps](INFO): Sending 553 bytes from file Logs/20250221T232728/Express0013.lzma 2025-02-21T23:38:49.253Z,1740181129.253 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Express0013.lzma.bak 2025-02-21T23:38:49.253Z,1740181129.253 [DataOverHttps](INFO): SBD MOMSN=23971554 2025-02-21T23:38:50.812Z,1740181130.812 [keepstation:NeedComms:D] Stopped 2025-02-21T23:38:50.812Z,1740181130.812 [keepstation:NeedComms:E] Running Loop=1 2025-02-21T23:38:51.205Z,1740181131.205 [keepstation:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-02-21T23:38:52.810Z,1740181132.810 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,233852.00,A,3647.44876,N,12150.88033,W,1.205,193.65,210225,,,A*71 2025-02-21T23:38:52.812Z,1740181132.812 [NAL9602](INFO): GPS fix at 20250221T233852: (36.790813, -121.848005) 2025-02-21T23:38:52.872Z,1740181132.872 [keepstation:NeedComms:E] Stopped 2025-02-21T23:38:52.873Z,1740181132.873 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2025-02-21T23:38:52.873Z,1740181132.873 [keepstation:NeedComms] Stopped 2025-02-21T23:38:52.874Z,1740181132.874 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2025-02-21T23:38:52.874Z,1740181132.874 [keepstation:NeedComms:B.GoToSurface] Stopped 2025-02-21T23:38:52.874Z,1740181132.874 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-21T23:38:53.261Z,1740181133.261 [keepstation:StartingMission](INFO): Completed keepstation:StartingMission 2025-02-21T23:38:53.261Z,1740181133.261 [keepstation:StartingMission] Stopped 2025-02-21T23:38:53.261Z,1740181133.261 [keepstation:StartingMission](DEBUG): Aggregate::uninitialize keepstation:StartingMission 2025-02-21T23:38:53.261Z,1740181133.261 [keepstation:TransitToStation] Running Loop=1 2025-02-21T23:38:53.261Z,1740181133.261 [keepstation:TransitToStation](DEBUG): Aggregate::initialize keepstation:TransitToStation 2025-02-21T23:38:53.261Z,1740181133.261 [keepstation:TransitToStation:A.Buoyancy] Running Loop=1 2025-02-21T23:38:53.261Z,1740181133.261 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Initialize Buoyancy Component. 2025-02-21T23:38:53.262Z,1740181133.262 [keepstation:TransitToStation:B.Pitch] Running Loop=1 2025-02-21T23:38:53.262Z,1740181133.262 [keepstation:TransitToStation:B.Pitch](DEBUG): Initialize. 2025-02-21T23:38:53.262Z,1740181133.262 [keepstation:TransitToStation:C.SetSpeed] Running Loop=1 2025-02-21T23:38:53.262Z,1740181133.262 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Initialize. 2025-02-21T23:38:53.262Z,1740181133.262 [keepstation:TransitToStation:Wpt1.Waypoint] Running Loop=1 2025-02-21T23:38:53.262Z,1740181133.262 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Initialize WaypointComponent. 2025-02-21T23:38:53.267Z,1740181133.267 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Navigating to waypoint: 36.797001,-121.847000 2025-02-21T23:38:53.651Z,1740181133.651 [keepstation:TransitToStation:Wpt1.Waypoint](INFO): Navigating to waypoint: 36.797001,-121.847000 2025-02-21T23:38:53.655Z,1740181133.655 [keepstation:TransitToStation:C.SetSpeed] Running Loop=1 2025-02-21T23:38:53.656Z,1740181133.656 [keepstation:TransitToStation:B.Pitch] Running Loop=1 2025-02-21T23:38:53.656Z,1740181133.656 [keepstation:TransitToStation:A.Buoyancy] Running Loop=1 2025-02-21T23:39:25.500Z,1740181165.500 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-21T23:39:29.830Z,1740181169.830 [BackseatComponent](IMPORTANT): IBASE811F-02: Running bioacoustics backseat app. Logging to: 20250221T233928 2025-02-21T23:40:14.184Z,1740181214.184 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.75 m/s, pitch 30.00 deg, mass-position 11.65 mm (2 active estimators). 2025-02-21T23:40:29.873Z,1740181229.873 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.height_above_sea_floor with code: 1975 2025-02-21T23:40:51.791Z,1740181251.791 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T23:41:14.783Z,1740181274.783 [Radio_Surface](INFO): Powering down 2025-02-21T23:41:22.928Z,1740181282.928 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T23:41:23.931Z,1740181283.931 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-02-21T23:43:00.329Z,1740181380.329 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.751724 2025-02-21T23:44:30.842Z,1740181470.842 [keepstation:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.simrad_data_logging_rate with code: 1976 2025-02-21T23:50:45.694Z,1740181845.694 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T23:50:59.438Z,1740181859.438 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T23:51:12.666Z,1740181872.666 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T23:51:25.138Z,1740181885.138 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T23:51:37.662Z,1740181897.662 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T23:51:51.354Z,1740181911.354 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T23:52:04.406Z,1740181924.406 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-02-21T23:55:07.207Z,1740182107.207 [keepstation:TransitToStation:Wpt1.Waypoint](IMPORTANT): Reached waypoint: 36.797001,-121.847000 2025-02-21T23:55:07.207Z,1740182107.207 [keepstation:TransitToStation:Wpt1.Waypoint] Stopped 2025-02-21T23:55:07.207Z,1740182107.207 [keepstation:TransitToStation:Wpt1.Waypoint](DEBUG): Uninitialize WaypointComponent. 2025-02-21T23:55:07.224Z,1740182107.224 [keepstation:TransitToStation](INFO): Completed keepstation:TransitToStation 2025-02-21T23:55:07.225Z,1740182107.225 [keepstation:TransitToStation] Stopped 2025-02-21T23:55:07.225Z,1740182107.225 [keepstation:TransitToStation](DEBUG): Aggregate::uninitialize keepstation:TransitToStation 2025-02-21T23:55:07.225Z,1740182107.225 [keepstation:TransitToStation:A.Buoyancy] Stopped 2025-02-21T23:55:07.225Z,1740182107.225 [keepstation:TransitToStation:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2025-02-21T23:55:07.225Z,1740182107.225 [keepstation:TransitToStation:B.Pitch] Stopped 2025-02-21T23:55:07.225Z,1740182107.225 [keepstation:TransitToStation:C.SetSpeed] Stopped 2025-02-21T23:55:07.225Z,1740182107.225 [keepstation:TransitToStation:C.SetSpeed](DEBUG): Uninitialize. 2025-02-21T23:55:07.225Z,1740182107.225 [keepstation:OnStation] Running Loop=1 2025-02-21T23:55:07.225Z,1740182107.225 [keepstation:OnStation](DEBUG): Aggregate::initialize keepstation:OnStation 2025-02-21T23:55:07.616Z,1740182107.616 [keepstation:NeedComms] Running Loop=1 2025-02-21T23:55:07.616Z,1740182107.616 [keepstation:NeedComms](DEBUG): Aggregate::initialize keepstation:NeedComms 2025-02-21T23:55:07.617Z,1740182107.617 [keepstation:NeedComms:B.GoToSurface] Running Loop=1 2025-02-21T23:55:07.617Z,1740182107.617 [keepstation:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-21T23:55:07.617Z,1740182107.617 [keepstation:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2025-02-21T23:55:07.617Z,1740182107.617 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2025-02-21T23:55:07.618Z,1740182107.618 [keepstation:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2025-02-21T23:55:07.618Z,1740182107.618 [keepstation:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2025-02-21T23:55:07.618Z,1740182107.618 [keepstation:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-21T23:55:07.619Z,1740182107.619 [keepstation:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-21T23:55:07.619Z,1740182107.619 [keepstation:NeedComms:A] Running Loop=1 2025-02-21T23:55:07.621Z,1740182107.621 [keepstation:NeedComms:A](INFO): last time_fix was: 1740181132.000000 second since 1970/01/01T00:00:00Z 2025-02-21T23:55:07.621Z,1740182107.621 [keepstation:NeedComms:A] Stopped 2025-02-21T23:56:01.181Z,1740182161.181 [keepstation:NeedComms:C] Running Loop=1 2025-02-21T23:56:01.847Z,1740182161.847 [Radio_Surface](INFO): Powering up 2025-02-21T23:56:07.575Z,1740182167.575 [DataOverHttps](INFO): Radio surface powered ON. 2025-02-21T23:56:37.699Z,1740182197.699 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T23:57:05.151Z,1740182225.151 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2025-02-21T23:57:08.825Z,1740182228.825 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T23:57:12.034Z,1740182232.034 [BPC1](ERROR): Battery stick #62 (s/n: 00CC) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x4AD0. 2025-02-21T23:57:12.035Z,1740182232.035 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 6. 2025-02-21T23:57:12.038Z,1740182232.038 [BPC1](INFO): Received data from all battery sticks. 2025-02-21T23:57:31.419Z,1740182251.419 [NAL9602](INFO): SBD MO Status=1, MOMSN=13093, MT Status=0, MTMSN=0 2025-02-21T23:57:31.419Z,1740182251.419 [NAL9602](INFO): No messages in MT queue 2025-02-21T23:57:32.626Z,1740182252.626 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235731.00,A,3647.71037,N,12150.85897,W,0.330,112.86,210225,,,A*7F 2025-02-21T23:57:32.628Z,1740182252.628 [NAL9602](INFO): GPS fix at 20250221T235731: (36.795173, -121.847650) 2025-02-21T23:57:32.641Z,1740182252.641 [UniversalFixResidualReporter](INFO): Fix residual: 35.4 %DT, over the last 779.8 m. Residual distance 275.7 m at bearing 19.4 degrees. Fix at (36.7952, -121.8476) with 485.9 m made good. 2025-02-21T23:57:32.644Z,1740182252.644 [keepstation:NeedComms:C] Stopped 2025-02-21T23:57:32.645Z,1740182252.645 [keepstation:NeedComms:D] Running Loop=1 2025-02-21T23:57:39.947Z,1740182259.947 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T23:58:04.794Z,1740182284.794 [NAL9602](INFO): SBD MO Status=2, MOMSN=13094, MT Status=2, MTMSN=0 2025-02-21T23:58:04.794Z,1740182284.794 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-02-21T23:58:11.075Z,1740182291.075 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-21T23:58:20.064Z,1740182300.064 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003126 2025-02-21T23:58:27.935Z,1740182307.935 [DataOverHttps](INFO): Sending 265 bytes from file Logs/20250221T232728/Courier0015.lzma 2025-02-21T23:58:28.937Z,1740182308.937 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Courier0015.lzma.bak 2025-02-21T23:58:28.937Z,1740182308.937 [DataOverHttps](INFO): SBD MOMSN=23971578 2025-02-21T23:58:33.710Z,1740182313.710 [NAL9602](INFO): SBD MO Status=1, MOMSN=13094, MT Status=0, MTMSN=0 2025-02-21T23:58:33.759Z,1740182313.759 [NAL9602](INFO): Sent 265 bytes from file Logs/20250221T232728/Courier0015.lzma 2025-02-21T23:58:33.760Z,1740182313.760 [NAL9602](INFO): Packets left to send: 0 2025-02-21T23:58:45.551Z,1740182325.551 [DataOverHttps](INFO): Sending 335 bytes from file Logs/20250221T232728/Express0017.lzma 2025-02-21T23:58:46.553Z,1740182326.553 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Express0017.lzma.bak 2025-02-21T23:58:46.553Z,1740182326.553 [DataOverHttps](INFO): SBD MOMSN=23971581 2025-02-21T23:58:48.280Z,1740182328.280 [keepstation:NeedComms:D] Stopped 2025-02-21T23:58:48.280Z,1740182328.280 [keepstation:NeedComms:E] Running Loop=1 2025-02-21T23:58:50.279Z,1740182330.279 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,235849.00,A,3647.70078,N,12150.85702,W,0.603,187.83,210225,,,A*7A 2025-02-21T23:58:50.281Z,1740182330.281 [NAL9602](INFO): GPS fix at 20250221T235849: (36.795013, -121.847617) 2025-02-21T23:58:50.328Z,1740182330.328 [keepstation:NeedComms:E] Stopped 2025-02-21T23:58:50.329Z,1740182330.329 [keepstation:NeedComms](INFO): Completed keepstation:NeedComms 2025-02-21T23:58:50.329Z,1740182330.329 [keepstation:NeedComms] Stopped 2025-02-21T23:58:50.329Z,1740182330.329 [keepstation:NeedComms](DEBUG): Aggregate::uninitialize keepstation:NeedComms 2025-02-21T23:58:50.329Z,1740182330.329 [keepstation:NeedComms:B.GoToSurface] Stopped 2025-02-21T23:58:50.329Z,1740182330.329 [keepstation:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-02-21T23:58:50.704Z,1740182330.704 [keepstation:OnStation](INFO): Completed keepstation:OnStation 2025-02-21T23:58:50.704Z,1740182330.704 [keepstation:OnStation] Stopped 2025-02-21T23:58:50.704Z,1740182330.704 [keepstation:OnStation](DEBUG): Aggregate::uninitialize keepstation:OnStation 2025-02-21T23:58:50.704Z,1740182330.704 [keepstation:KeepStation] Running Loop=1 2025-02-21T23:58:50.704Z,1740182330.704 [keepstation:KeepStation](DEBUG): Aggregate::initialize keepstation:KeepStation 2025-02-21T23:58:50.704Z,1740182330.704 [keepstation:KeepStation:A] Running Loop=1 2025-02-21T23:58:50.704Z,1740182330.704 [keepstation:KeepStation:B.Pitch] Running Loop=1 2025-02-21T23:58:50.705Z,1740182330.705 [keepstation:KeepStation:B.Pitch](DEBUG): Initialize. 2025-02-21T23:58:50.705Z,1740182330.705 [keepstation:KeepStation:C.KeepStation] Running Loop=1 2025-02-21T23:58:50.705Z,1740182330.705 [keepstation:KeepStation:C.KeepStation](DEBUG): Initialize KeepStationComponent. 2025-02-21T23:58:50.705Z,1740182330.705 [keepstation:KeepStation:D.Wait] Running Loop=1 2025-02-21T23:58:50.705Z,1740182330.705 [keepstation:KeepStation:D.Wait](DEBUG): Initialize Wait Component. 2025-02-21T23:58:51.113Z,1740182331.113 [keepstation:KeepStation:C.KeepStation] Running Loop=1 2025-02-21T23:58:51.114Z,1740182331.114 [keepstation:KeepStation:C.KeepStation](INFO): Rest->Waypoint 2025-02-21T23:58:51.115Z,1740182331.115 [keepstation:KeepStation:B.Pitch] Running Loop=1 2025-02-21T23:58:51.120Z,1740182331.120 [keepstation:KeepStation:A] Running Loop=1 2025-02-21T23:59:22.573Z,1740182362.573 [NAL9602](INFO): Not Powering down - fast GPS 2025-02-21T23:59:39.820Z,1740182379.820 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 0.75 m/s, pitch 20.00 deg, mass-position 11.65 mm (3 active estimators). 2025-02-21T23:59:49.120Z,1740182389.120 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2025-02-22T00:00:20.243Z,1740182420.243 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T00:00:40.391Z,1740182440.391 [Radio_Surface](INFO): Powering down 2025-02-22T00:00:51.379Z,1740182451.379 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T00:00:52.384Z,1740182452.384 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2025-02-22T00:01:56.641Z,1740182516.641 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.920334 2025-02-22T00:07:45.342Z,1740182865.342 [keepstation:KeepStation:C.KeepStation](INFO): Waypoint->Rest 2025-02-22T00:15:01.359Z,1740183301.359 [Radio_Surface](INFO): Powering up 2025-02-22T00:15:06.937Z,1740183306.937 [DataOverHttps](INFO): Radio surface powered ON. 2025-02-22T00:15:37.059Z,1740183337.059 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T00:16:08.195Z,1740183368.195 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T00:16:39.327Z,1740183399.327 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T00:17:10.472Z,1740183430.472 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T00:17:25.440Z,1740183445.440 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003114 2025-02-22T00:21:16.015Z,1740183676.015 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-02-22T00:23:18.978Z,1740183798.978 [keepstation](INFO): Timed out from 2025-02-21T23:38:18.9Z 2025-02-22T00:23:18.978Z,1740183798.978 [MissionManager](INFO): keepstation is completed. 2025-02-22T00:23:18.979Z,1740183798.979 [MissionManager](INFO): Uninitializing Mission keepstation 2025-02-22T00:23:18.979Z,1740183798.979 [keepstation] Stopped 2025-02-22T00:23:18.979Z,1740183798.979 [keepstation](DEBUG): Aggregate::uninitialize keepstation 2025-02-22T00:23:18.979Z,1740183798.979 [keepstation:StandardEnvelopes] Stopped 2025-02-22T00:23:18.979Z,1740183798.979 [keepstation:StandardEnvelopes](DEBUG): Aggregate::uninitialize keepstation:StandardEnvelopes 2025-02-22T00:23:18.979Z,1740183798.979 [keepstation:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2025-02-22T00:23:18.979Z,1740183798.979 [keepstation:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2025-02-22T00:23:18.979Z,1740183798.979 [keepstation:StandardEnvelopes:B.DepthEnvelope] Stopped 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:BackseatDriver] Stopped 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:BackseatDriver](DEBUG): Aggregate::uninitialize keepstation:BackseatDriver 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:BackseatDriver:A.BackseatDriver] Stopped 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:PowerOnly] Stopped 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:PowerOnly](DEBUG): Aggregate::uninitialize keepstation:PowerOnly 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:PowerOnly:E.Wait] Stopped 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:H.Pitch] Stopped 2025-02-22T00:23:18.980Z,1740183798.980 [keepstation:KeepStation] Stopped 2025-02-22T00:23:18.981Z,1740183798.981 [keepstation:KeepStation](DEBUG): Aggregate::uninitialize keepstation:KeepStation 2025-02-22T00:23:18.981Z,1740183798.981 [keepstation:KeepStation:A] Stopped 2025-02-22T00:23:18.981Z,1740183798.981 [keepstation:KeepStation:B.Pitch] Stopped 2025-02-22T00:23:18.981Z,1740183798.981 [keepstation:KeepStation:C.KeepStation] Stopped 2025-02-22T00:23:18.981Z,1740183798.981 [keepstation:KeepStation:C.KeepStation](DEBUG): Uninitialize KeepStationComponent. 2025-02-22T00:23:18.981Z,1740183798.981 [keepstation:KeepStation:D.Wait] Stopped 2025-02-22T00:23:18.981Z,1740183798.981 [keepstation:KeepStation:D.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T00:23:19.388Z,1740183799.388 [MissionManager](IMPORTANT): Started mission Default 2025-02-22T00:23:19.388Z,1740183799.388 [Default] Running Loop=1 2025-02-22T00:23:19.388Z,1740183799.388 [Default](DEBUG): Aggregate::initialize Default 2025-02-22T00:23:19.388Z,1740183799.388 [Default:B.GoToSurface] Running Loop=1 2025-02-22T00:23:19.388Z,1740183799.388 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-02-22T00:23:19.389Z,1740183799.389 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-02-22T00:23:19.389Z,1740183799.389 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-02-22T00:23:19.389Z,1740183799.389 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-02-22T00:23:19.390Z,1740183799.390 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-02-22T00:23:19.390Z,1740183799.390 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-02-22T00:23:19.390Z,1740183799.390 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-02-22T00:23:19.391Z,1740183799.391 [Default:A.Wait] Running Loop=1 2025-02-22T00:23:19.391Z,1740183799.391 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-02-22T00:23:20.040Z,1740183800.040 [BackseatComponent](INFO): Sent LCM shutdown request. 2025-02-22T00:23:20.041Z,1740183800.041 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.). 2025-02-22T00:23:32.743Z,1740183812.743 [Default:A.Wait](INFO): Done Waiting. 2025-02-22T00:23:32.759Z,1740183812.759 [Default:A.Wait] Stopped 2025-02-22T00:23:32.759Z,1740183812.759 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-02-22T00:23:33.157Z,1740183813.157 [Default:CheckIn] Running Loop=1 2025-02-22T00:23:33.157Z,1740183813.157 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-02-22T00:23:33.157Z,1740183813.157 [Default:CheckIn:Read_GPS] Running Loop=1 2025-02-22T00:23:35.159Z,1740183815.159 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,002334.00,A,3647.68189,N,12150.81669,W,1.438,213.13,220225,,,A*7C 2025-02-22T00:23:35.161Z,1740183815.161 [NAL9602](INFO): GPS fix at 20250222T002334: (36.794698, -121.846945) 2025-02-22T00:23:35.198Z,1740183815.198 [Default:CheckIn:Read_GPS] Stopped 2025-02-22T00:23:35.198Z,1740183815.198 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-02-22T00:23:38.208Z,1740183818.208 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec). 2025-02-22T00:23:38.208Z,1740183818.208 [BackseatComponent](INFO): Unsubscribing from LCM channels. 2025-02-22T00:23:38.208Z,1740183818.208 [LcmUniversalReporter](INFO): Deactivating messaging. 2025-02-22T00:23:43.295Z,1740183823.295 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250221T232728/Courier0021.lzma 2025-02-22T00:23:44.297Z,1740183824.297 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Courier0021.lzma.bak 2025-02-22T00:23:44.297Z,1740183824.297 [DataOverHttps](INFO): SBD MOMSN=23971588 2025-02-22T00:23:54.631Z,1740183834.631 [NAL9602](INFO): SBD MO Status=0, MOMSN=13095, MT Status=0, MTMSN=0 2025-02-22T00:23:54.631Z,1740183834.631 [NAL9602](INFO): No messages in MT queue 2025-02-22T00:24:01.007Z,1740183841.007 [DataOverHttps](INFO): Sending 137 bytes from file Logs/20250221T232728/Express0022.lzma 2025-02-22T00:24:02.010Z,1740183842.010 [DataOverHttps](INFO): Moved sent file to Logs/20250221T232728/Express0022.lzma.bak 2025-02-22T00:24:02.010Z,1740183842.010 [DataOverHttps](IMPORTANT): SBD MOMSN=23971592, MTMSN=20250222T002401 2025-02-22T00:24:03.536Z,1740183843.536 [Default:CheckIn:Read_Iridium] Stopped 2025-02-22T00:24:03.536Z,1740183843.536 [Default:CheckIn:C.Wait] Running Loop=1 2025-02-22T00:24:03.536Z,1740183843.536 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-02-22T00:24:09.891Z,1740183849.891 [DataOverHttps](INFO): Received command: restart logs