Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

UDP packet too small for all the configuration data #40

Open
frixhub opened this issue Jun 10, 2015 · 1 comment
Open

UDP packet too small for all the configuration data #40

frixhub opened this issue Jun 10, 2015 · 1 comment

Comments

@frixhub
Copy link

frixhub commented Jun 10, 2015

Good day,
I'm running a Kamailio SIP server (UDP transport) with rtpproxy on the same machine to assist in NAT traversing. I can successfully set up calls from mobile phones that run Zioper SIP client over the internet using the Kamailio/rtpproxy. Instant messaging also works.

I'm running sipcmd on Ubuntu 14.04LTS with libopal 3.10.10

I've tried to use sipcmd to initiate a call to a SIP client and play a wave file. The examples are clear enough, but there seems to be a problem when sipcmd (via Opal) tries to customise the parameters of the available codecs during the INVITE phase. I get this error message in the log:
0:01.535 sipcmd SIP PDU is too large (2295 bytes) trying compact form.
0:01.535 sipcmd SIP PDU is likely too large (2245 bytes) for UDP datagram.

My assumtion is that a partial INVITE message arrives at the server, which then rejects setting up the call.

Is there a way to limit the number of codecs that Opal:GetMediaFormats() returns?

Regards,
Frix
@frixhub
Copy link
Author

frixhub commented Jun 10, 2015

The log file:

0:00.108 sipcmd Version 1.0.1 by Command line VoIP testphone on Unix Linux (3.13.0-24-generic-i686) with PTLib (v2.10.10 (svn:29149)) at 2015/6/8 12:15:02.392
0:00.108 sipcmd OpalMan Attached endpoint with prefix sip
0:00.109 sipcmd OpalEP Created endpoint: sip
0:00.109 sipcmd PTLib Created read/write mutex 0x9be80f0
0:00.109 sipcmd PWLib File handle high water mark set: 9 PUDPSocket
0:00.109 sipcmd IfaceMon Initial interface list:
127.0.0.1 <00-00-00-00-00-00> (lo)
192.168.2.4 <00-1B-77-14-17-A4> (wlan0)

0:00.109 sipcmd PTLIB Opened NetLink socket
0:00.109 sipcmd PWLib File handle high water mark set: 16 Thread unblock pipe
0:00.109 sipcmd PTLib Created thread 0x9bea3f0
0:00.109 sipcmd PTLib Thread high water mark set: 3
0:00.109 sipcmd PTLib Created read/write mutex 0x9be8288
0:00.109 sipcmd PWLib File handle high water mark set: 18 Thread unblock pipe
0:00.110 sipcmd PTLib Created thread 0x9bea598 Housekeeper
0:00.110 sipcmd PTLib No permission to set priority level 4
0:00.110 sipcmd PTLib Thread high water mark set: 4
0:00.110 Housekeeper:0xaefabb40 PTLib Started thread 0x9bea598 (11109) Housekeeper:0xaefabb40
0:00.110 sipcmd OpalMan Attached endpoint with prefix sips
0:00.110 sipcmd SIP Created endpoint.
0:00.110 sipcmd OpalMan Added route "local:.=sip:"
0:00.111 sipcmd OpalMan Added route "sip:.=local:"
0:00.111 Network In...0xaefecb40 PTLib Started thread 0x9bea3f0 (11108) Network Interface Monitor:0xaefecb40
0:00.111 Network In...0xaefecb40 IfaceMon Started interface monitor thread.
0:00.111 sipcmd PTLib Created read/write mutex 0x9befd10
0:00.111 sipcmd PWLib File handle high water mark set: 19 PUDPSocket
0:00.111 sipcmd MonSock Created socket bundle for all interfaces.
0:00.111 sipcmd PWLib File handle high water mark set: 20 PUDPSocket
0:00.111 sipcmd MonSock Created bundled UDP socket 192.168.2.4:5060
0:00.111 sipcmd PWLib File handle high water mark set: 22 Thread unblock pipe
0:00.111 sipcmd PTLib Created thread 0x9bf0270 Opal Listener
0:00.112 sipcmd PTLib Thread high water mark set: 5
0:00.112 sipcmd PTLib No permission to set priority level 4
0:00.112 sipcmd SIP Start REGISTER
aor=006@my_sip_server
remote=my_sip_server
local=
contact=
proxy=
authID=
realm=
expire=0
restore=30
minRetry=default
maxRetry=default
compatibility=FullyCompliant
0:00.112 Opal Liste...0xaef6ab40 PTLib Started thread 0x9bf0270 (11110) Opal Listener:0xaef6ab40
0:00.112 Opal Liste...0xaef6ab40 Listen Started listening thread on udp$_:5060
0:00.112 sipcmd SIP Normalised REGISTER
aor=sip:006@my_sip_server
remote=sip:006@my_sip_server
local=
contact=
proxy=
authID=006
realm=
expire=3600
restore=30
minRetry=default
maxRetry=default
compatibility=FullyCompliant
0:00.112 sipcmd PTLib Created read/write mutex 0x9bf2438
0:00.113 sipcmd PWLib File handle high water mark set: 23 PUDPSocket
0:00.113 sipcmd SIP Constructed REGISTER handler for sip:006@my_sip_server
0:00.113 sipcmd SIP Executing state change to Subscribing for REGISTER handler, target=sip:006@my_sip_server, id=f023f8e4-340c-e511-9cc5-001b771417a4@laptop
0:00.113 sipcmd SIP Changing REGISTER handler from Unavailable to Subscribing, target=sip:006@my_sip_server, id=f023f8e4-340c-e511-9cc5-001b771417a4@laptop
0:00.113 sipcmd DNS SRV Lookup "_sip._udp.my_sip_server"
0:00.114 sipcmd DNS SRV physical lookup "_sip.udp.my_sip_server 33 0"
0:01.080 sipcmd DNS Query failed: error=-1
0:01.080 sipcmd SIP No SRV record found.
0:01.080 sipcmd PTLib Created read/write mutex 0x9bf36a8
0:01.081 sipcmd OpalUDP Binding to interface: 0.0.0.0:5060
0:01.470 sipcmd SIP Created transport udp$69.67.37.174:5060<if=udp$:5060>
0:01.471 sipcmd OpalUDP Started connect to 69.67.37.174:5060
0:01.471 sipcmd OpalUDP Writing to interface 0 - "192.168.2.4%wlan0"
0:01.474 sipcmd OpalMan Listener interfaces: associated transport=udp$192.168.2.4:5060
udp$192.168.2.4:5060
0:01.475 sipcmd PTLib Created read/write mutex 0x9bf6630
0:01.475 sipcmd SIP Transaction created.
0:01.477 sipcmd SIP Transaction remembering interface "192.168.2.4%wlan0"
0:01.477 sipcmd DNS SRV Lookup "_sip._udp.my_sip_server"
0:01.477 sipcmd SIP No SRV record found.
0:01.477 sipcmd SIP Transaction remote address is udp$my_sip_server:5060
0:01.478 sipcmd SIP Sending PDU (562 bytes) to: rem=udp$69.67.37.174:5060,local=udp$192.168.2.4:5060,if=192.168.2.4%wlan0
REGISTER sip:my_sip_server SIP/2.0
CSeq: 1 REGISTER
Via: SIP/2.0/UDP 192.168.2.4:5060;branch=z9hG4bK980fc8e5-340c-e511-9cc5-001b771417a4;rport
User-Agent: sipcmd/1.0.1
From: sip:006@my_sip_server;tag=0037f8e4-340c-e511-9cc5-001b771417a4
Call-ID: f023f8e4-340c-e511-9cc5-001b771417a4@laptop
Organization: Command line VoIP testphone
To: sip:006@my_sip_server
Contact: sip:006@192.168.2.4:5060;q=1
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK
Expires: 3600
Content-Length: 0
Max-Forwards: 70

