[OpenSIPS-Users] Serialforking failure, with lcr:parse_phostport: too many colons in udp:: 0
Taisto Qvist
taisto.qvist at ip-solutions.se
Tue Sep 28 17:49:46 CEST 2010
Hey, thanks!
That did solve my problem, I should probably have RTFM:eed better,
moving from 1.5->1.6. Weird that it worked last friday....
What is the equivalent of setting the serial-forking timers
that I previously used, such as:
modparam("lcr","fr_inv_timer_next",12) ## RollOverTimeout
Regards
TQ
Bogdan-Andrei Iancu skrev 2010-09-28 17:14:
> Hi Taiso,
>
> the load_contacts() and next_contact() are deprecated, better use the
> core functions:
> serialize_branches()
> http://www.opensips.org/Resources/DocsCoreFcn16#toc128
> next_branches() http://www.opensips.org/Resources/DocsCoreFcn16#toc112
>
> which works in the same way.
>
> Regards,
> Bogdan
>
> Taisto Qvist wrote:
>> 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
>>
>> ------------------------------------------------------------------------
>>
>> _______________________________________________
>> Users mailing list
>> Users at lists.opensips.org
>> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.opensips.org/pipermail/users/attachments/20100928/969b6efd/attachment-0001.htm
More information about the Users
mailing list