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