zzz.i2p.xyz

Development discussions
Zero (0) Client Tunnels? « Complaints and Questions ... « I2P Help, Hints, Advice
 
Sat, 26 Jul 2014, 08:11pm #1
micster
I2P Legend

When my router first starts up everything runs fine. My Network status is "OK", I'm "Accepting Tunnels", I have a handful of Exploratory tunnels, a few Client tunnels, and a green star next to "Shared Clients" under Local Destinations.

After a while, my Client tunnels will drop to zero and Local Destinations will say "none". Then I can no longer access eepsites or mail.

Interestingly I have over 1400 Participating tunnels and 20+ Exploratory and my share ratio is at 100%.

I2P version: 0.9.13-0-1~pq1
Java version: Sun Microsystems Inc. 1.6.0_31 (OpenJDK Runtime Environment 1.6.0_31-b31)
Wrapper version: 3.5.22
Server version: 8.1.14.v20131031
Servlet version: Jasper JSP 2.1 Engine
Platform: Linux amd64 3.2.0-61-generic
Processor: Core 2 (Conroe) (core2)
Jbigi: Locally optimized native BigInteger library loaded from file
Encoding: UTF-8
Charset: UTF-8

Last edited: Sun, 27 Jul 2014, 06:57pm by micster

Sun, 27 Jul 2014, 03:06pm #2
pcook
Contributor

Hi!

I ran into the same problem somewhere around I2P 0.9.12-15. I checked the logs and found the following error message:

2014/05/12 18:31:56 | Thread terminated unexpectedly: BuildExecutor
2014/05/12 18:31:56 | java.lang.NoSuchMethodError: java.util.concurrent.ConcurrentHashMap.keySet()Ljava/util/concurrent/ConcurrentHashMap$KeySetView;

I did some searching on the Internet and found this link:

https://gist.github.com/AlainODea/1375759b8720a...

The title of the article is:

Interaction of Convariance and Java Cross-compile

And talks about a problem compiling with Java 8 and then running the code on Java 7 (I was using Java 7, and though it looks like you are using Java 6, this may still work). There is a change in the return type, and I quote:

Java 1.7 ConcurrentHashMap#keySet() returns a Set<K> while the 1.8 ConcurrentHashMap#keySet() returns a ConcurrentHashMap.KeySetView<K,V>`.

I changed to Java 8 (I use the 64-bit version for i2p) and have not had a problem since.
I hope this helps.

Sun, 27 Jul 2014, 03:57pm #3
zzz
Administrator
Zzz

Interesting, very strange. Indeed, we target 1.6 for all compiles.

Sun, 27 Jul 2014, 07:06pm #4
echelon
I2P Legend

Moin

By chance: was it a MTN build from me? I do built with java 8 SDK on debian. And I remember one of these reports in IRC.
Nothing I can change currently.

echelon

Sun, 27 Jul 2014, 07:12pm #5
micster
I2P Legend

Here are some errors from the last time I restarted the router:

7/26/14 7:04:04 PM ERROR [onsole Jetty] rg.eclipse.jetty.server.Server: /themes/console/light/images/magic.png
java.lang.IllegalStateException
at org.eclipse.jetty.server.session.AbstractSession.checkValid(AbstractSession.java:109)
at org.eclipse.jetty.server.session.HashedSession.checkValid(HashedSession.java:73)
at org.eclipse.jetty.server.session.AbstractSession.getAttributeNames(AbstractSession.java:153)
at org.eclipse.jetty.server.session.AbstractSessionManager.renewSession(AbstractSessionManager.java:137)
at org.eclipse.jetty.security.authentication.LoginAuthenticator.renewSession(LoginAuthenticator.java:93)
at org.eclipse.jetty.security.authentication.LoginAuthenticator.login(LoginAuthenticator.java:50)
at org.eclipse.jetty.security.authentication.DigestAuthenticator.validateRequest(DigestAuthenticator.java:223)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:492)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:428)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
at net.i2p.router.web.LocaleWebAppHandler.handle(LocaleWebAppHandler.java:99)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:255)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:154)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
at org.eclipse.jetty.server.Server.handle(Server.java:370)
at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:494)
at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:971)
at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:1033)
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:644)
at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:235)
at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:667)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:701)

