Dépannage des problèmes d'enregistrement intermittent des téléphones Cisco 7800/8800

Introduction

Ce document décrit le processus de dépannage pour les téléphones Cisco 7800 enregistrés sur les annulations intermittentes de Cisco Unified Communications Manager (CUCM) provoquées par des problèmes réseau.

Versions et adressage

CUCM 11.0.1

Téléphone IP 7821, sip78xx.10-3-1-12

PUB CUCM : 10.48.47.143

SUB CUCM : 10.48.47.136

Téléphone IP : 10.62.153.20

Dépannage des problèmes d'enregistrement intermittent des téléphones Cisco 7800

La procédure de dépannage pour les téléphones qui ne s'enregistrent pas par intermittence peut être compliquée, car il est nécessaire de capturer un paquet à partir du téléphone non enregistré.

La solution ou plutôt une solution de contournement pour résoudre ce problème consiste à essayer d'isoler un groupe relativement petit de téléphones ayant le problème. Ensuite, configurez un serveur direct et SSH sur l'interface de ligne de commande de tous ces téléphones. Assurez-vous que les journaux sont écrits dans des fichiers journaux externes.

Activer l'accès SSH du téléphone

Dans la page Administration CUCM, accédez à Device -> Phone. Sélectionnez le téléphone dont vous avez besoin pour dépanner et sous Configuration spécifique au produit -> SSH Access set Enable settings. Vous devez également configurer la connexion SSH et le mot de passe dans la section Informations sur Secure Shell comme indiqué ci-dessous.

Activer les journaux téléphoniques

Pour les problèmes d'enregistrement, le dépannage de niveaux de débogage spécifiques doit être configuré sur le téléphone.

Connectez-vous au téléphone via le protocole SSH. Vous devez mettre les informations d'identification deux fois.

Les premières informations d'identification ont été spécifiées dans la configuration Secure Shell Information. Dans l'exemple, il s'agit

login: cisco
password: cisco

La deuxième invite d'informations d'identification s'affiche juste après la première et vous devez taper ce qui suit.

snoopyplus login: debug
password: debug

Pour le dépannage de l'enregistrement, activez les débogages suivants.

DEBUG> debug lsm vcm fim fsm gsm sip-messages sip-reg-state sip-adapter snapshot
debugs: sip-adapter fim fsm gsm lsm sip-state sip-messages sip-reg-state ccdefault vcm snapshot

DEBUG> debug jvm SIPCC
DEBUG> Successfully executed the command.

Dans votre jeu de logiciels SSH Client, configurez la journalisation de session à un fichier journal de texte.

Commencez à générer les entrées de débogage dans le client SSH.

DEBUG> sdump

Après avoir tapé la commande ci-dessus, de nombreuses lignes de journaux seront générées.

Scénario de travail

Dans ce scénario, CUCM Publisher (PUB) fonctionne et le seul serveur d'abonnés (SUB) déployé a arrêté le processus CallManager.

Lors de l'analyse du scénario de désinscription du téléphone, vous devez d'abord trouver le dernier enregistrement réussi du téléphone.

Reportez-vous aux résultats typiques des journaux téléphoniques ci-dessous.

Les messages les plus importants sont en gras.

1756 DEB nov 09 12:59:23.444344 JAVA-SIPCC-SIP_STATE : 97/1, sip_reg_sm_change_state : Modification de l'état de l'enregistrement : SIP_REG_STATE_REGISTERED —> SIP_REG_STATE_IDLE

1758 DEB nov 09 12:59:23.445474 JAVA-SIPCC-SIP_STATE : 97/1, sip_reg_sm_change_state : Modification de l'état de l'enregistrement : SIP_REG_STATE_IDLE —> SIP_REG_STATE_IDLE

1766 PAS nov 09 12:59:23.447427 JAVA-ccsip_messaging : sipSPIAddContactHeader : CFGID_DEVICE_NAME = SEPC80084AA8721
1767 PAS nov 09 12:59:23.447580 JAVA-ccsip_messaging : sipSPIAddContactHeader : ccb->call_mode = 0, display_name = 5035
1768 DEB nov 09 12:59:23.447732 JAVA-SIPCC-PLAT_API : platform_get_mac_address : ActiveMacAddr : à partir de Get Val : c800:84aa:8721

