On Tue, 2011-06-14 at 21:42 -0500, Dan Williams wrote: > On Tue, 2011-06-14 at 23:57 +0100, Sérgio Basto wrote: > > On Wed, 2011-06-15 at 00:30 +0200, Aleksander Morgado wrote: > > > So the overall modem detection needs up to 113s in your case, which > > > really is a lot, and mainly caused by the open/close port delays from > > > the kernel. Without these huge delays, the modem detection should take > > > around 20-25 max (guessing from the max time the QCDM port needs to > > > get detected). > > > > yes my ZTE always need more than 90s to be detected , since I bought it > > (September of 2008). No matter what kernel was. > > And speed up this detection for 20 seconds, would be great. > > If you can tell me the port #s and the USB interface #s of the ports > that take a long time to probe then we can add those ports to the kernel > blacklist as such. There are certain modems for which the firmware > simply doesn't respond to serial setup packets sent on certain > interfaces, which cause the kernel to wait for a while before timing > out. I just fixed that issue for the Alcatel X200 device and it's > likely that we need to do the same for your device. > > The second possibility is that your device does not have it's USB IDs > added to the right driver in the kernel and thus the driver that's being > used (which could be the generic 'usb-serial' driver if usb-modeswitch > force loaded it) doesn't handle flush requests when closing the port. I > had that issue with a ZTE CDMA device and fixed that in the kernel > around 2.6.32 or so, but this only works if your device is using the > 'option' driver, which all 3G modems shoudl be using. usb-serial is not > optimized for the serial speeds that 3G devices require, and thus any > modem IDs shoudl get added to the appropriate non-generic driver (like > option, hso, sierra, etc).
Hi, I send nm.log with /var/log/messages and yes since around 2.6.32 I got this ZTE ... if you need further logs please tell me. I recently got other mobile 3G card, which test it today and is detect in about 47 seconds, I also send to you in nm2.log the results to see if it is normal. Thanks, -- Sérgio M. B.
Jun 14 20:32:33 segulix kernel: [14869.187485] usb 2-1.3: new full speed USB device using ehci_hcd and address 5 Jun 14 20:32:33 segulix kernel: [14869.273814] usb 2-1.3: New USB device found, idVendor=19d2, idProduct=2000 Jun 14 20:32:33 segulix kernel: [14869.273821] usb 2-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jun 14 20:32:33 segulix kernel: [14869.273826] usb 2-1.3: Product: USB ZTE Storage Jun 14 20:32:33 segulix kernel: [14869.273830] usb 2-1.3: Manufacturer: Qualcomm, Incorporated Jun 14 20:32:33 segulix mtp-probe: checking bus 2, device 5: "/sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3" Jun 14 20:32:33 segulix mtp-probe: bus: 2, device: 5 was not an MTP device Jun 14 20:32:34 segulix usb_modeswitch: switching 19d2:2000 (Qualcomm, Incorporated: USB ZTE Storage) Jun 14 20:33:00 segulix kernel: [14896.715282] usbcore: registered new interface driver uas Jun 14 20:33:00 segulix kernel: [14896.737740] Initializing USB Mass Storage driver... Jun 14 20:33:00 segulix kernel: [14896.737991] scsi6 : usb-storage 2-1.3:1.0 Jun 14 20:33:00 segulix kernel: [14896.738322] usbcore: registered new interface driver usb-storage Jun 14 20:33:00 segulix kernel: [14896.738325] USB Mass Storage support registered. Jun 14 20:33:03 segulix kernel: [14898.974720] usb 2-1.3: USB disconnect, address 5 Jun 14 20:33:09 segulix kernel: [14904.966450] usb 2-1.3: new full speed USB device using ehci_hcd and address 6 Jun 14 20:33:09 segulix kernel: [14905.052917] usb 2-1.3: New USB device found, idVendor=19d2, idProduct=0001 Jun 14 20:33:09 segulix kernel: [14905.052924] usb 2-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jun 14 20:33:09 segulix kernel: [14905.052929] usb 2-1.3: Product: ZTE CDMA Technologies MSM Jun 14 20:33:09 segulix kernel: [14905.052933] usb 2-1.3: Manufacturer: Qualcomm, Incorporated Jun 14 20:33:09 segulix mtp-probe: checking bus 2, device 6: "/sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3" Jun 14 20:33:09 segulix mtp-probe: bus: 2, device: 6 was not an MTP device Jun 14 20:33:09 segulix kernel: [14905.238117] usbcore: registered new interface driver usbserial Jun 14 20:33:09 segulix kernel: [14905.238142] USB Serial support registered for generic Jun 14 20:33:09 segulix kernel: [14905.238249] usbcore: registered new interface driver usbserial_generic Jun 14 20:33:09 segulix kernel: [14905.238252] usbserial: USB Serial Driver core Jun 14 20:33:09 segulix kernel: [14905.257264] USB Serial support registered for GSM modem (1-port) Jun 14 20:33:09 segulix kernel: [14905.257351] option 2-1.3:1.0: GSM modem (1-port) converter detected Jun 14 20:33:09 segulix kernel: [14905.257561] usb 2-1.3: GSM modem (1-port) converter now attached to ttyUSB0 Jun 14 20:33:09 segulix kernel: [14905.257588] option 2-1.3:1.1: GSM modem (1-port) converter detected Jun 14 20:33:09 segulix kernel: [14905.257750] usb 2-1.3: GSM modem (1-port) converter now attached to ttyUSB1 Jun 14 20:33:09 segulix kernel: [14905.257770] option 2-1.3:1.2: GSM modem (1-port) converter detected Jun 14 20:33:09 segulix kernel: [14905.257917] usb 2-1.3: GSM modem (1-port) converter now attached to ttyUSB2 Jun 14 20:33:09 segulix kernel: [14905.258366] usbcore: registered new interface driver option Jun 14 20:33:09 segulix kernel: [14905.258372] option: v0.7.2:USB Driver for GSM modems Jun 14 20:33:09 segulix modem-manager[981]: <info> (ttyUSB2) opening serial port... Jun 14 20:33:09 segulix modem-manager[981]: <info> (ttyUSB1) opening serial port... Jun 14 20:33:09 segulix modem-manager[981]: <info> (ttyUSB0) opening serial port... Jun 14 20:33:19 segulix modem-manager[981]: <info> (ttyUSB2) closing serial port... Jun 14 20:33:19 segulix modem-manager[981]: <info> (ttyUSB2) serial port closed Jun 14 20:33:19 segulix modem-manager[981]: <info> (ttyUSB2) opening serial port... Jun 14 20:33:19 segulix modem-manager[981]: <info> (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3 claimed port ttyUSB2 Jun 14 20:33:19 segulix modem-manager[981]: <info> (ttyUSB2) closing serial port... Jun 14 20:33:19 segulix modem-manager[981]: <info> (ttyUSB2) serial port closed Jun 14 20:33:26 segulix modem-manager[981]: <info> (ttyUSB0) closing serial port... Jun 14 20:33:26 segulix modem-manager[981]: <info> (ttyUSB0) serial port closed Jun 14 20:33:26 segulix modem-manager[981]: mm_modem_base_add_port: assertion `port == NULL' failed Jun 14 20:33:26 segulix modem-manager[981]: (mm-generic-gsm.c:804):mm_generic_gsm_grab_port: runtime check failed: (port != NULL) Jun 14 20:33:26 segulix modem-manager[981]: <warn> plugin 'ZTE' claimed to support tty/ttyUSB0 but couldn't: (-1) (unknown) Jun 14 20:33:41 segulix modem-manager[981]: <info> (ttyUSB1) closing serial port... Jun 14 20:33:41 segulix modem-manager[981]: <info> (ttyUSB1) serial port closed Jun 14 20:33:41 segulix modem-manager[981]: <info> (ttyUSB1) opening serial port... Jun 14 20:33:44 segulix modem-manager[981]: <info> (ttyUSB1) closing serial port... Jun 14 20:33:44 segulix modem-manager[981]: <info> (ttyUSB1) serial port closed Jun 14 20:33:44 segulix modem-manager[981]: <info> (ZTE): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3 claimed port ttyUSB1 Jun 14 20:33:44 segulix NetworkManager[889]: <warn> (ttyUSB2): failed to look up interface index Jun 14 20:33:44 segulix NetworkManager[889]: <info> (ttyUSB2): new GSM/UMTS device (driver: 'option1' ifindex: -1) Jun 14 20:33:44 segulix NetworkManager[889]: <info> (ttyUSB2): exported as /org/freedesktop/NetworkManager/Devices/2 Jun 14 20:33:44 segulix NetworkManager[889]: <info> (ttyUSB2): now managed Jun 14 20:33:44 segulix NetworkManager[889]: <info> (ttyUSB2): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Jun 14 20:33:44 segulix NetworkManager[889]: <info> (ttyUSB2): deactivating device (reason: 2). Jun 14 20:33:44 segulix NetworkManager[889]: <info> (ttyUSB2): device state change: unavailable -> disconnected (reason 'none') [20 30 0] Jun 14 20:33:44 segulix NetworkManager[889]: <info> Activation (ttyUSB2) starting connection 'TMN Default' Jun 14 20:33:44 segulix NetworkManager[889]: <info> (ttyUSB2): device state change: disconnected -> prepare (reason 'none') [30 40 0] Jun 14 20:33:44 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) scheduled... Jun 14 20:33:44 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) started... Jun 14 20:33:44 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) complete. Jun 14 20:33:44 segulix NetworkManager[889]: <warn> GSM modem enable failed: (32) SIM PIN required Jun 14 20:33:44 segulix NetworkManager[889]: <info> (ttyUSB2): device state change: prepare -> need-auth (reason 'none') [40 60 0] Jun 14 20:33:44 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) scheduled... Jun 14 20:33:44 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) started... Jun 14 20:33:44 segulix NetworkManager[889]: <info> (ttyUSB2): device state change: need-auth -> prepare (reason 'none') [60 40 0] Jun 14 20:33:44 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 1 of 5 (Device Prepare) complete. Jun 14 20:33:44 segulix NetworkManager[889]: <warn> GSM modem enable failed: (32) SIM PIN required Jun 14 20:33:44 segulix modem-manager[981]: <info> (ttyUSB2) opening serial port... Jun 14 20:33:44 segulix modem-manager[981]: <info> Modem /org/freedesktop/ModemManager/Modems/0: unlock no longer required Jun 14 20:33:44 segulix modem-manager[981]: <info> Modem /org/freedesktop/ModemManager/Modems/0: # unlock retries is 0 Jun 14 20:33:44 segulix modem-manager[981]: <info> (ttyUSB2) closing serial port... Jun 14 20:33:44 segulix modem-manager[981]: <info> (ttyUSB2) serial port closed Jun 14 20:33:44 segulix modem-manager[981]: <info> (ttyUSB2) opening serial port... Jun 14 20:33:44 segulix modem-manager[981]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (disabled -> enabling) Jun 14 20:33:51 segulix modem-manager[981]: Invalid error code: 303 Jun 14 20:33:53 segulix modem-manager[981]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabling -> enabled) Jun 14 20:33:53 segulix NetworkManager[889]: <info> WWAN now enabled by management service Jun 14 20:33:53 segulix modem-manager[981]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (enabled -> registered) Jun 14 20:33:53 segulix modem-manager[981]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> connecting) Jun 14 20:33:53 segulix modem-manager[981]: <info> Modem /org/freedesktop/ModemManager/Modems/0: state changed (connecting -> connected) Jun 14 20:33:53 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 2 of 5 (Device Configure) scheduled... Jun 14 20:33:53 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 2 of 5 (Device Configure) starting... Jun 14 20:33:53 segulix NetworkManager[889]: <info> (ttyUSB2): device state change: prepare -> config (reason 'none') [40 50 0] Jun 14 20:33:53 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 2 of 5 (Device Configure) successful. Jun 14 20:33:53 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 3 of 5 (IP Configure Start) scheduled. Jun 14 20:33:53 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 2 of 5 (Device Configure) complete. Jun 14 20:33:53 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 3 of 5 (IP Configure Start) started... Jun 14 20:33:53 segulix NetworkManager[889]: <info> (ttyUSB2): device state change: config -> ip-config (reason 'none') [50 70 0] Jun 14 20:33:53 segulix NetworkManager[889]: <info> starting PPP connection Jun 14 20:33:53 segulix NetworkManager[889]: <info> pppd started with pid 7138 Jun 14 20:33:53 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 3 of 5 (IP Configure Start) complete. Jun 14 20:33:53 segulix pppd[7138]: Plugin /usr/lib64/pppd/2.4.5/nm-pppd-plugin.so loaded. Jun 14 20:33:53 segulix kernel: [14949.412710] PPP generic driver version 2.4.2 Jun 14 20:33:53 segulix pppd[7138]: pppd 2.4.5 started by root, uid 0 Jun 14 20:33:53 segulix pppd[7138]: Using interface ppp0 Jun 14 20:33:53 segulix pppd[7138]: Connect: ppp0 <--> /dev/ttyUSB2 Jun 14 20:33:53 segulix pppd[7138]: CHAP authentication succeeded Jun 14 20:33:53 segulix pppd[7138]: CHAP authentication succeeded Jun 14 20:33:53 segulix kernel: [14949.487961] PPP Deflate Compression module registered Jun 14 20:33:55 segulix pppd[7138]: Could not determine remote IP address: defaulting to 10.64.64.64 Jun 14 20:33:55 segulix pppd[7138]: local IP address 89.214.216.158 Jun 14 20:33:55 segulix pppd[7138]: remote IP address 10.64.64.64 Jun 14 20:33:55 segulix pppd[7138]: primary DNS address 88.214.182.2 Jun 14 20:33:55 segulix pppd[7138]: secondary DNS address 88.214.178.1 Jun 14 20:33:55 segulix NetworkManager[889]: <info> PPP manager(IP Config Get) reply received. Jun 14 20:33:55 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 4 of 5 (IP4 Configure Get) scheduled... Jun 14 20:33:55 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 4 of 5 (IP4 Configure Get) started... Jun 14 20:33:55 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 5 of 5 (IP Configure Commit) scheduled... Jun 14 20:33:55 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 4 of 5 (IP4 Configure Get) complete. Jun 14 20:33:55 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 5 of 5 (IP Configure Commit) started... Jun 14 20:33:56 segulix NetworkManager[889]: <info> Policy set 'System eth0' (eth0) as default for IPv4 routing and DNS. Jun 14 20:33:56 segulix NetworkManager[889]: <info> (ttyUSB2): device state change: ip-config -> activated (reason 'none') [70 100 0] Jun 14 20:33:56 segulix NetworkManager[889]: <info> Activation (ttyUSB2) successful, device activated. Jun 14 20:33:56 segulix NetworkManager[889]: <info> Activation (ttyUSB2) Stage 5 of 5 (IP Configure Commit) complete. Jun 14 20:33:56 segulix dbus-daemon: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper) Jun 14 20:33:56 segulix dbus-daemon: [system] Successfully activated service 'org.freedesktop.nm_dispatcher' Jun 14 20:33:56 segulix dhcpd: Internet Systems Consortium DHCP Server 4.2.1-P1 Jun 14 20:33:56 segulix dhcpd: Copyright 2004-2011 Internet Systems Consortium. Jun 14 20:33:56 segulix dhcpd: All rights reserved. Jun 14 20:33:56 segulix dhcpd: For info, please visit https://www.isc.org/software/dhcp/ Jun 14 20:33:56 segulix dhcpd: Not searching LDAP since ldap-server, ldap-port and ldap-base-dn were not specified in the config file Jun 14 20:33:56 segulix dhcpd: Wrote 0 leases to leases file. Jun 14 20:33:56 segulix ntpd[893]: Listen normally on 7 ppp0 89.214.216.158 UDP 123 Jun 14 20:33:56 segulix ntpd[893]: peers refreshed Jun 14 20:33:56 segulix dhcpd: Jun 14 20:33:56 segulix dhcpd: No subnet declaration for virbr0 (192.168.122.1). Jun 14 20:33:56 segulix dhcpd: ** Ignoring requests on virbr0. If this is not what Jun 14 20:33:56 segulix dhcpd: you want, please write a subnet declaration Jun 14 20:33:56 segulix dhcpd: in your dhcpd.conf file for the network segment Jun 14 20:33:56 segulix dhcpd: to which interface virbr0 is attached. ** Jun 14 20:33:56 segulix dhcpd: Jun 14 20:33:56 segulix dhcpd: Jun 14 20:33:56 segulix dhcpd: No subnet declaration for eth0 (10.134.132.157). Jun 14 20:33:56 segulix dhcpd: ** Ignoring requests on eth0. If this is not what Jun 14 20:33:56 segulix dhcpd: you want, please write a subnet declaration Jun 14 20:33:56 segulix dhcpd: in your dhcpd.conf file for the network segment Jun 14 20:33:56 segulix dhcpd: to which interface eth0 is attached. ** Jun 14 20:33:56 segulix dhcpd: Jun 14 20:33:56 segulix dhcpd: Jun 14 20:33:56 segulix dhcpd: Not configured to listen on any interfaces! Jun 14 20:33:56 segulix dhcpd: Jun 14 20:33:56 segulix dhcpd: This version of ISC DHCP is based on the release available Jun 14 20:33:56 segulix dhcpd: on ftp.isc.org. Features have been added and other changes Jun 14 20:33:56 segulix dhcpd: have been made to the base software release in order to make Jun 14 20:33:56 segulix dhcpd: it work better with this distribution. Jun 14 20:33:56 segulix dhcpd: Jun 14 20:33:56 segulix dhcpd: Please report for this software via the Red Hat Bugzilla site: Jun 14 20:33:56 segulix dhcpd: http://bugzilla.redhat.com Jun 14 20:33:56 segulix dhcpd: Jun 14 20:33:56 segulix dhcpd: exiting. Jun 14 20:33:56 segulix systemd[1]: dhcpd.service: main process exited, code=exited, status=1 Jun 14 20:33:56 segulix systemd[1]: Unit dhcpd.service entered failed state. Jun 14 20:37:31 segulix dnsmasq[1471]: reading /etc/resolv.conf Jun 14 20:37:31 segulix dnsmasq[1471]: using nameserver 88.214.178.1#53 Jun 14 20:37:31 segulix dnsmasq[1471]: using nameserver 88.214.182.2#53 Jun 14 20:37:31 segulix dnsmasq[1471]: using nameserver 10.134.2.3#53 Jun 14 20:37:31 segulix dnsmasq[1471]: using nameserver 10.134.2.2#53 Jun 14 20:39:58 segulix dhcpd: Internet Systems Consortium DHCP Server 4.2.1-P1 Jun 14 20:39:58 segulix dhcpd: Copyright 2004-2011 Internet Systems Consortium. Jun 14 20:39:58 segulix dhcpd: All rights reserved. Jun 14 20:39:58 segulix dhcpd: For info, please visit https://www.isc.org/software/dhcp/ Jun 14 20:39:58 segulix dhcpd: Not searching LDAP since ldap-server, ldap-port and ldap-base-dn were not specified in the config file Jun 14 20:39:58 segulix dhcpd: Wrote 0 leases to leases file. Jun 14 20:39:58 segulix dhcpd: Jun 14 20:39:58 segulix dhcpd: No subnet declaration for virbr0 (192.168.122.1). Jun 14 20:39:58 segulix dhcpd: ** Ignoring requests on virbr0. If this is not what Jun 14 20:39:58 segulix dhcpd: you want, please write a subnet declaration Jun 14 20:39:58 segulix dhcpd: in your dhcpd.conf file for the network segment Jun 14 20:39:58 segulix dhcpd: to which interface virbr0 is attached. ** Jun 14 20:39:58 segulix dhcpd: Jun 14 20:39:58 segulix dhcpd: Jun 14 20:39:58 segulix dhcpd: No subnet declaration for eth0 (10.134.132.157). Jun 14 20:39:58 segulix dhcpd: ** Ignoring requests on eth0. If this is not what Jun 14 20:39:58 segulix dhcpd: you want, please write a subnet declaration Jun 14 20:39:58 segulix dhcpd: in your dhcpd.conf file for the network segment Jun 14 20:39:58 segulix dhcpd: to which interface eth0 is attached. ** Jun 14 20:39:58 segulix dhcpd: Jun 14 20:39:58 segulix dhcpd: Jun 14 20:39:58 segulix dhcpd: Not configured to listen on any interfaces! Jun 14 20:39:58 segulix dhcpd: Jun 14 20:39:58 segulix dhcpd: This version of ISC DHCP is based on the release available Jun 14 20:39:58 segulix dhcpd: on ftp.isc.org. Features have been added and other changes Jun 14 20:39:58 segulix dhcpd: have been made to the base software release in order to make Jun 14 20:39:58 segulix dhcpd: it work better with this distribution. Jun 14 20:39:58 segulix dhcpd: Jun 14 20:39:58 segulix dhcpd: Please report for this software via the Red Hat Bugzilla site: Jun 14 20:39:58 segulix dhcpd: http://bugzilla.redhat.com Jun 14 20:39:58 segulix dhcpd: Jun 14 20:39:58 segulix dhcpd: exiting. Jun 14 20:39:58 segulix systemd[1]: dhcpd.service: main process exited, code=exited, status=1 Jun 14 20:39:58 segulix systemd[1]: Unit dhcpd.service entered failed state.
Jun 15 05:47:00 segulix kernel: [32122.432914] usb 2-1.3: new high speed USB device using ehci_hcd and address 19 Jun 15 05:47:00 segulix kernel: [32122.529978] usb 2-1.3: New USB device found, idVendor=12d1, idProduct=1446 Jun 15 05:47:00 segulix kernel: [32122.529988] usb 2-1.3: New USB device strings: Mfr=2, Product=1, SerialNumber=0 Jun 15 05:47:00 segulix kernel: [32122.529995] usb 2-1.3: Product: HUAWEI Mobile Jun 15 05:47:00 segulix kernel: [32122.530001] usb 2-1.3: Manufacturer: HUAWEI Technology Jun 15 05:47:00 segulix kernel: [32122.534802] scsi44 : usb-storage 2-1.3:1.0 Jun 15 05:47:00 segulix kernel: [32122.535303] scsi45 : usb-storage 2-1.3:1.1 Jun 15 05:47:00 segulix mtp-probe: checking bus 2, device 19: "/sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3" Jun 15 05:47:00 segulix mtp-probe: bus: 2, device: 19 was not an MTP device Jun 15 05:47:01 segulix usb_modeswitch: switching 12d1:1446 (HUAWEI Technology: HUAWEI Mobile) Jun 15 05:47:01 segulix kernel: [32123.278836] usb 2-1.3: USB disconnect, address 19 Jun 15 05:47:07 segulix kernel: [32129.332974] usb 2-1.3: new high speed USB device using ehci_hcd and address 20 Jun 15 05:47:07 segulix kernel: [32129.429964] usb 2-1.3: New USB device found, idVendor=12d1, idProduct=140c Jun 15 05:47:07 segulix kernel: [32129.429974] usb 2-1.3: New USB device strings: Mfr=2, Product=1, SerialNumber=0 Jun 15 05:47:07 segulix kernel: [32129.429982] usb 2-1.3: Product: HUAWEI Mobile Jun 15 05:47:07 segulix kernel: [32129.429987] usb 2-1.3: Manufacturer: HUAWEI Technology Jun 15 05:47:07 segulix kernel: [32129.435094] option 2-1.3:1.0: GSM modem (1-port) converter detected Jun 15 05:47:07 segulix kernel: [32129.435304] usb 2-1.3: GSM modem (1-port) converter now attached to ttyUSB0 Jun 15 05:47:07 segulix kernel: [32129.435651] option 2-1.3:1.1: GSM modem (1-port) converter detected Jun 15 05:47:07 segulix kernel: [32129.435855] usb 2-1.3: GSM modem (1-port) converter now attached to ttyUSB1 Jun 15 05:47:07 segulix kernel: [32129.436223] option 2-1.3:1.2: GSM modem (1-port) converter detected Jun 15 05:47:07 segulix kernel: [32129.436384] usb 2-1.3: GSM modem (1-port) converter now attached to ttyUSB2 Jun 15 05:47:07 segulix kernel: [32129.436869] option 2-1.3:1.3: GSM modem (1-port) converter detected Jun 15 05:47:07 segulix kernel: [32129.437073] usb 2-1.3: GSM modem (1-port) converter now attached to ttyUSB3 Jun 15 05:47:07 segulix kernel: [32129.437894] scsi50 : usb-storage 2-1.3:1.4 Jun 15 05:47:07 segulix kernel: [32129.439763] scsi51 : usb-storage 2-1.3:1.5 Jun 15 05:47:08 segulix usb_modeswitch: switched to 12d1:140c (HUAWEI Technology: HUAWEI Mobile) Jun 15 05:47:08 segulix kernel: [32130.440393] scsi 50:0:0:0: CD-ROM HUAWEI Mass Storage 2.31 PQ: 0 ANSI: 2 Jun 15 05:47:08 segulix kernel: [32130.442263] scsi 51:0:0:0: Direct-Access HUAWEI MMC Storage 2.31 PQ: 0 ANSI: 2 Jun 15 05:47:08 segulix kernel: [32130.451225] sr1: scsi-1 drive Jun 15 05:47:08 segulix kernel: [32130.451710] sr 50:0:0:0: Attached scsi generic sg2 type 5 Jun 15 05:47:08 segulix kernel: [32130.452448] sd 51:0:0:0: Attached scsi generic sg3 type 0 Jun 15 05:47:08 segulix kernel: [32130.462434] sd 51:0:0:0: [sdb] Attached SCSI removable disk Jun 15 05:47:09 segulix mtp-probe: checking bus 2, device 20: "/sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3" Jun 15 05:47:09 segulix mtp-probe: bus: 2, device: 20 was not an MTP device Jun 15 05:47:09 segulix modem-manager[981]: <info> (ttyUSB0) opening serial port... Jun 15 05:47:14 segulix modem-manager[981]: <info> (ttyUSB0) closing serial port... Jun 15 05:47:14 segulix modem-manager[981]: <info> (ttyUSB0) serial port closed Jun 15 05:47:14 segulix modem-manager[981]: <info> (ttyUSB0) opening serial port... Jun 15 05:47:14 segulix modem-manager[981]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3 claimed port ttyUSB0 Jun 15 05:47:14 segulix modem-manager[981]: <info> (ttyUSB0) closing serial port... Jun 15 05:47:14 segulix modem-manager[981]: <info> (ttyUSB0) serial port closed Jun 15 05:47:15 segulix modem-manager[981]: <info> (ttyUSB2) opening serial port... Jun 15 05:47:15 segulix modem-manager[981]: <info> (ttyUSB3) opening serial port... Jun 15 05:47:15 segulix modem-manager[981]: <info> (ttyUSB1) opening serial port... Jun 15 05:47:17 segulix modem-manager[981]: <info> (ttyUSB3) closing serial port... Jun 15 05:47:17 segulix modem-manager[981]: <info> (ttyUSB3) serial port closed Jun 15 05:47:17 segulix modem-manager[981]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3 claimed port ttyUSB3 Jun 15 05:47:24 segulix kernel: [32146.453883] sd 51:0:0:0: [sdb] 1888256 512-byte logical blocks: (966 MB/922 MiB) Jun 15 05:47:24 segulix kernel: [32146.456888] sd 51:0:0:0: [sdb] Assuming drive cache: write through Jun 15 05:47:24 segulix kernel: [32146.466854] sd 51:0:0:0: [sdb] Assuming drive cache: write through Jun 15 05:47:24 segulix kernel: [32146.470465] sdb: Jun 15 05:47:27 segulix modem-manager[981]: <info> (ttyUSB2) closing serial port... Jun 15 05:47:27 segulix modem-manager[981]: <info> (ttyUSB2) serial port closed Jun 15 05:47:27 segulix modem-manager[981]: <info> (ttyUSB2) opening serial port... Jun 15 05:47:27 segulix modem-manager[981]: <info> (ttyUSB1) closing serial port... Jun 15 05:47:27 segulix modem-manager[981]: <info> (ttyUSB1) serial port closed Jun 15 05:47:27 segulix modem-manager[981]: <info> (ttyUSB1) opening serial port... Jun 15 05:47:30 segulix modem-manager[981]: <info> (ttyUSB2) closing serial port... Jun 15 05:47:30 segulix modem-manager[981]: <info> (ttyUSB2) serial port closed Jun 15 05:47:30 segulix modem-manager[981]: <info> (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.3 claimed port ttyUSB2 Jun 15 05:47:33 segulix modem-manager[981]: <info> (ttyUSB1) closing serial port... Jun 15 05:47:33 segulix modem-manager[981]: <info> (ttyUSB1) serial port closed Jun 15 05:47:33 segulix NetworkManager[17001]: <warn> (ttyUSB0): failed to look up interface index Jun 15 05:47:33 segulix NetworkManager[17001]: <info> (ttyUSB0): new GSM/UMTS device (driver: 'option1' ifindex: -1) Jun 15 05:47:33 segulix NetworkManager[17001]: <info> (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/2 Jun 15 05:47:33 segulix NetworkManager[17001]: <info> (ttyUSB0): now managed Jun 15 05:47:33 segulix NetworkManager[17001]: <info> (ttyUSB0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2] Jun 15 05:47:33 segulix NetworkManager[17001]: <info> (ttyUSB0): deactivating device (reason: 2). Jun 15 05:47:33 segulix NetworkManager[17001]: <info> (ttyUSB0): device state change: unavailable -> disconnected (reason 'none') [20 30 0] Jun 15 05:47:39 segulix modem-manager[981]: <info> (ttyUSB0) opening serial port... Jun 15 05:47:40 segulix modem-manager[981]: <info> Modem /org/freedesktop/ModemManager/Modems/6: unlock no longer required Jun 15 05:47:40 segulix modem-manager[981]: <info> Modem /org/freedesktop/ModemManager/Modems/6: # unlock retries is 0 Jun 15 05:47:40 segulix modem-manager[981]: <info> (ttyUSB0) closing serial port... Jun 15 05:47:40 segulix modem-manager[981]: <info> (ttyUSB0) serial port closed
_______________________________________________ networkmanager-list mailing list networkmanager-list@gnome.org http://mail.gnome.org/mailman/listinfo/networkmanager-list