-- Logs begin at Wed 2025-01-01 08:38:11 UTC, end at Wed 2025-01-22 05:25:47 UTC. -- Jan 22 05:25:22 volumio systemd[1]: Time has been changed Jan 22 05:25:22 volumio wpa_supplicant[922]: wlan0: Associated with 2c:70:4f:b0:fb:b9 Jan 22 05:25:22 volumio wpa_supplicant[922]: wlan0: WPA: Key negotiation completed with 2c:70:4f:b0:fb:b9 [PTK=CCMP GTK=CCMP] Jan 22 05:25:22 volumio wpa_supplicant[922]: wlan0: CTRL-EVENT-CONNECTED - Connection to 2c:70:4f:b0:fb:b9 completed [id=0 id_str=] Jan 22 05:25:22 volumio dhcpcd[921]: wlan0: carrier acquired Jan 22 05:25:22 volumio wpa_supplicant[922]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CN Jan 22 05:25:22 volumio dhcpcd[921]: wlan0: soliciting an IPv6 router Jan 22 05:25:22 volumio volumio-remote-updater[548]: [2025-01-22 05:25:22] [info] asio async_connect error: system:111 (Connection refused) Jan 22 05:25:22 volumio volumio-remote-updater[548]: [2025-01-22 05:25:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 22 05:25:22 volumio volumio-remote-updater[548]: [2025-01-22 05:25:22] [error] handle_connect error: Underlying Transport Error Jan 22 05:25:23 volumio wireless.js[662]: trying... Jan 22 05:25:23 volumio sudo[979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 22 05:25:23 volumio sudo[979]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:23 volumio sudo[979]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:24 volumio wireless.js[662]: trying... Jan 22 05:25:24 volumio sudo[988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 22 05:25:24 volumio sudo[988]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:24 volumio sudo[988]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:25 volumio wireless.js[662]: trying... Jan 22 05:25:25 volumio sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 22 05:25:25 volumio sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:25 volumio sudo[997]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:26 volumio wireless.js[662]: trying... Jan 22 05:25:26 volumio sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 22 05:25:26 volumio sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:26 volumio sudo[1006]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:27 volumio wireless.js[662]: trying... Jan 22 05:25:27 volumio sudo[1015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 22 05:25:27 volumio sudo[1015]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:27 volumio sudo[1015]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:28 volumio dhcpcd[921]: wlan0: using IPv4LL address 169.254.164.220 Jan 22 05:25:28 volumio dhcpcd[921]: eth0: adding route to 192.168.1.0/24 Jan 22 05:25:28 volumio dhcpcd[921]: eth0: adding default route via 192.168.1.1 Jan 22 05:25:28 volumio dhcpcd[921]: wlan0: adding host route to 169.254.164.220 via 127.0.0.1 Jan 22 05:25:28 volumio dhcpcd[921]: wlan0: adding route to 169.254.0.0/16 Jan 22 05:25:28 volumio avahi-daemon[572]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.164.220. Jan 22 05:25:28 volumio avahi-daemon[572]: New relevant interface wlan0.IPv4 for mDNS. Jan 22 05:25:28 volumio avahi-daemon[572]: Registering new address record for 169.254.164.220 on wlan0.IPv4. Jan 22 05:25:28 volumio dhcpcd[921]: eth0: removing route to 192.168.1.0/24 Jan 22 05:25:28 volumio dhcpcd[921]: eth0: removing default route via 192.168.1.1 Jan 22 05:25:28 volumio wireless.js[662]: trying... Jan 22 05:25:28 volumio sudo[1044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 22 05:25:28 volumio sudo[1044]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:28 volumio sudo[1044]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:28 volumio wireless.js[662]: Connected to: ----804 Jan 22 05:25:28 volumio wireless.js[662]: ---- Jan 22 05:25:28 volumio sudo[1053]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 22 05:25:28 volumio sudo[1053]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:28 volumio sudo[1053]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:28 volumio wireless.js[662]: ... joined AP, wlan0 IPv4 is 169.254.164.220, ipV6 is undefined Jan 22 05:25:28 volumio wireless.js[662]: It's done! AP Jan 22 05:25:28 volumio systemd[1]: Started Wireless Services. Jan 22 05:25:28 volumio systemd[1]: Starting Volumio Backend Module... Jan 22 05:25:28 volumio systemd[1]: Started Volumio Backend Module. Jan 22 05:25:28 volumio systemd[1]: Starting Multi-User System. Jan 22 05:25:28 volumio systemd[1]: Reached target Multi-User System. Jan 22 05:25:28 volumio systemd[1]: Starting Graphical Interface. Jan 22 05:25:28 volumio systemd[1]: Reached target Graphical Interface. Jan 22 05:25:28 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 22 05:25:28 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 22 05:25:28 volumio systemd[1]: Startup finished in 10.743s (kernel) + 29.610s (userspace) = 40.353s. Jan 22 05:25:29 volumio ntpd[645]: Listen normally on 4 wlan0 169.254.164.220 UDP 123 Jan 22 05:25:29 volumio ntpd[645]: peers refreshed Jan 22 05:25:31 volumio ntfs-3g[827]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 65535: Invalid argument Jan 22 05:25:31 volumio ntfs-3g[827]: Index buffer (VCN 0x0) of directory inode 0x15dd has a size (24) differing from the directory specified size (4096). Jan 22 05:25:31 volumio ntfs-3g[827]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 65535: Invalid argument Jan 22 05:25:31 volumio ntfs-3g[827]: Index buffer (VCN 0x0) of directory inode 5597 has a size (24) differing from the directory specified size (4096). Jan 22 05:25:31 volumio volumio[1062]: info: ------------------------------------------- Jan 22 05:25:31 volumio volumio[1062]: info: ----- Volumio2 ---- Jan 22 05:25:31 volumio volumio[1062]: info: ------------------------------------------- Jan 22 05:25:31 volumio volumio[1062]: info: ----- System startup ---- Jan 22 05:25:31 volumio volumio[1062]: info: ------------------------------------------- Jan 22 05:25:31 volumio volumio[1062]: info: Plugin folders cleanup Jan 22 05:25:31 volumio volumio[1062]: info: Scanning into folder /volumio/app/plugins/ Jan 22 05:25:31 volumio volumio[1062]: info: Scanning category audio_interface Jan 22 05:25:31 volumio volumio[1062]: info: Scanning category miscellanea Jan 22 05:25:31 volumio volumio[1062]: info: Scanning category music_service Jan 22 05:25:31 volumio volumio[1062]: info: Scanning category plugins.json Jan 22 05:25:31 volumio volumio[1062]: info: Scanning category system_controller Jan 22 05:25:31 volumio volumio[1062]: info: Scanning category user_interface Jan 22 05:25:31 volumio volumio[1062]: info: Scanning into folder /data/plugins/ Jan 22 05:25:31 volumio volumio[1062]: info: Plugin folders cleanup completed Jan 22 05:25:31 volumio volumio[1062]: info: ------------------------------------------- Jan 22 05:25:31 volumio volumio[1062]: info: ----- Core plugins startup ---- Jan 22 05:25:31 volumio volumio[1062]: info: ------------------------------------------- Jan 22 05:25:31 volumio volumio[1062]: info: Loading plugins from folder /volumio/app/plugins/ Jan 22 05:25:31 volumio volumio[1062]: info: Adding plugin upnp to MyMusic Plugins Jan 22 05:25:31 volumio volumio[1062]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 22 05:25:31 volumio volumio[1062]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 22 05:25:31 volumio volumio[1062]: info: Loading plugins from folder /data/plugins/ Jan 22 05:25:31 volumio volumio[1062]: info: Loading plugin "system"... Jan 22 05:25:31 volumio volumio[1062]: info: Loading plugin "appearance"... Jan 22 05:25:32 volumio volumio-remote-updater[548]: [2025-01-22 05:25:32] [connect] Successful connection Jan 22 05:25:32 volumio dhcpcd[921]: wlan0: soliciting a DHCP lease Jan 22 05:25:32 volumio volumio[1062]: info: Loading plugin "network"... Jan 22 05:25:33 volumio volumio[1062]: info: Loading plugin "services"... Jan 22 05:25:33 volumio volumio[1062]: info: Loading plugin "alsa_controller"... Jan 22 05:25:33 volumio volumio[1062]: info: Loading plugin "wizard"... Jan 22 05:25:33 volumio volumio[1062]: info: Loading plugin "volumio_command_line_client"... Jan 22 05:25:33 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 22 05:25:33 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 22 05:25:33 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 22 05:25:33 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 22 05:25:33 volumio volumio[1062]: info: Loading plugin "upnp"... Jan 22 05:25:33 volumio volumio[1062]: info: [1737523533511] Starting Upmpd Daemon Jan 22 05:25:33 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 22 05:25:33 volumio volumio[1062]: info: Loading plugin "my_music"... Jan 22 05:25:33 volumio volumio[1062]: info: Loading plugin "mpd"... Jan 22 05:25:33 volumio volumio[1062]: info: Loading plugin "upnp_browser"... Jan 22 05:25:34 volumio dhcpcd[921]: wlan0: offered 192.168.1.139 from 192.168.1.1 Jan 22 05:25:34 volumio volumio[1062]: info: Loading plugin "networkfs"... Jan 22 05:25:34 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 22 05:25:34 volumio volumio[1062]: info: Loading plugin "alarm-clock"... Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugin "airplay_emulation"... Jan 22 05:25:35 volumio volumio[1062]: info: Starting Shairport Sync Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugin "last_100"... Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugin "webradio"... Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugin "i2s_dacs"... Jan 22 05:25:35 volumio volumio[1062]: info: I2S DAC not set, start Auto-detection Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugin "volumiodiscovery"... Jan 22 05:25:35 volumio volumio[1062]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 22 05:25:35 volumio node[1062]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 22 05:25:35 volumio node[1062]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 22 05:25:35 volumio node[1062]: *** WARNING *** For more information see Jan 22 05:25:35 volumio node[1062]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 22 05:25:35 volumio node[1062]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 22 05:25:35 volumio node[1062]: *** WARNING *** For more information see Jan 22 05:25:35 volumio volumio[1062]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 22 05:25:35 volumio volumio[1062]: *** WARNING *** For more information see Jan 22 05:25:35 volumio volumio[1062]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 22 05:25:35 volumio volumio[1062]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 22 05:25:35 volumio volumio[1062]: *** WARNING *** For more information see Jan 22 05:25:35 volumio volumio[1062]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 22 05:25:35 volumio volumio[1062]: Discovery: StartAdv! undefined Jan 22 05:25:35 volumio volumio[1062]: Discovery: Started advertising... Volumio - undefined Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugin "albumart"... Jan 22 05:25:35 volumio volumio[1062]: info: Plugin example_plugin is not enabled Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugin "updater_comm"... Jan 22 05:25:35 volumio volumio[1062]: info: Plugin mpdemulation is not enabled Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugin "rest_api"... Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugin "websocket"... Jan 22 05:25:35 volumio volumio[1062]: info: ___________ START PLUGINS ___________ Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 22 05:25:35 volumio volumio[1062]: info: [1737523535587] CoreMusicLibrary::Adding element Media Servers Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 22 05:25:35 volumio volumio[1062]: info: [1737523535616] CoreMusicLibrary::Adding element Last_100 Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 22 05:25:35 volumio volumio[1062]: info: [1737523535619] CoreMusicLibrary::Adding element Webradio Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 22 05:25:35 volumio volumio[1062]: info: ------------------------------------------- Jan 22 05:25:35 volumio volumio[1062]: info: ----- MyVolumio plugins startup ---- Jan 22 05:25:35 volumio volumio[1062]: info: ------------------------------------------- Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugins from folder /myvolumio/plugins Jan 22 05:25:35 volumio volumio[1062]: info: Loading plugins from folder /data/myvolumio/plugins Jan 22 05:25:35 volumio volumio[1062]: info: Loading i18n strings for locale zh Jan 22 05:25:35 volumio volumio[1062]: Updating browse sources language Jan 22 05:25:35 volumio volumio[1062]: Cannot find translation for sourceMedia Servers Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::initPlayerControls Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jan 22 05:25:35 volumio volumio[1062]: Forking 3 albumart workers Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 22 05:25:35 volumio volumio[1062]: info: BOOT COMPLETED Jan 22 05:25:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 22 05:25:36 volumio volumio[1062]: Starting albumart workers Jan 22 05:25:36 volumio volumio[1062]: Starting albumart workers Jan 22 05:25:36 volumio volumio[1062]: Starting albumart workers Jan 22 05:25:40 volumio dhcpcd[921]: wlan0: leased 192.168.1.139 for 7200 seconds Jan 22 05:25:40 volumio avahi-daemon[572]: Registering new address record for 192.168.1.139 on wlan0.IPv4. Jan 22 05:25:40 volumio avahi-daemon[572]: Withdrawing address record for 169.254.164.220 on wlan0. Jan 22 05:25:40 volumio avahi-daemon[572]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.164.220. Jan 22 05:25:40 volumio avahi-daemon[572]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.139. Jan 22 05:25:40 volumio dhcpcd[921]: eth0: adding route to 192.168.1.0/24 Jan 22 05:25:40 volumio dhcpcd[921]: eth0: adding default route via 192.168.1.1 Jan 22 05:25:40 volumio dhcpcd[921]: wlan0: adding host route to 192.168.1.139 via 127.0.0.1 Jan 22 05:25:40 volumio dhcpcd[921]: wlan0: adding route to 192.168.1.0/24 Jan 22 05:25:40 volumio dhcpcd[921]: wlan0: adding default route via 192.168.1.1 Jan 22 05:25:40 volumio dhcpcd[921]: wlan0: deleting host route to 169.254.164.220 via 127.0.0.1 Jan 22 05:25:40 volumio dhcpcd[921]: wlan0: deleting route to 169.254.0.0/16 Jan 22 05:25:40 volumio dhcpcd[921]: eth0: removing route to 192.168.1.0/24 Jan 22 05:25:40 volumio dhcpcd[921]: eth0: removing default route via 192.168.1.1 Jan 22 05:25:41 volumio volumio[1062]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 22 05:25:41 volumio volumio[1062]: info: CoreCommandRouter::Close All Modals sent Jan 22 05:25:41 volumio volumio[1062]: info: CoreCommandRouter::Close All Modals sent Jan 22 05:25:41 volumio volumio[1062]: Express server listening on port 3000 Jan 22 05:25:41 volumio volumio[1062]: Volumio Calling Home Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::resetVolumioState Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::getcurrentVolume Jan 22 05:25:41 volumio volumio[1062]: info: CoreCommandRouter::volumioRetrievevolume Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::updateTrackBlock Jan 22 05:25:41 volumio volumio[1062]: info: CorePlayQueue::getTrackBlock Jan 22 05:25:41 volumio volumio[1062]: info: Setting Device type: Raspberry PI Jan 22 05:25:41 volumio volumio[1062]: info: MPD running with PID578 ,establishing connection Jan 22 05:25:41 volumio sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jan 22 05:25:41 volumio sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:41 volumio sudo[1145]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:41 volumio volumio[1062]: info: VolumeController:: Volume=undefined Mute =undefined Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::pushState Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::getState Jan 22 05:25:41 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Jan 22 05:25:41 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Jan 22 05:25:41 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 22 05:25:41 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 22 05:25:41 volumio volumio[1062]: info: Reloading queue from file Jan 22 05:25:41 volumio volumio[1062]: info: Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::setRepeat null single undefined Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::pushState Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::getState Jan 22 05:25:41 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Jan 22 05:25:41 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Jan 22 05:25:41 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::setRandom null Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::pushState Jan 22 05:25:41 volumio volumio[1062]: info: CoreStateMachine::getState Jan 22 05:25:41 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Jan 22 05:25:41 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Jan 22 05:25:41 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 22 05:25:41 volumio sudo[1156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jan 22 05:25:41 volumio sudo[1156]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:41 volumio sudo[1158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jan 22 05:25:41 volumio sudo[1158]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:41 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jan 22 05:25:41 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jan 22 05:25:41 volumio sudo[1156]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:41 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Jan 22 05:25:41 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jan 22 05:25:41 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jan 22 05:25:41 volumio sudo[1158]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:41 volumio shairport-sync[1172]: Successful Startup Jan 22 05:25:41 volumio volumio[1062]: Discovery: adding 31359fc6-6d2e-4ec0-ae62-e32dc6e477c0 Jan 22 05:25:41 volumio volumio[1062]: info: mDNS: Found device Volumio Jan 22 05:25:41 volumio sudo[1179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 22 05:25:41 volumio sudo[1179]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:41 volumio sudo[1179]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:42 volumio ntpd[645]: Listen normally on 5 wlan0 192.168.1.139 UDP 123 Jan 22 05:25:42 volumio ntpd[645]: Deleting interface #4 wlan0, 169.254.164.220#123, interface stats: received=0, sent=0, dropped=0, active_time=13 secs Jan 22 05:25:42 volumio ntpd[645]: peers refreshed Jan 22 05:25:42 volumio volumio[1062]: info: Shairport-Sync Started Jan 22 05:25:42 volumio volumio[1062]: Error adding Membership: Error: addMembership EINVAL Jan 22 05:25:42 volumio volumio[1062]: info: Shairport-Sync Started Jan 22 05:25:42 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 22 05:25:42 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 22 05:25:42 volumio volumio[1062]: Discovery: this is already registered, 31359fc6-6d2e-4ec0-ae62-e32dc6e477c0 Jan 22 05:25:42 volumio volumio[1062]: info: mDNS: Found device Volumio Jan 22 05:25:42 volumio sudo[1192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 22 05:25:42 volumio sudo[1192]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:42 volumio sudo[1192]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:43 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Jan 22 05:25:43 volumio volumio[1062]: info: CoreStateMachine::getState Jan 22 05:25:43 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Jan 22 05:25:43 volumio sudo[1201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 22 05:25:43 volumio sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:43 volumio sudo[1201]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:43 volumio sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 22 05:25:43 volumio sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:43 volumio sudo[1210]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:43 volumio sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 22 05:25:43 volumio sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:43 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Jan 22 05:25:43 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jan 22 05:25:43 volumio sudo[1216]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:43 volumio volumio[1062]: info: Upmpdcli Daemon Started Jan 22 05:25:43 volumio volumio[1224]: Wrong scontrol identifier: Jan 22 05:25:43 volumio volumio[1224]: Wrong scontrol identifier: Jan 22 05:25:44 volumio sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 22 05:25:44 volumio sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:44 volumio sudo[1252]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:44 volumio sudo[1254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 22 05:25:44 volumio sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:44 volumio sudo[1254]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:44 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Jan 22 05:25:44 volumio volumio[1062]: info: CoreStateMachine::getState Jan 22 05:25:44 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Jan 22 05:25:44 volumio sudo[1270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 22 05:25:44 volumio sudo[1270]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:44 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Jan 22 05:25:44 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 22 05:25:44 volumio sudo[1270]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:44 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 22 05:25:44 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 22 05:25:44 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 22 05:25:44 volumio volumio[1062]: info: Listing playlists Jan 22 05:25:44 volumio sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 22 05:25:44 volumio sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 22 05:25:44 volumio sudo[1280]: pam_unix(sudo:session): session closed for user root Jan 22 05:25:44 volumio volumio[1224]: Wrong scontrol identifier: Jan 22 05:25:45 volumio volumio[1224]: Wrong scontrol identifier: Jan 22 05:25:46 volumio volumio[1062]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 22 05:25:46 volumio volumio[1062]: { Error: addMembership ENODEV Jan 22 05:25:46 volumio volumio[1062]: at _errnoException (util.js:1022:11) Jan 22 05:25:46 volumio volumio[1062]: at Socket.addMembership (dgram.js:615:11) Jan 22 05:25:46 volumio volumio[1062]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:261:16) Jan 22 05:25:46 volumio volumio[1062]: at ontimeout (timers.js:482:11) Jan 22 05:25:46 volumio volumio[1062]: at tryOnTimeout (timers.js:317:5) Jan 22 05:25:46 volumio volumio[1062]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Jan 22 05:25:46 volumio volumio[1062]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 22 05:25:47 volumio sudo[1310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-22 05:24 Jan 22 05:25:47 volumio sudo[1310]: 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="c00a19098320053824010d132d6bfb39774a7d2f" VOLUMIO_FE_VERSION="e2f152c30d370c9c7c86508a02c0323bef5c243b" VOLUMIO_BE_VERSION="909cc76a7609428f005f8e2878227062cb5328a6" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Sep 17 00:18:22 CEST 2018" VOLUMIO_VERSION="2.457" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="cdde21c6e3d40ce352c051f661950d1b"