1773 DEB nov 09 12:59:23.449563 JAVA-sipio-sent—> REGISTER sip:10.48.47.143 SIP/2.0^M
Via : SIP/2.0/TCP 10.62.153.20:51509 ; branch=z9hG4bK02d4d010^M
Expéditeur: <sip : 5035@10.48.47.143>;tag=c80084aa872100591162d8f8-468984ee^M
Par : <sip:5035@10.48.47.143>^M
ID d'appel : c80084aa-8721001f-10fda170-17017997@10.62.153.20^M
Transfert max. : 70^M
Date : mer, 09 novembre 2016 12:59:23 GMT^M
CSeq : 154 ENREGISTREMENT^M
Agent utilisateur : Cisco-CP7821/10.3.1^M
Contact : <sip : 2fbf6265-bffc-4f99-b8b2-40dce7ed2d19@10.62.153.20:51509;transport=tcp>;+sip.instance="<urn : uid 0000000-0000-0000-0000-c80084aa8721>« ;+u.sip ! devicename.ccm.cisco.com=« SEPC80084AA877 21 »;+u.sip ! model.ccm.cisco.com=« 621 »^M
Pris en charge: remplace,join,sdp-anat,norefersub,resource-priority,extended-reference,X-cisco-callinfo,X-cisco-service-euri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-7.0 0,X-cisco-xsi-8.5.1^M
Longueur de contenu : 0^M
Expire : 3 600^M
^M

1776 DEB nov 09 12:59:23.449899 JAVA-[[MESSAGE_1.0]] : [SIPCC] —> REGISTER sip:10.48.47.143 SIP/2.0() —> [10.48.47.143] :
1777 DEB nov 09 12:59:23.450082 JAVA-SIPCC-SIP_MSG_SEND : ccsip_store_send_msg_for_alarme : Envoyé:REGISTER sip:10.48.47.143 SIP/2.0 Cseq:154 REGISTER CallId:c80084aa-8721001f-10fda170-17017997@10.62.153.20
1778 DEB nov 09 12:59:23.450296 JAVA-SIPCC-SIP_STATE : 97/1, sip_reg_sm_change_state : Modification de l'état de l'enregistrement : SIP_REG_STATE_IDLE —> SIP_REG_STATE_REGISTERING

1780 DEB nov 09 12:59:23.486646 JAVA-sipio-recv<— SIP/2.0 100 Essai^M
Via : SIP/2.0/TCP 10.62.153.20:51509 ; branch=z9hG4bK02d4d010^M
Expéditeur: <sip : 5035@10.48.47.143>;tag=c80084aa872100591162d8f8-468984ee^M
Par : <sip:5035@10.48.47.143>^M
Date : mer, 09 novembre 2016 12:59:24 GMT^M
ID d'appel : c80084aa-8721001f-10fda170-17017997@10.62.153.20^M
CSeq : 154 ENREGISTREMENT^M
Longueur de contenu : 0^M
^M
1782 DEB nov 09 12:59:23.486890 JAVA-[[MESSAGE_1.0]] : [10.48.47.143] —> SIP/2.0 100 Tying() —> [SIPCC] :

1788 DEB nov 09 12:59:23.490033 JAVA-sipio-recv<— SIP/2.0 200 OK^M
Via : SIP/2.0/TCP 10.62.153.20:51509 ; branch=z9hG4bK02d4d010^M
Expéditeur: <sip : 5035@10.48.47.143>;tag=c80084aa872100591162d8f8-468984ee^M
Par : <sip:5035@10.48.47.143>;tag=1785778723^M
Date : mer, 09 novembre 2016 12:59:24 GMT^M
ID d'appel : c80084aa-8721001f-10fda170-17017997@10.62.153.20^M
Serveur : Cisco-CUCM11.0^M
CSeq : 154 ENREGISTREMENT^M
Expire : 120^M
Contact : <sip:2fbf6265-bffc-4f99-b8b2-40dce7ed2d19@10.62.153.20:51509;transport=tcp>;+sip.instance="<urn:uuid:0000000-0000-0000-0000-c80084aa8721>« ;+u.sip !devicle.ccm.cisco.com=« SEPC80084AA8721 »;+u.sip ! model.ccm.cisco.com=« 621 »^M
Pris en charge: X-cisco-srtp-fallback,X-cisco-sis-8.0.0^M
Longueur de contenu : 0^M
^M

