[jira] [Commented] (HBASE-22902) At regionserver start there's a request to roll the WAL
[ https://issues.apache.org/jira/browse/HBASE-22902?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=16942709#comment-16942709 ] Hudson commented on HBASE-22902: Results for branch branch-1 [build #1092 on builds.a.o|https://builds.apache.org/job/HBase%20Nightly/job/branch-1/1092/]: (x) *{color:red}-1 overall{color}* details (if available): (/) {color:green}+1 general checks{color} -- For more information [see general report|https://builds.apache.org/job/HBase%20Nightly/job/branch-1/1092//General_Nightly_Build_Report/] (x) {color:red}-1 jdk7 checks{color} -- For more information [see jdk7 report|https://builds.apache.org/job/HBase%20Nightly/job/branch-1/1092//JDK7_Nightly_Build_Report/] (/) {color:green}+1 jdk8 hadoop2 checks{color} -- For more information [see jdk8 (hadoop2) report|https://builds.apache.org/job/HBase%20Nightly/job/branch-1/1092//JDK8_Nightly_Build_Report_(Hadoop2)/] (/) {color:green}+1 source release artifact{color} -- See build output for details. > At regionserver start there's a request to roll the WAL > --- > > Key: HBASE-22902 > URL: https://issues.apache.org/jira/browse/HBASE-22902 > Project: HBase > Issue Type: Bug > Components: wal >Affects Versions: 3.0.0, 1.5.0, 2.3.0 >Reporter: David Manning >Assignee: Sandeep Pal >Priority: Minor > Fix For: 1.5.0 > > Attachments: HBASE-22902_branch-1_v1.patch > > > See HBASE-22301 for logic that requests to roll the WAL if regionserver > encounters a slow write pipeline. In the logs, during regionserver start, I > see that the WAL is requested to roll once. It's strange that we roll the WAL > because it wasn't a slow sync. It appears when this code executes, we haven't > initialized the {{rollOnSyncNs}} variable to use for determining whether it's > a slow sync. Current pipeline also shows empty in the logs. > Disclaimer: I'm experiencing this after backporting this to 1.3.x and > building it there - I haven't attempted in 1.5.x, though I'd expect similar > results. > Regionserver logs follow (notice *threshold=0 ms, current pipeline: []*): > {noformat} > Tue Aug 20 23:29:50 GMT 2019 Starting regionserver > ... > 2019-08-20 23:29:57,824 INFO wal.FSHLog - WAL configuration: blocksize=256 > MB, rollsize=243.20 MB, prefix=[truncated]%2C1566343792434, suffix=, > logDir=hdfs://[truncated]/hbase/WALs/[truncated],1566343792434, > archiveDir=hdfs://[truncated]/hbase/oldWALs > 2019-08-20 23:29:58,104 INFO wal.FSHLog - Slow sync cost: 186 ms, current > pipeline: [] > 2019-08-20 23:29:58,104 WARN wal.FSHLog - Requesting log roll because we > exceeded slow sync threshold; time=186 ms, threshold=0 ms, current pipeline: > [] > 2019-08-20 23:29:58,107 DEBUG regionserver.ReplicationSourceManager - Start > tracking logs for wal group [truncated]%2C1566343792434 for peer 1 > 2019-08-20 23:29:58,107 INFO wal.FSHLog - New WAL > /hbase/WALs/[truncated],1566343792434/[truncated]%2C1566343792434.1566343797824 > 2019-08-20 23:29:58,109 DEBUG regionserver.ReplicationSource - Starting up > worker for wal group [truncated]%2C1566343792434{noformat} -- This message was sent by Atlassian Jira (v8.3.4#803005)
[jira] [Commented] (HBASE-22902) At regionserver start there's a request to roll the WAL
[ https://issues.apache.org/jira/browse/HBASE-22902?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=16942135#comment-16942135 ] Andrew Kyle Purtell commented on HBASE-22902: - Let me try to commit this today. > At regionserver start there's a request to roll the WAL > --- > > Key: HBASE-22902 > URL: https://issues.apache.org/jira/browse/HBASE-22902 > Project: HBase > Issue Type: Bug > Components: wal >Affects Versions: 3.0.0, 1.5.0, 2.3.0 >Reporter: David Manning >Assignee: Sandeep Pal >Priority: Minor > Attachments: HBASE-22902_branch-1_v1.patch > > > See HBASE-22301 for logic that requests to roll the WAL if regionserver > encounters a slow write pipeline. In the logs, during regionserver start, I > see that the WAL is requested to roll once. It's strange that we roll the WAL > because it wasn't a slow sync. It appears when this code executes, we haven't > initialized the {{rollOnSyncNs}} variable to use for determining whether it's > a slow sync. Current pipeline also shows empty in the logs. > Disclaimer: I'm experiencing this after backporting this to 1.3.x and > building it there - I haven't attempted in 1.5.x, though I'd expect similar > results. > Regionserver logs follow (notice *threshold=0 ms, current pipeline: []*): > {noformat} > Tue Aug 20 23:29:50 GMT 2019 Starting regionserver > ... > 2019-08-20 23:29:57,824 INFO wal.FSHLog - WAL configuration: blocksize=256 > MB, rollsize=243.20 MB, prefix=[truncated]%2C1566343792434, suffix=, > logDir=hdfs://[truncated]/hbase/WALs/[truncated],1566343792434, > archiveDir=hdfs://[truncated]/hbase/oldWALs > 2019-08-20 23:29:58,104 INFO wal.FSHLog - Slow sync cost: 186 ms, current > pipeline: [] > 2019-08-20 23:29:58,104 WARN wal.FSHLog - Requesting log roll because we > exceeded slow sync threshold; time=186 ms, threshold=0 ms, current pipeline: > [] > 2019-08-20 23:29:58,107 DEBUG regionserver.ReplicationSourceManager - Start > tracking logs for wal group [truncated]%2C1566343792434 for peer 1 > 2019-08-20 23:29:58,107 INFO wal.FSHLog - New WAL > /hbase/WALs/[truncated],1566343792434/[truncated]%2C1566343792434.1566343797824 > 2019-08-20 23:29:58,109 DEBUG regionserver.ReplicationSource - Starting up > worker for wal group [truncated]%2C1566343792434{noformat} -- This message was sent by Atlassian Jira (v8.3.4#803005)
[jira] [Commented] (HBASE-22902) At regionserver start there's a request to roll the WAL
[ https://issues.apache.org/jira/browse/HBASE-22902?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=16941227#comment-16941227 ] Sandeep Pal commented on HBASE-22902: - Sure, thanks [~apurtell]. Will take care of the naming convention in future. > At regionserver start there's a request to roll the WAL > --- > > Key: HBASE-22902 > URL: https://issues.apache.org/jira/browse/HBASE-22902 > Project: HBase > Issue Type: Bug > Components: wal >Affects Versions: 3.0.0, 1.5.0, 2.3.0 >Reporter: David Manning >Assignee: Sandeep Pal >Priority: Minor > Attachments: HBASE-22902_branch-1_v1.patch > > > See HBASE-22301 for logic that requests to roll the WAL if regionserver > encounters a slow write pipeline. In the logs, during regionserver start, I > see that the WAL is requested to roll once. It's strange that we roll the WAL > because it wasn't a slow sync. It appears when this code executes, we haven't > initialized the {{rollOnSyncNs}} variable to use for determining whether it's > a slow sync. Current pipeline also shows empty in the logs. > Disclaimer: I'm experiencing this after backporting this to 1.3.x and > building it there - I haven't attempted in 1.5.x, though I'd expect similar > results. > Regionserver logs follow (notice *threshold=0 ms, current pipeline: []*): > {noformat} > Tue Aug 20 23:29:50 GMT 2019 Starting regionserver > ... > 2019-08-20 23:29:57,824 INFO wal.FSHLog - WAL configuration: blocksize=256 > MB, rollsize=243.20 MB, prefix=[truncated]%2C1566343792434, suffix=, > logDir=hdfs://[truncated]/hbase/WALs/[truncated],1566343792434, > archiveDir=hdfs://[truncated]/hbase/oldWALs > 2019-08-20 23:29:58,104 INFO wal.FSHLog - Slow sync cost: 186 ms, current > pipeline: [] > 2019-08-20 23:29:58,104 WARN wal.FSHLog - Requesting log roll because we > exceeded slow sync threshold; time=186 ms, threshold=0 ms, current pipeline: > [] > 2019-08-20 23:29:58,107 DEBUG regionserver.ReplicationSourceManager - Start > tracking logs for wal group [truncated]%2C1566343792434 for peer 1 > 2019-08-20 23:29:58,107 INFO wal.FSHLog - New WAL > /hbase/WALs/[truncated],1566343792434/[truncated]%2C1566343792434.1566343797824 > 2019-08-20 23:29:58,109 DEBUG regionserver.ReplicationSource - Starting up > worker for wal group [truncated]%2C1566343792434{noformat} -- This message was sent by Atlassian Jira (v8.3.4#803005)
[jira] [Commented] (HBASE-22902) At regionserver start there's a request to roll the WAL
[ https://issues.apache.org/jira/browse/HBASE-22902?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=16941168#comment-16941168 ] Andrew Kyle Purtell commented on HBASE-22902: - The patch is for branch-1 I think. Anyway the changes lgtm. I will try to apply this today. Will come back here if local checks fail for some reason. > At regionserver start there's a request to roll the WAL > --- > > Key: HBASE-22902 > URL: https://issues.apache.org/jira/browse/HBASE-22902 > Project: HBase > Issue Type: Bug > Components: wal >Affects Versions: 3.0.0, 1.5.0, 2.3.0 >Reporter: David Manning >Assignee: Sandeep Pal >Priority: Minor > Attachments: HBASE-22902_branch-1_v1.patch > > > See HBASE-22301 for logic that requests to roll the WAL if regionserver > encounters a slow write pipeline. In the logs, during regionserver start, I > see that the WAL is requested to roll once. It's strange that we roll the WAL > because it wasn't a slow sync. It appears when this code executes, we haven't > initialized the {{rollOnSyncNs}} variable to use for determining whether it's > a slow sync. Current pipeline also shows empty in the logs. > Disclaimer: I'm experiencing this after backporting this to 1.3.x and > building it there - I haven't attempted in 1.5.x, though I'd expect similar > results. > Regionserver logs follow (notice *threshold=0 ms, current pipeline: []*): > {noformat} > Tue Aug 20 23:29:50 GMT 2019 Starting regionserver > ... > 2019-08-20 23:29:57,824 INFO wal.FSHLog - WAL configuration: blocksize=256 > MB, rollsize=243.20 MB, prefix=[truncated]%2C1566343792434, suffix=, > logDir=hdfs://[truncated]/hbase/WALs/[truncated],1566343792434, > archiveDir=hdfs://[truncated]/hbase/oldWALs > 2019-08-20 23:29:58,104 INFO wal.FSHLog - Slow sync cost: 186 ms, current > pipeline: [] > 2019-08-20 23:29:58,104 WARN wal.FSHLog - Requesting log roll because we > exceeded slow sync threshold; time=186 ms, threshold=0 ms, current pipeline: > [] > 2019-08-20 23:29:58,107 DEBUG regionserver.ReplicationSourceManager - Start > tracking logs for wal group [truncated]%2C1566343792434 for peer 1 > 2019-08-20 23:29:58,107 INFO wal.FSHLog - New WAL > /hbase/WALs/[truncated],1566343792434/[truncated]%2C1566343792434.1566343797824 > 2019-08-20 23:29:58,109 DEBUG regionserver.ReplicationSource - Starting up > worker for wal group [truncated]%2C1566343792434{noformat} -- This message was sent by Atlassian Jira (v8.3.4#803005)
[jira] [Commented] (HBASE-22902) At regionserver start there's a request to roll the WAL
[ https://issues.apache.org/jira/browse/HBASE-22902?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=16939871#comment-16939871 ] HBase QA commented on HBASE-22902: -- | (x) *{color:red}-1 overall{color}* | \\ \\ || Vote || Subsystem || Runtime || Comment || | {color:blue}0{color} | {color:blue} reexec {color} | {color:blue} 0m 0s{color} | {color:blue} Docker mode activated. {color} | | {color:red}-1{color} | {color:red} patch {color} | {color:red} 0m 7s{color} | {color:red} HBASE-22902 does not apply to master. Rebase required? Wrong Branch? See https://yetus.apache.org/documentation/in-progress/precommit-patchnames for help. {color} | \\ \\ || Subsystem || Report/Notes || | JIRA Issue | HBASE-22902 | | JIRA Patch URL | https://issues.apache.org/jira/secure/attachment/12981622/HBASE-22902_branch-1_v1.patch | | Console output | https://builds.apache.org/job/PreCommit-HBASE-Build/928/console | | versions | git=2.17.1 | | Powered by | Apache Yetus 0.11.0 https://yetus.apache.org | This message was automatically generated. > At regionserver start there's a request to roll the WAL > --- > > Key: HBASE-22902 > URL: https://issues.apache.org/jira/browse/HBASE-22902 > Project: HBase > Issue Type: Bug > Components: wal >Affects Versions: 3.0.0, 1.5.0, 2.3.0 >Reporter: David Manning >Assignee: Sandeep Pal >Priority: Minor > Attachments: HBASE-22902_branch-1_v1.patch > > > See HBASE-22301 for logic that requests to roll the WAL if regionserver > encounters a slow write pipeline. In the logs, during regionserver start, I > see that the WAL is requested to roll once. It's strange that we roll the WAL > because it wasn't a slow sync. It appears when this code executes, we haven't > initialized the {{rollOnSyncNs}} variable to use for determining whether it's > a slow sync. Current pipeline also shows empty in the logs. > Disclaimer: I'm experiencing this after backporting this to 1.3.x and > building it there - I haven't attempted in 1.5.x, though I'd expect similar > results. > Regionserver logs follow (notice *threshold=0 ms, current pipeline: []*): > {noformat} > Tue Aug 20 23:29:50 GMT 2019 Starting regionserver > ... > 2019-08-20 23:29:57,824 INFO wal.FSHLog - WAL configuration: blocksize=256 > MB, rollsize=243.20 MB, prefix=[truncated]%2C1566343792434, suffix=, > logDir=hdfs://[truncated]/hbase/WALs/[truncated],1566343792434, > archiveDir=hdfs://[truncated]/hbase/oldWALs > 2019-08-20 23:29:58,104 INFO wal.FSHLog - Slow sync cost: 186 ms, current > pipeline: [] > 2019-08-20 23:29:58,104 WARN wal.FSHLog - Requesting log roll because we > exceeded slow sync threshold; time=186 ms, threshold=0 ms, current pipeline: > [] > 2019-08-20 23:29:58,107 DEBUG regionserver.ReplicationSourceManager - Start > tracking logs for wal group [truncated]%2C1566343792434 for peer 1 > 2019-08-20 23:29:58,107 INFO wal.FSHLog - New WAL > /hbase/WALs/[truncated],1566343792434/[truncated]%2C1566343792434.1566343797824 > 2019-08-20 23:29:58,109 DEBUG regionserver.ReplicationSource - Starting up > worker for wal group [truncated]%2C1566343792434{noformat} -- This message was sent by Atlassian Jira (v8.3.4#803005)
[jira] [Commented] (HBASE-22902) At regionserver start there's a request to roll the WAL
[ https://issues.apache.org/jira/browse/HBASE-22902?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=16939805#comment-16939805 ] HBase QA commented on HBASE-22902: -- | (x) *{color:red}-1 overall{color}* | \\ \\ || Vote || Subsystem || Runtime || Comment || | {color:blue}0{color} | {color:blue} reexec {color} | {color:blue} 1m 14s{color} | {color:blue} Docker mode activated. {color} | || || || || {color:brown} Prechecks {color} || | {color:green}+1{color} | {color:green} dupname {color} | {color:green} 0m 0s{color} | {color:green} No case conflicting files found. {color} | | {color:green}+1{color} | {color:green} hbaseanti {color} | {color:green} 0m 0s{color} | {color:green} Patch does not have any anti-patterns. {color} | | {color:green}+1{color} | {color:green} @author {color} | {color:green} 0m 0s{color} | {color:green} The patch does not contain any @author tags. {color} | | {color:orange}-0{color} | {color:orange} test4tests {color} | {color:orange} 0m 0s{color} | {color:orange} The patch doesn't appear to include any new or modified tests. Please justify why no new tests are needed for this patch. Also please list what manual steps were performed to verify this patch. {color} | || || || || {color:brown} branch-1 Compile Tests {color} || | {color:green}+1{color} | {color:green} mvninstall {color} | {color:green} 8m 25s{color} | {color:green} branch-1 passed {color} | | {color:green}+1{color} | {color:green} compile {color} | {color:green} 2m 5s{color} | {color:green} branch-1 passed with JDK v1.8.0_222 {color} | | {color:red}-1{color} | {color:red} compile {color} | {color:red} 0m 21s{color} | {color:red} hbase-server in branch-1 failed with JDK v1.7.0_232. {color} | | {color:green}+1{color} | {color:green} checkstyle {color} | {color:green} 1m 44s{color} | {color:green} branch-1 passed {color} | | {color:green}+1{color} | {color:green} shadedjars {color} | {color:green} 3m 9s{color} | {color:green} branch has no errors when building our shaded downstream artifacts. {color} | | {color:green}+1{color} | {color:green} javadoc {color} | {color:green} 0m 36s{color} | {color:green} branch-1 passed with JDK v1.8.0_222 {color} | | {color:green}+1{color} | {color:green} javadoc {color} | {color:green} 0m 41s{color} | {color:green} branch-1 passed with JDK v1.7.0_232 {color} | | {color:blue}0{color} | {color:blue} spotbugs {color} | {color:blue} 3m 2s{color} | {color:blue} Used deprecated FindBugs config; considering switching to SpotBugs. {color} | | {color:green}+1{color} | {color:green} findbugs {color} | {color:green} 2m 58s{color} | {color:green} branch-1 passed {color} | || || || || {color:brown} Patch Compile Tests {color} || | {color:green}+1{color} | {color:green} mvninstall {color} | {color:green} 2m 3s{color} | {color:green} the patch passed {color} | | {color:green}+1{color} | {color:green} compile {color} | {color:green} 1m 50s{color} | {color:green} the patch passed with JDK v1.8.0_222 {color} | | {color:green}+1{color} | {color:green} javac {color} | {color:green} 1m 50s{color} | {color:green} the patch passed {color} | | {color:red}-1{color} | {color:red} compile {color} | {color:red} 0m 22s{color} | {color:red} hbase-server in the patch failed with JDK v1.7.0_232. {color} | | {color:red}-1{color} | {color:red} javac {color} | {color:red} 0m 22s{color} | {color:red} hbase-server in the patch failed with JDK v1.7.0_232. {color} | | {color:green}+1{color} | {color:green} checkstyle {color} | {color:green} 1m 40s{color} | {color:green} the patch passed {color} | | {color:green}+1{color} | {color:green} whitespace {color} | {color:green} 0m 0s{color} | {color:green} The patch has no whitespace issues. {color} | | {color:green}+1{color} | {color:green} shadedjars {color} | {color:green} 3m 6s{color} | {color:green} patch has no errors when building our shaded downstream artifacts. {color} | | {color:green}+1{color} | {color:green} hadoopcheck {color} | {color:green} 5m 9s{color} | {color:green} Patch does not cause any errors with Hadoop 2.8.5 2.9.2. {color} | | {color:green}+1{color} | {color:green} javadoc {color} | {color:green} 0m 31s{color} | {color:green} the patch passed with JDK v1.8.0_222 {color} | | {color:green}+1{color} | {color:green} javadoc {color} | {color:green} 0m 41s{color} | {color:green} the patch passed with JDK v1.7.0_232 {color} | | {color:green}+1{color} | {color:green} findbugs {color} | {color:green} 3m 4s{color} | {color:green} the patch passed {color} | || || || || {color:brown} Other Tests {color} || | {color:red}-1{color} | {color:red} unit {color} | {color:red}150m 10s{color} | {color:red} hbase-server in the patch failed. {color} | | {color:green}+1{color} | {color:green} asflicense {color} | {color:green} 0m 30s{color} | {color:green} The patch does not generate ASF License warnings. {color} | | {color:black}{color} |
[jira] [Commented] (HBASE-22902) At regionserver start there's a request to roll the WAL
[ https://issues.apache.org/jira/browse/HBASE-22902?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=16926001#comment-16926001 ] Sandeep Pal commented on HBASE-22902: - [~apurtell] [~busbey] Can you please assign this to me? Also, can you please add me on a contributor list so I can assign jira's to myself ? > At regionserver start there's a request to roll the WAL > --- > > Key: HBASE-22902 > URL: https://issues.apache.org/jira/browse/HBASE-22902 > Project: HBase > Issue Type: Bug > Components: wal >Affects Versions: 3.0.0, 1.5.0, 2.3.0 >Reporter: David Manning >Priority: Minor > > See HBASE-22301 for logic that requests to roll the WAL if regionserver > encounters a slow write pipeline. In the logs, during regionserver start, I > see that the WAL is requested to roll once. It's strange that we roll the WAL > because it wasn't a slow sync. It appears when this code executes, we haven't > initialized the {{rollOnSyncNs}} variable to use for determining whether it's > a slow sync. Current pipeline also shows empty in the logs. > Disclaimer: I'm experiencing this after backporting this to 1.3.x and > building it there - I haven't attempted in 1.5.x, though I'd expect similar > results. > Regionserver logs follow (notice *threshold=0 ms, current pipeline: []*): > {noformat} > Tue Aug 20 23:29:50 GMT 2019 Starting regionserver > ... > 2019-08-20 23:29:57,824 INFO wal.FSHLog - WAL configuration: blocksize=256 > MB, rollsize=243.20 MB, prefix=[truncated]%2C1566343792434, suffix=, > logDir=hdfs://[truncated]/hbase/WALs/[truncated],1566343792434, > archiveDir=hdfs://[truncated]/hbase/oldWALs > 2019-08-20 23:29:58,104 INFO wal.FSHLog - Slow sync cost: 186 ms, current > pipeline: [] > 2019-08-20 23:29:58,104 WARN wal.FSHLog - Requesting log roll because we > exceeded slow sync threshold; time=186 ms, threshold=0 ms, current pipeline: > [] > 2019-08-20 23:29:58,107 DEBUG regionserver.ReplicationSourceManager - Start > tracking logs for wal group [truncated]%2C1566343792434 for peer 1 > 2019-08-20 23:29:58,107 INFO wal.FSHLog - New WAL > /hbase/WALs/[truncated],1566343792434/[truncated]%2C1566343792434.1566343797824 > 2019-08-20 23:29:58,109 DEBUG regionserver.ReplicationSource - Starting up > worker for wal group [truncated]%2C1566343792434{noformat} -- This message was sent by Atlassian Jira (v8.3.2#803003)
[jira] [Commented] (HBASE-22902) At regionserver start there's a request to roll the WAL
[ https://issues.apache.org/jira/browse/HBASE-22902?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=16925931#comment-16925931 ] Andrew Purtell commented on HBASE-22902: Going out on vacation for much of September. Unassigning, in case someone else is interested in picking it up in the meantime. I'll assign back to myself and do it upon return otherwise. > At regionserver start there's a request to roll the WAL > --- > > Key: HBASE-22902 > URL: https://issues.apache.org/jira/browse/HBASE-22902 > Project: HBase > Issue Type: Bug > Components: wal >Affects Versions: 3.0.0, 1.5.0, 2.3.0 >Reporter: David Manning >Priority: Minor > > See HBASE-22301 for logic that requests to roll the WAL if regionserver > encounters a slow write pipeline. In the logs, during regionserver start, I > see that the WAL is requested to roll once. It's strange that we roll the WAL > because it wasn't a slow sync. It appears when this code executes, we haven't > initialized the {{rollOnSyncNs}} variable to use for determining whether it's > a slow sync. Current pipeline also shows empty in the logs. > Disclaimer: I'm experiencing this after backporting this to 1.3.x and > building it there - I haven't attempted in 1.5.x, though I'd expect similar > results. > Regionserver logs follow (notice *threshold=0 ms, current pipeline: []*): > {noformat} > Tue Aug 20 23:29:50 GMT 2019 Starting regionserver > ... > 2019-08-20 23:29:57,824 INFO wal.FSHLog - WAL configuration: blocksize=256 > MB, rollsize=243.20 MB, prefix=[truncated]%2C1566343792434, suffix=, > logDir=hdfs://[truncated]/hbase/WALs/[truncated],1566343792434, > archiveDir=hdfs://[truncated]/hbase/oldWALs > 2019-08-20 23:29:58,104 INFO wal.FSHLog - Slow sync cost: 186 ms, current > pipeline: [] > 2019-08-20 23:29:58,104 WARN wal.FSHLog - Requesting log roll because we > exceeded slow sync threshold; time=186 ms, threshold=0 ms, current pipeline: > [] > 2019-08-20 23:29:58,107 DEBUG regionserver.ReplicationSourceManager - Start > tracking logs for wal group [truncated]%2C1566343792434 for peer 1 > 2019-08-20 23:29:58,107 INFO wal.FSHLog - New WAL > /hbase/WALs/[truncated],1566343792434/[truncated]%2C1566343792434.1566343797824 > 2019-08-20 23:29:58,109 DEBUG regionserver.ReplicationSource - Starting up > worker for wal group [truncated]%2C1566343792434{noformat} -- This message was sent by Atlassian Jira (v8.3.2#803003)
[jira] [Commented] (HBASE-22902) At regionserver start there's a request to roll the WAL
[ https://issues.apache.org/jira/browse/HBASE-22902?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel=16913813#comment-16913813 ] Andrew Purtell commented on HBASE-22902: Looks like an oversight. The extra roll isn't harmful but isn't correct either. Let me take this > At regionserver start there's a request to roll the WAL > --- > > Key: HBASE-22902 > URL: https://issues.apache.org/jira/browse/HBASE-22902 > Project: HBase > Issue Type: Bug > Components: wal >Affects Versions: 3.0.0, 1.5.0, 2.3.0 >Reporter: David Manning >Assignee: Andrew Purtell >Priority: Minor > > See HBASE-22301 for logic that requests to roll the WAL if regionserver > encounters a slow write pipeline. In the logs, during regionserver start, I > see that the WAL is requested to roll once. It's strange that we roll the WAL > because it wasn't a slow sync. It appears when this code executes, we haven't > initialized the {{rollOnSyncNs}} variable to use for determining whether it's > a slow sync. Current pipeline also shows empty in the logs. > Disclaimer: I'm experiencing this after backporting this to 1.3.x and > building it there - I haven't attempted in 1.5.x, though I'd expect similar > results. > Regionserver logs follow (notice *threshold=0 ms, current pipeline: []*): > {noformat} > Tue Aug 20 23:29:50 GMT 2019 Starting regionserver > ... > 2019-08-20 23:29:57,824 INFO wal.FSHLog - WAL configuration: blocksize=256 > MB, rollsize=243.20 MB, prefix=[truncated]%2C1566343792434, suffix=, > logDir=hdfs://[truncated]/hbase/WALs/[truncated],1566343792434, > archiveDir=hdfs://[truncated]/hbase/oldWALs > 2019-08-20 23:29:58,104 INFO wal.FSHLog - Slow sync cost: 186 ms, current > pipeline: [] > 2019-08-20 23:29:58,104 WARN wal.FSHLog - Requesting log roll because we > exceeded slow sync threshold; time=186 ms, threshold=0 ms, current pipeline: > [] > 2019-08-20 23:29:58,107 DEBUG regionserver.ReplicationSourceManager - Start > tracking logs for wal group [truncated]%2C1566343792434 for peer 1 > 2019-08-20 23:29:58,107 INFO wal.FSHLog - New WAL > /hbase/WALs/[truncated],1566343792434/[truncated]%2C1566343792434.1566343797824 > 2019-08-20 23:29:58,109 DEBUG regionserver.ReplicationSource - Starting up > worker for wal group [truncated]%2C1566343792434{noformat} -- This message was sent by Atlassian Jira (v8.3.2#803003)