0:01.479 sipcmd OpalUDP Setting interface to 192.168.2.4%wlan0
0:01.479 sipcmd SIP Transaction timers set: retry=10.000, completion=16.000
0:01.479 sipcmd OpalMan Attached endpoint with prefix local
0:01.479 sipcmd OpalEP Created endpoint: local
0:01.479 sipcmd LocalEP Created endpoint.
0:01.480 sipcmd OpalMan Set up call from local:* to sip:005@my_sip_server
0:01.480 sipcmd PTLib Created read/write mutex 0x9bf78d8
0:01.480 sipcmd Call Created Call[Cf70ec4881]
0:01.480 sipcmd OpalMan Set up connection to "local:"
0:01.480 sipcmd PTLib Created read/write mutex 0x9bf7d30
0:01.480 sipcmd OpalCon Created connection Call[Cf70ec4881]-EP[L69a179432]
0:01.481 sipcmd LocalCon Created connection with token "L69a179432"
0:01.481 sipcmd Call GetOtherPartyConnection Call[Cf70ec4881]-EP[L69a179432]
0:01.481 sipcmd OpalCon SetPhase from UninitialisedPhase to SetUpPhase for Call[Cf70ec4881]-EP[L69a179432]
0:01.481 sipcmd OpalMan OnIncoming connection Call[Cf70ec4881]-EP[L69a179432]
0:01.481 sipcmd Call GetOtherPartyConnection Call[Cf70ec4881]-EP[L69a179432]
0:01.481 sipcmd Call GetOtherPartyConnection Call[Cf70ec4881]-EP[L69a179432]
0:01.481 sipcmd OpalMan Searching for route "local:frix sip:005@my_sip_server"
0:01.482 sipcmd OpalMan Matched regex "^local:. .$" ("local:.")
0:01.482 sipcmd OpalMan Set up connection to "sip:005@my_sip_server"
0:01.482 sipcmd PTLib Created read/write mutex 0x9bfbc38
0:01.482 sipcmd OpalCon Created connection Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:01.482 sipcmd RFC2833 Handler created
0:01.482 sipcmd RFC2833 Handler created
0:01.483 sipcmd SIP Created connection.
0:01.483 sipcmd LocalCon Outgoing call routed to sip:005@my_sip_server for Call[Cf70ec4881]-EP[L69a179432]
0:01.483 sipcmd Call OnSetUp Call[Cf70ec4881]-EP[L69a179432]
0:01.483 sipcmd SIP SetUpConnection: sip:005@my_sip_server
0:01.483 sipcmd DNS SRV Lookup "_sip._udp.my_sip_server"
0:01.483 sipcmd SIP No SRV record found.
0:01.484 sipcmd SIP Connecting to sip:005@my_sip_server via sip:005@my_sip_server
0:01.484 sipcmd SIP Setting new transport for destination "sip:005@my_sip_server"
0:01.484 sipcmd SIP Found registrar on domain my_sip_server, using interface
0:01.484 sipcmd PTLib Created read/write mutex 0x9bfdad8
0:01.484 sipcmd OpalUDP Binding to interface: 0.0.0.0:5060
0:01.484 sipcmd SIP Created transport udp$69.67.37.174:5060<if=udp$*:5060>
0:01.484 sipcmd OpalUDP Started connect to 69.67.37.174:5060
0:01.505 sipcmd Call GetMediaFormats for Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
G.722.2,GSM-AMR,iLBC,GSM-06.10,G.726-40k,G.726-32k,G.726-24k,G.726-16k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,H.264-1,H.264-0,MPEG4,H.263,H.263plus,H.261,G.722-64k,G.722.1-24k,G.722.1-32k,SILK-16,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,LPC-10,MS-GSM,MS-IMA-ADPCM,SILK-8,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,T.38,iLBC-13k3,iLBC-15k2,UserInput/RFC2833,NamedSignalEvent,RFC4175_YCbCr-4:2:0,theora,MSRP,SIP-IM,T.140,H.224/H323AnnexQ
0:01.505 sipcmd SIP Local media formats set:
G.722.2,GSM-AMR,iLBC,GSM-06.10,G.726-40k,G.726-32k,G.726-24k,G.726-16k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,H.264-1,H.264-0,MPEG4,H.263,H.263plus,H.261,G.722-64k,G.722.1-24k,G.722.1-32k,SILK-16,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,LPC-10,MS-GSM,MS-IMA-ADPCM,SILK-8,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,T.38,iLBC-13k3,iLBC-15k2,UserInput/RFC2833,NamedSignalEvent,RFC4175_YCbCr-4:2:0,theora,MSRP,SIP-IM,T.140,H.224/H323AnnexQ
0:01.506 sipcmd SIP Remote media formats set:
G.722.2,GSM-AMR,iLBC,GSM-06.10,G.726-40k,G.726-32k,G.726-24k,G.726-16k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,H.264-1,H.264-0,MPEG4,H.263,H.263plus,H.261,G.722-64k,G.722.1-24k,G.722.1-32k,SILK-16,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,LPC-10,MS-GSM,MS-IMA-ADPCM,SILK-8,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,T.38,iLBC-13k3,iLBC-15k2,UserInput/RFC2833,NamedSignalEvent,RFC4175_YCbCr-4:2:0,theora,MSRP,SIP-IM,T.140,H.224/H323AnnexQ
0:01.506 sipcmd OpalUDP Writing to interface 0 - "192.168.2.4%wlan0"
0:01.506 sipcmd SIP Getting local URI from registeration: sip:006@my_sip_server
0:01.506 sipcmd SIP Updating dialog tag from "" to "dc1ac9e5-340c-e511-9cc5-001b771417a4"
0:01.507 sipcmd PTLib Created read/write mutex 0x9c058a0
0:01.507 sipcmd SIP Remote dialog address from target: sip:005@my_sip_server
0:01.507 sipcmd DNS SRV Lookup "_sip._udp.my_sip_server"
0:01.507 sipcmd SIP No SRV record found.
0:01.509 sipcmd SIP INVITE transaction id=z9hG4bK38f7cce5-340c-e511-9cc5-001b771417a4 created.
0:01.509 sipcmd SIP Creating INVITE request
0:01.509 sipcmd SIP Offering all configured media:
G.722.2,GSM-AMR,iLBC,GSM-06.10,G.726-40k,G.726-32k,G.726-24k,G.726-16k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,H.264-1,H.264-0,MPEG4,H.263,H.263plus,H.261,G.722-64k,G.722.1-24k,G.722.1-32k,SILK-16,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,LPC-10,MS-GSM,MS-IMA-ADPCM,SILK-8,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,T.38,iLBC-13k3,iLBC-15k2,UserInput/RFC2833,NamedSignalEvent,RFC4175_YCbCr-4:2:0,theora,MSRP,SIP-IM,T.140,H.224/H323AnnexQ
0:01.510 sipcmd SIP Offering media type audio in SDP
0:01.510 sipcmd Call IsMediaBypassPossible Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4] session 1
0:01.510 sipcmd OpalMan IsMediaBypassPossible: session 1
0:01.510 sipcmd OpalCon IsMediaBypassPossible: default returns false
0:01.510 sipcmd RTP Cannot find media session 1
0:01.510 sipcmd RTP Cannot find RTP session 1
0:01.510 sipcmd PTLib Created PXConfig 0x9c063e0
0:01.511 sipcmd RTP_UDP Session 1, created with NAT flag set to 0
0:01.511 sipcmd PWLib File handle high water mark set: 24 PUDPSocket
0:01.511 sipcmd RTP_UDP Session 1 created: 192.168.2.4:5000-5001 ssrc=273343867
0:01.511 sipcmd PWLib File handle high water mark set: 25 PUDPSocket
0:01.511 sipcmd RTP Creating new session RTP_UDP
0:01.512 sipcmd RTPEp Session 1, remembering local RTP port 5000 on connection Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:01.512 sipcmd RTP Found existing media session 1
0:01.512 sipcmd MediaFormat Validation of merge for media option "BitRate" failed.
0:01.513 sipcmd SDP SDP not including SpeexIETFWide-20.6k as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including SpeexWide-20.6k as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including MS-GSM as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including MS-IMA-ADPCM as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including SpeexIETFNarrow-11k as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including SpeexIETFNarrow-15k as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including SpeexIETFNarrow-18.2k as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including SpeexIETFNarrow-24.6k as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including SpeexIETFNarrow-5.95k as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including SpeexIETFNarrow-8k as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including SpeexWNarrow-8k as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including iLBC-13k3 as it is not a SIP transportable format
0:01.513 sipcmd SDP SDP not including iLBC-15k2 as it is not a SIP transportable format
0:01.514 sipcmd MediaFormat Merging UserInput/RFC2833 into UserInput/RFC2833
0:01.514 sipcmd RFC2833 Set tx pt=[pt=101], events="0-16,32,36" for UserInput/RFC2833
0:01.514 sipcmd RFC2833 Set rx pt=[pt=101], events="0-16,32,36" for UserInput/RFC2833
0:01.514 sipcmd MediaFormat Merging NamedSignalEvent into NamedSignalEvent
0:01.514 sipcmd RFC2833 Set tx pt=[pt=100], events="192-193" for NamedSignalEvent
0:01.514 sipcmd RFC2833 Set rx pt=[pt=100], events="192-193" for NamedSignalEvent
0:01.514 sipcmd SIP Offering media type video in SDP
0:01.514 sipcmd Call IsMediaBypassPossible Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4] session 2
0:01.514 sipcmd OpalMan IsMediaBypassPossible: session 2
0:01.514 sipcmd OpalCon IsMediaBypassPossible: default returns false
0:01.514 sipcmd RTP Cannot find media session 2
0:01.514 sipcmd RTP Cannot find RTP session 2
0:01.515 sipcmd RTP_UDP Session 2, created with NAT flag set to 0
0:01.515 sipcmd PWLib File handle high water mark set: 26 PUDPSocket
0:01.515 sipcmd RTP_UDP SetOption(25,8,1048576) failed, even though it said it succeeded!
0:01.515 sipcmd RTP_UDP SetOption(25,8,524288) failed, even though it said it succeeded!
0:01.515 sipcmd RTP_UDP SetOption(25,8,262144) succeeded.
0:01.515 sipcmd RTP_UDP Session 2 created: 192.168.2.4:5002-5003 ssrc=4217261914
0:01.515 sipcmd PWLib File handle high water mark set: 27 PUDPSocket
0:01.515 sipcmd RTP Creating new session RTP_UDP
0:01.515 sipcmd RTPEp Session 2, remembering local RTP port 5002 on connection Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:01.515 sipcmd RTP Found existing media session 2
0:01.516 sipcmd SDP SDP not including H.264 as it is not a SIP transportable format
0:01.516 sipcmd MediaFormat Validation of merge for media option "Packetization Mode" failed.
0:01.516 sipcmd SIP Transaction remembering interface "192.168.2.4%wlan0"
0:01.516 sipcmd SIP Transaction remote address is udp$my_sip_server:5060
0:01.517 sipcmd OpalPlugin to_customised_options:
Format Name = SILK-16
Media Type = audio
Payload Type = [pt=125]
Encoding Name = SILK
Channels (R/W) = 1 UnsignedInt
Clock Rate (R/O) = 16000 UnsignedInt
Complexity (R/O) = 1 UnsignedInt
Frame Time (R/O) = 320 UnsignedInt
Max Bit Rate (R/O) = 30000 UnsignedInt
Max Frame Size (R/O) = 75 UnsignedInt
Max Frames Per Packet (R/O) = 5 UnsignedInt
Needs Jitter (R/O) = 1 Boolean
Protocol (R/O) = SIP String
Rx Frames Per Packet (R/W) = 5 UnsignedInt
Tx Frames Per Packet (R/W) = 2 UnsignedInt
Use DTX (R/O) = 0 FMTP name: usedtx (0) Boolean
Use In-Band FEC (R/O) = 1 FMTP name: useinbandfec (1) Boolean

0:01.518 sipcmd OpalPlugin to_customised_options:
Format Name = SILK-8
Media Type = audio
Payload Type = [pt=124]
Encoding Name = SILK
Channels (R/W) = 1 UnsignedInt
Clock Rate (R/O) = 8000 UnsignedInt
Complexity (R/O) = 1 UnsignedInt
Frame Time (R/O) = 160 UnsignedInt
Max Bit Rate (R/O) = 20000 UnsignedInt
Max Frame Size (R/O) = 50 UnsignedInt
Max Frames Per Packet (R/O) = 5 UnsignedInt
Needs Jitter (R/O) = 1 Boolean
Protocol (R/O) = SIP String
Rx Frames Per Packet (R/W) = 5 UnsignedInt
Tx Frames Per Packet (R/W) = 2 UnsignedInt
Use DTX (R/O) = 0 FMTP name: usedtx (0) Boolean
Use In-Band FEC (R/O) = 1 FMTP name: useinbandfec (1) Boolean

