blob: 8e2e484fb2e8d80f1041cd658c590cd9a5b65aa1 [file] [log] [blame]
Colin Crossf45fa6b2012-03-26 12:38:26 -07001/*
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
Arve Hjønnevåg2db0f5f2014-10-15 18:08:37 -070017#include <dirent.h>
Colin Crossf45fa6b2012-03-26 12:38:26 -070018#include <errno.h>
19#include <fcntl.h>
Felipe Lemead5f6c42015-11-30 14:26:46 -080020#include <libgen.h>
Colin Crossf45fa6b2012-03-26 12:38:26 -070021#include <limits.h>
Felipe Leme6e01fa62015-11-11 19:35:14 -080022#include <memory>
Felipe Lemead5f6c42015-11-30 14:26:46 -080023#include <regex>
Felipe Leme635ca312016-01-05 14:23:02 -080024#include <set>
Mark Salyzyn8f37aa52015-06-12 12:28:24 -070025#include <stdbool.h>
Colin Crossf45fa6b2012-03-26 12:38:26 -070026#include <stdio.h>
27#include <stdlib.h>
Felipe Leme6e01fa62015-11-11 19:35:14 -080028#include <string>
Colin Crossf45fa6b2012-03-26 12:38:26 -070029#include <string.h>
Christopher Ferris7dc7f322014-07-22 16:08:19 -070030#include <sys/prctl.h>
Colin Crossf45fa6b2012-03-26 12:38:26 -070031#include <sys/resource.h>
32#include <sys/stat.h>
33#include <sys/time.h>
34#include <sys/wait.h>
35#include <unistd.h>
Colin Crossf45fa6b2012-03-26 12:38:26 -070036
Elliott Hughes9dc117c2015-12-07 14:21:50 -080037#include <android-base/stringprintf.h>
Colin Crossf45fa6b2012-03-26 12:38:26 -070038#include <cutils/properties.h>
39
40#include "private/android_filesystem_config.h"
41
42#define LOG_TAG "dumpstate"
Alex Ray656a6b92013-07-23 13:44:34 -070043#include <cutils/log.h>
Colin Crossf45fa6b2012-03-26 12:38:26 -070044
45#include "dumpstate.h"
Felipe Leme6e01fa62015-11-11 19:35:14 -080046#include "ScopedFd.h"
47#include "ziparchive/zip_writer.h"
48
Michal Karpinski4db754f2015-12-11 18:04:32 +000049#include "mincrypt/sha256.h"
50
Felipe Leme6e01fa62015-11-11 19:35:14 -080051using android::base::StringPrintf;
Colin Crossf45fa6b2012-03-26 12:38:26 -070052
53/* read before root is shed */
54static char cmdline_buf[16384] = "(unknown)";
55static const char *dump_traces_path = NULL;
56
Felipe Lemeefd7e272016-05-18 09:27:16 -070057// TODO: variables below should be part of dumpstate object
Felipe Leme8fecfdd2016-02-09 10:40:07 -080058static unsigned long id;
Felipe Leme78f2c862015-12-21 09:55:22 -080059static char build_type[PROPERTY_VALUE_MAX];
Felipe Lemee82a27d2016-01-05 13:35:44 -080060static time_t now;
61static std::unique_ptr<ZipWriter> zip_writer;
Felipe Leme635ca312016-01-05 14:23:02 -080062static std::set<std::string> mount_points;
63void add_mountinfo();
Felipe Leme2628e9e2016-04-12 16:36:51 -070064static int control_socket_fd;
Felipe Lemeefd7e272016-05-18 09:27:16 -070065/* 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;
Felipe Leme78f2c862015-12-21 09:55:22 -080068
Todd Poynor2a83daa2013-11-22 15:44:22 -080069#define PSTORE_LAST_KMSG "/sys/fs/pstore/console-ramoops"
70
Wei Liu341938b2016-04-27 16:18:17 -070071#define RAFT_DIR "/data/misc/raft"
Felipe Lemee82a27d2016-01-05 13:35:44 -080072#define RECOVERY_DIR "/cache/recovery"
Mark Salyzynd6ab0112016-03-25 12:56:39 -070073#define RECOVERY_DATA_DIR "/data/misc/recovery"
Mark Salyzyn4d42dea2016-04-01 10:03:14 -070074#define LOGPERSIST_DATA_DIR "/data/misc/logd"
Christopher Ferris7dc7f322014-07-22 16:08:19 -070075#define TOMBSTONE_DIR "/data/tombstones"
76#define TOMBSTONE_FILE_PREFIX TOMBSTONE_DIR "/tombstone_"
77/* Can accomodate a tombstone number up to 9999. */
78#define TOMBSTONE_MAX_LEN (sizeof(TOMBSTONE_FILE_PREFIX) + 4)
79#define NUM_TOMBSTONES 10
80
81typedef struct {
82 char name[TOMBSTONE_MAX_LEN];
83 int fd;
84} tombstone_data_t;
85
86static tombstone_data_t tombstone_data[NUM_TOMBSTONES];
87
Felipe Leme71ca15e2016-05-19 16:18:17 -070088const std::string ZIP_ROOT_DIR = "FS";
89std::string bugreport_dir;
Felipe Lemee82a27d2016-01-05 13:35:44 -080090
Felipe Leme809d74e2016-02-02 12:57:00 -080091/*
92 * List of supported zip format versions.
93 *
94 * See bugreport-format.txt for more info.
95 */
96// TODO: change to "v1" before final N build
Felipe Lemecc37b8e2016-04-11 13:45:18 -070097static std::string VERSION_DEFAULT = "v1-dev4";
Felipe Leme809d74e2016-02-02 12:57:00 -080098
Felipe Lemec4eee562016-04-21 15:42:55 -070099static bool is_user_build() {
100 return 0 == strncmp(build_type, "user", PROPERTY_VALUE_MAX - 1);
101}
102
Felipe Lemee82a27d2016-01-05 13:35:44 -0800103/* gets the tombstone data, according to the bugreport type: if zipped gets all tombstones,
104 * otherwise gets just those modified in the last half an hour. */
Christopher Ferris7dc7f322014-07-22 16:08:19 -0700105static void get_tombstone_fds(tombstone_data_t data[NUM_TOMBSTONES]) {
Felipe Lemee82a27d2016-01-05 13:35:44 -0800106 time_t thirty_minutes_ago = now - 60*30;
Christopher Ferris7dc7f322014-07-22 16:08:19 -0700107 for (size_t i = 0; i < NUM_TOMBSTONES; i++) {
108 snprintf(data[i].name, sizeof(data[i].name), "%s%02zu", TOMBSTONE_FILE_PREFIX, i);
Christopher Ferris54bcc5f2015-02-10 12:15:01 -0800109 int fd = TEMP_FAILURE_RETRY(open(data[i].name,
110 O_RDONLY | O_CLOEXEC | O_NOFOLLOW | O_NONBLOCK));
Christopher Ferris7dc7f322014-07-22 16:08:19 -0700111 struct stat st;
112 if (fstat(fd, &st) == 0 && S_ISREG(st.st_mode) &&
Felipe Lemee82a27d2016-01-05 13:35:44 -0800113 (zip_writer || (time_t) st.st_mtime >= thirty_minutes_ago)) {
114 data[i].fd = fd;
Christopher Ferris7dc7f322014-07-22 16:08:19 -0700115 } else {
Felipe Lemee82a27d2016-01-05 13:35:44 -0800116 close(fd);
Christopher Ferris7dc7f322014-07-22 16:08:19 -0700117 data[i].fd = -1;
118 }
119 }
120}
121
Felipe Leme635ca312016-01-05 14:23:02 -0800122// for_each_pid() callback to get mount info about a process.
123void do_mountinfo(int pid, const char *name) {
124 char path[PATH_MAX];
125
126 // Gets the the content of the /proc/PID/ns/mnt link, so only unique mount points
127 // are added.
Nick Kralevichf0922cc2016-05-14 16:47:44 -0700128 snprintf(path, sizeof(path), "/proc/%d/ns/mnt", pid);
Felipe Leme635ca312016-01-05 14:23:02 -0800129 char linkname[PATH_MAX];
130 ssize_t r = readlink(path, linkname, PATH_MAX);
131 if (r == -1) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800132 MYLOGE("Unable to read link for %s: %s\n", path, strerror(errno));
Felipe Leme635ca312016-01-05 14:23:02 -0800133 return;
134 }
135 linkname[r] = '\0';
136
137 if (mount_points.find(linkname) == mount_points.end()) {
138 // First time this mount point was found: add it
Nick Kralevichf0922cc2016-05-14 16:47:44 -0700139 snprintf(path, sizeof(path), "/proc/%d/mountinfo", pid);
Felipe Leme635ca312016-01-05 14:23:02 -0800140 if (add_zip_entry(ZIP_ROOT_DIR + path, path)) {
141 mount_points.insert(linkname);
142 } else {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800143 MYLOGE("Unable to add mountinfo %s to zip file\n", path);
Felipe Leme635ca312016-01-05 14:23:02 -0800144 }
145 }
146}
147
148void add_mountinfo() {
149 if (!zip_writer) return;
150 const char *title = "MOUNT INFO";
151 mount_points.clear();
Felipe Leme608385d2016-02-01 10:35:38 -0800152 DurationReporter duration_reporter(title, NULL);
Felipe Leme635ca312016-01-05 14:23:02 -0800153 for_each_pid(do_mountinfo, NULL);
Felipe Leme1b0225a2016-02-09 16:35:14 -0800154 MYLOGD("%s: %d entries added to zip file\n", title, (int) mount_points.size());
Felipe Leme635ca312016-01-05 14:23:02 -0800155}
156
Arve Hjønnevåg2db0f5f2014-10-15 18:08:37 -0700157static void dump_dev_files(const char *title, const char *driverpath, const char *filename)
158{
159 DIR *d;
160 struct dirent *de;
161 char path[PATH_MAX];
162
163 d = opendir(driverpath);
164 if (d == NULL) {
165 return;
166 }
167
168 while ((de = readdir(d))) {
169 if (de->d_type != DT_LNK) {
170 continue;
171 }
172 snprintf(path, sizeof(path), "%s/%s/%s", driverpath, de->d_name, filename);
173 dump_file(title, path);
174 }
175
176 closedir(d);
177}
178
Felipe Lemeefd7e272016-05-18 09:27:16 -0700179static void dump_systrace() {
Felipe Leme71a74ac2016-03-17 15:43:25 -0700180 if (!zip_writer) {
181 MYLOGD("Not dumping systrace because zip_writer is not set\n");
182 return;
183 }
Felipe Lemeefd7e272016-05-18 09:27:16 -0700184 std::string systrace_path = bugreport_dir + "/systrace-" + suffix + ".txt";
Felipe Leme14e034a2016-03-30 18:51:03 -0700185 if (systrace_path.empty()) {
186 MYLOGE("Not dumping systrace because path is empty\n");
187 return;
188 }
Felipe Leme71a74ac2016-03-17 15:43:25 -0700189 const char* path = "/sys/kernel/debug/tracing/tracing_on";
190 long int is_tracing;
191 if (read_file_as_long(path, &is_tracing)) {
192 return; // error already logged
193 }
194 if (is_tracing <= 0) {
195 MYLOGD("Skipping systrace because '%s' content is '%ld'\n", path, is_tracing);
196 return;
197 }
198
Felipe Leme14e034a2016-03-30 18:51:03 -0700199 MYLOGD("Running '/system/bin/atrace --async_dump -o %s', which can take several minutes",
200 systrace_path.c_str());
201 if (run_command("SYSTRACE", 120, "/system/bin/atrace", "--async_dump", "-o",
202 systrace_path.c_str(), NULL)) {
203 MYLOGE("systrace timed out, its zip entry will be incomplete\n");
204 // TODO: run_command tries to kill the process, but atrace doesn't die peacefully; ideally,
205 // we should call strace to stop itself, but there is no such option yet (just a
206 // --async_stop, which stops and dump
207 // if (run_command("SYSTRACE", 10, "/system/bin/atrace", "--kill", NULL)) {
208 // MYLOGE("could not stop systrace ");
209 // }
210 }
211 if (!add_zip_entry("systrace.txt", systrace_path)) {
212 MYLOGE("Unable to add systrace file %s to zip file\n", systrace_path.c_str());
Felipe Leme71a74ac2016-03-17 15:43:25 -0700213 } else {
Felipe Leme14e034a2016-03-30 18:51:03 -0700214 if (remove(systrace_path.c_str())) {
215 MYLOGE("Error removing systrace file %s: %s", systrace_path.c_str(), strerror(errno));
216 }
Felipe Leme71a74ac2016-03-17 15:43:25 -0700217 }
218}
219
Felipe Lemeefd7e272016-05-18 09:27:16 -0700220static void dump_raft() {
Wei Liu341938b2016-04-27 16:18:17 -0700221 if (is_user_build()) {
222 return;
223 }
224
Felipe Lemeefd7e272016-05-18 09:27:16 -0700225 std::string raft_log_path = bugreport_dir + "/raft_log.txt";
Wei Liu341938b2016-04-27 16:18:17 -0700226 if (raft_log_path.empty()) {
227 MYLOGD("raft_log_path is empty\n");
228 return;
229 }
Wei Liuf0e78d42016-05-25 14:21:02 -0700230
231 struct stat s;
232 if (stat(RAFT_DIR, &s) != 0 || !S_ISDIR(s.st_mode)) {
233 MYLOGD("%s does not exist or is not a directory\n", RAFT_DIR);
234 return;
235 }
236
Wei Liu341938b2016-04-27 16:18:17 -0700237 if (!zip_writer) {
Wei Liu310525a2016-05-25 11:28:57 -0700238 // Write compressed and encoded raft logs to stdout if not zip_writer.
239 run_command("RAFT LOGS", 600, "logcompressor", "-r", RAFT_DIR, NULL);
Wei Liu341938b2016-04-27 16:18:17 -0700240 return;
241 }
242
243 run_command("RAFT LOGS", 600, "logcompressor", "-n", "-r", RAFT_DIR,
244 "-o", raft_log_path.c_str(), NULL);
245 if (!add_zip_entry("raft_log.txt", raft_log_path)) {
246 MYLOGE("Unable to add raft log %s to zip file\n", raft_log_path.c_str());
247 } else {
248 if (remove(raft_log_path.c_str())) {
Felipe Lemeefd7e272016-05-18 09:27:16 -0700249 MYLOGE("Error removing raft file %s: %s\n", raft_log_path.c_str(), strerror(errno));
Wei Liu341938b2016-04-27 16:18:17 -0700250 }
251 }
252}
253
Mark Salyzyn326842f2015-04-30 09:49:41 -0700254static bool skip_not_stat(const char *path) {
255 static const char stat[] = "/stat";
256 size_t len = strlen(path);
257 if (path[len - 1] == '/') { /* Directory? */
258 return false;
259 }
260 return strcmp(path + len - sizeof(stat) + 1, stat); /* .../stat? */
261}
262
Felipe Lemee82a27d2016-01-05 13:35:44 -0800263static bool skip_none(const char *path) {
264 return false;
265}
266
Mark Salyzyn326842f2015-04-30 09:49:41 -0700267static const char mmcblk0[] = "/sys/block/mmcblk0/";
Mark Salyzyn8f37aa52015-06-12 12:28:24 -0700268unsigned long worst_write_perf = 20000; /* in KB/s */
Mark Salyzyn326842f2015-04-30 09:49:41 -0700269
Mark Salyzyn01d6c392016-02-04 09:20:44 -0800270//
271// stat offsets
272// Name units description
273// ---- ----- -----------
274// read I/Os requests number of read I/Os processed
275#define __STAT_READ_IOS 0
276// read merges requests number of read I/Os merged with in-queue I/O
277#define __STAT_READ_MERGES 1
278// read sectors sectors number of sectors read
279#define __STAT_READ_SECTORS 2
280// read ticks milliseconds total wait time for read requests
281#define __STAT_READ_TICKS 3
282// write I/Os requests number of write I/Os processed
283#define __STAT_WRITE_IOS 4
284// write merges requests number of write I/Os merged with in-queue I/O
285#define __STAT_WRITE_MERGES 5
286// write sectors sectors number of sectors written
287#define __STAT_WRITE_SECTORS 6
288// write ticks milliseconds total wait time for write requests
289#define __STAT_WRITE_TICKS 7
290// in_flight requests number of I/Os currently in flight
291#define __STAT_IN_FLIGHT 8
292// io_ticks milliseconds total time this block device has been active
293#define __STAT_IO_TICKS 9
294// time_in_queue milliseconds total wait time for all requests
295#define __STAT_IN_QUEUE 10
296#define __STAT_NUMBER_FIELD 11
297//
298// read I/Os, write I/Os
299// =====================
300//
301// These values increment when an I/O request completes.
302//
303// read merges, write merges
304// =========================
305//
306// These values increment when an I/O request is merged with an
307// already-queued I/O request.
308//
309// read sectors, write sectors
310// ===========================
311//
312// These values count the number of sectors read from or written to this
313// block device. The "sectors" in question are the standard UNIX 512-byte
314// sectors, not any device- or filesystem-specific block size. The
315// counters are incremented when the I/O completes.
316#define SECTOR_SIZE 512
317//
318// read ticks, write ticks
319// =======================
320//
321// These values count the number of milliseconds that I/O requests have
322// waited on this block device. If there are multiple I/O requests waiting,
323// these values will increase at a rate greater than 1000/second; for
324// example, if 60 read requests wait for an average of 30 ms, the read_ticks
325// field will increase by 60*30 = 1800.
326//
327// in_flight
328// =========
329//
330// This value counts the number of I/O requests that have been issued to
331// the device driver but have not yet completed. It does not include I/O
332// requests that are in the queue but not yet issued to the device driver.
333//
334// io_ticks
335// ========
336//
337// This value counts the number of milliseconds during which the device has
338// had I/O requests queued.
339//
340// time_in_queue
341// =============
342//
343// This value counts the number of milliseconds that I/O requests have waited
344// on this block device. If there are multiple I/O requests waiting, this
345// value will increase as the product of the number of milliseconds times the
346// number of requests waiting (see "read ticks" above for an example).
347#define S_TO_MS 1000
348//
349
Mark Salyzyn326842f2015-04-30 09:49:41 -0700350static int dump_stat_from_fd(const char *title __unused, const char *path, int fd) {
Mark Salyzyn01d6c392016-02-04 09:20:44 -0800351 unsigned long long fields[__STAT_NUMBER_FIELD];
Mark Salyzyn326842f2015-04-30 09:49:41 -0700352 bool z;
353 char *cp, *buffer = NULL;
354 size_t i = 0;
355 FILE *fp = fdopen(fd, "rb");
356 getline(&buffer, &i, fp);
357 fclose(fp);
358 if (!buffer) {
359 return -errno;
360 }
361 i = strlen(buffer);
362 while ((i > 0) && (buffer[i - 1] == '\n')) {
363 buffer[--i] = '\0';
364 }
365 if (!*buffer) {
366 free(buffer);
367 return 0;
368 }
369 z = true;
370 for (cp = buffer, i = 0; i < (sizeof(fields) / sizeof(fields[0])); ++i) {
Mark Salyzyn01d6c392016-02-04 09:20:44 -0800371 fields[i] = strtoull(cp, &cp, 10);
Mark Salyzyn326842f2015-04-30 09:49:41 -0700372 if (fields[i] != 0) {
373 z = false;
374 }
375 }
376 if (z) { /* never accessed */
377 free(buffer);
378 return 0;
379 }
380
381 if (!strncmp(path, mmcblk0, sizeof(mmcblk0) - 1)) {
382 path += sizeof(mmcblk0) - 1;
383 }
384
385 printf("%s: %s\n", path, buffer);
386 free(buffer);
387
Mark Salyzyn01d6c392016-02-04 09:20:44 -0800388 if (fields[__STAT_IO_TICKS]) {
389 unsigned long read_perf = 0;
390 unsigned long read_ios = 0;
391 if (fields[__STAT_READ_TICKS]) {
392 unsigned long long divisor = fields[__STAT_READ_TICKS]
393 * fields[__STAT_IO_TICKS];
394 read_perf = ((unsigned long long)SECTOR_SIZE
395 * fields[__STAT_READ_SECTORS]
396 * fields[__STAT_IN_QUEUE] + (divisor >> 1))
397 / divisor;
398 read_ios = ((unsigned long long)S_TO_MS * fields[__STAT_READ_IOS]
399 * fields[__STAT_IN_QUEUE] + (divisor >> 1))
400 / divisor;
401 }
402
403 unsigned long write_perf = 0;
404 unsigned long write_ios = 0;
405 if (fields[__STAT_WRITE_TICKS]) {
406 unsigned long long divisor = fields[__STAT_WRITE_TICKS]
407 * fields[__STAT_IO_TICKS];
408 write_perf = ((unsigned long long)SECTOR_SIZE
409 * fields[__STAT_WRITE_SECTORS]
410 * fields[__STAT_IN_QUEUE] + (divisor >> 1))
411 / divisor;
412 write_ios = ((unsigned long long)S_TO_MS * fields[__STAT_WRITE_IOS]
413 * fields[__STAT_IN_QUEUE] + (divisor >> 1))
414 / divisor;
415 }
416
417 unsigned queue = (fields[__STAT_IN_QUEUE]
418 + (fields[__STAT_IO_TICKS] >> 1))
419 / fields[__STAT_IO_TICKS];
420
421 if (!write_perf && !write_ios) {
422 printf("%s: perf(ios) rd: %luKB/s(%lu/s) q: %u\n",
423 path, read_perf, read_ios, queue);
424 } else {
425 printf("%s: perf(ios) rd: %luKB/s(%lu/s) wr: %luKB/s(%lu/s) q: %u\n",
426 path, read_perf, read_ios, write_perf, write_ios, queue);
427 }
428
429 /* bugreport timeout factor adjustment */
430 if ((write_perf > 1) && (write_perf < worst_write_perf)) {
431 worst_write_perf = write_perf;
432 }
Mark Salyzyn8f37aa52015-06-12 12:28:24 -0700433 }
Mark Salyzyn326842f2015-04-30 09:49:41 -0700434 return 0;
435}
436
Mark Salyzyn8f37aa52015-06-12 12:28:24 -0700437/* Copied policy from system/core/logd/LogBuffer.cpp */
438
439#define LOG_BUFFER_SIZE (256 * 1024)
440#define LOG_BUFFER_MIN_SIZE (64 * 1024UL)
441#define LOG_BUFFER_MAX_SIZE (256 * 1024 * 1024UL)
442
443static bool valid_size(unsigned long value) {
444 if ((value < LOG_BUFFER_MIN_SIZE) || (LOG_BUFFER_MAX_SIZE < value)) {
445 return false;
446 }
447
448 long pages = sysconf(_SC_PHYS_PAGES);
449 if (pages < 1) {
450 return true;
451 }
452
453 long pagesize = sysconf(_SC_PAGESIZE);
454 if (pagesize <= 1) {
455 pagesize = PAGE_SIZE;
456 }
457
458 // maximum memory impact a somewhat arbitrary ~3%
459 pages = (pages + 31) / 32;
460 unsigned long maximum = pages * pagesize;
461
462 if ((maximum < LOG_BUFFER_MIN_SIZE) || (LOG_BUFFER_MAX_SIZE < maximum)) {
463 return true;
464 }
465
466 return value <= maximum;
467}
468
469static unsigned long property_get_size(const char *key) {
470 unsigned long value;
471 char *cp, property[PROPERTY_VALUE_MAX];
472
473 property_get(key, property, "");
474 value = strtoul(property, &cp, 10);
475
476 switch(*cp) {
477 case 'm':
478 case 'M':
479 value *= 1024;
480 /* FALLTHRU */
481 case 'k':
482 case 'K':
483 value *= 1024;
484 /* FALLTHRU */
485 case '\0':
486 break;
487
488 default:
489 value = 0;
490 }
491
492 if (!valid_size(value)) {
493 value = 0;
494 }
495
496 return value;
497}
498
499/* timeout in ms */
Felipe Leme8620bb42015-11-10 11:04:45 -0800500static unsigned long logcat_timeout(const char *name) {
Mark Salyzyn8f37aa52015-06-12 12:28:24 -0700501 static const char global_tuneable[] = "persist.logd.size"; // Settings App
502 static const char global_default[] = "ro.logd.size"; // BoardConfig.mk
503 char key[PROP_NAME_MAX];
504 unsigned long property_size, default_size;
505
506 default_size = property_get_size(global_tuneable);
507 if (!default_size) {
508 default_size = property_get_size(global_default);
509 }
510
511 snprintf(key, sizeof(key), "%s.%s", global_tuneable, name);
512 property_size = property_get_size(key);
513
514 if (!property_size) {
515 snprintf(key, sizeof(key), "%s.%s", global_default, name);
516 property_size = property_get_size(key);
517 }
518
519 if (!property_size) {
520 property_size = default_size;
521 }
522
523 if (!property_size) {
524 property_size = LOG_BUFFER_SIZE;
525 }
526
527 /* Engineering margin is ten-fold our guess */
528 return 10 * (property_size + worst_write_perf) / worst_write_perf;
529}
530
531/* End copy from system/core/logd/LogBuffer.cpp */
532
Colin Crossf45fa6b2012-03-26 12:38:26 -0700533/* dumps the current system state to stdout */
Felipe Leme809d74e2016-02-02 12:57:00 -0800534static void print_header(std::string version) {
Colin Crossf45fa6b2012-03-26 12:38:26 -0700535 char build[PROPERTY_VALUE_MAX], fingerprint[PROPERTY_VALUE_MAX];
536 char radio[PROPERTY_VALUE_MAX], bootloader[PROPERTY_VALUE_MAX];
537 char network[PROPERTY_VALUE_MAX], date[80];
Colin Crossf45fa6b2012-03-26 12:38:26 -0700538
539 property_get("ro.build.display.id", build, "(unknown)");
540 property_get("ro.build.fingerprint", fingerprint, "(unknown)");
541 property_get("ro.build.type", build_type, "(unknown)");
542 property_get("ro.baseband", radio, "(unknown)");
543 property_get("ro.bootloader", bootloader, "(unknown)");
544 property_get("gsm.operator.alpha", network, "(unknown)");
545 strftime(date, sizeof(date), "%Y-%m-%d %H:%M:%S", localtime(&now));
546
547 printf("========================================================\n");
548 printf("== dumpstate: %s\n", date);
549 printf("========================================================\n");
550
551 printf("\n");
552 printf("Build: %s\n", build);
553 printf("Build fingerprint: '%s'\n", fingerprint); /* format is important for other tools */
554 printf("Bootloader: %s\n", bootloader);
555 printf("Radio: %s\n", radio);
556 printf("Network: %s\n", network);
557
558 printf("Kernel: ");
559 dump_file(NULL, "/proc/version");
560 printf("Command line: %s\n", strtok(cmdline_buf, "\n"));
Felipe Leme809d74e2016-02-02 12:57:00 -0800561 printf("Bugreport format version: %s\n", version.c_str());
Felipe Leme8fecfdd2016-02-09 10:40:07 -0800562 printf("Dumpstate info: id=%lu pid=%d\n", id, getpid());
Colin Crossf45fa6b2012-03-26 12:38:26 -0700563 printf("\n");
Felipe Leme78f2c862015-12-21 09:55:22 -0800564}
565
Felipe Leme71ca15e2016-05-19 16:18:17 -0700566bool add_zip_entry_from_fd(const std::string& entry_name, int fd) {
Felipe Leme111b9d02016-02-03 09:28:24 -0800567 if (!zip_writer) {
Felipe Leme88c79332016-02-22 11:06:49 -0800568 MYLOGD("Not adding zip entry %s from fd because zip_writer is not set\n",
569 entry_name.c_str());
Felipe Leme111b9d02016-02-03 09:28:24 -0800570 return false;
571 }
Felipe Leme6fe9db62016-02-12 09:04:16 -0800572 // Logging statement below is useful to time how long each entry takes, but it's too verbose.
573 // MYLOGD("Adding zip entry %s\n", entry_name.c_str());
Felipe Lemee82a27d2016-01-05 13:35:44 -0800574 int32_t err = zip_writer->StartEntryWithTime(entry_name.c_str(),
575 ZipWriter::kCompress, get_mtime(fd, now));
576 if (err) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800577 MYLOGE("zip_writer->StartEntryWithTime(%s): %s\n", entry_name.c_str(),
Felipe Leme809d74e2016-02-02 12:57:00 -0800578 ZipWriter::ErrorCodeString(err));
Felipe Lemee82a27d2016-01-05 13:35:44 -0800579 return false;
580 }
581
Felipe Leme770410d2016-01-26 17:07:14 -0800582 std::vector<uint8_t> buffer(65536);
Felipe Lemee82a27d2016-01-05 13:35:44 -0800583 while (1) {
Felipe Lemee82a27d2016-01-05 13:35:44 -0800584 ssize_t bytes_read = TEMP_FAILURE_RETRY(read(fd, buffer.data(), sizeof(buffer)));
585 if (bytes_read == 0) {
586 break;
587 } else if (bytes_read == -1) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800588 MYLOGE("read(%s): %s\n", entry_name.c_str(), strerror(errno));
Felipe Lemee82a27d2016-01-05 13:35:44 -0800589 return false;
590 }
591 err = zip_writer->WriteBytes(buffer.data(), bytes_read);
592 if (err) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800593 MYLOGE("zip_writer->WriteBytes(): %s\n", ZipWriter::ErrorCodeString(err));
Felipe Lemee82a27d2016-01-05 13:35:44 -0800594 return false;
595 }
596 }
597
598 err = zip_writer->FinishEntry();
599 if (err) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800600 MYLOGE("zip_writer->FinishEntry(): %s\n", ZipWriter::ErrorCodeString(err));
Felipe Lemee82a27d2016-01-05 13:35:44 -0800601 return false;
602 }
603
604 return true;
605}
606
Felipe Leme71ca15e2016-05-19 16:18:17 -0700607bool add_zip_entry(const std::string& entry_name, const std::string& entry_path) {
Felipe Lemee82a27d2016-01-05 13:35:44 -0800608 ScopedFd fd(TEMP_FAILURE_RETRY(open(entry_path.c_str(), O_RDONLY | O_NONBLOCK | O_CLOEXEC)));
609 if (fd.get() == -1) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800610 MYLOGE("open(%s): %s\n", entry_path.c_str(), strerror(errno));
Felipe Lemee82a27d2016-01-05 13:35:44 -0800611 return false;
612 }
613
614 return add_zip_entry_from_fd(entry_name, fd.get());
615}
616
617/* adds a file to the existing zipped bugreport */
618static int _add_file_from_fd(const char *title, const char *path, int fd) {
619 return add_zip_entry_from_fd(ZIP_ROOT_DIR + path, fd) ? 0 : 1;
620}
621
622/* adds all files from a directory to the zipped bugreport file */
623void add_dir(const char *dir, bool recursive) {
Felipe Leme111b9d02016-02-03 09:28:24 -0800624 if (!zip_writer) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800625 MYLOGD("Not adding dir %s because zip_writer is not set\n", dir);
Felipe Leme111b9d02016-02-03 09:28:24 -0800626 return;
627 }
Felipe Leme88c79332016-02-22 11:06:49 -0800628 MYLOGD("Adding dir %s (recursive: %d)\n", dir, recursive);
Felipe Leme608385d2016-02-01 10:35:38 -0800629 DurationReporter duration_reporter(dir, NULL);
Felipe Lemee82a27d2016-01-05 13:35:44 -0800630 dump_files(NULL, dir, recursive ? skip_none : is_dir, _add_file_from_fd);
631}
632
Felipe Leme809d74e2016-02-02 12:57:00 -0800633/* adds a text entry entry to the existing zip file. */
634static bool add_text_zip_entry(const std::string& entry_name, const std::string& content) {
Felipe Leme111b9d02016-02-03 09:28:24 -0800635 if (!zip_writer) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800636 MYLOGD("Not adding text zip entry %s because zip_writer is not set\n", entry_name.c_str());
Felipe Leme111b9d02016-02-03 09:28:24 -0800637 return false;
638 }
Felipe Lemecbce55d2016-02-08 09:53:18 -0800639 MYLOGD("Adding zip text entry %s\n", entry_name.c_str());
Felipe Leme809d74e2016-02-02 12:57:00 -0800640 int32_t err = zip_writer->StartEntryWithTime(entry_name.c_str(), ZipWriter::kCompress, now);
641 if (err) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800642 MYLOGE("zip_writer->StartEntryWithTime(%s): %s\n", entry_name.c_str(),
Felipe Leme809d74e2016-02-02 12:57:00 -0800643 ZipWriter::ErrorCodeString(err));
644 return false;
645 }
646
647 err = zip_writer->WriteBytes(content.c_str(), content.length());
648 if (err) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800649 MYLOGE("zip_writer->WriteBytes(%s): %s\n", entry_name.c_str(),
Felipe Leme809d74e2016-02-02 12:57:00 -0800650 ZipWriter::ErrorCodeString(err));
651 return false;
652 }
653
654 err = zip_writer->FinishEntry();
655 if (err) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800656 MYLOGE("zip_writer->FinishEntry(): %s\n", ZipWriter::ErrorCodeString(err));
Felipe Leme809d74e2016-02-02 12:57:00 -0800657 return false;
658 }
659
660 return true;
661}
662
Srinath Sridharanfdf52d32016-02-01 15:50:22 -0800663static void dumpstate(const std::string& screenshot_path, const std::string& version) {
Felipe Leme770410d2016-01-26 17:07:14 -0800664 DurationReporter duration_reporter("DUMPSTATE");
Felipe Leme78f2c862015-12-21 09:55:22 -0800665 unsigned long timeout;
Colin Crossf45fa6b2012-03-26 12:38:26 -0700666
Arve Hjønnevåg2db0f5f2014-10-15 18:08:37 -0700667 dump_dev_files("TRUSTY VERSION", "/sys/bus/platform/drivers/trusty", "trusty_version");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700668 run_command("UPTIME", 10, "uptime", NULL);
Mark Salyzyn326842f2015-04-30 09:49:41 -0700669 dump_files("UPTIME MMC PERF", mmcblk0, skip_not_stat, dump_stat_from_fd);
Mark Salyzyn8c8130e2015-12-09 11:21:28 -0800670 dump_emmc_ecsd("/d/mmc0/mmc0:0001/ext_csd");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700671 dump_file("MEMORY INFO", "/proc/meminfo");
Elliott Hughesb32c7e12015-11-13 11:32:48 -0800672 run_command("CPU INFO", 10, "top", "-n", "1", "-d", "1", "-m", "30", "-H", NULL);
Nick Kralevich2b1f88b2015-10-07 16:38:42 -0700673 run_command("PROCRANK", 20, SU_PATH, "root", "procrank", NULL);
Colin Crossf45fa6b2012-03-26 12:38:26 -0700674 dump_file("VIRTUAL MEMORY STATS", "/proc/vmstat");
675 dump_file("VMALLOC INFO", "/proc/vmallocinfo");
676 dump_file("SLAB INFO", "/proc/slabinfo");
677 dump_file("ZONEINFO", "/proc/zoneinfo");
678 dump_file("PAGETYPEINFO", "/proc/pagetypeinfo");
679 dump_file("BUDDYINFO", "/proc/buddyinfo");
Colin Cross2281af92012-10-28 22:41:06 -0700680 dump_file("FRAGMENTATION INFO", "/d/extfrag/unusable_index");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700681
Todd Poynor29e27a82012-05-22 17:54:59 -0700682 dump_file("KERNEL WAKE SOURCES", "/d/wakeup_sources");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700683 dump_file("KERNEL CPUFREQ", "/sys/devices/system/cpu/cpu0/cpufreq/stats/time_in_state");
Mathias Agopian85aea742012-08-08 15:32:02 -0700684 dump_file("KERNEL SYNC", "/d/sync");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700685
Elliott Hughesa3533a32015-10-30 16:17:49 -0700686 run_command("PROCESSES AND THREADS", 10, "ps", "-Z", "-t", "-p", "-P", NULL);
Nick Kralevichb82c9252015-11-27 17:56:13 -0800687 run_command("LIBRANK", 10, SU_PATH, "root", "librank", NULL);
Colin Crossf45fa6b2012-03-26 12:38:26 -0700688
Michal Karpinski4db754f2015-12-11 18:04:32 +0000689 run_command("PRINTENV", 10, "printenv", NULL);
Lorenzo Colittif7f26512016-03-11 10:58:55 +0900690 run_command("NETSTAT", 10, "netstat", "-n", NULL);
Michal Karpinski4db754f2015-12-11 18:04:32 +0000691 run_command("LSMOD", 10, "lsmod", NULL);
692
Colin Crossf45fa6b2012-03-26 12:38:26 -0700693 do_dmesg();
694
695 run_command("LIST OF OPEN FILES", 10, SU_PATH, "root", "lsof", NULL);
Jeff Brown1dc94e32014-09-11 14:15:27 -0700696 for_each_pid(do_showmap, "SMAPS OF ALL PROCESSES");
697 for_each_tid(show_wchan, "BLOCKED PROCESS WAIT-CHANNELS");
Mark Salyzyna297c322016-02-05 15:33:17 -0800698 for_each_pid(show_showtime, "PROCESS TIMES (pid cmd user system iowait+percentage)");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700699
Felipe Leme6e01fa62015-11-11 19:35:14 -0800700 if (!screenshot_path.empty()) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800701 MYLOGI("taking late screenshot\n");
Felipe Lemee338bf62015-12-07 14:03:50 -0800702 take_screenshot(screenshot_path);
Felipe Lemecbce55d2016-02-08 09:53:18 -0800703 MYLOGI("wrote screenshot: %s\n", screenshot_path.c_str());
Jeff Sharkey5a930032013-03-19 15:05:19 -0700704 }
705
Colin Crossf45fa6b2012-03-26 12:38:26 -0700706 // dump_file("EVENT LOG TAGS", "/etc/event-log-tags");
Mark Salyzyn8f37aa52015-06-12 12:28:24 -0700707 // calculate timeout
708 timeout = logcat_timeout("main") + logcat_timeout("system") + logcat_timeout("crash");
709 if (timeout < 20000) {
710 timeout = 20000;
711 }
Mark Salyzyn78316382015-10-09 14:02:07 -0700712 run_command("SYSTEM LOG", timeout / 1000, "logcat", "-v", "threadtime",
713 "-v", "printable",
714 "-d",
715 "*:v", NULL);
Mark Salyzyn43afe5d2016-01-26 07:24:08 -0800716 timeout = logcat_timeout("events");
Mark Salyzyn8f37aa52015-06-12 12:28:24 -0700717 if (timeout < 20000) {
718 timeout = 20000;
719 }
Mark Salyzyn78316382015-10-09 14:02:07 -0700720 run_command("EVENT LOG", timeout / 1000, "logcat", "-b", "events",
721 "-v", "threadtime",
722 "-v", "printable",
723 "-d",
724 "*:v", NULL);
Mark Salyzyn8f37aa52015-06-12 12:28:24 -0700725 timeout = logcat_timeout("radio");
726 if (timeout < 20000) {
727 timeout = 20000;
728 }
Mark Salyzyn78316382015-10-09 14:02:07 -0700729 run_command("RADIO LOG", timeout / 1000, "logcat", "-b", "radio",
730 "-v", "threadtime",
731 "-v", "printable",
732 "-d",
733 "*:v", NULL);
Colin Crossf45fa6b2012-03-26 12:38:26 -0700734
Mark Salyzynecc07632015-07-30 14:57:09 -0700735 run_command("LOG STATISTICS", 10, "logcat", "-b", "all", "-S", NULL);
736
Colin Crossf45fa6b2012-03-26 12:38:26 -0700737 /* show the traces we collected in main(), if that was done */
738 if (dump_traces_path != NULL) {
739 dump_file("VM TRACES JUST NOW", dump_traces_path);
740 }
741
742 /* only show ANR traces if they're less than 15 minutes old */
743 struct stat st;
744 char anr_traces_path[PATH_MAX];
745 property_get("dalvik.vm.stack-trace-file", anr_traces_path, "");
746 if (!anr_traces_path[0]) {
747 printf("*** NO VM TRACES FILE DEFINED (dalvik.vm.stack-trace-file)\n\n");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700748 } else {
Christopher Ferris54bcc5f2015-02-10 12:15:01 -0800749 int fd = TEMP_FAILURE_RETRY(open(anr_traces_path,
750 O_RDONLY | O_CLOEXEC | O_NOFOLLOW | O_NONBLOCK));
Christopher Ferris7dc7f322014-07-22 16:08:19 -0700751 if (fd < 0) {
752 printf("*** NO ANR VM TRACES FILE (%s): %s\n\n", anr_traces_path, strerror(errno));
753 } else {
754 dump_file_from_fd("VM TRACES AT LAST ANR", anr_traces_path, fd);
755 }
Colin Crossf45fa6b2012-03-26 12:38:26 -0700756 }
757
758 /* slow traces for slow operations */
759 if (anr_traces_path[0] != 0) {
760 int tail = strlen(anr_traces_path)-1;
761 while (tail > 0 && anr_traces_path[tail] != '/') {
762 tail--;
763 }
764 int i = 0;
765 while (1) {
766 sprintf(anr_traces_path+tail+1, "slow%02d.txt", i);
767 if (stat(anr_traces_path, &st)) {
768 // No traces file at this index, done with the files.
769 break;
770 }
771 dump_file("VM TRACES WHEN SLOW", anr_traces_path);
772 i++;
773 }
774 }
775
Christopher Ferris7dc7f322014-07-22 16:08:19 -0700776 int dumped = 0;
777 for (size_t i = 0; i < NUM_TOMBSTONES; i++) {
778 if (tombstone_data[i].fd != -1) {
Felipe Lemee82a27d2016-01-05 13:35:44 -0800779 const char *name = tombstone_data[i].name;
780 int fd = tombstone_data[i].fd;
Christopher Ferris7dc7f322014-07-22 16:08:19 -0700781 dumped = 1;
Felipe Lemee82a27d2016-01-05 13:35:44 -0800782 if (zip_writer) {
783 if (!add_zip_entry_from_fd(ZIP_ROOT_DIR + name, fd)) {
Felipe Lemecbce55d2016-02-08 09:53:18 -0800784 MYLOGE("Unable to add tombstone %s to zip file\n", name);
Felipe Lemee82a27d2016-01-05 13:35:44 -0800785 }
786 } else {
787 dump_file_from_fd("TOMBSTONE", name, fd);
788 }
789 close(fd);
Christopher Ferris7dc7f322014-07-22 16:08:19 -0700790 tombstone_data[i].fd = -1;
791 }
792 }
793 if (!dumped) {
794 printf("*** NO TOMBSTONES to dump in %s\n\n", TOMBSTONE_DIR);
795 }
796
Colin Crossf45fa6b2012-03-26 12:38:26 -0700797 dump_file("NETWORK DEV INFO", "/proc/net/dev");
798 dump_file("QTAGUID NETWORK INTERFACES INFO", "/proc/net/xt_qtaguid/iface_stat_all");
JP Abgrall012c2ea2012-05-16 20:49:29 -0700799 dump_file("QTAGUID NETWORK INTERFACES INFO (xt)", "/proc/net/xt_qtaguid/iface_stat_fmt");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700800 dump_file("QTAGUID CTRL INFO", "/proc/net/xt_qtaguid/ctrl");
801 dump_file("QTAGUID STATS INFO", "/proc/net/xt_qtaguid/stats");
802
Todd Poynor2a83daa2013-11-22 15:44:22 -0800803 if (!stat(PSTORE_LAST_KMSG, &st)) {
804 /* Also TODO: Make console-ramoops CAP_SYSLOG protected. */
805 dump_file("LAST KMSG", PSTORE_LAST_KMSG);
806 } else {
807 /* TODO: Make last_kmsg CAP_SYSLOG protected. b/5555691 */
808 dump_file("LAST KMSG", "/proc/last_kmsg");
809 }
810
Mark Salyzyn2262c162014-12-16 09:09:26 -0800811 /* kernels must set CONFIG_PSTORE_PMSG, slice up pstore with device tree */
Mark Salyzyn78316382015-10-09 14:02:07 -0700812 run_command("LAST LOGCAT", 10, "logcat", "-L",
813 "-b", "all",
814 "-v", "threadtime",
815 "-v", "printable",
816 "-d",
817 "*:v", NULL);
Mark Salyzyn2262c162014-12-16 09:09:26 -0800818
Colin Crossf45fa6b2012-03-26 12:38:26 -0700819 /* The following have a tendency to get wedged when wifi drivers/fw goes belly-up. */
Elliott Hughesa59828a2015-01-27 20:48:52 -0800820
821 run_command("NETWORK INTERFACES", 10, "ip", "link", NULL);
Lorenzo Colittid4c3d382014-07-30 14:38:20 +0900822
823 run_command("IPv4 ADDRESSES", 10, "ip", "-4", "addr", "show", NULL);
824 run_command("IPv6 ADDRESSES", 10, "ip", "-6", "addr", "show", NULL);
825
Colin Crossf45fa6b2012-03-26 12:38:26 -0700826 run_command("IP RULES", 10, "ip", "rule", "show", NULL);
827 run_command("IP RULES v6", 10, "ip", "-6", "rule", "show", NULL);
Sreeram Ramachandran2b3bba32014-07-08 15:40:55 -0700828
829 dump_route_tables();
830
Lorenzo Colittid4c3d382014-07-30 14:38:20 +0900831 run_command("ARP CACHE", 10, "ip", "-4", "neigh", "show", NULL);
832 run_command("IPv6 ND CACHE", 10, "ip", "-6", "neigh", "show", NULL);
833
Colin Crossf45fa6b2012-03-26 12:38:26 -0700834 run_command("IPTABLES", 10, SU_PATH, "root", "iptables", "-L", "-nvx", NULL);
835 run_command("IP6TABLES", 10, SU_PATH, "root", "ip6tables", "-L", "-nvx", NULL);
JP Abgrall012c2ea2012-05-16 20:49:29 -0700836 run_command("IPTABLE NAT", 10, SU_PATH, "root", "iptables", "-t", "nat", "-L", "-nvx", NULL);
837 /* no ip6 nat */
838 run_command("IPTABLE RAW", 10, SU_PATH, "root", "iptables", "-t", "raw", "-L", "-nvx", NULL);
839 run_command("IP6TABLE RAW", 10, SU_PATH, "root", "ip6tables", "-t", "raw", "-L", "-nvx", NULL);
Colin Crossf45fa6b2012-03-26 12:38:26 -0700840
841 run_command("WIFI NETWORKS", 20,
Dmitry Shmidt1d6b97c2013-08-21 10:58:29 -0700842 SU_PATH, "root", "wpa_cli", "IFNAME=wlan0", "list_networks", NULL);
Colin Crossf45fa6b2012-03-26 12:38:26 -0700843
Dmitry Shmidtc11f56e2012-11-07 10:42:05 -0800844#ifdef FWDUMP_bcmdhd
Lorenzo Colitti6afc38c2015-09-09 22:59:25 +0900845 run_command("ND OFFLOAD TABLE", 5,
846 SU_PATH, "root", "wlutil", "nd_hostip", NULL);
847
848 run_command("DUMP WIFI INTERNAL COUNTERS (1)", 20,
Dmitry Shmidtc11f56e2012-11-07 10:42:05 -0800849 SU_PATH, "root", "wlutil", "counters", NULL);
Lorenzo Colitti6afc38c2015-09-09 22:59:25 +0900850
851 run_command("ND OFFLOAD STATUS (1)", 5,
852 SU_PATH, "root", "wlutil", "nd_status", NULL);
853
Dmitry Shmidtc11f56e2012-11-07 10:42:05 -0800854#endif
Dmitry Shmidt0b2c9262012-11-07 11:09:46 -0800855 dump_file("INTERRUPTS (1)", "/proc/interrupts");
856
Lorenzo Colitti6afc38c2015-09-09 22:59:25 +0900857 run_command("NETWORK DIAGNOSTICS", 10, "dumpsys", "connectivity", "--diag", NULL);
858
Dmitry Shmidtc11f56e2012-11-07 10:42:05 -0800859#ifdef FWDUMP_bcmdhd
Colin Crossf45fa6b2012-03-26 12:38:26 -0700860 run_command("DUMP WIFI STATUS", 20,
861 SU_PATH, "root", "dhdutil", "-i", "wlan0", "dump", NULL);
Lorenzo Colitti6afc38c2015-09-09 22:59:25 +0900862
863 run_command("DUMP WIFI INTERNAL COUNTERS (2)", 20,
Colin Crossf45fa6b2012-03-26 12:38:26 -0700864 SU_PATH, "root", "wlutil", "counters", NULL);
Lorenzo Colitti6afc38c2015-09-09 22:59:25 +0900865
866 run_command("ND OFFLOAD STATUS (2)", 5,
867 SU_PATH, "root", "wlutil", "nd_status", NULL);
Colin Crossf45fa6b2012-03-26 12:38:26 -0700868#endif
Dmitry Shmidt0b2c9262012-11-07 11:09:46 -0800869 dump_file("INTERRUPTS (2)", "/proc/interrupts");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700870
871 print_properties();
872
873 run_command("VOLD DUMP", 10, "vdc", "dump", NULL);
874 run_command("SECURE CONTAINERS", 10, "vdc", "asec", "list", NULL);
875
Ken Sumrall8f75fa72013-02-08 17:35:58 -0800876 run_command("FILESYSTEMS & FREE SPACE", 10, "df", NULL);
Colin Crossf45fa6b2012-03-26 12:38:26 -0700877
Colin Crossf45fa6b2012-03-26 12:38:26 -0700878 run_command("LAST RADIO LOG", 10, "parse_radio_log", "/proc/last_radio_log", NULL);
879
880 printf("------ BACKLIGHTS ------\n");
881 printf("LCD brightness=");
882 dump_file(NULL, "/sys/class/leds/lcd-backlight/brightness");
883 printf("Button brightness=");
884 dump_file(NULL, "/sys/class/leds/button-backlight/brightness");
885 printf("Keyboard brightness=");
886 dump_file(NULL, "/sys/class/leds/keyboard-backlight/brightness");
887 printf("ALS mode=");
888 dump_file(NULL, "/sys/class/leds/lcd-backlight/als");
889 printf("LCD driver registers:\n");
890 dump_file(NULL, "/sys/class/leds/lcd-backlight/registers");
891 printf("\n");
892
893 /* Binder state is expensive to look at as it uses a lot of memory. */
894 dump_file("BINDER FAILED TRANSACTION LOG", "/sys/kernel/debug/binder/failed_transaction_log");
895 dump_file("BINDER TRANSACTION LOG", "/sys/kernel/debug/binder/transaction_log");
896 dump_file("BINDER TRANSACTIONS", "/sys/kernel/debug/binder/transactions");
897 dump_file("BINDER STATS", "/sys/kernel/debug/binder/stats");
898 dump_file("BINDER STATE", "/sys/kernel/debug/binder/state");
899
Colin Crossf45fa6b2012-03-26 12:38:26 -0700900 printf("========================================================\n");
901 printf("== Board\n");
902 printf("========================================================\n");
903
904 dumpstate_board();
905 printf("\n");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700906
907 /* Migrate the ril_dumpstate to a dumpstate_board()? */
908 char ril_dumpstate_timeout[PROPERTY_VALUE_MAX] = {0};
909 property_get("ril.dumpstate.timeout", ril_dumpstate_timeout, "30");
910 if (strnlen(ril_dumpstate_timeout, PROPERTY_VALUE_MAX - 1) > 0) {
Felipe Lemec4eee562016-04-21 15:42:55 -0700911 if (is_user_build()) {
Colin Crossf45fa6b2012-03-26 12:38:26 -0700912 // su does not exist on user builds, so try running without it.
913 // This way any implementations of vril-dump that do not require
914 // root can run on user builds.
915 run_command("DUMP VENDOR RIL LOGS", atoi(ril_dumpstate_timeout),
916 "vril-dump", NULL);
917 } else {
918 run_command("DUMP VENDOR RIL LOGS", atoi(ril_dumpstate_timeout),
919 SU_PATH, "root", "vril-dump", NULL);
920 }
921 }
922
923 printf("========================================================\n");
924 printf("== Android Framework Services\n");
925 printf("========================================================\n");
926
Wei Liu34222562016-05-19 13:59:01 -0700927 run_command("DUMPSYS", 60, "dumpsys", "-t", "60", "--skip", "meminfo", "cpuinfo", NULL);
Colin Crossf45fa6b2012-03-26 12:38:26 -0700928
929 printf("========================================================\n");
Dianne Hackborn02bea972013-06-26 18:59:09 -0700930 printf("== Checkins\n");
931 printf("========================================================\n");
932
Dianne Hackborn59b15162013-09-04 18:04:14 -0700933 run_command("CHECKIN BATTERYSTATS", 30, "dumpsys", "batterystats", "-c", NULL);
Dianne Hackborn3e5fa732013-07-03 16:51:15 -0700934 run_command("CHECKIN MEMINFO", 30, "dumpsys", "meminfo", "--checkin", NULL);
Dianne Hackborn02bea972013-06-26 18:59:09 -0700935 run_command("CHECKIN NETSTATS", 30, "dumpsys", "netstats", "--checkin", NULL);
Dianne Hackborn5cd46aa2013-07-09 15:01:40 -0700936 run_command("CHECKIN PROCSTATS", 30, "dumpsys", "procstats", "-c", NULL);
Dianne Hackborn1bd50682013-07-11 11:45:18 -0700937 run_command("CHECKIN USAGESTATS", 30, "dumpsys", "usagestats", "-c", NULL);
Ashish Sharma8b3e1332015-04-28 13:32:54 -0700938 run_command("CHECKIN PACKAGE", 30, "dumpsys", "package", "--checkin", NULL);
Dianne Hackborn02bea972013-06-26 18:59:09 -0700939
940 printf("========================================================\n");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700941 printf("== Running Application Activities\n");
942 printf("========================================================\n");
943
944 run_command("APP ACTIVITIES", 30, "dumpsys", "activity", "all", NULL);
945
946 printf("========================================================\n");
947 printf("== Running Application Services\n");
948 printf("========================================================\n");
949
950 run_command("APP SERVICES", 30, "dumpsys", "activity", "service", "all", NULL);
951
952 printf("========================================================\n");
953 printf("== Running Application Providers\n");
954 printf("========================================================\n");
955
956 run_command("APP SERVICES", 30, "dumpsys", "activity", "provider", "all", NULL);
957
958
959 printf("========================================================\n");
Felipe Leme608385d2016-02-01 10:35:38 -0800960 printf("== Final progress (pid %d): %d/%d (originally %d)\n",
961 getpid(), progress, weight_total, WEIGHT_TOTAL);
962 printf("========================================================\n");
Colin Crossf45fa6b2012-03-26 12:38:26 -0700963 printf("== dumpstate: done\n");
964 printf("========================================================\n");
965}
966
967static void usage() {
Felipe Lemecc37b8e2016-04-11 13:45:18 -0700968 fprintf(stderr,
Felipe Leme2628e9e2016-04-12 16:36:51 -0700969 "usage: dumpstate [-h] [-b soundfile] [-e soundfile] [-o file [-d] [-p] "
970 "[-z]] [-s] [-S] [-q] [-B] [-P] [-R] [-V version]\n"
971 " -h: display this help message\n"
Felipe Lemecc37b8e2016-04-11 13:45:18 -0700972 " -b: play sound file instead of vibrate, at beginning of job\n"
973 " -e: play sound file instead of vibrate, at end of job\n"
974 " -o: write to file (instead of stdout)\n"
975 " -d: append date to filename (requires -o)\n"
976 " -p: capture screenshot to filename.png (requires -o)\n"
Felipe Leme2628e9e2016-04-12 16:36:51 -0700977 " -z: generate zipped file (requires -o)\n"
Felipe Lemecc37b8e2016-04-11 13:45:18 -0700978 " -s: write output to control socket (for init)\n"
Felipe Leme2628e9e2016-04-12 16:36:51 -0700979 " -S: write file location to control socket (for init; requires -o and -z)"
Felipe Lemecc37b8e2016-04-11 13:45:18 -0700980 " -q: disable vibrate\n"
981 " -B: send broadcast when finished (requires -o)\n"
982 " -P: send broadcast when started and update system properties on "
983 "progress (requires -o and -B)\n"
984 " -R: take bugreport in remote mode (requires -o, -z, -d and -B, "
985 "shouldn't be used with -P)\n"
986 " -V: sets the bugreport format version (valid values: %s)\n",
987 VERSION_DEFAULT.c_str());
Colin Crossf45fa6b2012-03-26 12:38:26 -0700988}
989
John Michelau885f8882013-05-06 16:42:02 -0500990static void sigpipe_handler(int n) {
Andres Morales2e671bb2014-08-21 12:38:22 -0700991 // don't complain to stderr or stdout
992 _exit(EXIT_FAILURE);
John Michelau885f8882013-05-06 16:42:02 -0500993}
994
Felipe Leme1e9edc62015-12-21 16:02:13 -0800995/* adds the temporary report to the existing .zip file, closes the .zip file, and removes the
996 temporary file.
997 */
Felipe Lemee82a27d2016-01-05 13:35:44 -0800998static bool finish_zip_file(const std::string& bugreport_name, const std::string& bugreport_path,
Felipe Leme1e9edc62015-12-21 16:02:13 -0800999 time_t now) {
Felipe Lemee82a27d2016-01-05 13:35:44 -08001000 if (!add_zip_entry(bugreport_name, bugreport_path)) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001001 MYLOGE("Failed to add text entry to .zip file\n");
Felipe Leme1e9edc62015-12-21 16:02:13 -08001002 return false;
1003 }
Felipe Leme809d74e2016-02-02 12:57:00 -08001004 if (!add_text_zip_entry("main_entry.txt", bugreport_name)) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001005 MYLOGE("Failed to add main_entry.txt to .zip file\n");
Felipe Leme111b9d02016-02-03 09:28:24 -08001006 return false;
Felipe Leme809d74e2016-02-02 12:57:00 -08001007 }
Felipe Leme1e9edc62015-12-21 16:02:13 -08001008
Felipe Lemee82a27d2016-01-05 13:35:44 -08001009 int32_t err = zip_writer->Finish();
Felipe Leme1e9edc62015-12-21 16:02:13 -08001010 if (err) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001011 MYLOGE("zip_writer->Finish(): %s\n", ZipWriter::ErrorCodeString(err));
Felipe Leme1e9edc62015-12-21 16:02:13 -08001012 return false;
1013 }
1014
Felipe Lemec4eee562016-04-21 15:42:55 -07001015 if (is_user_build()) {
1016 MYLOGD("Removing temporary file %s\n", bugreport_path.c_str())
1017 if (remove(bugreport_path.c_str())) {
1018 ALOGW("remove(%s): %s\n", bugreport_path.c_str(), strerror(errno));
1019 }
1020 } else {
1021 MYLOGD("Keeping temporary file %s on non-user build\n", bugreport_path.c_str())
1022 }
1023
Felipe Leme1e9edc62015-12-21 16:02:13 -08001024 return true;
1025}
Felipe Leme6e01fa62015-11-11 19:35:14 -08001026
Michal Karpinski4db754f2015-12-11 18:04:32 +00001027static std::string SHA256_file_hash(std::string filepath) {
Michal Karpinskicbbdf732016-01-07 20:45:02 +00001028 ScopedFd fd(TEMP_FAILURE_RETRY(open(filepath.c_str(), O_RDONLY | O_NONBLOCK | O_CLOEXEC
1029 | O_NOFOLLOW)));
Michal Karpinski4db754f2015-12-11 18:04:32 +00001030 if (fd.get() == -1) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001031 MYLOGE("open(%s): %s\n", filepath.c_str(), strerror(errno));
Michal Karpinski4db754f2015-12-11 18:04:32 +00001032 return NULL;
1033 }
1034
1035 SHA256_CTX ctx;
1036 SHA256_init(&ctx);
1037
1038 std::vector<uint8_t> buffer(65536);
1039 while (1) {
1040 ssize_t bytes_read = TEMP_FAILURE_RETRY(read(fd.get(), buffer.data(), buffer.size()));
1041 if (bytes_read == 0) {
1042 break;
1043 } else if (bytes_read == -1) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001044 MYLOGE("read(%s): %s\n", filepath.c_str(), strerror(errno));
Michal Karpinski4db754f2015-12-11 18:04:32 +00001045 return NULL;
1046 }
1047
1048 SHA256_update(&ctx, buffer.data(), bytes_read);
1049 }
1050
1051 uint8_t hash[SHA256_DIGEST_SIZE];
1052 memcpy(hash, SHA256_final(&ctx), SHA256_DIGEST_SIZE);
1053 char hash_buffer[SHA256_DIGEST_SIZE * 2 + 1];
Michal Karpinskicbbdf732016-01-07 20:45:02 +00001054 for(size_t i = 0; i < SHA256_DIGEST_SIZE; i++) {
1055 sprintf(hash_buffer + (i * 2), "%02x", hash[i]);
Michal Karpinski4db754f2015-12-11 18:04:32 +00001056 }
1057 hash_buffer[sizeof(hash_buffer) - 1] = 0;
1058 return std::string(hash_buffer);
1059}
1060
Colin Crossf45fa6b2012-03-26 12:38:26 -07001061int main(int argc, char *argv[]) {
John Michelau885f8882013-05-06 16:42:02 -05001062 struct sigaction sigact;
Colin Crossf45fa6b2012-03-26 12:38:26 -07001063 int do_add_date = 0;
Felipe Leme6e01fa62015-11-11 19:35:14 -08001064 int do_zip_file = 0;
John Michelau1f794c42012-09-17 11:20:19 -05001065 int do_vibrate = 1;
Colin Crossf45fa6b2012-03-26 12:38:26 -07001066 char* use_outfile = 0;
Colin Crossf45fa6b2012-03-26 12:38:26 -07001067 int use_socket = 0;
Felipe Leme2628e9e2016-04-12 16:36:51 -07001068 int use_control_socket = 0;
Colin Crossf45fa6b2012-03-26 12:38:26 -07001069 int do_fb = 0;
Jeff Sharkey27f9e6d2013-03-13 15:45:50 -07001070 int do_broadcast = 0;
Felipe Lemee338bf62015-12-07 14:03:50 -08001071 int do_early_screenshot = 0;
Michal Karpinski4db754f2015-12-11 18:04:32 +00001072 int is_remote_mode = 0;
Felipe Leme809d74e2016-02-02 12:57:00 -08001073 std::string version = VERSION_DEFAULT;
Colin Crossf45fa6b2012-03-26 12:38:26 -07001074
Felipe Lemee82a27d2016-01-05 13:35:44 -08001075 now = time(NULL);
1076
Felipe Lemecbce55d2016-02-08 09:53:18 -08001077 MYLOGI("begin\n");
Colin Crossf45fa6b2012-03-26 12:38:26 -07001078
Felipe Leme8fecfdd2016-02-09 10:40:07 -08001079 /* gets the sequential id */
1080 char last_id[PROPERTY_VALUE_MAX];
1081 property_get("dumpstate.last_id", last_id, "0");
1082 id = strtoul(last_id, NULL, 10) + 1;
Nick Kralevichf0922cc2016-05-14 16:47:44 -07001083 snprintf(last_id, sizeof(last_id), "%lu", id);
Felipe Leme8fecfdd2016-02-09 10:40:07 -08001084 property_set("dumpstate.last_id", last_id);
1085 MYLOGI("dumpstate id: %lu\n", id);
1086
Jeff Brown1dc94e32014-09-11 14:15:27 -07001087 /* clear SIGPIPE handler */
John Michelau885f8882013-05-06 16:42:02 -05001088 memset(&sigact, 0, sizeof(sigact));
1089 sigact.sa_handler = sigpipe_handler;
1090 sigaction(SIGPIPE, &sigact, NULL);
JP Abgrall3e03d3f2012-05-11 14:14:09 -07001091
Colin Crossf45fa6b2012-03-26 12:38:26 -07001092 /* set as high priority, and protect from OOM killer */
1093 setpriority(PRIO_PROCESS, 0, -20);
Nick Kralevichcd67e9f2015-03-19 11:30:59 -07001094 FILE *oom_adj = fopen("/proc/self/oom_adj", "we");
Colin Crossf45fa6b2012-03-26 12:38:26 -07001095 if (oom_adj) {
1096 fputs("-17", oom_adj);
1097 fclose(oom_adj);
1098 }
1099
Jeff Brown1dc94e32014-09-11 14:15:27 -07001100 /* parse arguments */
Felipe Lemea34efb72016-03-11 09:33:32 -08001101 std::string args;
1102 format_args(argc, const_cast<const char **>(argv), &args);
1103 MYLOGD("Dumpstate command line: %s\n", args.c_str());
Colin Crossf45fa6b2012-03-26 12:38:26 -07001104 int c;
Felipe Leme2628e9e2016-04-12 16:36:51 -07001105 while ((c = getopt(argc, argv, "dho:svqzpPBRSV:")) != -1) {
Colin Crossf45fa6b2012-03-26 12:38:26 -07001106 switch (c) {
Felipe Leme71bbfc52015-11-23 14:14:51 -08001107 case 'd': do_add_date = 1; break;
1108 case 'z': do_zip_file = 1; break;
1109 case 'o': use_outfile = optarg; break;
1110 case 's': use_socket = 1; break;
Felipe Leme2628e9e2016-04-12 16:36:51 -07001111 case 'S': use_control_socket = 1; break;
Colin Crossf45fa6b2012-03-26 12:38:26 -07001112 case 'v': break; // compatibility no-op
Felipe Leme71bbfc52015-11-23 14:14:51 -08001113 case 'q': do_vibrate = 0; break;
1114 case 'p': do_fb = 1; break;
1115 case 'P': do_update_progress = 1; break;
Michal Karpinski4db754f2015-12-11 18:04:32 +00001116 case 'R': is_remote_mode = 1; break;
Felipe Leme71bbfc52015-11-23 14:14:51 -08001117 case 'B': do_broadcast = 1; break;
Felipe Leme809d74e2016-02-02 12:57:00 -08001118 case 'V': version = optarg; break;
Colin Crossf45fa6b2012-03-26 12:38:26 -07001119 case '?': printf("\n");
1120 case 'h':
1121 usage();
1122 exit(1);
1123 }
1124 }
1125
Felipe Leme71bbfc52015-11-23 14:14:51 -08001126 if ((do_zip_file || do_add_date || do_update_progress || do_broadcast) && !use_outfile) {
Felipe Leme6e01fa62015-11-11 19:35:14 -08001127 usage();
1128 exit(1);
1129 }
1130
Felipe Leme2628e9e2016-04-12 16:36:51 -07001131 if (use_control_socket && !do_zip_file) {
1132 usage();
1133 exit(1);
1134 }
1135
Felipe Leme71bbfc52015-11-23 14:14:51 -08001136 if (do_update_progress && !do_broadcast) {
1137 usage();
1138 exit(1);
1139 }
Felipe Leme6e01fa62015-11-11 19:35:14 -08001140
Michal Karpinski4db754f2015-12-11 18:04:32 +00001141 if (is_remote_mode && (do_update_progress || !do_broadcast || !do_zip_file || !do_add_date)) {
1142 usage();
1143 exit(1);
1144 }
1145
Felipe Lemecc37b8e2016-04-11 13:45:18 -07001146 if (version != VERSION_DEFAULT) {
1147 usage();
1148 exit(1);
Felipe Leme809d74e2016-02-02 12:57:00 -08001149 }
1150
Felipe Lemecbce55d2016-02-08 09:53:18 -08001151 MYLOGI("bugreport format version: %s\n", version.c_str());
Felipe Leme809d74e2016-02-02 12:57:00 -08001152
Felipe Lemee338bf62015-12-07 14:03:50 -08001153 do_early_screenshot = do_update_progress;
1154
Christopher Ferrised9354f2014-10-01 17:35:01 -07001155 // If we are going to use a socket, do it as early as possible
1156 // to avoid timeouts from bugreport.
1157 if (use_socket) {
1158 redirect_to_socket(stdout, "dumpstate");
1159 }
1160
Felipe Leme2628e9e2016-04-12 16:36:51 -07001161 if (use_control_socket) {
1162 MYLOGD("Opening control socket\n");
1163 control_socket_fd = open_socket("dumpstate");
1164 }
1165
Felipe Lemecbce55d2016-02-08 09:53:18 -08001166 /* full path of the temporary file containing the bugreport */
Felipe Lemead5f6c42015-11-30 14:26:46 -08001167 std::string tmp_path;
1168
Felipe Lemecbce55d2016-02-08 09:53:18 -08001169 /* full path of the file containing the dumpstate logs*/
1170 std::string log_path;
1171
Felipe Leme14e034a2016-03-30 18:51:03 -07001172 /* full path of the systrace file, when enabled */
1173 std::string systrace_path;
1174
Felipe Lemee338bf62015-12-07 14:03:50 -08001175 /* full path of the temporary file containing the screenshot (when requested) */
1176 std::string screenshot_path;
1177
Felipe Lemecbce55d2016-02-08 09:53:18 -08001178 /* base name (without suffix or extensions) of the bugreport files */
Felipe Lemead5f6c42015-11-30 14:26:46 -08001179 std::string base_name;
1180
Felipe Leme71bbfc52015-11-23 14:14:51 -08001181 /* pointer to the actual path, be it zip or text */
1182 std::string path;
1183
Felipe Leme635ca312016-01-05 14:23:02 -08001184 /* pointer to the zipped file */
Felipe Leme1e9edc62015-12-21 16:02:13 -08001185 std::unique_ptr<FILE, int(*)(FILE*)> zip_file(NULL, fclose);
Felipe Leme71bbfc52015-11-23 14:14:51 -08001186
Felipe Lemead5f6c42015-11-30 14:26:46 -08001187 /* redirect output if needed */
Felipe Leme71bbfc52015-11-23 14:14:51 -08001188 bool is_redirecting = !use_socket && use_outfile;
1189
1190 if (is_redirecting) {
Felipe Lemead5f6c42015-11-30 14:26:46 -08001191 bugreport_dir = dirname(use_outfile);
1192 base_name = basename(use_outfile);
Felipe Leme71bbfc52015-11-23 14:14:51 -08001193 if (do_add_date) {
1194 char date[80];
Felipe Lemead5f6c42015-11-30 14:26:46 -08001195 strftime(date, sizeof(date), "%Y-%m-%d-%H-%M-%S", localtime(&now));
1196 suffix = date;
1197 } else {
1198 suffix = "undated";
Felipe Leme71bbfc52015-11-23 14:14:51 -08001199 }
Felipe Lemecc37b8e2016-04-11 13:45:18 -07001200 char build_id[PROPERTY_VALUE_MAX];
1201 property_get("ro.build.id", build_id, "UNKNOWN_BUILD");
1202 base_name = base_name + "-" + build_id;
Felipe Leme71bbfc52015-11-23 14:14:51 -08001203 if (do_fb) {
Felipe Lemead5f6c42015-11-30 14:26:46 -08001204 // TODO: if dumpstate was an object, the paths could be internal variables and then
1205 // we could have a function to calculate the derived values, such as:
1206 // screenshot_path = GetPath(".png");
1207 screenshot_path = bugreport_dir + "/" + base_name + "-" + suffix + ".png";
Felipe Leme71bbfc52015-11-23 14:14:51 -08001208 }
Felipe Lemead5f6c42015-11-30 14:26:46 -08001209 tmp_path = bugreport_dir + "/" + base_name + "-" + suffix + ".tmp";
Felipe Lemecbce55d2016-02-08 09:53:18 -08001210 log_path = bugreport_dir + "/dumpstate_log-" + suffix + "-"
1211 + std::to_string(getpid()) + ".txt";
Felipe Leme71bbfc52015-11-23 14:14:51 -08001212
Felipe Lemecbce55d2016-02-08 09:53:18 -08001213 MYLOGD("Bugreport dir: %s\n"
1214 "Base name: %s\n"
1215 "Suffix: %s\n"
1216 "Log path: %s\n"
1217 "Temporary path: %s\n"
1218 "Screenshot path: %s\n",
1219 bugreport_dir.c_str(), base_name.c_str(), suffix.c_str(),
1220 log_path.c_str(), tmp_path.c_str(), screenshot_path.c_str());
Felipe Leme71bbfc52015-11-23 14:14:51 -08001221
Felipe Leme1e9edc62015-12-21 16:02:13 -08001222 if (do_zip_file) {
Felipe Leme1e9edc62015-12-21 16:02:13 -08001223 path = bugreport_dir + "/" + base_name + "-" + suffix + ".zip";
Felipe Leme26bd34c2016-03-15 13:40:33 -07001224 MYLOGD("Creating initial .zip file (%s)\n", path.c_str());
Felipe Leme111b9d02016-02-03 09:28:24 -08001225 create_parent_dirs(path.c_str());
Felipe Leme1e9edc62015-12-21 16:02:13 -08001226 zip_file.reset(fopen(path.c_str(), "wb"));
1227 if (!zip_file) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001228 MYLOGE("fopen(%s, 'wb'): %s\n", path.c_str(), strerror(errno));
Felipe Leme1e9edc62015-12-21 16:02:13 -08001229 do_zip_file = 0;
1230 } else {
1231 zip_writer.reset(new ZipWriter(zip_file.get()));
1232 }
Felipe Leme809d74e2016-02-02 12:57:00 -08001233 add_text_zip_entry("version.txt", version);
Felipe Leme1e9edc62015-12-21 16:02:13 -08001234 }
1235
Felipe Leme71bbfc52015-11-23 14:14:51 -08001236 if (do_update_progress) {
Felipe Lemead5f6c42015-11-30 14:26:46 -08001237 std::vector<std::string> am_args = {
Felipe Lemed5e724a2016-02-11 09:12:39 -08001238 "--receiver-permission", "android.permission.DUMP", "--receiver-foreground",
Felipe Lemead5f6c42015-11-30 14:26:46 -08001239 "--es", "android.intent.extra.NAME", suffix,
Felipe Leme8fecfdd2016-02-09 10:40:07 -08001240 "--ei", "android.intent.extra.ID", std::to_string(id),
Felipe Lemead5f6c42015-11-30 14:26:46 -08001241 "--ei", "android.intent.extra.PID", std::to_string(getpid()),
1242 "--ei", "android.intent.extra.MAX", std::to_string(WEIGHT_TOTAL),
1243 };
1244 send_broadcast("android.intent.action.BUGREPORT_STARTED", am_args);
Felipe Leme71bbfc52015-11-23 14:14:51 -08001245 }
1246 }
1247
Nick Kralevichf3599b32016-01-25 15:05:16 -08001248 /* read /proc/cmdline before dropping root */
1249 FILE *cmdline = fopen("/proc/cmdline", "re");
1250 if (cmdline) {
1251 fgets(cmdline_buf, sizeof(cmdline_buf), cmdline);
1252 fclose(cmdline);
1253 }
1254
Jeff Brown1dc94e32014-09-11 14:15:27 -07001255 /* open the vibrator before dropping root */
Felipe Leme6e01fa62015-11-11 19:35:14 -08001256 std::unique_ptr<FILE, int(*)(FILE*)> vibrator(NULL, fclose);
John Michelau1f794c42012-09-17 11:20:19 -05001257 if (do_vibrate) {
Felipe Leme6e01fa62015-11-11 19:35:14 -08001258 vibrator.reset(fopen("/sys/class/timed_output/vibrator/enable", "we"));
Jeff Brown1dc94e32014-09-11 14:15:27 -07001259 if (vibrator) {
Felipe Leme6e01fa62015-11-11 19:35:14 -08001260 vibrate(vibrator.get(), 150);
Jeff Brown1dc94e32014-09-11 14:15:27 -07001261 }
John Michelau1f794c42012-09-17 11:20:19 -05001262 }
Colin Crossf45fa6b2012-03-26 12:38:26 -07001263
Felipe Leme3634a1e2015-12-09 10:11:47 -08001264 if (do_fb && do_early_screenshot) {
1265 if (screenshot_path.empty()) {
1266 // should not have happened
Felipe Lemecbce55d2016-02-08 09:53:18 -08001267 MYLOGE("INTERNAL ERROR: skipping early screenshot because path was not set\n");
Felipe Leme3634a1e2015-12-09 10:11:47 -08001268 } else {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001269 MYLOGI("taking early screenshot\n");
Felipe Leme3634a1e2015-12-09 10:11:47 -08001270 take_screenshot(screenshot_path);
Felipe Lemecbce55d2016-02-08 09:53:18 -08001271 MYLOGI("wrote screenshot: %s\n", screenshot_path.c_str());
Felipe Leme3634a1e2015-12-09 10:11:47 -08001272 if (chown(screenshot_path.c_str(), AID_SHELL, AID_SHELL)) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001273 MYLOGE("Unable to change ownership of screenshot file %s: %s\n",
Felipe Leme3634a1e2015-12-09 10:11:47 -08001274 screenshot_path.c_str(), strerror(errno));
1275 }
Felipe Lemee338bf62015-12-07 14:03:50 -08001276 }
1277 }
1278
Felipe Leme1e9edc62015-12-21 16:02:13 -08001279 if (do_zip_file) {
1280 if (chown(path.c_str(), AID_SHELL, AID_SHELL)) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001281 MYLOGE("Unable to change ownership of zip file %s: %s\n", path.c_str(), strerror(errno));
Felipe Leme1e9edc62015-12-21 16:02:13 -08001282 }
1283 }
1284
Felipe Leme71bbfc52015-11-23 14:14:51 -08001285 if (is_redirecting) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001286 redirect_to_file(stderr, const_cast<char*>(log_path.c_str()));
Felipe Leme6fe9db62016-02-12 09:04:16 -08001287 if (chown(log_path.c_str(), AID_SHELL, AID_SHELL)) {
1288 MYLOGE("Unable to change ownership of dumpstate log file %s: %s\n",
1289 log_path.c_str(), strerror(errno));
1290 }
Felipe Leme6e01fa62015-11-11 19:35:14 -08001291 /* TODO: rather than generating a text file now and zipping it later,
1292 it would be more efficient to redirect stdout to the zip entry
1293 directly, but the libziparchive doesn't support that option yet. */
1294 redirect_to_file(stdout, const_cast<char*>(tmp_path.c_str()));
Felipe Leme6fe9db62016-02-12 09:04:16 -08001295 if (chown(tmp_path.c_str(), AID_SHELL, AID_SHELL)) {
1296 MYLOGE("Unable to change ownership of temporary bugreport file %s: %s\n",
1297 tmp_path.c_str(), strerror(errno));
1298 }
Colin Crossf45fa6b2012-03-26 12:38:26 -07001299 }
Felipe Leme608385d2016-02-01 10:35:38 -08001300 // NOTE: there should be no stdout output until now, otherwise it would break the header.
1301 // In particular, DurationReport objects should be created passing 'title, NULL', so their
Felipe Lemecbce55d2016-02-08 09:53:18 -08001302 // duration is logged into MYLOG instead.
Felipe Leme809d74e2016-02-02 12:57:00 -08001303 print_header(version);
Colin Crossf45fa6b2012-03-26 12:38:26 -07001304
Felipe Leme71a74ac2016-03-17 15:43:25 -07001305 // Dumps systrace right away, otherwise it will be filled with unnecessary events.
Felipe Lemeefd7e272016-05-18 09:27:16 -07001306 dump_systrace();
Felipe Leme71a74ac2016-03-17 15:43:25 -07001307
Wei Liu341938b2016-04-27 16:18:17 -07001308 // TODO: Drop root user and move into dumpstate() once b/28633932 is fixed.
Felipe Lemeefd7e272016-05-18 09:27:16 -07001309 dump_raft();
Wei Liu341938b2016-04-27 16:18:17 -07001310
Felipe Leme9c74aad2016-02-29 18:15:42 -08001311 // Invoking the following dumpsys calls before dump_traces() to try and
1312 // keep the system stats as close to its initial state as possible.
Thierry Strudel8b78b752016-03-22 10:25:44 -07001313 run_command_as_shell("DUMPSYS MEMINFO", 30, "dumpsys", "-t", "30", "meminfo", "-a", NULL);
1314 run_command_as_shell("DUMPSYS CPUINFO", 10, "dumpsys", "cpuinfo", "-a", NULL);
Srinath Sridharanfdf52d32016-02-01 15:50:22 -08001315
1316 /* collect stack traces from Dalvik and native processes (needs root) */
1317 dump_traces_path = dump_traces();
1318
1319 /* Get the tombstone fds, recovery files, and mount info here while we are running as root. */
1320 get_tombstone_fds(tombstone_data);
1321 add_dir(RECOVERY_DIR, true);
Mark Salyzynd6ab0112016-03-25 12:56:39 -07001322 add_dir(RECOVERY_DATA_DIR, true);
Mark Salyzyn4d42dea2016-04-01 10:03:14 -07001323 add_dir(LOGPERSIST_DATA_DIR, false);
Srinath Sridharanfdf52d32016-02-01 15:50:22 -08001324 add_mountinfo();
1325
Felipe Lemecf6a8b42016-03-11 10:38:19 -08001326 if (!drop_root_user()) {
Srinath Sridharanfdf52d32016-02-01 15:50:22 -08001327 return -1;
1328 }
1329
1330 dumpstate(do_early_screenshot ? "": screenshot_path, version);
Colin Crossf45fa6b2012-03-26 12:38:26 -07001331
Felipe Leme55b42a62015-11-10 17:39:08 -08001332 /* close output if needed */
Felipe Leme71bbfc52015-11-23 14:14:51 -08001333 if (is_redirecting) {
Colin Crossf45fa6b2012-03-26 12:38:26 -07001334 fclose(stdout);
Colin Crossf45fa6b2012-03-26 12:38:26 -07001335 }
1336
Felipe Leme6e01fa62015-11-11 19:35:14 -08001337 /* rename or zip the (now complete) .tmp file to its final location */
1338 if (use_outfile) {
Felipe Lemead5f6c42015-11-30 14:26:46 -08001339
1340 /* check if user changed the suffix using system properties */
1341 char key[PROPERTY_KEY_MAX];
1342 char value[PROPERTY_VALUE_MAX];
Nick Kralevichf0922cc2016-05-14 16:47:44 -07001343 snprintf(key, sizeof(key), "dumpstate.%d.name", getpid());
Felipe Lemead5f6c42015-11-30 14:26:46 -08001344 property_get(key, value, "");
1345 bool change_suffix= false;
1346 if (value[0]) {
1347 /* must whitelist which characters are allowed, otherwise it could cross directories */
1348 std::regex valid_regex("^[-_a-zA-Z0-9]+$");
1349 if (std::regex_match(value, valid_regex)) {
1350 change_suffix = true;
1351 } else {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001352 MYLOGE("invalid suffix provided by user: %s\n", value);
Felipe Lemead5f6c42015-11-30 14:26:46 -08001353 }
1354 }
1355 if (change_suffix) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001356 MYLOGI("changing suffix from %s to %s\n", suffix.c_str(), value);
Felipe Lemead5f6c42015-11-30 14:26:46 -08001357 suffix = value;
1358 if (!screenshot_path.empty()) {
1359 std::string new_screenshot_path =
1360 bugreport_dir + "/" + base_name + "-" + suffix + ".png";
1361 if (rename(screenshot_path.c_str(), new_screenshot_path.c_str())) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001362 MYLOGE("rename(%s, %s): %s\n", screenshot_path.c_str(),
Felipe Lemead5f6c42015-11-30 14:26:46 -08001363 new_screenshot_path.c_str(), strerror(errno));
1364 } else {
1365 screenshot_path = new_screenshot_path;
1366 }
1367 }
1368 }
1369
Felipe Leme6e01fa62015-11-11 19:35:14 -08001370 bool do_text_file = true;
1371 if (do_zip_file) {
Felipe Leme88c79332016-02-22 11:06:49 -08001372 std::string entry_name = base_name + "-" + suffix + ".txt";
1373 MYLOGD("Adding main entry (%s) to .zip bugreport\n", entry_name.c_str());
1374 if (!finish_zip_file(entry_name, tmp_path, now)) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001375 MYLOGE("Failed to finish zip file; sending text bugreport instead\n");
Felipe Leme6e01fa62015-11-11 19:35:14 -08001376 do_text_file = true;
1377 } else {
1378 do_text_file = false;
Felipe Leme91274352016-02-26 15:03:52 -08001379 // Since zip file is already created, it needs to be renamed.
1380 std::string new_path = bugreport_dir + "/" + base_name + "-" + suffix + ".zip";
1381 if (path != new_path) {
1382 MYLOGD("Renaming zip file from %s to %s\n", path.c_str(), new_path.c_str());
1383 if (rename(path.c_str(), new_path.c_str())) {
1384 MYLOGE("rename(%s, %s): %s\n", path.c_str(),
1385 new_path.c_str(), strerror(errno));
1386 } else {
1387 path = new_path;
1388 }
1389 }
Felipe Leme6e01fa62015-11-11 19:35:14 -08001390 }
1391 }
1392 if (do_text_file) {
Felipe Lemead5f6c42015-11-30 14:26:46 -08001393 path = bugreport_dir + "/" + base_name + "-" + suffix + ".txt";
Felipe Leme88c79332016-02-22 11:06:49 -08001394 MYLOGD("Generating .txt bugreport at %s from %s\n", path.c_str(), tmp_path.c_str());
Felipe Lemead5f6c42015-11-30 14:26:46 -08001395 if (rename(tmp_path.c_str(), path.c_str())) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001396 MYLOGE("rename(%s, %s): %s\n", tmp_path.c_str(), path.c_str(), strerror(errno));
Felipe Leme6e01fa62015-11-11 19:35:14 -08001397 path.clear();
1398 }
1399 }
Felipe Leme2628e9e2016-04-12 16:36:51 -07001400 if (use_control_socket) {
1401 if (do_text_file) {
1402 dprintf(control_socket_fd, "FAIL:could not create zip file, check %s "
1403 "for more details\n", log_path.c_str());
1404 } else {
1405 dprintf(control_socket_fd, "OK:%s\n", path.c_str());
1406 }
1407 }
Colin Crossf45fa6b2012-03-26 12:38:26 -07001408 }
1409
Felipe Lemecc2a2fa2016-02-25 14:02:44 -08001410 /* vibrate a few but shortly times to let user know it's finished */
1411 if (vibrator) {
1412 for (int i = 0; i < 3; i++) {
1413 vibrate(vibrator.get(), 75);
1414 usleep((75 + 50) * 1000);
1415 }
1416 }
1417
Jeff Brown1dc94e32014-09-11 14:15:27 -07001418 /* tell activity manager we're done */
Felipe Leme71bbfc52015-11-23 14:14:51 -08001419 if (do_broadcast) {
Felipe Leme6e01fa62015-11-11 19:35:14 -08001420 if (!path.empty()) {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001421 MYLOGI("Final bugreport path: %s\n", path.c_str());
Felipe Leme36b3f6f2015-11-19 15:41:04 -08001422 std::vector<std::string> am_args = {
Felipe Leme43fd1bb2016-01-29 09:07:57 -08001423 "--receiver-permission", "android.permission.DUMP", "--receiver-foreground",
Felipe Leme8fecfdd2016-02-09 10:40:07 -08001424 "--ei", "android.intent.extra.ID", std::to_string(id),
Felipe Leme71bbfc52015-11-23 14:14:51 -08001425 "--ei", "android.intent.extra.PID", std::to_string(getpid()),
Felipe Lemeee2e4a02016-02-22 18:12:11 -08001426 "--ei", "android.intent.extra.MAX", std::to_string(weight_total),
Felipe Lemecbce55d2016-02-08 09:53:18 -08001427 "--es", "android.intent.extra.BUGREPORT", path,
1428 "--es", "android.intent.extra.DUMPSTATE_LOG", log_path
Felipe Leme36b3f6f2015-11-19 15:41:04 -08001429 };
1430 if (do_fb) {
1431 am_args.push_back("--es");
1432 am_args.push_back("android.intent.extra.SCREENSHOT");
1433 am_args.push_back(screenshot_path);
1434 }
Michal Karpinski4db754f2015-12-11 18:04:32 +00001435 if (is_remote_mode) {
1436 am_args.push_back("--es");
1437 am_args.push_back("android.intent.extra.REMOTE_BUGREPORT_HASH");
1438 am_args.push_back(SHA256_file_hash(path));
1439 send_broadcast("android.intent.action.REMOTE_BUGREPORT_FINISHED", am_args);
1440 } else {
1441 send_broadcast("android.intent.action.BUGREPORT_FINISHED", am_args);
1442 }
Felipe Leme6e01fa62015-11-11 19:35:14 -08001443 } else {
Felipe Lemecbce55d2016-02-08 09:53:18 -08001444 MYLOGE("Skipping finished broadcast because bugreport could not be generated\n");
Felipe Leme6e01fa62015-11-11 19:35:14 -08001445 }
Jeff Sharkey27f9e6d2013-03-13 15:45:50 -07001446 }
1447
Felipe Lemecbce55d2016-02-08 09:53:18 -08001448 MYLOGD("Final progress: %d/%d (originally %d)\n", progress, weight_total, WEIGHT_TOTAL);
1449 MYLOGI("done\n");
Colin Crossf45fa6b2012-03-26 12:38:26 -07001450
Felipe Leme107a05f2016-03-08 15:11:15 -08001451 if (is_redirecting) {
1452 fclose(stderr);
1453 }
1454
Felipe Leme2628e9e2016-04-12 16:36:51 -07001455 if (use_control_socket && control_socket_fd >= 0) {
1456 MYLOGD("Closing control socket\n");
1457 close(control_socket_fd);
1458 }
1459
Colin Crossf45fa6b2012-03-26 12:38:26 -07001460 return 0;
1461}