CUCMでのプロキシTFTPの設定とトラブルシューティング

Updated: 2022 年 10 月 18 日
Document ID:214528
偏向のない言語

この製品のドキュメントセットは、偏向のない言語を使用するように配慮されています。このドキュメントセットでの偏向のない言語とは、年齢、障害、性別、人種的アイデンティティ、民族的アイデンティティ、性的指向、社会経済的地位、およびインターセクショナリティに基づく差別を意味しない言語として定義されています。製品ソフトウェアのユーザインターフェイスにハードコードされている言語、RFP のドキュメントに基づいて使用されている言語、または参照されているサードパーティ製品で使用されている言語によりドキュメントに例外が存在する場合があります。シスコのインクルーシブランゲージの取り組みの詳細は、こちらをご覧ください。
翻訳について

シスコは世界中のユーザにそれぞれの言語でサポートコンテンツを提供するために、機械と人による翻訳を組み合わせて、本ドキュメントを翻訳しています。ただし、最高度の機械翻訳であっても、専門家による翻訳のような正確性は確保されません。シスコは、これら翻訳の正確性について法的責任を負いません。原典である英語版（リンクからアクセス可能）もあわせて参照することを推奨します。
内容

概要
前提条件
要件
使用するコンポーネント
背景説明
ネットワーク図
設定
手動プロキシTFTP設定
ダイナミックプロキシTFTPの設定
トラブルシュート
収集するデータ
分析例
シスコラボのデバイス情報
プロキシTFTPクラスタのPCAPレビュー
プロキシTFTPクラスタのTFTPログレビュー
概要

このドキュメントでは、Cisco Unified Communications Manager(CUCM)のProxy Trivial File Transfer Protocol(TFTP)機能について説明します。
前提条件

要件

次の項目に関する知識があることが推奨されます。
Cisco Phone Registration
CUCM上のCisco TFTPサービス
使用するコンポーネント

現在サポートされているソフトウェアおよびハードウェアにはこの機能が含まれているため、このドキュメントは特定のソフトウェアおよびハードウェアのバージョンに限定されるものではありません。
このドキュメントの情報は、特定のラボ環境にあるデバイスに基づいて作成されました。このドキュメントで使用するすべてのデバイスは、初期（デフォルト）設定の状態から起動しています。本稼働中のネットワークでは、各コマンドによって起こる可能性がある影響を十分確認してください。
背景説明

このドキュメントでは、機能の目的、機能の設定、重要な診断データ、データの分析例、および追加調査のための関連リソースについて説明します。
この機能の目的は、複数のCUCMクラスタを含む大規模なCUCM環境にスケーラブルなTFTP設定を作成することです。
ネットワーク図

設定

手動プロキシTFTP設定

Cisco Unified CM Administration Webインターフェイスの[Find and List Remote Clusters] を使用して、リモートクラスタを追加します。
ステップ 1：リモートクラスタを追加します。
Cisco Unified CM Administrationで、Advanced Features > Cluster Viewの順に選択します。
Add Newをクリックし、Cluster IdとFully Qualified Domain Nameを入力します。
[Save] をクリックします。
ステップ2.プロキシTFTP機能を有効にします。
[TFTP]ハイパーリンクをクリックします。[Remote Cluster Manually Override Configuration] ウィンドウが表示されます。
[Manually configure remote service addresses]を選択します。
リモートクラスタのTFTPサーバのIPアドレスを入力します。
[Save] をクリックします。
手順 3：リモートTFTPサーバを追加します。
[TFTP]ハイパーリンクをクリックします。[Remote Cluster Manually Override Configuration] ウィンドウが表示されます。
[Manually configure remote service addresses]を選択します。
リモートクラスタのTFTPサーバのIPアドレスを入力します。
[Save] をクリックします。
ステップ4:（オプション）プロキシTFTPサーバをDynamic Host Configuration Protocol(DHCP)スコープに追加します。
複数のクラスタを展開する場合は、個々のリモートノードのDHCPスコープを変更して、プライマリプロキシTFTPサーバのIPアドレスを含めます。
ダイナミックプロキシTFTPの設定

ステップ 1：Intercluster Lookup Service(ILS)を設定します。
ステップ 2：Cluster ViewページでTFTPのチェックボックスをオンにします。
トラブルシュート

収集するデータ

プロキシTFTPの問題の場合は、各CUCMクラスタから次の情報を収集する必要があります。
詳細なTFTPログ
イベントビューア – アプリケーションログ
イベントビューア – システムログ
パケットキャプチャ
また、電話機から次の情報を収集する必要があります。
問題レポートツール(PRT)
パケットキャプチャ
分析例

シスコラボのデバイス情報

電話：
モデル：8861
ファームウェアバージョン：sip88xx.12-1-1SR1-4
IPアドレス：192.0.2.11
eth.addr==28:34:a2:82:3b:58
電話機が登録されるリーフクラスタ：
192.0.2.1400-11
192.0.2.12（1台のサーバのみ）
プロキシクラスタ：
192.0.2.1500-18
198.51.100.0（1台のサーバのみ）
プロキシTFTPクラスタのPCAPレビュー

Command output
cnf_request_proxy_pcap
app_dial_rules_softkeys_proxy_pcap
プロキシTFTPクラスタのTFTPログレビュー

 ##### 07:28:32.110 || SdlConnectionInd for the phone connecting to request the CTL file
00004372.000 |07:28:32.110 |SdlSig   |SdlConnectionInd                       |listening                      |HTTPServer(1,600,25,1)           |SdlTCPConnection(1,600,14,63)    |1,600,12,1.43^*^*                        |*TraceFlagOverrode
00004373.000 |07:28:32.110 |SdlStat  |Period: 17s #Lines: 1 #Bytes: 240 Total Number of Buffers: 2000 Free LWM: 1997 Free LWM(total): 1918
00004372.001 |07:28:32.110 |AppInfo  |-->HTTPSERVER::listening_SdlConnectionInd 
00004372.002 |07:28:32.110 |AppInfo  |HTTPServer::listening_SdlConnection - Printing the sender PID = [1, 600, 14, 63]
00004372.003 |07:28:32.110 |AppInfo  |HTTPServer::handleConnection - Sending a Reassociate Request to Reassociate the newly created HTTPConnectionInfo object to the network/client
00004372.004 |07:28:32.110 |AppInfo  |HTTPServer::listening_SdlConnectionInd - Maximum serving count for HTTP connection is  = 2500
00004372.005 |07:28:32.110 |AppInfo  |HTTPServer::listening_SdlConnectionInd - HTTPConnectionCount = 1
00004372.006 |07:28:32.110 |AppInfo  |<--HTTPSERVER::listening_SdlConnectionInd 
00004374.000 |07:28:32.110 |SdlSig   |SdlReassociateRsp                      |listening                      |HTTPServer(1,600,25,1)           |SdlTCPConnection(1,600,14,63)    |1,600,12,1.43^*^*                        |*TraceFlagOverrode
00004374.001 |07:28:32.110 |AppInfo  |HTTPServer::listening_SdlReassociateRsp - Reassociation Successfull
00004374.002 |07:28:32.110 |AppInfo  |HTTPServer::listening_SdlReassociateRsp - Printing the PID of sender = [1, 600, 14, 63]
00004375.000 |07:28:32.110 |SdlSig   |SdlReassociateInd                      |wait                           |HTTPConnection(1,600,26,3)       |SdlTCPConnection(1,600,14,63)    |1,600,12,1.43^*^*                        |*TraceFlagOverrode
00004375.001 |07:28:32.110 |AppInfo  |-->HTTPConnection::wait_SdlReassociateInd 
00004375.002 |07:28:32.110 |AppInfo  |   HTTPConnection::wait_SdlReassociateInd Received ReassociateIndication from 192.0.2.11
00004375.003 |07:28:32.110 |AppInfo  |<--HTTPConnection::wait_SdlReassociateInd 
00004376.000 |07:28:32.110 |SdlSig   |SdlDataInd                             |wait                           |HTTPConnection(1,600,26,3)       |SdlTCPConnection(1,600,14,63)    |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004376.001 |07:28:32.110 |AppInfo  |-->HTTPConnection::wait_SdlDataInd 
00004376.002 |07:28:32.110 |AppInfo  |   HTTPConnection::wait_SdlDataInd SdlDataInd recived from TcpPID-[1, 600, 14, 63]



 ##### 07:28:32.110 || Phone requests the CTL file
00004376.003 |07:28:32.110 |AppInfo  |   HTTPConnection::wait_SdlDataInd Printing the HTTPRequest : msgBuffer size [64] --: GET /CTLSEP2834A2823B58.tlv HTTP/1.1
Host:198.51.100.0:6970

X
00004376.004 |07:28:32.110 |AppInfo  |   HTTPConnection::wait_SdlDataInd Proxy Request- 0 , CTLSEP2834A2823B58.tlv
00004376.005 |07:28:32.110 |AppInfo  |   HTTPConnection::wait_SdlDataInd Decode successful - Filename is : CTLSEP2834A2823B58.tlv
00004376.006 |07:28:32.110 |AppInfo  |   HTTPConnection::wait_SdlDataInd File request signal sent to ServeFile process
00004376.007 |07:28:32.110 |AppInfo  |<--HTTPConnection::wait_SdlDataInd 
00004377.000 |07:28:32.110 |SdlSig   |FileRequest                            |wait                           |ServeFile(1,600,22,1)            |HTTPConnection(1,600,26,3)       |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004377.001 |07:28:32.110 |AppInfo  |-->ServeFile::wait_FileRequest 
00004377.002 |07:28:32.110 |AppInfo  |   ServeFile::wait_FileRequest Received File request for CTLSEP2834A2823B58.tlv with Request ID 43
00004377.003 |07:28:32.110 |AppInfo  |-->ServeFile::validateFileName 
00004377.004 |07:28:32.110 |AppInfo  |   ServeFile::validateFileName File Requested CTLSEP2834A2823B58.tlv
00004377.005 |07:28:32.110 |AppInfo  |<--ServeFile::validateFileName 
00004377.006 |07:28:32.110 |AppInfo  |   ServeFile::wait_FileRequest File Validation Success and the File to be Searched is CTLSEP2834A2823B58.tlv
00004377.007 |07:28:32.110 |AppInfo  |-->ServeFile::CheckFileIsStatic 
00004377.008 |07:28:32.110 |AppInfo  |   ServeFile::CheckFileIsStatic ctlsep2834a2823b58.tlv is (Not a Static) File
00004377.009 |07:28:32.110 |AppInfo  |<--ServeFile::CheckFileIsStatic 
00004377.010 |07:28:32.110 |AppInfo  |   ServeFile::wait_FileRequest Sending the FileRequest signal to ProcessServeDynamicFile process
00004377.011 |07:28:32.110 |AppInfo  |<--ServeFile::wait_FileRequest 
00004378.000 |07:28:32.110 |SdlSig   |FileRequest                            |wait                           |ServeDynamicFile(1,600,23,5)     |ServeFile(1,600,22,1)            |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004378.001 |07:28:32.110 |AppInfo  |-->ServeDynamicFile::wait_FileRequest 
00004378.002 |07:28:32.110 |AppInfo  |   ServeDynamicFile::wait_FileRequest Received File request for the dynamic file CTLSEP2834A2823B58.tlv
00004378.003 |07:28:32.110 |AppInfo  |-->ServeDynamicFile::isCTLCAPFRequest 
00004378.004 |07:28:32.110 |AppInfo  |   ServeDynamicFile::isCTLCAPFRequest [CTLSEP2834A2823B58.tlv] is Not a CTLCAPF File
00004378.005 |07:28:32.110 |AppInfo  |<--ServeDynamicFile::isCTLCAPFRequest 
00004378.006 |07:28:32.110 |AppInfo  |   ServeDynamicFile::wait_FileRequest HandleCTL: [CTLSEP2834A2823B58.tlv] is CTLSEPMac.tlv file, Searching[2834A2823B58]
00004378.007 |07:28:32.110 |AppInfo  |TFTPCache::FindMatching(SEP2834A2823B58), Not Found



 ##### 07:28:32.110 || The file isn't found locally