0:01.521 sipcmd OpalPlugin to_customised_options:
Format Name = H.264-1
Media Type = video
Payload Type = [pt=94]
Encoding Name = H264
Clock Rate (R/O) = 90000 UnsignedInt
Content Role (R/W) = No Role Enum
Content Role Mask (R/W) = 0 UnsignedInt
Frame Height (R/W) = 288 UnsignedInt
Frame Time (R/W) = 1500 UnsignedInt
Frame Width (R/W) = 352 UnsignedInt
Level (R/W) = 3 Enum
Max Bit Rate (R/W) = 240000000 UnsignedInt
Max NALU Size (R/W) = 1400 FMTP name: max-rcmd-nalu-size (1400) H.245 Ordinal: 9 Collapsing TCS OLC RM UnsignedInt
Max Rx Frame Height (R/W) = 2304 UnsignedInt
Max Rx Frame Width (R/W) = 2816 UnsignedInt
Max Tx Packet Size (R/O) = 1444 UnsignedInt
Min Rx Frame Height (R/W) = 96 UnsignedInt
Min Rx Frame Width (R/W) = 128 UnsignedInt
Packetization Mode (R/O) = 1 FMTP name: packetization-mode (0) UnsignedInt
Profile (R/W) = Baseline Enum
Protocol (R/O) = SIP String
Rate Control Period (R/W) = 1000 UnsignedInt
Rate Controller (R/W) = String
Send Access Unit Delimiters (R/W) = 0 Boolean
SIP/SDP Max BR (R/O) = 0 FMTP name: max-br (0) UnsignedInt
SIP/SDP Max FS (R/O) = 0 FMTP name: max-fs (0) UnsignedInt
SIP/SDP Max MBPS (R/O) = 0 FMTP name: max-mbps (0) UnsignedInt
SIP/SDP Profile & Level (R/O) = 42801e FMTP name: profile-level-id (42800A) OctetString
Target Bit Rate (R/W) = 240000000 UnsignedInt
Temporal Spatial Trade Off (R/W) = 31 UnsignedInt
Tx Key Frame Period (R/W) = 125 UnsignedInt

0:01.522 sipcmd x264 Level "3" selected index 8
0:01.523 sipcmd x264 Max resolution 2816x2304 selected index 8
0:01.523 sipcmd x264 Reduced max resolution to 1408x1152 (25344>25344)
0:01.523 sipcmd OpalPlugin to_customised_options changed option "Max Rx Frame Height" from "2304" to "1152"
0:01.523 sipcmd OpalPlugin to_customised_options changed option "Max Rx Frame Width" from "2816" to "1408"
0:01.523 sipcmd OpalPlugin to_customised_options changed option "SIP/SDP Max BR" from "0" to "240000"
0:01.523 sipcmd OpalPlugin to_customised_options changed option "SIP/SDP Max FS" from "0" to "6336"
0:01.523 sipcmd OpalPlugin to_customised_options changed option "SIP/SDP Max MBPS" from "0" to "380160"
0:01.523 sipcmd OpalPlugin to_customised_options:
Format Name = H.264-0
Media Type = video
Payload Type = [pt=93]
Encoding Name = H264
Clock Rate (R/O) = 90000 UnsignedInt
Content Role (R/W) = No Role Enum
Content Role Mask (R/W) = 0 UnsignedInt
Frame Height (R/W) = 288 UnsignedInt
Frame Time (R/W) = 1500 UnsignedInt
Frame Width (R/W) = 352 UnsignedInt
Level (R/W) = 3 Enum
Max Bit Rate (R/W) = 240000000 UnsignedInt
Max NALU Size (R/W) = 1400 FMTP name: max-rcmd-nalu-size (1400) H.245 Ordinal: 9 Collapsing TCS OLC RM UnsignedInt
Max Rx Frame Height (R/W) = 2304 UnsignedInt
Max Rx Frame Width (R/W) = 2816 UnsignedInt
Max Tx Packet Size (R/O) = 1444 UnsignedInt
Min Rx Frame Height (R/W) = 96 UnsignedInt
Min Rx Frame Width (R/W) = 128 UnsignedInt
Packetization Mode (R/O) = 0 FMTP name: packetization-mode (0) UnsignedInt
Profile (R/W) = Baseline Enum
Protocol (R/O) = SIP String
Rate Control Period (R/W) = 1000 UnsignedInt
Rate Controller (R/W) = String
Send Access Unit Delimiters (R/W) = 0 Boolean
SIP/SDP Max BR (R/O) = 0 FMTP name: max-br (0) UnsignedInt
SIP/SDP Max FS (R/O) = 0 FMTP name: max-fs (0) UnsignedInt
SIP/SDP Max MBPS (R/O) = 0 FMTP name: max-mbps (0) UnsignedInt
SIP/SDP Profile & Level (R/O) = 42801e FMTP name: profile-level-id (42800A) OctetString
Target Bit Rate (R/W) = 240000000 UnsignedInt
Temporal Spatial Trade Off (R/W) = 31 UnsignedInt
Tx Key Frame Period (R/W) = 125 UnsignedInt

0:01.525 sipcmd x264 Level "3" selected index 8
0:01.525 sipcmd x264 Max resolution 2816x2304 selected index 8
0:01.525 sipcmd x264 Reduced max resolution to 1408x1152 (25344>25344)
0:01.525 sipcmd OpalPlugin to_customised_options changed option "Max Rx Frame Height" from "2304" to "1152"
0:01.525 sipcmd OpalPlugin to_customised_options changed option "Max Rx Frame Width" from "2816" to "1408"
0:01.525 sipcmd OpalPlugin to_customised_options changed option "SIP/SDP Max BR" from "0" to "240000"
0:01.525 sipcmd OpalPlugin to_customised_options changed option "SIP/SDP Max FS" from "0" to "6336"
0:01.525 sipcmd OpalPlugin to_customised_options changed option "SIP/SDP Max MBPS" from "0" to "380160"
0:01.526 sipcmd OpalPlugin to_customised_options:
Format Name = H.263
Media Type = video
Payload Type = H263
Encoding Name = H263
Annex F - Advanced Prediction (R/W) = 1 FMTP name: F (0) Boolean
CIF MPI (R/W) = 1 FMTP name: CIF (33) UnsignedInt
CIF16 MPI (R/W) = 1 FMTP name: CIF16 (33) UnsignedInt
CIF4 MPI (R/W) = 1 FMTP name: CIF4 (33) UnsignedInt
Clock Rate (R/O) = 90000 UnsignedInt
Content Role (R/W) = No Role Enum
Content Role Mask (R/W) = 0 UnsignedInt
Frame Height (R/W) = 288 UnsignedInt
Frame Time (R/W) = 1500 UnsignedInt
Frame Width (R/W) = 352 UnsignedInt
Max Bit Rate (R/W) = 327600 UnsignedInt
Max Rx Frame Height (R/W) = 1152 UnsignedInt
Max Rx Frame Width (R/W) = 1408 UnsignedInt
Max Tx Packet Size (R/O) = 1444 UnsignedInt
MaxBR (R/W) = 0 FMTP name: maxbr (0) UnsignedInt
Media Packetization (R/O) = RFC2190 String
Min Rx Frame Height (R/W) = 96 UnsignedInt
Min Rx Frame Width (R/W) = 128 UnsignedInt
Protocol (R/O) = SIP String
QCIF MPI (R/W) = 1 FMTP name: QCIF (33) UnsignedInt
Rate Control Period (R/W) = 1000 UnsignedInt
Rate Controller (R/W) = String
SQCIF MPI (R/W) = 1 FMTP name: SQCIF (33) UnsignedInt
Target Bit Rate (R/W) = 327600 UnsignedInt
Tx Key Frame Period (R/W) = 125 UnsignedInt

0:01.527 sipcmd OpalPlugin to_customised_options changed option "MaxBR" from "0" to "3276"
0:01.527 sipcmd OpalPlugin to_customised_options:
Format Name = H.263plus
Media Type = video
Payload Type = [pt=92]
Encoding Name = H263-1998
Annex D - Unrestricted Motion Vector (R/W) = 1 FMTP name: D (0) Boolean
Annex F - Advanced Prediction (R/W) = 1 FMTP name: F (0) Boolean
Annex I - Advanced INTRA Coding (R/W) = 1 FMTP name: I (0) Boolean
Annex J - Deblocking Filter (R/W) = 1 FMTP name: J (0) Boolean
Annex K - Slice Structure (R/W) = 0 FMTP name: K (0) UnsignedInt
Annex N - Reference Picture Selection (R/O) = 0 FMTP name: N (0) Boolean
Annex T - Modified Quantization (R/O) = 0 FMTP name: T (0) Boolean
CIF MPI (R/W) = 1 FMTP name: CIF (33) UnsignedInt
CIF16 MPI (R/W) = 1 FMTP name: CIF16 (33) UnsignedInt
CIF4 MPI (R/W) = 1 FMTP name: CIF4 (33) UnsignedInt
Clock Rate (R/O) = 90000 UnsignedInt
Content Role (R/W) = No Role Enum
Content Role Mask (R/W) = 0 UnsignedInt
Custom MPI (R/W) = 0,0,33 FMTP name: CUSTOM (0,0,33) String
Frame Height (R/W) = 288 UnsignedInt
Frame Time (R/W) = 1500 UnsignedInt
Frame Width (R/W) = 352 UnsignedInt
Max Bit Rate (R/W) = 327600 UnsignedInt
Max Rx Frame Height (R/W) = 576 UnsignedInt
Max Rx Frame Width (R/W) = 704 UnsignedInt
Max Tx Packet Size (R/O) = 1444 UnsignedInt
MaxBR (R/W) = 0 FMTP name: maxbr (0) UnsignedInt
Media Packetizations (R/O) = RFC2429,RFC2190 String
Min Rx Frame Height (R/W) = 96 UnsignedInt
Min Rx Frame Width (R/W) = 128 UnsignedInt
Protocol (R/O) = SIP String
QCIF MPI (R/W) = 1 FMTP name: QCIF (33) UnsignedInt
Rate Control Period (R/W) = 1000 UnsignedInt
Rate Controller (R/W) = String
SQCIF MPI (R/W) = 1 FMTP name: SQCIF (33) UnsignedInt
Target Bit Rate (R/W) = 327600 UnsignedInt
Temporal Spatial Trade Off (R/W) = 31 UnsignedInt
Tx Key Frame Period (R/W) = 125 UnsignedInt

