Recording a call retrieved from Park

I am having an issue that calls are not recording when retrieving a call from park and then using the *1 on demand record feature code. I have tried the solution found here and it has not worked:

http://issues.freepbx.org/browse/FREEPBX-7129

We are running Asterisk 11.8.1 with FreePBX 2.11.0.42. Below is the log file of the most recent test up to from putting the call in Park to the error when trying to record:

[2015-02-26 11:24:17] VERBOSE[20807][C-00002c02] pbx.c: – Executing [[email protected]:1] Park(“SIP/4999-00000840”, “”) in new stack
[2015-02-26 11:24:19] VERBOSE[20807][C-00002c02] features.c: == Parked SIP/4999-00000840 on 71 (lot default). Will timeout back to extension [from-internal] s, 1 in 180 seconds
[2015-02-26 11:24:19] VERBOSE[20807][C-00002c02] pbx.c: – Added extension ‘71’ priority 1 to parkedcalls
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 221
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 420
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 219
[2015-02-26 11:24:19] VERBOSE[20807][C-00002c02] file.c: – <SIP/4999-00000840> Playing ‘digits/7.ulaw’ (language ‘en’)
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 125
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 218
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 220
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 121
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 115
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 116
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 124
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 112
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 114
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 110
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 118
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 117
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 119
[2015-02-26 11:24:19] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state InUse for Notify User 113
[2015-02-26 11:24:20] VERBOSE[20807][C-00002c02] file.c: – <SIP/4999-00000840> Playing ‘digits/1.ulaw’ (language ‘en’)
[2015-02-26 11:24:20] VERBOSE[20807][C-00002c02] res_musiconhold.c: – Started music on hold, class ‘default’, on SIP/4999-00000840
[2015-02-26 11:24:20] VERBOSE[20807][C-00002c02] pbx.c: == Spawn extension (from-internal, s, 1) exited non-zero on ‘Parked/SIP/4999-00000840’
[2015-02-26 11:24:20] VERBOSE[20807][C-00002c02] pbx.c: – Executing [[email protected]:1] Hangup(“Parked/SIP/4999-00000840”, “”) in new stack
[2015-02-26 11:24:20] VERBOSE[20807][C-00002c02] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on ‘Parked/SIP/4999-00000840’
[2015-02-26 11:24:21] VERBOSE[26162][C-00002c00] res_musiconhold.c: – Stopped music on hold on SIP/4999-00000840
[2015-02-26 11:24:21] VERBOSE[26162][C-00002c00] res_musiconhold.c: – Stopped music on hold on SIP/MandKtoToCHIHE1-0000083f
[2015-02-26 11:24:21] VERBOSE[26162][C-00002c00] res_musiconhold.c: – Started music on hold, class ‘default’, on SIP/MandKtoToCHIHE1-0000083f
[2015-02-26 11:24:21] VERBOSE[26162][C-00002c00] res_musiconhold.c: – Stopped music on hold on SIP/MandKtoToCHIHE1-0000083f
[2015-02-26 11:24:21] VERBOSE[26153] res_musiconhold.c: – Started music on hold, class ‘default’, on SIP/MandKtoToCHIHE1-0000083f
[2015-02-26 11:24:21] VERBOSE[20791][C-00002c00] pbx.c: – Executing [[email protected]:1] Macro(“SIP/4999-0000083e”, “hangupcall,”) in new stack
[2015-02-26 11:24:21] VERBOSE[20791][C-00002c00] pbx.c: – Executing [[email protected]:1] GotoIf(“SIP/4999-0000083e”, “1?theend”) in new stack
[2015-02-26 11:24:21] VERBOSE[20791][C-00002c00] pbx.c: – Goto (macro-hangupcall,s,3)
[2015-02-26 11:24:21] VERBOSE[20791][C-00002c00] pbx.c: – Executing [[email protected]:3] ExecIf(“SIP/4999-0000083e”, “0?Set(CDR(recordingfile)=)”) in new stack
[2015-02-26 11:24:21] VERBOSE[20791][C-00002c00] pbx.c: – Executing [[email protected]:4] Hangup(“SIP/4999-0000083e”, “”) in new stack
[2015-02-26 11:24:21] VERBOSE[20791][C-00002c00] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/4999-0000083e’ in macro ‘hangupcall’
[2015-02-26 11:24:21] VERBOSE[20791][C-00002c00] pbx.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on ‘SIP/4999-0000083e’
[2015-02-26 11:24:21] VERBOSE[20791][C-00002c00] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on ‘SIP/4999-0000083e’ in macro ‘dialout-trunk’
[2015-02-26 11:24:21] VERBOSE[20791][C-00002c00] pbx.c: == Spawn extension (from-internal, 4192559070, 5) exited non-zero on ‘SIP/4999-0000083e’
[2015-02-26 11:24:25] WARNING[26162] chan_sip.c: Retransmission timeout reached on transmission [email protected] for seqno 145 (Critical Request) – See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
Packet timed out after 6399ms with no response
[2015-02-26 11:24:26] VERBOSE[26162][C-00002c03] netsock2.c: == Using SIP RTP TOS bits 184
[2015-02-26 11:24:26] VERBOSE[26162][C-00002c03] netsock2.c: == Using SIP RTP CoS mark 5
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:1] Macro(“SIP/4999-00000841”, “parked-call,71,default”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:1] AGI(“SIP/4999-00000841”, “parkfetch.agi,71”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] res_agi.c: – Launched AGI Script /var/lib/asterisk/agi-bin/parkfetch.agi
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] res_agi.c: – <SIP/4999-00000841>AGI Script parkfetch.agi completed, returning 0
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:2] GotoIf(“SIP/4999-00000841”, “1?next”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Goto (macro-parked-call,s,6)
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:6] Set(“SIP/4999-00000841”, “CCSS_SETUP=TRUE”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:7] Macro(“SIP/4999-00000841”, “user-callerid,”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:1] Set(“SIP/4999-00000841”, “TOUCH_MONITOR=1424967866.23023”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:2] Set(“SIP/4999-00000841”, “AMPUSER=4999”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:3] GotoIf(“SIP/4999-00000841”, “0?report”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:4] ExecIf(“SIP/4999-00000841”, “1?Set(REALCALLERIDNUM=4999)”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:5] Set(“SIP/4999-00000841”, “AMPUSER=4999”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:6] GotoIf(“SIP/4999-00000841”, “0?limit”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:7] Set(“SIP/4999-00000841”, “AMPUSERCIDNAME=VTG Test”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:8] GotoIf(“SIP/4999-00000841”, “0?report”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:9] Set(“SIP/4999-00000841”, “AMPUSERCID=4999”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:10] Set(“SIP/4999-00000841”, “__DIAL_OPTIONS=Ttr”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:11] Set(“SIP/4999-00000841”, “CALLERID(all)=“VTG Test” <4999>”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:12] GotoIf(“SIP/4999-00000841”, “0?limit”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:13] ExecIf(“SIP/4999-00000841”, “0?Set(GROUP(concurrency_limit)=4999)”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:14] GosubIf(“SIP/4999-00000841”, “7?sub-ccss,s,1(macro-parked-call,71)”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:1] ExecIf(“SIP/4999-00000841”, “4?Return()”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:15] ExecIf(“SIP/4999-00000841”, “0?Set(CHANNEL(language)=)”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:16] GotoIf(“SIP/4999-00000841”, “0?continue”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:17] Set(“SIP/4999-00000841”, “__TTL=64”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:18] GotoIf(“SIP/4999-00000841”, “1?continue”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Goto (macro-user-callerid,s,29)
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:29] Set(“SIP/4999-00000841”, “CALLERID(number)=4999”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:30] Set(“SIP/4999-00000841”, “CALLERID(name)=VTG Test”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:31] Set(“SIP/4999-00000841”, “CDR(cnum)=4999”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:32] Set(“SIP/4999-00000841”, “CDR(cnam)=VTG Test”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:33] Set(“SIP/4999-00000841”, “CHANNEL(language)=en”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:8] GotoIf(“SIP/4999-00000841”, “1?pcall”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Goto (macro-parked-call,s,15)
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:15] NoOp(“SIP/4999-00000841”, “User: “VTG Test” <4999> attempting to pick up Parked Call Slot 71”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:16] ParkedCall(“SIP/4999-00000841”, “71,default”) in new stack
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 221
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 420
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 219
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 218
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] res_musiconhold.c: – Stopped music on hold on SIP/MandKtoToCHIHE1-0000083f
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 220
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 121
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 115
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 116
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 124
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 112
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 114
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 110
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 118
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 117
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 119
[2015-02-26 11:24:26] VERBOSE[26152] chan_sip.c: == Extension Changed 71[park-hints] new state Idle for Notify User 113
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] file.c: – <SIP/4999-00000841> Playing ‘beep.ulaw’ (language ‘en’)
[2015-02-26 11:24:27] VERBOSE[20808][C-00002c03] features.c: – Channel SIP/4999-00000841 connected to parked call 71
[2015-02-26 11:24:30] VERBOSE[20808][C-00002c03] features.c: – Feature Found: apprecord exten: apprecord
[2015-02-26 11:24:30] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:1] Set(“SIP/4999-00000841”, “ONETOUCH_REC_SCRIPT_STATUS=”) in new stack
[2015-02-26 11:24:30] VERBOSE[20808][C-00002c03] pbx.c: – Executing [[email protected]:2] System(“SIP/4999-00000841”, “/var/lib/asterisk/bin/one_touch_record.php SIP/4999-00000841”) in new stack
[2015-02-26 11:24:30] VERBOSE[20813] app_mixmonitor.c: == Begin MixMonitor Recording SIP/4999-00000841
[2015-02-26 11:24:30] WARNING[20813] file.c: Unable to open file ///.wav: Permission denied
[2015-02-26 11:24:30] ERROR[20813] app_mixmonitor.c: Cannot open ///.wav

The fix in 7129 only made it into FreePBX 12. Along with the recording rewrite that was done in 12 I can say that this will probably only ever work reliably in 12.

Ok, thanks Andrew. We will just update to 12.