[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 5.4.51-v7+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1333 SMP Mon Aug 10 16:45:19 BST 2020 [ 0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d [ 0.000000] CPU: div instructions available: patching division code [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache [ 0.000000] OF: fdt: Machine model: Raspberry Pi 3 Model B Rev 1.2 [ 0.000000] Memory policy: Data cache writealloc [ 0.000000] Reserved memory: created CMA memory pool at 0x37400000, size 64 MiB [ 0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool [ 0.000000] On node 0 totalpages: 242688 [ 0.000000] Normal zone: 2133 pages used for memmap [ 0.000000] Normal zone: 0 pages reserved [ 0.000000] Normal zone: 242688 pages, LIFO batch:63 [ 0.000000] percpu: Embedded 20 pages/cpu s49856 r8192 d23872 u81920 [ 0.000000] pcpu-alloc: s49856 r8192 d23872 u81920 alloc=20*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 240555 [ 0.000000] Kernel command line: coherent_pool=1M 8250.nr_uarts=1 snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 console=tty1 root=PARTUUID=43ed7bb4-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait [ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear) [ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.000000] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.000000] Memory: 881516K/970752K available (8192K kernel code, 689K rwdata, 2552K rodata, 1024K init, 825K bss, 23700K reserved, 65536K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] ftrace: allocating 28275 entries in 56 pages [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies. [ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16 [ 0.000000] random: get_random_bytes called from start_kernel+0x328/0x500 with crng_init=0 [ 0.000000] arch_timer: cp15 timer(s) running at 19.20MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns [ 0.000007] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns [ 0.000022] Switching to timer-based delay loop, resolution 52ns [ 0.000290] Console: colour dummy device 80x30 [ 0.000864] printk: console [tty1] enabled [ 0.000932] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000) [ 0.000980] pid_max: default: 32768 minimum: 301 [ 0.001381] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) [ 0.001427] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear) [ 0.002812] Disabling memory control group subsystem [ 0.002933] CPU: Testing write buffer coherency: ok [ 0.003512] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 [ 0.004470] Setting up static identity map for 0x100000 - 0x10003c [ 0.004687] rcu: Hierarchical SRCU implementation. [ 0.005383] smp: Bringing up secondary CPUs ... [ 0.006511] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 [ 0.007777] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 [ 0.008923] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 [ 0.009074] smp: Brought up 1 node, 4 CPUs [ 0.009161] SMP: Total of 4 processors activated (153.60 BogoMIPS). [ 0.009189] CPU: All CPU(s) started in HYP mode. [ 0.009214] CPU: Virtualization extensions available. [ 0.010284] devtmpfs: initialized [ 0.026475] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4 [ 0.026764] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 0.026822] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [ 0.029898] pinctrl core: initialized pinctrl subsystem [ 0.031173] NET: Registered protocol family 16 [ 0.035362] DMA: preallocated 1024 KiB pool for atomic coherent allocations [ 0.041637] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. [ 0.041678] hw-breakpoint: maximum watchpoint size is 8 bytes. [ 0.041928] Serial: AMBA PL011 UART driver [ 0.043907] bcm2835-mbox 3f00b880.mailbox: mailbox enabled [ 0.060096] raspberrypi-firmware soc:firmware: Attached to firmware from 2020-08-06 16:24, variant start [ 0.070109] raspberrypi-firmware soc:firmware: Firmware hash is af3edc2de473197cdfe1ff5a8ff2d34095d5b336 [ 0.121731] bcm2835-dma 3f007000.dma: DMA legacy API manager, dmachans=0x1 [ 0.124006] SCSI subsystem initialized [ 0.124283] usbcore: registered new interface driver usbfs [ 0.124365] usbcore: registered new interface driver hub [ 0.124511] usbcore: registered new device driver usb [ 0.126437] clocksource: Switched to clocksource arch_sys_counter [ 1.288041] VFS: Disk quotas dquot_6.6.0 [ 1.288185] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 1.288404] FS-Cache: Loaded [ 1.288690] CacheFiles: Loaded [ 1.299950] thermal_sys: Registered thermal governor 'step_wise' [ 1.300348] NET: Registered protocol family 2 [ 1.301417] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear) [ 1.301492] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear) [ 1.301632] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 1.301842] TCP: Hash tables configured (established 8192 bind 8192) [ 1.302025] UDP hash table entries: 512 (order: 2, 16384 bytes, linear) [ 1.302098] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) [ 1.302411] NET: Registered protocol family 1 [ 1.303137] RPC: Registered named UNIX socket transport module. [ 1.303169] RPC: Registered udp transport module. [ 1.303195] RPC: Registered tcp transport module. [ 1.303220] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.304914] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available [ 1.308356] Initialise system trusted keyrings [ 1.308653] workingset: timestamp_bits=14 max_order=18 bucket_order=4 [ 1.320459] FS-Cache: Netfs 'nfs' registered for caching [ 1.321279] NFS: Registering the id_resolver key type [ 1.321360] Key type id_resolver registered [ 1.321387] Key type id_legacy registered [ 1.321423] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 1.322753] Key type asymmetric registered [ 1.322784] Asymmetric key parser 'x509' registered [ 1.322852] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [ 1.322889] io scheduler mq-deadline registered [ 1.322916] io scheduler kyber registered [ 1.327817] bcm2708_fb soc:fb: FB found 1 display(s) [ 1.339499] Console: switching to colour frame buffer device 82x26 [ 1.346363] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 656x416 [ 1.354867] Serial: 8250/16550 driver, 1 ports, IRQ sharing enabled [ 1.359843] bcm2835-rng 3f104000.rng: hwrng registered [ 1.362933] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB) [ 1.368832] vc-sm: Videocore shared memory driver [ 1.371904] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000 [ 1.390079] brd: module loaded [ 1.405193] loop: module loaded [ 1.409358] Loading iSCSI transport class v2.0-870. [ 1.412866] libphy: Fixed MDIO Bus: probed [ 1.415561] usbcore: registered new interface driver lan78xx [ 1.418364] usbcore: registered new interface driver smsc95xx [ 1.420904] dwc_otg: version 3.00a 10-AUG-2012 (platform bus) [ 2.151634] Core Release: 2.80a [ 2.154075] Setting default values for core params [ 2.156637] Finished setting default values for core params [ 2.359545] Using Buffer DMA mode [ 2.362014] Periodic Transfer Interrupt Enhancement - disabled [ 2.364516] Multiprocessor Interrupt Enhancement - disabled [ 2.366990] OTG VER PARAM: 0, OTG VER FLAG: 0 [ 2.369399] Dedicated Tx FIFOs mode [ 2.372348] WARN::dwc_otg_hcd_init:1074: FIQ DMA bounce buffers: virt = b7504000 dma = 0xf7504000 len=9024 [ 2.377091] FIQ FSM acceleration enabled for : Non-periodic Split Transactions Periodic Split Transactions High-Speed Isochronous Endpoints Interrupt/Control Split Transaction hack enabled [ 2.388163] dwc_otg: Microframe scheduler enabled [ 2.388226] WARN::hcd_init_fiq:457: FIQ on core 1 [ 2.390462] WARN::hcd_init_fiq:458: FIQ ASM at 806d89f4 length 36 [ 2.392707] WARN::hcd_init_fiq:497: MPHI regs_base at bb810000 [ 2.394924] dwc_otg 3f980000.usb: DWC OTG Controller [ 2.397249] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1 [ 2.399612] dwc_otg 3f980000.usb: irq 56, io mem 0x00000000 [ 2.401920] Init: Port Power? op_state=1 [ 2.404168] Init: Power Port (0) [ 2.406739] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04 [ 2.411252] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 2.413668] usb usb1: Product: DWC OTG Controller [ 2.416040] usb usb1: Manufacturer: Linux 5.4.51-v7+ dwc_otg_hcd [ 2.418491] usb usb1: SerialNumber: 3f980000.usb [ 2.421496] hub 1-0:1.0: USB hub found [ 2.423799] hub 1-0:1.0: 1 port detected [ 2.426775] dwc_otg: FIQ enabled [ 2.426785] dwc_otg: NAK holdoff enabled [ 2.426795] dwc_otg: FIQ split-transaction FSM enabled [ 2.426809] Module dwc_common_port init [ 2.427155] usbcore: registered new interface driver usb-storage [ 2.429632] mousedev: PS/2 mouse device common for all mice [ 2.433315] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer [ 2.437954] sdhci: Secure Digital Host Controller Interface driver [ 2.440375] sdhci: Copyright(c) Pierre Ossman [ 2.443296] mmc-bcm2835 3f300000.mmcnr: could not get clk, deferring probe [ 2.446467] sdhost-bcm2835 3f202000.mmc: could not get clk, deferring probe [ 2.449251] sdhci-pltfm: SDHCI platform and OF driver helper [ 2.453627] ledtrig-cpu: registered to indicate activity on CPUs [ 2.456627] hidraw: raw HID events driver (C) Jiri Kosina [ 2.459399] usbcore: registered new interface driver usbhid [ 2.461972] usbhid: USB HID core driver [ 2.465536] vchiq: vchiq_init_state: slot_zero = (ptrval) [ 2.469871] [vc_sm_connected_init]: start [ 2.478666] [vc_sm_connected_init]: end - returning 0 [ 2.483076] Initializing XFRM netlink socket [ 2.485444] NET: Registered protocol family 17 [ 2.487943] Key type dns_resolver registered [ 2.490879] Registering SWP/SWPB emulation handler [ 2.493515] registered taskstats version 1 [ 2.495878] Loading compiled-in X.509 certificates [ 2.498748] Key type ._fscrypt registered [ 2.501043] Key type .fscrypt registered [ 2.513789] uart-pl011 3f201000.serial: cts_event_workaround enabled [ 2.516183] 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 81, base_baud = 0) is a PL011 rev2 [ 2.522715] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver [ 2.526640] mmc-bcm2835 3f300000.mmcnr: mmc_debug:0 mmc_debug2:0 [ 2.529018] mmc-bcm2835 3f300000.mmcnr: DMA channel allocated [ 2.557851] sdhost: log_buf @ (ptrval) (f7507000) [ 2.596173] mmc1: queuing unknown CIS tuple 0x80 (2 bytes) [ 2.600162] mmc1: queuing unknown CIS tuple 0x80 (3 bytes) [ 2.604029] mmc1: queuing unknown CIS tuple 0x80 (3 bytes) [ 2.609104] mmc1: queuing unknown CIS tuple 0x80 (7 bytes) [ 2.611205] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) [ 2.615854] of_cfs_init [ 2.618216] of_cfs_init: OK [ 2.622157] Waiting for root device PARTUUID=43ed7bb4-02... [ 2.646584] Indeed it is in host mode hprt0 = 00021501 [ 2.717954] random: fast init done [ 2.735500] mmc0: host does not support reading read-only switch, assuming write-enable [ 2.743043] mmc0: new high speed SDHC card at address 5048 [ 2.746580] mmcblk0: mmc0:5048 SD16G 14.4 GiB [ 2.752041] mmcblk0: p1 p2 p3 [ 2.777967] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) [ 2.782362] VFS: Mounted root (ext4 filesystem) readonly on device 179:2. [ 2.793175] devtmpfs: mounted [ 2.803336] Freeing unused kernel memory: 1024K [ 2.806862] Run /sbin/init as init process [ 2.809624] mmc1: new high speed SDIO card at address 0001 [ 2.856518] usb 1-1: new high-speed USB device number 2 using dwc_otg [ 2.859203] Indeed it is in host mode hprt0 = 00001101 [ 3.096890] usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00 [ 3.102161] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 3.105801] hub 1-1:1.0: USB hub found [ 3.108769] hub 1-1:1.0: 5 ports detected [ 3.426502] usb 1-1.1: new high-speed USB device number 3 using dwc_otg [ 3.444609] systemd[1]: System time before build time, advancing clock. [ 3.556870] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00 [ 3.562395] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 3.569295] smsc95xx v1.0.6 [ 3.596183] NET: Registered protocol family 10 [ 3.600529] Segment Routing with IPv6 [ 3.651642] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) [ 3.661295] systemd[1]: Detected architecture arm. [ 3.681212] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:4f:fa:b9 [ 3.735092] systemd[1]: Set hostname to . [ 4.679674] systemd[1]: /opt/openenergymonitor/emonpi/lcd/emonPiLCD.service:6: PIDFile= references path below legacy directory /var/run/, updating /var/run/emonpilcd.pid → /run/emonpilcd.pid; please update the unit file accordingly. [ 4.789768] random: systemd: uninitialized urandom read (16 bytes read) [ 4.808140] random: systemd: uninitialized urandom read (16 bytes read) [ 4.811671] systemd[1]: Listening on udev Kernel Socket. [ 4.818727] random: systemd: uninitialized urandom read (16 bytes read) [ 4.824810] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ 4.831569] systemd[1]: Reached target Swap. [ 4.838237] systemd[1]: Listening on initctl Compatibility Named Pipe. [ 4.844794] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ 4.855290] systemd[1]: Created slice User and Session Slice. [ 5.117472] i2c /dev entries driver [ 5.433295] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null) [ 6.127568] mc: Linux media interface: v0.10 [ 6.177662] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. [ 6.183551] videodev: Linux video capture interface: v2.00 [ 6.208808] bcm2835_vc_sm_cma_probe: Videocore shared memory driver [ 6.208830] [vc_sm_connected_init]: start [ 6.210937] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. [ 6.212850] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. [ 6.212971] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. [ 6.215289] [vc_sm_connected_init]: installed successfully [ 6.219641] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. [ 6.225667] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. [ 6.225671] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. [ 6.226372] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. [ 6.233179] bcm2835_audio bcm2835_audio: card created with 8 channels [ 6.235634] bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. [ 6.238090] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. [ 6.260456] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. [ 6.283230] bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 [ 6.284850] bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 [ 6.286318] bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 [ 6.288435] bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 [ 6.288472] bcm2835-isp bcm2835-isp: Register output node 0 with media controller [ 6.288496] bcm2835-isp bcm2835-isp: Register capture node 1 with media controller [ 6.288514] bcm2835-isp bcm2835-isp: Register capture node 2 with media controller [ 6.288531] bcm2835-isp bcm2835-isp: Register capture node 3 with media controller [ 6.288841] bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp [ 6.319643] bcm2835-codec bcm2835-codec: Device registered as /dev/video10 [ 6.319709] bcm2835-codec bcm2835-codec: Loaded V4L2 decode [ 6.324345] bcm2835-codec bcm2835-codec: Device registered as /dev/video11 [ 6.324394] bcm2835-codec bcm2835-codec: Loaded V4L2 encode [ 6.335594] bcm2835-codec bcm2835-codec: Device registered as /dev/video12 [ 6.335656] bcm2835-codec bcm2835-codec: Loaded V4L2 isp [ 6.730135] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 6.918717] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 7.033530] brcmfmac: F1 signature read @0x18000000=0x1541a9a6 [ 7.043614] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 [ 7.043906] usbcore: registered new interface driver brcmfmac [ 7.068659] brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43430-sdio.raspberrypi,3-model-b.txt failed with error -2 [ 7.293518] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 [ 7.293637] brcmfmac: brcmf_c_process_clm_blob: no clm_blob available (err=-2), device may have limited channels available [ 7.294446] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Oct 22 2019 01:59:28 version 7.45.98.94 (r723000 CY) FWID 01-3b33decd [ 8.366834] EXT4-fs (mmcblk0p3): mounting ext2 file system using the ext4 subsystem [ 8.395519] EXT4-fs (mmcblk0p3): mounted filesystem without journal. Opts: (null) [ 8.721075] systemd[1]: Mounted /boot. [ 8.726374] systemd[1]: Reached target Local File Systems. [ 8.728958] systemd[1]: Condition check resulted in Mark the need to relabel after reboot being skipped. [ 8.729178] systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. [ 8.734521] systemd[1]: Starting Raise network interfaces... [ 8.742900] systemd[1]: Starting Set console font and keymap... [ 8.752433] systemd[1]: Starting Log2Ram... [ 8.762608] systemd[1]: Starting Preprocess NFS configuration... [ 8.780072] systemd[1]: Started Set console font and keymap. [ 8.789701] systemd[1]: nfs-config.service: Succeeded. [ 9.499673] systemd-journald[356]: Received request to flush runtime journal from PID 1 [ 10.346297] random: crng init done [ 10.346329] random: 7 urandom warning(s) missed due to ratelimiting [ 10.558185] 8021q: 802.1Q VLAN Support v1.8 [ 10.796557] Adding 102396k swap on /var/swap. Priority:-2 extents:1 across:102396k SSFS [ 10.853234] brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled [ 11.228083] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup [ 12.293927] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 18.876629] Under-voltage detected! (0x00050005) [ 23.347833] uart-pl011 3f201000.serial: no DMA platform data [ 27.196821] Voltage normalised (0x00000000) [ 54.236610] Under-voltage detected! (0x00050005) [ 58.396588] Voltage normalised (0x00000000) [ 129.645719] ICMPv6: process `dhcpcd' is using deprecated sysctl (syscall) net.ipv6.neigh.wlan0.retrans_time - use net.ipv6.neigh.wlan0.retrans_time_ms instead