0:01.530 sipcmd OpalPlugin to_customised_options changed option "MaxBR" from "0" to "3276"
0:01.530 sipcmd OpalPlugin to_customised_options changed option "CIF16 MPI" from "1" to "33"
0:01.530 sipcmd OpalPlugin to_customised_options:
Format Name = H.261
Media Type = video
Payload Type = H261
Encoding Name = h261
Annex D (R/O) = 0 FMTP name: D (0) Boolean
CIF MPI (R/W) = 1 FMTP name: CIF (33) UnsignedInt
Clock Rate (R/O) = 90000 UnsignedInt
Content Role (R/W) = No Role Enum
Content Role Mask (R/W) = 0 UnsignedInt
Frame Height (R/W) = 288 UnsignedInt
Frame Time (R/W) = 1500 UnsignedInt
Frame Width (R/W) = 352 UnsignedInt
Max Bit Rate (R/W) = 621700 UnsignedInt
Max Rx Frame Height (R/O) = 288 UnsignedInt
Max Rx Frame Width (R/O) = 352 UnsignedInt
Max Tx Packet Size (R/O) = 1444 UnsignedInt
Min Rx Frame Height (R/O) = 144 UnsignedInt
Min Rx Frame Width (R/O) = 176 UnsignedInt
Protocol (R/O) = SIP String
QCIF MPI (R/W) = 1 FMTP name: QCIF (33) UnsignedInt
Rate Control Period (R/W) = 1000 UnsignedInt
Rate Controller (R/W) = String
Target Bit Rate (R/W) = 621700 UnsignedInt
Tx Key Frame Period (R/W) = 125 UnsignedInt

0:01.531 sipcmd OpalPlugin to_customised_options:
Format Name = theora
Media Type = video
Payload Type = [pt=126]
Encoding Name = theora
CAP Delivery (R/W) = in_band FMTP name: delivery-method (in_band) String
CAP Height (R/W) = 576 FMTP name: height (15) UnsignedInt
CAP Sampling (R/W) = YCbCr-4:2:0 FMTP name: sampling (YCbCr-4:2:0) String
CAP Width (R/W) = 704 FMTP name: width (15) UnsignedInt
Clock Rate (R/O) = 90000 UnsignedInt
Content Role (R/W) = No Role Enum
Content Role Mask (R/W) = 0 UnsignedInt
Frame Height (R/W) = 288 UnsignedInt
Frame Time (R/W) = 1500 UnsignedInt
Frame Width (R/W) = 352 UnsignedInt
Max Bit Rate (R/W) = 768000 UnsignedInt
Max Rx Frame Height (R/O) = 720 UnsignedInt
Max Rx Frame Width (R/O) = 1280 UnsignedInt
Max Tx Packet Size (R/O) = 1444 UnsignedInt
Min Rx Frame Height (R/O) = 144 UnsignedInt
Min Rx Frame Width (R/O) = 176 UnsignedInt
Protocol (R/O) = SIP String
Rate Control Period (R/W) = 1000 UnsignedInt
Rate Controller (R/W) = String
Target Bit Rate (R/W) = 768000 UnsignedInt
Tx Key Frame Period (R/W) = 125 UnsignedInt

0:01.535 sipcmd SIP PDU is too large (2295 bytes) trying compact form.
0:01.535 sipcmd SIP PDU is likely too large (2245 bytes) for UDP datagram.
0:01.535 sipcmd SIP Sending PDU (2245 bytes) to: rem=udp$69.67.37.174:5060,local=udp$192.168.2.4:5060,if=192.168.2.4%wlan0
INVITE sip:005@my_sip_server SIP/2.0
CSeq: 1 INVITE
v: SIP/2.0/UDP 192.168.2.4:5060;branch=z9hG4bK38f7cce5-340c-e511-9cc5-001b771417a4;rport
User-Agent: sipcmd/1.0.1
f: "frix" sip:006@my_sip_server;tag=dc1ac9e5-340c-e511-9cc5-001b771417a4
i: 0c27c9e5-340c-e511-9cc5-001b771417a4@laptop
k: 100rel,replaces
Organization: Command line VoIP testphone
t: sip:005@my_sip_server
m: "frix" sip:006@my_sip_server@192.168.2.4
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK
l: 1663
c: application/sdp
Max-Forwards: 70

v=0
o=- 1433758503 1 IN IP4 192.168.2.4
s=sipcmd/1.0.1
c=IN IP4 192.168.2.4
t=0 0
m=audio 5000 RTP/AVP 123 115 120 3 116 117 118 119 0 8 9 112 113 125 110 111 124 109 101 100
a=sendrecv
a=rtpmap:123 AMR-WB/16000/1
a=fmtp:123 octet-align=1
a=rtpmap:115 AMR/8000/1
a=rtpmap:120 iLBC/8000/1
a=fmtp:120 mode=20
a=rtpmap:3 gsm/8000/1
a=rtpmap:116 G726-40/8000/1
a=rtpmap:117 G726-32/8000/1
a=rtpmap:118 G726-24/8000/1
a=rtpmap:119 G726-16/8000/1
a=rtpmap:0 PCMU/8000/1
a=rtpmap:8 PCMA/8000/1
a=rtpmap:9 G722/8000/1
a=rtpmap:112 G7221/16000/1
a=fmtp:112 bitrate=24000
a=rtpmap:113 G7221/16000/1
a=fmtp:113 bitrate=32000
a=rtpmap:125 SILK/16000/1
a=rtpmap:110 Speex/16000/1
a=rtpmap:111 lpc10/8000/1
a=rtpmap:124 SILK/8000/1
a=rtpmap:109 Speex/8000/1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16,32,36
a=rtpmap:100 NSE/8000
a=fmtp:100 192-193
a=maxptime:30
m=video 5002 RTP/AVP 94 93 89 34 92 31 97 126
b=AS:240000
b=TIAS:240000000
a=sendrecv
a=rtpmap:94 H264/90000
a=fmtp:94 packetization-mode=1;max-br=240000;max-fs=6336;max-mbps=380160;profile-level-id=42801e
a=rtpmap:93 H264/90000
a=fmtp:93 max-br=240000;max-fs=6336;max-mbps=380160;profile-level-id=42801e
a=rtpmap:89 MP4V-ES/90000
a=fmtp:89 profile-level-id=5
a=rtpmap:34 H263/90000
a=fmtp:34 F=1;CIF=1;CIF16=1;CIF4=1;maxbr=3276;QCIF=1;SQCIF=1
a=rtpmap:92 H263-1998/90000
a=fmtp:92 D=1;F=1;I=1;J=1;CIF=1;CIF4=1;maxbr=3276;QCIF=1;SQCIF=1
a=rtpmap:31 h261/90000
a=fmtp:31 CIF=1;QCIF=1
a=rtpmap:97 raw/90000
a=fmtp:97 rate=90000;height=288;width=352;colorimetry=BT601-5;depth=8;sampling=YCbCr-4:2:0
a=rtpmap:126 theora/90000
a=fmtp:126 height=576;width=704

