目录

简介

先决条件

要求

使用的组件

背景信息

收集PRT的步骤

日志分析

PRT日志中的CIPC SIP注册

PRT日志中的CIPC注册问题

简介

本文档介绍Cisco IP Communicator(CIPC)问题报告收集和分析(PRT)的流程。

先决条件

要求

Cisco 建议您了解以下主题：

- 思科呼叫管理器

- 思科CIPC

使用的组件

本文档中的信息基于以下软件和硬件版本：

- CUCM版本11.5

- CIPC版本8.6.6.0

本文档中的信息是从特定实验环境中的设备和应用程序创建的。本文档中使用的所有设备和应用程序都以清除（默认）配置启动。如果您的网络处于活动状态，请确保您了解任何操作的潜在影响。

背景信息

Cisco IP Communicator是基于Windows PC的软电话应用，允许您使用个人计算机进行高级语音和视频呼叫。提供最新的IP通信技术，易于获取、部署和使用。

使用USB头戴式耳机或USB免提电话和Cisco IP Communicator，您可以轻松访问公司电话号码和语音邮件。您只需要互联网连接和远程访问公司网络，无论您是在家工作、支持联系中心还是出差。

收集PRT的步骤

步骤1.导航至“开始”并搜索“创建CIPC问题报告”，如图所示。

步骤2.显示如图所示的屏幕。

步骤3.单击“下一步”，并写下与问题相关的简短说明，如图所示。

步骤 4：单击Next，它将显示图像中所示的进程屏幕。

步骤 5：单击“完成”，如图所示。下载文件的默认路径在用户桌面上。

日志分析

PRT日志中的CIPC SIP注册

- CIPC电话注册流程：

This is the first line which showcase the CIPC boot up process started.

Thu Apr 26 13:37:34.164 :   DET : ( 32828) ATW trace initialized

Thu Apr 26 13:37:34.169 :    EE : ( 32828) MediaTerminationDll : NativeATWStart

- CIPC运行计算机的IP地址分配：

Thu Apr 26 13:37:35.002 :    EE : ( 16956) -SFB| --> CSettings::setIPAddress

Thu Apr 26 13:37:35.002 :  SPCL : ( 16956) -SFB|  &S CSettings::setIPAddress: Updating audio streaming IP(10.196.121.111) in properties dll

Thu Apr 26 13:37:35.002 :    EE : ( 16956) -SFB| <-- CSettings::setIPAddress

Thu Apr 26 13:37:35.002 :  SPCL : ( 16956) -SFB|  &S CSettings::selectIPAddressToUse : [True]: returning 10.196.121.111

- 正在获取TFTP服务器IP:

Thu Apr 26 13:37:35.494 :    EE : ( 16956) -SFB| --> CSettings::getRegIntHklmHkcu SOFTWARE\Cisco Systems, Inc.\Communicator TftpServer1

Thu Apr 26 13:37:35.494 :  SPCL : ( 16956) -SFB|  &S CSettings::getRegIntHklmHkcu SOFTWARE\Cisco Systems, Inc.\Communicator TftpServer1: TftpServer1 returned 10.106.99.199

Thu Apr 26 13:37:35.494 :    EE : ( 16956) -SFB| <-- CSettings::getRegIntHklmHkcu SOFTWARE\Cisco Systems, Inc.\Communicator TftpServer1

- CIPC请求CTL文件（CIPC不支持ITL）：

Thu Apr 26 13:37:35.514 :   DET : ( 16956) file sgn verify SUCCESS, hdr 448 byte, <C:\Users\sakaleka\AppData\Roaming\Cisco\Communicator\sec\CTLFile.tlv>

Thu Apr 26 13:37:35.514 :   DET : ( 16956) finished CTL initialization

Thu Apr 26 13:37:35.514 :   DET : ( 16956) ** phone has CTL *

- CIPC通过TFTP和HTTP请求的配置文件

- 请求配置文件，并将其写入AppData\Roaming文件夹。

Thu Apr 26 13:37:35.515 :   DET : ( 16956) -SFB|  &D CSettings::loadCNFFileOptions(): tftp-ing SEP00059A3C7AAA.cnf.xml to C:\Users\sakaleka\AppData\Roaming\Cisco\Communicator\cache\SEP00059A3C7AAA.1.cnf.xml

Thu Apr 26 13:37:35.516 :    EE : ( 16956) tftpRead : address , srcFile SEP00059A3C7AAA.cnf.xml, destFile C:\Users\sakaleka\AppData\Roaming\Cisco\Communicator\cache\SEP00059A3C7AAA.1.cnf.xml

