-- Logs begin at Fri 2023-01-20 14:25:15 UTC, end at Fri 2025-10-31 05:25:23 UTC. -- Oct 31 05:24:59 volumio volumio[1309]: info: CoreCommandRouter::volumioGetState Oct 31 05:24:59 volumio volumio[1309]: info: CoreCommandRouter::volumioGetState Oct 31 05:24:59 volumio volumio[1309]: info: Currently active: webradio Oct 31 05:24:59 volumio volumio[1309]: info: Stopping currently active service Oct 31 05:24:59 volumio volumio[1309]: info: CoreCommandRouter::volumioStop Oct 31 05:24:59 volumio volumio[1309]: info: CoreStateMachine::stop Oct 31 05:24:59 volumio volumio[1309]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 31 05:24:59 volumio volumio[1309]: verbose: UNSET VOLATILE Oct 31 05:24:59 volumio volumio[1309]: info: CoreStateMachine::stPlaybackTimer Oct 31 05:24:59 volumio volumio[1309]: info: CoreStateMachine::updateTrackBlock Oct 31 05:24:59 volumio volumio[1309]: info: CorePlayQueue::getTrackBlock Oct 31 05:24:59 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:24:59 volumio volumio[1309]: info: CorePlayQueue::getTrack 0 Oct 31 05:24:59 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:24:59 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:24:59 volumio volumio[1309]: info: CoreStateMachine::serviceStop Oct 31 05:24:59 volumio volumio[1309]: info: CorePlayQueue::getTrack 0 Oct 31 05:24:59 volumio volumio[1309]: info: CoreCommandRouter::serviceStop Oct 31 05:24:59 volumio volumio[1309]: info: [1761888299935] ControllerWebradio::stop Oct 31 05:24:59 volumio volumio[1309]: verbose: ControllerMpd::sendMpdCommand stop Oct 31 05:25:00 volumio volumio[1309]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 31 05:25:00 volumio volumio[1309]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 31 05:25:00 volumio volumio[1309]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 31 05:25:00 volumio vtcs[1924]: [2025-10-31 05:25:00.504] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:1 Oct 31 05:25:00 volumio volumio[1309]: info: Pushing metadata Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:00 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:00 volumio volumio[1309]: info: CorePlayQueue::getTrack 0 Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:00 volumio volumio[1309]: info: CorePlayQueue::getTrack 0 Oct 31 05:25:00 volumio volumio[1309]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:00 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:00 volumio volumio[1309]: info: CorePlayQueue::getTrack 0 Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:00 volumio volumio[1309]: info: CorePlayQueue::getTrack 0 Oct 31 05:25:00 volumio volumio[1309]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Oct 31 05:25:00 volumio volumio[1309]: info: TidalConnect Active Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::volumioGetState Oct 31 05:25:00 volumio volumio[1309]: info: CorePlayQueue::getTrack 0 Oct 31 05:25:00 volumio volumio[1309]: info: Currently active: webradio Oct 31 05:25:00 volumio volumio[1309]: info: Setting Volatile state to tidalconnect Oct 31 05:25:00 volumio volumio[1309]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:00 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:00 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:00 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:01 volumio volumio[1309]: info: Pushing metadata Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:01 volumio vtcs[1924]: [2025-10-31 05:25:01.534] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:326] Attempting to initialize a decoder without initial data! Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:01 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:01 volumio vtcs[1924]: Segmentation fault Oct 31 05:25:01 volumio systemd[1]: vtcs.service: main process exited, code=exited, status=139/n/a Oct 31 05:25:01 volumio systemd[1]: Unit vtcs.service entered failed state. Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:02 volumio volumio[1309]: info: Oct 31 05:25:02 volumio volumio[1309]: ---------------------------- MPD announces state update: player Oct 31 05:25:02 volumio volumio[1309]: info: sendMpdCommand stop took 2559 milliseconds Oct 31 05:25:02 volumio volumio[1309]: info: ControllerMpd::getState Oct 31 05:25:02 volumio volumio[1309]: verbose: ControllerMpd::sendMpdCommand status Oct 31 05:25:02 volumio volumio[1309]: info: TidalConnect Active Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::volumioGetState Oct 31 05:25:02 volumio volumio[1309]: info: Currently active: tidalconnect Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:02 volumio volumio[1309]: info: sendMpdCommand status took 75 milliseconds Oct 31 05:25:02 volumio volumio[1309]: verbose: ControllerMpd::parseState Oct 31 05:25:02 volumio volumio[1309]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 31 05:25:02 volumio volumio[1309]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 31 05:25:02 volumio volumio[1309]: info: sendMpdCommand playlistinfo took 337 milliseconds Oct 31 05:25:02 volumio volumio[1309]: verbose: ControllerMpd::parseTrackInfo Oct 31 05:25:02 volumio volumio[1309]: info: ControllerMpd::pushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::servicePushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreStateMachine::pushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:02 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:02 volumio volumio[1309]: info: CorePlayQueue::getTrack 0 Oct 31 05:25:02 volumio volumio[1309]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 31 05:25:02 volumio volumio[1309]: info: ------------------------------ 453ms Oct 31 05:25:03 volumio volumio[1309]: info: Tunnel connection is inactive, restarting it Oct 31 05:25:03 volumio volumio[1309]: info: Starting Tunnel 1 Oct 31 05:25:03 volumio volumio[1309]: info: Starting Tunnel Connection Checker Oct 31 05:25:04 volumio sudo[14696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Oct 31 05:25:04 volumio sudo[14696]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 05:25:04 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Oct 31 05:25:04 volumio autossh[14244]: received signal to exit (15) Oct 31 05:25:04 volumio systemd[1]: Starting MyVolumio SSH Tunnel... Oct 31 05:25:04 volumio systemd[1]: Started MyVolumio SSH Tunnel. Oct 31 05:25:04 volumio volumio[1309]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 05:25:04 volumio volumio[1309]: BT PLUGIN MESSAGE: Playing: false Oct 31 05:25:04 volumio volumio[1309]: BT PLUGIN MESSAGE: VOLATILE: undefined Oct 31 05:25:04 volumio volumio[1309]: BT PLUGIN MESSAGE: STATE:undefined Oct 31 05:25:04 volumio sudo[14696]: pam_unix(sudo:session): session closed for user root Oct 31 05:25:04 volumio volumio[1309]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 31 05:25:04 volumio volumio[1309]: BT PLUGIN MESSAGE: Playing: false Oct 31 05:25:04 volumio volumio[1309]: BT PLUGIN MESSAGE: VOLATILE: undefined Oct 31 05:25:04 volumio volumio[1309]: BT PLUGIN MESSAGE: STATE:undefined Oct 31 05:25:04 volumio autossh[14704]: port set to 0, monitoring disabled Oct 31 05:25:04 volumio autossh[14704]: starting ssh (count 1) Oct 31 05:25:04 volumio autossh[14704]: ssh child pid is 14709 Oct 31 05:25:04 volumio volumio[1309]: info: Remote SSH Started Oct 31 05:25:04 volumio volumio[1309]: info: CoreCommandRouter::volumioGetState Oct 31 05:25:04 volumio volumiossh-tunnel[14702]: Warning: Permanently added '[as1.myvolumio.org]:2222,[128.199.166.162]:2222' (RSA) to the list of known hosts. Oct 31 05:25:18 volumio volumio[1309]: info: CoreCommandRouter::volumioGetVisibleSources Oct 31 05:25:18 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 05:25:18 volumio volumio[1309]: info: CoreCommandRouter::volumioGetState Oct 31 05:25:18 volumio volumio[1309]: info: CoreCommandRouter::volumioGetQueue Oct 31 05:25:18 volumio volumio[1309]: info: CoreStateMachine::getQueue Oct 31 05:25:18 volumio volumio[1309]: info: CorePlayQueue::getQueue Oct 31 05:25:18 volumio volumio[1309]: info: Listing playlists Oct 31 05:25:20 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Oct 31 05:25:20 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 31 05:25:21 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Oct 31 05:25:21 volumio volumio[1309]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 31 05:25:21 volumio volumio[1309]: info: CoreStateMachine::ClearQueue Oct 31 05:25:21 volumio volumio[1309]: info: CoreStateMachine::stop Oct 31 05:25:21 volumio volumio[1309]: info: CoreStateMachine::serviceStop Oct 31 05:25:21 volumio volumio[1309]: info: Received STOP, but no service to execute it Oct 31 05:25:21 volumio volumio[1309]: info: CorePlayQueue::clearPlayQueue Oct 31 05:25:21 volumio volumio[1309]: info: CorePlayQueue::saveQueue Oct 31 05:25:21 volumio volumio[1309]: info: CoreCommandRouter::volumioPushState Oct 31 05:25:21 volumio volumio[1309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 05:25:21 volumio volumio[1309]: info: CoreCommandRouter::volumioPushQueue Oct 31 05:25:21 volumio volumio[1309]: info: CoreStateMachine::addQueueItems Oct 31 05:25:21 volumio volumio[1309]: info: CorePlayQueue::addQueueItems Oct 31 05:25:21 volumio volumio[1309]: info: Adding Item to queue: webkbs/0 Oct 31 05:25:21 volumio volumio[1309]: info: Exploding uri webkbs/0 in service personal_radio Oct 31 05:25:22 volumio volumio[1309]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 31 05:25:22 volumio volumio[1309]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 05:25:22 volumio volumio[1309]: ReferenceError: self is not defined Oct 31 05:25:22 volumio volumio[1309]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22) Oct 31 05:25:22 volumio volumio[1309]: at /data/plugins/music_service/personal_radio/index.js:487:12 Oct 31 05:25:22 volumio volumio[1309]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:355:15) Oct 31 05:25:22 volumio volumio[1309]: at self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) Oct 31 05:25:22 volumio volumio[1309]: at emitOne (events.js:116:13) Oct 31 05:25:22 volumio volumio[1309]: at Request.emit (events.js:211:7) Oct 31 05:25:22 volumio volumio[1309]: at Request.onRequestError (/data/plugins/music_service/personal_radio/node_modules/request/request.js:813:8) Oct 31 05:25:22 volumio volumio[1309]: at emitOne (events.js:116:13) Oct 31 05:25:22 volumio volumio[1309]: at ClientRequest.emit (events.js:211:7) Oct 31 05:25:22 volumio volumio[1309]: at Socket.socketErrorListener (_http_client.js:387:9) Oct 31 05:25:22 volumio volumio[1309]: at emitOne (events.js:116:13) Oct 31 05:25:22 volumio volumio[1309]: at Socket.emit (events.js:211:7) Oct 31 05:25:22 volumio volumio[1309]: at emitErrorNT (internal/streams/destroy.js:64:8) Oct 31 05:25:22 volumio volumio[1309]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Oct 31 05:25:22 volumio volumio[1309]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 31 05:25:22 volumio volumio[1309]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 05:25:23 volumio sudo[14785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-31 05:24 Oct 31 05:25:23 volumio sudo[14785]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 30 22:42:09 CEST 2021" VOLUMIO_VERSION="2.915" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="02ee61bb422c79b6e5c0b6d1847a78d9"