[Asterisk-Users] asterisk shutdown
Anton Krall
akrall-lists at intruder.com.mx
Tue Jul 4 14:38:14 MST 2006
Guys.
I was able to put asterisk on debug for a while and another shutdown took
place, here are the logs... I was wondering.. I notice that we are using a
lot of manager actions and can it be that if you place a lot of manager
actions in a short period of time, that it makes asterisk do a shutdown?
Maybe a bug?
[Jul 4 12:59:59] VERBOSE[8953]: [Jul 4 12:59:59] == Parsing
'/etc/asterisk/manager.conf': [Jul 4 12:59:59] VERBOSE[8953]: [Jul 4
12:59:59] == Parsing
'/etc/asterisk/manager.conf': [Jul 4 12:59:59] Found
[Jul 4 12:59:59] DEBUG[8953]: 0.0.0.0/0.0.0.0/0.0.0.0 appended to acl for
peer
[Jul 4 12:59:59] DEBUG[8953]: 127.0.0.1/255.255.255.255/255.255.255.255
appended to acl for peer
[Jul 4 12:59:59] DEBUG[8953]: 10.0.0.0/255.0.0.0/255.0.0.0 appended to acl
for peer
[Jul 4 12:59:59] DEBUG[8953]: ##### Testing 127.0.0.1 with 0.0.0.0
[Jul 4 12:59:59] DEBUG[8953]: ##### Testing 127.0.0.1 with 127.0.0.1
[Jul 4 12:59:59] DEBUG[8953]: ##### Testing 127.0.0.1 with 10.0.0.0
[Jul 4 12:59:59] DEBUG[8953]: Manager received command 'Command'
[Jul 4 12:59:59] DEBUG[8953]: Manager received command 'Logoff'
[Jul 4 12:59:59] DEBUG[8954]: Manager received command 'Login'
[Jul 4 12:59:59] VERBOSE[8954]: [Jul 4 12:59:59] == Parsing
'/etc/asterisk/manager.conf': [Jul 4 12:59:59] VERBOSE[8954]: [Jul 4
12:59:59] == Parsing
'/etc/asterisk/manager.conf': [Jul 4 12:59:59] Found
[Jul 4 12:59:59] DEBUG[8954]: 0.0.0.0/0.0.0.0/0.0.0.0 appended to acl for
peer
[Jul 4 12:59:59] DEBUG[8954]: 127.0.0.1/255.255.255.255/255.255.255.255
appended to acl for peer
[Jul 4 12:59:59] DEBUG[8954]: 10.0.0.0/255.0.0.0/255.0.0.0 appended to acl
for peer
[Jul 4 12:59:59] DEBUG[8954]: ##### Testing 127.0.0.1 with 0.0.0.0
[Jul 4 12:59:59] DEBUG[8954]: ##### Testing 127.0.0.1 with 127.0.0.1
[Jul 4 12:59:59] DEBUG[8954]: ##### Testing 127.0.0.1 with 10.0.0.0
[Jul 4 12:59:59] DEBUG[8954]: Manager received command 'Command'
[Jul 4 12:59:59] DEBUG[8954]: Manager received command 'Logoff'
[Jul 4 12:59:59] DEBUG[8955]: Manager received command 'Login'
[Jul 4 12:59:59] VERBOSE[8955]: [Jul 4 12:59:59] == Parsing
'/etc/asterisk/manager.conf': [Jul 4 12:59:59] VERBOSE[8955]: [Jul 4
12:59:59] == Parsing
'/etc/asterisk/manager.conf': [Jul 4 12:59:59] Found
[Jul 4 12:59:59] DEBUG[8955]: 0.0.0.0/0.0.0.0/0.0.0.0 appended to acl for
peer
[Jul 4 12:59:59] DEBUG[8955]: 127.0.0.1/255.255.255.255/255.255.255.255
appended to acl for peer
[Jul 4 12:59:59] DEBUG[8955]: 10.0.0.0/255.0.0.0/255.0.0.0 appended to acl
for peer
[Jul 4 12:59:59] DEBUG[8955]: ##### Testing 127.0.0.1 with 0.0.0.0
[Jul 4 12:59:59] DEBUG[8955]: ##### Testing 127.0.0.1 with 127.0.0.1
[Jul 4 12:59:59] DEBUG[8955]: ##### Testing 127.0.0.1 with 10.0.0.0
[Jul 4 12:59:59] DEBUG[8955]: Manager received command 'Command'
[Jul 4 12:59:59] DEBUG[8955]: Manager received command 'Logoff'
[Jul 4 13:00:02] DEBUG[8663]: update_call_counter(114) - decrement call
limit counter
[Jul 4 13:00:02] DEBUG[8663]: Acked pending invite 102
[Jul 4 13:00:02] DEBUG[8663]: Stopping retransmission on
'4137b6ce4afdb5ce6d0d36157793f7ae at 192.168.1.50' of Request 102: Match Found
[Jul 4 13:00:02] DEBUG[8663]: Exiting with DIALSTATUS=CANCEL.
[Jul 4 13:00:02] VERBOSE[8663]: [Jul 4 13:00:02] == Spawn extension
(internalphones, 114, 7) exited non-zero on 'SIP/101-f035'
[Jul 4 13:00:02] VERBOSE[8669]: [Jul 4 13:00:02] == End MixMonitor
Recording SIP/101-f035
[Jul 4 13:00:02] VERBOSE[8669]: [Jul 4 13:00:02] == Executing [chmod 777
/digrec/20060704-125935-1152035975.864-from-101-to-114.wav]
[Jul 4 13:00:02] DEBUG[8663]: Spy Ãd removed from channel SIP/101-f035
[Jul 4 13:00:02] DEBUG[8663]: cdr_mysql: inserting a CDR record.
[Jul 4 13:00:02] DEBUG[8663]: cdr_mysql: SQL command as follows: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duratio
n,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2006-07-04 12:59:35','\"Recepcion\" <101>','101','114','internalphones',
'SIP/101-f03
5','SIP/114-b115','Dial','SIP/114|120|rtwTW',27,0,'NO
ANSWER',3,'Recepcion','1152035975.864','[Recepcion -> Miguel Angel Sanz] ')
[Jul 4 13:00:02] DEBUG[8663]: update_call_counter(101) - decrement call
limit counter
[Jul 4 13:00:02] DEBUG[8319]: update_call_counter(101) - decrement call
limit counter
[Jul 4 13:00:02] DEBUG[8319]: Acked pending invite 102
[Jul 4 13:00:02] DEBUG[8319]: Stopping retransmission on
'129c0d1d2f0da8c15c397160686369d1 at 192.168.1.50' of Request 102: Match Found
[Jul 4 13:00:02] DEBUG[8305]: Didn't get a frame from channel: SIP/101-d287
[Jul 4 13:00:02] DEBUG[8305]: Bridge stops bridging channels UniCall/4-1
and SIP/101-d287
[Jul 4 13:00:02] DEBUG[8305]: update_call_counter(101) - decrement call
limit counter
[Jul 4 13:00:02] DEBUG[8227]: Didn't get a frame from channel: SIP/101-a2b9
[Jul 4 13:00:02] DEBUG[8227]: Bridge stops bridging channels Zap/35-1 and
SIP/101-a2b9
[Jul 4 13:00:02] DEBUG[8227]: update_call_counter(101) - decrement call
limit counter
[Jul 4 13:00:02] DEBUG[8281]: Didn't get a frame from channel: SIP/114-68c7
[Jul 4 13:00:02] DEBUG[8281]: Bridge stops bridging channels UniCall/1-1
and SIP/114-68c7
[Jul 4 13:00:02] DEBUG[8281]: update_call_counter(114) - decrement call
limit counter
[Jul 4 13:00:02] DEBUG[8025]: Didn't get a frame from channel: SIP/117-140e
[Jul 4 13:00:02] DEBUG[8025]: Bridge stops bridging channels UniCall/7-1
and SIP/117-140e
[Jul 4 13:00:02] DEBUG[8025]: update_call_counter(117) - decrement call
limit counter
[Jul 4 13:00:02] DEBUG[7456]: Didn't get a frame from channel: SIP/101-79f8
[Jul 4 13:00:02] DEBUG[7456]: Bridge stops bridging channels UniCall/5-1
and SIP/101-79f8
[Jul 4 13:00:02] DEBUG[7456]: update_call_counter(101) - decrement call
limit counter
[Jul 4 13:00:02] DEBUG[7062]: Didn't get a frame from channel: UniCall/2-1
[Jul 4 13:00:02] DEBUG[7062]: Bridge stops bridging channels SIP/124-e596
and UniCall/2-1
[Jul 4 13:00:02] DEBUG[7062]: Hangup: channel: 2 index = 0, normal = 15,
callwait = -1, thirdcall = -1
[Jul 4 13:00:02] DEBUG[7062]: Updated conferencing on 2, with 0 conference
users
[Jul 4 13:00:02] VERBOSE[7062]: [Jul 4 13:00:02] -- Hungup
'UniCall/2-1'
[Jul 4 13:00:02] NOTICE[8319]: No one is answering queue 'recepcion'
(1/0/0)
[Jul 4 13:00:02] VERBOSE[8319]: [Jul 4 13:00:02] -- User disconnected
from queue recepcion when they almost made it
[Jul 4 13:00:02] VERBOSE[8319]: [Jul 4 13:00:02] == Spawn extension
(recepcion, s, 3) exited non-zero on 'UniCall/8-1'
[Jul 4 13:00:02] DEBUG[8305]: Exiting with DIALSTATUS=ANSWER.
[Jul 4 13:00:02] VERBOSE[8305]: [Jul 4 13:00:02] == Spawn extension
(ivrextensions, 101, 12) exited non-zero on 'UniCall/4-1'
[Jul 4 13:00:02] DEBUG[8227]: Exiting with DIALSTATUS=ANSWER.
[Jul 4 13:00:02] DEBUG[8319]: Spy MixMonitor removed from channel
UniCall/8-1
[Jul 4 13:00:02] VERBOSE[8227]: [Jul 4 13:00:02] == Spawn extension
(ivrextensions, 101, 12) exited non-zero on 'Zap/35-1'
[Jul 4 13:00:02] DEBUG[8281]: Exiting with DIALSTATUS=ANSWER.
[Jul 4 13:00:02] VERBOSE[8281]: [Jul 4 13:00:02] == Spawn extension
(internalphones, 114, 7) exited non-zero on 'UniCall/1-1'
[Jul 4 13:00:02] DEBUG[8305]: Spy MixMonitor removed from channel
UniCall/4-1
[Jul 4 13:00:02] VERBOSE[8305]: [Jul 4 13:00:02] -- Stopped music on
hold on UniCall/4-1
[Jul 4 13:00:02] VERBOSE[8324]: [Jul 4 13:00:02] == End MixMonitor
Recording UniCall/8-1
[Jul 4 13:00:02] VERBOSE[8324]: [Jul 4 13:00:02] == Executing [chmod 777
/digrec/20060704-125837-1152035916.858-from-5552792400-to-101.wav]
[Jul 4 13:00:02] VERBOSE[8319]: [Jul 4 13:00:02] -- Stopped music on
hold on UniCall/8-1
[Jul 4 13:00:02] DEBUG[8025]: Exiting with DIALSTATUS=ANSWER.
[Jul 4 13:00:02] VERBOSE[8025]: [Jul 4 13:00:02] == Spawn extension
(internalphones, 117, 7) exited non-zero on 'UniCall/7-1'
[Jul 4 13:00:02] VERBOSE[8312]: [Jul 4 13:00:02] == End MixMonitor
Recording UniCall/4-1
[Jul 4 13:00:02] VERBOSE[8312]: [Jul 4 13:00:02] == Executing [chmod 777
/digrec/20060704-125831-1152035910.856-from-5512244045-to-101.wav]
[Jul 4 13:00:02] DEBUG[8227]: Spy MixMonitor removed from channel Zap/35-1
[Jul 4 13:00:02] VERBOSE[8227]: [Jul 4 13:00:02] -- Stopped music on
hold on Zap/35-1
[Jul 4 13:00:02] DEBUG[7456]: Exiting with DIALSTATUS=ANSWER.
[Jul 4 13:00:02] VERBOSE[7456]: [Jul 4 13:00:02] == Spawn extension
(ivrextensions, 101, 12) exited non-zero on 'UniCall/5-1'
[Jul 4 13:00:02] DEBUG[8281]: Spy MixMonitor removed from channel
UniCall/1-1
[Jul 4 13:00:02] VERBOSE[8294]: [Jul 4 13:00:02] == End MixMonitor
Recording Zap/35-1
[Jul 4 13:00:02] VERBOSE[8294]: [Jul 4 13:00:02] == Executing [chmod 777
/digrec/20060704-125824-1152035898.852-from-unknown-to-101.wav]
[Jul 4 13:00:02] DEBUG[8025]: Spy MixMonitor removed from channel
UniCall/7-1
[Jul 4 13:00:02] VERBOSE[8287]: [Jul 4 13:00:02] == End MixMonitor
Recording SIP/101-13f3
[Jul 4 13:00:02] VERBOSE[8287]: [Jul 4 13:00:02] == Executing [chmod 777
/digrec/20060704-125821-1152035901.853-from-101-to-114.wav]
[Jul 4 13:00:02] DEBUG[7456]: Spy MixMonitor removed from channel
UniCall/5-1
[Jul 4 13:00:02] VERBOSE[7456]: [Jul 4 13:00:02] -- Stopped music on
hold on UniCall/5-1
[Jul 4 13:00:02] VERBOSE[8031]: [Jul 4 13:00:02] == End MixMonitor
Recording SIP/101-150e
[Jul 4 13:00:02] VERBOSE[8031]: [Jul 4 13:00:02] == Executing [chmod 777
/digrec/20060704-125726-1152035846.844-from-101-to-117.wav]
[Jul 4 13:00:02] DEBUG[7062]: Exiting with DIALSTATUS=ANSWER.
[Jul 4 13:00:02] DEBUG[7062]: SIP/124-e596 hungup
[Jul 4 13:00:02] VERBOSE[7461]: [Jul 4 13:00:02] == End MixMonitor
Recording UniCall/5-1
[Jul 4 13:00:02] VERBOSE[7461]: [Jul 4 13:00:02] == Executing [chmod 777
/digrec/20060704-125424-1152035663.822-from-5555892534-to-101.wav]
[Jul 4 13:00:02] DEBUG[22699]: Stopping retransmission on
'4137b6ce4afdb5ce6d0d36157793f7ae at 192.168.1.50' of Request 102: Match Found
[Jul 4 13:00:02] DEBUG[8305]: cdr_mysql: inserting a CDR record.
[Jul 4 13:00:02] DEBUG[8305]: cdr_mysql: SQL command as follows: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duratio
n,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2006-07-04 12:58:30','\"5512244045\"
<5512244045>','5512244045','101','ivrextensions'
,
'UniCall/4-1','SIP/101-d287','Dial','SIP/101|120|rtwTW',92,92,'ANSWERED',3,'
Recepcion ','1152035910.856','')
[Jul 4 13:00:02] VERBOSE[7062]: [Jul 4 13:00:02] == Spawn extension
(internalphones, 56032890, 3) exited non-zero on 'SIP/124-e596'
[Jul 4 13:00:02] VERBOSE[22635]: [Jul 4 13:00:02] Beginning asterisk
shutdown....
[Jul 4 13:00:02] DEBUG[7062]: Spy MixMonitor removed from channel
SIP/124-e596
[Jul 4 13:00:02] DEBUG[8305]: Hangup: channel: 4 index = 0, normal = 21,
callwait = -1, thirdcall = -1
[Jul 4 13:00:02] DEBUG[8305]: Updated conferencing on 4, with 0 conference
users
[Jul 4 13:00:02] VERBOSE[8305]: [Jul 4 13:00:02] -- Hungup
'UniCall/4-1'
[Jul 4 13:00:02] VERBOSE[7068]: [Jul 4 13:00:02] == End MixMonitor
Recording SIP/124-e596
[Jul 4 13:00:02] VERBOSE[7068]: [Jul 4 13:00:02] == Executing [chmod 777
/digrec/20060704-125136-1152035496.797-from-124-to-56032890.wav]
[Jul 4 13:00:02] DEBUG[22699]: Stopping retransmission on
'7610b353-3520e895-47d32a36 at 192.168.1.144' of Response 2: Match Found
[Jul 4 13:00:02] DEBUG[8319]: cdr_mysql: inserting a CDR record.
[Jul 4 13:00:02] DEBUG[8319]: cdr_mysql: SQL command as follows: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duratio
n,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2006-07-04 12:58:36','\"5552792400\"
<5552792400>','5552792400','s','recepcion', 'Uni
Call/8-1','SIP/101-3237','Queue','recepcion|t',86,86,'ANSWERED',3,'Recepcion
','1152035916.858','')
[Jul 4 13:00:02] DEBUG[8319]: Hangup: channel: 8 index = 0, normal = 33,
callwait = -1, thirdcall = -1
[Jul 4 13:00:02] DEBUG[8319]: Updated conferencing on 8, with 0 conference
users
[Jul 4 13:00:02] VERBOSE[8319]: [Jul 4 13:00:02] -- Hungup
'UniCall/8-1'
[Jul 4 13:00:02] DEBUG[8227]: cdr_mysql: inserting a CDR record.
[Jul 4 13:00:02] DEBUG[8227]: cdr_mysql: SQL command as follows: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duratio
n,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2006-07-04 12:58:23','\"NO CID\"
<No_Caller_ID>','No_Caller_ID','101','ivrextensions'
,
'Zap/35-1','SIP/101-a2b9','Dial','SIP/101|120|rtwTW',99,99,'ANSWERED',3,'Rec
epcion ','1152035898.852','')
[Jul 4 13:00:02] DEBUG[8227]: Hangup: channel: 35 index = 0, normal = 47,
callwait = -1, thirdcall = -1
[Jul 4 13:00:02] DEBUG[8227]: disabled echo cancellation on channel 35
[Jul 4 13:00:02] DEBUG[8227]: Set option TDD MODE, value: OFF(0) on
Zap/35-1
[Jul 4 13:00:02] DEBUG[8227]: Updated conferencing on 35, with 0 conference
users
[Jul 4 13:00:02] VERBOSE[8227]: [Jul 4 13:00:02] -- Hungup 'Zap/35-1'
[Jul 4 13:00:02] DEBUG[8281]: cdr_mysql: inserting a CDR record.
[Jul 4 13:00:02] DEBUG[8281]: cdr_mysql: SQL command as follows: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duratio
n,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2006-07-04 12:58:21','\"5553749905\"
<5553749905>','5553749905','114','internalphones
',
'SIP/101-13f3','SIP/114-68c7','Dial','SIP/114|120|rtwTW',101,98,'ANSWERED',3
,'Recepcion','1152035901.853','[Recepcion -> Miguel Angel Sanz] ')
[Jul 4 13:00:02] DEBUG[8281]: cdr_mysql: inserting a CDR record.
[Jul 4 13:00:02] DEBUG[8281]: cdr_mysql: SQL command as follows: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duratio
n,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2006-07-04 12:57:50','\"5553749905\"
<5553749905>','5553749905','114','internalphones
',
'UniCall/1-1','SIP/101-a912','Dial','SIP/101|120|rtwTW',132,132,'ANSWERED',3
,'Recepcion','1152035870.848','')
[Jul 4 13:00:02] DEBUG[8281]: Hangup: channel: 1 index = 0, normal = 12,
callwait = -1, thirdcall = -1
[Jul 4 13:00:02] DEBUG[8281]: Updated conferencing on 1, with 0 conference
users
[Jul 4 13:00:02] VERBOSE[8281]: [Jul 4 13:00:02] -- Hungup
'UniCall/1-1'
[Jul 4 13:00:02] DEBUG[7456]: cdr_mysql: inserting a CDR record.
[Jul 4 13:00:02] DEBUG[7456]: cdr_mysql: SQL command as follows: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duratio
n,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2006-07-04 12:54:23','\"5555892534\"
<5555892534>','5555892534','101','ivrextensions'
,
'UniCall/5-1','SIP/101-79f8','Dial','SIP/101|120|rtwTW',339,339,'ANSWERED',3
,'Recepcion ','1152035663.822','')
[Jul 4 13:00:02] DEBUG[7456]: Hangup: channel: 5 index = 0, normal = 24,
callwait = -1, thirdcall = -1
[Jul 4 13:00:02] DEBUG[7456]: Updated conferencing on 5, with 0 conference
users
[Jul 4 13:00:02] VERBOSE[7456]: [Jul 4 13:00:02] -- Hungup
'UniCall/5-1'
[Jul 4 13:00:02] DEBUG[7062]: cdr_mysql: inserting a CDR record.
[Jul 4 13:00:02] DEBUG[7062]: cdr_mysql: SQL command as follows: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duratio
n,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2006-07-04 12:51:36','\"Departamento Contabilidad\"
<124>','124','56032890','internal
phones',
'SIP/124-e596','UniCall/2-1','Dial','Unicall/g1/56032890|60|wtWT/n',506,490,
'ANSWERED',3,'Departamento Contab','1152035496.797','')
[Jul 4 13:00:02] DEBUG[7062]: update_call_counter(124) - decrement call
limit counter
[Jul 4 13:00:02] DEBUG[8025]: cdr_mysql: inserting a CDR record.
[Jul 4 13:00:02] DEBUG[8025]: cdr_mysql: SQL command as follows: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duratio
n,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2006-07-04 12:57:26','\"5553947467\"
<5553947467>','5553947467','117','internalphones
',
'SIP/101-150e','SIP/117-140e','Dial','SIP/117|120|rtwTW',156,154,'ANSWERED',
3,'Recepcion','1152035846.844','[Recepcion -> Miriam Loranca] ')
[Jul 4 13:00:02] DEBUG[8025]: cdr_mysql: inserting a CDR record.
[Jul 4 13:00:02] DEBUG[8025]: cdr_mysql: SQL command as follows: INSERT
INTO cdr
(calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duratio
n,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES
('2006-07-04 12:57:04','\"5553947467\"
<5553947467>','5553947467','117','internalphones
',
'UniCall/7-1','SIP/101-9a84','Dial','SIP/101|120|rtwTW',178,178,'ANSWERED',3
,'Recepcion','1152035824.842','')
[Jul 4 13:00:02] DEBUG[8025]: Hangup: channel: 7 index = 0, normal = 30,
callwait = -1, thirdcall = -1
[Jul 4 13:00:02] DEBUG[8025]: Updated conferencing on 7, with 0 conference
users
[Jul 4 13:00:02] VERBOSE[8025]: [Jul 4 13:00:02] -- Hungup
'UniCall/7-1'
[Jul 4 13:00:02] VERBOSE[22635]: [Jul 4 13:00:02] Executing last minute
cleanups
[Jul 4 13:00:02] VERBOSE[22635]: [Jul 4 13:00:02] == Destroying
musiconhold processes
[Jul 4 13:00:02] DEBUG[22635]: killing 22693!
[Jul 4 13:00:02] DEBUG[22699]: Stopping retransmission on
'057c2e1a2c4b0ea333e3dde87e78037a at 192.168.1.50' of Request 103: Match Found
[Jul 4 13:00:02] DEBUG[22699]: Stopping retransmission on
'4137b6ce4afdb5ce6d0d36157793f7ae at 192.168.1.50' of Request 102: Match Not
Found
[Jul 4 13:00:02] WARNING[22696]: Unicall/2 event Drop call
[Jul 4 13:00:02] DEBUG[22696]: CRN 32840 - Doing a release call
[Jul 4 13:00:02] WARNING[22696]: Unicall/2 event Release call
[Jul 4 13:00:02] DEBUG[22696]: CRN 32840 - Call released
[Jul 4 13:00:02] VERBOSE[22696]: [Jul 4 13:00:02] -- Unicall/2
released
[Jul 4 13:00:02] DEBUG[22696]: disabled echo cancellation on channel 2
[Jul 4 13:00:02] DEBUG[22699]: Stopping retransmission on
'10f2e5cc-a418ab6-c9817029 at 192.168.1.141' of Request 102: Match Found
[Jul 4 13:00:02] DEBUG[22699]: Stopping retransmission on
'255227a0018cb6c510f55af62ad1d764 at 192.168.1.50' of Request 103: Match Found
[Jul 4 13:00:02] DEBUG[22699]: Stopping retransmission on
'129c0d1d2f0da8c15c397160686369d1 at 192.168.1.50' of Request 102: Match Found
[Jul 4 13:00:02] DEBUG[22635]: mpg123 pid 22693 and child died after 7424
bytes read
[Jul 4 13:00:02] VERBOSE[22635]: [Jul 4 13:00:02] Asterisk cleanly ending
(15).
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] Asterisk Event Logger
Started /var/log/asterisk/event_log
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Parsing
'/etc/asterisk/dnsmgr.conf': [Jul 4 13:00:03] VERBOSE[9072]: [Jul 4
13:00:03] == Parsing
'/etc/asterisk/dnsmgr.conf': [Jul 4 13:00:03] Found
[Jul 4 13:00:03] NOTICE[9072]: Managed DNS entries will be refreshed every
1200 seconds.
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] Asterisk Dynamic Loader
loading preload modules:
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Parsing
'/etc/asterisk/modules.conf': [Jul 4 13:00:03] VERBOSE[9072]: [Jul 4
13:00:03] == Parsing
'/etc/asterisk/modules.conf': [Jul 4 13:00:03] Found
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action Ping
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action Events
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action Logoff
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action Hangup
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action Status
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action Setvar
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action Getvar
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action Redirect
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action Originate
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action Command
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action ExtensionState
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action AbsoluteTimeout
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action MailboxStatus
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action MailboxCount
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Manager registered
action ListCommands
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Parsing
'/etc/asterisk/manager.conf': [Jul 4 13:00:03] VERBOSE[9072]: [Jul 4
13:00:03] == Parsing
'/etc/asterisk/manager.conf': [Jul 4 13:00:03] Found
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] Asterisk Management
interface listening on port 5038
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Parsing
'/etc/asterisk/cdr.conf': [Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03]
== Parsing '/e
tc/asterisk/cdr.conf': [Jul 4 13:00:03] Found
[Jul 4 13:00:03] NOTICE[9072]: CDR simple logging enabled.
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Parsing
'/etc/asterisk/rtp.conf': [Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03]
== Parsing '/e
tc/asterisk/rtp.conf': [Jul 4 13:00:03] Found
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == RTP Allocating from
port range 4460 -> 4560
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] Asterisk PBX Core
Initializing
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] Registering builtin
applications:
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [AbsoluteTimeout]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'AbsoluteTimeout'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [Answer]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'Answer'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [BackGround]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'BackGround'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [Busy]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'Busy'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [Congestion]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'Congestion'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [DigitTimeout]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'DigitTimeout'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [Goto]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'Goto'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [GotoIf]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'GotoIf'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [GotoIfTime]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'GotoIfTime'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [ExecIfTime]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'ExecIfTime'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [Hangup]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'Hangup'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [NoOp]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'NoOp'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [Progress]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'Progress'
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] [ResetCDR]
[Jul 4 13:00:03] VERBOSE[9072]: [Jul 4 13:00:03] == Registered
application 'ResetCDR'
More information about the asterisk-users
mailing list