Mar 27 20:38:01 volumio volumio[1129]: info: CALLMETHOD: user_interface now_playing configSaveBackgroundStyles [object Object]
Mar 27 20:38:01 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: now_playing , configSaveBackgroundStyles
Mar 27 20:38:06 volumio volumio[1129]: info: CALLMETHOD: user_interface now_playing configSaveBackgroundStyles [object Object]
Mar 27 20:38:06 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: now_playing , configSaveBackgroundStyles
Mar 27 20:38:07 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:38:07 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:38:07 volumio volumio[1129]: info: Listing playlists
Mar 27 20:38:07 volumio volumio[1129]: info: Listing playlists
Mar 27 20:38:17 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:38:17 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:38:21 volumio dhcpcd[840]: eth0: failed to renew DHCP, rebinding
Mar 27 20:38:21 volumio dhcpcd[840]: eth0: NAK: address not available from 192.168.62.1
Mar 27 20:38:21 volumio dhcpcd[840]: eth0: message: address not available
Mar 27 20:38:21 volumio avahi-daemon[764]: Withdrawing address record for 192.168.62.25 on eth0.
Mar 27 20:38:21 volumio avahi-daemon[764]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.62.25.
Mar 27 20:38:21 volumio dhcpcd[729]: eth0: pid 840 deleted IP address 192.168.62.25/24
Mar 27 20:38:21 volumio dhcpcd[729]: eth0: deleting route to 192.168.62.0/24
Mar 27 20:38:21 volumio dhcpcd[729]: eth0: deleting default route via 192.168.62.4
Mar 27 20:38:21 volumio dhcpcd[840]: eth0: deleting route to 192.168.62.0/24
Mar 27 20:38:21 volumio avahi-daemon[764]: Interface eth0.IPv4 no longer relevant for mDNS.
Mar 27 20:38:21 volumio dhcpcd[840]: eth0: deleting default route via 192.168.62.4
Mar 27 20:38:21 volumio volumio[1129]: info: Discovery: A device disappeared from network
Mar 27 20:38:21 volumio dhcpcd[840]: eth0: soliciting a DHCP lease
Mar 27 20:38:21 volumio dhcpcd[729]: eth0: soliciting a DHCP lease
Mar 27 20:38:21 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Mar 27 20:38:21 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Mar 27 20:38:21 volumio systemd[1]: welcome.service: Deactivated successfully.
Mar 27 20:38:21 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Mar 27 20:38:21 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Mar 27 20:38:21 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Mar 27 20:38:21 volumio dhcpcd[729]: eth0: offered 192.168.62.25 from 192.168.62.4
Mar 27 20:38:21 volumio dhcpcd[840]: eth0: offered 192.168.62.25 from 192.168.62.4
Mar 27 20:38:21 volumio dhcpcd[840]: eth0: probing address 192.168.62.25/24
Mar 27 20:38:21 volumio dhcpcd[729]: eth0: probing address 192.168.62.25/24
Mar 27 20:38:21 volumio welcome[6772]: Resolved ip:[0]
Mar 27 20:38:21 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Mar 27 20:38:21 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Mar 27 20:38:21 volumio volumio[1129]: info: Received Get System Info
Mar 27 20:38:21 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 27 20:38:21 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 27 20:38:21 volumio volumio[1129]: info: Discovery: Getting this device information
Mar 27 20:38:21 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:38:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:38:21 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 27 20:38:21 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 27 20:38:21 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 27 20:38:22 volumio volumio5-onboarding[2105]: time=2026-03-27T20:38:22.622+02:00 level=INFO msg="service successfully established" component=discovery/localnet
Mar 27 20:38:22 volumio ntpd[1013]: IO: Deleting interface #15 eth0, 192.168.62.25#123, interface stats: received=8, sent=8, dropped=0, active_time=105 secs
Mar 27 20:38:22 volumio ntpd[1013]: PROTO: 195.85.215.8 unlink local addr 192.168.62.25 ->
Mar 27 20:38:22 volumio ntpd[1013]: PROTO: 77.236.182.128 unlink local addr 192.168.62.25 ->
Mar 27 20:38:22 volumio ntpd[1013]: PROTO: 87.120.244.14 unlink local addr 192.168.62.25 ->
Mar 27 20:38:22 volumio ntpd[1013]: PROTO: 162.159.200.123 unlink local addr 192.168.62.25 ->
Mar 27 20:38:22 volumio ntpd[1013]: PROTO: 78.130.168.61 unlink local addr 192.168.62.25 ->
Mar 27 20:38:22 volumio ntpd[1013]: PROTO: 193.238.174.38 unlink local addr 192.168.62.25 ->
Mar 27 20:38:22 volumio ntpd[1013]: PROTO: 88.203.195.14 unlink local addr 192.168.62.25 ->
Mar 27 20:38:23 volumio volumio[1129]: info: Volumio Network Manager: Network status updated: 0
Mar 27 20:38:26 volumio dhcpcd[840]: eth0: leased 192.168.62.25 for 120 seconds
Mar 27 20:38:26 volumio avahi-daemon[764]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.62.25.
Mar 27 20:38:26 volumio avahi-daemon[764]: New relevant interface eth0.IPv4 for mDNS.
Mar 27 20:38:26 volumio avahi-daemon[764]: Registering new address record for 192.168.62.25 on eth0.IPv4.
Mar 27 20:38:26 volumio dhcpcd[840]: eth0: adding route to 192.168.62.0/24
Mar 27 20:38:26 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Mar 27 20:38:26 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Mar 27 20:38:26 volumio systemd[1]: welcome.service: Deactivated successfully.
Mar 27 20:38:26 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Mar 27 20:38:26 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Mar 27 20:38:26 volumio dhcpcd[840]: eth0: adding default route via 192.168.62.4
Mar 27 20:38:26 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Mar 27 20:38:26 volumio welcome[6808]: Resolved ip:[1] 192.168.62.25
Mar 27 20:38:26 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Mar 27 20:38:26 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Mar 27 20:38:26 volumio volumio[1129]: info: CALLMETHOD: user_interface now_playing configSaveBackgroundStyles [object Object]
Mar 27 20:38:26 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: now_playing , configSaveBackgroundStyles
Mar 27 20:38:26 volumio volumio[1129]: info: CALLMETHOD: user_interface now_playing configSaveBackgroundStyles [object Object]
Mar 27 20:38:26 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: now_playing , configSaveBackgroundStyles
Mar 27 20:38:26 volumio volumio[1129]: info: Received Get System Info
Mar 27 20:38:26 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 27 20:38:26 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 27 20:38:26 volumio volumio[1129]: info: Discovery: Getting this device information
Mar 27 20:38:26 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:38:26 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:38:26 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 27 20:38:26 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 27 20:38:26 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 27 20:38:26 volumio dhcpcd[729]: eth0: leased 192.168.62.25 for 120 seconds
Mar 27 20:38:26 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Mar 27 20:38:26 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Mar 27 20:38:26 volumio systemd[1]: welcome.service: Deactivated successfully.
Mar 27 20:38:26 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Mar 27 20:38:26 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Mar 27 20:38:26 volumio dhcpcd[729]: eth0: adding route to 192.168.62.0/24
Mar 27 20:38:26 volumio dhcpcd[729]: eth0: adding default route via 192.168.62.4
Mar 27 20:38:27 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Mar 27 20:38:27 volumio welcome[6837]: Resolved ip:[1] 192.168.62.25
Mar 27 20:38:27 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Mar 27 20:38:27 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Mar 27 20:38:27 volumio volumio[1129]: info: Discovery: adding 4b395812-8711-4d9f-95ab-5010e4102a2a
Mar 27 20:38:27 volumio volumio[1129]: info: Discovery: Found device Volumio
Mar 27 20:38:27 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:38:27 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:38:27 volumio volumio[1129]: info: Received Get System Info
Mar 27 20:38:27 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 27 20:38:27 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 27 20:38:27 volumio volumio[1129]: info: Discovery: Getting this device information
Mar 27 20:38:27 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:38:27 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:38:27 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 27 20:38:27 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 27 20:38:27 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 27 20:38:27 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:38:27 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:38:27 volumio volumio[1129]: info: Listing playlists
Mar 27 20:38:27 volumio volumio[1129]: info: Listing playlists
Mar 27 20:38:28 volumio volumio5-onboarding[2105]: time=2026-03-27T20:38:28.577+02:00 level=INFO msg="service successfully established" component=discovery/localnet
Mar 27 20:38:28 volumio ntpd[1013]: IO: Listen normally on 16 eth0 192.168.62.25:123
Mar 27 20:38:28 volumio ntpd[1013]: IO: new interface(s) found: waking up resolver
Mar 27 20:38:33 volumio volumio[1129]: info: Volumio Network Manager: Network status updated: 1
Mar 27 20:38:37 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:38:37 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:38:45 volumio volumio[1129]: info: CALLMETHOD: user_interface now_playing configSaveBackgroundStyles [object Object]
Mar 27 20:38:45 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: now_playing , configSaveBackgroundStyles
Mar 27 20:38:47 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:38:47 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:38:47 volumio volumio[1129]: info: Listing playlists
Mar 27 20:38:47 volumio volumio[1129]: info: Listing playlists
Mar 27 20:38:57 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:38:57 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:39:00 volumio volumio[1129]: info: CALLMETHOD: user_interface now_playing configSaveBackgroundStyles [object Object]
Mar 27 20:39:00 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: now_playing , configSaveBackgroundStyles
Mar 27 20:39:07 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:39:07 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:39:07 volumio volumio[1129]: info: Listing playlists
Mar 27 20:39:07 volumio volumio[1129]: info: Listing playlists
Mar 27 20:39:11 volumio volumio[1129]: info: CALLMETHOD: user_interface now_playing configSaveBackgroundStyles [object Object]
Mar 27 20:39:11 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: now_playing , configSaveBackgroundStyles
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioNext
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::next
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::stop
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::stPlaybackTimer
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::serviceStop
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 2
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::serviceStop
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::stop
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand stop took 12 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::play index undefined
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::startPlaybackTimer
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::clearAddPlayTracks NAS/Data2/For Music player/Audiophile/Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit.flac
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand status took 8 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand stop took 5 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand clear
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:16 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 19 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand clear took 19 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand status took 19 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand status took 19 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand add "NAS/Data2/For Music player/Audiophile/Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit.flac"
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Allan Taylor - Colour to the moon","artist":"Kyoto","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Allan Taylor - Colour to the moon.flac","trackType":"flac"}
Mar 27 20:39:16 volumio volumio[1129]: verbose: CURRENT POSITION 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: No code
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: 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}
Mar 27 20:39:16 volumio volumio[1129]: verbose: CURRENT POSITION 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: No code
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: 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}
Mar 27 20:39:16 volumio volumio[1129]: verbose: CURRENT POSITION 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: No code
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 74ms
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 65ms
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 65ms
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:16 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:16 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:16 volumio volumio[1129]: error: updateQueue error: null
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:16 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 62ms
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand add "NAS/Data2/For Music player/Audiophile/Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit.flac" took 60 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 14ms
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 7ms
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand play
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:16 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:16 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 48ms
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand play took 44 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 43ms
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 39ms
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand status took 8 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand status took 6 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand status took 5 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:16 volumio volumio[1129]: info:
Mar 27 20:39:16 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand status took 6 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 8 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 9 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 9 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand status took 9 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand status took 8 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":446,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit","artist":"Hi-res Audio 24bit","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit.flac","trackType":"flac"}
Mar 27 20:39:16 volumio volumio[1129]: verbose: CURRENT POSITION 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":446,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit","artist":"Hi-res Audio 24bit","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit.flac","trackType":"flac"}
Mar 27 20:39:16 volumio volumio[1129]: verbose: CURRENT POSITION 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:16 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":446,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit","artist":"Hi-res Audio 24bit","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit.flac","trackType":"flac"}
Mar 27 20:39:16 volumio volumio[1129]: verbose: CURRENT POSITION 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:16 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":446,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit","artist":"Hi-res Audio 24bit","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit.flac","trackType":"flac"}
Mar 27 20:39:16 volumio volumio[1129]: verbose: CURRENT POSITION 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:16 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 51ms
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 70ms
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 69ms
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 66ms
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 49 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 48 milliseconds
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:16 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":446,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit","artist":"Hi-res Audio 24bit","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit.flac","trackType":"flac"}
Mar 27 20:39:16 volumio volumio[1129]: verbose: CURRENT POSITION 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:16 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":446,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit","artist":"Hi-res Audio 24bit","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit.flac","trackType":"flac"}
Mar 27 20:39:16 volumio volumio[1129]: verbose: CURRENT POSITION 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:16 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:16 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:16 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 96ms
Mar 27 20:39:16 volumio volumio[1129]: info: ------------------------------ 96ms
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:16 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:17 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 0 seconds.
Mar 27 20:39:17 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:39:17 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioNext
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::next
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::stop
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::stPlaybackTimer
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::serviceStop
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 3
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::serviceStop
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::stop
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand stop took 25 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::play index undefined
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::startPlaybackTimer
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::clearAddPlayTracks NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line (Lyrics).flac
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand status took 9 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand stop took 7 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand status took 5 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand status took 1 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand clear
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:19 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:19 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand clear took 3 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand add "NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line (Lyrics).flac"
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit","artist":"Hi-res Audio 24bit","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Alvin Lee - The Bluest Blues (High-Res Audio) Flac 24bit.flac","trackType":"flac"}
Mar 27 20:39:19 volumio volumio[1129]: verbose: CURRENT POSITION 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: No code
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 31ms
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 26ms
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:19 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:19 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:19 volumio volumio[1129]: error: updateQueue error: null
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:19 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 24 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 24ms
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand add "NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line (Lyrics).flac" took 22 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 6ms
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand play
Mar 27 20:39:19 volumio volumio[1129]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 34ms
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:19 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 24ms
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 22ms
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand play took 17 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 14ms
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:19 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 1ms
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand status took 6 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:19 volumio volumio[1129]: info:
Mar 27 20:39:19 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand status took 28 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand status took 26 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand status took 20 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 19 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand status took 16 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand status took 15 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":263,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anna Yvette - Red Line (Lyrics)","artist":"Music Store","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line (Lyrics).flac","trackType":"flac"}
Mar 27 20:39:19 volumio volumio[1129]: verbose: CURRENT POSITION 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 37ms
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:19 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":263,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anna Yvette - Red Line (Lyrics)","artist":"Music Store","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line (Lyrics).flac","trackType":"flac"}
Mar 27 20:39:19 volumio volumio[1129]: verbose: CURRENT POSITION 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:19 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":263,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anna Yvette - Red Line (Lyrics)","artist":"Music Store","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line (Lyrics).flac","trackType":"flac"}
Mar 27 20:39:19 volumio volumio[1129]: verbose: CURRENT POSITION 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:19 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":263,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"920 Kbps","isStreaming":false,"title":"Anna Yvette - Red Line (Lyrics)","artist":"Music Store","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line (Lyrics).flac","trackType":"flac"}
Mar 27 20:39:19 volumio volumio[1129]: verbose: CURRENT POSITION 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:19 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":377,"duration":263,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"969 Kbps","isStreaming":false,"title":"Anna Yvette - Red Line (Lyrics)","artist":"Music Store","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line (Lyrics).flac","trackType":"flac"}
Mar 27 20:39:19 volumio volumio[1129]: verbose: CURRENT POSITION 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:19 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":263,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"981 Kbps","isStreaming":false,"title":"Anna Yvette - Red Line (Lyrics)","artist":"Music Store","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line (Lyrics).flac","trackType":"flac"}
Mar 27 20:39:19 volumio volumio[1129]: verbose: CURRENT POSITION 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:19 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:19 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:19 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 85ms
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 82ms
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 82ms
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 74ms
Mar 27 20:39:19 volumio volumio[1129]: info: ------------------------------ 72ms
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:19 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:20 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 0 seconds.
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioNext
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::next
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::stop
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::stPlaybackTimer
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::serviceStop
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 4
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::serviceStop
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::stop
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand stop took 6 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::play index undefined
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::startPlaybackTimer
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::clearAddPlayTracks NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music.flac
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand status took 1 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand stop took 1 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand clear
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:21 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 13 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand clear took 13 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand status took 2 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand status took 1 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand add "NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music.flac"
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anna Yvette - Red Line (Lyrics)","artist":"Music Store","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line (Lyrics).flac","trackType":"flac"}
Mar 27 20:39:21 volumio volumio[1129]: verbose: CURRENT POSITION 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: No code
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: 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}
Mar 27 20:39:21 volumio volumio[1129]: verbose: CURRENT POSITION 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: No code
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: 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}
Mar 27 20:39:21 volumio volumio[1129]: verbose: CURRENT POSITION 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: No code
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 72ms
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 61ms
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 60ms
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:21 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:21 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:21 volumio volumio[1129]: error: updateQueue error: null
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:21 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 65ms
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand add "NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music.flac" took 64 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 5ms
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 5ms
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand play
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:21 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:21 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 69ms
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand play took 70 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 69ms
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 75ms
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand status took 36 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand status took 27 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand status took 9 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:21 volumio volumio[1129]: info:
Mar 27 20:39:21 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand status took 13 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 10 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 11 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 11 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand status took 11 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand status took 10 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":265,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"942 Kbps","isStreaming":false,"title":"Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music","artist":"NoCopyrightSounds","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music.flac","trackType":"flac"}
Mar 27 20:39:21 volumio volumio[1129]: verbose: CURRENT POSITION 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":265,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"942 Kbps","isStreaming":false,"title":"Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music","artist":"NoCopyrightSounds","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music.flac","trackType":"flac"}
Mar 27 20:39:21 volumio volumio[1129]: verbose: CURRENT POSITION 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:21 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":265,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"942 Kbps","isStreaming":false,"title":"Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music","artist":"NoCopyrightSounds","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music.flac","trackType":"flac"}
Mar 27 20:39:21 volumio volumio[1129]: verbose: CURRENT POSITION 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:21 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 81ms
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 69ms
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 53ms
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 32 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 30 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 31 milliseconds
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:21 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":265,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"942 Kbps","isStreaming":false,"title":"Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music","artist":"NoCopyrightSounds","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music.flac","trackType":"flac"}
Mar 27 20:39:21 volumio volumio[1129]: verbose: CURRENT POSITION 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:21 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":265,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"942 Kbps","isStreaming":false,"title":"Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music","artist":"NoCopyrightSounds","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music.flac","trackType":"flac"}
Mar 27 20:39:21 volumio volumio[1129]: verbose: CURRENT POSITION 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:21 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":265,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"942 Kbps","isStreaming":false,"title":"Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music","artist":"NoCopyrightSounds","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music.flac","trackType":"flac"}
Mar 27 20:39:21 volumio volumio[1129]: verbose: CURRENT POSITION 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:21 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:21 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:21 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 78ms
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 69ms
Mar 27 20:39:21 volumio volumio[1129]: info: ------------------------------ 68ms
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:21 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 0 seconds.
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioNext
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::next
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::stop
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::stPlaybackTimer
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::serviceStop
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 5
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::serviceStop
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::stop
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand stop took 12 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::play index undefined
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::startPlaybackTimer
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::clearAddPlayTracks NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II (1).flac
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand status took 3 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand stop took 1 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand clear
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:23 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 12 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand clear took 12 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand add "NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II (1).flac"
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music","artist":"NoCopyrightSounds","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Anna Yvette - Red Line | Synthwave | NCS - Copyright Free Music.flac","trackType":"flac"}
Mar 27 20:39:23 volumio volumio[1129]: verbose: CURRENT POSITION 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: No code
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 30ms
Mar 27 20:39:23 volumio volumio[1129]: error: updateQueue error: null
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:23 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand status took 20 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand status took 19 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 18ms
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand add "NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II (1).flac" took 17 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand play
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: 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}
Mar 27 20:39:23 volumio volumio[1129]: verbose: CURRENT POSITION 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: No code
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: 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}
Mar 27 20:39:23 volumio volumio[1129]: verbose: CURRENT POSITION 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: No code
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 68ms
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 69ms
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:23 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:23 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 87ms
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand play took 85 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 35ms
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 34ms
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:23 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:23 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:23 volumio volumio[1129]: info:
Mar 27 20:39:23 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand status took 8 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand status took 9 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 8ms
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand status took 7 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 6ms
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand status took 5 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 7 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 7 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 7 milliseconds
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:23 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":521,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1332 Kbps","isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II (1).flac","trackType":"flac"}
Mar 27 20:39:23 volumio volumio[1129]: verbose: CURRENT POSITION 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":521,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1332 Kbps","isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II (1).flac","trackType":"flac"}
Mar 27 20:39:23 volumio volumio[1129]: verbose: CURRENT POSITION 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:23 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":521,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1332 Kbps","isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II (1).flac","trackType":"flac"}
Mar 27 20:39:23 volumio volumio[1129]: verbose: CURRENT POSITION 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:23 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":521,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1332 Kbps","isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II (1).flac","trackType":"flac"}
Mar 27 20:39:23 volumio volumio[1129]: verbose: CURRENT POSITION 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:23 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:23 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:23 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 34ms
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 50ms
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 49ms
Mar 27 20:39:23 volumio volumio[1129]: info: ------------------------------ 47ms
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:23 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 0 seconds.
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioNext
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::next
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::stop
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::stPlaybackTimer
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::serviceStop
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 6
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::serviceStop
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::stop
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand stop took 13 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::play index undefined
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::startPlaybackTimer
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::clearAddPlayTracks NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II.flac
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand status took 13 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand stop took 13 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand status took 3 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand status took 2 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand clear
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:24 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand clear took 3 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand add "NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II.flac"
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II (1).flac","trackType":"flac"}
Mar 27 20:39:24 volumio volumio[1129]: verbose: CURRENT POSITION 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: No code
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Mar 27 20:39:24 volumio volumio[1129]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 37ms
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 28ms
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 26ms
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:24 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:24 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:24 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 27 20:39:24 volumio volumio[1129]: error: updateQueue error: null
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:24 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 24ms
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand add "NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II.flac" took 21 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 3ms
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 2ms
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand play
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:24 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:24 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 16ms
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand play took 15 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 14ms
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 13ms
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand status took 5 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand status took 5 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand status took 5 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand status took 3 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 4 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand status took 2 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":521,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II.flac","trackType":"flac"}
Mar 27 20:39:24 volumio volumio[1129]: verbose: CURRENT POSITION 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":521,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II.flac","trackType":"flac"}
Mar 27 20:39:24 volumio volumio[1129]: verbose: CURRENT POSITION 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:24 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":80,"duration":521,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II.flac","trackType":"flac"}
Mar 27 20:39:24 volumio volumio[1129]: verbose: CURRENT POSITION 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:24 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 21ms
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 29ms
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 29ms
Mar 27 20:39:24 volumio volumio[1129]: info:
Mar 27 20:39:24 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 22 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 21 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":521,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1332 Kbps","isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II.flac","trackType":"flac"}
Mar 27 20:39:24 volumio volumio[1129]: verbose: CURRENT POSITION 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:24 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":521,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1332 Kbps","isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II.flac","trackType":"flac"}
Mar 27 20:39:24 volumio volumio[1129]: verbose: CURRENT POSITION 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:24 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 41ms
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 39ms
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand status took 76 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:24 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 27 20:39:24 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:24 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":521,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1332 Kbps","isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II.flac","trackType":"flac"}
Mar 27 20:39:24 volumio volumio[1129]: verbose: CURRENT POSITION 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:24 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:24 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:24 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:24 volumio volumio[1129]: info: ------------------------------ 88ms
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:24 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 0 seconds.
Mar 27 20:39:26 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Mar 27 20:39:26 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Mar 27 20:39:26 volumio systemd[1]: welcome.service: Deactivated successfully.
Mar 27 20:39:26 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console.
Mar 27 20:39:26 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console...
Mar 27 20:39:27 volumio systemd[1]: Starting welcome.service - Show a welcome message on console...
Mar 27 20:39:27 volumio welcome[6983]: Resolved ip:[1] 192.168.62.25
Mar 27 20:39:27 volumio systemd[1]: Finished welcome.service - Show a welcome message on console.
Mar 27 20:39:27 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Mar 27 20:39:27 volumio volumio[1129]: info: Received Get System Info
Mar 27 20:39:27 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 27 20:39:27 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 27 20:39:27 volumio volumio[1129]: info: Discovery: Getting this device information
Mar 27 20:39:27 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:39:27 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:27 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 27 20:39:27 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 27 20:39:27 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 27 20:39:27 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:39:27 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:27 volumio volumio[1129]: info: Listing playlists
Mar 27 20:39:27 volumio volumio[1129]: info: Listing playlists
Mar 27 20:39:28 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:39:28 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:28 volumio volumio5-onboarding[2105]: time=2026-03-27T20:39:28.358+02:00 level=INFO msg="service successfully established" component=discovery/localnet
Mar 27 20:39:34 volumio volumio[1129]: info: Preload queue cleared
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::ClearQueue
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::stop
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::stPlaybackTimer
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::serviceStop
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 7
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::serviceStop
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::stop
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::clearPlayQueue
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::saveQueue
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushQueue
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::addQueueItems
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::addQueueItems
Mar 27 20:39:34 volumio volumio[1129]: info: Preload queue cleared
Mar 27 20:39:34 volumio volumio[1129]: info: Adding Item to queue: music-library/NAS/Data2/For Music player/Baccara – Baccara DSD
Mar 27 20:39:34 volumio volumio[1129]: info: Exploding uri music-library/NAS/Data2/For Music player/Baccara – Baccara DSD in service mpd
Mar 27 20:39:34 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F01.%20Yes%20Sir%2C%20I%20Can%20Boogie.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F02.%20Love%20You%20Till%20I%20Die.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/02. Love You Till I Die.dsf
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F03.%20Granada.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/03. Granada.dsf
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F04.%20Gimme%20More.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/04. Gimme More.dsf
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F05.%20Koochie-Koo.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/05. Koochie-Koo.dsf
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F06.%20Sorry%2C%20I'm%20A%20Lady.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/06. Sorry, I'm A Lady.dsf
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F07.%20Cara%20Mia.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/07. Cara Mia.dsf
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F08.%20Feel%20Me.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/08. Feel Me.dsf
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F09.%20Can't%20Help%20Falling%20In%20Love.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/09. Can't Help Falling In Love.dsf
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F10.%20Number%20One.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/10. Number One.dsf
Mar 27 20:39:34 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=//extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD%2F11.%20Don't%20Play%20Me%20A%20Symphonie.dsf&metadata=false
Mar 27 20:39:34 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/11. Don't Play Me A Symphonie.dsf
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand stop took 34 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushQueue
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::saveQueue
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPlay
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::play index 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::stop
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::play index undefined
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::startPlaybackTimer
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::clearAddPlayTracks NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand status took 10 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand stop took 3 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand status took 3 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand status took 2 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand clear
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:34 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 120 seconds.
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:34 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 10 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand clear took 11 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 11 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 12 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand add "NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf"
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Best Audiophile Voices II","artist":"Achien chien","album":null,"uri":"NAS/Data2/For Music player/Audiophile/Best Audiophile Voices II.flac","trackType":"flac"}
Mar 27 20:39:34 volumio volumio[1129]: verbose: CURRENT POSITION 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState stateService stop
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: No code
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Mar 27 20:39:34 volumio volumio[1129]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 35ms
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 27ms
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 26ms
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:34 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:34 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:34 volumio volumio[1129]: error: updateQueue error: null
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:34 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 17ms
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand add "NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf" took 14 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 3ms
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 2ms
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand play
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:34 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces system playlist update
Mar 27 20:39:34 volumio volumio[1129]: info: Ignoring MPD Status Update
Mar 27 20:39:34 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:34 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:34 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 15ms
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand play took 14 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 13ms
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 12ms
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand status took 8 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand status took 7 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:34 volumio volumio[1129]: info:
Mar 27 20:39:34 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand status took 9 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand status took 7 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 6 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":276,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Yes Sir, I Can Boogie.dsf","artist":null,"album":null,"uri":"NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf","trackType":"dsf"}
Mar 27 20:39:34 volumio volumio[1129]: verbose: CURRENT POSITION 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus stop
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":276,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Yes Sir, I Can Boogie.dsf","artist":null,"album":null,"uri":"NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf","trackType":"dsf"}
Mar 27 20:39:34 volumio volumio[1129]: verbose: CURRENT POSITION 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:34 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 34ms
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 37ms
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand status took 65 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand status took 64 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 63 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 63 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":276,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Yes Sir, I Can Boogie.dsf","artist":null,"album":null,"uri":"NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf","trackType":"dsf"}
Mar 27 20:39:34 volumio volumio[1129]: verbose: CURRENT POSITION 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:34 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":276,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Yes Sir, I Can Boogie.dsf","artist":null,"album":null,"uri":"NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf","trackType":"dsf"}
Mar 27 20:39:34 volumio volumio[1129]: verbose: CURRENT POSITION 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:34 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 98ms
Mar 27 20:39:34 volumio volumio[1129]: info: ------------------------------ 97ms
Mar 27 20:39:34 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:34 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:34 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:34 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:34 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:34 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 71 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 71 milliseconds
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:34 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":276,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Yes Sir, I Can Boogie.dsf","artist":null,"album":null,"uri":"NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf","trackType":"dsf"}
Mar 27 20:39:34 volumio volumio[1129]: verbose: CURRENT POSITION 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:34 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":276,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Yes Sir, I Can Boogie.dsf","artist":null,"album":null,"uri":"NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf","trackType":"dsf"}
Mar 27 20:39:34 volumio volumio[1129]: verbose: CURRENT POSITION 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:34 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:34 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:34 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:34 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:35 volumio volumio[1129]: info: ------------------------------ 155ms
Mar 27 20:39:35 volumio volumio[1129]: info: ------------------------------ 157ms
Mar 27 20:39:35 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:35 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:35 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:35 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:35 volumio volumio[1129]: info: touch_display: Setting screensaver timeout to 0 seconds.
Mar 27 20:39:37 volumio volumio[1129]: info: CoreCommandRouter::volumioGetState
Mar 27 20:39:37 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::volumioSeek
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::seek
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: info: TRACKBLOCK {"uri":"mnt/NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf","service":"mpd","name":"01. Yes Sir, I Can Boogie.dsf","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=400&web=//extralarge&path=%2FNAS%2FData2%2FFor%20Music%20player%2FBaccara%20%E2%80%93%20Baccara%20DSD&metadata=false","duration":276,"samplerate":"5.64 MHz","bitdepth":"1 bit","trackType":"dsf","channels":2}
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::startPlaybackTimer
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: info: ControllerMpd::seek
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:43 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:43 volumio volumio[1129]: error: null
Mar 27 20:39:43 volumio volumio[1129]: info:
Mar 27 20:39:43 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:43 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:43 volumio volumio[1129]: info:
Mar 27 20:39:43 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:43 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:43 volumio volumio[1129]: info:
Mar 27 20:39:43 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:43 volumio volumio[1129]: info: ControllerMpd::getState
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand status
Mar 27 20:39:43 volumio volumio[1129]: info: sendMpdCommand status took 2 milliseconds
Mar 27 20:39:43 volumio volumio[1129]: info: sendMpdCommand status took 1 milliseconds
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:43 volumio volumio[1129]: info: sendMpdCommand status took 2 milliseconds
Mar 27 20:39:43 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 1 milliseconds
Mar 27 20:39:43 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 1 milliseconds
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::parseState
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:43 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46000,"duration":276,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"01. Yes Sir, I Can Boogie.dsf","artist":null,"album":null,"uri":"NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf","trackType":"dsf"}
Mar 27 20:39:43 volumio volumio[1129]: verbose: CURRENT POSITION 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:43 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:43 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46000,"duration":276,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"01. Yes Sir, I Can Boogie.dsf","artist":null,"album":null,"uri":"NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf","trackType":"dsf"}
Mar 27 20:39:43 volumio volumio[1129]: verbose: CURRENT POSITION 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:43 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:43 volumio volumio[1129]: info: ------------------------------ 29ms
Mar 27 20:39:43 volumio volumio[1129]: info: ------------------------------ 28ms
Mar 27 20:39:43 volumio volumio[1129]: info: sendMpdCommand playlistinfo took 25 milliseconds
Mar 27 20:39:43 volumio volumio[1129]: verbose: ControllerMpd::parseTrackInfo
Mar 27 20:39:43 volumio volumio[1129]: info: ControllerMpd::pushState
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::servicePushState
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46000,"duration":276,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"01. Yes Sir, I Can Boogie.dsf","artist":null,"album":null,"uri":"NAS/Data2/For Music player/Baccara – Baccara DSD/01. Yes Sir, I Can Boogie.dsf","trackType":"dsf"}
Mar 27 20:39:43 volumio volumio[1129]: verbose: CURRENT POSITION 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::syncState stateService play
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::syncState currentStatus play
Mar 27 20:39:43 volumio volumio[1129]: info: Received an update from plugin. extracting info from payload
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:43 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:43 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:43 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:43 volumio volumio[1129]: info: ------------------------------ 41ms
Mar 27 20:39:43 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:43 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:43 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:43 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:43 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:43 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:47 volumio volumio[1129]: info: Preload queue cleared
Mar 27 20:39:47 volumio volumio[1129]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 27 20:39:47 volumio volumio[1129]: info: CoreStateMachine::ClearQueue
Mar 27 20:39:47 volumio volumio[1129]: info: CoreStateMachine::stop
Mar 27 20:39:47 volumio volumio[1129]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 27 20:39:47 volumio volumio[1129]: info: CoreStateMachine::stPlaybackTimer
Mar 27 20:39:47 volumio volumio[1129]: info: CoreStateMachine::updateTrackBlock
Mar 27 20:39:47 volumio volumio[1129]: info: CorePlayQueue::getTrackBlock
Mar 27 20:39:47 volumio volumio[1129]: info: CoreStateMachine::pushState
Mar 27 20:39:47 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:47 volumio volumio[1129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 27 20:39:47 volumio volumio[1129]: info: CoreCommandRouter::volumioPushState
Mar 27 20:39:47 volumio volumio[1129]: info: CoreStateMachine::serviceStop
Mar 27 20:39:47 volumio volumio[1129]: info: CorePlayQueue::getTrack 0
Mar 27 20:39:47 volumio volumio[1129]: info: CoreCommandRouter::serviceStop
Mar 27 20:39:47 volumio volumio[1129]: info: ControllerMpd::stop
Mar 27 20:39:47 volumio volumio[1129]: verbose: ControllerMpd::sendMpdCommand stop
Mar 27 20:39:47 volumio volumio[1129]: info: CorePlayQueue::clearPlayQueue
Mar 27 20:39:47 volumio volumio[1129]: info: CorePlayQueue::saveQueue
Mar 27 20:39:47 volumio volumio[1129]: info: CoreCommandRouter::volumioPushQueue
Mar 27 20:39:47 volumio volumio[1129]: info: CoreStateMachine::addQueueItems
Mar 27 20:39:47 volumio volumio[1129]: info: CorePlayQueue::addQueueItems
Mar 27 20:39:47 volumio volumio[1129]: info: Preload queue cleared
Mar 27 20:39:47 volumio volumio[1129]: info: Adding Item to queue: music-library/NAS/Data2/For Music player/Bee Gees
Mar 27 20:39:47 volumio volumio[1129]: info: Exploding uri music-library/NAS/Data2/For Music player/Bee Gees in service mpd
Mar 27 20:39:47 volumio volumio[1129]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FA1%20In%20The%20Morning.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/A1 In The Morning.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FA2%20Lonely%20Days.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/A2 Lonely Days.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FA3%20Massachusetts.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/A3 Massachusetts.dsf
Mar 27 20:39:47 volumio volumio[1129]: info:
Mar 27 20:39:47 volumio volumio[1129]: ---------------------------- MPD announces state update: player
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FA4%20To%20Love%20Somebody.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/A4 To Love Somebody.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FA5%20Turn%20Of%20The%20Century.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/A5 Turn Of The Century.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FA6%20World.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/A6 World.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FA7%20Country%20Woman.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/A7 Country Woman.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FB1%20Melody%20Fair.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/B1 Melody Fair.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FB2%20How%20Can%20You%20Mend%20A%20Broken%20Heart.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/B2 How Can You Mend A Broken Heart.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FB3%20Two%20Years%20On.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/B3 Two Years On.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FB4%20I%20Started%20A%20Joke.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/B4 I Started A Joke.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FB5%20Holiday.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/B5 Holiday.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FB6%20Man%20For%20All%20Seasons.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/B6 Man For All Seasons.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=The%20Bee%20Gees/In%20The%20Morning%2C(RSO-MW%202129%2CJapan)/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20In%20The%20Morning%20-%201975%2C(Japan)%2CDSF(tracks)%2CTAV(ART-9%2BNG%2BTangens)%2FB7%20First%20Of%20May.dsf&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - In The Morning - 1975,(Japan),DSF(tracks),TAV(ART-9+NG+Tangens)/B7 First Of May.dsf
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=Bee%20Gees/The%20Very%20Best%20Of%20The%20Bee%20Gees/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20The%20Very%20Best%20Of%20The%2FBee%20Gees%20-%20The%20Very%20Best%20Of%20The%20Bee%20Gees.cue&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - The Very Best Of The/Bee Gees - The Very Best Of The Bee Gees.cue
Mar 27 20:39:47 volumio volumio[1129]: info: ALBUMART /albumart?cacheid=400&web=Bee%20Gees/The%20Very%20Best%20Of%20The%20Bee%20Gees/extralarge&path=%2Fmnt%2FNAS%2FData2%2FFor%20Music%20player%2FBee%20Gees%2FBee%20Gees%20-%20The%20Very%20Best%20Of%20The%2FBee%20Gees%20-%20The%20Very%20Best%20Of%20The%20Bee%20Gees.cue&metadata=false
Mar 27 20:39:47 volumio volumio[1129]: info: URI /mnt/NAS/Data2/For Music player/Bee Gees/Bee Gees - The Very Best Of The/Bee Gees - The Very Best Of The Bee Gees.cue
Mar 27 20:39:47 volumio volumio[1129]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 27 20:39:47 volumio volumio[1129]: Error: Unable to resolve or reject the same promise twice
Mar 27 20:39:47 volumio volumio[1129]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Mar 27 20:39:47 volumio volumio[1129]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21
Mar 27 20:39:47 volumio volumio[1129]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Mar 27 20:39:47 volumio volumio[1129]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Mar 27 20:39:47 volumio volumio[1129]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Mar 27 20:39:47 volumio volumio[1129]: at Socket.emit (node:events:514:28)
Mar 27 20:39:47 volumio volumio[1129]: at addChunk (node:internal/streams/readable:343:12)
Mar 27 20:39:47 volumio volumio[1129]: at readableAddChunk (node:internal/streams/readable:312:11)
Mar 27 20:39:47 volumio volumio[1129]: at Readable.push (node:internal/streams/readable:253:10)
Mar 27 20:39:47 volumio volumio[1129]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Mar 27 20:39:47 volumio volumio[1129]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 27 20:39:48 volumio sudo[7043]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-27 20:38'
Mar 27 20:39:48 volumio sudo[7043]: 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="dc61260dec5515dafd2b634881860b4c46c919ff"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026"
VOLUMIO_VERSION="4.103"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"