-- Logs begin at Mon 2024-08-19 12:37:23 UTC, end at Sun 2024-08-25 20:04:50 UTC. -- Aug 25 20:03:02 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.59:5353): type 47 is invalid Aug 25 20:03:04 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.74:5353): type 47 is invalid Aug 25 20:03:08 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.78:5353): type 47 is invalid Aug 25 20:03:09 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.64:5353): type 47 is invalid Aug 25 20:03:11 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.69:5353): type 47 is invalid Aug 25 20:03:12 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.58:5353): type 47 is invalid Aug 25 20:03:16 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.68:5353): type 47 is invalid Aug 25 20:03:16 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.65:5353): type 47 is invalid Aug 25 20:03:19 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.70:5353): type 47 is invalid Aug 25 20:03:26 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.54:5353): type 47 is invalid Aug 25 20:03:26 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.80:5353): type 47 is invalid Aug 25 20:03:26 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.88:5353): type 47 is invalid Aug 25 20:03:31 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.59:5353): type 47 is invalid Aug 25 20:03:34 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.74:5353): type 47 is invalid Aug 25 20:03:35 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.78:5353): type 47 is invalid Aug 25 20:03:38 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.64:5353): type 47 is invalid Aug 25 20:03:40 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.58:5353): type 47 is invalid Aug 25 20:03:40 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.69:5353): type 47 is invalid Aug 25 20:03:43 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.65:5353): type 47 is invalid Aug 25 20:03:46 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.68:5353): type 47 is invalid Aug 25 20:03:48 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.70:5353): type 47 is invalid Aug 25 20:03:53 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.54:5353): type 47 is invalid Aug 25 20:03:53 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.80:5353): type 47 is invalid Aug 25 20:03:55 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.88:5353): type 47 is invalid Aug 25 20:03:59 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.59:5353): type 47 is invalid Aug 25 20:04:02 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.78:5353): type 47 is invalid Aug 25 20:04:04 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.74:5353): type 47 is invalid Aug 25 20:04:07 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.64:5353): type 47 is invalid Aug 25 20:04:08 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.58:5353): type 47 is invalid Aug 25 20:04:09 volumio-az volumio[4958]: [Vollibrespot] : Loading with Spotify URI Aug 25 20:04:09 volumio-az volumio[4958]: [Vollibrespot] : (170000 ms) loaded Aug 25 20:04:10 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.69:5353): type 47 is invalid Aug 25 20:04:10 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.65:5353): type 47 is invalid Aug 25 20:04:16 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.68:5353): type 47 is invalid Aug 25 20:04:17 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.70:5353): type 47 is invalid Aug 25 20:04:20 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.54:5353): type 47 is invalid Aug 25 20:04:21 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.80:5353): type 47 is invalid Aug 25 20:04:24 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.88:5353): type 47 is invalid Aug 25 20:04:27 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.59:5353): type 47 is invalid Aug 25 20:04:28 volumio-az volumio[4958]: [Vollibrespot] : Event: Pause { track_id: SpotifyId { id: 278229529664460604189022613505367053118, audio_type: Track }, position_ms: 228722 } Aug 25 20:04:28 volumio-az volumio[4958]: [Vollibrespot] : Event: SinkInactive Aug 25 20:04:28 volumio-az volumio[4958]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 278229529664460604189022613505367053118, audio_type: Track } } Aug 25 20:04:29 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.78:5353): type 47 is invalid Aug 25 20:04:33 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.74:5353): type 47 is invalid Aug 25 20:04:36 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.64:5353): type 47 is invalid Aug 25 20:04:36 volumio-az sudo[24710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 25 20:04:36 volumio-az sudo[24710]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 20:04:36 volumio-az sudo[24715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 25 20:04:36 volumio-az sudo[24710]: pam_unix(sudo:session): session closed for user root Aug 25 20:04:36 volumio-az sudo[24715]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 20:04:36 volumio-az sudo[24715]: pam_unix(sudo:session): session closed for user root Aug 25 20:04:36 volumio-az sudo[24731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 25 20:04:36 volumio-az sudo[24731]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 20:04:36 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.58:5353): type 47 is invalid Aug 25 20:04:36 volumio-az sudo[24731]: pam_unix(sudo:session): session closed for user root Aug 25 20:04:36 volumio-az sudo[24735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 25 20:04:36 volumio-az sudo[24735]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 20:04:36 volumio-az sudo[24735]: pam_unix(sudo:session): session closed for user root Aug 25 20:04:36 volumio-az volumio[1193]: info: CoreCommandRouter::volumioGetState Aug 25 20:04:36 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 25 20:04:36 volumio-az volumio[1193]: info: Listing playlists Aug 25 20:04:36 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 25 20:04:36 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 25 20:04:36 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 25 20:04:36 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 25 20:04:38 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.65:5353): type 47 is invalid Aug 25 20:04:38 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 25 20:04:38 volumio-az volumio[1193]: info: CoreCommandRouter::volumioGetVisibleSources Aug 25 20:04:38 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 20:04:38 volumio-az volumio[1193]: info: CoreCommandRouter::volumioGetQueue Aug 25 20:04:38 volumio-az volumio[1193]: info: CoreStateMachine::getQueue Aug 25 20:04:38 volumio-az volumio[1193]: info: CorePlayQueue::getQueue Aug 25 20:04:39 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.69:5353): type 47 is invalid Aug 25 20:04:39 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 25 20:04:39 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 25 20:04:40 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreStateMachine::ClearQueue Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreStateMachine::stop Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreStateMachine::serviceStop Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreCommandRouter::serviceStop Aug 25 20:04:41 volumio-az volumio[1193]: error: WARNING: No stop method for service spop Aug 25 20:04:41 volumio-az volumio[1193]: info: CorePlayQueue::clearPlayQueue Aug 25 20:04:41 volumio-az volumio[1193]: info: CorePlayQueue::saveQueue Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPushState Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPushQueue Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreStateMachine::addQueueItems Aug 25 20:04:41 volumio-az volumio[1193]: info: CorePlayQueue::addQueueItems Aug 25 20:04:41 volumio-az volumio[1193]: info: Adding Item to queue: https://stream-167.zeno.fm/oz9orxedmqmtv?zs=kW2IVj6dTo6Lp7J7Ys5jmA Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 25 20:04:41 volumio-az volumio[1193]: info: CorePlayQueue::saveQueue Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPushQueue Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreStateMachine::updateTrackBlock Aug 25 20:04:41 volumio-az volumio[1193]: info: CorePlayQueue::getTrackBlock Aug 25 20:04:41 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPlay Aug 25 20:04:41 volumio-az volumio[1193]: verbose: UNSET VOLATILE Aug 25 20:04:41 volumio-az volumio[1193]: [SpotifyConnect] unSetVolatile called Aug 25 20:04:41 volumio-az volumio[1193]: info: Spotify Unset Volatile called Aug 25 20:04:41 volumio-az volumio[1193]: [SpotifyConnect] Relinquishing Volumio State to another service Aug 25 20:04:41 volumio-az volumio[1193]: [SpotifyConnect] Spotify Received stop Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreStateMachine::ClearQueue Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreStateMachine::stop Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreStateMachine::serviceStop Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreCommandRouter::serviceStop Aug 25 20:04:44 volumio-az volumio[1193]: error: WARNING: No stop method for service spop Aug 25 20:04:44 volumio-az volumio[1193]: info: CorePlayQueue::clearPlayQueue Aug 25 20:04:44 volumio-az volumio[1193]: info: CorePlayQueue::saveQueue Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPushState Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPushQueue Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreStateMachine::addQueueItems Aug 25 20:04:44 volumio-az volumio[1193]: info: CorePlayQueue::addQueueItems Aug 25 20:04:44 volumio-az volumio[1193]: info: Adding Item to queue: https://stream-167.zeno.fm/oz9orxedmqmtv?zs=kW2IVj6dTo6Lp7J7Ys5jmA Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 25 20:04:44 volumio-az volumio[1193]: info: CorePlayQueue::saveQueue Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPushQueue Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreStateMachine::updateTrackBlock Aug 25 20:04:44 volumio-az volumio[1193]: info: CorePlayQueue::getTrackBlock Aug 25 20:04:44 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPlay Aug 25 20:04:44 volumio-az volumio[1193]: verbose: UNSET VOLATILE Aug 25 20:04:44 volumio-az volumio[1193]: [SpotifyConnect] unSetVolatile called Aug 25 20:04:44 volumio-az volumio[1193]: info: Spotify Unset Volatile called Aug 25 20:04:44 volumio-az volumio[1193]: [SpotifyConnect] Relinquishing Volumio State to another service Aug 25 20:04:44 volumio-az volumio[1193]: [SpotifyConnect] Spotify Received stop Aug 25 20:04:45 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.68:5353): type 47 is invalid Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreStateMachine::ClearQueue Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreStateMachine::stop Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreStateMachine::serviceStop Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreCommandRouter::serviceStop Aug 25 20:04:46 volumio-az volumio[1193]: error: WARNING: No stop method for service spop Aug 25 20:04:46 volumio-az volumio[1193]: info: CorePlayQueue::clearPlayQueue Aug 25 20:04:46 volumio-az volumio[1193]: info: CorePlayQueue::saveQueue Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPushState Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPushQueue Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreStateMachine::addQueueItems Aug 25 20:04:46 volumio-az volumio[1193]: info: CorePlayQueue::addQueueItems Aug 25 20:04:46 volumio-az volumio[1193]: info: Adding Item to queue: https://stream-167.zeno.fm/oz9orxedmqmtv?zs=kW2IVj6dTo6Lp7J7Ys5jmA Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 25 20:04:46 volumio-az volumio[1193]: info: CorePlayQueue::saveQueue Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPushQueue Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreStateMachine::updateTrackBlock Aug 25 20:04:46 volumio-az volumio[1193]: info: CorePlayQueue::getTrackBlock Aug 25 20:04:46 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPlay Aug 25 20:04:46 volumio-az volumio[1193]: verbose: UNSET VOLATILE Aug 25 20:04:46 volumio-az volumio[1193]: [SpotifyConnect] unSetVolatile called Aug 25 20:04:46 volumio-az volumio[1193]: info: Spotify Unset Volatile called Aug 25 20:04:46 volumio-az volumio[1193]: [SpotifyConnect] Relinquishing Volumio State to another service Aug 25 20:04:46 volumio-az volumio[1193]: [SpotifyConnect] Spotify Received stop Aug 25 20:04:46 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.70:5353): type 47 is invalid Aug 25 20:04:47 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.54:5353): type 47 is invalid Aug 25 20:04:48 volumio-az volumio[4958]: [Vollibrespot] : couldn't parse packet from V4(192.168.10.80:5353): type 47 is invalid Aug 25 20:04:48 volumio-az volumio[1193]: info: CoreCommandRouter::volumioPlay Aug 25 20:04:48 volumio-az volumio[1193]: verbose: UNSET VOLATILE Aug 25 20:04:48 volumio-az volumio[1193]: [SpotifyConnect] unSetVolatile called Aug 25 20:04:48 volumio-az volumio[1193]: info: Spotify Unset Volatile called Aug 25 20:04:48 volumio-az volumio[1193]: [SpotifyConnect] Relinquishing Volumio State to another service Aug 25 20:04:48 volumio-az volumio[1193]: [SpotifyConnect] Spotify Received stop Aug 25 20:04:48 volumio-az volumio[1193]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 20:04:48 volumio-az volumio[1193]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running Aug 25 20:04:48 volumio-az volumio[1193]: at Socket._healthCheck (dgram.js:638:11) Aug 25 20:04:48 volumio-az volumio[1193]: at Socket.send (dgram.js:435:8) Aug 25 20:04:48 volumio-az volumio[1193]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) Aug 25 20:04:48 volumio-az volumio[1193]: at ControllerSpotify.stop (/data/plugins/music_service/spop/index.js:2674:19) Aug 25 20:04:48 volumio-az volumio[1193]: at ControllerSpotify.spotConnUnsetVolatile (/data/plugins/music_service/spop/index.js:2355:17) Aug 25 20:04:48 volumio-az volumio[1193]: at ControllerSpotify.unsetVol (/data/plugins/music_service/spop/index.js:68:21) Aug 25 20:04:48 volumio-az volumio[1193]: at CoreStateMachine.unSetVolatile (/volumio/app/statemachine.js:1519:27) Aug 25 20:04:48 volumio-az volumio[1193]: at CoreCommandRouter.volumioPlay (/volumio/app/index.js:1305:21) Aug 25 20:04:48 volumio-az volumio[1193]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:202:35) Aug 25 20:04:48 volumio-az volumio[1193]: at emitTwo (events.js:126:13) Aug 25 20:04:48 volumio-az volumio[1193]: at Socket.emit (events.js:214:7) Aug 25 20:04:48 volumio-az volumio[1193]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Aug 25 20:04:48 volumio-az volumio[1193]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Aug 25 20:04:48 volumio-az volumio[1193]: at process._tickCallback (internal/process/next_tick.js:180:9) Aug 25 20:04:48 volumio-az volumio[1193]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 20:04:50 volumio-az sudo[24808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-25 20:03 Aug 25 20:04:50 volumio-az sudo[24808]: 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"