Jan 1 13:12:03 ocur[21]: upnp: [192.168.1.122] Action(av[0]) GetTransportInfo success Jan 1 13:12:03 ocur[21]: upnp: [192.168.1.122] Calling Action(cas[0]) SetChannel Jan 1 13:12:03 ocur[21]: ocur: [0] Attempting to SetChannel (Channel=203 SourceId=0 Mode=0) Jan 1 13:12:03 ocur[21]: upnp: [192.168.1.122] Action(cas[0]) SetChannel success Jan 1 13:12:03 ocur[21]: ocur: Disabled table monitor for instance 0 Jan 1 13:12:03 ocur[21]: ocur: [0] Program number set to 0, was 0 Jan 1 13:12:03 ocur[21]: ocur: [0] Tune to 203 (mod=q256, freq=543000, program=203, std=9) Jan 1 13:12:03 ocur[21]: ocur: [0] Program number set to 203, was 0 Jan 1 13:12:03 ocur[21]: ocur: Disabled table monitor for instance 0 Jan 1 13:12:03 ocur[21]: ocur: [0] Locked: 1 Acc E: 0 Jan 1 13:12:03 ocur[21]: libcetonrtsp: object cetonmpeg0 Jan 1 13:12:04 ocur[21]: libctn91xx: Setting mpeg_eth headers for instance 0 Jan 1 13:12:04 ocur[21]: libctn91xx: rip C0A8017A lip C0A80179 rp 50000 lp 43012 Jan 1 13:12:04 ocur[21]: ocur: [0] rtp setup for client 192.168.1.122:50000 Jan 1 13:12:04 ocur[21]: ocur: [0] Tune finished to freq 543000 Jan 1 13:12:04 ocur[21]: ocur: [0] Getting pmt for program 203 Jan 1 13:12:04 ocur[21]: ocur: [0] Got pmt for program# 203 Jan 1 13:12:04 ocur[21]: ocur: [0] Adding pid 0x1ffc Jan 1 13:12:04 ocur[21]: ocur: [0] Adding pid 0x1ab0 Jan 1 13:12:04 ocur[21]: ocur: [0] Adding pid 0x1b10 Jan 1 13:12:04 ocur[21]: ocur: [0] Adding pid 0x1bb0 Jan 1 13:12:04 ocur[21]: ocur: [0] Adding pid 0x1be0 Jan 1 13:12:04 ocur[21]: upnp: [192.168.1.122] Calling Action(av[0]) Play Jan 1 13:12:04 ocur[21]: upnp: Event(tuner[0]): PCRLock, "1" Jan 1 13:12:04 ocur[21]: ocur: [0] Adding pid 0x0000 Jan 1 13:12:04 ocur[21]: ocur: [0] Adding pid 0x1be1 Jan 1 13:12:04 ocur[21]: ocur: [0] Adding pid 0x1be2 Jan 1 13:12:04 ocur[21]: ocur: [0] Adding pid 0x1be3 Jan 1 13:12:04 ocur[21]: ocur: Disabled table monitor for instance 0 Jan 1 13:12:04 ocur[21]: ocur: Enabled table monitor for instance 0 Jan 1 13:12:04 ocur[21]: ocur: [0] Channel is clear Jan 1 13:12:04 ocur[21]: ocur: [0] Sending ca_pmt to CableCARD for program number 203 index 0 Jan 1 13:12:04 ocur[21]: upnp: [192.168.1.122] Action(av[0]) Play success Jan 1 13:12:04 ocur[21]: ocur: [0] CCI 00 arrived for program# 203 Jan 1 13:36:41 ocur[21]: ocur: STT time Fri Jan 9 00:04:56 2015 UTC Jan 1 14:06:46 ocur[21]: ocur: STT time Fri Jan 9 00:34:56 2015 UTC Jan 1 14:36:53 ocur[21]: ocur: STT time Fri Jan 9 01:04:57 2015 UTC Jan 1 15:06:58 ocur[21]: ocur: STT time Fri Jan 9 01:34:58 2015 UTC Jan 1 15:29:38 ocur[21]: upnp: allocate[1] uuid:89333102-EBE5-11D8-AC9A-000008080EB2 c0a8017a Jan 1 15:29:38 ocur[21]: upnp: map[1] Jan 1 15:29:38 ocur[21]: upnp: map[0] = { alloc: 1, instance: 0, udn: uuid:89333102-EBE5-11D8-AC9A-000008080EB1, client: 192.168.1.122 } Jan 1 15:29:38 ocur[21]: upnp: map[1] = { alloc: 1, instance: 1, udn: uuid:89333102-EBE5-11D8-AC9A-000008080EB2, client: 192.168.1.122 } Jan 1 15:29:38 ocur[21]: upnp: map[2] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 } Jan 1 15:29:38 ocur[21]: upnp: map[3] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 } Jan 1 15:29:38 ocur[21]: upnp: map[4] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 } Jan 1 15:29:38 ocur[21]: upnp: map[5] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 } Jan 1 15:29:38 ocur[21]: upnp: [192.168.1.122] Calling Action(cm[1]) PrepareForConnection Jan 1 15:29:38 ocur[21]: upnp: Event(cm[1]): CurrentConnectionIDs, "0" Jan 1 15:29:38 ocur[21]: upnp: [192.168.1.122] Action(cm[1]) PrepareForConnection success Jan 1 15:29:38 ocur[21]: upnp: [192.168.1.122] Calling Action(av[1]) GetTransportInfo Jan 1 15:29:38 ocur[21]: upnp: [192.168.1.122] Action(av[1]) GetTransportInfo success Jan 1 15:29:38 ocur[21]: upnp: [192.168.1.122] Calling Action(fdc[1]) GetFDCStatus Jan 1 15:29:38 ocur[21]: upnp: [192.168.1.122] Action(fdc[1]) GetFDCStatus success Jan 1 15:29:38 ocur[21]: upnp: [192.168.1.122] Calling Action(aux[1]) GetAuxCapabilities Jan 1 15:29:38 ocur[21]: upnp: [192.168.1.122] Action(aux[1]) GetAuxCapabilities success Jan 1 15:29:38 ocur[21]: libcetonencode: ERROR: hal (nil) or get_audio_modelist (nil) was not set Jan 1 15:29:38 ocur[21]: libcetonencode: ERROR: hal (nil) or get_modelist (nil) was not set Jan 1 15:29:38 ocur[21]: upnp: [192.168.1.122] Calling Action(cas[1]) GetCardStatus Jan 1 15:29:38 ocur[21]: upnp: [192.168.1.122] Action(cas[1]) GetCardStatus success Jan 1 15:29:41 ocur[21]: upnp: ERROR: Action "GetCurrentTransportActions" was listed as required but was not implemented Jan 1 15:29:41 ocur[21]: upnp: ERROR: Action(av[1]) GetCurrentTransportActions failed: message "Unknown Error" error_code 602 Jan 1 15:29:41 ocur[21]: upnp: [192.168.1.122] Calling Action(av[1]) GetDeviceCapabilities Jan 1 15:29:41 ocur[21]: upnp: [192.168.1.122] Action(av[1]) GetDeviceCapabilities success Jan 1 15:29:41 ocur[21]: upnp: [192.168.1.122] Calling Action(av[1]) GetMediaInfo Jan 1 15:29:41 ocur[21]: upnp: [192.168.1.122] Action(av[1]) GetMediaInfo success Jan 1 15:29:41 ocur[21]: upnp: [192.168.1.122] Calling Action(av[1]) GetTransportInfo Jan 1 15:29:41 ocur[21]: upnp: [192.168.1.122] Action(av[1]) GetTransportInfo success Jan 1 15:29:41 ocur[21]: upnp: [192.168.1.122] Calling Action(av[1]) GetTransportSettings Jan 1 15:29:41 ocur[21]: upnp: [192.168.1.122] Action(av[1]) GetTransportSettings success Jan 1 15:29:41 ocur[21]: upnp: [192.168.1.122] Calling Action(cas[1]) SetChannel Jan 1 15:29:41 ocur[21]: ocur: [1] Attempting to SetChannel (Channel=220 SourceId=0 Mode=0) Jan 1 15:29:41 ocur[21]: ocur: Disabled table monitor for instance 1 Jan 1 15:29:41 ocur[21]: upnp: [192.168.1.122] Action(cas[1]) SetChannel success Jan 1 15:29:41 ocur[21]: ocur: [1] Program number set to 0, was 1 Jan 1 15:29:41 ocur[21]: ocur: [1] Tune to 220 (mod=q256, freq=663000, program=220, std=9) Jan 1 15:29:41 ocur[21]: ocur: [1] Program number set to 220, was 0 Jan 1 15:29:41 ocur[21]: ocur: Disabled table monitor for instance 1 Jan 1 15:29:41 ocur[21]: ocur: [1] Locked: 0 Acc E: 0 Jan 1 15:29:41 ocur[21]: libcetonrtsp: object cetonmpeg1 Jan 1 15:29:41 ocur[21]: libctn91xx: Setting mpeg_eth headers for instance 1 Jan 1 15:29:41 ocur[21]: libctn91xx: rip C0A8017A lip C0A80179 rp 50002 lp 43012 Jan 1 15:29:41 ocur[21]: ocur: [1] rtp setup for client 192.168.1.122:50002 Jan 1 15:29:41 ocur[21]: ocur: [1] Tune finished to freq 663000 Jan 1 15:29:41 ocur[21]: ocur: [1] Getting pmt for program 220 Jan 1 15:29:42 ocur[21]: ocur: [1] Got pmt for program# 220 Jan 1 15:29:42 ocur[21]: ocur: [1] Adding pid 0x1ffc Jan 1 15:29:42 ocur[21]: ocur: [1] Adding pid 0x1c70 Jan 1 15:29:42 ocur[21]: ocur: [1] Adding pid 0x1cf0 Jan 1 15:29:42 ocur[21]: ocur: [1] Adding pid 0x1d00 Jan 1 15:29:42 ocur[21]: upnp: Event(tuner[1]): PCRLock, "1" Jan 1 15:29:42 ocur[21]: ocur: [1] Found redistribution_control flag Jan 1 15:29:42 ocur[21]: ocur: [1] Adding pid 0x0000 Jan 1 15:29:42 ocur[21]: ocur: [1] Adding pid 0x1cf3 Jan 1 15:29:42 ocur[21]: ocur: [1] Adding pid 0x1cf1 Jan 1 15:29:42 ocur[21]: ocur: [1] Adding pid 0x1cfd Jan 1 15:29:42 ocur[21]: ocur: [1] Adding pid 0x1cf2 Jan 1 15:29:42 ocur[21]: ocur: Disabled table monitor for instance 1 Jan 1 15:29:42 ocur[21]: ocur: Enabled table monitor for instance 1 Jan 1 15:29:42 ocur[21]: ocur: [1] Channel is scrambled, expecting CCI Jan 1 15:29:42 ocur[21]: ocur: [1] Sending ca_pmt to CableCARD for program number 220 index 1 Jan 1 15:29:42 ocur[21]: ocur: [1] CCI 00 arrived for program# 220 Jan 1 15:29:43 ocur[21]: upnp: [192.168.1.122] Calling Action(av[1]) Play Jan 1 15:29:43 ocur[21]: upnp: [192.168.1.122] Action(av[1]) Play success Jan 1 15:29:43 ocur[21]: ocur: [1] Carrier lock is 1 Jan 1 15:30:11 ocur[21]: upnp: [192.168.1.122] Calling Action(av[1]) Stop Jan 1 15:30:11 ocur[21]: ocur: WARNING: [1] Disabling video Jan 1 15:30:11 ocur[21]: ocur: [1] Program number set to 0, was 220 Jan 1 15:30:11 ocur[21]: upnp: [192.168.1.122] Action(av[1]) Stop success Jan 1 15:30:11 ocur[21]: ocur: [1] Adding pid 0x1cfd Jan 1 15:30:35 ocur[21]: libcetonrtsp: ERROR: error receiving Jan 1 15:30:35 ocur[21]: libcetonrtsp: ERROR: error receiving Jan 1 15:32:46 ocur[21]: upnp: allocate[0] uuid:89333102-EBE5-11D8-AC9A-000008080EB1 c0a8017a Jan 1 15:32:46 ocur[21]: upnp: remap[0->2] uuid:89333102-EBE5-11D8-AC9A-000008080EB1 Jan 1 15:32:46 ocur[21]: upnp: map[0] = { alloc: 1, instance: 0, udn: uuid:89333102-EBE5-11D8-AC9A-000008080EB1, client: 192.168.1.122 } Jan 1 15:32:46 ocur[21]: upnp: map[1] = { alloc: 1, instance: 1, udn: uuid:89333102-EBE5-11D8-AC9A-000008080EB2, client: 192.168.1.122 } Jan 1 15:32:46 ocur[21]: upnp: map[2] = { alloc: 1, instance: 0, udn: uuid:89333102-EBE5-11D8-AC9A-000008080EB1, client: 192.168.1.122 } Jan 1 15:32:46 ocur[21]: upnp: map[3] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 } Jan 1 15:32:46 ocur[21]: upnp: map[4] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 } Jan 1 15:32:46 ocur[21]: upnp: map[5] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 } Jan 1 15:32:46 ocur[21]: upnp: [192.168.1.122] Calling Action(cm[2]) PrepareForConnection Jan 1 15:32:46 ocur[21]: upnp: Event(cm[2]): CurrentConnectionIDs, "0" Jan 1 15:32:46 ocur[21]: upnp: [192.168.1.122] Action(cm[2]) PrepareForConnection success Jan 1 15:32:46 ocur[21]: upnp: [192.168.1.122] Calling Action(av[0]) GetTransportInfo Jan 1 15:32:46 ocur[21]: upnp: [192.168.1.122] Action(av[0]) GetTransportInfo success Jan 1 15:32:46 ocur[21]: upnp: [192.168.1.122] Calling Action(cm[0]) ConnectionComplete Jan 1 15:32:46 ocur[21]: ocur: [0] rtp teardown for client 192.168.1.122:50000 Jan 1 15:32:46 ocur[21]: upnp: deallocate[0<-0] c0a8017a