内容

概要

前提条件

要件

使用するコンポーネント

背景説明

PRTの収集手順

ログ分析

PRTログでのCIPC SIP登録

PRTログでのCIPC登録の問題

概要

このドキュメントでは、Cisco IP Communicator(CIPC)の問題レポートの収集と分析(PRT)のプロセスについて説明します。

前提条件

要件

次の項目に関する知識があることが推奨されます。

- Cisco Call Manager

- Cisco CIPC

使用するコンポーネント

このドキュメントの情報は、次のソフトウェアとハードウェアのバージョンに基づいています。

- CUCM バージョン 11.5

- CIPCバージョン8.6.6.0

このドキュメントの情報は、特定のラボ環境のデバイスとアプリケーションから作成されたものです。このドキュメントで使用するすべてのデバイスとアプリケーションは、クリア（デフォルト）設定から開始されています。ネットワークが稼働中の場合は、どのようなアクションが及ぼす潜在的な影響を確実に理解しておいてください。

背景説明

Cisco IP Communicatorは、Windows PCベースのソフトフォンアプリケーションで、高品質の音声およびビデオ通話を行うためにパーソナルコンピュータを使用できます。取得、導入、および使用が容易な最新のIPコミュニケーションテクノロジーを提供します。

USBヘッドセットまたはUSBスピーカフォンとCisco IP Communicatorを使用すると、企業の電話番号とボイスメールに簡単にアクセスできます。必要なのは、自宅から仕事をしているか、コンタクトセンターをサポートしているか、ビジネスを行っているかにかかわらず、インターネット接続と企業ネットワークへのリモートアクセスだけです。

PRTの収集手順

ステップ1：図に示すように、[Start]に移動し、[Create CIPC Problem Report]を検索します。

ステップ2：図のように画面が表示されます。

ステップ3:[Next]をクリックし、図に示すように、問題に関する簡単な説明を記入します。

ステップ 4：[Next]をクリックすると、図に示すようにプロセス画面が表示されます。

ステップ 5：図に示すように[Finish]をクリックします。ダウンロードしたファイルのデフォルトパスは、ユーザデスクトップにあります。

ログ分析

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

- CTLファイルに対するCIPC要求（ITLはCIPCでサポートされていません）:

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