[Serusers] sems - answ_machine fails with "signal 17 received"

Klaus Darilion darilion at ict.tuwien.ac.at
Fri Jul 25 19:49:09 CEST 2003


Hi!

I'm using todays CVS for ser and sems on redhat 9. As database module, I use
mysql. When ser routes a call to sems, sems fails with "signal 17 received".

The log of ans_machine and ser are following, attached are the config files.
both fifo are read/write for everybody.

The CVS version of sems didn't compiled and stoped with an error in
ans_machine.cpp: 'pair' was not declared in this scope
I solved this error by adding 
	#include <vector.h>
in ans_machine.cpp. Could this be the cause of the error?

regards and thank you for any hints,
Klaus

----------------
ans_machine log
----------------
 ./ans_machine -D 7 -E


Configuration:
       configuration file:  /etc/sems.conf
       Ser's FIFO:          /tmp/ser_fifo
       our FIFO:            /tmp/am_fifo
       plug-in path:        lib
       daemon mode:         0
       local IP:            128.131.80.136

(7522) INFO: run (AmServer.cpp:143): Loading application plug-ins
(7522) DEBUG: load (AmPlugIn.cpp:83): loading lib/apps/announcement.so ...
(7522) DEBUG: loadAppPlugIn (AmPlugIn.cpp:262): application 'announcement'
loaded.
(7522) DEBUG: reloadModuleConfig (SemsConfiguration.cpp:70): using inline
configuration for module announcement
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key: >>fork<<
value: >>yes<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>stderr<< value: >>no<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>loglevel<< value: >>1<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>fifo_name<< value: >>/tmp/am_fifo<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>ser_fifo_name<< value: >>/tmp/ser_fifo<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>plugin_path<< value: >>lib<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>smtp_server<< value: >>localhost<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>smtp_port<< value: >>25<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>config.voicemail<< value: >>inline<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:155): entered inline module
configuration for voicemail
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: voicemail key:
>>announce_path<< value: >>/var/greetings/obelix.ict.tuwien.ac.at/<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: voicemail key:
>>default_announce<< value: >>default.wav<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: voicemail key:
>>max_record_time<< value: >>30<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: voicemail key:
>>config.voicemail<< value: >>end<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:167): leaving inline module
configuration for voicemail
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>config.announcement<< value: >>inline<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:155): entered inline module
configuration for announcement
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: announcement
key: >>announce_path<< value: >>/var/greetings/obelix.ict.tuwien.ac.at/<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: announcement
key: >>default_announce<< value: >>default.wav<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: announcement
key: >>config.announcement<< value: >>end<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:167): leaving inline module
configuration for announcement
(7522) DEBUG: load (AmPlugIn.cpp:83): loading lib/apps/echo.so ...
(7522) DEBUG: loadAppPlugIn (AmPlugIn.cpp:262): application 'echo' loaded.
(7522) DEBUG: load (AmPlugIn.cpp:83): loading lib/apps/voicemail.so ...
(7522) DEBUG: loadAppPlugIn (AmPlugIn.cpp:262): application 'voicemail'
loaded.
(7522) DEBUG: reloadModuleConfig (SemsConfiguration.cpp:70): using inline
configuration for module voicemail
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key: >>fork<<
value: >>yes<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>stderr<< value: >>no<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>loglevel<< value: >>1<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>fifo_name<< value: >>/tmp/am_fifo<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>ser_fifo_name<< value: >>/tmp/ser_fifo<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>plugin_path<< value: >>lib<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>smtp_server<< value: >>localhost<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>smtp_port<< value: >>25<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>config.voicemail<< value: >>inline<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:155): entered inline module
configuration for voicemail
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: voicemail key:
>>announce_path<< value: >>/var/greetings/obelix.ict.tuwien.ac.at/<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: voicemail key:
>>default_announce<< value: >>default.wav<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: voicemail key:
>>max_record_time<< value: >>30<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: voicemail key:
>>config.voicemail<< value: >>end<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:167): leaving inline module
configuration for voicemail
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module:  key:
>>config.announcement<< value: >>inline<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:155): entered inline module
configuration for announcement
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: announcement
key: >>announce_path<< value: >>/var/greetings/obelix.ict.tuwien.ac.at/<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: announcement
key: >>default_announce<< value: >>default.wav<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:135): module: announcement
key: >>config.announcement<< value: >>end<<
(7522) DEBUG: reloadFile (SemsConfiguration.cpp:167): leaving inline module
configuration for announcement
(7522) INFO: run (AmServer.cpp:147): Loading audio plug-ins
(7522) DEBUG: load (AmPlugIn.cpp:83): loading lib/audio/gsm.so ...
(7522) DEBUG: loadAudioPlugIn (AmPlugIn.cpp:199): codec id 3 inserted
(7522) DEBUG: loadAudioPlugIn (AmPlugIn.cpp:214): payload 'GSM'inserted with
id 3 
(7522) DEBUG: load (AmPlugIn.cpp:83): loading lib/audio/wav.so ...
(7522) DEBUG: loadAudioPlugIn (AmPlugIn.cpp:199): codec id 1 inserted
(7522) DEBUG: loadAudioPlugIn (AmPlugIn.cpp:199): codec id 2 inserted
(7522) DEBUG: loadAudioPlugIn (AmPlugIn.cpp:214): payload 'PCMU'inserted
with id 0 
(7522) DEBUG: loadAudioPlugIn (AmPlugIn.cpp:214): payload 'PCMU'inserted
with id 8 
(7522) DEBUG: loadAudioPlugIn (AmPlugIn.cpp:238): file format Wav inserted
(7522) INFO: run (AmServer.cpp:151): Starting session container
(7522) INFO: run (AmServer.cpp:154): Starting mailer
(7522) INFO: run (AmServer.cpp:157): FIFO waiting for work...



(7522) DEBUG: run (AmServer.cpp:170): version= <0.2>
(7522) DEBUG: run (AmServer.cpp:175): fct_name= <sip_request.voicemail>
(7522) DEBUG: execute (AmServer.cpp:230): cmd.method= <INVITE>
(7522) DEBUG: execute (AmServer.cpp:231): cmd.user= <testuser>
(7522) DEBUG: execute (AmServer.cpp:232): cmd.email=
<darilion at ict.tuwien.ac.at>
(7522) DEBUG: execute (AmServer.cpp:233): cmd.domain=
<obelix.ict.tuwien.ac.at>
(7522) DEBUG: execute (AmServer.cpp:234): cmd.dstip= <128.131.80.136>
(7522) DEBUG: execute (AmServer.cpp:235): cmd.port= <5060>
(7522) DEBUG: execute (AmServer.cpp:236): cmd.r_uri=
<sip:testuser at obelix.ict.tuwien.ac.at>
(7522) DEBUG: execute (AmServer.cpp:237): cmd.from_uri=
<sip:128.131.80.218:6997>
(7522) DEBUG: execute (AmServer.cpp:238): cmd.from=
<"testuser2 at obelix.ict.tuwien.ac.at"
<sip:testuser2 at obelix.ict.tuwien.ac.at>>
(7522) DEBUG: execute (AmServer.cpp:239): cmd.to=
<<sip:testuser at obelix.ict.tuwien.ac.at>>
(7522) DEBUG: execute (AmServer.cpp:240): cmd.callid=
<c88b8a17f734476d9fe80a16c44dd43c at 128.131.80.218>
(7522) DEBUG: execute (AmServer.cpp:241): cmd.from_tag=
<4f793f7afa1a4824976ad05508a58f6e>
(7522) DEBUG: execute (AmServer.cpp:242): cmd.to_tag= <>
(7522) DEBUG: execute (AmServer.cpp:245): cseq_str= <1>
(7522) DEBUG: execute (AmServer.cpp:250): cseq= <1>(1)
(7522) DEBUG: execute (AmServer.cpp:252): cmd.key= <64319:207254857>
(7522) DEBUG: execute (AmServer.cpp:253): cmd.route= <>
(7522) DEBUG: execute (AmServer.cpp:254): cmd.next_hop= <>
(7522) DEBUG: execute (AmServer.cpp:260): hdrs: `'
(7522) DEBUG: execute (AmServer.cpp:267): body: `v=0
o=- 0 0 IN IP4 128.131.80.218
s=session
c=IN IP4 128.131.80.218
b=CT:1000
t=0 0
m=audio 33678 RTP/AVP 97 111 112 6 0 8 4 5 3 101
k=base64:qNIq14h/mD0Jkylif9937MdxeXqvCF2SRHLus9Pl03o
a=rtpmap:97 red/8000
a=rtpmap:111 SIREN/16000
a=fmtp:111 bitrate=16000
a=rtpmap:112 G7221/16000
a=fmtp:112 bitrate=24000
a=rtpmap:6 DVI4/16000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:4 G723/8000
a=rtpmap:5 DVI4/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=encryption:optional
'
(7522) DEBUG: execute (AmServer.cpp:278): everything is OK !
(7522) DEBUG: onInvite (AnswerMachine.cpp:92): email address for user
'testuser': darilion at ict.tuwien.ac.at
(7521) DEBUG: sig_usr (ans_machine.cpp:71): signal 17 received
[root at obelix answer_machine]# 


