233933
From 023854d5573211d4737eb0ebe7ec954a7b7bb4ee Mon Sep 17 00:00:00 2001
233933
From: Mohit Agrawal <moagrawal@redhat.com>
233933
Date: Mon, 15 Apr 2019 10:34:34 +0530
233933
Subject: [PATCH 105/124] core: Log level changes do not effect on running
233933
 client process
233933
233933
Problem: commit c34e4161f3cb6539ec83a9020f3d27eb4759a975 set log-level
233933
         per xlator during reconfigure only for a brick process not for
233933
         the client process.
233933
233933
Solution: 1) Change per xlator log-level only if brick_mux is enabled.To make sure
233933
             about brick multiplex introudce a flag brick_mux at ctx->cmd_args.
233933
233933
Note: There are two other changes done with this patch
233933
      1) Ignore client-log-level option to attach a brick with
233933
         already running brick if brick_mux is enabled
233933
      2) Add a log to print pid of the running process to make easier
233933
         debugging
233933
233933
> Change-Id: I39e85de778e150d0685cd9a79425ce8b4783f9c9
233933
> Signed-off-by: Mohit Agrawal <moagrawal@redhat.com>
233933
> Fixes: bz#1696046
233933
> (Cherry picked from commit 798aadbe51a9a02dd98a0f861cc239ecf7c8ed57)
233933
> (Reviewed on upstream link https://review.gluster.org/#/c/glusterfs/+/22495/)
233933
233933
Change-Id: If82cc8e51cf00bd50d3321d31ec420f89786ea02
233933
Fixes: bz#1695081
233933
Signed-off-by: Mohit Agrawal <moagrawal@redhat.com>
233933
Reviewed-on: https://code.engineering.redhat.com/gerrit/167828
233933
Tested-by: Mohit Agrawal <moagrawa@redhat.com>
233933
Tested-by: RHGS Build Bot <nigelb@redhat.com>
233933
Reviewed-by: Atin Mukherjee <amukherj@redhat.com>
233933
---
233933
 glusterfsd/src/glusterfsd-messages.h       |   2 +-
233933
 glusterfsd/src/glusterfsd.c                |  20 ++++-
233933
 glusterfsd/src/glusterfsd.h                |   1 +
233933
 libglusterfs/src/glusterfs/glusterfs.h     |   1 +
233933
 tests/bugs/glusterd/bug-1696046.t          | 113 +++++++++++++++++++++++++++++
233933
 xlators/debug/io-stats/src/io-stats.c      |  22 +++---
233933
 xlators/mgmt/glusterd/src/glusterd-utils.c |   7 ++
233933
 7 files changed, 152 insertions(+), 14 deletions(-)
233933
 create mode 100644 tests/bugs/glusterd/bug-1696046.t
233933
233933
diff --git a/glusterfsd/src/glusterfsd-messages.h b/glusterfsd/src/glusterfsd-messages.h
233933
index 94312a5..280624c 100644
233933
--- a/glusterfsd/src/glusterfsd-messages.h
233933
+++ b/glusterfsd/src/glusterfsd-messages.h
233933
@@ -36,6 +36,6 @@ GLFS_MSGID(GLUSTERFSD, glusterfsd_msg_1, glusterfsd_msg_2, glusterfsd_msg_3,
233933
            glusterfsd_msg_31, glusterfsd_msg_32, glusterfsd_msg_33,
233933
            glusterfsd_msg_34, glusterfsd_msg_35, glusterfsd_msg_36,
233933
            glusterfsd_msg_37, glusterfsd_msg_38, glusterfsd_msg_39,
233933
-           glusterfsd_msg_40, glusterfsd_msg_41, glusterfsd_msg_42);
233933
+           glusterfsd_msg_40, glusterfsd_msg_41, glusterfsd_msg_42, glusterfsd_msg_43);
233933
 
233933
 #endif /* !_GLUSTERFSD_MESSAGES_H_ */
233933
diff --git a/glusterfsd/src/glusterfsd.c b/glusterfsd/src/glusterfsd.c
233933
index 3aa89ca..6aee4c1 100644
233933
--- a/glusterfsd/src/glusterfsd.c
233933
+++ b/glusterfsd/src/glusterfsd.c
233933
@@ -85,8 +85,7 @@ static char gf_doc[] = "";
233933
 static char argp_doc[] =