00004378.008 |07:28:32.110 |AppInfo  |   ServeDynamicFile::wait_FileRequest HandleCTL: Match[CTLSEP2834A2823B58.tlv] Not found locally
00004378.009 |07:28:32.110 |AppInfo  |-->ServeDynamicFile::FindAndServe 
00004378.010 |07:28:32.110 |AppInfo  |[CTLSEP2834A2823B58.tlv] file not found. Checking [CTLSEP2834A2823B58.tlv.sgn] to strip from
00004378.011 |07:28:32.110 |AppInfo  |   ServeDynamicFile::FindAndServe File Not Found - 404 - Failure
00004378.012 |07:28:32.110 |AppInfo  |<--ServeDynamicFile::FindAndServe 
00004378.013 |07:28:32.110 |AppInfo  |   ServeDynamicFile::wait_FileRequest ID not found for the request... Sending File Not Found
00004378.014 |07:28:32.110 |AppInfo  |<--ServeDynamicFile::wait_FileRequest 
00004379.000 |07:28:32.110 |SdlSig   |FileResponse                           |wait                           |ServeFile(1,600,22,1)            |ServeDynamicFile(1,600,23,5)     |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004379.001 |07:28:32.110 |AppInfo  |-->ServeFile::wait_FileResponse 
00004379.002 |07:28:32.110 |AppInfo  |   ServeFile::wait_FileResponse File Response signal received by ServeFile process



 ##### 07:28:32.110 || The TFTP service checks for remote TFTP servers
00004379.003 |07:28:32.110 |AppInfo  |   ServeFile::wait_FileResponse FileStatus : 0 -- OffClusters Configured : 1
00004379.004 |07:28:32.110 |AppInfo  |   ServeFile::wait_FileResponse OffClusters are configured. Have to search in off-cluster
00004379.005 |07:28:32.110 |AppInfo  |-->ServeFile::searchFileInOffCluster  
00004379.006 |07:28:32.110 |AppInfo  |   ServeFile::searchFileInOffCluster  FileName = CTLSEP2834A2823B58.tlv
00004379.007 |07:28:32.110 |AppInfo  |   ServeFile::searchFileInOffCluster  RequestID = 43
00004379.008 |07:28:32.110 |AppInfo  |   ServeFile::searchFileInOffCluster  IsStatic = 0
00004379.009 |07:28:32.110 |AppInfo  |-->ServeFile::StartSearchReq  
00004379.010 |07:28:32.110 |AppInfo  |   ServeFile::StartSearchReq  Inserting to CRMDB - [CTLSEP2834A2823B58.tlv] [0]



 ##### 07:28:32.110 || The request is sent to the ClusterGWAPi
00004379.011 |07:28:32.110 |AppInfo  |   ServeFile::StartSearchReq  Sending New SearchReq signal with TransID [43] to ClusterGWAPi
00004379.012 |07:28:32.110 |AppInfo  |-->ClusterGWApi::searchReq 
00004379.013 |07:28:32.110 |AppInfo  |   ClusterGWApi::searchReq Sending the SearchReq signal with trans ID [43] to ClusterGW.
00004379.014 |07:28:32.110 |AppInfo  |<--ClusterGWApi::searchReq 
00004379.015 |07:28:32.110 |AppInfo  |<--ServeFile::StartSearchReq  
00004379.016 |07:28:32.110 |AppInfo  |   ServeFile::searchFileInOffCluster  CRM DB Lookup failed, hence sending 503



 ##### 07:28:32.110 || The search for the file in other clusters is started
00004379.017 |07:28:32.110 |AppInfo  |   ServeFile::searchFileInOffCluster  Started the Search Request in the Off Cluster
00004379.018 |07:28:32.110 |AppInfo  |<--ServeFile::searchFileInOffCluster  
00004379.019 |07:28:32.110 |AppInfo  |<--ServeFile::wait_FileResponse 
00004380.000 |07:28:32.110 |SdlSig   |SearchReq                              |wait                           |ClusterMgr(1,600,28,1)           |ClusterGW(1,600,29,1)            |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004380.001 |07:28:32.110 |AppInfo  |-->ClusterMgr::wait_SearchReq 



 ##### 07:28:32.110 || The pkid for the remote cluster is listed as the cluster where the search is delivered to
00004380.002 |07:28:32.110 |AppInfo  |   ClusterMgr::wait_SearchReq Sending Search signal with TransID [43] to Cluster [99a15a05-1cb3-4d8f-9d55-0ec097da47cc]
00004380.003 |07:28:32.110 |AppInfo  |<--ClusterMgr::wait_SearchReq 
00004381.000 |07:28:32.110 |SdlSig   |SearchReq                              |wait                           |Cluster(1,600,31,2)              |ClusterMgr(1,600,28,1)           |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004381.001 |07:28:32.110 |AppInfo  |-->Cluster::wait_SearchReq 
00004381.002 |07:28:32.110 |AppInfo  |<--Cluster::wait_SearchReq 
00004382.000 |07:28:32.110 |SdlSig   |SearchRsp                              |wait                           |ClusterMgr(1,600,28,1)           |Cluster(1,600,31,2)              |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004382.001 |07:28:32.110 |AppInfo  |-->ClusterMgr::wait_SearchRsp 
00004382.002 |07:28:32.110 |AppInfo  |<--ClusterMgr::wait_SearchRsp 
00004383.000 |07:28:32.110 |SdlSig   |FileResponse                           |wait                           |HTTPConnection(1,600,26,3)       |ServeFile(1,600,22,1)            |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004383.001 |07:28:32.110 |AppInfo  |-->HTTPConnection::wait_FileResponse 
00004383.002 |07:28:32.110 |AppInfo  |   HTTPConnection::wait_FileResponse HTTPConnection::wait_FileResponse - Requested file is Busy... Sending 503 response
00004383.003 |07:28:32.110 |AppInfo  |<--HTTPConnection::wait_FileResponse 
00004384.000 |07:28:32.110 |SdlSig   |SearchRsp                              |wait                           |ClusterGW(1,600,29,1)            |ClusterMgr(1,600,28,1)           |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004384.001 |07:28:32.110 |AppInfo  |-->SearchRspCb 



 ##### 07:28:32.110 || The response from teh remote cluster is received and we can see it states FileNotFound. This is expected as the leaf cluster is not in mixed mode.
00004384.002 |07:28:32.110 |AppInfo  |   SearchRspCb Received Search Query response from search engine
00004384.003 |07:28:32.110 |AppInfo  |-->UpdateSearchRsp: Signal TransID[43] 
00004384.004 |07:28:32.110 |AppInfo  |   UpdateSearchRsp: Signal TransID[43] SearchRsp received filename[CTLSEP2834A2823B58.tlv] result [1] transId [43] clusterId [99a15a05-1cb3-4d8f-9d55-0ec097da47cc]isStatic [0] DynamicFile []
00004384.005 |07:28:32.110 |AppInfo  |   UpdateSearchRsp: Signal TransID[43] Search req updated to CRMDB [CTLSEP2834A2823B58.tlv] [FileNotFound] [0] time taken [0] secs
00004384.006 |07:28:32.110 |AppInfo  |<--UpdateSearchRsp: Signal TransID[43] 
00004384.007 |07:28:32.110 |AppInfo  |<--SearchRspCb 



 ##### 07:28:32.110 || SdlCloseRsp for the CTL SdlTCPConnection(1,600,14,63); however, this isn't closed at this time
00004385.000 |07:28:32.110 |SdlSig   |SdlCloseRsp                            |wait                           |HTTPConnection(1,600,26,3)       |SdlTCPConnection(1,600,14,63)    |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004385.001 |07:28:32.110 |AppInfo  |-->HTTPConnection::wait_SdlCloseRsp 
00004385.002 |07:28:32.110 |AppInfo  |   HTTPConnection::wait_SdlCloseRsp Recieved CloseRsp from TcpConnectionPID-[1, 600, 14, 63]
00004385.003 |07:28:32.110 |AppInfo  |<--HTTPConnection::wait_SdlCloseRsp 
00004386.000 |07:28:32.110 |SdlSig   |UpdateReqCount                         |listening                      |HTTPServer(1,600,25,1)           |HTTPConnection(1,600,26,3)       |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004386.001 |07:28:32.110 |AppInfo  |HTTPServer::listening_UpdateReqCount - Printing the PID of sender = [1, 600, 26, 3]
00004386.002 |07:28:32.110 |AppInfo  |HTTPServer::listening_throttle_UpdateReqCount - HTTPConnectionCount = 0, PersistentConnectionCount = 0
00004387.000 |07:28:32.738 |AppInfo  |RequestPoller::pollForRequest(30), fd(24) Read Ready
00004388.000 |07:28:32.738 |AppInfo  |-->TID[e71f5b70] TFTPEngine::getRequest[0xf4d26318](), server socket(24) 



 ##### 07:28:32.738 || The TFTP service seems to do another search for the file
00004389.000 |07:28:32.738 |AppInfo  |   TID[e71f5b70] TFTPEngine::getRequest[0xf4d26318](), server socket(24) INFO:: File Requested CTLSEP2834A2823B58.tlv
00004390.000 |07:28:32.738 |AppInfo  |<--TID[e71f5b70] TFTPEngine::getRequest[0xf4d26318](), server socket(24) 
00004391.000 |07:28:32.738 |AppInfo  |   TID[e71f5b70] TFTPServer::recvMessage[0x892bfd8]() sockets:24 CReqContext[0xf4d26318] Requested File[CTLSEP2834A2823B58.tlv]
00004392.000 |07:28:32.738 |AppInfo  |TFTPEngine::isReadRequest[0xf4d26318~5~192.0.2.11~51909], [CTLSEP2834A2823B58.tlv] opcode(1), Mode(octet), Serving Count(0)
00004393.000 |07:28:32.738 |AppInfo  |   TID[e71f5b70] TFTPServer::recvMessage[0x892bfd8]() sockets:24 count(00000), connect(0xf4d26318), nbytes(31)
00004394.000 |07:28:32.738 |AppInfo  |TID[e71f5b70] CReqProcessThreads::processTftpReq(push CReqContext[0xf4d26318])
00004395.000 |07:28:32.738 |AppInfo  |-->TID[e71f5b70] MemPool::getFromMemPool() 
00004396.000 |07:28:32.738 |AppInfo  |   TID[e71f5b70] MemPool::getFromMemPool() Element[6], Buff[0xf4d26d18], used[1]
00004397.000 |07:28:32.738 |AppInfo  |<--TID[e71f5b70] MemPool::getFromMemPool() 
00004398.000 |07:28:32.738 |AppInfo  |-->TID[f116fb70] CReqContext::TFTPProxyRun(), [0xf4d26318~5~192.0.2.11~51909] 
00004399.000 |07:28:32.738 |AppInfo  |-->TFTPEngine::setupTransport[0xf4d26318~5~192.0.2.11~51909] 
00004400.000 |07:28:32.739 |AppInfo  |   TFTPEngine::setupTransport[0xf4d26318~5~192.0.2.11~51909] TFTP IP_TOS conn sock dscp=96
00004401.000 |07:28:32.739 |AppInfo  |<--TFTPEngine::setupTransport[0xf4d26318~5~192.0.2.11~51909] 
00004402.000 |07:28:32.739 |AppInfo  |-->CReqContext::tftp[0xf4d26318~5~192.0.2.11~51909] 
00004403.000 |07:28:32.739 |AppInfo  |CReqContext::CheckAndSetIsStatic(ctlsep2834a2823b58.tlv) is (Not a Static) File
00004404.000 |07:28:32.739 |AppInfo  |CReqContext::isCTLCAPFRequest[CTLSEP2834A2823B58.tlv] Not a CTLCAPF File
00004405.000 |07:28:32.739 |AppInfo  |   CReqContext::tftp[0xf4d26318~5~192.0.2.11~51909] HandleCTL: [CTLSEP2834A2823B58.tlv] is CTLSEPMac.tlv file, Searching[2834A2823B58]



 ##### 07:28:32.739 || Once again we see Not found locally
