Here are few more logs:
tail -f /var/log/asterisk/full
[Aug 14 14:30:53] VERBOSE[3265] pbx.c: == Registered custom function ‘QUEUE_MEMBER_COUNT’
[Aug 14 14:30:53] VERBOSE[3265] pbx.c: == Registered custom function ‘QUEUE_MEMBER_LIST’
[Aug 14 14:30:53] VERBOSE[3265] pbx.c: == Registered custom function ‘QUEUE_WAITING_COUNT’
[Aug 14 14:30:53] VERBOSE[3265] pbx.c: == Registered custom function ‘QUEUE_MEMBER_PENALTY’
[Aug 14 14:30:53] VERBOSE[3265] loader.c: app_queue.so => (True Call Queueing)
[Aug 14 14:30:53] VERBOSE[3265] config.c: == Parsing ‘/etc/asterisk/cli_permissions.conf’: Found
[Aug 14 14:30:53] VERBOSE[3265] asterisk.c: Asterisk Ready.
[Aug 14 14:30:53] VERBOSE[3265] config.c: == Parsing ‘/etc/asterisk/cli.conf’: Found
[Aug 14 14:31:08] VERBOSE[3291] asterisk.c: – Remote UNIX connection
[Aug 14 14:31:23] VERBOSE[3579] asterisk.c: – Remote UNIX connection disconnected
[Aug 14 14:31:36] VERBOSE[3522][C-00000000] netsock2.c: == Using SIP RTP TOS bits 184
[Aug 14 14:31:36] VERBOSE[3522][C-00000000] netsock2.c: == Using SIP RTP CoS mark 5
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [8081891182@from-trunk:1] Set(“SIP/inbound-00000000”, “__FROM_DID=8081891182”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [8081891182@from-trunk:2] Gosub(“SIP/inbound-00000000”, “app-blacklist-check,s,1”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@app-blacklist-check:1] GotoIf(“SIP/inbound-00000000”, “0?blacklisted”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@app-blacklist-check:2] Set(“SIP/inbound-00000000”, “CALLED_BLACKLIST=1”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@app-blacklist-check:3] Return(“SIP/inbound-00000000”, “”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [8081891182@from-trunk:3] ExecIf(“SIP/inbound-00000000”, “0 ?Set(CALLERID(name)=)”) in new stack
[Aug 14 14:31:36] WARNING[3581][C-00000000] func_callerid.c: CALLERPRES is deprecated. Use CALLERID(name-pres) or CALLERID(num-pres) instead.
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [8081891182@from-trunk:4] Set(“SIP/inbound-00000000”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [8081891182@from-trunk:5] Set(“SIP/inbound-00000000”, “CALLERPRES()=allowed_not_screened”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [8081891182@from-trunk:6] Goto(“SIP/inbound-00000000”, “ext-queues,3003,1”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Goto (ext-queues,3003,1)
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:1] Macro(“SIP/inbound-00000000”, “user-callerid,”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/inbound-00000000”, “AMPUSER=”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:2] GotoIf(“SIP/inbound-00000000”, “0?report”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:3] ExecIf(“SIP/inbound-00000000”, “1?Set(REALCALLERIDNUM=)”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:4] Set(“SIP/inbound-00000000”, “AMPUSER=”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/inbound-00000000”, “AMPUSERCIDNAME=”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/inbound-00000000”, “1?report”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Goto (macro-user-callerid,s,10)
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:10] GotoIf(“SIP/inbound-00000000”, “0?continue”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:11] Set(“SIP/inbound-00000000”, “__TTL=64”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:12] GotoIf(“SIP/inbound-00000000”, “1?continue”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Goto (macro-user-callerid,s,19)
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:19] Set(“SIP/inbound-00000000”, “CALLERID(number)=”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:20] Set(“SIP/inbound-00000000”, “CALLERID(name)=TollFreeForwarding”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-user-callerid:21] NoOp(“SIP/inbound-00000000”, “Using CallerID “TollFreeForwarding” <>”) in new stack
[Aug 14 14:31:36] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:2] Answer(“SIP/inbound-00000000”, “”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:3] Set(“SIP/inbound-00000000”, “__BLKVM_OVERRIDE=BLKVM/3003/SIP/inbound-00000000”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:4] Set(“SIP/inbound-00000000”, “__BLKVM_BASE=3003”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:5] Set(“SIP/inbound-00000000”, “DB(BLKVM/3003/SIP/inbound-00000000)=TRUE”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:6] ExecIf(“SIP/inbound-00000000”, “1?Set(_DIAL_OPTIONS=trM(auto-blkvm))”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:7] Set(“SIP/inbound-00000000”, “__NODEST=3003”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:8] Set(“SIP/inbound-00000000”, “MONITOR_FILENAME=/var/spool/asterisk/monitor/q3003-20130814-143137-1376470896.0”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:9] Set(“SIP/inbound-00000000”, “__MOHCLASS=none”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:10] Set(“SIP/inbound-00000000”, “__CWIGNORE=TRUE”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:11] Set(“SIP/inbound-00000000”, “__CFIGNORE=TRUE”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:12] Set(“SIP/inbound-00000000”, “__FORWARD_CONTEXT=block-cf”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:13] Queue(“SIP/inbound-00000000”, “3003,t,”) in new stack
[Aug 14 14:31:37] WARNING[3581][C-00000000] app_queue.c: Unable to join queue ‘3003’
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:14] NoOp(“SIP/inbound-00000000”, “Deleting: BLKVM/3003/SIP/inbound-00000000 TRUE”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:15] Set(“SIP/inbound-00000000”, “__NODEST=”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:16] Set(“SIP/inbound-00000000”, “__CWIGNORE=”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:17] Set(“SIP/inbound-00000000”, “__CFIGNORE=”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:18] Set(“SIP/inbound-00000000”, “__FORWARD_CONTEXT=from-internal”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [3003@ext-queues:19] Goto(“SIP/inbound-00000000”, “”) in new stack
[Aug 14 14:31:37] WARNING[3581][C-00000000] pbx.c: Goto requires an argument ([[context,]extension,]priority)
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: == Spawn extension (ext-queues, 3003, 19) exited non-zero on ‘SIP/inbound-00000000’
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [h@ext-queues:1] Macro(“SIP/inbound-00000000”, “hangupcall,”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/inbound-00000000”, “1?endmixmoncheck”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Goto (macro-hangupcall,s,9)
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:9] NoOp(“SIP/inbound-00000000”, “End of MIXMON check”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:10] GotoIf(“SIP/inbound-00000000”, “1?nomeetmemon”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Goto (macro-hangupcall,s,28)
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:28] NoOp(“SIP/inbound-00000000”, “End of MEETME check”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:29] GotoIf(“SIP/inbound-00000000”, “1?noautomon”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Goto (macro-hangupcall,s,34)
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:34] NoOp(“SIP/inbound-00000000”, “TOUCH_MONITOR_OUTPUT=”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:35] GotoIf(“SIP/inbound-00000000”, “0?noautomon2”) in new stack
[Aug 14 14:31:37] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:36] System(“SIP/inbound-00000000”, “test -e /var/spool/asterisk/monitor/q3003-20130814-143137-1376470896.0*”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:37] NoOp(“SIP/inbound-00000000”, “SYSTEMSTATUS = APPERROR”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:38] GotoIf(“SIP/inbound-00000000”, “1?errornoautomon”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Goto (macro-hangupcall,s,40)
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:40] NoOp(“SIP/inbound-00000000”, “End of MONITOR QUEUE check”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:41] NoOp(“SIP/inbound-00000000”, “MONITOR_FILENAME=/var/spool/asterisk/monitor/q3003-20130814-143137-1376470896.0”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:42] GotoIf(“SIP/inbound-00000000”, “1?skiprg”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Goto (macro-hangupcall,s,45)
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:45] GotoIf(“SIP/inbound-00000000”, “0?skipblkvm”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:46] NoOp(“SIP/inbound-00000000”, “Cleaning Up Block VM Flag: BLKVM/3003/SIP/inbound-00000000”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:47] NoOp(“SIP/inbound-00000000”, "Deleting: BLKVM/3003/SIP/inbound-00000000 ") in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:48] GotoIf(“SIP/inbound-00000000”, “1?theend”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Goto (macro-hangupcall,s,50)
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:50] AGI(“SIP/inbound-00000000”, “hangup.agi”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] res_agi.c: – Launched AGI Script /var/lib/asterisk/agi-bin/hangup.agi
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] res_agi.c: – <SIP/inbound-00000000>AGI Script hangup.agi completed, returning 0
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: – Executing [s@macro-hangupcall:51] Hangup(“SIP/inbound-00000000”, “”) in new stack
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] app_macro.c: == Spawn extension (macro-hangupcall, s, 51) exited non-zero on ‘SIP/inbound-00000000’ in macro ‘hangupcall’
[Aug 14 14:31:59] VERBOSE[3581][C-00000000] pbx.c: == Spawn extension (ext-queues, h, 1) exited non-zero on ‘SIP/inbound-00000000’
[1]+ Stopped tail -f /var/log/asterisk/full