[Home]

Summary:ASTERISK-11914: Internal Calls cut after 20 seconds
Reporter:Bryan Walker (one2fone)Labels:
Date Opened:2008-04-24 13:50:35Date Closed:2011-06-07 14:02:43
Priority:MajorRegression?No
Status:Closed/CompleteComponents:. I did not set the category correctly.
Versions:Frequency of
Occurrence
Related
Issues:
Environment:Attachments:
Description:Whenever I dial an internal extension, or a feature ie Voicemail, the call cuts of after 20 seconds leaving no sound.

But if I ring from the PSTN, I can speak all day and listen to voicemail.

I have tried this using Polycom 430, Nokia E90, Nokia 95, and a softphone, and to avail they all have the same problem, so its not a phone default.  A copy of the logs are detailed below, 1 dialing the default call queue, and 1 ringing an extension.

[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:1] Macro("SIP/20000-09c79d78", "user-callerid|") in new stack
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:1] NoOp("SIP/20000-09c79d78", "user-callerid: device 20000") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Noop
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:2] Set("SIP/20000-09c79d78", "AMPUSER=20000") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Set
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:3] GotoIf("SIP/20000-09c79d78", "0?report") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: GotoIf
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:4] ExecIf("SIP/20000-09c79d78", "1|Set|REALCALLERIDNUM=20000") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: ExecIf
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:5] NoOp("SIP/20000-09c79d78", "REALCALLERIDNUM is 20000") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Noop
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:6] Set("SIP/20000-09c79d78", "AMPUSER=20000") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Set
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:7] Set("SIP/20000-09c79d78", "AMPUSERCIDNAME=Bryan Walker") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Set
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:8] GotoIf("SIP/20000-09c79d78", "0?report") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: GotoIf
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:9] Set("SIP/20000-09c79d78", "AMPUSERCID=20000") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Set
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:10] Set("SIP/20000-09c79d78", "CALLERID(all)="Bryan Walker" <20000>") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Set
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:11] Set("SIP/20000-09c79d78", "REALCALLERIDNUM=20000") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Set
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:12] ExecIf("SIP/20000-09c79d78", "1|Set|CHANNEL(language)=en") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: ExecIf
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Last app: Set|CHANNEL(language)=en
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:13] NoOp("SIP/20000-09c79d78", "TTL: ARG1: ") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Noop
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:14] GotoIf("SIP/20000-09c79d78", "0?continue") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: GotoIf
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:15] Set("SIP/20000-09c79d78", "__TTL=64") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Set
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:16] GotoIf("SIP/20000-09c79d78", "1?continue") in new stack
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Goto (macro-user-callerid,s,23)
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: GotoIf
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [s@macro-user-callerid:23] NoOp("SIP/20000-09c79d78", "Using CallerID "Bryan Walker" <20000>") in new stack
[Apr 24 13:12:54] DEBUG[30216] app_macro.c: Executed application: Noop
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:2] Answer("SIP/20000-09c79d78", "") in new stack
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:3] Set("SIP/20000-09c79d78", "__BLKVM_OVERRIDE=BLKVM/80000/SIP/20000-09c79d78") in new stack
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:4] Set("SIP/20000-09c79d78", "__BLKVM_BASE=80000") in new stack
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:5] Set("SIP/20000-09c79d78", "DB(BLKVM/80000/SIP/20000-09c79d78)=TRUE") in new stack
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:6] Set("SIP/20000-09c79d78", "_DIAL_OPTIONS=trM(auto-blkvm)") in new stack
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:7] Set("SIP/20000-09c79d78", "__NODEST=80000") in new stack
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:8] Set("SIP/20000-09c79d78", "MONITOR_FILENAME=/var/spool/asterisk/monitor/q80000-20080424-131254-1209060774.0") in new stack
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:9] Playback("SIP/20000-09c79d78", "custom/callimportant-gsm") in new stack
[Apr 24 13:12:54] VERBOSE[30216] logger.c: -- Playing 'custom/callimportant-gsm' (language 'en')
[Apr 24 13:13:01] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:10] Set("SIP/20000-09c79d78", "__MOHCLASS=default") in new stack
[Apr 24 13:13:01] VERBOSE[30216] logger.c: -- Executing [80000@from-internal:11] Queue("SIP/20000-09c79d78", "80000|t||") in new stack
[Apr 24 13:13:01] VERBOSE[30216] logger.c: -- Started music on hold, class 'default', on SIP/20000-09c79d78
[Apr 24 13:13:01] DEBUG[30216] app_queue.c: Everyone is busy at this time
[Apr 24 13:13:06] VERBOSE[30216] logger.c: -- Stopped music on hold on SIP/20000-09c79d78
[Apr 24 13:13:06] VERBOSE[30216] logger.c: -- Playing 'queue-youarenext' (language 'en')
[Apr 24 13:13:11] VERBOSE[30216] logger.c: -- Told SIP/20000-09c79d78 in 80000 their queue position (which was 1)
[Apr 24 13:13:11] VERBOSE[30216] logger.c: -- Playing 'queue-thankyou' (language 'en')
[Apr 24 13:13:13] VERBOSE[30216] logger.c: -- Started music on hold, class 'default', on SIP/20000-09c79d78
[Apr 24 13:13:13] DEBUG[30216] app_queue.c: Everyone is busy at this time
[Apr 24 13:13:14] WARNING[30159] chan_sip.c: Maximum retries exceeded on transmission cfa6a54d-e515294a-42437d9b@192.168.1.50 for seqno 2 (Critical Response)
[Apr 24 13:13:14] WARNING[30159] chan_sip.c: Hanging up call cfa6a54d-e515294a-42437d9b@192.168.1.50 - no reply to our critical packet.
[Apr 24 13:13:14] VERBOSE[30216] logger.c: -- Stopped music on hold on SIP/20000-09c79d78
[Apr 24 13:13:14] VERBOSE[30216] logger.c: == Spawn extension (from-internal, 80000, 11) exited non-zero on 'SIP/20000-09c79d78'
[Apr 24 13:13:14] VERBOSE[30216] logger.c: -- Executing [h@from-internal:1] Macro("SIP/20000-09c79d78", "hangupcall") in new stack
[Apr 24 13:13:14] VERBOSE[30216] logger.c: -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/20000-09c79d78", "w") in new stack
[Apr 24 13:13:14] DEBUG[30216] app_macro.c: Executed application: ResetCDR
[Apr 24 13:13:14] VERBOSE[30216] logger.c: -- Executing [s@macro-hangupcall:2] NoCDR("SIP/20000-09c79d78", "") in new stack
[Apr 24 13:13:14] DEBUG[30216] app_macro.c: Executed application: NoCDR
[Apr 24 13:13:14] VERBOSE[30216] logger.c: -- Executing [s@macro-hangupcall:3] GotoIf("SIP/20000-09c79d78", "1?skiprg") in new stack
[Apr 24 13:13:14] VERBOSE[30216] logger.c: -- Goto (macro-hangupcall,s,6)
[Apr 24 13:13:14] DEBUG[30216] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:14] VERBOSE[30216] logger.c: -- Executing [s@macro-hangupcall:6] GotoIf("SIP/20000-09c79d78", "0?skipblkvm") in new stack
[Apr 24 13:13:15] DEBUG[30216] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:15] VERBOSE[30216] logger.c: -- Executing [s@macro-hangupcall:7] NoOp("SIP/20000-09c79d78", "Cleaning Up Block VM Flag: BLKVM/80000/SIP/20000-09c79d78") in new stack
[Apr 24 13:13:15] DEBUG[30216] app_macro.c: Executed application: Noop
[Apr 24 13:13:15] VERBOSE[30216] logger.c: -- Executing [s@macro-hangupcall:8] DBdel("SIP/20000-09c79d78", "BLKVM/80000/SIP/20000-09c79d78") in new stack
[Apr 24 13:13:15] WARNING[30216] app_db.c: The DBdel application has been deprecated in favor of the DB_DELETE dialplan function!
[Apr 24 13:13:15] VERBOSE[30216] logger.c: -- DBdel: family=BLKVM, key=80000/SIP/20000-09c79d78
[Apr 24 13:13:15] DEBUG[30216] app_macro.c: Executed application: DBDel
[Apr 24 13:13:15] VERBOSE[30216] logger.c: -- Executing [s@macro-hangupcall:9] GotoIf("SIP/20000-09c79d78", "1?theend") in new stack
[Apr 24 13:13:15] VERBOSE[30216] logger.c: -- Goto (macro-hangupcall,s,11)
[Apr 24 13:13:15] DEBUG[30216] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:15] VERBOSE[30216] logger.c: -- Executing [s@macro-hangupcall:11] Hangup("SIP/20000-09c79d78", "") in new stack
[Apr 24 13:13:15] VERBOSE[30216] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/20000-09c79d78' in macro 'hangupcall'
[Apr 24 13:13:15] VERBOSE[30216] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/20000-09c79d78'
[Apr 24 13:13:24] VERBOSE[30221] logger.c: -- Executing [200001@from-internal:1] ResetCDR("SIP/20000-09cbd590", "") in new stack
[Apr 24 13:13:24] VERBOSE[30221] logger.c: -- Executing [200001@from-internal:2] NoCDR("SIP/20000-09cbd590", "") in new stack
[Apr 24 13:13:24] VERBOSE[30221] logger.c: -- Executing [200001@from-internal:3] Wait("SIP/20000-09cbd590", "1") in new stack
[Apr 24 13:13:25] VERBOSE[30221] logger.c: -- Executing [200001@from-internal:4] Playback("SIP/20000-09cbd590", "silence/1&cannot-complete-as-dialed&check-number-dial-again|noanswer") in new stack
[Apr 24 13:13:25] VERBOSE[30221] logger.c: -- Playing 'silence/1' (language 'en')
[Apr 24 13:13:26] VERBOSE[30221] logger.c: -- Playing 'cannot-complete-as-dialed' (language 'en')
[Apr 24 13:13:27] VERBOSE[30221] logger.c: == Spawn extension (from-internal, 200001, 4) exited non-zero on 'SIP/20000-09cbd590'
[Apr 24 13:13:27] VERBOSE[30221] logger.c: -- Executing [h@from-internal:1] Macro("SIP/20000-09cbd590", "hangupcall") in new stack
[Apr 24 13:13:27] VERBOSE[30221] logger.c: -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/20000-09cbd590", "w") in new stack
[Apr 24 13:13:27] DEBUG[30221] app_macro.c: Executed application: ResetCDR
[Apr 24 13:13:27] VERBOSE[30221] logger.c: -- Executing [s@macro-hangupcall:2] NoCDR("SIP/20000-09cbd590", "") in new stack
[Apr 24 13:13:27] DEBUG[30221] app_macro.c: Executed application: NoCDR
[Apr 24 13:13:27] VERBOSE[30221] logger.c: -- Executing [s@macro-hangupcall:3] GotoIf("SIP/20000-09cbd590", "1?skiprg") in new stack
[Apr 24 13:13:27] VERBOSE[30221] logger.c: -- Goto (macro-hangupcall,s,6)
[Apr 24 13:13:27] DEBUG[30221] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:27] VERBOSE[30221] logger.c: -- Executing [s@macro-hangupcall:6] GotoIf("SIP/20000-09cbd590", "1?skipblkvm") in new stack
[Apr 24 13:13:27] VERBOSE[30221] logger.c: -- Goto (macro-hangupcall,s,9)
[Apr 24 13:13:27] DEBUG[30221] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:27] VERBOSE[30221] logger.c: -- Executing [s@macro-hangupcall:9] GotoIf("SIP/20000-09cbd590", "1?theend") in new stack
[Apr 24 13:13:27] VERBOSE[30221] logger.c: -- Goto (macro-hangupcall,s,11)
[Apr 24 13:13:27] DEBUG[30221] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:27] VERBOSE[30221] logger.c: -- Executing [s@macro-hangupcall:11] Hangup("SIP/20000-09cbd590", "") in new stack
[Apr 24 13:13:27] VERBOSE[30221] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/20000-09cbd590' in macro 'hangupcall'
[Apr 24 13:13:27] VERBOSE[30221] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/20000-09cbd590'
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [20001@from-internal:1] Macro("SIP/20000-09cbd590", "exten-vm|20001|20001") in new stack
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-exten-vm:1] Macro("SIP/20000-09cbd590", "user-callerid") in new stack
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:1] NoOp("SIP/20000-09cbd590", "user-callerid: device 20000") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Noop
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:2] Set("SIP/20000-09cbd590", "AMPUSER=20000") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:3] GotoIf("SIP/20000-09cbd590", "0?report") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:4] ExecIf("SIP/20000-09cbd590", "1|Set|REALCALLERIDNUM=20000") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: ExecIf
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:5] NoOp("SIP/20000-09cbd590", "REALCALLERIDNUM is 20000") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Noop
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:6] Set("SIP/20000-09cbd590", "AMPUSER=20000") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:7] Set("SIP/20000-09cbd590", "AMPUSERCIDNAME=Bryan Walker") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:8] GotoIf("SIP/20000-09cbd590", "0?report") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:9] Set("SIP/20000-09cbd590", "AMPUSERCID=20000") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:10] Set("SIP/20000-09cbd590", "CALLERID(all)="Bryan Walker" <20000>") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:11] Set("SIP/20000-09cbd590", "REALCALLERIDNUM=20000") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:12] ExecIf("SIP/20000-09cbd590", "1|Set|CHANNEL(language)=en") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: ExecIf
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Last app: Set|CHANNEL(language)=en
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:13] NoOp("SIP/20000-09cbd590", "TTL: ARG1: 20001") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Noop
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:14] GotoIf("SIP/20000-09cbd590", "0?continue") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:15] Set("SIP/20000-09cbd590", "__TTL=64") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:16] GotoIf("SIP/20000-09cbd590", "1?continue") in new stack
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Goto (macro-user-callerid,s,23)
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-user-callerid:23] NoOp("SIP/20000-09cbd590", "Using CallerID "Bryan Walker" <20000>") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Noop
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Macro
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-exten-vm:2] Set("SIP/20000-09cbd590", "FROMCONTEXT=exten-vm") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-exten-vm:3] Set("SIP/20000-09cbd590", "VMBOX=20001") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-exten-vm:4] Set("SIP/20000-09cbd590", "EXTTOCALL=20001") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] DEBUG[30222] func_db.c: DB: CFU/20001 not found in database.
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-exten-vm:5] Set("SIP/20000-09cbd590", "CFUEXT=") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] DEBUG[30222] func_db.c: DB: CFB/20001 not found in database.
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-exten-vm:6] Set("SIP/20000-09cbd590", "CFBEXT=") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-exten-vm:7] Set("SIP/20000-09cbd590", "RT=15") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Set
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-exten-vm:8] Macro("SIP/20000-09cbd590", "record-enable|20001|IN") in new stack
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-record-enable:1] GotoIf("SIP/20000-09cbd590", "0?2:4") in new stack
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Goto (macro-record-enable,s,4)
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-record-enable:4] AGI("SIP/20000-09cbd590", "recordingcheck|20080424-131332|1209060812.2") in new stack
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
[Apr 24 13:13:32] VERBOSE[30222] logger.c: recordingcheck|20080424-131332|1209060812.2: Inbound recording not enabled
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- AGI Script recordingcheck completed, returning 0
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: AGI
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-record-enable:5] NoOp("SIP/20000-09cbd590", "No recording needed") in new stack
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Noop
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: Macro
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-exten-vm:9] Macro("SIP/20000-09cbd590", "dial|15|tr|20001") in new stack
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-dial:1] GotoIf("SIP/20000-09cbd590", "1?dial") in new stack
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Goto (macro-dial,s,3)
[Apr 24 13:13:32] DEBUG[30222] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Executing [s@macro-dial:3] AGI("SIP/20000-09cbd590", "dialparties.agi") in new stack
[Apr 24 13:13:32] VERBOSE[30222] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[Apr 24 13:13:33] VERBOSE[30222] logger.c: dialparties.agi: Starting New Dialparties.agi
[Apr 24 13:13:33] VERBOSE[30225] logger.c: == Parsing '/etc/asterisk/manager.conf': [Apr 24 13:13:33] VERBOSE[30225] logger.c: Found
[Apr 24 13:13:33] VERBOSE[30225] logger.c: == Parsing '/etc/asterisk/manager_additional.conf': [Apr 24 13:13:33] VERBOSE[30225] logger.c: Found
[Apr 24 13:13:33] VERBOSE[30225] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': [Apr 24 13:13:33] VERBOSE[30225] logger.c: Found
[Apr 24 13:13:33] VERBOSE[30225] logger.c: == Manager 'admin' logged on from 127.0.0.1
[Apr 24 13:13:33] VERBOSE[30222] logger.c: dialparties.agi: Caller ID name is 'Bryan Walker' number is '20000'
[Apr 24 13:13:33] VERBOSE[30222] logger.c: dialparties.agi: Methodology of ring is 'none'
[Apr 24 13:13:33] VERBOSE[30222] logger.c: -- dialparties.agi: Added extension 20001 to extension map
[Apr 24 13:13:33] VERBOSE[30222] logger.c: -- dialparties.agi: Extension 20001 cf is disabled
[Apr 24 13:13:33] VERBOSE[30222] logger.c: -- dialparties.agi: Extension 20001 do not disturb is disabled
[Apr 24 13:13:33] VERBOSE[30222] logger.c: -- dialparties.agi: dbset CALLTRACE/20001 to 20000
[Apr 24 13:13:33] VERBOSE[30222] logger.c: -- dialparties.agi: Filtered ARG3: 20001
[Apr 24 13:13:33] VERBOSE[30225] logger.c: == Manager 'admin' logged off from 127.0.0.1
[Apr 24 13:13:33] VERBOSE[30222] logger.c: -- AGI Script dialparties.agi completed, returning 0
[Apr 24 13:13:33] DEBUG[30222] app_macro.c: Executed application: AGI
[Apr 24 13:13:33] VERBOSE[30222] logger.c: -- Executing [s@macro-dial:7] Dial("SIP/20000-09cbd590", "SIP/20001|15|tr") in new stack
[Apr 24 13:13:33] VERBOSE[30222] logger.c: -- Called 20001
[Apr 24 13:13:34] VERBOSE[30222] logger.c: -- SIP/20001-09c7b760 is ringing
[Apr 24 13:13:37] VERBOSE[30222] logger.c: -- SIP/20001-09c7b760 answered SIP/20000-09cbd590
[Apr 24 13:13:57] WARNING[30159] chan_sip.c: Maximum retries exceeded on transmission d68a34fb-574a81f0-6cfea419@192.168.1.50 for seqno 2 (Critical Response)
[Apr 24 13:13:57] WARNING[30159] chan_sip.c: Hanging up call d68a34fb-574a81f0-6cfea419@192.168.1.50 - no reply to our critical packet.
[Apr 24 13:13:57] VERBOSE[30222] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/20000-09cbd590' in macro 'dial'
[Apr 24 13:13:57] VERBOSE[30222] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/20000-09cbd590' in macro 'exten-vm'
[Apr 24 13:13:57] VERBOSE[30222] logger.c: == Spawn extension (macro-dial, s, 7) exited non-zero on 'SIP/20000-09cbd590'
[Apr 24 13:13:57] VERBOSE[30222] logger.c: -- Executing [h@macro-dial:1] Macro("SIP/20000-09cbd590", "hangupcall") in new stack
[Apr 24 13:13:57] VERBOSE[30222] logger.c: -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/20000-09cbd590", "w") in new stack
[Apr 24 13:13:57] DEBUG[30222] app_macro.c: Executed application: ResetCDR
[Apr 24 13:13:57] VERBOSE[30222] logger.c: -- Executing [s@macro-hangupcall:2] NoCDR("SIP/20000-09cbd590", "") in new stack
[Apr 24 13:13:57] DEBUG[30222] app_macro.c: Executed application: NoCDR
[Apr 24 13:13:57] VERBOSE[30222] logger.c: -- Executing [s@macro-hangupcall:3] GotoIf("SIP/20000-09cbd590", "1?skiprg") in new stack
[Apr 24 13:13:57] VERBOSE[30222] logger.c: -- Goto (macro-hangupcall,s,6)
[Apr 24 13:13:57] DEBUG[30222] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:57] VERBOSE[30222] logger.c: -- Executing [s@macro-hangupcall:6] GotoIf("SIP/20000-09cbd590", "1?skipblkvm") in new stack
[Apr 24 13:13:57] VERBOSE[30222] logger.c: -- Goto (macro-hangupcall,s,9)
[Apr 24 13:13:57] DEBUG[30222] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:57] VERBOSE[30222] logger.c: -- Executing [s@macro-hangupcall:9] GotoIf("SIP/20000-09cbd590", "1?theend") in new stack
[Apr 24 13:13:57] VERBOSE[30222] logger.c: -- Goto (macro-hangupcall,s,11)
[Apr 24 13:13:57] DEBUG[30222] app_macro.c: Executed application: GotoIf
[Apr 24 13:13:57] VERBOSE[30222] logger.c: -- Executing [s@macro-hangupcall:11] Hangup("SIP/20000-09cbd590", "") in new stack
[Apr 24 13:13:57] VERBOSE[30222] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/20000-09cbd590' in macro 'hangupcall'
[Apr 24 13:13:57] VERBOSE[30222] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/20000-09cbd590'
Comments:By: Joshua C. Colp (jcolp) 2008-04-24 13:54:36

You are going to need to provide A LOT more information. Console output, what technologies are involved, sip debug or iax2 debug if either are involved, dialplan logic.
By: Jason Parker (jparker) 2008-05-01 13:04:26

Closing, due to lack of information.

Please reopen if you can provide what was requested.