-- Logs begin at Tue 2023-05-23 15:22:30 UTC, end at Tue 2023-05-23 15:34:04 UTC. -- May 23 15:33:06 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 15:33:06 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 15:33:06 volumio2 volumio[1722]: info: Discovery: Getting this device information May 23 15:33:06 volumio2 volumio[1722]: info: CoreCommandRouter::volumioGetState May 23 15:33:06 volumio2 volumio[1722]: info: CorePlayQueue::getTrack 0 May 23 15:33:06 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 23 15:33:06 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 23 15:33:06 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 23 15:33:06 volumio2 nmbd[831]: [2023/05/23 15:33:06.928253, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 23 15:33:06 volumio2 nmbd[831]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.68 for name WORKGROUP<1d>. May 23 15:33:06 volumio2 nmbd[831]: This response was from IP 192.168.178.14, reporting an IP address of 192.168.178.14. May 23 15:33:09 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri May 23 15:33:09 volumio2 volumio[1722]: info: In handleBrowseUri, curUri=spotify May 23 15:33:09 volumio2 volumio[1722]: error: An error occurred while listing Spotify new albums WebapiError: certificate is not yet valid May 23 15:33:09 volumio2 volumio[1722]: error: An error occurred while listing Spotify featured playlists WebapiError: certificate is not yet valid May 23 15:33:09 volumio2 volumio[1722]: error: An error occurred while listing Spotify categories WebapiError: certificate is not yet valid May 23 15:33:15 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPlay May 23 15:33:15 volumio2 volumio[1722]: verbose: UNSET VOLATILE May 23 15:33:15 volumio2 volumio[1722]: info: CoreStateMachine::play index undefined May 23 15:33:15 volumio2 volumio[1722]: info: CoreStateMachine::setConsumeUpdateService undefined May 23 15:33:15 volumio2 volumio[1722]: info: CorePlayQueue::getTrack 0 May 23 15:33:15 volumio2 volumio[1722]: info: CoreStateMachine::startPlaybackTimer May 23 15:33:15 volumio2 volumio[1722]: info: CorePlayQueue::getTrack 0 May 23 15:33:15 volumio2 volumio[1722]: info: [1684855995711] ControllerWebradio::clearAddPlayTrack May 23 15:33:15 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand stop May 23 15:33:15 volumio2 volumio[1722]: info: sendMpdCommand stop took 12 milliseconds May 23 15:33:15 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand clear May 23 15:33:15 volumio2 volumio[1722]: info: May 23 15:33:15 volumio2 volumio[1722]: ---------------------------- MPD announces system playlist update May 23 15:33:15 volumio2 volumio[1722]: info: Ignoring MPD Status Update May 23 15:33:15 volumio2 volumio[1722]: info: sendMpdCommand clear took 4 milliseconds May 23 15:33:15 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958" May 23 15:33:15 volumio2 volumio[1722]: error: updateQueue error: null May 23 15:33:15 volumio2 volumio[1722]: info: ------------------------------ 6ms May 23 15:33:15 volumio2 volumio[1722]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497958" took 133 milliseconds May 23 15:33:15 volumio2 volumio[1722]: info: CoreStateMachine::setConsumeUpdateService mpd May 23 15:33:15 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand play May 23 15:33:15 volumio2 volumio[1722]: info: May 23 15:33:15 volumio2 volumio[1722]: ---------------------------- MPD announces system playlist update May 23 15:33:15 volumio2 volumio[1722]: info: Ignoring MPD Status Update May 23 15:33:15 volumio2 volumio[1722]: info: sendMpdCommand play took 3 milliseconds May 23 15:33:15 volumio2 volumio[1722]: info: ------------------------------ 5ms May 23 15:33:16 volumio2 kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 May 23 15:33:16 volumio2 volumio[1722]: info: May 23 15:33:16 volumio2 volumio[1722]: ---------------------------- MPD announces state update: player May 23 15:33:16 volumio2 volumio[1722]: info: ControllerMpd::getState May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand status May 23 15:33:16 volumio2 volumio[1722]: info: May 23 15:33:16 volumio2 volumio[1722]: ---------------------------- MPD announces state update: player May 23 15:33:16 volumio2 volumio[1722]: info: sendMpdCommand status took 19 milliseconds May 23 15:33:16 volumio2 volumio[1722]: info: ControllerMpd::getState May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand status May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::parseState May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 15:33:16 volumio2 volumio[1722]: info: May 23 15:33:16 volumio2 volumio[1722]: ---------------------------- MPD announces system playlist update May 23 15:33:16 volumio2 volumio[1722]: info: Ignoring MPD Status Update May 23 15:33:16 volumio2 volumio[1722]: info: sendMpdCommand status took 6 milliseconds May 23 15:33:16 volumio2 volumio[1722]: info: sendMpdCommand playlistinfo took 5 milliseconds May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::parseState May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::parseTrackInfo May 23 15:33:16 volumio2 volumio[1722]: info: ControllerMpd::pushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::servicePushState May 23 15:33:16 volumio2 volumio[1722]: info: CorePlayQueue::getTrack 0 May 23 15:33:16 volumio2 volumio[1722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Electric Light Orchestra - Telephone line","artist":"OLDIE ANTENNE","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""} May 23 15:33:16 volumio2 volumio[1722]: verbose: CURRENT POSITION 0 May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::syncState stateService play May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::syncState currentStatus stop May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:16 volumio2 volumio[1722]: info: ------------------------------ 76ms May 23 15:33:16 volumio2 volumio[1722]: info: ------------------------------ 81ms May 23 15:33:16 volumio2 volumio[1722]: info: sendMpdCommand playlistinfo took 78 milliseconds May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::parseTrackInfo May 23 15:33:16 volumio2 volumio[1722]: info: ControllerMpd::pushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::servicePushState May 23 15:33:16 volumio2 volumio[1722]: info: CorePlayQueue::getTrack 0 May 23 15:33:16 volumio2 volumio[1722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Electric Light Orchestra - Telephone line","artist":"OLDIE ANTENNE","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""} May 23 15:33:16 volumio2 volumio[1722]: verbose: CURRENT POSITION 0 May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::syncState stateService play May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::syncState currentStatus play May 23 15:33:16 volumio2 volumio[1722]: info: Received an update from plugin. extracting info from payload May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:16 volumio2 volumio[1722]: info: ------------------------------ 204ms May 23 15:33:16 volumio2 volumio[1722]: info: May 23 15:33:16 volumio2 volumio[1722]: ---------------------------- MPD announces system playlist update May 23 15:33:16 volumio2 volumio[1722]: info: Ignoring MPD Status Update May 23 15:33:16 volumio2 volumio[1722]: info: May 23 15:33:16 volumio2 volumio[1722]: ---------------------------- MPD announces state update: player May 23 15:33:16 volumio2 volumio[1722]: info: ControllerMpd::getState May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand status May 23 15:33:16 volumio2 volumio[1722]: info: ------------------------------ 11ms May 23 15:33:16 volumio2 volumio[1722]: info: sendMpdCommand status took 17 milliseconds May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::parseState May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 15:33:16 volumio2 volumio[1722]: info: sendMpdCommand playlistinfo took 3 milliseconds May 23 15:33:16 volumio2 volumio[1722]: verbose: ControllerMpd::parseTrackInfo May 23 15:33:16 volumio2 volumio[1722]: info: ControllerMpd::pushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::servicePushState May 23 15:33:16 volumio2 volumio[1722]: info: CorePlayQueue::getTrack 0 May 23 15:33:16 volumio2 volumio[1722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1187,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Electric Light Orchestra - Telephone line","artist":"OLDIE ANTENNE","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""} May 23 15:33:16 volumio2 volumio[1722]: verbose: CURRENT POSITION 0 May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::syncState stateService play May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::syncState currentStatus play May 23 15:33:16 volumio2 volumio[1722]: info: Received an update from plugin. extracting info from payload May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:16 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:16 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:16 volumio2 volumio[1722]: info: ------------------------------ 76ms May 23 15:33:17 volumio2 kernel: rpi_firmware_get_throttled: 2 callbacks suppressed May 23 15:33:17 volumio2 kernel: Under-voltage detected! (0x00050005) May 23 15:33:18 volumio2 volumio[1722]: info: May 23 15:33:18 volumio2 volumio[1722]: ---------------------------- MPD announces system playlist update May 23 15:33:18 volumio2 volumio[1722]: info: Ignoring MPD Status Update May 23 15:33:18 volumio2 volumio[1722]: info: May 23 15:33:18 volumio2 volumio[1722]: ---------------------------- MPD announces state update: player May 23 15:33:18 volumio2 volumio[1722]: info: ControllerMpd::getState May 23 15:33:18 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand status May 23 15:33:18 volumio2 volumio[1722]: info: ------------------------------ 10ms May 23 15:33:18 volumio2 volumio[1722]: info: sendMpdCommand status took 5 milliseconds May 23 15:33:18 volumio2 volumio[1722]: verbose: ControllerMpd::parseState May 23 15:33:18 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 15:33:18 volumio2 volumio[1722]: info: sendMpdCommand playlistinfo took 3 milliseconds May 23 15:33:18 volumio2 volumio[1722]: verbose: ControllerMpd::parseTrackInfo May 23 15:33:18 volumio2 volumio[1722]: info: ControllerMpd::pushState May 23 15:33:18 volumio2 volumio[1722]: info: CoreCommandRouter::servicePushState May 23 15:33:18 volumio2 volumio[1722]: info: CorePlayQueue::getTrack 0 May 23 15:33:18 volumio2 volumio[1722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2980,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Electric Light Orchestra - Telephone line","artist":"OLDIE ANTENNE","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""} May 23 15:33:18 volumio2 volumio[1722]: verbose: CURRENT POSITION 0 May 23 15:33:18 volumio2 volumio[1722]: info: CoreStateMachine::syncState stateService play May 23 15:33:18 volumio2 volumio[1722]: info: CoreStateMachine::syncState currentStatus play May 23 15:33:18 volumio2 volumio[1722]: info: Received an update from plugin. extracting info from payload May 23 15:33:18 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 23 15:33:18 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:18 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:18 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:18 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:18 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:18 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:18 volumio2 volumio[1722]: info: ------------------------------ 82ms May 23 15:33:27 volumio2 volumio[1722]: info: VolumeController::SetAlsaVolume70 May 23 15:33:27 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:27 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:27 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:29 volumio2 volumio[1722]: info: VolumeController::SetAlsaVolume60 May 23 15:33:29 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:29 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:29 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:44 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 15:33:44 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 15:33:44 volumio2 volumio[1722]: info: Discovery: Getting this device information May 23 15:33:44 volumio2 volumio[1722]: info: CoreCommandRouter::volumioGetState May 23 15:33:44 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 23 15:33:44 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 23 15:33:44 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 23 15:33:50 volumio2 volumio[1722]: info: May 23 15:33:50 volumio2 volumio[1722]: ---------------------------- MPD announces system playlist update May 23 15:33:50 volumio2 volumio[1722]: info: Ignoring MPD Status Update May 23 15:33:50 volumio2 volumio[1722]: info: May 23 15:33:50 volumio2 volumio[1722]: ---------------------------- MPD announces state update: player May 23 15:33:50 volumio2 volumio[1722]: info: ControllerMpd::getState May 23 15:33:50 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand status May 23 15:33:50 volumio2 volumio[1722]: info: ------------------------------ 15ms May 23 15:33:50 volumio2 volumio[1722]: info: sendMpdCommand status took 5 milliseconds May 23 15:33:50 volumio2 volumio[1722]: verbose: ControllerMpd::parseState May 23 15:33:50 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 15:33:50 volumio2 volumio[1722]: info: sendMpdCommand playlistinfo took 3 milliseconds May 23 15:33:50 volumio2 volumio[1722]: verbose: ControllerMpd::parseTrackInfo May 23 15:33:50 volumio2 volumio[1722]: info: ControllerMpd::pushState May 23 15:33:50 volumio2 volumio[1722]: info: CoreCommandRouter::servicePushState May 23 15:33:50 volumio2 volumio[1722]: info: CorePlayQueue::getTrack 0 May 23 15:33:50 volumio2 volumio[1722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34586,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"OLDIE ANTENNE - Oldies but Goldies","artist":"OLDIE ANTENNE","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""} May 23 15:33:50 volumio2 volumio[1722]: verbose: CURRENT POSITION 0 May 23 15:33:50 volumio2 volumio[1722]: info: CoreStateMachine::syncState stateService play May 23 15:33:50 volumio2 volumio[1722]: info: CoreStateMachine::syncState currentStatus play May 23 15:33:50 volumio2 volumio[1722]: info: Received an update from plugin. extracting info from payload May 23 15:33:50 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 23 15:33:50 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:50 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:50 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:50 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:50 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:50 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:50 volumio2 volumio[1722]: info: ------------------------------ 53ms May 23 15:33:52 volumio2 volumio[1722]: info: May 23 15:33:52 volumio2 volumio[1722]: ---------------------------- MPD announces system playlist update May 23 15:33:52 volumio2 volumio[1722]: info: Ignoring MPD Status Update May 23 15:33:52 volumio2 volumio[1722]: info: May 23 15:33:52 volumio2 volumio[1722]: ---------------------------- MPD announces state update: player May 23 15:33:52 volumio2 volumio[1722]: info: ControllerMpd::getState May 23 15:33:52 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand status May 23 15:33:52 volumio2 volumio[1722]: info: ------------------------------ 8ms May 23 15:33:52 volumio2 volumio[1722]: info: sendMpdCommand status took 5 milliseconds May 23 15:33:52 volumio2 volumio[1722]: verbose: ControllerMpd::parseState May 23 15:33:52 volumio2 volumio[1722]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 23 15:33:52 volumio2 volumio[1722]: info: sendMpdCommand playlistinfo took 3 milliseconds May 23 15:33:52 volumio2 volumio[1722]: verbose: ControllerMpd::parseTrackInfo May 23 15:33:52 volumio2 volumio[1722]: info: ControllerMpd::pushState May 23 15:33:52 volumio2 volumio[1722]: info: CoreCommandRouter::servicePushState May 23 15:33:52 volumio2 volumio[1722]: info: CorePlayQueue::getTrack 0 May 23 15:33:52 volumio2 volumio[1722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37082,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"OLDIE ANTENNE - Oldies but Goldies","artist":"OLDIE ANTENNE","album":null,"uri":"http://stream.antenne.de:80/oldies-but-goldies","trackType":""} May 23 15:33:52 volumio2 volumio[1722]: verbose: CURRENT POSITION 0 May 23 15:33:52 volumio2 volumio[1722]: info: CoreStateMachine::syncState stateService play May 23 15:33:52 volumio2 volumio[1722]: info: CoreStateMachine::syncState currentStatus play May 23 15:33:52 volumio2 volumio[1722]: info: Received an update from plugin. extracting info from payload May 23 15:33:52 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 23 15:33:52 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:52 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:52 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:52 volumio2 volumio[1722]: info: CoreStateMachine::pushState May 23 15:33:52 volumio2 volumio[1722]: info: CoreCommandRouter::volumioPushState May 23 15:33:52 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 15:33:52 volumio2 volumio[1722]: info: ------------------------------ 50ms May 23 15:33:57 volumio2 volumio[1722]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify May 23 15:33:57 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 23 15:33:57 volumio2 volumio[1722]: [SpotifyConnect] Closing metadata listener May 23 15:33:57 volumio2 volumio[1722]: info: Disabling plugin spop May 23 15:33:57 volumio2 volumio[1722]: info: Done. May 23 15:33:57 volumio2 sudo[3115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service May 23 15:33:57 volumio2 sudo[3115]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 15:33:57 volumio2 systemd[1]: Stopping Volspotconnect2 Daemon... May 23 15:33:57 volumio2 systemd[1]: Stopped Volspotconnect2 Daemon. May 23 15:33:57 volumio2 sudo[3115]: pam_unix(sudo:session): session closed for user root May 23 15:33:57 volumio2 volumio[1722]: [SpotifyConnect] Vollibrespot Daemon service stoped! May 23 15:33:58 volumio2 volumio[1722]: info: Enabling plugin spop May 23 15:33:58 volumio2 volumio[1722]: info: Loading plugin "spop"... May 23 15:33:58 volumio2 volumio[1722]: info: PLUGIN START: spop May 23 15:33:58 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 23 15:33:58 volumio2 volumio[1722]: [SpotifyConnect] Creating VLS config file May 23 15:33:58 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 15:33:58 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 15:33:58 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 15:33:58 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 15:33:58 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 15:33:58 volumio2 volumio[1722]: [SpotifyConnect] Starting metadata listener May 23 15:33:58 volumio2 sudo[3127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts May 23 15:33:58 volumio2 sudo[3127]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 15:33:58 volumio2 sudo[3127]: pam_unix(sudo:session): session closed for user root May 23 15:33:58 volumio2 sudo[3131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service May 23 15:33:58 volumio2 sudo[3131]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 15:33:58 volumio2 systemd[1]: Starting Volspotconnect2 Daemon... May 23 15:33:58 volumio2 systemd[1]: Started Volspotconnect2 Daemon. May 23 15:33:58 volumio2 sudo[3131]: pam_unix(sudo:session): session closed for user root May 23 15:33:58 volumio2 volumio[3141]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 23 15:33:58 volumio2 volumio[3141]: Reading Config from "/tmp/volspotify.toml" May 23 15:33:58 volumio2 volumio[3141]: [Vollibrespot] : Using Alsa backend with device: plughw:2 May 23 15:33:58 volumio2 volumio[1722]: [SpotifyConnect] Vollibrespot Daemon service started! May 23 15:33:58 volumio2 volumio[1722]: [Metrics] SpotifyConnect: 0s 197.85ms May 23 15:33:58 volumio2 volumio[1722]: info: Done. May 23 15:33:58 volumio2 volumio[3141]: [Vollibrespot] : Connecting to AP "ap-gew4.spotify.com:443" May 23 15:33:59 volumio2 volumio[3141]: [Vollibrespot] : Authenticated as "janwalhof" ! May 23 15:33:59 volumio2 volumio[3141]: [Vollibrespot] : Using alsa sink May 23 15:33:59 volumio2 volumio[3141]: [Vollibrespot] : Metadata pipe established May 23 15:33:59 volumio2 volumio[3141]: [Vollibrespot] : Country: "NL" May 23 15:33:59 volumio2 volumio[3141]: [Vollibrespot] : Event: Volume { volume_to_mixer: 45875 } May 23 15:33:59 volumio2 volumio[1722]: [SpotifyConnect] Volume Spotify: 70.00076295109483 Volumio: 70 May 23 15:33:59 volumio2 kernel: Under-voltage detected! (0x00050005) May 23 15:33:59 volumio2 volumio[1722]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify May 23 15:33:59 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 23 15:33:59 volumio2 volumio[1722]: [SpotifyConnect] Closing metadata listener May 23 15:33:59 volumio2 volumio[1722]: info: Disabling plugin spop May 23 15:33:59 volumio2 volumio[1722]: info: Done. May 23 15:33:59 volumio2 sudo[3155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect.service May 23 15:33:59 volumio2 sudo[3155]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 15:33:59 volumio2 systemd[1]: Stopping Volspotconnect2 Daemon... May 23 15:33:59 volumio2 systemd[1]: Stopped Volspotconnect2 Daemon. May 23 15:33:59 volumio2 sudo[3155]: pam_unix(sudo:session): session closed for user root May 23 15:33:59 volumio2 volumio[1722]: [SpotifyConnect] Vollibrespot Daemon service stoped! May 23 15:34:00 volumio2 volumio[1722]: [SpotifyConnect] Stopping Vollibrespot daemon May 23 15:34:00 volumio2 volumio[1722]: [SpotifyConnect] Closing metadata listener May 23 15:34:00 volumio2 volumio[1722]: info: Disabling plugin volspotconnect2 May 23 15:34:00 volumio2 volumio[1722]: info: Done. May 23 15:34:00 volumio2 sudo[3168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volspotconnect2.service May 23 15:34:00 volumio2 sudo[3168]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 15:34:00 volumio2 systemd[1]: Stopping Volspotconnect2 Daemon... May 23 15:34:00 volumio2 systemd[1]: Stopped Volspotconnect2 Daemon. May 23 15:34:00 volumio2 sudo[3168]: pam_unix(sudo:session): session closed for user root May 23 15:34:00 volumio2 volumio[1722]: [SpotifyConnect] Vollibrespot Daemon service stoped! May 23 15:34:01 volumio2 volumio[1722]: info: Enabling plugin volspotconnect2 May 23 15:34:01 volumio2 volumio[1722]: info: Loading plugin "volspotconnect2"... May 23 15:34:01 volumio2 volumio[1722]: info: PLUGIN START: volspotconnect2 May 23 15:34:01 volumio2 volumio[1722]: [SpotifyConnect] Creating VLS config file May 23 15:34:01 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 15:34:01 volumio2 volumio[1722]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 15:34:01 volumio2 volumio[1722]: [SpotifyConnect] Starting metadata listener May 23 15:34:01 volumio2 sudo[3181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service May 23 15:34:01 volumio2 sudo[3181]: pam_unix(sudo:session): session opened for user root by (uid=0) May 23 15:34:01 volumio2 systemd[1]: Starting Volspotconnect2 Daemon... May 23 15:34:01 volumio2 systemd[1]: Started Volspotconnect2 Daemon. May 23 15:34:01 volumio2 sudo[3181]: pam_unix(sudo:session): session closed for user root May 23 15:34:01 volumio2 volumio[3186]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 May 23 15:34:01 volumio2 volumio[3186]: Reading Config from "volspotify.toml" May 23 15:34:01 volumio2 volumio[3186]: [Vollibrespot] : Using Alsa backend with device: plughw:2 May 23 15:34:01 volumio2 volumio[1722]: [SpotifyConnect] Vollibrespot Daemon service started! May 23 15:34:01 volumio2 volumio[1722]: [Metrics] SpotifyConnect: 0s 181.58ms May 23 15:34:01 volumio2 volumio[1722]: info: Done. May 23 15:34:02 volumio2 volumio[3186]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } May 23 15:34:02 volumio2 volumio[1722]: info: Checking Spotify Web API May 23 15:34:02 volumio2 volumio[1722]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 15:34:02 volumio2 volumio[1722]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running May 23 15:34:02 volumio2 volumio[1722]: at Socket._healthCheck (dgram.js:638:11) May 23 15:34:02 volumio2 volumio[1722]: at Socket.send (dgram.js:435:8) May 23 15:34:02 volumio2 volumio[1722]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) May 23 15:34:02 volumio2 volumio[1722]: at ControllerSpotify.checkWebApi (/data/plugins/music_service/spop/index.js:2318:23) May 23 15:34:02 volumio2 volumio[1722]: at Timeout.setTimeout [as _onTimeout] (/data/plugins/music_service/spop/index.js:2410:18) May 23 15:34:02 volumio2 volumio[1722]: at ontimeout (timers.js:482:11) May 23 15:34:02 volumio2 volumio[1722]: at tryOnTimeout (timers.js:317:5) May 23 15:34:02 volumio2 volumio[1722]: at Timer.listOnTimeout (timers.js:277:5) May 23 15:34:02 volumio2 volumio[1722]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 15:34:03 volumio2 sudo[3201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-05-23 15:33 May 23 15:34:04 volumio2 sudo[3201]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"