MSPS Publication for long hours gives exceptions.

7 views

Skip to first unread message

aayush bhatnagar

unread,

Aug 1, 2009, 1:54:45 AM8/1/09

to mobicents-public

I was trying out a long test with msps.

Started the test at around afternoon 3 pm yesterday..with a single presentity that was publishing/modifying state once a minute. It was subscribed to its own presence state. After approx 10 hours around 1 am..i got these errors suddenly in the middle of normal operation (below). These errors continued to come till the morning 10:30 am..before i shut everything down.

Sequence of events:

A) Test starts at 3 PM

B) First there was a stale state exception and Optimistic Lock Exception from Hibernate at 00:50 AM, which i think corrupted the data in the Database. I am working on a solution to prevent this corruption.

2009-08-01 00:50:08,187 ERROR [org.hibernate.jdbc.AbstractBatcher] Exception executing batch:
org.hibernate.StaleStateException: Batch update returned unexpected row count from update [0]; actual row count: 0; expected: 1

C) Then there was a JSIP Exception immediately after that (which never re-occured later in the test):

2009-08-01 00:50:08,406 ERROR [org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb] unable to fill notify headers
javax.sip.InvalidArgumentException: JAIN-SIP Exception, SubscriptionState, setExpires(), the expires parameter is < 0
at gov.nist.javax.sip.header.SubscriptionState.setExpires(SubscriptionState.java:73)
at org.mobicents.slee.sipevent.server.subscription.sip.SipSubscriberNotificationHandler.createNotify(SipSubscriberNotificationHandler.java:217)
at org.mobicents.slee.sipevent.server.subscription.winfo.WInfoSubscriptionHandler.notifyWinfoSubscriptions(WInfoSubscriptionHandler.java:91)
at org.mobicents.slee.sipevent.server.subscription.sip.RemoveSipSubscriptionHandler.removeSipSubscription(RemoveSipSubscriptionHandler.java:70)
at org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb.onTimerEvent(SubscriptionControlSbb.java:386)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.runtime.sbbentity.SbbEntity.invokeEventHandler(SbbEntity.java:759)
at org.mobicents.slee.runtime.EventRouterImpl.routeQueuedEvent(EventRouterImpl.java:933)
at org.mobicents.slee.runtime.EventRouterImpl.access$100(EventRouterImpl.java:64)
at org.mobicents.slee.runtime.EventRouterImpl$EventExecutor.run(EventRouterImpl.java:121)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
at java.lang.Thread.run(Thread.java:595)
2009-08-01 00:50:08,421 ERROR [org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb] failed to notify winfo subscriber
javax.sip.TransactionUnavailableException: Missing a required header : Subscription-State
at gov.nist.javax.sip.SipProviderImpl.getNewClientTransaction(SipProviderImpl.java:299)
at org.mobicents.slee.resource.sip11.SleeSipProviderImpl.getNewClientTransaction(SleeSipProviderImpl.java:268)
at org.mobicents.slee.resource.sip11.SleeSipProviderImpl.getNewClientTransaction(SleeSipProviderImpl.java:299)
at org.mobicents.slee.sipevent.server.subscription.winfo.WInfoSubscriptionHandler.notifyWinfoSubscriptions(WInfoSubscriptionHandler.java:101)
at org.mobicents.slee.sipevent.server.subscription.sip.RemoveSipSubscriptionHandler.removeSipSubscription(RemoveSipSubscriptionHandler.java:70)
at org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb.onTimerEvent(SubscriptionControlSbb.java:386)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.runtime.sbbentity.SbbEntity.invokeEventHandler(SbbEntity.java:759)
at org.mobicents.slee.runtime.EventRouterImpl.routeQueuedEvent(EventRouterImpl.java:933)
at org.mobicents.slee.runtime.EventRouterImpl.access$100(EventRouterImpl.java:64)
at org.mobicents.slee.runtime.EventRouterImpl$EventExecutor.run(EventRouterImpl.java:121)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
at java.lang.Thread.run(Thread.java:595)
Caused by: java.text.ParseException: Missing a required header : Subscription-State
at gov.nist.javax.sip.message.SIPRequest.checkHeaders(SIPRequest.java:239)
at gov.nist.javax.sip.SipProviderImpl.getNewClientTransaction(SipProviderImpl.java:297)
... 16 more

