Hello,
here is the stderr console output (just the last lines which should be
important as I saw there is a message size limit), and the gdb backtrace.
Do you see any hint for the crash?
Best regards
Sebastian
________________________________
Von: Anca-Maria Vamanu [mailto:[EMAIL PROTECTED]
Gesendet: Do 5/17/2007 16:57
An: Schumann Sebastian
Cc: [email protected]
Betreff: Re: [Users] OpenSER crashed with Segmentation Fault using
PresenceModule
Hello,
Please post the log and the gdb backtrace.
regards,
Anca Vamanu
Schumann Sebastian wrote:
Dear all
I am currently writing my final thesis and want to set up a Presence Core
therefore. I am using OpenSER as Presence Agent (with Registrar function or now
with separat Registrar, both configuration has the problem). It crashes after a
certain time and certain amount of watcher entries. I cannot replicate this or
deliminate to a certain action but it always happends, no matter if I clean up
the tables, restart the machine or whatever.
My configuration is one XCAP Server (XCAP Lite 1.0 from ag-projects, working
properly), one Registrar (OpenSER with MySQL DB, which forwards
SUBSCRIBE/PUBLISH to PA) and Presence Agent (OpenSER with Presence Module,
MySQL DB, XMLRPC Module) and Eyebeam 1.5 Clients. All runs on VMware virtual
machines.
I have just three clients that try to subscribe each other. Without any
Subscriptions everything works properly, XML data gets stored, PUBLISH is
processed etc. Subscribing one user by another is possible and works properly.
After allowing a watcher to subscription (using XCAP) and if the watcher logs
in next time, the state in the watcher table changes from pending to active. It
happens now and then, when a user goes online and one of his subscribed
presentities is not online, that the OpenSER PA crashes.
Analyzing DEBUG info and backtrace was not successful, because I found no
information or hints about it, just the message segmentation fault appears.
Does anyone have this problem as well or has anybody an idea about it? I can
provide you logs, the dump or traces if you need it.
Thanks for your help.
Sebastian
------------------------------------------------------------------------
0(4591) SIP Request:
0(4591) method: <SUBSCRIBE>
0(4591) uri: <sip:[EMAIL PROTECTED]>
0(4591) version: <SIP/2.0>
0(4591) parse_headers: flags=2
0(4591) Found param type 232, <branch> = <z9hG4bK0a73.6d721e06.0>; state=16
0(4591) end of header reached, state=5
0(4591) parse_headers: Via found, flags=2
0(4591) parse_headers: this is the first via
0(4591) After parse_msg...
0(4591) preparing to run routing scripts...
0(4591) parse_headers: flags=100
0(4591) Found param type 232, <branch> =
<z9hG4bK-d87543-666f5148e9613c52-1--d87543->; state=6
0(4591) Found param type 235, <rport> = <32800>; state=16
0(4591) end of header reached, state=5
0(4591) parse_headers: Via found, flags=100
0(4591) parse_headers: this is the second via
0(4591) DEBUG:maxfwd:is_maxfwd_present: value = 69
0(4591) DEBUG: t_newtran: T on entrance=0xffffffff
0(4591) parse_headers: flags=ffffffffffffffff
0(4591) DEBUG:parse_to:end of header reached, state=10
0(4591) DBUG:parse_to: display={}, ruri={sip:[EMAIL PROTECTED]
0(4591) DEBUG: get_hdr_field: <To> [25]; uri=[sip:[EMAIL PROTECTED]
0(4591) DEBUG: to body [<sip:[EMAIL PROTECTED]>
]
0(4591) get_hdr_field: cseq <CSeq>: <1> <SUBSCRIBE>
0(4591) DEBUG: get_hdr_body : content_length=0
0(4591) found end of header
0(4591) parse_headers: flags=78
0(4591) t_lookup_request: start searching: hash=14240, isACK=0
0(4591) DEBUG: RFC3261 transaction matching failed
0(4591) DEBUG: t_lookup_request: no transaction found
0(4591) parse_headers: flags=ffffffffffffffff
0(4591) PRESENCE: handle_subscribe:Missing or unsupported event header field
value
0(4591) parse_headers: flags=ffffffffffffffff
0(4591) check_via_address(10.96.115.125, 10.96.115.125, 0)
0(4591) PRESENCE:handle_subscribe: ERROR occured
0(4591) DEBUG:tm:UNREF_UNSAFE: after is 0
0(4591) DEBUG:destroy_avp_list: destroying list (nil)
0(4591) receive_msg: cleaning up
0(4591) SIP Request:
0(4591) method: <SUBSCRIBE>
0(4591) uri: <sip:[EMAIL PROTECTED]>
0(4591) version: <SIP/2.0>
0(4591) parse_headers: flags=2
0(4591) Found param type 232, <branch> = <z9hG4bKc989.6f967b16.0>; state=16
0(4591) end of header reached, state=5
0(4591) parse_headers: Via found, flags=2
0(4591) parse_headers: this is the first via
0(4591) After parse_msg...
0(4591) preparing to run routing scripts...
0(4591) parse_headers: flags=100
0(4591) Found param type 232, <branch> =
<z9hG4bK-d87543-4e0baf255d4f5c21-1--d87543->; state=6
0(4591) Found param type 235, <rport> = <32800>; state=16
0(4591) end of header reached, state=5
0(4591) parse_headers: Via found, flags=100
0(4591) parse_headers: this is the second via
0(4591) DEBUG:maxfwd:is_maxfwd_present: value = 69
0(4591) DEBUG: t_newtran: T on entrance=0xffffffff
0(4591) parse_headers: flags=ffffffffffffffff
0(4591) DEBUG:parse_to:end of header reached, state=10
0(4591) DBUG:parse_to: display={}, ruri={sip:[EMAIL PROTECTED]
0(4591) DEBUG: get_hdr_field: <To> [25]; uri=[sip:[EMAIL PROTECTED]
0(4591) DEBUG: to body [<sip:[EMAIL PROTECTED]>
]
0(4591) get_hdr_field: cseq <CSeq>: <1> <SUBSCRIBE>
0(4591) DEBUG: get_hdr_body : content_length=0
0(4591) found end of header
0(4591) parse_headers: flags=78
0(4591) t_lookup_request: start searching: hash=39068, isACK=0
0(4591) DEBUG: RFC3261 transaction matching failed
0(4591) DEBUG: t_lookup_request: no transaction found
0(4591) parse_headers: flags=ffffffffffffffff
0(4591) PRESENCE: handle_subscribe:Missing or unsupported event header field
value
0(4591) parse_headers: flags=ffffffffffffffff
0(4591) check_via_address(10.96.115.125, 10.96.115.125, 0)
0(4591) PRESENCE:handle_subscribe: ERROR occured
0(4591) DEBUG:tm:UNREF_UNSAFE: after is 0
0(4591) DEBUG:destroy_avp_list: destroying list (nil)
0(4591) receive_msg: cleaning up
0(4591) SIP Request:
0(4591) method: <SUBSCRIBE>
0(4591) uri: <sip:[EMAIL PROTECTED]>
0(4591) version: <SIP/2.0>
0(4591) parse_headers: flags=2
0(4591) Found param type 232, <branch> = <z9hG4bKe413.3434b775.0>; state=16
0(4591) end of header reached, state=5
0(4591) parse_headers: Via found, flags=2
0(4591) parse_headers: this is the first via
0(4591) After parse_msg...
0(4591) preparing to run routing scripts...
0(4591) parse_headers: flags=100
0(4591) Found param type 232, <branch> =
<z9hG4bK-d87543-2a56156bb30b720d-1--d87543->; state=6
0(4591) Found param type 235, <rport> = <32800>; state=16
0(4591) end of header reached, state=5
0(4591) parse_headers: Via found, flags=100
0(4591) parse_headers: this is the second via
0(4591) DEBUG:maxfwd:is_maxfwd_present: value = 69
0(4591) DEBUG: t_newtran: T on entrance=0xffffffff
0(4591) parse_headers: flags=ffffffffffffffff
0(4591) DEBUG:parse_to:end of header reached, state=10
0(4591) DBUG:parse_to: display={}, ruri={sip:[EMAIL PROTECTED]
0(4591) DEBUG: get_hdr_field: <To> [31]; uri=[sip:[EMAIL PROTECTED]
0(4591) DEBUG: to body [<sip:[EMAIL PROTECTED]>
]
0(4591) get_hdr_field: cseq <CSeq>: <1> <SUBSCRIBE>
0(4591) DEBUG: get_hdr_body : content_length=0
0(4591) found end of header
0(4591) parse_headers: flags=78
0(4591) t_lookup_request: start searching: hash=12622, isACK=0
0(4591) DEBUG: RFC3261 transaction matching failed
0(4591) DEBUG: t_lookup_request: no transaction found
0(4591) parse_headers: flags=ffffffffffffffff
0(4591) PRESENCE: handle_subscribe: 'expires' found
0(4591) PRESENCE: handle_subscribe: lexpire= 3600
0(4591) PRESENCE: handle_subscribe: 'To' header ALREADY PARSED: <sip:[EMAIL
PROTECTED]>
0(4591) PRESENCE:handle_subscribe: 'From' header not parsed
0(4591) DEBUG: add_param: tag=e035dc2e
0(4591) DEBUG:parse_to:end of header reached, state=29
0(4591) DBUG:parse_to: display={"Bob"}, ruri={sip:[EMAIL PROTECTED]
0(4591) PRESENCE:handle_subscribe: generating to_tag
0(4591) PRESENCE :proces_rr: out rr [<sip:10.96.115.125;lr=on;ftag=e035dc2e>]
0(4591)
[p_user]= sebastian [p_domain]= 10.96.115.125
[w_user]= bob [w_domain]= 10.96.115.125
0(4591) [event]= presence
[staus]= active
[expires]= 3600
0(4591) [to_tag]= 10.4591.1179421870.7
[from_tag]= e035dc2e
0(4591) PRESENCE: update_subscribtion ...
0(4591)
[p_user]= sebastian [p_domain]= 10.96.115.125
[w_user]= bob [w_domain]= 10.96.115.125
0(4591) [event]= presence
[staus]= active
[expires]= 3600
0(4591) [to_tag]= 10.4591.1179421870.7
[from_tag]= e035dc2e
0(4591) expires: 3600
0(4591) PRESENCE:update_subscribtion:Inserting into database:
n_query_cols:14
0(4591) [0] = to_user sebastian
0(4591) [1] = to_domain 10.96.115.125
0(4591) [2] = from_user bob
0(4591) [3] = from_domain 10.96.115.125
0(4591) [4] = event presence
0(4591) [5] = event_id
0(4591) [6] = callid YTUwN2U3MmViZDM3NDNmZDdkMTllNTQ4MDgyN2ExMDk.
0(4591) [7] = to_tag 10.4591.1179421870.7
0(4591) [8] = from_tag e035dc2e
0(4591) [9] = contact sip:[EMAIL PROTECTED]:32800
0(4591) [10] = status active
0(4591) [11] = cseq 1
0(4591) parse_headers: flags=ffffffffffffffff
0(4591) check_via_address(10.96.115.125, 10.96.115.125, 0)
0(4591) PRESENCE:get_subs_dialog:querying database table = active_watchers
0(4591) PRESENCE: get_subs_dialog:The query for subscribtion for [user]=
sebastian,[domain]= 10.96.115.125 for [event]= presence.winfo returned no result
0(4591) PRESENCE:query_db_notify: Could not get subs_dialog from database
0(4591) PRESENCE:update_subscribtion:Could not send notify for presence.winfo
0(4591) PRESENCE:notify:dialog informations:
0(4591)
[p_user]= sebastian [p_domain]= 10.96.115.125
[w_user]= bob [w_domain]= 10.96.115.125
0(4591) [event]= presence
[staus]= active
[expires]= 3600
0(4591) [to_tag]= 10.4591.1179421870.7
[from_tag]= e035dc2e
0(4591) PRESENCE:get_xcap_tree:The query in table xcap for [username]=sebastian
, domain=10.96.115.125 returned result 0(4591) PRESENCE:get_xcap_tree: xcap
body:
<?xml version="1.0" encoding="UTF-8"?>
<ruleset xmlns="urn:ietf:params:xml:ns:common-policy"
xmlns:pr="urn:ietf:params:xml:ns:pres-rules" xmlns:cp="www.counterpath.com/privacy-lists">
<rule id="whitelist">
<conditions>
<identity>
<id entity="sip:[EMAIL PROTECTED]"/>
</identity>
</conditions>
<actions>
<pr:sub-handling>allow</pr:sub-handling>
</actions>
<transformations>
<pr:provide-services>
<pr:all-services/>
</pr:provide-services>
<pr:provide-persons>
<pr:all-persons/>
</pr:provide-persons>
<pr:provide-devices>
<pr:all-devices/>
</pr:provide-devices>
<pr:provide-all-attributes/>
</transformations>
</rule>
<rule id="blacklist">
<conditions>
</conditions>
<actions>
<pr:sub-handling>block</pr:sub-handling>
</actions>
<transformations/>
</rule>
<cp:privacy-lists>
<cp:list name="whitelist_uri_phone">
</cp:list>
<cp:list name="blacklist_uri_phone">
</cp:list>
<cp:list name="whitelist_domain_phone">
</cp:list>
<cp:list name="blacklist_domain_phone">
</cp:list>
<cp:list name="whitelist_uri_IM">
</cp:list>
<cp:list name="blacklist_uri_IM">
</cp:list>
<cp:list name="whitelist_domain_IM">
</cp:list>
<cp:list name="blacklist_domain_IM">
</cp:list>
</cp:privacy-lists>
</ruleset> 0(4591) presence:uandd_to_uri: uri=sip:[EMAIL PROTECTED]
0(4591) PRESENCE:is_watcher_allowed:node1->name= rule
0(4591) PRESENCE:is_watcher_allowed:cond_node->name= conditions
0(4591) PRESENCE:is_watcher_allowed:actions_node->name= actions
0(4591) PRESENCE:is_watcher_allowed:sub_handling_node->name= sub-handling
0(4591) PRESENCE:is_watcher_allowed:sub_handling_node->content= allow
0(4591) PRESENCE:notify: [status]=active
0(4591) PRESENCE:get_p_notify_body: querying presentity
0(4591) PRESENCE: get_p_notify_body: The query returned no result
There is no presence information recorded forthe user
0(4591) PRESENCE:notify: Could not get the notify_body
0(4591) presence:uandd_to_uri: uri=sip:[EMAIL PROTECTED]
0(4591) PRESENCE: notify: build notify to user= bob domain= 10.96.115.125 for
event= presence
0(4591)
[p_user]= sebastian [p_domain]= 10.96.115.125
[w_user]= bob [w_domain]= 10.96.115.125
0(4591) [event]= presence
[staus]= active
[expires]= 3600
0(4591) [to_tag]= 10.4591.1179421870.7
[from_tag]= e035dc2e
0(4591) PRESENCE:build_str_hdr: expires = 3600
0(4591) PRESENCE:build_str_hdr: subs_expires : 3600
0(4591) PRESENCE: build_str_hdr: headers:
Event: presence
Contact: <sip:10.96.115.128:5060>
Subscription-State: active;expires=3600
Content-Type: application/pidf+xml
0(4591) PRESENCE:notify: headers:Event: presence
Contact: <sip:10.96.115.128:5060>
Subscription-State: active;expires=3600
Content-Type: application/pidf+xml
0(4591) CONTACT = sip:[EMAIL PROTECTED]:32800
0(4591) presence:uandd_to_uri: uri=sip:[EMAIL PROTECTED]
0(4591) DEBUG:tm:t_uac: next_hop=<sip:10.96.115.125;lr=on;ftag=e035dc2e>
0(4591) DEBUG: mk_proxy: doing DNS lookup...
0(4591) DEBUG:destroy_avp_list: destroying list (nil)
0(4591) DEBUG: dlg2hash: 12619
0(4591) print_request_uri: sip:[EMAIL PROTECTED]:32800
0(4591) DEBUG:tm:set_timer: relative timeout is 500000
0(4591) DEBUG: add_to_tail_of_timer[4]: 0xb5aaefec (41700000)
0(4591) DEBUG:tm:set_timer: relative timeout is 30
0(4591) DEBUG: add_to_tail_of_timer[0]: 0xb5aaf008 (71)
1(4592) DEBUG: timer routine:4,tl=0xb5aa825c next=0xb5aaefec, timeout=41700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aa8110, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 1000000
1(4592) DEBUG: add_to_tail_of_timer[5]: 0xb5aa825c (42700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:4,tl=0xb5aaefec next=(nil), timeout=41700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aaeea0, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 1000000
1(4592) DEBUG: add_to_tail_of_timer[5]: 0xb5aaefec (42700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:5,tl=0xb5aa825c next=0xb5aaefec, timeout=42700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aa8110, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 2000000
1(4592) DEBUG: add_to_tail_of_timer[6]: 0xb5aa825c (44700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:5,tl=0xb5aaefec next=(nil), timeout=42700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aaeea0, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 2000000
1(4592) DEBUG: add_to_tail_of_timer[6]: 0xb5aaefec (44700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:6,tl=0xb5aa825c next=0xb5aaefec, timeout=44700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aa8110, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aa825c (48700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:6,tl=0xb5aaefec next=(nil), timeout=44700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aaeea0, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aaefec (48700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:2,tl=0xb5aa9bc8 next=(nil), timeout=46
1(4592) DEBUG: wait_handler : removing 0xb5aa9b80 from table
1(4592) DEBUG: delete transaction 0xb5aa9b80
1(4592) DEBUG: wait_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aa825c next=0xb5aaefec, timeout=48700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aa8110, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aa825c (52700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aaefec next=(nil), timeout=48700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aaeea0, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aaefec (52700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aa825c next=0xb5aaefec, timeout=52700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aa8110, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aa825c (56700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aaefec next=(nil), timeout=52700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aaeea0, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aaefec (56700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aa825c next=0xb5aaefec, timeout=56700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aa8110, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aa825c (60700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aaefec next=(nil), timeout=56700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aaeea0, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aaefec (60700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aa825c next=0xb5aaefec, timeout=60700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aa8110, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aa825c (64700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aaefec next=(nil), timeout=60700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aaeea0, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aaefec (64700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aa825c next=0xb5aaefec, timeout=64700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aa8110, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aa825c (68700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aaefec next=(nil), timeout=64700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aaeea0, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aaefec (68700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aa825c next=0xb5aaefec, timeout=68700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aa8110, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aa825c (72700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aaefec next=(nil), timeout=68700000
1(4592) DEBUG: retransmission_handler : request resending (t=0xb5aaeea0, NOTIFY
si ... )
1(4592) DEBUG:tm:set_timer: relative timeout is 4000000
1(4592) DEBUG: add_to_tail_of_timer[7]: 0xb5aaefec (72700000)
1(4592) DEBUG: retransmission_handler : done
1(4592) DEBUG: timer routine:0,tl=0xb5aa8278 next=0xb5aaf008, timeout=71
1(4592) DEBUG: final_response_handler:stop retr. and send CANCEL (0xb5aa8110)
1(4592) DEBUG:tm:t_should_relay_response: T_code=0, new_code=408
1(4592) DEBUG:tm:t_pick_branch: picked branch 0, code 408
1(4592) DEBUG:tm:local_reply: branch=0, save=0, winner=0
1(4592) DEBUG:tm:local_reply: local transaction completed
1(4592) DBG: trans=0xb5aa8110, callback type 256, id 0 entered
1(4592) PRESENCE:p_tm_callback: completed with status 408
[watcher_id:0xb5aaa9cc/10.4591.1179421870.4]
1(4592) DEBUG: add_to_tail_of_timer[2]: 0xb5aa8158 (76)
1(4592) DEBUG: final_response_handler : done
1(4592) DEBUG: timer routine:0,tl=0xb5aaf008 next=(nil), timeout=71
1(4592) DEBUG: final_response_handler:stop retr. and send CANCEL (0xb5aaeea0)
1(4592) DEBUG:tm:t_should_relay_response: T_code=0, new_code=408
1(4592) DEBUG:tm:t_pick_branch: picked branch 0, code 408
1(4592) DEBUG:tm:local_reply: branch=0, save=0, winner=0
1(4592) DEBUG:tm:local_reply: local transaction completed
1(4592) DBG: trans=0xb5aaeea0, callback type 256, id 0 entered
1(4592) PRESENCE:p_tm_callback: completed with status 408
[watcher_id:0xb5aaacf4/10.4591.1179421870.7]
1(4592) DEBUG: add_to_tail_of_timer[2]: 0xb5aaeee8 (76)
1(4592) DEBUG: final_response_handler : done
1(4592) DEBUG: timer routine:7,tl=0xb5aa825c next=0xb5aaefec, timeout=72700000
1(4592) DEBUG: timer routine:7,tl=0xb5aaefec next=(nil), timeout=72700000
1(4592) DEBUG: timer routine:2,tl=0xb5aa8158 next=0xb5aaeee8, timeout=76
1(4592) DEBUG: wait_handler : removing 0xb5aa8110 from table
1(4592) DEBUG: delete transaction 0xb5aa8110
1(4592) DEBUG: wait_handler : done
1(4592) DEBUG: timer routine:2,tl=0xb5aaeee8 next=(nil), timeout=76
1(4592) DEBUG: wait_handler : removing 0xb5aaeea0 from table
1(4592) DEBUG: delete transaction 0xb5aaeea0
1(4592) DEBUG: wait_handler : done
1(4592) PRESENCE: msg_watchers_clean:cleaning pending subscriptions
1(4592) PRESENCE: msg_active_watchers_clean:cleaning expired watcher information
1(4592) PRESENCE:msg_presentity_clean:cleaning expired presentity information
1(4592) PRESENCE: msg_watchers_clean:cleaning pending subscriptions
1(4592) PRESENCE: msg_active_watchers_clean:cleaning expired watcher information
1(4592) PRESENCE:msg_presentity_clean:cleaning expired presentity information
------------------------------------------------------------------------
...
(no debugging symbols found)
Core was generated by `openser -f openser.cfg -w .'.
Program terminated with signal 11, Segmentation fault.
#0 0x0809e332 in fm_free ()
(gdb) bt
#0 0x0809e332 in fm_free ()
#1 0xb7b7d67a in handle_subscribe () from /usr/lib/openser/modules/presence.so
#2 0x08051224 in do_action ()
#3 0x08052f8c in run_action_list ()
#4 0x080521af in do_action ()
#5 0x08052f8c in run_action_list ()
#6 0x080525a1 in do_action ()
#7 0x08052f8c in run_action_list ()
#8 0x08053247 in run_top_route ()
#9 0x08074e04 in receive_msg ()
#10 0x0809832d in udp_rcv_loop ()
#11 0x080664f4 in main_loop ()
#12 0x08067f25 in main ()
(gdb) quit