Seite 1 von 2 12 LetzteLetzte
Zeige Ergebnis 1 bis 15 von 25

Thema: Starface PBX VM Edition 6.7.3.20 Anrufe können nicht angenommen werden o. extrem slow

  1. #1
    STARFACE User

    Registriert seit
    20.11.2018
    Beiträge
    15

    Ausrufezeichen Starface PBX VM Edition 6.7.3.20 Anrufe können nicht angenommen werden o. extrem slow

    Hallo zusammen,

    Wir haben derzeit ein Recht großes Problem mit unserer Starface.
    Technische Details:
    • Version: 6.7.3.20
    • Lizens: STARFACE PBX Server VM Edition, STARFACE PBX User, STARFACE PBX User, STARFACE PBX User, STARFACE PBX User, STARFACE PBX User, STARFACE PBX User Light, STARFACE PBX User Light, STARFACE PBX User Light, STARFACE PBX User, STARFACE PBX User

    Starface Settings Version.png
    Starface Settings Module.png

    Sicherheitstechnisch stellen wir derzeit viel in unserem Netzwerk um, deswegen werden auch für die Starface nur noch die Verbindungen erlaubt die Zwingend notwendig sind.
    Seitdem können aber teilweise keine Anrufe mehr angenommen werden und Anrufe ausgehend funktionieren auch nicht.

    Ich habe eine Skizze aller Verbindungen die wir auf der Firewall freigegeben haben erstellt, ich hoffe das hilft:
    Starface Skizze_Zensiert.jpg

    Ich hab bereits folgende Logs und einen tcpdump vom Server gesichert:
    • /var/log/asterisk/full
    • /var/log/starface/call-model.log
    • /var/log/starface/call-processing.log
    • /var/log/starface/support.log
    • capture.pcap


    Es geht um die Einträge von folgender Test Person:
    • Feldmann
    • 192.168.8.68
    • SIP/1040.winclient


    Durchwahl und Handy nummern wurden folgendermaßen Zensiert:
    • ### DURCHWAHL ARBEIT ###
    • ### HANDY PRIVAT ###


    In diesen Logs ist hoffentlich erkennbar das Herr Feldmann versucht hat sich selbst auf seinem Handy anzurufen 2 mal, und dies nicht funktioniert hatte.
    Danach hat Herr Feldmann versucht sich selbst vom Handy aus auf der Arbeit anzurufen, dann hatte es geklingelt aber er konnte nicht abnehmen. Der Click auf den grünen Hörer funktionierte nicht.
    Der Zeitraum dieser Tests liegt ungefähr zwischen 10:52 Uhr und 10:57 Uhr.

    Im ersten Post folgen aufgrund der Zeichenlimitierung von maximale 30000 Zeichen die Logs da ich diese nicht als Datei hochladen kann.
    das tcpdump Capture.pcap kann ich ebenfalls nicht hochladen.

  2. #2
    STARFACE User

    Registriert seit
    20.11.2018
    Beiträge
    15

    Standard

    Call-model:
    Code:
    [2021-09-08 10:51:02,892] INFO  [AMI HangupEvent] CallModelLog SIP/1023.WinClient-000002b2|1631091047.756||DOWN|Rec:false|pstnLineRequested:false HangupCause: Normal Clearing Cause:16 
    [2021-09-08 10:51:03,904] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002af] CallModelLog Adding Callback 8e97154a-32dd-42c8-8625-16f2b25d1e4e REDIRECTED Caller redirected flag (8e97154a-32dd-42c8-8625-16f2b25d1e4e) 
    [2021-09-08 10:51:03,904] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002af] CallModelLog Adding Callback 8e97154a-32dd-42c8-8625-16f2b25d1e4e REDIRECTED Caller redirected flag (8e97154a-32dd-42c8-8625-16f2b25d1e4e) 
    [2021-09-08 10:51:03,905] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002af] CallModelLog Adding Callback 8e97154a-32dd-42c8-8625-16f2b25d1e4e COMPLETED Ifmc or iPhoneClient caller (8e97154a-32dd-42c8-8625-16f2b25d1e4e) hangup 
    [2021-09-08 10:51:03,905] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002af] CallModelLog Adding Callback 8e97154a-32dd-42c8-8625-16f2b25d1e4e LINKED Ifmc or iPhoneClient caller (8e97154a-32dd-42c8-8625-16f2b25d1e4e) conenct with no fmc phone or iPhoneClient 
    [2021-09-08 10:51:03,905] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002af] CallModelLog Adding Callback 8e97154a-32dd-42c8-8625-16f2b25d1e4e REDIRECTED Ifmc or iPhoneClient caller (8e97154a-32dd-42c8-8625-16f2b25d1e4e) is redirected 
    [2021-09-08 10:51:03,924] INFO  [AMI NewChannelEvent] CallModelLog SIP/1040.WinClient-000002b3|1631091063.757||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:51:03,925] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1040.WinClient-000002b3 X-UCI_CALLID: 61096f3f-d9c0-4c3e-bc90-286449a041ed 
    [2021-09-08 10:51:03,925] INFO  [AMI DialEvent] CallModelLog SIP/021739250-000002af|1631091026.753||DIAL_SRC|Rec:false|pstnLineRequested:false ---> SIP/1040.WinClient-000002b3|1631091063.757||DIAL_TRG|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:51:08,651] INFO  [AMI HangupEvent] CallModelLog SIP/1040.WinClient-000002b3|1631091063.757||DOWN|Rec:false|pstnLineRequested:false HangupCause: null Cause:0 
    [2021-09-08 10:51:08,655] INFO  [AMI HangupEvent] CallModelLog SIP/021739250-000002af|1631091026.753||DOWN|Rec:false|pstnLineRequested:false HangupCause: No user responding Cause:18 
    [2021-09-08 10:51:08,657] INFO  [AMI HangupEvent] CallModelLog Executing Callback 8e97154a-32dd-42c8-8625-16f2b25d1e4e COMPLETED Ifmc or iPhoneClient caller (8e97154a-32dd-42c8-8625-16f2b25d1e4e) hangup 
    [2021-09-08 10:51:08,657] INFO  [AMI HangupEvent] CallModelLog Executing Callback 8e97154a-32dd-42c8-8625-16f2b25d1e4e COMPLETED Ifmc or iPhoneClient caller (8e97154a-32dd-42c8-8625-16f2b25d1e4e) hangup 
    [2021-09-08 10:51:08,657] INFO  [AMI HangupEvent] CallModelLog Executing Callback 8e97154a-32dd-42c8-8625-16f2b25d1e4e COMPLETED Ifmc or iPhoneClient caller (8e97154a-32dd-42c8-8625-16f2b25d1e4e) hangup 
    [2021-09-08 10:51:08,658] INFO  [AMI HangupEvent] CallModelLog Executing Callback 8e97154a-32dd-42c8-8625-16f2b25d1e4e COMPLETED Ifmc or iPhoneClient caller (8e97154a-32dd-42c8-8625-16f2b25d1e4e) hangup 
    
    [2021-09-08 10:51:08,661] WARN  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002af] CallModelLog Could not add Callback 8e97154a-32dd-42c8-8625-16f2b25d1e4e REDIRECTED Caller redirected flag (8e97154a-32dd-42c8-8625-16f2b25d1e4e) this can lead to not connected calls or calls are endless ringing. Returning already in state true. 
    
    [2021-09-08 10:51:27,867] INFO  [AMI PeerStatusEvent] CallModelLog SIP/2083.WinClient Registered 
    [2021-09-08 10:51:27,867] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/2083.WinClient goes online 
    [2021-09-08 10:51:39,768] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1784.WinClient Registered 
    [2021-09-08 10:51:39,768] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1784.WinClient goes online 
    [2021-09-08 10:52:06,155] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1764.WinClient Registered 
    [2021-09-08 10:52:06,155] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1764.WinClient goes online 
    [2021-09-08 10:52:28,584] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1546.WinClient Registered 
    [2021-09-08 10:52:28,584] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1546.WinClient goes online 
    [2021-09-08 10:52:30,223] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1163.WinClient Registered 
    [2021-09-08 10:52:30,223] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1163.WinClient goes online 
    [2021-09-08 10:53:03,057] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1170.WinClient Registered 
    [2021-09-08 10:53:03,057] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1170.WinClient goes online 
    [2021-09-08 10:53:06,255] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1048.WinClient Registered 
    [2021-09-08 10:53:06,255] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1048.WinClient goes online 
    [2021-09-08 10:53:10,462] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1164.WinClient Registered 
    [2021-09-08 10:53:10,462] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1164.WinClient goes online 
    [2021-09-08 10:53:13,373] INFO  [AMI NewChannelEvent] CallModelLog SIP/1040.WinClient-000002b4|1631091193.758||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:53:13,374] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1040.WinClient-000002b4 X-UCI_CALLID: a57d3af2-ebb5-438f-837d-d96a157a6643 
    [2021-09-08 10:53:13,374] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1040.WinClient-000002b4 Call-Info: <sip:10.254.3.19>;answer-after=0 
    [2021-09-08 10:53:13,375] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1040.WinClient-000002b4 X-UCI_ORIGINATE: a57d3af2-ebb5-438f-837d-d96a157a6643 
    [2021-09-08 10:53:26,781] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1295.WinClient Registered 
    [2021-09-08 10:53:26,781] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1295.WinClient goes online 
    [2021-09-08 10:53:27,978] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1277.WinClient Registered 
    [2021-09-08 10:53:27,978] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1277.WinClient goes online 
    [2021-09-08 10:53:33,756] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1459.WinClient Registered 
    [2021-09-08 10:53:33,756] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1459.WinClient goes online 
    [2021-09-08 10:53:35,509] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1040.WinClient Unreachable 
    [2021-09-08 10:53:38,914] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1229.WinClient Registered 
    [2021-09-08 10:53:38,915] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1229.WinClient goes online 
    [2021-09-08 10:53:41,500] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1040.WinClient Unregistered 
    [2021-09-08 10:53:41,500] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1040.WinClient goes offline 
    [2021-09-08 10:53:43,282] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1002.WinClient Registered 
    [2021-09-08 10:53:43,282] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1002.WinClient goes online 
    [2021-09-08 10:53:44,438] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1515.WinClient Registered 
    [2021-09-08 10:53:44,438] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1515.WinClient goes online 
    [2021-09-08 10:53:52,650] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1276.WinClient Registered 
    [2021-09-08 10:53:52,650] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1276.WinClient goes online 
    [2021-09-08 10:53:58,408] INFO  [AMI HangupEvent] CallModelLog SIP/1040.WinClient-000002b4|1631091193.758||DOWN|Rec:false|pstnLineRequested:false HangupCause: Normal Clearing Cause:16 
    [2021-09-08 10:54:02,420] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1040.WinClient Registered 
    [2021-09-08 10:54:02,420] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1040.WinClient goes online 
    [2021-09-08 10:54:02,423] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1040.WinClient Reachable 
    [2021-09-08 10:54:33,930] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1023.WinClient Registered 
    [2021-09-08 10:54:33,930] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1023.WinClient goes online 
    [2021-09-08 10:54:41,383] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1045.WinClient Registered 
    [2021-09-08 10:54:41,383] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1045.WinClient goes online 
    [2021-09-08 10:54:42,438] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1238.WinClient Registered 
    [2021-09-08 10:54:42,438] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1238.WinClient goes online 
    [2021-09-08 10:54:42,681] INFO  [AMI NewChannelEvent] CallModelLog SIP/1040.WinClient-000002b5|1631091282.760||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:54:42,682] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1040.WinClient-000002b5 X-UCI_CALLID: 1bf72199-16d3-4fd5-8b7b-baa6069cda99 
    [2021-09-08 10:54:42,682] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1040.WinClient-000002b5 Call-Info: <sip:10.254.3.19>;answer-after=0 
    [2021-09-08 10:54:42,682] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1040.WinClient-000002b5 X-UCI_ORIGINATE: 1bf72199-16d3-4fd5-8b7b-baa6069cda99 
    [2021-09-08 10:55:06,422] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1040.WinClient Unreachable 
    [2021-09-08 10:55:13,931] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1572.WinClient Registered 
    [2021-09-08 10:55:13,931] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1572.WinClient goes online 
    [2021-09-08 10:55:17,254] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1165.WinClient Registered 
    [2021-09-08 10:55:17,254] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1165.WinClient goes online 
    [2021-09-08 10:55:27,721] INFO  [AMI HangupEvent] CallModelLog SIP/1040.WinClient-000002b5|1631091282.760||DOWN|Rec:false|pstnLineRequested:false HangupCause: Normal Clearing Cause:16 
    [2021-09-08 10:55:31,312] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1040.WinClient Reachable 
    [2021-09-08 10:55:31,721] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1167.WinClient Registered 
    [2021-09-08 10:55:31,721] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1167.WinClient goes online 
    [2021-09-08 10:55:36,708] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1303.WinClient Registered 
    [2021-09-08 10:55:36,708] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1303.WinClient goes online 
    [2021-09-08 10:56:12,801] INFO  [AMI NewChannelEvent] CallModelLog SIP/021739250-000002b6|1631091372.762||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:12,801] INFO  [AMI NewStateEvent] CallModelLog SIP/021739250-000002b6|1631091372.762||RING|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:12,822] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Caller redirected flag (c72710ae-274f-4075-87d1-be6c0eb54e3b) 
    [2021-09-08 10:56:12,822] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b COMPLETED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) hangup 
    [2021-09-08 10:56:12,822] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b LINKED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) conenct with no fmc phone or iPhoneClient 
    [2021-09-08 10:56:12,822] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) is redirected 
    [2021-09-08 10:56:12,907] INFO  [AMI NewChannelEvent] CallModelLog SIP/1040.WinClient-000002b7|1631091372.763||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:12,908] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1040.WinClient-000002b7 X-UCI_CALLID: 897399a5-4269-40eb-9cdc-9c8e6948385f 
    [2021-09-08 10:56:12,909] INFO  [AMI DialEvent] CallModelLog SIP/021739250-000002b6|1631091372.762||DIAL_SRC|Rec:false|pstnLineRequested:false ---> SIP/1040.WinClient-000002b7|1631091372.763||DIAL_TRG|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:13,069] INFO  [AMI NewStateEvent] CallModelLog SIP/1040.WinClient-000002b7|1631091372.763||RINGING|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:17,633] INFO  [AMI NewChannelEvent] CallModelLog SIP/021739250-000002b8|1631091377.764||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:17,634] INFO  [AMI NewStateEvent] CallModelLog SIP/021739250-000002b8|1631091377.764||RING|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:17,651] INFO  [AGI 00492173925251-SIP/021739250-000002b8] CallModelLog Adding Callback be1cc5ea-7d70-4617-a061-cc13ad5197b1 REDIRECTED Caller redirected flag (be1cc5ea-7d70-4617-a061-cc13ad5197b1) 
    [2021-09-08 10:56:17,652] INFO  [AGI 00492173925251-SIP/021739250-000002b8] CallModelLog Adding Callback be1cc5ea-7d70-4617-a061-cc13ad5197b1 COMPLETED Ifmc or iPhoneClient caller (be1cc5ea-7d70-4617-a061-cc13ad5197b1) hangup 
    [2021-09-08 10:56:17,652] INFO  [AGI 00492173925251-SIP/021739250-000002b8] CallModelLog Adding Callback be1cc5ea-7d70-4617-a061-cc13ad5197b1 LINKED Ifmc or iPhoneClient caller (be1cc5ea-7d70-4617-a061-cc13ad5197b1) conenct with no fmc phone or iPhoneClient 
    [2021-09-08 10:56:17,652] INFO  [AGI 00492173925251-SIP/021739250-000002b8] CallModelLog Adding Callback be1cc5ea-7d70-4617-a061-cc13ad5197b1 REDIRECTED Ifmc or iPhoneClient caller (be1cc5ea-7d70-4617-a061-cc13ad5197b1) is redirected 
    [2021-09-08 10:56:17,738] INFO  [AMI NewChannelEvent] CallModelLog SIP/1295.WinClient-000002b9|1631091377.765||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:17,739] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1295.WinClient-000002b9 X-UCI_CALLID: 149d6463-cdb7-4fb2-a9e8-9b5f16a4a7ab 
    [2021-09-08 10:56:17,739] INFO  [AMI DialEvent] CallModelLog SIP/021739250-000002b8|1631091377.764||DIAL_SRC|Rec:false|pstnLineRequested:false ---> SIP/1295.WinClient-000002b9|1631091377.765||DIAL_TRG|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:17,940] INFO  [AMI NewStateEvent] CallModelLog SIP/1295.WinClient-000002b9|1631091377.765||RINGING|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:22,874] INFO  [AMI PeerStatusEvent] CallModelLog SIP/2083.WinClient Registered 
    [2021-09-08 10:56:22,875] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/2083.WinClient goes online 
    [2021-09-08 10:56:27,910] INFO  [AMI HangupEvent] CallModelLog SIP/1040.WinClient-000002b7|1631091372.763||DOWN|Rec:false|pstnLineRequested:false HangupCause: Normal Clearing Cause:16 
    [2021-09-08 10:56:27,949] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Caller redirected flag (c72710ae-274f-4075-87d1-be6c0eb54e3b) 
    [2021-09-08 10:56:27,949] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Caller redirected flag (c72710ae-274f-4075-87d1-be6c0eb54e3b) 
    [2021-09-08 10:56:27,950] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b COMPLETED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) hangup 
    [2021-09-08 10:56:27,950] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b LINKED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) conenct with no fmc phone or iPhoneClient 
    [2021-09-08 10:56:27,950] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) is redirected 
    [2021-09-08 10:56:27,968] INFO  [AMI NewChannelEvent] CallModelLog SIP/1040.WinClient-000002ba|1631091387.766||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:27,969] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1040.WinClient-000002ba X-UCI_CALLID: 897399a5-4269-40eb-9cdc-9c8e6948385f 
    [2021-09-08 10:56:27,969] INFO  [AMI DialEvent] CallModelLog SIP/021739250-000002b6|1631091372.762||DIAL_SRC|Rec:false|pstnLineRequested:false ---> SIP/1040.WinClient-000002ba|1631091387.766||DIAL_TRG|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:34,779] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1784.WinClient Registered 
    [2021-09-08 10:56:34,779] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1784.WinClient goes online 
    [2021-09-08 10:56:35,312] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1040.WinClient Unreachable 
    [2021-09-08 10:56:35,676] INFO  [AMI NewStateEvent] CallModelLog SIP/1295.WinClient-000002b9|1631091377.765||UP|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:35,677] INFO  [AMI NewStateEvent] CallModelLog SIP/021739250-000002b8|1631091377.764||UP|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:35,678] INFO  [AMI BridgeEvent] CallModelLog SIP/021739250-000002b8|1631091377.764||UP|Rec:false|pstnLineRequested:false <---> SIP/1295.WinClient-000002b9|1631091377.765||UP|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:35,678] INFO  [AMI BridgeEvent] CallModelLog Executing Callback be1cc5ea-7d70-4617-a061-cc13ad5197b1 LINKED Ifmc or iPhoneClient caller (be1cc5ea-7d70-4617-a061-cc13ad5197b1) conenct with no fmc phone or iPhoneClient 
    [2021-09-08 10:56:35,679] INFO  [AMI BridgeEvent] CallModelLog CallerIdUpdate "Jens Krakow (Gödde)" <sip:0004922159906170@10.254.3.19> to SIP/1295.WinClient-000002b9 
    [2021-09-08 10:56:42,985] INFO  [AMI HangupEvent] CallModelLog SIP/1040.WinClient-000002ba|1631091387.766||DOWN|Rec:false|pstnLineRequested:false HangupCause: null Cause:0 
    [2021-09-08 10:56:43,086] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Caller redirected flag (c72710ae-274f-4075-87d1-be6c0eb54e3b) 
    [2021-09-08 10:56:43,087] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b COMPLETED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) hangup 
    [2021-09-08 10:56:43,087] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b LINKED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) conenct with no fmc phone or iPhoneClient 
    [2021-09-08 10:56:43,087] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) is redirected 
    [2021-09-08 10:56:43,188] INFO  [AMI NewChannelEvent] CallModelLog SIP/1023.WinClient-000002bb|1631091403.767||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:43,188] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1023.WinClient-000002bb X-UCI_CALLID: 897399a5-4269-40eb-9cdc-9c8e6948385f 
    [2021-09-08 10:56:43,189] INFO  [AMI DialEvent] CallModelLog SIP/021739250-000002b6|1631091372.762||DIAL_SRC|Rec:false|pstnLineRequested:false ---> SIP/1023.WinClient-000002bb|1631091403.767||DIAL_TRG|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:43,304] INFO  [AMI NewStateEvent] CallModelLog SIP/1023.WinClient-000002bb|1631091403.767||RINGING|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:58,190] INFO  [AMI HangupEvent] CallModelLog SIP/1023.WinClient-000002bb|1631091403.767||DOWN|Rec:false|pstnLineRequested:false HangupCause: Normal Clearing Cause:16 
    [2021-09-08 10:56:59,204] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Caller redirected flag (c72710ae-274f-4075-87d1-be6c0eb54e3b) 
    [2021-09-08 10:56:59,204] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Caller redirected flag (c72710ae-274f-4075-87d1-be6c0eb54e3b) 
    [2021-09-08 10:56:59,205] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Caller redirected flag (c72710ae-274f-4075-87d1-be6c0eb54e3b) 
    [2021-09-08 10:56:59,206] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b COMPLETED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) hangup 
    [2021-09-08 10:56:59,206] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b LINKED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) conenct with no fmc phone or iPhoneClient 
    [2021-09-08 10:56:59,206] INFO  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Adding Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) is redirected 
    [2021-09-08 10:56:59,224] INFO  [AMI NewChannelEvent] CallModelLog SIP/1023.WinClient-000002bc|1631091419.768||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:59,224] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/1023.WinClient-000002bc X-UCI_CALLID: 897399a5-4269-40eb-9cdc-9c8e6948385f 
    [2021-09-08 10:56:59,225] INFO  [AMI DialEvent] CallModelLog SIP/021739250-000002b6|1631091372.762||DIAL_SRC|Rec:false|pstnLineRequested:false ---> SIP/1023.WinClient-000002bc|1631091419.768||DIAL_TRG|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:56:59,401] INFO  [AMI NewStateEvent] CallModelLog SIP/1023.WinClient-000002bc|1631091419.768||RINGING|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:57:01,162] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1764.WinClient Registered 
    [2021-09-08 10:57:01,162] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1764.WinClient goes online 
    [2021-09-08 10:57:13,315] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1040.WinClient Reachable 
    [2021-09-08 10:57:14,096] INFO  [AMI HangupEvent] CallModelLog SIP/1023.WinClient-000002bc|1631091419.768||DOWN|Rec:false|pstnLineRequested:false HangupCause: Normal Clearing Cause:16 
    [2021-09-08 10:57:14,098] INFO  [AMI HangupEvent] CallModelLog SIP/021739250-000002b6|1631091372.762||DOWN|Rec:false|pstnLineRequested:false HangupCause: null Cause:0 
    [2021-09-08 10:57:14,099] INFO  [AMI HangupEvent] CallModelLog Executing Callback c72710ae-274f-4075-87d1-be6c0eb54e3b COMPLETED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) hangup 
    [2021-09-08 10:57:14,100] INFO  [AMI HangupEvent] CallModelLog Executing Callback c72710ae-274f-4075-87d1-be6c0eb54e3b COMPLETED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) hangup 
    [2021-09-08 10:57:14,101] INFO  [AMI HangupEvent] CallModelLog Executing Callback c72710ae-274f-4075-87d1-be6c0eb54e3b COMPLETED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) hangup 
    [2021-09-08 10:57:14,103] INFO  [AMI HangupEvent] CallModelLog Executing Callback c72710ae-274f-4075-87d1-be6c0eb54e3b COMPLETED Ifmc or iPhoneClient caller (c72710ae-274f-4075-87d1-be6c0eb54e3b) hangup 
    
    [2021-09-08 10:57:15,105] WARN  [AGI ### DURCHWAHL ARBEIT ###-SIP/021739250-000002b6] CallModelLog Could not add Callback c72710ae-274f-4075-87d1-be6c0eb54e3b REDIRECTED Caller redirected flag (c72710ae-274f-4075-87d1-be6c0eb54e3b) this can lead to not connected calls or calls are endless ringing. Returning already in state true. 
    
    [2021-09-08 10:57:23,587] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1546.WinClient Registered 
    [2021-09-08 10:57:23,587] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1546.WinClient goes online 
    [2021-09-08 10:57:25,233] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1163.WinClient Registered 
    [2021-09-08 10:57:25,233] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1163.WinClient goes online 
    [2021-09-08 10:57:52,941] INFO  [AMI NewChannelEvent] CallModelLog SIP/021739250-000002bd|1631091472.769||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:57:52,941] INFO  [AMI NewStateEvent] CallModelLog SIP/021739250-000002bd|1631091472.769||RING|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:57:54,174] INFO  [AMI NewChannelEvent] CallModelLog SIP/021739250-000002be|1631091474.770||DOWN|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:57:54,174] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/021739250-000002be P-Preferred-Identity: "" <sip:+4921731054140@starface.de> 
    [2021-09-08 10:57:54,175] INFO  [AMI DialEvent] CallModelLog SIP/021739250-000002bd|1631091472.769||DIAL_SRC|Rec:false|pstnLineRequested:false ---> SIP/021739250-000002be|1631091474.770||DIAL_TRG|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:57:54,192] INFO  [AMI SipAddHeaderEvent] CallModelLog SIP/021739250-000002be P-Preferred-Identity: "" <sip:+4921731054140@starface.de> 
    [2021-09-08 10:57:55,449] INFO  [AMI NewStateEvent] CallModelLog SIP/021739250-000002be|1631091474.770||RINGING|Rec:false|pstnLineRequested:false 
    [2021-09-08 10:57:58,066] INFO  [AMI PeerStatusEvent] CallModelLog SIP/1170.WinClient Registered 
    [2021-09-08 10:57:58,066] INFO  [AMI PeerStatusEvent] CallModelLog Peer: SIP/1170.WinClient goes online

  3. #3
    STARFACE User

    Registriert seit
    20.11.2018
    Beiträge
    15

    Standard

    full:
    Code:
    [Sep  8 10:50:08] VERBOSE[5543] manager.c:     -- Manager 'actionasterisk' from 127.0.0.1, hanging up channel: SIP/1167.WinClient-000002ad
    [Sep  8 10:50:08] VERBOSE[29294][C-00000170] pbx.c:     -- Executing [h@dialstart:1] NoOp("SIP/1167.WinClient-000002ad", "HC 16") in new stack
    [Sep  8 10:50:08] VERBOSE[29294][C-00000170] pbx.c:     -- Executing [h@dialstart:2] Goto("SIP/1167.WinClient-000002ad", "_exit_,0") in new stack
    [Sep  8 10:50:08] VERBOSE[29294][C-00000170] pbx.c:     -- Goto (dialstart,_exit_,0)
    [Sep  8 10:50:08] VERBOSE[29294][C-00000170] pbx.c:   == Spawn extension (dialstart, +433164291004065, 1) exited non-zero on 'SIP/1167.WinClient-000002ad'
    [Sep  8 10:50:26] VERBOSE[4200][C-00000171] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:50:26] VERBOSE[4200][C-00000171] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:50:26] VERBOSE[4200][C-00000171] res_rtp_asterisk.c:        > 0x7f0774322850 -- Strict RTP learning after remote address set to: 92.60.208.23:32660
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] pbx.c:     -- Executing [+492173925187@0001-incoming:1] Set("SIP/021739250-000002af", "channelname=0001-incoming") in new stack
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] pbx.c:     -- Executing [+492173925187@0001-incoming:2] Set("SIP/021739250-000002af", "lineconfigid=1002") in new stack
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] pbx.c:     -- Executing [+492173925187@0001-incoming:3] Goto("SIP/021739250-000002af", "0001-incoming-manuell,+492173925187,1") in new stack
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] pbx.c:     -- Goto (0001-incoming-manuell,+492173925187,1)
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] pbx.c:     -- Executing [+492173925187@0001-incoming-manuell:1] Goto("SIP/021739250-000002af", "incoming,+492173925187,1") in new stack
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] pbx.c:     -- Goto (incoming,+492173925187,1)
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] pbx.c:     -- Executing [+492173925187@incoming:1] Goto("SIP/021739250-000002af", "calling,### DURCHWAHL ARBEIT ###,1") in new stack
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] pbx.c:     -- Goto (calling,### DURCHWAHL ARBEIT ###,1)
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] pbx.c:     -- Executing [### DURCHWAHL ARBEIT ###@calling:1] GotoIf("SIP/021739250-000002af", "0?4") in new stack
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] pbx.c:     -- Executing [### DURCHWAHL ARBEIT ###@calling:2] AGI("SIP/021739250-000002af", "agi:async,,1002,,,,,,,,,,,,,,") in new stack
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (SIPRemoveHeader) Options: (X-UCI_CALLID)
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (SIPAddHeader) Options: (X-UCI_CALLID:61096f3f-d9c0-4c3e-bc90-286449a041ed)
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(name)=Feldmann)
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(number)=### HANDY PRIVAT ###)
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Dial) Options: (SIP/1040.WinClient,15,wWtT)
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] app_dial.c:     -- Called SIP/1040.WinClient
    [Sep  8 10:50:26] VERBOSE[29471][C-00000171] app_dial.c:     -- SIP/1040.WinClient-000002b0 is ringing
    [Sep  8 10:50:34] VERBOSE[3962] asterisk.c:     -- Remote UNIX connection
    [Sep  8 10:50:34] VERBOSE[29497] asterisk.c:     -- Remote UNIX connection disconnected
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] app_dial.c:     -- Nobody picked up in 15000 ms
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (SIPRemoveHeader) Options: (X-UCI_CALLID)
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (SIPAddHeader) Options: (X-UCI_CALLID:61096f3f-d9c0-4c3e-bc90-286449a041ed)
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(name)=100 : Feldmann)
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(number)=### HANDY PRIVAT ###)
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Dial) Options: (SIP/1040.WinClient,15,wWtT)
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:50:41] VERBOSE[29471][C-00000171] app_dial.c:     -- Called SIP/1040.WinClient
    [Sep  8 10:50:47] WARNING[4200] chan_sip.c: Timeout on 6ea57da01e4033d23fbf44d546e4b904@10.254.3.19:5061 on non-critical invite transaction.
    [Sep  8 10:50:47] WARNING[4200] chan_sip.c: Retransmission timeout reached on transmission 44b12cc046dd3a8c1d3399712f9a4001@10.254.3.19:5061 for seqno 102 (Critical Request) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
    Packet timed out after 6399ms with no response
    [Sep  8 10:50:47] WARNING[4200] chan_sip.c: Hanging up call 44b12cc046dd3a8c1d3399712f9a4001@10.254.3.19:5061 - no reply to our critical packet (see https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions).
    [Sep  8 10:50:47] VERBOSE[29471][C-00000171] app_dial.c:   == Everyone is busy/congested at this time (1:0/0/1)
    [Sep  8 10:50:47] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(name)=100 : Feldmann)
    [Sep  8 10:50:47] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(number)=### HANDY PRIVAT ###)
    [Sep  8 10:50:47] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Dial) Options: (SIP/1023.WinClient,15,wWtT)
    [Sep  8 10:50:47] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:50:47] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:50:47] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:50:47] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:50:47] VERBOSE[29471][C-00000171] app_dial.c:     -- Called SIP/1023.WinClient
    [Sep  8 10:50:48] VERBOSE[29471][C-00000171] app_dial.c:     -- SIP/1023.WinClient-000002b2 is ringing
    [Sep  8 10:51:02] VERBOSE[29471][C-00000171] app_dial.c:     -- Nobody picked up in 15000 ms
    [Sep  8 10:51:03] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(name)=100 : Feldmann)
    [Sep  8 10:51:03] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(number)=### HANDY PRIVAT ###)
    [Sep  8 10:51:03] VERBOSE[29471][C-00000171] res_agi.c:     -- AGI Script Executing Application: (Dial) Options: (SIP/1040.WinClient,15,wWtT)
    [Sep  8 10:51:03] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:51:03] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:51:03] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:51:03] VERBOSE[29471][C-00000171] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:51:03] VERBOSE[29471][C-00000171] app_dial.c:     -- Called SIP/1040.WinClient
    [Sep  8 10:51:08] VERBOSE[29471][C-00000171] pbx.c:   == Spawn extension (calling, ### DURCHWAHL ARBEIT ###, 2) exited non-zero on 'SIP/021739250-000002af'
    [Sep  8 10:51:08] VERBOSE[29471][C-00000171] pbx.c:     -- Executing [h@calling:1] NoOp("SIP/021739250-000002af", "HC 18") in new stack
    [Sep  8 10:51:08] VERBOSE[29471][C-00000171] pbx.c:     -- Executing [h@calling:2] Goto("SIP/021739250-000002af", "_exit_,0") in new stack
    [Sep  8 10:51:08] VERBOSE[29471][C-00000171] pbx.c:     -- Goto (calling,_exit_,0)
    [Sep  8 10:51:10] WARNING[4200] chan_sip.c: Retransmission timeout reached on transmission 493f7e3b028cd95961f14b783f8f152c@10.254.3.19:5061 for seqno 102 (Critical Request) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
    Packet timed out after 6399ms with no response
    [Sep  8 10:51:34] VERBOSE[3962] asterisk.c:     -- Remote UNIX connection
    [Sep  8 10:51:34] VERBOSE[29571] asterisk.c:     -- Remote UNIX connection disconnected
    [Sep  8 10:52:34] VERBOSE[3962] asterisk.c:     -- Remote UNIX connection
    [Sep  8 10:52:34] VERBOSE[29645] asterisk.c:     -- Remote UNIX connection disconnected
    [Sep  8 10:53:13] VERBOSE[29702][C-00000172] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:53:13] VERBOSE[29702][C-00000172] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:53:13] VERBOSE[29702][C-00000172] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:53:13] VERBOSE[29702][C-00000172] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:53:34] VERBOSE[3962] asterisk.c:     -- Remote UNIX connection
    [Sep  8 10:53:34] VERBOSE[29734] asterisk.c:     -- Remote UNIX connection disconnected
    [Sep  8 10:53:35] NOTICE[4200] chan_sip.c: Peer '1040.WinClient' is now UNREACHABLE!  Last qualify: 1
    [Sep  8 10:53:58] VERBOSE[29702][C-00000172] pbx.c:     -- Executing [failed@dialstart:1] NoOp("OutgoingSpoolFailed", "HC 0") in new stack
    [Sep  8 10:53:58] VERBOSE[29702][C-00000172] pbx.c:     -- Executing [failed@dialstart:2] Goto("OutgoingSpoolFailed", "_exit_,0") in new stack
    [Sep  8 10:53:58] VERBOSE[29702][C-00000172] pbx.c:     -- Goto (dialstart,_exit_,0)
    [Sep  8 10:53:58] VERBOSE[29702][C-00000172] pbx.c:     -- Auto fallthrough, channel 'OutgoingSpoolFailed' status is 'UNKNOWN'
    [Sep  8 10:53:58] VERBOSE[29702][C-00000172] pbx.c:     -- Executing [h@dialstart:1] NoOp("OutgoingSpoolFailed", "HC 0") in new stack
    [Sep  8 10:53:58] VERBOSE[29702][C-00000172] pbx.c:     -- Executing [h@dialstart:2] Goto("OutgoingSpoolFailed", "_exit_,0") in new stack
    [Sep  8 10:53:58] VERBOSE[29702][C-00000172] pbx.c:     -- Goto (dialstart,_exit_,0)
    [Sep  8 10:54:01] VERBOSE[28820][C-00000172] res_rtp_asterisk.c:        > 0x7f0758021270 -- Strict RTP learning after remote address set to: 192.168.8.68:10012
    [Sep  8 10:54:01] VERBOSE[28820][C-00000172] res_rtp_asterisk.c:        > 0x7f0758024fb0 -- Strict RTP learning after remote address set to: 192.168.8.68:10014
    [Sep  8 10:54:02] VERBOSE[28820] chan_sip.c:     -- Registered SIP '1040.WinClient' at 192.168.8.68:63296
    [Sep  8 10:54:02] NOTICE[28820] chan_sip.c: Peer '1040.WinClient' is now Reachable. (1ms / 2000ms)
    [Sep  8 10:54:34] VERBOSE[3962] asterisk.c:     -- Remote UNIX connection
    [Sep  8 10:54:34] VERBOSE[29841] asterisk.c:     -- Remote UNIX connection disconnected
    [Sep  8 10:54:42] VERBOSE[29857][C-00000173] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:54:42] VERBOSE[29857][C-00000173] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:54:42] VERBOSE[29857][C-00000173] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:54:42] VERBOSE[29857][C-00000173] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:55:06] NOTICE[4200] chan_sip.c: Peer '1040.WinClient' is now UNREACHABLE!  Last qualify: 1
    [Sep  8 10:55:27] VERBOSE[29857][C-00000173] pbx.c:     -- Executing [failed@dialstart:1] NoOp("OutgoingSpoolFailed", "HC 0") in new stack
    [Sep  8 10:55:27] VERBOSE[29857][C-00000173] pbx.c:     -- Executing [failed@dialstart:2] Goto("OutgoingSpoolFailed", "_exit_,0") in new stack
    [Sep  8 10:55:27] VERBOSE[29857][C-00000173] pbx.c:     -- Goto (dialstart,_exit_,0)
    [Sep  8 10:55:27] VERBOSE[29857][C-00000173] pbx.c:     -- Auto fallthrough, channel 'OutgoingSpoolFailed' status is 'UNKNOWN'
    [Sep  8 10:55:27] VERBOSE[29857][C-00000173] pbx.c:     -- Executing [h@dialstart:1] NoOp("OutgoingSpoolFailed", "HC 0") in new stack
    [Sep  8 10:55:27] VERBOSE[29857][C-00000173] pbx.c:     -- Executing [h@dialstart:2] Goto("OutgoingSpoolFailed", "_exit_,0") in new stack
    [Sep  8 10:55:27] VERBOSE[29857][C-00000173] pbx.c:     -- Goto (dialstart,_exit_,0)
    [Sep  8 10:55:31] VERBOSE[28820][C-00000173] res_rtp_asterisk.c:        > 0x7f076c031440 -- Strict RTP learning after remote address set to: 192.168.8.68:10016
    [Sep  8 10:55:31] VERBOSE[28820][C-00000173] res_rtp_asterisk.c:        > 0x7f076c034f70 -- Strict RTP learning after remote address set to: 192.168.8.68:10018
    [Sep  8 10:55:31] NOTICE[28820] chan_sip.c: Peer '1040.WinClient' is now Reachable. (888ms / 2000ms)
    [Sep  8 10:55:34] VERBOSE[3962] asterisk.c:     -- Remote UNIX connection
    [Sep  8 10:55:34] VERBOSE[29946] asterisk.c:     -- Remote UNIX connection disconnected
    [Sep  8 10:56:12] VERBOSE[4200][C-00000174] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:56:12] VERBOSE[4200][C-00000174] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:56:12] VERBOSE[4200][C-00000174] res_rtp_asterisk.c:        > 0x7f0774322850 -- Strict RTP learning after remote address set to: 92.60.208.23:33016
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] pbx.c:     -- Executing [+492173925187@0001-incoming:1] Set("SIP/021739250-000002b6", "channelname=0001-incoming") in new stack
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] pbx.c:     -- Executing [+492173925187@0001-incoming:2] Set("SIP/021739250-000002b6", "lineconfigid=1002") in new stack
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] pbx.c:     -- Executing [+492173925187@0001-incoming:3] Goto("SIP/021739250-000002b6", "0001-incoming-manuell,+492173925187,1") in new stack
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] pbx.c:     -- Goto (0001-incoming-manuell,+492173925187,1)
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] pbx.c:     -- Executing [+492173925187@0001-incoming-manuell:1] Goto("SIP/021739250-000002b6", "incoming,+492173925187,1") in new stack
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] pbx.c:     -- Goto (incoming,+492173925187,1)
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] pbx.c:     -- Executing [+492173925187@incoming:1] Goto("SIP/021739250-000002b6", "calling,### DURCHWAHL ARBEIT ###,1") in new stack
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] pbx.c:     -- Goto (calling,### DURCHWAHL ARBEIT ###,1)
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] pbx.c:     -- Executing [### DURCHWAHL ARBEIT ###@calling:1] GotoIf("SIP/021739250-000002b6", "0?4") in new stack
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] pbx.c:     -- Executing [### DURCHWAHL ARBEIT ###@calling:2] AGI("SIP/021739250-000002b6", "agi:async,,1002,,,,,,,,,,,,,,") in new stack
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (SIPRemoveHeader) Options: (X-UCI_CALLID)
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (SIPAddHeader) Options: (X-UCI_CALLID:897399a5-4269-40eb-9cdc-9c8e6948385f)
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(name)=Feldmann)
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(number)=### HANDY PRIVAT ###)
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Dial) Options: (SIP/1040.WinClient,15,wWtT)
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:56:12] VERBOSE[29994][C-00000174] app_dial.c:     -- Called SIP/1040.WinClient
    [Sep  8 10:56:13] VERBOSE[29994][C-00000174] app_dial.c:     -- SIP/1040.WinClient-000002b7 is ringing
    [Sep  8 10:56:17] VERBOSE[4200][C-00000175] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:56:17] VERBOSE[4200][C-00000175] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:56:17] VERBOSE[4200][C-00000175] res_rtp_asterisk.c:        > 0x7f077433a5a0 -- Strict RTP learning after remote address set to: 92.60.208.23:33978
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] pbx.c:     -- Executing [+492173925251@0001-incoming:1] Set("SIP/021739250-000002b8", "channelname=0001-incoming") in new stack
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] pbx.c:     -- Executing [+492173925251@0001-incoming:2] Set("SIP/021739250-000002b8", "lineconfigid=1002") in new stack
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] pbx.c:     -- Executing [+492173925251@0001-incoming:3] Goto("SIP/021739250-000002b8", "0001-incoming-manuell,+492173925251,1") in new stack
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] pbx.c:     -- Goto (0001-incoming-manuell,+492173925251,1)
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] pbx.c:     -- Executing [+492173925251@0001-incoming-manuell:1] Goto("SIP/021739250-000002b8", "incoming,+492173925251,1") in new stack
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] pbx.c:     -- Goto (incoming,+492173925251,1)
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] pbx.c:     -- Executing [+492173925251@incoming:1] Goto("SIP/021739250-000002b8", "calling,00492173925251,1") in new stack
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] pbx.c:     -- Goto (calling,00492173925251,1)
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] pbx.c:     -- Executing [00492173925251@calling:1] GotoIf("SIP/021739250-000002b8", "0?4") in new stack
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] pbx.c:     -- Executing [00492173925251@calling:2] AGI("SIP/021739250-000002b8", "agi:async,,1002,,,,,,,,,,,,,,") in new stack
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] res_agi.c:     -- AGI Script Executing Application: (SIPRemoveHeader) Options: (X-UCI_CALLID)
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] res_agi.c:     -- AGI Script Executing Application: (SIPAddHeader) Options: (X-UCI_CALLID:149d6463-cdb7-4fb2-a9e8-9b5f16a4a7ab)
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(name)=Jens Krakow (Goedde))
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(number)=0004922159906170)
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] res_agi.c:     -- AGI Script Executing Application: (Dial) Options: (SIP/1295.WinClient,125,wWtT)
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] app_dial.c:     -- Called SIP/1295.WinClient
    [Sep  8 10:56:17] VERBOSE[30001][C-00000175] app_dial.c:     -- SIP/1295.WinClient-000002b9 is ringing
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] app_dial.c:     -- Nobody picked up in 15000 ms
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (SIPRemoveHeader) Options: (X-UCI_CALLID)
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (SIPAddHeader) Options: (X-UCI_CALLID:897399a5-4269-40eb-9cdc-9c8e6948385f)
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(name)=100 : Feldmann)
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(number)=### HANDY PRIVAT ###)
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Dial) Options: (SIP/1040.WinClient,15,wWtT)
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:56:27] VERBOSE[29994][C-00000174] app_dial.c:     -- Called SIP/1040.WinClient
    [Sep  8 10:56:34] VERBOSE[3962] asterisk.c:     -- Remote UNIX connection
    [Sep  8 10:56:34] VERBOSE[30024] asterisk.c:     -- Remote UNIX connection disconnected
    [Sep  8 10:56:35] NOTICE[4200] chan_sip.c: Peer '1040.WinClient' is now UNREACHABLE!  Last qualify: 888
    [Sep  8 10:56:35] VERBOSE[20250][C-00000175] res_rtp_asterisk.c:        > 0x7f07700c95f0 -- Strict RTP learning after remote address set to: 10.254.4.69:10028
    [Sep  8 10:56:35] VERBOSE[20250][C-00000175] res_rtp_asterisk.c:        > 0x7f07700d0a00 -- Strict RTP learning after remote address set to: 10.254.4.69:10030
    [Sep  8 10:56:35] VERBOSE[30001][C-00000175] app_dial.c:     -- SIP/1295.WinClient-000002b9 answered SIP/021739250-000002b8
    [Sep  8 10:56:35] VERBOSE[30001][C-00000175] res_rtp_asterisk.c:        > 0x7f07700c95f0 -- Strict RTP switching to RTP remote address 10.254.4.69:10028 as source
    [Sep  8 10:56:35] VERBOSE[30001][C-00000175] res_rtp_asterisk.c:        > 0x7f077433a5a0 -- Strict RTP switching to RTP remote address 92.60.208.23:33978 as source
    [Sep  8 10:56:35] VERBOSE[30001][C-00000175] res_rtp_asterisk.c:        > 0x7f077433a5a0 -- Strict RTP learning complete - Locking on source address 92.60.208.23:33978
    [Sep  8 10:56:40] VERBOSE[30001][C-00000175] res_rtp_asterisk.c:        > 0x7f07700c95f0 -- Strict RTP learning complete - Locking on source address 10.254.4.69:10028
    [Sep  8 10:56:42] VERBOSE[29994][C-00000174] app_dial.c:     -- Nobody picked up in 15000 ms
    [Sep  8 10:56:43] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(name)=100 : Feldmann)
    [Sep  8 10:56:43] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(number)=### HANDY PRIVAT ###)
    [Sep  8 10:56:43] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Dial) Options: (SIP/1023.WinClient,15,wWtT)
    [Sep  8 10:56:43] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:56:43] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:56:43] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:56:43] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:56:43] VERBOSE[29994][C-00000174] app_dial.c:     -- Called SIP/1023.WinClient
    [Sep  8 10:56:43] VERBOSE[29994][C-00000174] app_dial.c:     -- SIP/1023.WinClient-000002bb is ringing
    [Sep  8 10:56:58] VERBOSE[29994][C-00000174] app_dial.c:     -- Nobody picked up in 15000 ms
    [Sep  8 10:56:59] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(name)=100 : Feldmann)
    [Sep  8 10:56:59] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Set) Options: (CALLERID(number)=### HANDY PRIVAT ###)
    [Sep  8 10:56:59] VERBOSE[29994][C-00000174] res_agi.c:     -- AGI Script Executing Application: (Dial) Options: (SIP/1023.WinClient,15,wWtT)
    [Sep  8 10:56:59] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP VIDEO TOS bits 136
    [Sep  8 10:56:59] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP VIDEO CoS mark 6
    [Sep  8 10:56:59] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP RTP TOS bits 184
    [Sep  8 10:56:59] VERBOSE[29994][C-00000174] netsock2.c:   == Using SIP RTP CoS mark 5
    [Sep  8 10:56:59] VERBOSE[29994][C-00000174] app_dial.c:     -- Called SIP/1023.WinClient
    [Sep  8 10:56:59] VERBOSE[29994][C-00000174] app_dial.c:     -- SIP/1023.WinClient-000002bc is ringing
    [Sep  8 10:57:09] VERBOSE[28820][C-00000174] res_rtp_asterisk.c:        > 0x7f0774293df0 -- Strict RTP learning after remote address set to: 192.168.8.68:10020
    [Sep  8 10:57:09] VERBOSE[28820][C-00000174] res_rtp_asterisk.c:        > 0x7f07742e2a40 -- Strict RTP learning after remote address set to: 192.168.8.68:10022
    [Sep  8 10:57:13] NOTICE[28820] chan_sip.c: Peer '1040.WinClient' is now Reachable. (1ms / 2000ms)
    [Sep  8 10:57:14] VERBOSE[29994][C-00000174] pbx.c:   == Spawn extension (calling, ### DURCHWAHL ARBEIT ###, 2) exited non-zero on 'SIP/021739250-000002b6'
    [Sep  8 10:57:14] VERBOSE[29994][C-00000174] pbx.c:     -- Executing [h@calling:1] NoOp("SIP/021739250-000002b6", "HC 0") in new stack
    [Sep  8 10:57:14] VERBOSE[29994][C-00000174] pbx.c:     -- Executing [h@calling:2] Goto("SIP/021739250-000002b6", "_exit_,0") in new stack
    [Sep  8 10:57:14] VERBOSE[29994][C-00000174] pbx.c:     -- Goto (calling,_exit_,0)
    [Sep  8 10:57:34] VERBOSE[3962] asterisk.c:     -- Remote UNIX connection

  4. #4
    STARFACE User

    Registriert seit
    20.11.2018
    Beiträge
    15

    Standard

    call-processing:
    Code:
    [2021-09-08 10:50:08,810] INFO  [AMI HangupEvent] CallLeg 7f16f0b6-2826-4aeb-877a-96419e63e564 cleanup 
    [2021-09-08 10:50:08,812] INFO  [AMI HangupEvent] CallLeg c559cb61-3aba-4078-af6d-90c76511416e cleanup 
    [2021-09-08 10:50:41,228] INFO  [AMI HangupEvent] CallLeg 90c2a64e-fe2c-4c0a-a0ec-41debe52a79a cleanup 
    [2021-09-08 10:50:47,690] INFO  [AMI HangupEvent] CallLeg feb550bd-09e1-48ee-b487-09a7d2b1899e cleanup 
    [2021-09-08 10:51:02,893] INFO  [AMI HangupEvent] CallLeg e19dd470-3c4a-4703-acf4-e3c9b9f67ad4 cleanup 
    [2021-09-08 10:51:08,651] INFO  [AMI HangupEvent] CallLeg 5f5bfe3b-97e9-42e7-baa3-9e08f5cb311c cleanup 
    [2021-09-08 10:51:08,657] INFO  [AMI HangupEvent] CallLeg 8e97154a-32dd-42c8-8625-16f2b25d1e4e cleanup 
    [2021-09-08 10:53:58,409] INFO  [AMI HangupEvent] CallLeg 247e17b0-1554-4979-a2ba-40afb0a95fa5 cleanup 
    [2021-09-08 10:55:27,721] INFO  [AMI HangupEvent] CallLeg 6fbdddcc-ce6f-4e02-ae5f-1c5035a6a219 cleanup 
    [2021-09-08 10:56:27,910] INFO  [AMI HangupEvent] CallLeg 0f6070f5-687c-49cb-8a6a-a3f7652d000e cleanup 
    [2021-09-08 10:56:42,985] INFO  [AMI HangupEvent] CallLeg be5ac7c9-6038-48b7-9ced-2d7f8d06cfa3 cleanup 
    [2021-09-08 10:56:58,190] INFO  [AMI HangupEvent] CallLeg 206d9f09-85c5-4cfb-8206-6efbc53af78d cleanup 
    [2021-09-08 10:57:14,096] INFO  [AMI HangupEvent] CallLeg f281b12b-5549-4137-bfe2-73f4fb2ba9f7 cleanup 
    [2021-09-08 10:57:14,099] INFO  [AMI HangupEvent] CallLeg c72710ae-274f-4075-87d1-be6c0eb54e3b cleanup 
    [2021-09-08 10:59:07,816] INFO  [AMI HangupEvent] CallLeg 3b859708-be42-4990-a8c8-84a016484018 cleanup 
    [2021-09-08 10:59:07,819] INFO  [AMI HangupEvent] CallLeg dab5eca5-c250-43b2-b9b5-c670bf5511f6 cleanup

  5. #5
    STARFACE User

    Registriert seit
    20.11.2018
    Beiträge
    15

    Standard

    support:
    Code:
    [2021-09-08 10:50:26,123] [0369] ********* Call created ********* 
    [2021-09-08 10:50:26,123] [0369] Starting call routing : SIP/021739250-000002af|1631091026.753 dial number ### DURCHWAHL ARBEIT ### CallerId   <### HANDY PRIVAT ###> 
    [2021-09-08 10:50:26,124] [0369] Incoming call from line 0001(1002) 
    [2021-09-08 10:50:26,124] [0369] Found extension on line 0001(1002) ### DURCHWAHL ARBEIT ### 
    [2021-09-08 10:50:26,140] [0369] Routing call " Feldmann <### HANDY PRIVAT ###>" to number ### DURCHWAHL ARBEIT ### over service UserService 
    [2021-09-08 10:50:26,140] [0369] CallLeg 8e97154a-32dd-42c8-8625-16f2b25d1e4e 
    [2021-09-08 10:50:26,226] [0369] Dial SIP/021739250-000002af to SIP/1040.WinClient-000002b0 
    [2021-09-08 10:50:26,390] [0369] SIP/1040.WinClient-000002b0 Channelstate is Ringing 
    [2021-09-08 10:50:41,228] [0369] SIP/1040.WinClient-000002b0 Hangup Cause: Normal Clearing 
    [2021-09-08 10:50:41,247] [0369] Got dialstatus DialReturnCodes(hc=NO_ANSWER, ds=NOANSWER, cr=UNKNOWN) 
    [2021-09-08 10:50:41,267] [0369] Forwarding call to 100 TIMEOUT 
    [2021-09-08 10:50:41,269] [0369] Routing call " Feldmann <### HANDY PRIVAT ###>" to number 100 over service CallHuntingService 
    [2021-09-08 10:50:41,269] [0369] CallLeg 8e97154a-32dd-42c8-8625-16f2b25d1e4e 
    [2021-09-08 10:50:41,289] [0369] Dial SIP/021739250-000002af to SIP/1040.WinClient-000002b1 
    [2021-09-08 10:50:47,690] [0369] SIP/1040.WinClient-000002b1 HangupRequestEvent 
    [2021-09-08 10:50:47,690] [0369] SIP/1040.WinClient-000002b1 Hangup Cause: No user responding 
    [2021-09-08 10:50:47,892] [0369] Dial SIP/021739250-000002af to SIP/1023.WinClient-000002b2 
    [2021-09-08 10:50:48,007] [0369] SIP/1023.WinClient-000002b2 Channelstate is Ringing 
    [2021-09-08 10:51:02,892] [0369] SIP/1023.WinClient-000002b2 Hangup Cause: Normal Clearing 
    [2021-09-08 10:51:03,925] [0369] Dial SIP/021739250-000002af to SIP/1040.WinClient-000002b3 
    [2021-09-08 10:51:08,650] [0369] SIP/021739250-000002af HangupRequestEvent 
    [2021-09-08 10:51:08,651] [0369] SIP/1040.WinClient-000002b3 Hangup Cause: null 
    [2021-09-08 10:51:08,656] [0369] SIP/021739250-000002af Hangup Cause: No user responding 
    [2021-09-08 10:51:08,657] [0369] ********* Call finished ********* 
    [2021-09-08 10:53:13,367] [0370] ********* Call created ********* 
    [2021-09-08 10:53:58,409] [0370] SIP/1040.WinClient-000002b4 Hangup Cause: Normal Clearing 
    [2021-09-08 10:53:58,410] [0370] ********* Call finished ********* 
    [2021-09-08 10:54:42,676] [0371] ********* Call created ********* 
    [2021-09-08 10:55:27,721] [0371] SIP/1040.WinClient-000002b5 Hangup Cause: Normal Clearing 
    [2021-09-08 10:55:27,723] [0371] ********* Call finished ********* 
    [2021-09-08 10:56:12,804] [0372] ********* Call created ********* 
    [2021-09-08 10:56:12,804] [0372] Starting call routing : SIP/021739250-000002b6|1631091372.762 dial number ### DURCHWAHL ARBEIT ### CallerId   <### HANDY PRIVAT ###> 
    [2021-09-08 10:56:12,805] [0372] Incoming call from line 0001(1002) 
    [2021-09-08 10:56:12,805] [0372] Found extension on line 0001(1002) ### DURCHWAHL ARBEIT ### 
    [2021-09-08 10:56:12,822] [0372] Routing call " Feldmann <### HANDY PRIVAT ###>" to number ### DURCHWAHL ARBEIT ### over service UserService 
    [2021-09-08 10:56:12,822] [0372] CallLeg c72710ae-274f-4075-87d1-be6c0eb54e3b 
    [2021-09-08 10:56:12,910] [0372] Dial SIP/021739250-000002b6 to SIP/1040.WinClient-000002b7 
    [2021-09-08 10:56:13,069] [0372] SIP/1040.WinClient-000002b7 Channelstate is Ringing 
    [2021-09-08 10:56:17,639] [0373] ********* Call created ********* 
    [2021-09-08 10:56:17,639] [0373] Starting call routing : SIP/021739250-000002b8|1631091377.764 dial number 00492173925251 CallerId   <004922159906170> 
    [2021-09-08 10:56:17,640] [0373] Incoming call from line 0001(1002) 
    [2021-09-08 10:56:17,640] [0373] Found extension on line 0001(1002) 00492173925251 
    [2021-09-08 10:56:17,651] [0373] Routing call "Jens Krakow (Gödde) <004922159906170>" to number 00492173925251 over service UserService 
    [2021-09-08 10:56:17,651] [0373] CallLeg be1cc5ea-7d70-4617-a061-cc13ad5197b1 
    [2021-09-08 10:56:17,740] [0373] Dial SIP/021739250-000002b8 to SIP/1295.WinClient-000002b9 
    [2021-09-08 10:56:17,940] [0373] SIP/1295.WinClient-000002b9 Channelstate is Ringing 
    [2021-09-08 10:56:27,910] [0372] SIP/1040.WinClient-000002b7 Hangup Cause: Normal Clearing 
    [2021-09-08 10:56:27,927] [0372] Got dialstatus DialReturnCodes(hc=NO_ANSWER, ds=NOANSWER, cr=UNKNOWN) 
    [2021-09-08 10:56:27,947] [0372] Forwarding call to 100 TIMEOUT 
    [2021-09-08 10:56:27,948] [0372] Routing call " Feldmann <### HANDY PRIVAT ###>" to number 100 over service CallHuntingService 
    [2021-09-08 10:56:27,948] [0372] CallLeg c72710ae-274f-4075-87d1-be6c0eb54e3b 
    [2021-09-08 10:56:27,969] [0372] Dial SIP/021739250-000002b6 to SIP/1040.WinClient-000002ba 
    [2021-09-08 10:56:35,676] [0373] SIP/1295.WinClient-000002b9 Channelstate is Up 
    [2021-09-08 10:56:35,677] [0373] SIP/021739250-000002b8 Channelstate is Up 
    [2021-09-08 10:56:35,678] [0373] SIP/1295.WinClient-000002b9 Link SIP/021739250-000002b8 
    [2021-09-08 10:56:42,985] [0372] SIP/1040.WinClient-000002ba Hangup Cause: null 
    [2021-09-08 10:56:43,189] [0372] Dial SIP/021739250-000002b6 to SIP/1023.WinClient-000002bb 
    [2021-09-08 10:56:43,304] [0372] SIP/1023.WinClient-000002bb Channelstate is Ringing 
    [2021-09-08 10:56:58,190] [0372] SIP/1023.WinClient-000002bb Hangup Cause: Normal Clearing 
    [2021-09-08 10:56:59,225] [0372] Dial SIP/021739250-000002b6 to SIP/1023.WinClient-000002bc 
    [2021-09-08 10:56:59,401] [0372] SIP/1023.WinClient-000002bc Channelstate is Ringing 
    [2021-09-08 10:57:14,095] [0372] SIP/021739250-000002b6 HangupRequestEvent 
    [2021-09-08 10:57:14,096] [0372] SIP/1023.WinClient-000002bc Hangup Cause: Normal Clearing 
    [2021-09-08 10:57:14,098] [0372] SIP/021739250-000002b6 Hangup Cause: null 
    [2021-09-08 10:57:14,099] [0372] ********* Call finished *********

  6. #6
    STARFACE Expert

    Registriert seit
    11.05.2018
    Beiträge
    404

    Standard

    Telefone und/oder Softphones sind im selben Subnetz wie die Telefonanlage?
    Welche Adresse (interne/externe) wird bei der Provisionierung in die Telefone geschrieben?
    Viele Grüße
    Rouven

  7. #7
    STARFACE Expert
    Benutzerbild von FabianZ
    Registriert seit
    11.12.2012
    Ort
    9450 Altstätten
    Beiträge
    2.114

    Standard

    Hallo cpa

    Etwas was mich in den Logs stört, ist wie oft der UCC-Client sich neu an der STARFACE anmeldet.
    Hat er zwischen den Testanrufen den Client komplett beendet und wieder gestartet?

    Wenn nein, scheint irgendetwas Agressiv den Port 5060 zu schliessen.

    MfG

    Fabian
    SI-Solutions GmbH
    STARFACE Modul-Entwickler | STARFACE Excellence Partner
    Modul-Downloads | Wiki | Shop

  8. #8
    STARFACE User

    Registriert seit
    20.11.2018
    Beiträge
    15

    Standard

    Zitat Zitat von FabianZ Beitrag anzeigen
    Etwas was mich in den Logs stört, ist wie oft der UCC-Client sich neu an der STARFACE anmeldet.
    Hat er zwischen den Testanrufen den Client komplett beendet und wieder gestartet?
    Nein das ist nicht der Fall.

    Zitat Zitat von FabianZ Beitrag anzeigen
    Wenn nein, scheint irgendetwas Aggressiv den Port 5060 zu schließen.
    Die Ports 5060 sowie 5061 sind auf der Firewall freigegeben, dies konnte ich mittels Telnet erfolgreich testen.
    (z.B. Telnet 10.254.3.19 5060)

    Zitat Zitat von RH_BK Beitrag anzeigen
    Telefone und/oder Softphones sind im selben Subnetz wie die Telefonanlage?
    Nein der UCC Client und die Starface Telefonanlage sind nicht im selben Subnetz.

    Zitat Zitat von RH_BK Beitrag anzeigen
    Welche Adresse (interne/externe) wird bei der Provisionierung in die Telefone geschrieben?
    Was den für eine Adresse?

  9. #9
    STARFACE Expert

    Registriert seit
    11.05.2018
    Beiträge
    404

    Standard

    Zitat Zitat von cpa Beitrag anzeigen
    Nein der UCC Client und die Starface Telefonanlage sind nicht im selben Subnetz.
    Kann es sein, dass eure Firewall zwischen den Subnetzen noch Ports zu hat und die Anbindung deswegen nicht sauber funktioniert?

    Was den für eine Adresse?
    tel.PNG

    Je nach dem was hier bei dir ausgewählt ist und wie eure Firewall arbeitet, kann es dazu führen, dass eure internen Telefone so behandelt werden, als ob sie von extern zugreifen.
    Und für den externen Zugriff fehlen laut deiner Grafik Portfreigaben bzw. -weiterleitungen.

    /edit: du kannst auch mal in eines deiner Telefone schauen, sieht man auch welche Adresse (Verwendete Serveradresse) provisioniert wurde
    Viele Grüße
    Rouven

  10. #10
    STARFACE User

    Registriert seit
    20.11.2018
    Beiträge
    15

    Standard

    Zitat Zitat von RH_BK Beitrag anzeigen
    Kann es sein, dass eure Firewall zwischen den Subnetzen noch Ports zu hat und die Anbindung deswegen nicht sauber funktioniert?
    Möglicherweise. Welche Ports neben 80, 443, 5060 und 5061 soll ich denn noch testen?

    Zitat Zitat von RH_BK Beitrag anzeigen
    tel.PNG
    Je nach dem was hier bei dir ausgewählt ist und wie eure Firewall arbeitet, kann es dazu führen, dass eure internen Telefone so behandelt werden, als ob sie von extern zugreifen.
    Und für den externen Zugriff fehlen laut deiner Grafik Portfreigaben bzw. -Weiterleitungen.
    Ja, welche Ports fehlen denn deiner Meinung nach neben Ausgehend 5060, 5061 5039, 1025-65535 und eingehend 5060, 5061, 5039, 10000-20000?

    Zitat Zitat von RH_BK Beitrag anzeigen
    /edit: du kannst auch mal in eines deiner Telefone schauen, sieht man auch welche Adresse (Verwendete Serveradresse) provisioniert wurde
    Die Verwendete Serveraddresse ist Local (nicht Extern) 10.254.3.19.

  11. #11
    STARFACE Expert

    Registriert seit
    11.05.2018
    Beiträge
    404

    Standard

    Zitat Zitat von cpa Beitrag anzeigen
    Möglicherweise. Welche Ports neben 80, 443, 5060 und 5061 soll ich denn noch testen?
    Wenn die Firewall intern die restlichen Ports zu macht, dann fehlen TCP 5222, TCP 50080, TCP 50081 sowie sämtliche UDP Ports, über die die Sprache läuft.
    Viele Grüße
    Rouven

  12. #12
    STARFACE User

    Registriert seit
    20.11.2018
    Beiträge
    15

    Standard

    Zitat Zitat von RH_BK Beitrag anzeigen
    Wenn die Firewall intern die restlichen Ports zu macht, dann fehlen TCP 5222, TCP 50080, TCP 50081 sowie sämtliche UDP Ports, über die die Sprache läuft.
    Die Sprache läuft doch über RTP also Eingehend 10000-20000 und Ausgehend 1025-65535 oder Irre ich mich da? So ist es jedenfalls in der Starface Doku beschrieben.
    https://knowledge.starface.de/pages/...ageId=46564693
    Und 5222 ist doch nur XMPP, soweit ich weiß ist das nur für die Chatfunktion die sowieso nicht genutzt wird und auch nicht benötigt wird.
    50080 und 50081 sind nur für die Provisionierung, müssen Softclients wie z.B. der Starface UCC Client Provisioniert werden?

    P.S.: Ich habe eben eine neue Information bekommen. Intern hängt gar keine Firewall zwischen den Netzen also zwischen dem PBX Server und den Softphones.
    Nur nach extern ist jetzt eine Firewall dazwischen.
    Die Ports für die Auto Provisionierung sind also Frei auch wenn diese meiner Meinung nach gar nicht benötigt werden.
    Geändert von cpa (09.09.2021 um 12:01 Uhr)

  13. #13
    STARFACE Crew

    Registriert seit
    02.03.2018
    Ort
    Karlsruhe
    Beiträge
    67

    Standard

    Die UCI für die Remote Procedure Calls nutzt auch XMPP (XML-RPC über XMPP. Ob das der gleiche Port ist, da bin ich mir nicht sicher). Das ist der wichtigste und meistgenutzte Weg der Apps Daten mit dem Server auszutauschen.

    // edit: Dürfte Port 5223 sein.
    Geändert von Aaron (09.09.2021 um 12:13 Uhr)

  14. #14
    STARFACE User

    Registriert seit
    20.11.2018
    Beiträge
    15

    Standard

    Zitat Zitat von Aaron Beitrag anzeigen
    Die UCI für die Remote Procedure Calls nutzt auch XMPP
    Was genau bedeutet dass denn? Welche Funktionalitäten werden damit abgedeckt? Was genau sind Remote Procedure Calls bzw was für Daten werden auf diesem Weg zwischen Apps und Server ausgetauscht?

    Zitat Zitat von Aaron Beitrag anzeigen
    // edit: Dürfte Port 5223 sein.
    Also da wie gesagt intern gar keine Firewall zwischen den Netzen hängt, konnte ich gerade erfolgreich testen das Folgende Ports auf PBX Seite offen und aus dem Softphones netz erreichbar sind.
    80,443,5060,5061,5222,5223,50080,50081
    Geändert von cpa (09.09.2021 um 12:23 Uhr)

  15. #15
    STARFACE Expert

    Registriert seit
    11.05.2018
    Beiträge
    404

    Standard

    Zitat Zitat von cpa Beitrag anzeigen
    Die Sprache läuft doch über RTP also Eingehend 10000-20000 und Ausgehend 1025-65535 oder Irre ich mich da?
    RTP basiert auf UDP (normalerweise). Du kannst also das UDP auch gerne durch RTP ersetzen, scheint aber ja nicht das Problem zu sein, wenn keine Firewall dazwischen hängt.
    Ganz einfach ausschließen kannst du das aber, wenn du dir einfach mal einen UCC Client in das Netz der TK hängst und schaust ob es einen Unterschied macht.
    Viele Grüße
    Rouven

Ähnliche Themen

  1. Starface v6 Macros können nicht mehr als Regel ausgewählt werden
    Von netways im Forum STARFACE Einrichtung & Administration
    Antworten: 8
    Letzter Beitrag: 23.06.2015, 08:32
  2. IFMC: Anrufe können teilweise nicht angenommen werden oder brechen ab
    Von _Jochen im Forum STARFACE Einrichtung & Administration
    Antworten: 14
    Letzter Beitrag: 12.02.2015, 11:30
  3. Antworten: 2
    Letzter Beitrag: 28.07.2011, 07:24
  4. Antworten: 6
    Letzter Beitrag: 13.10.2007, 10:35
  5. * und # werden nicht angenommen
    Von lordmike1503 im Forum Bugreports
    Antworten: 2
    Letzter Beitrag: 14.08.2007, 17:48

Stichworte

Lesezeichen

Forumregeln

  • Es ist Ihnen nicht erlaubt, neue Themen zu verfassen.
  • Es ist Ihnen nicht erlaubt, auf Beiträge zu antworten.
  • Es ist Ihnen nicht erlaubt, Anhänge hochzuladen.
  • Es ist Ihnen nicht erlaubt, Ihre Beiträge zu bearbeiten.
  •