Αποστολή fax με Grandstream 702

**englishman** · 12-05-15, 21:29

Αγόρασα το Grandstream 702 ATA, το οποίο υποστηρίζει Τ.38 για αποστολή/λήψη fax. Το έκανα configure με τις ρυθμίσεις της Viva και πράγματι μπορώ να πραγματοποιήσω κλήσεις φωνής χωρίς κανένα πρόβλημα.

Εκεί που τα πράγματα είναι ακόμα δύσκολο να δουλέψουν είναι όταν συνδέσω fax πάνω στο ATA (το fax δυστυχώς μου είναι απαραίτητο να υπάρχει σαν ξεχωριστό αναλογικό μηχάνημα). Τόσο το Grandstream όσο και η Viva υποστηρίζουν το Τ.38 codec, το οποίο είναι συγκεκριμένα για fax over IP transmission. Ωστόσο, όταν προσπαθήσω να στείλω ένα fax και το μηχάνημα "ανοίξει" την γραμμή, το dial tone κλπ από το modem του fax ακούγεται εξαιρετικά "βραχνό" με πολλά παράσιτα, και το μηχάνημα δεν προσπαθεί καν να κάνει dial!

Δοκίμασα να παίξω λίγο με τα settings του Grandstream 702 αλλά ομολογώ ότι δεν γνωρίζω ιδιάιτερα πολλά, πέραν του να είναι ενεργοποιημένο το T.38. Επίσης, κατόπιν ψαξίματος online δοκίμασα να κατεβάσω το baud rate του fax στα 9600, και να απενεργοποιήσω το ECM, χωρίς όμως αποτέλεσμα.

Θα μπορούσε κάποιος να με καθοδηγήσει για το παραπάνω; Υπάρχει κάποιος τρόπος να κάνω "enforce" το Τ.38, ή κάποια άλλη ρύθμιση που μου διαφεύγει?

**dimangelid** · 13-05-15, 08:16

Αρχικό μήνυμα από englishman

Αγόρασα το Grandstream 702 ATA, το οποίο υποστηρίζει Τ.38 για αποστολή/λήψη fax. Το έκανα configure με τις ρυθμίσεις της Viva και πράγματι μπορώ να πραγματοποιήσω κλήσεις φωνής χωρίς κανένα πρόβλημα.

Εκεί που τα πράγματα είναι ακόμα δύσκολο να δουλέψουν είναι όταν συνδέσω fax πάνω στο ATA (το fax δυστυχώς μου είναι απαραίτητο να υπάρχει σαν ξεχωριστό αναλογικό μηχάνημα). Τόσο το Grandstream όσο και η Viva υποστηρίζουν το Τ.38 codec, το οποίο είναι συγκεκριμένα για fax over IP transmission. Ωστόσο, όταν προσπαθήσω να στείλω ένα fax και το μηχάνημα "ανοίξει" την γραμμή, το dial tone κλπ από το modem του fax ακούγεται εξαιρετικά "βραχνό" με πολλά παράσιτα, και το μηχάνημα δεν προσπαθεί καν να κάνει dial!

Δοκίμασα να παίξω λίγο με τα settings του Grandstream 702 αλλά ομολογώ ότι δεν γνωρίζω ιδιάιτερα πολλά, πέραν του να είναι ενεργοποιημένο το T.38. Επίσης, κατόπιν ψαξίματος online δοκίμασα να κατεβάσω το baud rate του fax στα 9600, και να απενεργοποιήσω το ECM, χωρίς όμως αποτέλεσμα.

Θα μπορούσε κάποιος να με καθοδηγήσει για το παραπάνω; Υπάρχει κάποιος τρόπος να κάνω "enforce" το Τ.38, ή κάποια άλλη ρύθμιση που μου διαφεύγει?

Το μόνο που έχω δοκιμάσει είναι να στείλω και να λάβω fax μέσω γραμμής ΟΤΕ ISDN, φυσικής συσκευής fax και Linksys PAP2. Έπαιζε για πολλά χρόνια σε γραφείο χωρίς προβλήματα. Με καθαρό VoIP δεν γνωρίζω, αλλά σε γενικές γραμμές είναι δύσκολο αυτό που προσπαθείς να κάνεις, παρ' όλο που θεωρητικά θα έπρεπε να δουλέψει καθώς το T.38 είναι για Fax over IP. Ρίξε λίγο μια ματιά στο forum, έχουν αναφερθεί διάφορα κατά καιρούς για το θέμα σου, και περίμενε μήπως απαντήσει κάποιος που γνωρίζει κάτι παραπάνω

**englishman** · 14-05-15, 01:01

Έκανα μία κάποια πρόοδο, κάνοντας configure τα σωστά tones για τα στάδια μιας κλήσης. Τώρα συμβαίνει το εξής!

Το φαξ πάλι ανοίγει την γραμμή κανονικά, κάνει dial, αλλά απο εκεί και πέρα δεν έχει κάποια απόκριση. Φαίνεται ότι το ΑΤΑ δεν αναγνωρίζει ότι το φαξ έκανε dial έναν αριθμό, και "περιμένει". Παρ'ολα αυτά, με το που γίνει dial το πρώτο ψηφίο, το dial tone του ΑΤΑ σταματάει, και εν τέλει κάνει time out (αφού δεν αναγνωρίζει ότι η συσκευή έκανε dial), με αποτέλεσμα να κάνει time out με τον γνωστό ήχο "βουίσματος".

Εάν συνδέσω το φαξ σε απλή γραμμή pstn τότε δεν υπάρχει κανένα πρόβλημα. Επιπλέον, το remote fax στο οποίο στέλνω λειτουργεί κανονικά, αφού ακόμα και αν το καλέσω από μία απλή γραμμή, απαντάει στο πρώτο ring και ξεκινάει το training.

Ανέβασα εδώ ένα πλήρες export του configuration -- θα ήμουν ευγνώμων σε όποιον μπορεί να ρίξει μία ματιά να δει τι μου έχει ξεφύγει!

**dimangelid** · 14-05-15, 12:22

Αρχικό μήνυμα από englishman

Έκανα μία κάποια πρόοδο, κάνοντας configure τα σωστά tones για τα στάδια μιας κλήσης. Τώρα συμβαίνει το εξής!

Το φαξ πάλι ανοίγει την γραμμή κανονικά, κάνει dial, αλλά απο εκεί και πέρα δεν έχει κάποια απόκριση. Φαίνεται ότι το ΑΤΑ δεν αναγνωρίζει ότι το φαξ έκανε dial έναν αριθμό, και "περιμένει". Παρ'ολα αυτά, με το που γίνει dial το πρώτο ψηφίο, το dial tone του ΑΤΑ σταματάει, και εν τέλει κάνει time out (αφού δεν αναγνωρίζει ότι η συσκευή έκανε dial), με αποτέλεσμα να κάνει time out με τον γνωστό ήχο "βουίσματος".

Εάν συνδέσω το φαξ σε απλή γραμμή pstn τότε δεν υπάρχει κανένα πρόβλημα. Επιπλέον, το remote fax στο οποίο στέλνω λειτουργεί κανονικά, αφού ακόμα και αν το καλέσω από μία απλή γραμμή, απαντάει στο πρώτο ring και ξεκινάει το training.

Ανέβασα εδώ ένα πλήρες export του configuration -- θα ήμουν ευγνώμων σε όποιον μπορεί να ρίξει μία ματιά να δει τι μου έχει ξεφύγει!

