[HELP] parked calls being dropped by *


#1

Hi Forum

We have been using asterisk successfully for over 18 months now with few problems. Recently, though, I have been getting odd problems with parked calls.

Scenario: call received by receptionist, placed in parking, receptionist rings another extension (and tells them that someone is on the phone for them), when the other person attempts to pick up the parked call there is nothing there.

I switched on verbose logging and below is a transcript of a dropped parked call:-

Call being parked:-

Oct 6 17:18:22 VERBOSE[27996]: – Executing ParkedCall(“SIP/20-7fd5”, “702”) in new stack
Oct 6 17:18:22 VERBOSE[27996]: – Stopped music on hold on Zap/2-1
Oct 6 17:18:22 DEBUG[27996]: Scheduling timer at 0 sample intervals
Oct 6 17:18:22 VERBOSE[27996]: – Channel SIP/20-7fd5 connected to parked call 702
Oct 6 17:18:22 DEBUG[27996]: Ooh, format changed from unknown to ulaw
Oct 6 17:18:47 DEBUG[27996]: Sending dtmf: 35 (#), at 192.168.0.163
Oct 6 17:18:47 DEBUG[27996]: Got AST_BRIDGE_DTMF_CHANNEL_0 on c0 (SIP/20-7fd5)
Oct 6 17:18:47 DEBUG[27996]: Bridge stops bridging channels SIP/20-7fd5 and Zap/2-1
Oct 6 17:18:47 VERBOSE[27996]: – Started music on hold, class ‘default’, on Zap/2-1
Oct 6 17:18:47 DEBUG[27996]: Scheduling timer at 160 sample intervals
Oct 6 17:18:47 DEBUG[27996]: Scheduling timer at 160 sample intervals
Oct 6 17:18:47 VERBOSE[27996]: – Playing ‘pbx-transfer’ (language ‘en’)
Oct 6 17:18:47 DEBUG[27996]: Sending dtmf: 55 (7), at 192.168.0.163
Oct 6 17:18:47 DEBUG[27996]: Scheduling timer at 0 sample intervals
Oct 6 17:18:48 DEBUG[27996]: Sending dtmf: 48 (0), at 192.168.0.163
Oct 6 17:18:48 DEBUG[27996]: Sending dtmf: 48 (0), at 192.168.0.163
Oct 6 17:18:48 VERBOSE[27996]: – Stopped music on hold on Zap/2-1
Oct 6 17:18:48 DEBUG[27996]: Scheduling timer at 0 sample intervals
Oct 6 17:18:48 VERBOSE[27996]: – Started music on hold, class ‘default’, on Zap/2-1
Oct 6 17:18:48 DEBUG[27996]: Scheduling timer at 160 sample intervals
Oct 6 17:18:48 VERBOSE[27996]: == Parked Zap/2-1 on 701. Will timeout back to gmappsmain,s,4 in 180 seconds
Oct 6 17:18:48 DEBUG[27996]: Difference is 4752, ms is 614
Oct 6 17:18:48 DEBUG[27996]: Scheduling timer at 160 sample intervals
Oct 6 17:18:48 VERBOSE[27996]: – Playing ‘digits/7’ (language ‘en’)
Oct 6 17:18:49 DEBUG[27996]: Scheduling timer at 0 sample intervals
Oct 6 17:18:49 DEBUG[27996]: Scheduling timer at 0 sample intervals
Oct 6 17:18:49 DEBUG[27996]: Scheduling timer at 160 sample intervals
Oct 6 17:18:49 VERBOSE[27996]: – Playing ‘digits/0’ (language ‘en’)
Oct 6 17:18:49 DEBUG[27996]: Scheduling timer at 0 sample intervals
Oct 6 17:18:49 DEBUG[27996]: Scheduling timer at 0 sample intervals
Oct 6 17:18:49 DEBUG[27996]: Scheduling timer at 160 sample intervals
Oct 6 17:18:49 VERBOSE[27996]: – Playing ‘digits/1’ (language ‘en’)
Oct 6 17:18:50 DEBUG[27996]: Scheduling timer at 0 sample intervals
Oct 6 17:18:50 DEBUG[27996]: Scheduling timer at 0 sample intervals
Oct 6 17:18:50 VERBOSE[27996]: – Added extension ‘701’ priority 1 to parkedcalls
Oct 6 17:18:50 VERBOSE[27996]: == Spawn extension (default, 702, 1) exited non-zero on 'SIP/20-7fd5’
Oct 6 17:18:50 DEBUG[27996]: update_user_counter(20) - decrement inUse counter

Reception ringing someone else:-

Oct 6 17:18:56 VERBOSE[27999]: – Executing Dial(“SIP/20-2cb4”, “SIP/39|30|rt”) in new stack
Oct 6 17:18:56 DEBUG[27999]: SIMPLE DIAL (NO URL)
Oct 6 17:18:56 DEBUG[27999]: Setting NAT on RTP to 0
Oct 6 17:18:56 DEBUG[27999]: Outgoing Call for 39
Oct 6 17:18:56 DEBUG[27999]: Call from user ‘39’ is 1 out of 1
Oct 6 17:18:56 VERBOSE[27999]: – Called 39
Oct 6 17:18:56 VERBOSE[27999]: – SIP/39-c171 is ringing
Oct 6 17:18:58 VERBOSE[27999]: – SIP/39-c171 answered SIP/20-2cb4
Oct 6 17:18:58 VERBOSE[27999]: – Attempting native bridge of SIP/20-2cb4 and SIP/39-c171
Oct 6 17:18:58 DEBUG[27999]: Ooh, format changed from unknown to ulaw
Oct 6 17:18:58 DEBUG[27999]: Ooh, format changed from unknown to ulaw
Oct 6 17:19:04 DEBUG[27999]: Didn’t get a frame from channel: SIP/20-2cb4
Oct 6 17:19:04 DEBUG[27999]: Bridge stops bridging channels SIP/20-2cb4 and SIP/39-c171
Oct 6 17:19:04 DEBUG[27999]: update_user_counter(39) - decrement outUse counter
Oct 6 17:19:04 DEBUG[27999]: Exiting with DIALSTATUS=ANSWER.
Oct 6 17:19:04 VERBOSE[27999]: == Spawn extension (default, 39, 1) exited non-zero on 'SIP/20-2cb4’
Oct 6 17:19:04 DEBUG[27999]: update_user_counter(20) - decrement inUse counter

Call being dropped:-

Oct 6 17:19:07 VERBOSE[28004]: – Executing ParkedCall(“SIP/20-bd8e”, “701”) in new stack
Oct 6 17:19:07 VERBOSE[28004]: – Stopped music on hold on Zap/2-1
Oct 6 17:19:07 DEBUG[28004]: Scheduling timer at 0 sample intervals
Oct 6 17:19:07 VERBOSE[28004]: – Channel SIP/20-bd8e connected to parked call 701
Oct 6 17:19:07 DEBUG[28004]: Ooh, format changed from unknown to ulaw
Oct 6 17:19:12 DEBUG[28004]: Didn’t get a frame from channel: SIP/20-bd8e
Oct 6 17:19:12 DEBUG[28004]: Bridge stops bridging channels SIP/20-bd8e and Zap/2-1
Oct 6 17:19:12 DEBUG[28004]: Set option AUDIO MODE, value: ON(1) on Zap/2-1
Oct 6 17:19:12 DEBUG[28004]: Hangup: channel: 2 index = 0, normal = 20, callwait = -1, thirdcall = -1
Oct 6 17:19:12 DEBUG[28004]: Not yet hungup… Calling hangup once with icause, and clearing call
Oct 6 17:19:12 DEBUG[28004]: disabled echo cancellation on channel 2
Oct 6 17:19:12 DEBUG[28004]: Set option TDD MODE, value: OFF(0) on Zap/2-1
Oct 6 17:19:12 DEBUG[28004]: Updated conferencing on 2, with 0 conference users
Oct 6 17:19:12 DEBUG[28004]: Set option AUDIO MODE, value: OFF(0) on Zap/2-1
Oct 6 17:19:12 DEBUG[28004]: disabled echo cancellation on channel 2
Oct 6 17:19:12 VERBOSE[28004]: – Hungup 'Zap/2-1’
Oct 6 17:19:12 VERBOSE[28004]: == Spawn extension (default, 701, 1) exited non-zero on 'SIP/20-bd8e’
Oct 6 17:19:12 DEBUG[28004]: update_user_counter(20) - decrement inUse counter

It looks as though the original call receiver somehow picks up the parked call. Has anyone seen this before or have any ideas?

Cheers
Frustrated SysAdmin :frowning:


#2

It looks like there’s some sort of 45 second timeout that’s happening in the system.

Do you have anything like that?

Can we see your parkandannounce instruction?


#3

Hi dufus

I assume you mean the section from parking.conf (I am using version 1.0.5 of *):-

-----snip-----
[general]
parkext => 700
parkpos => 701-720
context => parkedcalls
parkingtime => 180
-----snip-----

Which suggests that the timeout is 180 secs. I have timed the timeout of a parked call and it is taking 180 secs to bounce back.