Thu Apr 26 13:37:35.516 :  SPCL : ( 16956) tftpRead : Security setting passed in is Authentication 1

Thu Apr 26 13:37:35.517 :    EE : ( 16956) downloadFile : server 10.106.99.199, srcFile SEP00059A3C7AAA.cnf.xml.sgn, destFile C:\Users\sakaleka\AppData\Roaming\Cisco\Communicator\cache\SEP00059A3C7AAA.1.cnf.xml, secLevel 1

Thu Apr 26 13:37:35.517 :  SPCL : ( 16956) downloadFile : attempting HTTP download of file <SEP00059A3C7AAA.cnf.xml.sgn> to <C:\Users\sakaleka\AppData\Roaming\Cisco\Communicator\cache\SEP00059A3C7AAA.1.cnf.xml>

- HTTP下载配置文件请求：

Thu Apr 26 13:37:45.847 :    EE : ( 25384) downloadFile : server 10.106.99.199, srcFile SEP00059A3C7AAA.cnf.xml.sgn, destFile C:\Users\sakaleka\AppData\Roaming\Cisco\COMMUN~1\ram\SEP00059A3C7AAA.cnf.xml, secLevel 1

Thu Apr 26 13:37:45.848 :  SPCL : ( 25384) downloadFile : attempting HTTP download of file <SEP00059A3C7AAA.cnf.xml.sgn> to <C:\Users\sakaleka\AppData\Roaming\Cisco\COMMUN~1\ram\SEP00059A3C7AAA.cnf.xml>

Thu Apr 26 13:37:45.848 :    EE : ( 25384) httpDownload : server 10.106.99.199, port 6970, srcFile SEP00059A3C7AAA.cnf.xml.sgn, destFile C:\Users\sakaleka\AppData\Roaming\Cisco\COMMUN~1\ram\SEP00059A3C7AAA.cnf.xml, secLevel 1

- HTTP下载配置文件响应：

Thu Apr 26 13:37:45.889 :   DET : ( 25384) CHttpDownloader::ReceiveResponse - HttpQuererryInfo for content length returned: 13796

Thu Apr 26 13:37:45.892 :  SPCL : ( 25384) httpDownload : Successful HTTP download of file <SEP00059A3C7AAA.cnf.xml.sgn>

Thu Apr 26 13:37:45.893 :   DET : ( 25384) sgn-verify <C:\Users\sakaleka\AppData\Roaming\Cisco\COMMUN~1\ram\SEP00059A3C7AAA.cnf.xml>, 'name'[SEP00059A3C7AAA.cnf.xml.sgn]

- CIPC发送的注册消息到CUCM主服务器：

Thu Apr 26 13:37:51.577 :   DET : ( 17676) REGISTER sip:10.106.99.199 SIP/2.0

Via: SIP/2.0/TCP 10.196.121.111:61192;branch=z9hG4bK0000469a

From: <sip:3002@10.106.99.199>;tag=185e0f7d99f10002000036d0-00004489

To: <sip:3002@10.106.99.199>

Call-ID: 185e0f7d-99f10002-00006a5f-00007253@10.196.121.111

Max-Forwards: 70

Date: Thu, 26 Apr 2018 08:07:51 GMT

CSeq: 101 REGISTER

User-Agent: Cisco-SIPIPCommunicator/9.1.1

- 注册从CUM到CIPC的响应：

Thu Apr 26 13:37:51.719 :   DET : ( 17676) SIP/2.0 200 OK

Via: SIP/2.0/TCP 10.196.121.111:61192;branch=z9hG4bK0000469a

From: <sip:3002@10.106.99.199>;tag=185e0f7d99f10002000036d0-00004489

To: <sip:3002@10.106.99.199>;tag=488061601

Date: Thu, 26 Apr 2018 08:07:51 GMT

Call-ID: 185e0f7d-99f10002-00006a5f-00007253@10.196.121.111

Server: Cisco-CUCM11.5

CSeq: 101 REGISTER

Expires: 120

Now the CIPC register on primary node 10.106.99.199.

PRT日志中的CIPC注册问题

CIPC的启动

ATW trace initialized

DHCP问题

-NS| bind to Port(68) Error

系统关闭

Wed Apr 18 15:05:48.805 :   DET : (  5560) -VM| SystemManager n/a            SYSTEM_SHUTTING_DOWN

正常呼叫流

- search on – “sip_sm_process_event: Processing SM event”

