Re: pb with jain-sip-presence-proxy : 500 Server Internal Error
Jean-Luc <[email protected]> Fri, 1 Jun 2007 15:44:38 +0000 (UTC)
| Newsgroups | gmane.comp.voip.nist-sip |
|---|---|
| Message-ID | <[email protected]> |
M. (Neo-Ranga) Ranganathan <mranga <at> gmail.com> writes:
>
> Bonjour,
>
> The method should specify the transport. That is why it is deprecated.
> However, that is not the reason fro the internal error. Can you set
> the debug level to 32 (or debug) and send me the debug log for the
> stack. I am sure there is a problem with an exception generated
> somewhere.
>
> Ranga
>
Hello Mr. Ranga & thanks a lot for your "celerity",
1) Can you tell me how to do to have more debug ? (level 32 ?)
2) The fact is that in my last message, i have sent an extract of the
file "debug_log.txt" in the debug directory of the proxy project, but i have
more informations directly on the Eclipse console tab ... and i don't know how
to do to have the same thing on the console and on the file ...
This log file is declared in "configuration.xml" with the line in the LOGGING
part : debug_log="debug/debug_log.txt"
but in the file "log4j.properties" i have another file :
log4j.appender.A1.File=logs/debuglog.txt
but in this file i have nothing ...
=> pbs ! pbs ! it seems to be "incoherent" ...
3) i give you my configuration of log4j (issued from the downloading without
any modifications from myself), i don't know if it's rigth :
log4j.properties :
log4j.rootLogger=DEBUG, A1
log4j.appender.A1=org.apache.log4j.RollingFileAppender
log4j.appender.A1.File=logs/debuglog.txt
log4j.appender.A1.layout=org.apache.log4j.SimpleLayout
log4j.appender.A2=org.apache.log4j.ConsoleAppender
log4j.appender.A2.layout=org.apache.log4j.SimpleLayout
4) You're right : i have an exception (shown in the console tab) :
[java] 73425 [EventScannerThread] ERROR gov.nist.sip.proxy.RequestForwarding -
RequestForwarding, forwardRequest(), internal error, exception raised:
[java] java.lang.NullPointerException: null host
5) Here is all the content of the tab console :
(i have put inside the log the string ######################### to be able
easier to see the ERROR)
Have a nice WE & thanks a lot !!!
Jean-Luc
=>
Buildfile: /home/clap/jain-sip-presence-proxy-Neddam/build.xml
clean_logs:
[delete] Deleting 2 files from /home/clap/jain-sip-presence-proxy-
Neddam/debug
clean_logs:
clean:
[delete] Deleting directory /home/clap/jain-sip-presence-proxy-Neddam/classes
[delete] Deleting directory /home/clap/jain-sip-presence-proxy-Neddam/debug
compile-proxy:
[mkdir] Created dir: /home/clap/jain-sip-presence-proxy-Neddam/classes
[javac] Compiling 62 source files to /home/clap/jain-sip-presence-proxy-
Neddam/classes
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/RequestForwarding.java:179: warning:
[deprecation] getListeningPoint() in javax.sip.SipProvider has been deprecated
[javac] ListeningPoint lp = sipProvider.getListeningPoint();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ProxyLauncher.java:93: warning: [deprecation]
show() in java.awt.Window has been deprecated
[javac] show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ListenerProxy.java:61: warning: [deprecation]
show() in java.awt.Window has been deprecated
[javac] configurationFrame.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ListenerProxy.java:75: warning: [deprecation]
show() in java.awt.Dialog has been deprecated
[javac] helpBox.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ListenerProxy.java:203: warning:
[deprecation] show() in java.awt.Window has been deprecated
[javac] tracesViewer.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ListenerProxy.java:249: warning:
[deprecation] show() in java.awt.Window has been deprecated
[javac] tracesViewer.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ConfigurationFrame.java:58: warning:
[deprecation] hide() in java.awt.Window has been deprecated
[javac] this.hide();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/DomainDialog.java:80: warning: [deprecation]
show() in java.awt.Dialog has been deprecated
[javac] dialog.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ListeningPointDialog.java:87: warning:
[deprecation] show() in java.awt.Dialog has been deprecated
[javac] dialog.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/router/ProxyRouter.java:129: warning:
[deprecation] getNextHops(javax.sip.message.Request) in
javax.sip.address.Router has been deprecated
[javac] public ListIterator getNextHops(Request request)
[javac] ^
[javac] Note: Some input files use unchecked or unsafe operations.
[javac] Note: Recompile with -Xlint:unchecked for details.
[javac] 10 warnings
[rmic] RMI Compiling 1 class to /home/clap/jain-sip-presence-proxy-
Neddam/classes
clean_logs:
[mkdir] Created dir: /home/clap/jain-sip-presence-proxy-Neddam/debug
compile-proxy:
[javac] Compiling 62 source files to /home/clap/jain-sip-presence-proxy-
Neddam/classes
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/RequestForwarding.java:179: warning:
[deprecation] getListeningPoint() in javax.sip.SipProvider has been deprecated
[javac] ListeningPoint lp = sipProvider.getListeningPoint();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ProxyLauncher.java:93: warning: [deprecation]
show() in java.awt.Window has been deprecated
[javac] show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ListenerProxy.java:61: warning: [deprecation]
show() in java.awt.Window has been deprecated
[javac] configurationFrame.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ListenerProxy.java:75: warning: [deprecation]
show() in java.awt.Dialog has been deprecated
[javac] helpBox.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ListenerProxy.java:203: warning:
[deprecation] show() in java.awt.Window has been deprecated
[javac] tracesViewer.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ListenerProxy.java:249: warning:
[deprecation] show() in java.awt.Window has been deprecated
[javac] tracesViewer.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ConfigurationFrame.java:58: warning:
[deprecation] hide() in java.awt.Window has been deprecated
[javac] this.hide();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/DomainDialog.java:80: warning: [deprecation]
show() in java.awt.Dialog has been deprecated
[javac] dialog.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/gui/ListeningPointDialog.java:87: warning:
[deprecation] show() in java.awt.Dialog has been deprecated
[javac] dialog.show();
[javac] ^
[javac] /home/clap/jain-sip-presence-proxy-
Neddam/src/gov/nist/sip/proxy/router/ProxyRouter.java:129: warning:
[deprecation] getNextHops(javax.sip.message.Request) in
javax.sip.address.Router has been deprecated
[javac] public ListIterator getNextHops(Request request)
[javac] ^
[javac] Note: Some input files use unchecked or unsafe operations.
[javac] Note: Recompile with -Xlint:unchecked for details.
[javac] 10 warnings
[rmic] RMI Compiling 1 class to /home/clap/jain-sip-presence-proxy-
Neddam/classes
run-proxy:
[java] Initialisation Proxy Interface
[java] 0 [main] DEBUG gov.nist.sip.proxy.ProxyConfigurationHandler - -----
----------------------------------
[java] 2 [main] DEBUG gov.nist.sip.proxy.ProxyConfigurationHandler -
Parsing the XML configuration file...
[java] [Error] configuration.xml:2:16: Document root
element "CONFIGURATION", must match DOCTYPE root "null".
[java] SIP_STACK:INFORMATION: the name of the stack is set to:proxy-jiji
[java] SIP_STACK:INFORMATION: the stack IP address is set to:192.168.18.64
[java] SIP_STACK:INFORMATION: the outbound proxy is not set
[java] SIP_STACK:INFORMATION: the path for the router is set to:
gov.nist.sip.proxy.router.ProxyRouter
[java] SIP_STACK:INFORMATION: no extensions are supported
[java] SIP_STACK:INFORMATION: The proxy will authorize only 20 connections
[java] SIP_STACK:INFORMATION: The proxy will authorize only 20 server
transactions
[java] SIP_STACK:INFORMATION: The thread pool size is set to 20
[java] LISTENING_POINT:LISTENING_POINT port = 5060
[java] LISTENING_POINT:LISTENING_POINT transport = udp
[java] DOMAIN:INFORMATION: One domain to take care of is: flaviol
[java] DOMAIN:INFORMATION: One domain to take care of is: issy.fr
[java] REGISTRAR:INFORMATION: the registrations will be exported
[java] REGISTRAR:INFORMATION: The registry port is: 1099
[java] LOGGING:INFORMATION: RMI access to log file disabled
[java] LOGGING:INFORMATION: the Debug feature is set
[java] LOGGING:INFORMATION: the server message log file is:
debug/server_log.txt
[java] LOGGING:INFORMATION: the bad message log is:
debug/bad_message_log.txt
[java] LOGGING:INFORMATION: the debug log file is: debug/debug_log.txt
[java] LOGGING:INFORMATION: the output proxy file is:
debug/proxy_output.txt
[java] PRESENCE_SERVER:WARNING: The presence server feature is disabled
[java] AUTHENTICATION:WARNING: The authentication feature is disabled
[java] REGISTRATIONS:INFORMATION: expires time is set to:3600
[java] REGISTRATIONS:WARNING: No static registrations to upload
[java] REGISTRATIONS:INFORMATION: registrations file
is ./configuration/gov/nist/sip/proxy/configuration/registrations.xml
[java] 33 [main] DEBUG gov.nist.sip.proxy.ProxyConfigurationHandler - The
XML configuration file has been successfully parsed!
[java] 33 [main] DEBUG gov.nist.sip.proxy.ProxyConfigurationHandler - ----
-----------------------------------
[java] [Error] configuration.xml:2:16: Document is invalid: no grammar
found.
[java] 496 [main] DEBUG gov.nist.sip.proxy.gui.ProxyLauncher - Proxy
ready to work
[java] 8905 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy -
[java] *****************************************************
[java] 8913 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.ProxyConfigurationHandler - --------------------------------
-------
[java] 8913 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.ProxyConfigurationHandler - Parsing the XML configuration
file...
[java] SIP_STACK:INFORMATION: the name of the stack is set to:proxy-jiji
[java] SIP_STACK:INFORMATION: the stack IP address is set to:192.168.18.64
[java] SIP_STACK:INFORMATION: the outbound proxy is not set
[java] SIP_STACK:INFORMATION: the path for the router is set to:
gov.nist.sip.proxy.router.ProxyRouter
[java] SIP_STACK:INFORMATION: no extensions are supported
[java] SIP_STACK:INFORMATION: The proxy will authorize only 20 connections
[java] SIP_STACK:INFORMATION: The proxy will authorize only 20 server
transactions
[java] SIP_STACK:INFORMATION: The thread pool size is set to 20
[java] LISTENING_POINT:LISTENING_POINT port = 5060
[java] LISTENING_POINT:LISTENING_POINT transport = udp
[java] DOMAIN:INFORMATION: One domain to take care of is: flaviol
[java] DOMAIN:INFORMATION: One domain to take care of is: issy.fr
[java] REGISTRAR:INFORMATION: the registrations will be exported
[java] REGISTRAR:INFORMATION: The registry port is: 1099
[java] LOGGING:INFORMATION: RMI access to log file disabled
[java] LOGGING:INFORMATION: the Debug feature is set
[java] LOGGING:INFORMATION: the server message log file is:
debug/server_log.txt
[java] LOGGING:INFORMATION: the bad message log is:
debug/bad_message_log.txt
[java] LOGGING:INFORMATION: the debug log file is: debug/debug_log.txt
[java] LOGGING:INFORMATION: the output proxy file is:
debug/proxy_output.txt
[java] PRESENCE_SERVER:WARNING: The presence server feature is disabled
[java] AUTHENTICATION:WARNING: The authentication feature is disabled
[java] REGISTRATIONS:INFORMATION: expires time is set to:3600
[java] REGISTRATIONS:WARNING: No static registrations to upload
[java] REGISTRATIONS:INFORMATION: registrations file
is ./configuration/gov/nist/sip/proxy/configuration/registrations.xml
[java] [Error] configuration.xml:2:16: Document root
element "CONFIGURATION", must match DOCTYPE root "null".
[java] [Error] configuration.xml:2:16: Document is invalid: no grammar
found.
[java] 8920 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.ProxyConfigurationHandler - The XML configuration file has
been successfully parsed!
[java] 8920 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.ProxyConfigurationHandler - --------------------------------
-------
[java] 8922 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy - DEBUG, GUI chained to the registrar
[java] 8924 [AWT-EventQueue-0] DEBUG gov.nist.sip.proxy.Proxy - DEBUG
properties set!
[java] 8979 [AWT-EventQueue-0] DEBUG gov.nist.sip.proxy.Proxy - The proxy
is responsible for the domain:192.168.18.64
[java] 8979 [AWT-EventQueue-0] DEBUG gov.nist.sip.proxy.Proxy - Here is
one domain to take care of:flaviol
[java] 8979 [AWT-EventQueue-0] DEBUG gov.nist.sip.proxy.Proxy - Here is
one domain to take care of:issy.fr
[java] 8979 [AWT-EventQueue-0] DEBUG gov.nist.sip.proxy.Proxy - Here is
one domain to take care of:192.168.18.64
[java] 9067 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.checkLogFile(ServerLog.java:242) [Here are
the stack configuration properties
[java] {gov.nist.javax.sip.TRACE_LEVEL=32,
javax.sip.AUTOMATIC_DIALOG_SUPPORT=off, javax.sip.STACK_NAME=proxy-jiji,
gov.nist.javax.sip.SERVER_LOG=debug/server_log.txt,
gov.nist.javax.sip.THREAD_POOL_SIZE=20, gov.nist.javax.sip.MAX_CONNECTIONS=20,
gov.nist.javax.sip.DEBUG_LOG=debug/debug_log.txt}
[java] ]
[java] 9080 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.checkLogFile(ServerLog.java:245) [ ]]>]
[java] 9081 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.checkLogFile(ServerLog.java:246) [</debug>]
[java] 9082 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.checkLogFile(ServerLog.java:247)
[<description
[java] logDescription="proxy-jiji"
[java] name="null" />
[java] ]
[java] 9083 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.checkLogFile(ServerLog.java:253) [<debug>]
[java] 9084 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.checkLogFile(ServerLog.java:254) [<![CDATA[ ]
[java] 9087 [AWT-EventQueue-0] INFO gov.nist.sip.proxy.Proxy - transport
udp
[java] 9088 [AWT-EventQueue-0] INFO gov.nist.sip.proxy.Proxy - port 5060
[java] 9089 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.SipStackImpl.createListeningPoint(SipStackImpl.java:469)
[createListeningPoint : address = 192.168.18.64 port = 5060 transport = udp]
[java] 9381 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.SipStackImpl.createListeningPoint(SipStackImpl.java:506)
[Created Message Processor: 192.168.18.64 port = 5060 transport = udp]
[java] 9383 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.MessageProcessor.setListeningPoint
(MessageProcessor.java:138)
[setListeningPointgov.nist.javax.sip.stack.UDPMessageProcessor@f11404
listeningPoint = gov.nist.javax.sip.ListeningPointImpl@1592174]
[java] 9384 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.SipStackImpl.createSipProvider(SipStackImpl.java:536)
[createSipProvider: gov.nist.javax.sip.ListeningPointImpl@1592174]
[java] 9595 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.SipProviderImpl.addSipListener(SipProviderImpl.java:172)
[add SipListener gov.nist.sip.proxy.Proxy@704baa]
[java] 9595 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.registrar.RegistrarAccess - We don't export the
registrations because RMI is disabled.
[java] 9596 [AWT-EventQueue-0] WARN gov.nist.sip.proxy.Proxy - No
registrations to parse...
[java] 9596 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.registrar.RegistrarAccess - Registrar, registerToProxies(),
we have to register to 0 proxies
[java] 9597 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy -
[java] *****************************************************
[java] 43546 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:221)
[UDPMessageChannel: peerAddress = 192.168.18.63/5060]
[java] 43546 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:225)
[Length = 357]
[java] 43547 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:227)
[REGISTER sip:flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK1433766957
[java] From: <sip:coltranej@flaviol>;tag=1713037849
[java] To: <sip:coltranej@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Expires: 900
[java] Content-Length: 0
[java] ]
[java] 43785 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:312) [ ]]>]
[java] 43785 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:313) [</debug>]
[java] 43786 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:314) [<message
[java] from="192.168.18.63:5060"
[java] to="192.168.18.64:5060"
[java] time="1180710933003"
[java] isSender="false"
[java] transactionId="z9hg4bk1433766957"
[java] callId="[email protected]"
[java] firstLine="REGISTER sip:flaviol SIP/2.0"
[java] debugLine="17"
[java] >
[java] <![CDATA[REGISTER sip:flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK1433766957
[java] From: <sip:coltranej@flaviol>;tag=1713037849
[java] To: <sip:coltranej@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Expires: 900
[java] Content-Length: 0
[java] ]]>
[java] </message>
[java] ]
[java] 43786 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:315) [<debug>]
[java] 43786 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:316) [<![CDATA[ ]
[java] 43790 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findPendingTransaction
(SIPTransactionStack.java:723) [looking for pending tx for :z9hg4bk1433766957]
[java] 43814 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.<init>
(SIPServerTransaction.java:419) [Creating Server Transactionnull]
[java] 43815 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPServerTransaction.java:421][SIPTransactionStack.java:1007]
[SIPTransactionStack.java:829][UDPMessageChannel.java:370][Thread.java:595]]
[java] 43815 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setOriginalRequest
(SIPTransaction.java:384) [Setting Branch id : z9hG4bK1433766957]
[java] 43820 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.newSIPServerRequest
(SIPTransactionStack.java:844) [newSIPServerRequest(
REGISTER:z9hG4bK1433766957):gov.nist.javax.sip.stack.SIPServerTransaction@289ead
46]
[java] 43830 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.NistSipMessageFactoryImpl.newSIPServerRequest
(NistSipMessageFactoryImpl.java:62) [Returning request interface for REGISTER
sip:flaviol SIP/2.0
[java] gov.nist.javax.sip.DialogFilter@5e179a messageChannel =
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46]
[java] 43830 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.acquireSem(SIPTransaction.java:1078)
[acquireSem [[[[gov.nist.javax.sip.stack.SIPServerTransaction@289ead46]
[java] 43831 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:1079][SIPTransactionStack.java:854]
[UDPMessageChannel.java:370][Thread.java:595]]
[java] 43831 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:393)
[About to process REGISTER sip:flaviol SIP/2.0
[java] /gov.nist.javax.sip.stack.SIPServerTransaction@289ead46]
[java] 43831 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.processRequest
(SIPServerTransaction.java:623) [processRequest: REGISTER sip:flaviol SIP/2.0
[java] ]
[java] 43831 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.processRequest
(SIPServerTransaction.java:625) [tx state = null]
[java] 43832 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setOriginalRequest
(SIPTransaction.java:384) [Setting Branch id : z9hG4bK1433766957]
[java] 43832 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setState(SIPTransaction.java:504)
[Transaction:setState Trying Transaction
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46 branchID =
z9hG4bK1433766957 isClient = false]
[java] 43832 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:507][SIPServerTransaction.java:1311]
[SIPServerTransaction.java:635][UDPMessageChannel.java:397][Thread.java:595]]
[java] 43833 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setPassToListener
(SIPTransaction.java:1125) [setPassToListener()]
[java] 43833 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:69)
[PROCESSING INCOMING REQUEST REGISTER sip:flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK1433766957
[java] From: <sip:coltranej@flaviol>;tag=1713037849
[java] To: <sip:coltranej@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Expires: 900
[java] Content-Length: 0
[java] transactionChannel =
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46 listening point =
192.168.18.64:5060]
[java] 43834 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.getDialog
(SIPTransactionStack.java:491) [getDialog
([email protected]:coltranej@flaviol:coltranej@flaviol:1713037849) :
returning null]
[java] 43834 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:138) [dialogId
= [email protected]:coltranej@flaviol:coltranej@flaviol:1713037849]
[java] 43834 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:139) [dialog =
null]
[java] 43834 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:621) [REGISTER
transaction.isMapped = false]
[java] 43835 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.SipProviderImpl.handleEvent(SipProviderImpl.java:102)
[handleEvent javax.sip.RequestEvent
[source=gov.nist.javax.sip.SipProviderImpl@15fadcf]currentTransaction =
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46this.sipListener =
[email protected] =
gov.nist.javax.sip.SipProviderImpl@15fadcf]
[java] 43835 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.SipProviderImpl.handleEvent(SipProviderImpl.java:109)
[Dialog = null]
[java] 43836 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SipProviderImpl.java:114][DialogFilter.java:834]
[SIPServerTransaction.java:731][UDPMessageChannel.java:397][Thread.java:595]]
[java] 43837 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.addEvent(EventScanner.java:54) [addEvent
gov.nist.javax.sip.EventWrapper@fbb7cb]
[java] 43837 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.run(EventScanner.java:400) [Processing
gov.nist.javax.sip.EventWrapper@fbb7cbnevents 1]
[java] 43837 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:87) [sipEvent =
javax.sip.RequestEvent[source=gov.nist.javax.sip.SipProviderImpl@15fadcf]source
= gov.nist.javax.sip.SipProviderImpl@15fadcf]
[java] 43839 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:105)
[deliverEvent : REGISTER sip:flaviol SIP/2.0
[java] transaction gov.nist.javax.sip.stack.SIPServerTransaction@289ead46
sipEvent.serverTx = null]
[java] 43841 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findTransaction
(SIPTransactionStack.java:613) [serverTx: looking for key z9hg4bk1433766957
existing={}]
[java] 43841 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findPendingTransaction
(SIPTransactionStack.java:723) [looking for pending tx for :z9hg4bk1433766957]
[java] 43842 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.putPendingTransaction
(SIPTransactionStack.java:1222) [putPendingTransaction:
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46]
[java] 43842 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:154) [Calling
listener REGISTER sip:flaviol SIP/2.0
[java] ]
[java] 43843 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:158) [Calling
listener gov.nist.javax.sip.stack.SIPServerTransaction@289ead46]
[java] 43843 [EventScannerThread] DEBUG gov.nist.sip.proxy.Proxy -
[java] ****************************************************
[java] Request REGISTER received:
[java] REGISTER sip:flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK1433766957
[java] From: <sip:coltranej@flaviol>;tag=1713037849
[java] To: <sip:coltranej@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Expires: 900
[java] Content-Length: 0
[java] 43843 [EventScannerThread] DEBUG
gov.nist.sip.proxy.ProxyUtilities - DEBUG TRANSACTION INFO: the transaction is
null
[java] 43846 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.isDialogCreated
(SIPTransactionStack.java:363) [isDialogCreated : REGISTER returning false]
[java] 43846 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findTransaction
(SIPTransactionStack.java:613) [serverTx: looking for key z9hg4bk1433766957
existing={}]
[java] 43846 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.addTransactionHash
(SIPTransactionStack.java:1115) [ putTransactionHash : key = z9hg4bk1433766957]
[java] 43848 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction$TransactionTimer.<init>
(SIPServerTransaction.java:272) [TransactionTimer() : z9hg4bk1433766957]
[java] 43848 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.getDialog
(SIPTransactionStack.java:491) [getDialog
([email protected]:coltranej@flaviol:coltranej@flaviol:1713037849) :
returning null]
[java] 43850 [EventScannerThread] DEBUG gov.nist.sip.proxy.Proxy - Proxy,
processRequest(), we are responsible for the domain... Let's find the contact...
[java] 43850 [EventScannerThread] DEBUG gov.nist.sip.proxy.Proxy -
Incoming request Register
[java] 43850 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrarAccess - Registrar, processRegister(),
key: "sip:coltranej@flaviol"
[java] 43851 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - RegistrationsTable,
hasRegistration(), Checking registration for "sip:coltranej@flaviol" : not
registered
[java] 43851 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrarAccess - Registrar, hasExpiresZero(),
the REGISTER has an Expires Header with expires time:900
[java] 43861 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:407)
[Done processing REGISTER sip:flaviol SIP/2.0
[java] /gov.nist.javax.sip.stack.SIPServerTransaction@289ead46]
[java] 43878 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - RegistrationsTable,
startTimer(), timer started for the contact:
sip:[email protected]:5060 , expiresTime:900
[java] 43878 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - RegistrationsTable,
addRegistration(), registration added for the key: sip:coltranej@flaviol
[java] 43879 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - ********* Registration
record *****************
[java] 43879 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - registered
user: "sip:coltranej@flaviol"
[java] 43879 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.Registration - - contacts:
[java] 43879 [EventScannerThread] INFO
gov.nist.sip.proxy.registrar.Registration - contact 1 : Contact:
<sip:[email protected]:5060>;expires=900
[java] 43879 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable -
************************************************
[java] updReg: list=[(empty)] inList=false
key=sip:coltranej@flaviol
[java] updReg: updated list=[sip:coltranej@flaviol]
[java] 43898 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setState(SIPTransaction.java:504)
[Transaction:setState Completed Transaction
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46 branchID =
z9hG4bK1433766957 isClient = false]
[java] 43899 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:507][SIPServerTransaction.java:1311]
[SIPServerTransaction.java:837][SIPServerTransaction.java:1264][null:-1][null:-
1][EventScanner.java:162][EventScanner.java:404][Thread.java:595]]
[java] 43899 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.enableTimeoutTimer
(SIPTransaction.java:558) [enableTimeoutTimer
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46 tickCount 64
currentTickCount = -1]
[java] 43899 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.sendMessage
(SIPServerTransaction.java:940) [sendMessage : tx =
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46 getState = Completed
Transaction]
[java] 43900 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.<init>(UDPMessageChannel.java:169)
[Creating message channel 192.168.18.63/5060]
[java] 43901 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[UDPMessageChannel.java:509][SIPServerTransaction.java:396]
[SIPServerTransaction.java:945][SIPServerTransaction.java:1264][null:-1][null:-
1][EventScanner.java:162][EventScanner.java:404][Thread.java:595]]
[java] 43902 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.sendMessage
(UDPMessageChannel.java:609)
[gov.nist.javax.sip.stack.UDPMessageChannel:sendMessage 192.168.18.63/5060
[java] SIP/2.0 200 OK
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK1433766957
[java] From: <sip:coltranej@flaviol>;tag=1713037849
[java] To: <sip:coltranej@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>;expires=900
[java] Content-Length: 0
[java] ]
[java] 43910 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.sendMessage
(UDPMessageChannel.java:612) [*******************
[java] ]
[java] 43985 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.sendMessage
(UDPMessageChannel.java:629) [sendMessage 192.168.18.63/5060
[java] SIP/2.0 200 OK
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK1433766957
[java] From: <sip:coltranej@flaviol>;tag=1713037849
[java] To: <sip:coltranej@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>;expires=900
[java] Content-Length: 0
[java] ]
[java] 43997 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:312) [ ]]>]
[java] 43997 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:313) [</debug>]
[java] 43998 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:314) [<message
[java] from="192.168.18.64:5060"
[java] to="192.168.18.63:5060"
[java] time="1180710933357"
[java] isSender="true"
[java] transactionId="z9hg4bk1433766957"
[java] callId="[email protected]"
[java] firstLine="SIP/2.0 200 OK"
[java] debugLine="80"
[java] >
[java] <![CDATA[SIP/2.0 200 OK
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK1433766957
[java] From: <sip:coltranej@flaviol>;tag=1713037849
[java] To: <sip:coltranej@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>;expires=900
[java] Content-Length: 0
[java] ]]>
[java] </message>
[java] ]
[java] 43998 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:315) [<debug>]
[java] 43998 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:316) [<![CDATA[ ]
[java] 43998 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrarAccess - Registrar, processRegister(),
response sent:
[java] 43998 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrarAccess - SIP/2.0 200 OK
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK1433766957
[java] From: <sip:coltranej@flaviol>;tag=1713037849
[java] To: <sip:coltranej@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>;expires=900
[java] Content-Length: 0
[java] 43999 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:165) [Done
processing Message REGISTER sip:flaviol SIP/2.0
[java] ]
[java] 43999 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:189) [Done
processing Message REGISTER sip:flaviol SIP/2.0
[java] ]
[java] 43999 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.releaseSem(SIPTransaction.java:1098)
[releaseSem [[[[gov.nist.javax.sip.stack.SIPServerTransaction@289ead46]
[java] 43999 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:1099][SIPServerTransaction.java:1526]
[EventScanner.java:197][EventScanner.java:404][Thread.java:595]]
[java] 44000 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.removePendingTransaction
(SIPTransactionStack.java:740) [removePendingTx: z9hg4bk1433766957]
[java] 44366 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 45374 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 47390 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 51426 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 55458 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 56883 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:221)
[UDPMessageChannel: peerAddress = 192.168.18.65/5060]
[java] 56883 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:225)
[Length = 349]
[java] 56883 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:227)
[REGISTER sip:flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.65:5060;rport;branch=z9hG4bK1279140405
[java] From: <sip:sirejl@flaviol>;tag=1694578401
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Expires: 900
[java] Content-Length: 0
[java] ]
[java] 56892 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:312) [ ]]>]
[java] 56892 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:313) [</debug>]
[java] 56893 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:314) [<message
[java] from="192.168.18.65:5060"
[java] to="192.168.18.64:5060"
[java] time="1180710946339"
[java] isSender="false"
[java] transactionId="z9hg4bk1279140405"
[java] callId="[email protected]"
[java] firstLine="REGISTER sip:flaviol SIP/2.0"
[java] debugLine="115"
[java] >
[java] <![CDATA[REGISTER sip:flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.65:5060;rport;branch=z9hG4bK1279140405
[java] From: <sip:sirejl@flaviol>;tag=1694578401
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Expires: 900
[java] Content-Length: 0
[java] ]]>
[java] </message>
[java] ]
[java] 56893 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:315) [<debug>]
[java] 56893 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:316) [<![CDATA[ ]
[java] 56893 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findPendingTransaction
(SIPTransactionStack.java:723) [looking for pending tx for :z9hg4bk1279140405]
[java] 56894 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.<init>
(SIPServerTransaction.java:419) [Creating Server Transactionnull]
[java] 56894 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPServerTransaction.java:421][SIPTransactionStack.java:1007]
[SIPTransactionStack.java:829][UDPMessageChannel.java:370][Thread.java:595]]
[java] 56894 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setOriginalRequest
(SIPTransaction.java:384) [Setting Branch id : z9hG4bK1279140405]
[java] 56895 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.newSIPServerRequest
(SIPTransactionStack.java:844) [newSIPServerRequest(
REGISTER:z9hG4bK1279140405):gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5
ee]
[java] 56895 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.NistSipMessageFactoryImpl.newSIPServerRequest
(NistSipMessageFactoryImpl.java:62) [Returning request interface for REGISTER
sip:flaviol SIP/2.0
[java] gov.nist.javax.sip.DialogFilter@1275d39 messageChannel =
gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee]
[java] 56895 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.acquireSem(SIPTransaction.java:1078)
[acquireSem [[[[gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee]
[java] 56895 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:1079][SIPTransactionStack.java:854]
[UDPMessageChannel.java:370][Thread.java:595]]
[java] 56896 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:393)
[About to process REGISTER sip:flaviol SIP/2.0
[java] /gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee]
[java] 56896 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.processRequest
(SIPServerTransaction.java:623) [processRequest: REGISTER sip:flaviol SIP/2.0
[java] ]
[java] 56896 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.processRequest
(SIPServerTransaction.java:625) [tx state = null]
[java] 56896 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setOriginalRequest
(SIPTransaction.java:384) [Setting Branch id : z9hG4bK1279140405]
[java] 56896 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setState(SIPTransaction.java:504)
[Transaction:setState Trying Transaction
gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee branchID =
z9hG4bK1279140405 isClient = false]
[java] 56897 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:507][SIPServerTransaction.java:1311]
[SIPServerTransaction.java:635][UDPMessageChannel.java:397][Thread.java:595]]
[java] 56897 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setPassToListener
(SIPTransaction.java:1125) [setPassToListener()]
[java] 56897 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:69)
[PROCESSING INCOMING REQUEST REGISTER sip:flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.65:5060;rport;branch=z9hG4bK1279140405
[java] From: <sip:sirejl@flaviol>;tag=1694578401
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Expires: 900
[java] Content-Length: 0
[java] transactionChannel =
gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee listening point =
192.168.18.64:5060]
[java] 56898 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.getDialog
(SIPTransactionStack.java:491) [getDialog
([email protected]:sirejl@flaviol:sirejl@flaviol:1694578401) : returning
null]
[java] 56898 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:138) [dialogId
= [email protected]:sirejl@flaviol:sirejl@flaviol:1694578401]
[java] 56898 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:139) [dialog =
null]
[java] 56898 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:621) [REGISTER
transaction.isMapped = false]
[java] 56899 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.SipProviderImpl.handleEvent(SipProviderImpl.java:102)
[handleEvent javax.sip.RequestEvent
[source=gov.nist.javax.sip.SipProviderImpl@15fadcf]currentTransaction =
gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5eethis.sipListener =
[email protected] =
gov.nist.javax.sip.SipProviderImpl@15fadcf]
[java] 56899 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.SipProviderImpl.handleEvent(SipProviderImpl.java:109)
[Dialog = null]
[java] 56899 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SipProviderImpl.java:114][DialogFilter.java:834]
[SIPServerTransaction.java:731][UDPMessageChannel.java:397][Thread.java:595]]
[java] 56899 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.addEvent(EventScanner.java:54) [addEvent
gov.nist.javax.sip.EventWrapper@1595f51]
[java] 56900 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:407)
[Done processing REGISTER sip:flaviol SIP/2.0
[java] /gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee]
[java] 56900 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.run(EventScanner.java:400) [Processing
gov.nist.javax.sip.EventWrapper@1595f51nevents 1]
[java] 56900 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:87) [sipEvent =
javax.sip.RequestEvent[source=gov.nist.javax.sip.SipProviderImpl@15fadcf]source
= gov.nist.javax.sip.SipProviderImpl@15fadcf]
[java] 56900 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:105)
[deliverEvent : REGISTER sip:flaviol SIP/2.0
[java] transaction gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee
sipEvent.serverTx = null]
[java] 56900 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findTransaction
(SIPTransactionStack.java:613) [serverTx: looking for key z9hg4bk1279140405
existing=
{z9hg4bk1433766957=gov.nist.javax.sip.stack.SIPServerTransaction@289ead46}]
[java] 56901 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findPendingTransaction
(SIPTransactionStack.java:723) [looking for pending tx for :z9hg4bk1279140405]
[java] 56901 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.putPendingTransaction
(SIPTransactionStack.java:1222) [putPendingTransaction:
gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee]
[java] 56901 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:154) [Calling
listener REGISTER sip:flaviol SIP/2.0
[java] ]
[java] 56902 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:158) [Calling
listener gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee]
[java] 56902 [EventScannerThread] DEBUG gov.nist.sip.proxy.Proxy -
[java] ****************************************************
[java] Request REGISTER received:
[java] REGISTER sip:flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.65:5060;rport;branch=z9hG4bK1279140405
[java] From: <sip:sirejl@flaviol>;tag=1694578401
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Expires: 900
[java] Content-Length: 0
[java] 56902 [EventScannerThread] DEBUG
gov.nist.sip.proxy.ProxyUtilities - DEBUG TRANSACTION INFO: the transaction is
null
[java] 56902 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.isDialogCreated
(SIPTransactionStack.java:363) [isDialogCreated : REGISTER returning false]
[java] 56903 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findTransaction
(SIPTransactionStack.java:613) [serverTx: looking for key z9hg4bk1279140405
existing=
{z9hg4bk1433766957=gov.nist.javax.sip.stack.SIPServerTransaction@289ead46}]
[java] 56903 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.addTransactionHash
(SIPTransactionStack.java:1115) [ putTransactionHash : key = z9hg4bk1279140405]
[java] 56903 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction$TransactionTimer.<init>
(SIPServerTransaction.java:272) [TransactionTimer() : z9hg4bk1279140405]
[java] 56907 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.getDialog
(SIPTransactionStack.java:491) [getDialog
([email protected]:sirejl@flaviol:sirejl@flaviol:1694578401) : returning
null]
[java] 56907 [EventScannerThread] DEBUG gov.nist.sip.proxy.Proxy - Proxy,
processRequest(), we are responsible for the domain... Let's find the contact...
[java] 56908 [EventScannerThread] DEBUG gov.nist.sip.proxy.Proxy -
Incoming request Register
[java] 56908 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrarAccess - Registrar, processRegister(),
key: "sip:sirejl@flaviol"
[java] 56908 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - RegistrationsTable,
hasRegistration(), Checking registration for "sip:sirejl@flaviol" : not
registered
[java] 56908 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrarAccess - Registrar, hasExpiresZero(),
the REGISTER has an Expires Header with expires time:900
[java] 56914 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - RegistrationsTable,
startTimer(), timer started for the contact: sip:[email protected]:5060 ,
expiresTime:900
[java] 56914 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - RegistrationsTable,
addRegistration(), registration added for the key: sip:sirejl@flaviol
[java] 56914 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - ********* Registration
record *****************
[java] 56914 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - registered
user: "sip:sirejl@flaviol"
[java] 56915 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.Registration - - contacts:
[java] 56916 [EventScannerThread] INFO
gov.nist.sip.proxy.registrar.Registration - contact 1 : Contact:
<sip:[email protected]:5060>;expires=900
[java] 56916 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - registered
user: "sip:coltranej@flaviol"
[java] 56916 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.Registration - - contacts:
[java] 56916 [EventScannerThread] INFO
gov.nist.sip.proxy.registrar.Registration - contact 1 : Contact:
<sip:[email protected]:5060>;expires=900
[java] 56916 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable -
************************************************
[java] updReg: list=[sip:coltranej@flaviol] inList=false
key=sip:sirejl@flaviol
[java] updReg: updated list=[sip:coltranej@flaviol, sip:sirejl@flaviol]
[java] 56917 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setState(SIPTransaction.java:504)
[Transaction:setState Completed Transaction
gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee branchID =
z9hG4bK1279140405 isClient = false]
[java] 56918 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:507][SIPServerTransaction.java:1311]
[SIPServerTransaction.java:837][SIPServerTransaction.java:1264][null:-1][null:-
1][EventScanner.java:162][EventScanner.java:404][Thread.java:595]]
[java] 56918 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.enableTimeoutTimer
(SIPTransaction.java:558) [enableTimeoutTimer
gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee tickCount 64
currentTickCount = -1]
[java] 56918 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.sendMessage
(SIPServerTransaction.java:940) [sendMessage : tx =
gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee getState = Completed
Transaction]
[java] 56921 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.<init>(UDPMessageChannel.java:169)
[Creating message channel 192.168.18.65/5060]
[java] 56922 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[UDPMessageChannel.java:509][SIPServerTransaction.java:396]
[SIPServerTransaction.java:945][SIPServerTransaction.java:1264][null:-1][null:-
1][EventScanner.java:162][EventScanner.java:404][Thread.java:595]]
[java] 56923 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.sendMessage
(UDPMessageChannel.java:609)
[gov.nist.javax.sip.stack.UDPMessageChannel:sendMessage 192.168.18.65/5060
[java] SIP/2.0 200 OK
[java] Via: SIP/2.0/UDP 192.168.18.65:5060;rport;branch=z9hG4bK1279140405
[java] From: <sip:sirejl@flaviol>;tag=1694578401
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>;expires=900
[java] Content-Length: 0
[java] ]
[java] 56923 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.sendMessage
(UDPMessageChannel.java:612) [*******************
[java] ]
[java] 56924 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.sendMessage
(UDPMessageChannel.java:629) [sendMessage 192.168.18.65/5060
[java] SIP/2.0 200 OK
[java] Via: SIP/2.0/UDP 192.168.18.65:5060;rport;branch=z9hG4bK1279140405
[java] From: <sip:sirejl@flaviol>;tag=1694578401
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>;expires=900
[java] Content-Length: 0
[java] ]
[java] 56925 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:312) [ ]]>]
[java] 56926 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:313) [</debug>]
[java] 56927 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:314) [<message
[java] from="192.168.18.64:5060"
[java] to="192.168.18.65:5060"
[java] time="1180710946379"
[java] isSender="true"
[java] transactionId="z9hg4bk1279140405"
[java] callId="[email protected]"
[java] firstLine="SIP/2.0 200 OK"
[java] debugLine="178"
[java] >
[java] <![CDATA[SIP/2.0 200 OK
[java] Via: SIP/2.0/UDP 192.168.18.65:5060;rport;branch=z9hG4bK1279140405
[java] From: <sip:sirejl@flaviol>;tag=1694578401
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>;expires=900
[java] Content-Length: 0
[java] ]]>
[java] </message>
[java] ]
[java] 56927 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:315) [<debug>]
[java] 56927 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:316) [<![CDATA[ ]
[java] 56927 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrarAccess - Registrar, processRegister(),
response sent:
[java] 56928 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrarAccess - SIP/2.0 200 OK
[java] Via: SIP/2.0/UDP 192.168.18.65:5060;rport;branch=z9hG4bK1279140405
[java] From: <sip:sirejl@flaviol>;tag=1694578401
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 1 REGISTER
[java] Contact: <sip:[email protected]:5060>;expires=900
[java] Content-Length: 0
[java] 56928 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:165) [Done
processing Message REGISTER sip:flaviol SIP/2.0
[java] ]
[java] 56928 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:189) [Done
processing Message REGISTER sip:flaviol SIP/2.0
[java] ]
[java] 56928 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.releaseSem(SIPTransaction.java:1098)
[releaseSem [[[[gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee]
[java] 56929 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:1099][SIPServerTransaction.java:1526]
[EventScanner.java:197][EventScanner.java:404][Thread.java:595]]
[java] 56929 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.removePendingTransaction
(SIPTransactionStack.java:740) [removePendingTx: z9hg4bk1279140405]
[java] 57410 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 58418 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 59494 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 60434 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 63526 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 64466 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 67558 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 68498 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 71595 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 72531 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 73372 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:221)
[UDPMessageChannel: peerAddress = 192.168.18.63/5060]
[java] 73372 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:225)
[Length = 917]
[java] 73372 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:227)
[INVITE sip:sirejl@flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK301787825
[java] From: <sip:coltranej@flaviol>;tag=698334328
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 20 INVITE
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Subject: Phone call
[java] Expires: 120
[java] Allow: INVITE, ACK, CANCEL, BYE, OPTIONS, REFER, SUBSCRIBE, NOTIFY,
MESSAGE
[java] Content-Type: application/sdp
[java] Content-Length: 428
[java] v=0
[java] o=coltranej 123456 654321 IN IP4 192.168.18.63
[java] s=A conversation
[java] c=IN IP4 192.168.18.63
[java] t=0 0
[java] m=audio 7078 RTP/AVP 111 110 0 3 8 101
[java] a=rtpmap:111 speex/16000/1
[java] a=rtpmap:110 speex/8000/1
[java] a=rtpmap:0 PCMU/8000/1
[java] a=rtpmap:3 GSM/8000/1
[java] a=rtpmap:8 PCMA/8000/1
[java] a=rtpmap:101 telephone-event/8000
[java] a=fmtp:101 0-11
[java] m=video 9078 RTP/AVP 98 99
[java] a=rtpmap:98 H263-1998/90000
[java] a=fmtp:98 CIF=1;QCIF=1
[java] a=rtpmap:99 MP4V-ES/90000
[java] ]
[java] 73402 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:312) [ ]]>]
[java] 73402 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:313) [</debug>]
[java] 73403 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:314) [<message
[java] from="192.168.18.63:5060"
[java] to="192.168.18.64:5060"
[java] time="1180710962829"
[java] isSender="false"
[java] transactionId="z9hg4bk301787825"
[java] callId="[email protected]"
[java] firstLine="INVITE sip:sirejl@flaviol SIP/2.0"
[java] debugLine="233"
[java] >
[java] <![CDATA[INVITE sip:sirejl@flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK301787825
[java] From: <sip:coltranej@flaviol>;tag=698334328
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 20 INVITE
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Subject: Phone call
[java] Expires: 120
[java] Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,REFER,SUBSCRIBE,NOTIFY,MESSAGE
[java] Content-Type: application/sdp
[java] Content-Length: 428
[java] ]]>
[java] </message>
[java] ]
[java] 73403 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:315) [<debug>]
[java] 73403 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:316) [<![CDATA[ ]
[java] 73403 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findPendingTransaction
(SIPTransactionStack.java:723) [looking for pending tx for :z9hg4bk301787825]
[java] 73404 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.<init>
(SIPServerTransaction.java:419) [Creating Server Transactionnull]
[java] 73404 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPServerTransaction.java:421][SIPTransactionStack.java:1007]
[SIPTransactionStack.java:829][UDPMessageChannel.java:370][Thread.java:595]]
[java] 73404 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setOriginalRequest
(SIPTransaction.java:384) [Setting Branch id : z9hG4bK301787825]
[java] 73404 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.newSIPServerRequest
(SIPTransactionStack.java:844) [newSIPServerRequest(
INVITE:z9hG4bK301787825):gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73405 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.NistSipMessageFactoryImpl.newSIPServerRequest
(NistSipMessageFactoryImpl.java:62) [Returning request interface for INVITE
sip:sirejl@flaviol SIP/2.0
[java] gov.nist.javax.sip.DialogFilter@1d64c37 messageChannel =
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73405 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.acquireSem(SIPTransaction.java:1078)
[acquireSem [[[[gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73405 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:1079][SIPTransactionStack.java:854]
[UDPMessageChannel.java:370][Thread.java:595]]
[java] 73405 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:393)
[About to process INVITE sip:sirejl@flaviol SIP/2.0
[java] /gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73406 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.processRequest
(SIPServerTransaction.java:623) [processRequest: INVITE sip:sirejl@flaviol
SIP/2.0
[java] ]
[java] 73406 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.processRequest
(SIPServerTransaction.java:625) [tx state = null]
[java] 73406 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setOriginalRequest
(SIPTransaction.java:384) [Setting Branch id : z9hG4bK301787825]
[java] 73406 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setState(SIPTransaction.java:504)
[Transaction:setState Trying Transaction
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a branchID =
z9hG4bK301787825 isClient = false]
[java] 73407 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:507][SIPServerTransaction.java:1311]
[SIPServerTransaction.java:635][UDPMessageChannel.java:397][Thread.java:595]]
[java] 73407 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setPassToListener
(SIPTransaction.java:1125) [setPassToListener()]
[java] 73407 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:69)
[PROCESSING INCOMING REQUEST INVITE sip:sirejl@flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK301787825
[java] From: <sip:coltranej@flaviol>;tag=698334328
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 20 INVITE
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Subject: Phone call
[java] Expires: 120
[java] Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,REFER,SUBSCRIBE,NOTIFY,MESSAGE
[java] Content-Type: application/sdp
[java] Content-Length: 428
[java] v=0
[java] o=coltranej 123456 654321 IN IP4 192.168.18.63
[java] s=A conversation
[java] c=IN IP4 192.168.18.63
[java] t=0 0
[java] m=audio 7078 RTP/AVP 111 110 0 3 8 101
[java] a=rtpmap:111 speex/16000/1
[java] a=rtpmap:110 speex/8000/1
[java] a=rtpmap:0 PCMU/8000/1
[java] a=rtpmap:3 GSM/8000/1
[java] a=rtpmap:8 PCMA/8000/1
[java] a=rtpmap:101 telephone-event/8000
[java] a=fmtp:101 0-11
[java] m=video 9078 RTP/AVP 98 99
[java] a=rtpmap:98 H263-1998/90000
[java] a=fmtp:98 CIF=1;QCIF=1
[java] a=rtpmap:99 MP4V-ES/90000
[java] transactionChannel =
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a listening point =
192.168.18.64:5060]
[java] 73408 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.getDialog
(SIPTransactionStack.java:491) [getDialog
([email protected]:sirejl@flaviol:coltranej@flaviol:698334328) :
returning null]
[java] 73408 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:138) [dialogId
= [email protected]:sirejl@flaviol:coltranej@flaviol:698334328]
[java] 73408 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:139) [dialog =
null]
[java] 73408 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.DialogFilter.processRequest(DialogFilter.java:621) [INVITE
transaction.isMapped = false]
[java] 73408 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.SipProviderImpl.handleEvent(SipProviderImpl.java:102)
[handleEvent javax.sip.RequestEvent
[source=gov.nist.javax.sip.SipProviderImpl@15fadcf]currentTransaction =
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1athis.sipListener =
[email protected] =
gov.nist.javax.sip.SipProviderImpl@15fadcf]
[java] 73409 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.SipProviderImpl.handleEvent(SipProviderImpl.java:109)
[Dialog = null]
[java] 73409 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SipProviderImpl.java:114][DialogFilter.java:834]
[SIPServerTransaction.java:731][UDPMessageChannel.java:397][Thread.java:595]]
[java] 73409 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.addEvent(EventScanner.java:54) [addEvent
gov.nist.javax.sip.EventWrapper@25d2b2]
[java] 73409 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:407)
[Done processing INVITE sip:sirejl@flaviol SIP/2.0
[java] /gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73410 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.run(EventScanner.java:400) [Processing
gov.nist.javax.sip.EventWrapper@25d2b2nevents 1]
[java] 73410 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:87) [sipEvent =
javax.sip.RequestEvent[source=gov.nist.javax.sip.SipProviderImpl@15fadcf]source
= gov.nist.javax.sip.SipProviderImpl@15fadcf]
[java] 73410 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:105)
[deliverEvent : INVITE sip:sirejl@flaviol SIP/2.0
[java] transaction gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a
sipEvent.serverTx = null]
[java] 73410 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findTransaction
(SIPTransactionStack.java:613) [serverTx: looking for key z9hg4bk301787825
existing=
{z9hg4bk1433766957=gov.nist.javax.sip.stack.SIPServerTransaction@289ead46,
z9hg4bk1279140405=gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee}]
[java] 73412 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findPendingTransaction
(SIPTransactionStack.java:723) [looking for pending tx for :z9hg4bk301787825]
[java] 73413 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.putPendingTransaction
(SIPTransactionStack.java:1222) [putPendingTransaction:
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73413 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:154) [Calling
listener INVITE sip:sirejl@flaviol SIP/2.0
[java] ]
[java] 73413 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:158) [Calling
listener gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73417 [EventScannerThread] DEBUG gov.nist.sip.proxy.Proxy -
[java] ****************************************************
[java] Request INVITE received:
[java] INVITE sip:sirejl@flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK301787825
[java] From: <sip:coltranej@flaviol>;tag=698334328
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 20 INVITE
[java] Contact: <sip:[email protected]:5060>
[java] Max-Forwards: 5
[java] User-Agent: Linphone-1.6.0/eXosip
[java] Subject: Phone call
[java] Expires: 120
[java] Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,REFER,SUBSCRIBE,NOTIFY,MESSAGE
[java] Content-Type: application/sdp
[java] Content-Length: 428
[java] v=0
[java] o=coltranej 123456 654321 IN IP4 192.168.18.63
[java] s=A conversation
[java] c=IN IP4 192.168.18.63
[java] t=0 0
[java] m=audio 7078 RTP/AVP 111 110 0 3 8 101
[java] a=rtpmap:111 speex/16000/1
[java] a=rtpmap:110 speex/8000/1
[java] a=rtpmap:0 PCMU/8000/1
[java] a=rtpmap:3 GSM/8000/1
[java] a=rtpmap:8 PCMA/8000/1
[java] a=rtpmap:101 telephone-event/8000
[java] a=fmtp:101 0-11
[java] m=video 9078 RTP/AVP 98 99
[java] a=rtpmap:98 H263-1998/90000
[java] a=fmtp:98 CIF=1;QCIF=1
[java] a=rtpmap:99 MP4V-ES/90000
[java] 73417 [EventScannerThread] DEBUG
gov.nist.sip.proxy.ProxyUtilities - DEBUG TRANSACTION INFO: the transaction is
null
[java] 73418 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.isDialogCreated
(SIPTransactionStack.java:363) [isDialogCreated : INVITE returning true]
[java] 73418 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.findTransaction
(SIPTransactionStack.java:613) [serverTx: looking for key z9hg4bk301787825
existing=
{z9hg4bk1433766957=gov.nist.javax.sip.stack.SIPServerTransaction@289ead46,
z9hg4bk1279140405=gov.nist.javax.sip.stack.SIPServerTransaction@d2a3d5ee}]
[java] 73418 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.addTransaction
(SIPTransactionStack.java:1093) [added transaction
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73419 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction$SendTrying.<init>
(SIPServerTransaction.java:239) [scheduled timer for
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73419 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.removePendingTransaction
(SIPTransactionStack.java:740) [removePendingTx: z9hg4bk301787825]
[java] 73419 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.addTransactionHash
(SIPTransactionStack.java:1115) [ putTransactionHash : key = z9hg4bk301787825]
[java] 73420 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction$TransactionTimer.<init>
(SIPServerTransaction.java:272) [TransactionTimer() : z9hg4bk301787825]
[java] 73420 [EventScannerThread] DEBUG gov.nist.sip.proxy.Proxy - Proxy,
processRequest(), we are responsible for the domain... Let's find the contact...
[java] 73420 [EventScannerThread] DEBUG gov.nist.sip.proxy.Proxy - Proxy,
processRequest(), we canonicalized the request-URI
[java] 73420 [EventScannerThread] DEBUG
gov.nist.sip.proxy.registrar.RegistrationsTable - RegistrationsTable,
hasRegistration(), Checking registration for "sip:sirejl@flaviol" : registered
[java] 73420 [EventScannerThread] DEBUG gov.nist.sip.proxy.Proxy - Proxy,
processRequest(), the target set is the set of the contacts URI from the
location service
[java] 73421 [EventScannerThread] DEBUG
gov.nist.sip.proxy.RequestForwarding - RequestForwarding, forwardRequest()
(STEP 1), the request is cloned
[java] 73421 [EventScannerThread] DEBUG
gov.nist.sip.proxy.RequestForwarding - RequestForwarding, forwardRequest()
(STEP 2), The Request-URI in the copy's start line is replaced with the URI for
this target
[java] 73421 [EventScannerThread] DEBUG
gov.nist.sip.proxy.RequestForwarding - RequestForwarding, forwardRequest(),
(STEP 3) MaxForwardHeader decremented by one.
#########################
[java] 73425 [EventScannerThread] ERROR
gov.nist.sip.proxy.RequestForwarding - RequestForwarding, forwardRequest(),
internal error, exception raised:
[java] java.lang.NullPointerException: null host
[java] at gov.nist.javax.sip.address.AddressFactoryImpl.createSipURI
(AddressFactoryImpl.java:79)
[java] at gov.nist.sip.proxy.RequestForwarding.forwardRequest(Unknown
Source)
[java] at gov.nist.sip.proxy.Proxy.processRequest(Unknown Source)
[java] at gov.nist.javax.sip.EventScanner.deliverEvent
(EventScanner.java:162)
[java] at gov.nist.javax.sip.EventScanner.run(EventScanner.java:404)
[java] at java.lang.Thread.run(Thread.java:595)
[java] 73427 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setState(SIPTransaction.java:504)
[Transaction:setState Completed Transaction
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a branchID =
z9hG4bK301787825 isClient = false]
[java] 73428 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:507][SIPServerTransaction.java:1311]
[SIPServerTransaction.java:842][SIPServerTransaction.java:1264][null:-1][null:-
1][EventScanner.java:162][EventScanner.java:404][Thread.java:595]]
[java] 73428 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.enableTimeoutTimer
(SIPTransaction.java:558) [enableTimeoutTimer
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a tickCount 64
currentTickCount = -1]
[java] 73428 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.sendMessage
(SIPServerTransaction.java:940) [sendMessage : tx =
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a getState = Completed
Transaction]
[java] 73429 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.<init>(UDPMessageChannel.java:169)
[Creating message channel 192.168.18.63/5060]
[java] 73429 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[UDPMessageChannel.java:509][SIPServerTransaction.java:396]
[SIPServerTransaction.java:945][SIPServerTransaction.java:1264][null:-1][null:-
1][EventScanner.java:162][EventScanner.java:404][Thread.java:595]]
[java] 73430 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.sendMessage
(UDPMessageChannel.java:609)
[gov.nist.javax.sip.stack.UDPMessageChannel:sendMessage 192.168.18.63/5060
[java] SIP/2.0 500 Server Internal Error
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK301787825
[java] From: <sip:coltranej@flaviol>;tag=698334328
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 20 INVITE
[java] Content-Length: 0
[java] ]
[java] 73430 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.sendMessage
(UDPMessageChannel.java:612) [*******************
[java] ]
[java] 73430 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.sendMessage
(UDPMessageChannel.java:629) [sendMessage 192.168.18.63/5060
[java] SIP/2.0 500 Server Internal Error
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK301787825
[java] From: <sip:coltranej@flaviol>;tag=698334328
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 20 INVITE
[java] Content-Length: 0
[java] ]
[java] 73438 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:312) [ ]]>]
[java] 73439 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:313) [</debug>]
[java] 73439 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:314) [<message
[java] from="192.168.18.64:5060"
[java] to="192.168.18.63:5060"
[java] time="1180710962886"
[java] isSender="true"
[java] transactionId="z9hg4bk301787825"
[java] callId="[email protected]"
[java] firstLine="SIP/2.0 500 Server Internal Error"
[java] debugLine="317"
[java] >
[java] <![CDATA[SIP/2.0 500 Server Internal Error
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK301787825
[java] From: <sip:coltranej@flaviol>;tag=698334328
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 20 INVITE
[java] Content-Length: 0
[java] ]]>
[java] </message>
[java] ]
[java] 73439 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:315) [<debug>]
[java] 73440 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:316) [<![CDATA[ ]
[java] 73440 [EventScannerThread] DEBUG
gov.nist.sip.proxy.RequestForwarding - RequestForwarding, forwardRequest(),
500 SERVER_INTERNAL_ERROR replied:
[java] SIP/2.0 500 Server Internal Error
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK301787825
[java] From: <sip:coltranej@flaviol>;tag=698334328
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 20 INVITE
[java] Content-Length: 0
[java] 73440 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:165) [Done
processing Message INVITE sip:sirejl@flaviol SIP/2.0
[java] ]
[java] 73440 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:189) [Done
processing Message INVITE sip:sirejl@flaviol SIP/2.0
[java] ]
[java] 73440 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.releaseSem(SIPTransaction.java:1098)
[releaseSem [[[[gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73445 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:1099][SIPServerTransaction.java:1526]
[EventScanner.java:197][EventScanner.java:404][Thread.java:595]]
[java] 73446 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.removePendingTransaction
(SIPTransactionStack.java:740) [removePendingTx: z9hg4bk301787825]
[java] 73445 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:221)
[UDPMessageChannel: peerAddress = 192.168.18.63/5060]
[java] 73446 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:225)
[Length = 239]
[java] 73447 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:227) [ACK
sip:sirejl@flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK301787825
[java] From: <sip:coltranej@flaviol>;tag=698334328
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 20 ACK
[java] Content-Length: 0
[java] ]
[java] 73451 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:312) [ ]]>]
[java] 73451 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:313) [</debug>]
[java] 73451 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:314) [<message
[java] from="192.168.18.63:5060"
[java] to="192.168.18.64:5060"
[java] time="1180710962903"
[java] isSender="false"
[java] transactionId="z9hg4bk301787825"
[java] callId="[email protected]"
[java] firstLine="ACK sip:sirejl@flaviol SIP/2.0"
[java] debugLine="347"
[java] >
[java] <![CDATA[ACK sip:sirejl@flaviol SIP/2.0
[java] Via: SIP/2.0/UDP 192.168.18.63:5060;rport;branch=z9hG4bK301787825
[java] From: <sip:coltranej@flaviol>;tag=698334328
[java] To: <sip:sirejl@flaviol>
[java] Call-ID: [email protected]
[java] CSeq: 20 ACK
[java] Content-Length: 0
[java] ]]>
[java] </message>
[java] ]
[java] 73452 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:315) [<debug>]
[java] 73452 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.ServerLog.logMessage(ServerLog.java:316) [<![CDATA[ ]
[java] 73452 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.newSIPServerRequest
(SIPTransactionStack.java:844) [newSIPServerRequest(
ACK:z9hG4bK301787825):gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73454 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.NistSipMessageFactoryImpl.newSIPServerRequest
(NistSipMessageFactoryImpl.java:62) [Returning request interface for ACK
sip:sirejl@flaviol SIP/2.0
[java] gov.nist.javax.sip.DialogFilter@172e449 messageChannel =
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73454 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.acquireSem(SIPTransaction.java:1078)
[acquireSem [[[[gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73455 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:1079][SIPTransactionStack.java:854]
[UDPMessageChannel.java:370][Thread.java:595]]
[java] 73455 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:393)
[About to process ACK sip:sirejl@flaviol SIP/2.0
[java] /gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73457 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.processRequest
(SIPServerTransaction.java:623) [processRequest: ACK sip:sirejl@flaviol SIP/2.0
[java] ]
[java] 73457 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.processRequest
(SIPServerTransaction.java:625) [tx state = Completed Transaction]
[java] 73457 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setState(SIPTransaction.java:504)
[Transaction:setState Confirmed Transaction
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a branchID =
z9hG4bK301787825 isClient = false]
[java] 73458 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:507][SIPServerTransaction.java:1311]
[SIPServerTransaction.java:656][UDPMessageChannel.java:397][Thread.java:595]]
[java] 73458 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.enableTimeoutTimer
(SIPTransaction.java:558) [enableTimeoutTimer
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a tickCount 10
currentTickCount = 64]
[java] 73458 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.processRequest
(SIPServerTransaction.java:677) [ACK received for server Tx z9hg4bk301787825
not delivering to application!]
[java] 73458 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.releaseSem(SIPTransaction.java:1098)
[releaseSem [[[[gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 73459 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:1099][SIPServerTransaction.java:1526]
[UDPMessageChannel.java:402][Thread.java:595]]
[java] 73463 [UDPMessageChannelThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageChannel.run(UDPMessageChannel.java:407)
[Done processing ACK sip:sirejl@flaviol SIP/2.0
[java] /gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 75635 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 76139 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireTimeoutTimer
(SIPServerTransaction.java:1023) [SIPServerTransaction.fireTimeoutTimer this =
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46 current state =
Completed Transaction method = REGISTER]
[java] 76139 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.isDialogCreated
(SIPTransactionStack.java:363) [isDialogCreated : REGISTER returning false]
[java] 76139 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setState(SIPTransaction.java:504)
[Transaction:setState Terminated Transaction
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46 branchID =
z9hG4bK1433766957 isClient = false]
[java] 76140 [Timer-1] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:507][SIPServerTransaction.java:1311]
[SIPServerTransaction.java:1048][SIPTransaction.java:588]
[SIPServerTransaction.java:306][Timer.java:512][Timer.java:462]]
[java] 76140 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.removeTransaction
(SIPTransactionStack.java:1047) [Removing Transaction = z9hg4bk1433766957]
[java] 76140 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.removePendingTransaction
(SIPTransactionStack.java:740) [removePendingTx: z9hg4bk1433766957]
[java] 76141 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.SipProviderImpl.handleEvent(SipProviderImpl.java:102)
[handleEvent javax.sip.TransactionTerminatedEvent
[source=gov.nist.javax.sip.SipProviderImpl@15fadcf]currentTransaction =
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46this.sipListener =
[email protected] =
gov.nist.javax.sip.SipProviderImpl@15fadcf]
[java] 76141 [Timer-1] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SipProviderImpl.java:114][SIPTransactionStack.java:1062]
[SIPServerTransaction.java:1049][SIPTransaction.java:588]
[SIPServerTransaction.java:306][Timer.java:512][Timer.java:462]]
[java] 76141 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.addEvent(EventScanner.java:54) [addEvent
gov.nist.javax.sip.EventWrapper@1e97f9f]
[java] 76144 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.run(EventScanner.java:400) [Processing
gov.nist.javax.sip.EventWrapper@1e97f9fnevents 1]
[java] 76144 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:87) [sipEvent =
javax.sip.TransactionTerminatedEvent
[source=gov.nist.javax.sip.SipProviderImpl@15fadcf]source =
gov.nist.javax.sip.SipProviderImpl@15fadcf]
[java] 76144 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:324) [About to
deliver transactionTerminatedEvent]
[java] 76144 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:326) [tx = null]
[java] 76144 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:328) [tx =
gov.nist.javax.sip.stack.SIPServerTransaction@289ead46]
[java] 76145 [EventScannerThread] INFO gov.nist.sip.proxy.Proxy -
transaction terminated event
[java] 76567 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 76643 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction$LingerTimer.<init>
(SIPTransaction.java:236) [LingerTimer : z9hg4bk1433766957]
[java] 78463 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireTimeoutTimer
(SIPServerTransaction.java:1023) [SIPServerTransaction.fireTimeoutTimer this =
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a current state =
Confirmed Transaction method = INVITE]
[java] 78463 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.isDialogCreated
(SIPTransactionStack.java:363) [isDialogCreated : INVITE returning true]
[java] 78465 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction.setState(SIPTransaction.java:504)
[Transaction:setState Terminated Transaction
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a branchID =
z9hG4bK301787825 isClient = false]
[java] 78465 [Timer-1] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SIPTransaction.java:507][SIPServerTransaction.java:1311]
[SIPServerTransaction.java:1057][SIPTransaction.java:588]
[SIPServerTransaction.java:306][Timer.java:512][Timer.java:462]]
[java] 78465 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.removeTransaction
(SIPTransactionStack.java:1047) [Removing Transaction = z9hg4bk301787825]
[java] 78465 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.removePendingTransaction
(SIPTransactionStack.java:740) [removePendingTx: z9hg4bk301787825]
[java] 78466 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.SipProviderImpl.handleEvent(SipProviderImpl.java:102)
[handleEvent javax.sip.TransactionTerminatedEvent
[source=gov.nist.javax.sip.SipProviderImpl@15fadcf]currentTransaction =
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1athis.sipListener =
[email protected] =
gov.nist.javax.sip.SipProviderImpl@15fadcf]
[java] 78466 [Timer-1] DEBUG proxy-jiji -
gov.nist.core.LogWriter.logStackTrace(LogWriter.java:101)
[[SipProviderImpl.java:114][SIPTransactionStack.java:1062]
[SIPServerTransaction.java:1058][SIPTransaction.java:588]
[SIPServerTransaction.java:306][Timer.java:512][Timer.java:462]]
[java] 78466 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.addEvent(EventScanner.java:54) [addEvent
gov.nist.javax.sip.EventWrapper@b9b538]
[java] 78468 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.run(EventScanner.java:400) [Processing
gov.nist.javax.sip.EventWrapper@b9b538nevents 1]
[java] 78468 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:87) [sipEvent =
javax.sip.TransactionTerminatedEvent
[source=gov.nist.javax.sip.SipProviderImpl@15fadcf]source =
gov.nist.javax.sip.SipProviderImpl@15fadcf]
[java] 78469 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:324) [About to
deliver transactionTerminatedEvent]
[java] 78469 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:326) [tx = null]
[java] 78469 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.deliverEvent(EventScanner.java:328) [tx =
gov.nist.javax.sip.stack.SIPServerTransaction@69799e1a]
[java] 78469 [EventScannerThread] INFO gov.nist.sip.proxy.Proxy -
transaction terminated event
[java] 78967 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction$LingerTimer.<init>
(SIPTransaction.java:236) [LingerTimer : z9hg4bk301787825]
[java] 80619 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 84651 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction$LingerTimer.run
(SIPTransaction.java:247) [LingerTimer: run() : z9hg4bk1433766957]
[java] 84651 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransaction$LingerTimer.run
(SIPTransaction.java:256)
[removinggov.nist.javax.sip.stack.SIPServerTransaction@289ead46]
[java] 84651 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.removeTransaction
(SIPTransactionStack.java:1047) [Removing Transaction = z9hg4bk1433766957]
[java] 84652 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPTransactionStack.removePendingTransaction
(SIPTransactionStack.java:740) [removePendingTx: z9hg4bk1433766957]
[java] 84652 [Timer-1] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.SIPServerTransaction.fireRetransmissionTimer
(SIPServerTransaction.java:977) [fireRetransmissionTimer() -- ]
[java] 85014 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy -
[java] *****************************************************
[java] 85014 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy - Stopping the proxy
[java] 85015 [AWT-EventQueue-0] DEBUG proxy-jiji -
gov.nist.javax.sip.SipProviderImpl.stop(SipProviderImpl.java:69) [Exiting
provider]
[java] 85016 [UDPMessageProcessorThread] DEBUG proxy-jiji -
gov.nist.javax.sip.stack.UDPMessageProcessor.run(UDPMessageProcessor.java:204)
[UDPMessageProcessor: Stopping]
[java] 85018 [EventScannerThread] DEBUG proxy-jiji -
gov.nist.javax.sip.EventScanner.run(EventScanner.java:372) [Stopped event
scanner!!]
[java] 85519 [AWT-EventQueue-0] INFO gov.nist.sip.proxy.Proxy - One sip
Provider removed!
[java] 85519 [AWT-EventQueue-0] INFO gov.nist.sip.proxy.Proxy - One
listening point removed!
[java] 85520 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy - Proxy stopped
[java] 85520 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy -
[java] *****************************************************
[java] 92206 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ProxyLauncher - Proxy Clean up
[java] 92207 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy -
[java] *****************************************************
[java] 92207 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy - Stopping the proxy
[java] 92208 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy - Proxy stopped
[java] 92208 [AWT-EventQueue-0] DEBUG
gov.nist.sip.proxy.gui.ListenerProxy -
[java] *****************************************************
BUILD SUCCESSFUL
Total time: 1 minute 38 seconds