"Waited more than 200ms to dequeue, 10 in queue, 2143 millis since enqueued last item, 5065 maximum waits so far - could indicate serious JVM bug. Please report to [EMAIL PROTECTED] along with JVM and OS/kernel.
08.01.2004 13:17:41 (freenet.support.BlockingQueue, Ticker immediate execution thread, NORMAL): Waited more than 200ms to dequeue, 10 in queue, 2143 millis since enqueued last item, 5065 maximum waits so far - could indicate serious JVM bug. Please report to [EMAIL PROTECTED] along with JVM and OS/kernel."
for full log of this session see attached logfile.
windows xp
java -version: java version "1.4.2_01" Java(TM) 2 Runtime Environment, Standard Edition (build 1.4.2_01-b06) Java HotSpot(TM) Client VM (build 1.4.2_01-b06, mixed mode)
additional info: i multiplied the outbound bandwith in the advanced tab by 4. sorry for causing you work if this is the problem!
greets sascha
requestIntervalDefault: 1000
requestIntervalQRFactor: 1.05
requestIntervalAcceptedFactor: 0.9523809523809523
08.01.2004 13:04:35 (freenet.node.Main, main, NORMAL): loading node keys: node
08.01.2004 13:04:35 (freenet.node.Main, main, NORMAL): Read node file
08.01.2004 13:04:35 (freenet.node.Main, main, NORMAL): starting filesystem
08.01.2004 13:04:46 (freenet.node.Main, main, NORMAL): loading data store
08.01.2004 13:04:46 (freenet.node.Main, main, NORMAL): loading routing table
08.01.2004 13:04:51 (freenet.node.Main, main, NORMAL): Loaded stats
08.01.2004 13:04:51 (freenet.node.Main, main, NORMAL): loading temp bucket factory
08.01.2004 13:04:51 (freenet.node.Main, main, NORMAL): loaded temp bucket factory
08.01.2004 13:04:51 (freenet.node.Main, main, NORMAL): Loaded bucket factory
08.01.2004 13:05:04 (freenet.node.Main, main, NORMAL): read seed nodes
08.01.2004 13:05:04 (freenet.node.Main, main, NORMAL): Initial refs count: 593
08.01.2004 13:05:04 (freenet.node.Main, main, NORMAL): not seeding routing table
08.01.2004 13:05:04 (freenet.node.Main, main, NORMAL): saved routing table
08.01.2004 13:05:04 (freenet.node.Main, main, NORMAL): starting node
08.01.2004 13:05:05 (freenet.node.Main, main, NORMAL): loading service: mainport
08.01.2004 13:05:05 (freenet.node.Main, main, NORMAL): loading service: distribution
08.01.2004 13:05:05 (freenet.interfaces.servlet.SingleHttpServletContainer, main,
NORMAL): Loading the single servlet distribution.params.servlet
08.01.2004 13:05:05 (freenet.node.Node, main, NORMAL): Starting ticker..
08.01.2004 13:05:05 (freenet.node.Node, main, NORMAL): Starting interfaces..
08.01.2004 13:05:06 (freenet.node.http.BookmarkManagerServlet, main, NORMAL):
Bookmarks updated on request
08.01.2004 13:05:06 (freenet.node.http.infolets.DefaultInfolet, main, NORMAL):
Bookmarks updated on request: new bookmarks: Params: 1 Options:
0: count: mainport.params.servlet.2.bookmarks.count/=-1(1,true,6000)
End of Local Options.
0: 4: Params: 4 Options:
0: activelinkFile:
mainport.params.servlet.2.bookmarks.4.activelinkFile/=activelink.png(1,true,6142)
1: key:
mainport.params.servlet.2.bookmarks.4.key/=SSK%40Sc6qV~D6iFhaYord6HtbjJ8MaEYPAgM/YoYo//(1,true,6140)
2: description: mainport.params.servlet.2.bookmarks.4.description/=Categorized freenet
index(1,true,6143)
3: title: mainport.params.servlet.2.bookmarks.4.title/=YoYo!(1,true,6141)
End of Local Options.
{}End.
1: 3: Params: 4 Options:
0: activelinkFile:
mainport.params.servlet.2.bookmarks.3.activelinkFile/=CofETitle.jpg(1,true,6132)
1: key:
mainport.params.servlet.2.bookmarks.3.key/=SSK%409G4s~jLQJB7ALQg-v2q5xKAJy9YPAgM/CofE//(1,true,6130)
2: description: mainport.params.servlet.2.bookmarks.3.description/=One of Freenet's
oldest Freesites, witty discussion of Freenet, the universe, and
everything(1,true,6133)
3: title: mainport.params.servlet.2.bookmarks.3.title/=Content of Evil(1,true,6131)
End of Local Options.
{}End.
2: 2: Params: 4 Options:
0: activelinkFile:
mainport.params.servlet.2.bookmarks.2.activelinkFile/=activelink.png(1,true,6122)
1: key:
mainport.params.servlet.2.bookmarks.2.key/=SSK%40-w495UL3mfSlWC2c%7enRAuG2fAWwPAgM/TFEE//(1,true,6120)
2: description: mainport.params.servlet.2.bookmarks.2.description/=Categorized
automatically generated index with Google-like page ranking(1,true,6123)
3: title: mainport.params.servlet.2.bookmarks.2.title/=The Tower (TFEE)(1,true,6121)
End of Local Options.
{}End.
3: 1: Params: 4 Options:
0: activelinkFile:
mainport.params.servlet.2.bookmarks.1.activelinkFile/=ActiveLink.png(1,true,6112)
1: key: mainport.params.servlet.2.bookmarks.1.key/[EMAIL
PROTECTED]/FreenetHelp//(1,true,6110)
2: description: mainport.params.servlet.2.bookmarks.1.description/=Index of Freenet
help resources(1,true,6113)
3: title: mainport.params.servlet.2.bookmarks.1.title/=The Freenet Help
Index(1,true,6111)
End of Local Options.
{}End.
4: 0: Params: 4 Options:
0: activelinkFile:
mainport.params.servlet.2.bookmarks.0.activelinkFile/=ActiveLink.jpg(1,true,6102)
1: key:
mainport.params.servlet.2.bookmarks.0.key/=SSK%40rBjVda8pC-Kq04jUurIAb8IzAGcPAgM/TFE//(1,true,6100)
2: description: mainport.params.servlet.2.bookmarks.0.description/=Oldest living
Freenet portal(1,true,6103)
3: title: mainport.params.servlet.2.bookmarks.0.title/=The Freedom Engine(1,true,6101)
End of Local Options.
{}End.
{}End.
08.01.2004 13:05:08 (freenet.node.Node, main, NORMAL): starting ListenSelector..
08.01.2004 13:05:08 (freenet.node.Node, main, NORMAL): Scheduling open on all 49
connections
08.01.2004 13:13:27 (freenet.message.DataRequest, QThread-265, NORMAL): Long
messageInitialStateTime 3845 : freenet.Message: DataRequest @[EMAIL PROTECTED] for
tcp/connection: 80.34.85.86:3199>local,[EMAIL PROTECTED],[EMAIL PROTECTED], sending
null:-1 for [EMAIL PROTECTED] (DSA(8308 b3df 9faf 9988 8dfd 24ba d4e7 b04a 7edf
7b9c),tcp/80.34.85.86:64067, sessions=1, presentations=1, ID=DSA(8308 b3df 9faf 9988
8dfd 24ba d4e7 b04a 7edf 7b9c)): outbound attempts=0:7/7 @ ba96d4acd5a0a5e3
08.01.2004 13:13:28 (freenet.support.io.NIOInputStream, QThread-115, NORMAL): waited
more than 5 minutes in NIOIS.read() tcp/connection: 3650>129.13.162.73:24,[EMAIL
PROTECTED]:[EMAIL PROTECTED] closing
java.lang.Exception: debug
at freenet.support.io.NIOInputStream.read(NIOInputStream.java:293)
at java.io.FilterInputStream.read(Unknown Source)
at freenet.session.FnpLink.negotiateOutbound(FnpLink.java:607)
at freenet.session.FnpLink.solicit(FnpLink.java:174)
at freenet.session.FnpLinkManager.createOutgoing(FnpLinkManager.java:104)
at
freenet.OpenConnectionManager$ConnectionJob.run(OpenConnectionManager.java:976)
at
freenet.OpenConnectionManager.createConnection(OpenConnectionManager.java:551)
at freenet.node.ConnectionOpener.checkpoint(ConnectionOpener.java:182)
at freenet.node.states.maintenance.Checkpoint.checkpoint(Checkpoint.java:54)
at freenet.node.states.maintenance.Checkpoint.received(Checkpoint.java:47)
at freenet.node.StateChain.received(StateChain.java:192)
at freenet.node.StateChain.received(StateChain.java:68)
at
freenet.node.StandardMessageHandler$Ticket.run(StandardMessageHandler.java:235)
at
freenet.node.StandardMessageHandler$Ticket.received(StandardMessageHandler.java:173)
at
freenet.node.StandardMessageHandler$Ticket.access$100(StandardMessageHandler.java:125)
at freenet.node.StandardMessageHandler.handle(StandardMessageHandler.java:73)
at freenet.Ticker$Event.run(Ticker.java:324)
at freenet.thread.QThreadFactory$QThread.run(QThreadFactory.java:234)
Waited more than 200ms to dequeue, 10 in queue, 2143 millis since enqueued last item,
5065 maximum waits so far - could indicate serious JVM bug. Please report to [EMAIL
PROTECTED] along with JVM and OS/kernel.
08.01.2004 13:17:41 (freenet.support.BlockingQueue, Ticker immediate execution thread,
NORMAL): Waited more than 200ms to dequeue, 10 in queue, 2143 millis since enqueued
last item, 5065 maximum waits so far - could indicate serious JVM bug. Please report
to [EMAIL PROTECTED] along with JVM and OS/kernel.
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
State FAILED reached. for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
RouteNotFound, reason: No route found for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
The query was restarted somewhere on Freenet after a node failed to reply, waiting
another 77 seconds before I give up for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
The query was restarted somewhere on Freenet after a node failed to reply, waiting
another 83 seconds before I give up for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
The query was restarted somewhere on Freenet after a node failed to reply, waiting
another 89 seconds before I give up for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
The query was restarted somewhere on Freenet after a node failed to reply, waiting
another 95 seconds before I give up for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
The query was restarted somewhere on Freenet after a node failed to reply, waiting
another 107 seconds before I give up for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
The query was restarted somewhere on Freenet after a node failed to reply, waiting
another 118 seconds before I give up for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
The query was restarted somewhere on Freenet after a node failed to reply, waiting
another 124 seconds before I give up for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
The query was restarted somewhere on Freenet after a node failed to reply, waiting
another 135 seconds before I give up for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
The query was restarted somewhere on Freenet after a node failed to reply, waiting
another 141 seconds before I give up for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
The query was restarted somewhere on Freenet after a node failed to reply, waiting
another 157 seconds before I give up for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
State REQUESTING reached. for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.client.GetRequestProcess, QThread-419, NORMAL): Event:
State PREPARED reached. for [EMAIL PROTECTED]:freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/[EMAIL PROTECTED],true before
failure
08.01.2004 13:20:11 (freenet.node.rt.CPAlgoRoutingTable$CPAlgoData$LookupARK,
QThread-380, NORMAL): RouteNotFound Fetching ARK freenet:[EMAIL
PROTECTED],1YjJZAp7YRuzINydQ3BKhU-N~Y3Bji3XjTlFHV~FSM0/32
_______________________________________________ Support mailing list [EMAIL PROTECTED] http://news.gmane.org/gmane.network.freenet.support