0:01.536 sipcmd OpalUDP Setting interface to 192.168.2.4%wlan0
0:01.536 sipcmd SIP Transaction timers set: retry=10.000, completion=32.000
0:01.536 sipcmd OpalCon SetPhase from UninitialisedPhase to SetUpPhase for Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:01.536 sipcmd OpalCon OnSetUpConnectionCall[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:01.536 sipcmd OpalEP OnSetUpConnection Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:01.536 sipcmd OpalMan SetUpCall succeeded, call=Call[Cf70ec4881]
0:01.721 Opal Liste...0xaef6ab40 PTLib Created read/write mutex 0xaec06688
0:01.722 Opal Liste...0xaef6ab40 OpalUDP Binding to interface: 192.168.2.4:5060
0:01.722 Opal Liste...0xaef6ab40 PTLib Created read/write mutex 0xaec06bc0
0:01.722 Opal Liste...0xaef6ab40 SIP Waiting for PDU on udp$69.67.37.174:5060<if=udp$192.168.2.4:5060>
0:01.722 Opal Liste...0xaef6ab40 SIP PDU received: rem=udp$69.67.37.174:5060,local=udp$192.168.2.4:5060,if=192.168.2.4%wlan0
SIP/2.0 200 OK
CSeq: 1 REGISTER
Via: SIP/2.0/UDP 192.168.2.4:5060;branch=z9hG4bK980fc8e5-340c-e511-9cc5-001b771417a4;rport=5060;received=41.150.68.250
Server: kamailio (4.2.4 (i386/linux))
From: sip:006@my_sip_server;tag=0037f8e4-340c-e511-9cc5-001b771417a4
Call-ID: f023f8e4-340c-e511-9cc5-001b771417a4@laptop
To: sip:006@my_sip_server;tag=b2dcd027eebfd7171a5de8605fda5c47.b32d
Contact: sip:006@192.168.2.4:5060;q=1;expires=3600;received="sip:41.150.68.250:5060"
Content-Length: 0

0:01.723 Opal Liste...0xaef6ab40 SIP Queueing PDU "1 REGISTER <200>", transaction=z9hG4bK980fc8e5-340c-e511-9cc5-001b771417a4, token=f023f8e4-340c-e511-9cc5-001b771417a4@laptop
0:01.723 Opal Liste...0xaef6ab40 PWLib File handle high water mark set: 28 Thread unblock pipe
0:01.723 Opal Liste...0xaef6ab40 PTLib Created thread 0xaec07158 Pool
0:01.723 Opal Liste...0xaef6ab40 PTLib No permission to set priority level 3
0:01.723 Opal Liste...0xaef6ab40 PTLib Thread high water mark set: 6
0:01.723 Pool:0xaedffb40 PTLib Started thread 0xaec07158 (11111) Pool:0xaedffb40
0:01.724 Opal Liste...0xaef6ab40 Opal Transport clean up on termination
0:01.724 Opal Liste...0xaef6ab40 Opal Transport Close
0:01.724 Pool:0xaedffb40 SIP Handling PDU "1 REGISTER <200>" for transaction=z9hG4bK980fc8e5-340c-e511-9cc5-001b771417a4
0:01.724 Pool:0xaedffb40 SIP REGISTER transaction id=z9hG4bK980fc8e5-340c-e511-9cc5-001b771417a4 completing.
0:01.724 Pool:0xaedffb40 SIP Finalising handlers interface "192.168.2.4%wlan0"
0:01.724 Pool:0xaedffb40 OpalUDP Setting interface to 192.168.2.4%wlan0
0:01.724 Pool:0xaedffb40 SIP Product Info: name="kamailio", version="", vendor="", comments="(4.2.4 (i386/linux))"
0:01.725 Pool:0xaedffb40 SIP Remote indicated change of REGISTER Contact address(s) (sip:006@192.168.2.4:5060;q=1;received=sip:41.150.68.250:5060) required due to NAT address udp$41.150.68.250:5060, previous=
0:01.725 Pool:0xaedffb40 SIP Expiry time for REGISTER set to 0 seconds.
0:01.725 Pool:0xaedffb40 SIP Changing REGISTER handler from Subscribing to Refreshing, target=sip:006@my_sip_server, id=f023f8e4-340c-e511-9cc5-001b771417a4@laptop
0:01.725 Pool:0xaedffb40 PTLib Created read/write mutex 0xaee08ff0
0:01.725 Pool:0xaedffb40 SIP Transaction created.
0:01.725 Pool:0xaedffb40 PWLib File handle high water mark set: 29 PUDPSocket
0:01.726 Opal Liste...0xaef6ab40 Opal Deleted transport udp$69.67.37.174:5060<if=udp$192.168.2.4:5060>
0:01.726 Opal Liste...0xaef6ab40 PTLib Destroying read/write mutex 0xaec06688
0:01.727 Pool:0xaedffb40 SIP Transaction remembering interface "192.168.2.4%wlan0"
0:01.727 Pool:0xaedffb40 DNS SRV Lookup "_sip._udp.my_sip_server"
0:01.727 Pool:0xaedffb40 SIP No SRV record found.
0:01.727 Pool:0xaedffb40 SIP Transaction remote address is udp$my_sip_server:5060
0:01.728 Pool:0xaedffb40 SIP Sending PDU (591 bytes) to: rem=udp$69.67.37.174:5060,local=udp$192.168.2.4:5060,if=192.168.2.4%wlan0
REGISTER sip:my_sip_server SIP/2.0
CSeq: 2 REGISTER
Via: SIP/2.0/UDP 192.168.2.4:5060;branch=z9hG4bKcc37eee5-340c-e511-9cc5-001b771417a4;rport
User-Agent: sipcmd/1.0.1
From: sip:006@my_sip_server;tag=0037f8e4-340c-e511-9cc5-001b771417a4
Call-ID: f023f8e4-340c-e511-9cc5-001b771417a4@laptop
Organization: Command line VoIP testphone
To: sip:006@my_sip_server
Contact: sip:006@192.168.2.4:5060;q=1;received=sip:41.150.68.250:5060
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK
Expires: 0
Content-Length: 0
Max-Forwards: 70

0:01.728 Pool:0xaedffb40 OpalUDP Setting interface to 192.168.2.4%wlan0
0:01.729 Pool:0xaedffb40 SIP Transaction timers set: retry=10.000, completion=16.000
0:01.729 Pool:0xaedffb40 SIP REGISTER transaction id=z9hG4bK980fc8e5-340c-e511-9cc5-001b771417a4 completed.
0:01.729 Pool:0xaedffb40 SIP Handled PDU "1 REGISTER <200>"
0:01.729 Pool:0xaedffb40 PTLib Destroying read/write mutex 0xaec06bc0
0:02.081 Opal Liste...0xaef6ab40 PTLib Created read/write mutex 0xaec06688
0:02.081 Opal Liste...0xaef6ab40 OpalUDP Binding to interface: 192.168.2.4:5060
0:02.081 Opal Liste...0xaef6ab40 PTLib Created read/write mutex 0xaec06908
0:02.081 Opal Liste...0xaef6ab40 SIP Waiting for PDU on udp$69.67.37.174:5060<if=udp$192.168.2.4:5060>
0:02.081 Opal Liste...0xaef6ab40 SIP PDU received: rem=udp$69.67.37.174:5060,local=udp$192.168.2.4:5060,if=192.168.2.4%wlan0
SIP/2.0 200 OK
CSeq: 2 REGISTER
Via: SIP/2.0/UDP 192.168.2.4:5060;branch=z9hG4bKcc37eee5-340c-e511-9cc5-001b771417a4;rport=5060;received=41.150.68.250
Server: kamailio (4.2.4 (i386/linux))
From: sip:006@my_sip_server;tag=0037f8e4-340c-e511-9cc5-001b771417a4
Call-ID: f023f8e4-340c-e511-9cc5-001b771417a4@laptop
To: sip:006@my_sip_server;tag=b2dcd027eebfd7171a5de8605fda5c47.9bdf
Content-Length: 0

0:02.082 Opal Liste...0xaef6ab40 SIP Queueing PDU "2 REGISTER <200>", transaction=z9hG4bKcc37eee5-340c-e511-9cc5-001b771417a4, token=f023f8e4-340c-e511-9cc5-001b771417a4@laptop
0:02.082 Opal Liste...0xaef6ab40 Opal Transport clean up on termination
0:02.082 Opal Liste...0xaef6ab40 Opal Transport Close
0:02.082 Pool:0xaedffb40 SIP Handling PDU "2 REGISTER <200>" for transaction=z9hG4bKcc37eee5-340c-e511-9cc5-001b771417a4
0:02.082 Pool:0xaedffb40 SIP REGISTER transaction id=z9hG4bKcc37eee5-340c-e511-9cc5-001b771417a4 completing.
0:02.082 Pool:0xaedffb40 SIP Finalising handlers interface "192.168.2.4%wlan0"
0:02.082 Pool:0xaedffb40 OpalUDP Setting interface to 192.168.2.4%wlan0
0:02.082 Opal Liste...0xaef6ab40 Opal Deleted transport udp$69.67.37.174:5060<if=udp$192.168.2.4:5060>
0:02.082 Opal Liste...0xaef6ab40 PTLib Destroying read/write mutex 0xaec06688
0:02.082 Pool:0xaedffb40 SIP Product Info: name="kamailio", version="", vendor="", comments="(4.2.4 (i386/linux))"
0:02.083 Pool:0xaedffb40 SIP Re-registering NAT address change (sip:006@192.168.2.4:5060;q=1;received=sip:41.150.68.250:5060) to udp$41.150.68.250:5060
0:02.083 Pool:0xaedffb40 SIP Expiry time for REGISTER set to 3600 seconds.
0:02.083 Pool:0xaedffb40 PTLib Created read/write mutex 0xaee0a398
0:02.083 Pool:0xaedffb40 SIP Transaction created.
0:02.084 Pool:0xaedffb40 SIP Transaction remembering interface "192.168.2.4%wlan0"
0:02.084 Pool:0xaedffb40 DNS SRV Lookup "_sip._udp.my_sip_server"
0:02.084 Pool:0xaedffb40 SIP No SRV record found.
0:02.084 Pool:0xaedffb40 SIP Transaction remote address is udp$my_sip_server:5060
0:02.085 Pool:0xaedffb40 SIP Sending PDU (596 bytes) to: rem=udp$69.67.37.174:5060,local=udp$192.168.2.4:5060,if=192.168.2.4%wlan0
REGISTER sip:my_sip_server SIP/2.0
CSeq: 3 REGISTER
Via: SIP/2.0/UDP 192.168.2.4:5060;branch=z9hG4bKa8de24e6-340c-e511-9cc5-001b771417a4;rport
User-Agent: sipcmd/1.0.1
From: sip:006@my_sip_server;tag=0037f8e4-340c-e511-9cc5-001b771417a4
Call-ID: f023f8e4-340c-e511-9cc5-001b771417a4@laptop
Organization: Command line VoIP testphone
To: sip:006@my_sip_server
Contact: sip:006@41.150.68.250:5060;q=1;received=sip:41.150.68.250:5060
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK
Expires: 3600
Content-Length: 0
Max-Forwards: 70

0:02.085 Pool:0xaedffb40 OpalUDP Setting interface to 192.168.2.4%wlan0
0:02.085 Pool:0xaedffb40 SIP Transaction timers set: retry=10.000, completion=16.000
0:02.085 Pool:0xaedffb40 SIP REGISTER transaction id=z9hG4bKcc37eee5-340c-e511-9cc5-001b771417a4 completed.
0:02.085 Pool:0xaedffb40 SIP Handled PDU "2 REGISTER <200>"
0:02.085 Pool:0xaedffb40 PTLib Destroying read/write mutex 0xaec06908
0:02.401 Opal Liste...0xaef6ab40 PTLib Created read/write mutex 0xaec06688
0:02.401 Opal Liste...0xaef6ab40 OpalUDP Binding to interface: 192.168.2.4:5060
0:02.401 Opal Liste...0xaef6ab40 PTLib Created read/write mutex 0xaec06b20
0:02.402 Opal Liste...0xaef6ab40 SIP Waiting for PDU on udp$69.67.37.174:5060<if=udp$192.168.2.4:5060>
0:02.402 Opal Liste...0xaef6ab40 SIP PDU received: rem=udp$69.67.37.174:5060,local=udp$192.168.2.4:5060,if=192.168.2.4%wlan0
SIP/2.0 200 OK
CSeq: 3 REGISTER
Via: SIP/2.0/UDP 192.168.2.4:5060;branch=z9hG4bKa8de24e6-340c-e511-9cc5-001b771417a4;rport=5060;received=41.150.68.250
Server: kamailio (4.2.4 (i386/linux))
From: sip:006@my_sip_server;tag=0037f8e4-340c-e511-9cc5-001b771417a4
Call-ID: f023f8e4-340c-e511-9cc5-001b771417a4@laptop
To: sip:006@my_sip_server;tag=b2dcd027eebfd7171a5de8605fda5c47.84f3
Contact: sip:006@41.150.68.250:5060;q=1;expires=3600;received="sip:41.150.68.250:5060"
Content-Length: 0

0:02.403 Opal Liste...0xaef6ab40 SIP Queueing PDU "3 REGISTER <200>", transaction=z9hG4bKa8de24e6-340c-e511-9cc5-001b771417a4, token=f023f8e4-340c-e511-9cc5-001b771417a4@laptop
0:02.403 Opal Liste...0xaef6ab40 Opal Transport clean up on termination
0:02.403 Opal Liste...0xaef6ab40 Opal Transport Close
0:02.403 Pool:0xaedffb40 SIP Handling PDU "3 REGISTER <200>" for transaction=z9hG4bKa8de24e6-340c-e511-9cc5-001b771417a4
0:02.403 Opal Liste...0xaef6ab40 Opal Deleted transport udp$69.67.37.174:5060<if=udp$192.168.2.4:5060>
0:02.403 Opal Liste...0xaef6ab40 PTLib Destroying read/write mutex 0xaec06688
0:02.404 Pool:0xaedffb40 SIP REGISTER transaction id=z9hG4bKa8de24e6-340c-e511-9cc5-001b771417a4 completing.
0:02.404 Pool:0xaedffb40 SIP Finalising handlers interface "192.168.2.4%wlan0"
0:02.404 Pool:0xaedffb40 OpalUDP Setting interface to 192.168.2.4%wlan0
0:02.404 Pool:0xaedffb40 SIP Product Info: name="kamailio", version="", vendor="", comments="(4.2.4 (i386/linux))"
0:02.405 Pool:0xaedffb40 SIP Expiry time for REGISTER set to 3600 seconds.
0:02.405 Pool:0xaedffb40 SIP Changing REGISTER handler from Refreshing to Subscribed, target=sip:006@my_sip_server, id=f023f8e4-340c-e511-9cc5-001b771417a4@laptop
0:02.405 Pool:0xaedffb40 SIP REGISTER transaction id=z9hG4bKa8de24e6-340c-e511-9cc5-001b771417a4 completed.
0:02.406 Pool:0xaedffb40 SIP Handled PDU "3 REGISTER <200>"
0:02.406 Pool:0xaedffb40 PTLib Destroying read/write mutex 0xaec06b20
0:06.729 Housekeeper:0xaefabb40 SIP Set state Terminated_Success for REGISTER transaction id=z9hG4bK980fc8e5-340c-e511-9cc5-001b771417a4
0:06.729 Housekeeper:0xaefabb40 SIP Completed state for transaction id=z9hG4bK980fc8e5-340c-e511-9cc5-001b771417a4
0:07.085 Housekeeper:0xaefabb40 SIP Set state Terminated_Success for REGISTER transaction id=z9hG4bKcc37eee5-340c-e511-9cc5-001b771417a4
0:07.085 Housekeeper:0xaefabb40 SIP Completed state for transaction id=z9hG4bKcc37eee5-340c-e511-9cc5-001b771417a4
0:07.110 Opal Garbage:0xaf02db40 SIP Transaction id=z9hG4bK980fc8e5-340c-e511-9cc5-001b771417a4 destroyed.
0:07.110 Opal Garbage:0xaf02db40 PTLib Destroying read/write mutex 0x9bf6630
0:07.110 Opal Garbage:0xaf02db40 SIP Transaction id=z9hG4bKcc37eee5-340c-e511-9cc5-001b771417a4 destroyed.
0:07.111 Opal Garbage:0xaf02db40 PTLib Destroying read/write mutex 0xaee08ff0
0:07.406 Housekeeper:0xaefabb40 SIP Set state Terminated_Success for REGISTER transaction id=z9hG4bKa8de24e6-340c-e511-9cc5-001b771417a4
0:07.406 Housekeeper:0xaefabb40 SIP Completed state for transaction id=z9hG4bKa8de24e6-340c-e511-9cc5-001b771417a4
0:08.111 Opal Garbage:0xaf02db40 SIP Transaction id=z9hG4bKa8de24e6-340c-e511-9cc5-001b771417a4 destroyed.
0:08.111 Opal Garbage:0xaf02db40 PTLib Destroying read/write mutex 0xaee0a398
0:11.537 Housekeeper:0xaefabb40 SIP INVITE transaction id=z9hG4bK38f7cce5-340c-e511-9cc5-001b771417a4 timeout, making retry 1, timeout 20.000, state 1
0:11.537 Housekeeper:0xaefabb40 OpalUDP Setting interface to 192.168.2.4%wlan0
0:11.537 Housekeeper:0xaefabb40 SIP Set new interface 192.168.2.4%wlan0 for transport udp$69.67.37.174:5060<if=udp$192.168.2.4:5060>
0:11.538 Housekeeper:0xaefabb40 SIP PDU is too large (2295 bytes) trying compact form.
0:11.539 Housekeeper:0xaefabb40 SIP PDU is likely too large (2245 bytes) for UDP datagram.
0:11.539 Housekeeper:0xaefabb40 SIP Sending PDU (2245 bytes) to: rem=udp$69.67.37.174:5060,local=udp$192.168.2.4:5060,if=192.168.2.4%wlan0
INVITE sip:005@my_sip_server SIP/2.0
CSeq: 1 INVITE
v: SIP/2.0/UDP 192.168.2.4:5060;branch=z9hG4bK38f7cce5-340c-e511-9cc5-001b771417a4;rport
User-Agent: sipcmd/1.0.1
f: "frix" sip:006@my_sip_server;tag=dc1ac9e5-340c-e511-9cc5-001b771417a4
i: 0c27c9e5-340c-e511-9cc5-001b771417a4@laptop
k: 100rel,replaces
Organization: Command line VoIP testphone
t: sip:005@my_sip_server
m: "frix" sip:006@my_sip_server@192.168.2.4
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK
l: 1663
c: application/sdp
Max-Forwards: 70

v=0
o=- 1433758503 1 IN IP4 192.168.2.4
s=sipcmd/1.0.1
c=IN IP4 192.168.2.4
t=0 0
m=audio 5000 RTP/AVP 123 115 120 3 116 117 118 119 0 8 9 112 113 125 110 111 124 109 101 100
a=sendrecv
a=rtpmap:123 AMR-WB/16000/1
a=fmtp:123 octet-align=1
a=rtpmap:115 AMR/8000/1
a=rtpmap:120 iLBC/8000/1
a=fmtp:120 mode=20
a=rtpmap:3 gsm/8000/1
a=rtpmap:116 G726-40/8000/1
a=rtpmap:117 G726-32/8000/1
a=rtpmap:118 G726-24/8000/1
a=rtpmap:119 G726-16/8000/1
a=rtpmap:0 PCMU/8000/1
a=rtpmap:8 PCMA/8000/1
a=rtpmap:9 G722/8000/1
a=rtpmap:112 G7221/16000/1
a=fmtp:112 bitrate=24000
a=rtpmap:113 G7221/16000/1
a=fmtp:113 bitrate=32000
a=rtpmap:125 SILK/16000/1
a=rtpmap:110 Speex/16000/1
a=rtpmap:111 lpc10/8000/1
a=rtpmap:124 SILK/8000/1
a=rtpmap:109 Speex/8000/1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16,32,36
a=rtpmap:100 NSE/8000
a=fmtp:100 192-193
a=maxptime:30
m=video 5002 RTP/AVP 94 93 89 34 92 31 97 126
b=AS:240000
b=TIAS:240000000
a=sendrecv
a=rtpmap:94 H264/90000
a=fmtp:94 packetization-mode=1;max-br=240000;max-fs=6336;max-mbps=380160;profile-level-id=42801e
a=rtpmap:93 H264/90000
a=fmtp:93 max-br=240000;max-fs=6336;max-mbps=380160;profile-level-id=42801e
a=rtpmap:89 MP4V-ES/90000
a=fmtp:89 profile-level-id=5
a=rtpmap:34 H263/90000
a=fmtp:34 F=1;CIF=1;CIF16=1;CIF4=1;maxbr=3276;QCIF=1;SQCIF=1
a=rtpmap:92 H263-1998/90000
a=fmtp:92 D=1;F=1;I=1;J=1;CIF=1;CIF4=1;maxbr=3276;QCIF=1;SQCIF=1
a=rtpmap:31 h261/90000
a=fmtp:31 CIF=1;QCIF=1
a=rtpmap:97 raw/90000
a=fmtp:97 rate=90000;height=288;width=352;colorimetry=BT601-5;depth=8;sampling=YCbCr-4:2:0
a=rtpmap:126 theora/90000
a=fmtp:126 height=576;width=704

0:11.541 Housekeeper:0xaefabb40 OpalUDP Setting interface to
0:11.756 sipcmd OpalMan Clearing all calls and waiting, primary thread.
0:11.756 sipcmd Call Clearing Call[Cf70ec4881] reason=EndedByLocalUser
0:11.984 sipcmd OpalCon SetPhase from SetUpPhase to ReleasingPhase for Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:11.984 sipcmd OpalCon Call end reason for Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4] set to EndedByLocalUser
0:11.984 sipcmd OpalCon Releasing asynchronously Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:11.984 sipcmd PWLib File handle high water mark set: 30 Thread unblock pipe
0:11.984 sipcmd PTLib Created thread 0x9bf6ce0 OnRelease
0:11.984 sipcmd PTLib Thread high water mark set: 7
0:11.984 OnRelease:0xaedbeb40 PTLib Started thread 0x9bf6ce0 (11116) OnRelease:0xaedbeb40
0:11.984 OnRelease:0xaedbeb40 SIP OnReleased: Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:11.984 OnRelease:0xaedbeb40 SIP Cancelling 1 transactions.
0:11.984 OnRelease:0xaedbeb40 SIP Attempting to abort INVITE transaction id=z9hG4bK38f7cce5-340c-e511-9cc5-001b771417a4
0:11.984 OnRelease:0xaedbeb40 SIP Set state Terminated_Aborted for INVITE transaction id=z9hG4bK38f7cce5-340c-e511-9cc5-001b771417a4
0:11.984 OnRelease:0xaedbeb40 SIP Transaction 1 INVITE sip:005@my_sip_server failed, unknown handler, ID: 0c27c9e5-340c-e511-9cc5-001b771417a4@laptop
0:11.984 OnRelease:0xaedbeb40 SIP OnTransactionFailed for transaction id=z9hG4bK38f7cce5-340c-e511-9cc5-001b771417a4
0:11.985 OnRelease:0xaedbeb40 SIP Completed state for transaction id=z9hG4bK38f7cce5-340c-e511-9cc5-001b771417a4
0:11.985 OnRelease:0xaedbeb40 OpalCon OnReleased Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:11.985 OnRelease:0xaedbeb40 OpalCon Media streams closed.
0:11.985 OnRelease:0xaedbeb40 OpalEP OnReleased Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:11.985 OnRelease:0xaedbeb40 OpalMan OnReleased Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:11.985 OnRelease:0xaedbeb40 Call OnReleased Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:11.985 OnRelease:0xaedbeb40 OpalCon SetPhase from SetUpPhase to ReleasingPhase for Call[Cf70ec4881]-EP[L69a179432]
0:11.985 OnRelease:0xaedbeb40 OpalCon Call end reason for Call[Cf70ec4881]-EP[L69a179432] set to EndedByLocalUser
0:11.985 OnRelease:0xaedbeb40 OpalCon Releasing synchronously Call[Cf70ec4881]-EP[L69a179432]
0:11.985 OnRelease:0xaedbeb40 OpalCon OnReleased Call[Cf70ec4881]-EP[L69a179432]
0:11.985 OnRelease:0xaedbeb40 OpalCon Media streams closed.
0:11.985 OnRelease:0xaedbeb40 OpalEP OnReleased Call[Cf70ec4881]-EP[L69a179432]
0:11.986 OnRelease:0xaedbeb40 OpalMan OnReleased Call[Cf70ec4881]-EP[L69a179432]
0:11.986 OnRelease:0xaedbeb40 Call OnReleased Call[Cf70ec4881]-EP[L69a179432]
0:11.986 OnRelease:0xaedbeb40 OpalCon SetPhase from ReleasingPhase to ReleasedPhase for Call[Cf70ec4881]-EP[L69a179432]
0:11.986 OnRelease:0xaedbeb40 OpalCon Connection Call[Cf70ec4881]-EP[L69a179432] released
Initial Time: Mon, 08 Jun 2015 12:15:03 +02:00
SetUpPhase: 0.000
ProceedingPhase: N/A
AlertingPhase: N/A
ConnectedPhase: N/A
EstablishedPhase: N/A
ForwardingPhase: N/A
ReleasingPhase: 10.504
ReleasedPhase: 10.505
Call end reason: EndedByLocalUser

