-- Logs begin at Fri 2025-03-28 11:09:52 UTC, end at Sat 2025-06-28 04:03:10 UTC. -- Jun 28 04:02:42 volumio systemd[1]: Time has been changed Jun 28 04:02:42 volumio smbd[935]: [2025/06/28 04:02:42.820695, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jun 28 04:02:42 volumio smbd[935]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 28 04:02:42 volumio smbd[941]: [2025/06/28 04:02:42.824524, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jun 28 04:02:42 volumio smbd[941]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jun 28 04:02:43 volumio ntfs-3g[946]: Version 2014.2.15AR.2 integrated FUSE 28 Jun 28 04:02:43 volumio ntfs-3g[946]: Mounted /dev/sda1 (Read-Write, label "新加卷", NTFS 3.1) Jun 28 04:02:43 volumio ntfs-3g[946]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Jun 28 04:02:43 volumio ntfs-3g[946]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Jun 28 04:02:43 volumio ntfs-3g[946]: Global ownership and permissions enforced, configuration type 7 Jun 28 04:02:43 volumio udisks-glue[634]: Successfully automounted /dev/sda1 at /media/???_ Jun 28 04:02:43 volumio udisks-glue[634]: Device file /dev/sdb2 mounted at /media/??? Jun 28 04:02:43 volumio udisks-glue[634]: Device file /dev/sda1 mounted at /media/???_ Jun 28 04:02:43 volumio wireless.js[750]: trying... Jun 28 04:02:43 volumio sudo[952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 28 04:02:43 volumio sudo[952]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:43 volumio sudo[952]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:44 volumio wireless.js[750]: trying... Jun 28 04:02:44 volumio sudo[961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 28 04:02:44 volumio sudo[961]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:44 volumio sudo[961]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:45 volumio wireless.js[750]: trying... Jun 28 04:02:45 volumio sudo[970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 28 04:02:45 volumio sudo[970]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:45 volumio sudo[970]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:45 volumio wpa_supplicant[934]: wlan0: Trying to associate with 2c:70:4f:b0:fb:b9 (SSID='804' freq=5200 MHz) Jun 28 04:02:45 volumio systemd[1]: Started Music Player Daemon. Jun 28 04:02:45 volumio udisks-glue[634]: Updating DB (#1) ... Jun 28 04:02:45 volumio udisks-glue[634]: volume: 0% repeat: off random: off single: off consume: off Jun 28 04:02:45 volumio udisks-glue[634]: Updating DB (#1) ... Jun 28 04:02:45 volumio udisks-glue[634]: volume: 0% repeat: off random: off single: off consume: off Jun 28 04:02:45 volumio wpa_supplicant[934]: wlan0: Associated with 2c:70:4f:b0:fb:b9 Jun 28 04:02:45 volumio wpa_supplicant[934]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CN Jun 28 04:02:46 volumio wireless.js[750]: trying... Jun 28 04:02:46 volumio sudo[982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 28 04:02:46 volumio sudo[982]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:46 volumio sudo[982]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:46 volumio wpa_supplicant[934]: wlan0: WPA: Key negotiation completed with 2c:70:4f:b0:fb:b9 [PTK=CCMP GTK=CCMP] Jun 28 04:02:46 volumio wpa_supplicant[934]: wlan0: CTRL-EVENT-CONNECTED - Connection to 2c:70:4f:b0:fb:b9 completed [id=0 id_str=] Jun 28 04:02:46 volumio dhcpcd[930]: wlan0: carrier acquired Jun 28 04:02:46 volumio dhcpcd[930]: wlan0: soliciting an IPv6 router Jun 28 04:02:47 volumio wireless.js[750]: trying... Jun 28 04:02:47 volumio sudo[1008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 28 04:02:47 volumio sudo[1008]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:47 volumio sudo[1008]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:48 volumio wireless.js[750]: trying... Jun 28 04:02:48 volumio sudo[1017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 28 04:02:48 volumio sudo[1017]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:48 volumio volumio-remote-updater[637]: [2025-06-28 04:02:48] [info] asio async_connect error: system:111 (Connection refused) Jun 28 04:02:48 volumio volumio-remote-updater[637]: [2025-06-28 04:02:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 28 04:02:48 volumio volumio-remote-updater[637]: [2025-06-28 04:02:48] [error] handle_connect error: Underlying Transport Error Jun 28 04:02:48 volumio sudo[1017]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:49 volumio wireless.js[750]: trying... Jun 28 04:02:49 volumio sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 28 04:02:49 volumio sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:49 volumio sudo[1026]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:50 volumio wireless.js[750]: trying... Jun 28 04:02:50 volumio sudo[1035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 28 04:02:50 volumio sudo[1035]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:50 volumio sudo[1035]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:51 volumio wireless.js[750]: trying... Jun 28 04:02:51 volumio sudo[1044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 28 04:02:51 volumio sudo[1044]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:51 volumio sudo[1044]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:51 volumio dhcpcd[930]: wlan0: using IPv4LL address 169.254.34.189 Jun 28 04:02:51 volumio avahi-daemon[670]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.34.189. Jun 28 04:02:51 volumio dhcpcd[930]: eth0: adding route to 192.168.1.0/24 Jun 28 04:02:51 volumio dhcpcd[930]: eth0: adding default route via 192.168.1.1 Jun 28 04:02:51 volumio dhcpcd[930]: wlan0: adding host route to 169.254.34.189 via 127.0.0.1 Jun 28 04:02:51 volumio dhcpcd[930]: wlan0: adding route to 169.254.0.0/16 Jun 28 04:02:51 volumio avahi-daemon[670]: New relevant interface wlan0.IPv4 for mDNS. Jun 28 04:02:51 volumio avahi-daemon[670]: Registering new address record for 169.254.34.189 on wlan0.IPv4. Jun 28 04:02:51 volumio dhcpcd[930]: eth0: removing route to 192.168.1.0/24 Jun 28 04:02:51 volumio dhcpcd[930]: eth0: removing default route via 192.168.1.1 Jun 28 04:02:52 volumio wireless.js[750]: trying... Jun 28 04:02:52 volumio sudo[1072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 28 04:02:52 volumio sudo[1072]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:52 volumio sudo[1072]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:52 volumio wireless.js[750]: Connected to: ----804 Jun 28 04:02:52 volumio wireless.js[750]: ---- Jun 28 04:02:52 volumio sudo[1081]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 28 04:02:52 volumio sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:02:52 volumio sudo[1081]: pam_unix(sudo:session): session closed for user root Jun 28 04:02:52 volumio wireless.js[750]: ... joined AP, wlan0 IPv4 is 169.254.34.189, ipV6 is undefined Jun 28 04:02:52 volumio wireless.js[750]: It's done! AP Jun 28 04:02:52 volumio systemd[1]: Started Wireless Services. Jun 28 04:02:52 volumio systemd[1]: Starting Volumio Backend Module... Jun 28 04:02:52 volumio systemd[1]: Started Volumio Backend Module. Jun 28 04:02:52 volumio systemd[1]: Starting Multi-User System. Jun 28 04:02:52 volumio systemd[1]: Reached target Multi-User System. Jun 28 04:02:52 volumio systemd[1]: Starting Graphical Interface. Jun 28 04:02:52 volumio systemd[1]: Reached target Graphical Interface. Jun 28 04:02:52 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 28 04:02:52 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 28 04:02:52 volumio systemd[1]: Startup finished in 14.106s (kernel) + 38.265s (userspace) = 52.372s. Jun 28 04:02:53 volumio ntpd[740]: Listen normally on 4 wlan0 169.254.34.189 UDP 123 Jun 28 04:02:53 volumio ntpd[740]: peers refreshed Jun 28 04:02:54 volumio ntfs-3g[946]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 65535: Invalid argument Jun 28 04:02:54 volumio ntfs-3g[946]: Index buffer (VCN 0x0) of directory inode 0x15dd has a size (24) differing from the directory specified size (4096). Jun 28 04:02:54 volumio ntfs-3g[946]: ntfs_mst_post_read_fixup_warn: magic: 0x00000000 size: 4096 usa_ofs: 0 usa_count: 65535: Invalid argument Jun 28 04:02:54 volumio ntfs-3g[946]: Index buffer (VCN 0x0) of directory inode 5597 has a size (24) differing from the directory specified size (4096). Jun 28 04:02:54 volumio dhcpcd[930]: wlan0: soliciting a DHCP lease Jun 28 04:02:55 volumio volumio[1090]: info: ------------------------------------------- Jun 28 04:02:55 volumio volumio[1090]: info: ----- Volumio2 ---- Jun 28 04:02:55 volumio volumio[1090]: info: ------------------------------------------- Jun 28 04:02:55 volumio volumio[1090]: info: ----- System startup ---- Jun 28 04:02:55 volumio volumio[1090]: info: ------------------------------------------- Jun 28 04:02:55 volumio volumio[1090]: info: Plugin folders cleanup Jun 28 04:02:55 volumio volumio[1090]: info: Scanning into folder /volumio/app/plugins/ Jun 28 04:02:55 volumio volumio[1090]: info: Scanning category audio_interface Jun 28 04:02:55 volumio volumio[1090]: info: Scanning category miscellanea Jun 28 04:02:55 volumio volumio[1090]: info: Scanning category music_service Jun 28 04:02:55 volumio volumio[1090]: info: Scanning category plugins.json Jun 28 04:02:55 volumio volumio[1090]: info: Scanning category system_controller Jun 28 04:02:55 volumio volumio[1090]: info: Scanning category user_interface Jun 28 04:02:55 volumio volumio[1090]: info: Scanning into folder /data/plugins/ Jun 28 04:02:55 volumio volumio[1090]: info: Plugin folders cleanup completed Jun 28 04:02:55 volumio volumio[1090]: info: ------------------------------------------- Jun 28 04:02:55 volumio volumio[1090]: info: ----- Core plugins startup ---- Jun 28 04:02:55 volumio volumio[1090]: info: ------------------------------------------- Jun 28 04:02:55 volumio volumio[1090]: info: Loading plugins from folder /volumio/app/plugins/ Jun 28 04:02:55 volumio volumio[1090]: info: Adding plugin upnp to MyMusic Plugins Jun 28 04:02:55 volumio volumio[1090]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 28 04:02:55 volumio volumio[1090]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 28 04:02:55 volumio volumio[1090]: info: Loading plugins from folder /data/plugins/ Jun 28 04:02:55 volumio volumio[1090]: info: Loading plugin "system"... Jun 28 04:02:55 volumio volumio[1090]: info: Loading plugin "appearance"... Jun 28 04:02:56 volumio volumio[1090]: info: Loading plugin "network"... Jun 28 04:02:56 volumio volumio[1090]: info: Loading plugin "services"... Jun 28 04:02:56 volumio volumio[1090]: info: Loading plugin "alsa_controller"... Jun 28 04:02:56 volumio volumio[1090]: info: Loading plugin "wizard"... Jun 28 04:02:56 volumio volumio[1090]: info: Loading plugin "volumio_command_line_client"... Jun 28 04:02:56 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 28 04:02:56 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 28 04:02:56 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 28 04:02:56 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 28 04:02:57 volumio volumio[1090]: info: Loading plugin "upnp"... Jun 28 04:02:57 volumio volumio[1090]: info: [1751083377011] Starting Upmpd Daemon Jun 28 04:02:57 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 28 04:02:57 volumio volumio[1090]: info: Loading plugin "my_music"... Jun 28 04:02:57 volumio volumio[1090]: info: Loading plugin "mpd"... Jun 28 04:02:57 volumio dhcpcd[930]: wlan0: offered 192.168.1.139 from 192.168.1.1 Jun 28 04:02:57 volumio dhcpcd[930]: wlan0: ignoring offer of 192.168.1.139 from 192.168.1.1 Jun 28 04:02:57 volumio volumio[1090]: info: Loading plugin "upnp_browser"... Jun 28 04:02:58 volumio volumio-remote-updater[637]: [2025-06-28 04:02:58] [connect] Successful connection Jun 28 04:02:58 volumio volumio[1090]: info: Loading plugin "networkfs"... Jun 28 04:02:58 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 28 04:02:58 volumio volumio[1090]: info: Loading plugin "alarm-clock"... Jun 28 04:02:58 volumio volumio[1090]: info: Loading plugin "airplay_emulation"... Jun 28 04:02:58 volumio volumio[1090]: info: Starting Shairport Sync Jun 28 04:02:58 volumio volumio[1090]: info: Loading plugin "last_100"... Jun 28 04:02:58 volumio volumio[1090]: info: Loading plugin "webradio"... Jun 28 04:02:58 volumio volumio[1090]: info: Loading plugin "i2s_dacs"... Jun 28 04:02:58 volumio volumio[1090]: info: I2S DAC not set, start Auto-detection Jun 28 04:02:58 volumio volumio[1090]: info: Loading plugin "volumiodiscovery"... Jun 28 04:02:58 volumio volumio[1090]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 28 04:02:58 volumio node[1090]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 28 04:02:58 volumio node[1090]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 28 04:02:58 volumio node[1090]: *** WARNING *** For more information see Jun 28 04:02:58 volumio node[1090]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 28 04:02:58 volumio node[1090]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 28 04:02:58 volumio node[1090]: *** WARNING *** For more information see Jun 28 04:02:58 volumio volumio[1090]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 28 04:02:58 volumio volumio[1090]: *** WARNING *** For more information see Jun 28 04:02:58 volumio volumio[1090]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 28 04:02:58 volumio volumio[1090]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 28 04:02:58 volumio volumio[1090]: *** WARNING *** For more information see Jun 28 04:02:58 volumio volumio[1090]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 28 04:02:58 volumio volumio[1090]: Discovery: StartAdv! undefined Jun 28 04:02:58 volumio volumio[1090]: Discovery: Started advertising... Volumio - undefined Jun 28 04:02:58 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 28 04:02:58 volumio volumio[1090]: info: Loading plugin "albumart"... Jun 28 04:02:58 volumio volumio[1090]: info: Plugin example_plugin is not enabled Jun 28 04:02:58 volumio volumio[1090]: info: Loading plugin "updater_comm"... Jun 28 04:02:59 volumio volumio[1090]: info: Plugin mpdemulation is not enabled Jun 28 04:02:59 volumio volumio[1090]: info: Loading plugin "rest_api"... Jun 28 04:02:59 volumio volumio[1090]: info: Loading plugin "websocket"... Jun 28 04:02:59 volumio volumio[1090]: info: ___________ START PLUGINS ___________ Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 28 04:02:59 volumio volumio[1090]: info: [1751083379141] CoreMusicLibrary::Adding element Media Servers Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 28 04:02:59 volumio volumio[1090]: info: [1751083379169] CoreMusicLibrary::Adding element Last_100 Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 28 04:02:59 volumio volumio[1090]: info: [1751083379172] CoreMusicLibrary::Adding element Webradio Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 28 04:02:59 volumio volumio[1090]: info: ------------------------------------------- Jun 28 04:02:59 volumio volumio[1090]: info: ----- MyVolumio plugins startup ---- Jun 28 04:02:59 volumio volumio[1090]: info: ------------------------------------------- Jun 28 04:02:59 volumio volumio[1090]: info: Loading plugins from folder /myvolumio/plugins Jun 28 04:02:59 volumio volumio[1090]: info: Loading plugins from folder /data/myvolumio/plugins Jun 28 04:02:59 volumio volumio[1090]: info: Loading i18n strings for locale zh Jun 28 04:02:59 volumio volumio[1090]: Updating browse sources language Jun 28 04:02:59 volumio volumio[1090]: Cannot find translation for sourceMedia Servers Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::initPlayerControls Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 28 04:02:59 volumio volumio[1090]: Forking 3 albumart workers Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 28 04:02:59 volumio volumio[1090]: info: BOOT COMPLETED Jun 28 04:02:59 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 28 04:03:00 volumio volumio[1090]: Starting albumart workers Jun 28 04:03:00 volumio volumio[1090]: Starting albumart workers Jun 28 04:03:00 volumio volumio[1090]: Starting albumart workers Jun 28 04:03:01 volumio dhcpcd[930]: wlan0: leased 192.168.1.139 for 7200 seconds Jun 28 04:03:01 volumio avahi-daemon[670]: Registering new address record for 192.168.1.139 on wlan0.IPv4. Jun 28 04:03:01 volumio avahi-daemon[670]: Withdrawing address record for 169.254.34.189 on wlan0. Jun 28 04:03:01 volumio avahi-daemon[670]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.34.189. Jun 28 04:03:01 volumio dhcpcd[930]: eth0: adding route to 192.168.1.0/24 Jun 28 04:03:01 volumio dhcpcd[930]: eth0: adding default route via 192.168.1.1 Jun 28 04:03:01 volumio dhcpcd[930]: wlan0: adding host route to 192.168.1.139 via 127.0.0.1 Jun 28 04:03:01 volumio dhcpcd[930]: wlan0: adding route to 192.168.1.0/24 Jun 28 04:03:01 volumio dhcpcd[930]: wlan0: adding default route via 192.168.1.1 Jun 28 04:03:01 volumio dhcpcd[930]: wlan0: deleting host route to 169.254.34.189 via 127.0.0.1 Jun 28 04:03:01 volumio dhcpcd[930]: wlan0: deleting route to 169.254.0.0/16 Jun 28 04:03:01 volumio avahi-daemon[670]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.139. Jun 28 04:03:01 volumio dhcpcd[930]: eth0: removing route to 192.168.1.0/24 Jun 28 04:03:01 volumio dhcpcd[930]: eth0: removing default route via 192.168.1.1 Jun 28 04:03:03 volumio ntpd[740]: Listen normally on 5 wlan0 192.168.1.139 UDP 123 Jun 28 04:03:03 volumio ntpd[740]: Deleting interface #4 wlan0, 169.254.34.189#123, interface stats: received=0, sent=0, dropped=0, active_time=10 secs Jun 28 04:03:03 volumio ntpd[740]: peers refreshed Jun 28 04:03:04 volumio volumio[1090]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jun 28 04:03:04 volumio volumio[1090]: info: CoreCommandRouter::Close All Modals sent Jun 28 04:03:04 volumio volumio[1090]: info: CoreCommandRouter::Close All Modals sent Jun 28 04:03:04 volumio volumio[1090]: Express server listening on port 3000 Jun 28 04:03:04 volumio volumio[1090]: Volumio Calling Home Jun 28 04:03:04 volumio volumio[1090]: info: CoreStateMachine::resetVolumioState Jun 28 04:03:04 volumio volumio[1090]: info: CoreStateMachine::getcurrentVolume Jun 28 04:03:04 volumio volumio[1090]: info: CoreCommandRouter::volumioRetrievevolume Jun 28 04:03:04 volumio volumio[1090]: info: CoreStateMachine::updateTrackBlock Jun 28 04:03:04 volumio volumio[1090]: info: CorePlayQueue::getTrackBlock Jun 28 04:03:04 volumio volumio[1090]: info: Setting Device type: Raspberry PI Jun 28 04:03:04 volumio volumio[1090]: info: MPD running with PID671 ,establishing connection Jun 28 04:03:05 volumio sudo[1173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jun 28 04:03:05 volumio sudo[1173]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:03:05 volumio sudo[1173]: pam_unix(sudo:session): session closed for user root Jun 28 04:03:05 volumio volumio[1090]: info: VolumeController:: Volume=undefined Mute =undefined Jun 28 04:03:05 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 28 04:03:05 volumio volumio[1090]: info: CoreStateMachine::getState Jun 28 04:03:05 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 28 04:03:05 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 28 04:03:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 04:03:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 28 04:03:05 volumio volumio[1090]: info: Reloading queue from file Jun 28 04:03:05 volumio volumio[1090]: info: Jun 28 04:03:05 volumio volumio[1090]: info: CoreStateMachine::setRepeat null single undefined Jun 28 04:03:05 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 28 04:03:05 volumio volumio[1090]: info: CoreStateMachine::getState Jun 28 04:03:05 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 28 04:03:05 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 28 04:03:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 04:03:05 volumio volumio[1090]: info: CoreStateMachine::setRandom null Jun 28 04:03:05 volumio volumio[1090]: info: CoreStateMachine::pushState Jun 28 04:03:05 volumio volumio[1090]: info: CoreStateMachine::getState Jun 28 04:03:05 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 28 04:03:05 volumio volumio[1090]: info: CoreCommandRouter::volumioPushState Jun 28 04:03:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 28 04:03:05 volumio sudo[1184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jun 28 04:03:05 volumio sudo[1184]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:03:05 volumio sudo[1186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jun 28 04:03:05 volumio sudo[1186]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:03:05 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jun 28 04:03:05 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jun 28 04:03:05 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Jun 28 04:03:05 volumio sudo[1184]: pam_unix(sudo:session): session closed for user root Jun 28 04:03:05 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jun 28 04:03:05 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jun 28 04:03:05 volumio sudo[1186]: pam_unix(sudo:session): session closed for user root Jun 28 04:03:05 volumio shairport-sync[1198]: Successful Startup Jun 28 04:03:05 volumio volumio[1090]: Discovery: adding 31359fc6-6d2e-4ec0-ae62-e32dc6e477c0 Jun 28 04:03:05 volumio volumio[1090]: info: mDNS: Found device Volumio Jun 28 04:03:05 volumio sudo[1207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 28 04:03:05 volumio sudo[1207]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:03:05 volumio sudo[1207]: pam_unix(sudo:session): session closed for user root Jun 28 04:03:05 volumio volumio[1090]: info: Shairport-Sync Started Jun 28 04:03:05 volumio volumio[1090]: Error adding Membership: Error: addMembership EINVAL Jun 28 04:03:05 volumio volumio[1090]: info: Shairport-Sync Started Jun 28 04:03:05 volumio volumio[1090]: info: CoreCommandRouter::volumioGetState Jun 28 04:03:05 volumio volumio[1090]: info: CoreStateMachine::getState Jun 28 04:03:05 volumio volumio[1090]: info: CorePlayQueue::getTrack 0 Jun 28 04:03:05 volumio sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 28 04:03:05 volumio sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:03:05 volumio sudo[1216]: pam_unix(sudo:session): session closed for user root Jun 28 04:03:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 28 04:03:05 volumio volumio[1090]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 28 04:03:07 volumio sudo[1229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 28 04:03:07 volumio sudo[1229]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:03:07 volumio sudo[1229]: pam_unix(sudo:session): session closed for user root Jun 28 04:03:07 volumio sudo[1234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 28 04:03:07 volumio sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 28 04:03:07 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Jun 28 04:03:07 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 28 04:03:07 volumio sudo[1234]: pam_unix(sudo:session): session closed for user root Jun 28 04:03:07 volumio volumio[1090]: info: Upmpdcli Daemon Started Jun 28 04:03:07 volumio volumio[1243]: Wrong scontrol identifier: Jun 28 04:03:07 volumio volumio[1243]: Wrong scontrol identifier: Jun 28 04:03:08 volumio volumio[1243]: Wrong scontrol identifier: Jun 28 04:03:09 volumio volumio[1243]: Wrong scontrol identifier: Jun 28 04:03:09 volumio volumio[1090]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 04:03:09 volumio volumio[1090]: { Error: addMembership ENODEV Jun 28 04:03:09 volumio volumio[1090]: at _errnoException (util.js:1022:11) Jun 28 04:03:09 volumio volumio[1090]: at Socket.addMembership (dgram.js:615:11) Jun 28 04:03:09 volumio volumio[1090]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:261:16) Jun 28 04:03:09 volumio volumio[1090]: at ontimeout (timers.js:482:11) Jun 28 04:03:09 volumio volumio[1090]: at tryOnTimeout (timers.js:317:5) Jun 28 04:03:09 volumio volumio[1090]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Jun 28 04:03:09 volumio volumio[1090]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 28 04:03:10 volumio sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-28 04:02 Jun 28 04:03:10 volumio sudo[1293]: 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"