Eingehende Anrufe werden erst beim zweiten Versuch verbunden.

  • Hallo,


    wir haben seit nun mehreren Wochen das Problem, dass eingehende Anrufe von extern erst bei dem zweiten Versuch verbunden werden.
    Das Problem tritt nahezu bei jedem Anruf auf, beim ersten Versuch wird die Verbindung mit abnehmen des Hörers unterbrochen.
    Ruft der selbe Teilnehmer erneut an, wird das Gespräch normal Verbunden.


    Im Call-Routing log taucht folgender Eintrag auf:



    [2020-09-30 15:59:54,527] INFO [AGI xxxxxxx-SIP/+xxxxxxxx-0000d521] AsyncAgi d7d154cf-4774-417f-99d3-aa915d1cc20e Dial SIP/1073.N720&SIP/224.xxx.ylnkt46s&SIP/221.xxxx.ylnkt46s&SIP/223.xxxxx.ylnkt46s&SIP/229.xxxxxx.ylnkt46s&SIP/225.xxxxx.ylnkt46s&SIP/228.xxxxx.ylnkt46s&SIP/227.xxxxx.ylnkt46s,15,wWtT
    [2020-09-30 15:59:55,756] WARN [AMI HangupEvent] HangupCause Unknown HangupCause with id=26
    [2020-09-30 15:59:55,757] WARN [AMI HangupEvent] HangupCause Unknown HangupCause with id=26
    [2020-09-30 15:59:55,758] WARN [AMI HangupEvent] HangupCause Unknown HangupCause with id=26
    [2020-09-30 15:59:55,759] WARN [AMI HangupEvent] HangupCause Unknown HangupCause with id=26
    [2020-09-30 15:59:55,760] WARN [AMI HangupEvent] HangupCause Unknown HangupCause with id=26


    [2020-09-30 16:00:04,088] INFO [AGI xxxxxxxx-SIP/+xxxxxxx-0000d521] AsyncAgi execBlocking (d7d154cf-4774-417f-99d3-aa915d1cc20e): of command EXEC Dial "SIP/1073.N720&SIP/224.xxxxx.ylnkt46s&SIP/221.xxxxx.ylnkt46s&SIP/223.xxxxx.ylnkt46s&SIP/229.xxxxxx.ylnkt46s&SIP/225.xxxx.ylnkt46s&SIP/228.xxxx.ylnkt46s&SIP/227.xxxxx.ylnkt46s,15,wWtT" returned -1
    [2020-09-30 16:00:04,088] INFO [AGI xxxxxx-SIP/+xxxxxxx-0000d521] AsyncAgi getChannelVariable (d7d154cf-4774-417f-99d3-aa915d1cc20e): HANGUPCAUSE -> null



    Wir wären für jeden Tipp dankbar.

  • Hallo Merkurfrucht,


    hast du hierzu noch die Logs aus dem "Support" Log?


    Danke!


    Gruß Kreuzer

    STARFACE seit 2015
    STARFACE Advanced VoIP Engineer
    Vodafone Business Partner

  • Hallo Kreuzer,


    hier ist ein Auszug aus dem Support-Log.



    [2020-10-05 09:44:44,108] [1600] ********* Call created *********
    [2020-10-05 09:44:44,108] [1600] Starting call routing : SIP/+******-000014b2|1601883884.5357 dial number ****** CallerId <******>
    [2020-10-05 09:44:44,108] [1600] Incoming call from line TelekomSIP(2019)
    [2020-10-05 09:44:44,109] [1600] Found extension on line TelekomSIP(2019) ******
    [2020-10-05 09:44:44,114] [1600] Relevance check in "******" on callstage onAllIncomingCalls
    [2020-10-05 09:44:44,114] [1600] Relevance check in "******" on callstage onAllIncomingCalls
    [2020-10-05 09:44:44,114] [1600] Relevance check in "******" on callstage onAllIncomingCalls
    [2020-10-05 09:44:44,114] [1600] Relevance check in "******" on callstage onAllIncomingCalls
    [2020-10-05 09:44:44,114] [1600] Relevance check in "******" on callstage onAllIncomingCalls
    [2020-10-05 09:44:44,115] [1600] Relevance check in "******" on callstage onAllIncomingCalls
    [2020-10-05 09:44:44,115] [1600] Relevance check in "******" on callstage onAllIncomingCalls
    [2020-10-05 09:44:44,115] [1600] Relevance check in "******" on callstage onAllIncomingCalls
    [2020-10-05 09:44:44,116] [1600] Routing call " <******>" to number ****** over service RingAllGroupService
    [2020-10-05 09:44:44,116] [1600] CallLeg 3a316bcb-b7ef-4103-91ff-d1ff6527a266
    [2020-10-05 09:44:44,147] [1600] Sending push request: {"service":"apns","token":"9cfba29a7adbb2f42020cc7b0b97c552b99628a60c6d1acf4958e0b115f8554b","callId":"7258550b-40de-4505-8b3e-252c42497e40","content":"l8AnsM88RXiCbJWZL2Lb2w==:tSFAD1kbLyQGrz3tevGiozHxa8pATLUfATx/CLT4tttqyHJqeP+/AcyPpL3NJvQ6Y8ubNHiUVmHBple3HOnII76VjXgIqhVX+1hBXsMGZdU="}
    [2020-10-05 09:44:44,150] [1600] Sending push request: {"service":"","token":"","callId":"80ec4b11-4c93-41a3-84c4-978dd04bb152","content":"+A3nA0Dp529GlKKDpLXVTw==:vkedercBymm6dPcmcPCrAjH0dX/9dd8MRrUFatY2L2PTX2JOcpPrVf9vIHyTz3CCT6lS3JPYSj5JiAFuqf0s+jgnW6igTRrFLpGYUuclVZo="}
    [2020-10-05 09:44:44,203] [1600] Sending push request: {"service":"","token":"","callId":"80ec4b11-4c93-41a3-84c4-978dd04bb152","content":"+A3nA0Dp529GlKKDpLXVTw==:vkedercBymm6dPcmcPCrAjH0dX/9dd8MRrUFatY2L2PTX2JOcpPrVf9vIHyTz3CCT6lS3JPYSj5JiAFuqf0s+jgnW6igTRrFLpGYUuclVZo="} returns code 400
    [2020-10-05 09:44:44,203] [1600] Removing dial request
    [2020-10-05 09:44:44,218] [1600] Dial SIP/+******-000014b2 to SIP/224.******.ylnkt46s-000014b3
    [2020-10-05 09:44:44,219] [1600] Dial SIP/+******-000014b2 to SIP/225.******.ylnkt46s-000014b4
    [2020-10-05 09:44:44,220] [1600] Dial SIP/+******-000014b2 to SIP/1073.******-000014b5
    [2020-10-05 09:44:44,220] [1600] Dial SIP/+******-000014b2 to SIP/223.******.ylnkt46s-000014b6
    [2020-10-05 09:44:44,220] [1600] Dial SIP/+******-000014b2 to SIP/229.******.ylnkt46s-000014b7
    [2020-10-05 09:44:44,221] [1600] Dial SIP/+******-000014b2 to SIP/227.******.ylnkt46s-000014b8
    [2020-10-05 09:44:44,221] [1600] Dial SIP/+******-000014b2 to SIP/228.******.ylnkt46s-000014b9
    [2020-10-05 09:44:44,222] [1600] Dial SIP/+******-000014b2 to SIP/221.******.ylnkt46s-000014ba
    [2020-10-05 09:44:44,260] [1600] SIP/229.******.ylnkt46s-000014b7 Channelstate is Ringing
    [2020-10-05 09:44:44,278] [1600] SIP/224.******.ylnkt46s-000014b3 Channelstate is Ringing
    [2020-10-05 09:44:44,279] [1600] SIP/225.******.ylnkt46s-000014b4 Channelstate is Ringing
    [2020-10-05 09:44:44,283] [1600] SIP/223.******.ylnkt46s-000014b6 Channelstate is Ringing
    [2020-10-05 09:44:44,285] [1600] SIP/228.******.ylnkt46s-000014b9 Channelstate is Ringing
    [2020-10-05 09:44:44,285] [1600] SIP/227.******.ylnkt46s-000014b8 Channelstate is Ringing
    [2020-10-05 09:44:44,288] [1600] SIP/221.******.ylnkt46s-000014ba Channelstate is Ringing
    [2020-10-05 09:44:44,357] [1600] Sending push request: {"service":"apns","token":"9cfba29a7adbb2f42020cc7b0b97c552b99628a60c6d1acf4958e0b115f8554b","callId":"7258550b-40de-4505-8b3e-252c42497e40","content":"l8AnsM88RXiCbJWZL2Lb2w==:tSFAD1kbLyQGrz3tevGiozHxa8pATLUfATx/CLT4tttqyHJqeP+/AcyPpL3NJvQ6Y8ubNHiUVmHBple3HOnII76VjXgIqhVX+1hBXsMGZdU="} returns code 200
    [2020-10-05 09:44:45,317] [1600] SIP/1073.******-000014b5 Channelstate is Ringing
    [2020-10-05 09:44:50,474] [1600] SIP/227.******.ylnkt46s-000014b8 Channelstate is Up
    [2020-10-05 09:44:50,474] [1600] SIP/224.******.ylnkt46s-000014b3 Hangup Cause: Answered elsewhere
    [2020-10-05 09:44:50,475] [1600] SIP/225.******.ylnkt46s-000014b4 Hangup Cause: Answered elsewhere
    [2020-10-05 09:44:50,476] [1600] SIP/1073.******-000014b5 Hangup Cause: Answered elsewhere
    [2020-10-05 09:44:50,477] [1600] SIP/223.******.ylnkt46s-000014b6 Hangup Cause: Answered elsewhere
    [2020-10-05 09:44:50,479] [1600] SIP/229.******.ylnkt46s-000014b7 Hangup Cause: Answered elsewhere
    [2020-10-05 09:44:50,480] [1600] SIP/228.******.ylnkt46s-000014b9 Hangup Cause: Answered elsewhere
    [2020-10-05 09:44:50,480] [1600] SIP/221.******.ylnkt46s-000014ba Hangup Cause: Answered elsewhere
    [2020-10-05 09:44:50,481] [1600] SIP/+******-000014b2 Channelstate is Up
    [2020-10-05 09:44:50,481] [1600] SIP/227.******.ylnkt46s-000014b8 Link SIP/+******-000014b2
    [2020-10-05 09:44:55,508] [1600] SIP/227.******.ylnkt46s-000014b8 Unlink SIP/+******-000014b2
    [2020-10-05 09:44:55,508] [1600] SIP/227.******.ylnkt46s-000014b8 Link SIP/+******-000014b2
    [2020-10-05 09:44:57,407] [1600] SIP/227.******.ylnkt46s-000014b8 HangupRequestEvent
    [2020-10-05 09:44:57,407] [1600] SIP/227.******.ylnkt46s-000014b8 Unlink SIP/+******-000014b2
    [2020-10-05 09:44:57,409] [1600] SIP/227.******.ylnkt46s-000014b8 Hangup Cause: Normal Clearing
    [2020-10-05 09:44:57,410] [1600] Got dialstatus DialReturnCodes(hc=NORMAL_CLEARING, ds=ANSWER, cr=UNKNOWN)
    [2020-10-05 09:44:57,426] [1600] SIP/+******-000014b2 Hangup Cause: Normal Clearing
    [2020-10-05 09:44:57,426] [1600] ********* Call finished *********


    -------------------------------------------------------------------------------------------------------------------------------------------------------------

  • In diesem Fall ist es eine Gruppe in der iFMC zu besonderen Zeiten genutzt wird.
    Es betrifft aber auch einzelne Benutzer, weshalb ich iFMC, Gruppenzugehörigkeit oder auch Modul als Ursache ausschließen würde.
    Ich muss die Aussage "beim ersten Versuch wird die Verbindung mit abnehmen des Hörers unterbrochen", korrigieren.
    Die Verbindung scheint zu bestehen nur kann weder der Anrufer noch der Angerufene den anderen nicht hören.
    Beim zweiten Versuch, direkt nach dem auflegen gibt es keine Probleme.
    Die Frage ist wird das überhaupt als Fehler erkannt und als solcher protokolliert.


  • Die Verbindung scheint zu bestehen nur kann weder der Anrufer noch der Angerufene den anderen nicht hören.
    Beim zweiten Versuch, direkt nach dem auflegen gibt es keine Probleme.


    Das hört sich nach einem Firewall Problem an.
    Wo steht denn die Starface und die Telefone, im selben Netz?

    Die Frage ist wird das überhaupt als Fehler erkannt und als solcher protokolliert.


    Nein, als Fehler wird das nicht "erkannt".

  • Wie slu schon gesagt hat, ist das Vermutlich ein Firewall Problem.


    Spezifisch ich vermute der erste 200 OK von der Firewall verschluckt wird, und deshalb das Telefon munter weiterklingelt.


    Am besten erstellt du eine PCAP Datei. Admin ==> Systemstatus ==> Diagnose.
    Stell die Maximale Dateigrösse auf 999, Lass den Haken bei SIP/RTP drin, drücke auf Start. Provozier das Problem. drücke auf Stop, und lade die Datei herunter.
    Diese Datei enthält allerlei Informationen (Unmaskierte Nummern, Namen der Teilnehmer, IP-Adressen von der STARFACE/Endgeräten, Providerinformationen usw...), welche nicht einfach ins Internet gestellt werden sollten.
    Du kannst diese Datei mit dem Wireshark öffnen. https://www.wireshark.org/download.html


    Um die SIP-Flows anzusehen, klicke oben auf "Telephonie" ==> "VOIP-Anrufe" ==> Wähle deinen Anruf ==> drücke auf "Flow-Sequenzen".


    Eine korrekte Sequenz sollte so aussehen:



    MfG


    Fabian

  • Hallo Fabian


    Ich habe es gerade in Wireshark getestet.
    bei den erfolgreichen Versuchen höre ich mich und die Gegenstelle.
    Bei dem fehlgeschlagenen Versuch hört man nur die Gegenstelle.


    MfG
    merkurfrucht

  • Hallo Merkursfrucht


    Wie slu schon sagt, die Firewall.


    Der RTP-Stream von der gegenstelle geht vom weg von der Starface zum Telefon des Mitarbeiters verloren.
    Der RTP-Stream des Mitarbeiters geht auf dem weg zur Starface verloren.


    MfG


    Fabian

  • Da muss trotzdem ein Problem vorliegen, denn die STARFACE hört ja den internen Teilnehmer nicht.
    Und der externe Teilnehmer wird von der STARFACE gehört, aber kommt nicht bis zum internen Teilnehmer. Also irgendwo zwischen STARFACE ==> Interner Teilnehmer


    MfG


    Fabian

  • Die Anlage und Telefone befinden sich in einem eigenen Vlan, getrennt vom restlichen Netzwerk. Telefon-->Starface-->Firewall


    Das passt nicht zu deinem Wireshark Screenshot (oder ich verstehen den Ausschnitt falsch) hier steht nämlich was von 217...


    Edit: Wie Fabian schon sagt, irgendwas ist hier im Weg.

  • Das passt nicht zu deinem Wireshark Screenshot (oder ich verstehen den Ausschnitt falsch) hier steht nämlich was von 217...


    Edit: Wie Fabian schon sagt, irgendwas ist hier im Weg.


    Doch, das passt schon. Die IP mit der 217. ist dann sein SIP-Provider, die 192. sein internes Netz. Ich tippe aber auch auf ein Firewall-Problem.


    Viele Grüße,
    Torsten

Jetzt mitmachen!

Sie haben noch kein Benutzerkonto auf unserer Seite? Registrieren Sie sich kostenlos und nehmen Sie an unserer Community teil!