Exposing sensors to IPMI over dbus

AKASH G J akashgj91 at gmail.com
Thu Dec 26 23:44:54 AEDT 2019


Sorry for the late reply. I tried using *entity-manager* commit
*7d807754cc9153b04b599804464edd9654d7a81e* and *dbus-sensors* commit
*14f0ad806c3e92b5aee23632534698fbca18014b*.

Now the sensor configuration are exposed to dbus interface.

root at s2600wf:~# busctl tree --no-pager xyz.openbmc_project.HwmonTempSensor
`-/xyz
  `-/xyz/openbmc_project
    `-/xyz/openbmc_project/sensors
      `-/xyz/openbmc_project/sensors/temperature
        |-/xyz/openbmc_project/sensors/temperature/bmc_temp
        |-/xyz/openbmc_project/sensors/temperature/cpu0_vrd_temp
        |-/xyz/openbmc_project/sensors/temperature/cpu1_vrd_temp
        |-/xyz/openbmc_project/sensors/temperature/left_rear_temp
        `-/xyz/openbmc_project/sensors/temperature/right_rear_temp

root at s2600wf:~# busctl introspect --no-pager
xyz.openbmc_project.HwmonTempSensor
 /xyz/openbmc_project/sensors/temperature/bmc_temp
NAME                                          TYPE      SIGNATURE
RESULT/VALUE                             FLAGS
org.freedesktop.DBus.Introspectable           interface -         -
                               -
.Introspect                                   method    -         s
                               -
org.freedesktop.DBus.Peer                     interface -         -
                               -
.GetMachineId                                 method    -         s
                               -
.Ping                                         method    -         -
                               -
org.freedesktop.DBus.Properties               interface -         -
                               -
.Get                                          method    ss        v
                               -
.GetAll                                       method    s         a{sv}
                               -
.Set                                          method    ssv       -
                               -
.PropertiesChanged                            signal    sa{sv}as  -
                               -
xyz.openbmc_project.Association.Definitions   interface -         -
                               -
.Associations                                 property  a(sss)    1
"chassis" "all_sensors" "/xyz/openb... emits-change
xyz.openbmc_project.Sensor.Threshold.Critical interface -         -
                               -
.CriticalAlarmHigh                            property  b         false
                               emits-change
.CriticalHigh                                 property  d         80
                                emits-change writable
xyz.openbmc_project.Sensor.Value              interface -         -
                               -
.MaxValue                                     property  d         127
                               emits-change
.MinValue                                     property  d         -128
                                emits-change
.Value                                        property  d         28.562
                                emits-change writable

Still the sensors are not coming on IPMI commands. But it is coming when
using REST interface.

root at s2600wf:~# ipmitool sdr
Error obtaining SDR info: Requested sensor, data, or record not found
Unable to open SDR for reading

desktop at desktopc-pc:~$ curl -c cjar -b cjar -k https://
${bmc}/xyz/openbmc_project/sensors/temperature/bmc_temp
{
  "data": {
    "Associations": [
      [
        "chassis",
        "all_sensors",
        "/xyz/openbmc_project/inventory/system/board/Rudra_Baseboard"
      ]
    ],
    "CriticalAlarmHigh": false,
    "CriticalHigh": 80.0,
    "MaxValue": 127.0,
    "MinValue": -128.0,
    "Value": 29.125
  },
  "message": "200 OK",
  "status": "ok"


Journalctl logs are attached herewith.

On Sat, Dec 21, 2019 at 2:29 AM James Feist <james.feist at linux.intel.com>
wrote:

> On 12/20/19 4:08 AM, AKASH G J wrote:
> > Thanks for the help.
> >
> > I changed  "Probe" : "TRUE", now entity manager configuration file is
> > parsed and published to dbus a configuration.
> >
> > root at rudra:~# busctl introspect --no-pager
> > xyz.openbmc_project.EntityManager \
> >> /xyz/openbmc_project/inventory/system/board/Rudra_Baseboard/bmc_temp
> > NAME                                                TYPE      SIGNATURE
> > RESULT/VALUE     FLAGS
> > org.freedesktop.DBus.Introspectable                 interface -
> > -                -
> > .Introspect                                         method    -
> > s                -
> > org.freedesktop.DBus.Peer                           interface -
> > -                -
> > .GetMachineId                                       method    -
> > s                -
> > .Ping                                               method    -
> > -                -
> > org.freedesktop.DBus.Properties                     interface -
> > -                -
> > .Get                                                method    ss
> >   v                -
> > .GetAll                                             method    s
> > a{sv}            -
> > .Set                                                method    ssv
> > -                -
> > .PropertiesChanged                                  signal    sa{sv}as
> >   -                -
> > xyz.openbmc_project.Configuration.TMP75             interface -
> > -                -
> > .Address                                            property  s
> > "0x4a"           emits-change
>
>
> This should have been translated to an int, and is most likely the
> issue. Are you using an old version of entity-manager? If not it is a
> bug. You can also write it as the int version in the configuration file
> as a workaround, but I think this was fixed and was specifically an
> issue with using the TRUE probe.
>
>
> > .Bus                                                property  t
> > 5                emits-change
> > .Name                                               property  s
> > "bmc_temp"       emits-change
> > .Type                                               property  s
> > "TMP75"          emits-change
> > xyz.openbmc_project.Configuration.TMP75.Thresholds0 interface -
> > -                -
> > .Delete                                             method    -
> > i                -
> > .Direction                                          property  s
> > "greater than"   emits-change writable
> > .Name                                               property  s
> > "upper critical" emits-change writable
> > .Severity                                           property  d
> > 1                emits-change writable
> > .Value                                              property  d
> > 80               emits-change writable
> >
> > dbus-sensors hwmon temperature sensor daemon is not recognizing the
> > configuration interface: xyz.openbmc_project.Configuration.TMP75
> >
> > root at rudra:~# busctl tree --no-pager xyz.openbmc_project.HwmonTempSensor
> > Failed to introspect object / of service
> > xyz.openbmc_project.HwmonTempSensor: The name is not activatable
> > No objects discovered.
> >
> > In journalctl log the following messages are coming.
> >
> > hwmontempsensor[153]: Error communicating to entity manager
> > hwmontempsensor[566]: terminate called after throwing an instance of
> > 'std::bad_variant_access'
> > hwmontempsensor[566]:   what():  Unexpected index
> > phosphor-mapper[210]: Introspect call failed with error: generic:110,
> > Connection timed out on process: xyz.openbmc_project.HwmonTempSensor
> path: /
> > systemd[1]: xyz.openbmc_project.hwmontempsensor.service: Main process
> > exited, code=killed, status=6/ABRT
> > systemd[1]: xyz.openbmc_project.hwmontempsensor.service: Failed with
> > result 'signal'.
> > systemd[1]: xyz.openbmc_project.hwmontempsensor.service: Service
> > RestartSec=5s expired, scheduling restart.
> > systemd[1]: xyz.openbmc_project.hwmontempsensor.service: Scheduled
> > restart job, restart counter is at 4.
> > systemd[1]: Stopped Hwmon Temp Sensor.
> > phosphor-mapper[210]: Introspect call failed with error: generic:110,
> > Connection timed out on process: xyz.openbmc_project.HwmonTempSensor
> path: /
> > systemd-udevd[97]: Spawned process '/usr/bin/start_hwmon.sh start
> > /devices/platform/ahb/ahb:apb/ahb:apb:bus at 1e78a000/1e78a180.i2c-bus/i2c-5/5-004c/hwmon/hwmon2
>
> > /ahb/apb/bus at 1e78a000/i2c-bus at 180/tmp75 at 4c' [104] is taking longer than
> > 59s to complete
> >
> >
> >
> > Thanks and Regards,
> >
> > Akash
> >
> > On Fri, Dec 20, 2019 at 12:42 AM James Feist
> > <james.feist at linux.intel.com <mailto:james.feist at linux.intel.com>>
> wrote:
> >
> >     On 12/19/19 1:12 AM, AKASH G J wrote:
> >      > Hi all,
> >      > I am using OpenBMC firmware for server board having Aspeed
> AST-2500.
> >      >
> >      > Followed
> >      >
> >
> https://github.com/openbmc/entity-manager/blob/master/docs/my_first_sensors.md
> >
> >      > for populating sensor value to dbus. Entity manager configuration
> >     file
> >      > is given below.
> >      > {
> >      >      "Exposes": [
> >      >          {
> >      >              "Address": "0x4f",
> >      >              "Bus": 5,
> >      >              "Name": "cpu0_vrd_temp",
> >      >              "Thresholds": [
> >      >                  {
> >      >                      "Direction": "greater than",
> >      >                      "Name": "upper critical",
> >      >                      "Severity": 1,
> >      >                      "Value": 80
> >      >                  }
> >      >              ],
> >      >              "Type": "TMP75"
> >      >          }
> >      >      ],
> >      >      "Name": "Rudra Baseboard",
> >      >      "Probe":
> >     "xyz.openbmc_project.FruDevice({'PRODUCT_PRODUCT_NAME':
> >      > 'RUDRA'})",
> >      >      "Type": "Board",
> >      >      "xyz.openbmc_project.Inventory.Decorator.Asset": {
> >      >          "Manufacturer": "$BOARD_MANUFACTURER",
> >      >          "Model": "$BOARD_PRODUCT_NAME",
> >      >          "PartNumber": "$BOARD_PART_NUMBER",
> >      >          "SerialNumber": "$BOARD_SERIAL_NUMBER"
> >      >      }
> >      > }
> >      >
> >      > Wrote sample FRU information on eeprom with the following
> >     content. Used
> >      > dd command for writing to eeprom.
> >      >
> >      > root at s2600wf:/sys/bus/i2c/devices/3-0056# cat eeprom
> >      > Product:
> >      >    MANUFACTURER  "ABC"
> >      >    PART_NUMBER   "12345"
> >      >    PRODUCT_NAME  "SAMPLENAME"
> >      >    SERIAL_NUMBER "12312490840"
> >
> >     This is not a legal IMPI FRU. FRU Device only allows legal fru based
> on
> >     the spec:
> >
> https://www.intel.com/content/www/us/en/servers/ipmi/ipmi-platform-mgt-fru-infostorage-def-v1-0-rev-1-3-spec-update.html
> >
> >     For testing purposes using "Probe" : "TRUE" can be used as well.
> >      >
> >      > The dbus tree not showing
> /xyz/openbmc_project/FruDevice/SAMPLENAME
> >      >
> >      > root at s2600wf:~# busctl tree --no-pager
> xyz.openbmc_project.FruDevice
> >      > `-/xyz
> >      >    `-/xyz/openbmc_project
> >      >      `-/xyz/openbmc_project/FruDevice
> >      >
> >      > In journalctl log the following messages are printed.
> >      >
> >      > systemd[1]: Started Hwmon Temp Sensor.
> >      > hwmontempsensor[120]: Error communicating to entity manager
> >      > hwmontempsensor[120]: error communicating to entity manager
> >      >
> >      > Look like FruDevice daemon is not parsing the contents of eeprom
> and
> >      > publish them to dbus.
> >      >
> >      > Is there any thing missing in configuration? Please help to
> >     resolve the
> >      > problem.
> >      >
> >      >
> >      >
> >      > Thanks,
> >      >
> >      > Akash
> >      >
> >
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.ozlabs.org/pipermail/openbmc/attachments/20191226/4a371dc6/attachment-0001.htm>
-------------- next part --------------

