-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2024-11-27 23:10:32 CET. -- Nov 27 23:10:11 muzak systemd-timedated[1096]: Changed local time to Wed Nov 27 23:10:11 2024 Nov 27 23:10:11 muzak sudo[1094]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:11 muzak volumio-time-update[628]: volumio-time-update-util: System time updated successfully. Nov 27 23:10:11 muzak systemd[1]: Starting Daily apt download activities... Nov 27 23:10:11 muzak systemd[1]: Started Volumio Time Update Utility. Nov 27 23:10:11 muzak systemd[1]: Reached target Multi-User System. Nov 27 23:10:11 muzak systemd[1]: Reached target Graphical Interface. Nov 27 23:10:11 muzak systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 27 23:10:11 muzak systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 27 23:10:11 muzak systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 27 23:10:12 muzak systemd[1]: systemd-hostnamed.service: Succeeded. Nov 27 23:10:12 muzak volumio-remote-updater[658]: [2024-11-27 23:10:12] [connect] Successful connection Nov 27 23:10:12 muzak systemd[1]: apt-daily.service: Succeeded. Nov 27 23:10:12 muzak systemd[1]: Started Daily apt download activities. Nov 27 23:10:12 muzak systemd[1]: Starting Daily apt upgrade and clean activities... Nov 27 23:10:12 muzak volumio[1050]: info: MYVOLUMIO Environment detected Nov 27 23:10:13 muzak volumio[1050]: info: Plugin folders cleanup Nov 27 23:10:13 muzak volumio[1050]: info: Scanning into folder /volumio/app/plugins/ Nov 27 23:10:13 muzak volumio[1050]: info: Scanning category audio_interface Nov 27 23:10:13 muzak volumio[1050]: info: Scanning category miscellanea Nov 27 23:10:13 muzak volumio[1050]: info: Scanning category music_service Nov 27 23:10:13 muzak volumio[1050]: info: Scanning category plugins.json Nov 27 23:10:13 muzak volumio[1050]: info: Scanning category system_controller Nov 27 23:10:13 muzak volumio[1050]: info: Scanning category user_interface Nov 27 23:10:13 muzak volumio[1050]: info: Scanning into folder /data/plugins/ Nov 27 23:10:13 muzak volumio[1050]: info: Scanning category music_service Nov 27 23:10:13 muzak volumio[1050]: info: Scanning category user_interface Nov 27 23:10:13 muzak volumio[1050]: info: Plugin folders cleanup completed Nov 27 23:10:13 muzak volumio[1050]: info: ------------------------------------------- Nov 27 23:10:13 muzak volumio[1050]: info: ----- Core plugins startup ---- Nov 27 23:10:13 muzak volumio[1050]: info: ------------------------------------------- Nov 27 23:10:13 muzak volumio[1050]: info: Loading plugins from folder /volumio/app/plugins/ Nov 27 23:10:13 muzak volumio[1050]: info: Adding plugin upnp to MyMusic Plugins Nov 27 23:10:13 muzak volumio[1050]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 27 23:10:13 muzak volumio[1050]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 27 23:10:13 muzak volumio[1050]: info: Loading plugins from folder /data/plugins/ Nov 27 23:10:13 muzak volumio[1050]: info: Loading plugin "system"... Nov 27 23:10:13 muzak volumio[1050]: info: Loading plugin "appearance"... Nov 27 23:10:13 muzak systemd[1]: apt-daily-upgrade.service: Succeeded. Nov 27 23:10:13 muzak systemd[1]: Started Daily apt upgrade and clean activities. Nov 27 23:10:14 muzak systemd[1]: Startup finished in 14.271s (kernel) + 41.861s (userspace) = 56.133s. Nov 27 23:10:15 muzak volumio[1050]: info: Loading plugin "network"... Nov 27 23:10:15 muzak volumio[1050]: info: Refreshing Cached IP Addresses Nov 27 23:10:15 muzak sudo[1206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 27 23:10:15 muzak sudo[1206]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:15 muzak sudo[1206]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:15 muzak sudo[1208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 27 23:10:15 muzak sudo[1208]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:15 muzak sudo[1208]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:15 muzak volumio[1050]: info: Loading plugin "services"... Nov 27 23:10:15 muzak volumio[1050]: info: Loading plugin "alsa_controller"... Nov 27 23:10:15 muzak sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 27 23:10:15 muzak sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:15 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 27 23:10:15 muzak volumio[1050]: info: Loading plugin "wizard"... Nov 27 23:10:15 muzak volumio[1050]: info: Loading plugin "networkfs"... Nov 27 23:10:15 muzak volumio[1050]: info: Starting Udev Watcher for removable devices Nov 27 23:10:15 muzak volumio[1050]: info: Ignoring mount for partition: boot Nov 27 23:10:15 muzak volumio[1050]: info: Ignoring mount for partition: volumio Nov 27 23:10:15 muzak volumio[1050]: info: Ignoring mount for partition: volumio_data Nov 27 23:10:15 muzak volumio[1050]: info: Mounting Device MUZIK2 Nov 27 23:10:15 muzak sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/MUZIK2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 27 23:10:15 muzak sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:16 muzak kernel: FAT-fs (sdb1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Nov 27 23:10:16 muzak kernel: FAT-fs (sdb1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Nov 27 23:10:16 muzak sudo[1235]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:16 muzak volumio[1050]: info: Mounting Device MUZIK1 Nov 27 23:10:16 muzak sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/MUZIK1 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 27 23:10:16 muzak sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:16 muzak kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Nov 27 23:10:16 muzak sudo[1242]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:16 muzak kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Nov 27 23:10:16 muzak volumio[1050]: info: Mounting Device MUZIK3 Nov 27 23:10:16 muzak sudo[1251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/MUZIK3 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 27 23:10:16 muzak sudo[1251]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:16 muzak kernel: FAT-fs (sdc1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Nov 27 23:10:16 muzak kernel: FAT-fs (sdc1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Nov 27 23:10:16 muzak sudo[1251]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:16 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 27 23:10:16 muzak volumio[1050]: info: Loading plugin "volumio_command_line_client"... Nov 27 23:10:16 muzak volumio[1050]: info: Loading plugin "upnp"... Nov 27 23:10:16 muzak volumio[1050]: info: [1732745416532] Starting Upmpd Daemon Nov 27 23:10:16 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 27 23:10:16 muzak volumio[1050]: info: Loading plugin "my_music"... Nov 27 23:10:16 muzak volumio[1050]: info: Loading plugin "mpd"... Nov 27 23:10:17 muzak volumio[1050]: info: Loading plugin "upnp_browser"... Nov 27 23:10:17 muzak volumio[1050]: info: Loading plugin "alarm-clock"... Nov 27 23:10:18 muzak volumio[1050]: info: Loading plugin "airplay_emulation"... Nov 27 23:10:18 muzak volumio[1050]: info: Starting Shairport Sync Nov 27 23:10:18 muzak volumio[1050]: info: Loading plugin "last_100"... Nov 27 23:10:18 muzak volumio[1050]: info: Loading plugin "webradio"... Nov 27 23:10:18 muzak volumio[1050]: info: Loading plugin "i2s_dacs"... Nov 27 23:10:18 muzak volumio[1050]: info: Loading plugin "volumiodiscovery"... Nov 27 23:10:18 muzak volumio[1050]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 27 23:10:18 muzak volumio[1050]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 27 23:10:18 muzak volumio[1050]: *** WARNING *** For more information see Nov 27 23:10:18 muzak node[1050]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 27 23:10:18 muzak volumio[1050]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 27 23:10:18 muzak volumio[1050]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 27 23:10:18 muzak volumio[1050]: *** WARNING *** For more information see Nov 27 23:10:18 muzak node[1050]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 27 23:10:18 muzak node[1050]: *** WARNING *** For more information see Nov 27 23:10:18 muzak node[1050]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 27 23:10:18 muzak node[1050]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 27 23:10:18 muzak node[1050]: *** WARNING *** For more information see Nov 27 23:10:18 muzak volumio[1050]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 27 23:10:18 muzak volumio[1050]: info: Discovery: Started advertising with name: MuZaK Nov 27 23:10:18 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 27 23:10:18 muzak volumio[1050]: info: Loading plugin "bandcamp"... Nov 27 23:10:19 muzak sudo[1217]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:20 muzak volumio[1050]: info: Loading plugin "soundcloud"... Nov 27 23:10:20 muzak wpa_supplicant[914]: RRM: Ignoring radio measurement request: Not RRM network Nov 27 23:10:20 muzak volumio[1050]: info: Loading plugin "spop"... Nov 27 23:10:21 muzak volumio[1050]: info: Loading plugin "youtube2"... Nov 27 23:10:22 muzak wpa_supplicant[914]: RRM: Ignoring radio measurement request: Not RRM network Nov 27 23:10:23 muzak volumio[1050]: info: Loading plugin "ytcr"... Nov 27 23:10:24 muzak wpa_supplicant[914]: RRM: Ignoring radio measurement request: Not RRM network Nov 27 23:10:25 muzak dhcpcd[926]: wlan0: carrier lost Nov 27 23:10:25 muzak wpa_supplicant[914]: wlan0: Associated with b0:f2:08:7d:76:42 Nov 27 23:10:25 muzak wpa_supplicant[914]: wlan0: CTRL-EVENT-CONNECTED - Connection to b0:f2:08:7d:76:42 completed [id=0 id_str=] Nov 27 23:10:25 muzak wpa_supplicant[914]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Nov 27 23:10:25 muzak avahi-daemon[665]: Withdrawing address record for 192.168.178.33 on wlan0. Nov 27 23:10:25 muzak avahi-daemon[665]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.33. Nov 27 23:10:25 muzak avahi-daemon[665]: Interface wlan0.IPv4 no longer relevant for mDNS. Nov 27 23:10:25 muzak dhcpcd[926]: wlan0: deleting route to 192.168.178.0/24 Nov 27 23:10:25 muzak dhcpcd[926]: wlan0: deleting default route via 192.168.178.1 Nov 27 23:10:25 muzak dhcpcd[926]: wlan0: carrier acquired Nov 27 23:10:25 muzak dhcpcd[926]: wlan0: IAID 01:71:ec:48 Nov 27 23:10:26 muzak dhcpcd[926]: wlan0: soliciting a DHCP lease Nov 27 23:10:26 muzak dhcpcd[926]: wlan0: offered 192.168.178.33 from 192.168.178.1 Nov 27 23:10:26 muzak dhcpcd[926]: wlan0: probing address 192.168.178.33/24 Nov 27 23:10:26 muzak dhcpcd[926]: wlan0: soliciting an IPv6 router Nov 27 23:10:26 muzak volumio[1050]: info: Loading plugin "outputs"... Nov 27 23:10:26 muzak volumio[1050]: info: Loading plugin "albumart"... Nov 27 23:10:26 muzak volumio[1050]: info: Plugin example_plugin is not enabled Nov 27 23:10:26 muzak volumio[1050]: info: Loading plugin "inputs"... Nov 27 23:10:26 muzak volumio[1050]: info: Loading plugin "updater_comm"... Nov 27 23:10:26 muzak ntpd[801]: Deleting interface #3 wlan0, 192.168.178.33#123, interface stats: received=0, sent=0, dropped=0, active_time=19 secs Nov 27 23:10:26 muzak volumio[1050]: info: Plugin mpdemulation is not enabled Nov 27 23:10:26 muzak volumio[1050]: info: Loading plugin "rest_api"... Nov 27 23:10:26 muzak volumio[1050]: info: Loading plugin "websocket"... Nov 27 23:10:26 muzak volumio[1050]: info: Starting Socket.io Server version 2.3.0 Nov 27 23:10:26 muzak volumio[1050]: info: Loading plugin "lastfm"... Nov 27 23:10:26 muzak volumio[1050]: Forking 3 albumart workers Nov 27 23:10:27 muzak volumio-remote-updater[658]: [2024-11-27 23:10:27] [connect] Successful connection Nov 27 23:10:27 muzak volumio[1050]: info: Loading plugin "randomizer"... Nov 27 23:10:28 muzak volumio[1050]: Starting albumart workers Nov 27 23:10:28 muzak volumio[1050]: Starting albumart workers Nov 27 23:10:28 muzak volumio[1050]: Starting albumart workers Nov 27 23:10:28 muzak volumio[1050]: info: Applying required configuration parameters for plugin randomizer Nov 27 23:10:28 muzak volumio[1050]: info: Loading i18n strings for locale it Nov 27 23:10:28 muzak volumio[1050]: Updating browse sources language Nov 27 23:10:28 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::initPlayerControls Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: Express server listening on port 3000 Nov 27 23:10:29 muzak volumio[1050]: [Metrics] WebUI: 19s 701.24ms Nov 27 23:10:29 muzak volumio[1050]: info: CoreStateMachine::resetVolumioState Nov 27 23:10:29 muzak volumio[1050]: info: CoreStateMachine::getcurrentVolume Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::volumioRetrievevolume Nov 27 23:10:29 muzak volumio[1050]: info: CoreStateMachine::pushState Nov 27 23:10:29 muzak volumio[1050]: info: CorePlayQueue::getTrack 0 Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::volumioPushState Nov 27 23:10:29 muzak sudo[1360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 27 23:10:29 muzak sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:29 muzak sudo[1360]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:29 muzak sudo[1362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 27 23:10:29 muzak sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:29 muzak sudo[1362]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:29 muzak volumio[1050]: info: Volumio Network Manager: Network status updated: 2 Nov 27 23:10:29 muzak volumio-remote-updater[658]: [2024-11-27 23:10:29] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732745427 101 Nov 27 23:10:29 muzak volumio[1050]: 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: 1 Nov 27 23:10:29 muzak volumio[1050]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Nov 27 23:10:29 muzak volumio[1050]: info: Reloading queue from file Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 23:10:29 muzak volumio[1050]: info: Setting Device type: Raspberry PI Nov 27 23:10:29 muzak volumio[1050]: info: CoreStateMachine::setRepeat false single undefined Nov 27 23:10:29 muzak volumio[1050]: info: CoreStateMachine::pushState Nov 27 23:10:29 muzak volumio[1050]: info: CorePlayQueue::getTrack 0 Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::volumioPushState Nov 27 23:10:29 muzak volumio[1050]: info: CoreStateMachine::setRandom false Nov 27 23:10:29 muzak volumio[1050]: info: CoreStateMachine::pushState Nov 27 23:10:29 muzak volumio[1050]: info: CorePlayQueue::getTrack 0 Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 23:10:29 muzak volumio[1050]: info: CoreCommandRouter::volumioPushState Nov 27 23:10:29 muzak volumio[1050]: info: Completed loading Core Plugins Nov 27 23:10:29 muzak volumio[1050]: info: Preparing to generate the ALSA configuration file Nov 27 23:10:29 muzak volumio[1050]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Nov 27 23:10:29 muzak volumio[1050]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03114 Nov 27 23:10:29 muzak volumio[1050]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Nov 27 23:10:29 muzak volumio[1050]: info: Discovery: A device disappeared from network Nov 27 23:10:29 muzak volumio[1050]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Nov 27 23:10:29 muzak sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 27 23:10:29 muzak sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:29 muzak volumio[1050]: info: Asound.conf file unchanged, so no further update is needed Nov 27 23:10:29 muzak volumio[1050]: info: Output device has changed, restarting MPD Nov 27 23:10:30 muzak sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 27 23:10:30 muzak sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:30 muzak systemd[1]: Started UPnP Renderer front-end to MPD. Nov 27 23:10:30 muzak volumio[1050]: info: Output device has changed, restarting Shairport Sync Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 23:10:30 muzak sudo[1375]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:30 muzak sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 27 23:10:30 muzak sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:30 muzak sudo[1371]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:30 muzak systemd[1]: Stopping Music Player Daemon... Nov 27 23:10:30 muzak volumio[1050]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 27 23:10:30 muzak volumio[1050]: info: ___________ START PLUGINS ___________ Nov 27 23:10:30 muzak volumio[1050]: info: ControllerMpd::onStart: Initializing MPD Nov 27 23:10:30 muzak volumio[1050]: info: Creating MPD Configuration file Nov 27 23:10:30 muzak sudo[1384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 27 23:10:30 muzak sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 23:10:30 muzak sudo[1384]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:30 muzak volumio[1050]: info: [1732745430235] CoreMusicLibrary::Adding element Server multimediali Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 23:10:30 muzak sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 27 23:10:30 muzak sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 23:10:30 muzak volumio[1050]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 23:10:30 muzak systemd[1]: mpd.service: Succeeded. Nov 27 23:10:30 muzak systemd[1]: Stopped Music Player Daemon. Nov 27 23:10:30 muzak volumio[1050]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 23:10:30 muzak volumio[1050]: info: [1732745430432] CoreMusicLibrary::Adding element Last_100 Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 23:10:30 muzak volumio[1050]: info: [1732745430437] CoreMusicLibrary::Adding element Webradio Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 27 23:10:30 muzak systemd[1]: Starting Music Player Daemon... Nov 27 23:10:30 muzak volumio[1050]: info: Initializing BBC Radios Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 23:10:30 muzak volumio[1050]: info: [1732745430585] CoreMusicLibrary::Adding element Bandcamp Discover Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 23:10:30 muzak volumio[1050]: Cannot find translation for source Bandcamp Discover Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 23:10:30 muzak volumio[1050]: info: [1732745430604] CoreMusicLibrary::Adding element SoundCloud Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 23:10:30 muzak volumio[1050]: Cannot find translation for source Bandcamp Discover Nov 27 23:10:30 muzak volumio[1050]: Cannot find translation for source SoundCloud Nov 27 23:10:30 muzak sudo[1393]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 27 23:10:30 muzak sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:30 muzak volumio[1050]: info: Checking for old spotify connect plugin installed Nov 27 23:10:30 muzak sudo[1393]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 23:10:30 muzak volumio[1050]: info: [1732745430624] CoreMusicLibrary::Adding element YouTube2 Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 23:10:30 muzak volumio[1050]: Cannot find translation for source Bandcamp Discover Nov 27 23:10:30 muzak volumio[1050]: Cannot find translation for source SoundCloud Nov 27 23:10:30 muzak volumio[1050]: Cannot find translation for source YouTube2 Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 23:10:30 muzak volumio[1050]: info: [1732745430647] CoreMusicLibrary::Adding element LastFM Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 23:10:30 muzak volumio[1050]: Cannot find translation for source Bandcamp Discover Nov 27 23:10:30 muzak volumio[1050]: Cannot find translation for source SoundCloud Nov 27 23:10:30 muzak volumio[1050]: Cannot find translation for source YouTube2 Nov 27 23:10:30 muzak volumio[1050]: Cannot find translation for source LastFM Nov 27 23:10:30 muzak volumio[1050]: info: [LastFM] scrobbler initiated! Nov 27 23:10:30 muzak volumio[1050]: info: [LastFM] extended logging: false Nov 27 23:10:30 muzak volumio[1050]: info: [LastFM] try scrobble stream/radio plays: true Nov 27 23:10:30 muzak volumio[1050]: info: [LastFM] Left init routine Nov 27 23:10:30 muzak volumio[1050]: info: [LastFM] Socket already connected: true Nov 27 23:10:30 muzak volumio[1050]: info: Volumio Calling Home Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 27 23:10:30 muzak volumio[1050]: [SpotifyConnect] Creating VLS config file Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:30 muzak volumio[1050]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 23:10:30 muzak volumio[1050]: [SpotifyConnect] Starting metadata listener Nov 27 23:10:30 muzak sudo[1412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Nov 27 23:10:30 muzak sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 23:10:31 muzak systemd[1]: Started Volspotconnect2 Daemon. Nov 27 23:10:31 muzak sudo[1412]: pam_unix(sudo:session): session closed for user root Nov 27 23:10:31 muzak volumio[1050]: Unhandled rejection Error: No sockets available, cannot start. Nov 27 23:10:31 muzak volumio[1050]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Nov 27 23:10:31 muzak volumio[1050]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Nov 27 23:10:31 muzak volumio[1050]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Nov 27 23:10:31 muzak volumio[1050]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Nov 27 23:10:31 muzak volumio[1050]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Nov 27 23:10:31 muzak volumio[1050]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Nov 27 23:10:31 muzak volumio[1050]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Nov 27 23:10:31 muzak volumio[1050]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Nov 27 23:10:31 muzak volumio[1050]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Nov 27 23:10:31 muzak volumio[1050]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Nov 27 23:10:31 muzak volumio[1050]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Nov 27 23:10:31 muzak volumio[1050]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Nov 27 23:10:31 muzak volumio[1050]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Nov 27 23:10:31 muzak volumio[1050]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Nov 27 23:10:31 muzak volumio[1050]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Nov 27 23:10:31 muzak volumio[1050]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Nov 27 23:10:31 muzak volumio[1050]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 23:10:31 muzak volumio[1050]: Error: getaddrinfo EBUSY ws.audioscrobbler.com Nov 27 23:10:31 muzak volumio[1050]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) { Nov 27 23:10:31 muzak volumio[1050]: errno: -16, Nov 27 23:10:31 muzak volumio[1050]: code: 'EBUSY', Nov 27 23:10:31 muzak volumio[1050]: syscall: 'getaddrinfo', Nov 27 23:10:31 muzak volumio[1050]: hostname: 'ws.audioscrobbler.com' Nov 27 23:10:31 muzak volumio[1050]: } Nov 27 23:10:31 muzak volumio[1050]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 23:10:31 muzak volumio[1414]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Nov 27 23:10:31 muzak volumio[1414]: Reading Config from "/tmp/volspotify.toml" Nov 27 23:10:31 muzak volumio[1414]: Malformed config key: missing field `Authentication` Nov 27 23:10:31 muzak systemd[1]: volspotconnect.service: Main process exited, code=exited, status=1/FAILURE Nov 27 23:10:31 muzak systemd[1]: volspotconnect.service: Failed with result 'exit-code'. Nov 27 23:10:31 muzak dhcpcd[926]: wlan0: leased 192.168.178.33 for 864000 seconds Nov 27 23:10:31 muzak avahi-daemon[665]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.33. Nov 27 23:10:31 muzak avahi-daemon[665]: New relevant interface wlan0.IPv4 for mDNS. Nov 27 23:10:31 muzak dhcpcd[926]: wlan0: adding route to 192.168.178.0/24 Nov 27 23:10:31 muzak dhcpcd[926]: wlan0: adding default route via 192.168.178.1 Nov 27 23:10:31 muzak avahi-daemon[665]: Registering new address record for 192.168.178.33 on wlan0.IPv4. Nov 27 23:10:32 muzak sudo[1447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-27 23:09 Nov 27 23:10:32 muzak sudo[1447]: 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"