-- Logs begin at Fri 2024-11-22 17:39:41 UTC, end at Wed 2024-11-27 18:22:26 UTC. -- Nov 27 18:21:00 hobbyraum volumio[829]: info: Loading plugin "youtube2"... Nov 27 18:21:04 hobbyraum volumio-remote-updater[522]: [2024-11-27 18:21:04] [connect] Successful connection Nov 27 18:21:19 hobbyraum volumio-remote-updater[522]: [2024-11-27 18:21:19] [connect] Successful connection Nov 27 18:21:22 hobbyraum volumio[829]: info: Loading plugin "ytcr"... Nov 27 18:21:29 hobbyraum volumio[829]: info: Loading plugin "ytmusic"... Nov 27 18:21:34 hobbyraum volumio-remote-updater[522]: [2024-11-27 18:21:34] [connect] Successful connection Nov 27 18:21:35 hobbyraum volumio[829]: info: Loading plugin "gpio-buttons"... Nov 27 18:21:37 hobbyraum volumio[829]: info: GPIO-Buttons initialized Nov 27 18:21:37 hobbyraum volumio[829]: info: Loading plugin "outputs"... Nov 27 18:21:37 hobbyraum volumio[829]: info: Loading plugin "albumart"... Nov 27 18:21:37 hobbyraum volumio[829]: info: Plugin example_plugin is not enabled Nov 27 18:21:37 hobbyraum volumio[829]: info: Loading plugin "inputs"... Nov 27 18:21:37 hobbyraum volumio[829]: info: Loading plugin "updater_comm"... Nov 27 18:21:38 hobbyraum volumio[829]: info: Plugin mpdemulation is not enabled Nov 27 18:21:39 hobbyraum volumio[829]: info: Loading plugin "rest_api"... Nov 27 18:21:39 hobbyraum volumio[829]: info: Loading plugin "websocket"... Nov 27 18:21:39 hobbyraum volumio[829]: info: Starting Socket.io Server version 2.3.0 Nov 27 18:21:39 hobbyraum volumio[829]: info: Loading plugin "80s80s"... Nov 27 18:21:40 hobbyraum volumio[829]: Forking 1 albumart workers Nov 27 18:21:41 hobbyraum volumio[829]: info: Applying required configuration parameters for plugin 80s80s Nov 27 18:21:41 hobbyraum volumio[829]: info: [1732731701596] [80s80s] API delay: 30 Nov 27 18:21:41 hobbyraum volumio[829]: info: Loading i18n strings for locale de Nov 27 18:21:41 hobbyraum volumio[829]: Updating browse sources language Nov 27 18:21:41 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:21:43 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 18:21:43 hobbyraum volumio[829]: info: CoreCommandRouter::initPlayerControls Nov 27 18:21:43 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:21:43 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:21:43 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:21:43 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 18:21:43 hobbyraum volumio[829]: Express server listening on port 3000 Nov 27 18:21:43 hobbyraum volumio[829]: [Metrics] WebUI: 75s 855.82ms Nov 27 18:21:44 hobbyraum volumio[829]: info: CoreStateMachine::resetVolumioState Nov 27 18:21:44 hobbyraum volumio[829]: info: CoreStateMachine::getcurrentVolume Nov 27 18:21:44 hobbyraum volumio[829]: info: CoreCommandRouter::volumioRetrievevolume Nov 27 18:21:45 hobbyraum sudo[1227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 27 18:21:45 hobbyraum sudo[1225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 27 18:21:45 hobbyraum sudo[1227]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:21:45 hobbyraum sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:21:45 hobbyraum sudo[1227]: pam_unix(sudo:session): session closed for user root Nov 27 18:21:45 hobbyraum sudo[1225]: pam_unix(sudo:session): session closed for user root Nov 27 18:21:46 hobbyraum volumio[829]: info: Volumio Network Manager: Network status updated: 2 Nov 27 18:21:48 hobbyraum volumio[829]: verbose: New Socket.io Connection to 192.168.178.27:3000 from 192.168.178.72 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Nov 27 18:21:48 hobbyraum volumio[829]: verbose: New Socket.io Connection to 192.168.178.27:3000 from 192.168.178.72 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Nov 27 18:21:48 hobbyraum volumio[829]: verbose: New Socket.io Connection to 192.168.178.27:3000 from 192.168.178.72 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Nov 27 18:21:48 hobbyraum volumio[829]: verbose: New Socket.io Connection to 192.168.178.27:3000 from 192.168.178.72 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Nov 27 18:21:49 hobbyraum volumio[829]: verbose: New Socket.io Connection to 192.168.178.27:3000 from 192.168.178.72 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 27 18:21:49 hobbyraum volumio[829]: verbose: New Socket.io Connection to 192.168.178.27:3000 from 192.168.178.72 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Nov 27 18:21:49 hobbyraum volumio[829]: info: CoreStateMachine::pushState Nov 27 18:21:49 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:21:49 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 18:21:49 hobbyraum volumio[829]: info: CoreCommandRouter::volumioPushState Nov 27 18:21:49 hobbyraum volumio[829]: info: CoreStateMachine::updateTrackBlock Nov 27 18:21:49 hobbyraum volumio[829]: info: CorePlayQueue::getTrackBlock Nov 27 18:21:49 hobbyraum volumio[829]: info: CoreCommandRouter::volumioRetrievevolume Nov 27 18:21:49 hobbyraum volumio-remote-updater[522]: [2024-11-27 18:21:49] [connect] Successful connection Nov 27 18:21:49 hobbyraum volumio[829]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Nov 27 18:21:50 hobbyraum volumio[829]: info: Reloading queue from file Nov 27 18:21:50 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:21:50 hobbyraum volumio[829]: Starting albumart workers Nov 27 18:21:50 hobbyraum volumio[829]: verbose: New Socket.io Connection to 192.168.178.27:3000 from 192.168.178.72 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Nov 27 18:21:50 hobbyraum volumio-remote-updater[522]: [2024-11-27 18:21:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732731709 101 Nov 27 18:21:50 hobbyraum volumio[829]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 9 Nov 27 18:21:50 hobbyraum volumio[829]: info: CoreStateMachine::setRepeat true single undefined Nov 27 18:21:50 hobbyraum volumio[829]: info: CoreStateMachine::pushState Nov 27 18:21:50 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:21:51 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 18:21:51 hobbyraum volumio[829]: info: CoreCommandRouter::volumioPushState Nov 27 18:21:51 hobbyraum volumio[829]: info: CoreStateMachine::setRandom undefined Nov 27 18:21:51 hobbyraum volumio[829]: info: CoreStateMachine::pushState Nov 27 18:21:51 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:21:51 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 18:21:51 hobbyraum volumio[829]: info: CoreCommandRouter::volumioPushState Nov 27 18:21:51 hobbyraum volumio[829]: info: Setting Device type: Raspberry PI Nov 27 18:21:51 hobbyraum volumio[829]: info: Completed loading Core Plugins Nov 27 18:21:51 hobbyraum volumio[829]: info: Preparing to generate the ALSA configuration file Nov 27 18:21:51 hobbyraum volumio[829]: info: CoreStateMachine::pushState Nov 27 18:21:51 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:21:51 hobbyraum volumio[829]: info: CoreCommandRouter::volumioPushState Nov 27 18:21:51 hobbyraum volumio[829]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 27 18:21:51 hobbyraum volumio[829]: info: Reading ALSA contributions from plugins. Nov 27 18:21:52 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Nov 27 18:21:52 hobbyraum volumio[829]: info: Discovery: adding 60df01ac-863f-4f9e-ab8d-a83d8693079a Nov 27 18:21:52 hobbyraum volumio[829]: info: Discovery: Found device Hobbyraum Nov 27 18:21:52 hobbyraum volumio[829]: info: CoreCommandRouter::volumioGetState Nov 27 18:21:52 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:21:52 hobbyraum sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 27 18:21:52 hobbyraum sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:21:52 hobbyraum systemd[1]: Started UPnP Renderer front-end to MPD. Nov 27 18:21:52 hobbyraum sudo[1262]: pam_unix(sudo:session): session closed for user root Nov 27 18:21:53 hobbyraum volumio[829]: info: Discovery: adding 03a7b5e7-93f3-4385-963f-9fd0fd72de37 Nov 27 18:21:53 hobbyraum volumio[829]: info: Discovery: Found device Patrick Nov 27 18:21:53 hobbyraum volumio[829]: info: Discovery: Connecting to remote: 192.168.178.72 Nov 27 18:21:53 hobbyraum volumio[829]: info: CoreCommandRouter::volumioGetState Nov 27 18:21:53 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:21:53 hobbyraum volumio[829]: info: Upmpdcli Daemon Started Nov 27 18:21:54 hobbyraum volumio[829]: info: Discovery: Connected to remote: 192.168.178.72 Nov 27 18:21:54 hobbyraum volumio[829]: info: Asound.conf file unchanged, so no further update is needed Nov 27 18:21:54 hobbyraum volumio[829]: info: Output device has changed, restarting MPD Nov 27 18:21:55 hobbyraum volumio[829]: info: Output device has changed, restarting Shairport Sync Nov 27 18:21:55 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:21:55 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:21:55 hobbyraum sudo[1267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 27 18:21:55 hobbyraum sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:21:55 hobbyraum sudo[1267]: pam_unix(sudo:session): session closed for user root Nov 27 18:21:55 hobbyraum sudo[1269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 27 18:21:55 hobbyraum sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:21:55 hobbyraum systemd[1]: Stopping Music Player Daemon... Nov 27 18:21:56 hobbyraum volumio[829]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 27 18:21:56 hobbyraum volumio[829]: info: ___________ START PLUGINS ___________ Nov 27 18:21:56 hobbyraum volumio[829]: info: ControllerMpd::onStart: Initializing MPD Nov 27 18:21:56 hobbyraum volumio[829]: info: Creating MPD Configuration file Nov 27 18:21:56 hobbyraum systemd[1]: mpd.service: Succeeded. Nov 27 18:21:56 hobbyraum systemd[1]: Stopped Music Player Daemon. Nov 27 18:21:56 hobbyraum systemd[1]: Starting Music Player Daemon... Nov 27 18:21:57 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 18:21:57 hobbyraum sudo[1275]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 27 18:21:57 hobbyraum sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:21:57 hobbyraum volumio[829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:21:57 hobbyraum volumio[829]: info: [1732731717367] CoreMusicLibrary::Adding element Medienserver Nov 27 18:21:57 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:21:57 hobbyraum sudo[1275]: pam_unix(sudo:session): session closed for user root Nov 27 18:21:57 hobbyraum sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 27 18:21:57 hobbyraum sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:21:57 hobbyraum sudo[1277]: pam_unix(sudo:session): session closed for user root Nov 27 18:21:57 hobbyraum sudo[1283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 27 18:21:57 hobbyraum sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:21:58 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:21:58 hobbyraum systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 27 18:21:58 hobbyraum systemd[1]: mpd.service: Succeeded. Nov 27 18:21:58 hobbyraum systemd[1]: Stopped Music Player Daemon. Nov 27 18:21:58 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:21:58 hobbyraum systemd[1]: Starting Music Player Daemon... Nov 27 18:21:58 hobbyraum sudo[1292]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 27 18:21:58 hobbyraum sudo[1292]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:21:58 hobbyraum sudo[1292]: pam_unix(sudo:session): session closed for user root Nov 27 18:21:59 hobbyraum volumio[829]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 27 18:21:59 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:21:59 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:21:59 hobbyraum volumio[829]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 27 18:21:59 hobbyraum volumio[829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:21:59 hobbyraum volumio[829]: info: [1732731719385] CoreMusicLibrary::Adding element Last_100 Nov 27 18:21:59 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:21:59 hobbyraum volumio[829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:21:59 hobbyraum volumio[829]: info: [1732731719407] CoreMusicLibrary::Adding element Webradio Nov 27 18:21:59 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:21:59 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 27 18:21:59 hobbyraum volumio[829]: info: Initializing BBC Radios Nov 27 18:21:59 hobbyraum volumio[829]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Nov 27 18:21:59 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:22:00 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 27 18:22:00 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:22:00 hobbyraum volumio[829]: info: Creating Spotify config file Nov 27 18:22:00 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:22:01 hobbyraum volumio[829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:22:01 hobbyraum volumio[829]: info: [1732731721340] CoreMusicLibrary::Adding element YouTube2 Nov 27 18:22:01 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:22:01 hobbyraum volumio[829]: Cannot find translation for source YouTube2 Nov 27 18:22:01 hobbyraum volumio[829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:22:01 hobbyraum volumio[829]: info: [1732731721505] CoreMusicLibrary::Adding element YouTube Music Nov 27 18:22:01 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:22:01 hobbyraum volumio[829]: Cannot find translation for source YouTube2 Nov 27 18:22:01 hobbyraum volumio[829]: Cannot find translation for source YouTube Music Nov 27 18:22:01 hobbyraum volumio[829]: info: GPIO-Buttons: Reading config and creating triggers... Nov 27 18:22:01 hobbyraum volumio[829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:22:01 hobbyraum volumio[829]: info: [1732731721593] CoreMusicLibrary::Adding element 80s80s Radio Nov 27 18:22:01 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:22:01 hobbyraum volumio[829]: Cannot find translation for source YouTube2 Nov 27 18:22:01 hobbyraum volumio[829]: Cannot find translation for source YouTube Music Nov 27 18:22:01 hobbyraum volumio[829]: Cannot find translation for source 80s80s Radio Nov 27 18:22:01 hobbyraum volumio[829]: info: Volumio Calling Home Nov 27 18:22:02 hobbyraum systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 27 18:22:02 hobbyraum systemd[1]: mpd.service: Failed with result 'protocol'. Nov 27 18:22:02 hobbyraum systemd[1]: Failed to start Music Player Daemon. Nov 27 18:22:02 hobbyraum volumio[829]: info: GPIO-Buttons started Nov 27 18:22:02 hobbyraum sudo[1283]: pam_unix(sudo:session): session closed for user root Nov 27 18:22:02 hobbyraum sudo[1269]: pam_unix(sudo:session): session closed for user root Nov 27 18:22:02 hobbyraum systemd[1]: Starting Music Player Daemon... Nov 27 18:22:03 hobbyraum sudo[1332]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 27 18:22:03 hobbyraum sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:22:03 hobbyraum sudo[1332]: pam_unix(sudo:session): session closed for user root Nov 27 18:22:03 hobbyraum volumio[829]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 27 18:22:03 hobbyraum volumio[829]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Nov 27 18:22:03 hobbyraum volumio[829]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 27 18:22:03 hobbyraum volumio[829]: info: MPD Permissions set Nov 27 18:22:03 hobbyraum volumio[829]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Nov 27 18:22:03 hobbyraum volumio[829]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Nov 27 18:22:03 hobbyraum volumio[829]: See "systemctl status mpd.service" and "journalctl -xe" for details. Nov 27 18:22:03 hobbyraum volumio[829]: info: MPD Permissions set Nov 27 18:22:04 hobbyraum volumio[829]: info: Volumio called home Nov 27 18:22:04 hobbyraum volumio[829]: info: Spotify config file written Nov 27 18:22:04 hobbyraum sudo[1336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Nov 27 18:22:04 hobbyraum sudo[1336]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:22:04 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 27 18:22:04 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 27 18:22:04 hobbyraum volumio[829]: info: Discovery: Getting this device information Nov 27 18:22:04 hobbyraum volumio[829]: info: CoreCommandRouter::volumioGetState Nov 27 18:22:04 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:22:04 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 27 18:22:04 hobbyraum systemd[1]: Started go-librespot Daemon. Nov 27 18:22:04 hobbyraum go-librespot[1338]: Librespot-go daemon starting... Nov 27 18:22:04 hobbyraum sudo[1336]: pam_unix(sudo:session): session closed for user root Nov 27 18:22:05 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:05Z" level=info msg="generated new device id: a629fc55b33e12daceae9984f9b98c6e8d7aab87" Nov 27 18:22:05 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:05Z" level=debug msg="stored credentials found for 5ka1idsxg34hpl7qi69kbkxmr" Nov 27 18:22:08 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:08Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Nov 27 18:22:08 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:08Z" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Nov 27 18:22:08 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:08Z" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Nov 27 18:22:08 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:08Z" level=debug msg="zeroconf server listening on port 45753" Nov 27 18:22:08 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:08Z" level=debug msg="obtained new client token: AAA+fVYhiouXf+nEL0o1Ag/LMJOkgpzGWnargOsCmmZWYG25+H9lIpW5oZqlw1IroPGsqLBbLy1Of2g4kZ++O3qAepMSfK4mQ3oi0l7NO8cD/ba3elpgvJzsM9bMTbE/r/JkE5gE46gSXC1V0v7DRjbwIunW9cE9VgN3MQpDB/EHW/Y7R3BdNaI0RmKnZs4iA2oomIET5y3/+n/+Pigc8oTnmqMhzT+Q/jb9lZsH2KLOvfo1MRzo+j1JFQSsojI=" Nov 27 18:22:09 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:09Z" level=info msg="connected to ap-gew4.spotify.com:4070" Nov 27 18:22:09 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:09Z" level=debug msg="completed keyexchange" Nov 27 18:22:09 hobbyraum volumio[829]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Nov 27 18:22:09 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:09Z" level=debug msg="completed challenge" Nov 27 18:22:09 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:09Z" level=debug msg="authenticated as 5ka1idsxg34hpl7qi69kbkxmr" Nov 27 18:22:09 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:22:09 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="authenticated as 5ka1idsxg34hpl7qi69kbkxmr" Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="dealer connection opened" Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="initializing zeroconf session, username: 5ka1idsxg34hpl7qi69kbkxmr" Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="received connection id: MWQyOGNiNWQtMzU2OS00YWM4LWJhODItMWY2NTBiZWZhN2Y3K2RlYWxlcit0Y3A6Ly8wYWNhNTk3ZS5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArQkE0NkJBREU1OUIyNzZFQTA3NDFDRDg2QjRCMTBGQUYxQ0FCMTU3ODZCNDQxRDIzRkJEQTlFRjc1NUVGMzlBQw==" Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Nov 27 18:22:10 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:22:10 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:22:10 hobbyraum volumio[829]: info: No need to fix Spotify hosts Nov 27 18:22:10 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:22:10 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="put connect state because NEW_DEVICE" Nov 27 18:22:10 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Nov 27 18:22:10 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:10Z" level=debug msg="autoplay enabled: false" Nov 27 18:22:11 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:22:11 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:22:12 hobbyraum volumio[829]: verbose: New Socket.io Connection to 192.168.178.27:3000 from 192.168.178.71 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Nov 27 18:22:12 hobbyraum volumio[829]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 27 18:22:12 hobbyraum volumio[829]: SPOTIFY: BQAEKPO0nNYqj_kD4IlHlqzyr1-_udREnaOr8zOAUl6mE6jBHiyIy0B3-9dl343tfAQtCgb8SRF0RJSWnhbUxoP6TZ2iLMGzm1owoO7ogdx8nP_TMMviTakAbXifHsRyA2DQ1KOdLk3W8FeIwuQguDa8Zja2QuX30p5hqFVheJc1FIChp_AcdSzuFe-3aFCl7uwWRfVwdCSkP_koWdhFgz2whJO2pPKTUwcOqzFA6oWNYe68Gx5KS2qGSqB6Z5SI6xdviT7HRPoORe0 Nov 27 18:22:12 hobbyraum volumio[829]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Nov 27 18:22:12 hobbyraum volumio[829]: info: New Spotify access token = BQAEKPO0nNYqj_kD4IlHlqzyr1-_udREnaOr8zOAUl6mE6jBHiyIy0B3-9dl343tfAQtCgb8SRF0RJSWnhbUxoP6TZ2iLMGzm1owoO7ogdx8nP_TMMviTakAbXifHsRyA2DQ1KOdLk3W8FeIwuQguDa8Zja2QuX30p5hqFVheJc1FIChp_AcdSzuFe-3aFCl7uwWRfVwdCSkP_koWdhFgz2whJO2pPKTUwcOqzFA6oWNYe68Gx5KS2qGSqB6Z5SI6xdviT7HRPoORe0 Nov 27 18:22:12 hobbyraum volumio[829]: info: Spotify credentials grant success - running version from March 24, 2019 Nov 27 18:22:12 hobbyraum volumio[829]: info: Starting Shairport Sync Nov 27 18:22:12 hobbyraum volumio[829]: info: Starting Shairport Sync Nov 27 18:22:13 hobbyraum volumio[829]: info: Starting Shairport Sync Nov 27 18:22:13 hobbyraum sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 27 18:22:13 hobbyraum sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:22:13 hobbyraum systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 27 18:22:13 hobbyraum systemd[1]: shairport-sync.service: Succeeded. Nov 27 18:22:13 hobbyraum volumio[829]: info: CoreCommandRouter::volumioGetState Nov 27 18:22:13 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:22:13 hobbyraum systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 27 18:22:13 hobbyraum sudo[1370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 27 18:22:13 hobbyraum sudo[1370]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:22:13 hobbyraum systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 27 18:22:13 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 27 18:22:13 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 27 18:22:13 hobbyraum sudo[1368]: pam_unix(sudo:session): session closed for user root Nov 27 18:22:14 hobbyraum sudo[1373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 27 18:22:14 hobbyraum volumio[829]: info: CoreCommandRouter::volumioGetState Nov 27 18:22:14 hobbyraum sudo[1373]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:22:14 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:22:14 hobbyraum systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 27 18:22:14 hobbyraum systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 27 18:22:14 hobbyraum systemd[1]: shairport-sync.service: Succeeded. Nov 27 18:22:14 hobbyraum systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 27 18:22:14 hobbyraum systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 27 18:22:14 hobbyraum sudo[1370]: pam_unix(sudo:session): session closed for user root Nov 27 18:22:14 hobbyraum systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 27 18:22:14 hobbyraum volumio[829]: info: Shairport-Sync Started Nov 27 18:22:14 hobbyraum systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 27 18:22:14 hobbyraum volumio[829]: Error adding Membership: Error: addMembership EINVAL Nov 27 18:22:14 hobbyraum systemd[1]: shairport-sync.service: Succeeded. Nov 27 18:22:14 hobbyraum systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 27 18:22:14 hobbyraum systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 27 18:22:14 hobbyraum sudo[1373]: pam_unix(sudo:session): session closed for user root Nov 27 18:22:14 hobbyraum volumio[829]: info: Shairport-Sync Started Nov 27 18:22:14 hobbyraum volumio[829]: info: Shairport-Sync Started Nov 27 18:22:15 hobbyraum volumio[829]: SPOTIFY: User informations: {"country":"DE","display_name":"Roland","email":"roland.joerger@gmx.de","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/5ka1idsxg34hpl7qi69kbkxmr"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/5ka1idsxg34hpl7qi69kbkxmr","id":"5ka1idsxg34hpl7qi69kbkxmr","images":[],"product":"premium","type":"user","uri":"spotify:user:5ka1idsxg34hpl7qi69kbkxmr"} Nov 27 18:22:15 hobbyraum volumio[829]: info: Spotify Successfully logged in Nov 27 18:22:15 hobbyraum volumio[829]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:22:15 hobbyraum volumio[829]: info: [1732731735186] CoreMusicLibrary::Adding element Spotify Nov 27 18:22:15 hobbyraum volumio[829]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:22:15 hobbyraum volumio[829]: Cannot find translation for source YouTube2 Nov 27 18:22:15 hobbyraum volumio[829]: Cannot find translation for source YouTube Music Nov 27 18:22:15 hobbyraum volumio[829]: Cannot find translation for source 80s80s Radio Nov 27 18:22:15 hobbyraum volumio[829]: Cannot find translation for source Spotify Nov 27 18:22:15 hobbyraum volumio[829]: info: go-librespot daemon successfully initialized Nov 27 18:22:17 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:17Z" level=debug msg="handling transfer player command from 4e42dfdce4fda0e4fe0a5047666f47b02923a4de" Nov 27 18:22:17 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:17Z" level=debug msg="resolved context of track" uri="spotify:album:3bFD9qnUn8BVy9PVWXSbvl" Nov 27 18:22:17 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:17Z" level=trace msg="fetched new page 0 with 10 items (list: 10)" uri="spotify:album:3bFD9qnUn8BVy9PVWXSbvl" Nov 27 18:22:17 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:17Z" level=debug msg="loading track (paused: true, position: 52518ms)" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:17 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:17Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 27 18:22:17 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:17Z" level=trace msg="emitting websocket event: will_play" Nov 27 18:22:17 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:17Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Nov 27 18:22:17 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:17Z" level=debug msg="selected format OGG_VORBIS_320 (7db63ac5be8d7126f81062c9e0c3064833fac92c)" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:17 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:17Z" level=debug msg="requested aes key for file 7db63ac5be8d7126f81062c9e0c3064833fac92c, gid: 33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:17 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:17Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1364" Nov 27 18:22:18 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:18Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1127" Nov 27 18:22:18 hobbyraum volumio[829]: info: Initializing connection to go-librespot Websocket Nov 27 18:22:18 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:18Z" level=debug msg="new websocket client" Nov 27 18:22:18 hobbyraum volumio[829]: info: Connection to go-librespot Websocket established Nov 27 18:22:18 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:18Z" level=debug msg="fetched first chunk of 16, total size is 8023176 bytes" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:21 hobbyraum mpd[1334]: Nov 27 18:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 27 18:22:21 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:21Z" level=debug msg="fetched chunk 3/15, size: 524288" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:22 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:22Z" level=debug msg="fetched chunk 7/15, size: 524288" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:22 hobbyraum volumio[829]: info: Getting Spotify volume Nov 27 18:22:22 hobbyraum volumio[829]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Nov 27 18:22:22 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:22Z" level=debug msg="fetched chunk 1/15, size: 524288" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:22 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:22Z" level=debug msg="fetched chunk 5/15, size: 524288" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:22 hobbyraum systemd[1]: Started Music Player Daemon. Nov 27 18:22:23 hobbyraum mpd_monitor.sh[367]: MPD restarted due to no mpc output. Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=debug msg="fetched chunk 4/15, size: 524288" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=debug msg="fetched chunk 2/15, size: 524288" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=trace msg="seek to 52518ms (diff: 158ms, samples: 2316043, bytes: 2305680)" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=debug msg="fetched chunk 6/15, size: 524288" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 5102 us, period size = 225 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 98 frames" Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=debug msg="created new output device" Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=info msg="loaded track \"Liebe ist nur ein Wort\" (paused: true, position: 52518ms, duration: 186426ms, prefetched: false)" uri="spotify:track:33ektKPHVbTNSYN9WNWta0" Nov 27 18:22:23 hobbyraum volumio[829]: error: MPD error: The expression evaluated to a falsy value: Nov 27 18:22:23 hobbyraum volumio[829]: assert.ok(self.idling) Nov 27 18:22:23 hobbyraum volumio[829]: error: The expression evaluated to a falsy value: Nov 27 18:22:23 hobbyraum volumio[829]: assert.ok(self.idling) Nov 27 18:22:23 hobbyraum volumio[829]: Upnp client error: Error: This socket has been ended by the other party Nov 27 18:22:23 hobbyraum volumio[829]: error: updateQueue error: null Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=trace msg="emitting websocket event: metadata" Nov 27 18:22:23 hobbyraum volumio[829]: info: CoreCommandRouter::volumioGetState Nov 27 18:22:23 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=trace msg="emitting websocket event: active" Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=debug msg="sending successful reply for dealer request" Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Nov 27 18:22:23 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:23Z" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Nov 27 18:22:24 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:24Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Nov 27 18:22:24 hobbyraum go-librespot[1338]: time="2024-11-27T18:22:24Z" level=trace msg="emitting websocket event: paused" Nov 27 18:22:24 hobbyraum volumio[829]: [yt-cast-receiver] Listening on port 8098 Nov 27 18:22:24 hobbyraum volumio[829]: info: Completed starting Core Plugins Nov 27 18:22:24 hobbyraum volumio[829]: info: ------------------------------------------- Nov 27 18:22:24 hobbyraum volumio[829]: info: ----- MyVolumio plugins startup ---- Nov 27 18:22:24 hobbyraum volumio[829]: info: ------------------------------------------- Nov 27 18:22:24 hobbyraum volumio[829]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 27 18:22:24 hobbyraum volumio[829]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:33ektKPHVbTNSYN9WNWta0","name":"Liebe ist nur ein Wort","artist_names":["Element Of Crime"],"album_name":"Morgens um vier","album_cover_url":"https://i.scdn.co/image/ab67616d00001e028b2b2e45a6d22b80be924f24","position":52518,"duration":186426,"release_date":"year:2023 month:4 day:6","track_number":6,"disc_number":1}} Nov 27 18:22:24 hobbyraum volumio[829]: SPOTIFY: received: {"type":"active","data":null} Nov 27 18:22:24 hobbyraum volumio[829]: info: Aligning Spotify Volume to Volumio Volume Nov 27 18:22:24 hobbyraum volumio[829]: info: CoreCommandRouter::volumioGetState Nov 27 18:22:24 hobbyraum volumio[829]: info: CorePlayQueue::getTrack 0 Nov 27 18:22:24 hobbyraum volumio[829]: info: Setting Spotify Volume from Volumio: 21 Nov 27 18:22:24 hobbyraum volumio[829]: SPOTIFY: received: {"type":"paused","data":{"uri":"spotify:track:33ektKPHVbTNSYN9WNWta0","play_origin":"playlist"}} Nov 27 18:22:24 hobbyraum volumio[829]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 18:22:24 hobbyraum volumio[829]: TypeError: Cannot read property 'service' of undefined Nov 27 18:22:24 hobbyraum volumio[829]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:337:50) Nov 27 18:22:24 hobbyraum volumio[829]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:271:18) Nov 27 18:22:24 hobbyraum volumio[829]: at WebSocket.message (/data/plugins/music_service/spop/index.js:190:14) Nov 27 18:22:24 hobbyraum volumio[829]: at WebSocket.emit (events.js:315:20) Nov 27 18:22:24 hobbyraum volumio[829]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Nov 27 18:22:24 hobbyraum volumio[829]: at Receiver.emit (events.js:315:20) Nov 27 18:22:24 hobbyraum volumio[829]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Nov 27 18:22:24 hobbyraum volumio[829]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Nov 27 18:22:24 hobbyraum volumio[829]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Nov 27 18:22:24 hobbyraum volumio[829]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Nov 27 18:22:24 hobbyraum volumio[829]: at writeOrBuffer (internal/streams/writable.js:358:12) Nov 27 18:22:24 hobbyraum volumio[829]: at Receiver.Writable.write (internal/streams/writable.js:303:10) Nov 27 18:22:24 hobbyraum volumio[829]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35) Nov 27 18:22:24 hobbyraum volumio[829]: at Socket.emit (events.js:315:20) Nov 27 18:22:24 hobbyraum volumio[829]: at addChunk (internal/streams/readable.js:309:12) Nov 27 18:22:24 hobbyraum volumio[829]: at readableAddChunk (internal/streams/readable.js:284:9) Nov 27 18:22:24 hobbyraum volumio[829]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 18:22:26 hobbyraum sudo[1408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-27 18:21 Nov 27 18:22:26 hobbyraum sudo[1408]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"