-- Logs begin at Tue 2025-06-10 18:04:43 CST, end at Tue 2025-06-10 18:06:45 CST. --
Jun 10 18:05:00 volumio wireless.js[772]: trying...
Jun 10 18:05:00 volumio sudo[1058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jun 10 18:05:00 volumio sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:00 volumio sudo[1058]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:00 volumio kernel: usb 1-3.3: new full-speed USB device number 5 using xhci_hcd
Jun 10 18:05:00 volumio kernel: usb 1-3.3: New USB device found, idVendor=222a, idProduct=0001, bcdDevice= 1.00
Jun 10 18:05:00 volumio kernel: usb 1-3.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jun 10 18:05:00 volumio kernel: usb 1-3.3: Product: SingWon-CTP-V1.18B
Jun 10 18:05:00 volumio kernel: usb 1-3.3: Manufacturer: UsbHID
Jun 10 18:05:00 volumio kernel: usb 1-3.3: SerialNumber: 6F6A099B1133
Jun 10 18:05:00 volumio kernel: input: UsbHID SingWon-CTP-V1.18B as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.3/1-3.3:1.0/0003:222A:0001.0001/input/input4
Jun 10 18:05:00 volumio kernel: hid-generic 0003:222A:0001.0001: input,hidraw0: USB HID v1.11 Device [UsbHID SingWon-CTP-V1.18B] on usb-0000:00:14.0-3.3/input0
Jun 10 18:05:00 volumio kernel: input: UsbHID SingWon-CTP-V1.18B as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.3/1-3.3:1.1/0003:222A:0001.0002/input/input5
Jun 10 18:05:00 volumio kernel: hid-generic 0003:222A:0001.0002: input,hidraw1: USB HID v1.12 Keyboard [UsbHID SingWon-CTP-V1.18B] on usb-0000:00:14.0-3.3/input1
Jun 10 18:05:00 volumio kernel: usbcore: registered new interface driver usbkbd
Jun 10 18:05:00 volumio kernel: usbcore: registered new interface driver usbmouse
Jun 10 18:05:00 volumio kernel: input: UsbHID SingWon-CTP-V1.18B as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.3/1-3.3:1.0/0003:222A:0001.0001/input/input6
Jun 10 18:05:00 volumio kernel: hid-multitouch 0003:222A:0001.0001: input,hidraw0: USB HID v1.11 Device [UsbHID SingWon-CTP-V1.18B] on usb-0000:00:14.0-3.3/input0
Jun 10 18:05:00 volumio systemd-udevd[1065]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 10 18:05:00 volumio systemd-logind[766]: Watching system buttons on /dev/input/event5 (UsbHID SingWon-CTP-V1.18B)
Jun 10 18:05:01 volumio systemd-udevd[1065]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 10 18:05:01 volumio systemd-udevd[1064]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Jun 10 18:05:01 volumio wireless.js[772]: trying...
Jun 10 18:05:01 volumio sudo[1075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jun 10 18:05:01 volumio sudo[1075]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:01 volumio sudo[1075]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:02 volumio volumio-time-update[774]: volumio-time-update-util: Fetching time from Volumio...
Jun 10 18:05:02 volumio volumio-time-update[774]: volumio-time-update-util: Date not found in response
Jun 10 18:05:02 volumio volumio-time-update[774]: volumio-time-update-util: Retrying in 5 seconds...
Jun 10 18:05:02 volumio dhcpcd[830]: wlan0: using static address 192.168.3.123/24
Jun 10 18:05:02 volumio avahi-daemon[759]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.123.
Jun 10 18:05:02 volumio wireless.js[772]: trying...
Jun 10 18:05:02 volumio dhcpcd[830]: wlan0: adding route to 192.168.3.0/24
Jun 10 18:05:02 volumio avahi-daemon[759]: New relevant interface wlan0.IPv4 for mDNS.
Jun 10 18:05:02 volumio dhcpcd[830]: wlan0: adding default route via 192.168.3.1
Jun 10 18:05:02 volumio avahi-daemon[759]: Registering new address record for 192.168.3.123 on wlan0.IPv4.
Jun 10 18:05:02 volumio sudo[1084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jun 10 18:05:02 volumio sudo[1084]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:02 volumio sudo[1084]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:02 volumio wireless.js[772]: Connected to: ----HUAWEI-040L9B-ZJJ_5G
Jun 10 18:05:02 volumio wireless.js[772]: ----
Jun 10 18:05:02 volumio sudo[1099]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 10 18:05:02 volumio sudo[1099]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:02 volumio sudo[1099]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:02 volumio wireless.js[772]: ... joined AP, wlan0 IPv4 is 192.168.3.123, ipV6 is undefined
Jun 10 18:05:02 volumio wireless.js[772]: It's done! AP
Jun 10 18:05:02 volumio systemd[1]: Started Wireless Services.
Jun 10 18:05:02 volumio systemd[1]: Started Volumio Backend Module.
Jun 10 18:05:02 volumio systemd[1]: Started Intel SST and HDA soundcard init service.
Jun 10 18:05:02 volumio systemd[1]: Started Start Volumio Kiosk.
Jun 10 18:05:02 volumio systemd[1]: Started Volumio Cpu Tweaker.
Jun 10 18:05:02 volumio volumio-cpu-tweak[1113]: Setting RT Priority for mpd
Jun 10 18:05:02 volumio volumio-cpu-tweak[1113]: Setting MPD Affinity
Jun 10 18:05:02 volumio volumio-cpu-tweak[1113]: pid 974's current affinity mask: f
Jun 10 18:05:02 volumio volumio-cpu-tweak[1113]: pid 974's new affinity mask: 3
Jun 10 18:05:02 volumio volumio-cpu-tweak[1113]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Jun 10 18:05:02 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded.
Jun 10 18:05:02 volumio startx[1111]: X.Org X Server 1.20.4
Jun 10 18:05:02 volumio startx[1111]: X Protocol Version 11, Revision 0
Jun 10 18:05:02 volumio startx[1111]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian
Jun 10 18:05:02 volumio startx[1111]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64
Jun 10 18:05:02 volumio startx[1111]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=c9dc0ff7-9f12-407d-b73b-c0acff562c46 bootpart=UUID=9E04-BB0F datapart=UUID=874c43f3-ff55-470f-8154-f337435b4463 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=vendor net.ifnames=0 use_kmsg=no
Jun 10 18:05:02 volumio startx[1111]: Build Date: 18 December 2021 09:05:36AM
Jun 10 18:05:02 volumio startx[1111]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support)
Jun 10 18:05:02 volumio startx[1111]: Current version of pixman: 0.36.0
Jun 10 18:05:02 volumio startx[1111]: Before reporting problems, check http://wiki.x.org
Jun 10 18:05:02 volumio startx[1111]: to make sure that you have the latest version.
Jun 10 18:05:02 volumio startx[1111]: Markers: (--) probed, (**) from config file, (==) default setting,
Jun 10 18:05:02 volumio startx[1111]: (++) from command line, (!!) notice, (II) informational,
Jun 10 18:05:02 volumio startx[1111]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Jun 10 18:05:02 volumio startx[1111]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Jun 10 18:05:02 2025
Jun 10 18:05:02 volumio startx[1111]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Jun 10 18:05:03 volumio kernel: broken atomic modeset userspace detected, disabling atomic
Jun 10 18:05:03 volumio nmbd[956]: [2025/06/10 18:05:03.395002, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Jun 10 18:05:03 volumio systemd[1]: Started Samba NMB Daemon.
Jun 10 18:05:03 volumio nmbd[956]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Jun 10 18:05:03 volumio systemd[1]: Starting Samba Winbind Daemon...
Jun 10 18:05:03 volumio systemd[1]: soundcard-init.service: Succeeded.
Jun 10 18:05:03 volumio winbindd[1228]: [2025/06/10 18:05:03.668012, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Jun 10 18:05:03 volumio winbindd[1228]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Jun 10 18:05:03 volumio ntpd[969]: Listen normally on 3 wlan0 192.168.3.123:123
Jun 10 18:05:03 volumio ntpd[969]: new interface(s) found: waking up resolver
Jun 10 18:05:03 volumio systemd[1]: Started Samba Winbind Daemon.
Jun 10 18:05:03 volumio winbindd[1228]: [2025/06/10 18:05:03.693546, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Jun 10 18:05:03 volumio winbindd[1228]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Jun 10 18:05:03 volumio systemd[1]: Starting Samba SMB Daemon...
Jun 10 18:05:03 volumio startx[1111]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc.
Jun 10 18:05:04 volumio smbd[1266]: [2025/06/10 18:05:04.151674, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Jun 10 18:05:04 volumio systemd[1]: Started Samba SMB Daemon.
Jun 10 18:05:04 volumio smbd[1266]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Jun 10 18:05:04 volumio volumio[1109]: info: -------------------------------------------
Jun 10 18:05:04 volumio volumio[1109]: info: ----- Volumio3 ----
Jun 10 18:05:04 volumio volumio[1109]: info: -------------------------------------------
Jun 10 18:05:04 volumio volumio[1109]: info: ----- System startup ----
Jun 10 18:05:04 volumio volumio[1109]: info: -------------------------------------------
Jun 10 18:05:05 volumio sudo[1325]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xrandr -d :0 -o right
Jun 10 18:05:05 volumio sudo[1325]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:05 volumio kernel: i915 0000:00:02.0: vgaarb: VGA decodes changed: olddecodes=io+mem,decodes=io+mem:owns=io+mem
Jun 10 18:05:05 volumio sudo[1325]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:05 volumio sudo[1328]: root : TTY=unknown ; PWD=/ ; USER=root ; ENV=DISPLAY=:0 ; COMMAND=/usr/bin/xinput set-prop SingWon-CTP-V1.18B Coordinate Transformation Matrix 0 1 0 -1 0 1 0 0 1
Jun 10 18:05:05 volumio sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:05 volumio sudo[1328]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:05 volumio volumio[1109]: info: MYVOLUMIO Environment detected
Jun 10 18:05:06 volumio volumio[1109]: info: Plugin folders cleanup
Jun 10 18:05:06 volumio volumio[1109]: info: Scanning into folder /volumio/app/plugins/
Jun 10 18:05:06 volumio volumio[1109]: info: Scanning category audio_interface
Jun 10 18:05:06 volumio volumio[1109]: info: Scanning category miscellanea
Jun 10 18:05:06 volumio volumio[1109]: info: Scanning category music_service
Jun 10 18:05:06 volumio volumio[1109]: info: Scanning category plugins.json
Jun 10 18:05:06 volumio volumio[1109]: info: Scanning category system_controller
Jun 10 18:05:06 volumio volumio[1109]: info: Scanning category user_interface
Jun 10 18:05:06 volumio volumio[1109]: info: Scanning into folder /data/plugins/
Jun 10 18:05:06 volumio volumio[1109]: info: Scanning category user_interface
Jun 10 18:05:06 volumio volumio[1109]: info: Plugin folders cleanup completed
Jun 10 18:05:06 volumio volumio[1109]: info: -------------------------------------------
Jun 10 18:05:06 volumio volumio[1109]: info: ----- Core plugins startup ----
Jun 10 18:05:06 volumio volumio[1109]: info: -------------------------------------------
Jun 10 18:05:06 volumio volumio[1109]: info: Loading plugins from folder /volumio/app/plugins/
Jun 10 18:05:06 volumio volumio[1109]: info: Adding plugin upnp to MyMusic Plugins
Jun 10 18:05:06 volumio volumio[1109]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 10 18:05:06 volumio volumio[1109]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 10 18:05:06 volumio volumio[1109]: info: Loading plugins from folder /data/plugins/
Jun 10 18:05:06 volumio volumio[1109]: info: Loading plugin "system"...
Jun 10 18:05:06 volumio volumio[1109]: info: Loading plugin "appearance"...
Jun 10 18:05:07 volumio volumio-time-update[774]: volumio-time-update-util: Fetching time from Volumio...
Jun 10 18:05:07 volumio volumio-time-update[774]: volumio-time-update-util: Setting system time to: 2025-06-10 18:05:08
Jun 10 18:05:07 volumio sudo[1360]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-06-10 18:05:08
Jun 10 18:05:07 volumio sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:07 volumio dbus-daemon[768]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.9' (uid=0 pid=1361 comm="timedatectl set-time 2025-06-10 18:05:08 ")
Jun 10 18:05:08 volumio systemd[1]: Starting Time & Date Service...
Jun 10 18:05:08 volumio dbus-daemon[768]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 10 18:05:08 volumio systemd[1]: Started Time & Date Service.
Jun 10 18:05:08 volumio systemd-timedated[1362]: Changed local time to Tue Jun 10 18:05:08 2025
Jun 10 18:05:08 volumio sudo[1360]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:08 volumio volumio-time-update[774]: volumio-time-update-util: System time updated successfully.
Jun 10 18:05:08 volumio systemd[1]: Started Volumio Time Update Utility.
Jun 10 18:05:08 volumio volumio[1109]: info: Loading plugin "network"...
Jun 10 18:05:08 volumio volumio[1109]: info: Refreshing Cached IP Addresses
Jun 10 18:05:08 volumio sudo[1365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 10 18:05:08 volumio sudo[1365]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:08 volumio sudo[1367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 10 18:05:08 volumio sudo[1367]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:08 volumio sudo[1367]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:08 volumio volumio[1109]: info: Loading plugin "services"...
Jun 10 18:05:08 volumio sudo[1365]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:08 volumio volumio[1109]: info: Loading plugin "alsa_controller"...
Jun 10 18:05:08 volumio sudo[1381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 10 18:05:08 volumio sudo[1381]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:08 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 10 18:05:08 volumio volumio[1109]: info: Loading plugin "wizard"...
Jun 10 18:05:08 volumio volumio[1109]: info: Loading plugin "networkfs"...
Jun 10 18:05:08 volumio volumio[1109]: info: Starting Udev Watcher for removable devices
Jun 10 18:05:08 volumio volumio[1109]: info: Mounting Device 3762-0A9A
Jun 10 18:05:08 volumio sudo[1401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/3762-0A9A -o noatime
Jun 10 18:05:08 volumio sudo[1401]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:09 volumio mount.exfat[1411]: volume was not unmounted cleanly
Jun 10 18:05:09 volumio sudo[1401]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:09 volumio volumio[1109]: WARN: volume was not unmounted cleanly.
Jun 10 18:05:09 volumio volumio[1109]: info: Ignoring mount for partition: boot
Jun 10 18:05:09 volumio volumio[1109]: info: Ignoring mount for partition: volumio
Jun 10 18:05:09 volumio volumio[1109]: info: Ignoring mount for partition: volumio_data
Jun 10 18:05:09 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 10 18:05:09 volumio volumio[1109]: info: Loading plugin "volumio_command_line_client"...
Jun 10 18:05:09 volumio volumio[1109]: info: Loading plugin "upnp"...
Jun 10 18:05:09 volumio volumio[1109]: info: [1749549909468] Starting Upmpd Daemon
Jun 10 18:05:09 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 10 18:05:09 volumio volumio[1109]: info: Loading plugin "my_music"...
Jun 10 18:05:09 volumio volumio[1109]: info: Loading plugin "mpd"...
Jun 10 18:05:09 volumio volumio-remote-updater[752]: [2025-06-10 18:05:09] [connect] Successful connection
Jun 10 18:05:10 volumio volumio[1109]: info: Plugin upnp_browser is not enabled
Jun 10 18:05:10 volumio volumio[1109]: info: Loading plugin "alarm-clock"...
Jun 10 18:05:10 volumio volumio[1109]: info: Loading plugin "airplay_emulation"...
Jun 10 18:05:10 volumio volumio[1109]: info: Starting Shairport Sync
Jun 10 18:05:10 volumio volumio[1109]: info: Loading plugin "last_100"...
Jun 10 18:05:10 volumio volumio[1109]: info: Loading plugin "webradio"...
Jun 10 18:05:10 volumio volumio[1109]: info: Loading plugin "i2s_dacs"...
Jun 10 18:05:10 volumio volumio[1109]: info: I2S DAC not set, start Auto-detection
Jun 10 18:05:10 volumio volumio[1109]: info: Loading plugin "volumiodiscovery"...
Jun 10 18:05:10 volumio volumio[1109]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 10 18:05:10 volumio volumio[1109]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 10 18:05:10 volumio volumio[1109]: *** WARNING *** For more information see
Jun 10 18:05:10 volumio node[1109]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 10 18:05:10 volumio volumio[1109]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 10 18:05:10 volumio volumio[1109]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 10 18:05:10 volumio volumio[1109]: *** WARNING *** For more information see
Jun 10 18:05:10 volumio node[1109]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 10 18:05:10 volumio node[1109]: *** WARNING *** For more information see
Jun 10 18:05:10 volumio node[1109]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 10 18:05:10 volumio node[1109]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 10 18:05:10 volumio node[1109]: *** WARNING *** For more information see
Jun 10 18:05:10 volumio volumio[1109]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 10 18:05:10 volumio volumio[1109]: info: Discovery: Started advertising with name: Volumio
Jun 10 18:05:10 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 10 18:05:10 volumio volumio[1109]: info: Loading plugin "peppy_screensaver"...
Jun 10 18:05:11 volumio volumio[1109]: info: Applying required configuration parameters for plugin peppy_screensaver
Jun 10 18:05:11 volumio volumio[1109]: info: Loading plugin "outputs"...
Jun 10 18:05:11 volumio volumio[1109]: info: Loading plugin "albumart"...
Jun 10 18:05:11 volumio volumio[1109]: info: Plugin example_plugin is not enabled
Jun 10 18:05:11 volumio volumio[1109]: info: Loading plugin "inputs"...
Jun 10 18:05:11 volumio volumio[1109]: info: Loading plugin "updater_comm"...
Jun 10 18:05:11 volumio volumio[1109]: Forking 3 albumart workers
Jun 10 18:05:11 volumio volumio[1109]: info: Plugin mpdemulation is not enabled
Jun 10 18:05:11 volumio volumio[1109]: info: Loading plugin "rest_api"...
Jun 10 18:05:11 volumio volumio[1109]: info: Loading plugin "websocket"...
Jun 10 18:05:11 volumio volumio[1109]: info: Starting Socket.io Server version 2.3.0
Jun 10 18:05:11 volumio volumio[1109]: info: Loading i18n strings for locale zh
Jun 10 18:05:11 volumio volumio[1109]: Updating browse sources language
Jun 10 18:05:11 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 10 18:05:11 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 10 18:05:11 volumio volumio[1109]: info: CoreCommandRouter::initPlayerControls
Jun 10 18:05:11 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 10 18:05:12 volumio volumio[1109]: Express server listening on port 3000
Jun 10 18:05:12 volumio volumio[1109]: [Metrics] WebUI: 8s 300.66ms
Jun 10 18:05:12 volumio volumio[1109]: info: Setting Device type: x86
Jun 10 18:05:12 volumio volumio[1109]: info: CoreStateMachine::resetVolumioState
Jun 10 18:05:12 volumio volumio[1109]: info: CoreStateMachine::getcurrentVolume
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::volumioRetrievevolume
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:12 volumio volumio[1109]: Starting albumart workers
Jun 10 18:05:12 volumio volumio[1109]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Jun 10 18:05:12 volumio volumio[1109]: info: Completed loading Core Plugins
Jun 10 18:05:12 volumio volumio[1109]: info: Preparing to generate the ALSA configuration file
Jun 10 18:05:12 volumio volumio[1109]: Starting albumart workers
Jun 10 18:05:12 volumio volumio[1109]: Starting albumart workers
Jun 10 18:05:12 volumio volumio[1109]: info: Volumio Network Manager: Network status updated: 2
Jun 10 18:05:12 volumio volumio[1109]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Jun 10 18:05:12 volumio volumio[1109]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Jun 10 18:05:12 volumio volumio[1109]: info: Reading ALSA contributions from plugins.
Jun 10 18:05:12 volumio volumio-remote-updater[752]: [2025-06-10 18:05:12] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749549909 101
Jun 10 18:05:12 volumio volumio[1109]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1
Jun 10 18:05:12 volumio volumio[1109]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Jun 10 18:05:12 volumio volumio[1109]: info: Scanning new location : "USB/3762-0A9A"
Jun 10 18:05:12 volumio volumio[1109]: info: Reloading queue from file
Jun 10 18:05:12 volumio volumio[1109]: info: VolumeController:: Volume=30 Mute =false
Jun 10 18:05:12 volumio volumio[1109]: info: CoreStateMachine::pushState
Jun 10 18:05:12 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::volumioPushState
Jun 10 18:05:12 volumio volumio[1109]: info: CoreStateMachine::updateTrackBlock
Jun 10 18:05:12 volumio volumio[1109]: info: CorePlayQueue::getTrackBlock
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::volumioRetrievevolume
Jun 10 18:05:12 volumio volumio[1109]: info: CoreStateMachine::setRepeat false single undefined
Jun 10 18:05:12 volumio volumio[1109]: info: CoreStateMachine::pushState
Jun 10 18:05:12 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::volumioPushState
Jun 10 18:05:12 volumio volumio[1109]: info: CoreStateMachine::setRandom false
Jun 10 18:05:12 volumio volumio[1109]: info: CoreStateMachine::pushState
Jun 10 18:05:12 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::volumioPushState
Jun 10 18:05:12 volumio volumio[1109]: info: VolumeController:: Volume=30 Mute =false
Jun 10 18:05:12 volumio volumio[1109]: info: CoreStateMachine::pushState
Jun 10 18:05:12 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::volumioPushState
Jun 10 18:05:12 volumio volumio[1109]: info: Asound.conf file unchanged, so no further update is needed
Jun 10 18:05:12 volumio volumio[1109]: info: Output device has changed, restarting MPD
Jun 10 18:05:12 volumio volumio[1109]: info: Output device has changed, restarting Shairport Sync
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:12 volumio sudo[1545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 10 18:05:12 volumio sudo[1545]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:12 volumio sudo[1545]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:12 volumio sudo[1553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 10 18:05:12 volumio sudo[1553]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:12 volumio systemd[1]: Stopping Music Player Daemon...
Jun 10 18:05:12 volumio volumio[1109]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 10 18:05:12 volumio volumio[1109]: info: ___________ START PLUGINS ___________
Jun 10 18:05:12 volumio volumio[1109]: info: ControllerMpd::onStart: Initializing MPD
Jun 10 18:05:12 volumio volumio[1109]: info: Creating MPD Configuration file
Jun 10 18:05:12 volumio sudo[1566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:12 volumio sudo[1566]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:12 volumio sudo[1569]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 10 18:05:12 volumio sudo[1569]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:12 volumio sudo[1566]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:12 volumio systemd[1]: mpd.service: Succeeded.
Jun 10 18:05:12 volumio systemd[1]: Stopped Music Player Daemon.
Jun 10 18:05:12 volumio volumio[1109]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:12 volumio systemd[1]: Starting Music Player Daemon...
Jun 10 18:05:12 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jun 10 18:05:12 volumio systemd[1]: mpd.service: Succeeded.
Jun 10 18:05:13 volumio systemd[1]: Stopped Music Player Daemon.
Jun 10 18:05:13 volumio systemd[1]: Starting Music Player Daemon...
Jun 10 18:05:13 volumio volumio[1109]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 10 18:05:13 volumio volumio[1109]: info: [1749549913020] CoreMusicLibrary::Adding element Last_100
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 10 18:05:13 volumio volumio[1109]: info: [1749549913025] CoreMusicLibrary::Adding element Webradio
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 10 18:05:13 volumio volumio[1109]: info: Initializing BBC Radios
Jun 10 18:05:13 volumio volumio[1109]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:13 volumio sudo[1578]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 10 18:05:13 volumio sudo[1578]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:13 volumio sudo[1578]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:13 volumio volumio[1109]: info: Loading i18n strings for locale zh
Jun 10 18:05:13 volumio sudo[1381]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:13 volumio volumio[1109]: info: /tmp/myfifo created
Jun 10 18:05:13 volumio volumio[1109]: info: /tmp/myfifosa created
Jun 10 18:05:13 volumio sudo[1596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0
Jun 10 18:05:13 volumio sudo[1596]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:13 volumio sudo[1596]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:13 volumio volumio[1109]: info: snd-dummy loaded
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 10 18:05:13 volumio sudo[1619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/shairport-sync.conf.tmpl /volumio/app/plugins/music_service/airplay_emulation/shairport-sync.conf.tmpl
Jun 10 18:05:13 volumio sudo[1619]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:13 volumio sudo[1619]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:13 volumio volumio[1109]: info: Volumio Calling Home
Jun 10 18:05:13 volumio volumio[1109]: info: MPD Permissions set
Jun 10 18:05:13 volumio volumio[1109]: info: MPD Permissions set
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:13 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:13 volumio volumio[1109]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:13 volumio volumio[1109]: info: Starting Shairport Sync
Jun 10 18:05:13 volumio volumio[1109]: info: Starting Shairport Sync
Jun 10 18:05:13 volumio sudo[1640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl
Jun 10 18:05:13 volumio sudo[1640]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:13 volumio sudo[1642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 10 18:05:13 volumio sudo[1642]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:13 volumio volumio[1109]: info: Starting Shairport Sync
Jun 10 18:05:13 volumio sudo[1640]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:13 volumio sudo[1645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 10 18:05:13 volumio sudo[1645]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:13 volumio volumio[1109]: info: Starting Shairport Sync
Jun 10 18:05:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 10 18:05:13 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 10 18:05:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 10 18:05:13 volumio sudo[1649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 10 18:05:13 volumio sudo[1649]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:13 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:13 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:13 volumio sudo[1651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 10 18:05:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 10 18:05:13 volumio sudo[1642]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:14 volumio sudo[1651]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 10 18:05:14 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jun 10 18:05:14 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 10 18:05:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 10 18:05:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 10 18:05:14 volumio sudo[1645]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:14 volumio sudo[1649]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile
Jun 10 18:05:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 10 18:05:14 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jun 10 18:05:14 volumio systemd[1]: shairport-sync.service: Succeeded.
Jun 10 18:05:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 10 18:05:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 10 18:05:14 volumio sudo[1651]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:14 volumio volumio[1109]: info: Shairport-Sync Started
Jun 10 18:05:14 volumio sudo[1658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 10 18:05:14 volumio sudo[1658]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:14 volumio volumio[1109]: Error adding Membership: Error: addMembership EINVAL
Jun 10 18:05:14 volumio volumio[1109]: info: Shairport-Sync Started
Jun 10 18:05:14 volumio volumio[1109]: info: Shairport-Sync Started
Jun 10 18:05:14 volumio volumio[1109]: info: Shairport-Sync Started
Jun 10 18:05:14 volumio sudo[1658]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:14 volumio volumio[1109]: info: MPD Permissions set
Jun 10 18:05:14 volumio volumio[1109]: info: Volumio called home
Jun 10 18:05:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jun 10 18:05:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:14 volumio mpd[1590]: Jun 10 18:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 10 18:05:14 volumio systemd[1]: Started Music Player Daemon.
Jun 10 18:05:14 volumio sudo[1553]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:14 volumio sudo[1569]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:14 volumio volumio[1109]: info: Completed starting Core Plugins
Jun 10 18:05:14 volumio volumio[1109]: info: -------------------------------------------
Jun 10 18:05:14 volumio volumio[1109]: info: ----- MyVolumio plugins startup ----
Jun 10 18:05:14 volumio volumio[1109]: info: -------------------------------------------
Jun 10 18:05:14 volumio volumio[1109]: info: [MyVolumio PluginManager] Fetching plans data....
Jun 10 18:05:14 volumio volumio[1109]: error: MPD error: The expression evaluated to a falsy value:
Jun 10 18:05:14 volumio volumio[1109]: assert.ok(self.idling)
Jun 10 18:05:14 volumio volumio[1109]: error: The expression evaluated to a falsy value:
Jun 10 18:05:14 volumio volumio[1109]: assert.ok(self.idling)
Jun 10 18:05:14 volumio volumio[1109]: info: MPD running with PID1590
Jun 10 18:05:14 volumio volumio[1109]: ,establishing connection
Jun 10 18:05:14 volumio volumio[1109]: error: updateQueue error: null
Jun 10 18:05:14 volumio volumio[1109]: error: updateQueue error: null
Jun 10 18:05:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd
Jun 10 18:05:14 volumio sudo[1673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 10 18:05:14 volumio sudo[1673]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:14 volumio systemd[1]: Stopping Music Player Daemon...
Jun 10 18:05:14 volumio systemd[1]: mpd.service: Succeeded.
Jun 10 18:05:14 volumio systemd[1]: Stopped Music Player Daemon.
Jun 10 18:05:14 volumio systemd[1]: Starting Music Player Daemon...
Jun 10 18:05:14 volumio sudo[1675]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 10 18:05:14 volumio sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:14 volumio sudo[1675]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:15 volumio volumio[1109]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Jun 10 18:05:15 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Jun 10 18:05:15 volumio mpd[1677]: Jun 10 18:05 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 10 18:05:15 volumio systemd[1]: Started Music Player Daemon.
Jun 10 18:05:15 volumio sudo[1673]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:15 volumio volumio[1109]: error: updateQueue error: null
Jun 10 18:05:16 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 10 18:05:17 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Jun 10 18:05:17 volumio volumio[1109]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jun 10 18:05:19 volumio sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 10 18:05:19 volumio sudo[1699]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:19 volumio sudo[1701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 10 18:05:19 volumio sudo[1701]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:19 volumio sudo[1699]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:19 volumio sudo[1701]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:19 volumio sudo[1707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jun 10 18:05:19 volumio sudo[1707]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:19 volumio volumio[1109]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Jun 10 18:05:19 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 10 18:05:19 volumio sudo[1707]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:19 volumio volumio[1109]: info: Upmpdcli Daemon Started
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:19 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 10 18:05:19 volumio volumio[1109]: info: Received Get System Info
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 10 18:05:19 volumio volumio[1109]: info: Discovery: Getting this device information
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:19 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:19 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:19 volumio volumio[1109]: info: Listing playlists
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 10 18:05:19 volumio volumio[1109]: info: Received Get System Info
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 10 18:05:19 volumio volumio[1109]: info: Discovery: Getting this device information
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:19 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:19 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 10 18:05:19 volumio volumio[1109]: info: Received Get System Info
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 10 18:05:19 volumio volumio[1109]: info: Discovery: Getting this device information
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:19 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 18:05:19 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:19 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:19 volumio volumio[1109]: info: Listing playlists
Jun 10 18:05:19 volumio volumio[1709]: Generating RSA private key, 4096 bit long modulus (2 primes)
Jun 10 18:05:20 volumio volumio[1109]: info: Discovery: adding a4a38f5c-3c06-4b6c-addf-1f4213f4058a
Jun 10 18:05:20 volumio volumio[1109]: info: Discovery: Found device Volumio
Jun 10 18:05:20 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:20 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:21 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Jun 10 18:05:21 volumio volumio[1709]: .........................................................++++
Jun 10 18:05:21 volumio volumio[1709]: ..++++
Jun 10 18:05:21 volumio volumio[1709]: e is 65537 (0x010001)
Jun 10 18:05:21 volumio volumio[1709]: writing RSA key
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Jun 10 18:05:23 volumio volumio[1109]: info: Adding plugin bluetooth to MyMusic Plugins
Jun 10 18:05:23 volumio volumio[1109]: info: Adding plugin multiroom to MyMusic Plugins
Jun 10 18:05:23 volumio volumio[1109]: info: Adding plugin metavolumio to MyMusic Plugins
Jun 10 18:05:23 volumio volumio[1109]: info: Adding plugin cd_controller to MyMusic Plugins
Jun 10 18:05:23 volumio volumio[1109]: info: Adding plugin qobuzconnect to MyMusic Plugins
Jun 10 18:05:23 volumio volumio[1109]: info: Adding plugin smart_inputs to MyMusic Plugins
Jun 10 18:05:23 volumio volumio[1109]: info: Adding plugin tidalconnect to MyMusic Plugins
Jun 10 18:05:23 volumio volumio[1109]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Jun 10 18:05:24 volumio volumio[1109]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Jun 10 18:05:24 volumio volumio[1109]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Jun 10 18:05:24 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:24 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:24 volumio volumio[1109]: info: Starting MyVolumio Remote Streaming Endpoints
Jun 10 18:05:24 volumio volumio[1109]: info: MyVolumio not started
Jun 10 18:05:24 volumio volumio[1109]: info: Initializing device activation check
Jun 10 18:05:24 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:24 volumio volumio[1109]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Jun 10 18:05:24 volumio volumio[1109]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Jun 10 18:05:25 volumio volumio[1109]: info: Starting Streaming Service Transparent Proxy
Jun 10 18:05:25 volumio volumio[1109]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Jun 10 18:05:25 volumio volumio[1109]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Jun 10 18:05:25 volumio volumio[1109]: info: Streaming services startup
Jun 10 18:05:25 volumio volumio[1109]: info: Starting Streaming Daemon
Jun 10 18:05:25 volumio sudo[1923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jun 10 18:05:25 volumio sudo[1923]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:25 volumio sudo[1923]: pam_unix(sudo:session): session closed for user root
Jun 10 18:05:25 volumio volumio[1109]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Jun 10 18:05:25 volumio volumio[1109]: error: Cannot start Volumio Streaming Daemon
Jun 10 18:05:25 volumio volumio[1109]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jun 10 18:05:25 volumio volumio[1109]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jun 10 18:05:26 volumio volumio[1109]: STREAMING PROXY: Starting server on port 3245
Jun 10 18:05:26 volumio volumio[1109]: Node JS runtime: 14
Jun 10 18:05:27 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Jun 10 18:05:38 volumio systemd[1]: systemd-timedated.service: Succeeded.
Jun 10 18:05:39 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jun 10 18:05:39 volumio volumio[1109]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 10 18:05:39 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:39 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:43 volumio volumio[1109]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Jun 10 18:05:43 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:43 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 10 18:05:43 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:43 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 10 18:05:43 volumio volumio-remote-updater[752]: Test mode enabled
Jun 10 18:05:43 volumio volumio-remote-updater[752]: No alpha test mode
Jun 10 18:05:43 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jun 10 18:05:44 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:44 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:44 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Jun 10 18:05:44 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jun 10 18:05:44 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jun 10 18:05:44 volumio volumio[1109]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 10 18:05:44 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 10 18:05:44 volumio volumio[1109]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Various Fixes for QOBUZ Connect
\n- Various Fixes for Tidal Connect
\n
\nNEW ADDITIONS
\n\n- Add driver for RTL8153B on Primo2, Rivo and Rivo Plus
\n
\n","title":"Update v3.815","updateavailable":true}
Jun 10 18:05:44 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jun 10 18:05:44 volumio volumio[1109]: verbose: New Socket.io Connection to 192.168.3.123 from 192.168.3.35 UA: Mozilla/5.0 (Linux; Android 10; WLZ-AN00 Build/HUAWEIWLZ-AN00; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/114.0.5735.196 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Jun 10 18:05:45 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 10 18:05:45 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jun 10 18:05:45 volumio volumio[1109]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Jun 10 18:05:45 volumio volumio[1109]: info: Completed starting MyVolumio Plugin
Jun 10 18:05:45 volumio volumio[1109]: [Metrics] CommandRouter: 41s 42.66ms
Jun 10 18:05:45 volumio volumio[1109]: info: CoreCommandRouter::volumiosetStartupVolume
Jun 10 18:05:45 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 10 18:05:45 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 10 18:05:45 volumio volumio[1109]: info: CoreCommandRouter::Close All Modals sent
Jun 10 18:05:45 volumio volumio[1109]: info: CoreCommandRouter::Close All Modals sent
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:46 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::volumioGetQueue
Jun 10 18:05:46 volumio volumio[1109]: info: CoreStateMachine::getQueue
Jun 10 18:05:46 volumio volumio[1109]: info: CorePlayQueue::getQueue
Jun 10 18:05:46 volumio volumio[1109]: info: Listing playlists
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 10 18:05:46 volumio volumio[1109]: info: Received Get System Info
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 10 18:05:46 volumio volumio[1109]: info: Discovery: Getting this device information
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:46 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:46 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:46 volumio systemd[1]: Started My Shell Script.
Jun 10 18:05:46 volumio systemd[1]: Reached target Multi-User System.
Jun 10 18:05:46 volumio systemd[1]: Reached target Graphical Interface.
Jun 10 18:05:46 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Jun 10 18:05:46 volumio sudo[1968]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/bash /home/volumio/scripts/peppy.sh
Jun 10 18:05:46 volumio sudo[1968]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:46 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Jun 10 18:05:46 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Jun 10 18:05:46 volumio systemd[1]: Startup finished in 7.870s (firmware) + 3.132s (loader) + 10.442s (kernel) + 1min 3.753s (userspace) = 1min 25.198s.
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 10 18:05:46 volumio volumio[1109]: info: Discovery: Getting this device information
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:46 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 18:05:46 volumio volumio[1109]: verbose: New Socket.io Connection to 192.168.3.123:3000 from 192.168.3.35 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:46 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 10 18:05:46 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 10 18:05:50 volumio volumio[1109]: info: Preload queue cleared
Jun 10 18:05:50 volumio volumio[1109]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::ClearQueue
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::stop
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 10 18:05:50 volumio volumio[1109]: info: CorePlayQueue::clearPlayQueue
Jun 10 18:05:50 volumio volumio[1109]: info: CorePlayQueue::saveQueue
Jun 10 18:05:50 volumio volumio[1109]: info: CoreCommandRouter::volumioPushQueue
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::addQueueItems
Jun 10 18:05:50 volumio volumio[1109]: info: CorePlayQueue::addQueueItems
Jun 10 18:05:50 volumio volumio[1109]: info: Preload queue cleared
Jun 10 18:05:50 volumio volumio[1109]: info: Adding Item to queue: music-library/USB/3762-0A9A/周虹《相思 K2HD+DSD》[正版CD原抓WAV+CUE]
Jun 10 18:05:50 volumio volumio[1109]: info: Exploding uri music-library/USB/3762-0A9A/周虹《相思 K2HD+DSD》[正版CD原抓WAV+CUE] in service mpd
Jun 10 18:05:50 volumio volumio[1109]: info: ALBUMART /albumart?cacheid=868&path=%2Fmnt%2FUSB%2F3762-0A9A%2F%E5%91%A8%E8%99%B9%E3%80%8A%E7%9B%B8%E6%80%9D%20K2HD%2BDSD%E3%80%8B%5B%E6%AD%A3%E7%89%88CD%E5%8E%9F%E6%8A%93WAV%2BCUE%5D%2FCDImage.wav&metadata=false
Jun 10 18:05:50 volumio volumio[1109]: info: URI /mnt/USB/3762-0A9A/周虹《相思 K2HD+DSD》[正版CD原抓WAV+CUE]/CDImage.wav
Jun 10 18:05:50 volumio volumio[1109]: info: CoreCommandRouter::volumioPushQueue
Jun 10 18:05:50 volumio volumio[1109]: info: CorePlayQueue::saveQueue
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::updateTrackBlock
Jun 10 18:05:50 volumio volumio[1109]: info: CorePlayQueue::getTrackBlock
Jun 10 18:05:50 volumio volumio[1109]: info: CoreCommandRouter::volumioPlay
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::play index 0
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::stop
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::play index undefined
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 10 18:05:50 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:50 volumio volumio[1109]: info: CoreStateMachine::startPlaybackTimer
Jun 10 18:05:50 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:50 volumio volumio[1109]: verbose: ControllerMpd::clearAddPlayTracks USB/3762-0A9A/周虹《相思 K2HD+DSD》[正版CD原抓WAV+CUE]/CDImage.wav
Jun 10 18:05:50 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand stop
Jun 10 18:05:50 volumio volumio[1109]: info: sendMpdCommand stop took 5 milliseconds
Jun 10 18:05:50 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand clear
Jun 10 18:05:50 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 10 18:05:50 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 10 18:05:50 volumio volumio[1109]: info: Discovery: Getting this device information
Jun 10 18:05:50 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:50 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:50 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 18:05:50 volumio volumio[1109]: info:
Jun 10 18:05:50 volumio volumio[1109]: ---------------------------- MPD announces system playlist update
Jun 10 18:05:50 volumio volumio[1109]: info: Ignoring MPD Status Update
Jun 10 18:05:50 volumio volumio[1109]: info: sendMpdCommand clear took 13 milliseconds
Jun 10 18:05:50 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand add "USB/3762-0A9A/周虹《相思 K2HD+DSD》[正版CD原抓WAV+CUE]/CDImage.wav"
Jun 10 18:05:50 volumio volumio[1109]: error: updateQueue error: null
Jun 10 18:05:50 volumio volumio[1109]: info:
Jun 10 18:05:50 volumio volumio[1109]: ---------------------------- MPD announces system playlist update
Jun 10 18:05:50 volumio volumio[1109]: info: Ignoring MPD Status Update
Jun 10 18:05:50 volumio volumio[1109]: info: ------------------------------ 9ms
Jun 10 18:05:50 volumio volumio[1109]: info: sendMpdCommand add "USB/3762-0A9A/周虹《相思 K2HD+DSD》[正版CD原抓WAV+CUE]/CDImage.wav" took 6 milliseconds
Jun 10 18:05:50 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand play
Jun 10 18:05:50 volumio volumio[1109]: info: ------------------------------ 6ms
Jun 10 18:05:50 volumio volumio[1109]: info: sendMpdCommand play took 4 milliseconds
Jun 10 18:05:50 volumio volumio[1109]: info:
Jun 10 18:05:50 volumio volumio[1109]: ---------------------------- MPD announces state update: player
Jun 10 18:05:50 volumio volumio[1109]: info: ControllerMpd::getState
Jun 10 18:05:50 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand status
Jun 10 18:05:50 volumio volumio[1109]: info:
Jun 10 18:05:50 volumio volumio[1109]: ---------------------------- MPD announces state update: player
Jun 10 18:05:50 volumio volumio[1109]: info: sendMpdCommand status took 48 milliseconds
Jun 10 18:05:50 volumio volumio[1109]: info: ControllerMpd::getState
Jun 10 18:05:50 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand status
Jun 10 18:05:50 volumio volumio[1109]: verbose: ControllerMpd::parseState
Jun 10 18:05:50 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 10 18:05:51 volumio volumio[1109]: info: sendMpdCommand status took 3 milliseconds
Jun 10 18:05:51 volumio volumio[1109]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jun 10 18:05:51 volumio volumio[1109]: verbose: ControllerMpd::parseState
Jun 10 18:05:51 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 10 18:05:51 volumio volumio[1109]: verbose: ControllerMpd::parseTrackInfo
Jun 10 18:05:51 volumio volumio[1109]: info: ControllerMpd::pushState
Jun 10 18:05:51 volumio volumio[1109]: info: CoreCommandRouter::servicePushState
Jun 10 18:05:51 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:51 volumio volumio[1109]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":null,"uri":"USB/3762-0A9A/周虹《相思 K2HD+DSD》[正版CD原抓WAV+CUE]/CDImage.wav","trackType":"wav"}
Jun 10 18:05:51 volumio volumio[1109]: verbose: CURRENT POSITION 0
Jun 10 18:05:51 volumio volumio[1109]: info: CoreStateMachine::syncState stateService play
Jun 10 18:05:51 volumio volumio[1109]: info: CoreStateMachine::syncState currentStatus stop
Jun 10 18:05:51 volumio volumio[1109]: info: ------------------------------ 62ms
Jun 10 18:05:51 volumio volumio[1109]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jun 10 18:05:51 volumio volumio[1109]: verbose: ControllerMpd::parseTrackInfo
Jun 10 18:05:51 volumio volumio[1109]: info: ControllerMpd::pushState
Jun 10 18:05:51 volumio volumio[1109]: info: CoreCommandRouter::servicePushState
Jun 10 18:05:51 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:51 volumio volumio[1109]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":3172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":null,"uri":"USB/3762-0A9A/周虹《相思 K2HD+DSD》[正版CD原抓WAV+CUE]/CDImage.wav","trackType":"wav"}
Jun 10 18:05:51 volumio volumio[1109]: verbose: CURRENT POSITION 0
Jun 10 18:05:51 volumio volumio[1109]: info: CoreStateMachine::syncState stateService play
Jun 10 18:05:51 volumio volumio[1109]: info: CoreStateMachine::syncState currentStatus play
Jun 10 18:05:51 volumio volumio[1109]: info: Received an update from plugin. extracting info from payload
Jun 10 18:05:51 volumio volumio[1109]: info: CoreStateMachine::pushState
Jun 10 18:05:51 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:51 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 10 18:05:51 volumio volumio[1109]: info: CoreCommandRouter::volumioPushState
Jun 10 18:05:51 volumio volumio[1109]: info: CoreStateMachine::pushState
Jun 10 18:05:51 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:51 volumio volumio[1109]: info: CoreCommandRouter::volumioPushState
Jun 10 18:05:51 volumio volumio[1109]: info: ------------------------------ 43ms
Jun 10 18:05:52 volumio volumio[1109]: info: BOOT COMPLETED
Jun 10 18:05:53 volumio ntpd[969]: Soliciting pool server 116.203.151.74
Jun 10 18:05:54 volumio ntpd[969]: Soliciting pool server 108.59.2.24
Jun 10 18:05:55 volumio ntpd[969]: Soliciting pool server 202.118.1.130
Jun 10 18:05:56 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:05:56 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:05:56 volumio sudo[2059]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/bin/bash run_peppymeter.sh
Jun 10 18:05:56 volumio sudo[2059]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 10 18:05:56 volumio ntpd[969]: Soliciting pool server 119.28.183.184
Jun 10 18:05:56 volumio ntpd[969]: Soliciting pool server 202.118.1.81
Jun 10 18:05:57 volumio ntpd[969]: Soliciting pool server 117.80.231.60
Jun 10 18:05:57 volumio ntpd[969]: Soliciting pool server 193.182.111.14
Jun 10 18:05:57 volumio ntpd[969]: Soliciting pool server 117.80.112.205
Jun 10 18:05:58 volumio ntpd[969]: Soliciting pool server 193.182.111.12
Jun 10 18:05:58 volumio ntpd[969]: Soliciting pool server 45.76.221.157
Jun 10 18:05:58 volumio ntpd[969]: Soliciting pool server 162.159.200.123
Jun 10 18:05:59 volumio ntpd[969]: Soliciting pool server 193.182.111.141
Jun 10 18:05:59 volumio ntpd[969]: Soliciting pool server 193.182.111.143
Jun 10 18:06:00 volumio volumio[1109]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Jun 10 18:06:00 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:06:00 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:06:00 volumio ntpd[969]: Soliciting pool server 2a01:4f8:c2c:477d::2
Jun 10 18:06:04 volumio ntpd[969]: receive: Unexpected origin timestamp 0xebf2820b.734a5310 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xebf2820c.3c40c616
Jun 10 18:06:04 volumio ntpd[969]: receive: Unexpected origin timestamp 0xebf2820b.73435f21 does not match aorg 0000000000.00000000 from server@193.182.111.12 xmt 0xebf2820c.3fd36940
Jun 10 18:06:04 volumio ntpd[969]: receive: Unexpected origin timestamp 0xebf2820b.734f9d57 does not match aorg 0000000000.00000000 from server@108.59.2.24 xmt 0xebf2820c.48019070
Jun 10 18:06:09 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 10 18:06:09 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 10 18:06:09 volumio volumio[1109]: info: Discovery: Getting this device information
Jun 10 18:06:09 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:06:09 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:06:09 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 18:06:41 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 10 18:06:41 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 10 18:06:41 volumio volumio[1109]: info: Discovery: Getting this device information
Jun 10 18:06:41 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:06:41 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:06:41 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 18:06:42 volumio volumio[1109]: verbose: New Socket.io Connection to 192.168.3.123:3000 from 192.168.3.35 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Jun 10 18:06:42 volumio volumio[1109]: verbose: New Socket.io Connection to 192.168.3.123 from 192.168.3.35 UA: Mozilla/5.0 (Linux; Android 10; WLZ-AN00 Build/HUAWEIWLZ-AN00; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/114.0.5735.196 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:06:42 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::volumioGetQueue
Jun 10 18:06:42 volumio volumio[1109]: info: CoreStateMachine::getQueue
Jun 10 18:06:42 volumio volumio[1109]: info: CorePlayQueue::getQueue
Jun 10 18:06:42 volumio volumio[1109]: info: Listing playlists
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 10 18:06:42 volumio volumio[1109]: info: Received Get System Info
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 10 18:06:42 volumio volumio[1109]: info: Discovery: Getting this device information
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:06:42 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 18:06:42 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:06:42 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:06:43 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jun 10 18:06:43 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 10 18:06:43 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 10 18:06:43 volumio volumio[1109]: info: Discovery: Getting this device information
Jun 10 18:06:43 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState
Jun 10 18:06:43 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:06:43 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 10 18:06:44 volumio volumio[1109]: info: CoreCommandRouter::volumioPause
Jun 10 18:06:44 volumio volumio[1109]: info: CoreStateMachine::pause
Jun 10 18:06:44 volumio volumio[1109]: info: CoreStateMachine::stPlaybackTimer
Jun 10 18:06:44 volumio volumio[1109]: info: CoreStateMachine::servicePause
Jun 10 18:06:44 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:06:44 volumio volumio[1109]: info: CoreCommandRouter::servicePause
Jun 10 18:06:44 volumio volumio[1109]: info: ControllerMpd::pause
Jun 10 18:06:44 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand pause
Jun 10 18:06:44 volumio volumio[1109]: info: sendMpdCommand pause took 3 milliseconds
Jun 10 18:06:44 volumio volumio[1109]: info:
Jun 10 18:06:44 volumio volumio[1109]: ---------------------------- MPD announces state update: player
Jun 10 18:06:44 volumio volumio[1109]: info: ControllerMpd::getState
Jun 10 18:06:44 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand status
Jun 10 18:06:44 volumio volumio[1109]: info: sendMpdCommand status took 5 milliseconds
Jun 10 18:06:44 volumio volumio[1109]: verbose: ControllerMpd::parseState
Jun 10 18:06:44 volumio volumio[1109]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 10 18:06:44 volumio volumio[1109]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jun 10 18:06:44 volumio volumio[1109]: verbose: ControllerMpd::parseTrackInfo
Jun 10 18:06:44 volumio volumio[1109]: info: ControllerMpd::pushState
Jun 10 18:06:44 volumio volumio[1109]: info: CoreCommandRouter::servicePushState
Jun 10 18:06:44 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:06:44 volumio volumio[1109]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":53842,"duration":3172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":null,"uri":"USB/3762-0A9A/周虹《相思 K2HD+DSD》[正版CD原抓WAV+CUE]/CDImage.wav","trackType":"wav"}
Jun 10 18:06:44 volumio volumio[1109]: verbose: CURRENT POSITION 0
Jun 10 18:06:44 volumio volumio[1109]: info: CoreStateMachine::syncState stateService pause
Jun 10 18:06:44 volumio volumio[1109]: info: CoreStateMachine::syncState currentStatus pause
Jun 10 18:06:44 volumio volumio[1109]: info: CoreStateMachine::pushState
Jun 10 18:06:44 volumio volumio[1109]: info: CorePlayQueue::getTrack 0
Jun 10 18:06:44 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 10 18:06:44 volumio volumio[1109]: info: CoreCommandRouter::volumioPushState
Jun 10 18:06:44 volumio volumio[1109]: info: CoreStateMachine::stPlaybackTimer
Jun 10 18:06:44 volumio volumio[1109]: info: ------------------------------ 26ms
Jun 10 18:06:44 volumio volumio[1109]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 10 18:06:44 volumio volumio[1109]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Jun 10 18:06:44 volumio volumio[1109]: at Object.readdirSync (fs.js:1048:3)
Jun 10 18:06:44 volumio volumio[1109]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
Jun 10 18:06:44 volumio volumio[1109]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
Jun 10 18:06:44 volumio volumio[1109]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
Jun 10 18:06:44 volumio volumio[1109]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
Jun 10 18:06:44 volumio volumio[1109]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
Jun 10 18:06:44 volumio volumio[1109]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Jun 10 18:06:44 volumio volumio[1109]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
Jun 10 18:06:44 volumio volumio[1109]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
Jun 10 18:06:44 volumio volumio[1109]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) {
Jun 10 18:06:44 volumio volumio[1109]: errno: -20,
Jun 10 18:06:44 volumio volumio[1109]: syscall: 'scandir',
Jun 10 18:06:44 volumio volumio[1109]: code: 'ENOTDIR',
Jun 10 18:06:44 volumio volumio[1109]: path: '/tmp/peppyrunning'
Jun 10 18:06:44 volumio volumio[1109]: }
Jun 10 18:06:44 volumio volumio[1109]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 10 18:06:45 volumio sudo[2274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-10 18:05
Jun 10 18:06:45 volumio sudo[2274]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"