[sip-comm] Problems with SIP (making calls)


#1

Hello,

I am running the latest sources r3358, and I get these errors when I attempt to proceed with SIP call.

I still can't really understand how the project is built. I think I want to put my hands under the bonnet but I don't know where to start. Seems like sip-communicator is hooked up to Felix, new to me as well, not that easy to figure out how that works. Is there any information about this ?

The problem I have reported last week or so with the SIP account definition seems cleared.

Christian

···

==========
     [java] Call-ID: 548e6bfbe81431af673c70103bc5b59b@0.0.0.0
     [java] CSeq: 2 REGISTER
     [java] From: "17476868081" ;tag=8c8e7e21
     [java] To: "17476868081"
     [java] Max-Forwards: 70
     [java] Route:
     [java] User-Agent: SIP Communicator 1.0 CVS-Tue_Jan_22_20-39-32_GMT+01-00_2008
     [java] Expires: 3600
     [java] Contact: "17476868081" ;expires=3600
     [java] Via: SIP/2.0/UDP 192.168.1.221:5060;branch=z9hG4bK8832e2711dad2109de73299fc23d66c3
     [java] Authorization: Digest uri="sip:proxy01.sipphone.com",realm="proxy01.sipphone.com",userna me="17476868081",nonce="479647a0a2f824239f7779e227efda136811d8c1",response="de0150fb6ac1ca1984f6f035 4d76c017"
     [java] Content-Length: 0
     [java]
     [java]
     [java] 20:39:51.838 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTe rminated().1171 Found one processor for method REGISTER, processor is=SipRegistrarConnection-[dn=174 76868081 addr="17476868081" ]
     [java] 20:39:55.563 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest().1204 received request=
     [java] SUBSCRIBE sip:17476868081@78.22.49.130:29171;transport=udp SIP/2.0
     [java] Record-Route:
     [java] Via: SIP/2.0/UDP 198.65.166.131;branch=z9hG4bKb496.af0b0265.1,SIP/2.0/UDP 198.65.166.156:46053,SIP/2.0/TCP 192.168.1.100:39280;branch=z9hG 4bK-d87543-30100e4022174c26-1--d87543-;rport
     [java] Max-Forwards: 16
     [java] Contact:
     [java] To: "cr_test"
     [java] From: "cr_test" ;tag=bc38bc12
     [java] Call-ID: ZTVhYTYxNDE2NTBiMjQxOTFlZDczMzgzMGFkY2VjZmM.
     [java] CSeq: 1 SUBSCRIBE
     [java] Expires: 300
     [java] Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,MESSAGE,SUBSCRIBE,INFO
     [java] User-Agent: X-Lite release 1011s stamp 41150
     [java] Event: message-summary
     [java] Content-Length: 0
     [java]
     [java]
     [java] 20:39:55.599 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest().1287 Found one processor for method SUBSCRIBE, processor is=net.java.sip.communicator.impl.protocol.sip.OperationSetPresenceSipImpl@3d12a6
     [java] 20:39:55.600 SEVERE: impl.protocol.sip.OperationSetPresenceSipImpl.processRequest().2360 Failed to create a new servertransaction for an incoming request
     [java] (Next message contains the request)
     [java] javax.sip.TransactionAlreadyExistsException: server transaction already exists!
     [java] at gov.nist.javax.sip.SipProviderImpl.getNewServerTransaction(SipProviderImpl.java:457)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetPresenceSipImpl.processRequest(OperationSetPresenceSipImpl.java:2354)
     [java] at net.java.sip.communicator.impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest(ProtocolProviderServiceSipImpl.java:1290)
     [java] at gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:223)
     [java] at gov.nist.javax.sip.EventScanner.run(EventScanner.java:492)
     [java] at java.lang.Thread.run(Thread.java:595)
     [java] 20:40:09.577 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getLocalViaHeaders().1438 generated via headers:Via: SIP/2.0/UDP 192.168.1.221:5060
     [java]
     [java] 20:40:09.579 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getContactHeader().1562 generated contactHeader:Contact: "17476868081"
     [java]
     [java] 20:40:09.583 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getContactHeader().1518 generated contactHeader:Contact: "17476868081"
     [java]
     [java] 20:40:09.682 FINE: service.protocol.Call.fireCallParticipantEvent().165 Dispatching a CallParticipant event to 0 listeners. event is: CallParticipantEvent: ID=1 source participant=sip:17471996503@proxy01.sipphone.com <>;status=Unknown source call=Call: id=120103080967618323943 participants=1
     [java] 20:40:09.685 FINE: service.protocol.AbstractCallParticipant.fireCallParticipantChangeEvent().100 Dispatching a CallParticipantChangeEvent event to 1 listeners. event is: CallParticipantChangeEvent: type=CallParticipantStatusChange oldV=net.java.sip.communicator.service.protocol.CallParticipantState:Unknown newV=net.java.sip.communicator.service.protocol.CallParticipantState:Initiating Call for participant=sip:17471996503@proxy01.sipphone.com <>;status=Initiating Call
     [java] 20:40:09.687 FINE: impl.protocol.sip.OperationSetBasicTelephonySipImpl.fireCallEvent().310 Dispatching a CallEvent to 2 listeners. event is: CallEvent:[ id=1 Call=Call: id=120103080967618323943 participants=1]
     [java] Exception in thread "Thread-22" java.lang.NullPointerException: Specified service reference cannot be null.
     [java] at org.apache.felix.framework.BundleContextImpl.getService(BundleContextImpl.java:380)
     [java] at net.java.sip.communicator.impl.protocol.sip.SipActivator.getMediaService(SipActivator.java:143)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetBasicTelephonySipImpl.createOutgoingCall(OperationSetBasicTelephonySipImpl.java:226)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetBasicTelephonySipImpl.createCall(OperationSetBasicTelephonySipImpl.java:116)
     [java] at net.java.sip.communicator.impl.gui.main.call.CallManager$CreateCallThread.run(CallManager.java:827)
     [java] Exception in thread "AWT-EventQueue-0" java.lang.NullPointerException
     [java] at net.java.sip.communicator.impl.gui.main.call.CallManager.actionPerformed(CallManager.java:170)
     [java] at javax.swing.AbstractButton.fireActionPerformed(AbstractButton.java:1849)
     [java] at javax.swing.AbstractButton$Handler.actionPerformed(AbstractButton.java:2169)
     [java] at javax.swing.DefaultButtonModel.fireActionPerformed(DefaultButtonModel.java:420)
     [java] at javax.swing.DefaultButtonModel.setPressed(DefaultButtonModel.java:258)
     [java] at javax.swing.plaf.basic.BasicButtonListener.mouseReleased(BasicButtonListener.java:236)
     [java] at java.awt.Component.processMouseEvent(Component.java:5517)
     [java] at javax.swing.JComponent.processMouseEvent(JComponent.java:3135)
     [java] at java.awt.Component.processEvent(Component.java:5282)
     [java] at java.awt.Container.processEvent(Container.java:1966)
     [java] at java.awt.Component.dispatchEventImpl(Component.java:3984)
     [java] at java.awt.Container.dispatchEventImpl(Container.java:2024)
     [java] at java.awt.Component.dispatchEvent(Component.java:3819)
     [java] at java.awt.LightweightDispatcher.retargetMouseEvent(Container.java:4212)
     [java] at java.awt.LightweightDispatcher.processMouseEvent(Container.java:3892)
     [java] at java.awt.LightweightDispatcher.dispatchEvent(Container.java:3822)
     [java] at java.awt.Container.dispatchEventImpl(Container.java:2010)
     [java] at java.awt.Window.dispatchEventImpl(Window.java:1791)
     [java] at java.awt.Component.dispatchEvent(Component.java:3819)
     [java] at java.awt.EventQueue.dispatchEvent(EventQueue.java:463)
     [java] at java.awt.EventDispatchThread.pumpOneEventForHierarchy(EventDispatchThread.java:242)
     [java] at java.awt.EventDispatchThread.pumpEventsForHierarchy(EventDispatchThread.java:163)
     [java] at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:157)
     [java] at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:149)
     [java] at java.awt.EventDispatchThread.run(EventDispatchThread.java:110)
     [java] 20:40:27.134 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTerminated().1158 Transaction terminated for req=SUBSCRIBE sip:17476868081@78.22.49.130:29171;transport=udp SIP/2.0
     [java] Record-Route:
     [java] Via: SIP/2.0/UDP 198.65.166.131;branch=z9hG4bKb496.af0b0265.1,SIP/2.0/UDP 198.65.166.156:46053,SIP/2.0/TCP 192.168.1.100:39280;branch=z9hG4bK-d87543-30100e4022174c26-1--d87543-;rport
     [java] Max-Forwards: 16
     [java] Contact:
     [java] To: "cr_test"
     [java] From: "cr_test" ;tag=bc38bc12
     [java] Call-ID: ZTVhYTYxNDE2NTBiMjQxOTFlZDczMzgzMGFkY2VjZmM.
     [java] CSeq: 1 SUBSCRIBE
     [java] Expires: 300
     [java] Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,MESSAGE,SUBSCRIBE,INFO
     [java] User-Agent: X-Lite release 1011s stamp 41150
     [java] Event: message-summary
     [java] Content-Length: 0
     [java]
     [java]
     [java] 20:40:27.134 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTerminated().1171 Found one processor for method SUBSCRIBE, processor is=net.java.sip.communicator.impl.protocol.sip.OperationSetPresenceSipImpl@3d12a6
     [java] 20:41:35.139 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest().1204 received request=
     [java] SUBSCRIBE sip:17476868081@78.22.49.130:29171;transport=udp SIP/2.0
     [java] Record-Route:
     [java] Via: SIP/2.0/UDP 198.65.166.131;branch=z9hG4bK435d.bd42eae.1,SIP/2.0/UDP 198.65.166.156:46053,SIP/2.0/TCP 192.168.1.100:39280;branch=z9hG4bK-d87543-ef150d3acb7f360d-1--d87543-;rport
     [java] Max-Forwards: 16
     [java] Contact:
     ===========
_________________________________________________________________
Express yourself instantly with MSN Messenger! Download today it's FREE!
http://messenger.msn.click-url.com/go/onm00200471ave/direct/01/
---------------------------------------------------------------------
To unsubscribe, e-mail: users-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: users-help@sip-communicator.dev.java.net


#2

Hi Christian,

Thanks for reporting this. Could you please add some informations to help us to fix this ? If you could send a log and what did you do when this happened it would be wonderful.

You can post it on the dev mailing list (dev@sip-communicator.dev.java.net).

Thanks,
Ben

Christian Ravenier a �crit :

···

Hello,

I am running the latest sources r3358, and I get these errors when I attempt to proceed with SIP call.

I still can't really understand how the project is built. I think I want to put my hands under the bonnet but I don't know where to start. Seems like sip-communicator is hooked up to Felix, new to me as well, not that easy to figure out how that works. Is there any information about this ?

The problem I have reported last week or so with the SIP account definition seems cleared.

Christian

