dumpstate.cpp revision c0808155fd10d2d5c49bb4c8d4cafed8da28c182
1/* 2 * Copyright (C) 2008 The Android Open Source Project 3 * 4 * Licensed under the Apache License, Version 2.0 (the "License"); 5 * you may not use this file except in compliance with the License. 6 * You may obtain a copy of the License at 7 * 8 * http://www.apache.org/licenses/LICENSE-2.0 9 * 10 * Unless required by applicable law or agreed to in writing, software 11 * distributed under the License is distributed on an "AS IS" BASIS, 12 * WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. 13 * See the License for the specific language governing permissions and 14 * limitations under the License. 15 */ 16 17#include <dirent.h> 18#include <errno.h> 19#include <fcntl.h> 20#include <libgen.h> 21#include <limits.h> 22#include <memory> 23#include <regex> 24#include <set> 25#include <stdbool.h> 26#include <stdio.h> 27#include <stdlib.h> 28#include <string> 29#include <string.h> 30#include <sys/prctl.h> 31#include <sys/resource.h> 32#include <sys/stat.h> 33#include <sys/time.h> 34#include <sys/wait.h> 35#include <unistd.h> 36 37#include <android-base/stringprintf.h> 38#include <cutils/properties.h> 39 40#include "private/android_filesystem_config.h" 41 42#define LOG_TAG "dumpstate" 43#include <cutils/log.h> 44 45#include "dumpstate.h" 46#include "ScopedFd.h" 47#include "ziparchive/zip_writer.h" 48 49#include "mincrypt/sha256.h" 50 51using android::base::StringPrintf; 52 53/* read before root is shed */ 54static char cmdline_buf[16384] = "(unknown)"; 55static const char *dump_traces_path = NULL; 56 57// TODO: should be part of dumpstate object 58static unsigned long id; 59static char build_type[PROPERTY_VALUE_MAX]; 60static time_t now; 61static std::unique_ptr<ZipWriter> zip_writer; 62static std::set<std::string> mount_points; 63void add_mountinfo(); 64static int control_socket_fd; 65/* suffix of the bugreport files - it's typically the date (when invoked with -d), 66 * although it could be changed by the user using a system property */ 67static std::string suffix; 68 69#define PSTORE_LAST_KMSG "/sys/fs/pstore/console-ramoops" 70 71#define RAFT_DIR "/data/misc/raft/" 72#define RECOVERY_DIR "/cache/recovery" 73#define RECOVERY_DATA_DIR "/data/misc/recovery" 74#define LOGPERSIST_DATA_DIR "/data/misc/logd" 75#define PROFILE_DATA_DIR_CUR "/data/misc/profiles/cur" 76#define PROFILE_DATA_DIR_REF "/data/misc/profiles/ref" 77#define TOMBSTONE_DIR "/data/tombstones" 78#define TOMBSTONE_FILE_PREFIX TOMBSTONE_DIR "/tombstone_" 79/* Can accomodate a tombstone number up to 9999. */ 80#define TOMBSTONE_MAX_LEN (sizeof(TOMBSTONE_FILE_PREFIX) + 4) 81#define NUM_TOMBSTONES 10 82#define WLUTIL "/vendor/xbin/wlutil" 83 84typedef struct { 85 char name[TOMBSTONE_MAX_LEN]; 86 int fd; 87} tombstone_data_t; 88 89static tombstone_data_t tombstone_data[NUM_TOMBSTONES]; 90 91const std::string ZIP_ROOT_DIR = "FS"; 92std::string bugreport_dir; 93 94/* 95 * List of supported zip format versions. 96 * 97 * See bugreport-format.txt for more info. 98 */ 99static std::string VERSION_DEFAULT = "1.0"; 100 101bool is_user_build() { 102 return 0 == strncmp(build_type, "user", PROPERTY_VALUE_MAX - 1); 103} 104 105/* gets the tombstone data, according to the bugreport type: if zipped gets all tombstones, 106 * otherwise gets just those modified in the last half an hour. */ 107static void get_tombstone_fds(tombstone_data_t data[NUM_TOMBSTONES]) { 108 time_t thirty_minutes_ago = now - 60*30; 109 for (size_t i = 0; i < NUM_TOMBSTONES; i++) { 110 snprintf(data[i].name, sizeof(data[i].name), "%s%02zu", TOMBSTONE_FILE_PREFIX, i); 111 int fd = TEMP_FAILURE_RETRY(open(data[i].name, 112 O_RDONLY | O_CLOEXEC | O_NOFOLLOW | O_NONBLOCK)); 113 struct stat st; 114 if (fstat(fd, &st) == 0 && S_ISREG(st.st_mode) && 115 (zip_writer || (time_t) st.st_mtime >= thirty_minutes_ago)) { 116 data[i].fd = fd; 117 } else { 118 close(fd); 119 data[i].fd = -1; 120 } 121 } 122} 123 124// for_each_pid() callback to get mount info about a process. 125void do_mountinfo(int pid, const char *name) { 126 char path[PATH_MAX]; 127 128 // Gets the the content of the /proc/PID/ns/mnt link, so only unique mount points 129 // are added. 130 snprintf(path, sizeof(path), "/proc/%d/ns/mnt", pid); 131 char linkname[PATH_MAX]; 132 ssize_t r = readlink(path, linkname, PATH_MAX); 133 if (r == -1) { 134 MYLOGE("Unable to read link for %s: %s\n", path, strerror(errno)); 135 return; 136 } 137 linkname[r] = '\0'; 138 139 if (mount_points.find(linkname) == mount_points.end()) { 140 // First time this mount point was found: add it 141 snprintf(path, sizeof(path), "/proc/%d/mountinfo", pid); 142 if (add_zip_entry(ZIP_ROOT_DIR + path, path)) { 143 mount_points.insert(linkname); 144 } else { 145 MYLOGE("Unable to add mountinfo %s to zip file\n", path); 146 } 147 } 148} 149 150void add_mountinfo() { 151 if (!zip_writer) return; 152 const char *title = "MOUNT INFO"; 153 mount_points.clear(); 154 DurationReporter duration_reporter(title, NULL); 155 for_each_pid(do_mountinfo, NULL); 156 MYLOGD("%s: %d entries added to zip file\n", title, (int) mount_points.size()); 157} 158 159static void dump_dev_files(const char *title, const char *driverpath, const char *filename) 160{ 161 DIR *d; 162 struct dirent *de; 163 char path[PATH_MAX]; 164 165 d = opendir(driverpath); 166 if (d == NULL) { 167 return; 168 } 169 170 while ((de = readdir(d))) { 171 if (de->d_type != DT_LNK) { 172 continue; 173 } 174 snprintf(path, sizeof(path), "%s/%s/%s", driverpath, de->d_name, filename); 175 dump_file(title, path); 176 } 177 178 closedir(d); 179} 180 181static void dump_systrace() { 182 if (!zip_writer) { 183 MYLOGD("Not dumping systrace because zip_writer is not set\n"); 184 return; 185 } 186 std::string systrace_path = bugreport_dir + "/systrace-" + suffix + ".txt"; 187 if (systrace_path.empty()) { 188 MYLOGE("Not dumping systrace because path is empty\n"); 189 return; 190 } 191 const char* path = "/sys/kernel/debug/tracing/tracing_on"; 192 long int is_tracing; 193 if (read_file_as_long(path, &is_tracing)) { 194 return; // error already logged 195 } 196 if (is_tracing <= 0) { 197 MYLOGD("Skipping systrace because '%s' content is '%ld'\n", path, is_tracing); 198 return; 199 } 200 201 MYLOGD("Running '/system/bin/atrace --async_dump -o %s', which can take several minutes", 202 systrace_path.c_str()); 203 if (run_command("SYSTRACE", 120, "/system/bin/atrace", "--async_dump", "-o", 204 systrace_path.c_str(), NULL)) { 205 MYLOGE("systrace timed out, its zip entry will be incomplete\n"); 206 // TODO: run_command tries to kill the process, but atrace doesn't die peacefully; ideally, 207 // we should call strace to stop itself, but there is no such option yet (just a 208 // --async_stop, which stops and dump 209 // if (run_command("SYSTRACE", 10, "/system/bin/atrace", "--kill", NULL)) { 210 // MYLOGE("could not stop systrace "); 211 // } 212 } 213 if (!add_zip_entry("systrace.txt", systrace_path)) { 214 MYLOGE("Unable to add systrace file %s to zip file\n", systrace_path.c_str()); 215 } else { 216 if (remove(systrace_path.c_str())) { 217 MYLOGE("Error removing systrace file %s: %s", systrace_path.c_str(), strerror(errno)); 218 } 219 } 220} 221 222static bool skip_not_stat(const char *path) { 223 static const char stat[] = "/stat"; 224 size_t len = strlen(path); 225 if (path[len - 1] == '/') { /* Directory? */ 226 return false; 227 } 228 return strcmp(path + len - sizeof(stat) + 1, stat); /* .../stat? */ 229} 230 231static bool skip_none(const char *path) { 232 return false; 233} 234 235static const char mmcblk0[] = "/sys/block/mmcblk0/"; 236unsigned long worst_write_perf = 20000; /* in KB/s */ 237 238// 239// stat offsets 240// Name units description 241// ---- ----- ----------- 242// read I/Os requests number of read I/Os processed 243#define __STAT_READ_IOS 0 244// read merges requests number of read I/Os merged with in-queue I/O 245#define __STAT_READ_MERGES 1 246// read sectors sectors number of sectors read 247#define __STAT_READ_SECTORS 2 248// read ticks milliseconds total wait time for read requests 249#define __STAT_READ_TICKS 3 250// write I/Os requests number of write I/Os processed 251#define __STAT_WRITE_IOS 4 252// write merges requests number of write I/Os merged with in-queue I/O 253#define __STAT_WRITE_MERGES 5 254// write sectors sectors number of sectors written 255#define __STAT_WRITE_SECTORS 6 256// write ticks milliseconds total wait time for write requests 257#define __STAT_WRITE_TICKS 7 258// in_flight requests number of I/Os currently in flight 259#define __STAT_IN_FLIGHT 8 260// io_ticks milliseconds total time this block device has been active 261#define __STAT_IO_TICKS 9 262// time_in_queue milliseconds total wait time for all requests 263#define __STAT_IN_QUEUE 10 264#define __STAT_NUMBER_FIELD 11 265// 266// read I/Os, write I/Os 267// ===================== 268// 269// These values increment when an I/O request completes. 270// 271// read merges, write merges 272// ========================= 273// 274// These values increment when an I/O request is merged with an 275// already-queued I/O request. 276// 277// read sectors, write sectors 278// =========================== 279// 280// These values count the number of sectors read from or written to this 281// block device. The "sectors" in question are the standard UNIX 512-byte 282// sectors, not any device- or filesystem-specific block size. The 283// counters are incremented when the I/O completes. 284#define SECTOR_SIZE 512 285// 286// read ticks, write ticks 287// ======================= 288// 289// These values count the number of milliseconds that I/O requests have 290// waited on this block device. If there are multiple I/O requests waiting, 291// these values will increase at a rate greater than 1000/second; for 292// example, if 60 read requests wait for an average of 30 ms, the read_ticks 293// field will increase by 60*30 = 1800. 294// 295// in_flight 296// ========= 297// 298// This value counts the number of I/O requests that have been issued to 299// the device driver but have not yet completed. It does not include I/O 300// requests that are in the queue but not yet issued to the device driver. 301// 302// io_ticks 303// ======== 304// 305// This value counts the number of milliseconds during which the device has 306// had I/O requests queued. 307// 308// time_in_queue 309// ============= 310// 311// This value counts the number of milliseconds that I/O requests have waited 312// on this block device. If there are multiple I/O requests waiting, this 313// value will increase as the product of the number of milliseconds times the 314// number of requests waiting (see "read ticks" above for an example). 315#define S_TO_MS 1000 316// 317 318static int dump_stat_from_fd(const char *title __unused, const char *path, int fd) { 319 unsigned long long fields[__STAT_NUMBER_FIELD]; 320 bool z; 321 char *cp, *buffer = NULL; 322 size_t i = 0; 323 FILE *fp = fdopen(fd, "rb"); 324 getline(&buffer, &i, fp); 325 fclose(fp); 326 if (!buffer) { 327 return -errno; 328 } 329 i = strlen(buffer); 330 while ((i > 0) && (buffer[i - 1] == '\n')) { 331 buffer[--i] = '\0'; 332 } 333 if (!*buffer) { 334 free(buffer); 335 return 0; 336 } 337 z = true; 338 for (cp = buffer, i = 0; i < (sizeof(fields) / sizeof(fields[0])); ++i) { 339 fields[i] = strtoull(cp, &cp, 10); 340 if (fields[i] != 0) { 341 z = false; 342 } 343 } 344 if (z) { /* never accessed */ 345 free(buffer); 346 return 0; 347 } 348 349 if (!strncmp(path, mmcblk0, sizeof(mmcblk0) - 1)) { 350 path += sizeof(mmcblk0) - 1; 351 } 352 353 printf("%s: %s\n", path, buffer); 354 free(buffer); 355 356 if (fields[__STAT_IO_TICKS]) { 357 unsigned long read_perf = 0; 358 unsigned long read_ios = 0; 359 if (fields[__STAT_READ_TICKS]) { 360 unsigned long long divisor = fields[__STAT_READ_TICKS] 361 * fields[__STAT_IO_TICKS]; 362 read_perf = ((unsigned long long)SECTOR_SIZE 363 * fields[__STAT_READ_SECTORS] 364 * fields[__STAT_IN_QUEUE] + (divisor >> 1)) 365 / divisor; 366 read_ios = ((unsigned long long)S_TO_MS * fields[__STAT_READ_IOS] 367 * fields[__STAT_IN_QUEUE] + (divisor >> 1)) 368 / divisor; 369 } 370 371 unsigned long write_perf = 0; 372 unsigned long write_ios = 0; 373 if (fields[__STAT_WRITE_TICKS]) { 374 unsigned long long divisor = fields[__STAT_WRITE_TICKS] 375 * fields[__STAT_IO_TICKS]; 376 write_perf = ((unsigned long long)SECTOR_SIZE 377 * fields[__STAT_WRITE_SECTORS] 378 * fields[__STAT_IN_QUEUE] + (divisor >> 1)) 379 / divisor; 380 write_ios = ((unsigned long long)S_TO_MS * fields[__STAT_WRITE_IOS] 381 * fields[__STAT_IN_QUEUE] + (divisor >> 1)) 382 / divisor; 383 } 384 385 unsigned queue = (fields[__STAT_IN_QUEUE] 386 + (fields[__STAT_IO_TICKS] >> 1)) 387 / fields[__STAT_IO_TICKS]; 388 389 if (!write_perf && !write_ios) { 390 printf("%s: perf(ios) rd: %luKB/s(%lu/s) q: %u\n", 391 path, read_perf, read_ios, queue); 392 } else { 393 printf("%s: perf(ios) rd: %luKB/s(%lu/s) wr: %luKB/s(%lu/s) q: %u\n", 394 path, read_perf, read_ios, write_perf, write_ios, queue); 395 } 396 397 /* bugreport timeout factor adjustment */ 398 if ((write_perf > 1) && (write_perf < worst_write_perf)) { 399 worst_write_perf = write_perf; 400 } 401 } 402 return 0; 403} 404 405/* Copied policy from system/core/logd/LogBuffer.cpp */ 406 407#define LOG_BUFFER_SIZE (256 * 1024) 408#define LOG_BUFFER_MIN_SIZE (64 * 1024UL) 409#define LOG_BUFFER_MAX_SIZE (256 * 1024 * 1024UL) 410 411static bool valid_size(unsigned long value) { 412 if ((value < LOG_BUFFER_MIN_SIZE) || (LOG_BUFFER_MAX_SIZE < value)) { 413 return false; 414 } 415 416 long pages = sysconf(_SC_PHYS_PAGES); 417 if (pages < 1) { 418 return true; 419 } 420 421 long pagesize = sysconf(_SC_PAGESIZE); 422 if (pagesize <= 1) { 423 pagesize = PAGE_SIZE; 424 } 425 426 // maximum memory impact a somewhat arbitrary ~3% 427 pages = (pages + 31) / 32; 428 unsigned long maximum = pages * pagesize; 429 430 if ((maximum < LOG_BUFFER_MIN_SIZE) || (LOG_BUFFER_MAX_SIZE < maximum)) { 431 return true; 432 } 433 434 return value <= maximum; 435} 436 437static unsigned long property_get_size(const char *key) { 438 unsigned long value; 439 char *cp, property[PROPERTY_VALUE_MAX]; 440 441 property_get(key, property, ""); 442 value = strtoul(property, &cp, 10); 443 444 switch(*cp) { 445 case 'm': 446 case 'M': 447 value *= 1024; 448 /* FALLTHRU */ 449 case 'k': 450 case 'K': 451 value *= 1024; 452 /* FALLTHRU */ 453 case '\0': 454 break; 455 456 default: 457 value = 0; 458 } 459 460 if (!valid_size(value)) { 461 value = 0; 462 } 463 464 return value; 465} 466 467/* timeout in ms */ 468static unsigned long logcat_timeout(const char *name) { 469 static const char global_tuneable[] = "persist.logd.size"; // Settings App 470 static const char global_default[] = "ro.logd.size"; // BoardConfig.mk 471 char key[PROP_NAME_MAX]; 472 unsigned long property_size, default_size; 473 474 default_size = property_get_size(global_tuneable); 475 if (!default_size) { 476 default_size = property_get_size(global_default); 477 } 478 479 snprintf(key, sizeof(key), "%s.%s", global_tuneable, name); 480 property_size = property_get_size(key); 481 482 if (!property_size) { 483 snprintf(key, sizeof(key), "%s.%s", global_default, name); 484 property_size = property_get_size(key); 485 } 486 487 if (!property_size) { 488 property_size = default_size; 489 } 490 491 if (!property_size) { 492 property_size = LOG_BUFFER_SIZE; 493 } 494 495 /* Engineering margin is ten-fold our guess */ 496 return 10 * (property_size + worst_write_perf) / worst_write_perf; 497} 498 499/* End copy from system/core/logd/LogBuffer.cpp */ 500 501/* dumps the current system state to stdout */ 502static void print_header(std::string version) { 503 char build[PROPERTY_VALUE_MAX], fingerprint[PROPERTY_VALUE_MAX]; 504 char radio[PROPERTY_VALUE_MAX], bootloader[PROPERTY_VALUE_MAX]; 505 char network[PROPERTY_VALUE_MAX], date[80]; 506 507 property_get("ro.build.display.id", build, "(unknown)"); 508 property_get("ro.build.fingerprint", fingerprint, "(unknown)"); 509 property_get("ro.build.type", build_type, "(unknown)"); 510 property_get("ro.baseband", radio, "(unknown)"); 511 property_get("ro.bootloader", bootloader, "(unknown)"); 512 property_get("gsm.operator.alpha", network, "(unknown)"); 513 strftime(date, sizeof(date), "%Y-%m-%d %H:%M:%S", localtime(&now)); 514 515 printf("========================================================\n"); 516 printf("== dumpstate: %s\n", date); 517 printf("========================================================\n"); 518 519 printf("\n"); 520 printf("Build: %s\n", build); 521 printf("Build fingerprint: '%s'\n", fingerprint); /* format is important for other tools */ 522 printf("Bootloader: %s\n", bootloader); 523 printf("Radio: %s\n", radio); 524 printf("Network: %s\n", network); 525 526 printf("Kernel: "); 527 dump_file(NULL, "/proc/version"); 528 printf("Command line: %s\n", strtok(cmdline_buf, "\n")); 529 printf("Bugreport format version: %s\n", version.c_str()); 530 printf("Dumpstate info: id=%lu pid=%d\n", id, getpid()); 531 printf("\n"); 532} 533 534bool add_zip_entry_from_fd(const std::string& entry_name, int fd) { 535 if (!zip_writer) { 536 MYLOGD("Not adding zip entry %s from fd because zip_writer is not set\n", 537 entry_name.c_str()); 538 return false; 539 } 540 // Logging statement below is useful to time how long each entry takes, but it's too verbose. 541 // MYLOGD("Adding zip entry %s\n", entry_name.c_str()); 542 int32_t err = zip_writer->StartEntryWithTime(entry_name.c_str(), 543 ZipWriter::kCompress, get_mtime(fd, now)); 544 if (err) { 545 MYLOGE("zip_writer->StartEntryWithTime(%s): %s\n", entry_name.c_str(), 546 ZipWriter::ErrorCodeString(err)); 547 return false; 548 } 549 550 std::vector<uint8_t> buffer(65536); 551 while (1) { 552 ssize_t bytes_read = TEMP_FAILURE_RETRY(read(fd, buffer.data(), sizeof(buffer))); 553 if (bytes_read == 0) { 554 break; 555 } else if (bytes_read == -1) { 556 MYLOGE("read(%s): %s\n", entry_name.c_str(), strerror(errno)); 557 return false; 558 } 559 err = zip_writer->WriteBytes(buffer.data(), bytes_read); 560 if (err) { 561 MYLOGE("zip_writer->WriteBytes(): %s\n", ZipWriter::ErrorCodeString(err)); 562 return false; 563 } 564 } 565 566 err = zip_writer->FinishEntry(); 567 if (err) { 568 MYLOGE("zip_writer->FinishEntry(): %s\n", ZipWriter::ErrorCodeString(err)); 569 return false; 570 } 571 572 return true; 573} 574 575bool add_zip_entry(const std::string& entry_name, const std::string& entry_path) { 576 ScopedFd fd(TEMP_FAILURE_RETRY(open(entry_path.c_str(), O_RDONLY | O_NONBLOCK | O_CLOEXEC))); 577 if (fd.get() == -1) { 578 MYLOGE("open(%s): %s\n", entry_path.c_str(), strerror(errno)); 579 return false; 580 } 581 582 return add_zip_entry_from_fd(entry_name, fd.get()); 583} 584 585/* adds a file to the existing zipped bugreport */ 586static int _add_file_from_fd(const char *title, const char *path, int fd) { 587 return add_zip_entry_from_fd(ZIP_ROOT_DIR + path, fd) ? 0 : 1; 588} 589 590void add_dir(const char *dir, bool recursive) { 591 if (!zip_writer) { 592 MYLOGD("Not adding dir %s because zip_writer is not set\n", dir); 593 return; 594 } 595 MYLOGD("Adding dir %s (recursive: %d)\n", dir, recursive); 596 DurationReporter duration_reporter(dir, NULL); 597 dump_files(NULL, dir, recursive ? skip_none : is_dir, _add_file_from_fd); 598} 599 600/* adds a text entry entry to the existing zip file. */ 601static bool add_text_zip_entry(const std::string& entry_name, const std::string& content) { 602 if (!zip_writer) { 603 MYLOGD("Not adding text zip entry %s because zip_writer is not set\n", entry_name.c_str()); 604 return false; 605 } 606 MYLOGD("Adding zip text entry %s\n", entry_name.c_str()); 607 int32_t err = zip_writer->StartEntryWithTime(entry_name.c_str(), ZipWriter::kCompress, now); 608 if (err) { 609 MYLOGE("zip_writer->StartEntryWithTime(%s): %s\n", entry_name.c_str(), 610 ZipWriter::ErrorCodeString(err)); 611 return false; 612 } 613 614 err = zip_writer->WriteBytes(content.c_str(), content.length()); 615 if (err) { 616 MYLOGE("zip_writer->WriteBytes(%s): %s\n", entry_name.c_str(), 617 ZipWriter::ErrorCodeString(err)); 618 return false; 619 } 620 621 err = zip_writer->FinishEntry(); 622 if (err) { 623 MYLOGE("zip_writer->FinishEntry(): %s\n", ZipWriter::ErrorCodeString(err)); 624 return false; 625 } 626 627 return true; 628} 629 630static void dump_iptables() { 631 run_command("IPTABLES", 10, "iptables", "-L", "-nvx", NULL); 632 run_command("IP6TABLES", 10, "ip6tables", "-L", "-nvx", NULL); 633 run_command("IPTABLE NAT", 10, "iptables", "-t", "nat", "-L", "-nvx", NULL); 634 /* no ip6 nat */ 635 run_command("IPTABLE RAW", 10, "iptables", "-t", "raw", "-L", "-nvx", NULL); 636 run_command("IP6TABLE RAW", 10, "ip6tables", "-t", "raw", "-L", "-nvx", NULL); 637} 638 639static void dumpstate(const std::string& screenshot_path, const std::string& version) { 640 DurationReporter duration_reporter("DUMPSTATE"); 641 unsigned long timeout; 642 643 dump_dev_files("TRUSTY VERSION", "/sys/bus/platform/drivers/trusty", "trusty_version"); 644 run_command("UPTIME", 10, "uptime", NULL); 645 dump_files("UPTIME MMC PERF", mmcblk0, skip_not_stat, dump_stat_from_fd); 646 dump_emmc_ecsd("/d/mmc0/mmc0:0001/ext_csd"); 647 dump_file("MEMORY INFO", "/proc/meminfo"); 648 run_command("CPU INFO", 10, "top", "-n", "1", "-d", "1", "-m", "30", "-H", NULL); 649 run_command("PROCRANK", 20, SU_PATH, "root", "procrank", NULL); 650 dump_file("VIRTUAL MEMORY STATS", "/proc/vmstat"); 651 dump_file("VMALLOC INFO", "/proc/vmallocinfo"); 652 dump_file("SLAB INFO", "/proc/slabinfo"); 653 dump_file("ZONEINFO", "/proc/zoneinfo"); 654 dump_file("PAGETYPEINFO", "/proc/pagetypeinfo"); 655 dump_file("BUDDYINFO", "/proc/buddyinfo"); 656 dump_file("FRAGMENTATION INFO", "/d/extfrag/unusable_index"); 657 658 dump_file("KERNEL WAKE SOURCES", "/d/wakeup_sources"); 659 dump_file("KERNEL CPUFREQ", "/sys/devices/system/cpu/cpu0/cpufreq/stats/time_in_state"); 660 dump_file("KERNEL SYNC", "/d/sync"); 661 662 run_command("PROCESSES AND THREADS", 10, "ps", "-Z", "-t", "-p", "-P", NULL); 663 run_command("LIBRANK", 10, SU_PATH, "root", "librank", NULL); 664 665 run_command("PRINTENV", 10, "printenv", NULL); 666 run_command("NETSTAT", 10, "netstat", "-n", NULL); 667 run_command("LSMOD", 10, "lsmod", NULL); 668 669 do_dmesg(); 670 671 run_command("LIST OF OPEN FILES", 10, SU_PATH, "root", "lsof", NULL); 672 for_each_pid(do_showmap, "SMAPS OF ALL PROCESSES"); 673 for_each_tid(show_wchan, "BLOCKED PROCESS WAIT-CHANNELS"); 674 for_each_pid(show_showtime, "PROCESS TIMES (pid cmd user system iowait+percentage)"); 675 676 if (!screenshot_path.empty()) { 677 MYLOGI("taking late screenshot\n"); 678 take_screenshot(screenshot_path); 679 MYLOGI("wrote screenshot: %s\n", screenshot_path.c_str()); 680 } 681 682 // dump_file("EVENT LOG TAGS", "/etc/event-log-tags"); 683 // calculate timeout 684 timeout = logcat_timeout("main") + logcat_timeout("system") + logcat_timeout("crash"); 685 if (timeout < 20000) { 686 timeout = 20000; 687 } 688 run_command("SYSTEM LOG", timeout / 1000, "logcat", "-v", "threadtime", 689 "-v", "printable", 690 "-d", 691 "*:v", NULL); 692 timeout = logcat_timeout("events"); 693 if (timeout < 20000) { 694 timeout = 20000; 695 } 696 run_command("EVENT LOG", timeout / 1000, "logcat", "-b", "events", 697 "-v", "threadtime", 698 "-v", "printable", 699 "-d", 700 "*:v", NULL); 701 timeout = logcat_timeout("radio"); 702 if (timeout < 20000) { 703 timeout = 20000; 704 } 705 run_command("RADIO LOG", timeout / 1000, "logcat", "-b", "radio", 706 "-v", "threadtime", 707 "-v", "printable", 708 "-d", 709 "*:v", NULL); 710 711 run_command("LOG STATISTICS", 10, "logcat", "-b", "all", "-S", NULL); 712 713 run_command("RAFT LOGS", 600, SU_PATH, "root", "logcompressor", "-r", RAFT_DIR, NULL); 714 715 /* show the traces we collected in main(), if that was done */ 716 if (dump_traces_path != NULL) { 717 dump_file("VM TRACES JUST NOW", dump_traces_path); 718 } 719 720 /* only show ANR traces if they're less than 15 minutes old */ 721 struct stat st; 722 char anr_traces_path[PATH_MAX]; 723 property_get("dalvik.vm.stack-trace-file", anr_traces_path, ""); 724 if (!anr_traces_path[0]) { 725 printf("*** NO VM TRACES FILE DEFINED (dalvik.vm.stack-trace-file)\n\n"); 726 } else { 727 int fd = TEMP_FAILURE_RETRY(open(anr_traces_path, 728 O_RDONLY | O_CLOEXEC | O_NOFOLLOW | O_NONBLOCK)); 729 if (fd < 0) { 730 printf("*** NO ANR VM TRACES FILE (%s): %s\n\n", anr_traces_path, strerror(errno)); 731 } else { 732 dump_file_from_fd("VM TRACES AT LAST ANR", anr_traces_path, fd); 733 } 734 } 735 736 /* slow traces for slow operations */ 737 if (anr_traces_path[0] != 0) { 738 int tail = strlen(anr_traces_path)-1; 739 while (tail > 0 && anr_traces_path[tail] != '/') { 740 tail--; 741 } 742 int i = 0; 743 while (1) { 744 sprintf(anr_traces_path+tail+1, "slow%02d.txt", i); 745 if (stat(anr_traces_path, &st)) { 746 // No traces file at this index, done with the files. 747 break; 748 } 749 dump_file("VM TRACES WHEN SLOW", anr_traces_path); 750 i++; 751 } 752 } 753 754 int dumped = 0; 755 for (size_t i = 0; i < NUM_TOMBSTONES; i++) { 756 if (tombstone_data[i].fd != -1) { 757 const char *name = tombstone_data[i].name; 758 int fd = tombstone_data[i].fd; 759 dumped = 1; 760 if (zip_writer) { 761 if (!add_zip_entry_from_fd(ZIP_ROOT_DIR + name, fd)) { 762 MYLOGE("Unable to add tombstone %s to zip file\n", name); 763 } 764 } else { 765 dump_file_from_fd("TOMBSTONE", name, fd); 766 } 767 close(fd); 768 tombstone_data[i].fd = -1; 769 } 770 } 771 if (!dumped) { 772 printf("*** NO TOMBSTONES to dump in %s\n\n", TOMBSTONE_DIR); 773 } 774 775 dump_file("NETWORK DEV INFO", "/proc/net/dev"); 776 dump_file("QTAGUID NETWORK INTERFACES INFO", "/proc/net/xt_qtaguid/iface_stat_all"); 777 dump_file("QTAGUID NETWORK INTERFACES INFO (xt)", "/proc/net/xt_qtaguid/iface_stat_fmt"); 778 dump_file("QTAGUID CTRL INFO", "/proc/net/xt_qtaguid/ctrl"); 779 dump_file("QTAGUID STATS INFO", "/proc/net/xt_qtaguid/stats"); 780 781 if (!stat(PSTORE_LAST_KMSG, &st)) { 782 /* Also TODO: Make console-ramoops CAP_SYSLOG protected. */ 783 dump_file("LAST KMSG", PSTORE_LAST_KMSG); 784 } else { 785 /* TODO: Make last_kmsg CAP_SYSLOG protected. b/5555691 */ 786 dump_file("LAST KMSG", "/proc/last_kmsg"); 787 } 788 789 /* kernels must set CONFIG_PSTORE_PMSG, slice up pstore with device tree */ 790 run_command("LAST LOGCAT", 10, "logcat", "-L", 791 "-b", "all", 792 "-v", "threadtime", 793 "-v", "printable", 794 "-d", 795 "*:v", NULL); 796 797 /* The following have a tendency to get wedged when wifi drivers/fw goes belly-up. */ 798 799 run_command("NETWORK INTERFACES", 10, "ip", "link", NULL); 800 801 run_command("IPv4 ADDRESSES", 10, "ip", "-4", "addr", "show", NULL); 802 run_command("IPv6 ADDRESSES", 10, "ip", "-6", "addr", "show", NULL); 803 804 run_command("IP RULES", 10, "ip", "rule", "show", NULL); 805 run_command("IP RULES v6", 10, "ip", "-6", "rule", "show", NULL); 806 807 dump_route_tables(); 808 809 run_command("ARP CACHE", 10, "ip", "-4", "neigh", "show", NULL); 810 run_command("IPv6 ND CACHE", 10, "ip", "-6", "neigh", "show", NULL); 811 run_command("MULTICAST ADDRESSES", 10, "ip", "maddr", NULL); 812 run_command("WIFI NETWORKS", 20, "wpa_cli", "IFNAME=wlan0", "list_networks", NULL); 813 814#ifdef FWDUMP_bcmdhd 815 run_command("ND OFFLOAD TABLE", 5, 816 SU_PATH, "root", WLUTIL, "nd_hostip", NULL); 817 818 run_command("DUMP WIFI INTERNAL COUNTERS (1)", 20, 819 SU_PATH, "root", WLUTIL, "counters", NULL); 820 821 run_command("ND OFFLOAD STATUS (1)", 5, 822 SU_PATH, "root", WLUTIL, "nd_status", NULL); 823 824#endif 825 dump_file("INTERRUPTS (1)", "/proc/interrupts"); 826 827 run_command("NETWORK DIAGNOSTICS", 10, "dumpsys", "-t", "10", "connectivity", "--diag", NULL); 828 829#ifdef FWDUMP_bcmdhd 830 run_command("DUMP WIFI STATUS", 20, 831 SU_PATH, "root", "dhdutil", "-i", "wlan0", "dump", NULL); 832 833 run_command("DUMP WIFI INTERNAL COUNTERS (2)", 20, 834 SU_PATH, "root", WLUTIL, "counters", NULL); 835 836 run_command("ND OFFLOAD STATUS (2)", 5, 837 SU_PATH, "root", WLUTIL, "nd_status", NULL); 838#endif 839 dump_file("INTERRUPTS (2)", "/proc/interrupts"); 840 841 print_properties(); 842 843 run_command("VOLD DUMP", 10, "vdc", "dump", NULL); 844 run_command("SECURE CONTAINERS", 10, "vdc", "asec", "list", NULL); 845 846 run_command("FILESYSTEMS & FREE SPACE", 10, "df", NULL); 847 848 run_command("LAST RADIO LOG", 10, "parse_radio_log", "/proc/last_radio_log", NULL); 849 850 printf("------ BACKLIGHTS ------\n"); 851 printf("LCD brightness="); 852 dump_file(NULL, "/sys/class/leds/lcd-backlight/brightness"); 853 printf("Button brightness="); 854 dump_file(NULL, "/sys/class/leds/button-backlight/brightness"); 855 printf("Keyboard brightness="); 856 dump_file(NULL, "/sys/class/leds/keyboard-backlight/brightness"); 857 printf("ALS mode="); 858 dump_file(NULL, "/sys/class/leds/lcd-backlight/als"); 859 printf("LCD driver registers:\n"); 860 dump_file(NULL, "/sys/class/leds/lcd-backlight/registers"); 861 printf("\n"); 862 863 /* Binder state is expensive to look at as it uses a lot of memory. */ 864 dump_file("BINDER FAILED TRANSACTION LOG", "/sys/kernel/debug/binder/failed_transaction_log"); 865 dump_file("BINDER TRANSACTION LOG", "/sys/kernel/debug/binder/transaction_log"); 866 dump_file("BINDER TRANSACTIONS", "/sys/kernel/debug/binder/transactions"); 867 dump_file("BINDER STATS", "/sys/kernel/debug/binder/stats"); 868 dump_file("BINDER STATE", "/sys/kernel/debug/binder/state"); 869 870 printf("========================================================\n"); 871 printf("== Board\n"); 872 printf("========================================================\n"); 873 874 dumpstate_board(); 875 printf("\n"); 876 877 /* Migrate the ril_dumpstate to a dumpstate_board()? */ 878 char ril_dumpstate_timeout[PROPERTY_VALUE_MAX] = {0}; 879 property_get("ril.dumpstate.timeout", ril_dumpstate_timeout, "30"); 880 if (strnlen(ril_dumpstate_timeout, PROPERTY_VALUE_MAX - 1) > 0) { 881 if (is_user_build()) { 882 // su does not exist on user builds, so try running without it. 883 // This way any implementations of vril-dump that do not require 884 // root can run on user builds. 885 run_command("DUMP VENDOR RIL LOGS", atoi(ril_dumpstate_timeout), 886 "vril-dump", NULL); 887 } else { 888 run_command("DUMP VENDOR RIL LOGS", atoi(ril_dumpstate_timeout), 889 SU_PATH, "root", "vril-dump", NULL); 890 } 891 } 892 893 printf("========================================================\n"); 894 printf("== Android Framework Services\n"); 895 printf("========================================================\n"); 896 897 run_command("DUMPSYS", 60, "dumpsys", "-t", "60", "--skip", "meminfo", "cpuinfo", NULL); 898 899 printf("========================================================\n"); 900 printf("== Checkins\n"); 901 printf("========================================================\n"); 902 903 run_command("CHECKIN BATTERYSTATS", 30, "dumpsys", "-t", "30", "batterystats", "-c", NULL); 904 run_command("CHECKIN MEMINFO", 30, "dumpsys", "-t", "30", "meminfo", "--checkin", NULL); 905 run_command("CHECKIN NETSTATS", 30, "dumpsys", "-t", "30", "netstats", "--checkin", NULL); 906 run_command("CHECKIN PROCSTATS", 30, "dumpsys", "-t", "30", "procstats", "-c", NULL); 907 run_command("CHECKIN USAGESTATS", 30, "dumpsys", "-t", "30", "usagestats", "-c", NULL); 908 run_command("CHECKIN PACKAGE", 30, "dumpsys", "-t", "30", "package", "--checkin", NULL); 909 910 printf("========================================================\n"); 911 printf("== Running Application Activities\n"); 912 printf("========================================================\n"); 913 914 run_command("APP ACTIVITIES", 30, "dumpsys", "-t", "30", "activity", "all", NULL); 915 916 printf("========================================================\n"); 917 printf("== Running Application Services\n"); 918 printf("========================================================\n"); 919 920 run_command("APP SERVICES", 30, "dumpsys", "-t", "30", "activity", "service", "all", NULL); 921 922 printf("========================================================\n"); 923 printf("== Running Application Providers\n"); 924 printf("========================================================\n"); 925 926 run_command("APP SERVICES", 30, "dumpsys", "-t", "30", "activity", "provider", "all", NULL); 927 928 929 printf("========================================================\n"); 930 printf("== Final progress (pid %d): %d/%d (originally %d)\n", 931 getpid(), progress, weight_total, WEIGHT_TOTAL); 932 printf("========================================================\n"); 933 printf("== dumpstate: done\n"); 934 printf("========================================================\n"); 935} 936 937static void usage() { 938 fprintf(stderr, 939 "usage: dumpstate [-h] [-b soundfile] [-e soundfile] [-o file [-d] [-p] " 940 "[-z]] [-s] [-S] [-q] [-B] [-P] [-R] [-V version]\n" 941 " -h: display this help message\n" 942 " -b: play sound file instead of vibrate, at beginning of job\n" 943 " -e: play sound file instead of vibrate, at end of job\n" 944 " -o: write to file (instead of stdout)\n" 945 " -d: append date to filename (requires -o)\n" 946 " -p: capture screenshot to filename.png (requires -o)\n" 947 " -z: generate zipped file (requires -o)\n" 948 " -s: write output to control socket (for init)\n" 949 " -S: write file location to control socket (for init; requires -o and -z)" 950 " -q: disable vibrate\n" 951 " -B: send broadcast when finished (requires -o)\n" 952 " -P: send broadcast when started and update system properties on " 953 "progress (requires -o and -B)\n" 954 " -R: take bugreport in remote mode (requires -o, -z, -d and -B, " 955 "shouldn't be used with -P)\n" 956 " -V: sets the bugreport format version (valid values: %s)\n", 957 VERSION_DEFAULT.c_str()); 958} 959 960static void sigpipe_handler(int n) { 961 // don't complain to stderr or stdout 962 _exit(EXIT_FAILURE); 963} 964 965/* adds the temporary report to the existing .zip file, closes the .zip file, and removes the 966 temporary file. 967 */ 968static bool finish_zip_file(const std::string& bugreport_name, const std::string& bugreport_path, 969 time_t now) { 970 if (!add_zip_entry(bugreport_name, bugreport_path)) { 971 MYLOGE("Failed to add text entry to .zip file\n"); 972 return false; 973 } 974 if (!add_text_zip_entry("main_entry.txt", bugreport_name)) { 975 MYLOGE("Failed to add main_entry.txt to .zip file\n"); 976 return false; 977 } 978 979 int32_t err = zip_writer->Finish(); 980 if (err) { 981 MYLOGE("zip_writer->Finish(): %s\n", ZipWriter::ErrorCodeString(err)); 982 return false; 983 } 984 985 if (is_user_build()) { 986 MYLOGD("Removing temporary file %s\n", bugreport_path.c_str()) 987 if (remove(bugreport_path.c_str())) { 988 ALOGW("remove(%s): %s\n", bugreport_path.c_str(), strerror(errno)); 989 } 990 } else { 991 MYLOGD("Keeping temporary file %s on non-user build\n", bugreport_path.c_str()) 992 } 993 994 return true; 995} 996 997static std::string SHA256_file_hash(std::string filepath) { 998 ScopedFd fd(TEMP_FAILURE_RETRY(open(filepath.c_str(), O_RDONLY | O_NONBLOCK | O_CLOEXEC 999 | O_NOFOLLOW))); 1000 if (fd.get() == -1) { 1001 MYLOGE("open(%s): %s\n", filepath.c_str(), strerror(errno)); 1002 return NULL; 1003 } 1004 1005 SHA256_CTX ctx; 1006 SHA256_init(&ctx); 1007 1008 std::vector<uint8_t> buffer(65536); 1009 while (1) { 1010 ssize_t bytes_read = TEMP_FAILURE_RETRY(read(fd.get(), buffer.data(), buffer.size())); 1011 if (bytes_read == 0) { 1012 break; 1013 } else if (bytes_read == -1) { 1014 MYLOGE("read(%s): %s\n", filepath.c_str(), strerror(errno)); 1015 return NULL; 1016 } 1017 1018 SHA256_update(&ctx, buffer.data(), bytes_read); 1019 } 1020 1021 uint8_t hash[SHA256_DIGEST_SIZE]; 1022 memcpy(hash, SHA256_final(&ctx), SHA256_DIGEST_SIZE); 1023 char hash_buffer[SHA256_DIGEST_SIZE * 2 + 1]; 1024 for(size_t i = 0; i < SHA256_DIGEST_SIZE; i++) { 1025 sprintf(hash_buffer + (i * 2), "%02x", hash[i]); 1026 } 1027 hash_buffer[sizeof(hash_buffer) - 1] = 0; 1028 return std::string(hash_buffer); 1029} 1030 1031int main(int argc, char *argv[]) { 1032 struct sigaction sigact; 1033 int do_add_date = 0; 1034 int do_zip_file = 0; 1035 int do_vibrate = 1; 1036 char* use_outfile = 0; 1037 int use_socket = 0; 1038 int use_control_socket = 0; 1039 int do_fb = 0; 1040 int do_broadcast = 0; 1041 int do_early_screenshot = 0; 1042 int is_remote_mode = 0; 1043 std::string version = VERSION_DEFAULT; 1044 1045 now = time(NULL); 1046 1047 MYLOGI("begin\n"); 1048 1049 /* gets the sequential id */ 1050 char last_id[PROPERTY_VALUE_MAX]; 1051 property_get("dumpstate.last_id", last_id, "0"); 1052 id = strtoul(last_id, NULL, 10) + 1; 1053 snprintf(last_id, sizeof(last_id), "%lu", id); 1054 property_set("dumpstate.last_id", last_id); 1055 MYLOGI("dumpstate id: %lu\n", id); 1056 1057 /* clear SIGPIPE handler */ 1058 memset(&sigact, 0, sizeof(sigact)); 1059 sigact.sa_handler = sigpipe_handler; 1060 sigaction(SIGPIPE, &sigact, NULL); 1061 1062 /* set as high priority, and protect from OOM killer */ 1063 setpriority(PRIO_PROCESS, 0, -20); 1064 FILE *oom_adj = fopen("/proc/self/oom_adj", "we"); 1065 if (oom_adj) { 1066 fputs("-17", oom_adj); 1067 fclose(oom_adj); 1068 } 1069 1070 /* parse arguments */ 1071 std::string args; 1072 format_args(argc, const_cast<const char **>(argv), &args); 1073 MYLOGD("Dumpstate command line: %s\n", args.c_str()); 1074 int c; 1075 while ((c = getopt(argc, argv, "dho:svqzpPBRSV:")) != -1) { 1076 switch (c) { 1077 case 'd': do_add_date = 1; break; 1078 case 'z': do_zip_file = 1; break; 1079 case 'o': use_outfile = optarg; break; 1080 case 's': use_socket = 1; break; 1081 case 'S': use_control_socket = 1; break; 1082 case 'v': break; // compatibility no-op 1083 case 'q': do_vibrate = 0; break; 1084 case 'p': do_fb = 1; break; 1085 case 'P': do_update_progress = 1; break; 1086 case 'R': is_remote_mode = 1; break; 1087 case 'B': do_broadcast = 1; break; 1088 case 'V': version = optarg; break; 1089 case '?': printf("\n"); 1090 case 'h': 1091 usage(); 1092 exit(1); 1093 } 1094 } 1095 1096 if ((do_zip_file || do_add_date || do_update_progress || do_broadcast) && !use_outfile) { 1097 usage(); 1098 exit(1); 1099 } 1100 1101 if (use_control_socket && !do_zip_file) { 1102 usage(); 1103 exit(1); 1104 } 1105 1106 if (do_update_progress && !do_broadcast) { 1107 usage(); 1108 exit(1); 1109 } 1110 1111 if (is_remote_mode && (do_update_progress || !do_broadcast || !do_zip_file || !do_add_date)) { 1112 usage(); 1113 exit(1); 1114 } 1115 1116 if (version != VERSION_DEFAULT) { 1117 usage(); 1118 exit(1); 1119 } 1120 1121 MYLOGI("bugreport format version: %s\n", version.c_str()); 1122 1123 do_early_screenshot = do_update_progress; 1124 1125 // If we are going to use a socket, do it as early as possible 1126 // to avoid timeouts from bugreport. 1127 if (use_socket) { 1128 redirect_to_socket(stdout, "dumpstate"); 1129 } 1130 1131 if (use_control_socket) { 1132 MYLOGD("Opening control socket\n"); 1133 control_socket_fd = open_socket("dumpstate"); 1134 } 1135 1136 /* full path of the temporary file containing the bugreport */ 1137 std::string tmp_path; 1138 1139 /* full path of the file containing the dumpstate logs*/ 1140 std::string log_path; 1141 1142 /* full path of the systrace file, when enabled */ 1143 std::string systrace_path; 1144 1145 /* full path of the temporary file containing the screenshot (when requested) */ 1146 std::string screenshot_path; 1147 1148 /* base name (without suffix or extensions) of the bugreport files */ 1149 std::string base_name; 1150 1151 /* pointer to the actual path, be it zip or text */ 1152 std::string path; 1153 1154 /* pointer to the zipped file */ 1155 std::unique_ptr<FILE, int(*)(FILE*)> zip_file(NULL, fclose); 1156 1157 /* redirect output if needed */ 1158 bool is_redirecting = !use_socket && use_outfile; 1159 1160 if (is_redirecting) { 1161 bugreport_dir = dirname(use_outfile); 1162 base_name = basename(use_outfile); 1163 if (do_add_date) { 1164 char date[80]; 1165 strftime(date, sizeof(date), "%Y-%m-%d-%H-%M-%S", localtime(&now)); 1166 suffix = date; 1167 } else { 1168 suffix = "undated"; 1169 } 1170 char build_id[PROPERTY_VALUE_MAX]; 1171 property_get("ro.build.id", build_id, "UNKNOWN_BUILD"); 1172 base_name = base_name + "-" + build_id; 1173 if (do_fb) { 1174 // TODO: if dumpstate was an object, the paths could be internal variables and then 1175 // we could have a function to calculate the derived values, such as: 1176 // screenshot_path = GetPath(".png"); 1177 screenshot_path = bugreport_dir + "/" + base_name + "-" + suffix + ".png"; 1178 } 1179 tmp_path = bugreport_dir + "/" + base_name + "-" + suffix + ".tmp"; 1180 log_path = bugreport_dir + "/dumpstate_log-" + suffix + "-" 1181 + std::to_string(getpid()) + ".txt"; 1182 1183 MYLOGD("Bugreport dir: %s\n" 1184 "Base name: %s\n" 1185 "Suffix: %s\n" 1186 "Log path: %s\n" 1187 "Temporary path: %s\n" 1188 "Screenshot path: %s\n", 1189 bugreport_dir.c_str(), base_name.c_str(), suffix.c_str(), 1190 log_path.c_str(), tmp_path.c_str(), screenshot_path.c_str()); 1191 1192 if (do_zip_file) { 1193 path = bugreport_dir + "/" + base_name + "-" + suffix + ".zip"; 1194 MYLOGD("Creating initial .zip file (%s)\n", path.c_str()); 1195 create_parent_dirs(path.c_str()); 1196 zip_file.reset(fopen(path.c_str(), "wb")); 1197 if (!zip_file) { 1198 MYLOGE("fopen(%s, 'wb'): %s\n", path.c_str(), strerror(errno)); 1199 do_zip_file = 0; 1200 } else { 1201 zip_writer.reset(new ZipWriter(zip_file.get())); 1202 } 1203 add_text_zip_entry("version.txt", version); 1204 } 1205 1206 if (do_update_progress) { 1207 std::vector<std::string> am_args = { 1208 "--receiver-permission", "android.permission.DUMP", "--receiver-foreground", 1209 "--es", "android.intent.extra.NAME", suffix, 1210 "--ei", "android.intent.extra.ID", std::to_string(id), 1211 "--ei", "android.intent.extra.PID", std::to_string(getpid()), 1212 "--ei", "android.intent.extra.MAX", std::to_string(WEIGHT_TOTAL), 1213 }; 1214 send_broadcast("android.intent.action.BUGREPORT_STARTED", am_args); 1215 } 1216 } 1217 1218 /* read /proc/cmdline before dropping root */ 1219 FILE *cmdline = fopen("/proc/cmdline", "re"); 1220 if (cmdline) { 1221 fgets(cmdline_buf, sizeof(cmdline_buf), cmdline); 1222 fclose(cmdline); 1223 } 1224 1225 /* open the vibrator before dropping root */ 1226 std::unique_ptr<FILE, int(*)(FILE*)> vibrator(NULL, fclose); 1227 if (do_vibrate) { 1228 vibrator.reset(fopen("/sys/class/timed_output/vibrator/enable", "we")); 1229 if (vibrator) { 1230 vibrate(vibrator.get(), 150); 1231 } 1232 } 1233 1234 if (do_fb && do_early_screenshot) { 1235 if (screenshot_path.empty()) { 1236 // should not have happened 1237 MYLOGE("INTERNAL ERROR: skipping early screenshot because path was not set\n"); 1238 } else { 1239 MYLOGI("taking early screenshot\n"); 1240 take_screenshot(screenshot_path); 1241 MYLOGI("wrote screenshot: %s\n", screenshot_path.c_str()); 1242 if (chown(screenshot_path.c_str(), AID_SHELL, AID_SHELL)) { 1243 MYLOGE("Unable to change ownership of screenshot file %s: %s\n", 1244 screenshot_path.c_str(), strerror(errno)); 1245 } 1246 } 1247 } 1248 1249 if (do_zip_file) { 1250 if (chown(path.c_str(), AID_SHELL, AID_SHELL)) { 1251 MYLOGE("Unable to change ownership of zip file %s: %s\n", path.c_str(), strerror(errno)); 1252 } 1253 } 1254 1255 if (is_redirecting) { 1256 redirect_to_file(stderr, const_cast<char*>(log_path.c_str())); 1257 if (chown(log_path.c_str(), AID_SHELL, AID_SHELL)) { 1258 MYLOGE("Unable to change ownership of dumpstate log file %s: %s\n", 1259 log_path.c_str(), strerror(errno)); 1260 } 1261 /* TODO: rather than generating a text file now and zipping it later, 1262 it would be more efficient to redirect stdout to the zip entry 1263 directly, but the libziparchive doesn't support that option yet. */ 1264 redirect_to_file(stdout, const_cast<char*>(tmp_path.c_str())); 1265 if (chown(tmp_path.c_str(), AID_SHELL, AID_SHELL)) { 1266 MYLOGE("Unable to change ownership of temporary bugreport file %s: %s\n", 1267 tmp_path.c_str(), strerror(errno)); 1268 } 1269 } 1270 // NOTE: there should be no stdout output until now, otherwise it would break the header. 1271 // In particular, DurationReport objects should be created passing 'title, NULL', so their 1272 // duration is logged into MYLOG instead. 1273 print_header(version); 1274 1275 // Dumps systrace right away, otherwise it will be filled with unnecessary events. 1276 dump_systrace(); 1277 1278 // Invoking the following dumpsys calls before dump_traces() to try and 1279 // keep the system stats as close to its initial state as possible. 1280 run_command_as_shell("DUMPSYS MEMINFO", 30, "dumpsys", "-t", "30", "meminfo", "-a", NULL); 1281 run_command_as_shell("DUMPSYS CPUINFO", 10, "dumpsys", "-t", "10", "cpuinfo", "-a", NULL); 1282 1283 /* collect stack traces from Dalvik and native processes (needs root) */ 1284 dump_traces_path = dump_traces(); 1285 1286 /* Run some operations that require root. */ 1287 get_tombstone_fds(tombstone_data); 1288 add_dir(RECOVERY_DIR, true); 1289 add_dir(RECOVERY_DATA_DIR, true); 1290 add_dir(LOGPERSIST_DATA_DIR, false); 1291 if (!is_user_build()) { 1292 add_dir(PROFILE_DATA_DIR_CUR, true); 1293 add_dir(PROFILE_DATA_DIR_REF, true); 1294 } 1295 add_mountinfo(); 1296 dump_iptables(); 1297 1298 if (!drop_root_user()) { 1299 return -1; 1300 } 1301 1302 dumpstate(do_early_screenshot ? "": screenshot_path, version); 1303 1304 /* close output if needed */ 1305 if (is_redirecting) { 1306 fclose(stdout); 1307 } 1308 1309 /* rename or zip the (now complete) .tmp file to its final location */ 1310 if (use_outfile) { 1311 1312 /* check if user changed the suffix using system properties */ 1313 char key[PROPERTY_KEY_MAX]; 1314 char value[PROPERTY_VALUE_MAX]; 1315 snprintf(key, sizeof(key), "dumpstate.%d.name", getpid()); 1316 property_get(key, value, ""); 1317 bool change_suffix= false; 1318 if (value[0]) { 1319 /* must whitelist which characters are allowed, otherwise it could cross directories */ 1320 std::regex valid_regex("^[-_a-zA-Z0-9]+$"); 1321 if (std::regex_match(value, valid_regex)) { 1322 change_suffix = true; 1323 } else { 1324 MYLOGE("invalid suffix provided by user: %s\n", value); 1325 } 1326 } 1327 if (change_suffix) { 1328 MYLOGI("changing suffix from %s to %s\n", suffix.c_str(), value); 1329 suffix = value; 1330 if (!screenshot_path.empty()) { 1331 std::string new_screenshot_path = 1332 bugreport_dir + "/" + base_name + "-" + suffix + ".png"; 1333 if (rename(screenshot_path.c_str(), new_screenshot_path.c_str())) { 1334 MYLOGE("rename(%s, %s): %s\n", screenshot_path.c_str(), 1335 new_screenshot_path.c_str(), strerror(errno)); 1336 } else { 1337 screenshot_path = new_screenshot_path; 1338 } 1339 } 1340 } 1341 1342 bool do_text_file = true; 1343 if (do_zip_file) { 1344 std::string entry_name = base_name + "-" + suffix + ".txt"; 1345 MYLOGD("Adding main entry (%s) to .zip bugreport\n", entry_name.c_str()); 1346 if (!finish_zip_file(entry_name, tmp_path, now)) { 1347 MYLOGE("Failed to finish zip file; sending text bugreport instead\n"); 1348 do_text_file = true; 1349 } else { 1350 do_text_file = false; 1351 // Since zip file is already created, it needs to be renamed. 1352 std::string new_path = bugreport_dir + "/" + base_name + "-" + suffix + ".zip"; 1353 if (path != new_path) { 1354 MYLOGD("Renaming zip file from %s to %s\n", path.c_str(), new_path.c_str()); 1355 if (rename(path.c_str(), new_path.c_str())) { 1356 MYLOGE("rename(%s, %s): %s\n", path.c_str(), 1357 new_path.c_str(), strerror(errno)); 1358 } else { 1359 path = new_path; 1360 } 1361 } 1362 } 1363 } 1364 if (do_text_file) { 1365 path = bugreport_dir + "/" + base_name + "-" + suffix + ".txt"; 1366 MYLOGD("Generating .txt bugreport at %s from %s\n", path.c_str(), tmp_path.c_str()); 1367 if (rename(tmp_path.c_str(), path.c_str())) { 1368 MYLOGE("rename(%s, %s): %s\n", tmp_path.c_str(), path.c_str(), strerror(errno)); 1369 path.clear(); 1370 } 1371 } 1372 if (use_control_socket) { 1373 if (do_text_file) { 1374 dprintf(control_socket_fd, "FAIL:could not create zip file, check %s " 1375 "for more details\n", log_path.c_str()); 1376 } else { 1377 dprintf(control_socket_fd, "OK:%s\n", path.c_str()); 1378 } 1379 } 1380 } 1381 1382 /* vibrate a few but shortly times to let user know it's finished */ 1383 if (vibrator) { 1384 for (int i = 0; i < 3; i++) { 1385 vibrate(vibrator.get(), 75); 1386 usleep((75 + 50) * 1000); 1387 } 1388 } 1389 1390 /* tell activity manager we're done */ 1391 if (do_broadcast) { 1392 if (!path.empty()) { 1393 MYLOGI("Final bugreport path: %s\n", path.c_str()); 1394 std::vector<std::string> am_args = { 1395 "--receiver-permission", "android.permission.DUMP", "--receiver-foreground", 1396 "--ei", "android.intent.extra.ID", std::to_string(id), 1397 "--ei", "android.intent.extra.PID", std::to_string(getpid()), 1398 "--ei", "android.intent.extra.MAX", std::to_string(weight_total), 1399 "--es", "android.intent.extra.BUGREPORT", path, 1400 "--es", "android.intent.extra.DUMPSTATE_LOG", log_path 1401 }; 1402 if (do_fb) { 1403 am_args.push_back("--es"); 1404 am_args.push_back("android.intent.extra.SCREENSHOT"); 1405 am_args.push_back(screenshot_path); 1406 } 1407 if (is_remote_mode) { 1408 am_args.push_back("--es"); 1409 am_args.push_back("android.intent.extra.REMOTE_BUGREPORT_HASH"); 1410 am_args.push_back(SHA256_file_hash(path)); 1411 send_broadcast("android.intent.action.REMOTE_BUGREPORT_FINISHED", am_args); 1412 } else { 1413 send_broadcast("android.intent.action.BUGREPORT_FINISHED", am_args); 1414 } 1415 } else { 1416 MYLOGE("Skipping finished broadcast because bugreport could not be generated\n"); 1417 } 1418 } 1419 1420 MYLOGD("Final progress: %d/%d (originally %d)\n", progress, weight_total, WEIGHT_TOTAL); 1421 MYLOGI("done\n"); 1422 1423 if (is_redirecting) { 1424 fclose(stderr); 1425 } 1426 1427 if (use_control_socket && control_socket_fd >= 0) { 1428 MYLOGD("Closing control socket\n"); 1429 close(control_socket_fd); 1430 } 1431 1432 return 0; 1433} 1434