Reboot Loop -- logs attatched --bad hardware - (not harddrive?)

[dcbarry]

All:

I was out of town for awhile, and came home to find my Tivo HD in a reboot loop. The machine has a hacked PROM, and the CCI patch applied. My initial thought was that an update had come down, and I was not prepared. It had been rebooting for at least a week.

However, turns out that was not the case. I've taken a virgin image from a never booted TivoHD with 9.4 software using WinMFS. However, despite multiple attempts, the machine continues to reboot, during Stage F.

I've attached the same (re-applied) virgin image on the same HD to another HD box that is also PROM hacked. The only difference is the "bad box" is a Fusion Revision 4 box, the "good box" is Fusion Revision 5 or later. This rev5 box box boots normally, and proceeds to the User startup pages. So, we can eliminate bad hard drive as the hardware.

There is no "obvious" failure in the logs. EDIT: See post 3 ... with 11g software, there is an error to review... and it sounds ugly. I am attatching the full logs ("good boot" and "bad boot"). Within this message, just for quick persusal, I'm attaching the segments for the logs that show where the "bad boot" dies by using the good boot. (In other words, other than the time stamp, minor timing differences and the service number of the box, I' showing you where the "bad hardware" dies.) Also to note, that the box "dies" at the same point reliably and consistantly.


Again, full logs are attached.....



(EDIT: need to split over two messages due to length)






kernel:

Jun 29 07:16:51 (none) kernel: Drive bandwidth seems acceptable
Jun 29 07:16:51 (none) kernel: Performing basic S.M.A.R.T. checks
Jun 29 07:16:51 (none) kernel: This can cause DriveStatusError messages in some cases... don't worry.
Jun 29 07:16:51 (none) kernel: Checking /dev/hda
Jun 29 07:16:51 (none) kernel: S.M.A.R.T. pass on /dev/hda
Jun 29 07:16:51 (none) kernel: No forensic selected
Jun 29 07:16:51 (none) kernel: Scanning for phase3 repair scripts
Jun 29 07:16:51 (none) kernel: Running boot Stage F_ApplicationLaunch scripts
Jun 29 07:16:51 (none) kernel: Starting Services.
>>>>>>>> "BAD BOOT" ENDS WITH THIS LINE <<<<<<<<<<<

Jun 29 07:18:52 (none) kernel: [TV_BCMDISPLAY_SET_VIDEO_OUTPUT_MODE] mode=1
Jun 29 07:18:52 (none) kernel: FIRMWARE: Got standby mode update. Standby: NO
Jun 29 07:19:02 (none) kernel: Video feed not attached or on during construction
Jun 29 07:19:02 (none) kernel: [TV_BCMDISPLAY_SET_VIDEO_OUTPUT_MODE] mode=1
Jun 29 07:19:03 (none)
Jun 29 07:19:03 (none) kernel: [TV_BCMDISPLAY_SET_VIDEO_OUTPUT_MODE] mode=1
Jun 29 07:19:07 (none) kernel: Tuner lock acquired






TVLOG:


