[asterisk-bugs] [JIRA] (ASTERISK-28142) asterisk will execute continuation of agi file in situation of simultaneous hangup in both side (caller and calle)
robert (JIRA)
noreply at issues.asterisk.org
Mon Nov 5 07:15:57 CST 2018
[ https://issues.asterisk.org/jira/browse/ASTERISK-28142?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=245363#comment-245363 ]
robert commented on ASTERISK-28142:
-----------------------------------
hello , that's my staffs :
[context]
exten => _49763xxx,1,agi(inbound-logger.php,${EXTEN})
exten => _49763xxx,n,verbose(${AGISTATUS})
exten => _49763xxx,n,verbose(${channelstatus})
exten => h,1,verbose($[${ack${app}${i}}])
exten => h,n,verbose(${AGISTATUS})
exten => h,n,Verbose(hangup cause : ${HANGUPCAUSE} for callid: ${callid})
exten => h,n,gotoif($[${AGISTATUS} != SUCCESS]?ack)
exten => h,n,hangup()
exten => h,n(ack),gotoif($["$[${ack${app}${i}}]"=“done”]?hang)
exten => h,n(ack),agi(ack-logger.php,${ivrkey},${calllogid},${callid},${uniqi},${actionid},${meta},${app},${i})
and this is mentioned part of my agi file : inbound-logger.php
$agi->exec(“DIAL LOCAL/”.$queue."@from-internal,g");
/////////////*END action-ack api call start az inja
$data = array(
'AckTimeType' => 9101,
'Ek' => $ivrkey,
'CallLogId' => $calllogid,
'CallId' => $callid,
'UniqueId' => $uniq,
'ActionId' => $actionid,
'Meta' => $meta
);
//LOG
$log_msg = $uniq.'--'.$cid.'--'.$did.'--'.$callid.' now its time to CALL END ACK in inbound.conf';
$log = logger($log_msg);
$data_string = json_encode($data);
$ch = curl_init();
curl_setopt($ch, CURLOPT_URL, $url_ack);
curl_setopt($ch, CURLOPT_CUSTOMREQUEST, "POST");
curl_setopt($ch, CURLOPT_POSTFIELDS, $data_string);
curl_setopt($ch, CURLOPT_RETURNTRANSFER, 1);
curl_setopt($ch, CURLOPT_HTTP_VERSION, CURL_HTTP_VERSION_1_1);
curl_setopt($ch, CURLOPT_HTTPHEADER, array(
'Content-Type: application/json',
'access-token: '.$token)
);
$resp = curl_exec($ch);
$status = curl_getinfo($ch, CURLINFO_HTTP_CODE);
curl_close($ch);
$agi->verbose("*****".$callid."*******ack sent to DB successfully and Status : ".$status."");
and ack-logger.php
$data = array(
‘AckTimeType’ => 9101,
‘Ek’ => $ivrkey,
‘CallLogId’ => $calllogid,
‘CallId’ => $callid,
‘UniqueId’ => $uniq,
‘Meta’ => $meta,
‘ActionId’ => $actionid
);
$data_string = json_encode($data);
//LOG
$log_msg = $uniq.'--'.$callid.'---The Parameters that will pass to ACK api : '.$data_string;
$log = logger($log_msg);
$ch = curl_init();
curl_setopt($ch, CURLOPT_URL, $url_ack);
curl_setopt($ch, CURLOPT_CUSTOMREQUEST, "POST");
curl_setopt($ch, CURLOPT_POSTFIELDS, $data_string);
curl_setopt($ch, CURLOPT_RETURNTRANSFER, 1);
curl_setopt($ch, CURLOPT_HTTP_VERSION, CURL_HTTP_VERSION_1_1);
curl_setopt($ch, CURLOPT_HTTPHEADER, array(
'Content-Type: application/json',
'access-token: '.$token)
);
$resp = curl_exec($ch);
//LOG
$log_msg = $uniq.'--'.$callid.'---Executing Ack api';
$log = logger($log_msg);
$status = curl_getinfo($ch, CURLINFO_HTTP_CODE);
curl_close($ch);
$agi->verbose("*****".$callid."*******ack sent to DB successfully and Status : ".$status."");
$agi->verbose("ACK Api STATUSSSS is".$status."");
console log :
[Oct 29 10:06:58] VERBOSE[22753][C-0000171e] netsock2.c: Using SIP RTP CoS mark 5
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] pbx.c: Executing [195 at check:1] AGI("SIP/router-00002504", "inbound-logger.php,195") in new stack
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/inbound-logger.php
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: clientnumber: 38212019
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: AGI Uniqid==>1540795018.26003
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: AGI channel==>SIP/router-00002504
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__uniqi=1540795018.26003)
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: ccnumber195
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__direction=2910)
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__ccnumber=195)
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__clientnumber=38212019)
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (file=1540795018.26003)
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (filein=1540795018.26003-in)
[Oct 29 10:06:58] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (fileout=1540795018.26003-out)
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: init-call- ID -STATUSSSS is200
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: CALLid : 736656
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: CallLog : 735648
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: Meta :
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__callid=736656)
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__calllogid=735648)
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__meta=)
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: ****get call action parameters****
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: Cid : 38212019
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: Did : 195
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: IvrKey :
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: Uniq : 1540795018.26003
[Oct 29 10:06:59] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: CALLid : 736656
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: get-call-action STATUSSSS is200
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: COUNTTTT is1
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (set) Options: (__app=background)
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: Application : background
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: ActionID: 5616845518657414009
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: app : 5616845518657414009
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: file to be played: /2018/10/27/IVR_VOICES_4892169794965414321
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__i=0)
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__ivrkey=)
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__actionid=5616845518657414009)
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: ACK Api STATUSSSS is200
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: *****736656******* Call Action Ack Sent To CA SUCCESSFULLY ***Start of background********
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: before READDDDDD
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (read) Options: (key,/mnt/iwinsharedstorage/2018/10/27/IVR_VOICES_4892169794965414321,1,n,,10)
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] app_read.c: Accepting a maximum of 1 digits.
[Oct 29 10:07:00] VERBOSE[28918][C-0000171e] file.c: <SIP/router-00002504> Playing '/mnt/iwinsharedstorage/2018/10/27/IVR_VOICES_4892169794965414321.slin' (language 'en')
[Oct 29 10:07:03] DTMF[28918][C-0000171e] channel.c: DTMF begin '1' received on SIP/router-00002504
[Oct 29 10:07:03] DTMF[28918][C-0000171e] channel.c: DTMF begin ignored '1' on SIP/router-00002504
[Oct 29 10:07:03] DTMF[28918][C-0000171e] channel.c: DTMF end '1' received on SIP/router-00002504, duration 100 ms
[Oct 29 10:07:03] DTMF[28918][C-0000171e] channel.c: DTMF end passthrough '1' on SIP/router-00002504
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] app_read.c: User entered '1'
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: entered KEYYY :1
[Oct 29 10:07:03] DTMF[28918][C-0000171e] channel.c: DTMF end '1' received on SIP/router-00002504, duration 100 ms
[Oct 29 10:07:03] DTMF[28918][C-0000171e] channel.c: DTMF begin emulation of '1' with duration 100 queued on SIP/router-00002504
[Oct 29 10:07:03] DTMF[28918][C-0000171e] channel.c: DTMF end emulation of '1' queued on SIP/router-00002504
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: ACK Api STATUSSSS is200
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__acksent=yes)
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: *****736656******* Call Action Ack Sent To CA SUCCESSFULLY ***End of BACKGRUND********
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__ackbackground0=done)
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: ****get call action parameters****
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: Cid : 38212019
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: Did : 195
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: IvrKey : 1
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: Uniq : 1540795018.26003
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: CALLid : 736656
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: get-call-action STATUSSSS is200
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: COUNTTTT is1
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (set) Options: (__app=queue)
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: Application : queue
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: ActionID: 5559018136604900665
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: app : 5559018136604900665
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__i=0)
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__ivrkey=1)
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__actionid=5559018136604900665)
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: ACK Api STATUSSSS is200
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: inbound-logger.php,195: *****736656******* Call Action Ack Sent To CA SUCCESSFULLY ***Start of QUEUE********
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] res_agi.c: AGI Script Executing Application: (DIAL) Options: (LOCAL/8080 at from-internal,,g)
[Oct 29 10:07:03] VERBOSE[28918][C-0000171e] app_dial.c: Called LOCAL/8080 at from-internal
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [8080 at from-internal:1] Gosub("Local/8080 at from-internal-00000717;2", "from-queue,8080,1") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [8080 at from-queue:1] Set("Local/8080 at from-internal-00000717;2", "qname=8080") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [8080 at from-queue:2] ExecIf("Local/8080 at from-internal-00000717;2", "1?macro(mixmon,38212019,8080,,queue)") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:1] Verbose("Local/8080 at from-internal-00000717;2", "38212019") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] app_verbose.c: 38212019
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:2] Set("Local/8080 at from-internal-00000717;2", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:3] Set("Local/8080 at from-internal-00000717;2", "CALLFILENAME=1540795018.26003") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:4] Verbose("Local/8080 at from-internal-00000717;2", "1540795018.26003") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] app_verbose.c: 1540795018.26003
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:5] Monitor("Local/8080 at from-internal-00000717;2", "wav,/mnt/iwinsharedstorage/2018/10/29/1540795018.26003,b") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:6] MixMonitor("Local/8080 at from-internal-00000717;2", "/mnt/iwinsharedstorage/2018/10/29/1540795018.26003.wav,b") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:7] Set("Local/8080 at from-internal-00000717;2", "__file1=1540795018.26003-in.wav") in new stack
[Oct 29 10:07:03] VERBOSE[28926][C-0000171e] app_mixmonitor.c: Begin MixMonitor Recording Local/8080 at from-internal-00000717;2
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:8] Set("Local/8080 at from-internal-00000717;2", "__file2=1540795018.26003-out.wav") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:9] Set("Local/8080 at from-internal-00000717;2", "__file3=1540795018.26003.wav") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:10] Set("Local/8080 at from-internal-00000717;2", "CDR(recordingfile)=1540795018.26003") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-mixmon:11] MacroExit("Local/8080 at from-internal-00000717;2", "") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [8080 at from-queue:3] QueueLog("Local/8080 at from-internal-00000717;2", "8080,1540795023.26006,NONE,DID,") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [8080 at from-queue:4] ExecIf("Local/8080 at from-internal-00000717;2", "0?Set(__t=120):Set(__t=120)") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] pbx.c: Executing [8080 at from-queue:5] Queue("Local/8080 at from-internal-00000717;2", "8080,c,,,120,i-logger.php") in new stack
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] res_musiconhold.c: Started music on hold, class 'default', on channel 'Local/8080 at from-internal-00000717;2'
[Oct 29 10:07:03] WARNING[28925][C-0000171e] translate.c: no samples for ulawtolin
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] netsock2.c: Using SIP RTP CoS mark 5
[Oct 29 10:07:03] VERBOSE[28925][C-0000171e] app_queue.c: Called SIP/1033
[Oct 29 10:07:04] VERBOSE[28925][C-0000171e] app_queue.c: SIP/1033-00002506 is ringing
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] app_queue.c: SIP/1033-00002506 answered Local/8080 at from-internal-00000717;2
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_musiconhold.c: Stopped music on hold on Local/8080 at from-internal-00000717;2
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/i-logger.php
[Oct 29 10:07:08] VERBOSE[28918][C-0000171e] app_dial.c: Local/8080 at from-internal-00000717;1 answered SIP/router-00002504
[Oct 29 10:07:08] VERBOSE[28941][C-0000171e] bridge_channel.c: Channel Local/8080 at from-internal-00000717;1 joined 'simple_bridge' basic-bridge <c7ede4db-d423-4385-9d0d-b89ccc6c91ed>
[Oct 29 10:07:08] VERBOSE[28918][C-0000171e] bridge_channel.c: Channel SIP/router-00002504 joined 'simple_bridge' basic-bridge <c7ede4db-d423-4385-9d0d-b89ccc6c91ed>
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: uniq==>1540795018.26003
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: callid==>736656
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: calllogid==>735648
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: actionid==>5559018136604900665
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: ivrkey==>1
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: meta==>
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: queueNAME==>8080
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: queue_interface==>SIP/1033
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: 1033
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: AGI Script Executing Application: (Set) Options: (__extensionNumber=1033)
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: ACK Api STATUSSSS is200
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: i-logger.php: *****736656******* Call Action Ack Sent To CA SUCCESSFULLY ***Start of Queue CONNECET ack-3********
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] res_agi.c: <Local/8080 at from-internal-00000717;2>AGI Script i-logger.php completed, returning 0
[Oct 29 10:07:08] VERBOSE[28942][C-0000171e] bridge_channel.c: Channel SIP/1033-00002506 joined 'simple_bridge' basic-bridge <9de5bd4c-d840-45d2-8d1a-dc757147409b>
[Oct 29 10:07:08] VERBOSE[28925][C-0000171e] bridge_channel.c: Channel Local/8080 at from-internal-00000717;2 joined 'simple_bridge' basic-bridge <9de5bd4c-d840-45d2-8d1a-dc757147409b>
[Oct 29 10:07:51] VERBOSE[28942][C-0000171e] bridge_channel.c: Channel SIP/1033-00002506 left 'simple_bridge' basic-bridge <9de5bd4c-d840-45d2-8d1a-dc757147409b>
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] bridge_channel.c: Channel Local/8080 at from-internal-00000717;2 left 'simple_bridge' basic-bridge <9de5bd4c-d840-45d2-8d1a-dc757147409b>
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] pbx.c: Executing [8080 at from-queue:6] Verbose("Local/8080 at from-internal-00000717;2", "queue becomes: CONTINUE") in new stack
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] app_verbose.c: queue becomes: CONTINUE
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] pbx.c: Executing [8080 at from-queue:7] Set("Local/8080 at from-internal-00000717;2", "__qstat=CONTINUE") in new stack
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] pbx.c: Executing [8080 at from-queue:8] Return("Local/8080 at from-internal-00000717;2", "") in new stack
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] pbx.c: Auto fallthrough, channel 'Local/8080 at from-internal-00000717;2' status is 'UNKNOWN'
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] pbx.c: Executing [h at from-internal:1] Macro("Local/8080 at from-internal-00000717;2", "hangupcall,") in new stack
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-hangupcall:1] Verbose("Local/8080 at from-internal-00000717;2", "1540795018.26003-in.wavand1540795018.26003-out.wavandd1540795018.26003.wav********id is### uinq is 1540795023.26006") in new stack
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] app_verbose.c: 1540795018.26003-in.wavand1540795018.26003-out.wavandd1540795018.26003.wav********id is### uinq is 1540795023.26006
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-hangupcall:2] Verbose("Local/8080 at from-internal-00000717;2", "") in new stack
[Oct 29 10:07:51] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-hangupcall:3] ExecIf("Local/8080 at from-internal-00000717;2", "1?system(sudo python3.6 /var/lib/asterisk/agi-bin/iwinvoicemail.py 736656 38212019 195 NULL 1351)") in new stack
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-hangupcall:4] AGI("Local/8080 at from-internal-00000717;2", "file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav") in new stack
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/file-cdr.php
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: 2018
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: 10
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: 29
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: uniqeIDDDD is1540795023.26006
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: IDDDD is1540795018.26003-in.wav
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: FILE1111 is1540795018.26003-out.wav
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: FILE2222 is1540795018.26003.wav
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: FILE3333 is
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: /var/spool/asterisk/monitor/2018/10/29/
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: file sizeee1 is
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: file sizeee2 is
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: file sizeee3 is
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: duration1 is
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: duration2 is
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: file-cdr.php,1540795023.26006,1540795018.26003-in.wav,1540795018.26003-out.wav,1540795018.26003.wav: duration3 is
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] res_agi.c: <Local/8080 at from-internal-00000717;2>AGI Script file-cdr.php completed, returning 0
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-hangupcall:5] Verbose("Local/8080 at from-internal-00000717;2", "[{"File":{"storageType":"3351","localPath":"/var/spool/asterisk/monitor/2018/10/29/","fileSize":"","extention":"wav","mimeType":"audio/wav","duration":"","type":"3300" ,"FileName":"1540795018.26003-out.wav"}},{"File":{"storageType":"3351","localPath":"/var/spool/asterisk/monitor/2018/10/29/","fileSize":"","extention":"wav","mimeType":"audio/wav","duration":"","type":"3301" ,"FileName":"1540795018.26003.wav"}},{"File":{"storageType":"3351","localPath":"/var/spool/asterisk/monitor/2018/10/29/","fileSize":"","extention":"wav","mimeType":"audio/wav","duration":"","type":"3302" ,"FileName":""}}]") in new stack
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] app_verbose.c: [{File:{storageType:3351,localPath:/var/spool/asterisk/monitor/2018/10/29/,fileSize:,extention:wav,mimeType:audio/wav,duration:,type:3300 ,FileName:1540795018.26003-out.wav}},{File:{storageType:3351,localPath:/var/spool/asterisk/monitor/2018/10/29/,fileSize:,extention:wav,mimeType:audio/wav,duration:,type:3301 ,FileName:1540795018.26003.wav}},{File:{storageType:3351,localPath:/var/spool/asterisk/monitor/2018/10/29/,fileSize:,extention:wav,mimeType:audio/wav,duration:,type:3302 ,FileName:}}]
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-hangupcall:6] Set("Local/8080 at from-internal-00000717;2", "CDR(Property)=[{"File":{"storageType":"3351","localPath":"/var/spool/asterisk/monitor/2018/10/29/","fileSize":"","extention":"wav","mimeType":"audio/wav","duration":"","type":"3300" ,"FileName":"1540795018.26003-out.wav"}},{"File":{"storageType":"3351","localPath":"/var/spool/asterisk/monitor/2018/10/29/","fileSize":"","extention":"wav","mimeType":"audio/wav","duration":"","type":"3301" ,"FileName":"1540795018.26003.wav"}},{"File":{"storageType":"3351","localPath":"/var/spool/asterisk/monitor/2018/10/29/","fileSize":"","extention":"wav","mimeType":"audio/wav","duration":"","type":"3302" ,"FileName":""}}]") in new stack
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-hangupcall:7] Set("Local/8080 at from-internal-00000717;2", "CDR(did)=") in new stack
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] pbx.c: Executing [s at macro-hangupcall:8] Hangup("Local/8080 at from-internal-00000717;2", "") in new stack
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] app_macro.c: Spawn extension (macro-hangupcall, s, 8) exited non-zero on 'Local/8080 at from-internal-00000717;2' in macro 'hangupcall'
[Oct 29 10:07:52] VERBOSE[28925][C-0000171e] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'Local/8080 at from-internal-00000717;2'
[Oct 29 10:07:52] VERBOSE[28941][C-0000171e] bridge_channel.c: Channel Local/8080 at from-internal-00000717;1 left 'simple_bridge' basic-bridge <c7ede4db-d423-4385-9d0d-b89ccc6c91ed>
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] bridge_channel.c: Channel SIP/router-00002504 left 'simple_bridge' basic-bridge <c7ede4db-d423-4385-9d0d-b89ccc6c91ed>
[Oct 29 10:07:52] VERBOSE[28926][C-0000171e] app_mixmonitor.c: MixMonitor close filestream (mixed)
[Oct 29 10:07:52] VERBOSE[28926][C-0000171e] app_mixmonitor.c: End MixMonitor Recording Local/8080 at from-internal-00000717;2
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] res_agi.c: <SIP/router-00002504>AGI Script inbound-logger.php completed, returning 4
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] pbx.c: Spawn extension (check, 195, 1) exited non-zero on 'SIP/router-00002504'
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] pbx.c: Executing [h at check:1] Verbose("SIP/router-00002504", "") in new stack
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] pbx.c: Executing [h at check:2] Verbose("SIP/router-00002504", "HANGUP") in new stack
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] app_verbose.c: HANGUP
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] pbx.c: Executing [h at check:3] Verbose("SIP/router-00002504", "hangup cause : 16 for callid: 736656") in new stack
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] app_verbose.c: hangup cause : 16 for callid: 736656
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] pbx.c: Executing [h at check:4] GotoIf("SIP/router-00002504", "1?ack") in new stack
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] pbx_builtins.c: Goto (check,h,6)
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] pbx.c: Executing [h at check:6] GotoIf("SIP/router-00002504", "0?hang") in new stack
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] pbx.c: Executing [h at check:7] AGI("SIP/router-00002504", "ack-logger.php,1,735648,736656,1540795018.26003,5559018136604900665,,queue,0") in new stack
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/ack-logger.php
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] res_agi.c: ack-logger.php,1,735648,736656,1540795018.26003,5559018136604900665,,queue,0: *****736656*******ack ro baraye bare aval call kardam and Status : 200
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] res_agi.c: ack-logger.php,1,735648,736656,1540795018.26003,5559018136604900665,,queue,0: ACK Api STATUSSSS is200
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] res_agi.c: ack-logger.php,1,735648,736656,1540795018.26003,5559018136604900665,,queue,0: *****736656******* Call Action Ack Sent To CA SUCCESSFULLY *****End of queue Final ack in h exten for queue******
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] res_agi.c: <SIP/router-00002504>AGI Script ack-logger.php completed, returning 0
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] pbx.c: Executing [h at check:8] Hangup("SIP/router-00002504", "") in new stack
[Oct 29 10:07:52] VERBOSE[28918][C-0000171e] pbx.c: Spawn extension (check, h, 8) exited non-zero on 'SIP/router-00002504'
> asterisk will execute continuation of agi file in situation of simultaneous hangup in both side (caller and calle)
> ------------------------------------------------------------------------------------------------------------------
>
> Key: ASTERISK-28142
> URL: https://issues.asterisk.org/jira/browse/ASTERISK-28142
> Project: Asterisk
> Issue Type: Bug
> Security Level: None
> Components: Resources/res_agi
> Affects Versions: 13.18.4
> Environment: centos7
> Reporter: robert
> Assignee: robert
> Severity: Critical
>
> agi continues to its work after call comes out from it and i h exten i see in log AGISTATUS is not success and its hangup,
> but it does the code after the place it comes out from agi ang go to h exten of main context
--
This message was sent by Atlassian JIRA
(v6.2#6252)
More information about the asterisk-bugs
mailing list