[OpenSIPS-Users] Serialforking failure, with lcr:parse_phostport: too many colons in udp:: 0

[Taisto Qvist]

  Hi folks,

I am trying to recreate a serialforking scenario which I am receiving
the following problems with.
As far as I know(?), the config is just the same as last week when I
used the same config and everything worked.
Unfortunately I dont have the old config so I cant compare, but the changes
are so small that I cant figure out the differences.

I am running the latest opensips 1.6.3 from svn.
But I've tried a few other 1.6.3 versions with the same results.

Heres part of the script:
-------------------
             lookup("location", "m");
             switch ($retcode)
             {
                 case 1:
                     log(2, "(lab2) - Contact found in location server, rerouting.\n");
                     if (!load_contacts())
                     {
                        log(1, "(lab2) - Unable to load contacts for serial forking\n");
                        t_reply("500", "Server Internal Error (Serial fork)");
                        exit;
                     }
                     if ( !next_contacts() )
                     {
                         t_reply("509", "Serial fork error");
                         exit;
                     }
                     return(1);
-------------------
But the next_contacts() fails for some reason, and the error-printouts in the log, 
doesnt tell
me enough to know where to continue.

Heres the debug printout:
----------------------------
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:db_mysql:db_mysql_val2bind: 
added val (1): len=8; type=254; is_null=0
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: 
DBG:db_mysql:db_mysql_do_prepared_query: doing BIND_PARAM in...
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: 
DBG:db_mysql:db_mysql_do_prepared_query: prepared statement has 1 columns in result
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:db_new_result: allocate 28 
bytes for result set at 0x81cfc24
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:db_mysql:db_mysql_get_columns: 1 
columns returned from the query
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:db_allocate_columns: 
allocate 16 bytes for result columns at 0x81cc42c
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:db_mysql:db_mysql_get_columns: 
RES_NAMES(0x81cc430)[0]=[username]
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:db_mysql:db_mysql_get_columns: 
use DB_STRING result type
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:db_allocate_rows: allocate 
28 bytes for result rows and values at 0x81cfc50
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:db_mysql:db_mysql_str2val: 
converting STRING [jane]
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:uri:does_uri_exist: User in 
request uri does exist
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:db_free_columns: freeing 
result columns at 0x81cc42c
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:db_free_rows: freeing 1 rows
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:db_free_row: freeing row 
values at 0x81cfc58
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:db_free_rows: freeing rows 
at 0x81cfc50
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:db_free_result: freeing 
result set at 0x81cfc24
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: (lab2) - Its a valid local user
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:comp_scriptvar: int 20 : 0 / 0
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: (lab2) - Stateful LS lookup()
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:registrar:lookup: setting as 
ruri <sip:jane at 10.10.2.33:5060>
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:registrar:lookup: looking for 
branches
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:registrar:lookup: setting branch 
<sip:jane at 10.10.1.24:5061>
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: (lab2) - Contact found in location 
server, rerouting.
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:lcr:socket2str: <udp::>
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:lcr:load_contacts: Loaded 
contact <sip:jane at 10.10.1.24:5061   udp:: 0 > with q_flag <0>
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:lcr:socket2str: <udp::>
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:lcr:load_contacts: Loaded 
contact <sip:jane at 10.10.2.33:5060   udp:: 0 > with q_flag <4>
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:lcr:next_contacts: Next contact 
is <sip:jane at 10.10.2.33:5060   udp:: 0 >
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: ERROR:lcr:parse_phostport:  too many 
colons in udp:: 0
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: ERROR:lcr:decode_branch_info: 
Parsing of socket info <udp::> failed
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: ERROR:lcr:next_contacts: Decoding of 
branch info <sip:jane at 10.10.2.33:5060   udp:: 0 > failed
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:parse_headers: 
flags=ffffffffffffffff
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:check_ip_address: params 
10.10.10.11, sip.core.net, 0
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:core:_shm_resize: resize(0) called
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:tm:cleanup_uac_timers: RETR/FR 
timers reset
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:tm:set_timer: relative timeout 
is 500000
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:tm:insert_timer_unsafe: [4]: 
0xb5b6345c (159600000)
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:tm:set_timer: relative timeout is 32
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:tm:insert_timer_unsafe: [0]: 
0xb5b63478 (191)
Sep 28 16:12:21 sip-laptop2 opensips_lab2[2118]: DBG:tm:_reply_light: reply sent out. 
buf=0x81cff60: SIP/2.0 5..., shmem=0xb5b61374:
-------------------------

Many thanks for any help/tips you can give, I'm kind of lost...

Regards
Taisto Qvist

-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.opensips.org/pipermail/users/attachments/20100928/2a16a632/attachment.htm