Jun 29 07:17:11 (none) dbcache[314]: Creating dbcache in program myworld, size = 200
Jun 29 07:17:13 (none) TmkInit[314]: 2.081 seconds: start DbBillboardUtil
Jun 29 07:17:17 (none) TmkInit[314]: 3.831 seconds: start TvSettingsCommonService
Jun 29 07:17:17 (none) TmkActivityManager[314]: Activity High Water Mark: 10
Jun 29 07:17:17 (none) TmkActivityManager[314]: Activity High Water Mark: 20
Jun 29 07:17:17 (none) DbQueryCacheManager[314]: Creating DbQueryCacheManager in program myworld
Jun 29 07:17:17 (none) DbStationDayCache[329]: Directory scan took 0 seconds err = 0x0
Jun 29 07:17:17 (none) DbStationDayCache[329]: Allocated:0 Size:0
Jun 29 07:17:17 (none) DbNowShowingBucketList.C[314]: (130) Create
Jun 29 07:17:17 (none) DbNowShowingBucketList.C[314]: (148) CreateNoRetry strDir=/Recording/NowShowingByBucketTitle
Jun 29 07:17:17 (none) DbFilteredNowShowingBucketList.C[314]: (87) Create
Jun 29 07:17:17 (none) DbFilteredNowShowingBucketList.C[314]: (105) CreateNoRetry strDir=/Recording/NowShowingByFlatTitle
Jun 29 07:17:18 (none) TvSetupSignalSourceQueryServer[314]: TvSetupSignalSourceQueryServer started.
Jun 29 07:17:18 (none) TmkActivityManager[314]: Activity High Water Mark: 30
Jun 29 07:17:23 (none) DbRecordingList.C[329]: (496) Expand nAllocatedM=0 -> nToAllocate=25, freeK =4493
Jun 29 07:17:23 (none) TmkMempool[329]: STAT myworld: blocks=2552 bytes=96856 bytesMax=96920 unusedBytes=4600976 chunks=4 chunkBytes=3584 freeChunks=0 freeChunkBytes=0 maxFreeChunk=4591344
Jun 29 07:17:23 (none) DbRecordingList.C[329]: (539) Expand End, freeK =4491
Jun 29 07:17:23 (none) TmkMempool[329]: STAT myworld: blocks=2553 bytes=98360 bytesMax=98392 unusedBytes=4599464 chunks=4 chunkBytes=3584 freeChunks=0 freeChunkBytes=0 maxFreeChunk=4589832
Jun 29 07:17:23 (none) DbNowShowingBucketList.C[329]: (1010) Dump this=0x5eca6bb0 items=5 Nodes=2 pDirM=/Recording/NowShowingByBucketTitle
Jun 29 07:17:23 (none) DbFilteredNowShowingBucketList.C[329]: (246) DbFilteredNowShowingBucketList::PreLoadDirectory
Jun 29 07:17:23 (none) DbFilteredNowShowingBucketList.C[329]: (489) DbFilteredNowShowingBucketList::PostLoadDirectory
Jun 29 07:17:23 (none) DbFilteredNowShowingBucketList.C[329]: (558) Dump this=0x5eca6cd8 items=1 pDirM=/Recording/NowShowingByFlatTitle
Jun 29 07:17:28 (none) DbFilteredNowShowingBucketList.C[329]: (246) DbFilteredNowShowingBucketList::PreLoadDirectory
Jun 29 07:17:28 (none) DbFilteredNowShowingBucketList.C[329]: (489) DbFilteredNowShowingBucketList::PostLoadDirectory
Jun 29 07:17:28 (none) DbFilteredNowShowingBucketList.C[329]: (558) Dump this=0x5eca6cd8 items=1 pDirM=/Recording/NowShowingByFlatTitle
>>>>>>>> "BAD BOOT" ENDS WITH THIS LINE <<<<<<<<<<<

Jun 29 07:18:51 (none) TmkInit[314]: 93.801 seconds: start TvCryptoManager
Jun 29 07:18:52 (none) mediamgr[314]: Create mom mempool os size 9011200 (0x5e0c0000)
Jun 29 07:18:52 (none) mediamgr[314]: Creating a secure mempool for MOM os size 163840
Jun 29 07:18:52 (none) momglobals.C[314]: Creating 39 buffers of contigmem for encryption
Jun 29 07:18:52 (none) MOMGlobals[314]: TMK_DEBUGGER=not sleep
Jun 29 07:18:52 (none) TvMediaNetworkModule.C[314]: Created
Jun 29 07:18:52 (none) TmkActivityManager[314]: Activity High Water Mark: 40
Jun 29 07:18:52 (none) TvDbGenreMapperTivo[333]: Updating Genre Cache
Jun 29 07:18:52 (none) TvVideoGuts[330]: Setting video policy to TempTogglePolicy
Jun 29 07:18:52 (none) TvVideoGuts[330]: Setting network policy to SharedPolicy
Jun 29 07:18:52 (none) TvVideoClosedCaptionControlServe[330]: VideoClosedCaptionControlServer started.
Jun 29 07:18:52 (none) QeConsole[335]: FIRMWARE: Got standby mode update. Standby: NO





