3.17.1-rc4 sudden reset

1,304 views
Skip to first unread message

Ives van der Flaas

unread,
Oct 30, 2014, 5:50:43 AM10/30/14
to beagl...@googlegroups.com
I'm running Robert C Nelson's latest 3.17 kernel (3.17.1-bone4) because I need the new TI musb babble recovery code. It seems however that I'm having some strange instability on my BBB. After somewhere between 10 and 24 hours, the device seems to reset suddenly and without warning. There's no kernel panic as far as I can see (no kernel.panic time-out in my sysctl either) and nothing in the dmesg or kern log files. It suddenly resets. 

On the serial console, using my own FTDI cable, I was running "watch", and when I returned the next day the program wasn't refreshing as it should have been. I pressed enter and immediately a login prompt appeared. Uptime was also way shorter than it should have been. 

Any clues on what might cause this? This seems a bit like a power supply issue, but I've been running the same BBB for weeks using the same power supply on a 3.8.13 kernel and that's always worked fine, while on this kernel it can't even last a day. 

Thanks,
Ives

jpsc...@googlemail.com

unread,
Oct 30, 2014, 11:31:21 AM10/30/14
to beagl...@googlegroups.com
 Hi Ives,
I am experiencing the same issue with our beaglebones (several of them). We are using Robert C Nelson's latest 3.17.1-bone4 kernel image, and after some time they reboot. Beside that the kernel is much more stable than any other I have tried.
The only clue I have come across was in this thread: https://groups.google.com/forum/#!topic/beagleboard/xPxzYyNsA78
There it was suspected that the USB controller could have undesired side effects when it is scanning for OTG devices. I disabled USB OTG in my test kernel but not luck. I am currently trying to add the patch to print the last reboot reason and hope to get more data with it.

Otherwise, I appreciate any ideas or suggestions how to debug it.

Thanks,
Jens

david turvene

unread,
Oct 30, 2014, 12:34:00 PM10/30/14
to beagl...@googlegroups.com
On Thursday, October 30, 2014 5:50:43 AM UTC-4, Ives van der Flaas wrote:
I'm running Robert C Nelson's latest 3.17 kernel (3.17.1-bone4) because I need the new TI musb babble recovery code. It seems however that I'm having some strange instability on my BBB. After somewhere between 10 and 24 hours, the device seems to reset suddenly and without warning. There's no kernel panic as far as I can see (no kernel.panic time-out in my sysctl either) and nothing in the dmesg or kern log files. It suddenly resets. 


FWIW, I'm seeing similar behavior on Debian 7.7 on 3.17-0.rc7-bone4; it'll reboot somewhere between 2 and 48 hours for no apparent reason.  It doesn't seem to do it when I'm working on BBB so was suspecting something related to the watchdog and/or the PRCM module putting the processor in low-power suspend state.  I was thinking of going back to 3.8 in a little bit.

/proc/version:

Linux version 3.17.0-rc7-bone4 (dturvene@growler) (gcc version 4.9.2 20140904 (prerelease) (crosstool-NG linaro-1.13.1-4.9-2014.09 - Linaro GCC 4.9-2014.09) ) #1 Wed Oct 8 10:48:15 EDT 2014

Nothing on uart console but ALWAYS the last syslog statement before reboot is the hourly cron job - but there is nothing in it.

Oct 29 01:17:01 beaglebone /USR/SBIN/CRON[31755]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Oct 29 02:17:01 beaglebone /USR/SBIN/CRON[1888]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Oct 29 03:17:01 beaglebone /USR/SBIN/CRON[4062]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Oct 29 04:17:01 beaglebone /USR/SBIN/CRON[6238]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Oct 29 05:17:01 beaglebone /USR/SBIN/CRON[8413]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Jan  1 00:00:16 beaglebone kernel: imklog 5.8.11, log source = /proc/kmsg started.

Dave

Robert Nelson

unread,
Oct 30, 2014, 12:36:34 PM10/30/14
to Beagle Board
On Thu, Oct 30, 2014 at 11:34 AM, david turvene <dtur...@gmail.com> wrote:
> On Thursday, October 30, 2014 5:50:43 AM UTC-4, Ives van der Flaas wrote:
>>
>> I'm running Robert C Nelson's latest 3.17 kernel (3.17.1-bone4) because I
>> need the new TI musb babble recovery code. It seems however that I'm having
>> some strange instability on my BBB. After somewhere between 10 and 24 hours,
>> the device seems to reset suddenly and without warning. There's no kernel
>> panic as far as I can see (no kernel.panic time-out in my sysctl either) and
>> nothing in the dmesg or kern log files. It suddenly resets.
>>
>
> FWIW, I'm seeing similar behavior on Debian 7.7 on 3.17-0.rc7-bone4; it'll
> reboot somewhere between 2 and 48 hours for no apparent reason. It doesn't
> seem to do it when I'm working on BBB so was suspecting something related to
> the watchdog and/or the PRCM module putting the processor in low-power
> suspend state. I was thinking of going back to 3.8 in a little bit.
>
> /proc/version:
>
> Linux version 3.17.0-rc7-bone4 (dturvene@growler) (gcc version 4.9.2
> 20140904 (prerelease) (crosstool-NG linaro-1.13.1-4.9-2014.09 - Linaro GCC
> 4.9-2014.09) ) #1 Wed Oct 8 10:48:15 EDT 2014
>
> Nothing on uart console but ALWAYS the last syslog statement before reboot
> is the hourly cron job - but there is nothing in it.

Are you guys still seeing this with 3.18-rc2?

if you have my repo in /etc/apt/sources.list

sudo apt-get update
sudo apt-get install linux-image-3.18.0-rc2-bone1
sudo reboot

Regards,

--
Robert Nelson
http://www.rcn-ee.com/

david turvene

unread,
Oct 30, 2014, 1:10:18 PM10/30/14
to beagl...@googlegroups.com

Are you guys still seeing this with 3.18-rc2?

if you have my repo in /etc/apt/sources.list

sudo apt-get update
sudo apt-get install linux-image-3.18.0-rc2-bone1
sudo reboot

Regards,

--
Robert Nelson
http://www.rcn-ee.com/
 
@Robert - I just upgraded to your image and it is running.  I'll let it soak.  BTW, very impressive work you're doing on the BBs  - I love the image-builder scripts.

@Jens -  Interesting about the USB connection.  I am running a 4-port USB hub with a couple wifi plugs.

Dave

William Hermans

unread,
Oct 30, 2014, 1:15:33 PM10/30/14
to beagl...@googlegroups.com
So I'm curious. Did all of you follow Roberts DebianOnARM kernel build instructions, or are you all using a prebuilt image ?

Also, at some point I think the output of pstree from all of you *might* be somewhat enlightening.

--
For more options, visit http://beagleboard.org/discuss
---
You received this message because you are subscribed to the Google Groups "BeagleBoard" group.
To unsubscribe from this group and stop receiving emails from it, send an email to beagleboard...@googlegroups.com.
For more options, visit https://groups.google.com/d/optout.

Ives van der Flaas

unread,
Oct 31, 2014, 4:06:33 AM10/31/14
to beagl...@googlegroups.com
I'm currently trying the 3.18-rc2-bone1, no issues so far. I won't be able to check on them during the weekend so I'll know by monday. 

Op donderdag 30 oktober 2014 17:36:34 UTC+1 schreef RobertCNelson:

jpsc...@googlemail.com

unread,
Oct 31, 2014, 7:38:14 AM10/31/14
to beagl...@googlegroups.com
I updated 4 BBBs with the 3.18-rc2-bone1 image. Just had the first reboot after a bit more than 1.30 hours uptime.

@Robert, thank you for the help. Is it possible to print the reason for the last reset? I saw a patch in Android but only for OMAP4. Would you know if it is possible to get this information on the BBB as well? What other data can I provide to debug this problem?

Dmesg after reboot:
[    0.000000] Booting Linux on physical CPU 0x0                                                                                                                            
[    0.000000] Initializing cgroup subsys cpuset                                                                                                                            
[    0.000000] Initializing cgroup subsys cpu                                                                                                                                
[    0.000000] Initializing cgroup subsys cpuacct                                                                                                                            
[    0.000000] Linux version 3.18.0-rc2-bone1 (root@a5-imx6q-wandboard-2gb) (gcc version 4.9.1 (Debian 4.9.1-16) ) #1 Mon Oct 27 03:41:12 UTC 2014                          
[    0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=50c5387d                                                                                              
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache                                                                                      
[    0.000000] Machine model: TI AM335x BeagleBone Black                                                                                                                    
[    0.000000] cma: Reserved 16 MiB at 9e800000                                                                                                                              
[    0.000000] Memory policy: Data cache writeback                                                                                                                          
[    0.000000] On node 0 totalpages: 130816                                                                                                                                  
[    0.000000] free_area_init_node: node 0, pgdat c0a5d5b8, node_mem_map dfaf1000                                                                                            
[    0.000000]   Normal zone: 1024 pages used for memmap                                                                                                                    
[    0.000000]   Normal zone: 0 pages reserved                                                                                                                              
[    0.000000]   Normal zone: 130816 pages, LIFO batch:31                                                                                                                    
[    0.000000]   HighMem zone: 1048574 pages exceeds freesize 0                                                                                                              
[    0.000000] CPU: All CPU(s) started in SVC mode.                                                                                                                          
[    0.000000] AM335X ES2.1 (sgx neon )                                                                                                                                      
[    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: 129792                                                                                  
[    0.000000] Kernel command line: console=ttyO0,115200n8 root=UUID=47b4fe5e-a89a-4e10-b3b0-1d4050f2d6ad ro rootfstype=ext4 rootwait fixrtc quiet init=/lib/systemd/systemd coherent_pool=2M                                                                                                                                                            
[    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] allocated 1046528 bytes of page_cgroup
[    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
[    0.000000] Memory: 485984K/523264K available (6136K kernel code, 700K rwdata, 3388K rodata, 464K init, 863K bss, 37280K reserved, 0K highmem)
[    0.000000] Virtual kernel memory layout:
[    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[    0.000000]     fixmap  : 0xffc00000 - 0xffe00000   (2048 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 : 0xbf800000 - 0xbfe00000   (   6 MB)
[    0.000000]       .text : 0xc0008000 - 0xc09552a4   (9525 kB)
[    0.000000]       .init : 0xc0956000 - 0xc09ca000   ( 464 kB)
[    0.000000]       .data : 0xc09ca000 - 0xc0a79348   ( 701 kB)
[    0.000000]        .bss : 0xc0a79348 - 0xc0b50fa4   ( 864 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] OMAP clockevent source: timer2 at 24000000 Hz
[    0.000012] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956969942ns
[    0.000029] OMAP clocksource: timer1 at 24000000 Hz
[    0.000261] Console: colour dummy device 80x30
[    0.000287] Calibrating delay loop... 996.14 BogoMIPS (lpj=4980736)
[    0.088918] pid_max: default: 32768 minimum: 301
[    0.089026] Security Framework initialized
[    0.089094] AppArmor: AppArmor disabled by boot time parameter
[    0.089102] Yama: becoming mindful.
[    0.089277] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.089287] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.089877] Initializing cgroup subsys memory
[    0.089910] Initializing cgroup subsys devices
[    0.089924] Initializing cgroup subsys freezer
[    0.089937] Initializing cgroup subsys net_cls
[    0.089953] Initializing cgroup subsys blkio
[    0.089966] Initializing cgroup subsys perf_event
[    0.089977] Initializing cgroup subsys net_prio
[    0.090027] CPU: Testing write buffer coherency: ok
[    0.090071] ftrace: allocating 31261 entries in 62 pages
[    0.155742] Setting up static identity map for 0x805c5b98 - 0x805c5be4
[    0.162306] devtmpfs: initialized
[    0.163207] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
[    0.171556] omap_hwmod: tptc0 using broken dt data from edma
[    0.171650] omap_hwmod: tptc1 using broken dt data from edma
[    0.171730] omap_hwmod: tptc2 using broken dt data from edma
[    0.175884] omap_hwmod: debugss: _wait_target_disable failed
[    0.236823] xor: measuring software checksum speed
[    0.328890]    arm4regs  :  1244.800 MB/sec
[    0.428887]    8regs     :  1113.200 MB/sec
[    0.528889]    32regs    :  1112.400 MB/sec
[    0.628887]    neon      :  1791.600 MB/sec
[    0.628894] xor: using function: neon (1791.600 MB/sec)
[    0.628953] pinctrl core: initialized pinctrl subsystem
[    0.629343] regulator-dummy: no parameters
[    0.645452] NET: Registered protocol family 16
[    0.649315] DMA: preallocated 2048 KiB pool for atomic coherent allocations
[    0.650292] cpuidle: using governor ladder
[    0.650309] cpuidle: using governor menu
[    0.653138] OMAP GPIO hardware version 0.1
[    0.665814] No ATAGs?
[    0.665841] hw-breakpoint: debug architecture 0x4 unsupported.
[    0.839056] raid6: int32x1    270 MB/s
[    1.008926] raid6: int32x2    374 MB/s
[    1.178950] raid6: int32x4    389 MB/s
[    1.348931] raid6: int32x8    358 MB/s
[    1.518920] raid6: neonx1    1451 MB/s
[    1.688892] raid6: neonx2    1887 MB/s
[    1.858890] raid6: neonx4    2010 MB/s
[    2.028947] raid6: neonx8     667 MB/s
[    2.028953] raid6: using algorithm neonx4 (2010 MB/s)
[    2.028958] raid6: using intx1 recovery algorithm
[    2.036760] edma-dma-engine edma-dma-engine.0: TI EDMA DMA engine driver
[    2.037497] vbat: 5000 mV
[    2.037733] vmmcsd_fixed: 3300 mV
[    2.040534] SCSI subsystem initialized
[    2.040796] libata version 3.00 loaded.
[    2.041067] usbcore: registered new interface driver usbfs
[    2.041120] usbcore: registered new interface driver hub
[    2.041181] usbcore: registered new device driver usb
[    2.041701] omap_i2c 44e0b000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c0_pins, deferring probe
[    2.041722] platform 44e0b000.i2c: Driver omap_i2c requests probe deferral
[    2.041746] omap_i2c 4819c000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c2_pins, deferring probe
[    2.041758] platform 4819c000.i2c: Driver omap_i2c requests probe deferral
[    2.041894] media: Linux media interface: v0.10
[    2.041943] Linux video capture interface: v2.00
[    2.042034] pps_core: LinuxPPS API ver. 1 registered
[    2.042040] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giom...@linux.it>
[    2.042065] PTP clock support registered
[    2.042727] omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
[    2.044077] NetLabel: Initializing
[    2.044088] NetLabel:  domain hash size = 128
[    2.044093] NetLabel:  protocols = UNLABELED CIPSOv4
[    2.044150] NetLabel:  unlabeled traffic allowed by default
[    2.044628] Switched to clocksource timer1
[    2.099174] NET: Registered protocol family 2
[    2.099849] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[    2.099891] TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
[    2.099928] TCP: Hash tables configured (established 4096 bind 4096)
[    2.099985] TCP: reno registered
[    2.099995] UDP hash table entries: 256 (order: 0, 4096 bytes)
[    2.100010] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[    2.100180] NET: Registered protocol family 1
[    2.100544] RPC: Registered named UNIX socket transport module.
[    2.100552] RPC: Registered udp transport module.
[    2.100558] RPC: Registered tcp transport module.
[    2.100563] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    2.101067] Unpacking initramfs...
[    2.315119] Freeing initrd memory: 3384K (cfcb2000 - d0000000)
[    2.315757] hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available
[    2.318014] futex hash table entries: 256 (order: -1, 3072 bytes)
[    2.318115] audit: initializing netlink subsys (disabled)
[    2.318176] audit: type=2000 audit(2.270:1): initialized
[    2.319359] zpool: loaded
[    2.319376] zbud: loaded
[    2.319621] VFS: Disk quotas dquot_6.5.2
[    2.319682] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    2.320197] NFS: Registering the id_resolver key type
[    2.320248] Key type id_resolver registered
[    2.320254] Key type id_legacy registered
[    2.320276] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[    2.320531] fuse init (API version 7.23)
[    2.320727] SGI XFS with ACLs, security attributes, realtime, no debug enabled
[    2.321243] msgmni has been set to 987
[    2.322200] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[    2.322336] io scheduler noop registered
[    2.322349] io scheduler deadline registered
[    2.322392] io scheduler cfq registered (default)
[    2.323637] pinctrl-single 44e10800.pinmux: 142 pins at pa f9e10800 size 568
[    2.326629] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    2.328576] omap_uart 44e09000.serial: no wakeirq for uart0
[    2.328745] omap_uart 44e09000.serial: ttyO0 at MMIO 0x44e09000 (irq = 154, base_baud = 3000000) is a OMAP UART0
[    2.329159] console [ttyO0] enabled
[    2.329587] omap_uart 48022000.serial: no wakeirq for uart0
[    2.329706] omap_uart 48022000.serial: ttyO1 at MMIO 0x48022000 (irq = 155, base_baud = 3000000) is a OMAP UART1
[    2.330042] omap_uart 48024000.serial: no wakeirq for uart0
[    2.330146] omap_uart 48024000.serial: ttyO2 at MMIO 0x48024000 (irq = 156, base_baud = 3000000) is a OMAP UART2
[    2.330480] omap_uart 481a8000.serial: no wakeirq for uart0
[    2.330580] omap_uart 481a8000.serial: ttyO4 at MMIO 0x481a8000 (irq = 157, base_baud = 3000000) is a OMAP UART4
[    2.330915] omap_uart 481aa000.serial: no wakeirq for uart0
[    2.331016] omap_uart 481aa000.serial: ttyO5 at MMIO 0x481aa000 (irq = 158, base_baud = 3000000) is a OMAP UART5
[    2.332495] omap_rng 48310000.rng: OMAP Random Number Generator ver. 20
[    2.332789] [drm] Initialized drm 1.1.0 20060810
[    2.332876] usbcore: registered new interface driver udl
[    2.332894] Error: Driver '
tfp410' is already registered, aborting...
[    2.340011] slave hdmi: could not get i2c
[    2.344247] platform hdmi: Driver slave requests probe deferral
[    2.344504] platform 4830e000.lcdc: Driver tilcdc requests probe deferral
[    2.360038] ehci_hcd: USB 2.0 '
Enhanced' Host Controller (EHCI) Driver
[    2.360069] ehci-platform: EHCI generic platform driver
[    2.360263] ehci-omap: OMAP-EHCI Host Controller driver
[    2.360468] usbcore: registered new interface driver usb-storage
[    2.362179] 47401300.usb-phy supply vcc not found, using dummy regulator
[    2.364469] musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, bulk combine, bulk split, HB-ISO Rx, HB-ISO Tx, SoftConn)
[    2.364485] musb-hdrc: MHDRC RTL version 2.0
[    2.364492] musb-hdrc: setup fifo_mode 4
[    2.364508] musb-hdrc: 28/31 max ep, 16384/16384 memory
[    2.364690] musb-hdrc musb-hdrc.0.auto: MUSB HDRC host driver
[    2.364951] musb-hdrc musb-hdrc.0.auto: new USB bus registered, assigned bus number 1
[    2.365121] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    2.365131] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.365140] usb usb1: Product: MUSB HDRC host driver
[    2.365148] usb usb1: Manufacturer: Linux 3.18.0-rc2-bone1 musb-hcd
[    2.365155] usb usb1: SerialNumber: musb-hdrc.0.auto
[    2.365839] hub 1-0:1.0: USB hub found
[    2.365878] hub 1-0:1.0: 1 port detected
[    2.367214] 47401b00.usb-phy supply vcc not found, using dummy regulator
[    2.369439] musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, bulk combine, bulk split, HB-ISO Rx, HB-ISO Tx, SoftConn)
[    2.369454] musb-hdrc: MHDRC RTL version 2.0
[    2.369461] musb-hdrc: setup fifo_mode 4
[    2.369473] musb-hdrc: 28/31 max ep, 16384/16384 memory
[    2.369577] musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver
[    2.369834] musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 2
[    2.369986] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002
[    2.369997] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.370005] usb usb2: Product: MUSB HDRC host driver
[    2.370013] usb usb2: Manufacturer: Linux 3.18.0-rc2-bone1 musb-hcd
[    2.370020] usb usb2: SerialNumber: musb-hdrc.1.auto
[    2.370637] hub 2-0:1.0: USB hub found
[    2.370674] hub 2-0:1.0: 1 port detected
[    2.379084] mousedev: PS/2 mouse device common for all mice
[    2.380625] omap_rtc 44e3e000.rtc: rtc core: registered 44e3e000.rtc as rtc0
[    2.380825] i2c /dev entries driver
[    2.380949] IR XMP protocol handler initialized
[    2.382458] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
[    2.382906] sdhci: Secure Digital Host Controller Interface driver
[    2.382914] sdhci: Copyright(c) Pierre Ossman
[    2.474997] sdhci-pltfm: SDHCI platform and OF driver helper
[    2.476356] ledtrig-cpu: registered to indicate activity on CPUs
[    2.476452] hidraw: raw HID events driver (C) Jiri Kosina
[    2.478458] usbcore: registered new interface driver usbhid
[    2.478466] usbhid: USB HID core driver
[    2.481087] ashmem: initialized
[    2.482259] oprofile: using arm/armv7
[    2.482536] TCP: cubic registered
[    2.482629] NET: Registered protocol family 10
[    2.483545] mip6: Mobile IPv6
[    2.483568] NET: Registered protocol family 17
[    2.483669] Key type dns_resolver registered
[    2.483680] mpls_gso: MPLS GSO support
[    2.483978] omap_voltage_late_init: Voltage driver support not added
[    2.490761] sr_dev_init: No voltage domain specified for smartreflex0. Cannot initialize
[    2.499308] sr_dev_init: No voltage domain specified for smartreflex1. Cannot initialize
[    2.508445] platform cpufreq-dt.0: Driver cpufreq-dt requests probe deferral
[    2.508683] ThumbEE CPU extension supported.
[    2.508721] Registering SWP/SWPB emulation handler
[    2.508742] SmartReflex Class3 initialized
[    2.512538] registered taskstats version 1
[    2.513349] Btrfs loaded
[    2.520582] input: tps65217_pwr_but as /devices/ocp/44e0b000.i2c/i2c-0/0-0024/input/input0
[    2.522170] vdd_ddr3: 1350 mV
[    2.522964] vdd_mpu: 925 <--> 1325 mV at 1325 mV
[    2.523717] vdd_core: 925 <--> 1150 mV at 1125 mV
[    2.524453] vio,vrtc,vdds: at 1800 mV
[    2.525315] vdd_3v3aux: at 3300 mV
[    2.526091] vdd_1v8: 1800 mV
[    2.526909] vdd_3v3a: at 3300 mV
[    2.527715] tps65217 0-0024: TPS65217 ID 0xe version 1.2
[    2.532082] at24 0-0050: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
[    2.532126] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
[    2.537818] at24 2-0054: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
[    2.538265] mmc1: BKOPS_EN bit is not set
[    2.542693] at24 2-0055: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
[    2.543559] mmc1: new high speed MMC card at address 0001
[    2.547702] at24 2-0056: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
[    2.547899] mmcblk0: mmc1:0001 MMC04G 3.60 GiB
[    2.548133] mmcblk0boot0: mmc1:0001 MMC04G partition 1 2.00 MiB
[    2.548339] mmcblk0boot1: mmc1:0001 MMC04G partition 2 2.00 MiB
[    2.549347]  mmcblk0: p1
[    2.554865] at24 2-0057: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
[    2.554915] omap_i2c 4819c000.i2c: bus 2 rev0.11 at 100 kHz
[    2.676896] tda998x 0-0070: found TDA19988
[    2.677857] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[    2.677865] [drm] No driver support for vblank timestamp query.
[    2.678278] tilcdc 4830e000.lcdc: No connectors reported connected with modes
[    2.678297] [drm] Cannot find any crtc or sizes - going 1024x768
[    2.690912] Console: switching to colour frame buffer device 128x48
[    2.696353] tilcdc 4830e000.lcdc: fb0:  frame buffer device
[    2.696361] tilcdc 4830e000.lcdc: registered panic notifier
[    2.696383] [drm] Initialized tilcdc 1.0.0 20121205 on minor 0
[    2.754654] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
[    2.754672] davinci_mdio 4a101000.mdio: detected phy mask fffffffe
[    2.760163] libphy: 4a101000.mdio: probed
[    2.760191] davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver SMSC LAN8710/LAN8720
[    2.761083] cpsw 4a100000.ethernet: Detected MACID = 78:a5:04:ca:63:26
[    2.762203] omap_rtc 44e3e000.rtc: setting system clock to 2000-01-01 00:00:00 UTC (946684800)
[    2.762225] sr_init: No PMIC hook to init smartreflex
[    2.762405] sr_init: platform driver register failed for SR
[    2.771246] PM: Hibernation image not present or could not be loaded.
[    2.771287] vbat: disabling
[    2.772157] Freeing unused kernel memory: 464K (c0956000 - c09ca000)
[    2.814348] systemd-udevd[87]: starting version 215
[    2.816366] random: systemd-udevd urandom read with 8 bits of entropy available
[    2.844864] usb 2-1: new high-speed USB device number 2 using musb-hdrc
[    2.997239] usb 2-1: New USB device found, idVendor=2001, idProduct=1a02
[    2.997258] usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    2.997266] usb 2-1: Product: DUB-E100
[    2.997275] usb 2-1: Manufacturer: D-Link          
[    2.997282] usb 2-1: SerialNumber: 6D834B
[    3.364729] EXT4-fs (mmcblk0p1): INFO: recovery required on readonly filesystem
[    3.364746] EXT4-fs (mmcblk0p1): write access will be enabled during recovery
[    3.470757] EXT4-fs (mmcblk0p1): recovery complete
[    3.472052] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
[    3.908874] systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory.
[    4.516353] EXT4-fs (mmcblk0p1): re-mounted. Opts: errors=remount-ro
[    4.536626] systemd-udevd[150]: starting version 215
[    5.269132] systemd-journald[136]: Received request to flush runtime journal from PID 1
[    5.933765] net eth0: initializing cpsw version 1.12 (0)
[    5.937227] net eth0: phy found : id is : 0x7c0f1
[    5.937334] libphy: PHY 4a101000.mdio:01 not found
[    5.942365] net eth0: phy 4a101000.mdio:01 not found on slave 1
[    5.965042] net eth0: BQL enabled
[    5.969172] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[    5.988963] omap-sham 53100000.sham: hw accel on OMAP rev 4.3
[    6.041436] ip_tables: (C) 2000-2006 Netfilter Core Team
[    6.084440] nf_conntrack version 0.5.0 (7909 buckets, 31636 max)
[    6.086489] omap-aes 53500000.aes: OMAP AES hw accel rev: 3.2
[    7.780214] asix 2-1:1.0 eth1: register '
asix' at usb-musb-hdrc.1.auto-1, ASIX AX88772 USB 2.0 Ethernet, c4:a8:1d:6d:83:4b
[    7.781449] usbcore: registered new interface driver asix
[    7.901784] cfg80211: Calling CRDA to update world regulatory domain
[    8.268981] random: nonblocking pool is initialized
[    9.027752] using random self ethernet address
[    9.027772] using random host ethernet address
[    9.027784] using host ethernet address: 78:A5:04:CA:63:28
[    9.027818] using random self ethernet address
[    9.027826] using random host ethernet address
[    9.027837] using host ethernet address: 78:A5:04:CA:63:28
[    9.028599] usb0: HOST MAC 78:a5:04:ca:63:28
[    9.028669] usb0: MAC b2:3e:b3:5d:c1:be
[    9.068803] Number of LUNs=8
[    9.068829] Mass Storage Function, version: 2009/09/11
[    9.068839] LUN: removable file: (no medium)
[    9.068855] Number of LUNs=1
[    9.068982] LUN: removable file: /dev/mmcblk0p1
[    9.068989] Number of LUNs=1
[    9.087245] g_multi gadget: Multifunction Composite Gadget
[    9.087268] g_multi gadget: g_multi ready
[    9.486091] asix 2-1:1.0 eth1: link down
[    9.743591] asix 2-1:1.0 eth1: link up, 100Mbps, full-duplex, lpa 0xCDE1


