-- Logs begin at Sun 2024-04-28 12:11:21 UTC, end at Sun 2024-04-28 12:41:52 UTC. -- Apr 28 12:40:00 volumio volumio[984]: info: Pushing metadata Apr 28 12:40:00 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:00 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:00 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:00 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:00 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:00 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:00 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:00 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:01 volumio volumio[984]: info: Pushing metadata Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:01 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:01 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:01 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:01 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:01 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:01 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:01 volumio volumio[984]: info: Pushing metadata Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:01 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:01 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:01 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:01 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:01 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:02 volumio volumio[984]: info: Pushing metadata Apr 28 12:40:02 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:02 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:02 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:02 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: Pushing metadata Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: Pushing metadata Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: Pushing metadata Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: Pushing metadata Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:06 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:06 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:12 volumio vtcs[1412]: VTCS PCM name: 'plughw:2,0' Apr 28 12:40:12 volumio vtcs[1412]: [2024-04-28 12:40:12] [info] asio async_shutdown error: asio.misc:2 (End of file) Apr 28 12:40:15 volumio volumio[984]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 12:40:15 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 12:40:15 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Apr 28 12:40:15 volumio volumio[984]: info: CoreCommandRouter::volumioGetQueue Apr 28 12:40:15 volumio volumio[984]: info: CoreStateMachine::getQueue Apr 28 12:40:15 volumio volumio[984]: info: CorePlayQueue::getQueue Apr 28 12:40:15 volumio volumio[984]: info: Listing playlists Apr 28 12:40:15 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 28 12:40:22 volumio volumio[984]: info: Unknown command: notifyPlaybackError Apr 28 12:40:22 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:22 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:22 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:22 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:30 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:30 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:30 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:30 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:44 volumio vtcs[1412]: [2024-04-28 12:40:44] [info] asio async_shutdown error: asio.misc:2 (End of file) Apr 28 12:40:52 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:40:52 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:40:52 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:40:52 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:40:57 volumio vtcs[1412]: [2024-04-28 12:40:57] [info] asio async_shutdown error: asio.misc:2 (End of file) Apr 28 12:41:02 volumio volumio[984]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 12:41:02 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 12:41:02 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Apr 28 12:41:02 volumio volumio[984]: info: CoreCommandRouter::volumioGetQueue Apr 28 12:41:02 volumio volumio[984]: info: CoreStateMachine::getQueue Apr 28 12:41:02 volumio volumio[984]: info: CorePlayQueue::getQueue Apr 28 12:41:02 volumio volumio[984]: info: Listing playlists Apr 28 12:41:02 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 28 12:41:05 volumio volumio[984]: info: Tunnel connection is inactive, restarting it Apr 28 12:41:05 volumio volumio[984]: info: Starting Tunnel 1 Apr 28 12:41:05 volumio volumio[984]: info: Starting Tunnel Connection Checker Apr 28 12:41:06 volumio sudo[6067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 28 12:41:06 volumio sudo[6067]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 12:41:06 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Apr 28 12:41:06 volumio autossh[5598]: received signal to exit (15) Apr 28 12:41:06 volumio systemd[1]: Starting MyVolumio SSH Tunnel... Apr 28 12:41:06 volumio volumio[984]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 28 12:41:06 volumio volumio[984]: BT PLUGIN MESSAGE: Playing: false Apr 28 12:41:06 volumio volumio[984]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect Apr 28 12:41:06 volumio volumio[984]: BT PLUGIN MESSAGE: STATE:undefined Apr 28 12:41:06 volumio systemd[1]: Started MyVolumio SSH Tunnel. Apr 28 12:41:06 volumio sudo[6067]: pam_unix(sudo:session): session closed for user root Apr 28 12:41:06 volumio volumio[984]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 28 12:41:06 volumio volumio[984]: BT PLUGIN MESSAGE: Playing: false Apr 28 12:41:06 volumio volumio[984]: BT PLUGIN MESSAGE: VOLATILE: tidalconnect Apr 28 12:41:06 volumio volumio[984]: BT PLUGIN MESSAGE: STATE:undefined Apr 28 12:41:06 volumio autossh[6075]: port set to 0, monitoring disabled Apr 28 12:41:06 volumio autossh[6075]: starting ssh (count 1) Apr 28 12:41:06 volumio autossh[6075]: ssh child pid is 6080 Apr 28 12:41:06 volumio volumio[984]: info: Remote SSH Started Apr 28 12:41:06 volumio volumio[984]: info: CoreCommandRouter::volumioGetState Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::ClearQueue Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::stop Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::serviceStop Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::serviceStop Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::clearPlayQueue Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::saveQueue Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioPushQueue Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::addQueueItems Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::addQueueItems Apr 28 12:41:07 volumio volumio[984]: info: Adding Item to queue: webrns/1 Apr 28 12:41:07 volumio volumio[984]: info: Exploding uri webrns/1 in service nowyswiat Apr 28 12:41:07 volumio volumio[984]: info: [ ================== >>>> ] [RADIONOWYSWIAT] explodeUri: webrns/1 Apr 28 12:41:07 volumio volumio[984]: info: [ ================== >>>> ] [RADIONOWYSWIAT] channel: 1 Apr 28 12:41:07 volumio volumio[984]: info: [ ================== >>>> ] [RADIONOWYSWIAT] RNS_Link: http://stream.rcs.revma.com/ypqt40u0x1zuv Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::saveQueue Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioPushQueue Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::updateTrackBlock Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrackBlock Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioPlay Apr 28 12:41:07 volumio volumio[984]: UNSET VOLATILE Apr 28 12:41:07 volumio volumio[984]: info: unSetVolatile called Apr 28 12:41:07 volumio volumio[984]: info: Relinquishing Volumio State to another service Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::play index 0 Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::stop Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 12:41:07 volumio volumio[984]: UNSET VOLATILE Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::stPlaybackTimer Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::updateTrackBlock Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrackBlock Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::serviceStop Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::serviceStop Apr 28 12:41:07 volumio volumio[984]: info: ControllerMpd::stop Apr 28 12:41:07 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 12:41:07 volumio volumio[984]: info: PlaybackInactive Apr 28 12:41:07 volumio volumio[984]: info: Device Session is_active: true Apr 28 12:41:07 volumio volumio[984]: info: DeviceInactive Apr 28 12:41:07 volumio volumio[984]: info: Relinquishing Volumio State Apr 28 12:41:07 volumio volumio[984]: UNSET VOLATILE Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::resetVolumioState Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::getcurrentVolume Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioRetrievevolume Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:07 volumio volumio[984]: info: sendMpdCommand stop took 62 milliseconds Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:07 volumio volumio[984]: verbose: STATE SERVICE {"status":"stop"} Apr 28 12:41:07 volumio volumio[984]: verbose: CURRENT POSITION 0 Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::syncState stateService stop Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::syncState currentStatus stop Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:07 volumio volumio[984]: info: No code Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:07 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::play index undefined Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::startPlaybackTimer Apr 28 12:41:07 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:07 volumio volumio[984]: info: [ ================== >>>> ] [RADIONOWYSWIAT] Stream 256Kb: http://stream.rcs.revma.com/ypqt40u0x1zuv Apr 28 12:41:07 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand stop Apr 28 12:41:07 volumio volumio[984]: info: sendMpdCommand stop took 58 milliseconds Apr 28 12:41:07 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand clear Apr 28 12:41:07 volumio volumio[984]: info: Apr 28 12:41:07 volumio volumio[984]: ---------------------------- MPD announces system playlist update Apr 28 12:41:07 volumio volumio[984]: info: Ignoring MPD Status Update Apr 28 12:41:07 volumio volumio[984]: info: sendMpdCommand clear took 2 milliseconds Apr 28 12:41:07 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand add "http://stream.rcs.revma.com/ypqt40u0x1zuv" Apr 28 12:41:07 volumio volumio[984]: error: updateQueue error: null Apr 28 12:41:07 volumio volumio[984]: info: Apr 28 12:41:07 volumio volumio[984]: ---------------------------- MPD announces system playlist update Apr 28 12:41:07 volumio volumio[984]: info: Ignoring MPD Status Update Apr 28 12:41:07 volumio volumio[984]: info: ------------------------------ 2ms Apr 28 12:41:07 volumio volumio[984]: info: sendMpdCommand add "http://stream.rcs.revma.com/ypqt40u0x1zuv" took 2 milliseconds Apr 28 12:41:07 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand play Apr 28 12:41:07 volumio volumio[984]: info: ------------------------------ 4ms Apr 28 12:41:07 volumio volumio[984]: info: sendMpdCommand play took 4 milliseconds Apr 28 12:41:07 volumio volumio[984]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 28 12:41:13 volumio volumio[984]: info: Apr 28 12:41:13 volumio volumio[984]: ---------------------------- MPD announces state update: player Apr 28 12:41:13 volumio volumio[984]: info: ControllerMpd::getState Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand status Apr 28 12:41:13 volumio volumio[984]: info: Apr 28 12:41:13 volumio volumio[984]: ---------------------------- MPD announces state update: player Apr 28 12:41:13 volumio volumio[984]: info: ControllerMpd::getState Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand status Apr 28 12:41:13 volumio volumio[984]: info: Apr 28 12:41:13 volumio volumio[984]: ---------------------------- MPD announces system playlist update Apr 28 12:41:13 volumio volumio[984]: info: Ignoring MPD Status Update Apr 28 12:41:13 volumio volumio[984]: info: sendMpdCommand status took 2 milliseconds Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::parseState Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 12:41:13 volumio volumio[984]: info: sendMpdCommand status took 3 milliseconds Apr 28 12:41:13 volumio volumio[984]: info: ------------------------------ 2ms Apr 28 12:41:13 volumio volumio[984]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::parseState Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 12:41:13 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::parseTrackInfo Apr 28 12:41:13 volumio volumio[984]: info: ControllerMpd::pushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:41:13 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:13 volumio volumio[984]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ypqt40u0x1zuv","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Apr 28 12:41:13 volumio volumio[984]: verbose: CURRENT POSITION 0 Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::syncState stateService play Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::syncState currentStatus stop Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:13 volumio volumio[984]: info: ------------------------------ 16ms Apr 28 12:41:13 volumio volumio[984]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::parseTrackInfo Apr 28 12:41:13 volumio volumio[984]: info: ControllerMpd::pushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:41:13 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:13 volumio volumio[984]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ypqt40u0x1zuv","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Apr 28 12:41:13 volumio volumio[984]: verbose: CURRENT POSITION 0 Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::syncState stateService play Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::syncState currentStatus play Apr 28 12:41:13 volumio volumio[984]: info: Received an update from plugin. extracting info from payload Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:13 volumio volumio[984]: info: ------------------------------ 29ms Apr 28 12:41:13 volumio volumio[984]: info: Apr 28 12:41:13 volumio volumio[984]: ---------------------------- MPD announces system playlist update Apr 28 12:41:13 volumio volumio[984]: info: Ignoring MPD Status Update Apr 28 12:41:13 volumio volumio[984]: info: Apr 28 12:41:13 volumio volumio[984]: ---------------------------- MPD announces state update: player Apr 28 12:41:13 volumio volumio[984]: info: ControllerMpd::getState Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand status Apr 28 12:41:13 volumio volumio[984]: info: ------------------------------ 2ms Apr 28 12:41:13 volumio volumio[984]: info: sendMpdCommand status took 1 milliseconds Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::parseState Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 28 12:41:13 volumio volumio[984]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 28 12:41:13 volumio volumio[984]: verbose: ControllerMpd::parseTrackInfo Apr 28 12:41:13 volumio volumio[984]: info: ControllerMpd::pushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::servicePushState Apr 28 12:41:13 volumio volumio[984]: info: CorePlayQueue::getTrack 0 Apr 28 12:41:13 volumio volumio[984]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Renata Przemyk - Odjazd","artist":"Radio Nowy Swiat","album":null,"uri":"http://stream.rcs.revma.com/ypqt40u0x1zuv","trackType":""} Apr 28 12:41:13 volumio volumio[984]: verbose: CURRENT POSITION 0 Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::syncState stateService play Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::syncState currentStatus play Apr 28 12:41:13 volumio volumio[984]: info: Received an update from plugin. extracting info from payload Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:13 volumio volumio[984]: info: CoreStateMachine::pushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::volumioPushState Apr 28 12:41:13 volumio volumio[984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 12:41:13 volumio volumio[984]: info: ------------------------------ 16ms Apr 28 12:41:16 volumio volumiossh-tunnel[6073]: ssh_exchange_identification: read: Connection reset by peer Apr 28 12:41:16 volumio autossh[6075]: ssh exited prematurely with status 255; autossh exiting Apr 28 12:41:16 volumio systemd[1]: sshtunnel.service holdoff time over, scheduling restart. Apr 28 12:41:16 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Apr 28 12:41:16 volumio systemd[1]: Starting MyVolumio SSH Tunnel... Apr 28 12:41:16 volumio systemd[1]: Started MyVolumio SSH Tunnel. Apr 28 12:41:16 volumio autossh[6107]: port set to 0, monitoring disabled Apr 28 12:41:16 volumio autossh[6107]: starting ssh (count 1) Apr 28 12:41:16 volumio autossh[6107]: ssh child pid is 6110 Apr 28 12:41:19 volumio volumiossh-tunnel[6106]: Warning: Permanently added '[eu9.myvolumio.org]:2222,[164.92.213.40]:2222' (RSA) to the list of known hosts. Apr 28 12:41:52 volumio volumio[984]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 12:41:52 volumio volumio[984]: { Error: connect ETIMEDOUT 146.75.118.79:443 Apr 28 12:41:52 volumio volumio[984]: at Object._errnoException (util.js:1022:11) Apr 28 12:41:52 volumio volumio[984]: at _exceptionWithHostPort (util.js:1044:20) Apr 28 12:41:52 volumio volumio[984]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 28 12:41:52 volumio volumio[984]: code: 'ETIMEDOUT', Apr 28 12:41:52 volumio volumio[984]: errno: 'ETIMEDOUT', Apr 28 12:41:52 volumio volumio[984]: syscall: 'connect', Apr 28 12:41:52 volumio volumio[984]: address: '146.75.118.79', Apr 28 12:41:52 volumio volumio[984]: port: 443 } Apr 28 12:41:52 volumio volumio[984]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 12:41:52 volumio sudo[6213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-28 12:40 Apr 28 12:41:52 volumio sudo[6213]: 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="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6" VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021" VOLUMIO_VERSION="2.907" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"