PDA

View Full Version : Random reboot 3-30 minutes apart


ercdvs
11-09-2006, 11:24 PM
So, my tivo decides to reboot itself randomly anywhere from 5 minutes to 30+ minutes of use..

it is a series 2 stand alone running 7.3.1-oth-01-2-140
With a killhdinitrd kernel, tivowebplus,bash, tivoftp, mfs_ftp, and superpatch running on it. i also upgraded to a 160gb HD. This has been running great for 3+ months

My temps are holding at 41C .. mfscheck & mfsassert -please both show no errors.

I *think* it is rebooting due to the fact it is running an intensive background cleanup process or something ... which crashes ...and therefore prompts the tivo to reboot... as shown in my logs

I also have a large number of orphans as show in the MFS / database

**** Any thoughts on why this is happening? How can I check to see what process is running & causing the crash? I have tried lowering system load by disabling tivoftp + tivowebplus + mfs_ftp... and putting the system on standby or even a blank channel.... no dice.... what should I look at next?

My interesting log entries :

kernel:
Nov 9 22:34:52 (none) kernel: assert: Tmk Assertion Failure:
Nov 9 22:34:52 (none) kernel: assert: Audit, line 31 ()
Nov 9 22:34:52 (none) kernel: Tmk Fatal Error: Activity HandleDataChanged <423> strayed!
Nov 9 22:34:52 (none) kernel: Paste the following into a shell to get a backtrace...
Nov 9 22:34:52 (none) kernel:
Nov 9 22:34:52 (none) kernel: bt -t /tvbin/tivoapp <<END_OF_BT
Nov 9 22:34:52 (none) kernel: tcd 1
Nov 9 22:34:52 (none) kernel: hpk Series2
Nov 9 22:34:52 (none) kernel: build b-7-3-1-mr @238502 2006.06.20-1716 release-mips [SET_7_3_1_OTHER]
Nov 9 22:34:52 (none) kernel: pack 7.3.1-oth-01-2
Nov 9 22:34:52 (none) kernel: read 0x00400000 /tvbin/tivoapp
Nov 9 22:34:52 (none) kernel: read 0x02000000 /lib/libc.so.6
Nov 9 22:34:52 (none) kernel: read 0x02200000 /lib/libm.so.6
Nov 9 22:34:52 (none) kernel: read 0x02400000 /lib/libpthread.so.0
Nov 9 22:34:52 (none) kernel: read 0x02600000 /lib/libutil.so.1
Nov 9 22:34:52 (none) kernel: read 0x02800000 /lib/libtvutil.so
Nov 9 22:34:52 (none) kernel: read 0x02a00000 /lib/libtmk.so
Nov 9 22:34:52 (none) kernel: read 0x02c00000 /lib/libtvstructures.so
Nov 9 22:34:52 (none) kernel: read 0x2aaa8000 /lib/ld.so.1
Nov 9 22:34:52 (none) kernel: read 0x2ab04000 /lib/libhpkoss.so
Nov 9 22:34:52 (none) kernel: read 0x2ab50000 /platform/lib/libhpkhl.so
Nov 9 22:34:52 (none) kernel: read 0x2abf8000 /platform/lib/libhpkll.so
Nov 9 22:34:52 (none) kernel: read 0x2ac3c000 /lib/libdl.so.2
Nov 9 22:34:52 (none) kernel: read 0x2ac80000 /lib/libcdaudio.so
Nov 9 22:34:52 (none) kernel: 0x02a810a0 0x005dfec4 0x00550768 0x00545f94 0x00c3a2e4 0x00c332f8 0x006cbf40
Nov 9 22:34:52 (none) kernel: 0x006b70d4 0x006052ec 0x006ad014 0x006166d4 0x006fbdc8 0x00474f5c 0x00f77e64
Nov 9 22:34:52 (none) kernel: 0x02a2bf28 0x02a3d2dc 0x02a2b18c 0x02a265dc 0x02a2f0fc 0x02a626c0 0x02a2bf28
Nov 9 22:34:52 (none) kernel: 0x02a2eff0 0x02a2d308 0x02a39f38 0x02a39e20 0x02a39cd0 0x02a39084
Nov 9 22:34:52 (none) kernel: END_OF_BT
tverr:
Nov 9 22:49:00 (none) TmkAssertionFailure[397]: : (Audit, line 31 ())
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: Tmk Fatal Error: Activity HandleDataChanged <397> strayed! (block timestamp 68076040667)
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: bt -t /tvbin/tivoapp
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: tcd 1
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: hpk Series2
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: build b-7-3-1-mr @238502 2006.06.20-1716 release-mips [SET_7_3_1_OTHER]
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: pack 7.3.1-oth-01-2
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x00400000 /tvbin/tivoapp
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x02000000 /lib/libc.so.6
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x02200000 /lib/libm.so.6
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x02400000 /lib/libpthread.so.0
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x02600000 /lib/libutil.so.1
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x02800000 /lib/libtvutil.so
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x02a00000 /lib/libtmk.so
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x02c00000 /lib/libtvstructures.so
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x2aaa8000 /lib/ld.so.1
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x2ab04000 /lib/libhpkoss.so
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x2ab50000 /platform/lib/libhpkhl.so
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x2abf8000 /platform/lib/libhpkll.so
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x2ac3c000 /lib/libdl.so.2
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: read 0x2ac80000 /lib/libcdaudio.so
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: 0x02a810a0 0x005dfec4 0x00550768 0x00545f94 0x00c3a2e4 0x00c332f8 0x006cbf40 0x006b70d4 0x006052ec 0x006ad014 0x006166d4 0x006fbdc8 0x00474f5c 0x00f77e64 0x02a2bf28 0x02a3d2dc 0x02a2b18c 0x02a265dc 0x02a2f0fc 0x02a626c0 0x02a2bf28 0x02a2eff0 0x02a2d308 0x02a39f38 0x02a39e20 0x02a39cd0 0x02a39084
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: Tmk Fatal Error: Activity HandleDataChanged <397>: assertion failure
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: Tmk Fatal Error: Thread died due to signal -2
Nov 9 22:49:00 (none) Activity HandleDataChanged[397]: Invoking rule 834: rebooting system