==========
     [java] Call-ID: 548e6bfbe81431af673c70103bc5b59b@0.0.0.0
     [java] CSeq: 2 REGISTER
     [java] From: "17476868081" ;tag=8c8e7e21
     [java] To: "17476868081" [java] Max-Forwards: 70
     [java] Route: [java] User-Agent: SIP Communicator 1.0 CVS-Tue_Jan_22_20-39-32_GMT+01-00_2008
     [java] Expires: 3600
     [java] Contact: "17476868081" ;expires=3600
     [java] Via: SIP/2.0/UDP 192.168.1.221:5060;branch=z9hG4bK8832e2711dad2109de73299fc23d66c3
     [java] Authorization: Digest uri="sip:proxy01.sipphone.com",realm="proxy01.sipphone.com",userna me="17476868081",nonce="479647a0a2f824239f7779e227efda136811d8c1",response="de0150fb6ac1ca1984f6f035 4d76c017"
     [java] Content-Length: 0
     [java]
     [java] 20:39:51.838 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTe rminated().1171 Found one processor for method REGISTER, processor is=SipRegistrarConnection-[dn=174 76868081 addr="17476868081" ]
     [java] 20:39:55.563 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest().1204 received request=
     [java] SUBSCRIBE sip:17476868081@78.22.49.130:29171;transport=udp SIP/2.0
     [java] Record-Route: [java] Via: SIP/2.0/UDP 198.65.166.131;branch=z9hG4bKb496.af0b0265.1,SIP/2.0/UDP 198.65.166.156:46053,SIP/2.0/TCP 192.168.1.100:39280;branch=z9hG 4bK-d87543-30100e4022174c26-1--d87543-;rport
     [java] Max-Forwards: 16
     [java] Contact: [java] To: "cr_test" [java] From: "cr_test" ;tag=bc38bc12
     [java] Call-ID: ZTVhYTYxNDE2NTBiMjQxOTFlZDczMzgzMGFkY2VjZmM.
     [java] CSeq: 1 SUBSCRIBE
     [java] Expires: 300
     [java] Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,MESSAGE,SUBSCRIBE,INFO
     [java] User-Agent: X-Lite release 1011s stamp 41150
     [java] Event: message-summary
     [java] Content-Length: 0
     [java]
     [java] 20:39:55.599 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest().1287 Found one processor for method SUBSCRIBE, processor is=net.java.sip.communicator.impl.protocol.sip.OperationSetPresenceSipImpl@3d12a6
     [java] 20:39:55.600 SEVERE: impl.protocol.sip.OperationSetPresenceSipImpl.processRequest().2360 Failed to create a new servertransaction for an incoming request
     [java] (Next message contains the request)
     [java] javax.sip.TransactionAlreadyExistsException: server transaction already exists!
     [java] at gov.nist.javax.sip.SipProviderImpl.getNewServerTransaction(SipProviderImpl.java:457)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetPresenceSipImpl.processRequest(OperationSetPresenceSipImpl.java:2354)
     [java] at net.java.sip.communicator.impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest(ProtocolProviderServiceSipImpl.java:1290)
     [java] at gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:223)
     [java] at gov.nist.javax.sip.EventScanner.run(EventScanner.java:492)
     [java] at java.lang.Thread.run(Thread.java:595)
     [java] 20:40:09.577 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getLocalViaHeaders().1438 generated via headers:Via: SIP/2.0/UDP 192.168.1.221:5060
     [java]
     [java] 20:40:09.579 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getContactHeader().1562 generated contactHeader:Contact: "17476868081" [java]
     [java] 20:40:09.583 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getContactHeader().1518 generated contactHeader:Contact: "17476868081" [java]
     [java] 20:40:09.682 FINE: service.protocol.Call.fireCallParticipantEvent().165 Dispatching a CallParticipant event to 0 listeners. event is: CallParticipantEvent: ID=1 source participant=sip:17471996503@proxy01.sipphone.com <>;status=Unknown source call=Call: id=120103080967618323943 participants=1
     [java] 20:40:09.685 FINE: service.protocol.AbstractCallParticipant.fireCallParticipantChangeEvent().100 Dispatching a CallParticipantChangeEvent event to 1 listeners. event is: CallParticipantChangeEvent: type=CallParticipantStatusChange oldV=net.java.sip.communicator.service.protocol.CallParticipantState:Unknown newV=net.java.sip.communicator.service.protocol.CallParticipantState:Initiating Call for participant=sip:17471996503@proxy01.sipphone.com <>;status=Initiating Call
     [java] 20:40:09.687 FINE: impl.protocol.sip.OperationSetBasicTelephonySipImpl.fireCallEvent().310 Dispatching a CallEvent to 2 listeners. event is: CallEvent:[ id=1 Call=Call: id=120103080967618323943 participants=1]
     [java] Exception in thread "Thread-22" java.lang.NullPointerException: Specified service reference cannot be null.
     [java] at org.apache.felix.framework.BundleContextImpl.getService(BundleContextImpl.java:380)
     [java] at net.java.sip.communicator.impl.protocol.sip.SipActivator.getMediaService(SipActivator.java:143)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetBasicTelephonySipImpl.createOutgoingCall(OperationSetBasicTelephonySipImpl.java:226)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetBasicTelephonySipImpl.createCall(OperationSetBasicTelephonySipImpl.java:116)
     [java] at net.java.sip.communicator.impl.gui.main.call.CallManager$CreateCallThread.run(CallManager.java:827)
     [java] Exception in thread "AWT-EventQueue-0" java.lang.NullPointerException
     [java] at net.java.sip.communicator.impl.gui.main.call.CallManager.actionPerformed(CallManager.java:170)
     [java] at javax.swing.AbstractButton.fireActionPerformed(AbstractButton.java:1849)
     [java] at javax.swing.AbstractButton$Handler.actionPerformed(AbstractButton.java:2169)
     [java] at javax.swing.DefaultButtonModel.fireActionPerformed(DefaultButtonModel.java:420)
     [java] at javax.swing.DefaultButtonModel.setPressed(DefaultButtonModel.java:258)
     [java] at javax.swing.plaf.basic.BasicButtonListener.mouseReleased(BasicButtonListener.java:236)
     [java] at java.awt.Component.processMouseEvent(Component.java:5517)
     [java] at javax.swing.JComponent.processMouseEvent(JComponent.java:3135)
     [java] at java.awt.Component.processEvent(Component.java:5282)
     [java] at java.awt.Container.processEvent(Container.java:1966)
     [java] at java.awt.Component.dispatchEventImpl(Component.java:3984)
     [java] at java.awt.Container.dispatchEventImpl(Container.java:2024)
     [java] at java.awt.Component.dispatchEvent(Component.java:3819)
     [java] at java.awt.LightweightDispatcher.retargetMouseEvent(Container.java:4212)
     [java] at java.awt.LightweightDispatcher.processMouseEvent(Container.java:3892)
     [java] at java.awt.LightweightDispatcher.dispatchEvent(Container.java:3822)
     [java] at java.awt.Container.dispatchEventImpl(Container.java:2010)
     [java] at java.awt.Window.dispatchEventImpl(Window.java:1791)
     [java] at java.awt.Component.dispatchEvent(Component.java:3819)
     [java] at java.awt.EventQueue.dispatchEvent(EventQueue.java:463)
     [java] at java.awt.EventDispatchThread.pumpOneEventForHierarchy(EventDispatchThread.java:242)
     [java] at java.awt.EventDispatchThread.pumpEventsForHierarchy(EventDispatchThread.java:163)
     [java] at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:157)
     [java] at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:149)
     [java] at java.awt.EventDispatchThread.run(EventDispatchThread.java:110)
     [java] 20:40:27.134 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTerminated().1158 Transaction terminated for req=SUBSCRIBE sip:17476868081@78.22.49.130:29171;transport=udp SIP/2.0
     [java] Record-Route: [java] Via: SIP/2.0/UDP 198.65.166.131;branch=z9hG4bKb496.af0b0265.1,SIP/2.0/UDP 198.65.166.156:46053,SIP/2.0/TCP 192.168.1.100:39280;branch=z9hG4bK-d87543-30100e4022174c26-1--d87543-;rport
     [java] Max-Forwards: 16
     [java] Contact: [java] To: "cr_test" [java] From: "cr_test" ;tag=bc38bc12
     [java] Call-ID: ZTVhYTYxNDE2NTBiMjQxOTFlZDczMzgzMGFkY2VjZmM.
     [java] CSeq: 1 SUBSCRIBE
     [java] Expires: 300
     [java] Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,MESSAGE,SUBSCRIBE,INFO
     [java] User-Agent: X-Lite release 1011s stamp 41150
     [java] Event: message-summary
     [java] Content-Length: 0
     [java]
     [java] 20:40:27.134 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTerminated().1171 Found one processor for method SUBSCRIBE, processor is=net.java.sip.communicator.impl.protocol.sip.OperationSetPresenceSipImpl@3d12a6
     [java] 20:41:35.139 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest().1204 received request=
     [java] SUBSCRIBE sip:17476868081@78.22.49.130:29171;transport=udp SIP/2.0
     [java] Record-Route: [java] Via: SIP/2.0/UDP 198.65.166.131;branch=z9hG4bK435d.bd42eae.1,SIP/2.0/UDP 198.65.166.156:46053,SIP/2.0/TCP 192.168.1.100:39280;branch=z9hG4bK-d87543-ef150d3acb7f360d-1--d87543-;rport
     [java] Max-Forwards: 16
     [java] Contact: ===========
_________________________________________________________________
Express yourself instantly with MSN Messenger! Download today it's FREE!
http://messenger.msn.click-url.com/go/onm00200471ave/direct/01/
---------------------------------------------------------------------
To unsubscribe, e-mail: users-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: users-help@sip-communicator.dev.java.net

---------------------------------------------------------------------
To unsubscribe, e-mail: users-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: users-help@sip-communicator.dev.java.net


#3

Hi,

the problem is that for some reason the media service has not been activated properly.
So the logs will be help find what the problem is and some information about the environment - the OS, the java version ...

damencho

Christian Ravenier wrote:

···

Hello,

I am running the latest sources r3358, and I get these errors when I attempt to proceed with SIP call.

I still can't really understand how the project is built. I think I want to put my hands under the bonnet but I don't know where to start. Seems like sip-communicator is hooked up to Felix, new to me as well, not that easy to figure out how that works. Is there any information about this ?

The problem I have reported last week or so with the SIP account definition seems cleared.

Christian

