Jan 1 00:00:01 syslogd started: BusyBox v1.17.2 Jan 1 00:00:01 ocur[21]: libctn91xx: compiled on 2012-04-09 13:32:18.274405 Jan 1 00:00:01 ocur[21]: libctn91xx: git id 4fafbf00037e27d8c6e1fe1fe67c7a64bc03dd34 Jan 1 00:00:01 ocur[21]: libctn91xx: Opening device /dev/ceton/ctn91xx_ctl0 Jan 1 00:00:01 ocur[21]: libctn91xx: system clock freq 100000000, ticks per us 100 Jan 1 00:00:01 ocur[21]: libctn91xx: Chip Info: CTN-9120 v6210 on board 16 Jan 1 00:00:01 ocur[21]: ocur: detected pci Jan 1 00:00:01 ocur[21]: ocur: inited slot number callback Jan 1 00:00:01 ocur[21]: ocur: Set Mac Address: ctn0 00:22:2c:80:4f:2f Jan 1 00:00:01 ocur[21]: libctn91xx: WARNING: slave busy read_addr: 00.54 write_addr: 00.00 Jan 1 00:00:01 ocur[21]: MxL241SF: compiled on 2012-03-15 16:31:21.697140 Jan 1 00:00:01 ocur[21]: MxL241SF: git id 1b2388aa47737de5f3a2b522b0b9df81e7c3bc68 Jan 1 00:00:01 ocur[21]: libcetontune: MxL241SF demod instance 0 i2c 0000.00c4 Jan 1 00:00:01 ocur[21]: libcetontune: MxL241SF demod instance 1 i2c 0000.00c2 Jan 1 00:00:01 ocur[21]: libcetontune: MxL241SF demod instance 2 i2c 0000.00c6 Jan 1 00:00:01 ocur[21]: libcetontune: MxL241SF demod instance 3 i2c 0000.00c8 Jan 1 00:00:01 ocur[21]: libctn91xx: WARNING: slave busy read_addr: 00.ffff write_addr: 00.ce Jan 1 00:00:01 ocur[21]: libctn91xx: WARNING: slave busy read_addr: 00.ffff write_addr: 00.ce Jan 1 00:00:01 ocur[21]: libctn91xx: WARNING: slave busy read_addr: 00.ffff write_addr: 00.ce Jan 1 00:00:01 ocur[21]: libcetontune: WARNING: Could not find MxL241SF for instance 4 (00.CE) Jan 1 00:00:01 ocur[21]: libctn91xx: WARNING: slave busy read_addr: 00.ffff write_addr: 00.ca Jan 1 00:00:01 ocur[21]: libctn91xx: WARNING: slave busy read_addr: 00.ffff write_addr: 00.ca Jan 1 00:00:01 ocur[21]: libctn91xx: WARNING: slave busy read_addr: 00.ffff write_addr: 00.ca Jan 1 00:00:01 ocur[21]: libcetontune: WARNING: Could not find MxL241SF for instance 5 (00.CA) Jan 1 00:00:01 ocur[21]: ocur: WARNING: Could not open tuner calibration file Jan 1 00:00:01 ocur[21]: ocur: Proceeding with 4 active instances Jan 1 00:00:01 ocur[21]: ocur: Firmware Version: (1.1.8.2) Jan 1 00:00:01 ocur[21]: ocur: detected pci Jan 1 00:00:01 ocur[21]: ocur: Mac Address: 00:22:2c:80:4f:2f Jan 1 00:00:01 ocur[21]: libctn91xx: SYSTEM_CONTROL_CODE_IDENTIFIER_OFFSET 0x2 Jan 1 00:00:01 ocur[21]: libctn91xx: SYSTEM_CONTROL_TIMEOUT_INDICATOR_OFFSET 0 Jan 1 00:00:01 ocur[21]: libctn91xx: SYSTEM_CONTROL_WATCHDOG_TIMEOUT_OFFSET 0x3938700 Jan 1 00:00:01 ocur[21]: ocur: Firmware image ceton_infinitv_fw_20120412_1_1_8_2.IMAGE Jan 1 00:00:01 ocur[21]: ocur: Firmware upgrade state "done" Jan 1 00:00:01 ocur[21]: ocur: Watchdog was not set, normal boot Jan 1 00:00:01 ocur[21]: ocur: Sucessfully booted firmware slot "two" Jan 1 00:00:01 ocur[21]: ocur: Resetting upgrade state from done to done Jan 1 00:00:01 ocur[21]: ocur: Writing firmware state: done Jan 1 00:00:01 ocur[21]: ocur: default 1 dhcp 0 static 0 ip 192.168.200.1 Jan 1 00:00:01 ocur[21]: ocur: ifconfig ctn0 192.168.200.1 Jan 1 00:00:02 ocur[21]: mpeg: compiled on 2012-04-12 10:57:45.273164 Jan 1 00:00:02 ocur[21]: mpeg: git id 0892ac4bf955100a4bd0559fa3966a0f8773b909 Jan 1 00:00:02 ocur[21]: ocur: Card routing 0 -> 1 on 0 Jan 1 00:00:02 ocur[21]: ocur: Card routing 0 -> 1 on 1 Jan 1 00:00:02 ocur[21]: ocur: Card routing 0 -> 1 on 2 Jan 1 00:00:02 ocur[21]: ocur: Card routing 0 -> 1 on 3 Jan 1 00:00:02 ocur[21]: cyrano: [zdtv/logger:WARN] all systems go Jan 1 00:00:02 ocur[21]: cyrano: [zdtv/alarm:WARN] initialization completed Jan 1 00:00:02 ocur[21]: cyrano: Unable to open /ceton/ro/cablecard/host_CET_prod.ccc Jan 1 00:00:02 ocur[21]: cyrano: Got generalized host file Jan 1 00:00:02 ocur[21]: cyrano: Unable to open /ceton/ro/cablecard/mfg_CET_prod.ccc Jan 1 00:00:02 ocur[21]: cyrano: Got generalized mfg file Jan 1 00:00:02 ocur[21]: cyrano: [zccard/ccli:WARN] task started: 578F6D80 Jan 1 00:00:02 ocur[21]: cyrano: [zccard/s:INFO] initialization completed Jan 1 00:00:02 ocur[21]: cyrano: [zccard/t:INFO] initialization completed Jan 1 00:00:02 ocur[21]: cyrano: [zccard/a:INFO] retrieve auth state Jan 1 00:00:02 ocur[21]: cyrano: [zccard/a:INFO] initialization completed Jan 1 00:00:02 ocur[21]: cyrano: [zccard/oobsi:WARN] task started: 598F6D80 Jan 1 00:00:02 ocur[21]: cyrano: [zatsc:WARN]all systems go Jan 1 00:00:02 ocur[21]: ocur: Loaded 483 channels in channel map from flash Jan 1 00:00:02 ocur[21]: upnp: Initializing UPnP Sdk with ipaddress = "192.168.200.1" port = 80 Jan 1 00:00:03 ocur[21]: upnp: WARNING: Removing instance 4 from announcement (pos 4). Jan 1 00:00:03 ocur[21]: upnp: WARNING: Removing instance 5 from announcement (pos 4). Jan 1 00:00:03 ocur[21]: upnp: WARNING: Removing instance 8 from announcement (pos 6). Jan 1 00:00:03 ocur[21]: upnp: UDN: uuid:89333102-EBE5-11D8-AC9A-00000804F2F1 Jan 1 00:00:03 ocur[21]: upnp: UDN: uuid:89333102-EBE5-11D8-AC9A-00000804F2F2 Jan 1 00:00:03 ocur[21]: upnp: UDN: uuid:89333102-EBE5-11D8-AC9A-00000804F2F3 Jan 1 00:00:03 ocur[21]: upnp: UDN: uuid:89333102-EBE5-11D8-AC9A-00000804F2F4 Jan 1 00:00:03 ocur[21]: upnp: UDN: uuid:89333102-EBE5-11D8-AC9A-00000804F2F5 Jan 1 00:00:03 ocur[21]: upnp: UDN: uuid:89333102-EBE5-11D8-AC9A-00000804F2F6 Jan 1 00:00:03 ocur[21]: upnp: OCTA UDN: uuid:89333102-EBE5-11D8-AC9A-00000804F2F7 Jan 1 00:00:03 ocur[21]: upnp: OCTA UDN: uuid:89333102-EBE5-11D8-AC9A-00000804F2F8 Jan 1 00:00:03 ocur[21]: upnp: OCTA UDN: uuid:89333102-EBE5-11D8-AC9A-00000804F2F9 Jan 1 00:00:03 ocur[21]: upnp: Container UDN: uuid:89333102-EBE5-11D8-AC9A-00000804F2F0 Jan 1 00:00:03 heartbeat[25]: libcetonnet: watching pid 21 Jan 1 00:00:03 ocur[21]: upnp: RootDevice Registered device_handle: 1 Jan 1 00:00:03 ocur[21]: upnp: UPnP Initialized ipaddress = "192.168.200.1" port = 80 Jan 1 00:00:03 ocur[21]: upnp: Specifying the webserver root directory -- ./web Jan 1 00:00:04 ocur[21]: upnp: Advertisements Sent for device urn:schemas-upnp-org:device:MediaServer:1 Jan 1 00:00:04 ocur[21]: ocur: Done Booting. Took 00004.180000 seconds. Took 00002.490000 in server. Jan 1 00:00:04 ocur[21]: ocur: STT time Sun Jan 6 00:00:12 1980 UTC Jan 1 00:00:04 ocur[21]: upnp: Sending rapid advertise Jan 1 00:00:05 ocur[21]: libctn91xx: got card inserted interrupt Jan 1 00:00:05 ocur[21]: libctn91xx: origin: 0, card_type: 41 Jan 1 00:00:05 ocur[21]: ocur: Insert -------------------------------------- Jan 1 00:00:05 ocur[21]: upnp: Event(cas[0]): CardStatus, "Inserted" Jan 1 00:00:05 ocur[21]: ocur: Flow for pid 0x1ffc refs 1 result 1 Jan 1 00:00:05 ocur[21]: upnp: Event(cas[1]): CardStatus, "Inserted" Jan 1 00:00:05 ocur[21]: cyrano: [zccard/ccli:INFO] mcard inserted Jan 1 00:00:05 ocur[21]: ocur: Flow for pid 0x1ffc refs 2 result 1 Jan 1 00:00:05 ocur[21]: upnp: Event(cas[2]): CardStatus, "Inserted" Jan 1 00:00:05 ocur[21]: ocur: Flow for pid 0x1ffc refs 3 result 1 Jan 1 00:00:05 ocur[21]: cyrano: [zccard/ccli:INFO] Clearing Queue Jan 1 00:00:05 ocur[21]: ocur: Card reset Jan 1 00:00:05 ocur[21]: cyrano: pcmcia Reset Jan 1 00:00:05 ocur[21]: upnp: Event(cas[3]): CardStatus, "Inserted" Jan 1 00:00:05 ocur[21]: ocur: Flow for pid 0x1ffc refs 4 result 1 Jan 1 00:00:05 ocur[21]: ocur: SetCardMessage = (null) Jan 1 00:00:05 ocur[21]: upnp: Event(cas[0]): CardMessage, "" Jan 1 00:00:05 ocur[21]: cyrano: [zccard/s:INFO] Session card mode 2, was 2 Jan 1 00:00:05 ocur[21]: upnp: Event(cas[1]): CardMessage, "" Jan 1 00:00:05 ocur[21]: upnp: Event(cas[2]): CardMessage, "" Jan 1 00:00:05 ocur[21]: upnp: Event(cas[3]): CardMessage, "" Jan 1 00:00:05 ocur[21]: ocur: Card reset done Jan 1 00:00:05 ocur[21]: ocur: SetCardMessage = (null) Jan 1 00:00:05 ocur[21]: upnp: Event(cas[0]): CardMessage, "" Jan 1 00:00:05 ocur[21]: upnp: Event(cas[1]): CardMessage, "" Jan 1 00:00:05 ocur[21]: upnp: Event(cas[2]): CardMessage, "" Jan 1 00:00:05 ocur[21]: upnp: Event(cas[3]): CardMessage, "" Jan 1 00:00:06 ocur[21]: ocur: WMDRM is "Ready" Jan 1 00:00:06 ocur[21]: libcetontune: MxL241SF initialized Jan 1 00:00:06 ocur[21]: libcetontune: MxL241SF initialized Jan 1 00:00:06 ocur[21]: libcetontune: MxL241SF initialized Jan 1 00:00:06 ocur[21]: libcetontune: MxL241SF initialized Jan 1 00:00:06 ocur[21]: libcetontune: Found demod with OOB capabilities Jan 1 00:00:08 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 00010041 Jan 1 00:00:08 ocur[21]: cyrano: [zccard/s:INFO] Opened Resource Manager(1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> {profile_inq} Jan 1 00:00:08 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0001 Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] <- {profile_reply} Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] <- {/profile_reply} Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> {profile_changed} Jan 1 00:00:08 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0001 Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] <- {profile_inq} Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> {profile_reply} Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Resource Manager(1,1,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Application Info(2,2,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Conditional Access Support(3,2,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Host Control(32,2,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> System Time(36,1,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> MMI(64,2,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Homing(17,1,2) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Copy Protection(176,4,3) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Copy Protection(176,4,4) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Generic Feature Control(42,1,4) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Headend Communication(44,1,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Extended Channel Support(160,1,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Generic Diagnostic Support(260,2,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> System Control(43,2,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> Card Resource(38,3,1) Jan 1 00:00:08 ocur[21]: cyrano: [zccard/a:INFO] -> {/profile_reply} Jan 1 00:00:08 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 00a00041 Jan 1 00:00:08 ocur[21]: cyrano: [zccard/s:INFO] Opened Extended Channel Support(8) Jan 1 00:00:08 ocur[21]: ocur: available 1 flow_id 00000000 pid 0000 Jan 1 00:00:08 ocur[21]: ocur: Flows can be created Jan 1 00:00:08 ocur[21]: ocur: Activating fdc pid 0x1ffc Jan 1 00:00:08 ocur[21]: cyrano: [zccard/oobsi:INFO] OOB MPEG FLOW enabled Jan 1 00:00:09 ocur[21]: cyrano: [zccard/oobsi:INFO] Running oobsi filter nit, handle 80000001 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/card:INFO] zapi/ccard/trunk/src/card/zccard_card_cchi.c:982 Unable to create flow (pending one exists) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/oobsi:INFO] Running oobsi filter svct, handle 80000002 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/card:INFO] zapi/ccard/trunk/src/card/zccard_card_cchi.c:982 Unable to create flow (pending one exists) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/oobsi:INFO] Running oobsi filter stt, handle 80000003 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/card:INFO] zapi/ccard/trunk/src/card/zccard_card_cchi.c:982 Unable to create flow (pending one exists) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/oobsi:INFO] Running oobsi filter ntt, handle 80000004 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/card:INFO] zapi/ccard/trunk/src/card/zccard_card_cchi.c:982 Unable to create flow (pending one exists) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/oobsi:INFO] Running oobsi filter cea, handle 80000005 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/card:INFO] zapi/ccard/trunk/src/card/zccard_card_cchi.c:982 Unable to create flow (pending one exists) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {new_flow_req} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> service_type = MPEG section Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 00200081 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened Host Control(7) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 00030081 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened Conditional Access Support(5) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> pid = 0x1ffc Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 002a0044 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened Generic Feature Control(11) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {/new_flow_req} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 002c0041 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened Headend Communication(18) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 00020081 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened Application Info(3) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 00400081 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened MMI(2) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 00240041 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened System Time(14) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 01040081 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened Generic Diagnostic Support(13) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {ca_info_inq} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 002600c1 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened Card Resource(16) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 002b0081 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened System Control(15) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - open_session_request(): 00b00103 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] Opened Copy Protection(6) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {ai_req} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> DisplayRows = 40 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> DisplayColumns = 80 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> Vertical_scrolling = 0 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> Horizonal_scrolling = 0 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> Display_type_support = 0 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> Data_entry_support = 0 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> HTML_support = 0 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> Link_support = 38 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> Form_support = 0 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> Table_support = 0 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> List_support = 0 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> Image_support = 8 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {/ai_req} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0003 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {cp_valid_req} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] <- {oob_rx_tune_req} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] <- frequency_value = 75250Hz (0x1f9) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] <- data rate = 2048 kbps (Mode A) Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] <- spectrum = non-inverted Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] <- {/oob_rx_tune_req} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0005 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0009 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000a Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000b Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000c Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0004 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0007 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000d Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0002 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000d Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {oob_rx_tune_cnf} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> status = Tuning granted Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {/oob_rx_tune_cnf} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] <- {feature_list_req} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {feature_list} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> number_of_features = 7 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id = [0]RF Output Channel Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id = [1]Time Zone Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id = [2]Daylight Savings Control Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id = [3]Rating Region Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id = [4]Language Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id = [5]EA Location Code Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id = [6]Unknown Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {/feature_list} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] <- {system_time_inq} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> {system_time} Jan 1 00:00:09 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0005 Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> system_time = 00000009 "Sun Jan 6 00:00:17 1980 UTC" Jan 1 00:00:09 ocur[21]: cyrano: [zccard/a:INFO] -> GPS_UTC_offset = 00 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/system_time} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {diagnostic_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- diagnostic = MAC address:0x00 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/diagnostic_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {diagnostic_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> diagnostic = MAC address:0x00, diagnostic granted Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {mac_address} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {mac_address_desc} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> type = host Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> address = 00222C804F2F Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/mac_address_desc} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/mac_address} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/diagnostic_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {cr_stream_profile} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- max_number_of_streams = 6 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/cr_stream_profile} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {cr_stream_profile_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> number_of_streams_used = 4 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/cr_stream_profile_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000b Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {host_info_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- supported_download_type = 0 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/host_info_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {host_info_response} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> vendor_id = 0x507 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> hardware_version_id = 0x1 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/host_info_response} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {ca_info} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- ca_system_ids = {0x4749} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/ca_info} Jan 1 00:00:10 ocur[21]: cyrano: WARNING: No callback for dri event 00400000 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {ai_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- pod_manufacturer_id = Motorola(0x0) Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- pod_version_number = 1573 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- type = Conditional Access Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- version_number = 1 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- name = Conditional Access Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- url = CableCARD///ca/ca Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- type = Diagnostic Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- version_number = 1 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- name = CableCARD(tm) Status Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- url = CableCARD///ps/ps Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- type = Network Interface - SCTE 55-1 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- version_number = 1 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- name = Network Setup Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- url = CableCARD///ns/ns Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- type = CableCard Pairing information (HOST_ID,POD_ID) Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- version_number = 1 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- name = CableCARD(tm) Pairing Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- url = CableCARD///cp/auth Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- type = Unknown Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- version_number = 1 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- name = DSG Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- url = CableCARD///dsg/dsg Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- type = IP Service Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- version_number = 1 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- name = Interactive Info Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- url = CableCARD///ip/ip Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- type = Unknown Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- version_number = 1 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- name = CANH Status Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- url = CableCARD///canh/canh0 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/application} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/ai_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {cp_valid_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- status = Card is busy with binding authentication process Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/cp_valid_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:WARN] zapi/ccard/trunk/src/cchi/application/zccard_cchi_extendedchannel.c:334 zccard_cchi_recv_ec_new_flow_cnf 0 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {new_flow_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- status = Request Granted Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- flows_remaining = 5 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- flow_id = 0x2 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- serviceType = MPEG section Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/new_flow_cnf} Jan 1 00:00:10 ocur[21]: ocur: WARNING: Stubbed callback Jan 1 00:00:10 ocur[21]: cyrano: [zccard/card:ERROR] zapi/ccard/trunk/src/card/zccard_card_cchi.c:819 Found 6 filters for pid 0x1ffc Jan 1 00:00:10 ocur[21]: ocur: available 1 flow_id 0x000002 pid 0x1ffc Jan 1 00:00:10 ocur[21]: ocur: Pid 0x1ffc Flow 0x000002 is now available Jan 1 00:00:10 ocur[21]: cyrano: [zccard/card:INFO] zapi/ccard/trunk/src/card/zccard_card.c:230 No pending flows. Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {cp_open_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {cp_open_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> CP_system_id_bitmask = 0x2 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/cp_open_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000d Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {feature_list_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {feature_list_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {cr_program_profile} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- max_number_of_programs = 6 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/cr_program_profile} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {cr_program_profile_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {cp_data_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {auth_key_verification_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/auth_key_verification_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/cp_data_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {cp_data_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {auth_key_verification_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> AuthKey = 38E92624EFE4C88E1A6FB0CDD013750BFADED9B5 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/auth_key_verification_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/cp_data_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0005 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {feature_list} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- number_of_features = 7 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- feature_id = [0]RF Output Channel Jan 1 00:00:10 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000b Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- feature_id = [1]Time Zone Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- feature_id = [2]Daylight Savings Control Jan 1 00:00:10 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000d Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- feature_id = [3]Reset PIN Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- feature_id = [4]VCT ID Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- feature_id = [5]Turn on channel Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- feature_id = [6]Terminal Association Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/feature_list} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {feature_list_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {cr_es_profile} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- max_number_of_es = 64 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/cr_es_profile} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {cr_es_profile_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {cp_valid_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- status = Validated, validation message is received, authenticated, and the IDs match tho Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/cp_valid_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000d Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {cp_data_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {key_generation_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- POD_ID = 000000000265DBED Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/key_generation_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] <- {/cp_data_req} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {cp_data_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {key_generation_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0005 Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> Host_ID = 0E40004F2F Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> N_Host = BBEA51E2CECB532C Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/key_generation_cnf} Jan 1 00:00:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/cp_data_cnf} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] zapi/ccard/trunk/src/cchi/application/zccard_cchi_featurelist.c:476 gf_version 4 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {feature_parameters} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- number_of_features = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {rf_output_channel} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- output_channel = 3 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- output_channel_ui = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {/rf_output_channel} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {/feature_parameters} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> {feature_parameters_cnf} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> number_of_features = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id,status = [0]RF Output Channel,0 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> {/feature_parameters_cnf} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0005 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] zapi/ccard/trunk/src/cchi/application/zccard_cchi_featurelist.c:476 gf_version 4 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {feature_parameters} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- number_of_features = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {time_zone} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- time_zone_offset = 65236 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {/time_zone} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {/feature_parameters} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> {feature_parameters_cnf} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> number_of_features = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id,status = [0]Time Zone,0 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> {/feature_parameters_cnf} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0005 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] zapi/ccard/trunk/src/cchi/application/zccard_cchi_featurelist.c:476 gf_version 4 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {feature_parameters} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- number_of_features = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {daylight_savings} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- daylight_savings_control = 2 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- daylight_savings_delta = 60 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- daylight_savings_entry_time = 0x440FD270 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- daylight_savings_exit_time = 0x45498960 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {/daylight_saving} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {/feature_parameters} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> {feature_parameters_cnf} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> number_of_features = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id,status = [0]Daylight Savings Control,0 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> {/feature_parameters_cnf} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0005 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] zapi/ccard/trunk/src/cchi/application/zccard_cchi_featurelist.c:476 gf_version 4 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {feature_parameters} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- number_of_features = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {vct_id} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- vct_id = 0x000c Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {/vct_id} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {/feature_parameters} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> {feature_parameters_cnf} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> number_of_features = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id,status = [0]VCT ID,1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> {/feature_parameters_cnf} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 0005 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] zapi/ccard/trunk/src/cchi/application/zccard_cchi_featurelist.c:476 gf_version 4 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {feature_parameters} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- number_of_features = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {turn_on_channel} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {/turn_on_channel} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] <- {/feature_parameters} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> {feature_parameters_cnf} Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> number_of_features = 1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> feature_id,status = [0]Turn on channel,1 Jan 1 00:00:12 ocur[21]: cyrano: [zccard/a:INFO] -> {/feature_parameters_cnf} Jan 1 00:00:21 ocur[21]: ocur: STT time Sun Jan 24 16:32:15 2016 UTC Jan 1 00:00:28 ocur[21]: ocur: slot_number: 0 Jan 1 00:00:28 ocur[21]: ocur: slot_number: 0 Jan 1 00:00:39 ocur[21]: cyrano: [zccard/s:INFO] SPDU - session_number(): 000d Jan 1 00:00:39 ocur[21]: cyrano: [zccard/a:INFO] <- {cp_sync_req} Jan 1 00:00:39 ocur[21]: cyrano: [zccard/a:INFO] -> {cp_sync_cnf} Jan 1 00:00:39 ocur[21]: cyrano: [zccard/a:INFO] -> status = OK Jan 1 00:00:39 ocur[21]: cyrano: [zccard/a:INFO] -> {/cp_sync_cnf} Jan 1 00:00:42 ocur[21]: cyrano: [zccard/oobsi:INFO] Stopping oobsi filter ntt Jan 1 00:00:42 ocur[21]: cyrano: [zccard/oobsi:INFO] Running oobsi filter ntt, handle 80000006 Jan 1 00:00:51 ocur[21]: upnp: Got first subscription Jan 1 00:01:10 ocur[21]: cyrano: [zccard/a:INFO] <- {system_time_inq} Jan 1 00:01:10 ocur[21]: cyrano: [zccard/a:INFO] -> {system_time} Jan 1 00:01:10 ocur[21]: cyrano: [zccard/a:INFO] -> system_time = 43CFBF38 "Sun Jan 24 16:33:04 2016 UTC" Jan 1 00:01:10 ocur[21]: cyrano: [zccard/a:INFO] -> GPS_UTC_offset = 00 Jan 1 00:01:10 ocur[21]: cyrano: [zccard/a:INFO] -> {/system_time} Jan 1 00:02:06 ocur[21]: ocur: turning off verbose prints Jan 1 00:03:49 ocur[21]: ocur: accumulating new channel map (460) into old channel map (483) Jan 1 00:03:49 ocur[21]: ocur: accumulated channel map same as old Jan 1 00:06:15 ocur[21]: upnp: Done sending rapid advertise Jan 1 00:16:17 ocur[21]: upnp: [192.168.200.2] Calling Action(cm[0]) GetProtocolInfo Jan 1 00:16:17 ocur[21]: upnp: [192.168.200.2] Action(cm[0]) GetProtocolInfo success Jan 1 00:16:17 ocur[21]: upnp: [192.168.200.2] Calling Action(cas[0]) GetCardStatus Jan 1 00:16:17 ocur[21]: upnp: [192.168.200.2] Action(cas[0]) GetCardStatus success Jan 1 00:16:17 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:16:17 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Calling Action(cm[1]) GetProtocolInfo Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Action(cm[1]) GetProtocolInfo success Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Calling Action(cas[1]) GetCardStatus Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Action(cas[1]) GetCardStatus success Jan 1 00:16:18 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:16:18 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Calling Action(cm[2]) GetProtocolInfo Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Action(cm[2]) GetProtocolInfo success Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Calling Action(cas[2]) GetCardStatus Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Action(cas[2]) GetCardStatus success Jan 1 00:16:18 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:16:18 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Calling Action(cm[3]) GetProtocolInfo Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Action(cm[3]) GetProtocolInfo success Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Calling Action(cas[3]) GetCardStatus Jan 1 00:16:18 ocur[21]: upnp: [192.168.200.2] Action(cas[3]) GetCardStatus success Jan 1 00:16:18 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:16:18 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:17:28 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:17:28 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:17:28 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:17:28 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:17:28 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:17:28 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:17:28 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:17:28 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Calling Action(cm[0]) GetProtocolInfo Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Action(cm[0]) GetProtocolInfo success Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Calling Action(cas[0]) GetCardStatus Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Action(cas[0]) GetCardStatus success Jan 1 00:18:40 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:18:40 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Calling Action(cm[1]) GetProtocolInfo Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Action(cm[1]) GetProtocolInfo success Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Calling Action(cas[1]) GetCardStatus Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Action(cas[1]) GetCardStatus success Jan 1 00:18:40 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:18:40 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Calling Action(cm[2]) GetProtocolInfo Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Action(cm[2]) GetProtocolInfo success Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Calling Action(cas[2]) GetCardStatus Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Action(cas[2]) GetCardStatus success Jan 1 00:18:40 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:18:40 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Calling Action(cm[3]) GetProtocolInfo Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Action(cm[3]) GetProtocolInfo success Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Calling Action(cas[3]) GetCardStatus Jan 1 00:18:40 ocur[21]: upnp: [192.168.200.2] Action(cas[3]) GetCardStatus success Jan 1 00:18:40 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:18:40 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:29:20 ocur[21]: ocur: [2] Attempting to SetChannel (Channel=11 SourceId=0 Mode=0) Jan 1 00:29:20 ocur[21]: upnp: WARNING: Unable to find variable "Streaming_IP" Jan 1 00:29:20 ocur[21]: ocur: ERROR: Variable getter failed. Jan 1 00:29:20 ocur[21]: ocur: [2] Program number set to 0, was 1 Jan 1 00:29:20 ocur[21]: ocur: [2] Tune to 11 (mod=q256, freq=759000, program=8, std=9) Jan 1 00:29:20 ocur[21]: ocur: [2] Program number set to 8, was 0 Jan 1 00:29:20 ocur[21]: ocur: [2] Locked: 0 Acc E: 0 Jan 1 00:29:21 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:29:21 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:29:21 ocur[21]: ocur: [2] Tune finished to freq 759000 Jan 1 00:29:21 ocur[21]: ocur: [2] Getting pmt for program 8 Jan 1 00:29:21 ocur[21]: ocur: [2] Got pmt for program# 8 Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x01c7 Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x01c8 Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x01c9 Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x01ca Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x01cb Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x01cc Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x01cd Jan 1 00:29:21 ocur[21]: upnp: Event(tuner[2]): PCRLock, "1" Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x0000 Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x05e8 Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x05e9 Jan 1 00:29:21 ocur[21]: ocur: [2] Adding pid 0x05e4 Jan 1 00:29:21 ocur[21]: ocur: [2] Channel is clear Jan 1 00:29:21 ocur[21]: ocur: [2] Sending ca_pmt to CableCARD for program number 8 index 0 Jan 1 00:29:21 ocur[21]: ocur: [2] Attempting to SetChannel (Channel=0 SourceId=0 Mode=0) Jan 1 00:29:21 ocur[21]: ocur: [2] Program number set to 0, was 8 Jan 1 00:29:21 ocur[21]: ocur: WARNING: [2] Channel 0 not found Jan 1 00:29:22 ocur[21]: ocur: [2] Carrier lock is 1 Jan 1 00:30:26 ocur[21]: ocur: STT time Sun Jan 24 17:02:15 2016 UTC Jan 1 00:31:02 ocur[21]: ocur: [0] Attempting to SetChannel (Channel=7 SourceId=0 Mode=0) Jan 1 00:31:02 ocur[21]: ocur: [0] Program number set to 0, was 1 Jan 1 00:31:02 ocur[21]: ocur: [0] Tune to 7 (mod=q256, freq=753000, program=6, std=9) Jan 1 00:31:02 ocur[21]: ocur: [0] Program number set to 6, was 0 Jan 1 00:31:02 ocur[21]: ocur: [0] Locked: 0 Acc E: 0 Jan 1 00:31:02 ocur[21]: upnp: WARNING: Unable to find variable "Streaming_IP" Jan 1 00:31:02 ocur[21]: ocur: ERROR: Variable getter failed. Jan 1 00:31:02 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:31:02 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:31:03 ocur[21]: ocur: [0] Tune finished to freq 753000 Jan 1 00:31:03 ocur[21]: ocur: [0] Getting pmt for program 6 Jan 1 00:31:03 ocur[21]: ocur: [0] Got pmt for program# 6 Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x01c4 Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x01c5 Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x01c6 Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x01c7 Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x01c8 Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x01c9 Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x01ca Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x01cb Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x01cc Jan 1 00:31:03 ocur[21]: upnp: Event(tuner[0]): PCRLock, "1" Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x0000 Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x1054 Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x1055 Jan 1 00:31:03 ocur[21]: ocur: [0] Adding pid 0x1058 Jan 1 00:31:03 ocur[21]: ocur: [0] Channel is clear Jan 1 00:31:03 ocur[21]: ocur: [0] Sending ca_pmt to CableCARD for program number 6 index 0 Jan 1 00:31:03 ocur[21]: ocur: [0] Attempting to SetChannel (Channel=0 SourceId=0 Mode=0) Jan 1 00:31:03 ocur[21]: ocur: [0] Program number set to 0, was 6 Jan 1 00:31:03 ocur[21]: ocur: WARNING: [0] Channel 0 not found Jan 1 00:31:04 ocur[21]: ocur: [0] Carrier lock is 1 Jan 1 00:32:18 ocur[21]: ocur: [1] Attempting to SetChannel (Channel=32 SourceId=0 Mode=0) Jan 1 00:32:18 ocur[21]: ocur: [1] Program number set to 0, was 1 Jan 1 00:32:18 ocur[21]: ocur: [1] Tune to 32 (mod=q256, freq=783000, program=8, std=9) Jan 1 00:32:18 ocur[21]: ocur: [1] Program number set to 8, was 0 Jan 1 00:32:18 ocur[21]: ocur: [1] Locked: 0 Acc E: 0 Jan 1 00:32:18 ocur[21]: upnp: WARNING: Unable to find variable "Streaming_IP" Jan 1 00:32:18 ocur[21]: ocur: ERROR: Variable getter failed. Jan 1 00:32:18 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:32:18 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:32:18 ocur[21]: ocur: [1] Tune finished to freq 783000 Jan 1 00:32:18 ocur[21]: ocur: [1] Getting pmt for program 8 Jan 1 00:32:18 ocur[21]: ocur: [1] Got pmt for program# 8 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x01a0 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x01a1 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x01a2 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x01a3 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x01a4 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x01a5 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x01a6 Jan 1 00:32:18 ocur[21]: ocur: [1] Attempting to SetChannel (Channel=0 SourceId=0 Mode=0) Jan 1 00:32:18 ocur[21]: upnp: Event(tuner[1]): PCRLock, "1" Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x0000 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x1310 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x0426 Jan 1 00:32:18 ocur[21]: ocur: WARNING: [1] Set channel in progress, saving channel number request 0 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x1311 Jan 1 00:32:18 ocur[21]: ocur: [1] Adding pid 0x1312 Jan 1 00:32:18 ocur[21]: ocur: WARNING: [1] Aborting set channel for 32 Jan 1 00:32:18 ocur[21]: ocur: WARNING: [1] Restarting SetChannel with new channel number 0 Jan 1 00:32:18 ocur[21]: ocur: [1] Program number set to 0, was 8 Jan 1 00:32:18 ocur[21]: ocur: WARNING: [1] Channel 0 not found Jan 1 00:32:19 ocur[21]: ocur: [1] Carrier lock is 1 Jan 1 00:33:13 ocur[21]: ocur: [3] Attempting to SetChannel (Channel=67 SourceId=0 Mode=0) Jan 1 00:33:13 ocur[21]: ocur: [3] Program number set to 0, was 1 Jan 1 00:33:13 ocur[21]: ocur: [3] Tune to 67 (mod=q256, freq=801000, program=4, std=9) Jan 1 00:33:13 ocur[21]: ocur: [3] Program number set to 4, was 0 Jan 1 00:33:13 ocur[21]: upnp: WARNING: Unable to find variable "Streaming_IP" Jan 1 00:33:13 ocur[21]: ocur: ERROR: Variable getter failed. Jan 1 00:33:13 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:33:13 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:33:14 ocur[21]: ocur: [3] Locked: 0 Acc E: 0 Jan 1 00:33:14 ocur[21]: ocur: [3] Tune finished to freq 801000 Jan 1 00:33:14 ocur[21]: ocur: [3] Getting pmt for program 4 Jan 1 00:33:14 ocur[21]: ocur: [3] Got pmt for program# 4 Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01eb Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01ec Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01ed Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01ee Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01ef Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01f0 Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01f1 Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01f2 Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01f3 Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01f5 Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01fb Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x01fc Jan 1 00:33:14 ocur[21]: upnp: Event(tuner[3]): PCRLock, "1" Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x0000 Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x136d Jan 1 00:33:14 ocur[21]: ocur: [3] Attempting to SetChannel (Channel=0 SourceId=0 Mode=0) Jan 1 00:33:14 ocur[21]: ocur: WARNING: [3] Set channel in progress, saving channel number request 0 Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x046f Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x136e Jan 1 00:33:14 ocur[21]: ocur: [3] Adding pid 0x136f Jan 1 00:33:14 ocur[21]: ocur: WARNING: [3] Aborting set channel for 67 Jan 1 00:33:14 ocur[21]: ocur: WARNING: [3] Restarting SetChannel with new channel number 0 Jan 1 00:33:14 ocur[21]: ocur: [3] Program number set to 0, was 4 Jan 1 00:33:14 ocur[21]: ocur: WARNING: [3] Channel 0 not found Jan 1 00:33:15 ocur[21]: ocur: [3] Carrier lock is 1 Jan 1 00:35:08 ocur[21]: ocur: [3] Attempting to SetChannel (Channel=1 SourceId=0 Mode=0) Jan 1 00:35:08 ocur[21]: ocur: [3] Program number set to 0, was 0 Jan 1 00:35:08 ocur[21]: ocur: [3] Tune to 1 (mod=q256, freq=537000, program=1, std=9) Jan 1 00:35:08 ocur[21]: ocur: [3] Program number set to 1, was 0 Jan 1 00:35:08 ocur[21]: ocur: [3] Locked: 1 Acc E: 0 Jan 1 00:35:08 ocur[21]: upnp: WARNING: Unable to find variable "Streaming_IP" Jan 1 00:35:08 ocur[21]: ocur: ERROR: Variable getter failed. Jan 1 00:35:08 ocur[21]: ocur: ERROR: Unable to open presentation file "/stream_request.cgi" (No such file or directory) Jan 1 00:35:08 ocur[21]: ocur: ERROR: unknown write handle Jan 1 00:35:08 ocur[21]: ocur: [3] Tune finished to freq 537000 Jan 1 00:35:08 ocur[21]: ocur: [3] Getting pmt for program 1 Jan 1 00:35:09 ocur[21]: mpeg: WARNING: [ID-3] Unable to find program number 1 in pat Jan 1 00:35:09 ocur[21]: ocur: ERROR: [3] PAT returned but no PMT Jan 1 00:35:09 ocur[21]: ocur: [3] PCR Lock: 1 Jan 1 00:35:09 ocur[21]: ocur: [3] Packets: 1 (40 - 39) Data Ready 0 Jan 1 00:35:09 ocur[21]: mpeg: [ID-3] ready 00000002 pkts 00000002 filter 00000000 sections 00000002 no_filters 00000000 zero_pid 00000001 Jan 1 00:35:09 ocur[21]: libctn91xx: 0.9 read 00000002 comp 00000002 Jan 1 00:35:09 ocur[21]: mpeg: [ID-3] ready 00000003 pkts 00000003 filter 00000000 sections 00000003 no_filters 00000000 zero_pid 00000002 Jan 1 00:35:09 ocur[21]: libctn91xx: 0.9 read 00000003 comp 00000003 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000002 00000002 00000000 00000000 00000000 00000002 00000000 00000002 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000003 00000003 00000000 00000000 00000000 00000003 00000000 00000003 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000002 00000002 00000000 00000000 00000000 00000002 00000000 00000002 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000002 00000002 00000000 00000000 00000000 00000002 00000000 00000002 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00228941 00000009 00000000 00001459 00099776 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000000 00000000 00000002 00114164 00013531 Jan 1 00:35:09 ocur[21]: libctn91xx: 00002799 00011355 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: 00000000 00000000 00000000 00000000 Jan 1 00:35:09 ocur[21]: libctn91xx: Pid filter for stream id 7 Jan 1 00:35:09 ocur[21]: enabled: 1 whitelist: 1 nullify_if_not_found: 0 Jan 1 00:35:09 ocur[21]: Jan 1 00:35:09 ocur[21]: ocur: WARNING: [3] Could not get pmt Jan 1 00:35:09 ocur[21]: ocur: WARNING: [3] Disabling video Jan 1 00:35:09 ocur[21]: ocur: [3] Program number set to 0, was 1 Jan 1 00:35:20 ocur[21]: ocur: [3] Attempting to SetChannel (Channel=0 SourceId=0 Mode=0) Jan 1 00:35:20 ocur[21]: ocur: [3] Program number set to 0, was 0 Jan 1 00:35:20 ocur[21]: ocur: WARNING: [3] Channel 0 not found