00004406.000 |07:28:32.739 |AppInfo  |TFTPCache::FindMatching(SEP2834A2823B58), Not Found
00004407.000 |07:28:32.739 |AppInfo  |   CReqContext::tftp[0xf4d26318~5~192.0.2.11~51909] HandleCTL: Match[2834A2823B58] Not found locally
00004408.000 |07:28:32.739 |AppInfo  |CReqContext::checkAndHandleDiagReq[0xf4d26318~5~192.0.2.11~51909], File[CTLSEP2834A2823B58.tlv]
00004409.000 |07:28:32.739 |AppInfo  |   CReqContext::tftp[0xf4d26318~5~192.0.2.11~51909] Found entry [CTLSEP2834A2823B58.tlv] in state[1] in CRMDB with count [0]
00004410.000 |07:28:32.739 |AppInfo  |INFO: TFTPEngine::sendNAK[0xf4d26318~5~192.0.2.11~51909], File[CTLSEP2834A2823B58.tlv], Error(1)
00004411.000 |07:28:32.739 |AppInfo  |<--CReqContext::tftp[0xf4d26318~5~192.0.2.11~51909] 
00004412.000 |07:28:32.739 |AppInfo  |<--TID[f116fb70] CReqContext::TFTPProxyRun(), [0xf4d26318~5~192.0.2.11~51909] 
00004413.000 |07:28:32.739 |AppInfo  |TID[f116fb70] CReqContext::~CReqContext[0xf4d26318~5~192.0.2.11~51909]destructor
00004414.000 |07:28:32.739 |AppInfo  |TID[f116fb70] MemPool::putToMemPool(0xf4d26318) m_element[5].Buff = [0xf4d26318] 



 ##### 07:28:32.946 || SdlConnectionInd for the phone connecting to request the ITL file
00004415.000 |07:28:32.946 |SdlSig   |SdlConnectionInd                       |listening                      |HTTPServer(1,600,25,1)           |SdlTCPConnection(1,600,14,64)    |1,600,12,1.44^*^*                        |*TraceFlagOverrode
00004415.001 |07:28:32.946 |AppInfo  |-->HTTPSERVER::listening_SdlConnectionInd 
00004415.002 |07:28:32.946 |AppInfo  |HTTPServer::listening_SdlConnection - Printing the sender PID = [1, 600, 14, 64]
00004415.003 |07:28:32.946 |AppInfo  |HTTPServer::handleConnection - Sending a Reassociate Request to Reassociate the newly created HTTPConnectionInfo object to the network/client
00004415.004 |07:28:32.946 |AppInfo  |HTTPServer::listening_SdlConnectionInd - Maximum serving count for HTTP connection is  = 2500
00004415.005 |07:28:32.946 |AppInfo  |HTTPServer::listening_SdlConnectionInd - HTTPConnectionCount = 1
00004415.006 |07:28:32.946 |AppInfo  |<--HTTPSERVER::listening_SdlConnectionInd 
00004416.000 |07:28:32.946 |SdlSig   |SdlReassociateRsp                      |listening                      |HTTPServer(1,600,25,1)           |SdlTCPConnection(1,600,14,64)    |1,600,12,1.44^*^*                        |*TraceFlagOverrode
00004416.001 |07:28:32.946 |AppInfo  |HTTPServer::listening_SdlReassociateRsp - Reassociation Successfull
00004416.002 |07:28:32.946 |AppInfo  |HTTPServer::listening_SdlReassociateRsp - Printing the PID of sender = [1, 600, 14, 64]
00004417.000 |07:28:32.946 |SdlSig   |SdlReassociateInd                      |wait                           |HTTPConnection(1,600,26,4)       |SdlTCPConnection(1,600,14,64)    |1,600,12,1.44^*^*                        |*TraceFlagOverrode
00004417.001 |07:28:32.946 |AppInfo  |-->HTTPConnection::wait_SdlReassociateInd 
00004417.002 |07:28:32.946 |AppInfo  |   HTTPConnection::wait_SdlReassociateInd Received ReassociateIndication from 192.0.2.11
00004417.003 |07:28:32.946 |AppInfo  |<--HTTPConnection::wait_SdlReassociateInd 
00004418.000 |07:28:32.946 |SdlSig   |SdlDataInd                             |wait                           |HTTPConnection(1,600,26,4)       |SdlTCPConnection(1,600,14,64)    |1,600,14,64.2^*^*                        |*TraceFlagOverrode
00004418.001 |07:28:32.946 |AppInfo  |-->HTTPConnection::wait_SdlDataInd 
00004418.002 |07:28:32.946 |AppInfo  |   HTTPConnection::wait_SdlDataInd SdlDataInd recived from TcpPID-[1, 600, 14, 64]



 ##### 07:28:32.946 || The phone requests it's ITL
00004418.003 |07:28:32.946 |AppInfo  |   HTTPConnection::wait_SdlDataInd Printing the HTTPRequest : msgBuffer size [64] --: GET /ITLSEP2834A2823B58.tlv HTTP/1.1
Host:198.51.100.0:6970


00004418.004 |07:28:32.946 |AppInfo  |   HTTPConnection::wait_SdlDataInd Proxy Request- 0 , ITLSEP2834A2823B58.tlv
00004418.005 |07:28:32.946 |AppInfo  |   HTTPConnection::wait_SdlDataInd Decode successful - Filename is : ITLSEP2834A2823B58.tlv
00004418.006 |07:28:32.946 |AppInfo  |   HTTPConnection::wait_SdlDataInd File request signal sent to ServeFile process
00004418.007 |07:28:32.946 |AppInfo  |<--HTTPConnection::wait_SdlDataInd 
00004419.000 |07:28:32.946 |SdlSig   |FileRequest                            |wait                           |ServeFile(1,600,22,1)            |HTTPConnection(1,600,26,4)       |1,600,14,64.2^*^*                        |*TraceFlagOverrode
00004419.001 |07:28:32.946 |AppInfo  |-->ServeFile::wait_FileRequest 
00004419.002 |07:28:32.946 |AppInfo  |   ServeFile::wait_FileRequest Received File request for ITLSEP2834A2823B58.tlv with Request ID 44
00004419.003 |07:28:32.946 |AppInfo  |-->ServeFile::validateFileName 
00004419.004 |07:28:32.946 |AppInfo  |   ServeFile::validateFileName File Requested ITLSEP2834A2823B58.tlv
00004419.005 |07:28:32.946 |AppInfo  |<--ServeFile::validateFileName 
00004419.006 |07:28:32.946 |AppInfo  |   ServeFile::wait_FileRequest File Validation Success and the File to be Searched is ITLSEP2834A2823B58.tlv
00004419.007 |07:28:32.946 |AppInfo  |-->ServeFile::CheckFileIsStatic 
00004419.008 |07:28:32.946 |AppInfo  |   ServeFile::CheckFileIsStatic itlsep2834a2823b58.tlv is (Not a Static) File
00004419.009 |07:28:32.946 |AppInfo  |<--ServeFile::CheckFileIsStatic 
00004419.010 |07:28:32.946 |AppInfo  |   ServeFile::wait_FileRequest Sending the FileRequest signal to ProcessServeDynamicFile process
00004419.011 |07:28:32.946 |AppInfo  |<--ServeFile::wait_FileRequest 
00004420.000 |07:28:32.946 |SdlSig   |FileRequest                            |wait                           |ServeDynamicFile(1,600,23,1)     |ServeFile(1,600,22,1)            |1,600,14,64.2^*^*                        |*TraceFlagOverrode
00004420.001 |07:28:32.946 |AppInfo  |-->ServeDynamicFile::wait_FileRequest 
00004420.002 |07:28:32.946 |AppInfo  |   ServeDynamicFile::wait_FileRequest Received File request for the dynamic file ITLSEP2834A2823B58.tlv
00004420.003 |07:28:32.946 |AppInfo  |-->ServeDynamicFile::isCTLCAPFRequest 
00004420.004 |07:28:32.946 |AppInfo  |   ServeDynamicFile::isCTLCAPFRequest [ITLSEP2834A2823B58.tlv] is Not a CTLCAPF File
00004420.005 |07:28:32.946 |AppInfo  |<--ServeDynamicFile::isCTLCAPFRequest 



 ##### 07:28:32.946 || We see "Not found locally" for the ITL as well
00004420.006 |07:28:32.946 |AppInfo  |   ServeDynamicFile::wait_FileRequest HandleITL: [ITLSEP2834A2823B58.tlv] is ITLSEPMac.tlv file, Searching[2834A2823B58]
00004420.007 |07:28:32.946 |AppInfo  |TFTPCache::FindMatching(SEP2834A2823B58), Not Found
00004420.008 |07:28:32.946 |AppInfo  |   ServeDynamicFile::wait_FileRequest HandleITL: Match[ITLSEP2834A2823B58.tlv] Not found locally
00004420.009 |07:28:32.946 |AppInfo  |-->ServeDynamicFile::FindAndServe 
00004420.010 |07:28:32.946 |AppInfo  |[ITLSEP2834A2823B58.tlv] file not found. Checking [ITLSEP2834A2823B58.tlv.sgn] to strip from
00004420.011 |07:28:32.946 |AppInfo  |   ServeDynamicFile::FindAndServe File Not Found - 404 - Failure
00004420.012 |07:28:32.946 |AppInfo  |<--ServeDynamicFile::FindAndServe 
00004420.013 |07:28:32.946 |AppInfo  |   ServeDynamicFile::wait_FileRequest ID not found for the request... Sending File Not Found
00004420.014 |07:28:32.946 |AppInfo  |<--ServeDynamicFile::wait_FileRequest 
00004421.000 |07:28:32.946 |SdlSig   |FileResponse                           |wait                           |ServeFile(1,600,22,1)            |ServeDynamicFile(1,600,23,1)     |1,600,14,64.2^*^*                        |*TraceFlagOverrode
00004421.001 |07:28:32.946 |AppInfo  |-->ServeFile::wait_FileResponse 
00004421.002 |07:28:32.946 |AppInfo  |   ServeFile::wait_FileResponse File Response signal received by ServeFile process



 ##### 07:28:32.946 || Again TFTP checks for remote TFTP clusters
00004421.003 |07:28:32.946 |AppInfo  |   ServeFile::wait_FileResponse FileStatus : 0 -- OffClusters Configured : 1
00004421.004 |07:28:32.946 |AppInfo  |   ServeFile::wait_FileResponse OffClusters are configured. Have to search in off-cluster
00004421.005 |07:28:32.946 |AppInfo  |-->ServeFile::searchFileInOffCluster  
00004421.006 |07:28:32.946 |AppInfo  |   ServeFile::searchFileInOffCluster  FileName = ITLSEP2834A2823B58.tlv
00004421.007 |07:28:32.946 |AppInfo  |   ServeFile::searchFileInOffCluster  RequestID = 44
00004421.008 |07:28:32.946 |AppInfo  |   ServeFile::searchFileInOffCluster  IsStatic = 0
00004421.009 |07:28:32.946 |AppInfo  |   ServeFile::searchFileInOffCluster  Found entry [ITLSEP2834A2823B58.tlv] in state[15] in CRMDB with count [0]



 ##### 07:28:32.946 || The request is sent to ClusterGWApi