1790 DEB nov 09 12:59:23.490247 JAVA-[[MESSAGE_1.0]] : [10.48.47.143] —> SIP/2.0 200 OK() —> [SIPCC] :
1791 DEB nov 09 12:59:23.490400 JAVA-SIPCC-SIP_MSG_SEND : ccsip_store_rcvd_msg_for_alarme : Rcvd:SIP/2.0 200 OK Cseq:154 REGISTER CallId:c80084aa-8721001f-10fda170-17017997@10.62.153.20
1792 DEB nov 09 12:59:23.490949 JAVA-SIPCC-SIP_BRANCH : sip_sm_ccb_match_Branch_cseq : ID de filiale et CSeq correspondants
1793 DEB nov 09 12:59:23.491773 JAVA-SIPCC-SIP_RESP : sipSPICheckResponse : Correspondance de réponse : callid=c80084aa-8721001f-10fda170-17017997@10.62.153.20, cseq=154, cseq_method=REGISTER
1794 DEB nov 09 12:59:23.491956 JAVA-SIPCC-SIP_REG_BULK : 97/0, ccsip_handle_ev_2xx : statut_reg_masse : BULK_REG_SUCCESS, code_reg_resp_vrac : 200

1798 DEB nov 09 12:59:23.493726 JAVA-SIPCC-SIP_STATE : 97/1, sip_reg_sm_change_state : Modification de l'état de l'enregistrement : SIP_REG_STATE_REGISTERING —> SIP_REG_STATE_REGISTERED
1799 DEB nov 09 12:59:23.493848 JAVA-SIPCC-UI_API : ui_set_sip_register_state : LIGNE 1 : ENREGISTRÉ
1800 DEB nov 09 12:59:23.493940 JAVA-SIPCC-UI_API : ui_set_sip_register_state : réinitialiser le MDN.
1801 ERR Nov 09 12:59:23.494215 JAVA-SIPCC-SIP_CC_PROV : ccappFeatureUpdate : événement REG_STATE:line=1,state=1
1802 DEB nov 09 12:59:23.494367 JAVA-SIPCC-SIP_REG_STATE : ccsip_handle_ev_2xx : Bulk_reg=false. Définition de l'état Reg sur TRUE pour la ligne=1
1803 DEB nov 09 12:59:23.494550 JAVA-SIPCC-SIP_TIMER : 97/1, ccsip_handle_ev_2xx : Début du compteur d'expiration (115 secondes)

Désinscription du téléphone après CUCM

Dans ce scénario, le serveur UCS avec CUCM PUB s'est écrasé et le seul serveur SUB a arrêté le processus CallManager.

Note: Il n'y a aucun message explicite indiquant que le téléphone a perdu la connexion TCP.

Une fois que le téléphone tente d'établir une connexion TCP au noeud principal, il commence à essayer de créer une connexion au CUCM secondaire.

Ici, le processus CUCM SUB CallManager est arrêté. Par conséquent, le socket ne peut pas être créé et le secours d'enregistrement échoue.

Deux tentatives d'enregistrement ont été effectuées sur le noeud SUB.

1826 PAS le 09 novembre 13:00:44.003142 JAVA-SIPCC-SIP_FALLBACK : sip_regmgr_ev_tmr_ack_retry : Dans SIP_REG_STATE_IN_FALLBACK, tentative de création de connexion pour envoyer REG

