-- Logs begin at Fri 2024-10-18 09:18:41 CEST, end at Fri 2024-10-18 10:47:55 CEST. -- Oct 18 10:46:31 volumio volumio[1083]: error: error Oct 18 10:46:36 volumio volumio[1083]: error: error Oct 18 10:46:37 volumio volumio[1083]: error: error Oct 18 10:46:37 volumio volumio[1083]: error: error Oct 18 10:46:37 volumio volumio[1083]: error: error Oct 18 10:46:37 volumio volumio[1083]: error: error Oct 18 10:46:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 10:46:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 10:46:53 volumio volumio[1083]: info: Discovery: Getting this device information Oct 18 10:46:53 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Oct 18 10:46:53 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:46:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 18 10:46:53 volumio volumio[1083]: verbose: New Socket.io Connection to 10.0.2.20:3000 from 10.0.0.159 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Oct 18 10:46:53 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Oct 18 10:46:53 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:46:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 18 10:46:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 18 10:46:55 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 10:46:55 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 10:46:55 volumio volumio[1083]: info: Discovery: Getting this device information Oct 18 10:46:55 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Oct 18 10:46:55 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:46:55 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 18 10:46:58 volumio sudo[13734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 18 10:46:58 volumio sudo[13734]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:46:58 volumio sudo[13734]: pam_unix(sudo:session): session closed for user root Oct 18 10:46:58 volumio sudo[13737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 18 10:46:58 volumio sudo[13737]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:46:58 volumio sudo[13737]: pam_unix(sudo:session): session closed for user root Oct 18 10:46:58 volumio volumio[1083]: verbose: New Socket.io Connection to 10.0.2.20 from 10.0.0.159 UA: Mozilla/5.0 (Linux; Android 14; 23021RAA2Y Build/UKQ1.230917.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 18 10:46:59 volumio sudo[13742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 18 10:46:59 volumio sudo[13742]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:46:59 volumio sudo[13742]: pam_unix(sudo:session): session closed for user root Oct 18 10:46:59 volumio sudo[13745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 18 10:46:59 volumio sudo[13745]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:46:59 volumio sudo[13745]: pam_unix(sudo:session): session closed for user root Oct 18 10:46:59 volumio volumio[1083]: verbose: New Socket.io Connection to 10.0.2.20 from 10.0.0.159 UA: Mozilla/5.0 (Linux; Android 14; 23021RAA2Y Build/UKQ1.230917.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.100 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Oct 18 10:46:59 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Oct 18 10:46:59 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:46:59 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 18 10:46:59 volumio volumio[1083]: info: Listing playlists Oct 18 10:46:59 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 18 10:46:59 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 18 10:46:59 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 18 10:46:59 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 18 10:47:00 volumio volumio[1083]: info: CoreCommandRouter::volumioPlay Oct 18 10:47:00 volumio volumio[1083]: info: CoreStateMachine::play index undefined Oct 18 10:47:00 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 18 10:47:00 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:00 volumio volumio[1083]: info: CoreStateMachine::startPlaybackTimer Oct 18 10:47:00 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:00 volumio volumio[1083]: info: [1729241220162] ControllerWebradio::clearAddPlayTrack Oct 18 10:47:00 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand stop Oct 18 10:47:00 volumio volumio[1083]: info: sendMpdCommand stop took 2 milliseconds Oct 18 10:47:00 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand clear Oct 18 10:47:00 volumio volumio[1083]: info: sendMpdCommand clear took 1 milliseconds Oct 18 10:47:00 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand load "https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg" Oct 18 10:47:00 volumio volumio[1083]: info: Oct 18 10:47:00 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:00 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:00 volumio volumio[1083]: info: Oct 18 10:47:00 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:00 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:00 volumio volumio[1083]: info: Oct 18 10:47:00 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:00 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:00 volumio volumio[1083]: info: Oct 18 10:47:00 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:00 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:00 volumio volumio[1083]: info: Oct 18 10:47:00 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:00 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:00 volumio volumio[1083]: error: Upnp client error: Error: This socket has been ended by the other party Oct 18 10:47:01 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 18 10:47:01 volumio volumio[1083]: info: Received Get System Info Oct 18 10:47:01 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 10:47:01 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 10:47:01 volumio volumio[1083]: info: Discovery: Getting this device information Oct 18 10:47:01 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Oct 18 10:47:01 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:01 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 18 10:47:01 volumio volumio[1083]: error: updateQueue error: null Oct 18 10:47:01 volumio volumio[1083]: error: updateQueue error: null Oct 18 10:47:01 volumio volumio[1083]: error: updateQueue error: null Oct 18 10:47:01 volumio volumio[1083]: error: updateQueue error: null Oct 18 10:47:01 volumio volumio[1083]: error: updateQueue error: null Oct 18 10:47:01 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand add "https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg" Oct 18 10:47:01 volumio volumio[1083]: info: ------------------------------ 1677ms Oct 18 10:47:01 volumio volumio[1083]: info: ------------------------------ 1676ms Oct 18 10:47:01 volumio volumio[1083]: info: ------------------------------ 1676ms Oct 18 10:47:01 volumio volumio[1083]: info: ------------------------------ 1675ms Oct 18 10:47:01 volumio volumio[1083]: info: ------------------------------ 1675ms Oct 18 10:47:01 volumio volumio[1083]: info: Oct 18 10:47:01 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:01 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:01 volumio volumio[1083]: info: sendMpdCommand add "https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg" took 1 milliseconds Oct 18 10:47:01 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 18 10:47:01 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand play Oct 18 10:47:01 volumio volumio[1083]: info: Oct 18 10:47:01 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:01 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:01 volumio volumio[1083]: info: Oct 18 10:47:01 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:01 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:01 volumio volumio[1083]: info: Oct 18 10:47:01 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:01 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:01 volumio volumio[1083]: info: Oct 18 10:47:01 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:01 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:01 volumio volumio[1083]: info: ------------------------------ 5ms Oct 18 10:47:01 volumio volumio[1083]: info: sendMpdCommand play took 4 milliseconds Oct 18 10:47:01 volumio volumio[1083]: info: ------------------------------ 4ms Oct 18 10:47:01 volumio volumio[1083]: info: ------------------------------ 5ms Oct 18 10:47:01 volumio volumio[1083]: info: ------------------------------ 3ms Oct 18 10:47:01 volumio volumio[1083]: info: ------------------------------ 2ms Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:02 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 3 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 4 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 3 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 2 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 2 milliseconds Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:02 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 7 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 8ms Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 7 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 4 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 4 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 3ms Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 3 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 3 milliseconds Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:02 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:02 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:02 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:02 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 32ms Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 39ms Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 39ms Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 39ms Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 38ms Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:02 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:02 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:02 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:02 volumio volumio[1083]: info: Oct 18 10:47:02 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 31 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 31 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 29 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 29 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 28 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 28 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 4ms Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 3 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 2ms Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 2 milliseconds Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 2ms Oct 18 10:47:02 volumio volumio[1083]: info: sendMpdCommand status took 2 milliseconds Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:02 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:02 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:02 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:02 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:02 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:02 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:02 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:02 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:02 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:02 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:02 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 64ms Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 63ms Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 59ms Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 58ms Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 58ms Oct 18 10:47:02 volumio volumio[1083]: info: ------------------------------ 57ms Oct 18 10:47:02 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:02 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:02 volumio sudo[13762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:02 volumio sudo[13762]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:02 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:02 volumio sudo[13765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:02 volumio sudo[13765]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:02 volumio sudo[13769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio systemd[1]: Started peppymeterbasic Daemon. Oct 18 10:47:02 volumio sudo[13769]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:02 volumio sudo[13772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:02 volumio sudo[13772]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13775]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13778]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13781]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13784]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13787]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13762]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13791]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13795]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13765]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13775]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13772]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13781]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13787]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13791]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13778]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13784]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13769]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13798]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13795]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13798]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13801]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13801]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13804]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13804]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13807]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13807]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13810]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13810]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13813]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13813]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13816]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13816]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13819]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13819]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13822]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13822]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13825]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13828]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio systemd[1]: Started peppyspectrum Daemon. Oct 18 10:47:03 volumio sudo[13832]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13835]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13825]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13838]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13832]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13828]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13842]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13835]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13838]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13842]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13845]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13845]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13848]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13848]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13851]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13851]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13854]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13854]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13857]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13857]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13860]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13860]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13863]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13863]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13866]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13866]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13869]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13869]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13874]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13874]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13878]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13878]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13881]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13881]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13884]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13884]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13887]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio sudo[13887]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 337 milliseconds Oct 18 10:47:03 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 337 milliseconds Oct 18 10:47:03 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 337 milliseconds Oct 18 10:47:03 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:03 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:03 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:03 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:03 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:03 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:03 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:03 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:03 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:03 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:03 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:03 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:03 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:03 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:03 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:03 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"Radio BEAT - Classic Rock","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:03 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:03 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:03 volumio volumio[1083]: info: ------------------------------ 351ms Oct 18 10:47:03 volumio volumio[1083]: info: ------------------------------ 350ms Oct 18 10:47:03 volumio volumio[1083]: info: ------------------------------ 350ms Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 18 10:47:03 volumio volumio[1083]: info: Received Get System Info Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 10:47:03 volumio volumio[1083]: info: Discovery: Getting this device information Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Oct 18 10:47:03 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13890]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13890]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13893]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[13766]: libpng warning: iCCP: known incorrect sRGB profile Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio volumio[13766]: libpng warning: iCCP: known incorrect sRGB profile Oct 18 10:47:03 volumio sudo[13893]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13897]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13897]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13900]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:03 volumio sudo[13900]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13903]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[13766]: libpng warning: iCCP: known incorrect sRGB profile Oct 18 10:47:03 volumio sudo[13903]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:03 volumio sudo[13906]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13906]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13909]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13909]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13912]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13912]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13915]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13915]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13918]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:03 volumio sudo[13918]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio sudo[13921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13921]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13921]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:03 volumio sudo[13927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:03 volumio sudo[13927]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:03 volumio sudo[13927]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:03 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: Oct 18 10:47:16 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:16 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:16 volumio volumio[1083]: info: Oct 18 10:47:16 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:16 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:16 volumio volumio[1083]: info: Oct 18 10:47:16 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:16 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:16 volumio volumio[1083]: info: Oct 18 10:47:16 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:16 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:16 volumio volumio[1083]: info: Oct 18 10:47:16 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:16 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:16 volumio volumio[1083]: info: Oct 18 10:47:16 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:16 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:16 volumio volumio[1083]: info: Oct 18 10:47:16 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:16 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:16 volumio volumio[1083]: info: Oct 18 10:47:16 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:16 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:16 volumio volumio[1083]: info: Oct 18 10:47:16 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Oct 18 10:47:16 volumio volumio[1083]: info: Ignoring MPD Status Update Oct 18 10:47:16 volumio volumio[1083]: info: Oct 18 10:47:16 volumio volumio[1083]: ---------------------------- MPD announces state update: player Oct 18 10:47:16 volumio volumio[1083]: info: ControllerMpd::getState Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Oct 18 10:47:16 volumio volumio[1083]: info: ------------------------------ 5ms Oct 18 10:47:16 volumio volumio[1083]: info: sendMpdCommand status took 5 milliseconds Oct 18 10:47:16 volumio volumio[1083]: info: ------------------------------ 5ms Oct 18 10:47:16 volumio volumio[1083]: info: sendMpdCommand status took 4 milliseconds Oct 18 10:47:16 volumio volumio[1083]: info: ------------------------------ 4ms Oct 18 10:47:16 volumio volumio[1083]: info: sendMpdCommand status took 3 milliseconds Oct 18 10:47:16 volumio volumio[1083]: info: ------------------------------ 4ms Oct 18 10:47:16 volumio volumio[1083]: info: sendMpdCommand status took 3 milliseconds Oct 18 10:47:16 volumio volumio[1083]: info: ------------------------------ 3ms Oct 18 10:47:16 volumio volumio[1083]: info: sendMpdCommand status took 2 milliseconds Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::parseState Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 18 10:47:16 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 18 10:47:16 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 18 10:47:16 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 18 10:47:16 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 18 10:47:16 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:16 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Oct 18 10:47:16 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:16 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:16 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14285,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"LED ZEPPELIN - MISTY MOUNTAIN HOP","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:16 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:16 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:16 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:16 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:16 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14285,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"LED ZEPPELIN - MISTY MOUNTAIN HOP","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:16 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:16 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:16 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:16 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:16 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14285,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"LED ZEPPELIN - MISTY MOUNTAIN HOP","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:16 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:16 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:16 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:16 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:16 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14285,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"LED ZEPPELIN - MISTY MOUNTAIN HOP","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:16 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:16 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:16 volumio volumio[1083]: info: ControllerMpd::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Oct 18 10:47:16 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Oct 18 10:47:16 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":14285,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"121 Kbps","isStreaming":false,"title":"LED ZEPPELIN - MISTY MOUNTAIN HOP","artist":"RADIO BEAT","album":null,"uri":"https://n38a-eu.rcs.revma.com/3d47nqvb938uv?rj-ttl=5&rj-tok=AAABkpVrw7QAlEHezHOsFMjtxg","trackType":""} Oct 18 10:47:16 volumio volumio[1083]: verbose: CURRENT POSITION 0 Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Oct 18 10:47:16 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:16 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:16 volumio volumio[1083]: info: ------------------------------ 34ms Oct 18 10:47:16 volumio volumio[1083]: info: ------------------------------ 33ms Oct 18 10:47:16 volumio volumio[1083]: info: ------------------------------ 33ms Oct 18 10:47:16 volumio volumio[1083]: info: ------------------------------ 33ms Oct 18 10:47:16 volumio volumio[1083]: info: ------------------------------ 32ms Oct 18 10:47:16 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:16 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:16 volumio sudo[13962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:16 volumio sudo[13962]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:16 volumio sudo[13962]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:16 volumio sudo[13965]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:16 volumio sudo[13965]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:16 volumio sudo[13968]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:16 volumio sudo[13968]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:16 volumio sudo[13971]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:16 volumio sudo[13971]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:16 volumio sudo[13974]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:16 volumio sudo[13974]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:16 volumio sudo[13977]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:16 volumio sudo[13977]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:16 volumio sudo[13980]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:16 volumio sudo[13980]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:16 volumio sudo[13983]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:16 volumio sudo[13983]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:16 volumio sudo[13986]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio sudo[13986]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:16 volumio sudo[13989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:16 volumio sudo[13989]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:16 volumio sudo[13989]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:16 volumio sudo[13992]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:16 volumio sudo[13992]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:16 volumio sudo[13995]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:16 volumio sudo[13995]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[13998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:16 volumio sudo[13998]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:16 volumio sudo[13998]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[14001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:16 volumio sudo[14001]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:16 volumio sudo[14001]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[14004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:16 volumio sudo[14004]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:16 volumio sudo[14004]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[14007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:16 volumio sudo[14007]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio sudo[14007]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:16 volumio sudo[14010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:16 volumio sudo[14010]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:16 volumio sudo[14010]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[14013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:16 volumio sudo[14013]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:16 volumio sudo[14013]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio sudo[14016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:16 volumio sudo[14016]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio sudo[14016]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:16 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:16 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:16 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:16 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:16 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:16 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:16 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:16 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:16 volumio sudo[14019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:16 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Oct 18 10:47:16 volumio sudo[14019]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:16 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:16 volumio sudo[14019]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:16 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 18 10:47:17 volumio volumio[1083]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 18 10:47:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 18 10:47:17 volumio volumio[1083]: info: Received Get System Version Oct 18 10:47:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 18 10:47:17 volumio volumio[1083]: info: Received Get System Info Oct 18 10:47:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 10:47:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 10:47:17 volumio volumio[1083]: info: Discovery: Getting this device information Oct 18 10:47:17 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Oct 18 10:47:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 18 10:47:17 volumio volumio[1083]: info: VolumeController::SetAlsaVolume- Oct 18 10:47:17 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:17 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:17 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:18 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:18 volumio sudo[14027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:18 volumio sudo[14027]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:18 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 22 Oct 18 10:47:18 volumio volumio[1083]: SPOTIFY: SPOTIFY VOLUME 23 Oct 18 10:47:18 volumio volumio[1083]: SPOTIFY: VOLUMIO VOLUME 22 Oct 18 10:47:18 volumio volumio[1083]: SPOTIFY: DELTA VOLUME ENOUGH: false Oct 18 10:47:18 volumio sudo[14027]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:18 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:18 volumio sudo[14030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:18 volumio sudo[14030]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:18 volumio sudo[14030]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:18 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:18 volumio volumio[1083]: info: VolumeController::SetAlsaVolume- Oct 18 10:47:18 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:18 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:18 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:18 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:18 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:18 volumio sudo[14036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:18 volumio sudo[14036]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:18 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 21 Oct 18 10:47:18 volumio volumio[1083]: SPOTIFY: SPOTIFY VOLUME 23 Oct 18 10:47:18 volumio volumio[1083]: SPOTIFY: VOLUMIO VOLUME 21 Oct 18 10:47:18 volumio volumio[1083]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 18 10:47:18 volumio volumio[1083]: info: Setting Spotify Volume from Volumio: 21 Oct 18 10:47:18 volumio sudo[14036]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:18 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:18 volumio sudo[14039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:18 volumio sudo[14039]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:18 volumio sudo[14039]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:18 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:19 volumio volumio[1083]: info: VolumeController::SetAlsaVolume- Oct 18 10:47:19 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:19 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:19 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:19 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:19 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:19 volumio sudo[14043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:19 volumio sudo[14043]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:19 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 20 Oct 18 10:47:19 volumio volumio[1083]: SPOTIFY: SPOTIFY VOLUME 21 Oct 18 10:47:19 volumio volumio[1083]: SPOTIFY: VOLUMIO VOLUME 20 Oct 18 10:47:19 volumio volumio[1083]: SPOTIFY: DELTA VOLUME ENOUGH: false Oct 18 10:47:19 volumio sudo[14043]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:19 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:19 volumio sudo[14046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:19 volumio sudo[14046]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:19 volumio sudo[14046]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:19 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: SETTING SPOTIFY VOLUME 21 Oct 18 10:47:20 volumio volumio[1083]: info: Sending Spotify command with payload to local API: /player/volume Oct 18 10:47:20 volumio go-librespot[2470]: time="2024-10-18T10:47:20+02:00" level=debug msg="update volume to 13762/65535" Oct 18 10:47:20 volumio go-librespot[2470]: time="2024-10-18T10:47:20+02:00" level=debug msg="renewing login5 access token" Oct 18 10:47:20 volumio go-librespot[2470]: time="2024-10-18T10:47:20+02:00" level=debug msg="authenticated as gt6eb49y4juvvy0ynv3em8hmq" Oct 18 10:47:20 volumio go-librespot[2470]: time="2024-10-18T10:47:20+02:00" level=debug msg="put connect state because VOLUME_CHANGED" Oct 18 10:47:20 volumio go-librespot[2470]: time="2024-10-18T10:47:20+02:00" level=trace msg="emitting websocket event: volume" Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: received: {"type":"volume","data":{"value":21,"max":100}} Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: RECEIVED SPOTIFY VOLUME 21 Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: received: {"type":"volume","data":{"value":21,"max":100}} Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: RECEIVED SPOTIFY VOLUME 21 Oct 18 10:47:20 volumio volumio[1083]: info: VolumeController::SetAlsaVolume- Oct 18 10:47:20 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:20 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:20 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:20 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:20 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:20 volumio sudo[14054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:20 volumio sudo[14054]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: SPOTIFY VOLUME 21 Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: VOLUMIO VOLUME 19 Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 18 10:47:20 volumio volumio[1083]: info: Setting Spotify Volume from Volumio: 19 Oct 18 10:47:20 volumio sudo[14054]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:20 volumio sudo[14057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:20 volumio sudo[14057]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:20 volumio sudo[14057]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:20 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:20 volumio volumio[1083]: info: VolumeController::SetAlsaVolume- Oct 18 10:47:20 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:20 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:20 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:20 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:20 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:20 volumio sudo[14061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:20 volumio sudo[14061]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 18 Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: SPOTIFY VOLUME 19 Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: VOLUMIO VOLUME 18 Oct 18 10:47:20 volumio volumio[1083]: SPOTIFY: DELTA VOLUME ENOUGH: false Oct 18 10:47:20 volumio sudo[14061]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:20 volumio sudo[14064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:20 volumio sudo[14064]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:20 volumio sudo[14064]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:20 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:21 volumio volumio[1083]: info: VolumeController::SetAlsaVolume- Oct 18 10:47:21 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:21 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:21 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:21 volumio sudo[14068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:21 volumio sudo[14068]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:21 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Oct 18 10:47:21 volumio volumio[1083]: SPOTIFY: SPOTIFY VOLUME 19 Oct 18 10:47:21 volumio volumio[1083]: SPOTIFY: VOLUMIO VOLUME 17 Oct 18 10:47:21 volumio sudo[14068]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:21 volumio volumio[1083]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 18 10:47:21 volumio volumio[1083]: info: Setting Spotify Volume from Volumio: 17 Oct 18 10:47:21 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:21 volumio sudo[14071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:21 volumio sudo[14071]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:21 volumio sudo[14071]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:21 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:21 volumio volumio[1083]: info: VolumeController::SetAlsaVolume- Oct 18 10:47:21 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:21 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:21 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:21 volumio sudo[14075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:21 volumio sudo[14075]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:21 volumio sudo[14075]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:21 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 16 Oct 18 10:47:21 volumio volumio[1083]: SPOTIFY: SPOTIFY VOLUME 17 Oct 18 10:47:21 volumio volumio[1083]: SPOTIFY: VOLUMIO VOLUME 16 Oct 18 10:47:21 volumio volumio[1083]: SPOTIFY: DELTA VOLUME ENOUGH: false Oct 18 10:47:21 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:21 volumio sudo[14078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:21 volumio sudo[14078]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:21 volumio sudo[14078]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:21 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:21 volumio volumio[1083]: error: error Oct 18 10:47:22 volumio volumio[1083]: info: VolumeController::SetAlsaVolume+ Oct 18 10:47:22 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:22 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:22 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:22 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:22 volumio sudo[14084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:22 volumio sudo[14084]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:22 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 17 Oct 18 10:47:22 volumio sudo[14084]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:22 volumio sudo[14087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:22 volumio sudo[14087]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:22 volumio sudo[14087]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:22 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:22 volumio volumio[1083]: SPOTIFY: SETTING SPOTIFY VOLUME 17 Oct 18 10:47:22 volumio volumio[1083]: info: Sending Spotify command with payload to local API: /player/volume Oct 18 10:47:22 volumio go-librespot[2470]: time="2024-10-18T10:47:22+02:00" level=debug msg="update volume to 11140/65535" Oct 18 10:47:22 volumio go-librespot[2470]: time="2024-10-18T10:47:22+02:00" level=debug msg="put connect state because VOLUME_CHANGED" Oct 18 10:47:22 volumio go-librespot[2470]: time="2024-10-18T10:47:22+02:00" level=trace msg="emitting websocket event: volume" Oct 18 10:47:22 volumio volumio[1083]: SPOTIFY: received: {"type":"volume","data":{"value":17,"max":100}} Oct 18 10:47:22 volumio volumio[1083]: SPOTIFY: RECEIVED SPOTIFY VOLUME 17 Oct 18 10:47:22 volumio volumio[1083]: SPOTIFY: received: {"type":"volume","data":{"value":17,"max":100}} Oct 18 10:47:22 volumio volumio[1083]: SPOTIFY: RECEIVED SPOTIFY VOLUME 17 Oct 18 10:47:23 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 10:47:23 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 10:47:23 volumio volumio[1083]: info: Discovery: Getting this device information Oct 18 10:47:23 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Oct 18 10:47:23 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 18 10:47:23 volumio volumio[13766]: libpng warning: iCCP: known incorrect sRGB profile Oct 18 10:47:23 volumio volumio[13766]: libpng warning: iCCP: known incorrect sRGB profile Oct 18 10:47:23 volumio volumio[13766]: libpng warning: iCCP: known incorrect sRGB profile Oct 18 10:47:23 volumio volumio[1083]: info: VolumeController::SetAlsaVolume- Oct 18 10:47:23 volumio volumio[1083]: info: CoreStateMachine::pushState Oct 18 10:47:23 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 18 10:47:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Oct 18 10:47:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 18 10:47:23 volumio volumio[1083]: info: PeppySpectrum ---peppyspectrum status play Oct 18 10:47:23 volumio sudo[14095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 18 10:47:23 volumio sudo[14095]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:23 volumio volumio[1083]: SPOTIFY: RECEIVED VOLUMIO VOLUME 16 Oct 18 10:47:23 volumio volumio[1083]: SPOTIFY: SPOTIFY VOLUME 17 Oct 18 10:47:23 volumio volumio[1083]: SPOTIFY: VOLUMIO VOLUME 16 Oct 18 10:47:23 volumio volumio[1083]: SPOTIFY: DELTA VOLUME ENOUGH: false Oct 18 10:47:23 volumio sudo[14095]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:23 volumio volumio[1083]: info: peppymeterbasic Daemon Started Oct 18 10:47:23 volumio sudo[14098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Oct 18 10:47:23 volumio sudo[14098]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 18 10:47:23 volumio sudo[14098]: pam_unix(sudo:session): session closed for user root Oct 18 10:47:23 volumio volumio[1083]: info: peppyspectrum Daemon Started Oct 18 10:47:24 volumio volumio[1083]: error: error Oct 18 10:47:25 volumio volumio[1083]: error: error Oct 18 10:47:25 volumio volumio[1083]: error: error Oct 18 10:47:25 volumio volumio[1083]: error: error Oct 18 10:47:25 volumio volumio[1083]: error: error Oct 18 10:47:34 volumio volumio[1083]: info: CoreCommandRouter::volumioGetQueue Oct 18 10:47:34 volumio volumio[1083]: info: CoreStateMachine::getQueue Oct 18 10:47:34 volumio volumio[1083]: info: CorePlayQueue::getQueue Oct 18 10:47:41 volumio volumio[1083]: info: CoreCommandRouter::volumioGetVisibleSources Oct 18 10:47:41 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 18 10:47:43 volumio volumio[13766]: libpng warning: iCCP: known incorrect sRGB profile Oct 18 10:47:48 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 18 10:47:48 volumio volumio[1083]: info: Preload queue cleared Oct 18 10:47:50 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 18 10:47:50 volumio volumio[1083]: info: Preload queue cleared Oct 18 10:47:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 18 10:47:53 volumio volumio[1083]: info: Preload queue cleared Oct 18 10:47:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 18 10:47:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 18 10:47:53 volumio volumio[1083]: info: Discovery: Getting this device information Oct 18 10:47:53 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Oct 18 10:47:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 18 10:47:55 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 18 10:47:55 volumio volumio[1083]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 18 10:47:55 volumio volumio[1083]: TypeError: Cannot read property 'length' of undefined Oct 18 10:47:55 volumio volumio[1083]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 18 10:47:55 volumio volumio[1083]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 18 10:47:55 volumio volumio[1083]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 18 10:47:55 volumio volumio[1083]: at Parser.emit (events.js:400:28) Oct 18 10:47:55 volumio volumio[1083]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 18 10:47:55 volumio volumio[1083]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 18 10:47:55 volumio volumio[1083]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 18 10:47:55 volumio volumio[1083]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 18 10:47:55 volumio volumio[1083]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 18 10:47:55 volumio volumio[1083]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 18 10:47:55 volumio volumio[1083]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 18 10:47:55 volumio volumio[1083]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 18 10:47:55 volumio volumio[1083]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 18 10:47:55 volumio volumio[1083]: at IncomingMessage.emit (events.js:412:35) Oct 18 10:47:55 volumio volumio[1083]: at endReadableNT (internal/streams/readable.js:1333:12) Oct 18 10:47:55 volumio volumio[1083]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Oct 18 10:47:55 volumio volumio[1083]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 18 10:47:55 volumio sudo[14240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-18 10:46 Oct 18 10:47:55 volumio sudo[14240]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"