0:11.986 OnRelease:0xaedbeb40 OpalCon SetPhase from ReleasingPhase to ReleasedPhase for Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:11.986 OnRelease:0xaedbeb40 OpalCon Connection Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4] released
Initial Time: Mon, 08 Jun 2015 12:15:03 +02:00
SetUpPhase: 0.053
ProceedingPhase: N/A
AlertingPhase: N/A
ConnectedPhase: N/A
EstablishedPhase: N/A
ForwardingPhase: N/A
ReleasingPhase: 10.501
ReleasedPhase: 10.503
Call end reason: EndedByLocalUser

0:11.986 OnRelease:0xaedbeb40 OpalCon OnRelease thread completed for Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:11.986 OnRelease:0xaedbeb40 PWLib File handle high water mark set: 31 PTextFile
0:11.986 OnRelease:0xaedbeb40 PTLib Thread ended: name="OnRelease:0xaedbeb40", real=0.002, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
0:12.085 Housekeeper:0xaefabb40 PTLib Destroyed thread 0x9bf6ce0 OnRelease:0xaedbeb40(id = 0)
0:12.113 Opal Garbage:0xaf02db40 LocalCon Deleted connection.
0:12.113 Opal Garbage:0xaf02db40 OpalCon Connection Call[Cf70ec4881]-EP[L69a179432] destroyed.
0:12.113 Opal Garbage:0xaf02db40 PTLib Destroying read/write mutex 0x9bf7d30
0:13.113 Opal Garbage:0xaf02db40 RTP Deleting session 1
0:13.114 Opal Garbage:0xaf02db40 RTPEp Session 1, forgetting local RTP port 5000 on connection Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:13.114 Opal Garbage:0xaf02db40 RTP_UDP Session 1, Shutting down read.
0:13.114 Opal Garbage:0xaf02db40 RTP_UDP Session 1, shutting down write.
0:13.114 Opal Garbage:0xaf02db40 RTP Deleting session 2
0:13.115 Opal Garbage:0xaf02db40 RTPEp Session 2, forgetting local RTP port 5002 on connection Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4]
0:13.115 Opal Garbage:0xaf02db40 RTP_UDP Session 2, Shutting down read.
0:13.115 Opal Garbage:0xaf02db40 RTP_UDP Session 2, shutting down write.
0:13.115 Opal Garbage:0xaf02db40 SIP Transaction id=z9hG4bK38f7cce5-340c-e511-9cc5-001b771417a4 destroyed.
0:13.117 Opal Garbage:0xaf02db40 PTLib Destroying read/write mutex 0x9c058a0
0:13.117 Opal Garbage:0xaf02db40 SIP Deleting connection.
0:13.117 Opal Garbage:0xaf02db40 SIP Setting new transport for destination ""
0:13.117 Opal Garbage:0xaf02db40 Opal Transport clean up on termination
0:13.117 Opal Garbage:0xaf02db40 Opal Transport Close
0:13.117 Opal Garbage:0xaf02db40 Opal Transport clean up on termination
0:13.117 Opal Garbage:0xaf02db40 Opal Transport Close
0:13.118 Opal Garbage:0xaf02db40 PWLib File handle low water mark set: 23 PUDPSocket
0:13.118 Opal Garbage:0xaf02db40 Opal Deleted transport udp$69.67.37.174:5060<if=udp$*:5060>
0:13.118 Opal Garbage:0xaf02db40 PTLib Destroying read/write mutex 0x9bfdad8
0:13.119 Opal Garbage:0xaf02db40 OpalCon Connection Call[Cf70ec4881]-EP[dc1ac9e5-340c-e511-9cc5-001b771417a4] destroyed.
0:13.120 Opal Garbage:0xaf02db40 PTLib Destroying read/write mutex 0x9bfbc38
0:14.120 Opal Garbage:0xaf02db40 Call Destroyed Call[Cf70ec4881]
0:14.120 Opal Garbage:0xaf02db40 PTLib Destroying read/write mutex 0x9bf78d8
0:14.121 sipcmd OpalMan All calls cleared.
0:14.121 sipcmd OpalMan Shutting down endpoints.
0:14.121 sipcmd OpalMan Clearing all calls and waiting, primary thread.
0:15.121 sipcmd OpalMan All calls cleared.
0:15.121 sipcmd SIP Shutting down.
0:15.121 sipcmd SIP Changing REGISTER handler from Subscribed to Unsubscribing, target=sip:006@my_sip_server, id=f023f8e4-340c-e511-9cc5-001b771417a4@laptop
0:15.121 sipcmd PTLib Created read/write mutex 0x9c05840
0:15.121 sipcmd SIP Transaction created.
0:15.123 sipcmd SIP Transaction remembering interface "192.168.2.4%wlan0"
0:15.123 sipcmd DNS SRV Lookup "_sip._udp.my_sip_server"
0:15.124 sipcmd SIP No SRV record found.
0:15.124 sipcmd SIP Transaction remote address is udp$my_sip_server:5060
0:15.124 sipcmd SIP Sending PDU (593 bytes) to: rem=udp$69.67.37.174:5060,local=udp$192.168.2.4:5060,if=192.168.2.4%wlan0
REGISTER sip:my_sip_server SIP/2.0
CSeq: 4 REGISTER
Via: SIP/2.0/UDP 192.168.2.4:5060;branch=z9hG4bKbc5ceaed-340c-e511-9cc5-001b771417a4;rport
User-Agent: sipcmd/1.0.1
From: sip:006@my_sip_server;tag=0037f8e4-340c-e511-9cc5-001b771417a4
Call-ID: f023f8e4-340c-e511-9cc5-001b771417a4@laptop
Organization: Command line VoIP testphone
To: sip:006@my_sip_server
Contact: sip:006@41.150.68.250:5060;q=1;received=sip:41.150.68.250:5060
Allow: INVITE,ACK,OPTIONS,BYE,CANCEL,SUBSCRIBE,NOTIFY,REFER,MESSAGE,INFO,PING,PRACK
Expires: 0
Content-Length: 0
Max-Forwards: 70