TVERR:

Jun 29 07:16:59 (none) GetListOfKeys[246]: failed to get keys after 10 tries
>>>>>>>> "BAD BOOT" ENDS WITH THIS LINE <<<<<<<<<<<

Jun 29 07:17:04 (none) last message repeated 4 times
Jun 29 07:18:57 (none) GetListOfKeys[335]: failed to get keys after 10 tries
Jun 29 07:19:02 (none) scheduler[380]: Not allowed to schedule this network explicit, refused control: 101
Jun 29 07:19:02 (none) Scheduler[380]: Error 0x2e0069: TvSchedulerSingleNetworkRequestHandler.C line 146
Jun 29 07:21:15 (none) Scheduler[327]: Error 0xffff: HandleDataChangedChore.C line 326
Jun 29 07:21:30 (none) Scheduler[357]: Error 0xffff: HandleDataChangedChore.C line 326



SVCLOG --- is identical except for the time and TIVOID#





CONTINUED ON NEXT POST

[dcbarry]

Messages:

==> these lines have a slight variation, probabbly due to the board revision?????


Jan 2 00:01:02 (none) syslogd 1.3-3: restart.
Jun 29 07:16:32 (none) Stats: == System startup resource statistics ==
Jun 29 07:16:32 (none) Stats: ++ System build version numbers ++
Jun 29 07:16:32 (none) Stats: b-9-4-mr @308179 2008.07.30-2010 release-mips [] ARM_IDL_FREEZE CDDB_QUERY DCT_SERIAL DSS_SERIAL HPK IDL_FREEZE IRBLAST LOCAL_CALYPSO_SERVER LOCAL_MP3_PLAYER LOCAL_MUSIC_PLAYER LOCAL_PHOTO_VIEWER LOCAL_WMA_PLAYER MACROVISION MULTI_ROOM_VIEWING PERF_LOGGER PERF_LOGGER_USER_STATS PTHREADS_TMK REQUIRE_PRODUCTION_SPIGOT_LINEAGE SANITIZE_LOGS STRONG_CRYPTO T2KSOURCE US_CABLE_AUTO_DETECT
Jun 29 07:16:32 (none) Stats: 2008.07.30-2010 9.4b-01-2
Jun 29 07:16:32 (none) Stats: PROM version: TiVo/mips/Gen06/rel version v1.05-rel_C1
Jun 29 07:16:32 (none) Stats: !! Computed SHA1 doesn't match stored SHA1 !! Computed SHA1: 0x0D2A3758F682A0FB80D2D3040C446297FB5970F7 Stored SHA1: 0x8AB1DBA538DB7E33B8B7DCE592EBD35CAE38A4FE File length: 74372 Stored length: 74372 Build type: TiVo/mips/Gen06/rel Marked version: v1.05-rel_C1
Jun 29 07:16:32 (none) Stats: System Serial Number: 6520001804933E9
Jun 29 07:16:32 (none) Stats: Linux version 2.4.20 (build@buildmaster78) (gcc version 3.3.4) #1 Wed Jul 30 20:20:59 PDT 2008
Jun 29 07:16:32 (none) Stats: ++ Memory usage ++
Jun 29 07:16:32 (none) Stats: total: used: free: shared: buffers: cached:
----> Jun 29 07:16:32 (none) Stats: Mem: 130539520 65474560 65064960 0 1998848 32563200
Jun 29 07:16:32 (none) Stats: Swap: 133881856 0 133881856
Jun 29 07:16:32 (none) Stats: MemTotal: 127480 kB
====> Jun 29 07:16:32 (none) Stats: MemFree: 63540 kB
Jun 29 07:16:32 (none) Stats: MemShared: 0 kB
Jun 29 07:16:32 (none) Stats: Buffers: 1952 kB
Jun 29 07:16:32 (none) Stats: Cached: 31800 kB
Jun 29 07:16:32 (none) Stats: SwapCached: 0 kB
Jun 29 07:16:32 (none) Stats: PriActive 0 kB
Jun 29 07:16:32 (none) Stats: Active: 8996 kB
Jun 29 07:16:32 (none) Stats: Inactive: 28784 kB
Jun 29 07:16:32 (none) Stats: HighTotal: 0 kB
Jun 29 07:16:32 (none) Stats: HighFree: 0 kB
Jun 29 07:16:32 (none) Stats: LowTotal: 127480 kB
-----> Jun 29 07:16:32 (none) Stats: LowFree: 63540 kB
Jun 29 07:16:32 (none) Stats: SwapTotal: 130744 kB
Jun 29 07:16:32 (none) Stats: SwapFree: 130744 kB
Jun 29 07:16:32 (none) Stats: ++ CPU info ++
Jun 29 07:16:32 (none) Stats: system type^I^I: TiVo Fusion board
Jun 29 07:16:32 (none) Stats: processor^I^I: 0
Jun 29 07:16:32 (none) Stats: cpu model^I^I: BMIPS4000 V0.0
Jun 29 07:16:32 (none) Stats: BogoMIPS^I^I: 296.55
Jun 29 07:16:32 (none) Stats: wait instruction^I: yes
Jun 29 07:16:32 (none) Stats: microsecond timers^I: yes
Jun 29 07:16:32 (none) Stats: tlb_entries^I^I: 32
Jun 29 07:16:32 (none) Stats: extra interrupt vector^I: yes
Jun 29 07:16:32 (none) Stats: hardware watchpoint^I: no
------> Jun 29 07:16:32 (none) Stats: spurious interrupts^I: 285
Jun 29 07:16:32 (none) Stats: unaligned access^I: 6
-----> Jun 29 07:16:32 (none) Stats: cycle counter frequency^I: 148687500
Jun 29 07:16:32 (none) Stats: ++ Module info ++
Jun 29 07:16:32 (none) Stats: bcmenet 15472 0 (unused)
Jun 29 07:16:32 (none) Stats: router 67984 2
Jun 29 07:16:32 (none) Stats: ubuddy 5216 0
Jun 29 07:16:32 (none) Stats: mpod 22112 4
Jun 29 07:16:32 (none) Stats: bcm7401_C1 2998992 8
Jun 29 07:16:32 (none) Stats: tr 4032 2
Jun 29 07:16:32 (none) Stats: xcode2drv 3517760 8
Jun 29 07:16:32 (none) Stats: ati314_Gen06 118664 16
Jun 29 07:16:32 (none) Stats: ircatch_Gen06 18192 0
Jun 29 07:16:32 (none) Stats: frontpanel 2864 0 [ircatch_Gen06]
Jun 29 07:16:32 (none) Stats: i2c2 10992 2 [ubuddy ati314_Gen06]
Jun 29 07:16:32 (none) Stats: modemtty_Gen06 5664 0
Jun 29 07:16:32 (none) Stats: bcmtty_Gen06 4496 0
Jun 29 07:16:32 (none) Stats: gpio 4992 0 [mpod bcm7401_C1 ati314_Gen06 modemtty_Gen06]
Jun 29 07:16:32 (none) Stats: tivoconfig 944 0 (unused)
Jun 29 07:16:32 (none) Stats: ++ Device info ++
Jun 29 07:16:32 (none) Stats: Character devices:
Jun 29 07:16:32 (none) Stats: 1 mem
Jun 29 07:16:32 (none) Stats: 2 pty
Jun 29 07:16:32 (none) Stats: 3 ttyp
Jun 29 07:16:32 (none) Stats: 4 ttyS
Jun 29 07:16:32 (none) Stats: 5 cua
Jun 29 07:16:32 (none) Stats: 10 misc
Jun 29 07:16:32 (none) Stats: 30 tvbcmdriver
Jun 29 07:16:32 (none) Stats: 91 tivoconfig
Jun 29 07:16:32 (none) Stats: 97 ubuddy
Jun 29 07:16:32 (none) Stats: 99 i2c
Jun 29 07:16:32 (none) Stats: 104 router
Jun 29 07:16:32 (none) Stats: 108 ppp
Jun 29 07:16:32 (none) Stats: 111 pod
Jun 29 07:16:32 (none) Stats: 112 ati
Jun 29 07:16:33 (none) Stats: 114 tr
Jun 29 07:16:33 (none) Stats: 120 boxster
Jun 29 07:16:33 (none) Stats: 127 ircatch
Jun 29 07:16:33 (none) Stats: 162 raw
Jun 29 07:16:33 (none) Stats: 180 usb
Jun 29 07:16:33 (none) Stats: 204 bcmsettopapi
Jun 29 07:16:33 (none) Stats: 242 fbuf
Jun 29 07:16:33 (none) Stats: 243 gioctl
Jun 29 07:16:33 (none) Stats: 246 gpio
Jun 29 07:16:33 (none) Stats: 247 frontpanel
Jun 29 07:16:33 (none) Stats:
Jun 29 07:16:33 (none) Stats: Block devices:
Jun 29 07:16:33 (none) Stats: 1 ramdisk
Jun 29 07:16:33 (none) Stats: 3 ide0
Jun 29 07:16:33 (none) Stats: ++ Network device info ++
Jun 29 07:16:33 (none) Stats: Inter-| Receive | Transmit
Jun 29 07:16:33 (none) Stats: face |bytes packets errs drop fifo frame compressed multicast|bytes packets errs drop fifo colls carrier compressed
Jun 29 07:16:33 (none) Stats: lo: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Jun 29 07:16:33 (none) Stats: eth0: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0


>>>>>>>> "BAD BOOT" ENDS WITH THIS LINE <<<<<<<<<<<



Jun 29 07:19:03 (none) syslogd: Cannot glue message parts together
Jun 29 07:19:03 (none) 134>Jun 29 07:19:03 swedishChef[388]: Command line 2575 bytes: CHDIR=/var/tmp/SiHost UID=00000 GID=00000 DEBUG_BOARD=false DEBUG_INTERFACE_NAME=none EMERGENCY_REINSTALL=0 HDA_ID=WD-WCAP92944814 HDB_ID=Unknown HOME=/ HOSTNAME=(none) HOSTTYPE=i686 IrdSerialNumber=534933E9 LD_LIBRARY_PATH=/lib MACHTYPE=i686-pc-linux-gnu MFS_DEVICE=/dev/hda10 MODEM_DEVICE=/dev/cua3 MODEM_REV=C MODEM_TYPE=Si2434 OSTYPE=linux-gnu PATH=/bin:/sbin:/tvbin PROMVERSION=\n\nTiVo/mips/Gen06/rel\ version\ v1.05-rel_C1 PWD=/ SHELL=/bin/sh SHLVL=1 SerialNumber=6520001804933E9 SwSystem=9.4b-01-2 TERM=linux TIVO_REMOTE=TIVO TIVO_ROOT= TV_LAUNCHER_APPLICATION_ID=0 TV_LAUNCHER_PROGRAM_ID=SiHost_Atlas TV_STD=NTSC _=/tvbin/TvLauncher hpk_implementation=Gen06 internal_drive=hda primary_drive=hda root=/dev/hda7 varpartition=/dev/hda9 SiHost -name SiHost_Atlas -provide silicon -provide soma_musicphoto -provide soma_nowplaying -provide soma_mainmenu -provide soma_setup -provide soma_dvdburning -provide soma_dvdcentral -provide soma_dvdcommon -provide
Jun 29 07:19:03 (none)
Jun 29 07:19:03 (none) syslogd: Cannot glue message parts together
Jun 29 07:19:03 (none) soma_dvdsetup -provide soma_pickprograms -provide soma_camcorder -provide soma_uicommon -provide soma_dvdplayback -provide soma_vcrplus -provide atlas_uicommon -provide atlas_cablecard -provide atlas_mainmenu -provide atlas_nowplaying -provide atlas_pickprograms -provide atlas_setup -provide atlas_settings -provide atlas_video -provide atlas_showcases -provide atlas_resolver -path /lib/plugins/uiscreens/silicon:/lib/plugins/uiscreens/soma_musicphoto:/lib/plugins/uiscreens/soma_nowplaying:/lib/plugins/uiscreens/soma_mainmenu:/lib/plugins/uiscreens/soma_setup:/lib/plugins/uiscreens/soma_dvdsetup:/lib/plugins/uiscreens/soma_pickprograms:/lib/plugins/uiscreens/soma_camcorder:/lib/plugins/uiscreens/soma_uicommon:/lib/plugins/uiscreens/soma_dvdburning:/lib/plugins/uiscreens/soma_dvdcommon:/lib/plugins/uiscreens/soma_dvdcentral:/lib/plugins/uiscreens/soma_dvdplayback:/lib/plugins/uiscreens/soma_vcrplus:/lib/plugins/uiscreens/atlas_uicommon:/lib/plugins/fsmmodules/atlas_uicommon:/lib/plugins/uiscreens/atlas_cablecar
Jun 29 07:19:03 (none) d:/lib/plugins/fsmmodules/atlas_cablecard:/lib/plugins/fsmmodules/atlas_mainmenu:/lib/plugins/fsmmodules/atlas_nowplaying:/lib/plugins/fsmmodules/atlas_setup:/lib/plugins/uiscreens/atlas_setup:/lib/plugins/fsmmodules/atlas_settings:/lib/plugins/uiscreens/atlas_settings:/lib/plugins/uiscreens/atlas_pickprograms:/lib/plugins/fsmmodules/atlas_pickprograms:/lib/plugins/uiscreens/atlas_video:/lib/plugins/fsmmodules/atlas_video:/lib/plugins/fsmmodules/atlas_showcases:/lib/plugins/uiscreens/atlas_showcases:/lib/plugins/uiscreens/atlas_resolver:/lib/plugins/fsmmodules/atlas_resolver -verbose
Jun 29 07:19:59 (none) init: Child process 15 stopped with status 0x0
Jun 29 07:19:59 (none) init: Change to level 3 complete