233933
     "--volfile-server=SERVER [MOUNT-POINT]\n"
233933
     "--volfile=VOLFILE [MOUNT-POINT]";
233933
-const char *argp_program_version =
233933
-    PACKAGE_NAME" "PACKAGE_VERSION;
233933
+const char *argp_program_version = PACKAGE_NAME " " PACKAGE_VERSION;
233933
 const char *argp_program_bug_address = "<" PACKAGE_BUGREPORT ">";
233933
 
233933
 static error_t
233933
@@ -266,6 +265,7 @@ static struct argp_option gf_options[] = {
233933
      "attribute, dentry and page-cache. "
233933
      "Disable this only if same files/directories are not accessed across "
233933
      "two different mounts concurrently [default: \"on\"]"},
233933
+    {"brick-mux", ARGP_BRICK_MUX_KEY, 0, 0, "Enable brick mux. "},
233933
     {0, 0, 0, 0, "Miscellaneous Options:"},
233933
     {
233933
         0,
233933
@@ -702,7 +702,6 @@ create_fuse_mount(glusterfs_ctx_t *ctx)
233933
     xlator_t *master = NULL;
233933
 
233933
     cmd_args = &ctx->cmd_args;
233933
-
233933
     if (!cmd_args->mount_point) {
233933
         gf_msg_trace("glusterfsd", 0,
233933
                      "mount point not found, not a client process");
233933
@@ -1090,6 +1089,10 @@ parse_opts(int key, char *arg, struct argp_state *state)
233933
             cmd_args->thin_client = _gf_true;
233933
             break;
233933
 
233933
+        case ARGP_BRICK_MUX_KEY:
233933
+            cmd_args->brick_mux = _gf_true;
233933
+            break;
233933
+
233933
         case ARGP_PID_FILE_KEY:
233933
             cmd_args->pid_file = gf_strdup(arg);
233933
             break;
233933
@@ -1207,7 +1210,6 @@ parse_opts(int key, char *arg, struct argp_state *state)
233933
         case ARGP_KEY_ARG:
233933
             if (state->arg_num >= 1)
233933
                 argp_usage(state);
233933
-
233933
             cmd_args->mount_point = gf_strdup(arg);
233933
             break;
233933
 
233933
@@ -2540,6 +2542,8 @@ postfork:
233933
         if (ret)
233933
             goto out;
233933
     }
233933
+    gf_log("glusterfs", GF_LOG_INFO, "Pid of current running process is %d",
233933
+           getpid());
233933
     ret = gf_log_inject_timer_event(ctx);
233933
 
233933
     glusterfs_signals_setup(ctx);
233933
@@ -2787,6 +2791,14 @@ main(int argc, char *argv[])
233933
     if (ret)
233933
         goto out;
233933
 
233933
+    /* set brick_mux mode only for server process */
233933
+    if ((ctx->process_mode != GF_SERVER_PROCESS) && cmd->brick_mux) {
233933
+        gf_msg("glusterfs", GF_LOG_CRITICAL, 0, glusterfsd_msg_43,
233933
+               "command line argument --brick-mux is valid only for brick "
233933
+               "process");
233933
+        goto out;
233933
+    }
233933
+
233933
     /* log the version of glusterfs running here along with the actual
233933
        command line options. */
233933
     {
233933
diff --git a/glusterfsd/src/glusterfsd.h b/glusterfsd/src/glusterfsd.h
233933
index 35cf6d8..fa55789 100644
233933
--- a/glusterfsd/src/glusterfsd.h
233933
+++ b/glusterfsd/src/glusterfsd.h
233933
@@ -111,6 +111,7 @@ enum argp_option_keys {
233933
     ARGP_FUSE_FLUSH_HANDLE_INTERRUPT_KEY = 189,
233933
     ARGP_FUSE_LRU_LIMIT_KEY = 190,
233933
     ARGP_FUSE_AUTO_INVAL_KEY = 191,
233933
+    ARGP_BRICK_MUX_KEY = 192
233933
 };
233933
 
233933
 struct _gfd_vol_top_priv {
233933
diff --git a/libglusterfs/src/glusterfs/glusterfs.h b/libglusterfs/src/glusterfs/glusterfs.h
233933
index deec5ba..fb727fc 100644
233933
--- a/libglusterfs/src/glusterfs/glusterfs.h
233933
+++ b/libglusterfs/src/glusterfs/glusterfs.h
233933
@@ -575,6 +575,7 @@ struct _cmd_args {
233933
 
233933
     int fuse_flush_handle_interrupt;
233933
     int fuse_auto_inval;
233933
+    bool brick_mux;
233933
 };
233933
 typedef struct _cmd_args cmd_args_t;
233933
 
233933
diff --git a/tests/bugs/glusterd/bug-1696046.t b/tests/bugs/glusterd/bug-1696046.t
233933
new file mode 100644
233933
index 0000000..e1c1eb2
233933
--- /dev/null
233933
+++ b/tests/bugs/glusterd/bug-1696046.t
233933
@@ -0,0 +1,113 @@
233933
+#!/bin/bash
233933
+
233933
+. $(dirname $0)/../../include.rc
233933
+. $(dirname $0)/../../volume.rc
233933
+
233933
+cleanup;
233933
+
233933
+function count_up_bricks {
233933
+        $CLI --xml volume status $1 | grep '<status>1' | wc -l
233933
+}
233933
+
233933
+function count_brick_processes {
233933
+        pgrep glusterfsd | wc -l
233933
+}
233933
+
233933
+logdir=`gluster --print-logdir`
233933
+
233933
+## Start and create a volume
233933
+TEST glusterd;
233933
+TEST pidof glusterd;
233933
+
233933
+TEST $CLI volume set all cluster.brick-multiplex on
233933
+TEST $CLI volume create $V0 replica 3 $H0:$B0/${V0}{1,2,3};
233933
+TEST $CLI volume create $V1 replica 3 $H0:$B0/${V1}{1,2,3};
233933
+
233933
+## Start volume and verify
233933
+TEST $CLI volume start $V0;
233933
+EXPECT 'Started' volinfo_field $V0 'Status';
233933
+TEST $CLI volume start $V1;
233933
+EXPECT 'Started' volinfo_field $V1 'Status';
233933
+
233933
+
233933
+EXPECT_WITHIN $PROCESS_UP_TIMEOUT 4 count_up_bricks $V0
233933
+EXPECT_WITHIN $PROCESS_UP_TIMEOUT 4 count_up_bricks $V1
233933
+
233933
+EXPECT 1 count_brick_processes
233933
+
233933
+# Mount V0
233933
+TEST glusterfs --volfile-id=$V0 --volfile-server=$H0 --entry-timeout=0 $M0;
233933
+
233933
+function client-log-file-name()
233933
+{
233933
+    logfilename=$M0".log"
233933
+    echo ${logfilename:1} | tr / -
233933
+}
233933
+
233933
+function brick-log-file-name()
233933
+{
233933
+    logfilename=$B0"/"$V0"1.log"
233933
+    echo ${logfilename:1} | tr / -
233933
+}
233933
+
233933
+log_file=$logdir"/"`client-log-file-name`
233933
+nofdlog=$(cat $log_file | grep " D " | wc -l)
233933
+TEST [ $((nofdlog)) -eq 0 ]
233933
+
233933
+brick_log_file=$logdir"/bricks/"`brick-log-file-name`
233933
+nofdlog=$(cat $brick_log_file | grep " D " | wc -l)
233933
+TEST [ $((nofdlog)) -eq 0 ]
233933
+
233933
+## Set brick-log-level to DEBUG
233933
+TEST $CLI volume set $V0 diagnostics.brick-log-level DEBUG
233933
+
233933
+# Do some operation
233933
+touch $M0/file1
233933
+
233933
+# Check debug message debug message should be exist only for V0
233933
+# Server xlator is common in brick_mux so after enabling DEBUG log
233933
+# some debug message should be available for other xlators like posix
233933
+
233933
+brick_log_file=$logdir"/bricks/"`brick-log-file-name`
233933
+nofdlog=$(cat $brick_log_file | grep file1 | grep -v server | wc -l)
233933
+TEST [ $((nofdlog)) -ne 0 ]
233933
+
233933
+#Check if any debug log exist in client-log file
233933
+nofdlog=$(cat $log_file | grep " D " | wc -l)
233933
+TEST [ $((nofdlog)) -eq 0 ]
233933
+
233933
+## Set brick-log-level to INFO
233933
+TEST $CLI volume set $V0 diagnostics.brick-log-level INFO
233933
+
233933
+## Set client-log-level to DEBUG
233933
+TEST $CLI volume set $V0 diagnostics.client-log-level DEBUG
233933
+
233933
+# Do some operation
233933
+touch $M0/file2
233933
+
233933
+nofdlog=$(cat $brick_log_file | grep " D " | grep file2 | wc -l)
233933
+TEST [ $((nofdlog)) -eq 0 ]
233933
+
233933
+nofdlog=$(cat $log_file | grep " D " | wc -l)
233933
+TEST [ $((nofdlog)) -ne 0 ]
233933
+
233933
+# Unmount V0
233933
+TEST umount $M0
233933
+
233933
+#Mount V1
233933
+TEST glusterfs --volfile-id=$V1 --volfile-server=$H0 --entry-timeout=0 $M0;
233933
+
233933
+#do some operation
233933
+touch $M0/file3
233933
+
233933
+
233933
+# DEBUG log level is enabled only for V0 so no debug message should be available
233933
+# in log specific to file2 creation except for server xlator, server xlator is
233933
+# common xlator in brick mulitplex
233933
+nofdlog=$(cat $brick_log_file | grep file3 | grep -v server | wc -l)
233933
+TEST [ $((nofdlog)) -eq 0 ]
233933
+
233933
+# Unmount V1
233933
+TEST umount $M0
233933
+
233933
+cleanup;
233933
diff --git a/xlators/debug/io-stats/src/io-stats.c b/xlators/debug/io-stats/src/io-stats.c
233933
index 41b57c5..aa91a0a 100644
233933
--- a/xlators/debug/io-stats/src/io-stats.c
233933
+++ b/xlators/debug/io-stats/src/io-stats.c
233933
@@ -3704,19 +3704,23 @@ xlator_set_loglevel(xlator_t *this, int log_level)
233933
     active = ctx->active;
233933
     top = active->first;
233933
 
233933
-    if (strcmp(top->type, "protocol/server") || (log_level == -1))
233933
+    if (log_level == -1)
233933
         return;
233933
 
233933
-    /* Set log-level for server xlator */
233933
-    top->loglevel = log_level;
233933
+    if (ctx->cmd_args.brick_mux) {
233933
+        /* Set log-level for all brick xlators */
233933
+        top->loglevel = log_level;
233933
 
233933
-    /* Set log-level for parent xlator */
233933
-    if (this->parents)
233933
-        this->parents->xlator->loglevel = log_level;
233933
+        /* Set log-level for parent xlator */
233933
+        if (this->parents)
233933
+            this->parents->xlator->loglevel = log_level;
233933
 
233933
-    while (trav) {
233933
-        trav->loglevel = log_level;
233933
-        trav = trav->next;
233933
+        while (trav) {
233933
+            trav->loglevel = log_level;
233933
+            trav = trav->next;
233933
+        }
233933
+    } else {
233933
+        gf_log_set_loglevel(this->ctx, log_level);
233933
     }
233933
 }
233933
 
233933
diff --git a/xlators/mgmt/glusterd/src/glusterd-utils.c b/xlators/mgmt/glusterd/src/glusterd-utils.c
233933
index 2dd5f91..fdd7d91 100644
233933
--- a/xlators/mgmt/glusterd/src/glusterd-utils.c
233933
+++ b/xlators/mgmt/glusterd/src/glusterd-utils.c
233933
@@ -2240,6 +2240,9 @@ retry:
233933
     if (volinfo->memory_accounting)
233933
         runner_add_arg(&runner, "--mem-accounting");
233933
 
233933
+    if (is_brick_mx_enabled())
233933
+        runner_add_arg(&runner, "--brick-mux");
233933
+
233933
     runner_log(&runner, "", 0, "Starting GlusterFS");
233933
 
233933
     brickinfo->port = port;
233933
@@ -2378,6 +2381,10 @@ unsafe_option(dict_t *this, char *key, data_t *value, void *arg)
233933
         return _gf_false;
233933
     }
233933
 
233933
+    if (fnmatch("*diagnostics.client-log*", key, 0) == 0) {
233933
+        return _gf_false;
233933
+    }
233933
+
233933
     return _gf_true;
233933
 }
233933
 
233933
-- 
233933
1.8.3.1
233933