Jan 10 14:19:16 volumio volumio[1219]: verbose: New Socket.io Connection to 192.168.8.228 from 192.168.8.203 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::volumioGetVisibleSources Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Jan 10 14:19:16 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::volumioGetQueue Jan 10 14:19:16 volumio volumio[1219]: info: CoreStateMachine::getQueue Jan 10 14:19:16 volumio volumio[1219]: info: CorePlayQueue::getQueue Jan 10 14:19:16 volumio volumio[1219]: info: Listing playlists Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 10 14:19:16 volumio volumio[1219]: info: Received Get System Info Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 10 14:19:16 volumio volumio[1219]: info: Discovery: Getting this device information Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Jan 10 14:19:16 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Jan 10 14:19:16 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 10 14:19:16 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 10 14:19:18 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 10 14:19:18 volumio volumio[1219]: info: Received Get System Info Jan 10 14:19:18 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 10 14:19:18 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 10 14:19:18 volumio volumio[1219]: info: Discovery: Getting this device information Jan 10 14:19:18 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Jan 10 14:19:18 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:18 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 10 14:19:19 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 10 14:19:19 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Jan 10 14:19:19 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:20 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 10 14:19:20 volumio volumio[1219]: info: Received Get System Info Jan 10 14:19:20 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 10 14:19:20 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 10 14:19:20 volumio volumio[1219]: info: Discovery: Getting this device information Jan 10 14:19:20 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Jan 10 14:19:20 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:20 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 10 14:19:22 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 10 14:19:26 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 10 14:19:34 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 10 14:19:34 volumio volumio[1219]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 10 14:19:34 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 10 14:19:34 volumio volumio[1219]: info: Received Get System Version Jan 10 14:19:34 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 10 14:19:34 volumio volumio[1219]: info: Received Get System Info Jan 10 14:19:34 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 10 14:19:34 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 10 14:19:34 volumio volumio[1219]: info: Discovery: Getting this device information Jan 10 14:19:34 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Jan 10 14:19:34 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:34 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 10 14:19:48 volumio volumio[1219]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 10 14:19:48 volumio volumio[1219]: info: Preparing to save Alsa Options, stopping services first Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Jan 10 14:19:48 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::volumioPause Jan 10 14:19:48 volumio volumio[1219]: info: CoreStateMachine::pause Jan 10 14:19:48 volumio volumio[1219]: info: CoreStateMachine::stPlaybackTimer Jan 10 14:19:48 volumio volumio[1219]: info: CoreStateMachine::servicePause Jan 10 14:19:48 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::servicePause Jan 10 14:19:48 volumio volumio[1219]: info: ControllerMpd::pause Jan 10 14:19:48 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand pause Jan 10 14:19:48 volumio volumio[1219]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"FiiO KA1"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 14:19:48 volumio volumio[1219]: info: Setting mixer PCM for card FiiO KA1 Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 10 14:19:48 volumio volumio[1219]: info: Updating Volume Controller Parameters: Device: 5 Name: FiiO KA1 Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 10 14:19:48 volumio volumio[1219]: info: Disabling external Volume Control Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 10 14:19:48 volumio volumio[1219]: info: Preparing to generate the ALSA configuration file Jan 10 14:19:48 volumio volumio[1219]: info: Jan 10 14:19:48 volumio volumio[1219]: ---------------------------- MPD announces state update: player Jan 10 14:19:48 volumio volumio[1219]: info: sendMpdCommand pause took 98 milliseconds Jan 10 14:19:48 volumio volumio[1219]: info: ControllerMpd::getState Jan 10 14:19:48 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Jan 10 14:19:48 volumio volumio[1219]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Jan 10 14:19:48 volumio volumio[1219]: info: Reading ALSA contributions from plugins. Jan 10 14:19:48 volumio volumio[1219]: info: sendMpdCommand status took 11 milliseconds Jan 10 14:19:48 volumio volumio[1219]: verbose: ControllerMpd::parseState Jan 10 14:19:48 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 14:19:48 volumio volumio[1219]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 10 14:19:48 volumio volumio[1219]: verbose: ControllerMpd::parseTrackInfo Jan 10 14:19:48 volumio volumio[1219]: info: ControllerMpd::pushState Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::servicePushState Jan 10 14:19:48 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:48 volumio volumio[1219]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":56281,"duration":361,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"Birdland","artist":"Weather Report","album":"Heavy Weather","uri":"NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/01 -Birdland.dsf","trackType":"dsf"} Jan 10 14:19:48 volumio volumio[1219]: verbose: CURRENT POSITION 0 Jan 10 14:19:48 volumio volumio[1219]: info: CoreStateMachine::syncState stateService pause Jan 10 14:19:48 volumio volumio[1219]: info: CoreStateMachine::syncState currentStatus pause Jan 10 14:19:48 volumio volumio[1219]: info: CoreStateMachine::pushState Jan 10 14:19:48 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState Jan 10 14:19:48 volumio volumio[1219]: info: CoreStateMachine::stPlaybackTimer Jan 10 14:19:48 volumio volumio[1219]: info: ------------------------------ 17ms Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 10 14:19:48 volumio volumio[1219]: info: PeppyMeterBasic ---peppymeterbasic status pause Jan 10 14:19:48 volumio sudo[31820]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 10 14:19:48 volumio sudo[31820]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:19:48 volumio volumio[1219]: info: VolumeController:: Volume=22 Mute =false Jan 10 14:19:48 volumio volumio[1219]: info: CoreStateMachine::pushState Jan 10 14:19:48 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState Jan 10 14:19:48 volumio volumio[1219]: info: PeppyMeterBasic ---peppymeterbasic status pause Jan 10 14:19:48 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Jan 10 14:19:48 volumio volumio[1219]: info: Asound.conf file unchanged, so no further update is needed Jan 10 14:19:48 volumio volumio[1219]: info: Output device has changed, restarting MPD Jan 10 14:19:48 volumio sudo[31825]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 10 14:19:48 volumio sudo[31825]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:19:48 volumio volumio[1219]: info: Output device has changed, restarting Shairport Sync Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 14:19:48 volumio sudo[31828]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 10 14:19:48 volumio sudo[31828]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:19:48 volumio sudo[31828]: pam_unix(sudo:session): session closed for user root Jan 10 14:19:48 volumio volumio[1219]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 14:19:48 volumio sudo[31832]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 10 14:19:48 volumio volumio[1219]: info: MPD Permissions set Jan 10 14:19:48 volumio sudo[31832]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 14:19:48 volumio volumio[1219]: info: Starting Shairport Sync Jan 10 14:19:48 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 10 14:19:48 volumio sudo[31845]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 14:19:48 volumio volumio[1219]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 10 14:19:48 volumio sudo[31845]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:19:48 volumio systemd[1]: mpd.service: Deactivated successfully. Jan 10 14:19:48 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 10 14:19:48 volumio systemd[1]: mpd.service: Consumed 15min 2.674s CPU time. Jan 10 14:19:48 volumio systemd[1]: mpd.socket: Deactivated successfully. Jan 10 14:19:48 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 10 14:19:48 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 10 14:19:48 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 10 14:19:48 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 10 14:19:48 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 10 14:19:48 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 10 14:19:48 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 14:19:48 volumio systemd[1]: shairport-sync.service: Consumed 16.076s CPU time. Jan 10 14:19:48 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 10 14:19:48 volumio sudo[31845]: pam_unix(sudo:session): session closed for user root Jan 10 14:19:48 volumio volumio[1219]: info: Shairport-Sync Started Jan 10 14:19:48 volumio sudo[31848]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 10 14:19:48 volumio sudo[31848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 10 14:19:48 volumio sudo[31848]: pam_unix(sudo:session): session closed for user root Jan 10 14:19:48 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Jan 10 14:19:48 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Jan 10 14:19:48 volumio systemd[1]: peppymeterbasic.service: Consumed 13.728s CPU time. Jan 10 14:19:48 volumio sudo[31825]: pam_unix(sudo:session): session closed for user root Jan 10 14:19:48 volumio sudo[31820]: pam_unix(sudo:session): session closed for user root Jan 10 14:19:48 volumio volumio[1219]: info: peppymeterbasic Daemon Stop Jan 10 14:19:48 volumio volumio[1219]: info: peppymeterbasic Daemon Stop Jan 10 14:19:49 volumio mpd[31865]: 2026-01-10T14:19:49 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 10 14:19:49 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jan 10 14:19:49 volumio sudo[31832]: pam_unix(sudo:session): session closed for user root Jan 10 14:19:49 volumio volumio[1219]: error: updateQueue error: null Jan 10 14:19:52 volumio volumio[1219]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 10 14:19:52 volumio volumio[1219]: info: CoreStateMachine::getcurrentVolume Jan 10 14:19:52 volumio volumio[1219]: info: CoreCommandRouter::volumioRetrievevolume Jan 10 14:19:52 volumio volumio[1219]: info: VolumeController:: Volume=22 Mute =false Jan 10 14:19:52 volumio volumio[1219]: info: CoreStateMachine::pushState Jan 10 14:19:52 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:52 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 14:19:52 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState Jan 10 14:19:52 volumio volumio[1219]: info: CoreStateMachine::updateTrackBlock Jan 10 14:19:52 volumio volumio[1219]: info: CorePlayQueue::getTrackBlock Jan 10 14:19:52 volumio volumio[1219]: info: CoreCommandRouter::volumioRetrievevolume Jan 10 14:19:52 volumio volumio[1219]: info: PeppyMeterBasic ---peppymeterbasic status pause Jan 10 14:19:52 volumio sudo[31887]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 10 14:19:52 volumio sudo[31887]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:19:52 volumio volumio[1219]: info: VolumeController:: Volume=22 Mute =false Jan 10 14:19:52 volumio volumio[1219]: info: CoreStateMachine::pushState Jan 10 14:19:52 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:52 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState Jan 10 14:19:52 volumio volumio[1219]: info: PeppyMeterBasic ---peppymeterbasic status pause Jan 10 14:19:52 volumio sudo[31891]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 10 14:19:52 volumio sudo[31891]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:19:52 volumio sudo[31887]: pam_unix(sudo:session): session closed for user root Jan 10 14:19:52 volumio volumio[1219]: info: peppymeterbasic Daemon Stop Jan 10 14:19:52 volumio sudo[31891]: pam_unix(sudo:session): session closed for user root Jan 10 14:19:52 volumio volumio[1219]: info: peppymeterbasic Daemon Stop Jan 10 14:19:53 volumio sudo[31894]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 10 14:19:53 volumio sudo[31894]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:19:53 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Jan 10 14:19:53 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Jan 10 14:19:53 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Jan 10 14:19:53 volumio systemd[1]: mpd_monitor.service: Consumed 2.245s CPU time. Jan 10 14:19:53 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Jan 10 14:19:53 volumio sudo[31894]: pam_unix(sudo:session): session closed for user root Jan 10 14:19:53 volumio mpd_monitor.sh[31896]: MPD Monitor Service: Starting MPD Monitor Service Jan 10 14:19:53 volumio volumio[1219]: info: Successfully started MPD Monitor Jan 10 14:19:58 volumio volumio[1219]: info: CoreCommandRouter::volumioGetState Jan 10 14:19:58 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:59 volumio volumio[1219]: info: CoreCommandRouter::volumioPlay Jan 10 14:19:59 volumio volumio[1219]: info: CoreStateMachine::play index undefined Jan 10 14:19:59 volumio volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 14:19:59 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:59 volumio volumio[1219]: info: CoreStateMachine::startPlaybackTimer Jan 10 14:19:59 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:19:59 volumio volumio[1219]: info: ControllerMpd::resume Jan 10 14:19:59 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand play Jan 10 14:19:59 volumio volumio[1219]: info: sendMpdCommand play took 1 milliseconds Jan 10 14:20:09 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 14:20:09 volumio volumio[1219]: info: CURURI: artists:// Jan 10 14:20:09 volumio volumio[1219]: info: Preload queue cleared Jan 10 14:20:43 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 10 14:20:43 volumio volumio[1219]: info: CURURI: artists://Weather%20Report Jan 10 14:20:43 volumio volumio[1219]: info: Preload queue cleared Jan 10 14:20:43 volumio volumio[1219]: info: Preload queue cleared Jan 10 14:20:43 volumio volumio[1219]: info: No valid Plugin REST Endpoint Jan 10 14:20:43 volumio volumio[1219]: info: No valid Plugin REST Endpoint Jan 10 14:20:45 volumio volumio[1219]: info: Preload queue cleared Jan 10 14:20:45 volumio volumio[1219]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::ClearQueue Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::stop Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::updateTrackBlock Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::getTrackBlock Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::stPlaybackTimer Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::pushState Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:20:45 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 14:20:45 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::serviceStop Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:20:45 volumio volumio[1219]: info: CoreCommandRouter::serviceStop Jan 10 14:20:45 volumio volumio[1219]: info: ControllerMpd::stop Jan 10 14:20:45 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::clearPlayQueue Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::saveQueue Jan 10 14:20:45 volumio volumio[1219]: info: CoreCommandRouter::volumioPushQueue Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::addQueueItems Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::addQueueItems Jan 10 14:20:45 volumio volumio[1219]: info: Preload queue cleared Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/01 -Birdland.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/01 -Birdland.dsf Jan 10 14:20:45 volumio volumio[1219]: info: CoreCommandRouter::volumioPushQueue Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::saveQueue Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::updateTrackBlock Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::getTrackBlock Jan 10 14:20:45 volumio volumio[1219]: info: CoreCommandRouter::volumioPlay Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::play index 0 Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::addQueueItems Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::addQueueItems Jan 10 14:20:45 volumio volumio[1219]: info: Preload queue cleared Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/02 -A Remark You Made.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/02 -A Remark You Made.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/03 -Teen Town.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/03 -Teen Town.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/04 -Harlequin.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/04 -Harlequin.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/05 -Rumba Mamá.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/05 -Rumba Mamá.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/06 -Palladíum.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/06 -Palladíum.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/07 -The Juggler.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/07 -The Juggler.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/08 -Havona.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/08 -Havona.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/01 -Birdland.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/01 -Birdland.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/02 -A Remark You Made.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/02 -A Remark You Made.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/03 -Teen Town.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/03 -Teen Town.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/04 -Harlequin.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/04 -Harlequin.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/05 -Rumba Mamá.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/05 -Rumba Mamá.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/06 -Palladíum.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/06 -Palladíum.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/07 -The Juggler.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/07 -The Juggler.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Adding Item to queue: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/08 -Havona.dsf Jan 10 14:20:45 volumio volumio[1219]: info: Using cached record of: music-library/NAS/Music2/(uaoa) Weather Report - Heavy Weather - 1977/08 -Havona.dsf Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::stop Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 14:20:45 volumio volumio[1219]: info: CoreCommandRouter::volumioPushQueue Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::saveQueue Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::play index undefined Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::updateTrackBlock Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::getTrackBlock Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:20:45 volumio volumio[1219]: info: CoreStateMachine::startPlaybackTimer Jan 10 14:20:45 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:20:45 volumio volumio[1219]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/01 -Birdland.dsf Jan 10 14:20:45 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand stop Jan 10 14:20:45 volumio volumio[1219]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 10 14:20:45 volumio sudo[31983]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 10 14:20:45 volumio sudo[31983]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:20:45 volumio volumio[1219]: info: sendMpdCommand stop took 52 milliseconds Jan 10 14:20:45 volumio volumio[1219]: info: sendMpdCommand stop took 35 milliseconds Jan 10 14:20:45 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand clear Jan 10 14:20:45 volumio volumio[1219]: info: Jan 10 14:20:45 volumio volumio[1219]: ---------------------------- MPD announces system playlist update Jan 10 14:20:45 volumio volumio[1219]: info: Ignoring MPD Status Update Jan 10 14:20:45 volumio volumio[1219]: info: sendMpdCommand clear took 1 milliseconds Jan 10 14:20:45 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/01 -Birdland.dsf" Jan 10 14:20:45 volumio volumio[1219]: error: updateQueue error: null Jan 10 14:20:45 volumio volumio[1219]: info: Jan 10 14:20:45 volumio volumio[1219]: ---------------------------- MPD announces system playlist update Jan 10 14:20:45 volumio volumio[1219]: info: Ignoring MPD Status Update Jan 10 14:20:45 volumio volumio[1219]: info: ------------------------------ 9ms Jan 10 14:20:45 volumio volumio[1219]: info: sendMpdCommand add "NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/01 -Birdland.dsf" took 9 milliseconds Jan 10 14:20:45 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand play Jan 10 14:20:45 volumio volumio[1219]: info: ------------------------------ 2ms Jan 10 14:20:45 volumio volumio[1219]: info: sendMpdCommand play took 1 milliseconds Jan 10 14:20:45 volumio sudo[31983]: pam_unix(sudo:session): session closed for user root Jan 10 14:20:45 volumio volumio[1219]: info: peppymeterbasic Daemon Stop Jan 10 14:20:45 volumio volumio[1219]: info: Jan 10 14:20:45 volumio volumio[1219]: ---------------------------- MPD announces state update: player Jan 10 14:20:45 volumio volumio[1219]: info: ControllerMpd::getState Jan 10 14:20:45 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Jan 10 14:20:46 volumio volumio[1219]: info: Jan 10 14:20:46 volumio volumio[1219]: ---------------------------- MPD announces state update: player Jan 10 14:20:46 volumio volumio[1219]: info: sendMpdCommand status took 363 milliseconds Jan 10 14:20:46 volumio volumio[1219]: info: ControllerMpd::getState Jan 10 14:20:46 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Jan 10 14:20:46 volumio volumio[1219]: verbose: ControllerMpd::parseState Jan 10 14:20:46 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 14:20:46 volumio volumio[1219]: info: sendMpdCommand status took 1 milliseconds Jan 10 14:20:46 volumio volumio[1219]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 10 14:20:46 volumio volumio[1219]: verbose: ControllerMpd::parseState Jan 10 14:20:46 volumio volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 10 14:20:46 volumio volumio[1219]: verbose: ControllerMpd::parseTrackInfo Jan 10 14:20:46 volumio volumio[1219]: info: ControllerMpd::pushState Jan 10 14:20:46 volumio volumio[1219]: info: CoreCommandRouter::servicePushState Jan 10 14:20:46 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:20:46 volumio volumio[1219]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":361,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"Birdland","artist":"Weather Report","album":"Heavy Weather","uri":"NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/01 -Birdland.dsf","trackType":"dsf"} Jan 10 14:20:46 volumio volumio[1219]: verbose: CURRENT POSITION 0 Jan 10 14:20:46 volumio volumio[1219]: info: CoreStateMachine::syncState stateService play Jan 10 14:20:46 volumio volumio[1219]: info: CoreStateMachine::syncState currentStatus stop Jan 10 14:20:46 volumio volumio[1219]: info: ------------------------------ 366ms Jan 10 14:20:46 volumio volumio[1219]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 10 14:20:46 volumio volumio[1219]: verbose: ControllerMpd::parseTrackInfo Jan 10 14:20:46 volumio volumio[1219]: info: ControllerMpd::pushState Jan 10 14:20:46 volumio volumio[1219]: info: CoreCommandRouter::servicePushState Jan 10 14:20:46 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:20:46 volumio volumio[1219]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25,"duration":361,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"Birdland","artist":"Weather Report","album":"Heavy Weather","uri":"NAS/Music1/(uaoa) Weather Report - Heavy Weather - 1977/01 -Birdland.dsf","trackType":"dsf"} Jan 10 14:20:46 volumio volumio[1219]: verbose: CURRENT POSITION 0 Jan 10 14:20:46 volumio volumio[1219]: info: CoreStateMachine::syncState stateService play Jan 10 14:20:46 volumio volumio[1219]: info: CoreStateMachine::syncState currentStatus play Jan 10 14:20:46 volumio volumio[1219]: info: Received an update from plugin. extracting info from payload Jan 10 14:20:46 volumio volumio[1219]: info: CoreStateMachine::pushState Jan 10 14:20:46 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:20:46 volumio volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 14:20:46 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState Jan 10 14:20:46 volumio volumio[1219]: info: CoreStateMachine::pushState Jan 10 14:20:46 volumio volumio[1219]: info: CorePlayQueue::getTrack 0 Jan 10 14:20:46 volumio volumio[1219]: info: CoreCommandRouter::volumioPushState Jan 10 14:20:46 volumio volumio[1219]: info: ------------------------------ 11ms Jan 10 14:20:46 volumio volumio[1219]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 10 14:20:46 volumio volumio[1219]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 10 14:20:46 volumio sudo[31991]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 10 14:20:46 volumio sudo[31991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:20:46 volumio sudo[31993]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 10 14:20:46 volumio sudo[31993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 10 14:20:46 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Jan 10 14:20:46 volumio sudo[31991]: pam_unix(sudo:session): session closed for user root Jan 10 14:20:46 volumio volumio[1219]: info: peppymeterbasic Daemon Started Jan 10 14:20:46 volumio sudo[31993]: pam_unix(sudo:session): session closed for user root Jan 10 14:20:46 volumio volumio[1219]: info: peppymeterbasic Daemon Started Jan 10 14:20:50 volumio volumio[1219]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 14:20:50 volumio volumio[1219]: TypeError: Cannot read properties of null (reading 'slice') Jan 10 14:20:50 volumio volumio[1219]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Jan 10 14:20:50 volumio volumio[1219]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Jan 10 14:20:50 volumio volumio[1219]: at Object.onceWrapper (node:events:629:26) Jan 10 14:20:50 volumio volumio[1219]: at ClientRequest.emit (node:events:514:28) Jan 10 14:20:50 volumio volumio[1219]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Jan 10 14:20:50 volumio volumio[1219]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Jan 10 14:20:50 volumio volumio[1219]: at TLSSocket.socketOnData (node:_http_client:535:22) Jan 10 14:20:50 volumio volumio[1219]: at TLSSocket.emit (node:events:514:28) Jan 10 14:20:50 volumio volumio[1219]: at addChunk (node:internal/streams/readable:343:12) Jan 10 14:20:50 volumio volumio[1219]: at readableAddChunk (node:internal/streams/readable:316:9) Jan 10 14:20:50 volumio volumio[1219]: at Readable.push (node:internal/streams/readable:253:10) Jan 10 14:20:50 volumio volumio[1219]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Jan 10 14:20:50 volumio volumio[1219]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 14:20:50 volumio sudo[32027]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-10 14:19' Jan 10 14:20:50 volumio sudo[32027]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"