7/26/14 12:26:35 AM ERROR [JobQueue 1/1] .client.ClientConnectionRunner: Disconnecting the client - Too many leaseset request fails config: [SessionConfig:
Destination: [Destination:
Hash: *******************************************=
Certificate: [Certificate: type: Null payload: null]
PublicKey: [PublicKey: size: 256]
SigningPublicKey: [SigningPublicKey DSA_SHA1: size: 128]]
Signature: [Signature DSA_SHA1: size: 40]
Creation Date: Fri Jul 25 07:24:21 GMT 2014
Options: #: 41
[http.agent] = [I2P]
[http.keepAlive] = [false]
[i2cp.closeIdleTime] = [1800000]
[i2cp.closeOnIdle] = [false]
[i2cp.delayOpen] = [false]
[i2cp.dontPublishLeaseSet] = [true]
[i2cp.fastReceive] = [true]
[i2cp.messageReliability] = [none]
[i2cp.newDestOnResume] = [false]
[i2cp.reduceIdleTime] = [900000]
[i2cp.reduceOnIdle] = [true]
[i2cp.reduceQuantity] = [1]
[i2cp.tcp.host] = [127.0.0.1]
[i2cp.tcp.port] = [7654]
[i2p.dir.base] = [/usr/share/i2p]
[i2p.dir.pid] = [/var/run/i2p]
[i2p.dir.temp] = [/tmp/i2p-daemon]
[i2p.streaming.answerPings] = [false]
[i2p.streaming.connectDelay] = [1000]
[i2ptunnel.httpclient.jumpServers] = [http://i2host.i2p.xyz/cgi-bin/i2hostjump?,http://st...]
[i2ptunnel.httpclient.sendUserAgent] = [true]
[inbound.backupQuantity] = [0]
[inbound.length] = [3]
[inbound.lengthVariance] = [0]
[inbound.nickname] = [shared clients]
[inbound.quantity] = [2]
[jetty.class.path] = [/usr/share/i2p/lib/routerconsole.jar]
[loggerFilenameOverride] = [/var/log/i2p/log-router-@.txt]
[networkaddress.cache.negative.ttl] = [300]
[networkaddress.cache.ttl] = [300]
[org.mortbay.http.Version.paranoid] = [true]
[org.mortbay.xml.XmlParser.NotValidating] = [true]
[outbound.backupQuantity] = [0]
[outbound.length] = [3]
[outbound.lengthVariance] = [0]
[outbound.nickname] = [shared clients]
[outbound.quantity] = [2]
[outproxyAuth] = [false]
[persistentClientKey] = [false]
[proxyList] = [false.i2p.xyz]
[router.version] = [0.9.13]]

7/26/14 12:26:35 AM ↓↓↓ 3 similar messages omitted ↓↓↓

7/26/14 12:26:32 AM ERROR [JobQueue 2/4] uter.client.RequestLeaseSetJob: Error sending I2CP message requesting the lease set
net.i2p.data.i2cp.I2CPMessageException: I2CP write to queue failed
at net.i2p.router.client.QueuedClientConnectionRunner.doSend(QueuedClientConnectionRunner.java:69)
at net.i2p.router.client.RequestLeaseSetJob.runJob(RequestLeaseSetJob.java:104)
at net.i2p.router.JobQueueRunner.runCurrentJob(JobQueueRunner.java:134)
at net.i2p.router.JobQueueRunner.run(JobQueueRunner.java:75)
at java.lang.Thread.run(Thread.java:701)
at net.i2p.util.I2PThread.run(I2PThread.java:84)

7/26/14 12:26:31 AM ↓↓↓ 1 similar message omitted ↓↓↓

7/26/14 12:25:31 AM ERROR [JobQueue 1/1] uter.client.RequestLeaseSetJob: Failed to receive a leaseSet in the time allotted (59999): leaseSet request asking for [LeaseSet:
Destination: null
EncryptionKey: null
SigningKey: null
Signature: null
Leases: #2
[Lease:
End Date: Sat Jul 26 00:34:31 GMT 2014
Gateway: [Hash: *******************************************=]
TunnelId: 1600103670]
[Lease:
End Date: Sat Jul 26 00:26:13 GMT 2014
Gateway: [Hash: *******************************************=]
TunnelId: **********]] having received null succeeding? false expiring on 1406334331823 for *******************************************=

Sun, 27 Jul 2014, 10:16pm #6
zzz
Administrator
Zzz

The above errors are indications of problems somewhere but don't point to a root cause.

Re: covariance, my releases are compiled with Java 7. We don't use a bootstrap classpath as that would require anybody who compiles to have java 6 installed, even if compiling with a higher version.

@micster @pcook Please confirm what version crashed and where you got it.

Sun, 27 Jul 2014, 10:26pm #7
zzz
Administrator
Zzz

the following line in override.properties worked for me compiling on 7 (but then it works without it too). At least it compiled. Didn't try running it. Of course you need to have Java 6 JRE installed.

javac.compilerargs=-bootclasspath /usr/lib/jvm/java-6-openjdk-amd64/jre/lib/rt.jar:/usr/lib/jvm/java-6-openjdk-amd64/jre/lib/jce.jar

The trick is to try this when compiling with 8. I don't have 8 installed atm.

Sun, 27 Jul 2014, 10:58pm #8
micster
I2P Legend

I watched my tunnels a little more closely and took some notes...

At 4 minutes

Tunnels
Exploratory: 30
Client: 12
Participating: 0

Rejecting Tunnels: Starting Up

Local Destinations: Shared Clients

At 20 minutes
Tunnels
Exploratory: 18
Client: 12
Participating: 209

Accepting Tunnels

Local Destinations: Shared Clients

For the next hour the client and exploratory tunnels fluctuate up and down by a little bit while the participating tunnels continue to grow.

A little over 2 hours and Local Destinations shows "none"

Tunnels
Exploratory: 23
Client: 7
Participating: 726

Accepting Tunnels

Local Destinations: none

At this point I can no longer browse eepsites or use susimail. A few minutes later and Client Tunnels have dropped to zero.

What exactly are "Shared Clients" and should Local Destinations ever say "none"?

Sun, 27 Jul 2014, 10:58pm #9
zzz
Administrator
Zzz

If all the above is correct, here's what I propose adding to build.properties:

#
# Note to packagers, embedders, distributors:
#
# Strictly speaking, you must either use the compiler for the minimum Java version you are
# targeting (default 1.6, see above), or specify a bootclasspath, which means you need
# the JRE for the target version installed as well.
#
# However, in practice, you can compile with 1.7 and target 1.6 without specifying a bootclasspath,
# and it all works fine.
#
# But you cannot compile with 1.8 and target 1.6 or 1.7 without bootclasspath,
# or your users will get runtime errors.
# Below is an example of a bootclasspath that works on Ubuntu.
#
# For more info:
# http://zzz.i2p.xyz/topics/1668
# https://gist.github.com/AlainODea/1375759b8720a...
#
#javac.compilerargs=-bootclasspath /usr/lib/jvm/java-6-openjdk-amd64/jre/lib/rt.jar:/usr/lib/jvm/java-6-openjdk-amd64/jre/lib/jce.jar

Sun, 27 Jul 2014, 11:02pm #10
micster
I2P Legend

These were the only errors within the two hours mentioned above...

7/27/14 10:03:31 PM ERROR [JobQueue 2/4] .client.ClientConnectionRunner: Disconnecting the client - Too many leaseset request fails config: [SessionConfig:
Destination: [Destination:
Hash: *******************************************=
Certificate: [Certificate: type: Null payload: null]
PublicKey: [PublicKey: size: 256]
SigningPublicKey: [SigningPublicKey DSA_SHA1: size: 128]]
Signature: [Signature DSA_SHA1: size: 40]
Creation Date: Sun Jul 27 19:23:16 GMT 2014
Options: #: 42
[http.agent] = [I2P]
[http.keepAlive] = [false]
[i2cp.closeIdleTime] = [1800000]
[i2cp.closeOnIdle] = [false]
[i2cp.delayOpen] = [false]
[i2cp.dontPublishLeaseSet] = [true]
[i2cp.fastReceive] = [true]
[i2cp.messageReliability] = [none]
[i2cp.newDestOnResume] = [false]
[i2cp.reduceIdleTime] = [900000]
[i2cp.reduceOnIdle] = [false]
[i2cp.reduceQuantity] = [1]
[i2cp.tcp.host] = [127.0.0.1]
[i2cp.tcp.port] = [7654]
[i2p.dir.base] = [/usr/share/i2p]
[i2p.dir.pid] = [/var/run/i2p]
[i2p.dir.temp] = [/tmp/i2p-daemon]
[i2p.streaming.answerPings] = [false]
[i2p.streaming.connectDelay] = [1000]
[i2ptunnel.httpclient.jumpServers] = [http://i2host.i2p.xyz/cgi-bin/i2hostjump?,http://st...]
[i2ptunnel.httpclient.sendUserAgent] = [true]
[i2ptunnel.useLocalOutproxy] = [true]
[inbound.backupQuantity] = [3]
[inbound.length] = [3]
[inbound.lengthVariance] = [0]
[inbound.nickname] = [shared clients]
[inbound.quantity] = [3]
[jetty.class.path] = [/usr/share/i2p/lib/routerconsole.jar]
[loggerFilenameOverride] = [/var/log/i2p/log-router-@.txt]
[networkaddress.cache.negative.ttl] = [300]
[networkaddress.cache.ttl] = [300]
[org.mortbay.http.Version.paranoid] = [true]
[org.mortbay.xml.XmlParser.NotValidating] = [true]
[outbound.backupQuantity] = [3]
[outbound.length] = [3]
[outbound.lengthVariance] = [0]
[outbound.nickname] = [shared clients]
[outbound.quantity] = [3]
[outproxyAuth] = [false]
[persistentClientKey] = [false]
[proxyList] = [false.i2p.xyz]
[router.version] = [0.9.13]]

7/27/14 10:03:31 PM ↓↓↓ 1 similar message omitted ↓↓↓
7/27/14 10:03:17 PM ↓↓↓ 3 similar messages omitted ↓↓↓
7/27/14 10:02:51 PM ↓↓↓ 1 similar message omitted ↓↓↓

7/27/14 10:02:48 PM ERROR [JobQueue 4/4] uter.client.RequestLeaseSetJob: Error sending I2CP message requesting the lease set
net.i2p.data.i2cp.I2CPMessageException: I2CP write to queue failed
at net.i2p.router.client.QueuedClientConnectionRunner.doSend(QueuedClientConnectionRunner.java:69)
at net.i2p.router.client.RequestLeaseSetJob.runJob(RequestLeaseSetJob.java:104)
at net.i2p.router.JobQueueRunner.runCurrentJob(JobQueueRunner.java:134)
at net.i2p.router.JobQueueRunner.run(JobQueueRunner.java:75)
at java.lang.Thread.run(Thread.java:701)
at net.i2p.util.I2PThread.run(I2PThread.java:84)

Sun, 27 Jul 2014, 11:11pm #11
micster
I2P Legend

I'm running Ubuntu 12.04 and I installed i2p by adding the PPA as outlined on http://geti2p.net

deb http://ppa.launchpad.net/i2p-maintainers/i2p/ub... precise main
deb-src http://ppa.launchpad.net/i2p-maintainers/i2p/ub... precise main

I2P version: 0.9.13-0-1~pq1
Java version: Sun Microsystems Inc. 1.6.0_31 (OpenJDK Runtime Environment 1.6.0_31-b31)
Wrapper version: 3.5.22
Server version: 8.1.14.v20131031
Servlet version: Jasper JSP 2.1 Engine
Platform: Linux amd64 3.2.0-61-generic
Processor: Core 2 (Conroe) (core2)
Jbigi: Locally optimized native BigInteger library loaded from file
Encoding: UTF-8
Charset: UTF-8

Mon, 28 Jul 2014, 01:45am #12
str4d
I2P Legend
Str4d

micster wrote:

What exactly are "Shared Clients" and should Local Destinations ever say "none"?

"Shared Clients" shows up when a client tunnel in I2PTunnel is set to use shared client tunnels. Normally, each client or server tunnel has its own "tunnel pool" of inbound and outbound tunnels. With "Shared Clients" enabled, a client tunnel will use the same tunnel pool as other "shared clients" tunnels. Those tunnels will all have the same I2P Destination.

Local Destinations will say "none" when there are no tunnels running at all. This is always the case at startup, but I2PTunnel will start any tunnels with "autostart" set within a few minutes of the router being started.

Now, on to your bug:

micster wrote:

These were the only errors within the two hours mentioned above...
7/27/14 10:03:31 PM ERROR [JobQueue 2/4] .client.ClientConnectionRunner: Disconnecting the client - Too many leaseset request fails

This is why "Shared Clients" is disappearing - the router is disconnecting it because it can't fetch a LeaseSet from the client. The client (I2PTunnel) is the one with the signing keys, so the router creates a LeaseSet and sends it over I2CP to the client to sign. In your case, the router and client are in the same process, and the I2CP connection is an internal queue. Which leads us to the earlier errors:

micster wrote:

7/27/14 10:03:31 PM ↓↓↓ 1 similar message omitted ↓↓↓
7/27/14 10:03:17 PM ↓↓↓ 3 similar messages omitted ↓↓↓
7/27/14 10:02:51 PM ↓↓↓ 1 similar message omitted ↓↓↓

7/27/14 10:02:48 PM ERROR [JobQueue 4/4] uter.client.RequestLeaseSetJob: Error sending I2CP message requesting the lease set
net.i2p.data.i2cp.I2CPMessageException: I2CP write to queue failed
at net.i2p.router.client.QueuedClientConnectionRunner.doSend(QueuedClientConnectionRunner.java:69)
at net.i2p.router.client.RequestLeaseSetJob.runJob(RequestLeaseSetJob.java:104)
at net.i2p.router.JobQueueRunner.runCurrentJob(JobQueueRunner.java:134)
at net.i2p.router.JobQueueRunner.run(JobQueueRunner.java:75)
at java.lang.Thread.run(Thread.java:701)
at net.i2p.util.I2PThread.run(I2PThread.java:84)

The error(s) above get thrown if an I2CP message cannot be written to the queue; this happens if there is no space in the queue. Somehow, the client-side is not reading from the queue quickly enough, or the router side is filling the queue too quickly. Either way, after some time (two hours in your experience) the I2CP queue from router to client becomes completely full; the router can no longer get new LeaseSets signed, and cannot maintain the tunnel pool (which requires new LeaseSets to be published every ~10 min), so must disconnect it.

Next question: why is the queue filling up?

Mon, 28 Jul 2014, 03:28am #13
micster
I2P Legend

After restarting my router from before, the I2CP queue from router to client became completely full after just 30 minutes! So it would seem that the time taken to fill the que might fluctuate.

Once I lose all my Client Tunnels, if I click on Local Destinations then the i2ptunnelmgr still shows the I2P HTTP Proxy as "Running" (even though Local Destinations says none). Most everything else is in "Standby" mode which is normal for my setup.

I pressed the "Stop" button next to I2P HTTP Proxy and it dutifully shutdown. Then upon pressing "Start" everything begins working again. As I'm writing this it is still up and functioning.

I believe this problem is new. Please let me know what other information I can provide to help diagnose.

Mon, 28 Jul 2014, 08:01am #14
pcook
Contributor

This is what happened after downloading update 0.9.13-7 and restarting i2p. As I said earlier, the same thing started happening just before 0.9.12-15. Everything would start up and look good, with both exploratory and client tunnels, then after about 20 minutes exploratory tunnels would go down to 2 and client tunnels would be 0. There would, however, be participating traffic. I would update back to 0.9.12 and everything would be back to normal. I get unsigned builds from:

http://echelon.i2p.xyz/update/i2pupdate.zip

After the update is in place:

I2P version: 0.9.13-7
Java version: Oracle Corporation 1.7.0_55 (Java(TM) SE Runtime Environment 1.7.0_55-b13)
Wrapper version: 3.5.14
Server version: 8.1.15.v20140411
Servlet version: Jasper JSP 2.1 Engine
Platform: Windows 7 amd64 6.1
Processor: Phenom II / Opteron Gen 3 (Shanghai/Deneb/Heka/Callisto, 45 nm) (athlon64)
Jbigi: Locally optimized native BigInteger library loaded from file
Encoding: Cp1252
Charset: windows-1252

*******

Critical Logs

14/06/14 12:44:26 AM CRIT [uterWatchdog] 2p.router.tasks.RouterWatchdog: Router appears hung, or there is severe network congestion. Watchdog starts barking!

*******

Router Logs (configure)

14/06/14 7:38:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Memory: 66.80MB / 114.00MB
14/06/14 7:38:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Outbound send rate: 268Bps
14/06/14 7:38:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: 1 minute send processing time: 854ms
14/06/14 7:38:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Participating tunnel count: 3
14/06/14 7:38:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Job lag: 0
14/06/14 7:38:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Ready and waiting jobs: 0
14/06/14 7:38:27 AM ERROR [uterWatchdog] client.ClientManagerFacadeImpl: Client 5DBRnR has a leaseSet that expired 7h
14/06/14 7:38:27 AM ERROR [uterWatchdog] client.ClientManagerFacadeImpl: Client fUvvV8 has a leaseSet that expired 7h
14/06/14 7:38:27 AM ERROR [uterWatchdog] client.ClientManagerFacadeImpl: Client 3-fBug has a leaseSet that expired 7h
14/06/14 7:37:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Memory: 55.16MB / 114.00MB
14/06/14 7:37:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Outbound send rate: 106Bps
14/06/14 7:37:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: 1 minute send processing time: 4513ms
14/06/14 7:37:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Participating tunnel count: 0
14/06/14 7:37:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Job lag: 0
14/06/14 7:37:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Ready and waiting jobs: 0
14/06/14 7:37:27 AM ERROR [uterWatchdog] client.ClientManagerFacadeImpl: Client 5DBRnR has a leaseSet that expired 7h
14/06/14 7:37:27 AM ERROR [uterWatchdog] client.ClientManagerFacadeImpl: Client fUvvV8 has a leaseSet that expired 7h
14/06/14 7:37:27 AM ERROR [uterWatchdog] client.ClientManagerFacadeImpl: Client 3-fBug has a leaseSet that expired 7h
14/06/14 7:36:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Memory: 64.60MB / 114.00MB
14/06/14 7:36:27 AM ERROR [uterWatchdog] 2p.router.tasks.RouterWatchdog: Outbound send rate: 753Bps

*******

Service (Wrapper) Logs (I've only included after the update)

2014/06/14 00:16:25 | Launching a JVM...
2014/06/14 00:16:25 | WrapperManager: Initializing...
2014/06/14 00:16:25 | Starting I2P 0.9.13-7
2014/06/14 00:16:26 | INFO: Native CPUID library jcpuid-x86-windows loaded from file
2014/06/14 00:16:26 | INFO: Locally optimized native BigInteger library loaded from file
2014/06/14 00:16:37 | INFO: Jetty 8.1.15.v20140411 logging to I2P logs using class org.eclipse.jetty.server.Server
2014/06/14 00:16:38 | 2014-06-14 07:16:38.010:INFO:oejs.Server:jetty-8.1.15.v20140411
2014/06/14 00:16:47 | INFO: BOB is now running.
2014/06/14 00:17:07 | 2014-06-14 07:17:07.605:INFO:oejs.Server:jetty-8.1.15.v20140411
2014/06/14 00:21:50 | Adding Neodatis ODB to the JVM globally.
2014/06/14 00:21:50 | Adding `H:\Program Files\i2p\plugins\01_neodatis\lib\neodatis.jar` to classpath
2014/06/14 00:21:50 | PatchLevel 17
2014/06/14 00:21:50 | NeoDatis ODB Server is to be located at 127.0.0.1:65534
2014/06/14 00:21:50 | Added Neodatis ODB to the JVM Successfully.
2014/06/14 00:21:52 | Adding SeedlessCore to the JVM globally.
2014/06/14 00:21:52 | Adding `H:\Program Files\i2p\plugins\02_seedless\lib\SeedlessCore.jar` to classpath
2014/06/14 00:21:52 | SeedlessCore version: 00.01.07
2014/06/14 00:21:52 | Neodatis ODB version: 2.1.beta14-209 (21-02-2010-20-30-42)PatchLevel 17
2014/06/14 00:21:52 | Added SeedlessCore to the JVM Successfully.
2014/06/14 00:21:52 | Checking Version
2014/06/14 00:21:52 | Version OK
2014/06/14 00:21:55 | Attempting to start NeoDatis ODB Server on 127.0.0.1:65534
2014/06/14 00:21:55 | NeoDatis ODB Server [version=2.1.beta14 - build=209 - 21-02-2010-20-30-42] running on port 65534
2014/06/14 00:21:56 | SeedlessSeedFinder is using discovered setting of:127.0.0.1:4444
2014/06/14 00:21:56 | SeedlessSeedFinder server context initialized
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/i2pbote.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/mailapi.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/bcprov-ecc-jdk16-146.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/flexi-gmss-1.7p1.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/ntruenc-1.2.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/scrypt-1.3.3.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/lzma-9.20.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/apache-james-imap-api-0.3.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/apache-james-imap-message-0.3.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/apache-james-imapprocessor-0.3.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/apache-james-mailbox-api-0.4.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/apache-james-mailbox-store-0.4.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/apache-mime4j-core-0.7.2.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/commons-codec-1.5.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/commons-collections-3.2.1.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/commons-configuration-1.6.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/commons-io-2.0.1.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/commons-lang-2.6.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbotelib/james-server-lifecycle-api-3.0-beta4.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/james-server-protocols-imap4-3.0-beta4.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbotelibjames-server-protocols-library-3.0-beta4.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/james-server-util-3.0-beta4.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/libjutf7-1.0.0.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/netty-3.3.1.Final.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/protocols-api-1.6.2.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/protocolsnetty-1.6.2.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/slf4j-api-1.6.1.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/slf4j-jcl-1.7.5.jar to classpath for i2pbote
2014/06/14 00:21:57 | Adding H:\Program Files\i2p\plugins\i2pbote/lib/subethasmtp-3.1.7.jar to classpath for i2pbote
2014/06/14 00:21:59 | Waiting to launch SeedlessSeedFinder.
2014/06/14 00:21:59 | TunnelMonitor launching.
2014/06/14 00:21:59 | TunnelMonitor launched.
2014/06/14 00:21:59 | Proxy discovered at 127.0.0.1:4444
2014/06/14 00:21:59 | SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
2014/06/14 00:21:59 | SLF4J: Defaulting to no-operation (NOP) logger implementation
2014/06/14 00:21:59 | SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details.
2014/06/14 00:21:59 | SLF4J: Failed to load class "org.slf4j.impl.StaticMDCBinder".
2014/06/14 00:21:59 | SLF4J: Defaulting to no-operation MDCAdapter implementation.
2014/06/14 00:21:59 | SLF4J: See http://www.slf4j.org/codes.html#no_static_mdc_b... for further details.
2014/06/14 00:22:08 | 2014-06-14 07:22:08.432:INFO:oejs.Server:jetty-8.1.15.v20140411
2014/06/14 00:22:09 | Hurray! A proxy resource came up.
2014/06/14 00:22:09 | Waiting one minute for tunnel to build.
2014/06/14 00:23:09 | Please fasten seatbelts, SeedlessSeedFinder is now launched.
2014/06/14 00:23:09 | SeedlessCache is using discovered setting of:127.0.0.1:4444
2014/06/14 00:23:09 | Please fasten seatbelts, SeedlessCache is now launched.
2014/06/14 00:27:35 | Thread terminated unexpectedly: BuildExecutor
2014/06/14 00:27:35 | java.lang.NoSuchMethodError: java.util.concurrent.ConcurrentHashMap.keySet()Ljava/util/concurrent/ConcurrentHashMap$KeySetView;
2014/06/14 00:27:35 | at net.i2p.util.ObjectCounter.objects(ObjectCounter.java:50)
2014/06/14 00:27:35 | at net.i2p.router.tunnel.pool.TunnelPoolManager.selectPeersInTooManyTunnels(TunnelPoolManager.java:604)
2014/06/14 00:27:35 | at net.i2p.router.tunnel.pool.TunnelPeerSelector.getExclude(TunnelPeerSelector.java:203)
2014/06/14 00:27:35 | at net.i2p.router.tunnel.pool.ClientPeerSelector.selectPeers(ClientPeerSelector.java:36)
2014/06/14 00:27:35 | at net.i2p.router.tunnel.pool.TunnelPool.configureNewTunnel(TunnelPool.java:1121)
2014/06/14 00:27:35 | at net.i2p.router.tunnel.pool.TunnelPool.configureNewTunnel(TunnelPool.java:1084)
2014/06/14 00:27:35 | at net.i2p.router.tunnel.pool.BuildExecutor.run(BuildExecutor.java:367)
2014/06/14 00:27:35 | at java.lang.Thread.run(Unknown Source)
2014/06/14 00:27:35 | at net.i2p.util.I2PThread.run(I2PThread.java:84)
2014/06/14 00:30:55 | java.io.IOException: Input stream error
2014/06/14 00:30:55 | at net.i2p.client.streaming.impl.MessageInputStream.throwAnyError(MessageInputStream.java:498)
2014/06/14 00:30:55 | at net.i2p.client.streaming.impl.MessageInputStream.read(MessageInputStream.java:327)
2014/06/14 00:30:55 | at sun.nio.cs.StreamDecoder.readBytes(Unknown Source)
2014/06/14 00:30:55 | at sun.nio.cs.StreamDecoder.implRead(Unknown Source)
2014/06/14 00:30:55 | at sun.nio.cs.StreamDecoder.read(Unknown Source)
2014/06/14 00:30:55 | at java.io.InputStreamReader.read(Unknown Source)
2014/06/14 00:30:55 | at java.io.BufferedReader.fill(Unknown Source)
2014/06/14 00:30:55 | at java.io.BufferedReader.readLine(Unknown Source)
2014/06/14 00:30:55 | at java.io.BufferedReader.readLine(Unknown Source)
2014/06/14 00:30:55 | at i2p.bote.service.seedless.SeedlessAnnounce.doSeedlessAnnounce(SeedlessAnnounce.java:151)
2014/06/14 00:30:55 | at i2p.bote.service.seedless.SeedlessAnnounce.run(SeedlessAnnounce.java:89)
2014/06/14 00:30:55 | Caused by: java.io.IOException: Reset received
2014/06/14 00:30:55 | at net.i2p.client.streaming.impl.Connection.resetReceived(Connection.java:609)
2014/06/14 00:30:55 | at net.i2p.client.streaming.impl.ConnectionPacketHandler.verifyReset(ConnectionPacketHandler.java:528)
2014/06/14 00:30:55 | at net.i2p.client.streaming.impl.ConnectionPacketHandler.verifyPacket(ConnectionPacketHandler.java:480)
2014/06/14 00:30:55 | at net.i2p.client.streaming.impl.ConnectionPacketHandler.receivePacket(ConnectionPacketHandler.java:46)
2014/06/14 00:30:55 | at net.i2p.client.streaming.impl.PacketHandler.receiveKnownCon(PacketHandler.java:158)
2014/06/14 00:30:55 | at net.i2p.client.streaming.impl.PacketHandler.receivePacketDirect(PacketHandler.java:105)
2014/06/14 00:30:55 | at net.i2p.client.streaming.impl.PacketHandler.receivePacket(PacketHandler.java:92)
2014/06/14 00:30:55 | at net.i2p.client.streaming.impl.MessageHandler.messageAvailable(MessageHandler.java:68)
2014/06/14 00:30:55 | at net.i2p.client.I2PSessionDemultiplexer.messageAvailable(I2PSessionDemultiplexer.java:39)
2014/06/14 00:30:55 | at net.i2p.client.I2PSessionMuxedImpl$MuxedAvailabilityNotifier.run(I2PSessionMuxedImpl.java:369)
2014/06/14 00:30:55 | at java.lang.Thread.run(Unknown Source)
2014/06/14 00:30:55 | at net.i2p.util.I2PThread.run(I2PThread.java:84)
2014/06/14 00:44:28 | CRIT [uterWatchdog] 2p.router.tasks.RouterWatchdog: Router appears hung, or there is severe network congestion. Watchdog starts barking!

*******

From the side panel:

Version: 0.9.13-7
Uptime: 7 hours
Network: OK
Peers
Active: 111 / 654
Fast: 24
High capacity: 150
Integrated: 651
Known: 813
Bandwidth in/out
3 sec: 0.66 / 1.09 KBps
5 min: 1.10 / 1.59 KBps
Total: 1.09 / 1.66 KBps
Used: 28.91 MB / 44.44 MB
Tunnels
Exploratory: 2
Client: 0
Participating: 1
Share ratio: 0.25
Congestion
Job lag: 5 ms
Message delay: 2434 ms
Backlog: 0
Rejecting tunnels: High message delay
Local Destinations
Client shared clients Building…
Server I2P-Bote Building…

I hope this helps.

Mon, 28 Jul 2014, 12:53pm #15
zzz
Administrator
Zzz

pcook wrote:

2014/06/14 00:27:35 | Thread terminated unexpectedly: BuildExecutor
2014/06/14 00:27:35 | java.lang.NoSuchMethodError: java.util.concurrent.ConcurrentHashMap.keySet()Ljava/util/concurrent/ConcurrentHashMap$KeySetView;

Yep, you have the same problem.

Thanks for confirming you got it from echelon.

I recommend you do a manual update to 0.9.14 following the instructions at the bottom of the website download page.

Mon, 28 Jul 2014, 01:46pm #16
pcook
Contributor

Hi ZZZ!

Thank you for the quick reply. As I had mentioned earlier, changing from Java 7 to Java 8 fixed the problem that I was having. After upgrading to Java 8, I updated i2p from the version that I had been having to run, 0.9.12, to 0.9.13-7 using the saved i2pupdate file. I2p (0.9.13-7) was then able to run normally and automatically update (well, once I gave the OK) to 0.9.13-11, then 0.9.13-13, and last night to 0.9.14, using I2PSnark to download the update in the normal fashion each time.

My current system information is:

I2P version: 0.9.14-0
Java version: Oracle Corporation 1.8.0_11 (Java(TM) SE Runtime Environment 1.8.0_11-b12)
Wrapper version: 3.5.14
Server version: 8.1.15.v20140411
Servlet version: Jasper JSP 2.1 Engine
Platform: Windows 7 amd64 6.1
Processor: Phenom II / Opteron Gen 3 (Shanghai/Deneb/Heka/Callisto, 45 nm) (athlon64)
Jbigi: Locally optimized native BigInteger library loaded from file
Encoding: Cp1252
Charset: windows-1252

Mon, 28 Jul 2014, 05:10pm #17
echelon
I2P Legend

Moin

The issue is with the build of the unofficial mtn update versions.
I did switch to java 7 again, and will build all future mtn version on java 7 again.

echelon

Tue, 29 Jul 2014, 05:57pm #18
micster
I2P Legend

It's been a little over 20 hours since I upgraded to this version:

I2P version: 0.9.14-0-1~pq1
Java version: Sun Microsystems Inc. 1.6.0_31 (OpenJDK Runtime Environment 1.6.0_31-b31)
Wrapper version: 3.5.25
Server version: 8.1.15.v20140411
Servlet version: Jasper JSP 2.1 Engine
Platform: Linux amd64 3.2.0-61-generic
Processor: Core 2 (Conroe) (core2)
Jbigi: Locally optimized native BigInteger library loaded from file
Encoding: UTF-8
Charset: UTF-8
and were still going strong! Not a single Critical Log message.

Thanks for all the help.