1829 PAS nov 09 13:00:44.003813 JAVA-SIP : sip_tcp_get_free_conn_entry : index renvoyé = 1
1830 ERR nov 09 13:00:44.104500 JAVA-SIPCC-SIP_CC_CONN : sip_tcp_create_connection : échec de la connexion de socket cpr_errno : 1 ipaddr : 10.48.47.136, port : 5060
1831 ERR Nov 09 13:00:44.104653 JAVA-SIPCC-SIP_TRANS : sip_tcp_detach_socket : Nombre maximal de connexions TCP atteint.
1832 PAS le 09 novembre 13:00:44.104836 JAVA-SIPCC-SIP_TCP_MSG : sip_tcp_purge_entry : Socket Fd : 53 fermé pour la troisième phase avec l'adresse : 1, port distant : 170930056
1833 ERR nov 09 13:00:44.104927 JAVA-SIPCC-SIP_CC_CONN : sip_transport_setup_cc_conn : <PRIMARY_CCM>:tcp channel create error server addr=10.48.47.136, échec du port de serveur=5060.
1834 DEB nov 09 13:00:44.105263 JAVA-SNAPSHOT-CREATE : CCAPI_Device_getDeviceInfo : g_deviceInfo.ins_state=1
1835 DEB nov 09 13:00:44.105385 JAVA-SNAPSHOT-CREATE : CCAPI_Device_getDeviceInfo : deviceInfo->sis_name=X-cisco-sis-
1836 DEB nov 09 13:00:44.105477 JAVA-SNAPSHOT-CREATE : CCAPI_Device_getDeviceInfo : pointeur de référence=b31141c0
1837 DEB nov 09 13:00:44.105568 JAVA-SNAPSHOT-CREATE : CCAPI_Device_getDeviceInfo : deviceInfo->ins_state=1
1838 DEB nov 09 13:00:44.105629 JAVA-SIPCC-SIP_CC_PROV : ccsnap_gen_deviceEvent : g_deviceInfo.ins_state=1

1854 DEB nov 09 13:00:44.107949 JAVA-SIPCC-SIP_TRANS : sip_get_local_ip_addr : dst_addr : 10.48.47.143
1855 DEB nov 09 13:00:44.108040 JAVA-SIPCC-SIP_TRANS : sip_get_local_ip_addr : src_addr : 10.62.153.20
1856 DEB nov 09 13:00:44.108101 JAVA-SIPCC-SIP_TRANS : sip_transport_getaddrinfo : 10.48.47.136 est déjà une adresse IPv4

1861 PAS nov 09 13:00:44.108803 JAVA-SIP : sip_tcp_get_free_conn_entry : index renvoyé = 1
1862 ERR nov 09 13:00:44.209551 JAVA-SIPCC-SIP_CC_CONN : sip_tcp_create_connection : échec de la connexion de socket cpr_errno : 1 ipaddr : 10.48.47.136, port : 5060
1863 ERR nov 09 13:00:44.209704 JAVA-SIPCC-SIP_TRANS : sip_tcp_detach_socket : Nombre maximal de connexions TCP atteint.
1864 PAS le 09 novembre 13:00:44.209887 JAVA-SIPCC-SIP_TCP_MSG : sip_tcp_purge_entry : Socket Fd : 53 fermé pour la troisième phase avec l'adresse : 1, port distant : 170930056
1865 ERR nov 09 13:00:44.209978 JAVA-SIPCC-SIP_CC_CONN : sip_transport_setup_cc_conn : <PRIMARY_CCM>:tcp channel create error server addr=10.48.47.136, échec du port de serveur=5060.

1875 ERR Nov 09 13:00:44.211413 JAVA-SIPCC-SIP_TRANS : sip_transport_init_ti_addr : CCM non provisionné
1876 DEB nov 09 13:00:44.211474 JAVA-SIPCC-SIP_FALLBACK : 120/1, sip_regmgr_retry_timer_start : Début du compteur de secours (120 secondes)

 

Après 115 secondes, le téléphone envoie un autre message REGISTER vers le CUCM principal.

1900 DEB nov 09 13:01:18.688599 JAVA-SIPCC-MSG_SEND_REQ : sipSPIBuildRegisterHeaders : ENVOI DU REGISTRE...

1904 PAS nov 09 13:01:18.689667 JAVA-ccsip_messaging : sipSPIAddContactHeader : CFGID_DEVICE_NAME = SEPC80084AA8721

