-- Logs begin at Fri 2026-01-02 23:41:11 IST, end at Fri 2026-01-09 09:49:34 IST. -- Jan 09 09:48:03 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:48:13 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:48:13 volumio volumio[981]: info: Listing playlists Jan 09 09:48:13 volumio volumio[981]: info: Listing playlists Jan 09 09:48:18 volumio go-librespot[1437]: time="2026-01-09T09:48:18+05:30" level=trace msg="sent dealer ping" Jan 09 09:48:18 volumio go-librespot[1437]: time="2026-01-09T09:48:18+05:30" level=trace msg="received dealer pong" Jan 09 09:48:23 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:48:33 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:48:33 volumio volumio[981]: info: Listing playlists Jan 09 09:48:33 volumio volumio[981]: info: Listing playlists Jan 09 09:48:43 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:48:48 volumio go-librespot[1437]: time="2026-01-09T09:48:48+05:30" level=trace msg="received accesspoint ping" Jan 09 09:48:48 volumio go-librespot[1437]: time="2026-01-09T09:48:48+05:30" level=trace msg="received accesspoint pong ack" Jan 09 09:48:48 volumio go-librespot[1437]: time="2026-01-09T09:48:48+05:30" level=trace msg="sent dealer ping" Jan 09 09:48:48 volumio go-librespot[1437]: time="2026-01-09T09:48:48+05:30" level=trace msg="received dealer pong" Jan 09 09:48:53 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:48:53 volumio volumio[981]: info: Listing playlists Jan 09 09:48:53 volumio volumio[981]: info: Listing playlists Jan 09 09:49:03 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:49:13 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:49:13 volumio volumio[981]: info: Listing playlists Jan 09 09:49:13 volumio volumio[981]: info: Listing playlists Jan 09 09:49:18 volumio go-librespot[1437]: time="2026-01-09T09:49:18+05:30" level=trace msg="sent dealer ping" Jan 09 09:49:18 volumio go-librespot[1437]: time="2026-01-09T09:49:18+05:30" level=trace msg="received dealer pong" Jan 09 09:49:23 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:49:33 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:49:33 volumio volumio[981]: info: Listing playlists Jan 09 09:49:33 volumio volumio[981]: info: Listing playlists Jan 09 09:49:33 volumio volumio[981]: info: Jan 09 09:49:33 volumio volumio[981]: ---------------------------- Client requests Volumio play Jan 09 09:49:33 volumio volumio[981]: info: CoreCommandRouter::volumioPlay Jan 09 09:49:33 volumio volumio[981]: verbose: UNSET VOLATILE: Service: squeezelite_mc Jan 09 09:49:33 volumio volumio[981]: info: [squeezelite_mc] Pushing empty state... Jan 09 09:49:33 volumio volumio[981]: info: CoreCommandRouter::servicePushState Jan 09 09:49:33 volumio volumio[981]: info: CoreStateMachine::pushState Jan 09 09:49:33 volumio volumio[981]: info: CoreCommandRouter::volumioPushState Jan 09 09:49:33 volumio volumio[981]: info: CoreCommandRouter::servicePushState Jan 09 09:49:33 volumio volumio[981]: info: CoreStateMachine::pushState Jan 09 09:49:33 volumio volumio[981]: info: CoreCommandRouter::volumioPushState Jan 09 09:49:33 volumio volumio[981]: info: CoreStateMachine::play index undefined Jan 09 09:49:33 volumio volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 09:49:33 volumio volumio[981]: info: CorePlayQueue::getTrack 0 Jan 09 09:49:33 volumio volumio[981]: info: CoreStateMachine::startPlaybackTimer Jan 09 09:49:33 volumio volumio[981]: info: CorePlayQueue::getTrack 0 Jan 09 09:49:33 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand play Jan 09 09:49:33 volumio volumio[981]: info: [ASDebug] CurState: pause PrevState: pause Jan 09 09:49:33 volumio volumio[981]: info: [ASDebug] CurState: pause PrevState: pause Jan 09 09:49:33 volumio volumio[981]: info: sendMpdCommand play took 18 milliseconds Jan 09 09:49:33 volumio volumio[981]: info: CoreCommandRouter::servicePushState Jan 09 09:49:33 volumio volumio[981]: info: CorePlayQueue::getTrack 0 Jan 09 09:49:33 volumio volumio[981]: verbose: STATE SERVICE {"status":"play"} Jan 09 09:49:33 volumio volumio[981]: verbose: CURRENT POSITION 0 Jan 09 09:49:33 volumio volumio[981]: info: CoreStateMachine::syncState stateService play Jan 09 09:49:33 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus pause Jan 09 09:49:33 volumio volumio[981]: info: CoreStateMachine::pushState Jan 09 09:49:33 volumio volumio[981]: info: CorePlayQueue::getTrack 0 Jan 09 09:49:33 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 09 09:49:33 volumio volumio[981]: info: CoreCommandRouter::volumioPushState Jan 09 09:49:33 volumio volumio[981]: info: [1767932373236] [RadioParadise] getMetadata started with url undefined Jan 09 09:49:33 volumio volumio[981]: info: [ASDebug] CurState: play PrevState: pause Jan 09 09:49:33 volumio volumio[981]: info: [ASDebug] Togle GPIO: ON Jan 09 09:49:33 volumio volumio[981]: info: CoreCommandRouter::volumioGetState Jan 09 09:49:33 volumio volumio[981]: info: CorePlayQueue::getTrack 0 Jan 09 09:49:33 volumio volumio[981]: info: [1767932373272] [RadioParadise] Error: connect ECONNREFUSED 127.0.0.1:443 Jan 09 09:49:33 volumio volumio[981]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 09:49:33 volumio volumio[981]: TypeError: Cannot read property 'toUpperCase' of undefined Jan 09 09:49:33 volumio volumio[981]: at ControllerRadioParadise.errorToast (/data/plugins/music_service/radio_paradise/index.js:481:41) Jan 09 09:49:33 volumio volumio[981]: at ClientRequest. (/data/plugins/music_service/radio_paradise/index.js:452:14) Jan 09 09:49:33 volumio volumio[981]: at ClientRequest.emit (events.js:315:20) Jan 09 09:49:33 volumio volumio[981]: at TLSSocket.socketErrorListener (_http_client.js:469:9) Jan 09 09:49:33 volumio volumio[981]: at TLSSocket.emit (events.js:315:20) Jan 09 09:49:33 volumio volumio[981]: at emitErrorNT (internal/streams/destroy.js:106:8) Jan 09 09:49:33 volumio volumio[981]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Jan 09 09:49:33 volumio volumio[981]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 09 09:49:33 volumio volumio[981]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 09:49:34 volumio sudo[27443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-09 09:48 Jan 09 09:49:34 volumio sudo[27443]: 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"