[Feb 5 07:18:44] VERBOSE[13832] logger.c: AGI Rx << ANSWER [Feb 5 07:18:44] VERBOSE[13832] logger.c: AGI Tx >> 200 result=0 [Feb 5 07:18:44] VERBOSE[13832] logger.c: AGI Rx << CHANNEL STATUS [Feb 5 07:18:44] VERBOSE[13832] logger.c: AGI Tx >> 200 result=6 [Feb 5 07:18:44] VERBOSE[13832] logger.c: AGI Rx << SAY DIGITS 6 "" [Feb 5 07:18:44] DEBUG[13832] channel.c: Scheduling timer at 160 sample intervals [Feb 5 07:18:44] VERBOSE[13832] logger.c: -- Playing 'digits/6' (language 'en') [Feb 5 07:18:44] DEBUG[13848] manager.c: Manager received command 'Login' [Feb 5 07:18:44] VERBOSE[13848] logger.c: == Parsing '/etc/asterisk/manager.conf': [Feb 5 07:18:44] DEBUG[13848] config.c: Parsing /etc/asterisk/manager.conf [Feb 5 07:18:44] VERBOSE[13848] logger.c: Found [Feb 5 07:18:44] VERBOSE[13848] logger.c: == Manager 'nagios' logged on from 127.0.0.1 [Feb 5 07:18:44] DEBUG[13848] manager.c: Manager received command 'Command' [Feb 5 07:18:44] DEBUG[13848] manager.c: Manager received command 'Logoff' [Feb 5 07:18:44] VERBOSE[13848] logger.c: == Manager 'nagios' logged off from 127.0.0.1 [Feb 5 07:18:44] DEBUG[13849] manager.c: Manager received command 'Login' [Feb 5 07:18:44] VERBOSE[13849] logger.c: == Parsing '/etc/asterisk/manager.conf': [Feb 5 07:18:44] DEBUG[13849] config.c: Parsing /etc/asterisk/manager.conf [Feb 5 07:18:44] VERBOSE[13849] logger.c: Found [Feb 5 07:18:44] VERBOSE[13849] logger.c: == Manager 'nagios' logged on from 127.0.0.1 [Feb 5 07:18:44] DEBUG[13849] manager.c: Manager received command 'Command' [Feb 5 07:18:44] DEBUG[13849] manager.c: Manager received command 'Logoff' [Feb 5 07:18:44] VERBOSE[13849] logger.c: == Manager 'nagios' logged off from 127.0.0.1 [Feb 5 07:18:44] DEBUG[13832] channel.c: Scheduling timer at 150 sample intervals [Feb 5 07:18:44] DEBUG[13832] channel.c: Scheduling timer at 0 sample intervals [Feb 5 07:18:44] DEBUG[13832] channel.c: Scheduling timer at 0 sample intervals [Feb 5 07:18:44] VERBOSE[13832] logger.c: AGI Tx >> 200 result=0 [Feb 5 07:18:44] VERBOSE[13832] logger.c: AGI Rx << GET DATA one-moment-please 10000 3 [Feb 5 07:18:44] DEBUG[13832] channel.c: Scheduling timer at 160 sample intervals [Feb 5 07:18:44] VERBOSE[13832] logger.c: -- Playing 'one-moment-please' (language 'en') [Feb 5 07:18:45] DEBUG[21716] chan_sip.c: Auto destroying SIP dialog '46ec74ad689d23bd1a9189ff155ae042@202.83.176.47' [Feb 5 07:18:45] DEBUG[13832] channel.c: Scheduling timer at 104 sample intervals [Feb 5 07:18:45] DEBUG[13832] channel.c: Scheduling timer at 0 sample intervals [Feb 5 07:18:45] DEBUG[13832] channel.c: Scheduling timer at 0 sample intervals [Feb 5 07:18:46] DEBUG[13833] rtp.c: Sending dtmf: 49 (1), at 202.83.178.13 [Feb 5 07:18:46] DTMF[13833] channel.c: DTMF begin '1' received on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:46] DTMF[13833] channel.c: DTMF begin passthrough '1' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:46] DEBUG[13833] chan_zap.c: Started VLDTMF digit '1' [Feb 5 07:18:46] DEBUG[13833] rtp.c: Sending dtmf: 49 (1), at 202.83.178.13 [Feb 5 07:18:46] DTMF[13833] channel.c: DTMF end '1' received on SIP/lvl04.barnet.com.au-01446250, duration 100 ms [Feb 5 07:18:46] DTMF[13833] channel.c: DTMF end accepted with begin '1' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:46] DTMF[13833] channel.c: DTMF end passthrough '1' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:46] DEBUG[13833] chan_zap.c: Ending VLDTMF digit '1' [Feb 5 07:18:47] DEBUG[13833] rtp.c: Sending dtmf: 50 (2), at 202.83.178.13 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF begin '2' received on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF begin passthrough '2' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DEBUG[13833] chan_zap.c: Started VLDTMF digit '2' [Feb 5 07:18:47] DEBUG[13833] rtp.c: Sending dtmf: 50 (2), at 202.83.178.13 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF end '2' received on SIP/lvl04.barnet.com.au-01446250, duration 100 ms [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF end accepted with begin '2' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF end passthrough '2' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DEBUG[13833] chan_zap.c: Ending VLDTMF digit '2' [Feb 5 07:18:47] DEBUG[13833] rtp.c: Sending dtmf: 51 (3), at 202.83.178.13 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF begin '3' received on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF begin passthrough '3' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DEBUG[13833] chan_zap.c: Started VLDTMF digit '3' [Feb 5 07:18:47] DEBUG[13833] rtp.c: Sending dtmf: 51 (3), at 202.83.178.13 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF end '3' received on SIP/lvl04.barnet.com.au-01446250, duration 100 ms [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF end accepted with begin '3' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF end passthrough '3' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DEBUG[13833] chan_zap.c: Ending VLDTMF digit '3' [Feb 5 07:18:47] DEBUG[21716] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 5 07:18:47] DEBUG[13833] rtp.c: Sending dtmf: 52 (4), at 202.83.178.13 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF begin '4' received on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF begin passthrough '4' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DEBUG[13833] chan_zap.c: Started VLDTMF digit '4' [Feb 5 07:18:47] DEBUG[13833] rtp.c: Sending dtmf: 52 (4), at 202.83.178.13 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF end '4' received on SIP/lvl04.barnet.com.au-01446250, duration 100 ms [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF end accepted with begin '4' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF end passthrough '4' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DEBUG[13833] chan_zap.c: Ending VLDTMF digit '4' [Feb 5 07:18:47] DEBUG[13833] rtp.c: Sending dtmf: 53 (5), at 202.83.178.13 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF begin '5' received on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DTMF[13833] channel.c: DTMF begin passthrough '5' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:47] DEBUG[13833] chan_zap.c: Started VLDTMF digit '5' [Feb 5 07:18:48] DEBUG[13833] rtp.c: Sending dtmf: 53 (5), at 202.83.178.13 [Feb 5 07:18:48] DTMF[13833] channel.c: DTMF end '5' received on SIP/lvl04.barnet.com.au-01446250, duration 100 ms [Feb 5 07:18:48] DTMF[13833] channel.c: DTMF end accepted with begin '5' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:48] DTMF[13833] channel.c: DTMF end passthrough '5' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:48] DEBUG[13833] chan_zap.c: Ending VLDTMF digit '5' [Feb 5 07:18:48] DEBUG[13833] rtp.c: Sending dtmf: 54 (6), at 202.83.178.13 [Feb 5 07:18:48] DTMF[13833] channel.c: DTMF begin '6' received on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:48] DTMF[13833] channel.c: DTMF begin passthrough '6' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:48] DEBUG[13833] chan_zap.c: Started VLDTMF digit '6' [Feb 5 07:18:48] DEBUG[13833] rtp.c: Sending dtmf: 54 (6), at 202.83.178.13 [Feb 5 07:18:48] DTMF[13833] channel.c: DTMF end '6' received on SIP/lvl04.barnet.com.au-01446250, duration 100 ms [Feb 5 07:18:48] DTMF[13833] channel.c: DTMF end accepted with begin '6' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:48] DTMF[13833] channel.c: DTMF end passthrough '6' on SIP/lvl04.barnet.com.au-01446250 [Feb 5 07:18:48] DEBUG[13833] chan_zap.c: Ending VLDTMF digit '6' [Feb 5 07:18:49] DEBUG[21716] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 5 07:18:51] DEBUG[21716] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP) [Feb 5 07:18:51] DEBUG[21716] chan_sip.c: Stopping retransmission on '1373552413535bf5726daed56afc88c3@202.83.176.38' of Request 102: Match Not Found [Feb 5 07:18:56] VERBOSE[13832] logger.c: AGI Tx >> 200 result= (timeout) [Feb 5 07:18:56] VERBOSE[13832] logger.c: -- AGI Script callback2.agi completed, returning 0