-- Logs begin at Sat 2026-04-11 12:00:49 CST, end at Sat 2026-04-11 12:07:20 CST. --
Apr 11 12:06:12 volumio sudo[2328]: pam_unix(sudo:session): session closed for user root
Apr 11 12:06:23 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 11 12:06:23 volumio volumio[890]: info: CoreCommandRouter::volumioGetState
Apr 11 12:06:23 volumio sudo[2518]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Apr 11 12:06:23 volumio sudo[2518]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 12:06:24 volumio volumio[890]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 6
Apr 11 12:06:24 volumio volumio[890]: info: CoreCommandRouter::volumioGetState
Apr 11 12:06:25 volumio sudo[2518]: pam_unix(sudo:session): session closed for user root
Apr 11 12:06:28 volumio volumio[890]: info: CoreCommandRouter::Close All Modals sent
Apr 11 12:06:33 volumio volumio[890]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 12:06:33 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 12:06:36 volumio volumio[890]: info: CoreCommandRouter::volumioGetState
Apr 11 12:06:36 volumio sudo[2592]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Apr 11 12:06:36 volumio sudo[2592]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 12:06:37 volumio kernel: python3[2612]: segfault at 7f70ec0008d0 ip 00007f70ec0008d0 sp 00007f70ebffe098 error 15 likely on CPU 0 (core 0, socket 0)
Apr 11 12:06:37 volumio kernel: Code: 00 00 00 a0 59 06 00 00 00 00 00 a0 59 06 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 55 02 00 00 00 00 00 00 <07> 07 07 07 02 04 04 07 07 07 00 00 01 01 00 00 01 03 00 02 01 00
Apr 11 12:06:37 volumio sudo[2592]: pam_unix(sudo:session): session closed for user root
Apr 11 12:06:37 volumio screensaver.sh[612]: /home/volumio/PeppyMeter/screensaver.sh: line 24: 2592 Segmentation fault sudo python3 ./screensaver/volumio_peppymeter.py
Apr 11 12:06:44 volumio volumio[890]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object]
Apr 11 12:06:44 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf
Apr 11 12:06:44 volumio volumio[890]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 11 12:06:44 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 11 12:06:48 volumio volumio[890]: info: CoreCommandRouter::volumioGetState
Apr 11 12:06:48 volumio sudo[2640]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Apr 11 12:06:48 volumio sudo[2640]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 12:06:49 volumio volumio[890]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 6
Apr 11 12:06:49 volumio volumio[890]: info: CoreCommandRouter::volumioGetState
Apr 11 12:07:08 volumio sudo[2640]: pam_unix(sudo:session): session closed for user root
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioSeek
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::seek
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getTrack 0
Apr 11 12:07:10 volumio volumio[890]: info: TRACKBLOCK {"service":"upnp_browser","uri":"http://192.168.1.20:50002/m/NDLNA/19597.flac","realUri":"upnp/folder/http://192.168.1.20:50001/ContentDirectory/control@22$14502","type":"song","albumart":"http://192.168.1.20:50002/transcoder/jpegtnscaler.cgi/ebdart/19597.jpg","artist":"黄红英","album":"初次尝到寂寞","name":"01. 初次尝到寂寞","title":"01. 初次尝到寂寞","duration":257}
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::startPlaybackTimer
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getTrack 0
Apr 11 12:07:10 volumio volumio[890]: info: [1775880430540] ControllerUPNPBrowser::seek
Apr 11 12:07:10 volumio volumio[890]: info: ControllerMpd::seek
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:10 volumio volumio[890]: error: null
Apr 11 12:07:10 volumio volumio[890]: info:
Apr 11 12:07:10 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:10 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:10 volumio volumio[890]: info:
Apr 11 12:07:10 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:10 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:10 volumio volumio[890]: info:
Apr 11 12:07:10 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:10 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:10 volumio volumio[890]: info:
Apr 11 12:07:10 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:10 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:10 volumio volumio[890]: info: sendMpdCommand status took 2 milliseconds
Apr 11 12:07:10 volumio volumio[890]: info: sendMpdCommand status took 2 milliseconds
Apr 11 12:07:10 volumio volumio[890]: info: sendMpdCommand status took 2 milliseconds
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:10 volumio volumio[890]: info: sendMpdCommand status took 2 milliseconds
Apr 11 12:07:10 volumio volumio[890]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo
Apr 11 12:07:10 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getTrack 0
Apr 11 12:07:10 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211000,"duration":258,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7401 Kbps","isStreaming":false,"title":"01. 初次尝到寂寞","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19597.flac","trackType":"flac"}
Apr 11 12:07:10 volumio volumio[890]: verbose: CURRENT POSITION 0
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:10 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:10 volumio volumio[890]: info: ------------------------------ 10ms
Apr 11 12:07:10 volumio volumio[890]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 11 12:07:10 volumio volumio[890]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 11 12:07:10 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo
Apr 11 12:07:10 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getTrack 0
Apr 11 12:07:10 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211000,"duration":258,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7401 Kbps","isStreaming":false,"title":"01. 初次尝到寂寞","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19597.flac","trackType":"flac"}
Apr 11 12:07:10 volumio volumio[890]: verbose: CURRENT POSITION 0
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:10 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:10 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getTrack 0
Apr 11 12:07:10 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211000,"duration":258,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7401 Kbps","isStreaming":false,"title":"01. 初次尝到寂寞","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19597.flac","trackType":"flac"}
Apr 11 12:07:10 volumio volumio[890]: verbose: CURRENT POSITION 0
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:10 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:10 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getTrack 0
Apr 11 12:07:10 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":211000,"duration":258,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7401 Kbps","isStreaming":false,"title":"01. 初次尝到寂寞","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19597.flac","trackType":"flac"}
Apr 11 12:07:10 volumio volumio[890]: verbose: CURRENT POSITION 0
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:10 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:10 volumio volumio[890]: info: ------------------------------ 44ms
Apr 11 12:07:10 volumio volumio[890]: info: ------------------------------ 43ms
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:10 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:10 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioNext
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::next
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::next
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand next
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand next took 4 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 1 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 1 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 1 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 0 milliseconds
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 0
Apr 11 12:07:14 volumio volumio[890]: 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}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 0
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService stop
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::play index undefined
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: 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}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService stop
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: No code
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: 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}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService stop
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: No code
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: 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}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService stop
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: No code
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::startPlaybackTimer
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: [1775880434818] ControllerUPNPBrowser::clearAddPlayTrack
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand stop
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 25ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 24ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 25ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 25ms
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand stop took 5 milliseconds
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand clear
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand clear took 11 milliseconds
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.20:50002/m/NDLNA/19598.flac"
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: error: updateQueue error: null
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 2ms
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.20:50002/m/NDLNA/19598.flac"
Apr 11 12:07:14 volumio volumio[890]: error: updateQueue error: null
Apr 11 12:07:14 volumio volumio[890]: error: updateQueue error: null
Apr 11 12:07:14 volumio volumio[890]: error: updateQueue error: null
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 11ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 11ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 11ms
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand add "http://192.168.1.20:50002/m/NDLNA/19598.flac" took 1 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand play
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 3ms
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand play took 2 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 2ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 1ms
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 2 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 2 milliseconds
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 3 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"19598.flac","artist":null,"album":null,"uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus stop
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"19598.flac","artist":null,"album":null,"uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 11ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 18ms
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 24 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 29 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 30 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 15 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 8 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 8 milliseconds
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"19598.flac","artist":null,"album":null,"uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"19598.flac","artist":null,"album":null,"uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 62ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 61ms
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces system playlist update
Apr 11 12:07:14 volumio volumio[890]: info: Ignoring MPD Status Update
Apr 11 12:07:14 volumio volumio[890]: info:
Apr 11 12:07:14 volumio volumio[890]: ---------------------------- MPD announces state update: player
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::getState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand status
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 43ms
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 38 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 35 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 35 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 32 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 32 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 10ms
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 9 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 9ms
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 9 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 8ms
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand status took 8 milliseconds
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseState
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02. 船歌","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":8,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7059 Kbps","isStreaming":false,"title":"02. 船歌","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7059 Kbps","isStreaming":false,"title":"02. 船歌","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7059 Kbps","isStreaming":false,"title":"02. 船歌","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 89ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 74ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 70ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 66ms
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 20 milliseconds
Apr 11 12:07:14 volumio volumio[890]: info: sendMpdCommand playlistinfo took 19 milliseconds
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo
Apr 11 12:07:14 volumio volumio[890]: verbose: ControllerMpd::parseTrackInfo
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7004 Kbps","isStreaming":false,"title":"02. 船歌","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7058 Kbps","isStreaming":false,"title":"02. 船歌","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7058 Kbps","isStreaming":false,"title":"02. 船歌","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ControllerMpd::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::servicePushState
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getTrack 1
Apr 11 12:07:14 volumio volumio[890]: verbose: STATE SERVICE {"status":"play","position":0,"seek":56,"duration":279,"samplerate":"176.4 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"7058 Kbps","isStreaming":false,"title":"02. 船歌","artist":"黄红英","album":"初次尝到寂寞","uri":"http://192.168.1.20:50002/m/NDLNA/19598.flac","trackType":"flac"}
Apr 11 12:07:14 volumio volumio[890]: verbose: CURRENT POSITION 1
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState stateService play
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::syncState currentStatus play
Apr 11 12:07:14 volumio volumio[890]: info: Received an update from plugin. extracting info from payload
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::pushState
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioPushState
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 88ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 53ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 52ms
Apr 11 12:07:14 volumio volumio[890]: info: ------------------------------ 51ms
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:14 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:14 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:15 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:15 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:15 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:15 volumio volumio[890]: info: CoreCommandRouter::volumioGetQueue
Apr 11 12:07:15 volumio volumio[890]: info: CoreStateMachine::getQueue
Apr 11 12:07:15 volumio volumio[890]: info: CorePlayQueue::getQueue
Apr 11 12:07:19 volumio volumio[890]: info: CoreCommandRouter::volumioGetState
Apr 11 12:07:19 volumio sudo[2807]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py
Apr 11 12:07:19 volumio sudo[2807]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 11 12:07:20 volumio volumio[890]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 6
Apr 11 12:07:20 volumio volumio[890]: info: CoreCommandRouter::volumioGetState
Apr 11 12:07:20 volumio volumio[890]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 12:07:20 volumio volumio[890]: Error: connect ETIMEDOUT 128.121.146.228:443
Apr 11 12:07:20 volumio volumio[890]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Apr 11 12:07:20 volumio volumio[890]: errno: -110,
Apr 11 12:07:20 volumio volumio[890]: code: 'ETIMEDOUT',
Apr 11 12:07:20 volumio volumio[890]: syscall: 'connect',
Apr 11 12:07:20 volumio volumio[890]: address: '128.121.146.228',
Apr 11 12:07:20 volumio volumio[890]: port: 443
Apr 11 12:07:20 volumio volumio[890]: }
Apr 11 12:07:20 volumio volumio[890]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 11 12:07:20 volumio sudo[2841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-11 12:06
Apr 11 12:07:20 volumio sudo[2841]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d"
VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee"
VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623"
VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST"
VOLUMIO_VERSION="3.661"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"