1910 DEB nov 09 13:01:18.691132 JAVA-SIPCC-SIP_TRANS : sipTransportSendMessage : Sip msg sent handle=<49>, length=<876>, message=
1911 DEB nov 09 13:01:18.691804 JAVA-sipio-sent—> REGISTER sip:10.48.47.143 SIP/2.0^M
Via : SIP/2.0/TCP 10.62.153.20:51509 ; branch=z9hG4bK1eebbfed^M
Expéditeur: <sip : 5035@10.48.47.143>;tag=c80084aa8721005a4c0eda93-3da49275^M
Par : <sip:5035@10.48.47.143>^M
ID d'appel : c80084aa-8721001f-10fda170-17017997@10.62.153.20^M
Transfert max. : 70^M
Date : mer, 09 novembre 2016 13:01:18 GMT^M
CSeq : 155 REGISTER^M
Agent utilisateur : Cisco-CP7821/10.3.1^M
Contact : <sip:2fbf6265-bffc-4f99-b8b2-40dce7ed2d19@10.62.153.20:51509;transport=tcp>;+sip.instance="<urn:uuid:0000000-0000-0000-0000-c80084aa8721>« ;+u.sip !devicle.ccm.cisco.com=« SEPC80084AA8721 »;+u.sip ! model.ccm.cisco.com=« 621 »^M
Pris en charge: remplace,join,sdp-anat,norefersub,resource-priority,extended-reference,X-cisco-callinfo,X-cisco-service-euri,X-cisco-escapecodes,X-cisco-service-control,X-cisco-srtp-fallback,X-cisco-monrec,X-cisco-config,X-cisco-sis-7.0 0,X-cisco-xsi-8.5.1^M
Longueur de contenu : 0^M
Expire : 3 600^M
^M

1914 DEB nov 09 13:01:18.692139 JAVA-[[MESSAGE_1.0]] : [SIPCC] —> REGISTER sip:10.48.47.143 SIP/2.0() —> [10.48.47.143] :
1915 DEB nov 09 13:01:18.692322 JAVA-SIPCC-SIP_MSG_SEND : ccsip_store_send_msg_for_alarme : Envoyé:REGISTER sip:10.48.47.143 SIP/2.0 Cseq:155 REGISTER CallId:c80084aa-8721001f-10fda170-17017997@10.62.153.20
1916 DEB nov 09 13:01:18.692536 JAVA-SIPCC-SIP_STATE : 97/1, sip_reg_sm_change_state : Modification de l'état de l'enregistrement : SIP_REG_STATE_IDLE —> SIP_REG_STATE_REGISTERING

Le message « CUCM a fermé la connexion TCP » ici concerne le noeud SUB.

1917 DEB nov 09 13:01:22.523575 JAVA-SIPCC-SIP_TCP_MSG : sip_tcp_read_socket : CUCM a fermé la connexion TCP.
1918 ERR Nov 09 13:01:22.523758 JAVA-SIP : sip_tcp_read_socket : socket error=110

1923 DEB nov 09 13:01:22.524613 JAVA-SIPCC-SIP_TRANS : sip_transport_destruction_cc_conn : CC <SECONDARY_CCM> : fermeture de la connexion TCP

1924 DEB nov 09 13:01:22.524705 JAVA-SIPCC-SIP_SOCK : sip_tcp_destruction_connection : entrée de purge, socket is 49, connid is 0
1925 PAS nov 09 13:01:22.524888 JAVA-SIPCC-SIP_TCP_MSG : sip_tcp_purge_entry : Socket Fd : 49 fermé pour la suite 0 avec adresse : 1, port distant : 170930063

1941 DEB nov 09 13:01:22.527696 JAVA-SIPCC-SIP_TCP_MSG : sip_tcp_createconnfail_to_spi : Serveur actif en panne en raison d'ETIMEDOUT. ip_addr:10.48.47.143

Ensuite, le téléphone génère un message ALARM et tente de l'envoyer via le message SIP REFER.

Dans cet exemple, SIP REFER n'est pas généré, car le téléphone ne parvient pas à établir le socket TCP avec CUCM.