[dcbarry]

OK... further testing is disturbing.....

I decided to try to get 11g back on the box. Here's how I did it:

1) Re- Applied my virgin 9.4B Image W/ WINMFS
2) Booted it on the Good HD box... forced it to update to 11g
3) Performed a CD&E
4) Backed up the truncated imaged now w/ 11g (again via WinMFS)
5) Tested on the "good" HD box ... success.
6) Again, reapplied the 11g image
7) Booted on the bad box --- and back in the reboot loop.


Looks like this was a good idea, more clues .... but disturbing ones:





05:56:19 (none) kernel: Obliterating PlanetX datum (it obstructs my view of Venus)...
Jun 30 05:56:19 (none) kernel: Where's the KABOOM? There's supposed to be an Earth-shattering KABOOM!
Jun 30 05:56:19 (none) kernel: Scanning for phase3 repair scripts
Jun 30 05:56:19 (none) kernel: Running boot Stage F_ApplicationLaunch scripts
Jun 30 05:56:19 (none) kernel: Starting Services.
Jun 30 05:56:47 (none) kernel: scramblerkey: sn=025681006730/52342971ED12137B00/E is not owner=6520001804933E9/723884508AA912B812000000/E either
Jun 30 05:56:57 (none) last message repeated 4 times
Jun 30 05:56:57 (none) kernel: assert: TmkLogDebugAssertionFailure: false
Jun 30 05:56:57 (none) kernel: assert: TvStatus TvCryptoManager::SetupMasterKeysNoRetry(), line 796 (TvCryptoManager.C)
Jun 30 05:56:57 (none) kernel: assert: DecryptMachineKey failed
Jun 30 05:56:57 (none) kernel: assert: Backtrace: 0x04a8a27c 0x00888734 0x0074523c 0x0072d3f8 0x04a53ea0 0x04a60920 0x04a66578 0x04a582c8 0x0073e054 0x0079af58 0x007ce190 0x04813420 0x04812c14 0x00000000 0x00000000 0x00000000
Jun 30 05:57:44 (none) kernel: scramblerkey: sn=025681006730/52342971ED12137B00/E is not owner=6520001804933E9/723884508AA912B812000000/E either
Jun 30 05:57:55 (none) last message repeated 4 times
Jun 30 05:57:55 (none) kernel: assert: TmkLogDebugAssertionFailure: false
Jun 30 05:57:55 (none) kernel: assert: TvStatus TvCryptoManager::SetupMasterKeysNoRetry(), line 846 (TvCryptoManager.C)
Jun 30 05:57:55 (none) kernel: assert: DecryptMachineKey (sign) failed
Jun 30 05:57:55 (none) kernel: assert: Backtrace: 0x04a8a27c 0x00888668 0x0074523c 0x0072d3f8 0x04a53ea0 0x04a60920 0x04a66578 0x04a582c8 0x0073e054 0x0079af58 0x007ce190 0x04813420 0x04812c14 0x00000000 0x00000000 0x00000000
Jun 30 05:58:41 (none) kernel: scramblerkey: sn=025681006730/52342971ED12137B00/E is not owner=6520001804933E9/723884508AA912B812000000/E either
Jun 30 05:58:52 (none) last message repeated 4 times
Jun 30 05:58:52 (none) kernel: assert: TmkLogDebugAssertionFailure: false
Jun 30 05:58:52 (none) kernel: assert: TvStatus TvCryptoManager::SetupMasterKeysNoRetry(), line 896 (TvCryptoManager.C)
Jun 30 05:58:52 (none) kernel: assert: DecryptMachineKey (sign) failed
Jun 30 05:58:52 (none) kernel: assert: Backtrace: 0x04a8a27c 0x00888590 0x0074523c 0x0072d3f8 0x04a53ea0 0x04a60920 0x04a66578 0x04a582c8 0x0073e054 0x0079af58 0x007ce190 0x04813420 0x04812c14 0x00000000 0x00000000 0x00000000