0:15.125 sipcmd OpalUDP Setting interface to 192.168.2.4%wlan0
0:15.126 sipcmd SIP Transaction timers set: retry=9.999, completion=16.000
0:15.360 Opal Liste...0xaef6ab40 PTLib Created read/write mutex 0xaec06688
0:15.360 Opal Liste...0xaef6ab40 OpalUDP Binding to interface: 192.168.2.4:5060
0:15.361 Opal Liste...0xaef6ab40 PTLib Created read/write mutex 0xaec06b20
0:15.361 Opal Liste...0xaef6ab40 SIP Waiting for PDU on udp$69.67.37.174:5060<if=udp$192.168.2.4:5060>
0:15.361 Opal Liste...0xaef6ab40 SIP PDU received: rem=udp$69.67.37.174:5060,local=udp$192.168.2.4:5060,if=192.168.2.4%wlan0
SIP/2.0 200 OK
CSeq: 4 REGISTER
Via: SIP/2.0/UDP 192.168.2.4:5060;branch=z9hG4bKbc5ceaed-340c-e511-9cc5-001b771417a4;rport=5060;received=41.150.68.250
Server: kamailio (4.2.4 (i386/linux))
From: sip:006@my_sip_server;tag=0037f8e4-340c-e511-9cc5-001b771417a4
Call-ID: f023f8e4-340c-e511-9cc5-001b771417a4@laptop
To: sip:006@my_sip_server;tag=b2dcd027eebfd7171a5de8605fda5c47.2a2a
Content-Length: 0

