-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Wed 2024-05-01 08:14:10 EDT. -- May 01 08:13:00 volumiopi-ii kernel: videodev: Linux video capture interface: v2.00 May 01 08:13:00 volumiopi-ii kernel: Bluetooth: Core ver 2.22 May 01 08:13:00 volumiopi-ii kernel: NET: Registered PF_BLUETOOTH protocol family May 01 08:13:00 volumiopi-ii kernel: Bluetooth: HCI device and connection manager initialized May 01 08:13:00 volumiopi-ii kernel: Bluetooth: HCI socket layer initialized May 01 08:13:00 volumiopi-ii kernel: Bluetooth: L2CAP socket layer initialized May 01 08:13:00 volumiopi-ii kernel: Bluetooth: SCO socket layer initialized May 01 08:13:00 volumiopi-ii kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database May 01 08:13:00 volumiopi-ii kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. May 01 08:13:00 volumiopi-ii kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. May 01 08:13:00 volumiopi-ii kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. May 01 08:13:00 volumiopi-ii kernel: snd_bcm2835: unknown parameter 'enable_compat_alsa' ignored May 01 08:13:00 volumiopi-ii kernel: bcm2835_audio bcm2835_audio: card created with 4 channels May 01 08:13:00 volumiopi-ii kernel: bcm2835_audio bcm2835_audio: card created with 4 channels May 01 08:13:00 volumiopi-ii kernel: Bluetooth: HCI UART driver ver 2.3 May 01 08:13:00 volumiopi-ii kernel: Bluetooth: HCI UART protocol H4 registered May 01 08:13:00 volumiopi-ii kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered May 01 08:13:00 volumiopi-ii kernel: Bluetooth: HCI UART protocol Broadcom registered May 01 08:13:00 volumiopi-ii kernel: hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator May 01 08:13:00 volumiopi-ii kernel: hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator May 01 08:13:00 volumiopi-ii kernel: cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' May 01 08:13:00 volumiopi-ii kernel: cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' May 01 08:13:00 volumiopi-ii kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' May 01 08:13:00 volumiopi-ii kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. May 01 08:13:00 volumiopi-ii kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. May 01 08:13:00 volumiopi-ii kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 May 01 08:13:00 volumiopi-ii kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode May 01 08:13:00 volumiopi-ii kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 May 01 08:13:00 volumiopi-ii kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode May 01 08:13:00 volumiopi-ii kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 May 01 08:13:00 volumiopi-ii kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp May 01 08:13:00 volumiopi-ii kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video18 May 01 08:13:00 volumiopi-ii kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 image_fx May 01 08:13:00 volumiopi-ii kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video31 May 01 08:13:00 volumiopi-ii kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode_image May 01 08:13:00 volumiopi-ii kernel: uart-pl011 fe201000.serial: no DMA platform data May 01 08:13:00 volumiopi-ii kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. May 01 08:13:00 volumiopi-ii kernel: rpivid_hevc: module is from the staging directory, the quality is unknown, you have been warned. May 01 08:13:00 volumiopi-ii kernel: rpivid feb10000.codec: Device registered as /dev/video19 May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video20 May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video21 May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video22 May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video23 May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller May 01 08:13:00 volumiopi-ii kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp May 01 08:13:00 volumiopi-ii kernel: snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517 May 01 08:13:00 volumiopi-ii kernel: snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517 May 01 08:13:00 volumiopi-ii kernel: Bluetooth: hci0: BCM: chip id 107 May 01 08:13:00 volumiopi-ii kernel: Bluetooth: hci0: BCM: features 0x2f May 01 08:13:00 volumiopi-ii kernel: Bluetooth: hci0: BCM4345C0 May 01 08:13:00 volumiopi-ii kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 May 01 08:13:01 volumiopi-ii kernel: snd-allo-boss-dac soc:sound: snd_soc_register_card() failed: -517 May 01 08:13:01 volumiopi-ii kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.hcd' Patch May 01 08:13:01 volumiopi-ii kernel: pcm512x 1-004d: supply AVDD not found, using dummy regulator May 01 08:13:01 volumiopi-ii kernel: pcm512x 1-004d: supply DVDD not found, using dummy regulator May 01 08:13:01 volumiopi-ii kernel: pcm512x 1-004d: supply CPVDD not found, using dummy regulator May 01 08:13:01 volumiopi-ii kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 May 01 08:13:01 volumiopi-ii kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 May 01 08:13:01 volumiopi-ii kernel: usbcore: registered new interface driver brcmfmac May 01 08:13:01 volumiopi-ii kernel: Bluetooth: hci0: BCM: features 0x2f May 01 08:13:01 volumiopi-ii kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+ May 01 08:13:01 volumiopi-ii kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0342 May 01 08:13:02 volumiopi-ii kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Nov 1 2021 00:37:25 version 7.45.241 (1a2f2fa CY) FWID 01-703fd60 May 01 08:13:02 volumiopi-ii systemd-udevd[248]: Using default interface naming scheme 'v240'. May 01 08:13:02 volumiopi-ii systemd-udevd[248]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. May 01 08:13:03 volumiopi-ii systemd[1]: Started Helper to synchronize boot up for ifupdown. May 01 08:13:03 volumiopi-ii systemd[1]: Found device /dev/mmcblk0p1. May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in /sys/subsystem/net/devices/wlan0 being skipped. May 01 08:13:04 volumiopi-ii systemd[1]: Created slice system-bthelper.slice. May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in Huge Pages File System being skipped. May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in FUSE Control File System being skipped. May 01 08:13:04 volumiopi-ii systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. May 01 08:13:04 volumiopi-ii systemd[1]: Starting File System Check on /dev/mmcblk0p1... May 01 08:13:04 volumiopi-ii systemd[1]: Starting Load/Save RF Kill Switch Status... May 01 08:13:04 volumiopi-ii systemd[1]: Started File System Check Daemon to report status. May 01 08:13:04 volumiopi-ii systemd[1]: Started Load/Save RF Kill Switch Status. May 01 08:13:04 volumiopi-ii systemd-fsck[446]: fsck.fat 4.1 (2017-01-24) May 01 08:13:04 volumiopi-ii systemd-fsck[446]: Unexpected long filename sequence number (2 vs. expected 1). May 01 08:13:04 volumiopi-ii systemd-fsck[446]: It could be that just the number is wrong May 01 08:13:04 volumiopi-ii systemd-fsck[446]: if "network-confi" seems to match "g". May 01 08:13:04 volumiopi-ii systemd-fsck[446]: Not auto-correcting this. May 01 08:13:04 volumiopi-ii systemd-fsck[446]: /dev/mmcblk0p1: 366 files, 33348/46774 clusters May 01 08:13:04 volumiopi-ii systemd[1]: Started File System Check on /dev/mmcblk0p1. May 01 08:13:04 volumiopi-ii systemd[1]: Mounting /boot... May 01 08:13:04 volumiopi-ii systemd[1]: Mounted /boot. May 01 08:13:04 volumiopi-ii systemd[1]: Reached target Local File Systems. May 01 08:13:04 volumiopi-ii systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... May 01 08:13:04 volumiopi-ii systemd[1]: Starting Raise network interfaces... May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. May 01 08:13:04 volumiopi-ii systemd[1]: Starting Create Volatile Files and Directories... May 01 08:13:04 volumiopi-ii systemd[1]: Started ifup for eth0. May 01 08:13:04 volumiopi-ii systemd[1]: Starting Preprocess NFS configuration... May 01 08:13:04 volumiopi-ii systemd[1]: Started ifup for wlan0. May 01 08:13:04 volumiopi-ii systemd[1]: plymouth-read-write.service: Succeeded. May 01 08:13:04 volumiopi-ii systemd[1]: Started Tell Plymouth To Write Out Runtime Data. May 01 08:13:04 volumiopi-ii systemd[1]: Received SIGRTMIN+20 from PID 275 (plymouthd). May 01 08:13:04 volumiopi-ii systemd[1]: nfs-config.service: Succeeded. May 01 08:13:04 volumiopi-ii systemd[1]: Started Preprocess NFS configuration. May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. May 01 08:13:04 volumiopi-ii systemd[1]: Reached target NFS client services. May 01 08:13:04 volumiopi-ii systemd[1]: Started Create Volatile Files and Directories. May 01 08:13:04 volumiopi-ii systemd[1]: Starting Update UTMP about System Boot/Shutdown... May 01 08:13:04 volumiopi-ii systemd[1]: Starting RPC bind portmap service... May 01 08:13:04 volumiopi-ii systemd[1]: Condition check resulted in Network Time Synchronization being skipped. May 01 08:13:05 volumiopi-ii systemd[1]: Started Entropy daemon using the HAVEGE algorithm. May 01 08:13:05 volumiopi-ii systemd[1]: Started Update UTMP about System Boot/Shutdown. May 01 08:13:05 volumiopi-ii systemd[1]: Reached target System Initialization. May 01 08:13:05 volumiopi-ii systemd[1]: Started Daily apt download activities. May 01 08:13:05 volumiopi-ii systemd[1]: Started Volumio Splash. May 01 08:13:05 volumiopi-ii systemd[1]: Started Daily Cleanup of Temporary Directories. May 01 08:13:05 volumiopi-ii systemd[525]: volumiosplash.service: Failed to execute command: No such file or directory May 01 08:13:05 volumiopi-ii systemd[525]: volumiosplash.service: Failed at step EXEC spawning /bin/volumiosplash.sh: No such file or directory May 01 08:13:05 volumiopi-ii systemd[1]: Listening on D-Bus System Message Bus Socket. May 01 08:13:05 volumiopi-ii systemd[1]: Listening on lircd.socket. May 01 08:13:05 volumiopi-ii systemd[1]: Listening on triggerhappy.socket. May 01 08:13:05 volumiopi-ii systemd[1]: Started Daily apt upgrade and clean activities. May 01 08:13:05 volumiopi-ii systemd[1]: Reached target Timers. May 01 08:13:05 volumiopi-ii systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. May 01 08:13:05 volumiopi-ii systemd[1]: Reached target Sockets. May 01 08:13:05 volumiopi-ii systemd[1]: Reached target Basic System. May 01 08:13:05 volumiopi-ii systemd[1]: Starting Wireless Services... May 01 08:13:05 volumiopi-ii systemd[1]: Started Manage Sound Card State (restore and store). May 01 08:13:05 volumiopi-ii systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. May 01 08:13:05 volumiopi-ii systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. May 01 08:13:05 volumiopi-ii systemd[1]: Starting dhcpcd on all interfaces... May 01 08:13:05 volumiopi-ii kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 01 08:13:05 volumiopi-ii kernel: 8021q: 802.1Q VLAN Support v1.8 May 01 08:13:05 volumiopi-ii systemd[1]: Started D-Bus System Message Bus. May 01 08:13:05 volumiopi-ii alsactl[530]: alsactl 1.1.8 daemon started May 01 08:13:05 volumiopi-ii systemd[1]: Starting triggerhappy global hotkey daemon... May 01 08:13:05 volumiopi-ii systemd[1]: Started UPnP Renderer front-end to MPD. May 01 08:13:05 volumiopi-ii systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... May 01 08:13:05 volumiopi-ii systemd[1]: Started volumio-remote-updater.service. May 01 08:13:05 volumiopi-ii systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. May 01 08:13:05 volumiopi-ii dhcpcd[531]: Not running dhcpcd because /etc/network/interfaces May 01 08:13:05 volumiopi-ii dhcpcd[531]: defines some interfaces that will use a May 01 08:13:05 volumiopi-ii dhcpcd[531]: DHCP client or static address May 01 08:13:05 volumiopi-ii systemd[1]: Started Volumio Log Rotation Service. May 01 08:13:05 volumiopi-ii systemd[1]: Starting Save/Restore Sound Card State... May 01 08:13:05 volumiopi-ii systemd[1]: Starting Configure Bluetooth Modems connected by UART... May 01 08:13:05 volumiopi-ii systemd[1]: Started Volumio Iptables Module. May 01 08:13:05 volumiopi-ii systemd[1]: Starting Login Service... May 01 08:13:05 volumiopi-ii systemd[1]: Starting WPA supplicant... May 01 08:13:05 volumiopi-ii systemd[1]: Starting Avahi mDNS/DNS-SD Stack... May 01 08:13:05 volumiopi-ii systemd[1]: volumiosplash.service: Main process exited, code=exited, status=203/EXEC May 01 08:13:05 volumiopi-ii systemd[1]: volumiosplash.service: Failed with result 'exit-code'. May 01 08:13:05 volumiopi-ii systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED May 01 08:13:05 volumiopi-ii systemd[1]: dhcpcd.service: Failed with result 'exit-code'. May 01 08:13:05 volumiopi-ii systemd[1]: Failed to start dhcpcd on all interfaces. May 01 08:13:05 volumiopi-ii systemd[1]: Started Save/Restore Sound Card State. May 01 08:13:05 volumiopi-ii systemd[1]: Reached target Sound Card. May 01 08:13:05 volumiopi-ii thd[537]: Unable to parse trigger line: May 01 08:13:05 volumiopi-ii thd[537]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle May 01 08:13:05 volumiopi-ii thd[537]: Unable to parse trigger line: May 01 08:13:05 volumiopi-ii thd[537]: Found socket passed from systemd May 01 08:13:05 volumiopi-ii ifup[454]: ifup: waiting for lock on /run/network/ifstate.wlan0 May 01 08:13:05 volumiopi-ii sh[461]: wlan0=wlan0 May 01 08:13:05 volumiopi-ii systemd-logind[558]: New seat seat0. May 01 08:13:06 volumiopi-ii avahi-daemon[560]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). May 01 08:13:06 volumiopi-ii avahi-daemon[560]: Successfully dropped root privileges. May 01 08:13:06 volumiopi-ii avahi-daemon[560]: avahi-daemon 0.7 starting up. May 01 08:13:08 volumiopi-ii sh[457]: eth0: waiting for carrier May 01 08:13:08 volumiopi-ii kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) May 01 08:13:08 volumiopi-ii kernel: bcmgenet fd580000.ethernet eth0: Link is Down May 01 08:13:08 volumiopi-ii dhcpcd[502]: eth0: waiting for carrier May 01 08:13:08 volumiopi-ii systemd[1]: Started Login Service. May 01 08:13:08 volumiopi-ii systemd[1]: Started triggerhappy global hotkey daemon. May 01 08:13:08 volumiopi-ii systemd[1]: Started RPC bind portmap service. May 01 08:13:08 volumiopi-ii systemd[1]: hciuart.service: Succeeded. May 01 08:13:08 volumiopi-ii systemd[1]: Started Configure Bluetooth Modems connected by UART. May 01 08:13:08 volumiopi-ii avahi-daemon[560]: Successfully called chroot(). May 01 08:13:08 volumiopi-ii avahi-daemon[560]: Successfully dropped remaining capabilities. May 01 08:13:08 volumiopi-ii wpa_supplicant[559]: Successfully initialized wpa_supplicant May 01 08:13:08 volumiopi-ii systemd[1]: Started WPA supplicant. May 01 08:13:08 volumiopi-ii avahi-daemon[560]: Loading service file /services/volumio.service. May 01 08:13:08 volumiopi-ii systemd[1]: Started Avahi mDNS/DNS-SD Stack. May 01 08:13:08 volumiopi-ii haveged[517]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K May 01 08:13:08 volumiopi-ii haveged[517]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 May 01 08:13:08 volumiopi-ii haveged[517]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00171 May 01 08:13:08 volumiopi-ii haveged[517]: haveged: fills: 0, generated: 0 May 01 08:13:08 volumiopi-ii avahi-daemon[560]: Network interface enumeration completed. May 01 08:13:08 volumiopi-ii systemd[1]: Starting Raspberry Pi bluetooth helper... May 01 08:13:08 volumiopi-ii systemd[1]: Reached target Remote File Systems (Pre). May 01 08:13:08 volumiopi-ii systemd[1]: Reached target Remote File Systems. May 01 08:13:08 volumiopi-ii systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... May 01 08:13:08 volumiopi-ii systemd[1]: Reached target RPC Port Mapper. May 01 08:13:08 volumiopi-ii avahi-daemon[560]: Server startup complete. Host name is volumiopi-ii.local. Local service cookie is 508271197. May 01 08:13:08 volumiopi-ii avahi-daemon[560]: Service "VolumioPi-II" (/services/volumio.service) successfully established. May 01 08:13:08 volumiopi-ii systemd[1]: Started Raise network interfaces. May 01 08:13:08 volumiopi-ii systemd[1]: Reached target Network. May 01 08:13:08 volumiopi-ii systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. May 01 08:13:08 volumiopi-ii systemd[1]: Starting Permit User Sessions... May 01 08:13:08 volumiopi-ii systemd[1]: Starting Network Time Service... May 01 08:13:08 volumiopi-ii systemd[1]: Reached target Network is Online. May 01 08:13:08 volumiopi-ii systemd[1]: Starting Samba NMB Daemon... May 01 08:13:08 volumiopi-ii systemd[1]: Starting /etc/rc.local Compatibility... May 01 08:13:08 volumiopi-ii systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 01 08:13:08 volumiopi-ii bthelper[635]: Raspberry Pi BDADDR already set May 01 08:13:08 volumiopi-ii systemd[1]: Starting LSB: Brings up/down network automatically... May 01 08:13:08 volumiopi-ii systemd[1]: Started Raspberry Pi bluetooth helper. May 01 08:13:08 volumiopi-ii systemd[1]: Started /etc/rc.local Compatibility. May 01 08:13:08 volumiopi-ii systemd[1]: Starting Bluetooth service... May 01 08:13:08 volumiopi-ii systemd[1]: Started Permit User Sessions. May 01 08:13:08 volumiopi-ii systemd[1]: Starting Terminate Plymouth Boot Screen... May 01 08:13:08 volumiopi-ii systemd[1]: Starting Hold until boot process finishes up... May 01 08:13:09 volumiopi-ii systemd[1]: Received SIGRTMIN+21 from PID 275 (plymouthd). May 01 08:13:09 volumiopi-ii systemd[1]: plymouth-start.service: Succeeded. May 01 08:13:09 volumiopi-ii systemd[1]: plymouth-quit.service: Succeeded. May 01 08:13:09 volumiopi-ii systemd[1]: Started Terminate Plymouth Boot Screen. May 01 08:13:09 volumiopi-ii systemd[1]: plymouth-quit-wait.service: Succeeded. May 01 08:13:09 volumiopi-ii systemd[1]: Started Hold until boot process finishes up. May 01 08:13:09 volumiopi-ii systemd[1]: Received SIGRTMIN+21 from PID 275 (n/a). May 01 08:13:09 volumiopi-ii systemd[1]: Started Getty on tty1. May 01 08:13:09 volumiopi-ii systemd[1]: Reached target Login Prompts. May 01 08:13:09 volumiopi-ii systemd[1]: systemd-rfkill.service: Succeeded. May 01 08:13:09 volumiopi-ii ifplugd(eth0)[700]: ifplugd 0.28 initializing. May 01 08:13:09 volumiopi-ii ifplugd(eth0)[700]: Using interface eth0/D8:3A:DD:97:17:39 with driver (version: 6.1.69-v7l+) May 01 08:13:09 volumiopi-ii ifplugd(eth0)[700]: Using detection mode: SIOCETHTOOL May 01 08:13:09 volumiopi-ii ifplugd(eth0)[700]: Initialization complete, link beat not detected. May 01 08:13:09 volumiopi-ii volumio-remote-updater[545]: Error: No active session May 01 08:13:09 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:09] [info] asio async_connect error: system:111 (Connection refused) May 01 08:13:09 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:09] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 01 08:13:09 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:09] [error] handle_connect error: Underlying Transport Error May 01 08:13:09 volumiopi-ii ifplugd[657]: Network Interface Plugging Daemon...start eth0...done. May 01 08:13:09 volumiopi-ii systemd[1]: Started LSB: Brings up/down network automatically. May 01 08:13:09 volumiopi-ii bluetoothd[663]: Bluetooth daemon 5.50 May 01 08:13:09 volumiopi-ii ntpd[651]: ntpd 4.2.8p12@1.3728-o (1): Starting May 01 08:13:09 volumiopi-ii ntpd[651]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 May 01 08:13:09 volumiopi-ii volumio[539]: Could not open config: /tmp/upmpdcli.conf May 01 08:13:09 volumiopi-ii systemd[1]: Started Network Time Service. May 01 08:13:09 volumiopi-ii bluetoothd[663]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf May 01 08:13:09 volumiopi-ii systemd[1]: Started Bluetooth service. May 01 08:13:09 volumiopi-ii systemd[1]: Reached target Bluetooth. May 01 08:13:09 volumiopi-ii bluetoothd[663]: Starting SDP server May 01 08:13:09 volumiopi-ii bluetoothd[663]: Excluding (cli) sap May 01 08:13:09 volumiopi-ii systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE May 01 08:13:09 volumiopi-ii systemd[1]: upmpdcli.service: Failed with result 'exit-code'. May 01 08:13:09 volumiopi-ii ntpd[710]: proto: precision = 2.166 usec (-19) May 01 08:13:09 volumiopi-ii kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 May 01 08:13:09 volumiopi-ii kernel: Bluetooth: BNEP filters: protocol multicast May 01 08:13:09 volumiopi-ii kernel: Bluetooth: BNEP socket layer initialized May 01 08:13:09 volumiopi-ii bluetoothd[663]: Bluetooth management interface 1.22 initialized May 01 08:13:09 volumiopi-ii kernel: Bluetooth: MGMT ver 1.22 May 01 08:13:09 volumiopi-ii dbus-daemon[535]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=663 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") May 01 08:13:09 volumiopi-ii ntpd[710]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 01 08:13:09 volumiopi-ii ntpd[710]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 01 08:13:09 volumiopi-ii ntpd[710]: Listen and drop on 0 v6wildcard [::]:123 May 01 08:13:09 volumiopi-ii ntpd[710]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 01 08:13:09 volumiopi-ii ntpd[710]: Listen normally on 2 lo 127.0.0.1:123 May 01 08:13:09 volumiopi-ii ntpd[710]: Listening on routing socket on fd #19 for interface updates May 01 08:13:09 volumiopi-ii ntpd[710]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 01 08:13:09 volumiopi-ii ntpd[710]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 01 08:13:09 volumiopi-ii loadcpufreq[641]: Loading cpufreq kernel modules...done (none). May 01 08:13:09 volumiopi-ii bluetoothd[663]: Failed to set privacy: Rejected (0x0b) May 01 08:13:10 volumiopi-ii systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. May 01 08:13:10 volumiopi-ii systemd[1]: Starting LSB: set CPUFreq kernel parameters... May 01 08:13:10 volumiopi-ii systemd[1]: Starting Hostname Service... May 01 08:13:10 volumiopi-ii systemd[1]: iptables.service: Succeeded. May 01 08:13:10 volumiopi-ii cpufrequtils[733]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. May 01 08:13:10 volumiopi-ii systemd[1]: Started LSB: set CPUFreq kernel parameters. May 01 08:13:10 volumiopi-ii dbus-daemon[535]: [system] Successfully activated service 'org.freedesktop.hostname1' May 01 08:13:10 volumiopi-ii systemd[1]: Started Hostname Service. May 01 08:13:10 volumiopi-ii ntpd[710]: error resolving pool 0.debian.pool.ntp.org: System error (-11) May 01 08:13:11 volumiopi-ii nmbd[662]: [2024/05/01 08:13:11.017849, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) May 01 08:13:11 volumiopi-ii nmbd[662]: started asyncdns process 747 May 01 08:13:11 volumiopi-ii nmbd[662]: [2024/05/01 08:13:11.019693, 0] ../lib/util/become_daemon.c:149(daemon_status) May 01 08:13:11 volumiopi-ii nmbd[662]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... May 01 08:13:11 volumiopi-ii nmbd[662]: [2024/05/01 08:13:11.019821, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) May 01 08:13:11 volumiopi-ii nmbd[662]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). May 01 08:13:11 volumiopi-ii kernel: new mount options do not match the existing superblock, will be ignored May 01 08:13:11 volumiopi-ii wireless.js[529]: Cleaning previous... May 01 08:13:11 volumiopi-ii volumio[543]: cset: --> shielding system active with May 01 08:13:11 volumiopi-ii volumio[543]: cset: "system" cpuset of CPUSPEC(1-3) with 75 tasks running May 01 08:13:11 volumiopi-ii volumio[543]: cset: "user" cpuset of CPUSPEC(0) with 0 tasks running May 01 08:13:11 volumiopi-ii systemd[1]: Started Shield Volumio Music Services in the User CPU Set. May 01 08:13:11 volumiopi-ii sudo[762]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 01 08:13:11 volumiopi-ii sudo[762]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:11 volumiopi-ii sudo[762]: pam_unix(sudo:session): session closed for user root May 01 08:13:11 volumiopi-ii sudo[764]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 01 08:13:11 volumiopi-ii sudo[764]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:11 volumiopi-ii ntpd[710]: error resolving pool 1.debian.pool.ntp.org: System error (-11) May 01 08:13:11 volumiopi-ii sudo[764]: pam_unix(sudo:session): session closed for user root May 01 08:13:12 volumiopi-ii wireless.js[529]: Stopped aP May 01 08:13:12 volumiopi-ii sudo[771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 01 08:13:12 volumiopi-ii sudo[771]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:12 volumiopi-ii sudo[771]: pam_unix(sudo:session): session closed for user root May 01 08:13:12 volumiopi-ii kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 01 08:13:12 volumiopi-ii sudo[773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get May 01 08:13:12 volumiopi-ii sudo[773]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:12 volumiopi-ii sudo[773]: pam_unix(sudo:session): session closed for user root May 01 08:13:12 volumiopi-ii sudo[780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up May 01 08:13:12 volumiopi-ii sudo[780]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:12 volumiopi-ii sudo[780]: pam_unix(sudo:session): session closed for user root May 01 08:13:12 volumiopi-ii sudo[782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan May 01 08:13:12 volumiopi-ii sudo[782]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:12 volumiopi-ii ntpd[710]: error resolving pool 2.debian.pool.ntp.org: System error (-11) May 01 08:13:13 volumiopi-ii ntpd[710]: error resolving pool 3.debian.pool.ntp.org: System error (-11) May 01 08:13:13 volumiopi-ii bthelper[635]: Changing power off succeeded May 01 08:13:13 volumiopi-ii bthelper[635]: [CHG] Controller D8:3A:DD:97:17:3E Powered: no May 01 08:13:13 volumiopi-ii bthelper[635]: [CHG] Controller D8:3A:DD:97:17:3E Discovering: no May 01 08:13:13 volumiopi-ii bthelper[635]: [CHG] Controller D8:3A:DD:97:17:3E Class: 0x00000000 May 01 08:13:13 volumiopi-ii bthelper[635]: [CHG] Controller D8:3A:DD:97:17:3E Class: 0x0000041c May 01 08:13:13 volumiopi-ii bthelper[635]: Changing power on succeeded May 01 08:13:13 volumiopi-ii bthelper[635]: [CHG] Controller D8:3A:DD:97:17:3E Powered: yes May 01 08:13:14 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:14] [info] asio async_connect error: system:111 (Connection refused) May 01 08:13:14 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:14] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 01 08:13:14 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:14] [error] handle_connect error: Underlying Transport Error May 01 08:13:15 volumiopi-ii sudo[782]: pam_unix(sudo:session): session closed for user root May 01 08:13:15 volumiopi-ii wireless.js[529]: Start wireless flow May 01 08:13:15 volumiopi-ii wireless.js[529]: Stopped hotspot (if there).. May 01 08:13:15 volumiopi-ii sudo[794]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 May 01 08:13:15 volumiopi-ii sudo[794]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:15 volumiopi-ii sudo[794]: pam_unix(sudo:session): session closed for user root May 01 08:13:15 volumiopi-ii sudo[796]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down May 01 08:13:15 volumiopi-ii sudo[796]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:15 volumiopi-ii sudo[796]: pam_unix(sudo:session): session closed for user root May 01 08:13:15 volumiopi-ii wireless.js[529]: DHCP IP May 01 08:13:15 volumiopi-ii wireless.js[529]: Start ap May 01 08:13:15 volumiopi-ii wpa_supplicant[798]: Successfully initialized wpa_supplicant May 01 08:13:15 volumiopi-ii sudo[799]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd May 01 08:13:15 volumiopi-ii sudo[799]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:15 volumiopi-ii kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 01 08:13:15 volumiopi-ii dhcpcd[800]: dev: loaded udev May 01 08:13:15 volumiopi-ii dhcpcd-run-hooks[818]: wlan0: starting wpa_supplicant May 01 08:13:16 volumiopi-ii dhcpcd-run-hooks[823]: wlan0: failed to start wpa_supplicant May 01 08:13:16 volumiopi-ii dhcpcd-run-hooks[824]: 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 May 01 08:13:16 volumiopi-ii dhcpcd[800]: wlan0: connected to Access Point `' May 01 08:13:16 volumiopi-ii dhcpcd[800]: no interfaces have a carrier May 01 08:13:16 volumiopi-ii dhcpcd[800]: forked to background, child pid 834 May 01 08:13:16 volumiopi-ii dhcpcd[834]: eth0: waiting for carrier May 01 08:13:16 volumiopi-ii dhcpcd[834]: wlan0: waiting for carrier May 01 08:13:16 volumiopi-ii sudo[799]: pam_unix(sudo:session): session closed for user root May 01 08:13:16 volumiopi-ii wireless.js[529]: trying... May 01 08:13:16 volumiopi-ii sudo[836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:16 volumiopi-ii sudo[836]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:16 volumiopi-ii sudo[836]: pam_unix(sudo:session): session closed for user root May 01 08:13:17 volumiopi-ii wireless.js[529]: trying... May 01 08:13:17 volumiopi-ii sudo[839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:17 volumiopi-ii sudo[839]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:17 volumiopi-ii sudo[839]: pam_unix(sudo:session): session closed for user root May 01 08:13:18 volumiopi-ii wireless.js[529]: trying... May 01 08:13:18 volumiopi-ii sudo[842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:18 volumiopi-ii sudo[842]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:18 volumiopi-ii wpa_supplicant[822]: wlan0: Trying to associate with SSID 'Cracka's_NETGEAR' May 01 08:13:18 volumiopi-ii sudo[842]: pam_unix(sudo:session): session closed for user root May 01 08:13:19 volumiopi-ii wireless.js[529]: trying... May 01 08:13:19 volumiopi-ii sudo[845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:19 volumiopi-ii sudo[845]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:19 volumiopi-ii sudo[845]: pam_unix(sudo:session): session closed for user root May 01 08:13:20 volumiopi-ii wireless.js[529]: trying... May 01 08:13:20 volumiopi-ii sudo[848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:20 volumiopi-ii sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:20 volumiopi-ii sudo[848]: pam_unix(sudo:session): session closed for user root May 01 08:13:21 volumiopi-ii wireless.js[529]: trying... May 01 08:13:21 volumiopi-ii dhcpcd[834]: wlan0: carrier acquired May 01 08:13:21 volumiopi-ii wpa_supplicant[822]: wlan0: Associated with 14:59:c0:ae:d6:45 May 01 08:13:21 volumiopi-ii dhcpcd[834]: wlan0: connected to Access Point `Cracka's_NETGEAR' May 01 08:13:21 volumiopi-ii wpa_supplicant[822]: wlan0: CTRL-EVENT-CONNECTED - Connection to 14:59:c0:ae:d6:45 completed [id=0 id_str=] May 01 08:13:21 volumiopi-ii wpa_supplicant[822]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 01 08:13:21 volumiopi-ii sudo[851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:21 volumiopi-ii dhcpcd[834]: DUID 00:01:00:01:2d:69:1f:e4:d8:3a:dd:97:17:3c May 01 08:13:21 volumiopi-ii dhcpcd[834]: wlan0: IAID dd:97:17:3c May 01 08:13:21 volumiopi-ii dhcpcd[834]: wlan0: adding address fe80::da3a:ddff:fe97:173c May 01 08:13:21 volumiopi-ii sudo[851]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:21 volumiopi-ii dhcpcd[834]: ipv6_addaddr1: Permission denied May 01 08:13:21 volumiopi-ii dhcpcd[834]: wlan0: probing address 192.168.10.99/24 May 01 08:13:21 volumiopi-ii sudo[851]: pam_unix(sudo:session): session closed for user root May 01 08:13:21 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:21] [info] asio async_connect error: system:111 (Connection refused) May 01 08:13:21 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:21] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 01 08:13:21 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:21] [error] handle_connect error: Underlying Transport Error May 01 08:13:21 volumiopi-ii dhcpcd[834]: wlan0: carrier lost May 01 08:13:22 volumiopi-ii dhcpcd[834]: wlan0: carrier acquired May 01 08:13:22 volumiopi-ii dhcpcd[834]: wlan0: IAID dd:97:17:3c May 01 08:13:22 volumiopi-ii dhcpcd[834]: wlan0: probing address 192.168.10.99/24 May 01 08:13:22 volumiopi-ii dhcpcd[834]: wlan0: soliciting an IPv6 router May 01 08:13:22 volumiopi-ii wireless.js[529]: trying... May 01 08:13:22 volumiopi-ii sudo[875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:22 volumiopi-ii sudo[875]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:22 volumiopi-ii sudo[875]: pam_unix(sudo:session): session closed for user root May 01 08:13:23 volumiopi-ii wireless.js[529]: trying... May 01 08:13:23 volumiopi-ii sudo[878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:23 volumiopi-ii sudo[878]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:23 volumiopi-ii sudo[878]: pam_unix(sudo:session): session closed for user root May 01 08:13:24 volumiopi-ii wireless.js[529]: trying... May 01 08:13:24 volumiopi-ii sudo[881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:24 volumiopi-ii sudo[881]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:24 volumiopi-ii sudo[881]: pam_unix(sudo:session): session closed for user root May 01 08:13:25 volumiopi-ii wireless.js[529]: trying... May 01 08:13:25 volumiopi-ii sudo[884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:25 volumiopi-ii sudo[884]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:25 volumiopi-ii sudo[884]: pam_unix(sudo:session): session closed for user root May 01 08:13:26 volumiopi-ii wireless.js[529]: trying... May 01 08:13:26 volumiopi-ii sudo[887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:26 volumiopi-ii sudo[887]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:26 volumiopi-ii sudo[887]: pam_unix(sudo:session): session closed for user root May 01 08:13:27 volumiopi-ii dhcpcd[834]: wlan0: using static address 192.168.10.99/24 May 01 08:13:27 volumiopi-ii avahi-daemon[560]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.10.99. May 01 08:13:27 volumiopi-ii dhcpcd[834]: wlan0: adding route to 192.168.10.0/24 May 01 08:13:27 volumiopi-ii dhcpcd[834]: wlan0: adding default route via 192.168.10.254 May 01 08:13:27 volumiopi-ii avahi-daemon[560]: New relevant interface wlan0.IPv4 for mDNS. May 01 08:13:27 volumiopi-ii avahi-daemon[560]: Registering new address record for 192.168.10.99 on wlan0.IPv4. May 01 08:13:27 volumiopi-ii wireless.js[529]: trying... May 01 08:13:27 volumiopi-ii sudo[911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 08:13:27 volumiopi-ii sudo[911]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:27 volumiopi-ii sudo[911]: pam_unix(sudo:session): session closed for user root May 01 08:13:27 volumiopi-ii wireless.js[529]: Connected to: ----Cracka's_NETGEAR May 01 08:13:27 volumiopi-ii wireless.js[529]: ---- May 01 08:13:27 volumiopi-ii sudo[914]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 08:13:27 volumiopi-ii sudo[914]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:27 volumiopi-ii sudo[914]: pam_unix(sudo:session): session closed for user root May 01 08:13:27 volumiopi-ii wireless.js[529]: ... joined AP, wlan0 IPv4 is 192.168.10.99, ipV6 is undefined May 01 08:13:27 volumiopi-ii wireless.js[529]: It's done! AP May 01 08:13:28 volumiopi-ii systemd[1]: Started Wireless Services. May 01 08:13:28 volumiopi-ii kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 01 08:13:28 volumiopi-ii systemd[1]: Started Volumio Backend Module. May 01 08:13:28 volumiopi-ii systemd[1]: Started Volumio Cpu Tweaker. May 01 08:13:28 volumiopi-ii volumio-cpu-tweak[920]: Setting RT Priority for mpd May 01 08:13:28 volumiopi-ii volumio-cpu-tweak[920]: pid 35's current scheduling policy: SCHED_OTHER May 01 08:13:28 volumiopi-ii volumio-cpu-tweak[920]: pid 35's current scheduling priority: 0 May 01 08:13:28 volumiopi-ii volumio-cpu-tweak[920]: Setting MPD Affinity May 01 08:13:28 volumiopi-ii volumio-cpu-tweak[920]: pid 3's current affinity mask: f May 01 08:13:28 volumiopi-ii volumio-cpu-tweak[920]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 01 08:13:28 volumiopi-ii volumio-cpu-tweak[920]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 01 08:13:28 volumiopi-ii systemd[1]: volumio_cpu_tweak.service: Succeeded. May 01 08:13:28 volumiopi-ii ntpd[710]: Listen normally on 3 wlan0 192.168.10.99:123 May 01 08:13:28 volumiopi-ii ntpd[710]: new interface(s) found: waking up resolver May 01 08:13:29 volumiopi-ii volumio[919]: info: ------------------------------------------- May 01 08:13:29 volumiopi-ii volumio[919]: info: ----- Volumio3 ---- May 01 08:13:29 volumiopi-ii volumio[919]: info: ------------------------------------------- May 01 08:13:29 volumiopi-ii volumio[919]: info: ----- System startup ---- May 01 08:13:29 volumiopi-ii volumio[919]: info: ------------------------------------------- May 01 08:13:30 volumiopi-ii volumio[919]: info: MYVOLUMIO Environment detected May 01 08:13:30 volumiopi-ii volumio[919]: info: Plugin folders cleanup May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning into folder /volumio/app/plugins/ May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning category audio_interface May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning category miscellanea May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning category music_service May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning category plugins.json May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning category system_controller May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning category user_interface May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning into folder /data/plugins/ May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning category music_service May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning category system_controller May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning category system_hardware May 01 08:13:30 volumiopi-ii volumio[919]: info: Scanning category user_interface May 01 08:13:30 volumiopi-ii volumio[919]: info: Plugin folders cleanup completed May 01 08:13:30 volumiopi-ii volumio[919]: info: ------------------------------------------- May 01 08:13:30 volumiopi-ii volumio[919]: info: ----- Core plugins startup ---- May 01 08:13:30 volumiopi-ii volumio[919]: info: ------------------------------------------- May 01 08:13:30 volumiopi-ii volumio[919]: info: Loading plugins from folder /volumio/app/plugins/ May 01 08:13:30 volumiopi-ii volumio[919]: info: Adding plugin upnp to MyMusic Plugins May 01 08:13:30 volumiopi-ii volumio[919]: info: Adding plugin airplay_emulation to MyMusic Plugins May 01 08:13:30 volumiopi-ii volumio[919]: info: Adding plugin upnp_browser to MyMusic Plugins May 01 08:13:30 volumiopi-ii volumio[919]: info: Loading plugins from folder /data/plugins/ May 01 08:13:30 volumiopi-ii volumio[919]: info: Loading plugin "system"... May 01 08:13:30 volumiopi-ii volumio[919]: info: Loading plugin "appearance"... May 01 08:13:31 volumiopi-ii nmbd[662]: [2024/05/01 08:13:31.024212, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 01 08:13:31 volumiopi-ii nmbd[662]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 01 08:13:31 volumiopi-ii systemd[1]: Started Samba NMB Daemon. May 01 08:13:31 volumiopi-ii systemd[1]: Starting Samba Winbind Daemon... May 01 08:13:31 volumiopi-ii winbindd[949]: [2024/05/01 08:13:31.395795, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 01 08:13:31 volumiopi-ii winbindd[949]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 01 08:13:31 volumiopi-ii systemd[1]: Started Samba Winbind Daemon. May 01 08:13:31 volumiopi-ii winbindd[949]: [2024/05/01 08:13:31.884457, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 01 08:13:31 volumiopi-ii winbindd[949]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 01 08:13:31 volumiopi-ii systemd[1]: Starting Samba SMB Daemon... May 01 08:13:31 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:31] [connect] Successful connection May 01 08:13:34 volumiopi-ii systemd[1]: systemd-fsckd.service: Succeeded. May 01 08:13:34 volumiopi-ii systemd[1]: Started Samba SMB Daemon. May 01 08:13:34 volumiopi-ii systemd[1]: Reached target Multi-User System. May 01 08:13:34 volumiopi-ii systemd[1]: Reached target Graphical Interface. May 01 08:13:34 volumiopi-ii smbd[954]: [2024/05/01 08:13:34.912358, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 01 08:13:34 volumiopi-ii smbd[954]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 01 08:13:34 volumiopi-ii systemd[1]: Starting Update UTMP about System Runlevel Changes... May 01 08:13:35 volumiopi-ii systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 01 08:13:35 volumiopi-ii systemd[1]: Started Update UTMP about System Runlevel Changes. May 01 08:13:35 volumiopi-ii systemd[1]: Startup finished in 9.269s (kernel) + 38.712s (userspace) = 47.982s. May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "network"... May 01 08:13:35 volumiopi-ii volumio[919]: info: Refreshing Cached IP Addresses May 01 08:13:35 volumiopi-ii sudo[964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 08:13:35 volumiopi-ii sudo[964]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:35 volumiopi-ii sudo[964]: pam_unix(sudo:session): session closed for user root May 01 08:13:35 volumiopi-ii sudo[966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 08:13:35 volumiopi-ii sudo[966]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "services"... May 01 08:13:35 volumiopi-ii sudo[966]: pam_unix(sudo:session): session closed for user root May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "alsa_controller"... May 01 08:13:35 volumiopi-ii sudo[970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 01 08:13:35 volumiopi-ii sudo[970]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:35 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "wizard"... May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "networkfs"... May 01 08:13:35 volumiopi-ii volumio[919]: info: Starting Udev Watcher for removable devices May 01 08:13:35 volumiopi-ii sudo[977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=VolumioPi,password=@VolumioPi2001!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.250/DJ Cracka (L.BOUGIE)/DJ Cracka/All Music/ /mnt/NAS/Cracka\'s_NAS May 01 08:13:35 volumiopi-ii sudo[977]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:35 volumiopi-ii volumio[919]: info: Ignoring mount for partition: boot May 01 08:13:35 volumiopi-ii volumio[919]: info: Ignoring mount for partition: volumio May 01 08:13:35 volumiopi-ii volumio[919]: info: Ignoring mount for partition: volumio_data May 01 08:13:35 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "volumio_command_line_client"... May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "upnp"... May 01 08:13:35 volumiopi-ii volumio[919]: info: [1714565615305] Starting Upmpd Daemon May 01 08:13:35 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "my_music"... May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "mpd"... May 01 08:13:35 volumiopi-ii kernel: Key type cifs.spnego registered May 01 08:13:35 volumiopi-ii kernel: Key type cifs.idmap registered May 01 08:13:35 volumiopi-ii 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. May 01 08:13:35 volumiopi-ii kernel: CIFS: Attempting to mount \\192.168.10.250\DJ Cracka (L.BOUGIE) May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "upnp_browser"... May 01 08:13:35 volumiopi-ii volumio[919]: info: Loading plugin "alarm-clock"... May 01 08:13:36 volumiopi-ii volumio[919]: info: Loading plugin "airplay_emulation"... May 01 08:13:36 volumiopi-ii volumio[919]: info: Starting Shairport Sync May 01 08:13:36 volumiopi-ii volumio[919]: info: Loading plugin "last_100"... May 01 08:13:36 volumiopi-ii volumio[919]: info: Loading plugin "webradio"... May 01 08:13:36 volumiopi-ii volumio[919]: info: Loading plugin "i2s_dacs"... May 01 08:13:36 volumiopi-ii volumio[919]: info: Loading plugin "volumiodiscovery"... May 01 08:13:36 volumiopi-ii volumio[919]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 08:13:36 volumiopi-ii node[919]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 08:13:36 volumiopi-ii node[919]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 08:13:36 volumiopi-ii volumio[919]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 08:13:36 volumiopi-ii volumio[919]: *** WARNING *** For more information see May 01 08:13:36 volumiopi-ii volumio[919]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 08:13:36 volumiopi-ii volumio[919]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 08:13:36 volumiopi-ii volumio[919]: *** WARNING *** For more information see May 01 08:13:36 volumiopi-ii node[919]: *** WARNING *** For more information see May 01 08:13:36 volumiopi-ii node[919]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 08:13:36 volumiopi-ii node[919]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 08:13:36 volumiopi-ii node[919]: *** WARNING *** For more information see May 01 08:13:36 volumiopi-ii volumio[919]: info: Applying required configuration parameters for plugin volumiodiscovery May 01 08:13:36 volumiopi-ii volumio[919]: info: Discovery: Started advertising with name: VolumioPi-II May 01 08:13:36 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 08:13:36 volumiopi-ii volumio[919]: info: Loading plugin "bandcamp"... May 01 08:13:36 volumiopi-ii sudo[977]: pam_unix(sudo:session): session closed for user root May 01 08:13:37 volumiopi-ii volumio[919]: info: Loading plugin "mixcloud"... May 01 08:13:38 volumiopi-ii sh[457]: timed out May 01 08:13:38 volumiopi-ii dhcpcd[502]: timed out May 01 08:13:38 volumiopi-ii sh[457]: dhcpcd exited May 01 08:13:38 volumiopi-ii dhcpcd[502]: dhcpcd exited May 01 08:13:38 volumiopi-ii sh[457]: ifup: failed to bring up eth0 May 01 08:13:38 volumiopi-ii systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE May 01 08:13:38 volumiopi-ii systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. May 01 08:13:38 volumiopi-ii volumio[919]: info: Loading plugin "soundcloud"... May 01 08:13:38 volumiopi-ii volumio[919]: info: Loading plugin "spop"... May 01 08:13:39 volumiopi-ii sudo[970]: pam_unix(sudo:session): session closed for user root May 01 08:13:40 volumiopi-ii volumio[919]: info: Loading plugin "youtube2"... May 01 08:13:40 volumiopi-ii systemd[1]: systemd-hostnamed.service: Succeeded. May 01 08:13:41 volumiopi-ii volumio[919]: info: Loading plugin "ytmusic"... May 01 08:13:42 volumiopi-ii volumio[919]: info: Loading plugin "autostart"... May 01 08:13:42 volumiopi-ii volumio[919]: info: Applying required configuration parameters for plugin autostart May 01 08:13:42 volumiopi-ii volumio[919]: info: AutoStart - onVolumioStart - read config.json May 01 08:13:42 volumiopi-ii volumio[919]: info: Loading plugin "gpio-buttons"... May 01 08:13:45 volumiopi-ii volumio[919]: info: GPIO-Buttons initialized May 01 08:13:45 volumiopi-ii volumio[919]: info: Loading plugin "now_playing"... May 01 08:13:46 volumiopi-ii volumio[919]: info: Loading plugin "outputs"... May 01 08:13:46 volumiopi-ii volumio[919]: info: Loading plugin "albumart"... May 01 08:13:46 volumiopi-ii volumio[919]: info: Plugin example_plugin is not enabled May 01 08:13:46 volumiopi-ii volumio[919]: info: Loading plugin "inputs"... May 01 08:13:46 volumiopi-ii volumio[919]: info: Loading plugin "updater_comm"... May 01 08:13:46 volumiopi-ii volumio[919]: info: Plugin mpdemulation is not enabled May 01 08:13:46 volumiopi-ii volumio[919]: info: Loading plugin "rest_api"... May 01 08:13:46 volumiopi-ii volumio[919]: info: Loading plugin "websocket"... May 01 08:13:46 volumiopi-ii volumio[919]: info: Loading plugin "pandora"... May 01 08:13:46 volumiopi-ii volumio[919]: Forking 3 albumart workers May 01 08:13:46 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:13:46] [connect] Successful connection May 01 08:13:47 volumiopi-ii volumio[919]: Starting albumart workers May 01 08:13:47 volumiopi-ii volumio[919]: Starting albumart workers May 01 08:13:47 volumiopi-ii volumio[919]: Starting albumart workers May 01 08:13:49 volumiopi-ii volumio[919]: info: Applying required configuration parameters for plugin pandora May 01 08:13:49 volumiopi-ii volumio[919]: info: Loading plugin "backup_restore"... May 01 08:13:49 volumiopi-ii volumio[919]: info: Applying required configuration parameters for plugin backup_restore May 01 08:13:49 volumiopi-ii volumio[919]: info: Loading plugin "gpio_control"... May 01 08:13:50 volumiopi-ii volumio[919]: info: Applying required configuration parameters for plugin gpio_control May 01 08:13:50 volumiopi-ii volumio[919]: info: [GPIO_Control] Detected Raspberry Pi 4 Model B Rev 1.5 May 01 08:13:50 volumiopi-ii volumio[919]: info: [GPIO_Control] 40 GPIOs: true May 01 08:13:50 volumiopi-ii volumio[919]: info: [GPIO_Control] Initialized May 01 08:13:50 volumiopi-ii volumio[919]: info: Loading plugin "ir_controller"... May 01 08:13:50 volumiopi-ii volumio[919]: info: Applying required configuration parameters for plugin ir_controller May 01 08:13:50 volumiopi-ii volumio[919]: info: Plugin mpd_oled is not enabled May 01 08:13:50 volumiopi-ii volumio[919]: info: Loading plugin "music_services_shield"... May 01 08:13:50 volumiopi-ii volumio[919]: info: Applying required configuration parameters for plugin music_services_shield May 01 08:13:50 volumiopi-ii volumio[919]: info: Loading plugin "Systeminfo"... May 01 08:13:51 volumiopi-ii volumio[919]: info: Loading plugin "randomizer"... May 01 08:13:51 volumiopi-ii volumio[919]: info: Applying required configuration parameters for plugin randomizer May 01 08:13:51 volumiopi-ii volumio[919]: info: Loading i18n strings for locale en May 01 08:13:51 volumiopi-ii volumio[919]: Updating browse sources language May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::initPlayerControls May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 08:13:51 volumiopi-ii volumio[919]: Express server listening on port 3000 May 01 08:13:51 volumiopi-ii volumio[919]: [Metrics] WebUI: 22s 716.18ms May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreStateMachine::resetVolumioState May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreStateMachine::getcurrentVolume May 01 08:13:51 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioRetrievevolume May 01 08:13:52 volumiopi-ii sudo[1070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 08:13:52 volumiopi-ii sudo[1070]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:52 volumiopi-ii sudo[1070]: pam_unix(sudo:session): session closed for user root May 01 08:13:52 volumiopi-ii sudo[1073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 08:13:52 volumiopi-ii sudo[1073]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:52 volumiopi-ii sudo[1073]: pam_unix(sudo:session): session closed for user root May 01 08:13:52 volumiopi-ii volumio[919]: verbose: New Socket.io Connection to 192.168.10.99 from 192.168.10.29 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/111.0.0.0 Safari/537.36 Total Clients: 1 May 01 08:13:52 volumiopi-ii volumio[919]: verbose: New Socket.io Connection to 192.168.10.99 from 192.168.10.29 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/111.0.0.0 Safari/537.36 Total Clients: 2 May 01 08:13:52 volumiopi-ii volumio[919]: verbose: New Socket.io Connection to 192.168.10.99 from 192.168.10.29 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/111.0.0.0 Safari/537.36 Total Clients: 3 May 01 08:13:52 volumiopi-ii volumio[919]: verbose: New Socket.io Connection to 192.168.10.99 from 192.168.10.29 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/111.0.0.0 Safari/537.36 Total Clients: 4 May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioGetState May 01 08:13:52 volumiopi-ii volumio[919]: info: CorePlayQueue::getTrack 0 May 01 08:13:52 volumiopi-ii volumio[919]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 May 01 08:13:52 volumiopi-ii volumio[919]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 May 01 08:13:52 volumiopi-ii volumio[919]: info: VolumeController:: Volume=5 Mute =false May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreStateMachine::pushState May 01 08:13:52 volumiopi-ii volumio[919]: info: CorePlayQueue::getTrack 0 May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioPushState May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreStateMachine::updateTrackBlock May 01 08:13:52 volumiopi-ii volumio[919]: info: CorePlayQueue::getTrackBlock May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioRetrievevolume May 01 08:13:52 volumiopi-ii volumio[919]: info: Reloading queue from file May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreStateMachine::setRepeat null single undefined May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreStateMachine::pushState May 01 08:13:52 volumiopi-ii volumio[919]: info: CorePlayQueue::getTrack 0 May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioPushState May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreStateMachine::setRandom null May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreStateMachine::pushState May 01 08:13:52 volumiopi-ii volumio[919]: info: CorePlayQueue::getTrack 0 May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioPushState May 01 08:13:52 volumiopi-ii volumio[919]: info: Setting Device type: Raspberry PI May 01 08:13:52 volumiopi-ii volumio[919]: info: Listing playlists May 01 08:13:52 volumiopi-ii volumio[919]: info: Listing playlists May 01 08:13:52 volumiopi-ii sudo[1085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 01 08:13:52 volumiopi-ii sudo[1085]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 08:13:52 volumiopi-ii volumio[919]: info: VolumeController:: Volume=5 Mute =false May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreStateMachine::pushState May 01 08:13:52 volumiopi-ii volumio[919]: info: CorePlayQueue::getTrack 0 May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioPushState May 01 08:13:52 volumiopi-ii volumio[919]: info: Discovery: adding b7fdc3f0-f30c-4081-bbe1-d704af7a9dce May 01 08:13:52 volumiopi-ii volumio[919]: info: Discovery: Found device VolumioPi-II May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioGetState May 01 08:13:52 volumiopi-ii volumio[919]: info: CorePlayQueue::getTrack 0 May 01 08:13:52 volumiopi-ii sudo[1085]: pam_unix(sudo:session): session closed for user root May 01 08:13:52 volumiopi-ii systemd[1]: Started UPnP Renderer front-end to MPD. May 01 08:13:52 volumiopi-ii volumio[919]: info: Upmpdcli Daemon Started May 01 08:13:52 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioGetState May 01 08:13:52 volumiopi-ii volumio[919]: info: CorePlayQueue::getTrack 0 May 01 08:13:52 volumiopi-ii volumio[919]: info: Discovery: adding bc441d82-3efb-4d78-be4a-a5b997831dfc May 01 08:13:52 volumiopi-ii volumio[919]: info: Discovery: Found device VolumioPi May 01 08:13:52 volumiopi-ii volumio[919]: info: Discovery: Connecting to remote: 192.168.10.100 May 01 08:13:52 volumiopi-ii volumio[919]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 01 08:13:56 volumiopi-ii volumio[919]: info: Discovery: Connected to remote: 192.168.10.100 May 01 08:13:56 volumiopi-ii volumio[919]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 01 08:13:56 volumiopi-ii volumio[919]: verbose: New Socket.io Connection to 192.168.10.99 from 192.168.10.29 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/111.0.0.0 Safari/537.36 Total Clients: 7 May 01 08:13:56 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioGetState May 01 08:13:56 volumiopi-ii volumio[919]: info: CorePlayQueue::getTrack 0 May 01 08:13:56 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 08:13:56 volumiopi-ii volumio[919]: info: Listing playlists May 01 08:13:56 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioGetVisibleSources May 01 08:13:56 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 08:13:56 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioGetQueue May 01 08:13:56 volumiopi-ii volumio[919]: info: CoreStateMachine::getQueue May 01 08:13:56 volumiopi-ii volumio[919]: info: CorePlayQueue::getQueue May 01 08:14:01 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:14:01] [connect] Successful connection May 01 08:14:01 volumiopi-ii volumio-remote-updater[545]: [2024-05-01 08:14:01] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714565641 101 May 01 08:14:01 volumiopi-ii volumio[919]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 8 May 01 08:14:02 volumiopi-ii volumio[919]: info: CoreCommandRouter::volumioGetState May 01 08:14:02 volumiopi-ii volumio[919]: info: CorePlayQueue::getTrack 0 May 01 08:14:02 volumiopi-ii volumio[919]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 01 08:14:09 volumiopi-ii volumio[919]: Searching plugin music_service/webradio May 01 08:14:09 volumiopi-ii volumio[919]: info: CoreCommandRouter::executeOnPlugin: webradio , search May 01 08:14:09 volumiopi-ii volumio[919]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 08:14:09 volumiopi-ii volumio[919]: TypeError: Cannot read property 'search' of undefined May 01 08:14:09 volumiopi-ii volumio[919]: at ControllerWebradio.searchWithTuneIn (/volumio/app/plugins/music_service/webradio/index.js:1018:34) May 01 08:14:09 volumiopi-ii volumio[919]: at ControllerWebradio.search (/volumio/app/plugins/music_service/webradio/index.js:871:26) May 01 08:14:09 volumiopi-ii volumio[919]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) May 01 08:14:09 volumiopi-ii volumio[919]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:477:37) May 01 08:14:09 volumiopi-ii volumio[919]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:457:44) May 01 08:14:09 volumiopi-ii volumio[919]: at Socket.emit (events.js:315:20) May 01 08:14:09 volumiopi-ii volumio[919]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 01 08:14:09 volumiopi-ii volumio[919]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 01 08:14:09 volumiopi-ii volumio[919]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 08:14:10 volumiopi-ii sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 08:13 May 01 08:14:10 volumiopi-ii sudo[1132]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"