Re: usb0 and making it available to guest OS
On 08/05/2012 06:20 PM, Ralf Mardorf wrote:
>
> Sorry, I forgot to shorten the text and to reply to this. Because so
> much is involved, the host and guest, a restart IMO is a good idea.
>
>
Alright, just restarted the whole machine. What is happening now is the
following (or so it seems to be from the log, pasted further below):
1. Usbcore sees teh device.
2. It "disconnects" it or "unmanages" it because? Looks like because
VBox is capturing the device.
3. Network manager gets involved and gets a dhcp address from the USB
device.
4. A usb0 is created nevertheless (if the usb0 device was captured by
the guest OS, should it still result in a usb0 in the host?).
Here is the log in all its glory:
======================================================
Aug 5 18:21:06 red kernel: [ 161.617943] warning: `VirtualBox' uses
32-bit capabilities (legacy support in use)
Aug 5 18:23:19 red kernel: [ 294.540051] usb 1-2: new high-speed USB
device number 3 using ehci_hcd
Aug 5 18:23:19 red kernel: [ 294.673387] usb 1-2: New USB device
found, idVendor=1390, idProduct=5454
Aug 5 18:23:19 red kernel: [ 294.673398] usb 1-2: New USB device
strings: Mfr=1, Product=2, SerialNumber=3
Aug 5 18:23:19 red kernel: [ 294.673406] usb 1-2: Product: TomTom
Aug 5 18:23:19 red kernel: [ 294.673411] usb 1-2: Manufacturer: Linux
2.6.28.10 with dwc_otg_pcd
Aug 5 18:23:19 red kernel: [ 294.673416] usb 1-2: SerialNumber:
BM9999XY9999
Aug 5 18:23:19 red mtp-probe: checking bus 1, device 3:
"/sys/devices/pci0000:00/0000:00:12.2/usb1/1-2"
Aug 5 18:23:19 red mtp-probe: bus: 1, device: 3 was not an MTP device
Aug 5 18:23:19 red kernel: [ 294.776315] cdc_ether 1-2:1.0: usb0:
register 'cdc_ether' at usb-0000:00:12.2-2, CDC Ethernet Device,
02:04:06:08:0a:0c
Aug 5 18:23:19 red kernel: [ 294.776575] usbcore: registered new
interface driver cdc_ether
Aug 5 18:23:19 red NetworkManager[2020]: SCPlugin-Ifupdown: devices
added (path:
/sys/devices/pci0000:00/0000:00:12.2/usb1/1-2/1-2:1.0/net/usb0, iface: usb0)
Aug 5 18:23:19 red NetworkManager[2020]: SCPlugin-Ifupdown: device
added (path:
/sys/devices/pci0000:00/0000:00:12.2/usb1/1-2/1-2:1.0/net/usb0, iface:
usb0): no ifupdown configuration found.
Aug 5 18:23:19 red NetworkManager[2020]: <warn> failed to allocate link
cache: (-10) Operation not supported
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): carrier is OFF
Aug 5 18:23:19 red NetworkManager[2020]: <error> [1344205399.322526]
[nm-device-ethernet.c:456] real_update_permanent_hw_address(): (usb0):
unable to read permanent MAC address (error 0)
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): new Ethernet
device (driver: 'cdc_ether' ifindex: 3)
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): exported as
/org/freedesktop/NetworkManager/Devices/1
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): now managed
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): device state
change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): bringing up device.
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): carrier now ON
(device state 20)
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): preparing device.
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): deactivating
device (reason 'managed') [2]
Aug 5 18:23:19 red NetworkManager[2020]: <info> Added default wired
connection 'Wired connection 1' for
/sys/devices/pci0000:00/0000:00:12.2/usb1/1-2/1-2:1.0/net/usb0
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): device state
change: unavailable -> disconnected (reason 'none') [20 30 0]
Aug 5 18:23:19 red NetworkManager[2020]: <info> Auto-activating
connection 'Wired connection 1'.
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0)
starting connection 'Wired connection 1'
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): device state
change: disconnected -> prepare (reason 'none') [30 40 0]
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0) Stage
1 of 5 (Device Prepare) scheduled...
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0) Stage
1 of 5 (Device Prepare) started...
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0) Stage
2 of 5 (Device Configure) scheduled...
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0) Stage
1 of 5 (Device Prepare) complete.
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0) Stage
2 of 5 (Device Configure) starting...
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): device state
change: prepare -> config (reason 'none') [40 50 0]
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0) Stage
2 of 5 (Device Configure) successful.
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0) Stage
3 of 5 (IP Configure Start) scheduled.
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0) Stage
2 of 5 (Device Configure) complete.
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): carrier now OFF
(device state 50, deferring action for 4 seconds)
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0) Stage
3 of 5 (IP Configure Start) started...
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): device state
change: config -> ip-config (reason 'none') [50 70 0]
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0)
Beginning DHCPv4 transaction (timeout in 45 seconds)
Aug 5 18:23:19 red NetworkManager[2020]: <info> dhclient started with
pid 4605
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0)
Beginning IP6 addrconf.
Aug 5 18:23:19 red NetworkManager[2020]: <info> Activation (usb0) Stage
3 of 5 (IP Configure Start) complete.
Aug 5 18:23:19 red kernel: [ 294.884227] ADDRCONF(NETDEV_UP): usb0:
link is not ready
Aug 5 18:23:19 red dhclient: Internet Systems Consortium DHCP Client 4.2.2
Aug 5 18:23:19 red dhclient: Copyright 2004-2011 Internet Systems
Consortium.
Aug 5 18:23:19 red dhclient: All rights reserved.
Aug 5 18:23:19 red dhclient: For info, please visit
https://www.isc.org/software/dhcp/
Aug 5 18:23:19 red dhclient:
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): carrier now ON
(device state 70)
Aug 5 18:23:19 red kernel: [ 294.912583] ADDRCONF(NETDEV_CHANGE):
usb0: link becomes ready
Aug 5 18:23:19 red NetworkManager[2020]: <info> (usb0): DHCPv4 state
changed nbi -> preinit
Aug 5 18:23:19 red dhclient: Listening on LPF/usb0/02:04:06:08:0a:0c
Aug 5 18:23:19 red dhclient: Sending on LPF/usb0/02:04:06:08:0a:0c
Aug 5 18:23:19 red dhclient: Sending on Socket/fallback
Aug 5 18:23:19 red dhclient: DHCPDISCOVER on usb0 to 255.255.255.255
port 67 interval 8
Aug 5 18:23:19 red kernel: [ 295.374024] usb 1-2: usbfs: interface 0
claimed by cdc_ether while 'VirtualBox' sets config #2
Aug 5 18:23:21 red avahi-daemon[2214]: Joining mDNS multicast group on
interface usb0.IPv6 with address fe80::9:9ff:ff99:999.
Aug 5 18:23:21 red avahi-daemon[2214]: New relevant interface usb0.IPv6
for mDNS.
Aug 5 18:23:21 red avahi-daemon[2214]: Registering new address record
for fe80::9:9ff:ff99:999 on usb0.*.
Aug 5 18:23:21 red dhclient: DHCPREQUEST on usb0 to 255.255.255.255 port 67
Aug 5 18:23:21 red dhclient: DHCPOFFER from 169.254.255.1
Aug 5 18:23:21 red dhclient: DHCPACK from 169.254.255.1
Aug 5 18:23:21 red NetworkManager[2020]: <info> (usb0): DHCPv4 state
changed preinit -> bound
Aug 5 18:23:21 red NetworkManager[2020]: <info> address 169.254.255.2
Aug 5 18:23:21 red NetworkManager[2020]: <info> prefix 30
(255.255.255.252)
Aug 5 18:23:21 red NetworkManager[2020]: <info> hostname 'red'
Aug 5 18:23:21 red NetworkManager[2020]: <info> nameserver
'208.67.222.222'
Aug 5 18:23:21 red NetworkManager[2020]: <info> nameserver
'208.67.220.220'
Aug 5 18:23:21 red NetworkManager[2020]: <info> Activation (usb0) Stage
5 of 5 (IPv4 Configure Commit) scheduled...
Aug 5 18:23:21 red NetworkManager[2020]: <info> Activation (usb0) Stage
5 of 5 (IPv4 Commit) started...
Aug 5 18:23:21 red avahi-daemon[2214]: Joining mDNS multicast group on
interface usb0.IPv4 with address 169.254.255.2.
Aug 5 18:23:21 red avahi-daemon[2214]: New relevant interface usb0.IPv4
for mDNS.
Aug 5 18:23:21 red avahi-daemon[2214]: Registering new address record
for 169.254.255.2 on usb0.IPv4.
Aug 5 18:23:21 red dhclient: bound to 169.254.255.2 -- renewal in 41633
seconds.
Aug 5 18:23:22 red NetworkManager[2020]: <info> (usb0): writing
resolv.conf to /sbin/resolvconf
Aug 5 18:23:22 red NetworkManager[2020]: <info> (usb0): device state
change: ip-config -> activated (reason 'none') [70 100 0]
Aug 5 18:23:22 red NetworkManager[2020]: <info> Activation (usb0)
successful, device activated.
Aug 5 18:23:22 red NetworkManager[2020]: <info> Activation (usb0) Stage
5 of 5 (IPv4 Commit) complete.
Aug 5 18:23:22 red dbus[1995]: [system] Activating service
name='org.freedesktop.nm_dispatcher' (using servicehelper)
Aug 5 18:23:22 red dbus[1995]: [system] Successfully activated service
'org.freedesktop.nm_dispatcher'
Aug 5 18:23:23 red ntpdate[4674]: the NTP socket is in use, exiting
Aug 5 18:23:23 red ntpd[3186]: Listen normally on 6 usb0 169.254.255.2
UDP 123
Aug 5 18:23:23 red ntpd[3186]: Listen normally on 7 usb0
fe80::9:9ff:ff99:999 UDP 123
Aug 5 18:23:23 red ntpd[3186]: peers refreshed
Aug 5 18:23:30 red kernel: [ 305.912032] usb0: no IPv6 routers present
Aug 5 18:23:39 red NetworkManager[2020]: <info> (usb0): IP6 addrconf
timed out or failed.
Aug 5 18:23:39 red NetworkManager[2020]: <info> Activation (usb0) Stage
4 of 5 (IPv6 Configure Timeout) scheduled...
Aug 5 18:23:39 red NetworkManager[2020]: <info> Activation (usb0) Stage
4 of 5 (IPv6 Configure Timeout) started...
Aug 5 18:23:39 red NetworkManager[2020]: <info> Activation (usb0) Stage
4 of 5 (IPv6 Configure Timeout) complete.
======================================================
Thanks.
--
Please reply to this list only. I read this list on its corresponding
newsgroup on gmane.org. Replies sent to my email address are just
filtered to a folder in my mailbox and get periodically deleted without
ever having been read.
Reply to: