-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Mon 2025-12-15 20:17:35 MSK. --
Dec 15 20:16:04 volumio volumio[981]: info: CorePlayQueue::getTrack 2
Dec 15 20:16:04 volumio volumio[981]: info: CorePlayQueue::getTrack 3
Dec 15 20:16:09 volumio volumio[981]: info:
Dec 15 20:16:09 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:16:09 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:16:09 volumio volumio[981]: info:
Dec 15 20:16:09 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:16:09 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:09 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:09 volumio volumio[981]: info:
Dec 15 20:16:09 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:16:09 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:16:09 volumio volumio[981]: info:
Dec 15 20:16:09 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:16:09 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:09 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:09 volumio volumio[981]: info:
Dec 15 20:16:09 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:16:09 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:16:09 volumio volumio[981]: info:
Dec 15 20:16:09 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:16:09 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:09 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:09 volumio volumio[981]: info:
Dec 15 20:16:09 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:16:09 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:16:09 volumio volumio[981]: info:
Dec 15 20:16:09 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:16:09 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:09 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:09 volumio volumio[981]: error: updateQueue error: null
Dec 15 20:16:09 volumio volumio[981]: error: updateQueue error: null
Dec 15 20:16:09 volumio volumio[981]: error: updateQueue error: null
Dec 15 20:16:09 volumio volumio[981]: error: updateQueue error: null
Dec 15 20:16:09 volumio volumio[981]: info: ------------------------------ 7ms
Dec 15 20:16:09 volumio volumio[981]: info: sendMpdCommand status took 5 milliseconds
Dec 15 20:16:09 volumio volumio[981]: info: ------------------------------ 5ms
Dec 15 20:16:09 volumio volumio[981]: info: sendMpdCommand status took 4 milliseconds
Dec 15 20:16:09 volumio volumio[981]: info: ------------------------------ 4ms
Dec 15 20:16:09 volumio volumio[981]: info: sendMpdCommand status took 4 milliseconds
Dec 15 20:16:09 volumio volumio[981]: info: ------------------------------ 4ms
Dec 15 20:16:09 volumio volumio[981]: info: sendMpdCommand status took 3 milliseconds
Dec 15 20:16:09 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:09 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:09 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:09 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:09 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:09 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 1
Dec 15 20:16:09 volumio kernel: xhci_hcd 0000:01:00.0: @0000000429518020 00000000 00000000 0e000000 02028001
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 2
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 2
Dec 15 20:16:09 volumio volumio[981]: 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}
Dec 15 20:16:09 volumio volumio[981]: verbose: CURRENT POSITION 2
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::stPlaybackTimer
Dec 15 20:16:09 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: 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}
Dec 15 20:16:09 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: No code
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: 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}
Dec 15 20:16:09 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: No code
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: 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}
Dec 15 20:16:09 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: No code
Dec 15 20:16:09 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:09 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:09 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:09 volumio volumio[981]: info: ------------------------------ 111ms
Dec 15 20:16:09 volumio volumio[981]: info: ------------------------------ 110ms
Dec 15 20:16:09 volumio volumio[981]: info: ------------------------------ 114ms
Dec 15 20:16:09 volumio volumio[981]: info: ------------------------------ 113ms
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:09 volumio sudo[5111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:16:09 volumio sudo[5111]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:09 volumio sudo[5114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:09 volumio sudo[5114]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:09 volumio sudo[5111]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:09 volumio systemd[1]: Stopping peppymeterbasic Daemon...
Dec 15 20:16:09 volumio systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM
Dec 15 20:16:09 volumio sudo[5117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:09 volumio sudo[5117]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:09 volumio sudo[5120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:09 volumio sudo[5120]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:09 volumio systemd[1]: peppymeterbasic.service: Succeeded.
Dec 15 20:16:09 volumio systemd[1]: Stopped peppymeterbasic Daemon.
Dec 15 20:16:09 volumio sudo[5123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:09 volumio sudo[5123]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:09 volumio sudo[5114]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:09 volumio sudo[5117]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:09 volumio sudo[5120]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:09 volumio sudo[5126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:09 volumio sudo[5123]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:09 volumio sudo[5126]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:09 volumio sudo[5129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:09 volumio sudo[5129]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:09 volumio sudo[5126]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:09 volumio sudo[5135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:09 volumio sudo[5135]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:09 volumio sudo[5133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:09 volumio sudo[5133]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:09 volumio sudo[5129]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:09 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:09 volumio sudo[5135]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:09 volumio sudo[5139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:09 volumio sudo[5139]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:09 volumio sudo[5133]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:10 volumio sudo[5139]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:10 volumio sudo[5142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:10 volumio sudo[5142]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:10 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:10 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:10 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:16:10 volumio volumio[981]: info: touch_display: Setting screensaver timeout to 12000 seconds.
Dec 15 20:16:10 volumio sudo[5142]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:10 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:22 volumio volumio[981]: verbose: New Socket.io Connection to 192.168.1.99:3000 from 192.168.1.91 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Dec 15 20:16:22 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 15 20:16:22 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 15 20:16:22 volumio volumio[981]: info: Discovery: Getting this device information
Dec 15 20:16:22 volumio volumio[981]: info: CoreCommandRouter::volumioGetState
Dec 15 20:16:22 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:22 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 15 20:16:23 volumio volumio[981]: verbose: New Socket.io Connection to 192.168.1.99 from 192.168.1.91 UA: Mozilla/5.0 (Linux; Android 15; DNP-NX9 Build/HONORDNP-N39; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/142.0.7444.171 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::volumioGetState
Dec 15 20:16:23 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 15 20:16:23 volumio volumio[981]: info: Received Get System Info
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 15 20:16:23 volumio volumio[981]: info: Discovery: Getting this device information
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::volumioGetState
Dec 15 20:16:23 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::volumioGetState
Dec 15 20:16:23 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:23 volumio volumio[981]: info: Listing playlists
Dec 15 20:16:23 volumio volumio[981]: info: CoreCommandRouter::volumioGetQueue
Dec 15 20:16:23 volumio volumio[981]: info: CoreStateMachine::getQueue
Dec 15 20:16:23 volumio volumio[981]: info: CorePlayQueue::getQueue
Dec 15 20:16:24 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 15 20:16:25 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand update
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:27 volumio volumio[981]: info:
Dec 15 20:16:27 volumio volumio[981]: ---------------------------- MPD announces state update: update
Dec 15 20:16:27 volumio volumio[981]: info: sendMpdCommand update took 5 milliseconds
Dec 15 20:16:27 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:27 volumio volumio[981]: info:
Dec 15 20:16:27 volumio volumio[981]: ---------------------------- MPD announces state update: update
Dec 15 20:16:27 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:27 volumio volumio[981]: info:
Dec 15 20:16:27 volumio volumio[981]: ---------------------------- MPD announces state update: update
Dec 15 20:16:27 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:27 volumio volumio[981]: info:
Dec 15 20:16:27 volumio volumio[981]: ---------------------------- MPD announces state update: update
Dec 15 20:16:27 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:27 volumio volumio[981]: info: sendMpdCommand status took 8 milliseconds
Dec 15 20:16:27 volumio volumio[981]: info: sendMpdCommand status took 7 milliseconds
Dec 15 20:16:27 volumio volumio[981]: info: sendMpdCommand status took 6 milliseconds
Dec 15 20:16:27 volumio volumio[981]: info: sendMpdCommand status took 5 milliseconds
Dec 15 20:16:27 volumio volumio[981]: info: sendMpdCommand status took 5 milliseconds
Dec 15 20:16:27 volumio volumio[981]: info: sendMpdCommand status took 5 milliseconds
Dec 15 20:16:27 volumio volumio[981]: info: sendMpdCommand status took 4 milliseconds
Dec 15 20:16:27 volumio volumio[981]: info: sendMpdCommand status took 3 milliseconds
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:27 volumio volumio[981]: info: Command Router : Notfying DB Updatetrue
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::Close All Modals sent
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:27 volumio volumio[981]: info: Command Router : Notfying DB Updatetrue
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::Close All Modals sent
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:27 volumio volumio[981]: info: Command Router : Notfying DB Updatetrue
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::Close All Modals sent
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:27 volumio volumio[981]: info: Command Router : Notfying DB Updatetrue
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::Close All Modals sent
Dec 15 20:16:27 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:27 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 15 20:16:27 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: No code
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 15 20:16:27 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: No code
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 15 20:16:27 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: No code
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 15 20:16:27 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: No code
Dec 15 20:16:27 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:27 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:27 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:27 volumio volumio[981]: info: ------------------------------ 286ms
Dec 15 20:16:27 volumio volumio[981]: info: ------------------------------ 285ms
Dec 15 20:16:27 volumio volumio[981]: info: ------------------------------ 284ms
Dec 15 20:16:27 volumio volumio[981]: info: ------------------------------ 284ms
Dec 15 20:16:27 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:27 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:27 volumio sudo[5231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:27 volumio sudo[5231]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:27 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:27 volumio sudo[5234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:27 volumio sudo[5234]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:27 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:27 volumio sudo[5231]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio sudo[5237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:28 volumio sudo[5237]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:28 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:28 volumio sudo[5240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:28 volumio sudo[5240]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:28 volumio sudo[5234]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:28 volumio sudo[5243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:28 volumio sudo[5243]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:28 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:28 volumio sudo[5237]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio sudo[5246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:28 volumio sudo[5246]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:28 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:28 volumio sudo[5240]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio sudo[5249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:28 volumio sudo[5249]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:28 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:28 volumio sudo[5252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:28 volumio sudo[5252]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:28 volumio sudo[5243]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:28 volumio sudo[5249]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio sudo[5255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:28 volumio sudo[5255]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:28 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:28 volumio sudo[5246]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio sudo[5258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:28 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:28 volumio sudo[5258]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:28 volumio sudo[5252]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio sudo[5255]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio sudo[5260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:28 volumio sudo[5260]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:28 volumio sudo[5264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:28 volumio sudo[5264]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:28 volumio sudo[5260]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio sudo[5264]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:28 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:28 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:28 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:28 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:28 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:28 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:28 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:28 volumio sudo[5258]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:28 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:29 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 15 20:16:31 volumio ntpd[785]: Soliciting pool server 92.241.12.152
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:31 volumio volumio[981]: info:
Dec 15 20:16:31 volumio volumio[981]: ---------------------------- MPD announces state update: update
Dec 15 20:16:31 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:31 volumio volumio[981]: info:
Dec 15 20:16:31 volumio volumio[981]: ---------------------------- MPD announces state update: update
Dec 15 20:16:31 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:31 volumio volumio[981]: info:
Dec 15 20:16:31 volumio volumio[981]: ---------------------------- MPD announces state update: update
Dec 15 20:16:31 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:31 volumio volumio[981]: info:
Dec 15 20:16:31 volumio volumio[981]: ---------------------------- MPD announces state update: update
Dec 15 20:16:31 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:16:31 volumio volumio[981]: info: sendMpdCommand status took 5 milliseconds
Dec 15 20:16:31 volumio volumio[981]: info: sendMpdCommand status took 4 milliseconds
Dec 15 20:16:31 volumio volumio[981]: info: sendMpdCommand status took 4 milliseconds
Dec 15 20:16:31 volumio volumio[981]: info: sendMpdCommand status took 4 milliseconds
Dec 15 20:16:31 volumio volumio[981]: info: sendMpdCommand status took 4 milliseconds
Dec 15 20:16:31 volumio volumio[981]: info: sendMpdCommand status took 3 milliseconds
Dec 15 20:16:31 volumio volumio[981]: info: sendMpdCommand status took 2 milliseconds
Dec 15 20:16:31 volumio volumio[981]: info: sendMpdCommand status took 2 milliseconds
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:31 volumio volumio[981]: info: Command Router : Notfying DB Updatefalse
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::Close All Modals sent
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:31 volumio volumio[981]: info: Command Router : Notfying DB Updatefalse
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::Close All Modals sent
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:31 volumio volumio[981]: info: Command Router : Notfying DB Updatefalse
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::Close All Modals sent
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:31 volumio volumio[981]: info: Command Router : Notfying DB Updatefalse
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::Close All Modals sent
Dec 15 20:16:31 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:16:31 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: 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}
Dec 15 20:16:31 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: No code
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: 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}
Dec 15 20:16:31 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: No code
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: 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}
Dec 15 20:16:31 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: No code
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: 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}
Dec 15 20:16:31 volumio volumio[981]: verbose: CURRENT POSITION 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: No code
Dec 15 20:16:31 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:16:31 volumio volumio[981]: info: CorePlayQueue::getTrack 0
Dec 15 20:16:31 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:16:31 volumio volumio[981]: info: ------------------------------ 241ms
Dec 15 20:16:31 volumio volumio[981]: info: ------------------------------ 241ms
Dec 15 20:16:31 volumio volumio[981]: info: ------------------------------ 241ms
Dec 15 20:16:31 volumio volumio[981]: info: ------------------------------ 240ms
Dec 15 20:16:31 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio sudo[5275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5275]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio sudo[5278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5278]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio sudo[5281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5281]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio sudo[5275]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio ntpd[785]: Soliciting pool server 92.255.126.18
Dec 15 20:16:32 volumio sudo[5281]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio sudo[5284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5284]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio sudo[5278]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio sudo[5286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5286]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio sudo[5289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5289]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio sudo[5284]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio sudo[5293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5293]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio sudo[5295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5295]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio sudo[5289]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio sudo[5299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5299]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio sudo[5286]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio sudo[5302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5302]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status stop
Dec 15 20:16:32 volumio sudo[5295]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio sudo[5293]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio sudo[5305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio sudo[5299]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio sudo[5307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Dec 15 20:16:32 volumio sudo[5307]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:16:32 volumio sudo[5302]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio sudo[5307]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:32 volumio sudo[5305]: pam_unix(sudo:session): session closed for user root
Dec 15 20:16:32 volumio volumio[981]: info: peppymeterbasic Daemon Stop
Dec 15 20:16:33 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 15 20:16:33 volumio volumio[981]: info: CURURI: artists://
Dec 15 20:16:33 volumio volumio[981]: info: Preload queue cleared
Dec 15 20:16:34 volumio ntpd[785]: Soliciting pool server 2001:678:68c::3
Dec 15 20:16:38 volumio ntpd[785]: Soliciting pool server 92.63.177.245
Dec 15 20:16:56 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 15 20:16:56 volumio volumio[981]: info: CURURI: artists://Judy%20Collins
Dec 15 20:16:57 volumio volumio[981]: info: Preload queue cleared
Dec 15 20:16:57 volumio volumio[981]: info: Preload queue cleared
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/1-Judy-Collins-Someday-Soon-K1QM5B.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/2-Judy-Collins-Since-You-Asked-4WI2KF.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/3-Judy-Collins-Both-Sides-Now-MNDZV0.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/4-Judy-Collins-Sons-Of-7HJS66.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/5-Judy-Collins-Suzanne-82W79K.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/6-Judy-Collins-Farewell-to-Tarwathie-N4D25Z.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/7-Judy-Collins-Who-Knows-Where-the-Time-Goes-PHKHIF.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/8-Judy-Collins-Sunny-Goodge-Street-ACAZXV.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/10-Judy-Collins-Albatross-23C1IZ.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/11-Judy-Collins-In-My-Life-6THU7B.flac
Dec 15 20:16:57 volumio volumio[981]: info: Preloading song: music-library/NAS/Музыка/12-Judy-Collins-Amazing-Grace-EG6P1S.flac
Dec 15 20:16:57 volumio volumio[981]: info: No valid Plugin REST Endpoint
Dec 15 20:16:57 volumio volumio[981]: info: No valid Plugin REST Endpoint
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/1-Judy-Collins-Someday-Soon-K1QM5B.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F1-Judy-Collins-Someday-Soon-K1QM5B.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/1-Judy-Collins-Someday-Soon-K1QM5B.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/2-Judy-Collins-Since-You-Asked-4WI2KF.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F2-Judy-Collins-Since-You-Asked-4WI2KF.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/2-Judy-Collins-Since-You-Asked-4WI2KF.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/3-Judy-Collins-Both-Sides-Now-MNDZV0.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F3-Judy-Collins-Both-Sides-Now-MNDZV0.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/3-Judy-Collins-Both-Sides-Now-MNDZV0.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/4-Judy-Collins-Sons-Of-7HJS66.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F4-Judy-Collins-Sons-Of-7HJS66.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/4-Judy-Collins-Sons-Of-7HJS66.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/5-Judy-Collins-Suzanne-82W79K.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F5-Judy-Collins-Suzanne-82W79K.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/5-Judy-Collins-Suzanne-82W79K.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/6-Judy-Collins-Farewell-to-Tarwathie-N4D25Z.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F6-Judy-Collins-Farewell-to-Tarwathie-N4D25Z.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/6-Judy-Collins-Farewell-to-Tarwathie-N4D25Z.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/7-Judy-Collins-Who-Knows-Where-the-Time-Goes-PHKHIF.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F7-Judy-Collins-Who-Knows-Where-the-Time-Goes-PHKHIF.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/7-Judy-Collins-Who-Knows-Where-the-Time-Goes-PHKHIF.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/8-Judy-Collins-Sunny-Goodge-Street-ACAZXV.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F8-Judy-Collins-Sunny-Goodge-Street-ACAZXV.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/8-Judy-Collins-Sunny-Goodge-Street-ACAZXV.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F9-Judy-Collins-My-Father-PE608X.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/10-Judy-Collins-Albatross-23C1IZ.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F10-Judy-Collins-Albatross-23C1IZ.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/10-Judy-Collins-Albatross-23C1IZ.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/11-Judy-Collins-In-My-Life-6THU7B.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F11-Judy-Collins-In-My-Life-6THU7B.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/11-Judy-Collins-In-My-Life-6THU7B.flac
Dec 15 20:16:57 volumio volumio[981]: info: Exploding uri music-library/NAS/Музыка/12-Judy-Collins-Amazing-Grace-EG6P1S.flac in service mpd
Dec 15 20:16:57 volumio volumio[981]: info: ALBUMART /albumart?cacheid=47&web=Judy%20Collins/Colors%20Of%20The%20Day%2C%20The%20Best%20Of%20Judy%20Collins/extralarge&path=%2Fmnt%2FNAS%2F%D0%9C%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F12-Judy-Collins-Amazing-Grace-EG6P1S.flac&metadata=false
Dec 15 20:16:57 volumio volumio[981]: info: URI /mnt/NAS/Музыка/12-Judy-Collins-Amazing-Grace-EG6P1S.flac
Dec 15 20:17:01 volumio volumio[981]: info: Preload queue cleared
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::ClearQueue
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::stop
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::clearPlayQueue
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::saveQueue
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioPushQueue
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::addQueueItems
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::addQueueItems
Dec 15 20:17:01 volumio volumio[981]: info: Preload queue cleared
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/1-Judy-Collins-Someday-Soon-K1QM5B.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/1-Judy-Collins-Someday-Soon-K1QM5B.flac
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/2-Judy-Collins-Since-You-Asked-4WI2KF.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/2-Judy-Collins-Since-You-Asked-4WI2KF.flac
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/3-Judy-Collins-Both-Sides-Now-MNDZV0.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/3-Judy-Collins-Both-Sides-Now-MNDZV0.flac
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/4-Judy-Collins-Sons-Of-7HJS66.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/4-Judy-Collins-Sons-Of-7HJS66.flac
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/5-Judy-Collins-Suzanne-82W79K.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/5-Judy-Collins-Suzanne-82W79K.flac
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/6-Judy-Collins-Farewell-to-Tarwathie-N4D25Z.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/6-Judy-Collins-Farewell-to-Tarwathie-N4D25Z.flac
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/7-Judy-Collins-Who-Knows-Where-the-Time-Goes-PHKHIF.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/7-Judy-Collins-Who-Knows-Where-the-Time-Goes-PHKHIF.flac
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/8-Judy-Collins-Sunny-Goodge-Street-ACAZXV.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/8-Judy-Collins-Sunny-Goodge-Street-ACAZXV.flac
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioPushQueue
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::saveQueue
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::updateTrackBlock
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrackBlock
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioPlay
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::play index 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::addQueueItems
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::addQueueItems
Dec 15 20:17:01 volumio volumio[981]: info: Preload queue cleared
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/10-Judy-Collins-Albatross-23C1IZ.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/10-Judy-Collins-Albatross-23C1IZ.flac
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/11-Judy-Collins-In-My-Life-6THU7B.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/11-Judy-Collins-In-My-Life-6THU7B.flac
Dec 15 20:17:01 volumio volumio[981]: info: Adding Item to queue: music-library/NAS/Музыка/12-Judy-Collins-Amazing-Grace-EG6P1S.flac
Dec 15 20:17:01 volumio volumio[981]: info: Using cached record of: music-library/NAS/Музыка/12-Judy-Collins-Amazing-Grace-EG6P1S.flac
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::stop
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioPushQueue
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::saveQueue
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::play index undefined
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::updateTrackBlock
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrackBlock
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::startPlaybackTimer
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::clearAddPlayTracks NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand stop
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand stop took 4 milliseconds
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand clear
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:17:01 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand clear took 1 milliseconds
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand add "NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac"
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:17:01 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:17:01 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:17:01 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:17:01 volumio volumio[981]: error: updateQueue error: null
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:17:01 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:17:01 volumio volumio[981]: info: ------------------------------ 5ms
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand add "NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac" took 4 milliseconds
Dec 15 20:17:01 volumio volumio[981]: info: ------------------------------ 3ms
Dec 15 20:17:01 volumio volumio[981]: info: ------------------------------ 3ms
Dec 15 20:17:01 volumio volumio[981]: info: ------------------------------ 2ms
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand play
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:17:01 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:17:01 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces system playlist update
Dec 15 20:17:01 volumio volumio[981]: info: Ignoring MPD Status Update
Dec 15 20:17:01 volumio volumio[981]: info: ------------------------------ 4ms
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand play took 4 milliseconds
Dec 15 20:17:01 volumio volumio[981]: info: ------------------------------ 3ms
Dec 15 20:17:01 volumio volumio[981]: info: ------------------------------ 3ms
Dec 15 20:17:01 volumio volumio[981]: info: ------------------------------ 2ms
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand status took 11 milliseconds
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand status took 18 milliseconds
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand status took 16 milliseconds
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand status took 15 milliseconds
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand playlistinfo took 7 milliseconds
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Father","artist":"Judy Collins","album":"Colors Of The Day, The Best Of Judy Collins","uri":"NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac","trackType":"flac"}
Dec 15 20:17:01 volumio volumio[981]: verbose: CURRENT POSITION 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::syncState stateService play
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop
Dec 15 20:17:01 volumio volumio[981]: info: ------------------------------ 22ms
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:17:01 volumio volumio[981]: info:
Dec 15 20:17:01 volumio volumio[981]: ---------------------------- MPD announces state update: player
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::getState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand status took 8 milliseconds
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand playlistinfo took 7 milliseconds
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand status took 5 milliseconds
Dec 15 20:17:01 volumio volumio[981]: info: sendMpdCommand status took 4 milliseconds
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::parseState
Dec 15 20:17:01 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Father","artist":"Judy Collins","album":"Colors Of The Day, The Best Of Judy Collins","uri":"NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac","trackType":"flac"}
Dec 15 20:17:01 volumio volumio[981]: verbose: CURRENT POSITION 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::syncState stateService play
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play
Dec 15 20:17:01 volumio volumio[981]: info: Received an update from plugin. extracting info from payload
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Father","artist":"Judy Collins","album":"Colors Of The Day, The Best Of Judy Collins","uri":"NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac","trackType":"flac"}
Dec 15 20:17:01 volumio volumio[981]: verbose: CURRENT POSITION 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::syncState stateService play
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play
Dec 15 20:17:01 volumio volumio[981]: info: Received an update from plugin. extracting info from payload
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:01 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Father","artist":"Judy Collins","album":"Colors Of The Day, The Best Of Judy Collins","uri":"NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac","trackType":"flac"}
Dec 15 20:17:01 volumio volumio[981]: verbose: CURRENT POSITION 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::syncState stateService play
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play
Dec 15 20:17:01 volumio volumio[981]: info: Received an update from plugin. extracting info from payload
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:01 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:01 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:01 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:02 volumio volumio[981]: info: ------------------------------ 111ms
Dec 15 20:17:02 volumio volumio[981]: info: sendMpdCommand playlistinfo took 88 milliseconds
Dec 15 20:17:02 volumio volumio[981]: info: sendMpdCommand playlistinfo took 89 milliseconds
Dec 15 20:17:02 volumio volumio[981]: info: sendMpdCommand playlistinfo took 88 milliseconds
Dec 15 20:17:02 volumio volumio[981]: info: sendMpdCommand playlistinfo took 89 milliseconds
Dec 15 20:17:02 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo
Dec 15 20:17:02 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo
Dec 15 20:17:02 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo
Dec 15 20:17:02 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo
Dec 15 20:17:02 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Father","artist":"Judy Collins","album":"Colors Of The Day, The Best Of Judy Collins","uri":"NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac","trackType":"flac"}
Dec 15 20:17:02 volumio volumio[981]: verbose: CURRENT POSITION 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::syncState stateService play
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play
Dec 15 20:17:02 volumio volumio[981]: info: Received an update from plugin. extracting info from payload
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:02 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Father","artist":"Judy Collins","album":"Colors Of The Day, The Best Of Judy Collins","uri":"NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac","trackType":"flac"}
Dec 15 20:17:02 volumio volumio[981]: verbose: CURRENT POSITION 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::syncState stateService play
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play
Dec 15 20:17:02 volumio volumio[981]: info: Received an update from plugin. extracting info from payload
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:02 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Father","artist":"Judy Collins","album":"Colors Of The Day, The Best Of Judy Collins","uri":"NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac","trackType":"flac"}
Dec 15 20:17:02 volumio volumio[981]: verbose: CURRENT POSITION 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::syncState stateService play
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play
Dec 15 20:17:02 volumio volumio[981]: info: Received an update from plugin. extracting info from payload
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:02 volumio volumio[981]: info: ControllerMpd::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::servicePushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":303,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Father","artist":"Judy Collins","album":"Colors Of The Day, The Best Of Judy Collins","uri":"NAS/Музыка/9-Judy-Collins-My-Father-PE608X.flac","trackType":"flac"}
Dec 15 20:17:02 volumio volumio[981]: verbose: CURRENT POSITION 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::syncState stateService play
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play
Dec 15 20:17:02 volumio volumio[981]: info: Received an update from plugin. extracting info from payload
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:02 volumio volumio[981]: info: CoreStateMachine::pushState
Dec 15 20:17:02 volumio volumio[981]: info: CorePlayQueue::getTrack 8
Dec 15 20:17:02 volumio volumio[981]: info: CoreCommandRouter::volumioPushState
Dec 15 20:17:02 volumio volumio[981]: info: ------------------------------ 301ms
Dec 15 20:17:02 volumio volumio[981]: info: ------------------------------ 298ms
Dec 15 20:17:02 volumio volumio[981]: info: ------------------------------ 299ms
Dec 15 20:17:02 volumio volumio[981]: info: ------------------------------ 298ms
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5366]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5369]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio systemd[1]: Started peppymeterbasic Daemon.
Dec 15 20:17:02 volumio sudo[5372]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio sudo[5375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5375]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio sudo[5379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5379]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5383]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5366]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5386]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio sudo[5372]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio sudo[5369]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio sudo[5375]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio sudo[5388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5388]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5379]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio sudo[5383]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio sudo[5392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5392]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio sudo[5386]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio sudo[5388]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5395]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio sudo[5392]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5395]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio sudo[5398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5398]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5400]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio volumio[981]: info: PeppyMeterBasic ---peppymeterbasic status play
Dec 15 20:17:02 volumio sudo[5398]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio sudo[5404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5400]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio sudo[5404]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio sudo[5406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Dec 15 20:17:02 volumio sudo[5406]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 15 20:17:02 volumio sudo[5404]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio sudo[5406]: pam_unix(sudo:session): session closed for user root
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: peppymeterbasic Daemon Started
Dec 15 20:17:02 volumio volumio[981]: info: touch_display: Setting screensaver timeout to 0 seconds.
Dec 15 20:17:34 volumio volumio[981]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 15 20:17:34 volumio volumio[981]: Error: Client network socket disconnected before secure TLS connection was established
Dec 15 20:17:34 volumio volumio[981]: at connResetException (internal/errors.js:607:14)
Dec 15 20:17:34 volumio volumio[981]: at TLSSocket.onConnectEnd (_tls_wrap.js:1544:19)
Dec 15 20:17:34 volumio volumio[981]: at TLSSocket.emit (events.js:327:22)
Dec 15 20:17:34 volumio volumio[981]: at endReadableNT (internal/streams/readable.js:1327:12)
Dec 15 20:17:34 volumio volumio[981]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Dec 15 20:17:34 volumio volumio[981]: code: 'ECONNRESET',
Dec 15 20:17:34 volumio volumio[981]: path: null,
Dec 15 20:17:34 volumio volumio[981]: host: 'assets.fanart.tv',
Dec 15 20:17:34 volumio volumio[981]: port: 443,
Dec 15 20:17:34 volumio volumio[981]: localAddress: undefined
Dec 15 20:17:34 volumio volumio[981]: }
Dec 15 20:17:34 volumio volumio[981]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 15 20:17:35 volumio sudo[5578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-15 20:16
Dec 15 20:17:35 volumio sudo[5578]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="5d50cd80bebce60dddccd7f5e813d656e28ca4cd"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="7840f283c310c38bfe939a4c485727a6ff6a0ce1"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 21 Oct 2025 03:46:47 PM CEST"
VOLUMIO_VERSION="3.866"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e2f3a8aca3147ba51b5da8167dd6ff8"