Αν δεν μπορεί να ολοκληρώσει την κλήση, δοκίμασε πρώτα να βάλεις μια απλή συσκευή στο Grandstream να δεις τι κάνει αυτή. Το πιθανότερο βέβαια είναι ότι απλά δεν καταλαβαίνει ότι έχει τελειώσει η πληκτρολόγηση γιατί δεν έχει ελληνικό dial plan. Δοκίμασε στο τέλος του αριθμού να βάλεις # η οποία συνήθως λέει στα μηχανήματα να καλέσουν αμέσως ότι αριθμό Πληκτρολόγησε ο χρήστης.

**englishman** · 14-05-15, 19:58

Δοκίμασα να βάλω # στο τέλος του αριθμού, αλλά δεν άλλαξε τίποτα. Επίσης, αν συνδέσω απλή αναλογική συσκευή στο Grandstream, μπορώ να πραγματοποιήσω κλήσεις κανονικά χωρίς κανένα πρόβλημα. Επίσης, έχω ρυθμίσει το Grandstream να έχει το γενικό dial plan { x+ | *x+ }, για να μπορεί να δεχθεί οποιονδήποτε συνδυασμό αριθμών χωρίς περιορισμούς.

Εδώ ανέβασα ένα syslog export του Grandstream από μία (αποτυχημένη) αποστολή fax. Ίσως βοηθήσει κάποιον που ξέρει να το διαβάζει ολοκληρωμένα.

**_alx_** · 15-05-15, 11:23

Κάνε save as την σελίδα με τις ρυθμίσεις του fxs και ανέβασε το κάπου να ρίξουμε μια ματιά.

**englishman** · 16-05-15, 01:29

Μετά από αρκετό ψάξιμο, κατάφερα να κάνω τις σωστές αλλαγές για να ολοκληρωθεί η κλήση. Άλλαξα το dial plan και το SLIC Setting. Επίσης, αρκετές πηγές σε διάφορα fora συμβούλευαν να χρησιμοποιήσω 2-συρματο (και οχι 4-σύρματο) τηλεφωνικό καλώδιο RJ-11. Εν τέλει, όπως είπα, κατάφερα να κάνω σωστά την κλήση και να απαντήσει το άλλο φαξ.

Το θέμα είναι τώρα στο transmission...δεν ολοκληρώνεται σχεδόν καμία αποστολή φαξ. Σίγουρα είναι θέμα κάποιας ρύθμισης, καθώς βλέπω από τα logs ότι κάνει switch κανονικά σε Τ.38, αλλά δεν ολοκληρώνει την αποστολή.

Παρακάτω παραθέτω ένα log μίας αποτυχημένης αποστολής φαξ:

Spoiler:

Κώδικας:

