Pickup Indications bleiben "hängen"

doxon

Mitglied
Mitglied seit
11 Jun 2006
Beiträge
781
Punkte für Reaktionen
0
Punkte
0
Hallo zusammen,
ich habe das Problem das Pickup-Indications von Anrufen im Snom hängen blieben obwohl der Anrufer schon längst wieder aufgelegt hat.

Das ganze passiert genau in einer Konstellation die mehr oder weniger reproduzierbar ist.

Wenn der Anrufer [Tln. A] sofort (Anrufzeit < 1sec.) nach dem Wählen der Nebenstelle [Tln. B] wieder auflegt (z.b. verwählt) erscheint die Pickup-Indication im Display der anderen Nebenstellen und der Pickup-Aufmerksamkeitston wird gespielt.

Im Asterisk Verbose Log sehe ich das der "Extension State" jeweils an die entsprechenden überwachenden snom-Telefone geschickt wird.

Code:
Extension Changed 233 new state Ringing for Notify User xxxxx
(...)

Extension Changed 233 new state Idle for Notify User xxxxx
(...)

Die Pickup-Indication Meldungen (Anzeige und Aufmerksamkeitston) gehen allerdings erst wieder weg wenn Tln. B noch einmal angerufen wird, es mindestens 1-2 Sekunden klingelt und dann wieder aufgelegt wird.

Meine Frage ist nun, macht der Asterisk einen Fehler aufgrund der schnellen wählens/auflegens und schickt die "Idle" Subscription gar nicht zum Telefon oder kommt das Snom-Telefon durcheinander weil es zu schnell 2 Aufeinanderfolgende "Extensions Changed" bekommt.

Versionen:
Astersik 1.2.24
snom360 7.3.23

Hatte schon einmal jemand das Problem und/oder einen Lösungsansatz?

Gruß,
Sven
 
Hier weitere Erkenntnisse durch ein SIP-Debug:

Verdächtig hier, die beiden 200-OK Meldungen kommen erst nach den beiden ersten NOTIFYS. Vermutlich aufgrund der langsamen reaktion des Snom-Telefons, weil der anruf < 1 Sekunde war.

Der Fehler liegt anscheinend beim Asterisk weil er die Pakete mit der Anrufinformation (von dem Anruf der schon längst beendet wurde) immer wieder raussendet. Aber wieso?

Code:
[SIZE="1"]
asterisk01:~ # asterisk -r
Asterisk 1.2.24, Copyright (C) 1999 - 2007 Digium, Inc. and others.
Created by Mark Spencer <[email protected]>
Asterisk comes with ABSOLUTELY NO WARRANTY; type 'show warranty' for details.
This is free software, with components licensed under the GNU General Public
License version 2 and other licenses; you are welcome to redistribute it under
certain conditions. Type 'show license' for details.
=========================================================================
Connected to Asterisk 1.2.24 currently running on asterisk01 (pid = 16723)
asterisk01*CLI> sip debug peer 94222
SIP Debugging Enabled for IP: 172.16.13.46:5060

Reliably Transmitting (no NAT) to 172.16.13.46:5060:
NOTIFY sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Contact: <sip:[email protected]>
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: dialog
Content-Type: application/dialog-info+xml
Subscription-State: active
Content-Length: 578

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="12" state="full" entity="sip:[email protected]">
<dialog id="233" direction="recipient" call-id="[email protected]" local-tag="as084175ac" remote-tag="yc6qqpnb6b">
<state>early</state>
<local><identity display="233">sip:[email protected]</identity><target uri="sip:[email protected]"/></local>
<remote><identity display="TESTPHONE">[email protected]</identity><target uri="sip:[email protected]"/></remote>
</dialog>
</dialog-info>

---
Reliably Transmitting (no NAT) to 172.16.13.46:5060:
NOTIFY sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK6270f006;rport
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Contact: <sip:[email protected]>
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 115 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: dialog
Content-Type: application/dialog-info+xml
Subscription-State: active
Content-Length: 213

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="13" state="full" entity="sip:[email protected]">
<dialog id="233">
<state>terminated</state>
</dialog>
</dialog-info>

---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport=5060
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
Content-Length: 0


--- (7 headers 0 lines) ---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK6270f006;rport=5060
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 115 NOTIFY
Content-Length: 0


--- (7 headers 0 lines) ---
Retransmitting #1 (no NAT) to 172.16.13.46:5060:
NOTIFY sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Contact: <sip:[email protected]>
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: dialog
Content-Type: application/dialog-info+xml
Subscription-State: active
Content-Length: 578

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="12" state="full" entity="sip:[email protected]">
<dialog id="233" direction="recipient" call-id="[email protected]" local-tag="as084175ac" remote-tag="yc6qqpnb6b">
<state>early</state>
<local><identity display="233">sip:[email protected]</identity><target uri="sip:[email protected]"/></local>
<remote><identity display="TESTPHONE">[email protected]</identity><target uri="sip:[email protected]"/></remote>
</dialog>
</dialog-info>

---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport=5060
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
Content-Length: 0


--- (7 headers 0 lines) ---
Retransmitting #2 (no NAT) to 172.16.13.46:5060:
NOTIFY sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Contact: <sip:[email protected]>
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: dialog
Content-Type: application/dialog-info+xml
Subscription-State: active
Content-Length: 578

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="12" state="full" entity="sip:[email protected]">
<dialog id="233" direction="recipient" call-id="[email protected]" local-tag="as084175ac" remote-tag="yc6qqpnb6b">
<state>early</state>
<local><identity display="233">sip:[email protected]</identity><target uri="sip:[email protected]"/></local>
<remote><identity display="TESTPHONE">[email protected]</identity><target uri="sip:[email protected]"/></remote>
</dialog>
</dialog-info>

---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport=5060
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
Content-Length: 0


--- (7 headers 0 lines) ---
Retransmitting #3 (no NAT) to 172.16.13.46:5060:
NOTIFY sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Contact: <sip:[email protected]>
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: dialog
Content-Type: application/dialog-info+xml
Subscription-State: active
Content-Length: 578

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="12" state="full" entity="sip:[email protected]">
<dialog id="233" direction="recipient" call-id="[email protected]" local-tag="as084175ac" remote-tag="yc6qqpnb6b">
<state>early</state>
<local><identity display="233">sip:[email protected]</identity><target uri="sip:[email protected]"/></local>
<remote><identity display="TESTPHONE">[email protected]</identity><target uri="sip:[email protected]"/></remote>
</dialog>
</dialog-info>

---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport=5060
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
Content-Length: 0


--- (7 headers 0 lines) ---
Oct 15 10:31:20 WARNING[16754]: chan_sip.c:1230 retrans_pkt: Maximum retries exceeded on transmission 3c3101d1a8a5-5ypmyuif719h for seqno 104 (Non-critical Request)
Retransmitting #4 (no NAT) to 172.16.13.46:5060:
NOTIFY sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Contact: <sip:[email protected]>
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: dialog
Content-Type: application/dialog-info+xml
Subscription-State: active
Content-Length: 578

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="12" state="full" entity="sip:[email protected]">
<dialog id="233" direction="recipient" call-id="[email protected]" local-tag="as084175ac" remote-tag="yc6qqpnb6b">
<state>early</state>
<local><identity display="233">sip:[email protected]</identity><target uri="sip:[email protected]"/></local>
<remote><identity display="TESTPHONE">[email protected]</identity><target uri="sip:[email protected]"/></remote>
</dialog>
</dialog-info>

---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport=5060
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
Content-Length: 0


--- (7 headers 0 lines) ---
Retransmitting #5 (no NAT) to 172.16.13.46:5060:
NOTIFY sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Contact: <sip:[email protected]>
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: dialog
Content-Type: application/dialog-info+xml
Subscription-State: active
Content-Length: 578

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="12" state="full" entity="sip:[email protected]">
<dialog id="233" direction="recipient" call-id="[email protected]" local-tag="as084175ac" remote-tag="yc6qqpnb6b">
<state>early</state>
<local><identity display="233">sip:[email protected]</identity><target uri="sip:[email protected]"/></local>
<remote><identity display="TESTPHONE">[email protected]</identity><target uri="sip:[email protected]"/></remote>
</dialog>
</dialog-info>

---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport=5060
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
Content-Length: 0


--- (7 headers 0 lines) ---
Retransmitting #6 (no NAT) to 172.16.13.46:5060:
NOTIFY sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Contact: <sip:[email protected]>
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: dialog
Content-Type: application/dialog-info+xml
Subscription-State: active
Content-Length: 578

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="12" state="full" entity="sip:[email protected]">
<dialog id="233" direction="recipient" call-id="[email protected]" local-tag="as084175ac" remote-tag="yc6qqpnb6b">
<state>early</state>
<local><identity display="233">sip:[email protected]</identity><target uri="sip:[email protected]"/></local>
<remote><identity display="TESTPHONE">[email protected]</identity><target uri="sip:[email protected]"/></remote>
</dialog>
</dialog-info>

---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7ac80895;rport=5060
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 114 NOTIFY
Content-Length: 0


--- (7 headers 0 lines) ---
Oct 15 10:31:35 WARNING[16754]: chan_sip.c:1230 retrans_pkt: Maximum retries exceeded on transmission 3c2670206ab7-e6arrpl6s90w for seqno 114 (Non-critical Request)
Oct 15 10:31:35 WARNING[16754]: chan_sip.c:1230 retrans_pkt: Maximum retries exceeded on transmission 3c26702076bb-7zaoujp8jgz8 for seqno 457 (Non-critical Request)
Oct 15 10:31:35 WARNING[16754]: chan_sip.c:1230 retrans_pkt: Maximum retries exceeded on transmission 3c26702066f6-o6xa4xrn5sfg for seqno 524 (Non-critical Request)
Oct 15 10:31:35 WARNING[16754]: chan_sip.c:1230 retrans_pkt: Maximum retries exceeded on transmission 3c267051cebb-cypkqa5tgj7c for seqno 709 (Non-critical Request)
Oct 15 10:31:35 WARNING[16754]: chan_sip.c:1230 retrans_pkt: Maximum retries exceeded on transmission 3c26702075bf-15e4u85fpkc7 for seqno 709 (Non-critical Request)
Oct 15 10:31:35 WARNING[16754]: chan_sip.c:1230 retrans_pkt: Maximum retries exceeded on transmission 3c26701b26f7-tn5jblycbo7f for seqno 713 (Non-critical Request)
12 headers, 0 lines
Reliably Transmitting (no NAT) to 172.16.13.46:5060:
OPTIONS sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7d80320a;rport
From: "asterisk" <sip:[email protected]>;tag=as5cd46d3d
To: <sip:[email protected]:5060>
Contact: <sip:[email protected]>
Call-ID: [email protected]
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Thu, 15 Oct 2009 08:31:37 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0


---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK7d80320a;rport=5060
From: "asterisk" <sip:[email protected]>;tag=as5cd46d3d
To: <sip:[email protected]:5060>
Call-ID: [email protected]
CSeq: 102 OPTIONS
Contact: <sip:[email protected]:5060>;reg-id=1
User-Agent: snom360/7.3.23
Accept-Language: en
Accept: application/sdp
Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO
Allow-Events: talk, hold, refer, call-info
Supported: timer, 100rel, replaces, from-change
Content-Length: 0


--- (14 headers 0 lines) ---
[/SIZE]
[/quote]


Nach dem 2. Anrufen des B. Teilnehmers (Klingelzeit 2 Sekunden) werden die Meldungen korrekt gesendet.

[quote]
[SIZE="1"]
Reliably Transmitting (no NAT) to 172.16.13.46:5060:
NOTIFY sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK556d1b6f;rport
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Contact: <sip:[email protected]>
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 116 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: dialog
Content-Type: application/dialog-info+xml
Subscription-State: active
Content-Length: 578

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="14" state="full" entity="sip:[email protected]">
<dialog id="233" direction="recipient" call-id="[email protected]" local-tag="as088a9404" remote-tag="hc9aizcin3">
<state>early</state>
<local><identity display="233">sip:[email protected]</identity><target uri="sip:[email protected]"/></local>
<remote><identity display="TESTPHONE">[email protected]</identity><target uri="sip:[email protected]"/></remote>
</dialog>
</dialog-info>

---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK556d1b6f;rport=5060
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 116 NOTIFY
Content-Length: 0


--- (7 headers 0 lines) ---
Oct 15 10:31:47 WARNING[16754]: chan_sip.c:1230 retrans_pkt: Maximum retries exceeded on transmission 3c44b7973c02-lemwp9ims44k for seqno 104 (Non-critical Request)
Reliably Transmitting (no NAT) to 172.16.13.46:5060:
NOTIFY sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK056f71ff;rport
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Contact: <sip:[email protected]>
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 117 NOTIFY
User-Agent: Asterisk PBX
Max-Forwards: 70
Event: dialog
Content-Type: application/dialog-info+xml
Subscription-State: active
Content-Length: 213

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="15" state="full" entity="sip:[email protected]">
<dialog id="233">
<state>terminated</state>
</dialog>
</dialog-info>

---
asterisk01*CLI>
<-- SIP read from 172.16.13.46:5060:
SIP/2.0 200 Ok
Via: SIP/2.0/UDP 172.16.8.18:5060;branch=z9hG4bK056f71ff;rport=5060
From: <sip:[email protected];user=phone>;tag=as50707a38
To: <sip:[email protected]>;tag=smn6iupj8v
Call-ID: 3c2670206ab7-e6arrpl6s90w
CSeq: 117 NOTIFY
Content-Length: 0


--- (7 headers 0 lines) ---
[/SIZE]
 
Holen Sie sich 3CX - völlig kostenlos!
Verbinden Sie Ihr Team und Ihre Kunden Telefonie Livechat Videokonferenzen

Gehostet oder selbst-verwaltet. Für bis zu 10 Nutzer dauerhaft kostenlos. Keine Kreditkartendetails erforderlich. Ohne Risiko testen.

3CX
Für diese E-Mail-Adresse besteht bereits ein 3CX-Konto. Sie werden zum Kundenportal weitergeleitet, wo Sie sich anmelden oder Ihr Passwort zurücksetzen können, falls Sie dieses vergessen haben.