This thread has been locked.

If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.

Linux/WL1831MOD: BLE Function in WL1831MOD inits failed randomly on system boot (hciconfig and hcitool are all failed)

Part Number: WL1831MOD

Tool/software: Linux

Hi all,

We enconter a problem about the WL1831MOD our team used that BLE function inits failed randomly on system boot. When it fails, hciconfig and hcitool do not used normally.

The MOD run on Platform AM3558 with Ubuntu 14.04 Kernel 3.14.43 (based on SDK-1.00.00.03).

There are 27 fail in 100 times tests (auto reboot 100 times).  

I guess the issue caused by uim, ldsic (tty core, tty driver), but it happens randomly, I want to found out the root cause which is HW/SW/FW issue and try to solve it.

Please guide me how can I solve this problem.

Regards,
Jerry

Boot log from dmesg with BLE inits failed as followed:


[Fri Mar 17 14:19:14 2017] Booting Linux on physical CPU 0x0
[Fri Mar 17 14:19:14 2017] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c5387d
[Fri Mar 17 14:19:14 2017] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[Fri Mar 17 14:19:14 2017] Machine model: TI AM335x BeagleBone
[Fri Mar 17 14:19:14 2017] cma: CMA: reserved 24 MiB at 9e000000
[Fri Mar 17 14:19:14 2017] Memory policy: Data cache writeback
[Fri Mar 17 14:19:14 2017] On node 0 totalpages: 130816
[Fri Mar 17 14:19:14 2017] free_area_init_node: node 0, pgdat c0874298, node_mem_map dfaee000
[Fri Mar 17 14:19:14 2017]   Normal zone: 1024 pages used for memmap
[Fri Mar 17 14:19:14 2017]   Normal zone: 0 pages reserved
[Fri Mar 17 14:19:14 2017]   Normal zone: 130816 pages, LIFO batch:31
[Fri Mar 17 14:19:14 2017] CPU: All CPU(s) started in SVC mode.
[Fri Mar 17 14:19:14 2017] AM335X ES2.1 (sgx neon )
[Fri Mar 17 14:19:14 2017] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[Fri Mar 17 14:19:14 2017] pcpu-alloc: [0] 0 
[Fri Mar 17 14:19:14 2017] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 129792
[Fri Mar 17 14:19:14 2017] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 ro rootfstype=ext3 rootwait
[Fri Mar 17 14:19:14 2017] PID hash table entries: 2048 (order: 1, 8192 bytes)
[Fri Mar 17 14:19:14 2017] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[Fri Mar 17 14:19:14 2017] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[Fri Mar 17 14:19:14 2017] Memory: 485120K/523264K available (5895K kernel code, 303K rwdata, 2164K rodata, 261K init, 232K bss, 38144K reserved, 0K highmem)
[Fri Mar 17 14:19:14 2017] Virtual kernel memory layout:
[Fri Mar 17 14:19:14 2017]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[Fri Mar 17 14:19:14 2017]     fixmap  : 0xfff00000 - 0xfffe0000   ( 896 kB)
[Fri Mar 17 14:19:14 2017]     vmalloc : 0xe0800000 - 0xff000000   ( 488 MB)
[Fri Mar 17 14:19:14 2017]     lowmem  : 0xc0000000 - 0xe0000000   ( 512 MB)
[Fri Mar 17 14:19:14 2017]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
[Fri Mar 17 14:19:14 2017]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
[Fri Mar 17 14:19:14 2017]       .text : 0xc0008000 - 0xc07e70c4   (8061 kB)
[Fri Mar 17 14:19:14 2017]       .init : 0xc07e8000 - 0xc08296fc   ( 262 kB)
[Fri Mar 17 14:19:14 2017]       .data : 0xc082a000 - 0xc0875ce0   ( 304 kB)
[Fri Mar 17 14:19:14 2017]        .bss : 0xc0875ce0 - 0xc08afda0   ( 233 kB)
[Fri Mar 17 14:19:14 2017] NR_IRQS:16 nr_irqs:16 16
[Fri Mar 17 14:19:14 2017] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
[Fri Mar 17 14:19:14 2017] Total of 128 interrupts on 1 active controller
[Fri Mar 17 14:19:14 2017] OMAP clockevent source: timer2 at 24000000 Hz
[Fri Mar 17 14:19:14 2017] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956969942ns
[Fri Mar 17 14:19:14 2017] OMAP clocksource: timer1 at 24000000 Hz
[Fri Mar 17 14:19:14 2017] Console: colour dummy device 80x30
[Fri Mar 17 14:19:14 2017] WARNING: Your 'console=ttyO0' has been replaced by 'ttyS0'
[Fri Mar 17 14:19:14 2017] This ensures that you still see kernel messages. Please
[Fri Mar 17 14:19:14 2017] update your kernel commandline.
[Fri Mar 17 14:19:14 2017] Calibrating delay loop... 996.14 BogoMIPS (lpj=4980736)
[Fri Mar 17 14:19:14 2017] pid_max: default: 32768 minimum: 301
[Fri Mar 17 14:19:14 2017] Security Framework initialized
[Fri Mar 17 14:19:14 2017] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[Fri Mar 17 14:19:14 2017] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[Fri Mar 17 14:19:14 2017] CPU: Testing write buffer coherency: ok
[Fri Mar 17 14:19:14 2017] Setting up static identity map for 0x805c7420 - 0x805c7478
[Fri Mar 17 14:19:14 2017] devtmpfs: initialized
[Fri Mar 17 14:19:14 2017] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
[Fri Mar 17 14:19:14 2017] omap_hwmod: tptc0 using broken dt data from edma
[Fri Mar 17 14:19:14 2017] omap_hwmod: tptc1 using broken dt data from edma
[Fri Mar 17 14:19:14 2017] omap_hwmod: tptc2 using broken dt data from edma
[Fri Mar 17 14:19:14 2017] omap_hwmod: debugss: _wait_target_disable failed
[Fri Mar 17 14:19:14 2017] pinctrl core: initialized pinctrl subsystem
[Fri Mar 17 14:19:14 2017] regulator-dummy: no parameters
[Fri Mar 17 14:19:14 2017] NET: Registered protocol family 16
[Fri Mar 17 14:19:14 2017] DMA: preallocated 256 KiB pool for atomic coherent allocations
[Fri Mar 17 14:19:14 2017] cpuidle: using governor ladder
[Fri Mar 17 14:19:14 2017] cpuidle: using governor menu
[Fri Mar 17 14:19:14 2017] syscon 44e10000.control_module: regmap [mem 0x44e10000-0x44e107fb] registered
[Fri Mar 17 14:19:14 2017] platform 49000000.edma: alias fck already exists
[Fri Mar 17 14:19:14 2017] platform 49000000.edma: alias fck already exists
[Fri Mar 17 14:19:14 2017] platform 49000000.edma: alias fck already exists
[Fri Mar 17 14:19:14 2017] gpiochip_add: registered GPIOs 0 to 31 on device: gpio
[Fri Mar 17 14:19:14 2017] OMAP GPIO hardware version 0.1
[Fri Mar 17 14:19:14 2017] gpiochip_add: registered GPIOs 32 to 63 on device: gpio
[Fri Mar 17 14:19:14 2017] gpiochip_add: registered GPIOs 64 to 95 on device: gpio
[Fri Mar 17 14:19:14 2017] gpiochip_add: registered GPIOs 96 to 127 on device: gpio
[Fri Mar 17 14:19:14 2017] No ATAGs?
[Fri Mar 17 14:19:14 2017] hw-breakpoint: debug architecture 0x4 unsupported.
[Fri Mar 17 14:19:14 2017] bio: create slab <bio-0> at 0
[Fri Mar 17 14:19:14 2017] edma-dma-engine edma-dma-engine.0: TI EDMA DMA engine driver
[Fri Mar 17 14:19:14 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/fixedregulator@0[0]'
[Fri Mar 17 14:19:14 2017] vmmcsd_fixed: 3300 mV 
[Fri Mar 17 14:19:14 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:19:14 2017] wlan-en-regulator: 1800 mV 
[Fri Mar 17 14:19:14 2017] vgaarb: loaded
[Fri Mar 17 14:19:14 2017] i2c-core: driver [palmas] using legacy suspend method
[Fri Mar 17 14:19:14 2017] i2c-core: driver [palmas] using legacy resume method
[Fri Mar 17 14:19:14 2017] SCSI subsystem initialized
[Fri Mar 17 14:19:14 2017] libata version 3.00 loaded.
[Fri Mar 17 14:19:14 2017] usbcore: registered new interface driver usbfs
[Fri Mar 17 14:19:14 2017] usbcore: registered new interface driver hub
[Fri Mar 17 14:19:14 2017] usbcore: registered new device driver usb
[Fri Mar 17 14:19:14 2017] omap_i2c 44e0b000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c0_pins, deferring probe
[Fri Mar 17 14:19:14 2017] platform 44e0b000.i2c: Driver omap_i2c requests probe deferral
[Fri Mar 17 14:19:14 2017] omap_i2c 4802a000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c1_pins, deferring probe
[Fri Mar 17 14:19:14 2017] platform 4802a000.i2c: Driver omap_i2c requests probe deferral
[Fri Mar 17 14:19:14 2017] pps_core: LinuxPPS API ver. 1 registered
[Fri Mar 17 14:19:14 2017] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[Fri Mar 17 14:19:14 2017] PTP clock support registered
[Fri Mar 17 14:19:14 2017] omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
[Fri Mar 17 14:19:14 2017] Advanced Linux Sound Architecture Driver Initialized.
[Fri Mar 17 14:19:14 2017] Switched to clocksource timer1
[Fri Mar 17 14:19:14 2017] NET: Registered protocol family 2
[Fri Mar 17 14:19:14 2017] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[Fri Mar 17 14:19:14 2017] TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
[Fri Mar 17 14:19:14 2017] TCP: Hash tables configured (established 4096 bind 4096)
[Fri Mar 17 14:19:14 2017] TCP: reno registered
[Fri Mar 17 14:19:14 2017] UDP hash table entries: 256 (order: 0, 4096 bytes)
[Fri Mar 17 14:19:14 2017] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[Fri Mar 17 14:19:14 2017] NET: Registered protocol family 1
[Fri Mar 17 14:19:14 2017] RPC: Registered named UNIX socket transport module.
[Fri Mar 17 14:19:14 2017] RPC: Registered udp transport module.
[Fri Mar 17 14:19:14 2017] RPC: Registered tcp transport module.
[Fri Mar 17 14:19:14 2017] RPC: Registered tcp NFSv4.1 backchannel transport module.
[Fri Mar 17 14:19:14 2017] PCI: CLS 0 bytes, default 64
[Fri Mar 17 14:19:14 2017] hw perfevents: enabled with ARMv7 Cortex-A8 PMU driver, 5 counters available
[Fri Mar 17 14:19:14 2017] futex hash table entries: 256 (order: -1, 3072 bytes)
[Fri Mar 17 14:19:14 2017] VFS: Disk quotas dquot_6.5.2
[Fri Mar 17 14:19:14 2017] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[Fri Mar 17 14:19:14 2017] NFS: Registering the id_resolver key type
[Fri Mar 17 14:19:14 2017] Key type id_resolver registered
[Fri Mar 17 14:19:14 2017] Key type id_legacy registered
[Fri Mar 17 14:19:14 2017] jffs2: version 2.2. (NAND) (SUMMARY)  \xffffffc2\xffffffa9\xffffffa9 2001-2006 Red Hat, Inc.
[Fri Mar 17 14:19:14 2017] msgmni has been set to 995
[Fri Mar 17 14:19:14 2017] NET: Registered protocol family 38
[Fri Mar 17 14:19:14 2017] io scheduler noop registered
[Fri Mar 17 14:19:14 2017] io scheduler deadline registered
[Fri Mar 17 14:19:14 2017] io scheduler cfq registered (default)
[Fri Mar 17 14:19:14 2017] pinctrl-single 44e10800.pinmux: 142 pins at pa f9e10800 size 568
[Fri Mar 17 14:19:14 2017] Serial: 8250/16550 driver, 6 ports, IRQ sharing enabled
[Fri Mar 17 14:19:14 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@44e09000[0]'
[Fri Mar 17 14:19:14 2017] 44e09000.serial: ttyS0 at MMIO 0x44e09000 (irq = 88, base_baud = 3000000) is a 8250
[Fri Mar 17 14:19:15 2017] console [ttyS0] enabled
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@48022000[0]'
[Fri Mar 17 14:19:15 2017] 48022000.serial: ttyS1 at MMIO 0x48022000 (irq = 89, base_baud = 3000000) is a 8250
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@48024000[0]'
[Fri Mar 17 14:19:15 2017] 48024000.serial: ttyS2 at MMIO 0x48024000 (irq = 90, base_baud = 3000000) is a 8250
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@481a6000[0]'
[Fri Mar 17 14:19:15 2017] 481a6000.serial: ttyS3 at MMIO 0x481a6000 (irq = 60, base_baud = 3000000) is a 8250
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@481a8000[0]'
[Fri Mar 17 14:19:15 2017] 481a8000.serial: ttyS4 at MMIO 0x481a8000 (irq = 61, base_baud = 3000000) is a 8250
[Fri Mar 17 14:19:15 2017] omap_rng 48310000.rng: OMAP Random Number Generator ver. 20
[Fri Mar 17 14:19:15 2017] [drm] Initialized drm 1.1.0 20060810
[Fri Mar 17 14:19:15 2017] brd: module loaded
[Fri Mar 17 14:19:15 2017] loop: module loaded
[Fri Mar 17 14:19:15 2017] (stk) :sysfs entries created
[Fri Mar 17 14:19:15 2017] (stk) : debugfs entries created 
[Fri Mar 17 14:19:15 2017] (hci_tty): inside hci_tty_init
[Fri Mar 17 14:19:15 2017] (hci_tty): allocated 248, 0
[Fri Mar 17 14:19:15 2017] mtdoops: mtd device (mtddev=name/number) must be supplied
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver asix
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver ax88179_178a
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver cdc_ether
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver smsc95xx
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver net1080
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver cdc_subset
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver zaurus
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver cdc_ncm
[Fri Mar 17 14:19:15 2017] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[Fri Mar 17 14:19:15 2017] ehci-pci: EHCI PCI platform driver
[Fri Mar 17 14:19:15 2017] ehci-omap: OMAP-EHCI Host Controller driver
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver cdc_wdm
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver usb-storage
[Fri Mar 17 14:19:15 2017] mousedev: PS/2 mouse device common for all mice
[Fri Mar 17 14:19:15 2017] omap_rtc 44e3e000.rtc: rtc core: registered 44e3e000.rtc as rtc0
[Fri Mar 17 14:19:15 2017] i2c /dev entries driver
[Fri Mar 17 14:19:15 2017] Driver for 1-wire Dallas network protocol.
[Fri Mar 17 14:19:15 2017] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@48060000[0]'
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@481d8000[0]'
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@481d8000[0]'
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@47810000[0]'
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@47810000[0]'
[Fri Mar 17 14:19:15 2017] mmc1: BKOPS_EN bit is not set
[Fri Mar 17 14:19:15 2017] mmc1: new high speed MMC card at address 0001
[Fri Mar 17 14:19:15 2017] mmcblk0: mmc1:0001 M52516 14.5 GiB 
[Fri Mar 17 14:19:15 2017] mmcblk0boot0: mmc1:0001 M52516 partition 1 4.00 MiB
[Fri Mar 17 14:19:15 2017] mmcblk0boot1: mmc1:0001 M52516 partition 2 4.00 MiB
[Fri Mar 17 14:19:15 2017]  mmcblk0: p1 p2 p3 p4
[Fri Mar 17 14:19:15 2017]  mmcblk0boot1: unknown partition table
[Fri Mar 17 14:19:15 2017]  mmcblk0boot0: unknown partition table
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:19:15 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:19:15 2017] omap_hsmmc 47810000.mmc: card claims to support voltages below defined range
[Fri Mar 17 14:19:15 2017] ledtrig-cpu: registered to indicate activity on CPUs
[Fri Mar 17 14:19:15 2017] omap-aes 53500000.aes: OMAP AES hw accel rev: 3.2
[Fri Mar 17 14:19:15 2017] omap-sham 53100000.sham: hw accel on OMAP rev 4.3
[Fri Mar 17 14:19:15 2017] usbcore: registered new interface driver usbhid
[Fri Mar 17 14:19:15 2017] usbhid: USB HID core driver
[Fri Mar 17 14:19:15 2017] platform 44d00000.wkup_m3: Driver wkup_m3 requests probe deferral
[Fri Mar 17 14:19:15 2017] oprofile: using arm/armv7
[Fri Mar 17 14:19:15 2017] TCP: cubic registered
[Fri Mar 17 14:19:15 2017] Initializing XFRM netlink socket
[Fri Mar 17 14:19:15 2017] NET: Registered protocol family 17
[Fri Mar 17 14:19:15 2017] NET: Registered protocol family 15
[Fri Mar 17 14:19:15 2017] Key type dns_resolver registered
[Fri Mar 17 14:19:15 2017] cpu cpu0: of_pm_voltdm_notifier_register: Failed to get cpu0 regulator/voltdm: -517
[Fri Mar 17 14:19:15 2017] cpu cpu0: cpu0 clock notifier not ready, retry
[Fri Mar 17 14:19:15 2017] platform cpufreq-cpu0.0: Driver cpufreq-cpu0 requests probe deferral
[Fri Mar 17 14:19:15 2017] PM: bootloader does not support rtc-only!
[Fri Mar 17 14:19:15 2017] ThumbEE CPU extension supported.
[Fri Mar 17 14:19:15 2017] Registering SWP/SWPB emulation handler
[Fri Mar 17 14:19:15 2017] regulator-dummy: disabling
[Fri Mar 17 14:19:15 2017] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
[Fri Mar 17 14:19:15 2017] Error: Driver 'tfp410' is already registered, aborting...
[Fri Mar 17 14:19:15 2017] mmc2: new high speed SDIO card at address 0001
[Fri Mar 17 14:19:15 2017] DCDC1: at 1350 mV 
[Fri Mar 17 14:19:15 2017] vdd_mpu: 925 <--> 1375 mV at 1325 mV 
[Fri Mar 17 14:19:15 2017] vdd_core: 925 <--> 1150 mV at 1125 mV 
[Fri Mar 17 14:19:15 2017] LDO1: at 1800 mV 
[Fri Mar 17 14:19:15 2017] LDO2: at 3300 mV 
[Fri Mar 17 14:19:15 2017] LDO3: 1800 mV 
[Fri Mar 17 14:19:15 2017] LDO4: at 3300 mV 
[Fri Mar 17 14:19:15 2017] tps65217 0-0024: TPS65217 ID 0x6 version 1.2
[Fri Mar 17 14:19:15 2017] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
[Fri Mar 17 14:19:15 2017] rtc-mcp7940 1-006f: rtc core: registered mcp7940 as rtc1
[Fri Mar 17 14:19:15 2017] omap_i2c 4802a000.i2c: bus 1 rev0.11 at 400 kHz
[Fri Mar 17 14:19:15 2017]  remoteproc0: wkup_m3 is available
[Fri Mar 17 14:19:15 2017]  remoteproc0: Note: remoteproc is still under development and considered experimental.
[Fri Mar 17 14:19:15 2017]  remoteproc0: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
[Fri Mar 17 14:19:15 2017]  remoteproc0: Direct firmware load failed with error -2
[Fri Mar 17 14:19:15 2017]  remoteproc0: Falling back to user helper
[Fri Mar 17 14:19:15 2017] cpu cpu0: of_pm_voltdm_notifier_register: Fail calculating voltage latency[950000<->1325000]:-22
[Fri Mar 17 14:19:15 2017] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
[Fri Mar 17 14:19:15 2017] davinci_mdio 4a101000.mdio: detected phy mask fffffffe
[Fri Mar 17 14:19:15 2017] libphy: 4a101000.mdio: probed
[Fri Mar 17 14:19:15 2017] davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver SMSC LAN8710/LAN8720
[Fri Mar 17 14:19:15 2017] cpsw 4a100000.ethernet: Detected MACID = 68:9e:19:87:12:b7
[Fri Mar 17 14:19:15 2017] rtc-mcp7940 1-006f: setting system clock to 2017-03-17 06:19:16 UTC (1489731556)
[Fri Mar 17 14:19:15 2017] ALSA device list:
[Fri Mar 17 14:19:15 2017]   No soundcards found.
[Fri Mar 17 14:19:15 2017] EXT3-fs (mmcblk0p2): recovery required on readonly filesystem
[Fri Mar 17 14:19:15 2017] EXT3-fs (mmcblk0p2): write access will be enabled during recovery
[Fri Mar 17 14:19:15 2017] kjournald starting.  Commit interval 5 seconds
[Fri Mar 17 14:19:15 2017] EXT3-fs (mmcblk0p2): recovery complete
[Fri Mar 17 14:19:15 2017] EXT3-fs (mmcblk0p2): mounted filesystem with ordered data mode
[Fri Mar 17 14:19:15 2017] VFS: Mounted root (ext3 filesystem) readonly on device 179:2.
[Fri Mar 17 14:19:15 2017] devtmpfs: mounted
[Fri Mar 17 14:19:15 2017] Freeing unused kernel memory: 260K (c07e8000 - c0829000)
[Fri Mar 17 14:19:16 2017] random: init urandom read with 55 bits of entropy available
[Fri Mar 17 14:19:16 2017] init: plymouth-upstart-bridge main process (844) terminated with status 1
[Fri Mar 17 14:19:16 2017] init: plymouth-upstart-bridge main process ended, respawning
[Fri Mar 17 14:19:16 2017] init: plymouth-upstart-bridge main process (854) terminated with status 1
[Fri Mar 17 14:19:16 2017] init: plymouth-upstart-bridge main process ended, respawning
[Fri Mar 17 14:19:16 2017] init: ureadahead main process (847) terminated with status 5
[Fri Mar 17 14:19:16 2017] init: plymouth-upstart-bridge main process (859) terminated with status 1
[Fri Mar 17 14:19:16 2017] init: plymouth-upstart-bridge main process ended, respawning
[Fri Mar 17 14:19:18 2017] systemd-udevd[955]: starting version 204
[Fri Mar 17 14:19:18 2017] random: nonblocking pool is initialized
[Fri Mar 17 14:19:18 2017]  remoteproc0: powering up wkup_m3
[Fri Mar 17 14:19:18 2017]  remoteproc0: Booting fw image am335x-pm-firmware.elf, size 154412
[Fri Mar 17 14:19:18 2017] PM: CM3 Firmware Version = 0x190
[Fri Mar 17 14:19:18 2017]  remoteproc0: remote processor wkup_m3 is now up
[Fri Mar 17 14:19:18 2017] Bluetooth: Core ver 2.18
[Fri Mar 17 14:19:19 2017] NET: Registered protocol family 31
[Fri Mar 17 14:19:19 2017] Bluetooth: HCI device and connection manager initialized
[Fri Mar 17 14:19:19 2017] Bluetooth: HCI socket layer initialized
[Fri Mar 17 14:19:19 2017] Bluetooth: L2CAP socket layer initialized
[Fri Mar 17 14:19:19 2017] Bluetooth: SCO socket layer initialized
[Fri Mar 17 14:19:19 2017] at24 0-0050: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
[Fri Mar 17 14:19:19 2017] (stc):  chnl_id list empty :4 
[Fri Mar 17 14:19:19 2017] (stk) : st_kim_start(stk) :ldisc_install = 1
[Fri Mar 17 14:19:19 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/usb@47400000/usb-phy@47401300[0]'
[Fri Mar 17 14:19:19 2017] 47401300.usb-phy supply vcc not found, using dummy regulator
[Fri Mar 17 14:19:19 2017] Loading modules backported from Linux version R8.6_SP1-0-g4d167bf
[Fri Mar 17 14:19:19 2017] Backport generated by backports.git R8.6_SP1-0-g4677dc3
[Fri Mar 17 14:19:19 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/usb@47400000/usb-phy@47401b00[0]'
[Fri Mar 17 14:19:19 2017] 47401b00.usb-phy supply vcc not found, using dummy regulator
[Fri Mar 17 14:19:19 2017] cfg80211: Calling CRDA to update world regulatory domain
[Fri Mar 17 14:19:19 2017] cfg80211: World regulatory domain updated:
[Fri Mar 17 14:19:19 2017] cfg80211:  DFS Master region: unset
[Fri Mar 17 14:19:19 2017] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[Fri Mar 17 14:19:19 2017] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[Fri Mar 17 14:19:19 2017] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[Fri Mar 17 14:19:19 2017] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
[Fri Mar 17 14:19:19 2017] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[Fri Mar 17 14:19:19 2017] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
[Fri Mar 17 14:19:19 2017] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
[Fri Mar 17 14:19:19 2017] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
[Fri Mar 17 14:19:19 2017] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
[Fri Mar 17 14:19:20 2017] wlcore: wl18xx HW: 183x or 180x, PG 2.2 (ROM 0x11)
[Fri Mar 17 14:19:20 2017] (stk) :ldisc installation timeout
[Fri Mar 17 14:19:20 2017] (stk) :ldisc_install = 0<7>[    6.189859] musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, bulk combine, bulk split, HB-ISO Rx, HB-ISO Tx, SoftConn)
[Fri Mar 17 14:19:20 2017] musb-hdrc: MHDRC RTL version 2.0 
[Fri Mar 17 14:19:20 2017] musb-hdrc: setup fifo_mode 4
[Fri Mar 17 14:19:20 2017] musb-hdrc: 28/31 max ep, 16384/16384 memory
[Fri Mar 17 14:19:20 2017] wlcore: loaded
[Fri Mar 17 14:19:20 2017] wlcore: driver version: R8.6_SP1
[Fri Mar 17 14:19:20 2017] musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, bulk combine, bulk split, HB-ISO Rx, HB-ISO Tx, SoftConn)
[Fri Mar 17 14:19:20 2017] musb-hdrc: MHDRC RTL version 2.0 
[Fri Mar 17 14:19:20 2017] musb-hdrc: setup fifo_mode 4
[Fri Mar 17 14:19:20 2017] musb-hdrc: 28/31 max ep, 16384/16384 memory
[Fri Mar 17 14:19:20 2017] musb-hdrc musb-hdrc.2.auto: MUSB HDRC host driver
[Fri Mar 17 14:19:20 2017] musb-hdrc musb-hdrc.2.auto: new USB bus registered, assigned bus number 1
[Fri Mar 17 14:19:20 2017] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[Fri Mar 17 14:19:20 2017] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[Fri Mar 17 14:19:20 2017] usb usb1: Product: MUSB HDRC host driver
[Fri Mar 17 14:19:20 2017] usb usb1: Manufacturer: Linux 3.14.43 musb-hcd
[Fri Mar 17 14:19:20 2017] usb usb1: SerialNumber: musb-hdrc.2.auto
[Fri Mar 17 14:19:20 2017] hub 1-0:1.0: USB hub found
[Fri Mar 17 14:19:20 2017] hub 1-0:1.0: 1 port detected
[Fri Mar 17 14:19:20 2017] EXT3-fs (mmcblk0p2): using internal journal
[Fri Mar 17 14:19:21 2017] (stk) : timed out waiting for ldisc to be un-installed
[Fri Mar 17 14:19:21 2017] (stk) :ldisc_install = 1<6>[    7.798713] net eth0: initializing cpsw version 1.12 (0)
[Fri Mar 17 14:19:21 2017] net eth0: phy found : id is : 0x7c0f1
[Fri Mar 17 14:19:22 2017] (stk) :ldisc installation timeout
[Fri Mar 17 14:19:22 2017] (stk) :ldisc_install = 0(stk) : timed out waiting for ldisc to be un-installed
[Fri Mar 17 14:19:23 2017] (stk) :ldisc_install = 1(stk) :ldisc installation timeout
[Fri Mar 17 14:19:24 2017] (stk) :ldisc_install = 0(stk) : timed out waiting for ldisc to be un-installed
[Fri Mar 17 14:19:25 2017] (stk) :ldisc_install = 1init: avahi-cups-reload main process (1677) terminated with status 1
[Fri Mar 17 14:19:26 2017] init: Failed to obtain startpar-bridge instance: Unknown parameter: INSTANCE
[Fri Mar 17 14:19:26 2017] (stk) :ldisc installation timeout
[Fri Mar 17 14:19:26 2017] (stk) :ldisc_install = 0(stk) : timed out waiting for ldisc to be un-installed
[Fri Mar 17 14:19:27 2017] (stk) :ldisc_install = 1init: isc-dhcp-server pre-start process (1762) terminated with status 127
[Fri Mar 17 14:19:28 2017] (stk) :ldisc installation timeout
[Fri Mar 17 14:19:28 2017] (stk) :ldisc_install = 0(stk) : timed out waiting for ldisc to be un-installed
[Fri Mar 17 14:19:29 2017] (stk) :ldisc_install = 1(stk) :ldisc installation timeout
[Fri Mar 17 14:19:30 2017] (stk) :ldisc_install = 0init: plymouth-upstart-bridge main process ended, respawning
[Fri Mar 17 14:19:31 2017] (stk) : timed out waiting for ldisc to be un-installed
[Fri Mar 17 14:19:31 2017] Bluetooth: st_register failed -22


And Boot log from dmesg with BLE inits successfully as followed:


[Fri Mar 17 14:15:23 2017] Booting Linux on physical CPU 0x0
[Fri Mar 17 14:15:23 2017] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c5387d
[Fri Mar 17 14:15:23 2017] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[Fri Mar 17 14:15:23 2017] Machine model: TI AM335x BeagleBone
[Fri Mar 17 14:15:23 2017] cma: CMA: reserved 24 MiB at 9e000000
[Fri Mar 17 14:15:23 2017] Memory policy: Data cache writeback
[Fri Mar 17 14:15:23 2017] On node 0 totalpages: 130816
[Fri Mar 17 14:15:23 2017] free_area_init_node: node 0, pgdat c0874298, node_mem_map dfaee000
[Fri Mar 17 14:15:23 2017]   Normal zone: 1024 pages used for memmap
[Fri Mar 17 14:15:23 2017]   Normal zone: 0 pages reserved
[Fri Mar 17 14:15:23 2017]   Normal zone: 130816 pages, LIFO batch:31
[Fri Mar 17 14:15:23 2017] CPU: All CPU(s) started in SVC mode.
[Fri Mar 17 14:15:23 2017] AM335X ES2.1 (sgx neon )
[Fri Mar 17 14:15:23 2017] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[Fri Mar 17 14:15:23 2017] pcpu-alloc: [0] 0 
[Fri Mar 17 14:15:23 2017] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 129792
[Fri Mar 17 14:15:23 2017] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 ro rootfstype=ext3 rootwait
[Fri Mar 17 14:15:23 2017] PID hash table entries: 2048 (order: 1, 8192 bytes)
[Fri Mar 17 14:15:23 2017] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[Fri Mar 17 14:15:23 2017] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[Fri Mar 17 14:15:23 2017] Memory: 485120K/523264K available (5895K kernel code, 303K rwdata, 2164K rodata, 261K init, 232K bss, 38144K reserved, 0K highmem)
[Fri Mar 17 14:15:23 2017] Virtual kernel memory layout:
[Fri Mar 17 14:15:23 2017]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[Fri Mar 17 14:15:23 2017]     fixmap  : 0xfff00000 - 0xfffe0000   ( 896 kB)
[Fri Mar 17 14:15:23 2017]     vmalloc : 0xe0800000 - 0xff000000   ( 488 MB)
[Fri Mar 17 14:15:23 2017]     lowmem  : 0xc0000000 - 0xe0000000   ( 512 MB)
[Fri Mar 17 14:15:23 2017]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
[Fri Mar 17 14:15:23 2017]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
[Fri Mar 17 14:15:23 2017]       .text : 0xc0008000 - 0xc07e70c4   (8061 kB)
[Fri Mar 17 14:15:23 2017]       .init : 0xc07e8000 - 0xc08296fc   ( 262 kB)
[Fri Mar 17 14:15:23 2017]       .data : 0xc082a000 - 0xc0875ce0   ( 304 kB)
[Fri Mar 17 14:15:23 2017]        .bss : 0xc0875ce0 - 0xc08afda0   ( 233 kB)
[Fri Mar 17 14:15:23 2017] NR_IRQS:16 nr_irqs:16 16
[Fri Mar 17 14:15:23 2017] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
[Fri Mar 17 14:15:23 2017] Total of 128 interrupts on 1 active controller
[Fri Mar 17 14:15:23 2017] OMAP clockevent source: timer2 at 24000000 Hz
[Fri Mar 17 14:15:23 2017] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956969942ns
[Fri Mar 17 14:15:23 2017] OMAP clocksource: timer1 at 24000000 Hz
[Fri Mar 17 14:15:23 2017] Console: colour dummy device 80x30
[Fri Mar 17 14:15:23 2017] WARNING: Your 'console=ttyO0' has been replaced by 'ttyS0'
[Fri Mar 17 14:15:23 2017] This ensures that you still see kernel messages. Please
[Fri Mar 17 14:15:23 2017] update your kernel commandline.
[Fri Mar 17 14:15:23 2017] Calibrating delay loop... 996.14 BogoMIPS (lpj=4980736)
[Fri Mar 17 14:15:23 2017] pid_max: default: 32768 minimum: 301
[Fri Mar 17 14:15:23 2017] Security Framework initialized
[Fri Mar 17 14:15:23 2017] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[Fri Mar 17 14:15:23 2017] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[Fri Mar 17 14:15:23 2017] CPU: Testing write buffer coherency: ok
[Fri Mar 17 14:15:23 2017] Setting up static identity map for 0x805c7420 - 0x805c7478
[Fri Mar 17 14:15:23 2017] devtmpfs: initialized
[Fri Mar 17 14:15:23 2017] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
[Fri Mar 17 14:15:23 2017] omap_hwmod: tptc0 using broken dt data from edma
[Fri Mar 17 14:15:23 2017] omap_hwmod: tptc1 using broken dt data from edma
[Fri Mar 17 14:15:23 2017] omap_hwmod: tptc2 using broken dt data from edma
[Fri Mar 17 14:15:23 2017] omap_hwmod: debugss: _wait_target_disable failed
[Fri Mar 17 14:15:23 2017] pinctrl core: initialized pinctrl subsystem
[Fri Mar 17 14:15:23 2017] regulator-dummy: no parameters
[Fri Mar 17 14:15:23 2017] NET: Registered protocol family 16
[Fri Mar 17 14:15:23 2017] DMA: preallocated 256 KiB pool for atomic coherent allocations
[Fri Mar 17 14:15:23 2017] cpuidle: using governor ladder
[Fri Mar 17 14:15:23 2017] cpuidle: using governor menu
[Fri Mar 17 14:15:23 2017] syscon 44e10000.control_module: regmap [mem 0x44e10000-0x44e107fb] registered
[Fri Mar 17 14:15:23 2017] platform 49000000.edma: alias fck already exists
[Fri Mar 17 14:15:23 2017] platform 49000000.edma: alias fck already exists
[Fri Mar 17 14:15:23 2017] platform 49000000.edma: alias fck already exists
[Fri Mar 17 14:15:23 2017] gpiochip_add: registered GPIOs 0 to 31 on device: gpio
[Fri Mar 17 14:15:23 2017] OMAP GPIO hardware version 0.1
[Fri Mar 17 14:15:23 2017] gpiochip_add: registered GPIOs 32 to 63 on device: gpio
[Fri Mar 17 14:15:23 2017] gpiochip_add: registered GPIOs 64 to 95 on device: gpio
[Fri Mar 17 14:15:23 2017] gpiochip_add: registered GPIOs 96 to 127 on device: gpio
[Fri Mar 17 14:15:23 2017] No ATAGs?
[Fri Mar 17 14:15:23 2017] hw-breakpoint: debug architecture 0x4 unsupported.
[Fri Mar 17 14:15:23 2017] bio: create slab <bio-0> at 0
[Fri Mar 17 14:15:23 2017] edma-dma-engine edma-dma-engine.0: TI EDMA DMA engine driver
[Fri Mar 17 14:15:23 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/fixedregulator@0[0]'
[Fri Mar 17 14:15:23 2017] vmmcsd_fixed: 3300 mV 
[Fri Mar 17 14:15:23 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:15:23 2017] wlan-en-regulator: 1800 mV 
[Fri Mar 17 14:15:23 2017] vgaarb: loaded
[Fri Mar 17 14:15:23 2017] i2c-core: driver [palmas] using legacy suspend method
[Fri Mar 17 14:15:23 2017] i2c-core: driver [palmas] using legacy resume method
[Fri Mar 17 14:15:23 2017] SCSI subsystem initialized
[Fri Mar 17 14:15:23 2017] libata version 3.00 loaded.
[Fri Mar 17 14:15:23 2017] usbcore: registered new interface driver usbfs
[Fri Mar 17 14:15:23 2017] usbcore: registered new interface driver hub
[Fri Mar 17 14:15:23 2017] usbcore: registered new device driver usb
[Fri Mar 17 14:15:23 2017] omap_i2c 44e0b000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c0_pins, deferring probe
[Fri Mar 17 14:15:23 2017] platform 44e0b000.i2c: Driver omap_i2c requests probe deferral
[Fri Mar 17 14:15:23 2017] omap_i2c 4802a000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c1_pins, deferring probe
[Fri Mar 17 14:15:23 2017] platform 4802a000.i2c: Driver omap_i2c requests probe deferral
[Fri Mar 17 14:15:23 2017] pps_core: LinuxPPS API ver. 1 registered
[Fri Mar 17 14:15:23 2017] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[Fri Mar 17 14:15:23 2017] PTP clock support registered
[Fri Mar 17 14:15:23 2017] omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
[Fri Mar 17 14:15:23 2017] Advanced Linux Sound Architecture Driver Initialized.
[Fri Mar 17 14:15:23 2017] Switched to clocksource timer1
[Fri Mar 17 14:15:23 2017] NET: Registered protocol family 2
[Fri Mar 17 14:15:23 2017] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[Fri Mar 17 14:15:23 2017] TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
[Fri Mar 17 14:15:23 2017] TCP: Hash tables configured (established 4096 bind 4096)
[Fri Mar 17 14:15:23 2017] TCP: reno registered
[Fri Mar 17 14:15:23 2017] UDP hash table entries: 256 (order: 0, 4096 bytes)
[Fri Mar 17 14:15:23 2017] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[Fri Mar 17 14:15:23 2017] NET: Registered protocol family 1
[Fri Mar 17 14:15:23 2017] RPC: Registered named UNIX socket transport module.
[Fri Mar 17 14:15:23 2017] RPC: Registered udp transport module.
[Fri Mar 17 14:15:23 2017] RPC: Registered tcp transport module.
[Fri Mar 17 14:15:23 2017] RPC: Registered tcp NFSv4.1 backchannel transport module.
[Fri Mar 17 14:15:23 2017] PCI: CLS 0 bytes, default 64
[Fri Mar 17 14:15:23 2017] hw perfevents: enabled with ARMv7 Cortex-A8 PMU driver, 5 counters available
[Fri Mar 17 14:15:23 2017] futex hash table entries: 256 (order: -1, 3072 bytes)
[Fri Mar 17 14:15:23 2017] VFS: Disk quotas dquot_6.5.2
[Fri Mar 17 14:15:23 2017] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[Fri Mar 17 14:15:23 2017] NFS: Registering the id_resolver key type
[Fri Mar 17 14:15:23 2017] Key type id_resolver registered
[Fri Mar 17 14:15:23 2017] Key type id_legacy registered
[Fri Mar 17 14:15:23 2017] jffs2: version 2.2. (NAND) (SUMMARY)  \xffffffc2\xffffffa9\xffffffa9 2001-2006 Red Hat, Inc.
[Fri Mar 17 14:15:23 2017] msgmni has been set to 995
[Fri Mar 17 14:15:23 2017] NET: Registered protocol family 38
[Fri Mar 17 14:15:23 2017] io scheduler noop registered
[Fri Mar 17 14:15:23 2017] io scheduler deadline registered
[Fri Mar 17 14:15:23 2017] io scheduler cfq registered (default)
[Fri Mar 17 14:15:23 2017] pinctrl-single 44e10800.pinmux: 142 pins at pa f9e10800 size 568
[Fri Mar 17 14:15:23 2017] Serial: 8250/16550 driver, 6 ports, IRQ sharing enabled
[Fri Mar 17 14:15:23 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@44e09000[0]'
[Fri Mar 17 14:15:23 2017] 44e09000.serial: ttyS0 at MMIO 0x44e09000 (irq = 88, base_baud = 3000000) is a 8250
[Fri Mar 17 14:15:24 2017] console [ttyS0] enabled
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@48022000[0]'
[Fri Mar 17 14:15:24 2017] 48022000.serial: ttyS1 at MMIO 0x48022000 (irq = 89, base_baud = 3000000) is a 8250
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@48024000[0]'
[Fri Mar 17 14:15:24 2017] 48024000.serial: ttyS2 at MMIO 0x48024000 (irq = 90, base_baud = 3000000) is a 8250
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@481a6000[0]'
[Fri Mar 17 14:15:24 2017] 481a6000.serial: ttyS3 at MMIO 0x481a6000 (irq = 60, base_baud = 3000000) is a 8250
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/serial@481a8000[0]'
[Fri Mar 17 14:15:24 2017] 481a8000.serial: ttyS4 at MMIO 0x481a8000 (irq = 61, base_baud = 3000000) is a 8250
[Fri Mar 17 14:15:24 2017] omap_rng 48310000.rng: OMAP Random Number Generator ver. 20
[Fri Mar 17 14:15:24 2017] [drm] Initialized drm 1.1.0 20060810
[Fri Mar 17 14:15:24 2017] brd: module loaded
[Fri Mar 17 14:15:24 2017] loop: module loaded
[Fri Mar 17 14:15:24 2017] (stk) :sysfs entries created
[Fri Mar 17 14:15:24 2017] (stk) : debugfs entries created 
[Fri Mar 17 14:15:24 2017] (hci_tty): inside hci_tty_init
[Fri Mar 17 14:15:24 2017] (hci_tty): allocated 248, 0
[Fri Mar 17 14:15:24 2017] mtdoops: mtd device (mtddev=name/number) must be supplied
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver asix
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver ax88179_178a
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver cdc_ether
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver smsc95xx
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver net1080
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver cdc_subset
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver zaurus
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver cdc_ncm
[Fri Mar 17 14:15:24 2017] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[Fri Mar 17 14:15:24 2017] ehci-pci: EHCI PCI platform driver
[Fri Mar 17 14:15:24 2017] ehci-omap: OMAP-EHCI Host Controller driver
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver cdc_wdm
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver usb-storage
[Fri Mar 17 14:15:24 2017] mousedev: PS/2 mouse device common for all mice
[Fri Mar 17 14:15:24 2017] omap_rtc 44e3e000.rtc: rtc core: registered 44e3e000.rtc as rtc0
[Fri Mar 17 14:15:24 2017] 44e3e000.rtc: already running
[Fri Mar 17 14:15:24 2017] i2c /dev entries driver
[Fri Mar 17 14:15:24 2017] Driver for 1-wire Dallas network protocol.
[Fri Mar 17 14:15:24 2017] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@48060000[0]'
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@481d8000[0]'
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@481d8000[0]'
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@47810000[0]'
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/mmc@47810000[0]'
[Fri Mar 17 14:15:24 2017] mmc1: BKOPS_EN bit is not set
[Fri Mar 17 14:15:24 2017] mmc1: new high speed MMC card at address 0001
[Fri Mar 17 14:15:24 2017] mmcblk0: mmc1:0001 M52516 14.5 GiB 
[Fri Mar 17 14:15:24 2017] mmcblk0boot0: mmc1:0001 M52516 partition 1 4.00 MiB
[Fri Mar 17 14:15:24 2017] mmcblk0boot1: mmc1:0001 M52516 partition 2 4.00 MiB
[Fri Mar 17 14:15:24 2017]  mmcblk0: p1 p2 p3 p4
[Fri Mar 17 14:15:24 2017]  mmcblk0boot1: unknown partition table
[Fri Mar 17 14:15:24 2017]  mmcblk0boot0: unknown partition table
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:15:24 2017] of_get_named_gpiod_flags exited with status 0
[Fri Mar 17 14:15:24 2017] omap_hsmmc 47810000.mmc: card claims to support voltages below defined range
[Fri Mar 17 14:15:24 2017] ledtrig-cpu: registered to indicate activity on CPUs
[Fri Mar 17 14:15:24 2017] omap-aes 53500000.aes: OMAP AES hw accel rev: 3.2
[Fri Mar 17 14:15:24 2017] omap-sham 53100000.sham: hw accel on OMAP rev 4.3
[Fri Mar 17 14:15:24 2017] usbcore: registered new interface driver usbhid
[Fri Mar 17 14:15:24 2017] usbhid: USB HID core driver
[Fri Mar 17 14:15:24 2017] platform 44d00000.wkup_m3: Driver wkup_m3 requests probe deferral
[Fri Mar 17 14:15:24 2017] oprofile: using arm/armv7
[Fri Mar 17 14:15:24 2017] TCP: cubic registered
[Fri Mar 17 14:15:24 2017] Initializing XFRM netlink socket
[Fri Mar 17 14:15:24 2017] NET: Registered protocol family 17
[Fri Mar 17 14:15:24 2017] NET: Registered protocol family 15
[Fri Mar 17 14:15:24 2017] Key type dns_resolver registered
[Fri Mar 17 14:15:24 2017] cpu cpu0: of_pm_voltdm_notifier_register: Failed to get cpu0 regulator/voltdm: -517
[Fri Mar 17 14:15:24 2017] cpu cpu0: cpu0 clock notifier not ready, retry
[Fri Mar 17 14:15:24 2017] platform cpufreq-cpu0.0: Driver cpufreq-cpu0 requests probe deferral
[Fri Mar 17 14:15:24 2017] PM: bootloader does not support rtc-only!
[Fri Mar 17 14:15:24 2017] ThumbEE CPU extension supported.
[Fri Mar 17 14:15:24 2017] Registering SWP/SWPB emulation handler
[Fri Mar 17 14:15:24 2017] regulator-dummy: disabling
[Fri Mar 17 14:15:24 2017] Error: Driver 'tfp410' is already registered, aborting...
[Fri Mar 17 14:15:24 2017] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
[Fri Mar 17 14:15:24 2017] mmc2: new high speed SDIO card at address 0001
[Fri Mar 17 14:15:24 2017] DCDC1: at 1350 mV 
[Fri Mar 17 14:15:24 2017] vdd_mpu: 925 <--> 1375 mV at 1325 mV 
[Fri Mar 17 14:15:24 2017] vdd_core: 925 <--> 1150 mV at 1125 mV 
[Fri Mar 17 14:15:24 2017] LDO1: at 1800 mV 
[Fri Mar 17 14:15:24 2017] LDO2: at 3300 mV 
[Fri Mar 17 14:15:24 2017] LDO3: 1800 mV 
[Fri Mar 17 14:15:24 2017] LDO4: at 3300 mV 
[Fri Mar 17 14:15:24 2017] tps65217 0-0024: TPS65217 ID 0x6 version 1.2
[Fri Mar 17 14:15:24 2017] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
[Fri Mar 17 14:15:24 2017] rtc-mcp7940 1-006f: rtc core: registered mcp7940 as rtc1
[Fri Mar 17 14:15:24 2017] omap_i2c 4802a000.i2c: bus 1 rev0.11 at 400 kHz
[Fri Mar 17 14:15:24 2017]  remoteproc0: wkup_m3 is available
[Fri Mar 17 14:15:24 2017]  remoteproc0: Note: remoteproc is still under development and considered experimental.
[Fri Mar 17 14:15:24 2017]  remoteproc0: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
[Fri Mar 17 14:15:24 2017]  remoteproc0: Direct firmware load failed with error -2
[Fri Mar 17 14:15:24 2017]  remoteproc0: Falling back to user helper
[Fri Mar 17 14:15:24 2017] cpu cpu0: of_pm_voltdm_notifier_register: Fail calculating voltage latency[950000<->1325000]:-22
[Fri Mar 17 14:15:24 2017] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
[Fri Mar 17 14:15:24 2017] davinci_mdio 4a101000.mdio: detected phy mask fffffffe
[Fri Mar 17 14:15:24 2017] libphy: 4a101000.mdio: probed
[Fri Mar 17 14:15:24 2017] davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver SMSC LAN8710/LAN8720
[Fri Mar 17 14:15:24 2017] cpsw 4a100000.ethernet: Detected MACID = 68:9e:19:87:12:b7
[Fri Mar 17 14:15:24 2017] rtc-mcp7940 1-006f: setting system clock to 2017-03-17 06:15:25 UTC (1489731325)
[Fri Mar 17 14:15:24 2017] ALSA device list:
[Fri Mar 17 14:15:24 2017]   No soundcards found.
[Fri Mar 17 14:15:24 2017] kjournald starting.  Commit interval 5 seconds
[Fri Mar 17 14:15:24 2017] EXT3-fs (mmcblk0p2): mounted filesystem with ordered data mode
[Fri Mar 17 14:15:24 2017] VFS: Mounted root (ext3 filesystem) readonly on device 179:2.
[Fri Mar 17 14:15:24 2017] devtmpfs: mounted
[Fri Mar 17 14:15:24 2017] Freeing unused kernel memory: 260K (c07e8000 - c0829000)
[Fri Mar 17 14:15:25 2017] random: init urandom read with 49 bits of entropy available
[Fri Mar 17 14:15:25 2017] init: plymouth-upstart-bridge main process (844) terminated with status 1
[Fri Mar 17 14:15:25 2017] init: plymouth-upstart-bridge main process ended, respawning
[Fri Mar 17 14:15:25 2017] init: plymouth-upstart-bridge main process (854) terminated with status 1
[Fri Mar 17 14:15:25 2017] init: plymouth-upstart-bridge main process ended, respawning
[Fri Mar 17 14:15:25 2017] init: ureadahead main process (847) terminated with status 5
[Fri Mar 17 14:15:25 2017] init: plymouth-upstart-bridge main process (859) terminated with status 1
[Fri Mar 17 14:15:25 2017] init: plymouth-upstart-bridge main process ended, respawning
[Fri Mar 17 14:15:27 2017] systemd-udevd[956]: starting version 204
[Fri Mar 17 14:15:27 2017]  remoteproc0: powering up wkup_m3
[Fri Mar 17 14:15:27 2017]  remoteproc0: Booting fw image am335x-pm-firmware.elf, size 154412
[Fri Mar 17 14:15:27 2017] PM: CM3 Firmware Version = 0x190
[Fri Mar 17 14:15:27 2017]  remoteproc0: remote processor wkup_m3 is now up
[Fri Mar 17 14:15:27 2017] Bluetooth: Core ver 2.18
[Fri Mar 17 14:15:27 2017] NET: Registered protocol family 31
[Fri Mar 17 14:15:27 2017] Bluetooth: HCI device and connection manager initialized
[Fri Mar 17 14:15:27 2017] Bluetooth: HCI socket layer initialized
[Fri Mar 17 14:15:27 2017] Bluetooth: L2CAP socket layer initialized
[Fri Mar 17 14:15:27 2017] Bluetooth: SCO socket layer initialized
[Fri Mar 17 14:15:27 2017] at24 0-0050: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
[Fri Mar 17 14:15:27 2017] (stc):  chnl_id list empty :4 
[Fri Mar 17 14:15:27 2017] (stk) : st_kim_start(stk) :ldisc_install = 1
[Fri Mar 17 14:15:28 2017] random: nonblocking pool is initialized
[Fri Mar 17 14:15:28 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/usb@47400000/usb-phy@47401300[0]'
[Fri Mar 17 14:15:28 2017] 47401300.usb-phy supply vcc not found, using dummy regulator
[Fri Mar 17 14:15:28 2017] Loading modules backported from Linux version R8.6_SP1-0-g4d167bf
[Fri Mar 17 14:15:28 2017] Backport generated by backports.git R8.6_SP1-0-g4677dc3
[Fri Mar 17 14:15:28 2017] of_get_named_gpiod_flags: can't parse gpios property of node '/ocp/usb@47400000/usb-phy@47401b00[0]'
[Fri Mar 17 14:15:28 2017] 47401b00.usb-phy supply vcc not found, using dummy regulator
[Fri Mar 17 14:15:28 2017] cfg80211: Calling CRDA to update world regulatory domain
[Fri Mar 17 14:15:28 2017] cfg80211: World regulatory domain updated:
[Fri Mar 17 14:15:28 2017] cfg80211:  DFS Master region: unset
[Fri Mar 17 14:15:28 2017] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time)
[Fri Mar 17 14:15:28 2017] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[Fri Mar 17 14:15:28 2017] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[Fri Mar 17 14:15:28 2017] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A)
[Fri Mar 17 14:15:28 2017] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (N/A)
[Fri Mar 17 14:15:28 2017] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s)
[Fri Mar 17 14:15:28 2017] cfg80211:   (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s)
[Fri Mar 17 14:15:28 2017] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
[Fri Mar 17 14:15:28 2017] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A)
[Fri Mar 17 14:15:28 2017] wlcore: wl18xx HW: 183x or 180x, PG 2.2 (ROM 0x11)
[Fri Mar 17 14:15:29 2017] (stk) :ldisc installation timeout
[Fri Mar 17 14:15:29 2017] (stk) :ldisc_install = 0<7>[    6.075452] musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, bulk combine, bulk split, HB-ISO Rx, HB-ISO Tx, SoftConn)
[Fri Mar 17 14:15:29 2017] musb-hdrc: MHDRC RTL version 2.0 
[Fri Mar 17 14:15:29 2017] musb-hdrc: setup fifo_mode 4
[Fri Mar 17 14:15:29 2017] musb-hdrc: 28/31 max ep, 16384/16384 memory
[Fri Mar 17 14:15:29 2017] musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, bulk combine, bulk split, HB-ISO Rx, HB-ISO Tx, SoftConn)
[Fri Mar 17 14:15:29 2017] musb-hdrc: MHDRC RTL version 2.0 
[Fri Mar 17 14:15:29 2017] musb-hdrc: setup fifo_mode 4
[Fri Mar 17 14:15:29 2017] musb-hdrc: 28/31 max ep, 16384/16384 memory
[Fri Mar 17 14:15:29 2017] musb-hdrc musb-hdrc.2.auto: MUSB HDRC host driver
[Fri Mar 17 14:15:29 2017] musb-hdrc musb-hdrc.2.auto: new USB bus registered, assigned bus number 1
[Fri Mar 17 14:15:29 2017] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[Fri Mar 17 14:15:29 2017] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[Fri Mar 17 14:15:29 2017] usb usb1: Product: MUSB HDRC host driver
[Fri Mar 17 14:15:29 2017] usb usb1: Manufacturer: Linux 3.14.43 musb-hcd
[Fri Mar 17 14:15:29 2017] usb usb1: SerialNumber: musb-hdrc.2.auto
[Fri Mar 17 14:15:29 2017] wlcore: loaded
[Fri Mar 17 14:15:29 2017] wlcore: driver version: R8.6_SP1
[Fri Mar 17 14:15:29 2017] hub 1-0:1.0: USB hub found
[Fri Mar 17 14:15:29 2017] hub 1-0:1.0: 1 port detected
[Fri Mar 17 14:15:29 2017] EXT3-fs (mmcblk0p2): using internal journal
[Fri Mar 17 14:15:30 2017] net eth0: initializing cpsw version 1.12 (0)
[Fri Mar 17 14:15:30 2017] (stk) : timed out waiting for ldisc to be un-installed
[Fri Mar 17 14:15:30 2017] (stk) :ldisc_install = 1<6>[    7.154755] net eth0: phy found : id is : 0x7c0f1
[Fri Mar 17 14:15:31 2017] (stk) :ldisc installation timeout
[Fri Mar 17 14:15:31 2017] (stk) :ldisc_install = 0(stk) : timed out waiting for ldisc to be un-installed
[Fri Mar 17 14:15:32 2017] (stk) :ldisc_install = 1(stk) :ldisc installation timeout
[Fri Mar 17 14:15:33 2017] (stk) :ldisc_install = 0(stk) : timed out waiting for ldisc to be un-installed
[Fri Mar 17 14:15:34 2017] (stk) :ldisc_install = 1init: avahi-cups-reload main process (1678) terminated with status 1
[Fri Mar 17 14:15:35 2017] init: Failed to obtain startpar-bridge instance: Unknown parameter: INSTANCE
[Fri Mar 17 14:15:35 2017] (stk) :ldisc installation timeout
[Fri Mar 17 14:15:35 2017] (stk) :ldisc_install = 0(stk) : timed out waiting for ldisc to be un-installed
[Fri Mar 17 14:15:36 2017] (stk) :ldisc_install = 1(stc): st_tty_open 
[Fri Mar 17 14:15:36 2017] (stk) :line discipline installed(stk) :TIInit_11.8.32.bts
[Fri Mar 17 14:15:36 2017] (stk) :change remote baud rate command in firmware(stk) :skipping the wait event of change remote baud
[Fri Mar 17 14:15:36 2017] (stc): st_tty_close init: isc-dhcp-server pre-start process (1762) terminated with status 127
[Fri Mar 17 14:15:37 2017] (stk) :response timeout/signaled during fw download 
[Fri Mar 17 14:15:37 2017] (stk) :download firmware failed(stk) :ldisc_install = 0
[Fri Mar 17 14:15:38 2017] (stk) : timed out waiting for ldisc to be un-installed(stk) :ldisc_install = 1
[Fri Mar 17 14:15:38 2017] (stc): st_tty_open (stk) :line discipline installed
[Fri Mar 17 14:15:38 2017] (stk) :TIInit_11.8.32.bts(stk) :change remote baud rate command in firmware
[Fri Mar 17 14:15:38 2017] (stk) :skipping the wait event of change remote baud<6>[   16.538166] (stc): add_channel_to_table: id 4
[Fri Mar 17 14:15:39 2017] (stc): add_channel_to_table: id 2
[Fri Mar 17 14:15:39 2017] (stc): add_channel_to_table: id 3
[Fri Mar 17 14:15:40 2017] init: plymouth-upstart-bridge main process ended, respawning
[Fri Mar 17 14:15:41 2017] (stc): remove_channel_from_table: id 3
[Fri Mar 17 14:15:41 2017] (stc): remove_channel_from_table: id 2
[Fri Mar 17 14:15:41 2017] (stc): remove_channel_from_table: id 4
[Fri Mar 17 14:15:41 2017] (stc):  all chnl_ids unregistered 
[Fri Mar 17 14:15:41 2017] (stk) :ldisc_install = 0(stc): st_tty_close 
[Fri Mar 17 14:16:34 2017] (stc):  chnl_id list empty :4 (stk) : st_kim_start
[Fri Mar 17 14:16:34 2017] (stk) :ldisc_install = 1(stc): st_tty_open 
[Fri Mar 17 14:16:34 2017] (stk) :line discipline installed(stk) :TIInit_11.8.32.bts
[Fri Mar 17 14:16:34 2017] (stk) :change remote baud rate command in firmware(stk) :skipping the wait event of change remote baud
[Fri Mar 17 14:16:34 2017] (stc): add_channel_to_table: id 4
[Fri Mar 17 14:16:34 2017] (stc): add_channel_to_table: id 2
[Fri Mar 17 14:16:34 2017] (stc): add_channel_to_table: id 3

