-- Logs begin at Fri 2025-07-11 16:23:53 CEST, end at Fri 2025-07-11 19:28:47 CEST. -- Jul 11 19:28:25 lenovio volumio[955]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 11 19:28:25 lenovio volumio[955]: info: Preload queue cleared Jul 11 19:28:27 lenovio volumio[955]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 11 19:28:27 lenovio volumio[955]: info: Preload queue cleared Jul 11 19:28:29 lenovio volumio[955]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 11 19:28:30 lenovio volumio[955]: info: Preload queue cleared Jul 11 19:28:31 lenovio volumio[955]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 11 19:28:31 lenovio volumio[955]: info: Preload queue cleared Jul 11 19:28:32 lenovio volumio[955]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 11 19:28:33 lenovio volumio[955]: info: Preload queue cleared Jul 11 19:28:34 lenovio volumio[955]: info: Preload queue cleared Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::ClearQueue Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::stop Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::stPlaybackTimer Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::updateTrackBlock Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrackBlock Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::pushState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioPushState Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioGetState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output update for this device Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::serviceStop Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::serviceStop Jul 11 19:28:34 lenovio volumio[955]: info: ControllerMpd::stop Jul 11 19:28:34 lenovio volumio[955]: verbose: ControllerMpd::sendMpdCommand stop Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::clearPlayQueue Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::saveQueue Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioPushQueue Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::addQueueItems Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::addQueueItems Jul 11 19:28:34 lenovio volumio[955]: info: Preload queue cleared Jul 11 19:28:34 lenovio volumio[955]: info: Adding Item to queue: upnp/folder/http://192.168.1.166:2869/upnphost/udhisapi.dll?control=uuid:a5fdbebc-67c3-44f0-bf27-8b0d5b6780c6+urn:upnp-org:serviceId:ContentDirectory@15_73dfc309_a474f7e3 Jul 11 19:28:34 lenovio volumio[955]: info: Exploding uri upnp/folder/http://192.168.1.166:2869/upnphost/udhisapi.dll?control=uuid:a5fdbebc-67c3-44f0-bf27-8b0d5b6780c6+urn:upnp-org:serviceId:ContentDirectory@15_73dfc309_a474f7e3 in service upnp_browser Jul 11 19:28:34 lenovio volumio[955]: info: PeppyMeterBasic ---peppymeterbasic status stop Jul 11 19:28:34 lenovio sudo[28868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jul 11 19:28:34 lenovio sudo[28868]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 19:28:34 lenovio systemd[1]: Stopping peppymeterbasic Daemon... Jul 11 19:28:34 lenovio systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Jul 11 19:28:34 lenovio volumio[955]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 19:28:34 lenovio volumio[955]: info: Jul 11 19:28:34 lenovio volumio[955]: ---------------------------- MPD announces state update: player Jul 11 19:28:34 lenovio volumio[955]: info: sendMpdCommand stop took 24 milliseconds Jul 11 19:28:34 lenovio volumio[955]: info: ControllerMpd::getState Jul 11 19:28:34 lenovio volumio[955]: verbose: ControllerMpd::sendMpdCommand status Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::servicePushState Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::pushState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioPushState Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioGetState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output update for this device Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is4-ssl.mzstatic.com/image/thumb/Music114/v4/1f/e9/f1/1fe9f141-378f-ee04-df3d-d2034539b227/source/600x600bb.jpg","name":"Johnny Hates Jazz - Turn Back the Clock","title":"Turn Back the Clock","artist":"80s80s Love","album":"","streaming":true,"disableUiControls":true,"duration":"251","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 11 19:28:34 lenovio volumio[955]: verbose: CURRENT POSITION 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::syncState stateService stop Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::syncState currentStatus stop Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::pushState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioPushState Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioGetState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output update for this device Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output Jul 11 19:28:34 lenovio volumio[955]: info: No code Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::pushState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioPushState Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioGetState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output update for this device Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output Jul 11 19:28:34 lenovio volumio[955]: info: sendMpdCommand status took 6 milliseconds Jul 11 19:28:34 lenovio volumio[955]: verbose: ControllerMpd::parseState Jul 11 19:28:34 lenovio volumio[955]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 19:28:34 lenovio volumio[955]: info: PeppyMeterBasic ---peppymeterbasic status stop Jul 11 19:28:34 lenovio volumio[955]: info: PeppyMeterBasic ---peppymeterbasic status stop Jul 11 19:28:34 lenovio sudo[28871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jul 11 19:28:34 lenovio sudo[28871]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 19:28:34 lenovio volumio[955]: info: PeppyMeterBasic ---peppymeterbasic status stop Jul 11 19:28:34 lenovio sudo[28874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jul 11 19:28:34 lenovio sudo[28874]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 19:28:34 lenovio sudo[28877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jul 11 19:28:34 lenovio sudo[28877]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 19:28:34 lenovio volumio[955]: info: sendMpdCommand playlistinfo took 33 milliseconds Jul 11 19:28:34 lenovio volumio[955]: verbose: ControllerMpd::parseTrackInfo Jul 11 19:28:34 lenovio volumio[955]: info: ControllerMpd::pushState Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::servicePushState Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::pushState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioPushState Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioGetState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output update for this device Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: 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":"Johnny Hates Jazz - Turn Back the Clock","artist":"80s80s Love","album":null,"uri":"http://streams.80s80s.de/love/mp3-192/volumio","trackType":""} Jul 11 19:28:34 lenovio volumio[955]: verbose: CURRENT POSITION 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::syncState stateService stop Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::syncState currentStatus stop Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::pushState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioPushState Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioGetState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output update for this device Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output Jul 11 19:28:34 lenovio volumio[955]: info: No code Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::pushState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioPushState Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioGetState Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output update for this device Jul 11 19:28:34 lenovio volumio[955]: info: MRS: Pushing multiroomSync output Jul 11 19:28:34 lenovio volumio[955]: info: ------------------------------ 48ms Jul 11 19:28:34 lenovio volumio[955]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 11 19:28:34 lenovio volumio[955]: info: PeppyMeterBasic ---peppymeterbasic status stop Jul 11 19:28:34 lenovio volumio[955]: info: PeppyMeterBasic ---peppymeterbasic status stop Jul 11 19:28:34 lenovio systemd[1]: peppymeterbasic.service: Succeeded. Jul 11 19:28:34 lenovio systemd[1]: Stopped peppymeterbasic Daemon. Jul 11 19:28:34 lenovio sudo[28880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jul 11 19:28:34 lenovio sudo[28880]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 19:28:34 lenovio sudo[28877]: pam_unix(sudo:session): session closed for user root Jul 11 19:28:34 lenovio volumio[955]: info: PeppyMeterBasic ---peppymeterbasic status stop Jul 11 19:28:34 lenovio sudo[28868]: pam_unix(sudo:session): session closed for user root Jul 11 19:28:34 lenovio sudo[28871]: pam_unix(sudo:session): session closed for user root Jul 11 19:28:34 lenovio sudo[28874]: pam_unix(sudo:session): session closed for user root Jul 11 19:28:34 lenovio sudo[28883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jul 11 19:28:34 lenovio sudo[28883]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 19:28:34 lenovio sudo[28880]: pam_unix(sudo:session): session closed for user root Jul 11 19:28:34 lenovio sudo[28883]: pam_unix(sudo:session): session closed for user root Jul 11 19:28:34 lenovio sudo[28886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jul 11 19:28:34 lenovio sudo[28886]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 19:28:34 lenovio sudo[28886]: pam_unix(sudo:session): session closed for user root Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioPushQueue Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::saveQueue Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::updateTrackBlock Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrackBlock Jul 11 19:28:34 lenovio volumio[955]: info: CoreCommandRouter::volumioPlay Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::play index 0 Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::stop Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::play index undefined Jul 11 19:28:34 lenovio volumio[955]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 19:28:34 lenovio volumio[955]: info: CorePlayQueue::getTrack 0 Jul 11 19:28:34 lenovio volumio[955]: info: peppymeterbasic Daemon Stop Jul 11 19:28:34 lenovio volumio[955]: info: peppymeterbasic Daemon Stop Jul 11 19:28:34 lenovio volumio[955]: info: peppymeterbasic Daemon Stop Jul 11 19:28:34 lenovio volumio[955]: info: peppymeterbasic Daemon Stop Jul 11 19:28:34 lenovio volumio[955]: info: peppymeterbasic Daemon Stop Jul 11 19:28:34 lenovio volumio[955]: info: peppymeterbasic Daemon Stop Jul 11 19:28:34 lenovio volumio[955]: info: peppymeterbasic Daemon Stop Jul 11 19:28:47 lenovio volumio[955]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 11 19:28:47 lenovio volumio[955]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 19:28:47 lenovio volumio[955]: TypeError: Cannot read property 'length' of undefined Jul 11 19:28:47 lenovio volumio[955]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jul 11 19:28:47 lenovio volumio[955]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jul 11 19:28:47 lenovio volumio[955]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jul 11 19:28:47 lenovio volumio[955]: at Parser.emit (events.js:400:28) Jul 11 19:28:47 lenovio volumio[955]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jul 11 19:28:47 lenovio volumio[955]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jul 11 19:28:47 lenovio volumio[955]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jul 11 19:28:47 lenovio volumio[955]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jul 11 19:28:47 lenovio volumio[955]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jul 11 19:28:47 lenovio volumio[955]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jul 11 19:28:47 lenovio volumio[955]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jul 11 19:28:47 lenovio volumio[955]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jul 11 19:28:47 lenovio volumio[955]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jul 11 19:28:47 lenovio volumio[955]: at IncomingMessage.emit (events.js:412:35) Jul 11 19:28:47 lenovio volumio[955]: at endReadableNT (internal/streams/readable.js:1333:12) Jul 11 19:28:47 lenovio volumio[955]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jul 11 19:28:47 lenovio volumio[955]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 19:28:47 lenovio sudo[28915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-11 19:27 Jul 11 19:28:47 lenovio sudo[28915]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"