D) After some seconds, I got an error from Internal XDM client control SBB, that the doc was not found:

2009-08-01 00:50:38,796 DEBUG [org.mobicents.slee.xdm.server.InternalXDMClientControlSbb] Exception processing request
org.openxdm.xcap.common.error.NotFoundException
at org.openxdm.xcap.server.slee.RequestProcessorSbb.get(RequestProcessorSbb.java:586)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
at org.openxdm.xcap.server.slee.RequestProcessorSbbLocalObjectImpl.get(RequestProcessorSbbLocalObjectImpl.java)
at org.mobicents.slee.xdm.server.InternalXDMClientControlSbb.get(InternalXDMClientControlSbb.java:128)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
at org.mobicents.slee.xdm.server.XDMClientControlSbbLocalObjectImpl.get(XDMClientControlSbbLocalObjectImpl.java)
at org.mobicents.slee.sippresence.server.subscription.PresenceSubscriptionControl.isSubscriberAuthorized(PresenceSubscriptionControl.java:104)
at org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSubscriptionControlSbb.isSubscriberAuthorized(IntegratedSubscriptionControlSbb.java:148)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
at org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSubscriptionControlSbbLocalObjectImpl.isSubscriberAuthorized(IntegratedSubscriptionControlSbbLocalObjectImpl.java)
at org.mobicents.slee.sipevent.server.subscription.sip.NewSipSubscriptionHandler.authorizeNewSipSubscription(NewSipSubscriptionHandler.java:174)
at org.mobicents.slee.sipevent.server.subscription.sip.NewSipSubscriptionHandler.newSipSubscription(NewSipSubscriptionHandler.java:116)
at org.mobicents.slee.sipevent.server.subscription.sip.SipSubscriptionHandler.processRequest(SipSubscriptionHandler.java:182)
at org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb.onSubscribeOutOfDialog(SubscriptionControlSbb.java:291)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.runtime.sbbentity.SbbEntity.invokeEventHandler(SbbEntity.java:759)
at org.mobicents.slee.runtime.EventRouterImpl.routeQueuedEvent(EventRouterImpl.java:933)
at org.mobicents.slee.runtime.EventRouterImpl.access$100(EventRouterImpl.java:64)
at org.mobicents.slee.runtime.EventRouterImpl$EventExecutor.run(EventRouterImpl.java:121)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
at java.lang.Thread.run(Thread.java:595)

E) Then Presence Subscription Control class failed to get the Notify content. This error was repeated several times
everytime for the presence event package:

