1 // SPDX-License-Identifier: GPL-2.0-only 2 /* 3 * Copyright (C) 2020-2024 Intel Corporation 4 */ 5 6 #include <linux/ctype.h> 7 #include <linux/highmem.h> 8 #include <linux/fs.h> 9 #include <linux/slab.h> 10 #include <linux/moduleparam.h> 11 12 #include "vpu_boot_api.h" 13 #include "ivpu_drv.h" 14 #include "ivpu_fw.h" 15 #include "ivpu_fw_log.h" 16 #include "ivpu_gem.h" 17 18 #define IVPU_FW_LOG_LINE_LENGTH 256 19 20 unsigned int ivpu_fw_log_level = IVPU_FW_LOG_ERROR; 21 module_param_named(fw_log_level, ivpu_fw_log_level, uint, 0444); 22 MODULE_PARM_DESC(fw_log_level, 23 "NPU firmware default log level: debug=" __stringify(IVPU_FW_LOG_DEBUG) 24 " info=" __stringify(IVPU_FW_LOG_INFO) 25 " warn=" __stringify(IVPU_FW_LOG_WARN) 26 " error=" __stringify(IVPU_FW_LOG_ERROR) 27 " fatal=" __stringify(IVPU_FW_LOG_FATAL)); 28 29 static int fw_log_from_bo(struct ivpu_device *vdev, struct ivpu_bo *bo, u32 *offset, 30 struct vpu_tracing_buffer_header **out_log) 31 { 32 struct vpu_tracing_buffer_header *log; 33 34 if ((*offset + sizeof(*log)) > ivpu_bo_size(bo)) 35 return -EINVAL; 36 37 log = ivpu_bo_vaddr(bo) + *offset; 38 39 if (log->vpu_canary_start != VPU_TRACING_BUFFER_CANARY) 40 return -EINVAL; 41 42 if (log->header_size < sizeof(*log) || log->header_size > 1024) { 43 ivpu_dbg(vdev, FW_BOOT, "Invalid header size 0x%x\n", log->header_size); 44 return -EINVAL; 45 } 46 if ((char *)log + log->size > (char *)ivpu_bo_vaddr(bo) + ivpu_bo_size(bo)) { 47 ivpu_dbg(vdev, FW_BOOT, "Invalid log size 0x%x\n", log->size); 48 return -EINVAL; 49 } 50 51 *out_log = log; 52 *offset += log->size; 53 54 ivpu_dbg(vdev, FW_BOOT, 55 "FW log name \"%s\", write offset 0x%x size 0x%x, wrap count %d, hdr version %d size %d format %d, alignment %d", 56 log->name, log->write_index, log->size, log->wrap_count, log->header_version, 57 log->header_size, log->format, log->alignment); 58 59 return 0; 60 } 61 62 static void fw_log_print_lines(char *buffer, u32 size, struct drm_printer *p) 63 { 64 char line[IVPU_FW_LOG_LINE_LENGTH]; 65 u32 index = 0; 66 67 if (!size || !buffer) 68 return; 69 70 while (size--) { 71 if (*buffer == '\n' || *buffer == 0) { 72 line[index] = 0; 73 if (index != 0) 74 drm_printf(p, "%s\n", line); 75 index = 0; 76 buffer++; 77 continue; 78 } 79 if (index == IVPU_FW_LOG_LINE_LENGTH - 1) { 80 line[index] = 0; 81 index = 0; 82 drm_printf(p, "%s\n", line); 83 } 84 if (*buffer != '\r' && (isprint(*buffer) || iscntrl(*buffer))) 85 line[index++] = *buffer; 86 buffer++; 87 } 88 line[index] = 0; 89 if (index != 0) 90 drm_printf(p, "%s", line); 91 } 92 93 static void fw_log_print_buffer(struct vpu_tracing_buffer_header *log, const char *prefix, 94 bool only_new_msgs, struct drm_printer *p) 95 { 96 char *log_data = (void *)log + log->header_size; 97 u32 data_size = log->size - log->header_size; 98 u32 log_start = only_new_msgs ? READ_ONCE(log->read_index) : 0; 99 u32 log_end = READ_ONCE(log->write_index); 100 101 if (log_start >= data_size) 102 log_start = 0; 103 if (log_end > data_size) 104 log_end = data_size; 105 106 if (log->wrap_count == log->read_wrap_count) { 107 if (log_end <= log_start) { 108 drm_printf(p, "==== %s \"%s\" log empty ====\n", prefix, log->name); 109 return; 110 } 111 } else if (log->wrap_count == log->read_wrap_count + 1) { 112 if (log_end > log_start) 113 log_start = log_end; 114 } else { 115 log_start = log_end; 116 } 117 118 drm_printf(p, "==== %s \"%s\" log start ====\n", prefix, log->name); 119 if (log_end > log_start) { 120 fw_log_print_lines(log_data + log_start, log_end - log_start, p); 121 } else { 122 fw_log_print_lines(log_data + log_start, data_size - log_start, p); 123 fw_log_print_lines(log_data, log_end, p); 124 } 125 drm_printf(p, "\n\x1b[0m"); /* add new line and clear formatting */ 126 drm_printf(p, "==== %s \"%s\" log end ====\n", prefix, log->name); 127 } 128 129 static void 130 fw_log_print_all_in_bo(struct ivpu_device *vdev, const char *name, 131 struct ivpu_bo *bo, bool only_new_msgs, struct drm_printer *p) 132 { 133 struct vpu_tracing_buffer_header *log; 134 u32 next = 0; 135 136 while (fw_log_from_bo(vdev, bo, &next, &log) == 0) 137 fw_log_print_buffer(log, name, only_new_msgs, p); 138 } 139 140 void ivpu_fw_log_print(struct ivpu_device *vdev, bool only_new_msgs, struct drm_printer *p) 141 { 142 fw_log_print_all_in_bo(vdev, "NPU critical", vdev->fw->mem_log_crit, only_new_msgs, p); 143 fw_log_print_all_in_bo(vdev, "NPU verbose", vdev->fw->mem_log_verb, only_new_msgs, p); 144 } 145 146 void ivpu_fw_log_mark_read(struct ivpu_device *vdev) 147 { 148 struct vpu_tracing_buffer_header *log; 149 u32 next; 150 151 next = 0; 152 while (fw_log_from_bo(vdev, vdev->fw->mem_log_crit, &next, &log) == 0) { 153 log->read_index = READ_ONCE(log->write_index); 154 log->read_wrap_count = READ_ONCE(log->wrap_count); 155 } 156 157 next = 0; 158 while (fw_log_from_bo(vdev, vdev->fw->mem_log_verb, &next, &log) == 0) { 159 log->read_index = READ_ONCE(log->write_index); 160 log->read_wrap_count = READ_ONCE(log->wrap_count); 161 } 162 } 163 164 void ivpu_fw_log_reset(struct ivpu_device *vdev) 165 { 166 struct vpu_tracing_buffer_header *log; 167 u32 next; 168 169 next = 0; 170 while (fw_log_from_bo(vdev, vdev->fw->mem_log_crit, &next, &log) == 0) { 171 log->read_index = 0; 172 log->read_wrap_count = 0; 173 } 174 175 next = 0; 176 while (fw_log_from_bo(vdev, vdev->fw->mem_log_verb, &next, &log) == 0) { 177 log->read_index = 0; 178 log->read_wrap_count = 0; 179 } 180 } 181