Topic: Sail not recording calls

[Franco]

Hi,
I'm testing the new sail-2.4.1-10 and I can't get it to record the calls.
Any hints on how can I troubleshoot this?

Code: [Select]

AGI Tx >> 200 result=1 (4)
AGI Rx << GET VARIABLE MOH
AGI Tx >> 200 result=1 (NO)
AGI Rx << GET VARIABLE CALLRECORD1
AGI Tx >> 200 result=1 (Both)
AGI Rx << EXEC Set __filename=1268013159-7200-0519767XXXX.wav
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE CHANNEL
AGI Tx >> 200 result=1 (DAHDI/1-1)
AGI Rx << EXEC Set __channame=DAHDI/1-1
AGI Tx >> 200 result=0
AGI Rx << EXEC Monitor wav|1268013159-7200-0519767XXXX|mb
AGI Tx >> 200 result=0

Asterisk 1.4.28
Recording settings set to Both in Globals and on the Extension that receives the calls
I created an ibay and chmod the directory set on Globals (/home/e-smith/files/ibays/voipmon/files/monitor) to 777
I have the updated Sox as per the wiki.

Thanks,

[SARK devs]

What do you find in /var/spool/asterisk/monitor?

KInd REgards

S

[brick]

It exists, but it's empty 

[Franco]

Code: [Select]

[root@brio ~]# ls -la /var/spool/asterisk/monitor/
total 8
drwxr-xr-x  2 root root 4096 Mar  7 23:31 .
drwxr-xr-x  9 root root 4096 Mar  6 20:11 ..
[root@brio ~]#

nothing!

[SARK devs]

That is odd becasue the asterisk monitor command has been issued to start the recordiing

EXEC Monitor wav|1268013159-7200-0519767XXXX|mb

..and Asterisk stores its recordings in /var/spool/asterisk/monitor by default.

Try doing a search on your machine for the file it recorded

1268013159-7200-0519767XXXX.wav

See if you can find it.

Kind REgards

S

[Franco]

Hi S,
I can see what's happening, but can't figure it out.
I'm testing right now and while the conversation is happening this folder /var/spool/asterisk/monitor has two files, one in and one out.
Then the minute I hang up it becomes one file and then it disappears right after.
I'm assuming the file disappears when it moves from this folder to the one I assigned in Globals(?).
I have created an ibay voipmon and inside of it, a folder named monitor. This is where I pointed to save in the Globals.
Maybe I can't do that? If not, where should I point it to (I forget what the default value was).

Thanks,

[Franco]

Another install, same problem
The two files are created when the conversation is happening, then a single file, then it gets removed.
I checked voip-info.org and compared the configuration files, all good.

Code: [Select]

