This is what i have in my logs:
[Sep 25 15:11:25] VERBOSE[9105] logger.c: [Sep 25 15:11:25] == Manager 'sendcron' logged on from 192.168.1.4
[Sep 25 15:11:25] VERBOSE[9106] logger.c: [Sep 25 15:11:25] -- Executing [8600062@default:1] MeetMe("Local/8600062@default-ae15,2", "8600062|F") in new stack
[Sep 25 15:11:25] VERBOSE[9105] logger.c: [Sep 25 15:11:25] > Channel Local/8600062@default-ae15,1 was answered.
[Sep 25 15:11:25] VERBOSE[9107] logger.c: [Sep 25 15:11:25] -- Executing [17138077282@default:1] Dial("Local/8600062@default-ae15,1", "SIP/17138077282@AccelaSansay2") in new stack
[Sep 25 15:11:25] VERBOSE[9107] logger.c: [Sep 25 15:11:25] -- Called 17138077282@AccelaSansay2
[Sep 25 15:11:25] VERBOSE[9110] logger.c: [Sep 25 15:11:25] == Parsing '/etc/asterisk/manager.conf': [Sep 25 15:11:25] VERBOSE[9110] logger.c: [Sep 25 15:11:25] Found
[Sep 25 15:11:25] VERBOSE[9110] logger.c: [Sep 25 15:11:25] == Manager 'sendcron' logged on from 192.168.1.4
[Sep 25 15:11:25] VERBOSE[9111] logger.c: [Sep 25 15:11:25] -- Executing [58600062@default:1] MeetMe("Local/58600062@default-5bad,2", "8600062|Fmq") in new stack
[Sep 25 15:11:25] VERBOSE[9110] logger.c: [Sep 25 15:11:25] > Channel Local/58600062@default-5bad,1 was answered.
[Sep 25 15:11:25] VERBOSE[9112] logger.c: [Sep 25 15:11:25] -- Executing [8309@default:1] Answer("Local/58600062@default-5bad,1", "") in new stack
[Sep 25 15:11:25] VERBOSE[9112] logger.c: [Sep 25 15:11:25] -- Executing [8309@default:2] Monitor("Local/58600062@default-5bad,1", "wav|20120925-151125_FFG_7138077282_6015") in new stack
[Sep 25 15:11:25] VERBOSE[9112] logger.c: [Sep 25 15:11:25] -- Executing [8309@default:3] Wait("Local/58600062@default-5bad,1", "360000") in new stack
[Sep 25 15:11:25] VERBOSE[9044] logger.c: [Sep 25 15:11:25] -- SIP/AccelaSansay2-0000a3f2 is making progress passing it to Local/13103471460@default-24c9,2
[Sep 25 15:11:25] VERBOSE[9115] logger.c: [Sep 25 15:11:25] == Parsing '/etc/asterisk/manager.conf': [Sep 25 15:11:25] VERBOSE[9115] logger.c: [Sep 25 15:11:25] Found
[Sep 25 15:11:25] VERBOSE[9115] logger.c: [Sep 25 15:11:25] == Manager 'sendcron' logged on from 192.168.1.4
.
.
.
.
[Sep 25 15:17:18] WARNING[29851] format_wav.c: Unable to find our position
[Sep 25 15:17:18] WARNING[20399] format_wav.c: Unable to find our position
[Sep 25 15:17:18] WARNING[27492] format_wav.c: Unable to find our position
[Sep 25 15:17:18] VERBOSE[9107] logger.c: [Sep 25 15:17:18] -- AGI Script
agi://127.0.0.1:4577/call_log--HVcauses ... 53-----348 completed, returning 0
[Sep 25 15:17:18] VERBOSE[9107] logger.c: [Sep 25 15:17:18] == Spawn extension (default, 17138077282, 1) exited non-zero on 'Local/8600062@default-ae15,1'
[Sep 25 15:17:18] WARNING[19897] format_wav.c: Unable to find our position
[Sep 25 15:17:18] WARNING[2257] format_wav.c: Unable to find our position
[Sep 25 15:17:18] VERBOSE[9106] logger.c: [Sep 25 15:17:18] == Spawn extension (default, 8600062, 1) exited non-zero on 'Local/8600062@default-ae15,2'
[Sep 25 15:17:18] VERBOSE[9106] logger.c: [Sep 25 15:17:18] -- Executing [h@default:1] DeadAGI("Local/8600062@default-ae15,2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0---------------") in new stack
[Sep 25 15:17:18] WARNING[9554] format_wav.c: Unable to find our position
[Sep 25 15:17:18] WARNING[18734] format_wav.c: Unable to find our position
[Sep 25 15:17:18] WARNING[12004] format_wav.c: Unable to find our position
.
.
.