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 [70@from-internal: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 [h@from-internal: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 [h@macro-dialout-trunk:1] Macro(“SIP/4999-0000083e”, “hangupcall,”) in new stack
[2015-02-26 11:24:21] VERBOSE[20791][C-00002c00] pbx.c: – Executing [s@macro-hangupcall: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 [s@macro-hangupcall: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 [s@macro-hangupcall: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 [71@from-internal: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 [s@macro-parked-call: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 [s@macro-parked-call: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 [s@macro-parked-call:6] Set(“SIP/4999-00000841”, “CCSS_SETUP=TRUE”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-parked-call:7] Macro(“SIP/4999-00000841”, “user-callerid,”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid: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 [s@macro-user-callerid:2] Set(“SIP/4999-00000841”, “AMPUSER=4999”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“SIP/4999-00000841”, “0?report”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid: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 [s@macro-user-callerid:5] Set(“SIP/4999-00000841”, “AMPUSER=4999”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/4999-00000841”, “0?limit”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid:7] Set(“SIP/4999-00000841”, “AMPUSERCIDNAME=VTG Test”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid:8] GotoIf(“SIP/4999-00000841”, “0?report”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid:9] Set(“SIP/4999-00000841”, “AMPUSERCID=4999”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid:10] Set(“SIP/4999-00000841”, “__DIAL_OPTIONS=Ttr”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid: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 [s@macro-user-callerid:12] GotoIf(“SIP/4999-00000841”, “0?limit”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid: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 [s@macro-user-callerid: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 [s@sub-ccss:1] ExecIf(“SIP/4999-00000841”, “4?Return()”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid: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 [s@macro-user-callerid:16] GotoIf(“SIP/4999-00000841”, “0?continue”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid:17] Set(“SIP/4999-00000841”, “__TTL=64”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid: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 [s@macro-user-callerid:29] Set(“SIP/4999-00000841”, “CALLERID(number)=4999”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid: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 [s@macro-user-callerid:31] Set(“SIP/4999-00000841”, “CDR(cnum)=4999”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-user-callerid: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 [s@macro-user-callerid:33] Set(“SIP/4999-00000841”, “CHANNEL(language)=en”) in new stack
[2015-02-26 11:24:26] VERBOSE[20808][C-00002c03] pbx.c: – Executing [s@macro-parked-call: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 [s@macro-parked-call: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 [s@macro-parked-call: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 [s@macro-one-touch-record: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 [s@macro-one-touch-record: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.