2009-08-01 00:50:38,906 ERROR [org.mobicents.slee.sippresence.server.subscription.PresenceSubscriptionControl] failed to get notify content
java.lang.NullPointerException: null contentType or subType
at gov.nist.javax.sip.header.HeaderFactoryImpl.createContentTypeHeader(HeaderFactoryImpl.java:414)
at org.mobicents.slee.sippresence.server.subscription.PresenceSubscriptionControl.getNotifyContent(PresenceSubscriptionControl.java:349)
at org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSubscriptionControlSbb.getNotifyContent(IntegratedSubscriptionControlSbb.java:175)
at sun.reflect.GeneratedMethodAccessor118.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
at org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSubscriptionControlSbbLocalObjectImpl.getNotifyContent(IntegratedSubscriptionControlSbbLocalObjectImpl.java)
at org.mobicents.slee.sipevent.server.subscription.sip.SipSubscriberNotificationHandler.createAndSendNotify(SipSubscriberNotificationHandler.java:148)
at org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb.authorizationChanged(SubscriptionControlSbb.java:705)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
at org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbbLocalObjectImpl.authorizationChanged(SubscriptionControlSbbLocalObjectImpl.java)
at org.mobicents.slee.sippresence.server.subscription.PresenceSubscriptionControl.getResponse(PresenceSubscriptionControl.java:217)
at org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSubscriptionControlSbb.getResponse(IntegratedSubscriptionControlSbb.java:298)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
at org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSubscriptionControlSbbLocalObjectImpl.getResponse(IntegratedSubscriptionControlSbbLocalObjectImpl.java)
at org.mobicents.slee.xdm.server.InternalXDMClientControlSbb.get(InternalXDMClientControlSbb.java:140)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
at org.mobicents.slee.xdm.server.XDMClientControlSbbLocalObjectImpl.get(XDMClientControlSbbLocalObjectImpl.java)
at org.mobicents.slee.sippresence.server.subscription.PresenceSubscriptionControl.isSubscriberAuthorized(PresenceSubscriptionControl.java:104)
at org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSubscriptionControlSbb.isSubscriberAuthorized(IntegratedSubscriptionControlSbb.java:148)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
at org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSubscriptionControlSbbLocalObjectImpl.isSubscriberAuthorized(IntegratedSubscriptionControlSbbLocalObjectImpl.java)
at org.mobicents.slee.sipevent.server.subscription.sip.NewSipSubscriptionHandler.authorizeNewSipSubscription(NewSipSubscriptionHandler.java:174)
at org.mobicents.slee.sipevent.server.subscription.sip.NewSipSubscriptionHandler.newSipSubscription(NewSipSubscriptionHandler.java:116)
at org.mobicents.slee.sipevent.server.subscription.sip.SipSubscriptionHandler.processRequest(SipSubscriptionHandler.java:182)
at org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb.onSubscribeOutOfDialog(SubscriptionControlSbb.java:291)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.runtime.sbbentity.SbbEntity.invokeEventHandler(SbbEntity.java:759)
at org.mobicents.slee.runtime.EventRouterImpl.routeQueuedEvent(EventRouterImpl.java:933)
at org.mobicents.slee.runtime.EventRouterImpl.access$100(EventRouterImpl.java:64)
at org.mobicents.slee.runtime.EventRouterImpl$EventExecutor.run(EventRouterImpl.java:121)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
at java.lang.Thread.run(Thread.java:595)

F) Then I got the Name Not Bound Exception (probably due to aci unbind-rebind attempt code in the SBB on publication refresh):

2009-08-01 00:52:52,171 DEBUG [org.mobicents.slee.runtime.facilities.ActivityContextNamingFacilityImpl] Name not bound publicationKey: eTag=d737f11a221512851bbac260bc24bc97,entity=sip:bhat...@rancore.com,eventPackage=presence
2009-08-01 00:52:52,171 ERROR [org.mobicents.slee.sipevent.server.publication.PublicationControlSbb] failed to refresh publication
javax.slee.facilities.NameNotBoundException: Name not bound publicationKey: eTag=d737f11a221512851bbac260bc24bc97,entity=sip:bhat...@rancore.com,eventPackage=presence
at org.mobicents.slee.runtime.facilities.ActivityContextNamingFacilityImpl.unbind(ActivityContextNamingFacilityImpl.java:145)
at org.mobicents.slee.sipevent.server.publication.PublicationControlSbb.refreshPublication(PublicationControlSbb.java:320)
at sun.reflect.GeneratedMethodAccessor114.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
at org.mobicents.slee.sipevent.server.publication.PublicationControlSbbLocalObjectImpl.refreshPublication(PublicationControlSbbLocalObjectImpl.java)
at org.mobicents.slee.sipevent.server.publication.SipPublicationControlSbb.onPublish(SipPublicationControlSbb.java:219)
at sun.reflect.GeneratedMethodAccessor107.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.runtime.sbbentity.SbbEntity.invokeEventHandler(SbbEntity.java:759)
at org.mobicents.slee.runtime.EventRouterImpl.routeQueuedEvent(EventRouterImpl.java:933)
at org.mobicents.slee.runtime.EventRouterImpl.access$100(EventRouterImpl.java:64)
at org.mobicents.slee.runtime.EventRouterImpl$EventExecutor.run(EventRouterImpl.java:121)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
at java.lang.Thread.run(Thread.java:595)

G) Then the server failed to create any new publications after that. This is what got me a little worried.

