[SR-Users] segfault when using sipt modifications

david descartin at bts.io
Mon Aug 1 16:08:01 CEST 2016 

Hello Sergey, Daniel

thanks a lot for the guidance.
i changed the x00 by x01 and it works now, i was seeing the ISUP
truncated but i thought it was related to the tshark XD

i will find out about the changes needed at sipt configuration, but just
in case, the things chaged by this only are the forward call indicators,
so i hope that does give us many problems....

i will let you know anything

thanks and best regards
david


El lun, 01-08-2016 a las 12:09 +0200, Daniel-Constantin Mierla escribió:

> Hello,
> 
> I am not familiar with isup and no testbed around at this moment. That's
> why I asked for backtrace from the coredump file, based on the
> guidelines I did in my previous email.
> 
> Cheers,
> Daniel
> 
> 
> On 01/08/16 09:07, Sergey Basov wrote:
> > Hello,
> >
> > try make dump packet after
> > append_body_part("\x01\x12\x49\x00\x0a\x03\x02\x0a\x08\x84\x90\x33\x41\x72\x17\x00\x06\x0a\x08\x04\x13\x93\x70\x21\x73\x23\x10\x08\x01\x00\x00","application/isup;version=itu-t92+","signal;handling=optional");
> > before sipt_destination($rU, 31, 4);
> >
> > when i have done such conversion i found that kamailio from script
> > ignores all string content after symbol \x00 as this is end of line.
> >
> > To avoid this i have replaces \x00 with \x01 in my initial ISUP string
> > and make changes into SIP-T module to replace it with \x00 while
> > processing message. before number/presentation/screening
> > modifications.
> >
> > you have first \x00 as forth symbol in your ISUP string and after it
> > all have to be ignored. Look at dump using wireshark. I think you will
> > see mailformed ISUP incapsulated message.
> >
> > --
> > Best regards,
> > Sergey Basov                     e-mail: sergey.v.basov at gmail.com
> >
> > tel: (+38067) 403-62-54
> >
> >
> > 2016-08-01 8:21 GMT+03:00 Daniel-Constantin Mierla <miconda at gmail.com>:
> >> Hello,
> >>
> >> would be good to get a core dump file and the backtrace from it in order to
> >> see where it crashes.
> >>
> >> For getting the coredump, try:
> >>
> >>  - stop kamailio
> >>
> >>  - do: ulimit -c unlimited
> >>
> >>  - start kamailio as root
> >>
> >>  - reproduce the issue
> >>
> >> A corefile should be generated in / or working directory. Use gdb to grab
> >> the output of 'bt full' from the corefile and send it here to the mailing
> >> list.
> >>
> >> Cheers,
> >> Daniel
> >>
> >>
> >> On 29/07/16 18:21, david wrote:
> >>
> >> hello all
> >>
> >>
> >>
> >> i'm trying to add a ISUP multipart in a regular call using the textops
> >> module, and despite seeing one previous issue int he mail list, i'm finding
> >> some issue here
> >>
> >> i'm using this commands
> >>
> >>     msg_apply_changes();
> >>     set_body_multipart(,"2123894789_1257887457");
> >>     msg_apply_changes();
> >>
> >> append_body_part("\x01\x12\x49\x00\x0a\x03\x02\x0a\x08\x84\x90\x33\x41\x72\x17\x00\x06\x0a\x08\x04\x13\x93\x70\x21\x73\x23\x10\x08\x01\x00\x00","application/isup;version=itu-t92+","signal;handling=optional");
> >>     msg_apply_changes();
> >>     sipt_destination($rU, 31, 4);
> >>     sipt_set_calling($fU, 4, 0, 3);
> >>     msg_apply_changes();
> >>
> >> before the record_route command, and when using sipt_destination($rU, 31,
> >> 4); i'm getting asegfault
> >>
> >> here you have the logs
> >> could you please give me any clue about something i'm missing or doing
> >> wrong?
> >>
> >> thanks  alot and regards
> >> david
> >>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): SIP Request:
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg():  method:
> >> <INVITE>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():  uri:
> >> <sip:34666988297 at 79.170.71.132:5060>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:614]: parse_msg():  version:
> >> <SIP/2.0>
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found
> >> param type 235, <rport> = <n/a>; state=6
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found
> >> param type 232, <branch> = <z9hG4bK7ma5t4FKS0SKa>; state=16
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header
> >> reached, state=5
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
> >> parse_headers: Via found, flags=2
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
> >> parse_headers: this is the first via
> >> 5(24552) DEBUG: <core> [receive.c:178]: receive_msg(): After parse_msg...
> >> 5(24552) DEBUG: <core> [receive.c:221]: receive_msg(): preparing to run
> >> routing scripts...
> >> 5(24552) DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 65
> >> 5(24552) DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec():
> >> end of header reached, state=10
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG:
> >> get_hdr_field: <To> [49];
> >> uri=[sip:34666988297 at 79.170.71.132:5060;user=phone]
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to
> >> body [<sip:34666988297 at 79.170.71.132:5060;user=phone>
> >> ]
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
> >> get_hdr_field: cseq <CSeq>: <94568362> <INVITE>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG:
> >> get_hdr_body : content_length=104
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end
> >> of header
> >> 5(24552) DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param():
> >> DEBUG: add_param: tag=5jBBFae4D90rg
> >> 5(24552) DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec():
> >> end of header reached, state=29
> >> 5(24552) DEBUG: sanity [mod_sanity.c:248]: w_sanity_check(): sanity checks
> >> result: 1
> >> 5(24552) DEBUG: siputils [checks.c:97]: has_totag(): no totag
> >> 5(24552) DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if
> >> host==us: 13==13 && [79.170.71.132] == [79.170.71.132]
> >> 5(24552) DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if
> >> port 5060 (advertise 0) matches port 5060
> >> 5(24552) DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg
> >> id=1 global id=0 T start=0xffffffffffffffff
> >> 5(24552) DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request:
> >> start searching: hash=46859, isACK=0
> >> 5(24552) DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261
> >> transaction matching failed
> >> 5(24552) DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG:
> >> t_lookup_request: no transaction found
> >> 5(24552) DEBUG: tm [t_lookup.c:1080]: t_check_msg(): DEBUG: t_check_msg: msg
> >> id=1 global id=1 T end=(nil)
> >> 5(24552) DEBUG: tm [t_lookup.c:1312]: t_newtran(): DEBUG: t_newtran: msg
> >> id=1 , global msg id=1 , T on entrance=(nil)
> >> 5(24552) DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request:
> >> start searching: hash=46859, isACK=0
> >> 5(24552) DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261
> >> transaction matching failed
> >> 5(24552) DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG:
> >> t_lookup_request: no transaction found
> >> 5(24552) DEBUG: tm [t_hooks.c:358]: run_reqin_callbacks_internal(): DBG:
> >> trans=0x7fb3fb0c64e0, callback type 1, id 0 entered
> >> 5(24552) DEBUG: <core> [md5utils.c:67]: MD5StringArray(): MD5 calculated:
> >> 5ea9736b3bdcf90a4c3043a5a492b31f
> >> 5(24552) DEBUG: <core> [select.c:412]: run_select(): Calling SELECT
> >> 0x7fb404252ef8
> >> 5(24552) INFO: Theseus-Test Call 69672589-67f5-4edd-8844-f6ad2ee5b208 /
> >> Call-ID 69672589-67f5-4edd-8844-f6ad2ee5b208: Call-ID =
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208
> >> 5(24552) DEBUG: app_lua [app_lua_api.c:643]: app_lua_run(): reload
> >> deactivated
> >> 5(24552) DEBUG: app_lua [app_lua_api.c:644]: app_lua_run(): executing Lua
> >> function: [[allow_src_uri]]
> >> 5(24552) DEBUG: app_lua [app_lua_api.c:645]: app_lua_run(): lua top index
> >> is: 4
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:979]: lua_sr_pv_get(): pv get:
> >> $avp(s:call_obj)
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar
> >> [$avp(s:call_obj)] found in cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:979]: lua_sr_pv_get(): pv get: $ci
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar [$ci] found in
> >> cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:1101]: lua_sr_pv_sets(): pv set:
> >> $var(authorized)
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar
> >> [$var(authorized)] found in cache
> >> 5(24552) INFO: Theseus-Test Call 69672589-67f5-4edd-8844-f6ad2ee5b208 /
> >> Call-ID 69672589-67f5-4edd-8844-f6ad2ee5b208: Method INVITE from
> >> 79.170.64.130:5080 authorized
> >> 5(24552) INFO: Theseus-Test Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: Object 58825 assigned to Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208
> >> 5(24552) INFO: Theseus-Test Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: The call has been sent to RG 106406
> >> 5(24552) DEBUG: app_lua [app_lua_api.c:643]: app_lua_run(): reload
> >> deactivated
> >> 5(24552) DEBUG: app_lua [app_lua_api.c:644]: app_lua_run(): executing Lua
> >> function: [[get_rg_info]]
> >> 5(24552) DEBUG: app_lua [app_lua_api.c:645]: app_lua_run(): lua top index
> >> is: 4
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:979]: lua_sr_pv_get(): pv get: $ci
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar [$ci] found in
> >> cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:979]: lua_sr_pv_get(): pv get:
> >> $avp(s:call_obj)
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar
> >> [$avp(s:call_obj)] found in cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:979]: lua_sr_pv_get(): pv get:
> >> $shv(flag_list)
> >> 5(24552) DEBUG: <core> [pvapi.c:293]: pv_cache_add(): pvar [$shv(flag_list)]
> >> added in cache
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG 106406 attributes:
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG OUT 106406 description =
> >> PBX--NOC-TEST
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG OUT 106406 admin_status = 1
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG OUT 106406 cir_direction = 2
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG OUT 106406 ani_posttranslation = 0
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG OUT 106406
> >> ani_posttranslation_table = 0
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG OUT 106406 posttranslation = 1
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG OUT 106406 posttranslation_table =
> >> 106384
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG OUT 106406 pound = 2
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG OUT 106406 gw_port = 5060
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: RG OUT 106406 custom_flags = None
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:1101]: lua_sr_pv_sets(): pv set:
> >> $avp(s:description)
> >> 5(24552) DEBUG: <core> [usr_avp.c:882]: parse_avp_ident(): Parsing
> >> 's:description'
> >> 5(24552) DEBUG: <core> [pvapi.c:293]: pv_cache_add(): pvar
> >> [$avp(s:description)] added in cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:1101]: lua_sr_pv_sets(): pv set:
> >> $avp(s:admin_status)
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar
> >> [$avp(s:admin_status)] found in cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:1101]: lua_sr_pv_sets(): pv set:
> >> $avp(s:cir_direction)
> >> 5(24552) DEBUG: <core> [usr_avp.c:882]: parse_avp_ident(): Parsing
> >> 's:cir_direction'
> >> 5(24552) DEBUG: <core> [pvapi.c:293]: pv_cache_add(): pvar
> >> [$avp(s:cir_direction)] added in cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:1101]: lua_sr_pv_sets(): pv set:
> >> $avp(s:ani_posttranslation_table)
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar
> >> [$avp(s:ani_posttranslation_table)] found in cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:1101]: lua_sr_pv_sets(): pv set:
> >> $avp(s:posttranslation_table)
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar
> >> [$avp(s:posttranslation_table)] found in cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:1101]: lua_sr_pv_sets(): pv set:
> >> $avp(s:pound)
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar
> >> [$avp(s:pound)] found in cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:1101]: lua_sr_pv_sets(): pv set:
> >> $avp(s:gw_ip)
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar
> >> [$avp(s:gw_ip)] found in cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:1101]: lua_sr_pv_sets(): pv set:
> >> $avp(s:gw_port)
> >> 5(24552) DEBUG: <core> [pvapi.c:321]: pv_cache_lookup(): pvar
> >> [$avp(s:gw_port)] found in cache
> >> 5(24552) INFO: app_lua [app_lua_sr.c:96]: lua_sr_log(): Call 58825 / Call-ID
> >> 69672589-67f5-4edd-8844-f6ad2ee5b208: Custom flags = None
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:979]: lua_sr_pv_get(): pv get:
> >> $shv(custom_flag_list)
> >> 5(24552) DEBUG: <core> [pvapi.c:293]: pv_cache_add(): pvar
> >> [$shv(custom_flag_list)] added in cache
> >> 5(24552) DEBUG: app_lua [app_lua_sr.c:979]: lua_sr_pv_get(): pv get:
> >> $shv(custom_flag_list_branch)
> >> 5(24552) DEBUG: <core> [pvapi.c:293]: pv_cache_add(): pvar
> >> [$shv(custom_flag_list_branch)] added in cache
> >> 5(24552) DEBUG: textopsx [textopsx.c:231]: msg_apply_changes_f(): SIP
> >> message content updated - reparsing
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): SIP Request:
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg():  method:
> >> <INVITE>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():  uri:
> >> <sip:34666988297 at 79.170.71.132:5060>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:614]: parse_msg():  version:
> >> <SIP/2.0>
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found
> >> param type 235, <rport> = <n/a>; state=6
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found
> >> param type 232, <branch> = <z9hG4bK7ma5t4FKS0SKa>; state=16
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header
> >> reached, state=5
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
> >> parse_headers: Via found, flags=2
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
> >> parse_headers: this is the first via
> >> 5(24552) DEBUG: textops [textops.c:1577]: set_multibody_helper():
> >> delimiter<21>:[2123894789_1257887457]
> >> 5(24552) DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec():
> >> end of header reached, state=10
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG:
> >> get_hdr_field: <To> [49];
> >> uri=[sip:34666988297 at 79.170.71.132:5060;user=phone]
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to
> >> body [<sip:34666988297 at 79.170.71.132:5060;user=phone>
> >> ]
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
> >> get_hdr_field: cseq <CSeq>: <94568362> <INVITE>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG:
> >> get_hdr_body : content_length=104
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end
> >> of header
> >> 5(24552) DEBUG: textops [textops.c:1486]: generate_boundary(): adding final
> >> CRLF+CRLF
> >> 5(24552) DEBUG: textops [textops.c:1714]: set_multibody_helper():
> >> content-type<48>:[multipart/mixed;boundary="2123894789_1257887457"]
> >> 5(24552) DEBUG: textops [textops.c:1768]: set_multibody_helper(): set flag
> >> FL_BODY_MULTIPART
> >> 5(24552) INFO: <core> [msg_translator.c:1692]: get_boundary(): Content-Type
> >> hdr has no params <application/sdp>
> >> 5(24552) WARNING: <core> [msg_translator.c:1958]:
> >> build_req_buf_from_sip_req(): check_boundaries error
> >> 5(24552) DEBUG: <core> [msg_translator.c:422]: clen_builder():
> >> content-length: 189 (189)
> >> 5(24552) DEBUG: textopsx [textopsx.c:231]: msg_apply_changes_f(): SIP
> >> message content updated - reparsing
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): SIP Request:
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg():  method:
> >> <INVITE>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():  uri:
> >> <sip:34666988297 at 79.170.71.132:5060>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:614]: parse_msg():  version:
> >> <SIP/2.0>
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found
> >> param type 235, <rport> = <n/a>; state=6
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found
> >> param type 232, <branch> = <z9hG4bK7ma5t4FKS0SKa>; state=16
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header
> >> reached, state=5
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
> >> parse_headers: Via found, flags=2
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
> >> parse_headers: this is the first via
> >> 5(24552) ERROR: <core> [lvalue.c:345]: lval_pvar_assign(): non existing
> >> right pvar
> >> 5(24552) ERROR: <core> [lvalue.c:405]: lval_assign(): assignment failed at
> >> pos: (390,18-390,44)
> >> 5(24552) DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec():
> >> end of header reached, state=10
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG:
> >> get_hdr_field: <To> [49];
> >> uri=[sip:34666988297 at 79.170.71.132:5060;user=phone]
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to
> >> body [<sip:34666988297 at 79.170.71.132:5060;user=phone>
> >> ]
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
> >> get_hdr_field: cseq <CSeq>: <94568362> <INVITE>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG:
> >> get_hdr_body : content_length=189
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end
> >> of header
> >> 5(24552) DEBUG: textops [textops.c:1486]: generate_boundary(): adding final
> >> CRLF+CRLF
> >> 5(24552) DEBUG: <core> [msg_translator.c:1719]: get_boundary(): boundary is
> >> <--2123894789_1257887457>
> >> 5(24552) DEBUG: <core> [msg_translator.c:1839]: check_boundaries(): last
> >> bondary without -- at the end
> >> 5(24552) DEBUG: <core> [msg_translator.c:1639]: replace_body(): old size
> >> body[189] actual[319]
> >> 5(24552) DEBUG: <core> [msg_translator.c:422]: clen_builder():
> >> content-length: 319 (319)
> >> 5(24552) DEBUG: textopsx [textopsx.c:231]: msg_apply_changes_f(): SIP
> >> message content updated - reparsing
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): SIP Request:
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:610]: parse_msg():  method:
> >> <INVITE>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():  uri:
> >> <sip:34666988297 at 79.170.71.132:5060>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:614]: parse_msg():  version:
> >> <SIP/2.0>
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found
> >> param type 235, <rport> = <n/a>; state=6
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found
> >> param type 232, <branch> = <z9hG4bK7ma5t4FKS0SKa>; state=16
> >> 5(24552) DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header
> >> reached, state=5
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:496]: parse_headers():
> >> parse_headers: Via found, flags=2
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:498]: parse_headers():
> >> parse_headers: this is the first via
> >> 5(24552) DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec():
> >> end of header reached, state=10
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG:
> >> get_hdr_field: <To> [49];
> >> uri=[sip:34666988297 at 79.170.71.132:5060;user=phone]
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to
> >> body [<sip:34666988297 at 79.170.71.132:5060;user=phone>
> >> ]
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field():
> >> get_hdr_field: cseq <CSeq>: <94568362> <INVITE>
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG:
> >> get_hdr_body : content_length=319
> >> 5(24552) DEBUG: <core> [parser/parse_body.c:87]: get_boundary_param():
> >> boundary is "2123894789_1257887457"
> >> 5(24552) DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end
> >> of header
> >> 5(24552) DEBUG: <core> [parser/parse_body.c:87]: get_boundary_param():
> >> boundary is "2123894789_1257887457"
> >> 5(24552) CRITICAL: <core> [data_lump.c:297]: del_lump(): offset + len
> >> exceeds message size (1176 + 51 > 1201)
> >> 35(24582) CRITICAL: <core> [pass_fd.c:275]: receive_fd(): EOF on 17
> >> 35(24582) DEBUG: <core> [tcp_main.c:3448]: handle_ser_child(): dead child 5,
> >> pid 24552 (shutting down?)
> >> 35(24582) DEBUG: <core> [io_wait.h:598]: io_watch_del(): DBG: io_watch_del
> >> (0xa2ae40, 17, -1, 0x0) fd_no=39 called
> >> 0(24547) ALERT: <core> [main.c:739]: handle_sigs(): child process 24552
> >> exited by a signal 6
> >> 0(24547) ALERT: <core> [main.c:742]: handle_sigs(): core was not generated
> >> 0(24547) INFO: <core> [main.c:754]: handle_sigs(): terminating due to
> >> SIGCHLD
> >> 0(24547) DEBUG: <core> [main.c:756]: handle_sigs(): terminating due to
> >> SIGCHLD
> >> 34(24581) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 33(24580) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 32(24579) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 31(24578) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 30(24577) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 29(24576) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 28(24575) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 27(24574) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 26(24573) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 25(24572) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 24(24571) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 23(24570) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 22(24569) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 21(24568) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 20(24567) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 19(24566) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 18(24565) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 17(24564) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 16(24563) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 15(24562) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 14(24561) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 13(24560) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 12(24559) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 11(24558) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 10(24557) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 9(24556) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 8(24555) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 7(24554) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 6(24553) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 4(24551) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 3(24550) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 2(24549) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 1(24548) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 35(24582) INFO: <core> [main.c:809]: sig_usr(): signal 15 received
> >> 0(24547) DEBUG: rtpengine [rtpengine.c:2014]: mod_destroy():
> >> rtpengine_hash_table_destroy() success!
> >> 0(24547) DEBUG: db_text [dbtext.c:110]: destroy(): destroy ...
> >> 0(24547) DEBUG: tm [t_funcs.c:86]: tm_shutdown(): DEBUG: tm_shutdown : start
> >> 0(24547) DEBUG: tm [t_funcs.c:89]: tm_shutdown(): DEBUG: tm_shutdown :
> >> emptying hash table
> >> 0(24547) DEBUG: tm [h_table.c:127]: free_cell_helper(): freeing transaction
> >> 0x7fb3fb0c64e0 from h_table.c:449
> >> 0(24547) DEBUG: tm [t_funcs.c:91]: tm_shutdown(): DEBUG: tm_shutdown :
> >> removing semaphores
> >> 0(24547) DEBUG: tm [t_funcs.c:93]: tm_shutdown(): DEBUG: tm_shutdown :
> >> destroying tmcb lists
> >> 0(24547) DEBUG: tm [t_funcs.c:96]: tm_shutdown(): DEBUG: tm_shutdown : done
> >> 0(24547) INFO: <core> [sctp_core.c:53]: sctp_core_destroy(): SCTP API not
> >> initialized
> >> 0(24547) DEBUG: <core> [mem/shm.c:174]: shm_core_lock_destroy(): destroying
> >> the shared memory lock
> >> 0(24547) DEBUG: <core> [mem/shm.c:266]: shm_destroy_manager(): destroying
> >> memory manager: f_malloc
> >> 0(24547) DEBUG: <core> [mem/pkg.c:89]: pkg_destroy_manager(): destroying
> >> memory manager: f_malloc
> >>
> >>
> >>
> >> _______________________________________________
> >> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
> >> sr-users at lists.sip-router.org
> >> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
> >>
> >>
> >> --
> >> Daniel-Constantin Mierla
> >> http://www.asipto.com - http://www.kamailio.org
> >> http://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda
> >>
> >>
> >> _______________________________________________
> >> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
> >> sr-users at lists.sip-router.org
> >> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
> >>
> 


-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20160801/c908b5a8/attachment.html>

More information about the sr-users mailing list