Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Bluetooth issues #200

Closed
castalla opened this issue Jan 24, 2013 · 19 comments
Closed

Bluetooth issues #200

castalla opened this issue Jan 24, 2013 · 19 comments
Assignees

Comments

@castalla
Copy link

I think this may be part of the same range of bluetooth issues reported here. I am not technically adept. so I can only describe the symtoms.

Using bluetooth & bluez-utils I can pair, connect and play a test wav to Logitech bt speaker. If I switch the speaker off, then about 5-10 secs. later the ethernet network connection disappears from the entire network. Leds indicate ethernet activity continuing. Only solution is a cold reboot.

I'm using the latest kernel (19 Jan) & firmware (22 Jan).

This situation makes using bt with speakers useless.

@licaon-kter
Copy link

uname -a ? vcgencmd version ? lsusb -v ? dmesg ?

@castalla
Copy link
Author

Hope the following helps!

uname

root@squeezeplug:# uname -a
Linux squeezeplug 3.6.11+ #5 PREEMPT Fri Jan 18 16:48:08 EET 2013 armv6l GNU/Linux
root@squeezeplug:
#


vcgencmd

Jan 22 2013 17:51:08
Copyright (c) 2012 Broadcom

version 364242 (release)

lsusb -v

MaxPower 0mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 3
bInterfaceClass 224 Wireless
bInterfaceSubClass 1 Radio Frequency
bInterfaceProtocol 1 Bluetooth
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0010 1x 16 bytes
bInterval 1
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x82 EP 2 IN
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0040 1x 64 bytes
bInterval 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x02 EP 2 OUT
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0040 1x 64 bytes
bInterval 0
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 0
bNumEndpoints 2
bInterfaceClass 224 Wireless
bInterfaceSubClass 1 Radio Frequency
bInterfaceProtocol 1 Bluetooth
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x83 EP 3 IN
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0020 1x 32 bytes
bInterval 1
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x03 EP 3 OUT
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0020 1x 32 bytes
bInterval 1
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 1
bNumEndpoints 2
bInterfaceClass 224 Wireless
bInterfaceSubClass 1 Radio Frequency
bInterfaceProtocol 1 Bluetooth
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x83 EP 3 IN
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0009 1x 9 bytes
bInterval 1
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x03 EP 3 OUT
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0009 1x 9 bytes
bInterval 1
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 2
bNumEndpoints 2
bInterfaceClass 224 Wireless
bInterfaceSubClass 1 Radio Frequency
bInterfaceProtocol 1 Bluetooth
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x83 EP 3 IN
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0011 1x 17 bytes
bInterval 1
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x03 EP 3 OUT
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0011 1x 17 bytes
bInterval 1
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 3
bNumEndpoints 2
bInterfaceClass 224 Wireless
bInterfaceSubClass 1 Radio Frequency
bInterfaceProtocol 1 Bluetooth
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x83 EP 3 IN
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0019 1x 25 bytes
bInterval 1
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x03 EP 3 OUT
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0019 1x 25 bytes
bInterval 1
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 4
bNumEndpoints 2
bInterfaceClass 224 Wireless
bInterfaceSubClass 1 Radio Frequency
bInterfaceProtocol 1 Bluetooth
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x83 EP 3 IN
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0021 1x 33 bytes
bInterval 1
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x03 EP 3 OUT
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0021 1x 33 bytes
bInterval 1
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 1
bAlternateSetting 5
bNumEndpoints 2
bInterfaceClass 224 Wireless
bInterfaceSubClass 1 Radio Frequency
bInterfaceProtocol 1 Bluetooth
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x83 EP 3 IN
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0031 1x 49 bytes
bInterval 1
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x03 EP 3 OUT
bmAttributes 1
Transfer Type Isochronous
Synch Type None
Usage Type Data
wMaxPacketSize 0x0031 1x 49 bytes
bInterval 1
Device Status: 0x0000
(Bus Powered)


dmesg

[ 0.000000] Booting Linux on physical CPU 0
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 3.6.11+ (user@ubuntu-VirtualBox) (gcc version 4.7.1 20120402 (prerelease) (crosstool-NG 1.15.2) ) #5 PREEMPT Fri Jan 18 16:48:08 EET 2013
[ 0.000000] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
[ 0.000000] Machine: BCM2708
[ 0.000000] cma: CMA: reserved 16 MiB at 0e000000
[ 0.000000] Memory policy: ECC disabled, Data cache writeback
[ 0.000000] On node 0 totalpages: 61440
[ 0.000000] free_area_init_node: node 0, pgdat c053d834, node_mem_map c05e7000
[ 0.000000] Normal zone: 480 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 60960 pages, LIFO batch:15
[ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[ 0.000000] pcpu-alloc: [0] 0
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 60960
[ 0.000000] Kernel command line: dma.dmachans=0x7f35 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708.boardrev=0x4 bcm2708.serial=0x8f9c86fb smsc95xx.macaddr=B8:27:EB:9C:86:FB sdhci-bcm2708.emmc_clock_freq=100000000 vc_mem.mem_base=0xfa00000 vc_mem.mem_size=0x10000000 dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait
[ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
[ 0.000000] Memory: 240MB = 240MB total
[ 0.000000] Memory: 221128k/221128k available, 24632k reserved, 0K highmem
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB)
[ 0.000000] vmalloc : 0xcf800000 - 0xff000000 ( 760 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xcf000000 ( 240 MB)
[ 0.000000] modules : 0xbf000000 - 0xc0000000 ( 16 MB)
[ 0.000000] .text : 0xc0008000 - 0xc04e74a8 (4990 kB)
[ 0.000000] .init : 0xc04e8000 - 0xc0508f24 ( 132 kB)
[ 0.000000] .data : 0xc050a000 - 0xc053e060 ( 209 kB)
[ 0.000000] .bss : 0xc053e084 - 0xc05e6738 ( 674 kB)
[ 0.000000] NR_IRQS:330
[ 0.000000] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 4294967ms
[ 0.000000] Console: colour dummy device 80x30
[ 0.000000] console [tty1] enabled
[ 0.001034] Calibrating delay loop... 464.48 BogoMIPS (lpj=2322432)
[ 0.060064] pid_max: default: 32768 minimum: 301
[ 0.060406] Mount-cache hash table entries: 512
[ 0.061161] Initializing cgroup subsys cpuacct
[ 0.061218] Initializing cgroup subsys devices
[ 0.061250] Initializing cgroup subsys freezer
[ 0.061278] Initializing cgroup subsys blkio
[ 0.061376] CPU: Testing write buffer coherency: ok
[ 0.061708] hw perfevents: enabled with v6 PMU driver, 3 counters available
[ 0.061857] Setting up static identity map for 0x39f380 - 0x39f3dc
[ 0.063358] devtmpfs: initialized
[ 0.073701] NET: Registered protocol family 16
[ 0.080043] DMA: preallocated 4096 KiB pool for atomic coherent allocations
[ 0.081218] bcm2708.uart_clock = 0
[ 0.082655] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
[ 0.082708] hw-breakpoint: maximum watchpoint size is 4 bytes.
[ 0.082745] mailbox: Broadcom VideoCore Mailbox driver
[ 0.082839] bcm2708_vcio: mailbox at f200b880
[ 0.082939] bcm_power: Broadcom power driver
[ 0.082976] bcm_power_open() -> 0
[ 0.083001] bcm_power_request(0, 8)
[ 0.583689] bcm_mailbox_read -> 00000080, 0
[ 0.583728] bcm_power_request -> 0
[ 0.583753] Serial: AMBA PL011 UART driver
[ 0.583893] dev:f1: ttyAMA0 at MMIO 0x20201000 (irq = 83) is a PL011 rev3
[ 0.904864] console [ttyAMA0] enabled
[ 0.928415] bio: create slab at 0
[ 0.933290] SCSI subsystem initialized
[ 0.937377] usbcore: registered new interface driver usbfs
[ 0.942959] usbcore: registered new interface driver hub
[ 0.948549] usbcore: registered new device driver usb
[ 0.954915] Switching to clocksource stc
[ 0.959158] FS-Cache: Loaded
[ 0.962307] CacheFiles: Loaded
[ 0.977403] NET: Registered protocol family 2
[ 0.982697] TCP established hash table entries: 8192 (order: 4, 65536 bytes)
[ 0.990047] TCP bind hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.996629] TCP: Hash tables configured (established 8192 bind 8192)
[ 1.003060] TCP: reno registered
[ 1.006313] UDP hash table entries: 256 (order: 0, 4096 bytes)
[ 1.012210] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[ 1.018758] NET: Registered protocol family 1
[ 1.023667] RPC: Registered named UNIX socket transport module.
[ 1.029713] RPC: Registered udp transport module.
[ 1.034435] RPC: Registered tcp transport module.
[ 1.039180] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 1.046315] bcm2708_dma: DMA manager at f2007000
[ 1.051098] bcm2708_gpio: bcm2708_gpio_probe c0517d98
[ 1.056563] vc-mem: phys_addr:0x00000000 mem_base=0x0fa00000 mem_size:0x10000000(256 MiB)
[ 1.065746] audit: initializing netlink socket (disabled)
[ 1.071346] type=2000 audit(0.930:1): initialized
[ 1.193589] VFS: Disk quotas dquot_6.5.2
[ 1.197626] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 1.204682] FS-Cache: Netfs 'nfs' registered for caching
[ 1.210432] NFS: Registering the id_resolver key type
[ 1.215593] Key type id_resolver registered
[ 1.219886] Key type id_legacy registered
[ 1.224257] msgmni has been set to 463
[ 1.229798] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[ 1.237519] io scheduler noop registered
[ 1.241559] io scheduler deadline registered (default)
[ 1.246742] io scheduler cfq registered
[ 1.273976] Console: switching to colour frame buffer device 82x26
[ 1.285378] kgdb: Registered I/O driver kgdboc.
[ 1.292550] vc-cma: Videocore CMA driver
[ 1.298341] vc-cma: vc_cma_base = 0x00000000
[ 1.304910] vc-cma: vc_cma_size = 0x00000000 (0 MiB)
[ 1.312092] vc-cma: vc_cma_initial = 0x00000000 (0 MiB)
[ 1.328193] brd: module loaded
[ 1.337938] loop: module loaded
[ 1.343164] vchiq: vchiq_init_state: slot_zero = 0xce000000, is_master = 0
[ 1.352547] Loading iSCSI transport class v2.0-870.
[ 1.360148] usbcore: registered new interface driver smsc95xx
[ 1.367704] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[ 1.580319] Core Release: 2.80a
[ 1.585157] Setting default values for core params
[ 1.591733] Finished setting default values for core params
[ 1.804150] Using Buffer DMA mode
[ 1.809188] Periodic Transfer Interrupt Enhancement - disabled
[ 1.816690] Multiprocessor Interrupt Enhancement - disabled
[ 1.823958] OTG VER PARAM: 0, OTG VER FLAG: 0
[ 1.830027] Dedicated Tx FIFOs mode
[ 1.836064] dwc_otg: Microframe scheduler enabled
[ 1.836431] dwc_otg bcm2708_usb: DWC OTG Controller
[ 1.843168] dwc_otg bcm2708_usb: new USB bus registered, assigned bus number 1
[ 1.852307] dwc_otg bcm2708_usb: irq 32, io mem 0x00000000
[ 1.859600] Init: Port Power? op_state=1
[ 1.865215] Init: Power Port (0)
[ 1.870244] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[ 1.878870] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.887950] usb usb1: Product: DWC OTG Controller
[ 1.894521] usb usb1: Manufacturer: Linux 3.6.11+ dwc_otg_hcd
[ 1.902121] usb usb1: SerialNumber: bcm2708_usb
[ 1.909269] hub 1-0:1.0: USB hub found
[ 1.914835] hub 1-0:1.0: 1 port detected
[ 1.920827] dwc_otg: FIQ enabled
[ 1.920843] dwc_otg: NAK holdoff enabled
[ 1.920862] Module dwc_common_port init
[ 1.921087] Initializing USB Mass Storage driver...
[ 1.927887] usbcore: registered new interface driver usb-storage
[ 1.935728] USB Mass Storage support registered.
[ 1.942251] usbcore: registered new interface driver libusual
[ 1.950078] mousedev: PS/2 mouse device common for all mice
[ 1.958071] bcm2835-cpufreq: min=700000 max=700000 cur=700000
[ 1.963942] bcm2835-cpufreq: switching to governor powersavebcm2835-cpufreq: switching to governor powersave
[ 1.977328] cpuidle: using governor ladder
[ 1.985049] cpuidle: using governor menu
[ 1.990771] sdhci: Secure Digital Host Controller Interface driver
[ 1.998708] sdhci: Copyright(c) Pierre Ossman
[ 2.004896] sdhci: Enable low-latency mode
[ 2.049256] mmc0: SDHCI controller on BCM2708_Arasan [platform] using platform's DMA
[ 2.060791] mmc0: BCM2708 SDHC host at 0x20300000 DMA 2 IRQ 77
[ 2.070696] sdhci-pltfm: SDHCI platform and OF driver helper
[ 2.083986] usbcore: registered new interface driver usbhid
[ 2.091573] usbhid: USB HID core driver
[ 2.102039] TCP: cubic registered
[ 2.109377] Initializing XFRM netlink socket
[ 2.117680] NET: Registered protocol family 17
[ 2.124205] Indeed it is in host mode hprt0 = 00021501
[ 2.134706] Key type dns_resolver registered
[ 2.149424] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
[ 2.171576] mmc0: could read SD Status register (SSR) at the 2th attempt
[ 2.180854] registered taskstats version 1
[ 2.199581] Waiting for root device /dev/mmcblk0p2...
[ 2.210506] mmc0: new high speed SDHC card at address b368
[ 2.229273] mmcblk0: mmc0:b368 NCard 3.73 GiB
[ 2.250196] mmcblk0: p1 p2
[ 2.324140] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[ 2.336428] VFS: Mounted root (ext4 filesystem) on device 179:2.
[ 2.353303] devtmpfs: mounted
[ 2.358731] Freeing init memory: 128K
[ 2.379089] usb 1-1: new high-speed USB device number 2 using dwc_otg
[ 2.387752] Indeed it is in host mode hprt0 = 00001101
[ 2.599360] usb 1-1: New USB device found, idVendor=0424, idProduct=9512
[ 2.608483] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 2.619252] hub 1-1:1.0: USB hub found
[ 2.626429] hub 1-1:1.0: 3 ports detected
[ 2.909383] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
[ 3.039699] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
[ 3.048681] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 3.076008] smsc95xx v1.0.4
[ 3.143897] smsc95xx 1-1.1:1.0: eth0: register 'smsc95xx' at usb-bcm2708_usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:9c:86:fb
[ 3.249363] usb 1-1.2: new full-speed USB device number 4 using dwc_otg
[ 3.361337] usb 1-1.2: New USB device found, idVendor=0a12, idProduct=0001
[ 3.379092] usb 1-1.2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 3.816773] udevd[142]: starting version 175
[ 5.113822] Registered led device: led0
[ 5.232559] Bluetooth: Core ver 2.16
[ 5.498860] NET: Registered protocol family 31
[ 5.675200] Bluetooth: HCI device and connection manager initialized
[ 5.863994] Bluetooth: HCI socket layer initialized
[ 6.049153] Bluetooth: L2CAP socket layer initialized
[ 6.056455] Bluetooth: SCO socket layer initialized
[ 6.180000] usbcore: registered new interface driver btusb
[ 18.972558] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[ 19.385230] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[ 20.079510] bcm2835 ALSA card created!
[ 20.091390] bcm2835 ALSA chip created!
[ 20.102514] bcm2835 ALSA chip created!
[ 20.113109] bcm2835 ALSA chip created!
[ 20.123419] bcm2835 ALSA chip created!
[ 20.131379] bcm2835 ALSA chip created!
[ 20.139279] bcm2835 ALSA chip created!
[ 20.146991] bcm2835 ALSA chip created!
[ 28.189641] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[ 36.525766] CIFS: no cache= option specified, using "cache=loose". This default will change to "cache=strict" in 3.7.
[ 36.572139] CIFS VFS: default security mechanism requested. The default security mechanism will be upgraded from ntlm to ntlmv2 in kernel release 3.3
[ 48.907608] Adding 102396k swap on /var/swap. Priority:-1 extents:129 across:1754856k SS
[ 49.418627] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[ 49.418657] Bluetooth: BNEP filters: protocol multicast
[ 49.507472] Bluetooth: RFCOMM TTY layer initialized
[ 49.508202] Bluetooth: RFCOMM socket layer initialized
[ 49.508226] Bluetooth: RFCOMM ver 1.11
[ 52.089028] Bluetooth: hci0 command 0x0c45 tx timeout
[ 54.088928] Bluetooth: hci0 command 0x080f tx timeout
[ 56.088773] Bluetooth: hci0 command 0x0c24 tx timeout

@castalla castalla reopened this Jan 24, 2013
@castalla
Copy link
Author

Oops - hit wrong submit.

@castalla
Copy link
Author

A further procedural point. I tried the bt speaker when the Pi was using network wifi. I was able to switch off the speaker without a network failure. However, when I switched the speaker back on, it emiited one pairing beep (instead of the normal two beeps) and the network immediately crashed.

@licaon-kter
Copy link

what's different in your custom kernel?

@castalla
Copy link
Author

Sorry - i don't understand. I am using the Squeezeplug image which allows you to update the firmware (and the kernel?). In any event, the same issue is present in all the standard kernels. I've tried using this system for over a month without success. The fault is 100% reproducible - every time.

I suspect that the bt problem hasn't arisen with bt keyboards/mice because these would normally never be physically switched off, and therefore no-one else has raised the issue. I am surprised that only one other user has reported a similar problem with a bt headset.

@castalla
Copy link
Author

I should add that the fault is evident with any bt speaker I have used - not just the Logitech.

@castalla
Copy link
Author

here's the syslog


Jan 24 06:25:19 squeezeplug rsyslogd: [origin software="rsyslogd" swVersion="5.8.11" x-pid="1898" x-info="http://www.rsyslog.com"] rsyslogd was HUPed
Jan 24 07:17:01 squeezeplug /USR/SBIN/CRON[2668]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 24 08:17:01 squeezeplug /USR/SBIN/CRON[2680]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 24 08:46:16 squeezeplug dbus[2015]: [system] Activating service name='org.freedesktop.ConsoleKit' (using servicehelper)
Jan 24 08:46:16 squeezeplug dbus[2015]: [system] Activating service name='org.freedesktop.PolicyKit1' (using servicehelper)
Jan 24 08:46:16 squeezeplug polkitd[2762]: started daemon version 0.105 using authority implementation local' version0.105'
Jan 24 08:46:16 squeezeplug dbus[2015]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Jan 24 08:46:16 squeezeplug dbus[2015]: [system] Successfully activated service 'org.freedesktop.ConsoleKit'
Jan 24 08:46:21 squeezeplug shutdown[2776]: shutting down for system halt
Jan 24 08:46:28 squeezeplug init: Switching to runlevel: 0
Jan 24 08:46:29 squeezeplug bluetoothd[2103]: Terminating
Jan 24 08:46:29 squeezeplug bluetoothd[2103]: Stopping hci0 event socket
Jan 24 08:46:29 squeezeplug bluetoothd[2103]: Stopping SDP server
Jan 24 08:46:29 squeezeplug bluetoothd[2103]: Exit
Jan 24 08:46:30 squeezeplug ifplugd(eth0)[1457]: Exiting.
Jan 24 08:46:30 squeezeplug avahi-daemon[2060]: Got SIGTERM, quitting.
Jan 24 08:46:30 squeezeplug avahi-daemon[2060]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.20.
Jan 24 08:46:30 squeezeplug avahi-daemon[2060]: avahi-daemon 0.6.31 exiting.
Jan 24 08:46:43 squeezeplug ifplugd(lo)[1455]: Exiting.
Jan 24 08:46:43 squeezeplug ntpd[2051]: ntpd exiting on signal 15
Jan 24 08:46:54 squeezeplug kernel: imklog 5.8.11, log source = /proc/kmsg started.
Jan 24 08:46:54 squeezeplug rsyslogd: [origin software="rsyslogd" swVersion="5.8.11" x-pid="1890" x-info="http://www.rsyslog.com"] start
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Booting Linux on physical CPU 0
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Initializing cgroup subsys cpu
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Linux version 3.6.11+ (user@ubuntu-VirtualBox) (gcc version 4.7.1 20120402 (prerelease) (crosstool-NG 1.15.2) ) #5 PREEMPT Fri Jan 18 16:48:08 EET 2013
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Machine: BCM2708
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] cma: CMA: reserved 16 MiB at 0e000000
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Memory policy: ECC disabled, Data cache writeback
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] On node 0 totalpages: 61440
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] free_area_init_node: node 0, pgdat c053d834, node_mem_map c05e7000
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Normal zone: 480 pages used for memmap
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Normal zone: 0 pages reserved
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Normal zone: 60960 pages, LIFO batch:15
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1_32768
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] pcpu-alloc: [0] 0
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 60960
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Kernel command line: dma.dmachans=0x7f35 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708.boardrev=0x4 bcm2708.serial=0x8f9c86fb smsc95xx.macaddr=B8:27:EB:9C:86:FB sdhci-bcm2708.emmc_clock_freq=100000000 vc_mem.mem_base=0xfa00000 vc_mem.mem_size=0x10000000 dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Memory: 240MB = 240MB total
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Memory: 221128k/221128k available, 24632k reserved, 0K highmem
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Virtual kernel memory layout:
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] vmalloc : 0xcf800000 - 0xff000000 ( 760 MB)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] lowmem : 0xc0000000 - 0xcf000000 ( 240 MB)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] modules : 0xbf000000 - 0xc0000000 ( 16 MB)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] .text : 0xc0008000 - 0xc04e74a8 (4990 kB)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] .init : 0xc04e8000 - 0xc0508f24 ( 132 kB)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] .data : 0xc050a000 - 0xc053e060 ( 209 kB)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] .bss : 0xc053e084 - 0xc05e6738 ( 674 kB)
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] NR_IRQS:330
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 4294967ms
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] Console: colour dummy device 80x30
Jan 24 08:46:54 squeezeplug kernel: [ 0.000000] console [tty1] enabled
Jan 24 08:46:54 squeezeplug kernel: [ 0.001043] Calibrating delay loop... 464.48 BogoMIPS (lpj=2322432)
Jan 24 08:46:54 squeezeplug kernel: [ 0.060063] pid_max: default: 32768 minimum: 301
Jan 24 08:46:54 squeezeplug kernel: [ 0.060403] Mount-cache hash table entries: 512
Jan 24 08:46:54 squeezeplug kernel: [ 0.061167] Initializing cgroup subsys cpuacct
Jan 24 08:46:54 squeezeplug kernel: [ 0.061223] Initializing cgroup subsys devices
Jan 24 08:46:54 squeezeplug kernel: [ 0.061255] Initializing cgroup subsys freezer
Jan 24 08:46:54 squeezeplug kernel: [ 0.061284] Initializing cgroup subsys blkio
Jan 24 08:46:54 squeezeplug kernel: [ 0.061376] CPU: Testing write buffer coherency: ok
Jan 24 08:46:54 squeezeplug kernel: [ 0.061711] hw perfevents: enabled with v6 PMU driver, 3 counters available
Jan 24 08:46:54 squeezeplug kernel: [ 0.061860] Setting up static identity map for 0x39f380 - 0x39f3dc
Jan 24 08:46:54 squeezeplug kernel: [ 0.063366] devtmpfs: initialized
Jan 24 08:46:54 squeezeplug kernel: [ 0.073738] NET: Registered protocol family 16
Jan 24 08:46:54 squeezeplug kernel: [ 0.080086] DMA: preallocated 4096 KiB pool for atomic coherent allocations
Jan 24 08:46:54 squeezeplug kernel: [ 0.081259] bcm2708.uart_clock = 0
Jan 24 08:46:54 squeezeplug kernel: [ 0.082695] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
Jan 24 08:46:54 squeezeplug kernel: [ 0.082753] hw-breakpoint: maximum watchpoint size is 4 bytes.
Jan 24 08:46:54 squeezeplug kernel: [ 0.082788] mailbox: Broadcom VideoCore Mailbox driver
Jan 24 08:46:54 squeezeplug kernel: [ 0.082881] bcm2708_vcio: mailbox at f200b880
Jan 24 08:46:54 squeezeplug kernel: [ 0.082982] bcm_power: Broadcom power driver
Jan 24 08:46:54 squeezeplug kernel: [ 0.083019] bcm_power_open() -> 0
Jan 24 08:46:54 squeezeplug kernel: [ 0.083045] bcm_power_request(0, 8)
Jan 24 08:46:54 squeezeplug kernel: [ 0.583732] bcm_mailbox_read -> 00000080, 0
Jan 24 08:46:54 squeezeplug kernel: [ 0.583772] bcm_power_request -> 0
Jan 24 08:46:54 squeezeplug kernel: [ 0.583799] Serial: AMBA PL011 UART driver
Jan 24 08:46:54 squeezeplug kernel: [ 0.583939] dev:f1: ttyAMA0 at MMIO 0x20201000 (irq = 83) is a PL011 rev3
Jan 24 08:46:54 squeezeplug kernel: [ 0.904910] console [ttyAMA0] enabled
Jan 24 08:46:54 squeezeplug kernel: [ 0.928481] bio: create slab at 0
Jan 24 08:46:54 squeezeplug kernel: [ 0.933358] SCSI subsystem initialized
Jan 24 08:46:54 squeezeplug kernel: [ 0.937451] usbcore: registered new interface driver usbfs
Jan 24 08:46:54 squeezeplug kernel: [ 0.943034] usbcore: registered new interface driver hub
Jan 24 08:46:54 squeezeplug kernel: [ 0.948636] usbcore: registered new device driver usb
Jan 24 08:46:54 squeezeplug kernel: [ 0.955009] Switching to clocksource stc
Jan 24 08:46:54 squeezeplug kernel: [ 0.959255] FS-Cache: Loaded
Jan 24 08:46:54 squeezeplug kernel: [ 0.962402] CacheFiles: Loaded
Jan 24 08:46:54 squeezeplug kernel: [ 0.977613] NET: Registered protocol family 2
Jan 24 08:46:54 squeezeplug kernel: [ 0.982909] TCP established hash table entries: 8192 (order: 4, 65536 bytes)
Jan 24 08:46:54 squeezeplug kernel: [ 0.990261] TCP bind hash table entries: 8192 (order: 3, 32768 bytes)
Jan 24 08:46:54 squeezeplug kernel: [ 0.996844] TCP: Hash tables configured (established 8192 bind 8192)
Jan 24 08:46:54 squeezeplug kernel: [ 1.003275] TCP: reno registered
Jan 24 08:46:54 squeezeplug kernel: [ 1.006527] UDP hash table entries: 256 (order: 0, 4096 bytes)
Jan 24 08:46:54 squeezeplug kernel: [ 1.012426] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
Jan 24 08:46:54 squeezeplug kernel: [ 1.018974] NET: Registered protocol family 1
Jan 24 08:46:54 squeezeplug kernel: [ 1.023884] RPC: Registered named UNIX socket transport module.
Jan 24 08:46:54 squeezeplug kernel: [ 1.029924] RPC: Registered udp transport module.
Jan 24 08:46:54 squeezeplug kernel: [ 1.034646] RPC: Registered tcp transport module.
Jan 24 08:46:54 squeezeplug kernel: [ 1.039391] RPC: Registered tcp NFSv4.1 backchannel transport module.
Jan 24 08:46:54 squeezeplug kernel: [ 1.046527] bcm2708_dma: DMA manager at f2007000
Jan 24 08:46:54 squeezeplug kernel: [ 1.051314] bcm2708_gpio: bcm2708_gpio_probe c0517d98
Jan 24 08:46:54 squeezeplug kernel: [ 1.056784] vc-mem: phys_addr:0x00000000 mem_base=0x0fa00000 mem_size:0x10000000(256 MiB)
Jan 24 08:46:54 squeezeplug kernel: [ 1.065946] audit: initializing netlink socket (disabled)
Jan 24 08:46:54 squeezeplug kernel: [ 1.071546] type=2000 audit(0.930:1): initialized
Jan 24 08:46:54 squeezeplug kernel: [ 1.193783] VFS: Disk quotas dquot_6.5.2
Jan 24 08:46:54 squeezeplug kernel: [ 1.197816] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Jan 24 08:46:54 squeezeplug kernel: [ 1.204870] FS-Cache: Netfs 'nfs' registered for caching
Jan 24 08:46:54 squeezeplug kernel: [ 1.210622] NFS: Registering the id_resolver key type
Jan 24 08:46:54 squeezeplug kernel: [ 1.215783] Key type id_resolver registered
Jan 24 08:46:54 squeezeplug kernel: [ 1.220071] Key type id_legacy registered
Jan 24 08:46:54 squeezeplug kernel: [ 1.224443] msgmni has been set to 463
Jan 24 08:46:54 squeezeplug kernel: [ 1.230001] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Jan 24 08:46:54 squeezeplug kernel: [ 1.237707] io scheduler noop registered
Jan 24 08:46:54 squeezeplug kernel: [ 1.241747] io scheduler deadline registered (default)
Jan 24 08:46:54 squeezeplug kernel: [ 1.246929] io scheduler cfq registered
Jan 24 08:46:54 squeezeplug kernel: [ 1.274017] Console: switching to colour frame buffer device 82x26
Jan 24 08:46:54 squeezeplug kernel: [ 1.285417] kgdb: Registered I/O driver kgdboc.
Jan 24 08:46:54 squeezeplug kernel: [ 1.292584] vc-cma: Videocore CMA driver
Jan 24 08:46:54 squeezeplug kernel: [ 1.298374] vc-cma: vc_cma_base = 0x00000000
Jan 24 08:46:54 squeezeplug kernel: [ 1.304940] vc-cma: vc_cma_size = 0x00000000 (0 MiB)
Jan 24 08:46:54 squeezeplug kernel: [ 1.312123] vc-cma: vc_cma_initial = 0x00000000 (0 MiB)
Jan 24 08:46:54 squeezeplug kernel: [ 1.328269] brd: module loaded
Jan 24 08:46:54 squeezeplug kernel: [ 1.338034] loop: module loaded
Jan 24 08:46:54 squeezeplug kernel: [ 1.343267] vchiq: vchiq_init_state: slot_zero = 0xce000000, is_master = 0
Jan 24 08:46:54 squeezeplug kernel: [ 1.352646] Loading iSCSI transport class v2.0-870.
Jan 24 08:46:54 squeezeplug kernel: [ 1.360242] usbcore: registered new interface driver smsc95xx
Jan 24 08:46:54 squeezeplug kernel: [ 1.367795] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Jan 24 08:46:54 squeezeplug kernel: [ 1.580415] Core Release: 2.80a
Jan 24 08:46:54 squeezeplug kernel: [ 1.585252] Setting default values for core params
Jan 24 08:46:54 squeezeplug kernel: [ 1.591820] Finished setting default values for core params
Jan 24 08:46:54 squeezeplug kernel: [ 1.804233] Using Buffer DMA mode
Jan 24 08:46:54 squeezeplug kernel: [ 1.809265] Periodic Transfer Interrupt Enhancement - disabled
Jan 24 08:46:54 squeezeplug kernel: [ 1.816752] Multiprocessor Interrupt Enhancement - disabled
Jan 24 08:46:54 squeezeplug kernel: [ 1.824015] OTG VER PARAM: 0, OTG VER FLAG: 0
Jan 24 08:46:54 squeezeplug kernel: [ 1.830078] Dedicated Tx FIFOs mode
Jan 24 08:46:54 squeezeplug kernel: [ 1.836107] dwc_otg: Microframe scheduler enabled
Jan 24 08:46:54 squeezeplug kernel: [ 1.836461] dwc_otg bcm2708_usb: DWC OTG Controller
Jan 24 08:46:54 squeezeplug kernel: [ 1.843192] dwc_otg bcm2708_usb: new USB bus registered, assigned bus number 1
Jan 24 08:46:54 squeezeplug kernel: [ 1.852326] dwc_otg bcm2708_usb: irq 32, io mem 0x00000000
Jan 24 08:46:54 squeezeplug kernel: [ 1.859616] Init: Port Power? op_state=1
Jan 24 08:46:54 squeezeplug kernel: [ 1.865229] Init: Power Port (0)
Jan 24 08:46:54 squeezeplug kernel: [ 1.870256] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Jan 24 08:46:54 squeezeplug kernel: [ 1.878877] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan 24 08:46:54 squeezeplug kernel: [ 1.887960] usb usb1: Product: DWC OTG Controller
Jan 24 08:46:54 squeezeplug kernel: [ 1.894531] usb usb1: Manufacturer: Linux 3.6.11+ dwc_otg_hcd
Jan 24 08:46:54 squeezeplug kernel: [ 1.902131] usb usb1: SerialNumber: bcm2708_usb
Jan 24 08:46:54 squeezeplug kernel: [ 1.909277] hub 1-0:1.0: USB hub found
Jan 24 08:46:54 squeezeplug kernel: [ 1.914838] hub 1-0:1.0: 1 port detected
Jan 24 08:46:54 squeezeplug kernel: [ 1.920830] dwc_otg: FIQ enabled
Jan 24 08:46:54 squeezeplug kernel: [ 1.920846] dwc_otg: NAK holdoff enabled
Jan 24 08:46:54 squeezeplug kernel: [ 1.920865] Module dwc_common_port init
Jan 24 08:46:54 squeezeplug kernel: [ 1.921088] Initializing USB Mass Storage driver...
Jan 24 08:46:54 squeezeplug kernel: [ 1.927892] usbcore: registered new interface driver usb-storage
Jan 24 08:46:54 squeezeplug kernel: [ 1.935730] USB Mass Storage support registered.
Jan 24 08:46:54 squeezeplug kernel: [ 1.942258] usbcore: registered new interface driver libusual
Jan 24 08:46:54 squeezeplug kernel: [ 1.950089] mousedev: PS/2 mouse device common for all mice
Jan 24 08:46:54 squeezeplug kernel: [ 1.958088] bcm2835-cpufreq: min=700000 max=700000 cur=700000
Jan 24 08:46:54 squeezeplug kernel: [ 1.963957] bcm2835-cpufreq: switching to governor powersavebcm2835-cpufreq: switching to governor powersave
Jan 24 08:46:54 squeezeplug kernel: [ 1.977349] cpuidle: using governor ladder
Jan 24 08:46:54 squeezeplug kernel: [ 1.985069] cpuidle: using governor menu
Jan 24 08:46:54 squeezeplug kernel: [ 1.990793] sdhci: Secure Digital Host Controller Interface driver
Jan 24 08:46:54 squeezeplug kernel: [ 1.998726] sdhci: Copyright(c) Pierre Ossman
Jan 24 08:46:54 squeezeplug kernel: [ 2.004914] sdhci: Enable low-latency mode
Jan 24 08:46:54 squeezeplug kernel: [ 2.049349] mmc0: SDHCI controller on BCM2708_Arasan [platform] using platform's DMA
Jan 24 08:46:54 squeezeplug kernel: [ 2.060891] mmc0: BCM2708 SDHC host at 0x20300000 DMA 2 IRQ 77
Jan 24 08:46:54 squeezeplug kernel: [ 2.070802] sdhci-pltfm: SDHCI platform and OF driver helper
Jan 24 08:46:54 squeezeplug kernel: [ 2.084103] usbcore: registered new interface driver usbhid
Jan 24 08:46:54 squeezeplug kernel: [ 2.091689] usbhid: USB HID core driver
Jan 24 08:46:54 squeezeplug kernel: [ 2.102165] TCP: cubic registered
Jan 24 08:46:54 squeezeplug kernel: [ 2.109511] Initializing XFRM netlink socket
Jan 24 08:46:54 squeezeplug kernel: [ 2.117823] NET: Registered protocol family 17
Jan 24 08:46:54 squeezeplug kernel: [ 2.124358] Indeed it is in host mode hprt0 = 00021501
Jan 24 08:46:54 squeezeplug kernel: [ 2.134875] Key type dns_resolver registered
Jan 24 08:46:54 squeezeplug kernel: [ 2.149521] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
Jan 24 08:46:54 squeezeplug kernel: [ 2.171644] mmc0: could read SD Status register (SSR) at the 2th attempt
Jan 24 08:46:54 squeezeplug kernel: [ 2.181089] registered taskstats version 1
Jan 24 08:46:54 squeezeplug kernel: [ 2.199677] Waiting for root device /dev/mmcblk0p2...
Jan 24 08:46:54 squeezeplug kernel: [ 2.210614] mmc0: new high speed SDHC card at address b368
Jan 24 08:46:54 squeezeplug kernel: [ 2.229364] mmcblk0: mmc0:b368 NCard 3.73 GiB
Jan 24 08:46:54 squeezeplug kernel: [ 2.250277] mmcblk0: p1 p2
Jan 24 08:46:54 squeezeplug kernel: [ 2.329537] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Jan 24 08:46:54 squeezeplug kernel: [ 2.341813] VFS: Mounted root (ext4 filesystem) on device 179:2.
Jan 24 08:46:54 squeezeplug kernel: [ 2.358720] devtmpfs: mounted
Jan 24 08:46:54 squeezeplug kernel: [ 2.364215] Freeing init memory: 128K
Jan 24 08:46:54 squeezeplug kernel: [ 2.379175] usb 1-1: new high-speed USB device number 2 using dwc_otg
Jan 24 08:46:54 squeezeplug kernel: [ 2.387820] Indeed it is in host mode hprt0 = 00001101
Jan 24 08:46:54 squeezeplug kernel: [ 2.599469] usb 1-1: New USB device found, idVendor=0424, idProduct=9512
Jan 24 08:46:54 squeezeplug kernel: [ 2.609590] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Jan 24 08:46:54 squeezeplug kernel: [ 2.619725] hub 1-1:1.0: USB hub found
Jan 24 08:46:54 squeezeplug kernel: [ 2.625698] hub 1-1:1.0: 3 ports detected
Jan 24 08:46:54 squeezeplug kernel: [ 2.909467] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
Jan 24 08:46:54 squeezeplug kernel: [ 3.019601] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
Jan 24 08:46:54 squeezeplug kernel: [ 3.028588] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Jan 24 08:46:54 squeezeplug kernel: [ 3.041272] smsc95xx v1.0.4
Jan 24 08:46:54 squeezeplug kernel: [ 3.114041] smsc95xx 1-1.1:1.0: eth0: register 'smsc95xx' at usb-bcm2708_usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:9c:86:fb
Jan 24 08:46:54 squeezeplug kernel: [ 3.229380] usb 1-1.2: new full-speed USB device number 4 using dwc_otg
Jan 24 08:46:54 squeezeplug kernel: [ 3.341446] usb 1-1.2: New USB device found, idVendor=0a12, idProduct=0001
Jan 24 08:46:54 squeezeplug kernel: [ 3.359215] usb 1-1.2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Jan 24 08:46:54 squeezeplug kernel: [ 5.098408] Registered led device: led0
Jan 24 08:46:54 squeezeplug kernel: [ 5.375506] Bluetooth: Core ver 2.16
Jan 24 08:46:54 squeezeplug kernel: [ 5.721685] NET: Registered protocol family 31
Jan 24 08:46:54 squeezeplug kernel: [ 5.728313] Bluetooth: HCI device and connection manager initialized
Jan 24 08:46:54 squeezeplug kernel: [ 6.034525] Bluetooth: HCI socket layer initialized
Jan 24 08:46:54 squeezeplug kernel: [ 6.083283] Bluetooth: L2CAP socket layer initialized
Jan 24 08:46:54 squeezeplug kernel: [ 6.178349] Bluetooth: SCO socket layer initialized
Jan 24 08:46:54 squeezeplug kernel: [ 6.290534] usbcore: registered new interface driver btusb
Jan 24 08:46:54 squeezeplug kernel: [ 15.955321] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Jan 24 08:46:54 squeezeplug kernel: [ 16.352166] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Jan 24 08:46:54 squeezeplug kernel: [ 17.066145] bcm2835 ALSA card created!
Jan 24 08:46:54 squeezeplug kernel: [ 17.078042] bcm2835 ALSA chip created!
Jan 24 08:46:54 squeezeplug kernel: [ 17.089471] bcm2835 ALSA chip created!
Jan 24 08:46:54 squeezeplug kernel: [ 17.100124] bcm2835 ALSA chip created!
Jan 24 08:46:54 squeezeplug kernel: [ 17.110450] bcm2835 ALSA chip created!
Jan 24 08:46:54 squeezeplug kernel: [ 17.118368] bcm2835 ALSA chip created!
Jan 24 08:46:54 squeezeplug kernel: [ 17.126329] bcm2835 ALSA chip created!
Jan 24 08:46:54 squeezeplug kernel: [ 17.134180] bcm2835 ALSA chip created!
Jan 24 08:46:54 squeezeplug kernel: [ 25.366522] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
Jan 24 08:46:54 squeezeplug kernel: [ 28.970648] CIFS: no cache= option specified, using "cache=loose". This default will change to "cache=strict" in 3.7.
Jan 24 08:46:54 squeezeplug kernel: [ 29.016910] CIFS VFS: default security mechanism requested. The default security mechanism will be upgraded from ntlm to ntlmv2 in kernel release 3.3
Jan 24 08:46:55 squeezeplug /usr/sbin/cron[1960]: (CRON) INFO (pidfile fd = 3)
Jan 24 08:46:55 squeezeplug /usr/sbin/cron[1963]: (CRON) STARTUP (fork ok)
Jan 24 08:46:55 squeezeplug /usr/sbin/cron[1963]: (CRON) INFO (Running @reboot jobs)
Jan 24 08:46:56 squeezeplug kernel: [ 34.002246] Adding 102396k swap on /var/swap. Priority:-1 extents:129 across:1754856k SS
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: Found user 'avahi' (UID 109) and group 'avahi' (GID 114).
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: Successfully dropped root privileges.
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: avahi-daemon 0.6.31 starting up.
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: Successfully called chroot().
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: Successfully dropped remaining capabilities.
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: Loading service file /services/udisks.service.
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: socket() failed: Address family not supported by protocol
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: Failed to create IPv6 socket, proceeding in IPv4 only mode
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: socket() failed: Address family not supported by protocol
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.20.
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: New relevant interface eth0.IPv4 for mDNS.
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: Network interface enumeration completed.
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: Registering new address record for 192.168.1.20 on eth0.IPv4.
Jan 24 08:46:56 squeezeplug avahi-daemon[2024]: Registering HINFO record with values 'ARMV6L'/'LINUX'.
Jan 24 08:46:56 squeezeplug bluetoothd[2059]: Bluetooth daemon 4.99
Jan 24 08:46:56 squeezeplug bluetoothd[2059]: Starting SDP server
Jan 24 08:46:56 squeezeplug bluetoothd[2059]: Failed to init alert plugin
Jan 24 08:46:56 squeezeplug bluetoothd[2059]: Failed to init time plugin
Jan 24 08:46:56 squeezeplug bluetoothd[2059]: Failed to init gatt_example plugin
Jan 24 08:46:56 squeezeplug bluetoothd[2059]: Listening for HCI events on hci0
Jan 24 08:46:56 squeezeplug kernel: [ 34.549233] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Jan 24 08:46:56 squeezeplug kernel: [ 34.549266] Bluetooth: BNEP filters: protocol multicast
Jan 24 08:46:56 squeezeplug kernel: [ 34.591117] Bluetooth: RFCOMM TTY layer initialized
Jan 24 08:46:56 squeezeplug kernel: [ 34.591180] Bluetooth: RFCOMM socket layer initialized
Jan 24 08:46:56 squeezeplug kernel: [ 34.591197] Bluetooth: RFCOMM ver 1.11
Jan 24 08:46:57 squeezeplug bluetoothd[2059]: HCI dev 0 up
Jan 24 08:46:57 squeezeplug bluetoothd[2059]: Proximity GATT Reporter Driver: Operation not permitted (1)
Jan 24 08:46:57 squeezeplug avahi-daemon[2024]: Server startup complete. Host name is squeezeplug.local. Local service cookie is 3477310778.
Jan 24 08:46:58 squeezeplug avahi-daemon[2024]: Service "squeezeplug" (/services/udisks.service) successfully established.
Jan 24 08:47:00 squeezeplug bluetoothd[2059]: Could not get the contents of DMI chassis type
Jan 24 08:47:00 squeezeplug bluetoothd[2059]: Unable to load keys to adapter_ops: Function not implemented (38)
Jan 24 08:47:00 squeezeplug bluetoothd[2059]: Adapter /org/bluez/2059/hci0 has been enabled
Jan 24 08:47:00 squeezeplug ntpd[2128]: ntpd [email protected] Fri May 18 20:30:57 UTC 2012 (1)
Jan 24 08:47:01 squeezeplug ntpd[2132]: proto: precision = 1.000 usec
Jan 24 08:47:01 squeezeplug ntpd[2132]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
Jan 24 08:47:01 squeezeplug ntpd[2132]: Listen normally on 1 lo 127.0.0.1 UDP 123
Jan 24 08:47:01 squeezeplug ntpd[2132]: Listen normally on 2 eth0 192.168.1.20 UDP 123
Jan 24 08:47:01 squeezeplug ntpd[2132]: peers refreshed
Jan 24 08:47:01 squeezeplug ntpd[2132]: Listening on routing socket on fd #19 for interface updates
Jan 24 08:47:01 squeezeplug ntpd[2132]: restrict: error in address '::' on line 38. Ignoring...
Jan 24 08:47:01 squeezeplug ntpd[2132]: restrict: error in address '::1' on line 42. Ignoring...
Jan 24 15:14:07 squeezeplug dbus[1980]: [system] Activating service name='org.freedesktop.ConsoleKit' (using servicehelper)
Jan 24 15:14:08 squeezeplug dbus[1980]: [system] Activating service name='org.freedesktop.PolicyKit1' (using servicehelper)
Jan 24 15:14:11 squeezeplug polkitd[2345]: started daemon version 0.105 using authority implementation local' version0.105'
Jan 24 15:14:11 squeezeplug dbus[1980]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Jan 24 15:14:11 squeezeplug dbus[1980]: [system] Successfully activated service 'org.freedesktop.ConsoleKit'
Jan 24 15:17:02 squeezeplug /USR/SBIN/CRON[2398]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 24 15:19:07 squeezeplug kernel: [ 395.992382] mmc0: missed completion of cmd 18 DMA (512/512 [1]/[1]) - ignoring it
Jan 24 15:19:07 squeezeplug kernel: [ 395.992434] mmc0: DMA IRQ 6 ignored - results were reset
Jan 24 15:19:07 squeezeplug kernel: [ 396.332742] mmc0: missed completion of cmd 18 DMA (512/512 [1]/[1]) - ignoring it
Jan 24 15:19:07 squeezeplug kernel: [ 396.332817] mmc0: DMA IRQ 6 ignored - results were reset
Jan 24 15:21:17 squeezeplug kernel: [ 526.204385] smsc95xx 1-1.1:1.0: eth0: kevent 2 may have been dropped
Jan 24 15:24:29 squeezeplug kernel: [ 717.622049] smsc95xx 1-1.1:1.0: eth0: kevent 2 may have been dropped
Jan 24 16:17:01 squeezeplug /USR/SBIN/CRON[2439]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 24 16:23:26 squeezeplug shutdown[2448]: shutting down for system reboot
Jan 24 16:23:29 squeezeplug init: Switching to runlevel: 6
Jan 24 16:23:30 squeezeplug bluetoothd[2059]: Terminating
Jan 24 16:23:30 squeezeplug bluetoothd[2059]: Stopping hci0 event socket
Jan 24 16:23:30 squeezeplug bluetoothd[2059]: Stopping SDP server
Jan 24 16:23:30 squeezeplug bluetoothd[2059]: Exit
Jan 24 16:23:31 squeezeplug ifplugd(eth0)[1451]: Exiting.
Jan 24 16:23:32 squeezeplug avahi-daemon[2024]: Got SIGTERM, quitting.
Jan 24 16:23:32 squeezeplug avahi-daemon[2024]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.20.
Jan 24 16:23:32 squeezeplug avahi-daemon[2024]: avahi-daemon 0.6.31 exiting.
Jan 24 16:23:46 squeezeplug ifplugd(lo)[1458]: Exiting.
Jan 24 16:23:46 squeezeplug ntpd[2132]: ntpd exiting on signal 15
Jan 24 16:24:07 squeezeplug kernel: imklog 5.8.11, log source = /proc/kmsg started.
Jan 24 16:24:07 squeezeplug rsyslogd: [origin software="rsyslogd" swVersion="5.8.11" x-pid="1934" x-info="http://www.rsyslog.com"] start
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Booting Linux on physical CPU 0
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Initializing cgroup subsys cpu
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Linux version 3.6.11+ (user@ubuntu-VirtualBox) (gcc version 4.7.1 20120402 (prerelease) (crosstool-NG 1.15.2) ) #5 PREEMPT Fri Jan 18 16:48:08 EET 2013
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Machine: BCM2708
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] cma: CMA: reserved 16 MiB at 0e000000
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Memory policy: ECC disabled, Data cache writeback
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] On node 0 totalpages: 61440
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] free_area_init_node: node 0, pgdat c053d834, node_mem_map c05e7000
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Normal zone: 480 pages used for memmap
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Normal zone: 0 pages reserved
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Normal zone: 60960 pages, LIFO batch:15
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1_32768
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] pcpu-alloc: [0] 0
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 60960
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Kernel command line: dma.dmachans=0x7f35 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708.boardrev=0x4 bcm2708.serial=0x8f9c86fb smsc95xx.macaddr=B8:27:EB:9C:86:FB sdhci-bcm2708.emmc_clock_freq=100000000 vc_mem.mem_base=0xfa00000 vc_mem.mem_size=0x10000000 dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Memory: 240MB = 240MB total
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Memory: 221128k/221128k available, 24632k reserved, 0K highmem
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Virtual kernel memory layout:
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] vmalloc : 0xcf800000 - 0xff000000 ( 760 MB)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] lowmem : 0xc0000000 - 0xcf000000 ( 240 MB)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] modules : 0xbf000000 - 0xc0000000 ( 16 MB)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] .text : 0xc0008000 - 0xc04e74a8 (4990 kB)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] .init : 0xc04e8000 - 0xc0508f24 ( 132 kB)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] .data : 0xc050a000 - 0xc053e060 ( 209 kB)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] .bss : 0xc053e084 - 0xc05e6738 ( 674 kB)
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] NR_IRQS:330
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 4294967ms
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] Console: colour dummy device 80x30
Jan 24 16:24:07 squeezeplug kernel: [ 0.000000] console [tty1] enabled
Jan 24 16:24:07 squeezeplug kernel: [ 0.001034] Calibrating delay loop... 464.48 BogoMIPS (lpj=2322432)
Jan 24 16:24:07 squeezeplug kernel: [ 0.060064] pid_max: default: 32768 minimum: 301
Jan 24 16:24:07 squeezeplug kernel: [ 0.060406] Mount-cache hash table entries: 512
Jan 24 16:24:07 squeezeplug kernel: [ 0.061161] Initializing cgroup subsys cpuacct
Jan 24 16:24:07 squeezeplug kernel: [ 0.061218] Initializing cgroup subsys devices
Jan 24 16:24:07 squeezeplug kernel: [ 0.061250] Initializing cgroup subsys freezer
Jan 24 16:24:07 squeezeplug kernel: [ 0.061278] Initializing cgroup subsys blkio
Jan 24 16:24:07 squeezeplug kernel: [ 0.061376] CPU: Testing write buffer coherency: ok
Jan 24 16:24:07 squeezeplug kernel: [ 0.061708] hw perfevents: enabled with v6 PMU driver, 3 counters available
Jan 24 16:24:07 squeezeplug kernel: [ 0.061857] Setting up static identity map for 0x39f380 - 0x39f3dc
Jan 24 16:24:07 squeezeplug kernel: [ 0.063358] devtmpfs: initialized
Jan 24 16:24:07 squeezeplug kernel: [ 0.073701] NET: Registered protocol family 16
Jan 24 16:24:07 squeezeplug kernel: [ 0.080043] DMA: preallocated 4096 KiB pool for atomic coherent allocations
Jan 24 16:24:07 squeezeplug kernel: [ 0.081218] bcm2708.uart_clock = 0
Jan 24 16:24:07 squeezeplug kernel: [ 0.082655] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
Jan 24 16:24:07 squeezeplug kernel: [ 0.082708] hw-breakpoint: maximum watchpoint size is 4 bytes.
Jan 24 16:24:07 squeezeplug kernel: [ 0.082745] mailbox: Broadcom VideoCore Mailbox driver
Jan 24 16:24:07 squeezeplug kernel: [ 0.082839] bcm2708_vcio: mailbox at f200b880
Jan 24 16:24:07 squeezeplug kernel: [ 0.082939] bcm_power: Broadcom power driver
Jan 24 16:24:07 squeezeplug kernel: [ 0.082976] bcm_power_open() -> 0
Jan 24 16:24:07 squeezeplug kernel: [ 0.083001] bcm_power_request(0, 8)
Jan 24 16:24:07 squeezeplug kernel: [ 0.583689] bcm_mailbox_read -> 00000080, 0
Jan 24 16:24:07 squeezeplug kernel: [ 0.583728] bcm_power_request -> 0
Jan 24 16:24:07 squeezeplug kernel: [ 0.583753] Serial: AMBA PL011 UART driver
Jan 24 16:24:07 squeezeplug kernel: [ 0.583893] dev:f1: ttyAMA0 at MMIO 0x20201000 (irq = 83) is a PL011 rev3
Jan 24 16:24:07 squeezeplug kernel: [ 0.904864] console [ttyAMA0] enabled
Jan 24 16:24:07 squeezeplug kernel: [ 0.928415] bio: create slab at 0
Jan 24 16:24:07 squeezeplug kernel: [ 0.933290] SCSI subsystem initialized
Jan 24 16:24:07 squeezeplug kernel: [ 0.937377] usbcore: registered new interface driver usbfs
Jan 24 16:24:07 squeezeplug kernel: [ 0.942959] usbcore: registered new interface driver hub
Jan 24 16:24:07 squeezeplug kernel: [ 0.948549] usbcore: registered new device driver usb
Jan 24 16:24:07 squeezeplug kernel: [ 0.954915] Switching to clocksource stc
Jan 24 16:24:07 squeezeplug kernel: [ 0.959158] FS-Cache: Loaded
Jan 24 16:24:07 squeezeplug kernel: [ 0.962307] CacheFiles: Loaded
Jan 24 16:24:07 squeezeplug kernel: [ 0.977403] NET: Registered protocol family 2
Jan 24 16:24:07 squeezeplug kernel: [ 0.982697] TCP established hash table entries: 8192 (order: 4, 65536 bytes)
Jan 24 16:24:07 squeezeplug kernel: [ 0.990047] TCP bind hash table entries: 8192 (order: 3, 32768 bytes)
Jan 24 16:24:07 squeezeplug kernel: [ 0.996629] TCP: Hash tables configured (established 8192 bind 8192)
Jan 24 16:24:07 squeezeplug kernel: [ 1.003060] TCP: reno registered
Jan 24 16:24:07 squeezeplug kernel: [ 1.006313] UDP hash table entries: 256 (order: 0, 4096 bytes)
Jan 24 16:24:07 squeezeplug kernel: [ 1.012210] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
Jan 24 16:24:07 squeezeplug kernel: [ 1.018758] NET: Registered protocol family 1
Jan 24 16:24:07 squeezeplug kernel: [ 1.023667] RPC: Registered named UNIX socket transport module.
Jan 24 16:24:07 squeezeplug kernel: [ 1.029713] RPC: Registered udp transport module.
Jan 24 16:24:07 squeezeplug kernel: [ 1.034435] RPC: Registered tcp transport module.
Jan 24 16:24:07 squeezeplug kernel: [ 1.039180] RPC: Registered tcp NFSv4.1 backchannel transport module.
Jan 24 16:24:07 squeezeplug kernel: [ 1.046315] bcm2708_dma: DMA manager at f2007000
Jan 24 16:24:07 squeezeplug kernel: [ 1.051098] bcm2708_gpio: bcm2708_gpio_probe c0517d98
Jan 24 16:24:07 squeezeplug kernel: [ 1.056563] vc-mem: phys_addr:0x00000000 mem_base=0x0fa00000 mem_size:0x10000000(256 MiB)
Jan 24 16:24:07 squeezeplug kernel: [ 1.065746] audit: initializing netlink socket (disabled)
Jan 24 16:24:07 squeezeplug kernel: [ 1.071346] type=2000 audit(0.930:1): initialized
Jan 24 16:24:07 squeezeplug kernel: [ 1.193589] VFS: Disk quotas dquot_6.5.2
Jan 24 16:24:07 squeezeplug kernel: [ 1.197626] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Jan 24 16:24:07 squeezeplug kernel: [ 1.204682] FS-Cache: Netfs 'nfs' registered for caching
Jan 24 16:24:07 squeezeplug kernel: [ 1.210432] NFS: Registering the id_resolver key type
Jan 24 16:24:07 squeezeplug kernel: [ 1.215593] Key type id_resolver registered
Jan 24 16:24:07 squeezeplug kernel: [ 1.219886] Key type id_legacy registered
Jan 24 16:24:07 squeezeplug kernel: [ 1.224257] msgmni has been set to 463
Jan 24 16:24:07 squeezeplug kernel: [ 1.229798] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Jan 24 16:24:07 squeezeplug kernel: [ 1.237519] io scheduler noop registered
Jan 24 16:24:07 squeezeplug kernel: [ 1.241559] io scheduler deadline registered (default)
Jan 24 16:24:07 squeezeplug kernel: [ 1.246742] io scheduler cfq registered
Jan 24 16:24:07 squeezeplug kernel: [ 1.273976] Console: switching to colour frame buffer device 82x26
Jan 24 16:24:07 squeezeplug kernel: [ 1.285378] kgdb: Registered I/O driver kgdboc.
Jan 24 16:24:07 squeezeplug kernel: [ 1.292550] vc-cma: Videocore CMA driver
Jan 24 16:24:07 squeezeplug kernel: [ 1.298341] vc-cma: vc_cma_base = 0x00000000
Jan 24 16:24:07 squeezeplug kernel: [ 1.304910] vc-cma: vc_cma_size = 0x00000000 (0 MiB)
Jan 24 16:24:07 squeezeplug kernel: [ 1.312092] vc-cma: vc_cma_initial = 0x00000000 (0 MiB)
Jan 24 16:24:07 squeezeplug kernel: [ 1.328193] brd: module loaded
Jan 24 16:24:07 squeezeplug kernel: [ 1.337938] loop: module loaded
Jan 24 16:24:07 squeezeplug kernel: [ 1.343164] vchiq: vchiq_init_state: slot_zero = 0xce000000, is_master = 0
Jan 24 16:24:07 squeezeplug kernel: [ 1.352547] Loading iSCSI transport class v2.0-870.
Jan 24 16:24:07 squeezeplug kernel: [ 1.360148] usbcore: registered new interface driver smsc95xx
Jan 24 16:24:07 squeezeplug kernel: [ 1.367704] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Jan 24 16:24:07 squeezeplug kernel: [ 1.580319] Core Release: 2.80a
Jan 24 16:24:07 squeezeplug kernel: [ 1.585157] Setting default values for core params
Jan 24 16:24:07 squeezeplug kernel: [ 1.591733] Finished setting default values for core params
Jan 24 16:24:07 squeezeplug kernel: [ 1.804150] Using Buffer DMA mode
Jan 24 16:24:07 squeezeplug kernel: [ 1.809188] Periodic Transfer Interrupt Enhancement - disabled
Jan 24 16:24:07 squeezeplug kernel: [ 1.816690] Multiprocessor Interrupt Enhancement - disabled
Jan 24 16:24:07 squeezeplug kernel: [ 1.823958] OTG VER PARAM: 0, OTG VER FLAG: 0
Jan 24 16:24:07 squeezeplug kernel: [ 1.830027] Dedicated Tx FIFOs mode
Jan 24 16:24:07 squeezeplug kernel: [ 1.836064] dwc_otg: Microframe scheduler enabled
Jan 24 16:24:07 squeezeplug kernel: [ 1.836431] dwc_otg bcm2708_usb: DWC OTG Controller
Jan 24 16:24:07 squeezeplug kernel: [ 1.843168] dwc_otg bcm2708_usb: new USB bus registered, assigned bus number 1
Jan 24 16:24:07 squeezeplug kernel: [ 1.852307] dwc_otg bcm2708_usb: irq 32, io mem 0x00000000
Jan 24 16:24:07 squeezeplug kernel: [ 1.859600] Init: Port Power? op_state=1
Jan 24 16:24:07 squeezeplug kernel: [ 1.865215] Init: Power Port (0)
Jan 24 16:24:07 squeezeplug kernel: [ 1.870244] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Jan 24 16:24:07 squeezeplug kernel: [ 1.878870] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan 24 16:24:07 squeezeplug kernel: [ 1.887950] usb usb1: Product: DWC OTG Controller
Jan 24 16:24:07 squeezeplug kernel: [ 1.894521] usb usb1: Manufacturer: Linux 3.6.11+ dwc_otg_hcd
Jan 24 16:24:07 squeezeplug kernel: [ 1.902121] usb usb1: SerialNumber: bcm2708_usb
Jan 24 16:24:07 squeezeplug kernel: [ 1.909269] hub 1-0:1.0: USB hub found
Jan 24 16:24:07 squeezeplug kernel: [ 1.914835] hub 1-0:1.0: 1 port detected
Jan 24 16:24:07 squeezeplug kernel: [ 1.920827] dwc_otg: FIQ enabled
Jan 24 16:24:07 squeezeplug kernel: [ 1.920843] dwc_otg: NAK holdoff enabled
Jan 24 16:24:07 squeezeplug kernel: [ 1.920862] Module dwc_common_port init
Jan 24 16:24:07 squeezeplug kernel: [ 1.921087] Initializing USB Mass Storage driver...
Jan 24 16:24:07 squeezeplug kernel: [ 1.927887] usbcore: registered new interface driver usb-storage
Jan 24 16:24:07 squeezeplug kernel: [ 1.935728] USB Mass Storage support registered.
Jan 24 16:24:07 squeezeplug kernel: [ 1.942251] usbcore: registered new interface driver libusual
Jan 24 16:24:07 squeezeplug kernel: [ 1.950078] mousedev: PS/2 mouse device common for all mice
Jan 24 16:24:07 squeezeplug kernel: [ 1.958071] bcm2835-cpufreq: min=700000 max=700000 cur=700000
Jan 24 16:24:07 squeezeplug kernel: [ 1.963942] bcm2835-cpufreq: switching to governor powersavebcm2835-cpufreq: switching to governor powersave
Jan 24 16:24:07 squeezeplug kernel: [ 1.977328] cpuidle: using governor ladder
Jan 24 16:24:07 squeezeplug kernel: [ 1.985049] cpuidle: using governor menu
Jan 24 16:24:07 squeezeplug kernel: [ 1.990771] sdhci: Secure Digital Host Controller Interface driver
Jan 24 16:24:07 squeezeplug kernel: [ 1.998708] sdhci: Copyright(c) Pierre Ossman
Jan 24 16:24:07 squeezeplug kernel: [ 2.004896] sdhci: Enable low-latency mode
Jan 24 16:24:07 squeezeplug kernel: [ 2.049256] mmc0: SDHCI controller on BCM2708_Arasan [platform] using platform's DMA
Jan 24 16:24:07 squeezeplug kernel: [ 2.060791] mmc0: BCM2708 SDHC host at 0x20300000 DMA 2 IRQ 77
Jan 24 16:24:07 squeezeplug kernel: [ 2.070696] sdhci-pltfm: SDHCI platform and OF driver helper
Jan 24 16:24:07 squeezeplug kernel: [ 2.083986] usbcore: registered new interface driver usbhid
Jan 24 16:24:07 squeezeplug kernel: [ 2.091573] usbhid: USB HID core driver
Jan 24 16:24:07 squeezeplug kernel: [ 2.102039] TCP: cubic registered
Jan 24 16:24:07 squeezeplug kernel: [ 2.109377] Initializing XFRM netlink socket
Jan 24 16:24:07 squeezeplug kernel: [ 2.117680] NET: Registered protocol family 17
Jan 24 16:24:07 squeezeplug kernel: [ 2.124205] Indeed it is in host mode hprt0 = 00021501
Jan 24 16:24:07 squeezeplug kernel: [ 2.134706] Key type dns_resolver registered
Jan 24 16:24:07 squeezeplug kernel: [ 2.149424] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
Jan 24 16:24:07 squeezeplug kernel: [ 2.171576] mmc0: could read SD Status register (SSR) at the 2th attempt
Jan 24 16:24:07 squeezeplug kernel: [ 2.180854] registered taskstats version 1
Jan 24 16:24:07 squeezeplug kernel: [ 2.199581] Waiting for root device /dev/mmcblk0p2...
Jan 24 16:24:07 squeezeplug kernel: [ 2.210506] mmc0: new high speed SDHC card at address b368
Jan 24 16:24:07 squeezeplug kernel: [ 2.229273] mmcblk0: mmc0:b368 NCard 3.73 GiB
Jan 24 16:24:07 squeezeplug kernel: [ 2.250196] mmcblk0: p1 p2
Jan 24 16:24:07 squeezeplug kernel: [ 2.324140] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Jan 24 16:24:07 squeezeplug kernel: [ 2.336428] VFS: Mounted root (ext4 filesystem) on device 179:2.
Jan 24 16:24:07 squeezeplug kernel: [ 2.353303] devtmpfs: mounted
Jan 24 16:24:07 squeezeplug kernel: [ 2.358731] Freeing init memory: 128K
Jan 24 16:24:07 squeezeplug kernel: [ 2.379089] usb 1-1: new high-speed USB device number 2 using dwc_otg
Jan 24 16:24:07 squeezeplug kernel: [ 2.387752] Indeed it is in host mode hprt0 = 00001101
Jan 24 16:24:07 squeezeplug kernel: [ 2.599360] usb 1-1: New USB device found, idVendor=0424, idProduct=9512
Jan 24 16:24:07 squeezeplug kernel: [ 2.608483] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Jan 24 16:24:07 squeezeplug kernel: [ 2.619252] hub 1-1:1.0: USB hub found
Jan 24 16:24:07 squeezeplug kernel: [ 2.626429] hub 1-1:1.0: 3 ports detected
Jan 24 16:24:07 squeezeplug kernel: [ 2.909383] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
Jan 24 16:24:07 squeezeplug kernel: [ 3.039699] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
Jan 24 16:24:07 squeezeplug kernel: [ 3.048681] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Jan 24 16:24:07 squeezeplug kernel: [ 3.076008] smsc95xx v1.0.4
Jan 24 16:24:07 squeezeplug kernel: [ 3.143897] smsc95xx 1-1.1:1.0: eth0: register 'smsc95xx' at usb-bcm2708_usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:9c:86:fb
Jan 24 16:24:07 squeezeplug kernel: [ 3.249363] usb 1-1.2: new full-speed USB device number 4 using dwc_otg
Jan 24 16:24:07 squeezeplug kernel: [ 3.361337] usb 1-1.2: New USB device found, idVendor=0a12, idProduct=0001
Jan 24 16:24:07 squeezeplug kernel: [ 3.379092] usb 1-1.2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Jan 24 16:24:07 squeezeplug kernel: [ 5.113822] Registered led device: led0
Jan 24 16:24:07 squeezeplug kernel: [ 5.232559] Bluetooth: Core ver 2.16
Jan 24 16:24:07 squeezeplug kernel: [ 5.498860] NET: Registered protocol family 31
Jan 24 16:24:07 squeezeplug kernel: [ 5.675200] Bluetooth: HCI device and connection manager initialized
Jan 24 16:24:07 squeezeplug kernel: [ 5.863994] Bluetooth: HCI socket layer initialized
Jan 24 16:24:07 squeezeplug kernel: [ 6.049153] Bluetooth: L2CAP socket layer initialized
Jan 24 16:24:07 squeezeplug kernel: [ 6.056455] Bluetooth: SCO socket layer initialized
Jan 24 16:24:07 squeezeplug kernel: [ 6.180000] usbcore: registered new interface driver btusb
Jan 24 16:24:07 squeezeplug kernel: [ 18.972558] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Jan 24 16:24:07 squeezeplug kernel: [ 19.385230] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Jan 24 16:24:07 squeezeplug kernel: [ 20.079510] bcm2835 ALSA card created!
Jan 24 16:24:07 squeezeplug kernel: [ 20.091390] bcm2835 ALSA chip created!
Jan 24 16:24:07 squeezeplug kernel: [ 20.102514] bcm2835 ALSA chip created!
Jan 24 16:24:07 squeezeplug kernel: [ 20.113109] bcm2835 ALSA chip created!
Jan 24 16:24:07 squeezeplug kernel: [ 20.123419] bcm2835 ALSA chip created!
Jan 24 16:24:07 squeezeplug kernel: [ 20.131379] bcm2835 ALSA chip created!
Jan 24 16:24:07 squeezeplug kernel: [ 20.139279] bcm2835 ALSA chip created!
Jan 24 16:24:07 squeezeplug kernel: [ 20.146991] bcm2835 ALSA chip created!
Jan 24 16:24:07 squeezeplug kernel: [ 28.189641] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
Jan 24 16:24:07 squeezeplug kernel: [ 36.525766] CIFS: no cache= option specified, using "cache=loose". This default will change to "cache=strict" in 3.7.
Jan 24 16:24:07 squeezeplug kernel: [ 36.572139] CIFS VFS: default security mechanism requested. The default security mechanism will be upgraded from ntlm to ntlmv2 in kernel release 3.3
Jan 24 16:24:08 squeezeplug /usr/sbin/cron[2004]: (CRON) INFO (pidfile fd = 3)
Jan 24 16:24:09 squeezeplug /usr/sbin/cron[2005]: (CRON) STARTUP (fork ok)
Jan 24 16:24:11 squeezeplug /usr/sbin/cron[2005]: (CRON) INFO (Running @reboot jobs)
Jan 24 16:24:11 squeezeplug kernel: [ 48.907608] Adding 102396k swap on /var/swap. Priority:-1 extents:129 across:1754856k SS
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: Found user 'avahi' (UID 109) and group 'avahi' (GID 114).
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: Successfully dropped root privileges.
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: avahi-daemon 0.6.31 starting up.
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: Successfully called chroot().
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: Successfully dropped remaining capabilities.
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: Loading service file /services/udisks.service.
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: socket() failed: Address family not supported by protocol
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: Failed to create IPv6 socket, proceeding in IPv4 only mode
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: socket() failed: Address family not supported by protocol
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.20.
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: New relevant interface eth0.IPv4 for mDNS.
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: Network interface enumeration completed.
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: Registering new address record for 192.168.1.20 on eth0.IPv4.
Jan 24 16:24:12 squeezeplug avahi-daemon[2077]: Registering HINFO record with values 'ARMV6L'/'LINUX'.
Jan 24 16:24:12 squeezeplug bluetoothd[2099]: Bluetooth daemon 4.99
Jan 24 16:24:12 squeezeplug bluetoothd[2099]: Starting SDP server
Jan 24 16:24:12 squeezeplug bluetoothd[2099]: Failed to init alert plugin
Jan 24 16:24:12 squeezeplug bluetoothd[2099]: Failed to init time plugin
Jan 24 16:24:12 squeezeplug kernel: [ 49.418627] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Jan 24 16:24:12 squeezeplug kernel: [ 49.418657] Bluetooth: BNEP filters: protocol multicast
Jan 24 16:24:12 squeezeplug bluetoothd[2099]: Failed to init gatt_example plugin
Jan 24 16:24:12 squeezeplug bluetoothd[2099]: Listening for HCI events on hci0
Jan 24 16:24:12 squeezeplug kernel: [ 49.507472] Bluetooth: RFCOMM TTY layer initialized
Jan 24 16:24:12 squeezeplug kernel: [ 49.508202] Bluetooth: RFCOMM socket layer initialized
Jan 24 16:24:12 squeezeplug kernel: [ 49.508226] Bluetooth: RFCOMM ver 1.11
Jan 24 16:24:12 squeezeplug bluetoothd[2099]: HCI dev 0 up
Jan 24 16:24:12 squeezeplug bluetoothd[2099]: Proximity GATT Reporter Driver: Operation not permitted (1)
Jan 24 16:24:12 squeezeplug bluetoothd[2099]: Could not get the contents of DMI chassis type
Jan 24 16:24:13 squeezeplug avahi-daemon[2077]: Server startup complete. Host name is squeezeplug.local. Local service cookie is 3351112889.
Jan 24 16:24:13 squeezeplug bluetoothd[2099]: Unable to load keys to adapter_ops: Function not implemented (38)
Jan 24 16:24:13 squeezeplug bluetoothd[2099]: Adapter /org/bluez/2099/hci0 has been enabled
Jan 24 16:24:13 squeezeplug ntpd[2159]: ntpd [email protected] Fri May 18 20:30:57 UTC 2012 (1)
Jan 24 16:24:13 squeezeplug ntpd[2160]: proto: precision = 1.000 usec
Jan 24 16:24:13 squeezeplug ntpd[2160]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
Jan 24 16:24:13 squeezeplug ntpd[2160]: Listen normally on 1 lo 127.0.0.1 UDP 123
Jan 24 16:24:13 squeezeplug ntpd[2160]: Listen normally on 2 eth0 192.168.1.20 UDP 123
Jan 24 16:24:13 squeezeplug ntpd[2160]: peers refreshed
Jan 24 16:24:13 squeezeplug ntpd[2160]: Listening on routing socket on fd #19 for interface updates
Jan 24 16:24:13 squeezeplug ntpd[2160]: restrict: error in address '::' on line 38. Ignoring...
Jan 24 16:24:13 squeezeplug ntpd[2160]: restrict: error in address '::1' on line 42. Ignoring...
Jan 24 16:24:13 squeezeplug avahi-daemon[2077]: Service "squeezeplug" (/services/udisks.service) successfully established.
Jan 24 16:24:15 squeezeplug kernel: [ 52.089028] Bluetooth: hci0 command 0x0c45 tx timeout
Jan 24 16:24:17 squeezeplug kernel: [ 54.088928] Bluetooth: hci0 command 0x080f tx timeout
Jan 24 16:24:19 squeezeplug kernel: [ 56.088773] Bluetooth: hci0 command 0x0c24 tx timeout
Jan 24 16:43:11 squeezeplug dbus[2035]: [system] Activating service name='org.freedesktop.ConsoleKit' (using servicehelper)
Jan 24 16:43:11 squeezeplug dbus[2035]: [system] Activating service name='org.freedesktop.PolicyKit1' (using servicehelper)
Jan 24 16:43:12 squeezeplug polkitd[2377]: started daemon version 0.105 using authority implementation local' version0.105'
Jan 24 16:43:12 squeezeplug dbus[2035]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Jan 24 16:43:12 squeezeplug dbus[2035]: [system] Successfully activated service 'org.freedesktop.ConsoleKit'
Jan 24 17:17:01 squeezeplug /USR/SBIN/CRON[2426]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 24 18:17:01 squeezeplug /USR/SBIN/CRON[2441]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 24 19:17:01 squeezeplug /USR/SBIN/CRON[2456]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 24 20:17:01 squeezeplug /USR/SBIN/CRON[2470]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 24 21:17:01 squeezeplug /USR/SBIN/CRON[2502]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 24 22:17:01 squeezeplug /USR/SBIN/CRON[3138]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 24 23:17:01 squeezeplug /USR/SBIN/CRON[3153]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 25 00:17:01 squeezeplug /USR/SBIN/CRON[3169]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 25 01:17:01 squeezeplug /USR/SBIN/CRON[3184]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 25 02:17:01 squeezeplug /USR/SBIN/CRON[3198]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 25 03:02:12 squeezeplug dhclient: DHCPREQUEST on eth0 to 192.168.1.1 port 67
Jan 25 03:02:12 squeezeplug dhclient: DHCPACK from 192.168.1.1
Jan 25 03:02:12 squeezeplug dhclient: bound to 192.168.1.20 -- renewal in 35791 seconds.
Jan 25 03:17:01 squeezeplug /USR/SBIN/CRON[3243]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 25 04:17:01 squeezeplug /USR/SBIN/CRON[3257]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 25 05:17:01 squeezeplug /USR/SBIN/CRON[3273]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 25 06:17:01 squeezeplug /USR/SBIN/CRON[3289]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 25 06:25:01 squeezeplug /USR/SBIN/CRON[3297]: (root) CMD (test -x /usr/sbin/anacron || ( cd / && run-parts --report /etc/cron.daily )

@ghost ghost assigned ghollingworth Jan 25, 2013
@licaon-kter
Copy link

The firmware might get updated but you are using their custom kernel (so results might vary?!), can you try with the normal/official kernel, or you need something special in it hence the need for theirs?

@castalla
Copy link
Author

I tried with the normal kernel - same problems. Someone suggested a fix may be in the custom kernel ... that's probably why I used it.

Seems strange that such a basic feature cannot easily be fixed. I have an old Arm6 tablet which has ubuntu 9.02 on it and bluetooth works without any issues on that!

Certainly anybody is wasting their money if they expect bluetooth speakers to work with the Pi..

Just got to hope that somebody here picks this up and works on a fix.

I don't know what else to do - I've posted in just about every appropriate thread - no response, except somebody telling me to fix it myself!

@ghollingworth
Copy link

Sounds likely to be a USB problem, wait for the next USB fix and try again

Should be imminent, I'm still trying to fix some final bits but it is
looking promising

Gordon

On Friday, 25 January 2013, castalla wrote:

I tried with the normal kernel - same problems. Someone suggested a fix
may be in the custom kernel ... that's probably why I used it.

Seems strange that such a basic feature cannot easily be fixed. I have an
old Arm6 tablet which has ubuntu 9.02 on it and bluetooth works without any
issues on that!

Certainly anybody is wasting their money if they expect bluetooth speakers
to work with the Pi..

Just got to hope that somebody here picks this up and works on a fix.

I don't know what else to do - I've posted in just about every appropriate
thread - no response, except somebody telling me to fix it myself!


Reply to this email directly or view it on GitHubhttps://github.com//issues/200#issuecomment-12703942.

@castalla
Copy link
Author

Thanks! here's hoping. Where would a fix be - in the kernel or firmware?

@ghollingworth
Copy link

It will be in the kernel, that's where the USB driver is

Gordon

On Friday, 25 January 2013, castalla wrote:

Thanks! here's hoping. Where would a fix be - in the kernel or firmware?


Reply to this email directly or view it on GitHubhttps://github.com//issues/200#issuecomment-12705005.

@castalla
Copy link
Author

Okay - can you post here when it's released?

@edt-xx
Copy link

edt-xx commented Jan 26, 2013

I've also seen this sort of problem with bluetooth audio. Looking forward to that usb update too. In my case its with a monster clarity HD speaker. The other profiles I use with bt works fine (mouse, keyboard, pand).

@castalla
Copy link
Author

castalla commented Feb 1, 2013

Has any progress been made on this?

The latest kernel and firmware (dated 30 Jan) has not fixed the crashing network issue.

@castalla
Copy link
Author

castalla commented Feb 4, 2013

I'm uncertain whether the latest kernel, etc. has addressed these issues ....

In desperation, I switched to a different bt dongle (Broadcomm chip) - this works! No crashes.

Other issues, of course, but no crashes!

@ghollingworth
Copy link

You should try again now, there have been a whole tonne of changes in USB land... Reopen if still a problem

@ipavelek
Copy link

@castalla What BLE dongle did you use exactly?

popcornmix pushed a commit that referenced this issue Feb 12, 2018
[ Upstream commit e7aadb2 ]

Newly added igmpv3_get_srcaddr() needs to be called under rcu lock.

Timer callbacks do not ensure this locking.

=============================
WARNING: suspicious RCU usage
4.15.0+ #200 Not tainted
-----------------------------
./include/linux/inetdevice.h:216 suspicious rcu_dereference_check() usage!

other info that might help us debug this:

rcu_scheduler_active = 2, debug_locks = 1
3 locks held by syzkaller616973/4074:
 #0:  (&mm->mmap_sem){++++}, at: [<00000000bfce669e>] __do_page_fault+0x32d/0xc90 arch/x86/mm/fault.c:1355
 #1:  ((&im->timer)){+.-.}, at: [<00000000619d2f71>] lockdep_copy_map include/linux/lockdep.h:178 [inline]
 #1:  ((&im->timer)){+.-.}, at: [<00000000619d2f71>] call_timer_fn+0x1c6/0x820 kernel/time/timer.c:1316
 #2:  (&(&im->lock)->rlock){+.-.}, at: [<000000005f833c5c>] spin_lock_bh include/linux/spinlock.h:315 [inline]
 #2:  (&(&im->lock)->rlock){+.-.}, at: [<000000005f833c5c>] igmpv3_send_report+0x98/0x5b0 net/ipv4/igmp.c:600

stack backtrace:
CPU: 0 PID: 4074 Comm: syzkaller616973 Not tainted 4.15.0+ #200
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 <IRQ>
 __dump_stack lib/dump_stack.c:17 [inline]
 dump_stack+0x194/0x257 lib/dump_stack.c:53
 lockdep_rcu_suspicious+0x123/0x170 kernel/locking/lockdep.c:4592
 __in_dev_get_rcu include/linux/inetdevice.h:216 [inline]
 igmpv3_get_srcaddr net/ipv4/igmp.c:329 [inline]
 igmpv3_newpack+0xeef/0x12e0 net/ipv4/igmp.c:389
 add_grhead.isra.27+0x235/0x300 net/ipv4/igmp.c:432
 add_grec+0xbd3/0x1170 net/ipv4/igmp.c:565
 igmpv3_send_report+0xd5/0x5b0 net/ipv4/igmp.c:605
 igmp_send_report+0xc43/0x1050 net/ipv4/igmp.c:722
 igmp_timer_expire+0x322/0x5c0 net/ipv4/igmp.c:831
 call_timer_fn+0x228/0x820 kernel/time/timer.c:1326
 expire_timers kernel/time/timer.c:1363 [inline]
 __run_timers+0x7ee/0xb70 kernel/time/timer.c:1666
 run_timer_softirq+0x4c/0x70 kernel/time/timer.c:1692
 __do_softirq+0x2d7/0xb85 kernel/softirq.c:285
 invoke_softirq kernel/softirq.c:365 [inline]
 irq_exit+0x1cc/0x200 kernel/softirq.c:405
 exiting_irq arch/x86/include/asm/apic.h:541 [inline]
 smp_apic_timer_interrupt+0x16b/0x700 arch/x86/kernel/apic/apic.c:1052
 apic_timer_interrupt+0xa9/0xb0 arch/x86/entry/entry_64.S:938

Fixes: a46182b ("net: igmp: Use correct source address on IGMPv3 reports")
Signed-off-by: Eric Dumazet <[email protected]>
Reported-by: syzbot <[email protected]>

Signed-off-by: David S. Miller <[email protected]>
Signed-off-by: Greg Kroah-Hartman <[email protected]>
popcornmix pushed a commit that referenced this issue Feb 19, 2018
[ Upstream commit e7aadb2 ]

Newly added igmpv3_get_srcaddr() needs to be called under rcu lock.

Timer callbacks do not ensure this locking.

=============================
WARNING: suspicious RCU usage
4.15.0+ #200 Not tainted
-----------------------------
./include/linux/inetdevice.h:216 suspicious rcu_dereference_check() usage!

other info that might help us debug this:

rcu_scheduler_active = 2, debug_locks = 1
3 locks held by syzkaller616973/4074:
 #0:  (&mm->mmap_sem){++++}, at: [<00000000bfce669e>] __do_page_fault+0x32d/0xc90 arch/x86/mm/fault.c:1355
 #1:  ((&im->timer)){+.-.}, at: [<00000000619d2f71>] lockdep_copy_map include/linux/lockdep.h:178 [inline]
 #1:  ((&im->timer)){+.-.}, at: [<00000000619d2f71>] call_timer_fn+0x1c6/0x820 kernel/time/timer.c:1316
 #2:  (&(&im->lock)->rlock){+.-.}, at: [<000000005f833c5c>] spin_lock_bh include/linux/spinlock.h:315 [inline]
 #2:  (&(&im->lock)->rlock){+.-.}, at: [<000000005f833c5c>] igmpv3_send_report+0x98/0x5b0 net/ipv4/igmp.c:600

stack backtrace:
CPU: 0 PID: 4074 Comm: syzkaller616973 Not tainted 4.15.0+ #200
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 <IRQ>
 __dump_stack lib/dump_stack.c:17 [inline]
 dump_stack+0x194/0x257 lib/dump_stack.c:53
 lockdep_rcu_suspicious+0x123/0x170 kernel/locking/lockdep.c:4592
 __in_dev_get_rcu include/linux/inetdevice.h:216 [inline]
 igmpv3_get_srcaddr net/ipv4/igmp.c:329 [inline]
 igmpv3_newpack+0xeef/0x12e0 net/ipv4/igmp.c:389
 add_grhead.isra.27+0x235/0x300 net/ipv4/igmp.c:432
 add_grec+0xbd3/0x1170 net/ipv4/igmp.c:565
 igmpv3_send_report+0xd5/0x5b0 net/ipv4/igmp.c:605
 igmp_send_report+0xc43/0x1050 net/ipv4/igmp.c:722
 igmp_timer_expire+0x322/0x5c0 net/ipv4/igmp.c:831
 call_timer_fn+0x228/0x820 kernel/time/timer.c:1326
 expire_timers kernel/time/timer.c:1363 [inline]
 __run_timers+0x7ee/0xb70 kernel/time/timer.c:1666
 run_timer_softirq+0x4c/0x70 kernel/time/timer.c:1692
 __do_softirq+0x2d7/0xb85 kernel/softirq.c:285
 invoke_softirq kernel/softirq.c:365 [inline]
 irq_exit+0x1cc/0x200 kernel/softirq.c:405
 exiting_irq arch/x86/include/asm/apic.h:541 [inline]
 smp_apic_timer_interrupt+0x16b/0x700 arch/x86/kernel/apic/apic.c:1052
 apic_timer_interrupt+0xa9/0xb0 arch/x86/entry/entry_64.S:938

Fixes: a46182b ("net: igmp: Use correct source address on IGMPv3 reports")
Signed-off-by: Eric Dumazet <[email protected]>
Reported-by: syzbot <[email protected]>

Signed-off-by: David S. Miller <[email protected]>
Signed-off-by: Greg Kroah-Hartman <[email protected]>
anholt pushed a commit to anholt/linux that referenced this issue Feb 22, 2018
Newly added igmpv3_get_srcaddr() needs to be called under rcu lock.

Timer callbacks do not ensure this locking.

=============================
WARNING: suspicious RCU usage
4.15.0+ raspberrypi#200 Not tainted
-----------------------------
./include/linux/inetdevice.h:216 suspicious rcu_dereference_check() usage!

other info that might help us debug this:

rcu_scheduler_active = 2, debug_locks = 1
3 locks held by syzkaller616973/4074:
 #0:  (&mm->mmap_sem){++++}, at: [<00000000bfce669e>] __do_page_fault+0x32d/0xc90 arch/x86/mm/fault.c:1355
 #1:  ((&im->timer)){+.-.}, at: [<00000000619d2f71>] lockdep_copy_map include/linux/lockdep.h:178 [inline]
 #1:  ((&im->timer)){+.-.}, at: [<00000000619d2f71>] call_timer_fn+0x1c6/0x820 kernel/time/timer.c:1316
 #2:  (&(&im->lock)->rlock){+.-.}, at: [<000000005f833c5c>] spin_lock_bh include/linux/spinlock.h:315 [inline]
 #2:  (&(&im->lock)->rlock){+.-.}, at: [<000000005f833c5c>] igmpv3_send_report+0x98/0x5b0 net/ipv4/igmp.c:600

stack backtrace:
CPU: 0 PID: 4074 Comm: syzkaller616973 Not tainted 4.15.0+ raspberrypi#200
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 <IRQ>
 __dump_stack lib/dump_stack.c:17 [inline]
 dump_stack+0x194/0x257 lib/dump_stack.c:53
 lockdep_rcu_suspicious+0x123/0x170 kernel/locking/lockdep.c:4592
 __in_dev_get_rcu include/linux/inetdevice.h:216 [inline]
 igmpv3_get_srcaddr net/ipv4/igmp.c:329 [inline]
 igmpv3_newpack+0xeef/0x12e0 net/ipv4/igmp.c:389
 add_grhead.isra.27+0x235/0x300 net/ipv4/igmp.c:432
 add_grec+0xbd3/0x1170 net/ipv4/igmp.c:565
 igmpv3_send_report+0xd5/0x5b0 net/ipv4/igmp.c:605
 igmp_send_report+0xc43/0x1050 net/ipv4/igmp.c:722
 igmp_timer_expire+0x322/0x5c0 net/ipv4/igmp.c:831
 call_timer_fn+0x228/0x820 kernel/time/timer.c:1326
 expire_timers kernel/time/timer.c:1363 [inline]
 __run_timers+0x7ee/0xb70 kernel/time/timer.c:1666
 run_timer_softirq+0x4c/0x70 kernel/time/timer.c:1692
 __do_softirq+0x2d7/0xb85 kernel/softirq.c:285
 invoke_softirq kernel/softirq.c:365 [inline]
 irq_exit+0x1cc/0x200 kernel/softirq.c:405
 exiting_irq arch/x86/include/asm/apic.h:541 [inline]
 smp_apic_timer_interrupt+0x16b/0x700 arch/x86/kernel/apic/apic.c:1052
 apic_timer_interrupt+0xa9/0xb0 arch/x86/entry/entry_64.S:938

Fixes: a46182b ("net: igmp: Use correct source address on IGMPv3 reports")
Signed-off-by: Eric Dumazet <[email protected]>
Reported-by: syzbot <[email protected]>

Signed-off-by: David S. Miller <[email protected]>
ED6E0F17 pushed a commit to ED6E0F17/linux that referenced this issue Mar 15, 2018
[ Upstream commit e7aadb2 ]

Newly added igmpv3_get_srcaddr() needs to be called under rcu lock.

Timer callbacks do not ensure this locking.

=============================
WARNING: suspicious RCU usage
4.15.0+ raspberrypi#200 Not tainted
-----------------------------
./include/linux/inetdevice.h:216 suspicious rcu_dereference_check() usage!

other info that might help us debug this:

rcu_scheduler_active = 2, debug_locks = 1
3 locks held by syzkaller616973/4074:
 #0:  (&mm->mmap_sem){++++}, at: [<00000000bfce669e>] __do_page_fault+0x32d/0xc90 arch/x86/mm/fault.c:1355
 raspberrypi#1:  ((&im->timer)){+.-.}, at: [<00000000619d2f71>] lockdep_copy_map include/linux/lockdep.h:178 [inline]
 raspberrypi#1:  ((&im->timer)){+.-.}, at: [<00000000619d2f71>] call_timer_fn+0x1c6/0x820 kernel/time/timer.c:1316
 raspberrypi#2:  (&(&im->lock)->rlock){+.-.}, at: [<000000005f833c5c>] spin_lock_bh include/linux/spinlock.h:315 [inline]
 raspberrypi#2:  (&(&im->lock)->rlock){+.-.}, at: [<000000005f833c5c>] igmpv3_send_report+0x98/0x5b0 net/ipv4/igmp.c:600

stack backtrace:
CPU: 0 PID: 4074 Comm: syzkaller616973 Not tainted 4.15.0+ raspberrypi#200
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 <IRQ>
 __dump_stack lib/dump_stack.c:17 [inline]
 dump_stack+0x194/0x257 lib/dump_stack.c:53
 lockdep_rcu_suspicious+0x123/0x170 kernel/locking/lockdep.c:4592
 __in_dev_get_rcu include/linux/inetdevice.h:216 [inline]
 igmpv3_get_srcaddr net/ipv4/igmp.c:329 [inline]
 igmpv3_newpack+0xeef/0x12e0 net/ipv4/igmp.c:389
 add_grhead.isra.27+0x235/0x300 net/ipv4/igmp.c:432
 add_grec+0xbd3/0x1170 net/ipv4/igmp.c:565
 igmpv3_send_report+0xd5/0x5b0 net/ipv4/igmp.c:605
 igmp_send_report+0xc43/0x1050 net/ipv4/igmp.c:722
 igmp_timer_expire+0x322/0x5c0 net/ipv4/igmp.c:831
 call_timer_fn+0x228/0x820 kernel/time/timer.c:1326
 expire_timers kernel/time/timer.c:1363 [inline]
 __run_timers+0x7ee/0xb70 kernel/time/timer.c:1666
 run_timer_softirq+0x4c/0x70 kernel/time/timer.c:1692
 __do_softirq+0x2d7/0xb85 kernel/softirq.c:285
 invoke_softirq kernel/softirq.c:365 [inline]
 irq_exit+0x1cc/0x200 kernel/softirq.c:405
 exiting_irq arch/x86/include/asm/apic.h:541 [inline]
 smp_apic_timer_interrupt+0x16b/0x700 arch/x86/kernel/apic/apic.c:1052
 apic_timer_interrupt+0xa9/0xb0 arch/x86/entry/entry_64.S:938

Fixes: a46182b ("net: igmp: Use correct source address on IGMPv3 reports")
Signed-off-by: Eric Dumazet <[email protected]>
Reported-by: syzbot <[email protected]>

Signed-off-by: David S. Miller <[email protected]>
Signed-off-by: Greg Kroah-Hartman <[email protected]>
notcarbide pushed a commit to notcarbide/linux that referenced this issue Apr 9, 2021
…onward"

Although this patch helps in Debian, not all distributions using Zen
Kernrel have the same folder structure (/lib/firmware).  And as @Atemu
pointed out in raspberrypi#200, the patch is technically incredibly old for kernel
standards so it may only do harm than good.  Revert this patch.

This reverts commit 789af38.
popcornmix pushed a commit that referenced this issue Aug 14, 2023
BPF CI has reported the following failure:

Error: #200/79 sockmap_listen/sockmap VSOCK test_vsock_redir
  Error: #200/79 sockmap_listen/sockmap VSOCK test_vsock_redir
  ./test_progs:vsock_unix_redir_connectible:1506: egress: write: Transport endpoint is not connected
  vsock_unix_redir_connectible:FAIL:1506
  ./test_progs:vsock_unix_redir_connectible:1506: ingress: write: Transport endpoint is not connected
  vsock_unix_redir_connectible:FAIL:1506
  ./test_progs:vsock_unix_redir_connectible:1506: egress: write: Transport endpoint is not connected
  vsock_unix_redir_connectible:FAIL:1506
  ./test_progs:vsock_unix_redir_connectible:1514: ingress: recv() err, errno=11
  vsock_unix_redir_connectible:FAIL:1514
  ./test_progs:vsock_unix_redir_connectible:1518: ingress: vsock socket map failed, a != b
  vsock_unix_redir_connectible:FAIL:1518
  ./test_progs:vsock_unix_redir_connectible:1525: ingress: want pass count 1, have 0

It’s because the recv(... MSG_DONTWAIT) syscall in the test case is
called before the queued work sk_psock_backlog() in the kernel finishes
executing. So the data to be read is still queued in psock->ingress_skb
and cannot be read by the user program. Therefore, the non-blocking
recv() reads nothing and reports an EAGAIN error.

So replace recv(... MSG_DONTWAIT) with xrecv_nonblock(), which calls
select() to wait for data to be readable or timeout before calls recv().

Fixes: d61bd8c ("selftests/bpf: add a test case for vsock sockmap")
Signed-off-by: Xu Kuohai <[email protected]>
Link: https://lore.kernel.org/r/[email protected]
Signed-off-by: Martin KaFai Lau <[email protected]>
popcornmix pushed a commit that referenced this issue Aug 17, 2023
commit 90f0074 upstream.

BPF CI has reported the following failure:

Error: #200/79 sockmap_listen/sockmap VSOCK test_vsock_redir
  Error: #200/79 sockmap_listen/sockmap VSOCK test_vsock_redir
  ./test_progs:vsock_unix_redir_connectible:1506: egress: write: Transport endpoint is not connected
  vsock_unix_redir_connectible:FAIL:1506
  ./test_progs:vsock_unix_redir_connectible:1506: ingress: write: Transport endpoint is not connected
  vsock_unix_redir_connectible:FAIL:1506
  ./test_progs:vsock_unix_redir_connectible:1506: egress: write: Transport endpoint is not connected
  vsock_unix_redir_connectible:FAIL:1506
  ./test_progs:vsock_unix_redir_connectible:1514: ingress: recv() err, errno=11
  vsock_unix_redir_connectible:FAIL:1514
  ./test_progs:vsock_unix_redir_connectible:1518: ingress: vsock socket map failed, a != b
  vsock_unix_redir_connectible:FAIL:1518
  ./test_progs:vsock_unix_redir_connectible:1525: ingress: want pass count 1, have 0

It’s because the recv(... MSG_DONTWAIT) syscall in the test case is
called before the queued work sk_psock_backlog() in the kernel finishes
executing. So the data to be read is still queued in psock->ingress_skb
and cannot be read by the user program. Therefore, the non-blocking
recv() reads nothing and reports an EAGAIN error.

So replace recv(... MSG_DONTWAIT) with xrecv_nonblock(), which calls
select() to wait for data to be readable or timeout before calls recv().

Fixes: d61bd8c ("selftests/bpf: add a test case for vsock sockmap")
Signed-off-by: Xu Kuohai <[email protected]>
Link: https://lore.kernel.org/r/[email protected]
Signed-off-by: Martin KaFai Lau <[email protected]>
Signed-off-by: Greg Kroah-Hartman <[email protected]>
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

5 participants