----------------------------------------------------------------------------
-------------
ser log (only the part with the request) (there was also REGISTER request in
between)
----------------------------------------------------------------------------
-------------

0(7525) SIP Request:
 0(7525)  method:  <INVITE>
 0(7525)  uri:     <sip:testuser at obelix.ict.tuwien.ac.at>
 0(7525)  version: <SIP/2.0>
 0(7525) parse_headers: flags=1
 0(7525) end of header reached, state=5
 0(7525) parse_headers: Via found, flags=1
 0(7525) parse_headers: this is the first via
 0(7525) After parse_msg...
 0(7525) preparing to run routing scripts...
 0(7525) lookup(): 'testuser' Not found in usrloc
 0(7525) DEBUG : is_maxfwd_present: searching for max_forwards header
 0(7525) parse_headers: flags=128
 0(7525) DEBUG: is_maxfwd_present: value = 70 
 0(7525) parse_headers: flags=8
 0(7525) DEBUG: add_param: tag=4f793f7afa1a4824976ad05508a58f6e
 0(7525) DEBUG: add_param: epid=88cfc9fc75
 0(7525) end of header reached, state=29
 0(7525) parse_headers: flags=256
 0(7525) end of header reached, state=9
 0(7525) DEBUG: get_hdr_field: <To> [40];
uri=[sip:testuser at obelix.ict.tuwien.ac.at] 
 0(7525) DEBUG: to body [<sip:testuser at obelix.ict.tuwien.ac.at>
]
 0(7525) get_hdr_field: cseq <CSeq>: <1> <INVITE>
 0(7525) DEBUG: get_hdr_body : content_length=527
 0(7525) found end of header
 0(7525) find_first_route(): No Route headers found
 0(7525) loose_route(): There is no Route HF
 0(7525) check_self - checking if host==us: 23==14 &&
[obelix.ict.tuwien.ac.at] == [128.131.80.136]
 0(7525) DEBUG: t_addifnew: msg id=1 , global msg id=0 , T on
entrance=0xffffffff
 0(7525) parse_headers: flags=-1
 0(7525) parse_headers: flags=60
 0(7525) t_lookup_request: start searching: hash=64319, isACK=0
 0(7525) DEBUG: proceeding to pre-RFC3261 transaction matching
 0(7525) DEBUG: t_lookup_request: no transaction found
 0(7525) DEBUG: t_check: msg id=1 global id=1 T start=0x422b90f0
 0(7525) DEBUG: t_check: T alredy found!
 0(7525) parse_headers: flags=-1
 0(7525) check_via_address(128.131.80.218, 128.131.80.218, 0)
 0(7525) DEBUG: reply sent out. buf=0x80b9020: SIP/2.0 1...,
