2019-08-17T08:41:54.668Z,1566031314.668 [CommandLine](IMPORTANT): got command restart logs
2019-08-17T08:42:07.267Z,1566031327.267 [DataOverHttps](INFO): Sending 1932 bytes from file Logs/20190817T080214/Express0016.lzma
2019-08-17T08:42:08.474Z,1566031328.474 [DataOverHttps](INFO): Moved sent file to Logs/20190817T080214/Express0016.lzma.bak
2019-08-17T08:42:08.474Z,1566031328.474 [DataOverHttps](INFO): SBD MOMSN=11585117
2019-08-17T08:42:12.271Z,1566031332.271 [NAL9602](INFO): SBD MO Status=1, MOMSN=31361, MT Status=0, MTMSN=0
2019-08-17T08:42:12.271Z,1566031332.271 [NAL9602](INFO): No messages in MT queue
2019-08-17T08:42:20.304Z,1566031340.304 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190817T080214/Courier0018.lzma
2019-08-17T08:42:21.111Z,1566031341.111 [DataOverHttps](INFO): Moved sent file to Logs/20190817T080214/Courier0018.lzma.bak
2019-08-17T08:42:21.111Z,1566031341.111 [DataOverHttps](INFO): SBD MOMSN=11585142
2019-08-17T08:42:35.876Z,1566031355.876 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190817T080214/Express0019.lzma
2019-08-17T08:42:36.682Z,1566031356.682 [DataOverHttps](INFO): Moved sent file to Logs/20190817T080214/Express0019.lzma.bak
2019-08-17T08:42:36.682Z,1566031356.682 [DataOverHttps](INFO): SBD MOMSN=11585149
2019-08-17T08:42:37.765Z,1566031357.765 [Default:CheckIn:Read_Iridium] Stopped
2019-08-17T08:42:37.765Z,1566031357.765 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-17T08:42:37.765Z,1566031357.765 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-17T08:42:42.983Z,1566031362.983 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-17T08:47:38.332Z,1566031658.332 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-17T08:47:38.332Z,1566031658.332 [Default:CheckIn:C.Wait] Stopped
2019-08-17T08:47:38.332Z,1566031658.332 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-17T08:47:38.332Z,1566031658.332 [Default:CheckIn:D] Running Loop=1
2019-08-17T08:47:38.741Z,1566031658.741 [Default:CheckIn:D] Stopped
2019-08-17T08:47:38.741Z,1566031658.741 [Default:CheckIn:E] Running Loop=1
2019-08-17T08:47:39.139Z,1566031659.139 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 6.164865 min 
2019-08-17T08:47:39.139Z,1566031659.139 [Default:CheckIn:E] Stopped
2019-08-17T08:47:39.139Z,1566031659.139 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-17T08:47:39.139Z,1566031659.139 [Default:CheckIn] Stopped
2019-08-17T08:47:39.139Z,1566031659.139 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-17T08:47:39.139Z,1566031659.139 [Default:CheckIn](INFO): Running loop #2
2019-08-17T08:47:39.140Z,1566031659.140 [Default:CheckIn] Running Loop=2
2019-08-17T08:47:39.140Z,1566031659.140 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-17T08:47:39.140Z,1566031659.140 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-17T08:47:40.748Z,1566031660.748 [NAL9602](DEBUG): Fix Requested
2019-08-17T08:47:41.141Z,1566031661.141 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,084554.00,A,4144.32051,N,08318.40199,W,0.564,40.89,170819,,,A*47
2019-08-17T08:47:41.143Z,1566031661.143 [NAL9602](INFO): GPS fix at 20190817T084554: (41.738675, -83.306700)
2019-08-17T08:47:41.168Z,1566031661.168 [Default:CheckIn:Read_GPS] Stopped
2019-08-17T08:47:41.168Z,1566031661.168 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-17T08:47:42.774Z,1566031662.774 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-17T08:47:46.760Z,1566031666.760 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20190817T084154/Courier0000.lzma
2019-08-17T08:47:47.566Z,1566031667.566 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Courier0000.lzma.bak
2019-08-17T08:47:47.566Z,1566031667.566 [DataOverHttps](INFO): SBD MOMSN=11585152
2019-08-17T08:47:59.029Z,1566031679.029 [DataOverHttps](INFO): Sending 336 bytes from file Logs/20190817T084154/Express0001.lzma
2019-08-17T08:47:59.834Z,1566031679.834 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Express0001.lzma.bak
2019-08-17T08:47:59.834Z,1566031679.834 [DataOverHttps](INFO): SBD MOMSN=11585156
2019-08-17T08:48:01.006Z,1566031681.006 [Default:CheckIn:Read_Iridium] Stopped
2019-08-17T08:48:01.006Z,1566031681.006 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-17T08:48:01.006Z,1566031681.006 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-17T08:48:05.443Z,1566031685.443 [NAL9602](INFO): SBD MO Status=1, MOMSN=31362, MT Status=0, MTMSN=0
2019-08-17T08:48:05.444Z,1566031685.444 [NAL9602](INFO): No messages in MT queue
2019-08-17T08:48:36.081Z,1566031716.081 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-17T08:53:01.554Z,1566031981.554 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-17T08:53:01.554Z,1566031981.554 [Default:CheckIn:C.Wait] Stopped
2019-08-17T08:53:01.554Z,1566031981.554 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-17T08:53:01.554Z,1566031981.554 [Default:CheckIn:D] Running Loop=1
2019-08-17T08:53:01.976Z,1566031981.976 [Default:CheckIn:D] Stopped
2019-08-17T08:53:01.976Z,1566031981.976 [Default:CheckIn:E] Running Loop=1
2019-08-17T08:53:02.373Z,1566031982.373 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.552114 min 
2019-08-17T08:53:02.373Z,1566031982.373 [Default:CheckIn:E] Stopped
2019-08-17T08:53:02.373Z,1566031982.373 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-17T08:53:02.374Z,1566031982.374 [Default:CheckIn] Stopped
2019-08-17T08:53:02.374Z,1566031982.374 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-17T08:53:02.374Z,1566031982.374 [Default:CheckIn](INFO): Running loop #3
2019-08-17T08:53:02.374Z,1566031982.374 [Default:CheckIn] Running Loop=3
2019-08-17T08:53:02.374Z,1566031982.374 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-17T08:53:02.374Z,1566031982.374 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-17T08:53:03.968Z,1566031983.968 [NAL9602](DEBUG): Fix Requested
2019-08-17T08:53:04.366Z,1566031984.366 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,085117.00,A,4144.34198,N,08318.38966,W,0.175,305.22,170819,,,A*77
2019-08-17T08:53:04.368Z,1566031984.368 [NAL9602](INFO): GPS fix at 20190817T085117: (41.739033, -83.306494)
2019-08-17T08:53:04.392Z,1566031984.392 [Default:CheckIn:Read_GPS] Stopped
2019-08-17T08:53:04.392Z,1566031984.392 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-17T08:53:06.417Z,1566031986.417 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-17T08:53:10.136Z,1566031990.136 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190817T084154/Courier0003.lzma
2019-08-17T08:53:11.346Z,1566031991.346 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Courier0003.lzma.bak
2019-08-17T08:53:11.346Z,1566031991.346 [DataOverHttps](INFO): SBD MOMSN=11585165
2019-08-17T08:53:17.697Z,1566031997.697 [NAL9602](INFO): SBD MO Status=1, MOMSN=31363, MT Status=0, MTMSN=0
2019-08-17T08:53:17.697Z,1566031997.697 [NAL9602](INFO): No messages in MT queue
2019-08-17T08:53:22.668Z,1566032002.668 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20190817T084154/Express0004.lzma
2019-08-17T08:53:23.474Z,1566032003.474 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Express0004.lzma.bak
2019-08-17T08:53:23.474Z,1566032003.474 [DataOverHttps](INFO): SBD MOMSN=11585168
2019-08-17T08:53:24.611Z,1566032004.611 [Default:CheckIn:Read_Iridium] Stopped
2019-08-17T08:53:24.611Z,1566032004.611 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-17T08:53:24.611Z,1566032004.611 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-17T08:53:48.401Z,1566032028.401 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-17T08:54:06.690Z,1566032046.690 [DataOverHttps](IMPORTANT): SBD MTMSN=20190817T085219
2019-08-17T08:54:11.644Z,1566032051.644 [DataOverHttps](INFO): Received command:configSet VerticalControl.buoyancyNeutral 375 cc persist;configSet VerticalControl.massDefault -3 mm persist
2019-08-17T08:54:12.089Z,1566032052.089 [CommandLine](IMPORTANT): got command configSet VerticalControl.buoyancyNeutral 375.000000 cubic_centimeter persist
2019-08-17T08:54:12.092Z,1566032052.092 [CommandLine](IMPORTANT): got command configSet VerticalControl.massDefault -3.000000 millimeter persist
2019-08-17T08:55:26.082Z,1566032126.082 [CommandLine](IMPORTANT): got command get DropWeight.loadAtStartup
2019-08-17T08:55:26.083Z,1566032126.083 [CommandLine](IMPORTANT): DropWeight.loadAtStartup 1 bool
2019-08-17T08:58:25.242Z,1566032305.242 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-17T08:58:25.242Z,1566032305.242 [Default:CheckIn:C.Wait] Stopped
2019-08-17T08:58:25.242Z,1566032305.242 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-17T08:58:25.242Z,1566032305.242 [Default:CheckIn:D] Running Loop=1
2019-08-17T08:58:25.649Z,1566032305.649 [Default:CheckIn:D] Stopped
2019-08-17T08:58:25.649Z,1566032305.649 [Default:CheckIn:E] Running Loop=1
2019-08-17T08:58:26.053Z,1566032306.053 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.946673 min 
2019-08-17T08:58:26.053Z,1566032306.053 [Default:CheckIn:E] Stopped
2019-08-17T08:58:26.054Z,1566032306.054 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-17T08:58:26.054Z,1566032306.054 [Default:CheckIn] Stopped
2019-08-17T08:58:26.054Z,1566032306.054 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-17T08:58:26.054Z,1566032306.054 [Default:CheckIn](INFO): Running loop #4
2019-08-17T08:58:26.054Z,1566032306.054 [Default:CheckIn] Running Loop=4
2019-08-17T08:58:26.054Z,1566032306.054 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-17T08:58:26.054Z,1566032306.054 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-17T08:58:27.656Z,1566032307.656 [NAL9602](DEBUG): Fix Requested
2019-08-17T08:58:28.045Z,1566032308.045 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,085640.00,A,4144.36196,N,08318.37985,W,0.369,88.51,170819,,,D*44
2019-08-17T08:58:28.047Z,1566032308.047 [NAL9602](INFO): GPS fix at 20190817T085640: (41.739366, -83.306331)
2019-08-17T08:58:28.102Z,1566032308.102 [Default:CheckIn:Read_GPS] Stopped
2019-08-17T08:58:28.102Z,1566032308.102 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-17T08:58:29.669Z,1566032309.669 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-17T08:58:37.084Z,1566032317.084 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190817T084154/Courier0006.lzma
2019-08-17T08:58:37.890Z,1566032317.890 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Courier0006.lzma.bak
2019-08-17T08:58:37.890Z,1566032317.890 [DataOverHttps](INFO): SBD MOMSN=11585174
2019-08-17T08:58:40.191Z,1566032320.191 [NAL9602](INFO): SBD MO Status=1, MOMSN=31364, MT Status=0, MTMSN=0
2019-08-17T08:58:40.191Z,1566032320.191 [NAL9602](INFO): No messages in MT queue
2019-08-17T08:58:48.868Z,1566032328.868 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190817T084154/Courier0009.lzma
2019-08-17T08:58:49.674Z,1566032329.674 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Courier0009.lzma.bak
2019-08-17T08:58:49.674Z,1566032329.674 [DataOverHttps](INFO): SBD MOMSN=11585177
2019-08-17T08:59:01.292Z,1566032341.292 [DataOverHttps](INFO): Sending 344 bytes from file Logs/20190817T084154/Express0007.lzma
2019-08-17T08:59:02.098Z,1566032342.098 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Express0007.lzma.bak
2019-08-17T08:59:02.098Z,1566032342.098 [DataOverHttps](INFO): SBD MOMSN=11585179
2019-08-17T08:59:10.906Z,1566032350.906 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-17T08:59:13.816Z,1566032353.816 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190817T084154/Express0011.lzma
2019-08-17T08:59:14.622Z,1566032354.622 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Express0011.lzma.bak
2019-08-17T08:59:14.622Z,1566032354.622 [DataOverHttps](INFO): SBD MOMSN=11585187
2019-08-17T08:59:15.797Z,1566032355.797 [Default:CheckIn:Read_Iridium] Stopped
2019-08-17T08:59:15.797Z,1566032355.797 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-17T08:59:15.797Z,1566032355.797 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-17T09:00:26.938Z,1566032426.938 [DataOverHttps](IMPORTANT): SBD MTMSN=20190817T085839
2019-08-17T09:00:34.656Z,1566032434.656 [DataOverHttps](INFO): Received command:sched asap "load Science/sci2_flat_and_level.xml;set sci2_flat_and_level.MissionTimeout 12 minute;set sci2_flat_and_level.NeedCommsTime 12 minute;set sci2_flat_and_level.Depth 2.5 meter;set sci2_flat_and_level.Lat1 41.7389 degree" 1azli 1 3
2019-08-17T09:00:34.705Z,1566032434.705 [CommandLine](IMPORTANT): got command schedule asap "load Science/sci2_flat_and_level.xml;set sci2_flat_and_level.MissionTimeout 12 minute;set sci2_flat_and_level.NeedCommsTime 12 minute;set sci2_flat_and_level.Depth 2.5 meter;set sci2_flat_and_level.Lat1 41.7389 degree" 1azli 1 3.000000
2019-08-17T09:00:34.706Z,1566032434.706 [CommandLine](IMPORTANT): Scheduling command #1 of 3 with id=1azli
2019-08-17T09:00:34.707Z,1566032434.707 [CommandLine](IMPORTANT): Scheduled #48 (#1 of 3 with id='1azli'): "load Science/sci2_flat_and_level.xml;set sci2_flat_and_level.MissionTimeout 12 minute;set sci2_flat_and_level.NeedCommsTime 12 minute;set sci2_flat_and_level.Depth 2.5 meter;set sci2_flat_and_level.Lat1 41.7389 degree" ASAP
2019-08-17T09:00:35.462Z,1566032435.462 [DataOverHttps](IMPORTANT): SBD MTMSN=20190817T085847
2019-08-17T09:00:42.200Z,1566032442.200 [DataOverHttps](INFO): Received command:sched asap "set sci2_flat_and_level.Lon1 -83.3030 degree;set sci2_flat_and_level.ApproachPitchLimit 10 degree;set sci2_flat_and_level.MinAltitude 0.01 meter;set sci2_flat_and_level.MaxDepth 4.5 meter" 1azli 2 3
2019-08-17T09:00:42.260Z,1566032442.260 [CommandLine](IMPORTANT): got command schedule asap "set sci2_flat_and_level.Lon1 -83.3030 degree;set sci2_flat_and_level.ApproachPitchLimit 10 degree;set sci2_flat_and_level.MinAltitude 0.01 meter;set sci2_flat_and_level.MaxDepth 4.5 meter" 1azli 2 3.000000
2019-08-17T09:00:42.261Z,1566032442.261 [CommandLine](IMPORTANT): Scheduling command #2 of 3 with id=1azli
2019-08-17T09:00:42.261Z,1566032442.261 [CommandLine](IMPORTANT): Scheduled #49 (#2 of 3 with id='1azli'): "set sci2_flat_and_level.Lon1 -83.3030 degree;set sci2_flat_and_level.ApproachPitchLimit 10 degree;set sci2_flat_and_level.MinAltitude 0.01 meter;set sci2_flat_and_level.MaxDepth 4.5 meter" ASAP
2019-08-17T09:00:43.006Z,1566032443.006 [DataOverHttps](IMPORTANT): SBD MTMSN=20190817T085855
2019-08-17T09:00:48.324Z,1566032448.324 [DataOverHttps](INFO): Received command:sched asap "set sci2_flat_and_level.MinOffshore 0.01 kilometer;run " 1azli 3 3
2019-08-17T09:00:48.374Z,1566032448.374 [CommandLine](IMPORTANT): got command schedule asap "set sci2_flat_and_level.MinOffshore 0.01 kilometer;run " 1azli 3 3.000000
2019-08-17T09:00:48.374Z,1566032448.374 [CommandLine](IMPORTANT): Scheduling command #3 of 3 with id=1azli
2019-08-17T09:00:48.375Z,1566032448.375 [CommandLine](IMPORTANT): Scheduled #50 (#3 of 3 with id='1azli'): "set sci2_flat_and_level.MinOffshore 0.01 kilometer;run " ASAP
2019-08-17T09:00:48.528Z,1566032448.528 [CommandLine](IMPORTANT): got command load ./Missions/Science/sci2_flat_and_level.xml
2019-08-17T09:00:48.529Z,1566032448.529 [MissionManager](INFO): Loading Mission: ./Missions/Science/sci2_flat_and_level.xml
2019-08-17T09:00:48.758Z,1566032448.758 [MissionManager](INFO): DefineArg sci2_flat_and_level.MissionTimeout = 2.000000 h
2019-08-17T09:00:48.760Z,1566032448.760 [MissionManager](INFO): DefineArg sci2_flat_and_level.NeedCommsTime = 60.000000 min
2019-08-17T09:00:48.768Z,1566032448.768 [MissionManager](INFO): DefineArg sci2_flat_and_level.Depth = 3.000000 m
2019-08-17T09:00:48.770Z,1566032448.770 [MissionManager](INFO): DefineArg sci2_flat_and_level.Repeat = 1.000000 count
2019-08-17T09:00:48.773Z,1566032448.773 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat1 = nan arcdeg
2019-08-17T09:00:48.775Z,1566032448.775 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon1 = nan arcdeg
2019-08-17T09:00:48.777Z,1566032448.777 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat2 = nan arcdeg
2019-08-17T09:00:48.779Z,1566032448.779 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon2 = nan arcdeg
2019-08-17T09:00:48.782Z,1566032448.782 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat3 = nan arcdeg
2019-08-17T09:00:48.784Z,1566032448.784 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon3 = nan arcdeg
2019-08-17T09:00:48.786Z,1566032448.786 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat4 = nan arcdeg
2019-08-17T09:00:48.788Z,1566032448.788 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon4 = nan arcdeg
2019-08-17T09:00:48.790Z,1566032448.790 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat5 = nan arcdeg
2019-08-17T09:00:48.793Z,1566032448.793 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon5 = nan arcdeg
2019-08-17T09:00:48.795Z,1566032448.795 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat6 = nan arcdeg
2019-08-17T09:00:48.797Z,1566032448.797 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon6 = nan arcdeg
2019-08-17T09:00:48.799Z,1566032448.799 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat7 = nan arcdeg
2019-08-17T09:00:48.801Z,1566032448.801 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon7 = nan arcdeg
2019-08-17T09:00:48.804Z,1566032448.804 [MissionManager](INFO): DefineArg sci2_flat_and_level.Speed = 1.000000 m/s
2019-08-17T09:00:48.806Z,1566032448.806 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachDepth = 2.000000 m
2019-08-17T09:00:48.808Z,1566032448.808 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachSpeed = 0.700000 m/s
2019-08-17T09:00:48.811Z,1566032448.811 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachDepthRate = 0.050000 m/s
2019-08-17T09:00:48.813Z,1566032448.813 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachPitchLimit = 20.000000 arcdeg
2019-08-17T09:00:48.815Z,1566032448.815 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachDepthTimeout = 15.000000 min
2019-08-17T09:00:48.818Z,1566032448.818 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachSettleTimePreDive = 1.000000 min
2019-08-17T09:00:48.820Z,1566032448.820 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachSettleTimePostDive = 3.000000 min
2019-08-17T09:00:48.838Z,1566032448.838 [MissionManager](INFO): DefineArg sci2_flat_and_level.kpDepth = 0.070000 rad/m
2019-08-17T09:00:48.853Z,1566032448.853 [MissionManager](INFO): DefineArg sci2_flat_and_level.BuoyancyNeutral = 375.000003 cc
2019-08-17T09:00:48.856Z,1566032448.856 [MissionManager](INFO): DefineArg sci2_flat_and_level.MassDefault = -0.300000 cm
2019-08-17T09:00:48.866Z,1566032448.866 [MissionManager](INFO): DefineArg sci2_flat_and_level.MinAltitude = 2.000000 m
2019-08-17T09:00:48.873Z,1566032448.873 [MissionManager](INFO): DefineArg sci2_flat_and_level.MaxDepth = 15.000000 m
2019-08-17T09:00:48.875Z,1566032448.875 [MissionManager](INFO): DefineArg sci2_flat_and_level.MinOffshore = 2.000000 km
2019-08-17T09:00:48.886Z,1566032448.886 [MissionManager](INFO): DefineOutput sci2_flat_and_level.DiveMode = 0.000000 count
2019-08-17T09:00:48.888Z,1566032448.888 [MissionManager](INFO): DefineOutput sci2_flat_and_level.DoingComms = 0.000000 count
2019-08-17T09:00:48.915Z,1566032448.915 [MissionManager](INFO): DefineOutput sci2_flat_and_level.InitialDive = 1.000000 count
2019-08-17T09:00:48.922Z,1566032448.922 [MissionManager](INFO): DefineOutput sci2_flat_and_level.SettleAtDepth = 2.000000 count
2019-08-17T09:00:48.937Z,1566032448.937 [MissionManager](INFO): DefineOutput sci2_flat_and_level.MaintainDepth = 3.000000 count
2019-08-17T09:00:48.937Z,1566032448.937 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml
2019-08-17T09:00:49.460Z,1566032449.460 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.SampleISUS = 0 bool
2019-08-17T09:00:49.462Z,1566032449.462 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.SampleISUSmaxPitch = 60.000000 arcdeg
2019-08-17T09:00:49.464Z,1566032449.464 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.SampleISUSminPitch = -60.000000 arcdeg
2019-08-17T09:00:49.466Z,1566032449.466 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectChlActive = 0 bool
2019-08-17T09:00:49.468Z,1566032449.468 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.TimeWindowPeakReport = nan min
2019-08-17T09:00:49.470Z,1566032449.470 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.HighestChlPeakReportActive = 0 bool
2019-08-17T09:00:49.472Z,1566032449.472 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PatchTracking = 0 bool
2019-08-17T09:00:49.474Z,1566032449.474 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.FilterWidthHorizontal = 3.000000 count
2019-08-17T09:00:49.476Z,1566032449.476 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.NumProfilesSlidingwindow = 100.000000 count
2019-08-17T09:00:49.478Z,1566032449.478 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.OffPeakFractionHorizontal = 80.000000 %
2019-08-17T09:00:49.480Z,1566032449.480 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectNO3Active = 0 bool
2019-08-17T09:00:49.482Z,1566032449.482 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectOilActive = 0 bool
2019-08-17T09:00:49.484Z,1566032449.484 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectFDOMActive = 0 bool
2019-08-17T09:00:49.486Z,1566032449.486 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2019-08-17T09:00:49.509Z,1566032449.509 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledAanderaaO2 = 1.000000 bool
2019-08-17T09:00:49.511Z,1566032449.511 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledNeilBrown = 0.000000 bool
2019-08-17T09:00:49.514Z,1566032449.514 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledSeabird = 1.000000 bool
2019-08-17T09:00:49.516Z,1566032449.516 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledTurbulence_NPS = 0.000000 bool
2019-08-17T09:00:49.519Z,1566032449.519 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledWetLabsBB2FL = 1.000000 bool
2019-08-17T09:00:49.527Z,1566032449.527 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool
2019-08-17T09:00:49.547Z,1566032449.547 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledWetLabsUBAT = 0.000000 bool
2019-08-17T09:00:49.550Z,1566032449.550 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledISUS = 0.000000 bool
2019-08-17T09:00:49.552Z,1566032449.552 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.LowPassWindowLength = 20.000000 count
2019-08-17T09:00:49.554Z,1566032449.554 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.MedianFilterLen = 5.000000 count
2019-08-17T09:00:49.622Z,1566032449.622 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakChlShallowBound = nan m
2019-08-17T09:00:49.624Z,1566032449.624 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakChlDeepBound = nan m
2019-08-17T09:00:49.626Z,1566032449.626 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakShallowBound = nan m
2019-08-17T09:00:49.665Z,1566032449.665 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDeepBound = nan m
2019-08-17T09:00:49.667Z,1566032449.667 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChl = 0.000000 ug/l
2019-08-17T09:00:49.669Z,1566032449.669 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlDepth = 0.000000 m
2019-08-17T09:00:49.671Z,1566032449.671 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlTemperature = 0.000000 degC
2019-08-17T09:00:49.674Z,1566032449.674 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlLatitude = nan arcdeg
2019-08-17T09:00:49.676Z,1566032449.676 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlLongitude = nan arcdeg
2019-08-17T09:00:49.715Z,1566032449.715 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3 = 0.000000 umol/l
2019-08-17T09:00:49.721Z,1566032449.721 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3Depth = 0.000000 m
2019-08-17T09:00:49.724Z,1566032449.724 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3Latitude = nan arcdeg
2019-08-17T09:00:49.731Z,1566032449.731 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3Longitude = nan arcdeg
2019-08-17T09:00:49.753Z,1566032449.753 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChl = 0.000000 m
2019-08-17T09:00:49.755Z,1566032449.755 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlDepth = 0.000000 m
2019-08-17T09:00:49.766Z,1566032449.766 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlLatitude = nan arcdeg
2019-08-17T09:00:49.791Z,1566032449.791 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlLongitude = nan arcdeg
2019-08-17T09:00:49.807Z,1566032449.807 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlDistance = nan m
2019-08-17T09:00:49.810Z,1566032449.810 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOil = 0.000000 kg/m3
2019-08-17T09:00:49.812Z,1566032449.812 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOilDepth = 0.000000 m
2019-08-17T09:00:49.828Z,1566032449.828 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOilLatitude = nan arcdeg
2019-08-17T09:00:49.831Z,1566032449.831 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOilLongitude = nan arcdeg
2019-08-17T09:00:49.845Z,1566032449.845 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOM = 0.000000 ppb
2019-08-17T09:00:49.848Z,1566032449.848 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOMDepth = 0.000000 m
2019-08-17T09:00:49.854Z,1566032449.854 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOMLatitude = nan arcdeg
2019-08-17T09:00:49.861Z,1566032449.861 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOMLongitude = nan arcdeg
2019-08-17T09:00:49.863Z,1566032449.863 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchFDOMDistance = nan m
2019-08-17T09:00:49.990Z,1566032449.990 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-08-17T09:00:50.037Z,1566032450.037 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2019-08-17T09:00:50.087Z,1566032450.087 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-08-17T09:00:50.110Z,1566032450.110 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-08-17T09:00:50.141Z,1566032450.141 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-08-17T09:00:50.171Z,1566032450.171 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml
2019-08-17T09:00:50.230Z,1566032450.230 [MissionManager](INFO): DefineArg sci2_flat_and_level:StandardEnvelopes.MinAltitude = 5.000000 m
2019-08-17T09:00:50.237Z,1566032450.237 [MissionManager](INFO): DefineArg sci2_flat_and_level:StandardEnvelopes.MaxDepth = 200.000000 m
2019-08-17T09:00:50.240Z,1566032450.240 [MissionManager](INFO): DefineArg sci2_flat_and_level:StandardEnvelopes.MinOffshore = 2000.000000 m
2019-08-17T09:00:50.258Z,1566032450.258 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2019-08-17T09:00:50.263Z,1566032450.263 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2019-08-17T09:00:50.318Z,1566032450.318 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2019-08-17T09:00:50.383Z,1566032450.383 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml
2019-08-17T09:00:50.485Z,1566032450.485 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.DiveInterval = 3.000000 h
2019-08-17T09:00:50.487Z,1566032450.487 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.WaitForPitchUp = 10.000000 min
2019-08-17T09:00:50.489Z,1566032450.489 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.SurfacePitch = 20.000000 arcdeg
2019-08-17T09:00:50.491Z,1566032450.491 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.SurfaceDepthRate = nan m/s
2019-08-17T09:00:50.506Z,1566032450.506 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.SurfaceSpeed = 1.000000 m/s
2019-08-17T09:00:50.508Z,1566032450.508 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.GPSTimeout = 7.000000 min
2019-08-17T09:00:50.516Z,1566032450.516 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.CommsTimeout = 30.000000 min
2019-08-17T09:00:50.521Z,1566032450.521 [sci2_flat_and_level:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-08-17T09:00:50.590Z,1566032450.590 [sci2_flat_and_level:DiveCmd:InitialDive:dive:C.Mass](DEBUG): Construct.
2019-08-17T09:00:50.607Z,1566032450.607 [sci2_flat_and_level:DiveCmd:InitialDive:dive:D.Buoyancy](DEBUG): Construct Buoyancy.
2019-08-17T09:00:50.611Z,1566032450.611 [sci2_flat_and_level:DiveCmd:InitialDive:dive:F.Wait](DEBUG): Construct Wait.
2019-08-17T09:00:50.614Z,1566032450.614 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed](DEBUG): Construct.
2019-08-17T09:00:50.616Z,1566032450.616 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch](DEBUG): Construct.
2019-08-17T09:00:50.662Z,1566032450.662 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch:A_Timeout:B.Execute](DEBUG): Construct Execute.
2019-08-17T09:00:50.689Z,1566032450.689 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:B.Pitch](DEBUG): Construct.
2019-08-17T09:00:50.693Z,1566032450.693 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:C.Wait](DEBUG): Construct Wait.
2019-08-17T09:00:50.750Z,1566032450.750 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:A.Mass](DEBUG): Construct.
2019-08-17T09:00:50.752Z,1566032450.752 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.Buoyancy](DEBUG): Construct Buoyancy.
2019-08-17T09:00:50.754Z,1566032450.754 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.SetSpeed](DEBUG): Construct.
2019-08-17T09:00:50.792Z,1566032450.792 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:D.Pitch](DEBUG): Construct.
2019-08-17T09:00:50.800Z,1566032450.800 [sci2_flat_and_level:Lap:Wpt1:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-17T09:00:50.814Z,1566032450.814 [sci2_flat_and_level:Lap:Wpt2:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-17T09:00:50.819Z,1566032450.819 [sci2_flat_and_level:Lap:Wpt3:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-17T09:00:50.837Z,1566032450.837 [sci2_flat_and_level:Lap:Wpt4:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-17T09:00:50.842Z,1566032450.842 [sci2_flat_and_level:Lap:Wpt5:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-17T09:00:50.859Z,1566032450.859 [sci2_flat_and_level:Lap:Wpt6:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-17T09:00:50.864Z,1566032450.864 [sci2_flat_and_level:Lap:Wpt7:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-17T09:00:50.910Z,1566032450.910 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>

<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Control="Tethys/Control"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="sci2_flat_and_level">

    <Description>
        Vehicle transits to the specified waypoints at the commanded depth (flat-and-level) with science turned on.
    </Description>

    <DefineArg Name="MissionTimeout"><Description>
        Maximum duration of mission
    </Description><Units:hour/><Value>2</Value></DefineArg>

    <DefineArg Name="NeedCommsTime"><Description>
        How often to surface for commumications
    </Description><Units:minute/><Value>60</Value></DefineArg>

    <DefineArg Name="Depth"><Description>
        Depth of flat and level flight during the mission.
    </Description><Units:meter /><Value>3</Value></DefineArg>

    <DefineArg Name="Repeat"><Description>
        Number of times the vehicle should try to cycle through waypoints.
    </Description><Units:count/><Value>1</Value></DefineArg>

    <DefineArg Name="Lat1"><Description>
        Latitude of waypoint 1. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon1"><Description>
        Longitude of waypoint 1. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat2"><Description>
        Latitude of waypoint 2. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon2"><Description>
        Longitude of waypoint 2. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat3"><Description>
        Latitude of waypoint 3. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon3"><Description>
        Longitude of waypoint 3. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat4"><Description>
        Latitude of waypoint 4. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon4"><Description>
        Longitude of waypoint 4. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat5"><Description>
        Latitude of waypoint 5. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon5"><Description>
        Longitude of waypoint 5. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat6"><Description>
        Latitude of waypoint 6. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon6"><Description>
        Longitude of waypoint 6. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat7"><Description>
        Latitude of waypoint 7. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon7"><Description>
        Longitude of waypoint 7. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Speed"><Description>
        Speed while transiting to waypoints.
    </Description><Units:meter_per_second/><Value>1</Value></DefineArg>

    <DefineArg Name="ApproachDepth"><Description>
        Depth for initial descent form the surface.
    </Description><Units:meter/><Value>2</Value></DefineArg>

    <DefineArg Name="ApproachSpeed"><Description>
        Speed while descending to target depth.
    </Description><Units:meter_per_second/><Value>0.7</Value></DefineArg>

    <DefineArg Name="ApproachDepthRate"><Description>
        Descent depth rate (Positive depth rate means going down).
    </Description><Units:meter_per_second/><Value>0.05</Value></DefineArg>

    <DefineArg Name="ApproachPitchLimit"><Description>
        Max vehicle pitch (+/-) when decending from the surface.
    </Description><Units:degree/><Value>20</Value></DefineArg>

    <DefineArg Name="ApproachDepthTimeout"><Description>
        Maximum time duration for the vehicle to reach the target depth
    </Description><Units:minute/><Value>15</Value></DefineArg>

    <DefineArg Name="ApproachSettleTimePreDive"><Description>
        Time duration for the vehicle to pump down the VBS *BEFORE* leaving the surface.
    </Description><Units:minute/><Value>1</Value></DefineArg>

    <DefineArg Name="ApproachSettleTimePostDive"><Description>
        Time duration for the vehicle to settle *AFTER* reaching the target depth.
    </Description><Units:minute/><Value>3</Value></DefineArg>

    <DefineArg Name="kpDepth"><Description>
        Dive loop proportional gain (applied only while the vehicle is descending to target depth).
    </Description><Units:radian_per_meter/><Value>0.07</Value></DefineArg>

    <DefineArg Name="BuoyancyNeutral"><Description>
        Buoyancy bladder position during the mission. Defaults to buoyancyNeutral
        setting in the Config/Control.cfg file. Set to NaN cc for active buoyancy.
    </Description><Control:VerticalControl.buoyancyNeutral/></DefineArg>

    <DefineArg Name="MassDefault"><Description>
        Static setting for mass during the mission. Set to NaN mm for active
        mass position.
    </Description><Control:VerticalControl.massDefault/></DefineArg>

    <DefineArg Name="MinAltitude"><Description>
        Minimum height above the sea floor for the entire mission.
    </Description><Units:meter/><Value>2</Value></DefineArg>

    <DefineArg Name="MaxDepth"><Description>
        Maximum depth for the entire mission.
    </Description><Units:meter/><Value>15</Value></DefineArg>

    <DefineArg Name="MinOffshore"><Description>
        Minimum offshore distance for the entire mission.
    </Description><Units:kilometer/><Value>2</Value></DefineArg>

    <DefineOutput Name="DiveMode"><Description>
        Mission variable (don't change). The mission sets this variable to switch
        between dive modes. Initialized to DoingComms.
    </Description><Units:count/><Value>0</Value></DefineOutput>

    <DefineOutput Name="DoingComms"><Description>
        Mission variable (don't change).
        The mission will run in this to mode when doing surface comms.
    </Description><Units:count/><Value>0</Value></DefineOutput>

    <DefineOutput Name="InitialDive"><Description>
        Mission variable (don't change).
        The mission will run in this mode after surface comms are done to dive the
        vehicle to the approach depth.
    </Description><Units:count/><Value>1</Value></DefineOutput>

    <DefineOutput Name="SettleAtDepth"><Description>
        Mission variable (don't change).
        The mission will run in this mode to settle the vehicle at the target depth.
    </Description><Units:count/><Value>2</Value></DefineOutput>

    <DefineOutput Name="MaintainDepth"><Description>
        Mission variable (don't change).
        The mission will run in this mode to maintain the vehicle at the target depth.
    </Description><Units:count/><Value>3</Value></DefineOutput>


    <!-- Mission timeout -->

    <Timeout Duration="MissionTimeout"/>

    <!-- Science! -->

    <Insert Filename="Insert/Science.xml">
        <Description>
            Run the science sensors.
        </Description>
    </Insert>

    <!-- Safety nets and surfacing behaviors -->

    <Insert Filename="Insert/StandardEnvelopes.xml"/>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinAltitude"/><Arg Name="MinAltitude"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MaxDepth"/><Arg Name="MaxDepth"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinOffshore"/><Arg Name="MinOffshore"/></Assign>


    <Insert Filename="Insert/NeedComms.xml" Id="NeedComms"/>

    <Assign><Sequence/><Arg Name="NeedComms:DiveInterval"/><Arg Name="MissionTimeout"/></Assign>

    <Assign><Sequence/><Arg Name="NeedComms:WaitForPitchUp"/><Units:minute/><Value>0</Value></Assign>

    <Aggregate Id="SurfaceComms">
        <When>
            <Called/>
            <Or><Elapsed><Universal:time_fix/></Elapsed><Gt><Arg Name="NeedCommsTime"/></Gt></Or>
        </When>

        <Assign><Sequence/><Arg Name="DiveMode"/><Arg Name="DoingComms"/></Assign>

        <Call RefId="NeedComms"/>

        <Assign><Sequence/><Arg Name="DiveMode"/><Arg Name="InitialDive"/></Assign>
    </Aggregate>


    <Aggregate Id="DiveCmd">

        <Description>
            Called when the vehicle should be underwater.
            Arbitrates between 3 dive modes:
                1) descend from the surface to initial depth.
                2) settle at target depth using the VB.
                3) cruise at target depth.
        </Description>

        <When>
            <Called/>
        </When>


        <Aggregate Id="InitialDive">
            <Description>
                Descend from the surface to target depth, limit pitch and depth-rate.
            </Description>

            <While>
                <Arg Name="DiveMode"/><Eq><Arg Name="InitialDive"/></Eq>
            </While>

            <Aggregate Id="dive">
                <Sequence/>

                <Assign><Parallel/><Control:VerticalControl.pitchLimit/><Arg Name="ApproachPitchLimit"/></Assign>

                <Assign><Parallel/><Control:VerticalControl.kpDepth/><Arg Name="kpDepth"/></Assign>

                <Guidance:Mass>
                    <Parallel/>
                    <Setting><Guidance:Mass.position/><Arg Name="MassDefault"/></Setting>
                </Guidance:Mass>

                <Guidance:Buoyancy>
                    <Parallel/>
                    <Setting><Guidance:Buoyancy.position/><Arg Name="BuoyancyNeutral"/></Setting>
                </Guidance:Buoyancy>

                <Syslog Severity="Info">Waiting for <Arg Name="ApproachSettleTimePreDive"/><Units:minute/>while pumping down to neutral.</Syslog>

                <Guidance:Wait>
                    <Description>Take a few moments to ensure the VBS reaches neutral.</Description>
                    <Sequence/>
                    <Setting><Guidance:Wait.duration/><Arg Name="ApproachSettleTimePreDive"/></Setting>
                </Guidance:Wait>

                <Syslog>Moving to <Arg Name="ApproachDepth"/><Units:meter/></Syslog>

                <Aggregate Id="ApproachDepth">
                    <Sequence/>

                    <Guidance:SetSpeed>
                        <Parallel/>
                        <Setting><Guidance:SetSpeed.speed/><Arg Name="ApproachSpeed"/></Setting>
                    </Guidance:SetSpeed>

                    <Guidance:Pitch>
                        <Sequence/>
                        <Timeout Duration="ApproachDepthTimeout">
                            <Syslog Severity="Important">Timed out while trying to reach target depth at current depth of <Universal:depth/><Units:meter/></Syslog>
                            <Guidance:Execute>
                                <Sequence/>
                                <Setting><Guidance:Execute.command/><String>stop</String></Setting>
                            </Guidance:Execute>
                        </Timeout>
                        <Setting><Guidance:Pitch.depth/><Arg Name="ApproachDepth"/></Setting>
                        <Setting><Guidance:Pitch.depthRate/><Arg Name="ApproachDepthRate"/></Setting>
                    </Guidance:Pitch>
                </Aggregate>

                <Assign><Sequence/><Arg Name="DiveMode"/><Arg Name="SettleAtDepth"/></Assign>
            </Aggregate>
        </Aggregate>


        <Aggregate Id="SettleAtDepth">
            <Description>
                Take a few more moments here to make sure the vechile is settled at the target depth.
            </Description>

            <While>
                <Arg Name="DiveMode"/><Eq><Arg Name="SettleAtDepth"/></Eq>
            </While>

            <Aggregate Id="dive">
                <Sequence/>

                <Syslog Severity="Info">Reached <Universal:depth/><Units:meter/>, settling for <Arg Name="ApproachSettleTimePostDive"/><Units:minute/></Syslog>

                <Guidance:Pitch>
                    <Parallel/>
                    <Setting><Guidance:Pitch.depth/><Arg Name="Depth"/></Setting>
                </Guidance:Pitch>

                <Guidance:Wait>
                    <Sequence/>
                    <Setting><Guidance:Wait.duration/><Arg Name="ApproachSettleTimePostDive"/></Setting>
                </Guidance:Wait>

                <Assign><Sequence/><Arg Name="DiveMode"/><Arg Name="MaintainDepth"/></Assign>
            </Aggregate>
        </Aggregate>


        <Aggregate Id="MaintainDepth">
            <Description>
                Cruise at the target depth.
            </Description>

            <While>
                <Arg Name="DiveMode"/><Eq><Arg Name="MaintainDepth"/></Eq>
            </While>

            <Aggregate Id="dive">
                <Parallel/>

                <Guidance:Mass>
                    <Parallel/>
                    <Setting><Guidance:Mass.position/><Arg Name="MassDefault"/></Setting>
                </Guidance:Mass>

                <Guidance:Buoyancy>
                    <Parallel/>
                    <Setting><Guidance:Buoyancy.position/><Arg Name="BuoyancyNeutral"/></Setting>
                </Guidance:Buoyancy>

                <Guidance:SetSpeed>
                    <Parallel/>
                    <Setting><Guidance:SetSpeed.speed/><Arg Name="Speed"/></Setting>
                </Guidance:SetSpeed>

                <Guidance:Pitch>
                    <Parallel/>
                    <Setting><Guidance:Pitch.depth/><Arg Name="Depth"/></Setting>
                </Guidance:Pitch>
            </Aggregate>
        </Aggregate>

    </Aggregate>


    <!-- Start mission sequence -->

    <Call Id="StartingMission" RefId="SurfaceComms"/>

    <Aggregate Id="Lap">
        <Sequence Repeat="Repeat"/>

        <Aggregate Id="Dive">
            <While>
                <Not><Arg Name="DiveMode"/><Eq><Arg Name="DoingComms"/></Eq></Not>
            </While>

            <Call RefId="DiveCmd"/>
        </Aggregate>

        <Aggregate Id="Wpt1">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat1"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon1"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt2">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat2"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon2"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt3">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat3"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon3"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt4">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat4"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon4"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt5">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat5"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon5"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt6">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat6"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon6"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt7">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat7"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon7"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>
    </Aggregate>
</Mission>


2019-08-17T09:00:50.910Z,1566032450.910 [CommandLine](IMPORTANT): Loaded ./Missions/Science/sci2_flat_and_level.xml
2019-08-17T09:01:02.506Z,1566032462.506 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.MissionTimeout 12.000000 minute
2019-08-17T09:01:02.507Z,1566032462.507 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.NeedCommsTime 12.000000 minute
2019-08-17T09:01:02.508Z,1566032462.508 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.Depth 2.500000 meter
2019-08-17T09:01:02.508Z,1566032462.508 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.Lat1 41.738899 degree
2019-08-17T09:01:15.099Z,1566032475.099 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.Lon1 -83.303001 degree
2019-08-17T09:01:15.100Z,1566032475.100 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.ApproachPitchLimit 10.000000 degree
2019-08-17T09:01:15.101Z,1566032475.101 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.MinAltitude 0.010000 meter
2019-08-17T09:01:15.101Z,1566032475.101 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.MaxDepth 4.500000 meter
2019-08-17T09:01:21.701Z,1566032481.701 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.MinOffshore 0.010000 kilometer
2019-08-17T09:01:21.701Z,1566032481.701 [CommandLine](IMPORTANT): got command run 
2019-08-17T09:01:21.703Z,1566032481.703 [CommandLine](IMPORTANT): Running 
2019-08-17T09:01:21.851Z,1566032481.851 [Default] Stopped
2019-08-17T09:01:21.851Z,1566032481.851 [Default](DEBUG): Aggregate::uninitialize Default
2019-08-17T09:01:21.851Z,1566032481.851 [Default:B.GoToSurface] Stopped
2019-08-17T09:01:21.851Z,1566032481.851 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-08-17T09:01:21.851Z,1566032481.851 [Default:CheckIn] Stopped
2019-08-17T09:01:21.851Z,1566032481.851 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-17T09:01:21.852Z,1566032481.852 [Default:CheckIn:C.Wait] Stopped
2019-08-17T09:01:21.852Z,1566032481.852 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-17T09:01:21.852Z,1566032481.852 [MissionManager](IMPORTANT): Started mission sci2_flat_and_level
2019-08-17T09:01:21.852Z,1566032481.852 [sci2_flat_and_level] Running Loop=1
2019-08-17T09:01:21.852Z,1566032481.852 [sci2_flat_and_level](DEBUG): Aggregate::initialize sci2_flat_and_level
2019-08-17T09:01:21.852Z,1566032481.852 [sci2_flat_and_level:Science] Running Loop=1
2019-08-17T09:01:21.852Z,1566032481.852 [sci2_flat_and_level:Science](DEBUG): Aggregate::initialize sci2_flat_and_level:Science
2019-08-17T09:01:21.852Z,1566032481.852 [sci2_flat_and_level:Science:A] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:B] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:C] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:D] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:E] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:F] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:G] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:H] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:Read_Oil] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:PeakDetectChl] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:PeakDetectChl](DEBUG): Aggregate::initialize sci2_flat_and_level:Science:PeakDetectChl
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2019-08-17T09:01:21.853Z,1566032481.853 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-08-17T09:01:21.855Z,1566032481.855 [sci2_flat_and_level:Science:HighestChlPeakReport] Running Loop=1
2019-08-17T09:01:21.855Z,1566032481.855 [sci2_flat_and_level:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize sci2_flat_and_level:Science:HighestChlPeakReport
2019-08-17T09:01:21.855Z,1566032481.855 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2019-08-17T09:01:21.855Z,1566032481.855 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2019-08-17T09:01:21.855Z,1566032481.855 [sci2_flat_and_level:Science:PeakDetectNO3] Running Loop=1
2019-08-17T09:01:21.855Z,1566032481.855 [sci2_flat_and_level:Science:PeakDetectNO3](DEBUG): Aggregate::initialize sci2_flat_and_level:Science:PeakDetectNO3
2019-08-17T09:01:21.856Z,1566032481.856 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2019-08-17T09:01:21.856Z,1566032481.856 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-08-17T09:01:21.857Z,1566032481.857 [sci2_flat_and_level:Science:PeakDetectOil] Running Loop=1
2019-08-17T09:01:21.857Z,1566032481.857 [sci2_flat_and_level:Science:PeakDetectOil](DEBUG): Aggregate::initialize sci2_flat_and_level:Science:PeakDetectOil
2019-08-17T09:01:21.858Z,1566032481.858 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2019-08-17T09:01:21.858Z,1566032481.858 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-08-17T09:01:21.859Z,1566032481.859 [sci2_flat_and_level:Science:PeakDetectFDOM] Running Loop=1
2019-08-17T09:01:21.859Z,1566032481.859 [sci2_flat_and_level:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize sci2_flat_and_level:Science:PeakDetectFDOM
2019-08-17T09:01:21.859Z,1566032481.859 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2019-08-17T09:01:21.859Z,1566032481.859 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-08-17T09:01:21.860Z,1566032481.860 [sci2_flat_and_level:StandardEnvelopes] Running Loop=1
2019-08-17T09:01:21.860Z,1566032481.860 [sci2_flat_and_level:StandardEnvelopes](DEBUG): Aggregate::initialize sci2_flat_and_level:StandardEnvelopes
2019-08-17T09:01:21.860Z,1566032481.860 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2019-08-17T09:01:21.860Z,1566032481.860 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2019-08-17T09:01:21.860Z,1566032481.860 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2019-08-17T09:01:21.861Z,1566032481.861 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2019-08-17T09:01:21.861Z,1566032481.861 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2019-08-17T09:01:21.861Z,1566032481.861 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2019-08-17T09:01:21.861Z,1566032481.861 [sci2_flat_and_level:C] Running Loop=1
2019-08-17T09:01:21.862Z,1566032481.862 [sci2_flat_and_level:C] Stopped
2019-08-17T09:01:21.862Z,1566032481.862 [sci2_flat_and_level:D] Running Loop=1
2019-08-17T09:01:21.862Z,1566032481.862 [sci2_flat_and_level:StandardEnvelopes] Running Loop=1
2019-08-17T09:01:21.862Z,1566032481.862 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2019-08-17T09:01:21.862Z,1566032481.862 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2019-08-17T09:01:21.863Z,1566032481.863 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2019-08-17T09:01:21.863Z,1566032481.863 [sci2_flat_and_level:Science] Running Loop=1
2019-08-17T09:01:21.864Z,1566032481.864 [sci2_flat_and_level:Science:PeakDetectFDOM] Stopped
2019-08-17T09:01:21.864Z,1566032481.864 [sci2_flat_and_level:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science:PeakDetectFDOM
2019-08-17T09:01:21.864Z,1566032481.864 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2019-08-17T09:01:21.864Z,1566032481.864 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-08-17T09:01:21.864Z,1566032481.864 [sci2_flat_and_level:Science:PeakDetectOil] Stopped
2019-08-17T09:01:21.864Z,1566032481.864 [sci2_flat_and_level:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science:PeakDetectOil
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:PeakDetectNO3] Stopped
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science:PeakDetectNO3
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:HighestChlPeakReport] Stopped
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science:HighestChlPeakReport
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:PeakDetectChl] Stopped
2019-08-17T09:01:21.865Z,1566032481.865 [sci2_flat_and_level:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science:PeakDetectChl
2019-08-17T09:01:21.866Z,1566032481.866 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2019-08-17T09:01:21.866Z,1566032481.866 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-08-17T09:01:21.866Z,1566032481.866 [sci2_flat_and_level:Science:Read_Oil] Stopped
2019-08-17T09:01:21.866Z,1566032481.866 [sci2_flat_and_level:Science:H] Stopped
2019-08-17T09:01:21.866Z,1566032481.866 [sci2_flat_and_level:Science:G] Running Loop=1
2019-08-17T09:01:21.866Z,1566032481.866 [sci2_flat_and_level:Science:G](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2019-08-17T09:01:21.866Z,1566032481.866 [sci2_flat_and_level:Science:F] Stopped
2019-08-17T09:01:21.866Z,1566032481.866 [sci2_flat_and_level:Science:E] Stopped
2019-08-17T09:01:21.866Z,1566032481.866 [sci2_flat_and_level:Science:D] Running Loop=1
2019-08-17T09:01:21.867Z,1566032481.867 [sci2_flat_and_level:Science:D](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2019-08-17T09:01:21.867Z,1566032481.867 [sci2_flat_and_level:Science:D](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2019-08-17T09:01:21.867Z,1566032481.867 [sci2_flat_and_level:Science:C] Running Loop=1
2019-08-17T09:01:21.868Z,1566032481.868 [sci2_flat_and_level:Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2019-08-17T09:01:21.868Z,1566032481.868 [sci2_flat_and_level:Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2019-08-17T09:01:21.869Z,1566032481.869 [sci2_flat_and_level:Science:B] Stopped
2019-08-17T09:01:21.869Z,1566032481.869 [sci2_flat_and_level:Science:A] Running Loop=1
2019-08-17T09:01:21.869Z,1566032481.869 [sci2_flat_and_level:Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water
2019-08-17T09:01:22.013Z,1566032482.013 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=2
2019-08-17T09:01:22.013Z,1566032482.013 [WetLabsBB2FL](INFO): Powering up
2019-08-17T09:01:22.256Z,1566032482.256 [sci2_flat_and_level:D] Stopped
2019-08-17T09:01:22.256Z,1566032482.256 [sci2_flat_and_level:E] Running Loop=1
2019-08-17T09:01:22.664Z,1566032482.664 [sci2_flat_and_level:E] Stopped
2019-08-17T09:01:22.664Z,1566032482.664 [sci2_flat_and_level:G] Running Loop=1
2019-08-17T09:01:22.861Z,1566032482.861 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-08-17T09:01:23.080Z,1566032483.080 [sci2_flat_and_level:G] Stopped
2019-08-17T09:01:23.080Z,1566032483.080 [sci2_flat_and_level:H] Running Loop=1
2019-08-17T09:01:23.468Z,1566032483.468 [sci2_flat_and_level:H] Stopped
2019-08-17T09:01:23.468Z,1566032483.468 [sci2_flat_and_level:StartingMission] Running Loop=1
2019-08-17T09:01:23.468Z,1566032483.468 [sci2_flat_and_level:StartingMission](DEBUG): Aggregate::initialize sci2_flat_and_level:StartingMission
2019-08-17T09:01:23.469Z,1566032483.469 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2019-08-17T09:01:23.892Z,1566032483.892 [sci2_flat_and_level:SurfaceComms] Running Loop=1
2019-08-17T09:01:23.892Z,1566032483.892 [sci2_flat_and_level:SurfaceComms](DEBUG): Aggregate::initialize sci2_flat_and_level:SurfaceComms
2019-08-17T09:01:23.892Z,1566032483.892 [sci2_flat_and_level:SurfaceComms:A] Running Loop=1
2019-08-17T09:01:23.893Z,1566032483.893 [sci2_flat_and_level:SurfaceComms:A] Stopped
2019-08-17T09:01:23.893Z,1566032483.893 [sci2_flat_and_level:SurfaceComms:B] Running Loop=1
2019-08-17T09:01:23.893Z,1566032483.893 [sci2_flat_and_level:SurfaceComms:B](DEBUG): Aggregate::initialize sci2_flat_and_level:SurfaceComms:B
2019-08-17T09:01:24.287Z,1566032484.287 [sci2_flat_and_level:NeedComms] Running Loop=1
2019-08-17T09:01:24.287Z,1566032484.287 [sci2_flat_and_level:NeedComms](DEBUG): Aggregate::initialize sci2_flat_and_level:NeedComms
2019-08-17T09:01:24.287Z,1566032484.287 [sci2_flat_and_level:NeedComms:B.GoToSurface] Running Loop=1
2019-08-17T09:01:24.287Z,1566032484.287 [sci2_flat_and_level:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-08-17T09:01:24.288Z,1566032484.288 [sci2_flat_and_level:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2019-08-17T09:01:24.288Z,1566032484.288 [sci2_flat_and_level:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2019-08-17T09:01:24.289Z,1566032484.289 [sci2_flat_and_level:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2019-08-17T09:01:24.289Z,1566032484.289 [sci2_flat_and_level:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-08-17T09:01:24.289Z,1566032484.289 [sci2_flat_and_level:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-08-17T09:01:24.290Z,1566032484.290 [sci2_flat_and_level:NeedComms:A] Running Loop=1
2019-08-17T09:01:24.291Z,1566032484.291 [sci2_flat_and_level:NeedComms:A](INFO): last time_fix was: 1566032200.000000 second since 1970/01/01T00:00:00Z 
2019-08-17T09:01:24.291Z,1566032484.291 [sci2_flat_and_level:NeedComms:A] Stopped
2019-08-17T09:01:24.682Z,1566032484.682 [sci2_flat_and_level:NeedComms:C] Running Loop=1
2019-08-17T09:01:25.088Z,1566032485.088 [sci2_flat_and_level:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-08-17T09:01:25.874Z,1566032485.874 [CTD_Seabird](ERROR): Failed to parse device response: <!--startlogging-->
2019-08-17T09:01:26.288Z,1566032486.288 [NAL9602](DEBUG): Fix Requested
2019-08-17T09:01:26.679Z,1566032486.679 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,085938.00,A,4144.36878,N,08318.37687,W,0.369,133.93,170819,,,D*7F
2019-08-17T09:01:26.681Z,1566032486.681 [NAL9602](INFO): GPS fix at 20190817T085938: (41.739480, -83.306281)
2019-08-17T09:01:26.704Z,1566032486.704 [sci2_flat_and_level:NeedComms:C] Stopped
2019-08-17T09:01:26.705Z,1566032486.705 [sci2_flat_and_level:NeedComms:D] Running Loop=1
2019-08-17T09:01:27.135Z,1566032487.135 [sci2_flat_and_level:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-08-17T09:01:27.907Z,1566032487.907 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-17T09:01:32.881Z,1566032492.881 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190817T084154/Courier0010.lzma
2019-08-17T09:01:33.686Z,1566032493.686 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Courier0010.lzma.bak
2019-08-17T09:01:33.686Z,1566032493.686 [DataOverHttps](INFO): SBD MOMSN=11585194
2019-08-17T09:01:45.237Z,1566032505.237 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190817T084154/Courier0015.lzma
2019-08-17T09:01:46.042Z,1566032506.042 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Courier0015.lzma.bak
2019-08-17T09:01:46.042Z,1566032506.042 [DataOverHttps](INFO): SBD MOMSN=11585196
2019-08-17T09:01:47.303Z,1566032507.303 [NAL9602](INFO): SBD MO Status=1, MOMSN=31365, MT Status=0, MTMSN=0
2019-08-17T09:01:47.303Z,1566032507.303 [NAL9602](INFO): No messages in MT queue
2019-08-17T09:01:58.436Z,1566032518.436 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190817T084154/Express0012.lzma
2019-08-17T09:01:59.242Z,1566032519.242 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Express0012.lzma.bak
2019-08-17T09:01:59.242Z,1566032519.242 [DataOverHttps](INFO): SBD MOMSN=11585198
2019-08-17T09:02:12.147Z,1566032532.147 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20190817T084154/Express0016.lzma
2019-08-17T09:02:12.950Z,1566032532.950 [DataOverHttps](INFO): Moved sent file to Logs/20190817T084154/Express0016.lzma.bak
2019-08-17T09:02:12.950Z,1566032532.950 [DataOverHttps](INFO): SBD MOMSN=11585200
2019-08-17T09:02:13.987Z,1566032533.987 [sci2_flat_and_level:NeedComms:D] Stopped
2019-08-17T09:02:13.988Z,1566032533.988 [sci2_flat_and_level:NeedComms:E] Running Loop=1
2019-08-17T09:02:14.406Z,1566032534.406 [sci2_flat_and_level:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-08-17T09:02:15.580Z,1566032535.580 [NAL9602](DEBUG): Fix Requested
2019-08-17T09:02:15.979Z,1566032535.979 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,090027.00,A,4144.36776,N,08318.37614,W,0.486,146.81,170819,,,D*70
2019-08-17T09:02:15.985Z,1566032535.985 [NAL9602](INFO): GPS fix at 20190817T090027: (41.739463, -83.306269)
2019-08-17T09:02:16.016Z,1566032536.016 [sci2_flat_and_level:NeedComms:E] Stopped
2019-08-17T09:02:16.049Z,1566032536.049 [sci2_flat_and_level:NeedComms](INFO): Completed sci2_flat_and_level:NeedComms
2019-08-17T09:02:16.049Z,1566032536.049 [sci2_flat_and_level:NeedComms] Stopped
2019-08-17T09:02:16.049Z,1566032536.049 [sci2_flat_and_level:NeedComms](DEBUG): Aggregate::uninitialize sci2_flat_and_level:NeedComms
2019-08-17T09:02:16.049Z,1566032536.049 [sci2_flat_and_level:NeedComms:B.GoToSurface] Stopped
2019-08-17T09:02:16.049Z,1566032536.049 [sci2_flat_and_level:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-08-17T09:02:16.423Z,1566032536.423 [sci2_flat_and_level:SurfaceComms:B](INFO): Completed sci2_flat_and_level:SurfaceComms:B
2019-08-17T09:02:16.423Z,1566032536.423 [sci2_flat_and_level:SurfaceComms:B] Stopped
2019-08-17T09:02:16.423Z,1566032536.423 [sci2_flat_and_level:SurfaceComms:B](DEBUG): Aggregate::uninitialize sci2_flat_and_level:SurfaceComms:B
2019-08-17T09:02:16.424Z,1566032536.424 [sci2_flat_and_level:SurfaceComms:C] Running Loop=1
2019-08-17T09:02:16.837Z,1566032536.837 [sci2_flat_and_level:SurfaceComms:C] Stopped
2019-08-17T09:02:16.837Z,1566032536.837 [sci2_flat_and_level:SurfaceComms](INFO): Completed sci2_flat_and_level:SurfaceComms
2019-08-17T09:02:16.837Z,1566032536.837 [sci2_flat_and_level:SurfaceComms] Stopped
2019-08-17T09:02:16.837Z,1566032536.837 [sci2_flat_and_level:SurfaceComms](DEBUG): Aggregate::uninitialize sci2_flat_and_level:SurfaceComms
2019-08-17T09:02:17.224Z,1566032537.224 [sci2_flat_and_level:StartingMission](INFO): Completed sci2_flat_and_level:StartingMission
2019-08-17T09:02:17.224Z,1566032537.224 [sci2_flat_and_level:StartingMission] Stopped
2019-08-17T09:02:17.224Z,1566032537.224 [sci2_flat_and_level:StartingMission](DEBUG): Aggregate::uninitialize sci2_flat_and_level:StartingMission
2019-08-17T09:02:17.228Z,1566032537.228 [sci2_flat_and_level:Lap] Running Loop=1
2019-08-17T09:02:17.229Z,1566032537.229 [sci2_flat_and_level:Lap](DEBUG): Aggregate::initialize sci2_flat_and_level:Lap
2019-08-17T09:02:17.229Z,1566032537.229 [sci2_flat_and_level:Lap:Dive] Running Loop=1
2019-08-17T09:02:17.229Z,1566032537.229 [sci2_flat_and_level:Lap:Dive](DEBUG): Aggregate::initialize sci2_flat_and_level:Lap:Dive
2019-08-17T09:02:17.229Z,1566032537.229 [sci2_flat_and_level:Lap:Dive:A] Running Loop=1
2019-08-17T09:02:17.229Z,1566032537.229 [sci2_flat_and_level:Lap:Dive:A](DEBUG): Aggregate::initialize sci2_flat_and_level:Lap:Dive:A
2019-08-17T09:02:17.229Z,1566032537.229 [sci2_flat_and_level:Lap:Wpt1] Running Loop=1
2019-08-17T09:02:17.229Z,1566032537.229 [sci2_flat_and_level:Lap:Wpt1](DEBUG): Aggregate::initialize sci2_flat_and_level:Lap:Wpt1
2019-08-17T09:02:17.229Z,1566032537.229 [sci2_flat_and_level:Lap:Wpt1:A.Waypoint] Running Loop=1
2019-08-17T09:02:17.229Z,1566032537.229 [sci2_flat_and_level:Lap:Wpt1:A.Waypoint](DEBUG): Initialize WaypointComponent.
2019-08-17T09:02:17.633Z,1566032537.633 [sci2_flat_and_level:Lap:Dive] Running Loop=1
2019-08-17T09:02:17.633Z,1566032537.633 [sci2_flat_and_level:DiveCmd] Running Loop=1
2019-08-17T09:02:17.633Z,1566032537.633 [sci2_flat_and_level:DiveCmd](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd
2019-08-17T09:02:17.633Z,1566032537.633 [sci2_flat_and_level:DiveCmd:InitialDive] Running Loop=1
2019-08-17T09:02:17.633Z,1566032537.633 [sci2_flat_and_level:DiveCmd:InitialDive](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:InitialDive
2019-08-17T09:02:17.633Z,1566032537.633 [sci2_flat_and_level:DiveCmd:InitialDive:dive] Running Loop=1
2019-08-17T09:02:17.633Z,1566032537.633 [sci2_flat_and_level:DiveCmd:InitialDive:dive](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:InitialDive:dive
2019-08-17T09:02:17.633Z,1566032537.633 [sci2_flat_and_level:DiveCmd:InitialDive:dive:A] Running Loop=1
2019-08-17T09:02:17.633Z,1566032537.633 [sci2_flat_and_level:DiveCmd:InitialDive:dive:B] Running Loop=1
2019-08-17T09:02:17.633Z,1566032537.633 [sci2_flat_and_level:DiveCmd:InitialDive:dive:C.Mass] Running Loop=1
2019-08-17T09:02:17.634Z,1566032537.634 [sci2_flat_and_level:DiveCmd:InitialDive:dive:C.Mass](DEBUG): Initialize.
2019-08-17T09:02:17.634Z,1566032537.634 [sci2_flat_and_level:DiveCmd:InitialDive:dive:D.Buoyancy] Running Loop=1
2019-08-17T09:02:17.634Z,1566032537.634 [sci2_flat_and_level:DiveCmd:InitialDive:dive:D.Buoyancy](DEBUG): Initialize Buoyancy Component.
2019-08-17T09:02:17.634Z,1566032537.634 [sci2_flat_and_level:DiveCmd:InitialDive:dive:E] Running Loop=1
2019-08-17T09:02:17.634Z,1566032537.634 [sci2_flat_and_level:DiveCmd:SettleAtDepth] Running Loop=1
2019-08-17T09:02:17.634Z,1566032537.634 [sci2_flat_and_level:DiveCmd:SettleAtDepth](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:SettleAtDepth
2019-08-17T09:02:17.634Z,1566032537.634 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive] Running Loop=1
2019-08-17T09:02:17.634Z,1566032537.634 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:SettleAtDepth:dive
2019-08-17T09:02:17.634Z,1566032537.634 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:B.Pitch] Running Loop=1
2019-08-17T09:02:17.635Z,1566032537.635 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:B.Pitch](DEBUG): Initialize.
2019-08-17T09:02:17.635Z,1566032537.635 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:A] Running Loop=1
2019-08-17T09:02:17.635Z,1566032537.635 [sci2_flat_and_level:DiveCmd:MaintainDepth] Running Loop=1
2019-08-17T09:02:17.635Z,1566032537.635 [sci2_flat_and_level:DiveCmd:MaintainDepth](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:MaintainDepth
2019-08-17T09:02:17.635Z,1566032537.635 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive] Running Loop=1
2019-08-17T09:02:17.635Z,1566032537.635 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:MaintainDepth:dive
2019-08-17T09:02:17.635Z,1566032537.635 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:A.Mass] Running Loop=1
2019-08-17T09:02:17.635Z,1566032537.635 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:A.Mass](DEBUG): Initialize.
2019-08-17T09:02:17.635Z,1566032537.635 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.Buoyancy] Running Loop=1
2019-08-17T09:02:17.636Z,1566032537.636 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.Buoyancy](DEBUG): Initialize Buoyancy Component.
2019-08-17T09:02:17.636Z,1566032537.636 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.SetSpeed] Running Loop=1
2019-08-17T09:02:17.636Z,1566032537.636 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.SetSpeed](DEBUG): Initialize.
2019-08-17T09:02:17.636Z,1566032537.636 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:D.Pitch] Running Loop=1
2019-08-17T09:02:17.636Z,1566032537.636 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:D.Pitch](DEBUG): Initialize.
2019-08-17T09:02:17.641Z,1566032537.641 [sci2_flat_and_level:DiveCmd:MaintainDepth] Stopped
2019-08-17T09:02:17.641Z,1566032537.641 [sci2_flat_and_level:DiveCmd:MaintainDepth](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:MaintainDepth
2019-08-17T09:02:17.641Z,1566032537.641 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive] Stopped
2019-08-17T09:02:17.641Z,1566032537.641 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:MaintainDepth:dive
2019-08-17T09:02:17.642Z,1566032537.642 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:A.Mass] Stopped
2019-08-17T09:02:17.642Z,1566032537.642 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:A.Mass](DEBUG): Uninitialize.
2019-08-17T09:02:17.642Z,1566032537.642 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.Buoyancy] Stopped
2019-08-17T09:02:17.642Z,1566032537.642 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2019-08-17T09:02:17.642Z,1566032537.642 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.SetSpeed] Stopped
2019-08-17T09:02:17.642Z,1566032537.642 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.SetSpeed](DEBUG): Uninitialize.
2019-08-17T09:02:17.642Z,1566032537.642 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:D.Pitch] Stopped
2019-08-17T09:02:17.642Z,1566032537.642 [sci2_flat_and_level:DiveCmd:SettleAtDepth] Stopped
2019-08-17T09:02:17.642Z,1566032537.642 [sci2_flat_and_level:DiveCmd:SettleAtDepth](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:SettleAtDepth
2019-08-17T09:02:17.643Z,1566032537.643 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive] Stopped
2019-08-17T09:02:17.643Z,1566032537.643 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:SettleAtDepth:dive
2019-08-17T09:02:17.643Z,1566032537.643 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:A] Stopped
2019-08-17T09:02:17.643Z,1566032537.643 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:B.Pitch] Stopped
2019-08-17T09:02:17.643Z,1566032537.643 [sci2_flat_and_level:DiveCmd:InitialDive] Running Loop=1
2019-08-17T09:02:17.644Z,1566032537.644 [sci2_flat_and_level:DiveCmd:InitialDive:dive:E](INFO): Waiting for 1.000000 min while pumping down to neutral.
2019-08-17T09:02:17.648Z,1566032537.648 [sci2_flat_and_level:DiveCmd:InitialDive:dive:E] Stopped
2019-08-17T09:02:17.648Z,1566032537.648 [sci2_flat_and_level:DiveCmd:InitialDive:dive:F.Wait] Running Loop=1
2019-08-17T09:02:17.649Z,1566032537.649 [sci2_flat_and_level:DiveCmd:InitialDive:dive:F.Wait](DEBUG): Initialize Wait Component.
2019-08-17T09:02:17.649Z,1566032537.649 [sci2_flat_and_level:DiveCmd:InitialDive:dive:D.Buoyancy] Running Loop=1
2019-08-17T09:02:17.649Z,1566032537.649 [sci2_flat_and_level:DiveCmd:InitialDive:dive:C.Mass] Running Loop=1
2019-08-17T09:02:17.649Z,1566032537.649 [sci2_flat_and_level:DiveCmd:InitialDive:dive:B] Running Loop=1
2019-08-17T09:02:17.650Z,1566032537.650 [sci2_flat_and_level:DiveCmd:InitialDive:dive:A] Running Loop=1
2019-08-17T09:02:18.017Z,1566032538.017 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-17T09:02:48.706Z,1566032568.706 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-17T09:03:18.233Z,1566032598.233 [sci2_flat_and_level:DiveCmd:InitialDive:dive:F.Wait](INFO): Done Waiting.
2019-08-17T09:03:18.233Z,1566032598.233 [sci2_flat_and_level:DiveCmd:InitialDive:dive:F.Wait] Stopped
2019-08-17T09:03:18.233Z,1566032598.233 [sci2_flat_and_level:DiveCmd:InitialDive:dive:F.Wait](DEBUG): Uninitialize Wait Component.
2019-08-17T09:03:18.233Z,1566032598.233 [sci2_flat_and_level:DiveCmd:InitialDive:dive:G] Running Loop=1
2019-08-17T09:03:18.641Z,1566032598.641 [sci2_flat_and_level:DiveCmd:InitialDive:dive:G](INFO): Moving to 2.000000 m 
2019-08-17T09:03:18.641Z,1566032598.641 [sci2_flat_and_level:DiveCmd:InitialDive:dive:G] Stopped
2019-08-17T09:03:18.642Z,1566032598.642 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth] Running Loop=1
2019-08-17T09:03:18.642Z,1566032598.642 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth
2019-08-17T09:03:18.642Z,1566032598.642 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed] Running Loop=1
2019-08-17T09:03:18.642Z,1566032598.642 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed](DEBUG): Initialize.
2019-08-17T09:03:18.642Z,1566032598.642 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch] Running Loop=1
2019-08-17T09:03:18.642Z,1566032598.642 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch](DEBUG): Initialize.
2019-08-17T09:03:19.033Z,1566032599.033 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed] Running Loop=1
2019-08-17T09:05:17.847Z,1566032717.847 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.ApproachSettleTimePostDive 2.000000 minute
2019-08-17T09:06:11.159Z,1566032771.159 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch] Stopped
2019-08-17T09:06:11.159Z,1566032771.159 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth](INFO): Completed sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth
2019-08-17T09:06:11.159Z,1566032771.159 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth] Stopped
2019-08-17T09:06:11.160Z,1566032771.160 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth
2019-08-17T09:06:11.160Z,1566032771.160 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed] Stopped
2019-08-17T09:06:11.160Z,1566032771.160 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed](DEBUG): Uninitialize.
2019-08-17T09:06:11.160Z,1566032771.160 [sci2_flat_and_level:DiveCmd:InitialDive:dive:I] Running Loop=1
2019-08-17T09:06:11.569Z,1566032771.569 [sci2_flat_and_level:DiveCmd:InitialDive:dive:I] Stopped
2019-08-17T09:06:11.570Z,1566032771.570 [sci2_flat_and_level:DiveCmd:InitialDive:dive](INFO): Completed sci2_flat_and_level:DiveCmd:InitialDive:dive
2019-08-17T09:06:11.570Z,1566032771.570 [sci2_flat_and_level:DiveCmd:InitialDive:dive] Stopped
2019-08-17T09:06:11.571Z,1566032771.571 [sci2_flat_and_level:DiveCmd:InitialDive:dive](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:InitialDive:dive
2019-08-17T09:06:11.571Z,1566032771.571 [sci2_flat_and_level:DiveCmd:InitialDive:dive:A] Stopped
2019-08-17T09:06:11.571Z,1566032771.571 [sci2_flat_and_level:DiveCmd:InitialDive:dive:B] Stopped
2019-08-17T09:06:11.571Z,1566032771.571 [sci2_flat_and_level:DiveCmd:InitialDive:dive:C.Mass] Stopped
2019-08-17T09:06:11.571Z,1566032771.571 [sci2_flat_and_level:DiveCmd:InitialDive:dive:C.Mass](DEBUG): Uninitialize.
2019-08-17T09:06:11.571Z,1566032771.571 [sci2_flat_and_level:DiveCmd:InitialDive:dive:D.Buoyancy] Stopped
2019-08-17T09:06:11.571Z,1566032771.571 [sci2_flat_and_level:DiveCmd:InitialDive:dive:D.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2019-08-17T09:06:11.571Z,1566032771.571 [sci2_flat_and_level:DiveCmd:InitialDive](INFO): Completed sci2_flat_and_level:DiveCmd:InitialDive
2019-08-17T09:06:11.981Z,1566032771.981 [sci2_flat_and_level:DiveCmd:SettleAtDepth] Running Loop=1
2019-08-17T09:06:11.981Z,1566032771.981 [sci2_flat_and_level:DiveCmd:SettleAtDepth](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:SettleAtDepth
2019-08-17T09:06:11.982Z,1566032771.982 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive] Running Loop=1
2019-08-17T09:06:11.982Z,1566032771.982 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:SettleAtDepth:dive
2019-08-17T09:06:11.982Z,1566032771.982 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:B.Pitch] Running Loop=1
2019-08-17T09:06:11.982Z,1566032771.982 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:B.Pitch](DEBUG): Initialize.
2019-08-17T09:06:11.982Z,1566032771.982 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:A] Running Loop=1
2019-08-17T09:06:11.982Z,1566032771.982 [sci2_flat_and_level:DiveCmd:SettleAtDepth] Running Loop=1
2019-08-17T09:06:11.982Z,1566032771.982 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:B.Pitch] Running Loop=1
2019-08-17T09:06:11.983Z,1566032771.983 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:A](INFO): Reached 2.067576 m , settling for 2.000000 min 
2019-08-17T09:06:11.983Z,1566032771.983 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:A] Stopped
2019-08-17T09:06:11.984Z,1566032771.984 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:C.Wait] Running Loop=1
2019-08-17T09:06:11.984Z,1566032771.984 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:C.Wait](DEBUG): Initialize Wait Component.
2019-08-17T09:06:17.417Z,1566032777.417 [BuoyancyServo](ERROR): getPosition uart error serial timeout
2019-08-17T09:06:17.417Z,1566032777.417 [BuoyancyServo](FAULT): Buoyancy getPosition uart error.serial timeout
2019-08-17T09:06:17.417Z,1566032777.417 [BuoyancyServo] Communications Fault, FailCount= 1
2019-08-17T09:06:17.417Z,1566032777.417 [BuoyancyServo](ERROR): Communications Fault
2019-08-17T09:06:17.462Z,1566032777.462 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-08-17T09:06:19.366Z,1566032779.366 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-08-17T09:06:19.366Z,1566032779.366 [BuoyancyServo](INFO): Powering down
2019-08-17T09:06:20.228Z,1566032780.228 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-08-17T09:06:20.228Z,1566032780.228 [BuoyancyServo] No Fault, FailCount= 1
2019-08-17T09:06:20.585Z,1566032780.585 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-08-17T09:06:20.586Z,1566032780.586 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-08-17T09:06:52.713Z,1566032812.713 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-17T09:07:23.417Z,1566032843.417 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-17T09:07:54.121Z,1566032874.121 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-17T09:08:12.578Z,1566032892.578 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:C.Wait](INFO): Done Waiting.
2019-08-17T09:08:12.578Z,1566032892.578 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:C.Wait] Stopped
2019-08-17T09:08:12.578Z,1566032892.578 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-17T09:08:12.578Z,1566032892.578 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:D] Running Loop=1
2019-08-17T09:08:12.981Z,1566032892.981 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:D] Stopped
2019-08-17T09:08:12.981Z,1566032892.981 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive](INFO): Completed sci2_flat_and_level:DiveCmd:SettleAtDepth:dive
2019-08-17T09:08:12.981Z,1566032892.981 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive] Stopped
2019-08-17T09:08:12.982Z,1566032892.982 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:SettleAtDepth:dive
2019-08-17T09:08:12.982Z,1566032892.982 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:B.Pitch] Stopped
2019-08-17T09:08:12.982Z,1566032892.982 [sci2_flat_and_level:DiveCmd:SettleAtDepth](INFO): Completed sci2_flat_and_level:DiveCmd:SettleAtDepth
2019-08-17T09:08:13.389Z,1566032893.389 [sci2_flat_and_level:DiveCmd:MaintainDepth] Running Loop=1
2019-08-17T09:08:13.389Z,1566032893.389 [sci2_flat_and_level:DiveCmd:MaintainDepth](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:MaintainDepth
2019-08-17T09:08:13.389Z,1566032893.389 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive] Running Loop=1
2019-08-17T09:08:13.389Z,1566032893.389 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive](DEBUG): Aggregate::initialize sci2_flat_and_level:DiveCmd:MaintainDepth:dive
2019-08-17T09:08:13.389Z,1566032893.389 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:A.Mass] Running Loop=1
2019-08-17T09:08:13.389Z,1566032893.389 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:A.Mass](DEBUG): Initialize.
2019-08-17T09:08:13.389Z,1566032893.389 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.Buoyancy] Running Loop=1
2019-08-17T09:08:13.390Z,1566032893.390 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.Buoyancy](DEBUG): Initialize Buoyancy Component.
2019-08-17T09:08:13.390Z,1566032893.390 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.SetSpeed] Running Loop=1
2019-08-17T09:08:13.390Z,1566032893.390 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.SetSpeed](DEBUG): Initialize.
2019-08-17T09:08:13.390Z,1566032893.390 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:D.Pitch] Running Loop=1
2019-08-17T09:08:13.390Z,1566032893.390 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:D.Pitch](DEBUG): Initialize.
2019-08-17T09:08:13.390Z,1566032893.390 [sci2_flat_and_level:DiveCmd:MaintainDepth] Running Loop=1
2019-08-17T09:08:13.390Z,1566032893.390 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive] Running Loop=1
2019-08-17T09:08:13.390Z,1566032893.390 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:D.Pitch] Running Loop=1
2019-08-17T09:08:13.391Z,1566032893.391 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.SetSpeed] Running Loop=1
2019-08-17T09:08:13.391Z,1566032893.391 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.Buoyancy] Running Loop=1
2019-08-17T09:08:13.391Z,1566032893.391 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:A.Mass] Running Loop=1
2019-08-17T09:11:24.990Z,1566033084.990 [RudderServo](FAULT): Overload Error
2019-08-17T09:11:24.990Z,1566033084.990 [RudderServo] Hardware Fault, FailCount= 1
2019-08-17T09:11:24.991Z,1566033084.991 [RudderServo](ERROR): Hardware Fault
2019-08-17T09:11:25.057Z,1566033085.057 [CBIT](ERROR): Hardware Fault in component: RudderServo
2019-08-17T09:11:25.425Z,1566033085.425 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-08-17T09:11:25.425Z,1566033085.425 [RudderServo](INFO): Powering down
2019-08-17T09:11:25.997Z,1566033085.997 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-17T09:11:26.092Z,1566033086.092 [RudderServo](DEBUG): Initializing EZServoServo.
2019-08-17T09:11:26.209Z,1566033086.209 [RudderServo](DEBUG): Initializing RudderServo.
2019-08-17T09:11:26.240Z,1566033086.240 [CBIT](INFO): Clearing failed state for component RudderServo
2019-08-17T09:11:26.240Z,1566033086.240 [RudderServo] No Fault, FailCount= 1
2019-08-17T09:11:52.420Z,1566033112.420 [Radio_Surface](INFO): Powering down
2019-08-17T09:11:56.702Z,1566033116.702 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-17T09:11:57.105Z,1566033117.105 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2019-08-17T09:13:21.972Z,1566033201.972 [sci2_flat_and_level](INFO): Timed out from 2019-08-17T09:01:21.9Z
2019-08-17T09:13:21.972Z,1566033201.972 [MissionManager](INFO): sci2_flat_and_level is completed.
2019-08-17T09:13:21.972Z,1566033201.972 [MissionManager](INFO): Uninitializing Mission sci2_flat_and_level
2019-08-17T09:13:21.972Z,1566033201.972 [sci2_flat_and_level] Stopped
2019-08-17T09:13:21.972Z,1566033201.972 [sci2_flat_and_level](DEBUG): Aggregate::uninitialize sci2_flat_and_level
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:Science] Stopped
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:Science](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:Science:A] Stopped
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:Science:C] Stopped
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:Science:D] Stopped
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:Science:G] Stopped
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:StandardEnvelopes] Stopped
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:StandardEnvelopes](DEBUG): Aggregate::uninitialize sci2_flat_and_level:StandardEnvelopes
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope] Stopped
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2019-08-17T09:13:21.973Z,1566033201.973 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2019-08-17T09:13:21.974Z,1566033201.974 [sci2_flat_and_level:DiveCmd] Stopped
2019-08-17T09:13:21.974Z,1566033201.974 [sci2_flat_and_level:DiveCmd](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd
2019-08-17T09:13:21.974Z,1566033201.974 [sci2_flat_and_level:DiveCmd:InitialDive] Stopped
2019-08-17T09:13:21.974Z,1566033201.974 [sci2_flat_and_level:DiveCmd:InitialDive](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:InitialDive
2019-08-17T09:13:21.974Z,1566033201.974 [sci2_flat_and_level:DiveCmd:SettleAtDepth] Stopped
2019-08-17T09:13:21.974Z,1566033201.974 [sci2_flat_and_level:DiveCmd:SettleAtDepth](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:SettleAtDepth
2019-08-17T09:13:21.974Z,1566033201.974 [sci2_flat_and_level:DiveCmd:MaintainDepth] Stopped
2019-08-17T09:13:21.974Z,1566033201.974 [sci2_flat_and_level:DiveCmd:MaintainDepth](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:MaintainDepth
2019-08-17T09:13:21.974Z,1566033201.974 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive] Stopped
2019-08-17T09:13:21.974Z,1566033201.974 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive](DEBUG): Aggregate::uninitialize sci2_flat_and_level:DiveCmd:MaintainDepth:dive
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:A.Mass] Stopped
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:A.Mass](DEBUG): Uninitialize.
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.Buoyancy] Stopped
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.SetSpeed] Stopped
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.SetSpeed](DEBUG): Uninitialize.
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:D.Pitch] Stopped
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:Lap] Stopped
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:Lap](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Lap
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:Lap:Dive] Stopped
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:Lap:Dive](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Lap:Dive
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:Lap:Dive:A] Stopped
2019-08-17T09:13:21.975Z,1566033201.975 [sci2_flat_and_level:Lap:Dive:A](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Lap:Dive:A
2019-08-17T09:13:21.976Z,1566033201.976 [sci2_flat_and_level:Lap:Wpt1] Stopped
2019-08-17T09:13:21.976Z,1566033201.976 [sci2_flat_and_level:Lap:Wpt1](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Lap:Wpt1
2019-08-17T09:13:21.976Z,1566033201.976 [sci2_flat_and_level:Lap:Wpt1:A.Waypoint] Stopped
2019-08-17T09:13:21.976Z,1566033201.976 [sci2_flat_and_level:Lap:Wpt1:A.Waypoint](DEBUG): Uninitialize WaypointComponent.
2019-08-17T09:13:22.205Z,1566033202.205 [WetLabsBB2FL](INFO): Powering down
2019-08-17T09:13:22.375Z,1566033202.375 [MissionManager](IMPORTANT): Started mission Default
2019-08-17T09:13:22.375Z,1566033202.375 [Default] Running Loop=1
2019-08-17T09:13:22.376Z,1566033202.376 [Default](DEBUG): Aggregate::initialize Default
2019-08-17T09:13:22.376Z,1566033202.376 [Default:B.GoToSurface] Running Loop=1
2019-08-17T09:13:22.376Z,1566033202.376 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-08-17T09:13:22.380Z,1566033202.380 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-08-17T09:13:22.381Z,1566033202.381 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-08-17T09:13:22.381Z,1566033202.381 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-08-17T09:13:22.381Z,1566033202.381 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-08-17T09:13:22.382Z,1566033202.382 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-08-17T09:13:22.382Z,1566033202.382 [Default:A.Wait] Running Loop=1
2019-08-17T09:13:22.382Z,1566033202.382 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-08-17T09:13:22.924Z,1566033202.924 [Radio_Surface](INFO): Powering up
2019-08-17T09:13:23.128Z,1566033203.128 [Aanderaa_O2](INFO): Powering down
2019-08-17T09:13:28.417Z,1566033208.417 [DataOverHttps](INFO): Radio surface powered ON.
2019-08-17T09:13:32.869Z,1566033212.869 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=180.232132
2019-08-17T09:13:35.605Z,1566033215.605 [Default:A.Wait](INFO): Done Waiting.
2019-08-17T09:13:35.605Z,1566033215.605 [Default:A.Wait] Stopped
2019-08-17T09:13:35.605Z,1566033215.605 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-08-17T09:14:29.049Z,1566033269.049 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-17T09:14:48.726Z,1566033288.726 [Default:CheckIn] Running Loop=1
2019-08-17T09:14:48.726Z,1566033288.726 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-17T09:14:48.726Z,1566033288.726 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-17T09:14:50.328Z,1566033290.328 [NAL9602](DEBUG): Fix Requested
2019-08-17T09:14:59.754Z,1566033299.754 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-17T09:15:11.789Z,1566033311.789 [NAL9602](INFO): SBD MO Status=1, MOMSN=31366, MT Status=0, MTMSN=0
2019-08-17T09:15:11.789Z,1566033311.789 [NAL9602](INFO): No messages in MT queue
2019-08-17T09:15:12.616Z,1566033312.616 [NAL9602](DEBUG): Fix Requested
2019-08-17T09:15:13.005Z,1566033313.005 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,091323.00,A,4144.40528,N,08318.47818,W,1.069,243.35,170819,,,A*73
2019-08-17T09:15:13.007Z,1566033313.007 [NAL9602](INFO): GPS fix at 20190817T091323: (41.740088, -83.307970)
2019-08-17T09:15:13.063Z,1566033313.063 [Default:CheckIn:Read_GPS] Stopped
2019-08-17T09:15:13.063Z,1566033313.063 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-17T09:15:14.223Z,1566033314.223 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-17T09:15:27.203Z,1566033327.203 [NAL9602](INFO): SBD MO Status=1, MOMSN=31367, MT Status=0, MTMSN=0
2019-08-17T09:15:27.253Z,1566033327.253 [NAL9602](INFO): Sent 63 bytes from file Logs/20190817T084154/Courier0018.lzma
2019-08-17T09:15:27.253Z,1566033327.253 [NAL9602](INFO): Packets left to send: 0
2019-08-17T09:15:30.489Z,1566033330.489 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-17T09:15:38.333Z,1566033338.333 [NAL9602](INFO): SBD MO Status=1, MOMSN=31368, MT Status=0, MTMSN=0
2019-08-17T09:15:38.381Z,1566033338.381 [NAL9602](INFO): Sent 332 bytes from file Logs/20190817T084154/Express0019.lzma
2019-08-17T09:15:38.381Z,1566033338.381 [NAL9602](INFO): Packets left to send: 3
2019-08-17T09:15:48.375Z,1566033348.375 [NAL9602](INFO): SBD MO Status=1, MOMSN=31369, MT Status=0, MTMSN=0
2019-08-17T09:15:48.433Z,1566033348.433 [NAL9602](INFO): Sent 332 bytes from file Logs/20190817T084154/Express0019.lzma
2019-08-17T09:15:48.433Z,1566033348.433 [NAL9602](INFO): Packets left to send: 2
2019-08-17T09:15:56.310Z,1566033356.310 [NAL9602](INFO): SBD MO Status=1, MOMSN=31370, MT Status=0, MTMSN=0
2019-08-17T09:15:56.361Z,1566033356.361 [NAL9602](INFO): Sent 332 bytes from file Logs/20190817T084154/Express0019.lzma
2019-08-17T09:15:56.361Z,1566033356.361 [NAL9602](INFO): Packets left to send: 1
2019-08-17T09:16:01.193Z,1566033361.193 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-17T09:16:04.617Z,1566033364.617 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=31371, MT Status=1, MTMSN=2056
2019-08-17T09:16:04.693Z,1566033364.693 [NAL9602](INFO): Sent 114 bytes from file Logs/20190817T084154/Express0019.lzma
2019-08-17T09:16:04.693Z,1566033364.693 [NAL9602](INFO): Packets left to send: 0
2019-08-17T09:16:05.161Z,1566033365.161 [NAL9602](INFO): Received command:configSet BuoyancyServo.fastPumpDepth 6 meter persist
2019-08-17T09:16:05.390Z,1566033365.390 [CommandLine](IMPORTANT): got command configSet BuoyancyServo.fastPumpDepth 6.000000 meter persist
2019-08-17T09:16:12.409Z,1566033372.409 [NAL9602](INFO): SBD MO Status=0, MOMSN=31372, MT Status=0, MTMSN=0
2019-08-17T09:16:22.583Z,1566033382.583 [NAL9602](INFO): SBD MO Status=1, MOMSN=31373, MT Status=0, MTMSN=0
2019-08-17T09:16:22.646Z,1566033382.646 [NAL9602](INFO): Sent 25 bytes from file Logs/20190817T084154/Courier0021.lzma
2019-08-17T09:16:22.646Z,1566033382.646 [NAL9602](INFO): Packets left to send: 0
2019-08-17T09:16:30.479Z,1566033390.479 [NAL9602](INFO): SBD MO Status=1, MOMSN=31374, MT Status=0, MTMSN=0
2019-08-17T09:16:30.529Z,1566033390.529 [NAL9602](INFO): Sent 205 bytes from file Logs/20190817T084154/Express0022.lzma
2019-08-17T09:16:30.529Z,1566033390.529 [NAL9602](INFO): Packets left to send: 0
2019-08-17T09:16:31.897Z,1566033391.897 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-17T09:16:37.429Z,1566033397.429 [NAL9602](INFO): SBD MO Status=0, MOMSN=31375, MT Status=0, MTMSN=0
2019-08-17T09:16:37.535Z,1566033397.535 [Default:CheckIn:Read_Iridium] Stopped
2019-08-17T09:16:37.535Z,1566033397.535 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-17T09:16:37.535Z,1566033397.535 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-17T09:16:58.660Z,1566033418.660 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003144
2019-08-17T09:17:08.137Z,1566033428.137 [NAL9602](INFO): Not Powering down - fast GPS