[pkg-fso-maint] [debian] usb networking dead after upgrade

Tue Mar 16 19:52:25 UTC 2010

On Tue, 16 Mar 2010 19:39:46 +0100, arne anka wrote:

> i upgraded about an hour ago, and after a reboot, usb networking was gone.

Ha!
Same here. Good that I'm reading mail while my FR does a fsck :)

A bit more info:
* The network comes up on both sides.
* It just dies rather quickly. From the syslog on my desktop machine:

Mar 16 20:03:18 belanna kernel: usb 5-1: new full speed USB device using uhci_hcd and address 13
Mar 16 20:03:19 belanna kernel: usb 5-1: New USB device found, idVendor=1457, idProduct=5122
Mar 16 20:03:19 belanna kernel: usb 5-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Mar 16 20:03:19 belanna kernel: usb 5-1: Product: RNDIS/Ethernet Gadget
Mar 16 20:03:19 belanna kernel: usb 5-1: Manufacturer: Linux 2.6.29-rc3 with s3c2410_udc
Mar 16 20:03:19 belanna kernel: usb0: register 'cdc_ether' at usb-0000:00:1d.3-1, CDC Ethernet Device, f6:a4:32:0b:f5:f2
Mar 16 20:03:31 belanna kernel: usb0: no IPv6 routers present

Mar 16 20:03:27 deanna kernel: imklog 4.6.1, log source = /proc/kmsg started.
Mar 16 20:03:27 deanna rsyslogd: [origin software="rsyslogd" swVersion="4.6.1" x-pid="1157" x-info="http://www.rsyslog.com"] (re)start
[..]
Mar 16 20:03:27 deanna kernel: [21474739.920000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
Mar 16 20:03:27 deanna kernel: [21474739.935000] s3c-ohci s3c-ohci: S3C24XX OHCI
Mar 16 20:03:27 deanna kernel: [21474739.995000] s3c-ohci s3c-ohci: new USB bus registered, assigned bus number 1
Mar 16 20:03:27 deanna kernel: [21474740.005000] s3c-ohci s3c-ohci: irq 42, io mem 0x49000000
Mar 16 20:03:27 deanna kernel: [21474740.080000] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
Mar 16 20:03:27 deanna kernel: [21474740.095000] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Mar 16 20:03:27 deanna kernel: [21474740.110000] usb usb1: Product: S3C24XX OHCI
Mar 16 20:03:27 deanna kernel: [21474740.120000] usb usb1: Manufacturer: Linux 2.6.29-rc3 ohci_hcd
Mar 16 20:03:27 deanna kernel: [21474740.135000] usb usb1: SerialNumber: s3c24xx
Mar 16 20:03:27 deanna kernel: [21474740.295000] usb usb1: configuration #1 chosen from 1 choice
Mar 16 20:03:27 deanna kernel: [21474740.365000] hub 1-0:1.0: USB hub found
Mar 16 20:03:27 deanna kernel: [21474740.370000] hub 1-0:1.0: 2 ports detected
Mar 16 20:03:27 deanna kernel: [21474740.920000] usb 1-1: new full speed USB device using s3c-ohci and address 2
Mar 16 20:03:27 deanna kernel: [21474741.185000] usb 1-1: New USB device found, idVendor=0a12, idProduct=0001
Mar 16 20:03:27 deanna kernel: [21474741.190000] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Mar 16 20:03:27 deanna kernel: [21474741.235000] usb 1-1: configuration #1 chosen from 1 choice
Mar 16 20:03:27 deanna kernel: [21474742.250000] pcf50633 0-0073: usb curlim to 500 mA
Mar 16 20:03:27 deanna kernel: [21474742.425000] Bluetooth: Core ver 2.14
Mar 16 20:03:27 deanna kernel: [21474742.435000] NET: Registered protocol family 31
Mar 16 20:03:27 deanna kernel: [21474742.440000] Bluetooth: HCI device and connection manager initialized
Mar 16 20:03:27 deanna kernel: [21474742.450000] Bluetooth: HCI socket layer initialized
Mar 16 20:03:27 deanna kernel: [21474742.940000] Bluetooth: Generic Bluetooth USB driver ver 0.4
Mar 16 20:03:27 deanna kernel: [21474742.990000] usbcore: registered new interface driver btusb
Mar 16 20:03:31 deanna kernel: [21474762.275000] NET: Registered protocol family 10
Mar 16 20:03:42 deanna kernel: [21474773.105000] usb0: no IPv6 routers present

Mar 16 20:04:12 belanna kernel: usb 5-1: USB disconnect, address 13
Mar 16 20:04:12 belanna kernel: usb0: unregister 'cdc_ether' usb-0000:00:1d.3-1, CDC Ethernet Device

(belanna is my desktop, deanna the freerunner which logs to belanna
via rsyslog.)

Side note: after the boot the the gsm, wifi and bt devices are up,
which is new. gps is down.

> after an hour of research i did as a desperate attempt
> om usb mode device
> and there it was.

Yeah, helps here too. Thanks!

Mar 16 20:07:59 belanna kernel: usb 5-1: new full speed USB device using uhci_hcd and address 14
Mar 16 20:07:59 belanna kernel: usb 5-1: New USB device found, idVendor=1457, idProduct=5122
Mar 16 20:07:59 belanna kernel: usb 5-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Mar 16 20:07:59 belanna kernel: usb 5-1: Product: RNDIS/Ethernet Gadget
Mar 16 20:07:59 belanna kernel: usb 5-1: Manufacturer: Linux 2.6.29-rc3 with s3c2410_udc
Mar 16 20:08:00 belanna kernel: usb0: register 'cdc_ether' at usb-0000:00:1d.3-1, CDC Ethernet Device, f6:a4:32:0b:f5:f2
Mar 16 20:07:49 deanna kernel: [  183.805000] pcf50633 0-0073: usb curlim to 500 mA

> simple question: what happend? why wasn't the usb not set to device
> mode after a reboot?
> on a related not, fsousaged did not start -- having access back, i
> am going to investigate.

Here ogsmd whines:

2010.03.16 20:10:09.284 ogsmd.modems.ti_calypso INFO     Requesting new channel from 'fso-abyss'
2010.03.16 20:10:09.402 ogsmd.modems.ti_calypso CRITICAL Error allocating channel ogsmd.unsolicited : org.freedesktop.DBus.Error.ServiceUnknown: The name :1.23 was not provided by any .service files
2010.03.16 20:10:09.408 ogsmd.modem.abstract ERROR    could not open channel UNSOL, retrying in 2 seconds

Still the same after restarting frameworkd.

...

Further messing around with a couple of daemons doesn't help either.

Using gsm0710muxd instead of fso-abyss ... ah, that looks better.
No usaged either but well. At least zavai can do the PIN dance
successfully.

BTW: We have two new files:
/etc/freesmartphone/conf/openmoko_gta/fsousaged.conf and
/etc/freesmartphone/conf/default/fsousaged.conf (look like
/etc/freesmartphone/fsousaged.conf). What does this tell us?

Some time laster fsousaged runs. Whatever has started it. Hm.

2010-03-16T19:36:48.108892Z [WARN]  UsageController <0 R>: Invalid lowlevel_type none; suspend/resume will NOT be available!

That's probably from my /etc/freesmartphone/fsousaged.conf. Or from
/etc/freesmartphone/conf/default/fsousaged.conf.

Trial-and-error. Seems to be from /etc/freesmartphone/fsousaged.conf.

2010-03-16T19:42:25.417927Z [INFO]  fsousaged : Binary launched successful (FsoFrameworkFileLogger created as theLogger)
2010-03-16T19:42:25.683462Z [INFO]  LowLevelKernel26 <>: Registering kernel26 low level suspend/resume handling
2010-03-16T19:42:25.684534Z [INFO]  UsageController <0 R>: Ready. Using lowlevel plugin kernel26 to handle suspend/resume

Now that's from /etc/freesmartphone/conf/default/fsousaged.conf, so
/etc/freesmartphone/conf/openmoko_gta/fsousaged.conf seems to be
ignored. Mhm.

Another nice piece of info at the end:

# mdbus -s org.freesmartphone.ousaged /org/freesmartphone/Usage org.freesmartphone.Usage.SetResourcePolicy GSM enabled
ERROR:dbus.connection:Unable to set arguments ('GSM',) according to signature u'ss': <type 'exceptions.TypeError'>: More items found in D-Bus signature than in Python arguments
/org/freesmartphone/Usage: SetResourcePolicy failed: org.freesmartphone.Usage.ResourceUnknown (Resource GSM had never been registered)

Oh, well.

Cheers,
gregor, who --as usual-- doesn't understand all this stuff
-- 
 .''`.   http://info.comodo.priv.at/ -- GPG Key IDs: 0x8649AA06, 0x00F3CFE4
 : :' :  Debian GNU/Linux user, admin, & developer - http://www.debian.org/
 `. `'   Member of VIBE!AT & SPI, fellow of Free Software Foundation Europe
   `-    NP: Schmetterlinge: Wir hatten Gräber, ihr hattet Siege
-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: application/pgp-signature
Size: 836 bytes
Desc: Digital signature
URL: <http://lists.alioth.debian.org/pipermail/pkg-fso-maint/attachments/20100316/ba425082/attachment-0001.pgp>