shmem=0x422ba1d8: SIP/2.0 1
 0(7525) DEBUG: t_reply: finished
 0(7525) **************** vm start - begin ******************
 0(7525) parse_headers: flags=-1
 0(7525) DEBUG: t_check: msg id=1 global id=1 T start=0x422b90f0
 0(7525) DEBUG: t_check: T alredy found!
 0(7525) DEBUG: vm: ******* contacts: *******
 0(7525) DEBUG:           sip:128.131.80.218:6997
 0(7525) DEBUG: vm: **** end of contacts ****
 0(7525) vm: calculated route: 
 0(7525) vm: next r-uri: sip:128.131.80.218:6997
 0(7525) parse_headers: flags=-1
 0(7525) vm: write_to_vm_fifo: <0.2
sip_request.voicemail
INVITE
testuser
darilion at ict.tuwien.ac.at
obelix.ict.tuwien.ac.at
128.131.80.136
5060
sip:testuser at obelix.ict.tuwien.ac.at
sip:128.131.80.218:6997
"testuser2 at obelix.ict.tuwien.ac.at" <sip:testuser2 at obelix.ict.tuwien.ac.at>
<sip:testuser at obelix.ict.tuwien.ac.at>
c88b8a17f734476d9fe80a16c44dd43c at 128.131.80.218
4f793f7afa1a4824976ad05508a58f6e
.
1
64319:207254857
.
.
.
v=0
o=- 0 0 IN IP4 128.131.80.218
s=session
c=IN IP4 128.131.80.218
b=CT:1000
t=0 0
m=audio 33678 RTP/AVP 97 111 112 6 0 8 4 5 3 101
k=base64:qNIq14h/mD0Jkylif9937MdxeXqvCF2SRHLus9Pl03o
a=rtpmap:97 red/8000
a=rtpmap:111 SIREN/16000
a=fmtp:111 bitrate=16000
a=rtpmap:112 G7221/16000
a=fmtp:112 bitrate=24000
a=rtpmap:6 DVI4/16000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:4 G723/8000
a=rtpmap:5 DVI4/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=encryption:optional

>
 0(7525) DEBUG: write_to_vm_fifo: write completed
 0(7525) DEBUG: add_to_tail_of_timer[0]: 0x422b923c
 0(7525) **************** vm start - end ******************
 0(7525) receive_msg: cleaning up
 0(7525) SIP Request:
 0(7525)  method:  <REGISTER>
 0(7525)  uri:     <sip:obelix.ict.tuwien.ac.at>
 0(7525)  version: <SIP/2.0>
 0(7525) parse_headers: flags=1
 0(7525) end of header reached, state=5
 0(7525) parse_headers: Via found, flags=1
 0(7525) parse_headers: this is the first via
 0(7525) After parse_msg...
 0(7525) preparing to run routing scripts...
 0(7525) lookup(): '' Not found in usrloc
 0(7525) DEBUG : is_maxfwd_present: searching for max_forwards header
 0(7525) parse_headers: flags=128
 0(7525) end of header reached, state=9
 0(7525) DEBUG: get_hdr_field: <To> [37];
uri=[sip:kurth at obelix.ict.tuwien.ac.at] 
 0(7525) DEBUG: to body [<sip:kurth at obelix.ict.tuwien.ac.at>
]
 0(7525) get_hdr_field: cseq <CSeq>: <1> <REGISTER>
 0(7525) DEBUG: get_hdr_body : content_length=0
 0(7525) found end of header
 0(7525) DEBUG: is_maxfwd_present: max_forwards header not found!
 0(7525) DEBUG: add_param: tag=0422f6c4-5608-4e5f-9526-79275e6d920e
 0(7525) end of header reached, state=29
 0(7525) parse_headers: flags=256
 0(7525) find_first_route(): No Route headers found
 0(7525) loose_route(): There is no Route HF
 0(7525) parse_headers: flags=-1
 0(7525) check_via_address(128.131.80.37, 128.131.80.37, 0)
 0(7525) receive_msg: cleaning up
 1(7527) DEBUG: timer routine:0,tl=0x422b923c next=(nil)
 1(7527) DEBUG: FR_handler:stop retr. and send CANCEL (0x422b90f0)
 1(7527) ->>>>>>>>> T_code=100, new_code=408
 1(7527) DEBUG: relay_reply: branch=0, save=0, relay=0
 1(7527) parse_headers: flags=-1
 1(7527) check_via_address(128.131.80.218, 128.131.80.218, 0)
 1(7527) DEBUG: reply relayed. buf=0x80b8778: SIP/2.0 4...,
