-- Logs begin at Thu 2019-02-14 12:12:05 EET, end at Sun 2025-12-21 13:27:54 EET. --
Dec 21 13:26:34 volumio volumio[7908]: info: CoreCommandRouter::volumioPlay
Dec 21 13:26:34 volumio volumio[7908]: info: CoreStateMachine::play index undefined
Dec 21 13:26:34 volumio volumio[7908]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 21 13:26:34 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:34 volumio volumio[7908]: info: CoreStateMachine::startPlaybackTimer
Dec 21 13:26:34 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:34 volumio volumio[7908]: info: [1766316394424] ControllerWebradio::clearAddPlayTrack
Dec 21 13:26:34 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand stop
Dec 21 13:26:34 volumio volumio[7908]: info: sendMpdCommand stop took 14 milliseconds
Dec 21 13:26:34 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand clear
Dec 21 13:26:34 volumio volumio[7908]: info:
Dec 21 13:26:34 volumio volumio[7908]: ---------------------------- MPD announces system playlist update
Dec 21 13:26:34 volumio volumio[7908]: info: Ignoring MPD Status Update
Dec 21 13:26:34 volumio volumio[7908]: info: sendMpdCommand clear took 21 milliseconds
Dec 21 13:26:34 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand load "http://live.dancemusic.ro:7000/"
Dec 21 13:26:34 volumio volumio[7908]: info:
Dec 21 13:26:34 volumio volumio[7908]: ---------------------------- MPD announces system playlist update
Dec 21 13:26:34 volumio volumio[7908]: info: Ignoring MPD Status Update
Dec 21 13:26:34 volumio volumio[7908]: error: updateQueue error: null
Dec 21 13:26:34 volumio volumio[7908]: info: ------------------------------ 83ms
Dec 21 13:26:35 volumio volumio[7908]: error: updateQueue error: null
Dec 21 13:26:35 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand add "http://live.dancemusic.ro:7000/"
Dec 21 13:26:35 volumio volumio[7908]: info: ------------------------------ 1170ms
Dec 21 13:26:35 volumio volumio[7908]: info:
Dec 21 13:26:35 volumio volumio[7908]: ---------------------------- MPD announces system playlist update
Dec 21 13:26:35 volumio volumio[7908]: info: Ignoring MPD Status Update
Dec 21 13:26:35 volumio volumio[7908]: info: sendMpdCommand add "http://live.dancemusic.ro:7000/" took 24 milliseconds
Dec 21 13:26:35 volumio volumio[7908]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 21 13:26:35 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand play
Dec 21 13:26:35 volumio volumio[7908]: info:
Dec 21 13:26:35 volumio volumio[7908]: ---------------------------- MPD announces system playlist update
Dec 21 13:26:35 volumio volumio[7908]: info: Ignoring MPD Status Update
Dec 21 13:26:35 volumio volumio[7908]: info: ------------------------------ 62ms
Dec 21 13:26:35 volumio volumio[7908]: info: sendMpdCommand play took 56 milliseconds
Dec 21 13:26:35 volumio volumio[7908]: info: ------------------------------ 66ms
Dec 21 13:26:36 volumio volumio[7908]: info:
Dec 21 13:26:36 volumio volumio[7908]: ---------------------------- MPD announces state update: player
Dec 21 13:26:36 volumio volumio[7908]: info: ControllerMpd::getState
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand status
Dec 21 13:26:36 volumio volumio[7908]: info:
Dec 21 13:26:36 volumio volumio[7908]: ---------------------------- MPD announces state update: player
Dec 21 13:26:36 volumio volumio[7908]: info: ControllerMpd::getState
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand status
Dec 21 13:26:36 volumio volumio[7908]: info:
Dec 21 13:26:36 volumio volumio[7908]: ---------------------------- MPD announces state update: player
Dec 21 13:26:36 volumio volumio[7908]: info: ControllerMpd::getState
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand status
Dec 21 13:26:36 volumio volumio[7908]: info: sendMpdCommand status took 67 milliseconds
Dec 21 13:26:36 volumio volumio[7908]: info: sendMpdCommand status took 57 milliseconds
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::parseState
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::parseState
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 21 13:26:36 volumio volumio[7908]: info:
Dec 21 13:26:36 volumio volumio[7908]: ---------------------------- MPD announces state update: player
Dec 21 13:26:36 volumio volumio[7908]: info: ControllerMpd::getState
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand status
Dec 21 13:26:36 volumio volumio[7908]: info:
Dec 21 13:26:36 volumio volumio[7908]: ---------------------------- MPD announces system playlist update
Dec 21 13:26:36 volumio volumio[7908]: info: Ignoring MPD Status Update
Dec 21 13:26:36 volumio volumio[7908]: info:
Dec 21 13:26:36 volumio volumio[7908]: ---------------------------- MPD announces state update: player
Dec 21 13:26:36 volumio volumio[7908]: info: sendMpdCommand status took 163 milliseconds
Dec 21 13:26:36 volumio volumio[7908]: info: sendMpdCommand playlistinfo took 119 milliseconds
Dec 21 13:26:36 volumio volumio[7908]: info: sendMpdCommand playlistinfo took 105 milliseconds
Dec 21 13:26:36 volumio volumio[7908]: info: ControllerMpd::getState
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand status
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::parseState
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::parseTrackInfo
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::parseTrackInfo
Dec 21 13:26:36 volumio volumio[7908]: info: ControllerMpd::pushState
Dec 21 13:26:36 volumio volumio[7908]: info: CoreCommandRouter::servicePushState
Dec 21 13:26:36 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:36 volumio volumio[7908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://live.dancemusic.ro:7000/","trackType":"ro:7000/"}
Dec 21 13:26:36 volumio volumio[7908]: verbose: CURRENT POSITION 0
Dec 21 13:26:36 volumio volumio[7908]: info: CoreStateMachine::syncState stateService play
Dec 21 13:26:36 volumio volumio[7908]: info: CoreStateMachine::syncState currentStatus stop
Dec 21 13:26:36 volumio volumio[7908]: info: ControllerMpd::pushState
Dec 21 13:26:36 volumio volumio[7908]: info: CoreCommandRouter::servicePushState
Dec 21 13:26:36 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:36 volumio volumio[7908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://live.dancemusic.ro:7000/","trackType":"ro:7000/"}
Dec 21 13:26:36 volumio volumio[7908]: verbose: CURRENT POSITION 0
Dec 21 13:26:36 volumio volumio[7908]: info: CoreStateMachine::syncState stateService play
Dec 21 13:26:36 volumio volumio[7908]: info: CoreStateMachine::syncState currentStatus play
Dec 21 13:26:36 volumio volumio[7908]: info: Received an update from plugin. extracting info from payload
Dec 21 13:26:36 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:36 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 21 13:26:36 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:36 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:36 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:36 volumio volumio[7908]: info: ------------------------------ 663ms
Dec 21 13:26:36 volumio volumio[7908]: info: ------------------------------ 838ms
Dec 21 13:26:36 volumio volumio[7908]: info:
Dec 21 13:26:36 volumio volumio[7908]: ---------------------------- MPD announces system playlist update
Dec 21 13:26:36 volumio volumio[7908]: info: Ignoring MPD Status Update
Dec 21 13:26:36 volumio volumio[7908]: info:
Dec 21 13:26:36 volumio volumio[7908]: ---------------------------- MPD announces state update: player
Dec 21 13:26:36 volumio volumio[7908]: info: ControllerMpd::getState
Dec 21 13:26:36 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand status
Dec 21 13:26:37 volumio volumio[7908]: info:
Dec 21 13:26:37 volumio volumio[7908]: ---------------------------- MPD announces system playlist update
Dec 21 13:26:37 volumio volumio[7908]: info: Ignoring MPD Status Update
Dec 21 13:26:37 volumio volumio[7908]: info:
Dec 21 13:26:37 volumio volumio[7908]: ---------------------------- MPD announces state update: player
Dec 21 13:26:37 volumio volumio[7908]: info: sendMpdCommand status took 864 milliseconds
Dec 21 13:26:37 volumio volumio[7908]: info: ------------------------------ 859ms
Dec 21 13:26:37 volumio volumio[7908]: info: ControllerMpd::getState
Dec 21 13:26:37 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand status
Dec 21 13:26:37 volumio volumio[7908]: info: sendMpdCommand status took 818 milliseconds
Dec 21 13:26:37 volumio volumio[7908]: info: sendMpdCommand playlistinfo took 810 milliseconds
Dec 21 13:26:37 volumio volumio[7908]: info: ------------------------------ 222ms
Dec 21 13:26:37 volumio volumio[7908]: info: sendMpdCommand status took 197 milliseconds
Dec 21 13:26:37 volumio volumio[7908]: verbose: ControllerMpd::parseState
Dec 21 13:26:37 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 21 13:26:37 volumio volumio[7908]: verbose: ControllerMpd::parseState
Dec 21 13:26:37 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 21 13:26:37 volumio volumio[7908]: verbose: ControllerMpd::parseTrackInfo
Dec 21 13:26:37 volumio volumio[7908]: verbose: ControllerMpd::parseState
Dec 21 13:26:37 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 21 13:26:37 volumio volumio[7908]: info: ControllerMpd::pushState
Dec 21 13:26:37 volumio volumio[7908]: info: CoreCommandRouter::servicePushState
Dec 21 13:26:37 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:37 volumio volumio[7908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Farhad Jahangiri - Ali Gian ( Hayit Murat Remix )","artist":"Deep House Radio - Bucharest - Romania -","album":null,"uri":"http://live.dancemusic.ro:7000/","trackType":"ro:7000/"}
Dec 21 13:26:37 volumio volumio[7908]: verbose: CURRENT POSITION 0
Dec 21 13:26:37 volumio volumio[7908]: info: CoreStateMachine::syncState stateService play
Dec 21 13:26:37 volumio volumio[7908]: info: CoreStateMachine::syncState currentStatus play
Dec 21 13:26:37 volumio volumio[7908]: info: Received an update from plugin. extracting info from payload
Dec 21 13:26:37 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:37 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 21 13:26:37 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:37 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:37 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:37 volumio volumio[7908]: info: ------------------------------ 1505ms
Dec 21 13:26:37 volumio volumio[7908]: info:
Dec 21 13:26:37 volumio volumio[7908]: ---------------------------- MPD announces system playlist update
Dec 21 13:26:37 volumio volumio[7908]: info: Ignoring MPD Status Update
Dec 21 13:26:37 volumio volumio[7908]: info:
Dec 21 13:26:37 volumio volumio[7908]: ---------------------------- MPD announces state update: player
Dec 21 13:26:37 volumio volumio[7908]: info: ControllerMpd::getState
Dec 21 13:26:37 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand status
Dec 21 13:26:37 volumio volumio[7908]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Dec 21 13:26:37 volumio volumio[7908]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Dec 21 13:26:38 volumio volumio[7908]: info: ------------------------------ 944ms
Dec 21 13:26:38 volumio volumio[7908]: info: sendMpdCommand status took 894 milliseconds
Dec 21 13:26:38 volumio volumio[7908]: info: sendMpdCommand playlistinfo took 860 milliseconds
Dec 21 13:26:38 volumio volumio[7908]: info: sendMpdCommand playlistinfo took 839 milliseconds
Dec 21 13:26:38 volumio volumio[7908]: info: sendMpdCommand playlistinfo took 824 milliseconds
Dec 21 13:26:38 volumio volumio[7908]: info: ------------------------------ 412ms
Dec 21 13:26:38 volumio volumio[7908]: info: sendMpdCommand status took 386 milliseconds
Dec 21 13:26:38 volumio volumio[7908]: verbose: ControllerMpd::parseState
Dec 21 13:26:38 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 21 13:26:38 volumio volumio[7908]: verbose: ControllerMpd::parseTrackInfo
Dec 21 13:26:38 volumio volumio[7908]: verbose: ControllerMpd::parseTrackInfo
Dec 21 13:26:38 volumio volumio[7908]: verbose: ControllerMpd::parseState
Dec 21 13:26:38 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 21 13:26:38 volumio volumio[7908]: info: ControllerMpd::pushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreCommandRouter::servicePushState
Dec 21 13:26:38 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:38 volumio volumio[7908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":720,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Farhad Jahangiri - Ali Gian ( Hayit Murat Remix )","artist":"Deep House Radio - Bucharest - Romania -","album":null,"uri":"http://live.dancemusic.ro:7000/","trackType":"ro:7000/"}
Dec 21 13:26:38 volumio volumio[7908]: verbose: CURRENT POSITION 0
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::syncState stateService play
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::syncState currentStatus play
Dec 21 13:26:38 volumio volumio[7908]: info: Received an update from plugin. extracting info from payload
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 21 13:26:38 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:38 volumio volumio[7908]: info: ControllerMpd::pushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreCommandRouter::servicePushState
Dec 21 13:26:38 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:38 volumio volumio[7908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":977,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Farhad Jahangiri - Ali Gian ( Hayit Murat Remix )","artist":"Deep House Radio - Bucharest - Romania -","album":null,"uri":"http://live.dancemusic.ro:7000/","trackType":"ro:7000/"}
Dec 21 13:26:38 volumio volumio[7908]: verbose: CURRENT POSITION 0
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::syncState stateService play
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::syncState currentStatus play
Dec 21 13:26:38 volumio volumio[7908]: info: Received an update from plugin. extracting info from payload
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:38 volumio volumio[7908]: info: ControllerMpd::pushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreCommandRouter::servicePushState
Dec 21 13:26:38 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:38 volumio volumio[7908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1606,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Farhad Jahangiri - Ali Gian ( Hayit Murat Remix )","artist":"Deep House Radio - Bucharest - Romania -","album":null,"uri":"http://live.dancemusic.ro:7000/","trackType":"ro:7000/"}
Dec 21 13:26:38 volumio volumio[7908]: verbose: CURRENT POSITION 0
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::syncState stateService play
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::syncState currentStatus play
Dec 21 13:26:38 volumio volumio[7908]: info: Received an update from plugin. extracting info from payload
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:38 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:39 volumio volumio[7908]: info: ------------------------------ 2804ms
Dec 21 13:26:39 volumio volumio[7908]: info: ------------------------------ 2758ms
Dec 21 13:26:39 volumio volumio[7908]: info: ------------------------------ 2104ms
Dec 21 13:26:39 volumio volumio[7908]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Dec 21 13:26:39 volumio volumio[7908]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Dec 21 13:26:39 volumio volumio[7908]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Dec 21 13:26:39 volumio volumio[7908]: info: sendMpdCommand playlistinfo took 1106 milliseconds
Dec 21 13:26:39 volumio volumio[7908]: info: sendMpdCommand playlistinfo took 1078 milliseconds
Dec 21 13:26:39 volumio volumio[7908]: verbose: ControllerMpd::parseTrackInfo
Dec 21 13:26:39 volumio volumio[7908]: verbose: ControllerMpd::parseTrackInfo
Dec 21 13:26:39 volumio volumio[7908]: info: ControllerMpd::pushState
Dec 21 13:26:39 volumio volumio[7908]: info: CoreCommandRouter::servicePushState
Dec 21 13:26:39 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:39 volumio volumio[7908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Farhad Jahangiri - Ali Gian ( Hayit Murat Remix )","artist":"Deep House Radio - Bucharest - Romania -","album":null,"uri":"http://live.dancemusic.ro:7000/","trackType":"ro:7000/"}
Dec 21 13:26:39 volumio volumio[7908]: verbose: CURRENT POSITION 0
Dec 21 13:26:39 volumio volumio[7908]: info: CoreStateMachine::syncState stateService play
Dec 21 13:26:39 volumio volumio[7908]: info: CoreStateMachine::syncState currentStatus play
Dec 21 13:26:39 volumio volumio[7908]: info: Received an update from plugin. extracting info from payload
Dec 21 13:26:39 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:39 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 21 13:26:39 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:39 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:39 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:39 volumio volumio[7908]: info: ControllerMpd::pushState
Dec 21 13:26:39 volumio volumio[7908]: info: CoreCommandRouter::servicePushState
Dec 21 13:26:39 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:39 volumio volumio[7908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2360,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Farhad Jahangiri - Ali Gian ( Hayit Murat Remix )","artist":"Deep House Radio - Bucharest - Romania -","album":null,"uri":"http://live.dancemusic.ro:7000/","trackType":"ro:7000/"}
Dec 21 13:26:39 volumio volumio[7908]: verbose: CURRENT POSITION 0
Dec 21 13:26:39 volumio volumio[7908]: info: CoreStateMachine::syncState stateService play
Dec 21 13:26:39 volumio volumio[7908]: info: CoreStateMachine::syncState currentStatus play
Dec 21 13:26:39 volumio volumio[7908]: info: Received an update from plugin. extracting info from payload
Dec 21 13:26:39 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:39 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:39 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:39 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:39 volumio volumio[7908]: info: ------------------------------ 2471ms
Dec 21 13:26:39 volumio volumio[7908]: info: ------------------------------ 1931ms
Dec 21 13:26:39 volumio volumio[7908]: info: CoreCommandRouter::volumioGetState
Dec 21 13:26:39 volumio volumio[7908]: info: CoreCommandRouter::volumioGetState
Dec 21 13:26:39 volumio volumio[7908]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Dec 21 13:26:39 volumio volumio[7908]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Dec 21 13:26:39 volumio volumio[7908]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Dec 21 13:26:54 volumio volumio[7908]: info: CoreCommandRouter::volumioStop
Dec 21 13:26:54 volumio volumio[7908]: info: CoreStateMachine::stop
Dec 21 13:26:54 volumio volumio[7908]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 21 13:26:54 volumio volumio[7908]: info: CoreStateMachine::stPlaybackTimer
Dec 21 13:26:54 volumio volumio[7908]: info: CoreStateMachine::updateTrackBlock
Dec 21 13:26:54 volumio volumio[7908]: info: CorePlayQueue::getTrackBlock
Dec 21 13:26:54 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:54 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:54 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 21 13:26:54 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:54 volumio volumio[7908]: info: CoreStateMachine::serviceStop
Dec 21 13:26:54 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:54 volumio volumio[7908]: info: CoreCommandRouter::serviceStop
Dec 21 13:26:54 volumio volumio[7908]: info: [1766316414366] ControllerWebradio::stop
Dec 21 13:26:54 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand stop
Dec 21 13:26:54 volumio volumio[7908]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Dec 21 13:26:54 volumio volumio[7908]: info:
Dec 21 13:26:54 volumio volumio[7908]: ---------------------------- MPD announces state update: player
Dec 21 13:26:54 volumio volumio[7908]: info: sendMpdCommand stop took 209 milliseconds
Dec 21 13:26:54 volumio volumio[7908]: info: ControllerMpd::getState
Dec 21 13:26:54 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand status
Dec 21 13:26:54 volumio volumio[7908]: info: sendMpdCommand status took 7 milliseconds
Dec 21 13:26:54 volumio volumio[7908]: verbose: ControllerMpd::parseState
Dec 21 13:26:54 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 21 13:26:54 volumio volumio[7908]: info:
Dec 21 13:26:54 volumio volumio[7908]: ---------------------------- MPD announces state update: player
Dec 21 13:26:54 volumio volumio[7908]: info: ControllerMpd::getState
Dec 21 13:26:54 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand status
Dec 21 13:26:54 volumio volumio[7908]: info: sendMpdCommand playlistinfo took 26 milliseconds
Dec 21 13:26:54 volumio volumio[7908]: info: sendMpdCommand status took 14 milliseconds
Dec 21 13:26:54 volumio volumio[7908]: verbose: ControllerMpd::parseTrackInfo
Dec 21 13:26:54 volumio volumio[7908]: verbose: ControllerMpd::parseState
Dec 21 13:26:54 volumio volumio[7908]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 21 13:26:54 volumio volumio[7908]: info: ControllerMpd::pushState
Dec 21 13:26:54 volumio volumio[7908]: info: CoreCommandRouter::servicePushState
Dec 21 13:26:54 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:54 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:54 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 21 13:26:54 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:54 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:54 volumio volumio[7908]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Dec 21 13:26:54 volumio volumio[7908]: info: ------------------------------ 182ms
Dec 21 13:26:54 volumio volumio[7908]: info: sendMpdCommand playlistinfo took 116 milliseconds
Dec 21 13:26:54 volumio volumio[7908]: verbose: ControllerMpd::parseTrackInfo
Dec 21 13:26:54 volumio volumio[7908]: info: ControllerMpd::pushState
Dec 21 13:26:54 volumio volumio[7908]: info: CoreCommandRouter::servicePushState
Dec 21 13:26:54 volumio volumio[7908]: info: CoreStateMachine::pushState
Dec 21 13:26:54 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:54 volumio volumio[7908]: info: CoreCommandRouter::volumioPushState
Dec 21 13:26:54 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:26:54 volumio volumio[7908]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Dec 21 13:26:54 volumio volumio[7908]: info: ------------------------------ 261ms
Dec 21 13:26:54 volumio volumio[7908]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50
Dec 21 13:27:16 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 21 13:27:16 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Dec 21 13:27:34 volumio volumio[7908]: info: Enabling plugin fusiondsp
Dec 21 13:27:34 volumio volumio[7908]: info: Loading plugin "fusiondsp"...
Dec 21 13:27:36 volumio volumio[7908]: info: Applying required configuration parameters for plugin fusiondsp
Dec 21 13:27:37 volumio volumio[7908]: info: Preparing to generate the ALSA configuration file
Dec 21 13:27:37 volumio volumio[7908]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Dec 21 13:27:37 volumio volumio[7908]: info: Reading ALSA contributions from plugins.
Dec 21 13:27:37 volumio volumio[7908]: info: Asound.conf file written
Dec 21 13:27:37 volumio sudo[9427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Dec 21 13:27:37 volumio sudo[9427]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:37 volumio sudo[9427]: pam_unix(sudo:session): session closed for user root
Dec 21 13:27:37 volumio volumio[7908]: info: Output device has changed, restarting MPD
Dec 21 13:27:38 volumio sudo[9432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 21 13:27:38 volumio volumio[7908]: info: Output device has changed, restarting Shairport Sync
Dec 21 13:27:38 volumio sudo[9432]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:38 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 21 13:27:38 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 21 13:27:38 volumio sudo[9432]: pam_unix(sudo:session): session closed for user root
Dec 21 13:27:38 volumio sudo[9435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 21 13:27:38 volumio sudo[9435]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:38 volumio systemd[1]: Stopping Music Player Daemon...
Dec 21 13:27:38 volumio volumio[7908]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 21 13:27:38 volumio volumio[7908]: info: PLUGIN START: fusiondsp
Dec 21 13:27:38 volumio volumio[7908]: info: Loading i18n strings for locale en
Dec 21 13:27:38 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Dec 21 13:27:38 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 21 13:27:38 volumio volumio[7908]: info: FusionDsp - mixtype--------------------- Hardware
Dec 21 13:27:38 volumio volumio[7908]: info: Preparing to generate the ALSA configuration file
Dec 21 13:27:39 volumio systemd[1]: mpd.service: Succeeded.
Dec 21 13:27:39 volumio volumio[7908]: info: Done.
Dec 21 13:27:39 volumio systemd[1]: Stopped Music Player Daemon.
Dec 21 13:27:39 volumio systemd[1]: Starting Music Player Daemon...
Dec 21 13:27:39 volumio volumio[7908]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Dec 21 13:27:39 volumio volumio[7908]: info: Reading ALSA contributions from plugins.
Dec 21 13:27:39 volumio volumio[7908]: info: MPD Permissions set
Dec 21 13:27:39 volumio volumio[7908]: info: CoreCommandRouter::volumioGetState
Dec 21 13:27:39 volumio volumio[7908]: info: CorePlayQueue::getTrack 0
Dec 21 13:27:39 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 21 13:27:39 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 21 13:27:39 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 21 13:27:39 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 21 13:27:39 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 21 13:27:39 volumio sudo[9440]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 21 13:27:39 volumio sudo[9440]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:39 volumio volumio[7908]: info: Starting Shairport Sync
Dec 21 13:27:39 volumio sudo[9440]: pam_unix(sudo:session): session closed for user root
Dec 21 13:27:40 volumio volumio[7908]: info: Asound.conf file unchanged, so no further update is needed
Dec 21 13:27:40 volumio volumio[7908]: info: Output device has changed, restarting MPD
Dec 21 13:27:40 volumio sudo[9448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Dec 21 13:27:40 volumio sudo[9448]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:40 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Dec 21 13:27:40 volumio systemd[1]: shairport-sync.service: Succeeded.
Dec 21 13:27:40 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Dec 21 13:27:41 volumio sudo[9453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 21 13:27:41 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Dec 21 13:27:41 volumio volumio[7908]: info: Output device has changed, restarting Shairport Sync
Dec 21 13:27:41 volumio sudo[9453]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:41 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 21 13:27:41 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 21 13:27:41 volumio sudo[9448]: pam_unix(sudo:session): session closed for user root
Dec 21 13:27:41 volumio sudo[9453]: pam_unix(sudo:session): session closed for user root
Dec 21 13:27:41 volumio sudo[9456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 21 13:27:41 volumio sudo[9456]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:42 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Dec 21 13:27:42 volumio systemd[1]: mpd.service: Succeeded.
Dec 21 13:27:42 volumio systemd[1]: Stopped Music Player Daemon.
Dec 21 13:27:42 volumio systemd[1]: Starting Music Player Daemon...
Dec 21 13:27:42 volumio volumio[7908]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Dec 21 13:27:42 volumio volumio[7908]: info: camilladsp service started and running in background, instance 1
Dec 21 13:27:42 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 21 13:27:42 volumio volumio[7908]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Dec 21 13:27:42 volumio volumio[7908]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Dec 21 13:27:42 volumio volumio[7908]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Dec 21 13:27:43 volumio sudo[9464]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 21 13:27:43 volumio sudo[9464]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:43 volumio sudo[9464]: pam_unix(sudo:session): session closed for user root
Dec 21 13:27:43 volumio volumio[7908]: info: FusionDsp loaded
Dec 21 13:27:43 volumio volumio[7908]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 21 13:27:43 volumio sudo[9477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Dec 21 13:27:43 volumio sudo[9477]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:43 volumio volumio[7908]: info: FusionDsp - Reporting Fusion DSP Enabled
Dec 21 13:27:43 volumio volumio[7908]: info: Adding Signal Path Element [object Object]
Dec 21 13:27:43 volumio volumio[7908]: info: Adding fusiondspeq DSP Signal Path Element
Dec 21 13:27:43 volumio volumio[7908]: info: FusionDsp - ---- installed callbackRead
Dec 21 13:27:43 volumio volumio[7908]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 21 13:27:43 volumio systemd[1]: Started FusionDsp Daemon.
Dec 21 13:27:44 volumio sudo[9477]: pam_unix(sudo:session): session closed for user root
Dec 21 13:27:44 volumio volumio[7908]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Dec 21 13:27:44 volumio volumio[7908]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Dec 21 13:27:44 volumio volumio[7908]: at onErrorNT (internal/child_process.js:465:16)
Dec 21 13:27:44 volumio volumio[7908]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Dec 21 13:27:44 volumio volumio[7908]: at runNextTicks (internal/process/task_queues.js:62:3)
Dec 21 13:27:44 volumio volumio[7908]: at listOnTimeout (internal/timers.js:523:9)
Dec 21 13:27:44 volumio volumio[7908]: at processTimers (internal/timers.js:497:7) {
Dec 21 13:27:44 volumio volumio[7908]: errno: -2,
Dec 21 13:27:44 volumio volumio[7908]: code: 'ENOENT',
Dec 21 13:27:44 volumio volumio[7908]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Dec 21 13:27:44 volumio volumio[7908]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Dec 21 13:27:44 volumio volumio[7908]: spawnargs: [
Dec 21 13:27:44 volumio volumio[7908]: '-p',
Dec 21 13:27:44 volumio volumio[7908]: 9876,
Dec 21 13:27:44 volumio volumio[7908]: '-o',
Dec 21 13:27:44 volumio volumio[7908]: '/tmp/camilladsp.log',
Dec 21 13:27:44 volumio volumio[7908]: '-l',
Dec 21 13:27:44 volumio volumio[7908]: 'warn',
Dec 21 13:27:44 volumio volumio[7908]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Dec 21 13:27:44 volumio volumio[7908]: ]
Dec 21 13:27:44 volumio volumio[7908]: }
Dec 21 13:27:44 volumio volumio[7908]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 21 13:27:50 volumio mpd_monitor.sh[8814]: MPD Monitor Service: MPD Appears to be inactive, restarting
Dec 21 13:27:50 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Dec 21 13:27:50 volumio systemd[1]: mpd.service: Failed with result 'protocol'.
Dec 21 13:27:50 volumio systemd[1]: Failed to start Music Player Daemon.
Dec 21 13:27:50 volumio sudo[9435]: pam_unix(sudo:session): session closed for user root
Dec 21 13:27:50 volumio sudo[9456]: pam_unix(sudo:session): session closed for user root
Dec 21 13:27:51 volumio systemd[1]: Starting Music Player Daemon...
Dec 21 13:27:52 volumio sudo[9505]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 21 13:27:52 volumio sudo[9505]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:52 volumio sudo[9505]: pam_unix(sudo:session): session closed for user root
Dec 21 13:27:54 volumio sudo[9509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-21 13:26
Dec 21 13:27:54 volumio sudo[9509]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 21 13:27:54 volumio volumio-remote-updater[379]: [2025-12-21 13:27:54] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
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="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"