Uploaded image for project: 'Flume'
  1. Flume
  2. FLUME-1268

FileChannel ReplayLog fails to replay

    XMLWordPrintableJSON

Details

    • Bug
    • Status: Resolved
    • Major
    • Resolution: Duplicate
    • 1.2.0
    • None
    • Sinks+Sources
    • None

    Description

      2012-06-09 17:15:05,718 ERROR file.Log: Failed to initialize Log
java.lang.IllegalStateException: Pending takes 1516 exist after the end of replay
	at com.google.common.base.Preconditions.checkState(Preconditions.java:145)
	at org.apache.flume.channel.file.ReplayHandler.replayLog(ReplayHandler.java:137)
	at org.apache.flume.channel.file.Log.replay(Log.java:205)
	at org.apache.flume.channel.file.FileChannel.start(FileChannel.java:180)
	at org.apache.flume.lifecycle.LifecycleSupervisor$MonitorRunnable.run(LifecycleSupervisor.java:228)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
	at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
	at java.lang.Thread.run(Thread.java:662)
2012-06-09 17:15:05,718 ERROR lifecycle.LifecycleSupervisor: Unable to start org.apache.flume.channel.file.FileChannel@556917ee - Exception follows.
java.lang.IllegalStateException: Log is closed
	at com.google.common.base.Preconditions.checkState(Preconditions.java:145)
	at org.apache.flume.channel.file.Log.getFlumeEventQueue(Log.java:226)
	at org.apache.flume.channel.file.FileChannel.getDepth(FileChannel.java:253)
	at org.apache.flume.channel.file.FileChannel.start(FileChannel.java:187)
	at org.apache.flume.lifecycle.LifecycleSupervisor$MonitorRunnable.run(LifecycleSupervisor.java:228)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
	at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
	at java.lang.Thread.run(Thread.java:662)
2012-06-09 17:15:05,926 INFO nodemanager.DefaultLogicalNodeManager: Waiting for channel: file-channel-1 to start. Sleeping for 500 ms
2012-06-09 17:15:06,428 INFO nodemanager.DefaultLogicalNodeManager: Waiting for channel: file-channel-1 to start. Sleeping for 500 ms

2012-06-09 17:15:08,377 INFO file.FileChannel: Starting FileChannel with dataDir [/data3/flume/file-channel/data2]
2012-06-09 17:15:08,378 INFO file.Log: Cannot lock /data3/flume/file-channel/checkpoint2. The directory is already locked.
2012-06-09 17:15:08,379 ERROR lifecycle.LifecycleSupervisor: Unable to start org.apache.flume.channel.file.FileChannel@4bf54c5f - Exception follows.
java.lang.RuntimeException: java.io.IOException: Cannot lock /data3/flume/file-channel/checkpoint2. The directory is already locked.
	at com.google.common.base.Throwables.propagate(Throwables.java:156)
	at org.apache.flume.channel.file.FileChannel.start(FileChannel.java:182)
	at org.apache.flume.lifecycle.LifecycleSupervisor$MonitorRunnable.run(LifecycleSupervisor.java:228)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
	at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
	at java.lang.Thread.run(Thread.java:662)
Caused by: java.io.IOException: Cannot lock /data3/flume/file-channel/checkpoint2. The directory is already locked.
	at org.apache.flume.channel.file.Log.lock(Log.java:574)
	at org.apache.flume.channel.file.Log.<init>(Log.java:95)
	at org.apache.flume.channel.file.FileChannel.start(FileChannel.java:178)
	... 10 more
2012-06-09 17:15:08,425 INFO file.FileChannel: Starting FileChannel with dataDir [/data2/flume/file-channel/data1]
2012-06-09 17:15:08,425 INFO file.Log: Cannot lock /data2/flume/file-channel/checkpoint1. The directory is already locked.
2012-06-09 17:15:08,425 ERROR lifecycle.LifecycleSupervisor: Unable to start org.apache.flume.channel.file.FileChannel@42f1916f - Exception follows.
java.lang.RuntimeException: java.io.IOException: Cannot lock /data2/flume/file-channel/checkpoint1. The directory is already locked.
	at com.google.common.base.Throwables.propagate(Throwables.java:156)
	at org.apache.flume.channel.file.FileChannel.start(FileChannel.java:182)
	at org.apache.flume.lifecycle.LifecycleSupervisor$MonitorRunnable.run(LifecycleSupervisor.java:228)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
	at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
	at java.lang.Thread.run(Thread.java:662)
