-- Logs begin at Wed 2025-03-19 19:52:47 CST, end at Wed 2025-03-19 19:54:05 CST. --
Mar 19 19:53:00 volumio screensaver.sh[811]: curl: (7) Failed to connect to 127.0.0.1 port 3000: Connection refused
Mar 19 19:53:00 volumio wireless.js[813]: trying...
Mar 19 19:53:00 volumio sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 19 19:53:00 volumio sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:00 volumio sudo[1107]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:01 volumio volumio-time-update[820]: volumio-time-update-util: Fetching time from Volumio...
Mar 19 19:53:01 volumio volumio-time-update[820]: volumio-time-update-util: Date not found in response
Mar 19 19:53:01 volumio volumio-time-update[820]: volumio-time-update-util: Retrying in 5 seconds...
Mar 19 19:53:01 volumio dhcpcd[843]: wlan0: leased 192.168.0.129 for 86400 seconds
Mar 19 19:53:01 volumio dhcpcd[843]: wlan0: leased 192.168.0.129 for 86400 seconds
Mar 19 19:53:01 volumio dhcpcd[843]: wlan0: adding route to 192.168.0.0/24
Mar 19 19:53:01 volumio dhcpcd[843]: wlan0: adding default route via 192.168.0.1
Mar 19 19:53:01 volumio avahi-daemon[835]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.129.
Mar 19 19:53:01 volumio avahi-daemon[835]: New relevant interface wlan0.IPv4 for mDNS.
Mar 19 19:53:01 volumio avahi-daemon[835]: Registering new address record for 192.168.0.129 on wlan0.IPv4.
Mar 19 19:53:01 volumio dhcpcd[843]: wlan0: adding route to 192.168.0.0/24
Mar 19 19:53:01 volumio dhcpcd[843]: wlan0: adding default route via 192.168.0.1
Mar 19 19:53:01 volumio kernel: brcmsmac bcma0:1: brcms_ops_bss_info_changed: arp filtering: 1 addresses (implement)
Mar 19 19:53:01 volumio ntpd[984]: ntpd exiting on signal 15 (Terminated)
Mar 19 19:53:01 volumio systemd[1]: Stopping Network Time Service...
Mar 19 19:53:01 volumio systemd[1]: ntp.service: Succeeded.
Mar 19 19:53:01 volumio systemd[1]: Stopped Network Time Service.
Mar 19 19:53:01 volumio systemd[1]: Starting Network Time Service...
Mar 19 19:53:01 volumio ntpd[1147]: ntpd 4.2.8p12@1.3728-o (1): Starting
Mar 19 19:53:01 volumio ntpd[1147]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103
Mar 19 19:53:01 volumio systemd[1]: Started Network Time Service.
Mar 19 19:53:01 volumio ntpd[1153]: proto: precision = 0.156 usec (-23)
Mar 19 19:53:01 volumio dhcpcd[843]: forked to background, child pid 1154
Mar 19 19:53:01 volumio systemd[1]: Started DHCP Client Daemon.
Mar 19 19:53:01 volumio dhcpcd[843]: forked to background, child pid 1154
Mar 19 19:53:01 volumio ntpd[1153]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Mar 19 19:53:01 volumio ntpd[1153]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Mar 19 19:53:01 volumio ntpd[1153]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 813 days ago
Mar 19 19:53:01 volumio ntpd[1153]: Listen and drop on 0 v6wildcard [::]:123
Mar 19 19:53:01 volumio ntpd[1153]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Mar 19 19:53:01 volumio ntpd[1153]: Listen normally on 2 lo 127.0.0.1:123
Mar 19 19:53:01 volumio ntpd[1153]: Listen normally on 3 wlan0 192.168.0.129:123
Mar 19 19:53:01 volumio ntpd[1153]: Listening on routing socket on fd #20 for interface updates
Mar 19 19:53:01 volumio ntpd[1153]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Mar 19 19:53:01 volumio ntpd[1153]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Mar 19 19:53:01 volumio wireless.js[813]: trying...
Mar 19 19:53:01 volumio sudo[1157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Mar 19 19:53:01 volumio sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:01 volumio sudo[1157]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:01 volumio wireless.js[813]: Connected to: ----Tenda_D62EF0
Mar 19 19:53:01 volumio wireless.js[813]: ----
Mar 19 19:53:01 volumio sudo[1160]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 19 19:53:01 volumio sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:01 volumio sudo[1160]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:01 volumio wireless.js[813]: ... joined AP, wlan0 IPv4 is 192.168.0.129, ipV6 is undefined
Mar 19 19:53:01 volumio wireless.js[813]: It's done! AP
Mar 19 19:53:01 volumio iwconfig[1164]: Error for wireless request "Set Power Management" (8B2C) :
Mar 19 19:53:01 volumio iwconfig[1164]: SET failed on device wlan0 ; Operation not supported.
Mar 19 19:53:01 volumio systemd[1]: Started Wireless Services.
Mar 19 19:53:01 volumio systemd[1]: Started Volumio Backend Module.
Mar 19 19:53:01 volumio systemd[1]: Started Volumio Cpu Tweaker.
Mar 19 19:53:01 volumio systemd[1]: Started Intel SST and HDA soundcard init service.
Mar 19 19:53:01 volumio systemd[1]: Started Start Volumio Kiosk.
Mar 19 19:53:01 volumio volumio-cpu-tweak[1166]: Setting RT Priority for mpd
Mar 19 19:53:01 volumio volumio-cpu-tweak[1166]: Not enough cores to set MPD affinity
Mar 19 19:53:01 volumio volumio-cpu-tweak[1166]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Mar 19 19:53:01 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded.
Mar 19 19:53:01 volumio startx[1173]: X.Org X Server 1.20.4
Mar 19 19:53:01 volumio startx[1173]: X Protocol Version 11, Revision 0
Mar 19 19:53:01 volumio startx[1173]: Build Operating System: Linux 5.10.0-10-amd64 x86_64 Debian
Mar 19 19:53:01 volumio startx[1173]: Current Operating System: Linux volumio 6.6.32-volumio #2 SMP PREEMPT_DYNAMIC Wed May 29 23:04:42 CEST 2024 x86_64
Mar 19 19:53:01 volumio startx[1173]: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 biosdevname=0 imgpart=UUID=d35eb915-f24a-437a-a43b-4afe991304f7 bootpart=UUID=79FB-2BA3 datapart=UUID=2fc5abe1-9579-4377-a3f7-b00c1ebaeecd 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 initrd=volumio.initrd
Mar 19 19:53:01 volumio startx[1173]: Build Date: 18 December 2021 09:05:36AM
Mar 19 19:53:01 volumio startx[1173]: xorg-server 2:1.20.4-1+deb10u4 (https://www.debian.org/support)
Mar 19 19:53:01 volumio startx[1173]: Current version of pixman: 0.36.0
Mar 19 19:53:01 volumio startx[1173]: Before reporting problems, check http://wiki.x.org
Mar 19 19:53:01 volumio startx[1173]: to make sure that you have the latest version.
Mar 19 19:53:01 volumio startx[1173]: Markers: (--) probed, (**) from config file, (==) default setting,
Mar 19 19:53:01 volumio startx[1173]: (++) from command line, (!!) notice, (II) informational,
Mar 19 19:53:01 volumio startx[1173]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Mar 19 19:53:01 volumio startx[1173]: (==) Log file: "/var/log/Xorg.0.log", Time: Wed Mar 19 19:53:01 2025
Mar 19 19:53:01 volumio startx[1173]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Mar 19 19:53:02 volumio nmbd[952]: [2025/03/19 19:53:02.105663, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 19 19:53:02 volumio nmbd[952]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Mar 19 19:53:02 volumio systemd[1]: Started Samba NMB Daemon.
Mar 19 19:53:02 volumio systemd[1]: Starting Samba Winbind Daemon...
Mar 19 19:53:02 volumio ntpd[1153]: Soliciting pool server 78.46.102.180
Mar 19 19:53:02 volumio kernel: broken atomic modeset userspace detected, disabling atomic
Mar 19 19:53:02 volumio winbindd[1233]: [2025/03/19 19:53:02.459778, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Mar 19 19:53:02 volumio winbindd[1233]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Mar 19 19:53:02 volumio winbindd[1233]: [2025/03/19 19:53:02.478239, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 19 19:53:02 volumio systemd[1]: Started Samba Winbind Daemon.
Mar 19 19:53:02 volumio winbindd[1233]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Mar 19 19:53:02 volumio systemd[1]: Starting Samba SMB Daemon...
Mar 19 19:53:02 volumio startx[1173]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc.
Mar 19 19:53:02 volumio systemd[1]: soundcard-init.service: Succeeded.
Mar 19 19:53:03 volumio winbindd[1233]: [2025/03/19 19:53:03.029563, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv)
Mar 19 19:53:03 volumio winbindd[1233]: res_names->count = 3, expected 4
Mar 19 19:53:03 volumio smbd[1269]: [2025/03/19 19:53:03.054203, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Mar 19 19:53:03 volumio smbd[1269]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Mar 19 19:53:03 volumio systemd[1]: Started Samba SMB Daemon.
Mar 19 19:53:03 volumio ntpd[1153]: Soliciting pool server 116.203.151.74
Mar 19 19:53:03 volumio ntpd[1153]: Soliciting pool server 162.159.200.1
Mar 19 19:53:03 volumio volumio-remote-updater[780]: [2025-03-19 19:53:03] [connect] Successful connection
Mar 19 19:53:04 volumio ntpd[1153]: Soliciting pool server 5.79.108.34
Mar 19 19:53:04 volumio ntpd[1153]: Soliciting pool server 95.111.202.5
Mar 19 19:53:04 volumio ntpd[1153]: Soliciting pool server 202.118.1.130
Mar 19 19:53:04 volumio volumio[1165]: info: -------------------------------------------
Mar 19 19:53:04 volumio volumio[1165]: info: ----- Volumio3 ----
Mar 19 19:53:04 volumio volumio[1165]: info: -------------------------------------------
Mar 19 19:53:04 volumio volumio[1165]: info: ----- System startup ----
Mar 19 19:53:04 volumio volumio[1165]: info: -------------------------------------------
Mar 19 19:53:05 volumio ntpd[1153]: Soliciting pool server 117.80.231.60
Mar 19 19:53:05 volumio ntpd[1153]: Soliciting pool server 193.182.111.141
Mar 19 19:53:05 volumio ntpd[1153]: Soliciting pool server 193.182.111.12
Mar 19 19:53:05 volumio volumio[1165]: info: MYVOLUMIO Environment detected
Mar 19 19:53:05 volumio volumio[1165]: info: Plugin folders cleanup
Mar 19 19:53:05 volumio volumio[1165]: info: Scanning into folder /volumio/app/plugins/
Mar 19 19:53:05 volumio volumio[1165]: info: Scanning category audio_interface
Mar 19 19:53:05 volumio volumio[1165]: info: Scanning category miscellanea
Mar 19 19:53:05 volumio volumio[1165]: info: Scanning category music_service
Mar 19 19:53:05 volumio volumio[1165]: info: Scanning category plugins.json
Mar 19 19:53:05 volumio volumio[1165]: info: Scanning category system_controller
Mar 19 19:53:05 volumio volumio[1165]: info: Scanning category user_interface
Mar 19 19:53:05 volumio volumio[1165]: info: Scanning into folder /data/plugins/
Mar 19 19:53:05 volumio volumio[1165]: info: Scanning category music_service
Mar 19 19:53:05 volumio volumio[1165]: info: Scanning category user_interface
Mar 19 19:53:05 volumio volumio[1165]: info: Plugin folders cleanup completed
Mar 19 19:53:05 volumio volumio[1165]: info: -------------------------------------------
Mar 19 19:53:05 volumio volumio[1165]: info: ----- Core plugins startup ----
Mar 19 19:53:05 volumio volumio[1165]: info: -------------------------------------------
Mar 19 19:53:05 volumio volumio[1165]: info: Loading plugins from folder /volumio/app/plugins/
Mar 19 19:53:05 volumio volumio[1165]: info: Adding plugin upnp to MyMusic Plugins
Mar 19 19:53:05 volumio volumio[1165]: info: Adding plugin airplay_emulation to MyMusic Plugins
Mar 19 19:53:05 volumio volumio[1165]: info: Adding plugin upnp_browser to MyMusic Plugins
Mar 19 19:53:05 volumio volumio[1165]: info: Loading plugins from folder /data/plugins/
Mar 19 19:53:05 volumio volumio[1165]: info: Loading plugin "system"...
Mar 19 19:53:05 volumio volumio[1165]: info: Loading plugin "appearance"...
Mar 19 19:53:06 volumio volumio-time-update[820]: volumio-time-update-util: Fetching time from Volumio...
Mar 19 19:53:06 volumio ntpd[1153]: Soliciting pool server 193.182.111.14
Mar 19 19:53:06 volumio ntpd[1153]: Soliciting pool server 119.28.206.193
Mar 19 19:53:06 volumio ntpd[1153]: Soliciting pool server 47.92.198.198
Mar 19 19:53:06 volumio volumio-time-update[820]: volumio-time-update-util: Setting system time to: 2025-03-19 19:53:06
Mar 19 19:53:06 volumio sudo[1403]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-03-19 19:53:06
Mar 19 19:53:06 volumio sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:06 volumio dbus-daemon[824]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.7' (uid=0 pid=1404 comm="timedatectl set-time 2025-03-19 19:53:06 ")
Mar 19 19:53:06 volumio systemd[1]: Starting Time & Date Service...
Mar 19 19:53:06 volumio dbus-daemon[824]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.8' (uid=0 pid=1351 comm="/usr/lib/chromium/chromium --show-component-extens")
Mar 19 19:53:06 volumio dbus-daemon[824]: [system] Successfully activated service 'org.freedesktop.timedate1'
Mar 19 19:53:06 volumio systemd[1]: Started Time & Date Service.
Mar 19 19:53:06 volumio systemd-timedated[1405]: Changed local time to Wed Mar 19 19:53:06 2025
Mar 19 19:53:06 volumio sudo[1403]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:06 volumio volumio-time-update[820]: volumio-time-update-util: System time updated successfully.
Mar 19 19:53:06 volumio systemd[1]: Starting Bluetooth service...
Mar 19 19:53:06 volumio systemd[1]: Started Volumio Time Update Utility.
Mar 19 19:53:06 volumio systemd[1]: Reached target Multi-User System.
Mar 19 19:53:06 volumio systemd[1]: Reached target Graphical Interface.
Mar 19 19:53:06 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Mar 19 19:53:06 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Mar 19 19:53:06 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Mar 19 19:53:06 volumio bluetoothd[1409]: Bluetooth daemon 5.50
Mar 19 19:53:06 volumio bluetoothd[1409]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Mar 19 19:53:06 volumio dbus-daemon[824]: [system] Successfully activated service 'org.bluez'
Mar 19 19:53:06 volumio systemd[1]: Started Bluetooth service.
Mar 19 19:53:06 volumio systemd[1]: Startup finished in 7.824s (kernel) + 20.044s (userspace) = 27.868s.
Mar 19 19:53:06 volumio bluetoothd[1409]: Starting SDP server
Mar 19 19:53:06 volumio bluetoothd[1409]: Excluding (cli) sap
Mar 19 19:53:06 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Mar 19 19:53:06 volumio kernel: Bluetooth: BNEP filters: protocol multicast
Mar 19 19:53:06 volumio kernel: Bluetooth: BNEP socket layer initialized
Mar 19 19:53:06 volumio dbus-daemon[824]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.10' (uid=0 pid=1409 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Mar 19 19:53:06 volumio bluetoothd[1409]: Bluetooth management interface 1.22 initialized
Mar 19 19:53:06 volumio ntpd[1153]: Soliciting pool server 193.182.111.142
Mar 19 19:53:06 volumio systemd[1]: Starting Hostname Service...
Mar 19 19:53:06 volumio volumio[1165]: info: Loading plugin "network"...
Mar 19 19:53:06 volumio volumio[1165]: info: Refreshing Cached IP Addresses
Mar 19 19:53:06 volumio dbus-daemon[824]: [system] Successfully activated service 'org.freedesktop.hostname1'
Mar 19 19:53:06 volumio systemd[1]: Started Hostname Service.
Mar 19 19:53:06 volumio sudo[1434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 19 19:53:06 volumio sudo[1434]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:06 volumio sudo[1434]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:06 volumio sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 19 19:53:06 volumio sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:06 volumio volumio[1165]: info: Loading plugin "services"...
Mar 19 19:53:06 volumio sudo[1436]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:06 volumio volumio[1165]: info: Loading plugin "alsa_controller"...
Mar 19 19:53:06 volumio sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Mar 19 19:53:06 volumio sudo[1456]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:06 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 19 19:53:06 volumio volumio[1165]: info: Loading plugin "wizard"...
Mar 19 19:53:06 volumio volumio[1165]: info: Loading plugin "networkfs"...
Mar 19 19:53:06 volumio volumio[1165]: info: Starting Udev Watcher for removable devices
Mar 19 19:53:06 volumio volumio[1165]: info: Ignoring mount for partition: 0DDA-064D
Mar 19 19:53:06 volumio volumio[1165]: info: Ignoring mount for partition: boot
Mar 19 19:53:06 volumio volumio[1165]: info: Ignoring mount for partition: volumio
Mar 19 19:53:06 volumio volumio[1165]: info: Ignoring mount for partition: volumio_data
Mar 19 19:53:06 volumio volumio[1165]: info: Mounting Device 0D32-0B7B
Mar 19 19:53:06 volumio sudo[1506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/0D32-0B7B -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Mar 19 19:53:06 volumio sudo[1506]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:07 volumio kernel: FAT-fs (sdb1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive!
Mar 19 19:53:07 volumio sudo[1506]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:07 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "volumio_command_line_client"...
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "upnp"...
Mar 19 19:53:07 volumio volumio[1165]: info: [1742385187134] Starting Upmpd Daemon
Mar 19 19:53:07 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "my_music"...
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "mpd"...
Mar 19 19:53:07 volumio ntpd[1153]: Soliciting pool server 81.16.177.123
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "upnp_browser"...
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "alarm-clock"...
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "airplay_emulation"...
Mar 19 19:53:07 volumio volumio[1165]: info: Starting Shairport Sync
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "last_100"...
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "webradio"...
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "i2s_dacs"...
Mar 19 19:53:07 volumio volumio[1165]: info: I2S DAC not set, start Auto-detection
Mar 19 19:53:07 volumio volumio[1165]: info: Loading plugin "volumiodiscovery"...
Mar 19 19:53:08 volumio volumio[1165]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Mar 19 19:53:08 volumio volumio[1165]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 19 19:53:08 volumio node[1165]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Mar 19 19:53:08 volumio volumio[1165]: *** WARNING *** For more information see
Mar 19 19:53:08 volumio volumio[1165]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Mar 19 19:53:08 volumio volumio[1165]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 19 19:53:08 volumio node[1165]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 19 19:53:08 volumio volumio[1165]: *** WARNING *** For more information see
Mar 19 19:53:08 volumio node[1165]: *** WARNING *** For more information see
Mar 19 19:53:08 volumio node[1165]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Mar 19 19:53:08 volumio node[1165]: *** WARNING *** Please fix your application to use the native API of Avahi!
Mar 19 19:53:08 volumio node[1165]: *** WARNING *** For more information see
Mar 19 19:53:08 volumio volumio[1165]: info: Applying required configuration parameters for plugin volumiodiscovery
Mar 19 19:53:08 volumio volumio[1165]: info: Discovery: Started advertising with name: Volumio
Mar 19 19:53:08 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 19 19:53:08 volumio volumio[1165]: info: Loading plugin "jellyfin"...
Mar 19 19:53:08 volumio volumio[1165]: info: Loading plugin "peppy_screensaver"...
Mar 19 19:53:08 volumio sudo[1456]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:09 volumio volumio[1165]: info: Applying required configuration parameters for plugin peppy_screensaver
Mar 19 19:53:09 volumio volumio[1165]: info: Loading plugin "outputs"...
Mar 19 19:53:09 volumio volumio[1165]: info: Loading plugin "albumart"...
Mar 19 19:53:09 volumio volumio[1165]: info: Plugin example_plugin is not enabled
Mar 19 19:53:09 volumio volumio[1165]: info: Loading plugin "inputs"...
Mar 19 19:53:09 volumio volumio[1165]: info: Loading plugin "updater_comm"...
Mar 19 19:53:09 volumio volumio[1165]: Forking 1 albumart workers
Mar 19 19:53:09 volumio volumio[1165]: info: Plugin mpdemulation is not enabled
Mar 19 19:53:09 volumio volumio[1165]: info: Loading plugin "rest_api"...
Mar 19 19:53:09 volumio volumio[1165]: info: Loading plugin "websocket"...
Mar 19 19:53:09 volumio volumio[1165]: info: Starting Socket.io Server version 2.3.0
Mar 19 19:53:09 volumio volumio[1165]: info: Loading plugin "RoonBridge"...
Mar 19 19:53:09 volumio volumio[1165]: info: Applying required configuration parameters for plugin RoonBridge
Mar 19 19:53:09 volumio volumio[1165]: info: Loading i18n strings for locale zh
Mar 19 19:53:09 volumio volumio[1165]: Updating browse sources language
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 19 19:53:09 volumio volumio[1165]: Starting albumart workers
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::initPlayerControls
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 19 19:53:09 volumio volumio[1165]: Express server listening on port 3000
Mar 19 19:53:09 volumio volumio[1165]: [Metrics] WebUI: 7s 192.22ms
Mar 19 19:53:09 volumio volumio[1165]: info: Setting Device type: x86
Mar 19 19:53:09 volumio volumio[1165]: info: CoreStateMachine::resetVolumioState
Mar 19 19:53:09 volumio volumio[1165]: info: CoreStateMachine::getcurrentVolume
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::volumioRetrievevolume
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:09 volumio volumio[1165]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Mar 19 19:53:09 volumio volumio[1165]: info: Completed loading Core Plugins
Mar 19 19:53:09 volumio volumio[1165]: info: Preparing to generate the ALSA configuration file
Mar 19 19:53:09 volumio volumio[1165]: info: Volumio Network Manager: Network status updated: 2
Mar 19 19:53:09 volumio volumio[1165]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Mar 19 19:53:09 volumio volumio[1165]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Mar 19 19:53:09 volumio volumio[1165]: info: Reading ALSA contributions from plugins.
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 19 19:53:09 volumio volumio[1165]: info: Discovery: Getting this device information
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:09 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 19 19:53:10 volumio volumio[1165]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Mar 19 19:53:10 volumio volumio[1165]: info: Reloading queue from file
Mar 19 19:53:10 volumio volumio[1165]: info: VolumeController:: Volume=100 Mute =false
Mar 19 19:53:10 volumio volumio[1165]: info: CoreStateMachine::pushState
Mar 19 19:53:10 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Mar 19 19:53:10 volumio volumio[1165]: info: CoreStateMachine::updateTrackBlock
Mar 19 19:53:10 volumio volumio[1165]: info: CorePlayQueue::getTrackBlock
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioRetrievevolume
Mar 19 19:53:10 volumio volumio[1165]: info: CoreStateMachine::setRepeat null single undefined
Mar 19 19:53:10 volumio volumio[1165]: info: CoreStateMachine::pushState
Mar 19 19:53:10 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Mar 19 19:53:10 volumio volumio[1165]: info: CoreStateMachine::setRandom false
Mar 19 19:53:10 volumio volumio[1165]: info: CoreStateMachine::pushState
Mar 19 19:53:10 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Mar 19 19:53:10 volumio volumio[1165]: verbose: New Socket.io Connection to 192.168.0.129 from 192.168.0.152 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 2
Mar 19 19:53:10 volumio volumio[1165]: info: Discovery: adding fb01895a-ebae-453f-bcee-4c834f3efed2
Mar 19 19:53:10 volumio volumio[1165]: info: Discovery: Found device Volumio
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:10 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:10 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 19 19:53:10 volumio volumio[1165]: info: VolumeController:: Volume=100 Mute =false
Mar 19 19:53:10 volumio volumio[1165]: info: CoreStateMachine::pushState
Mar 19 19:53:10 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Mar 19 19:53:10 volumio volumio[1165]: info: Asound.conf file unchanged, so no further update is needed
Mar 19 19:53:10 volumio volumio[1165]: info: Output device has changed, restarting MPD
Mar 19 19:53:10 volumio sudo[1553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 19 19:53:10 volumio volumio[1165]: info: Output device has changed, restarting Shairport Sync
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:10 volumio sudo[1553]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:10 volumio sudo[1553]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:10 volumio sudo[1555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 19 19:53:10 volumio sudo[1555]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:10 volumio systemd[1]: Stopping Music Player Daemon...
Mar 19 19:53:10 volumio systemd[1]: mpd.service: Succeeded.
Mar 19 19:53:10 volumio systemd[1]: Stopped Music Player Daemon.
Mar 19 19:53:10 volumio volumio[1165]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 19 19:53:10 volumio volumio[1165]: info: ___________ START PLUGINS ___________
Mar 19 19:53:10 volumio volumio[1165]: info: ControllerMpd::onStart: Initializing MPD
Mar 19 19:53:10 volumio systemd[1]: Starting Music Player Daemon...
Mar 19 19:53:10 volumio volumio[1165]: info: Creating MPD Configuration file
Mar 19 19:53:10 volumio sudo[1563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 19 19:53:10 volumio sudo[1563]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 19 19:53:10 volumio volumio[1165]: info: [1742385190538] CoreMusicLibrary::Adding element 媒体服务器
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 19 19:53:10 volumio sudo[1561]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Mar 19 19:53:10 volumio sudo[1563]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:10 volumio sudo[1561]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:10 volumio sudo[1561]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:10 volumio sudo[1566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 19 19:53:10 volumio sudo[1566]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:10 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Mar 19 19:53:10 volumio systemd[1]: mpd.service: Succeeded.
Mar 19 19:53:10 volumio systemd[1]: Stopped Music Player Daemon.
Mar 19 19:53:10 volumio systemd[1]: Starting Music Player Daemon...
Mar 19 19:53:10 volumio sudo[1571]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Mar 19 19:53:10 volumio sudo[1571]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:10 volumio volumio[1165]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 19 19:53:10 volumio sudo[1571]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:10 volumio volumio[1165]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 19 19:53:10 volumio volumio[1165]: info: [1742385190799] CoreMusicLibrary::Adding element Last_100
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 19 19:53:10 volumio volumio[1165]: info: [1742385190805] CoreMusicLibrary::Adding element Webradio
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 19 19:53:10 volumio volumio[1165]: info: Initializing BBC Radios
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 19 19:53:10 volumio volumio[1165]: info: Discovery: Getting this device information
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:10 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 19 19:53:10 volumio volumio[1165]: info: [1742385190958] CoreMusicLibrary::Adding element Jellyfin
Mar 19 19:53:10 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 19 19:53:10 volumio volumio[1165]: Cannot find translation for source Jellyfin
Mar 19 19:53:10 volumio volumio[1165]: info: [jellyfin] Initialized plugin with device info: {"id":"fb01895a-ebae-453f-bcee-4c834f3efed2","host":"http://192.168.0.129","name":"Volumio","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":100,"mute":false,"artist":"韩宝仪","track":"無奈的思緒","albumart":"http://192.168.0.129/albumart?cacheid=775&web=%E9%9F%A9%E5%AE%9D%E4%BB%AA/%E7%B2%89%E7%BA%A2%E8%89%B2%E7%9A%84%E5%9B%9E%E5%BF%86/extralarge&path=%2FUSB%2F0D32-0B7B%2F%E9%9F%93%E5%AF%B6%E5%84%80%20-%20%E7%B2%89%E7%B4%85%E8%89%B2%E7%9A%84%E5%9B%9E%E6%86%B6&metadata=false"}}
Mar 19 19:53:10 volumio volumio[1165]: info: Loading i18n strings for locale zh
Mar 19 19:53:10 volumio volumio[1165]: info: /tmp/myfifo created
Mar 19 19:53:11 volumio volumio[1165]: info: /tmp/myfifosa created
Mar 19 19:53:11 volumio sudo[1598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0
Mar 19 19:53:11 volumio sudo[1598]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:11 volumio sudo[1598]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:11 volumio volumio[1165]: info: snd-dummy loaded
Mar 19 19:53:11 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:11 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:11 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:11 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync
Mar 19 19:53:11 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:11 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:11 volumio volumio[1165]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 19 19:53:11 volumio volumio[1165]: info: Volumio Calling Home
Mar 19 19:53:11 volumio sudo[1618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Mar 19 19:53:11 volumio sudo[1618]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:11 volumio systemd[1]: Started RoonBridge.
Mar 19 19:53:11 volumio sudo[1618]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:11 volumio mpd[1579]: Mar 19 19:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 19 19:53:11 volumio systemd[1]: Started Music Player Daemon.
Mar 19 19:53:11 volumio sudo[1566]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:11 volumio sudo[1555]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:11 volumio volumio[1165]: info: MPD Permissions set
Mar 19 19:53:12 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:12 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:12 volumio screensaver.sh[811]: 1607
Mar 19 19:53:12 volumio volumio[1165]: info: Completed starting Core Plugins
Mar 19 19:53:12 volumio volumio[1165]: info: -------------------------------------------
Mar 19 19:53:12 volumio volumio[1165]: info: ----- MyVolumio plugins startup ----
Mar 19 19:53:12 volumio volumio[1165]: info: -------------------------------------------
Mar 19 19:53:12 volumio volumio[1165]: info: [MyVolumio PluginManager] Fetching plans data....
Mar 19 19:53:12 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:12 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:12 volumio volumio[1165]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Mar 19 19:53:12 volumio volumio[1165]: info: MPD running with PID1579
Mar 19 19:53:12 volumio volumio[1165]: ,establishing connection
Mar 19 19:53:12 volumio volumio[1165]: warn: peppy_screensaver: An error occurred on pygame check Command failed: python3 -c "import pygame"
Mar 19 19:53:12 volumio volumio[1165]: Terminated
Mar 19 19:53:12 volumio volumio[1165]: {"killed":false,"code":143,"signal":null,"cmd":"python3 -c \"import pygame\"","stack":"Error: Command failed: python3 -c \"import pygame\"\nTerminated\n\n at ChildProcess.exithandler (child_process.js:383:12)\n at ChildProcess.emit (events.js:400:28)\n at maybeClose (internal/child_process.js:1088:16)\n at Socket. (internal/child_process.js:446:11)\n at Socket.emit (events.js:400:28)\n at Pipe. (net.js:686:12)"}
Mar 19 19:53:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:12 volumio sudo[1645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl
Mar 19 19:53:12 volumio sudo[1645]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:12 volumio sudo[1645]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Mar 19 19:53:13 volumio ntpd[1153]: receive: Unexpected origin timestamp 0xeb852ea8.53bfc43a does not match aorg 0000000000.00000000 from server@47.92.198.198 xmt 0xeb852ea9.29ae64ca
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:13 volumio volumio[1165]: error: MPD error: The expression evaluated to a falsy value:
Mar 19 19:53:13 volumio volumio[1165]: assert.ok(self.idling)
Mar 19 19:53:13 volumio volumio[1165]: error: The expression evaluated to a falsy value:
Mar 19 19:53:13 volumio volumio[1165]: assert.ok(self.idling)
Mar 19 19:53:13 volumio volumio[1165]: error: MPD error: The expression evaluated to a falsy value:
Mar 19 19:53:13 volumio volumio[1165]: assert.ok(self.idling)
Mar 19 19:53:13 volumio volumio[1165]: error: The expression evaluated to a falsy value:
Mar 19 19:53:13 volumio volumio[1165]: assert.ok(self.idling)
Mar 19 19:53:13 volumio volumio[1165]: info: Volumio called home
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile
Mar 19 19:53:13 volumio RoonBridge[1622]: 00:00:00.008 Warn: get lock file path: /tmp/.rnbgem0-
Mar 19 19:53:13 volumio ntpd[1153]: receive: Unexpected origin timestamp 0xeb852ea8.53b8cdfe does not match aorg 0000000000.00000000 from server@193.182.111.14 xmt 0xeb852ea9.454287b1
Mar 19 19:53:13 volumio sudo[1663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 19 19:53:13 volumio sudo[1663]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:13 volumio sudo[1663]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:13 volumio volumio[1165]: error: updateQueue error: null
Mar 19 19:53:13 volumio volumio[1165]: info: Starting Shairport Sync
Mar 19 19:53:13 volumio volumio[1165]: info: Starting Shairport Sync
Mar 19 19:53:13 volumio sudo[1666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Mar 19 19:53:13 volumio sudo[1666]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:13 volumio volumio[1165]: info: Starting Shairport Sync
Mar 19 19:53:13 volumio volumio[1165]: info: Starting Shairport Sync
Mar 19 19:53:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Mar 19 19:53:13 volumio sudo[1669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Mar 19 19:53:13 volumio systemd[1]: shairport-sync.service: Succeeded.
Mar 19 19:53:13 volumio sudo[1669]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Mar 19 19:53:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Mar 19 19:53:13 volumio sudo[1666]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:13 volumio sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Mar 19 19:53:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Mar 19 19:53:13 volumio systemd[1]: shairport-sync.service: Succeeded.
Mar 19 19:53:13 volumio sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:13 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Mar 19 19:53:13 volumio sudo[1669]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:13 volumio sudo[1675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Mar 19 19:53:13 volumio volumio[1165]: info: MPD Permissions set
Mar 19 19:53:13 volumio sudo[1675]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Mar 19 19:53:13 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Mar 19 19:53:13 volumio systemd[1]: shairport-sync.service: Succeeded.
Mar 19 19:53:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Mar 19 19:53:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Mar 19 19:53:13 volumio sudo[1671]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Mar 19 19:53:13 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Mar 19 19:53:13 volumio systemd[1]: shairport-sync.service: Succeeded.
Mar 19 19:53:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Mar 19 19:53:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Mar 19 19:53:13 volumio sudo[1675]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:13 volumio volumio[1165]: info: Shairport-Sync Started
Mar 19 19:53:13 volumio volumio[1165]: Error adding Membership: Error: addMembership EINVAL
Mar 19 19:53:13 volumio volumio[1165]: info: Shairport-Sync Started
Mar 19 19:53:13 volumio RoonBridge[1622]: 00:00:00.531 Trace: [childprocess] using unix child process
Mar 19 19:53:13 volumio volumio[1165]: info: Shairport-Sync Started
Mar 19 19:53:13 volumio volumio[1165]: info: Shairport-Sync Started
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:13 volumio RoonBridge[1622]: 00:00:00.616 Debug: PathForResource, filename: ../.update
Mar 19 19:53:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd
Mar 19 19:53:13 volumio RoonBridge[1622]: 00:00:00.667 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update
Mar 19 19:53:13 volumio sudo[1692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 19 19:53:13 volumio RoonBridge[1622]: 00:00:00.678 Debug: PathForResource, filename: RAATServer
Mar 19 19:53:13 volumio RoonBridge[1622]: 00:00:00.679 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer
Mar 19 19:53:13 volumio RoonBridge[1622]: 00:00:00.679 Debug: PathForResource, filename: RoonBridgeHelper
Mar 19 19:53:13 volumio RoonBridge[1622]: 00:00:00.679 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper
Mar 19 19:53:14 volumio RoonBridge[1622]: Initializing
Mar 19 19:53:14 volumio sudo[1692]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:14 volumio systemd[1]: Stopping Music Player Daemon...
Mar 19 19:53:14 volumio systemd[1]: mpd.service: Succeeded.
Mar 19 19:53:14 volumio systemd[1]: Stopped Music Player Daemon.
Mar 19 19:53:14 volumio RoonBridge[1622]: 00:00:00.740 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper
Mar 19 19:53:14 volumio systemd[1]: Starting Music Player Daemon...
Mar 19 19:53:14 volumio RoonBridge[1622]: 00:00:00.844 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer
Mar 19 19:53:14 volumio sudo[1697]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Mar 19 19:53:14 volumio sudo[1697]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:14 volumio sudo[1697]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:14 volumio RoonBridge[1622]: Not Running (.o)
Mar 19 19:53:14 volumio RoonBridge[1622]: Running
Mar 19 19:53:15 volumio volumio[1165]: 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
Mar 19 19:53:15 volumio mpd[1699]: Mar 19 19:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 19 19:53:15 volumio systemd[1]: Started Music Player Daemon.
Mar 19 19:53:15 volumio sudo[1692]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:15 volumio volumio[1165]: error: updateQueue error: null
Mar 19 19:53:15 volumio RoonBridge[1622]: 00:00:00.023 Warn: get lock file path: /tmp/.rnbhgem0-
Mar 19 19:53:16 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 19 19:53:18 volumio sudo[1806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 19 19:53:18 volumio sudo[1806]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:18 volumio sudo[1806]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:18 volumio sudo[1808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 19 19:53:18 volumio sudo[1808]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:18 volumio sudo[1808]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:18 volumio volumio[1165]: 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
Mar 19 19:53:18 volumio sudo[1815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Mar 19 19:53:18 volumio sudo[1815]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:18 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Mar 19 19:53:18 volumio sudo[1815]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:18 volumio volumio[1165]: info: Upmpdcli Daemon Started
Mar 19 19:53:18 volumio volumio-remote-updater[780]: [2025-03-19 19:53:18] [connect] Successful connection
Mar 19 19:53:18 volumio volumio-remote-updater[780]: [2025-03-19 19:53:18] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742385198 101
Mar 19 19:53:18 volumio volumio[1165]: 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: 6
Mar 19 19:53:18 volumio volumio[1818]: Generating RSA private key, 4096 bit long modulus (2 primes)
Mar 19 19:53:19 volumio volumio[1818]: ............................++++
Mar 19 19:53:19 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Mar 19 19:53:19 volumio sudo[1956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 19 19:53:19 volumio sudo[1956]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:19 volumio sudo[1956]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:19 volumio sudo[1958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 19 19:53:19 volumio sudo[1958]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:19 volumio sudo[1958]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:20 volumio volumio[1165]: verbose: New Socket.io Connection to 192.168.0.129 from 192.168.0.152 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 7
Mar 19 19:53:20 volumio sh[711]: timed out
Mar 19 19:53:20 volumio dhcpcd[748]: timed out
Mar 19 19:53:20 volumio sh[711]: dhcpcd exited
Mar 19 19:53:20 volumio dhcpcd[748]: dhcpcd exited
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 19 19:53:20 volumio sh[711]: ifup: failed to bring up eth0
Mar 19 19:53:20 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Mar 19 19:53:20 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:20 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 19 19:53:20 volumio volumio[1165]: info: Received Get System Info
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 19 19:53:20 volumio volumio[1165]: info: Discovery: Getting this device information
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:20 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:20 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:20 volumio volumio[1165]: info: Listing playlists
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 19 19:53:20 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 19 19:53:21 volumio volumio[1818]: ......................................................++++
Mar 19 19:53:21 volumio volumio[1818]: e is 65537 (0x010001)
Mar 19 19:53:21 volumio volumio[1818]: writing RSA key
Mar 19 19:53:21 volumio volumio[1165]: 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: 8
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:21 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 19 19:53:21 volumio volumio[1165]: info: Received Get System Info
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 19 19:53:21 volumio volumio[1165]: info: Discovery: Getting this device information
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:21 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:21 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:21 volumio volumio[1165]: info: Listing playlists
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 19 19:53:21 volumio volumio[1165]: info: Received Get System Info
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 19 19:53:21 volumio volumio[1165]: info: Discovery: Getting this device information
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:21 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:21 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:21 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:21 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 19 19:53:21 volumio volumio[1165]: info: Received Get System Info
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 19 19:53:21 volumio volumio[1165]: info: Discovery: Getting this device information
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:21 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:21 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:21 volumio volumio[1165]: info: Listing playlists
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 19 19:53:21 volumio volumio[1165]: info: Received Get System Info
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 19 19:53:21 volumio volumio[1165]: info: Discovery: Getting this device information
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:21 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 19 19:53:22 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Mar 19 19:53:22 volumio volumio[1165]: info: Adding plugin bluetooth to MyMusic Plugins
Mar 19 19:53:22 volumio volumio[1165]: info: Adding plugin multiroom to MyMusic Plugins
Mar 19 19:53:22 volumio volumio[1165]: info: Adding plugin metavolumio to MyMusic Plugins
Mar 19 19:53:22 volumio volumio[1165]: info: Adding plugin cd_controller to MyMusic Plugins
Mar 19 19:53:22 volumio volumio[1165]: info: Adding plugin smart_inputs to MyMusic Plugins
Mar 19 19:53:22 volumio volumio[1165]: info: Adding plugin tidalconnect to MyMusic Plugins
Mar 19 19:53:22 volumio volumio[1165]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Mar 19 19:53:23 volumio volumio[1165]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Mar 19 19:53:23 volumio volumio[1165]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Mar 19 19:53:23 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:23 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:23 volumio volumio[1165]: info: Starting MyVolumio Remote Streaming Endpoints
Mar 19 19:53:23 volumio volumio[1165]: info: MyVolumio login type: Token
Mar 19 19:53:23 volumio volumio[1165]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Mar 19 19:53:23 volumio volumio[1165]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Mar 19 19:53:24 volumio volumio[1165]: info: Starting Streaming Service Transparent Proxy
Mar 19 19:53:24 volumio volumio[1165]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Mar 19 19:53:24 volumio volumio[1165]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Mar 19 19:53:24 volumio volumio[1165]: info: Streaming services startup
Mar 19 19:53:24 volumio volumio[1165]: info: Starting Streaming Daemon
Mar 19 19:53:24 volumio sudo[1997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 19 19:53:24 volumio sudo[1997]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:24 volumio volumio[1165]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Mar 19 19:53:24 volumio sudo[1997]: pam_unix(sudo:session): session closed for user root
Mar 19 19:53:24 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Mar 19 19:53:24 volumio volumio[1165]: info: CoreCommandRouter::volumioPlay
Mar 19 19:53:24 volumio volumio[1165]: info: CoreStateMachine::play index undefined
Mar 19 19:53:24 volumio volumio[1165]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 19 19:53:24 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:24 volumio volumio[1165]: info: CoreStateMachine::startPlaybackTimer
Mar 19 19:53:24 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::clearAddPlayTracks USB/0D32-0B7B/韓寶儀 - 粉紅色的回憶/01 無奈的思緒.wav
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand stop
Mar 19 19:53:24 volumio volumio[1165]: error: Cannot start Volumio Streaming Daemon
Mar 19 19:53:24 volumio volumio[1165]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 19 19:53:24 volumio volumio[1165]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 19 19:53:24 volumio volumio[1165]: info: sendMpdCommand stop took 55 milliseconds
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand clear
Mar 19 19:53:24 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:24 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:24 volumio volumio[1165]: info:
Mar 19 19:53:24 volumio volumio[1165]: ---------------------------- MPD announces system playlist update
Mar 19 19:53:24 volumio volumio[1165]: info: Ignoring MPD Status Update
Mar 19 19:53:24 volumio volumio[1165]: info: sendMpdCommand clear took 18 milliseconds
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand add "USB/0D32-0B7B/韓寶儀 - 粉紅色的回憶/01 無奈的思緒.wav"
Mar 19 19:53:24 volumio volumio[1165]: error: updateQueue error: null
Mar 19 19:53:24 volumio volumio[1165]: info:
Mar 19 19:53:24 volumio volumio[1165]: ---------------------------- MPD announces system playlist update
Mar 19 19:53:24 volumio volumio[1165]: info: Ignoring MPD Status Update
Mar 19 19:53:24 volumio volumio[1165]: info: ------------------------------ 13ms
Mar 19 19:53:24 volumio volumio[1165]: info: sendMpdCommand add "USB/0D32-0B7B/韓寶儀 - 粉紅色的回憶/01 無奈的思緒.wav" took 9 milliseconds
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand play
Mar 19 19:53:24 volumio volumio[1165]: info: ------------------------------ 35ms
Mar 19 19:53:24 volumio volumio[1165]: info: sendMpdCommand play took 36 milliseconds
Mar 19 19:53:24 volumio volumio[1165]: info:
Mar 19 19:53:24 volumio volumio[1165]: ---------------------------- MPD announces state update: player
Mar 19 19:53:24 volumio volumio[1165]: info: ControllerMpd::getState
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Mar 19 19:53:24 volumio volumio[1165]: info:
Mar 19 19:53:24 volumio volumio[1165]: ---------------------------- MPD announces state update: player
Mar 19 19:53:24 volumio volumio[1165]: info: sendMpdCommand status took 67 milliseconds
Mar 19 19:53:24 volumio volumio[1165]: info: ControllerMpd::getState
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::parseState
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 19 19:53:24 volumio volumio[1165]: info: sendMpdCommand status took 11 milliseconds
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::parseState
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 19 19:53:24 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 14 milliseconds
Mar 19 19:53:24 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Mar 19 19:53:24 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Mar 19 19:53:24 volumio volumio[1165]: info: ControllerMpd::pushState
Mar 19 19:53:24 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Mar 19 19:53:24 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:24 volumio volumio[1165]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"無奈的思緒","artist":"韩宝仪","album":"粉红色的回忆","uri":"USB/0D32-0B7B/韓寶儀 - 粉紅色的回憶/01 無奈的思緒.wav","trackType":"wav"}
Mar 19 19:53:24 volumio volumio[1165]: verbose: CURRENT POSITION 0
Mar 19 19:53:24 volumio volumio[1165]: info: CoreStateMachine::syncState stateService play
Mar 19 19:53:24 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus stop
Mar 19 19:53:24 volumio volumio[1165]: info: ControllerMpd::pushState
Mar 19 19:53:24 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Mar 19 19:53:24 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:24 volumio volumio[1165]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"無奈的思緒","artist":"韩宝仪","album":"粉红色的回忆","uri":"USB/0D32-0B7B/韓寶儀 - 粉紅色的回憶/01 無奈的思緒.wav","trackType":"wav"}
Mar 19 19:53:24 volumio volumio[1165]: verbose: CURRENT POSITION 0
Mar 19 19:53:24 volumio volumio[1165]: info: CoreStateMachine::syncState stateService play
Mar 19 19:53:24 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus play
Mar 19 19:53:24 volumio volumio[1165]: info: Received an update from plugin. extracting info from payload
Mar 19 19:53:24 volumio volumio[1165]: info: CoreStateMachine::pushState
Mar 19 19:53:24 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:24 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 19 19:53:24 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Mar 19 19:53:24 volumio volumio[1165]: info: CoreStateMachine::pushState
Mar 19 19:53:24 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:24 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Mar 19 19:53:24 volumio volumio[1165]: info: ------------------------------ 120ms
Mar 19 19:53:24 volumio volumio[1165]: info: ------------------------------ 65ms
Mar 19 19:53:24 volumio volumio[1165]: STREAMING PROXY: Starting server on port 3245
Mar 19 19:53:24 volumio volumio[1165]: Node JS runtime: 14
Mar 19 19:53:28 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 19 19:53:30 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 19 19:53:34 volumio volumio[1165]: info: CoreCommandRouter::volumioGetQueue
Mar 19 19:53:34 volumio volumio[1165]: info: CoreStateMachine::getQueue
Mar 19 19:53:34 volumio volumio[1165]: info: CorePlayQueue::getQueue
Mar 19 19:53:35 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:35 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:35 volumio sudo[2064]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Mar 19 19:53:35 volumio sudo[2064]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 19 19:53:36 volumio systemd[1]: systemd-timedated.service: Succeeded.
Mar 19 19:53:37 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Mar 19 19:53:38 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 19 19:53:38 volumio volumio[1165]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Mar 19 19:53:38 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:38 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:38 volumio volumio[1165]: 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: 10
Mar 19 19:53:38 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Mar 19 19:53:38 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:53:42 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 19 19:53:42 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:42 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 19 19:53:42 volumio volumio-remote-updater[780]: No test mode
Mar 19 19:53:42 volumio volumio-remote-updater[780]: No alpha test mode
Mar 19 19:53:42 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Mar 19 19:53:43 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:43 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:43 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Mar 19 19:53:43 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 19 19:53:43 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Mar 19 19:53:43 volumio volumio[1165]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 19 19:53:43 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 19 19:53:44 volumio volumio[1165]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Mar 19 19:53:44 volumio volumio[1165]: info: Completed starting MyVolumio Plugin
Mar 19 19:53:44 volumio volumio[1165]: [Metrics] CommandRouter: 40s 34.74ms
Mar 19 19:53:44 volumio volumio[1165]: info: CoreCommandRouter::volumiosetStartupVolume
Mar 19 19:53:44 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 19 19:53:44 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 19 19:53:44 volumio volumio[1165]: info: CoreCommandRouter::Close All Modals sent
Mar 19 19:53:44 volumio volumio[1165]: info: CoreCommandRouter::Close All Modals sent
Mar 19 19:53:44 volumio volumio[1165]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Mar 19 19:53:44 volumio volumio[1165]: aplay: main:828: audio open error: Device or resource busy
Mar 19 19:53:44 volumio volumio[1165]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
NEW ADDITIONS
- Fix potential issues with QOBUZ and TIDAL Streaming on slow connections
","title":"Update v3.795","updateavailable":true}
Mar 19 19:53:44 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 19 19:53:45 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Mar 19 19:53:45 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 19 19:53:45 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Mar 19 19:53:51 volumio volumio[1165]: info: BOOT COMPLETED
Mar 19 19:53:54 volumio volumio[1165]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Mar 19 19:53:54 volumio volumio[1165]: info: Retrying Login Due to Network Error
Mar 19 19:54:04 volumio volumio[1165]: info: MyVolumio login type: Token
Mar 19 19:54:05 volumio volumio[1165]: info: CoreCommandRouter::volumioPause
Mar 19 19:54:05 volumio volumio[1165]: info: CoreStateMachine::pause
Mar 19 19:54:05 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Mar 19 19:54:05 volumio volumio[1165]: info: CoreStateMachine::servicePause
Mar 19 19:54:05 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:54:05 volumio volumio[1165]: info: CoreCommandRouter::servicePause
Mar 19 19:54:05 volumio volumio[1165]: info: ControllerMpd::pause
Mar 19 19:54:05 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand pause
Mar 19 19:54:05 volumio volumio[1165]: info:
Mar 19 19:54:05 volumio volumio[1165]: ---------------------------- MPD announces state update: player
Mar 19 19:54:05 volumio volumio[1165]: info: sendMpdCommand pause took 2 milliseconds
Mar 19 19:54:05 volumio volumio[1165]: info: ControllerMpd::getState
Mar 19 19:54:05 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Mar 19 19:54:05 volumio volumio[1165]: info: sendMpdCommand status took 1 milliseconds
Mar 19 19:54:05 volumio volumio[1165]: verbose: ControllerMpd::parseState
Mar 19 19:54:05 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 19 19:54:05 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 1 milliseconds
Mar 19 19:54:05 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Mar 19 19:54:05 volumio volumio[1165]: info: ControllerMpd::pushState
Mar 19 19:54:05 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Mar 19 19:54:05 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:54:05 volumio volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41389,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"無奈的思緒","artist":"韩宝仪","album":"粉红色的回忆","uri":"USB/0D32-0B7B/韓寶儀 - 粉紅色的回憶/01 無奈的思緒.wav","trackType":"wav"}
Mar 19 19:54:05 volumio volumio[1165]: verbose: CURRENT POSITION 0
Mar 19 19:54:05 volumio volumio[1165]: info: CoreStateMachine::syncState stateService pause
Mar 19 19:54:05 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Mar 19 19:54:05 volumio volumio[1165]: info: CoreStateMachine::pushState
Mar 19 19:54:05 volumio volumio[1165]: info: CorePlayQueue::getTrack 0
Mar 19 19:54:05 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 19 19:54:05 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Mar 19 19:54:05 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Mar 19 19:54:05 volumio volumio[1165]: info: ------------------------------ 20ms
Mar 19 19:54:05 volumio volumio[1165]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 19 19:54:05 volumio volumio[1165]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Mar 19 19:54:05 volumio volumio[1165]: at Object.readdirSync (fs.js:1048:3)
Mar 19 19:54:05 volumio volumio[1165]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
Mar 19 19:54:05 volumio volumio[1165]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
Mar 19 19:54:05 volumio volumio[1165]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
Mar 19 19:54:05 volumio volumio[1165]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
Mar 19 19:54:05 volumio volumio[1165]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
Mar 19 19:54:05 volumio volumio[1165]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Mar 19 19:54:05 volumio volumio[1165]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
Mar 19 19:54:05 volumio volumio[1165]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
Mar 19 19:54:05 volumio volumio[1165]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Mar 19 19:54:05 volumio volumio[1165]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Mar 19 19:54:05 volumio volumio[1165]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8)
Mar 19 19:54:05 volumio volumio[1165]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Mar 19 19:54:05 volumio volumio[1165]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Mar 19 19:54:05 volumio volumio[1165]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12)
Mar 19 19:54:05 volumio volumio[1165]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) {
Mar 19 19:54:05 volumio volumio[1165]: errno: -20,
Mar 19 19:54:05 volumio volumio[1165]: syscall: 'scandir',
Mar 19 19:54:05 volumio volumio[1165]: code: 'ENOTDIR',
Mar 19 19:54:05 volumio volumio[1165]: path: '/tmp/peppyrunning'
Mar 19 19:54:05 volumio volumio[1165]: }
Mar 19 19:54:05 volumio volumio[1165]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 19 19:54:05 volumio sudo[2280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-19 19:53
Mar 19 19:54:05 volumio sudo[2280]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"