Arch Linux

Kernel-bug oder Speicherfehler?

[gelöscht]

Hallo,

bei dem Versuch mit mc Dateien von sda2 auf sdb2 (beide reiserfs) zu verschieben fror mc ein.

Im Log konnte ich dies finden:

Feb 19 21:09:03 arbeit ------------[ cut here ]------------
Feb 19 21:09:03 arbeit kernel BUG at fs/reiserfs/bitmap.c:1222!
Feb 19 21:09:03 arbeit invalid opcode: 0000 [#1] PREEMPT SMP 
Feb 19 21:09:03 arbeit Modules linked in: snd_seq_midi snd_emu10k1_synth snd_emux_synth snd_seq_virmidi snd_seq_midi_emul ipv6 nvidia(P) nls_cp437 vfat fat ppdev analog lp ns558 parport_pc parport ppp_generic slhc rtc_cmos rtc_core rtc_lib psmouse serio_raw pcspkr snd_usb_audio snd_usb_lib sn9c102 compat_ioctl32 videodev v4l1_compat v4l2_common i2c_viapro i2c_core via_ircc irda crc_ccitt emu10k1_gp gameport shpchp pci_hotplug via_agp agpgart sg evdev thermal processor fan button battery ac snd_emu10k1 snd_util_mem snd_ac97_codec snd_rawmidi snd_hwdep snd_seq_oss snd_seq_midi_event snd_seq snd_seq_device snd_pcm_oss snd_pcm snd_timer snd_page_alloc snd_mixer_oss snd soundcore ac97_bus 8139too mii reiserfs uhci_hcd sr_mod cdrom sd_mod usbcore pata_acpi ata_generic pata_via libata
Feb 19 21:09:03 arbeit 
Feb 19 21:09:03 arbeit Pid: 6910, comm: mc Tainted: P        (2.6.24-ARCH #1)
Feb 19 21:09:03 arbeit EIP: 0060:[<e08dd05e>] EFLAGS: 00210246 CPU: 0
Feb 19 21:09:03 arbeit EIP is at reiserfs_cache_bitmap_metadata+0x5e/0x70 [reiserfs]
Feb 19 21:09:03 arbeit EAX: 47e1b4f4 EBX: e0b75104 ECX: 00001000 EDX: c614d000
Feb 19 21:09:03 arbeit ESI: d26b0230 EDI: df97ea00 EBP: 00000041 ESP: dc42fa5c
Feb 19 21:09:03 arbeit DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
Feb 19 21:09:03 arbeit Process mc (pid: 6910, ti=dc42e000 task=ce06b540 task.ti=dc42e000)
Feb 19 21:09:03 arbeit Stack: d26b0230 00208000 e08dd259 00001000 ffffffff e08e4ff8 00000004 e0b75000 
Feb 19 21:09:03 arbeit 00000041 00000041 00000001 dc42fb58 e08dd3f5 df281200 04040404 df97ea00 
Feb 19 21:09:03 arbeit 00000041 ce07f380 df97ea00 e0b75104 00000800 c0186f02 00000041 00000041 
Feb 19 21:09:03 arbeit Call Trace:
Feb 19 21:09:03 arbeit [<e08dd259>] reiserfs_read_bitmap_block+0x99/0xe0 [reiserfs]
Feb 19 21:09:03 arbeit [<e08e4ff8>] make_cpu_key+0x48/0x60 [reiserfs]
Feb 19 21:09:03 arbeit [<e08dd3f5>] scan_bitmap_block+0x55/0x2b0 [reiserfs]
Feb 19 21:09:03 arbeit [<c0186f02>] inode_add_bytes+0x22/0x70
Feb 19 21:09:03 arbeit [<e08de91b>] reiserfs_allocate_blocknrs+0x9db/0x1030 [reiserfs]
Feb 19 21:09:03 arbeit [<e08e72b2>] reiserfs_get_block+0x342/0x13d0 [reiserfs]
Feb 19 21:09:03 arbeit [<c0233da0>] blk_unplug_timeout+0x0/0xa0
Feb 19 21:09:03 arbeit [<c01a521b>] __find_get_block+0xab/0x1c0
Feb 19 21:09:03 arbeit [<c02b887d>] scsi_request_fn+0x1ed/0x2f0
Feb 19 21:09:03 arbeit [<c01a6408>] __block_prepare_write+0x228/0x400
Feb 19 21:09:03 arbeit [<c01a666d>] block_write_begin+0x4d/0xf0
Feb 19 21:09:03 arbeit [<e08e6f70>] reiserfs_get_block+0x0/0x13d0 [reiserfs]
Feb 19 21:09:03 arbeit [<e08e970f>] reiserfs_write_begin+0xff/0x210 [reiserfs]
Feb 19 21:09:03 arbeit [<e08e6f70>] reiserfs_get_block+0x0/0x13d0 [reiserfs]
Feb 19 21:09:03 arbeit [<c0160c60>] generic_file_buffered_write+0x120/0x660
Feb 19 21:09:03 arbeit [<c0142460>] autoremove_wake_function+0x0/0x40
Feb 19 21:09:03 arbeit [<c0161454>] __generic_file_aio_write_nolock+0x2b4/0x530
Feb 19 21:09:03 arbeit [<c036d2ca>] __mutex_lock_slowpath+0x16a/0x2d0
Feb 19 21:09:03 arbeit [<c0161735>] generic_file_aio_write+0x65/0xe0
Feb 19 21:09:03 arbeit [<c0183a35>] do_sync_write+0xd5/0x120
Feb 19 21:09:03 arbeit [<c0142460>] autoremove_wake_function+0x0/0x40
Feb 19 21:09:03 arbeit [<c028c866>] tty_ldisc_deref+0x46/0x70
Feb 19 21:09:03 arbeit [<c028eadf>] tty_write+0x1bf/0x1d0
Feb 19 21:09:03 arbeit [<e08ea6e0>] reiserfs_file_write+0x0/0xb0 [reiserfs]
Feb 19 21:09:03 arbeit [<c01842e5>] vfs_write+0xb5/0x140
Feb 19 21:09:03 arbeit [<c0184981>] sys_write+0x41/0x70
Feb 19 21:09:03 arbeit [<c01054e2>] sysenter_past_esp+0x6b/0xa1
Feb 19 21:09:03 arbeit =======================
Feb 19 21:09:03 arbeit Code: 18 39 d1 73 ed 5b 5e c3 83 c0 01 74 de ba 1f 00 00 00 0f a3 11 19 c0 85 c0 75 03 83 03 01 83 ea 01 83 fa ff 75 ec 8b 56 18 eb c0 <0f> 0b eb fe 8d b4 26 00 00 00 00 8d bc 27 00 00 00 00 83 ec 28 
Feb 19 21:09:03 arbeit EIP: [<e08dd05e>] reiserfs_cache_bitmap_metadata+0x5e/0x70 [reiserfs] SS:ESP 0068:dc42fa5c
Feb 19 21:09:03 arbeit ---[ end trace ea7da8b983bc3b15 ]---
Feb 19 21:09:03 arbeit WARNING: at kernel/exit.c:917 do_exit()
Feb 19 21:09:03 arbeit Pid: 6910, comm: mc Tainted: P      D 2.6.24-ARCH #1
Feb 19 21:09:03 arbeit [<c013190d>] do_exit+0x73d/0x7b0
Feb 19 21:09:03 arbeit [<c012e78b>] printk+0x1b/0x20
Feb 19 21:09:03 arbeit [<c0106b87>] die+0x267/0x270
Feb 19 21:09:03 arbeit [<c0106f20>] do_invalid_op+0x0/0x90
Feb 19 21:09:03 arbeit [<c0106fa1>] do_invalid_op+0x81/0x90
Feb 19 21:09:03 arbeit [<e08dd05e>] reiserfs_cache_bitmap_metadata+0x5e/0x70 [reiserfs]
Feb 19 21:09:03 arbeit [<c036c585>] schedule+0x525/0x610
Feb 19 21:09:03 arbeit [<c036cab9>] __wait_on_bit+0x59/0x70
Feb 19 21:09:03 arbeit [<c01a5ca0>] sync_buffer+0x0/0x40
Feb 19 21:09:03 arbeit [<c01a5ca0>] sync_buffer+0x0/0x40
Feb 19 21:09:03 arbeit [<c036e992>] error_code+0x72/0x78
Feb 19 21:09:03 arbeit [<e08dd05e>] reiserfs_cache_bitmap_metadata+0x5e/0x70 [reiserfs]
Feb 19 21:09:03 arbeit [<e08dd259>] reiserfs_read_bitmap_block+0x99/0xe0 [reiserfs]
Feb 19 21:09:03 arbeit [<e08e4ff8>] make_cpu_key+0x48/0x60 [reiserfs]
Feb 19 21:09:03 arbeit [<e08dd3f5>] scan_bitmap_block+0x55/0x2b0 [reiserfs]
Feb 19 21:09:03 arbeit [<c0186f02>] inode_add_bytes+0x22/0x70
Feb 19 21:09:03 arbeit [<e08de91b>] reiserfs_allocate_blocknrs+0x9db/0x1030 [reiserfs]
Feb 19 21:09:03 arbeit [<e08e72b2>] reiserfs_get_block+0x342/0x13d0 [reiserfs]
Feb 19 21:09:03 arbeit [<c0233da0>] blk_unplug_timeout+0x0/0xa0
Feb 19 21:09:03 arbeit [<c01a521b>] __find_get_block+0xab/0x1c0
Feb 19 21:09:03 arbeit [<c02b887d>] scsi_request_fn+0x1ed/0x2f0
Feb 19 21:09:03 arbeit [<c01a6408>] __block_prepare_write+0x228/0x400
Feb 19 21:09:03 arbeit [<c01a666d>] block_write_begin+0x4d/0xf0
Feb 19 21:09:03 arbeit [<e08e6f70>] reiserfs_get_block+0x0/0x13d0 [reiserfs]
Feb 19 21:09:03 arbeit [<e08e970f>] reiserfs_write_begin+0xff/0x210 [reiserfs]
Feb 19 21:09:03 arbeit [<e08e6f70>] reiserfs_get_block+0x0/0x13d0 [reiserfs]
Feb 19 21:09:03 arbeit [<c0160c60>] generic_file_buffered_write+0x120/0x660
Feb 19 21:09:03 arbeit [<c0142460>] autoremove_wake_function+0x0/0x40
Feb 19 21:09:03 arbeit [<c0161454>] __generic_file_aio_write_nolock+0x2b4/0x530
Feb 19 21:09:03 arbeit [<c036d2ca>] __mutex_lock_slowpath+0x16a/0x2d0
Feb 19 21:09:03 arbeit [<c0161735>] generic_file_aio_write+0x65/0xe0
Feb 19 21:09:03 arbeit [<c0183a35>] do_sync_write+0xd5/0x120
Feb 19 21:09:03 arbeit [<c0142460>] autoremove_wake_function+0x0/0x40
Feb 19 21:09:03 arbeit [<c028c866>] tty_ldisc_deref+0x46/0x70
Feb 19 21:09:03 arbeit [<c028eadf>] tty_write+0x1bf/0x1d0
Feb 19 21:09:03 arbeit [<e08ea6e0>] reiserfs_file_write+0x0/0xb0 [reiserfs]
Feb 19 21:09:03 arbeit [<c01842e5>] vfs_write+0xb5/0x140
Feb 19 21:09:03 arbeit [<c0184981>] sys_write+0x41/0x70
Feb 19 21:09:03 arbeit [<c01054e2>] sysenter_past_esp+0x6b/0xa1
Feb 19 21:09:03 arbeit =======================

Nun hatte ich heute zwei Komplettabstürze (keine Maus/Tastatur, kein Umschalten auf Konsole) beim Versuch, eine URL in KMail einzufügen (zeitgleich lief u.a. firefox mit ca. 5 geöffneten Tabs, 2x google, 2x youtube), diesen Absturz konnte ich reproduzieren, in den Logs war leider nichts zu finden.
Daraufhin habe ich mir eine StartCD mit memtest86 gebrannt und das ca. 40 Minuten laufen (die ersten acht Tests...), keine Fehlermeldung.

Die sda ist erst ein paar Tage alt (mit badblocks geprüft), die sdb war ehedem mal meine Startplatte.

Vielleicht hat ja jemand eine Idee...

grüße

ralf

GerBra

Nun, Vermutungen schon. Jedenfalls wo ich ansetzen würde.
Solche Abstürze außerhalb eines definierten Programms/Vorgang sind m.E. zu 99%
Hardware-Probleme.

memtest von 40min ist zuwenig. Wir hatten letztens einen Thread wo der memtester
IMHO erst nach 8 (oder doch mehr als 20 h) einen Fehler fand.

Wenn die letzte nennenswerte Aktion deinerseits (also keine großen Updates) der
Einbau der neuen Platte war liegt die Vermutung nahe das es damit zu tun haben
könnte. Kabel, Verträglichkeit mit der anderen Platte, Platte selbst, evtl. Master/Slave
nicht richtig gejumpert bei IDE,...

Auch was anderes kann zu diesem zeitpunkt natürlich kaputt gehen um den User zu
verwirren 😉 Beliebt sind m.E. Netzteile, falsche Spannungen, Schwankungen.

Software (wenn du da was vermutest) kannst du ja ggf. downgraden.
Die neue HD halt mal auf o.a. prüfen, ggf. mal weglassen zum Testen.

[gelöscht]

Hallo GerBra,

habe memtest über Nacht laufen lassen, nach 18,5 Stunden hat er noch nichts gefunden.
Allerdings hatte ich schon einmal einen kaputten Speicherriegel in Kombination mit einem zum Teil defekten Netzteil, das war eine langwierige Suche.

Ich habe jetzt noch einmal alle Steckverbindungen geprüft und die Platten auf Master und Slave gejumpert (standen vorher auf CableSelect).

Werde nochmal irgendein Diagnosetool über die Platten laufen lassen, damit ich die ausschließen kann.

Momentan läuft es ja.

Noch 🙂

Danke und einen netten Abend

ralf

[gelöscht]

So,

jetzt habe ich smartmontools installiert und bei meiner Samsung gibt es folgendes Protokoll:

[root@arbeit ~]# smartctl -a /dev/sdb
smartctl version 5.37 [i686-pc-linux-gnu] Copyright (C) 2002-6 Bruce Allen
Home page is http://smartmontools.sourceforge.net/

=== START OF INFORMATION SECTION ===
Device Model:     SAMSUNG SV6004H
Serial Number:    0403J1FR807780
Firmware Version: PY100-11
User Capacity:    60.060.672.000 bytes
Device is:        In smartctl database [for details use: -P show]
ATA Version is:   6
ATA Standard is:  ATA/ATAPI-6 T13 1410D revision 1
Local Time is:    Thu Feb 21 00:02:56 2008 CET

==> WARNING: May need -F samsung or -F samsung2 enabled; see manual for details.

SMART support is: Available - device has SMART capability.
SMART support is: Enabled

=== START OF READ SMART DATA SECTION ===
SMART overall-health self-assessment test result: PASSED

General SMART Values:
Offline data collection status:  (0x00) Offline data collection activity
                                        was never started.
                                        Auto Offline Data Collection: Disabled.
Self-test execution status:      (   0) The previous self-test routine completed
                                        without error or no self-test has ever
                                        been run.
Total time to complete Offline
data collection:                 (2640) seconds.
Offline data collection
capabilities:                    (0x1b) SMART execute Offline immediate.
                                        Auto Offline data collection on/off support.
                                        Suspend Offline collection upon new
                                        command.
                                        Offline surface scan supported.
                                        Self-test supported.
                                        No Conveyance Self-test supported.
                                        No Selective Self-test supported.
SMART capabilities:            (0x0003) Saves SMART data before entering
                                        power-saving mode.
                                        Supports SMART auto save timer.
Error logging capability:        (0x01) Error logging supported.
                                        No General Purpose Logging support.
Short self-test routine
recommended polling time:        (   1) minutes.
Extended self-test routine
recommended polling time:        (  16) minutes.

SMART Attributes Data Structure revision number: 9
Vendor Specific SMART Attributes with Thresholds:
ID# ATTRIBUTE_NAME          FLAG     VALUE WORST THRESH TYPE      UPDATED  WHEN_FAILED RAW_VALUE
  1 Raw_Read_Error_Rate     0x000a   100   100   000    Old_age   Always       -       46
  4 Start_Stop_Count        0x0032   098   098   000    Old_age   Always       -       2189
  5 Reallocated_Sector_Ct   0x0033   253   253   010    Pre-fail  Always       -       0
  7 Seek_Error_Rate         0x000a   253   253   051    Old_age   Always       -       0
  8 Seek_Time_Performance   0x0024   253   253   000    Old_age   Offline      -       0
  9 Power_On_Hours          0x0032   099   099   000    Old_age   Always       -       629682
 12 Power_Cycle_Count       0x0032   099   099   000    Old_age   Always       -       1147
197 Current_Pending_Sector  0x0032   253   253   010    Old_age   Always       -       0
198 Offline_Uncorrectable   0x0030   253   253   010    Old_age   Offline      -       0
199 UDMA_CRC_Error_Count    0x000a   200   200   000    Old_age   Always       -       0
200 Multi_Zone_Error_Rate   0x000a   100   100   051    Old_age   Always       -       0
201 Soft_Read_Error_Rate    0x000a   100   100   051    Old_age   Always       -       0

SMART Error Log Version: 1
Warning: ATA error count 128 inconsistent with error log pointer 1

ATA Error Count: 128 (device log contains only the most recent five errors)
        CR = Command Register [HEX]
        FR = Features Register [HEX]
        SC = Sector Count Register [HEX]
        SN = Sector Number Register [HEX]
        CL = Cylinder Low Register [HEX]
        CH = Cylinder High Register [HEX]
        DH = Device/Head Register [HEX]
        DC = Device Command Register [HEX]
        ER = Error register [HEX]
        ST = Status register [HEX]
Powered_Up_Time is measured from power on, and printed as
DDd+hh:mm:SS.sss where DD=days, hh=hours, mm=minutes,
SS=sec, and sss=millisec. It "wraps" after 49.710 days.

Error 128 occurred at disk power-on lifetime: 5246 hours (218 days + 14 hours)
  When the command that caused the error occurred, the device was active or idle.

  After command completion occurred, registers were:
  ER ST SC SN CL CH DH
  -- -- -- -- -- -- --
  04 88 05 01 00 00 b0

  Commands leading to the command that caused the error were:
  CR FR SC SN CL CH DH DC   Powered_Up_Time  Command/Feature_Name
  -- -- -- -- -- -- -- --  ----------------  --------------------
  a1 00 05 01 00 00 b0 00      02:36:07.000  IDENTIFY PACKET DEVICE
  ca 00 08 7e 77 71 f2 ff      02:35:53.000  WRITE DMA
  ca 00 10 6e 77 71 f2 ff      02:35:52.000  WRITE DMA
  e7 00 80 58 09 14 b0 00      02:35:52.000  FLUSH CACHE
  ca 00 08 06 17 72 f2 00      02:35:51.000  WRITE DMA

Error 127 occurred at disk power-on lifetime: 5244 hours (218 days + 12 hours)
  When the command that caused the error occurred, the device was active or idle.

  After command completion occurred, registers were:
  ER ST SC SN CL CH DH
  -- -- -- -- -- -- --
  04 88 05 01 00 00 b0

  Commands leading to the command that caused the error were:
  CR FR SC SN CL CH DH DC   Powered_Up_Time  Command/Feature_Name
  -- -- -- -- -- -- -- --  ----------------  --------------------
  a1 00 05 01 00 00 b0 00      00:00:11.000  IDENTIFY PACKET DEVICE
  ca 00 40 9e f8 76 f2 ff      00:00:11.000  WRITE DMA
  ca 00 00 9e f7 76 f2 ff      00:00:11.000  WRITE DMA
  ec 00 01 01 00 00 b0 00      00:00:11.000  IDENTIFY DEVICE
  a1 00 05 01 00 00 b0 00      01:46:25.000  IDENTIFY PACKET DEVICE

Error 126 occurred at disk power-on lifetime: 5244 hours (218 days + 12 hours)
  When the command that caused the error occurred, the device was active or idle.

  After command completion occurred, registers were:
  ER ST SC SN CL CH DH
  -- -- -- -- -- -- --
  04 88 01 01 00 00 b0

  Commands leading to the command that caused the error were:
  CR FR SC SN CL CH DH DC   Powered_Up_Time  Command/Feature_Name
  -- -- -- -- -- -- -- --  ----------------  --------------------
  a1 00 01 01 00 00 b0 00      00:00:11.000  IDENTIFY PACKET DEVICE
  10 00 00 00 00 00 b0 ff      00:00:11.000  RECALIBRATE [OBS-4]
  00 03 45 00 00 00 b0 ff      00:00:11.000  NOP [Reserved subcommand]
  e3 00 00 00 aa 00 b0 00      00:00:11.000  IDLE
  c6 00 10 00 00 00 fc 00      00:00:11.000  SET MULTIPLE MODE

Error 125 occurred at disk power-on lifetime: 5244 hours (218 days + 12 hours)
  When the command that caused the error occurred, the device was active or idle.

  After command completion occurred, registers were:
  ER ST SC SN CL CH DH
  -- -- -- -- -- -- --
  04 80 05 01 00 00 b0

  Commands leading to the command that caused the error were:
  CR FR SC SN CL CH DH DC   Powered_Up_Time  Command/Feature_Name
  -- -- -- -- -- -- -- --  ----------------  --------------------
  a1 00 05 01 00 00 b0 00      00:00:11.000  IDENTIFY PACKET DEVICE
  e3 00 00 00 aa 00 b0 00      04:44:20.000  IDLE
  c6 00 10 00 00 00 fc 00      04:44:20.000  SET MULTIPLE MODE
  91 00 3f 00 00 00 bf 00      04:44:20.000  INITIALIZE DEVICE PARAMETERS [OBS-6]
  10 00 00 00 00 00 b0 00      04:44:20.000  RECALIBRATE [OBS-4]

Error 124 occurred at disk power-on lifetime: 5244 hours (218 days + 12 hours)
  When the command that caused the error occurred, the device was active or idle.

  After command completion occurred, registers were:
  ER ST SC SN CL CH DH
  -- -- -- -- -- -- --
  04 88 05 01 00 00 b0

  Commands leading to the command that caused the error were:
  CR FR SC SN CL CH DH DC   Powered_Up_Time  Command/Feature_Name
  -- -- -- -- -- -- -- --  ----------------  --------------------
  b0 d5 01 01 4f c2 10 00      03:26:19.000  SMART READ LOG
  b0 d1 01 01 4f c2 10 00      03:26:19.000  SMART READ ATTRIBUTE THRESHOLDS [OBS-4]
  b0 d0 01 00 4f c2 10 00      03:26:19.000  SMART READ DATA
  b0 da 00 00 4f c2 10 00      03:26:19.000  SMART RETURN STATUS
  b0 da 00 00 4f c2 10 00      03:26:19.000  SMART RETURN STATUS

SMART Self-test log structure revision number 1
No self-tests have been logged.  [To run self-tests, use: smartctl -t]

Inzwischen sind wieder zwei Fehler dazu gekommen, so langsam mache ich mir jetzt doch Sorgen 🙂

Also scheint Deine Vermutung eines Hardware-Defektes wohl richtig zu sein.

Werde mal schauen, ob Google mir bei der Auflösung der Meldung helfen kann.

grüße

ralf