Caused by: java.io.IOException: Cannot lock /data2/flume/file-channel/checkpoint1. The directory is already locked.
	at org.apache.flume.channel.file.Log.lock(Log.java:574)
	at org.apache.flume.channel.file.Log.<init>(Log.java:95)
	at org.apache.flume.channel.file.FileChannel.start(FileChannel.java:178)
	... 10 more

2012-06-09 17:15:08,535 INFO file.FileChannel: Starting FileChannel with dataDir [/data5/flume/file-channel/data4]
2012-06-09 17:15:08,535 INFO file.Log: Cannot lock /data5/flume/file-channel/checkpoint4. The directory is already locked.
2012-06-09 17:15:08,535 ERROR lifecycle.LifecycleSupervisor: Unable to start org.apache.flume.channel.file.FileChannel@66a23610 - Exception follows.
java.lang.RuntimeException: java.io.IOException: Cannot lock /data5/flume/file-channel/checkpoint4. The directory is already locked.
	at com.google.common.base.Throwables.propagate(Throwables.java:156)
	at org.apache.flume.channel.file.FileChannel.start(FileChannel.java:182)
	at org.apache.flume.lifecycle.LifecycleSupervisor$MonitorRunnable.run(LifecycleSupervisor.java:228)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
	at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
	at java.lang.Thread.run(Thread.java:662)
Caused by: java.io.IOException: Cannot lock /data5/flume/file-channel/checkpoint4. The directory is already locked.
	at org.apache.flume.channel.file.Log.lock(Log.java:574)
	at org.apache.flume.channel.file.Log.<init>(Log.java:95)
	at org.apache.flume.channel.file.FileChannel.start(FileChannel.java:178)
	... 10 more
2012-06-09 17:15:08,719 INFO file.FileChannel: Starting FileChannel with dataDir [/data4/flume/file-channel/data3]
2012-06-09 17:15:08,719 INFO file.Log: Cannot lock /data4/flume/file-channel/checkpoint3. The directory is already locked.
2012-06-09 17:15:08,719 ERROR lifecycle.LifecycleSupervisor: Unable to start org.apache.flume.channel.file.FileChannel@556917ee - Exception follows.
java.lang.RuntimeException: java.io.IOException: Cannot lock /data4/flume/file-channel/checkpoint3. The directory is already locked.
	at com.google.common.base.Throwables.propagate(Throwables.java:156)
	at org.apache.flume.channel.file.FileChannel.start(FileChannel.java:182)
	at org.apache.flume.lifecycle.LifecycleSupervisor$MonitorRunnable.run(LifecycleSupervisor.java:228)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
	at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
	at java.lang.Thread.run(Thread.java:662)
Caused by: java.io.IOException: Cannot lock /data4/flume/file-channel/checkpoint3. The directory is already locked.
	at org.apache.flume.channel.file.Log.lock(Log.java:574)
	at org.apache.flume.channel.file.Log.<init>(Log.java:95)
	at org.apache.flume.channel.file.FileChannel.start(FileChannel.java:178)
	... 10 more
2012-06-09 17:15:08,938 INFO nodemanager.DefaultLogicalNodeManager: Waiting for channel: file-channel-1 to start. Sleeping for 500 ms

      Attachments

        Issue Links

          is duplicated by

          Bug - A problem which impairs or prevents the functions of the product. FLUME-1232 Cannot start agent a 3rd time when using FileChannel

          • Blocker - Blocks development and/or testing work, production could not run
          • Closed

          Activity

            People

              Unassigned Unassigned
              mubarakseyed Mubarak Seyed
              Votes:
              0 Vote for this issue
              Watchers:
              2 Start watching this issue

              Dates

                Created:
                Updated:
                Resolved: