2010-06-27, 22:10
When starting a DVD I own (Mr. Show - Season 2), XBMC seemed to lock up. The screen went black and become unresponsive. Nearly ten minutes later, the DVD menu appeared. The problem appears to be an extremely long lag in libdvdread while retrieving the DVD keys. Any ideas why this would be happening?
My DVD player isn't automounting, so I'm manually mounting the disc and starting it by selecting the mount point in the Videos menu.
I can't rip this DVD in Brasero. It returns a "fatal error in vts css key" after just a few seconds. Apparently, it's giving up rather than waiting 10 minutes for the key.
XBMC version is 9.11 r26018 (aka 1:9.11-lucid2). libdvdread is 4.1.3-8ubuntu1.
Here's the portion of the log from the time I open the DVD to the time the last key is returned.
My DVD player isn't automounting, so I'm manually mounting the disc and starting it by selecting the mount point in the Videos menu.
I can't rip this DVD in Brasero. It returns a "fatal error in vts css key" after just a few seconds. Apparently, it's giving up rather than waiting 10 minutes for the key.
XBMC version is 9.11 r26018 (aka 1:9.11-lucid2). libdvdread is 4.1.3-8ubuntu1.
Here's the portion of the log from the time I open the DVD to the time the last key is returned.
Code:
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerCoreFactory::GetPlayers(/media/MRSHOW_SEASON2/VIDEO_TS/VIDEO_TS.IFO)
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: dvdfile
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: adding player: videodefaultdvdplayer (1) for rule: dvdfile
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerCoreFactory::GetPlayers: matched 1 rules with players
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
15:37:25 T:3024406400 M:3356049408 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
15:37:25 T:3024406400 M:3354906624 NOTICE: DVDPlayer: Opening: /media/MRSHOW_SEASON2/VIDEO_TS/VIDEO_TS.IFO
15:37:25 T:3024406400 M:3354906624 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
15:37:25 T:2773527408 M:3354906624 DEBUG: thread start, auto delete: 1
15:37:25 T:2765134704 M:3354906624 DEBUG: thread start, auto delete: 0
15:37:25 T:2765134704 M:3354906624 NOTICE: Creating InputStream
15:37:25 T:2765134704 M:3354906624 DEBUG: Loading: /usr/share/xbmc/system/players/dvdplayer/libdvdnav-i486-linux.so
15:37:25 T:2765134704 M:3354906624 INFO: msg: libdvdnav: Using dvdnav version 4.1.3
15:37:25 T:2765134704 M:3354906624 INFO: msg: libdvdread: Using libdvdcss version 1.2.10 for DVD access
15:37:25 T:2765134704 M:3354906624 INFO: dll_fopen - something opened the mount file, let's hope it knows what it's doing
15:37:25 T:2765134704 M:3354906624 INFO: msg: libdvdread: Attempting to use device /dev/sr0 mounted on /media/MRSHOW_SEASON2 for CSS authentication
15:37:25 T:2765134704 M:3354779648 INFO: msg: libdvdnav: vm: DVD Title: MRSHOW_SEASON2
15:37:25 T:2765134704 M:3354779648 INFO: msg: libdvdnav: Unable to find map file '/home/chris/.dvdnav/MRSHOW_SEASON2.map'
15:37:25 T:2765134704 M:3354779648 INFO: msg: libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions:
15:37:25 T:2765134704 M:3354779648 INFO: msg: 1
15:37:25 T:2765134704 M:3354779648 INFO: msg:
15:37:25 T:2765134704 M:3354779648 INFO: msg:
15:37:25 T:2765134704 M:3354779648 INFO: msg: libdvdread: Attempting to retrieve all CSS keys
15:37:25 T:2765134704 M:3354779648 INFO: msg: libdvdread: This can take a _long_ time, please be patient
15:37:25 T:2765134704 M:3354779648 INFO: msg: libdvdread: Get key for /VIDEO_TS/VIDEO_TS.VOB at 0x00000127
15:37:25 T:2765134704 M:3354779648 INFO: msg: libdvdread: Elapsed time 0
15:37:25 T:2765134704 M:3354779648 INFO: msg: libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x0001e852
15:37:25 T:2765134704 M:3354779648 INFO: msg: libdvdread: Elapsed time 0
15:37:25 T:2765134704 M:3354779648 INFO: msg: libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0001e944
15:37:25 T:2765134704 M:3354779648 WARNING: dll_ioctl - 21394 request failed with error [5] Input/output error
15:37:25 T:2765134704 M:3354779648 WARNING: dll_ioctl - 21394 request failed with error [5] Input/output error
15:37:28 T:2773527408 M:3354206208 INFO: Loading skin file: DialogProgress.xml
15:37:28 T:2773527408 M:3354206208 DEBUG: Load DialogProgress.xml: 2.17ms
15:37:28 T:2773527408 M:3354206208 DEBUG: ------ Window Init (DialogProgress.xml) ------
15:37:28 T:2773527408 M:3354206208 DEBUG: Alloc resources: 0.13ms (0.00 ms skin load)
15:37:47 T:2942925680 M:3354243072 DEBUG: Thread 2942925680 terminating (autodelete)
15:37:48 T:2969549680 M:3354255360 DEBUG: Thread 2969549680 terminating (autodelete)
15:37:52 T:3003120496 M:3354304512 DEBUG: Thread 3003120496 terminating (autodelete)
15:47:06 T:2765134704 M:3280453632 INFO: msg: libdvdread: Elapsed time 581
15:47:06 T:2765134704 M:3280453632 INFO: msg: libdvdread: Found 1 VTS's
15:47:06 T:2765134704 M:3280453632 INFO: msg: libdvdread: Elapsed time 581