2015-05-15 14:29:03	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:29:14	Syslog.Info	192.168.1.11	Keep-alive message
2015-05-15 14:29:18	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:29:33	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:29:39	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:System uptime: 3726
2015-05-15 14:29:39	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:System memory: 13205504/811008/0/729088
2015-05-15 14:29:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:30:03	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:30:09	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::performRegistration on acct 0, registered: 1, proxy: voip.viva.gr, preferPrimary: 0
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::snd_message:(822)REGISTER sip:voip.viva.gr SIP/2.0  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1695562444;rport  Route: <sip:voip.viv
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:a.gr:5060;lr>  From: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1305305112  To: <sip:302118002985@voip.viva.gr>  Call-ID: 1981096903-28555-2@BJC.B
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GI.B.BB  CSeq: 2038 REGISTER  Contact: <sip:302118002985@192.168.1.11:28555>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-1000-8000-000B823D5C66>" 
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]: Authorization: Digest username="302118002985", realm="viva.gr", nonce="5555d7fa00003cd08ed13ccb732e0c735f61c83421544ca8", uri="sip:voip.viva.gr", res
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ponse="baf313ede95ee809fe25ab1d63764e9b", algorithm=MD5  Max-Forwards: 70  User-Agent: Grandstream HT702 1.0.7.3  Supported: path  Expires: 3600  Allo
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:w: INVITE, ACK, OPTIONS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE  Content-Length: 0    
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: setNetworkConnected
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: Last good IP Addr:0.0.0.0
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPClientTransaction::sendRequest: Request 73 is sent
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::receiveMessage:(459)SIP/2.0 401 Unauthorized  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1695562444;rport=28555  From: "Englesos" <si
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:p:302118002985@voip.viva.gr>;tag=1305305112  To: <sip:302118002985@voip.viva.gr>;tag=ae428d0fc435bd570aaae338d70dfd1f.488a  Call-ID: 1981096903-28555-
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:2@BJC.BGI.B.BB  CSeq: 2038 REGISTER  WWW-Authenticate: Digest realm="viva.gr", nonce="5555d8ea00007bc914fa2b88f0d0bf87ca9237127503247c", stale=true  S
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:erver: Viva VoIP  Content-Length: 0    
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 0, server= voip.viva.gr:5060, failover= voip.viva.gr:5060, outboundproxy= voip.viva.gr:5060
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 1, server= NULL:5060, failover= NULL:5060, outboundproxy= NULL:5060
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_rcv4xx: Received 401 response for transaction 73(REGISTER)
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPTransaction::waitForResponse: Request 73 got status code 401
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::snd_message:(822)REGISTER sip:voip.viva.gr SIP/2.0  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1723520214;rport  Route: <sip:voip.viv
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:a.gr:5060;lr>  From: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1305305112  To: <sip:302118002985@voip.viva.gr>  Call-ID: 1981096903-28555-2@BJC.B
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GI.B.BB  CSeq: 2039 REGISTER  Contact: <sip:302118002985@192.168.1.11:28555>;reg-id=1;+sip.instance="<urn:uuid:00000000-0000-1000-8000-000B823D5C66>" 
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]: Authorization: Digest username="302118002985", realm="viva.gr", nonce="5555d8ea00007bc914fa2b88f0d0bf87ca9237127503247c", uri="sip:voip.viva.gr", res
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ponse="e47747456009ed8644351e55a68117fc", algorithm=MD5  Max-Forwards: 70  User-Agent: Grandstream HT702 1.0.7.3  Supported: path  Expires: 3600  Allo
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:w: INVITE, ACK, OPTIONS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE  Content-Length: 0    
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: setNetworkConnected
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: Last good IP Addr:0.0.0.0
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 3
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::receiveMessage:(446)SIP/2.0 200 OK  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1723520214;rport=28555  From: "Englesos" <sip:30211800
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:2985@voip.viva.gr>;tag=1305305112  To: <sip:302118002985@voip.viva.gr>;tag=ae428d0fc435bd570aaae338d70dfd1f.fd6a  Call-ID: 1981096903-28555-2@BJC.BGI.
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:B.BB  CSeq: 2039 REGISTER  Contact: <sip:302118002985@2.86.129.167:5060>;expires=90, <sip:302118002985@192.168.1.11:28555>;expires=480  Server: Viva V
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:oIP  Content-Length: 0    
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 0, server= voip.viva.gr:5060, failover= voip.viva.gr:5060, outboundproxy= voip.viva.gr:5060
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 1, server= NULL:5060, failover= NULL:5060, outboundproxy= NULL:5060
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_rcv2xx: Received 200 response for transaction 74(REGISTER)
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 3
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPTransaction::waitForResponse: Request 74 got status code 200
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::performRegistration, transaction got code 0:200
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::performRegistration, regRetries:0, retryAfter:0, regRetryWait:1
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 31 (SIG_REGISTERED) on port -1:-1
2015-05-15 14:30:10	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::processSigRegistered, Account 0 Registered, tried 0; Next reg in 240 seconds (3996) on voip.viva.gr
2015-05-15 14:30:15	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_nict_kill_transaction: Kill NICT transaction 73
2015-05-15 14:30:15	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:30:15	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_nict_kill_transaction: Kill NICT transaction 74
2015-05-15 14:30:15	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:30:15	Syslog.Info	192.168.1.11	Keep-alive message
2015-05-15 14:30:30	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:30:43	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 5 (PHONE_OFF_HOOK) on port 0:0
2015-05-15 14:30:43	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneOffHook on port 0:0, status = CALL_IDLE/CALL_IDLE, reg'd:1, allow calls w/o reg:0 ,sigReferred:0
2015-05-15 14:30:43	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::playDialTone, port 0, reg'd 1, vm 0, enDial W/O Reg 0
2015-05-15 14:30:43	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::stopTone, Stop tone on port 0, direction 0
2015-05-15 14:30:43	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::playTone, Play tone 34 on port 0, direction 1
2015-05-15 14:30:43	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Phone at port 0 is off-hook
2015-05-15 14:30:45	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 146 92  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_DIGIT rev 
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 for EP 1 
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::DTMF_DIGIT event received on port 0:0, digit 2, mapped to 2, local 1, network 0
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 7 (PHONE_DIALING) on port 0:0
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneDialing on port 0:0, status = CALL_IDLE/CALL_IDLE ,sigReferred:0
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::registerEventListener: listener Call
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::init, DialPlan callFeatureFlag = 0x0
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::Call, Creating Call object 9 at port 0:0, caller 1
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::stopTone, Stop tone on port 0, direction 0
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlanSeg::match: match [0-9]+$
2015-05-15 14:30:46	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::dialPlanEngine, DialPlanStatus: 0x4 2 line: 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 143 8f  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_OFF evt 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 145 91  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_DIGIT rev 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 for EP 1 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::DTMF_DIGIT event received on port 0:0, digit 1, mapped to 1, local 1, network 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 7 (PHONE_DIALING) on port 0:0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneDialing on port 0:0, status = CALL_DIALING/CALL_IDLE ,sigReferred:0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlanSeg::match: match [0-9]+$
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::dialPlanEngine, DialPlanStatus: 0x4 21 line: 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 143 8f  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_OFF evt 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 144 90  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_DIGIT rev 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 for EP 1 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::DTMF_DIGIT event received on port 0:0, digit 0, mapped to 0, local 1, network 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 7 (PHONE_DIALING) on port 0:0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneDialing on port 0:0, status = CALL_DIALING/CALL_IDLE ,sigReferred:0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlanSeg::match: match [0-9]+$
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::dialPlanEngine, DialPlanStatus: 0x4 210 line: 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 143 8f  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_OFF evt 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 151 97  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_DIGIT rev 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 for EP 1 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::DTMF_DIGIT event received on port 0:0, digit 7, mapped to 7, local 1, network 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 7 (PHONE_DIALING) on port 0:0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneDialing on port 0:0, status = CALL_DIALING/CALL_IDLE ,sigReferred:0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlanSeg::match: match [0-9]+$
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::dialPlanEngine, DialPlanStatus: 0x4 2107 line: 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 143 8f  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_OFF evt 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 151 97  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_DIGIT rev 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 for EP 1 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::DTMF_DIGIT event received on port 0:0, digit 7, mapped to 7, local 1, network 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 7 (PHONE_DIALING) on port 0:0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneDialing on port 0:0, status = CALL_DIALING/CALL_IDLE ,sigReferred:0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlanSeg::match: match [0-9]+$
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::dialPlanEngine, DialPlanStatus: 0x4 21077 line: 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 143 8f  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_OFF evt 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 150 96  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_DIGIT rev 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 for EP 1 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::DTMF_DIGIT event received on port 0:0, digit 6, mapped to 6, local 1, network 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 7 (PHONE_DIALING) on port 0:0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneDialing on port 0:0, status = CALL_DIALING/CALL_IDLE ,sigReferred:0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlanSeg::match: match [0-9]+$
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::dialPlanEngine, DialPlanStatus: 0x4 210776 line: 0
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 143 8f  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_OFF evt 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 
2015-05-15 14:30:47	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 144 90  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_DIGIT rev 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 for EP 1 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::DTMF_DIGIT event received on port 0:0, digit 0, mapped to 0, local 1, network 0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 7 (PHONE_DIALING) on port 0:0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneDialing on port 0:0, status = CALL_DIALING/CALL_IDLE ,sigReferred:0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlanSeg::match: match [0-9]+$
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::dialPlanEngine, DialPlanStatus: 0x4 2107760 line: 0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 143 8f  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_OFF evt 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 152 98  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_DIGIT rev 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 for EP 1 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::DTMF_DIGIT event received on port 0:0, digit 8, mapped to 8, local 1, network 0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 7 (PHONE_DIALING) on port 0:0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneDialing on port 0:0, status = CALL_DIALING/CALL_IDLE ,sigReferred:0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlanSeg::match: match [0-9]+$
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::dialPlanEngine, DialPlanStatus: 0x4 21077608 line: 0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 143 8f  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_OFF evt 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 153 99  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_DIGIT rev 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 for EP 1 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::DTMF_DIGIT event received on port 0:0, digit 9, mapped to 9, local 1, network 0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 7 (PHONE_DIALING) on port 0:0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneDialing on port 0:0, status = CALL_DIALING/CALL_IDLE ,sigReferred:0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlanSeg::match: match [0-9]+$
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::dialPlanEngine, DialPlanStatus: 0x4 210776089 line: 0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 143 8f  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_OFF evt 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 153 99  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_DIGIT rev 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 for EP 1 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::DTMF_DIGIT event received on port 0:0, digit 9, mapped to 9, local 1, network 0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 7 (PHONE_DIALING) on port 0:0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneDialing on port 0:0, status = CALL_DIALING/CALL_IDLE ,sigReferred:0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlanSeg::match: match [0-9]+$
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::dialPlanEngine, DialPlanStatus: 0x4 2107760899 line: 0
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### uchAudioAPICallback with event 143 8f  DIGIT 0-9 $$$ @@@ 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : DTMF_OFF evt 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Value of DLY Status 0 
2015-05-15 14:30:48	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :$$$$$$$$$$$   p_mi13_LineEvent with event 21 
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlan timeout: 0x4 2107760899
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:DialPlan timeout: repetitive rule
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::run, Dialing 2107760899
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::call on port 0:0, status = 2(CALL_DIALED), disableLEC=1 canConf:1
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP::openSocket, Bound to RTP port 25506, socket 25
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP::openSocket, Bound to RTCP port 25507, socket 26
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP::QoS: Layer 3 DSCP for RTP set to 46
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP::QoS: Layer 3 DSCP for RTCP set to 46
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::call on port 0:0, status = CALL_DIALED/CALL_IDLE, reg=1
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::snd_message:(899)INVITE sip:2107760899@voip.viva.gr SIP/2.0  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1451939154;rport  Route: <sip
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]::voip.viva.gr:5060;lr>  From: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  To: <sip:2107760899@voip.viva.gr>  Call-ID: 348369638-28555-1
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:0@BJC.BGI.B.BB  CSeq: 80 INVITE  Contact: "Englesos" <sip:302118002985@192.168.1.11:28555>  Max-Forwards: 70  User-Agent: Grandstream HT702 1.0.7.3  P
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:rivacy: none  P-Preferred-Identity: "Englesos" <sip:302118002985@voip.viva.gr>  Supported: replaces, path, timer, eventlist  Allow: INVITE, ACK, OPTIO
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:NS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE  Content-Type: application/sdp  Accept: application/sdp, application/dtmf-relay  Content-Lengt
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:h:   164    v=0  o=302118002985 8000 8000 IN IP4 192.168.1.11  s=SIP Call  c=IN IP4 192.168.1.11  t=0 0  m=audio 25506 RTP/AVP 0  a=sendrecv  a=rtpmap
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]::0 PCMU/8000  a=ptime:20  
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: setNetworkConnected
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: Last good IP Addr:0.0.0.0
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPClientTransaction::sendRequest: Request 75 is sent
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::receiveMessage:(460)SIP/2.0 407 Proxy Authentication Required  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1451939154;rport=28555  Fro
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:m: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  To: <sip:2107760899@voip.viva.gr>;tag=ae428d0fc435bd570aaae338d70dfd1f.ab09  Call-ID: 34
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:8369638-28555-10@BJC.BGI.B.BB  CSeq: 80 INVITE  Proxy-Authenticate: Digest realm="viva.gr", nonce="5555d91a00008953d732d3a807f20028875895f625ee3dea"  
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Server: Viva VoIP  Content-Length: 0    
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 0, server= voip.viva.gr:5060, failover= voip.viva.gr:5060, outboundproxy= voip.viva.gr:5060
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 1, server= NULL:5060, failover= NULL:5060, outboundproxy= NULL:5060
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::snd_message:(363)ACK sip:2107760899@voip.viva.gr SIP/2.0  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1451939154;rport  Route: <sip:vo
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ip.viva.gr:5060;lr>  From: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  To: <sip:2107760899@voip.viva.gr>;tag=ae428d0fc435bd570aaae338d7
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:0dfd1f.ab09  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 80 ACK  Content-Length: 0    
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: setNetworkConnected
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: Last good IP Addr:0.0.0.0
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_rcv4xx: Received 407 response for transaction 75(INVITE)
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPTransaction::waitForResponse: Request 75 got status code 407
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::snd_message:(1122)INVITE sip:2107760899@voip.viva.gr SIP/2.0  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1896807826;rport  Route: <si
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:p:voip.viva.gr:5060;lr>  From: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  To: <sip:2107760899@voip.viva.gr>  Call-ID: 348369638-28555-
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:10@BJC.BGI.B.BB  CSeq: 81 INVITE  Contact: "Englesos" <sip:302118002985@192.168.1.11:28555>  Proxy-Authorization: Digest username="302118002985", real
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:m="viva.gr", nonce="5555d91a00008953d732d3a807f20028875895f625ee3dea", uri="sip:2107760899@voip.viva.gr", response="43546fcbcc513038e2dcc8cda850d7bc",
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]: algorithm=MD5  Max-Forwards: 70  User-Agent: Grandstream HT702 1.0.7.3  Privacy: none  P-Preferred-Identity: "Englesos" <sip:302118002985@voip.viva.g
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:r>  Supported: replaces, path, timer, eventlist  Allow: INVITE, ACK, OPTIONS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE  Content-Type: appli
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:cation/sdp  Accept: application/sdp, application/dtmf-relay  Content-Length:   164    v=0  o=302118002985 8000 8000 IN IP4 
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: setNetworkConnected
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: Last good IP Addr:0.0.0.0
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 3
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::receiveMessage:(299)SIP/2.0 100 Giving a try  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1896807826;rport=28555  From: "Englesos" <si
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:p:302118002985@voip.viva.gr>;tag=1319639322  To: <sip:2107760899@voip.viva.gr>  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 81 INVITE  Server: Viv
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:a VoIP  Content-Length: 0    
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 0, server= voip.viva.gr:5060, failover= voip.viva.gr:5060, outboundproxy= voip.viva.gr:5060
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 1, server= NULL:5060, failover= NULL:5060, outboundproxy= NULL:5060
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_rcv1xx: Received 100 response for transaction 76 (INVITE)
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 3
2015-05-15 14:30:57	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPTransaction::waitForResponse: Request 76 got status code 100
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::receiveMessage:(751)SIP/2.0 183 Session Progress  Via: SIP/2.0/UDP 192.168.1.11:28555;received=192.168.1.11;branch=z9hG4bK1896807826;rport=2
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:8555  Record-Route: <sip:83.235.24.86;lr=on;ftag=1319639322>  From: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  To: <sip:2107760899@voi
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:p.viva.gr>;tag=as0b1e400f  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 81 INVITE  Server: m2  Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUB
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SCRIBE, NOTIFY, INFO  Supported: replaces, timer  Contact: <sip:2107760899@83.235.24.92>  Content-Type: application/sdp  Content-Length: 187    v=0  o
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:=root 280784478 280784478 IN IP4 83.235.24.92  s=m2  c=IN IP4 83.235.24.92  t=0 0  m=audio 22374 RTP/AVP 0  a=rtpmap:0 PCMU/8000  a=silenceSupp:off - 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:- - -  a=ptime:20  a=sendrecv  
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 0, server= voip.viva.gr:5060, failover= voip.viva.gr:5060, outboundproxy= voip.viva.gr:5060
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 1, server= NULL:5060, failover= NULL:5060, outboundproxy= NULL:5060
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_rcv1xx: Received 183 response for transaction 76 (INVITE)
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPDialog, set SDP media to remote 83.235.24.92:22374, state=0 sdp=0 new sdp=0x1281f0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPDialog, set SDP media, sdp set to 0x1281f0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 40 (SIG_EARLY_MEDIA) on port 0:0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processSigEarlyMedia on port 0:0, status = CALL_DIALED/CALL_IDLE
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP::setSDP on port 0:0, current sdp: (nil), new sdp: 0x12b4d0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EarlyMedia::EarlyMedia, Creating Early Media object at port 0:0, disableLEC 1, hasInfo 1
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPTransaction::waitForResponse: Request 76 got status code 183
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EarlyMedia::run, Start Early Media on port 0:0, disableLEC 1, hasInfo =1
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EarlyMedia::run(), peer has no RFC2833, INFO=1, port 0, ch 0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EarlyMedia::run(), DTMF method negotiated: IN_AUDIO
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::stop RTP on port 0:0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::RTP stopped on port 0:0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP::start on port 0:0, SRTP status NO_SRTP
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ FXS 1 disable LEC
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##	CH_MODEMCALL_ON_OFF --> For EP 1 and Param 1 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP at port 0:0, RTP encoder 0@20, VAD 0, disableLEC:1 ptevt:0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : Modem Call Is Turned ON!!! Disable NES ... 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP, JB min =120, JB max =1000, silence =0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP, SRTP Disabled
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP set up RTCP
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP, Start RTP on port 0:0, socket 25, sndrcv 3, remote 83.235.24.92:22374
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ VOIP : Value of Isw 20
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@ VOIP (IPI3) ON  CH_SMU_DLY FOR EP 1 and PARAM 0 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : IN FTUCH Inst 1 and XInfo 0 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 1
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 3
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :FTRTP: RTP_START_CHAN
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :voice_start_chan: Request to start an RTP session
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : $$$$ IN cordless the rtp start the Max 1000 and Min 120 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : #### List of Rx codec received from user space 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_Start:  capabilities[0x30214b]  
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_Start, Max 1000 and Min 120 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_Start: ENC Tx Codec - coderTypeEnc[28] (AUC_G71B_ULAW_DTX==30, AUC_G71B_ULAW==28, AUC_G711_ULAW==16) 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_Start:Dec Rx Codec - coderTypeEnc[28] (AUC_G71B_ULAW_DTX==30, AUC_G71B_ULAW==28, AUC_G711_ALAW==15) 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :AFTER p_rtp_SessionCreate, pRtpSession is VALID
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : RTPAPP capabilities 30214B, EvtTx 255, EvTRX 255
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP started on port 0:0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ VOIP : Value of Isw 20
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@ VOIP (IPI3) ON RTPSTART: dec_chan=8, coderTypeDec = 28, status = 0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :RTPSTART: enc_chan=9coderTypeEnc = 28, status = 0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :pLineData->dwCapabilities = 3154251, pLineData->dec_chan = 8, jib_instance = 46d
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@@@ Value of pktsize 10 ms is 1 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : The MIN JIB value received from User space 120 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@ ### JB ADAPTATION DISABLED 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :p_rtpapp_DecStartCb: decoder chan 8 started for line 0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function p_rtpapp_Start;Line 2080; STATE CHANGE: to 1
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :voice_start_channel success
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :p_rtpapp_AUCCbTx: Encoder chan 9 started for line 0 and PktCnt 3
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :p_rtpapp_SetSesionStatus: started decoder and encoder for line 0
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### AUC Channel started sending COMA REPLY #####
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 5
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function p_rtpapp_SetSesionStatus;Line 4101; STATE CHANGE: to 2
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :FTRTP:1071: Calling voice_start_rtcp
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function p_rtpapp_RtcpStart;Line 3009; Calling p_rtcp_SessionInit
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : rtcp interval 1 and opts flag 19 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### p_rtcp_SessionInit 1 opts 19 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : AFTER COPY TO rtcpsession interval  1 opts 19 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : Modes of RTCP 19 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ######## RTCP interval given from user space 1 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 14
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ############ First RTP Packet received from remote so do rtp malloc 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : $$$$$$ Value of payload in this  ptArr[pRtpSession->pMember->bCd].bType 0 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : packet recv is DTMF so d'nt update the bPt from recv packet 
2015-05-15 14:30:58	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ############ First RTP Packet state is not ST_RTP_MEMBER_VALID and  pMember->bPt =0 update from rev packet 
2015-05-15 14:30:59	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@##  #$$$  Sending RTCP  based on TS 
2015-05-15 14:31:00	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 16
2015-05-15 14:31:00	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@##  #$$$  Sending RTCP  based on TS 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@##  #$$$  Sending RTCP  based on TS 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::receiveMessage:(737)SIP/2.0 200 OK  Via: SIP/2.0/UDP 192.168.1.11:28555;received=192.168.1.11;branch=z9hG4bK1896807826;rport=28555  Record-R
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:oute: <sip:83.235.24.86;lr=on;ftag=1319639322>  From: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  To: <sip:2107760899@voip.viva.gr>;tag
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:=as0b1e400f  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 81 INVITE  Server: m2  Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:, INFO  Supported: replaces, timer  Contact: <sip:2107760899@83.235.24.92>  Content-Type: application/sdp  Content-Length: 187    v=0  o=root 28078447
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:8 280784479 IN IP4 83.235.24.92  s=m2  c=IN IP4 83.235.24.92  t=0 0  m=audio 22374 RTP/AVP 0  a=rtpmap:0 PCMU/8000  a=silenceSupp:off - - - -  a=ptime
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]::20  a=sendrecv  
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 0, server= voip.viva.gr:5060, failover= voip.viva.gr:5060, outboundproxy= voip.viva.gr:5060
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 1, server= NULL:5060, failover= NULL:5060, outboundproxy= NULL:5060
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_rcv2xx: Received 200 response for transaction 76(INVITE)
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPDialog, set SDP media to remote 83.235.24.92:22374, state=1 sdp=1 new sdp=0x127b30
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPDialog, set SDP media, sdp set to 0x127b30
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::SessionTimer2xxAction on port 0:0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_ict_kill_transaction: Kill ICT transaction 76
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPTransaction::waitForResponse: Request 76 got status code 200
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EarlyMedia::stop, Stop Early Media on port 0:0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::stop RTP on port 0:0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ VOIP : Value of Isw 0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : CH_SMU_DLY FOR EP 1 and PARAM 0 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : IN FTUCH Inst 1 and XInfo 0 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :FTRTP: RTP_STOP_CHAN
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function p_rtpapp_Stop;Line 2846; STATE CHANGE: to 3
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :return value of p_rtpapp_Stopis 0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_AUCCallback is getting called 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_AUCCallback is getting called 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :RTP_ENCDEC_STOP_TIMER Algorithm started now 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Posting FTRTP_ENCDEC_STOP event to FTRTP from p_rtp_ENCDEC_StopTimer 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ENC/DEC stopped by DSP remove session and stop JB 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function p_rtp_session_jb_stop;Line 2919; STATE CHANGE: to 4
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### AUC Channel STOPPED sending COMA REPLY ##### 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 7
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : *** vmPrintDbgMemory report starts *** 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
	 Allocated Ptr : 0xe00b2c50[8896] LR : 0xe0022c00
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : *** vmPrintDbgMemory report ends *** 
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
Function create_voice_message; Sending coma response 16
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 9
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 0 )
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::RTP stopped on port 0:0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EarlyMedia::~EarlyMedia, Deleting Early Media object at port 0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::setSrtpStatusCaller, No SRTP on port 0:0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::call, Peer has no RFC2833, hasINFO= 1; we prefer IN_AUDIO IN_AUDIO IN_AUDIO
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::call, DTMF method negotiated: IN_AUDIO
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP::setSDP on port 0:0, current sdp: 0x12b4d0, new sdp: 0x127b30
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::snd_message:(805)ACK sip:2107760899@83.235.24.92 SIP/2.0  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1219370203;rport  Route: <sip:83
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:.235.24.86;lr=on;ftag=1319639322>  From: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  To: <sip:2107760899@voip.viva.gr>;tag=as0b1e400f  
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 81 ACK  Contact: <sip:302118002985@192.168.1.11:28555>  Proxy-Authorization: Digest username="30211800
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:2985", realm="viva.gr", nonce="5555d91a00008953d732d3a807f20028875895f625ee3dea", uri="sip:2107760899@voip.viva.gr", response="43546fcbcc513038e2dcc8c
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:da850d7bc", algorithm=MD5  Max-Forwards: 70  Supported: replaces, path, timer, eventlist  User-Agent: Grandstream HT702 1.0.7.3  Allow: INVITE, ACK, O
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:PTIONS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE  Content-Length: 0    
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: Last good IP Addr:0.0.0.0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processCallStarted on port 0:0, status = CALL_RINGING/CALL_IDLE, isCaller 1 canConf:1 ,sigReferred:0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::stopTone, Stop tone on port 0, direction 0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP SSRC/SEQ inited on port 0 ch 0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::processMedia, Call started on port 0:0:25506,status=CALL_COMMUNICATION,canSend=1,canRecv=1,disable2833=1,dtmf:IN_AUDIO,disableLEC:1
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::stop RTP on port 0:0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::RTP stopped on port 0:0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP::start on port 0:0, SRTP status NO_SRTP
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 18 (CALL_STARTED) on port 0:0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::processEvent, CALL_STARTED, port 0:0, evtPort 0:0
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::receiveMessage:(737)SIP/2.0 200 OK  Via: SIP/2.0/UDP 192.168.1.11:28555;received=192.168.1.11;branch=z9hG4bK1896807826;rport=28555  Record-R
2015-05-15 14:31:01	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ FXS 1 disable LEC
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##	CH_MODEMCALL_ON_OFF --> For EP 1 and Param 1 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : Modem Call Is Turned ON!!! Disable NES ... 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:oute: <sip:83.235.24.86;lr=on;ftag=1319639322>  From: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  To: <sip:2107760899@voip.viva.gr>;tag
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:=as0b1e400f  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 81 INVITE  Server: m2  Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:, INFO  Supported: replaces, timer  Contact: <sip:2107760899@83.235.24.92>  Content-Type: application/sdp  Content-Length: 187    v=0  o=root 28078447
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:8 280784479 IN IP4 83.235.24.92  s=m2  c=IN IP4 83.235.24.92  t=0 0  m=audio 22374 RTP/AVP 0  a=rtpmap:0 PCMU/8000  a=silenceSupp:off - - - -  a=ptime
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]::20  a=sendrecv  
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 0, server= voip.viva.gr:5060, failover= voip.viva.gr:5060, outboundproxy= voip.viva.gr:5060
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 1, server= NULL:5060, failover= NULL:5060, outboundproxy= NULL:5060
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::parseMessage: The response does not match any transaction. Check for retransmission
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::handle2xxForInvite: Find a dialog to match 200 OK
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::handle2xxForInvite: Resend ACK
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::snd_message:(805)ACK sip:2107760899@83.235.24.92 SIP/2.0  Via: SIP/2.0/UDP 192.168.1.11:28555;branch=z9hG4bK1219370203;rport  Route: <sip:83
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:.235.24.86;lr=on;ftag=1319639322>  From: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  To: <sip:2107760899@voip.viva.gr>;tag=as0b1e400f  
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 81 ACK  Contact: <sip:302118002985@192.168.1.11:28555>  Proxy-Authorization: Digest username="30211800
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:2985", realm="viva.gr", nonce="5555d91a00008953d732d3a807f20028875895f625ee3dea", uri="sip:2107760899@voip.viva.gr", response="43546fcbcc513038e2dcc8c
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:da850d7bc", algorithm=MD5  Max-Forwards: 70  Supported: replaces, path, timer, eventlist  User-Agent: Grandstream HT702 1.0.7.3  Allow: INVITE, ACK, O
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:PTIONS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE  Content-Length: 0    
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: Last good IP Addr:0.0.0.0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP at port 0:0, RTP encoder 0@20, VAD 0, disableLEC:1 ptevt:0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP, JB min =120, JB max =1000, silence =0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP, SRTP Disabled
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP set up RTCP
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP, Start RTP on port 0:0, socket 25, sndrcv 3, remote 83.235.24.92:22374
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ VOIP : Value of Isw 20
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@ VOIP (IPI3) ON  CH_SMU_DLY FOR EP 1 and PARAM 0 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : IN FTUCH Inst 1 and XInfo 0 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 1
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 3
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :FTRTP: RTP_START_CHAN
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :voice_start_chan: Request to start an RTP session
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : $$$$ IN cordless the rtp start the Max 1000 and Min 120 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : #### List of Rx codec received from user space 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Codec 0 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Dynamic String  
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@ Encode string codec  0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_Start:  capabilities[0x30214b]  
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_Start, Max 1000 and Min 120 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_Start: ENC Tx Codec - coderTypeEnc[28] (AUC_G71B_ULAW_DTX==30, AUC_G71B_ULAW==28, AUC_G711_ULAW==16) 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_Start:Dec Rx Codec - coderTypeEnc[28] (AUC_G71B_ULAW_DTX==30, AUC_G71B_ULAW==28, AUC_G711_ALAW==15) 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :AFTER p_rtp_SessionCreate, pRtpSession is VALID
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : RTPAPP capabilities 30214B, EvtTx 255, EvTRX 255
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ VOIP : Value of Isw 20
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@ VOIP (IPI3) ON RTPSTART: dec_chan=8, coderTypeDec = 28, status = 0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :RTPSTART: enc_chan=9coderTypeEnc = 28, status = 0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :pLineData->dwCapabilities = 3154251, pLineData->dec_chan = 8, jib_instance = 46d
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@@@ Value of pktsize 10 ms is 1 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : The MIN JIB value received from User space 120 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@ ### JB ADAPTATION DISABLED 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :p_rtpapp_DecStartCb: decoder chan 8 started for line 0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function p_rtpapp_Start;Line 2080; STATE CHANGE: to 1
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :voice_start_channel success
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :p_rtpapp_AUCCbTx: Encoder chan 9 started for line 0 and PktCnt 3
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :p_rtpapp_SetSesionStatus: started decoder and encoder for line 0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### AUC Channel started sending COMA REPLY #####
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 5
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function p_rtpapp_SetSesionStatus;Line 4101; STATE CHANGE: to 2
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ############ First RTP Packet received from remote so do rtp malloc 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : $$$$$$ Value of payload in this  ptArr[pRtpSession->pMember->bCd].bType 0 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : packet recv is DTMF so d'nt update the bPt from recv packet 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ############ First RTP Packet state is not ST_RTP_MEMBER_VALID and  pMember->bPt =0 update from rev packet 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startRTP started on port 0:0
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :FTRTP:1071: Calling voice_start_rtcp
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function p_rtpapp_RtcpStart;Line 3009; Calling p_rtcp_SessionInit
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : rtcp interval 1 and opts flag 19 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### p_rtcp_SessionInit 1 opts 19 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : AFTER COPY TO rtcpsession interval  1 opts 19 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : Modes of RTCP 19 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ######## RTCP interval given from user space 1 
2015-05-15 14:31:02	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 14
2015-05-15 14:31:03	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@##  #$$$  Sending RTCP  based on TS 
2015-05-15 14:31:03	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :RDRD Cordless: Receiving RTCP 1
2015-05-15 14:31:03	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ## Got the pMember based on SSRC of RTCP 
2015-05-15 14:31:03	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :cur_time  369e1c , pRtcpSession->dwTc 369c0c
2015-05-15 14:31:03	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : remote NTP timestamp  pMember->stats.dwRLsr  5782931e, pMember->stats.dwLsr  0x5a3af
2015-05-15 14:31:04	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 16
2015-05-15 14:31:04	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@##  #$$$  Sending RTCP  based on TS 
2015-05-15 14:31:04	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :pMember->stats.dwLsr  5a3af  delta  480 Tmp_dLsr 7ae1
2015-05-15 14:31:05	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@##  #$$$  Sending RTCP  based on TS 
2015-05-15 14:31:05	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :pMember->stats.dwLsr  5a3af  delta  1480 Tmp_dLsr 17ae1
2015-05-15 14:31:06	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@##  #$$$  Sending RTCP  based on TS 
2015-05-15 14:31:06	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :pMember->stats.dwLsr  5a3af  delta  2480 Tmp_dLsr 27ae1
2015-05-15 14:31:06	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 17
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@##  #$$$  Sending RTCP  based on TS 
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 1
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 10 (PHONE_FAX_DETECTED) on port 0:0
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::processSigFaxModem on port 0:0, status = CALL_COMMUNICATION/CALL_IDLE, evt =10
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::processSigFaxModem on port 0:0, reInv=0, feature=100, caller=1
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton, Fax/Modem signal detected on port 0
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : Node 0 1: Other EP connected to same node 5  
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :## CNG Detected and Restarting SSR/SSW Fifo if t38 running for Channel 0 
2015-05-15 14:31:07	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ FXS 1 disable LEC
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@@##  #$$$  Sending RTCP  based on TS 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::receiveMessage:(917)INVITE sip:302118002985@192.168.1.11:28555 SIP/2.0  Record-Route: <sip:83.235.24.86;lr=on;ftag=as0b1e400f>  Via: SIP/2.0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:/UDP 83.235.24.86;branch=z9hG4bK2c8b.0d377423.0  Via: SIP/2.0/UDP 83.235.24.92:5060;received=83.235.24.92;branch=z9hG4bK1276b2d8;rport=5060  Max-Forwa
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:rds: 69  From: <sip:2107760899@voip.viva.gr>;tag=as0b1e400f  To: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  Contact: <sip:2107760899@8
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:3.235.24.92>  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 102 INVITE  User-Agent: m2  Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:NOTIFY, INFO  Supported: replaces, timer  Content-Type: application/sdp  Content-Length: 251    v=0  o=root 280784478 280784480 IN IP4 83.235.24.92  s
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:=m2  c=IN IP4 83.235.24.92  t=0 0  m=image 48559 udptl t38  a=T38FaxVersion:0  a=T38MaxBitRate:9600  a=T38FaxRateManagement:transferredTCF  a=T38FaxMa
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:xDatagram:784  a=T38FaxUdpEC:t38UDPRedundancy  
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 0, server= voip.viva.gr:5060, failover= voip.viva.gr:5060, outboundproxy= voip.viva.gr:5060
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 1, server= NULL:5060, failover= NULL:5060, outboundproxy= NULL:5060
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_rcvreq: Received SIP request INVITE
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPDialog, set SDP media to remote 83.235.24.92:48559, state=2 sdp=1 new sdp=0x12a2e8
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPDialog, set SDP media, reinviteSDP set to 0x12a2e8
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 37 (SIG_REMOTE_RECONNECT) on port 0:0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::processSigRemoteReconnect on port 0:0, status = CALL_COMMUNICATION/CALL_IDLE
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :RDRD Cordless: Receiving RTCP 1
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ## Got the pMember based on SSRC of RTCP 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :cur_time  36b1a2 , pRtcpSession->dwTc 36af94
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : remote NTP timestamp  pMember->stats.dwRLsr  578792ed, pMember->stats.dwLsr  0x5a5a3
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::snd_message:(639)SIP/2.0 100 Trying  Via: SIP/2.0/UDP 83.235.24.86;branch=z9hG4bK2c8b.0d377423.0  Via: SIP/2.0/UDP 83.235.24.92:5060;receive
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:d=83.235.24.92;branch=z9hG4bK1276b2d8;rport=5060  Record-Route: <sip:83.235.24.86;lr=on;ftag=as0b1e400f>  From: <sip:2107760899@voip.viva.gr>;tag=as0b
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:1e400f  To: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 102 INVITE  Contact: <sip:30211
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:8002985@192.168.1.11:28555>  Supported: replaces, path, timer, eventlist  User-Agent: Grandstream HT702 1.0.7.3  Allow: INVITE, ACK, OPTIONS, CANCEL, 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE  Content-Length: 0    
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: Last good IP Addr:0.0.0.0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::SigRemoteReconnect, holdFlag[0][0] = 0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::SigRemoteReconnect, ReInvite w/ SDP holdFlag[0][0] = 0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::SigRemoteReconnect, Peer has no RFC2833, has INFO 1, port 0, ch 0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::SigRemoteReconnect, DTMF method negotiated: IN_AUDIO
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 41 (SIG_MEDIA_CHANGE) on port 0:0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::processEvent, SIG_MEDIA_CHANGE, port 0:0, evtPort 0:0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::stop RTP on port 0:0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ VOIP : Value of Isw 0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : CH_SMU_DLY FOR EP 1 and PARAM 0 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : IN FTUCH Inst 1 and XInfo 0 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :FTRTP: RTP_STOP_CHAN
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function p_rtpapp_Stop;Line 2846; STATE CHANGE: to 3
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :return value of p_rtpapp_Stopis 0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_AUCCallback is getting called 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : p_rtpapp_AUCCallback is getting called 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :RTP_ENCDEC_STOP_TIMER Algorithm started now 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::snd_message:(948)SIP/2.0 200 OK  Via: SIP/2.0/UDP 83.235.24.86;branch=z9hG4bK2c8b.0d377423.0  Via: SIP/2.0/UDP 83.235.24.92:5060;received=83
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:.235.24.92;branch=z9hG4bK1276b2d8;rport=5060  Record-Route: <sip:83.235.24.86;lr=on;ftag=as0b1e400f>  From: <sip:2107760899@voip.viva.gr>;tag=as0b1e40
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:0f  To: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 102 INVITE  Contact: <sip:302118002
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:985@192.168.1.11:28555>  Supported: replaces, path, timer, eventlist  User-Agent: Grandstream HT702 1.0.7.3  Allow: INVITE, ACK, OPTIONS, CANCEL, BYE,
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]: SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE  Content-Type: application/sdp  Content-Length:   278    v=0  o=302118002985 8000 8001 IN IP4 192.168.1.11  s=
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIP Call  c=IN IP4 192.168.1.11  t=0 0  m=image 25506 udptl t38  a=T38FaxVersion:0  a=T38MaxBitRate:9600  a=T38FaxRateManagement:transferredTCF  a=T38
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:FaxMaxBuffer:400  a=T38FaxMaxDatagram:784  a=T38FaxUdpEC:t38UDPRedundancy  
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: Last good IP Addr:0.0.0.0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_ist_kill_transaction: Kill IST transaction 77
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Posting FTRTP_ENCDEC_STOP event to FTRTP from p_rtp_ENCDEC_StopTimer 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ENC/DEC stopped by DSP remove session and stop JB 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function p_rtp_session_jb_stop;Line 2919; STATE CHANGE: to 4
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### AUC Channel STOPPED sending COMA REPLY ##### 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 7
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : *** vmPrintDbgMemory report starts *** 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
	 Allocated Ptr : 0xe00b2c50[8896] LR : 0xe0022c00
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : *** vmPrintDbgMemory report ends *** 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
Function create_voice_message; Sending coma response 16
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 9
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 0 )
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::RTP stopped on port 0:0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::stopTone, Stop tone on port 0, direction 0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::processMedia, changeSDP on port 0:0:25506,canSend=1,canRecv=1,t38=0,t38dir=0,SRTP=0,holdFlg=0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::START FAX
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP stop on port 0:0 local rtp port:25506 sdp:0x127b30
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:RTP::closeSocket(), Closing socket: 25, local rtp port: 25506
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:T38::startSession, T38 START SESSION
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:T38::startSession, T38 START SESSION A
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:T38::startSession, T38 START SESSION B
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startFAX entry point
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startFAX, port 0:0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startFAX, Start FAX on port 0:0, socket 25, remote 83.235.24.92:48559
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ VOIP : Value of Isw 20
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : @@ VOIP (IPI3) ON  CH_SMU_DLY FOR EP 1 and PARAM 0 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : IN FTUCH Inst 1 and XInfo 0 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 1
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 3
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :FTRTP: RTP_START_CHAN
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :voice_start_chan: Request to start a T38 session
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ### Allocating static mem for ptT38DPStatic ### 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :###### T38 Call Mode value ::-Disable 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :###### T38 Enable Fax Tone Indicator ::-disable
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##### Library added :-ctpl_faxrelay_ver3.5b2_20121129.a
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::receiveMessage:(469)ACK sip:302118002985@192.168.1.11:28555 SIP/2.0  Via: SIP/2.0/UDP 83.235.24.86;branch=z9hG4bK2c8b.0d377423.2  Via: SIP/2
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :t38_session_start: Started T38 chan 0 
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:.0/UDP 83.235.24.92:5060;received=83.235.24.92;branch=z9hG4bK0b8d6aa7;rport=5060  Max-Forwards: 69  From: <sip:2107760899@voip.viva.gr>;tag=as0b1e400f
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 5
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:  To: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  Contact: <sip:2107760899@83.235.24.92>  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSe
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :voice_start_channel success
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:q: 102 ACK  User-Agent: m2  Content-Length: 0    
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 0, server= voip.viva.gr:5060, failover= voip.viva.gr:5060, outboundproxy= voip.viva.gr:5060
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 1, server= NULL:5060, failover= NULL:5060, outboundproxy= NULL:5060
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::startFAX started on port 0:0
2015-05-15 14:31:08	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:T38::startSession, T38 START SESSION C
2015-05-15 14:31:11	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 16
2015-05-15 14:31:13	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 17
2015-05-15 14:31:14	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 1
2015-05-15 14:31:14	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:14	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:14	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:14	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : Node 0 1: Other EP connected to same node 5  
2015-05-15 14:31:14	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :## CNG Detected and Restarting SSR/SSW Fifo if t38 running for Channel 0 
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:16	Syslog.Info	192.168.1.11	Keep-alive message
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:16	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:17	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:19	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:20	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:24	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:31:24	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 2
2015-05-15 14:31:24	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:24	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:24	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:24	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:25	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:26	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :VFD detected a tone with value 4
2015-05-15 14:31:26	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 1 )
2015-05-15 14:31:26	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :value of vfdMemSize is 492
2015-05-15 14:31:26	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::event_handler_chan, event = 1, detected
2015-05-15 14:31:29	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_ict_kill_transaction: Kill ICT transaction 75
2015-05-15 14:31:29	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:31:29	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::receiveMessage:(502)BYE sip:302118002985@192.168.1.11:28555 SIP/2.0  Via: SIP/2.0/UDP 83.235.24.86;branch=z9hG4bK3c8b.f19daac3.0  Via: SIP/2
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:.0/UDP 83.235.24.92:5060;received=83.235.24.92;branch=z9hG4bK7da3eee0;rport=5060  Max-Forwards: 69  From: <sip:2107760899@voip.viva.gr>;tag=as0b1e400f
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:  To: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1319639322  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 103 BYE  User-Agent: m2  X-Asterisk-H
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:angupCause: Normal Clearing  X-Asterisk-HangupCauseCode: 16  Content-Length: 0    
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 0, server= voip.viva.gr:5060, failover= voip.viva.gr:5060, outboundproxy= voip.viva.gr:5060
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::isMessegeFromAllowedProxy, acct= 1, server= NULL:5060, failover= NULL:5060, outboundproxy= NULL:5060
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::cb_rcvreq: Received SIP request BYE
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 39 (SIG_REMOTE_DISCONNECT) on port 0:0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processSigRemoteDisconnect on port 0:0, status = CALL_COMMUNICATION/CALL_IDLE ,sigReferred:0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::stopTone, Stop tone on port 0, direction 0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::playTone, Play tone 40 on port 0, direction 1
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 26 (CALL_COMPLETED) on port 0:0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SigCtrl::processCallCompleted on port 0:0, status = CALL_ENDING/CALL_IDLE
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processCallCompleted on port 0:0, status = CALL_IDLE/CALL_IDLE canConf:1 ,sigReferred:0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack::snd_message:(576)SIP/2.0 200 OK  Via: SIP/2.0/UDP 83.235.24.86;branch=z9hG4bK3c8b.f19daac3.0  Via: SIP/2.0/UDP 83.235.24.92:5060;received=83
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:.235.24.92;branch=z9hG4bK7da3eee0;rport=5060  From: <sip:2107760899@voip.viva.gr>;tag=as0b1e400f  To: "Englesos" <sip:302118002985@voip.viva.gr>;tag=1
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ FXS 1 disable LEC
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:319639322  Call-ID: 348369638-28555-10@BJC.BGI.B.BB  CSeq: 103 BYE  Contact: <sip:302118002985@192.168.1.11:28555>  Supported: replaces, path, timer, 
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:eventlist  User-Agent: Grandstream HT702 1.0.7.3  Allow: INVITE, ACK, OPTIONS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE  Content-Length: 0 
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##	CH_MODEMCALL_ON_OFF --> For EP 1 and Param 1 
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : Modem Call Is Turned ON!!! Disable NES ... 
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:   
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:snd_message: Last good IP Addr:0.0.0.0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::stop RTP on port 0:0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ VOIP : Value of Isw 0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : CH_SMU_DLY FOR EP 1 and PARAM 0 
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : IN FTUCH Inst 1 and XInfo 0 
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :FTRTP: RTP_STOP_CHAN
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :return value of t38_session_stop is 0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 7
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :Function create_voice_message; Sending coma response 9
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :switchVfdState ( instance = 1, on = 0 )
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active call dialogs: 1
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::RTP stopped on port 0:0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP :@@ FXS 1 disable LEC
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::stop RTP on port 0:0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:GSDSP::RTP stopped on port 0:0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:T38::stop, T38 session stopped at port 0:0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::processMedia, Call stopped on port 0:0, inTransfer = 0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::unregisterEventListener: listener Call
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Call(9)::~Call, Deleting Call object 9 at port 0:0, callCount=0
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : ##	CH_MODEMCALL_ON_OFF --> For EP 1 and Param 1 
2015-05-15 14:31:35	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3] DSP : Modem Call Is Turned ON!!! Disable NES ... 
2015-05-15 14:31:51	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Deleting call dialog (8)
2015-05-15 14:31:51	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPDialog::~SIPDialog: Cleaning in-dialog in-transaction 
2015-05-15 14:31:51	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPDialog::~SIPDialog: Cleaning in-dialog out-transaction 
2015-05-15 14:31:51	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPDialog::~SIPDialog, Deleting SDP in the dialog
2015-05-15 14:31:51	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:32:06	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:32:17	Syslog.Info	192.168.1.11	Keep-alive message
2015-05-15 14:32:21	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:32:36	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:32:38	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::stopTone, Stop tone on port 0, direction 0
2015-05-15 14:32:38	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::playTone, Play tone 39 on port 0, direction 1
2015-05-15 14:32:44	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:EventManager::run: Dispatching event 4 (PHONE_ON_HOOK) on port 0:0
2015-05-15 14:32:44	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:ATACtrl::processPhoneOnHook on port 0:0, status = CALL_IDLE/CALL_IDLE ,sigReferred:0
2015-05-15 14:32:44	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::stopTone, Stop tone on port 0, direction 0
2015-05-15 14:32:44	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Nuvoton::stopTone, Stop tone on port 0, direction 0
2015-05-15 14:32:44	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:Phone at port 0 is on-hook
2015-05-15 14:32:51	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1
2015-05-15 14:33:06	Local7.Debug	192.168.1.11	HT702 [00:0B:82:3D:5C:66] [1.0.7.3]:SIPStack(0)::run: Active transactions: 1

Επίσης, κάνω attach το config page του FXS.

Υπάρχει περίπτωση το πρόβλημα να είναι από την μεριά της Viva με το Τ.38 implementation τους να είναι ασύμβατο με αυτό του Grandstream; Μπορεί να είναι αλλού το πρόβλημα;

Υ.Γ.: Δοκιμάζοντας με Fax Pass-through αντί για Τ.38, δεν μπορούσε καν να ολοκληρωθεί η κλήση. Η λύση είναι προφανώς το Τ.38, αρκεί να δουλέψει σωστά.

**kourakos** · 16-05-15, 01:35

Με τι codec δουλεύεις;Δοκίμασε το g711u ή a. Αν πάλι δεν λειτουργήσει τότε γύρισε το τ38 σε pass through.

**englishman** · 16-05-15, 02:00

Έχω ρυθμισμένο ήδη το PCMA (=G711a) στο Grandstream. Δοκίμασα και με pass-through αλλά όπως ανέφερα πιο πάνω, δεν κατάφερε καν να ολοκληρώσει την κλήση για να αρχίσει το transmission. Απότι φαίνεται στο syslog που παρέθεσα πιο πάνω, δεν κάνει σωστό negotiation από την στιγμή που φεύγει από το PCMA και (ορθά) πάει στο Τ.38. Ο server της Viva στέλνει πολύ νωρίς το BYE signal.

**nontasaggelis** · 25-05-15, 02:35

Και εγω που ειχα δοκιμασει με viva, ποτε δεν τα κατεφερα!
ΑΝΤΙΘΕΤΑ, με MODULUS με την πρωτη! και ληψη και αποστολη! Και να φανταστεις με ενα απλο pap2 με 711 δουλευει τωρα στο κατω σπιτι τελεια! (ρυθμισεις του φαξ δεν πειραξα καθολου).

Θέμα: Αποστολή fax με Grandstream 702

Παρόμοια Θέματα

Elastix & Voip Gateway & FAX

Αποστολή καφέ με δέμα

Κλείσιμο γραμμής σε Grandstream GXP2130

ADSL και πρόβλημα με fax...

Tags για αυτό το Θέμα

Bookmarks

Bookmarks

Δικαιώματα - Επιλογές