2009-08-01 00:53:47,031 ERROR [org.mobicents.slee.sipevent.server.publication.PublicationControlSbb] failed to create publication
javax.slee.TransactionRolledbackLocalException: Invocation resulted in exception !
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:79)
at org.mobicents.slee.sipevent.server.publication.ImplementedPublicationControlSbbLocalObjectImpl.combinePublication(ImplementedPublicationControlSbbLocalObjectImpl.java)
at org.mobicents.slee.sipevent.server.publication.PublicationControlSbb.getUpdatedComposedPublication(PublicationControlSbb.java:263)
at org.mobicents.slee.sipevent.server.publication.PublicationControlSbb.newPublication(PublicationControlSbb.java:216)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
at org.mobicents.slee.sipevent.server.publication.PublicationControlSbbLocalObjectImpl.newPublication(PublicationControlSbbLocalObjectImpl.java)
at org.mobicents.slee.sipevent.server.publication.SipPublicationControlSbb.onPublish(SipPublicationControlSbb.java:238)
at sun.reflect.GeneratedMethodAccessor107.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.runtime.sbbentity.SbbEntity.invokeEventHandler(SbbEntity.java:759)
at org.mobicents.slee.runtime.EventRouterImpl.routeQueuedEvent(EventRouterImpl.java:933)
at org.mobicents.slee.runtime.EventRouterImpl.access$100(EventRouterImpl.java:64)
at org.mobicents.slee.runtime.EventRouterImpl$EventExecutor.run(EventRouterImpl.java:121)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
at java.lang.Thread.run(Thread.java:595)
Caused by: java.lang.NullPointerException
at java.io.StringReader.<init>(StringReader.java:33)
at org.mobicents.slee.sippresence.server.publication.PresencePublicationControlSbb.unmarshall(PresencePublicationControlSbb.java:202)
at org.mobicents.slee.sippresence.server.publication.PresencePublicationControlSbb.combinePublication(PresencePublicationControlSbb.java:250)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectInterceptor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
... 21 more

H) Test stopped at 10:30 AM.

--
aayush
----------------------------------------------------
"A philosopher always knows what to do...until it happens to him"

aayushb

unread,

Aug 1, 2009, 9:28:03 AM8/1/09

to mobicents-public

I think i got the problem's cause..Will confirm later..after a similar
duration.

On Aug 1, 10:54 am, aayush bhatnagar <abhatnagar192...@gmail.com>
wrote:

> I was trying out a long test with msps.
> Started the test at around afternoon 3 pm yesterday..with a single
> presentity that was publishing/modifying state once a minute. It was
> subscribed to its own presence state. After approx 10 hours around 1 am..i
> got these errors suddenly in the middle of normal operation (below). These
> errors continued to come till the morning 10:30 am..before i shut everything
> down.
>
> Sequence of events:
>

> *A) Test starts at 3 PM*
>
> *B) First there was a stale state exception and Optimistic Lock Exception

> from Hibernate at 00:50 AM, which i think corrupted the data in the

> Database. I am working on a solution to prevent this corruption.*

>
> 2009-08-01 00:50:08,187 ERROR [org.hibernate.jdbc.AbstractBatcher] Exception
> executing batch:
> org.hibernate.StaleStateException: Batch update returned unexpected row
> count from update [0]; actual row count: 0; expected: 1
>

> *C) Then there was a JSIP Exception immediately after that (which never
> re-occured later in the test):*

>
> 2009-08-01 00:50:08,406 ERROR
> [org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb]
> unable to fill notify headers
> javax.sip.InvalidArgumentException: JAIN-SIP Exception, SubscriptionState,
> setExpires(), the expires parameter is < 0
> at
> gov.nist.javax.sip.header.SubscriptionState.setExpires(SubscriptionState.ja va:73)
> at
> org.mobicents.slee.sipevent.server.subscription.sip.SipSubscriberNotificati onHandler.createNotify(SipSubscriberNotificationHandler.java:217)
> at
> org.mobicents.slee.sipevent.server.subscription.winfo.WInfoSubscriptionHand ler.notifyWinfoSubscriptions(WInfoSubscriptionHandler.java:91)
> at
> org.mobicents.slee.sipevent.server.subscription.sip.RemoveSipSubscriptionHa ndler.removeSipSubscription(RemoveSipSubscriptionHandler.java:70)
> at

