-- Logs begin at Sat 2025-05-24 23:05:15 CST, end at Sat 2025-05-24 23:07:17 CST. --
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 24 23:06:00 volumio volumio[1186]: info: Discovery: Getting this device information
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:00 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 24 23:06:00 volumio volumio[1186]: info: [1748099160041] CoreMusicLibrary::Adding element Jellyfin
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 24 23:06:00 volumio volumio[1186]: Cannot find translation for source Jellyfin
May 24 23:06:00 volumio volumio[1186]: info: [jellyfin] Initialized plugin with device info: {"id":"6576be8c-9ca3-4f6e-ad09-3e064e726785","host":"http://192.168.1.14","name":"Volumio","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":"","mute":false,"artist":"赵鹏","track":"乌兰巴托的夜晚","albumart":"http://192.168.1.14/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=%2FUSB&metadata=false"}}
May 24 23:06:00 volumio volumio[1186]: info: AutoStart - onStart
May 24 23:06:00 volumio volumio[1186]: info: Loading i18n strings for locale zh
May 24 23:06:00 volumio volumio[1186]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 24 23:06:00 volumio volumio[1186]: info: /tmp/myfifo created
May 24 23:06:00 volumio volumio[1186]: info: /tmp/myfifosa created
May 24 23:06:00 volumio sudo[1602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0
May 24 23:06:00 volumio sudo[1602]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:00 volumio sudo[1602]: pam_unix(sudo:session): session closed for user root
May 24 23:06:00 volumio volumio[1186]: info: snd-dummy loaded
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:00 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:06:00 volumio volumio[1186]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 24 23:06:00 volumio sudo[1622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
May 24 23:06:00 volumio volumio[1186]: info: Loading i18n strings for locale zh
May 24 23:06:00 volumio sudo[1622]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:00 volumio volumio[1186]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found.
May 24 23:06:00 volumio volumio[1186]: info: Volumio Calling Home
May 24 23:06:00 volumio systemd[1]: Started RoonBridge.
May 24 23:06:00 volumio sudo[1624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart logitechmediaserver
May 24 23:06:00 volumio sudo[1622]: pam_unix(sudo:session): session closed for user root
May 24 23:06:00 volumio sudo[1624]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:01 volumio systemd[1]: /data/plugins/music_service/lms/unit/logitechmediaserver.service:7: PIDFile= references path below legacy directory /var/run/, updating /var/run/logitechmediaserver.pid → /run/logitechmediaserver.pid; please update the unit file accordingly.
May 24 23:06:01 volumio systemd[1]: Starting Logitech Media Server Daemon...
May 24 23:06:01 volumio systemd[1]: Started Logitech Media Server Daemon.
May 24 23:06:01 volumio systemd[1641]: logitechmediaserver.service: Failed to execute command: No such file or directory
May 24 23:06:01 volumio systemd[1641]: logitechmediaserver.service: Failed at step EXEC spawning /usr/sbin/squeezeboxserver: No such file or directory
May 24 23:06:01 volumio systemd[1]: logitechmediaserver.service: Main process exited, code=exited, status=203/EXEC
May 24 23:06:01 volumio systemd[1]: logitechmediaserver.service: Failed with result 'exit-code'.
May 24 23:06:01 volumio sudo[1624]: pam_unix(sudo:session): session closed for user root
May 24 23:06:01 volumio systemd[1]: systemd-timedated.service: Succeeded.
May 24 23:06:01 volumio volumio[1186]: info: logitechmediaserver started
May 24 23:06:01 volumio volumio[1186]: info: MPD Permissions set
May 24 23:06:01 volumio volumio[1186]: info: MPD Permissions set
May 24 23:06:02 volumio volumio[1186]: error: error
May 24 23:06:02 volumio volumio[1186]: info: minidlna: Found miniDLNA version 1.2.1
May 24 23:06:02 volumio volumio[1186]: info: minidlna: Starting minidlna.service
May 24 23:06:02 volumio sudo[1648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service
May 24 23:06:02 volumio sudo[1648]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:02 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server.
May 24 23:06:02 volumio sudo[1654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl
May 24 23:06:02 volumio sudo[1648]: pam_unix(sudo:session): session closed for user root
May 24 23:06:02 volumio sudo[1654]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:02 volumio sudo[1654]: pam_unix(sudo:session): session closed for user root
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:02 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:02 volumio volumio[1186]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:02 volumio mpd[1586]: May 24 23:06 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 24 23:06:02 volumio systemd[1]: Started Music Player Daemon.
May 24 23:06:02 volumio sudo[1565]: pam_unix(sudo:session): session closed for user root
May 24 23:06:02 volumio sudo[1575]: pam_unix(sudo:session): session closed for user root
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:06:02 volumio RoonBridge[1628]: 00:00:00.021 Warn: get lock file path: /tmp/.rnbgem0-
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:02 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile
May 24 23:06:03 volumio volumio[1186]: info: minidlna: systemctl start minidlna.service succeeded.
May 24 23:06:03 volumio RoonBridge[1628]: 00:00:00.697 Trace: [childprocess] using unix child process
May 24 23:06:03 volumio sudo[1691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 24 23:06:03 volumio sudo[1691]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:03 volumio sudo[1691]: pam_unix(sudo:session): session closed for user root
May 24 23:06:03 volumio RoonBridge[1628]: 00:00:00.821 Debug: PathForResource, filename: ../.update
May 24 23:06:03 volumio sudo[1693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 24 23:06:03 volumio sudo[1693]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:03 volumio RoonBridge[1628]: 00:00:00.882 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update
May 24 23:06:03 volumio sudo[1693]: pam_unix(sudo:session): session closed for user root
May 24 23:06:03 volumio sudo[1697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 24 23:06:03 volumio sudo[1697]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:03 volumio sudo[1697]: pam_unix(sudo:session): session closed for user root
May 24 23:06:03 volumio RoonBridge[1628]: 00:00:00.900 Debug: PathForResource, filename: RAATServer
May 24 23:06:03 volumio RoonBridge[1628]: 00:00:00.903 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer
May 24 23:06:03 volumio RoonBridge[1628]: 00:00:00.904 Debug: PathForResource, filename: RoonBridgeHelper
May 24 23:06:03 volumio RoonBridge[1628]: 00:00:00.905 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper
May 24 23:06:03 volumio RoonBridge[1628]: Initializing
May 24 23:06:03 volumio volumio[1186]: info: MPD Permissions set
May 24 23:06:03 volumio RoonBridge[1628]: 00:00:01.019 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper
May 24 23:06:03 volumio volumio[1186]: info: Completed starting Core Plugins
May 24 23:06:03 volumio volumio[1186]: info: -------------------------------------------
May 24 23:06:03 volumio RoonBridge[1628]: 00:00:01.071 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer
May 24 23:06:03 volumio volumio[1186]: info: ----- MyVolumio plugins startup ----
May 24 23:06:03 volumio volumio[1186]: info: -------------------------------------------
May 24 23:06:03 volumio volumio[1186]: info: [MyVolumio PluginManager] Fetching plans data....
May 24 23:06:03 volumio volumio[1186]: info: Volumio called home
May 24 23:06:03 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd
May 24 23:06:03 volumio sudo[1712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 24 23:06:03 volumio sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:03 volumio RoonBridge[1628]: Not Running (.o)
May 24 23:06:03 volumio systemd[1]: Stopping Music Player Daemon...
May 24 23:06:03 volumio volumio[1186]: info: MPD running with PID1586
May 24 23:06:03 volumio volumio[1186]: ,establishing connection
May 24 23:06:03 volumio systemd[1]: mpd.service: Succeeded.
May 24 23:06:03 volumio systemd[1]: Stopped Music Player Daemon.
May 24 23:06:03 volumio volumio[1186]: info: Starting Shairport Sync
May 24 23:06:03 volumio systemd[1]: Starting Music Player Daemon...
May 24 23:06:03 volumio volumio[1186]: info: Starting Shairport Sync
May 24 23:06:03 volumio volumio[1186]: info: Starting Shairport Sync
May 24 23:06:03 volumio sudo[1715]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 24 23:06:03 volumio sudo[1715]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:03 volumio sudo[1715]: pam_unix(sudo:session): session closed for user root
May 24 23:06:04 volumio sudo[1719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 24 23:06:04 volumio sudo[1719]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:04 volumio volumio[1186]: info: Starting Shairport Sync
May 24 23:06:04 volumio sudo[1721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 24 23:06:04 volumio sudo[1721]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 24 23:06:04 volumio systemd[1]: shairport-sync.service: Succeeded.
May 24 23:06:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 24 23:06:04 volumio sudo[1726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 24 23:06:04 volumio sudo[1726]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 24 23:06:04 volumio sudo[1719]: pam_unix(sudo:session): session closed for user root
May 24 23:06:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 24 23:06:04 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
May 24 23:06:04 volumio systemd[1]: shairport-sync.service: Succeeded.
May 24 23:06:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 24 23:06:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 24 23:06:04 volumio sudo[1721]: pam_unix(sudo:session): session closed for user root
May 24 23:06:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 24 23:06:04 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
May 24 23:06:04 volumio systemd[1]: shairport-sync.service: Succeeded.
May 24 23:06:04 volumio volumio[1186]: error: MPD error: Error: write EPIPE
May 24 23:06:04 volumio volumio[1186]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
May 24 23:06:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 24 23:06:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 24 23:06:04 volumio sudo[1726]: pam_unix(sudo:session): session closed for user root
May 24 23:06:04 volumio sudo[1731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 24 23:06:04 volumio sudo[1731]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 24 23:06:04 volumio systemd[1]: shairport-sync.service: Succeeded.
May 24 23:06:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 24 23:06:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 24 23:06:04 volumio volumio[1186]: error: MPD error: The expression evaluated to a falsy value:
May 24 23:06:04 volumio volumio[1186]: assert.ok(self.idling)
May 24 23:06:04 volumio volumio[1186]: error: The expression evaluated to a falsy value:
May 24 23:06:04 volumio volumio[1186]: assert.ok(self.idling)
May 24 23:06:04 volumio volumio[1186]: error: MPD error: Error: write EPIPE
May 24 23:06:04 volumio volumio[1186]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
May 24 23:06:04 volumio volumio[1186]: error: MPD error: The expression evaluated to a falsy value:
May 24 23:06:04 volumio volumio[1186]: assert.ok(self.idling)
May 24 23:06:04 volumio volumio[1186]: error: The expression evaluated to a falsy value:
May 24 23:06:04 volumio volumio[1186]: assert.ok(self.idling)
May 24 23:06:04 volumio sudo[1731]: pam_unix(sudo:session): session closed for user root
May 24 23:06:04 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:04 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:04 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:04 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:04 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:04 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:06:04 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 24 23:06:04 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:04 volumio volumio[1186]: info: Shairport-Sync Started
May 24 23:06:05 volumio volumio[1186]: Error adding Membership: Error: addMembership EINVAL
May 24 23:06:05 volumio volumio[1186]: info: Shairport-Sync Started
May 24 23:06:05 volumio volumio[1186]: info: Shairport-Sync Started
May 24 23:06:05 volumio volumio[1186]: info: Shairport-Sync Started
May 24 23:06:05 volumio RoonBridge[1628]: Running
May 24 23:06:05 volumio sudo[1754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 24 23:06:05 volumio sudo[1754]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:05 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
May 24 23:06:05 volumio sudo[1754]: pam_unix(sudo:session): session closed for user root
May 24 23:06:05 volumio volumio[1186]: info: Upmpdcli Daemon Started
May 24 23:06:06 volumio RoonBridge[1628]: 00:00:00.185 Warn: get lock file path: /tmp/.rnbhgem0-
May 24 23:06:07 volumio mpd[1724]: May 24 23:06 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 24 23:06:07 volumio systemd[1]: Started Music Player Daemon.
May 24 23:06:07 volumio sudo[1712]: pam_unix(sudo:session): session closed for user root
May 24 23:06:07 volumio volumio[1186]: error: updateQueue error: null
May 24 23:06:07 volumio volumio[1186]: error: updateQueue error: null
May 24 23:06:07 volumio volumio[1757]: Generating RSA private key, 4096 bit long modulus (2 primes)
May 24 23:06:07 volumio volumio[1757]: ....++++
May 24 23:06:07 volumio volumio[1186]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
May 24 23:06:08 volumio volumio-remote-updater[686]: [2025-05-24 23:06:08] [connect] Successful connection
May 24 23:06:08 volumio volumio-remote-updater[686]: [2025-05-24 23:06:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748099168 101
May 24 23:06:08 volumio volumio[1186]: 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
May 24 23:06:10 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:10 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:10 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 24 23:06:10 volumio volumio[1757]: ..............................................................++++
May 24 23:06:10 volumio volumio[1757]: e is 65537 (0x010001)
May 24 23:06:10 volumio volumio[1757]: writing RSA key
May 24 23:06:11 volumio RoonBridge[1628]: 00:00:08.983 Warn: exception starting raatserver: System.Net.Sockets.SocketException (0x80004005): Connection refused
May 24 23:06:11 volumio RoonBridge[1628]: at System.Net.Sockets.TcpClient..ctor (System.String hostname, System.Int32 port) [0x0006d] in <08911f3881ec4a92acc8fdc4d13b73bf>:0
May 24 23:06:11 volumio RoonBridge[1628]: at Sooloos.RAATServer.ConnectOrStartAndWaitForExit (System.String path, System.String args, System.Action`1[T] status, Base.ChildProcess& p) [0x00165] in <5529660cb9214b5a92e49e1607b30d50>:0
May 24 23:06:11 volumio RoonBridge[1628]: Not Running (.o)
May 24 23:06:11 volumio RoonBridge[1628]: 00:00:09.043 Debug: PathForResource, filename: ../.update
May 24 23:06:11 volumio RoonBridge[1628]: 00:00:09.043 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update
May 24 23:06:13 volumio RoonBridge[1628]: 00:00:11.044 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer
May 24 23:06:13 volumio RoonBridge[1628]: Running
May 24 23:06:13 volumio volumio[1186]: 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
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 24 23:06:16 volumio volumio[1186]: info: Adding plugin bluetooth to MyMusic Plugins
May 24 23:06:16 volumio volumio[1186]: info: Adding plugin multiroom to MyMusic Plugins
May 24 23:06:16 volumio volumio[1186]: info: Adding plugin metavolumio to MyMusic Plugins
May 24 23:06:16 volumio volumio[1186]: info: Adding plugin cd_controller to MyMusic Plugins
May 24 23:06:16 volumio volumio[1186]: info: Adding plugin qobuzconnect to MyMusic Plugins
May 24 23:06:16 volumio volumio[1186]: info: Adding plugin smart_inputs to MyMusic Plugins
May 24 23:06:16 volumio volumio[1186]: info: Adding plugin tidalconnect to MyMusic Plugins
May 24 23:06:16 volumio volumio[1186]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 24 23:06:17 volumio volumio[1186]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 24 23:06:17 volumio volumio[1186]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 24 23:06:17 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:06:17 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:06:17 volumio volumio[1186]: info: Starting MyVolumio Remote Streaming Endpoints
May 24 23:06:17 volumio volumio[1186]: info: MyVolumio login type: Token
May 24 23:06:17 volumio volumio[1186]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 24 23:06:17 volumio volumio[1186]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
May 24 23:06:19 volumio volumio[1186]: info: Starting Streaming Service Transparent Proxy
May 24 23:06:19 volumio volumio[1186]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
May 24 23:06:19 volumio volumio[1186]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
May 24 23:06:19 volumio volumio[1186]: info: Streaming services startup
May 24 23:06:19 volumio volumio[1186]: info: Starting Streaming Daemon
May 24 23:06:19 volumio sudo[2034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 24 23:06:19 volumio sudo[2034]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:19 volumio sudo[2034]: pam_unix(sudo:session): session closed for user root
May 24 23:06:20 volumio volumio[1186]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
May 24 23:06:20 volumio volumio[1186]: info: AutoStart - Plugin is starting
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::volumioGetQueue
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::getQueue
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getQueue
May 24 23:06:20 volumio volumio[1186]: info: AutoStart - start playing
May 24 23:06:20 volumio volumio[1186]: info: AutoStart - start playing with no specific position
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::volumioPlay
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::play index 0
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::stop
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::play index undefined
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::startPlaybackTimer
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::clearAddPlayTracks USB/赵鹏 - 乌兰巴托的夜晚.flac
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand stop
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand stop took 117 milliseconds
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand clear
May 24 23:06:20 volumio volumio[1186]: error: Cannot start Volumio Streaming Daemon
May 24 23:06:20 volumio volumio[1186]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 24 23:06:20 volumio volumio[1186]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 24 23:06:20 volumio volumio[1186]: info:
May 24 23:06:20 volumio volumio[1186]: ---------------------------- MPD announces system playlist update
May 24 23:06:20 volumio volumio[1186]: info: Ignoring MPD Status Update
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand clear took 65 milliseconds
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand add "USB/赵鹏 - 乌兰巴托的夜晚.flac"
May 24 23:06:20 volumio volumio[1186]: info:
May 24 23:06:20 volumio volumio[1186]: ---------------------------- MPD announces system playlist update
May 24 23:06:20 volumio volumio[1186]: info: Ignoring MPD Status Update
May 24 23:06:20 volumio volumio[1186]: 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
May 24 23:06:20 volumio volumio[1186]: 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
May 24 23:06:20 volumio volumio[1186]: error: updateQueue error: null
May 24 23:06:20 volumio volumio[1186]: info:
May 24 23:06:20 volumio volumio[1186]: ---------------------------- MPD announces system playlist update
May 24 23:06:20 volumio volumio[1186]: info: Ignoring MPD Status Update
May 24 23:06:20 volumio volumio[1186]: info: ------------------------------ 70ms
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand add "USB/赵鹏 - 乌兰巴托的夜晚.flac" took 48 milliseconds
May 24 23:06:20 volumio volumio[1186]: info: ------------------------------ 47ms
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand play
May 24 23:06:20 volumio volumio[1186]: info:
May 24 23:06:20 volumio volumio[1186]: ---------------------------- MPD announces system playlist update
May 24 23:06:20 volumio volumio[1186]: info: Ignoring MPD Status Update
May 24 23:06:20 volumio volumio[1186]: info:
May 24 23:06:20 volumio volumio[1186]: ---------------------------- MPD announces state update: player
May 24 23:06:20 volumio volumio[1186]: info: ------------------------------ 85ms
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand play took 79 milliseconds
May 24 23:06:20 volumio volumio[1186]: info: ------------------------------ 66ms
May 24 23:06:20 volumio volumio[1186]: info: ControllerMpd::getState
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand status
May 24 23:06:20 volumio volumio[1186]: info:
May 24 23:06:20 volumio volumio[1186]: ---------------------------- MPD announces state update: player
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand status took 35 milliseconds
May 24 23:06:20 volumio volumio[1186]: info: ControllerMpd::getState
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand status
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::parseState
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 23:06:20 volumio volumio[1186]: info:
May 24 23:06:20 volumio volumio[1186]: ---------------------------- MPD announces state update: player
May 24 23:06:20 volumio volumio[1186]: info: ControllerMpd::getState
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand status
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand status took 50 milliseconds
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand playlistinfo took 29 milliseconds
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand status took 22 milliseconds
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::parseState
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::parseTrackInfo
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::parseState
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 23:06:20 volumio volumio[1186]: info: ControllerMpd::pushState
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::servicePushState
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: verbose: STATE SERVICE {"status":"play","position":0,"seek":341,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"533 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"}
May 24 23:06:20 volumio volumio[1186]: verbose: CURRENT POSITION 0
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::syncState stateService play
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::syncState currentStatus stop
May 24 23:06:20 volumio volumio[1186]: info: ------------------------------ 176ms
May 24 23:06:20 volumio volumio[1186]: info:
May 24 23:06:20 volumio volumio[1186]: ---------------------------- MPD announces state update: player
May 24 23:06:20 volumio volumio[1186]: info: ControllerMpd::getState
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand status
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand playlistinfo took 88 milliseconds
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand playlistinfo took 75 milliseconds
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand status took 13 milliseconds
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::parseTrackInfo
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::parseState
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 23:06:20 volumio volumio[1186]: info: ControllerMpd::pushState
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::servicePushState
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"}
May 24 23:06:20 volumio volumio[1186]: verbose: CURRENT POSITION 0
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::syncState stateService play
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::syncState currentStatus play
May 24 23:06:20 volumio volumio[1186]: info: Received an update from plugin. extracting info from payload
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::pushState
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::pushState
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
May 24 23:06:20 volumio volumio[1186]: info: ControllerMpd::pushState
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::servicePushState
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"558 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"}
May 24 23:06:20 volumio volumio[1186]: verbose: CURRENT POSITION 0
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::syncState stateService play
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::syncState currentStatus play
May 24 23:06:20 volumio volumio[1186]: info: Received an update from plugin. extracting info from payload
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::pushState
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::pushState
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
May 24 23:06:20 volumio volumio[1186]: info: ------------------------------ 208ms
May 24 23:06:20 volumio volumio[1186]: info: ------------------------------ 186ms
May 24 23:06:20 volumio volumio[1186]: info: sendMpdCommand playlistinfo took 59 milliseconds
May 24 23:06:20 volumio volumio[1186]: verbose: ControllerMpd::parseTrackInfo
May 24 23:06:20 volumio volumio[1186]: info: ControllerMpd::pushState
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::servicePushState
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"664 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"}
May 24 23:06:20 volumio volumio[1186]: verbose: CURRENT POSITION 0
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::syncState stateService play
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::syncState currentStatus play
May 24 23:06:20 volumio volumio[1186]: info: Received an update from plugin. extracting info from payload
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::pushState
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
May 24 23:06:20 volumio volumio[1186]: info: CoreStateMachine::pushState
May 24 23:06:20 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:20 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
May 24 23:06:20 volumio volumio[1186]: info: ------------------------------ 125ms
May 24 23:06:21 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:21 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:21 volumio sudo[2101]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
May 24 23:06:21 volumio sudo[2101]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:06:21 volumio volumio[1186]: STREAMING PROXY: Starting server on port 3245
May 24 23:06:21 volumio volumio[1186]: Node JS runtime: 14
May 24 23:06:23 volumio volumio[1186]: 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: 9
May 24 23:06:23 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetVisibleSources
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:24 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 24 23:06:24 volumio volumio[1186]: info: Received Get System Info
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 24 23:06:24 volumio volumio[1186]: info: Discovery: Getting this device information
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:24 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:24 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:24 volumio volumio[1186]: info: Listing playlists
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 24 23:06:24 volumio volumio[1186]: info: Received Get System Info
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 24 23:06:24 volumio volumio[1186]: info: Discovery: Getting this device information
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:24 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:24 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetVisibleSources
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:24 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:24 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 24 23:06:24 volumio volumio[1186]: info: Received Get System Info
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 24 23:06:24 volumio volumio[1186]: info: Discovery: Getting this device information
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:24 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:24 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:24 volumio volumio[1186]: info: Listing playlists
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 24 23:06:24 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 24 23:06:25 volumio volumio[1186]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10
May 24 23:06:26 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 24 23:06:26 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:26 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:27 volumio volumio[1186]: 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: 11
May 24 23:06:27 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:27 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:30 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 24 23:06:30 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:06:30 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 24 23:06:31 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
May 24 23:06:31 volumio volumio-remote-updater[686]: No test mode
May 24 23:06:31 volumio volumio-remote-updater[686]: No alpha test mode
May 24 23:06:31 volumio volumio[1186]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
May 24 23:06:31 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 24 23:06:32 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 24 23:06:32 volumio volumio[1186]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12
May 24 23:06:32 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:06:32 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:06:35 volumio ntpd[1097]: Soliciting pool server 202.118.1.130
May 24 23:06:37 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:37 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:37 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
May 24 23:06:37 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 24 23:06:37 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
May 24 23:06:37 volumio volumio[1186]: info: CoreCommandRouter::volumioGetBrowseSources
May 24 23:06:37 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 24 23:06:38 volumio ntpd[1097]: Soliciting pool server 45.76.221.157
May 24 23:06:40 volumio volumio[1186]: error: MyVolumio Plugin failed to authenticate in a timely fashion
May 24 23:06:40 volumio volumio[1186]: info: Completed starting MyVolumio Plugin
May 24 23:06:40 volumio volumio[1186]: [Metrics] CommandRouter: 51s 955.30ms
May 24 23:06:40 volumio volumio[1186]: info: CoreCommandRouter::volumiosetStartupVolume
May 24 23:06:40 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 24 23:06:40 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:06:40 volumio volumio[1186]: info: CoreCommandRouter::Close All Modals sent
May 24 23:06:40 volumio volumio[1186]: info: CoreCommandRouter::Close All Modals sent
May 24 23:06:40 volumio volumio[1186]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
May 24 23:06:40 volumio volumio[1186]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card
May 24 23:06:40 volumio volumio[1186]: aplay: main:828: audio open error: No such device
May 24 23:06:41 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 24 23:06:41 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 24 23:06:41 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
May 24 23:06:41 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 24 23:06:47 volumio volumio[1186]: info: BOOT COMPLETED
May 24 23:06:49 volumio volumio[1186]: error: error
May 24 23:06:50 volumio volumio[1186]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
May 24 23:06:50 volumio volumio[1186]: info: Retrying Login Due to Network Error
May 24 23:07:00 volumio volumio[1186]: info: MyVolumio login type: Token
May 24 23:07:01 volumio kernel: usb 5-3: new low-speed USB device number 4 using ohci-pci
May 24 23:07:01 volumio kernel: usb 5-3: New USB device found, idVendor=413c, idProduct=301a, bcdDevice= 1.00
May 24 23:07:01 volumio kernel: usb 5-3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
May 24 23:07:01 volumio kernel: usb 5-3: Product: Dell MS116 USB Optical Mouse
May 24 23:07:01 volumio kernel: usb 5-3: Manufacturer: PixArt
May 24 23:07:01 volumio kernel: input: PixArt Dell MS116 USB Optical Mouse as /devices/pci0000:00/0000:00:13.0/usb5/5-3/5-3:1.0/0003:413C:301A.0001/input/input9
May 24 23:07:01 volumio kernel: hid-generic 0003:413C:301A.0001: input,hidraw0: USB HID v1.11 Mouse [PixArt Dell MS116 USB Optical Mouse] on usb-0000:00:13.0-3/input0
May 24 23:07:01 volumio kernel: usbcore: registered new interface driver usbmouse
May 24 23:07:01 volumio systemd-udevd[2299]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 24 23:07:01 volumio systemd-udevd[2298]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
May 24 23:07:03 volumio sudo[2101]: pam_unix(sudo:session): session closed for user root
May 24 23:07:10 volumio volumio[1186]: info: CoreCommandRouter::getUIConfigOnPlugin
May 24 23:07:11 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 24 23:07:11 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:07:11 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 24 23:07:11 volumio volumio[1186]: Invalid card number.
May 24 23:07:11 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:07:11 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:07:11 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:07:11 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:07:11 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:07:11 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
May 24 23:07:11 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 24 23:07:14 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:07:14 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:07:14 volumio sudo[2370]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
May 24 23:07:14 volumio sudo[2370]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 24 23:07:16 volumio volumio[1186]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
May 24 23:07:16 volumio volumio[1186]: info: Preparing to save Alsa Options, stopping services first
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
May 24 23:07:16 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::volumioPause
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::pause
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::stPlaybackTimer
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::servicePause
May 24 23:07:16 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::servicePause
May 24 23:07:16 volumio volumio[1186]: info: ControllerMpd::pause
May 24 23:07:16 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand pause
May 24 23:07:16 volumio volumio[1186]: info: Saving Audio Output to: {"output_device":{"value":"1,0","label":"Analog Out"}}
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 24 23:07:16 volumio volumio[1186]: info: Found match in Cards Database: setting mixer for card Analog Out
May 24 23:07:16 volumio volumio[1186]: info: Setting mixer Master for card Analog Out
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::volumioUpdateVolumeSettings
May 24 23:07:16 volumio volumio[1186]: info: Updating Volume Controller Parameters: Device: 1,0 Name: Analog Out Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
May 24 23:07:16 volumio volumio[1186]: info: Disabling external Volume Control
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::getUIConfigOnPlugin
May 24 23:07:16 volumio volumio[1186]: info: Preparing to generate the ALSA configuration file
May 24 23:07:16 volumio volumio[1186]: info:
May 24 23:07:16 volumio volumio[1186]: ---------------------------- MPD announces state update: player
May 24 23:07:16 volumio volumio[1186]: info: sendMpdCommand pause took 306 milliseconds
May 24 23:07:16 volumio volumio[1186]: info: ControllerMpd::getState
May 24 23:07:16 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand status
May 24 23:07:16 volumio volumio[1186]: info:
May 24 23:07:16 volumio volumio[1186]: ---------------------------- MPD announces state update: player
May 24 23:07:16 volumio volumio[1186]: info: ControllerMpd::getState
May 24 23:07:16 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand status
May 24 23:07:16 volumio volumio[1186]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
May 24 23:07:16 volumio volumio[1186]: info: Reading ALSA contributions from plugins.
May 24 23:07:16 volumio volumio[1186]: info: sendMpdCommand status took 36 milliseconds
May 24 23:07:16 volumio volumio[1186]: info: sendMpdCommand status took 33 milliseconds
May 24 23:07:16 volumio volumio[1186]: verbose: ControllerMpd::parseState
May 24 23:07:16 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 23:07:16 volumio volumio[1186]: verbose: ControllerMpd::parseState
May 24 23:07:16 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 23:07:16 volumio volumio[1186]: info: sendMpdCommand playlistinfo took 9 milliseconds
May 24 23:07:16 volumio volumio[1186]: info: sendMpdCommand playlistinfo took 8 milliseconds
May 24 23:07:16 volumio volumio[1186]: verbose: ControllerMpd::parseTrackInfo
May 24 23:07:16 volumio volumio[1186]: verbose: ControllerMpd::parseTrackInfo
May 24 23:07:16 volumio volumio[1186]: info: ControllerMpd::pushState
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::servicePushState
May 24 23:07:16 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:07:16 volumio volumio[1186]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":56620,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"898 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"}
May 24 23:07:16 volumio volumio[1186]: verbose: CURRENT POSITION 0
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::syncState stateService pause
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::syncState currentStatus pause
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::pushState
May 24 23:07:16 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::stPlaybackTimer
May 24 23:07:16 volumio volumio[1186]: info: ControllerMpd::pushState
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::servicePushState
May 24 23:07:16 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:07:16 volumio volumio[1186]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":56620,"duration":337,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"898 Kbps","isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"}
May 24 23:07:16 volumio volumio[1186]: verbose: CURRENT POSITION 0
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::syncState stateService pause
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::syncState currentStatus pause
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::pushState
May 24 23:07:16 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
May 24 23:07:16 volumio volumio[1186]: info: CoreStateMachine::stPlaybackTimer
May 24 23:07:16 volumio volumio[1186]: info: ------------------------------ 108ms
May 24 23:07:16 volumio volumio[1186]: info: ------------------------------ 104ms
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
May 24 23:07:16 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 24 23:07:16 volumio volumio[1186]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 24 23:07:16 volumio volumio[1186]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
May 24 23:07:16 volumio volumio[1186]: at Object.readdirSync (fs.js:1048:3)
May 24 23:07:16 volumio volumio[1186]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
May 24 23:07:16 volumio volumio[1186]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
May 24 23:07:16 volumio volumio[1186]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
May 24 23:07:16 volumio volumio[1186]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
May 24 23:07:16 volumio volumio[1186]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
May 24 23:07:16 volumio volumio[1186]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
May 24 23:07:16 volumio volumio[1186]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
May 24 23:07:16 volumio volumio[1186]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
May 24 23:07:16 volumio volumio[1186]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
May 24 23:07:16 volumio volumio[1186]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
May 24 23:07:16 volumio volumio[1186]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8)
May 24 23:07:16 volumio volumio[1186]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
May 24 23:07:16 volumio volumio[1186]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
May 24 23:07:16 volumio volumio[1186]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12)
May 24 23:07:16 volumio volumio[1186]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) {
May 24 23:07:16 volumio volumio[1186]: errno: -20,
May 24 23:07:16 volumio volumio[1186]: syscall: 'scandir',
May 24 23:07:16 volumio volumio[1186]: code: 'ENOTDIR',
May 24 23:07:16 volumio volumio[1186]: path: '/tmp/peppyrunning'
May 24 23:07:16 volumio volumio[1186]: }
May 24 23:07:16 volumio volumio[1186]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 24 23:07:17 volumio sudo[2417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-24 23:06
May 24 23:07:17 volumio sudo[2417]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"