[opensuse-kernel] openafs-1.6 kernel-3.1.9 scheduling while atomic
Dear all, after upgrading from opensuse 11.4 to 12.1, I have a strange problem when using openafs (version 1.6 from the repository http://download.opensuse.org/repositories/filesystems ). After some time my pc freezes, no keyboard or mouse action is possible and in order to get the pc working again, I need to do a reset and reboot it. Inspecting the log-messages (/var/log/messages) I find a bug-entry with the line "scheduling while atomic". A sample of this is given here: -------------------------------------------------------------------- Mar 21 22:34:02 lxgeiger2 kernel: [223202.582543] BUG: scheduling while atomic: dsmc/5358/0x00000002 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582554] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntr ack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_cor e edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soun dcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582674] Pid: 5358, comm: dsmc Tainted: P 3.1.9-1.4-desktop #1 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582677] Call Trace: Mar 21 22:34:02 lxgeiger2 kernel: [223202.582698] [<ffffffff810043fa>] dump_trace+0xaa/0x2b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582775] [<ffffffff815843d3>] dump_stack+0x69/0x6f Mar 21 22:34:02 lxgeiger2 kernel: [223202.582784] [<ffffffff8159b90f>] thread_return+0x325/0x356 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582812] [<ffffffffa104c95d>] afs_cv_wait+0x12d/0x2d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582868] [<ffffffffa104b6ed>] rxi_ReadProc+0x1dd/0x4d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582907] [<ffffffffa1050ae6>] xdrrx_getint32+0x16/0x30 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582985] [<ffffffffa105256b>] afs_xdr_char+0x4b/0x70 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583104] [<ffffffffa103eaec>] afs_xdr_vector+0x4c/0x80 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583152] [<ffffffffa10a2d4a>] xdr_uvldbentry+0x2a/0x90 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583331] [<ffffffffa10a28a1>] VL_GetEntryByNameU+0x191/0x1e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583479] [<ffffffffa1098cf4>] afs_NewVolumeByName.isra.0+0x274/0x610 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583650] [<ffffffffa1099418>] afs_GetVolume+0x68/0x80 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583748] [<ffffffffa1081ef1>] afs_GetVCache+0x211/0x5e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583840] [<ffffffffa10823f6>] afs_VerifyVCache2+0x136/0x1e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583932] [<ffffffffa1083422>] afs_access+0x372/0x780 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584051] [<ffffffffa10ac7b2>] afs_linux_permission+0x82/0x110 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584209] [<ffffffff8115e497>] inode_permission+0xb7/0x120 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584217] [<ffffffff81160870>] link_path_walk+0x60/0x8b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584224] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584229] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584236] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584243] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584332] BUG: scheduling while atomic: dsmc/5358/0x00000002 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584338] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_core edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soundcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584431] Pid: 5358, comm: dsmc Tainted: P 3.1.9-1.4-desktop #1 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584434] Call Trace: Mar 21 22:34:02 lxgeiger2 kernel: [223202.584443] [<ffffffff810043fa>] dump_trace+0xaa/0x2b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584448] [<ffffffff815843d3>] dump_stack+0x69/0x6f Mar 21 22:34:02 lxgeiger2 kernel: [223202.584454] [<ffffffff8159b90f>] thread_return+0x325/0x356 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584474] [<ffffffffa104c95d>] afs_cv_wait+0x12d/0x2d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584514] [<ffffffffa104b6ed>] rxi_ReadProc+0x1dd/0x4d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584552] [<ffffffffa1050ae6>] xdrrx_getint32+0x16/0x30 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584602] [<ffffffffa1099df9>] xdr_AFSFetchStatus+0x19/0x80 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584697] [<ffffffffa109c48a>] RXAFS_FetchStatus+0x1ba/0x240 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584797] [<ffffffffa107fa6b>] afs_FetchStatus+0xeb/0x420 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584885] [<ffffffffa1081f5b>] afs_GetVCache+0x27b/0x5e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584974] [<ffffffffa10823f6>] afs_VerifyVCache2+0x136/0x1e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.585119] [<ffffffffa1083422>] afs_access+0x372/0x780 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.585290] [<ffffffffa10ac7b2>] afs_linux_permission+0x82/0x110 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.585437] [<ffffffff8115e497>] inode_permission+0xb7/0x120 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585444] [<ffffffff81160870>] link_path_walk+0x60/0x8b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585450] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585455] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585460] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585466] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:29 lxgeiger2 kernel: [223228.113994] BUG: soft lockup - CPU#1 stuck for 22s! [dsmc:5358] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114000] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_core edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soundcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] CPU 1 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_core edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soundcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Pid: 5358, comm: dsmc Tainted: P 3.1.9-1.4-desktop #1 TYAN COMPUTER S2676/S2676 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RIP: 0010:[<ffffffff8116fdf8>] [<ffffffff8116fdf8>] vfsmount_lock_local_lock+0x38/0x40 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RSP: 0018:ffff880100e8dcf0 EFLAGS: 00000202 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RAX: ffff880137c8fa70 RBX: ffff880100e8de68 RCX: 0000000000002e78 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RDX: 0000000000002e77 RSI: ffff880100e8de68 RDI: ffff88012e084280 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RBP: ffff8800c15df009 R08: 0000000000000000 R09: 67706d2e676e6968 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] R10: 676e696863726167 R11: 0000000000000002 R12: 00ff8801020b3800 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] R13: ffff8801333666c0 R14: ffffffff81000000 R15: ffff8801020b3c00 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] FS: 0000000000000000(0000) GS:ffff880137c80000(0063) knlGS:00000000f54ffb70 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] CS: 0010 DS: 002b ES: 002b CR0: 0000000080050033 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] CR2: 00007f89540060c8 CR3: 000000012ddf7000 CR4: 00000000000006e0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Process dsmc (pid: 5358, threadinfo ffff880100e8c000, task ffff88012886a1c0) Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Stack: Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] ffffffff81171ab6 ffffea0003bead88 ffff880100e8de68 ffff8800c15df009 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] ffffffff81160b6f ffff880130fa3cc0 ffffffff81089311 ffff88012e499540 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] 00000002fffffff5 0000000000e8de00 ffff88012886a1c0 ffff880100e8de78 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Call Trace: Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81171ab6>] mntput_no_expire+0x16/0x100 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81160b6f>] link_path_walk+0x35f/0x8b0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Code: ff ff 01 48 c7 c0 70 fa 00 00 65 48 03 04 25 38 c6 00 00 ba 00 00 01 00 f0 0f c1 10 0f b7 ca c1 ea 10 39 d1 74 07 f3 90 0f b7 08 <eb> f5 c3 0f 1f 44 00 00 65 48 8b 04 25 48 b6 00 00 83 80 44 e0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Call Trace: Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81171ab6>] mntput_no_expire+0x16/0x100 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81160b6f>] link_path_walk+0x35f/0x8b0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:29 lxgeiger2 kernel: [223228.269970] BUG: soft lockup - CPU#3 stuck for 22s! [dsmc:5356] . . . -------------------------------------------------------------------- This "crash" happened in the night and the reset has been done in the morning. There is output almost till the reset. Looking at other "crashes" they always have afs involved in the first call-traces, just as in the case shown above. In that particular case it happened during a backup run with "dsmc", but it in other cases it occured with all different kind of executables including seamonkey, tcsh, ex, awk, sed and others. In all case the call-trace contained the afs-lines with the last being "afs_linux_permission". Has anyone experienced such a problem and does anyone know what the reason could be and how to get openafs working again for me? What else is needed for an analysis of the problem? Any help is appreciated. Best regards, Joachim -- To unsubscribe, e-mail: opensuse-kernel+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse-kernel+owner@opensuse.org
Dear all, after upgrading from opensuse 11.4 to 12.1, I have a strange problem when using openafs (version 1.6 from the repository http://download.opensuse.org/repositories/filesystems ). After some time my pc freezes, no keyboard or mouse action is possible and in order to get the pc working again, I need to do a reset and reboot it. Inspecting the log-messages (/var/log/messages) I find a bug-entry with the line "scheduling while atomic". Thanks for report. This looks like a problem with libafs module from openafs package so I suggest you file a bug in our bugzilla and let openafs
Hi, On Wed 11-04-12 17:27:08, Joachim Geiger wrote: maintainers handle it. Honza
A sample of this is given here: -------------------------------------------------------------------- Mar 21 22:34:02 lxgeiger2 kernel: [223202.582543] BUG: scheduling while atomic: dsmc/5358/0x00000002 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582554] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntr ack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_cor e edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soun dcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582674] Pid: 5358, comm: dsmc Tainted: P 3.1.9-1.4-desktop #1 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582677] Call Trace: Mar 21 22:34:02 lxgeiger2 kernel: [223202.582698] [<ffffffff810043fa>] dump_trace+0xaa/0x2b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582775] [<ffffffff815843d3>] dump_stack+0x69/0x6f Mar 21 22:34:02 lxgeiger2 kernel: [223202.582784] [<ffffffff8159b90f>] thread_return+0x325/0x356 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582812] [<ffffffffa104c95d>] afs_cv_wait+0x12d/0x2d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582868] [<ffffffffa104b6ed>] rxi_ReadProc+0x1dd/0x4d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582907] [<ffffffffa1050ae6>] xdrrx_getint32+0x16/0x30 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582985] [<ffffffffa105256b>] afs_xdr_char+0x4b/0x70 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583104] [<ffffffffa103eaec>] afs_xdr_vector+0x4c/0x80 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583152] [<ffffffffa10a2d4a>] xdr_uvldbentry+0x2a/0x90 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583331] [<ffffffffa10a28a1>] VL_GetEntryByNameU+0x191/0x1e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583479] [<ffffffffa1098cf4>] afs_NewVolumeByName.isra.0+0x274/0x610 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583650] [<ffffffffa1099418>] afs_GetVolume+0x68/0x80 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583748] [<ffffffffa1081ef1>] afs_GetVCache+0x211/0x5e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583840] [<ffffffffa10823f6>] afs_VerifyVCache2+0x136/0x1e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583932] [<ffffffffa1083422>] afs_access+0x372/0x780 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584051] [<ffffffffa10ac7b2>] afs_linux_permission+0x82/0x110 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584209] [<ffffffff8115e497>] inode_permission+0xb7/0x120 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584217] [<ffffffff81160870>] link_path_walk+0x60/0x8b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584224] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584229] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584236] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584243] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584332] BUG: scheduling while atomic: dsmc/5358/0x00000002 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584338] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_core edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soundcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584431] Pid: 5358, comm: dsmc Tainted: P 3.1.9-1.4-desktop #1 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584434] Call Trace: Mar 21 22:34:02 lxgeiger2 kernel: [223202.584443] [<ffffffff810043fa>] dump_trace+0xaa/0x2b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584448] [<ffffffff815843d3>] dump_stack+0x69/0x6f Mar 21 22:34:02 lxgeiger2 kernel: [223202.584454] [<ffffffff8159b90f>] thread_return+0x325/0x356 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584474] [<ffffffffa104c95d>] afs_cv_wait+0x12d/0x2d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584514] [<ffffffffa104b6ed>] rxi_ReadProc+0x1dd/0x4d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584552] [<ffffffffa1050ae6>] xdrrx_getint32+0x16/0x30 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584602] [<ffffffffa1099df9>] xdr_AFSFetchStatus+0x19/0x80 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584697] [<ffffffffa109c48a>] RXAFS_FetchStatus+0x1ba/0x240 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584797] [<ffffffffa107fa6b>] afs_FetchStatus+0xeb/0x420 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584885] [<ffffffffa1081f5b>] afs_GetVCache+0x27b/0x5e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584974] [<ffffffffa10823f6>] afs_VerifyVCache2+0x136/0x1e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.585119] [<ffffffffa1083422>] afs_access+0x372/0x780 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.585290] [<ffffffffa10ac7b2>] afs_linux_permission+0x82/0x110 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.585437] [<ffffffff8115e497>] inode_permission+0xb7/0x120 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585444] [<ffffffff81160870>] link_path_walk+0x60/0x8b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585450] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585455] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585460] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585466] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:29 lxgeiger2 kernel: [223228.113994] BUG: soft lockup - CPU#1 stuck for 22s! [dsmc:5358] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114000] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_core edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soundcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] CPU 1 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_core edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soundcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Pid: 5358, comm: dsmc Tainted: P 3.1.9-1.4-desktop #1 TYAN COMPUTER S2676/S2676 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RIP: 0010:[<ffffffff8116fdf8>] [<ffffffff8116fdf8>] vfsmount_lock_local_lock+0x38/0x40 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RSP: 0018:ffff880100e8dcf0 EFLAGS: 00000202 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RAX: ffff880137c8fa70 RBX: ffff880100e8de68 RCX: 0000000000002e78 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RDX: 0000000000002e77 RSI: ffff880100e8de68 RDI: ffff88012e084280 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RBP: ffff8800c15df009 R08: 0000000000000000 R09: 67706d2e676e6968 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] R10: 676e696863726167 R11: 0000000000000002 R12: 00ff8801020b3800 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] R13: ffff8801333666c0 R14: ffffffff81000000 R15: ffff8801020b3c00 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] FS: 0000000000000000(0000) GS:ffff880137c80000(0063) knlGS:00000000f54ffb70 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] CS: 0010 DS: 002b ES: 002b CR0: 0000000080050033 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] CR2: 00007f89540060c8 CR3: 000000012ddf7000 CR4: 00000000000006e0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Process dsmc (pid: 5358, threadinfo ffff880100e8c000, task ffff88012886a1c0) Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Stack: Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] ffffffff81171ab6 ffffea0003bead88 ffff880100e8de68 ffff8800c15df009 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] ffffffff81160b6f ffff880130fa3cc0 ffffffff81089311 ffff88012e499540 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] 00000002fffffff5 0000000000e8de00 ffff88012886a1c0 ffff880100e8de78 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Call Trace: Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81171ab6>] mntput_no_expire+0x16/0x100 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81160b6f>] link_path_walk+0x35f/0x8b0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Code: ff ff 01 48 c7 c0 70 fa 00 00 65 48 03 04 25 38 c6 00 00 ba 00 00 01 00 f0 0f c1 10 0f b7 ca c1 ea 10 39 d1 74 07 f3 90 0f b7 08 <eb> f5 c3 0f 1f 44 00 00 65 48 8b 04 25 48 b6 00 00 83 80 44 e0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Call Trace: Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81171ab6>] mntput_no_expire+0x16/0x100 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81160b6f>] link_path_walk+0x35f/0x8b0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:29 lxgeiger2 kernel: [223228.269970] BUG: soft lockup - CPU#3 stuck for 22s! [dsmc:5356] . . . -------------------------------------------------------------------- This "crash" happened in the night and the reset has been done in the morning. There is output almost till the reset. Looking at other "crashes" they always have afs involved in the first call-traces, just as in the case shown above. In that particular case it happened during a backup run with "dsmc", but it in other cases it occured with all different kind of executables including seamonkey, tcsh, ex, awk, sed and others. In all case the call-trace contained the afs-lines with the last being "afs_linux_permission". Has anyone experienced such a problem and does anyone know what the reason could be and how to get openafs working again for me? What else is needed for an analysis of the problem? Any help is appreciated. Best regards, Joachim -- To unsubscribe, e-mail: opensuse-kernel+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse-kernel+owner@opensuse.org
--
Jan Kara
Hi, I am sorry for the delay in the answer, however, I had trouble with the hardware. Just after launching my help-request, I got aware of a hard-disk problem which led to a disk replacement, new installation of the OS etc.. With the new disk and the reinstalled OS, I accidentally switched to memory-cache for openafs. The problem did not occur since then. I plan to test openafs again with a separate partition for the cache, but since it is not yet set up this has to wait a bit. At the moment at least it seems that the problem could have been connected to the harddisk problem (read/write-error) which unfortunately must have occured at the same time when I upgraded from opensuse 11.4 to 12.1 I will try to post a follow-up on this hopefully in May. Best regards and thanks for the response, Joachim Am 13.04.2012 11:52, schrieb Jan Kara:
Hi,
Dear all, after upgrading from opensuse 11.4 to 12.1, I have a strange problem when using openafs (version 1.6 from the repository http://download.opensuse.org/repositories/filesystems ). After some time my pc freezes, no keyboard or mouse action is possible and in order to get the pc working again, I need to do a reset and reboot it. Inspecting the log-messages (/var/log/messages) I find a bug-entry with the line "scheduling while atomic". Thanks for report. This looks like a problem with libafs module from openafs package so I suggest you file a bug in our bugzilla and let openafs
On Wed 11-04-12 17:27:08, Joachim Geiger wrote: maintainers handle it.
Honza
A sample of this is given here: -------------------------------------------------------------------- Mar 21 22:34:02 lxgeiger2 kernel: [223202.582543] BUG: scheduling while atomic: dsmc/5358/0x00000002 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582554] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntr ack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_cor e edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soun dcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582674] Pid: 5358, comm: dsmc Tainted: P 3.1.9-1.4-desktop #1 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582677] Call Trace: Mar 21 22:34:02 lxgeiger2 kernel: [223202.582698] [<ffffffff810043fa>] dump_trace+0xaa/0x2b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582775] [<ffffffff815843d3>] dump_stack+0x69/0x6f Mar 21 22:34:02 lxgeiger2 kernel: [223202.582784] [<ffffffff8159b90f>] thread_return+0x325/0x356 Mar 21 22:34:02 lxgeiger2 kernel: [223202.582812] [<ffffffffa104c95d>] afs_cv_wait+0x12d/0x2d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582868] [<ffffffffa104b6ed>] rxi_ReadProc+0x1dd/0x4d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582907] [<ffffffffa1050ae6>] xdrrx_getint32+0x16/0x30 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.582985] [<ffffffffa105256b>] afs_xdr_char+0x4b/0x70 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583104] [<ffffffffa103eaec>] afs_xdr_vector+0x4c/0x80 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583152] [<ffffffffa10a2d4a>] xdr_uvldbentry+0x2a/0x90 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583331] [<ffffffffa10a28a1>] VL_GetEntryByNameU+0x191/0x1e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583479] [<ffffffffa1098cf4>] afs_NewVolumeByName.isra.0+0x274/0x610 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583650] [<ffffffffa1099418>] afs_GetVolume+0x68/0x80 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583748] [<ffffffffa1081ef1>] afs_GetVCache+0x211/0x5e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583840] [<ffffffffa10823f6>] afs_VerifyVCache2+0x136/0x1e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.583932] [<ffffffffa1083422>] afs_access+0x372/0x780 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584051] [<ffffffffa10ac7b2>] afs_linux_permission+0x82/0x110 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584209] [<ffffffff8115e497>] inode_permission+0xb7/0x120 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584217] [<ffffffff81160870>] link_path_walk+0x60/0x8b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584224] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584229] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584236] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584243] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584332] BUG: scheduling while atomic: dsmc/5358/0x00000002 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584338] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_core edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soundcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584431] Pid: 5358, comm: dsmc Tainted: P 3.1.9-1.4-desktop #1 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584434] Call Trace: Mar 21 22:34:02 lxgeiger2 kernel: [223202.584443] [<ffffffff810043fa>] dump_trace+0xaa/0x2b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584448] [<ffffffff815843d3>] dump_stack+0x69/0x6f Mar 21 22:34:02 lxgeiger2 kernel: [223202.584454] [<ffffffff8159b90f>] thread_return+0x325/0x356 Mar 21 22:34:02 lxgeiger2 kernel: [223202.584474] [<ffffffffa104c95d>] afs_cv_wait+0x12d/0x2d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584514] [<ffffffffa104b6ed>] rxi_ReadProc+0x1dd/0x4d0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584552] [<ffffffffa1050ae6>] xdrrx_getint32+0x16/0x30 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584602] [<ffffffffa1099df9>] xdr_AFSFetchStatus+0x19/0x80 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584697] [<ffffffffa109c48a>] RXAFS_FetchStatus+0x1ba/0x240 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584797] [<ffffffffa107fa6b>] afs_FetchStatus+0xeb/0x420 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584885] [<ffffffffa1081f5b>] afs_GetVCache+0x27b/0x5e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.584974] [<ffffffffa10823f6>] afs_VerifyVCache2+0x136/0x1e0 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.585119] [<ffffffffa1083422>] afs_access+0x372/0x780 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.585290] [<ffffffffa10ac7b2>] afs_linux_permission+0x82/0x110 [libafs] Mar 21 22:34:02 lxgeiger2 kernel: [223202.585437] [<ffffffff8115e497>] inode_permission+0xb7/0x120 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585444] [<ffffffff81160870>] link_path_walk+0x60/0x8b0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585450] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585455] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585460] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:02 lxgeiger2 kernel: [223202.585466] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:29 lxgeiger2 kernel: [223228.113994] BUG: soft lockup - CPU#1 stuck for 22s! [dsmc:5358] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114000] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_core edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soundcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] CPU 1 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Modules linked in: libafs(P) nls_iso8859_1 nls_cp437 vfat fat des_generic ecb md4 md5 nls_utf8 cifs parport_pc st af_packet joydev dm_mod ip6t_LOG xt_tcpudp xt_pkttype ipt_LOG xt_limit snd_pcm_oss snd_mixer_oss snd_seq snd_seq_device edd vmnet fuse vsock vmci nfs lockd fscache auth_rpcgss nfs_acl sunrpc vmmon ip6t_REJECT nf_conntrack_ipv6 nf_defrag_ipv6 ip6table_raw xt_NOTRACK ipt_REJECT iptable_raw iptable_filter ip6table_mangle nf_conntrack_netbios_ns nf_conntrack_broadcast nf_conntrack_ipv4 nf_defrag_ipv4 ip_tables xt_conntrack nf_conntrack ip6table_filter ip6_tables x_tables microcode mperf nvidia(P) ppdev sr_mod e752x_edac firewire_ohci parport firewire_core edac_core cdrom floppy container button iTCO_wdt iTCO_vendor_support tg3 tulip sg pcspkr i2c_i801 crc_itu_t snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm shpchp snd_timer snd soundcore snd_page_alloc pci_hotplug processor thermal_sys ata_generic [last unloaded: ppa] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Pid: 5358, comm: dsmc Tainted: P 3.1.9-1.4-desktop #1 TYAN COMPUTER S2676/S2676 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RIP: 0010:[<ffffffff8116fdf8>] [<ffffffff8116fdf8>] vfsmount_lock_local_lock+0x38/0x40 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RSP: 0018:ffff880100e8dcf0 EFLAGS: 00000202 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RAX: ffff880137c8fa70 RBX: ffff880100e8de68 RCX: 0000000000002e78 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RDX: 0000000000002e77 RSI: ffff880100e8de68 RDI: ffff88012e084280 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] RBP: ffff8800c15df009 R08: 0000000000000000 R09: 67706d2e676e6968 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] R10: 676e696863726167 R11: 0000000000000002 R12: 00ff8801020b3800 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] R13: ffff8801333666c0 R14: ffffffff81000000 R15: ffff8801020b3c00 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] FS: 0000000000000000(0000) GS:ffff880137c80000(0063) knlGS:00000000f54ffb70 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] CS: 0010 DS: 002b ES: 002b CR0: 0000000080050033 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] CR2: 00007f89540060c8 CR3: 000000012ddf7000 CR4: 00000000000006e0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Process dsmc (pid: 5358, threadinfo ffff880100e8c000, task ffff88012886a1c0) Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Stack: Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] ffffffff81171ab6 ffffea0003bead88 ffff880100e8de68 ffff8800c15df009 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] ffffffff81160b6f ffff880130fa3cc0 ffffffff81089311 ffff88012e499540 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] 00000002fffffff5 0000000000e8de00 ffff88012886a1c0 ffff880100e8de78 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Call Trace: Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81171ab6>] mntput_no_expire+0x16/0x100 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81160b6f>] link_path_walk+0x35f/0x8b0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Code: ff ff 01 48 c7 c0 70 fa 00 00 65 48 03 04 25 38 c6 00 00 ba 00 00 01 00 f0 0f c1 10 0f b7 ca c1 ea 10 39 d1 74 07 f3 90 0f b7 08<eb> f5 c3 0f 1f 44 00 00 65 48 8b 04 25 48 b6 00 00 83 80 44 e0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] Call Trace: Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81171ab6>] mntput_no_expire+0x16/0x100 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81160b6f>] link_path_walk+0x35f/0x8b0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81162bcd>] path_openat+0xbd/0x3f0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff81163025>] do_filp_open+0x45/0xb0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff811527d7>] do_sys_open+0xf7/0x1d0 Mar 21 22:34:29 lxgeiger2 kernel: [223228.114001] [<ffffffff815a7493>] ia32_do_call+0x13/0x13 Mar 21 22:34:29 lxgeiger2 kernel: [223228.269970] BUG: soft lockup - CPU#3 stuck for 22s! [dsmc:5356] . . . -------------------------------------------------------------------- This "crash" happened in the night and the reset has been done in the morning. There is output almost till the reset. Looking at other "crashes" they always have afs involved in the first call-traces, just as in the case shown above. In that particular case it happened during a backup run with "dsmc", but it in other cases it occured with all different kind of executables including seamonkey, tcsh, ex, awk, sed and others. In all case the call-trace contained the afs-lines with the last being "afs_linux_permission". Has anyone experienced such a problem and does anyone know what the reason could be and how to get openafs working again for me? What else is needed for an analysis of the problem? Any help is appreciated. Best regards, Joachim -- To unsubscribe, e-mail: opensuse-kernel+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse-kernel+owner@opensuse.org
-- Joachim Geiger --------------------------------@\\ Max-Planck-Institute for Plasma Physics, @\\ Euratom Association \\\ Department Stellaratortheorie (ST) \\\__ Wendelsteinstr. 1 ( \\ \ D-17491 Greifswald, Germany \_ \\(_ Tel.: ++49 3834/88-2327 Fax: ++49 3834/88-2409 ) \\ \ e-mail: joachim.geiger@ipp.mpg.de \ - | --------------------------------------------------- \____/ -- To unsubscribe, e-mail: opensuse-kernel+unsubscribe@opensuse.org To contact the owner, e-mail: opensuse-kernel+owner@opensuse.org
participants (2)
-
Jan Kara -
Joachim Geiger