On 23 October 2011 21:41, Alan Stern <stern@xxxxxxxxxxxxxxxxxxx> wrote: > > The type of system doesn't matter; what matters is the USB hardware. > The usbmon trace shows that the modem gets disconnected whenever the > OHCI controller on the AMD system issues a reset. This could be the > fault of the modem or of the controller. > > Do any other full-speed devices work on this system? Actually, a few USB disk drives have been connected to this system in the past (to the same USB port as well). Even now one USB Disk Drive is connected. I am not sure if it is full speed or not. How does one check that? Further I tried connecting another USB modem to the same system. The dmesg log when I connected the modem is as follows: [82869.475111] hub 2-0:1.0: unable to enumerate USB device on port 1 [82869.791769] hub 4-0:1.0: unable to enumerate USB device on port 1 [82870.138438] hub 2-0:1.0: unable to enumerate USB device on port 1 [82870.408438] hub 2-0:1.0: unable to enumerate USB device on port 1 [82870.668437] hub 2-0:1.0: unable to enumerate USB device on port 1 [82870.988871] hub 4-0:1.0: unable to enumerate USB device on port 1 [82871.215110] hub 2-0:1.0: unable to enumerate USB device on port 1 [82872.081784] hub 2-0:1.0: unable to enumerate USB device on port 1 [82925.208420] usb 3-2: new full speed USB device number 102 using ohci_hcd [82925.408229] scsi183 : usb-storage 3-2:1.0 [82926.416938] scsi 183:0:0:0: CD-ROM ZTE USB Storage FFF1 2.31 PQ: 0 ANSI: 2 [82926.450873] sr1: scsi-1 drive [82926.451482] sr 183:0:0:0: Attached scsi CD-ROM sr1 [82926.451777] sr 183:0:0:0: Attached scsi generic sg3 type 5 [82926.458379] scsi 183:0:0:1: Direct-Access ZTE USB Storage FFF1 2.31 PQ: 0 ANSI: 2 [82926.459088] sd 183:0:0:1: Attached scsi generic sg4 type 0 [82926.514865] sd 183:0:0:1: [sdc] Attached SCSI removable disk [82926.799271] BUG: unable to handle kernel NULL pointer dereference at 00000004 [82926.800459] IP: [<f8534f07>] sd_revalidate_disk+0x27/0x1cb0 [sd_mod] [82926.801706] *pde = 00000000 [82926.801738] Oops: 0000 [#1] PREEMPT SMP [82926.803298] Modules linked in: usbmon usb_storage uas fuse nfsd exportfs appletalk ipx p8022 psnap llc p8023 ipt_REJECT xt_tcpudp nf_conntrack_ipv4 nf_defrag_ipv4 xt_state nf_conntrack ipv6 iptable_filter ip_tables x_tables rfcomm bnep nvidia(P) btusb bluetooth snd_hda_intel snd_hda_codec r852 uvcvideo sm_common nand videodev nand_ids snd_hwdep snd_pcm snd_timer snd sg media nand_ecc soundcore arc4 firewire_ohci crc16 joydev ath5k snd_page_alloc evdev mtd sdhci_pci sdhci mmc_core r592 firewire_core serio_raw i2c_nforce2 agpgart memstick ath forcedeth crc_itu_t i2c_core pcspkr acer_wmi mac80211 psmouse cfg80211 k8temp thermal sparse_keymap rfkill wmi battery video ac button nfs lockd fscache auth_rpcgss nfs_acl sunrpc cpufreq_powersave cpufreq_ondemand powernow_k8 freq_table processor mperf ext3 jbd mbcache sr_mod sd_mod cdrom pata_acpi ohci_hcd pata_amd ahci libahci libata ehci_hcd scsi_mod usbcore [82926.807678] [82926.807678] Pid: 25337, comm: blkid Tainted: P 3.0-ARCH #1 Acer, inc. Aspire 4520 /Mono [82926.807678] EIP: 0060:[<f8534f07>] EFLAGS: 00010246 CPU: 1 [82926.807678] EIP is at sd_revalidate_disk+0x27/0x1cb0 [sd_mod] [82926.807678] EAX: 00000000 EBX: f52f4e10 ECX: 00000001 EDX: 00000000 [82926.807678] ESI: f3a50860 EDI: f3a50800 EBP: f433dd38 ESP: f433dcac [82926.807678] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 [82926.807678] Process blkid (pid: 25337, ti=f433c000 task=f3b90470 task.ti=f433c000) [82926.807678] Stack: [82926.807678] c02bf1dd 00000002 00000296 f822c04d f433dcdc c022faea f52f4e90 c0246740 [82926.807678] f676cf14 f3a5083c f676cf14 f5404600 f433dcfc c0230680 f433dd0c f3a5083c [82926.807678] f3a50800 f433dd10 c02bf1dd f3a50800 f433dd10 f52f4e90 00000000 f433dd20 [82926.807678] Call Trace: [82926.807678] [<c02bf1dd>] ? kobject_put+0x1d/0x50 [82926.807678] [<f822c04d>] ? scsi_device_dev_release_usercontext+0x13d/0x160 [scsi_mod] [82926.873463] [<c022faea>] ? find_inode+0x8a/0x90 [82926.873463] [<c0246740>] ? I_BDEV+0x10/0x10 [82926.873463] [<c0230680>] ? iget5_locked+0x70/0x180 [82926.873463] [<c02bf1dd>] ? kobject_put+0x1d/0x50 [82926.873463] [<c02307c1>] ? iput+0x31/0x180 [82926.873463] [<c02b0ca7>] ? disk_part_iter_next+0x97/0xe0 [82926.873463] [<c026d7a2>] rescan_partitions+0x82/0x560 [82926.873463] [<c02bf1dd>] ? kobject_put+0x1d/0x50 [82926.873463] [<f8221007>] ? scsi_device_put+0x47/0x50 [scsi_mod] [82926.873463] [<c0452bcd>] ? mutex_unlock+0xd/0x10 [82926.873463] [<f85329d9>] ? scsi_disk_put+0x39/0x50 [sd_mod] [82926.873463] [<c0247f83>] __blkdev_get+0x263/0x3b0 [82926.873463] [<c024811b>] blkdev_get+0x4b/0x2b0 [82926.873463] [<c0246760>] ? bdev_test+0x20/0x20 [82926.873463] [<c02483d3>] blkdev_open+0x53/0x70 [82926.873463] [<c0217c41>] __dentry_open+0x141/0x320 [82926.873463] [<c0218fee>] nameidata_to_filp+0x6e/0x80 [82926.873463] [<c0248380>] ? blkdev_get+0x2b0/0x2b0 [82926.873463] [<c0225f37>] do_last+0x2a7/0x810 [82926.873463] [<c02270cd>] path_openat+0x9d/0x350 [82926.873463] [<c01efe11>] ? handle_pte_fault+0xe1/0x8e0 [82926.873463] [<c02273b1>] do_filp_open+0x31/0x80 [82926.873463] [<c0232253>] ? alloc_fd+0xa3/0xe0 [82926.873463] [<c0223a85>] ? getname_flags+0xf5/0x130 [82926.873463] [<c02190e6>] do_sys_open+0xe6/0x1b0 [82926.873463] [<c02191de>] sys_open+0x2e/0x40 [82926.873463] [<c0454bdf>] sysenter_do_call+0x12/0x28 [82926.873463] Code: 90 90 90 90 55 89 e5 57 56 53 83 c4 80 3e 8d 74 26 00 31 d2 89 45 b4 65 a1 14 00 00 00 89 45 f0 31 c0 8b 45 b4 8b 80 ec 01 00 00 <8b> 58 04 89 45 c0 8b 83 9c 03 00 00 89 5d b8 83 f8 04 0f 95 c2 [82926.873463] EIP: [<f8534f07>] sd_revalidate_disk+0x27/0x1cb0 [sd_mod] SS:ESP 0068:f433dcac [82926.873463] CR2: 0000000000000004 [82926.978261] ---[ end trace 114d3029dfcfa383 ]--- [82927.707336] usb 3-2: USB disconnect, device number 102 [82929.165167] hub 2-0:1.0: unable to enumerate USB device on port 1 [82929.458419] usb 3-2: new full speed USB device number 103 using ohci_hcd [82929.673614] scsi184 : usb-storage 3-2:1.5 [82929.981772] hub 4-0:1.0: unable to enumerate USB device on port 1 [82930.207945] usbcore: registered new interface driver usbserial [82930.212794] USB Serial support registered for generic [82930.217301] usbcore: registered new interface driver usbserial_generic [82930.221419] usbserial: USB Serial Driver core [82930.244411] USB Serial support registered for GSM modem (1-port) [82930.249589] option 3-2:1.0: GSM modem (1-port) converter detected [82930.254091] usb 3-2: GSM modem (1-port) converter now attached to ttyUSB0 [82930.258643] option 3-2:1.1: GSM modem (1-port) converter detected [82930.263111] usb 3-2: GSM modem (1-port) converter now attached to ttyUSB1 [82930.267273] option 3-2:1.2: GSM modem (1-port) converter detected [82930.271763] usb 3-2: GSM modem (1-port) converter now attached to ttyUSB2 [82930.275924] option 3-2:1.3: GSM modem (1-port) converter detected [82930.280421] usb 3-2: GSM modem (1-port) converter now attached to ttyUSB3 [82930.284783] option 3-2:1.4: GSM modem (1-port) converter detected [82930.289228] usb 3-2: GSM modem (1-port) converter now attached to ttyUSB4 [82930.294427] usbcore: registered new interface driver option [82930.298788] option: v0.7.2:USB Driver for GSM modems [82930.683163] scsi 184:0:0:0: Direct-Access ZTE USB Storage FFF1 2.31 PQ: 0 ANSI: 2 [82930.686054] sd 184:0:0:0: Attached scsi generic sg3 type 0 [82930.717209] sd 184:0:0:0: [sdc] Attached SCSI removable disk [82930.798473] hub 2-0:1.0: unable to enumerate USB device on port 1 [82931.118454] hub 4-0:1.0: unable to enumerate USB device on port 1 [82954.261764] hub 2-0:1.0: unable to enumerate USB device on port 1 [82956.635211] hub 2-0:1.0: unable to enumerate USB device on port 1 [82957.508479] hub 2-0:1.0: unable to enumerate USB device on port 1 [82958.878471] hub 2-0:1.0: unable to enumerate USB device on port 1 [82959.201783] hub 4-0:1.0: unable to enumerate USB device on port 1 [82959.431795] hub 2-0:1.0: unable to enumerate USB device on port 1 [82959.631792] hub 4-0:1.0: unable to enumerate USB device on port 1 [82959.861810] hub 2-0:1.0: unable to enumerate USB device on port 1 [82960.061816] hub 4-0:1.0: unable to enumerate USB device on port 1 [82960.291811] hub 2-0:1.0: unable to enumerate USB device on port 1 Even though one can see a NULL pointer dereference issue. I was able to connect to internet using the modem (device /dev/ttyUSB0). Now I wanted to record usbmon output as well. So I disconnected and connected again. But this time no modem device was created. The relevant dmesg output is as follows: [83057.428442] hub 2-0:1.0: unable to enumerate USB device on port 1 [83057.745100] hub 4-0:1.0: unable to enumerate USB device on port 1 [83057.971773] hub 2-0:1.0: unable to enumerate USB device on port 1 [83061.891789] hub 2-0:1.0: unable to enumerate USB device on port 1 [83069.571749] usb 3-2: new full speed USB device number 104 using ohci_hcd [83069.770878] scsi185 : usb-storage 3-2:1.0 [83070.275095] hub 2-0:1.0: unable to enumerate USB device on port 1 [83070.591756] hub 4-0:1.0: unable to enumerate USB device on port 1 [83070.780560] scsi 185:0:0:0: CD-ROM ZTE USB Storage FFF1 2.31 PQ: 0 ANSI: 2 [83070.815511] sr1: scsi-1 drive [83070.817504] sr 185:0:0:0: Attached scsi CD-ROM sr1 [83070.819379] sr 185:0:0:0: Attached scsi generic sg3 type 5 [83070.847548] scsi 185:0:0:1: Direct-Access ZTE USB Storage FFF1 2.31 PQ: 0 ANSI: 2 [83070.849881] sd 185:0:0:1: Attached scsi generic sg4 type 0 [83070.882539] sd 185:0:0:1: [sdc] Attached SCSI removable disk [83070.938463] hub 2-0:1.0: unable to enumerate USB device on port 1 [83071.255104] hub 4-0:1.0: unable to enumerate USB device on port 1 [83071.481771] hub 2-0:1.0: unable to enumerate USB device on port 1 [83071.678421] hub 4-0:1.0: unable to enumerate USB device on port 1 [83071.905102] hub 2-0:1.0: unable to enumerate USB device on port 1 [83072.101750] hub 4-0:1.0: unable to enumerate USB device on port 1 On looking the dmesg output more closely, I caught these lines in between the above two excerpts: [83039.671749] hub 2-0:1.0: unable to enumerate USB device on port 1 [83039.868447] hub 4-0:1.0: unable to enumerate USB device on port 1 [83040.095102] hub 2-0:1.0: unable to enumerate USB device on port 1 [83040.291748] hub 4-0:1.0: unable to enumerate USB device on port 1 [83040.456139] option: option_instat_callback: error -62 [83040.518423] hub 2-0:1.0: unable to enumerate USB device on port 1 [83040.552136] option: option_instat_callback: error -62 [83040.648128] option: option_instat_callback: error -62 [83040.715104] hub 4-0:1.0: unable to enumerate USB device on port 1 [83040.716780] usb 3-2: USB disconnect, device number 103 [83040.719127] option: option_instat_callback: error -108 [83040.721221] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 [83040.724898] option 3-2:1.0: device disconnected [83040.729906] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 [83040.732876] option 3-2:1.1: device disconnected [83040.738107] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2 [83040.741220] option 3-2:1.2: device disconnected [83040.746772] option1 ttyUSB3: GSM modem (1-port) converter now disconnected from ttyUSB3 [83040.750108] option 3-2:1.3: device disconnected [83040.755255] option1 ttyUSB4: GSM modem (1-port) converter now disconnected from ttyUSB4 [83040.758081] option 3-2:1.4: device disconnected [83041.131758] hub 2-0:1.0: unable to enumerate USB device on port 1 [83041.328421] hub 4-0:1.0: unable to enumerate USB device on port 1 [83041.555085] hub 2-0:1.0: unable to enumerate USB device on port 1 [83041.751743] hub 4-0:1.0: unable to enumerate USB device on port 1 I tried connecting and disconnecting a few times, to no avail. Relevant output: [83262.055070] hub 4-0:1.0: unable to enumerate USB device on port 1 [83262.401731] hub 2-0:1.0: unable to enumerate USB device on port 1 [83263.108410] hub 2-0:1.0: unable to enumerate USB device on port 1 [83263.358433] usb 3-2: USB disconnect, device number 104 [83263.778436] hub 2-0:1.0: unable to enumerate USB device on port 1 [83264.371763] hub 2-0:1.0: unable to enumerate USB device on port 1 [83265.775099] hub 2-0:1.0: unable to enumerate USB device on port 1 [83285.511723] usb 3-2: new full speed USB device number 105 using ohci_hcd [83285.710864] scsi186 : usb-storage 3-2:1.0 [83286.720526] scsi 186:0:0:0: CD-ROM ZTE USB Storage FFF1 2.31 PQ: 0 ANSI: 2 [83286.755471] sr1: scsi-1 drive [83286.757474] sr 186:0:0:0: Attached scsi CD-ROM sr1 [83286.759399] sr 186:0:0:0: Attached scsi generic sg3 type 5 [83286.787497] scsi 186:0:0:1: Direct-Access ZTE USB Storage FFF1 2.31 PQ: 0 ANSI: 2 [83286.789871] sd 186:0:0:1: Attached scsi generic sg4 type 0 [83286.822484] sd 186:0:0:1: [sdc] Attached SCSI removable disk [83436.604389] usb 3-2: USB disconnect, device number 105 [83455.748371] usb 3-2: new full speed USB device number 106 using ohci_hcd [83455.951474] scsi187 : usb-storage 3-2:1.0 [83456.960168] scsi 187:0:0:0: CD-ROM ZTE USB Storage FFF1 2.31 PQ: 0 ANSI: 2 [83456.996125] sr1: scsi-1 drive [83456.998853] sr 187:0:0:0: Attached scsi CD-ROM sr1 [83457.001494] sr 187:0:0:0: Attached scsi generic sg3 type 5 [83457.030145] scsi 187:0:0:1: Direct-Access ZTE USB Storage FFF1 2.31 PQ: 0 ANSI: 2 [83457.033293] sd 187:0:0:1: Attached scsi generic sg4 type 0 [83457.066130] sd 187:0:0:1: [sdc] Attached SCSI removable disk [83511.685117] sr1: CDROM (ioctl) error, command: cdb[0]=0x51 51 00 00 00 00 00 00 00 02 00 [83511.688066] sr: Sense Key : 0x4 [current] [83511.691048] sr: ASC=0x0 ASCQ=0x0 [83511.819094] sr1: CDROM (ioctl) error, command: cdb[0]=0x46 46 00 00 00 00 00 00 00 20 00 [83511.820520] sr: Sense Key : 0x4 [current] [83511.822167] sr: ASC=0x0 ASCQ=0x0 [84189.318325] hub 2-0:1.0: unable to enumerate USB device on port 1 [84190.458314] hub 2-0:1.0: unable to enumerate USB device on port 1 [84191.208317] hub 2-0:1.0: unable to enumerate USB device on port 1 [84191.858314] hub 2-0:1.0: unable to enumerate USB device on port 1 I have attached usbmon output as well (gzipped) during connecting and disconnecting of this modem. I have attached dmesg output as well. One thing I can note is that "unable to enumerate USB device on port 1" messages are appearing less frequently, and appear to start and stop intermittently, once null pointer dereference occurred. > > Also, have you tried attaching a USB hub between the computer and the > modem? I haven't tried connecting USB hub. I don't have one handy either, right now. Sorry. However, I have tried the USB modem from my previous mail on another laptop and it works there though the kernel version is different on that laptop (kernel version: 2.6.32-lts). Please forgive me for bringing up multiple issues in one go. Thanks for your effort, -OBD
Attachment:
usbmon.log.gz
Description: GNU Zip compressed data
Attachment:
dmesg.log.gz
Description: GNU Zip compressed data
