log.c revision 4497075b5e08b0c8ee89425a1758258ae80550fc
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive/* Licensed to the Apache Software Foundation (ASF) under one or more
530eba85dbd41b8a0fa5255d3648d1440199a661slive * contributor license agreements. See the NOTICE file distributed with
e942c741056732f50da2074b36fe59805d370650slive * this work for additional information regarding copyright ownership.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * The ASF licenses this file to You under the Apache License, Version 2.0
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * (the "License"); you may not use this file except in compliance with
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * the License. You may obtain a copy of the License at
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * Unless required by applicable law or agreed to in writing, software
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * distributed under the License is distributed on an "AS IS" BASIS,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
003f0c9fda6664daf5092a0e42f65ede20098153slive * See the License for the specific language governing permissions and
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * limitations under the License.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * http_log.c: Dealing with the logs and errors
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * Rob McCool
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivetypedef struct {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *t_name;
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveint AP_DECLARE_DATA ap_default_loglevel = DEFAULT_LOGLEVEL;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive/* track pipe handles to close in child process */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivetypedef struct read_handle_t {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * @brief The piped logging structure.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * Piped logs are used to move functionality out of the main server.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * For example, log rotation is done with piped logs.
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd /** The pool to use for the piped log */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /** The pipe between the server and the logging process */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /** The name of the program the logging process is running */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /** The pid of the logging process */
1f53e295ebd19aed1767d12da7abfab9936c148cjerenkrantz /** How to reinvoke program when it must be replaced */
1f53e295ebd19aed1767d12da7abfab9936c148cjerenkrantzAP_DECLARE(apr_file_t *) ap_piped_log_read_fd(piped_log *pl)
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(apr_file_t *) ap_piped_log_write_fd(piped_log *pl)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive/* clear_handle_list() is called when plog is cleared; at that
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * point we need to forget about our old list of pipe read
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * handles. We let the plog cleanups close the actual pipes.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive/* remember to close this handle in the child process
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * On Win32 this makes zero sense, because we don't
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * take the parent process's child procs.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * If the win32 parent instead passed each and every
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * logger write handle from itself down to the child,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * and the parent manages all aspects of keeping the
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * reliable pipe log children alive, this would still
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * make no sense :) Cripple it on Win32.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic void close_handle_in_child(apr_pool_t *p, apr_file_t *f)
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(apr_status_t) ap_replace_stderr_log(apr_pool_t *p,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *fname)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "%s: could not open error log file %s.",
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* This is safe provided we revert it when we are finished.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * We don't manager the callers pool!
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if ((rc = apr_file_open_stderr(&stderr_log, stderr_pool))
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if ((rc = apr_file_dup2(stderr_log, stderr_file, stderr_pool))
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * You might ponder why stderr_pool should survive?
1c9f7cdf2e1bc8313e559a96638c3c36e3143791yoshiki * The trouble is, stderr_pool may have s_main->error_log,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * so we aren't in a position to destory stderr_pool until
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * the next recycle. There's also an apparent bug which
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * is not; if some folk decided to call this function before
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * the core open error logs hook, this pool won't survive.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * Neither does the stderr logger, so this isn't a problem.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* Revert, see above */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "unable to replace stderr with error log file");
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic void log_child_errfn(apr_pool_t *pool, apr_status_t err,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *description)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive/* Create a child process running PROGNAME with a pipe connected to
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * the childs stdin. The write-end of the pipe will be placed in
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * *FPIN on successful return. If dummy_stderr is non-zero, the
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * stderr for the child will be the same as the stdout of the parent.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * Otherwise the child will inherit the stderr from the parent. */
4c7bdb15764021d39e486adb7bc2166d3f683773bnicholesstatic int log_child(apr_pool_t *p, const char *progname,
4c7bdb15764021d39e486adb7bc2166d3f683773bnicholes /* Child process code for 'ErrorLog "|..."';
4c7bdb15764021d39e486adb7bc2166d3f683773bnicholes * may want a common framework for this, since I expect it will
4c7bdb15764021d39e486adb7bc2166d3f683773bnicholes * be common for other foo-loggers to want this sort of thing...
4c7bdb15764021d39e486adb7bc2166d3f683773bnicholes if (((rc = apr_procattr_create(&procattr, p)) == APR_SUCCESS)
4c7bdb15764021d39e486adb7bc2166d3f683773bnicholes && ((rc = apr_procattr_cmdtype_set(procattr, cmdtype)) == APR_SUCCESS)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive && ((rc = apr_procattr_error_check_set(procattr, 1)) == APR_SUCCESS)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive && ((rc = apr_procattr_child_errfn_set(procattr, log_child_errfn))
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *pname;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive procnew = (apr_proc_t *)apr_pcalloc(p, sizeof(*procnew));
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if ((rc = apr_file_open_stdout(&errfile, p)) == APR_SUCCESS)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive rc = apr_procattr_child_err_set(procattr, errfile, NULL);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive rc = apr_proc_create(procnew, pname, (const char * const *)args,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive apr_pool_note_subprocess(p, procnew, APR_KILL_AFTER_TIMEOUT);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* read handle to pipe not kept open, so no need to call
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * close_handle_in_child()
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive/* Open the error log for the given server_rec. If IS_MAIN is
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * non-zero, s is the main server. */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int open_error_log(server_rec *s, int is_main, apr_pool_t *p)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *fname;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* In 2.4 favor PROGRAM_ENV, accept "||prog" syntax for compatibility
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * and "|$cmd" to override the default.
76f2a3125fb6aca59d43b02220dabac91175a281slive * Any 2.2 backport would continue to favor SHELLCMD_ENV so there
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * accept "||prog" to override, and "|$cmd" to ease conversion.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* Spawn a new child logger. If this is the main server_rec,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * the new child must use a dummy stderr since the current
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * stderr might be a pipe to the old logger. Otherwise, the
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * child inherits the parents stderr. */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd "Couldn't start ErrorLog process '%s'.",
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive openlog(ap_server_argv0, LOG_NDELAY|LOG_CONS|LOG_PID, LOG_LOCAL7);
003f0c9fda6664daf5092a0e42f65ede20098153slive ap_log_error(APLOG_MARK, APLOG_STARTUP, APR_EBADPATH, NULL,
003f0c9fda6664daf5092a0e42f65ede20098153slive "%s: Invalid error log path %s.",
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd "%s: could not open error log file %s.",
b06660a3ed3d885e15d99c0209a46c4657df33fbrbowenint ap_open_logs(apr_pool_t *pconf, apr_pool_t *p /* plog */,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd /* Register to throw away the read_handles list when we
530eba85dbd41b8a0fa5255d3648d1440199a661slive * cleanup plog. Upon fork() for the apache children,
530eba85dbd41b8a0fa5255d3648d1440199a661slive * this read_handles list is closed so only the parent
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * can relaunch a lost log child. These read handles
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * are always closed on exec.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * We won't care what happens to our stderr log child
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * between log phases, so we don't mind losing stderr's
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * read_handle a little bit early.
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd /* HERE we need a stdout log that outlives plog.
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * We *presume* the parent of plog is a process
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * or global pool which spans server restarts.
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * Create our stderr_pool as a child of the plog's
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * parent pool.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* Replace existing stderr with new log. */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive rv = apr_file_dup2(stderr_log, s_main->error_log, stderr_p);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "unable to replace stderr with error_log");
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* We are done with stderr_pool, close it, killing
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * the previous generation's stderr logger
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * Now that we have dup'ed s_main->error_log to stderr_log
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * close it and set s_main->error_log to stderr_log. This avoids
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * this fd being inherited by the next piped logger who would
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * keep open the writing end of the pipe that this one uses
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * as stdin. This in turn would prevent the piped logger from
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* note that stderr may still need to be replaced with something
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * because it points to the old error log, or back to the tty
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * of the submitter.
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * XXX: This is BS - /dev/null is non-portable
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * errno-as-apr_status_t is also non-portable
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd if (replace_stderr && freopen("/dev/null", "w", stderr) == NULL) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "unable to replace stderr with /dev/null");
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (q == virt) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive apr_file_dup2(s->error_log, errfile, s->process->pool);
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cndstatic int cpystrn(char *buf, const char *arg, int buflen)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_remote_address(const ap_errorlog_info *info, const char *arg,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive return apr_snprintf(buf, buflen, "%s:%d", info->c->remote_ip,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_local_address(const ap_errorlog_info *info, const char *arg,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive return apr_snprintf(buf, buflen, "%s:%d", info->c->local_ip,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cndstatic int log_pid(const ap_errorlog_info *info, const char *arg,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive return apr_snprintf(buf, buflen, "%" APR_PID_T_FMT, pid);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_tid(const ap_errorlog_info *info, const char *arg,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (ap_mpm_query(AP_MPMQ_IS_THREADED, &result) == APR_SUCCESS
003f0c9fda6664daf5092a0e42f65ede20098153slivestatic int log_ctime(const ap_errorlog_info *info, const char *arg,
003f0c9fda6664daf5092a0e42f65ede20098153slive switch (*arg) {
af18698b10b429b270551ca3a5d51a75e1c9db22brianp ap_recent_ctime_ex(buf, apr_time_now(), option, &time_len);
af18698b10b429b270551ca3a5d51a75e1c9db22brianp /* ap_recent_ctime_ex includes the trailing \0 in time_len */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cndstatic int log_loglevel(const ap_errorlog_info *info, const char *arg,
af18698b10b429b270551ca3a5d51a75e1c9db22brianp return cpystrn(buf, priorities[info->level].t_name, buflen);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_log_id(const ap_errorlog_info *info, const char *arg,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * C: log conn log_id if available,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * c: log conn log id if available and not a once-per-request log line
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * else: log request log id if available
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive else if (info->r) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_keepalives(const ap_errorlog_info *info, const char *arg,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive return apr_snprintf(buf, buflen, "%d", info->c->keepalives);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_module_name(const ap_errorlog_info *info, const char *arg,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive return cpystrn(buf, ap_find_module_short_name(info->module_index), buflen);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_file_line(const ap_errorlog_info *info, const char *arg,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd#if defined(_OSD_POSIX) || defined(WIN32) || defined(__MVS__)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* In OSD/POSIX, the compiler returns for __FILE__
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * a string like: __FILE__="*POSIX(/usr/include/stdio.h)"
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * (it even returns an absolute path for sources in
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * the current directory). Here we try to strip this
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * down to the basename.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (*e == ')') {
4f854c24127e28f7ad72ce9a39d4448aaf910fc1slive#else /* _OSD_POSIX || WIN32 */
4f854c24127e28f7ad72ce9a39d4448aaf910fc1slive const char *p;
4f854c24127e28f7ad72ce9a39d4448aaf910fc1slive /* On Unix, __FILE__ may be an absolute path in a
4f854c24127e28f7ad72ce9a39d4448aaf910fc1slive * VPATH build. */
4f854c24127e28f7ad72ce9a39d4448aaf910fc1slive if (file[0] == '/' && (p = ap_strrchr_c(file, '/')) != NULL) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive#endif /*_OSD_POSIX || WIN32 */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive return apr_snprintf(buf, buflen, "%s(%d)", file, info->line);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_apr_status(const ap_errorlog_info *info, const char *arg,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_table_entry(const apr_table_t *table, const char *name,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *value;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive ap_escape_errorlog_item(scratch, value, MAX_STRING_LEN);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive return cpystrn(buf, apr_table_get(table, name), buflen);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_header(const ap_errorlog_info *info, const char *arg,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive return log_table_entry(info->r->headers_in, arg, buf, buflen);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_note(const ap_errorlog_info *info, const char *arg,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd /* XXX: maybe escaping the entry is not necessary for notes? */
530eba85dbd41b8a0fa5255d3648d1440199a661slive return log_table_entry(info->r->notes, arg, buf, buflen);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int log_env_var(const ap_errorlog_info *info, const char *arg,
530eba85dbd41b8a0fa5255d3648d1440199a661slive return log_table_entry(info->r->subprocess_env, arg, buf, buflen);
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cndAP_DECLARE(void) ap_register_builtin_errorlog_handlers(apr_pool_t *p)
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd ap_register_errorlog_handler(p, "a", log_remote_address, 0);
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd ap_register_errorlog_handler(p, "A", log_local_address, 0);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive ap_register_errorlog_handler(p, "l", log_loglevel, 0);
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd ap_register_errorlog_handler(p, "m", log_module_name, 0);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic void add_log_id(const conn_rec *c, const request_rec *r)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (r && r->request_time) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive apr_uintptr_t tmp2 = (apr_uintptr_t)c->current_thread;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive len = apr_base64_encode_len(sizeof(id)); /* includes trailing \0 */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* Skip the last char, it is always '=' */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* need to cast const away */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * This is used if no error log format is defined and during startup.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * It automatically omits the timestamp if logging to syslog.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int do_errorlog_default(const ap_errorlog_info *info, char *buf,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive len += log_module_name(info, NULL, buf + len, buflen - len);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive len += log_loglevel(info, NULL, buf + len, buflen - len);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive item_len = log_tid(info, NULL, buf + len, buflen - len);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive item_len = log_file_line(info, NULL, buf + len, buflen - len);
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd item_len = log_apr_status(info, NULL, buf + len, buflen - len);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * remote_ip can be client or backend server. If we have a scoreboard
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * handle, it is likely a client.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* the actual error message */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (apr_vsnprintf(scratch, MAX_STRING_LEN, errstr_fmt, args)) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive len += apr_vsnprintf(buf + len, buflen - len, errstr_fmt, args);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive len += cpystrn(buf + len, ", referer: ", buflen - len);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive item_len = log_header(info, "Referer", buf + len, buflen - len);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic int do_errorlog_format(apr_array_header_t *fmt, ap_errorlog_info *info,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive ap_errorlog_format_item *items = (ap_errorlog_format_item *)fmt->elts;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* the actual error message */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (apr_vsnprintf(scratch, MAX_STRING_LEN, err_fmt, args)) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive len += apr_vsnprintf(buf + len, buflen - len, err_fmt, args);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive int item_len = (*item->func)(info, item->arg, buf + len,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* required item is empty. skip whole line */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd else if (item->flags & AP_ERRORLOG_FLAG_NULL_AS_HYPHEN) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic void write_logline(char *errstr, apr_size_t len, apr_file_t *logf,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd /* NULL if we are logging to syslog */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd /* Truncate for the terminator (as apr_snprintf does) */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd syslog(level < LOG_PRIMASK ? level : APLOG_DEBUG, "%s", errstr);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic void log_error_core(const char *file, int line, int module_index,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* do we need to log once-per-req or once-per-conn info? */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd if (r && r->connection) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (s == NULL) {
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * If we are doing stderr logging (startup), don't log messages that are
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * above the default server log level unless it is a startup/shutdown
bea526116133aa3d7dabd1924bfc580b37fbf22aslive int configured_level = r ? ap_get_request_module_loglevel(r, module_index) :
bea526116133aa3d7dabd1924bfc580b37fbf22aslive c ? ap_get_conn_server_module_loglevel(c, s, module_index) :
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * If we are doing normal logging, don't log messages that are
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * above the module's log level unless it is a startup/shutdown notice
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * If we are doing syslog logging, don't log messages that are
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * above the module's log level (including a startup/shutdown notice)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive sconf = ap_get_module_config(s->module_config, &core_module);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (c && !c->log_id) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (sconf->error_log_conn && sconf->error_log_conn->nelts > 0)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* XXX: do we need separate log ids for subrequests? */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (sconf->error_log_req && sconf->error_log_req->nelts > 0)
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * XXX: potential optimization: only create log id if %L is
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * XXX: actually used
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd info.startup = ((level & APLOG_STARTUP) == APLOG_STARTUP);
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd while (!done) {
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd /* XXX: potential optimization: format common prefixes only once */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd /* once-per-connection info */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd lines = (apr_array_header_t **)sconf->error_log_conn->elts;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* this is the last line of once-per-connection info */
18b4b0fd6056093002ddef488636bf5ebe415ef0erikabele /* once-per-request info */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive lines = (apr_array_header_t **)sconf->error_log_req->elts;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* this is the last line of once-per-request info */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* the actual error message */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * prepare and log one line
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd len += do_errorlog_format(log_format, &info, errstr + len,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive len += do_errorlog_default(&info, errstr + len, MAX_STRING_LEN - len,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * Don't log empty lines. This can happen with once-per-conn/req
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * info if an item with AP_ERRORLOG_FLAG_REQUIRED is NULL.
003f0c9fda6664daf5092a0e42f65ede20098153slive /* only pass the real error string to the hook */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd ap_run_error_log(file, line, module_index, level, status, s, r, pool,
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(void) ap_log_error_(const char *file, int line, int module_index,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive log_error_core(file, line, module_index, level, status, s, NULL, NULL,
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(void) ap_log_perror_(const char *file, int line, int module_index,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd const char *fmt, ...)
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd log_error_core(file, line, module_index, level, status, NULL, NULL, NULL,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cndAP_DECLARE(void) ap_log_rerror_(const char *file, int line, int module_index,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive log_error_core(file, line, module_index, level, status, r->server, NULL, r,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * IF APLOG_TOCLIENT is set,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * AND the error level is 'warning' or more severe,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * AND there isn't already error text associated with this request,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * THEN make the message text available to ErrorDocument and
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * other error processors.
d3f27ec18dfa6283e852aa98253212edafaa0e2brbowen && (apr_table_get(r->notes, "error-notes") == NULL)) {
d3f27ec18dfa6283e852aa98253212edafaa0e2brbowenAP_DECLARE(void) ap_log_cserror_(const char *file, int line, int module_index,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd const char *fmt, ...)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive log_error_core(file, line, module_index, level, status, s, c,
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(void) ap_log_cerror_(const char *file, int line, int module_index,
003f0c9fda6664daf5092a0e42f65ede20098153slive log_error_core(file, line, module_index, level, status, c->base_server, c,
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(void) ap_log_command_line(apr_pool_t *plog, server_rec *s)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* Piece together the command line from the pieces
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * in process->argv, with spaces in between.
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cndAP_DECLARE(void) ap_log_pid(apr_pool_t *p, const char *filename)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *fname;
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd ap_log_error(APLOG_MARK, APLOG_STARTUP|APLOG_CRIT, APR_EBADPATH,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive NULL, "Invalid PID file path %s, ignoring.", filename);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive && apr_stat(&finfo, fname, APR_FINFO_MTIME, p) == APR_SUCCESS) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* AP_SIG_GRACEFUL and HUP call this on each restart.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * Only warn on first time through for this pid.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * XXX: Could just write first time through too, although
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * that may screw up scripts written to do something
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * based on the last modification time of the pid file.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "pid file %s overwritten -- Unclean "
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "shutdown of previous Apache run?",
d3f27ec18dfa6283e852aa98253212edafaa0e2brbowen "%s: could not log pid to file %s",
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive apr_file_printf(pid_file, "%" APR_PID_T_FMT APR_EOL_STR, mypid);
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(apr_status_t) ap_read_pid(apr_pool_t *p, const char *filename,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const apr_size_t BUFFER_SIZE = sizeof(long) * 3 + 2; /* see apr_ltoa */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *fname;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive ap_log_error(APLOG_MARK, APLOG_STARTUP|APLOG_CRIT, APR_EBADPATH,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive NULL, "Invalid PID file path %s, ignoring.", filename);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive rv = apr_file_open(&pid_file, fname, APR_READ, APR_OS_DEFAULT, p);
d3f27ec18dfa6283e852aa98253212edafaa0e2brbowen rv = apr_file_read_full(pid_file, buf, BUFFER_SIZE - 1, &bytes_read);
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* If we fill the buffer, we're probably reading a corrupt pid file.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * To be nice, let's also ensure the first char is a digit. */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (bytes_read == 0 || bytes_read == BUFFER_SIZE - 1 || !apr_isdigit(*buf)) {
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(void) ap_log_assert(const char *szExp, const char *szFile,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "[%s] file %s, line %d, assertion \"%s\" failed",
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive#if defined(WIN32)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* unix assert does an abort leading to a core dump */
d3f27ec18dfa6283e852aa98253212edafaa0e2brbowen/* piped log support */
d3f27ec18dfa6283e852aa98253212edafaa0e2brbowen/* forward declaration */
d3f27ec18dfa6283e852aa98253212edafaa0e2brbowenstatic void piped_log_maintenance(int reason, void *data, apr_wait_t status);
d3f27ec18dfa6283e852aa98253212edafaa0e2brbowen/* Spawn the piped logger process pl->program. */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive if (((status = apr_procattr_create(&procattr, pl->p)) != APR_SUCCESS) ||
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive ((status = apr_procattr_dir_set(procattr, ap_server_root))
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd ((status = apr_procattr_cmdtype_set(procattr, pl->cmdtype))
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive ((status = apr_procattr_child_errfn_set(procattr, log_child_errfn))
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive ((status = apr_procattr_error_check_set(procattr, 1)) != APR_SUCCESS)) {
d3f27ec18dfa6283e852aa98253212edafaa0e2brbowen /* Something bad happened, give up and go away. */
d3f27ec18dfa6283e852aa98253212edafaa0e2brbowen "piped_log_spawn: unable to setup child process '%s': %s",
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *pname;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive status = apr_proc_create(procnew, pname, (const char * const *) args,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* procnew->in was dup2'd from pl->write_fd;
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * since the original fd is still valid, close the copy to
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * avoid a leak. */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive apr_proc_other_child_register(procnew, piped_log_maintenance, pl,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* Something bad happened, give up and go away. */
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "unable to start piped log program '%s': %s",
80c4526970a11f37c0f8e3b82afdf03902dac3f3slivestatic void piped_log_maintenance(int reason, void *data, apr_wait_t status)
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd pl->pid = NULL; /* in case we don't get it going again, this
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * tells other logic not to try to kill it
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "can't query MPM state; not restarting "
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "piped log program '%s'",
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "piped log program '%s' failed unexpectedly",
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd /* what can we do? This could be the error log we're having
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * problems opening up... */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd "piped_log_maintenance: unable to respawn '%s': %s",
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd /* We should not kill off the pipe here, since it may only be full.
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd * If it really is locked, we should kill it off manually. */
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cndstatic apr_status_t piped_log_cleanup_for_exec(void *data)
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(piped_log *) ap_open_piped_log_ex(apr_pool_t *p,
a7f40ca49262952d6dd69d021cf5b0c2b452ae4cnd const char *program,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive#else /* !AP_HAVE_RELIABLE_PIPED_LOGS */
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(piped_log *) ap_open_piped_log_ex(apr_pool_t *p,
530eba85dbd41b8a0fa5255d3648d1440199a661slive const char *program,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive "Couldn't start piped log process '%s'.",
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive apr_pool_cleanup_register(p, pl, piped_log_cleanup, piped_log_cleanup);
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(piped_log *) ap_open_piped_log(apr_pool_t *p,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *program)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive /* In 2.4 favor PROGRAM_ENV, accept "||prog" syntax for compatibility
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * and "|$cmd" to override the default.
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * Any 2.2 backport would continue to favor SHELLCMD_ENV so there
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive * accept "||prog" to override, and "|$cmd" to ease conversion.
80c4526970a11f37c0f8e3b82afdf03902dac3f3sliveAP_DECLARE(const char *) ap_parse_log_level(const char *str, int *val)
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive char *err = "Log level keyword must be one of emerg/alert/crit/error/warn/"
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive (const char *file, int line, int module_index, int level,
80c4526970a11f37c0f8e3b82afdf03902dac3f3slive const char *errstr), (file, line, module_index, level,