1950 PAS nov 09 13:01:22.529008 JAVA-Thread-5|JPlatUi:updateAlarmInfo - infoType:1, ccmId:0, phonePort:51509, sipMsg:Sent:REGENT TER sip:10.48.47.143 SIP/2.0 Cseq:155 REGISTER CallId:c80084aa-8721001f-10fda170-17017997@10.62.153.20
1951 DEB nov 09 13:01:22.541857 JAVA-SIPCC-SIP_ALARM : update_unregister_alarme_info : Info_type=CC_UNREG_ALARM_SIP_MSG_INFO ccm_id=VISITING_CCM phone_tcp_port=0 sip_info_msg=< ? xml version=« 1.0 » codage=« UTF-8 » ? >
<x-cisco-alarme>
<Nom de l'alarme=« LastOutOfServiceInformation »>
<Liste de paramètres>
<String name=« DeviceName »>SEPC80084AA8721</String>
<String name=« DeviceIPv4Address »>10.62.153.20 / 0</String>
<String name=« IPv4DefaultGateway »>10.62.153.17</String>
<String name=« DeviceIPv6Address »></String>
<String name=« IPv6DefaultGateway »></String>
<String name=« ModelNumber »>CP-7821</String>
<String name=« NeighborIPv4Address »>10.62.153.17</String>
<String name=« NeighborIPv6Address »></String>
<String name=« NeighborDeviceID »></String>
<String name=« NeighborPortID »>FastEthernet0/1</String>
<Enum name=« DHCPv4Status »>1</Enum>
<Enum name=« DHCPv6Status »>3</Enum>
<Enum name=« TFTPCfgStatus »>1</Enum>
<Enum name=« DNSStatusUnifiedCM1 »>4</Enum>
<Enum name=« DNSStatusUnifiedCM2 »>4</Enum>
<Enum name=« DNSStatusUnifiedCM3 »>3</Enum>
<String name=« VoiceVLAN »>150</String>
<Strin
1952 DEB nov 09 13:01:22.542223 JAVA-SIPCC-SIP_ALARM : storeAlarm : alarme stockée à l'index [0].

1958 NON nov 09 13:01:22.544024 JAVA-Thread-5|JPlatUi:setUnregReason - old-unregister-Raison:25, new unregister-Raison:10, cc-server-type:0
1959 PAS nov 09 13:01:22.544268 JAVA-Thread-5|JPlatUi:isThisFailureFromNewCause - old unregReason =25 newUnregReason=10
1960 PAS nov 09 13:01:22.549762 JAVA-Thread-5|JPlatUi:setUnregReason - défini sur unregister-raison:10

Le code raison 10 ci-dessous est décodé comme « LastTimeTCPtimeout ».

1961 ERR Nov 09 13:01:22.681060 JAVA-Thread-5 - ======================== stonemark5
1962 NON nov 09 13:01:22.681701 JAVA-Thread-5|cip.sipcc.SipEnhancedAlarmInfo : setLastDeregistrationReason - new unreg-Raison=10(LastTimeTCPtimeout), unreg-Raison=25
1963 WRN nov 09 13:01:22.689698 JAVA-Thread-5|cip.sipcc.SipEnhancedAlarmInfo:getLastUnregisterTimeReason - TimeStamp=14786964826 81 ; Motifs = 10
1964 ERR Nov 09 13:01:22.814801 JAVA-Thread-5 - ======================== stonemark5

1965 PAS nov 09 13:01:22.821546 JAVA-Thread-5|JPlatUi:setUnregReason - essayez d'envoyer une première alarme unreg après l'enregistrement du téléphone, unregister-raisin:10
1966 INF nov 09 13:01:22.822003 JAVA-Thread-5|cip.sipcc.SipCcAdapter : - ALarmerIF send alarm( LastOutOfServiceInformation ) : DeviceName=SEPC80084AA8721 DeviceIPv4Address=10.62.153.20/29 IPv4DefaultGateway=10.62.153.17 DeviceIPv6Address= IPv6DefaultGateway= ModelNumber=CP-7821 Neighbor IP v4Address=10.62.153.17 NeighborIPv6Address= NeighborDeviceID=KPOE-allevich.cisco.com NeighborPortID=FastEthernet0/1 DHCPv4Status=1 DHCPv6Status=3 TFTPCfgStatus=1 DNSStatusUnifiedCM1=4 DNSStatusUnifiedCM2=4 DNSStatusUnifiedCM3=0 DNSv6StatusUnifiedCM1=0 DNSv6StatusUnifiedCM2=0 DNSv6StatusUnifiedCM3=0 VoiceVLAN=150 UnifiedCMIPAddress=10.48.47 .143 LocalPort=51509 TimeStamp=1478696482681 ReasonForOutOfService=10 LastProtocolEventSent=Envoyé:REGISTER sip:10.48.47.1 SIP43/2.0 Cseq:155 REGISTER CallId:c80084aa-8721001f-10fda170-17017997@10.62.153.20 LastProtocolEventReceived=Rcvd:SIP/2.0 200 OK Cseq:103 REGISTER CallId:c80084aa-87210003-03fea156-01e00b4a@10.62.153.20

