nghttp2/src/shrpx_log.h

305 lines
8.7 KiB
C
Raw Normal View History

/*
2014-03-30 12:09:21 +02:00
* nghttp2 - HTTP/2 C Library
*
* Copyright (c) 2012 Tatsuhiro Tsujikawa
*
* Permission is hereby granted, free of charge, to any person obtaining
* a copy of this software and associated documentation files (the
* "Software"), to deal in the Software without restriction, including
* without limitation the rights to use, copy, modify, merge, publish,
* distribute, sublicense, and/or sell copies of the Software, and to
* permit persons to whom the Software is furnished to do so, subject to
* the following conditions:
*
* The above copyright notice and this permission notice shall be
* included in all copies or substantial portions of the Software.
*
* THE SOFTWARE IS PROVIDED "AS IS", WITHOUT WARRANTY OF ANY KIND,
* EXPRESS OR IMPLIED, INCLUDING BUT NOT LIMITED TO THE WARRANTIES OF
* MERCHANTABILITY, FITNESS FOR A PARTICULAR PURPOSE AND
* NONINFRINGEMENT. IN NO EVENT SHALL THE AUTHORS OR COPYRIGHT HOLDERS BE
* LIABLE FOR ANY CLAIM, DAMAGES OR OTHER LIABILITY, WHETHER IN AN ACTION
* OF CONTRACT, TORT OR OTHERWISE, ARISING FROM, OUT OF OR IN CONNECTION
* WITH THE SOFTWARE OR THE USE OR OTHER DEALINGS IN THE SOFTWARE.
*/
#ifndef SHRPX_LOG_H
#define SHRPX_LOG_H
#include "shrpx.h"
#include <sys/types.h>
#include <memory>
#include <vector>
#include <chrono>
#include "shrpx_config.h"
#include "shrpx_log_config.h"
#include "tls.h"
2016-01-17 03:19:19 +01:00
#include "template.h"
#include "util.h"
2016-01-17 03:19:19 +01:00
using namespace nghttp2;
#define ENABLE_LOG 1
2015-10-17 04:52:33 +02:00
#define LOG_ENABLED(SEVERITY) (ENABLE_LOG && shrpx::Log::log_enabled(SEVERITY))
2015-10-17 04:52:33 +02:00
#define LOG(SEVERITY) shrpx::Log(SEVERITY, __FILE__, __LINE__)
// Listener log
2014-11-27 15:39:04 +01:00
#define LLOG(SEVERITY, LISTEN) \
2015-10-17 04:52:33 +02:00
(shrpx::Log(SEVERITY, __FILE__, __LINE__) << "[LISTEN:" << LISTEN << "] ")
// Worker log
#define WLOG(SEVERITY, WORKER) \
2015-10-17 04:52:33 +02:00
(shrpx::Log(SEVERITY, __FILE__, __LINE__) << "[WORKER:" << WORKER << "] ")
// ClientHandler log
2014-11-27 15:39:04 +01:00
#define CLOG(SEVERITY, CLIENT_HANDLER) \
2015-10-17 04:52:33 +02:00
(shrpx::Log(SEVERITY, __FILE__, __LINE__) \
<< "[CLIENT_HANDLER:" << CLIENT_HANDLER << "] ")
// Upstream log
2014-11-27 15:39:04 +01:00
#define ULOG(SEVERITY, UPSTREAM) \
2017-11-23 06:19:12 +01:00
(shrpx::Log(SEVERITY, __FILE__, __LINE__) << "[UPSTREAM:" << UPSTREAM \
<< "]" \
" ")
// Downstream log
2014-11-27 15:39:04 +01:00
#define DLOG(SEVERITY, DOWNSTREAM) \
2017-04-30 08:45:53 +02:00
(shrpx::Log(SEVERITY, __FILE__, __LINE__) \
<< "[DOWNSTREAM:" << DOWNSTREAM << "] ")
// Downstream connection log
2014-11-27 15:39:04 +01:00
#define DCLOG(SEVERITY, DCONN) \
2015-10-17 04:52:33 +02:00
(shrpx::Log(SEVERITY, __FILE__, __LINE__) << "[DCONN:" << DCONN << "] ")
// Downstream HTTP2 session log
2014-11-27 15:39:04 +01:00
#define SSLOG(SEVERITY, HTTP2) \
2015-10-17 04:52:33 +02:00
(shrpx::Log(SEVERITY, __FILE__, __LINE__) << "[DHTTP2:" << HTTP2 << "] ")
// Memcached connection log
#define MCLOG(SEVERITY, MCONN) \
2015-10-17 04:52:33 +02:00
(shrpx::Log(SEVERITY, __FILE__, __LINE__) << "[MCONN:" << MCONN << "] ")
namespace shrpx {
class Downstream;
struct DownstreamAddr;
2014-11-27 15:39:04 +01:00
enum SeverityLevel { INFO, NOTICE, WARN, ERROR, FATAL };
using LogBuffer = std::array<uint8_t, 4_k>;
class Log {
public:
Log(int severity, const char *filename, int linenum);
~Log();
Log &operator<<(const std::string &s);
Log &operator<<(const char *s);
Log &operator<<(const StringRef &s);
Log &operator<<(const ImmutableString &s);
Log &operator<<(short n) { return *this << static_cast<long long>(n); }
Log &operator<<(int n) { return *this << static_cast<long long>(n); }
Log &operator<<(long n) { return *this << static_cast<long long>(n); }
Log &operator<<(long long n);
Log &operator<<(unsigned short n) {
return *this << static_cast<unsigned long long>(n);
}
Log &operator<<(unsigned int n) {
return *this << static_cast<unsigned long long>(n);
}
Log &operator<<(unsigned long n) {
return *this << static_cast<unsigned long long>(n);
}
Log &operator<<(unsigned long long n);
Log &operator<<(float n) { return *this << static_cast<double>(n); }
Log &operator<<(double n);
Log &operator<<(long double n);
Log &operator<<(bool n);
Log &operator<<(const void *p);
template <typename T> Log &operator<<(const std::shared_ptr<T> &ptr) {
return *this << ptr.get();
}
Log &operator<<(void (*func)(Log &log)) {
func(*this);
return *this;
}
template <typename InputIt> void write_seq(InputIt first, InputIt last) {
if (full_) {
return;
}
auto d = std::distance(first, last);
auto n = std::min(wleft(), static_cast<size_t>(d));
last_ = std::copy(first, first + n, last_);
update_full();
}
template <typename T> void write_hex(T n) {
if (full_) {
return;
}
if (n == 0) {
if (wleft() < 4 /* for "0x00" */) {
full_ = true;
return;
}
*last_++ = '0';
*last_++ = 'x';
*last_++ = '0';
*last_++ = '0';
update_full();
return;
}
size_t nlen = 0;
for (auto t = n; t; t >>= 8, ++nlen)
;
nlen *= 2;
if (wleft() < 2 /* for "0x" */ + nlen) {
full_ = true;
return;
}
*last_++ = '0';
*last_++ = 'x';
last_ += nlen;
update_full();
auto p = last_ - 1;
for (; n; n >>= 8) {
uint8_t b = n & 0xff;
*p-- = util::LOWER_XDIGITS[b & 0xf];
*p-- = util::LOWER_XDIGITS[b >> 4];
}
}
static void set_severity_level(int severity);
// Returns the severity level by |name|. Returns -1 if |name| is
// unknown.
static int get_severity_level_by_name(const StringRef &name);
2014-11-27 15:39:04 +01:00
static bool log_enabled(int severity) { return severity >= severity_thres_; }
enum {
fmt_dec = 0x00,
fmt_hex = 0x01,
};
void set_flags(int flags) { flags_ = flags; }
private:
size_t rleft() { return last_ - begin_; }
size_t wleft() { return end_ - last_; }
void update_full() { full_ = last_ == end_; }
LogBuffer &buf_;
uint8_t *begin_;
uint8_t *end_;
uint8_t *last_;
const char *filename_;
uint32_t flags_;
2013-12-06 15:17:38 +01:00
int severity_;
int linenum_;
bool full_;
static int severity_thres_;
};
namespace log {
void hex(Log &log);
void dec(Log &log);
} // namespace log
#define TTY_HTTP_HD (log_config()->errorlog_tty ? "\033[1;34m" : "")
#define TTY_RST (log_config()->errorlog_tty ? "\033[0m" : "")
enum class LogFragmentType {
NONE,
LITERAL,
REMOTE_ADDR,
TIME_LOCAL,
TIME_ISO8601,
REQUEST,
STATUS,
BODY_BYTES_SENT,
HTTP,
AUTHORITY,
REMOTE_PORT,
SERVER_PORT,
REQUEST_TIME,
PID,
ALPN,
TLS_CIPHER,
SSL_CIPHER = TLS_CIPHER,
TLS_PROTOCOL,
SSL_PROTOCOL = TLS_PROTOCOL,
TLS_SESSION_ID,
SSL_SESSION_ID = TLS_SESSION_ID,
TLS_SESSION_REUSED,
SSL_SESSION_REUSED = TLS_SESSION_REUSED,
TLS_SNI,
TLS_CLIENT_FINGERPRINT_SHA1,
TLS_CLIENT_FINGERPRINT_SHA256,
TLS_CLIENT_ISSUER_NAME,
TLS_CLIENT_SERIAL,
TLS_CLIENT_SUBJECT_NAME,
BACKEND_HOST,
BACKEND_PORT,
};
struct LogFragment {
LogFragment(LogFragmentType type, StringRef value = StringRef::from_lit(""))
2015-07-14 15:43:02 +02:00
: type(type), value(std::move(value)) {}
LogFragmentType type;
StringRef value;
};
struct LogSpec {
Downstream *downstream;
2016-01-17 03:33:45 +01:00
StringRef remote_addr;
StringRef alpn;
StringRef sni;
SSL *ssl;
std::chrono::high_resolution_clock::time_point request_end_time;
2016-01-17 03:33:45 +01:00
StringRef remote_port;
uint16_t server_port;
pid_t pid;
};
void upstream_accesslog(const std::vector<LogFragment> &lf,
const LogSpec &lgsp);
int reopen_log_files(const LoggingConfig &loggingconf);
// Logs message when process whose pid is |pid| and exist status is
// |rstatus| exited. The |msg| is prepended to the log message.
void log_chld(pid_t pid, int rstatus, const char *msg);
void redirect_stderr_to_errorlog(const LoggingConfig &loggingconf);
// Makes internal copy of stderr (and possibly stdout in the future),
// which is then used as pointer to /dev/stderr or /proc/self/fd/2
void store_original_fds();
// Restores the original stderr that was stored with copy_original_fds
// Used just before execv
void restore_original_fds();
// Closes |fd| which was returned by open_log_file (see below)
// and sets it to -1. In the case that |fd| points to stdout or
// stderr, or is -1, the descriptor is not closed (but still set to -1).
void close_log_file(int &fd);
// Opens |path| with O_APPEND enabled. If file does not exist, it is
// created first. This function returns file descriptor referring the
// opened file if it succeeds, or -1.
int open_log_file(const char *path);
} // namespace shrpx
#endif // SHRPX_LOG_H