-- Logs begin at Sun 2023-10-08 08:48:25 UTC, end at Sun 2024-05-12 07:20:33 UTC. -- May 12 07:19:00 outdoor-speakers volumio[1014]: info: Following Redirect to: http://plugins.volumio.workers.dev/plugins/volumio/armhf/plugins.json May 12 07:19:05 outdoor-speakers volumio[1014]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 07:19:05 outdoor-speakers volumio[1014]: [SpotifyConnect] config : toggling initvol/volume_ctrl May 12 07:19:16 outdoor-speakers volumio[1014]: info: Downloading plugin at http://plugins.volumio.org/plugins/volumio/armhf/music_service/spop/spop.zip May 12 07:19:20 outdoor-speakers volumio[1014]: info: END DOWNLOAD: http://plugins.volumio.org/plugins/volumio/armhf/music_service/spop/spop.zip May 12 07:19:20 outdoor-speakers volumio[1014]: info: Folder /tmp/plugins removed May 12 07:19:22 outdoor-speakers volumio[1014]: info: Checking if plugin already exists May 12 07:19:22 outdoor-speakers volumio[1014]: info: Rename folder May 12 07:19:22 outdoor-speakers volumio[1014]: info: Folder /tmp/downloaded_plugin.zip removed May 12 07:19:22 outdoor-speakers volumio[1014]: info: Move to category May 12 07:19:24 outdoor-speakers volumio[1014]: info: Checking if install.sh is present May 12 07:19:24 outdoor-speakers volumio[1014]: info: Executing install.sh May 12 07:19:25 outdoor-speakers sudo[2768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh May 12 07:19:25 outdoor-speakers sudo[2768]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 07:19:25 outdoor-speakers volumio[1014]: info: Writing systemd unit May 12 07:19:25 outdoor-speakers sudo[2768]: pam_unix(sudo:session): session closed for user root May 12 07:19:25 outdoor-speakers volumio[1014]: info: Setting permissions May 12 07:19:25 outdoor-speakers volumio[1014]: info: Writing startconnect unit May 12 07:19:25 outdoor-speakers volumio[1014]: Plugin install end detected on script May 12 07:19:25 outdoor-speakers volumio[1014]: info: Install script completed May 12 07:19:25 outdoor-speakers volumio[1014]: info: Adding reference to registry May 12 07:19:25 outdoor-speakers volumio[1014]: info: Done installing plugin. May 12 07:19:25 outdoor-speakers volumio[1014]: info: Folder /tmp/plugins removed May 12 07:19:25 outdoor-speakers volumio[1014]: info: Folder /tmp/downloaded_plugin.zip removed May 12 07:19:25 outdoor-speakers volumio[1014]: info: Folder /data/temp removed May 12 07:19:33 outdoor-speakers volumio[1014]: info: Enabling plugin spop May 12 07:19:33 outdoor-speakers volumio[1014]: info: Loading plugin "spop"... May 12 07:19:33 outdoor-speakers volumio[1014]: info: PLUGIN START: spop May 12 07:19:33 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 12 07:19:33 outdoor-speakers volumio[1014]: [SpotifyConnect] Creating VLS config file May 12 07:19:33 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 07:19:33 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 07:19:33 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 07:19:33 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 07:19:33 outdoor-speakers volumio[1014]: [SpotifyConnect] Starting metadata listener May 12 07:19:33 outdoor-speakers sudo[2798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts May 12 07:19:33 outdoor-speakers volumio[1014]: [SpotifyConnect] Error: bind EADDRINUSE 0.0.0.0:5030 May 12 07:19:33 outdoor-speakers volumio[1014]: at Object._errnoException (util.js:1022:11) May 12 07:19:33 outdoor-speakers volumio[1014]: at _exceptionWithHostPort (util.js:1044:20) May 12 07:19:33 outdoor-speakers volumio[1014]: at _handle.lookup (dgram.js:266:18) May 12 07:19:33 outdoor-speakers volumio[1014]: at _combinedTickCallback (internal/process/next_tick.js:141:11) May 12 07:19:33 outdoor-speakers volumio[1014]: at process._tickCallback (internal/process/next_tick.js:180:9) May 12 07:19:33 outdoor-speakers sudo[2798]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 07:19:33 outdoor-speakers volumio[1014]: [SpotifyConnect] Error [ERR_SOCKET_CANNOT_SEND]: Unable to send data May 12 07:19:33 outdoor-speakers volumio[1014]: at Socket.onListenError (dgram.js:362:22) May 12 07:19:33 outdoor-speakers volumio[1014]: at Object.onceWrapper (events.js:315:30) May 12 07:19:33 outdoor-speakers volumio[1014]: at emitOne (events.js:121:20) May 12 07:19:33 outdoor-speakers volumio[1014]: at Socket.emit (events.js:211:7) May 12 07:19:33 outdoor-speakers volumio[1014]: at _handle.lookup (dgram.js:267:14) May 12 07:19:33 outdoor-speakers volumio[1014]: at _combinedTickCallback (internal/process/next_tick.js:141:11) May 12 07:19:33 outdoor-speakers volumio[1014]: at process._tickCallback (internal/process/next_tick.js:180:9) May 12 07:19:33 outdoor-speakers sudo[2798]: pam_unix(sudo:session): session closed for user root May 12 07:19:33 outdoor-speakers sudo[2802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service May 12 07:19:33 outdoor-speakers sudo[2802]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 07:19:33 outdoor-speakers systemd[1]: Starting Volspotconnect2 Daemon... May 12 07:19:33 outdoor-speakers systemd[1]: Started Volspotconnect2 Daemon. May 12 07:19:33 outdoor-speakers sudo[2802]: pam_unix(sudo:session): session closed for user root May 12 07:19:33 outdoor-speakers volumio[2814]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 12 07:19:33 outdoor-speakers volumio[2814]: Reading Config from "/tmp/volspotify.toml" May 12 07:19:33 outdoor-speakers volumio[1014]: [SpotifyConnect] Vollibrespot Daemon service started! May 12 07:19:33 outdoor-speakers volumio[1014]: [Metrics] SpotifyConnect: 0s 149.04ms May 12 07:19:33 outdoor-speakers volumio[2814]: [Vollibrespot] : Using Alsa backend with device: softvolume May 12 07:19:33 outdoor-speakers volumio[1014]: info: Done. May 12 07:19:33 outdoor-speakers volumio[2814]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } May 12 07:19:36 outdoor-speakers volumio[1014]: info: CoreCommandRouter::getUIConfigOnPlugin May 12 07:19:37 outdoor-speakers volumio[1014]: info: Checking Spotify Web API May 12 07:19:49 outdoor-speakers volumio[1014]: error: error May 12 07:19:52 outdoor-speakers volumio[1014]: info: CALLMETHOD: music_service spop saveVolspotconnectAccount [object Object] May 12 07:19:52 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: spop , saveVolspotconnectAccount May 12 07:19:52 outdoor-speakers volumio[1014]: [SpotifyConnect] Creating VLS config file May 12 07:19:52 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 07:19:52 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 07:19:52 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 07:19:52 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 07:19:52 outdoor-speakers volumio[1014]: [SpotifyConnect] Restarting Vollibrespot Daemon May 12 07:19:52 outdoor-speakers sudo[2876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service May 12 07:19:52 outdoor-speakers sudo[2876]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 07:19:52 outdoor-speakers systemd[1]: Stopping Volspotconnect2 Daemon... May 12 07:19:52 outdoor-speakers systemd[1]: Starting Volspotconnect2 Daemon... May 12 07:19:52 outdoor-speakers systemd[1]: Started Volspotconnect2 Daemon. May 12 07:19:52 outdoor-speakers sudo[2876]: pam_unix(sudo:session): session closed for user root May 12 07:19:53 outdoor-speakers volumio[2882]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 12 07:19:53 outdoor-speakers volumio[2882]: Reading Config from "/tmp/volspotify.toml" May 12 07:19:53 outdoor-speakers volumio[2882]: [Vollibrespot] : Using Alsa backend with device: softvolume May 12 07:19:53 outdoor-speakers volumio[1014]: [SpotifyConnect] Vollibrespot Daemon service restarted! May 12 07:19:53 outdoor-speakers volumio[2882]: [Vollibrespot] : Connecting to AP "ap-gae2.spotify.com:443" May 12 07:19:54 outdoor-speakers volumio[2882]: [Vollibrespot] : Authenticated as "jamesoallan" ! May 12 07:19:54 outdoor-speakers volumio[2882]: [Vollibrespot] : Country: "AU" May 12 07:19:54 outdoor-speakers volumio[2882]: [Vollibrespot] : Using alsa sink May 12 07:19:54 outdoor-speakers volumio[2882]: [Vollibrespot] : Metadata pipe established May 12 07:19:54 outdoor-speakers volumio[2882]: [Vollibrespot] : Event: Volume { volume_to_mixer: 32768 } May 12 07:19:54 outdoor-speakers volumio[1014]: [SpotifyConnect] 50.000762951094835 May 12 07:19:54 outdoor-speakers volumio[1014]: [SpotifyConnect] Volume: Spotify:50.000762951094835 Volumio: 50 May 12 07:19:54 outdoor-speakers volumio[1014]: info: CoreStateMachine::pushState May 12 07:19:54 outdoor-speakers volumio[1014]: info: CoreCommandRouter::volumioPushState May 12 07:19:54 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 07:19:58 outdoor-speakers volumio[1014]: info: CALLMETHOD: music_service spop saveVolspotconnectSettings [object Object] May 12 07:19:58 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: spop , saveVolspotconnectSettings May 12 07:19:58 outdoor-speakers volumio[1014]: error: Failed callmethod call: TypeError: Cannot read property 'config' of undefined May 12 07:19:59 outdoor-speakers volumio[1014]: info: Checking Spotify Web API May 12 07:19:59 outdoor-speakers volumio[2882]: [Vollibrespot] : ReqToken May 12 07:19:59 outdoor-speakers volumio[1014]: [SpotifyConnect] BQDQ_8UdhQOYX4c2aCuXF9VCEil5ktYqffyOazSTb1wcxO0Sh4_glA2cAxxtjQb33yktLx3TxaMitrIUVc4ZU1TiJzGByyHVDJDuUK8hcj2wtjinfUmNKCTE76wT3hTvFxMlCKgNiYF5xnj9uoQpu98J5SsNdnaxGCMeOZnVKdHwhKLjdUNn7gp-M-b5pZBl71H1hIH3svJAnW4hPfgtRTYWFq7Eqv4_IO2H0ZRquHulIUKdVg May 12 07:19:59 outdoor-speakers volumio[1014]: [SpotifyConnect] No active spotify devices found May 12 07:19:59 outdoor-speakers volumio[1014]: [SpotifyConnect] Devices: { devices: May 12 07:19:59 outdoor-speakers volumio[1014]: [ { id: 'fd1b4eb611164d5f87d01cf06028f05ca85ef0dc', May 12 07:19:59 outdoor-speakers volumio[1014]: is_active: false, May 12 07:19:59 outdoor-speakers volumio[1014]: is_private_session: false, May 12 07:19:59 outdoor-speakers volumio[1014]: is_restricted: false, May 12 07:19:59 outdoor-speakers volumio[1014]: name: 'iPhone', May 12 07:19:59 outdoor-speakers volumio[1014]: supports_volume: false, May 12 07:19:59 outdoor-speakers volumio[1014]: type: 'Smartphone', May 12 07:19:59 outdoor-speakers volumio[1014]: volume_percent: 100 }, May 12 07:19:59 outdoor-speakers volumio[1014]: { id: 'f8f127f201ca5407894f9db23bec0ed98a629275', May 12 07:19:59 outdoor-speakers volumio[1014]: is_active: false, May 12 07:19:59 outdoor-speakers volumio[1014]: is_private_session: false, May 12 07:19:59 outdoor-speakers volumio[1014]: is_restricted: false, May 12 07:19:59 outdoor-speakers volumio[1014]: name: 'outdoor-speakers', May 12 07:19:59 outdoor-speakers volumio[1014]: supports_volume: true, May 12 07:19:59 outdoor-speakers volumio[1014]: type: 'AVR', May 12 07:19:59 outdoor-speakers volumio[1014]: volume_percent: 50 }, May 12 07:19:59 outdoor-speakers volumio[1014]: [length]: 2 ] } May 12 07:20:11 outdoor-speakers volumio[1014]: info: CoreCommandRouter::volumioGetVisibleSources May 12 07:20:11 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 07:20:16 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 12 07:20:18 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 12 07:20:21 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 12 07:20:23 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreCommandRouter::volumioReplaceandPlayItems May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreStateMachine::ClearQueue May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreStateMachine::stop May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreStateMachine::serviceStop May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreCommandRouter::serviceStop May 12 07:20:28 outdoor-speakers volumio[1014]: [SpotifyConnect] Spotify Received stop May 12 07:20:28 outdoor-speakers volumio[1014]: info: CorePlayQueue::clearPlayQueue May 12 07:20:28 outdoor-speakers volumio[1014]: info: CorePlayQueue::saveQueue May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreCommandRouter::volumioPushState May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreCommandRouter::volumioPushQueue May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreStateMachine::addQueueItems May 12 07:20:28 outdoor-speakers volumio[1014]: info: CorePlayQueue::addQueueItems May 12 07:20:28 outdoor-speakers volumio[1014]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 12 07:20:28 outdoor-speakers volumio[1014]: info: CorePlayQueue::saveQueue May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreCommandRouter::volumioPushQueue May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreStateMachine::updateTrackBlock May 12 07:20:28 outdoor-speakers volumio[1014]: info: CorePlayQueue::getTrackBlock May 12 07:20:28 outdoor-speakers volumio[1014]: info: CoreCommandRouter::volumioPlay May 12 07:20:28 outdoor-speakers volumio[1014]: verbose: UNSET VOLATILE May 12 07:20:28 outdoor-speakers volumio[1014]: [SpotifyConnect] unSetVolatile called May 12 07:20:28 outdoor-speakers volumio[1014]: info: Spotify Unset Volatile called May 12 07:20:28 outdoor-speakers volumio[1014]: [SpotifyConnect] Relinquishing Volumio State to another service May 12 07:20:28 outdoor-speakers volumio[1014]: [SpotifyConnect] Spotify Received stop May 12 07:20:28 outdoor-speakers volumio[2882]: [Vollibrespot] : Pause May 12 07:20:28 outdoor-speakers volumio[1014]: [SpotifyConnect] Pause May 12 07:20:31 outdoor-speakers volumio[1014]: info: CoreCommandRouter::volumioPlay May 12 07:20:31 outdoor-speakers volumio[1014]: verbose: UNSET VOLATILE May 12 07:20:31 outdoor-speakers volumio[1014]: [SpotifyConnect] unSetVolatile called May 12 07:20:31 outdoor-speakers volumio[1014]: info: Spotify Unset Volatile called May 12 07:20:31 outdoor-speakers volumio[1014]: [SpotifyConnect] Relinquishing Volumio State to another service May 12 07:20:31 outdoor-speakers volumio[1014]: [SpotifyConnect] Spotify Received stop May 12 07:20:31 outdoor-speakers volumio[1014]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 07:20:31 outdoor-speakers volumio[1014]: Error [ERR_SOCKET_DGRAM_NOT_RUNNING]: Not running May 12 07:20:31 outdoor-speakers volumio[1014]: at Socket._healthCheck (dgram.js:638:11) May 12 07:20:31 outdoor-speakers volumio[1014]: at Socket.send (dgram.js:435:8) May 12 07:20:31 outdoor-speakers volumio[1014]: at SpotConnEvents.sendmsg (/data/plugins/music_service/spop/SpotConnController.js:106:21) May 12 07:20:31 outdoor-speakers volumio[1014]: at ControllerSpotify.stop (/data/plugins/music_service/spop/index.js:2674:19) May 12 07:20:31 outdoor-speakers volumio[1014]: at ControllerSpotify.spotConnUnsetVolatile (/data/plugins/music_service/spop/index.js:2355:17) May 12 07:20:31 outdoor-speakers volumio[1014]: at ControllerSpotify.unsetVol (/data/plugins/music_service/spop/index.js:68:21) May 12 07:20:31 outdoor-speakers volumio[1014]: at CoreStateMachine.unSetVolatile (/volumio/app/statemachine.js:1519:27) May 12 07:20:31 outdoor-speakers volumio[1014]: at CoreCommandRouter.volumioPlay (/volumio/app/index.js:1305:21) May 12 07:20:31 outdoor-speakers volumio[1014]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:202:35) May 12 07:20:31 outdoor-speakers volumio[1014]: at emitTwo (events.js:126:13) May 12 07:20:31 outdoor-speakers volumio[1014]: at Socket.emit (events.js:214:7) May 12 07:20:31 outdoor-speakers volumio[1014]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 12 07:20:31 outdoor-speakers volumio[1014]: at _combinedTickCallback (internal/process/next_tick.js:131:7) May 12 07:20:31 outdoor-speakers volumio[1014]: at process._tickCallback (internal/process/next_tick.js:180:9) May 12 07:20:31 outdoor-speakers volumio[1014]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 07:20:33 outdoor-speakers sudo[2981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-12 07:19 May 12 07:20:33 outdoor-speakers sudo[2981]: 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"