[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

[xmlblaster] java.lang.NullPointerException on doSend with svn checkout



rev 15545

I get the same strange exception. 

I'm not a java guru, so I can't tell if 'i' is out of range or if .get is returning Null

         if (oneways != null) {
            for (int i=0; i<oneways.size(); i++) {
               Holder holder = (Holder)responders.get(i);  <-- boom

               SubscriptionInfo subscriptionInfo = null;


here's fine logging if it helps:


Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.SubscriptionInfo initSubscriptionId: Generated child subscription ID=_subId:customs_resubmit:1160427411321000000
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.util.admin.extern.JmxWrapper registerMBean: Registered MBean 'org.xmlBlaster:nodeClass=node,node="xmlBlaster_192_168_1_4_3412",subscriptionClass=subscription,subscription="_subId:customs_resubmit:1160427411321000000"' for JMX monitoring and control
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.SubscriptionInfo init: Created SubscriptionInfo '_subId:customs_resubmit:1160427411321000000' for client 'client/customs/session/1' for topic 'xmlBlaster_192_168_1_4_3412-1160427410364000000'
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.xml2java.XmlKey match: XPath subscription '/xmlBlaster/key/customs/save_pending' does NOT match message 'xmlBlaster_192_168_1_4_3412-1160427410364000000'
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.xml2java.XmlKey match: XPath subscription '/xmlBlaster/key/customs/lookup' does NOT match message 'xmlBlaster_192_168_1_4_3412-1160427410364000000'
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.xml2java.XmlKey match: XPath subscription '/xmlBlaster/key/customs/commit_batch' does NOT match message 'xmlBlaster_192_168_1_4_3412-1160427410364000000'
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.RequestBroker fireSubscriptionEvent: Going to fire fireSubscriptionEvent(true) ...
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.ClientSubscriptions subscriptionAdd: Subscription add event _subId:customs_resubmit:1160427411321000000 / /node/xmlBlaster_192_168_1_4_3412/client/customs/session/1 / xmlBlaster_192_168_1_4_3412-1160427410364000000
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.ClientSubscriptions subscriptionAdd: Adding subscriptionId=_subId:customs_resubmit:1160427411321000000 to subMap of client /node/xmlBlaster_192_168_1_4_3412/client/customs/session/1
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.SubscriptionInfo addTopicHandler: Assign to SubscriptionInfo '_subId:customs_resubmit:1160427411321000000' for client '/node/xmlBlaster_192_168_1_4_3412/client/customs/session/1' topic 'xmlBlaster_192_168_1_4_3412-1160427410364000000'
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.TopicHandler addSubscriber: /topic/xmlBlaster_192_168_1_4_3412-1160427410364000000: Client '/node/xmlBlaster_192_168_1_4_3412/client/customs/session/1' has successfully subscribed
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.TopicHandler addSubscriber: /topic/xmlBlaster_192_168_1_4_3412-1160427410364000000: addSubscriber(_subId:customs_resubmit:1160427411321000000)
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.xml2java.XmlKey cleanupMatch: Releasing tiny DOM tree
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.MsgUnitWrapper <init>: Created new MsgUnitWrapper instance 'org.xmlBlaster.engine.MsgUnitWrapper at 1958cc2'
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.queuemsg.MsgQueueHistoryEntry <init>: Created new MsgQueueHistoryEntry for published message, id=-1160427411341000000 prio=NORM
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.util.queue.cache.CacheQueueInterceptorPlugin checkSpaceAvailable: history:xmlBlaster_192_168_1_4_3412/xmlBlaster_192_168_1_4_3412-1160427410364000000: maxNumOfBytes=10485760' numOfBytes='0'. Occured at first check in put
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.util.queue.cache.CacheQueueInterceptorPlugin checkSpaceAvailable: history:xmlBlaster_192_168_1_4_3412/xmlBlaster_192_168_1_4_3412-1160427410364000000: maxNumOfBytes=2097152' numOfBytes='176'. Occured at second check in put
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.MsgUnitWrapper incrementReferenceCounter: Reference count changed from 1 to 2, new historyEntries=1 this='org.xmlBlaster.engine.MsgUnitWrapper at 1958cc2' storageId='history:xmlBlaster_192_168_1_4_3412/xmlBlaster_192_168_1_4_3412-1160427410364000000'
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.TopicHandler publish: /topic/xmlBlaster_192_168_1_4_3412-1160427410364000000: Message xmlBlaster_192_168_1_4_3412-1160427410364000000/2006-10-09 16:56:50.364000001 handled, now we can send updates to all interested clients.
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.TopicHandler invokeCallbackAndHandleFailure: /topic/xmlBlaster_192_168_1_4_3412-1160427410364000000: Going to update dependent clients for xmlBlaster_192_168_1_4_3412-1160427410364000000, subscriberMap.size() = 1
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.queuemsg.MsgQueueUpdateEntry <init>: Created new MsgQueueUpdateEntry for published message 'xmlBlaster_192_168_1_4_3412-1160427410364000000/2006-10-09 16:56:50.364000001', id=1160427411345000000 prio=NORM
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.util.queue.cache.CacheQueueInterceptorPlugin checkSpaceAvailable: callback:/node/xmlBlaster_192_168_1_4_3412/client/customs/session/1: maxNumOfBytes=10485760' numOfBytes='0'. Occured at first check in put
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.util.queue.cache.CacheQueueInterceptorPlugin checkSpaceAvailable: callback:/node/xmlBlaster_192_168_1_4_3412/client/customs/session/1: maxNumOfBytes=2097152' numOfBytes='179'. Occured at second check in put
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.MsgUnitWrapper incrementReferenceCounter: Reference count changed from 2 to 3, new historyEntries=1 this='org.xmlBlaster.engine.MsgUnitWrapper at 1958cc2' storageId='callback:/node/xmlBlaster_192_168_1_4_3412/client/customs/session/1'
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.util.dispatch.DispatchWorkerPool initialize: maximumPoolSize=200 minimumPoolSize=20 createThreads=5 threadLifetime=org.xmlBlaster.util.property.PropLong=180000' ms
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 17-XmlBlaster.SOCKET.tcpListener-customs_client RL10 org.xmlBlaster.engine.MsgUnitWrapper setReferenceCounter: Reference count changed from 3 to 2, this='org.xmlBlaster.engine.MsgUnitWrapper at 1958cc2'
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 24-XmlBlaster.DispatchWorkerPool.xmlBlaster_192_168_1_4_3412-5 RL10 org.xmlBlaster.util.dispatch.DispatchWorker run: Sending now 1 messages ..., current queue size is 1 'callback:/node/xmlBlaster_192_168_1_4_3412/client/customs/session/1/NORM/1160427411345000000/xmlBlaster_192_168_1_4_3412-1160427410364000000'
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 24-XmlBlaster.DispatchWorkerPool.xmlBlaster_192_168_1_4_3412-5 RL10 org.xmlBlaster.util.dispatch.DispatchConnectionsHandler send: callback:/node/xmlBlaster_192_168_1_4_3412/client/customs/session/1: Trying cb# 0 state=ALIVE ...
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 24-XmlBlaster.DispatchWorkerPool.xmlBlaster_192_168_1_4_3412-5 RL10 org.xmlBlaster.util.dispatch.DispatchManager givingUpDelivery: callback:/node/xmlBlaster_192_168_1_4_3412/client/customs/session/1: Entering givingUpDelivery(), state is ALIVE
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 24-XmlBlaster.DispatchWorkerPool.xmlBlaster_192_168_1_4_3412-5 RL10 org.xmlBlaster.engine.MsgErrorHandler handleError: Flushing 1 remaining message from queue
Oct 9, 2006 4:56:51 PM ESC[36;40m FINE  ESC[0m 24-XmlBlaster.DispatchWorkerPool.xmlBlaster_192_168_1_4_3412-5 RL10 org.xmlBlaster.engine.RequestBroker deadMessage: Publishing 1 volatile dead messages

Oct 9, 2006 4:56:51 PM ESC[33;40mWARNINGESC[0m 24-XmlBlaster.DispatchWorkerPool.xmlBlaster_192_168_1_4_3412-5 RL10 org.xmlBlaster.engine.RequestBroker deadMessage: Generating dead message 'callback:/node/xmlBlaster_192_168_1_4_3412/client/customs/session/1/NORM/1160427411345000000/xmlBlaster_192_168_1_4_3412-1160427410364000000' from publisher=/node/xmlBlaster_192_168_1_4_3412/client/customs_client/session/-2 because delivery failed: XmlBlasterException serverSideException=true node=[xmlBlaster_192_168_1_4_3412] location=[callback:/node/xmlBlaster_192_168_1_4_3412/client/customs/session/1]
java.lang.NullPointerException
stackTrace=java.lang.NullPointerException
        at org.xmlBlaster.engine.dispatch.CbDispatchConnection.doSend(CbDispatchConnection.java:253)
        at org.xmlBlaster.util.dispatch.DispatchConnection.send(DispatchConnection.java:231)
        at org.xmlBlaster.util.dispatch.DispatchConnectionsHandler.send(DispatchConnectionsHandler.java:430)
        at org.xmlBlaster.util.dispatch.DispatchWorker.run(DispatchWorker.java:160)
        at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:727)
        at java.lang.Thread.run(Thread.java:595)
errorCode=communication.noConnection.dead message=#15545M The remote connection is not established and we have given up to poll for it. -> http://www.xmlblaster.org/xmlBlaster/doc/requirements/admin.errorcodes.listing.html#communication.noConnection.dead
        at org.xmlBlaster.util.dispatch.DispatchManager.handleWorkerException(DispatchManager.java:465)
        at org.xmlBlaster.util.dispatch.DispatchWorker.run(DispatchWorker.java:193)
        at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:727)
        at java.lang.Thread.run(Thread.java:595)
versionInfo=version=1.3,revision=15545M,os.name=Linux,os.version=2.6.9-42.0.3.ELsmp,java.vm.vendor=Sun Microsystems Inc.,java.vm.version=1.5.0_05-b05,os.arch=i386,build.timestamp=10/09/2006 04:41 PM,build.java.vendor=Sun Microsystems Inc.,build.java.version=1.5.0_05
errorCode description=http://www.xmlblaster.org/xmlBlaster/doc/requirements/admin.errorcodes.listing.html#communication.noConnection.dead




-- 
Brad Clements,                bkc at murkworks.com    (315)268-1000
http://www.murkworks.com                          
AOL-IM or SKYPE: BKClements