Connected to Asterisk 1.4.28 currently running on serv3 (pid = 20050)
srv3*CLI> agi debug
AGI Debugging Enabled
AGI Tx >> agi_request: selintra
AGI Tx >> agi_channel: SIP/2002-0000003d
AGI Tx >> agi_language: en
AGI Tx >> agi_type: SIP
AGI Tx >> agi_uniqueid: 1270495519.195
AGI Tx >> agi_callerid: 2002
AGI Tx >> agi_calleridname: 2002
AGI Tx >> agi_callingpres: 0
AGI Tx >> agi_callingani2: 0
AGI Tx >> agi_callington: 0
AGI Tx >> agi_callingtns: 0
AGI Tx >> agi_dnid: 2505130624750
AGI Tx >> agi_rdnis: unknown
AGI Tx >> agi_context: internal
AGI Tx >> agi_extension: 2505130624750
AGI Tx >> agi_priority: 1
AGI Tx >> agi_enhanced: 0.0
AGI Tx >> agi_accountcode:
AGI Tx >>
AGI Rx << GET VARIABLE EXTLEN
AGI Tx >> 200 result=1 (4)
AGI Rx << SET PRIORITY 1
AGI Tx >> 200 result=0
AGI Rx << SET EXTENSION 2505130624750
AGI Tx >> 200 result=0
AGI Rx << SET CONTEXT qrxvtmny
AGI Tx >> 200 result=0
AGI Tx >> agi_request: selintra
AGI Tx >> agi_channel: SIP/2002-0000003d
AGI Tx >> agi_language: en
AGI Tx >> agi_type: SIP
AGI Tx >> agi_uniqueid: 1270495519.195
AGI Tx >> agi_callerid: 2002
AGI Tx >> agi_calleridname: 2002
AGI Tx >> agi_callingpres: 0
AGI Tx >> agi_callingani2: 0
AGI Tx >> agi_callington: 0
AGI Tx >> agi_callingtns: 0
AGI Tx >> agi_dnid: 2505130624750
AGI Tx >> agi_rdnis: unknown
AGI Tx >> agi_context: qrxvtmny
AGI Tx >> agi_extension: 2505130624750
AGI Tx >> agi_priority: 1
AGI Tx >> agi_enhanced: 0.0
AGI Tx >> agi_accountcode:
AGI Tx >>
AGI Rx << GET VARIABLE EXTLEN
AGI Tx >> 200 result=1 (4)
AGI Rx << GET VARIABLE PLAYBUSY
AGI Tx >> 200 result=1 (NO)
AGI Rx << GET VARIABLE PLAYCONGESTED
AGI Tx >> 200 result=1 (NO)
AGI Rx << GET VARIABLE EXTLEN
AGI Tx >> 200 result=1 (4)
AGI Rx << GET VARIABLE VOIPMAX
AGI Tx >> 200 result=1 (3)
AGI Rx << GET VARIABLE ALLOWHASHXFER
AGI Tx >> 200 result=1 (disabled)
AGI Rx << SET VARIABLE GROUP() "OUTBOUND_GROUP"
AGI Tx >> 200 result=1
AGI Rx << GET VARIABLE GROUP_COUNT()
AGI Tx >> 200 result=1 (1)
AGI Rx << GET VARIABLE CALLRECORD1
AGI Tx >> 200 result=1 (Both)
AGI Rx << EXEC Set __filename=1270495519-2505130624750-2002.wav
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE CHANNEL
AGI Tx >> 200 result=1 (SIP/2002-0000003d)
AGI Rx << EXEC Set __channame=SIP/2002-0000003d
AGI Tx >> 200 result=0
AGI Rx << EXEC Monitor wav|1270495519-2505130624750-2002|mb


[SARK devs]

HI Franco

Sorry for the delay - we've been a bit busy with V3.0 and CentOS5/SME 8. 

The recording post-process is controlled by a script called selmix (its in /etc/selintra).   Its just a simple bash script that moves the recordings around.  It's trying to move your recodings to the stage directory.  This is specified in globals in MONITORSTAGE...

Code: [Select]

[root@switch html]# db selintra show global | grep MONITOR
    MONITOROUT=/home/e-smith/files/primary/files/monitorout
    MONITORSTAGE=/home/e-smith/files/primary/files/stage
You'll need to ensure that you have a directory by that name.  As long as you have then your sound files should appear there.

Code: [Select]

[root@switch html]# ls -l /home/e-smith/files/primary/files/stage

-rw-r--r-- 1 root admin 364 Apr  5 22:54 1270508042-7000-001924918076.wav
Hope this helps

Kind Regards

S

[Teviot]

SARK devs

I am having the same trouble. Have included the output from the console and agi debug, plus some other infomation I thought might help from reading this post below

Code: [Select]

