-- Logs begin at Sat 2024-10-26 10:19:38 CST, end at Sat 2024-10-26 10:21:13 CST. --
Oct 26 10:20:00 volumio ntpd[1175]: Soliciting pool server 119.28.183.184
Oct 26 10:20:00 volumio ntpd[1175]: Soliciting pool server 111.230.189.174
Oct 26 10:20:00 volumio ntpd[1175]: Soliciting pool server 162.159.200.123
Oct 26 10:20:00 volumio wireless.js[739]: trying...
Oct 26 10:20:00 volumio sudo[1234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 26 10:20:00 volumio sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:00 volumio sudo[1234]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:01 volumio ntpd[1175]: Soliciting pool server 202.112.29.82
Oct 26 10:20:01 volumio ntpd[1175]: Soliciting pool server 193.182.111.12
Oct 26 10:20:01 volumio volumio-remote-updater[734]: [2024-10-26 10:20:01] [info] asio async_connect error: system:111 (Connection refused)
Oct 26 10:20:01 volumio volumio-remote-updater[734]: [2024-10-26 10:20:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Oct 26 10:20:01 volumio volumio-remote-updater[734]: [2024-10-26 10:20:01] [error] handle_connect error: Underlying Transport Error
Oct 26 10:20:01 volumio wireless.js[739]: trying...
Oct 26 10:20:01 volumio sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 26 10:20:01 volumio sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:01 volumio sudo[1237]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:02 volumio ntpd[1175]: Soliciting pool server 193.182.111.142
Oct 26 10:20:02 volumio wireless.js[739]: trying...
Oct 26 10:20:02 volumio sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 26 10:20:02 volumio sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:02 volumio sudo[1240]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:03 volumio ntpd[1175]: Soliciting pool server 108.59.2.24
Oct 26 10:20:03 volumio wireless.js[739]: trying...
Oct 26 10:20:03 volumio sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 26 10:20:03 volumio sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:03 volumio sudo[1243]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:04 volumio wireless.js[739]: trying...
Oct 26 10:20:04 volumio sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 26 10:20:04 volumio sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:04 volumio sudo[1246]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:05 volumio wireless.js[739]: trying...
Oct 26 10:20:05 volumio sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 26 10:20:05 volumio sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:05 volumio sudo[1249]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:00 volumio sudo[1544]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:00 volumio volumio[1286]: info: Mounting Device Newsmy
Oct 26 10:20:00 volumio sudo[1553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Newsmy -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Oct 26 10:20:00 volumio sudo[1553]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:00 volumio ntfs-3g[1558]: Version 2017.3.23AR.3 integrated FUSE 28
Oct 26 10:20:00 volumio ntfs-3g[1558]: Mounted /dev/sdb1 (Read-Write, label "Newsmy", NTFS 3.1)
Oct 26 10:20:00 volumio ntfs-3g[1558]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
Oct 26 10:20:00 volumio ntfs-3g[1558]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096
Oct 26 10:20:00 volumio ntfs-3g[1558]: Global ownership and permissions enforced, configuration type 7
Oct 26 10:20:00 volumio sudo[1553]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:00 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 26 10:20:00 volumio volumio[1286]: info: Loading plugin "volumio_command_line_client"...
Oct 26 10:20:00 volumio volumio[1286]: info: Loading plugin "upnp"...
Oct 26 10:20:00 volumio volumio[1286]: info: [1729909200843] Starting Upmpd Daemon
Oct 26 10:20:00 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 26 10:20:00 volumio volumio[1286]: info: Loading plugin "my_music"...
Oct 26 10:20:00 volumio volumio[1286]: info: Loading plugin "mpd"...
Oct 26 10:20:01 volumio volumio[1286]: info: Loading plugin "upnp_browser"...
Oct 26 10:20:02 volumio volumio[1286]: info: Loading plugin "alarm-clock"...
Oct 26 10:20:02 volumio sudo[1516]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:02 volumio volumio[1286]: info: Loading plugin "airplay_emulation"...
Oct 26 10:20:02 volumio volumio[1286]: info: Starting Shairport Sync
Oct 26 10:20:02 volumio volumio[1286]: info: Loading plugin "last_100"...
Oct 26 10:20:02 volumio volumio[1286]: info: Loading plugin "webradio"...
Oct 26 10:20:03 volumio volumio[1286]: info: Loading plugin "i2s_dacs"...
Oct 26 10:20:03 volumio volumio[1286]: info: I2S DAC not set, start Auto-detection
Oct 26 10:20:03 volumio volumio[1286]: info: Loading plugin "volumiodiscovery"...
Oct 26 10:20:03 volumio volumio[1286]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 26 10:20:03 volumio node[1286]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 26 10:20:03 volumio volumio[1286]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 26 10:20:03 volumio node[1286]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 26 10:20:03 volumio volumio[1286]: *** WARNING *** For more information see
Oct 26 10:20:03 volumio node[1286]: *** WARNING *** For more information see
Oct 26 10:20:03 volumio volumio[1286]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 26 10:20:03 volumio volumio[1286]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 26 10:20:03 volumio volumio[1286]: *** WARNING *** For more information see
Oct 26 10:20:03 volumio node[1286]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 26 10:20:03 volumio node[1286]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 26 10:20:03 volumio node[1286]: *** WARNING *** For more information see
Oct 26 10:20:03 volumio volumio[1286]: info: Applying required configuration parameters for plugin volumiodiscovery
Oct 26 10:20:03 volumio volumio[1286]: info: Discovery: Started advertising with name: Volumio
Oct 26 10:20:03 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 26 10:20:03 volumio volumio[1286]: info: Loading plugin "peppy_screensaver"...
Oct 26 10:20:04 volumio volumio[1286]: info: Applying required configuration parameters for plugin peppy_screensaver
Oct 26 10:20:04 volumio volumio[1286]: info: Loading plugin "outputs"...
Oct 26 10:20:04 volumio volumio[1286]: info: Loading plugin "albumart"...
Oct 26 10:20:04 volumio volumio[1286]: info: Plugin example_plugin is not enabled
Oct 26 10:20:04 volumio volumio[1286]: info: Loading plugin "inputs"...
Oct 26 10:20:04 volumio volumio[1286]: info: Loading plugin "updater_comm"...
Oct 26 10:20:05 volumio volumio[1286]: Forking 1 albumart workers
Oct 26 10:20:05 volumio volumio[1286]: info: Plugin mpdemulation is not enabled
Oct 26 10:20:05 volumio volumio[1286]: info: Loading plugin "rest_api"...
Oct 26 10:20:05 volumio volumio[1286]: info: Loading plugin "websocket"...
Oct 26 10:20:05 volumio volumio[1286]: info: Starting Socket.io Server version 2.3.0
Oct 26 10:20:05 volumio volumio[1286]: info: Loading i18n strings for locale zh
Oct 26 10:20:05 volumio volumio[1286]: Updating browse sources language
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::initPlayerControls
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: Express server listening on port 3000
Oct 26 10:20:05 volumio volumio[1286]: [Metrics] WebUI: 15s 645.58ms
Oct 26 10:20:05 volumio volumio[1286]: info: Setting Device type: x86
Oct 26 10:20:05 volumio volumio[1286]: info: CoreStateMachine::resetVolumioState
Oct 26 10:20:05 volumio volumio[1286]: info: CoreStateMachine::getcurrentVolume
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::volumioRetrievevolume
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Oct 26 10:20:05 volumio volumio[1286]: info: CoreStateMachine::getcurrentVolume
Oct 26 10:20:05 volumio volumio[1286]: info: CoreCommandRouter::volumioRetrievevolume
Oct 26 10:20:05 volumio volumio[1286]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Oct 26 10:20:05 volumio volumio[1286]: info: Completed loading Core Plugins
Oct 26 10:20:05 volumio volumio[1286]: info: Preparing to generate the ALSA configuration file
Oct 26 10:20:05 volumio volumio[1286]: Starting albumart workers
Oct 26 10:20:05 volumio volumio[1286]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Oct 26 10:20:06 volumio volumio[1286]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Oct 26 10:20:06 volumio volumio[1286]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Oct 26 10:20:06 volumio volumio[1286]: info: Reading ALSA contributions from plugins.
Oct 26 10:20:06 volumio volumio[1286]: info: VolumeController:: Volume=undefined Mute =false
Oct 26 10:20:06 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:06 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:06 volumio volumio[1286]: info: CoreStateMachine::updateTrackBlock
Oct 26 10:20:06 volumio volumio[1286]: info: CorePlayQueue::getTrackBlock
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::volumioRetrievevolume
Oct 26 10:20:06 volumio volumio[1286]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:06 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 10:20:06 volumio volumio[1286]: info: Discovery: Getting this device information
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:06 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 10:20:06 volumio volumio[1286]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Oct 26 10:20:06 volumio volumio[1286]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Oct 26 10:20:06 volumio volumio[1286]: MPD error: Cannot assign requested address
Oct 26 10:20:06 volumio volumio[1286]: info: Reloading queue from file
Oct 26 10:20:06 volumio volumio[1286]: info: VolumeController:: Volume=undefined Mute =false
Oct 26 10:20:06 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:06 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:06 volumio volumio[1286]: info: CoreStateMachine::updateTrackBlock
Oct 26 10:20:06 volumio volumio[1286]: info: CorePlayQueue::getTrackBlock
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::volumioRetrievevolume
Oct 26 10:20:06 volumio volumio[1286]: info: CoreStateMachine::setRepeat null single undefined
Oct 26 10:20:06 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:06 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:06 volumio volumio[1286]: info: CoreStateMachine::setRandom null
Oct 26 10:20:06 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:06 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:06 volumio volumio[1286]: verbose: New Socket.io Connection to 192.168.31.34 from 192.168.31.135 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 2
Oct 26 10:20:06 volumio volumio[1286]: info: VolumeController:: Volume=undefined Mute =false
Oct 26 10:20:06 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:06 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:06 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:07 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 26 10:20:07 volumio volumio[1286]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Oct 26 10:20:07 volumio volumio[1286]: info: Discovery: adding 492524ff-0d18-4e9b-b0b7-e00a3046faf7
Oct 26 10:20:07 volumio volumio[1286]: info: Discovery: Found device Volumio
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:07 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:07 volumio volumio[1286]: info: VolumeController:: Volume=undefined Mute =false
Oct 26 10:20:07 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:07 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:07 volumio volumio[1286]: info: Asound.conf file unchanged, so no further update is needed
Oct 26 10:20:07 volumio volumio[1286]: info: Output device has changed, restarting MPD
Oct 26 10:20:07 volumio sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 26 10:20:07 volumio sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:07 volumio sudo[1671]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:07 volumio volumio[1286]: info: Output device has changed, restarting Shairport Sync
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:07 volumio sudo[1674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 26 10:20:07 volumio sudo[1674]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:07 volumio systemd[1]: Listening on mpd.socket.
Oct 26 10:20:07 volumio volumio[1286]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 26 10:20:07 volumio volumio[1286]: info: ___________ START PLUGINS ___________
Oct 26 10:20:07 volumio systemd[1]: Starting Music Player Daemon...
Oct 26 10:20:07 volumio volumio[1286]: info: ControllerMpd::onStart: Initializing MPD
Oct 26 10:20:07 volumio volumio[1286]: info: Creating MPD Configuration file
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 26 10:20:07 volumio volumio[1286]: info: [1729909207588] CoreMusicLibrary::Adding element 媒体服务器
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 26 10:20:07 volumio sudo[1681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 26 10:20:07 volumio sudo[1679]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 26 10:20:07 volumio sudo[1681]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:07 volumio sudo[1679]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:07 volumio sudo[1681]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:07 volumio sudo[1679]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Oct 26 10:20:07 volumio sudo[1679]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:07 volumio sudo[1683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 26 10:20:07 volumio sudo[1683]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:07 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Oct 26 10:20:07 volumio systemd[1]: mpd.service: Succeeded.
Oct 26 10:20:07 volumio systemd[1]: Stopped Music Player Daemon.
Oct 26 10:20:07 volumio systemd[1]: Starting Music Player Daemon...
Oct 26 10:20:07 volumio volumio[1286]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:07 volumio sudo[1691]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 26 10:20:07 volumio volumio[1286]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 26 10:20:07 volumio volumio[1286]: info: [1729909207966] CoreMusicLibrary::Adding element Last_100
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 26 10:20:07 volumio volumio[1286]: info: [1729909207970] CoreMusicLibrary::Adding element Webradio
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 26 10:20:07 volumio sudo[1691]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:07 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 26 10:20:07 volumio volumio[1286]: info: Initializing BBC Radios
Oct 26 10:20:07 volumio sudo[1691]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Oct 26 10:20:08 volumio sudo[1691]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:08 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 26 10:20:08 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:08 volumio volumio[1286]: info: Loading i18n strings for locale zh
Oct 26 10:20:08 volumio volumio[1286]: info: /tmp/myfifo created
Oct 26 10:20:08 volumio volumio[1286]: info: /tmp/myfifosa created
Oct 26 10:20:08 volumio sudo[1712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0
Oct 26 10:20:08 volumio sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:08 volumio sudo[1712]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:08 volumio volumio[1286]: info: snd-dummy loaded
Oct 26 10:20:08 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:08 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:08 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:08 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync
Oct 26 10:20:08 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:08 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:08 volumio volumio[1286]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 26 10:20:08 volumio volumio[1286]: info: Volumio Calling Home
Oct 26 10:20:09 volumio volumio[1286]: info: MPD Permissions set
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:09 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:09 volumio volumio[1286]: 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 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Oct 26 10:20:09 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:10 volumio sudo[1750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl
Oct 26 10:20:10 volumio sudo[1750]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:10 volumio volumio[1286]: info: Volumio called home
Oct 26 10:20:10 volumio sudo[1750]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:10 volumio volumio[1286]: info: Starting Shairport Sync
Oct 26 10:20:10 volumio volumio[1286]: info: Starting Shairport Sync
Oct 26 10:20:10 volumio sudo[1753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 26 10:20:10 volumio sudo[1753]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:10 volumio volumio[1286]: info: Starting Shairport Sync
Oct 26 10:20:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 26 10:20:10 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 26 10:20:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 26 10:20:10 volumio volumio[1286]: info: Starting Shairport Sync
Oct 26 10:20:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 26 10:20:10 volumio sudo[1753]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:10 volumio sudo[1756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 26 10:20:10 volumio sudo[1756]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:10 volumio sudo[1759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 26 10:20:10 volumio sudo[1759]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 26 10:20:10 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 26 10:20:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 26 10:20:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 26 10:20:10 volumio sudo[1756]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:10 volumio sudo[1764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 26 10:20:10 volumio sudo[1764]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 26 10:20:10 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 26 10:20:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 26 10:20:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 26 10:20:11 volumio sudo[1759]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 26 10:20:11 volumio volumio-remote-updater[734]: [2024-10-26 10:20:11] [connect] Successful connection
Oct 26 10:20:11 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Oct 26 10:20:11 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 26 10:20:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 26 10:20:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 26 10:20:11 volumio sudo[1764]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:11 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:11 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:11 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile
Oct 26 10:20:11 volumio sudo[1774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 26 10:20:11 volumio sudo[1774]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:11 volumio sudo[1774]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:11 volumio sudo[1778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 26 10:20:11 volumio sudo[1778]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:11 volumio sudo[1778]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:11 volumio sudo[1781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 26 10:20:11 volumio sudo[1781]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:11 volumio sudo[1781]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:11 volumio volumio[1286]: info: MPD Permissions set
Oct 26 10:20:11 volumio volumio[1286]: info: Shairport-Sync Started
Oct 26 10:20:11 volumio volumio[1286]: Error adding Membership: Error: addMembership EINVAL
Oct 26 10:20:11 volumio volumio[1286]: info: Shairport-Sync Started
Oct 26 10:20:11 volumio volumio[1286]: info: Shairport-Sync Started
Oct 26 10:20:11 volumio volumio[1286]: info: Shairport-Sync Started
Oct 26 10:20:11 volumio volumio-remote-updater[734]: [2024-10-26 10:20:11] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1729909211 101
Oct 26 10:20:11 volumio volumio[1286]: 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: 4
Oct 26 10:20:11 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd
Oct 26 10:20:12 volumio sudo[1789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 26 10:20:12 volumio sudo[1789]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:12 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Oct 26 10:20:12 volumio systemd[1]: mpd.service: Succeeded.
Oct 26 10:20:12 volumio systemd[1]: Stopped Music Player Daemon.
Oct 26 10:20:12 volumio systemd[1]: Starting Music Player Daemon...
Oct 26 10:20:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Oct 26 10:20:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:12 volumio sudo[1797]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 26 10:20:12 volumio sudo[1797]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:12 volumio sudo[1797]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Oct 26 10:20:12 volumio sudo[1797]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:12 volumio sudo[1817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Oct 26 10:20:12 volumio sudo[1817]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:12 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Oct 26 10:20:12 volumio sudo[1817]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:12 volumio volumio[1286]: info: Upmpdcli Daemon Started
Oct 26 10:20:15 volumio sudo[1912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 26 10:20:15 volumio sudo[1912]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:15 volumio sudo[1917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 26 10:20:15 volumio sudo[1917]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:15 volumio sudo[1917]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:15 volumio sudo[1912]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:15 volumio volumio[1286]: verbose: New Socket.io Connection to 192.168.31.34 from 192.168.31.135 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 5
Oct 26 10:20:15 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:15 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:15 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 26 10:20:15 volumio volumio[1286]: info: Listing playlists
Oct 26 10:20:15 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 26 10:20:15 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 26 10:20:15 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 26 10:20:15 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 26 10:20:16 volumio volumio[1286]: 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 26 10:20:16 volumio mpd[1810]: Oct 26 10:20 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Oct 26 10:20:16 volumio systemd[1]: Started Music Player Daemon.
Oct 26 10:20:16 volumio volumio[1286]: Upnp client error: Error: This socket has been ended by the other party
Oct 26 10:20:16 volumio sudo[1789]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:16 volumio sudo[1674]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:16 volumio sudo[1683]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:16 volumio volumio[1286]: error: MPD error: The expression evaluated to a falsy value:
Oct 26 10:20:16 volumio volumio[1286]: assert.ok(self.idling)
Oct 26 10:20:16 volumio volumio[1286]: error: The expression evaluated to a falsy value:
Oct 26 10:20:16 volumio volumio[1286]: assert.ok(self.idling)
Oct 26 10:20:16 volumio volumio[1286]: info: Completed starting Core Plugins
Oct 26 10:20:16 volumio volumio[1286]: info: -------------------------------------------
Oct 26 10:20:16 volumio volumio[1286]: info: ----- MyVolumio plugins startup ----
Oct 26 10:20:16 volumio volumio[1286]: info: -------------------------------------------
Oct 26 10:20:16 volumio volumio[1286]: info: [MyVolumio PluginManager] Fetching plans data....
Oct 26 10:20:16 volumio volumio[1286]: error: MPD error: The expression evaluated to a falsy value:
Oct 26 10:20:16 volumio volumio[1286]: assert.ok(self.idling)
Oct 26 10:20:16 volumio volumio[1286]: error: The expression evaluated to a falsy value:
Oct 26 10:20:16 volumio volumio[1286]: assert.ok(self.idling)
Oct 26 10:20:16 volumio volumio[1286]: info: MPD running with PID1810
Oct 26 10:20:16 volumio volumio[1286]: ,establishing connection
Oct 26 10:20:16 volumio volumio[1286]: error: updateQueue error: null
Oct 26 10:20:16 volumio volumio[1286]: error: updateQueue error: null
Oct 26 10:20:16 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 26 10:20:16 volumio volumio[1286]: info: Received Get System Info
Oct 26 10:20:16 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 10:20:16 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 10:20:16 volumio volumio[1286]: info: Discovery: Getting this device information
Oct 26 10:20:16 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:16 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:16 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 10:20:17 volumio volumio[1286]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 26 10:20:17 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 26 10:20:17 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:17 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:17 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 26 10:20:17 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 26 10:20:17 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 26 10:20:17 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 26 10:20:17 volumio volumio[1821]: Generating RSA private key, 4096 bit long modulus (2 primes)
Oct 26 10:20:17 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:17 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:18 volumio volumio[1286]: 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 26 10:20:19 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:19 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:19 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 26 10:20:19 volumio volumio[1286]: info: Listing playlists
Oct 26 10:20:19 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 26 10:20:19 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 26 10:20:19 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 26 10:20:19 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 26 10:20:20 volumio volumio[1286]: info: CoreCommandRouter::volumioPlay
Oct 26 10:20:20 volumio volumio[1286]: info: CoreStateMachine::play index undefined
Oct 26 10:20:20 volumio volumio[1286]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 10:20:20 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:20 volumio volumio[1286]: info: CoreStateMachine::startPlaybackTimer
Oct 26 10:20:20 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:20 volumio volumio[1286]: verbose: ControllerMpd::clearAddPlayTracks USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav
Oct 26 10:20:20 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand stop
Oct 26 10:20:20 volumio volumio[1286]: info: sendMpdCommand stop took 6 milliseconds
Oct 26 10:20:20 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand clear
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:20 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:20 volumio volumio[1286]: info: sendMpdCommand clear took 6 milliseconds
Oct 26 10:20:20 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand add "USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav"
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:20 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:20 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:20 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:20 volumio volumio[1286]: error: updateQueue error: null
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:20 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:20 volumio volumio[1286]: info: ------------------------------ 27ms
Oct 26 10:20:20 volumio volumio[1286]: info: sendMpdCommand add "USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav" took 23 milliseconds
Oct 26 10:20:20 volumio volumio[1286]: info: ------------------------------ 22ms
Oct 26 10:20:20 volumio volumio[1286]: info: ------------------------------ 18ms
Oct 26 10:20:20 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand play
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:20 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:20 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:20 volumio volumio[1286]: info: ------------------------------ 26ms
Oct 26 10:20:20 volumio volumio[1286]: info: ------------------------------ 23ms
Oct 26 10:20:20 volumio volumio[1286]: info: sendMpdCommand play took 13 milliseconds
Oct 26 10:20:20 volumio volumio[1286]: info: ------------------------------ 11ms
Oct 26 10:20:20 volumio volumio[1286]: info: ------------------------------ 10ms
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:20 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:20 volumio volumio[1286]: info: ------------------------------ 6ms
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:20 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:20 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:20 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:20 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:20 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:20 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:20 volumio volumio[1286]: info:
Oct 26 10:20:20 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:20 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:20 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:21 volumio volumio[1286]: info:
Oct 26 10:20:21 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand status took 110 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand status took 106 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand status took 123 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand status took 122 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand status took 28 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 18 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:21 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus stop
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:21 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:21 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: ------------------------------ 215ms
Oct 26 10:20:21 volumio volumio[1286]: info: ------------------------------ 238ms
Oct 26 10:20:21 volumio volumio[1286]: info:
Oct 26 10:20:21 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:21 volumio volumio[1286]: info:
Oct 26 10:20:21 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:21 volumio volumio[1286]: info:
Oct 26 10:20:21 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 111 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 114 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 117 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand status took 21 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand status took 17 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand status took 14 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":2280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:21 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:21 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":295,"duration":2280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:21 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:21 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":2280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:21 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:21 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: ------------------------------ 442ms
Oct 26 10:20:21 volumio volumio[1286]: info: ------------------------------ 444ms
Oct 26 10:20:21 volumio volumio[1286]: info: ------------------------------ 358ms
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 282 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 281 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 282 milliseconds
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:21 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":2280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:21 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:21 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":2280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:21 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:21 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":2280,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:21 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:21 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:21 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:21 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:21 volumio volumio[1286]: info: ------------------------------ 439ms
Oct 26 10:20:21 volumio volumio[1286]: info: ------------------------------ 443ms
Oct 26 10:20:21 volumio volumio[1286]: info: ------------------------------ 441ms
Oct 26 10:20:22 volumio volumio[1286]: info: VolumeController::SetAlsaVolume0
Oct 26 10:20:22 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:22 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:22 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:22 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:22 volumio volumio[1286]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Oct 26 10:20:24 volumio volumio[1821]: ....................................................................................................................................................................++++
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Oct 26 10:20:26 volumio volumio[1286]: info: Adding plugin bluetooth to MyMusic Plugins
Oct 26 10:20:26 volumio volumio[1286]: info: Adding plugin multiroom to MyMusic Plugins
Oct 26 10:20:26 volumio volumio[1286]: info: Adding plugin metavolumio to MyMusic Plugins
Oct 26 10:20:26 volumio volumio[1286]: info: Adding plugin cd_controller to MyMusic Plugins
Oct 26 10:20:26 volumio volumio[1286]: info: Adding plugin smart_inputs to MyMusic Plugins
Oct 26 10:20:26 volumio volumio[1286]: info: Adding plugin tidalconnect to MyMusic Plugins
Oct 26 10:20:26 volumio volumio[1286]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Oct 26 10:20:28 volumio volumio[1821]: ..................................................................................................++++
Oct 26 10:20:28 volumio volumio[1821]: e is 65537 (0x010001)
Oct 26 10:20:29 volumio volumio[1821]: writing RSA key
Oct 26 10:20:29 volumio volumio[1286]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Oct 26 10:20:29 volumio volumio[1286]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Oct 26 10:20:29 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:29 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:29 volumio volumio[1286]: info: Starting MyVolumio Remote Streaming Endpoints
Oct 26 10:20:29 volumio volumio[1286]: info: MyVolumio login type: Token
Oct 26 10:20:29 volumio volumio[1286]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Oct 26 10:20:29 volumio volumio[1286]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Oct 26 10:20:31 volumio volumio[1286]: info: Starting Streaming Service Transparent Proxy
Oct 26 10:20:31 volumio volumio[1286]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Oct 26 10:20:31 volumio volumio[1286]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Oct 26 10:20:31 volumio volumio[1286]: info: Streaming services startup
Oct 26 10:20:31 volumio volumio[1286]: info: Starting Streaming Daemon
Oct 26 10:20:31 volumio sudo[2095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Oct 26 10:20:31 volumio sudo[2095]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:31 volumio sudo[2095]: pam_unix(sudo:session): session closed for user root
Oct 26 10:20:31 volumio volumio[1286]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Oct 26 10:20:31 volumio volumio[1286]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 26 10:20:31 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 26 10:20:31 volumio volumio[1286]: info: CoreCommandRouter::volumioGetQueue
Oct 26 10:20:31 volumio volumio[1286]: info: CoreStateMachine::getQueue
Oct 26 10:20:31 volumio volumio[1286]: info: CorePlayQueue::getQueue
Oct 26 10:20:31 volumio volumio[1286]: error: Cannot start Volumio Streaming Daemon
Oct 26 10:20:31 volumio volumio[1286]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Oct 26 10:20:31 volumio volumio[1286]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Oct 26 10:20:31 volumio volumio[1286]: Upnp client error: Error: This socket has been ended by the other party
Oct 26 10:20:31 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:31 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:31 volumio volumio[1286]: Upnp client error: Error: This socket has been ended by the other party
Oct 26 10:20:31 volumio sudo[2102]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Oct 26 10:20:31 volumio sudo[2102]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 26 10:20:32 volumio volumio[1286]: STREAMING PROXY: Starting server on port 3245
Oct 26 10:20:32 volumio volumio[1286]: Node JS runtime: 14
Oct 26 10:20:34 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 26 10:20:34 volumio volumio[1286]: info: CURURI: music-library
Oct 26 10:20:34 volumio volumio[1286]: info: Preload queue cleared
Oct 26 10:20:35 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 26 10:20:35 volumio volumio[1286]: info: CURURI: music-library/USB
Oct 26 10:20:36 volumio volumio[1286]: info: Preload queue cleared
Oct 26 10:20:36 volumio volumio[1286]: info: Preloading song: music-library/USB/Kiroro - 長い間.flac
Oct 26 10:20:36 volumio volumio[1286]: info: Preloading song: music-library/USB/Kiroro - 未来へ.flac
Oct 26 10:20:36 volumio volumio[1286]: info: Preloading song: music-library/USB/Richard Sanderson - Reality.flac
Oct 26 10:20:36 volumio volumio[1286]: info: Preloading song: music-library/USB/THE虎舞竜 - ロード.flac
Oct 26 10:20:36 volumio volumio[1286]: info: Preloading song: music-library/USB/蔡琴 - 恰似你的温柔.flac
Oct 26 10:20:36 volumio volumio[1286]: info: Exploding uri music-library/USB/Kiroro - 長い間.flac in service mpd
Oct 26 10:20:36 volumio volumio[1286]: info: ALBUMART /albumart?cacheid=851&web=Kiroro/Nagai%20Aida%20%EF%BD%9EKiroro%20no%20Mori%EF%BD%9E/extralarge&path=%2Fmnt%2FUSB%2FKiroro%20-%20%E9%95%B7%E3%81%84%E9%96%93.flac&metadata=false
Oct 26 10:20:36 volumio volumio[1286]: info: URI /mnt/USB/Kiroro - 長い間.flac
Oct 26 10:20:36 volumio volumio[1286]: info: Exploding uri music-library/USB/Kiroro - 未来へ.flac in service mpd
Oct 26 10:20:36 volumio volumio[1286]: info: ALBUMART /albumart?cacheid=851&web=Kiroro/Nagai%20Aida%20%EF%BD%9EKiroro%20no%20Mori%EF%BD%9E/extralarge&path=%2Fmnt%2FUSB%2FKiroro%20-%20%E6%9C%AA%E6%9D%A5%E3%81%B8.flac&metadata=false
Oct 26 10:20:36 volumio volumio[1286]: info: URI /mnt/USB/Kiroro - 未来へ.flac
Oct 26 10:20:36 volumio volumio[1286]: info: Exploding uri music-library/USB/Richard Sanderson - Reality.flac in service mpd
Oct 26 10:20:36 volumio volumio[1286]: info: ALBUMART /albumart?cacheid=851&web=Richard%20Sanderson/Reality/extralarge&path=%2Fmnt%2FUSB%2FRichard%20Sanderson%20-%20Reality.flac&metadata=false
Oct 26 10:20:36 volumio volumio[1286]: info: URI /mnt/USB/Richard Sanderson - Reality.flac
Oct 26 10:20:36 volumio volumio[1286]: info: Exploding uri music-library/USB/THE虎舞竜 - ロード.flac in service mpd
Oct 26 10:20:36 volumio volumio[1286]: info: ALBUMART /albumart?cacheid=851&web=THE%E8%99%8E%E8%88%9E%E7%AB%9C/%E3%83%AD%E3%83%BC%E3%83%89~%E3%83%89%E3%82%AD%E3%83%A5%E3%83%A1%E3%83%B3%E3%83%88/extralarge&path=%2Fmnt%2FUSB%2FTHE%E8%99%8E%E8%88%9E%E7%AB%9C%20-%20%E3%83%AD%E3%83%BC%E3%83%89.flac&metadata=false
Oct 26 10:20:36 volumio volumio[1286]: info: URI /mnt/USB/THE虎舞竜 - ロード.flac
Oct 26 10:20:36 volumio volumio[1286]: info: Exploding uri music-library/USB/蔡琴 - 恰似你的温柔.flac in service mpd
Oct 26 10:20:36 volumio volumio[1286]: info: ALBUMART /albumart?cacheid=851&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 26 10:20:36 volumio volumio[1286]: info: URI /mnt/USB/蔡琴 - 恰似你的温柔.flac
Oct 26 10:20:36 volumio volumio[1286]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8
Oct 26 10:20:36 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:36 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:38 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 26 10:20:38 volumio volumio[1286]: info: CURURI: music-library/USB/Newsmy
Oct 26 10:20:38 volumio volumio[1286]: info: Preload queue cleared
Oct 26 10:20:38 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 26 10:20:38 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:38 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 26 10:20:39 volumio volumio-remote-updater[734]: No test mode
Oct 26 10:20:39 volumio volumio-remote-updater[734]: No alpha test mode
Oct 26 10:20:39 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Oct 26 10:20:39 volumio volumio[1286]: 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: 9
Oct 26 10:20:39 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:39 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:40 volumio volumio[1286]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
- Fix for Wizard not showing on second start
- Fix for Playback Queue not advancing
NEW ADDITIONS
- Add DSD Quirk for Marantz SA-12 on Rivo and Primo v2
","title":"Update v3.757","updateavailable":true}
Oct 26 10:20:40 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 26 10:20:44 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 26 10:20:44 volumio volumio[1286]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Oct 26 10:20:44 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:20:44 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 26 10:20:49 volumio volumio[1286]: info: Preload queue cleared
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::ClearQueue
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::stop
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::stPlaybackTimer
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::updateTrackBlock
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrackBlock
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::serviceStop
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::serviceStop
Oct 26 10:20:49 volumio volumio[1286]: info: ControllerMpd::stop
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand stop
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::clearPlayQueue
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::saveQueue
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushQueue
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::addQueueItems
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::addQueueItems
Oct 26 10:20:49 volumio volumio[1286]: info: Preload queue cleared
Oct 26 10:20:49 volumio volumio[1286]: info: Adding Item to queue: music-library/USB/Newsmy/梅小琴
Oct 26 10:20:49 volumio volumio[1286]: info: Exploding uri music-library/USB/Newsmy/梅小琴 in service mpd
Oct 26 10:20:49 volumio volumio[1286]: info: sendMpdCommand stop took 96 milliseconds
Oct 26 10:20:49 volumio volumio[1286]: info:
Oct 26 10:20:49 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:49 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:49 volumio volumio[1286]: info:
Oct 26 10:20:49 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:49 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:49 volumio volumio[1286]: info:
Oct 26 10:20:49 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:49 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:49 volumio volumio[1286]: info:
Oct 26 10:20:49 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:49 volumio volumio[1286]: info: ALBUMART /albumart?cacheid=851&web=//extralarge&path=%2Fmnt%2FUSB%2FNewsmy%2F%E6%A2%85%E5%B0%8F%E7%90%B4%2F%E6%A2%85%E5%B0%8F%E7%90%B4%E3%80%8A%E5%85%B1%E9%B8%A3%20HQ%E2%85%A1%E3%80%8B2023%E5%A4%B4%E7%89%88%E9%99%90%E9%87%8F%E7%BC%96%E5%8F%B7%5B%E4%BD%8E%E9%80%9F%E6%95%B4%E8%BD%A8WAV%5D%2F%E6%A2%85%E5%B0%8F%E7%90%B4%20-%20%E5%85%B1%E9%B8%A3HQ%E2%85%A1.wav&metadata=false
Oct 26 10:20:49 volumio volumio[1286]: info: URI /mnt/USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav
Oct 26 10:20:49 volumio volumio[1286]: info: ALBUMART /albumart?cacheid=851&web=%3F%3F%3F%20//extralarge&path=%2Fmnt%2FUSB%2FNewsmy%2F%E6%A2%85%E5%B0%8F%E7%90%B4%2F%E6%A2%85%E5%B0%8F%E7%90%B4%E3%80%8A%E5%85%B1%E9%B8%A3%E3%80%8B2023%E5%A4%B4%E7%89%881%EF%BC%9A1%E9%BB%84%E9%87%91%E6%AF%8D%E7%9B%98%E7%89%88%5BWAV%2BCUE%5D%2F%E6%A2%85%E5%B0%8F%E7%90%B4%20%20-%20%E5%85%B1%E9%B8%A3.wav&metadata=false
Oct 26 10:20:49 volumio volumio[1286]: info: URI /mnt/USB/Newsmy/梅小琴/梅小琴《共鸣》2023头版1：1黄金母盘版[WAV+CUE]/梅小琴 - 共鸣.wav
Oct 26 10:20:49 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:49 volumio volumio[1286]: info: sendMpdCommand status took 16 milliseconds
Oct 26 10:20:49 volumio volumio[1286]: info: sendMpdCommand status took 13 milliseconds
Oct 26 10:20:49 volumio volumio[1286]: info: sendMpdCommand status took 10 milliseconds
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushQueue
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::saveQueue
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::updateTrackBlock
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrackBlock
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPlay
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::play index 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::stop
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::play index undefined
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::startPlaybackTimer
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::clearAddPlayTracks USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand stop
Oct 26 10:20:49 volumio volumio[1286]: info: sendMpdCommand status took 43 milliseconds
Oct 26 10:20:49 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 38 milliseconds
Oct 26 10:20:49 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 36 milliseconds
Oct 26 10:20:49 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 35 milliseconds
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:49 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:49 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::syncState stateService stop
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus stop
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:49 volumio volumio[1286]: info: No code
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:49 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:49 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::syncState stateService stop
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus stop
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:49 volumio volumio[1286]: info: No code
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:49 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:49 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::syncState stateService stop
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus stop
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:49 volumio volumio[1286]: info: No code
Oct 26 10:20:49 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:49 volumio volumio[1286]: info: ------------------------------ 349ms
Oct 26 10:20:49 volumio volumio[1286]: info: ------------------------------ 349ms
Oct 26 10:20:49 volumio volumio[1286]: info: ------------------------------ 348ms
Oct 26 10:20:49 volumio volumio[1286]: info: sendMpdCommand stop took 358 milliseconds
Oct 26 10:20:49 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 354 milliseconds
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand clear
Oct 26 10:20:49 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:49 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:49 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"孙露《观心》限量母盘1：1直刻.wav","artist":"??????????1:1?? ??HIFI??","album":"??????????1:1?? ??HIFI??","uri":"USB/Newsmy/孙露/孙露《观心》限量母盘1：1直刻.wav","trackType":"wav"}
Oct 26 10:20:50 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState stateService stop
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus stop
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: No code
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 618ms
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:50 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand clear took 227 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand add "USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav"
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:50 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:50 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:50 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:50 volumio volumio[1286]: error: updateQueue error: null
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:50 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 48ms
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand add "USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav" took 47 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 44ms
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 37ms
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 35ms
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand play
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:50 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:50 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces system playlist update
Oct 26 10:20:50 volumio volumio[1286]: info: Ignoring MPD Status Update
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 184ms
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand play took 177 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 19ms
Oct 26 10:20:50 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 19ms
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 17ms
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:50 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:50 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:50 volumio volumio[1286]: info:
Oct 26 10:20:50 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:20:50 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand status took 14 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand status took 13 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand status took 8 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand status took 6 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand status took 11 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 8 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 6 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 7 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 6 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:50 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":3130,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梅小琴 - 共鸣HQⅡ.wav","artist":null,"album":null,"uri":"USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav","trackType":"wav"}
Oct 26 10:20:50 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus stop
Oct 26 10:20:50 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":3130,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梅小琴 - 共鸣HQⅡ.wav","artist":null,"album":null,"uri":"USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav","trackType":"wav"}
Oct 26 10:20:50 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:50 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":3130,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梅小琴 - 共鸣HQⅡ.wav","artist":null,"album":null,"uri":"USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav","trackType":"wav"}
Oct 26 10:20:50 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:50 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":3130,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梅小琴 - 共鸣HQⅡ.wav","artist":null,"album":null,"uri":"USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav","trackType":"wav"}
Oct 26 10:20:50 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:50 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 97ms
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 206ms
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 194ms
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 193ms
Oct 26 10:20:50 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 187 milliseconds
Oct 26 10:20:50 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:20:50 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: verbose: STATE SERVICE {"status":"play","position":0,"seek":796,"duration":3130,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梅小琴 - 共鸣HQⅡ.wav","artist":null,"album":null,"uri":"USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav","trackType":"wav"}
Oct 26 10:20:50 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState stateService play
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus play
Oct 26 10:20:50 volumio volumio[1286]: info: Received an update from plugin. extracting info from payload
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:20:50 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:20:50 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:20:50 volumio volumio[1286]: info: ------------------------------ 282ms
Oct 26 10:20:51 volumio volumio[1286]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Oct 26 10:20:51 volumio volumio[1286]: info: Completed starting MyVolumio Plugin
Oct 26 10:20:51 volumio volumio[1286]: info: BOOT COMPLETED
Oct 26 10:20:51 volumio volumio[1286]: [Metrics] CommandRouter: 59s 967.67ms
Oct 26 10:20:51 volumio volumio[1286]: info: CoreCommandRouter::volumiosetStartupVolume
Oct 26 10:20:51 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 26 10:20:51 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:20:51 volumio volumio[1286]: info: CoreCommandRouter::Close All Modals sent
Oct 26 10:20:51 volumio volumio[1286]: info: CoreCommandRouter::Close All Modals sent
Oct 26 10:20:51 volumio volumio[1286]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Oct 26 10:20:51 volumio volumio[1286]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card
Oct 26 10:20:51 volumio volumio[1286]: aplay: main:828: audio open error: No such device
Oct 26 10:20:52 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Oct 26 10:20:52 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 26 10:20:52 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Oct 26 10:20:52 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Oct 26 10:21:01 volumio volumio[1286]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Oct 26 10:21:01 volumio volumio[1286]: info: Retrying Login Due to Network Error
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 26 10:21:04 volumio volumio[1286]: Invalid card number.
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 26 10:21:04 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 26 10:21:11 volumio volumio[1286]: info: MyVolumio login type: Token
Oct 26 10:21:11 volumio volumio[1286]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Oct 26 10:21:11 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Oct 26 10:21:11 volumio volumio[1286]: info: Preparing to save Alsa Options, stopping services first
Oct 26 10:21:11 volumio volumio[1286]: info: CoreCommandRouter::volumioGetState
Oct 26 10:21:11 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:21:11 volumio volumio[1286]: info: CoreCommandRouter::volumioPause
Oct 26 10:21:11 volumio volumio[1286]: info: CoreStateMachine::pause
Oct 26 10:21:11 volumio volumio[1286]: info: CoreStateMachine::stPlaybackTimer
Oct 26 10:21:11 volumio volumio[1286]: info: CoreStateMachine::servicePause
Oct 26 10:21:11 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:21:11 volumio volumio[1286]: info: CoreCommandRouter::servicePause
Oct 26 10:21:11 volumio volumio[1286]: info: ControllerMpd::pause
Oct 26 10:21:11 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand pause
Oct 26 10:21:11 volumio volumio[1286]: info: Saving Audio Output to: {"output_device":{"value":"1,0","label":"Analog Out"}}
Oct 26 10:21:11 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 26 10:21:12 volumio volumio[1286]: info: Found match in Cards Database: setting mixer for card Analog Out
Oct 26 10:21:12 volumio volumio[1286]: info: Setting mixer Master for card Analog Out
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 26 10:21:12 volumio volumio[1286]: info: Updating Volume Controller Parameters: Device: 1,0 Name: Analog Out Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 26 10:21:12 volumio volumio[1286]: info: Disabling external Volume Control
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 26 10:21:12 volumio volumio[1286]: info: Preparing to generate the ALSA configuration file
Oct 26 10:21:12 volumio volumio[1286]: info:
Oct 26 10:21:12 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:21:12 volumio volumio[1286]: info: sendMpdCommand pause took 350 milliseconds
Oct 26 10:21:12 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:21:12 volumio volumio[1286]: info:
Oct 26 10:21:12 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:21:12 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:21:12 volumio volumio[1286]: info:
Oct 26 10:21:12 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:21:12 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:21:12 volumio volumio[1286]: info:
Oct 26 10:21:12 volumio volumio[1286]: ---------------------------- MPD announces state update: player
Oct 26 10:21:12 volumio volumio[1286]: info: ControllerMpd::getState
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 10:21:12 volumio volumio[1286]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Oct 26 10:21:12 volumio volumio[1286]: info: Reading ALSA contributions from plugins.
Oct 26 10:21:12 volumio volumio[1286]: info: sendMpdCommand status took 52 milliseconds
Oct 26 10:21:12 volumio volumio[1286]: info: sendMpdCommand status took 49 milliseconds
Oct 26 10:21:12 volumio volumio[1286]: info: sendMpdCommand status took 43 milliseconds
Oct 26 10:21:12 volumio volumio[1286]: info: sendMpdCommand status took 42 milliseconds
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::parseState
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 10:21:12 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 11 milliseconds
Oct 26 10:21:12 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 12 milliseconds
Oct 26 10:21:12 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 11 milliseconds
Oct 26 10:21:12 volumio volumio[1286]: info: sendMpdCommand playlistinfo took 12 milliseconds
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:21:12 volumio volumio[1286]: verbose: ControllerMpd::parseTrackInfo
Oct 26 10:21:12 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:21:12 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:21:12 volumio volumio[1286]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":22629,"duration":3130,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梅小琴 - 共鸣HQⅡ.wav","artist":null,"album":null,"uri":"USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav","trackType":"wav"}
Oct 26 10:21:12 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::syncState stateService pause
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus pause
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:21:12 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::stPlaybackTimer
Oct 26 10:21:12 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:21:12 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:21:12 volumio volumio[1286]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":22629,"duration":3130,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梅小琴 - 共鸣HQⅡ.wav","artist":null,"album":null,"uri":"USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav","trackType":"wav"}
Oct 26 10:21:12 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::syncState stateService pause
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus pause
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:21:12 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::stPlaybackTimer
Oct 26 10:21:12 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:21:12 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:21:12 volumio volumio[1286]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":22629,"duration":3130,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梅小琴 - 共鸣HQⅡ.wav","artist":null,"album":null,"uri":"USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav","trackType":"wav"}
Oct 26 10:21:12 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::syncState stateService pause
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus pause
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:21:12 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::stPlaybackTimer
Oct 26 10:21:12 volumio volumio[1286]: info: ControllerMpd::pushState
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::servicePushState
Oct 26 10:21:12 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:21:12 volumio volumio[1286]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":22629,"duration":3130,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梅小琴 - 共鸣HQⅡ.wav","artist":null,"album":null,"uri":"USB/Newsmy/梅小琴/梅小琴《共鸣 HQⅡ》2023头版限量编号[低速整轨WAV]/梅小琴 - 共鸣HQⅡ.wav","trackType":"wav"}
Oct 26 10:21:12 volumio volumio[1286]: verbose: CURRENT POSITION 0
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::syncState stateService pause
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::syncState currentStatus pause
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::pushState
Oct 26 10:21:12 volumio volumio[1286]: info: CorePlayQueue::getTrack 0
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::volumioPushState
Oct 26 10:21:12 volumio volumio[1286]: info: CoreStateMachine::stPlaybackTimer
Oct 26 10:21:12 volumio volumio[1286]: info: ------------------------------ 225ms
Oct 26 10:21:12 volumio volumio[1286]: info: ------------------------------ 225ms
Oct 26 10:21:12 volumio volumio[1286]: info: ------------------------------ 223ms
Oct 26 10:21:12 volumio volumio[1286]: info: ------------------------------ 218ms
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 26 10:21:12 volumio volumio[1286]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 26 10:21:12 volumio volumio[1286]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 26 10:21:12 volumio volumio[1286]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning'
Oct 26 10:21:12 volumio volumio[1286]: at Object.readdirSync (fs.js:1048:3)
Oct 26 10:21:12 volumio volumio[1286]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11)
Oct 26 10:21:12 volumio volumio[1286]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7)
Oct 26 10:21:12 volumio volumio[1286]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62)
Oct 26 10:21:12 volumio volumio[1286]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17)
Oct 26 10:21:12 volumio volumio[1286]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48)
Oct 26 10:21:12 volumio volumio[1286]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Oct 26 10:21:12 volumio volumio[1286]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10)
Oct 26 10:21:12 volumio volumio[1286]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12)
Oct 26 10:21:12 volumio volumio[1286]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Oct 26 10:21:12 volumio volumio[1286]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Oct 26 10:21:12 volumio volumio[1286]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8)
Oct 26 10:21:12 volumio volumio[1286]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15)
Oct 26 10:21:12 volumio volumio[1286]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20)
Oct 26 10:21:12 volumio volumio[1286]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12)
Oct 26 10:21:12 volumio volumio[1286]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) {
Oct 26 10:21:12 volumio volumio[1286]: errno: -20,
Oct 26 10:21:12 volumio volumio[1286]: syscall: 'scandir',
Oct 26 10:21:12 volumio volumio[1286]: code: 'ENOTDIR',
Oct 26 10:21:12 volumio volumio[1286]: path: '/tmp/peppyrunning'
Oct 26 10:21:12 volumio volumio[1286]: }
Oct 26 10:21:12 volumio volumio[1286]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 26 10:21:13 volumio sudo[2399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-26 10:20
Oct 26 10:21:13 volumio sudo[2399]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST"
VOLUMIO_VERSION="3.742"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"