[OpenSIPS-Users] Contact Header Crash

Bogdan-Andrei Iancu bogdan at voice-system.ro
Fri Jan 16 11:24:33 CET 2009


Hi Antonio,

Thanks for trouble shooting - you are correct, the module should be 
proofed to such issues (like insufficient buffer) and not crash. I will 
fwd this to the people working on this module.

regards,
Bogdan

Antonio Frongillo wrote:
> 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 
> <mailto: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
>     <mailto: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
>     <mailto: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> <mailto: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>
>                <mailto: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>
>             <mailto: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 <mailto:Users at lists.opensips.org>
>             http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>              
>
>
>
>




More information about the Users mailing list