-- 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"