passenger passenger_log_file 日志分析

最新推荐文章于 2023-05-17 17:14:42 发布

weixin_33775582

最新推荐文章于 2023-05-17 17:14:42 发布

阅读量496

点赞数

文章标签： c/c++ python

原文链接：https://my.oschina.net/monkeyzhu/blog/595321

版权

2019独角兽企业重金招聘Python工程师标准>>>

`passenger passenger_log_file 日志分析`

通过日志来分析相关逻辑及调优，主要使用正则表达式来找出具体源文件位置。

App pid stdout 正则表达式`App.+?stdout`

日志输出：
App 7375 stdout: 
App 7383 stdout: 
App 7391 stdout: 
App 7401 stdout:

在Spawner.h中

string readMessageLine(Details &details) {
    TRACE_POINT();
    while (true) {
        string result = details.io.readLine(1024 * 4, &details.timeout);
        string line = result;
        if (!line.empty() && line[line.size() - 1] == '\n') {
            line.erase(line.size() - 1, 1);
        }

        if (result.empty()) {
            // EOF
            return result;
        } else if (startsWith(result, "!> ")) {
            P_DEBUG("[App " << details.pid << " stdout] " << line);
            result.erase(0, sizeof("!> ") - 1);
            return result;
        } else {
            if (details.stderrCapturer != NULL) {
                details.stderrCapturer->appendToBuffer(result);
            }
            printAppOutput(details.pid, "stdout", line.data(), line.size());
        }
    }
}

通过文件名和代码内容能看出为spawn进程时所产生日志。

Disconnecting long-running connections for process 20545`正则表达式Disconnecting long-running connections for process`

static void
abortLongRunningConnections(const ApplicationPool2::ProcessPtr &process) {
    // We are inside the ApplicationPool lock. Be very careful here.
    WorkingObjects *wo = workingObjects;
    P_NOTICE("Disconnecting long-running connections for process " <<
        process->getPid() << ", application " << process->getGroup()->getName());
    for (unsigned int i = 0; i < wo->threadWorkingObjects.size(); i++) {
        wo->threadWorkingObjects[i].bgloop->safe->runLater(
            boost::bind(abortLongRunningConnectionsOnController,
                wo->threadWorkingObjects[i].controller,
                process->getGupid().toString()));
    }
}

通过函数名和逻辑可判断为进程在达到最大空闲时间后，被kill进程时输出的日志。

Returning HTTP 503 due to: Request queue full (configured max. size: 100) `Returning HTTP`

在CheckoutSession.cpp文件中

void
Controller::writeRequestQueueFullExceptionErrorResponse(Client *client, Request *req,
    const boost::shared_ptr<RequestQueueFullException> &e)
{
    TRACE_POINT();
    const LString *value = req->secureHeaders.lookup(
        "!~PASSENGER_REQUEST_QUEUE_OVERFLOW_STATUS_CODE");
    int requestQueueOverflowStatusCode = 503;
    if (value != NULL && value->size > 0) {
        value = psg_lstr_make_contiguous(value, req->pool);
        requestQueueOverflowStatusCode = stringToInt(
            StaticString(value->start->data, value->size));
    }

    SKC_WARN(client, "Returning HTTP " << requestQueueOverflowStatusCode <<
        " due to: " << e->what());

    endRequestWithSimpleResponse(&client, &req,
        "<h2>This website is under heavy load (queue full)</h2>"
        "<p>We're sorry, too many people are accessing this website at the same "
        "time. We're working on this problem. Please try again later.</p>",
        requestQueueOverflowStatusCode);
}

明显此处Request queue full，并且返回给用户This website is under heavy load的页面，默认为最大为100，具体可以查看官方文档。注意此处为达到最大的队列大小的原因是什么如果确实是请求并发高，可以加大该队列大小，但是如果为慢查询连接未被释放，则需要自己查看原因，而不是盲目加大该参数。

转载于:https://my.oschina.net/monkeyzhu/blog/595321