-- 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"