First attempt - is drive locked? [solved]

Message

skeptic_always · #1 Post by **skeptic_always** » Fri Jan 08, 2010 5:00 pm

[ Solved by updating firmware for my blu-ray drive (Liteon DH-401S). ]

I own exactly one blu-ray movie, Live Free or Die Hard. It's the only BR movie to be put in my BR drive, but when I try to open the disk with MakeMKV 1.4.11 beta I get this (from the log file):

Code: Select all

Debug log started at Fri Jan  8 16:18:04 2010 , written by MakeMKV v1.4.11 beta linux(x86-release)                      
001014:000000:0000 MakeMKV v1.4.11 beta linux(x86-release) started                                                      
001013:000000:0000 Debug logging enabled, log will be saved as /home/user/MakeMKV_log.txt                               
001012:000000:0020 DEBUG: Code 256 at qK*K.cv80{` /,B; xS9R:29394942                                                    
001012:000000:0020 DEBUG: Code 256 at qK*K.cv80{` /,B; xS9R:29394942                                                    
003010:000000:0000 Using direct disc access mode                                                                        
001012:000000:0020 DEBUG: Code 256 at qK*K.cv80{` /,B; xS9R:29394942                                                    
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured
 while issuing SCSI command to device 'SG:dev_11:1'                                                                          
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:29394344                                                            
001012:000000:0020 DEBUG: Code 0 at ?]=L2Bca-]"|qiT2bf:121261727                                                             
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured
 while issuing SCSI command to device 'SG:dev_11:1'                                                                          
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:29394344                                                            
001012:000000:0020 DEBUG: Code 1 at ?]=L2Bca-]"|qiT2bf:121261727                                                             
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured
 while issuing SCSI command to device 'SG:dev_11:1'                                                                          
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:29394344                                                            
001012:000000:0020 DEBUG: Code 2 at ?]=L2Bca-]"|qiT2bf:121261727                                                             
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured
 while issuing SCSI command to device 'SG:dev_11:1'                                                                          
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:29394344                                                            
001012:000000:0020 DEBUG: Code 3 at ?]=L2Bca-]"|qiT2bf:121261727                                                             
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured
 while issuing SCSI command to device 'SG:dev_11:1'                                                                          
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:29394344                                                            
001012:000000:0020 DEBUG: Code 4 at ?]=L2Bca-]"|qiT2bf:121261727                                                             
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured
 while issuing SCSI command to device 'SG:dev_11:1'                                                                          
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:29394344                                                            
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - KEY NOT ESTABLISHED' occured wh
ile issuing SCSI command to device 'SG:dev_11:1'                                                                             
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:121262026                                                           
001012:000000:0020 DEBUG: Code 0 at ?]=L2Bca-]"|qiT2bf:121261727                                                             
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured
 while issuing SCSI command to device 'SG:dev_11:1'                                                                          
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:29394344                                                            
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - KEY NOT ESTABLISHED' occured wh
ile issuing SCSI command to device 'SG:dev_11:1'                                                                             
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:121262026
001012:000000:0020 DEBUG: Code 1 at ?]=L2Bca-]"|qiT2bf:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured
 while issuing SCSI command to device 'SG:dev_11:1'
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:29394344
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - KEY NOT ESTABLISHED' occured wh
ile issuing SCSI command to device 'SG:dev_11:1'
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:121262026
001012:000000:0020 DEBUG: Code 2 at ?]=L2Bca-]"|qiT2bf:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured
 while issuing SCSI command to device 'SG:dev_11:1'
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:29394344
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - KEY NOT ESTABLISHED' occured wh
ile issuing SCSI command to device 'SG:dev_11:1'
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:121262026
001012:000000:0020 DEBUG: Code 3 at ?]=L2Bca-]"|qiT2bf:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured
 while issuing SCSI command to device 'SG:dev_11:1'
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:29394344
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - KEY NOT ESTABLISHED' occured wh
ile issuing SCSI command to device 'SG:dev_11:1'
001012:000000:0020 DEBUG: Code 0 at Zbo*.3IMI$\P=)HtDmXg:121262026
001012:000000:0020 DEBUG: Code 4 at ?]=L2Bca-]"|qiT2bf:121261727
003311:000000:0000 Can't read AACS VID from disc - most likely current AACS host certificate is revoked by your drive
003302:000000:0000 The volume key is unknown for this disc - video can't be decrypted
001012:000000:0020 DEBUG: Code 0 at ?iuK/E)CG)TOA9 t~gK:121263015
001012:000000:0020 DEBUG: Code 0 at ?iuK/E)CG)TOA9 t~gK:213132721
005010:000000:0000 Failed to open disc

I tried running it as myself as well as root (sudo). It was released in '07 so I don't see how it could have revoked the AACS host certificate??? If it makes a difference, it is a BD+ movie.

theophile · #2 Post by **theophile** » Sat Jan 09, 2010 5:55 am

I'm getting a similar error from three different BD discs I've tried. I'm a newcomer to this "scene" but I'm fairly handy with Linux. Have tried running as root to no avail. My debug log is this:

Code: Select all

Debug log started at Sat Jan  9 05:42:07 2010 , written by MakeMKV v1.4.11 beta linux(x64-release)
001014:000000:0000 MakeMKV v1.4.11 beta linux(x64-release) started
001013:000000:0000 Debug logging enabled, log will be saved as /root/MakeMKV_log.txt
001012:000000:0020 DEBUG: Code 256 at hU9bI67c}EHVoVe_kI.d(:29394942
003010:000000:0000 Using direct disc access mode
001012:000000:0020 DEBUG: Code 256 at hU9bI67c}EHVoVe_kI.d(:29394942
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:29394344
001012:000000:0020 DEBUG: Code 0 at oGp,#J`nWnOmh3*|.[:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:29394344
001012:000000:0020 DEBUG: Code 1 at oGp,#J`nWnOmh3*|.[:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:29394344
001012:000000:0020 DEBUG: Code 2 at oGp,#J`nWnOmh3*|.[:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:29394344
001012:000000:0020 DEBUG: Code 3 at oGp,#J`nWnOmh3*|.[:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:29394344
001012:000000:0020 DEBUG: Code 4 at oGp,#J`nWnOmh3*|.[:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:29394344
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - KEY NOT ESTABLISHED' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:121262026
001012:000000:0020 DEBUG: Code 0 at oGp,#J`nWnOmh3*|.[:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:29394344
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - KEY NOT ESTABLISHED' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:121262026
001012:000000:0020 DEBUG: Code 1 at oGp,#J`nWnOmh3*|.[:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:29394344
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - KEY NOT ESTABLISHED' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:121262026
001012:000000:0020 DEBUG: Code 2 at oGp,#J`nWnOmh3*|.[:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:29394344
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - KEY NOT ESTABLISHED' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:121262026
001012:000000:0020 DEBUG: Code 3 at oGp,#J`nWnOmh3*|.[:121261727
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - AUTHENTICATION FAILURE' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:29394344
002014:000000:0000 Error 'Scsi error - ILLEGAL REQUEST:COPY PROTECTION KEY EXCHANGE FAILURE - KEY NOT ESTABLISHED' occured while issuing SCSI command to device 'SG:dev_11:0'
001012:000000:0020 DEBUG: Code 0 at u'Wv"eC__h*1w^P6Nqi,:121262026
001012:000000:0020 DEBUG: Code 4 at oGp,#J`nWnOmh3*|.[:121261727
003311:000000:0000 Can't read AACS VID from disc - most likely current AACS host certificate is revoked by your drive
003302:000000:0000 The volume key is unknown for this disc - video can't be decrypted
001012:000000:0020 DEBUG: Code 0 at )`{#h~L[K+b6y0LG`/,:121263015
001012:000000:0020 DEBUG: Code 0 at )`{#h~L[K+b6y0LG`/,:213132721
005010:000000:0000 Failed to open disc
Application exited at Sat Jan  9 05:43:28 2010

Are we in the same boat?

skeptic_always · #3 Post by **skeptic_always** » Sat Jan 09, 2010 7:46 pm

theophile wrote:I'm getting a similar error from three different BD discs I've tried. I'm a newcomer to this "scene" but I'm fairly handy with Linux. Have tried running as root to no avail. My debug log is this:
<snip>
Are we in the same boat?

As this is my first exposure to MakeMKV I don't know what I should be looking for in the debug, but a casual glance says yes, we have the same problem. I admit I'm not well versed in blu-ray protection, key revocation, etc. but it doesn't seem likely to me that a host certificate has been revoked.

Not sure it helps, but I did try DVDFab in windows (desktop is dual boot). It was able to create an ISO without complaint, but I am unable to watch the iso.

theophile · #4 Post by **theophile** » Sat Jan 09, 2010 9:15 pm

I've been playing around some more and installed Windows 7 in a VM (using VirtualBox) on the same machine. Using AnyDVD HD in Windows, I have been able to decrypt and rip every BD I've thrown at it, but I still get this error from MakeMKV. I'm also trying to get the Windows version of MakeMKV to work in the VM but so far it hangs while scanning the drives. I'm still tinkering...

skeptic_always · #5 Post by **skeptic_always** » Sun Jan 10, 2010 11:40 pm

Quick update - Windows (windows 7) version of MakeMKV gives the same error. I downloaded and installed the demo versions of AnyDVD and PowerDVD. With anyDVD running and the powerDVD virtual drive fix box checked PowerDVD gives this error: "there is a disk with an unsupported format". However, I am able to browse to the stream directory and with SMPlayer (mplayer for windows) play the .m2ts file and watch the movie.

Also, with AnyDVD running I am able to run MakeMKV and rip the movie into a .mkv file just fine. Looks like my drive is just fine, but MakeMKV is unable to decrypt this movie. I'd be happy to post/e-mail more info on this if there is anything useful to provide.

#6 Post by **mike admin** » Mon Jan 11, 2010 9:55 am

Thank you for providing the log. It looks like a particular drive bug. What drive are you using?

theophile · #7 Post by **theophile** » Mon Jan 11, 2010 6:14 pm

My drive is a "Sunext BDROM V8402" revision "BH98". This drive was the OEM drive inside the Memorex 2511 standalone player. Due to terrible customer support by Memorex, there is a buggy firmware update for the 2511 that causes the unit to be irreparably bricked by newed Bluray discs. Nevertheless, the drive works great when connected to a computer and using AnyDVD HD.

This is a separate issue, but I'm also trying to figure out if there's a way to flash upgrade this firmware using Linux, since there is a more recent revision than BH98. "Sunext" is now owned by Broadcom so I will contact them and see what can be done. In the mean time, I have to assume that it is theoretically possible to make this drive work in Linux since it does work in Windows.

Thanks for your help!

skeptic_always · #8 Post by **skeptic_always** » Mon Jan 11, 2010 8:04 pm

Mine is a Liteon. I believe the model number is dh-401s. I will look to see if there is a firmware upgrade then report back if it makes any difference.

skeptic_always · #9 Post by **skeptic_always** » Mon Jan 11, 2010 11:11 pm

As AnyDVD allows me to rip/watch the movie I didn't think there was likely to be an issue with the drive. Much to my surprise, after updating firmware MakeMKV can rip the movie to .mkv in both Windows and Linux.

Fantastic job guys! I may actually buy blu-ray movies now.

theophile · #10 Post by **theophile** » Tue Jan 12, 2010 12:08 am

Bah, looks like I'm on my own now. I contacted Broadcom about a firmware update but I don't think that's going to happen since this is an OEM drive. Is it a revocation list problem that is solved by the firmware update? Am I completely out of luck with MakeMKV?

#11 Post by **mike admin** » Wed Jan 13, 2010 7:15 am

as it seems it is a drive firmware bug that manifests under rare conditions, and MakeMKV somehow creates these. We're trying to identify the problem but so far no luck.

theophile · #12 Post by **theophile** » Wed Jan 13, 2010 3:02 pm

Please let me know if there is anything I can do to help.

richwill · #13 Post by **richwill** » Wed Sep 07, 2011 3:54 pm

Is this issue related? If so, I don't mind running other tests, etc. The drive I'm using is an LG BD-RE BH10NS30 with the H102 firmware.

Here's the log I get no matter what BD disk I use. Interestingly enough, MakeMKV worked just fine on version 1.6.7 even with the same disk.

Debug log started at Wed Sep 7 11:28:13 2011 , written by MakeMKV v1.6.14 linux(x64-release)
Using 1048320KB for read cache.
001005:0000 MakeMKV v1.6.14 linux(x64-release) started
001004:0000 Debug logging enabled, log will be saved as /home/rich/MakeMKV_log.txt
001003:0020 DEBUG: Code 0 at iT=;<B?!PgGmTo`D:121261911
001003:0020 DEBUG: Code 0 at %H:d]`9`.\O!it:213130375
003006:0000 Opening files on harddrive at /dev/sr2
001003:0020 DEBUG: Code 2 at d"OWT;\=6 2yn67t3Aq/;>:121261658
001003:0020 DEBUG: Code 2 at d"OWT;\=6 2yn67t3Aq/;>:121261658
001003:0020 DEBUG: Code 0 at %,_WU9K&9VvMEIL&d:213130260
001003:0020 DEBUG: Code 0 at [QLHUYXI0V'q[L)8~:29394137
001003:0020 DEBUG: Code 2 at d"OWT;\=6 2yn67t3Aq/;>:121261658
005010:0000 Failed to open disc
Application exited at Wed Sep 7 11:28:29 2011

HTH

#14 Post by **mike admin** » Thu Sep 22, 2011 2:05 pm

Seems you're using invalid command line - do you use GUI or console app?

www.makemkv.com

First attempt - is drive locked? [solved]

First attempt - is drive locked? [solved]

Re: First attempt - is drive locked?

Re: First attempt - is drive locked?

Re: First attempt - is drive locked?

Re: First attempt - is drive locked?

Re: First attempt - is drive locked?

Re: First attempt - is drive locked?

Re: First attempt - is drive locked?

Re: First attempt - is drive locked?

Re: First attempt - is drive locked? [solved]

Re: First attempt - is drive locked? [solved]

Re: First attempt - is drive locked? [solved]

Re: First attempt - is drive locked? [solved]

Re: First attempt - is drive locked? [solved]