Don't know what I did Wrong with My Asterisk Box

Hi all,

I have a Box running Asterisk 1.2.9.1 on Fedora Core 5. It was working perfectly with few extensions until I created 50 additional extensions. The problem now is every extension I call keep going to voice mail. I then disable voice mail for extensions and still getting extension not available when its actually available.

someone pls help. Here is my log file.

var/log/asterisk/full - last 2000 lines

Jul 18 15:29:34 VERBOSE[1841] logger.c: == Parsing ‘/etc/asterisk/sip_additional.conf’: Jul 18 15:29:34 VERBOSE[1841] logger.c: == Parsing ‘/etc/asterisk/sip_additional.conf’: Found
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘cdr_csv.so’ (Comma Separated Values CDR Backend)
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘app_voicemail.so’ (Comedian Mail (Voicemail System))
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/voicemail.conf’: Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/voicemail.conf’: Found
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/vm_general.inc’: Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/vm_general.inc’: Found
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/vm_email.inc’: Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/vm_email.inc’: Found
Jul 18 15:29:34 DEBUG[3013] app_voicemail.c: VM CID Info before msg disabled globally
Jul 18 15:29:34 DEBUG[3013] app_voicemail.c: Send Voicemail msg disabled globally
Jul 18 15:29:34 DEBUG[3013] app_voicemail.c: ENVELOPE before msg enabled globally
Jul 18 15:29:34 DEBUG[3013] app_voicemail.c: Duration info before msg enabled globally
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘app_meetme.so’ (MeetMe conference bridge)
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/meetme.conf’: Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/meetme.conf’: Found
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/meetme_additional.conf’: Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/meetme_additional.conf’: Found
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘codec_ulaw.so’ (Mu-law Coder/Decoder)
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘app_queue.so’ (True Call Queueing)
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/queues.conf’: Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/queues.conf’: Found
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/queues_additional.conf’: Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/queues_additional.conf’: Found
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘codec_gsm.so’ (GSM/PCM16 (signed linear) Codec Translator)
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘app_hasnewvoicemail.so’ (Indicator for whether a voice mailbox has messages in a given folder.)
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘cdr_custom.so’ (Customizable Comma Separated Values CDR Backend)
Jul 18 15:29:34 WARNING[3013] cdr_custom.c: Failed to reload configuration file.
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘app_enumlookup.so’ (ENUM Lookup)
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/enum.conf’: Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/enum.conf’: Found
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘codec_g726.so’ (ITU G.726-32kbps G726 Transcoder)
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘cdr_manager.so’ (Asterisk Call Manager CDR Backend)
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘codec_alaw.so’ (A-law Coder/Decoder)
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘cdr_addon_mysql.so’ (MySQL CDR Backend)
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Unregistered ‘mysql’ CDR backend
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/cdr_mysql.conf’: Jul 18 15:29:34 VERBOSE[3013] logger.c: == Parsing ‘/etc/asterisk/cdr_mysql.conf’: Found
Jul 18 15:29:34 WARNING[3013] cdr_addon_mysql.c: MySQL database sock file not specified. Using default
Jul 18 15:29:34 NOTICE[3013] cdr_addon_mysql.c: MySQL database table not specified. Assuming "cdr"
Jul 18 15:29:34 DEBUG[3013] cdr_addon_mysql.c: cdr_mysql: got hostname of localhost
Jul 18 15:29:34 DEBUG[3013] cdr_addon_mysql.c: cdr_mysql: got port of 0
Jul 18 15:29:34 DEBUG[3013] cdr_addon_mysql.c: cdr_mysql: got a timeout of 0
Jul 18 15:29:34 DEBUG[3013] cdr_addon_mysql.c: cdr_mysql: got user of asteriskuser
Jul 18 15:29:34 DEBUG[3013] cdr_addon_mysql.c: cdr_mysql: got dbname of asteriskcdrdb
Jul 18 15:29:34 DEBUG[3013] cdr_addon_mysql.c: cdr_mysql: got password of amp109
Jul 18 15:29:34 DEBUG[3013] cdr_addon_mysql.c: Successfully connected to MySQL database.
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘codec_lpc10.so’ (LPC10 2.4kbps (signed linear) Voice Coder)
Jul 18 15:29:34 VERBOSE[3013] logger.c: – Reloading module ‘codec_adpcm.so’ (Adaptive Differential PCM Coder/Decoder)
Jul 18 15:29:34 DEBUG[3013] manager.c: Manager received command 'Logoff’
Jul 18 15:29:34 VERBOSE[3013] logger.c: == Manager ‘admin’ logged off from 127.0.0.1
Jul 18 15:29:34 VERBOSE[2987] logger.c: == Manager ‘admin’ logged off from 127.0.0.1
Jul 18 15:29:39 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘035dbaaf1e0493ba3d2c81587cf724dd@10.0.15.254’ of Request 102: Match Found
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Challenge’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Login’
Jul 18 15:29:39 VERBOSE[3021] logger.c: == Parsing ‘/etc/asterisk/manager.conf’: Jul 18 15:29:39 VERBOSE[3021] logger.c: == Parsing ‘/etc/asterisk/manager.conf’: Found
Jul 18 15:29:39 WARNING[3021] config.c: Unknown directive ‘’ at line 28 of manager.conf
Jul 18 15:29:39 DEBUG[3021] acl.c: 0.0.0.0/0.0.0.0/0.0.0.0 appended to acl for peer
Jul 18 15:29:39 DEBUG[3021] acl.c: 127.0.0.1/255.255.255.0/255.255.255.0 appended to acl for peer
Jul 18 15:29:39 DEBUG[3021] acl.c: ##### Testing 127.0.0.1 with 0.0.0.0
Jul 18 15:29:39 DEBUG[3021] acl.c: ##### Testing 127.0.0.1 with 127.0.0.0
Jul 18 15:29:39 VERBOSE[3021] logger.c: == Manager ‘admin’ logged on from 127.0.0.1
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1143’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1140’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1114’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1104’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1003’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1119’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1107’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1134’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1141’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1000’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1136’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1123’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1002’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1147’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1142’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1116’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1110’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1145’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1001’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1148’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1121’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1004’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1115’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1117’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1146’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1118’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1102’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1131’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1113’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1138’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1135’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1126’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1005’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1112’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1152’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1109’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1127’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1139’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1132’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1105’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1124’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1151’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1122’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1108’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1100’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1006’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1130’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1137’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1120’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1149’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1150’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1128’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1125’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1153’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1129’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1103’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1144’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1133’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1106’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1111’ in family 'cfb’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1143’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1140’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1114’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1104’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1003’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1119’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1107’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1134’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1141’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1000’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1136’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1123’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1002’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1147’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1142’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1116’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1110’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1145’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1001’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1148’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1121’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1004’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1115’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1117’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1146’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1118’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1102’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1131’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1113’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1138’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1135’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1126’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1005’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1112’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1152’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1109’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1127’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1139’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1132’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1105’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1124’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1151’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1122’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1108’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1100’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1006’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1130’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1137’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1120’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1149’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1150’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1128’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1125’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1153’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1129’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1103’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1144’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1133’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1106’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] db.c: Unable to find key ‘SIP/1111’ in family 'dnd’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'QueueStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Status’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'ZapShowChannels’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'MailboxStatus’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:39 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:40 DEBUG[3021] manager.c: Manager received command 'MailboxCount’
Jul 18 15:29:40 DEBUG[3021] manager.c: Manager received command 'MailboxCount’
Jul 18 15:29:40 DEBUG[3021] manager.c: Manager received command 'MailboxCount’
Jul 18 15:29:40 DEBUG[3021] manager.c: Manager received command 'MailboxCount’
Jul 18 15:29:40 DEBUG[3021] manager.c: Manager received command 'MailboxCount’
Jul 18 15:29:40 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘6d2634bc317739834d906eca10e7bab8@10.0.15.254’ of Request 102: Match Found
Jul 18 15:29:40 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘183fe1174defd935083aeda7567e071a@10.0.15.254’ of Request 102: Match Found
Jul 18 15:29:40 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘0cae2f897113a4c27d68f12a15807606@10.0.15.254’ of Request 102: Match Found
Jul 18 15:29:40 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘4b8384c6332d797c6b64300a2ad833fe@10.0.15.254’ of Request 102: Match Found
Jul 18 15:29:41 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘4136133a5f3aa6f41c67284d195e4d2a@10.0.15.254’ of Request 102: Match Found
Jul 18 15:29:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:29:46 DEBUG[1841] chan_sip.c: Setting NAT on RTP to 0
Jul 18 15:29:46 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘cb2694398f6ca33aYTEyNDdiNWZiYTgyMmUyODNhZDA2OWNmM2YwYWRjYjc.’ of Response 1: Match Found
Jul 18 15:29:46 DEBUG[1841] chan_sip.c: Setting NAT on RTP to 0
Jul 18 15:29:46 DEBUG[1841] chan_sip.c: Checking SIP call limits for device 1001
Jul 18 15:29:46 DEBUG[1841] chan_sip.c: build_route: Contact hop:
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Macro(“SIP/1001-4b87”, “exten-vm|1006|1006”) in new stack
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Macro(“SIP/1001-4b87”, “user-callerid”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing GotoIf(“SIP/1001-4b87”, “0?report”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Not taking any branch
Jul 18 15:29:46 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing GotoIf(“SIP/1001-4b87”, “0?start”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Not taking any branch
Jul 18 15:29:46 DEBUG[3022] pbx.c: Function result is '1001’
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “REALCALLERIDNUM=1001”) in new stack
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing NoOp(“SIP/1001-4b87”, “REALCALLERIDNUM is 1001”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Function result is '1001’
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “AMPUSER=1001”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Function result is 'Kayode Akintunde’
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “AMPUSERCIDNAME=Kayode Akintunde”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing GotoIf(“SIP/1001-4b87”, “0?report”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Not taking any branch
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “CALLERID(all)=Kayode Akintunde <1001>”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Function result is '“Kayode Akintunde” <1001>'
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing NoOp(“SIP/1001-4b87”, “Using CallerID “Kayode Akintunde” <1001>”) in new stack
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “FROMCONTEXT=exten-vm”) in new stack
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “VMBOX=1006”) in new stack
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “EXTTOCALL=1006”) in new stack
Jul 18 15:29:46 DEBUG[3022] db.c: Unable to find key ‘1006’ in family 'CFU’
Jul 18 15:29:46 DEBUG[3022] func_db.c: DB: CFU/1006 not found in database.
Jul 18 15:29:46 DEBUG[3022] pbx.c: Function result is ''
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “CFUEXT=”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Expression result is '1’
Jul 18 15:29:46 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:46 DEBUG[3022] pbx.c: Expression result is '1’
Jul 18 15:29:46 DEBUG[3022] pbx.c: Function result is '30’
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “RT=30”) in new stack
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Macro(“SIP/1001-4b87”, “record-enable|1006|IN”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Function result is '0’
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing GotoIf(“SIP/1001-4b87”, “0 > 0?2:4”) in new stack
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Goto (macro-record-enable,s,4)
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing AGI(“SIP/1001-4b87”, “recordingcheck|20060718-152946|1153232986.14”) in new stack
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
Jul 18 15:29:46 VERBOSE[3022] logger.c: recordingcheck|20060718-152946|1153232986.14: Inbound recording not enabled
Jul 18 15:29:46 VERBOSE[3022] logger.c: – AGI Script recordingcheck completed, returning 0
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing NoOp(“SIP/1001-4b87”, “No recording needed”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing GotoIf(“SIP/1001-4b87”, “0?dolocaldial|1”) in new stack
Jul 18 15:29:46 DEBUG[3022] pbx.c: Not taking any branch
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing Macro(“SIP/1001-4b87”, “dial|30|tr|1006”) in new stack
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Executing AGI(“SIP/1001-4b87”, “dialparties.agi”) in new stack
Jul 18 15:29:46 VERBOSE[3022] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi: Starting New Dialparties.agi
Jul 18 15:29:46 VERBOSE[3022] logger.c: – dialparties.agi: priority is 1
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi: Caller ID name is ‘Kayode Akintunde’ number is '1001’
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi: Methodology of ring is 'none’
Jul 18 15:29:46 VERBOSE[3022] logger.c: – dialparties.agi: Added extension 1006 to extension map
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi: Extension 1006 has call forward set to Invalid command syntax. Proper usage follows:
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi: Usage: DATABASE GET
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi: Retrieves an entry in the Asterisk database for a
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi: given family and key.
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi: Returns 0 if is not set. Returns 1 if
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi: is set and returns the variable in parentheses.
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi: Example return code: 200 result=1 (testvariable)
Jul 18 15:29:46 VERBOSE[3022] logger.c: dialparties.agi:
Jul 18 15:29:47 VERBOSE[3022] logger.c: – AGI Script dialparties.agi completed, returning 0
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing Dial(“SIP/1001-4b87”, “Local/Invalid command syntax. Proper usage follows:n Usage: DATABASE GET n Retrieves an entry in the Asterisk database for an given family and key.n Returns 0 if is not set. Returns 1 if n is set and returns the variable in parentheses.n Example return code: 200 result=1 (testvariable)n@from-internal/n|30|tr”) in new stack
Jul 18 15:29:47 NOTICE[3022] chan_local.c: No such extension/context Invalid command syntax. Proper usage follows:n Usage: DATABASE GET Jul 18 15:29:47 NOTICE[3022] app_dial.c: Unable to create channel of type ‘Local’ (cause 0 - Unknown)
Jul 18 15:29:47 VERBOSE[3022] logger.c: == Everyone is busy/congested at this time (1:0/0/1)
Jul 18 15:29:47 DEBUG[3022] app_dial.c: Exiting with DIALSTATUS=CHANUNAVAIL.
Jul 18 15:29:47 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:47 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:47 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing GosubIf(“SIP/1001-4b87”, “0?docfu|1”) in new stack
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing NoOp(“SIP/1001-4b87”, “Voicemail is 1006”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing GotoIf(“SIP/1001-4b87”, “0?s-CHANUNAVAIL|1”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Not taking any branch
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing NoOp(“SIP/1001-4b87”, “Sending to Voicemail box 1006”) in new stack
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing Macro(“SIP/1001-4b87”, “vm|1006|CHANUNAVAIL”) in new stack
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing Macro(“SIP/1001-4b87”, “user-callerid”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing GotoIf(“SIP/1001-4b87”, “0?report”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Not taking any branch
Jul 18 15:29:47 DEBUG[3022] pbx.c: Expression result is '1’
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing GotoIf(“SIP/1001-4b87”, “1?start”) in new stack
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Goto (macro-user-callerid,s,4)
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing NoOp(“SIP/1001-4b87”, “REALCALLERIDNUM is 1001”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Function result is '1001’
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “AMPUSER=1001”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Function result is 'Kayode Akintunde’
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “AMPUSERCIDNAME=Kayode Akintunde”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing GotoIf(“SIP/1001-4b87”, “0?report”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Not taking any branch
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “CALLERID(all)=Kayode Akintunde <1001>”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Function result is '“Kayode Akintunde” <1001>'
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing NoOp(“SIP/1001-4b87”, “Using CallerID “Kayode Akintunde” <1001>”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Expression result is '0’
Jul 18 15:29:47 DEBUG[3022] pbx.c: Function result is '‘
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “VMGAIN=”) in new stack
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing Goto(“SIP/1001-4b87”, “s-CHANUNAVAIL|1”) in new stack
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Goto (macro-vm,s-CHANUNAVAIL,1)
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing Macro(“SIP/1001-4b87”, “get-vmcontext|1006”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Function result is ‘default’
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing Set(“SIP/1001-4b87”, “VMCONTEXT=default”) in new stack
Jul 18 15:29:47 DEBUG[3022] pbx.c: Expression result is ‘0’
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing GotoIf(“SIP/1001-4b87”, “0?200:300”) in new stack
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Goto (macro-get-vmcontext,s,300)
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing NoOp(“SIP/1001-4b87”, “”) in new stack
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Executing VoiceMail(“SIP/1001-4b87”, “1006@default|u”) in new stack
Jul 18 15:29:47 DEBUG[3022] app_voicemail.c: /var/spool/asterisk/voicemail/default/1006/unavail doesn’t exist, doing what we can
Jul 18 15:29:47 VERBOSE[3022] logger.c: – Playing ‘vm-theperson’ (language ‘en’)
Jul 18 15:29:47 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘cb2694398f6ca33aYTEyNDdiNWZiYTgyMmUyODNhZDA2OWNmM2YwYWRjYjc.’ of Response 2: Match Found
Jul 18 15:29:48 VERBOSE[3022] logger.c: – Playing ‘digits/1’ (language ‘en’)
Jul 18 15:29:49 VERBOSE[3022] logger.c: – Playing ‘digits/0’ (language ‘en’)
Jul 18 15:29:50 VERBOSE[3022] logger.c: – Playing ‘digits/0’ (language ‘en’)
Jul 18 15:29:50 DEBUG[3022] app_voicemail.c: Hang up during prefile playback
Jul 18 15:29:50 VERBOSE[3022] logger.c: == Spawn extension (macro-vm, s-CHANUNAVAIL, 2) exited non-zero on ‘SIP/1001-4b87’ in macro ‘vm’
Jul 18 15:29:50 VERBOSE[3022] logger.c: == Spawn extension (macro-vm, s-CHANUNAVAIL, 2) exited non-zero on ‘SIP/1001-4b87’ in macro ‘exten-vm’
Jul 18 15:29:50 VERBOSE[3022] logger.c: == Spawn extension (macro-vm, s-CHANUNAVAIL, 2) exited non-zero on ‘SIP/1001-4b87’
Jul 18 15:29:50 DEBUG[3022] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Jul 18 15:29:50 DEBUG[3022] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,uniqueid) VALUES (‘2006-07-18 15:29:46’,’“Kayode Akintunde” <1001>’,‘1001’,‘1006’,‘from-internal’, ‘SIP/1001-4b87’,’’,‘VoiceMail’,‘1006@default|u’,4,3,‘ANSWERED’,3,’’,‘1153232986.14’)
Jul 18 15:29:50 DEBUG[3022] chan_sip.c: update_call_counter(1001) - decrement call limit counter
Jul 18 15:30:26 DEBUG[1841] chan_sip.c: Setting NAT on RTP to 0
Jul 18 15:30:26 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘b843151c05246744YTEyNDdiNWZiYTgyMmUyODNhZDA2OWNmM2YwYWRjYjc.’ of Response 1: Match Found
Jul 18 15:30:26 DEBUG[1841] chan_sip.c: Setting NAT on RTP to 0
Jul 18 15:30:26 DEBUG[1841] chan_sip.c: Checking SIP call limits for device 1001
Jul 18 15:30:26 DEBUG[1841] chan_sip.c: build_route: Contact hop:
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Macro(“SIP/1001-7e8d”, “exten-vm|1006|1006”) in new stack
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Macro(“SIP/1001-7e8d”, “user-callerid”) in new stack
Jul 18 15:30:26 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing GotoIf(“SIP/1001-7e8d”, “0?report”) in new stack
Jul 18 15:30:26 DEBUG[3031] pbx.c: Not taking any branch
Jul 18 15:30:26 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing GotoIf(“SIP/1001-7e8d”, “0?start”) in new stack
Jul 18 15:30:26 DEBUG[3031] pbx.c: Not taking any branch
Jul 18 15:30:26 DEBUG[3031] pbx.c: Function result is '1001’
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “REALCALLERIDNUM=1001”) in new stack
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing NoOp(“SIP/1001-7e8d”, “REALCALLERIDNUM is 1001”) in new stack
Jul 18 15:30:26 DEBUG[3031] pbx.c: Function result is '1001’
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “AMPUSER=1001”) in new stack
Jul 18 15:30:26 DEBUG[3031] pbx.c: Function result is 'Kayode Akintunde’
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “AMPUSERCIDNAME=Kayode Akintunde”) in new stack
Jul 18 15:30:26 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing GotoIf(“SIP/1001-7e8d”, “0?report”) in new stack
Jul 18 15:30:26 DEBUG[3031] pbx.c: Not taking any branch
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “CALLERID(all)=Kayode Akintunde <1001>”) in new stack
Jul 18 15:30:26 DEBUG[3031] pbx.c: Function result is '“Kayode Akintunde” <1001>'
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing NoOp(“SIP/1001-7e8d”, “Using CallerID “Kayode Akintunde” <1001>”) in new stack
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “FROMCONTEXT=exten-vm”) in new stack
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “VMBOX=1006”) in new stack
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “EXTTOCALL=1006”) in new stack
Jul 18 15:30:26 DEBUG[3031] db.c: Unable to find key ‘1006’ in family 'CFU’
Jul 18 15:30:26 DEBUG[3031] func_db.c: DB: CFU/1006 not found in database.
Jul 18 15:30:26 DEBUG[3031] pbx.c: Function result is ''
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “CFUEXT=”) in new stack
Jul 18 15:30:26 DEBUG[3031] pbx.c: Expression result is '1’
Jul 18 15:30:26 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:26 DEBUG[3031] pbx.c: Expression result is '1’
Jul 18 15:30:26 DEBUG[3031] pbx.c: Function result is '30’
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “RT=30”) in new stack
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing Macro(“SIP/1001-7e8d”, “record-enable|1006|IN”) in new stack
Jul 18 15:30:26 DEBUG[3031] pbx.c: Function result is '0’
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing GotoIf(“SIP/1001-7e8d”, “0 > 0?2:4”) in new stack
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Goto (macro-record-enable,s,4)
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Executing AGI(“SIP/1001-7e8d”, “recordingcheck|20060718-153026|1153233026.15”) in new stack
Jul 18 15:30:26 VERBOSE[3031] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
Jul 18 15:30:27 VERBOSE[3031] logger.c: recordingcheck|20060718-153026|1153233026.15: Inbound recording not enabled
Jul 18 15:30:27 VERBOSE[3031] logger.c: – AGI Script recordingcheck completed, returning 0
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing NoOp(“SIP/1001-7e8d”, “No recording needed”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing GotoIf(“SIP/1001-7e8d”, “0?dolocaldial|1”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Not taking any branch
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Macro(“SIP/1001-7e8d”, “dial|30|tr|1006”) in new stack
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing AGI(“SIP/1001-7e8d”, “dialparties.agi”) in new stack
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi: Starting New Dialparties.agi
Jul 18 15:30:27 VERBOSE[3031] logger.c: – dialparties.agi: priority is 1
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi: Caller ID name is ‘Kayode Akintunde’ number is '1001’
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi: Methodology of ring is 'none’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – dialparties.agi: Added extension 1006 to extension map
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi: Extension 1006 has call forward set to Invalid command syntax. Proper usage follows:
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi: Usage: DATABASE GET
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi: Retrieves an entry in the Asterisk database for a
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi: given family and key.
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi: Returns 0 if is not set. Returns 1 if
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi: is set and returns the variable in parentheses.
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi: Example return code: 200 result=1 (testvariable)
Jul 18 15:30:27 VERBOSE[3031] logger.c: dialparties.agi:
Jul 18 15:30:27 VERBOSE[3031] logger.c: – AGI Script dialparties.agi completed, returning 0
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Dial(“SIP/1001-7e8d”, “Local/Invalid command syntax. Proper usage follows:n Usage: DATABASE GET n Retrieves an entry in the Asterisk database for an given family and key.n Returns 0 if is not set. Returns 1 if n is set and returns the variable in parentheses.n Example return code: 200 result=1 (testvariable)n@from-internal/n|30|tr”) in new stack
Jul 18 15:30:27 NOTICE[3031] chan_local.c: No such extension/context Invalid command syntax. Proper usage follows:n Usage: DATABASE GET Jul 18 15:30:27 NOTICE[3031] app_dial.c: Unable to create channel of type ‘Local’ (cause 0 - Unknown)
Jul 18 15:30:27 VERBOSE[3031] logger.c: == Everyone is busy/congested at this time (1:0/0/1)
Jul 18 15:30:27 DEBUG[3031] app_dial.c: Exiting with DIALSTATUS=CHANUNAVAIL.
Jul 18 15:30:27 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:27 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:27 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing GosubIf(“SIP/1001-7e8d”, “0?docfu|1”) in new stack
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing NoOp(“SIP/1001-7e8d”, “Voicemail is 1006”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing GotoIf(“SIP/1001-7e8d”, “0?s-CHANUNAVAIL|1”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Not taking any branch
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing NoOp(“SIP/1001-7e8d”, “Sending to Voicemail box 1006”) in new stack
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Macro(“SIP/1001-7e8d”, “vm|1006|CHANUNAVAIL”) in new stack
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Macro(“SIP/1001-7e8d”, “user-callerid”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing GotoIf(“SIP/1001-7e8d”, “0?report”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Not taking any branch
Jul 18 15:30:27 DEBUG[3031] pbx.c: Expression result is '1’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing GotoIf(“SIP/1001-7e8d”, “1?start”) in new stack
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Goto (macro-user-callerid,s,4)
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing NoOp(“SIP/1001-7e8d”, “REALCALLERIDNUM is 1001”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Function result is '1001’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “AMPUSER=1001”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Function result is 'Kayode Akintunde’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “AMPUSERCIDNAME=Kayode Akintunde”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing GotoIf(“SIP/1001-7e8d”, “0?report”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Not taking any branch
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “CALLERID(all)=Kayode Akintunde <1001>”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Function result is '“Kayode Akintunde” <1001>'
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing NoOp(“SIP/1001-7e8d”, “Using CallerID “Kayode Akintunde” <1001>”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Expression result is '0’
Jul 18 15:30:27 DEBUG[3031] pbx.c: Function result is '‘
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “VMGAIN=”) in new stack
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Goto(“SIP/1001-7e8d”, “s-CHANUNAVAIL|1”) in new stack
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Goto (macro-vm,s-CHANUNAVAIL,1)
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Macro(“SIP/1001-7e8d”, “get-vmcontext|1006”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Function result is ‘default’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing Set(“SIP/1001-7e8d”, “VMCONTEXT=default”) in new stack
Jul 18 15:30:27 DEBUG[3031] pbx.c: Expression result is ‘0’
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing GotoIf(“SIP/1001-7e8d”, “0?200:300”) in new stack
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Goto (macro-get-vmcontext,s,300)
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing NoOp(“SIP/1001-7e8d”, “”) in new stack
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Executing VoiceMail(“SIP/1001-7e8d”, “1006@default|u”) in new stack
Jul 18 15:30:27 DEBUG[3031] app_voicemail.c: /var/spool/asterisk/voicemail/default/1006/unavail doesn’t exist, doing what we can
Jul 18 15:30:27 VERBOSE[3031] logger.c: – Playing ‘vm-theperson’ (language ‘en’)
Jul 18 15:30:27 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘b843151c05246744YTEyNDdiNWZiYTgyMmUyODNhZDA2OWNmM2YwYWRjYjc.’ of Response 2: Match Found
Jul 18 15:30:28 VERBOSE[3031] logger.c: – Playing ‘digits/1’ (language ‘en’)
Jul 18 15:30:29 VERBOSE[3031] logger.c: – Playing ‘digits/0’ (language ‘en’)
Jul 18 15:30:30 VERBOSE[3031] logger.c: – Playing ‘digits/0’ (language ‘en’)
Jul 18 15:30:31 VERBOSE[3031] logger.c: – Playing ‘digits/6’ (language ‘en’)
Jul 18 15:30:31 VERBOSE[3031] logger.c: – Playing ‘vm-isunavail’ (language ‘en’)
Jul 18 15:30:32 DEBUG[3031] app_voicemail.c: Hang up during prefile playback
Jul 18 15:30:32 VERBOSE[3031] logger.c: == Spawn extension (macro-vm, s-CHANUNAVAIL, 2) exited non-zero on ‘SIP/1001-7e8d’ in macro ‘vm’
Jul 18 15:30:32 VERBOSE[3031] logger.c: == Spawn extension (macro-vm, s-CHANUNAVAIL, 2) exited non-zero on ‘SIP/1001-7e8d’ in macro ‘exten-vm’
Jul 18 15:30:32 VERBOSE[3031] logger.c: == Spawn extension (macro-vm, s-CHANUNAVAIL, 2) exited non-zero on ‘SIP/1001-7e8d’
Jul 18 15:30:32 DEBUG[3031] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Jul 18 15:30:32 DEBUG[3031] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,uniqueid) VALUES (‘2006-07-18 15:30:26’,’“Kayode Akintunde” <1001>’,‘1001’,‘1006’,‘from-internal’, ‘SIP/1001-7e8d’,’’,‘VoiceMail’,‘1006@default|u’,6,5,‘ANSWERED’,3,’’,‘1153233026.15’)
Jul 18 15:30:32 DEBUG[3031] chan_sip.c: update_call_counter(1001) - decrement call limit counter
Jul 18 15:31:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:31:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:33:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:33:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:35:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:35:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:37:01 DEBUG[1841] chan_sip.c: Stopping retransmission on ‘1ac23546233b3bba15bf0c6d65be984e@10.0.15.254’ of Request 102: Match Found
Jul 18 15:37:08 DEBUG[1841] chan_sip.c: Auto destroying call '0315125e5202a463@Tm9ydQ…'
Jul 18 15:37:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:37:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:39:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:39:41 DEBUG[3021] manager.c: Manager received command 'Command’
Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/manager.conf’: Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/manager.conf’: Found
Jul 18 15:39:55 NOTICE[2843] cdr.c: CDR simple logging enabled.
Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/enum.conf’: Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/enum.conf’: Found
Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/rtp.conf’: Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/rtp.conf’: Found
Jul 18 15:39:55 VERBOSE[2843] logger.c: == RTP Allocating from port range 10000 -> 20000
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Reloading module ‘res_musiconhold.so’ (Music On Hold Resource)
Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/musiconhold.conf’: Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/musiconhold.conf’: Found
Jul 18 15:39:55 DEBUG[2843] res_musiconhold.c: Music on Hold class ‘default’ left alone from initial load.
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Reloading module ‘res_adsi.so’ (ADSI Resource)
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Reloading module ‘res_config_mysql.so’ (MySQL RealTime Configuration Driver)
Jul 18 15:39:55 DEBUG[2843] res_config_mysql.c: MySQL RealTime Host:
Jul 18 15:39:55 DEBUG[2843] res_config_mysql.c: MySQL RealTime Port: 0
Jul 18 15:39:55 DEBUG[2843] res_config_mysql.c: MySQL RealTime User:
Jul 18 15:39:55 DEBUG[2843] res_config_mysql.c: MySQL RealTime Password:
Jul 18 15:39:55 ERROR[2843] res_config_mysql.c: MySQL RealTime: Failed to connect database server on . Check debug for more info.
Jul 18 15:39:55 DEBUG[2843] res_config_mysql.c: MySQL RealTime: Cannot Connect: Can’t connect to local MySQL server through socket ‘’ (111)
Jul 18 15:39:55 WARNING[2843] res_config_mysql.c: MySQL RealTime: Couldn’t establish connection. Check debug.
Jul 18 15:39:55 DEBUG[2843] res_config_mysql.c: MySQL RealTime: Cannot Connect: Can’t connect to local MySQL server through socket ‘’ (111)
Jul 18 15:39:55 VERBOSE[2843] logger.c: == MySQL RealTime reloaded.
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Reloading module ‘res_features.so’ (Call Features Resource)
Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/features.conf’: Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/features.conf’: Found
Jul 18 15:39:55 VERBOSE[2843] logger.c: == Remapping feature One Touch Monitor (automon) to sequence '*1’
Jul 18 15:39:55 DEBUG[2843] res_features.c: Removed old parking extension 70@parkedcalls
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Added extension ‘70’ priority 1 to parkedcalls
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Reloading module ‘res_crypto.so’ (Cryptographic Digital Signatures)
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Reloading module ‘res_indications.so’ (Indications Configuration)
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'at’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'au’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'br’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'be’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'ch’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'cl’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'cn’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'cz’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'de’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'dk’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'ee’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'es’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'fi’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'fr’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'gr’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'hu’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'it’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'lt’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'mx’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'nl’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'no’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'nz’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'pl’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'pt’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'ru’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'se’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'sg’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'uk’
Jul 18 15:39:55 NOTICE[2843] indications.c: Removed default indication country 'us’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'us’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'us-o’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Unregistered indication country 'tw’
Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/indications.conf’: Jul 18 15:39:55 VERBOSE[2843] logger.c: == Parsing ‘/etc/asterisk/indications.conf’: Found
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Registered indication country 'at’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Registered indication country 'au’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Registered indication country 'br’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Registered indication country 'be’
Jul 18 15:39:55 VERBOSE[2843] logger.c: – Registered indication country 'ch’
Jul 18 15:3

Are you using realtime with a database (Mysql?)?

I was looking at: Unable to find key ‘SIP/1127’ in family ‘dnd’

And wonder if it has anything to do with the section of extconf.cfg where you identify the family:

; Realtime configuration engine
;
; maps a particular family of realtime
; configuration to a given database driver,
; database and table (or uses the name of
; the family if the table is not specified
;
;example => odbc,asterisk,alttable

thanks for your reply. Yeah U are right. I think this is where my problem is. Can u pls explain clearly what I can do to get this fixed. Got this again today.

Logfile:

Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1000’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1001’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1002’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1003’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1004’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1005’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1006’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1100’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1102’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1103’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1104’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1105’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1106’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1107’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1108’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1109’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1110’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1111’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1112’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1113’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1114’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1115’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1116’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1117’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1118’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1119’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1120’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1121’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1122’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1123’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1124’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1125’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1126’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1127’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1128’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1129’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1130’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1131’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1132’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1133’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1134’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1135’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1136’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1137’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1138’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1139’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1140’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1141’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1142’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1143’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1144’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1145’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1146’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1147’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1148’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1149’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1150’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1151’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1152’ in family 'SIP/Registry’
Jul 19 07:46:16 DEBUG[1838] db.c: Unable to find key ‘1153’ in family ‘SIP/Registry’

it looks like your config is well and truly b0rked.

the “unable to find key” messages are not really errors, but an indication that “Call Forward on Busy” is not set.

i would be more concerned with the fact that dialparties.agi is returning an invalid result, which is killing Dial()

and this seems to stem from

you could drop the call forward family entries in ASTDB and start again, but something has caused this so it may well happen again.

[quote]it looks like your config is well and truly b0rked.

the “unable to find key” messages are not really errors, but an indication that “Call Forward on Busy” is not set.

i would be more concerned with the fact that dialparties.agi is returning an invalid result, which is killing Dial()
Quote:
Local/Invalid command syntax. Proper usage follows:n Usage: DATABASE GET n Retrieves an entry in the Asterisk database for an given family and key.n Returns 0 if is not set. Returns 1 if n is set and returns the variable in parentheses.n Example return code: 200 result=1 (testvariable)n

and this seems to stem from
Quote:
Extension 1006 has call forward set to Invalid command syntax. Proper usage follows:

[/quote]

u are very correct with that. Thats the exact error I am facing. What I did before getting this is enabling Call Waiting for all extensions in my amportal.conf before creating the extension (I am using freebpx on my box).

Are u saying I should recompile Asterisk or what. Please explain

Thanks.

at the CLI, familiarise yourself with “show application ‘appname’”, e.g. “show application DBdeltree”, "show application DBdel"and “database show”

using these, you can see what is in the ASTDB, and delete individual keys or entire family entries.

it might be worth checking with the devs of FreePBX in case there’s a known bug. your ASTDB shouldn’t be corrupted byusing their app.

[quote]it might be worth checking with the devs of FreePBX in case there’s a known bug. your ASTDB shouldn’t be corrupted byusing their app.
[/quote]

Yeah you are right. Search their forum and found this.

freepbx.org/forums/viewtopic … arties+agi

I will try your suggestion now and sort it out.

thanks man.

Cheers.