[OpenSIPS-Users] Contact Header Crash
Antonio Frongillo
antonio at frogweb.it
Thu Jan 15 22:27:03 CET 2009
Hi Bogdan,
I went deeper in the analysis and I find out that the problem was that the
SIP message is too long and makes Seas crash.
I found the parameter ENCODED_MSG_SIZE in "seas.h" that is set to 3200 by
default.
Setting this parameter to a larger value it seems that all is going fine.
What do you think about this issue? It seems not a good behavior that the
OpenSips server crash with this kind of messages.
Is it possible to release a patch that fix this or for example makes the
maximum size of the payload configurable from the opensips configuration
file?
Thanks in advance,
Antonio
2009/1/15 Antonio Frongillo <antonio at frogweb.it>
> Hi Bogdan,
> I made a deeper analysis on the problem and I think that the error (the seg
> fault on SEAS module) is caused by incoming messages with a BIG Content.
>
> Both 200 OK with big payload and NOTIFY makes OpenSips seas module to crash
> in different points (seeing the core generated) and randomly (it doesn't
> crash for each message, also identical messages some times works and other
> times crashes).
>
> Could it be that when Seas try to read the BIG Content it wrongly manages
> the memory and write in an illegal memory address (so sometimes works and
> other times go in seg fault) ????
>
> Below you can find the logs of OpenSips and a couple of core dump.
>
> Jan 15 17:31:31 [31065] DBG:core:tcp_send: tcp connection found
> (0xb614d6a0), acquiring fd
> Jan 15 17:31:31 [31065] DBG:core:tcp_send: c= 0xb614d6a0, n=8
> Jan 15 17:31:31 [31061] DBG:core:handle_ser_child: read response= b614d6a0,
> 1, fd -1 from 1 (31042)
> Jan 15 17:31:31 [31065] DBG:core:tcp_send: after receive_fd: c= 0xb614d6a0
> n=4 fd=13
> Jan 15 17:31:31 [31065] DBG:core:tcp_send: sending...
> Jan 15 17:31:31 [31065] DBG:core:tcp_send: after write: c= 0xb614d6a0
> n=1915 fd=13
> Jan 15 17:31:31 [31065] DBG:core:tcp_send: buf=
> SERVICE sip:max.ambrogi at hmcint.local:5060;transport=tcp SIP/2.0
> Via: SIP/2.0/TCP 192.168.5.59;branch=z9hG4bKa21a.c42740c2.0
> To: sip:max.ambrogi at hmcint.local:5060;transport=tcp
> From: sip:max.ambrogi at hmcint.local
> ;transport=tcp;tag=AB62C6E82E8FD0E5FE0D61C590FF8064
> CSeq: 1 SERVICE
> Call-ID: 2835F715D923D84438CD30BFCB886F6A at 192.168.5.59
> Content-Length: 1064
> Max-Forwards: 70
> Contact: <sip:192.168.5.59:5060;transport=tcp;AppId=.sip2msipGW>;methods="INVITE,
> MESSAGE, INFO, OPTIONS, BYE, CANCEL, NOTIFY, ACK,
> REFER";proxy=replace;+sip.instance="<urn:uuid:8ceb9439-8543-4acd-8691-d2ef85926f22>"
> Proxy-Authorization: NTLM qop="auth",realm="SIP Communications
> Service",opaque="23E04879",crand="94867859",cnum="25",targetname="HMCINTOCS.HMCINT.LOCAL",response="01000000000000006A61B6F3C230F2DF"
> Content-Type: application/msrtc-category-publish+xml
>
> <publish xmlns="http://schemas.microsoft.com/2006/09/sip/rich-presence"><publications
> uri="sip:max.ambrogi at hmcint.local"><publication categoryName="state"
> instance="603979776" container="3" version="0" expireType="time"
> expires="0"/><publication categoryName="state" instance="603979776"
> container="2" version="0" expireType="time" expires="0"/><publication
> categoryName="state" instance="536870912" container="3" version="141"
> expireType="static"><state xmlns="
> http://schemas.microsoft.com/2006/09/sip/state" manual="true" xmlns:xsi="
> http://www.w3.org/2001/XMLSchema-instance"
> xsi:type="userState"><availability>3500</availability><endpointLocation></endpointLocation></state></publication><publication
> categoryName="state" instance="536870912" container="2" version="141"
> expireType="static"><state xmlns="
> http://schemas.microsoft.com/2006/09/sip/state" manual="true" xmlns:xsi="
> http://www.w3.org/2001/XMLSchema-instance"
> xsi:type="userState"><availability>3500</availability><endpointLocation></endpointLocation></state></publication></publications></publish>
> Jan 15 17:31:31 [31065] DBG:tm:set_timer: relative timeout is 30
> Jan 15 17:31:31 [31065] DBG:tm:insert_timer_unsafe: [0]: 0xb6160ed0 (230)
> Jan 15 17:31:31 [31065] DBG:seas:process_input: (Action
> dispatched,buffer.len=0)
> Jan 15 17:31:31 [31053] DBG:core:tcp_read_req: content-length= 3935
> Jan 15 17:31:31 [31053] DBG:core:parse_msg: SIP Reply (status):
> Jan 15 17:31:31 [31053] DBG:core:parse_msg: version: <SIP/2.0>
> Jan 15 17:31:31 [31053] DBG:core:parse_msg: status: <200>
> Jan 15 17:31:31 [31053] DBG:core:parse_msg: reason: <OK>
> Jan 15 17:31:31 [31053] DBG:core:parse_headers: flags=2
> Jan 15 17:31:31 [31053] DBG:core:get_hdr_field: content_length=3935
> Jan 15 17:31:31 [31053] DBG:core:parse_to_param: transport=tcp
> Jan 15 17:31:31 [31053] DBG:core:parse_to_param:
> tag=F38CBA48BA483432B3C92CFD2033D7D1
> Jan 15 17:31:31 [31053] DBG:core:parse_to: end of header reached, state=29
> Jan 15 17:31:31 [31053] DBG:core:parse_to: display={},
> ruri={sip:max.ambrogi at hmcint.local:5060}
> Jan 15 17:31:31 [31053] DBG:core:get_hdr_field: <To> [86];
> uri=[sip:max.ambrogi at hmcint.local:5060]
> Jan 15 17:31:31 [31053] DBG:core:get_hdr_field: to body
> [sip:max.ambrogi at hmcint.local:5060]
> Jan 15 17:31:31 [31053] DBG:core:get_hdr_field: cseq <CSeq>: <1> <SERVICE>
> Jan 15 17:31:31 [31053] DBG:core:parse_via_param: found param type 232,
> <branch> = <z9hG4bKa21a.c42740c2.0>; state=6
> Jan 15 17:31:31 [31053] DBG:core:parse_via_param: found param type 238,
> <ms-received-port> = <44569>; state=6
> Jan 15 17:31:31 [31053] DBG:core:parse_via_param: found param type 238,
> <ms-received-cid> = <C700>; state=16
> Jan 15 17:31:31 [31053] DBG:core:parse_via: end of header reached, state=5
> Jan 15 17:31:31 [31053] DBG:core:parse_headers: via found, flags=2
> Jan 15 17:31:31 [31053] DBG:core:parse_headers: this is the first via
> Jan 15 17:31:31 [31053] DBG:core:receive_msg: After parse_msg...
> Jan 15 17:31:31 [31053] DBG:core:comp_scriptvar: str 20 : 200
> Jan 15 17:31:31 [31053] DBG:core:forward_reply: found module tm, passing
> reply to it
> Jan 15 17:31:31 [31053] DBG:tm:t_check: start=0xffffffff
> Jan 15 17:31:31 [31053] DBG:core:parse_headers: flags=22
> Jan 15 17:31:31 [31053] DBG:tm:t_reply_matching: hash 41258 label 738488908
> branch 0
> Jan 15 17:31:31 [31053] DBG:tm:t_reply_matching: REF_UNSAFE: after is 1
> Jan 15 17:31:31 [31053] DBG:tm:t_reply_matching: reply matched
> (T=0xb6160d68)!
> Jan 15 17:31:31 [31053] DBG:tm:t_check: end=0xb6160d68
> Jan 15 17:31:31 [31053] DBG:tm:reply_received: org. status uas=0, uac[0]=0
> local=2 is_invite=0)
> Jan 15 17:31:31 [31053] DBG:tm:t_should_relay_response: T_code=0,
> new_code=200
> Jan 15 17:31:31 [31053] DBG:tm:local_reply: branch=0, save=0, winner=0
> Jan 15 17:31:31 [31053] DBG:tm:local_reply: local transaction completed
> Jan 15 17:31:31 [31053] DBG:tm:run_trans_callbacks: trans=0xb6160d68,
> callback type 256, id 0 entered
> Jan 15 17:31:31 [31053] DBG:seas:uac_cb: reply to UAC Transaction for
> AS:shootist code: 200
> Jan 15 17:31:31 [31053] DBG:seas:uac_cb: transaction 0xb6160d68
> Nr_of_outgoings:1 is_Local:y
> Jan 15 17:31:31 [31053] DBG:seas:uac_cb: UAC[0].last_received=200
> Jan 15 17:31:31 [31053] DBG:core:parse_headers: flags=ffffffffffffffff
> Jan 15 17:31:31 [31053] DBG:core:get_hdr_field: found end of header
> Jan 15 17:31:31 [31053] DBG:core:parse_headers: flags=ffffffffffffffff
> Jan 15 17:31:31 [31053] DBG:core:parse_to_param: transport=tcp
> Jan 15 17:31:31 [31053] DBG:core:parse_to_param:
> tag=AB62C6E82E8FD0E5FE0D61C590FF8064
> Jan 15 17:31:31 [31053] DBG:core:parse_to: end of header reached, state=29
> Jan 15 17:31:31 [31053] DBG:core:parse_to: display={"Max Ambrogi"},
> ruri={sip:max.ambrogi at hmcint.local}
> Jan 15 17:31:31 [31053] DBG:seas:encode_msg: msglen = 4605,msg starts at
> 154
> Jan 15 17:31:31 [31053] DBG:tm:cleanup_uac_timers: RETR/FR timers reset
> Jan 15 17:31:31 [31053] DBG:tm:insert_timer_unsafe: [2]: 0xb6160db0 (205)
> Jan 15 17:31:31 [31053] DBG:tm:t_unref: UNREF_UNSAFE: after is 0
> Jan 15 17:31:31 [31053] DBG:core:destroy_avp_list: destroying list (nil)
> Jan 15 17:31:31 [31053] DBG:core:receive_msg: cleaning up
> Jan 15 17:31:31 [-1241746112] DBG:seas:dispatch_relay: Event relaied to
> shootist AS
> Jan 15 17:31:31 [-1241746112] DBG:seas:dispatch_relay: Event type UAC_REQ
> Jan 15 17:31:31 [-1241746112] DBG:seas:dispatcher_main_loop: Scanning data
> from 1 AS
> Jan 15 17:31:31 [-1241746112] DBG:seas:dispatcher_main_loop: Scanning data
> from 0 uncomplete AS
> Jan 15 17:31:31 [-1241746112] INFO:seas:dispatcher_main_loop: polling [2
> ServSock] [1 pipe] [1 App Servers] [0 Uncomplete AS]
> Jan 15 17:31:35 [31051] DBG:tm:timer_routine: timer routine:2,tl=0xb615ff60
> next=0xb6160db0, timeout=205
> Jan 15 17:31:35 [31051] DBG:tm:wait_handler: removing 0xb615ff18 from table
> Jan 15 17:31:35 [31051] DBG:tm:delete_cell: delete transaction 0xb615ff18
> Jan 15 17:31:36 [31041] INFO:core:handle_sigs: child process 31051 exited
> by a signal 11
> Jan 15 17:31:36 [31041] INFO:core:handle_sigs: core was generated
> Jan 15 17:31:36 [31041] INFO:core:handle_sigs: terminating due to SIGCHLD
> Jan 15 17:31:36 [-1241746112] INFO:seas:seas_sighandler: INFO: signal 15
> received
> Jan 15 17:31:36 [31042] heap size= 1048576
> used= 52968, used+overhead=72856, free=975720
> max used (+overhead)= 72856
> dumpingJan 15 17:31:36 [31044] INFO:core:sig_usr: signal 15 received
> Memory status (pkg):
> fm_status (0x8194f20):
> heap size= 1048576
> used= 49024, used+overhead=68904, free=979672
> max used (+overhead)= 68904
> dumping free list:
> hash = 1 fragments no.: 1, unused: 0
> bucket size: 8 - 8 (first 8)
> hash = 42 fragments no.: 1, unused: 0
> bucket size: 336 - 336 (first 336)
> hash = 53 fragments no.: 1, unused: 0
> bucket size: 424 - 424 (first 424)
> hash = 56 fragments no.: 1, unused: 0
> bucket size: 448 - 448 (first 448)
> hash = 2054 fragments no.: 1, unused: 0
> bucket size: 524288 - 1048576 (first 978496)
> TOTAL: 5 free fragments = 979712 free bytes
> -----------------------------
> ping free list:
> hash = 1 fragments no.: 1, unused: 0
> bucket sJan 15 17:31:36 [31049] INFO:core:sig_usr: signal
> 15 received
> Memory status (pkg):
> fm_status (0x8194f20):
> heap size= 1048576
> used= 49024, used+overhead=68904, free=979672
> max used (+overhead)= 68904
> dumping free list:
> hash = 1 fragments no.: 1, unused: 0
> bucket size: 8 - 8 (first 8)
> hash = 42 fragments no.: 1, Jan 15 17:31:36 [31052] INFO:core:sig_usr:
> signal 15 received
> Memory status (pkg):
> fm_status (0x8194f20Jan 15 17:31:36 [31054] INFO:core:sig_usr: signal 15
> received
> Memory status (pkg):
> fm_status (0x8194f20):
> heap size= 1048576
> used= 99160, used+overhead=119056, free=929520
> max used (+overhead)= 119056
> dumping free list:
> hash = 1 fragments no.: 1, unused: 0
> bucket size: 8 - 8 (first 8)
> hash = 7 fragments no.: 1, unused: 0
> bucket size: 56 - 56 (first 56)
> hash = 42 fragments no.: 1, unused: 0
> bucket size: 336 - 336 (first 336)
> hash = 53 fragments no.: 1, unused: 0
> bucket size: 424 - Jan 15 17:31:36 [31059]
> INFO:core:sig_usr: signal 15 received
> Memory status (pkg):
> fm_status (0x8194f20):
> heap size= 1048576
> used= 99160, used+overhead=119056, free=929520
> max used (+overhead)= 119056
> dumping free list:
> hash = 1 fragments no.: 1, unused: 0
> bucket size: 8 - 8 (first 8)
> hashJan 15 17:31:36 [31065] INFO:seas:seas_sighandler: INFO: signal 15
> received
> fm_status (0x8194f20)hash = 1 fragments no.: 1, unused: 0
> bucket size: 8 - 8 (first 8)
> hash = 7 fragments no.: 1, unused: 0
> bucket size: 56 - 56 (first 56)
> hash = 42 fragments no.: 1, unused: 0
> bucket size: 336 - 336 (first 336)
> hash = 53 fragments no.: 1, unused: 0
> bucket size: 424 - 424 (first 424)
> hash = 56 fragments no.: 1, unused: 0
> bucket size: 448 - 448 (first 448)
> hash = 2054 fragments no.: 1, unused: 0
> bucket size: 524288 - 1048576 (first 928288)
> TOTAL: 6 free fragments = 929560 free bytes
> -----------------------------
> Jan 15 17:31:36 [-1241746112] INFO:seas:seas_sighandler: Child stopped or
> terminated
> Jan 15 17:31:36 [31041] DBG:xlog:destroy: destroy module...
> Jan 15 17:31:36 [31041] DBG:tm:tm_shutdown: tm_shutdown : start
> Jan 15 17:31:36 [31041] DBG:tm:unlink_timer_lists: emptying DELETE list
> Jan 15 17:31:36 [31041] DBG:tm:tm_shutdown: emptying hash table
> Jan 15 17:31:36 [31041] DBG:tm:run_trans_callbacks: trans=0xb6160d68,
> callback type 2048, id 1 entered
> Jan 15 17:31:36 [31041] DBG:tm:tm_shutdown: releasing timers
> Jan 15 17:31:36 [31041] DBG:tm:tm_shutdown: removing semaphores
> Jan 15 17:31:36 [31041] DBG:tm:tm_shutdown: destroying callback lists
> Jan 15 17:31:36 [31041] DBG:tm:tm_shutdown: tm_shutdown : done
> Jan 15 17:31:36 [31041] DBG:core:destroy_tls: entered
> Memory status (pkg):
> fm_status (0x8194f20):
> heap size= 1048576
> used= 33728, used+overhead=53600, free=994976
> max used (+overhead)= 60648
> dumping free list:
> hash = 1 fragments no.: 2, unused: 0
> bucket size: 8 - 8 (first 8)
> hash = 2 fragments no.: 17, unused: 0
> bucket size: 16 - 16 (first 16)
> hash = 3 fragments no.: 2, unused: 0
> bucket size: 24 - 24 (first 24)
> hash = 5 fragments no.: 4, unused: 0
> bucket size: 40 - 40 (first 40)
> hash = 7 fragments no.: 1, unused: 0
> bucket size: 56 - 56 (first 56)
> hash = 10 fragments no.: 2, unused: 0
> bucket size: 80 - 80 (first 80)
> hash = 42 fragments no.: 1, unused: 0
> bucket size: 336 - 336 (first 336)
> hash = 53 fragments no.: 1, unused: 0
> bucket size: 424 - 424 (first 424)
> hash = 56 fragments no.: 1, unused: 0
> bucket size: 448 - 448 (first 448)
> hash = 800 fragments no.: 1, unused: 0
> bucket size: 6400 - 6400 (first 6400)
> hash = 2054 fragments no.: 1, unused: 0
> bucket size: 524288 - 1048576 (first 986696)
> TOTAL: 33 free fragments = 995016 free bytes
> -----------------------------
> Memory status (shm):
> fm_status (0xb5fc1000):
> heap size= 33554432
> used= 2593372002, used+overhead=2593389770, free=1735131958
> max used (+overhead)= 1714504
> dumping free list:
> hash = 0 fragments no.: 2, unused: 0
> bucket size: 0 - 0 (first 0)
> hash = 1 fragments no.: 48, unused: 0
> bucket size: 8 - 8 (first 8)
> hash = 2 fragments no.: 7, unused: 0
> bucket size: 16 - 16 (first 16)
> hash = 3 fragments no.: 6, unused: 0
> bucket size: 24 - 24 (first 24)
> hash = 4 fragments no.: 46, unused: 0
> bucket size: 32 - 32 (first 32)
> hash = 5 fragments no.: 4, unused: 0
> bucket size: 40 - 40 (first 40)
> hash = 6 fragments no.: 4, unused: 0
> bucket size: 48 - 48 (first 48)
> hash = 8 fragments no.: 2, unused: 0
> bucket size: 64 - 64 (first 64)
> hash = 16 fragments no.: 1, unused: 0
> bucket size: 128 - 128 (first 128)
> hash = 18 fragments no.: 1, unused: 0
> bucket size: 144 - 144 (first 144)
> hash = 64 fragments no.: 1, unused: 0
> bucket size: 512 - 512 (first 512)
>
> [root at OCS log]# less opensips.log
> [root at OCS log]# less opensips.log
> hash = 56 fragments no.: 1, unused: 0
> bucket size: 448 - 448 (first 448)
> hash = 800 fragments no.: 1, unused: 0
> bucket size: 6400 - 6400 (first 6400)
> hash = 2054 fragments no.: 1, unused: 0
> bucket size: 524288 - 1048576 (first 986696)
> TOTAL: 33 free fragments = 995016 free bytes
> -----------------------------
> Memory status (shm):
> fm_status (0xb5fc1000):
> heap size= 33554432
> used= 2593372002, used+overhead=2593389770, free=1735131958
> max used (+overhead)= 1714504
> dumping free list:
> hash = 0 fragments no.: 2, unused: 0
> bucket size: 0 - 0 (first 0)
> hash = 1 fragments no.: 48, unused: 0
> bucket size: 8 - 8 (first 8)
> hash = 2 fragments no.: 7, unused: 0
> bucket size: 16 - 16 (first 16)
> hash = 3 fragments no.: 6, unused: 0
> bucket size: 24 - 24 (first 24)
> hash = 4 fragments no.: 46, unused: 0
> bucket size: 32 - 32 (first 32)
> hash = 5 fragments no.: 4, unused: 0
> bucket size: 40 - 40 (first 40)
> hash = 6 fragments no.: 4, unused: 0
> bucket size: 48 - 48 (first 48)
> hash = 8 fragments no.: 2, unused: 0
> bucket size: 64 - 64 (first 64)
> hash = 16 fragments no.: 1, unused: 0
> bucket size: 128 - 128 (first 128)
> hash = 18 fragments no.: 1, unused: 0
> bucket size: 144 - 144 (first 144)
> hash = 64 fragments no.: 1, unused: 0
>
>
> CORE DUMP 1:
>
> #0 0x006edf21 in run_trans_callbacks (type=2048, trans=0xb615ff18,
> req=0x0, rpl=0x0, code=0) at t_hooks.c:204
> 204 if ( (cbp->types)&type ) {
> (gdb) bt
> #0 0x006edf21 in run_trans_callbacks (type=2048, trans=0xb615ff18,
> req=0x0, rpl=0x0, code=0) at t_hooks.c:204
> #1 0x006db1ad in free_cell (dead_cell=0xb615ff18) at h_table.c:124
> #2 0x006f0464 in delete_cell (p_cell=0xb615ff18, unlock=1) at timer.c:239
> #3 0x006f1479 in timer_routine (ticks=205, attr=0x0) at timer.c:409
> #4 0x080c5a41 in start_timer_processes () at timer.c:280
> #5 0x0806ba43 in main (argc=2, argv=0xbfea9784) at main.c:815
>
>
> CORE DUMP 2:
>
> #0 0x080d578e in fm_status (qm=0xb5fc1000) at mem/f_malloc.c:512
> 512 for (f=qm->free_hash[h].first,j=0; f;
> (gdb) bt
> #0 0x080d578e in fm_status (qm=0xb5fc1000) at mem/f_malloc.c:512
> #1 0x08067018 in cleanup (show_status=1) at main.c:352
> #2 0x08067a18 in handle_sigs () at main.c:519
> #3 0x0806bb6e in main (argc=2, argv=0xbfea9784) at main.c:861
>
>
>
>
>
>
> 2009/1/15 Bogdan-Andrei Iancu <bogdan at voice-system.ro>
>
>> Hi Antonio,
>>
>> There is a SEG FAULT happening:
>> INFO:seas:dispatcher_main_loop: child process 20783 exited by a signal
>> 11
>>
>> I guess 20783 is a SEAS specific module - could you check in the logs what
>> are the last messages from this processes ? or do you have a core file from
>> it?
>>
>> Regards,
>> Bogdan
>>
>> Antonio Frongillo wrote:
>>
>>>
>>>
>>> 2009/1/15 Antonio Frongillo <antonio at frogweb.it <mailto:
>>> antonio at frogweb.it>>
>>>
>>>
>>> I'm trying to use OpenSips (configured with WeSip) to communicate
>>> with Microsoft OCS 2007.
>>> I'm able to sends REGISTER and SUBSCRIBE to OCS from a Sip Servlet
>>> without any problem.
>>> Randomly (or at least it seems) the 200 OK returned by the
>>> SUBSCRIBE, or one of the NOTIFYs sent by OCS after the
>>> subscription makes OpenSips to crash:
>>>
>>> Jan 15 11:33:42 [1933272943] INFO:seas:seas_sighandler: Child
>>> stopped or terminated
>>> Jan 15 11:33:42 [1933272943] INFO:seas:dispatcher_main_loop: child
>>> process 20783 exited by a signal 11
>>> Jan 15 11:33:42 [1933272943] WARNING:seas:dispatcher_main_loop:
>>> client [shootist] leaving (Action Dispatcher Process died !)
>>> Jan 15 11:33:42 [1933272943] INFO:seas:dispatcher_main_loop:
>>> polling [2 ServSock] [1 pipe] [0 App Servers] [0 Uncomplete AS]
>>> Jan 15 11:33:43 [20779] DBG:core:handle_tcp_child: dead tcp child
>>> 0 (pid 20771, no 0) (shutting down?)
>>> Jan 15 11:33:43 [20779] DBG:core:io_watch_del: io_watch_del
>>> (0x8174e80, 15, -1, 0x0) fd_no=16 called
>>> Jan 15 11:33:43 [20779] CRITICAL:core:receive_fd: EOF on 17
>>> Jan 15 11:33:43 [20779] DBG:core:handle_ser_child: dead child 7,
>>> pid 20771 (shutting down?)
>>> Jan 15 11:33:43 [20779] DBG:core:io_watch_del: io_watch_del
>>> (0x8174e80, 17, -1, 0x0) fd_no=15 called
>>>
>>>
>>> The SUBSCRIBE from OCS returns this 200 OK:
>>>
>>> SIP/2.0 200 OK
>>> Contact:
>>>
>>> <sip:OCSPool01.HMCINT.LOCAL;transport=tcp;ms-fe=HMCINTOCS.HMCINT.LOCAL>
>>> Authentication-Info: NTLM
>>> rspauth="0100000070B14E017817E85DC230F2DF", srand="B91383E2",
>>> snum="2", opaque="0FFEF1C7", qop="auth",
>>> targetname="HMCINTOCS.HMCINT.LOCAL", realm="SIP Communications
>>> Service"
>>> Content-Length: 8452
>>> From: "Uma
>>> Thurman"<sip:uma.thurman at hmcint.local
>>> >;transport=tcp;tag=D7DE4E07A70DEB0AF902F3F3ABBBA6D1
>>> To: sip:uma.thurman at hmcint.local:5060;transport=tcp;tag=33280080
>>> Call-ID: A19293DAF5E2116DE5D31992A298736
>>> CSeq: 1 SUBSCRIBE
>>> Via: SIP/2.0/TCP
>>>
>>> 10.107.109.108;branch=z9hG4bK398e.5338e871.0;ms-received-port=54613;ms-received-cid=6E00
>>> Expires: 43200
>>> Require: eventlist
>>> Content-Type: application/vnd-microsoft-roaming-self+xml
>>> Event: vnd-microsoft-roaming-self
>>> subscription-state: active;expires=43200
>>> ms-piggyback-cseq: 1
>>> Supported: ms-benotify, ms-piggyback-first-notify
>>>
>>> <roamingData
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/roaming-self"
>>> xmlns:cat="http://schemas.microsoft.com/2006/09/sip/categories"
>>> xmlns:con="http://schemas.microsoft.com/2006/09/sip/containers"
>>> xmlns:sub="
>>> http://schemas.microsoft.com/2006/09/sip/presence-subscribers">
>>> <categories
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/categories"
>>> uri="sip:uma.thurman at hmcint.local">
>>> <category name="calendarData" instance="0"
>>> publishTime="2008-12-03T13:19:10.797" container="32000"
>>> version="1" expireType="static"/>
>>> <category name="calendarData" instance="0"
>>> publishTime="2008-12-03T13:19:10.797" container="100" version="1"
>>> expireType="static"/>
>>> <category name="contactCard" instance="0"
>>> publishTime="2008-12-03T13:18:55.133" container="32000"
>>> version="4" expireType="static">
>>> <contactCard
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/contactcard" >
>>> <identity >
>>> <name >
>>> <displayName >
>>> Uma Thurman</displayName>
>>> </name>
>>> <email >
>>> uma.thurman at hmcint.local</email>
>>> </identity>
>>> </contactCard>
>>> </category>
>>> <category name="contactCard" instance="0"
>>> publishTime="2008-12-03T13:18:55.133" container="400" version="4"
>>> expireType="static">
>>> <contactCard
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/contactcard" >
>>> <identity >
>>> <name >
>>> <displayName >
>>> Uma Thurman</displayName>
>>> </name>
>>> <email >
>>> uma.thurman at hmcint.local</email>
>>> </identity>
>>> </contactCard>
>>> </category>
>>> <category name="contactCard" instance="0"
>>> publishTime="2008-12-03T13:18:55.133" container="300" version="4"
>>> expireType="static">
>>> <contactCard
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/contactcard" >
>>> <identity >
>>> <name >
>>> <displayName >
>>> Uma Thurman</displayName>
>>> </name>
>>> <email >
>>> uma.thurman at hmcint.local</email>
>>> </identity>
>>> </contactCard>
>>> </category>
>>> <category name="contactCard" instance="0"
>>> publishTime="2008-12-03T13:18:55.133" container="200" version="4"
>>> expireType="static">
>>> <contactCard
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/contactcard" >
>>> <identity >
>>> <name >
>>> <displayName >
>>> Uma Thurman</displayName>
>>> </name>
>>> <email >
>>> uma.thurman at hmcint.local</email>
>>> </identity>
>>> </contactCard>
>>> </category>
>>> <category name="contactCard" instance="0"
>>> publishTime="2008-12-03T13:18:55.133" container="100" version="4"
>>> expireType="static">
>>> <contactCard
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/contactcard" >
>>> <identity >
>>> <name >
>>> <displayName >
>>> Uma Thurman</displayName>
>>> </name>
>>> <email >
>>> uma.thurman at hmcint.local</email>
>>> </identity>
>>> </contactCard>
>>> </category>
>>> <category name="contactCard" instance="0"
>>> publishTime="2008-12-03T13:18:55.133" container="0" version="4"
>>> expireType="static">
>>> <contactCard
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/contactcard" >
>>> <identity >
>>> <name >
>>> <displayName >
>>> Uma Thurman</displayName>
>>> </name>
>>> <email >
>>> uma.thurman at hmcint.local</email>
>>> </identity>
>>> </contactCard>
>>> </category>
>>> <category name="note" instance="0"
>>> publishTime="2008-12-03T13:19:10.797" container="32000"
>>> version="1" expireType="static"/>
>>> <category name="note" instance="0"
>>> publishTime="2008-12-03T13:19:10.797" container="100" version="1"
>>> expireType="static"/>
>>> <category name="state" instance="0"
>>> publishTime="2008-12-03T13:19:10.797" container="32000"
>>> version="1" expireType="static">
>>> <state xmlns="http://schemas.microsoft.com/2006/09/sip/state"
>>> xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
>>> manual="false" xsi:type="aggregateState" ><availability
>>> >18500</availability><endpointLocation ></endpointLocation></state>
>>> </category>
>>> <category name="state" instance="0"
>>> publishTime="2009-01-14T15:06:10.723" container="400" version="1"
>>> expireType="static">
>>> <state xsi:type="aggregateState" lastActive="2009-01-14T15:06:10"
>>> xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/state
>>> "><availability>18000</availability></state>
>>> </category>
>>> <category name="state" instance="0"
>>> publishTime="2009-01-14T15:06:10.723" container="300" version="1"
>>> expireType="static">
>>> <state xsi:type="aggregateState" lastActive="2009-01-14T15:06:10"
>>> xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/state
>>> "><availability>18000</availability></state>
>>> </category>
>>> <category name="state" instance="0"
>>> publishTime="2009-01-14T15:06:10.723" container="200" version="1"
>>> expireType="static">
>>> <state xsi:type="aggregateState"
>>> xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/state
>>> "><availability>18000</availability></state>
>>> </category>
>>> <category name="state" instance="0"
>>> publishTime="2009-01-14T15:06:10.723" container="100" version="1"
>>> expireType="static">
>>> <state xsi:type="aggregateState"
>>> xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/state
>>> "><availability>18000</availability></state>
>>> </category>
>>> <category name="state" instance="0"
>>> publishTime="2009-01-14T15:06:10.723" container="3" version="1"
>>> expireType="static">
>>> <state xsi:type="aggregateState" lastActive="2009-01-14T15:06:10"
>>> xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/state
>>> "><availability>18000</availability></state>
>>> </category>
>>> <category name="state" instance="0"
>>> publishTime="2009-01-14T15:06:10.723" container="2" version="1"
>>> expireType="static">
>>> <state xsi:type="aggregateState" lastActive="2009-01-14T15:06:10"
>>> xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/state
>>> "><availability>18000</availability></state>
>>> </category>
>>> <category name="routing" instance="0"
>>> publishTime="2008-12-03T13:19:10.707" container="32000"
>>> version="1" expireType="static">
>>> <routing xmlns="http://schemas.microsoft.com/02/2006/sip/routing"
>>> name="rtcdefault" version="1" ><preamble ><flags
>>> name="clientflags" value="block" ></flags></preamble></routing>
>>> </category>
>>> <category name="legacyInterop" instance="0"
>>> publishTime="2008-12-03T13:18:55.133" container="32000"
>>> version="4" expireType="static">
>>> <legacyInterop availability="18500" />
>>> </category>
>>> <category name="legacyInterop" instance="0"
>>> publishTime="2009-01-14T15:06:10.723" container="400" version="1"
>>> expireType="static">
>>> <legacyInterop availability="18000" />
>>> </category>
>>> <category name="legacyInterop" instance="0"
>>> publishTime="2009-01-14T15:06:10.723" container="300" version="1"
>>> expireType="static">
>>> <legacyInterop availability="18000" />
>>> </category>
>>> <category name="legacyInterop" instance="0"
>>> publishTime="2009-01-14T15:06:10.723" container="200" version="1"
>>> expireType="static">
>>> <legacyInterop availability="18000" />
>>> </category>
>>> <category name="legacyInterop" instance="0"
>>> publishTime="2009-01-14T15:06:10.723" container="100" version="1"
>>> expireType="static">
>>> <legacyInterop availability="18000" />
>>> </category>
>>> <category name="services" instance="0"
>>> publishTime="2008-12-03T13:19:10.797" container="32000"
>>> version="1" expireType="static">
>>> <services xmlns="http://schemas.microsoft.com/2006/09/sip/service"
>>> ></services>
>>> </category>
>>> <category name="userInformation" instance="0"
>>> publishTime="2008-12-10T10:12:32.427" container="1" version="1"
>>> expireType="static">
>>> <userInformation
>>> xmlns="
>>> http://schemas.microsoft.com/2006/09/sip/options/userInformation"
>>> ><phones ><phone type="work" ><readOnly
>>> >true</readOnly><displayString >306</displayString><uri
>>> >tel:306;phone-context=dialstring</uri></phone><phone
>>> type="mobile" ></phone><phone type="home" ></phone><phone
>>> type="other" ></phone></phones></userInformation>
>>> </category>
>>> <category name="userProperties" instance="0"
>>> publishTime="2008-12-03T13:18:55.133" container="1" version="4"
>>> expireType="static">
>>> <userProperties >
>>> <lines >
>>> <line lineType="Uc" >
>>> tel:306</line>
>>> </lines>
>>> <telephonyMode >
>>> Uc</telephonyMode>
>>> </userProperties>
>>> </category>
>>> </categories>
>>> <containers
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/containers">
>>> <container id="32000" version="0"/>
>>> <container id="400" version="0"/>
>>> <container id="300" version="0"/>
>>> <container id="200" version="1">
>>> <member type="sameEnterprise"/>
>>> </container>
>>> <container id="100" version="1">
>>> <member type="federated"/>
>>> </container>
>>> <container id="3" version="0"/>
>>> <container id="2" version="0"/>
>>> <container id="1" version="0"/>
>>> <container id="0" version="0">
>>> <member type="everyone"/>
>>> </container>
>>> </containers>
>>> <subscribers
>>> xmlns="http://schemas.microsoft.com/2006/09/sip/presence-subscribers
>>> "/>
>>> </roamingData>
>>>
>>>
>>>
>>>
>>> This message makes OpenSips crash on
>>>
>>> 2009/1/15 Bogdan-Andrei Iancu <bogdan at voice-system.ro
>>> <mailto:bogdan at voice-system.ro>>
>>>
>>> Hi Antonio,
>>>
>>> Could you detail a bit please ? who is receiving the 200 OK
>>> and from where... What is the actual error? Also please
>>> describe your scenario.
>>>
>>> Regards,
>>> Bogdan
>>>
>>> Antonio Frongillo wrote:
>>>
>>> Hi,
>>> I'm experiencing an error in receiving 200 OK of REGISTER
>>> requests where are set several Contact Header.
>>> According to Sip Servlet specification it should be
>>> possible to receive messages with more than one Contact
>>> Header, actually I saw that with 8 Contact Header OpenSips
>>> crash always, with 2-3 Contact Header it seems to be stable.
>>>
>>> Could it be a bug or I'm missing something?
>>>
>>> Thanks in advance
>>> Antonio
>>>
>>> ------------------------------------------------------------------------
>>>
>>> _______________________________________________
>>> Users mailing list
>>> Users at lists.opensips.org <mailto:Users at lists.opensips.org>
>>> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>>>
>>>
>>>
>>>
>>> ------------------------------------------------------------------------
>>>
>>> _______________________________________________
>>> 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/20090115/22b9247b/attachment-0001.htm
More information about the Users
mailing list