Feb 22 11:54:00 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:00 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:10 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:10 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:10 volumio volumio[9395]: info: Listing playlists
Feb 22 11:54:10 volumio volumio[9395]: info: Listing playlists
Feb 22 11:54:20 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:20 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:30 volumio volumio[9395]: verbose: New Socket.io Connection to 192.168.1.242 from 192.168.1.116 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:30 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:30 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 22 11:54:30 volumio volumio[9395]: info: Received Get System Info
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 22 11:54:30 volumio volumio[9395]: info: Discovery: Getting this device information
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:30 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:30 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:30 volumio volumio[9395]: info: Listing playlists
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::volumioGetQueue
Feb 22 11:54:30 volumio volumio[9395]: info: CoreStateMachine::getQueue
Feb 22 11:54:30 volumio volumio[9395]: info: CorePlayQueue::getQueue
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 22 11:54:30 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:30 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:30 volumio volumio[9395]: info: Listing playlists
Feb 22 11:54:30 volumio volumio[9395]: info: Listing playlists
Feb 22 11:54:31 volumio volumio[9395]: verbose: New Socket.io Connection to 192.168.1.242:3000 from 192.168.1.116 UA: unknown Engine version: 3 Transport: websocket Total Clients: 6
Feb 22 11:54:31 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:31 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:40 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:50 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:54:50 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:54:50 volumio volumio[9395]: info: Listing playlists
Feb 22 11:54:50 volumio volumio[9395]: info: Listing playlists
Feb 22 11:55:00 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:00 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:55:10 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:10 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:55:10 volumio volumio[9395]: info: Listing playlists
Feb 22 11:55:10 volumio volumio[9395]: info: Listing playlists
Feb 22 11:55:17 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:55:17 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:17 volumio volumio[9395]: info: Prefetching next song
Feb 22 11:55:17 volumio volumio[9395]: info: DOING PREFETCH IN MPD
Feb 22 11:55:17 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Music/Lenny Kravitz/1995 - Circus/06 Magdalene.mp3"
Feb 22 11:55:17 volumio volumio[9395]: info:
Feb 22 11:55:17 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:17 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:17 volumio volumio[9395]: info: sendMpdCommand add "INTERNAL/Music/Lenny Kravitz/1995 - Circus/06 Magdalene.mp3" took 1 milliseconds
Feb 22 11:55:17 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand consume 1
Feb 22 11:55:17 volumio volumio[9395]: info:
Feb 22 11:55:17 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:17 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:17 volumio volumio[9395]: info:
Feb 22 11:55:17 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:17 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:17 volumio volumio[9395]: info: ------------------------------ 3ms
Feb 22 11:55:17 volumio volumio[9395]: info: sendMpdCommand consume 1 took 2 milliseconds
Feb 22 11:55:17 volumio volumio[9395]: info: ------------------------------ 2ms
Feb 22 11:55:17 volumio volumio[9395]: info: ------------------------------ 1ms
Feb 22 11:55:20 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:20 volumio volumio[9395]: info: CorePlayQueue::getTrack 4
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::startPlaybackTimer
Feb 22 11:55:21 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:21 volumio volumio[9395]: info:
Feb 22 11:55:21 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:21 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:21 volumio volumio[9395]: info:
Feb 22 11:55:21 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:21 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:21 volumio volumio[9395]: info:
Feb 22 11:55:21 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:21 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:21 volumio volumio[9395]: info:
Feb 22 11:55:21 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:21 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:21 volumio volumio[9395]: info:
Feb 22 11:55:21 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:21 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:21 volumio volumio[9395]: info:
Feb 22 11:55:21 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:21 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:21 volumio volumio[9395]: info: ------------------------------ 2ms
Feb 22 11:55:21 volumio volumio[9395]: info: sendMpdCommand status took 2 milliseconds
Feb 22 11:55:21 volumio volumio[9395]: info: ------------------------------ 1ms
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 11:55:21 volumio volumio[9395]: info: sendMpdCommand status took 3 milliseconds
Feb 22 11:55:21 volumio volumio[9395]: info: ------------------------------ 3ms
Feb 22 11:55:21 volumio volumio[9395]: info: sendMpdCommand status took 2 milliseconds
Feb 22 11:55:21 volumio volumio[9395]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::parseTrackInfo
Feb 22 11:55:21 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:21 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:21 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:21 volumio volumio[9395]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Magdalene","artist":"Lenny Kravitz","album":"Circus","uri":"INTERNAL/Music/Lenny Kravitz/1995 - Circus/06 Magdalene.mp3","trackType":"mp3"}
Feb 22 11:55:21 volumio volumio[9395]: verbose: CURRENT POSITION 5
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::syncState stateService play
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus play
Feb 22 11:55:21 volumio volumio[9395]: info: Received an update from plugin. extracting info from payload
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:21 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:21 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 11:55:21 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:21 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:21 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:21 volumio volumio[9395]: info: ------------------------------ 10ms
Feb 22 11:55:21 volumio volumio[9395]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 22 11:55:21 volumio volumio[9395]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::parseTrackInfo
Feb 22 11:55:21 volumio volumio[9395]: verbose: ControllerMpd::parseTrackInfo
Feb 22 11:55:21 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:21 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:21 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:21 volumio volumio[9395]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Magdalene","artist":"Lenny Kravitz","album":"Circus","uri":"INTERNAL/Music/Lenny Kravitz/1995 - Circus/06 Magdalene.mp3","trackType":"mp3"}
Feb 22 11:55:21 volumio volumio[9395]: verbose: CURRENT POSITION 5
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::syncState stateService play
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus play
Feb 22 11:55:21 volumio volumio[9395]: info: Received an update from plugin. extracting info from payload
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:21 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:21 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:21 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:21 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:21 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:21 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:21 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:21 volumio volumio[9395]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Magdalene","artist":"Lenny Kravitz","album":"Circus","uri":"INTERNAL/Music/Lenny Kravitz/1995 - Circus/06 Magdalene.mp3","trackType":"mp3"}
Feb 22 11:55:21 volumio volumio[9395]: verbose: CURRENT POSITION 5
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::syncState stateService play
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus play
Feb 22 11:55:21 volumio volumio[9395]: info: Received an update from plugin. extracting info from payload
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:21 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:21 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:21 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:21 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:21 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:21 volumio volumio[9395]: info: ------------------------------ 18ms
Feb 22 11:55:21 volumio volumio[9395]: info: ------------------------------ 18ms
Feb 22 11:55:22 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:22 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:22 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:24 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 22 11:55:24 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 22 11:55:24 volumio volumio[9395]: info: Discovery: Getting this device information
Feb 22 11:55:24 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:24 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:24 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 11:55:24 volumio volumio[9395]: verbose: New Socket.io Connection to 192.168.1.242:3000 from 192.168.1.232 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Feb 22 11:55:24 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 22 11:55:24 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 22 11:55:24 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:24.329+05:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.232:63553
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.594+05:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.1.232:63553 @ 0x2a1b080" latency=182.260227ms platform=PLATFORM_IOS version=5.260120.0
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.597+05:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.232:63553 @ 0x2a1b080" latency=180.310708ms timeout=10s
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.600+05:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080"
Feb 22 11:55:25 volumio volumio[9395]: info: Received Get System Info
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 22 11:55:25 volumio volumio[9395]: info: Discovery: Getting this device information
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:25 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.607+05:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" name=Volumio
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.615+05:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" language=en
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.616+05:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" timezone=Asia/Yekaterinburg
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.617+05:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" available=true connected=false macAddress= ip4Address= ip6Address=
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.622+05:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" available=true connected=true macAddress=e4:5f:01:52:b6:3d ip4Address=192.168.1.242/24 ip6Address= ssid=PazdnikOFF
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.623+05:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" setupComplete=true
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 11:55:25 volumio volumio[9395]: amixer -c 0 info | grep "bcm2835 ALSA"
Feb 22 11:55:25 volumio volumio[9395]: amixer -c 1 info | grep "bcm2835 Headphones"
Feb 22 11:55:25 volumio volumio[9395]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones'
Feb 22 11:55:25 volumio volumio[9395]: amixer -c 2 info | grep "vc4-hdmi-0"
Feb 22 11:55:25 volumio volumio[9395]: Card sysdefault:2 'vc4hdmi0'/'vc4-hdmi-0'
Feb 22 11:55:25 volumio volumio[9395]: amixer -c 3 info | grep "vc4-hdmi-1"
Feb 22 11:55:25 volumio volumio[9395]: Card sysdefault:3 'vc4hdmi1'/'vc4-hdmi-1'
Feb 22 11:55:25 volumio volumio[9395]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4
Feb 22 11:55:25 volumio volumio[9395]: /bin/sh: 1: /usr/local/bin/alsacap: not found
Feb 22 11:55:25 volumio volumio[9395]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"}
Feb 22 11:55:25 volumio volumio[9395]: amixer -c 4 info | grep "Raspberry Pi DAC+"
Feb 22 11:55:25 volumio volumio[9395]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 4
Feb 22 11:55:25 volumio volumio[9395]: /bin/sh: 1: /usr/local/bin/alsacap: not found
Feb 22 11:55:25 volumio volumio[9395]: {"cmd":"/usr/local/bin/alsacap -C 4","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 4\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"}
Feb 22 11:55:25 volumio volumio[9395]: amixer -c 4 info | grep "RPi DAC+"
Feb 22 11:55:25 volumio volumio[9395]: Card sysdefault:4 'DAC'/'RPi DAC+'
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.788+05:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" selectedOutputId=4
Feb 22 11:55:25 volumio volumio[9395]: info: Received Get System Info
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 22 11:55:25 volumio volumio[9395]: info: Discovery: Getting this device information
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:25 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.854+05:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" currentVersion=4.096 latestVersion=4.096
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.854+05:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" status=UPDATE_STATUS_NONE progress=0
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.854+05:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" userId=
Feb 22 11:55:25 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:25.855+05:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" providers=3
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 22 11:55:25 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 22 11:55:27 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:27.419+05:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" plugins=60
Feb 22 11:55:27 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:27 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:27 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:27.422+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=5513 volume=100
Feb 22 11:55:27 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:27.424+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1995 - Circus/06 Magdalene.mp3" title=Magdalene
Feb 22 11:55:27 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:27.565+05:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.232:63553 @ 0x2a1b080" latency=83.044097ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE
Feb 22 11:55:27 volumio volumio[9395]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Lenny%20Kravitz/Circus/9ed144ff-a7ee-4ed8-b758-a803d61f99d4.png'
Feb 22 11:55:28 volumio sudo[26418]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 22 11:55:28 volumio sudo[26418]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 11:55:28 volumio sudo[26418]: pam_unix(sudo:session): session closed for user root
Feb 22 11:55:28 volumio sudo[26420]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 22 11:55:28 volumio sudo[26420]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 11:55:28 volumio sudo[26420]: pam_unix(sudo:session): session closed for user root
Feb 22 11:55:28 volumio volumio[9395]: verbose: New Socket.io Connection to 192.168.1.242 from 192.168.1.232 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 22 11:55:28 volumio sudo[26434]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 22 11:55:28 volumio sudo[26434]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 11:55:28 volumio sudo[26434]: pam_unix(sudo:session): session closed for user root
Feb 22 11:55:28 volumio sudo[26441]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 22 11:55:28 volumio sudo[26441]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 11:55:28 volumio sudo[26441]: pam_unix(sudo:session): session closed for user root
Feb 22 11:55:28 volumio volumio[9395]: verbose: New Socket.io Connection to 192.168.1.242 from 192.168.1.232 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:28 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 22 11:55:28 volumio volumio[9395]: info: Received Get System Info
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 22 11:55:28 volumio volumio[9395]: info: Discovery: Getting this device information
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:28 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:28 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:28 volumio volumio[9395]: info: Listing playlists
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 22 11:55:28 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 22 11:55:28 volumio volumio[9395]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Lenny%20Kravitz/Circus/9ed144ff-a7ee-4ed8-b758-a803d61f99d4.png'
Feb 22 11:55:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Feb 22 11:55:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 22 11:55:30 volumio volumio[9395]: info: Received Get System Info
Feb 22 11:55:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 22 11:55:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 22 11:55:30 volumio volumio[9395]: info: Discovery: Getting this device information
Feb 22 11:55:30 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:30 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 11:55:30 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 22 11:55:30 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:30 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:30 volumio volumio[9395]: info: Listing playlists
Feb 22 11:55:30 volumio volumio[9395]: info: Listing playlists
Feb 22 11:55:33 volumio volumio[9395]: info: CoreCommandRouter::volumioGetQueue
Feb 22 11:55:33 volumio volumio[9395]: info: CoreStateMachine::getQueue
Feb 22 11:55:33 volumio volumio[9395]: info: CorePlayQueue::getQueue
Feb 22 11:55:34 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 22 11:55:34 volumio volumio[9395]: info: Received Get System Info
Feb 22 11:55:34 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 22 11:55:34 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 22 11:55:34 volumio volumio[9395]: info: Discovery: Getting this device information
Feb 22 11:55:34 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:34 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:34 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 11:55:35 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 22 11:55:35 volumio volumio[9395]: info: CURURI: music-library
Feb 22 11:55:35 volumio volumio[9395]: info: Preload queue cleared
Feb 22 11:55:36 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 22 11:55:36 volumio volumio[9395]: info: CURURI: music-library/INTERNAL
Feb 22 11:55:36 volumio volumio[9395]: info: Preload queue cleared
Feb 22 11:55:36 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 22 11:55:36 volumio volumio[9395]: info: CURURI: music-library/INTERNAL/Music
Feb 22 11:55:36 volumio volumio[9395]: info: Preload queue cleared
Feb 22 11:55:37 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 22 11:55:37 volumio volumio[9395]: info: CURURI: music-library/INTERNAL/Music/Lenny Kravitz
Feb 22 11:55:37 volumio volumio[9395]: info: Preload queue cleared
Feb 22 11:55:38 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 22 11:55:38 volumio volumio[9395]: info: CURURI: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5
Feb 22 11:55:38 volumio volumio[9395]: info: Preload queue cleared
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/01 Live.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/02 Supersoulfighter.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/04 Black Velveteen.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/05 If You Can't Say No.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/06 Thinking Of You.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/07 Take Time.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/08 Fly Away.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/09 It's Your Life.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/10 Straight Cold Player.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/11 Little Girl's Eyes.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/12 You're My Favor.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/13 Can We Find A Reason.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Preloading song: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/14 Without You.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/01 Live.mp3 in service mpd
Feb 22 11:55:38 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F01%20Live.mp3&metadata=false
Feb 22 11:55:38 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/01 Live.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/02 Supersoulfighter.mp3 in service mpd
Feb 22 11:55:38 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F02%20Supersoulfighter.mp3&metadata=false
Feb 22 11:55:38 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/02 Supersoulfighter.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3 in service mpd
Feb 22 11:55:38 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F03%20I%20Belong%20To%20Tou.mp3&metadata=false
Feb 22 11:55:38 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/04 Black Velveteen.mp3 in service mpd
Feb 22 11:55:38 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F04%20Black%20Velveteen.mp3&metadata=false
Feb 22 11:55:38 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/04 Black Velveteen.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 22 11:55:38 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/05 If You Can't Say No.mp3 in service mpd
Feb 22 11:55:38 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F05%20If%20You%20Can't%20Say%20No.mp3&metadata=false
Feb 22 11:55:38 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/05 If You Can't Say No.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/06 Thinking Of You.mp3 in service mpd
Feb 22 11:55:38 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F06%20Thinking%20Of%20You.mp3&metadata=false
Feb 22 11:55:38 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/06 Thinking Of You.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/07 Take Time.mp3 in service mpd
Feb 22 11:55:38 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F07%20Take%20Time.mp3&metadata=false
Feb 22 11:55:38 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/07 Take Time.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/08 Fly Away.mp3 in service mpd
Feb 22 11:55:38 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F08%20Fly%20Away.mp3&metadata=false
Feb 22 11:55:38 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/08 Fly Away.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/09 It's Your Life.mp3 in service mpd
Feb 22 11:55:38 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F09%20It's%20Your%20Life.mp3&metadata=false
Feb 22 11:55:38 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/09 It's Your Life.mp3
Feb 22 11:55:38 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/10 Straight Cold Player.mp3 in service mpd
Feb 22 11:55:38 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F10%20Straight%20Cold%20Player.mp3&metadata=false
Feb 22 11:55:38 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/10 Straight Cold Player.mp3
Feb 22 11:55:39 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/11 Little Girl's Eyes.mp3 in service mpd
Feb 22 11:55:39 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F11%20Little%20Girl's%20Eyes.mp3&metadata=false
Feb 22 11:55:39 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/11 Little Girl's Eyes.mp3
Feb 22 11:55:39 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/12 You're My Favor.mp3 in service mpd
Feb 22 11:55:39 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F12%20You're%20My%20Favor.mp3&metadata=false
Feb 22 11:55:39 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/12 You're My Favor.mp3
Feb 22 11:55:39 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/13 Can We Find A Reason.mp3 in service mpd
Feb 22 11:55:39 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F13%20Can%20We%20Find%20A%20Reason.mp3&metadata=false
Feb 22 11:55:39 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/13 Can We Find A Reason.mp3
Feb 22 11:55:39 volumio volumio[9395]: info: Exploding uri music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/14 Without You.mp3 in service mpd
Feb 22 11:55:39 volumio volumio[9395]: info: ALBUMART /albumart?cacheid=428&web=Lenny%20Kravitz/5/extralarge&path=%2Fmnt%2FINTERNAL%2FMusic%2FLenny%20Kravitz%2F1998%20-%205%2F14%20Without%20You.mp3&metadata=false
Feb 22 11:55:39 volumio volumio[9395]: info: URI /mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/14 Without You.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Preload queue cleared
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioReplaceandPlayItems
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::ClearQueue
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::stop
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::stPlaybackTimer
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::updateTrackBlock
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrackBlock
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::serviceStop
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 5
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::serviceStop
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::stop
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand stop
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::clearPlayQueue
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::saveQueue
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushQueue
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::addQueueItems
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::addQueueItems
Feb 22 11:55:40 volumio volumio[9395]: info: Preload queue cleared
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/01 Live.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/01 Live.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/02 Supersoulfighter.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/02 Supersoulfighter.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.704+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_STOPPED positionMs=0 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.704+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1995 - Circus/06 Magdalene.mp3" title=Magdalene
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushQueue
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::saveQueue
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::updateTrackBlock
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrackBlock
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPlay
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::play index 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::addQueueItems
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::addQueueItems
Feb 22 11:55:40 volumio volumio[9395]: info: Preload queue cleared
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/04 Black Velveteen.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/04 Black Velveteen.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/05 If You Can't Say No.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/05 If You Can't Say No.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/06 Thinking Of You.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/06 Thinking Of You.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/07 Take Time.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/07 Take Time.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/08 Fly Away.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/08 Fly Away.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/09 It's Your Life.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/09 It's Your Life.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/10 Straight Cold Player.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/10 Straight Cold Player.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/11 Little Girl's Eyes.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/11 Little Girl's Eyes.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/12 You're My Favor.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/12 You're My Favor.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/13 Can We Find A Reason.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/13 Can We Find A Reason.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Adding Item to queue: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/14 Without You.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: Using cached record of: music-library/INTERNAL/Music/Lenny Kravitz/1998 - 5/14 Without You.mp3
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::stop
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushQueue
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::saveQueue
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::play index undefined
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::updateTrackBlock
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrackBlock
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::startPlaybackTimer
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand stop
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand stop took 19 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand stop took 5 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand clear
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:40 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand status took 4 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand clear took 4 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand status took 4 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand status took 3 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3"
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 22 11:55:40 volumio volumio[9395]: verbose: CURRENT POSITION 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState stateService stop
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus stop
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: No code
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 22 11:55:40 volumio volumio[9395]: verbose: CURRENT POSITION 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState stateService stop
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus stop
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: No code
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.734+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_STOPPED positionMs=0 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.734+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_STOPPED positionMs=0 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.735+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.735+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_STOPPED positionMs=0 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.735+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.735+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_STOPPED positionMs=0 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.735+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.735+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.735+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_STOPPED positionMs=0 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.736+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.736+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_STOPPED positionMs=0 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.737+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 18ms
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 19ms
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:40 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:40 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:40 volumio volumio[9395]: error: updateQueue error: null
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:40 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 18ms
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand playlistinfo took 17 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand add "INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" took 17 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseTrackInfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand play
Feb 22 11:55:40 volumio volumio[9395]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 25ms
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 9ms
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 8ms
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:40 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces system playlist update
Feb 22 11:55:40 volumio volumio[9395]: info: Ignoring MPD Status Update
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 13ms
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand play took 12 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 3ms
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 3ms
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand status took 4 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:40 volumio volumio[9395]: info:
Feb 22 11:55:40 volumio volumio[9395]: ---------------------------- MPD announces state update: player
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::getState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand status took 7 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand status took 4 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand status took 4 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand status took 3 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand status took 2 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseTrackInfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseState
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Belong To Tou","artist":"Lenny Kravitz","album":"5","uri":"INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3","trackType":"mp3"}
Feb 22 11:55:40 volumio volumio[9395]: verbose: CURRENT POSITION 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState stateService play
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus stop
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 13ms
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseTrackInfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseTrackInfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseTrackInfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseTrackInfo
Feb 22 11:55:40 volumio volumio[9395]: verbose: ControllerMpd::parseTrackInfo
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Belong To Tou","artist":"Lenny Kravitz","album":"5","uri":"INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3","trackType":"mp3"}
Feb 22 11:55:40 volumio volumio[9395]: verbose: CURRENT POSITION 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState stateService play
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus play
Feb 22 11:55:40 volumio volumio[9395]: info: Received an update from plugin. extracting info from payload
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Belong To Tou","artist":"Lenny Kravitz","album":"5","uri":"INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3","trackType":"mp3"}
Feb 22 11:55:40 volumio volumio[9395]: verbose: CURRENT POSITION 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState stateService play
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus play
Feb 22 11:55:40 volumio volumio[9395]: info: Received an update from plugin. extracting info from payload
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Belong To Tou","artist":"Lenny Kravitz","album":"5","uri":"INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3","trackType":"mp3"}
Feb 22 11:55:40 volumio volumio[9395]: verbose: CURRENT POSITION 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState stateService play
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus play
Feb 22 11:55:40 volumio volumio[9395]: info: Received an update from plugin. extracting info from payload
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Belong To Tou","artist":"Lenny Kravitz","album":"5","uri":"INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3","trackType":"mp3"}
Feb 22 11:55:40 volumio volumio[9395]: verbose: CURRENT POSITION 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState stateService play
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus play
Feb 22 11:55:40 volumio volumio[9395]: info: Received an update from plugin. extracting info from payload
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: ControllerMpd::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::servicePushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I Belong To Tou","artist":"Lenny Kravitz","album":"5","uri":"INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3","trackType":"mp3"}
Feb 22 11:55:40 volumio volumio[9395]: verbose: CURRENT POSITION 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState stateService play
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::syncState currentStatus play
Feb 22 11:55:40 volumio volumio[9395]: info: Received an update from plugin. extracting info from payload
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio[9395]: info: CoreStateMachine::pushState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioPushState
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.818+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=871 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.819+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.819+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=871 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.821+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.819+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=871 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.820+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=871 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.820+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=871 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.820+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=871 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.821+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=871 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.822+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.822+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.822+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.821+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=871 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.822+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.822+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=871 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.823+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.823+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.824+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 43ms
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 43ms
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 42ms
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 39ms
Feb 22 11:55:40 volumio volumio[9395]: info: ------------------------------ 39ms
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.829+05:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" state=STATUS_PLAYING positionMs=871 volume=100
Feb 22 11:55:40 volumio volumio5-onboarding[1610]: time=2026-02-22T11:55:40.829+05:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.232:63553 @ 0x2a1b080" id="mnt/INTERNAL/Music/Lenny Kravitz/1998 - 5/03 I Belong To Tou.mp3" title="I Belong To Tou"
Feb 22 11:55:40 volumio volumio[9395]: info: CoreCommandRouter::volumioGetState
Feb 22 11:55:40 volumio volumio[9395]: info: CorePlayQueue::getTrack 2
Feb 22 11:55:41 volumio volumio[9395]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 22 11:55:41 volumio volumio[9395]: Error: read ECONNRESET
Feb 22 11:55:41 volumio volumio[9395]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:217:20) {
Feb 22 11:55:41 volumio volumio[9395]: errno: -104,
Feb 22 11:55:41 volumio volumio[9395]: code: 'ECONNRESET',
Feb 22 11:55:41 volumio volumio[9395]: syscall: 'read'
Feb 22 11:55:41 volumio volumio[9395]: }
Feb 22 11:55:41 volumio volumio[9395]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 22 11:55:41 volumio sudo[26502]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-22 11:54'
Feb 22 11:55:41 volumio sudo[26502]: 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"