1967 DEB nov 09 13:01:22.822309 JAVA-SIPCC-SIP_ALARM : storeAlarm : alarme stockée à l'index [1].

1974 DEB nov 09 13:01:22.857499 JAVA-SIPCC-SIP_ALARM : update_unregister_alarme_info : Info_type=CC_UNREG_ALARM_SIP_MSG_INFO ccm_id=VISITING_CCM phone_tcp_port=0 sip_info_msg=Envoyé:REGISTER sip:10.48.47.143 SIP/2.0 Cseq:155 REGISTER CallId:c80084aa-8721001f-10fda170-17017997@10.62.153.20

1975 DEB nov 09 13:01:22.857804 JAVA-SNAPSHOT-VERSION : CCAPI_Device_releaseDeviceInfo : pointeur de référence=b3535768
1976 ERR Nov 09 13:01:22.857926 JAVA-SIPCC-SIP_TCP_MSG : sip_tcp_createconnfail_to_spi : envoyer un message SIP_TMR_REG_RETRYafin que cette adresse ip cucm:10.48.47.143 puisse être placée dans la liste de secours
1977 DEB nov 09 13:01:22.857987 JAVA-SIPCC-SIP_MSG_SEND : ccsip_register_send_msg : cmd=90=SIP_TMR_REG_RETRY ndx=97
1978 ERR Nov 09 13:01:22.858140 JAVA-SIPCC-SIP_TRANS : sip_tcp_detach_socket : socket non valide
1979 PAS nov 09 13:01:22.858231 JAVA-SIPCC-SIP_TCP_MSG : sip_tcp_purge_entry : Socket Fd : -1 fermé pour la suite 0 avec adresse : 0, port distant : 0

1980 DEB nov 09 13:01:22.858506 JAVA-SIPCC-MSG_SEND_REQ : SIPSPISendSubscribe : Envoi de l'ABONNÉ...

1989 PAS nov 09 13:01:22.860734 JAVA-SIPCC-SIP_MSG_SEND : ccsip_dump_send_msg_info : <10.48.47.143:5060> : REPORTEZ-VOUS aux sections suivantes : <sip:10.48.47.143> :1000 REPORTEZ-VOUS À LA SECTION::c80084aa-8721001e-25e32e9e-6505ba59@10.62.153.20
1990 ERR 09 novembre 13:01:22.860856 JAVA-SIPCC-SIP_TRANS : sipTransportSendMessage : aucune connexion à l'adresse distante 10.48.47.143:5060
1991 ERR Nov 09 13:01:22.860917 JAVA-SIPCC-FUNC_CALL : sipTransportCreateSendMessage : Erreur : sipTransportSendMessage() a retourné une erreur.
1992 ERR Nov 09 13:01:22.861131 JAVA-SIP : SIPSPISendSubscribe : échec de l'envoi du message
1993 ERR Nov 09 13:01:22.861222 JAVA-SIP : subsmanager_handle_ev_app_subscribe : échec de l'envoi du message SUBSCRIBE

2028 PAS nov 09 13:01:22.869341 JAVA-SIPCC-UI_API : ui_set_ccm_conn_status : ***********CUCM 10.48.47.143 Non connecté************

2072 DEB nov 09 13:01:22.879687 JAVA-SIPCC-SIP_FAILOVER : sip_regmgr_ccm_get_next : AUCUNE CC DISPONIBLE. REDÉMARREZ !

