the8x3_filename: 01410002 full_filename: ramses-2018-249-7-2 4954 20 01410002.mlg LOG FILE OPENED Megabytes used on CF file system = 231.625000 Megabytes available on CF file system = 1769.312500 4957 init_gps_input() 4957 behavior surface_7: SUBSTATE 7 ->9 : Waiting for final gps fix 4958 disabling Iridium console... 4980 24 sensor: m_gps_status = 2 enum 4980 sensor: m_gps_invalid_lat = 3558.0122 lat 4980 sensor: m_gps_invalid_lon = -7523.7109 lon 4981 sensor: m_gps_status = 2 enum 4981 sensor: m_gps_invalid_lat = 3558.0122 lat 4981 sensor: m_gps_invalid_lon = -7523.7109 lon 4984 25 sensor: m_gps_status = 2 enum 4985 sensor: m_gps_invalid_lat = 3558.0122 lat 4985 sensor: m_gps_invalid_lon = -7523.7109 lon 4990 25 sensor: m_gps_status = 1 enum 4990 sensor: m_gps_ignored_lat = 3558.0802 lat 4990 sensor: m_gps_ignored_lon = -7524.8507 lon 4995 26 sensor: m_gps_status = 1 enum 4995 sensor: m_gps_ignored_lat = 3558.0798 lat 4995 sensor: m_gps_ignored_lon = -7524.8508 lon 5000 28 sensor: m_gps_status = 1 enum 5000 sensor: m_gps_ignored_lat = 3558.0798 lat 5000 sensor: m_gps_ignored_lon = -7524.8508 lon 5005 29 sensor: m_gps_status = 1 enum 5005 sensor: m_gps_ignored_lat = 3558.0798 lat 5005 sensor: m_gps_ignored_lon = -7524.8508 lon 5010 29 sensor: m_gps_status = 1 enum 5010 sensor: m_gps_ignored_lat = 3558.0798 lat 5010 sensor: m_gps_ignored_lon = -7524.8508 lon 5015 30 sensor: m_gps_lat = 3558.0798 lat 5015 sensor: m_gps_lon = -7524.8508 lon 5015 sensor: m_gps_status = 0 enum 5020 32 end_gps_input() 5020 behavior surface_7: SUBSTATE 9 ->11 : All done 5020 behavior surface_7: STATE Active -> UnInited 5020 sensor: m_gps_lat = 3558.0798 lat 5020 sensor: m_gps_lon = -7524.8508 lon 5020 sensor: m_gps_status = 0 enum 5025 33 behavior surface_7: Reading b_args from surfac99.ma 5025 behavior surface_7: start_when(enum)=9.000000 5025 behavior surface_7: when_secs(s)=900.000000 5025 behavior surface_7: end_action(enum)=1.000000 5025 behavior surface_7: report_all(bool)=1.000000 5025 behavior surface_7: gps_wait_time(s)=300.000000 5025 behavior surface_7: keystroke_wait_time(s)=300.000000 5025 behavior surface_7: STATE UnInited -> Waiting for Activation 5025 behavior surface_7: argument: args_from_file = 99.000000 enum 5025 behavior surface_7: argument: start_when = 9.000000 enum 5025 behavior surface_7: argument: when_secs = 900.000000 sec 5025 behavior surface_7: argument: when_wpt_dist = 10.000000 m 5025 behavior surface_7: argument: end_action = 1.000000 enum 5025 behavior surface_7: argument: report_all = 1.000000 bool 5025 behavior surface_7: argument: gps_wait_time = 300.000000 sec 5025 behavior surface_7: argument: keystroke_wait_time = 300.000000 sec 5025 behavior surface_7: argument: end_wpt_dist = 0.000000 m 5025 behavior surface_7: argument: c_use_bpump = 2.000000 enum 5026 behavior surface_7: argument: c_bpump_value = 1000.000000 X 5026 behavior surface_7: argument: c_use_pitch = 3.000000 enum 5026 behavior surface_7: argument: c_pitch_value = 0.436300 X 5026 behavior surface_7: argument: printout_cycle_time = 60.000000 sec 5026 behavior surface_7: argument: gps_postfix_wait_time = 60.000000 sec 5026 behavior surface_7: argument: force_iridium_use = 0.000000 nodim 5026 behavior surface_7: argument: min_time_between_gps_fixes = 300.000000 sec 5026 behavior surface_7: argument: sensor_input_wait_time = 10.000000 sec 5026 behavior surface_7: argument: when_utc_min = -1.000000 min 5026 behavior surface_7: argument: when_utc_hour = -1.000000 hour 5026 behavior surface_7: argument: when_utc_day = -1.000000 day 5026 behavior surface_7: argument: when_utc_month = -1.000000 month 5026 behavior surface_7: argument: when_utc_on_surface = 0.000000 bool 5026 behavior surface_7: argument: strobe_on = 0.000000 bool 5026 behavior surface_7: STATE Waiting for Activation -> Active 5026 behavior surface_7: SUBSTATE 0 UnInited->1 : climb_to the surface 5030 behavior climb_to_701: STATE UnInited -> Active 5030 behavior climb_to_701: argument: target_depth = 2.000000 m 5030 behavior climb_to_701: argument: target_altitude = -1.000000 m 5030 behavior climb_to_701: argument: use_bpump = 2.000000 enum 5030 behavior climb_to_701: argument: bpump_value = 1000.000000 X 5030 behavior climb_to_701: argument: use_pitch = 3.000000 enum 5030 behavior climb_to_701: argument: pitch_value = 0.436300 X 5030 behavior climb_to_701: argument: start_when = 0.000000 enum 5030 behavior climb_to_701: argument: stop_when_hover_for = -1.000000 sec 5030 behavior climb_to_701: argument: stop_when_stalled_for = -1.000000 sec 5031 behavior climb_to_701: argument: initial_inflection = 1.000000 bool 5031 behavior climb_to_701: argument: speed_min = 100.000000 m/s 5031 behavior climb_to_701: argument: speed_max = -100.000000 m/s 5031 behavior climb_to_701: SUBSTATE 0 UnInited->1 : waiting for initial depth reading 5031 behavior climb_to_701: SUBSTATE 1 ->3 : Starting the climb 5031 behavior climb_to_701: SUBSTATE 3 ->4 : climbing 5031 behavior climb_to_701: SUBSTATE 4 ->5 : Complete reached depth 5031 behavior climb_to_701: STATE Active -> Complete 5031 behavior surface_7: SUBSTATE 1 ->2 : waiting for various sensors 5031 sensor: m_gps_lat = 3558.0798 lat 5031 sensor: m_gps_lon = -7524.8508 lon 5031 sensor: m_gps_status = 0 enum 5031 sensor: m_gps_lat = 3558.0798 lat 5031 sensor: m_gps_lon = -7524.8508 lon 5031 sensor: m_gps_status = 0 enum 5031 sensor: m_air_pump = 1 bool 5032 sensor: m_fin = 0.003105015 rad 5032 sensor: m_vacuum = 5.00048388278388 inHg 5032 sensor: m_battery = 15.2825325115158 volts 5032 sensor: m_pressure = 0.00941187827304038 bar 5032 sensor: m_depth = 0.0941187827304038 m 5032 sensor: m_battpos = 1.11512047212047 in 5032 sensor: m_air_pump = 1 bool 5032 sensor: m_leakdetect_voltage = 2.5 volts 5033 sensor: m_pitch = -0.10471975511966 rad 5033 sensor: m_roll = -0.113446401379631 rad 5033 sensor: m_heading = 0.78190750489346 rad 5035 33 sensor: m_gps_lat = 3558.0798 lat 5035 sensor: m_gps_lon = -7524.8508 lon 5035 sensor: m_gps_status = 0 enum 5036 sensor: m_raw_altitude = 23.1514041514041 m 5040 34 sensor: m_gps_lat = 3558.0798 lat 5040 sensor: m_gps_lon = -7524.8508 lon 5041 sensor: m_gps_status = 0 enum 5043 sensor: m_gps_lat = 3558.0798 lat 5043 sensor: m_gps_lon = -7524.8508 lon 5043 sensor: m_gps_status = 0 enum 5043 sensor: m_water_pressure = 0.017 bar 5045 36 behavior surface_7: SUBSTATE 2 ->3 : waiting for GPS fix 5045 init_gps_input() 5054 37 sensor: m_gps_lat = 3558.0798 lat 5054 sensor: m_gps_lon = -7524.8508 lon 5054 sensor: m_gps_status = 0 enum 5054 sensor: m_gps_lat = 3558.0798 lat 5054 sensor: m_gps_lon = -7524.8508 lon 5054 sensor: m_gps_status = 0 enum 5059 37 end_gps_input() 5059 init_gps_input() 5059 behavior surface_7: SUBSTATE 3 ->4 : Picking iridium or freewave 5059 behavior surface_7: SUBSTATE 4 ->5 : Waiting for more gps fixes 5059 sensor: m_gps_lat = 3558.084 lat 5059 sensor: m_gps_lon = -7524.8682 lon 5059 sensor: m_gps_status = 0 enum 5064 38 end_gps_input() 5064 behavior surface_7: SUBSTATE 5 ->7 : waiting for control-C to exit/resume 5064 sensor: m_gps_lat = 3558.084 lat 5064 sensor: m_gps_lon = -7524.8682 lon 5064 sensor: m_gps_status = 0 enum 5069 40 sensor: m_gps_lat = 3558.084 lat 5069 sensor: m_gps_lon = -7524.8682 lon 5069 sensor: m_gps_status = 0 enum 5075 41 Iridium has been powered on for 5.0 secs 5075 Waking up Iridium... sending:ATE1 5075 Iridium, modem making attempt #1 at primary number (881600005168) 5080 41 Iridium driver received:[ATE1[0D][0D]] 5080 Iridium modem matched: OK 5080 Waking up Iridium... sending:AT+cbst=6,0,1 5085 42 Iridium driver received:[AT+cbst=6,0,1[0D][0D]] 5085 Iridium modem matched: OK 5085 Waking up Iridium... sending:AT+CSQ 5096 45 Iridium driver received:[AT+CSQ[0D]] 5096 Iridium driver received:[[0D][0A]+CSQ:5[0D][0A][0D]] 5096 Iridium modem matched: OK 5101 46 Obtaining Iridium RSSI... 5101 Iridium dialing [ATD00881600005168]........... 5101 Iridium waiting for connection... 5106 46 Iridium driver received:[ATD00881600005168[0D]] 5111 48 Iridium driver received:[[0D]] 5111 Iridium modem matched: CONNECT 4800 5111 Iridium connected... 5111 Iridium console active and ready... Vehicle Name: ramses Curr Time: Fri Sep 7 18:38:22 2018 MT: 5110 DR Location: 3558.084 N -7524.868 E measured 38.879 secs ago GPS TooFar: 3558.246 N -7523.074 E measured 1e+308 secs ago GPS Invalid : 3558.012 N -7523.711 E measured 126.364 secs ago GPS Location: 3558.084 N -7524.868 E measured 41.459 secs ago sensor:c_wpt_lat(lat)=3557.48439 4944.39 secs ago sensor:c_wpt_lon(lon)=-7520.3609 4944.46 secs ago sensor:m_battery(volts)=15.2794191871042 15.56 secs ago sensor:m_gps_lat(lat)=3558.084 41.889 secs ago sensor:m_gps_lon(lon)=-7524.8682 41.945 secs ago sensor:m_iridium_signal_strength(nodim)=5 10.86 secs ago sensor:m_leakdetect_voltage(volts)=2.5 15.743 secs ago sensor:m_leakdetect_voltage_forward(volts)=-1 5.82 secs ago sensor:m_mission_start_time(timestamp)=1536340391 1e+308 secs ago sensor:m_present_time(timestamp)=1536345501.36319 1.786 secs ago sensor:m_tot_num_inflections(nodim)=42482 79.127 secs ago sensor:m_vacuum(inHg)=5.00048388278388 79.61 secs ago sensor:m_water_vx(m/s)=-0.0690686577646066 3951.66 secs ago sensor:m_water_vy(m/s)=0.0561906144111058 3951.72 secs ago sensor:u_use_current_correction(nodim)=1 1e+308 secs ago sensor:x_last_wpt_lat(lat)=3558.21502413708 1e+308 secs ago sensor:x_last_wpt_lon(lon)=-7523.21928720985 1e+308 secs ago ABORT HISTORY: total since reset: 1 ABORT HISTORY: last abort cause: MS_ABORT_OVERTIME ABORT HISTORY: last abort details: ABORT HISTORY: last abort time: 2018-09-07T15:32:04 ABORT HISTORY: last abort segment: ramses-2018-249-4-0 (0138.0000) ABORT HISTORY: last abort mission: INI4.MI 5112 No login script found for processing. 5112 DRIVER_ODDITY:iridium:1508:xxx_ctrl() ran too long 5126 50 Iridium driver received:[[0D]] 5126 Iridium modem matched: NO CARRIER 5126 disabling Iridium console... 5126 DRIVER_ODDITY:iridium:1:retry due to Iridium reporting NO CARRIER 5126 DRIVER_ODDITY:iridium:0:secs; cycling Iridium power 5136 53 Iridium has been powered on for 5.1 secs 5136 Waking up Iridium... sending:ATE1 5136 Iridium, modem making attempt #2 at primary number (881600005168) 5144 54 Iridium driver received:[ATE1[0D][0D]] 5144 Iridium modem matched: OK 5144 Waking up Iridium... sending:AT+cbst=6,0,1 5149 54 Iridium driver received:[AT+cbst=6,0,1[0D][0D]] 5149 Iridium modem matched: OK 5149 Waking up Iridium... sending:AT+CSQ 5159 57 Iridium driver received:[AT+CSQ[0D]] 5159 Iridium driver received:[[0D][0A]+CSQ:5[0D][0A][0D]] 5159 Iridium modem matched: OK 5164 58 Obtaining Iridium RSSI... 5164 Iridium dialing [ATD00881600005168]........... 5164 Iridium waiting for connection... 5169 58 Iridium driver received:[ATD00881600005168[0D]] 5174 59 Iridium driver received:[[0D]] 5175 Iridium modem matched: CONNECT 4800 5175 Iridium connected... 5175 Iridium console active and ready... Vehicle Name: ramses Curr Time: Fri Sep 7 18:39:26 2018 MT: 5174 DR Location: 3558.084 N -7524.868 E measured 102.622 secs ago GPS TooFar: 3558.246 N -7523.074 E measured 1e+308 secs ago GPS Invalid : 3558.012 N -7523.711 E measured 190.107 secs ago GPS Location: 3558.084 N -7524.868 E measured 105.203 secs ago sensor:c_wpt_lat(lat)=3557.48439 5008.13 secs ago sensor:c_wpt_lon(lon)=-7520.3609 5008.21 secs ago sensor:m_battery(volts)=15.2768106017271 15.564 secs ago sensor:m_gps_lat(lat)=3558.084 105.632 secs ago sensor:m_gps_lon(lon)=-7524.8682 105.689 secs ago sensor:m_iridium_signal_strength(nodim)=5 10.865 secs ago sensor:m_leakdetect_voltage(volts)=2.5 15.745 secs ago sensor:m_leakdetect_voltage_forward(volts)=-1 5.816 secs ago sensor:m_mission_start_time(timestamp)=1536340391 1e+308 secs ago sensor:m_present_time(timestamp)=1536345565.1077 1.78 secs ago sensor:m_tot_num_inflections(nodim)=42482 142.864 secs ago sensor:m_vacuum(inHg)=7.17080961538461 21.089 secs ago sensor:m_water_vx(m/s)=-0.0690686577646066 4015.4 secs ago sensor:m_water_vy(m/s)=0.0561906144111058 4015.45 secs ago sensor:u_use_current_correction(nodim)=1 1e+308 secs ago sensor:x_last_wpt_lat(lat)=3558.21502413708 1e+308 secs ago sensor:x_last_wpt_lon(lon)=-7523.21928720985 1e+308 secs ago ABORT HISTORY: total since reset: 1 ABORT HISTORY: last abort cause: MS_ABORT_OVERTIME ABORT HISTORY: last abort details: ABORT HISTORY: last abort time: 2018-09-07T15:32:04 ABORT HISTORY: last abort segment: ramses-2018-249-4-0 (0138.0000) ABORT HISTORY: last abort mission: INI4.MI 5176 No login script found for processing. 5176 DRIVER_ODDITY:iridium:1509:xxx_ctrl() ran too long 5233 71 01410002.mlg LOG FILE CLOSED