sail*CLI>
    -- Executing [500@internal:1] AGI("SIP/401-09b31698", "selintra|OutCluster|500") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
    -- AGI Script selintra completed, returning 0
    -- Executing [500@qrxvtmny:1] AGI("SIP/401-09b31698", "selintra|Alias|Local/44166@internal|500") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
    -- AGI Script Executing Application: (Set) Options: (__filename=1270533164-500-401.wav)
    -- AGI Script Executing Application: (Set) Options: (__channame=SIP/401-09b31698)
    -- AGI Script Executing Application: (Monitor) Options: (wav|1270533164-500-401|mb)
    -- AGI Script Executing Application: (Dial) Options: (Local/44166@internal||)
    -- Called 44166@internal
    -- Executing [44166@internal:1] AGI("Local/44166@internal-1fc7,2", "selintra|OutCluster|44166") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
    -- AGI Script selintra completed, returning 0
    -- Executing [44166@qrxvtmny:1] AGI("Local/44166@internal-1fc7,2", "selintra|OutTrunk|3xxxxxx1") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
    -- AGI Script Executing Application: (Set) Options: (__filename=1270533164-44166-401.wav)
    -- AGI Script Executing Application: (Set) Options: (__channame=Local/44166@internal-1fc7,2)
    -- AGI Script Executing Application: (Monitor) Options: (wav|1270533164-44166-401|mb)
    -- AGI Script Executing Application: (Dial) Options: (SIP/166@Voipfone||T)
    -- Called 166@Voipfone
    -- SIP/Voipfone-09b36800 answered Local/44166@internal-1fc7,2
    -- Local/44166@internal-1fc7,1 answered SIP/401-09b31698
    -- AGI Script selintra completed, returning 0
    -- Executing [h@qrxvtmny:1] Hangup("Local/44166@internal-1fc7,2", "") in new stack
  == Spawn extension (qrxvtmny, h, 1) exited non-zero on 'Local/44166@internal-1fc7,2'
  == Spawn extension (qrxvtmny, 500, 1) exited non-zero on 'SIP/401-09b31698'
    -- Executing [h@qrxvtmny:1] Hangup("SIP/401-09b31698", "") in new stack
  == Spawn extension (qrxvtmny, h, 1) exited non-zero on 'SIP/401-09b31698'


Code: [Select]

sail*CLI> agi debug
AGI Debugging Enabled
    -- Remote UNIX connection
    -- Remote UNIX connection disconnected
    -- Remote UNIX connection
    -- Remote UNIX connection disconnected
    -- Executing [44155@internal:1] AGI("SIP/401-09a41108", "selintra|OutCluster|44155") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
AGI Tx >> agi_request: selintra
AGI Tx >> agi_channel: SIP/401-09a41108
AGI Tx >> agi_language: en
AGI Tx >> agi_type: SIP
AGI Tx >> agi_uniqueid: 1270516328.81
AGI Tx >> agi_callerid: 401
AGI Tx >> agi_calleridname: ext401
AGI Tx >> agi_callingpres: 0
AGI Tx >> agi_callingani2: 0
AGI Tx >> agi_callington: 0
AGI Tx >> agi_callingtns: 0
AGI Tx >> agi_dnid: 44155
AGI Tx >> agi_rdnis: unknown
AGI Tx >> agi_context: internal
AGI Tx >> agi_extension: 44155
AGI Tx >> agi_priority: 1
AGI Tx >> agi_enhanced: 0.0
AGI Tx >> agi_accountcode:
AGI Tx >>
AGI Rx << GET VARIABLE EXTLEN
AGI Tx >> 200 result=1 (3)
AGI Rx << SET PRIORITY 1
AGI Tx >> 200 result=0
AGI Rx << SET EXTENSION 44155
AGI Tx >> 200 result=0
AGI Rx << SET CONTEXT qrxvtmny
AGI Tx >> 200 result=0
    -- AGI Script selintra completed, returning 0
    -- Executing [44155@qrxvtmny:1] AGI("SIP/401-09a41108", "selintra|OutTrunk|3xxxxxx1") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