00004421.010 |07:28:32.946 |AppInfo  |   ServeFile::searchFileInOffCluster  File [ITLSEP2834A2823B58.tlv] Found in CRMDB. Sending ServeReq Signal to ClusterGWApi.
00004421.011 |07:28:32.946 |AppInfo  |   ServeFile::searchFileInOffCluster  Saved ConReq [0xed605458]. Sending New ServeReq signal with TransID [44] to ClusterGWAPi
00004421.012 |07:28:32.946 |AppInfo  |-->ClusterGWApi::serveReq 
00004421.013 |07:28:32.946 |AppInfo  |   ClusterGWApi::serveReq Sending the ServeReq signal with trans ID [44] to ClusterGW.
00004421.014 |07:28:32.946 |AppInfo  |<--ClusterGWApi::serveReq 
00004421.015 |07:28:32.946 |AppInfo  |<--ServeFile::searchFileInOffCluster  
00004421.016 |07:28:32.946 |AppInfo  |<--ServeFile::wait_FileResponse 
00004422.000 |07:28:32.946 |SdlSig   |ServeReq                               |wait                           |ClusterMgr(1,600,28,1)           |ClusterGW(1,600,29,1)            |1,600,14,64.2^*^*                        |*TraceFlagOverrode
00004422.001 |07:28:32.946 |AppInfo  |-->ClusterMgr::wait_ServeReq 



 ##### 07:28:32.946 || The pkid for the remote cluster is listed as the cluster where the search is delivered to
00004422.002 |07:28:32.946 |AppInfo  |   ClusterMgr::wait_ServeReq Sending ServeReq signal with TransID [44] to Cluster [99a15a05-1cb3-4d8f-9d55-0ec097da47cc]
00004422.003 |07:28:32.946 |AppInfo  |<--ClusterMgr::wait_ServeReq 
00004423.000 |07:28:32.946 |SdlSig   |ServeReq                               |wait                           |Cluster(1,600,31,2)              |ClusterMgr(1,600,28,1)           |1,600,14,64.2^*^*                        |*TraceFlagOverrode
00004423.001 |07:28:32.946 |AppInfo  |-->Cluster::wait_ServeReq 
00004423.002 |07:28:32.946 |AppInfo  |<--Cluster::wait_ServeReq 
00004424.000 |07:28:32.947 |SdlSig   |SdlReadRsp                             |searching                      |ClusterClient(1,600,30,11)       |SdlTCPConnection(1,600,14,14)    |1,600,14,14.33^*^*                       |*TraceFlagOverrode
00004424.001 |07:28:32.947 |AppInfo  |-->ClusterClient::searching_SdlReadRsp 



 ##### 07:28:32.947 || We see a 200 OK
