047cc0729f
- Cleanup resulting from experience and feedback - When filtering inside logd, drop any leading expire messages, they are cluttering up leading edge of tombstones (which filter by pid) - Increase and introduce EXPIRE_RATELIMIT from 1 to 10 seconds - Increase EXPIRE_THRESHOLD from 4 to 10 count - Improve the expire messages from: logd : uid=1000(system) too chatty comm=com.google.android.phone, expire 2800 lines change tag to be more descriptive, and reduce accusatory tone to: chatty : uid=1000(system) com.google.android.phone expire 2800 lines - if the UID name forms a prefix for comm name, then drop UID name Change-Id: Ied7cc04c0ab3ae02167649a0b97378e44ef7b588
263 lines
6.1 KiB
C++
263 lines
6.1 KiB
C++
/*
|
|
* Copyright (C) 2014 The Android Open Source Project
|
|
*
|
|
* Licensed under the Apache License, Version 2.0 (the "License");
|
|
* you may not use this file except in compliance with the License.
|
|
* You may obtain a copy of the License at
|
|
*
|
|
* http://www.apache.org/licenses/LICENSE-2.0
|
|
*
|
|
* Unless required by applicable law or agreed to in writing, software
|
|
* distributed under the License is distributed on an "AS IS" BASIS,
|
|
* WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
|
|
* See the License for the specific language governing permissions and
|
|
* limitations under the License.
|
|
*/
|
|
|
|
#include <sys/prctl.h>
|
|
|
|
#include "FlushCommand.h"
|
|
#include "LogBuffer.h"
|
|
#include "LogTimes.h"
|
|
#include "LogReader.h"
|
|
|
|
pthread_mutex_t LogTimeEntry::timesLock = PTHREAD_MUTEX_INITIALIZER;
|
|
|
|
LogTimeEntry::LogTimeEntry(LogReader &reader, SocketClient *client,
|
|
bool nonBlock, unsigned long tail,
|
|
unsigned int logMask, pid_t pid,
|
|
uint64_t start) :
|
|
mRefCount(1),
|
|
mRelease(false),
|
|
mError(false),
|
|
threadRunning(false),
|
|
leadingDropped(false),
|
|
mReader(reader),
|
|
mLogMask(logMask),
|
|
mPid(pid),
|
|
mCount(0),
|
|
mTail(tail),
|
|
mIndex(0),
|
|
mClient(client),
|
|
mStart(start),
|
|
mNonBlock(nonBlock),
|
|
mEnd(LogBufferElement::getCurrentSequence()) {
|
|
pthread_cond_init(&threadTriggeredCondition, NULL);
|
|
cleanSkip_Locked();
|
|
}
|
|
|
|
void LogTimeEntry::startReader_Locked(void) {
|
|
pthread_attr_t attr;
|
|
|
|
threadRunning = true;
|
|
|
|
if (!pthread_attr_init(&attr)) {
|
|
if (!pthread_attr_setdetachstate(&attr, PTHREAD_CREATE_DETACHED)) {
|
|
if (!pthread_create(&mThread, &attr,
|
|
LogTimeEntry::threadStart, this)) {
|
|
pthread_attr_destroy(&attr);
|
|
return;
|
|
}
|
|
}
|
|
pthread_attr_destroy(&attr);
|
|
}
|
|
threadRunning = false;
|
|
if (mClient) {
|
|
mClient->decRef();
|
|
}
|
|
decRef_Locked();
|
|
}
|
|
|
|
void LogTimeEntry::threadStop(void *obj) {
|
|
LogTimeEntry *me = reinterpret_cast<LogTimeEntry *>(obj);
|
|
|
|
lock();
|
|
|
|
if (me->mNonBlock) {
|
|
me->error_Locked();
|
|
}
|
|
|
|
SocketClient *client = me->mClient;
|
|
|
|
if (me->isError_Locked()) {
|
|
LogReader &reader = me->mReader;
|
|
LastLogTimes × = reader.logbuf().mTimes;
|
|
|
|
LastLogTimes::iterator it = times.begin();
|
|
while(it != times.end()) {
|
|
if (*it == me) {
|
|
times.erase(it);
|
|
me->release_Locked();
|
|
break;
|
|
}
|
|
it++;
|
|
}
|
|
|
|
me->mClient = NULL;
|
|
reader.release(client);
|
|
}
|
|
|
|
if (client) {
|
|
client->decRef();
|
|
}
|
|
|
|
me->threadRunning = false;
|
|
me->decRef_Locked();
|
|
|
|
unlock();
|
|
}
|
|
|
|
void *LogTimeEntry::threadStart(void *obj) {
|
|
prctl(PR_SET_NAME, "logd.reader.per");
|
|
|
|
LogTimeEntry *me = reinterpret_cast<LogTimeEntry *>(obj);
|
|
|
|
pthread_cleanup_push(threadStop, obj);
|
|
|
|
SocketClient *client = me->mClient;
|
|
if (!client) {
|
|
me->error();
|
|
return NULL;
|
|
}
|
|
|
|
LogBuffer &logbuf = me->mReader.logbuf();
|
|
|
|
bool privileged = FlushCommand::hasReadLogs(client);
|
|
|
|
me->leadingDropped = true;
|
|
|
|
lock();
|
|
|
|
while (me->threadRunning && !me->isError_Locked()) {
|
|
uint64_t start = me->mStart;
|
|
|
|
unlock();
|
|
|
|
if (me->mTail) {
|
|
logbuf.flushTo(client, start, privileged, FilterFirstPass, me);
|
|
me->leadingDropped = true;
|
|
}
|
|
start = logbuf.flushTo(client, start, privileged, FilterSecondPass, me);
|
|
|
|
lock();
|
|
|
|
if (start == LogBufferElement::FLUSH_ERROR) {
|
|
me->error_Locked();
|
|
}
|
|
|
|
if (me->mNonBlock || !me->threadRunning || me->isError_Locked()) {
|
|
break;
|
|
}
|
|
|
|
me->cleanSkip_Locked();
|
|
|
|
pthread_cond_wait(&me->threadTriggeredCondition, ×Lock);
|
|
}
|
|
|
|
unlock();
|
|
|
|
pthread_cleanup_pop(true);
|
|
|
|
return NULL;
|
|
}
|
|
|
|
// A first pass to count the number of elements
|
|
int LogTimeEntry::FilterFirstPass(const LogBufferElement *element, void *obj) {
|
|
LogTimeEntry *me = reinterpret_cast<LogTimeEntry *>(obj);
|
|
|
|
LogTimeEntry::lock();
|
|
|
|
if (me->leadingDropped) {
|
|
if (element->getDropped()) {
|
|
LogTimeEntry::unlock();
|
|
return false;
|
|
}
|
|
me->leadingDropped = false;
|
|
}
|
|
|
|
if (me->mCount == 0) {
|
|
me->mStart = element->getSequence();
|
|
}
|
|
|
|
if ((!me->mPid || (me->mPid == element->getPid()))
|
|
&& (me->isWatching(element->getLogId()))) {
|
|
++me->mCount;
|
|
}
|
|
|
|
LogTimeEntry::unlock();
|
|
|
|
return false;
|
|
}
|
|
|
|
// A second pass to send the selected elements
|
|
int LogTimeEntry::FilterSecondPass(const LogBufferElement *element, void *obj) {
|
|
LogTimeEntry *me = reinterpret_cast<LogTimeEntry *>(obj);
|
|
|
|
LogTimeEntry::lock();
|
|
|
|
me->mStart = element->getSequence();
|
|
|
|
if (me->skipAhead[element->getLogId()]) {
|
|
me->skipAhead[element->getLogId()]--;
|
|
goto skip;
|
|
}
|
|
|
|
if (me->leadingDropped) {
|
|
if (element->getDropped()) {
|
|
goto skip;
|
|
}
|
|
me->leadingDropped = false;
|
|
}
|
|
|
|
// Truncate to close race between first and second pass
|
|
if (me->mNonBlock && me->mTail && (me->mIndex >= me->mCount)) {
|
|
goto stop;
|
|
}
|
|
|
|
if (!me->isWatching(element->getLogId())) {
|
|
goto skip;
|
|
}
|
|
|
|
if (me->mPid && (me->mPid != element->getPid())) {
|
|
goto skip;
|
|
}
|
|
|
|
if (me->isError_Locked()) {
|
|
goto stop;
|
|
}
|
|
|
|
if (!me->mTail) {
|
|
goto ok;
|
|
}
|
|
|
|
++me->mIndex;
|
|
|
|
if ((me->mCount > me->mTail) && (me->mIndex <= (me->mCount - me->mTail))) {
|
|
goto skip;
|
|
}
|
|
|
|
if (!me->mNonBlock) {
|
|
me->mTail = 0;
|
|
}
|
|
|
|
ok:
|
|
if (!me->skipAhead[element->getLogId()]) {
|
|
LogTimeEntry::unlock();
|
|
return true;
|
|
}
|
|
// FALLTHRU
|
|
|
|
skip:
|
|
LogTimeEntry::unlock();
|
|
return false;
|
|
|
|
stop:
|
|
LogTimeEntry::unlock();
|
|
return -1;
|
|
}
|
|
|
|
void LogTimeEntry::cleanSkip_Locked(void) {
|
|
for (log_id_t i = LOG_ID_MIN; i < LOG_ID_MAX; i = (log_id_t) (i + 1)) {
|
|
skipAhead[i] = 0;
|
|
}
|
|
}
|