0:15.362 Opal Liste...0xaef6ab40 SIP Queueing PDU "4 REGISTER <200>", transaction=z9hG4bKbc5ceaed-340c-e511-9cc5-001b771417a4, token=f023f8e4-340c-e511-9cc5-001b771417a4@laptop
0:15.362 Opal Liste...0xaef6ab40 Opal Transport clean up on termination
0:15.362 Opal Liste...0xaef6ab40 Opal Transport Close
0:15.362 Pool:0xaedffb40 SIP Handling PDU "4 REGISTER <200>" for transaction=z9hG4bKbc5ceaed-340c-e511-9cc5-001b771417a4
0:15.363 Pool:0xaedffb40 SIP REGISTER transaction id=z9hG4bKbc5ceaed-340c-e511-9cc5-001b771417a4 completing.
0:15.363 Pool:0xaedffb40 SIP Finalising handlers interface "192.168.2.4%wlan0"
0:15.363 Pool:0xaedffb40 OpalUDP Setting interface to 192.168.2.4%wlan0
0:15.363 Pool:0xaedffb40 SIP Changing REGISTER handler from Unsubscribing to Unsubscribed, target=sip:006@my_sip_server, id=f023f8e4-340c-e511-9cc5-001b771417a4@laptop
0:15.363 Pool:0xaedffb40 SIP REGISTER transaction id=z9hG4bKbc5ceaed-340c-e511-9cc5-001b771417a4 completed.
0:15.363 Pool:0xaedffb40 SIP Handled PDU "4 REGISTER <200>"
0:15.363 Pool:0xaedffb40 PTLib Destroying read/write mutex 0xaec06b20
0:15.363 Opal Liste...0xaef6ab40 Opal Deleted transport udp$69.67.37.174:5060<if=udp$192.168.2.4:5060>
0:15.364 Opal Liste...0xaef6ab40 PTLib Destroying read/write mutex 0xaec06688
0:16.121 Opal Garbage:0xaf02db40 Opal Transport clean up on termination
0:16.121 Opal Garbage:0xaf02db40 Opal Transport Close
0:16.121 Opal Garbage:0xaf02db40 Opal Transport clean up on termination
0:16.121 Opal Garbage:0xaf02db40 Opal Transport Close
0:16.122 Opal Garbage:0xaf02db40 Opal Deleted transport udp$69.67.37.174:5060<if=udp$192.168.2.4:5060>
0:16.122 Opal Garbage:0xaf02db40 PTLib Destroying read/write mutex 0x9bf36a8
0:16.122 Opal Garbage:0xaf02db40 SIP Destroyed REGISTER handler for sip:006@my_sip_server
0:16.122 Opal Garbage:0xaf02db40 PTLib Destroying read/write mutex 0x9bf2438
0:20.363 Housekeeper:0xaefabb40 SIP Set state Terminated_Success for REGISTER transaction id=z9hG4bKbc5ceaed-340c-e511-9cc5-001b771417a4
0:20.363 Housekeeper:0xaefabb40 SIP Completed state for transaction id=z9hG4bKbc5ceaed-340c-e511-9cc5-001b771417a4
0:20.437 sipcmd OpalEP sip endpoint shutting down.
0:20.437 sipcmd Listen Stopping listening thread on udp$*:5060
0:20.437 sipcmd MonSock Closed UDP socket 0x9bf0088
0:20.437 Opal Liste...0xaef6ab40 Listen UDP read error.
0:20.438 Opal Liste...0xaef6ab40 PWLib File handle low water mark set: 20 PTextFile
0:20.438 Opal Liste...0xaef6ab40 PTLib Thread ended: name="Opal Listener:0xaef6ab40", real=20.325, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
0:20.458 sipcmd MonSock Deleting UDP socket 0x9bf0088
0:20.458 sipcmd PTLib Destroyed thread 0x9bf0270 Opal Listener:0xaef6ab40(id = aef6ab40)
0:20.458 sipcmd PTLib Destroying read/write mutex 0x9befd10
0:20.458 sipcmd OpalEP local endpoint shutting down.
0:20.458 sipcmd PTLib Destroying read/write mutex 0x9be8288
0:20.458 sipcmd IfaceMon Awaiting thread termination
0:20.459 Network In...0xaefecb40 IfaceMon Finished interface monitor thread.
0:20.459 Network In...0xaefecb40 PWLib File handle low water mark set: 19 PTextFile
0:20.459 Network In...0xaefecb40 PTLib Thread ended: name="Network Interface Monitor:0xaefecb40", real=20.348, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
0:20.459 sipcmd PTLib Destroyed thread 0x9bea3f0 Network Interface Monitor:0xaefecb40(id = aefecb40)
0:20.460 sipcmd PTLib Destroying read/write mutex 0x9be80f0
0:20.460 Pool:0xaedffb40 PWLib File handle low water mark set: 9 PTextFile
0:20.460 Pool:0xaedffb40 PTLib Thread ended: name="Pool:0xaedffb40", real=18.737, kernel=0.000 (0%), user=0.010 (0%), both=0.010 (0%)
0:20.460 sipcmd ThreadPool Destroying pool thread
0:20.460 sipcmd PTLib Destroyed thread 0xaec07158 Pool:0xaedffb40(id = aedffb40)
0:20.461 sipcmd SIP Transaction id=z9hG4bKbc5ceaed-340c-e511-9cc5-001b771417a4 destroyed.
0:20.461 sipcmd PTLib Destroying read/write mutex 0x9c05840
0:20.461 sipcmd OpalEP sip endpoint destroyed.
0:20.462 sipcmd LocalEP Deleted endpoint.
0:20.462 sipcmd OpalEP local endpoint destroyed.
0:20.462 Opal Garbage:0xaf02db40 PTLib Thread ended: name="Opal Garbage:0xaf02db40", real=20.354, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
0:20.472 sipcmd PTLib Destroyed thread 0x9be5700 Opal Garbage:0xaf02db40(id = af02db40)
0:20.473 sipcmd OpalMan Deleted manager.
0:20.473 sipcmd PTLib Destroying read/write mutex 0x9be39e0
0:20.474 sipcmd OpalPlugin Using default handler for plugin codec spandsp_ptplugin
0:20.475 sipcmd OpalPlugin Using default handler for plugin codec speex_ptplugin
0:20.475 sipcmd OpalPlugin Using default handler for plugin codec lpc10_ptplugin
0:20.475 sipcmd OpalPlugin Using default handler for plugin codec ima_adpcm_ptplugin
0:20.475 sipcmd OpalPlugin Using default handler for plugin codec g7221_ptplugin
0:20.475 sipcmd OpalPlugin Using default handler for plugin codec gsm0610_ptplugin
0:20.475 sipcmd OpalPlugin Using default handler for plugin codec gsmamrcodec_ptplugin
0:20.476 sipcmd OpalPlugin Using default handler for plugin codec g726_ptplugin
0:20.476 sipcmd OpalPlugin Using default handler for plugin codec iLBC_ptplugin
0:20.476 sipcmd OpalPlugin Using default handler for plugin codec g722_ptplugin
0:20.476 sipcmd OpalPlugin Using default handler for plugin codec g7222_ptplugin
0:20.476 sipcmd OpalPlugin Using default handler for plugin codec silk_ptplugin
0:20.476 sipcmd OpalPlugin Using default handler for plugin codec theora_ptplugin
0:20.476 sipcmd OpalPlugin Using default handler for plugin codec h264_x264_ptplugin
0:20.477 sipcmd OpalPlugin Using default handler for plugin codec h263_ffmpeg_ptplugin
0:20.477 sipcmd OpalPlugin Using default handler for plugin codec h261_vic_ptplugin
0:20.477 sipcmd OpalPlugin Using default handler for plugin codec mpeg4_ffmpeg_ptplugin
0:20.477 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/video/mpeg4_ffmpeg_ptplugin.so
0:20.477 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/video/h261_vic_ptplugin.so
0:20.477 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/video/h263_ffmpeg_ptplugin.so
0:20.478 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/video/h264_x264_ptplugin.so
0:20.478 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/video/theora_ptplugin.so
0:20.478 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/silk_ptplugin.so
0:20.478 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/g7222_ptplugin.so
0:20.478 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/g722_ptplugin.so
0:20.478 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/iLBC_ptplugin.so
0:20.478 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/g726_ptplugin.so
0:20.478 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/gsmamrcodec_ptplugin.so
0:20.478 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/gsm0610_ptplugin.so
0:20.479 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/g7221_ptplugin.so
0:20.479 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/ima_adpcm_ptplugin.so
0:20.479 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/lpc10_ptplugin.so
0:20.479 sipcmd UDLL Closing /usr/lib/opal-3.10.10/codecs/audio/speex_ptplugin.so
0:20.479 sipcmd UDLL Closing /usr/lib/opal-3.10.10/fax/spandsp_ptplugin.so
0:20.479 sipcmd UDLL Closing /usr/lib/ptlib-2.10.10/devices/sound/oss_pwplugin.so
0:20.479 sipcmd UDLL Closing /usr/lib/ptlib-2.10.10/devices/sound/alsa_pwplugin.so
0:20.479 sipcmd UDLL Closing /usr/lib/ptlib-2.10.10/devices/sound/pulse_pwplugin.so
0:20.479 sipcmd UDLL Closing /usr/lib/ptlib-2.10.10/devices/videoinput/v4l2_pwplugin.so
0:25.125 Housekeeper:0xaefabb40 Housekeeping thread ended
0:25.125 Housekeeper:0xaefabb40 PWLib File handle low water mark set: 6 PTextFile
0:25.126 Housekeeper:0xaefabb40 PTLib Thread ended: name="Housekeeper:0xaefabb40", real=25.015, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
0:25.133 sipcmd PTLib Destroyed thread 0x9bea598 Housekeeper:0xaefabb40(id = aefabb40)
0:25.133 sipcmd PTLib Destroyed PXConfig 0x9c063e0

@pfandfrei pfandfrei mentioned this issue Feb 15, 2017
Merged
@fralbo fralbo mentioned this issue Nov 27, 2018
Open
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
1 participant
@frixhub