==========
     [java] Call-ID: 548e6bfbe81431af673c70103bc5b59b@0.0.0.0
     [java] CSeq: 2 REGISTER
     [java] From: "17476868081" ;tag=8c8e7e21
     [java] To: "17476868081" [java] Max-Forwards: 70
     [java] Route: [java] User-Agent: SIP Communicator 1.0 CVS-Tue_Jan_22_20-39-32_GMT+01-00_2008
     [java] Expires: 3600
     [java] Contact: "17476868081" ;expires=3600
     [java] Via: SIP/2.0/UDP 192.168.1.221:5060;branch=z9hG4bK8832e2711dad2109de73299fc23d66c3
     [java] Authorization: Digest uri="sip:proxy01.sipphone.com",realm="proxy01.sipphone.com",userna me="17476868081",nonce="479647a0a2f824239f7779e227efda136811d8c1",response="de0150fb6ac1ca1984f6f035 4d76c017"
     [java] Content-Length: 0
     [java]
     [java] 20:39:51.838 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTe rminated().1171 Found one processor for method REGISTER, processor is=SipRegistrarConnection-[dn=174 76868081 addr="17476868081" ]
     [java] 20:39:55.563 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest().1204 received request=
     [java] SUBSCRIBE sip:17476868081@78.22.49.130:29171;transport=udp SIP/2.0
     [java] Record-Route: [java] Via: SIP/2.0/UDP 198.65.166.131;branch=z9hG4bKb496.af0b0265.1,SIP/2.0/UDP 198.65.166.156:46053,SIP/2.0/TCP 192.168.1.100:39280;branch=z9hG 4bK-d87543-30100e4022174c26-1--d87543-;rport
     [java] Max-Forwards: 16
     [java] Contact: [java] To: "cr_test" [java] From: "cr_test" ;tag=bc38bc12
     [java] Call-ID: ZTVhYTYxNDE2NTBiMjQxOTFlZDczMzgzMGFkY2VjZmM.
     [java] CSeq: 1 SUBSCRIBE
     [java] Expires: 300
     [java] Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,MESSAGE,SUBSCRIBE,INFO
     [java] User-Agent: X-Lite release 1011s stamp 41150
     [java] Event: message-summary
     [java] Content-Length: 0
     [java]
     [java] 20:39:55.599 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest().1287 Found one processor for method SUBSCRIBE, processor is=net.java.sip.communicator.impl.protocol.sip.OperationSetPresenceSipImpl@3d12a6
     [java] 20:39:55.600 SEVERE: impl.protocol.sip.OperationSetPresenceSipImpl.processRequest().2360 Failed to create a new servertransaction for an incoming request
     [java] (Next message contains the request)
     [java] javax.sip.TransactionAlreadyExistsException: server transaction already exists!
     [java] at gov.nist.javax.sip.SipProviderImpl.getNewServerTransaction(SipProviderImpl.java:457)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetPresenceSipImpl.processRequest(OperationSetPresenceSipImpl.java:2354)
     [java] at net.java.sip.communicator.impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest(ProtocolProviderServiceSipImpl.java:1290)
     [java] at gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:223)
     [java] at gov.nist.javax.sip.EventScanner.run(EventScanner.java:492)
     [java] at java.lang.Thread.run(Thread.java:595)
     [java] 20:40:09.577 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getLocalViaHeaders().1438 generated via headers:Via: SIP/2.0/UDP 192.168.1.221:5060
     [java]
     [java] 20:40:09.579 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getContactHeader().1562 generated contactHeader:Contact: "17476868081" [java]
     [java] 20:40:09.583 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getContactHeader().1518 generated contactHeader:Contact: "17476868081" [java]
     [java] 20:40:09.682 FINE: service.protocol.Call.fireCallParticipantEvent().165 Dispatching a CallParticipant event to 0 listeners. event is: CallParticipantEvent: ID=1 source participant=sip:17471996503@proxy01.sipphone.com <>;status=Unknown source call=Call: id=120103080967618323943 participants=1
     [java] 20:40:09.685 FINE: service.protocol.AbstractCallParticipant.fireCallParticipantChangeEvent().100 Dispatching a CallParticipantChangeEvent event to 1 listeners. event is: CallParticipantChangeEvent: type=CallParticipantStatusChange oldV=net.java.sip.communicator.service.protocol.CallParticipantState:Unknown newV=net.java.sip.communicator.service.protocol.CallParticipantState:Initiating Call for participant=sip:17471996503@proxy01.sipphone.com <>;status=Initiating Call
     [java] 20:40:09.687 FINE: impl.protocol.sip.OperationSetBasicTelephonySipImpl.fireCallEvent().310 Dispatching a CallEvent to 2 listeners. event is: CallEvent:[ id=1 Call=Call: id=120103080967618323943 participants=1]
     [java] Exception in thread "Thread-22" java.lang.NullPointerException: Specified service reference cannot be null.
     [java] at org.apache.felix.framework.BundleContextImpl.getService(BundleContextImpl.java:380)
     [java] at net.java.sip.communicator.impl.protocol.sip.SipActivator.getMediaService(SipActivator.java:143)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetBasicTelephonySipImpl.createOutgoingCall(OperationSetBasicTelephonySipImpl.java:226)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetBasicTelephonySipImpl.createCall(OperationSetBasicTelephonySipImpl.java:116)
     [java] at net.java.sip.communicator.impl.gui.main.call.CallManager$CreateCallThread.run(CallManager.java:827)
     [java] Exception in thread "AWT-EventQueue-0" java.lang.NullPointerException
     [java] at net.java.sip.communicator.impl.gui.main.call.CallManager.actionPerformed(CallManager.java:170)
     [java] at javax.swing.AbstractButton.fireActionPerformed(AbstractButton.java:1849)
     [java] at javax.swing.AbstractButton$Handler.actionPerformed(AbstractButton.java:2169)
     [java] at javax.swing.DefaultButtonModel.fireActionPerformed(DefaultButtonModel.java:420)
     [java] at javax.swing.DefaultButtonModel.setPressed(DefaultButtonModel.java:258)
     [java] at javax.swing.plaf.basic.BasicButtonListener.mouseReleased(BasicButtonListener.java:236)
     [java] at java.awt.Component.processMouseEvent(Component.java:5517)
     [java] at javax.swing.JComponent.processMouseEvent(JComponent.java:3135)
     [java] at java.awt.Component.processEvent(Component.java:5282)
     [java] at java.awt.Container.processEvent(Container.java:1966)
     [java] at java.awt.Component.dispatchEventImpl(Component.java:3984)
     [java] at java.awt.Container.dispatchEventImpl(Container.java:2024)
     [java] at java.awt.Component.dispatchEvent(Component.java:3819)
     [java] at java.awt.LightweightDispatcher.retargetMouseEvent(Container.java:4212)
     [java] at java.awt.LightweightDispatcher.processMouseEvent(Container.java:3892)
     [java] at java.awt.LightweightDispatcher.dispatchEvent(Container.java:3822)
     [java] at java.awt.Container.dispatchEventImpl(Container.java:2010)
     [java] at java.awt.Window.dispatchEventImpl(Window.java:1791)
     [java] at java.awt.Component.dispatchEvent(Component.java:3819)
     [java] at java.awt.EventQueue.dispatchEvent(EventQueue.java:463)
     [java] at java.awt.EventDispatchThread.pumpOneEventForHierarchy(EventDispatchThread.java:242)
     [java] at java.awt.EventDispatchThread.pumpEventsForHierarchy(EventDispatchThread.java:163)
     [java] at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:157)
     [java] at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:149)
     [java] at java.awt.EventDispatchThread.run(EventDispatchThread.java:110)
     [java] 20:40:27.134 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTerminated().1158 Transaction terminated for req=SUBSCRIBE sip:17476868081@78.22.49.130:29171;transport=udp SIP/2.0
     [java] Record-Route: [java] Via: SIP/2.0/UDP 198.65.166.131;branch=z9hG4bKb496.af0b0265.1,SIP/2.0/UDP 198.65.166.156:46053,SIP/2.0/TCP 192.168.1.100:39280;branch=z9hG4bK-d87543-30100e4022174c26-1--d87543-;rport
     [java] Max-Forwards: 16
     [java] Contact: [java] To: "cr_test" [java] From: "cr_test" ;tag=bc38bc12
     [java] Call-ID: ZTVhYTYxNDE2NTBiMjQxOTFlZDczMzgzMGFkY2VjZmM.
     [java] CSeq: 1 SUBSCRIBE
     [java] Expires: 300
     [java] Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,MESSAGE,SUBSCRIBE,INFO
     [java] User-Agent: X-Lite release 1011s stamp 41150
     [java] Event: message-summary
     [java] Content-Length: 0
     [java]
     [java] 20:40:27.134 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTerminated().1171 Found one processor for method SUBSCRIBE, processor is=net.java.sip.communicator.impl.protocol.sip.OperationSetPresenceSipImpl@3d12a6
     [java] 20:41:35.139 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processRequest().1204 received request=
     [java] SUBSCRIBE sip:17476868081@78.22.49.130:29171;transport=udp SIP/2.0
     [java] Record-Route: [java] Via: SIP/2.0/UDP 198.65.166.131;branch=z9hG4bK435d.bd42eae.1,SIP/2.0/UDP 198.65.166.156:46053,SIP/2.0/TCP 192.168.1.100:39280;branch=z9hG4bK-d87543-ef150d3acb7f360d-1--d87543-;rport
     [java] Max-Forwards: 16
     [java] Contact: ===========
_________________________________________________________________
Express yourself instantly with MSN Messenger! Download today it's FREE!
http://messenger.msn.click-url.com/go/onm00200471ave/direct/01/
---------------------------------------------------------------------
To unsubscribe, e-mail: users-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: users-help@sip-communicator.dev.java.net

---------------------------------------------------------------------
To unsubscribe, e-mail: users-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: users-help@sip-communicator.dev.java.net


#4

HI,

More information on the problem for calling SIP numbers under Kubuntu 7.10, reported yesterday. I have tested from Windows 2000 and it works fine.

Hardware : Dell Inspiron 6400
OS : Kubuntu 7.10, 2.6.22-14-generic
Sound device : Card: HDA Intel, Chip: SigmaTel STAC9200

lspci displays this :

00:00.0 Host bridge: Intel Corporation Mobile 945GM/PM/GMS, 943/940GML and 945GT Express Memory Controller Hub (rev 03)
00:01.0 PCI bridge: Intel Corporation Mobile 945GM/PM/GMS, 943/940GML and 945GT Express PCI Express Root Port (rev 03)
00:1b.0 Audio device: Intel Corporation 82801G (ICH7 Family) High Definition Audio Controller (rev 01)
00:1c.0 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 1 (rev 01)
00:1c.3 PCI bridge: Intel Corporation 82801G (ICH7 Family) PCI Express Port 4 (rev 01)
00:1d.0 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI Controller #1 (rev 01)
00:1d.1 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI Controller #2 (rev 01)
00:1d.2 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI Controller #3 (rev 01)
00:1d.3 USB Controller: Intel Corporation 82801G (ICH7 Family) USB UHCI Controller #4 (rev 01)
00:1d.7 USB Controller: Intel Corporation 82801G (ICH7 Family) USB2 EHCI Controller (rev 01)
00:1e.0 PCI bridge: Intel Corporation 82801 Mobile PCI Bridge (rev e1)
00:1f.0 ISA bridge: Intel Corporation 82801GBM (ICH7-M) LPC Interface Bridge (rev 01)
00:1f.2 IDE interface: Intel Corporation 82801GBM/GHM (ICH7 Family) SATA IDE Controller (rev 01)
00:1f.3 SMBus: Intel Corporation 82801G (ICH7 Family) SMBus Controller (rev 01)
01:00.0 VGA compatible controller: ATI Technologies Inc Radeon Mobility X1400
03:00.0 Ethernet controller: Broadcom Corporation BCM4401-B0 100Base-TX (rev 02)
03:01.0 FireWire (IEEE 1394): Ricoh Co Ltd R5C832 IEEE 1394 Controller
03:01.1 Generic system peripheral [0805]: Ricoh Co Ltd R5C822 SD/SDIO/MMC/MS/MSPro Host Adapter (rev 19)
03:01.2 System peripheral: Ricoh Co Ltd R5C843 MMC Host Controller (rev 01)
03:01.3 System peripheral: Ricoh Co Ltd R5C592 Memory Stick Bus Host Adapter (rev 0a)
03:01.4 System peripheral: Ricoh Co Ltd xD-Picture Card Controller (rev 05)
0b:00.0 Network controller: Intel Corporation PRO/Wireless 3945ABG Network Connection (rev 02)

Now the log of the bug. I have configured the SPI account, works, but there is a problem when pressing on the call button after the recipient number is typed in.

Buildfile: build.xml

-deploy-os-specific-bundles:

run:
     [java]
     [java] Welcome to Felix.
     [java] =================
     [java]
     [java] 19:36:39.004 FINER: util.UtilActivator.start().39 Setting default uncaught exception handler.
     [java] 19:36:39.025 FINE: impl.configuration.ConfigurationServiceImpl.start().37 Service Impl: net.java.sip.communicator.impl.configuration.ConfigurationActivator [ STARTED ]
     [java] 19:36:39.026 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition
     [java] 19:36:39.027 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 felix.config.properties=file:/home/cr/ff/eclipse/workspace/sip-communicator/lib/felix.client.run.properties
     [java] 19:36:39.028 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 sun.boot.library.path=/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/i386
     [java] 19:36:39.028 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.vm.version=1.5.0_13-b05
     [java] 19:36:39.029 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.vm.vendor=Sun Microsystems Inc.
     [java] 19:36:39.030 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.vendor.url=http://java.sun.com/
     [java] 19:36:39.030 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 path.separator=:
     [java] 19:36:39.031 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.util.logging.config.file=/home/cr/ff/eclipse/workspace/sip-communicator/lib/logging.properties
     [java] 19:36:39.031 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.vm.name=Java HotSpot(TM) Server VM
     [java] 19:36:39.032 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 file.encoding.pkg=sun.io
     [java] 19:36:39.032 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 sun.java.launcher=SUN_STANDARD
     [java] 19:36:39.033 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 user.country=GB
     [java] 19:36:39.033 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 sun.os.patch.level=unknown
     [java] 19:36:39.034 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.vm.specification.name=Java Virtual Machine Specification
     [java] 19:36:39.034 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 user.dir=/home/cr/ff/eclipse/workspace/sip-communicator
     [java] 19:36:39.035 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.runtime.version=1.5.0_13-b05
     [java] 19:36:39.035 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.awt.graphicsenv=sun.awt.X11GraphicsEnvironment
     [java] 19:36:39.036 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.endorsed.dirs=/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/endorsed
     [java] 19:36:39.036 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 os.arch=i386
     [java] 19:36:39.037 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.io.tmpdir=/tmp
     [java] 19:36:39.037 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 line.separator=
     [java]
     [java] 19:36:39.038 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.vm.specification.vendor=Sun Microsystems Inc.
     [java] 19:36:39.038 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 user.variant=${user.variant}
     [java] 19:36:39.039 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 os.name=Linux
     [java] 19:36:39.040 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 sun.jnu.encoding=UTF-8
     [java] 19:36:39.040 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.net.preferIPv6Addresses=false
     [java] 19:36:39.040 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.library.path=/home/cr/ff/eclipse/workspace/sip-communicator/lib/native/linux:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/i386/server:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/i386:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/lib/i386:/home/cr/ff/eclipse/workspace/sip-communicator/lib/native/windows:/home/cr/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11:/usr/games:/home/cr/scripts:/home/cr/ff/eclipse/workspace/sip-communicator/${dyld.library.path}
     [java] 19:36:39.041 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.specification.name=Java Platform API Specification
     [java] 19:36:39.042 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.class.version=49.0
     [java] 19:36:39.042 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 sun.management.compiler=HotSpot Server Compiler
     [java] 19:36:39.043 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 os.version=2.6.22-14-generic
     [java] 19:36:39.065 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 user.home=/home/cr
     [java] 19:36:39.065 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 user.timezone=GMT+01:00
     [java] 19:36:39.066 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.awt.printerjob=sun.print.PSPrinterJob
     [java] 19:36:39.067 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 file.encoding=UTF-8
     [java] 19:36:39.067 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.specification.version=1.5
     [java] 19:36:39.068 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.class.path=/home/cr/ff/eclipse/workspace/sip-communicator/lib:/home/cr/ff/eclipse/workspace/sip-communicator/sc-bundles/util.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/bundle/junit.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/bundle/log4j.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/bundle/org.apache.felix.bundlerepository-1.0.0.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/bundle/org.apache.felix.servicebinder-0.9.0-SNAPSHOT.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/felix.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/JainSipApi1.2.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/JainSipRi1.2.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/Stun4J.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/aclibico-2.1.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/bcprov-jdk14-130.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/commons-logging.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/concurrent.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/dnsjava-2.0.3.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/jcalendar-1.3.2.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/jdom.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/jmf.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/jml-1.0b2.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/joscar-client.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/joscar-common.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/joscar-protocol.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/jsch-0.1.33.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/jsocks-klea.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/jspeex.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/junit.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/log4j-1.2.8.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/nist-sdp-1.0.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/pircbot.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/rome-0.9.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/smack.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/smackx-jingle.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/smackx.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/installer-exclude/ymsg_network_v0_63.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/jdic-all.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/os-specific/linux/installer-exclude/jmf.jar:/home/cr/ff/eclipse/workspace/sip-communicator/lib/os-specific/linux/jdic_stub.jar
     [java] 19:36:39.069 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 user.name=cr
     [java] 19:36:39.070 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.vm.specification.version=1.0
     [java] 19:36:39.070 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.home=/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre
     [java] 19:36:39.071 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 sun.arch.data.model=32
     [java] 19:36:39.072 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 user.language=en
     [java] 19:36:39.073 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.specification.vendor=Sun Microsystems Inc.
     [java] 19:36:39.073 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.vm.info=mixed mode
     [java] 19:36:39.074 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.version=1.5.0_13
     [java] 19:36:39.075 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.ext.dirs=/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/ext
     [java] 19:36:39.076 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 sun.boot.class.path=/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/rt.jar:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/i18n.jar:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/sunrsasign.jar:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/jsse.jar:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/jce.jar:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/lib/charsets.jar:/usr/lib/jvm/java-1.5.0-sun-1.5.0.13/jre/classes
     [java] 19:36:39.076 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.vendor=Sun Microsystems Inc.
     [java] 19:36:39.077 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 file.separator=/
     [java] 19:36:39.078 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi
     [java] 19:36:39.078 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 sun.io.unicode.encoding=UnicodeLittle
     [java] 19:36:39.079 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 sun.cpu.endian=little
     [java] 19:36:39.080 FINE: impl.configuration.ConfigurationServiceImpl.debugPrintSystemProperties().1103 sun.cpu.isalist=
     [java] 19:36:39.081 FINE: impl.configuration.ConfigurationServiceImpl.createConfigurationFile().847 Using config file in $HOME/.sip-communicator: /home/cr/ff/eclipse/workspace/sip-communicator/sip-communicator.xml
     [java] 19:36:39.166 FINE: impl.configuration.ConfigurationServiceImpl.start().46 Service Impl: net.java.sip.communicator.impl.configuration.ConfigurationActivator [REGISTERED]
     [java] 19:36:39.173 FINE: impl.version.VersionActivator.start().42 Started.
     [java] 19:36:39.176 FINE: impl.version.VersionActivator.start().53 SIP Protocol Provider Factory ... [REGISTERED]
     [java] 19:36:39.177 FINE: impl.version.VersionActivator.start().54 SIP Communicator Version: sip-communicator-1.0-alpha3-0.build.by.cr
     [java] 19:36:39.178 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 sip-communicator.version( oldValue=1.0-alpha3-0.build.by.cr, newValue=1.0-alpha3-0.build.by.cr.
     [java] 19:36:39.220 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 sip-communicator.application.name( oldValue=SIP Communicator, newValue=SIP Communicator.
     [java] 19:36:41.645 INFO: impl.browserlauncher.BrowserLauncherActivator.start().37 UI Service...[ STARTED ]
     [java] 19:36:41.648 INFO: impl.browserlauncher.BrowserLauncherActivator.start().42 UI Service ...[REGISTERED]
     [java] 19:36:41.675 FINE: impl.media.MediaActivator.start().53 Started.
     [java] 19:36:41.721 FINEST: impl.media.device.JmfDeviceDetector.setupJMF().294 [entry] setupJMF
     [java] 19:36:41.723 FINEST: impl.fileaccess.FileAccessServiceImpl.getPrivatePersistentFile().117 [entry] getPrivatePersistentFile
     [java] 19:36:41.725 FINEST: impl.fileaccess.FileAccessServiceImpl.accessibleFile().323 [entry] accessibleFile
     [java] 19:36:41.726 FINEST: impl.fileaccess.FileAccessServiceImpl.accessibleFile().358 [exit] accessibleFile
     [java] 19:36:41.729 FINEST: impl.fileaccess.FileAccessServiceImpl.getPrivatePersistentFile().130 [exit] getPrivatePersistentFile
     [java] 19:36:42.327 INFO: impl.media.device.JmfDeviceDetector.detectCaptureDevices().116 Looking for Audio capturer
     [java] 19:36:42.339 INFO: impl.media.device.DirectSoundAuto.().55 DirectSound Capture Supported = false
     [java] 19:36:42.416 INFO: impl.media.device.JavaSoundAuto.().43 JavaSound Capture Supported = true
     [java] 19:36:42.482 INFO: impl.media.device.JavaSoundAuto.().69 JavaSoundAuto: Committed ok
     [java] 19:36:42.483 INFO: impl.media.device.JmfDeviceDetector.detectCaptureDevices().122 Looking for video capture devices
     [java] 19:36:42.488 FINE: impl.media.device.JmfDeviceDetector.detectCaptureDevices().135 No VFW video detected: com/sun/media/protocol/vfw/VFWCapture
     [java] 19:36:42.508 INFO: impl.media.device.JmfDeviceDetector.detectCaptureDevices().144 Detected 0 SUN Video capture device(s).
     [java] 19:36:42.526 INFO: impl.media.device.JmfDeviceDetector.detectCaptureDevices().159 Detected 0 SUN Video Plus device(s).
     [java] 19:36:42.531 FINE: impl.media.device.V4LAuto.autoDetect().94 No device for index 0. Can't open video card 0
     [java] 19:36:42.533 FINE: impl.media.device.V4LAuto.autoDetect().94 No device for index 1. Can't open video card 1
     [java] 19:36:42.535 FINE: impl.media.device.V4LAuto.autoDetect().94 No device for index 2. Can't open video card 2
     [java] 19:36:42.537 FINE: impl.media.device.V4LAuto.autoDetect().94 No device for index 3. Can't open video card 3
     [java] 19:36:42.552 FINE: impl.media.device.V4LAuto.autoDetect().94 No device for index 4. Can't open video card 4
     [java] 19:36:42.554 FINE: impl.media.device.V4LAuto.autoDetect().94 No device for index 5. Can't open video card 5
     [java] 19:36:42.556 FINE: impl.media.device.V4LAuto.autoDetect().94 No device for index 6. Can't open video card 6
     [java] 19:36:42.559 FINE: impl.media.device.V4LAuto.autoDetect().94 No device for index 7. Can't open video card 7
     [java] 19:36:42.561 FINE: impl.media.device.V4LAuto.autoDetect().94 No device for index 8. Can't open video card 8
     [java] 19:36:42.563 FINE: impl.media.device.V4LAuto.autoDetect().94 No device for index 9. Can't open video card 9
     [java] 19:36:42.564 INFO: impl.media.device.JmfDeviceDetector.detectCaptureDevices().173 Detected 10 V4L video capture device.
     [java] 19:36:42.565 FINEST: impl.media.device.JmfDeviceDetector.setupJMF().345 [exit] setupJMF
     [java] 19:36:42.565 INFO: impl.media.device.DeviceConfiguration.extractConfiguredCaptureDevices().81 Scanning for configured Audio Devices.
     [java] 19:36:42.566 FINE: impl.media.device.DeviceConfiguration.extractConfiguredCaptureDevices().89 Found 1 capture devices: [JavaSound audio capture : javasound://44100
     [java] LINEAR, 44100.0 Hz, 16-bit, Stereo, LittleEndian, Signed
     [java] LINEAR, 44100.0 Hz, 16-bit, Mono, LittleEndian, Signed
     [java] LINEAR, 22050.0 Hz, 16-bit, Stereo, LittleEndian, Signed
     [java] LINEAR, 22050.0 Hz, 16-bit, Mono, LittleEndian, Signed
     [java] LINEAR, 11025.0 Hz, 16-bit, Stereo, LittleEndian, Signed
     [java] LINEAR, 11025.0 Hz, 16-bit, Mono, LittleEndian, Signed
     [java] LINEAR, 8000.0 Hz, 16-bit, Stereo, LittleEndian, Signed
     [java] LINEAR, 8000.0 Hz, 16-bit, Mono, LittleEndian, Signed
     [java] ]
     [java] 19:36:42.568 INFO: impl.media.device.DeviceConfiguration.extractConfiguredCaptureDevices().92 Found JavaSound audio capture as an audio capture device.
     [java] 19:36:42.568 INFO: impl.media.device.DeviceConfiguration.extractConfiguredCaptureDevices().96 Scanning for configured Video Devices.
     [java] 19:36:42.569 INFO: impl.media.device.DeviceConfiguration.extractConfiguredCaptureDevices().116 No Video Device was found.
     [java] 19:36:42.570 FINE: impl.media.MediaControl.registerCustomPackages().1158 Adding package : net.java.sip.communicator.impl
     [java] 19:36:42.610 FINE: impl.media.MediaControl.registerCustomPackages().1164 Registering new protocol prefix list : [javax, com.sun, com.ibm, net.java.sip.communicator.impl]
     [java] 19:36:42.611 INFO: impl.media.MediaControl.createDataSource().676 Creating datasource for:javasound://44100
     [java] 19:36:42.703 FINE: impl.media.MediaControl.registerCustomCodecs().1106 Codec : net.java.sip.communicator.impl.media.codec.audio.alaw.JavaEncoder is succsefully registered : true
     [java] 19:36:42.705 FINE: impl.media.MediaControl.registerCustomCodecs().1106 Codec : net.java.sip.communicator.impl.media.codec.audio.alaw.DePacketizer is succsefully registered : true
     [java] 19:36:42.708 FINE: impl.media.MediaControl.registerCustomCodecs().1106 Codec : net.java.sip.communicator.impl.media.codec.audio.alaw.Packetizer is succsefully registered : true
     [java] 19:36:42.735 FINE: impl.media.MediaControl.registerCustomCodecs().1106 Codec : net.java.sip.communicator.impl.media.codec.audio.ulaw.Packetizer is succsefully registered : true
     [java] 19:36:42.738 FINE: impl.media.MediaControl.registerCustomCodecs().1106 Codec : net.java.sip.communicator.impl.media.codec.audio.speex.JavaEncoder is succsefully registered : true
     [java] 19:36:42.740 FINE: impl.media.MediaControl.registerCustomCodecs().1106 Codec : net.java.sip.communicator.impl.media.codec.audio.speex.JavaDecoder is succsefully registered : true
     [java] 19:36:42.743 FINE: impl.media.MediaControl.registerCustomCodecs().1106 Codec : net.java.sip.communicator.impl.media.codec.audio.ilbc.JavaEncoder is succsefully registered : true
     [java] 19:36:42.745 FINE: impl.media.MediaControl.registerCustomCodecs().1106 Codec : net.java.sip.communicator.impl.media.codec.audio.ilbc.JavaDecoder is succsefully registered : true
     [java] Cannot open audio device for input: javax.sound.sampled.LineUnavailableException: line with format PCM_SIGNED 44100.0 Hz, 16 bit, stereo, 4 bytes/frame, little-endian not supported.
     [java] Failed to configure: com.sun.media.ProcessEngine@36ae83
     [java] IO exception: line with format PCM_SIGNED 44100.0 Hz, 16 bit, stereo, 4 bytes/frame, little-endian not supported.
     [java]
     [java] Error: Unable to configure com.sun.media.ProcessEngine@36ae83
     [java] javax.media.NotConfiguredError: setContentDescriptor cannot be called before configured
     [java] at com.sun.media.ProcessEngine.setContentDescriptor(ProcessEngine.java:342)
     [java] at com.sun.media.MediaProcessor.setContentDescriptor(MediaProcessor.java:123)
     [java] at net.java.sip.communicator.impl.media.MediaControl.initProcessor(MediaControl.java:542)
     [java] at net.java.sip.communicator.impl.media.MediaControl.initCaptureDevices(MediaControl.java:412)
     [java] at net.java.sip.communicator.impl.media.MediaControl.initialize(MediaControl.java:204)
     [java] at net.java.sip.communicator.impl.media.MediaServiceImpl$DeviceConfigurationThread.run(MediaServiceImpl.java:394)
     [java] at net.java.sip.communicator.impl.media.MediaServiceImpl.start(MediaServiceImpl.java:223)
     [java] ERROR: Error starting reference:file:sc-bundles/media.jar (org.osgi.framework.BundleException: Activator start error.)
     [java] at net.java.sip.communicator.impl.media.MediaActivator.start(MediaActivator.java:60)
     [java] at org.apache.felix.framework.util.SecureAction.startActivator(SecureAction.java:589)
     [java] at org.apache.felix.framework.Felix._startBundle(Felix.java:1536)
     [java] at org.apache.felix.framework.Felix.startBundle(Felix.java:1470)
     [java] at org.apache.felix.framework.Felix.setFrameworkStartLevel(Felix.java:1065)
     [java] at org.apache.felix.framework.StartLevelImpl.run(StartLevelImpl.java:258)
     [java] at java.lang.Thread.run(Thread.java:595)
     [java] javax.media.NotConfiguredError: setContentDescriptor cannot be called before configured
     [java] at com.sun.media.ProcessEngine.setContentDescriptor(ProcessEngine.java:342)
     [java] at com.sun.media.MediaProcessor.setContentDescriptor(MediaProcessor.java:123)
     [java] at net.java.sip.communicator.impl.media.MediaControl.initProcessor(MediaControl.java:542)
     [java] at net.java.sip.communicator.impl.media.MediaControl.initCaptureDevices(MediaControl.java:412)
     [java] at net.java.sip.communicator.impl.media.MediaControl.initialize(MediaControl.java:204)
     [java] at net.java.sip.communicator.impl.media.MediaServiceImpl$DeviceConfigurationThread.run(MediaServiceImpl.java:394)
     [java] at net.java.sip.communicator.impl.media.MediaServiceImpl.start(MediaServiceImpl.java:223)
     [java] at net.java.sip.communicator.impl.media.MediaActivator.start(MediaActivator.java:60)
     [java] at org.apache.felix.framework.util.SecureAction.startActivator(SecureAction.java:589)
     [java] at org.apache.felix.framework.Felix._startBundle(Felix.java:1536)
     [java] at org.apache.felix.framework.Felix.startBundle(Felix.java:1470)
     [java] at org.apache.felix.framework.Felix.setFrameworkStartLevel(Felix.java:1065)
     [java] at org.apache.felix.framework.StartLevelImpl.run(StartLevelImpl.java:258)
     [java] at java.lang.Thread.run(Thread.java:595)
     [java] 19:36:43.215 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().414 Discovered 0 stored accounts
     [java] 19:36:43.216 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().414 Discovered 0 stored accounts
     [java] 19:36:43.229 FINE: impl.protocol.sip.SipActivator.start().48 Started.
     [java] 19:36:43.232 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().414 Discovered 1 stored accounts
     [java] 19:36:43.233 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().424 Loading account net.java.sip.communicator.impl.protocol.sip.acc1201018861325
     [java] 19:36:43.355 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.initialize().600 Created stack: gov.nist.javax.sip.SipStackImpl@1429cf1
     [java] 19:36:43.480 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.createListeningPoint().943 Created LP 0.0.0.0:5060/udp
     [java] 19:36:43.493 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.createListeningPoint().943 Created LP 0.0.0.0:5060/tcp
     [java] 19:36:44.096 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.createListeningPoint().943 Created LP 0.0.0.0:5061/tls
     [java] 19:36:44.114 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.initListeningPoints().863 Created listening points and SIP provider for account SIP:17476868081@proxy01.sipphone.com
     [java] 19:36:44.115 FINER: impl.protocol.sip.ProtocolProviderServiceSipImpl.initListeningPoints().884 Done creating listening points.
     [java] 19:36:44.256 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.().260 presence initialized with :true, true, 30, 3600 for null
     [java] 19:36:44.294 FINE: impl.protocol.sip.SipActivator.start().63 SIP Protocol Provider Factory ... [REGISTERED]
     [java] 19:36:44.406 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().414 Discovered 0 stored accounts
     [java] 19:36:44.443 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().414 Discovered 0 stored accounts
     [java] 19:36:44.474 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().414 Discovered 0 stored accounts
     [java] 19:36:44.509 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().414 Discovered 0 stored accounts
     [java] 19:36:44.510 INFO: impl.protocol.gibberish.GibberishActivator.start().74 Gibberish protocol implementation [STARTED].
     [java] 19:36:44.519 FINEST: impl.netaddr.NetworkAddressManagerServiceImpl.start().42 [entry] start
     [java] 19:36:44.550 INFO: impl.netaddr.NetworkAddressManagerServiceImpl.start().149 Stun server address(null)/port(null) not set (or invalid). Disabling STUN.
     [java] 19:36:44.550 INFO: impl.netaddr.NetworkAddressManagerServiceImpl.start().59 Network Address Manager ...[ STARTED ]
     [java] 19:36:44.551 INFO: impl.netaddr.NetworkAddressManagerServiceImpl.start().64 Network Address Manager Service ...[REGISTERED]
     [java] 19:36:44.551 FINEST: impl.netaddr.NetworkAddressManagerServiceImpl.start().68 [exit] start
     [java] 19:36:44.567 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().414 Discovered 0 stored accounts
     [java] 19:36:44.568 INFO: impl.protocol.rss.RssActivator.start().75 RSS protocol implementation [STARTED].
     [java] 19:36:44.570 FINE: impl.protocol.rss.RssActivator.start().82 User-Agent set to SIP Communicator/1.0-alpha3-0.build.by.cr
     [java] 19:36:44.578 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().414 Discovered 0 stored accounts
     [java] 19:36:44.580 INFO: impl.protocol.zeroconf.ZeroconfActivator.start().77 Zeroconf protocol implementation [STARTED].
     [java] 19:36:44.587 FINE: service.protocol.ProtocolProviderFactory.loadStoredAccounts().414 Discovered 0 stored accounts
     [java] 19:36:44.588 INFO: impl.protocol.irc.IrcActivator.start().75 IRC protocol implementation [STARTED].
     [java] 19:36:44.596 FINE: impl.contactlist.ContactlistActivator.start().36 Service Impl: net.java.sip.communicator.impl.contactlist.ContactlistActivator [ STARTED ]
     [java] 19:36:44.630 FINE: impl.contactlist.MetaContactListServiceImpl.start().139 Starting the meta contact list implementation.
     [java] 19:36:44.632 FINEST: impl.fileaccess.FileAccessServiceImpl.getPrivatePersistentFile().117 [entry] getPrivatePersistentFile
     [java] 19:36:44.633 FINEST: impl.fileaccess.FileAccessServiceImpl.accessibleFile().323 [entry] accessibleFile
     [java] 19:36:44.634 FINEST: impl.fileaccess.FileAccessServiceImpl.accessibleFile().358 [exit] accessibleFile
     [java] 19:36:44.635 FINEST: impl.fileaccess.FileAccessServiceImpl.getPrivatePersistentFile().130 [exit] getPrivatePersistentFile
     [java] 19:36:44.641 FINE: impl.contactlist.MetaContactListServiceImpl.start().177 Found 1 already installed providers.
     [java] 19:36:44.642 FINE: impl.contactlist.MetaContactListServiceImpl.handleProviderAdded().1495 Adding protocol provider SIP
     [java] 19:36:44.644 FINER: impl.contactlist.MetaContactListServiceImpl.synchronizeOpSetWithLocalContactList().1385 subgroups: 0
     [java] 19:36:44.645 FINER: impl.contactlist.MetaContactListServiceImpl.synchronizeOpSetWithLocalContactList().1387 child contacts: 0
     [java] 19:36:44.646 FINE: impl.contactlist.ContactlistActivator.start().49 Service Impl: net.java.sip.communicator.impl.contactlist.ContactlistActivator [REGISTERED]
     [java] 19:36:44.673 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.history.HistoryServiceImpl
     [java] 19:36:44.676 FINEST: impl.msghistory.MessageHistoryActivator.start().37 [entry] start
     [java] 19:36:44.688 FINE: impl.msghistory.MessageHistoryServiceImpl.setHistoryService().826 New history service registered.
     [java] 19:36:44.688 FINE: impl.msghistory.MessageHistoryServiceImpl.start().605 Starting the msg history implementation.
     [java] 19:36:44.689 FINE: impl.msghistory.MessageHistoryServiceImpl.start().630 Found 1 already installed providers.
     [java] 19:36:44.690 FINE: impl.msghistory.MessageHistoryServiceImpl.handleProviderAdded().889 Adding protocol provider SIP
     [java] 19:36:44.692 FINER: impl.msghistory.MessageHistoryServiceImpl.handleProviderAdded().926 Service did not have a multi im op. set.
     [java] 19:36:44.693 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.msghistory.MessageHistoryServiceImpl
     [java] 19:36:44.694 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.msghistory.MessageHistoryServiceImpl
     [java] 19:36:44.695 INFO: impl.msghistory.MessageHistoryActivator.start().56 Message History Service ...[REGISTERED]
     [java] 19:36:44.696 FINEST: impl.msghistory.MessageHistoryActivator.start().60 [exit] start
     [java] 19:36:44.698 FINEST: impl.callhistory.CallHistoryActivator.start().37 [entry] start
     [java] 19:36:44.707 FINE: impl.callhistory.CallHistoryServiceImpl.setHistoryService().608 New history service registered.
     [java] 19:36:44.708 FINE: impl.callhistory.CallHistoryServiceImpl.start().468 Starting the call history implementation.
     [java] 19:36:44.709 FINE: impl.callhistory.CallHistoryServiceImpl.start().493 Found 1 already installed providers.
     [java] 19:36:44.710 FINE: impl.callhistory.CallHistoryServiceImpl.handleProviderAdded().671 Adding protocol provider SIP
     [java] 19:36:44.711 FINER: impl.callhistory.CallHistoryServiceImpl.serviceChanged().640 Received a service event for: net.java.sip.communicator.impl.callhistory.CallHistoryServiceImpl
     [java] 19:36:44.712 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.callhistory.CallHistoryServiceImpl
     [java] 19:36:44.713 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.callhistory.CallHistoryServiceImpl
     [java] 19:36:44.714 INFO: impl.callhistory.CallHistoryActivator.start().56 Call History Service ...[REGISTERED]
     [java] 19:36:44.715 FINEST: impl.callhistory.CallHistoryActivator.start().60 [exit] start
     [java] 19:36:44.720 FINEST: impl.audionotifier.AudioNotifierActivator.start().54 [entry] start
     [java] 19:36:44.721 INFO: impl.audionotifier.AudioNotifierActivator.start().56 Audio Notifier Service...[ STARTED ]
     [java] 19:36:44.722 FINER: impl.callhistory.CallHistoryServiceImpl.serviceChanged().640 Received a service event for: net.java.sip.communicator.impl.audionotifier.AudioNotifierServiceImpl
     [java] 19:36:44.723 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.audionotifier.AudioNotifierServiceImpl
     [java] 19:36:44.724 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.audionotifier.AudioNotifierServiceImpl
     [java] 19:36:44.725 INFO: impl.audionotifier.AudioNotifierActivator.start().61 Audio Notifier Service ...[REGISTERED]
     [java] 19:36:44.725 FINEST: impl.audionotifier.AudioNotifierActivator.start().64 [exit] start
     [java] 19:36:44.736 INFO: impl.notification.NotificationActivator.start().46 Notification Service...[ STARTED ]
     [java] 19:36:44.737 FINER: impl.callhistory.CallHistoryServiceImpl.serviceChanged().640 Received a service event for: net.java.sip.communicator.impl.notification.NotificationServiceImpl
     [java] 19:36:44.738 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.notification.NotificationServiceImpl
     [java] 19:36:44.739 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.notification.NotificationServiceImpl
     [java] 19:36:44.740 INFO: impl.notification.NotificationActivator.start().53 Notification Service ...[REGISTERED]
     [java] 19:36:44.741 FINEST: impl.notification.NotificationActivator.start().55 [entry] start
     [java] 19:36:44.742 FINEST: impl.notification.NotificationActivator.start().58 [exit] start
     [java] 19:36:44.850 INFO: impl.gui.GuiActivator.start().76 UI Service...[ STARTED ]
     [java] 19:36:44.851 FINER: impl.callhistory.CallHistoryServiceImpl.serviceChanged().640 Received a service event for: net.java.sip.communicator.impl.gui.UIServiceImpl
     [java] 19:36:44.852 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.gui.UIServiceImpl
     [java] 19:36:44.853 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.gui.UIServiceImpl
     [java] 19:36:44.854 INFO: impl.gui.GuiActivator.start().81 UI Service ...[REGISTERED]
     [java] 19:36:46.280 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.showOffline( oldValue=true, newValue=true.
     [java] 19:36:46.397 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.fireRegistrationStateChanged().331 Dispatching RegistrationStateChangeEvent[ oldState=Unregistered; newState=RegistrationState=Registering;reasonCode=-1;reason=null] to 3 listeners.
     [java] 19:36:46.398 FINE: impl.protocol.sip.OperationSetBasicInstantMessagingSipImpl.registrationStateChanged().571 The provider changed state from: RegistrationState=Unregistered to: RegistrationState=Registering
     [java] 19:36:46.398 FINER: impl.protocol.sip.ProtocolProviderServiceSipImpl.fireRegistrationStateChanged().348 Done.
     [java] 19:36:46.420 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getLocalViaHeaders().1438 generated via headers:Via: SIP/2.0/UDP 192.168.1.221:5060
     [java]
     [java] 19:36:46.421 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getMaxForwardsHeader().1483 generated max forwards: Max-Forwards: 70
     [java]
     [java] 19:36:46.454 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getContactHeader().1562 generated contactHeader:Contact: "17476868081"
     [java]
     [java] 19:36:46.496 FINE: impl.protocol.sip.SipRegistrarConnection.register().363 sent request= REGISTER sip:proxy01.sipphone.com SIP/2.0
     [java] Call-ID: fbc393985bae52d11071212b03e39b68@0.0.0.0
     [java] CSeq: 1 REGISTER
     [java] From: "17476868081" ;tag=7188268
     [java] To: "17476868081"
     [java] Via: SIP/2.0/UDP 192.168.1.221:5060;branch=z9hG4bKf47ee5401e41acb7b231d33388814b32
     [java] Max-Forwards: 70
     [java] Route:
     [java] User-Agent: SIP Communicator 1.0 CVS-Wed_Jan_23_19-36-46_GMT+01-00_2008
     [java] Expires: 3600
     [java] Contact: "17476868081" ;expires=3600
     [java] Content-Length: 0
     [java]
     [java]
     [java] 19:36:46.803 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processResponse().1057 received response=
     [java] SIP/2.0 401 Unauthorized
     [java] Call-ID: fbc393985bae52d11071212b03e39b68@0.0.0.0
     [java] CSeq: 1 REGISTER
     [java] From: "17476868081" ;tag=7188268
     [java] To: "17476868081" ;tag=21a483426c2cd5d9b85bffe6bba40a2e.1c1d
     [java] Via: SIP/2.0/UDP 78.22.49.130:14038;branch=z9hG4bKf47ee5401e41acb7b231d33388814b32
     [java] WWW-Authenticate: Digest realm="proxy01.sipphone.com",nonce="47978a6a3ebdff1c27a47ee9620b2a0e415023ee"
     [java] Content-Length: 0
     [java]
     [java]
     [java] 19:36:46.804 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processResponse().1078 Found one processor for method REGISTER, processor is=SipRegistrarConnection-[dn=17476868081 addr="17476868081" ]
     [java] 19:36:46.808 FINE: impl.protocol.sip.SipRegistrarConnection.processAuthenticationChallenge().871 Authenticating a Register request.
     [java] 19:36:46.817 FINER: impl.protocol.sip.security.SipSecurityManager.handleChallenge().196 We don't seem to have a good pass! Get one.
     [java] 19:36:46.888 INFO: impl.systray.SystrayActivator.start().53 Systray Service...[ STARTED ]
     [java] 19:36:46.899 FINER: impl.callhistory.CallHistoryServiceImpl.serviceChanged().640 Received a service event for: net.java.sip.communicator.impl.systray.jdic.SystrayServiceJdicImpl
     [java] 19:36:46.900 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.systray.jdic.SystrayServiceJdicImpl
     [java] 19:36:46.901 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.systray.jdic.SystrayServiceJdicImpl
     [java] 19:36:46.901 INFO: impl.systray.SystrayActivator.start().60 Systray Service ...[REGISTERED]
     [java] 19:36:46.902 FINEST: impl.systray.SystrayActivator.start().62 [entry] start
     [java] 19:36:46.902 FINEST: impl.systray.SystrayActivator.start().65 [exit] start
     [java] 19:36:47.399 INFO: plugin.gibberishaccregwizz.GibberishAccRegWizzActivator.start().49 Loading gibberish account wizard.
     [java] 19:36:47.430 INFO: plugin.gibberishaccregwizz.GibberishAccRegWizzActivator.start().65 Gibberish account registration wizard [STARTED].
     [java] 19:36:47.478 INFO: plugin.rssaccregwizz.RssAccRegWizzActivator.start().42 Loading rss account wizard.
     [java] 19:36:47.496 INFO: plugin.rssaccregwizz.RssAccRegWizzActivator.start().60 RSS account registration wizard [STARTED].
     [java] 19:36:47.506 INFO: plugin.zeroconfaccregwizz.ZeroconfAccRegWizzActivator.start().45 Loading zeroconf account wizard.
     [java] 19:36:47.536 INFO: plugin.zeroconfaccregwizz.ZeroconfAccRegWizzActivator.start().62 Zeroconf account registration wizard [STARTED].
     [java] 19:36:47.545 INFO: plugin.ircaccregwizz.IrcAccRegWizzActivator.start().40 Loading irc account wizard.
     [java] 19:36:47.563 INFO: plugin.ircaccregwizz.IrcAccRegWizzActivator.start().58 IRC account registration wizard [STARTED].
     [java] 19:36:47.593 FINE: impl.shutdown.ShutdownTimeout.start().51 Starting the ShutdownTimeout service.
     [java] 19:36:49.671 FINER: impl.contactlist.MclStorageManager.storeContactList0().375 storing contact list. because is started ==true
     [java] 19:36:49.672 FINER: impl.contactlist.MclStorageManager.storeContactList0().377 storing contact list. because is modified ==true
     [java] 19:36:57.654 FINE: impl.protocol.sip.security.MessageDigestAlgorithm.calculateResponse().61 trying to authenticate using : null, 17476868081, proxy01.sipphone.com, true, 47978a6a3ebdff1c27a47ee9620b2a0e415023ee, 00000001, xyz, REGISTER, sip:proxy01.sipphone.com, , null
     [java] 19:36:57.656 FINE: impl.protocol.sip.security.SipSecurityManager.handleChallenge().260 Created authorization header: Authorization: Digest uri="sip:proxy01.sipphone.com",realm="proxy01.sipphone.com",username="17476868081",nonce="47978a6a3ebdff1c27a47ee9620b2a0e415023ee",response="96a797a5ab2b5840fec3a0fce7db07e2"
     [java]
     [java] 19:36:57.657 FINE: impl.protocol.sip.security.SipSecurityManager.handleChallenge().277 Returning authorization transaction.
     [java] 19:36:57.669 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.main.login.AuthenticationWindow.width( oldValue=426, newValue=426.
     [java] 19:36:57.682 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.main.login.AuthenticationWindow.height( oldValue=262, newValue=262.
     [java] 19:36:57.696 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.main.login.AuthenticationWindow.x( oldValue=627, newValue=627.
     [java] 19:36:57.702 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.main.login.AuthenticationWindow.y( oldValue=394, newValue=394.
     [java] 19:36:57.713 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTerminated().1158 Transaction terminated for req=REGISTER sip:proxy01.sipphone.com SIP/2.0
     [java] Call-ID: fbc393985bae52d11071212b03e39b68@0.0.0.0
     [java] CSeq: 1 REGISTER
     [java] From: "17476868081" ;tag=7188268
     [java] To: "17476868081"
     [java] Via: SIP/2.0/UDP 192.168.1.221:5060;branch=z9hG4bKf47ee5401e41acb7b231d33388814b32
     [java] Max-Forwards: 70
     [java] Route:
     [java] User-Agent: SIP Communicator 1.0 CVS-Wed_Jan_23_19-36-46_GMT+01-00_2008
     [java] Expires: 3600
     [java] Contact: "17476868081" ;expires=3600
     [java] Content-Length: 0
     [java]
     [java]
     [java] 19:36:57.713 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTerminated().1171 Found one processor for method REGISTER, processor is=SipRegistrarConnection-[dn=17476868081 addr="17476868081" ]
     [java] 19:36:57.919 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processResponse().1057 received response=
     [java] SIP/2.0 200 OK
     [java] Call-ID: fbc393985bae52d11071212b03e39b68@0.0.0.0
     [java] CSeq: 2 REGISTER
     [java] From: "17476868081" ;tag=7188268
     [java] To: "17476868081" ;tag=21a483426c2cd5d9b85bffe6bba40a2e.4ec9
     [java] Via: SIP/2.0/UDP 78.22.49.130:14038;branch=z9hG4bK15022a418fd7ee193483a765fce89a6a
     [java] Contact: ;expires=3600
     [java] Content-Length: 0
     [java]
     [java]
     [java] 19:36:57.920 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processResponse().1078 Found one processor for method REGISTER, processor is=SipRegistrarConnection-[dn=17476868081 addr="17476868081" ]
     [java] 19:36:57.935 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.fireRegistrationStateChanged().331 Dispatching RegistrationStateChangeEvent[ oldState=Registering; newState=RegistrationState=Registered;reasonCode=-1;reason=null] to 3 listeners.
     [java] 19:36:57.936 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.registrationStateChanged().4474 enter registered state
     [java] 19:36:57.939 FINE: impl.protocol.sip.OperationSetBasicInstantMessagingSipImpl.registrationStateChanged().571 The provider changed state from: RegistrationState=Registering to: RegistrationState=Registered
     [java] 19:36:57.959 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.fireProviderStatusChangeEvent().701 Dispatching Provider Status Change. Listeners=2 evt=ProviderPresenceStatusChangeEvent-[OldStatus=PresenceStatus:Offline, NewStatus=PresenceStatus:Online]
     [java] 19:36:57.960 FINER: impl.protocol.sip.ProtocolProviderServiceSipImpl.fireRegistrationStateChanged().348 Done.
     [java] 19:36:57.968 FINER: impl.systray.jdic.StatusSelector.updateStatus().160 Systray update status for provider: sip:17476868081@proxy01.sipphone.com. The new status will be: Online
     [java] 19:36:57.972 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.fireProviderStatusChangeEvent().719 status dispatching done.
     [java] 19:36:57.973 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.fireProviderMsgStatusChangeEvent().735 Dispatching stat. msg change. Listeners=2 evt=java.beans.PropertyChangeEvent[source=net.java.sip.communicator.impl.protocol.sip.ProtocolProviderServiceSipImpl@a193fe]
     [java] 19:36:57.974 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.fireProviderMsgStatusChangeEvent().753 status dispatching done.
     [java] 19:37:03.335 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTerminated().1158 Transaction terminated for req=REGISTER sip:proxy01.sipphone.com SIP/2.0
     [java] Call-ID: fbc393985bae52d11071212b03e39b68@0.0.0.0
     [java] CSeq: 2 REGISTER
     [java] From: "17476868081" ;tag=7188268
     [java] To: "17476868081"
     [java] Max-Forwards: 70
     [java] Route:
     [java] User-Agent: SIP Communicator 1.0 CVS-Wed_Jan_23_19-36-46_GMT+01-00_2008
     [java] Expires: 3600
     [java] Contact: "17476868081" ;expires=3600
     [java] Via: SIP/2.0/UDP 192.168.1.221:5060;branch=z9hG4bK15022a418fd7ee193483a765fce89a6a
     [java] Authorization: Digest uri="sip:proxy01.sipphone.com",realm="proxy01.sipphone.com",username="17476868081",nonce="47978a6a3ebdff1c27a47ee9620b2a0e415023ee",response="96a797a5ab2b5840fec3a0fce7db07e2"
     [java] Content-Length: 0
     [java]
     [java]
     [java] 19:37:03.336 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.processTransactionTerminated().1171 Found one processor for method REGISTER, processor is=SipRegistrarConnection-[dn=17476868081 addr="17476868081" ]
     [java] 19:37:29.804 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getLocalViaHeaders().1438 generated via headers:Via: SIP/2.0/UDP 192.168.1.221:5060
     [java]
     [java] 19:37:29.805 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getContactHeader().1562 generated contactHeader:Contact: "17476868081"
     [java]
     [java] 19:37:29.806 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.getContactHeader().1518 generated contactHeader:Contact: "17476868081"
     [java]
     [java] 19:37:29.859 FINE: service.protocol.Call.fireCallParticipantEvent().165 Dispatching a CallParticipant event to 0 listeners. event is: CallParticipantEvent: ID=1 source participant=sip:17471996503@proxy01.sipphone.com ;status=Unknown source call=Call: id=120111344985531931917 participants=1
     [java] 19:37:29.860 FINE: service.protocol.AbstractCallParticipant.fireCallParticipantChangeEvent().100 Dispatching a CallParticipantChangeEvent event to 1 listeners. event is: CallParticipantChangeEvent: type=CallParticipantStatusChange oldV=net.java.sip.communicator.service.protocol.CallParticipantState:Unknown newV=net.java.sip.communicator.service.protocol.CallParticipantState:Initiating Call for participant=sip:17471996503@proxy01.sipphone.com ;status=Initiating Call
     [java] 19:37:29.862 FINE: impl.protocol.sip.OperationSetBasicTelephonySipImpl.fireCallEvent().310 Dispatching a CallEvent to 2 listeners. event is: CallEvent:[ id=1 Call=Call: id=120111344985531931917 participants=1]
     [java] Exception in thread "Thread-21" java.lang.NullPointerException: Specified service reference cannot be null.
     [java] at org.apache.felix.framework.BundleContextImpl.getService(BundleContextImpl.java:380)
     [java] at net.java.sip.communicator.impl.protocol.sip.SipActivator.getMediaService(SipActivator.java:143)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetBasicTelephonySipImpl.createOutgoingCall(OperationSetBasicTelephonySipImpl.java:226)
     [java] at net.java.sip.communicator.impl.protocol.sip.OperationSetBasicTelephonySipImpl.createCall(OperationSetBasicTelephonySipImpl.java:116)
     [java] at net.java.sip.communicator.impl.gui.main.call.CallManager$CreateCallThread.run(CallManager.java:827)
     [java] 19:37:44.884 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.main.configforms.ConfigurationFrame.width( oldValue=0, newValue=0.
     [java] 19:37:44.898 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.main.configforms.ConfigurationFrame.height( oldValue=0, newValue=0.
     [java] 19:37:44.906 FINER: impl.shutdown.ShutdownTimeout.stop().85 Created the shutdown timer thread.
     [java] 19:37:44.913 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.main.configforms.ConfigurationFrame.x( oldValue=0, newValue=0.
     [java] 19:37:44.914 FINER: impl.callhistory.CallHistoryServiceImpl.serviceChanged().640 Received a service event for: net.java.sip.communicator.impl.systray.jdic.SystrayServiceJdicImpl
     [java] 19:37:44.916 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.systray.jdic.SystrayServiceJdicImpl
     [java] 19:37:44.918 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.systray.jdic.SystrayServiceJdicImpl
     [java] 19:37:44.920 INFO: impl.gui.GuiActivator.stop().103 UI Service ...[STOPPED]
     [java] 19:37:44.921 FINER: impl.callhistory.CallHistoryServiceImpl.serviceChanged().640 Received a service event for: net.java.sip.communicator.impl.gui.UIServiceImpl
     [java] 19:37:44.923 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.gui.UIServiceImpl
     [java] 19:37:44.924 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.gui.UIServiceImpl
     [java] 19:37:44.927 FINER: impl.shutdown.ShutdownTimeout.run().74 Starting shutdown countdown of 15000ms.
     [java] 19:37:44.927 INFO: impl.notification.NotificationActivator.stop().64 UI Service ...[STOPPED]
     [java] 19:37:44.929 FINER: impl.callhistory.CallHistoryServiceImpl.serviceChanged().640 Received a service event for: net.java.sip.communicator.impl.notification.NotificationServiceImpl
     [java] 19:37:44.930 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.notification.NotificationServiceImpl
     [java] 19:37:44.932 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.notification.NotificationServiceImpl
     [java] 19:37:44.934 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.sound.isSoundEnabled( oldValue=true, newValue=true.
     [java] 19:37:44.942 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.main.configforms.ConfigurationFrame.y( oldValue=0, newValue=0.
     [java] 19:37:44.978 INFO: impl.audionotifier.AudioNotifierActivator.stop().92 AudioNotifier Service ...[STOPPED]
     [java] 19:37:44.978 FINER: impl.callhistory.CallHistoryServiceImpl.serviceChanged().640 Received a service event for: net.java.sip.communicator.impl.audionotifier.AudioNotifierServiceImpl
     [java] 19:37:44.979 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.audionotifier.AudioNotifierServiceImpl
     [java] 19:37:44.980 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.audionotifier.AudioNotifierServiceImpl
     [java] 19:37:44.981 FINER: impl.msghistory.MessageHistoryServiceImpl.serviceChanged().858 Received a service event for: net.java.sip.communicator.impl.callhistory.CallHistoryServiceImpl
     [java] 19:37:44.981 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.callhistory.CallHistoryServiceImpl
     [java] 19:37:44.982 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.msghistory.MessageHistoryServiceImpl
     [java] 19:37:44.983 FINER: impl.contactlist.MetaContactListServiceImpl.serviceChanged().1763 Received a service event for: net.java.sip.communicator.impl.history.HistoryServiceImpl
     [java] 19:37:44.984 FINER: impl.contactlist.ContactlistActivator.stop().64 Stopping the contact list.
     [java] 19:37:44.985 FINER: impl.contactlist.MclStorageManager.storeContactList0().375 storing contact list. because is started ==false
     [java] 19:37:44.986 FINER: impl.contactlist.MclStorageManager.storeContactList0().377 storing contact list. because is modified ==false
     [java] 19:37:44.986 FINER: impl.contactlist.MclStorageManager.stop().225 Stopping the MCL XML storage manager.
     [java] 19:37:44.987 INFO: impl.protocol.irc.IrcActivator.stop().102 IRC protocol implementation [STOPPED].
     [java] 19:37:44.988 INFO: impl.protocol.zeroconf.ZeroconfActivator.stop().118 Zeroconf protocol implementation [STOPPED].
     [java] 19:37:44.989 INFO: impl.protocol.rss.RssActivator.stop().121 RSS protocol implementation [STOPPED].
     [java] 19:37:44.990 FINE: impl.netaddr.NetworkAddressManagerServiceImpl.stop().206 Failed to properly shutdown a stun detector: null
     [java] 19:37:44.991 FINEST: impl.netaddr.NetworkAddressManagerServiceImpl.stop().223 [exit] stop
     [java] 19:37:44.991 INFO: impl.netaddr.NetworkAddressManagerServiceImpl.stop().102 Network Address Manager Service ...[STOPPED]
     [java] 19:37:44.992 INFO: impl.protocol.gibberish.GibberishActivator.stop().115 Gibberish protocol implementation [STOPPED].
     [java] 19:37:44.993 FINER: impl.protocol.sip.ProtocolProviderFactorySipImpl.stop().269 Preparing to stop all SIP protocol providers.
     [java] 19:37:44.995 FINER: impl.protocol.sip.ProtocolProviderServiceSipImpl.run().1317 Killing the SIP Protocol Provider.
     [java] 19:37:44.996 FINER: impl.protocol.sip.OperationSetBasicTelephonySipImpl.shutdown().1896 Ending all active calls.
     [java] 19:37:44.997 FINE: service.protocol.AbstractCallParticipant.fireCallParticipantChangeEvent().100 Dispatching a CallParticipantChangeEvent event to 2 listeners. event is: CallParticipantChangeEvent: type=CallParticipantStatusChange oldV=net.java.sip.communicator.service.protocol.CallParticipantState:Initiating Call newV=net.java.sip.communicator.service.protocol.CallParticipantState:Disconnected for participant=sip:17471996503@proxy01.sipphone.com ;status=Disconnected
     [java] 19:37:44.998 FINE: service.protocol.Call.fireCallParticipantEvent().165 Dispatching a CallParticipant event to 2 listeners. event is: CallParticipantEvent: ID=2 source participant=sip:17471996503@proxy01.sipphone.com ;status=Disconnected source call=Call: id=120111344985531931917 participants=0
     [java] 19:37:45.000 FINE: service.protocol.Call.fireCallChangeEvent().217 Dispatching a CallChange event to 2 listeners. event is: CallChangeEvent: type=CallState oldV=net.java.sip.communicator.service.protocol.CallState:Initializing newV=net.java.sip.communicator.service.protocol.CallState:Ended
     [java] 19:37:45.000 FINER: impl.protocol.sip.ActiveCallsRepository.callStateChanged().84 Removing call Call: id=120111344985531931917 participants=0 from the list of active calls because it entered an ENDED state
     [java] 19:37:45.001 FINE: impl.protocol.sip.OperationSetBasicTelephonySipImpl.fireCallEvent().310 Dispatching a CallEvent to 1 listeners. event is: CallEvent:[ id=3 Call=Call: id=120111344985531931917 participants=0]
     [java] 19:37:45.002 SEVERE: impl.protocol.sip.OperationSetBasicTelephonySipImpl.hangupCallParticipant().1434 Could not determine call participant state!
     [java] 19:37:45.008 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.fireRegistrationStateChanged().331 Dispatching RegistrationStateChangeEvent[ oldState=Registered; newState=RegistrationState=Unregistering;reasonCode=0;reason=] to 4 listeners.
     [java] 19:37:45.009 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.fireProviderStatusChangeEvent().701 Dispatching Provider Status Change. Listeners=2 evt=ProviderPresenceStatusChangeEvent-[OldStatus=PresenceStatus:Online, NewStatus=PresenceStatus:Offline]
     [java] 19:37:45.018 FINER: impl.systray.jdic.StatusSelector.updateStatus().160 Systray update status for provider: sip:17476868081@proxy01.sipphone.com. The new status will be: Offline
     [java] 19:37:45.021 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.fireProviderStatusChangeEvent().719 status dispatching done.
     [java] 19:37:45.022 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.fireProviderMsgStatusChangeEvent().735 Dispatching stat. msg change. Listeners=2 evt=java.beans.PropertyChangeEvent[source=net.java.sip.communicator.impl.protocol.sip.ProtocolProviderServiceSipImpl@a193fe]
     [java] 19:37:45.022 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.fireProviderMsgStatusChangeEvent().753 status dispatching done.
     [java] 19:37:45.023 FINE: impl.protocol.sip.OperationSetPresenceSipImpl.unsubscribeToAllContact().4184 trying to unsubscribe to every contact
     [java] 19:37:45.024 FINE: impl.protocol.sip.OperationSetBasicInstantMessagingSipImpl.registrationStateChanged().571 The provider changed state from: RegistrationState=Registered to: RegistrationState=Unregistering
     [java] 19:37:45.025 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.registrationStateChanged().2142 Received a RegistrationStateChangeEvent: RegistrationStateChangeEvent[ oldState=Registered; newState=RegistrationState=Unregistering;reasonCode=0;reason=]
     [java] 19:37:45.025 FINER: impl.protocol.sip.ProtocolProviderServiceSipImpl.fireRegistrationStateChanged().348 Done.
     [java] 19:37:45.048 FINE: impl.protocol.sip.SipRegistrarConnection.unregister().568 sent request: REGISTER sip:proxy01.sipphone.com SIP/2.0
     [java] Call-ID: fbc393985bae52d11071212b03e39b68@0.0.0.0
     [java] CSeq: 2 REGISTER
     [java] From: "17476868081" ;tag=7188268
     [java] To: "17476868081"
     [java] Via: SIP/2.0/UDP 192.168.1.221:5060;branch=z9hG4bKb007f86a3f208c97d5250e09a0bab67a
     [java] Max-Forwards: 70
     [java] Route:
     [java] User-Agent: SIP Communicator 1.0 CVS-Wed_Jan_23_19-36-46_GMT+01-00_2008
     [java] Expires: 0
     [java] Contact: "17476868081" ;expires=0
     [java] Content-Length: 0
     [java]
     [java]
     [java] 19:37:45.048 FINER: impl.protocol.sip.SipRegistrarConnection.unregister().574 Setting state to UNREGISTERED.
     [java] 19:37:45.049 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.fireRegistrationStateChanged().331 Dispatching RegistrationStateChangeEvent[ oldState=Unregistering; newState=RegistrationState=Unregistered;reasonCode=0;reason=null] to 4 listeners.
     [java] 19:37:45.050 FINE: impl.protocol.sip.OperationSetBasicInstantMessagingSipImpl.registrationStateChanged().571 The provider changed state from: RegistrationState=Unregistering to: RegistrationState=Unregistered
     [java] 19:37:45.053 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.main.MainFrame.width( oldValue=306, newValue=306.
     [java] 19:37:45.055 SEVERE: impl.gui.main.login.LoginManager.registrationStateChanged().401 null
     [java] 19:37:45.055 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.registrationStateChanged().2142 Received a RegistrationStateChangeEvent: RegistrationStateChangeEvent[ oldState=Unregistering; newState=RegistrationState=Unregistered;reasonCode=0;reason=null]
     [java] 19:37:45.056 FINE: impl.protocol.sip.ProtocolProviderServiceSipImpl.registrationStateChanged().2148 We're unregistered and will notify those who wait
     [java] 19:37:45.057 FINER: impl.protocol.sip.ProtocolProviderServiceSipImpl.fireRegistrationStateChanged().348 Done.
     [java] 19:37:45.057 FINER: impl.protocol.sip.ProtocolProviderServiceSipImpl.waitForEvent().2166 Waiting for a RegistrationStateChangeEvent.UNREGISTERED
     [java] 19:37:45.058 FINER: impl.protocol.sip.ProtocolProviderServiceSipImpl.waitForEvent().2174 Event already received. [RegistrationState=Unregistering, RegistrationState=Unregistered]
     [java] 19:37:45.060 FINEST: impl.configuration.ConfigurationServiceImpl.stop().58 [entry] stop
     [java] 19:37:45.060 INFO: impl.configuration.ConfigurationServiceImpl.stop().60 The ConfigurationService stop method has been called.
     [java] 19:37:45.074 FINER: impl.configuration.ConfigurationServiceImpl.setProperty().149 net.java.sip.communicator.impl.gui.main.MainFrame.height( oldValue=713, newValue=713.
     [java] Exception in thread "AWT-EventQueue-0" java.lang.IllegalStateException: Service is stopped or has not been started
     [java] at net.java.sip.communicator.impl.configuration.ConfigurationServiceImpl.storeConfiguration(ConfigurationServiceImpl.java:524)
     [java] at net.java.sip.communicator.impl.configuration.ConfigurationServiceImpl.storeConfiguration(ConfigurationServiceImpl.java:489)
     [java] at net.java.sip.communicator.impl.configuration.ConfigurationServiceImpl.setProperty(ConfigurationServiceImpl.java:191)
     [java] at net.java.sip.communicator.impl.configuration.ConfigurationServiceImpl.setProperty(ConfigurationServiceImpl.java:114)
     [java] at net.java.sip.communicator.impl.gui.customcontrols.SIPCommFrame.saveSizeAndLocation(SIPCommFrame.java:106)
     [java] at net.java.sip.communicator.impl.gui.customcontrols.SIPCommFrame.dispose(SIPCommFrame.java:206)
     [java] at net.java.sip.communicator.impl.gui.main.menus.FileMenu.actionPerformed(FileMenu.java:173)
     [java] at javax.swing.AbstractButton.fireActionPerformed(AbstractButton.java:1849)
     [java] at javax.swing.AbstractButton$Handler.actionPerformed(AbstractButton.java:2169)
     [java] at javax.swing.DefaultButtonModel.fireActionPerformed(DefaultButtonModel.java:420)
     [java] at javax.swing.DefaultButtonModel.setPressed(DefaultButtonModel.java:258)
     [java] at javax.swing.AbstractButton.doClick(AbstractButton.java:302)
     [java] at javax.swing.plaf.basic.BasicMenuItemUI.doClick(BasicMenuItemUI.java:1051)
     [java] at javax.swing.plaf.basic.BasicMenuItemUI$Handler.mouseReleased(BasicMenuItemUI.java:1092)
     [java] at java.awt.Component.processMouseEvent(Component.java:5517)
     [java] at javax.swing.JComponent.processMouseEvent(JComponent.java:3135)
     [java] at java.awt.Component.processEvent(Component.java:5282)
     [java] at java.awt.Container.processEvent(Container.java:1966)
     [java] at java.awt.Component.dispatchEventImpl(Component.java:3984)
     [java] at java.awt.Container.dispatchEventImpl(Container.java:2024)
     [java] at java.awt.Component.dispatchEvent(Component.java:3819)
     [java] at java.awt.LightweightDispatcher.retargetMouseEvent(Container.java:4212)
     [java] at java.awt.LightweightDispatcher.processMouseEvent(Container.java:3892)
     [java] at java.awt.LightweightDispatcher.dispatchEvent(Container.java:3822)
     [java] at java.awt.Container.dispatchEventImpl(Container.java:2010)
     [java] at java.awt.Window.dispatchEventImpl(Window.java:1791)
     [java] at java.awt.Component.dispatchEvent(Component.java:3819)
     [java] at java.awt.EventQueue.dispatchEvent(EventQueue.java:463)
     [java] at java.awt.EventDispatchThread.pumpOneEventForHierarchy(EventDispatchThread.java:242)
     [java] at java.awt.EventDispatchThread.pumpEventsForHierarchy(EventDispatchThread.java:163)
     [java] at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:157)
     [java] at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:149)
     [java] at java.awt.EventDispatchThread.run(EventDispatchThread.java:110)

BUILD SUCCESSFUL
Total time: 1 minute 8 seconds

···

_________________________________________________________________
Express yourself instantly with MSN Messenger! Download today it's FREE!
http://messenger.msn.click-url.com/go/onm00200471ave/direct/01/
---------------------------------------------------------------------
To unsubscribe, e-mail: users-unsubscribe@sip-communicator.dev.java.net
For additional commands, e-mail: users-help@sip-communicator.dev.java.net