1 // SPDX-License-Identifier: GPL-2.0+ 2 // Debug logs for the ChromeOS EC 3 // 4 // Copyright (C) 2015 Google, Inc. 5 6 #include <linux/circ_buf.h> 7 #include <linux/debugfs.h> 8 #include <linux/delay.h> 9 #include <linux/fs.h> 10 #include <linux/module.h> 11 #include <linux/mutex.h> 12 #include <linux/platform_data/cros_ec_commands.h> 13 #include <linux/platform_data/cros_ec_proto.h> 14 #include <linux/platform_device.h> 15 #include <linux/poll.h> 16 #include <linux/sched.h> 17 #include <linux/slab.h> 18 #include <linux/wait.h> 19 20 #define DRV_NAME "cros-ec-debugfs" 21 22 #define LOG_SHIFT 14 23 #define LOG_SIZE (1 << LOG_SHIFT) 24 #define LOG_POLL_SEC 10 25 26 #define CIRC_ADD(idx, size, value) (((idx) + (value)) & ((size) - 1)) 27 28 /* waitqueue for log readers */ 29 static DECLARE_WAIT_QUEUE_HEAD(cros_ec_debugfs_log_wq); 30 31 /** 32 * struct cros_ec_debugfs - EC debugging information. 33 * 34 * @ec: EC device this debugfs information belongs to 35 * @dir: dentry for debugfs files 36 * @log_buffer: circular buffer for console log information 37 * @read_msg: preallocated EC command and buffer to read console log 38 * @log_mutex: mutex to protect circular buffer 39 * @log_poll_work: recurring task to poll EC for new console log data 40 * @panicinfo_blob: panicinfo debugfs blob 41 */ 42 struct cros_ec_debugfs { 43 struct cros_ec_dev *ec; 44 struct dentry *dir; 45 /* EC log */ 46 struct circ_buf log_buffer; 47 struct cros_ec_command *read_msg; 48 struct mutex log_mutex; 49 struct delayed_work log_poll_work; 50 /* EC panicinfo */ 51 struct debugfs_blob_wrapper panicinfo_blob; 52 }; 53 54 /* 55 * We need to make sure that the EC log buffer on the UART is large enough, 56 * so that it is unlikely enough to overlow within LOG_POLL_SEC. 57 */ 58 static void cros_ec_console_log_work(struct work_struct *__work) 59 { 60 struct cros_ec_debugfs *debug_info = 61 container_of(to_delayed_work(__work), 62 struct cros_ec_debugfs, 63 log_poll_work); 64 struct cros_ec_dev *ec = debug_info->ec; 65 struct circ_buf *cb = &debug_info->log_buffer; 66 struct cros_ec_command snapshot_msg = { 67 .command = EC_CMD_CONSOLE_SNAPSHOT + ec->cmd_offset, 68 }; 69 70 struct ec_params_console_read_v1 *read_params = 71 (struct ec_params_console_read_v1 *)debug_info->read_msg->data; 72 uint8_t *ec_buffer = (uint8_t *)debug_info->read_msg->data; 73 int idx; 74 int buf_space; 75 int ret; 76 77 ret = cros_ec_cmd_xfer_status(ec->ec_dev, &snapshot_msg); 78 if (ret < 0) 79 goto resched; 80 81 /* Loop until we have read everything, or there's an error. */ 82 mutex_lock(&debug_info->log_mutex); 83 buf_space = CIRC_SPACE(cb->head, cb->tail, LOG_SIZE); 84 85 while (1) { 86 if (!buf_space) { 87 dev_info_once(ec->dev, 88 "Some logs may have been dropped...\n"); 89 break; 90 } 91 92 memset(read_params, '\0', sizeof(*read_params)); 93 read_params->subcmd = CONSOLE_READ_RECENT; 94 ret = cros_ec_cmd_xfer_status(ec->ec_dev, 95 debug_info->read_msg); 96 if (ret < 0) 97 break; 98 99 /* If the buffer is empty, we're done here. */ 100 if (ret == 0 || ec_buffer[0] == '\0') 101 break; 102 103 idx = 0; 104 while (idx < ret && ec_buffer[idx] != '\0' && buf_space > 0) { 105 cb->buf[cb->head] = ec_buffer[idx]; 106 cb->head = CIRC_ADD(cb->head, LOG_SIZE, 1); 107 idx++; 108 buf_space--; 109 } 110 111 wake_up(&cros_ec_debugfs_log_wq); 112 } 113 114 mutex_unlock(&debug_info->log_mutex); 115 116 resched: 117 schedule_delayed_work(&debug_info->log_poll_work, 118 msecs_to_jiffies(LOG_POLL_SEC * 1000)); 119 } 120 121 static int cros_ec_console_log_open(struct inode *inode, struct file *file) 122 { 123 file->private_data = inode->i_private; 124 125 return stream_open(inode, file); 126 } 127 128 static ssize_t cros_ec_console_log_read(struct file *file, char __user *buf, 129 size_t count, loff_t *ppos) 130 { 131 struct cros_ec_debugfs *debug_info = file->private_data; 132 struct circ_buf *cb = &debug_info->log_buffer; 133 ssize_t ret; 134 135 mutex_lock(&debug_info->log_mutex); 136 137 while (!CIRC_CNT(cb->head, cb->tail, LOG_SIZE)) { 138 if (file->f_flags & O_NONBLOCK) { 139 ret = -EAGAIN; 140 goto error; 141 } 142 143 mutex_unlock(&debug_info->log_mutex); 144 145 ret = wait_event_interruptible(cros_ec_debugfs_log_wq, 146 CIRC_CNT(cb->head, cb->tail, LOG_SIZE)); 147 if (ret < 0) 148 return ret; 149 150 mutex_lock(&debug_info->log_mutex); 151 } 152 153 /* Only copy until the end of the circular buffer, and let userspace 154 * retry to get the rest of the data. 155 */ 156 ret = min_t(size_t, CIRC_CNT_TO_END(cb->head, cb->tail, LOG_SIZE), 157 count); 158 159 if (copy_to_user(buf, cb->buf + cb->tail, ret)) { 160 ret = -EFAULT; 161 goto error; 162 } 163 164 cb->tail = CIRC_ADD(cb->tail, LOG_SIZE, ret); 165 166 error: 167 mutex_unlock(&debug_info->log_mutex); 168 return ret; 169 } 170 171 static __poll_t cros_ec_console_log_poll(struct file *file, 172 poll_table *wait) 173 { 174 struct cros_ec_debugfs *debug_info = file->private_data; 175 __poll_t mask = 0; 176 177 poll_wait(file, &cros_ec_debugfs_log_wq, wait); 178 179 mutex_lock(&debug_info->log_mutex); 180 if (CIRC_CNT(debug_info->log_buffer.head, 181 debug_info->log_buffer.tail, 182 LOG_SIZE)) 183 mask |= EPOLLIN | EPOLLRDNORM; 184 mutex_unlock(&debug_info->log_mutex); 185 186 return mask; 187 } 188 189 static int cros_ec_console_log_release(struct inode *inode, struct file *file) 190 { 191 return 0; 192 } 193 194 static ssize_t cros_ec_pdinfo_read(struct file *file, 195 char __user *user_buf, 196 size_t count, 197 loff_t *ppos) 198 { 199 char read_buf[EC_USB_PD_MAX_PORTS * 40], *p = read_buf; 200 struct cros_ec_debugfs *debug_info = file->private_data; 201 struct cros_ec_device *ec_dev = debug_info->ec->ec_dev; 202 struct { 203 struct cros_ec_command msg; 204 union { 205 struct ec_response_usb_pd_control_v1 resp; 206 struct ec_params_usb_pd_control params; 207 }; 208 } __packed ec_buf; 209 struct cros_ec_command *msg; 210 struct ec_response_usb_pd_control_v1 *resp; 211 struct ec_params_usb_pd_control *params; 212 int i; 213 214 msg = &ec_buf.msg; 215 params = (struct ec_params_usb_pd_control *)msg->data; 216 resp = (struct ec_response_usb_pd_control_v1 *)msg->data; 217 218 msg->command = EC_CMD_USB_PD_CONTROL; 219 msg->version = 1; 220 msg->insize = sizeof(*resp); 221 msg->outsize = sizeof(*params); 222 223 /* 224 * Read status from all PD ports until failure, typically caused 225 * by attempting to read status on a port that doesn't exist. 226 */ 227 for (i = 0; i < EC_USB_PD_MAX_PORTS; ++i) { 228 params->port = i; 229 params->role = 0; 230 params->mux = 0; 231 params->swap = 0; 232 233 if (cros_ec_cmd_xfer_status(ec_dev, msg) < 0) 234 break; 235 236 p += scnprintf(p, sizeof(read_buf) + read_buf - p, 237 "p%d: %s en:%.2x role:%.2x pol:%.2x\n", i, 238 resp->state, resp->enabled, resp->role, 239 resp->polarity); 240 } 241 242 return simple_read_from_buffer(user_buf, count, ppos, 243 read_buf, p - read_buf); 244 } 245 246 static bool cros_ec_uptime_is_supported(struct cros_ec_device *ec_dev) 247 { 248 struct { 249 struct cros_ec_command cmd; 250 struct ec_response_uptime_info resp; 251 } __packed msg = {}; 252 int ret; 253 254 msg.cmd.command = EC_CMD_GET_UPTIME_INFO; 255 msg.cmd.insize = sizeof(msg.resp); 256 257 ret = cros_ec_cmd_xfer_status(ec_dev, &msg.cmd); 258 if (ret == -EPROTO && msg.cmd.result == EC_RES_INVALID_COMMAND) 259 return false; 260 261 /* Other errors maybe a transient error, do not rule about support. */ 262 return true; 263 } 264 265 static ssize_t cros_ec_uptime_read(struct file *file, char __user *user_buf, 266 size_t count, loff_t *ppos) 267 { 268 struct cros_ec_debugfs *debug_info = file->private_data; 269 struct cros_ec_device *ec_dev = debug_info->ec->ec_dev; 270 struct { 271 struct cros_ec_command cmd; 272 struct ec_response_uptime_info resp; 273 } __packed msg = {}; 274 struct ec_response_uptime_info *resp; 275 char read_buf[32]; 276 int ret; 277 278 resp = (struct ec_response_uptime_info *)&msg.resp; 279 280 msg.cmd.command = EC_CMD_GET_UPTIME_INFO; 281 msg.cmd.insize = sizeof(*resp); 282 283 ret = cros_ec_cmd_xfer_status(ec_dev, &msg.cmd); 284 if (ret < 0) 285 return ret; 286 287 ret = scnprintf(read_buf, sizeof(read_buf), "%u\n", 288 resp->time_since_ec_boot_ms); 289 290 return simple_read_from_buffer(user_buf, count, ppos, read_buf, ret); 291 } 292 293 static const struct file_operations cros_ec_console_log_fops = { 294 .owner = THIS_MODULE, 295 .open = cros_ec_console_log_open, 296 .read = cros_ec_console_log_read, 297 .llseek = no_llseek, 298 .poll = cros_ec_console_log_poll, 299 .release = cros_ec_console_log_release, 300 }; 301 302 static const struct file_operations cros_ec_pdinfo_fops = { 303 .owner = THIS_MODULE, 304 .open = simple_open, 305 .read = cros_ec_pdinfo_read, 306 .llseek = default_llseek, 307 }; 308 309 static const struct file_operations cros_ec_uptime_fops = { 310 .owner = THIS_MODULE, 311 .open = simple_open, 312 .read = cros_ec_uptime_read, 313 .llseek = default_llseek, 314 }; 315 316 static int ec_read_version_supported(struct cros_ec_dev *ec) 317 { 318 struct ec_params_get_cmd_versions_v1 *params; 319 struct ec_response_get_cmd_versions *response; 320 int ret; 321 322 struct cros_ec_command *msg; 323 324 msg = kzalloc(sizeof(*msg) + max(sizeof(*params), sizeof(*response)), 325 GFP_KERNEL); 326 if (!msg) 327 return 0; 328 329 msg->command = EC_CMD_GET_CMD_VERSIONS + ec->cmd_offset; 330 msg->outsize = sizeof(*params); 331 msg->insize = sizeof(*response); 332 333 params = (struct ec_params_get_cmd_versions_v1 *)msg->data; 334 params->cmd = EC_CMD_CONSOLE_READ; 335 response = (struct ec_response_get_cmd_versions *)msg->data; 336 337 ret = cros_ec_cmd_xfer_status(ec->ec_dev, msg) >= 0 && 338 response->version_mask & EC_VER_MASK(1); 339 340 kfree(msg); 341 342 return ret; 343 } 344 345 static int cros_ec_create_console_log(struct cros_ec_debugfs *debug_info) 346 { 347 struct cros_ec_dev *ec = debug_info->ec; 348 char *buf; 349 int read_params_size; 350 int read_response_size; 351 352 /* 353 * If the console log feature is not supported return silently and 354 * don't create the console_log entry. 355 */ 356 if (!ec_read_version_supported(ec)) 357 return 0; 358 359 buf = devm_kzalloc(ec->dev, LOG_SIZE, GFP_KERNEL); 360 if (!buf) 361 return -ENOMEM; 362 363 read_params_size = sizeof(struct ec_params_console_read_v1); 364 read_response_size = ec->ec_dev->max_response; 365 debug_info->read_msg = devm_kzalloc(ec->dev, 366 sizeof(*debug_info->read_msg) + 367 max(read_params_size, read_response_size), GFP_KERNEL); 368 if (!debug_info->read_msg) 369 return -ENOMEM; 370 371 debug_info->read_msg->version = 1; 372 debug_info->read_msg->command = EC_CMD_CONSOLE_READ + ec->cmd_offset; 373 debug_info->read_msg->outsize = read_params_size; 374 debug_info->read_msg->insize = read_response_size; 375 376 debug_info->log_buffer.buf = buf; 377 debug_info->log_buffer.head = 0; 378 debug_info->log_buffer.tail = 0; 379 380 mutex_init(&debug_info->log_mutex); 381 382 debugfs_create_file("console_log", S_IFREG | 0444, debug_info->dir, 383 debug_info, &cros_ec_console_log_fops); 384 385 INIT_DELAYED_WORK(&debug_info->log_poll_work, 386 cros_ec_console_log_work); 387 schedule_delayed_work(&debug_info->log_poll_work, 0); 388 389 return 0; 390 } 391 392 static void cros_ec_cleanup_console_log(struct cros_ec_debugfs *debug_info) 393 { 394 if (debug_info->log_buffer.buf) { 395 cancel_delayed_work_sync(&debug_info->log_poll_work); 396 mutex_destroy(&debug_info->log_mutex); 397 } 398 } 399 400 static int cros_ec_create_panicinfo(struct cros_ec_debugfs *debug_info) 401 { 402 struct cros_ec_device *ec_dev = debug_info->ec->ec_dev; 403 int ret; 404 struct cros_ec_command *msg; 405 int insize; 406 407 insize = ec_dev->max_response; 408 409 msg = devm_kzalloc(debug_info->ec->dev, 410 sizeof(*msg) + insize, GFP_KERNEL); 411 if (!msg) 412 return -ENOMEM; 413 414 msg->command = EC_CMD_GET_PANIC_INFO; 415 msg->insize = insize; 416 417 ret = cros_ec_cmd_xfer_status(ec_dev, msg); 418 if (ret < 0) { 419 ret = 0; 420 goto free; 421 } 422 423 /* No panic data */ 424 if (ret == 0) 425 goto free; 426 427 debug_info->panicinfo_blob.data = msg->data; 428 debug_info->panicinfo_blob.size = ret; 429 430 debugfs_create_blob("panicinfo", S_IFREG | 0444, debug_info->dir, 431 &debug_info->panicinfo_blob); 432 433 return 0; 434 435 free: 436 devm_kfree(debug_info->ec->dev, msg); 437 return ret; 438 } 439 440 static int cros_ec_debugfs_probe(struct platform_device *pd) 441 { 442 struct cros_ec_dev *ec = dev_get_drvdata(pd->dev.parent); 443 struct cros_ec_platform *ec_platform = dev_get_platdata(ec->dev); 444 const char *name = ec_platform->ec_name; 445 struct cros_ec_debugfs *debug_info; 446 int ret; 447 448 debug_info = devm_kzalloc(ec->dev, sizeof(*debug_info), GFP_KERNEL); 449 if (!debug_info) 450 return -ENOMEM; 451 452 debug_info->ec = ec; 453 debug_info->dir = debugfs_create_dir(name, NULL); 454 455 ret = cros_ec_create_panicinfo(debug_info); 456 if (ret) 457 goto remove_debugfs; 458 459 ret = cros_ec_create_console_log(debug_info); 460 if (ret) 461 goto remove_debugfs; 462 463 debugfs_create_file("pdinfo", 0444, debug_info->dir, debug_info, 464 &cros_ec_pdinfo_fops); 465 466 if (cros_ec_uptime_is_supported(ec->ec_dev)) 467 debugfs_create_file("uptime", 0444, debug_info->dir, debug_info, 468 &cros_ec_uptime_fops); 469 470 debugfs_create_x32("last_resume_result", 0444, debug_info->dir, 471 &ec->ec_dev->last_resume_result); 472 473 debugfs_create_u16("suspend_timeout_ms", 0664, debug_info->dir, 474 &ec->ec_dev->suspend_timeout_ms); 475 476 ec->debug_info = debug_info; 477 478 dev_set_drvdata(&pd->dev, ec); 479 480 return 0; 481 482 remove_debugfs: 483 debugfs_remove_recursive(debug_info->dir); 484 return ret; 485 } 486 487 static int cros_ec_debugfs_remove(struct platform_device *pd) 488 { 489 struct cros_ec_dev *ec = dev_get_drvdata(pd->dev.parent); 490 491 debugfs_remove_recursive(ec->debug_info->dir); 492 cros_ec_cleanup_console_log(ec->debug_info); 493 494 return 0; 495 } 496 497 static int __maybe_unused cros_ec_debugfs_suspend(struct device *dev) 498 { 499 struct cros_ec_dev *ec = dev_get_drvdata(dev); 500 501 if (ec->debug_info->log_buffer.buf) 502 cancel_delayed_work_sync(&ec->debug_info->log_poll_work); 503 504 return 0; 505 } 506 507 static int __maybe_unused cros_ec_debugfs_resume(struct device *dev) 508 { 509 struct cros_ec_dev *ec = dev_get_drvdata(dev); 510 511 if (ec->debug_info->log_buffer.buf) 512 schedule_delayed_work(&ec->debug_info->log_poll_work, 0); 513 514 return 0; 515 } 516 517 static SIMPLE_DEV_PM_OPS(cros_ec_debugfs_pm_ops, 518 cros_ec_debugfs_suspend, cros_ec_debugfs_resume); 519 520 static struct platform_driver cros_ec_debugfs_driver = { 521 .driver = { 522 .name = DRV_NAME, 523 .pm = &cros_ec_debugfs_pm_ops, 524 .probe_type = PROBE_PREFER_ASYNCHRONOUS, 525 }, 526 .probe = cros_ec_debugfs_probe, 527 .remove = cros_ec_debugfs_remove, 528 }; 529 530 module_platform_driver(cros_ec_debugfs_driver); 531 532 MODULE_LICENSE("GPL"); 533 MODULE_DESCRIPTION("Debug logs for ChromeOS EC"); 534 MODULE_ALIAS("platform:" DRV_NAME); 535