> org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb.onTi merEvent(SubscriptionControlSbb.java:386)

> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:3 9)
> at

> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImp l.java:25)

> at java.lang.reflect.Method.invoke(Method.java:585)
> at
> org.mobicents.slee.runtime.sbbentity.SbbEntity.invokeEventHandler(SbbEntity .java:759)
> at

> org.mobicents.slee.runtime.EventRouterImpl.routeQueuedEvent(EventRouterImpl .java:933)

> at
> org.mobicents.slee.runtime.EventRouterImpl.access$100(EventRouterImpl.java: 64)
> at
> org.mobicents.slee.runtime.EventRouterImpl$EventExecutor.run(EventRouterImp l.java:121)
> at

> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.j ava:650)

> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java: 675)
> at java.lang.Thread.run(Thread.java:595)
> 2009-08-01 00:50:08,421 ERROR
> [org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb]
> failed to notify winfo subscriber
> javax.sip.TransactionUnavailableException: Missing a required header :
> Subscription-State
> at
> gov.nist.javax.sip.SipProviderImpl.getNewClientTransaction(SipProviderImpl. java:299)
> at
> org.mobicents.slee.resource.sip11.SleeSipProviderImpl.getNewClientTransacti on(SleeSipProviderImpl.java:268)
> at
> org.mobicents.slee.resource.sip11.SleeSipProviderImpl.getNewClientTransacti on(SleeSipProviderImpl.java:299)
> at
> org.mobicents.slee.sipevent.server.subscription.winfo.WInfoSubscriptionHand ler.notifyWinfoSubscriptions(WInfoSubscriptionHandler.java:101)
> at
> org.mobicents.slee.sipevent.server.subscription.sip.RemoveSipSubscriptionHa ndler.removeSipSubscription(RemoveSipSubscriptionHandler.java:70)
> at

> org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb.onTi merEvent(SubscriptionControlSbb.java:386)

> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:3 9)
> at

> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImp l.java:25)

> at java.lang.reflect.Method.invoke(Method.java:585)
> at
> org.mobicents.slee.runtime.sbbentity.SbbEntity.invokeEventHandler(SbbEntity .java:759)
> at

> org.mobicents.slee.runtime.EventRouterImpl.routeQueuedEvent(EventRouterImpl .java:933)

> at
> org.mobicents.slee.runtime.EventRouterImpl.access$100(EventRouterImpl.java: 64)
> at
> org.mobicents.slee.runtime.EventRouterImpl$EventExecutor.run(EventRouterImp l.java:121)
> at

> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.j ava:650)

> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java: 675)
> at java.lang.Thread.run(Thread.java:595)
> Caused by: java.text.ParseException: Missing a required header :
> Subscription-State
> at gov.nist.javax.sip.message.SIPRequest.checkHeaders(SIPRequest.java:239)
> at
> gov.nist.javax.sip.SipProviderImpl.getNewClientTransaction(SipProviderImpl. java:297)
> ... 16 more
>

> *D) After some seconds, I got an error from Internal XDM client control SBB,
> that the doc was not found:*

>
> 2009-08-01 00:50:38,796 DEBUG
> [org.mobicents.slee.xdm.server.InternalXDMClientControlSbb] Exception
> processing request
> org.openxdm.xcap.common.error.NotFoundException
> at

> org.openxdm.xcap.server.slee.RequestProcessorSbb.get(RequestProcessorSbb.ja va:586)

> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:3 9)
> at

> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImp l.java:25)
> at java.lang.reflect.Method.invoke(Method.java:585)
> at
> org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectIntercep tor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
> at
> org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectIntercep tor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
> at
> org.mobicents.slee.xdm.server.XDMClientControlSbbLocalObjectImpl.get(XDMCli entControlSbbLocalObjectImpl.java)
> at
> org.mobicents.slee.sippresence.server.subscription.PresenceSubscriptionCont rol.isSubscriberAuthorized(PresenceSubscriptionControl.java:104)
> at
> org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSub scriptionControlSbb.isSubscriberAuthorized(IntegratedSubscriptionControlSbb .java:148)

> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:3 9)
> at

> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImp l.java:25)
> at java.lang.reflect.Method.invoke(Method.java:585)
> at
> org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectIntercep tor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
> at
> org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectIntercep tor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
> at
> org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSub scriptionControlSbbLocalObjectImpl.isSubscriberAuthorized(IntegratedSubscri ptionControlSbbLocalObjectImpl.java)
> at
> org.mobicents.slee.sipevent.server.subscription.sip.NewSipSubscriptionHandl er.authorizeNewSipSubscription(NewSipSubscriptionHandler.java:174)
> at
> org.mobicents.slee.sipevent.server.subscription.sip.NewSipSubscriptionHandl er.newSipSubscription(NewSipSubscriptionHandler.java:116)
> at
> org.mobicents.slee.sipevent.server.subscription.sip.SipSubscriptionHandler. processRequest(SipSubscriptionHandler.java:182)
> at
> org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb.onSu bscribeOutOfDialog(SubscriptionControlSbb.java:291)

> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:3 9)
> at

> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImp l.java:25)

> at java.lang.reflect.Method.invoke(Method.java:585)
> at
> org.mobicents.slee.runtime.sbbentity.SbbEntity.invokeEventHandler(SbbEntity .java:759)
> at

> org.mobicents.slee.runtime.EventRouterImpl.routeQueuedEvent(EventRouterImpl .java:933)

> at
> org.mobicents.slee.runtime.EventRouterImpl.access$100(EventRouterImpl.java: 64)
> at
> org.mobicents.slee.runtime.EventRouterImpl$EventExecutor.run(EventRouterImp l.java:121)
> at

> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.j ava:650)

> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java: 675)
> at java.lang.Thread.run(Thread.java:595)
>

> *E) Then Presence Subscription Control class failed to get the Notify

> content. This error was repeated several times

> everytime for the presence event package:*

>
> 2009-08-01 00:50:38,906 ERROR
> [org.mobicents.slee.sippresence.server.subscription.PresenceSubscriptionCon trol]
> failed to get notify content
> java.lang.NullPointerException: null contentType or subType
> at
> gov.nist.javax.sip.header.HeaderFactoryImpl.createContentTypeHeader(HeaderF actoryImpl.java:414)
> at
> org.mobicents.slee.sippresence.server.subscription.PresenceSubscriptionCont rol.getNotifyContent(PresenceSubscriptionControl.java:349)
> at

> org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSub scriptionControlSbb.getNotifyContent(IntegratedSubscriptionControlSbb.java: 175)
> at sun.reflect.GeneratedMethodAccessor118.invoke(Unknown Source)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImp l.java:25)
> at java.lang.reflect.Method.invoke(Method.java:585)
> at
> org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectIntercep tor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
> at
> org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSub scriptionControlSbbLocalObjectImpl.getNotifyContent(IntegratedSubscriptionC ontrolSbbLocalObjectImpl.java)
> at
> org.mobicents.slee.sipevent.server.subscription.sip.SipSubscriberNotificati onHandler.createAndSendNotify(SipSubscriberNotificationHandler.java:148)
> at
> org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbb.auth orizationChanged(SubscriptionControlSbb.java:705)

> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:3 9)
> at

> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImp l.java:25)
> at java.lang.reflect.Method.invoke(Method.java:585)
> at
> org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectIntercep tor.invokeAndReturnObject(SbbLocalObjectInterceptor.java:72)
> at
> org.mobicents.slee.container.deployment.interceptors.SbbLocalObjectIntercep tor.invokeAndReturnvoid(SbbLocalObjectInterceptor.java:113)
> at
> org.mobicents.slee.sipevent.server.subscription.SubscriptionControlSbbLocal ObjectImpl.authorizationChanged(SubscriptionControlSbbLocalObjectImpl.java)
> at
> org.mobicents.slee.sippresence.server.subscription.PresenceSubscriptionCont rol.getResponse(PresenceSubscriptionControl.java:217)
> at
> org.mobicents.slee.sippresence.server.integrated.subscription.IntegratedSub scriptionControlSbb.getResponse(IntegratedSubscriptionControlSbb.java:298)