[ 1130.658526] start VIDEO0 on dmx 5 pid:13ed index 3
[ 1130.658566] VIDEO0: total delay: 18000 (200 ms)
[ 1130.663575] VIDEO0: start decode
[ 1130.676591] si2183(0): start tune freq 1743750, sr 22000000, delsys 6
[ 1130.676603] si2183(0): IS_ID 240
[ 1130.793763] si2183(0): found carrier after 117 ms
[ 1130.793771] si2183(0): final lock after 117 ms
[ 1130.823290] audio ch0: first pts 0xd9cd12e8, stc 0xd9ccfcc2, pcr valid
[ 1130.855328] audio ch0: lock
[ 1130.855347] audio ch0: sample rate changed isr (48000)
[ 1131.130459] audio ch0: status ready isr
[ 1131.297689] VIDEO0: first pts 0xd9cf2856
[ 1131.297715] VIDEO0: framerate changed 6
[ 1131.297726] VIDEO0: resolution changed (1280 720)
[ 1131.297763] set current avs auto aspect to 16:9
[ 1131.297817] set sb to 3(1)
[ 1131.459252] VIDEO0: enable tsm
[ 1131.677663] VIDEO0: progressive changed (1)
[ 1165.049760] stop PCR0 on dmx 5 pid:13ed
[ 1165.049906] stop VIDEO0 on dmx 5 pid:13ed
[ 1165.050877] VIDEO0: stop decode
[ 1165.051278] audio ch0: decoder stop
[ 1165.053526] stop AUDIO0 on dmx 5 pid:13f2
[ 1165.053532] audio ch0: xpt stop
[ 1165.053539] sync0 1fff no decoder left in sync handling so disable
[ 1165.053543] sync0: was last pcroffset0 user so free it
[ 1165.095955] si2183(1): DVB-S(2) voltage is 18V now
[ 1165.096826] start PCR0 on dmx 4 pid:ff index 12
[ 1165.097026] start AUDIO0 on dmx 4 pid:103 index 8
[ 1165.097032] audio ch0: xpt start
[ 1165.097051] sync0 is off so we enable it
[ 1165.097057] sync0: allocated pcroffset 0
[ 1165.097068] sync0: demux-index 4 pcr pid ff
[ 1165.097080] sync0: using 12 as pcr pidchannel
[ 1165.097097] audio ch0: AC3
[ 1165.097171] audio ch0: decoder start
[ 1165.097178] audio ch0 delay 18000 (200 ms)
[ 1165.097183] VIDEO0: total delay: 18000 (200 ms)
[ 1165.097709] VIDEO0: set streamtype!
[ 1165.097725] ->      set MPEG2
[ 1165.097735] ->      sw rave disabled!
[ 1165.097756] audio ch0: video delay 0 (0 ms)
[ 1165.097765] VIDEO0: total delay: 0 (0 ms)
[ 1165.097917] start VIDEO0 on dmx 4 pid:ff index 12
[ 1165.097955] VIDEO0: total delay: 0 (0 ms)
[ 1165.102993] VIDEO0: start decode
[ 1166.086922] si2183(1): tune timeout!
[ 1166.421491] si2183(1): changed wideband attenuator threshold
[ 1166.421499] si2183(1): start tune freq 1944750, sr 22000000, delsys 5
[ 1168.908965] si2183(1): tune timeout!
[ 1176.761594] si2183(1): start tune freq 1944750, sr 22000000, delsys 5
[ 1176.878618] si2183(1): found carrier after 117 ms
[ 1176.895236] audio ch0: first pts 0x3bc4c346, stc 0x64d298a, pcr invalid
[ 1176.900028] si2183(1): final lock after 138 ms
[ 1176.925732] audio ch0: lock
[ 1176.925760] audio ch0: sample rate changed isr (48000)
[ 1176.925782] audio ch0: tsm fail
[ 1176.925790] audio ch0: pts error 0 PTS 0x3bc4c346, STC 0x3bc4bb88, type 0
[ 1177.024040] audio ch0: status ready isr
[ 1177.497750] VIDEO0: first pts 0x3bc5cc78
[ 1177.497770] VIDEO0: framerate changed 3
[ 1177.497777] VIDEO0: resolution changed (720 576)
[ 1177.497783] VIDEO0: progressive changed (0)
[ 1177.497834] set current avs auto aspect to 16:9
[ 1177.497895] set sb to 3(1)
[ 1177.647280] VIDEO0: enable tsm
[ 1188.260992] si2183(0): DVB-S(2) voltage disabled now
[ 1188.261409] si2183(0): DVB-S(2) voltage disabled now
[ 1212.219660] stop PCR0 on dmx 4 pid:ff
[ 1212.220146] stop VIDEO0 on dmx 4 pid:ff
[ 1212.220801] VIDEO0: stop decode
[ 1212.221902] audio ch0: decoder stop
[ 1212.224162] stop AUDIO0 on dmx 4 pid:103
[ 1212.224170] audio ch0: xpt stop
[ 1212.224176] sync0 1fff no decoder left in sync handling so disable
[ 1212.224181] sync0: was last pcroffset0 user so free it
[ 1212.253130] start PCR0 on dmx 5 pid:13ed index 3
[ 1212.253360] start AUDIO0 on dmx 5 pid:13f2 index 1
[ 1212.253368] audio ch0: xpt start
[ 1212.253389] sync0 is off so we enable it
[ 1212.253394] sync0: allocated pcroffset 0
[ 1212.253408] sync0: demux-index 5 pcr pid 13ed
[ 1212.253420] sync0: using 3 as pcr pidchannel
[ 1212.253438] audio ch0: AC3
[ 1212.253504] audio ch0: decoder start
[ 1212.253511] audio ch0: video delay 0 (0 ms)
[ 1212.253517] VIDEO0: total delay: 0 (0 ms)
[ 1212.254823] VIDEO0: set streamtype!
[ 1212.254836] ->      set H264
[ 1212.254855] ->      sw rave disabled!
[ 1212.254872] audio ch0 delay 18000 (200 ms)
[ 1212.254876] VIDEO0: total delay: 18000 (200 ms)
[ 1212.254906] si2183(0): DVB-S(2) voltage is 18V now
[ 1212.255570] start VIDEO0 on dmx 5 pid:13ed index 3
[ 1212.255606] VIDEO0: total delay: 18000 (200 ms)
[ 1212.260882] VIDEO0: start decode
[ 1213.247677] si2183(0): tune timeout!
[ 1213.552898] si2183(0): start tune freq 1743750, sr 22000000, delsys 6
[ 1213.552907] si2183(0): IS_ID 240
[ 1213.670790] si2183(0): found carrier after 118 ms
[ 1213.670799] si2183(0): final lock after 118 ms
[ 1213.732237] audio ch0: lock
[ 1213.732268] audio ch0: sample rate changed isr (48000)
[ 1213.732287] audio ch0: tsm fail
[ 1213.732293] audio ch0: ignore pts error when audio is not running
[ 1213.767546] audio ch0: tsm fail
[ 1213.767559] audio ch0: ignore pts error when audio is not running
[ 1213.767573] audio ch0: first pts 0xda3efae8, stc 0xda3ee4d0, pcr valid
[ 1214.074677] audio ch0: status ready isr
[ 1214.337806] VIDEO0: first pts 0xda413216
[ 1214.337836] VIDEO0: framerate changed 6
[ 1214.337846] VIDEO0: resolution changed (1280 720)
[ 1214.337859] VIDEO0: progressive changed (1)
[ 1214.337961] set current avs auto aspect to 16:9
[ 1214.338025] set sb to 3(1)
[ 1214.487280] VIDEO0: enable tsm
[ 1215.468641] si2183(1): DVB-S(2) voltage disabled now
[ 1215.469009] si2183(1): DVB-S(2) voltage disabled now
[ 1236.881074] stop PCR0 on dmx 5 pid:13ed
[ 1236.881166] stop VIDEO0 on dmx 5 pid:13ed
[ 1236.882054] VIDEO0: stop decode
[ 1236.882299] audio ch0: decoder stop
[ 1236.884577] stop AUDIO0 on dmx 5 pid:13f2
[ 1236.884584] audio ch0: xpt stop
[ 1236.884591] sync0 1fff no decoder left in sync handling so disable
[ 1236.884595] sync0: was last pcroffset0 user so free it
[ 1236.915196] start PCR0 on dmx 4 pid:ff index 12
[ 1236.915522] start AUDIO0 on dmx 4 pid:103 index 7
[ 1236.915532] audio ch0: xpt start
[ 1236.915555] sync0 is off so we enable it
[ 1236.915563] sync0: allocated pcroffset 0
[ 1236.915576] sync0: demux-index 4 pcr pid ff
[ 1236.915589] sync0: using 12 as pcr pidchannel
[ 1236.915610] audio ch0: AC3
[ 1236.915753] audio ch0: decoder start
[ 1236.915768] audio ch0 delay 18000 (200 ms)
[ 1236.915773] VIDEO0: total delay: 18000 (200 ms)
[ 1236.916346] VIDEO0: set streamtype!
[ 1236.916356] ->      set MPEG2
[ 1236.916362] ->      sw rave disabled!
[ 1236.916379] audio ch0: video delay 0 (0 ms)
[ 1236.916383] VIDEO0: total delay: 0 (0 ms)
[ 1236.916491] start VIDEO0 on dmx 4 pid:ff index 12
[ 1236.916530] VIDEO0: total delay: 0 (0 ms)
[ 1236.916750] si2183(1): DVB-S(2) voltage is 18V now
[ 1236.921665] VIDEO0: start decode
[ 1237.963710] si2183(1): tune timeout!
[ 1238.227997] si2183(1): start tune freq 1944750, sr 22000000, delsys 5
[ 1238.364607] si2183(1): found carrier after 137 ms
[ 1238.364616] si2183(1): final lock after 137 ms
[ 1238.400052] audio ch0: lock
[ 1238.400075] audio ch0: sample rate changed isr (48000)
[ 1238.400092] audio ch0: tsm fail
[ 1238.400096] audio ch0: ignore pts error when audio is not running
[ 1238.430427] audio ch0: tsm fail
[ 1238.430436] audio ch0: ignore pts error when audio is not running
[ 1238.460933] audio ch0: tsm fail
[ 1238.460948] audio ch0: ignore pts error when audio is not running
[ 1238.495450] audio ch0: tsm fail
[ 1238.495468] audio ch0: ignore pts error when audio is not running
[ 1238.495485] audio ch0: first pts 0x3c195b86, stc 0x3c194916, pcr valid
[ 1238.592134] audio ch0: status ready isr
[ 1238.957819] VIDEO0: first pts 0x3c1a2c78
[ 1238.957848] VIDEO0: framerate changed 3
[ 1238.957859] VIDEO0: resolution changed (720 576)
[ 1238.957867] VIDEO0: progressive changed (0)
[ 1238.958038] set current avs auto aspect to 16:9
[ 1238.958331] set sb to 3(1)
[ 1239.107276] VIDEO0: enable tsm
[ 1257.143812] si2183(0): DVB-S(2) voltage disabled now
[ 1257.144177] si2183(0): DVB-S(2) voltage disabled now