Repository: qpid-dispatch
Updated Branches:
  refs/heads/master 1b39fff04 -> f6a68fd14


DISPATCH-1082: Add connection_id to log messages for disambiguation

Eleven log messages are prefixed with '[N]'.
Server on_accept log message deletes the from field as it is unknown
at this stage in the connection life cycle and always blank.


Project: http://git-wip-us.apache.org/repos/asf/qpid-dispatch/repo
Commit: http://git-wip-us.apache.org/repos/asf/qpid-dispatch/commit/f6a68fd1
Tree: http://git-wip-us.apache.org/repos/asf/qpid-dispatch/tree/f6a68fd1
Diff: http://git-wip-us.apache.org/repos/asf/qpid-dispatch/diff/f6a68fd1

Branch: refs/heads/master
Commit: f6a68fd14db5a47f2ef6ea3ae7057309b41dc83d
Parents: 1b39fff
Author: Chuck Rolke <cro...@redhat.com>
Authored: Wed Jul 18 11:46:44 2018 -0400
Committer: Chuck Rolke <cro...@redhat.com>
Committed: Wed Jul 18 11:46:44 2018 -0400

----------------------------------------------------------------------
 src/policy.c | 36 ++++++++++++++++++------------------
 src/server.c | 16 ++++++++--------
 2 files changed, 26 insertions(+), 26 deletions(-)
----------------------------------------------------------------------


http://git-wip-us.apache.org/repos/asf/qpid-dispatch/blob/f6a68fd1/src/policy.c
----------------------------------------------------------------------
diff --git a/src/policy.c b/src/policy.c
index 21038d8..9bdbffa 100644
--- a/src/policy.c
+++ b/src/policy.c
@@ -460,8 +460,8 @@ bool qd_policy_open_lookup_user(
     if (name_buf[0]) {
         qd_log(policy->log_source,
            QD_LOG_TRACE,
-           "ALLOW AMQP Open lookup_user: %s, rhost: %s, vhost: %s, connection: 
%s. Usergroup: '%s'%s",
-           username, hostip, vhost, conn_name, name_buf, (res ? "" : " 
Internal error."));
+           "[%"PRIu64"]: ALLOW AMQP Open lookup_user: %s, rhost: %s, vhost: 
%s, connection: %s. Usergroup: '%s'%s",
+           conn_id, username, hostip, vhost, conn_name, name_buf, (res ? "" : 
" Internal error."));
     } else {
         // Denials are logged in python code
     }
@@ -515,13 +515,13 @@ bool qd_policy_approve_amqp_session(pn_session_t *ssn, 
qd_connection_t *qd_conn)
     if (result) {
         qd_log(policy->log_source,
            QD_LOG_TRACE,
-           "ALLOW AMQP Begin Session. user: %s, rhost: %s, vhost: %s",
-           qd_conn->user_id, hostip, vhost);
+           "[%"PRIu64"]: ALLOW AMQP Begin Session. user: %s, rhost: %s, vhost: 
%s",
+           qd_conn->connection_id, qd_conn->user_id, hostip, vhost);
     } else {
         qd_log(policy->log_source,
            QD_LOG_INFO,
-           "DENY AMQP Begin Session due to session limit. user: %s, rhost: %s, 
vhost: %s",
-           qd_conn->user_id, hostip, vhost);
+           "[%"PRIu64"]: DENY AMQP Begin Session due to session limit. user: 
%s, rhost: %s, vhost: %s",
+           qd_conn->connection_id, qd_conn->user_id, hostip, vhost);
     }
     return result;
 }
