-- Logs begin at Sat 2024-03-30 21:13:46 SAST, end at Sat 2024-03-30 21:15:02 SAST. -- Mar 30 21:14:00 volumio wireless.js[875]: trying... Mar 30 21:14:00 volumio sudo[1144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 30 21:14:00 volumio sudo[1144]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:00 volumio sudo[1144]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:01 volumio wireless.js[875]: trying... Mar 30 21:14:01 volumio sudo[1153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 30 21:14:01 volumio sudo[1153]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:01 volumio sudo[1153]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:02 volumio wireless.js[875]: trying... Mar 30 21:14:02 volumio sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 30 21:14:02 volumio sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:02 volumio sudo[1162]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:03 volumio wpa_supplicant[1072]: wlan0: Associated with ba:db:09:ce:4e:5e Mar 30 21:14:03 volumio wpa_supplicant[1072]: wlan0: WPA: Key negotiation completed with ba:db:09:ce:4e:5e [PTK=CCMP GTK=CCMP] Mar 30 21:14:03 volumio wpa_supplicant[1072]: wlan0: CTRL-EVENT-CONNECTED - Connection to ba:db:09:ce:4e:5e completed [id=1 id_str=] Mar 30 21:14:03 volumio dhcpcd[1046]: wlan0: carrier acquired Mar 30 21:14:03 volumio wpa_supplicant[1072]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Mar 30 21:14:03 volumio dhcpcd[1046]: wlan0: soliciting an IPv6 router Mar 30 21:14:03 volumio wireless.js[875]: trying... Mar 30 21:14:03 volumio sudo[1184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 30 21:14:03 volumio sudo[1184]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:03 volumio sudo[1184]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:04 volumio volumio-remote-updater[522]: [2024-03-30 21:14:04] [info] asio async_connect error: system:111 (Connection refused) Mar 30 21:14:04 volumio volumio-remote-updater[522]: [2024-03-30 21:14:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 30 21:14:04 volumio volumio-remote-updater[522]: [2024-03-30 21:14:04] [error] handle_connect error: Underlying Transport Error Mar 30 21:14:04 volumio wireless.js[875]: trying... Mar 30 21:14:05 volumio sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 30 21:14:05 volumio sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:05 volumio sudo[1193]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:06 volumio wireless.js[875]: trying... Mar 30 21:14:06 volumio sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 30 21:14:06 volumio sudo[1202]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:06 volumio sudo[1202]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:07 volumio wireless.js[875]: trying... Mar 30 21:14:07 volumio sudo[1211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 30 21:14:07 volumio sudo[1211]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:07 volumio sudo[1211]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:08 volumio wireless.js[875]: trying... Mar 30 21:14:08 volumio sudo[1220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 30 21:14:08 volumio sudo[1220]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:08 volumio sudo[1220]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:08 volumio dhcpcd[1046]: wlan0: using IPv4LL address 169.254.37.243 Mar 30 21:14:08 volumio avahi-daemon[564]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.37.243. Mar 30 21:14:08 volumio avahi-daemon[564]: New relevant interface wlan0.IPv4 for mDNS. Mar 30 21:14:08 volumio avahi-daemon[564]: Registering new address record for 169.254.37.243 on wlan0.IPv4. Mar 30 21:14:08 volumio dhcpcd[1046]: wlan0: adding host route to 169.254.37.243 via 127.0.0.1 Mar 30 21:14:08 volumio dhcpcd[1046]: wlan0: adding route to 169.254.0.0/16 Mar 30 21:14:08 volumio dhcpcd[1046]: forked to background, child pid 1241 Mar 30 21:14:08 volumio sudo[1042]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:09 volumio wireless.js[875]: trying... Mar 30 21:14:09 volumio sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 30 21:14:09 volumio sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:09 volumio sudo[1246]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:09 volumio wireless.js[875]: Connected to: ----LovisaWireless Mar 30 21:14:09 volumio wireless.js[875]: ---- Mar 30 21:14:09 volumio sudo[1255]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 30 21:14:09 volumio sudo[1255]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:09 volumio sudo[1255]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:09 volumio wireless.js[875]: ... joined AP, wlan0 IPv4 is 169.254.37.243, ipV6 is undefined Mar 30 21:14:09 volumio wireless.js[875]: It's done! AP Mar 30 21:14:09 volumio systemd[1]: Started Wireless Services. Mar 30 21:14:09 volumio systemd[1]: Starting Volumio Backend Module... Mar 30 21:14:09 volumio systemd[1]: Started Volumio Backend Module. Mar 30 21:14:09 volumio systemd[1]: Starting Volumio Streaming Daemon... Mar 30 21:14:09 volumio systemd[1]: Started Volumio Streaming Daemon. Mar 30 21:14:09 volumio systemd[1]: Starting Multi-User System. Mar 30 21:14:09 volumio systemd[1]: Reached target Multi-User System. Mar 30 21:14:09 volumio systemd[1]: Starting Graphical Interface. Mar 30 21:14:09 volumio systemd[1]: Reached target Graphical Interface. Mar 30 21:14:09 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 30 21:14:09 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 30 21:14:09 volumio systemd[1]: Startup finished in 9.073s (kernel) + 24.080s (userspace) = 33.154s. Mar 30 21:14:09 volumio volumio-streaming-daemon[1265]: ############################ Mar 30 21:14:09 volumio volumio-streaming-daemon[1265]: # Volumio Streaming Daemon # Mar 30 21:14:09 volumio volumio-streaming-daemon[1265]: # Running on port 7777 # Mar 30 21:14:09 volumio volumio-streaming-daemon[1265]: ############################ Mar 30 21:14:10 volumio ntpd[1010]: Listen normally on 3 wlan0 169.254.37.243 UDP 123 Mar 30 21:14:10 volumio ntpd[1010]: peers refreshed Mar 30 21:14:11 volumio nmbd[1000]: [2024/03/30 21:14:11.425142, 0] ../lib/util/become_daemon.c:124(daemon_ready) Mar 30 21:14:11 volumio nmbd[1000]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 30 21:14:11 volumio volumio[1264]: info: ------------------------------------------- Mar 30 21:14:11 volumio volumio[1264]: info: ----- Volumio2 ---- Mar 30 21:14:11 volumio volumio[1264]: info: ------------------------------------------- Mar 30 21:14:11 volumio volumio[1264]: info: ----- System startup ---- Mar 30 21:14:11 volumio volumio[1264]: info: ------------------------------------------- Mar 30 21:14:11 volumio volumio[1264]: info: MYVOLUMIO Environment detected Mar 30 21:14:12 volumio volumio[1264]: info: Plugin folders cleanup Mar 30 21:14:12 volumio volumio[1264]: info: Scanning into folder /volumio/app/plugins/ Mar 30 21:14:12 volumio volumio[1264]: info: Scanning category audio_interface Mar 30 21:14:12 volumio volumio[1264]: info: Scanning category miscellanea Mar 30 21:14:12 volumio volumio[1264]: info: Scanning category music_service Mar 30 21:14:12 volumio volumio[1264]: info: Scanning category plugins.json Mar 30 21:14:12 volumio volumio[1264]: info: Scanning category system_controller Mar 30 21:14:12 volumio volumio[1264]: info: Scanning category user_interface Mar 30 21:14:12 volumio volumio[1264]: info: Scanning into folder /data/plugins/ Mar 30 21:14:12 volumio volumio[1264]: info: Scanning category miscellanea Mar 30 21:14:12 volumio volumio[1264]: info: Plugin folders cleanup completed Mar 30 21:14:12 volumio volumio[1264]: info: ------------------------------------------- Mar 30 21:14:12 volumio volumio[1264]: info: ----- Core plugins startup ---- Mar 30 21:14:12 volumio volumio[1264]: info: ------------------------------------------- Mar 30 21:14:12 volumio volumio[1264]: info: Loading plugins from folder /volumio/app/plugins/ Mar 30 21:14:12 volumio volumio[1264]: info: Adding plugin upnp to MyMusic Plugins Mar 30 21:14:12 volumio volumio[1264]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 30 21:14:12 volumio volumio[1264]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 30 21:14:12 volumio volumio[1264]: info: Loading plugins from folder /data/plugins/ Mar 30 21:14:12 volumio volumio[1264]: info: Loading plugin "system"... Mar 30 21:14:12 volumio volumio[1264]: info: Loading plugin "appearance"... Mar 30 21:14:12 volumio ntpd_intres[1026]: host name not found: 0.debian.pool.ntp.org Mar 30 21:14:12 volumio ntpd_intres[1026]: host name not found: 1.debian.pool.ntp.org Mar 30 21:14:12 volumio ntpd_intres[1026]: host name not found: 2.debian.pool.ntp.org Mar 30 21:14:12 volumio ntpd_intres[1026]: host name not found: 3.debian.pool.ntp.org Mar 30 21:14:13 volumio dhcpcd[1241]: wlan0: soliciting a DHCP lease Mar 30 21:14:13 volumio dhcpcd[1241]: wlan0: offered 172.16.99.220 from 172.16.99.1 Mar 30 21:14:13 volumio volumio[1264]: info: Loading plugin "network"... Mar 30 21:14:13 volumio volumio[1264]: info: Loading plugin "services"... Mar 30 21:14:13 volumio volumio[1264]: info: Loading plugin "alsa_controller"... Mar 30 21:14:14 volumio volumio[1264]: info: Loading plugin "wizard"... Mar 30 21:14:14 volumio volumio[1264]: info: Loading plugin "volumio_command_line_client"... Mar 30 21:14:14 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 21:14:14 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 21:14:14 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 21:14:14 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 21:14:14 volumio volumio[1264]: info: Loading plugin "upnp"... Mar 30 21:14:14 volumio volumio[1264]: info: [1711826054156] Starting Upmpd Daemon Mar 30 21:14:14 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 30 21:14:14 volumio volumio[1264]: info: Loading plugin "my_music"... Mar 30 21:14:14 volumio volumio[1264]: info: Loading plugin "mpd"... Mar 30 21:14:14 volumio volumio[1264]: info: Loading plugin "upnp_browser"... Mar 30 21:14:14 volumio volumio-remote-updater[522]: [2024-03-30 21:14:14] [connect] Successful connection Mar 30 21:14:15 volumio volumio[1264]: info: Loading plugin "networkfs"... Mar 30 21:14:16 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "alarm-clock"... Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "airplay_emulation"... Mar 30 21:14:16 volumio volumio[1264]: info: Starting Shairport Sync Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "last_100"... Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "webradio"... Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "i2s_dacs"... Mar 30 21:14:16 volumio volumio[1264]: info: I2S DAC not set, start Auto-detection Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "volumiodiscovery"... Mar 30 21:14:16 volumio volumio[1264]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 30 21:14:16 volumio node[1264]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 30 21:14:16 volumio node[1264]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 30 21:14:16 volumio node[1264]: *** WARNING *** For more information see Mar 30 21:14:16 volumio node[1264]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 30 21:14:16 volumio node[1264]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 30 21:14:16 volumio node[1264]: *** WARNING *** For more information see Mar 30 21:14:16 volumio volumio[1264]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 30 21:14:16 volumio volumio[1264]: *** WARNING *** For more information see Mar 30 21:14:16 volumio volumio[1264]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 30 21:14:16 volumio volumio[1264]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 30 21:14:16 volumio volumio[1264]: *** WARNING *** For more information see Mar 30 21:14:16 volumio volumio[1264]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 30 21:14:16 volumio volumio[1264]: Discovery: StartAdv! undefined Mar 30 21:14:16 volumio volumio[1264]: Discovery: Started advertising... Volumio - undefined Mar 30 21:14:16 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "auto_play"... Mar 30 21:14:16 volumio volumio[1264]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "outputs"... Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "albumart"... Mar 30 21:14:16 volumio volumio[1264]: info: Plugin example_plugin is not enabled Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "inputs"... Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "updater_comm"... Mar 30 21:14:16 volumio volumio[1264]: info: Plugin mpdemulation is not enabled Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "rest_api"... Mar 30 21:14:16 volumio volumio[1264]: info: Loading plugin "websocket"... Mar 30 21:14:17 volumio volumio[1264]: info: ___________ START PLUGINS ___________ Mar 30 21:14:17 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 30 21:14:17 volumio volumio[1264]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 30 21:14:17 volumio volumio[1264]: info: [1711826057026] CoreMusicLibrary::Adding element Media Servers Mar 30 21:14:17 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 30 21:14:17 volumio volumio[1264]: Forking 3 albumart workers Mar 30 21:14:17 volumio volumio[1264]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 30 21:14:17 volumio volumio[1264]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 30 21:14:17 volumio volumio[1264]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 30 21:14:17 volumio volumio[1264]: info: [1711826057132] CoreMusicLibrary::Adding element Last_100 Mar 30 21:14:17 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 30 21:14:17 volumio volumio[1264]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 30 21:14:17 volumio volumio[1264]: info: [1711826057136] CoreMusicLibrary::Adding element Webradio Mar 30 21:14:17 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 30 21:14:17 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 30 21:14:17 volumio volumio[1264]: info: ------------------------------------------- Mar 30 21:14:17 volumio volumio[1264]: info: ----- MyVolumio plugins startup ---- Mar 30 21:14:17 volumio volumio[1264]: info: ------------------------------------------- Mar 30 21:14:17 volumio volumio[1264]: info: Loading plugins from folder /myvolumio/plugins Mar 30 21:14:17 volumio volumio[1264]: info: Loading plugins from folder /data/myvolumio/plugins Mar 30 21:14:17 volumio volumio[1264]: info: Loading plugin "cd_controller"... Mar 30 21:14:17 volumio volumio[1264]: info: Loading plugin "streaming_services"... Mar 30 21:14:17 volumio volumio[1264]: info: Loading plugin "my_volumio"... Mar 30 21:14:18 volumio volumio[1264]: Starting albumart workers Mar 30 21:14:18 volumio dhcpcd[1241]: wlan0: leased 172.16.99.220 for 84294 seconds Mar 30 21:14:18 volumio volumio[1264]: Starting albumart workers Mar 30 21:14:18 volumio volumio[1264]: Starting albumart workers Mar 30 21:14:18 volumio avahi-daemon[564]: Registering new address record for 172.16.99.220 on wlan0.IPv4. Mar 30 21:14:18 volumio avahi-daemon[564]: Withdrawing address record for 169.254.37.243 on wlan0. Mar 30 21:14:18 volumio avahi-daemon[564]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.37.243. Mar 30 21:14:18 volumio avahi-daemon[564]: Joining mDNS multicast group on interface wlan0.IPv4 with address 172.16.99.220. Mar 30 21:14:18 volumio dhcpcd[1241]: wlan0: adding host route to 172.16.99.220 via 127.0.0.1 Mar 30 21:14:18 volumio dhcpcd[1241]: wlan0: adding route to 172.16.99.0/24 Mar 30 21:14:18 volumio dhcpcd[1241]: wlan0: adding default route via 172.16.99.1 Mar 30 21:14:18 volumio dhcpcd[1241]: wlan0: deleting host route to 169.254.37.243 via 127.0.0.1 Mar 30 21:14:18 volumio dhcpcd[1241]: wlan0: deleting route to 169.254.0.0/16 Mar 30 21:14:18 volumio systemd[1]: Stopping LSB: Start NTP daemon... Mar 30 21:14:18 volumio ntpd[1010]: ntpd exiting on signal 15 Mar 30 21:14:18 volumio ntp[1430]: Stopping NTP server: ntpd. Mar 30 21:14:18 volumio systemd[1]: Starting LSB: Start NTP daemon... Mar 30 21:14:18 volumio ntpd[1449]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) Mar 30 21:14:18 volumio ntpd[1450]: proto: precision = 0.625 usec Mar 30 21:14:18 volumio ntpd[1450]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Mar 30 21:14:18 volumio ntp[1440]: Starting NTP server: ntpd. Mar 30 21:14:18 volumio ntpd[1450]: Listen and drop on 1 v6wildcard :: UDP 123 Mar 30 21:14:18 volumio ntpd[1450]: Listen normally on 2 lo 127.0.0.1 UDP 123 Mar 30 21:14:18 volumio ntpd[1450]: Listen normally on 3 wlan0 172.16.99.220 UDP 123 Mar 30 21:14:18 volumio ntpd[1450]: peers refreshed Mar 30 21:14:18 volumio ntpd[1450]: Listening on routing socket on fd #20 for interface updates Mar 30 21:14:18 volumio systemd[1]: Started LSB: Start NTP daemon. Mar 30 21:14:18 volumio volumio[1264]: info: Adding CD REST API Endpoints Mar 30 21:14:18 volumio volumio[1264]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Mar 30 21:14:18 volumio volumio[1264]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Mar 30 21:14:18 volumio volumio[1264]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Mar 30 21:14:18 volumio volumio[1264]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Mar 30 21:14:18 volumio volumio[1264]: info: Detecting CD presence Mar 30 21:14:18 volumio volumio[1264]: info: Streaming services startup Mar 30 21:14:18 volumio volumio[1264]: info: Starting Streaming Daemon Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 30 21:14:18 volumio volumio[1264]: info: Starting MyVolumio Remote Streaming Endpoints Mar 30 21:14:18 volumio sudo[1453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 30 21:14:18 volumio sudo[1453]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:18 volumio systemd[1]: Stopping Volumio Streaming Daemon... Mar 30 21:14:18 volumio systemd[1]: Starting Volumio Streaming Daemon... Mar 30 21:14:18 volumio systemd[1]: Started Volumio Streaming Daemon. Mar 30 21:14:18 volumio sudo[1453]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:18 volumio volumio[1264]: info: Loading i18n strings for locale pl Mar 30 21:14:18 volumio volumio-streaming-daemon[1459]: ############################ Mar 30 21:14:18 volumio volumio-streaming-daemon[1459]: # Volumio Streaming Daemon # Mar 30 21:14:18 volumio volumio-streaming-daemon[1459]: # Running on port 7777 # Mar 30 21:14:18 volumio volumio-streaming-daemon[1459]: ############################ Mar 30 21:14:18 volumio volumio[1264]: Updating browse sources language Mar 30 21:14:18 volumio volumio[1264]: Cannot find translation for sourceMedia Servers Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::initPlayerControls Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 30 21:14:18 volumio volumio[1264]: info: BOOT COMPLETED Mar 30 21:14:18 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 30 21:14:19 volumio dhcpcd[474]: timed out Mar 30 21:14:19 volumio dhcpcd[474]: allowing 8 seconds for IPv4LL timeout Mar 30 21:14:19 volumio ifup[442]: dhcpcd[474]: timed out Mar 30 21:14:19 volumio ifup[442]: dhcpcd[474]: allowing 8 seconds for IPv4LL timeout Mar 30 21:14:23 volumio volumio[1264]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Mar 30 21:14:23 volumio volumio[1264]: info: CoreCommandRouter::Close All Modals sent Mar 30 21:14:23 volumio volumio[1264]: info: CoreCommandRouter::Close All Modals sent Mar 30 21:14:23 volumio volumio[1264]: Express server listening on port 3000 Mar 30 21:14:23 volumio volumio[1264]: Volumio Calling Home Mar 30 21:14:23 volumio volumio[1264]: info: MyVolumio not started Mar 30 21:14:23 volumio volumio[1264]: info: Initializing device activation check Mar 30 21:14:23 volumio volumio[1264]: info: CoreStateMachine::resetVolumioState Mar 30 21:14:23 volumio volumio[1264]: info: CoreStateMachine::getcurrentVolume Mar 30 21:14:23 volumio volumio[1264]: info: CoreCommandRouter::volumioRetrievevolume Mar 30 21:14:24 volumio volumio[1264]: info: Setting Device type: Raspberry PI Mar 30 21:14:24 volumio volumio[1264]: info: MPD running with PID573 ,establishing connection Mar 30 21:14:24 volumio sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Mar 30 21:14:24 volumio sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:24 volumio sudo[1488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 30 21:14:24 volumio sudo[1488]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:24 volumio sudo[1484]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:24 volumio sudo[1488]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:24 volumio volumio[1264]: info: VolumeController:: Volume=100 Mute =false Mar 30 21:14:24 volumio volumio[1264]: info: CoreStateMachine::pushState Mar 30 21:14:24 volumio volumio[1264]: info: CoreStateMachine::getState Mar 30 21:14:24 volumio volumio[1264]: info: CorePlayQueue::getTrack 0 Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::volumioPushState Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 21:14:24 volumio volumio[1264]: info: Mar 30 21:14:24 volumio volumio[1264]: ---------------------------- Client requests Volume 100 Mar 30 21:14:24 volumio volumio[1264]: info: VolumeController::SetAlsaVolume100 Mar 30 21:14:24 volumio volumio[1264]: info: CoreStateMachine::pushState Mar 30 21:14:24 volumio volumio[1264]: info: CoreStateMachine::getState Mar 30 21:14:24 volumio volumio[1264]: info: CorePlayQueue::getTrack 0 Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::volumioPushState Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 30 21:14:24 volumio volumio[1264]: info: Reloading queue from file Mar 30 21:14:24 volumio volumio[1264]: info: Mar 30 21:14:24 volumio volumio[1264]: info: message= [50@0] {} No such directory, stack=Error: [50@0] {} No such directory Mar 30 21:14:24 volumio volumio[1264]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Mar 30 21:14:24 volumio volumio[1264]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Mar 30 21:14:24 volumio volumio[1264]: at emitOne (events.js:116:13) Mar 30 21:14:24 volumio volumio[1264]: at Socket.emit (events.js:211:7) Mar 30 21:14:24 volumio volumio[1264]: at addChunk (_stream_readable.js:263:12) Mar 30 21:14:24 volumio volumio[1264]: at readableAddChunk (_stream_readable.js:246:13) Mar 30 21:14:24 volumio volumio[1264]: at Socket.Readable.push (_stream_readable.js:208:10) Mar 30 21:14:24 volumio volumio[1264]: at Pipe.onread (net.js:607:20) Mar 30 21:14:24 volumio volumio[1264]: info: Setting volume on startup at 100 Mar 30 21:14:24 volumio volumio[1264]: info: CoreStateMachine::setRepeat on single undefined Mar 30 21:14:24 volumio volumio[1264]: info: CoreStateMachine::pushState Mar 30 21:14:24 volumio volumio[1264]: info: CoreStateMachine::getState Mar 30 21:14:24 volumio volumio[1264]: info: CorePlayQueue::getTrack 0 Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::volumioPushState Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 21:14:24 volumio volumio[1264]: info: CoreStateMachine::setRandom on Mar 30 21:14:24 volumio volumio[1264]: info: CoreStateMachine::pushState Mar 30 21:14:24 volumio volumio[1264]: info: CoreStateMachine::getState Mar 30 21:14:24 volumio volumio[1264]: info: CorePlayQueue::getTrack 0 Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::volumioPushState Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 30 21:14:24 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 30 21:14:24 volumio sudo[1507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Mar 30 21:14:24 volumio sudo[1507]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:24 volumio sudo[1509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Mar 30 21:14:24 volumio sudo[1509]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:24 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Mar 30 21:14:24 volumio systemd[1]: Started ShairportSync AirTunes receiver. Mar 30 21:14:24 volumio sudo[1507]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:25 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Mar 30 21:14:25 volumio shairport-sync[1517]: Successful Startup Mar 30 21:14:25 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Mar 30 21:14:25 volumio systemd[1]: Started ShairportSync AirTunes receiver. Mar 30 21:14:25 volumio sudo[1523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 30 21:14:25 volumio sudo[1509]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:25 volumio sudo[1523]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:25 volumio shairport-sync[1526]: Successful Startup Mar 30 21:14:25 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Mar 30 21:14:25 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 30 21:14:25 volumio sudo[1523]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:25 volumio volumio[1264]: Discovery: adding 004d4c5c-ee31-43a1-bcb1-ca4d7ffc5cc7 Mar 30 21:14:25 volumio volumio[1264]: info: mDNS: Found device Volumio Mar 30 21:14:25 volumio sudo[1541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 30 21:14:25 volumio sudo[1541]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:25 volumio sudo[1541]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:25 volumio volumio[1264]: info: Upmpdcli Daemon Started Mar 30 21:14:25 volumio volumio[1264]: info: Shairport-Sync Started Mar 30 21:14:25 volumio volumio[1264]: Error adding Membership: Error: addMembership EINVAL Mar 30 21:14:25 volumio volumio[1264]: info: Shairport-Sync Started Mar 30 21:14:25 volumio volumio[1264]: info: ControllerAutoPlay - mpd ready Mar 30 21:14:25 volumio volumio[1264]: info: CoreCommandRouter::volumioGetState Mar 30 21:14:25 volumio volumio[1264]: info: CoreStateMachine::getState Mar 30 21:14:25 volumio volumio[1264]: info: CorePlayQueue::getTrack 0 Mar 30 21:14:25 volumio sudo[1550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 30 21:14:25 volumio sudo[1550]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 30 21:14:25 volumio sudo[1550]: pam_unix(sudo:session): session closed for user root Mar 30 21:14:58 volumio systemd[1091]: Time has been changed Mar 30 21:14:58 volumio systemd[1]: Time has been changed Mar 30 21:14:59 volumio volumio[1264]: info: Fetching Streaming Services browse cache Mar 30 21:14:59 volumio volumio[1264]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Mar 30 21:14:59 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 30 21:14:59 volumio volumio[1264]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Mar 30 21:14:59 volumio volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 30 21:15:00 volumio dhcpcd[474]: timed out Mar 30 21:15:00 volumio dhcpcd[474]: exited Mar 30 21:15:00 volumio ifup[442]: dhcpcd[474]: timed out Mar 30 21:15:00 volumio ifup[442]: dhcpcd[474]: exited Mar 30 21:15:00 volumio ifup[442]: Failed to bring up eth0. Mar 30 21:15:01 volumio volumio[1264]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 30 21:15:01 volumio volumio[1264]: { Error: addMembership ENODEV Mar 30 21:15:01 volumio volumio[1264]: at _errnoException (util.js:1022:11) Mar 30 21:15:01 volumio volumio[1264]: at Socket.addMembership (dgram.js:615:11) Mar 30 21:15:01 volumio volumio[1264]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:261:16) Mar 30 21:15:01 volumio volumio[1264]: at ontimeout (timers.js:482:11) Mar 30 21:15:01 volumio volumio[1264]: at tryOnTimeout (timers.js:317:5) Mar 30 21:15:01 volumio volumio[1264]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Mar 30 21:15:01 volumio volumio[1264]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 30 21:15:02 volumio sudo[1621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-30 21:14 Mar 30 21:15:02 volumio sudo[1621]: 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="f1d44ae5428081b5b8ca49f419b134ef83e234df" VOLUMIO_FE_VERSION="021732c5252c1ad4fb85955339e1f032fe4ae9f0" VOLUMIO_BE_VERSION="caf6c0f9a8e3cd984391aa77621b50a9247127b8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Aug 2 17:17:17 CEST 2019" VOLUMIO_VERSION="2.599" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="c28fac21d698202aa4e6e014f85b1eaf"