00004424.002 |07:28:32.947 |AppInfo  |   ClusterClient::searching_SdlReadRsp ClusterClient_searching_SdlReadRsp: Contents of msgBuffer is HTTP/1.1 200 OK
Content-length: 8003
Cache-Control: no-store
Content-type: */*
00004424.003 |07:28:32.947 |AppInfo  |-->ClusterClient::decodeHttpHdr 



 ##### 07:28:32.947 || The file is written to /usr/local/cm/tftp/tftpcache/
00004424.004 |07:28:32.947 |AppInfo  |   ClusterClient::decodeHttpHdr SERVE_QUERY: Writing Dynamic file to location [/usr/local/cm/tftp/tftpcache/ITLSEP2834A2823B58.tlv.44]
00004424.005 |07:28:32.947 |AppInfo  |<--ClusterClient::decodeHttpHdr 
00004424.006 |07:28:32.947 |AppInfo  |<--ClusterClient::searching_SdlReadRsp 
00004425.000 |07:28:32.947 |SdlSig   |WriteReq                               |wait                           |Writer(1,600,20,1)               |WriterMgr(1,600,19,1)            |1,600,14,14.33^*^*                       |*TraceFlagOverrode
00004425.001 |07:28:32.947 |AppInfo  |-->WriteReq::wait_WriteReq 
00004426.000 |07:28:32.947 |SdlSig   |SdlReadRsp                             |searching                      |ClusterClient(1,600,30,11)       |SdlTCPConnection(1,600,14,14)    |1,600,14,14.34^*^*                       |*TraceFlagOverrode
00004426.001 |07:28:32.947 |AppInfo  |-->ClusterClient::searching_SdlReadRsp 



 ##### 07:28:32.947 || the content is decoded
00004426.002 |07:28:32.947 |AppInfo  |-->ClusterClient::decodeHttpContent 
00004426.003 |07:28:32.947 |AppInfo  |sendServeRsp to [1.600.31.2], result[15], transId[44], filename[ITLSEP2834A2823B58.tlv], clusterId[192.0.2.12(99a15a05-1cb3-4d8f-9d55-0ec097da47cc)],prevResult[0],Protocoltype [1] 
00004426.004 |07:28:32.947 |AppInfo  |<--ClusterClient::decodeHttpContent 
00004426.005 |07:28:32.947 |AppInfo  |<--ClusterClient::searching_SdlReadRsp 
00004427.000 |07:28:32.947 |SdlSig   |ServeRsp                               |wait                           |Cluster(1,600,31,2)              |ClusterClient(1,600,30,11)       |1,600,14,14.34^*^*                       |*TraceFlagOverrode
00004427.001 |07:28:32.947 |AppInfo  |-->Cluster::recvServeRsp 
00004427.002 |07:28:32.947 |AppInfo  |<--Cluster::recvServeRsp 
00004428.000 |07:28:32.947 |SdlSig   |ServeRsp                               |wait                           |ClusterMgr(1,600,28,1)           |Cluster(1,600,31,2)              |1,600,14,14.34^*^*                       |*TraceFlagOverrode
00004428.001 |07:28:32.947 |AppInfo  |-->ClusterMgr::wait_ServeRsp 
00004428.002 |07:28:32.947 |AppInfo  |   ClusterMgr::wait_ServeRsp File found for the ServeReq with TransID [44] in Cluster [99a15a05-1cb3-4d8f-9d55-0ec097da47cc]
00004428.003 |07:28:32.947 |AppInfo  |<--ClusterMgr::wait_ServeRsp 
00004425.002 |07:28:32.947 |AppInfo  |<--WriteReq::wait_WriteReq 
00004429.000 |07:28:32.947 |SdlSig   |WriteReq                               |wait                           |Writer(1,600,20,1)               |WriterMgr(1,600,19,1)            |1,600,14,14.34^*^*                       |*TraceFlagOverrode
00004429.001 |07:28:32.947 |AppInfo  |-->WriteReq::wait_WriteReq 
00004429.002 |07:28:32.947 |AppInfo  |<--WriteReq::wait_WriteReq 
00004430.000 |07:28:32.947 |SdlSig   |WriteReq                               |wait                           |Writer(1,600,20,1)               |WriterMgr(1,600,19,1)            |1,600,14,14.34^*^*                       |*TraceFlagOverrode
00004430.001 |07:28:32.947 |AppInfo  |-->WriteReq::wait_WriteReq 
00004430.002 |07:28:32.947 |AppInfo  |sendServeRsp from writerThread to clusterGw, result[15], transId[44], filename[ITLSEP2834A2823B58.tlv], clusterId[99a15a05-1cb3-4d8f-9d55-0ec097da47cc], ProtocolType[1]
00004430.003 |07:28:32.947 |AppInfo  |<--WriteReq::wait_WriteReq 
00004431.000 |07:28:32.947 |SdlSig   |ServeRsp                               |wait                           |ClusterGW(1,600,29,1)            |Writer(1,600,20,1)               |1,600,14,14.34^*^*                       |*TraceFlagOverrode
00004431.001 |07:28:32.947 |AppInfo  |-->SearchRspCb 
00004431.002 |07:28:32.947 |AppInfo  |   SearchRspCb Received Serve Query response from search engine
00004431.003 |07:28:32.947 |AppInfo  |   SearchRspCb ProtocolValue = 1
00004431.004 |07:28:32.947 |AppInfo  |-->ReceivedServeRsp: Signal TransID[44] 
00004431.005 |07:28:32.947 |AppInfo  |   ReceivedServeRsp: Signal TransID[44] Dynamic Filename [/usr/local/cm/tftp/tftpcache/ITLSEP2834A2823B58.tlv.44]
00004431.006 |07:28:32.947 |AppInfo  |   ReceivedServeRsp: Signal TransID[44] File Found - 200 - Success
00004431.007 |07:28:32.947 |AppInfo  |   ReceivedServeRsp: Signal TransID[44] FileResponse Signal sent to connection object
00004431.008 |07:28:32.947 |AppInfo  |<--ReceivedServeRsp: Signal TransID[44] 
00004431.009 |07:28:32.947 |AppInfo  |<--SearchRspCb 
00004432.000 |07:28:32.947 |SdlSig   |FileResponse                           |wait                           |HTTPConnection(1,600,26,4)       |ServeFile(1,600,22,1)            |1,600,14,14.34^*^*                       |*TraceFlagOverrode
00004432.001 |07:28:32.947 |AppInfo  |-->HTTPConnection::wait_FileResponse 



 ##### 07:28:32.947 || The Proxy TFTP sends the ITL file to the phone.
00004432.002 |07:28:32.947 |AppInfo  |   HTTPConnection::wait_FileResponse Requested file FOUND... Sending file Response
00004432.003 |07:28:32.947 |AppInfo  |   HTTPConnection::wait_FileResponse Skip envelope is false or this is not a static file request, serving file [/usr/local/cm/tftp/tftpcache/ITLSEP2834A2823B58.tlv.44]
00004432.004 |07:28:32.947 |AppInfo  |<--HTTPConnection::wait_FileResponse 
00004433.000 |07:28:32.947 |SdlSig   |SdlSendfileRsp                         |wait                           |HTTPConnection(1,600,26,4)       |SdlTCPConnection(1,600,14,64)    |1,600,14,64.3^*^*                        |*TraceFlagOverrode
00004433.001 |07:28:32.947 |AppInfo  |-->HTTPConnection::wait_SdlSendfileRsp 
00004433.002 |07:28:32.947 |AppInfo  |<--HTTPConnection::wait_SdlSendfileRsp 



 ##### 07:28:33.560 || SdlCloseInd closing the connection for the ITL requestSdlTCPConnection(1,600,14,64)
00004434.000 |07:28:33.560 |SdlSig   |SdlCloseInd                            |wait                           |HTTPConnection(1,600,26,4)       |SdlTCPConnection(1,600,14,64)    |1,600,14,64.4^*^*                        |*TraceFlagOverrode
00004434.001 |07:28:33.560 |AppInfo  |-->HTTPConnection::wait_SdlCloseInd 
00004434.002 |07:28:33.560 |AppInfo  |   HTTPConnection::wait_SdlCloseInd Recieved CloseInd from TcpConnectionPID-[1, 600, 14, 64]
00004434.003 |07:28:33.560 |AppInfo  |<--HTTPConnection::wait_SdlCloseInd 
00004435.000 |07:28:33.560 |SdlSig   |UpdateReqCount                         |listening                      |HTTPServer(1,600,25,1)           |HTTPConnection(1,600,26,4)       |1,600,14,64.4^*^*                        |*TraceFlagOverrode
00004435.001 |07:28:33.560 |AppInfo  |HTTPServer::listening_UpdateReqCount - Printing the PID of sender = [1, 600, 26, 4]
00004435.002 |07:28:33.560 |AppInfo  |HTTPServer::listening_throttle_UpdateReqCount - HTTPConnectionCount = 0, PersistentConnectionCount = 0



 ##### 07:28:34.615 || SdlConnectionInd for the phone connecting to request the config file SdlTCPConnection(1,600,14,65)
00004436.000 |07:28:34.615 |SdlSig   |SdlConnectionInd                       |listening                      |HTTPServer(1,600,25,1)           |SdlTCPConnection(1,600,14,65)    |1,600,12,1.45^*^*                        |*TraceFlagOverrode
00004436.001 |07:28:34.615 |AppInfo  |-->HTTPSERVER::listening_SdlConnectionInd 
00004436.002 |07:28:34.615 |AppInfo  |HTTPServer::listening_SdlConnection - Printing the sender PID = [1, 600, 14, 65]
00004436.003 |07:28:34.615 |AppInfo  |HTTPServer::handleConnection - Sending a Reassociate Request to Reassociate the newly created HTTPConnectionInfo object to the network/client
00004436.004 |07:28:34.615 |AppInfo  |HTTPServer::listening_SdlConnectionInd - Maximum serving count for HTTP connection is  = 2500
00004436.005 |07:28:34.615 |AppInfo  |HTTPServer::listening_SdlConnectionInd - HTTPConnectionCount = 1
00004436.006 |07:28:34.615 |AppInfo  |<--HTTPSERVER::listening_SdlConnectionInd 
00004437.000 |07:28:34.615 |SdlSig   |SdlReassociateRsp                      |listening                      |HTTPServer(1,600,25,1)           |SdlTCPConnection(1,600,14,65)    |1,600,12,1.45^*^*                        |*TraceFlagOverrode
00004437.001 |07:28:34.615 |AppInfo  |HTTPServer::listening_SdlReassociateRsp - Reassociation Successfull
00004437.002 |07:28:34.615 |AppInfo  |HTTPServer::listening_SdlReassociateRsp - Printing the PID of sender = [1, 600, 14, 65]
00004438.000 |07:28:34.615 |SdlSig   |SdlReassociateInd                      |wait                           |HTTPConnection(1,600,26,5)       |SdlTCPConnection(1,600,14,65)    |1,600,12,1.45^*^*                        |*TraceFlagOverrode
00004438.001 |07:28:34.615 |AppInfo  |-->HTTPConnection::wait_SdlReassociateInd 
00004438.002 |07:28:34.615 |AppInfo  |   HTTPConnection::wait_SdlReassociateInd Received ReassociateIndication from 192.0.2.11
00004438.003 |07:28:34.615 |AppInfo  |<--HTTPConnection::wait_SdlReassociateInd 
00004439.000 |07:28:34.615 |SdlSig   |SdlDataInd                             |wait                           |HTTPConnection(1,600,26,5)       |SdlTCPConnection(1,600,14,65)    |1,600,14,65.2^*^*                        |*TraceFlagOverrode
00004439.001 |07:28:34.615 |AppInfo  |-->HTTPConnection::wait_SdlDataInd 
00004439.002 |07:28:34.615 |AppInfo  |   HTTPConnection::wait_SdlDataInd SdlDataInd recived from TcpPID-[1, 600, 14, 65]



 ##### 07:28:34.615 || The phone requests it's config file
00004439.003 |07:28:34.615 |AppInfo  |   HTTPConnection::wait_SdlDataInd Printing the HTTPRequest : msgBuffer size [69] --: GET /SEP2834A2823B58.cnf.xml.sgn HTTP/1.1
Host:198.51.100.0:6970


00004439.004 |07:28:34.615 |AppInfo  |   HTTPConnection::wait_SdlDataInd Proxy Request- 0 , SEP2834A2823B58.cnf.xml.sgn
00004439.005 |07:28:34.615 |AppInfo  |   HTTPConnection::wait_SdlDataInd Decode successful - Filename is : SEP2834A2823B58.cnf.xml.sgn
00004439.006 |07:28:34.615 |AppInfo  |   HTTPConnection::wait_SdlDataInd File request signal sent to ServeFile process
00004439.007 |07:28:34.615 |AppInfo  |<--HTTPConnection::wait_SdlDataInd 
00004440.000 |07:28:34.615 |SdlSig   |FileRequest                            |wait                           |ServeFile(1,600,22,1)            |HTTPConnection(1,600,26,5)       |1,600,14,65.2^*^*                        |*TraceFlagOverrode
00004440.001 |07:28:34.615 |AppInfo  |-->ServeFile::wait_FileRequest 
00004440.002 |07:28:34.616 |AppInfo  |   ServeFile::wait_FileRequest Received File request for SEP2834A2823B58.cnf.xml.sgn with Request ID 45
00004440.003 |07:28:34.616 |AppInfo  |-->ServeFile::validateFileName 
00004440.004 |07:28:34.616 |AppInfo  |   ServeFile::validateFileName File Requested SEP2834A2823B58.cnf.xml.sgn
00004440.005 |07:28:34.616 |AppInfo  |<--ServeFile::validateFileName 
00004440.006 |07:28:34.616 |AppInfo  |   ServeFile::wait_FileRequest File Validation Success and the File to be Searched is SEP2834A2823B58.cnf.xml.sgn
00004440.007 |07:28:34.616 |AppInfo  |-->ServeFile::CheckFileIsStatic 
00004440.008 |07:28:34.616 |AppInfo  |   ServeFile::CheckFileIsStatic sep2834a2823b58.cnf.xml.sgn is (Not a Static) File
00004440.009 |07:28:34.616 |AppInfo  |<--ServeFile::CheckFileIsStatic 
00004440.010 |07:28:34.616 |AppInfo  |   ServeFile::wait_FileRequest Sending the FileRequest signal to ProcessServeDynamicFile process
00004440.011 |07:28:34.616 |AppInfo  |<--ServeFile::wait_FileRequest 
00004441.000 |07:28:34.616 |SdlSig   |FileRequest                            |wait                           |ServeDynamicFile(1,600,23,2)     |ServeFile(1,600,22,1)            |1,600,14,65.2^*^*                        |*TraceFlagOverrode
00004441.001 |07:28:34.616 |AppInfo  |-->ServeDynamicFile::wait_FileRequest 
00004441.002 |07:28:34.616 |AppInfo  |   ServeDynamicFile::wait_FileRequest Received File request for the dynamic file SEP2834A2823B58.cnf.xml.sgn
00004441.003 |07:28:34.616 |AppInfo  |-->ServeDynamicFile::isCTLCAPFRequest 
00004441.004 |07:28:34.616 |AppInfo  |   ServeDynamicFile::isCTLCAPFRequest [SEP2834A2823B58.cnf.xml.sgn] is Not a CTLCAPF File
00004441.005 |07:28:34.616 |AppInfo  |<--ServeDynamicFile::isCTLCAPFRequest 
00004441.006 |07:28:34.616 |AppInfo  |   ServeDynamicFile::wait_FileRequest Requested File is : [sep2834a2823b58.cnf.xml.sgn]
00004441.007 |07:28:34.616 |AppInfo  |-->ServeDynamicFile::retrieveTypeOfRequest 
00004441.008 |07:28:34.616 |AppInfo  |   ServeDynamicFile::retrieveTypeOfRequest Request is for XML signed Config File
00004441.009 |07:28:34.616 |AppInfo  |   ServeDynamicFile::retrieveTypeOfRequest File Requested is : [sep2834a2823b58.cnf.xml.sgn]
00004441.010 |07:28:34.616 |AppInfo  |<--ServeDynamicFile::retrieveTypeOfRequest 
00004441.011 |07:28:34.616 |AppInfo  |   ServeDynamicFile::wait_FileRequest Type of Request is : [2]
00004441.012 |07:28:34.616 |AppInfo  |-->CServiceModule::getDeviceNameFromRequest 
00004441.013 |07:28:34.616 |AppInfo  |   CServiceModule::getDeviceNameFromRequest File name after stripping off the extensions = sep2834a2823b58
00004441.014 |07:28:34.616 |AppInfo  |<--CServiceModule::getDeviceNameFromRequest 
00004441.015 |07:28:34.616 |AppInfo  |-->CServiceModule::getIDForRequest 
00004441.016 |07:28:34.616 |AppInfo  |   CServiceModule::getIDForRequest Unable to find device in DB = sep2834a2823b58
00004441.017 |07:28:34.616 |AppInfo  |<--CServiceModule::getIDForRequest 
00004441.018 |07:28:34.616 |AppInfo  |-->ServeDynamicFile::FindAndServe 



 ##### 07:28:34.616 || The proxy TFTP service lets us know the phone's config file isn't found; however, this time it doesn't state Not found locally
00004441.019 |07:28:34.616 |AppInfo  |   ServeDynamicFile::FindAndServe File Not Found - 404 - Failure
00004441.020 |07:28:34.616 |AppInfo  |<--ServeDynamicFile::FindAndServe 
00004441.021 |07:28:34.616 |AppInfo  |   ServeDynamicFile::wait_FileRequest ID not found for the request... Sending File Not Found
00004441.022 |07:28:34.616 |AppInfo  |<--ServeDynamicFile::wait_FileRequest 
00004442.000 |07:28:34.616 |SdlSig   |FileResponse                           |wait                           |ServeFile(1,600,22,1)            |ServeDynamicFile(1,600,23,2)     |1,600,14,65.2^*^*                        |*TraceFlagOverrode
00004442.001 |07:28:34.616 |AppInfo  |-->ServeFile::wait_FileResponse 
00004442.002 |07:28:34.616 |AppInfo  |   ServeFile::wait_FileResponse File Response signal received by ServeFile process



 ##### 07:28:34.616 || The TFTP service checks for remote TFTP servers
00004442.003 |07:28:34.616 |AppInfo  |   ServeFile::wait_FileResponse FileStatus : 0 -- OffClusters Configured : 1
00004442.004 |07:28:34.616 |AppInfo  |   ServeFile::wait_FileResponse OffClusters are configured. Have to search in off-cluster
00004442.005 |07:28:34.616 |AppInfo  |-->ServeFile::searchFileInOffCluster  
00004442.006 |07:28:34.616 |AppInfo  |   ServeFile::searchFileInOffCluster  FileName = SEP2834A2823B58.cnf.xml.sgn
00004442.007 |07:28:34.616 |AppInfo  |   ServeFile::searchFileInOffCluster  RequestID = 45
00004442.008 |07:28:34.616 |AppInfo  |   ServeFile::searchFileInOffCluster  IsStatic = 0
00004442.009 |07:28:34.616 |AppInfo  |   ServeFile::searchFileInOffCluster  Found entry [SEP2834A2823B58.cnf.xml.sgn] in state[15] in CRMDB with count [0]



 ##### 07:28:34.616 || The request is sent to the ClusterGWAPi
00004442.010 |07:28:34.616 |AppInfo  |   ServeFile::searchFileInOffCluster  File [SEP2834A2823B58.cnf.xml.sgn] Found in CRMDB. Sending ServeReq Signal to ClusterGWApi.
00004442.011 |07:28:34.616 |AppInfo  |   ServeFile::searchFileInOffCluster  Saved ConReq [0xed605458]. Sending New ServeReq signal with TransID [45] to ClusterGWAPi
00004442.012 |07:28:34.616 |AppInfo  |-->ClusterGWApi::serveReq 
00004442.013 |07:28:34.616 |AppInfo  |   ClusterGWApi::serveReq Sending the ServeReq signal with trans ID [45] to ClusterGW.
00004442.014 |07:28:34.616 |AppInfo  |<--ClusterGWApi::serveReq 
00004442.015 |07:28:34.616 |AppInfo  |<--ServeFile::searchFileInOffCluster  
00004442.016 |07:28:34.616 |AppInfo  |<--ServeFile::wait_FileResponse 
00004443.000 |07:28:34.616 |SdlSig   |ServeReq                               |wait                           |ClusterMgr(1,600,28,1)           |ClusterGW(1,600,29,1)            |1,600,14,65.2^*^*                        |*TraceFlagOverrode
00004443.001 |07:28:34.616 |AppInfo  |-->ClusterMgr::wait_ServeReq 



 ##### 07:28:34.616 || The pkid for the remote cluster is listed as the cluster where the search is delivered to
00004443.002 |07:28:34.616 |AppInfo  |   ClusterMgr::wait_ServeReq Sending ServeReq signal with TransID [45] to Cluster [99a15a05-1cb3-4d8f-9d55-0ec097da47cc]
00004443.003 |07:28:34.616 |AppInfo  |<--ClusterMgr::wait_ServeReq 
00004444.000 |07:28:34.616 |SdlSig   |ServeReq                               |wait                           |Cluster(1,600,31,2)              |ClusterMgr(1,600,28,1)           |1,600,14,65.2^*^*                        |*TraceFlagOverrode
00004444.001 |07:28:34.616 |AppInfo  |-->Cluster::wait_ServeReq 
00004444.002 |07:28:34.616 |AppInfo  |<--Cluster::wait_ServeReq 
00004445.000 |07:28:34.624 |SdlSig   |SdlReadRsp                             |searching                      |ClusterClient(1,600,30,11)       |SdlTCPConnection(1,600,14,14)    |1,600,14,14.35^*^*                       |*TraceFlagOverrode
00004445.001 |07:28:34.624 |AppInfo  |-->ClusterClient::searching_SdlReadRsp 



 ##### 07:28:34.624 || We see a 200 OK
00004445.002 |07:28:34.624 |AppInfo  |   ClusterClient::searching_SdlReadRsp ClusterClient_searching_SdlReadRsp: Contents of msgBuffer is HTTP/1.1 200 OK
Content-length: 12952
Cache-Control: no-store
Content-type: */*

