GNOME.org
 

Re: Slow mobile broadband detection

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
[Date Prev][Date Next]   [Thread Prev][Thread Next]   [Thread Index] [Date Index] [Author Index]