blob: acb6ed6d445621cadd8d9e5b786384b9f47ff21d [file] [log] [blame]
Jeff Brown053b8652012-06-06 16:25:03 -07001/*
2 * Copyright (C) 2012 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 <stddef.h>
Jeff Brown053b8652012-06-06 16:25:03 -070018#include <stdlib.h>
19#include <signal.h>
20#include <string.h>
21#include <stdio.h>
22#include <fcntl.h>
23#include <errno.h>
24#include <dirent.h>
25#include <time.h>
26#include <sys/ptrace.h>
27#include <sys/stat.h>
Christopher Ferris20303f82014-01-10 16:33:16 -080028#include <inttypes.h>
Jeff Brown053b8652012-06-06 16:25:03 -070029
30#include <private/android_filesystem_config.h>
31
Colin Cross9227bd32013-07-23 16:59:20 -070032#include <log/logger.h>
Jeff Brown053b8652012-06-06 16:25:03 -070033#include <cutils/properties.h>
34
Christopher Ferris20303f82014-01-10 16:33:16 -080035#include <backtrace/Backtrace.h>
Christopher Ferris46756822014-01-14 20:16:30 -080036#include <backtrace/BacktraceMap.h>
Jeff Brown053b8652012-06-06 16:25:03 -070037
Christopher Tateded2e5a2013-03-19 13:12:23 -070038#include <sys/socket.h>
39#include <linux/un.h>
40
rpcraigf1186f32012-07-19 09:38:06 -040041#include <selinux/android.h>
rpcraigf1186f32012-07-19 09:38:06 -040042
Christopher Ferris20303f82014-01-10 16:33:16 -080043#include <UniquePtr.h>
44
Jeff Brown053b8652012-06-06 16:25:03 -070045#include "machine.h"
46#include "tombstone.h"
Christopher Ferris365e4ae2013-10-02 12:26:48 -070047#include "backtrace.h"
Jeff Brown053b8652012-06-06 16:25:03 -070048
Jeff Brown053b8652012-06-06 16:25:03 -070049#define STACK_WORDS 16
50
51#define MAX_TOMBSTONES 10
52#define TOMBSTONE_DIR "/data/tombstones"
53
Christopher Ferris20303f82014-01-10 16:33:16 -080054// Must match the path defined in NativeCrashListener.java
Christopher Tateded2e5a2013-03-19 13:12:23 -070055#define NCRASH_SOCKET_PATH "/data/system/ndebugsocket"
56
Jeff Brown053b8652012-06-06 16:25:03 -070057#define typecheck(x,y) { \
Christopher Ferris20303f82014-01-10 16:33:16 -080058 typeof(x) __dummy1; \
59 typeof(y) __dummy2; \
60 (void)(&__dummy1 == &__dummy2); }
Jeff Brown053b8652012-06-06 16:25:03 -070061
62
63static bool signal_has_address(int sig) {
Christopher Ferris20303f82014-01-10 16:33:16 -080064 switch (sig) {
Jeff Brown053b8652012-06-06 16:25:03 -070065 case SIGILL:
Christopher Ferris20303f82014-01-10 16:33:16 -080066 case SIGFPE:
67 case SIGSEGV:
68 case SIGBUS:
69 return true;
70 default:
71 return false;
72 }
73}
74
75static const char* get_signame(int sig) {
76 switch(sig) {
77 case SIGILL: return "SIGILL";
78 case SIGABRT: return "SIGABRT";
79 case SIGBUS: return "SIGBUS";
80 case SIGFPE: return "SIGFPE";
81 case SIGSEGV: return "SIGSEGV";
82 case SIGPIPE: return "SIGPIPE";
83#ifdef SIGSTKFLT
84 case SIGSTKFLT: return "SIGSTKFLT";
85#endif
86 case SIGSTOP: return "SIGSTOP";
87 default: return "?";
88 }
89}
90
91static const char* get_sigcode(int signo, int code) {
92 // Try the signal-specific codes...
93 switch (signo) {
94 case SIGILL:
95 switch (code) {
Jeff Brown053b8652012-06-06 16:25:03 -070096 case ILL_ILLOPC: return "ILL_ILLOPC";
97 case ILL_ILLOPN: return "ILL_ILLOPN";
98 case ILL_ILLADR: return "ILL_ILLADR";
99 case ILL_ILLTRP: return "ILL_ILLTRP";
100 case ILL_PRVOPC: return "ILL_PRVOPC";
101 case ILL_PRVREG: return "ILL_PRVREG";
102 case ILL_COPROC: return "ILL_COPROC";
103 case ILL_BADSTK: return "ILL_BADSTK";
Christopher Ferris20303f82014-01-10 16:33:16 -0800104 }
105 break;
Jeff Brown053b8652012-06-06 16:25:03 -0700106 case SIGBUS:
Christopher Ferris20303f82014-01-10 16:33:16 -0800107 switch (code) {
Jeff Brown053b8652012-06-06 16:25:03 -0700108 case BUS_ADRALN: return "BUS_ADRALN";
109 case BUS_ADRERR: return "BUS_ADRERR";
110 case BUS_OBJERR: return "BUS_OBJERR";
Christopher Ferris20303f82014-01-10 16:33:16 -0800111 }
112 break;
Jeff Brown053b8652012-06-06 16:25:03 -0700113 case SIGFPE:
Christopher Ferris20303f82014-01-10 16:33:16 -0800114 switch (code) {
Jeff Brown053b8652012-06-06 16:25:03 -0700115 case FPE_INTDIV: return "FPE_INTDIV";
116 case FPE_INTOVF: return "FPE_INTOVF";
117 case FPE_FLTDIV: return "FPE_FLTDIV";
118 case FPE_FLTOVF: return "FPE_FLTOVF";
119 case FPE_FLTUND: return "FPE_FLTUND";
120 case FPE_FLTRES: return "FPE_FLTRES";
121 case FPE_FLTINV: return "FPE_FLTINV";
122 case FPE_FLTSUB: return "FPE_FLTSUB";
Christopher Ferris20303f82014-01-10 16:33:16 -0800123 }
124 break;
Jeff Brown053b8652012-06-06 16:25:03 -0700125 case SIGSEGV:
Christopher Ferris20303f82014-01-10 16:33:16 -0800126 switch (code) {
Jeff Brown053b8652012-06-06 16:25:03 -0700127 case SEGV_MAPERR: return "SEGV_MAPERR";
128 case SEGV_ACCERR: return "SEGV_ACCERR";
Christopher Ferris20303f82014-01-10 16:33:16 -0800129 }
130 break;
Elliott Hughes8f7d4432012-12-10 10:29:05 -0800131 case SIGTRAP:
Christopher Ferris20303f82014-01-10 16:33:16 -0800132 switch (code) {
Elliott Hughes8f7d4432012-12-10 10:29:05 -0800133 case TRAP_BRKPT: return "TRAP_BRKPT";
134 case TRAP_TRACE: return "TRAP_TRACE";
Christopher Ferris20303f82014-01-10 16:33:16 -0800135 }
136 break;
137 }
138 // Then the other codes...
139 switch (code) {
140 case SI_USER: return "SI_USER";
Elliott Hughes8f7d4432012-12-10 10:29:05 -0800141#if defined(SI_KERNEL)
Christopher Ferris20303f82014-01-10 16:33:16 -0800142 case SI_KERNEL: return "SI_KERNEL";
Elliott Hughes8f7d4432012-12-10 10:29:05 -0800143#endif
Christopher Ferris20303f82014-01-10 16:33:16 -0800144 case SI_QUEUE: return "SI_QUEUE";
145 case SI_TIMER: return "SI_TIMER";
146 case SI_MESGQ: return "SI_MESGQ";
Elliott Hughes8f7d4432012-12-10 10:29:05 -0800147 case SI_ASYNCIO: return "SI_ASYNCIO";
148#if defined(SI_SIGIO)
Christopher Ferris20303f82014-01-10 16:33:16 -0800149 case SI_SIGIO: return "SI_SIGIO";
Elliott Hughes8f7d4432012-12-10 10:29:05 -0800150#endif
151#if defined(SI_TKILL)
Christopher Ferris20303f82014-01-10 16:33:16 -0800152 case SI_TKILL: return "SI_TKILL";
Elliott Hughes8f7d4432012-12-10 10:29:05 -0800153#endif
Christopher Ferris20303f82014-01-10 16:33:16 -0800154 }
155 // Then give up...
156 return "?";
Jeff Brown053b8652012-06-06 16:25:03 -0700157}
158
Christopher Ferris20303f82014-01-10 16:33:16 -0800159static void dump_revision_info(log_t* log) {
160 char revision[PROPERTY_VALUE_MAX];
Ben Chengd7760c12012-09-19 16:04:01 -0700161
Christopher Ferris20303f82014-01-10 16:33:16 -0800162 property_get("ro.revision", revision, "unknown");
Ben Chengd7760c12012-09-19 16:04:01 -0700163
Christopher Ferris20303f82014-01-10 16:33:16 -0800164 _LOG(log, SCOPE_AT_FAULT, "Revision: '%s'\n", revision);
Ben Chengd7760c12012-09-19 16:04:01 -0700165}
166
Christopher Ferris20303f82014-01-10 16:33:16 -0800167static void dump_build_info(log_t* log) {
168 char fingerprint[PROPERTY_VALUE_MAX];
Jeff Brown053b8652012-06-06 16:25:03 -0700169
Christopher Ferris20303f82014-01-10 16:33:16 -0800170 property_get("ro.build.fingerprint", fingerprint, "unknown");
Jeff Brown053b8652012-06-06 16:25:03 -0700171
Christopher Ferris20303f82014-01-10 16:33:16 -0800172 _LOG(log, SCOPE_AT_FAULT, "Build fingerprint: '%s'\n", fingerprint);
Jeff Brown053b8652012-06-06 16:25:03 -0700173}
174
Christopher Ferris20303f82014-01-10 16:33:16 -0800175static void dump_fault_addr(log_t* log, pid_t tid, int sig) {
176 siginfo_t si;
Jeff Brown053b8652012-06-06 16:25:03 -0700177
Christopher Ferris20303f82014-01-10 16:33:16 -0800178 memset(&si, 0, sizeof(si));
179 if (ptrace(PTRACE_GETSIGINFO, tid, 0, &si)){
180 _LOG(log, SCOPE_AT_FAULT, "cannot get siginfo: %s\n", strerror(errno));
181 } else if (signal_has_address(sig)) {
182 _LOG(log, SCOPE_AT_FAULT, "signal %d (%s), code %d (%s), fault addr %0*" PRIxPTR "\n",
183 sig, get_signame(sig), si.si_code, get_sigcode(sig, si.si_code),
184 sizeof(uintptr_t)*2, reinterpret_cast<uintptr_t>(si.si_addr));
185 } else {
186 _LOG(log, SCOPE_AT_FAULT, "signal %d (%s), code %d (%s), fault addr --------\n",
187 sig, get_signame(sig), si.si_code, get_sigcode(sig, si.si_code));
188 }
Jeff Brown053b8652012-06-06 16:25:03 -0700189}
190
Christopher Ferris365e4ae2013-10-02 12:26:48 -0700191static void dump_thread_info(log_t* log, pid_t pid, pid_t tid, int scope_flags) {
Christopher Ferris20303f82014-01-10 16:33:16 -0800192 char path[64];
193 char threadnamebuf[1024];
194 char* threadname = NULL;
195 FILE *fp;
Jeff Brown053b8652012-06-06 16:25:03 -0700196
Christopher Ferris20303f82014-01-10 16:33:16 -0800197 snprintf(path, sizeof(path), "/proc/%d/comm", tid);
198 if ((fp = fopen(path, "r"))) {
199 threadname = fgets(threadnamebuf, sizeof(threadnamebuf), fp);
200 fclose(fp);
201 if (threadname) {
202 size_t len = strlen(threadname);
203 if (len && threadname[len - 1] == '\n') {
204 threadname[len - 1] = '\0';
205 }
206 }
207 }
208
209 if (IS_AT_FAULT(scope_flags)) {
210 char procnamebuf[1024];
211 char* procname = NULL;
212
213 snprintf(path, sizeof(path), "/proc/%d/cmdline", pid);
Jeff Brown053b8652012-06-06 16:25:03 -0700214 if ((fp = fopen(path, "r"))) {
Christopher Ferris20303f82014-01-10 16:33:16 -0800215 procname = fgets(procnamebuf, sizeof(procnamebuf), fp);
216 fclose(fp);
Jeff Brown053b8652012-06-06 16:25:03 -0700217 }
218
Christopher Ferris20303f82014-01-10 16:33:16 -0800219 _LOG(log, SCOPE_AT_FAULT, "pid: %d, tid: %d, name: %s >>> %s <<<\n", pid, tid,
220 threadname ? threadname : "UNKNOWN", procname ? procname : "UNKNOWN");
221 } else {
222 _LOG(log, 0, "pid: %d, tid: %d, name: %s\n", pid, tid, threadname ? threadname : "UNKNOWN");
223 }
224}
Jeff Brown053b8652012-06-06 16:25:03 -0700225
Christopher Ferris20303f82014-01-10 16:33:16 -0800226static void dump_stack_segment(
227 Backtrace* backtrace, log_t* log, int scope_flags, uintptr_t* sp, size_t words, int label) {
228 for (size_t i = 0; i < words; i++) {
229 uint32_t stack_content;
230 if (!backtrace->ReadWord(*sp, &stack_content)) {
231 break;
232 }
233
Christopher Ferris46756822014-01-14 20:16:30 -0800234 const backtrace_map_t* map = backtrace->FindMap(stack_content);
235 const char* map_name;
236 if (!map) {
Christopher Ferris20303f82014-01-10 16:33:16 -0800237 map_name = "";
Christopher Ferris46756822014-01-14 20:16:30 -0800238 } else {
239 map_name = map->name.c_str();
Christopher Ferris20303f82014-01-10 16:33:16 -0800240 }
241 uintptr_t offset = 0;
242 std::string func_name(backtrace->GetFunctionName(stack_content, &offset));
243 if (!func_name.empty()) {
244 if (!i && label >= 0) {
245 if (offset) {
246 _LOG(log, scope_flags, " #%02d %08x %08x %s (%s+%u)\n",
247 label, *sp, stack_content, map_name, func_name.c_str(), offset);
248 } else {
249 _LOG(log, scope_flags, " #%02d %08x %08x %s (%s)\n",
250 label, *sp, stack_content, map_name, func_name.c_str());
Jeff Brown053b8652012-06-06 16:25:03 -0700251 }
Christopher Ferris20303f82014-01-10 16:33:16 -0800252 } else {
253 if (offset) {
254 _LOG(log, scope_flags, " %08x %08x %s (%s+%u)\n",
255 *sp, stack_content, map_name, func_name.c_str(), offset);
256 } else {
257 _LOG(log, scope_flags, " %08x %08x %s (%s)\n",
258 *sp, stack_content, map_name, func_name.c_str());
259 }
260 }
Jeff Brown053b8652012-06-06 16:25:03 -0700261 } else {
Christopher Ferris20303f82014-01-10 16:33:16 -0800262 if (!i && label >= 0) {
263 _LOG(log, scope_flags, " #%02d %08x %08x %s\n",
264 label, *sp, stack_content, map_name);
265 } else {
266 _LOG(log, scope_flags, " %08x %08x %s\n",
267 *sp, stack_content, map_name);
268 }
Jeff Brown053b8652012-06-06 16:25:03 -0700269 }
Christopher Ferris20303f82014-01-10 16:33:16 -0800270
271 *sp += sizeof(uint32_t);
272 }
Jeff Brown053b8652012-06-06 16:25:03 -0700273}
274
Christopher Ferris20303f82014-01-10 16:33:16 -0800275static void dump_stack(Backtrace* backtrace, log_t* log, int scope_flags) {
276 size_t first = 0, last;
277 for (size_t i = 0; i < backtrace->NumFrames(); i++) {
278 const backtrace_frame_data_t* frame = backtrace->GetFrame(i);
279 if (frame->sp) {
280 if (!first) {
281 first = i+1;
282 }
283 last = i;
Jeff Brown053b8652012-06-06 16:25:03 -0700284 }
Christopher Ferris20303f82014-01-10 16:33:16 -0800285 }
286 if (!first) {
287 return;
288 }
289 first--;
290
291 scope_flags |= SCOPE_SENSITIVE;
292
293 // Dump a few words before the first frame.
294 uintptr_t sp = backtrace->GetFrame(first)->sp - STACK_WORDS * sizeof(uint32_t);
295 dump_stack_segment(backtrace, log, scope_flags, &sp, STACK_WORDS, -1);
296
297 // Dump a few words from all successive frames.
298 // Only log the first 3 frames, put the rest in the tombstone.
299 for (size_t i = first; i <= last; i++) {
300 const backtrace_frame_data_t* frame = backtrace->GetFrame(i);
301 if (sp != frame->sp) {
302 _LOG(log, scope_flags, " ........ ........\n");
303 sp = frame->sp;
304 }
305 if (i - first == 3) {
306 scope_flags &= (~SCOPE_AT_FAULT);
307 }
308 if (i == last) {
309 dump_stack_segment(backtrace, log, scope_flags, &sp, STACK_WORDS, i);
310 if (sp < frame->sp + frame->stack_size) {
311 _LOG(log, scope_flags, " ........ ........\n");
312 }
313 } else {
314 size_t words = frame->stack_size / sizeof(uint32_t);
315 if (words == 0) {
316 words = 1;
317 } else if (words > STACK_WORDS) {
318 words = STACK_WORDS;
319 }
320 dump_stack_segment(backtrace, log, scope_flags, &sp, words, i);
321 }
322 }
Jeff Brown053b8652012-06-06 16:25:03 -0700323}
324
Christopher Ferris20303f82014-01-10 16:33:16 -0800325static void dump_backtrace_and_stack(Backtrace* backtrace, log_t* log, int scope_flags) {
326 if (backtrace->NumFrames()) {
327 _LOG(log, scope_flags, "\nbacktrace:\n");
328 dump_backtrace_to_log(backtrace, log, scope_flags, " ");
Jeff Brown053b8652012-06-06 16:25:03 -0700329
Christopher Ferris20303f82014-01-10 16:33:16 -0800330 _LOG(log, scope_flags, "\nstack:\n");
331 dump_stack(backtrace, log, scope_flags);
332 }
Jeff Brown053b8652012-06-06 16:25:03 -0700333}
334
Christopher Ferris46756822014-01-14 20:16:30 -0800335static void dump_map(log_t* log, const backtrace_map_t* map, const char* what, int scope_flags) {
336 if (map != NULL) {
337 _LOG(log, scope_flags, " %08x-%08x %c%c%c %s\n", map->start, map->end,
338 (map->flags & PROT_READ) ? 'r' : '-', (map->flags & PROT_WRITE) ? 'w' : '-',
339 (map->flags & PROT_EXEC) ? 'x' : '-', map->name.c_str());
Christopher Ferris20303f82014-01-10 16:33:16 -0800340 } else {
341 _LOG(log, scope_flags, " (no %s)\n", what);
342 }
Elliott Hughesd1420be2013-01-03 13:39:57 -0800343}
344
Christopher Ferris46756822014-01-14 20:16:30 -0800345static void dump_nearby_maps(BacktraceMap* map, log_t* log, pid_t tid, int scope_flags) {
Christopher Ferris20303f82014-01-10 16:33:16 -0800346 scope_flags |= SCOPE_SENSITIVE;
347 siginfo_t si;
348 memset(&si, 0, sizeof(si));
349 if (ptrace(PTRACE_GETSIGINFO, tid, 0, &si)) {
350 _LOG(log, scope_flags, "cannot get siginfo for %d: %s\n", tid, strerror(errno));
351 return;
352 }
353 if (!signal_has_address(si.si_signo)) {
354 return;
355 }
356
Christopher Ferris46756822014-01-14 20:16:30 -0800357 uintptr_t addr = reinterpret_cast<uintptr_t>(si.si_addr);
Christopher Ferris20303f82014-01-10 16:33:16 -0800358 addr &= ~0xfff; // round to 4K page boundary
359 if (addr == 0) { // null-pointer deref
360 return;
361 }
362
363 _LOG(log, scope_flags, "\nmemory map around fault addr %" PRIxPTR ":\n",
364 reinterpret_cast<uintptr_t>(si.si_addr));
365
366 // Search for a match, or for a hole where the match would be. The list
367 // is backward from the file content, so it starts at high addresses.
Christopher Ferris46756822014-01-14 20:16:30 -0800368 const backtrace_map_t* cur_map = NULL;
369 const backtrace_map_t* next_map = NULL;
370 const backtrace_map_t* prev_map = NULL;
371 for (BacktraceMap::const_iterator it = map->begin(); it != map->end(); ++it) {
372 if (addr >= it->start && addr < it->end) {
373 cur_map = &*it;
374 if (it != map->begin()) {
375 prev_map = &*(it-1);
376 }
377 if (++it != map->end()) {
378 next_map = &*it;
379 }
Christopher Ferris20303f82014-01-10 16:33:16 -0800380 break;
Jeff Brown053b8652012-06-06 16:25:03 -0700381 }
Christopher Ferris20303f82014-01-10 16:33:16 -0800382 }
Jeff Brown053b8652012-06-06 16:25:03 -0700383
Christopher Ferris46756822014-01-14 20:16:30 -0800384 // Show the map address in ascending order (like /proc/pid/maps).
385 dump_map(log, prev_map, "map below", scope_flags);
386 dump_map(log, cur_map, "map for address", scope_flags);
387 dump_map(log, next_map, "map above", scope_flags);
Jeff Brown053b8652012-06-06 16:25:03 -0700388}
389
Christopher Ferris20303f82014-01-10 16:33:16 -0800390static void dump_thread(
391 Backtrace* backtrace, log_t* log, int scope_flags, int* total_sleep_time_usec) {
392 wait_for_stop(backtrace->Tid(), total_sleep_time_usec);
Jeff Brown053b8652012-06-06 16:25:03 -0700393
Christopher Ferris20303f82014-01-10 16:33:16 -0800394 dump_registers(log, backtrace->Tid(), scope_flags);
395 dump_backtrace_and_stack(backtrace, log, scope_flags);
396 if (IS_AT_FAULT(scope_flags)) {
397 dump_memory_and_code(log, backtrace->Tid(), scope_flags);
Christopher Ferris46756822014-01-14 20:16:30 -0800398 dump_nearby_maps(backtrace->GetMap(), log, backtrace->Tid(), scope_flags);
Christopher Ferris20303f82014-01-10 16:33:16 -0800399 }
Jeff Brown053b8652012-06-06 16:25:03 -0700400}
401
Christopher Ferris20303f82014-01-10 16:33:16 -0800402// Return true if some thread is not detached cleanly
Christopher Ferris365e4ae2013-10-02 12:26:48 -0700403static bool dump_sibling_thread_report(
Christopher Ferris46756822014-01-14 20:16:30 -0800404 log_t* log, pid_t pid, pid_t tid, int* total_sleep_time_usec, BacktraceMap* map) {
Christopher Ferris20303f82014-01-10 16:33:16 -0800405 char task_path[64];
406 snprintf(task_path, sizeof(task_path), "/proc/%d/task", pid);
Jeff Brown053b8652012-06-06 16:25:03 -0700407
Christopher Ferris20303f82014-01-10 16:33:16 -0800408 DIR* d = opendir(task_path);
409 // Bail early if the task directory cannot be opened
410 if (d == NULL) {
411 XLOG("Cannot open /proc/%d/task\n", pid);
412 return false;
413 }
414
415 bool detach_failed = false;
416 struct dirent* de;
417 while ((de = readdir(d)) != NULL) {
418 // Ignore "." and ".."
419 if (!strcmp(de->d_name, ".") || !strcmp(de->d_name, "..")) {
420 continue;
Jeff Brown053b8652012-06-06 16:25:03 -0700421 }
422
Christopher Ferris20303f82014-01-10 16:33:16 -0800423 // The main thread at fault has been handled individually
424 char* end;
425 pid_t new_tid = strtoul(de->d_name, &end, 10);
426 if (*end || new_tid == tid) {
427 continue;
Jeff Brown053b8652012-06-06 16:25:03 -0700428 }
429
Christopher Ferris20303f82014-01-10 16:33:16 -0800430 // Skip this thread if cannot ptrace it
431 if (ptrace(PTRACE_ATTACH, new_tid, 0, 0) < 0) {
432 continue;
433 }
434
435 _LOG(log, 0, "--- --- --- --- --- --- --- --- --- --- --- --- --- --- --- ---\n");
436 dump_thread_info(log, pid, new_tid, 0);
437
Christopher Ferris46756822014-01-14 20:16:30 -0800438 UniquePtr<Backtrace> backtrace(Backtrace::Create(pid, new_tid, map));
Christopher Ferris20303f82014-01-10 16:33:16 -0800439 if (backtrace->Unwind(0)) {
440 dump_thread(backtrace.get(), log, 0, total_sleep_time_usec);
441 }
442
443 if (ptrace(PTRACE_DETACH, new_tid, 0, 0) != 0) {
444 LOG("ptrace detach from %d failed: %s\n", new_tid, strerror(errno));
445 detach_failed = true;
446 }
447 }
448
449 closedir(d);
450 return detach_failed;
Jeff Brown053b8652012-06-06 16:25:03 -0700451}
452
Christopher Ferris20303f82014-01-10 16:33:16 -0800453// Reads the contents of the specified log device, filters out the entries
454// that don't match the specified pid, and writes them to the tombstone file.
455//
456// If "tailOnly" is set, we only print the last few lines.
457static void dump_log_file(log_t* log, pid_t pid, const char* filename, bool tailOnly) {
458 bool first = true;
Jeff Brown053b8652012-06-06 16:25:03 -0700459
Christopher Ferris20303f82014-01-10 16:33:16 -0800460 // circular buffer, for "tailOnly" mode
461 const int kShortLogMaxLines = 5;
462 const int kShortLogLineLen = 256;
463 char shortLog[kShortLogMaxLines][kShortLogLineLen];
464 int shortLogCount = 0;
465 int shortLogNext = 0;
Jeff Brown053b8652012-06-06 16:25:03 -0700466
Christopher Ferris20303f82014-01-10 16:33:16 -0800467 int logfd = open(filename, O_RDONLY | O_NONBLOCK);
468 if (logfd < 0) {
469 XLOG("Unable to open %s: %s\n", filename, strerror(errno));
470 return;
471 }
472
473 union {
474 unsigned char buf[LOGGER_ENTRY_MAX_LEN + 1];
475 struct logger_entry entry;
476 } log_entry;
477
478 while (true) {
479 ssize_t actual = read(logfd, log_entry.buf, LOGGER_ENTRY_MAX_LEN);
480 if (actual < 0) {
481 if (errno == EINTR) {
482 // interrupted by signal, retry
483 continue;
484 } else if (errno == EAGAIN) {
485 // non-blocking EOF; we're done
486 break;
487 } else {
488 _LOG(log, 0, "Error while reading log: %s\n", strerror(errno));
489 break;
490 }
491 } else if (actual == 0) {
492 _LOG(log, 0, "Got zero bytes while reading log: %s\n", strerror(errno));
493 break;
Jeff Brown053b8652012-06-06 16:25:03 -0700494 }
495
Christopher Ferris20303f82014-01-10 16:33:16 -0800496 // NOTE: if you XLOG something here, this will spin forever,
497 // because you will be writing as fast as you're reading. Any
498 // high-frequency debug diagnostics should just be written to
499 // the tombstone file.
500 struct logger_entry* entry = &log_entry.entry;
Jeff Brown053b8652012-06-06 16:25:03 -0700501
Christopher Ferris20303f82014-01-10 16:33:16 -0800502 if (entry->pid != static_cast<int32_t>(pid)) {
503 // wrong pid, ignore
504 continue;
Jeff Brown053b8652012-06-06 16:25:03 -0700505 }
506
Christopher Ferris20303f82014-01-10 16:33:16 -0800507 if (first) {
508 _LOG(log, 0, "--------- %slog %s\n", tailOnly ? "tail end of " : "", filename);
509 first = false;
510 }
511
512 // Msg format is: <priority:1><tag:N>\0<message:N>\0
513 //
514 // We want to display it in the same format as "logcat -v threadtime"
515 // (although in this case the pid is redundant).
516 //
517 // TODO: scan for line breaks ('\n') and display each text line
518 // on a separate line, prefixed with the header, like logcat does.
519 static const char* kPrioChars = "!.VDIWEFS";
520 unsigned char prio = entry->msg[0];
521 char* tag = entry->msg + 1;
522 char* msg = tag + strlen(tag) + 1;
523
524 // consume any trailing newlines
525 char* eatnl = msg + strlen(msg) - 1;
526 while (eatnl >= msg && *eatnl == '\n') {
527 *eatnl-- = '\0';
528 }
529
530 char prioChar = (prio < strlen(kPrioChars) ? kPrioChars[prio] : '?');
531
532 char timeBuf[32];
533 time_t sec = static_cast<time_t>(entry->sec);
534 struct tm tmBuf;
535 struct tm* ptm;
536 ptm = localtime_r(&sec, &tmBuf);
537 strftime(timeBuf, sizeof(timeBuf), "%m-%d %H:%M:%S", ptm);
538
Jeff Brown053b8652012-06-06 16:25:03 -0700539 if (tailOnly) {
Christopher Ferris20303f82014-01-10 16:33:16 -0800540 snprintf(shortLog[shortLogNext], kShortLogLineLen,
541 "%s.%03d %5d %5d %c %-8s: %s",
542 timeBuf, entry->nsec / 1000000, entry->pid, entry->tid,
543 prioChar, tag, msg);
544 shortLogNext = (shortLogNext + 1) % kShortLogMaxLines;
545 shortLogCount++;
546 } else {
547 _LOG(log, 0, "%s.%03d %5d %5d %c %-8s: %s\n",
548 timeBuf, entry->nsec / 1000000, entry->pid, entry->tid, prioChar, tag, msg);
549 }
550 }
Jeff Brown053b8652012-06-06 16:25:03 -0700551
Christopher Ferris20303f82014-01-10 16:33:16 -0800552 if (tailOnly) {
553 int i;
Jeff Brown053b8652012-06-06 16:25:03 -0700554
Christopher Ferris20303f82014-01-10 16:33:16 -0800555 // If we filled the buffer, we want to start at "next", which has
556 // the oldest entry. If we didn't, we want to start at zero.
557 if (shortLogCount < kShortLogMaxLines) {
558 shortLogNext = 0;
559 } else {
560 shortLogCount = kShortLogMaxLines; // cap at window size
Jeff Brown053b8652012-06-06 16:25:03 -0700561 }
562
Christopher Ferris20303f82014-01-10 16:33:16 -0800563 for (i = 0; i < shortLogCount; i++) {
564 _LOG(log, 0, "%s\n", shortLog[shortLogNext]);
565 shortLogNext = (shortLogNext + 1) % kShortLogMaxLines;
566 }
567 }
568
569 close(logfd);
Jeff Brown053b8652012-06-06 16:25:03 -0700570}
571
Christopher Ferris20303f82014-01-10 16:33:16 -0800572// Dumps the logs generated by the specified pid to the tombstone, from both
573// "system" and "main" log devices. Ideally we'd interleave the output.
574static void dump_logs(log_t* log, pid_t pid, bool tailOnly) {
575 dump_log_file(log, pid, "/dev/log/system", tailOnly);
576 dump_log_file(log, pid, "/dev/log/main", tailOnly);
Jeff Brown053b8652012-06-06 16:25:03 -0700577}
578
Christopher Ferris20303f82014-01-10 16:33:16 -0800579static void dump_abort_message(Backtrace* backtrace, log_t* log, uintptr_t address) {
Elliott Hughese5f8a692013-04-04 13:52:01 -0700580 if (address == 0) {
581 return;
582 }
583
584 address += sizeof(size_t); // Skip the buffer length.
585
586 char msg[512];
587 memset(msg, 0, sizeof(msg));
588 char* p = &msg[0];
589 while (p < &msg[sizeof(msg)]) {
590 uint32_t data;
Christopher Ferris20303f82014-01-10 16:33:16 -0800591 if (!backtrace->ReadWord(address, &data)) {
Elliott Hughese5f8a692013-04-04 13:52:01 -0700592 break;
593 }
594 address += sizeof(uint32_t);
595
596 if ((*p++ = (data >> 0) & 0xff) == 0) {
597 break;
598 }
599 if ((*p++ = (data >> 8) & 0xff) == 0) {
600 break;
601 }
602 if ((*p++ = (data >> 16) & 0xff) == 0) {
603 break;
604 }
605 if ((*p++ = (data >> 24) & 0xff) == 0) {
606 break;
607 }
608 }
609 msg[sizeof(msg) - 1] = '\0';
610
Christopher Tate7716aef2013-04-02 14:00:27 -0700611 _LOG(log, SCOPE_AT_FAULT, "Abort message: '%s'\n", msg);
Elliott Hughese5f8a692013-04-04 13:52:01 -0700612}
613
Christopher Ferris20303f82014-01-10 16:33:16 -0800614// Dumps all information about the specified pid to the tombstone.
Elliott Hughese5f8a692013-04-04 13:52:01 -0700615static bool dump_crash(log_t* log, pid_t pid, pid_t tid, int signal, uintptr_t abort_msg_address,
Christopher Ferris20303f82014-01-10 16:33:16 -0800616 bool dump_sibling_threads, int* total_sleep_time_usec) {
617 // don't copy log messages to tombstone unless this is a dev device
618 char value[PROPERTY_VALUE_MAX];
619 property_get("ro.debuggable", value, "0");
620 bool want_logs = (value[0] == '1');
Jeff Brown053b8652012-06-06 16:25:03 -0700621
Christopher Ferris20303f82014-01-10 16:33:16 -0800622 if (log->amfd >= 0) {
623 // Activity Manager protocol: binary 32-bit network-byte-order ints for the
624 // pid and signal number, followed by the raw text of the dump, culminating
625 // in a zero byte that marks end-of-data.
626 uint32_t datum = htonl(pid);
627 TEMP_FAILURE_RETRY( write(log->amfd, &datum, 4) );
628 datum = htonl(signal);
629 TEMP_FAILURE_RETRY( write(log->amfd, &datum, 4) );
630 }
Christopher Tateded2e5a2013-03-19 13:12:23 -0700631
Christopher Ferris20303f82014-01-10 16:33:16 -0800632 _LOG(log, SCOPE_AT_FAULT,
633 "*** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***\n");
634 dump_build_info(log);
635 dump_revision_info(log);
636 dump_thread_info(log, pid, tid, SCOPE_AT_FAULT);
637 if (signal) {
638 dump_fault_addr(log, tid, signal);
639 }
Jeff Brown053b8652012-06-06 16:25:03 -0700640
Christopher Ferris46756822014-01-14 20:16:30 -0800641 BacktraceMap* map = NULL;
642 UniquePtr<Backtrace> backtrace(Backtrace::Create(pid, tid));
Christopher Ferris20303f82014-01-10 16:33:16 -0800643 if (backtrace->Unwind(0)) {
Christopher Ferris46756822014-01-14 20:16:30 -0800644 // Grab the map that was created and share it with the siblings.
645 map = backtrace->TakeMapOwnership();
646
Christopher Ferris20303f82014-01-10 16:33:16 -0800647 dump_abort_message(backtrace.get(), log, abort_msg_address);
648 dump_thread(backtrace.get(), log, SCOPE_AT_FAULT, total_sleep_time_usec);
649 }
Jeff Brown053b8652012-06-06 16:25:03 -0700650
Christopher Ferris20303f82014-01-10 16:33:16 -0800651 if (want_logs) {
652 dump_logs(log, pid, true);
653 }
Jeff Brown053b8652012-06-06 16:25:03 -0700654
Christopher Ferris20303f82014-01-10 16:33:16 -0800655 bool detach_failed = false;
656 if (dump_sibling_threads) {
Christopher Ferris46756822014-01-14 20:16:30 -0800657 detach_failed = dump_sibling_thread_report(log, pid, tid, total_sleep_time_usec, map);
Christopher Ferris20303f82014-01-10 16:33:16 -0800658 }
Christopher Ferris98464972014-01-06 19:16:33 -0800659
Christopher Ferris46756822014-01-14 20:16:30 -0800660 // Destroy the BacktraceMap object.
661 delete map;
Christopher Tateded2e5a2013-03-19 13:12:23 -0700662
Christopher Ferris20303f82014-01-10 16:33:16 -0800663 if (want_logs) {
664 dump_logs(log, pid, false);
665 }
Christopher Tateded2e5a2013-03-19 13:12:23 -0700666
Christopher Ferris20303f82014-01-10 16:33:16 -0800667 // send EOD to the Activity Manager, then wait for its ack to avoid racing ahead
668 // and killing the target out from under it
669 if (log->amfd >= 0) {
670 uint8_t eodMarker = 0;
671 TEMP_FAILURE_RETRY( write(log->amfd, &eodMarker, 1) );
672 // 3 sec timeout reading the ack; we're fine if that happens
673 TEMP_FAILURE_RETRY( read(log->amfd, &eodMarker, 1) );
674 }
675
676 return detach_failed;
Jeff Brown053b8652012-06-06 16:25:03 -0700677}
678
Christopher Ferris20303f82014-01-10 16:33:16 -0800679// find_and_open_tombstone - find an available tombstone slot, if any, of the
680// form tombstone_XX where XX is 00 to MAX_TOMBSTONES-1, inclusive. If no
681// file is available, we reuse the least-recently-modified file.
682//
683// Returns the path of the tombstone file, allocated using malloc(). Caller must free() it.
684static char* find_and_open_tombstone(int* fd) {
685 unsigned long mtime = ULONG_MAX;
686 struct stat sb;
Jeff Brown053b8652012-06-06 16:25:03 -0700687
Christopher Ferris20303f82014-01-10 16:33:16 -0800688 // XXX: Our stat.st_mtime isn't time_t. If it changes, as it probably ought
689 // to, our logic breaks. This check will generate a warning if that happens.
690 typecheck(mtime, sb.st_mtime);
Jeff Brown053b8652012-06-06 16:25:03 -0700691
Christopher Ferris20303f82014-01-10 16:33:16 -0800692 // In a single wolf-like pass, find an available slot and, in case none
693 // exist, find and record the least-recently-modified file.
694 char path[128];
695 int oldest = 0;
696 for (int i = 0; i < MAX_TOMBSTONES; i++) {
697 snprintf(path, sizeof(path), TOMBSTONE_DIR"/tombstone_%02d", i);
Jeff Brown053b8652012-06-06 16:25:03 -0700698
Christopher Ferris20303f82014-01-10 16:33:16 -0800699 if (!stat(path, &sb)) {
700 if (sb.st_mtime < mtime) {
701 oldest = i;
702 mtime = sb.st_mtime;
703 }
704 continue;
Jeff Brown053b8652012-06-06 16:25:03 -0700705 }
Christopher Ferris20303f82014-01-10 16:33:16 -0800706 if (errno != ENOENT)
707 continue;
Jeff Brown053b8652012-06-06 16:25:03 -0700708
Christopher Ferris20303f82014-01-10 16:33:16 -0800709 *fd = open(path, O_CREAT | O_EXCL | O_WRONLY, 0600);
710 if (*fd < 0)
711 continue; // raced ?
712
Jeff Brown053b8652012-06-06 16:25:03 -0700713 fchown(*fd, AID_SYSTEM, AID_SYSTEM);
714 return strdup(path);
Christopher Ferris20303f82014-01-10 16:33:16 -0800715 }
716
717 // we didn't find an available file, so we clobber the oldest one
718 snprintf(path, sizeof(path), TOMBSTONE_DIR"/tombstone_%02d", oldest);
719 *fd = open(path, O_CREAT | O_TRUNC | O_WRONLY, 0600);
720 if (*fd < 0) {
721 LOG("failed to open tombstone file '%s': %s\n", path, strerror(errno));
722 return NULL;
723 }
724 fchown(*fd, AID_SYSTEM, AID_SYSTEM);
725 return strdup(path);
Jeff Brown053b8652012-06-06 16:25:03 -0700726}
727
Christopher Tateded2e5a2013-03-19 13:12:23 -0700728static int activity_manager_connect() {
Christopher Ferris20303f82014-01-10 16:33:16 -0800729 int amfd = socket(PF_UNIX, SOCK_STREAM, 0);
730 if (amfd >= 0) {
731 struct sockaddr_un address;
732 int err;
Christopher Tateded2e5a2013-03-19 13:12:23 -0700733
Christopher Ferris20303f82014-01-10 16:33:16 -0800734 memset(&address, 0, sizeof(address));
735 address.sun_family = AF_UNIX;
736 strncpy(address.sun_path, NCRASH_SOCKET_PATH, sizeof(address.sun_path));
737 err = TEMP_FAILURE_RETRY(connect(
738 amfd, reinterpret_cast<struct sockaddr*>(&address), sizeof(address)));
739 if (!err) {
740 struct timeval tv;
741 memset(&tv, 0, sizeof(tv));
742 tv.tv_sec = 1; // tight leash
743 err = setsockopt(amfd, SOL_SOCKET, SO_SNDTIMEO, &tv, sizeof(tv));
744 if (!err) {
745 tv.tv_sec = 3; // 3 seconds on handshake read
746 err = setsockopt(amfd, SOL_SOCKET, SO_RCVTIMEO, &tv, sizeof(tv));
747 }
Christopher Tateded2e5a2013-03-19 13:12:23 -0700748 }
Christopher Ferris20303f82014-01-10 16:33:16 -0800749 if (err) {
750 close(amfd);
751 amfd = -1;
752 }
753 }
Christopher Tateded2e5a2013-03-19 13:12:23 -0700754
Christopher Ferris20303f82014-01-10 16:33:16 -0800755 return amfd;
Christopher Tateded2e5a2013-03-19 13:12:23 -0700756}
757
Christopher Ferris20303f82014-01-10 16:33:16 -0800758char* engrave_tombstone(
759 pid_t pid, pid_t tid, int signal, uintptr_t abort_msg_address, bool dump_sibling_threads,
760 bool quiet, bool* detach_failed, int* total_sleep_time_usec) {
761 mkdir(TOMBSTONE_DIR, 0755);
762 chown(TOMBSTONE_DIR, AID_SYSTEM, AID_SYSTEM);
Jeff Brown053b8652012-06-06 16:25:03 -0700763
Christopher Ferris20303f82014-01-10 16:33:16 -0800764 if (selinux_android_restorecon(TOMBSTONE_DIR) == -1) {
765 *detach_failed = false;
766 return NULL;
767 }
rpcraigf1186f32012-07-19 09:38:06 -0400768
Christopher Ferris20303f82014-01-10 16:33:16 -0800769 int fd;
770 char* path = find_and_open_tombstone(&fd);
771 if (!path) {
772 *detach_failed = false;
773 return NULL;
774 }
Jeff Brown053b8652012-06-06 16:25:03 -0700775
Christopher Ferris20303f82014-01-10 16:33:16 -0800776 log_t log;
777 log.tfd = fd;
778 log.amfd = activity_manager_connect();
779 log.quiet = quiet;
780 *detach_failed = dump_crash(
781 &log, pid, tid, signal, abort_msg_address, dump_sibling_threads, total_sleep_time_usec);
Jeff Brown053b8652012-06-06 16:25:03 -0700782
Christopher Ferris20303f82014-01-10 16:33:16 -0800783 close(log.amfd);
784 close(fd);
785 return path;
Jeff Brown053b8652012-06-06 16:25:03 -0700786}