-- Logs begin at Thu 2024-04-18 12:17:05 CEST, end at Thu 2024-04-18 13:31:50 CEST. --
Apr 18 13:30:00 volumio-salonw volumio[899]: info: Selecting previously unselected package gcc-8.
Apr 18 13:30:00 volumio-salonw volumio[899]: info: Preparing to unpack .../15-gcc-8_8.3.0-6+rpi1_armhf.deb ...
Apr 18 13:30:00 volumio-salonw volumio[899]: info: Unpacking gcc-8 (8.3.0-6+rpi1) ...
Apr 18 13:30:01 volumio-salonw volumio[899]: info: Selecting previously unselected package gcc.
Apr 18 13:30:01 volumio-salonw volumio[899]: info: Preparing to unpack .../16-gcc_4%3a8.3.0-1+rpi2_armhf.deb ...
Apr 18 13:30:01 volumio-salonw volumio[899]: info: Unpacking gcc (4:8.3.0-1+rpi2) ...
Apr 18 13:30:01 volumio-salonw volumio[899]: info: Selecting previously unselected package libstdc++-8-dev:armhf.
Apr 18 13:30:01 volumio-salonw volumio[899]: info: Preparing to unpack .../17-libstdc++-8-dev_8.3.0-6+rpi1_armhf.deb ...
Apr 18 13:30:01 volumio-salonw volumio[899]: info: Unpacking libstdc++-8-dev:armhf (8.3.0-6+rpi1) ...
Apr 18 13:30:01 volumio-salonw volumio[899]: info:
Apr 18 13:30:01 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:01 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:01 volumio-salonw volumio[899]: info:
Apr 18 13:30:01 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:01 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:01 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:01 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:01 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:01 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:01 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:01 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:01 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:01 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:01 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:01 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:01 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":93474,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:01 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:01 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:01 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:01 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:01 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:01 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:01 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:01 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:01 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:01 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:01 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:01 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:01 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:01 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:01 volumio-salonw volumio[899]: info: ------------------------------ 6ms
Apr 18 13:30:03 volumio-salonw volumio[899]: info: Selecting previously unselected package g++-8.
Apr 18 13:30:03 volumio-salonw volumio[899]: info: Preparing to unpack .../18-g++-8_8.3.0-6+rpi1_armhf.deb ...
Apr 18 13:30:03 volumio-salonw volumio[899]: info: Unpacking g++-8 (8.3.0-6+rpi1) ...
Apr 18 13:30:04 volumio-salonw volumio[899]: info:
Apr 18 13:30:04 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:04 volumio-salonw volumio[899]: info:
Apr 18 13:30:04 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:04 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:04 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:04 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:04 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:04 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:04 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:04 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:04 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:04 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:04 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:04 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:04 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":95853,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:04 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:04 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:04 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:04 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:04 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:04 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:04 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:04 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:04 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:04 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:04 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:04 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:04 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:04 volumio-salonw volumio[899]: info: ------------------------------ 4ms
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Selecting previously unselected package g++.
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Preparing to unpack .../19-g++_4%3a8.3.0-1+rpi2_armhf.deb ...
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Unpacking g++ (4:8.3.0-1+rpi2) ...
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Selecting previously unselected package make.
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Preparing to unpack .../20-make_4.2.1-1.2_armhf.deb ...
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Unpacking make (4.2.1-1.2) ...
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Selecting previously unselected package patch.
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Preparing to unpack .../21-patch_2.7.6-3+deb10u1_armhf.deb ...
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Unpacking patch (2.7.6-3+deb10u1) ...
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Selecting previously unselected package dpkg-dev.
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Preparing to unpack .../22-dpkg-dev_1.19.8_all.deb ...
Apr 18 13:30:04 volumio-salonw volumio[899]: info: Unpacking dpkg-dev (1.19.8) ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Selecting previously unselected package build-essential.
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Preparing to unpack .../23-build-essential_12.6_armhf.deb ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Unpacking build-essential (12.6) ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Selecting previously unselected package dh-python.
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Preparing to unpack .../24-dh-python_3.20190308_all.deb ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Unpacking dh-python (3.20190308) ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Selecting previously unselected package libfakeroot:armhf.
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Preparing to unpack .../25-libfakeroot_1.23-1_armhf.deb ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Unpacking libfakeroot:armhf (1.23-1) ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Selecting previously unselected package fakeroot.
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Preparing to unpack .../26-fakeroot_1.23-1_armhf.deb ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Unpacking fakeroot (1.23-1) ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Selecting previously unselected package libalgorithm-diff-perl.
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Preparing to unpack .../27-libalgorithm-diff-perl_1.19.03-2_all.deb ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Unpacking libalgorithm-diff-perl (1.19.03-2) ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Selecting previously unselected package libalgorithm-diff-xs-perl.
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Preparing to unpack .../28-libalgorithm-diff-xs-perl_0.04-5+b1_armhf.deb ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Unpacking libalgorithm-diff-xs-perl (0.04-5+b1) ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Selecting previously unselected package libalgorithm-merge-perl.
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Preparing to unpack .../29-libalgorithm-merge-perl_0.08-3_all.deb ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Unpacking libalgorithm-merge-perl (0.08-3) ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Selecting previously unselected package libexpat1-dev:armhf.
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Preparing to unpack .../30-libexpat1-dev_2.2.6-2+deb10u7_armhf.deb ...
Apr 18 13:30:05 volumio-salonw volumio[899]: info: Unpacking libexpat1-dev:armhf (2.2.6-2+deb10u7) ...
Apr 18 13:30:06 volumio-salonw volumio[899]: info: Selecting previously unselected package libpython3.7:armhf.
Apr 18 13:30:06 volumio-salonw volumio[899]: info: Preparing to unpack .../31-libpython3.7_3.7.3-2+deb10u7_armhf.deb ...
Apr 18 13:30:06 volumio-salonw volumio[899]: info: Unpacking libpython3.7:armhf (3.7.3-2+deb10u7) ...
Apr 18 13:30:06 volumio-salonw volumio[899]: info: Selecting previously unselected package libpython3.7-dev:armhf.
Apr 18 13:30:06 volumio-salonw volumio[899]: info: Preparing to unpack .../32-libpython3.7-dev_3.7.3-2+deb10u7_armhf.deb ...
Apr 18 13:30:06 volumio-salonw volumio[899]: info: Unpacking libpython3.7-dev:armhf (3.7.3-2+deb10u7) ...
Apr 18 13:30:07 volumio-salonw volumio[899]: info:
Apr 18 13:30:07 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:07 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:07 volumio-salonw volumio[899]: info:
Apr 18 13:30:07 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:07 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:07 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:07 volumio-salonw volumio[899]: info: ------------------------------ 3ms
Apr 18 13:30:07 volumio-salonw volumio[899]: info: sendMpdCommand status took 2 milliseconds
Apr 18 13:30:07 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:07 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:07 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:07 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:07 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:07 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:07 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:07 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":99474,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:07 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:07 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:07 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:07 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:07 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:07 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:07 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:07 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:07 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:07 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:07 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:07 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:07 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:07 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:07 volumio-salonw volumio[899]: info: ------------------------------ 11ms
Apr 18 13:30:10 volumio-salonw volumio[899]: info: Selecting previously unselected package libpython3-dev:armhf.
Apr 18 13:30:10 volumio-salonw volumio[899]: info: Preparing to unpack .../33-libpython3-dev_3.7.3-1_armhf.deb ...
Apr 18 13:30:10 volumio-salonw volumio[899]: info: Unpacking libpython3-dev:armhf (3.7.3-1) ...
Apr 18 13:30:10 volumio-salonw volumio[899]: info: Selecting previously unselected package libxslt1.1:armhf.
Apr 18 13:30:10 volumio-salonw volumio[899]: info: Preparing to unpack .../34-libxslt1.1_1.1.32-2.2~deb10u2_armhf.deb ...
Apr 18 13:30:10 volumio-salonw volumio[899]: info: Unpacking libxslt1.1:armhf (1.1.32-2.2~deb10u2) ...
Apr 18 13:30:10 volumio-salonw volumio[899]: info: Selecting previously unselected package python-libxml2.
Apr 18 13:30:10 volumio-salonw volumio[899]: info: Preparing to unpack .../35-python-libxml2_2.9.4+dfsg1-7+deb10u6_armhf.deb ...
Apr 18 13:30:10 volumio-salonw volumio[899]: info: Unpacking python-libxml2 (2.9.4+dfsg1-7+deb10u6) ...
Apr 18 13:30:10 volumio-salonw volumio[899]: info:
Apr 18 13:30:10 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:10 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:10 volumio-salonw volumio[899]: info:
Apr 18 13:30:10 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:10 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:10 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:10 volumio-salonw volumio[899]: info: ------------------------------ 2ms
Apr 18 13:30:10 volumio-salonw volumio[899]: info: sendMpdCommand status took 2 milliseconds
Apr 18 13:30:10 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:10 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:11 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 18 13:30:11 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:11 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:11 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:11 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:11 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":102596,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:11 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:11 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:11 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:11 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:11 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:11 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:11 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:11 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:11 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:11 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:11 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:11 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:11 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:11 volumio-salonw volumio[899]: info: ------------------------------ 14ms
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Selecting previously unselected package python-libxslt1.
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Preparing to unpack .../36-python-libxslt1_1.1.32-2.2~deb10u2_armhf.deb ...
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Unpacking python-libxslt1 (1.1.32-2.2~deb10u2) ...
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Selecting previously unselected package python-pip-whl.
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Preparing to unpack .../37-python-pip-whl_18.1-5+rpt1_all.deb ...
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Unpacking python-pip-whl (18.1-5+rpt1) ...
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-asn1crypto.
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Preparing to unpack .../38-python3-asn1crypto_0.24.0-1_all.deb ...
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Unpacking python3-asn1crypto (0.24.0-1) ...
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-cffi-backend.
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Preparing to unpack .../39-python3-cffi-backend_1.12.2-1_armhf.deb ...
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Unpacking python3-cffi-backend (1.12.2-1) ...
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-crypto.
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Preparing to unpack .../40-python3-crypto_2.6.1-9+b1_armhf.deb ...
Apr 18 13:30:11 volumio-salonw volumio[899]: info: Unpacking python3-crypto (2.6.1-9+b1) ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-cryptography.
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Preparing to unpack .../41-python3-cryptography_2.6.1-3+deb10u4_armhf.deb ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Unpacking python3-cryptography (2.6.1-3+deb10u4) ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-dbus.
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Preparing to unpack .../42-python3-dbus_1.2.8-3_armhf.deb ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Unpacking python3-dbus (1.2.8-3) ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Selecting previously unselected package python3.7-dev.
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Preparing to unpack .../43-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-dev.
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Preparing to unpack .../44-python3-dev_3.7.3-1_armhf.deb ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Unpacking python3-dev (3.7.3-1) ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-entrypoints.
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Preparing to unpack .../45-python3-entrypoints_0.3-1_all.deb ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Unpacking python3-entrypoints (0.3-1) ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-gi.
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Preparing to unpack .../46-python3-gi_3.30.4-1_armhf.deb ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Unpacking python3-gi (3.30.4-1) ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-secretstorage.
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Preparing to unpack .../47-python3-secretstorage_2.3.1-2_all.deb ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Unpacking python3-secretstorage (2.3.1-2) ...
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-keyring.
Apr 18 13:30:12 volumio-salonw volumio[899]: info: Preparing to unpack .../48-python3-keyring_17.1.1-1_all.deb ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Unpacking python3-keyring (17.1.1-1) ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-keyrings.alt.
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Preparing to unpack .../49-python3-keyrings.alt_3.1.1-1_all.deb ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Unpacking python3-keyrings.alt (3.1.1-1) ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-pip.
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Preparing to unpack .../50-python3-pip_18.1-5+rpt1_all.deb ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Unpacking python3-pip (18.1-5+rpt1) ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-setuptools.
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Preparing to unpack .../51-python3-setuptools_40.8.0-1_all.deb ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Unpacking python3-setuptools (40.8.0-1) ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-wheel.
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Preparing to unpack .../52-python3-wheel_0.32.3-2_all.deb ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Unpacking python3-wheel (0.32.3-2) ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Selecting previously unselected package python3-xdg.
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Preparing to unpack .../53-python3-xdg_0.25-5_all.deb ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Unpacking python3-xdg (0.25-5) ...
Apr 18 13:30:13 volumio-salonw volumio[899]: info:
Apr 18 13:30:13 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:13 volumio-salonw volumio[899]: info:
Apr 18 13:30:13 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:13 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:13 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:13 volumio-salonw volumio[899]: info: ------------------------------ 2ms
Apr 18 13:30:13 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:13 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:13 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:13 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:13 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:13 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:13 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:13 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:13 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":105592,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:13 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:13 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:13 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:13 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:13 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:13 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:13 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:13 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:13 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:13 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:13 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:13 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:14 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:14 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:14 volumio-salonw volumio[899]: info: ------------------------------ 8ms
Apr 18 13:30:14 volumio-salonw volumio[899]: info: Setting up python3-entrypoints (0.3-1) ...
Apr 18 13:30:14 volumio-salonw volumio[899]: info: Setting up dh-python (3.20190308) ...
Apr 18 13:30:14 volumio-salonw volumio[899]: info: Setting up libexpat1:armhf (2.2.6-2+deb10u7) ...
Apr 18 13:30:14 volumio-salonw volumio[899]: info: Setting up python3-dbus (1.2.8-3) ...
Apr 18 13:30:14 volumio-salonw volumio[899]: info: Setting up python3-setuptools (40.8.0-1) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up libalgorithm-diff-perl (1.19.03-2) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up python3-xdg (0.25-5) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up bzip2 (1.0.6-9.2~deb10u2) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up libpython3.7-minimal:armhf (3.7.3-2+deb10u7) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up python3-wheel (0.32.3-2) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up libfakeroot:armhf (1.23-1) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up fakeroot (1.23-1) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: update-alternatives: using /usr/bin/fakeroot-sysv to provide /usr/bin/fakeroot (fakeroot) in auto mode
Apr 18 13:30:15 volumio-salonw volumio[899]: info: update-alternatives: warning: skip creation of /usr/share/man/es/man1/fakeroot.1.gz because associated file /usr/share/man/es/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist
Apr 18 13:30:15 volumio-salonw volumio[899]: info: update-alternatives: warning: skip creation of /usr/share/man/es/man1/faked.1.gz because associated file /usr/share/man/es/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist
Apr 18 13:30:15 volumio-salonw volumio[899]: info: update-alternatives: warning: skip creation of /usr/share/man/fr/man1/fakeroot.1.gz because associated file /usr/share/man/fr/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist
Apr 18 13:30:15 volumio-salonw volumio[899]: info: update-alternatives: warning: skip creation of /usr/share/man/fr/man1/faked.1.gz because associated file /usr/share/man/fr/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist
Apr 18 13:30:15 volumio-salonw volumio[899]: info: update-alternatives: warning: skip creation of /usr/share/man/sv/man1/fakeroot.1.gz because associated file /usr/share/man/sv/man1/fakeroot-sysv.1.gz (of link group fakeroot) doesn't exist
Apr 18 13:30:15 volumio-salonw volumio[899]: info: update-alternatives: warning: skip creation of /usr/share/man/sv/man1/faked.1.gz because associated file /usr/share/man/sv/man1/faked-sysv.1.gz (of link group fakeroot) doesn't exist
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up libasan5:armhf (8.3.0-6+rpi1) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up libexpat1-dev:armhf (2.2.6-2+deb10u7) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up make (4.2.1-1.2) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up libmpfr6:armhf (4.0.2-1) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up python3-gi (3.30.4-1) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up libmpc3:armhf (1.1.0-1) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up patch (2.7.6-3+deb10u1) ...
Apr 18 13:30:15 volumio-salonw volumio[899]: info: Setting up python3.7-minimal (3.7.3-2+deb10u7) ...
Apr 18 13:30:16 volumio-salonw volumio[899]: info: Setting up libubsan1:armhf (8.3.0-6+rpi1) ...
Apr 18 13:30:16 volumio-salonw volumio[899]: info: Setting up python-libxml2 (2.9.4+dfsg1-7+deb10u6) ...
Apr 18 13:30:16 volumio-salonw volumio[899]: info: Setting up libisl19:armhf (0.20-2) ...
Apr 18 13:30:16 volumio-salonw volumio[899]: info:
Apr 18 13:30:16 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:16 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:16 volumio-salonw volumio[899]: info:
Apr 18 13:30:16 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:16 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:16 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:16 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:16 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:16 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:16 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:16 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:30:16 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:16 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:16 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:16 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:16 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":108600,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:16 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:16 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:16 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:16 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:16 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:16 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:16 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:16 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:16 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:16 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:16 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:16 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:16 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:16 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:17 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:30:17 volumio-salonw volumio[899]: info: Setting up libxslt1.1:armhf (1.1.32-2.2~deb10u2) ...
Apr 18 13:30:17 volumio-salonw volumio[899]: info: Setting up python3-crypto (2.6.1-9+b1) ...
Apr 18 13:30:17 volumio-salonw volumio[899]: info: Setting up python-pip-whl (18.1-5+rpt1) ...
Apr 18 13:30:17 volumio-salonw volumio[899]: info: Setting up cpp-8 (8.3.0-6+rpi1) ...
Apr 18 13:30:17 volumio-salonw volumio[899]: info: Setting up libalgorithm-diff-xs-perl (0.04-5+b1) ...
Apr 18 13:30:17 volumio-salonw volumio[899]: info: Setting up python3-asn1crypto (0.24.0-1) ...
Apr 18 13:30:18 volumio-salonw volumio[899]: info: Setting up libcc1-0:armhf (8.3.0-6+rpi1) ...
Apr 18 13:30:18 volumio-salonw volumio[899]: info: Setting up python3-cffi-backend (1.12.2-1) ...
Apr 18 13:30:18 volumio-salonw volumio[899]: info: Setting up libalgorithm-merge-perl (0.08-3) ...
Apr 18 13:30:18 volumio-salonw volumio[899]: info: Setting up libpython3.7-stdlib:armhf (3.7.3-2+deb10u7) ...
Apr 18 13:30:18 volumio-salonw volumio[899]: info: Setting up libpython3.7:armhf (3.7.3-2+deb10u7) ...
Apr 18 13:30:18 volumio-salonw volumio[899]: info: Setting up libpython3.7-dev:armhf (3.7.3-2+deb10u7) ...
Apr 18 13:30:18 volumio-salonw volumio[899]: info: Setting up python-libxslt1 (1.1.32-2.2~deb10u2) ...
Apr 18 13:30:18 volumio-salonw volumio[899]: info: Setting up dpkg-dev (1.19.8) ...
Apr 18 13:30:18 volumio-salonw volumio[899]: info: Setting up python3-cryptography (2.6.1-3+deb10u4) ...
Apr 18 13:30:19 volumio-salonw volumio[899]: info: Setting up python3-pip (18.1-5+rpt1) ...
Apr 18 13:30:19 volumio-salonw volumio[899]: info: Setting up libgcc-8-dev:armhf (8.3.0-6+rpi1) ...
Apr 18 13:30:19 volumio-salonw volumio[899]: info: Setting up cpp (4:8.3.0-1+rpi2) ...
Apr 18 13:30:19 volumio-salonw volumio[899]: info: Setting up python3-keyrings.alt (3.1.1-1) ...
Apr 18 13:30:19 volumio-salonw volumio[899]: info: Setting up libstdc++-8-dev:armhf (8.3.0-6+rpi1) ...
Apr 18 13:30:19 volumio-salonw volumio[899]: info: Setting up python3.7 (3.7.3-2+deb10u7) ...
Apr 18 13:30:19 volumio-salonw volumio[899]: info:
Apr 18 13:30:19 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:19 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:19 volumio-salonw volumio[899]: info:
Apr 18 13:30:19 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:19 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:19 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:19 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:19 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:19 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:19 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:19 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 18 13:30:19 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:19 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:19 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:19 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:19 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":111596,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:19 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:19 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:19 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:19 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:19 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:19 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:20 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:20 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:20 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:20 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:20 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:20 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:20 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:20 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:20 volumio-salonw volumio[899]: info: ------------------------------ 10ms
Apr 18 13:30:20 volumio-salonw volumio[899]: info: Setting up gcc-8 (8.3.0-6+rpi1) ...
Apr 18 13:30:20 volumio-salonw volumio[899]: info: Setting up libpython3-dev:armhf (3.7.3-1) ...
Apr 18 13:30:20 volumio-salonw volumio[899]: info: Setting up python3.7-dev (3.7.3-2+deb10u7) ...
Apr 18 13:30:20 volumio-salonw volumio[899]: info: Setting up gcc (4:8.3.0-1+rpi2) ...
Apr 18 13:30:20 volumio-salonw volumio[899]: info: Setting up python3-secretstorage (2.3.1-2) ...
Apr 18 13:30:20 volumio-salonw volumio[899]: info: Setting up python3-dev (3.7.3-1) ...
Apr 18 13:30:20 volumio-salonw volumio[899]: info: Setting up g++-8 (8.3.0-6+rpi1) ...
Apr 18 13:30:20 volumio-salonw volumio[899]: info: Setting up python3-keyring (17.1.1-1) ...
Apr 18 13:30:21 volumio-salonw volumio[899]: info: Setting up g++ (4:8.3.0-1+rpi2) ...
Apr 18 13:30:21 volumio-salonw volumio[899]: info: update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode
Apr 18 13:30:21 volumio-salonw volumio[899]: info: Setting up build-essential (12.6) ...
Apr 18 13:30:21 volumio-salonw volumio[899]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ...
Apr 18 13:30:21 volumio-salonw volumio[899]: info: Processing triggers for mime-support (3.62) ...
Apr 18 13:30:21 volumio-salonw sudo[17755]: pam_unix(sudo:session): session closed for user root
Apr 18 13:30:21 volumio-salonw sudo[18691]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/pip3 install streamlink
Apr 18 13:30:21 volumio-salonw sudo[18691]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 18 13:30:22 volumio-salonw volumio[899]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
Apr 18 13:30:22 volumio-salonw volumio[899]: info: Collecting streamlink
Apr 18 13:30:22 volumio-salonw volumio[899]: info:
Apr 18 13:30:22 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:22 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:22 volumio-salonw volumio[899]: info:
Apr 18 13:30:22 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:22 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:22 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:22 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:22 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:22 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:22 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:22 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:22 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:22 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:22 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:22 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:22 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":114594,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:22 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:22 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:22 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:22 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:22 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:22 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:22 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:22 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:22 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:22 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:22 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:22 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:22 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:22 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:22 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:30:23 volumio-salonw volumio[899]: info: Downloading https://files.pythonhosted.org/packages/cd/5f/3ccd2c5453900b868fb483253735f22eca61c6da125054e02cd999defa1b/streamlink-5.5.1-py3-none-any.whl (362kB)
Apr 18 13:30:23 volumio-salonw volumio[899]: info: Collecting urllib3<3,>=1.26.0 (from streamlink)
Apr 18 13:30:23 volumio-salonw volumio[899]: info: Downloading https://files.pythonhosted.org/packages/d2/b2/b157855192a68541a91ba7b2bbcb91f1b4faa51f8bae38d8005c034be524/urllib3-2.0.7-py3-none-any.whl (124kB)
Apr 18 13:30:23 volumio-salonw volumio[899]: info: Collecting requests<3.0,>=2.26.0 (from streamlink)
Apr 18 13:30:24 volumio-salonw volumio[899]: info: Downloading https://files.pythonhosted.org/packages/70/8e/0e2d847013cb52cd35b38c009bb167a1a26b2ce6cd6965bf26b47bc0bf44/requests-2.31.0-py3-none-any.whl (62kB)
Apr 18 13:30:24 volumio-salonw volumio[899]: info: Collecting pycountry (from streamlink)
Apr 18 13:30:24 volumio-salonw volumio[899]: info: Downloading https://www.piwheels.org/simple/pycountry/pycountry-22.3.5-py2.py3-none-any.whl (10.7MB)
Apr 18 13:30:25 volumio-salonw volumio[899]: info:
Apr 18 13:30:25 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:25 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:25 volumio-salonw volumio[899]: info:
Apr 18 13:30:25 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:25 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:25 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:25 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:25 volumio-salonw volumio[899]: info: sendMpdCommand status took 0 milliseconds
Apr 18 13:30:25 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:25 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:25 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:30:25 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:25 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:25 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:25 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:25 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":117601,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:25 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:25 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:25 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:25 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:25 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:25 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:25 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:25 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:25 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:25 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:25 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:25 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:25 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:25 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:26 volumio-salonw volumio[899]: info: ------------------------------ 7ms
Apr 18 13:30:28 volumio-salonw volumio[899]: info: Collecting lxml<5.0,>=4.6.4 (from streamlink)
Apr 18 13:30:28 volumio-salonw volumio[899]: info:
Apr 18 13:30:28 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:28 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:28 volumio-salonw volumio[899]: info:
Apr 18 13:30:28 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:28 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:28 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:28 volumio-salonw volumio[899]: info: ------------------------------ 0ms
Apr 18 13:30:28 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:28 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:28 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:28 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:28 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:28 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:28 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:28 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:28 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":120592,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:28 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:28 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:28 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:28 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:28 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:28 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:28 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:28 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:28 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:28 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:28 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:28 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:28 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:28 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:28 volumio-salonw volumio[899]: info: ------------------------------ 4ms
Apr 18 13:30:29 volumio-salonw volumio[899]: info: Downloading https://files.pythonhosted.org/packages/84/14/c2070b5e37c650198de8328467dd3d1681e80986f81ba0fea04fc4ec9883/lxml-4.9.4.tar.gz (3.6MB)
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Complete output from command python setup.py egg_info:
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Building lxml version 4.9.4.
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Building without Cython.
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Error: Please make sure the libxml2 and libxslt development packages are installed.
Apr 18 13:30:31 volumio-salonw volumio[899]: info:
Apr 18 13:30:31 volumio-salonw volumio[899]: info: ----------------------------------------
Apr 18 13:30:31 volumio-salonw sudo[18691]: pam_unix(sudo:session): session closed for user root
Apr 18 13:30:31 volumio-salonw sudo[17544]: pam_unix(sudo:session): session closed for user root
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Mixcloud plugin installed
Apr 18 13:30:31 volumio-salonw volumio[899]: Plugin install end detected on script
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Install script completed
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Adding reference to registry
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Done installing plugin.
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Folder /tmp/plugins removed
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Folder /tmp/downloaded_plugin.zip removed
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Folder /data/temp removed
Apr 18 13:30:31 volumio-salonw volumio[899]: info:
Apr 18 13:30:31 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:31 volumio-salonw volumio[899]: info:
Apr 18 13:30:31 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:31 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:31 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:31 volumio-salonw volumio[899]: info: ------------------------------ 0ms
Apr 18 13:30:31 volumio-salonw volumio[899]: info: sendMpdCommand status took 0 milliseconds
Apr 18 13:30:31 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:31 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:31 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:31 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:31 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:31 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":123600,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:31 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:31 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:31 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:31 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:31 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:31 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:31 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:31 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:30:34 volumio-salonw volumio[899]: info: Enabling plugin mixcloud
Apr 18 13:30:34 volumio-salonw volumio[899]: info: Loading plugin "mixcloud"...
Apr 18 13:30:34 volumio-salonw volumio[899]: info: PLUGIN START: mixcloud
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 18 13:30:34 volumio-salonw volumio[899]: info: [1713439834532] CoreMusicLibrary::Adding element Mixcloud
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 18 13:30:34 volumio-salonw volumio[899]: Cannot find translation for source QOBUZ
Apr 18 13:30:34 volumio-salonw volumio[899]: Cannot find translation for source Bandcamp Discover
Apr 18 13:30:34 volumio-salonw volumio[899]: Cannot find translation for source Mixcloud
Apr 18 13:30:34 volumio-salonw volumio[899]: info: Done.
Apr 18 13:30:34 volumio-salonw volumio[899]: info:
Apr 18 13:30:34 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:34 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:34 volumio-salonw volumio[899]: info:
Apr 18 13:30:34 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:34 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:34 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:34 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:34 volumio-salonw volumio[899]: info: sendMpdCommand status took 0 milliseconds
Apr 18 13:30:34 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:34 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:34 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:30:34 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:34 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:34 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":126596,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:34 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:34 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:34 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:34 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:34 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:34 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:34 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:34 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:30:37 volumio-salonw volumio[899]: info:
Apr 18 13:30:37 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:37 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:37 volumio-salonw volumio[899]: info:
Apr 18 13:30:37 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:37 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:37 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:37 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:37 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:37 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:37 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:37 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:37 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:37 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:37 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:37 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:37 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":129594,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:37 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:37 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:37 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:37 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:37 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:37 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:37 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:37 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:37 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:37 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:37 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:37 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:37 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:37 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:37 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:30:40 volumio-salonw volumio[899]: info:
Apr 18 13:30:40 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:40 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:40 volumio-salonw volumio[899]: info:
Apr 18 13:30:40 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:40 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:40 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:40 volumio-salonw volumio[899]: info: ------------------------------ 2ms
Apr 18 13:30:40 volumio-salonw volumio[899]: info: sendMpdCommand status took 0 milliseconds
Apr 18 13:30:40 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:40 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:40 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:40 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:40 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:40 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:40 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:40 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":132590,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:40 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:40 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:40 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:40 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:40 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:40 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:40 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:40 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:40 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:40 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:40 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:40 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:40 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:41 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:41 volumio-salonw volumio[899]: info: ------------------------------ 8ms
Apr 18 13:30:43 volumio-salonw volumio[899]: info:
Apr 18 13:30:43 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:43 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:43 volumio-salonw volumio[899]: info:
Apr 18 13:30:43 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:43 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:43 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:43 volumio-salonw volumio[899]: info: ------------------------------ 2ms
Apr 18 13:30:43 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:43 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:43 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:43 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:30:43 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:43 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:43 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:43 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:43 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":135597,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:43 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:43 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:43 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:43 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:43 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:43 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:43 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:43 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:43 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:44 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:44 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:44 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:44 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:44 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:44 volumio-salonw volumio[899]: info: ------------------------------ 10ms
Apr 18 13:30:46 volumio-salonw volumio[899]: info:
Apr 18 13:30:46 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:46 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:46 volumio-salonw volumio[899]: info:
Apr 18 13:30:46 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:46 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:46 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:46 volumio-salonw volumio[899]: info: ------------------------------ 2ms
Apr 18 13:30:46 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:46 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:46 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:46 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 18 13:30:46 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:47 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:47 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:47 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:47 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":138590,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:47 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:47 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:47 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:47 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:47 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:47 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:47 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:47 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:47 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:47 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:47 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:47 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:47 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:47 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:47 volumio-salonw volumio[899]: info: ------------------------------ 14ms
Apr 18 13:30:49 volumio-salonw volumio[899]: info:
Apr 18 13:30:49 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:49 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:49 volumio-salonw volumio[899]: info:
Apr 18 13:30:49 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:49 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:49 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:49 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:49 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:49 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:49 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:49 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:49 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:49 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:49 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:49 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:49 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":141597,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:49 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:49 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:49 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:49 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:49 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:49 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:49 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:49 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:49 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:49 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:49 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:49 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:49 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:49 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:49 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:30:52 volumio-salonw volumio[899]: info:
Apr 18 13:30:52 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:52 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:52 volumio-salonw volumio[899]: info:
Apr 18 13:30:52 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:52 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:52 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:52 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:52 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:52 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:52 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:52 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:52 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:52 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:52 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:52 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:52 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":144594,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:52 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:52 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:52 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:52 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:52 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:52 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:52 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:52 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:52 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:52 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:52 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:52 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:52 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:52 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:52 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:30:55 volumio-salonw volumio[899]: info:
Apr 18 13:30:55 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:55 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:55 volumio-salonw volumio[899]: info:
Apr 18 13:30:55 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:55 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:55 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:55 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:55 volumio-salonw volumio[899]: info: sendMpdCommand status took 0 milliseconds
Apr 18 13:30:55 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:55 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:55 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:30:55 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:55 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:55 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:55 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:55 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":147590,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:55 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:55 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:55 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:55 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:55 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:55 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:55 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:55 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:55 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:55 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:55 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:55 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:55 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:55 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:55 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:30:57 volumio-salonw volumio[899]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf
Apr 18 13:30:58 volumio-salonw volumio[899]: info:
Apr 18 13:30:58 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:30:58 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:30:58 volumio-salonw volumio[899]: info:
Apr 18 13:30:58 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:30:58 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:30:58 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:30:58 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:30:58 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:30:58 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:30:58 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:30:58 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:30:58 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:30:58 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:30:58 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:30:58 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:30:58 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":150598,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:30:58 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:30:58 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:30:58 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:30:58 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:30:58 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:30:58 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:58 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:30:58 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:58 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:58 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:58 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:30:58 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:30:58 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:30:58 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:30:58 volumio-salonw volumio[899]: info: ------------------------------ 7ms
Apr 18 13:31:00 volumio-salonw volumio[899]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf
Apr 18 13:31:00 volumio-salonw volumio[899]: info: Folder /tmp/plugins removed
Apr 18 13:31:00 volumio-salonw volumio[899]: info: Check plugin dependencies
Apr 18 13:31:00 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 18 13:31:00 volumio-salonw volumio[899]: info: Checking if plugin already exists
Apr 18 13:31:00 volumio-salonw volumio[899]: info: Rename folder
Apr 18 13:31:00 volumio-salonw volumio[899]: info: Folder /tmp/downloaded_plugin.zip removed
Apr 18 13:31:00 volumio-salonw volumio[899]: info: Move to category
Apr 18 13:31:01 volumio-salonw volumio[899]: info: Checking if install.sh is present
Apr 18 13:31:01 volumio-salonw volumio[899]: info: Executing install.sh
Apr 18 13:31:01 volumio-salonw sudo[18824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh
Apr 18 13:31:01 volumio-salonw sudo[18824]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 18 13:31:01 volumio-salonw volumio[899]: info: Installing Go-librespot
Apr 18 13:31:01 volumio-salonw volumio[899]: info: Checking old vollibrespot installs
Apr 18 13:31:01 volumio-salonw systemd[1]: Reloading.
Apr 18 13:31:01 volumio-salonw systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Apr 18 13:31:01 volumio-salonw volumio[899]: info: Dowloading daemon
Apr 18 13:31:01 volumio-salonw volumio[899]: info:
Apr 18 13:31:01 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:01 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:01 volumio-salonw volumio[899]: info:
Apr 18 13:31:01 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:01 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:01 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:01 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:31:01 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:01 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:01 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:01 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:31:01 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:01 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:01 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:01 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:01 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":153595,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:01 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:01 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:01 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:01 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:01 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:01 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:01 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:01 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:01 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:01 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:01 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:01 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:01 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:01 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:01 volumio-salonw volumio[899]: info: ------------------------------ 7ms
Apr 18 13:31:02 volumio-salonw volumio[899]: info: Creating Start Script
Apr 18 13:31:02 volumio-salonw systemd[1]: Reloading.
Apr 18 13:31:02 volumio-salonw systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Apr 18 13:31:02 volumio-salonw sudo[18824]: pam_unix(sudo:session): session closed for user root
Apr 18 13:31:02 volumio-salonw volumio[899]: Plugin install end detected on script
Apr 18 13:31:02 volumio-salonw volumio[899]: info: Install script completed
Apr 18 13:31:02 volumio-salonw volumio[899]: info: Adding reference to registry
Apr 18 13:31:02 volumio-salonw volumio[899]: info: Done installing plugin.
Apr 18 13:31:02 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 18 13:31:02 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Apr 18 13:31:02 volumio-salonw volumio[899]: info: Folder /tmp/plugins removed
Apr 18 13:31:02 volumio-salonw volumio[899]: info: Folder /tmp/downloaded_plugin.zip removed
Apr 18 13:31:02 volumio-salonw volumio[899]: info: Folder /data/temp removed
Apr 18 13:31:04 volumio-salonw volumio[899]: info: Enabling plugin spop
Apr 18 13:31:04 volumio-salonw volumio[899]: info: Loading plugin "spop"...
Apr 18 13:31:05 volumio-salonw volumio[899]: info: PLUGIN START: spop
Apr 18 13:31:05 volumio-salonw volumio[899]: info: Creating Spotify config file
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 18 13:31:05 volumio-salonw volumio[899]: info: Done.
Apr 18 13:31:05 volumio-salonw volumio[899]: info:
Apr 18 13:31:05 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:05 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:05 volumio-salonw volumio[899]: info:
Apr 18 13:31:05 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:05 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:05 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:05 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:31:05 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:05 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:05 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:05 volumio-salonw volumio[899]: info: Spotify config file written
Apr 18 13:31:05 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 18 13:31:05 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:05 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:05 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":156723,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:05 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:05 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:05 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:05 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:05 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:05 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:05 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:05 volumio-salonw volumio[899]: info: ------------------------------ 16ms
Apr 18 13:31:05 volumio-salonw sudo[18879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Apr 18 13:31:05 volumio-salonw sudo[18879]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 18 13:31:05 volumio-salonw systemd[1]: Started go-librespot Daemon.
Apr 18 13:31:05 volumio-salonw go-librespot[18883]: Librespot-go daemon starting...
Apr 18 13:31:05 volumio-salonw sudo[18879]: pam_unix(sudo:session): session closed for user root
Apr 18 13:31:05 volumio-salonw go-librespot[18883]: time="2024-04-18T13:31:05+02:00" level=info msg="generated new device id: dd953d71a105668d928575602ad08f4d149c7744"
Apr 18 13:31:05 volumio-salonw go-librespot[18883]: time="2024-04-18T13:31:05+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Apr 18 13:31:05 volumio-salonw go-librespot[18883]: time="2024-04-18T13:31:05+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Apr 18 13:31:05 volumio-salonw go-librespot[18883]: time="2024-04-18T13:31:05+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Apr 18 13:31:05 volumio-salonw go-librespot[18883]: time="2024-04-18T13:31:05+02:00" level=debug msg="zeroconf server listening on port 36593"
Apr 18 13:31:07 volumio-salonw volumio[899]: info:
Apr 18 13:31:07 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:07 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:07 volumio-salonw volumio[899]: info:
Apr 18 13:31:07 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:07 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:07 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:07 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:31:07 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:07 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:07 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:07 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:31:07 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:07 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:07 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:07 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:07 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":159594,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:07 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:07 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:07 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:07 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:07 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:07 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:07 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:07 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:07 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:07 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:07 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:07 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:07 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:07 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:07 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:31:08 volumio-salonw volumio[899]: info: go-librespot daemon successfully initialized
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 18 13:31:09 volumio-salonw volumio[899]: info: Retrieving Cloud Streaming UI
Apr 18 13:31:09 volumio-salonw volumio[899]: info: Getting Tidal Cloud Configuration
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 18 13:31:09 volumio-salonw volumio[899]: info: Getting Qobuz Cloud Configuration
Apr 18 13:31:09 volumio-salonw volumio[899]: info: Asking plugin for UI Config
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 18 13:31:09 volumio-salonw volumio[899]: info: Getting Spotify Cloud Configuration
Apr 18 13:31:09 volumio-salonw volumio[899]: info: Asking plugin for UI Config
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 18 13:31:09 volumio-salonw volumio[899]: info: Saving Spotify Acccount
Apr 18 13:31:09 volumio-salonw volumio[899]: info: Got it
Apr 18 13:31:09 volumio-salonw volumio[899]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 18 13:31:09 volumio-salonw volumio[899]: info: Got Tidal Cloud Configuration
Apr 18 13:31:09 volumio-salonw volumio[899]: info: Got it
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 18 13:31:09 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 18 13:31:10 volumio-salonw volumio[899]: info:
Apr 18 13:31:10 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:10 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:10 volumio-salonw volumio[899]: info:
Apr 18 13:31:10 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:10 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:10 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:10 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:31:10 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:10 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:10 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:10 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:31:10 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:10 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:10 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":162590,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:10 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:10 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:10 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:10 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:10 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:10 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:10 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:10 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:31:11 volumio-salonw volumio[899]: info: Initializing connection to go-librespot Websocket
Apr 18 13:31:11 volumio-salonw go-librespot[18883]: time="2024-04-18T13:31:11+02:00" level=debug msg="new websocket client"
Apr 18 13:31:11 volumio-salonw volumio[899]: info: Connection to go-librespot Websocket established
Apr 18 13:31:11 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Apr 18 13:31:11 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 18 13:31:13 volumio-salonw volumio[899]: info:
Apr 18 13:31:13 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:13 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:13 volumio-salonw volumio[899]: info:
Apr 18 13:31:13 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:13 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:13 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:13 volumio-salonw volumio[899]: info: ------------------------------ 0ms
Apr 18 13:31:13 volumio-salonw volumio[899]: info: sendMpdCommand status took 0 milliseconds
Apr 18 13:31:13 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:13 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:13 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:31:13 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:13 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:13 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":165586,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:13 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:13 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:13 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:13 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:13 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:13 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:13 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:13 volumio-salonw volumio[899]: info: ------------------------------ 7ms
Apr 18 13:31:14 volumio-salonw volumio[899]: info: Getting Spotify volume
Apr 18 13:31:14 volumio-salonw volumio[899]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6
Apr 18 13:31:14 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioGetState
Apr 18 13:31:14 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:14 volumio-salonw volumio[899]: SPOTIFY: SPOTIFY VOLUME undefined
Apr 18 13:31:14 volumio-salonw volumio[899]: SPOTIFY: VOLUMIO VOLUME 100
Apr 18 13:31:14 volumio-salonw volumio[899]: info: Aligning Spotify Volume to Volumio Volume
Apr 18 13:31:14 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioGetState
Apr 18 13:31:14 volumio-salonw volumio[899]: info: Setting Spotify Volume from Volumio: 100
Apr 18 13:31:15 volumio-salonw volumio[899]: SPOTIFY: SETTING SPOTIFY VOLUME 100
Apr 18 13:31:15 volumio-salonw volumio[899]: info: Sending Spotify command with payload to local API: /player/volume
Apr 18 13:31:16 volumio-salonw volumio[899]: info: Error browsing device NAS-ALAINDIV for shares : Error: Command failed: echo volumio | smbclient -L NAS-ALAINDIV.local.
Apr 18 13:31:16 volumio-salonw volumio[899]: Unable to initialize messaging context
Apr 18 13:31:16 volumio-salonw volumio[899]: do_connect: Connection to NAS-ALAINDIV.local. failed (Error NT_STATUS_HOST_UNREACHABLE)
Apr 18 13:31:16 volumio-salonw volumio[899]: info:
Apr 18 13:31:16 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:16 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:16 volumio-salonw volumio[899]: info:
Apr 18 13:31:16 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:16 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:16 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:16 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:31:16 volumio-salonw volumio[899]: info: sendMpdCommand status took 0 milliseconds
Apr 18 13:31:16 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:16 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:16 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:31:16 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:16 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:16 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:16 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:16 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":168595,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:16 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:16 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:16 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:16 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:16 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:16 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:16 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:16 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:16 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:16 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:16 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:16 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:16 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:16 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:16 volumio-salonw volumio[899]: info: ------------------------------ 7ms
Apr 18 13:31:16 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:17 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:17 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 18 13:31:19 volumio-salonw volumio[899]: info:
Apr 18 13:31:19 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:19 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:19 volumio-salonw volumio[899]: info:
Apr 18 13:31:19 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:19 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:19 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:19 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:31:19 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:19 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:19 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:19 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:31:19 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:19 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:19 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:19 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:19 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":171591,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:19 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:19 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:19 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:19 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:19 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:19 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:19 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:19 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:19 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:19 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:19 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:19 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:19 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:19 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:19 volumio-salonw volumio[899]: info: ------------------------------ 9ms
Apr 18 13:31:19 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:20 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:20 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 18 13:31:20 volumio-salonw volumio[899]: info: CURURI: music-library
Apr 18 13:31:20 volumio-salonw volumio[899]: error: Failed LSINFO: null
Apr 18 13:31:20 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:22 volumio-salonw volumio[899]: info:
Apr 18 13:31:22 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:22 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:22 volumio-salonw volumio[899]: info:
Apr 18 13:31:22 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:22 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:22 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:22 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:31:22 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:22 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:22 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:22 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:31:22 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:22 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:22 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:22 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:22 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":174587,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:22 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:22 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:22 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:22 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:22 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:22 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:22 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:22 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:22 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:22 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:22 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:22 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:22 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:22 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:22 volumio-salonw volumio[899]: info: ------------------------------ 6ms
Apr 18 13:31:22 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:23 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:24 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: mixcloud , handleBrowseUri
Apr 18 13:31:24 volumio-salonw volumio[899]: info: [mixcloud] browseUri: mixcloud
Apr 18 13:31:24 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:24 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:24 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:24 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:24 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:24 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:25 volumio-salonw volumio[899]: info:
Apr 18 13:31:25 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:25 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:25 volumio-salonw volumio[899]: info:
Apr 18 13:31:25 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:25 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:25 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:25 volumio-salonw volumio[899]: info: ------------------------------ 3ms
Apr 18 13:31:25 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:25 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:25 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:25 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:31:25 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:25 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:25 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:25 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:25 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":177590,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:25 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:25 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:25 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:25 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:25 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:25 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:25 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:25 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:25 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:25 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:25 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:25 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:25 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:25 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:25 volumio-salonw volumio[899]: info: ------------------------------ 10ms
Apr 18 13:31:26 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:26 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:28 volumio-salonw volumio[899]: info:
Apr 18 13:31:28 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:28 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:28 volumio-salonw volumio[899]: info:
Apr 18 13:31:28 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:28 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:28 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:28 volumio-salonw volumio[899]: info: ------------------------------ 3ms
Apr 18 13:31:28 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:28 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:28 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:28 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:31:28 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:28 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:28 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:28 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:28 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":180587,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:28 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:28 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:28 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:28 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:28 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:28 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:28 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:28 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:28 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:28 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:28 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:28 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:28 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:28 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:28 volumio-salonw volumio[899]: info: ------------------------------ 10ms
Apr 18 13:31:29 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:29 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:29 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: bandcamp , handleBrowseUri
Apr 18 13:31:29 volumio-salonw volumio[899]: info: [bandcamp-browse] browseUri: bandcamp
Apr 18 13:31:31 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:31 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:31 volumio-salonw volumio[899]: info:
Apr 18 13:31:31 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:31 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:31 volumio-salonw volumio[899]: info:
Apr 18 13:31:31 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:31 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:31 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:31 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:31:31 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:31 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:31 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:31 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 18 13:31:31 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:31 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:31 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:31 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:31 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":183595,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:31 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:31 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:31 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:31 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:31 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:31 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:31 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:31 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:31 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:31 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:31 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:31 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:31 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:31 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:31 volumio-salonw volumio[899]: info: ------------------------------ 7ms
Apr 18 13:31:31 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:32 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:33 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 18 13:31:34 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:34 volumio-salonw volumio[899]: info:
Apr 18 13:31:34 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:34 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:34 volumio-salonw volumio[899]: info:
Apr 18 13:31:34 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:34 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:34 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:34 volumio-salonw volumio[899]: info: ------------------------------ 0ms
Apr 18 13:31:34 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:34 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:34 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:34 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:31:34 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:34 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:34 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:34 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:34 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":186592,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:34 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:34 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:34 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:34 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:34 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:34 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:34 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:34 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:34 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:34 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:34 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:34 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:34 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:34 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:34 volumio-salonw volumio[899]: info: ------------------------------ 6ms
Apr 18 13:31:34 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:35 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 18 13:31:37 volumio-salonw volumio[899]: error: Error browsing0:Error: Did not get any response from server:
Apr 18 13:31:37 volumio-salonw volumio[899]: error: Failed to execute browseSource:
Apr 18 13:31:37 volumio-salonw volumio[899]: info:
Apr 18 13:31:37 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:37 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:37 volumio-salonw volumio[899]: info:
Apr 18 13:31:37 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:37 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:37 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:37 volumio-salonw volumio[899]: info: ------------------------------ 2ms
Apr 18 13:31:37 volumio-salonw volumio[899]: info: sendMpdCommand status took 0 milliseconds
Apr 18 13:31:37 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:37 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:37 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:31:37 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:37 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:37 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":189588,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:37 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:37 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:37 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:37 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:37 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:37 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:37 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:37 volumio-salonw volumio[899]: info: ------------------------------ 9ms
Apr 18 13:31:37 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:38 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 18 13:31:40 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:40 volumio-salonw volumio[899]: info:
Apr 18 13:31:40 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:40 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:40 volumio-salonw volumio[899]: info:
Apr 18 13:31:40 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:40 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:40 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:40 volumio-salonw volumio[899]: info: ------------------------------ 2ms
Apr 18 13:31:40 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:40 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:40 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:40 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:31:40 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:40 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:40 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":192345,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:40 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:40 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:40 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:40 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:40 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:40 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:40 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:40 volumio-salonw volumio[899]: info: ------------------------------ 7ms
Apr 18 13:31:40 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:40 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:43 volumio-salonw volumio[899]: info:
Apr 18 13:31:43 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:43 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:43 volumio-salonw volumio[899]: info:
Apr 18 13:31:43 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:43 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:43 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:43 volumio-salonw volumio[899]: info: ------------------------------ 2ms
Apr 18 13:31:43 volumio-salonw volumio[899]: info: sendMpdCommand status took 1 milliseconds
Apr 18 13:31:43 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:43 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:43 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:31:43 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:43 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:43 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:43 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:43 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":195588,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:43 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:43 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:43 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:43 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:43 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:43 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:43 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:43 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:43 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:43 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:43 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:43 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:43 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:43 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:43 volumio-salonw volumio[899]: info: ------------------------------ 10ms
Apr 18 13:31:43 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:44 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:44 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 18 13:31:44 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 18 13:31:46 volumio-salonw volumio[899]: info: Preload queue cleared
Apr 18 13:31:46 volumio-salonw volumio[899]: info:
Apr 18 13:31:46 volumio-salonw volumio[899]: ---------------------------- MPD announces system playlist update
Apr 18 13:31:46 volumio-salonw volumio[899]: info: Ignoring MPD Status Update
Apr 18 13:31:46 volumio-salonw volumio[899]: info:
Apr 18 13:31:46 volumio-salonw volumio[899]: ---------------------------- MPD announces state update: player
Apr 18 13:31:46 volumio-salonw volumio[899]: info: ControllerMpd::getState
Apr 18 13:31:46 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand status
Apr 18 13:31:46 volumio-salonw volumio[899]: info: ------------------------------ 1ms
Apr 18 13:31:46 volumio-salonw volumio[899]: info: sendMpdCommand status took 0 milliseconds
Apr 18 13:31:46 volumio-salonw volumio[899]: verbose: ControllerMpd::parseState
Apr 18 13:31:46 volumio-salonw volumio[899]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 18 13:31:46 volumio-salonw volumio[899]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 18 13:31:46 volumio-salonw volumio[899]: verbose: ControllerMpd::parseTrackInfo
Apr 18 13:31:46 volumio-salonw volumio[899]: info: ControllerMpd::pushState
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CoreCommandRouter::servicePushState
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CorePlayQueue::getTrack 0
Apr 18 13:31:46 volumio-salonw volumio[899]: verbose: STATE SERVICE {"status":"play","position":0,"seek":198584,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"CHICO SCIENCE - Maracatu Atômico","artist":"stream","album":null,"uri":"https://stream10.xdevel.com/audio12s976748-1798/stream/icecast.audio","trackType":"audio"}
Apr 18 13:31:46 volumio-salonw volumio[899]: verbose: CURRENT POSITION 0
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CoreStateMachine::syncState stateService play
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CoreStateMachine::syncState currentStatus play
Apr 18 13:31:46 volumio-salonw volumio[899]: info: Received an update from plugin. extracting info from payload
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:46 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:46 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CoreStateMachine::pushState
Apr 18 13:31:46 volumio-salonw volumio[899]: info: CoreCommandRouter::volumioPushState
Apr 18 13:31:46 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output update for this device
Apr 18 13:31:46 volumio-salonw volumio[899]: info: MRS: Pushing multiroomSync output
Apr 18 13:31:46 volumio-salonw volumio[899]: info: ------------------------------ 5ms
Apr 18 13:31:46 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:47 volumio-salonw volumio[899]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100
Apr 18 13:31:49 volumio-salonw volumio[899]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Apr 18 13:31:49 volumio-salonw volumio[899]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 18 13:31:49 volumio-salonw volumio[899]: TypeError: Cannot read property 'length' of undefined
Apr 18 13:31:49 volumio-salonw volumio[899]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25
Apr 18 13:31:49 volumio-salonw volumio[899]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13
Apr 18 13:31:49 volumio-salonw volumio[899]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18)
Apr 18 13:31:49 volumio-salonw volumio[899]: at Parser.emit (events.js:315:20)
Apr 18 13:31:49 volumio-salonw volumio[899]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26)
Apr 18 13:31:49 volumio-salonw volumio[899]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
Apr 18 13:31:49 volumio-salonw volumio[899]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
Apr 18 13:31:49 volumio-salonw volumio[899]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
Apr 18 13:31:49 volumio-salonw volumio[899]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
Apr 18 13:31:49 volumio-salonw volumio[899]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31)
Apr 18 13:31:49 volumio-salonw volumio[899]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
Apr 18 13:31:49 volumio-salonw volumio[899]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19)
Apr 18 13:31:49 volumio-salonw volumio[899]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15)
Apr 18 13:31:49 volumio-salonw volumio[899]: at IncomingMessage.emit (events.js:327:22)
Apr 18 13:31:49 volumio-salonw volumio[899]: at endReadableNT (internal/streams/readable.js:1327:12)
Apr 18 13:31:49 volumio-salonw volumio[899]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Apr 18 13:31:49 volumio-salonw volumio[899]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 18 13:31:50 volumio-salonw sudo[19088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-18 13:30
Apr 18 13:31:50 volumio-salonw sudo[19088]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"