// -*- tab-width: 4; Mode: C++; c-basic-offset: 4; indent-tabs-mode: nil -*- #include "Plane.h" #if LOGGING_ENABLED == ENABLED #if CLI_ENABLED == ENABLED // Code to Write and Read packets from DataFlash.log memory // Code to interact with the user to dump or erase logs // Creates a constant array of structs representing menu options // and stores them in Flash memory, not RAM. // User enters the string in the console to call the functions on the right. // See class Menu in AP_Coommon for implementation details static const struct Menu::command log_menu_commands[] PROGMEM = { {"dump", MENU_FUNC(dump_log)}, {"erase", MENU_FUNC(erase_logs)}, {"enable", MENU_FUNC(select_logs)}, {"disable", MENU_FUNC(select_logs)} }; // A Macro to create the Menu MENU2(log_menu, "Log", log_menu_commands, FUNCTOR_BIND(&plane, &Plane::print_log_menu, bool)); bool Plane::print_log_menu(void) { cliSerial->println_P(PSTR("logs enabled: ")); if (0 == g.log_bitmask) { cliSerial->println_P(PSTR("none")); }else{ // Macro to make the following code a bit easier on the eye. // Pass it the capitalised name of the log option, as defined // in defines.h but without the LOG_ prefix. It will check for // the bit being set and print the name of the log option to suit. #define PLOG(_s) if (g.log_bitmask & MASK_LOG_ ## _s) cliSerial->printf_P(PSTR(" %S"), PSTR(# _s)) PLOG(ATTITUDE_FAST); PLOG(ATTITUDE_MED); PLOG(GPS); PLOG(PM); PLOG(CTUN); PLOG(NTUN); PLOG(MODE); PLOG(IMU); PLOG(CMD); PLOG(CURRENT); PLOG(COMPASS); PLOG(TECS); PLOG(CAMERA); PLOG(RC); PLOG(SONAR); #undef PLOG } cliSerial->println(); DataFlash.ListAvailableLogs(cliSerial); return(true); } int8_t Plane::dump_log(uint8_t argc, const Menu::arg *argv) { int16_t dump_log_num; uint16_t dump_log_start; uint16_t dump_log_end; uint16_t last_log_num; // check that the requested log number can be read dump_log_num = argv[1].i; last_log_num = DataFlash.find_last_log(); if (dump_log_num == -2) { DataFlash.DumpPageInfo(cliSerial); return(-1); } else if (dump_log_num <= 0) { cliSerial->printf_P(PSTR("dumping all\n")); Log_Read(0, 1, 0); return(-1); } else if ((argc != 2) || ((uint16_t)dump_log_num > last_log_num)) { cliSerial->printf_P(PSTR("bad log number\n")); return(-1); } DataFlash.get_log_boundaries(dump_log_num, dump_log_start, dump_log_end); Log_Read((uint16_t)dump_log_num, dump_log_start, dump_log_end); return 0; } int8_t Plane::erase_logs(uint8_t argc, const Menu::arg *argv) { in_mavlink_delay = true; do_erase_logs(); in_mavlink_delay = false; return 0; } int8_t Plane::select_logs(uint8_t argc, const Menu::arg *argv) { uint32_t bits; if (argc != 2) { cliSerial->printf_P(PSTR("missing log type\n")); return(-1); } bits = 0; // Macro to make the following code a bit easier on the eye. // Pass it the capitalised name of the log option, as defined // in defines.h but without the LOG_ prefix. It will check for // that name as the argument to the command, and set the bit in // bits accordingly. // if (!strcasecmp_P(argv[1].str, PSTR("all"))) { bits = 0xFFFFFFFFUL; } else { #define TARG(_s) if (!strcasecmp_P(argv[1].str, PSTR(# _s))) bits |= MASK_LOG_ ## _s TARG(ATTITUDE_FAST); TARG(ATTITUDE_MED); TARG(GPS); TARG(PM); TARG(CTUN); TARG(NTUN); TARG(MODE); TARG(IMU); TARG(CMD); TARG(CURRENT); TARG(COMPASS); TARG(TECS); TARG(CAMERA); TARG(RC); TARG(SONAR); #undef TARG } if (!strcasecmp_P(argv[0].str, PSTR("enable"))) { g.log_bitmask.set_and_save(g.log_bitmask | bits); }else{ g.log_bitmask.set_and_save(g.log_bitmask & ~bits); } return(0); } int8_t Plane::process_logs(uint8_t argc, const Menu::arg *argv) { log_menu.run(); return 0; } #endif // CLI_ENABLED == ENABLED void Plane::do_erase_logs(void) { gcs_send_text_P(SEVERITY_LOW, PSTR("Erasing logs")); DataFlash.EraseAll(); gcs_send_text_P(SEVERITY_LOW, PSTR("Log erase complete")); } // Write an attitude packet void Plane::Log_Write_Attitude(void) { Vector3f targets; // Package up the targets into a vector for commonality with Copter usage of Log_Wrote_Attitude targets.x = nav_roll_cd; targets.y = nav_pitch_cd; targets.z = 0; //Plane does not have the concept of navyaw. This is a placeholder. DataFlash.Log_Write_Attitude(ahrs, targets); #if HAL_CPU_CLASS > HAL_CPU_CLASS_16 DataFlash.Log_Write_PID(LOG_PIDR_MSG, rollController.get_pid_info()); DataFlash.Log_Write_PID(LOG_PIDP_MSG, pitchController.get_pid_info()); #endif #if AP_AHRS_NAVEKF_AVAILABLE #if OPTFLOW == ENABLED DataFlash.Log_Write_EKF(ahrs,optflow.enabled()); #else DataFlash.Log_Write_EKF(ahrs,false); #endif DataFlash.Log_Write_AHRS2(ahrs); #endif #if CONFIG_HAL_BOARD == HAL_BOARD_SITL sitl.Log_Write_SIMSTATE(DataFlash); #endif DataFlash.Log_Write_POS(ahrs); } struct PACKED log_Performance { LOG_PACKET_HEADER; uint64_t time_us; uint32_t loop_time; uint16_t main_loop_count; uint32_t g_dt_max; int16_t gyro_drift_x; int16_t gyro_drift_y; int16_t gyro_drift_z; uint8_t i2c_lockup_count; uint16_t ins_error_count; }; // Write a performance monitoring packet. Total length : 19 bytes void Plane::Log_Write_Performance() { struct log_Performance pkt = { LOG_PACKET_HEADER_INIT(LOG_PERFORMANCE_MSG), time_us : hal.scheduler->micros64(), loop_time : millis() - perf_mon_timer, main_loop_count : mainLoop_count, g_dt_max : G_Dt_max, gyro_drift_x : (int16_t)(ahrs.get_gyro_drift().x * 1000), gyro_drift_y : (int16_t)(ahrs.get_gyro_drift().y * 1000), gyro_drift_z : (int16_t)(ahrs.get_gyro_drift().z * 1000), i2c_lockup_count: hal.i2c->lockup_count(), ins_error_count : ins.error_count() }; DataFlash.WriteBlock(&pkt, sizeof(pkt)); } // Write a mission command. Total length : 36 bytes void Plane::Log_Write_Cmd(const AP_Mission::Mission_Command &cmd) { mavlink_mission_item_t mav_cmd = {}; AP_Mission::mission_cmd_to_mavlink(cmd,mav_cmd); DataFlash.Log_Write_MavCmd(mission.num_commands(),mav_cmd); } struct PACKED log_Startup { LOG_PACKET_HEADER; uint64_t time_us; uint8_t startup_type; uint16_t command_total; }; void Plane::Log_Write_Startup(uint8_t type) { // Write all current parameters DataFlash.Log_Write_Parameters(); struct log_Startup pkt = { LOG_PACKET_HEADER_INIT(LOG_STARTUP_MSG), time_us : hal.scheduler->micros64(), startup_type : type, command_total : mission.num_commands() }; DataFlash.WriteBlock(&pkt, sizeof(pkt)); // write all commands to the dataflash as well if (should_log(MASK_LOG_CMD)) { Log_Write_EntireMission(); } } void Plane::Log_Write_EntireMission() { DataFlash.Log_Write_Message_P(PSTR("New mission")); AP_Mission::Mission_Command cmd; for (uint16_t i = 0; i < mission.num_commands(); i++) { if (mission.read_cmd_from_storage(i,cmd)) { Log_Write_Cmd(cmd); } } } struct PACKED log_Control_Tuning { LOG_PACKET_HEADER; uint64_t time_us; int16_t nav_roll_cd; int16_t roll; int16_t nav_pitch_cd; int16_t pitch; int16_t throttle_out; int16_t rudder_out; float accel_y; }; // Write a control tuning packet. Total length : 22 bytes void Plane::Log_Write_Control_Tuning() { Vector3f accel = ins.get_accel(); struct log_Control_Tuning pkt = { LOG_PACKET_HEADER_INIT(LOG_CTUN_MSG), time_us : hal.scheduler->micros64(), nav_roll_cd : (int16_t)nav_roll_cd, roll : (int16_t)ahrs.roll_sensor, nav_pitch_cd : (int16_t)nav_pitch_cd, pitch : (int16_t)ahrs.pitch_sensor, throttle_out : (int16_t)channel_throttle->servo_out, rudder_out : (int16_t)channel_rudder->servo_out, accel_y : accel.y }; DataFlash.WriteBlock(&pkt, sizeof(pkt)); } // Write a TECS tuning packet void Plane::Log_Write_TECS_Tuning(void) { SpdHgt_Controller->log_data(DataFlash, LOG_TECS_MSG); } struct PACKED log_Nav_Tuning { LOG_PACKET_HEADER; uint64_t time_us; uint16_t yaw; float wp_distance; int16_t target_bearing_cd; int16_t nav_bearing_cd; int16_t altitude_error_cm; int16_t airspeed_cm; float altitude; uint32_t groundspeed_cm; }; // Write a navigation tuning packe void Plane::Log_Write_Nav_Tuning() { struct log_Nav_Tuning pkt = { LOG_PACKET_HEADER_INIT(LOG_NTUN_MSG), time_us : hal.scheduler->micros64(), yaw : (uint16_t)ahrs.yaw_sensor, wp_distance : auto_state.wp_distance, target_bearing_cd : (int16_t)nav_controller->target_bearing_cd(), nav_bearing_cd : (int16_t)nav_controller->nav_bearing_cd(), altitude_error_cm : (int16_t)altitude_error_cm, airspeed_cm : (int16_t)airspeed.get_airspeed_cm(), altitude : barometer.get_altitude(), groundspeed_cm : (uint32_t)(gps.ground_speed()*100) }; DataFlash.WriteBlock(&pkt, sizeof(pkt)); } struct PACKED log_Status { LOG_PACKET_HEADER; uint64_t time_us; uint8_t is_flying; float is_flying_probability; uint8_t armed; uint8_t safety; }; void Plane::Log_Write_Status() { struct log_Status pkt = { LOG_PACKET_HEADER_INIT(LOG_STATUS_MSG) ,time_us : hal.scheduler->micros64() ,is_flying : is_flying() ,is_flying_probability : isFlyingProbability ,armed : hal.util->get_soft_armed() ,safety : hal.util->safety_switch_state() }; DataFlash.WriteBlock(&pkt, sizeof(pkt)); } struct PACKED log_Sonar { LOG_PACKET_HEADER; uint64_t time_us; float distance; float voltage; float baro_alt; float groundspeed; uint8_t throttle; uint8_t count; float correction; }; // Write a sonar packet void Plane::Log_Write_Sonar() { #if RANGEFINDER_ENABLED == ENABLED struct log_Sonar pkt = { LOG_PACKET_HEADER_INIT(LOG_SONAR_MSG), time_us : hal.scheduler->micros64(), distance : (float)rangefinder.distance_cm(), voltage : rangefinder.voltage_mv()*0.001f, baro_alt : barometer.get_altitude(), groundspeed : gps.ground_speed(), throttle : (uint8_t)(100 * channel_throttle->norm_output()), count : rangefinder_state.in_range_count, correction : rangefinder_state.correction }; DataFlash.WriteBlock(&pkt, sizeof(pkt)); #endif } struct PACKED log_Optflow { LOG_PACKET_HEADER; uint64_t time_us; uint8_t surface_quality; float flow_x; float flow_y; float body_x; float body_y; }; #if OPTFLOW == ENABLED // Write an optical flow packet void Plane::Log_Write_Optflow() { // exit immediately if not enabled if (!optflow.enabled()) { return; } const Vector2f &flowRate = optflow.flowRate(); const Vector2f &bodyRate = optflow.bodyRate(); struct log_Optflow pkt = { LOG_PACKET_HEADER_INIT(LOG_OPTFLOW_MSG), time_us : hal.scheduler->micros64(), surface_quality : optflow.quality(), flow_x : flowRate.x, flow_y : flowRate.y, body_x : bodyRate.x, body_y : bodyRate.y }; DataFlash.WriteBlock(&pkt, sizeof(pkt)); } #endif struct PACKED log_Arm_Disarm { LOG_PACKET_HEADER; uint64_t time_us; uint8_t arm_state; uint16_t arm_checks; }; void Plane::Log_Write_Current() { DataFlash.Log_Write_Current(battery, channel_throttle->control_in); // also write power status DataFlash.Log_Write_Power(); } void Plane::Log_Arm_Disarm() { struct log_Arm_Disarm pkt = { LOG_PACKET_HEADER_INIT(LOG_ARM_DISARM_MSG), time_us : hal.scheduler->micros64(), arm_state : arming.is_armed(), arm_checks : arming.get_enabled_checks() }; DataFlash.WriteBlock(&pkt, sizeof(pkt)); } void Plane::Log_Write_GPS(uint8_t instance) { DataFlash.Log_Write_GPS(gps, instance, current_loc.alt - ahrs.get_home().alt); } void Plane::Log_Write_IMU() { DataFlash.Log_Write_IMU(ins); } void Plane::Log_Write_RC(void) { DataFlash.Log_Write_RCIN(); DataFlash.Log_Write_RCOUT(); } void Plane::Log_Write_Baro(void) { DataFlash.Log_Write_Baro(barometer); } // Write a AIRSPEED packet void Plane::Log_Write_Airspeed(void) { DataFlash.Log_Write_Airspeed(airspeed); } static const struct LogStructure log_structure[] PROGMEM = { LOG_COMMON_STRUCTURES, { LOG_PERFORMANCE_MSG, sizeof(log_Performance), "PM", "QIHIhhhBH", "TimeUS,LTime,MLC,gDt,GDx,GDy,GDz,I2CErr,INSErr" }, { LOG_STARTUP_MSG, sizeof(log_Startup), "STRT", "QBH", "TimeUS,SType,CTot" }, { LOG_CTUN_MSG, sizeof(log_Control_Tuning), "CTUN", "Qcccchhf", "TimeUS,NavRoll,Roll,NavPitch,Pitch,ThrOut,RdrOut,AccY" }, { LOG_NTUN_MSG, sizeof(log_Nav_Tuning), "NTUN", "QCfccccfI", "TimeUS,Yaw,WpDist,TargBrg,NavBrg,AltErr,Arspd,Alt,GSpdCM" }, { LOG_SONAR_MSG, sizeof(log_Sonar), "SONR", "QffffBBf", "TimeUS,DistCM,Volt,BaroAlt,GSpd,Thr,Cnt,Corr" }, { LOG_ARM_DISARM_MSG, sizeof(log_Arm_Disarm), "ARM", "QHB", "TimeUS,ArmState,ArmChecks" }, { LOG_ATRP_MSG, sizeof(AP_AutoTune::log_ATRP), "ATRP", "QBBcfff", "TimeUS,Type,State,Servo,Demanded,Achieved,P" }, { LOG_STATUS_MSG, sizeof(log_Status), "STAT", "QBfBB", "TimeUS,isFlying,isFlyProb,Armed,Safety" }, #if OPTFLOW == ENABLED { LOG_OPTFLOW_MSG, sizeof(log_Optflow), "OF", "QBffff", "TimeUS,Qual,flowX,flowY,bodyX,bodyY" }, #endif TECS_LOG_FORMAT(LOG_TECS_MSG) }; #if CLI_ENABLED == ENABLED // Read the DataFlash.log memory : Packet Parser void Plane::Log_Read(uint16_t log_num, int16_t start_page, int16_t end_page) { cliSerial->printf_P(PSTR("\n" FIRMWARE_STRING "\nFree RAM: %u\n"), (unsigned)hal.util->available_memory()); cliSerial->println_P(PSTR(HAL_BOARD_NAME)); DataFlash.LogReadProcess(log_num, start_page, end_page, FUNCTOR_BIND_MEMBER(&Plane::print_flight_mode, void, AP_HAL::BetterStream *, uint8_t), cliSerial); } #endif // CLI_ENABLED // start a new log void Plane::start_logging() { DataFlash.StartNewLog(); DataFlash.Log_Write_Message_P(PSTR(FIRMWARE_STRING)); #if defined(PX4_GIT_VERSION) && defined(NUTTX_GIT_VERSION) DataFlash.Log_Write_Message_P(PSTR("PX4: " PX4_GIT_VERSION " NuttX: " NUTTX_GIT_VERSION)); #endif // write system identifier as well if available char sysid[40]; if (hal.util->get_system_id(sysid)) { DataFlash.Log_Write_Message(sysid); } } /* initialise logging subsystem */ void Plane::log_init(void) { DataFlash.Init(log_structure, sizeof(log_structure)/sizeof(log_structure[0])); if (!DataFlash.CardInserted()) { gcs_send_text_P(SEVERITY_LOW, PSTR("No dataflash card inserted")); g.log_bitmask.set(0); } else if (DataFlash.NeedErase()) { gcs_send_text_P(SEVERITY_LOW, PSTR("ERASING LOGS")); do_erase_logs(); for (uint8_t i=0; i