Bug#606686: linux-image-2.6.32-5-686-bigmem: problem mounting CD, even as a loop device
Hi Ben,
On Sat, 11.12.2010 at 02:06:59 +0000, Ben Hutchings <ben@decadent.org.uk> wrote:
> We need to see the *first* oops message. This...
below I have included the first BUG message I could find,
> ...shows the D and W flags which indicate there were prior BUG and WARN
> messages.
but the 'W' flag is already set:
Dec 10 22:38:53 debian kernel: [1736183.557889] sr 1:0:0:0: [sr0] Sense Key : Illegal Request [current]
Dec 10 22:38:53 debian kernel: [1736183.557900] Info fld=0x509aa, ILI
Dec 10 22:38:53 debian kernel: [1736183.557905] sr 1:0:0:0: [sr0] Add. Sense: Illegal mode for this track
Dec 10 22:38:53 debian kernel: [1736183.557917] sr 1:0:0:0: [sr0] CDB: Read(10): 28 00 00 05 09 aa 00 00 01 00
Dec 10 22:38:53 debian kernel: [1736183.557937] end_request: I/O error, dev sr0, sector 1320616
Dec 10 22:38:53 debian kernel: [1736183.562482] sr 1:0:0:0: [sr0] Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE
Dec 10 22:38:53 debian kernel: [1736183.562494] sr 1:0:0:0: [sr0] Sense Key : Illegal Request [current]
Dec 10 22:38:53 debian kernel: [1736183.562505] Info fld=0x509a9, ILI
Dec 10 22:38:53 debian kernel: [1736183.562510] sr 1:0:0:0: [sr0] Add. Sense: Illegal mode for this track
Dec 10 22:38:53 debian kernel: [1736183.562522] sr 1:0:0:0: [sr0] CDB: Read(10): 28 00 00 05 09 a8 00 00 02 00
Dec 10 22:38:53 debian kernel: [1736183.562541] end_request: I/O error, dev sr0, sector 1320608
Dec 10 22:39:34 debian kernel: [1736225.147779] ISO 9660 Extensions: Microsoft Joliet Level 3
Dec 10 22:39:34 debian kernel: [1736225.296822] ISO 9660 Extensions: RRIP_1991A
Dec 10 22:39:36 debian kernel: [1736227.289668] BUG: unable to handle kernel paging request at 4ced1b76
Dec 10 22:39:36 debian kernel: [1736227.289681] IP: [<c1090d31>] zone_watermark_ok+0x5c/0x9d
Dec 10 22:39:36 debian kernel: [1736227.289700] *pdpt = 000000000edfa001 *pde = 0000000000000000
Dec 10 22:39:36 debian kernel: [1736227.289712] Oops: 0000 [#1] SMP
Dec 10 22:39:36 debian kernel: [1736227.289720] last sysfs file: /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:14/ATK0110:00/hwmon/hwmon0/fan3_input
Dec 10 22:39:36 debian kernel: [1736227.289732] Modules linked in: nls_utf8 isofs udf crc_itu_t xfrm_user xfrm4_tunnel tunnel4 ipcomp xfrm_ipcomp esp4 ah4 fuse ip6table_filter ip6_tables ebtable_nat ebtables binfmt_misc drbd lru_cache cn sco bnep rfcomm l2cap crc16 bluetooth rfkill kvm_amd kvm battery powernow_k8 cpufreq_userspace cpufreq_conservative cpufreq_powersave cpufreq_stats nfsd exportfs nfs lockd fscache nfs_acl auth_rpcgss sunrpc nf_nat_ftp nf_nat_irc nf_conntrack_ftp nf_conntrack_irc ipt_MASQUERADE iptable_nat nf_nat ipt_LOG xt_limit xt_tcpudp xt_state nf_conntrack_ipv4 nf_conntrack nf_defrag_ipv4 iptable_filter ip_tables x_tables ppp_deflate bsd_comp ppp_async crc_ccitt ppp_generic slhc bridge stp deflate zlib_deflate ctr twofish twofish_common camellia serpent blowfish cast5 des_generic xcbc rmd160 sha1_generic hmac crypto_null af_key loop snd_hda_codec_via snd_hda_intel snd_hda_codec radeon ttm snd_hwdep drm_kms_helper snd_pcm_oss snd_mixer_oss drm snd_pcm snd_seq_midi snd_rawmidi snd_seq_midi_eve
Dec 10 22:39:36 debian kernel: nt snd_seq snd_timer snd_seq_device i2c_algo_bit asus_atk0110 parport_pc evdev snd shpchp pcspkr i2c_piix4 processor button soundcore parport snd_page_alloc i2c_core pci_hotplug acpi_processor ext3 jbd mbcache sha256_generic aes_i586 aes_generic cbc dm_crypt dm_mod raid1 md_mod sg usbhid hid sr_mod cdrom sd_mod crc_t10dif ata_generic ohci_hcd pata_atiixp ahci e1000e libata thermal thermal_sys scsi_mod ehci_hcd r8169 usbcore nls_base mii [last unloaded: fuse]
Dec 10 22:39:36 debian kernel: [1736227.289976]
Dec 10 22:39:36 debian kernel: [1736227.289985] Pid: 13859, comm: ls Tainted: G W (2.6.32-5-xen-686 #1) System Product Name
Dec 10 22:39:36 debian kernel: [1736227.289996] EIP: 0060:[<c1090d31>] EFLAGS: 00010246 CPU: 0
Dec 10 22:39:36 debian kernel: [1736227.290006] EIP is at zone_watermark_ok+0x5c/0x9d
Dec 10 22:39:36 debian kernel: [1736227.290013] EAX: a2f41292 EBX: c11cd122 ECX: 00000000 EDX: 90c35d5f
Dec 10 22:39:36 debian kernel: [1736227.290021] ESI: 00000000 EDI: 00000000 EBP: 5356c789 ESP: e9ad3cf8
Dec 10 22:39:36 debian kernel: [1736227.290029] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
Dec 10 22:39:36 debian kernel: [1736227.290038] Process ls (pid: 13859, ti=e9ad2000 task=c5ed9100 task.ti=e9ad2000)
Dec 10 22:39:36 debian kernel: [1736227.290045] Stack:
Dec 10 22:39:36 debian kernel: [1736227.290049] c5ac43c0 00000000 c102f844 c145ee1c e9ad3d68 00000000 000200d0 e9ad3ed0
Dec 10 22:39:36 debian kernel: [1736227.290065] <0> c1092879 a2f41292 00000041 ffffffff 00000000 c5a84424 a2f41292 00000000
Dec 10 22:39:36 debian kernel: [1736227.290081] <0> 00000000 000200d0 c13f57ec c5ac4418 00000000 00000000 c5ac441c 00000000
Dec 10 22:39:36 debian kernel: [1736227.290098] Call Trace:
Dec 10 22:39:36 debian kernel: [1736227.290109] [<c102f844>] ? find_busiest_group+0x2e9/0x6e6
Dec 10 22:39:36 debian kernel: [1736227.290121] [<c1092879>] ? get_page_from_freelist+0xc0/0x3c7
Dec 10 22:39:36 debian kernel: [1736227.290135] [<c11cd122>] ? pci_hp_diva_setup+0x0/0x6b
Dec 10 22:39:36 debian kernel: [1736227.290146] [<c1092e41>] ? __alloc_pages_nodemask+0xf3/0x4e0
Dec 10 22:39:36 debian kernel: [1736227.290156] [<c11cd122>] ? pci_hp_diva_setup+0x0/0x6b
Dec 10 22:39:36 debian kernel: [1736227.290167] [<c128c35f>] ? schedule+0x7a0/0x7dc
Dec 10 22:39:36 debian kernel: [1736227.290176] [<c11cd122>] ? pci_hp_diva_setup+0x0/0x6b
Dec 10 22:39:36 debian kernel: [1736227.290189] [<f8262035>] ? isofs_lookup+0x35/0x3e4 [isofs]
Dec 10 22:39:36 debian kernel: [1736227.290201] [<c10c8e2c>] ? d_alloc+0x1b/0x154
Dec 10 22:39:36 debian kernel: [1736227.290212] [<c10c8f31>] ? d_alloc+0x120/0x154
Dec 10 22:39:36 debian kernel: [1736227.290222] [<c10c1a71>] ? do_lookup+0xa6/0x116
Dec 10 22:39:36 debian kernel: [1736227.290232] [<c10c22e0>] ? __link_path_walk+0x4b7/0x5de
Dec 10 22:39:36 debian kernel: [1736227.290242] [<c10c25bd>] ? path_walk+0x4f/0xa3
Dec 10 22:39:36 debian kernel: [1736227.290252] [<c10c3739>] ? do_path_lookup+0x1f/0x69
Dec 10 22:39:36 debian kernel: [1736227.290262] [<c10c48a1>] ? user_path_at+0x37/0x5f
Dec 10 22:39:36 debian kernel: [1736227.290275] [<c10be12f>] ? vfs_fstatat+0x2a/0x50
Dec 10 22:39:36 debian kernel: [1736227.290285] [<c10be196>] ? vfs_lstat+0x13/0x15
Dec 10 22:39:36 debian kernel: [1736227.290296] [<c10be1a7>] ? sys_lstat64+0xf/0x23
Dec 10 22:39:36 debian kernel: [1736227.290307] [<c10cccef>] ? mntput_no_expire+0x17/0xb6
Dec 10 22:39:36 debian kernel: [1736227.290317] [<c10cf8e8>] ? sys_getxattr+0x40/0x48
Dec 10 22:39:36 debian kernel: [1736227.290328] [<c1008e1b>] ? sysenter_do_call+0x12/0x28
Dec 10 22:39:36 debian kernel: [1736227.290335] Code: c6 20 00 00 00 74 0f 89 e8 b9 02 00 00 00 99 f7 f9 89 04 24 29 c5 83 e6 10 74 0c 89 e8 be 04 00 00 00 99 f7 fe 29 c5 8b 44 24 24 <8b> 4c 83 0c 8d 44 0d 00 39 44 24 04 76 29 8b 74 24 04 31 d2 eb
Dec 10 22:39:36 debian kernel: [1736227.290406] EIP: [<c1090d31>] zone_watermark_ok+0x5c/0x9d SS:ESP 0068:e9ad3cf8
Dec 10 22:39:36 debian kernel: [1736227.290420] CR2: 000000004ced1b76
Dec 10 22:39:36 debian kernel: [1736227.290426] ---[ end trace e771b795f7396384 ]---
Dec 10 22:48:59 debian kernel: [1736789.365433] VFS: busy inodes on changed media or resized disk sr0
Dec 10 22:48:59 debian kernel: [1736789.384923] VFS: busy inodes on changed media or resized disk sr0
Dec 10 22:48:59 debian kernel: [1736789.404508] VFS: busy inodes on changed media or resized disk sr0
Dec 10 22:48:59 debian kernel: [1736789.424166] VFS: busy inodes on changed media or resized disk sr0
FWIW, the CD the kernel was complaining about, was burnt a few minutes
before on that same machine, and read perfectly fine in the same drive
after a reboot. However, the same error about corrupted data occurred
when I tried to loop-mount the image that I had burnt on the CD in
question.
Here is a WARNING message that occurred before, but I can't interpret
it:
Nov 21 11:41:33 debian kernel: [55144.204346] ------------[ cut here ]------------
Nov 21 11:41:33 debian kernel: [55144.204371] WARNING: at /build/buildd-linux-2.6_2.6.32-21-i386-Ullf8h/linux-2.6-2.6.32/debian/build/source_i386_xen/arch/x86/kernel/apic/ipi.c:109 default_send_IPI_mask_logical+0x28/0x80()
Nov 21 11:41:33 debian kernel: [55144.204387] Hardware name: System Product Name
Nov 21 11:41:33 debian kernel: [55144.204396] empty IPI mask
Nov 21 11:41:33 debian kernel: [55144.204400] Modules linked in: fuse ip6table_filter ip6_tables ebtable_nat ebtables binfmt_misc drbd lru_cache cn sco bnep rfcomm l2cap crc16 bluetooth rfkill kvm_amd kvm battery powernow_k8 cpufreq_userspace cpufreq_conservative cpufreq_powersave cpufreq_stats nfsd exportfs nfs lockd fscache nfs_acl auth_rpcgss sunrpc nf_nat_ftp nf_nat_irc nf_conntrack_ftp nf_conntrack_irc ipt_MASQUERADE iptable_nat nf_nat ipt_LOG xt_limit xt_tcpudp xt_state nf_conntrack_ipv4 nf_conntrack nf_defrag_ipv4 iptable_filter ip_tables x_tables ppp_deflate bsd_comp ppp_async crc_ccitt ppp_generic slhc bridge stp deflate zlib_deflate ctr twofish twofish_common camellia serpent blowfish cast5 des_generic xcbc rmd160 sha1_generic hmac crypto_null af_key loop snd_hda_codec_via snd_hda_intel snd_hda_codec radeon ttm snd_hwdep drm_kms_helper snd_pcm_oss snd_mixer_oss drm snd_pcm snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq snd_timer snd_seq_device i2c_algo_bit asus_atk0110 parport_pc evdev snd shpchp
Nov 21 11:41:33 debian kernel: pcspkr i2c_piix4 processor button soundcore parport snd_page_alloc i2c_core pci_hotplug acpi_processor ext3 jbd mbcache sha256_generic aes_i586 aes_generic cbc dm_crypt dm_mod raid1 md_mod sg usbhid hid sr_mod cdrom sd_mod crc_t10dif ata_generic ohci_hcd pata_atiixp ahci e1000e libata thermal thermal_sys scsi_mod ehci_hcd r8169 usbcore nls_base mii [last unloaded: fuse]
Nov 21 11:41:33 debian kernel: [55144.204763] Pid: 18, comm: events/3 Not tainted 2.6.32-5-xen-686 #1
Nov 21 11:41:33 debian kernel: [55144.204775] Call Trace:
Nov 21 11:41:33 debian kernel: [55144.204791] [<c103709d>] ? warn_slowpath_common+0x5e/0x8a
Nov 21 11:41:33 debian kernel: [55144.204809] [<c10370fb>] ? warn_slowpath_fmt+0x26/0x2a
Nov 21 11:41:33 debian kernel: [55144.204823] [<c101a6b8>] ? default_send_IPI_mask_logical+0x28/0x80
Nov 21 11:41:33 debian kernel: [55144.204841] [<c10190d6>] ? native_send_call_func_ipi+0x51/0x54
Nov 21 11:41:33 debian kernel: [55144.204856] [<c1059d6c>] ? smp_call_function_many+0x163/0x17c
Nov 21 11:41:33 debian kernel: [55144.204872] [<c10224ad>] ? __cpa_flush_range+0x0/0x17
Nov 21 11:41:33 debian kernel: [55144.204886] [<c10224ad>] ? __cpa_flush_range+0x0/0x17
Nov 21 11:41:33 debian kernel: [55144.204901] [<c1059d9e>] ? smp_call_function+0x19/0x1f
Nov 21 11:41:33 debian kernel: [55144.204914] [<c103bef8>] ? on_each_cpu+0xc/0x24
Nov 21 11:41:33 debian kernel: [55144.204931] [<c10230c5>] ? change_page_attr_set_clr+0x2d3/0x35f
Nov 21 11:41:33 debian kernel: [55144.204946] [<c102321b>] ? change_page_attr_clear+0x22/0x26
Nov 21 11:41:33 debian kernel: [55144.204961] [<c10232e3>] ? _set_memory_wb+0x13/0x17
Nov 21 11:41:33 debian kernel: [55144.204974] [<c10232f3>] ? set_memory_wb+0xc/0x31
Nov 21 11:41:33 debian kernel: [55144.205039] [<f8eb1a21>] ? ttm_tt_set_page_caching+0x41/0x7b [ttm]
Nov 21 11:41:33 debian kernel: [55144.205073] [<f8eb1cc5>] ? ttm_tt_set_caching+0x4e/0x8a [ttm]
Nov 21 11:41:33 debian kernel: [55144.205105] [<f8eb1d1f>] ? ttm_tt_free_alloced_pages+0x1e/0x88 [ttm]
Nov 21 11:41:33 debian kernel: [55144.205137] [<f8eb2086>] ? ttm_tt_destroy+0x37/0x73 [ttm]
Nov 21 11:41:33 debian kernel: [55144.205169] [<f8eb2628>] ? ttm_bo_release_list+0x67/0x9a [ttm]
Nov 21 11:41:33 debian kernel: [55144.205201] [<f8eb25c1>] ? ttm_bo_release_list+0x0/0x9a [ttm]
Nov 21 11:41:33 debian kernel: [55144.205218] [<c113effa>] ? kref_put+0x36/0x40
Nov 21 11:41:33 debian kernel: [55144.205252] [<f8eb3259>] ? ttm_bo_delayed_delete+0x7b/0xbe [ttm]
Nov 21 11:41:33 debian kernel: [55144.205285] [<f8eb32ac>] ? ttm_bo_delayed_workqueue+0x10/0x23 [ttm]
Nov 21 11:41:33 debian kernel: [55144.205301] [<c104809f>] ? worker_thread+0x141/0x1bd
Nov 21 11:41:33 debian kernel: [55144.205339] [<f8eb329c>] ? ttm_bo_delayed_workqueue+0x0/0x23 [ttm]
Nov 21 11:41:33 debian kernel: [55144.205360] [<c104add6>] ? autoremove_wake_function+0x0/0x2d
Nov 21 11:41:33 debian kernel: [55144.205379] [<c1047f5e>] ? worker_thread+0x0/0x1bd
Nov 21 11:41:33 debian kernel: [55144.205395] [<c104aba4>] ? kthread+0x61/0x66
Nov 21 11:41:33 debian kernel: [55144.205414] [<c104ab43>] ? kthread+0x0/0x66
Nov 21 11:41:33 debian kernel: [55144.205433] [<c1009a67>] ? kernel_thread_helper+0x7/0x10
Nov 21 11:41:33 debian kernel: [55144.205448] ---[ end trace e771b795f7396383 ]---
Kind regards,
--Toni++
Reply to: