-- Logs begin at Sun 2026-01-11 09:42:10 UTC, end at Sun 2026-01-11 09:47:54 UTC. -- Jan 11 09:46:04 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: mixcloud , handleBrowseUri Jan 11 09:46:04 volumio volumio[836]: info: [mixcloud] browseUri: mixcloud Jan 11 09:46:05 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:05 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:05 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:05 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:05 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:05 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:08 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:08 volumio volumio[836]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::ClearQueue Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:08 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue Jan 11 09:46:08 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:46:08 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::addQueueItems Jan 11 09:46:08 volumio volumio[836]: info: CorePlayQueue::addQueueItems Jan 11 09:46:08 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:08 volumio volumio[836]: info: Adding Item to queue: mixcloud/liveStreams@inSection=1/user@username=MrsDennisNewsagent@playTarget=liveStream Jan 11 09:46:08 volumio volumio[836]: info: Exploding uri mixcloud/liveStreams@inSection=1/user@username=MrsDennisNewsagent@playTarget=liveStream in service mixcloud Jan 11 09:46:08 volumio volumio[836]: info: [mixcloud] explodeUri: mixcloud/liveStreams@inSection=1/user@username=MrsDennisNewsagent@playTarget=liveStream Jan 11 09:46:08 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:46:08 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock Jan 11 09:46:08 volumio volumio[836]: info: CorePlayQueue::getTrackBlock Jan 11 09:46:08 volumio volumio[836]: info: CoreCommandRouter::volumioPlay Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::play index 0 Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::play index undefined Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:08 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:08 volumio volumio[836]: info: CoreStateMachine::startPlaybackTimer Jan 11 09:46:08 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:08 volumio volumio[836]: info: [mixcloud] clearAddPlayTrack: mixcloud/liveStream@username=MrsDennisNewsagent Jan 11 09:46:08 volumio volumio[836]: info: [mixcloud] (PID: 2028) LiveStreamProxy: process spawned for cmd: streamlink \ Jan 11 09:46:08 volumio volumio[836]: "https://live-fsn1-hez.mixcloud.com/hls/10E247A3D220/1768296792/P8hOC7GPsl-kJtfVR9bdYw/26bc2d19-57bc-443a-9504-6522e5d750f0/master.m3u8" \ Jan 11 09:46:08 volumio volumio[836]: best \ Jan 11 09:46:08 volumio volumio[836]: --stdout \ Jan 11 09:46:08 volumio volumio[836]: | \ Jan 11 09:46:08 volumio volumio[836]: ffmpeg -hide_banner -loglevel error \ Jan 11 09:46:08 volumio volumio[836]: -i - \ Jan 11 09:46:08 volumio volumio[836]: -map 0:a \ Jan 11 09:46:08 volumio volumio[836]: -f mpegts \ Jan 11 09:46:08 volumio volumio[836]: -listen 1 "http://localhost:43175" Jan 11 09:46:09 volumio go-librespot[1882]: time="2026-01-11T09:46:09Z" level=trace msg="sent dealer ping" Jan 11 09:46:09 volumio go-librespot[1882]: time="2026-01-11T09:46:09Z" level=trace msg="received dealer pong" Jan 11 09:46:09 volumio volumio[836]: info: [mixcloud] (PID: 2028) LiveStreamProxy: Traceback (most recent call last): Jan 11 09:46:09 volumio volumio[836]: File "/usr/local/bin/streamlink", line 6, in Jan 11 09:46:09 volumio volumio[836]: from streamlink_cli.main import main Jan 11 09:46:09 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink_cli/main.py", line 15, in Jan 11 09:46:09 volumio volumio[836]: import streamlink.logger as logger Jan 11 09:46:09 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/__init__.py", line 19, in Jan 11 09:46:09 volumio volumio[836]: from streamlink.api import streams Jan 11 09:46:09 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/api.py", line 1, in Jan 11 09:46:09 volumio volumio[836]: from streamlink.session import Streamlink Jan 11 09:46:09 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/session.py", line 13, in Jan 11 09:46:09 volumio volumio[836]: from streamlink.logger import StreamlinkLogger Jan 11 09:46:09 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/logger.py", line 14, in Jan 11 09:46:09 volumio volumio[836]: from streamlink.utils.times import fromlocaltimestamp Jan 11 09:46:09 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/utils/__init__.py", line 5, in Jan 11 09:46:09 volumio volumio[836]: from streamlink.utils.parse import parse_html, parse_json, parse_qsd, parse_xml Jan 11 09:46:09 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/utils/parse.py", line 5, in Jan 11 09:46:09 volumio volumio[836]: from lxml.etree import HTML, XML Jan 11 09:46:09 volumio volumio[836]: ImportError: libxslt.so.1: cannot open shared object file: No such file or directory Jan 11 09:46:09 volumio volumio[836]: info: [mixcloud] (PID: 2028) LiveStreamProxy: pipe:: Invalid data found when processing input Jan 11 09:46:09 volumio volumio[836]: info: [mixcloud] (PID: 2028) LiveStreamProxy: process closed - code: 1, signal: null Jan 11 09:46:09 volumio volumio[836]: error: [mixcloud] Error getting stream: Error: Live stream obtained for user MrsDennisNewsagent, but failed to start live stream proxy for playback. Jan 11 09:46:12 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:12 volumio volumio[836]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 09:46:12 volumio volumio[836]: info: CoreStateMachine::ClearQueue Jan 11 09:46:12 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:46:12 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:12 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue Jan 11 09:46:12 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:46:12 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:46:12 volumio volumio[836]: info: CoreStateMachine::addQueueItems Jan 11 09:46:12 volumio volumio[836]: info: CorePlayQueue::addQueueItems Jan 11 09:46:12 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:12 volumio volumio[836]: info: Adding Item to queue: mixcloud/liveStreams@inSection=1/user@username=RadioVulture@playTarget=liveStream Jan 11 09:46:12 volumio volumio[836]: info: Exploding uri mixcloud/liveStreams@inSection=1/user@username=RadioVulture@playTarget=liveStream in service mixcloud Jan 11 09:46:12 volumio volumio[836]: info: [mixcloud] explodeUri: mixcloud/liveStreams@inSection=1/user@username=RadioVulture@playTarget=liveStream Jan 11 09:46:13 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:46:13 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:46:13 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock Jan 11 09:46:13 volumio volumio[836]: info: CorePlayQueue::getTrackBlock Jan 11 09:46:13 volumio volumio[836]: info: CoreCommandRouter::volumioPlay Jan 11 09:46:13 volumio volumio[836]: info: CoreStateMachine::play index 0 Jan 11 09:46:13 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:13 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:46:13 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:13 volumio volumio[836]: info: CoreStateMachine::play index undefined Jan 11 09:46:13 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:13 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:13 volumio volumio[836]: info: CoreStateMachine::startPlaybackTimer Jan 11 09:46:13 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:13 volumio volumio[836]: info: [mixcloud] clearAddPlayTrack: mixcloud/liveStream@username=RadioVulture Jan 11 09:46:13 volumio volumio[836]: info: [mixcloud] (PID: 2046) LiveStreamProxy: process spawned for cmd: streamlink \ Jan 11 09:46:13 volumio volumio[836]: "https://live-fsn1-hez.mixcloud.com/hls/10E247A1D4/1768296016/vj0GwP-YhhTHlrpiwDsRfw/f6bc56eb-ed0d-4cc5-bed7-dc0ee88228fd/master.m3u8" \ Jan 11 09:46:13 volumio volumio[836]: best \ Jan 11 09:46:13 volumio volumio[836]: --stdout \ Jan 11 09:46:13 volumio volumio[836]: | \ Jan 11 09:46:13 volumio volumio[836]: ffmpeg -hide_banner -loglevel error \ Jan 11 09:46:13 volumio volumio[836]: -i - \ Jan 11 09:46:13 volumio volumio[836]: -map 0:a \ Jan 11 09:46:13 volumio volumio[836]: -f mpegts \ Jan 11 09:46:13 volumio volumio[836]: -listen 1 "http://localhost:36031" Jan 11 09:46:13 volumio volumio[836]: info: [mixcloud] (PID: 2046) LiveStreamProxy: Traceback (most recent call last): Jan 11 09:46:13 volumio volumio[836]: File "/usr/local/bin/streamlink", line 6, in Jan 11 09:46:13 volumio volumio[836]: from streamlink_cli.main import main Jan 11 09:46:13 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink_cli/main.py", line 15, in Jan 11 09:46:13 volumio volumio[836]: import streamlink.logger as logger Jan 11 09:46:13 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/__init__.py", line 19, in Jan 11 09:46:13 volumio volumio[836]: from streamlink.api import streams Jan 11 09:46:13 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/api.py", line 1, in Jan 11 09:46:13 volumio volumio[836]: from streamlink.session import Streamlink Jan 11 09:46:13 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/session.py", line 13, in Jan 11 09:46:13 volumio volumio[836]: from streamlink.logger import StreamlinkLogger Jan 11 09:46:13 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/logger.py", line 14, in Jan 11 09:46:13 volumio volumio[836]: from streamlink.utils.times import fromlocaltimestamp Jan 11 09:46:13 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/utils/__init__.py", line 5, in Jan 11 09:46:13 volumio volumio[836]: from streamlink.utils.parse import parse_html, parse_json, parse_qsd, parse_xml Jan 11 09:46:13 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/utils/parse.py", line 5, in Jan 11 09:46:13 volumio volumio[836]: from lxml.etree import HTML, XML Jan 11 09:46:13 volumio volumio[836]: ImportError: libxslt.so.1: cannot open shared object file: No such file or directory Jan 11 09:46:13 volumio volumio[836]: info: [mixcloud] (PID: 2046) LiveStreamProxy: pipe:: Invalid data found when processing input Jan 11 09:46:13 volumio volumio[836]: info: [mixcloud] (PID: 2046) LiveStreamProxy: process closed - code: 1, signal: null Jan 11 09:46:13 volumio volumio[836]: error: [mixcloud] Error getting stream: Error: Live stream obtained for user RadioVulture, but failed to start live stream proxy for playback. Jan 11 09:46:17 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:17 volumio volumio[836]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::ClearQueue Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:17 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue Jan 11 09:46:17 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:46:17 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::addQueueItems Jan 11 09:46:17 volumio volumio[836]: info: CorePlayQueue::addQueueItems Jan 11 09:46:17 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:17 volumio volumio[836]: info: Adding Item to queue: mixcloud/liveStreams@inSection=1/user@username=FTLOHUK@playTarget=liveStream Jan 11 09:46:17 volumio volumio[836]: info: Exploding uri mixcloud/liveStreams@inSection=1/user@username=FTLOHUK@playTarget=liveStream in service mixcloud Jan 11 09:46:17 volumio volumio[836]: info: [mixcloud] explodeUri: mixcloud/liveStreams@inSection=1/user@username=FTLOHUK@playTarget=liveStream Jan 11 09:46:17 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:46:17 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock Jan 11 09:46:17 volumio volumio[836]: info: CorePlayQueue::getTrackBlock Jan 11 09:46:17 volumio volumio[836]: info: CoreCommandRouter::volumioPlay Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::play index 0 Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::play index undefined Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:17 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:17 volumio volumio[836]: info: CoreStateMachine::startPlaybackTimer Jan 11 09:46:17 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:17 volumio volumio[836]: info: [mixcloud] clearAddPlayTrack: mixcloud/liveStream@username=FTLOHUK Jan 11 09:46:17 volumio volumio[836]: info: [mixcloud] (PID: 2094) LiveStreamProxy: process spawned for cmd: streamlink \ Jan 11 09:46:17 volumio volumio[836]: "https://live-fsn1-hez.mixcloud.com/hls/10E247A1D221/1768291204/HMWdlDESDdgTeIHF8FWKjQ/2fdeb20c-c15f-418b-9193-90ce70fd869b/master.m3u8" \ Jan 11 09:46:17 volumio volumio[836]: best \ Jan 11 09:46:17 volumio volumio[836]: --stdout \ Jan 11 09:46:17 volumio volumio[836]: | \ Jan 11 09:46:17 volumio volumio[836]: ffmpeg -hide_banner -loglevel error \ Jan 11 09:46:17 volumio volumio[836]: -i - \ Jan 11 09:46:17 volumio volumio[836]: -map 0:a \ Jan 11 09:46:17 volumio volumio[836]: -f mpegts \ Jan 11 09:46:17 volumio volumio[836]: -listen 1 "http://localhost:39959" Jan 11 09:46:17 volumio volumio[836]: info: [mixcloud] (PID: 2094) LiveStreamProxy: Traceback (most recent call last): Jan 11 09:46:17 volumio volumio[836]: File "/usr/local/bin/streamlink", line 6, in Jan 11 09:46:17 volumio volumio[836]: from streamlink_cli.main import main Jan 11 09:46:17 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink_cli/main.py", line 15, in Jan 11 09:46:17 volumio volumio[836]: import streamlink.logger as logger Jan 11 09:46:17 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/__init__.py", line 19, in Jan 11 09:46:17 volumio volumio[836]: from streamlink.api import streams Jan 11 09:46:17 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/api.py", line 1, in Jan 11 09:46:17 volumio volumio[836]: from streamlink.session import Streamlink Jan 11 09:46:17 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/session.py", line 13, in Jan 11 09:46:17 volumio volumio[836]: from streamlink.logger import StreamlinkLogger Jan 11 09:46:17 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/logger.py", line 14, in Jan 11 09:46:17 volumio volumio[836]: from streamlink.utils.times import fromlocaltimestamp Jan 11 09:46:17 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/utils/__init__.py", line 5, in Jan 11 09:46:17 volumio volumio[836]: from streamlink.utils.parse import parse_html, parse_json, parse_qsd, parse_xml Jan 11 09:46:17 volumio volumio[836]: File "/usr/local/lib/python3.7/dist-packages/streamlink/utils/parse.py", line 5, in Jan 11 09:46:17 volumio volumio[836]: from lxml.etree import HTML, XML Jan 11 09:46:17 volumio volumio[836]: ImportError: libxslt.so.1: cannot open shared object file: No such file or directory Jan 11 09:46:17 volumio volumio[836]: info: [mixcloud] (PID: 2094) LiveStreamProxy: pipe:: Invalid data found when processing input Jan 11 09:46:17 volumio volumio[836]: info: [mixcloud] (PID: 2094) LiveStreamProxy: process closed - code: 1, signal: null Jan 11 09:46:17 volumio volumio[836]: error: [mixcloud] Error getting stream: Error: Live stream obtained for user FTLOHUK, but failed to start live stream proxy for playback. Jan 11 09:46:29 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:29 volumio volumio[836]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 09:46:29 volumio volumio[836]: info: CoreStateMachine::ClearQueue Jan 11 09:46:29 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:46:29 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:29 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue Jan 11 09:46:29 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:46:29 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:46:29 volumio volumio[836]: info: CoreStateMachine::addQueueItems Jan 11 09:46:29 volumio volumio[836]: info: CorePlayQueue::addQueueItems Jan 11 09:46:29 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:29 volumio volumio[836]: info: Adding Item to queue: mixcloud/discover@slug=bass Jan 11 09:46:29 volumio volumio[836]: info: Exploding uri mixcloud/discover@slug=bass in service mixcloud Jan 11 09:46:29 volumio volumio[836]: info: [mixcloud] explodeUri: mixcloud/discover@slug=bass Jan 11 09:46:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:46:30 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:46:30 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock Jan 11 09:46:30 volumio volumio[836]: info: CorePlayQueue::getTrackBlock Jan 11 09:46:30 volumio volumio[836]: info: CoreCommandRouter::volumioPlay Jan 11 09:46:30 volumio volumio[836]: info: CoreStateMachine::play index 0 Jan 11 09:46:30 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:30 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:46:30 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:30 volumio volumio[836]: info: CoreStateMachine::play index undefined Jan 11 09:46:30 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:30 volumio volumio[836]: info: CoreStateMachine::startPlaybackTimer Jan 11 09:46:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:30 volumio volumio[836]: info: [mixcloud] clearAddPlayTrack: mixcloud/cloudcast@cloudcastId=Q2xvdWRjYXN0OjIxODczMjUxNTA%3D@owner=kushsessions Jan 11 09:46:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 09:46:30 volumio volumio[836]: info: sendMpdCommand stop took 3 milliseconds Jan 11 09:46:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 09:46:30 volumio volumio[836]: info: Jan 11 09:46:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:30 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:30 volumio volumio[836]: info: sendMpdCommand clear took 2 milliseconds Jan 11 09:46:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand addid "https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8" Jan 11 09:46:30 volumio volumio[836]: info: Jan 11 09:46:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:30 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:30 volumio volumio[836]: info: Jan 11 09:46:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:30 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:30 volumio volumio[836]: error: updateQueue error: null Jan 11 09:46:30 volumio volumio[836]: info: Jan 11 09:46:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:30 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:30 volumio volumio[836]: info: ------------------------------ 8ms Jan 11 09:46:30 volumio volumio[836]: info: sendMpdCommand addid "https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8" took 6 milliseconds Jan 11 09:46:30 volumio volumio[836]: info: ------------------------------ 7ms Jan 11 09:46:30 volumio volumio[836]: info: ------------------------------ 7ms Jan 11 09:46:30 volumio volumio[836]: verbose: MPD COMMAND [object Object] Jan 11 09:46:30 volumio volumio[836]: verbose: MPD COMMAND [object Object] Jan 11 09:46:30 volumio volumio[836]: info: Jan 11 09:46:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:30 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:30 volumio volumio[836]: info: Jan 11 09:46:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:30 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:30 volumio volumio[836]: error: Upnp client error: Error: This socket has been ended by the other party Jan 11 09:46:30 volumio volumio[836]: info: Jan 11 09:46:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:30 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:30 volumio volumio[836]: info: ------------------------------ 10ms Jan 11 09:46:30 volumio volumio[836]: info: ------------------------------ 3ms Jan 11 09:46:30 volumio volumio[836]: info: ------------------------------ 4ms Jan 11 09:46:30 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 11 09:46:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand play Jan 11 09:46:30 volumio volumio[836]: info: Jan 11 09:46:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:30 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:30 volumio volumio[836]: info: Jan 11 09:46:30 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:30 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:30 volumio volumio[836]: info: ------------------------------ 6ms Jan 11 09:46:30 volumio volumio[836]: info: sendMpdCommand play took 5 milliseconds Jan 11 09:46:30 volumio volumio[836]: info: ------------------------------ 4ms Jan 11 09:46:30 volumio volumio[836]: info: ------------------------------ 2ms Jan 11 09:46:30 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: mixcloud , handleBrowseUri Jan 11 09:46:30 volumio volumio[836]: info: [mixcloud] browseUri: mixcloud/discover@slug=bass Jan 11 09:46:31 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:31 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:31 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:32 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:32 volumio volumio[836]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::ClearQueue Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:32 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue Jan 11 09:46:32 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:46:32 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::addQueueItems Jan 11 09:46:32 volumio volumio[836]: info: CorePlayQueue::addQueueItems Jan 11 09:46:32 volumio volumio[836]: info: Preload queue cleared Jan 11 09:46:32 volumio volumio[836]: info: Adding Item to queue: mixcloud/discover@slug=bass/cloudcast@cloudcastId=Q2xvdWRjYXN0OjIxODczMjUxNTA%3D@showMoreFromUser=1 Jan 11 09:46:32 volumio volumio[836]: info: Exploding uri mixcloud/discover@slug=bass/cloudcast@cloudcastId=Q2xvdWRjYXN0OjIxODczMjUxNTA%3D@showMoreFromUser=1 in service mixcloud Jan 11 09:46:32 volumio volumio[836]: info: [mixcloud] explodeUri: mixcloud/discover@slug=bass/cloudcast@cloudcastId=Q2xvdWRjYXN0OjIxODczMjUxNTA%3D@showMoreFromUser=1 Jan 11 09:46:32 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:46:32 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock Jan 11 09:46:32 volumio volumio[836]: info: CorePlayQueue::getTrackBlock Jan 11 09:46:32 volumio volumio[836]: info: CoreCommandRouter::volumioPlay Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::play index 0 Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::play index undefined Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:46:32 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:32 volumio volumio[836]: info: CoreStateMachine::startPlaybackTimer Jan 11 09:46:32 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:32 volumio volumio[836]: info: [mixcloud] clearAddPlayTrack: mixcloud/cloudcast@cloudcastId=Q2xvdWRjYXN0OjIxODczMjUxNTA%3D@owner=kushsessions Jan 11 09:46:32 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 09:46:34 volumio volumio[836]: info: sendMpdCommand stop took 1416 milliseconds Jan 11 09:46:34 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:46:34 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:46:34 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:46:34 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:46:34 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:46:34 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:46:34 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:34 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:34 volumio volumio[836]: info: sendMpdCommand clear took 5 milliseconds Jan 11 09:46:34 volumio volumio[836]: info: sendMpdCommand status took 5 milliseconds Jan 11 09:46:34 volumio volumio[836]: info: sendMpdCommand status took 4 milliseconds Jan 11 09:46:34 volumio volumio[836]: info: sendMpdCommand status took 4 milliseconds Jan 11 09:46:34 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand addid "https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8" Jan 11 09:46:34 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:46:34 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:46:34 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:46:34 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:46:34 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:46:34 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:34 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:34 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 09:46:34 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:34 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:34 volumio volumio[836]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mixcloud Received mpd Jan 11 09:46:34 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:46:34 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:46:34 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:34 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:34 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:34 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:34 volumio volumio[836]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mixcloud Received mpd Jan 11 09:46:34 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:46:34 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:46:34 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:34 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:34 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:34 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:34 volumio volumio[836]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mixcloud Received mpd Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 40ms Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 38ms Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 38ms Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:34 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:34 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:34 volumio volumio[836]: error: updateQueue error: null Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:34 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 42ms Jan 11 09:46:34 volumio volumio[836]: info: sendMpdCommand addid "https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8" took 40 milliseconds Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 6ms Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 5ms Jan 11 09:46:34 volumio volumio[836]: verbose: MPD COMMAND [object Object] Jan 11 09:46:34 volumio volumio[836]: verbose: MPD COMMAND [object Object] Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:34 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:34 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:34 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:34 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:34 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:34 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 18ms Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 14ms Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 13ms Jan 11 09:46:34 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 11 09:46:34 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand play Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:34 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:34 volumio volumio[836]: info: Jan 11 09:46:34 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:46:34 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 8ms Jan 11 09:46:34 volumio volumio[836]: info: sendMpdCommand play took 6 milliseconds Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 5ms Jan 11 09:46:34 volumio volumio[836]: info: ------------------------------ 4ms Jan 11 09:46:36 volumio volumio[836]: info: Jan 11 09:46:36 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:46:36 volumio volumio[836]: info: Jan 11 09:46:36 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:46:36 volumio volumio[836]: info: Jan 11 09:46:36 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand status took 12 milliseconds Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:46:36 volumio volumio[836]: info: Jan 11 09:46:36 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:46:36 volumio volumio[836]: info: Jan 11 09:46:36 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:46:36 volumio volumio[836]: info: Jan 11 09:46:36 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand status took 16 milliseconds Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand status took 16 milliseconds Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand status took 5 milliseconds Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:46:36 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:36 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":17478,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"#004 KushFlow (Melodic Drum & Bass Mix)","artist":"kushsessions","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"} Jan 11 09:46:36 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus stop Jan 11 09:46:36 volumio volumio[836]: info: ------------------------------ 28ms Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand status took 12 milliseconds Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand status took 11 milliseconds Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:46:36 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:36 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":834,"duration":17478,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"#004 KushFlow (Melodic Drum & Bass Mix)","artist":"kushsessions","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"} Jan 11 09:46:36 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play Jan 11 09:46:36 volumio volumio[836]: info: Received an update from plugin. extracting info from payload Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:46:36 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:36 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":17478,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"#004 KushFlow (Melodic Drum & Bass Mix)","artist":"kushsessions","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"} Jan 11 09:46:36 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play Jan 11 09:46:36 volumio volumio[836]: info: Received an update from plugin. extracting info from payload Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:46:36 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:36 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":17478,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"#004 KushFlow (Melodic Drum & Bass Mix)","artist":"kushsessions","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"} Jan 11 09:46:36 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play Jan 11 09:46:36 volumio volumio[836]: info: Received an update from plugin. extracting info from payload Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:36 volumio volumio[836]: info: ------------------------------ 86ms Jan 11 09:46:36 volumio volumio[836]: info: ------------------------------ 86ms Jan 11 09:46:36 volumio volumio[836]: info: ------------------------------ 75ms Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand playlistinfo took 61 milliseconds Jan 11 09:46:36 volumio volumio[836]: info: sendMpdCommand playlistinfo took 60 milliseconds Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:46:36 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:46:36 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:36 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":17478,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"#004 KushFlow (Melodic Drum & Bass Mix)","artist":"kushsessions","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"} Jan 11 09:46:36 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play Jan 11 09:46:36 volumio volumio[836]: info: Received an update from plugin. extracting info from payload Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:36 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:46:36 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:46:36 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":17478,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"#004 KushFlow (Melodic Drum & Bass Mix)","artist":"kushsessions","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"} Jan 11 09:46:36 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play Jan 11 09:46:36 volumio volumio[836]: info: Received an update from plugin. extracting info from payload Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:36 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:46:36 volumio volumio[836]: info: ------------------------------ 127ms Jan 11 09:46:36 volumio volumio[836]: info: ------------------------------ 126ms Jan 11 09:46:36 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:36 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:36 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:36 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:36 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:36 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:36 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:36 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:36 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:36 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:46:36 volumio volumio[836]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 11 09:46:36 volumio volumio[836]: info: CoreCommandRouter::volumioGetState Jan 11 09:46:37 volumio volumio[836]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Jan 11 09:46:37 volumio volumio[836]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 11 09:46:39 volumio go-librespot[1882]: time="2026-01-11T09:46:39Z" level=trace msg="sent dealer ping" Jan 11 09:46:39 volumio go-librespot[1882]: time="2026-01-11T09:46:39Z" level=trace msg="received dealer pong" Jan 11 09:47:07 volumio go-librespot[1882]: time="2026-01-11T09:47:07Z" level=trace msg="received accesspoint ping" Jan 11 09:47:07 volumio go-librespot[1882]: time="2026-01-11T09:47:07Z" level=trace msg="received accesspoint pong ack" Jan 11 09:47:09 volumio go-librespot[1882]: time="2026-01-11T09:47:09Z" level=trace msg="sent dealer ping" Jan 11 09:47:09 volumio go-librespot[1882]: time="2026-01-11T09:47:09Z" level=trace msg="received dealer pong" Jan 11 09:47:17 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 11 09:47:17 volumio volumio[836]: info: CURURI: music-library Jan 11 09:47:17 volumio volumio[836]: info: Preload queue cleared Jan 11 09:47:20 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 11 09:47:20 volumio volumio[836]: info: CURURI: music-library/NAS Jan 11 09:47:21 volumio volumio[836]: info: Preload queue cleared Jan 11 09:47:21 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 11 09:47:21 volumio volumio[836]: info: CURURI: music-library/NAS/All_music Jan 11 09:47:22 volumio volumio[836]: info: Preload queue cleared Jan 11 09:47:24 volumio volumio[836]: Upnp client error: Error: This socket has been ended by the other party Jan 11 09:47:25 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 11 09:47:25 volumio volumio[836]: info: CURURI: music-library/NAS/All_music/FLAC music Jan 11 09:47:25 volumio volumio[836]: info: Preload queue cleared Jan 11 09:47:25 volumio volumio[836]: info: Preloading song: music-library/NAS/All_music/FLAC music/La Mejor Musica para Entrenar en el GYM 2017 - Workout Motivation Music 3.mp3 Jan 11 09:47:25 volumio volumio[836]: info: Preloading song: music-library/NAS/All_music/FLAC music/Legendary Massive Badass Workout Music Mix Vol2.mp3 Jan 11 09:47:25 volumio volumio[836]: info: Preloading song: music-library/NAS/All_music/FLAC music/Top 10 Car Bass Music 2017 Bass Boosted Songs for Car.mp3 Jan 11 09:47:25 volumio volumio[836]: info: Exploding uri music-library/NAS/All_music/FLAC music/La Mejor Musica para Entrenar en el GYM 2017 - Workout Motivation Music 3.mp3 in service mpd Jan 11 09:47:25 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=//extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2FLa%20Mejor%20Musica%20para%20Entrenar%20en%20el%20GYM%202017%20-%20Workout%20Motivation%20Music%203.mp3&metadata=false Jan 11 09:47:25 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/La Mejor Musica para Entrenar en el GYM 2017 - Workout Motivation Music 3.mp3 Jan 11 09:47:25 volumio volumio[836]: info: Exploding uri music-library/NAS/All_music/FLAC music/Legendary Massive Badass Workout Music Mix Vol2.mp3 in service mpd Jan 11 09:47:25 volumio volumio[836]: info: Exploding uri music-library/NAS/All_music/FLAC music/Top 10 Car Bass Music 2017 Bass Boosted Songs for Car.mp3 in service mpd Jan 11 09:47:25 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=//extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2FLegendary%20Massive%20Badass%20Workout%20Music%20Mix%20%20Vol2.mp3&metadata=false Jan 11 09:47:25 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/Legendary Massive Badass Workout Music Mix Vol2.mp3 Jan 11 09:47:25 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=//extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2FTop%2010%20Car%20Bass%20Music%202017%20Bass%20Boosted%20Songs%20for%20Car.mp3&metadata=false Jan 11 09:47:25 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/Top 10 Car Bass Music 2017 Bass Boosted Songs for Car.mp3 Jan 11 09:47:29 volumio volumio[836]: info: Preload queue cleared Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::ClearQueue Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::stPlaybackTimer Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::getTrackBlock Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::serviceStop Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::serviceStop Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 11 09:47:29 volumio volumio[836]: info: ControllerMpd::stop Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::addQueueItems Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::addQueueItems Jan 11 09:47:29 volumio volumio[836]: info: Preload queue cleared Jan 11 09:47:29 volumio volumio[836]: info: Adding Item to queue: music-library/NAS/All_music/FLAC music/1980 - Joy Division - Closer Jan 11 09:47:29 volumio volumio[836]: info: Exploding uri music-library/NAS/All_music/FLAC music/1980 - Joy Division - Closer in service mpd Jan 11 09:47:29 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:29 volumio volumio[836]: info: touch_display: Setting screensaver timeout to 120 seconds. Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand stop took 66 milliseconds Jan 11 09:47:29 volumio volumio[836]: info: Jan 11 09:47:29 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:47:29 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=//extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F1980%20-%20Joy%20Division%20-%20Closer%2F02%20Isolation.flac&metadata=false Jan 11 09:47:29 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/1980 - Joy Division - Closer/02 Isolation.flac Jan 11 09:47:29 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=//extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F1980%20-%20Joy%20Division%20-%20Closer%2F03%20Passover.flac&metadata=false Jan 11 09:47:29 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/1980 - Joy Division - Closer/03 Passover.flac Jan 11 09:47:29 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=//extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F1980%20-%20Joy%20Division%20-%20Closer%2F04%20Colony.flac&metadata=false Jan 11 09:47:29 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/1980 - Joy Division - Closer/04 Colony.flac Jan 11 09:47:29 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=//extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F1980%20-%20Joy%20Division%20-%20Closer%2F05%20A%20means%20to%20an%20end.flac&metadata=false Jan 11 09:47:29 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/1980 - Joy Division - Closer/05 A means to an end.flac Jan 11 09:47:29 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=//extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F1980%20-%20Joy%20Division%20-%20Closer%2F07%20Twenty%20four%20hours.flac&metadata=false Jan 11 09:47:29 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/1980 - Joy Division - Closer/07 Twenty four hours.flac Jan 11 09:47:29 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=//extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F1980%20-%20Joy%20Division%20-%20Closer%2F08%20The%20eternal.flac&metadata=false Jan 11 09:47:29 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/1980 - Joy Division - Closer/08 The eternal.flac Jan 11 09:47:29 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::getTrackBlock Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::volumioPlay Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::play index 0 Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::play index undefined Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::startPlaybackTimer Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::clearAddPlayTracks NAS/All_music/FLAC music/1980 - Joy Division - Closer/02 Isolation.flac Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 09:47:29 volumio volumio[836]: info: Jan 11 09:47:29 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:47:29 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:47:29 volumio volumio[836]: info: Jan 11 09:47:29 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:47:29 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand status took 17 milliseconds Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand stop took 4 milliseconds Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand status took 3 milliseconds Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand status took 2 milliseconds Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:47:29 volumio volumio[836]: info: Jan 11 09:47:29 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:47:29 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand clear took 5 milliseconds Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand add "NAS/All_music/FLAC music/1980 - Joy Division - Closer/02 Isolation.flac" Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:47:29 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:29 volumio volumio[836]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"#004 KushFlow (Melodic Drum & Bass Mix)","artist":"kushsessions","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f,8/3/6/5/5681-8d73-451d-8af1-9e77bf6c086f-192K,.m4a.urlset/index.m3u8","trackType":"m3u8"} Jan 11 09:47:29 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::syncState stateService stop Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus stop Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:29 volumio volumio[836]: info: No code Jan 11 09:47:29 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:29 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:29 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:29 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 09:47:29 volumio volumio[836]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 09:47:29 volumio volumio[836]: info: ------------------------------ 60ms Jan 11 09:47:29 volumio volumio[836]: info: ------------------------------ 39ms Jan 11 09:47:29 volumio volumio[836]: info: ------------------------------ 38ms Jan 11 09:47:29 volumio volumio[836]: info: Jan 11 09:47:29 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:47:29 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:47:29 volumio volumio[836]: info: Jan 11 09:47:29 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:47:29 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:47:29 volumio volumio[836]: error: updateQueue error: null Jan 11 09:47:29 volumio volumio[836]: info: Jan 11 09:47:29 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:47:29 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:47:29 volumio volumio[836]: info: ------------------------------ 36ms Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand add "NAS/All_music/FLAC music/1980 - Joy Division - Closer/02 Isolation.flac" took 35 milliseconds Jan 11 09:47:29 volumio volumio[836]: info: ------------------------------ 5ms Jan 11 09:47:29 volumio volumio[836]: info: ------------------------------ 4ms Jan 11 09:47:29 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand play Jan 11 09:47:29 volumio volumio[836]: info: Jan 11 09:47:29 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:47:29 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:47:29 volumio volumio[836]: info: Jan 11 09:47:29 volumio volumio[836]: ---------------------------- MPD announces system playlist update Jan 11 09:47:29 volumio volumio[836]: info: Ignoring MPD Status Update Jan 11 09:47:29 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:29 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:29 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:29 volumio volumio[836]: info: ------------------------------ 18ms Jan 11 09:47:29 volumio volumio[836]: info: sendMpdCommand play took 15 milliseconds Jan 11 09:47:29 volumio volumio[836]: info: ------------------------------ 14ms Jan 11 09:47:29 volumio volumio[836]: info: ------------------------------ 12ms Jan 11 09:47:30 volumio volumio[836]: info: Jan 11 09:47:30 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:47:30 volumio volumio[836]: info: Jan 11 09:47:30 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:47:30 volumio volumio[836]: info: Jan 11 09:47:30 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:47:30 volumio volumio[836]: info: Jan 11 09:47:30 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand status took 13 milliseconds Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand status took 12 milliseconds Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand status took 12 milliseconds Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:47:30 volumio volumio[836]: info: Jan 11 09:47:30 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:47:30 volumio volumio[836]: info: Jan 11 09:47:30 volumio volumio[836]: ---------------------------- MPD announces state update: player Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::getState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand status Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand status took 6 milliseconds Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand status took 4 milliseconds Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand status took 3 milliseconds Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseState Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":173,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"02 Isolation.flac","artist":null,"album":null,"uri":"NAS/All_music/FLAC music/1980 - Joy Division - Closer/02 Isolation.flac","trackType":"flac"} Jan 11 09:47:30 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus stop Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":173,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"02 Isolation.flac","artist":null,"album":null,"uri":"NAS/All_music/FLAC music/1980 - Joy Division - Closer/02 Isolation.flac","trackType":"flac"} Jan 11 09:47:30 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play Jan 11 09:47:30 volumio volumio[836]: info: Received an update from plugin. extracting info from payload Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":173,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"02 Isolation.flac","artist":null,"album":null,"uri":"NAS/All_music/FLAC music/1980 - Joy Division - Closer/02 Isolation.flac","trackType":"flac"} Jan 11 09:47:30 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play Jan 11 09:47:30 volumio volumio[836]: info: Received an update from plugin. extracting info from payload Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:30 volumio volumio[836]: info: ------------------------------ 39ms Jan 11 09:47:30 volumio volumio[836]: info: ------------------------------ 64ms Jan 11 09:47:30 volumio volumio[836]: info: ------------------------------ 64ms Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand playlistinfo took 53 milliseconds Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand playlistinfo took 53 milliseconds Jan 11 09:47:30 volumio volumio[836]: info: sendMpdCommand playlistinfo took 53 milliseconds Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:47:30 volumio volumio[836]: verbose: ControllerMpd::parseTrackInfo Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":173,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"02 Isolation.flac","artist":null,"album":null,"uri":"NAS/All_music/FLAC music/1980 - Joy Division - Closer/02 Isolation.flac","trackType":"flac"} Jan 11 09:47:30 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play Jan 11 09:47:30 volumio volumio[836]: info: Received an update from plugin. extracting info from payload Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":173,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"02 Isolation.flac","artist":null,"album":null,"uri":"NAS/All_music/FLAC music/1980 - Joy Division - Closer/02 Isolation.flac","trackType":"flac"} Jan 11 09:47:30 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play Jan 11 09:47:30 volumio volumio[836]: info: Received an update from plugin. extracting info from payload Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:30 volumio volumio[836]: info: ControllerMpd::pushState Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::servicePushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":173,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"849 Kbps","isStreaming":false,"title":"02 Isolation.flac","artist":null,"album":null,"uri":"NAS/All_music/FLAC music/1980 - Joy Division - Closer/02 Isolation.flac","trackType":"flac"} Jan 11 09:47:30 volumio volumio[836]: verbose: CURRENT POSITION 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState stateService play Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::syncState currentStatus play Jan 11 09:47:30 volumio volumio[836]: info: Received an update from plugin. extracting info from payload Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:30 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:30 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:30 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:30 volumio volumio[836]: info: ------------------------------ 126ms Jan 11 09:47:30 volumio volumio[836]: info: ------------------------------ 123ms Jan 11 09:47:30 volumio volumio[836]: info: ------------------------------ 123ms Jan 11 09:47:30 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:30 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:30 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:30 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:30 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:30 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:30 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:30 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:30 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:30 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:30 volumio volumio[836]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 11 09:47:39 volumio go-librespot[1882]: time="2026-01-11T09:47:39Z" level=trace msg="sent dealer ping" Jan 11 09:47:39 volumio go-librespot[1882]: time="2026-01-11T09:47:39Z" level=trace msg="received dealer pong" Jan 11 09:47:53 volumio volumio[836]: info: Preload queue cleared Jan 11 09:47:53 volumio volumio[836]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 09:47:53 volumio volumio[836]: info: CoreStateMachine::ClearQueue Jan 11 09:47:53 volumio volumio[836]: info: CoreStateMachine::stop Jan 11 09:47:53 volumio volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 09:47:53 volumio volumio[836]: info: CoreStateMachine::stPlaybackTimer Jan 11 09:47:53 volumio volumio[836]: info: CoreStateMachine::updateTrackBlock Jan 11 09:47:53 volumio volumio[836]: info: CorePlayQueue::getTrackBlock Jan 11 09:47:53 volumio volumio[836]: info: CoreStateMachine::pushState Jan 11 09:47:53 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:53 volumio volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 09:47:53 volumio volumio[836]: info: CoreCommandRouter::volumioPushState Jan 11 09:47:53 volumio volumio[836]: info: CoreStateMachine::serviceStop Jan 11 09:47:53 volumio volumio[836]: info: CorePlayQueue::getTrack 0 Jan 11 09:47:53 volumio volumio[836]: info: CoreCommandRouter::serviceStop Jan 11 09:47:53 volumio volumio[836]: info: ControllerMpd::stop Jan 11 09:47:53 volumio volumio[836]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 09:47:53 volumio volumio[836]: info: CorePlayQueue::clearPlayQueue Jan 11 09:47:53 volumio volumio[836]: info: CorePlayQueue::saveQueue Jan 11 09:47:53 volumio volumio[836]: info: CoreCommandRouter::volumioPushQueue Jan 11 09:47:53 volumio volumio[836]: info: CoreStateMachine::addQueueItems Jan 11 09:47:53 volumio volumio[836]: info: CorePlayQueue::addQueueItems Jan 11 09:47:53 volumio volumio[836]: info: Preload queue cleared Jan 11 09:47:53 volumio volumio[836]: info: Adding Item to queue: music-library/NAS/All_music/FLAC music/2015 - Coffee Shop Selection Jan 11 09:47:53 volumio volumio[836]: info: Exploding uri music-library/NAS/All_music/FLAC music/2015 - Coffee Shop Selection in service mpd Jan 11 09:47:53 volumio volumio[836]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F01%20-%20In%20My%20City.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/01 - In My City.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F02%20-%20Virtual%20Insight.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/02 - Virtual Insight.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F03%20-%20Tranquilo.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/03 - Tranquilo.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F04%20-%20Some%20Breaks.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/04 - Some Breaks.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F05%20-%20Afternoon%20Soul.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/05 - Afternoon Soul.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F06%20-%20Just%20Jammin'.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/06 - Just Jammin'.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F07%20-%20Swucca%20Chust.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/07 - Swucca Chust.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F08%20-%20Chillaxin'%20By%20the%20Sea.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/08 - Chillaxin' By the Sea.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F09%20-%20Guitar%20Madness.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/09 - Guitar Madness.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F10%20-%20Muy%20Tranquilo.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/10 - Muy Tranquilo.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F11%20-%20No%20Way%20Out.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/11 - No Way Out.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F12%20-%20Late%20Night%20Jazz.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/12 - Late Night Jazz.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F13%20-%20Victory.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/13 - Victory.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F14%20-%20Sitar%20Chop.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/14 - Sitar Chop.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F15%20-%20Pizzi%20Chop.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/15 - Pizzi Chop.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F16%20-%20Talk%20That%20Slang.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/16 - Talk That Slang.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F17%20-%20Hold%20On.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/17 - Hold On.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F18%20-%20Indigo%20Child.flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/18 - Indigo Child.flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F19%20-%20Just%20Jammin'%20NYC%20(feat.%20Exmag).flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/19 - Just Jammin' NYC (feat. Exmag).flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F20%20-%20Faraway%20(Instrumental).flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/20 - Faraway (Instrumental).flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F21%20-%20Obviously%20(Instrumental).flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/21 - Obviously (Instrumental).flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2F22%20-%20The%20Anthem%20(Instrumental).flac&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/22 - The Anthem (Instrumental).flac Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2FGramatik%20-%20Coffee%20Shop%20Selection%20-%20FLAC.cue&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/Gramatik - Coffee Shop Selection - FLAC.cue Jan 11 09:47:53 volumio volumio[836]: info: ALBUMART /albumart?cacheid=374&web=Gramatik/Coffee%20Shop%20Selection/extralarge&path=%2Fmnt%2FNAS%2FAll_music%2FFLAC%20music%2F2015%20-%20Coffee%20Shop%20Selection%2FGramatik%20-%20Coffee%20Shop%20Selection%20-%20FLAC.cue&metadata=false Jan 11 09:47:53 volumio volumio[836]: info: URI /mnt/NAS/All_music/FLAC music/2015 - Coffee Shop Selection/Gramatik - Coffee Shop Selection - FLAC.cue Jan 11 09:47:53 volumio volumio[836]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 09:47:53 volumio volumio[836]: Error: Unable to resolve or reject the same promise twice Jan 11 09:47:53 volumio volumio[836]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jan 11 09:47:53 volumio volumio[836]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21 Jan 11 09:47:53 volumio volumio[836]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jan 11 09:47:53 volumio volumio[836]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jan 11 09:47:53 volumio volumio[836]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jan 11 09:47:53 volumio volumio[836]: at Socket.emit (events.js:315:20) Jan 11 09:47:53 volumio volumio[836]: at addChunk (internal/streams/readable.js:309:12) Jan 11 09:47:53 volumio volumio[836]: at readableAddChunk (internal/streams/readable.js:280:11) Jan 11 09:47:53 volumio volumio[836]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jan 11 09:47:53 volumio volumio[836]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jan 11 09:47:53 volumio volumio[836]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 09:47:54 volumio sudo[2500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-11 09:46 Jan 11 09:47:54 volumio sudo[2500]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"