-- Logs begin at Wed 2023-08-02 03:18:03 UTC, end at Wed 2024-05-01 12:38:09 UTC. -- May 01 12:37:46 volumio systemd[830]: Time has been changed May 01 12:37:46 volumio systemd[1]: Time has been changed May 01 12:37:46 volumio dhcpcd[1018]: wlan0: using IPv4LL address 169.254.17.217 May 01 12:37:46 volumio avahi-daemon[630]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.17.217. May 01 12:37:46 volumio dhcpcd[1018]: eth0: adding route to 10.0.0.0/24 May 01 12:37:46 volumio dhcpcd[1018]: eth0: adding default route via 10.0.0.1 May 01 12:37:46 volumio dhcpcd[1018]: wlan0: adding host route to 169.254.17.217 via 127.0.0.1 May 01 12:37:46 volumio dhcpcd[1018]: wlan0: adding route to 169.254.0.0/16 May 01 12:37:46 volumio avahi-daemon[630]: New relevant interface wlan0.IPv4 for mDNS. May 01 12:37:46 volumio avahi-daemon[630]: Registering new address record for 169.254.17.217 on wlan0.IPv4. May 01 12:37:46 volumio dhcpcd[1018]: eth0: removing route to 10.0.0.0/24 May 01 12:37:46 volumio dhcpcd[1018]: eth0: removing default route via 10.0.0.1 May 01 12:37:47 volumio wireless.js[767]: trying... May 01 12:37:47 volumio sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 01 12:37:47 volumio sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:37:47 volumio sudo[1216]: pam_unix(sudo:session): session closed for user root May 01 12:37:47 volumio wireless.js[767]: Connected to: ----HOME-FFB8-2.4 May 01 12:37:47 volumio wireless.js[767]: ---- May 01 12:37:47 volumio sudo[1225]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 12:37:47 volumio sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:37:47 volumio sudo[1225]: pam_unix(sudo:session): session closed for user root May 01 12:37:47 volumio wireless.js[767]: ... joined AP, wlan0 IPv4 is 169.254.17.217, ipV6 is undefined May 01 12:37:47 volumio wireless.js[767]: It's done! AP May 01 12:37:47 volumio systemd[1]: Started Wireless Services. May 01 12:37:47 volumio systemd[1]: Starting Volumio Backend Module... May 01 12:37:47 volumio systemd[1]: Started Volumio Backend Module. May 01 12:37:47 volumio systemd[1]: Starting Volumio Streaming Daemon... May 01 12:37:47 volumio systemd[1]: Started Volumio Streaming Daemon. May 01 12:37:47 volumio systemd[1]: Starting Multi-User System. May 01 12:37:47 volumio systemd[1]: Reached target Multi-User System. May 01 12:37:47 volumio systemd[1]: Starting Graphical Interface. May 01 12:37:47 volumio systemd[1]: Reached target Graphical Interface. May 01 12:37:47 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 01 12:37:47 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. May 01 12:37:47 volumio systemd[1]: Startup finished in 9.352s (kernel) + 27.215s (userspace) = 36.568s. May 01 12:37:47 volumio volumio-streaming-daemon[1235]: ############################ May 01 12:37:47 volumio volumio-streaming-daemon[1235]: # Volumio Streaming Daemon # May 01 12:37:47 volumio volumio-streaming-daemon[1235]: # Running on port 7777 # May 01 12:37:47 volumio volumio-streaming-daemon[1235]: ############################ May 01 12:37:47 volumio volumio-streaming-daemon[1235]: Environment: production May 01 12:37:48 volumio ntpd[721]: Listen normally on 4 wlan0 169.254.17.217 UDP 123 May 01 12:37:48 volumio ntpd[721]: peers refreshed May 01 12:37:49 volumio volumio[1234]: info: ------------------------------------------- May 01 12:37:49 volumio volumio[1234]: info: ----- Volumio2 ---- May 01 12:37:49 volumio volumio[1234]: info: ------------------------------------------- May 01 12:37:49 volumio volumio[1234]: info: ----- System startup ---- May 01 12:37:49 volumio volumio[1234]: info: ------------------------------------------- May 01 12:37:50 volumio volumio[1234]: info: MYVOLUMIO Environment detected May 01 12:37:50 volumio volumio[1234]: info: Plugin folders cleanup May 01 12:37:50 volumio volumio[1234]: info: Scanning into folder /volumio/app/plugins/ May 01 12:37:50 volumio volumio[1234]: info: Scanning category audio_interface May 01 12:37:50 volumio volumio[1234]: info: Scanning category miscellanea May 01 12:37:50 volumio volumio[1234]: info: Scanning category music_service May 01 12:37:50 volumio volumio[1234]: info: Scanning category plugins.json May 01 12:37:50 volumio volumio[1234]: info: Scanning category system_controller May 01 12:37:50 volumio volumio[1234]: info: Scanning category user_interface May 01 12:37:50 volumio volumio[1234]: info: Scanning into folder /data/plugins/ May 01 12:37:50 volumio volumio[1234]: info: Scanning category miscellanea May 01 12:37:50 volumio volumio[1234]: info: Scanning category music_service May 01 12:37:50 volumio volumio[1234]: info: Plugin folders cleanup completed May 01 12:37:50 volumio volumio[1234]: info: ------------------------------------------- May 01 12:37:50 volumio volumio[1234]: info: ----- Core plugins startup ---- May 01 12:37:50 volumio volumio[1234]: info: ------------------------------------------- May 01 12:37:50 volumio volumio[1234]: info: Loading plugins from folder /volumio/app/plugins/ May 01 12:37:50 volumio volumio[1234]: info: Adding plugin upnp to MyMusic Plugins May 01 12:37:50 volumio volumio[1234]: info: Adding plugin airplay_emulation to MyMusic Plugins May 01 12:37:50 volumio volumio[1234]: info: Adding plugin upnp_browser to MyMusic Plugins May 01 12:37:50 volumio volumio[1234]: info: Loading plugins from folder /data/plugins/ May 01 12:37:50 volumio volumio[1234]: info: Loading plugin "system"... May 01 12:37:50 volumio volumio[1234]: info: Loading plugin "appearance"... May 01 12:37:51 volumio dhcpcd[1018]: wlan0: soliciting a DHCP lease May 01 12:37:51 volumio volumio[1234]: info: Loading plugin "network"... May 01 12:37:51 volumio volumio[1234]: info: Refreshing Cached IP Addresses May 01 12:37:51 volumio volumio[1234]: info: Loading plugin "touch_display"... May 01 12:37:51 volumio sudo[1261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 12:37:51 volumio sudo[1261]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:37:51 volumio sudo[1263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 12:37:51 volumio sudo[1261]: pam_unix(sudo:session): session closed for user root May 01 12:37:51 volumio sudo[1263]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:37:51 volumio sudo[1263]: pam_unix(sudo:session): session closed for user root May 01 12:37:51 volumio volumio[1234]: info: Applying required configuration parameters for plugin touch_display May 01 12:37:51 volumio volumio[1234]: info: Loading plugin "services"... May 01 12:37:51 volumio volumio[1234]: info: Loading plugin "alsa_controller"... May 01 12:37:51 volumio volumio[1234]: info: Loading plugin "wizard"... May 01 12:37:51 volumio volumio[1234]: info: Loading plugin "virtual_keyboard"... May 01 12:37:51 volumio volumio[1234]: info: Applying required configuration parameters for plugin virtual_keyboard May 01 12:37:51 volumio volumio[1234]: info: Loading plugin "volumio_command_line_client"... May 01 12:37:51 volumio volumio[1234]: info: Loading plugin "upnp"... May 01 12:37:51 volumio volumio[1234]: info: [1714567071893] Starting Upmpd Daemon May 01 12:37:51 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 12:37:51 volumio volumio[1234]: info: Loading plugin "my_music"... May 01 12:37:51 volumio volumio[1234]: info: Loading plugin "mpd"... May 01 12:37:52 volumio volumio[1234]: info: Loading plugin "upnp_browser"... May 01 12:37:52 volumio volumio[1234]: info: Loading plugin "networkfs"... May 01 12:37:52 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 12:37:52 volumio volumio[1234]: info: Loading plugin "alarm-clock"... May 01 12:37:52 volumio sudo[1287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=music,password=music1,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //2023NEWPC/MrB's Complete Albums /mnt/NAS/MrB's_Complete_Albums May 01 12:37:52 volumio sudo[1287]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:37:52 volumio sudo[1289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=music,password=music1,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //2023NEWPC/MrB's Singles by Genre /mnt/NAS/MrB's_Singles_by_Genre May 01 12:37:52 volumio sudo[1289]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:37:52 volumio volumio[1234]: info: Loading plugin "airplay_emulation"... May 01 12:37:52 volumio volumio[1234]: info: Starting Shairport Sync May 01 12:37:52 volumio volumio[1234]: info: Loading plugin "last_100"... May 01 12:37:52 volumio volumio[1234]: info: Loading plugin "webradio"... May 01 12:37:53 volumio volumio[1234]: info: Loading plugin "i2s_dacs"... May 01 12:37:53 volumio volumio[1234]: info: I2S DAC not set, start Auto-detection May 01 12:37:53 volumio volumio[1234]: info: Loading plugin "volumiodiscovery"... May 01 12:37:53 volumio volumio[1234]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 12:37:53 volumio node[1234]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 01 12:37:53 volumio node[1234]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 12:37:53 volumio node[1234]: *** WARNING *** For more information see May 01 12:37:53 volumio node[1234]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 12:37:53 volumio node[1234]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 12:37:53 volumio node[1234]: *** WARNING *** For more information see May 01 12:37:53 volumio volumio[1234]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 12:37:53 volumio volumio[1234]: *** WARNING *** For more information see May 01 12:37:53 volumio volumio[1234]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 01 12:37:53 volumio volumio[1234]: *** WARNING *** Please fix your application to use the native API of Avahi! May 01 12:37:53 volumio volumio[1234]: *** WARNING *** For more information see May 01 12:37:53 volumio volumio[1234]: info: Applying required configuration parameters for plugin volumiodiscovery May 01 12:37:53 volumio volumio[1234]: Discovery: StartAdv! undefined May 01 12:37:53 volumio volumio[1234]: Discovery: Started advertising... Volumio - undefined May 01 12:37:53 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 12:37:53 volumio volumio[1234]: info: Loading plugin "outputs"... May 01 12:37:53 volumio volumio[1234]: info: Loading plugin "albumart"... May 01 12:37:53 volumio volumio[1234]: info: Plugin example_plugin is not enabled May 01 12:37:53 volumio volumio[1234]: info: Loading plugin "inputs"... May 01 12:37:53 volumio volumio[1234]: info: Loading plugin "updater_comm"... May 01 12:37:53 volumio kernel: FS-Cache: Netfs 'cifs' registered for caching May 01 12:37:53 volumio kernel: Key type cifs.spnego registered May 01 12:37:53 volumio kernel: Key type cifs.idmap registered May 01 12:37:53 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. May 01 12:37:53 volumio volumio[1234]: info: Plugin mpdemulation is not enabled May 01 12:37:53 volumio volumio[1234]: info: Loading plugin "rest_api"... May 01 12:37:53 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. May 01 12:37:53 volumio kernel: FS-Cache: Duplicate cookie detected May 01 12:37:53 volumio kernel: FS-Cache: O-cookie c=3ae4411c [p=eac62f9e fl=222 nc=0 na=1] May 01 12:37:53 volumio kernel: FS-Cache: O-cookie d=a8d58017 n=49aff54f May 01 12:37:53 volumio kernel: FS-Cache: O-key=[8] '020001bd0a0000aa' May 01 12:37:53 volumio kernel: FS-Cache: N-cookie c=1bba2a89 [p=eac62f9e fl=2 nc=0 na=1] May 01 12:37:53 volumio kernel: FS-Cache: N-cookie d=a8d58017 n=473ef48f May 01 12:37:53 volumio kernel: FS-Cache: N-key=[8] '020001bd0a0000aa' May 01 12:37:53 volumio volumio[1234]: info: Loading plugin "websocket"... May 01 12:37:53 volumio volumio-remote-updater[576]: [2024-05-01 12:37:53] [connect] Successful connection May 01 12:37:53 volumio volumio[1234]: info: Loading plugin "pandora"... May 01 12:37:53 volumio volumio[1234]: Forking 3 albumart workers May 01 12:37:53 volumio sudo[1289]: pam_unix(sudo:session): session closed for user root May 01 12:37:53 volumio sudo[1287]: pam_unix(sudo:session): session closed for user root May 01 12:37:53 volumio volumio[1234]: Starting albumart workers May 01 12:37:53 volumio volumio[1234]: Starting albumart workers May 01 12:37:54 volumio volumio[1234]: Starting albumart workers May 01 12:37:54 volumio dhcpcd[1018]: wlan0: offered 10.0.0.192 from 10.0.0.1 May 01 12:37:54 volumio volumio[1234]: info: Applying required configuration parameters for plugin pandora May 01 12:37:54 volumio volumio[1234]: info: Loading plugin "spop"... May 01 12:37:55 volumio volumio[1234]: info: Loading plugin "volspotconnect2"... May 01 12:37:56 volumio volumio[1234]: info: ___________ START PLUGINS ___________ May 01 12:37:56 volumio volumio[1234]: info: Loading i18n strings for locale en May 01 12:37:56 volumio volumio[1234]: info: Loading i18n strings for locale en May 01 12:37:56 volumio sudo[1413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 01 12:37:56 volumio sudo[1413]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 01 12:37:56 volumio volumio[1234]: info: [1714567076118] CoreMusicLibrary::Adding element Media Servers May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 12:37:56 volumio systemd[1]: Reloading. May 01 12:37:56 volumio volumio[1234]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 01 12:37:56 volumio volumio[1234]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 01 12:37:56 volumio volumio[1234]: info: [1714567076225] CoreMusicLibrary::Adding element Last_100 May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 12:37:56 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' May 01 12:37:56 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' May 01 12:37:56 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' May 01 12:37:56 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 01 12:37:56 volumio volumio[1234]: info: [1714567076228] CoreMusicLibrary::Adding element Webradio May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 01 12:37:56 volumio volumio[1234]: info: [1714567076240] CoreMusicLibrary::Adding element Pandora Radio May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 12:37:56 volumio volumio[1234]: info: [1714567076242] ControllerPandora::initializeMQTT May 01 12:37:56 volumio volumio[1234]: info: [1714567076243] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration May 01 12:37:56 volumio sudo[1413]: pam_unix(sudo:session): session closed for user root May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 01 12:37:56 volumio volumio[1234]: [SpotifyConnect] Creating VLS config file May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: [SpotifyConnect] Starting metadata listener May 01 12:37:56 volumio sudo[1438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts May 01 12:37:56 volumio sudo[1438]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:37:56 volumio volumio[1234]: [SpotifyConnect] Creating VLS config file May 01 12:37:56 volumio sudo[1438]: pam_unix(sudo:session): session closed for user root May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: [SpotifyConnect] Unimplemented debug mode!! May 01 12:37:56 volumio volumio[1234]: [SpotifyConnect] Starting metadata listener May 01 12:37:56 volumio sudo[1444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service May 01 12:37:56 volumio sudo[1444]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:37:56 volumio volumio[1234]: info: ------------------------------------------- May 01 12:37:56 volumio volumio[1234]: info: ----- MyVolumio plugins startup ---- May 01 12:37:56 volumio volumio[1234]: info: ------------------------------------------- May 01 12:37:56 volumio volumio[1234]: info: [MyVolumio PluginManager] Fetching plans data.... May 01 12:37:56 volumio volumio[1234]: info: Loading i18n strings for locale en May 01 12:37:56 volumio volumio[1234]: Updating browse sources language May 01 12:37:56 volumio volumio[1234]: Cannot find translation for sourceMedia Servers May 01 12:37:56 volumio sudo[1452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service May 01 12:37:56 volumio volumio[1234]: Cannot find translation for sourcePandora Radio May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 12:37:56 volumio systemd[1]: Starting Volspotconnect2 Daemon... May 01 12:37:56 volumio systemd[1]: Failed to reset devices.list on /system.slice: Invalid argument May 01 12:37:56 volumio systemd[1]: Started Volspotconnect2 Daemon. May 01 12:37:56 volumio sudo[1452]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::initPlayerControls May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:37:56 volumio volumio[1234]: info: BOOT COMPLETED May 01 12:37:56 volumio volumio[1234]: [Metrics] CommandRouter: 7s 126.64ms May 01 12:37:56 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 12:37:56 volumio sudo[1444]: pam_unix(sudo:session): session closed for user root May 01 12:37:56 volumio systemd[1]: Starting Volspotconnect2 Daemon... May 01 12:37:56 volumio systemd[1]: Started Volspotconnect2 Daemon. May 01 12:37:56 volumio sudo[1452]: pam_unix(sudo:session): session closed for user root May 01 12:37:56 volumio volumio[1457]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 01 12:37:56 volumio volumio[1457]: Reading Config from "/tmp/volspotify.toml" May 01 12:37:56 volumio volumio[1457]: Malformed config key: missing field `Authentication` May 01 12:37:56 volumio volumio[1468]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 May 01 12:37:56 volumio volumio[1468]: Reading Config from "volspotify.toml" May 01 12:37:56 volumio volumio[1468]: [Vollibrespot] : Using Alsa backend with device: plughw:1 May 01 12:37:57 volumio volumio[1468]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } May 01 12:37:58 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. May 01 12:37:58 volumio systemd[1]: Stopping Volspotconnect2 Daemon... May 01 12:37:58 volumio systemd[1]: Starting Volspotconnect2 Daemon... May 01 12:37:58 volumio systemd[1]: Started Volspotconnect2 Daemon. May 01 12:37:58 volumio volumio[1474]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 01 12:37:58 volumio volumio[1474]: Reading Config from "/tmp/volspotify.toml" May 01 12:37:58 volumio volumio[1474]: Malformed config key: missing field `Authentication` May 01 12:37:59 volumio dhcpcd[1018]: wlan0: leased 10.0.0.192 for 172800 seconds May 01 12:37:59 volumio avahi-daemon[630]: Registering new address record for 10.0.0.192 on wlan0.IPv4. May 01 12:37:59 volumio avahi-daemon[630]: Withdrawing address record for 169.254.17.217 on wlan0. May 01 12:37:59 volumio avahi-daemon[630]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.17.217. May 01 12:37:59 volumio avahi-daemon[630]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.0.192. May 01 12:37:59 volumio dhcpcd[1018]: eth0: adding route to 10.0.0.0/24 May 01 12:37:59 volumio dhcpcd[1018]: eth0: adding default route via 10.0.0.1 May 01 12:37:59 volumio dhcpcd[1018]: wlan0: adding host route to 10.0.0.192 via 127.0.0.1 May 01 12:37:59 volumio dhcpcd[1018]: wlan0: adding route to 10.0.0.0/24 May 01 12:37:59 volumio dhcpcd[1018]: wlan0: adding default route via 10.0.0.1 May 01 12:37:59 volumio dhcpcd[1018]: wlan0: deleting host route to 169.254.17.217 via 127.0.0.1 May 01 12:37:59 volumio dhcpcd[1018]: wlan0: deleting route to 169.254.0.0/16 May 01 12:37:59 volumio dhcpcd[1018]: eth0: removing route to 10.0.0.0/24 May 01 12:37:59 volumio dhcpcd[1018]: eth0: removing default route via 10.0.0.1 May 01 12:38:01 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. May 01 12:38:01 volumio systemd[1]: Stopping Volspotconnect2 Daemon... May 01 12:38:01 volumio systemd[1]: Starting Volspotconnect2 Daemon... May 01 12:38:01 volumio systemd[1]: Started Volspotconnect2 Daemon. May 01 12:38:01 volumio volumio[1502]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 01 12:38:01 volumio volumio[1502]: Reading Config from "/tmp/volspotify.toml" May 01 12:38:01 volumio volumio[1502]: Malformed config key: missing field `Authentication` May 01 12:38:01 volumio volumio[1234]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo May 01 12:38:01 volumio volumio[1234]: info: CoreCommandRouter::Close All Modals sent May 01 12:38:01 volumio volumio[1234]: info: CoreCommandRouter::Close All Modals sent May 01 12:38:01 volumio volumio[1234]: Express server listening on port 3000 May 01 12:38:01 volumio volumio[1234]: [Metrics] WebUI: 12s 983.69ms May 01 12:38:01 volumio volumio[1234]: Volumio Calling Home May 01 12:38:01 volumio ntpd[721]: Listen normally on 5 wlan0 10.0.0.192 UDP 123 May 01 12:38:01 volumio ntpd[721]: Deleting interface #4 wlan0, 169.254.17.217#123, interface stats: received=0, sent=0, dropped=0, active_time=13 secs May 01 12:38:01 volumio ntpd[721]: peers refreshed May 01 12:38:01 volumio volumio[1234]: info: [1714567081819] ControllerPandora::validateAndSetAccountOptions May 01 12:38:01 volumio volumio[1234]: info: [1714567081820] ControllerPandora::initialSetup May 01 12:38:01 volumio volumio[1234]: info: [1714567081821] ControllerPandora::PandoraHandler::init May 01 12:38:01 volumio volumio[1234]: info: [1714567081823] ControllerPandora::PandoraHandler::loadErrorCodes May 01 12:38:01 volumio volumio[1234]: [SpotifyConnect] Error: bind EADDRINUSE 0.0.0.0:5030 May 01 12:38:01 volumio volumio[1234]: at Object._errnoException (util.js:1022:11) May 01 12:38:01 volumio volumio[1234]: at _exceptionWithHostPort (util.js:1044:20) May 01 12:38:01 volumio volumio[1234]: at _handle.lookup (dgram.js:266:18) May 01 12:38:01 volumio volumio[1234]: at _combinedTickCallback (internal/process/next_tick.js:141:11) May 01 12:38:01 volumio volumio[1234]: at process._tickCallback (internal/process/next_tick.js:180:9) May 01 12:38:01 volumio volumio[1234]: at Function.Module.runMain (module.js:695:11) May 01 12:38:01 volumio volumio[1234]: at startup (bootstrap_node.js:188:16) May 01 12:38:01 volumio volumio[1234]: at bootstrap_node.js:609:3 May 01 12:38:01 volumio volumio[1234]: [SpotifyConnect] Error [ERR_SOCKET_CANNOT_SEND]: Unable to send data May 01 12:38:01 volumio volumio[1234]: at Socket.onListenError (dgram.js:362:22) May 01 12:38:01 volumio volumio[1234]: at Object.onceWrapper (events.js:315:30) May 01 12:38:01 volumio volumio[1234]: at emitOne (events.js:121:20) May 01 12:38:01 volumio volumio[1234]: at Socket.emit (events.js:211:7) May 01 12:38:01 volumio volumio[1234]: at _handle.lookup (dgram.js:267:14) May 01 12:38:01 volumio volumio[1234]: at _combinedTickCallback (internal/process/next_tick.js:141:11) May 01 12:38:01 volumio volumio[1234]: at process._tickCallback (internal/process/next_tick.js:180:9) May 01 12:38:01 volumio volumio[1234]: at Function.Module.runMain (module.js:695:11) May 01 12:38:01 volumio volumio[1234]: at startup (bootstrap_node.js:188:16) May 01 12:38:01 volumio volumio[1234]: at bootstrap_node.js:609:3 May 01 12:38:01 volumio volumio[1234]: info: CoreStateMachine::resetVolumioState May 01 12:38:01 volumio volumio[1234]: info: CoreStateMachine::getcurrentVolume May 01 12:38:01 volumio volumio[1234]: info: CoreCommandRouter::volumioRetrievevolume May 01 12:38:01 volumio volumio[1234]: info: [1714567081848] [Pandora] PandoraHandler::setMaxStationTracks: 16 May 01 12:38:01 volumio volumio[1234]: info: [1714567081849] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty May 01 12:38:01 volumio volumio[1234]: info: [1714567081850] ControllerPandora::PandoraHandler::setAccountOptions May 01 12:38:01 volumio volumio[1234]: info: [1714567081852] ControllerPandora::PreventAuthTimeout::fn May 01 12:38:01 volumio volumio[1234]: info: [1714567081853] ControllerPandora::PandoraHandler::pandoraLoginAndGetStations May 01 12:38:01 volumio volumio[1234]: info: [1714567081870] [Pandora] PreventAuthTimeout::init: Timer loaded May 01 12:38:01 volumio volumio[1234]: info: [1714567081870] [Pandora] PreventAuthTimeout::init: Interval set to 10800000 ms May 01 12:38:01 volumio volumio[1234]: info: [1714567081871] [Pandora] ExpireOldTracks::init: Timer loaded May 01 12:38:01 volumio volumio[1234]: info: [1714567081871] [Pandora] ExpireOldTracks::init: Interval set to 300000 ms May 01 12:38:01 volumio volumio[1234]: info: [1714567081872] ControllerPandora::flushPandora May 01 12:38:01 volumio volumio[1234]: info: CorePlayQueue::getQueue May 01 12:38:01 volumio volumio[1234]: info: CorePlayQueue::clearPlayQueue May 01 12:38:01 volumio volumio[1234]: info: CorePlayQueue::saveQueue May 01 12:38:01 volumio volumio[1234]: info: CoreCommandRouter::volumioPushState May 01 12:38:01 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:38:01 volumio volumio[1234]: info: CoreCommandRouter::volumioPushQueue May 01 12:38:01 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 12:38:01 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 01 12:38:01 volumio sudo[1516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 01 12:38:01 volumio sudo[1516]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:38:01 volumio sudo[1519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 01 12:38:01 volumio sudo[1516]: pam_unix(sudo:session): session closed for user root May 01 12:38:01 volumio sudo[1519]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:38:02 volumio sudo[1519]: pam_unix(sudo:session): session closed for user root May 01 12:38:02 volumio volumio[1234]: info: Setting Device type: Raspberry PI May 01 12:38:02 volumio volumio[1234]: [SpotifyConnect] Vollibrespot Daemon service started! May 01 12:38:02 volumio volumio[1234]: [Metrics] SpotifyConnect: 5s 818.79ms May 01 12:38:02 volumio volumio[1234]: [SpotifyConnect] Vollibrespot Daemon service started! May 01 12:38:02 volumio volumio[1234]: [Metrics] SpotifyConnect: 5s 819.98ms May 01 12:38:02 volumio volumio[1234]: info: touch_display: systemctl daemon-reload succeeded. May 01 12:38:02 volumio sudo[1535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 01 12:38:02 volumio volumio[1234]: info: MPD running with PID635 May 01 12:38:02 volumio volumio[1234]: ,establishing connection May 01 12:38:02 volumio sudo[1537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 May 01 12:38:02 volumio sudo[1535]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:38:02 volumio sudo[1537]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:38:02 volumio systemd[1]: Starting Volumio Kiosk... May 01 12:38:02 volumio systemd[1]: Started Volumio Kiosk. May 01 12:38:02 volumio sudo[1537]: pam_unix(sudo:session): session closed for user root May 01 12:38:02 volumio startx[1546]: X.Org X Server 1.18.4 May 01 12:38:02 volumio startx[1546]: Release Date: 2016-07-19 May 01 12:38:02 volumio startx[1546]: X Protocol Version 11, Revision 0 May 01 12:38:02 volumio startx[1546]: Build Operating System: Linux 4.4.26-v7+ armv7l Raspbian May 01 12:38:02 volumio startx[1546]: Current Operating System: Linux volumio 4.19.118-v7l+ #1311 SMP Mon Apr 27 14:26:42 BST 2020 armv7l May 01 12:38:02 volumio startx[1546]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 cma=64M bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:9B:CE:0B vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash quiet plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 console=ttyS0,115200 kgdboc=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh elevator=noop rootwait bootdelay=5 logo.nologo vt.global_cursor_default=0 loglevel=0 snd-bcm2835.enable_compat_alsa=1 snd_bcm2835.enable_headphones=1 May 01 12:38:02 volumio startx[1546]: Build Date: 11 November 2016 11:59:59AM May 01 12:38:02 volumio startx[1546]: xorg-server 2:1.18.4-2+rpi1 (https://www.debian.org/support) May 01 12:38:02 volumio startx[1546]: Current version of pixman: 0.32.6 May 01 12:38:02 volumio startx[1546]: Before reporting problems, check http://wiki.x.org May 01 12:38:02 volumio startx[1546]: to make sure that you have the latest version. May 01 12:38:02 volumio startx[1546]: Markers: (--) probed, (**) from config file, (==) default setting, May 01 12:38:02 volumio startx[1546]: (++) from command line, (!!) notice, (II) informational, May 01 12:38:02 volumio startx[1546]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 01 12:38:02 volumio startx[1546]: (==) Log file: "/var/log/Xorg.1.log", Time: Wed May 1 12:38:02 2024 May 01 12:38:02 volumio startx[1546]: (==) Using config directory: "/etc/X11/xorg.conf.d" May 01 12:38:02 volumio startx[1546]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 01 12:38:02 volumio volumio[1234]: info: VolumeController:: Volume=85 Mute =false May 01 12:38:02 volumio volumio[1234]: info: CoreStateMachine::pushState May 01 12:38:02 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::volumioPushState May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:38:02 volumio volumio[1234]: info: CoreStateMachine::updateTrackBlock May 01 12:38:02 volumio volumio[1234]: info: CorePlayQueue::getTrackBlock May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::volumioRetrievevolume May 01 12:38:02 volumio sudo[1535]: pam_unix(sudo:session): session closed for user root May 01 12:38:02 volumio startx[1546]: modprobe: FATAL: Module g2d_23 not found. May 01 12:38:02 volumio volumio[1234]: info: May 01 12:38:02 volumio volumio[1234]: ---------------------------- Client requests Volume 85 May 01 12:38:02 volumio volumio[1234]: info: VolumeController::SetAlsaVolume85 May 01 12:38:02 volumio volumio[1234]: info: CoreStateMachine::pushState May 01 12:38:02 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::volumioPushState May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:38:02 volumio volumio[1234]: info: touch_display: systemctl start volumio-kiosk.service succeeded. May 01 12:38:02 volumio volumio[1234]: info: touch_display: Volumio Kiosk started May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::volumioGetState May 01 12:38:02 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 12:38:02 volumio volumio[1234]: error: updateQueue error: null May 01 12:38:02 volumio volumio[1234]: error: Failed LSINFO: Error: [50@0] {} No such directory May 01 12:38:02 volumio volumio[1234]: info: Setting volume on startup at 85 May 01 12:38:02 volumio volumio[1234]: info: Reloading queue from file May 01 12:38:02 volumio volumio[1234]: info: CoreStateMachine::setRepeat null single undefined May 01 12:38:02 volumio volumio[1234]: info: CoreStateMachine::pushState May 01 12:38:02 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::volumioPushState May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:38:02 volumio volumio[1234]: info: CoreStateMachine::setRandom false May 01 12:38:02 volumio volumio[1234]: info: CoreStateMachine::pushState May 01 12:38:02 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::volumioPushState May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:38:02 volumio volumio[1234]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X1 May 01 12:38:02 volumio volumio[1234]: info: VolumeController:: Volume=85 Mute =false May 01 12:38:02 volumio volumio[1234]: info: CoreStateMachine::pushState May 01 12:38:02 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::volumioPushState May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 01 12:38:02 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 01 12:38:02 volumio volumio[1234]: info: Starting Shairport Sync May 01 12:38:02 volumio sudo[1609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 01 12:38:02 volumio volumio[1234]: info: Starting Shairport Sync May 01 12:38:02 volumio sudo[1609]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:38:02 volumio sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 01 12:38:02 volumio sudo[1615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 01 12:38:02 volumio sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:38:02 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 01 12:38:02 volumio sudo[1615]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:38:02 volumio sudo[1609]: pam_unix(sudo:session): session closed for user root May 01 12:38:02 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 01 12:38:02 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... May 01 12:38:02 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 01 12:38:02 volumio sudo[1611]: pam_unix(sudo:session): session closed for user root May 01 12:38:02 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 01 12:38:02 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 01 12:38:02 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 01 12:38:02 volumio sudo[1615]: pam_unix(sudo:session): session closed for user root May 01 12:38:03 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. May 01 12:38:03 volumio systemd[1]: Stopping Volspotconnect2 Daemon... May 01 12:38:03 volumio systemd[1]: Starting Volspotconnect2 Daemon... May 01 12:38:03 volumio systemd[1]: Started Volspotconnect2 Daemon. May 01 12:38:03 volumio volumio[1648]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 01 12:38:03 volumio volumio[1648]: Reading Config from "/tmp/volspotify.toml" May 01 12:38:03 volumio volumio[1648]: [Vollibrespot] : Using Alsa backend with device: plughw:1 May 01 12:38:03 volumio volumio[1648]: [Vollibrespot] : Connecting to AP "ap-gue1.spotify.com:443" May 01 12:38:03 volumio volumio[1648]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /home/volumio/.cargo/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 May 01 12:38:03 volumio volumio[1648]: stack backtrace: May 01 12:38:03 volumio volumio[1234]: info: CoreCommandRouter::volumioGetState May 01 12:38:03 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 01 12:38:03 volumio volumio[1234]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X1 May 01 12:38:03 volumio volumio[1234]: info: touch_display: No Raspberry Pi Foundation touch screen detected. May 01 12:38:03 volumio volumio[1234]: Discovery: adding ad43dbc3-b1ce-4696-8a73-e1109e70c5e6 May 01 12:38:03 volumio volumio[1234]: info: mDNS: Found device Volumio May 01 12:38:03 volumio volumio[1234]: info: CoreCommandRouter::volumioGetState May 01 12:38:03 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 01 12:38:04 volumio sudo[1678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf May 01 12:38:04 volumio sudo[1678]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:38:04 volumio sudo[1678]: pam_unix(sudo:session): session closed for user root May 01 12:38:04 volumio volumio[1648]: 0: 0xa4ec40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 May 01 12:38:04 volumio volumio[1648]: 1: 0xa4ec40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 May 01 12:38:04 volumio volumio[1648]: 2: 0xa4ec40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 May 01 12:38:04 volumio volumio[1648]: 3: 0xa4ec40 - ::fmt::hf1c91d83d30a63b5 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 May 01 12:38:04 volumio volumio[1648]: 4: 0xa74d68 - core::fmt::write::he7b81f119cac9e82 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 May 01 12:38:04 volumio volumio[1648]: 5: 0xa485d4 - std::io::Write::write_fmt::hd6a547671801193b May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 May 01 12:38:04 volumio volumio[1648]: 6: 0xa50728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 May 01 12:38:04 volumio volumio[1648]: 7: 0xa50728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 May 01 12:38:04 volumio volumio[1648]: 8: 0xa50728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 May 01 12:38:04 volumio volumio[1648]: 9: 0xa5023c - std::panicking::default_hook::h3b931251a9c4b1f6 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 May 01 12:38:04 volumio volumio[1648]: 10: 0xa50f44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 May 01 12:38:04 volumio volumio[1648]: 11: 0xa50c30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 May 01 12:38:04 volumio volumio[1648]: 12: 0xa4f1bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 May 01 12:38:04 volumio volumio[1648]: 13: 0xa509ec - rust_begin_unwind May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 May 01 12:38:04 volumio volumio[1648]: 14: 0x533e2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 May 01 12:38:04 volumio volumio[1648]: 15: 0x710538 - futures::future::chain::Chain::poll::hccd4c598af3a6335 May 01 12:38:04 volumio volumio[1648]: 16: 0x72aaf4 - as futures::future::Future>::poll::h38eb93796db62721 May 01 12:38:04 volumio volumio[1648]: 17: 0x70cba8 - futures::future::chain::Chain::poll::h39f31221e88b3bd1 May 01 12:38:04 volumio volumio[1648]: 18: 0x796fc0 - as futures::future::Future>::poll::hc585bb28ee7b8420 May 01 12:38:04 volumio volumio[1648]: 19: 0x55cdd8 - ::poll::h06f390c1cf340695 May 01 12:38:04 volumio volumio[1648]: 20: 0x57418c - futures::task_impl::std::set::h917345edbb2d7b17 May 01 12:38:04 volumio volumio[1648]: 21: 0x595f24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 May 01 12:38:04 volumio volumio[1648]: 22: 0x564924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 May 01 12:38:04 volumio volumio[1648]: 23: 0x595bac - std::thread::local::LocalKey::with::hb9ef5b7276039152 May 01 12:38:04 volumio volumio[1648]: 24: 0x584604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d May 01 12:38:04 volumio volumio[1648]: 25: 0x553da4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c May 01 12:38:04 volumio volumio[1648]: 26: 0x55e9a0 - vollibrespot::main::haa33a046348d736f May 01 12:38:04 volumio volumio[1648]: 27: 0x57c6fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 May 01 12:38:04 volumio volumio[1648]: 28: 0x594278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 May 01 12:38:04 volumio volumio[1648]: 29: 0xa41bcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 May 01 12:38:04 volumio volumio[1648]: 30: 0xa41bcc - std::panicking::try::do_call::h7a5efa020212c0f3 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 May 01 12:38:04 volumio volumio[1648]: 31: 0xa41bcc - std::panicking::try::h3145f518af029892 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 May 01 12:38:04 volumio volumio[1648]: 32: 0xa41bcc - std::panic::catch_unwind::h876d78503e730edb May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 May 01 12:38:04 volumio volumio[1648]: 33: 0xa41bcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 May 01 12:38:04 volumio volumio[1648]: 34: 0xa41bcc - std::panicking::try::do_call::h6affa17582fe803e May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 May 01 12:38:04 volumio volumio[1648]: 35: 0xa41bcc - std::panicking::try::hf3254f9f909f508b May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 May 01 12:38:04 volumio volumio[1648]: 36: 0xa41bcc - std::panic::catch_unwind::h17abded8b6d92414 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 May 01 12:38:04 volumio volumio[1648]: 37: 0xa41bcc - std::rt::lang_start_internal::h62925866154f59e6 May 01 12:38:04 volumio volumio[1648]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 May 01 12:38:04 volumio volumio[1648]: 38: 0x55f11c - main May 01 12:38:04 volumio volumio[1648]: 39: 0xb6c10294 - __libc_start_main May 01 12:38:05 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 01 12:38:05 volumio volumio[1234]: info: Listing playlists May 01 12:38:05 volumio volumio[1234]: info: CoreCommandRouter::volumioGetQueue May 01 12:38:05 volumio volumio[1234]: info: CoreStateMachine::getQueue May 01 12:38:05 volumio volumio[1234]: info: CorePlayQueue::getQueue May 01 12:38:05 volumio volumio[1234]: info: CoreCommandRouter::volumioGetVisibleSources May 01 12:38:05 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 01 12:38:05 volumio volumio[1234]: info: Shairport-Sync Started May 01 12:38:05 volumio volumio[1234]: Error adding Membership: Error: addMembership EINVAL May 01 12:38:05 volumio volumio[1234]: info: Upmpdcli Daemon Started May 01 12:38:05 volumio volumio[1234]: info: Shairport-Sync Started May 01 12:38:05 volumio volumio[1234]: info: touch_display: Setting screensaver timeout to 600 seconds. May 01 12:38:05 volumio volumio[1234]: info: touch_display: Touchscreen transformation matrix removed. May 01 12:38:05 volumio volumio[1234]: info: CoreCommandRouter::volumioGetState May 01 12:38:05 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 01 12:38:05 volumio volumio[1234]: info: CoreCommandRouter::volumioGetState May 01 12:38:05 volumio volumio[1234]: info: CorePlayQueue::getTrack 0 May 01 12:38:05 volumio volumio[1234]: info: [1714567085286] [Pandora] PandoraHandler::pandoraLoginAndGetStations::pandoraLogin: [<=- Logged in to Pandora Servers -=>] May 01 12:38:05 volumio volumio[1234]: info: [1714567085289] ControllerPandora::PandoraHandler::fillStationData May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 01 12:38:06 volumio volumio[1234]: info: Adding plugin bluetooth to MyMusic Plugins May 01 12:38:06 volumio volumio[1234]: info: Adding plugin cd_controller to MyMusic Plugins May 01 12:38:06 volumio volumio[1234]: info: Adding plugin smart_inputs to MyMusic Plugins May 01 12:38:06 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 01 12:38:06 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. May 01 12:38:06 volumio systemd[1]: Stopping Volspotconnect2 Daemon... May 01 12:38:06 volumio systemd[1]: Starting Volspotconnect2 Daemon... May 01 12:38:06 volumio systemd[1]: Started Volspotconnect2 Daemon. May 01 12:38:06 volumio volumio[1704]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 01 12:38:06 volumio volumio[1704]: Reading Config from "/tmp/volspotify.toml" May 01 12:38:06 volumio volumio[1704]: [Vollibrespot] : Using Alsa backend with device: plughw:1 May 01 12:38:06 volumio volumio[1704]: [Vollibrespot] : Connecting to AP "ap-gue1.spotify.com:443" May 01 12:38:07 volumio volumio[1704]: thread 'main' panicked at 'Authentication failed with reason: BadCredentials', /home/volumio/.cargo/git/checkouts/librespot-6f197fd632ef9380/08d8bcc/core/src/connection/mod.rs:93:21 May 01 12:38:07 volumio volumio[1704]: stack backtrace: May 01 12:38:07 volumio volumio[1704]: 0: 0xa12c40 - std::backtrace_rs::backtrace::libunwind::trace::h9be44abcd6023537 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5 May 01 12:38:07 volumio volumio[1704]: 1: 0xa12c40 - std::backtrace_rs::backtrace::trace_unsynchronized::he588770997e640ec May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 May 01 12:38:07 volumio volumio[1704]: 2: 0xa12c40 - std::sys_common::backtrace::_print_fmt::h2a5bea2fa6ce9b3d May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:66:5 May 01 12:38:07 volumio volumio[1704]: 3: 0xa12c40 - ::fmt::hf1c91d83d30a63b5 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:45:22 May 01 12:38:07 volumio volumio[1704]: 4: 0xa38d68 - core::fmt::write::he7b81f119cac9e82 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/fmt/mod.rs:1196:17 May 01 12:38:07 volumio volumio[1704]: 5: 0xa0c5d4 - std::io::Write::write_fmt::hd6a547671801193b May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/io/mod.rs:1654:15 May 01 12:38:07 volumio volumio[1704]: 6: 0xa14728 - std::sys_common::backtrace::_print::hcf4a7819f0b4198f May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:48:5 May 01 12:38:07 volumio volumio[1704]: 7: 0xa14728 - std::sys_common::backtrace::print::hb4deb0b578e6c939 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:35:9 May 01 12:38:07 volumio volumio[1704]: 8: 0xa14728 - std::panicking::default_hook::{{closure}}::h7d65a85d73ca528f May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:295:22 May 01 12:38:07 volumio volumio[1704]: 9: 0xa1423c - std::panicking::default_hook::h3b931251a9c4b1f6 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:314:9 May 01 12:38:07 volumio volumio[1704]: 10: 0xa14f44 - std::panicking::rust_panic_with_hook::h52cc4877d8c74a8b May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:698:17 May 01 12:38:07 volumio volumio[1704]: 11: 0xa14c30 - std::panicking::begin_panic_handler::{{closure}}::h7546eed0ba906ec0 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:588:13 May 01 12:38:07 volumio volumio[1704]: 12: 0xa131bc - std::sys_common::backtrace::__rust_end_short_backtrace::h32ad68afde8ac292 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/sys_common/backtrace.rs:138:18 May 01 12:38:07 volumio volumio[1704]: 13: 0xa149ec - rust_begin_unwind May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:584:5 May 01 12:38:07 volumio volumio[1704]: 14: 0x4f7e2c - core::panicking::panic_fmt::h43e2baa6a2dcb05a May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/panicking.rs:142:14 May 01 12:38:07 volumio volumio[1704]: 15: 0x6d4538 - futures::future::chain::Chain::poll::hccd4c598af3a6335 May 01 12:38:07 volumio volumio[1704]: 16: 0x6eeaf4 - as futures::future::Future>::poll::h38eb93796db62721 May 01 12:38:07 volumio volumio[1704]: 17: 0x6d0ba8 - futures::future::chain::Chain::poll::h39f31221e88b3bd1 May 01 12:38:07 volumio volumio[1704]: 18: 0x75afc0 - as futures::future::Future>::poll::hc585bb28ee7b8420 May 01 12:38:07 volumio volumio[1704]: 19: 0x520dd8 - ::poll::h06f390c1cf340695 May 01 12:38:07 volumio volumio[1704]: 20: 0x53818c - futures::task_impl::std::set::h917345edbb2d7b17 May 01 12:38:07 volumio volumio[1704]: 21: 0x559f24 - std::thread::local::LocalKey::with::hebf033a3f9f19674 May 01 12:38:07 volumio volumio[1704]: 22: 0x528924 - tokio_current_thread::Entered

::block_on::h34935ca5acdeef78 May 01 12:38:07 volumio volumio[1704]: 23: 0x559bac - std::thread::local::LocalKey::with::hb9ef5b7276039152 May 01 12:38:07 volumio volumio[1704]: 24: 0x548604 - tokio_reactor::with_default::hcd4b2b1df52c6b3d May 01 12:38:07 volumio volumio[1704]: 25: 0x517da4 - tokio::runtime::current_thread::runtime::Runtime::block_on::hdff564047631f32c May 01 12:38:07 volumio volumio[1704]: 26: 0x5229a0 - vollibrespot::main::haa33a046348d736f May 01 12:38:07 volumio volumio[1704]: 27: 0x5406fc - std::sys_common::backtrace::__rust_begin_short_backtrace::h434d7d11e1d7d897 May 01 12:38:07 volumio volumio[1704]: 28: 0x558278 - std::rt::lang_start::{{closure}}::h7ee31a2c0e916c10 May 01 12:38:07 volumio volumio[1704]: 29: 0xa05bcc - core::ops::function::impls:: for &F>::call_once::h9368c55e0af27eda May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/core/src/ops/function.rs:280:13 May 01 12:38:07 volumio volumio[1704]: 30: 0xa05bcc - std::panicking::try::do_call::h7a5efa020212c0f3 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 May 01 12:38:07 volumio volumio[1704]: 31: 0xa05bcc - std::panicking::try::h3145f518af029892 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 May 01 12:38:07 volumio volumio[1704]: 32: 0xa05bcc - std::panic::catch_unwind::h876d78503e730edb May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 May 01 12:38:07 volumio volumio[1704]: 33: 0xa05bcc - std::rt::lang_start_internal::{{closure}}::hfb915b4bce05c29a May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:48 May 01 12:38:07 volumio volumio[1704]: 34: 0xa05bcc - std::panicking::try::do_call::h6affa17582fe803e May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:492:40 May 01 12:38:07 volumio volumio[1704]: 35: 0xa05bcc - std::panicking::try::hf3254f9f909f508b May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panicking.rs:456:19 May 01 12:38:07 volumio volumio[1704]: 36: 0xa05bcc - std::panic::catch_unwind::h17abded8b6d92414 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/panic.rs:137:14 May 01 12:38:07 volumio volumio[1704]: 37: 0xa05bcc - std::rt::lang_start_internal::h62925866154f59e6 May 01 12:38:07 volumio volumio[1704]: at /rustc/a8314ef7d0ec7b75c336af2c9857bfaf43002bfc/library/std/src/rt.rs:128:20 May 01 12:38:07 volumio volumio[1704]: 38: 0x52311c - main May 01 12:38:07 volumio volumio[1704]: 39: 0xb6c5a294 - __libc_start_main May 01 12:38:08 volumio volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 01 12:38:08 volumio volumio-remote-updater[576]: [2024-05-01 12:38:08] [connect] Successful connection May 01 12:38:09 volumio volumio[1234]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 01 12:38:09 volumio volumio[1234]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 01 12:38:09 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 12:38:09 volumio volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 01 12:38:09 volumio volumio[1234]: info: Starting MyVolumio Remote Streaming Endpoints May 01 12:38:09 volumio volumio[1234]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 01 12:38:09 volumio volumio[1234]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 01 12:38:09 volumio volumio[1234]: info: Streaming services startup May 01 12:38:09 volumio volumio[1234]: info: Starting Streaming Daemon May 01 12:38:09 volumio sudo[1734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 01 12:38:09 volumio sudo[1734]: pam_unix(sudo:session): session opened for user root by (uid=0) May 01 12:38:09 volumio systemd[1]: Stopping Volumio Streaming Daemon... May 01 12:38:09 volumio volumio[1234]: info: MyVolumio not started May 01 12:38:09 volumio volumio[1234]: info: Initializing device activation check May 01 12:38:09 volumio systemd[1]: Starting Volumio Streaming Daemon... May 01 12:38:09 volumio systemd[1]: Started Volumio Streaming Daemon. May 01 12:38:09 volumio sudo[1734]: pam_unix(sudo:session): session closed for user root May 01 12:38:09 volumio volumio-streaming-daemon[1744]: ############################ May 01 12:38:09 volumio volumio-streaming-daemon[1744]: # Volumio Streaming Daemon # May 01 12:38:09 volumio volumio-streaming-daemon[1744]: # Running on port 7777 # May 01 12:38:09 volumio volumio-streaming-daemon[1744]: ############################ May 01 12:38:09 volumio volumio-streaming-daemon[1744]: Environment: production May 01 12:38:09 volumio volumio[1234]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 01 12:38:09 volumio volumio[1234]: info: Checking Spotify Web API May 01 12:38:09 volumio volumio[1234]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 12:38:09 volumio volumio[1234]: { Error: addMembership ENODEV May 01 12:38:09 volumio volumio[1234]: at _errnoException (util.js:1022:11) May 01 12:38:09 volumio volumio[1234]: at Socket.addMembership (dgram.js:615:11) May 01 12:38:09 volumio volumio[1234]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:264:16) May 01 12:38:09 volumio volumio[1234]: at ontimeout (timers.js:482:11) May 01 12:38:09 volumio volumio[1234]: at tryOnTimeout (timers.js:317:5) May 01 12:38:09 volumio volumio[1234]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } May 01 12:38:09 volumio volumio[1234]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 12:38:09 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. May 01 12:38:09 volumio systemd[1]: Stopping Volspotconnect2 Daemon... May 01 12:38:09 volumio systemd[1]: Starting Volspotconnect2 Daemon... May 01 12:38:09 volumio systemd[1]: Started Volspotconnect2 Daemon. May 01 12:38:09 volumio volumio[1773]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 May 01 12:38:09 volumio volumio[1773]: Reading Config from "/tmp/volspotify.toml" May 01 12:38:09 volumio volumio[1773]: [Vollibrespot] : Using Alsa backend with device: plughw:1 May 01 12:38:09 volumio volumio[1773]: [Vollibrespot] : Connecting to AP "ap-gue1.spotify.com:443" May 01 12:38:09 volumio sudo[1780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 12:37 May 01 12:38:09 volumio sudo[1780]: 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="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 14:39:52 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="097e28ee6263e31d0bf6b690a02dcab3"