root at s2600wf:~# journalctl --no-page
-- Logs begin at Thu 1970-01-01 00:00:29 UTC, end at Thu 1970-01-01 00:03:04 UTC. --
Jan 01 00:00:29 s2600wf kernel: Booting Linux on physical CPU 0x0
Jan 01 00:00:29 s2600wf kernel: Linux version 5.3.11-d41fa1f-dirty-c401fb6 (oe-user at oe-host) (gcc version 9.2.0 (GCC)) #1 Mon Dec 16 09:26:29 UTC 2019
Jan 01 00:00:29 s2600wf kernel: CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
Jan 01 00:00:29 s2600wf kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
Jan 01 00:00:29 s2600wf kernel: OF: fdt: Machine model: S2600WF BMC
Jan 01 00:00:29 s2600wf kernel: Memory policy: Data cache writeback
Jan 01 00:00:29 s2600wf kernel: cma: Reserved 16 MiB at 0x9c400000
Jan 01 00:00:29 s2600wf kernel: Built 1 zonelists, mobility grouping on.  Total pages: 125984
Jan 01 00:00:29 s2600wf kernel: Kernel command line: console=ttyS4,115200n8 root=/dev/ram rw
Jan 01 00:00:30 s2600wf kernel: Dentry cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jan 01 00:00:30 s2600wf kernel: Inode-cache hash table entries: 32768 (order: 5, 131072 bytes, linear)
Jan 01 00:00:30 s2600wf kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Jan 01 00:00:30 s2600wf kernel: Memory: 454680K/507904K available (6144K kernel code, 393K rwdata, 1424K rodata, 1024K init, 145K bss, 36840K reserved, 16384K cma-reserved)
Jan 01 00:00:30 s2600wf kernel: random: get_random_u32 called from cache_alloc_refill+0x3e8/0x8d8 with crng_init=0
Jan 01 00:00:30 s2600wf kernel: ftrace: allocating 21025 entries in 42 pages
Jan 01 00:00:30 s2600wf kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Jan 01 00:00:30 s2600wf kernel: i2c controller registered, irq 16
Jan 01 00:00:30 s2600wf kernel: clocksource: FTTMR010-TIMER2: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 77222644334 ns
Jan 01 00:00:30 s2600wf kernel: sched_clock: 32 bits at 24MHz, resolution 40ns, wraps every 86767015915ns
Jan 01 00:00:30 s2600wf kernel: Switching to timer-based delay loop, resolution 40ns
Jan 01 00:00:30 s2600wf kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 49.50 BogoMIPS (lpj=247500)
Jan 01 00:00:30 s2600wf kernel: pid_max: default: 32768 minimum: 301
Jan 01 00:00:30 s2600wf kernel: Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
Jan 01 00:00:30 s2600wf kernel: Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
Jan 01 00:00:30 s2600wf kernel: CPU: Testing write buffer coherency: ok
Jan 01 00:00:30 s2600wf kernel: Setting up static identity map for 0x80100000 - 0x80100038
Jan 01 00:00:30 s2600wf kernel: devtmpfs: initialized
Jan 01 00:00:30 s2600wf kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Jan 01 00:00:30 s2600wf kernel: futex hash table entries: 256 (order: -1, 3072 bytes, linear)
Jan 01 00:00:30 s2600wf kernel: pinctrl core: initialized pinctrl subsystem
Jan 01 00:00:30 s2600wf kernel: NET: Registered protocol family 16
Jan 01 00:00:30 s2600wf kernel: DMA: preallocated 256 KiB pool for atomic coherent allocations
Jan 01 00:00:30 s2600wf kernel: hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
Jan 01 00:00:30 s2600wf kernel: hw-breakpoint: maximum watchpoint size is 4 bytes.
Jan 01 00:00:30 s2600wf kernel: videodev: Linux video capture interface: v2.00
Jan 01 00:00:30 s2600wf kernel: clocksource: Switched to clocksource FTTMR010-TIMER2
Jan 01 00:00:30 s2600wf kernel: NET: Registered protocol family 2
Jan 01 00:00:30 s2600wf kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes, linear)
Jan 01 00:00:30 s2600wf kernel: TCP established hash table entries: 4096 (order: 2, 16384 bytes, linear)
Jan 01 00:00:30 s2600wf kernel: TCP bind hash table entries: 4096 (order: 2, 16384 bytes, linear)
Jan 01 00:00:30 s2600wf kernel: TCP: Hash tables configured (established 4096 bind 4096)
Jan 01 00:00:30 s2600wf kernel: UDP hash table entries: 256 (order: 0, 4096 bytes, linear)
Jan 01 00:00:30 s2600wf kernel: UDP-Lite hash table entries: 256 (order: 0, 4096 bytes, linear)
Jan 01 00:00:30 s2600wf kernel: NET: Registered protocol family 1
Jan 01 00:00:30 s2600wf kernel: Unpacking initramfs...
Jan 01 00:00:30 s2600wf kernel: random: fast init done
Jan 01 00:00:30 s2600wf kernel: Freeing initrd memory: 22508K
Jan 01 00:00:30 s2600wf kernel: workingset: timestamp_bits=30 max_order=17 bucket_order=0
Jan 01 00:00:30 s2600wf kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jan 01 00:00:30 s2600wf kernel: jffs2: version 2.2. (SUMMARY)  © 2001-2006 Red Hat, Inc.
Jan 01 00:00:30 s2600wf kernel: NET: Registered protocol family 38
Jan 01 00:00:30 s2600wf kernel: Serial: 8250/16550 driver, 6 ports, IRQ sharing enabled
Jan 01 00:00:30 s2600wf kernel: printk: console [ttyS4] disabled
Jan 01 00:00:30 s2600wf kernel: 1e784000.serial: ttyS4 at MMIO 0x1e784000 (irq = 30, base_baud = 1500000) is a 16550A
Jan 01 00:00:30 s2600wf kernel: printk: console [ttyS4] enabled
Jan 01 00:00:30 s2600wf kernel: timeriomem_rng 1e6e2078.hwrng: 32bits from 0x(ptrval) @ 1us
Jan 01 00:00:30 s2600wf kernel: aspeed_gfx 1e6e6000.display: failed to initialize reserved mem: -19
Jan 01 00:00:30 s2600wf kernel: random: crng init done
Jan 01 00:00:30 s2600wf kernel: loop: module loaded
Jan 01 00:00:30 s2600wf kernel: aspeed-smc 1e620000.spi: Using 50 MHz SPI frequency
Jan 01 00:00:30 s2600wf kernel: aspeed-smc 1e620000.spi: w25m512jv (32768 Kbytes)
Jan 01 00:00:30 s2600wf kernel: aspeed-smc 1e620000.spi: CE0 window [ 0x20000000 - 0x22000000 ] 32MB
Jan 01 00:00:30 s2600wf kernel: aspeed-smc 1e620000.spi: CE1 window [ 0x22000000 - 0x2a000000 ] 128MB
Jan 01 00:00:30 s2600wf kernel: aspeed-smc 1e620000.spi: read control register: 203b0641
Jan 01 00:00:30 s2600wf kernel: 5 fixed-partitions partitions found on MTD device bmc
Jan 01 00:00:30 s2600wf kernel: Creating 5 MTD partitions on "bmc":
Jan 01 00:00:30 s2600wf kernel: 0x000000000000-0x000000060000 : "u-boot"
Jan 01 00:00:30 s2600wf kernel: 0x000000060000-0x000000080000 : "u-boot-env"
Jan 01 00:00:30 s2600wf kernel: 0x000000080000-0x0000004c0000 : "kernel"
Jan 01 00:00:30 s2600wf kernel: 0x0000004c0000-0x000001c00000 : "rofs"
Jan 01 00:00:30 s2600wf kernel: 0x000001c00000-0x000002000000 : "rwfs"
Jan 01 00:00:30 s2600wf kernel: aspeed-smc 1e630000.spi: Using 50 MHz SPI frequency
Jan 01 00:00:30 s2600wf kernel: aspeed-smc 1e630000.spi: unrecognized JEDEC id bytes: 00 00 00 00 00 00
Jan 01 00:00:30 s2600wf kernel: aspeed-smc 1e630000.spi: Aspeed SMC probe failed -2
Jan 01 00:00:30 s2600wf kernel: aspeed-smc: probe of 1e630000.spi failed with error -2
Jan 01 00:00:30 s2600wf kernel: libphy: Fixed MDIO Bus: probed
Jan 01 00:00:30 s2600wf kernel: ftgmac100 1e660000.ethernet: Generated random MAC address 86:85:b9:3b:f6:98
Jan 01 00:00:30 s2600wf kernel: ftgmac100 1e660000.ethernet: Using NCSI interface
Jan 01 00:00:30 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: irq 19, mapped at 591e3696
Jan 01 00:00:30 s2600wf kernel: ftgmac100 1e680000.ethernet: Generated random MAC address 56:49:ff:da:1b:cc
Jan 01 00:00:30 s2600wf kernel: libphy: ftgmac100_mdio: probed
Jan 01 00:00:30 s2600wf kernel: Generic PHY 1e680000.ethernet--1:00: attached PHY driver [Generic PHY] (mii_bus:phy_addr=1e680000.ethernet--1:00, irq=POLL)
Jan 01 00:00:30 s2600wf kernel: ftgmac100 1e680000.ethernet eth1: irq 20, mapped at 593ad10f
Jan 01 00:00:30 s2600wf kernel: udc-core: couldn't find an available UDC - added [g_mass_storage] to list of pending drivers
Jan 01 00:00:30 s2600wf kernel: i2c /dev entries driver
Jan 01 00:00:30 s2600wf kernel: aspeed-i2c-bus 1e78a080.i2c-bus: i2c bus 1 registered, irq 31
Jan 01 00:00:30 s2600wf kernel: aspeed-i2c-bus 1e78a0c0.i2c-bus: i2c bus 2 registered, irq 32
Jan 01 00:00:30 s2600wf kernel: aspeed-i2c-bus 1e78a100.i2c-bus: i2c bus 3 registered, irq 33
Jan 01 00:00:30 s2600wf kernel: aspeed-i2c-bus 1e78a140.i2c-bus: i2c bus 4 registered, irq 34
Jan 01 00:00:30 s2600wf kernel: aspeed-i2c-bus 1e78a180.i2c-bus: i2c bus 5 registered, irq 35
Jan 01 00:00:30 s2600wf kernel: aspeed-i2c-bus 1e78a1c0.i2c-bus: i2c bus 6 registered, irq 36
Jan 01 00:00:30 s2600wf kernel: aspeed-i2c-bus 1e78a300.i2c-bus: i2c bus 7 registered, irq 37
Jan 01 00:00:30 s2600wf kernel: aspeed-i2c-bus 1e78a480.i2c-bus: i2c bus 13 registered, irq 38
Jan 01 00:00:30 s2600wf kernel: Driver for 1-wire Dallas network protocol.
Jan 01 00:00:30 s2600wf kernel: NET: Registered protocol family 10
Jan 01 00:00:30 s2600wf kernel: Segment Routing with IPv6
Jan 01 00:00:30 s2600wf kernel: sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
Jan 01 00:00:30 s2600wf kernel: NET: Registered protocol family 17
Jan 01 00:00:30 s2600wf kernel: 8021q: 802.1Q VLAN Support v1.8
Jan 01 00:00:30 s2600wf kernel: printk: console [netcon0] enabled
Jan 01 00:00:30 s2600wf kernel: netconsole: network logging started
Jan 01 00:00:30 s2600wf kernel: hctosys: unable to open rtc device (rtc0)
Jan 01 00:00:30 s2600wf kernel: Freeing unused kernel memory: 1024K
Jan 01 00:00:30 s2600wf kernel: Checked W+X mappings: passed, no W+X pages found
Jan 01 00:00:30 s2600wf kernel: Run /init as init process
Jan 01 00:00:30 s2600wf systemd[1]: Failed to lookup module alias 'autofs4': Function not implemented
Jan 01 00:00:30 s2600wf systemd[1]: systemd 243+ 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)
Jan 01 00:00:30 s2600wf systemd[1]: Detected architecture arm.
Jan 01 00:00:30 s2600wf systemd[1]: Set hostname to <s2600wf>.
Jan 01 00:00:30 s2600wf systemd[1]: Initializing machine ID from random generator.
Jan 01 00:00:30 s2600wf systemd[1]: Failed to put bus name to hashmap: File exists
Jan 01 00:00:30 s2600wf systemd[1]: xyz.openbmc_project.State.Host.service: Two services allocated for the same bus name xyz.openbmc_project.State.Host, refusing operation.
Jan 01 00:00:30 s2600wf systemd[1]: unit_file_find_fragment: obmc-host-reset-running at .target+0obmc-host-reset-running at 0.target
Jan 01 00:00:30 s2600wf systemd[1]: unit_file_find_fragment: obmc-host-reset at .target+0obmc-host-reset at 0.target
Jan 01 00:00:30 s2600wf systemd[1]: Configuration file /lib/systemd/system/fanmonitor.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Jan 01 00:00:30 s2600wf systemd[1]: /lib/systemd/system/phosphor-ipmi-net at .socket:3: Invalid interface name, ignoring: sys-subsystem-net-devices-%i.device
Jan 01 00:00:30 s2600wf systemd-journald[44]: Journal started
Jan 01 00:00:30 s2600wf systemd-journald[44]: Runtime Journal (/run/log/journal/f6ca6217810c4b2c9db636c5790555cf) is 8.0M, max 64.0M, 56.0M free.
Jan 01 00:00:29 s2600wf systemd-sysctl[47]: Couldn't write '16' to 'kernel/sysrq', ignoring: No such file or directory
Jan 01 00:00:29 s2600wf systemd-sysctl[47]: Couldn't write 'fq_codel' to 'net/core/default_qdisc', ignoring: No such file or directory
Jan 01 00:00:30 s2600wf systemd-sysusers[54]: Creating group wheel with gid 991.
Jan 01 00:00:30 s2600wf systemd-sysusers[54]: Creating group render with gid 990.
Jan 01 00:00:30 s2600wf systemd-sysusers[54]: Creating group nobody with gid 989.
Jan 01 00:00:30 s2600wf systemd[1]: Starting Flush Journal to Persistent Storage...
Jan 01 00:00:30 s2600wf systemd[1]: Starting Create Static Device Nodes in /dev...
Jan 01 00:00:30 s2600wf systemd-journald[44]: Runtime Journal (/run/log/journal/f6ca6217810c4b2c9db636c5790555cf) is 8.0M, max 64.0M, 56.0M free.
Jan 01 00:00:30 s2600wf systemd[1]: Started Flush Journal to Persistent Storage.
Jan 01 00:00:30 s2600wf systemd[1]: Started Create Static Device Nodes in /dev.
Jan 01 00:00:30 s2600wf rngd[49]: Initializing available sources
Jan 01 00:00:30 s2600wf rngd[49]: Initializing entropy source hwrng
Jan 01 00:00:30 s2600wf systemd[1]: Reached target Local File Systems (Pre).
Jan 01 00:00:30 s2600wf systemd[1]: Mounting /var/volatile...
Jan 01 00:00:30 s2600wf systemd[1]: Starting udev Kernel Device Manager...
Jan 01 00:00:30 s2600wf systemd[1]: Mounted /var/volatile.
Jan 01 00:00:31 s2600wf systemd[59]: systemd-udevd.service: ProtectHostname=yes is configured, but the kernel does not support UTS namespaces, ignoring namespace setup.
Jan 01 00:00:31 s2600wf systemd[1]: Condition check resulted in Bind mount volatile /var/cache being skipped.
Jan 01 00:00:31 s2600wf systemd[1]: Condition check resulted in Bind mount volatile /var/lib being skipped.
Jan 01 00:00:31 s2600wf systemd[1]: Starting Load/Save Random Seed...
Jan 01 00:00:31 s2600wf systemd[1]: Condition check resulted in Bind mount volatile /var/spool being skipped.
Jan 01 00:00:31 s2600wf systemd[1]: Condition check resulted in Bind mount volatile /srv being skipped.
Jan 01 00:00:31 s2600wf systemd[1]: Reached target Local File Systems.
Jan 01 00:00:31 s2600wf systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Jan 01 00:00:31 s2600wf systemd[1]: Starting Create Volatile Files and Directories...
Jan 01 00:00:31 s2600wf systemd[1]: Started Load/Save Random Seed.
Jan 01 00:00:31 s2600wf systemd[1]: Started udev Kernel Device Manager.
Jan 01 00:00:31 s2600wf systemd[1]: Starting Network Service...
Jan 01 00:00:31 s2600wf systemd[1]: Started Create Volatile Files and Directories.
Jan 01 00:00:31 s2600wf systemd[1]: Starting Run pending postinsts...
Jan 01 00:00:32 s2600wf systemd[1]: Starting Rebuild Journal Catalog...
Jan 01 00:00:32 s2600wf systemd[1]: Starting Network Time Synchronization...
Jan 01 00:00:32 s2600wf systemd[1]: Started Rebuild Journal Catalog.
Jan 01 00:00:32 s2600wf systemd[1]: Starting Update is Completed...
Jan 01 00:00:32 s2600wf run-postinsts[67]:  Removing any system startup links for run-postinsts ...
Jan 01 00:00:33 s2600wf systemd[1]: Started Update is Completed.
Jan 01 00:00:33 s2600wf systemd-networkd[62]: Enumeration completed
Jan 01 00:00:33 s2600wf systemd[1]: Started Network Service.
Jan 01 00:00:33 s2600wf systemd[1]: Starting Network Name Resolution...
Jan 01 00:00:33 s2600wf systemd-udevd[73]: Using default interface naming scheme 'v243'.
Jan 01 00:00:33 s2600wf systemd-udevd[65]: Using default interface naming scheme 'v243'.
Jan 01 00:00:34 s2600wf systemd-udevd[73]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jan 01 00:00:34 s2600wf systemctl[79]: Removed /etc/systemd/system/sysinit.target.wants/run-postinsts.service.
Jan 01 00:00:34 s2600wf systemd-udevd[65]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jan 01 00:00:34 s2600wf systemd[1]: run-postinsts.service: Succeeded.
Jan 01 00:00:34 s2600wf systemd[1]: Started Run pending postinsts.
Jan 01 00:00:34 s2600wf systemd[1]: Started udev Coldplug all Devices.
Jan 01 00:00:34 s2600wf systemd-networkd[62]: eth0: IPv6 successfully enabled
Jan 01 00:00:34 s2600wf kernel: 8021q: adding VLAN 0 to HW filter on device eth0
Jan 01 00:00:34 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI: Handler for packet type 0x82 returned -19
Jan 01 00:00:34 s2600wf systemd-networkd[62]: eth0: Gained carrier
Jan 01 00:00:34 s2600wf systemd-networkd[62]: eth1: IPv6 successfully enabled
Jan 01 00:00:35 s2600wf kernel: Generic PHY 1e680000.ethernet--1:00: PHY advertising (00,00000200,000062ff) more modes than genphy supports, some modes not advertised.
Jan 01 00:00:35 s2600wf systemd[69]: systemd-timesyncd.service: ProtectHostname=yes is configured, but the kernel does not support UTS namespaces, ignoring namespace setup.
Jan 01 00:00:35 s2600wf systemd-udevd[71]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jan 01 00:00:35 s2600wf systemd-udevd[66]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jan 01 00:00:36 s2600wf systemd[1]: Started Network Time Synchronization.
Jan 01 00:00:36 s2600wf systemd-networkd[62]: eth0: Gained IPv6LL
Jan 01 00:00:36 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:00:36 s2600wf systemd-resolved[80]: Positive Trust Anchors:
Jan 01 00:00:36 s2600wf systemd-resolved[80]: . IN DS 19036 8 2 49aac11d7b6f6446702e54a1607371607a1a41855200fd2ce1cdde32f24e8fb5
Jan 01 00:00:36 s2600wf systemd-resolved[80]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Jan 01 00:00:36 s2600wf systemd-resolved[80]: Negative trust anchors: 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test
Jan 01 00:00:36 s2600wf systemd-resolved[80]: Using system hostname 's2600wf'.
Jan 01 00:00:36 s2600wf systemd[1]: Started Network Name Resolution.
Jan 01 00:00:36 s2600wf systemd[1]: Created slice system-xyz.openbmc_project.Hwmon.slice.
Jan 01 00:00:36 s2600wf systemd[1]: Reached target Network.
Jan 01 00:00:36 s2600wf systemd[1]: Reached target Host and Network Name Lookups.
Jan 01 00:00:36 s2600wf systemd[1]: Reached target System Time Set.
Jan 01 00:00:36 s2600wf systemd[1]: Reached target System Time Synchronized.
Jan 01 00:00:36 s2600wf systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Jan 01 00:00:36 s2600wf systemd[1]: Condition check resulted in POSIX Message Queue File System being skipped.
Jan 01 00:00:36 s2600wf systemd[1]: Condition check resulted in Create list of static device nodes for the current kernel being skipped.
Jan 01 00:00:36 s2600wf systemd[1]: Starting Run pending postinsts...
Jan 01 00:00:36 s2600wf systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Jan 01 00:00:36 s2600wf systemd[1]: Condition check resulted in Load Kernel Modules being skipped.
Jan 01 00:00:36 s2600wf systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Jan 01 00:00:37 s2600wf run-postinsts[94]:  Removing any system startup links for run-postinsts ...
Jan 01 00:00:37 s2600wf systemd[1]: run-postinsts.service: Succeeded.
Jan 01 00:00:37 s2600wf systemd[1]: Started Run pending postinsts.
Jan 01 00:00:37 s2600wf systemd[1]: Reached target System Initialization.
Jan 01 00:00:37 s2600wf systemd[1]: Started Daily rotation of log files.
Jan 01 00:00:37 s2600wf systemd[1]: Started Run rotate-event-logs.service every minute.
Jan 01 00:00:37 s2600wf systemd[1]: Started Daily Cleanup of Temporary Directories.
Jan 01 00:00:37 s2600wf systemd[1]: Reached target Timers.
Jan 01 00:00:37 s2600wf systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Jan 01 00:00:37 s2600wf systemd[1]: Listening on BMC Webserver socket.
Jan 01 00:00:37 s2600wf systemd[1]: Listening on D-Bus System Message Bus Socket.
Jan 01 00:00:37 s2600wf systemd[1]: Listening on dropbear.socket.
Jan 01 00:00:37 s2600wf systemd[1]: Listening on Phosphor Host Console SSH Per-Connection socket.
Jan 01 00:00:37 s2600wf systemd[1]: Listening on phosphor-ipmi-net at eth1.socket.
Jan 01 00:00:37 s2600wf systemd[1]: Reached target Sockets.
Jan 01 00:00:37 s2600wf systemd[1]: Starting D-Bus System Message Bus...
Jan 01 00:00:38 s2600wf systemd[1]: Started D-Bus System Message Bus.
Jan 01 00:00:38 s2600wf systemd[1]: Reached target Basic System.
Jan 01 00:00:38 s2600wf systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Jan 01 00:00:38 s2600wf dbus-broker-lau[99]: Ready
Jan 01 00:00:38 s2600wf systemd[1]: Started Start bmcweb server.
Jan 01 00:00:38 s2600wf systemd[1]: Starting Clear one time boot overrides...
Jan 01 00:00:38 s2600wf systemd[1]: Starting SSH Key Generation...
Jan 01 00:00:38 s2600wf fw_setenv[103]: Warning: Bad CRC, using default environment
Jan 01 00:00:38 s2600wf systemd[1]: Starting Gpio configuration...
Jan 01 00:00:38 s2600wf systemd[1]: Starting Run Scripts at Start and Stop...
Jan 01 00:00:38 s2600wf systemd[1]: Starting Name Service Cache Daemon...
Jan 01 00:00:38 s2600wf systemd[1]: Starting LDAP daemon...
Jan 01 00:00:38 s2600wf sh[105]: Generating 2048 bit rsa key, this may take a while...
Jan 01 00:00:38 s2600wf systemd[1]: Started Phosphor Dump core monitor..
Jan 01 00:00:38 s2600wf nscd[114]: 114 monitoring file `/etc/passwd` (1)
Jan 01 00:00:38 s2600wf systemd[1]: Starting Phosphor BMC0 Control...
Jan 01 00:00:38 s2600wf nscd[114]: 114 monitoring directory `/etc` (2)
Jan 01 00:00:38 s2600wf nscd[114]: 114 monitoring file `/etc/group` (3)
Jan 01 00:00:38 s2600wf nscd[114]: 114 monitoring directory `/etc` (2)
Jan 01 00:00:38 s2600wf nscd[114]: 114 monitoring file `/etc/hosts` (4)
Jan 01 00:00:38 s2600wf nscd[114]: 114 monitoring directory `/etc` (2)
Jan 01 00:00:38 s2600wf nscd[114]: 114 monitoring file `/etc/resolv.conf` (5)
Jan 01 00:00:38 s2600wf nscd[114]: 114 monitoring directory `/etc` (2)
Jan 01 00:00:38 s2600wf nscd[114]: 114 monitoring file `/etc/services` (6)
Jan 01 00:00:38 s2600wf nscd[114]: 114 monitoring directory `/etc` (2)
Jan 01 00:00:38 s2600wf systemd[1]: Starting OpenPOWER Host0 Control...
Jan 01 00:00:39 s2600wf systemd[1]: Starting Phosphor Download Manager...
Jan 01 00:00:39 s2600wf nslcd[130]: version 0.9.8 starting
Jan 01 00:00:39 s2600wf nslcd[130]: accepting connections
Jan 01 00:00:39 s2600wf sh[107]: /usr/sbin/initscript.sh: line 14: /sys/class/hwmon/hwmon0/pwm1: Permission denied
Jan 01 00:00:39 s2600wf sh[107]: /usr/sbin/initscript.sh: line 15: /sys/class/hwmon/hwmon0/pwm2: Permission denied
Jan 01 00:00:39 s2600wf kernel: ftgmac100 1e680000.ethernet eth1: Link is Up - 1Gbps/Full - flow control off
Jan 01 00:00:39 s2600wf kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
Jan 01 00:00:39 s2600wf systemd-networkd[62]: eth1: Gained carrier
Jan 01 00:00:39 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:00:39 s2600wf nscd[114]: 114 ignored inotify event for `/etc/resolv.conf` (file exists)
Jan 01 00:00:39 s2600wf nscd[114]: 114 ignored inotify event for `/etc/resolv.conf` (file exists)
Jan 01 00:00:39 s2600wf systemd[1]: Started Phosphor certificate manager for authority.
Jan 01 00:00:39 s2600wf sh[106]: mask f5425286
Jan 01 00:00:39 s2600wf sh[106]: Value f5425286
Jan 01 00:00:39 s2600wf sh[106]: buffer f5425286
Jan 01 00:00:39 s2600wf sh[106]: Command devmem 0x1E6E2070 w 0xf5425286
Jan 01 00:00:39 s2600wf sh[106]: mask c0a003
Jan 01 00:00:39 s2600wf sh[106]: Value c0a003
Jan 01 00:00:39 s2600wf sh[106]: buffer c0a003
Jan 01 00:00:39 s2600wf sh[106]: Command devmem 0x1E6E2080 w 0xc0a003
Jan 01 00:00:39 s2600wf sh[106]: mask ff0f00
Jan 01 00:00:39 s2600wf sh[106]: Value ffff00
Jan 01 00:00:39 s2600wf sh[106]: buffer ffff00
Jan 01 00:00:39 s2600wf sh[106]: Command devmem 0x1E6E2084 w 0xffff00
Jan 01 00:00:39 s2600wf sh[106]: mask ff
Jan 01 00:00:39 s2600wf sh[106]: Value 30000ff
Jan 01 00:00:39 s2600wf sh[106]: buffer 30000ff
Jan 01 00:00:39 s2600wf sh[106]: Command devmem 0x1E6E2088 w 0x30000ff
Jan 01 00:00:39 s2600wf sh[106]: mask ffffffbf
Jan 01 00:00:39 s2600wf sh[106]: Value 87fa004
Jan 01 00:00:39 s2600wf sh[106]: buffer 87fa004
Jan 01 00:00:39 s2600wf sh[106]: Command devmem 0x1E6E2090 w 0x87fa004
Jan 01 00:00:39 s2600wf sh[106]: mask fffffffc
Jan 01 00:00:39 s2600wf sh[106]: Value a000
Jan 01 00:00:39 s2600wf sh[106]: buffer a000
Jan 01 00:00:39 s2600wf sh[106]: Command devmem 0x1E6E2094 w 0xa000
Jan 01 00:00:39 s2600wf systemd[1]: Started Phosphor certificate manager for bmcweb.
Jan 01 00:00:39 s2600wf systemd[1]: Started Phosphor certificate manager for nslcd.
Jan 01 00:00:39 s2600wf systemd[1]: Started Phosphor-Pid-Control Margin-based Fan Control Daemon.
Jan 01 00:00:40 s2600wf systemd[1]: Started phosphor systemd target monitor.
Jan 01 00:00:40 s2600wf systemd[1]: Starting Rotates the event logs...
Jan 01 00:00:40 s2600wf systemd[1]: Starting System Logging Service...
Jan 01 00:00:40 s2600wf systemd[1]: Started Lightweight SLP Server.
Jan 01 00:00:40 s2600wf systemd[1]: Starting OpenBMC ipKVM daemon...
Jan 01 00:00:40 s2600wf systemd[1]: Starting Permit User Sessions...
Jan 01 00:00:40 s2600wf sh[107]: read command /sbin/devmem 0x1E7801E0 w > /var/registerValue
Jan 01 00:00:40 s2600wf sh[107]: mask ffbfffff
Jan 01 00:00:40 s2600wf sh[107]: [16B blob data]
Jan 01 00:00:40 s2600wf sh[107]: Value 2881c0
Jan 01 00:00:40 s2600wf sh[107]: buffer 2881c0
Jan 01 00:00:40 s2600wf sh[107]: Command /sbin/devmem 0x1E7801E0 w 0x2881c0
Jan 01 00:00:40 s2600wf sh[107]: read command /sbin/devmem 0x1E7801E0 w > /var/registerValue
Jan 01 00:00:40 s2600wf sh[107]: mask 400004
Jan 01 00:00:40 s2600wf sh[107]: [16B blob data]
Jan 01 00:00:40 s2600wf sh[107]: Value 6881c4
Jan 01 00:00:40 s2600wf sh[107]: buffer 6881c4
Jan 01 00:00:40 s2600wf sh[107]: Command /sbin/devmem 0x1E7801E0  w 0x6881c4
Jan 01 00:00:40 s2600wf sh[107]: Chassis Power: On
Jan 01 00:00:40 s2600wf systemd[1]: Starting Intel Power Control...
Jan 01 00:00:40 s2600wf rsyslogd[165]: warning: ~ action is deprecated, consider using the 'stop' statement instead [v8.1910.0 try https://www.rsyslog.com/e/2307 ]
Jan 01 00:00:40 s2600wf rsyslogd[165]: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd.  [v8.1910.0]
Jan 01 00:00:41 s2600wf rsyslogd[165]: [origin software="rsyslogd" swVersion="8.1910.0" x-pid="165" x-info="https://www.rsyslog.com"] start
Jan 01 00:00:41 s2600wf systemd[1]: Starting Phosphor Dump Manager...
Jan 01 00:00:41 s2600wf systemd[1]: Starting Entity Manager...
Jan 01 00:00:41 s2600wf systemd-networkd[62]: eth1: Gained IPv6LL
Jan 01 00:00:41 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:00:41 s2600wf swampd[157]: terminate called after throwing an instance of 'std::runtime_error'
Jan 01 00:00:41 s2600wf swampd[157]:   what():  ObjectMapper Call Failure
Jan 01 00:00:41 s2600wf systemd[1]: Started Fru Device.
Jan 01 00:00:41 s2600wf phosphor-systemd-target-monitor[161]: org.freedesktop.systemd1 not on dbus yet
Jan 01 00:00:41 s2600wf systemd[1]: Starting Phosphor Inventory Manager...
Jan 01 00:00:41 s2600wf systemd[1]: Starting Phosphor LDAP privilege mapper...
Jan 01 00:00:41 s2600wf systemd[1]: Starting Phosphor LED Group Management Daemon...
Jan 01 00:00:41 s2600wf create_usbhid.sh[167]: /usr/bin/create_usbhid.sh: line 133: echo: write error: No such device
Jan 01 00:00:41 s2600wf power-control[169]: Start Chassis power control service...
Jan 01 00:00:41 s2600wf systemd[1]: Starting Phosphor Log Manager...
Jan 01 00:00:42 s2600wf systemd[1]: Starting Phosphor DBus Service Discovery Manager...
Jan 01 00:00:42 s2600wf power-control[169]: Failed to find the PS_PWROK line
Jan 01 00:00:42 s2600wf systemd[1]: Starting Phosphor Settings Daemon...
Jan 01 00:00:42 s2600wf systemd[1]: Starting Phosphor Download Manager...
Jan 01 00:00:42 s2600wf systemd[1]: Starting Rsyslog config updater...
Jan 01 00:00:42 s2600wf systemd[1]: Starting Phosphor User Manager...
Jan 01 00:00:43 s2600wf systemd-networkd[62]: eth1: DHCPv4 address 10.208.23.226/23 via 10.208.22.1
Jan 01 00:00:43 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:00:43 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:00:43 s2600wf systemd[1]: Started System Logging Service.
Jan 01 00:00:44 s2600wf systemd[1]: gpiolist.service: Main process exited, code=exited, status=1/FAILURE
Jan 01 00:00:44 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:44 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:44 s2600wf systemd[1]: gpiolist.service: Failed with result 'exit-code'.
Jan 01 00:00:44 s2600wf systemd[1]: Failed to start Gpio configuration.
Jan 01 00:00:44 s2600wf systemd[1]: Started Run Scripts at Start and Stop.
Jan 01 00:00:44 s2600wf systemd[1]: Started Name Service Cache Daemon.
Jan 01 00:00:44 s2600wf systemd[1]: Started LDAP daemon.
Jan 01 00:00:44 s2600wf systemd[1]: phosphor-pid-control.service: Main process exited, code=killed, status=6/ABRT
Jan 01 00:00:44 s2600wf systemd[1]: phosphor-pid-control.service: Failed with result 'signal'.
Jan 01 00:00:44 s2600wf bmcweb[102]: Checking certs in file /etc/ssl/certs/https/server.pem
Jan 01 00:00:44 s2600wf bmcweb[102]: Error in verifying signature, regenerating
Jan 01 00:00:44 s2600wf bmcweb[102]: Generating new keys
Jan 01 00:00:44 s2600wf bmcweb[102]: Generating EC key
Jan 01 00:00:44 s2600wf systemd[1]: rotate-event-logs.service: Succeeded.
Jan 01 00:00:44 s2600wf bmcweb[102]: Generating x509 Certificate
Jan 01 00:00:44 s2600wf systemd[1]: Started Rotates the event logs.
Jan 01 00:00:44 s2600wf systemd[1]: Started OpenBMC ipKVM daemon.
Jan 01 00:00:44 s2600wf systemd[1]: Started Permit User Sessions.
Jan 01 00:00:44 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Main process exited, code=exited, status=255/EXCEPTION
Jan 01 00:00:44 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Failed with result 'exit-code'.
Jan 01 00:00:45 s2600wf systemd[1]: Failed to start Intel Power Control.
Jan 01 00:00:45 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:45 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:45 s2600wf systemd[1]: Started Clear one time boot overrides.
Jan 01 00:00:45 s2600wf systemd[1]: Started Entity Manager.
Jan 01 00:00:45 s2600wf obmc-ikvm[203]: Failed to open input device
Jan 01 00:00:45 s2600wf avahi-daemon[206]: Found user 'avahi' (UID 997) and group 'avahi' (GID 997).
Jan 01 00:00:45 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:45 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:45 s2600wf obmc-ikvm[203]: Failed to open a file
Jan 01 00:00:45 s2600wf obmc-ikvm[203]: terminate called after throwing an instance of 'sdbusplus::xyz::openbmc_project::Common::File::Error::Open'
Jan 01 00:00:45 s2600wf obmc-ikvm[203]:   what():  xyz.openbmc_project.Common.File.Error.Open: Failed to open a file
Jan 01 00:00:45 s2600wf phosphor-systemd-target-monitor[161]: org.freedesktop.systemd1 is now on dbus
Jan 01 00:00:45 s2600wf systemd[1]: start-ipkvm.service: Main process exited, code=killed, status=6/ABRT
Jan 01 00:00:45 s2600wf systemd[1]: start-ipkvm.service: Failed with result 'signal'.
Jan 01 00:00:45 s2600wf systemd[1]: Started Phosphor Download Manager.
Jan 01 00:00:46 s2600wf systemd[1]: Started Phosphor Log Manager.
Jan 01 00:00:46 s2600wf systemd[1]: Started Phosphor LED Group Management Daemon.
Jan 01 00:00:46 s2600wf systemd[1]: Started Phosphor Settings Daemon.
Jan 01 00:00:46 s2600wf systemd[1]: Started Phosphor LDAP privilege mapper.
Jan 01 00:00:46 s2600wf systemd[1]: Started Phosphor DBus Service Discovery Manager.
Jan 01 00:00:46 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:46 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:46 s2600wf entity-manager[207]: Clearing previous configuration
Jan 01 00:00:46 s2600wf systemd[1]: Started OpenPOWER Host0 Control.
Jan 01 00:00:46 s2600wf systemd[1]: Started Rsyslog config updater.
Jan 01 00:00:46 s2600wf systemd[1]: Started Phosphor BMC0 Control.
Jan 01 00:00:46 s2600wf systemd[1]: Started Phosphor Inventory Manager.
Jan 01 00:00:46 s2600wf systemd[1]: Started Phosphor Dump Manager.
Jan 01 00:00:46 s2600wf systemd[1]: Reached target Phosphor Object Mapper.
Jan 01 00:00:46 s2600wf systemd[1]: Condition check resulted in Getty on tty1 being skipped.
Jan 01 00:00:46 s2600wf systemd[1]: Starting Wait for /org/openbmc/managers/Download...
Jan 01 00:00:46 s2600wf systemd[1]: Starting Wait for /xyz/openbmc_project/control/host0/boot/one_time...
Jan 01 00:00:46 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:46 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:46 s2600wf systemd[1]: Starting Wait for /xyz/openbmc_project/control/host0/boot...
Jan 01 00:00:46 s2600wf systemd[1]: Starting Wait for /xyz/openbmc_project/control/host0/power_restore_policy...
Jan 01 00:00:47 s2600wf systemd[1]: Starting Wait for /xyz/openbmc_project/control/host0/restriction_mode...
Jan 01 00:00:47 s2600wf systemd[1]: Starting Wait for /xyz/openbmc_project/led/groups/bmc_booted...
Jan 01 00:00:47 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:47 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:47 s2600wf systemd[1]: Starting Wait for /xyz/openbmc_project/led/groups...
Jan 01 00:00:47 s2600wf systemd[1]: Starting Wait for /xyz/openbmc_project/state/chassis0...
Jan 01 00:00:47 s2600wf systemd[1]: Starting Wait for /xyz/openbmc_project/state/host0...
Jan 01 00:00:47 s2600wf systemd[1]: Starting Wait for /xyz/openbmc_project/time/owner...
Jan 01 00:00:47 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:47 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:47 s2600wf systemd[1]: Starting Wait for /xyz/openbmc_project/time/sync_method...
Jan 01 00:00:47 s2600wf systemd[1]: Started Phosphor DBus Monitor.
Jan 01 00:00:48 s2600wf systemd[1]: Started Serial Getty on ttyS4.
Jan 01 00:00:48 s2600wf systemd[1]: Reached target Login Prompts.
Jan 01 00:00:48 s2600wf systemd[1]: Condition check resulted in Phosphor Hwmon Poller being skipped.
Jan 01 00:00:48 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:48 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:48 s2600wf systemd[1]: Starting Phosphor Ldap config updater...
Jan 01 00:00:48 s2600wf systemd[1]: Starting Phosphor SNMP conf Manager...
Jan 01 00:00:48 s2600wf systemd[1]: Starting Phosphor Network Manager...
Jan 01 00:00:48 s2600wf systemd[1]: Starting OpenBMC Software Update Manager...
Jan 01 00:00:48 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:48 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:48 s2600wf systemd[1]: Starting Phosphor BMC State Manager...
Jan 01 00:00:48 s2600wf fru-device[180]: Error reading bus 2
Jan 01 00:00:49 s2600wf systemd[1]: Starting Phosphor Chassis State Manager...
Jan 01 00:00:49 s2600wf systemd[1]: Started Adc Sensor.
Jan 01 00:00:49 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:49 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:49 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:49 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:49 s2600wf systemd[1]: Started CPU Sensor.
Jan 01 00:00:49 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:49 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:49 s2600wf systemd[1]: Started Exit Air Temp Sensor.
Jan 01 00:00:49 s2600wf phosphor-network-manager[223]: Created the default network file.
Jan 01 00:00:50 s2600wf phosphor-network-manager[223]: Created the default network file.
Jan 01 00:00:50 s2600wf phosphor-network-manager[223]: Created the default network file.
Jan 01 00:00:50 s2600wf systemd[1]: Started Fan Sensor.
Jan 01 00:00:51 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI: No channel with link found, configuring channel 0
Jan 01 00:00:50 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:50 s2600wf systemd[1]: Started Hwmon Temp Sensor.
Jan 01 00:00:50 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:50 s2600wf systemd[1]: Started Intrusion Sensor.
Jan 01 00:00:50 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:51 s2600wf systemd[1]: Started IPMB Sensor.
Jan 01 00:00:50 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:51 s2600wf systemd[1]: Started MCU Temp Sensor.
Jan 01 00:00:50 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:51 s2600wf systemd[1]: Started PSU Sensor.
Jan 01 00:00:50 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:50 s2600wf nslcd[130]: [334873] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:50 s2600wf nslcd[130]: [334873] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:51 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:52 s2600wf phosphor-mapper[192]: Found invalid association on path /xyz/openbmc_project/software/81ce8d58
Jan 01 00:00:52 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:00:51 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:51 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:51 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:51 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:51 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:51 s2600wf nslcd[130]: [334873] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:51 s2600wf nslcd[130]: [334873] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:52 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:52 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:52 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:52 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:52 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:52 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:52 s2600wf nslcd[130]: [334873] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:52 s2600wf nslcd[130]: [334873] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:53 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:53 s2600wf nslcd[130]: [8b4567] <group="priv-noaccess"> no available LDAP server found: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:53 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:53 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:53 s2600wf systemd-networkd[62]: eth1: Configured
Jan 01 00:00:53 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:53 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:53 s2600wf nslcd[130]: [334873] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:53 s2600wf nslcd[130]: [334873] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:53 s2600wf systemd[1]: Started Wait for /xyz/openbmc_project/control/host0/boot/one_time.
Jan 01 00:00:53 s2600wf systemd[1]: Started Wait for /xyz/openbmc_project/control/host0/boot.
Jan 01 00:00:54 s2600wf systemd[1]: Started Wait for /xyz/openbmc_project/control/host0/power_restore_policy.
Jan 01 00:00:54 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:54 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:54 s2600wf systemd[1]: Started Wait for /xyz/openbmc_project/control/host0/restriction_mode.
Jan 01 00:00:54 s2600wf intrusion-sensor[234]: can't find matched I2C or GPIO configuration for intrusion sensor.
Jan 01 00:00:54 s2600wf systemd[1]: Started Wait for /xyz/openbmc_project/led/groups/bmc_booted.
Jan 01 00:00:54 s2600wf psusensor[240]: Driver name aspeed_pwm_tacho not found in sensor whitelist
Jan 01 00:00:54 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:54 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:54 s2600wf nslcd[130]: [334873] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:54 s2600wf nslcd[130]: [334873] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:54 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:54 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found, sleeping 1 seconds
Jan 01 00:00:54 s2600wf systemd[1]: Started Wait for /xyz/openbmc_project/led/groups.
Jan 01 00:00:55 s2600wf systemd[1]: Started Wait for /xyz/openbmc_project/time/owner.
Jan 01 00:00:55 s2600wf entity-manager[207]: Inventory Added
Jan 01 00:00:55 s2600wf systemd[1]: Started Wait for /xyz/openbmc_project/time/sync_method.
Jan 01 00:00:55 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:55 s2600wf nslcd[130]: [3c9869] <group="priv-noaccess"> no available LDAP server found: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:55 s2600wf phosphor-user-manager[196]: Group not found
Jan 01 00:00:55 s2600wf nslcd[130]: [334873] <group/member="avahi"> no available LDAP server found: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:55 s2600wf nslcd[130]: [334873] <group/member="avahi"> no available LDAP server found: Server is unavailable: Transport endpoint is not connected
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Successfully dropped root privileges.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: avahi-daemon 0.7 starting up.
Jan 01 00:00:55 s2600wf nslcd[130]: [7b23c6] <group/member="avahi"> no available LDAP server found: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Successfully called chroot().
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Successfully dropped remaining capabilities.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Loading service file /services/obmc_console.service.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Loading service file /services/sftp-ssh.service.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Loading service file /services/ssh.service.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Joining mDNS multicast group on interface eth1.IPv6 with address fe80::184b:b0ff:fea8:9d96.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: New relevant interface eth1.IPv6 for mDNS.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Joining mDNS multicast group on interface eth1.IPv4 with address 10.208.23.226.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: New relevant interface eth1.IPv4 for mDNS.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::9445:9dff:fe6b:9585.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: New relevant interface eth0.IPv6 for mDNS.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Network interface enumeration completed.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Registering new address record for fe80::184b:b0ff:fea8:9d96 on eth1.*.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Registering new address record for 10.208.23.226 on eth1.IPv4.
Jan 01 00:00:55 s2600wf avahi-daemon[206]: Registering new address record for fe80::9445:9dff:fe6b:9585 on eth0.*.
Jan 01 00:00:55 s2600wf kernel: lm75 5-0048: hwmon1: sensor 'tmp75'
Jan 01 00:00:55 s2600wf kernel: i2c i2c-5: new_device: Instantiated device tmp75 at 0x48
Jan 01 00:00:56 s2600wf kernel: lm75 5-0049: hwmon2: sensor 'tmp75'
Jan 01 00:00:56 s2600wf kernel: i2c i2c-5: new_device: Instantiated device tmp75 at 0x49
Jan 01 00:00:56 s2600wf kernel: lm75 5-004a: hwmon3: sensor 'tmp75'
Jan 01 00:00:56 s2600wf kernel: i2c i2c-5: new_device: Instantiated device tmp75 at 0x4a
Jan 01 00:00:56 s2600wf fru-device[180]: Error reading bus 7
Jan 01 00:00:56 s2600wf systemd[1]: Started Phosphor SNMP conf Manager.
Jan 01 00:00:56 s2600wf kernel: lm75 5-004c: hwmon4: sensor 'tmp75'
Jan 01 00:00:56 s2600wf kernel: i2c i2c-5: new_device: Instantiated device tmp75 at 0x4c
Jan 01 00:00:56 s2600wf systemd[1]: start-ipkvm.service: Service RestartSec=1s expired, scheduling restart.
Jan 01 00:00:56 s2600wf systemd[1]: start-ipkvm.service: Scheduled restart job, restart counter is at 1.
Jan 01 00:00:56 s2600wf avahi-daemon[206]: Server startup complete. Host name is s2600wf.local. Local service cookie is 4216281580.
Jan 01 00:00:56 s2600wf systemd[1]: phosphor-pid-control.service: Service RestartSec=5s expired, scheduling restart.
Jan 01 00:00:56 s2600wf systemd[1]: phosphor-pid-control.service: Scheduled restart job, restart counter is at 1.
Jan 01 00:00:56 s2600wf kernel: lm75 5-004f: hwmon5: sensor 'tmp75'
Jan 01 00:00:56 s2600wf kernel: i2c i2c-5: new_device: Instantiated device tmp75 at 0x4f
Jan 01 00:00:56 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Service RestartSec=3s expired, scheduling restart.
Jan 01 00:00:56 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Scheduled restart job, restart counter is at 1.
Jan 01 00:00:57 s2600wf systemd[1]: Started Phosphor Ldap config updater.
Jan 01 00:00:57 s2600wf avahi-daemon[206]: Service "s2600wf" (/services/ssh.service) successfully established.
Jan 01 00:00:57 s2600wf avahi-daemon[206]: Service "s2600wf" (/services/sftp-ssh.service) successfully established.
Jan 01 00:00:57 s2600wf avahi-daemon[206]: Service "obmc_console" (/services/obmc_console.service) successfully established.
Jan 01 00:00:57 s2600wf fru-device[180]: device at bus 7 register 6 busy
Jan 01 00:00:58 s2600wf systemd[1]: Started Phosphor Network Manager.
Jan 01 00:01:01 s2600wf systemd[1]: Started OpenBMC Software Update Manager.
Jan 01 00:01:02 s2600wf phosphor-chassis-state-manager[226]: Initial Chassis State will be Off
Jan 01 00:01:02 s2600wf systemd[1]: Started Phosphor User Manager.
Jan 01 00:01:02 s2600wf systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Jan 01 00:01:02 s2600wf systemd[1]: Started Phosphor Chassis State Manager.
Jan 01 00:01:02 s2600wf phosphor-bmc-state-manager[225]: Setting the BMCState field
Jan 01 00:01:02 s2600wf phosphor-bmc-state-manager[225]: Setting the BMCState field
Jan 01 00:01:02 s2600wf systemd[1]: Started FRU Fault monitor service.
Jan 01 00:01:02 s2600wf systemd[1]: Starting Phosphor Inband IPMI...
Jan 01 00:01:02 s2600wf systemd[1]: Stopped Phosphor-Pid-Control Margin-based Fan Control Daemon.
Jan 01 00:01:03 s2600wf systemd[1]: Started Phosphor-Pid-Control Margin-based Fan Control Daemon.
Jan 01 00:01:03 s2600wf systemd[1]: Starting Rotates the event logs...
Jan 01 00:01:03 s2600wf systemd[1]: Stopped OpenBMC ipKVM daemon.
Jan 01 00:01:03 s2600wf systemd[1]: Starting OpenBMC ipKVM daemon...
Jan 01 00:01:03 s2600wf systemd[1]: Stopping Network Service...
Jan 01 00:01:03 s2600wf systemd[1]: Stopped Intel Power Control.
Jan 01 00:01:03 s2600wf systemd[1]: Starting Intel Power Control...
Jan 01 00:01:03 s2600wf systemd[1]: Condition check resulted in Phosphor Hwmon Poller being skipped.
Jan 01 00:01:03 s2600wf systemd[1]: Condition check resulted in Phosphor Hwmon Poller being skipped.
Jan 01 00:01:03 s2600wf systemd[1]: Condition check resulted in Phosphor Hwmon Poller being skipped.
Jan 01 00:01:03 s2600wf systemd[1]: Condition check resulted in Phosphor Hwmon Poller being skipped.
Jan 01 00:01:04 s2600wf systemd[1]: Condition check resulted in Phosphor Hwmon Poller being skipped.
Jan 01 00:01:04 s2600wf systemd[1]: Starting Phosphor Version Software Manager...
Jan 01 00:01:04 s2600wf power-control[276]: Start Chassis power control service...
Jan 01 00:01:04 s2600wf power-control[276]: terminate called after throwing an instance of 'sdbusplus::exception::SdBusError'
Jan 01 00:01:04 s2600wf power-control[276]:   what():  sd_bus_request_name: org.freedesktop.DBus.Error.FileExists: File exists
Jan 01 00:01:04 s2600wf ipmid[270]: JSON file not found
Jan 01 00:01:04 s2600wf ipmid[270]: JSON file not found
Jan 01 00:01:05 s2600wf ipmid[270]: Registering OEM:[0X00C2CF], Cmd:[0X04] for Manual Zone Control
Jan 01 00:01:05 s2600wf systemd[1]: systemd-networkd.service: Succeeded.
Jan 01 00:01:05 s2600wf systemd[1]: Stopped Network Service.
Jan 01 00:01:05 s2600wf systemd[1]: rotate-event-logs.service: Succeeded.
Jan 01 00:01:05 s2600wf systemd[1]: Started Rotates the event logs.
Jan 01 00:01:05 s2600wf ipmid[270]: Error in reading IPMI user data file
Jan 01 00:01:05 s2600wf systemd[1]: Started OpenBMC ipKVM daemon.
Jan 01 00:01:05 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Main process exited, code=killed, status=6/ABRT
Jan 01 00:01:05 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Failed with result 'signal'.
Jan 01 00:01:05 s2600wf systemd[1]: Failed to start Intel Power Control.
Jan 01 00:01:06 s2600wf phosphor-mapper[192]: Introspect call failed with error: generic:113, No route to host on process: xyz.openbmc_project.State.Host path: /
Jan 01 00:01:06 s2600wf swampd[271]: No fan zones, application pausing until new configuration
Jan 01 00:01:06 s2600wf systemd[1]: Started Phosphor BMC State Manager.
Jan 01 00:01:06 s2600wf systemd[1]: Started Phosphor Inband IPMI.
Jan 01 00:01:06 s2600wf systemd[1]: Started Fan Monitor Service.
Jan 01 00:01:06 s2600wf obmc-ikvm[278]: Failed to open input device
Jan 01 00:01:06 s2600wf obmc-ikvm[278]: Failed to open a file
Jan 01 00:01:06 s2600wf phosphor-mapper[192]: Introspect call failed with error: generic:53, Invalid request descriptor on process: xyz.openbmc_project.State.FanCtrl path: /
Jan 01 00:01:06 s2600wf obmc-ikvm[278]: terminate called after throwing an instance of 'sdbusplus::xyz::openbmc_project::Common::File::Error::Open'
Jan 01 00:01:06 s2600wf obmc-ikvm[278]:   what():  xyz.openbmc_project.Common.File.Error.Open: Failed to open a file
Jan 01 00:01:06 s2600wf systemd[1]: Started Phosphor IPMI KCS DBus Bridge.
Jan 01 00:01:07 s2600wf systemd[1]: Started Network IPMI daemon.
Jan 01 00:01:07 s2600wf systemd[1]: Condition check resulted in Check Host0 status on BMC reset being skipped.
Jan 01 00:01:07 s2600wf systemd[1]: Reached target Host0 running after reset.
Jan 01 00:01:07 s2600wf ipmid[270]: Loading whitelist filter
Jan 01 00:01:07 s2600wf phosphor-mapper[192]: Introspect call failed with error: generic:53, Invalid request descriptor on process: xyz.openbmc_project.Hwmon.external path: /
Jan 01 00:01:07 s2600wf systemd[1]: Condition check resulted in Start host0 running after BMC reset being skipped.
Jan 01 00:01:08 s2600wf ipmid[270]: Registering OEM commands
Jan 01 00:01:08 s2600wf kcsbridged[282]: Couldn't open SMS channel O_RDWR
Jan 01 00:01:08 s2600wf systemd[1]: Starting Network Service...
Jan 01 00:01:08 s2600wf nslcd[130]: [b0dc51] <group/member="systemd-network"> failed to bind to LDAP server ldap://127.0.0.1/: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:01:08 s2600wf nslcd[130]: [b0dc51] <group/member="systemd-network"> no available LDAP server found: Can't contact LDAP server: Transport endpoint is not connected
Jan 01 00:01:08 s2600wf nslcd[130]: [b0dc51] <group/member="systemd-network"> no available LDAP server found: Server is unavailable: Transport endpoint is not connected
Jan 01 00:01:08 s2600wf ipmid[270]: Registering MultiNode commands
Jan 01 00:01:08 s2600wf ipmid[270]: Registering App commands
Jan 01 00:01:08 s2600wf ipmid[270]: Registering Chassis commands
Jan 01 00:01:08 s2600wf login[220]: pam_unix(login:auth): authentication failure; logname=LOGIN uid=0 euid=0 tty=/dev/ttyS4 ruser= rhost=  user=root
Jan 01 00:01:08 s2600wf nslcd[130]: [495cff] <authc="root"> no available LDAP server found: Server is unavailable: Transport endpoint is not connected
Jan 01 00:01:08 s2600wf login[220]: pam_ldap(login:auth): error reading from nslcd: Connection reset by peer
Jan 01 00:01:08 s2600wf download_manager.py[125]: Running Download Manager
Jan 01 00:01:09 s2600wf systemd[1]: start-ipkvm.service: Main process exited, code=killed, status=6/ABRT
Jan 01 00:01:09 s2600wf systemd[1]: start-ipkvm.service: Failed with result 'signal'.
Jan 01 00:01:10 s2600wf systemd[1]: phosphor-ipmi-kcs at ipmi-kcs3.service: Main process exited, code=exited, status=1/FAILURE
Jan 01 00:01:10 s2600wf systemd[1]: phosphor-ipmi-kcs at ipmi-kcs3.service: Failed with result 'exit-code'.
Jan 01 00:01:10 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Service RestartSec=3s expired, scheduling restart.
Jan 01 00:01:10 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Scheduled restart job, restart counter is at 2.
Jan 01 00:01:11 s2600wf systemd[1]: Started Phosphor Version Software Manager.
Jan 01 00:01:11 s2600wf systemd[1]: start-ipkvm.service: Service RestartSec=1s expired, scheduling restart.
Jan 01 00:01:11 s2600wf systemd[1]: start-ipkvm.service: Scheduled restart job, restart counter is at 2.
Jan 01 00:01:11 s2600wf login[220]: FAILED LOGIN (1) on '/dev/ttyS4' FOR 'root', Authentication failure
Jan 01 00:01:11 s2600wf systemd[1]: Started Phosphor Download Manager.
Jan 01 00:01:12 s2600wf systemd[1]: phosphor-ipmi-kcs at ipmi-kcs3.service: Service RestartSec=1s expired, scheduling restart.
Jan 01 00:01:12 s2600wf systemd[1]: phosphor-ipmi-kcs at ipmi-kcs3.service: Scheduled restart job, restart counter is at 1.
Jan 01 00:01:12 s2600wf netipmid[284]: Failed to get bus name
Jan 01 00:01:12 s2600wf systemd[1]: Stopped Phosphor IPMI KCS DBus Bridge.
Jan 01 00:01:13 s2600wf systemd[1]: Started Phosphor IPMI KCS DBus Bridge.
Jan 01 00:01:13 s2600wf systemd[1]: Stopped OpenBMC ipKVM daemon.
Jan 01 00:01:13 s2600wf ipmid[270]: Set restrictedMode = false
Jan 01 00:01:13 s2600wf swampd[271]: New configuration detected, reloading
Jan 01 00:01:13 s2600wf swampd[271]: .No fan zones, application pausing until new configuration
Jan 01 00:01:13 s2600wf netipmid[284]: Bind to interfae
Jan 01 00:01:13 s2600wf systemd[1]: Starting OpenBMC ipKVM daemon...
Jan 01 00:01:13 s2600wf ipmid[270]: New interface mapping
Jan 01 00:01:13 s2600wf systemd[1]: Stopped Intel Power Control.
Jan 01 00:01:14 s2600wf systemd[1]: Starting Intel Power Control...
Jan 01 00:01:14 s2600wf kcsbridged[457]: Couldn't open SMS channel O_RDWR
Jan 01 00:01:15 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI Channel 0 timed out!
Jan 01 00:01:15 s2600wf systemd[1]: Started Wait for /org/openbmc/managers/Download.
Jan 01 00:01:16 s2600wf systemd[1]: Started Wait for /xyz/openbmc_project/state/chassis0.
Jan 01 00:01:16 s2600wf power-control[499]: Start Chassis power control service...
Jan 01 00:01:16 s2600wf systemd-networkd[292]: eth1: Gained IPv6LL
Jan 01 00:01:16 s2600wf systemd-networkd[292]: eth0: Gained IPv6LL
Jan 01 00:01:16 s2600wf systemd[1]: phosphor-ipmi-kcs at ipmi-kcs3.service: Main process exited, code=exited, status=1/FAILURE
Jan 01 00:01:16 s2600wf power-control[499]: terminate called after throwing an instance of 'sdbusplus::exception::SdBusError'
Jan 01 00:01:16 s2600wf systemd[1]: phosphor-ipmi-kcs at ipmi-kcs3.service: Failed with result 'exit-code'.
Jan 01 00:01:16 s2600wf power-control[499]:   what():  sd_bus_request_name: org.freedesktop.DBus.Error.FileExists: File exists
Jan 01 00:01:16 s2600wf phosphor-mapper[192]: Introspect call failed with error: generic:110, Connection timed out on process: xyz.openbmc_project.State.Host path: /
Jan 01 00:01:16 s2600wf systemd-networkd[292]: Enumeration completed
Jan 01 00:01:16 s2600wf intrusion-sensor[234]: can't find matched NIC name.
Jan 01 00:01:17 s2600wf intrusion-sensor[234]: unexpected eth for suffixStr 31
Jan 01 00:01:17 s2600wf systemd[1]: Started Network Service.
Jan 01 00:01:17 s2600wf avahi-daemon[206]: Withdrawing address record for 10.208.23.226 on eth1.
Jan 01 00:01:17 s2600wf avahi-daemon[206]: Leaving mDNS multicast group on interface eth1.IPv4 with address 10.208.23.226.
Jan 01 00:01:17 s2600wf avahi-daemon[206]: Interface eth1.IPv4 no longer relevant for mDNS.
Jan 01 00:01:17 s2600wf systemd-networkd[292]: eth1: IPv6 successfully enabled
Jan 01 00:01:17 s2600wf login[220]: pam_lastlog(login:session): file /var/log/lastlog created
Jan 01 00:01:17 s2600wf nslcd[130]: [e8944a] <group/member="root"> no available LDAP server found: Server is unavailable: Transport endpoint is not connected
Jan 01 00:01:17 s2600wf nslcd[130]: [e8944a] <group/member="root"> no available LDAP server found: Server is unavailable: Transport endpoint is not connected
Jan 01 00:01:17 s2600wf login[624]: ROOT LOGIN  on '/dev/ttyS4'
Jan 01 00:01:18 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:01:18 s2600wf systemd-networkd[292]: eth0: IPv6 successfully enabled
Jan 01 00:01:18 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:01:18 s2600wf systemd[1]: Started OpenBMC ipKVM daemon.
Jan 01 00:01:18 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:01:18 s2600wf systemd-networkd[292]: eth1: DHCPv4 address 10.208.23.226/23 via 10.208.22.1
Jan 01 00:01:18 s2600wf avahi-daemon[206]: Joining mDNS multicast group on interface eth1.IPv4 with address 10.208.23.226.
Jan 01 00:01:18 s2600wf avahi-daemon[206]: New relevant interface eth1.IPv4 for mDNS.
Jan 01 00:01:18 s2600wf avahi-daemon[206]: Registering new address record for 10.208.23.226 on eth1.IPv4.
Jan 01 00:01:18 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:01:19 s2600wf intrusion-sensor[234]: unexpected eth for suffixStr 34
Jan 01 00:01:19 s2600wf systemd-networkd[292]: sit0: Gained carrier
Jan 01 00:01:19 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Main process exited, code=killed, status=6/ABRT
Jan 01 00:01:19 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:01:19 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Failed with result 'signal'.
Jan 01 00:01:19 s2600wf intrusion-sensor[234]: unexpected eth for suffixStr 34
Jan 01 00:01:19 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:01:19 s2600wf systemd[1]: Failed to start Intel Power Control.
Jan 01 00:01:19 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:01:19 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:01:20 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI: No channel with link found, configuring channel 0
Jan 01 00:01:20 s2600wf systemd[1]: phosphor-ipmi-kcs at ipmi-kcs3.service: Service RestartSec=1s expired, scheduling restart.
Jan 01 00:01:21 s2600wf systemd[1]: phosphor-ipmi-kcs at ipmi-kcs3.service: Scheduled restart job, restart counter is at 2.
Jan 01 00:01:21 s2600wf obmc-ikvm[648]: Failed to open input device
Jan 01 00:01:21 s2600wf obmc-ikvm[648]: Failed to open a file
Jan 01 00:01:21 s2600wf obmc-ikvm[648]: terminate called after throwing an instance of 'sdbusplus::xyz::openbmc_project::Common::File::Error::Open'
Jan 01 00:01:21 s2600wf obmc-ikvm[648]:   what():  xyz.openbmc_project.Common.File.Error.Open: Failed to open a file
Jan 01 00:01:21 s2600wf systemd[1]: Starting Phosphor BMC Code Update...
Jan 01 00:01:21 s2600wf systemd[1]: Stopped Phosphor IPMI KCS DBus Bridge.
Jan 01 00:01:21 s2600wf systemd[1]: phosphor-ipmi-kcs at ipmi-kcs3.service: Start request repeated too quickly.
Jan 01 00:01:21 s2600wf systemd[1]: phosphor-ipmi-kcs at ipmi-kcs3.service: Failed with result 'exit-code'.
Jan 01 00:01:22 s2600wf systemd[1]: Failed to start Phosphor IPMI KCS DBus Bridge.
Jan 01 00:01:22 s2600wf systemd[1]: start-ipkvm.service: Main process exited, code=killed, status=6/ABRT
Jan 01 00:01:22 s2600wf systemd[1]: start-ipkvm.service: Failed with result 'signal'.
Jan 01 00:01:23 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Service RestartSec=3s expired, scheduling restart.
Jan 01 00:01:23 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Scheduled restart job, restart counter is at 3.
Jan 01 00:01:23 s2600wf systemd[1]: Stopped Intel Power Control.
Jan 01 00:01:24 s2600wf systemd[1]: Starting Intel Power Control...
Jan 01 00:01:24 s2600wf systemd-networkd[292]: eth1: Configured
Jan 01 00:01:24 s2600wf avahi-daemon[206]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.252.111.
Jan 01 00:01:24 s2600wf avahi-daemon[206]: New relevant interface eth0.IPv4 for mDNS.
Jan 01 00:01:24 s2600wf avahi-daemon[206]: Registering new address record for 169.254.252.111 on eth0.IPv4.
Jan 01 00:01:24 s2600wf systemd-timesyncd[69]: Network configuration changed, trying to establish connection.
Jan 01 00:01:24 s2600wf systemd[1]: start-ipkvm.service: Service RestartSec=1s expired, scheduling restart.
Jan 01 00:01:24 s2600wf systemd[1]: start-ipkvm.service: Scheduled restart job, restart counter is at 3.
Jan 01 00:01:25 s2600wf systemd[1]: Stopped OpenBMC ipKVM daemon.
Jan 01 00:01:25 s2600wf systemd[1]: Starting OpenBMC ipKVM daemon...
Jan 01 00:01:25 s2600wf power-control[838]: Start Chassis power control service...
Jan 01 00:01:26 s2600wf phosphor-mapper[192]: Introspect call failed with error: generic:110, Connection timed out on process: xyz.openbmc_project.PSUSensor path: /
Jan 01 00:01:26 s2600wf power-control[838]: terminate called after throwing an instance of 'sdbusplus::exception::SdBusError'
Jan 01 00:01:26 s2600wf power-control[838]:   what():  sd_bus_request_name: org.freedesktop.DBus.Error.FileExists: File exists
Jan 01 00:01:26 s2600wf phosphor-mapper[192]: Introspect call failed with error: generic:110, Connection timed out on process: xyz.openbmc_project.State.Host path: /
Jan 01 00:01:26 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Main process exited, code=killed, status=6/ABRT
Jan 01 00:01:26 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Failed with result 'signal'.
Jan 01 00:01:26 s2600wf systemd[1]: Failed to start Intel Power Control.
Jan 01 00:01:27 s2600wf systemd[1]: Started OpenBMC ipKVM daemon.
Jan 01 00:01:27 s2600wf phosphor-network-manager[223]: Refreshing the objects.
Jan 01 00:01:27 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:01:29 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:01:29 s2600wf systemd[1]: Starting Hostname Service...
Jan 01 00:01:29 s2600wf systemd[1028]: systemd-hostnamed.service: PrivateNetwork=yes is configured, but the kernel does not support network namespaces, ignoring.
Jan 01 00:01:29 s2600wf obmc-ikvm[950]: Failed to open input device
Jan 01 00:01:30 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Service RestartSec=3s expired, scheduling restart.
Jan 01 00:01:30 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Scheduled restart job, restart counter is at 4.
Jan 01 00:01:30 s2600wf systemd[1]: Stopped Intel Power Control.
Jan 01 00:01:30 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Start request repeated too quickly.
Jan 01 00:01:30 s2600wf systemd[1]: xyz.openbmc_project.Chassis.Control.Power.service: Failed with result 'signal'.
Jan 01 00:01:30 s2600wf obmc-ikvm[950]: Failed to open a file
Jan 01 00:01:30 s2600wf obmc-ikvm[950]: terminate called after throwing an instance of 'sdbusplus::xyz::openbmc_project::Common::File::Error::Open'
Jan 01 00:01:30 s2600wf obmc-ikvm[950]:   what():  xyz.openbmc_project.Common.File.Error.Open: Failed to open a file
Jan 01 00:01:30 s2600wf systemd[1]: Failed to start Intel Power Control.
Jan 01 00:01:30 s2600wf systemd[1]: start-ipkvm.service: Main process exited, code=killed, status=6/ABRT
Jan 01 00:01:30 s2600wf systemd[1]: start-ipkvm.service: Failed with result 'signal'.
Jan 01 00:01:32 s2600wf systemd[1]: start-ipkvm.service: Service RestartSec=1s expired, scheduling restart.
Jan 01 00:01:32 s2600wf systemd[1]: start-ipkvm.service: Scheduled restart job, restart counter is at 4.
Jan 01 00:01:32 s2600wf systemd[1]: Stopped OpenBMC ipKVM daemon.
Jan 01 00:01:32 s2600wf systemd[1]: start-ipkvm.service: Start request repeated too quickly.
Jan 01 00:01:32 s2600wf systemd[1]: start-ipkvm.service: Failed with result 'signal'.
Jan 01 00:01:32 s2600wf systemd[1]: Failed to start OpenBMC ipKVM daemon.
Jan 01 00:01:37 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI Channel 0 timed out!
Jan 01 00:01:42 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI: No channel with link found, configuring channel 0
Jan 01 00:01:42 s2600wf systemd[1]: Started Hostname Service.
Jan 01 00:01:42 s2600wf phosphor-network-manager[223]: Refreshing complete.
Jan 01 00:01:44 s2600wf ipmid[270]: Get BMC version
Jan 01 00:01:52 s2600wf phosphor-network-manager[223]: Refreshing the objects.
Jan 01 00:01:52 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:01:52 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:01:53 s2600wf phosphor-network-manager[223]: Refreshing complete.
Jan 01 00:01:59 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI Channel 0 timed out!
Jan 01 00:01:59 s2600wf systemd[1]: dev-ttyVUART0.device: Job dev-ttyVUART0.device/start timed out.
Jan 01 00:01:59 s2600wf systemd[1]: Timed out waiting for device /dev/ttyVUART0.
Jan 01 00:01:59 s2600wf systemd[1]: Dependency failed for Phosphor Console Muxer listening on device /dev/ttyVUART0.
Jan 01 00:01:59 s2600wf systemd[1]: obmc-console at ttyVUART0.service: Job obmc-console at ttyVUART0.service/start failed with result 'dependency'.
Jan 01 00:01:59 s2600wf systemd[1]: dev-ttyVUART0.device: Job dev-ttyVUART0.device/start failed with result 'timeout'.
Jan 01 00:02:04 s2600wf systemd[1]: Starting Rotates the event logs...
Jan 01 00:02:04 s2600wf systemd[1]: rotate-event-logs.service: Succeeded.
Jan 01 00:02:04 s2600wf systemd[1]: Started Rotates the event logs.
Jan 01 00:02:04 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI: No channel with link found, configuring channel 0
Jan 01 00:02:07 s2600wf phosphor-network-manager[223]: Refreshing the objects.
Jan 01 00:02:08 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:02:08 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:02:09 s2600wf phosphor-network-manager[223]: Refreshing complete.
Jan 01 00:02:19 s2600wf phosphor-network-manager[223]: Refreshing the objects.
Jan 01 00:02:19 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:02:19 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:02:20 s2600wf phosphor-network-manager[223]: Refreshing complete.
Jan 01 00:02:20 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI Channel 0 timed out!
Jan 01 00:02:26 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI: No channel with link found, configuring channel 0
Jan 01 00:02:36 s2600wf phosphor-network-manager[223]: Refreshing the objects.
Jan 01 00:02:36 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:02:36 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:02:37 s2600wf phosphor-network-manager[223]: Refreshing complete.
Jan 01 00:02:39 s2600wf systemd[1]: Started Phosphor BMC Code Update.
Jan 01 00:02:39 s2600wf bmc_update.py[747]: Running Bmc Flash Control
Jan 01 00:02:42 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI Channel 0 timed out!
Jan 01 00:02:47 s2600wf phosphor-network-manager[223]: Refreshing the objects.
Jan 01 00:02:47 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:02:47 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:02:47 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI: No channel with link found, configuring channel 0
Jan 01 00:02:49 s2600wf phosphor-network-manager[223]: Refreshing complete.
Jan 01 00:02:55 s2600wf phosphor-certificate-manager[148]: Writing private key to file
Jan 01 00:02:55 s2600wf phosphor-certificate-manager[148]: Certificate install
Jan 01 00:02:56 s2600wf phosphor-certificate-manager[148]: Certificate loadCert
Jan 01 00:02:56 s2600wf phosphor-certificate-manager[148]: Certificate compareKeys
Jan 01 00:02:56 s2600wf phosphor-certificate-manager[148]: Certificate loadCert
Jan 01 00:03:00 s2600wf systemd[1]: Starting Rotates the event logs...
Jan 01 00:03:00 s2600wf systemd[1]: rotate-event-logs.service: Succeeded.
Jan 01 00:03:00 s2600wf systemd[1]: Started Rotates the event logs.
Jan 01 00:03:04 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI Channel 0 timed out!
Jan 01 00:03:06 s2600wf phosphor-network-manager[223]: Refreshing the objects.
Jan 01 00:03:06 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:03:06 s2600wf phosphor-network-manager[223]: ioctl failed for SIOCETHTOOL:
Jan 01 00:03:07 s2600wf phosphor-network-manager[223]: Refreshing complete.
Jan 01 00:03:09 s2600wf kernel: ftgmac100 1e660000.ethernet eth0: NCSI: No channel with link found, configuring channel 0


More information about the openbmc mailing list