Problem: libdvbpsi error (PSI decoder): TS discontinuity
Posted: 18 May 2006 16:14
I have "libdvbpsi error (PSI decoder): TS discontinuity" messages every 6 or so seconds. For some reason TS packets are dropped, which garble audio/video repeatedly.
The card is a WinTV Nova-T (DVB-T) under kubuntu's kernel 2.6.12. VLC is the svn version from a few days ago. dvbstream works perfectly without dropping TS packets: /usr/bin/dvbstream -udp -net 192.168.250.229:3000 0 110 120 130
Any help concerning this problem would be greatly appreciated ! At this point I don't know if it is a libdbpsi bug or a linux-dvb bug or a driver bug....
small log:
./vlc -v dvb: --dvb-frequency=490000000 --dvb-bandwidth=8 --program=320
VLC media player 0.8.6-svn Janus
Remote control interface initialized. Type `help' for help.
[00000254] main private warning: Option sout-standard-url is deprecated. You should use sout-standard-dst instead.
[00000256] main private: creating httpd
[00000262] main demuxer warning: no access_demux module matched "dvb"
status change: ( new input: dvb: )
status change: ( audio volume: 256 )
status change: ( play state: 1 )
[00000263] dvb access warning: CAMInit: opening CAM device failed (No such device)
[00000263] dvb access warning: unimplemented query in control
libdvbpsi error (PSI decoder): TS discontinuity (received 8, expected 0) for PID 0
libdvbpsi error (PSI decoder): TS discontinuity (received 13, expected 0) for PID 18
libdvbpsi error (PSI decoder): TS discontinuity (received 11, expected 0) for PID 17
[00000263] dvb access warning: no lock, tuning again
libdvbpsi error (PSI decoder): TS discontinuity (received 2, expected 15) for PID 18
libdvbpsi error (PSI decoder): TS discontinuity (received 6, expected 3) for PID 18
libdvbpsi error (PSI decoder): TS discontinuity (received 15, expected 10) for PID 0
libdvbpsi error (PSI decoder): TS discontinuity (received 15, expected 14) for PID 17
[00000263] dvb access warning: no lock, tuning again
libdvbpsi error (PSI decoder): TS discontinuity (received 0, expected 4) for PID 18
libdvbpsi error (PSI decoder): TS discontinuity (received 11, expected 4) for PID 0
libdvbpsi error (PSI decoder): TS discontinuity (received 6, expected 5) for PID 17
full log:
VLC media player 0.8.6-svn Janus
[00000001] main vlc debug: checking builtin modules
[00000001] main vlc debug: checking plugin modules
[00000001] main vlc debug: loading plugins cache file /home/mpujos/.vlc/cache/plugins-04041e.dat
[00000001] main vlc debug: recursively browsing `modules'
[00000001] main vlc debug: recursively browsing `/home/mpujos/build/vlc/lib/vlc'
[00000001] main vlc debug: recursively browsing `plugins'
[00000001] main vlc debug: module bank initialized, found 188 modules
[00000001] main vlc debug: opening config file /home/mpujos/.vlc/vlcrc
[00000001] main vlc debug: CPU has capabilities 486 586 MMX MMXEXT SSE SSE2 FPU
[00000001] main vlc debug: looking for memcpy module: 3 candidates
[00000001] main vlc debug: using memcpy module "memcpymmxext"
[00000243] main playlist debug: waiting for thread completion
[00000243] main playlist debug: thread 3082353584 (playlist) created at priority 0 (playlist/playlist.c:184)
[00000244] main private debug: waiting for thread completion
[00000244] main private debug: thread 3073960880 (preparser) created at priority 0 (playlist/playlist.c:210)
[00000245] main interface debug: looking for interface module: 1 candidate
[00000245] main interface debug: using interface module "hotkeys"
[00000245] main interface debug: thread 3065543600 (interface) created at priority 0 (interface/interface.c:231)
[00000247] main interface debug: looking for interface module: 1 candidate
[00000247] main interface debug: using interface module "screensaver"
[00000247] main interface debug: thread 3057142704 (interface) created at priority 0 (interface/interface.c:231)
[00000243] main playlist debug: adding playlist item `dvb:' ( dvb: )
[00000249] main interface debug: looking for interface module: 1 candidate
Remote control interface initialized. Type `help' for help.
[00000249] main interface debug: using interface module "rc"
[00000249] main interface debug: thread 3048700848 (manager) created at priority 0 (interface/interface.c:216)
[00000243] main playlist debug: creating new input thread
[00000251] main input debug: waiting for thread completion
[00000251] main input debug: creating statistics handler
[00000251] main input debug: `dvb:' gives access `dvb' demux `' path `'
[00000251] main input debug: creating demux: access='dvb' demux='' path=''
[00000253] main demuxer debug: looking for access_demux module: 0 candidates
[00000253] main demuxer warning: no access_demux module matched "dvb"
[00000251] main input debug: creating access 'dvb' path=''
[00000254] main access debug: looking for access2 module: 5 candidates
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/frontend0
[00000251] main input debug: thread 3040308144 (input) created at priority 0 (input/input.c:261)
[00000254] dvb access debug: Frontend Info:
[00000254] dvb access debug: name = Hauppauge Nova-T DVB-T
[00000254] dvb access debug: type = OFDM (DVB-T)
[00000254] dvb access debug: frequency_min = 177000000 (kHz)
[00000254] dvb access debug: frequency_max = 858000000 (kHz)
[00000254] dvb access debug: frequency_stepsize = 166666
[00000254] dvb access debug: frequency_tolerance = 0
[00000254] dvb access debug: symbol_rate_min = 0 (kHz)
[00000254] dvb access debug: symbol_rate_max = 0 (kHz)
[00000254] dvb access debug: symbol_rate_tolerance (ppm) = 0
[00000254] dvb access debug: notifier_delay (ms) = 0
[00000254] dvb access debug: Frontend Info capability list:
[00000254] dvb access debug: inversion auto
[00000254] dvb access debug: forward error correction 1/2
[00000254] dvb access debug: forward error correction 2/3
[00000254] dvb access debug: forward error correction 3/4
[00000254] dvb access debug: forward error correction 5/6
[00000254] dvb access debug: forward error correction 7/8
[00000254] dvb access debug: forward error correction auto
[00000254] dvb access debug: card can do QPSK
[00000254] dvb access debug: card can do QAM 16
[00000254] dvb access debug: card can do QAM 64
[00000254] dvb access debug: card can do QAM auto
[00000254] dvb access debug: transmission mode auto
[00000254] dvb access debug: guard interval mode auto
[00000254] dvb access debug: hierarchy mode auto
[00000254] dvb access debug: card can recover from a cable unplug
[00000254] dvb access debug: End of capability list
[00000254] dvb access debug: trying to tune the frontend...
[00000254] dvb access debug: using inversion=2
[00000254] dvb access debug: using bandwidth=8
[00000254] dvb access debug: using fec=9
[00000254] dvb access debug: using fec=9
[00000254] dvb access debug: using transmission=0
[00000254] dvb access debug: using guard=0
[00000254] dvb access debug: using hierarchy=0
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/dvr0
[00000254] dvb access debug: setting filter on PAT
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/demux0
[00000254] dvb access debug: DMXSetFilter: DMX_PES_OTHER for PID 0
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/ca0
[00000254] dvb access warning: CAMInit: opening CAM device failed (No such device)
[00000254] main access debug: using access2 module "dvb"
[00000256] main private debug: pre buffering
status change: ( new input: dvb: )
status change: ( audio volume: 256 )
status change: ( play state: 1 )
[00000256] main private debug: received first data for our buffer
[00000256] main private debug: prebuffering done 376 bytes in 2s - 0 kbytes/s
[00000251] main input debug: creating demux: access='dvb' demux='' path=''
[00000257] main demuxer debug: looking for demux2 module: 40 candidates
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/demux0
[00000254] dvb access debug: DMXSetFilter: DMX_PES_OTHER for PID 17
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/demux0
[00000254] dvb access debug: DMXSetFilter: DMX_PES_OTHER for PID 18
[00000257] main demuxer debug: using demux2 module "ts"
[00000251] main input debug: looking for a subtitle file in /home/mpujos/build/vlc/bin/
[00000257] ts demuxer debug: DEMUX_SET_GROUP 320 (nil)
[00000254] dvb access warning: unimplemented query in control
[00000251] main input debug: `dvb:' successfully opened
libdvbpsi error (PSI decoder): TS discontinuity (received 11, expected 0) for PID 0
[00000257] ts demuxer debug: PATCallBack called
[00000257] ts demuxer debug: new PAT ts_id=1 version=2 current_next=1
[00000257] ts demuxer debug: * number=0 pid=16
[00000257] ts demuxer debug: * number=257 pid=110
[00000257] ts demuxer debug: * number=259 pid=410
[00000257] ts demuxer debug: * number=260 pid=310
[00000257] ts demuxer debug: * number=261 pid=510
[00000257] ts demuxer debug: * number=262 pid=610
[00000257] ts demuxer debug: * number=274 pid=210
[00000257] ts demuxer debug: * number=511 pid=1010
libdvbpsi error (PSI decoder): TS discontinuity (received 12, expected 0) for PID 18
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x101(257)
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x103(259)
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x104(260)
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x105(261)
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x106(262)
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x112(274)
[00000257] ts demuxer debug: EITCallBack called
[00000257] ts demuxer debug: new EIT service_id=257 version=15 current_next=1 ts_id=1 network_id=8442 segment_last_section_number=1 last_table_id=78
[00000257] ts demuxer debug: * event id=30517 start_time:mjd=53867 07:30:00 duration=01:20:00 running=4 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'C'est au programme' : 'Magazine de société.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000257] ts demuxer debug: * event id=30518 start_time:mjd=53867 08:50:00 duration=00:10:00 running=1 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Flash info' : 'Journal.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000251] main input debug: EsOutProgramMeta: number=257
[00000251] main input debug: - Event 30517 = 07:30:00: C'est au programme (+01:20:00) Magazine de société. ()
[00000251] main input debug: - Now Playing = C'est au programme
[00000251] main input debug: - Event 30518 = 08:50:00: Flash info (+00:10:00) Journal. ()
[00000257] ts demuxer debug: EITCallBack called
[00000257] ts demuxer debug: new EIT service_id=259 version=2 current_next=1 ts_id=1 network_id=8442 segment_last_section_number=1 last_table_id=78
[00000257] ts demuxer debug: * event id=30671 start_time:mjd=53867 07:55:00 duration=00:30:00 running=4 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Age sensible' : '«Fausse excuse». Série sentimentale. 2001. Saison 1. 4/28.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000257] ts demuxer debug: * event id=30672 start_time:mjd=53867 08:25:00 duration=00:25:00 running=1 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Blague à part' : '«Bucky». Série humoristique. 1998. Saison 1. 4/20.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000251] main input debug: EsOutProgramMeta: number=259
[00000251] main input debug: - Event 30671 = 07:55:00: Age sensible (+00:30:00) «Fausse excuse». Série sentimentale. 2001. Saison 1. 4/28. ()
[00000251] main input debug: - Now Playing = Age sensible
[00000251] main input debug: - Event 30672 = 08:25:00: Blague à part (+00:25:00) «Bucky». Série humoristique. 1998. Saison 1. 4/20. ()
[00000257] ts demuxer debug: EITCallBack called
[00000257] ts demuxer debug: new EIT service_id=260 version=18 current_next=1 ts_id=1 network_id=8442 segment_last_section_number=1 last_table_id=78
[00000257] ts demuxer debug: * event id=30723 start_time:mjd=53867 07:00:00 duration=01:33:00 running=4 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Les maternelles' : 'Magazine de société.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000257] ts demuxer debug: * event id=30724 start_time:mjd=53867 08:33:00 duration=00:02:00 running=1 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Mon bébé et moi' : 'Magazine de la santé.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000251] main input debug: EsOutProgramMeta: number=260
[00000251] main input debug: - Event 30723 = 07:00:00: Les maternelles (+01:33:00) Magazine de société. ()
[00000251] main input debug: - Now Playing = Les maternelles
[00000251] main input debug: - Event 30724 = 08:33:00: Mon bébé et moi (+00:02:00) Magazine de la santé. ()
[00000257] ts demuxer debug: EITCallBack called
[00000257] ts demuxer debug: new EIT service_id=261 version=15 current_next=1 ts_id=1 network_id=8442 segment_last_section_number=1 last_table_id=78
[00000257] ts demuxer debug: * event id=30788 start_time:mjd=53867 07:55:00 duration=00:30:00 running=4 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Memoquiz' : 'Jeu.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000257] ts demuxer debug: * event id=30789 start_time:mjd=53867 08:25:00 duration=00:10:00 running=1 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Le dessous des cartes' : '«Peuples : de la richesse et de la fragilité». Magazine de géopolitique.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000251] main input debug: EsOutProgramMeta: number=261
[00000251] main input debug: - Event 30788 = 07:55:00: Memoquiz (+00:30:00) Jeu. ()
[00000251] main input debug: - Now Playing = Memoquiz
[00000251] main input debug: - Event 30789 = 08:25:00: Le dessous des cartes (+00:10:00) «Peuples : de la richesse et de la fragilité». Magazine de géopolitique. ()
[00000257] ts demuxer debug: EITCallBack called
[00000257] ts demuxer debug: new EIT service_id=262 version=6 current_next=1 ts_id=1 network_id=8442 segment_last_section_number=1 last_table_id=78
[00000257] ts demuxer debug: * event id=30857 start_time:mjd=53867 07:30:00 duration=01:05:00 running=4 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Les travaux de l'Assemblée nationale' : 'Débat parlementaire.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000257] ts demuxer debug: * event id=30858 start_time:mjd=53867 08:35:00 duration=01:25:00 running=1 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'En commission au Sénat' : '«Mission d'information sur les quartiers difficiles». Débat parlementaire.'
The card is a WinTV Nova-T (DVB-T) under kubuntu's kernel 2.6.12. VLC is the svn version from a few days ago. dvbstream works perfectly without dropping TS packets: /usr/bin/dvbstream -udp -net 192.168.250.229:3000 0 110 120 130
Any help concerning this problem would be greatly appreciated ! At this point I don't know if it is a libdbpsi bug or a linux-dvb bug or a driver bug....
small log:
./vlc -v dvb: --dvb-frequency=490000000 --dvb-bandwidth=8 --program=320
VLC media player 0.8.6-svn Janus
Remote control interface initialized. Type `help' for help.
[00000254] main private warning: Option sout-standard-url is deprecated. You should use sout-standard-dst instead.
[00000256] main private: creating httpd
[00000262] main demuxer warning: no access_demux module matched "dvb"
status change: ( new input: dvb: )
status change: ( audio volume: 256 )
status change: ( play state: 1 )
[00000263] dvb access warning: CAMInit: opening CAM device failed (No such device)
[00000263] dvb access warning: unimplemented query in control
libdvbpsi error (PSI decoder): TS discontinuity (received 8, expected 0) for PID 0
libdvbpsi error (PSI decoder): TS discontinuity (received 13, expected 0) for PID 18
libdvbpsi error (PSI decoder): TS discontinuity (received 11, expected 0) for PID 17
[00000263] dvb access warning: no lock, tuning again
libdvbpsi error (PSI decoder): TS discontinuity (received 2, expected 15) for PID 18
libdvbpsi error (PSI decoder): TS discontinuity (received 6, expected 3) for PID 18
libdvbpsi error (PSI decoder): TS discontinuity (received 15, expected 10) for PID 0
libdvbpsi error (PSI decoder): TS discontinuity (received 15, expected 14) for PID 17
[00000263] dvb access warning: no lock, tuning again
libdvbpsi error (PSI decoder): TS discontinuity (received 0, expected 4) for PID 18
libdvbpsi error (PSI decoder): TS discontinuity (received 11, expected 4) for PID 0
libdvbpsi error (PSI decoder): TS discontinuity (received 6, expected 5) for PID 17
full log:
VLC media player 0.8.6-svn Janus
[00000001] main vlc debug: checking builtin modules
[00000001] main vlc debug: checking plugin modules
[00000001] main vlc debug: loading plugins cache file /home/mpujos/.vlc/cache/plugins-04041e.dat
[00000001] main vlc debug: recursively browsing `modules'
[00000001] main vlc debug: recursively browsing `/home/mpujos/build/vlc/lib/vlc'
[00000001] main vlc debug: recursively browsing `plugins'
[00000001] main vlc debug: module bank initialized, found 188 modules
[00000001] main vlc debug: opening config file /home/mpujos/.vlc/vlcrc
[00000001] main vlc debug: CPU has capabilities 486 586 MMX MMXEXT SSE SSE2 FPU
[00000001] main vlc debug: looking for memcpy module: 3 candidates
[00000001] main vlc debug: using memcpy module "memcpymmxext"
[00000243] main playlist debug: waiting for thread completion
[00000243] main playlist debug: thread 3082353584 (playlist) created at priority 0 (playlist/playlist.c:184)
[00000244] main private debug: waiting for thread completion
[00000244] main private debug: thread 3073960880 (preparser) created at priority 0 (playlist/playlist.c:210)
[00000245] main interface debug: looking for interface module: 1 candidate
[00000245] main interface debug: using interface module "hotkeys"
[00000245] main interface debug: thread 3065543600 (interface) created at priority 0 (interface/interface.c:231)
[00000247] main interface debug: looking for interface module: 1 candidate
[00000247] main interface debug: using interface module "screensaver"
[00000247] main interface debug: thread 3057142704 (interface) created at priority 0 (interface/interface.c:231)
[00000243] main playlist debug: adding playlist item `dvb:' ( dvb: )
[00000249] main interface debug: looking for interface module: 1 candidate
Remote control interface initialized. Type `help' for help.
[00000249] main interface debug: using interface module "rc"
[00000249] main interface debug: thread 3048700848 (manager) created at priority 0 (interface/interface.c:216)
[00000243] main playlist debug: creating new input thread
[00000251] main input debug: waiting for thread completion
[00000251] main input debug: creating statistics handler
[00000251] main input debug: `dvb:' gives access `dvb' demux `' path `'
[00000251] main input debug: creating demux: access='dvb' demux='' path=''
[00000253] main demuxer debug: looking for access_demux module: 0 candidates
[00000253] main demuxer warning: no access_demux module matched "dvb"
[00000251] main input debug: creating access 'dvb' path=''
[00000254] main access debug: looking for access2 module: 5 candidates
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/frontend0
[00000251] main input debug: thread 3040308144 (input) created at priority 0 (input/input.c:261)
[00000254] dvb access debug: Frontend Info:
[00000254] dvb access debug: name = Hauppauge Nova-T DVB-T
[00000254] dvb access debug: type = OFDM (DVB-T)
[00000254] dvb access debug: frequency_min = 177000000 (kHz)
[00000254] dvb access debug: frequency_max = 858000000 (kHz)
[00000254] dvb access debug: frequency_stepsize = 166666
[00000254] dvb access debug: frequency_tolerance = 0
[00000254] dvb access debug: symbol_rate_min = 0 (kHz)
[00000254] dvb access debug: symbol_rate_max = 0 (kHz)
[00000254] dvb access debug: symbol_rate_tolerance (ppm) = 0
[00000254] dvb access debug: notifier_delay (ms) = 0
[00000254] dvb access debug: Frontend Info capability list:
[00000254] dvb access debug: inversion auto
[00000254] dvb access debug: forward error correction 1/2
[00000254] dvb access debug: forward error correction 2/3
[00000254] dvb access debug: forward error correction 3/4
[00000254] dvb access debug: forward error correction 5/6
[00000254] dvb access debug: forward error correction 7/8
[00000254] dvb access debug: forward error correction auto
[00000254] dvb access debug: card can do QPSK
[00000254] dvb access debug: card can do QAM 16
[00000254] dvb access debug: card can do QAM 64
[00000254] dvb access debug: card can do QAM auto
[00000254] dvb access debug: transmission mode auto
[00000254] dvb access debug: guard interval mode auto
[00000254] dvb access debug: hierarchy mode auto
[00000254] dvb access debug: card can recover from a cable unplug
[00000254] dvb access debug: End of capability list
[00000254] dvb access debug: trying to tune the frontend...
[00000254] dvb access debug: using inversion=2
[00000254] dvb access debug: using bandwidth=8
[00000254] dvb access debug: using fec=9
[00000254] dvb access debug: using fec=9
[00000254] dvb access debug: using transmission=0
[00000254] dvb access debug: using guard=0
[00000254] dvb access debug: using hierarchy=0
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/dvr0
[00000254] dvb access debug: setting filter on PAT
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/demux0
[00000254] dvb access debug: DMXSetFilter: DMX_PES_OTHER for PID 0
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/ca0
[00000254] dvb access warning: CAMInit: opening CAM device failed (No such device)
[00000254] main access debug: using access2 module "dvb"
[00000256] main private debug: pre buffering
status change: ( new input: dvb: )
status change: ( audio volume: 256 )
status change: ( play state: 1 )
[00000256] main private debug: received first data for our buffer
[00000256] main private debug: prebuffering done 376 bytes in 2s - 0 kbytes/s
[00000251] main input debug: creating demux: access='dvb' demux='' path=''
[00000257] main demuxer debug: looking for demux2 module: 40 candidates
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/demux0
[00000254] dvb access debug: DMXSetFilter: DMX_PES_OTHER for PID 17
[00000254] dvb access debug: Opening device /dev/dvb/adapter0/demux0
[00000254] dvb access debug: DMXSetFilter: DMX_PES_OTHER for PID 18
[00000257] main demuxer debug: using demux2 module "ts"
[00000251] main input debug: looking for a subtitle file in /home/mpujos/build/vlc/bin/
[00000257] ts demuxer debug: DEMUX_SET_GROUP 320 (nil)
[00000254] dvb access warning: unimplemented query in control
[00000251] main input debug: `dvb:' successfully opened
libdvbpsi error (PSI decoder): TS discontinuity (received 11, expected 0) for PID 0
[00000257] ts demuxer debug: PATCallBack called
[00000257] ts demuxer debug: new PAT ts_id=1 version=2 current_next=1
[00000257] ts demuxer debug: * number=0 pid=16
[00000257] ts demuxer debug: * number=257 pid=110
[00000257] ts demuxer debug: * number=259 pid=410
[00000257] ts demuxer debug: * number=260 pid=310
[00000257] ts demuxer debug: * number=261 pid=510
[00000257] ts demuxer debug: * number=262 pid=610
[00000257] ts demuxer debug: * number=274 pid=210
[00000257] ts demuxer debug: * number=511 pid=1010
libdvbpsi error (PSI decoder): TS discontinuity (received 12, expected 0) for PID 18
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x101(257)
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x103(259)
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x104(260)
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x105(261)
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x106(262)
[00000257] ts demuxer debug: PSINewTableCallBack: table 0x4e(78) ext=0x112(274)
[00000257] ts demuxer debug: EITCallBack called
[00000257] ts demuxer debug: new EIT service_id=257 version=15 current_next=1 ts_id=1 network_id=8442 segment_last_section_number=1 last_table_id=78
[00000257] ts demuxer debug: * event id=30517 start_time:mjd=53867 07:30:00 duration=01:20:00 running=4 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'C'est au programme' : 'Magazine de société.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000257] ts demuxer debug: * event id=30518 start_time:mjd=53867 08:50:00 duration=00:10:00 running=1 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Flash info' : 'Journal.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000251] main input debug: EsOutProgramMeta: number=257
[00000251] main input debug: - Event 30517 = 07:30:00: C'est au programme (+01:20:00) Magazine de société. ()
[00000251] main input debug: - Now Playing = C'est au programme
[00000251] main input debug: - Event 30518 = 08:50:00: Flash info (+00:10:00) Journal. ()
[00000257] ts demuxer debug: EITCallBack called
[00000257] ts demuxer debug: new EIT service_id=259 version=2 current_next=1 ts_id=1 network_id=8442 segment_last_section_number=1 last_table_id=78
[00000257] ts demuxer debug: * event id=30671 start_time:mjd=53867 07:55:00 duration=00:30:00 running=4 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Age sensible' : '«Fausse excuse». Série sentimentale. 2001. Saison 1. 4/28.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000257] ts demuxer debug: * event id=30672 start_time:mjd=53867 08:25:00 duration=00:25:00 running=1 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Blague à part' : '«Bucky». Série humoristique. 1998. Saison 1. 4/20.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000251] main input debug: EsOutProgramMeta: number=259
[00000251] main input debug: - Event 30671 = 07:55:00: Age sensible (+00:30:00) «Fausse excuse». Série sentimentale. 2001. Saison 1. 4/28. ()
[00000251] main input debug: - Now Playing = Age sensible
[00000251] main input debug: - Event 30672 = 08:25:00: Blague à part (+00:25:00) «Bucky». Série humoristique. 1998. Saison 1. 4/20. ()
[00000257] ts demuxer debug: EITCallBack called
[00000257] ts demuxer debug: new EIT service_id=260 version=18 current_next=1 ts_id=1 network_id=8442 segment_last_section_number=1 last_table_id=78
[00000257] ts demuxer debug: * event id=30723 start_time:mjd=53867 07:00:00 duration=01:33:00 running=4 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Les maternelles' : 'Magazine de société.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000257] ts demuxer debug: * event id=30724 start_time:mjd=53867 08:33:00 duration=00:02:00 running=1 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Mon bébé et moi' : 'Magazine de la santé.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000251] main input debug: EsOutProgramMeta: number=260
[00000251] main input debug: - Event 30723 = 07:00:00: Les maternelles (+01:33:00) Magazine de société. ()
[00000251] main input debug: - Now Playing = Les maternelles
[00000251] main input debug: - Event 30724 = 08:33:00: Mon bébé et moi (+00:02:00) Magazine de la santé. ()
[00000257] ts demuxer debug: EITCallBack called
[00000257] ts demuxer debug: new EIT service_id=261 version=15 current_next=1 ts_id=1 network_id=8442 segment_last_section_number=1 last_table_id=78
[00000257] ts demuxer debug: * event id=30788 start_time:mjd=53867 07:55:00 duration=00:30:00 running=4 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Memoquiz' : 'Jeu.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000257] ts demuxer debug: * event id=30789 start_time:mjd=53867 08:25:00 duration=00:10:00 running=1 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Le dessous des cartes' : '«Peuples : de la richesse et de la fragilité». Magazine de géopolitique.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000251] main input debug: EsOutProgramMeta: number=261
[00000251] main input debug: - Event 30788 = 07:55:00: Memoquiz (+00:30:00) Jeu. ()
[00000251] main input debug: - Now Playing = Memoquiz
[00000251] main input debug: - Event 30789 = 08:25:00: Le dessous des cartes (+00:10:00) «Peuples : de la richesse et de la fragilité». Magazine de géopolitique. ()
[00000257] ts demuxer debug: EITCallBack called
[00000257] ts demuxer debug: new EIT service_id=262 version=6 current_next=1 ts_id=1 network_id=8442 segment_last_section_number=1 last_table_id=78
[00000257] ts demuxer debug: * event id=30857 start_time:mjd=53867 07:30:00 duration=01:05:00 running=4 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'Les travaux de l'Assemblée nationale' : 'Débat parlementaire.'
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x50(80)
[00000257] ts demuxer debug: - tag=0x55(85)
[00000257] ts demuxer debug: - tag=0x54(84)
[00000257] ts demuxer debug: * event id=30858 start_time:mjd=53867 08:35:00 duration=01:25:00 running=1 free_ca=0
[00000257] ts demuxer debug: - short event lang=fre 'En commission au Sénat' : '«Mission d'information sur les quartiers difficiles». Débat parlementaire.'