Line 3254: Wed Apr 18 13:49:06.755 :   DET : (  5928) SIPCC-SIP_EVT: 1/0, sip_sm_process_event: Processing SM event: 0: --0x0dd32430--                     : SIP_STATE_IDLE <- E_SIP_INVITE

Line 3813: Wed Apr 18 13:49:07.929 :   DET : (  5928) SIPCC-SIP_EVT: 1/163, sip_sm_process_event: Processing SM event: 0: --0x0dd2d3a0--                     : SIP_STATE_RECV_INVITE_CONNECTED <- E_SIP_ACK

Line 4157: Wed Apr 18 13:49:08.489 :   DET : (  5928) SIPCC-SIP_EVT: 1/163, sip_sm_process_event: Processing SM event: 0: --0x0dd30830--                     : SIP_STATE_ACTIVE <- E_SIP_INVITE

Line 4404: Wed Apr 18 13:49:08.516 :   DET : (  5928) SIPCC-SIP_EVT: 1/163, sip_sm_process_event: Processing SM event: 0: --0x0dd311a0--                     : SIP_STATE_RECV_MIDCALL_INVITE_SIPACK_PENDING <- E_SIP_ACK

Line 4513: Wed Apr 18 13:49:17.045 :   DET : (  5928) SIPCC-SIP_EVT: 1/163, sip_sm_process_event: Processing SM event: 0: --0x0dd2dc00--                     : SIP_STATE_ACTIVE <- E_SIP_BYE

双呼叫日志

- search on – “sip_sm_process_event: Processing SM event”

Line 23745: Tue Apr 17 17:14:53.834 :   DET : (  5288) SIPCC-SIP_EVT: 1/0, sip_sm_process_event: Processing SM event: 0: --0x0de92430--                     : SIP_STATE_IDLE <- E_SIP_INVITE

Line 24125: Tue Apr 17 17:14:54.009 :   DET : (  5288) SIPCC-SIP_EVT: 1/106, sip_sm_process_event: Processing SM event: 0: --0x0de8dc00--                     : SIP_STATE_RECV_INVITE_ALERTING <- E_SIP_CANCEL

Line 24330: Tue Apr 17 17:14:54.013 :   DET : (  5288) SIPCC-SIP_EVT: 1/106, sip_sm_process_event: Processing SM event: 0: --0x0de94c20--                     : SIP_STATE_RELEASE <- E_SIP_ACK

蓝屏问题

- search on – “httpDownload”. Only failed download that matters if the cnf.xml file. If this fails, it’ll reset cipc.

Line 1683: Sat Apr 07 10:27:02.591 :    EE : (  4600) httpDownload : server 192.168.180.109, port 6970, srcFile SEPD067E5227A3F.cnf.xml, destFile C:\Users\jakei\AppData\Roaming\Cisco\COMMUN~1\ram\SEPD067E5227A3F.cnf.xml, secLevel 0

Line 1684: Sat Apr 07 10:27:02.591 :    EE : (  4600) CHttpDownloader::DownloadToFile

Line 1685: Sat Apr 07 10:27:02.591 :    EE : (  4600) CHttpDownloader::OpenConnection

Line 1686: Sat Apr 07 10:27:02.591 :    EE : (  4600) CHttpDownloader::SendRequest

Line 1687: Sat Apr 07 10:27:02.594 :   DET : (  4600) CHttpDownloader::SendRequest - HttpQuererryInfo for status code returned:200

Line 1688: Sat Apr 07 10:27:02.594 :    EE : (  4600) CHttpDownloader::ReceiveResponse

Line 1689: Sat Apr 07 10:27:02.594 : ERROR : (  4600) CHttpDownloader::ReceiveResponse - File open failed for C:\Users\jakei\AppData\Roaming\Cisco\COMMUN~1\ram\SEPD067E5227A3F.cnf.xml

音量变化

Wed Apr 18 13:29:09.466 :    EE : (  1944) MediaTerminationDll : NativeSetVolume : audioType 1, volume 19

用户从未完成音频调节向导

ATW=AudioTuningWizard

Wed Apr 18 11:17:57.959 :    EE : (  4860) MediaTerminationDll : ~NativeGetNextRingableDevice : (null)

Wed Apr 18 11:17:57.977 :   DET : (  4860) ATW: Menu items (help, troubleshoot, about) are set

Wed Apr 18 11:51:37.236 :    EE : (  4860) MediaTerminationDll : NativeGetStreamableDeviceID

网络断开

Mon Apr 16 17:16:44.625 :  SPCL : (  4356) -SFB|  &S CNetAdapterUtil::CObjSinkHelper::Indicate: MSNdis_StatusMediaDisconnect