testWithDiskFullAndAbilityToCreateNewIndexFile very often

[eolivelli]

• What did you do?

run on master and branch-4.6 this command
mvn clean install

• What did you expect to see?

build passes

• What did you see instead?

build fails, the error is not always reproducible but it fails quite often on every of the two laptops I am using to work on BK (Fedora 25 and Fedora 27 linux distributions)

testWithDiskFullAndAbilityToCreateNewIndexFile(org.apache.bookkeeper.bookie.BookieInitializationTest)  Time elapsed: 12.869 sec  <<< FAILURE!
java.lang.AssertionError: Bookie should be up and running
	at org.apache.bookkeeper.bookie.BookieInitializationTest.testWithDiskFullAndAbilityToCreateNewIndexFile(BookieInitializationTest.java:602)

This is the error in the log

2018-01-19 13:12:57,461 - WARN  - [LedgerDirsMonitorThread:LedgerDirsMonitor@78] - Ledger directory /tmp/DiskCheck5050359558289051793test/current is almost full.
2018-01-19 13:12:57,461 - ERROR - [Time-limited test:Bookie@880] - Couldn't register bookie with zookeeper, shutting down : 
java.util.concurrent.ExecutionException: java.io.IOException: org.apache.bookkeeper.bookie.BookieException$MetadataStoreException: java.io.IOException: ZK exception checking and wait ephemeral znode /ledgers/available/10.168.101.193:44289 expired
        at java.util.concurrent.FutureTask.report(FutureTask.java:122)
        at java.util.concurrent.FutureTask.get(FutureTask.java:192)
        at org.apache.bookkeeper.bookie.Bookie.start(Bookie.java:878)
        at org.apache.bookkeeper.proto.BookieServer.start(BookieServer.java:106)
        at org.apache.bookkeeper.bookie.BookieInitializationTest.testWithDiskFullAndAbilityToCreateNewIndexFile(BookieInitializationTest.java:600)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:50)
        at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12)
        at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:47)
        at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:17)
        at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:26)
        at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:27)
        at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55)
        at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:298)
        at org.junit.internal.runners.statements.FailOnTimeout$CallableStatement.call(FailOnTimeout.java:292)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at java.lang.Thread.run(Thread.java:745)
Caused by: java.io.IOException: org.apache.bookkeeper.bookie.BookieException$MetadataStoreException: java.io.IOException: ZK exception checking and wait ephemeral znode /ledgers/available/10.168.101.193:44289 expired
        at org.apache.bookkeeper.bookie.Bookie.doRegisterBookie(Bookie.java:994)
        at org.apache.bookkeeper.bookie.Bookie.doRegisterBookie(Bookie.java:977)
        at org.apache.bookkeeper.bookie.Bookie$5.call(Bookie.java:962)
        at org.apache.bookkeeper.bookie.Bookie$5.call(Bookie.java:958)
        at java.util.concurrent.FutureTask.run(FutureTask.java:266)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        ... 1 more
Caused by: org.apache.bookkeeper.bookie.BookieException$MetadataStoreException: java.io.IOException: ZK exception checking and wait ephemeral znode /ledgers/available/10.168.101.193:44289 expired
        at org.apache.bookkeeper.discover.ZKRegistrationManager.doRegisterBookie(ZKRegistrationManager.java:255)
        at org.apache.bookkeeper.discover.ZKRegistrationManager.registerBookie(ZKRegistrationManager.java:229)
        at org.apache.bookkeeper.bookie.Bookie.doRegisterBookie(Bookie.java:991)
        ... 7 more
Caused by: java.io.IOException: ZK exception checking and wait ephemeral znode /ledgers/available/10.168.101.193:44289 expired
        at org.apache.bookkeeper.discover.ZKRegistrationManager.checkRegNodeAndWaitExpired(ZKRegistrationManager.java:216)
        at org.apache.bookkeeper.discover.ZKRegistrationManager.doRegisterBookie(ZKRegistrationManager.java:238)
        ... 9 more
Caused by: org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode = NodeExists for /ledgers/available/10.168.101.193:44289
        at org.apache.bookkeeper.discover.ZKRegistrationManager.checkRegNodeAndWaitExpired(ZKRegistrationManager.java:205)
        ... 10 more