Some interesting things from tvlog:

Nov 9 22:34:24 (none) TvHttpMind[312]: HttpState: 200 OK
Nov 9 22:34:24 (none) TmkActivityManager[312]: Activity High Water Mark: 21
Nov 9 22:34:30 (none) TmkTransform::Trace[239]: ClipCache 0x5e560b08 Secondary Reset
Nov 9 22:34:30 (none) ClipCache[235]: 0x5e560b08 in Entry(), thread 235, fsid 2082750
Nov 9 22:34:30 (none) TmkReadAheadCache.C[235]: Invalidate 2082750
Nov 9 22:34:30 (none) pcache[237]: flushed fsid 2082749, up to 1559 (1560)
Nov 9 22:34:36 (none) DbGuideViewCacheChore[423]: Do some work...
Nov 9 22:34:43 (none) DbGuideViewCacheDailyGenerator[423]: Done caching all channels.
Nov 9 22:34:43 (none) DbGuideViewCacheDailyGenerator[423]: Wall clock duration: 0d 0h 11m 31s
Nov 9 22:34:43 (none) DbGuideViewCacheDailyGenerator[423]: Running duration: 0d 0h 2m 54s

Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: Begin (186): 155218944, 137042526, 136982016, 60510, 153832960, 420734, 2925
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1946902, 831488, 1802, 3691, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1946903, 835584, 1802, 3709, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1953882, 831488, 1803, 3689, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1955886, 831488, 1802, 3691, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1964698, 831488, 1802, 3691, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1966699, 835584, 1802, 3709, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1975616, 835584, 1802, 3709, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1986227, 835584, 1802, 3709, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1987955, 835584, 1801, 3711, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1997003, 835584, 1801, 3711, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 1999066, 835584, 1803, 3707, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 2008155, 1276928, 3602, 2836, 0x5, 0x2, 0x5, 0x2, 0x2
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 2008169, 835584, 1802, 3709, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 2009704, 835584, 1802, 3709, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 2019497, 1276928, 3602, 2836, 0x5, 0x2, 0x5, 0x2, 0x2
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 2019507, 831488, 1801, 3693, 0x4, 0x6, 0x5, 0x5, 0x5
Nov 9 22:34:49 (none) TvDbUtil[431]: LogRecordings3: 2020711, 831488, 1802, 3691, 0x4, 0x6, 0x5, 0x5, 0x5

Nov 9 22:35:52 (none) TmkInit[94]: 0.000 seconds: TOTAL for HpkPlatform
Nov 9 22:35:53 (none) CalypsoDataImageFile[95]: Warning: Hardware DOES NOT support local photos, but the TvFeature is turned ON!
Nov 9 22:35:53 (none) CalypsoDataImageFile[95]: Warning: Hardware DOES NOT support local photos, but the TvFeature is turned ON!
Nov 9 22:35:53 (none) TmkInit[95]: Starting program TvLauncher
Nov 9 22:35:58 (none) TmkMempool[95]: STAT TvIdlRegistry: blocks=1741 bytes=306272 bytesMax=306272 unusedBytes=211928 chunks=0 chunkBytes=0 freeChunks=0 freeChunkBytes=0 maxFreeChunk=203312
Nov 9 22:35:58 (none) TmkInit[95]: 5.427 seconds: start TvIdlRegistrySharedMemory

ercdvs
11-09-2006, 11:59 PM
http://www.dealdatabase.com/forum/showthread.php?t=42737&page=2
this thread holds interest as it seems to have similar error messages..

Removing all my season passes now to check it out

ercdvs
11-10-2006, 09:10 AM
*SOLVED* (so far)

Deleting the SP only did nothing, but a full wipe of all guide data, etc, and a pull of new data from tivo has resulted in an uptime of 6+ hours so far.