It's an incoming request
Debug3 :
May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29536]: DEBUG: <core> [ip_addr.c:247]: tcpconn_new: new tcp connection: 80.80.80.241 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29536]: DEBUG: <core> [tcp_main.c:1089]: tcpconn_new: on port 51898, type 2 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29536]: DEBUG: <core> [tcp_main.c:1400]: tcpconn_add: hashes: 902:996:7, 4 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29536]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x82cec0, 57, 2, 0x7f8481de59a0), fd_no=48 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29536]: DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x82cec0, 57, -1, 0x0) fd_no=49 called May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29536]: DEBUG: <core> [tcp_main.c:4295]: tcp: DBG: sending to child, events 1 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29536]: DEBUG: <core> [tcp_main.c:3966]: selected tcp worker 3 33(29526) for activity on [tcp:172.16.60.113:5060], 0x7f8481de59a0 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [tcp_read.c:1354]: received n=8 con=0x7f8481de59a0, fd=11 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:624]: SIP Request: May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:626]: method: <GET> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:628]: uri: </Update> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:630]: version: <HTTP/1.1> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:104]: found end of header May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: ERROR: <core> [parser/parse_from.c:60]: ERROR:parse_from_header: bad msg or missing FROM header May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: ERROR: topoh [topoh_mod.c:215]: cannot parse FROM header May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:624]: SIP Request: May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:626]: method: <GET> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:628]: uri: </Update> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:630]: version: <HTTP/1.1> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:104]: found end of header May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [receive.c:149]: After parse_msg... May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: xhttp [xhttp_mod.c:345]: new fake msg created (300 bytes):#012<GET /Update HTTP/1.1#015#012Via: SIP/2.0/TCP 80.80.80.241:51898#015#012Accept: text/html, application/xhtml+xml, */*#015#012Accept-Language: he-IL#015#012User-Agent: Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)#015#012Accept-Encoding: gzip, deflate#015#012Host: 172.16.60.113:5060#015#012DNT: 1#015#012Connection: Keep-Alive#015#012#015#012> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:624]: SIP Request: May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:626]: method: <GET> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:628]: uri: </Update> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:630]: version: <HTTP/1.1> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: this is the first via May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: NOTICE: <script>: HTTP HANDLER /Update May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: exec [exec_mod.c:208]: executing [kamctl fifo mt_list] May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [main.c:886]: SIGCHLD received: we do not worry about grand-children May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: exec [exec.c:274]: no result from kamctl fifo mt_list May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: mtree [mtree.c:414]: no match for: May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: INFO: mtree [mtree_mod.c:450]: no prefix found in [CAC] for [] May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: sl [sl.c:278]: reply in stateless mode (sl) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:104]: found end of header May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [msg_translator.c:206]: check_via_address(80.80.80.241, 80.80.80.241, 0) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:624]: SIP Request: May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:626]: method: <HTTP/1.1> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:628]: uri: <200> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:630]: version: <OK> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: this is the first via May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body : content_length=61 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [parser/msg_parser.c:104]: found end of header May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: ERROR: <core> [parser/parse_from.c:60]: ERROR:parse_from_header: bad msg or missing FROM header May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: ERROR: topoh [topoh_mod.c:215]: cannot parse FROM header May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [tcp_main.c:2313]: tcp_send: send from reader (29526 (33)), reusing fd May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [tcp_main.c:2549]: tcp_send: sending... May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [tcp_main.c:2583]: tcp_send: after real write: c= 0x7f8481de59a0 n=203 fd=11 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [tcp_main.c:2584]: tcp_send: buf=#012HTTP/1.1 200 OK#015#012Via: SIP/2.0/TCP 80.80.80.241:51898#015#012Content-Type: text/html#015#012Server: kamailio (3.3.1 (x86_64/linux))#015#012Content-Length: 61#015#012#015#012<html><body>LastUpdated 0 result <null>;<null>;</body></html> May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29536]: DEBUG: <core> [tcp_main.c:3617]: handle_ser_child: read response= 7f8481de59a0, -1, fd -1 from 33 (29526) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [xavp.c:365]: destroying xavp list (nil) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [receive.c:293]: receive_msg: cleaning up May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x871120, 11, 2, 0x7f8481de59a0), fd_no=1 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x871120, 11, -1, 0x10) fd_no=2 called May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [tcp_read.c:1281]: releasing con 0x7f8481de59a0, state -2, fd=11, id=4 May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29526]: DEBUG: <core> [tcp_read.c:1282]: extra_data (nil) May 23 15:44:57 RNDSRV /usr/local/sbin/kamailio[29536]: DEBUG: <core> [tcp_main.c:3378]: handle_tcp_child: reader response= 7f8481de59a0, -2 from 3
Thank you,
Julia
_____
From: sr-users-bounces@lists.sip-router.org [mailto:sr-users-bounces@lists.sip-router.org] On Behalf Of Daniel-Constantin Mierla Sent: Thursday, May 23, 2013 3:10 PM To: Kamailio (SER) - Users Mailing List Subject: Re: [SR-Users] topoch and xHTTP
Hello,
iirc, topoh callbacks are executed only for incoming sip traffic. Do you try to relay the http request? That doesn't work, kamailio works only as http server, not proxy.
If it is the case of incoming request, can you run with debug=3 and send the output of such case here?
Cheers, Daniel
On 5/23/13 12:21 PM, Julia wrote:
Hello,
I am testing the xHTTP module on kamailio-3.3 with topology hiding (topoch) and I get parsing error for each received HTTP message:
/usr/local/sbin/kamailio[2937]: ERROR: <core> [parser/parse_from.c:60]: ERROR:parse_from_header: bad msg or missing FROM header /usr/local/sbin/kamailio[2937]: ERROR: topoh [topoh_mod.c:215]: cannot parse FROM header
Is it configuration issue?