킹׋ɱ
00004445.003 |07:28:34.624 |AppInfo  |-->ClusterClient::decodeHttpHdr 



 ##### 07:28:34.624 || The file is written to /usr/local/cm/tftp/tftpcache/
00004445.004 |07:28:34.624 |AppInfo  |   ClusterClient::decodeHttpHdr SERVE_QUERY: Writing Dynamic file to location [/usr/local/cm/tftp/tftpcache/SEP2834A2823B58.cnf.xml.sgn.45]
00004445.005 |07:28:34.624 |AppInfo  |<--ClusterClient::decodeHttpHdr 
00004445.006 |07:28:34.624 |AppInfo  |<--ClusterClient::searching_SdlReadRsp 
00004446.000 |07:28:34.624 |SdlSig   |WriteReq                               |wait                           |Writer(1,600,20,1)               |WriterMgr(1,600,19,1)            |1,600,14,14.35^*^*                       |*TraceFlagOverrode
00004446.001 |07:28:34.624 |AppInfo  |-->WriteReq::wait_WriteReq 
00004446.002 |07:28:34.624 |AppInfo  |<--WriteReq::wait_WriteReq 
00004447.000 |07:28:34.624 |SdlSig   |SdlReadRsp                             |searching                      |ClusterClient(1,600,30,11)       |SdlTCPConnection(1,600,14,14)    |1,600,14,14.36^*^*                       |*TraceFlagOverrode
00004447.001 |07:28:34.624 |AppInfo  |-->ClusterClient::searching_SdlReadRsp 



 ##### 07:28:34.624 || the content is decoded
00004447.002 |07:28:34.624 |AppInfo  |-->ClusterClient::decodeHttpContent 
00004447.003 |07:28:34.624 |AppInfo  |sendServeRsp to [1.600.31.2], result[15], transId[45], filename[SEP2834A2823B58.cnf.xml.sgn], clusterId[192.0.2.12(99a15a05-1cb3-4d8f-9d55-0ec097da47cc)],prevResult[0],Protocoltype [1] 
00004447.004 |07:28:34.624 |AppInfo  |<--ClusterClient::decodeHttpContent 
00004447.005 |07:28:34.624 |AppInfo  |<--ClusterClient::searching_SdlReadRsp 
00004448.000 |07:28:34.624 |SdlSig   |ServeRsp                               |wait                           |Cluster(1,600,31,2)              |ClusterClient(1,600,30,11)       |1,600,14,14.36^*^*                       |*TraceFlagOverrode
00004448.001 |07:28:34.624 |AppInfo  |-->Cluster::recvServeRsp 
00004448.002 |07:28:34.624 |AppInfo  |<--Cluster::recvServeRsp 
00004449.000 |07:28:34.624 |SdlSig   |ServeRsp                               |wait                           |ClusterMgr(1,600,28,1)           |Cluster(1,600,31,2)              |1,600,14,14.36^*^*                       |*TraceFlagOverrode
00004449.001 |07:28:34.624 |AppInfo  |-->ClusterMgr::wait_ServeRsp 
00004449.002 |07:28:34.624 |AppInfo  |   ClusterMgr::wait_ServeRsp File found for the ServeReq with TransID [45] in Cluster [99a15a05-1cb3-4d8f-9d55-0ec097da47cc]
00004449.003 |07:28:34.624 |AppInfo  |<--ClusterMgr::wait_ServeRsp 
00004450.000 |07:28:34.624 |SdlSig   |WriteReq                               |wait                           |Writer(1,600,20,1)               |WriterMgr(1,600,19,1)            |1,600,14,14.36^*^*                       |*TraceFlagOverrode
00004450.001 |07:28:34.624 |AppInfo  |-->WriteReq::wait_WriteReq 
00004450.002 |07:28:34.624 |AppInfo  |<--WriteReq::wait_WriteReq 
00004451.000 |07:28:34.624 |SdlSig   |WriteReq                               |wait                           |Writer(1,600,20,1)               |WriterMgr(1,600,19,1)            |1,600,14,14.36^*^*                       |*TraceFlagOverrode
00004451.001 |07:28:34.624 |AppInfo  |-->WriteReq::wait_WriteReq 
00004451.002 |07:28:34.624 |AppInfo  |sendServeRsp from writerThread to clusterGw, result[15], transId[45], filename[SEP2834A2823B58.cnf.xml.sgn], clusterId[99a15a05-1cb3-4d8f-9d55-0ec097da47cc], ProtocolType[1]
00004451.003 |07:28:34.624 |AppInfo  |<--WriteReq::wait_WriteReq 
00004452.000 |07:28:34.624 |SdlSig   |ServeRsp                               |wait                           |ClusterGW(1,600,29,1)            |Writer(1,600,20,1)               |1,600,14,14.36^*^*                       |*TraceFlagOverrode
00004452.001 |07:28:34.624 |AppInfo  |-->SearchRspCb 
00004452.002 |07:28:34.624 |AppInfo  |   SearchRspCb Received Serve Query response from search engine
00004452.003 |07:28:34.624 |AppInfo  |   SearchRspCb ProtocolValue = 1
00004452.004 |07:28:34.624 |AppInfo  |-->ReceivedServeRsp: Signal TransID[45] 
00004452.005 |07:28:34.624 |AppInfo  |   ReceivedServeRsp: Signal TransID[45] Dynamic Filename [/usr/local/cm/tftp/tftpcache/SEP2834A2823B58.cnf.xml.sgn.45]
00004452.006 |07:28:34.624 |AppInfo  |   ReceivedServeRsp: Signal TransID[45] File Found - 200 - Success
00004452.007 |07:28:34.624 |AppInfo  |   ReceivedServeRsp: Signal TransID[45] FileResponse Signal sent to connection object
00004452.008 |07:28:34.624 |AppInfo  |<--ReceivedServeRsp: Signal TransID[45] 
00004452.009 |07:28:34.624 |AppInfo  |<--SearchRspCb 



 ##### 07:28:34.625 || The Proxy TFTP sends the file to the phone
00004453.000 |07:28:34.625 |SdlSig   |FileResponse                           |wait                           |HTTPConnection(1,600,26,5)       |ServeFile(1,600,22,1)            |1,600,14,14.36^*^*                       |*TraceFlagOverrode
00004453.001 |07:28:34.625 |AppInfo  |-->HTTPConnection::wait_FileResponse 
00004453.002 |07:28:34.625 |AppInfo  |   HTTPConnection::wait_FileResponse Requested file FOUND... Sending file Response
00004453.003 |07:28:34.625 |AppInfo  |   HTTPConnection::wait_FileResponse Skip envelope is false or this is not a static file request, serving file [/usr/local/cm/tftp/tftpcache/SEP2834A2823B58.cnf.xml.sgn.45]
00004453.004 |07:28:34.625 |AppInfo  |<--HTTPConnection::wait_FileResponse 
00004454.000 |07:28:34.625 |SdlSig   |SdlSendfileRsp                         |wait                           |HTTPConnection(1,600,26,5)       |SdlTCPConnection(1,600,14,65)    |1,600,14,65.3^*^*                        |*TraceFlagOverrode
00004454.001 |07:28:34.625 |AppInfo  |-->HTTPConnection::wait_SdlSendfileRsp 
00004454.002 |07:28:34.625 |AppInfo  |<--HTTPConnection::wait_SdlSendfileRsp 



 ##### 07:28:35.110 || SdlCloseInd closing the connection for the CNF request SdlTCPConnection(1,600,14,65)
00004455.000 |07:28:35.110 |SdlSig   |SdlCloseInd                            |wait                           |HTTPConnection(1,600,26,5)       |SdlTCPConnection(1,600,14,65)    |1,600,14,65.4^*^*                        |*TraceFlagOverrode
00004455.001 |07:28:35.110 |AppInfo  |-->HTTPConnection::wait_SdlCloseInd 
00004455.002 |07:28:35.110 |AppInfo  |   HTTPConnection::wait_SdlCloseInd Recieved CloseInd from TcpConnectionPID-[1, 600, 14, 65]
00004455.003 |07:28:35.110 |AppInfo  |<--HTTPConnection::wait_SdlCloseInd 
00004456.000 |07:28:35.110 |SdlSig   |UpdateReqCount                         |listening                      |HTTPServer(1,600,25,1)           |HTTPConnection(1,600,26,5)       |1,600,14,65.4^*^*                        |*TraceFlagOverrode
00004456.001 |07:28:35.110 |AppInfo  |HTTPServer::listening_UpdateReqCount - Printing the PID of sender = [1, 600, 26, 5]
00004456.002 |07:28:35.110 |AppInfo  |HTTPServer::listening_throttle_UpdateReqCount - HTTPConnectionCount = 0, PersistentConnectionCount = 0



 ##### 07:28:37.124 || At this point the timer for the connection to request the CTL is hit
00004457.000 |07:28:37.124 |SdlSig   |HTTPReadTimer                          |wait                           |HTTPConnection(1,600,26,3)       |SdlTimerService(1,600,3,1)       |1,600,14,63.2^*^*                        |*TraceFlagOverrode
00004457.001 |07:28:37.124 |AppInfo  |-->HTTPConnection::wait_HTTPReadTimer 



 ##### 07:28:37.124 || The connection for the CTL request is closed due to timeout
00004457.002 |07:28:37.124 |AppInfo  |   HTTPConnection::wait_HTTPReadTimer Received a HTTPReadRequest Timeout signal... Closing connection : [1:600:14:63]
00004457.003 |07:28:37.124 |AppInfo  |   HTTPConnection::wait_HTTPReadTimer TCPConnectionPID : [1:600:14:63] not found in active connections
00004457.004 |07:28:37.124 |AppInfo  |<--HTTPConnection::wait_HTTPReadTimer 



 ##### 07:28:38.208 || SdlConnectionInd for the phone connecting to request the AppDialRules.xml file SdlTCPConnection(1,600,14,66)
