-- Logs begin at Fri 2025-05-23 16:18:15 UTC, end at Fri 2025-05-23 20:45:07 UTC. --
May 23 20:44:00 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 23 20:44:02 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 23 20:44:03 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:03 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:03 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:08 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:08 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:08 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::volumioAddQueueItems
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::addQueueItems
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::addQueueItems
May 23 20:44:10 volumio volumio[2113]: info: Adding Item to queue: upnp/folder/http://192.168.0.17:2869/upnphost/udhisapi.dll?control=uuid:9e35311f-8747-4c73-8c07-fceec220d671+urn:upnp-org:serviceId:ContentDirectory@1
May 23 20:44:10 volumio volumio[2113]: info: Exploding uri upnp/folder/http://192.168.0.17:2869/upnphost/udhisapi.dll?control=uuid:9e35311f-8747-4c73-8c07-fceec220d671+urn:upnp-org:serviceId:ContentDirectory@1 in service upnp_browser
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::saveQueue
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::volumioPushQueue
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::updateTrackBlock
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrackBlock
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::volumioPlay
May 23 20:44:10 volumio volumio[2113]: UNSET VOLATILE
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::play index 55
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::setConsumeUpdateService undefined
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::stop
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::setConsumeUpdateService undefined
May 23 20:44:10 volumio volumio[2113]: UNSET VOLATILE
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::updateTrackBlock
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrackBlock
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::stPlaybackTimer
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::pushState
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::getState
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrack 54
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::volumioPushState
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::serviceStop
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrack 54
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::serviceStop
May 23 20:44:10 volumio volumio[2113]: info: ControllerMpd::stop
May 23 20:44:10 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand stop
May 23 20:44:10 volumio volumio[2113]: info: sending command...
May 23 20:44:10 volumio volumio[2113]: info: An error occurred saving queue to disk: Error: ENOSPC: no space left on device, write
May 23 20:44:10 volumio volumio[2113]: info:
May 23 20:44:10 volumio volumio[2113]: ---------------------------- MPD announces state update: player
May 23 20:44:10 volumio volumio[2113]: info: parsing response...
May 23 20:44:10 volumio volumio[2113]: info: ControllerMpd::getState
May 23 20:44:10 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand status
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::servicePushState
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::syncState
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::pushState
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::getState
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrack 54
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::volumioPushState
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrack 54
May 23 20:44:10 volumio volumio[2113]: info: STATE SERVICE {"status":"stop","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B0000296J3.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Blue Skies","title":"Blue Skies","artist":"Willie Nelson","album":"Stardust","streaming":true,"disableUiControls":true,"duration":208,"seek":114146,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
May 23 20:44:10 volumio volumio[2113]: info: CURRENT POSITION 54
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::syncState stateService stop
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::syncState currentStatus stop
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::pushState
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::getState
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrack 54
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::volumioPushState
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 20:44:10 volumio volumio[2113]: info: No code
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::pushState
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::getState
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrack 54
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::volumioPushState
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 20:44:10 volumio volumio[2113]: info: sending command...
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::play index undefined
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::setConsumeUpdateService undefined
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrack 55
May 23 20:44:10 volumio volumio[2113]: info: parsing response...
May 23 20:44:10 volumio volumio[2113]: info: ControllerMpd::parseState
May 23 20:44:10 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand playlistinfo
May 23 20:44:10 volumio volumio[2113]: info: sending command...
May 23 20:44:10 volumio volumio[2113]: info: parsing response...
May 23 20:44:10 volumio volumio[2113]: info: ControllerMpd::parseTrackInfo
May 23 20:44:10 volumio volumio[2113]: info: ControllerMpd::pushState
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::servicePushState
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::syncState
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::pushState
May 23 20:44:10 volumio volumio[2113]: info: CoreStateMachine::getState
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::volumioPushState
May 23 20:44:10 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 20:44:10 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:10 volumio volumio[2113]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
May 23 20:44:10 volumio volumio[2113]: info: ------------------------------ 64ms
May 23 20:44:13 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:13 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:13 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:14 volumio volumio[2113]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms.
May 23 20:44:15 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 23 20:44:17 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
May 23 20:44:17 volumio volumio[2113]: error: message=Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"501"}],"errorDescription":[{"_":"Action Failed"}]}]}]}]}]}}, stack=Error: Did not get expected response from server:{"Envelope":{"$":{"xmlns:SOAP-ENV":"http://schemas.xmlsoap.org/soap/envelope/","SOAP-ENV:encodingStyle":"http://schemas.xmlsoap.org/soap/encoding/"},"Body":[{"Fault":[{"faultcode":[{"_":"SOAP-ENV:Client"}],"faultstring":[{"_":"UPnPError"}],"detail":[{"UPnPError":[{"$":{"xmlns:u":"urn:schemas-upnp-org:control-1-0"},"errorCode":[{"_":"501"}],"errorDescription":[{"_":"Action Failed"}]}]}]}]}]}}
May 23 20:44:17 volumio volumio[2113]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:140:24
May 23 20:44:17 volumio volumio[2113]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:303:18)
May 23 20:44:17 volumio volumio[2113]: at emitOne (events.js:116:13)
May 23 20:44:17 volumio volumio[2113]: at Parser.emit (events.js:211:7)
May 23 20:44:17 volumio volumio[2113]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:261:26)
May 23 20:44:17 volumio volumio[2113]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35)
May 23 20:44:17 volumio volumio[2113]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5)
May 23 20:44:17 volumio volumio[2113]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7)
May 23 20:44:17 volumio volumio[2113]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13)
May 23 20:44:17 volumio volumio[2113]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:322:31)
May 23 20:44:17 volumio volumio[2113]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59)
May 23 20:44:17 volumio volumio[2113]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:354:19)
May 23 20:44:17 volumio volumio[2113]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:93:15)
May 23 20:44:17 volumio volumio[2113]: at emitNone (events.js:111:20)
May 23 20:44:17 volumio volumio[2113]: at IncomingMessage.emit (events.js:208:7)
May 23 20:44:17 volumio volumio[2113]: at endReadableNT (_stream_readable.js:1064:12)
May 23 20:44:18 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:18 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:18 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:23 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:23 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:23 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:28 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:28 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:28 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:33 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:33 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:33 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:38 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:38 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:38 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:43 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:43 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:43 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:44 volumio volumio[2113]: info: CoreCommandRouter::volumioGetState
May 23 20:44:44 volumio volumio[2113]: info: CoreStateMachine::getState
May 23 20:44:44 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:44 volumio volumio[2113]: info: CoreCommandRouter::volumioGetBrowseSources
May 23 20:44:44 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 23 20:44:44 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 23 20:44:44 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 23 20:44:44 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 23 20:44:44 volumio volumio[2113]: Plugin multiroom or method getMultiroom not found
May 23 20:44:44 volumio volumio[2113]: info: Listing playlists
May 23 20:44:44 volumio volumio[2113]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms.
May 23 20:44:48 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:48 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:48 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:49 volumio volumio[2113]: info: CoreCommandRouter::volumioPlay
May 23 20:44:49 volumio volumio[2113]: UNSET VOLATILE
May 23 20:44:49 volumio volumio[2113]: info: CoreStateMachine::play index undefined
May 23 20:44:49 volumio volumio[2113]: info: CoreStateMachine::setConsumeUpdateService undefined
May 23 20:44:49 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:49 volumio volumio[2113]: info: CoreStateMachine::startPlaybackTimer
May 23 20:44:49 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:49 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand stop
May 23 20:44:49 volumio volumio[2113]: info: sending command...
May 23 20:44:49 volumio volumio[2113]: info: parsing response...
May 23 20:44:49 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand clear
May 23 20:44:49 volumio volumio[2113]: info: sending command...
May 23 20:44:49 volumio volumio[2113]: info:
May 23 20:44:49 volumio volumio[2113]: ---------------------------- MPD announces system playlist update
May 23 20:44:49 volumio volumio[2113]: info: Ignoring MPD Status Update
May 23 20:44:49 volumio volumio[2113]: info: parsing response...
May 23 20:44:49 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand consume 1
May 23 20:44:49 volumio volumio[2113]: info: sending command...
May 23 20:44:49 volumio volumio[2113]: info:
May 23 20:44:49 volumio volumio[2113]: info: ------------------------------ 4ms
May 23 20:44:49 volumio volumio[2113]: info: parsing response...
May 23 20:44:49 volumio volumio[2113]: info: [1748033089423] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/mellow-flac
May 23 20:44:49 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/mellow-flac"
May 23 20:44:49 volumio volumio[2113]: info: sending command...
May 23 20:44:49 volumio volumio[2113]: info:
May 23 20:44:49 volumio volumio[2113]: ---------------------------- MPD announces system playlist update
May 23 20:44:49 volumio volumio[2113]: info: Ignoring MPD Status Update
May 23 20:44:49 volumio volumio[2113]: info: parsing response...
May 23 20:44:49 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand play
May 23 20:44:49 volumio volumio[2113]: info: sending command...
May 23 20:44:49 volumio volumio[2113]: info: ------------------------------ 6ms
May 23 20:44:49 volumio volumio[2113]: info: parsing response...
May 23 20:44:49 volumio volumio[2113]: info: [1748033089432] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1
May 23 20:44:50 volumio volumio[2113]: info: [1748033090125] [RadioParadise] received new metadata: {"time":281,"artist":"Sting","title":"La Belle Dame sans regrets","album":"Mercury Falling","year":"1996","cover":"https://img.radioparadise.com/covers/l/B000005ILF.jpg","cover_med":"https://img.radioparadise.com/covers/m/B000005ILF.jpg","cover_small":"https://img.radioparadise.com/covers/s/B000005ILF.jpg"}
May 23 20:44:50 volumio volumio[2113]: info: CoreStateMachine::getState
May 23 20:44:50 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:50 volumio volumio[2113]: info: CoreCommandRouter::servicePushState
May 23 20:44:50 volumio volumio[2113]: info: CoreStateMachine::syncState
May 23 20:44:50 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:50 volumio volumio[2113]: info: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B000005ILF.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"La Belle Dame sans regrets","title":"La Belle Dame sans regrets","artist":"Sting","album":"Mercury Falling","streaming":true,"disableUiControls":true,"duration":286,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
May 23 20:44:50 volumio volumio[2113]: info: CURRENT POSITION 0
May 23 20:44:50 volumio volumio[2113]: info: CoreStateMachine::syncState stateService play
May 23 20:44:50 volumio volumio[2113]: info: CoreStateMachine::syncState currentStatus stop
May 23 20:44:50 volumio volumio[2113]: info: CoreStateMachine::pushState
May 23 20:44:50 volumio volumio[2113]: info: CoreStateMachine::getState
May 23 20:44:50 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:50 volumio volumio[2113]: info: CoreCommandRouter::volumioPushState
May 23 20:44:50 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 20:44:50 volumio volumio[2113]: info: [1748033090135] [RadioParadise] setting new timer with duration of 286000 seconds.
May 23 20:44:50 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:50 volumio volumio[2113]: info: CorePlayQueue::getTrack 1
May 23 20:44:50 volumio volumio[2113]: info: Prefetching next song
May 23 20:44:50 volumio volumio[2113]: info:
May 23 20:44:50 volumio volumio[2113]: ---------------------------- MPD announces state update: player
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::getState
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand status
May 23 20:44:50 volumio volumio[2113]: info: sending command...
May 23 20:44:50 volumio volumio[2113]: info:
May 23 20:44:50 volumio volumio[2113]: ---------------------------- MPD announces system playlist update
May 23 20:44:50 volumio volumio[2113]: info: Ignoring MPD Status Update
May 23 20:44:50 volumio volumio[2113]: info:
May 23 20:44:50 volumio volumio[2113]: ---------------------------- MPD announces state update: player
May 23 20:44:50 volumio volumio[2113]: info: parsing response...
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::getState
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand status
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::parseState
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand playlistinfo
May 23 20:44:50 volumio volumio[2113]: info: sending command...
May 23 20:44:50 volumio volumio[2113]: info: sending command...
May 23 20:44:50 volumio volumio[2113]: info: ------------------------------ 18ms
May 23 20:44:50 volumio volumio[2113]: info: parsing response...
May 23 20:44:50 volumio volumio[2113]: info: parsing response...
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::parseState
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::sendMpdCommand playlistinfo
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::parseTrackInfo
May 23 20:44:50 volumio volumio[2113]: info: sending command...
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::pushState
May 23 20:44:50 volumio volumio[2113]: info: CoreCommandRouter::servicePushState
May 23 20:44:50 volumio volumio[2113]: info: CoreStateMachine::syncState
May 23 20:44:50 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:50 volumio volumio[2113]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
May 23 20:44:50 volumio volumio[2113]: info: ------------------------------ 33ms
May 23 20:44:50 volumio volumio[2113]: info: parsing response...
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::parseTrackInfo
May 23 20:44:50 volumio volumio[2113]: info: ControllerMpd::pushState
May 23 20:44:50 volumio volumio[2113]: info: CoreCommandRouter::servicePushState
May 23 20:44:50 volumio volumio[2113]: info: CoreStateMachine::syncState
May 23 20:44:50 volumio volumio[2113]: info: CorePlayQueue::getTrack 0
May 23 20:44:50 volumio volumio[2113]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
May 23 20:44:50 volumio volumio[2113]: info: ------------------------------ 30ms
May 23 20:44:53 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:53 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:53 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:44:58 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:44:58 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:44:58 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:45:00 volumio volumio[2113]: info: CoreCommandRouter::volumioGetQueue
May 23 20:45:00 volumio volumio[2113]: info: CoreStateMachine::getQueue
May 23 20:45:00 volumio volumio[2113]: info: CorePlayQueue::getQueue
May 23 20:45:03 volumio volumio[2113]: Discovery: ecc TypeError: argument 8 must be an integer (port)
May 23 20:45:03 volumio volumio[2113]: Discovery: StartAdv! false
May 23 20:45:03 volumio volumio[2113]: Discovery: Started advertising... Volumio - false
May 23 20:45:06 volumio volumio[2113]: info: CoreCommandRouter::executeOnPlugin: pandora , handleBrowseUri
May 23 20:45:06 volumio volumio[2113]: info: [1748033106179] ControllerPandora::handleBrowseUri
May 23 20:45:06 volumio volumio[2113]: info: [1748033106181] ControllerPandora::checkForExpiredStations
May 23 20:45:06 volumio volumio[2113]: info: [1748033106183] [Pandora] checkForExpiredStations: Stations expired
May 23 20:45:06 volumio volumio[2113]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 23 20:45:06 volumio volumio[2113]: TypeError: Cannot read property 'fillStationData' of undefined
May 23 20:45:06 volumio volumio[2113]: at ControllerPandora.checkForExpiredStations (/data/plugins/music_service/pandora/index.js:819:36)
May 23 20:45:06 volumio volumio[2113]: at ControllerPandora.handleBrowseUri (/data/plugins/music_service/pandora/index.js:421:17)
May 23 20:45:06 volumio volumio[2113]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1013:29)
May 23 20:45:06 volumio volumio[2113]: at CoreMusicLibrary.executeBrowseSource (/volumio/app/musiclibrary.js:328:47)
May 23 20:45:06 volumio volumio[2113]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:354:32)
May 23 20:45:06 volumio volumio[2113]: at emitTwo (events.js:126:13)
May 23 20:45:06 volumio volumio[2113]: at Socket.emit (events.js:214:7)
May 23 20:45:06 volumio volumio[2113]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
May 23 20:45:06 volumio volumio[2113]: at _combinedTickCallback (internal/process/next_tick.js:131:7)
May 23 20:45:06 volumio volumio[2113]: at process._tickCallback (internal/process/next_tick.js:180:9)
May 23 20:45:06 volumio volumio[2113]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 23 20:45:07 volumio sudo[6753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-23 20:44
May 23 20:45:07 volumio sudo[6753]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
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="7124eaf0213deb060cebb17ef631669189a6650e"
VOLUMIO_FE_VERSION="b52b5dfa93e3b26d6f23f09c91a5b90b0a43edf0"
VOLUMIO_BE_VERSION="273d2050e44b6f5ae901d967e346577f7ad86f2c"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon Aug 27 17:21:50 CEST 2018"
VOLUMIO_VERSION="2.452"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="1802c403029d39af3072f40e987e7ba4"