Re: Howto change port used for 3g modem?

[Dan Williams <dcbw redhat com>]

On Tue, 2011-05-10 at 09:29 +0100, perazim portugalmail pt wrote:
> Dan,
> 
> mm now detects the Alcatel X220D and uses the X22X plugin and things now work.
> 
> I have some follow-up questions:
> 
> 1) Why does it take 2 minutes 40 seconds from plugin of modem till I  
> get a connection to the service provider?
> Looking at the logs (see below) shows mm cycling through the ports  
> several times.

Detailed modem-manager logs (using --debug) would help figure that out,
since it will include detailed timing information and show exactly
what's going on during the detection process.

> 2) Does mm interact in any way with usb_modeswitch or use any of its  
> config files? I notice
> that usb_modeswitch (1.1.17) does not have an entry for this model of  
> Alcatel where it
> explicitly defines the target product as 0x0017.

No, it doesn't interact with usb_modeswitch, but it does require that
usb_modeswitch have already run, otherwise the modem won't have been
flipped to modem mode, and there wont' be any serial ports for
modem-manager to use.

> 3) When would this update be pushed to fedora 14 rpm repositories?  
> Would this also include nm as well?
> I ask because I package a customized version of fedora 14 that I  
> compose from rpms. The current mm
> in fedora 14 is ModemManager-0.4-4.git20100720.fc14.i686.

I was thinking of pushing some of the MM 0.5 release candidates to F14,
at least in the updates-testing repository, and certainly the MM 0.5
final release.  That would happen "soon".

Dan

> Thanks for the help.
> 
> Perazim
> 
> 
> 
> May 10 11:09:39 travelmate kernel: [175074.936847] usb 2-1: new high  
> speed USB device using ehci_hcd and address 20
> May 10 11:09:39 travelmate kernel: [175075.053777] usb 2-1: New USB  
> device found, idVendor=1bbb, idProduct=f000
> May 10 11:09:39 travelmate kernel: [175075.053782] usb 2-1: New USB  
> device strings: Mfr=3, Product=2, SerialNumber=4
> May 10 11:09:39 travelmate kernel: [175075.053785] usb 2-1: Product:  
> HSPA Data Card
> May 10 11:09:39 travelmate kernel: [175075.053788] usb 2-1:  
> Manufacturer: USBModem
> May 10 11:09:39 travelmate kernel: [175075.053790] usb 2-1:  
> SerialNumber: 1234567890ABCDEF
> May 10 11:09:39 travelmate kernel: [175075.056585] scsi21 :  
> usb-storage 2-1:1.0
> May 10 11:09:40 travelmate usb_modeswitch: switching 1bbb:f000  
> (USBModem: HSPA Data Card)
> May 10 11:09:40 travelmate kernel: [175075.830688] usb 2-1: USB  
> disconnect, address 20
> May 10 11:09:40 travelmate kernel: [175076.140041] usb 2-1: new high  
> speed USB device using ehci_hcd and address 21
> May 10 11:09:40 travelmate kernel: [175076.257535] usb 2-1: New USB  
> device found, idVendor=1bbb, idProduct=0017
> May 10 11:09:40 travelmate kernel: [175076.257540] usb 2-1: New USB  
> device strings: Mfr=3, Product=2, SerialNumber=4
> May 10 11:09:40 travelmate kernel: [175076.257543] usb 2-1: Product:  
> HSPA Data Card
> May 10 11:09:40 travelmate kernel: [175076.257546] usb 2-1:  
> Manufacturer: USBModem
> May 10 11:09:40 travelmate kernel: [175076.257548] usb 2-1:  
> SerialNumber: 1234567890ABCDEF
> May 10 11:09:40 travelmate kernel: [175076.259898] option 2-1:1.0: GSM  
> modem (1-port) converter detected
> May 10 11:09:40 travelmate kernel: [175076.260113] usb 2-1: GSM modem  
> (1-port) converter now attached to ttyUSB0
> May 10 11:09:40 travelmate kernel: [175076.260228] option 2-1:1.1: GSM  
> modem (1-port) converter detected
> May 10 11:09:40 travelmate kernel: [175076.260334] usb 2-1: GSM modem  
> (1-port) converter now attached to ttyUSB1
> May 10 11:09:40 travelmate kernel: [175076.260442] option 2-1:1.2: GSM  
> modem (1-port) converter detected
> May 10 11:09:40 travelmate kernel: [175076.260541] usb 2-1: GSM modem  
> (1-port) converter now attached to ttyUSB2
> May 10 11:09:40 travelmate kernel: [175076.260645] option 2-1:1.3: GSM  
> modem (1-port) converter detected
> May 10 11:09:40 travelmate kernel: [175076.260744] usb 2-1: GSM modem  
> (1-port) converter now attached to ttyUSB4
> May 10 11:09:40 travelmate kernel: [175076.271044] scsi22 :  
> usb-storage 2-1:1.4
> May 10 11:09:40 travelmate kernel: [175076.274210] option 2-1:1.5: GSM  
> modem (1-port) converter detected
> May 10 11:09:40 travelmate kernel: [175076.274425] usb 2-1: GSM modem  
> (1-port) converter now attached to ttyUSB5
> May 10 11:09:40 travelmate modem-manager[1297]: <info>  (ttyUSB2)  
> opening serial port...
> May 10 11:09:40 travelmate modem-manager[1297]: <info>  (ttyUSB1)  
> opening serial port...
> May 10 11:09:40 travelmate modem-manager[1297]: <info>  (ttyUSB5)  
> opening serial port...
> May 10 11:09:40 travelmate modem-manager[1297]: <info>  (ttyUSB4)  
> opening serial port...
> May 10 11:09:40 travelmate modem-manager[1297]: <info>  (ttyUSB0)  
> opening serial port...
> May 10 11:09:41 travelmate usb_modeswitch: switched to 1bbb:0017  
> (USBModem: HSPA Data Card)
> May 10 11:09:41 travelmate kernel: [175077.294173] scsi 22:0:0:0:  
> Direct-Access     ALCATEL  Mass Storage     2.31 PQ: 0 ANSI: 2
> May 10 11:09:41 travelmate kernel: [175077.297547] sd 22:0:0:0:  
> Attached scsi generic sg4 type 0
> May 10 11:09:41 travelmate kernel: [175077.315530] sd 22:0:0:0: [sdd]  
> Attached SCSI removable disk
> May 10 11:09:41 travelmate modem-manager[1297]: <info>  (ttyUSB5)  
> closing serial port...
> May 10 11:09:41 travelmate modem-manager[1297]: <info>  (ttyUSB5)  
> serial port closed
> May 10 11:09:41 travelmate modem-manager[1297]: <info>  (ttyUSB4)  
> closing serial port...
> May 10 11:09:41 travelmate modem-manager[1297]: <info>  (ttyUSB4)  
> serial port closed
> May 10 11:09:41 travelmate modem-manager[1297]: <info>  (ttyUSB5)  
> opening serial port...
> May 10 11:09:41 travelmate modem-manager[1297]: <info>  (X22X): GSM  
> modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1 claimed port ttyUSB5
> May 10 11:09:41 travelmate modem-manager[1297]: <info>  (X22X): GSM  
> modem /sys/devices/pci0000:00/0000:00:1d.7/usb2/2-1 claimed port ttyUSB4
> May 10 11:09:42 travelmate modem-manager[1297]: <info>  (ttyUSB5)  
> closing serial port...
> May 10 11:09:42 travelmate modem-manager[1297]: <info>  (ttyUSB5)  
> serial port closed
> May 10 11:09:53 travelmate modem-manager[1297]: <info>  (ttyUSB2)  
> closing serial port...
> May 10 11:09:53 travelmate modem-manager[1297]: <info>  (ttyUSB2)  
> serial port closed
> May 10 11:09:53 travelmate modem-manager[1297]: <info>  (ttyUSB2)  
> opening serial port...
> May 10 11:09:55 travelmate modem-manager[1297]: <info>  (ttyUSB1)  
> closing serial port...
> May 10 11:10:25 travelmate modem-manager[1297]: <info>  (ttyUSB1)  
> serial port closed
> May 10 11:10:25 travelmate modem-manager[1297]: <info>  (ttyUSB1)  
> opening serial port...
> May 10 11:10:25 travelmate modem-manager[1297]: <info>  (ttyUSB0)  
> closing serial port...
> May 10 11:10:55 travelmate modem-manager[1297]: <info>  (ttyUSB0)  
> serial port closed
> May 10 11:10:55 travelmate modem-manager[1297]: <info>  (ttyUSB0)  
> opening serial port...
> May 10 11:10:58 travelmate modem-manager[1297]: <info>  (ttyUSB2)  
> closing serial port...
> May 10 11:10:58 travelmate modem-manager[1297]: <info>  (ttyUSB2)  
> serial port closed
> May 10 11:11:01 travelmate modem-manager[1297]: <info>  (ttyUSB1)  
> closing serial port...
> May 10 11:11:31 travelmate modem-manager[1297]: <info>  (ttyUSB1)  
> serial port closed
> May 10 11:11:31 travelmate modem-manager[1297]: <info>  (ttyUSB0)  
> closing serial port...
> May 10 11:12:01 travelmate modem-manager[1297]: <info>  (ttyUSB0)  
> serial port closed
> May 10 11:12:01 travelmate NetworkManager[2934]: <warn> (ttyUSB5):  
> failed to look up interface index
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> WWAN now  
> disabled by management service
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> (ttyUSB5): new  
> GSM device (driver: 'option1' ifindex: -1)
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> (ttyUSB5):  
> exported as /org/freedesktop/NetworkManager/Devices/9
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> (ttyUSB5): now managed
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> (ttyUSB5):  
> device state change: 1 -> 2 (reason 2)
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> (ttyUSB5):  
> deactivating device (reason: 2).
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> (ttyUSB5):  
> device state change: 2 -> 3 (reason 0)
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) starting connection 'Orange Default'
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> (ttyUSB5):  
> device state change: 3 -> 4 (reason 0)
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 1 of 5 (Device Prepare) scheduled...
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 1 of 5 (Device Prepare) started...
> May 10 11:12:01 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 1 of 5 (Device Prepare) complete.
> May 10 11:12:01 travelmate modem-manager[1297]: <info>  (ttyUSB5)  
> opening serial port...
> May 10 11:12:01 travelmate modem-manager[1297]: <info>  Modem  
> /org/freedesktop/ModemManager/Modems/7: state changed (disabled ->  
> enabling)
> May 10 11:12:01 travelmate modem-manager[1297]: <info>  (ttyUSB4)  
> opening serial port...
> May 10 11:12:01 travelmate modem-manager[1297]: Invalid error code: 303
> May 10 11:12:02 travelmate modem-manager[1297]: <info>  Modem  
> /org/freedesktop/ModemManager/Modems/7: state changed (enabling ->  
> enabled)
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> WWAN now  
> enabled by management service
> May 10 11:12:02 travelmate modem-manager[1297]: <info>  Modem  
> /org/freedesktop/ModemManager/Modems/7: state changed (enabled ->  
> registered)
> May 10 11:12:02 travelmate modem-manager[1297]: <info>  Modem  
> /org/freedesktop/ModemManager/Modems/7: state changed (registered ->  
> connecting)
> May 10 11:12:02 travelmate modem-manager[1297]: <info>  Modem  
> /org/freedesktop/ModemManager/Modems/7: state changed (connecting ->  
> connected)
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 2 of 5 (Device Configure) scheduled...
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 2 of 5 (Device Configure) starting...
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> (ttyUSB5):  
> device state change: 4 -> 5 (reason 0)
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 2 of 5 (Device Configure) successful.
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 3 of 5 (IP Configure Start) scheduled.
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 2 of 5 (Device Configure) complete.
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 3 of 5 (IP Configure Start) started...
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> (ttyUSB5):  
> device state change: 5 -> 7 (reason 0)
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> starting PPP  
> connection
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> pppd started  
> with pid 1570
> May 10 11:12:02 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 3 of 5 (IP Configure Start) complete.
> May 10 11:12:02 travelmate pppd[1570]: Plugin  
> /usr/lib/pppd/2.4.5/nm-pppd-plugin.so loaded.
> May 10 11:12:02 travelmate pppd[1570]: pppd 2.4.5 started by yossi, uid 0
> May 10 11:12:02 travelmate pppd[1570]: Using interface ppp0
> May 10 11:12:02 travelmate pppd[1570]: Connect: ppp0 <--> /dev/ttyUSB5
> May 10 11:12:02 travelmate pppd[1570]: CHAP authentication succeeded
> May 10 11:12:02 travelmate pppd[1570]: CHAP authentication succeeded
> May 10 11:12:02 travelmate NetworkManager[2934]: <warn>  
> /sys/devices/virtual/net/ppp0: couldn't determine device driver;  
> ignoring...
> May 10 11:12:05 travelmate pppd[1570]: Could not determine remote IP  
> address: defaulting to 10.64.64.64
> May 10 11:12:05 travelmate pppd[1570]: local  IP address 10.195.158.5
> May 10 11:12:05 travelmate pppd[1570]: remote IP address 10.64.64.64
> May 10 11:12:05 travelmate pppd[1570]: primary   DNS address 82.102.139.10
> May 10 11:12:05 travelmate pppd[1570]: secondary DNS address 82.102.139.20
> May 10 11:12:05 travelmate NetworkManager[2934]: <info> PPP manager(IP  
> Config Get) reply received.
> May 10 11:12:05 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 4 of 5 (IP4 Configure Get) scheduled...
> May 10 11:12:05 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 4 of 5 (IP4 Configure Get) started...
> May 10 11:12:05 travelmate NetworkManager[2934]: <info> Scheduling stage 5
> May 10 11:12:05 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 5 of 5 (IP Configure Commit) scheduled...
> May 10 11:12:05 travelmate NetworkManager[2934]: <info> Done  
> scheduling stage 5
> May 10 11:12:05 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 4 of 5 (IP4 Configure Get) complete.
> May 10 11:12:05 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 5 of 5 (IP Configure Commit) started...
> May 10 11:12:06 travelmate NetworkManager[2934]: <info> (ttyUSB5):  
> device state change: 7 -> 8 (reason 0)
> May 10 11:12:06 travelmate NetworkManager[2934]: <info> Policy set  
> 'Orange Default' (ppp0) as default for IPv4 routing and DNS.
> May 10 11:12:06 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) successful, device activated.
> May 10 11:12:06 travelmate NetworkManager[2934]: <info> Activation  
> (ttyUSB5) Stage 5 of 5 (IP Configure Commit) complete.
> May 10 11:12:06 travelmate ntpd[1771]: Listen normally on 24 ppp0  
> 10.195.158.5 UDP 123
> 
> 
> ________________________________________________________________________________
> O email é um dos seus instrumentos de trabalho?
> http://www.portugalmail.net/profissional
> _______________________________________________
> networkmanager-list mailing list
> networkmanager-list gnome org
> http://mail.gnome.org/mailman/listinfo/networkmanager-list