2083 ERR Nov 09 13:01:22.881396 JAVA-SIPCC-SIP_TRANS : sip_transport_get_ti_addr : Aucun CUCM actif trouvé avec CUCM principal
2084 DEB nov 09 13:01:22.881488 JAVA-SIPCC-SIP_REG : sip_regmgr_handle_reg_all_fail : Toutes les tentatives d'enregistrement ont échoué.
2085 PAS nov 09 13:01:22.881640 JAVA-SIPCC-UI_API : ui_set_ccm_conn_status : ***********CUCM 10.48.47.136 Non connecté************

2125 DEB nov 09 13:01:22.892811 JAVA-SIPCC-SIP_TRANS : sip_transport_destruction_cc_conn : CC <PRIMARY_CCM> : connexion déjà fermée
2126 NON nov 09 13:01:22.892933 JAVA-SIPCC-UI_API : ui_set_ccm_conn_status : ***********CUCM 10.48.47.143 Non connecté************
2127 DEB nov 09 13:01:22.893116 JAVA-SIPCC-SIP_TRANS : sip_transport_destruction_cc_conn : CC <SECONDARY_CCM> : connexion déjà fermée
2128 ERR nov 09 13:01:22.893238 JAVA-SIPCC-SIP_TRANS : sip_transport_get_ti_addr : Aucun CUCM actif trouvé avec CUCM principal
2129 ERR nov 09 13:01:22.893299 JAVA-SIPCC-SIP_TRANS : sip_transport_get_ti_addr : Aucun CUCM actif trouvé avec CUCM principal
2130 PAS nov 09 13:01:22.893513 JAVA-SIPCC-UI_API : ui_set_ccm_conn_status : ***********CUCM 10.48.47.136 Non connecté************
2131 DEB nov 09 13:01:22.893665 JAVA-SIPCC-SIP_TRANS : sip_transport_destruction_cc_conn : CC <TERTIARY_CCM> : connexion déjà fermée
2132 ERR nov 09 13:01:22.893757 JAVA-SIPCC-SIP_TRANS : sip_transport_get_ti_addr : Aucun CUCM actif trouvé avec CUCM principal
2133 ERR nov 09 13:01:22.893879 JAVA-SIPCC-SIP_TRANS : sip_transport_get_ti_addr : Aucun CUCM actif trouvé avec CUCM principal
2134 PAS nov 09 13:01:22.893971 JAVA-SIPCC-UI_API : ui_set_ccm_conn_status : ***********CUCM 10.48.47.136 Non connecté************
2135 DEB nov 09 13:01:22.894123 JAVA-SIPCC-SIP_TRANS : sip_transport_destruction_cc_conn : CC <SRST_CCM> : connexion déjà fermée
2136 DEB nov 09 13:01:22.894245 JAVA-SIPCC-UI_API : ui_set_sip_register_state : LIGNE 1 : NON ENREGISTRÉ

Après avoir tenté sans succès de s'enregistrer sur tous les noeuds, le téléphone redémarre et l'enregistrement est de nouveau tenté.

2288 DEB nov 09 13:01:22.996946 JAVA-SIPCC-SIP_REG : sip_regmgr_regallfail_timer_callback : Échec de l'enregistrement . Redémarrage du système maintenant !
2289 DEB nov 09 13:01:22.997099 JAVA-SIPCC-SIP_REG : sip_regmgr_send_status : src_id : 1 msg_id : 1

2290 DEB nov 09 13:01:22.997160 JAVA-SIPCC-UI_API : ui_reg_all_fail : ***********Échec de l'enregistrement de tous les CUCM.************
2291 DEB nov 09 13:01:22.997313 JAVA-SIPCC-SIP_REG : sip_regmgr_send_status : ÉCHEC DE RÉG ALL
2292 PAS le 09 novembre 13:01:22.998045 JAVA-SIPCC-SIP_DEVICE_MGR : enregistrement_processEvent : Événement EV_CC_OOS_REG_ALL_FAILED, état actuel MGMT_STATE_REGISTERED
2293 PAS le 09 novembre 13:01:22.998320 JAVA-SIPCC-SIP_DEVICE_MGR : setState : nouvel état d'enregistrement = MGMT_STATE_OOS_AWAIT_SHUTDOWN_ACK