[SR-Users] About sdpops

Grégoire Vandendeurpel g.vandendeurpel at gmail.com
Mon Jun 11 16:14:17 CEST 2012


And, when I put the lines about sdpops in comments, everythings is working
well...

2012/6/11 Grégoire Vandendeurpel <g.vandendeurpel at gmail.com>

> Here is the debug mode messages:
> You have to know that I'm recreating the reality on once physical machine
> with different virtual machine.
>
> My network is like that: machine3UDP 172.16.0.12 NAT ---------------
> machine 1, 172.16.0.10 and 192.168.1.9 NAT(kamailio realtime asterisk)
> ----------- machine 2 and 3 (private network)192.168.1.15 and.16 TLS
>
> af8448de310d568e037
> 13(19429) DEBUG: auth [api.c:210]: check_response: Our result =
> '1fa92b49d32418c756adbcef119c0521'
> 13(19429) DEBUG: auth [api.c:217]: check_response: Authorization is OK
> 13(19429) DEBUG: <core> [db_res.c:81]: freeing 1 columns
> 13(19429) DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[0] at 0xb736e5ec
> 13(19429) DEBUG: <core> [db_res.c:94]: freeing result names at 0xb736e584
> 13(19429) DEBUG: <core> [db_res.c:99]: freeing result types at 0xb736e5b8
> 13(19429) DEBUG: <core> [db_res.c:54]: freeing 1 rows
> 13(19429) DEBUG: <core> [db_row.c:97]: freeing row values at 0xb736e65c
> 13(19429) DEBUG: <core> [db_res.c:62]: freeing rows at 0xb736e624
> 13(19429) DEBUG: <core> [db_res.c:136]: freeing result set at 0xb7371bf0
> 13(19429) DEBUG: <core> [socket_info.c:502]: grep_sock_info - checking if
> host==us: 11==11 &&  [192.168.1.9] == [192.168.1.9]
> 13(19429) DEBUG: <core> [socket_info.c:505]: grep_sock_info - checking if
> port 5060 matches port 5060
> 13(19429) DEBUG: usrloc [ucontact.c:805]: exists callback for type=
> UL_CONTACT_UPDATE
> 13(19429) DEBUG: registrar [reply.c:192]: created Contact HF: Contact:
> <sip:102 at 192.168.1.15:5061
> ;transport=TLS;ob>;expires=300;received="sip:192.168.1.15:1158
> ;transport=TLS"
>
> 13(19429) DEBUG: sl [sl.c:278]: reply in stateless mode (sl)
> 13(19429) DEBUG: <core> [msg_translator.c:204]:
> check_via_address(192.168.1.15, 192.168.1.15, 0)
> 13(19429) DEBUG: <core> [tcp_main.c:2284]: tcp_send: send from reader
> (19429 (13)), reusing fd
> 13(19429) DEBUG: <core> [tcp_main.c:2520]: tcp_send: sending...
> 13(19429) DEBUG: <core> [tcp_main.c:2554]: tcp_send: after real write: c=
> 0xb35bc370 n=517 fd=11
> 13(19429) DEBUG: <core> [tcp_main.c:2555]: tcp_send: buf=
>  13(19429) DEBUG: <core> [select.c:424]: Calling SELECT 0xb737c788
> 13(19429) DEBUG: <core> [select.c:424]: Calling SELECT 0xb737ebf4
> 13(19429) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7384bd0
> 13(19429) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7385ef0
> 13(19429) DEBUG: <core> [select.c:424]: Calling SELECT 0xb73872b4
> 13(19429) DEBUG: tm [uac.c:243]: DEBUG:tm:t_uac: next_hop=<sip:
> 192.168.1.9:5080>
> 13(19429) DEBUG: tm [uac.c:182]: DEBUG: dlg2hash: 41917
> 13(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list 0xb35d2388
> 13(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
> 13(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
> 13(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
> 13(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
> 13(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
> 13(19429) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)
> 13(19429) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up
>  4(19415) DEBUG: <core> [parser/msg_parser.c:628]: SIP Request:
>  4(19415) DEBUG: <core> [parser/msg_parser.c:630]:  method:  <PUBLISH>
>  4(19415) DEBUG: <core> [parser/msg_parser.c:632]:  uri:
> <sip:102 at sip.wtz.local>
>  4(19415) DEBUG: <core> [parser/msg_parser.c:634]:  version: <SIP/2.0>
>  4(19415) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 235,
> <rport> = <n/a>; state=6
>  4(19415) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232,
> <branch> = <z9hG4bKPjaaa2cc6202fd4abda385cac59b336e54>; state=16
>  4(19415) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached,
> state=5
>  4(19415) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via
> found, flags=2
>  4(19415) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is
> the first via
>  4(19415) DEBUG: <core> [receive.c:147]: After parse_msg...
>  4(19415) DEBUG: <core> [receive.c:188]: preparing to run routing
> scripts...
>  4(19415) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param:
> tag=78a5897e698d4401a128e4918e9edc0b
>  4(19415) DEBUG: <core> [parser/parse_to.c:801]: end of header reached,
> state=29
>  4(19415) DEBUG: maxfwd [mf_funcs.c:85]: value = 70
>  4(19415) DEBUG: <core> [parser/parse_to.c:801]: end of header reached,
> state=10
>  4(19415) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field:
> <To> [25]; uri=[sip:102 at sip.wtz.local]
>  4(19415) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body
> [<sip:102 at sip.wtz.local>
> ]
>  4(19415) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq
> <CSeq>: <18509> <PUBLISH>
>  4(19415) DEBUG: <core> [parser/msg_parser.c:201]: DEBUG: get_hdr_body :
> content_length=284
>  4(19415) DEBUG: <core> [parser/msg_parser.c:103]: found end of header
>  4(19415) DEBUG: sanity [mod_sanity.c:251]: sanity checks result: 1
>  4(19415) DEBUG: <core> [msg_translator.c:204]:
> check_via_address(192.168.1.15, 192.168.1.15, 0)
>  4(19415) DEBUG: siputils [checks.c:104]: no totag
>  4(19415) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=2 global
> id=1 T start=(nil)
>  4(19415) DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching:
> hash=21215, isACK=0
>  4(19415) DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching
> failed
>  4(19415) DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no
> transaction found
>  4(19415) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=2 global
> id=2 T end=(nil)
>  4(19415) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7376c38
>  4(19415) ERROR: permissions [trusted.c:415]: no connection to database
>  4(19415) DEBUG: <core> [socket_info.c:502]: grep_sock_info - checking if
> host==us: 13==11 &&  [sip.wtz.local] == [192.168.1.9]
>  4(19415) DEBUG: <core> [socket_info.c:505]: grep_sock_info - checking if
> port 5060 matches port 5060
>  4(19415) DEBUG: <core> [socket_info.c:502]: grep_sock_info - checking if
> host==us: 13==11 &&  [sip.wtz.local] == [192.168.1.9]
>  4(19415) DEBUG: <core> [socket_info.c:505]: grep_sock_info - checking if
> port 5061 matches port 5060
>  4(19415) DEBUG: <core> [msg_translator.c:204]:
> check_via_address(192.168.1.15, 192.168.1.15, 0)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)
>  4(19415) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up
>  1(19412) DEBUG: <core> [parser/msg_parser.c:638]: SIP Reply  (status):
>  1(19412) DEBUG: <core> [parser/msg_parser.c:640]:  version: <SIP/2.0>
>  1(19412) DEBUG: <core> [parser/msg_parser.c:642]:  status:  <200>
>  1(19412) DEBUG: <core> [parser/msg_parser.c:644]:  reason:  <OK>
>  1(19412) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232,
> <branch> = <z9hG4bKdb3a.0be1df11.0>; state=6
>  1(19412) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 234,
> <received> = <192.168.1.9>; state=16
>  1(19412) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached,
> state=5
>  1(19412) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via
> found, flags=2
>  1(19412) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is
> the first via
>  1(19412) DEBUG: <core> [receive.c:147]: After parse_msg...
>  1(19412) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=3 global
> id=2 T start=0xffffffff
>  1(19412) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param:
> tag=as699907a5
>  1(19412) DEBUG: <core> [parser/parse_to.c:801]: end of header reached,
> state=29
>  1(19412) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field:
> <To> [36]; uri=[sip:102 at 192.168.1.9]
>  1(19412) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body [
> sip:102 at 192.168.1.9]
>  1(19412) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq
> <CSeq>: <10> <REGISTER>
>  1(19412) DEBUG: tm [t_lookup.c:965]: DEBUG: t_reply_matching: hash 41917
> label 301801136 branch 0
>  1(19412) DEBUG: tm [t_lookup.c:1016]: DEBUG: t_reply_matching: reply
> matched (T=0xb35cfc68)!
>  1(19412) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=3 global
> id=3 T end=0xb35cfc68
>  1(19412) DEBUG: tm [t_reply.c:2053]: DEBUG: reply_received: org. status
> uas=0, uac[0]=0 local=2 is_invite=0)
>  1(19412) DEBUG: tm [t_reply.c:1168]: ->>>>>>>>> T_code=0, new_code=200
>  1(19412) DEBUG: tm [t_reply.c:1931]: DEBUG: local_reply: branch=0,
> save=0, winner=0
>  1(19412) DEBUG: tm [t_reply.c:1968]: DEBUG: local transaction completed
>  1(19412) DEBUG: tm [t_reply.c:1509]: DEBUG: cleanup_uac_timers: RETR/FR
> timers reset
>  1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  1(19412) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)
>  1(19412) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up
>  2(19413) DEBUG: <core> [parser/msg_parser.c:628]: SIP Request:
>  2(19413) DEBUG: <core> [parser/msg_parser.c:630]:  method:  <REGISTER>
>  2(19413) DEBUG: <core> [parser/msg_parser.c:632]:  uri:
> <sip:sip.wtz.local>
>  2(19413) DEBUG: <core> [parser/msg_parser.c:634]:  version: <SIP/2.0>
>  2(19413) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 235,
> <rport> = <n/a>; state=6
>  2(19413) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232,
> <branch> = <z9hG4bKPjb88ef0f513f643c9b9b08ad7dba384aa>; state=16
>  2(19413) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached,
> state=5
>  2(19413) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via
> found, flags=2
>  2(19413) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is
> the first via
>  2(19413) DEBUG: <core> [receive.c:147]: After parse_msg...
>  2(19413) DEBUG: <core> [receive.c:188]: preparing to run routing
> scripts...
>  2(19413) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param:
> tag=27a6e4f8cff94d9ab8a68d58011e5508
>  2(19413) DEBUG: <core> [parser/parse_to.c:801]: end of header reached,
> state=29
>  2(19413) DEBUG: <core> [parser/parse_to.c:801]: end of header reached,
> state=10
>  2(19413) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field:
> <To> [23]; uri=[sip:103 at sip.wtz.nat]
>  2(19413) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body
> [<sip:103 at sip.wtz.nat>
> ]
>  2(19413) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq
> <CSeq>: <45402> <REGISTER>
>  2(19413) DEBUG: <core> [parser/msg_parser.c:201]: DEBUG: get_hdr_body :
> content_length=0
>  2(19413) DEBUG: <core> [parser/msg_parser.c:103]: found end of header
>  2(19413) DEBUG: <core> [parser/sdp/sdp.c:696]: message body has length
> zero
>  2(19413) DEBUG: sdpops [sdpops_mod.c:657]: attempting to search for media
> type: [audio]
>  2(19413) DEBUG: sdpops [sdpops_mod.c:662]: No sdp body
>  2(19413) DEBUG: maxfwd [mf_funcs.c:85]: value = 70
>  2(19413) DEBUG: sanity [mod_sanity.c:251]: sanity checks result: 1
>  2(19413) DEBUG: <core> [msg_translator.c:204]:
> check_via_address(172.16.0.12, 172.16.0.12, 0)
>  2(19413) DEBUG: siputils [checks.c:104]: no totag
>  2(19413) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=3 global
> id=2 T start=0xffffffff
>  2(19413) DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching:
> hash=36220, isACK=0
>  2(19413) DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching
> failed
>  2(19413) DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no
> transaction found
>  2(19413) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=3 global
> id=3 T end=(nil)
>  2(19413) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7376c38
>  2(19413) DEBUG: auth_db [authorize.c:303]: realm value [sip.wtz.nat]
>  2(19413) DEBUG: auth [api.c:85]: auth:pre_auth: Credentials with realm
> 'sip.wtz.nat' not found
>  2(19413) DEBUG: auth_db [authorize.c:177]: no credentials
>  2(19413) DEBUG: auth [challenge.c:102]: build_challenge_hf:
> realm='sip.wtz.nat'
>  2(19413) DEBUG: auth [challenge.c:244]: auth: 'WWW-Authenticate: Digest
> realm="sip.wtz.nat", nonce="T9X59E/V+Mg6xGlySWH+rfOEihqYhssq"
> '
>  2(19413) DEBUG: sl [sl.c:278]: reply in stateless mode (sl)
>  2(19413) DEBUG: <core> [msg_translator.c:204]:
> check_via_address(172.16.0.12, 172.16.0.12, 0)
>  2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list 0xb35d2388
>  2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  2(19413) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)
>  2(19413) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up
>  3(19414) DEBUG: <core> [parser/msg_parser.c:628]: SIP Request:
>  3(19414) DEBUG: <core> [parser/msg_parser.c:630]:  method:  <REGISTER>
>  3(19414) DEBUG: <core> [parser/msg_parser.c:632]:  uri:
> <sip:sip.wtz.local>
>  3(19414) DEBUG: <core> [parser/msg_parser.c:634]:  version: <SIP/2.0>
>  3(19414) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 235,
> <rport> = <n/a>; state=6
>  3(19414) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232,
> <branch> = <z9hG4bKPjec9008971eff4b1fbea5ec76965dfe42>; state=16
>  3(19414) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached,
> state=5
>  3(19414) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via
> found, flags=2
>  3(19414) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is
> the first via
>  3(19414) DEBUG: <core> [receive.c:147]: After parse_msg...
>  3(19414) DEBUG: <core> [receive.c:188]: preparing to run routing
> scripts...
>  3(19414) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param:
> tag=27a6e4f8cff94d9ab8a68d58011e5508
>  3(19414) DEBUG: <core> [parser/parse_to.c:801]: end of header reached,
> state=29
>  3(19414) DEBUG: <core> [parser/parse_to.c:801]: end of header reached,
> state=10
>  3(19414) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field:
> <To> [23]; uri=[sip:103 at sip.wtz.nat]
>  3(19414) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body
> [<sip:103 at sip.wtz.nat>
> ]
>  3(19414) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq
> <CSeq>: <45403> <REGISTER>
>  3(19414) DEBUG: <core> [parser/msg_parser.c:201]: DEBUG: get_hdr_body :
> content_length=0
>  3(19414) DEBUG: <core> [parser/msg_parser.c:103]: found end of header
>  3(19414) DEBUG: <core> [parser/sdp/sdp.c:696]: message body has length
> zero
>  3(19414) DEBUG: sdpops [sdpops_mod.c:657]: attempting to search for media
> type: [audio]
>  3(19414) DEBUG: sdpops [sdpops_mod.c:662]: No sdp body
>  3(19414) DEBUG: maxfwd [mf_funcs.c:85]: value = 70
>  3(19414) DEBUG: sanity [mod_sanity.c:251]: sanity checks result: 1
>  3(19414) DEBUG: <core> [msg_translator.c:204]:
> check_via_address(172.16.0.12, 172.16.0.12, 0)
>  3(19414) DEBUG: siputils [checks.c:104]: no totag
>  3(19414) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=2 global
> id=1 T start=0xffffffff
>  3(19414) DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching:
> hash=36221, isACK=0
>  3(19414) DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching
> failed
>  3(19414) DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no
> transaction found
>  3(19414) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=2 global
> id=2 T end=(nil)
>  3(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7376c38
>  3(19414) DEBUG: auth_db [authorize.c:303]: realm value [sip.wtz.nat]
>  3(19414) DEBUG: auth [api.c:95]: auth: digest-algo:  parsed value: 0
>  3(19414) DEBUG: <core> [db_res.c:118]: allocate 28 bytes for result set
> at 0xb7371ad4
>  3(19414) DEBUG: db_mysql [km_res.c:68]: 1 columns returned from the query
>  3(19414) DEBUG: <core> [db_res.c:155]: allocate 4 bytes for result names
> at 0xb7386114
>  3(19414) DEBUG: <core> [db_res.c:165]: allocate 4 bytes for result types
> at 0xb732be3c
>  3(19414) DEBUG: db_mysql [km_res.c:85]: allocate 8 bytes for RES_NAMES[0]
> at 0xb736e3a0
>  3(19414) DEBUG: db_mysql [km_res.c:92]:
> RES_NAMES(0xb736e3a0)[0]=[sippasswd]
>  3(19414) DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
>  3(19414) DEBUG: <core> [db_res.c:184]: allocate 8 bytes for rows at
> 0xb736e3d8
>  3(19414) DEBUG: <core> [db_row.c:119]: allocate 20 bytes for row values
> at 0xb736e410
>  3(19414) DEBUG: <core> [db_val.c:117]: converting STRING [103]
>  3(19414) DEBUG: auth_db [authorize.c:121]: HA1 string calculated:
> 7c958fe006d9d282b8b1791acd644a9b
>  3(19414) DEBUG: auth [api.c:210]: check_response: Our result =
> 'e76ca7c04e2060cfda3422bd689a3ce6'
>  3(19414) DEBUG: auth [api.c:217]: check_response: Authorization is OK
>  3(19414) DEBUG: <core> [db_res.c:81]: freeing 1 columns
>  3(19414) DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[0] at 0xb736e3a0
>  3(19414) DEBUG: <core> [db_res.c:94]: freeing result names at 0xb7386114
>  3(19414) DEBUG: <core> [db_res.c:99]: freeing result types at 0xb732be3c
>  3(19414) DEBUG: <core> [db_res.c:54]: freeing 1 rows
>  3(19414) DEBUG: <core> [db_row.c:97]: freeing row values at 0xb736e410
>  3(19414) DEBUG: <core> [db_res.c:62]: freeing rows at 0xb736e3d8
>  3(19414) DEBUG: <core> [db_res.c:136]: freeing result set at 0xb7371ad4
>  3(19414) DEBUG: <core> [socket_info.c:502]: grep_sock_info - checking if
> host==us: 13==11 &&  [sip.wtz.local] == [192.168.1.9]
>  3(19414) DEBUG: <core> [socket_info.c:505]: grep_sock_info - checking if
> port 5060 matches port 5060
>  3(19414) DEBUG: <core> [socket_info.c:502]: grep_sock_info - checking if
> host==us: 13==11 &&  [sip.wtz.local] == [192.168.1.9]
>  3(19414) DEBUG: <core> [socket_info.c:505]: grep_sock_info - checking if
> port 5061 matches port 5060
>  3(19414) DEBUG: usrloc [ucontact.c:805]: exists callback for type=
> UL_CONTACT_UPDATE
>  3(19414) DEBUG: registrar [reply.c:192]: created Contact HF: Contact:
> <sip:103 at 172.16.0.12:5060;ob>;expires=300;received="sip:172.16.0.12:5060"
>
>  3(19414) DEBUG: sl [sl.c:278]: reply in stateless mode (sl)
>  3(19414) DEBUG: <core> [msg_translator.c:204]:
> check_via_address(172.16.0.12, 172.16.0.12, 0)
>  3(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb737c788
>  3(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb737ebf4
>  3(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7384bd0
>  3(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7385ef0
>  3(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb73872b4
>  3(19414) DEBUG: tm [uac.c:243]: DEBUG:tm:t_uac: next_hop=<sip:
> 192.168.1.9:5080>
>  3(19414) DEBUG: tm [uac.c:182]: DEBUG: dlg2hash: 27378
>  3(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list 0xb35d2388
>  3(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  3(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  3(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  3(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  3(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  3(19414) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)
>  3(19414) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up
>  4(19415) DEBUG: <core> [parser/msg_parser.c:638]: SIP Reply  (status):
>  4(19415) DEBUG: <core> [parser/msg_parser.c:640]:  version: <SIP/2.0>
>  4(19415) DEBUG: <core> [parser/msg_parser.c:642]:  status:  <200>
>  4(19415) DEBUG: <core> [parser/msg_parser.c:644]:  reason:  <OK>
>  4(19415) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232,
> <branch> = <z9hG4bK2fa6.37c16006.0>; state=6
>  4(19415) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 234,
> <received> = <192.168.1.9>; state=16
>  4(19415) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached,
> state=5
>  4(19415) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via
> found, flags=2
>  4(19415) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is
> the first via
>  4(19415) DEBUG: <core> [receive.c:147]: After parse_msg...
>  4(19415) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=3 global
> id=2 T start=(nil)
>  4(19415) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param:
> tag=as50edab1b
>  4(19415) DEBUG: <core> [parser/parse_to.c:801]: end of header reached,
> state=29
>  4(19415) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field:
> <To> [36]; uri=[sip:103 at 192.168.1.9]
>  4(19415) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body [
> sip:103 at 192.168.1.9]
>  4(19415) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq
> <CSeq>: <10> <REGISTER>
>  4(19415) DEBUG: tm [t_lookup.c:965]: DEBUG: t_reply_matching: hash 27378
> label 1611013235 branch 0
>  4(19415) DEBUG: tm [t_lookup.c:1016]: DEBUG: t_reply_matching: reply
> matched (T=0xb35cfc68)!
>  4(19415) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=3 global
> id=3 T end=0xb35cfc68
>  4(19415) DEBUG: tm [t_reply.c:2053]: DEBUG: reply_received: org. status
> uas=0, uac[0]=0 local=2 is_invite=0)
>  4(19415) DEBUG: tm [t_reply.c:1168]: ->>>>>>>>> T_code=0, new_code=200
>  4(19415) DEBUG: tm [t_reply.c:1931]: DEBUG: local_reply: branch=0,
> save=0, winner=0
>  4(19415) DEBUG: tm [t_reply.c:1968]: DEBUG: local transaction completed
>  4(19415) DEBUG: tm [t_reply.c:1509]: DEBUG: cleanup_uac_timers: RETR/FR
> timers reset
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list:
> destroying list (nil)
>  4(19415) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)
>  4(19415) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up
> 13(19429) DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x82831e0, 11,
> -1, 0x10) fd_no=2 called
> 13(19429) DEBUG: <core> [tcp_read.c:1089]: releasing con 0xb35bc370, state
> 1, fd=11, id=2
> 13(19429) DEBUG: <core> [tcp_read.c:1090]:  extra_data 0xb35b9b50
> 16(19433) DEBUG: <core> [tcp_main.c:3345]: handle_tcp_child: reader
> response= b35bc370, 1 from 1
> 16(19433) DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x8260fa0, 31,
> 2, 0xb35bc370), fd_no=20
> 16(19433) DEBUG: <core> [tcp_main.c:3475]: handle_tcp_child: CONN_RELEASE
>  0xb35bc370 refcnt= 1
>  1(19412) DEBUG: <core> [udp_server.c:498]: udp_rcv_loop: probing packet
> received from 192.168.1.16 50195
>  2(19413) DEBUG: <core> [parser/msg_parser.c:628]: SIP Request:
>  2(19413) DEBUG: <core> [parser/msg_parser.c:630]:  method:  <INVITE>
>  2(19413) DEBUG: <core> [parser/msg_parser.c:632]:  uri:
> <sip:102 at sip.wtz.local>
>  2(19413) DEBUG: <core> [parser/msg_parser.c:634]:  version: <SIP/2.0>
>  2(19413) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 235,
> <rport> = <n/a>; state=6
>  2(19413) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232,
> <branch> = <z9hG4bKPj4ce735389e3f4d8aaa1a4891c1ec15a5>; state=16
>  2(19413) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached,
> state=5
>  2(19413) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via
> found, flags=2
>  2(19413) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is
> the first via
>  2(19413) DEBUG: <core> [receive.c:147]: After parse_msg...
>  2(19413) DEBUG: <core> [receive.c:188]: preparing to run routing
> scripts...
>  2(19413) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param:
> tag=b84abd4ec1314a7aae8acc436dc7e4a3
>  2(19413) DEBUG: <core> [parser/parse_to.c:801]: end of header reached,
> state=29
>  2(19413) DEBUG: <core> [parser/parse_to.c:801]: end of header reached,
> state=10
>  2(19413) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field:
> <To> [25]; uri=[sip:102 at sip.wtz.local]
>  2(19413) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body
> [<sip:102 at sip.wtz.local>
> ]
>  2(19413) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq
> <CSeq>: <11479> <INVITE>
>  2(19413) DEBUG: <core> [parser/msg_parser.c:201]: DEBUG: get_hdr_body :
> content_length=656
>  2(19413) DEBUG: <core> [parser/msg_parser.c:103]: found end of header
>  2(19413) DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:493]: located IP
> address [172.16.0.12] in `o=' field
>  2(19413) DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:493]: located IP
> address [172.16.0.12] in `c=' field
>  2(19413) DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:493]: located IP
> address [172.16.0.12] in `c=' field
>  2(19413) DEBUG: sdpops [sdpops_mod.c:657]: attempting to search for media
> type: [audio]
>  2(19413) DEBUG: sdpops [sdpops_mod.c:679]: stream 0 of 0 - media [audio]
>  2(19413) DEBUG: sdpops [sdpops_mod.c:685]: removing media stream:
> audio16(19433) : <core> [pass_fd.c:293]: ERROR: receive_fd: EOF on 11
> 16(19433) DEBUG: <core> [tcp_main.c:3555]: DBG: handle_ser_child: dead
> child 2, pid 19413 (shutting down?)
> 16(19433) DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x8260fa0, 11,
> -1, 0x0) fd_no=21 called
>  0(19411) ALERT: <core> [main.c:751]: child process 19413 exited by a
> signal 11
>  0(19411) ALERT: <core> [main.c:754]: core was not generated
>  0(19411) INFO: <core> [main.c:766]: INFO: terminating due to SIGCHLD
>  9(19424) INFO: <core> [main.c:817]: INFO: signal 15 received
> 10(19425) INFO: <core> [main.c:817]: INFO: signal 15 received
> 11(19426) INFO: <core> [main.c:817]: INFO: signal 15 received
> 13(19429) INFO: <core> [main.c:817]: INFO: signal 15 received
>  5(19416) INFO: <core> [main.c:817]: INFO: signal 15 received
> 15(19432) INFO: <core> [main.c:817]: INFO: signal 15 received
> 12(19428) INFO: <core> [main.c:817]: INFO: signal 15 received
>  7(19418) INFO: <core> [main.c:817]: INFO: signal 15 received
>  3(19414) INFO: <core> [main.c:817]: INFO: signal 15 received
> 16(19433) INFO: <core> [main.c:817]: INFO: signal 15 received
>  1(19412) INFO: <core> [main.c:817]: INFO: signal 15 received
>  4(19415) INFO: <core> [main.c:817]: INFO: signal 15 received
> 14(19430) INFO: <core> [main.c:817]: INFO: signal 15 received
>  8(19423) INFO: <core> [main.c:817]: INFO: signal 15 received
>  6(19417) INFO: <core> [main.c:817]: INFO: signal 15 received
>  0(19411) ERROR: ctl [ctl.c:379]: ERROR: ctl: could not delete unix socket
> /tmp/kamailio_ctl: Operation not permitted (1)
>  0(19411) DEBUG: <core> [db_pool.c:102]: removing connection from the pool
>  0(19411) DEBUG: tm [t_funcs.c:122]: DEBUG: tm_shutdown : start
>  0(19411) DEBUG: tm [t_funcs.c:125]: DEBUG: tm_shutdown : emptying hash
> table
>  0(19411) DEBUG: tm [t_funcs.c:127]: DEBUG: tm_shutdown : removing
> semaphores
>  0(19411) DEBUG: tm [t_funcs.c:129]: DEBUG: tm_shutdown : destroying tmcb
> lists
>  0(19411) DEBUG: tm [t_funcs.c:132]: DEBUG: tm_shutdown : done
>  0(19411) DEBUG: tls [tls_init.c:674]: tls module final tls destroy
>  0(19411) DEBUG: <core> [mem/shm_mem.c:242]: shm_mem_destroy
>  0(19411) DEBUG: <core> [mem/shm_mem.c:245]: destroying the shared memory
> lock
>  0(19411) DEBUG: <core> [main.c:770]: terminating due to SIGCHLD
>
>
> 2012/6/11 Daniel-Constantin Mierla <miconda at gmail.com>
>
>> Hello,
>>
>>
>> On 6/11/12 3:19 PM, Grégoire Vandendeurpel wrote:
>>
>>> Hello,
>>>
>>> I'm using Kamailio 3.2.3 and SDPOPS module.
>>>
>>> I just have a question about the configuration:
>>>
>>> What do you mean by "ANY_ROUTE" in configuration ??
>>>
>>> Cause I don't know where in the configuration , I have to use the
>>> differents functions of SDPOPS.
>>>
>>> If I do something like this:
>>>
>>> request_route {
>>>
>>> if ($fU == "103") {
>>>        sdp_remove_codecs_by_id("0,3,**8");
>>>       #sdp_remove_media("audio");
>>>
>>> }
>>>
>>> It does not work .
>>>
>>> So please help me about where I have to put this in??
>>>
>>
>> it should work in that route if it's a request with SDP. Can you send the
>> ngrep of such SIP message along with log messages when debug=3 in your
>> config?
>>
>> Cheers,
>> Daniel
>>
>> --
>> Daniel-Constantin Mierla - http://www.asipto.com
>> http://twitter.com/#!/miconda - http://www.linkedin.com/in/**miconda<http://www.linkedin.com/in/miconda>
>> Kamailio Advanced Training, Seattle, USA, Sep 23-26, 2012 -
>> http://asipto.com/u/katu
>> Kamailio Practical Workshop, Netherlands, Sep 10-12, 2012 -
>> http://asipto.com/u/kpw
>>
>>
>>
>>
>
>
> --
> *Grégoire Vandendeurpel, *
> *
> *
> *IT Sector*
>



-- 
*Grégoire Vandendeurpel, *
*
*
*IT Sector*
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20120611/c7afc00e/attachment-0001.htm>


More information about the sr-users mailing list