Mar 28 22:36:00 kitchen volumio[1017]: [Metrics] WebUI: 28s 835.91ms
Mar 28 22:36:00 kitchen volumio[1017]: info: CoreStateMachine::resetVolumioState
Mar 28 22:36:00 kitchen volumio[1017]: info: CoreStateMachine::getcurrentVolume
Mar 28 22:36:00 kitchen volumio[1017]: info: CoreCommandRouter::volumioRetrievevolume
Mar 28 22:36:00 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 28 22:36:00 kitchen volumio[1251]: Starting albumart workers
Mar 28 22:36:00 kitchen volumio[1017]: info: Volumio Network Manager: Network status updated: 2
Mar 28 22:36:01 kitchen volumio-remote-updater[550]: [2026-03-28 22:36:01] [connect] Successful connection
Mar 28 22:36:02 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50:3000 from 10.0.13.52 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Mar 28 22:36:02 kitchen volumio[1017]: info: VolumeController:: Volume=49 Mute =false
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreStateMachine::pushState
Mar 28 22:36:02 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreCommandRouter::volumioPushState
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreStateMachine::updateTrackBlock
Mar 28 22:36:02 kitchen volumio[1017]: info: CorePlayQueue::getTrackBlock
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreCommandRouter::volumioRetrievevolume
Mar 28 22:36:02 kitchen volumio[1017]: info: Reloading queue from file
Mar 28 22:36:02 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50:3000 from 10.0.13.51 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreStateMachine::setRepeat null single undefined
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreStateMachine::pushState
Mar 28 22:36:02 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreCommandRouter::volumioPushState
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreStateMachine::setRandom false
Mar 28 22:36:02 kitchen volumio[1017]: info: CoreStateMachine::pushState
Mar 28 22:36:03 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:03 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 22:36:03 kitchen volumio[1017]: info: CoreCommandRouter::volumioPushState
Mar 28 22:36:03 kitchen volumio[1017]: info: Setting Device type: Raspberry PI
Mar 28 22:36:03 kitchen volumio[1017]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Mar 28 22:36:03 kitchen volumio[1017]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120
Mar 28 22:36:03 kitchen volumio[1017]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Mar 28 22:36:03 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50:3000 from 10.0.13.52 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Mar 28 22:36:03 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50:3000 from 10.0.13.51 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Mar 28 22:36:03 kitchen volumio[1017]: info: VolumeController:: Volume=49 Mute =false
Mar 28 22:36:03 kitchen volumio[1017]: info: CoreStateMachine::pushState
Mar 28 22:36:03 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:03 kitchen volumio[1017]: info: CoreCommandRouter::volumioPushState
Mar 28 22:36:03 kitchen volumio[1017]: info: Discovery: adding 32e1a811-fc46-4891-a867-6fbb8349177a
Mar 28 22:36:03 kitchen volumio[1017]: info: Discovery: Found device Kitchen
Mar 28 22:36:04 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:04 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:04 kitchen volumio[1017]: info: Discovery: this is already registered, 32e1a811-fc46-4891-a867-6fbb8349177a
Mar 28 22:36:04 kitchen volumio[1017]: info: Discovery: Found device Kitchen
Mar 28 22:36:04 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:04 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:04 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50:3000 from 10.0.13.52 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Mar 28 22:36:04 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50:3000 from 10.0.13.51 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Mar 28 22:36:04 kitchen volumio[1017]: info: Discovery: adding cf6b43a4-4d95-40d0-bad6-29c237dde832
Mar 28 22:36:04 kitchen volumio[1017]: info: Discovery: Found device Patio
Mar 28 22:36:04 kitchen volumio[1017]: info: Discovery: Connecting to remote: 10.0.13.52
Mar 28 22:36:04 kitchen volumio[1017]: info: Discovery: adding b4757e7c-40df-4721-9d44-3e9d86f6b7fc
Mar 28 22:36:04 kitchen volumio[1017]: info: Discovery: Found device Master
Mar 28 22:36:04 kitchen volumio[1017]: info: Discovery: Connecting to remote: 10.0.13.51
Mar 28 22:36:04 kitchen volumio-remote-updater[550]: [2026-03-28 22:36:04] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1774755361 101
Mar 28 22:36:04 kitchen volumio[1017]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 7
Mar 28 22:36:04 kitchen volumio[1017]: info: Completed loading Core Plugins
Mar 28 22:36:04 kitchen volumio[1017]: info: Preparing to generate the ALSA configuration file
Mar 28 22:36:04 kitchen volumio[1017]: info: Discovery: Connected to remote: 10.0.13.52
Mar 28 22:36:05 kitchen volumio[1017]: info: Discovery: Connected to remote: 10.0.13.51
Mar 28 22:36:05 kitchen volumio[1017]: info: Asound.conf file unchanged, so no further update is needed
Mar 28 22:36:05 kitchen volumio[1017]: info: Output device has changed, restarting MPD
Mar 28 22:36:05 kitchen volumio[1017]: info: ___________ START PLUGINS ___________
Mar 28 22:36:05 kitchen volumio[1017]: info: ControllerMpd::onStart: Initializing MPD
Mar 28 22:36:05 kitchen sudo[1372]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 28 22:36:05 kitchen sudo[1372]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 28 22:36:05 kitchen volumio[1017]: info: Creating MPD Configuration file
Mar 28 22:36:05 kitchen sudo[1374]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 28 22:36:05 kitchen sudo[1372]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:05 kitchen sudo[1374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 28 22:36:05 kitchen volumio[1017]: info: [1774755365619] CoreMusicLibrary::Adding element Last_100
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 28 22:36:05 kitchen volumio[1017]: info: [1774755365633] CoreMusicLibrary::Adding element Webradio
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 28 22:36:05 kitchen sudo[1378]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 28 22:36:05 kitchen volumio[1017]: info: Initializing BBC Radios
Mar 28 22:36:05 kitchen sudo[1376]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Mar 28 22:36:05 kitchen sudo[1376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 28 22:36:05 kitchen volumio[1017]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 28 22:36:05 kitchen sudo[1378]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 28 22:36:05 kitchen sudo[1378]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:05 kitchen sudo[1382]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 28 22:36:05 kitchen sudo[1382]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 28 22:36:05 kitchen volumio[1017]: info: Discovery: Getting this device information
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:05 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 28 22:36:05 kitchen volumio[1017]: info: [1774755365980] CoreMusicLibrary::Adding element Jellyfin
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 28 22:36:05 kitchen volumio[1017]: Cannot find translation for source Jellyfin
Mar 28 22:36:05 kitchen volumio[1017]: info: [jellyfin] Initialized plugin with device info: {"host":"http://10.0.13.50","id":"32e1a811-fc46-4891-a867-6fbb8349177a","name":"Kitchen","serviceName":"Volumio","state":{"albumart":"http://10.0.11.10:8096/Items/10adcb2aedfb112f77e3ad9fdbd1d5a9/Images/Primary?maxWidth=500&maxHeight=500&quality=90","artist":"Fly by Midnight","mute":false,"status":"stop","track":"Be Right There","volume":49},"type":"device"}
Mar 28 22:36:05 kitchen volumio[1017]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Mar 28 22:36:06 kitchen volumio[1017]: info: [1774755366004] CoreMusicLibrary::Adding element Pandora Radio
Mar 28 22:36:06 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 28 22:36:06 kitchen volumio[1017]: Cannot find translation for source Jellyfin
Mar 28 22:36:06 kitchen volumio[1017]: Cannot find translation for source Pandora Radio
Mar 28 22:36:06 kitchen volumio[1017]: info: [1774755366015] ControllerPandora::initialSetup
Mar 28 22:36:06 kitchen volumio[1017]: info: [1774755366026] ControllerPandora::checkPing
Mar 28 22:36:06 kitchen volumio[1017]: info: Volumio Calling Home
Mar 28 22:36:06 kitchen systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Mar 28 22:36:06 kitchen systemd[1]: Starting mpd.service - Music Player Daemon...
Mar 28 22:36:06 kitchen systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server.
Mar 28 22:36:06 kitchen systemd[1]: mpd.service: Deactivated successfully.
Mar 28 22:36:06 kitchen systemd[1]: Stopped mpd.service - Music Player Daemon.
Mar 28 22:36:06 kitchen sudo[1376]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:06 kitchen systemd[1]: mpd.socket: Deactivated successfully.
Mar 28 22:36:06 kitchen systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Mar 28 22:36:06 kitchen systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Mar 28 22:36:06 kitchen systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Mar 28 22:36:06 kitchen systemd[1]: Starting mpd.service - Music Player Daemon...
Mar 28 22:36:06 kitchen sudo[1405]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Mar 28 22:36:06 kitchen sudo[1405]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Mar 28 22:36:06 kitchen sudo[1412]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Mar 28 22:36:06 kitchen sudo[1405]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:06 kitchen volumio5-onboarding[1402]: time=2026-03-28T22:36:06.894-05:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z
Mar 28 22:36:10 kitchen systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4.
Mar 28 22:36:10 kitchen systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Mar 28 22:36:10 kitchen systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Mar 28 22:36:11 kitchen upmpdcli[1430]: Could not open config: /tmp/upmpdcli.conf
Mar 28 22:36:11 kitchen systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Mar 28 22:36:11 kitchen systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Mar 28 22:36:12 kitchen volumio[1017]: info: MPD Permissions set
Mar 28 22:36:12 kitchen volumio[1017]: info: MPD Permissions set
Mar 28 22:36:13 kitchen volumio[1017]: info: [jellyfin-poller] Polled http://10.0.11.10:8096: online
Mar 28 22:36:13 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50:3000 from 10.0.13.52 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Mar 28 22:36:13 kitchen volumio[1017]: info: [1774755373390] [Pandora] checkPing: ***LOOKS GOOD, ICE DOWN THE BEERS IN THE COOLER***
Mar 28 22:36:13 kitchen volumio[1017]: info: [1774755373392] ControllerPandora::checkHTTP
Mar 28 22:36:13 kitchen volumio[1017]: info: Volumio called home
Mar 28 22:36:14 kitchen volumio[1017]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 28 22:36:14 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:14 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:14 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:14 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:14 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:14 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:14 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:14 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 28 22:36:15 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:36:16 kitchen volumio[1017]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 28 22:36:16 kitchen volumio[1017]: info: Received Get System Info
Mar 28 22:36:16 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 28 22:36:16 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 28 22:36:16 kitchen volumio[1017]: info: Discovery: Getting this device information
Mar 28 22:36:16 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:16 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:16 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 28 22:36:16 kitchen volumio5-onboarding[1402]: time=2026-03-28T22:36:16.345-05:00 level=INFO msg="system info for 63a93011b28e0bbefbd3fcb40a01e652" deviceName=Kitchen deviceVariant=volumio deviceModel= softwareVersion=4.096
Mar 28 22:36:16 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50:3000 from 10.0.13.51 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Mar 28 22:36:16 kitchen volumio[1017]: info: Received Get System Info
Mar 28 22:36:16 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 28 22:36:16 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 28 22:36:16 kitchen volumio[1017]: info: Discovery: Getting this device information
Mar 28 22:36:16 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:16 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:16 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 28 22:36:16 kitchen volumio[1017]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11
Mar 28 22:36:16 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 28 22:36:16 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 28 22:36:16 kitchen volumio5-onboarding[1402]: time=2026-03-28T22:36:16.929-05:00 level=INFO msg="enabling local network discovery"
Mar 28 22:36:17 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50:3000 from 10.0.13.52 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12
Mar 28 22:36:17 kitchen mpd[1413]: decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 28 22:36:17 kitchen mpd[1413]: output: No 'audio_output' defined in config file
Mar 28 22:36:17 kitchen volumio5-onboarding[1402]: time=2026-03-28T22:36:17.171-05:00 level=INFO msg="bootstrapping state" hasInternet=true
Mar 28 22:36:17 kitchen mpd[1413]: output: Successfully detected a sndio audio device
Mar 28 22:36:17 kitchen mpd[1413]: zeroconf: No global port, disabling zeroconf
Mar 28 22:36:17 kitchen systemd[1]: Started mpd.service - Music Player Daemon.
Mar 28 22:36:17 kitchen volumio[1017]: info: Received Get System Info
Mar 28 22:36:17 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 28 22:36:17 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 28 22:36:17 kitchen volumio[1017]: info: Discovery: Getting this device information
Mar 28 22:36:17 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:17 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:17 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 28 22:36:17 kitchen volumio-remote-updater[550]: Test mode disabled
Mar 28 22:36:17 kitchen volumio-remote-updater[550]: Alpha mode disabled
Mar 28 22:36:17 kitchen volumio-remote-updater[550]: Alpha legacy test mode disabled
Mar 28 22:36:17 kitchen sudo[1374]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:17 kitchen sudo[1382]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:17 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Mar 28 22:36:17 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:17 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:18 kitchen volumio[1017]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Fix for missing PWM backlight module
- Fix for crash loop on Onboarding plugin
NEW ADDITIONS
- Bump RPi/CM4 kernel to 6.12.74
","title":"Update v4.119","updateavailable":true}
Mar 28 22:36:18 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 28 22:36:18 kitchen volumio[1017]: info: MPD running with PID1413
Mar 28 22:36:18 kitchen volumio[1017]: ,establishing connection
Mar 28 22:36:19 kitchen volumio[1017]: error: MPD error: The expression evaluated to a falsy value:
Mar 28 22:36:19 kitchen volumio[1017]: assert.ok(self.idling)
Mar 28 22:36:19 kitchen volumio[1017]: error: The expression evaluated to a falsy value:
Mar 28 22:36:19 kitchen volumio[1017]: assert.ok(self.idling)
Mar 28 22:36:19 kitchen volumio[1017]: error: MPD error: The expression evaluated to a falsy value:
Mar 28 22:36:19 kitchen volumio[1017]: assert.ok(self.idling)
Mar 28 22:36:19 kitchen volumio[1017]: error: The expression evaluated to a falsy value:
Mar 28 22:36:19 kitchen volumio[1017]: assert.ok(self.idling)
Mar 28 22:36:19 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 28 22:36:19 kitchen volumio5-onboarding[1402]: time=2026-03-28T22:36:19.485-05:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory"
Mar 28 22:36:19 kitchen volumio5-onboarding[1402]: time=2026-03-28T22:36:19.487-05:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory"
Mar 28 22:36:19 kitchen volumio5-onboarding[1402]: time=2026-03-28T22:36:19.487-05:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory"
Mar 28 22:36:19 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 28 22:36:19 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50:3000 from 10.0.13.51 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13
Mar 28 22:36:19 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 28 22:36:19 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:36:20 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:20 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:20 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Mar 28 22:36:20 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:20 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381183] [Pandora] checkHTTP: ***CRACK THE BEERS WE HAVE INTERNET***
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381207] ControllerPandora::initializeMQTT
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381208] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381209] ControllerPandora::PandoraHandler::init
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381210] ControllerPandora::PandoraHandler::loadErrorCodes
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381242] ControllerPandora::validateAndSetAccountOptions
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381259] ControllerPandora::PandoraHandler::setAccountOptions
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381262] ControllerPandora::flushPandora
Mar 28 22:36:21 kitchen volumio[1017]: info: CorePlayQueue::getQueue
Mar 28 22:36:21 kitchen volumio[1017]: info: CorePlayQueue::clearAddPlayQueue
Mar 28 22:36:21 kitchen volumio[1017]: info: CorePlayQueue::saveQueue
Mar 28 22:36:21 kitchen volumio[1017]: info: CoreCommandRouter::serviceClearAddPlayTracks
Mar 28 22:36:21 kitchen volumio[1017]: error: WARNING: No clearAddPlayTracks method for service jellyfin
Mar 28 22:36:21 kitchen volumio[1017]: info: CoreCommandRouter::volumioPushQueue
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381386] [Pandora] PreventAuthTimeout::init: Timer loaded
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381399] [Pandora] PreventAuthTimeout::init: Interval set to 10800000 ms
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381400] [Pandora] PreventAuthTimeout::init: Starting delayed timer after next interval
Mar 28 22:36:21 kitchen volumio[1017]: info: [1774755381401] ControllerPandora::PandoraHandler::pandoraLoginAndGetStations
Mar 28 22:36:22 kitchen volumio[1017]: info: [1774755382774] [Pandora] PandoraHandler::pandoraLoginAndGetStations::pandoraLogin: [<=- Logged in to Pandora Servers -=>]
Mar 28 22:36:22 kitchen volumio[1017]: info: [1774755382837] [Pandora] validateAndSetAccountOptions: ***DEBUG*** self.loggedIn: true
Mar 28 22:36:22 kitchen volumio[1017]: info: [1774755382851] [Pandora] ExpireOldTracks::init: Timer loaded
Mar 28 22:36:22 kitchen volumio[1017]: info: [1774755382866] [Pandora] ExpireOldTracks::init: Interval set to 300000 ms
Mar 28 22:36:22 kitchen volumio[1017]: info: [1774755382866] [Pandora] ExpireOldTracks::init: Starting delayed timer after next interval
Mar 28 22:36:22 kitchen volumio[1017]: info: [1774755382868] ControllerPandora::PandoraHandler::fillStationData
Mar 28 22:36:23 kitchen volumio[1017]: info: [1774755383541] [Pandora] PandoraHandler::setMaxStationTracks: 16
Mar 28 22:36:23 kitchen volumio[1017]: info: [1774755383568] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty
Mar 28 22:36:23 kitchen volumio[1017]: info: [1774755383574] ControllerPandora::flushPandora
Mar 28 22:36:23 kitchen volumio[1017]: info: CorePlayQueue::getQueue
Mar 28 22:36:23 kitchen volumio[1017]: info: CorePlayQueue::clearAddPlayQueue
Mar 28 22:36:23 kitchen volumio[1017]: info: CorePlayQueue::saveQueue
Mar 28 22:36:23 kitchen volumio[1017]: info: CoreCommandRouter::serviceClearAddPlayTracks
Mar 28 22:36:23 kitchen volumio[1017]: error: WARNING: No clearAddPlayTracks method for service jellyfin
Mar 28 22:36:23 kitchen volumio[1017]: info: CoreCommandRouter::volumioPushQueue
Mar 28 22:36:23 kitchen volumio[1017]: info: Completed starting Core Plugins
Mar 28 22:36:23 kitchen volumio[1017]: info: -------------------------------------------
Mar 28 22:36:23 kitchen volumio[1017]: info: ----- MyVolumio plugins startup ----
Mar 28 22:36:23 kitchen volumio[1017]: info: -------------------------------------------
Mar 28 22:36:23 kitchen volumio[1017]: info: [MyVolumio PluginManager] Fetching plans data....
Mar 28 22:36:23 kitchen mpd[1413]: exception: No database
Mar 28 22:36:23 kitchen mpd[1413]: exception: No database
Mar 28 22:36:23 kitchen mpd[1413]: exception: No database
Mar 28 22:36:23 kitchen volumio[1017]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database
Mar 28 22:36:26 kitchen systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5.
Mar 28 22:36:26 kitchen systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Mar 28 22:36:26 kitchen systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Mar 28 22:36:26 kitchen upmpdcli[1468]: Could not open config: /tmp/upmpdcli.conf
Mar 28 22:36:27 kitchen systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Mar 28 22:36:27 kitchen systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Mar 28 22:36:28 kitchen sudo[1470]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 28 22:36:28 kitchen sudo[1470]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 28 22:36:28 kitchen sudo[1470]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:28 kitchen sudo[1472]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 28 22:36:28 kitchen sudo[1472]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 28 22:36:28 kitchen sudo[1472]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:29 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50 from 10.0.11.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14
Mar 28 22:36:30 kitchen sudo[1492]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 28 22:36:30 kitchen sudo[1492]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 28 22:36:30 kitchen sudo[1492]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:30 kitchen sudo[1497]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 28 22:36:30 kitchen sudo[1497]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 28 22:36:30 kitchen sudo[1497]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:30 kitchen volumio[1017]: verbose: New Socket.io Connection to 10.0.13.50 from 10.0.11.101 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/146.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15
Mar 28 22:36:30 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:31 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 28 22:36:31 kitchen volumio[1017]: info: Received Get System Info
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 28 22:36:31 kitchen volumio[1017]: info: Discovery: Getting this device information
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:31 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:31 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:31 kitchen volumio[1017]: info: Listing playlists
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 28 22:36:31 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:31 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:32 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 28 22:36:32 kitchen volumio[1017]: info: Received Get System Info
Mar 28 22:36:32 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 28 22:36:32 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 28 22:36:32 kitchen volumio[1017]: info: Discovery: Getting this device information
Mar 28 22:36:32 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:32 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:32 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Mar 28 22:36:32 kitchen volumio[1017]: info: Adding plugin bluetooth to MyMusic Plugins
Mar 28 22:36:32 kitchen volumio[1017]: info: Adding plugin multiroom to MyMusic Plugins
Mar 28 22:36:32 kitchen volumio[1017]: info: Adding plugin metavolumio to MyMusic Plugins
Mar 28 22:36:32 kitchen volumio[1017]: info: Adding plugin cd_controller to MyMusic Plugins
Mar 28 22:36:32 kitchen volumio[1017]: info: Adding plugin qobuzconnect to MyMusic Plugins
Mar 28 22:36:32 kitchen volumio[1017]: info: Adding plugin smart_inputs to MyMusic Plugins
Mar 28 22:36:32 kitchen volumio[1017]: info: Adding plugin tidalconnect to MyMusic Plugins
Mar 28 22:36:32 kitchen volumio[1017]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Mar 28 22:36:39 kitchen volumio[1017]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Mar 28 22:36:39 kitchen volumio[1017]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Mar 28 22:36:39 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 28 22:36:39 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 28 22:36:39 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 28 22:36:39 kitchen volumio[1017]: info: Starting MyVolumio Remote Streaming Endpoints
Mar 28 22:36:40 kitchen volumio[1017]: info: MyVolumio login type: Token
Mar 28 22:36:40 kitchen volumio[1017]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Mar 28 22:36:40 kitchen volumio[1017]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Mar 28 22:36:42 kitchen systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 6.
Mar 28 22:36:42 kitchen systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Mar 28 22:36:42 kitchen systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Mar 28 22:36:42 kitchen upmpdcli[1515]: Could not open config: /tmp/upmpdcli.conf
Mar 28 22:36:42 kitchen systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Mar 28 22:36:42 kitchen systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Mar 28 22:36:49 kitchen volumio[1017]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Mar 28 22:36:49 kitchen volumio[1017]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Mar 28 22:36:49 kitchen volumio[1017]: info: Streaming services startup
Mar 28 22:36:49 kitchen volumio[1017]: info: Starting Streaming Daemon
Mar 28 22:36:49 kitchen volumio[1017]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Mar 28 22:36:49 kitchen sudo[1517]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Mar 28 22:36:49 kitchen sudo[1517]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 28 22:36:49 kitchen volumio[1017]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Mar 28 22:36:49 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 28 22:36:49 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 28 22:36:49 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 28 22:36:49 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 28 22:36:49 kitchen sudo[1517]: pam_unix(sudo:session): session closed for user root
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::volumioPlay
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::play index undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::volumioPlay
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::play index undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::volumioPlay
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::play index undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::volumioPlay
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::play index undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::volumioNext
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::next
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::stop
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::volumioPlay
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::play index undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::volumioPlay
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::play index undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 28 22:36:50 kitchen volumio[1017]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Mar 28 22:36:50 kitchen volumio[1017]: info: Received Get System Version
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 28 22:36:50 kitchen volumio[1017]: info: Received Get System Info
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 28 22:36:50 kitchen volumio[1017]: info: Discovery: Getting this device information
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::startPlaybackTimer
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/egoh@72363f650cd348f9b82a4d11a0f536b0/song@songId=10adcb2aedfb112f77e3ad9fdbd1d5a9
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-conn] Using previously assigned device Id for egoh@mac-server: 36039cf8-25a2-4f59-b445-8abba14d2aae
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::startPlaybackTimer
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/egoh@72363f650cd348f9b82a4d11a0f536b0/song@songId=10adcb2aedfb112f77e3ad9fdbd1d5a9
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-conn] Returning existing auth promise
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::startPlaybackTimer
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/egoh@72363f650cd348f9b82a4d11a0f536b0/song@songId=10adcb2aedfb112f77e3ad9fdbd1d5a9
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-conn] Returning existing auth promise
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::startPlaybackTimer
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 0
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/egoh@72363f650cd348f9b82a4d11a0f536b0/song@songId=10adcb2aedfb112f77e3ad9fdbd1d5a9
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-conn] Returning existing auth promise
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::startPlaybackTimer
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/egoh@72363f650cd348f9b82a4d11a0f536b0/song@songId=ba71728c37a660127eec10baa676cd53
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-conn] Returning existing auth promise
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::startPlaybackTimer
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/egoh@72363f650cd348f9b82a4d11a0f536b0/song@songId=ba71728c37a660127eec10baa676cd53
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-conn] Returning existing auth promise
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::play index undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::startPlaybackTimer
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/egoh@72363f650cd348f9b82a4d11a0f536b0/song@songId=ba71728c37a660127eec10baa676cd53
Mar 28 22:36:50 kitchen volumio[1017]: info: [jellyfin-conn] Returning existing auth promise
Mar 28 22:36:50 kitchen volumio[1017]: info: CoreStateMachine::updateTrackBlock
Mar 28 22:36:50 kitchen volumio[1017]: info: CorePlayQueue::getTrackBlock
Mar 28 22:36:51 kitchen volumio[1017]: error: Cannot start Volumio Streaming Daemon
Mar 28 22:36:51 kitchen volumio[1017]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Mar 28 22:36:51 kitchen volumio[1017]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Mar 28 22:36:51 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetQueue
Mar 28 22:36:51 kitchen volumio[1017]: info: CoreStateMachine::getQueue
Mar 28 22:36:51 kitchen volumio[1017]: info: CorePlayQueue::getQueue
Mar 28 22:36:52 kitchen volumio[1017]: info: [jellyfin-conn] Login successful: egoh@mac-server
Mar 28 22:36:53 kitchen volumio[1017]: error: MyVolumio Custom Token format not valid, refreshing it
Mar 28 22:36:53 kitchen volumio[1017]: info: [jellyfin-play] Stream URL for Be Right There: http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e
Mar 28 22:36:53 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 22:36:53 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri
Mar 28 22:36:53 kitchen volumio[1017]: info: [jellyfin-browse] browseUri: jellyfin
Mar 28 22:36:53 kitchen volumio[1017]: info: [jellyfin-play] Stream URL for Be Right There: http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e
Mar 28 22:36:53 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 22:36:53 kitchen volumio[1017]: info: Preload queue cleared
Mar 28 22:36:54 kitchen volumio[1017]: info: [jellyfin-play] Stream URL for Be Right There: http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 22:36:54 kitchen volumio[1017]: info: [jellyfin-play] Stream URL for Be Right There: http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 22:36:54 kitchen volumio[1017]: info: [jellyfin-play] Stream URL for No Choice: http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 22:36:54 kitchen volumio[1017]: info: [jellyfin-play] Stream URL for No Choice: http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 22:36:54 kitchen volumio[1017]: info: [jellyfin-play] Stream URL for No Choice: http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 22:36:54 kitchen volumio[1017]: info: sendMpdCommand stop took 1029 milliseconds
Mar 28 22:36:54 kitchen volumio[1017]: info: sendMpdCommand stop took 624 milliseconds
Mar 28 22:36:54 kitchen volumio[1017]: info: sendMpdCommand stop took 181 milliseconds
Mar 28 22:36:54 kitchen volumio[1017]: info: sendMpdCommand stop took 169 milliseconds
Mar 28 22:36:54 kitchen volumio[1017]: info: sendMpdCommand stop took 126 milliseconds
Mar 28 22:36:54 kitchen volumio[1017]: info: sendMpdCommand stop took 111 milliseconds
Mar 28 22:36:54 kitchen volumio[1017]: info: sendMpdCommand stop took 63 milliseconds
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 22:36:54 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 22:36:54 kitchen volumio-remote-updater[550]: Test mode disabled
Mar 28 22:36:54 kitchen volumio-remote-updater[550]: Alpha mode disabled
Mar 28 22:36:54 kitchen volumio-remote-updater[550]: Alpha legacy test mode disabled
Mar 28 22:36:54 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Mar 28 22:36:54 kitchen volumio[1017]: info:
Mar 28 22:36:54 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:54 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:54 kitchen volumio[1017]: info:
Mar 28 22:36:54 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:54 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:54 kitchen volumio[1017]: info:
Mar 28 22:36:54 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:54 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:54 kitchen volumio[1017]: info:
Mar 28 22:36:54 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:54 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:54 kitchen volumio[1017]: info:
Mar 28 22:36:54 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:54 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:54 kitchen volumio[1017]: info:
Mar 28 22:36:54 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:54 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:54 kitchen volumio[1017]: info:
Mar 28 22:36:54 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:54 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:54 kitchen volumio[1017]: info: sendMpdCommand clear took 575 milliseconds
Mar 28 22:36:54 kitchen volumio[1017]: info: sendMpdCommand clear took 576 milliseconds
Mar 28 22:36:54 kitchen volumio[1017]: info: sendMpdCommand clear took 575 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand clear took 617 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand clear took 620 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand clear took 628 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand clear took 634 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand load "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand load "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand load "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand load "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand load "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand load "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand load "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: info:
Mar 28 22:36:55 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:55 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:55 kitchen volumio[1017]: info:
Mar 28 22:36:55 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:55 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:55 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 28 22:36:55 kitchen mpd[1413]: exception: No such playlist
Mar 28 22:36:55 kitchen mpd[1413]: exception: No such playlist
Mar 28 22:36:55 kitchen mpd[1413]: exception: No such playlist
Mar 28 22:36:55 kitchen mpd[1413]: exception: No such playlist
Mar 28 22:36:55 kitchen mpd[1413]: exception: No such playlist
Mar 28 22:36:55 kitchen mpd[1413]: exception: No such playlist
Mar 28 22:36:55 kitchen mpd[1413]: exception: No such playlist
Mar 28 22:36:55 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:36:55 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:36:55 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:36:55 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:36:55 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:36:55 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:36:55 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:36:55 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:36:55 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:36:55 kitchen volumio[1017]: info: ------------------------------ 428ms
Mar 28 22:36:55 kitchen volumio[1017]: info: ------------------------------ 383ms
Mar 28 22:36:55 kitchen volumio[1017]: info: ------------------------------ 382ms
Mar 28 22:36:55 kitchen volumio[1017]: info: ------------------------------ 381ms
Mar 28 22:36:55 kitchen volumio[1017]: info: ------------------------------ 381ms
Mar 28 22:36:55 kitchen volumio[1017]: info: ------------------------------ 380ms
Mar 28 22:36:55 kitchen volumio[1017]: info: ------------------------------ 380ms
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand addid "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand addid "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand addid "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand addid "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand addid "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand addid "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand addid "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3"
Mar 28 22:36:55 kitchen volumio[1017]: info: ------------------------------ 250ms
Mar 28 22:36:55 kitchen volumio[1017]: info: ------------------------------ 248ms
Mar 28 22:36:55 kitchen volumio[1017]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Fix for missing PWM backlight module
- Fix for crash loop on Onboarding plugin
NEW ADDITIONS
- Bump RPi/CM4 kernel to 6.12.74
","title":"Update v4.119","updateavailable":true}
Mar 28 22:36:55 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 28 22:36:55 kitchen volumio[1017]: info:
Mar 28 22:36:55 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:55 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:55 kitchen volumio[1017]: info:
Mar 28 22:36:55 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:55 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:55 kitchen volumio[1017]: info:
Mar 28 22:36:55 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:55 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:55 kitchen volumio[1017]: info:
Mar 28 22:36:55 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:55 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:55 kitchen volumio[1017]: info:
Mar 28 22:36:55 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:55 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:55 kitchen volumio[1017]: info:
Mar 28 22:36:55 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:55 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:55 kitchen volumio[1017]: info:
Mar 28 22:36:55 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:55 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand addid "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3" took 554 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand addid "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3" took 554 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand addid "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3" took 594 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand addid "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3" took 596 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand addid "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3" took 596 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand addid "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3" took 596 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: info: sendMpdCommand addid "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3" took 596 milliseconds
Mar 28 22:36:55 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:55 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:55 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:55 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:55 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:55 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: verbose: MPD COMMAND [object Object]
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen volumio[1017]: info: ------------------------------ 402ms
Mar 28 22:36:56 kitchen volumio[1017]: info: ------------------------------ 400ms
Mar 28 22:36:56 kitchen volumio[1017]: info: ------------------------------ 399ms
Mar 28 22:36:56 kitchen volumio[1017]: info: ------------------------------ 399ms
Mar 28 22:36:56 kitchen volumio[1017]: info: ------------------------------ 398ms
Mar 28 22:36:56 kitchen volumio[1017]: info: ------------------------------ 398ms
Mar 28 22:36:56 kitchen volumio[1017]: info: ------------------------------ 398ms
Mar 28 22:36:56 kitchen volumio[1017]: info: ------------------------------ 256ms
Mar 28 22:36:56 kitchen volumio[1017]: info: ------------------------------ 216ms
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService mpd
Mar 28 22:36:56 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand play
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService mpd
Mar 28 22:36:56 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand play
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService mpd
Mar 28 22:36:56 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand play
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService mpd
Mar 28 22:36:56 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand play
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService mpd
Mar 28 22:36:56 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand play
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService mpd
Mar 28 22:36:56 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand play
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService mpd
Mar 28 22:36:56 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand play
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen volumio[1017]: info:
Mar 28 22:36:56 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:36:56 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:36:56 kitchen mpd[1413]: [src/libmpg123/parse.c:do_readahead():1122] error: cannot seek!
Mar 28 22:36:56 kitchen mpd[1413]: mpg123: mpg123_getformat() failed: A generic mpg123 error.
Mar 28 22:36:56 kitchen mpd[1413]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Mar 28 22:36:56 kitchen mpd[1413]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Mar 28 22:36:56 kitchen mpd[1413]: player: problems opening audio device while playing "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3"
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetState
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreCommandRouter::volumioPlay
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreStateMachine::play index undefined
Mar 28 22:36:56 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 22:36:57 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:57 kitchen volumio[1017]: info: CoreStateMachine::startPlaybackTimer
Mar 28 22:36:57 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:57 kitchen volumio[1017]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/egoh@72363f650cd348f9b82a4d11a0f536b0/song@songId=ba71728c37a660127eec10baa676cd53
Mar 28 22:36:57 kitchen volumio[1017]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16
Mar 28 22:36:57 kitchen systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7.
Mar 28 22:36:57 kitchen systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Mar 28 22:36:57 kitchen systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Mar 28 22:36:57 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:57 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:57 kitchen volumio[1017]: info:
Mar 28 22:36:57 kitchen volumio[1017]: ---------------------------- MPD announces state update: player
Mar 28 22:36:57 kitchen volumio[1017]: info: ------------------------------ 1193ms
Mar 28 22:36:57 kitchen volumio[1017]: info: ------------------------------ 1193ms
Mar 28 22:36:57 kitchen volumio[1017]: info: ------------------------------ 1193ms
Mar 28 22:36:57 kitchen volumio[1017]: info: ------------------------------ 1192ms
Mar 28 22:36:57 kitchen volumio[1017]: info: ------------------------------ 1192ms
Mar 28 22:36:57 kitchen volumio[1017]: info: ------------------------------ 1192ms
Mar 28 22:36:57 kitchen volumio[1017]: info: ------------------------------ 1192ms
Mar 28 22:36:57 kitchen volumio[1017]: info: sendMpdCommand play took 1187 milliseconds
Mar 28 22:36:57 kitchen volumio[1017]: info: sendMpdCommand play took 1186 milliseconds
Mar 28 22:36:57 kitchen volumio[1017]: info: sendMpdCommand play took 1187 milliseconds
Mar 28 22:36:57 kitchen volumio[1017]: info: sendMpdCommand play took 1186 milliseconds
Mar 28 22:36:57 kitchen volumio[1017]: info: sendMpdCommand play took 1185 milliseconds
Mar 28 22:36:57 kitchen volumio[1017]: info: sendMpdCommand play took 1104 milliseconds
Mar 28 22:36:57 kitchen volumio[1017]: info: sendMpdCommand play took 1104 milliseconds
Mar 28 22:36:57 kitchen volumio[1017]: info: ------------------------------ 1103ms
Mar 28 22:36:57 kitchen volumio[1017]: info: ------------------------------ 1102ms
Mar 28 22:36:57 kitchen upmpdcli[1555]: Could not open config: /tmp/upmpdcli.conf
Mar 28 22:36:57 kitchen systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Mar 28 22:36:57 kitchen systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Mar 28 22:36:57 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:57 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:58 kitchen volumio[1017]: info:
Mar 28 22:36:58 kitchen volumio[1017]: ---------------------------- MPD announces state update: player
Mar 28 22:36:58 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:58 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:58 kitchen volumio[1017]: info:
Mar 28 22:36:58 kitchen volumio[1017]: ---------------------------- MPD announces state update: player
Mar 28 22:36:58 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:58 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:58 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:58 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:58 kitchen volumio[1017]: info:
Mar 28 22:36:58 kitchen volumio[1017]: ---------------------------- MPD announces state update: player
Mar 28 22:36:58 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:58 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:58 kitchen volumio[1017]: error: MPD returned error for command status: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Mar 28 22:36:58 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 28 22:36:58 kitchen volumio[1017]: info: sendMpdCommand status took 1249 milliseconds
Mar 28 22:36:58 kitchen volumio[1017]: error: MPD returned error for command status: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Mar 28 22:36:58 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 28 22:36:58 kitchen volumio[1017]: info: sendMpdCommand status took 1171 milliseconds
Mar 28 22:36:58 kitchen volumio[1017]: error: MPD returned error for command status: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Mar 28 22:36:58 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 28 22:36:58 kitchen volumio[1017]: info: sendMpdCommand status took 604 milliseconds
Mar 28 22:36:58 kitchen volumio[1017]: error: MPD returned error for command status: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Mar 28 22:36:58 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 28 22:36:58 kitchen volumio[1017]: info: sendMpdCommand status took 679 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 22:36:59 kitchen volumio[1017]: info:
Mar 28 22:36:59 kitchen volumio[1017]: ---------------------------- MPD announces state update: player
Mar 28 22:36:59 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:59 kitchen volumio[1017]: info:
Mar 28 22:36:59 kitchen volumio[1017]: ---------------------------- MPD announces state update: player
Mar 28 22:36:59 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:59 kitchen volumio[1017]: info: [jellyfin-play] Stream URL for No Choice: http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 22:36:59 kitchen mpd[1413]: player: played "http://10.0.11.10:8096/Audio/10adcb2aedfb112f77e3ad9fdbd1d5a9/stream.mp3?static=true&mediaSourceId=10adcb2aedfb112f77e3ad9fdbd1d5a9&tag=f7ba51ba3223a8363649e2d425411e0e&t.mp3"
Mar 28 22:36:59 kitchen volumio[1017]: info: [jellyfin-play]: Mark song Be Right There as played by egoh.
Mar 28 22:36:59 kitchen volumio[1017]: info: [jellyfin-play]: Mark song Be Right There as played by egoh.
Mar 28 22:36:59 kitchen volumio[1017]: info: [jellyfin-play]: Mark song No Choice as played by egoh.
Mar 28 22:36:59 kitchen volumio[1017]: info: [jellyfin-play]: Mark song Be Right There as played by egoh.
Mar 28 22:36:59 kitchen volumio[1017]: info: [jellyfin-play]: Mark song No Choice as played by egoh.
Mar 28 22:36:59 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:59 kitchen volumio[1017]: info:
Mar 28 22:36:59 kitchen volumio[1017]: ---------------------------- MPD announces state update: player
Mar 28 22:36:59 kitchen volumio[1017]: error: MPD returned error for command status: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand status took 902 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: error: MPD returned error for command status: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clearerror
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand status took 904 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand clearerror took 830 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand clearerror took 829 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand clearerror took 827 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand clearerror took 750 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand playlistinfo took 450 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand playlistinfo took 449 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand playlistinfo took 452 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand playlistinfo took 438 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand status took 425 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand status took 422 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: sendMpdCommand stop took 331 milliseconds
Mar 28 22:36:59 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 22:36:59 kitchen volumio[1017]: info: ControllerMpd::pushState
Mar 28 22:36:59 kitchen volumio[1017]: info: CoreCommandRouter::servicePushState
Mar 28 22:36:59 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:59 kitchen volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd
Mar 28 22:36:59 kitchen volumio[1017]: info: ControllerMpd::pushState
Mar 28 22:36:59 kitchen volumio[1017]: info: CoreCommandRouter::servicePushState
Mar 28 22:36:59 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:59 kitchen volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd
Mar 28 22:36:59 kitchen volumio[1017]: info: ControllerMpd::pushState
Mar 28 22:36:59 kitchen volumio[1017]: info: CoreCommandRouter::servicePushState
Mar 28 22:36:59 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:59 kitchen volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd
Mar 28 22:36:59 kitchen volumio[1017]: info: ------------------------------ 2370ms
Mar 28 22:36:59 kitchen volumio[1017]: info: ------------------------------ 1755ms
Mar 28 22:36:59 kitchen volumio[1017]: info: ------------------------------ 1753ms
Mar 28 22:36:59 kitchen volumio[1017]: info:
Mar 28 22:36:59 kitchen volumio[1017]: ---------------------------- MPD announces state update: player
Mar 28 22:36:59 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:59 kitchen volumio[1017]: info:
Mar 28 22:36:59 kitchen volumio[1017]: ---------------------------- MPD announces state update: player
Mar 28 22:36:59 kitchen volumio[1017]: info: ControllerMpd::getState
Mar 28 22:36:59 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 22:36:59 kitchen volumio[1017]: info: [jellyfin-play]: Mark song Be Right There as played by egoh.
Mar 28 22:36:59 kitchen volumio[1017]: info: CoreCommandRouter::volumioPlay
Mar 28 22:36:59 kitchen volumio[1017]: info: CoreStateMachine::play index undefined
Mar 28 22:36:59 kitchen volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 22:36:59 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:59 kitchen volumio[1017]: info: CoreStateMachine::startPlaybackTimer
Mar 28 22:36:59 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:36:59 kitchen volumio[1017]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/egoh@72363f650cd348f9b82a4d11a0f536b0/song@songId=ba71728c37a660127eec10baa676cd53
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 28 22:37:00 kitchen volumio[1017]: info:
Mar 28 22:37:00 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:37:00 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand status took 923 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand clearerror took 811 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand clearerror took 806 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand status took 742 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand playlistinfo took 676 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand playlistinfo took 620 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand playlistinfo took 601 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand playlistinfo took 602 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand clear took 575 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand status took 503 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: info: sendMpdCommand status took 503 milliseconds
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand load "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3"
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::parseState
Mar 28 22:37:00 kitchen volumio[1017]: info: ControllerMpd::pushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::servicePushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:37:00 kitchen volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd
Mar 28 22:37:00 kitchen volumio[1017]: info: ControllerMpd::pushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::servicePushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:37:00 kitchen volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd
Mar 28 22:37:00 kitchen volumio[1017]: info: ControllerMpd::pushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::servicePushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:37:00 kitchen volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd
Mar 28 22:37:00 kitchen volumio[1017]: info: ControllerMpd::pushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::servicePushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreStateMachine::pushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::volumioPushState
Mar 28 22:37:00 kitchen mpd[1413]: exception: No such playlist
Mar 28 22:37:00 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:37:00 kitchen volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd
Mar 28 22:37:00 kitchen volumio[1017]: info: ControllerMpd::pushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::servicePushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreStateMachine::pushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:37:00 kitchen volumio[1017]: info: CoreCommandRouter::volumioPushState
Mar 28 22:37:00 kitchen volumio[1017]: info: CorePlayQueue::getTrack 1
Mar 28 22:37:00 kitchen volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd
Mar 28 22:37:00 kitchen volumio[1017]: info: ------------------------------ 2022ms
Mar 28 22:37:00 kitchen volumio[1017]: info: ------------------------------ 1501ms
Mar 28 22:37:00 kitchen volumio[1017]: info: ------------------------------ 1494ms
Mar 28 22:37:00 kitchen volumio[1017]: info: ------------------------------ 911ms
Mar 28 22:37:00 kitchen volumio[1017]: info: ------------------------------ 906ms
Mar 28 22:37:00 kitchen volumio[1017]: info:
Mar 28 22:37:00 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:37:00 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:37:00 kitchen volumio[1017]: info:
Mar 28 22:37:00 kitchen volumio[1017]: ---------------------------- MPD announces system playlist update
Mar 28 22:37:00 kitchen volumio[1017]: info: Ignoring MPD Status Update
Mar 28 22:37:00 kitchen volumio[1017]: info: [jellyfin-play] Stream URL for No Choice: http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1
Mar 28 22:37:00 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 22:37:00 kitchen volumio[1017]: info: [jellyfin-play]: Mark song No Choice as played by egoh.
Mar 28 22:37:01 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:37:01 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:37:01 kitchen volumio[1017]: error: updateQueue error: null
Mar 28 22:37:01 kitchen volumio[1017]: info: ------------------------------ 977ms
Mar 28 22:37:01 kitchen volumio[1017]: info: sendMpdCommand playlistinfo took 909 milliseconds
Mar 28 22:37:01 kitchen volumio[1017]: info: sendMpdCommand playlistinfo took 950 milliseconds
Mar 28 22:37:01 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand addid "http://10.0.11.10:8096/Audio/ba71728c37a660127eec10baa676cd53/stream.mp3?static=true&mediaSourceId=ba71728c37a660127eec10baa676cd53&tag=77acd6758cb1e7b273fb6cf680fdbcf1&t.mp3"
Mar 28 22:37:01 kitchen volumio[1017]: info: ------------------------------ 538ms
Mar 28 22:37:01 kitchen volumio[1017]: info: ------------------------------ 532ms
Mar 28 22:37:01 kitchen volumio[1017]: info: sendMpdCommand stop took 509 milliseconds
Mar 28 22:37:01 kitchen volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Mar 28 22:37:01 kitchen volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Mar 28 22:37:01 kitchen volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 22:37:01 kitchen volumio[1017]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Mar 28 22:37:01 kitchen volumio[1017]: info: ------------------------------ 1913ms
Mar 28 22:37:01 kitchen volumio[1017]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 28 22:37:01 kitchen volumio[1017]: TypeError: Cannot read properties of undefined (reading 'split')
Mar 28 22:37:01 kitchen volumio[1017]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:280:60)
Mar 28 22:37:01 kitchen volumio[1017]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Mar 28 22:37:01 kitchen volumio[1017]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11)
Mar 28 22:37:01 kitchen volumio[1017]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 28 22:37:12 kitchen systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 8.
Mar 28 22:37:12 kitchen systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Mar 28 22:37:12 kitchen systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Mar 28 22:37:12 kitchen upmpdcli[1597]: Could not open config: /tmp/upmpdcli.conf
Mar 28 22:37:12 kitchen systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Mar 28 22:37:12 kitchen systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Mar 28 22:37:13 kitchen sudo[1600]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-28 22:36'
Mar 28 22:37:13 kitchen sudo[1600]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"