00004458.000 |07:28:38.208 |SdlSig   |SdlConnectionInd                       |listening                      |HTTPServer(1,600,25,1)           |SdlTCPConnection(1,600,14,66)    |1,600,12,1.46^*^*                        |*TraceFlagOverrode
00004459.000 |07:28:38.208 |SdlStat  |Period: 6s #Lines: 395 #Bytes: 49155 Total Number of Buffers: 2000 Free LWM: 1928 Free LWM(total): 1918
00004458.001 |07:28:38.208 |AppInfo  |-->HTTPSERVER::listening_SdlConnectionInd 
00004458.002 |07:28:38.208 |AppInfo  |HTTPServer::listening_SdlConnection - Printing the sender PID = [1, 600, 14, 66]
00004458.003 |07:28:38.208 |AppInfo  |HTTPServer::handleConnection - Sending a Reassociate Request to Reassociate the newly created HTTPConnectionInfo object to the network/client
00004458.004 |07:28:38.208 |AppInfo  |HTTPServer::listening_SdlConnectionInd - Maximum serving count for HTTP connection is  = 2500
00004458.005 |07:28:38.208 |AppInfo  |HTTPServer::listening_SdlConnectionInd - HTTPConnectionCount = 1
00004458.006 |07:28:38.208 |AppInfo  |<--HTTPSERVER::listening_SdlConnectionInd 
00004460.000 |07:28:38.208 |SdlSig   |SdlReassociateRsp                      |listening                      |HTTPServer(1,600,25,1)           |SdlTCPConnection(1,600,14,66)    |1,600,12,1.46^*^*                        |*TraceFlagOverrode
00004460.001 |07:28:38.208 |AppInfo  |HTTPServer::listening_SdlReassociateRsp - Reassociation Successfull
00004460.002 |07:28:38.208 |AppInfo  |HTTPServer::listening_SdlReassociateRsp - Printing the PID of sender = [1, 600, 14, 66]
00004461.000 |07:28:38.208 |SdlSig   |SdlReassociateInd                      |wait                           |HTTPConnection(1,600,26,1)       |SdlTCPConnection(1,600,14,66)    |1,600,12,1.46^*^*                        |*TraceFlagOverrode
00004461.001 |07:28:38.208 |AppInfo  |-->HTTPConnection::wait_SdlReassociateInd 
00004461.002 |07:28:38.208 |AppInfo  |   HTTPConnection::wait_SdlReassociateInd Received ReassociateIndication from 192.0.2.11
00004461.003 |07:28:38.208 |AppInfo  |<--HTTPConnection::wait_SdlReassociateInd 
00004462.000 |07:28:38.208 |SdlSig   |SdlDataInd                             |wait                           |HTTPConnection(1,600,26,1)       |SdlTCPConnection(1,600,14,66)    |1,600,14,66.2^*^*                        |*TraceFlagOverrode
00004462.001 |07:28:38.208 |AppInfo  |-->HTTPConnection::wait_SdlDataInd 
00004462.002 |07:28:38.208 |AppInfo  |   HTTPConnection::wait_SdlDataInd SdlDataInd recived from TcpPID-[1, 600, 14, 66]



 ##### 07:28:38.208 || The phone requests the AppDialRules.xml
00004462.003 |07:28:38.208 |AppInfo  |   HTTPConnection::wait_SdlDataInd Printing the HTTPRequest : msgBuffer size [58] --: GET /AppDialRules.xml HTTP/1.1
Host:198.51.100.0:6970

0004462.004 |07:28:38.208 |AppInfo  |   HTTPConnection::wait_SdlDataInd Proxy Request- 0 , AppDialRules.xml
00004462.005 |07:28:38.208 |AppInfo  |   HTTPConnection::wait_SdlDataInd Decode successful - Filename is : AppDialRules.xml
00004462.006 |07:28:38.208 |AppInfo  |   HTTPConnection::wait_SdlDataInd File request signal sent to ServeFile process
00004462.007 |07:28:38.208 |AppInfo  |<--HTTPConnection::wait_SdlDataInd 
00004463.000 |07:28:38.208 |SdlSig   |FileRequest                            |wait                           |ServeFile(1,600,22,1)            |HTTPConnection(1,600,26,1)       |1,600,14,66.2^*^*                        |*TraceFlagOverrode
00004463.001 |07:28:38.208 |AppInfo  |-->ServeFile::wait_FileRequest 
00004463.002 |07:28:38.208 |AppInfo  |   ServeFile::wait_FileRequest Received File request for AppDialRules.xml with Request ID 46
00004463.003 |07:28:38.208 |AppInfo  |-->ServeFile::validateFileName 
00004463.004 |07:28:38.208 |AppInfo  |   ServeFile::validateFileName File Requested AppDialRules.xml
00004463.005 |07:28:38.208 |AppInfo  |<--ServeFile::validateFileName 
00004463.006 |07:28:38.208 |AppInfo  |   ServeFile::wait_FileRequest File Validation Success and the File to be Searched is AppDialRules.xml
00004463.007 |07:28:38.208 |AppInfo  |-->ServeFile::CheckFileIsStatic 
00004463.008 |07:28:38.208 |AppInfo  |   ServeFile::CheckFileIsStatic appdialrules.xml is (Not a Static) File
00004463.009 |07:28:38.208 |AppInfo  |<--ServeFile::CheckFileIsStatic 
00004463.010 |07:28:38.208 |AppInfo  |   ServeFile::wait_FileRequest Sending the FileRequest signal to ProcessServeDynamicFile process
00004463.011 |07:28:38.208 |AppInfo  |<--ServeFile::wait_FileRequest 
00004464.000 |07:28:38.208 |SdlSig   |FileRequest                            |wait                           |ServeDynamicFile(1,600,23,3)     |ServeFile(1,600,22,1)            |1,600,14,66.2^*^*                        |*TraceFlagOverrode
00004464.001 |07:28:38.208 |AppInfo  |-->ServeDynamicFile::wait_FileRequest 
00004464.002 |07:28:38.208 |AppInfo  |   ServeDynamicFile::wait_FileRequest Received File request for the dynamic file AppDialRules.xml
00004464.003 |07:28:38.208 |AppInfo  |-->ServeDynamicFile::isCTLCAPFRequest 
00004464.004 |07:28:38.208 |AppInfo  |   ServeDynamicFile::isCTLCAPFRequest [AppDialRules.xml] is Not a CTLCAPF File
00004464.005 |07:28:38.208 |AppInfo  |<--ServeDynamicFile::isCTLCAPFRequest 
00004464.006 |07:28:38.208 |AppInfo  |   ServeDynamicFile::wait_FileRequest Requested File is : [appdialrules.xml]
00004464.007 |07:28:38.208 |AppInfo  |-->ServeDynamicFile::retrieveTypeOfRequest 
00004464.008 |07:28:38.208 |AppInfo  |   ServeDynamicFile::retrieveTypeOfRequest Request is for XML Config File
00004464.009 |07:28:38.208 |AppInfo  |   ServeDynamicFile::retrieveTypeOfRequest File Requested is : [appdialrules.xml]
00004464.010 |07:28:38.208 |AppInfo  |<--ServeDynamicFile::retrieveTypeOfRequest 
00004464.011 |07:28:38.208 |AppInfo  |   ServeDynamicFile::wait_FileRequest Type of Request is : [1]
00004464.012 |07:28:38.208 |AppInfo  |-->CServiceModule::getDeviceNameFromRequest 
00004464.013 |07:28:38.208 |AppInfo  |   CServiceModule::getDeviceNameFromRequest File Request without extensions
00004464.014 |07:28:38.208 |AppInfo  |<--CServiceModule::getDeviceNameFromRequest 
00004464.015 |07:28:38.208 |AppInfo  |-->CServiceModule::getIDForRequest 
00004464.016 |07:28:38.208 |AppInfo  |   CServiceModule::getIDForRequest Unable to find device in DB = appdialrules.xml
00004464.017 |07:28:38.208 |AppInfo  |<--CServiceModule::getIDForRequest 
00004464.018 |07:28:38.208 |AppInfo  |-->ServeDynamicFile::FindAndServe 



 ##### 07:28:38.208 || appdialrules.xml is found
00004464.019 |07:28:38.208 |AppInfo  |   ServeDynamicFile::FindAndServe File Found - 200 - Success
00004464.020 |07:28:38.208 |AppInfo  |   ServeDynamicFile::FindAndServe ServeDynamicFile::wait_dynamicFileRequest [FileName:(AppDialRules.xml),Content Length:(25)]
00004464.021 |07:28:38.208 |AppInfo  |   ServeDynamicFile::FindAndServe Request ID : 46
00004464.022 |07:28:38.208 |AppInfo  |<--ServeDynamicFile::FindAndServe 
00004464.023 |07:28:38.208 |AppInfo  |<--ServeDynamicFile::wait_FileRequest 
00004465.000 |07:28:38.208 |SdlSig   |FileResponse                           |wait                           |ServeFile(1,600,22,1)            |ServeDynamicFile(1,600,23,3)     |1,600,14,66.2^*^*                        |*TraceFlagOverrode
00004465.001 |07:28:38.208 |AppInfo  |-->ServeFile::wait_FileResponse 
00004465.002 |07:28:38.208 |AppInfo  |   ServeFile::wait_FileResponse File Response signal received by ServeFile process
00004465.003 |07:28:38.208 |AppInfo  |   ServeFile::wait_FileResponse FileStatus : 1 -- OffClusters Configured : 1



 ##### 07:28:38.208 || The TFTP service makes it clear the file was found locally
00004465.004 |07:28:38.208 |AppInfo  |   ServeFile::wait_FileResponse File found in proxy tftp itself. Sending the file response to corresponding connection object
00004465.005 |07:28:38.208 |AppInfo  |<--ServeFile::wait_FileResponse 
00004466.000 |07:28:38.208 |SdlSig   |FileResponse                           |wait                           |HTTPConnection(1,600,26,1)       |ServeFile(1,600,22,1)            |1,600,14,66.2^*^*                        |*TraceFlagOverrode
00004466.001 |07:28:38.208 |AppInfo  |-->HTTPConnection::wait_FileResponse 



 ##### 07:28:38.208 || The file response is sent
00004466.002 |07:28:38.208 |AppInfo  |   HTTPConnection::wait_FileResponse Requested file FOUND... Sending file Response
00004466.003 |07:28:38.208 |AppInfo  |<--HTTPConnection::wait_FileResponse 



 ##### 07:28:38.275 || SdlCloseInd closing the connection for the phone requesting the appdialrules SdlTCPConnection(1,600,14,66)
00004467.000 |07:28:38.275 |SdlSig   |SdlCloseInd                            |wait                           |HTTPConnection(1,600,26,1)       |SdlTCPConnection(1,600,14,66)    |1,600,14,66.3^*^*                        |*TraceFlagOverrode
00004467.001 |07:28:38.275 |AppInfo  |-->HTTPConnection::wait_SdlCloseInd 
00004467.002 |07:28:38.275 |AppInfo  |   HTTPConnection::wait_SdlCloseInd Recieved CloseInd from TcpConnectionPID-[1, 600, 14, 66]
00004467.003 |07:28:38.275 |AppInfo  |<--HTTPConnection::wait_SdlCloseInd 
00004468.000 |07:28:38.275 |SdlSig   |UpdateReqCount                         |listening                      |HTTPServer(1,600,25,1)           |HTTPConnection(1,600,26,1)       |1,600,14,66.3^*^*                        |*TraceFlagOverrode
00004468.001 |07:28:38.275 |AppInfo  |HTTPServer::listening_UpdateReqCount - Printing the PID of sender = [1, 600, 26, 1]
00004468.002 |07:28:38.275 |AppInfo  |HTTPServer::listening_throttle_UpdateReqCount - HTTPConnectionCount = 0, PersistentConnectionCount = 0



 ##### 07:28:38.337 || SdlConnectionInd for the phone connecting to request the SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn SdlTCPConnection(1,600,14,67)
00004469.000 |07:28:38.337 |SdlSig   |SdlConnectionInd                       |listening                      |HTTPServer(1,600,25,1)           |SdlTCPConnection(1,600,14,67)    |1,600,12,1.47^*^*                        |*TraceFlagOverrode
00004469.001 |07:28:38.337 |AppInfo  |-->HTTPSERVER::listening_SdlConnectionInd 
00004469.002 |07:28:38.337 |AppInfo  |HTTPServer::listening_SdlConnection - Printing the sender PID = [1, 600, 14, 67]
00004469.003 |07:28:38.337 |AppInfo  |HTTPServer::handleConnection - Sending a Reassociate Request to Reassociate the newly created HTTPConnectionInfo object to the network/client
00004469.004 |07:28:38.337 |AppInfo  |HTTPServer::listening_SdlConnectionInd - Maximum serving count for HTTP connection is  = 2500
00004469.005 |07:28:38.337 |AppInfo  |HTTPServer::listening_SdlConnectionInd - HTTPConnectionCount = 1
00004469.006 |07:28:38.337 |AppInfo  |<--HTTPSERVER::listening_SdlConnectionInd 
00004470.000 |07:28:38.337 |SdlSig   |SdlReassociateRsp                      |listening                      |HTTPServer(1,600,25,1)           |SdlTCPConnection(1,600,14,67)    |1,600,12,1.47^*^*                        |*TraceFlagOverrode
00004470.001 |07:28:38.337 |AppInfo  |HTTPServer::listening_SdlReassociateRsp - Reassociation Successfull
00004470.002 |07:28:38.337 |AppInfo  |HTTPServer::listening_SdlReassociateRsp - Printing the PID of sender = [1, 600, 14, 67]
00004471.000 |07:28:38.337 |SdlSig   |SdlReassociateInd                      |wait                           |HTTPConnection(1,600,26,2)       |SdlTCPConnection(1,600,14,67)    |1,600,12,1.47^*^*                        |*TraceFlagOverrode
00004471.001 |07:28:38.337 |AppInfo  |-->HTTPConnection::wait_SdlReassociateInd 
00004471.002 |07:28:38.337 |AppInfo  |   HTTPConnection::wait_SdlReassociateInd Received ReassociateIndication from 192.0.2.11
00004471.003 |07:28:38.337 |AppInfo  |<--HTTPConnection::wait_SdlReassociateInd 
00004472.000 |07:28:38.337 |SdlSig   |SdlDataInd                             |wait                           |HTTPConnection(1,600,26,2)       |SdlTCPConnection(1,600,14,67)    |1,600,14,67.2^*^*                        |*TraceFlagOverrode
00004472.001 |07:28:38.337 |AppInfo  |-->HTTPConnection::wait_SdlDataInd 
00004472.002 |07:28:38.337 |AppInfo  |   HTTPConnection::wait_SdlDataInd SdlDataInd recived from TcpPID-[1, 600, 14, 67]



 ##### 07:28:38.337 || The phone requests SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn
00004472.003 |07:28:38.337 |AppInfo  |   HTTPConnection::wait_SdlDataInd Printing the HTTPRequest : msgBuffer size [88] --: GET /SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn HTTP/1.1
Host:198.51.100.0:6970


00004472.004 |07:28:38.337 |AppInfo  |   HTTPConnection::wait_SdlDataInd Proxy Request- 0 , SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn
00004472.005 |07:28:38.337 |AppInfo  |   HTTPConnection::wait_SdlDataInd Decode successful - Filename is : SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn
00004472.006 |07:28:38.337 |AppInfo  |   HTTPConnection::wait_SdlDataInd File request signal sent to ServeFile process
00004472.007 |07:28:38.337 |AppInfo  |<--HTTPConnection::wait_SdlDataInd 
00004473.000 |07:28:38.337 |SdlSig   |FileRequest                            |wait                           |ServeFile(1,600,22,1)            |HTTPConnection(1,600,26,2)       |1,600,14,67.2^*^*                        |*TraceFlagOverrode
00004473.001 |07:28:38.337 |AppInfo  |-->ServeFile::wait_FileRequest 
00004473.002 |07:28:38.337 |AppInfo  |   ServeFile::wait_FileRequest Received File request for SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn with Request ID 47
00004473.003 |07:28:38.337 |AppInfo  |-->ServeFile::validateFileName 
00004473.004 |07:28:38.337 |AppInfo  |   ServeFile::validateFileName File Requested SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn
00004473.005 |07:28:38.337 |AppInfo  |<--ServeFile::validateFileName 
00004473.006 |07:28:38.337 |AppInfo  |   ServeFile::wait_FileRequest File Validation Success and the File to be Searched is SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn
00004473.007 |07:28:38.337 |AppInfo  |-->ServeFile::CheckFileIsStatic 
00004473.008 |07:28:38.337 |AppInfo  |   ServeFile::CheckFileIsStatic sk72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn is (Not a Static) File
00004473.009 |07:28:38.337 |AppInfo  |<--ServeFile::CheckFileIsStatic 
00004473.010 |07:28:38.337 |AppInfo  |   ServeFile::wait_FileRequest Sending the FileRequest signal to ProcessServeDynamicFile process
00004473.011 |07:28:38.337 |AppInfo  |<--ServeFile::wait_FileRequest 
00004474.000 |07:28:38.337 |SdlSig   |FileRequest                            |wait                           |ServeDynamicFile(1,600,23,4)     |ServeFile(1,600,22,1)            |1,600,14,67.2^*^*                        |*TraceFlagOverrode
00004474.001 |07:28:38.337 |AppInfo  |-->ServeDynamicFile::wait_FileRequest 
00004474.002 |07:28:38.337 |AppInfo  |   ServeDynamicFile::wait_FileRequest Received File request for the dynamic file SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn
00004474.003 |07:28:38.337 |AppInfo  |-->ServeDynamicFile::isCTLCAPFRequest 
00004474.004 |07:28:38.337 |AppInfo  |   ServeDynamicFile::isCTLCAPFRequest [SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn] is Not a CTLCAPF File
00004474.005 |07:28:38.337 |AppInfo  |<--ServeDynamicFile::isCTLCAPFRequest 
00004474.006 |07:28:38.337 |AppInfo  |   ServeDynamicFile::wait_FileRequest Requested File is : [sk72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn]
00004474.007 |07:28:38.337 |AppInfo  |-->ServeDynamicFile::retrieveTypeOfRequest 
00004474.008 |07:28:38.337 |AppInfo  |   ServeDynamicFile::retrieveTypeOfRequest Request is for XML signed Config File
00004474.009 |07:28:38.337 |AppInfo  |   ServeDynamicFile::retrieveTypeOfRequest File Requested is : [sk72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn]
00004474.010 |07:28:38.337 |AppInfo  |<--ServeDynamicFile::retrieveTypeOfRequest 
00004474.011 |07:28:38.337 |AppInfo  |   ServeDynamicFile::wait_FileRequest Type of Request is : [2]
00004474.012 |07:28:38.337 |AppInfo  |-->CServiceModule::getDeviceNameFromRequest 
00004474.013 |07:28:38.337 |AppInfo  |   CServiceModule::getDeviceNameFromRequest File Request without extensions
00004474.014 |07:28:38.337 |AppInfo  |<--CServiceModule::getDeviceNameFromRequest 
00004474.015 |07:28:38.337 |AppInfo  |-->CServiceModule::getIDForRequest 
00004474.016 |07:28:38.337 |AppInfo  |   CServiceModule::getIDForRequest Unable to find device in DB = sk72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn
00004474.017 |07:28:38.337 |AppInfo  |<--CServiceModule::getIDForRequest 
00004474.018 |07:28:38.337 |AppInfo  |-->ServeDynamicFile::FindAndServe 



 ##### 07:28:38.337 || SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn is found
00004474.019 |07:28:38.337 |AppInfo  |   ServeDynamicFile::FindAndServe File Found - 200 - Success
00004474.020 |07:28:38.337 |AppInfo  |   ServeDynamicFile::FindAndServe ServeDynamicFile::wait_dynamicFileRequest [FileName:(SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn),Content Length:(4963)]
00004474.021 |07:28:38.337 |AppInfo  |   ServeDynamicFile::FindAndServe Request ID : 47
00004474.022 |07:28:38.337 |AppInfo  |<--ServeDynamicFile::FindAndServe 
00004474.023 |07:28:38.337 |AppInfo  |<--ServeDynamicFile::wait_FileRequest 
00004475.000 |07:28:38.337 |SdlSig   |FileResponse                           |wait                           |ServeFile(1,600,22,1)            |ServeDynamicFile(1,600,23,4)     |1,600,14,67.2^*^*                        |*TraceFlagOverrode
00004475.001 |07:28:38.337 |AppInfo  |-->ServeFile::wait_FileResponse 
00004475.002 |07:28:38.337 |AppInfo  |   ServeFile::wait_FileResponse File Response signal received by ServeFile process
00004475.003 |07:28:38.337 |AppInfo  |   ServeFile::wait_FileResponse FileStatus : 1 -- OffClusters Configured : 1



 ##### 07:28:38.337 || The TFTP service makes it clear the file was found locally
00004475.004 |07:28:38.337 |AppInfo  |   ServeFile::wait_FileResponse File found in proxy tftp itself. Sending the file response to corresponding connection object
00004475.005 |07:28:38.337 |AppInfo  |<--ServeFile::wait_FileResponse 
00004476.000 |07:28:38.337 |SdlSig   |FileResponse                           |wait                           |HTTPConnection(1,600,26,2)       |ServeFile(1,600,22,1)            |1,600,14,67.2^*^*                        |*TraceFlagOverrode
00004476.001 |07:28:38.337 |AppInfo  |-->HTTPConnection::wait_FileResponse 



 ##### 07:28:38.337 || The file response is sent
00004476.002 |07:28:38.337 |AppInfo  |   HTTPConnection::wait_FileResponse Requested file FOUND... Sending file Response
00004476.003 |07:28:38.337 |AppInfo  |<--HTTPConnection::wait_FileResponse 



 ##### 07:28:38.940 || SdlCloseInd closing the connection for the phone requesting SK72f64050-7ad5-4b47-9bfa-5e9ad9cd4aa9.xml.sgn SdlTCPConnection(1,600,14,67)
00004477.000 |07:28:38.940 |SdlSig   |SdlCloseInd                            |wait                           |HTTPConnection(1,600,26,2)       |SdlTCPConnection(1,600,14,67)    |1,600,14,67.3^*^*                        |*TraceFlagOverrode
00004477.001 |07:28:38.940 |AppInfo  |-->HTTPConnection::wait_SdlCloseInd 
00004477.002 |07:28:38.940 |AppInfo  |   HTTPConnection::wait_SdlCloseInd Recieved CloseInd from TcpConnectionPID-[1, 600, 14, 67]
00004477.003 |07:28:38.940 |AppInfo  |<--HTTPConnection::wait_SdlCloseInd
改定	発行日	コメント
2.0	18-Oct-2022	ドキュメントのアドレス指定とドメイン標準に合わせたドキュメント。
1.0	19-Jun-2019	初版
CUCMでのプロキシTFTPの設定とトラブルシューティング

偏向のない言語

翻訳について

内容

概要

前提条件

要件

使用するコンポーネント

背景説明

ネットワーク図

設定

手動プロキシTFTP設定

ダイナミックプロキシTFTPの設定

トラブルシュート

収集するデータ

分析例

シスコラボのデバイス情報

プロキシTFTPクラスタのPCAPレビュー

プロキシTFTPクラスタのTFTPログレビュー

関連情報

更新履歴

シスコエンジニア提供

このドキュメントは役に立ちましたか?

シスコに問い合わせ

このドキュメントは次の製品に対応しています

CUCMでのプロキシTFTPの設定とトラブルシューティング

偏向のない言語

翻訳について

内容

概要

前提条件

要件

使用するコンポーネント

背景説明

ネットワーク図

設定

手動プロキシTFTP設定

ダイナミックプロキシTFTPの設定

トラブルシュート

収集するデータ

分析例

シスコラボのデバイス情報

プロキシTFTPクラスタのPCAPレビュー

プロキシTFTPクラスタのTFTPログレビュー

関連情報

更新履歴

シスコ エンジニア提供

このドキュメントは役に立ちましたか?

シスコに問い合わせ

このドキュメントは次の製品に対応しています

シスコエンジニア提供
