On Sun, Dec 21, 2008 at 12:37:27AM +0100, Moritz Muehlenhoff wrote: > On Mon, Mar 24, 2008 at 03:59:51PM +0100, Lionel Elie Mamane wrote:
>> Further experience shows that the errors / lockups come only after >> using the mISDN ports; it may not be a bug in the kernel proper, only >> mISDN somehow corrupting an internal data structure which leads to the >> lockup later. It may also be a problem of the sort that mISDN calls >> some kernel interface incorrectly, which corrupts said data >> structure. Frankly, I don't know. > Does this error still occur with the Lenny kernel? Yes. syslog entries attached. > If so, you could try 2.6.28, since misdn has been merged into > mainline since 2.6.27. The mISDN merged into 2.6.27 is mISDN v2, while the problem appears with mISDN v1.1.8~git.20081226 (and previous versions of mISDN). And the userspace application that triggers the problem (asterisk with chan_misdn) does not yet support mISDN v2. It is not really a big problem for me anyway, because I can just use zaptel/dahdi instead of mISDN to do what I need to do with the hardware... -- Lionel
[7745018.127033] kobject (ffff81007c8b59a8): tried to init an initialized object, something is seriously wrong. [7745018.138150] Pid: 11304, comm: mISDNd Not tainted 2.6.26-1-amd64 #1 [7745018.145374] [7745018.145375] Call Trace: [7745018.149690] [<ffffffff8031acea>] kobject_init+0x39/0x69 [7745018.155183] [<ffffffff803829d2>] device_initialize+0x25/0xb5 [7745018.161107] [<ffffffff8038322e>] device_register+0x9/0x12 [7745018.169119] [<ffffffffa02c15bb>] :mISDN_core:mISDN_register_sysfs_inst+0x3b/0x8c [7745018.176784] [<ffffffffa02bbda3>] :mISDN_core:register_layer+0x202/0x22f [7745018.183767] [<ffffffffa02ba345>] :mISDN_core:mISDN_ctrl+0x12c/0x5e4 [7745018.189446] [<ffffffffa02bb4ca>] :mISDN_core:set_stack+0x104/0x214 [7745018.195986] [<ffffffffa02ba502>] :mISDN_core:mISDN_ctrl+0x2e9/0x5e4 [7745018.202426] [<ffffffffa02baf8f>] :mISDN_core:mISDNd+0x15d/0x26e [7745018.210418] [<ffffffff80246021>] autoremove_wake_function+0x0/0x2e [7745018.216869] [<ffffffff8020cef8>] child_rip+0xa/0x12 [7745018.222027] [<ffffffffa02bae32>] :mISDN_core:mISDNd+0x0/0x26e [7745018.226755] [<ffffffff8020ceee>] child_rip+0x0/0x12 [7745018.234757] [7745064.275911] DSS1 1 Restart 80 [7745064.275911] DSS1 1 Resetting channel [7745064.275911] [7745145.303899] kobject (ffff81007c8b59a8): tried to init an initialized object, something is seriously wrong. [7745145.311905] Pid: 11304, comm: mISDNd Not tainted 2.6.26-1-amd64 #1 [7745145.321928] [7745145.321929] Call Trace: [7745145.327784] [<ffffffff8031acea>] kobject_init+0x39/0x69 [7745145.333272] [<ffffffff803829d2>] device_initialize+0x25/0xb5 [7745145.339190] [<ffffffff8038322e>] device_register+0x9/0x12 [7745145.345575] [<ffffffffa02c15bb>] :mISDN_core:mISDN_register_sysfs_inst+0x3b/0x8c [7745145.353630] [<ffffffffa02bbda3>] :mISDN_core:register_layer+0x202/0x22f [7745145.361861] [<ffffffffa02ba345>] :mISDN_core:mISDN_ctrl+0x12c/0x5e4 [7745145.368310] [<ffffffffa02bb4ca>] :mISDN_core:set_stack+0x104/0x214 [7745145.374850] [<ffffffffa02ba502>] :mISDN_core:mISDN_ctrl+0x2e9/0x5e4 [7745145.381307] [<ffffffffa02baf8f>] :mISDN_core:mISDNd+0x15d/0x26e [7745145.387838] [<ffffffff80246021>] autoremove_wake_function+0x0/0x2e [7745145.395221] [<ffffffff8020cef8>] child_rip+0xa/0x12 [7745145.400686] [<ffffffffa02bae32>] :mISDN_core:mISDNd+0x0/0x26e [7745145.406690] [<ffffffff8020ceee>] child_rip+0x0/0x12 [7745145.412908] [7745375.304808] kobject (ffff81007c8b59a8): tried to init an initialized object, something is seriously wrong. [7745375.312814] Pid: 11304, comm: mISDNd Not tainted 2.6.26-1-amd64 #1 [7745375.322870] [7745375.322871] Call Trace: [7745375.328691] [<ffffffff8031acea>] kobject_init+0x39/0x69 [7745375.334181] [<ffffffff803829d2>] device_initialize+0x25/0xb5 [7745375.338474] [<ffffffff8038322e>] device_register+0x9/0x12 [7745375.344150] [<ffffffffa02c15bb>] :mISDN_core:mISDN_register_sysfs_inst+0x3b/0x8c [7745375.352916] [<ffffffffa02bbda3>] :mISDN_core:register_layer+0x202/0x22f [7745375.361147] [<ffffffffa02ba345>] :mISDN_core:mISDN_ctrl+0x12c/0x5e4 [7745375.367683] [<ffffffffa02bb4ca>] :mISDN_core:set_stack+0x104/0x214 [7745375.374573] [<ffffffffa02ba502>] :mISDN_core:mISDN_ctrl+0x2e9/0x5e4 [7745375.381030] [<ffffffffa02baf8f>] :mISDN_core:mISDNd+0x15d/0x26e [7745375.387563] [<ffffffff80246021>] autoremove_wake_function+0x0/0x2e [7745375.394921] [<ffffffff8020cef8>] child_rip+0xa/0x12 [7745375.400388] [<ffffffffa02bae32>] :mISDN_core:mISDNd+0x0/0x26e [7745375.406392] [<ffffffff8020ceee>] child_rip+0x0/0x12 [7745375.412606] [7745389.630812] kobject (ffff81007c8b59a8): tried to init an initialized object, something is seriously wrong. [7745389.645530] Pid: 11304, comm: mISDNd Not tainted 2.6.26-1-amd64 #1 [7745389.653530] [7745389.653531] Call Trace: [7745389.656584] [<ffffffff8031acea>] kobject_init+0x39/0x69 [7745389.662079] [<ffffffff803829d2>] device_initialize+0x25/0xb5 [7745389.668003] [<ffffffff8038322e>] device_register+0x9/0x12 [7745389.673677] [<ffffffffa02c15bb>] :mISDN_core:mISDN_register_sysfs_inst+0x3b/0x8c [7745389.685888] [<ffffffffa02bbda3>] :mISDN_core:register_layer+0x202/0x22f [7745389.693554] [<ffffffffa02ba345>] :mISDN_core:mISDN_ctrl+0x12c/0x5e4 [7745389.700099] [<ffffffffa02bb4ca>] :mISDN_core:set_stack+0x104/0x214 [7745389.706564] [<ffffffffa02ba502>] :mISDN_core:mISDN_ctrl+0x2e9/0x5e4 [7745389.713107] [<ffffffffa02baf8f>] :mISDN_core:mISDNd+0x15d/0x26e [7745389.719305] [<ffffffff80246021>] autoremove_wake_function+0x0/0x2e [7745389.729262] [<ffffffff8020cef8>] child_rip+0xa/0x12 [7745389.734423] [<ffffffffa02bae32>] :mISDN_core:mISDNd+0x0/0x26e [7745389.740432] [<ffffffff8020ceee>] child_rip+0x0/0x12 [7745389.745578] [7745389.747363] kobject_add_internal failed for inst-50010102 with -EEXIST, don't try to register things with the same name in the same directory. [7745389.763010] Pid: 11304, comm: mISDNd Not tainted 2.6.26-1-amd64 #1 [7745389.771010] [7745389.771011] Call Trace: [7745389.775307] [<ffffffff8031b031>] kobject_add_internal+0x13f/0x17e [7745389.781722] [<ffffffff8031b46e>] kobject_add+0x74/0x7c [7745389.787130] [<ffffffff8031f2ee>] snprintf+0x44/0x4c [7745389.791031] [<ffffffff802e2470>] sysfs_addrm_finish+0x19/0x1ea [7745389.798643] [<ffffffff802e21b4>] sysfs_find_dirent+0x1b/0x2f [7745389.804551] [<ffffffff8031ae88>] kobject_get+0x12/0x17 [7745389.810669] [<ffffffff80382771>] get_device+0x17/0x20 [7745389.816349] [<ffffffff80382d81>] device_add+0x9b/0x53f [7745389.821754] [<ffffffff8031acf2>] kobject_init+0x41/0x69 [7745389.827261] [<ffffffffa02c15bb>] :mISDN_core:mISDN_register_sysfs_inst+0x3b/0x8c [7745389.840040] [<ffffffffa02bbda3>] :mISDN_core:register_layer+0x202/0x22f [7745389.846925] [<ffffffffa02ba336>] :mISDN_core:mISDN_ctrl+0x11d/0x5e4 [7745389.853473] [<ffffffffa02bbeb2>] :mISDN_core:get_instance+0xe2/0x1ae [7745389.862917] [<ffffffffa041d6bc>] :mISDN_dsp:dsp_manager+0x289/0x3a6 [7745389.869460] [<ffffffffa02ba89a>] :mISDN_core:get_next_instance+0x32/0x158 [7745389.877228] [<ffffffffa02bb532>] :mISDN_core:set_stack+0x16c/0x214 [7745389.883765] [<ffffffffa02ba502>] :mISDN_core:mISDN_ctrl+0x2e9/0x5e4 [7745389.890529] [<ffffffffa02baf8f>] :mISDN_core:mISDNd+0x15d/0x26e [7745389.896726] [<ffffffff80246021>] autoremove_wake_function+0x0/0x2e [7745389.903176] [<ffffffff8020cef8>] child_rip+0xa/0x12 [7745389.908340] [<ffffffffa02bae32>] :mISDN_core:mISDNd+0x0/0x26e [7745389.915997] [<ffffffff8020ceee>] child_rip+0x0/0x12 [7745389.921144] [7745389.925139] register_layer: register_sysfs failed -17 st(10010100) inst(50010102) [7745390.157122] BUG: unable to handle kernel NULL pointer dereference at 0000000000000028 [7745390.165120] IP: [<ffffffff802e21a2>] sysfs_find_dirent+0x9/0x2f [7745390.165120] PGD 5e042067 PUD 24081067 PMD 0 [7745390.165120] Oops: 0000 [1] SMP [7745390.165120] CPU 0 [7745390.165120] Modules linked in: tcp_diag inet_diag mISDN_dsp_kb1ec mISDN_dsp_mg2ec mISDN_dsp_mec2 mISDN_dsp hfcmulti mISDN_capi l3udss1 mISDN_l2 mISDN_l1 mISDN_core capi capifs kernelcapi ppdev parport_pc lp parport tun sit tunnel4 ac battery xt_state ipt_MASQUERADE xt_tcpudp ipt_LOG iptable_mangle iptable_filter iptable_nat ip_tables nf_nat x_tables nf_conntrack_ipv4 nf_conntrack deflate zlib_deflate zlib_inflate ctr twofish twofish_common camellia serpent blowfish des_generic cbc aes_x86_64 aes_generic xcbc sha256_generic sha1_generic crypto_null crypto_blkcipher af_key ext2 eeprom ipv6 8021q snd_hda_intel snd_pcm_oss snd_mixer_oss snd_pcm floppy snd_timer k8temp pcspkr snd soundcore snd_page_alloc sg i2c_nforce2 button sr_mod i2c_core cdrom evdev ext3 jbd mbcache dm_mirror dm_log dm_snapshot dm_mod ide_generic sd_mod ata_generic forcedeth sata_nv libata ohci1394 amd74xx scsi_mod dock ehci_hcd ieee1394 ide_core ohci_hcd thermal processor fan thermal_sys [last unloaded: crc_ccitt] [7745390.266022] Pid: 19914, comm: asterisk Not tainted 2.6.26-1-amd64 #1 [7745390.266022] RIP: 0010:[<ffffffff802e21a2>] [<ffffffff802e21a2>] sysfs_find_dirent+0x9/0x2f [7745390.266022] RSP: 0018:ffff81005e125a48 EFLAGS: 00010296 [7745390.266022] RAX: 0000000000000007 RBX: ffffffff804ad49f RCX: 00000000fffffffb [7745390.266022] RDX: ffff81005e125817 RSI: ffffffff804ad49f RDI: 0000000000000000 [7745390.266022] RBP: ffffffff804ad49f R08: 0000000000000000 R09: ffff81005e125800 [7745390.266022] R10: 0000000000000000 R11: ffff81005e125dc8 R12: 0000000000000000 [7745390.266022] R13: ffff8100525a1dc0 R14: ffff810037902c00 R15: 00007f2d340e8fc0 [7745390.266022] FS: 0000000042fd5950(0063) GS:ffffffff8053b000(0000) knlGS:0000000000000000 [7745390.266022] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b [7745390.266022] CR2: 0000000000000028 CR3: 000000002f110000 CR4: 00000000000006e0 [7745390.266022] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [7745390.266022] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400 [7745390.266022] Process asterisk (pid: 19914, threadinfo ffff81005e124000, task ffff81007c8326d0) [7745390.266022] Stack: 0000000000000002 ffffffff804ad49f 0000000000000000 ffffffff802e2c35 [7745390.266022] ffff81005e125eb8 ffff8100525a1cd0 ffffffff8051b5e0 ffffffff802e3506 [7745390.266022] 0000000000000000 ffff8100525a1cd0 ffff8100525a1c18 0000000000000000 [7745390.266022] Call Trace: [7745390.266022] [<ffffffff802e2c35>] ? sysfs_get_dirent+0x24/0x59 [7745390.266022] [<ffffffff802e3506>] ? sysfs_remove_group+0x24/0xc2 [7745390.266022] [<ffffffff80387647>] ? device_pm_remove+0x18/0x49 [7745390.266022] [<ffffffff80382b40>] ? device_del+0x13/0x15d [7745390.266022] [<ffffffff80382c93>] ? device_unregister+0x9/0x12 [7745390.266022] [<ffffffffa02c157a>] ? :mISDN_core:mISDN_unregister_sysfs_inst+0x3e/0x44 [7745390.266022] [<ffffffffa02bb629>] ? :mISDN_core:unregister_instance+0x4f/0x215 [7745390.266022] [<ffffffffa02ba36c>] ? :mISDN_core:mISDN_ctrl+0x153/0x5e4 [7745390.266022] [<ffffffffa02bdac3>] ? :mISDN_core:del_layer+0x162/0x1e4 [7745390.266022] [<ffffffffa02befd6>] ? :mISDN_core:mISDN_write+0xa3b/0x114a [7745390.266022] [<ffffffff8022bdf5>] ? task_rq_lock+0x4d/0x7f [7745390.266022] [<ffffffff8022c184>] ? try_to_wake_up+0x118/0x129 [7745390.266022] [<ffffffff80228429>] ? __wake_up_common+0x41/0x74 [7745390.266022] [<ffffffff802aaf62>] ? __d_lookup+0xb3/0xfb [7745390.266022] [<ffffffff802a19e6>] ? do_lookup+0x63/0x1c1 [7745390.266022] [<ffffffff802aa6cc>] ? dput+0x1c/0xdd [7745390.266022] [<ffffffff802a3f05>] ? __link_path_walk+0xbc7/0xd05 [7745390.266022] [<ffffffff803af30f>] ? sock_aio_write+0xf8/0x110 [7745390.266022] [<ffffffff802a76ef>] ? core_sys_select+0x213/0x264 [7745390.266022] [<ffffffff802af641>] ? mntput_no_expire+0x20/0x117 [7745390.266022] [<ffffffff8029db7d>] ? cp_new_stat+0xe7/0xff [7745390.266022] [<ffffffff8029b1dd>] ? vfs_write+0xad/0x156 [7745390.266022] [<ffffffff8029b77f>] ? sys_write+0x45/0x6e [7745390.266022] [<ffffffff8020be9a>] ? system_call_after_swapgs+0x8a/0x8f [7745390.266022] [7745390.266022] [7745390.266022] Code: 0f 0b eb fe 48 8b 48 38 48 39 4f 38 72 0c 48 8d 50 10 48 8b 02 48 85 c0 75 ea 48 89 47 10 48 89 3a c3 55 48 89 f5 53 48 83 ec 08 <48> 8b 5f 28 eb 14 48 8b 7b 18 48 89 ee e8 e6 b9 03 00 85 c0 74 [7745390.266022] RIP [<ffffffff802e21a2>] sysfs_find_dirent+0x9/0x2f [7745390.266022] RSP <ffff81005e125a48> [7745390.266022] CR2: 0000000000000028 [7745390.605044] ---[ end trace a2cf1c4e908a2401 ]--- [7745561.157519] general protection fault: 0000 [2] SMP [7745561.161515] CPU 1 [7745561.161515] Modules linked in: tcp_diag inet_diag mISDN_dsp_kb1ec mISDN_dsp_mg2ec mISDN_dsp_mec2 mISDN_dsp hfcmulti mISDN_capi l3udss1 mISDN_l2 mISDN_l1 mISDN_core capi capifs kernelcapi ppdev parport_pc lp parport tun sit tunnel4 ac battery xt_state ipt_MASQUERADE xt_tcpudp ipt_LOG iptable_mangle iptable_filter iptable_nat ip_tables nf_nat x_tables nf_conntrack_ipv4 nf_conntrack deflate zlib_deflate zlib_inflate ctr twofish twofish_common camellia serpent blowfish des_generic cbc aes_x86_64 aes_generic xcbc sha256_generic sha1_generic crypto_null crypto_blkcipher af_key ext2 eeprom ipv6 8021q snd_hda_intel snd_pcm_oss snd_mixer_oss snd_pcm floppy snd_timer k8temp pcspkr snd soundcore snd_page_alloc sg i2c_nforce2 button sr_mod i2c_core cdrom evdev ext3 jbd mbcache dm_mirror dm_log dm_snapshot dm_mod ide_generic sd_mod ata_generic forcedeth sata_nv libata ohci1394 amd74xx scsi_mod dock ehci_hcd ieee1394 ide_core ohci_hcd thermal processor fan thermal_sys [last unloaded: crc_ccitt] [7745561.161515] Pid: 6938, comm: aiccu Tainted: G D 2.6.26-1-amd64 #1 [7745561.161515] RIP: 0010:[<ffffffff803d0f82>] [<ffffffff803d0f82>] netlink_autobind+0x6d/0xac [7745561.161515] RSP: 0018:ffff81007c92fe78 EFLAGS: 00010002 [7745561.161515] RAX: 6c2f343662696c2f RBX: 0000000000001b1a RCX: 000000002dbf9400 [7745561.161515] RDX: 000000000000e833 RSI: 00000000b20b6fe5 RDI: ffff81007fba8000 [7745561.161515] RBP: ffff81007fba8000 R08: 0000000000000028 R09: ffff81007ad35ac0 [7745561.161515] R10: 0000000000000000 R11: ffffffff802f1f8a R12: ffff81007dcf3800 [7745561.161515] R13: 00007fffb2783b80 R14: 00007fffb2783d5f R15: 00007fffb2783d5e [7745561.161515] FS: 00007f7baa6626e0(0000) GS:ffff81007fb7d9c0(0000) knlGS:0000000000000000 [7745561.161515] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b [7745561.161515] CR2: 00007fb30a72d650 CR3: 000000007dd16000 CR4: 00000000000006e0 [7745561.161515] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [7745561.161515] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400 [7745561.161515] Process aiccu (pid: 6938, threadinfo ffff81007c92e000, task ffff81007f206a50) [7745561.161515] Stack: ffff81007ad35ac0 ffff81007dcf3800 ffff81007c92fec8 ffffffff803d2330 [7745561.161515] 0000000000000000 ffff81007ad35ac0 000000000000000c 00007fffb2783d40 [7745561.161515] 00007fffb2783b80 ffffffff803b066d 0000000000000010 ffffffff00000000 [7745561.161515] Call Trace: [7745561.161515] [<ffffffff803d2330>] ? netlink_bind+0x9a/0x134 [7745561.161515] [<ffffffff803b066d>] ? sys_bind+0x6e/0x9e [7745561.161515] [<ffffffff802ab1a0>] ? d_instantiate+0x52/0x67 [7745561.161515] [<ffffffff803af75c>] ? sock_attach_fd+0x84/0xaf [7745561.161515] [<ffffffff802991b5>] ? fd_install+0x25/0x56 [7745561.161515] [<ffffffff803af7d6>] ? sock_map_fd+0x4f/0x5a [7745561.161515] [<ffffffff8020be9a>] ? system_call_after_swapgs+0x8a/0x8f [7745561.161515] [7745561.161515] [7745561.161515] Code: 1d ac 1b 15 00 b8 ff ef ff ff 8d 53 ff 81 fa 00 f0 ff ff 0f 4c c2 89 05 95 1b 15 00 e8 c7 f8 ff ff eb c3 48 89 d0 48 85 c0 74 10 <39> 98 40 02 00 00 48 8b 10 0f 18 0a 75 ea eb c4 e8 a8 f8 ff ff [7745561.161515] RIP [<ffffffff803d0f82>] netlink_autobind+0x6d/0xac [7745561.161515] RSP <ffff81007c92fe78> [7745561.161515] ---[ end trace a2cf1c4e908a2401 ]---