Dieses Dokument enthält die progressiven Befehlseinträge, die zur Implementierung der E1 R2-Signalisierung erforderlich sind. Dieses Dokument enthält auch Informationen zur Fehlerbehebung mit Debugbefehlen.
Hinweis: Bevor Sie dieses Dokument verwenden, sollten Sie zuerst die E1 R2-Signalisierungstheorie lesen.
Stellen Sie vor dem Versuch dieser Konfiguration sicher, dass Sie die folgenden Voraussetzungen erfüllen:
Die R2-Signalisierung gilt nur für E1.
Die R2-Signalisierung wird vom Cisco Router MC3810 nicht unterstützt.
Für die Ausführung der R2-Signalisierung auf Cisco Routern der Serien 2600 und 3600 ist diese Hardware erforderlich:
VWIC-1MFT-E1 oder VWIC-2MFT-E1 oder VWIC-2MFT-E1-DI zusammen mit einem der folgenden Module für die Sprachdichte: NM-HDV (High Density Voice Network Module) oder NM-HD-2VE (IP Communications Voice/Fax Network Module mit zwei Steckplätzen).
Definieren Sie den Befehl ds0-group (oder cas-group, basierend auf der Cisco IOS®-Version) auf den E1-Controllern (AS5x00, Cisco 2600/3600-Router).
Verwenden Sie den Befehl cas-custom, um die E1 R2-Varianten für verschiedene Länder oder Regionen anzupassen.
Die Informationen in diesem Dokument basieren auf dieser Software- und Hardwareversion:
Cisco AS5300 mit Cisco IOS Software, Version 12.0.7T
Hinweis: Die E1 R2-Signalisierung wurde in den Cisco IOS Software-Versionen 12.1.2XH und 12.1(3)T auf den Routern der Serien 2600 und 3600 eingeführt.
Die Informationen in diesem Dokument beziehen sich auf Geräte in einer speziell eingerichteten Testumgebung. Alle Geräte, die in diesem Dokument benutzt wurden, begannen mit einer gelöschten (Nichterfüllungs) Konfiguration. Wenn Ihr Netz Live ist, überprüfen Sie, ob Sie die mögliche Auswirkung jedes möglichen Befehls verstehen.
Weitere Informationen zu Dokumentkonventionen finden Sie unter Cisco Technical Tips Conventions (Technische Tipps von Cisco zu Konventionen).
In diesem Abschnitt finden Sie die Informationen, die Sie zum Konfigurieren von E1 R2 verwenden können.
Hinweis: Weitere Informationen zu den in diesem Dokument verwendeten Befehlen finden Sie im Command Lookup Tool (nur registrierte Kunden).
Bevor Sie die E1 R2-Signalisierung in einen Cisco AS5300-Router implementieren, stellen Sie sicher, dass Ihre Version der Cisco IOS-Software mit der Cisco VCware im E1-Modul kompatibel ist. Weitere Informationen zur Überprüfung der Kompatibilität der Cisco IOS-Software finden Sie in der Cisco VCWare Compatibility Matrix for the Cisco AS5300. Wenn die Versionen nicht kompatibel sind, werden die Digital Signal Processor (DSP) Module der Sprachkarte nicht geladen, und die Sprachsignalverarbeitung erfolgt nicht.
Wenn die Version von Cisco VCWare mit der Cisco IOS-Software nicht kompatibel ist, können Sie den Schnittstellenbefehl show vfc slot_number eingeben, um dies wie im folgenden Beispiel gezeigt anzuzeigen.
eefje#show vfc 1 interface Rx: in ptr 18, outptr 0 Tx: in ptr 14 outptr 14 0 in hw queue, 0 queue head , 0 queue tail Hardware is VFC out-of-band channel Interface : state RESET DSP instance (0x61048284) dsp_number 0, Channel ID 0 TX outstanding 0, max TX outstanding 0 Received 18 packets, 1087 bytes, 0 giant packets 0 drops, 0 no buffers, 0 input errors 121 bytes output, 14 frames output 0 bounce errors 0 DSP module 1 is not installed DSP module 2 is not installed DSP module 3 is not installed DSP module 4 is not installed DSP module 5 is not installed
In der ersten Beispielausgabe des Befehls show vfc slot_number interface wird die DSP-Modulnummer nicht installiert Anweisungen zeigen, dass die Versionen für diese Modulnummer nicht kompatibel sind.
Diese zweite Ausgabe ist ein Beispiel für die DSP-Module, bei denen die richtige Cisco VCWare-Version geladen ist:
eefje#show vfc 1 interface Rx: in ptr 24, outptr 0 TX: in ptr 15 outptr 15 0 in hw queue, 0 queue head , 0 queue tail Hardware is VFC out-of-band channel Interface : state RESET DSP instance (0x618C6088) dsp_number 0, Channel ID 0 TX outstanding 0, max TX outstanding 0 Received 283288 packets, 15864278 bytes, 0 giant packets 0 drops, 0 no buffers, 0 input errors 1416459 bytes output, 141647 frames output 0 bounce errors 0 Slot 1, DSPM 1 (C542), DSP 1, Channel 1 State RESET, DSP instance (0x61914BDC) TX outstanding 0, max TX outstanding 8 Received 0 packets, 0 bytes, 0 giant packets 0 drops, 0 no buffers, 0 input errors 0 bytes output, 0 frames output 0 bounce errors 0 Slot 1, DSPM 1 (C542), DSP 2, Channel 1 State RESET, DSP instance (0x6191510C) TX outstanding 0, max TX outstanding 8 Received 0 packets, 0 bytes, 0 giant packets 0 drops, 0 no buffers, 0 input errors 0 bytes output, 0 frames output 0 bounce errors 0
Um die installierte Cisco VCWare-Version zu überprüfen, geben Sie den Befehl show vfc slot_number version vcware ein, wie in diesem Beispiel gezeigt:
eefje#show vfc 1 version vcware Voice Feature Card in Slot 1: VCware Version : 4.10 ROM Monitor Version : 1.2 DSPware Version : Technology : C542
Hinweis: Vergewissern Sie sich, dass die Cisco VCWare-Technologieversion (c549 oder c542) der installierten VFC-DSP-Technologie (DSPM-542: Sprachunterstützung mit einfacher Dichte oder DSPM-549: Sprachunterstützung).
Gehen Sie wie folgt vor, um E1 R2 zu konfigurieren:
Richten Sie den Controller E1 ein, der mit dem PBX-System (Private Automatic Branch Exchange) oder Switch verbunden ist.
Stellen Sie sicher, dass das Framing und die Verkabelung des E1 richtig eingestellt sind.
Wählen Sie für E1-Framing entweder CRC oder Nicht-CRC.
Wählen Sie für E1-Linecding entweder HDB3 oder AMI aus.
Wählen Sie für die E1-Taktquelle entweder intern oder line aus. Beachten Sie, dass für verschiedene PBX-Systeme unterschiedliche Anforderungen an die Taktquelle gelten.
Passen Sie die Konfiguration mit dem benutzerdefinierten Befehl cas an.
Verwenden Sie diese Befehlsfolge, um die Leitungssignalisierung zu definieren.
eefje(config)#controller E1 0 eefje(config-controller)#ds0-group 1 timeslots 1-15 type ? ... r2-analog R2 ITU Q411 r2-digital R2 ITU Q421 r2-pulse R2 ITU Supplement 7 ...
Dies ist die Befehlsfolge für Cisco IOS Software Release 11.3.
eefje(config)#controller E1 0 eefje(config-controller)#cas-group 1 timeslot 1-15 type ? ...
Hinweis: Wenn Sie ein Upgrade von Cisco IOS Software Release 11.3 auf 12.0 durchführen, ersetzt der neue Befehl automatisch den alten Befehl.
In diesem Beispiel für die Befehlsfolge wird veranschaulicht, wie die verschiedenen Typen der Inter-Register-Signalisierung konfiguriert werden:
eefje(config)#controller E1 0 eefje(config-controller)#ds0-group 1 timeslots 1-15 type r2-digital ? dtmf DTMF tone signaling r2-compelled R2 Compelled Register Signaling r2-non-compelled R2 Non Compelled Register Signaling r2-semi-compelled R2 Semi Compelled Register Signaling
Bei der Cisco Implementierung der R2-Signalisierung wurde standardmäßig die Unterstützung für den Wähltelefonnummer Identification Service (DNIS) aktiviert. Wenn Sie die Option Automatic Number Identification (ANI) aktivieren, werden die DNIS-Informationen weiterhin erfasst. Durch die Angabe der ANI-Option wird die DNS-Erfassung nicht deaktiviert. DNIS ist die Nummer, die aufgerufen wird. ANI ist die Nummer des Anrufers. Wenn Sie beispielsweise einen Router mit dem Namen A für den Anruf eines Routers mit dem Namen B konfigurieren, wird die DNIS-Nummer Router B zugewiesen und die ANI-Nummer Router A zugewiesen. Die ANI ähnelt der Anrufer-ID.
Die Unterbefehle unter dem Befehl cas-custom werden verwendet, um die Ländervarianten einzubinden. Sie werden auch verwendet, um Channel Associated Signaling (CAS)-Parameter anzupassen. Diese Befehlsfolge veranschaulicht, wie Sie alle cas-benutzerdefinierten Befehlsoptionen anzeigen können.
eefje(config)#controller E1 0 eefje(config-controller)#cas-custom 1 eefje(config-ctrl-cas)#? CAS custom commands: ani-digits Expected number of ANI digits ani-timeout Timeout for ANI digits answer-guard-time Wait Between Group-B Answer Signal And Line Answer answer-signal Answer signal to be used caller-digits Digits to be collected before requesting CallerID category Category signal country Country Name debounce-time Debounce Timer default Set a command to its defaults dnis-complete Send I-15 after DNIS digits for dial-out dnis-digits Expected number of DNIS digits exit Exit from cas custom mode groupa-callerid-end Send Group-A Caller ID End invert-abcd invert the ABCD bits before TX and after rx ka kA Signal kd KD Signal metering R2 network is sending metering signal nc-congestion Non Compelled Congestion signal no Negate a command or set its defaults proceed-to-send Suppress proceed-to-send signal for pulsed line signaling release-ack Send Release Acknowledgment to Clear Forward release-guard-time Release Guard Timer request-category DNIS Digits to be collected before requesting category seizure-ack-time Seizure to Acknowledge timer unused-abcd Unused ABCD bit values
Weitere Informationen zu cas-custom Befehlsparametern finden Sie unter E1 R2 Customization with the cas-custom command.
In diesem Dokument wird diese Netzwerkeinrichtung verwendet.
Für die Zwecke dieses Dokuments sind dies die drei verschiedenen R2-Konfigurationen, die über die E1-Schnittstelle angezeigt werden:
Die Konfigurationen wurden geändert, um nur die Informationen anzuzeigen, die in diesem Dokument behandelt werden.
eefje konfiguriert für R2 Digital Non-Compelling |
---|
hostname eefje ! controller E1 0 clock source line primary dso-group 1 timeslots 1-15 type r2-digital r2-non-compelled cas-custom 1 !--- For more information on these commands !--- refer to ds0-group and cas-custom. ! voice-port 0:1 cptone BE !--- The cptone command is country specific. For more !--- information on this command, refer to cptone . ! dial-peer voice 123 pots destination-pattern 123 direct-inward-dial port 0:1 prefix 123 ! dial-peer voice 567 voip destination-pattern 567 session target ipv4:2.0.0.2 ! |
eefje konfiguriert für "R2 Digital Semi Compelling" |
---|
hostname eefje ! controller E1 0 clock source line primary ds0-group 1 timeslots 1-15 type r2-digital r2-semi-compelled cas-custom 1 !--- For more information on these commands !--- refer to ds0-group and cas-custom . ! voice-port 0:1 cptone BE !--- The cptone command is country specific. For more !--- information on this command, refer to cptone . dial-peer voice 123 pots destination-pattern 123 direct-inward-dial port 0:1 prefix 123 ! dial-peer voice 567 voip destination-pattern 567 session target ipv4:2.0.0.2 ! |
eefje konfiguriert für R2 Digital Compeled ANI |
---|
hostname eefje ! controller E1 0 clock source line primary ds0-group 1 timeslots 1-15 type r2-digital r2-compelled ani cas-custom 1 !--- For more information on these commands !--- refer to ds0-group and cas-custom . voice-port 0:1 cptone BE !--- The cptone command is country specific. For more !--- information on this command, refer to cptone . dial-peer voice 123 pots destination-pattern 123 direct-inward-dial port 0:1 prefix 123 ! dial-peer voice 567 voip destination-pattern 567 session target ipv4:2.0.0.2 ! |
Für diese Konfiguration ist derzeit kein Überprüfungsverfahren verfügbar.
In diesem Abschnitt finden Sie Informationen zur Behebung von Fehlern in Ihrer Konfiguration.
Dies sind die für diese Konfiguration relevanten Informationen zur Fehlerbehebung. Befolgen Sie diese Anweisungen, um eine Fehlerbehebung für Ihre Konfiguration durchzuführen.
Überprüfen Sie, ob der Controller E1 0 betriebsbereit ist.
Wenn sie ausgefallen ist, überprüfen Sie die Einstellungen für Framing, Leitungscodierung, Taktquelle, Alarme, ersetzen Sie das Kabel, setzen Sie die Karte wieder ein usw. Verwenden Sie die E1 R2-Anpassung mit dem cas-custom Command-Dokument als Referenz.
Wenn Sie einen AS5300 verwenden, überprüfen Sie, ob die DSPs korrekt mit dem Schnittstellenbefehl show vfc slot number interface installiert sind.
Konfigurieren Sie die DID (Direct Inward Dial) auf dem normalen POTS-Peer (Call Old Telefone Service), sodass die empfangenen Ziffern zur Auswahl eines ausgehenden Peers verwendet werden.
Geben Sie cptone (cptone ist für Ihr Land spezifisch) an den Sprach-Ports an.
Ein cpton-Länderbefehl muss konfiguriert werden, um dem cas-custom country-Befehl zu entsprechen. Der cptone-Parameter legt die Anruffortschrittstöne für ein bestimmtes Land fest und legt vor allem die Kodierung auf ein Gesetz oder ein Unrecht fest, das vom Land abhängig ist. Die Standardcodierung für die USA lautet u-law.
Ordnen Sie die Signalisierungsanforderungen für Leitungen und Register der Switch-Konfiguration zu.
Aktivieren Sie einige der in diesem Dokument gezeigten Debuggen, und untersuchen Sie die Ausgaben.
Auf Kommunikation zwischen Router und PBX oder Switch prüfen:
Wird die Leitung besetzt?
Empfängt/sendet der Router Zahlen?
Finden Sie heraus, welche Seite den Anruf beendet.
Verwenden Sie nach Möglichkeit die neuesten Cisco IOS-Softwareversionen, die auf Cisco.com verfügbar sind.
Einige Befehle des Typs show werden vom Tool Output Interpreter unterstützt (nur für registrierte Kunden), mit dem sich Analysen der Ausgabe von Befehlen des Typs show abrufen lassen.
Hinweis: Bevor Sie Debugbefehle ausgeben, lesen Sie die Informationen Wichtige Informationen über Debug-Befehle.
Hinweis: Verwenden Sie für Cisco IOS Software Release 12.0 die folgenden Debugging:
debug cas - Für die Leitungssignalisierung.
debug csm voice - Für die Interregister-Signalisierung.
debug vtsp all - Um die Ausgabe aller Nachrichten (Ziffern) zwischen dem PBX-System und dem Router zu erhalten.
Verwenden Sie für Cisco IOS Software Release IOS 11.3 die folgenden Befehle:
modem-mgmt csm debug-rbs - Für die Leitungssignalisierung (Sie müssen zuerst internen Service im Konfigurationsmodus angeben.)
debug csm voice - Für die Interregister-Signalisierung.
debug vtsp all - Um die Ausgabe aller Nachrichten (Ziffern) zwischen dem PBX-System und dem Router zu erhalten.
Verwenden Sie für die Plattformen AS5400 und AS5350 die folgenden Debugging-Optionen:
debug sigsm r2 - Für Inter-Register-Signalisierung
debug vtsp all - Um die Ausgabe aller Nachrichten (Ziffern) zwischen dem PBX-System und dem Router zu erhalten.
Da dieses Dokument drei verschiedene Konfigurationen enthält, gibt es drei verschiedene Debugging-Typen:
Um diese Debug-Ausgabe besser zu verstehen, lesen Sie E1 R2 Signaling Theory.
eefje#show debug CAS: Channel Associated Signaling debugging is on CSM Voice: Voice Call Switching Module debugging is on Voice Telephony session debugging is on Voice Telephony dsp debugging is on Voice Telephony error debugging is on eefje# eefje# eefje# Jan 6 10:41:28.677: from NEAT(0): (0/0): Rx SEIZURE (ABCD=0001) Jan 6 10:41:28.717: VDEV_ALLOCATE: failed to allocate a device Jan 6 10:41:28.717: VDEV_ALLOCATE: 1/28 is allocated Jan 6 10:41:28.721: csm_vtsp_init_tdm (voice_vdev=0x620BF874) Jan 6 10:41:28.721: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm slot 2, dspm 1, dsp 5, dsp_channel 1 Jan 6 10:41:28.721: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm stream 5, channel 3, bank 1, bp_channel 4, BP_stream 255 Jan 6 10:41:28.721: CSM_RX_CAS_EVENT_FROM_NEAT:(cid0018): EVENT_CALL_DIAL_IN at slot 2 and port 16 Jan 6 10:41:28.721: CSM_PROC_IDLE: CSM_EVENT_START_DIGIT_COLLECT at slot 2, port 16 Jan 6 10:41:28.721: csm_vtsp_start_digit_collect (voice_vdev=0x620BF874) Jan 6 10:41:28.721: Enter csm_connect_pri_vdev function Jan 6 10:41:28.721: csm_connect_pri_vdev:tdm_allocate_BP_ts()call. BP TS allocated at BP_stream0, BP_Ch28,vdev_common 0x6 20BF8E4 Jan 6 10:41:28.721: to NEAT:(cid0018) EVENT_CHANNEL_LOCK for slot0 ctlr0 chan0 Jan 6 10:41:28.721: vtsp_do_call_setup_ind Jan 6 10:41:28.721: vtsp_do_call_setup_ind: Call ID=65681, guid=61FAF610 Jan 6 10:41:28.721: vtsp_do_call_setup_ind: type=0, under_spec=0, name=, id0=0, id1=0, id2=0, calling=, called= Jan 6 10:41:28.721: vtsp_do_call_setup_ind: redirect DN = reason = 0vtsp_open_voice_and_set_params Jan 6 10:41:28.721: dsp_close_voice_channel: [0:1:0] packet_len=8 channel_id =8529 packet_id=75 Jan 6 10:41:28.721: dsp_open_voice_channel_20: [0:1:0] packet_Len=16 channel_id =8529 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0 time_slot=0 serial_port=0 Jan 6 10:41:28.721: dsp_encap_config_20: [0:1:0] packet_Len=24 channel_id=8529 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0 Jan 6 10:41:28.721: dsp_set_playout: [0:1:0] packet_Len=18 channel_id=8529 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300 Jan 6 10:41:28.721: dsp_echo_canceller_control: [0:1:0] packet_Len=10 channel_id=8529 packet_id=66 flags=0x0 Jan 6 10:41:28.721: dsp_set_gains: [0:1:0] packet_Len=12 channel_id=8529 packet_id=91 in_gain=0 out_gain=0 Jan 6 10:41:28.721: dsp_vad_enable: [0:1:0] packet_Len=10 channel_id=8529 packet_id=78 thresh=-38 Jan 6 10:41:28.721: dsp_voice_mode: [0:1:0] packet_Len=24 channel_id=8529 packet_id=73 coding_type=1 voice_field_size=80 V AD_flag=0 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay=2 AGC_flag=0vtsp_do_r2_start_digit(): dsp_dtmf_mode() dsp_dtmf_mode(VTSP_TONE_R2_MF_FORWARD_MODE) Jan 6 10:41:28.725: dsp_dtmf_mode: [0:1:0] packet_Len=10 channel_id=8529 packet_id=65 dtmf_or_mf=1vtsp_do_r2_start_digit():fsm_push(vtsp_r2_state_table) Jan 6 10:41:28.725: csm_vtsp_call_setup_resp (vdev_info=0x620BF874, vtsp_cdb=0x621C5F3C) Jan 6 10:41:28.725: csm_vtsp_call_setup_resp:vdev_common BP TS allocatedat BP_stream0,BP_Ch28 Jan 6 10:41:28.725: csm_vtsp_call_setup_resp:dst_tdm_chnl call. BP TS allocatedat stream 5, chan 3,BP_stream 255, BP_ch 4 Jan 6 10:41:28.725: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 5, chan 3,BP_stream 0, BP_ch 28 Jan 6 10:41:28.725: CSM_PROC_IC1_COLLECT_ADDR_INFO: CSM_EVENT_MODEM_OFFHOOK (DNIS=, ANI=) at slot 2, port 16 Jan 6 10:41:28.725: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE: R2_IN_IDLE R2 Got Event R2_START Jan 6 10:41:28.821: CSM_RX_CAS_EVENT_FROM_NEAT:(0018):EVENT_START_RX_TONE at slot 2 and port 16 Jan 6 10:41:28.821: from NEAT(0): (0/0): TX SEIZURE_ACK (ABCD=1101) !--- Digit 5 is sent: Forward Signal Group I-5. Jan 6 10:41:29.233: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=5, rtp_timestamp=0x0CA95D43 dc_digit_up Jan 6 10:41:29.233: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C) received digit (5) Jan 6 10:41:29.233: CSM voice (2/16): Rcvd Digit detected(5) Jan 6 10:41:29.233: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE: R2_IN_COLLECT_DNIS R2 Got Event 5 Jan 6 10:41:29.365: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=5, duration=8321dc_digit Jan 6 10:41:29.365: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C) received digit (5) Jan 6 10:41:29.365: CSM voice (2/16): Rcvd Digit detected(5) Jan 6 10:41:29.365: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE:R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF !--- Digit 6 is sent: Forward Signal Group I-6. Jan 6 10:41:29.593: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=6, rtp_timestamp=0x0CA95D43 dc_digit_up Jan 6 10:41:29.593: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C) received digit (6) Jan 6 10:41:29.593: CSM voice (2/16): Rcvd Digit detected(6) Jan 6 10:41:29.593: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE: R2_IN_COLLECT_DNIS R2 Got Event 6 Jan 6 10:41:29.725: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=6, duration=8321dc_digit Jan 6 10:41:29.725: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C) received digit (6) Jan 6 10:41:29.725: CSM voice (2/16): Rcvd Digit detected(6) Jan 6 10:41:29.725: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF !--- Digit 7 is sent: Forward Signal Group I-7. Jan 6 10:41:29.953: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=7, rtp_timestamp=0x0CA95D43 dc_digit_up Jan 6 10:41:29.953: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C) received digit (7) Jan 6 10:41:29.953: CSM voice (2/16): Rcvd Digit detected(7) Jan 6 10:41:29.953: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE:R2_IN_COLLECT_DNIS R2 Got Event 7 Jan 6 10:41:30.085: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=7, duration=8321dc_digit Jan 6 10:41:30.085: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C)received digit (7) Jan 6 10:41:30.085: CSM voice (2/16): Rcvd Digit detected(7) Jan 6 10:41:30.085: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF !--- Timeout: 3 seconds (default timer - AS5300 assumes DNIS is finished). Jan 6 10:41:32.953: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_TIMER !--- Send digit 6: Backward Signal Group B-6 (subscriber's line free-charge). Jan 6 10:41:32.953: vtsp_r2_generate_digits: vdev_common=0x620BF8E4, string=567dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 6# Jan 6 10:41:32.953: dsp_dtmf_dialing: [0:1:0] packet_Len=36 channel_id=8529 packet_id=90 string=6# digits=2, time_on=150, time_off=30 Jan 6 10:41:32.953:& digit=e, components=2, freq_of_first=900, freq_of_second=780, amp_of_first=8192, amp_of_second=8192 Jan 6 10:41:32.953: digit=o, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 Jan 6 10:41:33.313: vtsp_process_dsp_message: MSG_TX_DIALING_DONE dc_dialing_done() Jan 6 10:41:33.313: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE:R2_IN_ANSWER_PULSE R2 Got Event R2_DIGITS_GENR2_ALERTING Jan 6 10:41:34.313: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE: R2_IN_ANSWER_PULSE R2 Got Event R2_TONE_TIMER Jan 6 10:41:34.313: R2_IN_IDLE:2 r2_in_connect called Jan 6 10:41:34.313: CSM_PROC_IC1_COLLECT_ADDR_INFO: CSM_EVENT_ADDR_INFO_COLLECTED (DNIS=567, ANI=) at slot 2, port 16 Jan 6 10:41:34.313: vtsp_tsp_call_accept_check (sdb=0x61B8F0E0, calling_number= called_number=567): peer_tag=0 Jan 6 10:41:34.313: VDEV_ALLOCATE: failed to allocate a device Jan 6 10:41:34.313: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem Jan 6 10:41:34.313: VDEV_ALLOCATE: failed to allocate a device Jan 6 10:41:34.313: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem Jan 6 10:41:34.313: VDEV_ALLOCATE: failed to allocate a device Jan 6 10:41:34.313: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem Jan 6 10:41:34.313: CSM_PROC_IC3_WAIT_FOR_RES_RESP: CSM_EVENT_RESOURCE_OK at slot 2, port 16 Jan 6 10:41:34.313: vtsp_ic_switch : (voice_vdev= 0x620BF874) Jan 6 10:41:34.313: vtsp_tsp_call_switch_ind (cdb=0x621C5F3C, tsp_info=0x620BF874, calling_number= called_number=567 redir ect_number=): peer_tag=123dc_switch: fsm_pop() Jan 6 10:41:34.313: vtsp_do_call_setup_ind Jan 6 10:41:34.313: vtsp_do_call_setup_ind: Call ID=65683, guid=61FAF610 Jan 6 10:41:34.313: vtsp_do_call_setup_ind: type=0, under_spec=0, name=ab^Lx, id0=1, id1=0, id2=0, calling=123, called=567 Jan 6 10:41:34.317: dsp_cp_tone_off: [] packet_Len=8 channel_id=8529 packet_id=71 Jan 6 10:41:34.317: dsp_idle_mode: [] packet_Len=8 channel_id=8529 packet_id=68 Jan 6 10:41:34.317: dsp_close_voice_channel: [] packet_Len=8 channel_id=8529 packet_id=75 Jan 6 10:41:34.317: vtsp_timer_stop: 67475758 Jan 6 10:41:34.317: csm_vtsp_call_setup_resp (vdev_info=0x620BF874, vtsp_cdb=0x621C5F3C) Jan 6 10:41:34.317: csm_vtsp_call_setup_resp:vdev_common BP TS allocatedat BP_stream0, BP_Ch28 Jan 6 10:41:34.317: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 5, chan 3,BP_stream 0, BP_ch 28 Jan 6 10:41:34.317: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 5, chan 3,BP_stream 0, BP_ch 28vt sp_open_voice_and_set_params Jan 6 10:41:34.317: dsp_close_voice_channel: [0:1 (54)] packet_Len=8 channel_id=8529 packet_id=75 Jan 6 10:41:34.317: dsp_open_voice_channel_20: [0:1 (54)] packet_Len=16 channel_id=8529 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0 time_slot=0 serial_port=0 Jan 6 10:41:34.317: dsp_encap_config_20: [0:1 (54)] packet_Len=24 channel_id=8529 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0 Jan 6 10:41:34.317: dsp_set_playout: [0:1 (54)] packet_Len=18 channel_id=8529 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300 Jan 6 10:41:34.317: dsp_echo_canceller_control: [0:1 (54)] packet_Len=10 channel_id=8529 packet_id=66 flags=0x0 Jan 6 10:41:34.317: dsp_set_gains: [0:1 (54)] packet_Len=12 channel_id=8529 packet_id=91 in_gain=0 out_gain=0 Jan 6 10:41:34.317: dsp_vad_enable: [0:1 (54)] packet_Len=10 channel_id=8529 packet_id=78 thresh=-38act_proceeding Jan 6 10:41:34.321: csm_vtsp_call_proceeding:DST_tdm_chnl call. BP TS allocatedstream 5, chan 3,BP_stream 0, BP_ch 28act_alert Jan 6 10:41:34.345: vtsp_ring_noan_timer_start: 67475761 Jan 6 10:41:34.345: csm_vtsp_call_alert (vtsp_cdb=0x621C5F3C)act_bridge act_caps_ind Jan 6 10:41:34.589: act_caps_ind:Encap 1, Vad 2, Codec 0x4, CodecBytes 20, FaxRate 2, FaxBytes 20 SignalType 0 DtmfRelay 1, Modem 1act_caps_ack Jan 6 10:41:34.589: dsp_idle_mode: [0:1 (54)] packet_Len=8 channel_id=8529 packet_id=68 Jan 6 10:41:34.589: act_caps_ack: codec = 15, ret = 1 Jan 6 10:41:34.589: dsp_cp_tone_off: [0:1 (54)] packet_Len=8 channel_id=8529 packet_id=71 Jan 6 10:41:34.589: dsp_idle_mode: [0:1 (54)] packet_Len=8 channel_id=8529 packet_id=68 Jan 6 10:41:34.589: dsp_encap_config_20: [0:1 (54)] packet_Len=24 channel_id=8529 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0 Jan 6 10:41:34.589: dsp_voice_mode: [0:1 (54)] packet_Len=24 channel_id=8529 packet_id=73 coding_type=20 voice_field_size=20 VAD_flag=1 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay=2 AGC_flag=0act_alert_connect Jan 6 10:41:36.857: vtsp_ring_noan_timer_stop: 67476012 Jan 6 10:41:36.857: dsp_cp_tone_off: [0:1 (54)] packet_Len=8 channel_id=8529 packet_id=71 Jan 6 10:41:36.857: csm_vtsp_call_connect (vtsp_cdb=0x621C5F3C, voice_vdev=0x620BF874) Jan 6 10:41:36.857: CSM_IC5_WAIT_FOR_SWITCH_OVER: CSM_EVENT_MODEM_OFFHOOK at slot 2, port 16 Jan 6 10:41:36.917: CSM_RX_CAS_EVENT_FROM_NEAT:(0018): EVENT_CHANNEL_CONNECTED at slot 2 and port 16 Jan 6 10:41:36.917: CSM_PROC_IC6_WAIT_FOR_CONNECT: CSM_EVENT_DSX0_CONNECTED at slot 2, port 16 Jan 6 10:41:36.921: from NEAT(0): (0/0): TX ANSWERED(ABCD=0101) eefje#
Um diese Debugausgabe besser zu verstehen, lesen Sie E1 R2 Signaling Theory.
eefje#show debug CAS: Channel Associated Signaling debugging is on CSM Voice: Voice Call Switching Module debugging is on Voice Telephony session debugging is on Voice Telephony dsp debugging is on Voice Telephony error debugging is on eefje# eefje# eefje# Jan 6 09:53:42.389: from NEAT(0): (0/2): Rx SEIZURE(ABCD=0001) Jan 6 09:53:42.433: VDEV_ALLOCATE: failed to allocate a device Jan 6 09:53:42.433: VDEV_ALLOCATE: 1/27 is allocated Jan 6 09:53:42.433: csm_vtsp_init_tdm (voice_vdev=0x620BF320) Jan 6 09:53:42.433: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm slot 2, dspm 1, dsp 4, dsp_channel 4 Jan 6 09:53:42.433: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm stream 7, channel 0, bank 4, BP_channel 3, BP_stream 255 Jan 6 09:53:42.433: CSM_RX_CAS_EVENT_FROM_NEAT:(cid0017): EVENT_CALL_DIAL_IN at slot 2 and port 15 Jan 6 09:53:42.433: CSM_PROC_IDLE: CSM_EVENT_START_DIGIT_COLLECT at slot 2, port 15 Jan 6 09:53:42.433: csm_vtsp_start_digit_collect (voice_vdev=0x620BF320) Jan 6 09:53:42.433: Enter csm_connect_pri_vdev function Jan 6 09:53:42.433: csm_connect_pri_vdev:tdm_allocate_BP_Ts()call. BP TS allocated at BP_stream0, BP_Ch27,vdev_common 0x6 20BF390 Jan 6 09:53:42.433: to NEAT:(cid0017) EVENT_CHANNEL_LOCK for slot0 ctlr0 chan2 Jan 6 09:53:42.433: vtsp_do_call_setup_ind Jan 6 09:53:42.433: vtsp_do_call_setup_ind: Call ID=65675, guid=61FAF610 Jan 6 09:53:42.433: vtsp_do_call_setup_ind: type=0, under_spec=0, name=, id0=0, id1=0, id2=0, calling=, called= Jan 6 09:53:42.433: vtsp_do_call_setup_ind: redirect DN = reason = 0vtsp_open_voice_and_set_params Jan 6 09:53:42.433: dsp_close_voice_channel: [0:1:2] packet_Len=8 channel_id=8516 packet_id=75 Jan 6 09:53:42.433: dsp_open_voice_channel_20: [0:1:2] packet_Len=16 channel_id=8516 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0 time_slot=1 serial_port=1 Jan 6 09:53:42.433: dsp_encap_config_20: [0:1:2] packet_Len=24 channel_id=8516 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0 Jan 6 09:53:42.433: dsp_set_playout: [0:1:2] packet_Len=18 channel_id=8516 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300 Jan 6 09:53:42.433: dsp_echo_canceller_control: [0:1:2] packet_Len=10 channel_id=8516 packet_id=66 flags=0x0 Jan 6 09:53:42.437: dsp_set_gains:[0:1:2] packet_Len=12 channel_id=8516 packet_id=91 in_gain=0 out_gain=0 Jan 6 09:53:42.437: dsp_vad_enable: [0:1:2] packet_Len=10 channel_id=8516 packet_id=78 thresh=-38 Jan 6 09:53:42.437: dsp_voice_mode: [0:1:2] packet_Len=24 channel_id=8516 packet_id=73 coding_type=1 voice_field_size=80 VAD_flag=0 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay=2 AGC_flag=0vtsp_do_r2_start_digit(): dsp_dtmf_mode() dsp_dtmf_mode(VTSP_TONE_R2_MF_FORWARD_MODE) Jan 6 09:53:42.437: dsp_dtmf_mode: [0:1:2] packet_Len=10 channel_id=8516 packet_id=65 dtmf_or_mf=1vtsp_do_r2_start_digit(): fsm_push(vtsp_r2_state_table) Jan 6 09:53:42.437: csm_vtsp_call_setup_resp (vdev_info=0x620BF320, vtsp_cdb=0x621C5F3C) Jan 6 09:53:42.437: csm_vtsp_call_setup_resp:vdev_common BP TS allocatedat BP_stream0, BP_Ch27 Jan 6 09:53:42.437: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 7, chan 0,BP_stream 255, BP_ch 3 Jan 6 09:53:42.437: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 7, chan 0,BP_stream 0, BP_ch 27 Jan 6 09:53:42.437: CSM_PROC_IC1_COLLECT_ADDR_INFO: CSM_EVENT_MODEM_OFFHOOK (DNIS=, ANI=) at slot 2, port 15 Jan 6 09:53:42.437: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_IDLE R2 Got Event R2_START Jan 6 09:53:42.533: CSM_RX_CAS_EVENT_FROM_NEAT:(0017):EVENT_START_RX_TONE at slot 2 and port 15 Jan 6 09:53:42.533: from NEAT(0): (0/2): TX SEIZURE_ACK (ABCD=1101) !--- Digit 5 is sent: Forward Signal Group I-5. Jan 6 09:53:42.641: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=5, rtp_timestamp=0x9330B42B dc_digit_up Jan 6 09:53:42.641: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C) received digit (5) Jan 6 09:53:42.641: CSM voice (2/15): Rcvd Digit detected(5) Jan 6 09:53:42.641: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_COLLECT_DNIS R2 Got Event 5 !--- Digit 1 sent (pulse): Backward Signal Group A-1 (Send next digit) !--- "#" this indicates that it is a pulse). Jan 6 09:53:42.641: vtsp_r2_generate_digits: vdev_common=0x620BF390, string=5dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1# Jan 6 09:53:42.641: dsp_dtmf_dialing: [0:1:2] packet_Len=36 channel_id=8516 packet_id=90 string=1# digits=2, time_on=150, time_off=30 Jan 6 09:53:42.641: digit=`, components=2, freq_of_first=1020, freq_of_second=1140, amp_of_first=8192, amp_of_second=8192 Jan 6 09:53:42.641: digit=o, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 Jan 6 09:53:42.741: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=5, duration=8291dc_digit Jan 6 09:53:42.741: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C) received digit (5) Jan 6 09:53:42.741: CSM voice (2/15): Rcvd Digit detected(5) Jan 6 09:53:42.741: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF !--- Digit 6 is sent: Forward Signal Group I. Jan 6 09:53:42.881: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=6, rtp_timestamp=0x9330B42B dc_digit_up Jan 6 09:53:42.881: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C)received digit (6) Jan 6 09:53:42.881: CSM voice (2/15): Rcvd Digit detected(6) Jan 6 09:53:42.881: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_COLLECT_DNIS R2 Got Event 6 !--- Digit 1 sent (pulse): Backward Signal Group A-1. (Send next digit.) Jan 6 09:53:42.881: vtsp_r2_generate_digits: vdev_common=0x620BF390, string=56dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1# Jan 6 09:53:42.881: dsp_dtmf_dialing: [0:1:2] packet_Len=36 channel_id=8516 packet_id=90 string=1# digits=2, time_on=150, time_off=30 Jan 6 09:53:42.881: digit=`, components=2, freq_of_first=1020, freq_of_second=1140, amp_of_first=8192, amp_of_second=8192 Jan 6 09:53:42.881: digit=o, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 Jan 6 09:53:42.981: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=6, duration=8291dc_digit Jan 6 09:53:42.981: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C) received digit (6) Jan 6 09:53:42.981: CSM voice (2/15): Rcvd Digit detected(6) Jan 6 09:53:42.981: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF !--- Digit 7 is sent: Forward Signal Group I-7. Jan 6 09:53:43.121: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=7, rtp_timestamp=0x9330B42B dc_digit_up Jan 6 09:53:43.121: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C)received digit (7) Jan 6 09:53:43.121: CSM voice (2/15): Rcvd Digit detected(7) Jan 6 09:53:43.121: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_COLLECT_DNIS R2 Got Event 7 !--- Send digit 1 (pulse): Backward Signal Group A-1. Jan 6 09:53:43.121: vtsp_r2_generate_digits: vdev_common=0x620BF390, string=567dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1# Jan 6 09:53:43.121: dsp_dtmf_dialing: [0:1:2] packet_Len=36 channel_id=8516 packet_id=90 string=1# digits=2, time_on=150, time_off=30 Jan 6 09:53:43.121: digit=`, components=2, freq_of_first=1020, freq_of_second=1140, amp_of_first=8192, amp_of_second=8192 Jan 6 09:53:43.121: digit=o, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 Jan 6 09:53:43.221: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=7, duration=8291dc_digit Jan 6 09:53:43.221: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C) received digit (7) Jan 6 09:53:43.221: CSM voice (2/15): Rcvd Digit detected(7) Jan 6 09:53:43.221: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF Jan 6 09:53:43.489: vtsp_process_dsp_message: MSG_TX_DIALING_DONEdc_dialing_done() !--- Timeout is 3 seconds. Jan 6 09:53:46.121: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_TIMER !--- Digit 3 sent(pulse): Backward Signal Group A-3. !--- (Address-complete, changeover to reception of Group-B signals). Jan 6 09:53:46.121: vtsp_r2_generate_digits: vdev_common=0x620BF390, string=567dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 3# Jan 6 09:53:46.121: dsp_dtmf_dialing: [0:1:2] packet_Len=36 channel_id=8516 packet_id=90 string=3# digits=2, time_on=150, time_off=30 Jan 6 09:53:46.121: digit=b, components=2, freq_of_first=1020, freq_of_second=900, amp_of_first=8192, amp_of_second=8192 Jan 6 09:53:46.121: digit=o, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 !--- Digit 1 is sent: Forward Signal Group II-1 !--- (subscriber without priority). Jan 6 09:53:46.361: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=1, rtp_timestamp=0x9330B42B dc_digit_up Jan 6 09:53:46.361: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C) received digit (1) Jan 6 09:53:46.361: CSM voice (2/15): Rcvd Digit detected(1) Jan 6 09:53:46.361: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_CATEGORY R2 Got Event 1 Jan 6 09:53:46.361: r2_comp_category:R2_ALERTING !--- Digit 6 sent (pulse): Backward Signal Group B-6 !--- (the subscriber line free of charge). Jan 6 09:53:46.361: vtsp_r2_generate_digits: vdev_common=0x620BF390, string=567dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 6# Jan 6 09:53:46.361: dsp_dtmf_dialing: [0:1:2] packet_Len=36 channel_id=8516 packet_id=90 string=6# digits=2, time_on=150, time_off=30 Jan 6 09:53:46.361: digit=e, components=2, freq_of_first=900, freq_of_second=780, amp_of_first=8192, amp_of_second=8192 Jan 6 09:53:46.361: digit=o, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 Jan 6 09:53:46.461: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF:digit=1, duration=8291dc_digit Jan 6 09:53:46.461: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C)received digit (1) Jan 6 09:53:46.461: CSM voice (2/15): Rcvd Digit detected(1) Jan 6 09:53:46.461: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_COMPLETE R2 Got Event R2_TONE_OFF Jan 6 09:53:46.729: vtsp_process_dsp_message: MSG_TX_DIALING_DONEdc_dialing_done() Jan 6 09:53:47.461: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_WAIT_GUARD R2 Got Event R2_TONE_TIMER Jan 6 09:53:47.461: R2_IN_IDLE:2 r2_in_connect called Jan 6 09:53:47.461: CSM_PROC_IC1_COLLECT_ADDR_INFO: CSM_EVENT_ADDR_INFO_COLLECTED (DNIS=567, ANI=) at slot 2, port 15 Jan 6 09:53:47.461: vtsp_tsp_call_accept_check (sdb=0x61B8F0E0,calling_number= called_number=567): peer_tag=0 Jan 6 09:53:47.461: VDEV_ALLOCATE: failed to allocate a device Jan 6 09:53:47.461: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem Jan 6 09:53:47.461: VDEV_ALLOCATE: failed to allocate a device Jan 6 09:53:47.461: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem Jan 6 09:53:47.461: VDEV_ALLOCATE: failed to allocate a device Jan 6 09:53:47.461: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem Jan 6 09:53:47.461: CSM_PROC_IC3_WAIT_FOR_RES_RESP: CSM_EVENT_RESOURCE_OK at slot 2, port 15 Jan 6 09:53:47.461: vtsp_IC_switch : (voice_vdev= 0x620BF320) Jan 6 09:53:47.461: vtsp_tsp_call_switch_ind (cdb=0x621C5F3C,tsp_info=0x620BF320, calling_number= called_number=567 redirect_number=): peer_tag=123dc_switch: fsm_pop() Jan 6 09:53:47.461: vtsp_do_call_setup_ind Jan 6 09:53:47.461: vtsp_do_call_setup_ind: Call ID=65677, guid=61FAF610 Jan 6 09:53:47.461: vtsp_do_call_setup_ind: type=0, under_spec=0, name=AB^Lo, id0=3, id1=0, id2=0, calling=123, called=567 Jan 6 09:53:47.465: dsp_cp_tone_off: [] packet_Len=8 channel_id=8516 packet_id=71 Jan 6 09:53:47.465: dsp_idle_mode: [] packet_Len=8 channel_id=8516 packet_id=68 Jan 6 09:53:47.465: dsp_close_voice_channel: [] packet_Len=8 channel_id=8516 packet_id=75 Jan 6 09:53:47.465: vtsp_timer_stop: 67189073 Jan 6 09:53:47.465: csm_vtsp_call_setup_resp (vdev_info=0x620BF320, vtsp_cdb=0x621C5F3C) Jan 6 09:53:47.465: csm_vtsp_call_setup_resp:vdev_common BP TS allocatedat BP_stream0, BP_Ch27 Jan 6 09:53:47.465: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 7, chan 0,BP_stream 0, BP_ch 27 Jan 6 09:53:47.465: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 7, chan 0,BP_stream 0, BP_ch 27vtsp_open_voice_and_set_params Jan 6 09:53:47.465: dsp_close_voice_channel: [0:1 (52)] packet_Len=8 channel_id=8516 packet_id=75 Jan 6 09:53:47.465: dsp_open_voice_channel_20: [0:1 (52)] packet_Len=16 channel_id=8516 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0 time_slot=1 serial_port=1 Jan 6 09:53:47.465: dsp_encap_config_20: [0:1 (52)] packet_Len=24 channel_id=8516 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0 Jan 6 09:53:47.465: dsp_set_playout: [0:1 (52)] packet_Len=18 channel_id=8516 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300 Jan& 6 09:53:47.465: dsp_echo_canceller_control: [0:1 (52)] packet_Len=10 channel_id=8516 packet_id=66 flags=0x0 Jan 6 09:53:47.465: dsp_set_gains: [0:1 (52)] packet_Len=12 channel_id=8516 packet_id=91 in_gain=0 out_gain=0 Jan 6 09:53:47.465: dsp_vad_enable: [0:1 (52)] packet_Len=10 channel_id=8516 packet_id=78 thresh=-38act_proceeding Jan 6 09:53:47.469: csm_vtsp_call_proceeding:DST_tdm_chnl call. BP TS allocatedstream 7, chan 0,BP_stream 0, BP_ch 27act_alert Jan 6 09:53:47.493: vtsp_ring_noan_timer_start: 67189076 Jan 6 09:53:47.493: csm_vtsp_call_alert (vtsp_cdb=0x621C5F3C) act_bridge act_caps_ind Jan 6 09:53:47.737: act_caps_ind:Encap 1, Vad 2, Codec 0x4, CodecBytes 20, FaxRate 2, FaxBytes 20 SignalType 0 DtmfRelay 1, Modem 1act_caps_ack Jan 6 09:53:47.737: dsp_idle_mode: [0:1 (52)] packet_Len=8 channel_id=8516 packet_id=68 Jan 6 09:53:47.737: act_caps_ack: codec = 15, ret = 1 Jan 6 09:53:47.737: dsp_cp_tone_off: [0:1 (52)] packet_Len=8 channel_id=8516 packet_id=71 Jan 6 09:53:47.737: dsp_idle_mode: [0:1 (52)] packet_Len=8 channel_id=8516 packet_id=68 Jan 6 09:53:47.737: dsp_encap_config_20: [0:1 (52)] packet_Len=24 channel_id=8516 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0 Jan 6 09:53:47.737: dsp_voice_mode: [0:1 (52)] packet_Len=24 channel_id=8516 packet_id=73 coding_type=20 voice_field_size= 20 VAD_flag=1 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay=2 AGC_flag=0act_alert_connect Jan 6 09:53:49.461: vtsp_ring_noan_timer_stop: 67189273 Jan 6 09:53:49.461: dsp_cp_tone_off: [0:1 (52)] packet_Len=8 channel_id=8516 packet_id=71 Jan 6 09:53:49.461: csm_vtsp_call_connect (vtsp_cdb=0x621C5F3C, voice_vdev=0x620BF320) Jan 6 09:53:49.461: CSM_IC5_WAIT_FOR_SWITCH_OVER: CSM_EVENT_MODEM_OFFHOOK at slot 2, port 15 Jan 6 09:53:49.617: CSM_RX_CAS_EVENT_FROM_NEAT:(0017): EVENT_CHANNEL_CONNECTED at slot 2 and port 15 Jan 6 09:53:49.617: CSM_PROC_IC6_WAIT_FOR_CONNECT: CSM_EVENT_DSX0_CONNECTED at slot 2, port 15 Jan 6 09:53:49.621: from NEAT(0): (0/2): TX ANSWERED(ABCD=0101) eefje# eefje#
Um diese Debug-Ausgabe besser zu verstehen, lesen Sie E1 R2 Signaling Theory.
eefje#debug csm voice Voice Call Switching Module debugging is on eefje#debug cas Channel Associated Signaling debugging is on Jan 7 10:00:02.907: from NEAT(0): debug-cas is on Jan 7 10:00:02.907: from NEAT(0): special debug-cas is offg vtsp all Voice telephony call control all debugging is on eefje# eefje# Jan 7 10:00:23.883: from NEAT(0): (0/8): Rx SEIZURE (ABCD=0001) Jan 7 10:00:23.927: VDEV_ALLOCATE: failed to allocate a device Jan 7 10:00:23.927: VDEV_ALLOCATE: 1/2 is allocated Jan 7 10:00:23.927: csm_vtsp_init_tdm (voice_vdev=0x61F19688) Jan 7 10:00:23.927: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm slot 1, dspm 3, dsp 4, dsp_channel 1 Jan 7 10:00:23.927: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm stream 5, channel 13, bank 0, BP_channel 15, BP_stream 255 Jan 7 10:00:23.927: CSM_RX_CAS_EVENT_FROM_NEAT:(cid0007): EVENT_CALL_DIAL_IN at slot 1 and port 60 Jan 7 10:00:23.927: CSM_PROC_IDLE: CSM_EVENT_START_DIGIT_COLLECT at slot 1, port 60 Jan 7 10:00:23.927: csm_vtsp_start_digit_collect (voice_vdev=0x61F19688) Jan 7 10:00:23.927: Enter csm_connect_pri_vdev function Jan 7 10:00:23.927: csm_connect_pri_vdev:tdm_allocate_BP_Ts() call. BP TS allocated at BP_stream0, BP_Ch8,vdev_common 0x6205E5F8 Jan 7 10:00:23.927: to NEAT:(cid0007) EVENT_CHANNEL_LOCK for slot0 ctlr0 chan8 Jan 7 10:00:23.927: vtsp_do_call_setup_ind Jan 7 10:00:23.927: vtsp_do_call_setup_ind: Call ID=65579, guid=62031A88 Jan 7 10:00:23.927: vtsp_do_call_setup_ind: type=0, under_spec=0, name=, id0=0, id1=0,id2=0, calling=, called= Jan 7 10:00:23.927: vtsp_do_call_setup_ind: redirect DN = reason = 0vtsp_do_r2_start_digit(): fsm_push(vtsp_r2_state_table) Jan 7 10:00:23.927: csm_vtsp_call_setup_resp (vdev_info=0x61F19688, vtsp_cdb=0x61B5BFF8) Jan 7 10:00:23.927: csm_vtsp_call_setup_resp:vdev_common BP TS allocatedat BP_stream0, BP_Ch8 Jan 7 10:00:23.927: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 5, chan 13,BP_stream 255, BP_ch 15 Jan 7 10:00:23.927: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 5, chan 13,BP_stream 0, BP_ch 8 Jan 7 10:00:23.927: CSM_PROC_IC1_COLLECT_ADDR_INFO: CSM_EVENT_MODEM_OFFHOOK (DNIS=, ANI=) at slot 1, port 60 Jan 7 10:00:23.931: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE: R2_IN_IDLE R2 Got Event R2_START Jan 7 10:00:24.027: CSM_RX_CAS_EVENT_FROM_NEAT:(0007): EVENT_START_RX_TONE at slot 1 and port 60 Jan 7 10:00:24.027: from NEAT(0): (0/8): TX SEIZURE_ACK (ABCD=1101)dc_init_dsp vtsp_open_voice_and_set_params Jan 7 10:00:24.151: dsp_close_voice_channel: [0:1:8] packet_Len=8 channel_id=4929 packet_id=75 Jan 7 10:00:24.151: dsp_open_voice_channel_20: [0:1:8] packet_Len=16 channel_id=4929 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0 time_slot=0 serial_port=0 Jan 7 10:00:24.151: dsp_encap_config_20: [0:1:8] packet_Len=24 channel_id=4929 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0 Jan 7 10:00:24.151: dsp_set_playout: [0:1:8] packet_Len=18 channel_id=4929 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300 Jan 7 10:00:24.151: dsp_echo_canceller_control: [0:1:8] packet_Len=10 channel_id=4929 packet_id=66 flags=0x0 Jan 7 10:00:24.151: dsp_set_gains: [0:1:8] packet_Len=12 channel_id=4929 packet_id=91 in_gain=0 out_gain=0 Jan 7 10:00:24.151: dsp_vad_enable: [0:1:8] packet_Len=10 channel_id=4929 packet_id=78 thresh=-38 Jan 7 10:00:24.151: dsp_voice_mode: [0:1:8] packet_Len=24 channel_id=4929 packet_id=73 coding_type=1 voice_field_size=80 VAD_flag=0 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay=2 AGC_flag=0dsp_dtmf_mode (VTSP_TONE_R2_MF_FORWARD_MODE) Jan 7 10:00:24.151: dsp_dtmf_mode: [0:1:8] packet_Len=10 channel_id=4929 packet_id=65dtmf_or_mf=1 !--- Digit 5 is sent: Forward Signal Group I-5 (First DNIS digit). Jan 7 10:00:24.203: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=5, rtp_timestamp=0x04030000 dc_digit_up Jan 7 10:00:24.203: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)received digit (5) Jan 7 10:00:24.203: CSM voice (1/60): Rcvd Digit detected(5) Jan 7 10:00:24.203: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_PRE_CALLERID R2 Got Event 5 !--- Send Backward Signal Group A-5 (caller category request). Jan 7 10:00:24.203: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 5 Jan 7 10:00:24.203: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929packet_id=90 string=5 digits=1, time_on=65435, time_off=30 Jan 7 10:00:24.203: digit=, components=2, freq_of_first=1020, freq_of_second=780, amp_of_first=8192, amp_of_second=8192 Jan 7 10:00:24.303: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF:digit=5, duration=30dc_digit Jan 7 10:00:24.303: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (5) Jan 7 10:00:24.303: CSM voice (1/60): Rcvd Digit detected(5) Jan 7 10:00:24.303: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2 Got Event R2_TONE_OFF Jan 7 10:00:24.303: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = # Jan 7 10:00:24.303: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=# digits=1, time_on=150, time_off=30 Jan 7 10:00:24.303: digit=, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 !--- Caller Category Forward Signal Group II-1 is sent. Jan 7 10:00:24.403: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=1, rtp_timestamp=0x001E0010 dc_digit_up Jan 7 10:00:24.403: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)received digit (1) Jan 7 10:00:24.403: CSM voice (1/60): Rcvd Digit detected(1) Jan 7 10:00:24.403: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2 Got Event 1 !--- Send Backward Signal Group A-5 (Caller ID request). Jan 7 10:00:24.403: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 5 Jan 7 10:00:24.403: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=5 digits=1, time_on=65435, time_off=30 Jan 7 10:00:24.403: digit=, components=2, freq_of_first=1020, freq_of_second=780, amp_of_first=8192, amp_of_second=8192 Jan 7 10:00:24.503: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=1, duration=30dc_digit Jan 7 10:00:24.503: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (1) Jan 7 10:00:24.503: CSM voice (1/60): Rcvd Digit detected(1) Jan 7 10:00:24.503: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2 Got Event R2_TONE_OFF Jan 7 10:00:24.503: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = # Jan 7 10:00:24.503: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=# digits=1, time_on=150, time_off=30 Jan 7 10:00:24.503: digit=, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 !--- First ANI digit is sent: Forward Signal Group I-1. Jan 7 10:00:24.603: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=1, rtp_timestamp=0x001E0010 dc_digit_up Jan 7 10:00:24.603: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8) received digit (1) Jan 7 10:00:24.603: CSM voice (1/60): Rcvd Digit detected(1) Jan 7 10:00:24.603: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2 Got Event 1 !--- Send Backward Signal Group A-5 (Caller ID request). Jan 7 10:00:24.603: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 5 Jan 7 10:00:24.603: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=5 digits=1, time_on=65435, time_off=30 Jan 7 10:00:24.603: digit=, components=2, freq_of_first=1020, freq_of_second=780, amp_of_first=8192, amp_of_second=8192 Jan 7 10:00:24.703: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=1, duration=30dc_digit Jan 7 10:00:24.703: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (1) Jan 7 10:00:24.703: CSM voice (1/60): Rcvd Digit detected(1) Jan 7 10:00:24.703: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2 Got Event R2_TONE_OFF Jan 7 10:00:24.703: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = # Jan 7 10:00:24.703: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=# digits=1, time_on=150, time_off=30 Jan 7 10:00:24.703: digit=, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 !--- Second ANI digit is sent: Forward Signal Group I-2. Jan 7 10:00:24.803: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN:digit=2, rtp_timestamp=0x001E0010 dc_digit_up Jan 7 10:00:24.803: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8) received digit (2) Jan 7 10:00:24.803: CSM voice (1/60): Rcvd Digit detected(2) Jan 7 10:00:24.803: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2 Got Event 2 !--- Send Backward Signal Group A-5 (Caller ID request). Jan 7 10:00:24.803: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 5 Jan 7 10:00:24.803: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929packet_id=90 string=5 digits=1, time_on=65435, time_off=30 Jan 7 10:00:24.803: digit=, components=2, freq_of_first=1020, freq_of_second=780, amp_of_first=8192, amp_of_second=8192 Jan 7 10:00:24.903: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=2, duration=30dc_digit Jan 7 10:00:24.903: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (2) Jan 7 10:00:24.903: CSM voice (1/60): Rcvd Digit detected(2) Jan 7 10:00:24.903: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2 Got Event R2_TONE_OFF Jan 7 10:00:24.903: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = # Jan 7 10:00:24.903: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=# digits=1, time_on=150, time_off=30 Jan 7 10:00:24.903: digit=, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 !--- Third ANI digit is sent: Forward Signal Group I-3. Jan 7 10:00:25.003: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=3, rtp_timestamp=0x001E0010 dc_digit_up Jan 7 10:00:25.003: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8) received digit (3) Jan 7 10:00:25.003: CSM voice (1/60): Rcvd Digit detected(3) Jan 7 10:00:25.003: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2 Got Event 3 !--- Send Backward Signal Group A-5 (Caller ID request). Jan 7 10:00:25.003: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 5 Jan 7 10:00:25.003: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=5 digits=1, time_on=65435, time_off=30 Jan 7 10:00:25.003: digit=, components=2, freq_of_first=1020, freq_of_second=780, amp_of_first=8192, amp_of_second=8192 Jan 7 10:00:25.103: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF:digit=3, duration=30dc_digit Jan 7 10:00:25.103: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (3) Jan 7 10:00:25.103: CSM voice (1/60): Rcvd Digit detected(3) Jan 7 10:00:25.103: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2 Got Event R2_TONE_OFF Jan 7 10:00:25.103: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = # Jan 7 10:00:25.103: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=# digits=1, time_on=150, time_off=30 Jan 7 10:00:25.103: digit=, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 !--- Digit 15 is sent: Forward Signal Group I-15 (end of ANI digit). Jan 7 10:00:25.203: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=15, rtp_timestamp=0x001E0010 dc_digit_up Jan 7 10:00:25.203: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8) received digit (*) Jan 7 10:00:25.203: CSM voice (1/60): Rcvd Digit detected(*) Jan 7 10:00:25.203: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2 Got Event 15 !--- Send Backward Signal Group A-1 (next DNIS digit). Jan 7 10:00:25.203: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1 Jan 7 10:00:25.203: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=1 digits=1, time_on=65435, time_off=30 Jan 7 10:00:25.203: digit=, components=2, freq_of_first=1020, freq_of_second=1140, amp_of_first=8192, amp_of_second=8192 Jan 7 10:00:25.303: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=15, duration=30dc_digit Jan 7 10:00:25.303: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (*) Jan 7 10:00:25.303: CSM voice (1/60): Rcvd Digit detected(*) Jan 7 10:00:25.303: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF Jan 7 10:00:25.303: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = # Jan 7 10:00:25.303: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=# digits=1, time_on=150, time_off=30 Jan 7 10:00:25.303: digit=, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 !--- Second DNIS digit is sent: Forward Signal Group I-6. Jan 7 10:00:25.391: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=6, rtp_timestamp=0x001E0010 dc_digit_up Jan 7 10:00:25.391: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8) received digit (6) Jan 7 10:00:25.391: CSM voice (1/60): Rcvd Digit detected(6) Jan 7 10:00:25.391: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_COLLECT_DNIS R2 Got Event 6 !--- Send Backward Signal Group A-1. Jan 7 10:00:25.391: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=56dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1 Jan 7 10:00:25.391: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=1 digits=1, time_on=65435, time_off=30 Jan 7 10:00:25.391: digit=, components=2, freq_of_first=1020, freq_of_second=1140, amp_of_first=8192, amp_of_second=8192 Jan 7 10:00:25.491: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF:digit=6, duration=30dc_digit Jan 7 10:00:25.491: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (6) Jan 7 10:00:25.491: CSM voice (1/60): Rcvd Digit detected(6) Jan 7 10:00:25.491: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF Jan 7 10:00:25.491: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=56dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = # Jan 7 10:00:25.491: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=# digits=1, time_on=150, time_off=30 Jan 7 10:00:25.491: digit=, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 !--- Third DNIS digit is sent: Forward Signal Group I-7. Jan 7 10:00:25.583: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=7, rtp_timestamp=0x001E0010 dc_digit_up Jan 7 10:00:25.583: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8) received digit (7) Jan 7 10:00:25.583: CSM voice (1/60): Rcvd Digit detected(7) Jan 7 10:00:25.583: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_COLLECT_DNIS R2 Got Event 7 !--- Send Backward Signal Group A-1. Jan 7 10:00:25.583: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=567dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1 Jan 7 10:00:25.583: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=1 digits=1, time_on=65435, time_off=30 Jan 7 10:00:25.583: digit=, components=2, freq_of_first=1020, freq_of_second=1140, amp_of_first=8192, amp_of_second=8192 Jan 7 10:00:25.683: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=7, duration=30dc_digit Jan 7 10:00:25.683: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (7) Jan 7 10:00:25.683: CSM voice (1/60): Rcvd Digit detected(7) Jan 7 10:00:25.683: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF Jan 7 10:00:25.683: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=567dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = # Jan 7 10:00:25.683: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929 packet_id=90 string=# digits=1, time_on=150, time_off=30 Jan 7 10:00:25.683: digit=, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 Jan 7 10:00:25.835: vtsp_process_dsp_message: MSG_TX_DIALING_DONEdc_dialing_done() !--- Timeout is 3 seconds. Jan 7 10:00:28.583: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_TIMER !--- Send Backward Signal Group A-3: address-complete, changeover !--- to reception of group-B signal. Jan 7 10:00:28.583: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=567dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 3# Jan 7 10:00:28.583: dsp_dtmf_dialing: [0:1:8] packet_Len=36 channel_id=4929 packet_id=90 string=3# digits=2, time_on=150, time_off=30 Jan 7 10:00:28.583: digit=, components=2, freq_of_first=1020, freq_of_second=900, amp_of_first=8192, amp_of_second=8192 Jan 7 10:00:28.583: digit=, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1 !--- Forward Signal Group II-1 is sent: subscriber without priority. Jan 7 10:00:28.831: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=1, rtp_timestamp=0x001E0003 dc_digit_up Jan 7 10:00:28.831: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8) received digit (1) Jan 7 10:00:28.831: CSM voice (1/60): Rcvd Digit detected(1) Jan 7 10:00:28.831: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CATEGORY R2 Got Event 1 Jan 7 10:00:28.831: CSM_PROC_IC1_COLLECT_ADDR_INFO: CSM_EVENT_ADDR_INFO_COLLECTED (DNIS=567, ANI=123) at slot 1, port 60 Jan 7 10:00:28.831: vtsp_tsp_call_accept_check (sdb=0x61DADEE0, calling_number=123 called_number=567): peer_tag=0 Jan 7 10:00:28.835: VDEV_ALLOCATE: failed to allocate a device Jan 7 10:00:28.835: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem Jan 7 10:00:28.835: VDEV_ALLOCATE: failed to allocate a device Jan 7 10:00:28.835: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem Jan 7 10:00:28.835: VDEV_ALLOCATE: failed to allocate a device Jan 7 10:00:28.835: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem Jan 7 10:00:28.835: CSM_PROC_IC3_WAIT_FOR_RES_RESP: CSM_EVENT_RESOURCE_OK at slot 1, port 60 Jan 7 10:00:28.835: vtsp_IC_switch : (voice_vdev= 0x61F19688) Jan 7 10:00:28.835: vtsp_tsp_call_switch_ind (cdb=0x61B5BFF8, tsp_info=0x61F19688, calling_number=123 called_number=567 redirect_number=): peer_tag=123dc_switch: fsm_pop() Jan 7 10:00:28.835: vtsp_do_call_setup_ind Jan 7 10:00:28.835: vtsp_do_call_setup_ind: Call ID=65581, guid=62031A88 Jan 7 10:00:28.835: vtsp_do_call_setup_ind: type=0, under_spec=0, name=b`, id0=9, id1=0, id2=0, calling=123, called=567 Jan 7 10:00:28.835: dsp_cp_tone_off: [] packet_Len=8 channel_id=4929 packet_id=71 Jan 7 10:00:28.835: dsp_idle_mode: [] packet_Len=8 channel_id=4929 packet_id=68 Jan 7 10:00:28.835: dsp_close_voice_channel: [] packet_Len=8 channel_id=4929 packet_id=75 Jan 7 10:00:28.835: vtsp_timer_stop: 7063006 Jan 7 10:00:28.839: csm_vtsp_call_setup_resp (vdev_info=0x61F19688, vtsp_cdb=0x61B5BFF8) Jan 7 10:00:28.839: csm_vtsp_call_setup_resp:vdev_common BP TS allocatedat BP_stream0, BP_Ch8 Jan 7 10:00:28.839: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 5, chan 13,BP_stream 0, BP_ch 8 Jan 7 10:00:28.839: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat stream 5, chan 13,BP_stream 0, BP_ch 8vtsp_open_voice_and_set_params Jan 7 10:00:28.839: dsp_close_voice_channel: [0:1 (17)] packet_Len=8 channel_id=4929 packet_id=75 Jan 7 10:00:28.839: dsp_open_voice_channel_20: [0:1 (17)] packet_Len=16 channel_id=4929 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0 time_slot=0 serial_port=0 Jan 7 10:00:28.839: dsp_encap_config_20: [0:1 (17)] packet_Len=24 channel_id=4929 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0t_vpxcc=0x0 r_vpxcc=0x0 Jan 7 10:00:28.839: dsp_set_playout: [0:1 (17)] packet_Len=18 channel_id=4929 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300 Jan 7 10:00:28.839: dsp_echo_canceller_control: [0:1 (17)] packet_Len=10 channel_id=4929 packet_id=66 flags=0x0 Jan 7 10:00:28.839: dsp_set_gains: [0:1 (17)] packet_Len=12 channel_id=4929 packet_id=91 in_gain=0 out_gain=0 Jan 7 10:00:28.839: dsp_vad_enable: [0:1 (17)] packet_Len=10 channel_id=4929 packet_id=78 thresh=-38act_proceeding Jan 7 10:00:28.839: csm_vtsp_call_proceeding:DST_tdm_chnl call. BP TS allocatedstream 5, chan 13,BP_stream 0, BP_ch 8act_alert Jan 7 10:00:28.867: vtsp_ring_noan_timer_start: 7063009 Jan 7 10:00:28.867: csm_vtsp_call_alert (vtsp_cdb=0x61B5BFF8) Jan 7 10:00:28.867: csm_vtsp_call_alert: CSM_EVENT_ALERTING_RECEIVED Jan 7 10:00:28.867: CSM_IC5_WAIT_FOR_SWITCH_OVER: at slot 1, port 60 Jan 7 10:00:28.867: CSM_EVENT_ALERTING_RECEIVED: Jan 7 10:00:28.867: calling alerting_start_event !--- Note: For modems, Backward Signal !--- Group B-6 (subscriber's line free, charge) !--- is sent immediately. !--- For voice, it is delayed until alerting is received. !--- Notice that "R2_REJECT" is printed instead of R2_ALERTING. !--- This printing issue is solved in Cisco IOS Software Release 12.1T. Jan 7 10:00:28.867: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_IDLE R2 Got Event R2_REJECT Jan 7 10:00:28.867: R2_ALERTING: r2_comp_idle Jan 7 10:00:28.867: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=567act_bridge Jan 7 10:00:28.867: dsp_voice_mode: [0:1 (17)] packet_Len=24 channel_id=4929 packet_id=73 coding_type=1 voice_field_size=80 VAD_flag=0 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay=2 AGC_flag=0dsp_dtmf_mode (VTSP_TONE_R2_MF_FORWARD_MODE) !--- Answer signal (B-6) is sent after alerting is received. !--- Send Backward Signal Group B6 signal (Subscriber's line free, charge). Jan 7 10:00:28.871: dsp_dtmf_mode: [0:1 (17)] packet_Len=10 channel_id=4929 packet_id=65 dtmf_or_mf=1vtsp_r2_dial vtsp_r2_dial(): fsm_push(vtsp_r2_state_table) dsp_dtmf_dialing(): dial_string = 6 Jan 7 10:00:28.871: dsp_dtmf_dialing: [0:1 (17)] packet_Len=24 channel_id=4929 packet_id=90 string=6 digits=1, time_on=65435, time_off=30 Jan 7 10:00:28.871: digit=, components=2, freq_of_first=900, freq_of_second=780, amp_of_first=8192, amp_of_second=8192 Jan 7 10:00:28.923: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=1, rtp_timestamp=0x001E0006 dc_digit_up Jan 7 10:00:28.923: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8) received digit (1) Jan 7 10:00:28.923: CSM voice (1/60): Rcvd Digit detected(1) Jan 7 10:00:28.923: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE: R2_IN_COMPLETE R2 Got Event 1 Jan 7 10:00:28.971: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=1, duration=30dc_digit Jan 7 10:00:28.971: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (1) Jan 7 10:00:28.971: CSM voice (1/60): Rcvd Digit detected(1) Jan 7 10:00:28.971: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE: R2_IN_COMPLETE R2 Got Event R2_TONE_OFF Jan 7 10:00:28.971: vtsp_r2_generate_digits: vdev_common=0x6205E5F8, string=567dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = # Jan 7 10:00:28.971: dsp_dtmf_dialing: [0:1 (17)] packet_Len=24 channel_id=4929 packet_id=90 string=# digits=1, time_on=150, time_off=30 Jan 7 10:00:28.975: digit=, components=2, freq_of_first=0, freq_of_second=0, amp_of_first=1, amp_of_second=1ds_dialing_defaultds_dialing_default Jan 7 10:00:29.127: vtsp_process_dsp_message: MSG_TX_DIALING_DONEdc_dialing_done() Jan 7 10:00:29.971: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE: R2_IN_WAIT_GUARD R2 Got Event R2_TONE_TIMER Jan 7 10:00:29.971: R2_IN_IDLE:2 r2_in_connect called Jan 7 10:00:29.971: R2_IN_CONNECT: call end dial Jan 7 10:00:29.971: pop the dial state machine Jan 7 10:00:29.971: vtsp_r2_end_dial: vdev_common=0x6205E5F8, string=567ds_end_dial(): fsm_pop() act_caps_ind Jan 7 10:00:29.971: act_caps_ind:Encap 1, Vad 2, Codec 0x4, CodecBytes 20, FaxRate 2, FaxBytes 20 SignalType 0 DtmfRelay 1, Modem 1act_caps_ack Jan 7 10:00:29.971: dsp_idle_mode: [0:1 (17)] packet_Len=8 channel_id=4929 packet_id=68 Jan 7 10:00:29.971: act_caps_ack: codec = 15, ret = 1 Jan 7 10:00:29.971: dsp_cp_tone_off: [0:1 (17)] packet_Len=8 channel_id=4929 packet_id=71 Jan 7 10:00:29.971: dsp_idle_mode: [0:1 (17)] packet_Len=8 channel_id=4929 packet_id=68 Jan 7 10:00:29.971: dsp_encap_config_20: [0:1 (17)] packet_Len=24 channel_id=4929 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0 Jan 7 10:00:29.971: dsp_voice_mode: [0:1 (17)] packet_Len=24 channel_id=4929 packet_id=73 coding_type=19 voice_field_size=20 VAD_flag=1 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay=2 AGC_flag=0act_alert_connect Jan 7 10:00:30.255: vtsp_ring_noan_timer_stop: 7063148 Jan 7 10:00:30.255: dsp_cp_tone_off: [0:1 (17)] packet_Len=8 channel_id=4929 packet_id=71 Jan 7 10:00:30.255: csm_vtsp_call_connect (vtsp_cdb=0x61B5BFF8, voice_vdev=0x61F19688) Jan 7 10:00:30.255: CSM_IC5_WAIT_FOR_SWITCH_OVER: CSM_EVENT_MODEM_OFFHOOK at slot 1, port 60 Jan 7 10:00:30.607: CSM_RX_CAS_EVENT_FROM_NEAT:(0007): EVENT_CHANNEL_CONNECTED at slot 1 and port 60 Jan 7 10:00:30.607: CSM_PROC_IC6_WAIT_FOR_CONNECT: CSM_EVENT_DSX0_CONNECTED at slot 1, port 60 Jan 7 10:00:30.607: from NEAT(0): (0/8): TX ANSWERED (ABCD=0101) eefje#