[asterisk-bugs] [JIRA] (ASTERISK-22056) Asterisk 11.4.0 : Queue RINGNOANSWER wrong ring time when one of the peer becomes unresponsive

[Nikita Zogas (JIRA)]

Nikita Zogas created ASTERISK-22056:
---------------------------------------

             Summary: Asterisk 11.4.0 : Queue RINGNOANSWER wrong ring time when one of the peer becomes unresponsive
                 Key: ASTERISK-22056
                 URL: https://issues.asterisk.org/jira/browse/ASTERISK-22056
             Project: Asterisk
          Issue Type: Bug
      Security Level: None
          Components: Applications/app_queue
    Affects Versions: 11.4.0
         Environment: CentOS release 6.4 (Final), CPU info: Intel(R) Xeon(R) CPU E31220 @ 3.10GHz
            Reporter: Nikita Zogas
            Severity: Critical


When Queue application dials to one agent (peer) which becomes unresponsive during call, another agent's phone rings for remaining time of queue_timeout but still logs full timeout to second agent. 

To illustrate, here is what is seen in the log:

[Jun 21 09:53:09] VERBOSE[14467][C-00004b41] pbx.c:     -- Executing [2 at sodra-ivr-work:2] Queue("SIP/testlink-00005981", "pasalpos") in new stack
[Jun 21 09:53:09] VERBOSE[14467][C-00004b41] res_musiconhold.c:     -- Started music on hold, class 'default', on SIP/testlink-00005981
[Jun 21 09:53:09] WARNING[14467][C-00004b41] translate.c: no samples for alawtolin
[Jun 21 09:53:09] VERBOSE[14469][C-00004b41] pbx.c:     -- Executing [316 at agents:1] NoOp("Local/316 at agents-00003418;2", "Dial to agent 316") in new stack
[Jun 21 09:53:09] VERBOSE[14469][C-00004b41] pbx.c:     -- Executing [316 at agents:2] Dial("Local/316 at agents-00003418;2", "SIP/316") in new stack
[Jun 21 09:53:09] VERBOSE[14469][C-00004b41] netsock2.c:   == Using SIP RTP CoS mark 5
[Jun 21 09:53:09] VERBOSE[14469][C-00004b41] app_dial.c:     -- Called SIP/316

SIP/316 is called and then got message in the log:

[Jun 21 09:53:15] WARNING[5650] chan_sip.c: Retransmission timeout reached on transmission 1e3ed80f5a8fd5976b56602868f6501a at 192.168.88.2:5060 for seqno 102 (Critical Request) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
Packet timed out after 6399ms with no response
[Jun 21 09:53:15] WARNING[5650] chan_sip.c: Hanging up call 1e3ed80f5a8fd5976b56602868f6501a at 192.168.88.2:5060 - no reply to our critical packet (see https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions).
[Jun 21 09:53:15] VERBOSE[14469][C-00004b41] app_dial.c:   == Everyone is busy/congested at this time (1:0/0/1)
[Jun 21 09:53:15] VERBOSE[14469][C-00004b41] pbx.c:     -- Executing [316 at agents:3] Hangup("Local/316 at agents-00003418;2", "") in new stack
[Jun 21 09:53:15] VERBOSE[14469][C-00004b41] pbx.c:   == Spawn extension (agents, 316, 3) exited non-zero on 'Local/316 at agents-00003418;2'
[Jun 21 09:53:15] VERBOSE[14467][C-00004b41] app_queue.c:     -- Nobody picked up in 6000 ms

then starts new call, as you see, call start and end difference is 2 seconds whereas Asterisk states "Nobody picked up in 8000 ms"

[Jun 21 09:53:15] VERBOSE[14475][C-00004b41] pbx.c:     -- Executing [330 at agents:1] NoOp("Local/330 at agents-00003419;2", "Dial to agent 330") in new stack
[Jun 21 09:53:15] VERBOSE[14475][C-00004b41] pbx.c:     -- Executing [330 at agents:2] Dial("Local/330 at agents-00003419;2", "SIP/330") in new stack
[Jun 21 09:53:15] VERBOSE[14475][C-00004b41] netsock2.c:   == Using SIP RTP CoS mark 5
[Jun 21 09:53:15] VERBOSE[14475][C-00004b41] app_dial.c:     -- Called SIP/330
[Jun 21 09:53:15] VERBOSE[14475][C-00004b41] app_dial.c:     -- SIP/330-00005983 is ringing
[Jun 21 09:53:15] VERBOSE[14467][C-00004b41] app_queue.c:     -- Local/330 at agents-00003419;1 is ringing
[Jun 21 09:53:16] VERBOSE[14449][C-00004b40] pbx.c:     -- Executing [s at sodra-ivr-work:10] BackGround("OOH323/avaya1-10151", "sodra4") in new stack
[Jun 21 09:53:16] VERBOSE[14449][C-00004b40] file.c:     -- <OOH323/avaya1-10151> Playing 'sodra4.slin' (language 'en')
[Jun 21 09:53:17] VERBOSE[14467][C-00004b41] app_queue.c:     -- Nobody picked up in 8000 ms
[Jun 21 09:53:17] VERBOSE[14475][C-00004b41] pbx.c:   == Spawn extension (agents, 330, 2) exited non-zero on 'Local/330 at agents-00003419;2'
[Jun 21 09:53:20] VERBOSE[14437][C-00004b39] res_musiconhold.c:     -- Started music on hold, class 'default', on Local/320 at agents-00003414;2


Steps to reproduce (likely):

1. Use Queue() application and 2 logged agents
2. Force one agent to become unresponsive (e.g. unplug Ethernet cable of VoIP phone if HW phone is used)


--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators: https://issues.asterisk.org/jira/secure/ContactAdministrators!default.jspa
For more information on JIRA, see: http://www.atlassian.com/software/jira