I've seen only one other instance of this in the forum, but without detail as to why.

Just for the record, again, this box was PROM hacked (by me)... but there have been no attempts by me to alter the SN ..... but if I'm readng this right, it sure seems to be a SN mismatch of some kind.


The only other thing I can think of is that the C&DE step is not clearing enough???

[Jamie]

The scramblerkey errors are normal when you try to move a drive from one box to another. Clear and delete everything right before you move it.

[dcbarry]

Jaime:

That is what is so confusing. The image is from an Image that is post cd&e. admittedly, I was keeping some late hours, so I will give it one more try, but I am fairly certain I was applying a cleaned image.


Is there a known way to set the cd&e flag so it is forced at first boot? I've seen some reference to it in the code, but I am unclear what the triggering condition is.


Thanks,

D.

[AlphaWolf]

Jaime:

That is what is so confusing. The image is from an Image that is post cd&e. admittedly, I was keeping some late hours, so I will give it one more try, but I am fairly certain I was applying a cleaned image.


Is there a known way to set the cd&e flag so it is forced at first boot? I've seen some reference to it in the code, but I am unclear what the triggering condition is.


Thanks,

D.

/tvlib/tcl/tv/setzaprequestfactoryreset.tcl

[dcbarry]

/tvlib/tcl/tv/setzaprequestfactoryreset.tcl

Thanks Alpha.. I did discover that a bit later. For those who read this later, this actually ends up setting a flag in the MFS database. So you need to have a live image running. (Although, I guess there are tools that let you set manipulate the database on a cold system mounted with MFSTools.)


I think I'm going just move on this... The good news here is that I found out I could (legitimately) transfer my lifetime on this box to a month to month THD box that was going to be a project box. I was fooling around on the tivo site, and discovered the "transfer service number" option. I fully expected it not to work, presuming that some option needed to be set by a Tivo CSR to allow it to work. But bam, 10 seconds later, my lifetime was transfered.


Unfortunately, I spent too much time on the issue and my kids are beginning to complain about the smell coming from the basement where Dad is spending way too much time with uncased electronics.
;-)