-- Logs begin at Thu 2024-10-17 11:25:51 CST, end at Thu 2024-10-17 11:27:20 CST. -- Oct 17 11:26:00 volumio-x86 volumio-remote-updater[604]: [2024-10-17 11:26:00] [connect] Successful connection Oct 17 11:26:00 volumio-x86 ntpd[825]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 17 11:26:00 volumio-x86 volumio[839]: info: ------------------------------------------- Oct 17 11:26:00 volumio-x86 volumio[839]: info: ----- Volumio3 ---- Oct 17 11:26:00 volumio-x86 volumio[839]: info: ------------------------------------------- Oct 17 11:26:00 volumio-x86 volumio[839]: info: ----- System startup ---- Oct 17 11:26:00 volumio-x86 volumio[839]: info: ------------------------------------------- Oct 17 11:26:02 volumio-x86 volumio[839]: info: MYVOLUMIO Environment detected Oct 17 11:26:03 volumio-x86 volumio[839]: info: Plugin folders cleanup Oct 17 11:26:03 volumio-x86 volumio[839]: info: Scanning into folder /volumio/app/plugins/ Oct 17 11:26:03 volumio-x86 volumio[839]: info: Scanning category audio_interface Oct 17 11:26:03 volumio-x86 volumio[839]: info: Scanning category miscellanea Oct 17 11:26:03 volumio-x86 volumio[839]: info: Scanning category music_service Oct 17 11:26:03 volumio-x86 volumio[839]: info: Scanning category plugins.json Oct 17 11:26:03 volumio-x86 volumio[839]: info: Scanning category system_controller Oct 17 11:26:03 volumio-x86 volumio[839]: info: Scanning category user_interface Oct 17 11:26:03 volumio-x86 volumio[839]: info: Scanning into folder /data/plugins/ Oct 17 11:26:03 volumio-x86 volumio[839]: info: Scanning category user_interface Oct 17 11:26:03 volumio-x86 volumio[839]: info: Plugin folders cleanup completed Oct 17 11:26:03 volumio-x86 volumio[839]: info: ------------------------------------------- Oct 17 11:26:03 volumio-x86 volumio[839]: info: ----- Core plugins startup ---- Oct 17 11:26:03 volumio-x86 volumio[839]: info: ------------------------------------------- Oct 17 11:26:03 volumio-x86 volumio[839]: info: Loading plugins from folder /volumio/app/plugins/ Oct 17 11:26:03 volumio-x86 volumio[839]: info: Adding plugin upnp to MyMusic Plugins Oct 17 11:26:03 volumio-x86 volumio[839]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 17 11:26:03 volumio-x86 volumio[839]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 17 11:26:03 volumio-x86 volumio[839]: info: Loading plugins from folder /data/plugins/ Oct 17 11:26:03 volumio-x86 volumio[839]: info: Loading plugin "system"... Oct 17 11:26:03 volumio-x86 volumio[839]: info: Loading plugin "appearance"... Oct 17 11:26:04 volumio-x86 dhcpcd[722]: eth0: leased 192.168.10.112 for 14400 seconds Oct 17 11:26:04 volumio-x86 dhcpcd[722]: eth0: adding route to 192.168.10.0/24 Oct 17 11:26:04 volumio-x86 dhcpcd[722]: eth0: adding default route via 192.168.10.1 Oct 17 11:26:04 volumio-x86 avahi-daemon[612]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.10.112. Oct 17 11:26:04 volumio-x86 avahi-daemon[612]: New relevant interface eth0.IPv4 for mDNS. Oct 17 11:26:04 volumio-x86 avahi-daemon[612]: Registering new address record for 192.168.10.112 on eth0.IPv4. Oct 17 11:26:04 volumio-x86 systemd[1]: Stopping Network Time Service... Oct 17 11:26:04 volumio-x86 ntpd[825]: ntpd exiting on signal 15 (Terminated) Oct 17 11:26:04 volumio-x86 systemd[1]: ntp.service: Succeeded. Oct 17 11:26:04 volumio-x86 systemd[1]: Stopped Network Time Service. Oct 17 11:26:04 volumio-x86 systemd[1]: Starting Network Time Service... Oct 17 11:26:04 volumio-x86 ntpd[1095]: ntpd 4.2.8p12@1.3728-o (1): Starting Oct 17 11:26:04 volumio-x86 ntpd[1095]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Oct 17 11:26:04 volumio-x86 systemd[1]: Started Network Time Service. Oct 17 11:26:04 volumio-x86 ntpd[1101]: proto: precision = 0.264 usec (-22) Oct 17 11:26:04 volumio-x86 ntpd[1101]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Oct 17 11:26:04 volumio-x86 ntpd[1101]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Oct 17 11:26:04 volumio-x86 ntpd[1101]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 660 days ago Oct 17 11:26:04 volumio-x86 ntpd[1101]: Listen and drop on 0 v6wildcard [::]:123 Oct 17 11:26:04 volumio-x86 ntpd[1101]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Oct 17 11:26:04 volumio-x86 ntpd[1101]: Listen normally on 2 lo 127.0.0.1:123 Oct 17 11:26:04 volumio-x86 ntpd[1101]: Listen normally on 3 eth0 192.168.10.112:123 Oct 17 11:26:04 volumio-x86 ntpd[1101]: Listening on routing socket on fd #20 for interface updates Oct 17 11:26:04 volumio-x86 ntpd[1101]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 17 11:26:04 volumio-x86 ntpd[1101]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Oct 17 11:26:05 volumio-x86 volumio[839]: info: Loading plugin "network"... Oct 17 11:26:05 volumio-x86 volumio[839]: info: Refreshing Cached IP Addresses Oct 17 11:26:05 volumio-x86 volumio[839]: info: Loading plugin "services"... Oct 17 11:26:05 volumio-x86 volumio[839]: info: Loading plugin "alsa_controller"... Oct 17 11:26:05 volumio-x86 sudo[1112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 17 11:26:05 volumio-x86 sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 11:26:05 volumio-x86 sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 11:26:05 volumio-x86 sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:05 volumio-x86 sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:05 volumio-x86 sudo[1112]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:05 volumio-x86 sudo[1108]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:05 volumio-x86 sudo[1112]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:05 volumio-x86 sudo[1110]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:05 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 11:26:05 volumio-x86 volumio[839]: info: Loading plugin "wizard"... Oct 17 11:26:05 volumio-x86 volumio[839]: info: Loading plugin "networkfs"... Oct 17 11:26:05 volumio-x86 volumio[839]: info: Starting Udev Watcher for removable devices Oct 17 11:26:05 volumio-x86 volumio[839]: info: Ignoring mount for partition: boot Oct 17 11:26:05 volumio-x86 volumio[839]: info: Ignoring mount for partition: volumio Oct 17 11:26:05 volumio-x86 volumio[839]: info: Ignoring mount for partition: volumio_data Oct 17 11:26:05 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 11:26:05 volumio-x86 volumio[839]: info: Loading plugin "volumio_command_line_client"... Oct 17 11:26:06 volumio-x86 volumio[839]: info: Loading plugin "upnp"... Oct 17 11:26:06 volumio-x86 volumio[839]: info: [1729135566017] Starting Upmpd Daemon Oct 17 11:26:06 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 11:26:06 volumio-x86 volumio[839]: info: Loading plugin "my_music"... Oct 17 11:26:06 volumio-x86 volumio[839]: info: Loading plugin "mpd"... Oct 17 11:26:06 volumio-x86 ntpd[1101]: Soliciting pool server 210.243.152.152 Oct 17 11:26:06 volumio-x86 dbus-daemon[608]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.6' (uid=0 pid=1034 comm="/usr/lib/chromium/chromium --show-component-extens") Oct 17 11:26:06 volumio-x86 systemd[1]: Starting Bluetooth service... Oct 17 11:26:06 volumio-x86 bluetoothd[1134]: Bluetooth daemon 5.50 Oct 17 11:26:06 volumio-x86 bluetoothd[1134]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Oct 17 11:26:06 volumio-x86 dbus-daemon[608]: [system] Successfully activated service 'org.bluez' Oct 17 11:26:06 volumio-x86 systemd[1]: Started Bluetooth service. Oct 17 11:26:06 volumio-x86 bluetoothd[1134]: Starting SDP server Oct 17 11:26:06 volumio-x86 bluetoothd[1134]: Excluding (cli) sap Oct 17 11:26:06 volumio-x86 volumio[839]: info: Loading plugin "upnp_browser"... Oct 17 11:26:06 volumio-x86 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Oct 17 11:26:06 volumio-x86 kernel: Bluetooth: BNEP filters: protocol multicast Oct 17 11:26:06 volumio-x86 kernel: Bluetooth: BNEP socket layer initialized Oct 17 11:26:06 volumio-x86 dbus-daemon[608]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.7' (uid=0 pid=1134 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Oct 17 11:26:06 volumio-x86 bluetoothd[1134]: Bluetooth management interface 1.22 initialized Oct 17 11:26:06 volumio-x86 systemd[1]: Starting Hostname Service... Oct 17 11:26:06 volumio-x86 ntpd[1101]: Soliciting pool server 17.253.116.253 Oct 17 11:26:06 volumio-x86 dbus-daemon[608]: [system] Successfully activated service 'org.freedesktop.hostname1' Oct 17 11:26:06 volumio-x86 systemd[1]: Started Hostname Service. Oct 17 11:26:07 volumio-x86 ntpd[1101]: Soliciting pool server 125.229.106.76 Oct 17 11:26:07 volumio-x86 volumio[839]: info: Loading plugin "alarm-clock"... Oct 17 11:26:07 volumio-x86 nmbd[783]: [2024/10/17 11:26:07.395805, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 17 11:26:07 volumio-x86 nmbd[783]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 17 11:26:07 volumio-x86 systemd[1]: Started Samba NMB Daemon. Oct 17 11:26:07 volumio-x86 systemd[1]: Starting Samba Winbind Daemon... Oct 17 11:26:07 volumio-x86 volumio[839]: info: Loading plugin "airplay_emulation"... Oct 17 11:26:07 volumio-x86 volumio[839]: info: Starting Shairport Sync Oct 17 11:26:07 volumio-x86 volumio[839]: info: Loading plugin "last_100"... Oct 17 11:26:07 volumio-x86 volumio[839]: info: Loading plugin "webradio"... Oct 17 11:26:07 volumio-x86 ntpd[1101]: Soliciting pool server 114.34.171.136 Oct 17 11:26:07 volumio-x86 ntpd[1101]: Soliciting pool server 103.147.22.149 Oct 17 11:26:07 volumio-x86 volumio[839]: info: Loading plugin "i2s_dacs"... Oct 17 11:26:07 volumio-x86 volumio[839]: info: I2S DAC not set, start Auto-detection Oct 17 11:26:08 volumio-x86 volumio[839]: info: Loading plugin "volumiodiscovery"... Oct 17 11:26:08 volumio-x86 winbindd[1176]: [2024/10/17 11:26:08.033068, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Oct 17 11:26:08 volumio-x86 winbindd[1176]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 17 11:26:08 volumio-x86 winbindd[1176]: [2024/10/17 11:26:08.061196, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 17 11:26:08 volumio-x86 systemd[1]: Started Samba Winbind Daemon. Oct 17 11:26:08 volumio-x86 winbindd[1176]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 17 11:26:08 volumio-x86 systemd[1]: Starting Samba SMB Daemon... Oct 17 11:26:08 volumio-x86 volumio[839]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 17 11:26:08 volumio-x86 node[839]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 17 11:26:08 volumio-x86 volumio[839]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 11:26:08 volumio-x86 volumio[839]: *** WARNING *** For more information see Oct 17 11:26:08 volumio-x86 volumio[839]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 17 11:26:08 volumio-x86 volumio[839]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 11:26:08 volumio-x86 volumio[839]: *** WARNING *** For more information see Oct 17 11:26:08 volumio-x86 node[839]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 11:26:08 volumio-x86 node[839]: *** WARNING *** For more information see Oct 17 11:26:08 volumio-x86 node[839]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 17 11:26:08 volumio-x86 node[839]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 11:26:08 volumio-x86 node[839]: *** WARNING *** For more information see Oct 17 11:26:08 volumio-x86 volumio[839]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 17 11:26:08 volumio-x86 volumio[839]: info: Discovery: Started advertising with name: Volumio X86 Oct 17 11:26:08 volumio-x86 ntpd[1101]: Soliciting pool server 183.177.72.202 Oct 17 11:26:08 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 11:26:08 volumio-x86 volumio[839]: info: Loading plugin "peppy_screensaver"... Oct 17 11:26:08 volumio-x86 smbd[1203]: [2024/10/17 11:26:08.840553, 0] ../lib/util/become_daemon.c:138(daemon_ready) Oct 17 11:26:08 volumio-x86 smbd[1203]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 17 11:26:08 volumio-x86 systemd[1]: Started Samba SMB Daemon. Oct 17 11:26:08 volumio-x86 systemd[1]: Reached target Multi-User System. Oct 17 11:26:08 volumio-x86 systemd[1]: Reached target Graphical Interface. Oct 17 11:26:08 volumio-x86 systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 17 11:26:08 volumio-x86 ntpd[1101]: Soliciting pool server 118.163.74.161 Oct 17 11:26:08 volumio-x86 ntpd[1101]: Soliciting pool server 118.163.81.61 Oct 17 11:26:08 volumio-x86 ntpd[1101]: Soliciting pool server 125.229.162.223 Oct 17 11:26:08 volumio-x86 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 17 11:26:08 volumio-x86 systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 17 11:26:08 volumio-x86 systemd[1]: Startup finished in 3.728s (firmware) + 2.802s (loader) + 15.912s (kernel) + 18.848s (userspace) = 41.291s. Oct 17 11:26:08 volumio-x86 ntpd[1101]: Soliciting pool server 218.35.163.245 Oct 17 11:26:09 volumio-x86 volumio[839]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 17 11:26:09 volumio-x86 volumio[839]: info: Loading plugin "outputs"... Oct 17 11:26:09 volumio-x86 volumio[839]: info: Loading plugin "albumart"... Oct 17 11:26:09 volumio-x86 volumio[839]: info: Plugin example_plugin is not enabled Oct 17 11:26:09 volumio-x86 volumio[839]: info: Loading plugin "inputs"... Oct 17 11:26:09 volumio-x86 volumio[839]: info: Loading plugin "updater_comm"... Oct 17 11:26:09 volumio-x86 volumio[839]: info: Plugin mpdemulation is not enabled Oct 17 11:26:09 volumio-x86 volumio[839]: info: Loading plugin "rest_api"... Oct 17 11:26:09 volumio-x86 volumio[839]: info: Loading plugin "websocket"... Oct 17 11:26:09 volumio-x86 volumio[839]: Forking 1 albumart workers Oct 17 11:26:09 volumio-x86 volumio[839]: info: Starting Socket.io Server version 2.3.0 Oct 17 11:26:09 volumio-x86 volumio[839]: info: Loading i18n strings for locale zh_TW Oct 17 11:26:09 volumio-x86 volumio[839]: Updating browse sources language Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:26:09 volumio-x86 ntpd[1101]: Soliciting pool server 114.33.15.129 Oct 17 11:26:09 volumio-x86 ntpd[1101]: Soliciting pool server 2406:2000:fc:437::2000 Oct 17 11:26:09 volumio-x86 ntpd[1101]: Soliciting pool server 122.117.253.246 Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::initPlayerControls Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 11:26:09 volumio-x86 volumio[839]: Express server listening on port 3000 Oct 17 11:26:09 volumio-x86 volumio[839]: [Metrics] WebUI: 10s 229.06ms Oct 17 11:26:09 volumio-x86 volumio[839]: info: Setting Device type: x86 Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreStateMachine::resetVolumioState Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreStateMachine::getcurrentVolume Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 11:26:09 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:09 volumio-x86 volumio[839]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 17 11:26:09 volumio-x86 volumio[839]: info: Completed loading Core Plugins Oct 17 11:26:09 volumio-x86 volumio[839]: info: Preparing to generate the ALSA configuration file Oct 17 11:26:10 volumio-x86 ntpd[1101]: Soliciting pool server 220.134.230.37 Oct 17 11:26:10 volumio-x86 volumio[839]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 17 11:26:10 volumio-x86 volumio[839]: wlan0 Interface doesn't support scanning. Oct 17 11:26:10 volumio-x86 volumio[839]: info: Cannot use regular scanning, forcing with ap-force Oct 17 11:26:10 volumio-x86 sudo[1239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 17 11:26:10 volumio-x86 sudo[1239]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:10 volumio-x86 sudo[1239]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:10 volumio-x86 volumio[839]: command failed: No such device (-19) Oct 17 11:26:10 volumio-x86 volumio[839]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Oct 17 11:26:10 volumio-x86 volumio[839]: command failed: No such device (-19) Oct 17 11:26:10 volumio-x86 volumio[839]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 17 11:26:10 volumio-x86 volumio[839]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 17 11:26:10 volumio-x86 volumio[839]: info: Reading ALSA contributions from plugins. Oct 17 11:26:10 volumio-x86 volumio[839]: Starting albumart workers Oct 17 11:26:10 volumio-x86 volumio[839]: verbose: New Socket.io Connection to 192.168.10.112 from 192.168.10.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 17 11:26:10 volumio-x86 volumio[839]: verbose: New Socket.io Connection to 192.168.10.112 from 192.168.10.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 11:26:10 volumio-x86 volumio[839]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 17 11:26:10 volumio-x86 volumio[839]: info: Reloading queue from file Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 11:26:10 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:10 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:10 volumio-x86 volumio[839]: info: Listing playlists Oct 17 11:26:10 volumio-x86 volumio[839]: info: VolumeController:: Volume=96 Mute =false Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreStateMachine::updateTrackBlock Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrackBlock Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreStateMachine::setRepeat null single undefined Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreStateMachine::setRandom null Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:26:10 volumio-x86 volumio[839]: info: Discovery: adding 6576be8c-9ca3-4f6e-ad09-3e064e726785 Oct 17 11:26:10 volumio-x86 volumio[839]: info: Discovery: Found device Volumio X86 Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:10 volumio-x86 volumio[839]: info: VolumeController:: Volume=96 Mute =false Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:26:10 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:10 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:26:10 volumio-x86 volumio[839]: info: Asound.conf file unchanged, so no further update is needed Oct 17 11:26:10 volumio-x86 volumio[839]: info: Output device has changed, restarting MPD Oct 17 11:26:11 volumio-x86 sudo[1264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 11:26:11 volumio-x86 sudo[1264]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:11 volumio-x86 sudo[1264]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:11 volumio-x86 volumio[839]: info: Output device has changed, restarting Shairport Sync Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:11 volumio-x86 sudo[1267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 11:26:11 volumio-x86 sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:11 volumio-x86 systemd[1]: Listening on mpd.socket. Oct 17 11:26:11 volumio-x86 volumio[839]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 11:26:11 volumio-x86 volumio[839]: info: ___________ START PLUGINS ___________ Oct 17 11:26:11 volumio-x86 volumio[839]: info: ControllerMpd::onStart: Initializing MPD Oct 17 11:26:11 volumio-x86 volumio[839]: info: Creating MPD Configuration file Oct 17 11:26:11 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 11:26:11 volumio-x86 sudo[1274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 11:26:11 volumio-x86 sudo[1274]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 11:26:11 volumio-x86 volumio[839]: info: [1729135571276] CoreMusicLibrary::Adding element Media Servers Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:26:11 volumio-x86 sudo[1274]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:11 volumio-x86 sudo[1276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:11 volumio-x86 sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:11 volumio-x86 sudo[1272]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 11:26:11 volumio-x86 sudo[1272]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:11 volumio-x86 sudo[1272]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 17 11:26:11 volumio-x86 sudo[1272]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:11 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 11:26:11 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 11:26:11 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 11:26:11 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 11:26:11 volumio-x86 volumio[839]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:11 volumio-x86 sudo[1284]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 11:26:11 volumio-x86 sudo[1284]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:11 volumio-x86 sudo[1284]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 17 11:26:11 volumio-x86 sudo[1284]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:11 volumio-x86 volumio[839]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 11:26:11 volumio-x86 volumio[839]: info: [1729135571576] CoreMusicLibrary::Adding element Last_100 Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 11:26:11 volumio-x86 volumio[839]: info: [1729135571588] CoreMusicLibrary::Adding element Webradio Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 11:26:11 volumio-x86 volumio[839]: info: Initializing BBC Radios Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:11 volumio-x86 volumio[839]: info: Loading i18n strings for locale zh_TW Oct 17 11:26:11 volumio-x86 volumio[839]: info: /tmp/myfifo created Oct 17 11:26:11 volumio-x86 volumio[839]: info: /tmp/myfifosa created Oct 17 11:26:11 volumio-x86 sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 17 11:26:11 volumio-x86 sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:11 volumio-x86 sudo[1305]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:11 volumio-x86 volumio[839]: info: snd-dummy loaded Oct 17 11:26:11 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 11:26:12 volumio-x86 volumio[839]: info: Volumio Calling Home Oct 17 11:26:12 volumio-x86 volumio[839]: info: MPD Permissions set Oct 17 11:26:12 volumio-x86 volumio[839]: info: MPD Permissions set Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:12 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:12 volumio-x86 volumio[839]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 11:26:12 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:13 volumio-x86 volumio[839]: info: Volumio called home Oct 17 11:26:13 volumio-x86 sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 11:26:13 volumio-x86 sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:13 volumio-x86 volumio[839]: info: Starting Shairport Sync Oct 17 11:26:13 volumio-x86 volumio-remote-updater[604]: [2024-10-17 11:26:13] [connect] Successful connection Oct 17 11:26:13 volumio-x86 sudo[1343]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:13 volumio-x86 volumio[839]: info: Starting Shairport Sync Oct 17 11:26:13 volumio-x86 volumio[839]: info: Starting Shairport Sync Oct 17 11:26:13 volumio-x86 sudo[1346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 11:26:13 volumio-x86 sudo[1346]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:13 volumio-x86 volumio[839]: info: Starting Shairport Sync Oct 17 11:26:13 volumio-x86 sudo[1348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 11:26:13 volumio-x86 sudo[1348]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:13 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 11:26:13 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 11:26:13 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 11:26:13 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 11:26:13 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:13 volumio-x86 sudo[1351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 11:26:13 volumio-x86 sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:13 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:13 volumio-x86 sudo[1346]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:13 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 11:26:13 volumio-x86 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 17 11:26:13 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 11:26:13 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 11:26:13 volumio-x86 sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 11:26:13 volumio-x86 sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:13 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 11:26:13 volumio-x86 sudo[1348]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:13 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 11:26:13 volumio-x86 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 17 11:26:13 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 11:26:13 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 11:26:13 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 11:26:13 volumio-x86 sudo[1351]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:13 volumio-x86 sudo[1354]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:13 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Oct 17 11:26:13 volumio-x86 sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 11:26:13 volumio-x86 sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:13 volumio-x86 volumio-remote-updater[604]: [2024-10-17 11:26:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1729135573 101 Oct 17 11:26:13 volumio-x86 volumio[839]: 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: 5 Oct 17 11:26:13 volumio-x86 sudo[1363]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:13 volumio-x86 volumio[839]: info: Shairport-Sync Started Oct 17 11:26:13 volumio-x86 volumio[839]: Error adding Membership: Error: addMembership EINVAL Oct 17 11:26:13 volumio-x86 volumio[839]: info: Shairport-Sync Started Oct 17 11:26:13 volumio-x86 volumio[839]: info: Shairport-Sync Started Oct 17 11:26:13 volumio-x86 volumio[839]: info: Shairport-Sync Started Oct 17 11:26:13 volumio-x86 volumio[839]: info: MPD Permissions set Oct 17 11:26:13 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:13 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:13 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:13 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:13 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:13 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:13 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:13 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:14 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:14 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 11:26:14 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:14 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 17 11:26:14 volumio-x86 sudo[1374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 11:26:14 volumio-x86 sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:14 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 11:26:14 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 11:26:14 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 11:26:14 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 11:26:14 volumio-x86 sudo[1378]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 11:26:14 volumio-x86 sudo[1378]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:14 volumio-x86 sudo[1378]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 17 11:26:14 volumio-x86 sudo[1378]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:15 volumio-x86 ntpd[1101]: receive: Unexpected origin timestamp 0xeabb0256.e677797f does not match aorg 0000000000.00000000 from server@183.177.72.202 xmt 0xeabb0257.4e76961a Oct 17 11:26:15 volumio-x86 ntpd[1101]: receive: Unexpected origin timestamp 0xeabb0256.e66e5c22 does not match aorg 0000000000.00000000 from server@220.134.230.37 xmt 0xeabb0257.4e82e9d8 Oct 17 11:26:15 volumio-x86 ntpd[1101]: receive: Unexpected origin timestamp 0xeabb0256.e675e574 does not match aorg 0000000000.00000000 from server@118.163.81.61 xmt 0xeabb0257.4e9d87dc Oct 17 11:26:15 volumio-x86 ntpd[1101]: receive: Unexpected origin timestamp 0xeabb0256.e67fec26 does not match aorg 0000000000.00000000 from server@210.243.152.152 xmt 0xeabb0257.4ebfc429 Oct 17 11:26:15 volumio-x86 ntpd[1101]: receive: Unexpected origin timestamp 0xeabb0256.e6728ec4 does not match aorg 0000000000.00000000 from server@114.33.15.129 xmt 0xeabb0257.4ebf38a9 Oct 17 11:26:15 volumio-x86 ntpd[1101]: receive: Unexpected origin timestamp 0xeabb0256.e6744e70 does not match aorg 0000000000.00000000 from server@118.163.74.161 xmt 0xeabb0257.584ae68f Oct 17 11:26:15 volumio-x86 ntpd[1101]: receive: Unexpected origin timestamp 0xeabb0256.e67b2756 does not match aorg 0000000000.00000000 from server@103.147.22.149 xmt 0xeabb0257.5a46fc28 Oct 17 11:26:16 volumio-x86 sudo[1494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 11:26:16 volumio-x86 sudo[1494]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:16 volumio-x86 sudo[1494]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:16 volumio-x86 sudo[1500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 11:26:16 volumio-x86 sudo[1500]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:16 volumio-x86 sudo[1500]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:16 volumio-x86 sudo[1513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 17 11:26:16 volumio-x86 sudo[1513]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:16 volumio-x86 systemd[1]: Started UPnP Renderer front-end to MPD. Oct 17 11:26:16 volumio-x86 sudo[1513]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:16 volumio-x86 volumio[839]: info: Upmpdcli Daemon Started Oct 17 11:26:16 volumio-x86 mpd[1389]: Oct 17 11:26 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 11:26:16 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 17 11:26:16 volumio-x86 sudo[1276]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:16 volumio-x86 sudo[1374]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:16 volumio-x86 sudo[1267]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:16 volumio-x86 volumio[839]: info: Completed starting Core Plugins Oct 17 11:26:16 volumio-x86 volumio[839]: info: ------------------------------------------- Oct 17 11:26:16 volumio-x86 volumio[839]: info: ----- MyVolumio plugins startup ---- Oct 17 11:26:16 volumio-x86 volumio[839]: info: ------------------------------------------- Oct 17 11:26:16 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 17 11:26:16 volumio-x86 volumio[839]: error: MPD error: The expression evaluated to a falsy value: Oct 17 11:26:16 volumio-x86 volumio[839]: assert.ok(self.idling) Oct 17 11:26:16 volumio-x86 volumio[839]: error: The expression evaluated to a falsy value: Oct 17 11:26:16 volumio-x86 volumio[839]: assert.ok(self.idling) Oct 17 11:26:17 volumio-x86 volumio[839]: error: MPD error: The expression evaluated to a falsy value: Oct 17 11:26:17 volumio-x86 volumio[839]: assert.ok(self.idling) Oct 17 11:26:17 volumio-x86 volumio[839]: error: The expression evaluated to a falsy value: Oct 17 11:26:17 volumio-x86 volumio[839]: assert.ok(self.idling) Oct 17 11:26:17 volumio-x86 volumio[839]: info: MPD running with PID1389 Oct 17 11:26:17 volumio-x86 volumio[839]: ,establishing connection Oct 17 11:26:17 volumio-x86 volumio[839]: error: updateQueue error: null Oct 17 11:26:17 volumio-x86 volumio[839]: error: updateQueue error: null Oct 17 11:26:17 volumio-x86 volumio[1519]: Generating RSA private key, 4096 bit long modulus (2 primes) Oct 17 11:26:17 volumio-x86 volumio[839]: 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 Oct 17 11:26:20 volumio-x86 volumio[1519]: .............................................................................................++++ Oct 17 11:26:20 volumio-x86 volumio[839]: 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: 7 Oct 17 11:26:21 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:21 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:22 volumio-x86 volumio[839]: 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 Oct 17 11:26:22 volumio-x86 volumio[1519]: ...................................................................++++ Oct 17 11:26:22 volumio-x86 volumio[1519]: e is 65537 (0x010001) Oct 17 11:26:22 volumio-x86 volumio[1519]: writing RSA key Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:22 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 11:26:22 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:22 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:22 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:22 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:22 volumio-x86 volumio[839]: info: Listing playlists Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:22 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 11:26:22 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:22 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:22 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:22 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:22 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 11:26:22 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:22 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:22 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:22 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:22 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:22 volumio-x86 volumio[839]: info: Listing playlists Oct 17 11:26:24 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 17 11:26:25 volumio-x86 systemd[1]: systemd-fsckd.service: Succeeded. Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 17 11:26:25 volumio-x86 volumio[839]: info: Adding plugin bluetooth to MyMusic Plugins Oct 17 11:26:25 volumio-x86 volumio[839]: info: Adding plugin multiroom to MyMusic Plugins Oct 17 11:26:25 volumio-x86 volumio[839]: info: Adding plugin metavolumio to MyMusic Plugins Oct 17 11:26:25 volumio-x86 volumio[839]: info: Adding plugin cd_controller to MyMusic Plugins Oct 17 11:26:25 volumio-x86 volumio[839]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 17 11:26:25 volumio-x86 volumio[839]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 17 11:26:25 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 17 11:26:26 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 17 11:26:26 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 17 11:26:26 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:26 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:26 volumio-x86 volumio[839]: info: Starting MyVolumio Remote Streaming Endpoints Oct 17 11:26:26 volumio-x86 volumio[839]: info: MyVolumio login type: Token Oct 17 11:26:26 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 17 11:26:26 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 17 11:26:28 volumio-x86 volumio[839]: info: Starting Streaming Service Transparent Proxy Oct 17 11:26:28 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 17 11:26:28 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 17 11:26:28 volumio-x86 volumio[839]: info: Streaming services startup Oct 17 11:26:28 volumio-x86 volumio[839]: info: Starting Streaming Daemon Oct 17 11:26:28 volumio-x86 volumio[839]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 17 11:26:28 volumio-x86 sudo[1624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 17 11:26:28 volumio-x86 sudo[1624]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:28 volumio-x86 sudo[1624]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:28 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 11:26:28 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:28 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:28 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:28 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:28 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:28 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:28 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:28 volumio-x86 volumio[839]: error: Cannot start Volumio Streaming Daemon Oct 17 11:26:28 volumio-x86 volumio[839]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 17 11:26:28 volumio-x86 volumio[839]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 17 11:26:29 volumio-x86 volumio[839]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 17 11:26:29 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Oct 17 11:26:29 volumio-x86 volumio[839]: info: MyVolumio login type: Token Oct 17 11:26:30 volumio-x86 volumio[839]: STREAMING PROXY: Starting server on port 3245 Oct 17 11:26:30 volumio-x86 volumio[839]: Node JS runtime: 14 Oct 17 11:26:30 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 17 11:26:30 volumio-x86 volumio[839]: info: MyVolumio token set successfully Oct 17 11:26:30 volumio-x86 volumio[839]: info: MYVOLUMIO: Adding device Oct 17 11:26:30 volumio-x86 volumio[839]: info: MYVOLUMIO: Evaluating Server Oct 17 11:26:31 volumio-x86 volumio[839]: info: MyVolumio status changed Oct 17 11:26:31 volumio-x86 volumio[839]: info: Streaming services startup Oct 17 11:26:31 volumio-x86 volumio[839]: info: Starting Streaming Daemon Oct 17 11:26:31 volumio-x86 volumio[839]: info: Removing browser output: myVolumio user plan is not superstar Oct 17 11:26:31 volumio-x86 volumio[839]: info: Removing audio output: Oct 17 11:26:31 volumio-x86 volumio[839]: info: Stoppping Tunnel 1 Oct 17 11:26:31 volumio-x86 sudo[1649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 17 11:26:31 volumio-x86 sudo[1649]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:31 volumio-x86 sudo[1649]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:31 volumio-x86 sudo[1652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 17 11:26:31 volumio-x86 volumio[839]: error: Cannot start Volumio Streaming Daemon Oct 17 11:26:31 volumio-x86 volumio[839]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 17 11:26:31 volumio-x86 volumio[839]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 17 11:26:31 volumio-x86 sudo[1652]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:31 volumio-x86 sudo[1652]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:31 volumio-x86 volumio[839]: info: Remote SSH Stopped Oct 17 11:26:31 volumio-x86 volumio[839]: info: Setting Geolocation for MyVolumio to as1 Oct 17 11:26:31 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:31 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:31 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:32 volumio-x86 volumio[839]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 17 11:26:32 volumio-x86 volumio[839]: info: Updating MyVolumio device info Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 11:26:32 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:32 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:32 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 11:26:32 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:32 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:32 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:32 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:33 volumio-x86 volumio[839]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:33 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 11:26:33 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:33 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:33 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 11:26:33 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:33 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:33 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:33 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:36 volumio-x86 volumio[839]: info: MYVOLUMIO: Adding device Oct 17 11:26:36 volumio-x86 volumio[839]: info: MYVOLUMIO: Evaluating Server Oct 17 11:26:37 volumio-x86 volumio[839]: info: Setting Geolocation for MyVolumio to as1 Oct 17 11:26:37 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:37 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:37 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:37 volumio-x86 systemd[1]: systemd-hostnamed.service: Succeeded. Oct 17 11:26:37 volumio-x86 volumio[839]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 17 11:26:38 volumio-x86 volumio[839]: info: Updating MyVolumio device info Oct 17 11:26:38 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:38 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:38 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:38 volumio-x86 volumio[839]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 17 11:26:38 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 11:26:38 volumio-x86 volumio[839]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 17 11:26:38 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 17 11:26:38 volumio-x86 volumio[839]: info: Received Get System Version Oct 17 11:26:38 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 11:26:38 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:38 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:38 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:38 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:38 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:38 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:38 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:41 volumio-x86 sudo[1679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 11:26:41 volumio-x86 sudo[1679]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:41 volumio-x86 sudo[1679]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:41 volumio-x86 sudo[1682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 11:26:41 volumio-x86 sudo[1682]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:26:41 volumio-x86 sudo[1682]: pam_unix(sudo:session): session closed for user root Oct 17 11:26:41 volumio-x86 volumio[839]: verbose: New Socket.io Connection to 192.168.10.112 from 192.168.10.137 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:41 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 11:26:41 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:41 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:41 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:41 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:41 volumio-x86 volumio[839]: info: Listing playlists Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 11:26:41 volumio-x86 volumio[839]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 17 11:26:41 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:41 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:42 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:42 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:42 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 11:26:42 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:42 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 11:26:42 volumio-x86 volumio-remote-updater[604]: No test mode Oct 17 11:26:42 volumio-x86 volumio-remote-updater[604]: No alpha test mode Oct 17 11:26:42 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 17 11:26:42 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 11:26:43 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:43 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:43 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:43 volumio-x86 volumio[839]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 11:26:43 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:43 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:43 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:43 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:26:44 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:44 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:46 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetQueue Oct 17 11:26:46 volumio-x86 volumio[839]: info: CoreStateMachine::getQueue Oct 17 11:26:46 volumio-x86 volumio[839]: info: CorePlayQueue::getQueue Oct 17 11:26:46 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:46 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:46 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 17 11:26:46 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 17 11:26:46 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 17 11:26:46 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetBrowseSources Oct 17 11:26:46 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 11:26:48 volumio-x86 volumio[839]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 17 11:26:48 volumio-x86 volumio[839]: info: Completed starting MyVolumio Plugin Oct 17 11:26:48 volumio-x86 volumio[839]: info: BOOT COMPLETED Oct 17 11:26:48 volumio-x86 volumio[839]: [Metrics] CommandRouter: 47s 429.75ms Oct 17 11:26:48 volumio-x86 volumio[839]: info: CoreCommandRouter::volumiosetStartupVolume Oct 17 11:26:48 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 11:26:48 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 11:26:48 volumio-x86 volumio[839]: info: CoreCommandRouter::Close All Modals sent Oct 17 11:26:48 volumio-x86 volumio[839]: info: CoreCommandRouter::Close All Modals sent Oct 17 11:26:49 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 17 11:26:49 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 17 11:26:49 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 17 11:26:51 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 17 11:26:55 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:55 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:56 volumio-x86 volumiologrotate[624]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Oct 17 11:26:56 volumio-x86 volumiologrotate[624]: ls: cannot access 'X86': No such file or directory Oct 17 11:26:56 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 11:26:56 volumio-x86 volumio[839]: info: CURURI: music-library Oct 17 11:26:56 volumio-x86 volumio[839]: info: Preload queue cleared Oct 17 11:26:57 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 17 11:26:57 volumio-x86 volumio[839]: info: CURURI: music-library/USB Oct 17 11:26:57 volumio-x86 volumio[839]: info: Preload queue cleared Oct 17 11:26:57 volumio-x86 volumio[839]: info: Preloading song: music-library/USB/赵鹏 - 乌兰巴托的夜晚.flac Oct 17 11:26:57 volumio-x86 volumio[839]: info: Preloading song: music-library/USB/赵鹏 - 北国之春.flac Oct 17 11:26:57 volumio-x86 volumio[839]: info: Preloading song: music-library/USB/江智民,周虹 - 有没有人告诉你.flac Oct 17 11:26:57 volumio-x86 volumio[839]: info: Preloading song: music-library/USB/区瑞强 - 偏偏喜欢你.flac Oct 17 11:26:57 volumio-x86 volumio[839]: info: Preloading song: music-library/USB/赵鹏 - 白月光.flac Oct 17 11:26:57 volumio-x86 volumio[839]: info: Preloading song: music-library/USB/蔡琴 - 恰似你的温柔.flac Oct 17 11:26:57 volumio-x86 volumio[839]: info: Exploding uri music-library/USB/赵鹏 - 乌兰巴托的夜晚.flac in service mpd Oct 17 11:26:57 volumio-x86 volumio[839]: info: ALBUMART /albumart?cacheid=609&web=%E8%B5%B5%E9%B9%8F/%E4%B8%AD%E5%9B%BD%E6%9C%80%E5%A5%BD%E5%A3%B0%E9%9F%B3%3A%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E4%B8%93%E7%94%A8%E5%A4%A7%E7%A2%9F/extralarge&path=%2Fmnt%2FUSB%2F%E8%B5%B5%E9%B9%8F%20-%20%E4%B9%8C%E5%85%B0%E5%B7%B4%E6%89%98%E7%9A%84%E5%A4%9C%E6%99%9A.flac&metadata=false Oct 17 11:26:57 volumio-x86 volumio[839]: info: URI /mnt/USB/赵鹏 - 乌兰巴托的夜晚.flac Oct 17 11:26:57 volumio-x86 volumio[839]: info: Exploding uri music-library/USB/赵鹏 - 北国之春.flac in service mpd Oct 17 11:26:57 volumio-x86 volumio[839]: info: ALBUMART /albumart?cacheid=609&web=%E8%B5%B5%E9%B9%8F/%E4%B8%AD%E5%9B%BD%E6%9C%80%E5%A5%BD%E5%A3%B0%E9%9F%B3%3A%E4%BA%BA%E5%A3%B0%E6%B5%8B%E8%AF%95%E4%B8%93%E7%94%A8%E5%A4%A7%E7%A2%9F/extralarge&path=%2Fmnt%2FUSB%2F%E8%B5%B5%E9%B9%8F%20-%20%E5%8C%97%E5%9B%BD%E4%B9%8B%E6%98%A5.flac&metadata=false Oct 17 11:26:57 volumio-x86 volumio[839]: info: URI /mnt/USB/赵鹏 - 北国之春.flac Oct 17 11:26:57 volumio-x86 volumio[839]: info: Exploding uri music-library/USB/江智民,周虹 - 有没有人告诉你.flac in service mpd Oct 17 11:26:57 volumio-x86 volumio[839]: info: ALBUMART /albumart?cacheid=609&web=%E6%B1%9F%E6%99%BA%E6%B0%91%2F%E5%91%A8%E8%99%B9/%E5%BD%93%E6%B5%81%E8%A1%8C%E9%81%87%E4%B8%8A%E5%8F%91%E7%83%A7%E6%97%B6/extralarge&path=%2Fmnt%2FUSB%2F%E6%B1%9F%E6%99%BA%E6%B0%91%2C%E5%91%A8%E8%99%B9%20-%20%E6%9C%89%E6%B2%A1%E6%9C%89%E4%BA%BA%E5%91%8A%E8%AF%89%E4%BD%A0.flac&metadata=false Oct 17 11:26:57 volumio-x86 volumio[839]: info: URI /mnt/USB/江智民,周虹 - 有没有人告诉你.flac Oct 17 11:26:58 volumio-x86 volumio[839]: info: Exploding uri music-library/USB/区瑞强 - 偏偏喜欢你.flac in service mpd Oct 17 11:26:58 volumio-x86 volumio[839]: info: ALBUMART /albumart?cacheid=609&web=%E5%8C%BA%E7%91%9E%E5%BC%BA/%E6%83%A0%E5%A8%81T200A%E8%AF%95%E9%9F%B3%E7%A2%9F/extralarge&path=%2Fmnt%2FUSB%2F%E5%8C%BA%E7%91%9E%E5%BC%BA%20-%20%E5%81%8F%E5%81%8F%E5%96%9C%E6%AC%A2%E4%BD%A0.flac&metadata=false Oct 17 11:26:58 volumio-x86 volumio[839]: info: URI /mnt/USB/区瑞强 - 偏偏喜欢你.flac Oct 17 11:26:58 volumio-x86 volumio[839]: info: Exploding uri music-library/USB/赵鹏 - 白月光.flac in service mpd Oct 17 11:26:58 volumio-x86 volumio[839]: info: ALBUMART /albumart?cacheid=609&web=%E8%B5%B5%E9%B9%8F/%E6%A2%A6%E2%80%94%E2%80%94%E7%8C%AE%E7%BB%99%E5%A4%A7%E4%BA%BA%E4%BB%AC%E7%9A%84%E6%91%87%E7%AF%AE%E6%9B%B2/extralarge&path=%2Fmnt%2FUSB%2F%E8%B5%B5%E9%B9%8F%20-%20%E7%99%BD%E6%9C%88%E5%85%89.flac&metadata=false Oct 17 11:26:58 volumio-x86 volumio[839]: info: URI /mnt/USB/赵鹏 - 白月光.flac Oct 17 11:26:58 volumio-x86 volumio[839]: info: Exploding uri music-library/USB/蔡琴 - 恰似你的温柔.flac in service mpd Oct 17 11:26:58 volumio-x86 volumio[839]: info: ALBUMART /albumart?cacheid=609&web=%E8%94%A1%E7%90%B4/%E7%B2%BE%E9%80%89%E8%94%A1%E7%90%B4/extralarge&path=%2Fmnt%2FUSB%2F%E8%94%A1%E7%90%B4%20-%20%E6%81%B0%E4%BC%BC%E4%BD%A0%E7%9A%84%E6%B8%A9%E6%9F%94.flac&metadata=false Oct 17 11:26:58 volumio-x86 volumio[839]: info: URI /mnt/USB/蔡琴 - 恰似你的温柔.flac Oct 17 11:26:59 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 11:26:59 volumio-x86 volumio[839]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 17 11:26:59 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 17 11:26:59 volumio-x86 volumio[839]: info: Received Get System Version Oct 17 11:26:59 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 11:26:59 volumio-x86 volumio[839]: info: Received Get System Info Oct 17 11:26:59 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 11:26:59 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 11:26:59 volumio-x86 volumio[839]: info: Discovery: Getting this device information Oct 17 11:26:59 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:26:59 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 0 Oct 17 11:26:59 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 11:27:01 volumio-x86 volumio[839]: info: Preload queue cleared Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::ClearQueue Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::stop Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 11:27:01 volumio-x86 volumio[839]: info: CorePlayQueue::clearPlayQueue Oct 17 11:27:01 volumio-x86 volumio[839]: info: CorePlayQueue::saveQueue Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushQueue Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::addQueueItems Oct 17 11:27:01 volumio-x86 volumio[839]: info: CorePlayQueue::addQueueItems Oct 17 11:27:01 volumio-x86 volumio[839]: info: Preload queue cleared Oct 17 11:27:01 volumio-x86 volumio[839]: info: Adding Item to queue: music-library/USB/赵鹏 - 乌兰巴托的夜晚.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Using cached record of: music-library/USB/赵鹏 - 乌兰巴托的夜晚.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Adding Item to queue: music-library/USB/赵鹏 - 北国之春.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Using cached record of: music-library/USB/赵鹏 - 北国之春.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Adding Item to queue: music-library/USB/江智民,周虹 - 有没有人告诉你.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Using cached record of: music-library/USB/江智民,周虹 - 有没有人告诉你.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Adding Item to queue: music-library/USB/区瑞强 - 偏偏喜欢你.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Using cached record of: music-library/USB/区瑞强 - 偏偏喜欢你.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Adding Item to queue: music-library/USB/赵鹏 - 白月光.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Using cached record of: music-library/USB/赵鹏 - 白月光.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Adding Item to queue: music-library/USB/蔡琴 - 恰似你的温柔.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Using cached record of: music-library/USB/蔡琴 - 恰似你的温柔.flac Oct 17 11:27:01 volumio-x86 volumio[839]: info: Adding Item to queue: music-library/USB/Windows Oct 17 11:27:01 volumio-x86 volumio[839]: info: Exploding uri music-library/USB/Windows in service mpd Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushQueue Oct 17 11:27:01 volumio-x86 volumio[839]: info: CorePlayQueue::saveQueue Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::updateTrackBlock Oct 17 11:27:01 volumio-x86 volumio[839]: info: CorePlayQueue::getTrackBlock Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPlay Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::play index 5 Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::stop Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::play index undefined Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 11:27:01 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:01 volumio-x86 volumio[839]: info: CoreStateMachine::startPlaybackTimer Oct 17 11:27:01 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:01 volumio-x86 volumio[839]: verbose: ControllerMpd::clearAddPlayTracks USB/蔡琴 - 恰似你的温柔.flac Oct 17 11:27:01 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 11:27:01 volumio-x86 volumio[839]: info: sendMpdCommand stop took 5 milliseconds Oct 17 11:27:01 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand clear Oct 17 11:27:01 volumio-x86 volumio[839]: info: sendMpdCommand clear took 1 milliseconds Oct 17 11:27:01 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand add "USB/蔡琴 - 恰似你的温柔.flac" Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces system playlist update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Ignoring MPD Status Update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces system playlist update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Ignoring MPD Status Update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces system playlist update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Ignoring MPD Status Update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces system playlist update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Ignoring MPD Status Update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces system playlist update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Ignoring MPD Status Update Oct 17 11:27:01 volumio-x86 volumio[839]: info: sendMpdCommand add "USB/蔡琴 - 恰似你的温柔.flac" took 9 milliseconds Oct 17 11:27:01 volumio-x86 volumio[839]: info: ------------------------------ 9ms Oct 17 11:27:01 volumio-x86 volumio[839]: info: ------------------------------ 7ms Oct 17 11:27:01 volumio-x86 volumio[839]: info: ------------------------------ 6ms Oct 17 11:27:01 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand play Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces system playlist update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Ignoring MPD Status Update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces system playlist update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Ignoring MPD Status Update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces system playlist update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Ignoring MPD Status Update Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:01 volumio-x86 volumio[839]: info: ------------------------------ 19ms Oct 17 11:27:01 volumio-x86 volumio[839]: info: sendMpdCommand play took 14 milliseconds Oct 17 11:27:01 volumio-x86 volumio[839]: info: ------------------------------ 15ms Oct 17 11:27:01 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:01 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:01 volumio-x86 volumio[839]: info: ------------------------------ 15ms Oct 17 11:27:01 volumio-x86 volumio[839]: info: ------------------------------ 12ms Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:01 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:01 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:01 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:01 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:01 volumio-x86 volumio[839]: info: Oct 17 11:27:01 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:01 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:01 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:02 volumio-x86 volumio[839]: info: Oct 17 11:27:02 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand status took 82 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand status took 81 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand status took 79 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand status took 75 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand status took 6 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:02 volumio-x86 volumio[839]: info: Oct 17 11:27:02 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:02 volumio-x86 volumio[839]: info: Oct 17 11:27:02 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:02 volumio-x86 volumio[839]: info: Oct 17 11:27:02 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand playlistinfo took 35 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseTrackInfo Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService play Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus stop Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"530 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService play Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus play Oct 17 11:27:02 volumio-x86 volumio[839]: info: Received an update from plugin. extracting info from payload Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: ------------------------------ 162ms Oct 17 11:27:02 volumio-x86 volumio[839]: info: ------------------------------ 172ms Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand playlistinfo took 86 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand status took 77 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand status took 72 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand status took 70 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseTrackInfo Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseTrackInfo Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseTrackInfo Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"581 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService play Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus play Oct 17 11:27:02 volumio-x86 volumio[839]: info: Received an update from plugin. extracting info from payload Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"581 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService play Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus play Oct 17 11:27:02 volumio-x86 volumio[839]: info: Received an update from plugin. extracting info from payload Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"581 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService play Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus play Oct 17 11:27:02 volumio-x86 volumio[839]: info: Received an update from plugin. extracting info from payload Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: ------------------------------ 270ms Oct 17 11:27:02 volumio-x86 volumio[839]: info: ------------------------------ 268ms Oct 17 11:27:02 volumio-x86 volumio[839]: info: ------------------------------ 202ms Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand playlistinfo took 144 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand playlistinfo took 144 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: info: sendMpdCommand playlistinfo took 144 milliseconds Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: ControllerMpd::parseTrackInfo Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":500,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"881 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService play Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus play Oct 17 11:27:02 volumio-x86 volumio[839]: info: Received an update from plugin. extracting info from payload Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":500,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"881 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService play Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus play Oct 17 11:27:02 volumio-x86 volumio[839]: info: Received an update from plugin. extracting info from payload Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"play","position":0,"seek":500,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"881 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:02 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService play Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus play Oct 17 11:27:02 volumio-x86 volumio[839]: info: Received an update from plugin. extracting info from payload Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:02 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:02 volumio-x86 volumio[839]: info: ------------------------------ 395ms Oct 17 11:27:02 volumio-x86 volumio[839]: info: ------------------------------ 394ms Oct 17 11:27:02 volumio-x86 volumio[839]: info: ------------------------------ 389ms Oct 17 11:27:06 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:27:06 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:06 volumio-x86 sudo[1777]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 17 11:27:06 volumio-x86 sudo[1777]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 11:27:13 volumio-x86 volumio[839]: 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: 7 Oct 17 11:27:13 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioGetState Oct 17 11:27:13 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::pause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::stPlaybackTimer Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::servicePause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePause Oct 17 11:27:20 volumio-x86 volumio[839]: info: ControllerMpd::pause Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand pause Oct 17 11:27:20 volumio-x86 volumio[839]: info: Oct 17 11:27:20 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:20 volumio-x86 volumio[839]: info: sendMpdCommand pause took 4 milliseconds Oct 17 11:27:20 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:20 volumio-x86 volumio[839]: info: Oct 17 11:27:20 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:20 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:20 volumio-x86 volumio[839]: info: Oct 17 11:27:20 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:20 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:20 volumio-x86 volumio[839]: info: Oct 17 11:27:20 volumio-x86 volumio[839]: ---------------------------- MPD announces state update: player Oct 17 11:27:20 volumio-x86 volumio[839]: info: ControllerMpd::getState Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand status Oct 17 11:27:20 volumio-x86 volumio[839]: info: sendMpdCommand status took 7 milliseconds Oct 17 11:27:20 volumio-x86 volumio[839]: info: sendMpdCommand status took 6 milliseconds Oct 17 11:27:20 volumio-x86 volumio[839]: info: sendMpdCommand status took 5 milliseconds Oct 17 11:27:20 volumio-x86 volumio[839]: info: sendMpdCommand status took 3 milliseconds Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::parseState Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 11:27:20 volumio-x86 volumio[839]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 17 11:27:20 volumio-x86 volumio[839]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 17 11:27:20 volumio-x86 volumio[839]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 17 11:27:20 volumio-x86 volumio[839]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::parseTrackInfo Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::parseTrackInfo Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: ControllerMpd::parseTrackInfo Oct 17 11:27:20 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18736,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"795 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService pause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus pause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::stPlaybackTimer Oct 17 11:27:20 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18736,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"795 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService pause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus pause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::stPlaybackTimer Oct 17 11:27:20 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18736,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"795 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService pause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus pause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::stPlaybackTimer Oct 17 11:27:20 volumio-x86 volumio[839]: info: ControllerMpd::pushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::servicePushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18736,"duration":255,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"795 Kbps","isStreaming":false,"title":"恰似你的温柔","artist":"蔡琴","album":"精选蔡琴","uri":"USB/蔡琴 - 恰似你的温柔.flac","trackType":"flac"} Oct 17 11:27:20 volumio-x86 volumio[839]: verbose: CURRENT POSITION 5 Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::syncState stateService pause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::syncState currentStatus pause Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::pushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CorePlayQueue::getTrack 5 Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreCommandRouter::volumioPushState Oct 17 11:27:20 volumio-x86 volumio[839]: info: CoreStateMachine::stPlaybackTimer Oct 17 11:27:20 volumio-x86 volumio[839]: info: ------------------------------ 92ms Oct 17 11:27:20 volumio-x86 volumio[839]: info: ------------------------------ 93ms Oct 17 11:27:20 volumio-x86 volumio[839]: info: ------------------------------ 94ms Oct 17 11:27:20 volumio-x86 volumio[839]: info: ------------------------------ 92ms Oct 17 11:27:20 volumio-x86 volumio[839]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 11:27:20 volumio-x86 volumio[839]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 17 11:27:20 volumio-x86 volumio[839]: at Object.readdirSync (fs.js:1048:3) Oct 17 11:27:20 volumio-x86 volumio[839]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Oct 17 11:27:20 volumio-x86 volumio[839]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Oct 17 11:27:20 volumio-x86 volumio[839]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Oct 17 11:27:20 volumio-x86 volumio[839]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Oct 17 11:27:20 volumio-x86 volumio[839]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Oct 17 11:27:20 volumio-x86 volumio[839]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 11:27:20 volumio-x86 volumio[839]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Oct 17 11:27:20 volumio-x86 volumio[839]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Oct 17 11:27:20 volumio-x86 volumio[839]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 17 11:27:20 volumio-x86 volumio[839]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 11:27:20 volumio-x86 volumio[839]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Oct 17 11:27:20 volumio-x86 volumio[839]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 17 11:27:20 volumio-x86 volumio[839]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 11:27:20 volumio-x86 volumio[839]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Oct 17 11:27:20 volumio-x86 volumio[839]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Oct 17 11:27:20 volumio-x86 volumio[839]: errno: -20, Oct 17 11:27:20 volumio-x86 volumio[839]: syscall: 'scandir', Oct 17 11:27:20 volumio-x86 volumio[839]: code: 'ENOTDIR', Oct 17 11:27:20 volumio-x86 volumio[839]: path: '/tmp/peppyrunning' Oct 17 11:27:20 volumio-x86 volumio[839]: } Oct 17 11:27:20 volumio-x86 volumio[839]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 11:27:20 volumio-x86 sudo[1854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-17 11:26 Oct 17 11:27:20 volumio-x86 sudo[1854]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"