AGI Tx >> agi_request: selintra
AGI Tx >> agi_channel: SIP/401-09a41108
AGI Tx >> agi_language: en
AGI Tx >> agi_type: SIP
AGI Tx >> agi_uniqueid: 1270516328.81
AGI Tx >> agi_callerid: 401
AGI Tx >> agi_calleridname: ext401
AGI Tx >> agi_callingpres: 0
AGI Tx >> agi_callingani2: 0
AGI Tx >> agi_callington: 0
AGI Tx >> agi_callingtns: 0
AGI Tx >> agi_dnid: 44155
AGI Tx >> agi_rdnis: unknown
AGI Tx >> agi_context: qrxvtmny
AGI Tx >> agi_extension: 44155
AGI Tx >> agi_priority: 1
AGI Tx >> agi_enhanced: 0.0
AGI Tx >> agi_accountcode:
AGI Tx >>
AGI Rx << GET VARIABLE EXTLEN
AGI Tx >> 200 result=1 (3)
AGI Rx << GET VARIABLE PLAYBUSY
AGI Tx >> 200 result=1 (NO)
AGI Rx << GET VARIABLE PLAYCONGESTED
AGI Tx >> 200 result=1 (NO)
AGI Rx << GET VARIABLE EXTLEN
AGI Tx >> 200 result=1 (3)
AGI Rx << GET VARIABLE VOIPMAX
AGI Tx >> 200 result=1 (3)
AGI Rx << GET VARIABLE ALLOWHASHXFER
AGI Tx >> 200 result=1 (enabled)
AGI Rx << SET CALLERID 3xxxxxx1
AGI Tx >> 200 result=1
AGI Rx << SET VARIABLE GROUP() "OUTBOUND_GROUP"
AGI Tx >> 200 result=1
AGI Rx << GET VARIABLE GROUP_COUNT()
AGI Tx >> 200 result=1 (2)
AGI Rx << GET VARIABLE CALLRECORD1
AGI Tx >> 200 result=1 (Both)
AGI Rx << EXEC Set __filename=1270516328-44155-401.wav
    -- AGI Script Executing Application: (Set) Options: (__filename=1270516328-44155-401.wav)
AGI Tx >> 200 result=0
AGI Rx << GET VARIABLE CHANNEL
AGI Tx >> 200 result=1 (SIP/401-09a41108)
AGI Rx << EXEC Set __channame=SIP/401-09a41108
    -- AGI Script Executing Application: (Set) Options: (__channame=SIP/401-09a41108)
AGI Tx >> 200 result=0
AGI Rx << EXEC Monitor wav|1270516328-44155-401|mb
    -- AGI Script Executing Application: (Monitor) Options: (wav|1270516328-44155-401|mb)
AGI Tx >> 200 result=0
AGI Rx << EXEC Dial SIP/155@Voipfone||T
    -- AGI Script Executing Application: (Dial) Options: (SIP/155@Voipfone||T)
    -- Called 155@Voipfone
    -- SIP/Voipfone-09aa6f10 answered SIP/401-09a41108
AGI Tx >> 200 result=-1
AGI Rx << GET VARIABLE DIALSTATUS
AGI Tx >> 200 result=1 (ANSWER)
    -- AGI Script selintra completed, returning 0
  == Auto fallthrough, channel 'SIP/401-09a41108' status is 'ANSWER'
    -- Executing [h@qrxvtmny:1] Hangup("SIP/401-09a41108", "") in new stack
  == Spawn extension (qrxvtmny, h, 1) exited non-zero on 'SIP/401-09a41108'
    -- Got SIP response 400 "Bad Request" back from 192.168.76.1
sail*CLI>

Code: [Select]

[root@sail ~]# db selintra show global | grep MONITOR
    MONITOROUT=/home/e-smith/files/ibays/voipmon/files
[root@sail ~]#
If i'm reading correctly the MONITORSTAGE is not working or doesn't exsist. I'm not sure where to go from here

Something else you might need to help me diagnose the problem is below

Code: [Select]

SarkGlobals

Version: sail-2.2.4-35
 Local IP: 192.xxx.xxx.xxx
 System Name: sail
 media type: disk
 DiskUsage: 48%
 
System Mode: servergateway
 Total Memory: 1002852
 Used Memory: 957224
 Free Memory: 45628
 USB DiskUsage: Not Found
 
Serial #: 721630
 Shared Memory: 0
 Buffers: 70296
 cached: 615708
 Logging to: Disk
 
Swap Memory: 2031608
 Swap Used: 208
 Swap Free: 2031400
 Ext Length: 3
 System Type: FULL
 