Syslog output, capturing first 3.18 boot and then the 2nd, unrequested reboot:
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Booting Linux on physical CPU 0x0
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Initializing cgroup subsys cpuset
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Initializing cgroup subsys cpu
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Initializing cgroup subsys cpuacct
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Linux version 3.18.0-rc2-bone1 (root@a5-imx6q-wandboard-2gb) (gcc version 4.9.1 (Debian 4.9.1-16) ) #1 Mon Oct 27 03:41:12 UTC 2014
Oct 31 09:40:30 base-programmer kernel: [    0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=50c5387d
Oct 31 09:40:30 base-programmer kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Machine model: TI AM335x BeagleBone Black
Oct 31 09:40:30 base-programmer kernel: [    0.000000] cma: Reserved 16 MiB at 9e800000
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Memory policy: Data cache writeback
Oct 31 09:40:30 base-programmer kernel: [    0.000000] On node 0 totalpages: 130816
Oct 31 09:40:30 base-programmer kernel: [    0.000000] free_area_init_node: node 0, pgdat c0a5d5b8, node_mem_map dfaf1000
Oct 31 09:40:30 base-programmer kernel: [    0.000000]   Normal zone: 1024 pages used for memmap
Oct 31 09:40:30 base-programmer kernel: [    0.000000]   Normal zone: 0 pages reserved
Oct 31 09:40:30 base-programmer kernel: [    0.000000]   Normal zone: 130816 pages, LIFO batch:31
Oct 31 09:40:30 base-programmer kernel: [    0.000000]   HighMem zone: 1048574 pages exceeds freesize 0
Oct 31 09:40:30 base-programmer kernel: [    0.000000] CPU: All CPU(s) started in SVC mode.
Oct 31 09:40:30 base-programmer kernel: [    0.000000] AM335X ES2.1 (sgx neon )
Oct 31 09:40:30 base-programmer kernel: [    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
Oct 31 09:40:30 base-programmer kernel: [    0.000000] pcpu-alloc: [0] 0
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 129792
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Kernel command line: console=ttyO0,115200n8 root=UUID=47b4fe5e-a89a-4e10-b3b0-1d4050f2d6ad ro rootfstype=ext4 rootwait fixrtc quiet init=/lib/systemd/systemd coherent_pool=2M
Oct 31 09:40:30 base-programmer kernel: [    0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
Oct 31 09:40:30 base-programmer kernel: [    0.000000] allocated 1046528 bytes of page_cgroup
Oct 31 09:40:30 base-programmer kernel: [    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Memory: 485984K/523264K available (6136K kernel code, 700K rwdata, 3388K rodata, 464K init, 863K bss, 37280K reserved, 0K highmem)
Oct 31 09:40:30 base-programmer kernel: [    0.000000] Virtual kernel memory layout:
Oct 31 09:40:30 base-programmer kernel: [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
Oct 31 09:40:30 base-programmer kernel: [    0.000000]     fixmap  : 0xffc00000 - 0xffe00000   (2048 kB)
Oct 31 09:40:30 base-programmer kernel: [    0.000000]     vmalloc : 0xe0800000 - 0xff000000   ( 488 MB)
Oct 31 09:40:30 base-programmer kernel: [    0.000000]     lowmem  : 0xc0000000 - 0xe0000000   ( 512 MB)
Oct 31 09:40:30 base-programmer kernel: [    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
Oct 31 09:40:30 base-programmer kernel: [    0.000000]     modules : 0xbf800000 - 0xbfe00000   (   6 MB)
Oct 31 09:40:30 base-programmer kernel: [    0.000000]       .text : 0xc0008000 - 0xc09552a4   (9525 kB)
Oct 31 09:40:30 base-programmer kernel: [    0.000000]       .init : 0xc0956000 - 0xc09ca000   ( 464 kB)
Oct 31 09:40:30 base-programmer kernel: [    0.000000]       .data : 0xc09ca000 - 0xc0a79348   ( 701 kB)
Oct 31 09:40:30 base-programmer kernel: [    0.000000]        .bss : 0xc0a79348 - 0xc0b50fa4   ( 864 kB)
Oct 31 09:40:30 base-programmer kernel: [    0.000000] NR_IRQS:16 nr_irqs:16 16
Oct 31 09:40:30 base-programmer kernel: [    0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
Oct 31 09:40:30 base-programmer kernel: [    0.000000] OMAP clockevent source: timer2 at 24000000 Hz
Oct 31 09:40:30 base-programmer kernel: [    0.000011] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956969942ns
Oct 31 09:40:30 base-programmer kernel: [    0.000028] OMAP clocksource: timer1 at 24000000 Hz
Oct 31 09:40:30 base-programmer kernel: [    0.000265] Console: colour dummy device 80x30
Oct 31 09:40:30 base-programmer kernel: [    0.000288] Calibrating delay loop... 996.14 BogoMIPS (lpj=4980736)
Oct 31 09:40:30 base-programmer kernel: [    0.088908] pid_max: default: 32768 minimum: 301
Oct 31 09:40:30 base-programmer kernel: [    0.089017] Security Framework initialized
Oct 31 09:40:30 base-programmer kernel: [    0.089085] AppArmor: AppArmor disabled by boot time parameter
Oct 31 09:40:30 base-programmer kernel: [    0.089091] Yama: becoming mindful.
Oct 31 09:40:30 base-programmer kernel: [    0.089267] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
Oct 31 09:40:30 base-programmer kernel: [    0.089279] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
Oct 31 09:40:30 base-programmer kernel: [    0.089871] Initializing cgroup subsys memory
Oct 31 09:40:30 base-programmer kernel: [    0.089905] Initializing cgroup subsys devices
Oct 31 09:40:30 base-programmer kernel: [    0.089920] Initializing cgroup subsys freezer
Oct 31 09:40:30 base-programmer kernel: [    0.089933] Initializing cgroup subsys net_cls
Oct 31 09:40:30 base-programmer kernel: [    0.089950] Initializing cgroup subsys blkio
Oct 31 09:40:30 base-programmer kernel: [    0.089963] Initializing cgroup subsys perf_event
Oct 31 09:40:30 base-programmer kernel: [    0.089974] Initializing cgroup subsys net_prio
Oct 31 09:40:30 base-programmer kernel: [    0.090021] CPU: Testing write buffer coherency: ok
Oct 31 09:40:30 base-programmer kernel: [    0.090062] ftrace: allocating 31261 entries in 62 pages
Oct 31 09:40:30 base-programmer kernel: [    0.155709] Setting up static identity map for 0x805c5b98 - 0x805c5be4
Oct 31 09:40:30 base-programmer kernel: [    0.162272] devtmpfs: initialized
Oct 31 09:40:30 base-programmer kernel: [    0.163169] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
Oct 31 09:40:30 base-programmer kernel: [    0.171487] omap_hwmod: tptc0 using broken dt data from edma
Oct 31 09:40:30 base-programmer kernel: [    0.171580] omap_hwmod: tptc1 using broken dt data from edma
Oct 31 09:40:30 base-programmer kernel: [    0.171657] omap_hwmod: tptc2 using broken dt data from edma
Oct 31 09:40:30 base-programmer kernel: [    0.175804] omap_hwmod: debugss: _wait_target_disable failed
Oct 31 09:40:30 base-programmer kernel: [    0.236728] xor: measuring software checksum speed
Oct 31 09:40:30 base-programmer kernel: [    0.328879]    arm4regs  :  1244.400 MB/sec
Oct 31 09:40:30 base-programmer kernel: [    0.428876]    8regs     :  1113.200 MB/sec
Oct 31 09:40:30 base-programmer kernel: [    0.528874]    32regs    :  1112.400 MB/sec
Oct 31 09:40:30 base-programmer kernel: [    0.628877]    neon      :  1790.800 MB/sec
Oct 31 09:40:30 base-programmer kernel: [    0.628883] xor: using function: neon (1790.800 MB/sec)
Oct 31 09:40:30 base-programmer kernel: [    0.628942] pinctrl core: initialized pinctrl subsystem
Oct 31 09:40:30 base-programmer kernel: [    0.629326] regulator-dummy: no parameters
Oct 31 09:40:30 base-programmer kernel: [    0.645437] NET: Registered protocol family 16
Oct 31 09:40:30 base-programmer kernel: [    0.649310] DMA: preallocated 2048 KiB pool for atomic coherent allocations
Oct 31 09:40:30 base-programmer kernel: [    0.650291] cpuidle: using governor ladder
Oct 31 09:40:30 base-programmer kernel: [    0.650308] cpuidle: using governor menu
Oct 31 09:40:30 base-programmer kernel: [    0.653145] OMAP GPIO hardware version 0.1
Oct 31 09:40:30 base-programmer kernel: [    0.665822] No ATAGs?
Oct 31 09:40:30 base-programmer kernel: [    0.665848] hw-breakpoint: debug architecture 0x4 unsupported.
Oct 31 09:40:30 base-programmer kernel: [    0.839063] raid6: int32x1    270 MB/s
Oct 31 09:40:30 base-programmer kernel: [    1.008912] raid6: int32x2    374 MB/s
Oct 31 09:40:30 base-programmer kernel: [    1.178924] raid6: int32x4    389 MB/s
Oct 31 09:40:30 base-programmer kernel: [    1.348896] raid6: int32x8    358 MB/s
Oct 31 09:40:30 base-programmer kernel: [    1.518881] raid6: neonx1    1449 MB/s
Oct 31 09:40:30 base-programmer kernel: [    1.688886] raid6: neonx2    1886 MB/s
Oct 31 09:40:30 base-programmer kernel: [    1.858894] raid6: neonx4    2010 MB/s
Oct 31 09:40:30 base-programmer kernel: [    2.028895] raid6: neonx8     667 MB/s
Oct 31 09:40:30 base-programmer kernel: [    2.028901] raid6: using algorithm neonx4 (2010 MB/s)
Oct 31 09:40:30 base-programmer kernel: [    2.028906] raid6: using intx1 recovery algorithm
Oct 31 09:40:30 base-programmer kernel: [    2.036727] edma-dma-engine edma-dma-engine.0: TI EDMA DMA engine driver
Oct 31 09:40:30 base-programmer kernel: [    2.037463] vbat: 5000 mV
Oct 31 09:40:30 base-programmer kernel: [    2.037700] vmmcsd_fixed: 3300 mV
Oct 31 09:40:30 base-programmer kernel: [    2.040493] SCSI subsystem initialized
Oct 31 09:40:30 base-programmer kernel: [    2.040747] libata version 3.00 loaded.
Oct 31 09:40:30 base-programmer kernel: [    2.041019] usbcore: registered new interface driver usbfs
Oct 31 09:40:30 base-programmer kernel: [    2.041074] usbcore: registered new interface driver hub
Oct 31 09:40:30 base-programmer kernel: [    2.041136] usbcore: registered new device driver usb
Oct 31 09:40:30 base-programmer kernel: [    2.041655] omap_i2c 44e0b000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c0_pins, deferring probe
Oct 31 09:40:30 base-programmer kernel: [    2.041677] platform 44e0b000.i2c: Driver omap_i2c requests probe deferral
Oct 31 09:40:30 base-programmer kernel: [    2.041700] omap_i2c 4819c000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c2_pins, deferring probe
Oct 31 09:40:30 base-programmer kernel: [    2.041711] platform 4819c000.i2c: Driver omap_i2c requests probe deferral
Oct 31 09:40:30 base-programmer kernel: [    2.041849] media: Linux media interface: v0.10
Oct 31 09:40:30 base-programmer kernel: [    2.041897] Linux video capture interface: v2.00
Oct 31 09:40:30 base-programmer kernel: [    2.041986] pps_core: LinuxPPS API ver. 1 registered
Oct 31 09:40:30 base-programmer kernel: [    2.041993] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giom...@linux.it>
Oct 31 09:40:30 base-programmer kernel: [    2.042018] PTP clock support registered
Oct 31 09:40:30 base-programmer kernel: [    2.042677] omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
Oct 31 09:40:30 base-programmer kernel: [    2.044038] NetLabel: Initializing
Oct 31 09:40:30 base-programmer kernel: [    2.044049] NetLabel:  domain hash size = 128
Oct 31 09:40:30 base-programmer kernel: [    2.044053] NetLabel:  protocols = UNLABELED CIPSOv4
Oct 31 09:40:30 base-programmer kernel: [    2.044111] NetLabel:  unlabeled traffic allowed by default
Oct 31 09:40:30 base-programmer kernel: [    2.044592] Switched to clocksource timer1
Oct 31 09:40:30 base-programmer kernel: [    2.099093] NET: Registered protocol family 2
Oct 31 09:40:30 base-programmer kernel: [    2.099781] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
Oct 31 09:40:30 base-programmer kernel: [    2.099823] TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
Oct 31 09:40:30 base-programmer kernel: [    2.099860] TCP: Hash tables configured (established 4096 bind 4096)
Oct 31 09:40:30 base-programmer kernel: [    2.099916] TCP: reno registered
Oct 31 09:40:30 base-programmer kernel: [    2.099926] UDP hash table entries: 256 (order: 0, 4096 bytes)
Oct 31 09:40:30 base-programmer kernel: [    2.099940] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
Oct 31 09:40:30 base-programmer kernel: [    2.100113] NET: Registered protocol family 1
Oct 31 09:40:30 base-programmer kernel: [    2.100479] RPC: Registered named UNIX socket transport module.
Oct 31 09:40:30 base-programmer kernel: [    2.100490] RPC: Registered udp transport module.
Oct 31 09:40:30 base-programmer kernel: [    2.100495] RPC: Registered tcp transport module.
Oct 31 09:40:30 base-programmer kernel: [    2.100501] RPC: Registered tcp NFSv4.1 backchannel transport module.
Oct 31 09:40:30 base-programmer kernel: [    2.101003] Unpacking initramfs...
Oct 31 09:40:30 base-programmer kernel: [    2.315087] Freeing initrd memory: 3384K (cfcb2000 - d0000000)
Oct 31 09:40:30 base-programmer kernel: [    2.315728] hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available
Oct 31 09:40:30 base-programmer kernel: [    2.318002] futex hash table entries: 256 (order: -1, 3072 bytes)
Oct 31 09:40:30 base-programmer systemd-udevd[150]: Network interface NamePolicy= disabled on kernel commandline, ignoring.
Oct 31 09:40:30 base-programmer systemd-udevd[150]: Network interface NamePolicy= disabled on kernel commandline, ignoring.
Oct 31 09:40:30 base-programmer ntpdate[282]: Can'
t find host 0.debian.pool.ntp.org: Name or service not known (-2)
Oct 31 09:40:30 base-programmer ntpdate[282]: Can't find host 1.debian.pool.ntp.org: Name or service not known (-2)
Oct 31 09:40:30 base-programmer ntpdate[282]: Can'
t find host 2.debian.pool.ntp.org: Name or service not known (-2)
Oct 31 09:40:30 base-programmer ntpdate[282]: Can't find host 3.debian.pool.ntp.org: Name or service not known (-2)
Oct 31 09:40:30 base-programmer kernel: [    2.318104] audit: initializing netlink subsys (disabled)
Oct 31 09:40:30 base-programmer kernel: [    2.318168] audit: type=2000 audit(2.270:1): initialized
Oct 31 09:40:30 base-programmer kernel: [    2.319354] zpool: loaded
Oct 31 09:40:30 base-programmer kernel: [    2.319370] zbud: loaded
Oct 31 09:40:30 base-programmer kernel: [    2.319616] VFS: Disk quotas dquot_6.5.2
Oct 31 09:40:30 base-programmer kernel: [    2.319675] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Oct 31 09:40:30 base-programmer kernel: [    2.320184] NFS: Registering the id_resolver key type
Oct 31 09:40:30 base-programmer kernel: [    2.320233] Key type id_resolver registered
Oct 31 09:40:30 base-programmer kernel: [    2.320239] Key type id_legacy registered
Oct 31 09:40:30 base-programmer kernel: [    2.320262] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Oct 31 09:40:30 base-programmer kernel: [    2.320519] fuse init (API version 7.23)
Oct 31 09:40:30 base-programmer kernel: [    2.320715] SGI XFS with ACLs, security attributes, realtime, no debug enabled
Oct 31 09:40:30 base-programmer kernel: [    2.321232] msgmni has been set to 987
Oct 31 09:40:30 base-programmer kernel: [    2.322197] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Oct 31 09:40:30 base-programmer kernel: [    2.322332] io scheduler noop registered
Oct 31 09:40:30 base-programmer kernel: [    2.322343] io scheduler deadline registered
Oct 31 09:40:30 base-programmer kernel: [    2.322387] io scheduler cfq registered (default)
Oct 31 09:40:30 base-programmer kernel: [    2.323637] pinctrl-single 44e10800.pinmux: 142 pins at pa f9e10800 size 568
Oct 31 09:40:30 base-programmer kernel: [    2.326637] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
Oct 31 09:40:30 base-programmer kernel: [    2.328577] omap_uart 44e09000.serial: no wakeirq for uart0
Oct 31 09:40:30 base-programmer kernel: [    2.328747] omap_uart 44e09000.serial: ttyO0 at MMIO 0x44e09000 (irq = 154, base_baud = 3000000) is a OMAP UART0
Oct 31 09:40:30 base-programmer kernel: [    2.329160] console [ttyO0] enabled
Oct 31 09:40:30 base-programmer kernel: [    2.329588] omap_uart 48022000.serial: no wakeirq for uart0
Oct 31 09:40:30 base-programmer kernel: [    2.329704] omap_uart 48022000.serial: ttyO1 at MMIO 0x48022000 (irq = 155, base_baud = 3000000) is a OMAP UART1
Oct 31 09:40:30 base-programmer kernel: [    2.330052] omap_uart 48024000.serial: no wakeirq for uart0
Oct 31 09:40:30 base-programmer kernel: [    2.330153] omap_uart 48024000.serial: ttyO2 at MMIO 0x48024000 (irq = 156, base_baud = 3000000) is a OMAP UART2
Oct 31 09:40:30 base-programmer kernel: [    2.330489] omap_uart 481a8000.serial: no wakeirq for uart0
Oct 31 09:40:30 base-programmer kernel: [    2.330590] omap_uart 481a8000.serial: ttyO4 at MMIO 0x481a8000 (irq = 157, base_baud = 3000000) is a OMAP UART4
Oct 31 09:40:30 base-programmer kernel: [    2.330921] omap_uart 481aa000.serial: no wakeirq for uart0
Oct 31 09:40:30 base-programmer kernel: [    2.331019] omap_uart 481aa000.serial: ttyO5 at MMIO 0x481aa000 (irq = 158, base_baud = 3000000) is a OMAP UART5
Oct 31 09:40:30 base-programmer kernel: [    2.332487] omap_rng 48310000.rng: OMAP Random Number Generator ver. 20
Oct 31 09:40:30 base-programmer kernel: [    2.332777] [drm] Initialized drm 1.1.0 20060810
Oct 31 09:40:30 base-programmer kernel: [    2.332864] usbcore: registered new interface driver udl
Oct 31 09:40:30 base-programmer kernel: [    2.332883] Error: Driver '
tfp410' is already registered, aborting...
Oct 31 09:40:30 base-programmer kernel: [    2.340007] slave hdmi: could not get i2c
Oct 31 09:40:30 base-programmer kernel: [    2.344240] platform hdmi: Driver slave requests probe deferral
Oct 31 09:40:30 base-programmer kernel: [    2.344487] platform 4830e000.lcdc: Driver tilcdc requests probe deferral
Oct 31 09:40:30 base-programmer kernel: [    2.360029] ehci_hcd: USB 2.0 '
Enhanced' Host Controller (EHCI) Driver
Oct 31 09:40:30 base-programmer kernel: [    2.360059] ehci-platform: EHCI generic platform driver
Oct 31 09:40:30 base-programmer kernel: [    2.360255] ehci-omap: OMAP-EHCI Host Controller driver
Oct 31 09:40:30 base-programmer kernel: [    2.360464] usbcore: registered new interface driver usb-storage
Oct 31 09:40:30 base-programmer kernel: [    2.362170] 47401300.usb-phy supply vcc not found, using dummy regulator
Oct 31 09:40:30 base-programmer kernel: [    2.364469] musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, bulk combine, bulk split, HB-ISO Rx, HB-ISO Tx, SoftConn)
Oct 31 09:40:30 base-programmer kernel: [    2.364484] musb-hdrc: MHDRC RTL version 2.0
Oct 31 09:40:30 base-programmer kernel: [    2.364491] musb-hdrc: setup fifo_mode 4
Oct 31 09:40:30 base-programmer kernel: [    2.364507] musb-hdrc: 28/31 max ep, 16384/16384 memory
Oct 31 09:40:30 base-programmer kernel: [    2.364695] musb-hdrc musb-hdrc.0.auto: MUSB HDRC host driver
Oct 31 09:40:30 base-programmer kernel: [    2.364958] musb-hdrc musb-hdrc.0.auto: new USB bus registered, assigned bus number 1
Oct 31 09:40:30 base-programmer kernel: [    2.365128] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Oct 31 09:40:30 base-programmer kernel: [    2.365139] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 31 09:40:30 base-programmer kernel: [    2.365147] usb usb1: Product: MUSB HDRC host driver
Oct 31 09:40:30 base-programmer kernel: [    2.365155] usb usb1: Manufacturer: Linux 3.18.0-rc2-bone1 musb-hcd
Oct 31 09:40:30 base-programmer kernel: [    2.365163] usb usb1: SerialNumber: musb-hdrc.0.auto
Oct 31 09:40:30 base-programmer kernel: [    2.365841] hub 1-0:1.0: USB hub found
Oct 31 09:40:30 base-programmer kernel: [    2.365881] hub 1-0:1.0: 1 port detected
Oct 31 09:40:30 base-programmer kernel: [    2.367220] 47401b00.usb-phy supply vcc not found, using dummy regulator
Oct 31 09:40:30 base-programmer kernel: [    2.369443] musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, bulk combine, bulk split, HB-ISO Rx, HB-ISO Tx, SoftConn)
Oct 31 09:40:30 base-programmer kernel: [    2.369456] musb-hdrc: MHDRC RTL version 2.0
Oct 31 09:40:30 base-programmer kernel: [    2.369464] musb-hdrc: setup fifo_mode 4
Oct 31 09:40:30 base-programmer kernel: [    2.369475] musb-hdrc: 28/31 max ep, 16384/16384 memory
Oct 31 09:40:30 base-programmer kernel: [    2.369573] musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver
Oct 31 09:40:30 base-programmer kernel: [    2.369830] musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 2
Oct 31 09:40:30 base-programmer kernel: [    2.369983] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002
Oct 31 09:40:30 base-programmer kernel: [    2.369994] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 31 09:40:30 base-programmer kernel: [    2.370002] usb usb2: Product: MUSB HDRC host driver
Oct 31 09:40:30 base-programmer kernel: [    2.370010] usb usb2: Manufacturer: Linux 3.18.0-rc2-bone1 musb-hcd
Oct 31 09:40:30 base-programmer kernel: [    2.370017] usb usb2: SerialNumber: musb-hdrc.1.auto
Oct 31 09:40:30 base-programmer kernel: [    2.370640] hub 2-0:1.0: USB hub found
Oct 31 09:40:30 base-programmer kernel: [    2.370677] hub 2-0:1.0: 1 port detected
Oct 31 09:40:30 base-programmer kernel: [    2.379092] mousedev: PS/2 mouse device common for all mice
Oct 31 09:40:30 base-programmer kernel: [    2.380264] omap_rtc 44e3e000.rtc: already running
Oct 31 09:40:30 base-programmer kernel: [    2.380624] omap_rtc 44e3e000.rtc: rtc core: registered 44e3e000.rtc as rtc0
Oct 31 09:40:30 base-programmer kernel: [    2.380820] i2c /dev entries driver
Oct 31 09:40:30 base-programmer kernel: [    2.380945] IR XMP protocol handler initialized
Oct 31 09:40:30 base-programmer kernel: [    2.382467] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
Oct 31 09:40:30 base-programmer kernel: [    2.382924] sdhci: Secure Digital Host Controller Interface driver
Oct 31 09:40:30 base-programmer kernel: [    2.382931] sdhci: Copyright(c) Pierre Ossman
Oct 31 09:40:30 base-programmer kernel: [    2.474953] sdhci-pltfm: SDHCI platform and OF driver helper
Oct 31 09:40:30 base-programmer kernel: [    2.476294] ledtrig-cpu: registered to indicate activity on CPUs
Oct 31 09:40:30 base-programmer kernel: [    2.476390] hidraw: raw HID events driver (C) Jiri Kosina
Oct 31 09:40:30 base-programmer kernel: [    2.478403] usbcore: registered new interface driver usbhid
Oct 31 09:40:30 base-programmer kernel: [    2.478413] usbhid: USB HID core driver
Oct 31 09:40:30 base-programmer kernel: [    2.481030] ashmem: initialized
Oct 31 09:40:30 base-programmer kernel: [    2.482191] oprofile: using arm/armv7
Oct 31 09:40:30 base-programmer kernel: [    2.482466] TCP: cubic registered
Oct 31 09:40:30 base-programmer kernel: [    2.482558] NET: Registered protocol family 10
Oct 31 09:40:30 base-programmer kernel: [    2.483476] mip6: Mobile IPv6
Oct 31 09:40:30 base-programmer kernel: [    2.483498] NET: Registered protocol family 17
Oct 31 09:40:30 base-programmer kernel: [    2.483598] Key type dns_resolver registered
Oct 31 09:40:30 base-programmer kernel: [    2.483609] mpls_gso: MPLS GSO support
Oct 31 09:40:30 base-programmer kernel: [    2.483905] omap_voltage_late_init: Voltage driver support not added
Oct 31 09:40:30 base-programmer kernel: [    2.490690] sr_dev_init: No voltage domain specified for smartreflex0. Cannot initialize
Oct 31 09:40:30 base-programmer kernel: [    2.499237] sr_dev_init: No voltage domain specified for smartreflex1. Cannot initialize
Oct 31 09:40:30 base-programmer kernel: [    2.508373] platform cpufreq-dt.0: Driver cpufreq-dt requests probe deferral
Oct 31 09:40:30 base-programmer kernel: [    2.508619] ThumbEE CPU extension supported.
Oct 31 09:40:30 base-programmer kernel: [    2.508659] Registering SWP/SWPB emulation handler
Oct 31 09:40:30 base-programmer kernel: [    2.508678] SmartReflex Class3 initialized
Oct 31 09:40:30 base-programmer kernel: [    2.512471] registered taskstats version 1
Oct 31 09:40:30 base-programmer kernel: [    2.513290] Btrfs loaded
Oct 31 09:40:30 base-programmer kernel: [    2.520526] input: tps65217_pwr_but as /devices/ocp/44e0b000.i2c/i2c-0/0-0024/input/input0
Oct 31 09:40:30 base-programmer kernel: [    2.521882] vdd_ddr3: 1350 mV
Oct 31 09:40:30 base-programmer kernel: [    2.522680] vdd_mpu: 925 <--> 1325 mV at 1325 mV
Oct 31 09:40:30 base-programmer kernel: [    2.523438] vdd_core: 925 <--> 1150 mV at 1125 mV
Oct 31 09:40:30 base-programmer kernel: [    2.524172] vio,vrtc,vdds: at 1800 mV
Oct 31 09:40:30 base-programmer kernel: [    2.524986] vdd_3v3aux: at 3300 mV
Oct 31 09:40:30 base-programmer kernel: [    2.525757] vdd_1v8: 1800 mV
Oct 31 09:40:30 base-programmer kernel: [    2.526514] vdd_3v3a: at 3300 mV
Oct 31 09:40:30 base-programmer kernel: [    2.527350] tps65217 0-0024: TPS65217 ID 0xe version 1.2
Oct 31 09:40:30 base-programmer kernel: [    2.531729] at24 0-0050: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
Oct 31 09:40:30 base-programmer kernel: [    2.531775] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
Oct 31 09:40:30 base-programmer kernel: [    2.537482] at24 2-0054: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
Oct 31 09:40:30 base-programmer kernel: [    2.538282] mmc1: BKOPS_EN bit is not set
Oct 31 09:40:30 base-programmer kernel: [    2.542333] at24 2-0055: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
Oct 31 09:40:30 base-programmer kernel: [    2.543240] mmc1: new high speed MMC card at address 0001
Oct 31 09:40:30 base-programmer kernel: [    2.547369] at24 2-0056: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
Oct 31 09:40:30 base-programmer kernel: [    2.547569] mmcblk0: mmc1:0001 MMC04G 3.60 GiB
Oct 31 09:40:30 base-programmer kernel: [    2.547802] mmcblk0boot0: mmc1:0001 MMC04G partition 1 2.00 MiB
Oct 31 09:40:30 base-programmer kernel: [    2.548005] mmcblk0boot1: mmc1:0001 MMC04G partition 2 2.00 MiB
Oct 31 09:40:30 base-programmer kernel: [    2.549016]  mmcblk0: p1
Oct 31 09:40:30 base-programmer kernel: [    2.554480] at24 2-0057: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
Oct 31 09:40:30 base-programmer kernel: [    2.554526] omap_i2c 4819c000.i2c: bus 2 rev0.11 at 100 kHz
Oct 31 09:40:30 base-programmer kernel: [    2.676862] tda998x 0-0070: found TDA19988
Oct 31 09:40:30 base-programmer kernel: [    2.677813] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
Oct 31 09:40:30 base-programmer kernel: [    2.677821] [drm] No driver support for vblank timestamp query.
Oct 31 09:40:30 base-programmer kernel: [    2.678240] tilcdc 4830e000.lcdc: No connectors reported connected with modes
Oct 31 09:40:30 base-programmer kernel: [    2.678259] [drm] Cannot find any crtc or sizes - going 1024x768
Oct 31 09:40:30 base-programmer kernel: [    2.690868] Console: switching to colour frame buffer device 128x48
Oct 31 09:40:30 base-programmer kernel: [    2.696305] tilcdc 4830e000.lcdc: fb0:  frame buffer device
Oct 31 09:40:30 base-programmer kernel: [    2.696313] tilcdc 4830e000.lcdc: registered panic notifier
Oct 31 09:40:30 base-programmer kernel: [    2.696332] [drm] Initialized tilcdc 1.0.0 20121205 on minor 0
Oct 31 09:40:30 base-programmer kernel: [    2.754620] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
Oct 31 09:40:30 base-programmer kernel: [    2.754638] davinci_mdio 4a101000.mdio: detected phy mask fffffffe
Oct 31 09:40:30 base-programmer kernel: [    2.760122] libphy: 4a101000.mdio: probed
Oct 31 09:40:30 base-programmer kernel: [    2.760151] davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver SMSC LAN8710/LAN8720
Oct 31 09:40:30 base-programmer kernel: [    2.761034] cpsw 4a100000.ethernet: Detected MACID = 78:a5:04:ca:63:26
Oct 31 09:40:30 base-programmer kernel: [    2.762164] omap_rtc 44e3e000.rtc: setting system clock to 2014-10-31 09:40:25 UTC (1414748425)
Oct 31 09:40:30 base-programmer kernel: [    2.762184] sr_init: No PMIC hook to init smartreflex
Oct 31 09:40:30 base-programmer kernel: [    2.762361] sr_init: platform driver register failed for SR
Oct 31 09:40:30 base-programmer kernel: [    2.771211] PM: Hibernation image not present or could not be loaded.
Oct 31 09:40:30 base-programmer kernel: [    2.771252] vbat: disabling
Oct 31 09:40:30 base-programmer kernel: [    2.772121] Freeing unused kernel memory: 464K (c0956000 - c09ca000)
Oct 31 09:40:30 base-programmer kernel: [    2.816482] random: systemd-udevd urandom read with 8 bits of entropy available
Oct 31 09:40:30 base-programmer kernel: [    2.844827] usb 2-1: new high-speed USB device number 2 using musb-hdrc
Oct 31 09:40:30 base-programmer kernel: [    2.997139] usb 2-1: New USB device found, idVendor=2001, idProduct=1a02
Oct 31 09:40:30 base-programmer kernel: [    2.997158] usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Oct 31 09:40:30 base-programmer kernel: [    2.997167] usb 2-1: Product: DUB-E100
Oct 31 09:40:30 base-programmer kernel: [    2.997175] usb 2-1: Manufacturer: D-Link          
Oct 31 09:40:30 base-programmer kernel: [    2.997182] usb 2-1: SerialNumber: 6D834B
Oct 31 09:40:30 base-programmer kernel: [    3.374582] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
Oct 31 09:40:30 base-programmer kernel: [    4.452120] EXT4-fs (mmcblk0p1): re-mounted. Opts: errors=remount-ro
Oct 31 09:40:30 base-programmer kernel: [    5.903224] net eth0: initializing cpsw version 1.12 (0)
Oct 31 09:40:30 base-programmer kernel: [    5.908341] net eth0: phy found : id is : 0x7c0f1
Oct 31 09:40:30 base-programmer kernel: [    5.908454] libphy: PHY 4a101000.mdio:01 not found
Oct 31 09:40:30 base-programmer kernel: [    5.913485] net eth0: phy 4a101000.mdio:01 not found on slave 1
Oct 31 09:40:30 base-programmer kernel: [    5.934270] net eth0: BQL enabled
Oct 31 09:40:30 base-programmer kernel: [    5.943112] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Oct 31 09:40:30 base-programmer kernel: [    5.969606] omap-sham 53100000.sham: hw accel on OMAP rev 4.3
Oct 31 09:40:30 base-programmer kernel: [    6.010577] ip_tables: (C) 2000-2006 Netfilter Core Team
Oct 31 09:40:30 base-programmer kernel: [    6.045651] omap-aes 53500000.aes: OMAP AES hw accel rev: 3.2
Oct 31 09:40:30 base-programmer kernel: [    6.050590] nf_conntrack version 0.5.0 (7909 buckets, 31636 max)
Oct 31 09:40:30 base-programmer kernel: [    7.723806] random: nonblocking pool is initialized
Oct 31 09:40:30 base-programmer kernel: [    7.742643] asix 2-1:1.0 eth1: register '
asix' at usb-musb-hdrc.1.auto-1, ASIX AX88772 USB 2.0 Ethernet, c4:a8:1d:6d:83:4b
Oct 31 09:40:30 base-programmer kernel: [    7.743330] cfg80211: Calling CRDA to update world regulatory domain
Oct 31 09:40:30 base-programmer kernel: [    7.746297] usbcore: registered new interface driver asix
Oct 31 09:40:30 base-programmer dnsmasq[359]: started, version 2.72 cachesize 150
Oct 31 09:40:30 base-programmer dnsmasq[359]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect
Oct 31 09:40:30 base-programmer dnsmasq[359]: DBus support enabled: connected to system bus
Oct 31 09:40:30 base-programmer dnsmasq-dhcp[359]: DHCP, IP range 192.168.0.50 -- 192.168.0.150, lease time 12h
Oct 31 09:40:30 base-programmer dnsmasq[359]: reading /etc/resolv.conf
Oct 31 09:40:30 base-programmer dnsmasq[359]: using nameserver 192.168.1.2#53
Oct 31 09:40:30 base-programmer dnsmasq[359]: read /etc/hosts - 2 addresses
Oct 31 09:40:30 base-programmer kernel: [    8.173083] using random self ethernet address
Oct 31 09:40:30 base-programmer kernel: [    8.173105] using random host ethernet address
Oct 31 09:40:30 base-programmer kernel: [    8.173118] using host ethernet address: 78:A5:04:CA:63:28
Oct 31 09:40:30 base-programmer kernel: [    8.173141] using random self ethernet address
Oct 31 09:40:30 base-programmer kernel: [    8.173150] using random host ethernet address
Oct 31 09:40:30 base-programmer kernel: [    8.173160] using host ethernet address: 78:A5:04:CA:63:28
Oct 31 09:40:30 base-programmer kernel: [    8.173895] usb0: HOST MAC 78:a5:04:ca:63:28
Oct 31 09:40:30 base-programmer kernel: [    8.173957] usb0: MAC c2:14:81:c3:27:77
Oct 31 09:40:30 base-programmer kernel: [    8.201371] Number of LUNs=8
Oct 31 09:40:30 base-programmer kernel: [    8.201395] Mass Storage Function, version: 2009/09/11
Oct 31 09:40:30 base-programmer kernel: [    8.201405] LUN: removable file: (no medium)
Oct 31 09:40:30 base-programmer kernel: [    8.201421] Number of LUNs=1
Oct 31 09:40:30 base-programmer kernel: [    8.201547] LUN: removable file: /dev/mmcblk0p1
Oct 31 09:40:30 base-programmer kernel: [    8.201554] Number of LUNs=1
Oct 31 09:40:30 base-programmer kernel: [    8.209463] g_multi gadget: Multifunction Composite Gadget
Oct 31 09:40:30 base-programmer kernel: [    8.209484] g_multi gadget: g_multi ready
Oct 31 09:40:31 base-programmer polkitd[413]: started daemon version 0.105 using authority implementation `local'
version `0.105'
Oct 31 09:40:31 base-programmer dbus[328]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> init!
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> update_system_hostname
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info>       interface-parser: parsing file /etc/network/interfaces
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info>       interface-parser: finished parsing file /etc/network/interfaces
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> guessed connection type (eth0) = 802-3-ethernet
Oct 31 09:40:31 base-programmer NetworkManager[319]: Libgcrypt warning: missing initialization - please fix the application
Oct 31 09:40:31 base-programmer ntpd[434]: ntpd 4.2...@1.2349-o Wed Jul 23 19:53:33 UTC 2014 (1)
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> update_connection_setting_from_if_block: name:eth0, type:802-3-ethernet, id:Ifupdown (eth0), uuid: 681b428f-beaf-8932-dce4-687ed5bae28e
Oct 31 09:40:31 base-programmer ntpd[439]: proto: precision = 1.041 usec
Oct 31 09:40:31 base-programmer ntpd[439]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> addresses count: 1
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> No dns-nameserver configured in /etc/network/interfaces
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> adding eth0 to connections
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> adding iface eth0 to eni_ifaces
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> autoconnect
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> management mode: unmanaged
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> devices added (path: /sys/devices/ocp/47400000.usb/47401400.usb/musb-hdrc.0.auto/gadget/net/usb0, iface: usb0)
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> device added (path: /sys/devices/ocp/47400000.usb/47401400.usb/musb-hdrc.0.auto/gadget/net/usb0, iface: usb0): no ifupdown configuration found.
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> devices added (path: /sys/devices/ocp/47400000.usb/47401c00.usb/musb-hdrc.1.auto/usb2/2-1/2-1:1.0/net/eth1, iface: eth1)
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> device added (path: /sys/devices/ocp/47400000.usb/47401c00.usb/musb-hdrc.1.auto/usb2/2-1/2-1:1.0/net/eth1, iface: eth1): no ifupdown configuration found.
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> devices added (path: /sys/devices/ocp/4a100000.ethernet/net/eth0, iface: eth0)
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> locking wired connection setting
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> devices added (path: /sys/devices/virtual/net/lo, iface: lo)
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found.
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> end _init.
Oct 31 09:40:31 base-programmer ntpd[439]: Listen and drop on 1 v6wildcard :: UDP 123
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> Loaded plugin ifupdown: (C) 2008 Canonical Ltd.  To report bugs please use the NetworkManager mailing list.
Oct 31 09:40:31 base-programmer ntpd[439]: Listen normally on 2 lo 127.0.0.1 UDP 123
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> Loaded plugin keyfile: (c) 2007 - 2013 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
Oct 31 09:40:31 base-programmer ntpd[439]: Listen normally on 3 eth0 192.168.0.1 UDP 123
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> (7430224) ... get_connections.
Oct 31 09:40:31 base-programmer ntpd[439]: Listen normally on 4 lo ::1 UDP 123
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> (7430224) ... get_connections (managed=false): return empty list.
Oct 31 09:40:31 base-programmer ntpd[439]: peers refreshed
Oct 31 09:40:31 base-programmer ntpd[439]: Listening on routing socket on fd #21 for interface updates
Oct 31 09:40:31 base-programmer ntpd[439]: Deferring DNS for 0.debian.pool.ntp.org 1
Oct 31 09:40:31 base-programmer ntpd[439]: Deferring DNS for 1.debian.pool.ntp.org 1
Oct 31 09:40:31 base-programmer ntpd[439]: Deferring DNS for 2.debian.pool.ntp.org 1
Oct 31 09:40:31 base-programmer ntpd[439]: Deferring DNS for 3.debian.pool.ntp.org 1
Oct 31 09:40:31 base-programmer ntpd[448]: signal_no_reset: signal 17 had flags 4000000
Oct 31 09:40:31 base-programmer ntp[418]: Starting NTP server: ntpd.
Oct 31 09:40:31 base-programmer loadcpufreq[414]: Loading cpufreq kernel modules...done (none).
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> new connection /etc/NetworkManager/system-connections/awthcb
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> get unmanaged devices count: 1
Oct 31 09:40:31 base-programmer cpufrequtils[458]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...done.
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> monitoring kernel firmware directory '/lib/firmware'.
Oct 31 09:40:31 base-programmer NetworkManager[319]: <info> monitoring ifupdown state file '/run/network/ifstate'.
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> WiFi hardware radio set enabled
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> WWAN hardware radio set enabled
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-wwan.so
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-bluetooth.so
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-wifi.so
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-adsl.so
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> WiFi enabled by radio killswitch; enabled by state file
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> WWAN enabled by radio killswitch; enabled by state file
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> WiMAX enabled by radio killswitch; enabled by state file
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Networking is enabled by state file
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (lo): link connected
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (lo): carrier is ON
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (lo): new Generic device (driver: 'unknown' ifindex: 1)
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (lo): exported as /org/freedesktop/NetworkManager/Devices/0
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth0): carrier is OFF
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth0): new Ethernet device (driver: 'cpsw' ifindex: 2)
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/1
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> startup complete
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> NetworkManager state is now CONNECTED_GLOBAL
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): carrier is OFF
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): new Ethernet device (driver: 'asix' ifindex: 3)
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): exported as /org/freedesktop/NetworkManager/Devices/2
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Oct 31 09:40:32 base-programmer kernel: [    9.493997] asix 2-1:1.0 eth1: link up, 100Mbps, full-duplex, lpa 0xCDE1
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): preparing device
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): created default wired connection 'Wired connection 1'
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (usb0): carrier is OFF
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (usb0): new Ethernet device (driver: 'musb-hdrc' ifindex: 4)
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (usb0): exported as /org/freedesktop/NetworkManager/Devices/3
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (usb0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (usb0): preparing device
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (usb0): created default wired connection 'Wired connection 2'
Oct 31 09:40:32 base-programmer kernel: [    9.624432] asix 2-1:1.0 eth1: link up, 100Mbps, full-duplex, lpa 0xCDE1
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): link connected
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): device state change: unavailable -> disconnected (reason 'carrier-changed') [20 30 40]
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Auto-activating connection 'Wired connection 1'.
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> ModemManager available in the bus
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) starting connection 'Wired connection 1'
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) scheduled...
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) started...
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 2 of 5 (Device Configure) scheduled...
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) complete.
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 2 of 5 (Device Configure) starting...
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): device state change: prepare -> config (reason 'none') [40 50 0]
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 2 of 5 (Device Configure) successful.
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) scheduled.
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 2 of 5 (Device Configure) complete.
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) started...
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): device state change: config -> ip-config (reason 'none') [50 70 0]
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Beginning DHCPv4 transaction (timeout in 45 seconds)
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> dhclient started with pid 490
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) complete.
Oct 31 09:40:32 base-programmer dhclient: Internet Systems Consortium DHCP Client 4.3.1
Oct 31 09:40:32 base-programmer NetworkManager[319]: Internet Systems Consortium DHCP Client 4.3.1
Oct 31 09:40:32 base-programmer dhclient: Copyright 2004-2014 Internet Systems Consortium.
Oct 31 09:40:32 base-programmer dhclient: All rights reserved.
Oct 31 09:40:32 base-programmer dhclient: For info, please visit https://www.isc.org/software/dhcp/
Oct 31 09:40:32 base-programmer dhclient:
Oct 31 09:40:32 base-programmer NetworkManager[319]: Copyright 2004-2014 Internet Systems Consortium.
Oct 31 09:40:32 base-programmer NetworkManager[319]: All rights reserved.
Oct 31 09:40:32 base-programmer NetworkManager[319]: For info, please visit https://www.isc.org/software/dhcp/
Oct 31 09:40:32 base-programmer dhclient: Listening on LPF/eth1/c4:a8:1d:6d:83:4b
Oct 31 09:40:32 base-programmer NetworkManager[319]: Listening on LPF/eth1/c4:a8:1d:6d:83:4b
Oct 31 09:40:32 base-programmer dhclient: Sending on   LPF/eth1/c4:a8:1d:6d:83:4b
Oct 31 09:40:32 base-programmer dhclient: Sending on   Socket/fallback
Oct 31 09:40:32 base-programmer dhclient: DHCPDISCOVER on eth1 to 255.255.255.255 port 67 interval 3
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): DHCPv4 state changed nbi -> preinit
Oct 31 09:40:32 base-programmer dhclient: DHCPREQUEST on eth1 to 255.255.255.255 port 67
Oct 31 09:40:32 base-programmer dhclient: DHCPOFFER from 192.168.1.2
Oct 31 09:40:32 base-programmer NetworkManager[319]: Sending on   LPF/eth1/c4:a8:1d:6d:83:4b
Oct 31 09:40:32 base-programmer NetworkManager[319]: Sending on   Socket/fallback
Oct 31 09:40:32 base-programmer NetworkManager[319]: DHCPDISCOVER on eth1 to 255.255.255.255 port 67 interval 3
Oct 31 09:40:32 base-programmer NetworkManager[319]: DHCPREQUEST on eth1 to 255.255.255.255 port 67
Oct 31 09:40:32 base-programmer NetworkManager[319]: DHCPOFFER from 192.168.1.2
Oct 31 09:40:32 base-programmer dhclient: DHCPACK from 192.168.1.2
Oct 31 09:40:32 base-programmer NetworkManager[319]: DHCPACK from 192.168.1.2
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): DHCPv4 state changed preinit -> bound
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info>   address 192.168.1.182
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info>   plen 24 (255.255.255.0)
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info>   classless static route 10.8.0.0/24 gw 192.168.1.98
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info>   gateway 192.168.1.1
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info>   server identifier 192.168.1.2
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info>   lease time 86400
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info>   hostname 'base-programmer'
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info>   nameserver '192.168.1.2'
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info>   domain name 'scypho.com'
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Oct 31 09:40:32 base-programmer dhclient: bound to 192.168.1.182 -- renewal in 41209 seconds.
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 5 of 5 (IPv4 Commit) started...
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
Oct 31 09:40:32 base-programmer NetworkManager[319]: bound to 192.168.1.182 -- renewal in 41209 seconds.
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 5 of 5 (IPv4 Commit) complete.
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> (eth1): device state change: secondaries -> activated (reason 'none') [90 100 0]
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Policy set 'Wired connection 1' (eth1) as default for IPv4 routing and DNS.
Oct 31 09:40:32 base-programmer NetworkManager[319]: <info> Activation (eth1) successful, device activated.
Oct 31 09:40:32 base-programmer dbus[328]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
Oct 31 09:40:32 base-programmer dbus[328]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Oct 31 09:40:32 base-programmer nm-dispatcher: Dispatching action 'up' for eth1
Oct 31 09:40:33 base-programmer ntpdate[513]: the NTP socket is in use, exiting
Oct 31 09:40:33 base-programmer ntpd_intres[448]: DNS 0.debian.pool.ntp.org -> 81.170.151.240
Oct 31 09:40:33 base-programmer ntpd_intres[448]: DNS 1.debian.pool.ntp.org -> 217.75.106.216
Oct 31 09:40:33 base-programmer ntpd_intres[448]: DNS 2.debian.pool.ntp.org -> 94.245.35.13
Oct 31 09:40:33 base-programmer ntpd_intres[448]: DNS 3.debian.pool.ntp.org -> 195.178.181.98
Oct 31 09:40:33 base-programmer ModemManager[315]: <warn>  Couldn't find support for device at '/sys/devices/ocp/47400000.usb/47401c00.usb/musb-hdrc.1.auto/usb2/2-1': not supported by any plugin
Oct 31 09:40:35 base-programmer ntpd[439]: Listen normally on 5 eth1 192.168.1.182 UDP 123
Oct 31 09:40:35 base-programmer ntpd[439]: Listen normally on 6 eth1 fe80::c6a8:1dff:fe6d:834b UDP 123
Oct 31 09:40:35 base-programmer ntpd[439]: 94.245.35.13 interface 192.168.0.1 -> 192.168.1.182
Oct 31 09:40:35 base-programmer ntpd[439]: 217.75.106.216 interface 192.168.0.1 -> 192.168.1.182
Oct 31 09:40:35 base-programmer ntpd[439]: 195.178.181.98 interface 192.168.0.1 -> 192.168.1.182
Oct 31 09:40:35 base-programmer ntpd[439]: 81.170.151.240 interface 192.168.0.1 -> 192.168.1.182
Oct 31 09:40:35 base-programmer ntpd[439]: peers refreshed
Oct 31 09:41:29 base-programmer dnsmasq[359]: reading /etc/resolv.conf
Oct 31 09:41:29 base-programmer dnsmasq[359]: using nameserver 192.168.1.2#53
Oct 31 09:47:15 base-programmer systemd[551]: Starting Paths.
Oct 31 09:47:15 base-programmer systemd[551]: Reached target Paths.
Oct 31 09:47:15 base-programmer systemd[551]: Starting Timers.
Oct 31 09:47:15 base-programmer systemd[551]: Reached target Timers.
Oct 31 09:47:15 base-programmer systemd[551]: Starting Sockets.
Oct 31 09:47:15 base-programmer systemd[551]: Reached target Sockets.
Oct 31 09:47:15 base-programmer systemd[551]: Starting Basic System.
Oct 31 09:47:15 base-programmer systemd[551]: Reached target Basic System.
Oct 31 09:47:15 base-programmer systemd[551]: Starting Default.
Oct 31 09:47:15 base-programmer systemd[551]: Reached target Default.
Oct 31 09:47:15 base-programmer systemd[551]: Startup finished in 38ms.
Oct 31 10:17:01 base-programmer /USR/SBIN/CRON[571]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Oct 31 11:17:01 base-programmer /USR/SBIN/CRON[587]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Oct 16 12:20:00 base-programmer rsyslogd: [origin software="rsyslogd" swVersion="8.4.2" x-pid="360" x-info="http://www.rsyslog.com"] start
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Booting Linux on physical CPU 0x0
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Initializing cgroup subsys cpuset
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Initializing cgroup subsys cpu
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Initializing cgroup subsys cpuacct
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Linux version 3.18.0-rc2-bone1 (root@a5-imx6q-wandboard-2gb) (gcc version 4.9.1 (Debian 4.9.1-16) ) #1 Mon Oct 27 03:41:12 UTC 2014
Oct 16 12:20:00 base-programmer kernel: [    0.000000] CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=50c5387d
Oct 16 12:20:00 base-programmer kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Machine model: TI AM335x BeagleBone Black
Oct 16 12:20:00 base-programmer kernel: [    0.000000] cma: Reserved 16 MiB at 9e800000
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Memory policy: Data cache writeback
Oct 16 12:20:00 base-programmer kernel: [    0.000000] On node 0 totalpages: 130816
Oct 16 12:20:00 base-programmer kernel: [    0.000000] free_area_init_node: node 0, pgdat c0a5d5b8, node_mem_map dfaf1000
Oct 16 12:20:00 base-programmer kernel: [    0.000000]   Normal zone: 1024 pages used for memmap
Oct 16 12:20:00 base-programmer kernel: [    0.000000]   Normal zone: 0 pages reserved
Oct 16 12:20:00 base-programmer kernel: [    0.000000]   Normal zone: 130816 pages, LIFO batch:31
Oct 16 12:20:00 base-programmer kernel: [    0.000000]   HighMem zone: 1048574 pages exceeds freesize 0
Oct 16 12:20:00 base-programmer kernel: [    0.000000] CPU: All CPU(s) started in SVC mode.
Oct 16 12:20:00 base-programmer kernel: [    0.000000] AM335X ES2.1 (sgx neon )
Oct 16 12:20:00 base-programmer kernel: [    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
Oct 16 12:20:00 base-programmer kernel: [    0.000000] pcpu-alloc: [0] 0
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 129792
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Kernel command line: console=ttyO0,115200n8 root=UUID=47b4fe5e-a89a-4e10-b3b0-1d4050f2d6ad ro rootfstype=ext4 rootwait fixrtc quiet init=/lib/systemd/systemd coherent_pool=2M
Oct 16 12:20:00 base-programmer kernel: [    0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
Oct 16 12:20:00 base-programmer kernel: [    0.000000] allocated 1046528 bytes of page_cgroup
Oct 16 12:20:00 base-programmer kernel: [    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Memory: 485984K/523264K available (6136K kernel code, 700K rwdata, 3388K rodata, 464K init, 863K bss, 37280K reserved, 0K highmem)
Oct 16 12:20:00 base-programmer kernel: [    0.000000] Virtual kernel memory layout:
Oct 16 12:20:00 base-programmer kernel: [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
Oct 16 12:20:00 base-programmer kernel: [    0.000000]     fixmap  : 0xffc00000 - 0xffe00000   (2048 kB)
Oct 16 12:20:00 base-programmer kernel: [    0.000000]     vmalloc : 0xe0800000 - 0xff000000   ( 488 MB)
Oct 16 12:20:00 base-programmer kernel: [    0.000000]     lowmem  : 0xc0000000 - 0xe0000000   ( 512 MB)
Oct 16 12:20:00 base-programmer kernel: [    0.000000]     pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
Oct 16 12:20:00 base-programmer kernel: [    0.000000]     modules : 0xbf800000 - 0xbfe00000   (   6 MB)
Oct 16 12:20:00 base-programmer kernel: [    0.000000]       .text : 0xc0008000 - 0xc09552a4   (9525 kB)
Oct 16 12:20:00 base-programmer kernel: [    0.000000]       .init : 0xc0956000 - 0xc09ca000   ( 464 kB)
Oct 16 12:20:00 base-programmer kernel: [    0.000000]       .data : 0xc09ca000 - 0xc0a79348   ( 701 kB)
Oct 16 12:20:00 base-programmer kernel: [    0.000000]        .bss : 0xc0a79348 - 0xc0b50fa4   ( 864 kB)
Oct 16 12:20:00 base-programmer kernel: [    0.000000] NR_IRQS:16 nr_irqs:16 16
Oct 16 12:20:00 base-programmer kernel: [    0.000000] IRQ: Found an INTC at 0xfa200000 (revision 5.0) with 128 interrupts
Oct 16 12:20:00 base-programmer kernel: [    0.000000] OMAP clockevent source: timer2 at 24000000 Hz
Oct 16 12:20:00 base-programmer kernel: [    0.000012] sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956969942ns
Oct 16 12:20:00 base-programmer kernel: [    0.000029] OMAP clocksource: timer1 at 24000000 Hz
Oct 16 12:20:00 base-programmer kernel: [    0.000261] Console: colour dummy device 80x30
Oct 16 12:20:00 base-programmer kernel: [    0.000287] Calibrating delay loop... 996.14 BogoMIPS (lpj=4980736)
Oct 16 12:20:00 base-programmer kernel: [    0.088918] pid_max: default: 32768 minimum: 301
Oct 16 12:20:00 base-programmer kernel: [    0.089026] Security Framework initialized
Oct 16 12:20:00 base-programmer kernel: [    0.089094] AppArmor: AppArmor disabled by boot time parameter
Oct 16 12:20:00 base-programmer kernel: [    0.089102] Yama: becoming mindful.
Oct 16 12:20:00 base-programmer kernel: [    0.089277] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
Oct 16 12:20:00 base-programmer kernel: [    0.089287] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
Oct 16 12:20:00 base-programmer kernel: [    0.089877] Initializing cgroup subsys memory
Oct 16 12:20:00 base-programmer kernel: [    0.089910] Initializing cgroup subsys devices
Oct 16 12:20:00 base-programmer kernel: [    0.089924] Initializing cgroup subsys freezer
Oct 16 12:20:00 base-programmer kernel: [    0.089937] Initializing cgroup subsys net_cls
Oct 16 12:20:00 base-programmer kernel: [    0.089953] Initializing cgroup subsys blkio
Oct 16 12:20:00 base-programmer kernel: [    0.089966] Initializing cgroup subsys perf_event
Oct 16 12:20:00 base-programmer kernel: [    0.089977] Initializing cgroup subsys net_prio
Oct 16 12:20:00 base-programmer kernel: [    0.090027] CPU: Testing write buffer coherency: ok
Oct 16 12:20:00 base-programmer kernel: [    0.090071] ftrace: allocating 31261 entries in 62 pages
Oct 16 12:20:00 base-programmer kernel: [    0.155742] Setting up static identity map for 0x805c5b98 - 0x805c5be4
Oct 16 12:20:00 base-programmer kernel: [    0.162306] devtmpfs: initialized
Oct 16 12:20:00 base-programmer kernel: [    0.163207] VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
Oct 16 12:20:00 base-programmer kernel: [    0.171556] omap_hwmod: tptc0 using broken dt data from edma
Oct 16 12:20:00 base-programmer kernel: [    0.171650] omap_hwmod: tptc1 using broken dt data from edma
Oct 16 12:20:00 base-programmer kernel: [    0.171730] omap_hwmod: tptc2 using broken dt data from edma
Oct 16 12:20:00 base-programmer kernel: [    0.175884] omap_hwmod: debugss: _wait_target_disable failed
Oct 16 12:20:00 base-programmer kernel: [    0.236823] xor: measuring software checksum speed
Oct 16 12:20:00 base-programmer kernel: [    0.328890]    arm4regs  :  1244.800 MB/sec
Oct 16 12:20:00 base-programmer kernel: [    0.428887]    8regs     :  1113.200 MB/sec
Oct 16 12:20:00 base-programmer kernel: [    0.528889]    32regs    :  1112.400 MB/sec
Oct 16 12:20:00 base-programmer kernel: [    0.628887]    neon      :  1791.600 MB/sec
Oct 16 12:20:00 base-programmer kernel: [    0.628894] xor: using function: neon (1791.600 MB/sec)
Oct 16 12:20:00 base-programmer kernel: [    0.628953] pinctrl core: initialized pinctrl subsystem
Oct 16 12:20:00 base-programmer kernel: [    0.629343] regulator-dummy: no parameters
Oct 16 12:20:00 base-programmer kernel: [    0.645452] NET: Registered protocol family 16
Oct 16 12:20:00 base-programmer kernel: [    0.649315] DMA: preallocated 2048 KiB pool for atomic coherent allocations
Oct 16 12:20:00 base-programmer kernel: [    0.650292] cpuidle: using governor ladder
Oct 16 12:20:00 base-programmer kernel: [    0.650309] cpuidle: using governor menu
Oct 16 12:20:00 base-programmer kernel: [    0.653138] OMAP GPIO hardware version 0.1
Oct 16 12:20:00 base-programmer kernel: [    0.665814] No ATAGs?
Oct 16 12:20:00 base-programmer kernel: [    0.665841] hw-breakpoint: debug architecture 0x4 unsupported.
Oct 16 12:20:00 base-programmer kernel: [    0.839056] raid6: int32x1    270 MB/s
Oct 16 12:20:00 base-programmer kernel: [    1.008926] raid6: int32x2    374 MB/s
Oct 16 12:20:00 base-programmer kernel: [    1.178950] raid6: int32x4    389 MB/s
Oct 16 12:20:00 base-programmer kernel: [    1.348931] raid6: int32x8    358 MB/s
Oct 16 12:20:00 base-programmer kernel: [    1.518920] raid6: neonx1    1451 MB/s
Oct 16 12:20:00 base-programmer kernel: [    1.688892] raid6: neonx2    1887 MB/s
Oct 16 12:20:00 base-programmer kernel: [    1.858890] raid6: neonx4    2010 MB/s
Oct 16 12:20:00 base-programmer kernel: [    2.028947] raid6: neonx8     667 MB/s
Oct 16 12:20:00 base-programmer kernel: [    2.028953] raid6: using algorithm neonx4 (2010 MB/s)
Oct 16 12:20:00 base-programmer kernel: [    2.028958] raid6: using intx1 recovery algorithm
Oct 16 12:20:00 base-programmer kernel: [    2.036760] edma-dma-engine edma-dma-engine.0: TI EDMA DMA engine driver
Oct 16 12:20:00 base-programmer kernel: [    2.037497] vbat: 5000 mV
Oct 16 12:20:00 base-programmer kernel: [    2.037733] vmmcsd_fixed: 3300 mV
Oct 16 12:20:00 base-programmer kernel: [    2.040534] SCSI subsystem initialized
Oct 16 12:20:00 base-programmer kernel: [    2.040796] libata version 3.00 loaded.
Oct 16 12:20:00 base-programmer kernel: [    2.041067] usbcore: registered new interface driver usbfs
Oct 16 12:20:00 base-programmer kernel: [    2.041120] usbcore: registered new interface driver hub
Oct 16 12:20:00 base-programmer kernel: [    2.041181] usbcore: registered new device driver usb
Oct 16 12:20:00 base-programmer kernel: [    2.041701] omap_i2c 44e0b000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c0_pins, deferring probe
Oct 16 12:20:00 base-programmer kernel: [    2.041722] platform 44e0b000.i2c: Driver omap_i2c requests probe deferral
Oct 16 12:20:00 base-programmer kernel: [    2.041746] omap_i2c 4819c000.i2c: could not find pctldev for node /pinmux@44e10800/pinmux_i2c2_pins, deferring probe
Oct 16 12:20:00 base-programmer kernel: [    2.041758] platform 4819c000.i2c: Driver omap_i2c requests probe deferral
Oct 16 12:20:00 base-programmer kernel: [    2.041894] media: Linux media interface: v0.10
Oct 16 12:20:00 base-programmer kernel: [    2.041943] Linux video capture interface: v2.00
Oct 16 12:20:00 base-programmer kernel: [    2.042034] pps_core: LinuxPPS API ver. 1 registered
Oct 16 12:20:00 base-programmer kernel: [    2.042040] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giom...@linux.it>
Oct 16 12:20:00 base-programmer kernel: [    2.042065] PTP clock support registered
Oct 16 12:20:00 base-programmer kernel: [    2.042727] omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
Oct 16 12:20:00 base-programmer kernel: [    2.044077] NetLabel: Initializing
Oct 16 12:20:00 base-programmer kernel: [    2.044088] NetLabel:  domain hash size = 128
Oct 16 12:20:00 base-programmer kernel: [    2.044093] NetLabel:  protocols = UNLABELED CIPSOv4
Oct 16 12:20:00 base-programmer kernel: [    2.044150] NetLabel:  unlabeled traffic allowed by default
Oct 16 12:20:00 base-programmer kernel: [    2.044628] Switched to clocksource timer1
Oct 16 12:20:00 base-programmer kernel: [    2.099174] NET: Registered protocol family 2
Oct 16 12:20:00 base-programmer kernel: [    2.099849] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
Oct 16 12:20:00 base-programmer kernel: [    2.099891] TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
Oct 16 12:20:00 base-programmer systemd-modules-load[135]: Failed to find module 'mt7601Usta'
Oct 16 12:20:00 base-programmer systemd[1]: systemd-modules-load.service: main process exited, code=exited, status=1/FAILURE
Oct 16 12:20:00 base-programmer systemd[1]: Failed to start Load Kernel Modules.
Oct 16 12:20:00 base-programmer systemd[1]: Unit systemd-modules-load.service entered failed state.
Oct 16 12:20:00 base-programmer systemd-fsck[129]: rootfs: clean, 36027/236176 files, 242463/943872 blocks
Oct 16 12:20:00 base-programmer systemd-udevd[150]: Network interface NamePolicy= disabled on kernel commandline, ignoring.
Oct 16 12:20:00 base-programmer systemd-udevd[150]: Network interface NamePolicy= disabled on kernel commandline, ignoring.
Oct 16 12:20:00 base-programmer ntpdate[283]: Can't find host 0.debian.pool.ntp.org: Name or service not known (-2)
Oct 16 12:20:00 base-programmer ntpdate[283]: Can't find host 1.debian.pool.ntp.org: Name or service not known (-2)
Oct 16 12:20:00 base-programmer ntpdate[283]: Can't find host 2.debian.pool.ntp.org: Name or service not known (-2)
Oct 16 12:20:00 base-programmer ntpdate[283]: Can't find host 3.debian.pool.ntp.org: Name or service not known (-2)
Oct 16 12:20:00 base-programmer kernel: [    2.099928] TCP: Hash tables configured (established 4096 bind 4096)
Oct 16 12:20:00 base-programmer kernel: [    2.099985] TCP: reno registered
Oct 16 12:20:00 base-programmer kernel: [    2.099995] UDP hash table entries: 256 (order: 0, 4096 bytes)
Oct 16 12:20:00 base-programmer kernel: [    2.100010] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
Oct 16 12:20:00 base-programmer kernel: [    2.100180] NET: Registered protocol family 1
Oct 16 12:20:00 base-programmer kernel: [    2.100544] RPC: Registered named UNIX socket transport module.
Oct 16 12:20:00 base-programmer kernel: [    2.100552] RPC: Registered udp transport module.
Oct 16 12:20:00 base-programmer kernel: [    2.100558] RPC: Registered tcp transport module.
Oct 16 12:20:00 base-programmer kernel: [    2.100563] RPC: Registered tcp NFSv4.1 backchannel transport module.
Oct 16 12:20:00 base-programmer kernel: [    2.101067] Unpacking initramfs...
Oct 16 12:20:00 base-programmer kernel: [    2.315119] Freeing initrd memory: 3384K (cfcb2000 - d0000000)
Oct 16 12:20:00 base-programmer kernel: [    2.315757] hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available
Oct 16 12:20:00 base-programmer kernel: [    2.318014] futex hash table entries: 256 (order: -1, 3072 bytes)
Oct 16 12:20:00 base-programmer kernel: [    2.318115] audit: initializing netlink subsys (disabled)
Oct 16 12:20:00 base-programmer kernel: [    2.318176] audit: type=2000 audit(2.270:1): initialized
Oct 16 12:20:00 base-programmer kernel: [    2.319359] zpool: loaded
Oct 16 12:20:00 base-programmer kernel: [    2.319376] zbud: loaded
Oct 16 12:20:00 base-programmer kernel: [    2.319621] VFS: Disk quotas dquot_6.5.2
Oct 16 12:20:00 base-programmer kernel: [    2.319682] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Oct 16 12:20:00 base-programmer kernel: [    2.320197] NFS: Registering the id_resolver key type
Oct 16 12:20:00 base-programmer kernel: [    2.320248] Key type id_resolver registered
Oct 16 12:20:00 base-programmer kernel: [    2.320254] Key type id_legacy registered
Oct 16 12:20:00 base-programmer kernel: [    2.320276] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Oct 16 12:20:00 base-programmer kernel: [    2.320531] fuse init (API version 7.23)
Oct 16 12:20:00 base-programmer kernel: [    2.320727] SGI XFS with ACLs, security attributes, realtime, no debug enabled
Oct 16 12:20:00 base-programmer kernel: [    2.321243] msgmni has been set to 987
Oct 16 12:20:00 base-programmer kernel: [    2.322200] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Oct 16 12:20:00 base-programmer kernel: [    2.322336] io scheduler noop registered
Oct 16 12:20:00 base-programmer kernel: [    2.322349] io scheduler deadline registered
Oct 16 12:20:00 base-programmer kernel: [    2.322392] io scheduler cfq registered (default)
Oct 16 12:20:00 base-programmer kernel: [    2.323637] pinctrl-single 44e10800.pinmux: 142 pins at pa f9e10800 size 568
Oct 16 12:20:00 base-programmer kernel: [    2.326629] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
Oct 16 12:20:00 base-programmer kernel: [    2.328576] omap_uart 44e09000.serial: no wakeirq for uart0
Oct 16 12:20:00 base-programmer kernel: [    2.328745] omap_uart 44e09000.serial: ttyO0 at MMIO 0x44e09000 (irq = 154, base_baud = 3000000) is a OMAP UART0
Oct 16 12:20:00 base-programmer kernel: [    2.329159] console [ttyO0] enabled
Oct 16 12:20:00 base-programmer kernel: [    2.329587] omap_uart 48022000.serial: no wakeirq for uart0
Oct 16 12:20:00 base-programmer kernel: [    2.329706] omap_uart 48022000.serial: ttyO1 at MMIO 0x48022000 (irq = 155, base_baud = 3000000) is a OMAP UART1
Oct 16 12:20:00 base-programmer kernel: [    2.330042] omap_uart 48024000.serial: no wakeirq for uart0
Oct 16 12:20:00 base-programmer kernel: [    2.330146] omap_uart 48024000.serial: ttyO2 at MMIO 0x48024000 (irq = 156, base_baud = 3000000) is a OMAP UART2
Oct 16 12:20:00 base-programmer kernel: [    2.330480] omap_uart 481a8000.serial: no wakeirq for uart0
Oct 16 12:20:00 base-programmer kernel: [    2.330580] omap_uart 481a8000.serial: ttyO4 at MMIO 0x481a8000 (irq = 157, base_baud = 3000000) is a OMAP UART4
Oct 16 12:20:00 base-programmer kernel: [    2.330915] omap_uart 481aa000.serial: no wakeirq for uart0
Oct 16 12:20:00 base-programmer kernel: [    2.331016] omap_uart 481aa000.serial: ttyO5 at MMIO 0x481aa000 (irq = 158, base_baud = 3000000) is a OMAP UART5
Oct 16 12:20:00 base-programmer kernel: [    2.332495] omap_rng 48310000.rng: OMAP Random Number Generator ver. 20
Oct 16 12:20:00 base-programmer kernel: [    2.332789] [drm] Initialized drm 1.1.0 20060810
Oct 16 12:20:00 base-programmer kernel: [    2.332876] usbcore: registered new interface driver udl
Oct 16 12:20:00 base-programmer kernel: [    2.332894] Error: Driver 'tfp410' is already registered, aborting...
Oct 16 12:20:00 base-programmer kernel: [    2.340011] slave hdmi: could not get i2c
Oct 16 12:20:00 base-programmer kernel: [    2.344247] platform hdmi: Driver slave requests probe deferral
Oct 16 12:20:00 base-programmer kernel: [    2.344504] platform 4830e000.lcdc: Driver tilcdc requests probe deferral
Oct 16 12:20:00 base-programmer kernel: [    2.360038] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Oct 16 12:20:00 base-programmer kernel: [    2.360069] ehci-platform: EHCI generic platform driver
Oct 16 12:20:00 base-programmer kernel: [    2.360263] ehci-omap: OMAP-EHCI Host Controller driver
Oct 16 12:20:00 base-programmer kernel: [    2.360468] usbcore: registered new interface driver usb-storage
Oct 16 12:20:00 base-programmer kernel: [    2.362179] 47401300.usb-phy supply vcc not found, using dummy regulator
Oct 16 12:20:00 base-programmer kernel: [    2.364469] musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, bulk combine, bulk split, HB-ISO Rx, HB-ISO Tx, SoftConn)
Oct 16 12:20:00 base-programmer kernel: [    2.364485] musb-hdrc: MHDRC RTL version 2.0
Oct 16 12:20:00 base-programmer kernel: [    2.364492] musb-hdrc: setup fifo_mode 4
Oct 16 12:20:00 base-programmer kernel: [    2.364508] musb-hdrc: 28/31 max ep, 16384/16384 memory
Oct 16 12:20:00 base-programmer kernel: [    2.364690] musb-hdrc musb-hdrc.0.auto: MUSB HDRC host driver
Oct 16 12:20:00 base-programmer kernel: [    2.364951] musb-hdrc musb-hdrc.0.auto: new USB bus registered, assigned bus number 1
Oct 16 12:20:00 base-programmer kernel: [    2.365121] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Oct 16 12:20:00 base-programmer kernel: [    2.365131] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 16 12:20:00 base-programmer kernel: [    2.365140] usb usb1: Product: MUSB HDRC host driver
Oct 16 12:20:00 base-programmer kernel: [    2.365148] usb usb1: Manufacturer: Linux 3.18.0-rc2-bone1 musb-hcd
Oct 16 12:20:00 base-programmer kernel: [    2.365155] usb usb1: SerialNumber: musb-hdrc.0.auto
Oct 16 12:20:00 base-programmer kernel: [    2.365839] hub 1-0:1.0: USB hub found
Oct 16 12:20:00 base-programmer kernel: [    2.365878] hub 1-0:1.0: 1 port detected
Oct 16 12:20:00 base-programmer kernel: [    2.367214] 47401b00.usb-phy supply vcc not found, using dummy regulator
Oct 16 12:20:00 base-programmer kernel: [    2.369439] musb-hdrc: ConfigData=0xde (UTMI-8, dyn FIFOs, bulk combine, bulk split, HB-ISO Rx, HB-ISO Tx, SoftConn)
Oct 16 12:20:00 base-programmer kernel: [    2.369454] musb-hdrc: MHDRC RTL version 2.0
Oct 16 12:20:00 base-programmer kernel: [    2.369461] musb-hdrc: setup fifo_mode 4
Oct 16 12:20:00 base-programmer kernel: [    2.369473] musb-hdrc: 28/31 max ep, 16384/16384 memory
Oct 16 12:20:00 base-programmer kernel: [    2.369577] musb-hdrc musb-hdrc.1.auto: MUSB HDRC host driver
Oct 16 12:20:00 base-programmer kernel: [    2.369834] musb-hdrc musb-hdrc.1.auto: new USB bus registered, assigned bus number 2
Oct 16 12:20:00 base-programmer kernel: [    2.369986] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002
Oct 16 12:20:00 base-programmer kernel: [    2.369997] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 16 12:20:00 base-programmer kernel: [    2.370005] usb usb2: Product: MUSB HDRC host driver
Oct 16 12:20:00 base-programmer kernel: [    2.370013] usb usb2: Manufacturer: Linux 3.18.0-rc2-bone1 musb-hcd
Oct 16 12:20:00 base-programmer kernel: [    2.370020] usb usb2: SerialNumber: musb-hdrc.1.auto
Oct 16 12:20:00 base-programmer kernel: [    2.370637] hub 2-0:1.0: USB hub found
Oct 16 12:20:00 base-programmer kernel: [    2.370674] hub 2-0:1.0: 1 port detected
Oct 16 12:20:00 base-programmer kernel: [    2.379084] mousedev: PS/2 mouse device common for all mice
Oct 16 12:20:00 base-programmer kernel: [    2.380625] omap_rtc 44e3e000.rtc: rtc core: registered 44e3e000.rtc as rtc0
Oct 16 12:20:00 base-programmer kernel: [    2.380825] i2c /dev entries driver
Oct 16 12:20:00 base-programmer kernel: [    2.380949] IR XMP protocol handler initialized
Oct 16 12:20:00 base-programmer kernel: [    2.382458] omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
Oct 16 12:20:00 base-programmer kernel: [    2.382906] sdhci: Secure Digital Host Controller Interface driver
Oct 16 12:20:00 base-programmer kernel: [    2.382914] sdhci: Copyright(c) Pierre Ossman
Oct 16 12:20:00 base-programmer kernel: [    2.474997] sdhci-pltfm: SDHCI platform and OF driver helper
Oct 16 12:20:00 base-programmer kernel: [    2.476356] ledtrig-cpu: registered to indicate activity on CPUs
Oct 16 12:20:00 base-programmer kernel: [    2.476452] hidraw: raw HID events driver (C) Jiri Kosina
Oct 16 12:20:00 base-programmer kernel: [    2.478458] usbcore: registered new interface driver usbhid
Oct 16 12:20:00 base-programmer kernel: [    2.478466] usbhid: USB HID core driver
Oct 16 12:20:00 base-programmer kernel: [    2.481087] ashmem: initialized
Oct 16 12:20:00 base-programmer kernel: [    2.482259] oprofile: using arm/armv7
Oct 16 12:20:00 base-programmer kernel: [    2.482536] TCP: cubic registered
Oct 16 12:20:00 base-programmer kernel: [    2.482629] NET: Registered protocol family 10
Oct 16 12:20:00 base-programmer kernel: [    2.483545] mip6: Mobile IPv6
Oct 16 12:20:00 base-programmer kernel: [    2.483568] NET: Registered protocol family 17
Oct 16 12:20:00 base-programmer kernel: [    2.483669] Key type dns_resolver registered
Oct 16 12:20:00 base-programmer kernel: [    2.483680] mpls_gso: MPLS GSO support
Oct 16 12:20:00 base-programmer kernel: [    2.483978] omap_voltage_late_init: Voltage driver support not added
Oct 16 12:20:00 base-programmer kernel: [    2.490761] sr_dev_init: No voltage domain specified for smartreflex0. Cannot initialize
Oct 16 12:20:00 base-programmer kernel: [    2.499308] sr_dev_init: No voltage domain specified for smartreflex1. Cannot initialize
Oct 16 12:20:00 base-programmer kernel: [    2.508445] platform cpufreq-dt.0: Driver cpufreq-dt requests probe deferral
Oct 16 12:20:00 base-programmer kernel: [    2.508683] ThumbEE CPU extension supported.
Oct 16 12:20:00 base-programmer kernel: [    2.508721] Registering SWP/SWPB emulation handler
Oct 16 12:20:00 base-programmer kernel: [    2.508742] SmartReflex Class3 initialized
Oct 16 12:20:00 base-programmer kernel: [    2.512538] registered taskstats version 1
Oct 16 12:20:00 base-programmer kernel: [    2.513349] Btrfs loaded
Oct 16 12:20:00 base-programmer kernel: [    2.520582] input: tps65217_pwr_but as /devices/ocp/44e0b000.i2c/i2c-0/0-0024/input/input0
Oct 16 12:20:00 base-programmer kernel: [    2.522170] vdd_ddr3: 1350 mV
Oct 16 12:20:00 base-programmer kernel: [    2.522964] vdd_mpu: 925 <--> 1325 mV at 1325 mV
Oct 16 12:20:00 base-programmer kernel: [    2.523717] vdd_core: 925 <--> 1150 mV at 1125 mV
Oct 16 12:20:00 base-programmer kernel: [    2.524453] vio,vrtc,vdds: at 1800 mV
Oct 16 12:20:00 base-programmer kernel: [    2.525315] vdd_3v3aux: at 3300 mV
Oct 16 12:20:00 base-programmer kernel: [    2.526091] vdd_1v8: 1800 mV
Oct 16 12:20:00 base-programmer kernel: [    2.526909] vdd_3v3a: at 3300 mV
Oct 16 12:20:00 base-programmer kernel: [    2.527715] tps65217 0-0024: TPS65217 ID 0xe version 1.2
Oct 16 12:20:00 base-programmer kernel: [    2.532082] at24 0-0050: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
Oct 16 12:20:00 base-programmer kernel: [    2.532126] omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
Oct 16 12:20:00 base-programmer kernel: [    2.537818] at24 2-0054: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
Oct 16 12:20:00 base-programmer kernel: [    2.538265] mmc1: BKOPS_EN bit is not set
Oct 16 12:20:00 base-programmer kernel: [    2.542693] at24 2-0055: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
Oct 16 12:20:00 base-programmer kernel: [    2.543559] mmc1: new high speed MMC card at address 0001
Oct 16 12:20:00 base-programmer kernel: [    2.547702] at24 2-0056: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
Oct 16 12:20:00 base-programmer kernel: [    2.547899] mmcblk0: mmc1:0001 MMC04G 3.60 GiB
Oct 16 12:20:00 base-programmer kernel: [    2.548133] mmcblk0boot0: mmc1:0001 MMC04G partition 1 2.00 MiB
Oct 16 12:20:00 base-programmer kernel: [    2.548339] mmcblk0boot1: mmc1:0001 MMC04G partition 2 2.00 MiB
Oct 16 12:20:00 base-programmer kernel: [    2.549347]  mmcblk0: p1
Oct 16 12:20:00 base-programmer kernel: [    2.554865] at24 2-0057: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
Oct 16 12:20:00 base-programmer kernel: [    2.554915] omap_i2c 4819c000.i2c: bus 2 rev0.11 at 100 kHz
Oct 16 12:20:00 base-programmer kernel: [    2.676896] tda998x 0-0070: found TDA19988
Oct 16 12:20:00 base-programmer kernel: [    2.677857] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
Oct 16 12:20:00 base-programmer kernel: [    2.677865] [drm] No driver support for vblank timestamp query.
Oct 16 12:20:00 base-programmer kernel: [    2.678278] tilcdc 4830e000.lcdc: No connectors reported connected with modes
Oct 16 12:20:00 base-programmer kernel: [    2.678297] [drm] Cannot find any crtc or sizes - going 1024x768
Oct 16 12:20:00 base-programmer kernel: [    2.690912] Console: switching to colour frame buffer device 128x48
Oct 16 12:20:00 base-programmer kernel: [    2.696353] tilcdc 4830e000.lcdc: fb0:  frame buffer device
Oct 16 12:20:00 base-programmer kernel: [    2.696361] tilcdc 4830e000.lcdc: registered panic notifier
Oct 16 12:20:00 base-programmer kernel: [    2.696383] [drm] Initialized tilcdc 1.0.0 20121205 on minor 0
Oct 16 12:20:00 base-programmer kernel: [    2.754654] davinci_mdio 4a101000.mdio: davinci mdio revision 1.6
Oct 16 12:20:00 base-programmer kernel: [    2.754672] davinci_mdio 4a101000.mdio: detected phy mask fffffffe
Oct 16 12:20:00 base-programmer kernel: [    2.760163] libphy: 4a101000.mdio: probed
Oct 16 12:20:00 base-programmer kernel: [    2.760191] davinci_mdio 4a101000.mdio: phy[0]: device 4a101000.mdio:00, driver SMSC LAN8710/LAN8720
Oct 16 12:20:00 base-programmer kernel: [    2.761083] cpsw 4a100000.ethernet: Detected MACID = 78:a5:04:ca:63:26
Oct 16 12:20:00 base-programmer kernel: [    2.762203] omap_rtc 44e3e000.rtc: setting system clock to 2000-01-01 00:00:00 UTC (946684800)
Oct 16 12:20:00 base-programmer kernel: [    2.762225] sr_init: No PMIC hook to init smartreflex
Oct 16 12:20:00 base-programmer kernel: [    2.762405] sr_init: platform driver register failed for SR
Oct 16 12:20:00 base-programmer kernel: [    2.771246] PM: Hibernation image not present or could not be loaded.
Oct 16 12:20:00 base-programmer kernel: [    2.771287] vbat: disabling
Oct 16 12:20:00 base-programmer kernel: [    2.772157] Freeing unused kernel memory: 464K (c0956000 - c09ca000)
Oct 16 12:20:00 base-programmer kernel: [    2.816366] random: systemd-udevd urandom read with 8 bits of entropy available
Oct 16 12:20:00 base-programmer kernel: [    2.844864] usb 2-1: new high-speed USB device number 2 using musb-hdrc
Oct 16 12:20:00 base-programmer kernel: [    2.997239] usb 2-1: New USB device found, idVendor=2001, idProduct=1a02
Oct 16 12:20:00 base-programmer kernel: [    2.997258] usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Oct 16 12:20:00 base-programmer kernel: [    2.997266] usb 2-1: Product: DUB-E100
Oct 16 12:20:00 base-programmer kernel: [    2.997275] usb 2-1: Manufacturer: D-Link          
Oct 16 12:20:00 base-programmer kernel: [    2.997282] usb 2-1: SerialNumber: 6D834B
Oct 16 12:20:00 base-programmer kernel: [    3.364729] EXT4-fs (mmcblk0p1): INFO: recovery required on readonly filesystem
Oct 16 12:20:00 base-programmer kernel: [    3.364746] EXT4-fs (mmcblk0p1): write access will be enabled during recovery
Oct 16 12:20:00 base-programmer kernel: [    3.470757] EXT4-fs (mmcblk0p1): recovery complete
Oct 16 12:20:00 base-programmer kernel: [    3.472052] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
Oct 16 12:20:00 base-programmer kernel: [    4.516353] EXT4-fs (mmcblk0p1): re-mounted. Opts: errors=remount-ro
Oct 16 12:20:00 base-programmer kernel: [    5.933765] net eth0: initializing cpsw version 1.12 (0)
Oct 16 12:20:00 base-programmer kernel: [    5.937227] net eth0: phy found : id is : 0x7c0f1
Oct 16 12:20:00 base-programmer kernel: [    5.937334] libphy: PHY 4a101000.mdio:01 not found
Oct 16 12:20:00 base-programmer kernel: [    5.942365] net eth0: phy 4a101000.mdio:01 not found on slave 1
Oct 16 12:20:00 base-programmer kernel: [    5.965042] net eth0: BQL enabled
Oct 16 12:20:00 base-programmer kernel: [    5.969172] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Oct 16 12:20:00 base-programmer kernel: [    5.988963] omap-sham 53100000.sham: hw accel on OMAP rev 4.3
Oct 16 12:20:00 base-programmer kernel: [    6.041436] ip_tables: (C) 2000-2006 Netfilter Core Team
Oct 16 12:20:00 base-programmer kernel: [    6.084440] nf_conntrack version 0.5.0 (7909 buckets, 31636 max)
Oct 16 12:20:00 base-programmer kernel: [    6.086489] omap-aes 53500000.aes: OMAP AES hw accel rev: 3.2
Oct 16 12:20:00 base-programmer kernel: [    7.780214] asix 2-1:1.0 eth1: register 'asix' at usb-musb-hdrc.1.auto-1, ASIX AX88772 USB 2.0 Ethernet, c4:a8:1d:6d:83:4b
Oct 16 12:20:00 base-programmer kernel: [    7.781449] usbcore: registered new interface driver asix
Oct 16 12:20:00 base-programmer kernel: [    7.901784] cfg80211: Calling CRDA to update world regulatory domain
Oct 16 12:20:00 base-programmer dnsmasq[366]: started, version 2.72 cachesize 150
Oct 16 12:20:00 base-programmer dnsmasq[366]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect
Oct 16 12:20:00 base-programmer dnsmasq[366]: DBus support enabled: connected to system bus
Oct 16 12:20:00 base-programmer dnsmasq-dhcp[366]: DHCP, IP range 192.168.0.50 -- 192.168.0.150, lease time 12h
Oct 16 12:20:00 base-programmer dnsmasq[366]: reading /etc/resolv.conf
Oct 16 12:20:00 base-programmer dnsmasq[366]: using nameserver 192.168.1.2#53
Oct 16 12:20:00 base-programmer dnsmasq[366]: read /etc/hosts - 2 addresses
Oct 16 12:20:00 base-programmer kernel: [    8.268981] random: nonblocking pool is initialized
Oct 16 12:20:00 base-programmer polkitd[402]: started daemon version 0.105 using authority implementation `
local' version `0.105'
Oct 16 12:20:00 base-programmer dbus[328]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Oct 16 12:20:00 base-programmer ntpd[423]: ntpd 4.2.6p5@1.2349-o Wed Jul 23 19:53:33 UTC 2014 (1)
Oct 16 12:20:00 base-programmer NetworkManager[319]: <info> init!
Oct 16 12:20:00 base-programmer ntp[404]: Starting NTP server: ntpd.
Oct 16 12:20:00 base-programmer ntpd[431]: proto: precision = 1.042 usec
Oct 16 12:20:00 base-programmer ntpd[431]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> update_system_hostname
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info>       interface-parser: parsing file /etc/network/interfaces
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info>       interface-parser: finished parsing file /etc/network/interfaces
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> guessed connection type (eth0) = 802-3-ethernet
Oct 16 12:20:01 base-programmer NetworkManager[319]: Libgcrypt warning: missing initialization - please fix the application
Oct 16 12:20:01 base-programmer ntpd[431]: Listen and drop on 1 v6wildcard :: UDP 123
Oct 16 12:20:01 base-programmer ntpd[431]: Listen normally on 2 lo 127.0.0.1 UDP 123
Oct 16 12:20:01 base-programmer ntpd[431]: Listen normally on 3 eth0 192.168.0.1 UDP 123
Oct 16 12:20:01 base-programmer ntpd[431]: Listen normally on 4 lo ::1 UDP 123
Oct 16 12:20:01 base-programmer ntpd[431]: peers refreshed
Oct 16 12:20:01 base-programmer ntpd[431]: Listening on routing socket on fd #21 for interface updates
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> update_connection_setting_from_if_block: name:eth0, type:802-3-ethernet, id:Ifupdown (eth0), uuid: 681b428f-beaf-8932-dce4-687ed5bae28e
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> addresses count: 1
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> No dns-nameserver configured in /etc/network/interfaces
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> adding eth0 to connections
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> adding iface eth0 to eni_ifaces
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> autoconnect
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> management mode: unmanaged
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> devices added (path: /sys/devices/ocp/47400000.usb/47401c00.usb/musb-hdrc.1.auto/usb2/2-1/2-1:1.0/net/eth1, iface: eth1)
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> device added (path: /sys/devices/ocp/47400000.usb/47401c00.usb/musb-hdrc.1.auto/usb2/2-1/2-1:1.0/net/eth1, iface: eth1): no ifupdown configuration found.
Oct 16 12:20:01 base-programmer ntpd[431]: Deferring DNS for 0.debian.pool.ntp.org 1
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> devices added (path: /sys/devices/ocp/4a100000.ethernet/net/eth0, iface: eth0)
Oct 16 12:20:01 base-programmer ntpd[431]: Deferring DNS for 1.debian.pool.ntp.org 1
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> locking wired connection setting
Oct 16 12:20:01 base-programmer ntpd[431]: Deferring DNS for 2.debian.pool.ntp.org 1
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> devices added (path: /sys/devices/virtual/net/lo, iface: lo)
Oct 16 12:20:01 base-programmer ntpd[431]: Deferring DNS for 3.debian.pool.ntp.org 1
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> device added (path: /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found.
Oct 16 12:20:01 base-programmer ntpd[443]: signal_no_reset: signal 17 had flags 4000000
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> end _init.
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> Loaded plugin ifupdown: (C) 2008 Canonical Ltd.  To report bugs please use the NetworkManager mailing list.
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> Loaded plugin keyfile: (c) 2007 - 2013 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (14303312) ... get_connections.
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (14303312) ... get_connections (managed=false): return empty list.
Oct 16 12:20:01 base-programmer kernel: [    9.027752] using random self ethernet address
Oct 16 12:20:01 base-programmer kernel: [    9.027772] using random host ethernet address
Oct 16 12:20:01 base-programmer kernel: [    9.027784] using host ethernet address: 78:A5:04:CA:63:28
Oct 16 12:20:01 base-programmer kernel: [    9.027818] using random self ethernet address
Oct 16 12:20:01 base-programmer kernel: [    9.027826] using random host ethernet address
Oct 16 12:20:01 base-programmer kernel: [    9.027837] using host ethernet address: 78:A5:04:CA:63:28
Oct 16 12:20:01 base-programmer kernel: [    9.028599] usb0: HOST MAC 78:a5:04:ca:63:28
Oct 16 12:20:01 base-programmer kernel: [    9.028669] usb0: MAC b2:3e:b3:5d:c1:be
Oct 16 12:20:01 base-programmer kernel: [    9.068803] Number of LUNs=8
Oct 16 12:20:01 base-programmer kernel: [    9.068829] Mass Storage Function, version: 2009/09/11
Oct 16 12:20:01 base-programmer kernel: [    9.068839] LUN: removable file: (no medium)
Oct 16 12:20:01 base-programmer kernel: [    9.068855] Number of LUNs=1
Oct 16 12:20:01 base-programmer kernel: [    9.068982] LUN: removable file: /dev/mmcblk0p1
Oct 16 12:20:01 base-programmer kernel: [    9.068989] Number of LUNs=1
Oct 16 12:20:01 base-programmer kernel: [    9.087245] g_multi gadget: Multifunction Composite Gadget
Oct 16 12:20:01 base-programmer kernel: [    9.087268] g_multi gadget: g_multi ready
Oct 16 12:20:01 base-programmer loadcpufreq[403]: Loading cpufreq kernel modules...done (none).
Oct 16 12:20:01 base-programmer cpufrequtils[469]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...done.
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> new connection /etc/NetworkManager/system-connections/awthcb
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> get unmanaged devices count: 1
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> monitoring kernel firmware directory '/lib/firmware'.
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> monitoring ifupdown state file '/run/network/ifstate'.
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> WiFi hardware radio set enabled
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> WWAN hardware radio set enabled
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-wwan.so
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-bluetooth.so
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-wifi.so
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-adsl.so
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> WiFi enabled by radio killswitch; enabled by state file
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> WWAN enabled by radio killswitch; enabled by state file
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> WiMAX enabled by radio killswitch; enabled by state file
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> Networking is enabled by state file
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (lo): link connected
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (lo): carrier is ON
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (lo): new Generic device (driver: 'unknown' ifindex: 1)
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (lo): exported as /org/freedesktop/NetworkManager/Devices/0
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (eth0): carrier is OFF
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (eth0): new Ethernet device (driver: 'cpsw' ifindex: 2)
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/1
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> startup complete
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> NetworkManager state is now CONNECTED_GLOBAL
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (eth1): carrier is OFF
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (eth1): new Ethernet device (driver: 'asix' ifindex: 3)
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (eth1): exported as /org/freedesktop/NetworkManager/Devices/2
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (eth1): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (eth1): preparing device
Oct 16 12:20:01 base-programmer kernel: [    9.486091] asix 2-1:1.0 eth1: link down
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (eth1): created default wired connection 'Wired connection 1'
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> devices added (path: /sys/devices/ocp/47400000.usb/47401400.usb/musb-hdrc.0.auto/gadget/net/usb0, iface: usb0)
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> device added (path: /sys/devices/ocp/47400000.usb/47401400.usb/musb-hdrc.0.auto/gadget/net/usb0, iface: usb0): no ifupdown configuration found.
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (usb0): carrier is OFF
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (usb0): new Ethernet device (driver: 'musb-hdrc' ifindex: 4)
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (usb0): exported as /org/freedesktop/NetworkManager/Devices/3
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (usb0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (usb0): preparing device
Oct 16 12:20:01 base-programmer NetworkManager[319]: <info> (usb0): created default wired connection 'Wired connection 2'
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> ModemManager available in the bus
Oct 16 12:20:02 base-programmer kernel: [    9.743591] asix 2-1:1.0 eth1: link up, 100Mbps, full-duplex, lpa 0xCDE1
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> (eth1): link connected
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> (eth1): device state change: unavailable -> disconnected (reason 'carrier-changed') [20 30 40]
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Auto-activating connection 'Wired connection 1'.
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) starting connection 'Wired connection 1'
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) scheduled...
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) started...
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> (eth1): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 2 of 5 (Device Configure) scheduled...
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) complete.
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 2 of 5 (Device Configure) starting...
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> (eth1): device state change: prepare -> config (reason 'none') [40 50 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 2 of 5 (Device Configure) successful.
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) scheduled.
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 2 of 5 (Device Configure) complete.
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) started...
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> (eth1): device state change: config -> ip-config (reason 'none') [50 70 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Beginning DHCPv4 transaction (timeout in 45 seconds)
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> dhclient started with pid 480
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 3 of 5 (IP Configure Start) complete.
Oct 16 12:20:02 base-programmer dhclient: Internet Systems Consortium DHCP Client 4.3.1
Oct 16 12:20:02 base-programmer NetworkManager[319]: Internet Systems Consortium DHCP Client 4.3.1
Oct 16 12:20:02 base-programmer dhclient: Copyright 2004-2014 Internet Systems Consortium.
Oct 16 12:20:02 base-programmer dhclient: All rights reserved.
Oct 16 12:20:02 base-programmer dhclient: For info, please visit https://www.isc.org/software/dhcp/
Oct 16 12:20:02 base-programmer dhclient:
Oct 16 12:20:02 base-programmer NetworkManager[319]: Copyright 2004-2014 Internet Systems Consortium.
Oct 16 12:20:02 base-programmer NetworkManager[319]: All rights reserved.
Oct 16 12:20:02 base-programmer NetworkManager[319]: For info, please visit https://www.isc.org/software/dhcp/
Oct 16 12:20:02 base-programmer dhclient: Listening on LPF/eth1/c4:a8:1d:6d:83:4b
Oct 16 12:20:02 base-programmer NetworkManager[319]: Listening on LPF/eth1/c4:a8:1d:6d:83:4b
Oct 16 12:20:02 base-programmer dhclient: Sending on   LPF/eth1/c4:a8:1d:6d:83:4b
Oct 16 12:20:02 base-programmer dhclient: Sending on   Socket/fallback
Oct 16 12:20:02 base-programmer dhclient: DHCPDISCOVER on eth1 to 255.255.255.255 port 67 interval 8
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> (eth1): DHCPv4 state changed nbi -> preinit
Oct 16 12:20:02 base-programmer dhclient: DHCPREQUEST on eth1 to 255.255.255.255 port 67
Oct 16 12:20:02 base-programmer dhclient: DHCPOFFER from 192.168.1.2
Oct 16 12:20:02 base-programmer NetworkManager[319]: Sending on   LPF/eth1/c4:a8:1d:6d:83:4b
Oct 16 12:20:02 base-programmer NetworkManager[319]: Sending on   Socket/fallback
Oct 16 12:20:02 base-programmer NetworkManager[319]: DHCPDISCOVER on eth1 to 255.255.255.255 port 67 interval 8
Oct 16 12:20:02 base-programmer NetworkManager[319]: DHCPREQUEST on eth1 to 255.255.255.255 port 67
Oct 16 12:20:02 base-programmer NetworkManager[319]: DHCPOFFER from 192.168.1.2
Oct 16 12:20:02 base-programmer dhclient: DHCPACK from 192.168.1.2
Oct 16 12:20:02 base-programmer NetworkManager[319]: DHCPACK from 192.168.1.2
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> (eth1): DHCPv4 state changed preinit -> bound
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info>   address 192.168.1.182
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info>   plen 24 (255.255.255.0)
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info>   classless static route 10.8.0.0/24 gw 192.168.1.98
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info>   gateway 192.168.1.1
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info>   server identifier 192.168.1.2
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info>   lease time 86400
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info>   hostname 'base-programmer'
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info>   nameserver '192.168.1.2'
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info>   domain name 'scypho.com'
Oct 16 12:20:02 base-programmer dhclient: bound to 192.168.1.182 -- renewal in 39867 seconds.
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 5 of 5 (IPv4 Commit) started...
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> (eth1): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) Stage 5 of 5 (IPv4 Commit) complete.
Oct 16 12:20:02 base-programmer NetworkManager[319]: bound to 192.168.1.182 -- renewal in 39867 seconds.
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> (eth1): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> (eth1): device state change: secondaries -> activated (reason 'none') [90 100 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Policy set 'Wired connection 1' (eth1) as default for IPv4 routing and DNS.
Oct 16 12:20:02 base-programmer NetworkManager[319]: <info> Activation (eth1) successful, device activated.
Oct 16 12:20:02 base-programmer dbus[328]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
Oct 16 12:20:02 base-programmer dbus[328]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Oct 16 12:20:02 base-programmer nm-dispatcher: Dispatching action 'up' for eth1
Oct 16 12:20:02 base-programmer ntpdate[524]: the NTP socket is in use, exiting
Oct 16 12:20:03 base-programmer ntpd_intres[443]: DNS 0.debian.pool.ntp.org -> 83.168.200.199
Oct 16 12:20:03 base-programmer ntpd_intres[443]: DNS 1.debian.pool.ntp.org -> 81.234.134.160
Oct 16 12:20:03 base-programmer ntpd_intres[443]: DNS 2.debian.pool.ntp.org -> 195.178.181.98
Oct 16 12:20:03 base-programmer ntpd_intres[443]: DNS 3.debian.pool.ntp.org -> 192.36.143.153
Oct 16 12:20:03 base-programmer ModemManager[315]: <warn>  Couldn't find support for device at '/sys/devices/ocp/47400000.usb/47401c00.usb/musb-hdrc.1.auto/usb2/2-1': not supported by any plugin
Oct 16 12:20:04 base-programmer ntpd[431]: Listen normally on 5 eth1 192.168.1.182 UDP 123
Oct 16 12:20:04 base-programmer ntpd[431]: Listen normally on 6 eth1 fe80::c6a8:1dff:fe6d:834b UDP 123
Oct 16 12:20:04 base-programmer ntpd[431]: 192.36.143.153 interface 192.168.0.1 -> 192.168.1.182
Oct 16 12:20:04 base-programmer ntpd[431]: 83.168.200.199 interface 192.168.0.1 -> 192.168.1.182
Oct 16 12:20:04 base-programmer ntpd[431]: 195.178.181.98 interface 192.168.0.1 -> 192.168.1.182
Oct 16 12:20:05 base-programmer ntpd[431]: 81.234.134.160 interface 192.168.0.1 -> 192.168.1.182
Oct 16 12:20:05 base-programmer ntpd[431]: peers refreshed
Oct 31 11:20:24 base-programmer dnsmasq[366]: reading /etc/resolv.conf
Oct 31 11:20:24 base-programmer dnsmasq[366]: using nameserver 192.168.1.2#53
Oct 31 11:22:38 base-programmer systemd[560]: Starting Paths.
Oct 31 11:22:38 base-programmer systemd[560]: Reached target Paths.
Oct 31 11:22:38 base-programmer systemd[560]: Starting Timers.
Oct 31 11:22:38 base-programmer systemd[560]: Reached target Timers.
Oct 31 11:22:38 base-programmer sy
stemd[560]: Starting Sockets.
Oct 31 11:22:38 base-programmer systemd[560]: Reached target Sockets.
Oct 31 11:22:38 base-programmer systemd[560]: Starting Basic System.
Oct 31 11:22:38 base-programmer systemd[560]: Reached target Basic System.
Oct 31 11:22:38 base-programmer systemd[560]: Starting Default.
Oct 31 11:22:38 base-programmer systemd[560]: Reached target Default.
Oct 31 11:22:38 base-programmer systemd[560]: Startup finished in 44ms.
scypho@base-programmer:/var/log$




@William I use Robert's prebuild images at the moment, but the customise the installed packages. When building a kernel I usually use Robert's bb-kernel scripts. With pstree do you mean the pstree command to print a process tree?

jpsc...@googlemail.com

unread,
Oct 31, 2014, 9:42:37 AM10/31/14
to beagl...@googlegroups.com
I just had another reboot on 3.18-rc2-bone1

Ives van der Flaas

unread,
Oct 31, 2014, 2:20:29 PM10/31/14
to beagl...@googlegroups.com
I can confirm that the problem still exists on the 3.18-rc2-bone1. 

Ives van der Flaas

unread,
Oct 31, 2014, 2:24:55 PM10/31/14
to beagl...@googlegroups.com
Op donderdag 30 oktober 2014 18:15:33 UTC+1 schreef William Hermans:
So I'm curious. Did all of you follow Roberts DebianOnARM kernel build instructions, or are you all using a prebuilt image ?

I'm using a pretty old prebuilt 13.04 image (with lots of libraries and scripts with quite a few units running in production, not easily upgraded). Meaning that I'm also running an old u-boot. 

david turvene

unread,
Nov 1, 2014, 3:24:33 PM11/1/14
to beagl...@googlegroups.com
On Friday, October 31, 2014 2:20:29 PM UTC-4, Ives van der Flaas wrote:
I can confirm that the problem still exists on the 3.18-rc2-bone1. 
 

Running the RCN 3.18-rc2-bone1 my system has rebooted several times over the weekend (EST).  This is not good for me - and I've been trying to figure out the root.  

I am porting a wifi sniffing app (802.11 monitor mode) that worked fine on a Ubuntu 12.04 LTS laptop using one USB plug (two interfaces, second one is type monitor) and two USB plugs (second plug configured as monitor otherbss).  I have a collection of wifi USB plugs on a 4-port USB hub; I control via wicd-cli or the dbus interface to wicd.  My target plug (Edimax) that worked on 12.04 do not have drivers on Wheezy 7.7.  I was planning on manually porting it's driver as the next step.

* The system runs fine when I'm not messing around with the plugs, changing the wifi properties, or sniffing.  When I do any of these the system occasionally silently reboots - I've been able to test up to 20 sniffing sessions before it reboots, sometimes it will reboot immediately when I start an monitor session.
* I run the BBB headless, generally using SSH xterm.
* The silent reboot happens with NO indication.  NOTHING.  The uart console just shows a system restart.
* I triggered a watchdog NMI (it takes 22 seconds) and it showed a lot of diagnostic info - so that's not it.

Dave

david turvene

unread,
Nov 3, 2014, 6:18:43 PM11/3/14
to beagl...@googlegroups.com
On Saturday, November 1, 2014 3:24:33 PM UTC-4, david turvene wrote:
The system runs fine when I'm not messing around with the plugs, changing the wifi properties, or sniffing.  When I do any of these the system occasionally silently reboots - I've been able to test up to 20 sniffing sessions before it reboots, sometimes it will reboot immediately when I start an monitor session.
* I run the BBB headless, generally using SSH xterm.
* The silent reboot happens with NO indication.  NOTHING.  The uart console just shows a system restart.
* I triggered a watchdog NMI (it takes 22 seconds) and it showed a lot of diagnostic info - so that's not it.

Further research - similar behavior was reported last year.  Lot's of red herrings (USB control appeared to be the most suspicious because that's my main interface but also long threads blaming the power management unit.)  Someone found that another clock source was needed for low-power state and moved the new code into u-boot.  I was running with a local build from RCN's git repo described at:


and 2014.7 baseline.  I noticed it is now at 2014.10 so I rebuilt and installed on target.  The system is much more stable after testing for a lot longer than I could before.  And I'm pretty sure the clocking/power is the root cause of the silent reboots so I'm checking how the clock change, to the RTC32K clock, works.

Also, since I'm running from emmc, I used am335x_boneblack_defconfig to build u-boot.  The only difference is it sets EMMC_BOOT but a quick grep shows it changes logic in a couple places.

Anyway, it's a start...

Ives van der Flaas

unread,
Nov 4, 2014, 9:01:53 AM11/4/14
to beagl...@googlegroups.com
Have you had any resets since the upgrade to the new u-boot version? I've also been suspecting u-boot, hence my "Meaning that I'm also running an old u-boot. " in the last post. 

Op dinsdag 4 november 2014 00:18:43 UTC+1 schreef david turvene:

jpsc...@googlemail.com

unread,
Nov 4, 2014, 7:36:09 PM11/4/14
to beagl...@googlegroups.com
I followed up on the USB OTG hint as mentioned in my previous post. I patched the dtb for the bbb so that the mini usb port runs as peripheral and not as OTG. The patch was deployed to 7 systems so far and they all are stable (no reboot) since then on any of the systems. The uptime is more than 3 days now.
If interested, I can post more details.

david turvene

unread,
Nov 5, 2014, 4:05:58 PM11/5/14
to beagl...@googlegroups.com
On Tuesday, November 4, 2014 9:01:53 AM UTC-5, Ives van der Flaas wrote:
Have you had any resets since the upgrade to the new u-boot version? I've also been suspecting u-boot, hence my "Meaning that I'm also running an old u-boot. " in the last post. 


Yes, it has rebooted a couple times in the last two days.  This seems to be an ongoing issue on another thread - use "Beaglebone Black Rebooting Several Times Every Day" in the Search for topics widget.  

One person suggested powering the BBB from the mini USB port - which I'll try.  I'm currently using a 1.5A supply from a pandaboard.

Another person thinks it's the watchdog.  I triggered a "noisy" watchdog NMI the other day (stack trace starts with "NMI watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [kworker/u2:0:2226]") but can force a silent watchdog NMI by holding /dev/watchdog open for 60sec.  I'm investigating the watchdog logic now.

In the worst case, I can live with an occasional reboot.

Jens Peter Schroer

unread,
Nov 6, 2014, 11:10:37 AM11/6/14
to beagl...@googlegroups.com

I have followed the USB OTG hint as mentioned in my previous post. I patched the dtb for the bbb so that the mini usb port runs as peripheral and not as OTG. The patch was deployed to 7 systems so far and they all are stable (no reboot) since then on any of the systems. The uptime is more than 3 days now.

--
For more options, visit http://beagleboard.org/discuss
---
You received this message because you are subscribed to a topic in the Google Groups "BeagleBoard" group.
To unsubscribe from this topic, visit https://groups.google.com/d/topic/beagleboard/RMOTnQBgIo8/unsubscribe.
To unsubscribe from this group and all its topics, send an email to beagleboard...@googlegroups.com.

William Hermans

unread,
Nov 6, 2014, 2:42:26 PM11/6/14
to beagl...@googlegroups.com
If interested, I can post more details.


Please do Jens, I am sure someone will find the information useful. Did you by chance debug / bug report to the maintainer ?

david turvene

unread,
Nov 6, 2014, 5:31:43 PM11/6/14
to beagl...@googlegroups.com, jpsc...@googlemail.com
On Thursday, November 6, 2014 11:10:37 AM UTC-5, Jens Peter Schroer wrote:

I have followed the USB OTG hint as mentioned in my previous post. I patched the dtb for the bbb so that the mini usb port runs as peripheral and not as OTG. The patch was deployed to 7 systems so far and they all are stable (no reboot) since then on any of the systems. The uptime is more than 3 days now. 

@Jens - thanks for the tip.

I tried it: setting usb0 dr_mode = peripheral and usb1 dr_mode = host.  I don't use usb0 at all; usb1 has a usb hub with wifi plugs.  The BBB ran for about a three hours under heavy load (125K packet captures w/ about 10K dropped) and then silently reset.  I'm going to try (1) soaking the BBB with a light load overnight, 2) run power over usb0.

Dave

Ives van der Flaas

unread,
Nov 7, 2014, 3:20:17 AM11/7/14
to beagl...@googlegroups.com, jpsc...@googlemail.com
@David, did you try it on 3.17 or 3.18? Jens did his patch on 3.17 so there could potentially be a difference there (unlikely that it is). 

Op donderdag 6 november 2014 23:31:43 UTC+1 schreef david turvene:

Ives van der Flaas

unread,
Nov 8, 2014, 4:37:51 AM11/8/14
to beagl...@googlegroups.com, jpsc...@googlemail.com
Setting the usb0 dr_mode to peripheral and disabling OTG in the .config definitely makes a big difference. I have a 3.18-rc2-bone1 currently running for almost 24 hours with this patch, much more than I've ever previously achieved with 3.18 or 3.17. 

Op woensdag 5 november 2014 01:36:09 UTC+1 schreef Jens Peter Schroer:

Ives van der Flaas

unread,
Nov 8, 2014, 10:01:52 AM11/8/14
to beagl...@googlegroups.com, jpsc...@googlemail.com
However, not enoug of a difference apparently. I just had a sudden reset occur. This is on a 3.18-rc2-bone1 with both a Dymo labelwriter and a smartcard reader attached through USB. 

The boot log after reset can be found at http://pastebin.com/YGnNpJyQ

Op zaterdag 8 november 2014 10:37:51 UTC+1 schreef Ives van der Flaas:

david turvene

unread,
Nov 9, 2014, 1:50:46 PM11/9/14
to beagl...@googlegroups.com, jpsc...@googlemail.com
On Saturday, November 8, 2014 10:01:52 AM UTC-5, Ives van der Flaas wrote:
However, not enoug of a difference apparently. I just had a sudden reset occur. This is on a 3.18-rc2-bone1 with both a Dymo labelwriter and a smartcard reader attached through USB. 

Jens Peter Schroer gave me the recipe to make it work in my configuration.  I tried to enter an issue in http://bugs.elinux.org/projects/beaglebone-black/issues but it kept giving me an internal error, so I'm adding it here.

There are a number of google group threads with similar characteristics to this issue; search group for:

* "Beaglebone Black Rebooting Several Times Every Day"
* "Beaglebone Black Random Reboot"
* "3.17.1-rc4 sudden reset"

Scenario: 
* BBBv3
* 3.17.1-rc4, 7.6 wheezy
* usb0 is NOT connected
* running BBB headless, control through uart and SSH
* usb1 has a hub with one to three wireless plugs
* 1.5A 5V power source

Goal is a low-cost wifi monitor where the wifi plug runs with two interfaces: one in standard 802.11 mode and the second in monitor/otherbss mode capturing all traffic.  I use the netlink iw package to add the second interface and set it to 802.11 monitor mode. I use wireshark to read on that interface and save packets to the sdcard.  The normal interface is used for SSH control/monitor of the BBB.

Initially the system ran okay using the wifi but when I ran the second monitor, it silently reboot at erratic times but all within 3 hours.  There was no cause indication on the console or the logs.  I built a couple versions of the kernel, up to 3.18.0-rc3-bone1, and tried a pre-built RCN image - all showing the same problem.

Jens Peter Schroer emailed me a possible solution, which I have attached, of forcing usb0 to act as a peripheral and not OTG. His solution worked for my configuration.  

It appears there are other configurations that manifest the same silent reboot that the changing of usb0 dr_mode DOES NOT fix.

jens-email-bbb-silent-reboot.txt

Ives van der Flaas

unread,
Nov 15, 2014, 9:06:36 AM11/15/14
to beagl...@googlegroups.com, jpsc...@googlemail.com, dturvene gmail
The problem still isn't fixed on my end, but I've certainly been getting closer. 

I've tried
 - Disabling all watchdog timers in u-boot and Linux, still crashes
 - A different 5V power supply, still crashes
 - Disconnecting all USB devices, still crashes

And to ensure I don't have faulty hardware, I tried running on a different BBB (still crashes) as well as changing the kernel to the old 3.8 (does not crash). 

The one thing I have found that actually works, is disabling the custom application that's running all the time. The application uses pcscd to constantly poll (interrupt based wasn't supported) if a smartcard is being inserted. I have to suspect that through these repeated USB reads, I'm somehow triggering the same bug that Jens and David could eliminate by disabling OTG. 

As to how I could actually pinpoint that bug, I really have no idea - the USB subsystem is rather complicated. All help is welcome. 

Op zondag 9 november 2014 19:50:46 UTC+1 schreef david turvene:

terry.b...@googlemail.com

unread,
Nov 19, 2014, 3:20:33 AM11/19/14
to beagl...@googlegroups.com, jpsc...@googlemail.com, dtur...@gmail.com
We have been having a similar problem with an AM335x design using the TPS65217 connected like a Beaglebone black.
We are using the 3.12.10 kernel and saw system resets every 14 hours or so.
We had set the USB ports to be host and peripheral types (in the boards DTB) , however we still saw, on an oscilloscope, pulses on the peripheral's USB VBUS line from OTG probing.
Removing USB support from the kernel appears to fix the reboot problem.
On current investigations, the OTG probing only starts after we load the g_ether module.
To sum up, we think there are issues in at least the 3.12.10 kernel where USB OTG probing still happens even when the USB device is set to peripheral mode.
Am looking at kernel sources to see why this may be so.

Rick Reynolds

unread,
Nov 19, 2014, 4:57:49 PM11/19/14
to beagl...@googlegroups.com
Just an FYI...

We are currently working on a project using Rev C BBB and RCN 3.13.11-bone12 kernel. We had been experiencing random reboots. Sometimes multiple times per day and sometimes once per day, mostly at night. We determined that the reboots were only occuring when the BBB was being powered only from the 5VDC connector. We never saw a reboot when the BBB was either powered from, or just connected to, the USB OTG port.

One of our engineers suggested that it might be a noise issue on the USB OTG port and the way that the TPS65217C PMIC works in the system. The way he explained it to me is that the PMIC is set up to default to the USB OTG port for power. If you leave the USB OTG port open, or floating, while powered from the 5VDC connector and then get noise on the USB OTG port then the PMIC will attempt to switch to USB OTG port and finding that there is no voltage there the system reboots.

What we have done to solve the problem so far: I made a pigtail cable for the USB OTG port that simply ties the shield, ground and 5VDC together. There is no 5VDC on the USB OTG port when not connected to a host machine. Not a great final solution but it did prove the theory. With the pigtail installed we never get reboots, it's been tested on several BBBs now and is very consistent. So, reboots regularly without the pigtail and never with the pigtail installed.

One other thing to note... On the schematic there are 4.7uF caps from both the USB OTG and 5VDC lines to ground. We were thinking that this could allow some relatively high frequency noise to pass to the PMIC. I don't know what the response time, that would cause a switch over, is on the PMIC. It's possible that something on the order of a .01uF - .1uF cap from the USB OTG 5VDC line to ground might also solve the problem. This has not been tested yet however.

Hope this helps...

Robert Nelson

unread,
Nov 19, 2014, 5:06:09 PM11/19/14
to Beagle Board

terry.b...@googlemail.com

unread,
Nov 20, 2014, 4:35:56 AM11/20/14
to beagl...@googlegroups.com
Hi Rick the "noise issue on the USB OTG" in our case appears to be due to USB OTG device probing. We see the VBUS (+5V) line pulsing high for a short period once every 2 seconds or so.When a USB controller is set to OTG and it doesn't see 5V on its VBUS input (ie no host computer is connected) then as far as I am aware, it then powers the VBUS (+5V) line on once every 2 seconds so that it can power a peripheral; USB device to see if any are present. On the Beaglebone design (and our design) the USB's VBUS line is connected to the TPS65217's USB power in line.
However the USB's VBUS is connected to the AM335x's USB0_VBUS line which should only be an input (it has the USB0_DRVVBUS which should be used to enable 5V power). So why the USB0_VBUS is pulsing I do not know (AM335x bug or is the Linux kernel commanding the TPS65217 to connect the USB input to SYS_5V ?).

So ideally you shoud set the USB controller to be fixed to peripheral mode instead of OTG mode rather than short this line. Another option might be to increase the value of the resistor connected in series with the USB0_VBUS CPU line if somehow the CPU is driving this line.
I would have thought that the TPS65217 should prioritise AC input rather than USB, but the datasheet does not seem to mention this so maybe it just switches to the one that has a power up edge (TPS65217 issue ?) ?
However when we have set the USB controller to peripheral mode it still pulses the VBUS line. Removing the USB drivers completely eliminates the issue.

RobertCNelson
thanks for the info, but we already have "dr_mode" set to "peripheral" in the systems DTB file. When the system first powers up there is no USB OTG probing (oscilloscope connected) but once we load the g_ether USB gadget driver the USB0 port begins OTG probing so I suspect some kernel issue in at least 3.12.10 as well as some AM335x issue. Will carry on digging into the kernel sources and try a very recent kernel.

terry.b...@googlemail.com

unread,
Nov 20, 2014, 8:35:49 AM11/20/14
to beagl...@googlegroups.com
Ok, I have now got somewhere with this. What seems to be happening at least on our custom design (similar to BBB) is:
  1. We have an oscilloscope on the USB0 VBUS line.
  2. We have set the USB0 controller's mode to "peripheral" using the DTB's dr_mode setting.
  3. When the g_ether gadget's module is loaded into the kernel the VBUS line begins pulsing high (about 2V) once every 2 seconds. It appears that the g_ether module causes the USB0 controller to ignore its "peripheral" status and go into "otg" mode. I think in OTG mode the USB0 pulses the VBUS line to check on the capacitance of the line and thus see if a slave devise is attached. If one is the USB controller will go into host mode. It can't really do this on our board as there is no ability to power the VBUS line.
  4. As the USB0 VBUS line is connected to the TPS65217's USB power input it sees this pulsing. I guess once in a while it decides to move to USB power and this fails so the system reboots.
If this is the case a few things at fault here I think.
  1. The TPS65217 should prioritise AC power over USB power and thus not try to switch to USB power when AC power is present and not switch on mere pulses (chip bug ?)
  2. The Linux USB stack (musb driver ?) should not allow the USB controller to go into OTG mode when set to "host" or "peripheral". This may be in the musb driver or g_ether module ? (Linux kernel bug ?)
  3. The AM335x (we are using an AM3358BZCZ) CPU appears to drive the USB0 VBUS line (we have changed the in-series resistor to 1k and can see the pin driving), possibly with a current source, in order to check for VBUS capacitance. The AM335x manual states this line is an analogue input only not an output. So there is a documentation  discrepancy there. (documentation bug ?)
Fixes are (I think):
1. Look at the Linux kernel to try and see why it goes into OTG mode when the g_ether module (may be other cases as well)  is loaded and stop this happening when the device is set to "peripheral" mode. We are using 3.12.10 maybe this has been fixed in later versions ?
2. Increase the value of the CPU's VBUS pins series resistor (maybe 10k ?). Not sure if this will work yet.

david turvene

unread,
Nov 22, 2014, 6:12:17 PM11/22/14
to beagl...@googlegroups.com, terry.b...@googlemail.com
On Thursday, November 20, 2014 8:35:49 AM UTC-5, terry.b...@googlemail.com wrote:
Ok, I have now got somewhere with this. What seems to be happening at least on our custom design (similar to BBB) is:
  1. We have an oscilloscope on the USB0 VBUS line.
  2. We have set the USB0 controller's mode to "peripheral" using the DTB's dr_mode setting.
  3. When the g_ether gadget's module is loaded into the kernel the VBUS line begins pulsing high (about 2V) once every 2 seconds. It appears that the g_ether module causes the USB0 controller to ignore its "peripheral" status and go into "otg" mode. I think in OTG mode the USB0 pulses the VBUS line to check on the capacitance of the line and thus see if a slave devise is attached. If one is the USB controller will go into host mode. It can't really do this on our board as there is no ability to power the VBUS line.
  4. As the USB0 VBUS line is connected to the TPS65217's USB power input it sees this pulsing. I guess once in a while it decides to move to USB power and this fails so the system reboots.
If this is the case a few things at fault here I think.
  1. The TPS65217 should prioritise AC power over USB power and thus not try to switch to USB power when AC power is present and not switch on mere pulses (chip bug ?)
  2. The Linux USB stack (musb driver ?) should not allow the USB controller to go into OTG mode when set to "host" or "peripheral". This may be in the musb driver or g_ether module ? (Linux kernel bug ?)
  3. The AM335x (we are using an AM3358BZCZ) CPU appears to drive the USB0 VBUS line (we have changed the in-series resistor to 1k and can see the pin driving), possibly with a current source, in order to check for VBUS capacitance. The AM335x manual states this line is an analogue input only not an output. So there is a documentation  discrepancy there. (documentation bug ?)
Fixes are (I think):
1. Look at the Linux kernel to try and see why it goes into OTG mode when the g_ether module (may be other cases as well)  is loaded and stop this happening when the device is set to "peripheral" mode. We are using 3.12.10 maybe this has been fixed in later versions ?
2. Increase the value of the CPU's VBUS pins series resistor (maybe 10k ?). Not sure if this will work yet.

Well, this post seem to be the definitive investigation of the problem.  I admire the persistence and follow-up documentation.  

I'm running a custom build off RCN github 3.18.0-rc3-bone1 and my system has run as expected since I changed USB0 to "peripheral", in a variety of stressed wifi chip configs slaved on a USB hub (e.g. one in normal mode, another in 802.11 RFMON mode - which overwhelms the single-core CPU.) I'm used a mix of wifi chips from Realtek and Ralink.  And I'd love to investigate the whole gadget layer more....

So, my question is: what impact does the behavior have when USB0 is in "peripheral" mode? Is it a debilitating bug?  I'm just not familiar enough with USB to understand the impact.

Dave

William Hermans

unread,
Nov 22, 2014, 6:54:24 PM11/22/14
to beagl...@googlegroups.com
Just a quick google search, but the "automatic reboot" portion of the second "answer" got my attention.

http://stackoverflow.com/questions/20467010/usb0-changed-the-mode-due-to-emi-using-am1808

Also for what it is worth, I've "booted" my BBB via external / self powered USB
 Hard drive in the past, and let it idle with the occasional tinkering of the rootfs with no problems at all. The kernel i used was 3.8.13-bone21 converted to a uImage( have not done this recently, as I find NFS root much handier).

Also for what it is worth, I have always powered my beaglebone black via the Mini USB port. Which is an A5A.

--
For more options, visit http://beagleboard.org/discuss
---
You received this message because you are subscribed to the Google Groups "BeagleBoard" group.
To unsubscribe from this group and stop receiving emails from it, send an email to beagleboard...@googlegroups.com.

terry.b...@googlemail.com

unread,
Nov 24, 2014, 3:15:35 AM11/24/14
to beagl...@googlegroups.com, terry.b...@googlemail.com
I have just ported Linux kernel 3.17.3 to our board. This stops the system going into OTG probing when the g_ether module is loaded. It still does a single OTG probe when initially loaded but there is no every 2 seconds probe.
If this fixes things for all USB modules, I don't know and I don't know in which kernel version between 3.12.10 and 3.17.3 it was fixed.
Not sure if the vanilla kernel 3.17.3 will work on the Beaglebone.
Reply all
Reply to author
Forward
0 new messages