===================================================================================================

Now, I  add the boot message with Fail

Broadcast message from ubuntu@ubuntu
        (/dev/ttyS0) at 0:35 ...

The system is going down for reboot NOW!
root@ubuntu:/home/ubuntu# wait-for-state stop/waiting
UIM SYSFS Node Found at /sys/./devices/kim/install
Stopping uim-sysfs daemon[  105.032642] (stc): 2 not un-registered(stc): 3 not un-registered
[  105.038509] (stc): 4 not un-registered.
/etc/init.d/rc: line 121: /etc/rc6.d/K09apache2: Permission denied
 * Stopping rsync daemon rsync                                           [ OK ]
/etc/init.d/rc: line 121: /etc/rc6.d/K20udhcpd: Permission denied
Conlogic is not running
Detect old script PID file, Stop script and remove.
Stopping service¡K
Service stopped
Restarting btweb
yac:info: COMMAND = restart

http: error: ConnectionError: HTTPConnectionPool(host='127.0.0.1', port=6010): Max retries exceeded with url: /api/v1/std/restart (Caused by NewConnectionError('<requests.packages.urllib3.connection.HTTPConnection object at 0xb670f1b0>: Failed to establish a new connection: [Errno 111] Connection refused',))
btweb restarted
 * Asking all remaining processes to terminate...                        [ OK ]
 * All processes ended within 1 seconds...                               [ OK ]
