3.17.1-rc4 sudden reset

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

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

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

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,

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

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.

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.

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.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© 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 © 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: © 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.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 implementationlocal’ 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.6p5@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.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]: 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]: update_system_hostname
Oct 16 12:20:01 base-programmer NetworkManager[319]: interface-parser: parsing file /etc/network/interfaces
Oct 16 12:20:01 base-programmer NetworkManager[319]: interface-parser: finished parsing file /etc/network/interfaces
Oct 16 12:20:01 base-programmer NetworkManager[319]: 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]: 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]: addresses count: 1
Oct 16 12:20:01 base-programmer NetworkManager[319]: No dns-nameserver configured in /etc/network/interfaces
Oct 16 12:20:01 base-programmer NetworkManager[319]: adding eth0 to connections
Oct 16 12:20:01 base-programmer NetworkManager[319]: adding iface eth0 to eni_ifaces
Oct 16 12:20:01 base-programmer NetworkManager[319]: autoconnect
Oct 16 12:20:01 base-programmer NetworkManager[319]: management mode: unmanaged
Oct 16 12:20:01 base-programmer NetworkManager[319]: 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]: 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]: 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]: 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]: 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]: 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]: end _init.
Oct 16 12:20:01 base-programmer NetworkManager[319]: Loaded plugin ifupdown: © 2008 Canonical Ltd. To report bugs please use the NetworkManager mailing list.
Oct 16 12:20:01 base-programmer NetworkManager[319]: Loaded plugin keyfile: © 2007 - 2013 Red Hat, Inc. To report bugs please use the NetworkManager mailing list.
Oct 16 12:20:01 base-programmer NetworkManager[319]: (14303312) … get_connections.
Oct 16 12:20:01 base-programmer NetworkManager[319]: (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]: new connection /etc/NetworkManager/system-connections/awthcb
Oct 16 12:20:01 base-programmer NetworkManager[319]: get unmanaged devices count: 1
Oct 16 12:20:01 base-programmer NetworkManager[319]: monitoring kernel firmware directory ‘/lib/firmware’.
Oct 16 12:20:01 base-programmer NetworkManager[319]: monitoring ifupdown state file ‘/run/network/ifstate’.
Oct 16 12:20:01 base-programmer NetworkManager[319]: WiFi hardware radio set enabled
Oct 16 12:20:01 base-programmer NetworkManager[319]: WWAN hardware radio set enabled
Oct 16 12:20:01 base-programmer NetworkManager[319]: Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-wwan.so
Oct 16 12:20:01 base-programmer NetworkManager[319]: Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-bluetooth.so
Oct 16 12:20:01 base-programmer NetworkManager[319]: Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-wifi.so
Oct 16 12:20:01 base-programmer NetworkManager[319]: Loaded device plugin: /usr/lib/arm-linux-gnueabihf/NetworkManager/libnm-device-plugin-adsl.so
Oct 16 12:20:01 base-programmer NetworkManager[319]: WiFi enabled by radio killswitch; enabled by state file
Oct 16 12:20:01 base-programmer NetworkManager[319]: WWAN enabled by radio killswitch; enabled by state file
Oct 16 12:20:01 base-programmer NetworkManager[319]: WiMAX enabled by radio killswitch; enabled by state file
Oct 16 12:20:01 base-programmer NetworkManager[319]: Networking is enabled by state file
Oct 16 12:20:01 base-programmer NetworkManager[319]: (lo): link connected
Oct 16 12:20:01 base-programmer NetworkManager[319]: (lo): carrier is ON
Oct 16 12:20:01 base-programmer NetworkManager[319]: (lo): new Generic device (driver: ‘unknown’ ifindex: 1)
Oct 16 12:20:01 base-programmer NetworkManager[319]: (lo): exported as /org/freedesktop/NetworkManager/Devices/0
Oct 16 12:20:01 base-programmer NetworkManager[319]: (eth0): carrier is OFF
Oct 16 12:20:01 base-programmer NetworkManager[319]: (eth0): new Ethernet device (driver: ‘cpsw’ ifindex: 2)
Oct 16 12:20:01 base-programmer NetworkManager[319]: (eth0): exported as /org/freedesktop/NetworkManager/Devices/1
Oct 16 12:20:01 base-programmer NetworkManager[319]: startup complete
Oct 16 12:20:01 base-programmer NetworkManager[319]: NetworkManager state is now CONNECTED_GLOBAL
Oct 16 12:20:01 base-programmer NetworkManager[319]: (eth1): carrier is OFF
Oct 16 12:20:01 base-programmer NetworkManager[319]: (eth1): new Ethernet device (driver: ‘asix’ ifindex: 3)
Oct 16 12:20:01 base-programmer NetworkManager[319]: (eth1): exported as /org/freedesktop/NetworkManager/Devices/2
Oct 16 12:20:01 base-programmer NetworkManager[319]: (eth1): device state change: unmanaged → unavailable (reason ‘managed’) [10 20 2]
Oct 16 12:20:01 base-programmer NetworkManager[319]: (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]: (eth1): created default wired connection ‘Wired connection 1’
Oct 16 12:20:01 base-programmer NetworkManager[319]: 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]: 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]: (usb0): carrier is OFF
Oct 16 12:20:01 base-programmer NetworkManager[319]: (usb0): new Ethernet device (driver: ‘musb-hdrc’ ifindex: 4)
Oct 16 12:20:01 base-programmer NetworkManager[319]: (usb0): exported as /org/freedesktop/NetworkManager/Devices/3
Oct 16 12:20:01 base-programmer NetworkManager[319]: (usb0): device state change: unmanaged → unavailable (reason ‘managed’) [10 20 2]
Oct 16 12:20:01 base-programmer NetworkManager[319]: (usb0): preparing device
Oct 16 12:20:01 base-programmer NetworkManager[319]: (usb0): created default wired connection ‘Wired connection 2’
Oct 16 12:20:02 base-programmer NetworkManager[319]: 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]: (eth1): link connected
Oct 16 12:20:02 base-programmer NetworkManager[319]: (eth1): device state change: unavailable → disconnected (reason ‘carrier-changed’) [20 30 40]
Oct 16 12:20:02 base-programmer NetworkManager[319]: Auto-activating connection ‘Wired connection 1’.
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) starting connection ‘Wired connection 1’
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Stage 1 of 5 (Device Prepare) scheduled…
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Stage 1 of 5 (Device Prepare) started…
Oct 16 12:20:02 base-programmer NetworkManager[319]: (eth1): device state change: disconnected → prepare (reason ‘none’) [30 40 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Stage 2 of 5 (Device Configure) scheduled…
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Stage 1 of 5 (Device Prepare) complete.
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Stage 2 of 5 (Device Configure) starting…
Oct 16 12:20:02 base-programmer NetworkManager[319]: (eth1): device state change: prepare → config (reason ‘none’) [40 50 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Stage 2 of 5 (Device Configure) successful.
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Stage 3 of 5 (IP Configure Start) scheduled.
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Stage 2 of 5 (Device Configure) complete.
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Stage 3 of 5 (IP Configure Start) started…
Oct 16 12:20:02 base-programmer NetworkManager[319]: (eth1): device state change: config → ip-config (reason ‘none’) [50 70 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Beginning DHCPv4 transaction (timeout in 45 seconds)
Oct 16 12:20:02 base-programmer NetworkManager[319]: dhclient started with pid 480
Oct 16 12:20:02 base-programmer NetworkManager[319]: 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]: (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]: (eth1): DHCPv4 state changed preinit → bound
Oct 16 12:20:02 base-programmer NetworkManager[319]: address 192.168.1.182
Oct 16 12:20:02 base-programmer NetworkManager[319]: plen 24 (255.255.255.0)
Oct 16 12:20:02 base-programmer NetworkManager[319]: classless static route 10.8.0.0/24 gw 192.168.1.98
Oct 16 12:20:02 base-programmer NetworkManager[319]: gateway 192.168.1.1
Oct 16 12:20:02 base-programmer NetworkManager[319]: server identifier 192.168.1.2
Oct 16 12:20:02 base-programmer NetworkManager[319]: lease time 86400
Oct 16 12:20:02 base-programmer NetworkManager[319]: hostname ‘base-programmer’
Oct 16 12:20:02 base-programmer NetworkManager[319]: nameserver ‘192.168.1.2’
Oct 16 12:20:02 base-programmer NetworkManager[319]: 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]: Activation (eth1) Stage 5 of 5 (IPv4 Configure Commit) scheduled…
Oct 16 12:20:02 base-programmer NetworkManager[319]: Activation (eth1) Stage 5 of 5 (IPv4 Commit) started…
Oct 16 12:20:02 base-programmer NetworkManager[319]: (eth1): device state change: ip-config → ip-check (reason ‘none’) [70 80 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: 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]: (eth1): device state change: ip-check → secondaries (reason ‘none’) [80 90 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: (eth1): device state change: secondaries → activated (reason ‘none’) [90 100 0]
Oct 16 12:20:02 base-programmer NetworkManager[319]: Policy set ‘Wired connection 1’ (eth1) as default for IPv4 routing and DNS.
Oct 16 12:20:02 base-programmer NetworkManager[319]: 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]: 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 systemd[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?

I just had another reboot on 3.18-rc2-bone1

I can confirm that the problem still exists on the 3.18-rc2-bone1.

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.

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

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:

https://eewiki.net/display/linuxonarm/BeagleBone+Black#BeagleBoneBlack-Bootloader:U-Boot

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…

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.

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.

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.

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.

If interested, I can post more details.

@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

@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).