-- Logs begin at Thu 2019-02-14 19:11:59 JST, end at Sun 2023-09-17 12:33:31 JST. --
Sep 17 12:32:12 volumiok2 kernel: sdhost: log_buf @ (ptrval) (d9113000)
Sep 17 12:32:12 volumiok2 kernel: mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Sep 17 12:32:12 volumiok2 kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Sep 17 12:32:12 volumiok2 kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Sep 17 12:32:12 volumiok2 kernel: mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Sep 17 12:32:12 volumiok2 kernel: mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Sep 17 12:32:12 volumiok2 kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
Sep 17 12:32:12 volumiok2 kernel: of_cfs_init
Sep 17 12:32:12 volumiok2 kernel: of_cfs_init: OK
Sep 17 12:32:12 volumiok2 kernel: Indeed it is in host mode hprt0 = 00021501
Sep 17 12:32:12 volumiok2 kernel: Freeing unused kernel memory: 1024K
Sep 17 12:32:12 volumiok2 kernel: Run /init as init process
Sep 17 12:32:12 volumiok2 kernel: with arguments:
Sep 17 12:32:12 volumiok2 kernel: /init
Sep 17 12:32:12 volumiok2 kernel: splash
Sep 17 12:32:12 volumiok2 kernel: with environment:
Sep 17 12:32:12 volumiok2 kernel: HOME=/
Sep 17 12:32:12 volumiok2 kernel: TERM=linux
Sep 17 12:32:12 volumiok2 kernel: imgpart=/dev/mmcblk0p2
Sep 17 12:32:12 volumiok2 kernel: imgfile=/volumio_current.sqsh
Sep 17 12:32:12 volumiok2 kernel: bootdelay=5
Sep 17 12:32:12 volumiok2 kernel: mmc0: host does not support reading read-only switch, assuming write-enable
Sep 17 12:32:12 volumiok2 kernel: mmc0: new high speed SDHC card at address 0001
Sep 17 12:32:12 volumiok2 kernel: mmcblk0: mmc0:0001 SD32G 29.1 GiB
Sep 17 12:32:12 volumiok2 kernel: mmcblk0: p1 p2 p3
Sep 17 12:32:12 volumiok2 kernel: mmc1: new high speed SDIO card at address 0001
Sep 17 12:32:12 volumiok2 kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg
Sep 17 12:32:12 volumiok2 kernel: Indeed it is in host mode hprt0 = 00001101
Sep 17 12:32:12 volumiok2 initramfs: Booting Volumio for BCM2835
Sep 17 12:32:12 volumiok2 initramfs: This script mounts rootfs RO with an overlay RW layer.
Sep 17 12:32:12 volumiok2 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Sep 17 12:32:12 volumiok2 initramfs: IMGPART=/dev/mmcblk0p2
Sep 17 12:32:12 volumiok2 initramfs: IMGFILE=/volumio_current.sqsh
Sep 17 12:32:12 volumiok2 initramfs: Boot delay (except first time) will be 5 seconds
Sep 17 12:32:12 volumiok2 initramfs: /dev/mmcblk0p2:
Sep 17 12:32:12 volumiok2 kernel: usb 1-1: New USB device found, idVendor=05e3, idProduct=0608, bcdDevice= 6.03
Sep 17 12:32:12 volumiok2 kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Sep 17 12:32:12 volumiok2 kernel: usb 1-1: Product: USB2.0 Hub
Sep 17 12:32:12 volumiok2 kernel: hub 1-1:1.0: USB hub found
Sep 17 12:32:12 volumiok2 kernel: hub 1-1:1.0: 4 ports detected
Sep 17 12:32:12 volumiok2 kernel: EXT4-fs (mmcblk0p2): recovery complete
Sep 17 12:32:12 volumiok2 kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Sep 17 12:32:12 volumiok2 initramfs: Doing a 5 second delay here to give kernel load a headstart
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.1: new high-speed USB device number 3 using dwc_otg
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.1: New USB device found, idVendor=13fe, idProduct=5500, bcdDevice= 1.00
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.1: Product: USB DISK 3.0
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.1: Manufacturer:
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.1: SerialNumber: 070003EA951FA845
Sep 17 12:32:12 volumiok2 kernel: usb-storage 1-1.1:1.0: USB Mass Storage device detected
Sep 17 12:32:12 volumiok2 kernel: scsi host0: usb-storage 1-1.1:1.0
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.3: new full-speed USB device number 4 using dwc_otg
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.3: config 1 has an invalid interface number: 3 but max is 2
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.3: config 1 has an invalid interface number: 3 but max is 2
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.3: config 1 has an invalid interface number: 3 but max is 2
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.3: config 1 has an invalid interface number: 3 but max is 2
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.3: config 1 has no interface number 2
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.3: New USB device found, idVendor=262a, idProduct=9023, bcdDevice= 0.01
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.3: Product: FX-D03J
Sep 17 12:32:12 volumiok2 kernel: usb 1-1.3: Manufacturer: FX AUDIO
Sep 17 12:32:12 volumiok2 kernel: hid-generic 0003:262A:9023.0001: No inputs registered, leaving
Sep 17 12:32:12 volumiok2 kernel: hid-generic 0003:262A:9023.0001: hidraw0: USB HID v1.00 Device [FX AUDIO FX-D03J] on usb-3f980000.usb-1.3/input0
Sep 17 12:32:12 volumiok2 kernel: scsi 0:0:0:0: Direct-Access USB DISK 3.0 PMAP PQ: 0 ANSI: 6
Sep 17 12:32:12 volumiok2 kernel: sd 0:0:0:0: [sda] 242259840 512-byte logical blocks: (124 GB/116 GiB)
Sep 17 12:32:12 volumiok2 kernel: sd 0:0:0:0: [sda] Write Protect is off
Sep 17 12:32:12 volumiok2 kernel: sd 0:0:0:0: [sda] Mode Sense: 2b 00 00 08
Sep 17 12:32:12 volumiok2 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
Sep 17 12:32:12 volumiok2 kernel: sda: sda1 sda2
Sep 17 12:32:12 volumiok2 kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk
Sep 17 12:32:12 volumiok2 initramfs: Checking for USB updates
Sep 17 12:32:12 volumiok2 kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Sep 17 12:32:12 volumiok2 kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Sep 17 12:32:12 volumiok2 kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Sep 17 12:32:12 volumiok2 kernel: EXT4-fs (mmcblk0p3): recovery complete
Sep 17 12:32:12 volumiok2 kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null)
Sep 17 12:32:12 volumiok2 initramfs: With Option:
Sep 17 12:32:12 volumiok2 initramfs: VOLUMIO_VERSION="3.512"
Sep 17 12:32:12 volumiok2 initramfs: Finish initramfs, continue booting Volumio
Sep 17 12:32:12 volumiok2 systemd[1]: System time before build time, advancing clock.
Sep 17 12:32:12 volumiok2 kernel: NET: Registered protocol family 10
Sep 17 12:32:12 volumiok2 kernel: Segment Routing with IPv6
Sep 17 12:32:12 volumiok2 systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
Sep 17 12:32:12 volumiok2 systemd[1]: Detected architecture arm.
Sep 17 12:32:12 volumiok2 systemd[1]: Set hostname to .
Sep 17 12:32:12 volumiok2 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Sep 17 12:32:12 volumiok2 kernel: random: systemd: uninitialized urandom read (16 bytes read)
Sep 17 12:32:12 volumiok2 kernel: random: systemd: uninitialized urandom read (16 bytes read)
Sep 17 12:32:12 volumiok2 kernel: random: systemd: uninitialized urandom read (16 bytes read)
Sep 17 12:32:12 volumiok2 systemd[1]: Listening on Journal Socket (/dev/log).
Sep 17 12:32:12 volumiok2 systemd[1]: Listening on udev Kernel Socket.
Sep 17 12:32:12 volumiok2 systemd[1]: Listening on initctl Compatibility Named Pipe.
Sep 17 12:32:12 volumiok2 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
Sep 17 12:32:12 volumiok2 systemd[1]: Created slice User and Session Slice.
Sep 17 12:32:12 volumiok2 systemd[1]: Reached target Slices.
Sep 17 12:32:12 volumiok2 kernel: i2c /dev entries driver
Sep 17 12:32:12 volumiok2 systemd-journald[193]: Journal started
Sep 17 12:32:12 volumiok2 systemd-journald[193]: Runtime journal (/run/log/journal/e0cd2c47cf23b59004a7709f63e254f8) is 7.5M, max 30.0M, 22.5M free.
Sep 17 12:32:12 volumiok2 systemd-modules-load[188]: Inserted module 'i2c_dev'
Sep 17 12:32:12 volumiok2 fake-hwclock[192]: Sun Sep 17 03:32:12 UTC 2023
Sep 17 12:32:12 volumiok2 systemd[1]: Started Load/Save Random Seed.
Sep 17 12:32:12 volumiok2 volumio[187]: 512 MB or less RAM Detected, need to enable swap
Sep 17 12:32:12 volumiok2 systemd[1]: Started Create System Users.
Sep 17 12:32:12 volumiok2 systemd[1]: Starting Create Static Device Nodes in /dev...
Sep 17 12:32:12 volumiok2 systemd[1]: Started udev Coldplug all Devices.
Sep 17 12:32:12 volumiok2 systemd[1]: Starting Helper to synchronize boot up for ifupdown...
Sep 17 12:32:12 volumiok2 systemd[1]: Started Create Static Device Nodes in /dev.
Sep 17 12:32:12 volumiok2 systemd[1]: Starting udev Kernel Device Manager...
Sep 17 12:32:12 volumiok2 systemd[1]: Reached target Local File Systems (Pre).
Sep 17 12:32:12 volumiok2 systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway.
Sep 17 12:32:12 volumiok2 systemd[1]: Mounting /tmp...
Sep 17 12:32:12 volumiok2 systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway.
Sep 17 12:32:12 volumiok2 systemd[1]: Mounting /var/log...
Sep 17 12:32:12 volumiok2 systemd[1]: Mounting /var/spool/cups...
Sep 17 12:32:12 volumiok2 systemd[1]: Started Helper to synchronize boot up for ifupdown.
Sep 17 12:32:12 volumiok2 systemd[1]: Mounted /tmp.
Sep 17 12:32:12 volumiok2 systemd[1]: Mounted /var/log.
Sep 17 12:32:12 volumiok2 systemd[1]: Mounted /var/spool/cups.
Sep 17 12:32:12 volumiok2 systemd[1]: Mounting /var/spool/cups/tmp...
Sep 17 12:32:12 volumiok2 systemd-udevd[224]: Network interface NamePolicy= disabled on kernel command line, ignoring.
Sep 17 12:32:12 volumiok2 systemd[1]: Starting Flush Journal to Persistent Storage...
Sep 17 12:32:12 volumiok2 systemd[1]: Mounted /var/spool/cups/tmp.
Sep 17 12:32:12 volumiok2 systemd[1]: Started udev Kernel Device Manager.
Sep 17 12:32:12 volumiok2 systemd[1]: Starting Show Plymouth Boot Screen...
Sep 17 12:32:12 volumiok2 systemd-journald[193]: Runtime journal (/run/log/journal/e0cd2c47cf23b59004a7709f63e254f8) is 7.5M, max 30.0M, 22.5M free.
Sep 17 12:32:12 volumiok2 systemd[1]: Started Flush Journal to Persistent Storage.
Sep 17 12:32:12 volumiok2 systemd[1]: Received SIGRTMIN+20 from PID 239 (plymouthd).
Sep 17 12:32:12 volumiok2 systemd[1]: Started Show Plymouth Boot Screen.
Sep 17 12:32:12 volumiok2 systemd[1]: Started Forward Password Requests to Plymouth Directory Watch.
Sep 17 12:32:12 volumiok2 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Sep 17 12:32:12 volumiok2 systemd[1]: Reached target Local Encrypted Volumes.
Sep 17 12:32:12 volumiok2 systemd[1]: Reached target Paths.
Sep 17 12:32:12 volumiok2 volumio[187]: Enabling Swap
Sep 17 12:32:12 volumiok2 kernel: ext4 filesystem being mounted at /swap supports timestamps until 2038 (0x7fffffff)
Sep 17 12:32:12 volumiok2 kernel: Adding 524236k swap on /swap/swapfile. Priority:-2 extents:12 across:575480k SSFS
Sep 17 12:32:12 volumiok2 volumio[187]: Setting swappiness to 40
Sep 17 12:32:12 volumiok2 kernel: mc: Linux media interface: v0.10
Sep 17 12:32:12 volumiok2 kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
Sep 17 12:32:12 volumiok2 kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Sep 17 12:32:12 volumiok2 kernel: [vc_sm_connected_init]: start
Sep 17 12:32:13 volumiok2 kernel: [vc_sm_connected_init]: installed successfully
Sep 17 12:32:13 volumiok2 kernel: videodev: Linux video capture interface: v2.00
Sep 17 12:32:13 volumiok2 kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Sep 17 12:32:13 volumiok2 kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Sep 17 12:32:13 volumiok2 kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Sep 17 12:32:13 volumiok2 kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Sep 17 12:32:13 volumiok2 kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Sep 17 12:32:13 volumiok2 kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Sep 17 12:32:13 volumiok2 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Sep 17 12:32:13 volumiok2 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Sep 17 12:32:13 volumiok2 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Sep 17 12:32:13 volumiok2 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Sep 17 12:32:13 volumiok2 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Sep 17 12:32:13 volumiok2 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20
Sep 17 12:32:13 volumiok2 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18
Sep 17 12:32:13 volumiok2 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Sep 17 12:32:13 volumiok2 kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Sep 17 12:32:13 volumiok2 volumio[187]: vm.swappiness = 40
Sep 17 12:32:13 volumiok2 systemd[1]: dynamicswap.service: Succeeded.
Sep 17 12:32:13 volumiok2 kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Sep 17 12:32:13 volumiok2 kernel: bcm2835_audio bcm2835_audio: there is not valid maps for state default
Sep 17 12:32:13 volumiok2 kernel: bcm2835_audio bcm2835_audio: card created with 8 channels
Sep 17 12:32:13 volumiok2 systemd-udevd[232]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 17 12:32:13 volumiok2 kernel: usbcore: registered new interface driver uas
Sep 17 12:32:13 volumiok2 kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
Sep 17 12:32:14 volumiok2 kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Sep 17 12:32:14 volumiok2 kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Sep 17 12:32:14 volumiok2 kernel: snd_usb_audio: unknown parameter 'nrpacks' ignored
Sep 17 12:32:14 volumiok2 kernel: cfg80211: loaded regulatory.db is malformed or signature is missing/invalid
Sep 17 12:32:14 volumiok2 kernel: usbcore: registered new interface driver snd-usb-audio
Sep 17 12:32:14 volumiok2 kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6
Sep 17 12:32:14 volumiok2 kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43436s-sdio for chip BCM43430/1
Sep 17 12:32:14 volumiok2 kernel: usbcore: registered new interface driver brcmfmac
Sep 17 12:32:14 volumiok2 systemd[1]: Found device /dev/mmcblk0p1.
Sep 17 12:32:15 volumiok2 kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43436s-sdio for chip BCM43430/1
Sep 17 12:32:15 volumiok2 kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43436s-sdio for chip BCM43430/1
Sep 17 12:32:15 volumiok2 kernel: brcmfmac: brcmf_c_process_clm_blob: no clm_blob available (err=-2), device may have limited channels available
Sep 17 12:32:15 volumiok2 kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Jul 5 2022 21:29:56 version 7.45.96.141 (g53ba0094) FWID 01-eef9b3bf es7
Sep 17 12:32:15 volumiok2 systemd-udevd[230]: Using default interface naming scheme 'v240'.
Sep 17 12:32:15 volumiok2 systemd-udevd[230]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
Sep 17 12:32:17 volumiok2 systemd-udevd[240]: Process '/bin/bash -c '/usr/local/bin/volumio usbattach'' failed with exit code 7.
Sep 17 12:32:17 volumiok2 systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Sep 17 12:32:17 volumiok2 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Sep 17 12:32:17 volumiok2 systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped.
Sep 17 12:32:17 volumiok2 systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Sep 17 12:32:17 volumiok2 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Sep 17 12:32:17 volumiok2 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Sep 17 12:32:17 volumiok2 systemd[1]: Starting File System Check on /dev/mmcblk0p1...
Sep 17 12:32:17 volumiok2 systemd[1]: Starting Load/Save RF Kill Switch Status...
Sep 17 12:32:17 volumiok2 systemd[1]: Found device /sys/subsystem/net/devices/wlan0.
Sep 17 12:32:17 volumiok2 systemd[1]: Started Load/Save RF Kill Switch Status.
Sep 17 12:32:17 volumiok2 systemd[1]: Started File System Check Daemon to report status.
Sep 17 12:32:17 volumiok2 systemd-fsck[337]: fsck.fat 4.1 (2017-01-24)
Sep 17 12:32:17 volumiok2 systemd-fsck[337]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.
Sep 17 12:32:17 volumiok2 systemd-fsck[337]: Automatically removing dirty bit.
Sep 17 12:32:17 volumiok2 systemd-fsck[337]: Performing changes.
Sep 17 12:32:17 volumiok2 systemd-fsck[337]: /dev/mmcblk0p1: 304 files, 27495/46774 clusters
Sep 17 12:32:17 volumiok2 systemd[1]: Started File System Check on /dev/mmcblk0p1.
Sep 17 12:32:17 volumiok2 systemd[1]: Mounting /boot...
Sep 17 12:32:18 volumiok2 systemd[1]: Mounted /boot.
Sep 17 12:32:18 volumiok2 systemd[1]: Reached target Local File Systems.
Sep 17 12:32:18 volumiok2 systemd[1]: Starting Preprocess NFS configuration...
Sep 17 12:32:18 volumiok2 systemd[1]: Started ifup for wlan0.
Sep 17 12:32:18 volumiok2 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Sep 17 12:32:18 volumiok2 systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Sep 17 12:32:18 volumiok2 systemd[1]: Starting Create Volatile Files and Directories...
Sep 17 12:32:18 volumiok2 systemd[1]: Starting Raise network interfaces...
Sep 17 12:32:18 volumiok2 systemd[1]: Received SIGRTMIN+20 from PID 239 (plymouthd).
Sep 17 12:32:18 volumiok2 systemd[1]: nfs-config.service: Succeeded.
Sep 17 12:32:18 volumiok2 systemd[1]: Started Preprocess NFS configuration.
Sep 17 12:32:18 volumiok2 systemd[1]: plymouth-read-write.service: Succeeded.
Sep 17 12:32:18 volumiok2 systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Sep 17 12:32:18 volumiok2 systemd[1]: Condition check resulted in RPC security service for NFS server being skipped.
Sep 17 12:32:18 volumiok2 systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped.
Sep 17 12:32:18 volumiok2 systemd[1]: Reached target NFS client services.
Sep 17 12:32:18 volumiok2 systemd[1]: Started Create Volatile Files and Directories.
Sep 17 12:32:18 volumiok2 systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Sep 17 12:32:18 volumiok2 systemd[1]: Starting RPC bind portmap service...
Sep 17 12:32:18 volumiok2 systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
Sep 17 12:32:18 volumiok2 systemd[1]: Condition check resulted in Network Time Synchronization being skipped.
Sep 17 12:32:18 volumiok2 systemd[1]: Started Update UTMP about System Boot/Shutdown.
Sep 17 12:32:18 volumiok2 systemd[1]: Reached target System Initialization.
Sep 17 12:32:18 volumiok2 systemd[1]: Listening on triggerhappy.socket.
Sep 17 12:32:18 volumiok2 systemd[1]: Listening on D-Bus System Message Bus Socket.
Sep 17 12:32:18 volumiok2 systemd[1]: Started Daily Cleanup of Temporary Directories.
Sep 17 12:32:18 volumiok2 systemd[1]: apt-daily.timer: Not using persistent file timestamp Sat 2024-11-30 10:18:09 JST as it is in the future.
Sep 17 12:32:18 volumiok2 systemd[1]: Started Daily apt download activities.
Sep 17 12:32:18 volumiok2 systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Sat 2024-11-30 06:08:24 JST as it is in the future.
Sep 17 12:32:18 volumiok2 systemd[1]: Started Daily apt upgrade and clean activities.
Sep 17 12:32:18 volumiok2 systemd[1]: Reached target Timers.
Sep 17 12:32:18 volumiok2 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Sep 17 12:32:18 volumiok2 systemd[1]: Listening on mpd.socket.
Sep 17 12:32:18 volumiok2 systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
Sep 17 12:32:18 volumiok2 systemd[1]: Reached target Sockets.
Sep 17 12:32:18 volumiok2 systemd[1]: Reached target Basic System.
Sep 17 12:32:18 volumiok2 systemd[1]: Started UPnP Renderer front-end to MPD.
Sep 17 12:32:18 volumiok2 systemd[1]: Starting Configure Bluetooth Modems connected by UART...
Sep 17 12:32:18 volumiok2 systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped.
Sep 17 12:32:18 volumiok2 systemd[1]: Started Volumio Iptables Module.
Sep 17 12:32:18 volumiok2 systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
Sep 17 12:32:18 volumiok2 systemd[1]: Starting triggerhappy global hotkey daemon...
Sep 17 12:32:18 volumiok2 systemd[1]: Starting Wireless Services...
Sep 17 12:32:18 volumiok2 systemd[1]: Condition check resulted in Volumio SSH enabler being skipped.
Sep 17 12:32:18 volumiok2 systemd[1]: Starting dhcpcd on all interfaces...
Sep 17 12:32:18 volumiok2 systemd[1]: Started D-Bus System Message Bus.
Sep 17 12:32:18 volumiok2 systemd[1]: Starting WPA supplicant...
Sep 17 12:32:18 volumiok2 dhcpcd[419]: Not running dhcpcd because /etc/network/interfaces
Sep 17 12:32:18 volumiok2 dhcpcd[419]: defines some interfaces that will use a
Sep 17 12:32:18 volumiok2 dhcpcd[419]: DHCP client or static address
Sep 17 12:32:18 volumiok2 systemd[1]: Starting Login Service...
Sep 17 12:32:18 volumiok2 systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
Sep 17 12:32:18 volumiok2 systemd[1]: Started Manage Sound Card State (restore and store).
Sep 17 12:32:18 volumiok2 systemd[1]: Starting Save/Restore Sound Card State...
Sep 17 12:32:18 volumiok2 alsactl[436]: alsactl 1.1.8 daemon started
Sep 17 12:32:18 volumiok2 systemd[1]: Started volumio-remote-updater.service.
Sep 17 12:32:18 volumiok2 systemd[1]: Started RPC bind portmap service.
Sep 17 12:32:18 volumiok2 systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED
Sep 17 12:32:18 volumiok2 systemd[1]: dhcpcd.service: Failed with result 'exit-code'.
Sep 17 12:32:18 volumiok2 systemd[1]: Failed to start dhcpcd on all interfaces.
Sep 17 12:32:18 volumiok2 thd[413]: Unable to parse trigger line:
Sep 17 12:32:18 volumiok2 thd[413]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle
Sep 17 12:32:18 volumiok2 thd[413]: Unable to parse trigger line:
Sep 17 12:32:18 volumiok2 thd[413]: Unable to parse trigger line:
Sep 17 12:32:18 volumiok2 thd[413]: Found socket passed from systemd
Sep 17 12:32:18 volumiok2 systemd[1]: Started triggerhappy global hotkey daemon.
Sep 17 12:32:18 volumiok2 systemd[1]: Reached target Remote File Systems (Pre).
Sep 17 12:32:19 volumiok2 systemd[1]: Reached target Remote File Systems.
Sep 17 12:32:19 volumiok2 systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
Sep 17 12:32:19 volumiok2 systemd[1]: Reached target RPC Port Mapper.
Sep 17 12:32:19 volumiok2 systemd[1]: Started Save/Restore Sound Card State.
Sep 17 12:32:19 volumiok2 sh[344]: wlan0=wlan0
Sep 17 12:32:19 volumiok2 systemd[1]: Reached target Sound Card.
Sep 17 12:32:19 volumiok2 avahi-daemon[410]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113).
Sep 17 12:32:19 volumiok2 avahi-daemon[410]: Successfully dropped root privileges.
Sep 17 12:32:19 volumiok2 avahi-daemon[410]: avahi-daemon 0.7 starting up.
Sep 17 12:32:19 volumiok2 kernel: random: crng init done
Sep 17 12:32:19 volumiok2 kernel: random: 7 urandom warning(s) missed due to ratelimiting
Sep 17 12:32:19 volumiok2 kernel: uart-pl011 3f201000.serial: no DMA platform data
Sep 17 12:32:19 volumiok2 systemd-logind[432]: New seat seat0.
Sep 17 12:32:19 volumiok2 avahi-daemon[410]: Successfully called chroot().
Sep 17 12:32:19 volumiok2 avahi-daemon[410]: Successfully dropped remaining capabilities.
Sep 17 12:32:20 volumiok2 avahi-daemon[410]: Loading service file /services/volumio.service.
Sep 17 12:32:20 volumiok2 avahi-daemon[410]: Network interface enumeration completed.
Sep 17 12:32:20 volumiok2 avahi-daemon[410]: Server startup complete. Host name is volumiok2.local. Local service cookie is 1657227515.
Sep 17 12:32:20 volumiok2 avahi-daemon[410]: Service "Volumiok2" (/services/volumio.service) successfully established.
Sep 17 12:32:20 volumiok2 systemd[1]: Started Raise network interfaces.
Sep 17 12:32:20 volumiok2 systemd[1]: Started Login Service.
Sep 17 12:32:20 volumiok2 systemd[1]: Started Avahi mDNS/DNS-SD Stack.
Sep 17 12:32:20 volumiok2 loadcpufreq[457]: Loading cpufreq kernel modules...done (none).
Sep 17 12:32:20 volumiok2 systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
Sep 17 12:32:20 volumiok2 systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Sep 17 12:32:21 volumiok2 cpufrequtils[520]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done.
Sep 17 12:32:21 volumiok2 systemd[1]: Started LSB: set CPUFreq kernel parameters.
Sep 17 12:32:21 volumiok2 systemd[1]: iptables.service: Succeeded.
Sep 17 12:32:21 volumiok2 haveged[380]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K
Sep 17 12:32:21 volumiok2 haveged[380]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488
Sep 17 12:32:21 volumiok2 haveged[380]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99832
Sep 17 12:32:21 volumiok2 haveged[380]: haveged: fills: 0, generated: 0
Sep 17 12:32:21 volumiok2 systemd[1]: Started WPA supplicant.
Sep 17 12:32:21 volumiok2 systemd[1]: Reached target Network.
Sep 17 12:32:21 volumiok2 wpa_supplicant[429]: Successfully initialized wpa_supplicant
Sep 17 12:32:21 volumiok2 systemd[1]: Starting Permit User Sessions...
Sep 17 12:32:21 volumiok2 systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Sep 17 12:32:21 volumiok2 systemd[1]: Reached target Network is Online.
Sep 17 12:32:21 volumiok2 systemd[1]: Starting LSB: Brings up/down network automatically...
Sep 17 12:32:21 volumiok2 volumio-remote-updater[441]: Error: No active session
Sep 17 12:32:21 volumiok2 systemd[1]: Starting /etc/rc.local Compatibility...
Sep 17 12:32:21 volumiok2 systemd[1]: Starting Network Time Service...
Sep 17 12:32:21 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:21] [info] asio async_connect error: system:111 (Connection refused)
Sep 17 12:32:21 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:21] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Sep 17 12:32:21 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:21] [error] handle_connect error: Underlying Transport Error
Sep 17 12:32:21 volumiok2 systemd[1]: Starting Music Player Daemon...
Sep 17 12:32:21 volumiok2 systemd[1]: Starting Samba NMB Daemon...
Sep 17 12:32:21 volumiok2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 12:32:21 volumiok2 systemd[1]: Started Permit User Sessions.
Sep 17 12:32:21 volumiok2 systemd[1]: Started /etc/rc.local Compatibility.
Sep 17 12:32:21 volumiok2 systemd[1]: Starting Hold until boot process finishes up...
Sep 17 12:32:21 volumiok2 systemd[1]: Starting Terminate Plymouth Boot Screen...
Sep 17 12:32:21 volumiok2 systemd[1]: Received SIGRTMIN+21 from PID 239 (plymouthd).
Sep 17 12:32:21 volumiok2 ifplugd[540]: Network Interface Plugging Daemon...skip eth0...done.
Sep 17 12:32:21 volumiok2 systemd[1]: Started LSB: Brings up/down network automatically.
Sep 17 12:32:21 volumiok2 systemd[1]: Received SIGRTMIN+21 from PID 239 (plymouthd).
Sep 17 12:32:21 volumiok2 systemd[1]: plymouth-quit-wait.service: Succeeded.
Sep 17 12:32:21 volumiok2 systemd[1]: Started Hold until boot process finishes up.
Sep 17 12:32:21 volumiok2 systemd[1]: plymouth-start.service: Succeeded.
Sep 17 12:32:21 volumiok2 systemd[1]: plymouth-quit.service: Succeeded.
Sep 17 12:32:21 volumiok2 systemd[1]: Started Terminate Plymouth Boot Screen.
Sep 17 12:32:21 volumiok2 systemd[1]: Started Getty on tty1.
Sep 17 12:32:21 volumiok2 systemd[1]: Reached target Login Prompts.
Sep 17 12:32:21 volumiok2 volumio[400]: Could not open config: /tmp/upmpdcli.conf
Sep 17 12:32:21 volumiok2 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Sep 17 12:32:21 volumiok2 systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Sep 17 12:32:21 volumiok2 ntpd[545]: ntpd 4.2.8p12@1.3728-o (1): Starting
Sep 17 12:32:21 volumiok2 ntpd[545]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103
Sep 17 12:32:21 volumiok2 systemd[1]: Started Network Time Service.
Sep 17 12:32:22 volumiok2 ntpd[566]: proto: precision = 0.833 usec (-20)
Sep 17 12:32:22 volumiok2 ntpd[566]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Sep 17 12:32:22 volumiok2 ntpd[566]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2023-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Sep 17 12:32:22 volumiok2 ntpd[566]: Listen and drop on 0 v6wildcard [::]:123
Sep 17 12:32:22 volumiok2 ntpd[566]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Sep 17 12:32:22 volumiok2 ntpd[566]: Listen normally on 2 lo 127.0.0.1:123
Sep 17 12:32:22 volumiok2 ntpd[566]: Listening on routing socket on fd #19 for interface updates
Sep 17 12:32:22 volumiok2 ntpd[566]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Sep 17 12:32:22 volumiok2 ntpd[566]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Sep 17 12:32:22 volumiok2 systemd[1]: systemd-rfkill.service: Succeeded.
Sep 17 12:32:23 volumiok2 ntpd[566]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Sep 17 12:32:24 volumiok2 ntpd[566]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Sep 17 12:32:24 volumiok2 nmbd[555]: [2023/09/17 12:32:24.168163, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns)
Sep 17 12:32:24 volumiok2 nmbd[555]: started asyncdns process 575
Sep 17 12:32:24 volumiok2 nmbd[555]: [2023/09/17 12:32:24.171499, 0] ../lib/util/become_daemon.c:149(daemon_status)
Sep 17 12:32:24 volumiok2 nmbd[555]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...
Sep 17 12:32:24 volumiok2 nmbd[555]: [2023/09/17 12:32:24.171788, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets)
Sep 17 12:32:24 volumiok2 nmbd[555]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: Core ver 2.22
Sep 17 12:32:24 volumiok2 kernel: NET: Registered protocol family 31
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: HCI device and connection manager initialized
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: HCI socket layer initialized
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: L2CAP socket layer initialized
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: SCO socket layer initialized
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: HCI UART driver ver 2.3
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: HCI UART protocol H4 registered
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: HCI UART protocol Broadcom registered
Sep 17 12:32:24 volumiok2 btuart[404]: bcm43xx_init
Sep 17 12:32:24 volumiok2 btuart[404]: Flash firmware /lib/firmware/brcm/BCM43430A1.hcd
Sep 17 12:32:24 volumiok2 btuart[404]: Set BDADDR UART: b8:27:eb:41:d6:b1
Sep 17 12:32:24 volumiok2 btuart[404]: Set Controller UART speed to 3000000 bit/s
Sep 17 12:32:24 volumiok2 btuart[404]: Device setup complete
Sep 17 12:32:24 volumiok2 systemd[1]: Starting Load/Save RF Kill Switch Status...
Sep 17 12:32:24 volumiok2 systemd[1]: Started Configure Bluetooth Modems connected by UART.
Sep 17 12:32:24 volumiok2 systemd[1]: Started Load/Save RF Kill Switch Status.
Sep 17 12:32:24 volumiok2 systemd[1]: Created slice system-bthelper.slice.
Sep 17 12:32:24 volumiok2 systemd[1]: Starting Raspberry Pi bluetooth helper...
Sep 17 12:32:24 volumiok2 bthelper[581]: Raspberry Pi BDADDR already set
Sep 17 12:32:24 volumiok2 systemd[1]: Started Raspberry Pi bluetooth helper.
Sep 17 12:32:24 volumiok2 systemd[1]: Starting Bluetooth service...
Sep 17 12:32:24 volumiok2 bluetoothd[590]: Bluetooth daemon 5.50
Sep 17 12:32:24 volumiok2 bluetoothd[590]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Sep 17 12:32:24 volumiok2 systemd[1]: Started Bluetooth service.
Sep 17 12:32:24 volumiok2 systemd[1]: Reached target Bluetooth.
Sep 17 12:32:24 volumiok2 bluetoothd[590]: Starting SDP server
Sep 17 12:32:24 volumiok2 bluetoothd[590]: Excluding (cli) sap
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: BNEP filters: protocol multicast
Sep 17 12:32:24 volumiok2 kernel: Bluetooth: BNEP socket layer initialized
Sep 17 12:32:24 volumiok2 dbus-daemon[421]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=590 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Sep 17 12:32:24 volumiok2 bluetoothd[590]: Bluetooth management interface 1.18 initialized
Sep 17 12:32:24 volumiok2 systemd[1]: Starting Hostname Service...
Sep 17 12:32:24 volumiok2 bluetoothd[590]: Failed to set privacy: Rejected (0x0b)
Sep 17 12:32:25 volumiok2 ntpd[566]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Sep 17 12:32:25 volumiok2 dbus-daemon[421]: [system] Successfully activated service 'org.freedesktop.hostname1'
Sep 17 12:32:25 volumiok2 systemd[1]: Started Hostname Service.
Sep 17 12:32:25 volumiok2 wireless.js[415]: Cleaning previous...
Sep 17 12:32:25 volumiok2 sudo[601]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Sep 17 12:32:25 volumiok2 sudo[601]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:25 volumiok2 sudo[601]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:25 volumiok2 sudo[603]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Sep 17 12:32:25 volumiok2 sudo[603]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:26 volumiok2 ntpd[566]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Sep 17 12:32:26 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:26] [info] asio async_connect error: system:111 (Connection refused)
Sep 17 12:32:26 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:26] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Sep 17 12:32:26 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:26] [error] handle_connect error: Underlying Transport Error
Sep 17 12:32:26 volumiok2 sudo[603]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:26 volumiok2 wireless.js[415]: Stopped aP
Sep 17 12:32:26 volumiok2 sudo[610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Sep 17 12:32:26 volumiok2 sudo[610]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:26 volumiok2 sudo[610]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:26 volumiok2 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Sep 17 12:32:26 volumiok2 sudo[612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Sep 17 12:32:26 volumiok2 sudo[612]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:26 volumiok2 sudo[612]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:26 volumiok2 sudo[619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Sep 17 12:32:26 volumiok2 sudo[619]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:26 volumiok2 sudo[619]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:26 volumiok2 sudo[621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Sep 17 12:32:26 volumiok2 sudo[621]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:26 volumiok2 mpd[563]: Sep 17 12:32 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 17 12:32:26 volumiok2 mpd[563]: Sep 17 12:32 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Sep 17 12:32:26 volumiok2 mpd[563]: Sep 17 12:32 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Sep 17 12:32:26 volumiok2 systemd[1]: Started Music Player Daemon.
Sep 17 12:32:27 volumiok2 sudo[621]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:27 volumiok2 wireless.js[415]: Start wireless flow
Sep 17 12:32:27 volumiok2 wireless.js[415]: Stopped hotspot (if there)..
Sep 17 12:32:27 volumiok2 sudo[628]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Sep 17 12:32:27 volumiok2 sudo[628]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:27 volumiok2 sudo[628]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:27 volumiok2 sudo[630]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Sep 17 12:32:27 volumiok2 sudo[630]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:27 volumiok2 sudo[630]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:27 volumiok2 wireless.js[415]: DHCP IP
Sep 17 12:32:27 volumiok2 wireless.js[415]: Start ap
Sep 17 12:32:27 volumiok2 wpa_supplicant[632]: Successfully initialized wpa_supplicant
Sep 17 12:32:27 volumiok2 sudo[633]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Sep 17 12:32:27 volumiok2 sudo[633]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:27 volumiok2 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Sep 17 12:32:28 volumiok2 dhcpcd[634]: dev: loaded udev
Sep 17 12:32:28 volumiok2 kernel: 8021q: 802.1Q VLAN Support v1.8
Sep 17 12:32:28 volumiok2 dhcpcd-run-hooks[642]: wlan0: starting wpa_supplicant
Sep 17 12:32:28 volumiok2 dhcpcd-run-hooks[647]: wlan0: failed to start wpa_supplicant
Sep 17 12:32:28 volumiok2 dhcpcd-run-hooks[648]: wlan0: Successfully initialized wpa_supplicant
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Match already configured
nl80211: kernel reports: Ma
Sep 17 12:32:28 volumiok2 dhcpcd[634]: wlan0: connected to Access Point `'
Sep 17 12:32:28 volumiok2 dhcpcd[634]: no interfaces have a carrier
Sep 17 12:32:28 volumiok2 dhcpcd[634]: forked to background, child pid 662
Sep 17 12:32:28 volumiok2 dhcpcd[662]: wlan0: waiting for carrier
Sep 17 12:32:28 volumiok2 sudo[633]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:28 volumiok2 wpa_supplicant[646]: wlan0: Trying to associate with SSID 'aterm-dd4c7d-a'
Sep 17 12:32:28 volumiok2 wireless.js[415]: trying...
Sep 17 12:32:28 volumiok2 sudo[664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Sep 17 12:32:28 volumiok2 sudo[664]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:28 volumiok2 sudo[664]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:29 volumiok2 systemd[1]: systemd-rfkill.service: Succeeded.
Sep 17 12:32:29 volumiok2 bthelper[581]: Changing power off succeeded
Sep 17 12:32:29 volumiok2 bthelper[581]: [CHG] Controller B8:27:EB:41:D6:B1 Class: 0x0000041c
Sep 17 12:32:29 volumiok2 bthelper[581]: Changing power on succeeded
Sep 17 12:32:29 volumiok2 wpa_supplicant[646]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16
Sep 17 12:32:29 volumiok2 wireless.js[415]: trying...
Sep 17 12:32:29 volumiok2 sudo[673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Sep 17 12:32:29 volumiok2 sudo[673]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:29 volumiok2 sudo[673]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:30 volumiok2 wpa_supplicant[646]: wlan0: Trying to associate with SSID 'aterm-dd4c7d-a'
Sep 17 12:32:30 volumiok2 wireless.js[415]: trying...
Sep 17 12:32:30 volumiok2 sudo[676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Sep 17 12:32:30 volumiok2 sudo[676]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:30 volumiok2 sudo[676]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:31 volumiok2 dhcpcd[662]: wlan0: carrier acquired
Sep 17 12:32:31 volumiok2 dhcpcd[662]: wlan0: connected to Access Point `aterm-dd4c7d-a'
Sep 17 12:32:31 volumiok2 wpa_supplicant[646]: wlan0: Associated with 54:9b:49:ad:36:be
Sep 17 12:32:31 volumiok2 wpa_supplicant[646]: wlan0: CTRL-EVENT-CONNECTED - Connection to 54:9b:49:ad:36:be completed [id=0 id_str=]
Sep 17 12:32:31 volumiok2 wpa_supplicant[646]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Sep 17 12:32:31 volumiok2 dhcpcd[662]: DUID 00:01:00:01:2b:75:14:1d:e4:5f:01:92:19:af
Sep 17 12:32:31 volumiok2 dhcpcd[662]: wlan0: IAID 01:92:19:af
Sep 17 12:32:31 volumiok2 dhcpcd[662]: wlan0: adding address fe80::4d4:7b7b:c88a:7061
Sep 17 12:32:31 volumiok2 dhcpcd[662]: ipv6_addaddr1: Permission denied
Sep 17 12:32:31 volumiok2 dhcpcd[662]: wlan0: carrier lost
Sep 17 12:32:31 volumiok2 wpa_supplicant[646]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP
Sep 17 12:32:31 volumiok2 dhcpcd[662]: wlan0: carrier acquired
Sep 17 12:32:31 volumiok2 dhcpcd[662]: wlan0: IAID 01:92:19:af
Sep 17 12:32:31 volumiok2 dhcpcd[662]: wlan0: rebinding lease of 192.168.10.13
Sep 17 12:32:31 volumiok2 dhcpcd[662]: wlan0: probing address 192.168.10.13/24
Sep 17 12:32:31 volumiok2 dhcpcd[662]: wlan0: soliciting an IPv6 router
Sep 17 12:32:31 volumiok2 wireless.js[415]: trying...
Sep 17 12:32:31 volumiok2 sudo[692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Sep 17 12:32:31 volumiok2 sudo[692]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:31 volumiok2 sudo[692]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:32 volumiok2 wireless.js[415]: trying...
Sep 17 12:32:32 volumiok2 sudo[695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Sep 17 12:32:32 volumiok2 sudo[695]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:32 volumiok2 sudo[695]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:33 volumiok2 kernel: cam1-reg: disabling
Sep 17 12:32:33 volumiok2 kernel: cam-dummy-reg: disabling
Sep 17 12:32:33 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:33] [info] asio async_connect error: system:111 (Connection refused)
Sep 17 12:32:33 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:33] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Sep 17 12:32:33 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:33] [error] handle_connect error: Underlying Transport Error
Sep 17 12:32:33 volumiok2 wireless.js[415]: trying...
Sep 17 12:32:33 volumiok2 sudo[698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Sep 17 12:32:33 volumiok2 sudo[698]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:33 volumiok2 sudo[698]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:34 volumiok2 wireless.js[415]: trying...
Sep 17 12:32:34 volumiok2 sudo[701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Sep 17 12:32:34 volumiok2 sudo[701]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:34 volumiok2 sudo[701]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:35 volumiok2 wireless.js[415]: trying...
Sep 17 12:32:35 volumiok2 sudo[704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Sep 17 12:32:35 volumiok2 dhcpcd[662]: wlan0: leased 192.168.10.13 for 86400 seconds
Sep 17 12:32:35 volumiok2 avahi-daemon[410]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.10.13.
Sep 17 12:32:35 volumiok2 sudo[704]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:35 volumiok2 dhcpcd[662]: wlan0: adding route to 192.168.10.0/24
Sep 17 12:32:35 volumiok2 dhcpcd[662]: wlan0: adding default route via 192.168.10.1
Sep 17 12:32:35 volumiok2 avahi-daemon[410]: New relevant interface wlan0.IPv4 for mDNS.
Sep 17 12:32:35 volumiok2 avahi-daemon[410]: Registering new address record for 192.168.10.13 on wlan0.IPv4.
Sep 17 12:32:35 volumiok2 sudo[704]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:36 volumiok2 wireless.js[415]: Connected to: ----aterm-dd4c7d-a
Sep 17 12:32:36 volumiok2 wireless.js[415]: ----
Sep 17 12:32:36 volumiok2 sudo[713]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 12:32:36 volumiok2 sudo[713]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:36 volumiok2 sudo[713]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:36 volumiok2 wireless.js[415]: ... joined AP, wlan0 IPv4 is 192.168.10.13, ipV6 is undefined
Sep 17 12:32:36 volumiok2 wireless.js[415]: It's done! AP
Sep 17 12:32:36 volumiok2 systemd[1]: Started Wireless Services.
Sep 17 12:32:36 volumiok2 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Sep 17 12:32:36 volumiok2 systemd[1]: Started Volumio Backend Module.
Sep 17 12:32:37 volumiok2 ntpd[566]: Listen normally on 3 wlan0 192.168.10.13:123
Sep 17 12:32:37 volumiok2 ntpd[566]: new interface(s) found: waking up resolver
Sep 17 12:32:39 volumiok2 systemd[1]: Started Samba NMB Daemon.
Sep 17 12:32:39 volumiok2 nmbd[555]: [2023/09/17 12:32:39.186795, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Sep 17 12:32:39 volumiok2 nmbd[555]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Sep 17 12:32:39 volumiok2 systemd[1]: Starting Samba Winbind Daemon...
Sep 17 12:32:39 volumiok2 volumio[732]: info: -------------------------------------------
Sep 17 12:32:39 volumiok2 volumio[732]: info: ----- Volumio3 ----
Sep 17 12:32:39 volumiok2 volumio[732]: info: -------------------------------------------
Sep 17 12:32:39 volumiok2 volumio[732]: info: ----- System startup ----
Sep 17 12:32:39 volumiok2 volumio[732]: info: -------------------------------------------
Sep 17 12:32:39 volumiok2 winbindd[747]: [2023/09/17 12:32:39.585798, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Sep 17 12:32:39 volumiok2 winbindd[747]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Sep 17 12:32:39 volumiok2 systemd[1]: Started Samba Winbind Daemon.
Sep 17 12:32:39 volumiok2 winbindd[747]: [2023/09/17 12:32:39.613200, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Sep 17 12:32:39 volumiok2 winbindd[747]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Sep 17 12:32:39 volumiok2 systemd[1]: Starting Samba SMB Daemon...
Sep 17 12:32:40 volumiok2 winbindd[747]: [2023/09/17 12:32:40.323646, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv)
Sep 17 12:32:40 volumiok2 winbindd[747]: res_names->count = 3, expected 4
Sep 17 12:32:40 volumiok2 smbd[752]: [2023/09/17 12:32:40.359587, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Sep 17 12:32:40 volumiok2 smbd[752]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Sep 17 12:32:40 volumiok2 systemd[1]: Started Samba SMB Daemon.
Sep 17 12:32:40 volumiok2 systemd[1]: Reached target Multi-User System.
Sep 17 12:32:40 volumiok2 systemd[1]: Reached target Graphical Interface.
Sep 17 12:32:40 volumiok2 systemd[1]: Starting Update UTMP about System Runlevel Changes...
Sep 17 12:32:40 volumiok2 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Sep 17 12:32:40 volumiok2 systemd[1]: Started Update UTMP about System Runlevel Changes.
Sep 17 12:32:40 volumiok2 systemd[1]: Startup finished in 11.318s (kernel) + 30.318s (userspace) = 41.637s.
Sep 17 12:32:41 volumiok2 volumio[732]: info: MYVOLUMIO Environment detected
Sep 17 12:32:41 volumiok2 volumio[732]: info: Plugin folders cleanup
Sep 17 12:32:41 volumiok2 volumio[732]: info: Scanning into folder /volumio/app/plugins/
Sep 17 12:32:41 volumiok2 volumio[732]: info: Scanning category audio_interface
Sep 17 12:32:41 volumiok2 volumio[732]: info: Scanning category miscellanea
Sep 17 12:32:41 volumiok2 volumio[732]: info: Scanning category music_service
Sep 17 12:32:41 volumiok2 volumio[732]: info: Scanning category plugins.json
Sep 17 12:32:41 volumiok2 volumio[732]: info: Scanning category system_controller
Sep 17 12:32:41 volumiok2 volumio[732]: info: Scanning category user_interface
Sep 17 12:32:41 volumiok2 volumio[732]: info: Scanning into folder /data/plugins/
Sep 17 12:32:41 volumiok2 volumio[732]: info: Plugin folders cleanup completed
Sep 17 12:32:41 volumiok2 volumio[732]: info: -------------------------------------------
Sep 17 12:32:41 volumiok2 volumio[732]: info: ----- Core plugins startup ----
Sep 17 12:32:41 volumiok2 volumio[732]: info: -------------------------------------------
Sep 17 12:32:41 volumiok2 volumio[732]: info: Loading plugins from folder /volumio/app/plugins/
Sep 17 12:32:41 volumiok2 volumio[732]: info: Adding plugin upnp to MyMusic Plugins
Sep 17 12:32:41 volumiok2 volumio[732]: info: Adding plugin airplay_emulation to MyMusic Plugins
Sep 17 12:32:41 volumiok2 volumio[732]: info: Adding plugin upnp_browser to MyMusic Plugins
Sep 17 12:32:41 volumiok2 volumio[732]: info: Loading plugins from folder /data/plugins/
Sep 17 12:32:41 volumiok2 volumio[732]: info: Loading plugin "system"...
Sep 17 12:32:41 volumiok2 volumio[732]: info: Loading plugin "appearance"...
Sep 17 12:32:43 volumiok2 volumio[732]: info: Loading plugin "network"...
Sep 17 12:32:43 volumiok2 volumio[732]: info: Refreshing Cached IP Addresses
Sep 17 12:32:43 volumiok2 sudo[764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 17 12:32:43 volumiok2 sudo[764]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:43 volumiok2 sudo[766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 12:32:43 volumiok2 sudo[766]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:43 volumiok2 volumio[732]: info: Loading plugin "services"...
Sep 17 12:32:43 volumiok2 sudo[766]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:43 volumiok2 volumio[732]: info: Loading plugin "alsa_controller"...
Sep 17 12:32:43 volumiok2 sudo[770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Sep 17 12:32:43 volumiok2 sudo[770]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:43 volumiok2 sudo[764]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:43 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 12:32:43 volumiok2 volumio[732]: info: Loading plugin "wizard"...
Sep 17 12:32:43 volumiok2 volumio[732]: info: Loading plugin "volumio_command_line_client"...
Sep 17 12:32:43 volumiok2 volumio[732]: info: Loading plugin "upnp"...
Sep 17 12:32:43 volumiok2 volumio[732]: info: [1694921563516] Starting Upmpd Daemon
Sep 17 12:32:43 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 12:32:43 volumiok2 volumio[732]: info: Loading plugin "my_music"...
Sep 17 12:32:43 volumiok2 volumio[732]: info: Loading plugin "mpd"...
Sep 17 12:32:43 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:43] [connect] Successful connection
Sep 17 12:32:44 volumiok2 volumio[732]: info: Creating MPD Configuration file
Sep 17 12:32:44 volumiok2 volumio[732]: info: Loading plugin "upnp_browser"...
Sep 17 12:32:44 volumiok2 sudo[779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 12:32:44 volumiok2 sudo[779]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:44 volumiok2 sudo[779]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:44 volumiok2 sudo[781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 12:32:44 volumiok2 sudo[781]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:44 volumiok2 systemd[1]: Stopping Music Player Daemon...
Sep 17 12:32:44 volumiok2 sudo[770]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:44 volumiok2 systemd[1]: mpd.service: Succeeded.
Sep 17 12:32:44 volumiok2 systemd[1]: Stopped Music Player Daemon.
Sep 17 12:32:44 volumiok2 systemd[1]: Starting Music Player Daemon...
Sep 17 12:32:44 volumiok2 volumio[732]: info: Loading plugin "networkfs"...
Sep 17 12:32:45 volumiok2 volumio[732]: info: Starting Udev Watcher for removable devices
Sep 17 12:32:45 volumiok2 sudo[789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=shashikawa,password=K0tetsuO630.,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.200/ncp-shashikawa /mnt/NAS/ncp-shashikawa
Sep 17 12:32:45 volumiok2 sudo[789]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:45 volumiok2 kernel: FS-Cache: Netfs 'cifs' registered for caching
Sep 17 12:32:45 volumiok2 kernel: Key type cifs.spnego registered
Sep 17 12:32:45 volumiok2 kernel: Key type cifs.idmap registered
Sep 17 12:32:45 volumiok2 kernel: CIFS: Attempting to mount //192.168.10.200/ncp-shashikawa
Sep 17 12:32:45 volumiok2 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount.
Sep 17 12:32:45 volumiok2 volumio[732]: info: Ignoring mount for partition: boot
Sep 17 12:32:45 volumiok2 volumio[732]: info: Ignoring mount for partition: volumio
Sep 17 12:32:45 volumiok2 volumio[732]: info: Ignoring mount for partition: volumio_data
Sep 17 12:32:45 volumiok2 volumio[732]: info: Mounting Device EFI
Sep 17 12:32:45 volumiok2 sudo[805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/EFI -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Sep 17 12:32:45 volumiok2 sudo[805]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:45 volumiok2 kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Sep 17 12:32:45 volumiok2 kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Sep 17 12:32:45 volumiok2 sudo[805]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:46 volumiok2 volumio[732]: info: Mounting Device sound
Sep 17 12:32:46 volumiok2 sudo[811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/sound -o noatime
Sep 17 12:32:46 volumiok2 sudo[811]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:46 volumiok2 mpd[786]: Sep 17 12:32 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 17 12:32:46 volumiok2 mount.exfat[813]: volume was not unmounted cleanly
Sep 17 12:32:46 volumiok2 kernel: fuse: init (API version 7.32)
Sep 17 12:32:46 volumiok2 sudo[811]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:46 volumiok2 volumio[732]: WARN: volume was not unmounted cleanly.
Sep 17 12:32:46 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 12:32:46 volumiok2 volumio[732]: info: Loading plugin "alarm-clock"...
Sep 17 12:32:46 volumiok2 mpd[786]: Sep 17 12:32 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Sep 17 12:32:46 volumiok2 mpd[786]: Sep 17 12:32 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Sep 17 12:32:46 volumiok2 systemd[1]: Mounting FUSE Control File System...
Sep 17 12:32:46 volumiok2 systemd[1]: Started Music Player Daemon.
Sep 17 12:32:46 volumiok2 sudo[781]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:46 volumiok2 systemd[1]: Mounted FUSE Control File System.
Sep 17 12:32:46 volumiok2 volumio[732]: info: Loading plugin "airplay_emulation"...
Sep 17 12:32:46 volumiok2 volumio[732]: info: Starting Shairport Sync
Sep 17 12:32:46 volumiok2 volumio[732]: info: Loading plugin "last_100"...
Sep 17 12:32:46 volumiok2 volumio[732]: info: Loading plugin "webradio"...
Sep 17 12:32:46 volumiok2 volumio[732]: info: Loading plugin "i2s_dacs"...
Sep 17 12:32:46 volumiok2 volumio[732]: info: I2S DAC not set, start Auto-detection
Sep 17 12:32:46 volumiok2 volumio[732]: info: Loading plugin "volumiodiscovery"...
Sep 17 12:32:46 volumiok2 volumio[732]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 12:32:46 volumiok2 volumio[732]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 12:32:46 volumiok2 volumio[732]: *** WARNING *** For more information see
Sep 17 12:32:46 volumiok2 node[732]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Sep 17 12:32:46 volumiok2 volumio[732]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 12:32:46 volumiok2 volumio[732]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 12:32:46 volumiok2 volumio[732]: *** WARNING *** For more information see
Sep 17 12:32:46 volumiok2 node[732]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 12:32:46 volumiok2 node[732]: *** WARNING *** For more information see
Sep 17 12:32:46 volumiok2 node[732]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Sep 17 12:32:46 volumiok2 node[732]: *** WARNING *** Please fix your application to use the native API of Avahi!
Sep 17 12:32:46 volumiok2 node[732]: *** WARNING *** For more information see
Sep 17 12:32:46 volumiok2 volumio[732]: info: Applying required configuration parameters for plugin volumiodiscovery
Sep 17 12:32:46 volumiok2 volumio[732]: info: Discovery: Started advertising with name: Volumiok2
Sep 17 12:32:46 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Sep 17 12:32:46 volumiok2 volumio[732]: info: Loading plugin "outputs"...
Sep 17 12:32:46 volumiok2 volumio[732]: info: Loading plugin "albumart"...
Sep 17 12:32:46 volumiok2 volumio[732]: info: Plugin example_plugin is not enabled
Sep 17 12:32:46 volumiok2 volumio[732]: info: Loading plugin "inputs"...
Sep 17 12:32:46 volumiok2 volumio[732]: info: Loading plugin "updater_comm"...
Sep 17 12:32:47 volumiok2 volumio[732]: info: Plugin mpdemulation is not enabled
Sep 17 12:32:47 volumiok2 volumio[732]: info: Loading plugin "rest_api"...
Sep 17 12:32:47 volumiok2 volumio[732]: info: Loading plugin "websocket"...
Sep 17 12:32:47 volumiok2 volumio[732]: info: Loading i18n strings for locale ja
Sep 17 12:32:47 volumiok2 volumio[732]: Updating browse sources language
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 12:32:47 volumiok2 volumio[732]: Forking 3 albumart workers
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::initPlayerControls
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:47 volumiok2 systemd[1]: systemd-fsckd.service: Succeeded.
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 12:32:47 volumiok2 volumio[732]: Express server listening on port 3000
Sep 17 12:32:47 volumiok2 volumio[732]: [Metrics] WebUI: 9s 506.97ms
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreStateMachine::resetVolumioState
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreStateMachine::getcurrentVolume
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 12:32:47 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 12:32:48 volumiok2 volumio[732]: info: MPD Permissions set
Sep 17 12:32:48 volumiok2 volumio-remote-updater[441]: [2023-09-17 12:32:48] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1694921563 101
Sep 17 12:32:48 volumiok2 volumio[732]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1
Sep 17 12:32:48 volumiok2 volumio[732]: info: MPD running with PID786
Sep 17 12:32:48 volumiok2 volumio[732]: ,establishing connection
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:48 volumiok2 volumio[732]: info: Reloading queue from file
Sep 17 12:32:48 volumiok2 volumio[732]: error: updateQueue error: null
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreStateMachine::setRepeat false single undefined
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreStateMachine::pushState
Sep 17 12:32:48 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::volumioPushState
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreStateMachine::setRandom false
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreStateMachine::pushState
Sep 17 12:32:48 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::volumioPushState
Sep 17 12:32:48 volumiok2 volumio[732]: info: Setting Device type: Raspberry PI
Sep 17 12:32:48 volumiok2 volumio[732]: info: VolumeController:: Volume=38 Mute =false
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreStateMachine::pushState
Sep 17 12:32:48 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::volumioPushState
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreStateMachine::updateTrackBlock
Sep 17 12:32:48 volumiok2 volumio[732]: info: CorePlayQueue::getTrackBlock
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::volumioRetrievevolume
Sep 17 12:32:48 volumiok2 volumio[732]: error: updateQueue error: null
Sep 17 12:32:48 volumiok2 volumio[732]: info: VolumeController:: Volume=38 Mute =false
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreStateMachine::pushState
Sep 17 12:32:48 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::volumioPushState
Sep 17 12:32:48 volumiok2 volumio[732]: Starting albumart workers
Sep 17 12:32:48 volumiok2 volumio[732]: Starting albumart workers
Sep 17 12:32:48 volumiok2 volumio[732]: Starting albumart workers
Sep 17 12:32:48 volumiok2 volumio[732]: info: Discovery: adding 7970bcc7-d531-4a91-a927-ddd8a072d089
Sep 17 12:32:48 volumiok2 volumio[732]: info: Discovery: Found device Volumiok2
Sep 17 12:32:48 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:32:48 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:32:51 volumiok2 sudo[789]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:51 volumiok2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 17 12:32:51 volumiok2 kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Sep 17 12:32:51 volumiok2 volumio[732]: info: Cannot mount NAS ncp-shashikawa at system boot, trial number 1 ,retrying in 5 seconds
Sep 17 12:32:51 volumiok2 volumio[732]: info: Completed loading Core Plugins
Sep 17 12:32:51 volumiok2 volumio[732]: info: Preparing to generate the ALSA configuration file
Sep 17 12:32:51 volumiok2 volumio[732]: info: Asound.conf file unchanged, so no further update is needed
Sep 17 12:32:51 volumiok2 volumio[732]: info: Output device has changed, restarting MPD
Sep 17 12:32:51 volumiok2 volumio[732]: info: Output device has changed, restarting Shairport Sync
Sep 17 12:32:51 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:51 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 12:32:51 volumiok2 sudo[893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 17 12:32:51 volumiok2 sudo[895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 17 12:32:51 volumiok2 sudo[893]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:51 volumiok2 sudo[895]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:51 volumiok2 sudo[893]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:52 volumiok2 systemd[1]: Stopping Music Player Daemon...
Sep 17 12:32:52 volumiok2 volumio[732]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 12:32:52 volumiok2 volumio[732]: info: ___________ START PLUGINS ___________
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 12:32:52 volumiok2 volumio[732]: info: [1694921572025] CoreMusicLibrary::Adding element Media Servers
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 12:32:52 volumiok2 systemd[1]: mpd.service: Succeeded.
Sep 17 12:32:52 volumiok2 systemd[1]: Stopped Music Player Daemon.
Sep 17 12:32:52 volumiok2 systemd[1]: Starting Music Player Daemon...
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 12:32:52 volumiok2 volumio[732]: info: [1694921572186] CoreMusicLibrary::Adding element Last_100
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 17 12:32:52 volumiok2 volumio[732]: info: [1694921572191] CoreMusicLibrary::Adding element Webradio
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 12:32:52 volumiok2 volumio[732]: info: Volumio Calling Home
Sep 17 12:32:52 volumiok2 volumio[732]: info: Completed starting Core Plugins
Sep 17 12:32:52 volumiok2 volumio[732]: info: -------------------------------------------
Sep 17 12:32:52 volumiok2 volumio[732]: info: ----- MyVolumio plugins startup ----
Sep 17 12:32:52 volumiok2 volumio[732]: info: -------------------------------------------
Sep 17 12:32:52 volumiok2 volumio[732]: info: [MyVolumio PluginManager] Fetching plans data....
Sep 17 12:32:52 volumiok2 volumio[732]: info: MPD Permissions set
Sep 17 12:32:52 volumiok2 volumio[732]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:32:52 volumiok2 volumio[732]: info: Starting Shairport Sync
Sep 17 12:32:52 volumiok2 volumio[732]: info: Starting Shairport Sync
Sep 17 12:32:52 volumiok2 volumio[732]: info: Starting Shairport Sync
Sep 17 12:32:52 volumiok2 sudo[918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 12:32:52 volumiok2 sudo[918]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:52 volumiok2 sudo[920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 12:32:52 volumiok2 sudo[920]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:52 volumiok2 sudo[924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Sep 17 12:32:52 volumiok2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 12:32:52 volumiok2 systemd[1]: shairport-sync.service: Succeeded.
Sep 17 12:32:52 volumiok2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 12:32:52 volumiok2 sudo[924]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:52 volumiok2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 12:32:52 volumiok2 sudo[918]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:52 volumiok2 sudo[920]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:52 volumiok2 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Sep 17 12:32:52 volumiok2 systemd[1]: shairport-sync.service: Succeeded.
Sep 17 12:32:52 volumiok2 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Sep 17 12:32:52 volumiok2 volumio[732]: info: Volumio called home
Sep 17 12:32:52 volumiok2 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Sep 17 12:32:52 volumiok2 sudo[924]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:52 volumiok2 volumio[732]: info: Shairport-Sync Started
Sep 17 12:32:52 volumiok2 volumio[732]: Error adding Membership: Error: addMembership EINVAL
Sep 17 12:32:52 volumiok2 volumio[732]: info: Shairport-Sync Started
Sep 17 12:32:52 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:32:52 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:32:53 volumiok2 volumio[732]: info: Shairport-Sync Started
Sep 17 12:32:53 volumiok2 volumio[732]: error: MPD error: Error: This socket has been ended by the other party
Sep 17 12:32:53 volumiok2 volumio[732]: error: This socket has been ended by the other party {"code":"EPIPE"}
Sep 17 12:32:53 volumiok2 volumio[732]: error: MPD error: Error: This socket has been ended by the other party
Sep 17 12:32:53 volumiok2 volumio[732]: error: This socket has been ended by the other party {"code":"EPIPE"}
Sep 17 12:32:53 volumiok2 volumio[732]: error: MPD error: Error: This socket has been ended by the other party
Sep 17 12:32:53 volumiok2 volumio[732]: error: This socket has been ended by the other party {"code":"EPIPE"}
Sep 17 12:32:53 volumiok2 volumio[732]: error: MPD error: Error: This socket has been ended by the other party
Sep 17 12:32:53 volumiok2 volumio[732]: error: This socket has been ended by the other party {"code":"EPIPE"}
Sep 17 12:32:53 volumiok2 volumio[732]: error: MPD error: Error: This socket has been ended by the other party
Sep 17 12:32:53 volumiok2 volumio[732]: error: This socket has been ended by the other party {"code":"EPIPE"}
Sep 17 12:32:53 volumiok2 volumio[732]: error: MPD error: Error: This socket has been ended by the other party
Sep 17 12:32:53 volumiok2 volumio[732]: error: This socket has been ended by the other party {"code":"EPIPE"}
Sep 17 12:32:53 volumiok2 volumio[732]: error: MPD error: Error: This socket has been ended by the other party
Sep 17 12:32:53 volumiok2 volumio[732]: error: This socket has been ended by the other party {"code":"EPIPE"}
Sep 17 12:32:53 volumiok2 volumio[732]: error: MPD error: Error: This socket has been ended by the other party
Sep 17 12:32:53 volumiok2 volumio[732]: error: This socket has been ended by the other party {"code":"EPIPE"}
Sep 17 12:32:53 volumiok2 volumio[732]: error: MPD error: Error: This socket has been ended by the other party
Sep 17 12:32:53 volumiok2 volumio[732]: error: This socket has been ended by the other party {"code":"EPIPE"}
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 12:32:53 volumiok2 volumio[732]: info: Discovery: Getting this device information
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:32:53 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 12:32:53 volumiok2 volumio[732]: info: Discovery: Getting this device information
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:32:53 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 12:32:53 volumiok2 volumio[732]: verbose: New Socket.io Connection to 192.168.10.13:3000 from 192.168.10.15 UA: Dart/3.5 (dart:io) Total Clients: 3
Sep 17 12:32:53 volumiok2 sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 17 12:32:53 volumiok2 sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:53 volumiok2 sudo[934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 12:32:53 volumiok2 sudo[934]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:53 volumiok2 sudo[934]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:53 volumiok2 sudo[932]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:32:53 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Sep 17 12:32:53 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Sep 17 12:32:53 volumiok2 sudo[940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Sep 17 12:32:53 volumiok2 sudo[940]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:53 volumiok2 systemd[1]: Started UPnP Renderer front-end to MPD.
Sep 17 12:32:53 volumiok2 sudo[940]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:53 volumiok2 volumio[732]: info: Upmpdcli Daemon Started
Sep 17 12:32:53 volumiok2 mpd[912]: Sep 17 12:32 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Sep 17 12:32:53 volumiok2 mpd[912]: Sep 17 12:32 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured
Sep 17 12:32:53 volumiok2 mpd[912]: Sep 17 12:32 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured
Sep 17 12:32:53 volumiok2 systemd[1]: Started Music Player Daemon.
Sep 17 12:32:53 volumiok2 sudo[895]: pam_unix(sudo:session): session closed for user root
Sep 17 12:32:53 volumiok2 volumio[732]: error: updateQueue error: null
Sep 17 12:32:54 volumiok2 volumio[942]: Generating RSA private key, 4096 bit long modulus (2 primes)
Sep 17 12:32:55 volumiok2 systemd[1]: systemd-hostnamed.service: Succeeded.
Sep 17 12:32:56 volumiok2 volumio[942]: ............++++
Sep 17 12:32:56 volumiok2 sudo[963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=shashikawa,password=K0tetsuO630.,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.200/ncp-shashikawa /mnt/NAS/ncp-shashikawa
Sep 17 12:32:56 volumiok2 sudo[963]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:32:56 volumiok2 kernel: CIFS: Attempting to mount //192.168.10.200/ncp-shashikawa
Sep 17 12:32:58 volumiok2 volumio[942]: ..........++++
Sep 17 12:32:58 volumiok2 volumio[942]: e is 65537 (0x010001)
Sep 17 12:32:58 volumiok2 volumio[942]: writing RSA key
Sep 17 12:33:03 volumiok2 sudo[963]: pam_unix(sudo:session): session closed for user root
Sep 17 12:33:03 volumiok2 volumio[732]: info: Cannot mount NAS ncp-shashikawa at system boot, trial number 2 ,retrying in 5 seconds
Sep 17 12:33:03 volumiok2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 17 12:33:03 volumiok2 kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Sep 17 12:33:03 volumiok2 sudo[983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 17 12:33:03 volumiok2 sudo[983]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:33:03 volumiok2 sudo[985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 12:33:03 volumiok2 sudo[985]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:33:03 volumiok2 sudo[985]: pam_unix(sudo:session): session closed for user root
Sep 17 12:33:03 volumiok2 sudo[983]: pam_unix(sudo:session): session closed for user root
Sep 17 12:33:03 volumiok2 volumio[732]: verbose: New Socket.io Connection to 192.168.10.13 from 192.168.10.15 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 4
Sep 17 12:33:04 volumiok2 sudo[991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 17 12:33:04 volumiok2 sudo[991]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:33:04 volumiok2 sudo[993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 17 12:33:04 volumiok2 sudo[993]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:33:04 volumiok2 sudo[993]: pam_unix(sudo:session): session closed for user root
Sep 17 12:33:04 volumiok2 sudo[991]: pam_unix(sudo:session): session closed for user root
Sep 17 12:33:04 volumiok2 volumio[732]: verbose: New Socket.io Connection to 192.168.10.13 from 192.168.10.15 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Total Clients: 5
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetVisibleSources
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:33:04 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Sep 17 12:33:04 volumiok2 volumio[732]: info: Received Get System Info
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 12:33:04 volumiok2 volumio[732]: info: Discovery: Getting this device information
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:33:04 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:33:04 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:33:04 volumiok2 volumio[732]: info: Listing playlists
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Sep 17 12:33:04 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 17 12:33:05 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:33:05 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:33:06 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Sep 17 12:33:06 volumiok2 volumio[732]: info: Received Get System Info
Sep 17 12:33:06 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 12:33:06 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 12:33:06 volumiok2 volumio[732]: info: Discovery: Getting this device information
Sep 17 12:33:06 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:33:06 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:33:06 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 12:33:08 volumiok2 sudo[999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=shashikawa,password=K0tetsuO630.,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.200/ncp-shashikawa /mnt/NAS/ncp-shashikawa
Sep 17 12:33:08 volumiok2 sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:33:08 volumiok2 kernel: CIFS: Attempting to mount //192.168.10.200/ncp-shashikawa
Sep 17 12:33:12 volumiok2 volumio[732]: error: MyVolumio Plugin failed to start in a timely fashion
Sep 17 12:33:12 volumiok2 volumio[732]: info: BOOT COMPLETED
Sep 17 12:33:12 volumiok2 volumio[732]: [Metrics] CommandRouter: 32s 871.74ms
Sep 17 12:33:12 volumiok2 volumio[732]: info: CoreCommandRouter::volumiosetStartupVolume
Sep 17 12:33:12 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 17 12:33:12 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 12:33:12 volumiok2 volumio[732]: info: CoreCommandRouter::Close All Modals sent
Sep 17 12:33:12 volumiok2 volumio[732]: info: CoreCommandRouter::Close All Modals sent
Sep 17 12:33:13 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Sep 17 12:33:13 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 17 12:33:13 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Sep 17 12:33:14 volumiok2 sudo[999]: pam_unix(sudo:session): session closed for user root
Sep 17 12:33:14 volumiok2 volumio[732]: info: Cannot mount NAS ncp-shashikawa at system boot, trial number 3 ,retrying in 5 seconds
Sep 17 12:33:14 volumiok2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 17 12:33:14 volumiok2 kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::getUIConfigOnPlugin
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetBrowseSources
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 12:33:18 volumiok2 volumio[732]: info: Discovery: Getting this device information
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:33:18 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:33:18 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 12:33:19 volumiok2 sudo[1011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=shashikawa,password=K0tetsuO630.,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.200/ncp-shashikawa /mnt/NAS/ncp-shashikawa
Sep 17 12:33:19 volumiok2 sudo[1011]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 17 12:33:19 volumiok2 kernel: CIFS: Attempting to mount //192.168.10.200/ncp-shashikawa
Sep 17 12:33:22 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 17 12:33:22 volumiok2 volumio[732]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Sep 17 12:33:22 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 12:33:22 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 12:33:22 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 17 12:33:22 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 17 12:33:23 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Sep 17 12:33:23 volumiok2 volumio[732]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Sep 17 12:33:23 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Sep 17 12:33:23 volumiok2 volumio[732]: info: Received Get System Version
Sep 17 12:33:23 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 17 12:33:23 volumiok2 volumio[732]: info: Received Get System Info
Sep 17 12:33:23 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Sep 17 12:33:23 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Sep 17 12:33:23 volumiok2 volumio[732]: info: Discovery: Getting this device information
Sep 17 12:33:23 volumiok2 volumio[732]: info: CoreCommandRouter::volumioGetState
Sep 17 12:33:23 volumiok2 volumio[732]: info: CorePlayQueue::getTrack 0
Sep 17 12:33:23 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 17 12:33:25 volumiok2 sudo[1011]: pam_unix(sudo:session): session closed for user root
Sep 17 12:33:25 volumiok2 volumio[732]: info: Cannot mount NAS ncp-shashikawa at system boot, trial number 4 ,retrying in 5 seconds
Sep 17 12:33:25 volumiok2 kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Sep 17 12:33:25 volumiok2 kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Sep 17 12:33:26 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 17 12:33:28 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Sep 17 12:33:29 volumiok2 ntpd[566]: Soliciting pool server 129.250.35.250
Sep 17 12:33:29 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Sep 17 12:33:30 volumiok2 ntpd[566]: Soliciting pool server 133.243.238.243
Sep 17 12:33:30 volumiok2 volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Sep 17 12:33:30 volumiok2 ntpd[566]: Soliciting pool server 202.181.103.212
Sep 17 12:33:30 volumiok2 volumio[732]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 12:33:30 volumiok2 volumio[732]: TypeError: Cannot read property 'replace' of undefined
Sep 17 12:33:30 volumiok2 volumio[732]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28)
Sep 17 12:33:30 volumiok2 volumio[732]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20)
Sep 17 12:33:30 volumiok2 volumio[732]: at listOnTimeout (internal/timers.js:554:17)
Sep 17 12:33:30 volumiok2 volumio[732]: at processTimers (internal/timers.js:497:7)
Sep 17 12:33:30 volumiok2 volumio[732]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 17 12:33:31 volumiok2 ntpd[566]: Soliciting pool server 162.159.200.123
Sep 17 12:33:31 volumiok2 ntpd[566]: Soliciting pool server 45.76.211.39
Sep 17 12:33:31 volumiok2 ntpd[566]: Soliciting pool server 163.44.97.196
Sep 17 12:33:31 volumiok2 sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-09-17 12:32
Sep 17 12:33:31 volumiok2 sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST"
VOLUMIO_VERSION="3.512"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"