@@ -867,8 +867,8 @@ bool qd_policy_approve_amqp_sender_link(pn_link_t *pn_link, 
qd_connection_t *qd_
         if (qd_conn->n_senders == qd_conn->policy_settings->maxSenders) {
             // Max sender limit specified and violated.
             qd_log(qd_server_dispatch(qd_conn->server)->policy->log_source, 
QD_LOG_INFO,
-                "DENY AMQP Attach sender for user '%s', rhost '%s', vhost '%s' 
based on maxSenders limit",
-                qd_conn->user_id, hostip, vhost);
+                "[%"PRIu64"]: DENY AMQP Attach sender for user '%s', rhost 
'%s', vhost '%s' based on maxSenders limit",
+                qd_conn->connection_id, qd_conn->user_id, hostip, vhost);
             _qd_policy_deny_amqp_sender_link(pn_link, qd_conn, 
QD_AMQP_COND_RESOURCE_LIMIT_EXCEEDED);
             return false;
         } else {
@@ -885,8 +885,8 @@ bool qd_policy_approve_amqp_sender_link(pn_link_t *pn_link, 
qd_connection_t *qd_
         lookup = qd_policy_approve_link_name(qd_conn->user_id, 
qd_conn->policy_settings, target, false);
 
         qd_log(qd_server_dispatch(qd_conn->server)->policy->log_source, 
(lookup ? QD_LOG_TRACE : QD_LOG_INFO),
-            "%s AMQP Attach sender link '%s' for user '%s', rhost '%s', vhost 
'%s' based on link target name",
-            (lookup ? "ALLOW" : "DENY"), target, qd_conn->user_id, hostip, 
vhost);
+            "[%"PRIu64"]: %s AMQP Attach sender link '%s' for user '%s', rhost 
'%s', vhost '%s' based on link target name",
+            qd_conn->connection_id, (lookup ? "ALLOW" : "DENY"), target, 
qd_conn->user_id, hostip, vhost);
 
         if (!lookup) {
             _qd_policy_deny_amqp_sender_link(pn_link, qd_conn, 
QD_AMQP_COND_UNAUTHORIZED_ACCESS);
@@ -897,8 +897,8 @@ bool qd_policy_approve_amqp_sender_link(pn_link_t *pn_link, 
qd_connection_t *qd_
         // This happens all the time with anonymous relay
         lookup = qd_conn->policy_settings->allowAnonymousSender;
         qd_log(qd_server_dispatch(qd_conn->server)->policy->log_source, 
(lookup ? QD_LOG_TRACE : QD_LOG_INFO),
-            "%s AMQP Attach anonymous sender for user '%s', rhost '%s', vhost 
'%s'",
-            (lookup ? "ALLOW" : "DENY"), qd_conn->user_id, hostip, vhost);
+            "[%"PRIu64"]: %s AMQP Attach anonymous sender for user '%s', rhost 
'%s', vhost '%s'",
+            qd_conn->connection_id, (lookup ? "ALLOW" : "DENY"), 
qd_conn->user_id, hostip, vhost);
         if (!lookup) {
             _qd_policy_deny_amqp_sender_link(pn_link, qd_conn, 
QD_AMQP_COND_UNAUTHORIZED_ACCESS);
             return false;
@@ -918,8 +918,8 @@ bool qd_policy_approve_amqp_receiver_link(pn_link_t 
*pn_link, qd_connection_t *q
         if (qd_conn->n_receivers == qd_conn->policy_settings->maxReceivers) {
             // Max sender limit specified and violated.
             qd_log(qd_server_dispatch(qd_conn->server)->policy->log_source, 
QD_LOG_INFO,
-                "DENY AMQP Attach receiver for user '%s', rhost '%s', vhost 
'%s' based on maxReceivers limit",
-                qd_conn->user_id, hostip, vhost);
+                "[%"PRIu64"]: DENY AMQP Attach receiver for user '%s', rhost 
'%s', vhost '%s' based on maxReceivers limit",
+                qd_conn->connection_id, qd_conn->user_id, hostip, vhost);
             _qd_policy_deny_amqp_receiver_link(pn_link, qd_conn, 
QD_AMQP_COND_RESOURCE_LIMIT_EXCEEDED);
             return false;
         } else {
@@ -933,8 +933,8 @@ bool qd_policy_approve_amqp_receiver_link(pn_link_t 
*pn_link, qd_connection_t *q
     if (dynamic_src) {
         bool lookup = qd_conn->policy_settings->allowDynamicSource;
         qd_log(qd_server_dispatch(qd_conn->server)->policy->log_source, 
(lookup ? QD_LOG_TRACE : QD_LOG_INFO),
-            "%s AMQP Attach receiver dynamic source for user '%s', rhost '%s', 
vhost '%s',",
-            (lookup ? "ALLOW" : "DENY"), qd_conn->user_id, hostip, vhost);
+            "[%"PRIu64"]: %s AMQP Attach receiver dynamic source for user 
'%s', rhost '%s', vhost '%s',",
+            qd_conn->connection_id, (lookup ? "ALLOW" : "DENY"), 
qd_conn->user_id, hostip, vhost);
         // Dynamic source policy rendered the decision
         if (!lookup) {
             _qd_policy_deny_amqp_receiver_link(pn_link, qd_conn, 
QD_AMQP_COND_UNAUTHORIZED_ACCESS);
@@ -947,8 +947,8 @@ bool qd_policy_approve_amqp_receiver_link(pn_link_t 
*pn_link, qd_connection_t *q
         bool lookup = qd_policy_approve_link_name(qd_conn->user_id, 
qd_conn->policy_settings, source, true);
 
         qd_log(qd_server_dispatch(qd_conn->server)->policy->log_source, 
(lookup ? QD_LOG_TRACE : QD_LOG_INFO),
-            "%s AMQP Attach receiver link '%s' for user '%s', rhost '%s', 
vhost '%s' based on link source name",
-            (lookup ? "ALLOW" : "DENY"), source, qd_conn->user_id, hostip, 
vhost);
+            "[%"PRIu64"]: %s AMQP Attach receiver link '%s' for user '%s', 
rhost '%s', vhost '%s' based on link source name",
+            qd_conn->connection_id, (lookup ? "ALLOW" : "DENY"), source, 
qd_conn->user_id, hostip, vhost);
 
         if (!lookup) {
             _qd_policy_deny_amqp_receiver_link(pn_link, qd_conn, 
QD_AMQP_COND_UNAUTHORIZED_ACCESS);

http://git-wip-us.apache.org/repos/asf/qpid-dispatch/blob/f6a68fd1/src/server.c
----------------------------------------------------------------------
diff --git a/src/server.c b/src/server.c
index 2ad6f6d..b698fab 100644
--- a/src/server.c
+++ b/src/server.c
@@ -544,8 +544,8 @@ static void on_accept(pn_event_t *e)
     }
     ctx->listener = listener;
     qd_log(listener->server->log_source, QD_LOG_TRACE,
-           "[%"PRIu64"] Accepting incoming connection from %s to %s",
-           ctx->connection_id, qd_connection_name(ctx), 
ctx->listener->config.host_port);
+           "[%"PRIu64"]: Accepting incoming connection to '%s'",
+           ctx->connection_id, ctx->listener->config.host_port);
     /* Asynchronous accept, configure the transport on PN_CONNECTION_BOUND */
     pn_listener_accept(pn_listener, ctx->pn_conn);
  }
@@ -652,8 +652,8 @@ static void on_connection_bound(qd_server_t *server, 
pn_event_t *e) {
         pn_sasl_set_allow_insecure_mechs(sasl, 
config->allowInsecureAuthentication);
         sys_mutex_unlock(ctx->server->lock);
 
-        qd_log(ctx->server->log_source, QD_LOG_INFO, "Accepted connection to 
%s from %s",
-               name, ctx->rhost_port);
+        qd_log(ctx->server->log_source, QD_LOG_INFO, "[%"PRIu64"]: Accepted 
connection to %s from %s",
+               ctx->connection_id, name, ctx->rhost_port);
     } else if (ctx->connector) { /* Establishing an outgoing connection */
         config = &ctx->connector->config;
         setup_ssl_sasl_and_open(ctx);
@@ -924,15 +924,15 @@ static bool handle(qd_server_t *qd_server, pn_event_t *e) 
{
                 qd_increment_conn_index(ctx);
                 const qd_server_config_t *config = &ctx->connector->config;
                 if (condition  && pn_condition_is_set(condition)) {
-                    qd_log(qd_server->log_source, QD_LOG_INFO, "Connection to 
%s failed: %s %s", config->host_port,
+                    qd_log(qd_server->log_source, QD_LOG_INFO, "[%"PRIu64"]: 
Connection to %s failed: %s %s", ctx->connection_id, config->host_port,
                            pn_condition_get_name(condition), 
pn_condition_get_description(condition));
                 } else {
-                    qd_log(qd_server->log_source, QD_LOG_INFO, "Connection to 
%s failed", config->host_port);
+                    qd_log(qd_server->log_source, QD_LOG_INFO, "[%"PRIu64"]: 
Connection to %s failed", ctx->connection_id, config->host_port);
                 }
             } else if (ctx && ctx->listener) { /* Incoming connection */
                 if (condition && pn_condition_is_set(condition)) {
-                    qd_log(ctx->server->log_source, QD_LOG_INFO, "Connection 
from %s (to %s) failed: %s %s",
-                           ctx->rhost_port, ctx->listener->config.host_port, 
pn_condition_get_name(condition),
+                    qd_log(ctx->server->log_source, QD_LOG_INFO, "[%"PRIu64"]: 
Connection from %s (to %s) failed: %s %s",
+                           ctx->connection_id, ctx->rhost_port, 
ctx->listener->config.host_port, pn_condition_get_name(condition),
                            pn_condition_get_description(condition));
                 }
             }


---------------------------------------------------------------------
To unsubscribe, e-mail: commits-unsubscr...@qpid.apache.org
For additional commands, e-mail: commits-h...@qpid.apache.org

Reply via email to