rpcbind: rpcbind terminating on signal. Restart with "rpcbind -w"
 * Deactivating swap...                                                  [ OK ]
 * Will now restart
[  112.041099] musb-dsps 47401c00.usb: otg: usb_otg_unregister_hcd: device not registered to otg core
[  112.070954] reboot: Restarting system

U-Boot SPL 2014.07 (Jan 06 2017 - 13:11:45)
reading args
spl_load_image_fat_os: error reading image args, err - -1
reading u-boot.img
reading u-boot.img


U-Boot 2014.07 (Jan 06 2017 - 13:11:45)

I2C:   ready
DRAM:  512 MiB
NAND:  0 MiB
MMC:   OMAP SD/MMC: 0, OMAP SD/MMC: 1
Card did not respond to voltage select!
** Bad device mmc 0 **
Using default environment

Net:   <ethaddr> not set. Validating first E-fuse MAC
cpsw, usb_ether
Hit q key to stop autoboot:  0
Card did not respond to voltage select!
Card did not respond to voltage select!
switch to partitions #0, OK
mmc1(part 0) is current device
SD/MMC found on device 1
reading uEnv.txt
1127 bytes read in 5 ms (219.7 KiB/s)
Loaded environment from uEnv.txt
Importing environment from mmc ...
Running uenvcmd ...
ipcs-3.0.dtb found
32535 bytes read in 21 ms (1.5 MiB/s)
Loaded ipcs-3.0.dtb
zImage-ipcs-3.0 found
4373976 bytes read in 257 ms (16.2 MiB/s)
Loaded zImage-ipcs-3.0
Kernel image @ 0x82000000 [ 0x000000 - 0x42bdd8 ]
## Flattened Device Tree blob at 88000000
   Booting using the fdt blob at 0x88000000
   Loading Device Tree to 8fff5000, end 8fffff16 ... OK

Starting kernel ...

[    0.000000] Booting Linux on physical CPU 0x0
[    0.000000] Linux version 3.14.43 (XXXXXX) (gcc version 4.7.3 20130226 (prerelease) (crosstool-NG linaro-1.13.1-4.7-2013.03-20130313 - Linaro GCC 2013.03) ) #6 Mon Jan 9 14:06:55 CST 2017
[    0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c5387d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] Machine model: TI AM335x BeagleBone
[    0.000000] cma: CMA: reserved 24 MiB at 9e000000
[    0.000000] Memory policy: Data cache writeback
[    0.000000] CPU: All CPU(s) started in SVC mode.
[    0.000000] AM335X ES2.1 (sgx neon )
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 129792
[    0.000000] Kernel command line: console=ttyO0,115200n8 root=/dev/mmcblk0p2 ro rootfstype=ext3 rootwait
[    0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[    0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.000000] Memory: 485120K/523264K available (5895K kernel code, 303K rwdata, 2164K rodata, 261K init, 232K bss, 38144K 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 : 0xe0800000 - 0xff000000   ( 488 MB)
[    0.000000]     lowmem  : 0xc0000000 - 0xe0000000   ( 512 MB)
[    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
[    0.000000]     modules : 0xbf000000 - 0xbfe00000   (  14 MB)
[    0.000000]       .text : 0xc0008000 - 0xc07e70c4   (8061 kB)
[    0.000000]       .init : 0xc07e8000 - 0xc08296fc   ( 262 kB)
[    0.000000]       .data : 0xc082a000 - 0xc0875ce0   ( 304 kB)
[    0.000000]        .bss : 0xc0875ce0 - 0xc08afda0   ( 233 kB)
[    0.000000] NR_IRQS:16 nr_irqs:16 16
[    0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
[    0.000000] Total of 128 interrupts on 1 active controller
[    0.000000] OMAP clockevent source: timer2 at 24000000 Hz
[    0.000012] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956969942ns
[    0.000027] OMAP clocksource: timer1 at 24000000 Hz
[    0.000254] Console: colour dummy device 80x30
[    0.000274] WARNING: Your 'console=ttyO0' has been replaced by 'ttyS0'
[    0.000280] This ensures that you still see kernel messages. Please
[    0.000284] update your kernel commandline.
[    0.000303] Calibrating delay loop... 996.14 BogoMIPS (lpj=4980736)
[    0.089553] pid_max: default: 32768 minimum: 301
[    0.089635] Security Framework initialized
[    0.089682] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.089691] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.095289] CPU: Testing write buffer coherency: ok
[    0.095619] Setting up static identity map for 0x805c7420 - 0x805c7478
[    0.096426] devtmpfs: initialized
[    0.097931] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
[    0.103584] omap_hwmod: tptc0 using broken dt data from edma
[    0.103648] omap_hwmod: tptc1 using broken dt data from edma
[    0.103706] omap_hwmod: tptc2 using broken dt data from edma
[    0.107628] omap_hwmod: debugss: _wait_target_disable failed
[    0.162184] pinctrl core: initialized pinctrl subsystem
[    0.163046] regulator-dummy: no parameters
[    0.165065] NET: Registered protocol family 16
[    0.166700] DMA: preallocated 256 KiB pool for atomic coherent allocations
[    0.168806] cpuidle: using governor ladder
[    0.168818] cpuidle: using governor menu
[    0.173966] syscon 44e10000.control_module: regmap [mem 0x44e10000-0x44e107fb] registered
[    0.175160] platform 49000000.edma: alias fck already exists
[    0.175179] platform 49000000.edma: alias fck already exists
[    0.175191] platform 49000000.edma: alias fck already exists
[    0.176115] OMAP GPIO hardware version 0.1
[    0.187730] No ATAGs?
[    0.187749] hw-breakpoint: debug architecture 0x4 unsupported.
[    0.208990] bio: create slab <bio-0> at 0
[    0.222058] edma-dma-engine edma-dma-engine.0: TI EDMA DMA engine driver
[    0.222907] vmmcsd_fixed: 3300 mV
[    0.223359] wlan-en-regulator: 1800 mV
[    0.225890] vgaarb: loaded
[    0.226319] i2c-core: driver [palmas] using legacy suspend method
[    0.226328] i2c-core: driver [palmas] using legacy resume method
[    0.226915] SCSI subsystem initialized
[    0.228132] usbcore: registered new interface driver usbfs
[    0.228281] usbcore: registered new interface driver hub
[    0.228449] usbcore: registered new device driver usb
[    0.229416] omap_i2c 44e0b000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c0_pins, deferring probe
[    0.229439] platform 44e0b000.i2c: Driver omap_i2c requests probe deferral
[    0.229462] omap_i2c 4802a000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c1_pins, deferring probe
[    0.229474] platform 4802a000.i2c: Driver omap_i2c requests probe deferral
[    0.229833] pps_core: LinuxPPS API ver. 1 registered
[    0.229842] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.229952] PTP clock support registered
[    0.231547] omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
[    0.232438] Advanced Linux Sound Architecture Driver Initialized.
[    0.233790] Switched to clocksource timer1
[    0.249551] NET: Registered protocol family 2
[    0.250264] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[    0.250307] TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
[    0.250345] TCP: Hash tables configured (established 4096 bind 4096)
[    0.250402] TCP: reno registered
[    0.250421] UDP hash table entries: 256 (order: 0, 4096 bytes)
[    0.250435] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[    0.250589] NET: Registered protocol family 1
[    0.250928] RPC: Registered named UNIX socket transport module.
[    0.250938] RPC: Registered udp transport module.
[    0.250943] RPC: Registered tcp transport module.
[    0.250948] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    0.251882] hw perfevents: enabled with ARMv7 Cortex-A8 PMU driver, 5 counters available
[    0.254254] futex hash table entries: 256 (order: -1, 3072 bytes)
[    0.392110] VFS: Disk quotas dquot_6.5.2
[    0.392171] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.392607] NFS: Registering the id_resolver key type
[    0.392682] Key type id_resolver registered
[    0.392689] Key type id_legacy registered
[    0.392721] jffs2: version 2.2. (NAND) (SUMMARY)  {U+00A9} 2001-2006 Red Hat, Inc.
[    0.392867] msgmni has been set to 995
[    0.394429] NET: Registered protocol family 38
[    0.394469] io scheduler noop registered
[    0.394475] io scheduler deadline registered
[    0.394492] io scheduler cfq registered (default)
[    0.395955] pinctrl-single 44e10800.pinmux: 142 pins at pa f9e10800 size 568
[    0.400359] Serial: 8250/16550 driver, 6 ports, IRQ sharing enabled
[    0.403623] 44e09000.serial: ttyS0 at MMIO 0x44e09000 (irq = 88, base_baud = 3000000) is a 8250
[    1.048837] console [ttyS0] enabled
[    1.053302] 48022000.serial: ttyS1 at MMIO 0x48022000 (irq = 89, base_baud = 3000000) is a 8250
[    1.062938] 48024000.serial: ttyS2 at MMIO 0x48024000 (irq = 90, base_baud = 3000000) is a 8250
[    1.072515] 481a6000.serial: ttyS3 at MMIO 0x481a6000 (irq = 60, base_baud = 3000000) is a 8250
[    1.082121] 481a8000.serial: ttyS4 at MMIO 0x481a8000 (irq = 61, base_baud = 3000000) is a 8250
[    1.092310] omap_rng 48310000.rng: OMAP Random Number Generator ver. 20
[    1.099317] [drm] Initialized drm 1.1.0 20060810
[    1.112492] brd: module loaded
[    1.120091] loop: module loaded
[    1.123512] (stk) :sysfs entries created
[    1.127584] (stk) : debugfs entries created
[    1.131867] (hci_tty): inside hci_tty_init
[    1.136574] (hci_tty): allocated 248, 0
[    1.143927] mtdoops: mtd device (mtddev=name/number) must be supplied
[    1.153479] usbcore: registered new interface driver asix
[    1.159128] usbcore: registered new interface driver ax88179_178a
[    1.165412] usbcore: registered new interface driver cdc_ether
[    1.171445] usbcore: registered new interface driver smsc95xx
[    1.177345] usbcore: registered new interface driver net1080
[    1.183165] usbcore: registered new interface driver cdc_subset
[    1.189231] usbcore: registered new interface driver zaurus
[    1.195028] usbcore: registered new interface driver cdc_ncm
[    1.201164] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.207752] ehci-pci: EHCI PCI platform driver
[    1.212385] ehci-omap: OMAP-EHCI Host Controller driver
[    1.218064] usbcore: registered new interface driver cdc_wdm
[    1.223947] usbcore: registered new interface driver usb-storage
[    1.230873] mousedev: PS/2 mouse device common for all mice
[    1.238817] omap_rtc 44e3e000.rtc: rtc core: registered 44e3e000.rtc as rtc0
[    1.246011] 44e3e000.rtc: already running
[    1.250696] i2c /dev entries driver
[    1.254373] Driver for 1-wire Dallas network protocol.
[    1.261634] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[    1.387981] mmc1: BKOPS_EN bit is not set
[    1.396671] mmc1: new high speed MMC card at address 0001
[    1.402616] mmcblk0: mmc1:0001 M52516 14.5 GiB
[    1.407377] mmcblk0boot0: mmc1:0001 M52516 partition 1 4.00 MiB
[    1.413431] mmcblk0boot1: mmc1:0001 M52516 partition 2 4.00 MiB
[    1.420677]  mmcblk0: p1 p2 p3 p4
[    1.427347]  mmcblk0boot1: unknown partition table
[    1.434451]  mmcblk0boot0: unknown partition table
[    1.469018] omap_hsmmc 47810000.mmc: card claims to support voltages below defined range
[    1.477249] ledtrig-cpu: registered to indicate activity on CPUs
[    1.483767] omap-aes 53500000.aes: OMAP AES hw accel rev: 3.2
[    1.490786] omap-sham 53100000.sham: hw accel on OMAP rev 4.3
[    1.497936] usbcore: registered new interface driver usbhid
[    1.503545] usbhid: USB HID core driver
[    1.507672] platform 44d00000.wkup_m3: Driver wkup_m3 requests probe deferral
[    1.518828] oprofile: using arm/armv7
[    1.522821] TCP: cubic registered
[    1.526201] Initializing XFRM netlink socket
[    1.530519] NET: Registered protocol family 17
[    1.535094] NET: Registered protocol family 15
[    1.539684] Key type dns_resolver registered
[    1.544679] cpu cpu0: of_pm_voltdm_notifier_register: Failed to get cpu0 regulator/voltdm: -517
[    1.553441] cpu cpu0: cpu0 clock notifier not ready, retry
[    1.559072] platform cpufreq-cpu0.0: Driver cpufreq-cpu0 requests probe deferral
[    1.567131] PM: bootloader does not support rtc-only!
[    1.572214] ThumbEE CPU extension supported.
[    1.576641] Registering SWP/SWPB emulation handler
[    1.583007] regulator-dummy: disabling
[    1.587767] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
[    1.593451] Error: Driver 'tfp410' is already registered, aborting...
[    1.600838] mmc2: new high speed SDIO card at address 0001
[    1.611160] DCDC1: at 1350 mV
[    1.615312] vdd_mpu: 925 <--> 1375 mV at 1325 mV
[    1.621028] vdd_core: 925 <--> 1150 mV at 1125 mV
[    1.626818] LDO1: at 1800 mV
[    1.630765] LDO2: at 3300 mV
[    1.634690] LDO3: 1800 mV
[    1.638343] LDO4: at 3300 mV
[    1.642338] tps65217 0-0024: TPS65217 ID 0x6 version 1.2
[    1.648158] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
[    1.656223] rtc-mcp7940 1-006f: rtc core: registered mcp7940 as rtc1
[    1.662637] omap_i2c 4802a000.i2c: bus 1 rev0.11 at 400 kHz
[    1.668858]  remoteproc0: wkup_m3 is available
[    1.673325]  remoteproc0: Note: remoteproc is still under development and considered experimental.
[    1.682357]  remoteproc0: THE BINARY FORMAT IS NOT YET FINALIZED, and backward compatibility isn't yet guaranteed.
[    1.692879]  remoteproc0: Direct firmware load failed with error -2
[    1.699199]  remoteproc0: Falling back to user helper
[    1.704728] cpu cpu0: of_pm_voltdm_notifier_register: Fail calculating voltage latency[950000<->1325000]:-22
[    1.773839] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
[    1.779973] davinci_mdio 4a101000.mdio: detected phy mask fffffffe
[    1.786835] libphy: 4a101000.mdio: probed
[    1.790870] davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver SMSC LAN8710/LAN8720
[    1.800757] cpsw 4a100000.ethernet: Detected MACID = 68:9e:19:87:03:6b
[    1.809217] rtc-mcp7940 1-006f: setting system clock to 2014-08-13 16:35:40 UTC (1407947740)
[    1.820258] ALSA device list:
[    1.823253]   No soundcards found.
[    1.832136] kjournald starting.  Commit interval 5 seconds
[    1.837798] EXT3-fs (mmcblk0p2): mounted filesystem with ordered data mode
[    1.844764] VFS: Mounted root (ext3 filesystem) readonly on device 179:2.
[    1.852857] devtmpfs: mounted
[    1.856193] Freeing unused kernel memory: 260K (c07e8000 - c0829000)
Mount failed for selinuxfs on /sys/fs/selinux:  No such file or directory
[    2.107050] random: init urandom read with 48 bits of entropy available
[    2.343738] init: plymouth-upstart-bridge main process (844) terminated with status 1
[    2.388285] init: plymouth-upstart-bridge main process ended, respawning
[    2.504684] init: plymouth-upstart-bridge main process (854) terminated with status 1
[    2.512641] init: plymouth-upstart-bridge main process ended, respawning
[    2.538871] init: ureadahead main process (847) terminated with status 5
[    2.606074] init: plymouth-upstart-bridge main process (859) terminated with status 1
[    2.626484] init: plymouth-upstart-bridge main process ended, respawning
[    6.033887] (stk) :ldisc installation timeout
[    7.033878] (stk) : timed out waiting for ldisc to be un-installed
[    8.144803] (stk) :ldisc installation timeout
 * Starting Mount filesystems on boot                                    [ OK ]
 * Stopping Send an event to indicate plymouth is up                     [ OK ]
 * Starting Fix-up /sys/kernel/debug filesystem                          [ OK ]
 * Stopping Fix-up /sys/kernel/debug filesystem                          [ OK ]
 * Starting Populate and link to /run filesystem                         [ OK ]
 * Stopping Populate and link to /run filesystem                         [ OK ]
 * Stopping Track if upstart is running in a container                   [ OK ]
 * Starting Initialize or finalize resolvconf                            [ OK ]
 * Starting set console keymap                                           [ OK ]
 * Starting Signal sysvinit that virtual filesystems are mounted         [ OK ]
 * Starting Signal sysvinit that virtual filesystems are mounted         [ OK ]
 * Starting Bridge udev events into upstart                              [ OK ]
 * Stopping set console keymap                                           [ OK ]
 * Starting Signal sysvinit that remote filesystems are mounted          [ OK ]
 * Starting device node and kernel event manager                         [ OK ]
 * Starting load modules from /etc/modules                               [ OK ]
 * Starting cold plug devices                                            [ OK ]
 * Starting log initial device creation                                  [ OK ]
 * Stopping load modules from /etc/modules                               [ OK ]
 * Starting configure network device security                            [ OK ]
 * Starting Signal sysvinit that the rootfs is mounted                   [ OK ]
 * Starting configure network device security                            [ OK ]
 * Starting configure network device                                     [ OK ]
 * Stopping cold plug devices                                            [ OK ]
 * Stopping log initial device creation                                  [ OK ]
 * Starting set console font                                             [ OK ]
 * Starting Clean /tmp directory                                         [ OK ]
 * Stopping set console font                                             [ OK ]
 * Starting userspace bootsplash                                         [ OK ]
 * Stopping Clean /tmp directory                                         [ OK ]
 * Stopping userspace bootsplash                                         [ OK ]
 * Starting Send an event to indicate plymouth is up                     [ OK ]
 * Stopping Send an event to indicate plymouth is up                     [ OK ]
(stk) : timed out waiting for ldisc to be un-installed
 * Starting Signal sysvinit that local filesystems are mounted           [ OK ]
 * Starting configure network device security                            [ OK ]
 * Starting configure network device security                            [ OK ]
 * Stopping Mount filesystems on boot                                    [ OK ]
 * Starting flush early job output to logs                               [ OK ]
 * Starting D-Bus system message bus                                     [ OK ]
 * Starting NFSv4 id <-> name mapper                                     [ OK ]
(stk) :ldisc installation timeout
 * Starting configure virtual network devices                            [ OK ]
 * Stopping flush early job output to logs                               [ OK ]
 * Starting SystemD login management service                             [ OK ]
 * Starting configure network device                                     [ OK ]
Waiting for network configuration...
Waiting up to 60 more seconds for network configuration...
Booting system without full network configuration...
 * Starting Mount network filesystems                                    [ OK ]
 * Starting Upstart job to start rpcbind on boot only                    [ OK ]
 * Starting Failsafe Boot Delay                                          [ OK ]
 * Stopping Upstart job to start rpcbind on boot only                    [ OK ]
(stk) : timed out waiting for ldisc to be un-installed
 * Stopping rpcsec_gss daemon                                            [ OK ]
 * Starting system logging daemon                                        [ OK ]
 * Stopping Mount network filesystems                                    [ OK ]
 * Starting mDNS/DNS-SD daemon                                           [ OK ]
 * Starting Reload cups, upon starting avahi-daemon to make sure remote q[ OK ]are populated
 * Starting RPC portmapper replacement                                   [ OK ]
 * Starting Reload cups, upon starting avahi-daemon to make sure remote q[fail]are populated
 * Stopping Failsafe Boot Delay                                          [ OK ]
 * Starting System V initialisation compatibility                        [ OK ]
 * Starting NSM status monitor                                           [ OK ]
[   12.363889] (stk) :ldisc installation timeout
 * Starting Bridge file events into upstart                              [ OK ]
 * Starting Bridge socket events into upstart                            [ OK ]
UIM SYSFS Node Found at /sys/./devices/kim/install
Starting uim-sysfs daemon.
uim:@ main
uim:install = /sys/./devices/kim/install
uim:dev_name = /sys/./devices/kim/dev_name
uim:baud_rate = /sys/./devices/kim/baud_rate
uim:flow_cntrl = /sys/./devices/kim/flow_cntrl
uim:begin polling...
 * Setting up X socket directories...                                    [ OK ]
(stk) : timed out waiting for ldisc to be un-installed
uim:poll broke due to event 10(PRI:2/ERR:8)

uim:read 1 from install

uim:@ st_uart_config
uim: signal received, opening /dev/ttyS4
uim:@ set_baud_rate
uim:set_baud_rate() done
uim:Setting speed to 3000000
uim:@ read_command_complete
uim: Command complete started
uim:@ read_hci_event
uim: read_hci_event
 * Stopping System V initialisation compatibility                        [ OK ]
[   14.473882] (stk) :ldisc installation timeout
 * Starting System V runlevel compatibility                              [ OK ]
 * Starting save kernel messages                                         [ OK ]
 * Starting OpenSSH server                                               [ OK ]
 * Starting ACPI daemon                                                  [ OK ]
 * Starting regular background program processing daemon                 [ OK ]
 * Stopping save kernel messages                                         [ OK ]
 * Stopping ISC DHCP IPv6 server                                         [ OK ]
UIM SYSFS Node Found at /sys/./devices/kim/install
Starting uim-sysfs daemon.
uim:@ main
uim:install = /sys/./devices/kim/install
uim:dev_name = /sys/./devices/kim/dev_name
uim:baud_rate = /sys/./devices/kim/baud_rate
uim:flow_cntrl = /sys/./devices/kim/flow_cntrl
uim:begin polling...
(stk) : timed out waiting for ldisc to be un-installed
uim:poll broke due to event 10(PRI:2/ERR:8)

uim:read 1 from install

uim:@ st_uart_config
uim: signal received, opening /dev/ttyS4
uim:@ set_baud_rate
uim:set_baud_rate() done
uim:Setting speed to 3000000
uim:@ read_command_complete
uim: Command complete started
uim:@ read_hci_event
uim: read_hci_event
 * Loading cpufreq kernel modules...                                     [ OK ]
 * CPU0...       uim:Invalid response
uim:begin polling...
                                                                         [ OK ]  * CPUFreq Utilities: Setting ondemand CPUFreq governor...
/etc/init.d/rc: line 121: /etc/rc2.d/S20udhcpd: Permission denied
/etc/init.d/rc: line 121: /etc/rc2.d/S91apache2: Permission denied
Starting service¡K
Service started
 * Stopping System V runlevel compatibility                              [ OK ]
(stk) :ldisc installation timeout
uim:poll broke due to event 10(PRI:2/ERR:8)

uim:read 0 from install

uim:@ st_uart_config
uim:Un-Installed N_TI_WL Line displine
uim:begin polling...
d_complete
uim: Command complete started
uim:@ read_hci_event
uim: read_hci_event
 * Stopping System V initialisation compatibility                        [ OK ]
 * Starting System V runlevel compatibility                              [ OK ]
 * Starting save kernel messages                                         [ OK ]
 * Starting OpenSSH server                                               [ OK ]
 * Starting ACPI daemon                                                  [ OK ]
 * Starting regular background program processing daemon                 [ OK ]
 * Stopping save kernel messages                                         [ OK ]
 * Stopping ISC DHCP IPv6 server                                         [ OK ]
UIM SYSFS Node Found at /sys/./devices/kim/install
Starting uim-sysfs daemon.
uim:@ main
uim:install = /sys/./devices/kim/install
uim:dev_name = /sys/./devices/kim/dev_name
uim:baud_rate = /sys/./devices/kim/baud_rate
uim:flow_cntrl = /sys/./devices/kim/flow_cntrl
uim:begin polling...
uim:poll broke due to event 10(PRI:2/ERR:8)

uim:read 1 from install

uim:@ st_uart_config
uim: signal received, opening /dev/ttyS4
uim:@ set_baud_rate
uim:set_baud_rate() done
uim:Setting speed to 3000000
uim:@ read_command_complete
uim: Command complete started
uim:@ read_hci_event
uim: read_hci_event
 * Loading cpufreq kernel modules...                                     [ OK ]
 * CPU0...       uim:Invalid response
uim:begin polling...
                                                                         [ OK ]  * CPUFreq Utilities: Setting ondemand CPUFreq governor...
/etc/init.d/rc: line 121: /etc/rc2.d/S20udhcpd: Permission denied
/etc/init.d/rc: line 121: /etc/rc2.d/S91apache2: Permission denied
Starting service¡K
Service started
 * Stopping System V runlevel compatibility                              [ OK ]
uim:poll broke due to event 10(PRI:2/ERR:8)

uim:read 0 from install

uim:@ st_uart_config
uim:Un-Installed N_TI_WL Line displine
uim:begin polling...
 * Starting Signal sysvinit that local filesystems are mounted           [ OK ]
 * Starting configure network device security                            [ OK ]
 * Starting configure network device security                            [ OK ]
 * Stopping Mount filesystems on boot                                    [ OK ]
 * Starting flush early job output to logs                               [ OK ]
 * Starting D-Bus system message bus                                     [ OK ]
 * Starting NFSv4 id <-> name mapper                                     [ OK ]
 * Starting configure virtual network devices                            [ OK ]
 * Stopping flush early job output to logs                               [ OK ]
 * Starting SystemD login management service                             [ OK ]
 * Starting configure network device                                     [ OK ]
Waiting for network configuration...
Waiting up to 60 more seconds for network configuration...
Booting system without full network configuration...
 * Starting Mount network filesystems                                    [ OK ]
 * Starting Upstart job to start rpcbind on boot only                    [ OK ]
 * Starting Failsafe Boot Delay                                          [ OK ]
 * Stopping Upstart job to start rpcbind on boot only                    [ OK ]
 * Stopping rpcsec_gss daemon                                            [ OK ]
 * Starting system logging daemon                                        [ OK ]
 * Stopping Mount network filesystems                                    [ OK ]
 * Starting mDNS/DNS-SD daemon                                           [ OK ]
 * Starting Reload cups, upon starting avahi-daemon to make sure remote q[ OK ]are populated
 * Starting RPC portmapper replacement                                   [ OK ]
 * Starting Reload cups, upon starting avahi-daemon to make sure remote q[fail]are populated
 * Stopping Failsafe Boot Delay                                          [ OK ]
 * Starting System V initialisation compatibility                        [ OK ]
 * Starting NSM status monitor                                           [ OK ]
 * Starting Bridge file events into upstart                              [ OK ]
 * Starting Bridge socket events into upstart                            [ OK ]
UIM SYSFS Node Found at /sys/./devices/kim/install
Starting uim-sysfs daemon.
uim:@ main
uim:install = /sys/./devices/kim/install
uim:dev_name = /sys/./devices/kim/dev_name
uim:baud_rate = /sys/./devices/kim/baud_rate
uim:flow_cntrl = /sys/./devices/kim/flow_cntrl
uim:begin polling...
 * Setting up X socket directories...                                    [ OK ]
uim:poll broke due to event 10(PRI:2/ERR:8)

uim:read 1 from install

uim:@ st_uart_config
uim: signal receiv[   17.583862] (stk) : timed out waiting for ldisc to be un-installed
[   17.591963] Bluetooth: st_register failed -22

Ubuntu 14.04.1 LTS ubuntu ttyS0


The IP Address for wlan0 is: 192.168.0.116
The IP Address for usb0 is: 192.168.7.2

  • Hi Jerry,

    This query has been assigned to a relevant expert. We will get back to you soon.

    Best regards,
    Vihang
  • Which Bluez version are you using and did you make any modifications? How do you attach to the BLE/BT controller? Is it done automatically through a systemd or init rc script? If so, can you remove that and try to start it manually after board bootup, and see if problem is still reproducible.

    Thanks
  • Hi Hari Nagalla,
    We just installed libbluetooth-dev(4.101-0ubuntu13.1) and do not make any modification.
    I confused "How do you attach to the BLE/BT controller?" because we do not modify the relate procedure of BLE/BT controller attaching.

    Also when the init fail after boot, if I type "hciconfig hci0 up", the error message as followed.
    Please help me to address the problem, thanks a lot.

    root@XXXXX:/home/ubuntu# hciconfig hci0 up
    uim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 1 from install

    uim:@ st_uart_config
    uim: signal received, opening /dev/ttyS4
    uim:@ set_baud_rate
    uim:set_baud_rate() done
    uim:Setting speed to 3000000
    uim:@ read_command_complete
    uim: Command complete started
    uim:@ read_hci_event
    uim: read_hci_event
    uim:Invalid response
    uim:begin polling...
    [ 92.423842] (stk) :ldisc installation timeoutuim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 0 from install

    uim:@ st_uart_config
    uim:Un-Installed N_TI_WL Line displine
    uim:begin polling...
    [ 93.423896] (stk) : timed out waiting for ldisc to be un-installeduim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 1 from install

    uim:@ st_uart_config
    uim: signal received, opening /dev/ttyS4
    uim:@ set_baud_rate
    uim:set_baud_rate() done
    uim:Setting speed to 3000000
    uim:@ read_command_complete
    uim: Command complete started
    uim:@ read_hci_event
    uim: read_hci_event
    uim:Invalid response
    uim:begin polling...
    [ 94.533781] (stk) :ldisc installation timeoutuim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 0 from install

    uim:@ st_uart_config
    uim:Un-Installed N_TI_WL Line displine
    uim:begin polling...
    [ 95.533815] (stk) : timed out waiting for ldisc to be un-installeduim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 1 from install

    uim:@ st_uart_config
    uim: signal received, opening /dev/ttyS4
    uim:@ set_baud_rate
    uim:set_baud_rate() done
    uim:Setting speed to 3000000
    uim:@ read_command_complete
    uim: Command complete started
    uim:@ read_hci_event
    uim: read_hci_event
    uim:Invalid response
    uim:begin polling...
    [ 96.643825] (stk) :ldisc installation timeoutuim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 0 from install

    uim:@ st_uart_config
    uim:Un-Installed N_TI_WL Line displine
    uim:begin polling...
    [ 97.643841] (stk) : timed out waiting for ldisc to be un-installeduim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 1 from install

    uim:@ st_uart_config
    uim: signal received, opening /dev/ttyS4
    uim:@ set_baud_rate
    uim:set_baud_rate() done
    uim:Setting speed to 3000000
    uim:@ read_command_complete
    uim: Command complete started
    uim:@ read_hci_event
    uim: read_hci_event
    uim:Invalid response
    uim:begin polling...
    [ 98.753846] (stk) :ldisc installation timeoutuim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 0 from install

    uim:@ st_uart_config
    uim:Un-Installed N_TI_WL Line displine
    uim:begin polling...
    [ 99.753847] (stk) : timed out waiting for ldisc to be un-installeduim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 1 from install

    uim:@ st_uart_config
    uim: signal received, opening /dev/ttyS4
    uim:@ set_baud_rate
    uim:set_baud_rate() done
    uim:Setting speed to 3000000
    uim:@ read_command_complete
    uim: Command complete started
    uim:@ read_hci_event
    uim: read_hci_event
    uim:Invalid response
    uim:begin polling...
    [ 100.863822] (stk) :ldisc installation timeoutuim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 0 from install

    uim:@ st_uart_config
    uim:Un-Installed N_TI_WL Line displine
    uim:begin polling...
    [ 101.863835] (stk) : timed out waiting for ldisc to be un-installeduim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 1 from install

    uim:@ st_uart_config
    uim: signal received, opening /dev/ttyS4
    uim:@ set_baud_rate
    uim:set_baud_rate() done
    uim:Setting speed to 3000000
    uim:@ read_command_complete
    uim: Command complete started
    uim:@ read_hci_event
    uim: read_hci_event
    uim:Invalid response
    uim:begin polling...
    [ 102.973819] (stk) :ldisc installation timeoutuim:poll broke due to event 10(PRI:2/ERR:8)

    uim:read 0 from install

    uim:@ st_uart_config
    uim:Un-Installed N_TI_WL Line displine
    uim:begin polling...
    [ 103.973832] (stk) : timed out waiting for ldisc to be un-installed[ 103.981942] Bluetooth: st_register failed -22
    Can't init device hci0: Input/output error (5)
  • I found a familiar issue. (Also randomly occur)
    e2e.ti.com/.../534759
    Does the issue close already?

  • Finally, we found this issue possible happens when we enable the hci0 (hciconfig hci0 up) on the wlan0 is disable.

    So we modified the enabling sequence and the issue did not happen again we observed.

    But, we want to check is this the correct solution and is the phenomenon unusual?