And here's the full routing block. I copied it from someone else on the list that was troubleshooting msilo a while back. Also, I can confirm the message never gets delivered because it remains in msilo DB and kamailio logs shows it trying and trying.
####### Routing Logic ######## # Main SIP request routing logic # - processing of any incoming SIP request starts with this route route { # per request initial checks route(REQINIT); # NAT detection route(NAT); # handle requests within SIP dialogs route(WITHINDLG); ### only initial requests (no To tag) # CANCEL processing if (is_method("CANCEL")) { if (t_check_trans()) t_relay(); exit; } if (is_method("MESSAGE")) { log(1,"-------------------------------------------------------->WE HAVE A NEW MESSAGE\n"); route(MSILO_MESSAGE); } t_check_trans(); # authentication route(AUTH); # record routing for dialog forming requests (in case they are routed) # - remove preloaded route headers remove_hf("Route"); if (is_method("INVITE|SUBSCRIBE")) record_route(); # account only INVITEs if (is_method("INVITE")) { setflag(FLT_ACC); # do accounting } # dispatch requests to foreign domains route(SIPOUT); ### requests for my local domains # handle presence related requests route(PRESENCE); # handle registrations route(REGISTRAR); if ($rU==$null) { # request with no Username in RURI sl_send_reply("484","Address Incomplete"); exit; } # dispatch destinations to PSTN route(PSTN); # user location service route(LOCATION); route(RELAY); } route[RELAY] { #!ifdef WITH_NAT if (check_route_param("nat=yes")) { setbflag(FLB_NATB); } if (isflagset(FLT_NATS) || isbflagset(FLB_NATB)) { route(RTPPROXY); } #!endif /* example how to enable some additional event routes */ if (is_method("INVITE")) { #t_on_branch("BRANCH_ONE"); t_on_reply("REPLY_ONE"); t_on_failure("FAIL_ONE"); } if (!t_relay()) { sl_reply_error(); } exit; } ##storing offline messages route[MSILO_MESSAGE]{ if (lookup("location")){ t_on_failure("FAIL_MESSAGE"); t_relay(); xlog("L_NOTICE","---------------------------------MI: ($mi), MB: ($mb)\n"); }else{ xlog("L_NOTICE","------------------MESSAGE PROCESSING: location not found, storing offline message ID: ($ru)\n"); m_store("$ru"); sl_send_reply("202", "ACCEPTED"); xlog("L_NOTICE","------------------MESSAGE PROCESSING: location not found, stored offline message ID: ($ru)\n"); }; exit; }; failure_route[FAIL_MESSAGE]{ xlog("L_NOTICE","------------------MESSAGE PROCESSING: user cannot be reached, storing offline message ID: ($ou)\n"); m_store("$ou"); t_reply("202", "ACCEPTED"); xlog("L_NOTICE","------------------MESSAGE PROCESSING: user cannot be reached, stored offline message ID: ($ou)\n"); exit; } # Per SIP request initial checks route[REQINIT] { #!ifdef WITH_ANTIFLOOD # flood dection from same IP and traffic ban for a while # be sure you exclude checking trusted peers, such as pstn gateways # - local host excluded (e.g., loop to self) if(src_ip!=myself) { if($sht(ipban=>$si)!=$null) { # ip is already blocked xdbg("request from blocked IP - $rm from $fu (IP:$si:$sp)\n"); exit; } if (!pike_check_req()) { xlog("L_ALERT","ALERT: pike blocking $rm from $fu (IP:$si:$sp)\n"); $sht(ipban=>$si) = 1; exit; } } #!endif if (!mf_process_maxfwd_header("10")) { sl_send_reply("483","Too Many Hops"); exit; } if(!sanity_check("1511", "7")) { xlog("Malformed SIP message from $si:$sp\n"); exit; } } # Handle requests within SIP dialogs route[WITHINDLG] { if (has_totag()) { # sequential request withing a dialog should # take the path determined by record-routing if (loose_route()) { if (is_method("BYE")) { setflag(FLT_ACC); # do accounting ... setflag(FLT_ACCFAILED); # ... even if the transaction fails } route(RELAY); } else { if (is_method("SUBSCRIBE") && uri == myself) { # in-dialog subscribe requests route(PRESENCE); exit; } if ( is_method("ACK") ) { if ( t_check_trans() ) { # no loose-route, but stateful ACK; # must be an ACK after a 487 # or e.g. 404 from upstream server t_relay(); exit; } else { # ACK without matching transaction ... ignore and discard exit; } } sl_send_reply("404","Not here"); } exit; } } # Handle SIP registrations route[REGISTRAR] { if (is_method("REGISTER")) { if(isflagset(FLT_NATS)) { setbflag(FLB_NATB); # uncomment next line to do SIP NAT pinging setbflag(FLB_NATSIPPING); } if (!save("location")) sl_reply_error(); # MSILO - dumping user's offline messages m_dump(); log(1,"-------------------------MESSAGE PROCESSING: dumping offline messages\n"); exit; } } # USER location service route[LOCATION] { #!ifdef WITH_ALIASDB # search in DB-based aliases alias_db_lookup("dbaliases"); #!endif if (!lookup("location")) { switch ($rc) { case -1: case -3: t_newtran(); t_reply("404", "Not Found"); exit; case -2: sl_send_reply("405", "Method Not Allowed"); exit; } } # when routing via usrloc, log the missed calls also if (is_method("INVITE")) { setflag(FLT_ACCMISSED); } } # Presence server route route[PRESENCE] { if(!is_method("PUBLISH|SUBSCRIBE")) return; #!ifdef WITH_PRESENCE if (!t_newtran()) { sl_reply_error(); exit; }; if(is_method("PUBLISH")) { handle_publish(); t_release(); } else if( is_method("SUBSCRIBE")) { handle_subscribe(); t_release(); } exit; #!endif # if presence enabled, this part will not be executed if (is_method("PUBLISH") || $rU==$null) { sl_send_reply("404", "Not here"); exit; } return; } # Authentication route route[AUTH] { #!ifdef WITH_AUTH if (is_method("REGISTER")) { # authenticate the REGISTER requests (uncomment to enable auth) if (!www_authorize("$td", "subscriber")) { www_challenge("$td", "0"); exit; } if ($au!=$tU) { sl_send_reply("403","Forbidden auth ID"); exit; } } else { #!ifdef WITH_IPAUTH if(allow_source_address()) { # source IP allowed return; } #!endif # authenticate if from local subscriber if (from_uri==myself) { if (!proxy_authorize("$fd", "subscriber")) { proxy_challenge("$fd", "0"); exit; } if (is_method("PUBLISH")) { if ($au!=$tU) { sl_send_reply("403","Forbidden auth ID"); exit; } } else { if ($au!=$fU) { sl_send_reply("403","Forbidden auth ID"); exit; } } consume_credentials(); # caller authenticated } else { # caller is not local subscriber, then check if it calls # a local destination, otherwise deny, not an open relay here if (!uri==myself) { sl_send_reply("403","Not relaying"); exit; } } } #!endif return; } # Caller NAT detection route route[NAT] { #!ifdef WITH_NAT force_rport(); if (nat_uac_test("19")) { if (method=="REGISTER") { fix_nated_register(); } else { fix_nated_contact(); } setflag(FLT_NATS); } #!endif return; } # RTPProxy control route[RTPPROXY] { #!ifdef WITH_NAT if (is_method("BYE")) { unforce_rtp_proxy(); } else if (is_method("INVITE")){ rtpproxy_offer(); } if (!has_totag()) add_rr_param(";nat=yes"); #!endif return; } # Routing to foreign domains route[SIPOUT] { if (!uri==myself) { append_hf("P-hint: outbound\r\n"); route(RELAY); } } # PSTN GW routing route[PSTN] { #!ifdef WITH_PSTN # check if PSTN GW IP is defined if (strempty($sel(cfg_get.pstn.gw_ip))) { xlog("SCRIPT: PSTN rotuing enabled but pstn.gw_ip not defined\n"); return; } # route to PSTN dialed numbers starting with '+' or '00' # (international format) # - update the condition to match your dialing rules for PSTN routing if(!($rU=~"^(\+|00)[1-9][0-9]{3,20}$")) return; # only local users allowed to call if(from_uri!=myself) { sl_send_reply("403", "Not Allowed"); exit; } $ru = "sip:" + $rU + "@" + $sel(cfg_get.pstn.gw_ip); route(RELAY); exit; #!endif return; } # XMLRPC routing #!ifdef WITH_XMLRPC route[XMLRPC] { # allow XMLRPC from localhost if ((method=="POST" || method=="GET") && (src_ip==127.0.0.1)) { # close connection only for xmlrpclib user agents (there is a bug in # xmlrpclib: it waits for EOF before interpreting the response). if ($hdr(User-Agent) =~ "xmlrpclib") set_reply_close(); set_reply_no_connect(); dispatch_rpc(); exit; } send_reply("403", "Forbidden"); exit; } #!endif # Sample branch router branch_route[BRANCH_ONE] { xdbg("new branch at $ru\n"); } # Sample onreply route onreply_route[REPLY_ONE] { xdbg("incoming reply\n"); #!ifdef WITH_NAT if ((isflagset(FLT_NATS) || isbflagset(FLB_NATB)) && status=~"(183)|(2[0-9][0-9])") { rtpproxy_answer(); } if (isbflagset("6")) { fix_nated_contact(); } #!endif } # Sample failure route failure_route[FAIL_ONE] { #!ifdef WITH_NAT if (is_method("INVITE") && (isbflagset(FLB_NATB) || isflagset(FLT_NATS))) { unforce_rtp_proxy(); } #!endif if (t_is_canceled()) { exit; } # uncomment the following lines if you want to block client # redirect based on 3xx replies. ##if (t_check_status("3[0-9][0-9]")) { ##t_reply("404","Not found"); ## exit; ##} # uncomment the following lines if you want to redirect the failed # calls to a different new destination ##if (t_check_status("486|408")) { ## sethostport("192.168.2.100:5060"); ## append_branch(); ## # do not set the missed call flag again ## t_relay(); ##} } On Wed, Jul 16, 2014 at 4:38 PM, Peter Villeneuve <peterv...@gmail.com> wrote: > Thanks for your help Daniel. > > OK I ngrepped port 5060 and indeed the message tries to get delivered. > However it never arrives at the client (1010 in this case). > I have added localhost listeners for UDP and TCP, even though all clients > register through TLS only (could this be the root of the problem?). I added > localhost listeners because I was getting the no socket found error message. > > Listening on > udp: 127.0.0.1:5080 > tcp: 127.0.0.1:5060 > tls: 79.my.server.IP1:5061 > Aliases: > tcp: localhost:5060 > udp: localhost:5080 > *: my.domain.com:* > > U 2014/07/16 15:29:14.904285 127.0.0.1:5080 -> 79.my.server.IP1:5060 > MESSAGE sip:1...@my.domain.com SIP/2.0. > Via: SIP/2.0/UDP 127.0.0.1:5080 > ;branch=z9hG4bKcde3.542219f4000000000000000000000000.0. > To: <sip:1...@my.domain.com>. > From: <sip:1...@my.domain.com>;tag=def4124455da8a0b8e97eafabd028e26-2c30. > CSeq: 10 MESSAGE. > Call-ID: 16b126996f51d89c-12460@127.0.0.1. > Max-Forwards: 70. > Content-Length: 58. > User-Agent: kamailio (4.1.4 (x86_64/linux)). > Date: Wed, 16 Jul 2014 15:22:31 GMT. > Content-Type: text/plain. > . > [Offline message - Wed Jul 16 15:22:31 2014] Test 1,2,3 > > > On Wed, Jul 16, 2014 at 8:58 AM, Daniel-Constantin Mierla < > mico...@gmail.com> wrote: > >> Hello, >> >> can you watch the sip traffic on the network to see if the sip messages >> is sent out? You can use ngrep, like: >> >> ngrep -d any -qt -W byline "sip" port 5060 >> >> Cheers, >> Daniel >> >> >> On 14/07/14 19:56, Peter Villeneuve wrote: >> >> Hi, >> >> This is most likely a stupid mistake on my route config, but msilo >> correctly stores messages for offline users, but when they come back >> online, the message never arrives. >> >> Looking through the debug logs indeed there is an error, with status >> 408, which suggests kamaiio can't find a route to the user that just >> logged. Before I spend hours looking through all the routing blocks, >> perhaps someone more exprienced in kamailio can see the problem right away >> and offer a solution? >> >> Thanks >> >> >> DEBUG: msilo [msilo.c:1148]: m_dump(): msg [1-12] for: >> sip:1...@my.domain.com >> DEBUG: <core> [io_wait.h:617]: io_watch_del(): DBG: io_watch_del >> (0x8e3040, 9, -1, 0x10) fd_no=2 called >> DEBUG: <core> [tcp_read.c:1437]: release_tcpconn(): releasing con >> 0x7f61ced1b1b0, state 1, fd=9, id=1 >> DEBUG: <core> [tcp_read.c:1438]: release_tcpconn(): extra_data >> 0x7f61ced1c4f8 >> DEBUG: <core> [tcp_main.c:3385]: handle_tcp_child(): handle_tcp_child: >> reader response= 7f61ced1b1b0, 1 from 0 >> DEBUG: <core> [io_wait.h:390]: io_watch_add(): DBG: >> io_watch_add(0x89ec40, 26, 2, 0x7f61ced1b1b0), fd_no=21 >> DEBUG: <core> [tcp_main.c:3515]: handle_tcp_child(): handle_tcp_child: >> CONN_RELEASE 0x7f61ced1b1b0 refcnt= 1 >> DEBUG: tm [t_reply.c:1304]: t_should_relay_response(): ->>>>>>>>> >> T_code=0, new_code=408 >> DEBUG: tm [t_reply.c:2086]: local_reply(): DEBUG: local_reply: branch=0, >> save=0, winner=0 >> DEBUG: tm [t_reply.c:2123]: local_reply(): DEBUG: local transaction >> completed >> DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: >> trans=0x7f61ced1d868, callback type 1024, id 0 entered >> DEBUG: msilo [msilo.c:1317]: m_tm_callback(): *completed with status >> 408* [mid: 140058058335472/13] >> DEBUG: msilo [msilo.c:1325]: m_tm_callback(): message <13> was not sent >> successfully >> DEBUG: msilo [ms_msg_list.c:236]: msg_list_set_flag(): mid:13 fl:8 >> DEBUG: tm [t_reply.c:1304]: t_should_relay_response(): ->>>>>>>>> >> T_code=0, new_code=408 >> DEBUG: tm [t_reply.c:2086]: local_reply(): DEBUG: local_reply: branch=0, >> save=0, winner=0 >> DEBUG: tm [t_reply.c:2123]: local_reply(): DEBUG: local transaction >> completed >> DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG: >> trans=0x7f61ced5f098, callback type 1024, id 0 entered >> DEBUG: msilo [msilo.c:1317]: m_tm_callback(): completed with status 408 >> [mid: 140058058329184/12] >> DEBUG: msilo [msilo.c:1325]: m_tm_callback(): message <12> was not sent >> successfully >> DEBUG: msilo [ms_msg_list.c:236]: msg_list_set_flag(): mid:12 fl:8 >> >> >> >> >> _______________________________________________ >> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing >> listsr-us...@lists.sip-router.orghttp://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users >> >> >> -- >> Daniel-Constantin Mierla - >> http://www.asipto.comhttp://twitter.com/#!/miconda - >> http://www.linkedin.com/in/miconda >> >> >> _______________________________________________ >> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list >> sr-users@lists.sip-router.org >> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users >> >> >
_______________________________________________ SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list sr-users@lists.sip-router.org http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users