Asterisk State: RUNNING
 HAE State: Not Installed
 Nodetype: PRIMARY
 Virtual IP: 192.xxx.xxx.xxx
 


[SARK devs]

create it with

Code: [Select]

db selintra-work setprop global MONITORSTAGE /my/stage/directory
db selintra setprop global MONITORSTAGE /my/stage/directory

mkdir /my/stage/directory
Best

S

[Teviot]

Thanks SARK devs

done what you suggested and still no file appears

Code: [Select]

sail*CLI>
    -- Executing [500@internal:1] AGI("SIP/401-09b33248", "selintra|OutCluster|500") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
    -- AGI Script selintra completed, returning 0
    -- Executing [500@qrxvtmny:1] AGI("SIP/401-09b33248", "selintra|Alias|Local/44166@internal|500") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
    -- AGI Script Executing Application: (Set) Options: (__filename=1270542079-500-401.wav)
    -- AGI Script Executing Application: (Set) Options: (__channame=SIP/401-09b33248)
    -- AGI Script Executing Application: (Monitor) Options: (wav|1270542079-500-401|mb)
    -- AGI Script Executing Application: (Dial) Options: (Local/44166@internal||)
    -- Called 44166@internal
    -- Executing [44166@internal:1] AGI("Local/44166@internal-cc14,2", "selintra|OutCluster|44166") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
    -- AGI Script selintra completed, returning 0
    -- Executing [44166@qrxvtmny:1] AGI("Local/44166@internal-cc14,2", "selintra|OutTrunk|3xxxxxx1") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
    -- AGI Script Executing Application: (Set) Options: (__filename=1270542079-44166-401.wav)
    -- AGI Script Executing Application: (Set) Options: (__channame=Local/44166@internal-cc14,2)
    -- AGI Script Executing Application: (Monitor) Options: (wav|1270542079-44166-401|mb)
    -- AGI Script Executing Application: (Dial) Options: (SIP/166@Voipfone||T)
    -- Called 166@Voipfone
    -- SIP/Voipfone-09b65be0 answered Local/44166@internal-cc14,2
    -- Local/44166@internal-cc14,1 answered SIP/401-09b33248
    -- AGI Script selintra completed, returning 0
    -- Executing [h@qrxvtmny:1] Hangup("Local/44166@internal-cc14,2", "") in new stack
  == Spawn extension (qrxvtmny, h, 1) exited non-zero on 'Local/44166@internal-cc14,2'
    -- Got SIP response 400 "Bad Request" back from 192.168.76.1
  == Spawn extension (qrxvtmny, 500, 1) exited non-zero on 'SIP/401-09b33248'
    -- Executing [h@qrxvtmny:1] Hangup("SIP/401-09b33248", "") in new stack
  == Spawn extension (qrxvtmny, h, 1) exited non-zero on 'SIP/401-09b33248'
sail*CLI>

Code: [Select]

[root@sail ~]# db selintra show global | grep MONITOR
    MONITOROUT=/home/e-smith/files/ibays/voipmon/files
    MONITORSTAGE=/home/e-smith/files/ibays/voipmon/files
[root@sail ~]#
In the CDR Database if have the following

Code: [Select]

1.  2010-04-06 18:28:58 SIP/tel... telstra "telstra"  Monitor wav|1270542538-600-unknown|mX 600  ANSWERED 06:27

[SARK devs]

I've tested this again here on our reference server and it works just fine.  As you can appreciate it is very difficult for us to help if we can't recreate the problem.
Our test rig is a little ahead of yours from a release point of view but nothing much has changed in the recording functionality for quite some time.

Kind Regards

S

 

[Franco]

Code: [Select]

[root@switch html]# ls -l /home/e-smith/files/primary/files/stage

Hi S,
This was my problem!
Stage was a file and not a directory, this happened in two different installs, so I deleted the file and created the directory.

Thanks,

[Teviot]

Franco

Is your PBX now recording calls?

[Franco]

Hi Teviot,
It's recording, but I really don't think the changes I made is what fixed.
After a signal-event post-upgrade all went back to normal, and my recordings are still happening.

Thanks,