Bootlog of nfsroot

bootlog_pi2_nfsroot.txt

Uncompressing Linux... done, booting the kernel.
?
Welcome to the rescue system
recovery login: Uncompressing Linux... done, booting the kernel.
[    0.000000] Booting Linux on physical CPU 0xf00
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Initializing cgroup subsys cpuacct
[    0.000000] Linux version 4.1.7-v7+ (koba@f0a4f48bb49b) (gcc version 4.8.3 20140303 (prerelease) (crosstool-NG linaro-1.13.1+bzr2650 - Linaro GCC 2014.03) ) #2 SMP PREEMPT Wed Sep 23 11:39:37 JST 2015
[    0.000000] CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c5387d
[    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
[    0.000000] Machine model: Raspberry Pi 2 Model B
[    0.000000] cma: Reserved 8 MiB at 0x3a800000
[    0.000000] Memory policy: Data cache writealloc
[    0.000000] [bcm2709_smp_init_cpus] enter (9420->f3003010)
[    0.000000] [bcm2709_smp_init_cpus] ncores=4
[    0.000000] PERCPU: Embedded 13 pages/cpu @b9f64000 s20608 r8192 d24448 u53248
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 239540
[    0.000000] Kernel command line: dma.dmachans=0x7f35 bcm2708_fb.fbwidth=592 bcm2708_fb.fbheight=448 bcm2709.boardrev=0xa01041 bcm2709.serial=0xf6b0477e smsc95xx.macaddr=B8:27:EB:B0:47:7E bcm2708_fb.fbswap=1 bcm2709.disk_led_gpio=47 bcm2709.disk_led_active_low=0 sdhci-bcm2708.emmc_clock_freq=250000000 vc_mem.mem_base=0x3dc00000 vc_mem.mem_size=0x3f000000  dwc_otg.lpm_enable=0 console=ttyAMA0,115200 root=/dev/nfs nfsroot=192.168.0.6:/export/raspbian/root rw ip=dhcp elevator=deadline rootwait
[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Memory: 939512K/966656K available (5958K kernel code, 534K rwdata, 1648K rodata, 416K init, 757K bss, 18952K reserved, 8192K cma-reserved)
[    0.000000] Virtual kernel memory layout:
[    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
[    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
[    0.000000]     vmalloc : 0xbb800000 - 0xff000000   (1080 MB)
[    0.000000]     lowmem  : 0x80000000 - 0xbb000000   ( 944 MB)
[    0.000000]     modules : 0x7f000000 - 0x80000000   (  16 MB)
[    0.000000]       .text : 0x80008000 - 0x80775cd0   (7608 kB)
[    0.000000]       .init : 0x80776000 - 0x807de000   ( 416 kB)
[    0.000000]       .data : 0x807de000 - 0x80863af4   ( 535 kB)
[    0.000000]        .bss : 0x80866000 - 0x8092378c   ( 758 kB)
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] Preemptible hierarchical RCU implementation.
[    0.000000] 	Additional per-CPU info printed with stalls.
[    0.000000] NR_IRQS:608
[    0.000000] Architected cp15 timer(s) running at 19.20MHz (virt).
[    0.000000] clocksource arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
[    0.000010] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
[    0.000032] Switching to timer-based delay loop, resolution 52ns
[    0.000325] Console: colour dummy device 80x30
[    0.000367] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
[    0.000391] pid_max: default: 32768 minimum: 301
[    0.000723] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.000744] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[    0.002009] Initializing cgroup subsys blkio
[    0.002049] Initializing cgroup subsys memory
[    0.002084] Initializing cgroup subsys devices
[    0.002110] Initializing cgroup subsys freezer
[    0.002151] Initializing cgroup subsys net_cls
[    0.002224] CPU: Testing write buffer coherency: ok
[    0.002308] ftrace: allocating 20207 entries in 60 pages
[    0.051849] CPU0: update cpu_capacity 1024
[    0.051886] CPU0: thread -1, cpu 0, socket 15, mpidr 80000f00
[    0.051905] [bcm2709_smp_prepare_cpus] enter
[    0.052040] Setting up static identity map for 0x8240 - 0x8274
[    0.111742] [bcm2709_boot_secondary] cpu:1 started (0) 18
[    0.112171] [bcm2709_secondary_init] enter cpu:1
[    0.112222] CPU1: update cpu_capacity 1024
[    0.112230] CPU1: thread -1, cpu 1, socket 15, mpidr 80000f01
[    0.131716] [bcm2709_boot_secondary] cpu:2 started (0) 18
[    0.132072] [bcm2709_secondary_init] enter cpu:2
[    0.132103] CPU2: update cpu_capacity 1024
[    0.132111] CPU2: thread -1, cpu 2, socket 15, mpidr 80000f02
[    0.151759] [bcm2709_boot_secondary] cpu:3 started (0) 17
[    0.152012] [bcm2709_secondary_init] enter cpu:3
[    0.152040] CPU3: update cpu_capacity 1024
[    0.152048] CPU3: thread -1, cpu 3, socket 15, mpidr 80000f03
[    0.152143] Brought up 4 CPUs
[    0.152173] SMP: Total of 4 processors activated (153.60 BogoMIPS).
[    0.152184] CPU: All CPU(s) started in SVC mode.
[    0.153197] devtmpfs: initialized
[    0.178033] VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5
[    0.178362] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.179477] pinctrl core: initialized pinctrl subsystem
[    0.180286] NET: Registered protocol family 16
[    0.186030] DMA: preallocated 4096 KiB pool for atomic coherent allocations
[    0.187214] bcm2709.uart_clock = 3000000
[    0.192488] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[    0.192504] hw-breakpoint: maximum watchpoint size is 8 bytes.
[    0.192697] Serial: AMBA PL011 UART driver
[    0.192883] 3f201000.uart: ttyAMA0 at MMIO 0x3f201000 (irq = 83, base_baud = 0) is a PL011 rev2
[    0.690098] console [ttyAMA0] enabled
[    0.694332] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
[    0.774292] bcm2708-dmaengine 3f007000.dma: DMA legacy API manager at f3007000, dmachans=0xf35
[    0.782995] bcm2708-dmaengine 3f007000.dma: Initialized 7 DMA channels (+ 1 legacy)
[    0.791353] bcm2708-dmaengine 3f007000.dma: Load BCM2835 DMA engine driver
[    0.798244] bcm2708-dmaengine 3f007000.dma: dma_debug:0
[    0.804190] SCSI subsystem initialized
[    0.808175] usbcore: registered new interface driver usbfs
[    0.813775] usbcore: registered new interface driver hub
[    0.819221] usbcore: registered new device driver usb
[    0.824984] raspberrypi-firmware soc:firmware: Attached to firmware from 2015-04-21 14:42
[    1.335473] Switched to clocksource arch_sys_counter
[    1.389506] FS-Cache: Loaded
[    1.392752] CacheFiles: Loaded
[    1.407528] NET: Registered protocol family 2
[    1.413192] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[    1.420418] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[    1.427107] TCP: Hash tables configured (established 8192 bind 8192)
[    1.433571] UDP hash table entries: 512 (order: 2, 16384 bytes)
[    1.439568] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
[    1.446299] NET: Registered protocol family 1
[    1.451087] RPC: Registered named UNIX socket transport module.
[    1.457074] RPC: Registered udp transport module.
[    1.461775] RPC: Registered tcp transport module.
[    1.466506] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    1.474159] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counters available
[    1.483711] futex hash table entries: 1024 (order: 4, 65536 bytes)
[    1.505792] VFS: Disk quotas dquot_6.6.0
[    1.510096] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    1.519652] FS-Cache: Netfs 'nfs' registered for caching
[    1.526170] NFS: Registering the id_resolver key type
[    1.531284] Key type id_resolver registered
[    1.535501] Key type id_legacy registered
[    1.542316] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    1.549946] io scheduler noop registered
[    1.553882] io scheduler deadline registered (default)
[    1.559361] io scheduler cfq registered
[    1.565841] BCM2708FB: allocated DMA memory fac00000
[    1.570835] BCM2708FB: allocated DMA channel 0 @ f3007000
[    1.581746] Console: switching to colour frame buffer device 74x28
[    1.591557] Serial: 8250/16550 driver, 0 ports, IRQ sharing disabled
[    1.599238] vc-cma: Videocore CMA driver
[    1.603160] vc-cma: vc_cma_base      = 0x00000000
[    1.607889] vc-cma: vc_cma_size      = 0x00000000 (0 MiB)
[    1.613280] vc-cma: vc_cma_initial   = 0x00000000 (0 MiB)
[    1.618940] vc-mem: phys_addr:0x00000000 mem_base=0x3dc00000 mem_size:0x3f000000(1008 MiB)
[    1.642885] brd: module loaded
[    1.654906] loop: module loaded
[    1.659156] vchiq: vchiq_init_state: slot_zero = 0xbac80000, is_master = 0
[    1.667068] bcm2835_vchiq 3f00b840.vchiq: failed to set channelbase
[    1.673683] vchiq: could not load vchiq
[    1.677657] bcm2835_vchiq: probe of 3f00b840.vchiq failed with error -1178945280
[    1.685180] Loading iSCSI transport class v2.0-870.
[    1.690991] usbcore: registered new interface driver smsc95xx
[    1.696826] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    1.902931] Core Release: 2.80a
[    1.906110] Setting default values for core params
[    1.910932] Finished setting default values for core params
[    2.116918] Using Buffer DMA mode
[    2.120233] Periodic Transfer Interrupt Enhancement - disabled
[    2.126079] Multiprocessor Interrupt Enhancement - disabled
[    2.131644] OTG VER PARAM: 0, OTG VER FLAG: 0
[    2.136021] Dedicated Tx FIFOs mode
[    2.139846] WARN::dwc_otg_hcd_init:1047: FIQ DMA bounce buffers: virt = 0xbac14000 dma = 0xfac14000 len=9024
[    2.149719] FIQ FSM acceleration enabled for :
[    2.149719] Non-periodic Split Transactions
[    2.149719] Periodic Split Transactions
[    2.149719] High-Speed Isochronous Endpoints
[    2.166491] WARN::hcd_init_fiq:412: FIQ on core 1 at 0x80401108
[    2.172409] WARN::hcd_init_fiq:413: FIQ ASM at 0x80401464 length 36
[    2.178672] WARN::hcd_init_fiq:438: MPHI regs_base at 0xbb89a000
[    2.184737] dwc_otg 3f980000.usb: DWC OTG Controller
[    2.189764] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
[    2.197122] dwc_otg 3f980000.usb: irq 32, io mem 0x00000000
[    2.202727] Init: Port Power? op_state=1
[    2.206670] Init: Power Port (0)
[    2.210191] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    2.217007] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    2.224223] usb usb1: Product: DWC OTG Controller
[    2.228952] usb usb1: Manufacturer: Linux 4.1.7-v7+ dwc_otg_hcd
[    2.234866] usb usb1: SerialNumber: 3f980000.usb
[    2.240379] hub 1-0:1.0: USB hub found
[    2.244180] hub 1-0:1.0: 1 port detected
[    2.249123] usbcore: registered new interface driver usb-storage
[    2.255379] mousedev: PS/2 mouse device common for all mice
[    2.261859] bcm2835-cpufreq: min=600000 max=900000
[    2.267026] sdhci: Secure Digital Host Controller Interface driver
[    2.273198] sdhci: Copyright(c) Pierre Ossman
[    2.278033] mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0
[    2.283864] mmc-bcm2835 3f300000.mmc: DMA channels allocated
[    2.325841] sdhci-pltfm: SDHCI platform and OF driver helper
[    2.337563] ledtrig-cpu: registered to indicate activity on CPUs
[    2.343871] hidraw: raw HID events driver (C) Jiri Kosina
[    2.350641] usbcore: registered new interface driver usbhid
[    2.356330] usbhid: USB HID core driver
[    2.360641] Initializing XFRM netlink socket
[    2.365004] NET: Registered protocol family 17
[    2.373062] Key type dns_resolver registered
[    2.378010] Registering SWP/SWPB emulation handler
[    2.383792] registered taskstats version 1
[    2.388201] vc-sm: Videocore shared memory driver
[    2.403370] mmc0: host does not support reading read-only switch, assuming write-enable
[    2.413666] mmc0: new high speed SDHC card at address 1234
[    2.419767] mmcblk0: mmc0:1234 SA08G 7.28 GiB 
[    2.429950]  mmcblk0: p1 p2 < p5 p6 p7 > p3
[    2.445645] Indeed it is in host mode hprt0 = 00021501
[    2.625514] usb 1-1: new high-speed USB device number 2 using dwc_otg
[    2.632127] Indeed it is in host mode hprt0 = 00001101
[    2.835865] usb 1-1: New USB device found, idVendor=0424, idProduct=9514
[    2.842567] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    2.850557] hub 1-1:1.0: USB hub found
[    2.854424] hub 1-1:1.0: 5 ports detected
[    3.135515] usb 1-1.1: new high-speed USB device number 3 using dwc_otg
[    3.255838] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
[    3.262713] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[    3.272852] smsc95xx v1.0.4
[    3.339654] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:b0:47:7e
[    3.458191] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
[    4.909899] smsc95xx 1-1.1:1.0 eth0: link up, 100Mbps, full-duplex, lpa 0x41E1
[    4.945511] Sending DHCP requests ., OK
[    5.265526] IP-Config: Got DHCP answer from 192.168.0.1, my address is 192.168.0.8
[    5.273382] IP-Config: Complete:
[    5.276726]      device=eth0, hwaddr=b8:27:eb:b0:47:7e, ipaddr=192.168.0.8, mask=255.255.255.0, gw=192.168.0.1
[    5.286813]      host=192.168.0.8, domain=, nis-domain=(none)
[    5.292571]      bootserver=0.0.0.0, rootserver=192.168.0.6, rootpath=
[    5.299004]      nameserver0=192.168.0.1
[    5.303411] uart-pl011 3f201000.uart: no DMA platform data
[    5.436042] VFS: Mounted root (nfs filesystem) on device 0:15.
[    5.443553] devtmpfs: mounted
[    5.447342] Freeing unused kernel memory: 416K (80776000 - 807de000)
INIT: version 2.88 booting
[    6.673402] random: nonblocking pool is initialized
[info] Using makefile-style concurrent boot in runlevel S.
[....] Starting the hotplug events dispatcher: udevd[    8.635611] udevd[174]: starting version 175
. ok 
[....] Synthesizing the initial hotplug events...[   10.043831] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
[ ok                                             done.
[ ok ] Waiting for /dev to be fully populated...done.
Starting fake hwclock: loading system time.
Wed Sep 23 07:07:07 UTC 2015
[ ok ] Setting preliminary keymap...done.
[ ok ] Activating swap...done.
[ ok ] Cleaning up temporary files... /tmp.
[info] Loading kernel module snd-bcm2835.
[ ok ] Activating lvm and md swap...done.
[....] Checking file systems...fsck from util-linux 2.20.1
dosfsck 3.0.13, 30 Jun 2012, FAT32, LFN
/dev/mmcblk0p6: 104 files, 15818/30651 clusters
done.
[ ok ] Mounting local filesystems...done.
[ ok ] Activating swapfile swap...done.
[ ok ] Cleaning up temporary files....
[ ok ] Setting kernel variables ...done.
[....] Configuring network interfaces...wpa_supplicant: /sbin/wpa_supplicant daemon failed to start
run-parts: /etc/network/if-pre-up.d/wpasupplicant exited with return code 1
wpa_supplicant: /sbin/wpa_supplicant daemon failed to start
run-parts: /etc/network/if-pre-up.d/wpasupplicant exited with return code 1
ifup: interface eth0 already configured
done.
[ ok ] Cleaning up temporary files....
[ ok ] Setting up ALSA...done.
[info] Setting console screen modes.
setterm: cannot (un)set powersave mode: Inappropriate ioctl for device
[info] Skipping font and keymap setup (handled by console-setup).
[ ok ] Setting up console font and keymap...done.
[ ok ] Setting up X socket directories... /tmp/.X11-unix /tmp/.ICE-unix.
INIT: Entering runlevel: 2
[info] Using makefile-style concurrent boot in runlevel 2.
Error opening '/dev/input/event*': No such file or directory
[ ok ] Network Interface Plugging Daemon...skip eth0...done.
[info] Initializing cgroups.
[warn] Kernel lacks cgroups or memory controller not available, not starting cgroups. ... (warning).
[ ok ] Starting enhanced syslogd: rsyslogd.
Starting dphys-swapfile swapfile setup ...
want /var/swap=100MByte, checking existing: keeping it
done.
[ ok ] Starting NTP server: ntpd.
[ ok ] Starting periodic command scheduler: cron.
[ ok ] Starting system message bus: dbus.
[ ok ] Starting OpenBSD Secure Shell server: sshd.
[ ok ] Starting Avahi mDNS/DNS-SD Daemon: avahi-daemon.
dhcpcd[1866]: version 6.7.1 starting
dhcpcd[1866]: all: IPv6 kernel autoconf disabled
dhcpcd[1866]: eth0: adding address fe80::97b1:1c56:4f56:ebe5
dhcpcd[1866]: if_addaddress6: Operation not supported
dhcpcd[1866]: DUID 00:01:00:01:1c:dd:60:65:b8:27:eb:b0:47:7e
dhcpcd[1866]: eth0: IAID eb:b0:47:7e
dhcpcd[1866]: eth0: rebinding lease of 192.168.0.7
dhcpcd[1866]: eth0: leased 192.168.0.7 for 3600 seconds
dhcpcd[1866]: eth0: adding route to 192.168.0.0/24
dhcpcd[1866]: eth0: adding default route via 192.168.0.1
dhcpcd[1866]: forked to background, child pid 2203
My IP address is 192.168.0.8 192.168.0.7 

Raspbian GNU/Linux 7 raspberrypi ttyAMA0

raspberrypi login: pi
Password: 
Last login: Wed Sep 23 15:44:22 JST 2015 on ttyAMA0
Linux raspberrypi 4.1.7-v7+ #2 SMP PREEMPT Wed Sep 23 11:39:37 JST 2015 armv7l

The programs included with the Debian GNU/Linux system are free software;
the exact distribution terms for each program are described in the
individual files in /usr/share/doc/*/copyright.

Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
permitted by applicable law.
pi@raspberrypi:~$ df
Filesystem                        1K-blocks     Used Available Use% Mounted on
192.168.0.6:/export/raspbian/root  71084424 61694912   5755592  92% /
devtmpfs                             469756        0    469756   0% /dev
tmpfs                                 94812      236     94576   1% /run
tmpfs                                  5120        0      5120   0% /run/lock
tmpfs                                189620        0    189620   0% /run/shm
/dev/mmcblk0p6                        61302    31636     29666  52% /boot
pi@raspberrypi:~$