DRAM Init-V10-DDR4 0abc1-4Gb-Done Read margin-DL:0.3549/DH:0.3764 CK (min:0.30) U-Boot 2016.07 (Apr 20 2018 - 17:27:42 -0500) Watchdog enabled DRAM: 496 MiB Flash: 32 MiB In: serial Out: serial Err: serial Net: aspeednic#0 Hit any key to stop autoboot: 0 ## Loading kernel from FIT Image at 20080000 ... Using 'conf@1' configuration Trying 'kernel@1' kernel subimage Description: Linux kernel Type: Kernel Image Compression: uncompressed Data Start: 0x20080128 Data Size: 2082304 Bytes = 2 MiB Architecture: ARM OS: Linux Load Address: 0x80001000 Entry Point: 0x80001000 Hash algo: sha1 Hash value: bc8d72a08447e7520ccb4a7279b092578f2bd042 Verifying Hash Integrity ... sha1+ OK ## Loading ramdisk from FIT Image at 20080000 ... Using 'conf@1' configuration Trying 'ramdisk@1' ramdisk subimage Description: obmc-phosphor-initramfs Type: RAMDisk Image Compression: lzma compressed Data Start: 0x20283e64 Data Size: 1586264 Bytes = 1.5 MiB Architecture: ARM OS: Linux Load Address: unavailable Entry Point: unavailable Hash algo: sha1 Hash value: bc7c85315528f10445194671eb7d323be00290bd Verifying Hash Integrity ... sha1+ OK ## Loading fdt from FIT Image at 20080000 ... Using 'conf@1' configuration Trying 'fdt@1' fdt subimage Description: Flattened Device Tree blob Type: Flat Device Tree Compression: uncompressed Data Start: 0x2027c81c Data Size: 30085 Bytes = 29.4 KiB Architecture: ARM Hash algo: sha1 Hash value: 5bce58a150da2055762b8fda1f8f854f4f6ec209 Verifying Hash Integrity ... sha1+ OK Booting using the fdt blob at 0x2027c81c Loading Kernel Image ... OK Loading Ramdisk to 9ea14000, end 9eb97458 ... OK Loading Device Tree to 9ea09000, end 9ea13584 ... OK Starting kernel ... Uncompressing Linux... done, booting the kernel. [ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 4.10.17-6e79807fd36a3f7abd0e8142654630fda3929a96 (yocto-build@apollo) (gcc version 6.2.0 (GCC) ) #1 Fri Apr 20 17:24:18 CDT 2018 [ 0.000000] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache [ 0.000000] OF: fdt:Machine model: Talos™ II BMC [ 0.000000] Memory policy: Data cache writeback [ 0.000000] SOC Rev: 04030303 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 109600 [ 0.000000] Kernel command line: console=ttyS4,115200n8 root=/dev/ram rw [ 0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes) [ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes) [ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Memory: 430424K/442368K available (4081K kernel code, 282K rwdata, 1196K rodata, 280K init, 111K bss, 11944K reserved, 0K 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 : 0x9f800000 - 0xff800000 (1536 MB) [ 0.000000] lowmem : 0x80000000 - 0x9f000000 ( 496 MB) [ 0.000000] .text : 0x80008000 - 0x804049a0 (4083 kB) [ 0.000000] .init : 0x8058a000 - 0x805d0000 ( 280 kB) [ 0.000000] .data : 0x805d0000 - 0x806168e8 ( 283 kB) [ 0.000000] .bss : 0x806168e8 - 0x80632798 ( 112 kB) [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] i2c controller registered, irq 16 [ 0.000000] clocksource: moxart_timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 77222644334 ns [ 0.000000] sched_clock: 32 bits at 100 Hz, resolution 10000000ns, wraps every 21474836475000000ns [ 0.090000] Calibrating delay loop... 789.70 BogoMIPS (lpj=3948544) [ 0.090000] pid_max: default: 32768 minimum: 301 [ 0.090000] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.090000] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.090000] CPU: Testing write buffer coherency: ok [ 0.090000] ftrace: allocating 15009 entries in 45 pages [ 0.120000] Setting up static identity map for 0x80008220 - 0x8000827c [ 0.130000] devtmpfs: initialized [ 0.140000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 0.140000] futex hash table entries: 256 (order: -1, 3072 bytes) [ 0.140000] pinctrl core: initialized pinctrl subsystem [ 0.140000] NET: Registered protocol family 16 [ 0.140000] DMA: preallocated 256 KiB pool for atomic coherent allocations [ 0.210000] usbcore: registered new interface driver usbfs [ 0.210000] usbcore: registered new interface driver hub [ 0.210000] usbcore: registered new device driver usb [ 0.220000] clocksource: Switched to clocksource moxart_timer [ 0.230000] NET: Registered protocol family 2 [ 0.230000] TCP established hash table entries: 4096 (order: 2, 16384 bytes) [ 0.230000] TCP bind hash table entries: 4096 (order: 2, 16384 bytes) [ 0.230000] TCP: Hash tables configured (established 4096 bind 4096) [ 0.230000] UDP hash table entries: 256 (order: 0, 4096 bytes) [ 0.230000] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes) [ 0.240000] NET: Registered protocol family 1 [ 0.240000] Trying to unpack rootfs image as initramfs... [ 1.910000] Freeing initrd memory: 1552K [ 1.910000] workingset: timestamp_bits=30 max_order=17 bucket_order=0 [ 1.910000] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 1.910000] jffs2: version 2.2. (SUMMARY) © 2001-2006 Red Hat, Inc. [ 1.910000] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) [ 1.910000] io scheduler noop registered [ 1.910000] io scheduler deadline registered [ 1.910000] io scheduler cfq registered (default) [ 1.910000] GPIO line 307 (nic_func_mode0) hogged as output/low [ 1.910000] GPIO line 308 (nic_func_mode1) hogged as output/low [ 2.060000] ipmi-bt-host 1e789140.ibt: Found bt bmc device [ 2.060000] ipmi-bt-host 1e789140.ibt: Using IRQ 22 [ 2.060000] Serial: 8250/16550 driver, 6 ports, IRQ sharing enabled [ 2.060000] 1e787000.vuart: ttyS5 at MMIO 0x1e787000 (irq = 22, base_baud = 1500000) is a 16550A [ 2.060000] 1e783000.serial: ttyS0 at MMIO 0x1e783000 (irq = 23, base_baud = 1500000) is a 16550A [ 2.060000] 1e784000.serial: ttyS4 at MMIO 0x1e784000 (irq = 24, base_baud = 1500000) is a 16550A [ 2.430000] console [ttyS4] enabled [ 2.590000] timeriomem_rng 1e6e2078.hwrng: 32bits from 0xf00e2078 @ 1us [ 2.620000] random: fast init done [ 2.650000] brd: module loaded [ 2.650000] random: crng init done [ 2.680000] loop: module loaded [ 2.680000] aspeed-lpc-ctrl 1e789080.lpc-ctrl: Loaded at 0x98000000 (0x04000000) [ 2.690000] aspeed-smc 1e620000.flash-controller: Using IRQ 18 [ 2.690000] aspeed-smc 1e620000.flash-controller: DMA support disabled. [ 2.710000] aspeed-smc 1e620000.flash-controller: mx25l25635e (32768 Kbytes) [ 2.710000] aspeed-smc 1e620000.flash-controller: CE0 window [ 0x20000000 - 0x22000000 ] 32MB [ 2.710000] aspeed-smc 1e620000.flash-controller: CE1 window [ 0x22000000 - 0x2a000000 ] 128MB [ 2.730000] 5 ofpart partitions found on MTD device bmc [ 2.730000] Creating 5 MTD partitions on "bmc": [ 2.730000] 0x000000000000-0x000000060000 : "u-boot" [ 2.730000] 0x000000060000-0x000000080000 : "u-boot-env" [ 2.770000] 0x000000080000-0x0000004c0000 : "kernel" [ 2.770000] 0x0000004c0000-0x000001c00000 : "rofs" [ 2.790000] 0x000001c00000-0x000002000000 : "rwfs" [ 2.790000] aspeed-smc 1e630000.flash-controller: n25q512ax3 (65536 Kbytes) [ 2.800000] aspeed-smc 1e630000.flash-controller: CE0 window [ 0x30000000 - 0x34000000 ] 64MB [ 2.800000] aspeed-smc 1e630000.flash-controller: CE1 window [ 0x34000000 - 0x38000000 ] 64MB [ 3.680000] libphy: Fixed MDIO Bus: probed [ 3.680000] ftgmac100 1e660000.ethernet: Read MAC address 2c:09:4d:00:01:f2 from chip [ 3.680000] ftgmac100 1e660000.ethernet: Using NCSI interface [ 3.680000] ftgmac100 1e660000.ethernet eth0: irq 20, mapped at f0060000 [ 3.680000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 3.680000] ehci-platform: EHCI generic platform driver [ 3.950000] i2c /dev entries driver [ 3.950000] aspeed-i2c-bus 1e78a080.i2c-bus: i2c bus 1 registered, irq 25 [ 3.960000] aspeed-i2c-bus 1e78a0c0.i2c-bus: i2c bus 2 registered, irq 26 [ 3.970000] aspeed-i2c-bus 1e78a100.i2c-bus: i2c bus 3 registered, irq 27 [ 3.980000] aspeed-i2c-bus 1e78a140.i2c-bus: i2c bus 4 registered, irq 28 [ 3.990000] aspeed-i2c-bus 1e78a180.i2c-bus: i2c bus 5 registered, irq 29 [ 4.000000] aspeed-i2c-bus 1e78a1c0.i2c-bus: i2c bus 6 registered, irq 30 [ 4.000000] aspeed-i2c-bus 1e78a300.i2c-bus: i2c bus 7 registered, irq 31 [ 4.010000] aspeed-i2c-bus 1e78a340.i2c-bus: i2c bus 8 registered, irq 32 [ 4.020000] aspeed-i2c-bus 1e78a380.i2c-bus: i2c bus 9 registered, irq 33 [ 4.030000] aspeed-i2c-bus 1e78a3c0.i2c-bus: i2c bus 10 registered, irq 34 [ 4.040000] rtc-rv8803 11-0032: Voltage low, temperature compensation stopped. [ 4.050000] rtc-rv8803 11-0032: Voltage low, data loss detected. [ 4.050000] rtc-rv8803 11-0032: An alarm maybe have been missed. [ 4.060000] rtc-rv8803 11-0032: Voltage low, data is invalid. [ 4.070000] rtc-rv8803 11-0032: rtc core: registered rx8900 as rtc0 [ 4.080000] aspeed-i2c-bus 1e78a400.i2c-bus: i2c bus 11 registered, irq 35 [ 4.090000] aspeed-i2c-bus 1e78a440.i2c-bus: i2c bus 12 registered, irq 36 [ 4.100000] Driver for 1-wire Dallas network protocol. [ 8.050000] usbcore: registered new interface driver usbhid [ 8.060000] usbhid: USB HID core driver [ 8.080000] NET: Registered protocol family 10 [ 8.090000] Segment Routing with IPv6 [ 8.090000] NET: Registered protocol family 17 [ 8.090000] 8021q: 802.1Q VLAN Support v1.8 [ 8.100000] console [netcon0] enabled [ 8.100000] netconsole: network logging started [ 8.100000] input: gpio-keys as /devices/platform/gpio-keys/input/input0 [ 8.120000] rtc-rv8803 11-0032: Voltage low, data is invalid. [ 8.120000] rtc-rv8803 11-0032: hctosys: unable to read the hardware clock [ 8.120000] Freeing unused kernel memory: 280K [ 8.120000] This architecture does not have kernel memory protection. rofs = mtd4 squashfs rwfs = mtd5 jffs2 [ 8.960000] jffs2: notice: (503) jffs2_build_xattr_subsystem: complete building xattr subsystem, 1 of xdatum (1 unchecked, 0 orphan) and 9 of xref (0 dead, 0 orphan) found. [ 11.120000] systemd[1]: System time before build time, advancing clock. [ 11.160000] systemd[1]: Failed to insert module 'autofs4': No such file or directory [ 11.280000] systemd[1]: systemd 232 running in system mode. (+PAM -AUDIT -SELINUX -IMA -APPARMOR -SMACK +SYSVINIT -UTMP -LIBCRYPTSETUP -GCRYPT -GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN) [ 11.280000] systemd[1]: Detected architecture arm. Welcome to Phosphor OpenBMC (Phosphor OpenBMC Project Reference Distro) v2.0-236! [ 11.360000] systemd[1]: Set hostname to . [ 12.900000] systemd[1]: Listening on Network Service Netlink Socket. [ OK ] Listening on Network Service Netlink Socket. [ 13.030000] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 13.070000] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 13.110000] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 13.150000] systemd[1]: Reached target Remote File Systems. [ OK ] Reached target Remote File Systems. [ 13.220000] systemd[1]: Listening on Syslog Socket. [ OK ] Listening on Syslog Socket. [ 13.260000] systemd[1]: Reached target Fans Ready. [ OK ] Reached target Fans Ready. [ OK ] Listening on Journal Socket. [ OK ] Listening on /dev/initctl Compatibility Named Pipe. [ OK ] Listening on Process Core Dump Socket. [ OK ] Reached target Swap. [ OK ] Started Forward Password Requests to Wall Directory Watch. [ OK ] Started Dispatch Password Requests to Console Directory Watch. [ OK ] Reached target Paths. [ OK ] Created slice System Slice. [ OK ] Created slice system-org.openbmc.buttons.reset.slice. [ OK ] Created slice system-getty.slice. Mounting Debug File System... Mounting Temporary Directory... Starting udev Coldplug all Devices... [ OK ] Created slice system-op\x2dreset\x2dchassis\x2don.slice. [ OK ] Created slice system-phosphor\x2ddiscover\x2dsystem\x2dstate.slice. [ OK ] Created slice system-obmc\x2dconsole.slice. [ OK ] Created slice system-obmc\x2dflash\x2dbmc\x2dsetenv.slice. [ OK ] Created slice system-phosphor\x2dreset\x2dhost\x2dcheck.slice. [ OK ] Created slice system-obmc\x2dled\x2dgroup\x2dstart.slice. [ OK ] Created slice system-org.openbmc.control.Power.slice. [ OK ] Created slice system-phosphor\x2dcooling\x2dtype.slice. [ OK ] Created slice system-op\x2dreset\x2dchassis\x2drunning.slice. [ OK ] Reached target Slices. [ OK ] Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-org.openbmc.control.Chassis.slice. Starting Remount Root and Kernel File Systems... [ OK ] Created slice system-phosphor\x2dreset\x2dhost\x2drunning.slice. Starting Apply Kernel Variables... [ OK ] Created slice system-org.openbmc.buttons.Power.slice. Starting Journal Service... [ OK ] Created slice system-org.openbmc.control.Bmc.slice. [ OK ] Created slice system-mapper\x2dwait.slice. [ OK ] Mounted Debug File System. [ OK ] Mounted Temporary Directory. [ OK ] Started Remount Root and Kernel File Systems. [ OK ] Started Apply Kernel Variables. Starting Create Static Device Nodes in /dev... [ OK ] Started Journal Service. Starting Flush Journal to Persistent Storage... [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /var/volatile... Starting udev Kernel Device Manager... [ OK ] Mounted /var/volatile. [ OK ] Started udev Coldplug all Devices. Starting Load/Save Random Seed... [ OK ] Reached target Local File Systems. [ OK ] Started udev Kernel Device Manager. [ OK ] Started Load/Save Random Seed. [ 16.800000] systemd-journald[637]: Received request to flush runtime journal from PID 1 [ OK ] Started Flush Journal to Persistent Storage. Starting Create Volatile Files and Directories... [ OK ] Started Create Volatile Files and Directories. Starting Network Time Synchronization... [ OK ] Found device /dev/ttyS4. [ OK ] Found device /dev/ttyVUART0. [ OK ] Found device /dev/aspeed-lpc-ctrl. [ OK ] Found device /dev/aspeed-mbox. [ OK ] Created slice system-xyz.openbmc_project.Hwmon.slice. [ OK ] Started Network Time Synchronization. [ OK ] Created slice system-xyz.openbmc_project.led.controller.slice. [ OK ] Reached target System Time Synchronized. [ OK ] Reached target System Initialization. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket. [ OK ] Listening on phosphor-ipmi-net.socket. [ OK ] Listening on dropbear.socket. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Listening on Phosphor Host Console SSH Per-Connection socket. [ OK ] Listening on Phosphor DBUS Browser socket. [ OK ] Listening on Phosphor Webserver socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting Phosphor Chassis0 Control... [ OK ] Started Phosphor sysfs LED controller. Starting Clear one time boot overrides... [ OK ] Started Kernel Logging Service. [ OK ] Started System Logging Service. Starting Phosphor DBus Service Discovery Manager... Starting Phosphor IPMI BT DBus Bridge... [ OK ] Reached target Containers. Starting Phosphor Settings Daemon... Starting Phosphor Inventory Manager... Starting Avahi mDNS/DNS-SD Stack... [ OK ] Started Phosphor sysfs LED controller. [ OK ] Started Phosphor Console Muxer listening on device /dev/ttyVUART0. Starting Phosphor BMC0 Control... Starting Set U-Boot environment variable... Starting Phosphor User Manager... [ OK ] Started Hardware RNG Entropy Gatherer Daemon. [ OK ] Started Phosphor sysfs LED controller. [ OK ] Started Phosphor sysfs LED controller. Starting Phosphor LED Group Management Daemon... Starting Phosphor Inventory Manager... [ OK ] Started D-Bus System Message Bus. [ OK ] Started Phosphor LED Group Management Daemon. [ OK ] Started Avahi mDNS/DNS-SD Stack. [ OK ] Started Phosphor User Manager. [ OK ] Started Phosphor Settings Daemon. [ OK ] Started Phosphor IPMI BT DBus Bridge. [ OK ] Started Phosphor Inventory Manager. Starting Network Service... [ OK ] Started Phosphor sysfs LED controller. Starting Phosphor Fan Control... Starting Phosphor Download Manager... Starting Phosphor Sensor Manager... Starting Phosphor Log Manager... [ OK ] Started Phosphor Dump core monitor.. [ OK ] Started Phosphor MBOX Daemon. Starting Phosphor Download Manager... Starting Phosphor Dump Manager... Starting Phosphor Network Manager... [ OK ] Started Set U-Boot environment variable. Starting Remount the ubi volume after a reboot... [ OK ] Started Clear one time boot overrides. [ OK ] Started Phosphor BMC0 Control. [ OK ] Started Phosphor Fan Control. [ OK ] Reached target Fan Control. [ OK ] Started Phosphor Download Manager. [ OK ] Started Phosphor Dump Manager. [ OK ] Started Remount the ubi volume after a reboot. [ OK ] Started Network Service. [ OK ] Reached target Network. [ OK ] Started Lightweight SLP Server. Starting Permit User Sessions... [ 33.770000] 8021q: adding VLAN 0 to HW filter on device eth0 [ 33.770000] ftgmac100 1e660000.ethernet eth0: NCSI: Handler for packet type 0x82 returned -19 [ OK ] Started Permit User Sessions. [ OK ] Started Serial Getty on ttyS4. [ OK ] Reached target Login Prompts. [ OK ] Reached target Multi-User System. [ 37.390000] ftgmac100 1e660000.ethernet eth0: NCSI: configuring channel 0 [ 37.390000] ftgmac100 1e660000.ethernet eth0: NCSI: Handler for packet type 0x8b returned -34 [ 37.390000] ftgmac100 1e660000.ethernet eth0: NCSI: channel 0 link down after config [ 37.390000] ftgmac100 1e660000.ethernet eth0: NCSI interface down Phosphor OpenBMC (Phosphor OpenBMC Project Reference Distro) 0.1.0 talos ttyS4 talos login: root Password: root@talos:~# tail -f /var/log/mes tail: can't open '/var/log/mes': No such file or directory tail: no files root@talos:~# tail -f /var/log/messages Apr 20 22:08:08 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:08 talos kern.info phosphor-hwmon-readd[965]: Logging failing sysfs file Apr 20 22:08:08 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:08 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:08 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:09 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:09 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:09 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:11 talos kern.err phosphor-hwmon-readd[1004]: Failed to read from device. Apr 20 22:08:12 talos daemon.info system_manager.py[959]: Running System State: BASE_APPS Apr 20 22:08:12 talos daemon.info system_manager.py[959]: SystemManager Init Done Apr 20 22:08:12 talos daemon.info system_manager.py[959]: Running SystemManager Apr 20 22:08:12 talos daemon.info systemd[1]: Started Phoshpor System Manager. Apr 20 22:08:14 talos daemon.info systemd[1]: Started Phosphor BMC Code Update. Apr 20 22:08:14 talos daemon.info bmc_update.py[978]: Running Bmc Flash Control Apr 20 22:08:14 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:14 talos kern.info phosphor-hwmon-readd[1004]: Logging failing sysfs file Apr 20 22:08:14 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:14 talos daemon.info system_manager.py[959]: SystemManager Goto System State: BMC_STARTING Apr 20 22:08:14 talos daemon.info system_manager.py[959]: Running System State: BMC_STARTING Apr 20 22:08:14 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:14 talos daemon.info settings_manager.py[964]: Running HostSettingsService Apr 20 22:08:14 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:14 talos daemon.info systemd[1]: Started Phosphor Settings Manager. Apr 20 22:08:14 talos daemon.info systemd[1]: Starting Wait for /org/openbmc/settings/host0... Apr 20 22:08:15 talos kern.err phosphor-fru-fault-monitor[981]: Error in getting associations Apr 20 22:08:15 talos kern.err phosphor-fru-fault-monitor[981]: Error in getting associations Apr 20 22:08:15 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:15 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:15 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:16 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/288 Apr 20 22:08:16 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/289 Apr 20 22:08:17 talos kern.err phosphor-hwmon-readd[1012]: Failed to read from device. Apr 20 22:08:19 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:19 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/290 Apr 20 22:08:19 talos kern.info phosphor-hwmon-readd[1012]: Logging failing sysfs file Apr 20 22:08:19 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:19 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:19 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:19 talos daemon.info systemd[1]: Started Wait for /org/openbmc/control/flash/bios. Apr 20 22:08:19 talos daemon.info systemd[1]: Started Initialize BIOS Flash. Apr 20 22:08:20 talos daemon.info systemd[1]: Started Wait for /org/openbmc/managers/System. Apr 20 22:08:20 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:20 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:20 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:20 talos daemon.info systemd[1]: Starting Phosphor Power Button0... Apr 20 22:08:20 talos daemon.info systemd[1]: Starting Phosphor BMC State Manager... Apr 20 22:08:21 talos daemon.info systemd[1]: Starting Phosphor Power0 Control... Apr 20 22:08:21 talos daemon.info systemd[1]: Starting Phosphor Reset Button0... Apr 20 22:08:21 talos daemon.info systemd[1]: Starting Phosphor Chassis State Manager... Apr 20 22:08:21 talos daemon.info systemd[1]: Started Wait for /org/openbmc/settings/host0. Apr 20 22:08:22 talos kern.info phosphor-chassis-state-manager[1028]: Initial Chassis State will be Off Apr 20 22:08:22 talos daemon.info systemd[1]: Started Phosphor Chassis State Manager. Apr 20 22:08:22 talos daemon.info systemd[1]: Started Phosphor Inband IPMI. Apr 20 22:08:22 talos daemon.info system_manager.py[959]: New object: /org/openbmc/control/power0 (:1.77) Apr 20 22:08:22 talos kern.err phosphor-hwmon-readd[1017]: Failed to read from device. Apr 20 22:08:22 talos kern.info phosphor-bmc-state-manager[1019]: Setting the BMCState field Apr 20 22:08:22 talos kern.info phosphor-bmc-state-manager[1019]: Setting the BMCState field Apr 20 22:08:22 talos daemon.info systemd[1]: Started Phosphor BMC State Manager. Apr 20 22:08:22 talos daemon.info button_power.exe[1018]: GPIO Lookup: POWER_BUTTON = 347,both Apr 20 22:08:22 talos daemon.info button_reset.exe[1027]: GPIO Lookup: RESET_BUTTON = 398,both Apr 20 22:08:22 talos daemon.info systemd[1]: Started Phosphor Reset Button0. Apr 20 22:08:22 talos daemon.info system_manager.py[959]: Power GPIO config: ['SYS_PWROK_BUFF', '', [('BMC_POWER_UP', True)], [], [], 'FSI_DATA', 'FSI_CLK', 'FSI_ENABLE', 'CRONUS_SEL', []] Apr 20 22:08:22 talos daemon.info power_control.exe[1026]: Power GPIO latch output: Apr 20 22:08:22 talos daemon.info power_control.exe[1026]: Power GPIO power good input: SYS_PWROK_BUFF Apr 20 22:08:22 talos daemon.info power_control.exe[1026]: Power GPIO 1 power_up outputs Apr 20 22:08:22 talos daemon.info power_control.exe[1026]: Power GPIO power_up[0] = BMC_POWER_UP active HIGH Apr 20 22:08:22 talos daemon.info power_control.exe[1026]: Power GPIO 0 reset outputs Apr 20 22:08:22 talos daemon.info power_control.exe[1026]: Power GPIO 0 pci reset outputs Apr 20 22:08:22 talos daemon.info power_control.exe[1026]: FSI DATA GPIO: FSI_DATA Apr 20 22:08:22 talos daemon.info power_control.exe[1026]: FSI CLK GPIO: FSI_CLK Apr 20 22:08:23 talos daemon.info power_control.exe[1026]: FSI ENABLE GPIO: FSI_ENABLE Apr 20 22:08:23 talos daemon.info power_control.exe[1026]: CRONUS SEL GPIO: CRONUS_SEL Apr 20 22:08:23 talos daemon.info power_control.exe[1026]: Hostctl GPIO optionals: 0 Apr 20 22:08:23 talos daemon.info power_control.exe[1026]: GPIO Lookup: SYS_PWROK_BUFF = 306,in Apr 20 22:08:23 talos daemon.info systemd[1]: Started Phosphor Power Button0. Apr 20 22:08:23 talos daemon.info power_control.exe[1026]: GPIO Lookup: BMC_POWER_UP = 305,out Apr 20 22:08:23 talos daemon.info power_control.exe[1026]: Pgood state: 0 Apr 20 22:08:23 talos daemon.info systemd[1]: Started Phosphor Power0 Control. Apr 20 22:08:23 talos daemon.info flash_bios.exe[977]: Starting flasher: bios,,/org/openbmc/control/flash/bios, Apr 20 22:08:23 talos daemon.info flash_bios.exe[977]: flasher: , BMC = 1, address = 0x0 Apr 20 22:08:23 talos daemon.info flash_bios.exe[977]: Setting up flash Apr 20 22:08:24 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:24 talos daemon.info flash_bios.exe[977]: Starting flasher: bios,,/org/openbmc/control/flash/bios, Apr 20 22:08:24 talos daemon.info flash_bios.exe[977]: flasher: , BMC = 1, address = 0x0 Apr 20 22:08:24 talos daemon.info flash_bios.exe[977]: Setting up flash Apr 20 22:08:24 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/291 Apr 20 22:08:24 talos kern.info phosphor-hwmon-readd[1017]: Logging failing sysfs file Apr 20 22:08:24 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:24 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:24 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:25 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:25 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:25 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:27 talos kern.err phosphor-hwmon-readd[1053]: Failed to read from device. Apr 20 22:08:28 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:28 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/292 Apr 20 22:08:28 talos kern.info phosphor-hwmon-readd[1053]: Logging failing sysfs file Apr 20 22:08:28 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:28 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:28 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:28 talos daemon.info system_manager.py[959]: SystemManager Goto System State: BMC_READY Apr 20 22:08:28 talos daemon.info system_manager.py[959]: Running System State: BMC_READY Apr 20 22:08:28 talos daemon.info systemd[1]: Started Wait for /org/openbmc/control/power0. Apr 20 22:08:28 talos daemon.info systemd[1]: Starting Check Chassis0 pgood and create a file to indicate it... Apr 20 22:08:28 talos daemon.info systemd[1]: Started Wait for /xyz/openbmc_project/state/chassis0. Apr 20 22:08:29 talos daemon.info systemd[1]: Started Wait for /xyz/openbmc_project/control/host0. Apr 20 22:08:29 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:29 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:29 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:29 talos daemon.info systemd[1]: Started Check Chassis0 pgood and create a file to indicate it. Apr 20 22:08:29 talos daemon.info systemd[1]: Reached target Chassis0 power on after reset. Apr 20 22:08:29 talos daemon.info systemd[1]: Reached target Chassis0 (Reset Check). Apr 20 22:08:29 talos daemon.info systemd[1]: Reached target Host0 running after reset. Apr 20 22:08:29 talos daemon.info systemd[1]: Starting Phosphor Host State Manager... Apr 20 22:08:29 talos daemon.info systemd[1]: Reached target Host0 (Reset Check). Apr 20 22:08:30 talos kern.info phosphor-host-state-manager[1068]: Initial Host State will be Off Apr 20 22:08:30 talos kern.debug phosphor-host-state-manager[1068]: External request to reset reboot count Apr 20 22:08:30 talos daemon.info systemd[1]: Started Phosphor Host State Manager. Apr 20 22:08:30 talos daemon.info systemd[1]: Starting Phoshpor IPL Status Observer... Apr 20 22:08:31 talos kern.err phosphor-hwmon-readd[1066]: Failed to read from device. Apr 20 22:08:31 talos daemon.info systemd[1]: Started Wait for /xyz/openbmc_project/state/host0. Apr 20 22:08:32 talos daemon.info systemd[1]: Starting Reboot If Enabled... Apr 20 22:08:32 talos daemon.info systemd[1]: Starting Phosphor Time Manager daemon... Apr 20 22:08:32 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:32 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/293 Apr 20 22:08:32 talos kern.info phosphor-hwmon-readd[1066]: Logging failing sysfs file Apr 20 22:08:32 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:32 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:32 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:33 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:33 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:33 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:35 talos kern.err phosphor-hwmon-readd[1077]: Failed to read from device. Apr 20 22:08:35 talos kern.info phosphor-discover-system-state[1074]: Host power is off, checking power policy Apr 20 22:08:35 talos daemon.info systemd[1]: Started Reboot If Enabled. Apr 20 22:08:36 talos daemon.notice dbus[895]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' Apr 20 22:08:36 talos daemon.info systemd[1]: Starting Time & Date Service... Apr 20 22:08:36 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:36 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/294 Apr 20 22:08:36 talos kern.info phosphor-hwmon-readd[1077]: Logging failing sysfs file Apr 20 22:08:36 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:36 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:36 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:36 talos daemon.notice dbus[895]: [system] Successfully activated service 'org.freedesktop.timedate1' Apr 20 22:08:36 talos daemon.warn systemd-timedated[1081]: Failed to get target of /etc/localtime: No such file or directory Apr 20 22:08:36 talos daemon.info systemd[1]: Started Time & Date Service. Apr 20 22:08:36 talos daemon.info systemd[1]: Started Phosphor Time Manager daemon. Apr 20 22:08:37 talos daemon.info ipl_status_observer.py[1071]: IPLStatus Init Done Apr 20 22:08:37 talos daemon.info systemd[1]: Started Phoshpor IPL Status Observer. Apr 20 22:08:37 talos daemon.info systemd[1]: Started Phoshpor IPL Status LED Monitor. Apr 20 22:08:37 talos daemon.info ipl_status_observer.py[1071]: Running IPLStatus Apr 20 22:08:37 talos daemon.info systemd[1]: Reached target Phosphor System - Standby. Apr 20 22:08:37 talos kern.info phosphor-bmc-state-manager[1019]: BMC_READY Apr 20 22:08:37 talos kern.info phosphor-bmc-state-manager[1019]: Setting the BMCState field Apr 20 22:08:37 talos daemon.info systemd[1]: Starting Assert bmc_booted LED... Apr 20 22:08:37 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:37 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:37 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:38 talos daemon.info phosphor-ledmanager[893]: Asserting LEDs Apr 20 22:08:38 talos daemon.info systemd[1]: Started Assert bmc_booted LED. Apr 20 22:08:38 talos daemon.info systemd[1]: Startup finished in 10.889s (kernel) + 1min 29.782s (userspace) = 1min 40.672s. Apr 20 22:08:39 talos kern.err phosphor-hwmon-readd[1087]: Failed to read from device. Apr 20 22:08:40 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:40 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/295 Apr 20 22:08:40 talos kern.info phosphor-hwmon-readd[1087]: Logging failing sysfs file Apr 20 22:08:40 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:40 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:40 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:41 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:41 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:41 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:43 talos kern.err phosphor-hwmon-readd[1094]: Failed to read from device. Apr 20 22:08:43 talos daemon.info ipl_status_led_monitor.py[1083]: IPLStatusLEDMonitor Init Done Apr 20 22:08:43 talos daemon.info ipl_status_led_monitor.py[1083]: Running IPLStatusLEDMonitor Apr 20 22:08:44 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:44 talos kern.info phosphor-hwmon-readd[1094]: Logging failing sysfs file Apr 20 22:08:44 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:44 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/296 Apr 20 22:08:44 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:44 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:45 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:45 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:45 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:47 talos kern.err phosphor-hwmon-readd[1120]: Failed to read from device. Apr 20 22:08:48 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:48 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/297 Apr 20 22:08:48 talos kern.info phosphor-hwmon-readd[1120]: Logging failing sysfs file Apr 20 22:08:48 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:48 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:48 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:49 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:49 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:49 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:51 talos kern.err phosphor-hwmon-readd[1191]: Failed to read from device. Apr 20 22:08:52 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:52 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/298 Apr 20 22:08:52 talos kern.info phosphor-hwmon-readd[1191]: Logging failing sysfs file Apr 20 22:08:52 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:52 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:52 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:53 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:53 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:53 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:54 talos kern.err phosphor-hwmon-readd[1262]: Failed to read from device. Apr 20 22:08:55 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:55 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/299 Apr 20 22:08:55 talos kern.info phosphor-hwmon-readd[1262]: Logging failing sysfs file Apr 20 22:08:55 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:55 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:55 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:08:56 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:08:56 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:08:56 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:08:58 talos kern.err phosphor-hwmon-readd[1332]: Failed to read from device. Apr 20 22:08:58 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:08:58 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/300 Apr 20 22:08:58 talos kern.info phosphor-hwmon-readd[1332]: Logging failing sysfs file Apr 20 22:08:58 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:08:59 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:08:59 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:09:00 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:09:00 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:09:00 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:09:01 talos kern.err phosphor-hwmon-readd[1370]: Failed to read from device. Apr 20 22:09:01 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:09:01 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/301 Apr 20 22:09:01 talos kern.info phosphor-hwmon-readd[1370]: Logging failing sysfs file Apr 20 22:09:01 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:09:02 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:09:02 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:09:03 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:09:03 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:09:03 talos daemon.info systemd[1]: Started Phosphor Hwmon Poller. Apr 20 22:09:04 talos kern.err phosphor-hwmon-readd[1373]: Failed to read from device. Apr 20 22:09:04 talos kern.info phosphor-log-manager[906]: Failed to find metadata Apr 20 22:09:04 talos kern.err phosphor-fru-fault-monitor[981]: /xyz/openbmc_project/logging/entry/302 Apr 20 22:09:04 talos kern.info phosphor-hwmon-readd[1373]: Logging failing sysfs file Apr 20 22:09:04 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Main process exited, code=exited, status=1/FAILURE Apr 20 22:09:05 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:09:05 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'. Apr 20 22:09:06 talos daemon.info systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Service hold-off time over, scheduling restart. Apr 20 22:09:06 talos daemon.info systemd[1]: Stopped Phosphor Hwmon Poller. Apr 20 22:09:06 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Start request repeated too quickly. Apr 20 22:09:06 talos daemon.err systemd[1]: Failed to start Phosphor Hwmon Poller. Apr 20 22:09:06 talos daemon.notice systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Unit entered failed state. Apr 20 22:09:06 talos daemon.warn systemd[1]: xyz.openbmc_project.Hwmon@ahb-apb-pwm\x2dtacho\x2dcontroller\x401e786000.service: Failed with result 'exit-code'.