简单点说,这个是区域频点的问题所致。
排除方法:
1. 到“自助服务”的系统设置中,点击96956,进入设置,检查portal地址和区域码,重要的是检查VOD部署参数中的“频点频率”是否和中心的ERM中的频点频率是否一致;如下图:
-1表示未开启,这里正常的是706000000
2.检查地市的IEPGM中的区域频点是否和ERM中的区域频点是否一致,如不一致,VOD部署参数中的频点频率不会显示706000000,那么请修改成,如下
3.修改完之后,查看IEPG日志:
4.以下为正常的SM会话日志,用户为
测试平台正常的MAP日志(剩下问题找VS)
02/27/14 16:15:09,770 INFO SID[285544368599760921]-inited:0x9811cb8,10.135.252.17:45550
02/27/14 16:15:09,770 DEBUG SID[285544368599760921]-current state: 2 and will set state: 0
02/27/14 16:15:09,771 INFO SID[285544368599760921]-Received:
SETUP rtsp://172.16.244.239:554/;purchaseToken=DA8AC40E3EB22D9EA951006EDDE3D2AD;serverId=172.16.244.246:8080; RTSP/1.0
CSeq: 1
Require: com.comcast.ngod.s1
Transport: MP2T/DVBC/QAM;unicast;client=8000302100210197;qam_name=11
ClientSessionId: 800030210021019700039500
02/27/14 16:15:09,772 INFO start to connect AAA 172.16.244.246:8080
02/27/14 16:15:09,772 INFO succ to connect AAA 172.16.244.246:8080
02/27/14 16:15:09,772 INFO SID[285544368599760921]-S2 Proxy Sent:
<?xml version="1.0" encoding="UTF-8"?>
<RequestPlaylist SMName="COSHIP_SM" sessionID="6c0f0c1bc09a4226a268bef3906f3168" deviceID="8000302100210197" usage="Start" PT="DA8AC40E3EB22D9EA951006EDDE3D2AD"/>
02/27/14 16:15:09,781 INFO SID[285544368599760921]-S2 Proxy receive, http status code: 200:
<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<PhysicalPlaylist startNPT="0" startIndex="1" bitRate="0" playlistID="150543">
<ContentRef end_npt="591.0" start_npt="0.0" assetID="ABCD4013101219094321" providerID="gd"/>
<playType>1</playType>
</PhysicalPlaylist>
02/27/14 16:15:09,792 INFO SID[285544368599760921]-start to connect 172.16.244.197:556
02/27/14 16:15:09,793 INFO SID[285544368599760921]-succ to connect 172.16.244.197:556
02/27/14 16:15:09,794 INFO SID[285544368599760921]-ngod.S6 Proxy Sent:
SETUP rtsp://172.16.244.197:556 RTSP/1.0
Require: sdp.s6
SessionGroup: group1
Transport: MP2T/DVBC/QAM;unicast;client=00AF123456DE;bandwidth=0;qam_name=11;modulation=QAM64
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
CSeq: 1
02/27/14 16:15:09,839 INFO SID[285544368599760921]-Proxy Received:
RTSP/1.0 200 OK
CSeq: 1
Session: 1128624144406044
Transport: MP2T/DVBC/UDP;unicast;destination=172.16.244.124;client_port=11010;edge_input_group=11;client=00AF123456DE,MP2T/DVBC/QAM;unicast;destination=706000000.7;qam_name=BeiJing.HaiDian.11;qam_group=null;channel_width=8000000;modulation=qam64;annex=A;symbolRate=6875;client=00AF123456DE
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
02/27/14 16:15:09,839 INFO succ to get sopgroup: EVMSOP_GP0 by landmark: 11
02/27/14 16:15:09,839 INFO SID[285544368599760921]-get QAM resource, freq usage id:1, start_freq:706000000, prog_no:7, ip:172.16.244.124, port:11010, STB landmark:11, qam landmark:0, vss landmark:EVMSOP_GP0
02/27/14 16:15:09,839 DEBUG SID[285544368599760921]-demand: 2 seq: 1, landmark: 11, filename:
02/27/14 16:15:09,840 DEBUG SID[285544368599760921]-select[3] vsid: 1, servername: ServerRtspNGOD
02/27/14 16:15:09,840 DEBUG SID[285544368599760921]-path_id: -1, volume: library
02/27/14 16:15:09,840 INFO SID[285544368599760921]-schedule to[ServerRtspNGOD/seachange][phyID,pid]1,0[IP:PORT][172.16.244.212:554], proxy: 0xe8504b98
02/27/14 16:15:09,840 INFO SID[285544368599760921]-start to connect 172.16.244.212:554
02/27/14 16:15:09,840 DEBUG SID[285544368599760921]-to update sessioninfo where sessionStatus =0
02/27/14 16:15:09,840 INFO SID[285544368599760921]-succ to connect 172.16.244.212:554
02/27/14 16:15:09,841 INFO SID[285544368599760921]-ngod.R2 Proxy Sent:
SETUP rtsp://172.16.244.212:554 RTSP/1.0
Require: com.comcast.ngod.r2,com.comcast.ngod.r2.decimal_npts
StreamControlProto: rtsp
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
Volume: library
Transport: MP2T/DVBC/UDP;unicast;client=8000302100210197;bandwidth=0;destination=172.16.244.124;client_port=11010;sop_name=EVMSOP
SessionGroup: SM1
StartPoint: 1 0
Content-Type: application/sdp
Content-Length: 176
CSeq: 2
v=0
o=-6c0f0c1bc09a4226a268bef3906f3168 3602564109 IN IP4 172.16.244.239
s=
t=0 0
a=X-playlist-item: gd ABCD4013101219094321 0-90498
c=IN IP4 0.0.0.0
m=video 0 udp MP2T
02/27/14 16:15:09,842 INFO SID[285544368599760921]-Proxy Received:
RTSP/1.0 200 OK
CSeq: 2
Session: 956396680
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
Transport: MP2T/DVBC/QAM;unicast;client=8000302100210197;bandwidth=;destination=172.16.244.124;client_port=11010;source=172.16.244.212;server_port=48156;sop_name=EVMSOP;sop_group=EVMSOP_GP1
Content-type: application/sdp
Content-Length: 152
v=0
o=- 956396680 IN IP4 172.16.244.212
s=
t=0 0
a=control:rtsp://172.16.244.212:554/956396680
c=IN IP4 172.16.244.124
m=video 11010 udp MP2T
02/27/14 16:15:09,842 DEBUG before request sop resource availableBW: 1024000000, sessions: 0, sopname: EVMSOP
02/27/14 16:15:09,842 DEBUG after request sop resource reference: 1, sopname: EVMSOP, sessions: 1,availableBW: 1024000000
02/27/14 16:15:09,842 INFO SID[285544368599760921] is Added
02/27/14 16:15:09,842 INFO SID[285544368599760921]-Sent:
RTSP/1.0 200 OK
CSeq: 1
Session: 285544368599760921;timeout=60
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
ClientSessionId: 800030210021019700039500
Transport: MP2T/DVBC/QAM;unicast;destination=706000000.7
Content-Type: application/sdp
Content-Length: 154
v=0
o=- 956396680 IN IP4 172.16.244.212
s=
t=0 0
a=control:rtsp://172.16.244.212:554/956396680
c=IN IP4 172.16.244.124
m=video 11010 udp MP2T
02/27/14 16:15:09,842 INFO SID[285544368599760921]-responsed:2 reqID:1
02/27/14 16:15:09,843 INFO start to connect AAA 172.16.244.246:8080
02/27/14 16:15:09,843 INFO succ to connect AAA 172.16.244.246:8080
02/27/14 16:15:09,843 INFO SID[285544368599760921]-S2 Proxy Sent:
<?xml version="1.0" encoding="UTF-8"?>
<SessionStart SMName="COSHIP_SM" sessionID="6c0f0c1bc09a4226a268bef3906f3168" deviceID="8000302100210197" playlistID="150543" startDateTime="2014-02-27T08:15:09Z"/>
02/27/14 16:15:09,850 INFO SID[285544368599760921]-S2 Proxy receive, http status code: 200
02/27/14 16:15:09,899 INFO SID[285544368599760921]-Received:
PING rtsp://172.16.244.239:554 RTSP/1.0
CSeq: 2
Require: com.comcast.ngod.s1
Session: 285544368599760921
OnDemandSessionId:6c0f0c1bc09a4226a268bef3906f3168
ClientSessionId:800030210021019700039500
02/27/14 16:15:09,899 INFO SID[285544368599760921]-Sent:
RTSP/1.0 200 OK
CSeq: 2
Session: 285544368599760921
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
02/27/14 16:15:10,758 INFO SID[285544368599760921]-Received:
TEARDOWN rtsp://172.16.244.239:554 RTSP/1.0
CSeq: 3
Require: com.comcast.ngod.s1
Reason: 200 "user pressed stop"
Session: 285544368599760921
OnDemandSessionId:6c0f0c1bc09a4226a268bef3906f3168
ClientSessionId:800030210021019700039500
02/27/14 16:15:10,758 DEBUG SID[285544368599760921]-demand: 5 seq: 3, landmark: 11, filename:
02/27/14 16:15:10,758 INFO SID[285544368599760921]-ngod.R2 Proxy Sent:
TEARDOWN rtsp://172.16.244.212:554 RTSP/1.0
Reason: 200 "user pressed stop"
Require: com.comcast.ngod.r2,com.comcast.ngod.r2.decimal_npts
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
Session: 956396680
CSeq: 3
02/27/14 16:15:10,840 INFO SID[285544368599760921]-Proxy Received:
RTSP/1.0 200 OK
CSeq: 3
Session: 956396680
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
StopPoint: 1 0.000
FinalNPT: 0.000
Content-Type: text/xml
Content-Length: 338
<ResponseData>
<ODRMSessionHistory>
<ODRMSession
componentName="SGP1_1"
ODSessionID="6c0f0c1bc09a4226a268bef3906f3168"
setupDate="2014-02-27T16:16:37Z"
teardownDate="2014-02-27T16:16:38Z"
sessionGroup="SGP1_1"
ODRMIpAddr="172.16.244.212"
SMIpAddr="172.16.244.212"
resultCode="200">
</ODRMSession>
</ODRMSessionHistory>
</ResponseData>
02/27/14 16:15:10,840 INFO SID[285544368599760921] is removed from server
02/27/14 16:15:10,840 INFO SID[285544368599760921]-ngod.S6 Proxy Sent:
TEARDOWN rtsp://172.16.244.197:556 RTSP/1.0
Require: sdp.s6
Session: 1128624144406044
Reason: 200 "user pressed stop"
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
CSeq: 2
02/27/14 16:15:10,851 INFO SID[285544368599760921]-Proxy Received:
RTSP/1.0 200 OK
CSeq: 2
Session: 1128624144406044
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
02/27/14 16:15:10,851 INFO SID[285544368599760921]-Sent:
RTSP/1.0 200 OK
CSeq: 3
Session: 285544368599760921
OnDemandSessionId: 6c0f0c1bc09a4226a268bef3906f3168
ClientSessionId: 800030210021019700039500
02/27/14 16:15:10,851 INFO SID[285544368599760921]-responsed:5 reqID:3
02/27/14 16:15:10,851 INFO SID[285544368599760921]-teardown response:1
02/27/14 16:15:10,851 DEBUG SID[285544368599760921]-current state: 0 and will set state: 1
02/27/14 16:15:10,852 INFO start to connect AAA 172.16.244.246:8080
02/27/14 16:15:10,852 INFO succ to connect AAA 172.16.244.246:8080
02/27/14 16:15:10,852 INFO SID[285544368599760921]-S2 Proxy Sent:
<?xml version="1.0" encoding="UTF-8"?>
<SessionStop SMName="COSHIP_SM" sessionID="6c0f0c1bc09a4226a268bef3906f3168" deviceID="8000302100210197" playlistID="150543" stopNPT="0" stopAssetIndex="1" stopDateTime="2014-02-27T08:15:10Z"/>
02/27/14 16:15:10,860 INFO SID[285544368599760921]-S2 Proxy receive, http status code: 200
02/27/14 16:15:10,972 INFO SID[285544368599760921]-force to teardown the cur session
02/27/14 16:15:10,972 INFO SID[285544368599760921]-force to teardown the cur session
02/27/14 16:15:10,972 INFO SID[285544368599760921]-free m_proxyNGODS6 in FreeProxyObject
还有一个需要注意的,注意UDP端口与IPQAM是否一致,如果不一致也有可能出现“S1-10921” 的错误