shmem=0x422ba1d8: SIP/2.0 4
 1(7527) DEBUG: add_to_tail_of_timer[4]: 0x422b91a8
 1(7527) DEBUG: add_to_tail_of_timer[0]: 0x422b91c0
 1(7527) DEBUG: final_response_handler : done
 0(7525) SIP Request:
 0(7525)  method:  <ACK>
 0(7525)  uri:     <sip:testuser at obelix.ict.tuwien.ac.at>
 0(7525)  version: <SIP/2.0>
 0(7525) parse_headers: flags=1
 0(7525) end of header reached, state=5
 0(7525) parse_headers: Via found, flags=1
 0(7525) parse_headers: this is the first via
 0(7525) After parse_msg...
 0(7525) DEBUG : sl_filter_ACK: to late to be a local ACK!
 0(7525) preparing to run routing scripts...
 0(7525) lookup(): 'testuser' Not found in usrloc
 0(7525) DEBUG : is_maxfwd_present: searching for max_forwards header
 0(7525) parse_headers: flags=128
 0(7525) DEBUG: is_maxfwd_present: value = 70 
 0(7525) parse_headers: flags=8
 0(7525) DEBUG: add_param: tag=4f793f7afa1a4824976ad05508a58f6e
 0(7525) DEBUG: add_param: epid=88cfc9fc75
 0(7525) end of header reached, state=29
 0(7525) parse_headers: flags=256
 0(7525) DEBUG: add_param: tag=58ff021f53ab5af6efbf188c434a3c48-8561
 0(7525) end of header reached, state=29
 0(7525) DEBUG: get_hdr_field: <To> [82];
uri=[sip:testuser at obelix.ict.tuwien.ac.at] 
 0(7525) DEBUG: to body [<sip:testuser at obelix.ict.tuwien.ac.at>]
 0(7525) get_hdr_field: cseq <CSeq>: <1> <ACK>
 0(7525) DEBUG: get_hdr_body : content_length=0
 0(7525) found end of header
 0(7525) find_first_route(): No Route headers found
 0(7525) loose_route(): There is no Route HF
 0(7525) check_self - checking if host==us: 23==14 &&
[obelix.ict.tuwien.ac.at] == [128.131.80.136]
 0(7525) DEBUG: t_addifnew: msg id=3 , global msg id=1 , T on
entrance=0xffffffff
 0(7525) parse_headers: flags=-1
 0(7525) parse_headers: flags=60
 0(7525) t_lookup_request: start searching: hash=64319, isACK=1
 0(7525) DEBUG: proceeding to pre-RFC3261 transaction matching
 0(7525) DEBUG: non-2xx ACK matched
 0(7525) DEBUG: t_lookup_request: transaction found (T=0x422b90f0)
 0(7525) DEBUG: cleanup_uacs: RETR/FR timers reset
 0(7525) DEBUG: add_to_tail_of_timer[2]: 0x422b9138
 0(7525) receive_msg: cleaning up
 1(7527) DEBUG: timer routine:0,tl=0x422b91c0 next=(nil)
 1(7527) DEBUG: timer routine:4,tl=0x422b91a8 next=(nil)
 1(7527) DEBUG: timer routine:2,tl=0x422b9138 next=(nil)
 1(7527) DEBUG: wait_handler : removing 0x422b90f0 from table 
 1(7527) DEBUG: delete transaction 0x422b90f0
 1(7527) DEBUG: wait_handler : done
-------------- next part --------------
A non-text attachment was scrubbed...
Name: sems.conf
Type: application/octet-stream
Size: 2792 bytes
Desc: not available
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20030725/59a68f20/attachment.obj>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: ser.cfg
Type: application/octet-stream
Size: 6043 bytes
Desc: not available
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20030725/59a68f20/attachment-0001.obj>


More information about the sr-users mailing list