-- Logs begin at Thu 2019-02-14 19:12:00 KST, end at Tue 2025-05-20 17:12:49 KST. -- May 20 17:11:03 volumio volumio[12815]: info: CoreCommandRouter::volumioGetState May 20 17:11:03 volumio volumio[12815]: info: CorePlayQueue::getTrack 0 May 20 17:11:03 volumio volumio[12815]: info: Listing playlists May 20 17:11:03 volumio volumio[12815]: info: Listing playlists May 20 17:11:03 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:11:11 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:11:13 volumio volumio[12815]: info: CoreCommandRouter::volumioGetState May 20 17:11:13 volumio volumio[12815]: info: CorePlayQueue::getTrack 0 May 20 17:11:19 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:11:23 volumio volumio[12815]: info: CoreCommandRouter::volumioGetState May 20 17:11:23 volumio volumio[12815]: info: CorePlayQueue::getTrack 0 May 20 17:11:23 volumio volumio[12815]: info: Listing playlists May 20 17:11:23 volumio volumio[12815]: info: Listing playlists May 20 17:11:27 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:11:33 volumio volumio[12815]: info: CoreCommandRouter::volumioGetState May 20 17:11:33 volumio volumio[12815]: info: CorePlayQueue::getTrack 0 May 20 17:11:34 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:11:42 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:11:43 volumio volumio[12815]: info: CoreCommandRouter::volumioGetState May 20 17:11:43 volumio volumio[12815]: info: CorePlayQueue::getTrack 0 May 20 17:11:43 volumio volumio[12815]: info: Listing playlists May 20 17:11:43 volumio volumio[12815]: info: Listing playlists May 20 17:11:50 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:11:53 volumio volumio[12815]: info: CoreCommandRouter::volumioGetState May 20 17:11:53 volumio volumio[12815]: info: CorePlayQueue::getTrack 0 May 20 17:11:58 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:12:03 volumio volumio[12815]: info: CoreCommandRouter::volumioGetState May 20 17:12:03 volumio volumio[12815]: info: CorePlayQueue::getTrack 0 May 20 17:12:03 volumio volumio[12815]: info: Listing playlists May 20 17:12:03 volumio volumio[12815]: info: Listing playlists May 20 17:12:06 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:12:13 volumio volumio[12815]: info: CoreCommandRouter::volumioGetState May 20 17:12:13 volumio volumio[12815]: info: CorePlayQueue::getTrack 0 May 20 17:12:13 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:12:21 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:12:23 volumio volumio[12815]: info: CoreCommandRouter::volumioGetState May 20 17:12:23 volumio volumio[12815]: info: CorePlayQueue::getTrack 0 May 20 17:12:23 volumio volumio[12815]: info: Listing playlists May 20 17:12:23 volumio volumio[12815]: info: Listing playlists May 20 17:12:28 volumio dhcpcd[1191]: eth0: carrier lost May 20 17:12:28 volumio dhcpcd[1238]: eth0: carrier lost May 20 17:12:28 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Down May 20 17:12:28 volumio dhcpcd[1191]: eth0: deleting route to 192.168.1.0/24 May 20 17:12:28 volumio avahi-daemon[637]: Withdrawing address record for 192.168.1.7 on eth0. May 20 17:12:28 volumio avahi-daemon[637]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.7. May 20 17:12:28 volumio dhcpcd[1191]: eth0: deleting default route via 192.168.1.1 May 20 17:12:28 volumio avahi-daemon[637]: Interface eth0.IPv4 no longer relevant for mDNS. May 20 17:12:28 volumio volumio[12815]: info: Discovery: A device disappeared from network May 20 17:12:28 volumio volumio[12815]: info: Discovery: Device volumio disappeared from network May 20 17:12:28 volumio dhcpcd[1238]: eth0: deleting route to 192.168.1.0/24 May 20 17:12:28 volumio dhcpcd[1238]: eth0: deleting default route via 192.168.1.1 May 20 17:12:29 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:12:29 volumio ifplugd(eth0)[785]: Link beat lost. May 20 17:12:30 volumio ntpd[786]: Deleting interface #11 eth0, 192.168.1.7#123, interface stats: received=149, sent=159, dropped=0, active_time=11706 secs May 20 17:12:30 volumio ntpd[786]: 221.151.118.78 local addr 192.168.1.7 -> May 20 17:12:30 volumio ntpd[786]: 106.247.248.106 local addr 192.168.1.7 -> May 20 17:12:30 volumio ntpd[786]: 175.195.167.194 local addr 192.168.1.7 -> May 20 17:12:30 volumio ntpd[786]: 158.247.202.103 local addr 192.168.1.7 -> May 20 17:12:30 volumio ntpd[786]: 194.0.5.123 local addr 192.168.1.7 -> May 20 17:12:30 volumio ntpd[786]: 121.174.142.82 local addr 192.168.1.7 -> May 20 17:12:30 volumio ntpd[786]: 193.123.243.2 local addr 192.168.1.7 -> May 20 17:12:30 volumio ntpd[786]: 121.174.142.81 local addr 192.168.1.7 -> May 20 17:12:31 volumio dhcpcd[1238]: eth0: carrier acquired May 20 17:12:31 volumio dhcpcd[1191]: eth0: carrier acquired May 20 17:12:31 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx May 20 17:12:31 volumio dhcpcd[1238]: eth0: IAID 32:70:fa:ab May 20 17:12:31 volumio dhcpcd[1191]: eth0: IAID 32:70:fa:ab May 20 17:12:31 volumio dhcpcd[1191]: eth0: rebinding lease of 192.168.1.7 May 20 17:12:31 volumio dhcpcd[1191]: eth0: soliciting an IPv6 router May 20 17:12:32 volumio dhcpcd[1238]: eth0: rebinding lease of 192.168.1.7 May 20 17:12:32 volumio dhcpcd[1238]: eth0: soliciting an IPv6 router May 20 17:12:32 volumio ifplugd(eth0)[785]: Link beat detected. May 20 17:12:33 volumio volumio[12815]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 17:12:33 volumio volumio[12815]: Error: send ENETUNREACH 255.255.255.255:3483 May 20 17:12:33 volumio volumio[12815]: at doSend (dgram.js:692:16) May 20 17:12:33 volumio volumio[12815]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) May 20 17:12:33 volumio volumio[12815]: at afterDns (dgram.js:638:5) May 20 17:12:33 volumio volumio[12815]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { May 20 17:12:33 volumio volumio[12815]: errno: -101, May 20 17:12:33 volumio volumio[12815]: code: 'ENETUNREACH', May 20 17:12:33 volumio volumio[12815]: syscall: 'send', May 20 17:12:33 volumio volumio[12815]: address: '255.255.255.255', May 20 17:12:33 volumio volumio[12815]: port: 3483 May 20 17:12:33 volumio volumio[12815]: } May 20 17:12:33 volumio volumio[12815]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 17:12:33 volumio dhcpcd[1238]: eth0: carrier lost May 20 17:12:33 volumio dhcpcd[1191]: eth0: carrier lost May 20 17:12:33 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Down May 20 17:12:34 volumio sudo[21339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-20 17:11 May 20 17:12:34 volumio sudo[21339]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 17:12:34 volumio ifplugd(eth0)[785]: Link beat lost. May 20 17:12:34 volumio sudo[21339]: pam_unix(sudo:session): session closed for user root May 20 17:12:34 volumio volumio-remote-updater[614]: [2025-05-20 17:12:34] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 20 17:12:34 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 20 17:12:34 volumio volumio-remote-updater[614]: [2025-05-20 17:12:34] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 20 17:12:34 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. May 20 17:12:35 volumio systemd[1]: Started dynamicswap service. May 20 17:12:35 volumio systemd[1]: dynamicswap.service: Succeeded. May 20 17:12:35 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 20 17:12:35 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 11. May 20 17:12:35 volumio systemd[1]: Stopped Volumio Backend Module. May 20 17:12:35 volumio systemd[1]: Started Volumio Backend Module. May 20 17:12:35 volumio systemd[1]: Started dynamicswap service. May 20 17:12:35 volumio systemd[1]: dynamicswap.service: Succeeded. May 20 17:12:36 volumio dhcpcd[1238]: eth0: carrier acquired May 20 17:12:36 volumio dhcpcd[1191]: eth0: carrier acquired May 20 17:12:36 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx May 20 17:12:36 volumio dhcpcd[1191]: eth0: IAID 32:70:fa:ab May 20 17:12:36 volumio dhcpcd[1238]: eth0: IAID 32:70:fa:ab May 20 17:12:37 volumio dhcpcd[1191]: eth0: soliciting an IPv6 router May 20 17:12:37 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:12:37 volumio dhcpcd[1238]: eth0: rebinding lease of 192.168.1.7 May 20 17:12:37 volumio dhcpcd[1238]: eth0: soliciting an IPv6 router May 20 17:12:37 volumio dhcpcd[1191]: eth0: rebinding lease of 192.168.1.7 May 20 17:12:37 volumio dhcpcd[1191]: eth0: probing address 192.168.1.7/24 May 20 17:12:37 volumio ifplugd(eth0)[785]: Link beat detected. May 20 17:12:37 volumio volumio[21353]: info: ------------------------------------------- May 20 17:12:37 volumio volumio[21353]: info: ----- Volumio3 ---- May 20 17:12:37 volumio volumio[21353]: info: ------------------------------------------- May 20 17:12:37 volumio volumio[21353]: info: ----- System startup ---- May 20 17:12:37 volumio volumio[21353]: info: ------------------------------------------- May 20 17:12:39 volumio volumio[21353]: info: MYVOLUMIO Environment detected May 20 17:12:39 volumio volumio[21353]: info: Plugin folders cleanup May 20 17:12:39 volumio volumio[21353]: info: Scanning into folder /volumio/app/plugins/ May 20 17:12:39 volumio volumio[21353]: info: Scanning category audio_interface May 20 17:12:39 volumio volumio[21353]: info: Scanning category miscellanea May 20 17:12:39 volumio volumio[21353]: info: Scanning category music_service May 20 17:12:39 volumio volumio[21353]: info: Scanning category plugins.json May 20 17:12:39 volumio volumio[21353]: info: Scanning category system_controller May 20 17:12:39 volumio volumio[21353]: info: Scanning category user_interface May 20 17:12:39 volumio volumio[21353]: info: Scanning into folder /data/plugins/ May 20 17:12:39 volumio volumio[21353]: info: Scanning category music_service May 20 17:12:39 volumio volumio[21353]: info: Plugin folders cleanup completed May 20 17:12:39 volumio volumio[21353]: info: ------------------------------------------- May 20 17:12:39 volumio volumio[21353]: info: ----- Core plugins startup ---- May 20 17:12:39 volumio volumio[21353]: info: ------------------------------------------- May 20 17:12:39 volumio volumio[21353]: info: Loading plugins from folder /volumio/app/plugins/ May 20 17:12:39 volumio volumio[21353]: info: Adding plugin upnp to MyMusic Plugins May 20 17:12:39 volumio volumio[21353]: info: Adding plugin airplay_emulation to MyMusic Plugins May 20 17:12:39 volumio volumio[21353]: info: Adding plugin upnp_browser to MyMusic Plugins May 20 17:12:39 volumio volumio[21353]: info: Loading plugins from folder /data/plugins/ May 20 17:12:39 volumio volumio[21353]: info: Loading plugin "system"... May 20 17:12:39 volumio volumio[21353]: info: Loading plugin "appearance"... May 20 17:12:39 volumio volumio-remote-updater[614]: [2025-05-20 17:12:39] [connect] Successful connection May 20 17:12:40 volumio volumio[21353]: info: Loading plugin "network"... May 20 17:12:40 volumio volumio[21353]: info: Refreshing Cached IP Addresses May 20 17:12:40 volumio sudo[21382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 20 17:12:40 volumio sudo[21382]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 17:12:40 volumio sudo[21382]: pam_unix(sudo:session): session closed for user root May 20 17:12:40 volumio volumio[21353]: info: Loading plugin "services"... May 20 17:12:40 volumio sudo[21384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 20 17:12:40 volumio sudo[21384]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 17:12:40 volumio volumio[21353]: info: Loading plugin "alsa_controller"... May 20 17:12:40 volumio sudo[21384]: pam_unix(sudo:session): session closed for user root May 20 17:12:40 volumio sudo[21387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 20 17:12:40 volumio sudo[21387]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 17:12:41 volumio volumio[21353]: warn: Unable to locate the audio output device FiiO K11 R2R. Please configure a valid output device. May 20 17:12:41 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 20 17:12:41 volumio volumio[21353]: info: Loading plugin "wizard"... May 20 17:12:41 volumio dhcpcd[1191]: eth0: carrier lost May 20 17:12:41 volumio dhcpcd[1238]: eth0: carrier lost May 20 17:12:41 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Down May 20 17:12:41 volumio volumio[21353]: info: Loading plugin "networkfs"... May 20 17:12:41 volumio volumio[21353]: info: Starting Udev Watcher for removable devices May 20 17:12:41 volumio volumio[21353]: info: Ignoring mount for partition: boot May 20 17:12:41 volumio volumio[21353]: info: Ignoring mount for partition: volumio May 20 17:12:41 volumio volumio[21353]: info: Ignoring mount for partition: volumio_data May 20 17:12:41 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 20 17:12:41 volumio volumio[21353]: info: Loading plugin "volumio_command_line_client"... May 20 17:12:41 volumio volumio[21353]: info: Loading plugin "upnp"... May 20 17:12:41 volumio volumio[21353]: info: [1747728761188] Starting Upmpd Daemon May 20 17:12:41 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 20 17:12:41 volumio volumio[21353]: info: Loading plugin "my_music"... May 20 17:12:41 volumio volumio[21353]: info: Loading plugin "mpd"... May 20 17:12:41 volumio volumio[21353]: info: Loading plugin "upnp_browser"... May 20 17:12:41 volumio ifplugd(eth0)[785]: Link beat lost. May 20 17:12:42 volumio volumio[21353]: info: Loading plugin "alarm-clock"... May 20 17:12:42 volumio volumio[21353]: info: Loading plugin "airplay_emulation"... May 20 17:12:42 volumio volumio[21353]: info: Starting Shairport Sync May 20 17:12:42 volumio volumio[21353]: info: Loading plugin "last_100"... May 20 17:12:42 volumio volumio[21353]: info: Loading plugin "webradio"... May 20 17:12:42 volumio volumio[21353]: info: Loading plugin "i2s_dacs"... May 20 17:12:42 volumio volumio[21353]: info: I2S DAC not set, start Auto-detection May 20 17:12:42 volumio volumio[21353]: info: Loading plugin "volumiodiscovery"... May 20 17:12:42 volumio volumio[21353]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 20 17:12:42 volumio volumio[21353]: *** WARNING *** Please fix your application to use the native API of Avahi! May 20 17:12:42 volumio node[21353]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 20 17:12:42 volumio volumio[21353]: *** WARNING *** For more information see May 20 17:12:42 volumio volumio[21353]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 20 17:12:42 volumio volumio[21353]: *** WARNING *** Please fix your application to use the native API of Avahi! May 20 17:12:42 volumio volumio[21353]: *** WARNING *** For more information see May 20 17:12:42 volumio node[21353]: *** WARNING *** Please fix your application to use the native API of Avahi! May 20 17:12:42 volumio node[21353]: *** WARNING *** For more information see May 20 17:12:42 volumio node[21353]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 20 17:12:42 volumio node[21353]: *** WARNING *** Please fix your application to use the native API of Avahi! May 20 17:12:42 volumio node[21353]: *** WARNING *** For more information see May 20 17:12:42 volumio volumio[21353]: info: Applying required configuration parameters for plugin volumiodiscovery May 20 17:12:42 volumio volumio[21353]: info: Discovery: Started advertising with name: Volumio May 20 17:12:42 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 20 17:12:42 volumio volumio[21353]: info: Loading plugin "squeezelite_mc"... May 20 17:12:43 volumio sudo[21387]: pam_unix(sudo:session): session closed for user root May 20 17:12:43 volumio volumio[21353]: info: Loading plugin "outputs"... May 20 17:12:44 volumio volumio[21353]: info: Loading plugin "albumart"... May 20 17:12:44 volumio volumio[21353]: info: Plugin example_plugin is not enabled May 20 17:12:44 volumio volumio[21353]: info: Loading plugin "inputs"... May 20 17:12:44 volumio volumio[21353]: info: Loading plugin "updater_comm"... May 20 17:12:44 volumio volumio[21353]: info: Plugin mpdemulation is not enabled May 20 17:12:44 volumio volumio[21353]: info: Loading plugin "rest_api"... May 20 17:12:44 volumio volumio[21353]: info: Loading plugin "websocket"... May 20 17:12:44 volumio volumio[21353]: info: Starting Socket.io Server version 2.3.0 May 20 17:12:44 volumio volumio[21353]: info: Loading plugin "personal_radio"... May 20 17:12:44 volumio volumio[21353]: Forking 3 albumart workers May 20 17:12:45 volumio dhcpcd[1191]: eth0: carrier acquired May 20 17:12:45 volumio dhcpcd[1238]: eth0: carrier acquired May 20 17:12:45 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx May 20 17:12:45 volumio dhcpcd[1191]: eth0: IAID 32:70:fa:ab May 20 17:12:45 volumio dhcpcd[1238]: eth0: IAID 32:70:fa:ab May 20 17:12:45 volumio dhcpcd[1191]: eth0: rebinding lease of 192.168.1.7 May 20 17:12:45 volumio dhcpcd[1191]: eth0: probing address 192.168.1.7/24 May 20 17:12:45 volumio volumio[21353]: info: ControllerPersonalRadio::constructor May 20 17:12:45 volumio dhcpcd[1238]: eth0: rebinding lease of 192.168.1.7 May 20 17:12:45 volumio dhcpcd[1238]: eth0: probing address 192.168.1.7/24 May 20 17:12:45 volumio volumio[21353]: info: Loading i18n strings for locale ko May 20 17:12:45 volumio volumio[21353]: Updating browse sources language May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 20 17:12:45 volumio dhcpcd[1191]: eth0: soliciting an IPv6 router May 20 17:12:45 volumio dhcpcd[1238]: eth0: soliciting an IPv6 router May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::initPlayerControls May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 17:12:45 volumio volumio[21353]: Express server listening on port 3000 May 20 17:12:45 volumio volumio[21353]: [Metrics] WebUI: 8s 636.53ms May 20 17:12:45 volumio volumio[21353]: info: CoreStateMachine::resetVolumioState May 20 17:12:45 volumio volumio[21353]: info: CoreStateMachine::getcurrentVolume May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::volumioRetrievevolume May 20 17:12:45 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 17:12:45 volumio ifplugd(eth0)[785]: Link beat detected. May 20 17:12:46 volumio volumio[21353]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. May 20 17:12:46 volumio volumio[21353]: Starting albumart workers May 20 17:12:46 volumio volumio[21353]: info: VolumeController:: Volume=undefined Mute =false May 20 17:12:46 volumio volumio[21353]: info: CoreStateMachine::pushState May 20 17:12:46 volumio volumio[21353]: info: CorePlayQueue::getTrack 0 May 20 17:12:46 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 17:12:46 volumio volumio[21353]: info: CoreCommandRouter::volumioPushState May 20 17:12:46 volumio volumio[21353]: info: CoreStateMachine::updateTrackBlock May 20 17:12:46 volumio volumio[21353]: info: CorePlayQueue::getTrackBlock May 20 17:12:46 volumio volumio[21353]: info: CoreCommandRouter::volumioRetrievevolume May 20 17:12:46 volumio volumio[21353]: Starting albumart workers May 20 17:12:46 volumio wpa_supplicant[1063]: wlan0: Failed to initiate sched scan May 20 17:12:46 volumio volumio[21353]: Starting albumart workers May 20 17:12:46 volumio volumio[21353]: info: Reloading queue from file May 20 17:12:46 volumio volumio[21353]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. May 20 17:12:46 volumio volumio[21353]: info: CoreStateMachine::setRepeat null single undefined May 20 17:12:46 volumio volumio[21353]: info: CoreStateMachine::pushState May 20 17:12:46 volumio volumio[21353]: info: CorePlayQueue::getTrack 0 May 20 17:12:46 volumio volumio[21353]: info: CoreCommandRouter::volumioPushState May 20 17:12:46 volumio volumio[21353]: info: CoreStateMachine::setRandom null May 20 17:12:46 volumio volumio[21353]: info: CoreStateMachine::pushState May 20 17:12:46 volumio volumio[21353]: info: CorePlayQueue::getTrack 0 May 20 17:12:46 volumio volumio[21353]: info: CoreCommandRouter::volumioPushState May 20 17:12:46 volumio volumio[21353]: info: Setting Device type: Raspberry PI May 20 17:12:46 volumio volumio[21353]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb May 20 17:12:46 volumio volumio[21353]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 May 20 17:12:46 volumio volumio[21353]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI May 20 17:12:46 volumio volumio[21353]: info: VolumeController:: Volume=undefined Mute =false May 20 17:12:46 volumio volumio[21353]: info: CoreStateMachine::pushState May 20 17:12:46 volumio volumio[21353]: info: CorePlayQueue::getTrack 0 May 20 17:12:46 volumio volumio[21353]: info: CoreCommandRouter::volumioPushState May 20 17:12:46 volumio volumio[21353]: info: Discovery: adding 07cef708-92f5-466e-93d8-6cfd4f8a805f May 20 17:12:46 volumio volumio[21353]: info: Discovery: Found device Volumio May 20 17:12:46 volumio volumio[21353]: info: CoreCommandRouter::volumioGetState May 20 17:12:46 volumio volumio[21353]: info: CorePlayQueue::getTrack 0 May 20 17:12:46 volumio volumio[21353]: info: Completed loading Core Plugins May 20 17:12:46 volumio volumio[21353]: info: Preparing to generate the ALSA configuration file May 20 17:12:46 volumio volumio[21353]: info: Asound.conf file unchanged, so no further update is needed May 20 17:12:46 volumio volumio[21353]: info: Output device has changed, restarting MPD May 20 17:12:47 volumio volumio[21353]: info: Output device has changed, restarting Shairport Sync May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 17:12:47 volumio sudo[21478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 20 17:12:47 volumio sudo[21478]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 17:12:47 volumio sudo[21478]: pam_unix(sudo:session): session closed for user root May 20 17:12:47 volumio sudo[21480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 20 17:12:47 volumio sudo[21480]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 17:12:47 volumio volumio[21353]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 20 17:12:47 volumio volumio[21353]: info: ___________ START PLUGINS ___________ May 20 17:12:47 volumio volumio[21353]: info: ControllerMpd::onStart: Initializing MPD May 20 17:12:47 volumio systemd[1]: Stopping Music Player Daemon... May 20 17:12:47 volumio volumio[21353]: info: Creating MPD Configuration file May 20 17:12:47 volumio systemd[1]: mpd.service: Succeeded. May 20 17:12:47 volumio systemd[1]: Stopped Music Player Daemon. May 20 17:12:47 volumio systemd[1]: Starting Music Player Daemon... May 20 17:12:47 volumio sudo[21488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 20 17:12:47 volumio sudo[21488]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 17:12:47 volumio sudo[21488]: pam_unix(sudo:session): session closed for user root May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 20 17:12:47 volumio volumio[21353]: info: [1747728767553] CoreMusicLibrary::Adding element 미디어 서버 May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 17:12:47 volumio sudo[21487]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 20 17:12:47 volumio sudo[21487]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 17:12:47 volumio sudo[21496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 20 17:12:47 volumio sudo[21496]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 17:12:47 volumio sudo[21487]: pam_unix(sudo:session): session closed for user root May 20 17:12:47 volumio volumio[21353]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 20 17:12:47 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 20 17:12:47 volumio systemd[1]: mpd.service: Succeeded. May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 17:12:47 volumio systemd[1]: Stopped Music Player Daemon. May 20 17:12:47 volumio systemd[1]: Starting Music Player Daemon... May 20 17:12:47 volumio volumio[21353]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 20 17:12:47 volumio volumio[21353]: info: [1747728767966] CoreMusicLibrary::Adding element Last_100 May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 20 17:12:47 volumio volumio[21353]: info: [1747728767970] CoreMusicLibrary::Adding element Webradio May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 20 17:12:47 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 20 17:12:47 volumio volumio[21353]: info: Initializing BBC Radios May 20 17:12:48 volumio sudo[21523]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 20 17:12:48 volumio sudo[21523]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 17:12:48 volumio sudo[21523]: pam_unix(sudo:session): session closed for user root May 20 17:12:48 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 20 17:12:48 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 17:12:48 volumio volumio[21353]: info: [squeezelite_mc] Starting proxy server... May 20 17:12:48 volumio volumio[21353]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 20 17:12:48 volumio volumio[21353]: info: [1747728768359] CoreMusicLibrary::Adding element 개인 라디오 May 20 17:12:48 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 20 17:12:48 volumio volumio[21353]: Cannot find translation for source 개인 라디오 May 20 17:12:48 volumio volumio[21353]: info: Volumio Calling Home May 20 17:12:48 volumio volumio[21353]: info: [squeezelite_mc] Proxy server started on port 33769 May 20 17:12:48 volumio volumio[21353]: info: CoreCommandRouter::volumioRetrievevolume May 20 17:12:48 volumio volumio[21353]: Unhandled rejection Error: No sockets available, cannot start. May 20 17:12:48 volumio volumio[21353]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) May 20 17:12:48 volumio volumio[21353]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) May 20 17:12:48 volumio volumio[21353]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 May 20 17:12:48 volumio volumio[21353]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) May 20 17:12:48 volumio volumio[21353]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) May 20 17:12:48 volumio volumio[21353]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) May 20 17:12:48 volumio volumio[21353]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) May 20 17:12:48 volumio volumio[21353]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) May 20 17:12:48 volumio volumio[21353]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) May 20 17:12:48 volumio volumio[21353]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) May 20 17:12:48 volumio volumio[21353]: at HashMap. (/volumio/app/pluginmanager.js:496:31) May 20 17:12:48 volumio volumio[21353]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) May 20 17:12:48 volumio volumio[21353]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) May 20 17:12:48 volumio volumio[21353]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) May 20 17:12:48 volumio volumio[21353]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) May 20 17:12:48 volumio volumio[21353]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 20 17:12:48 volumio volumio[21353]: info: ControllerPersonalRadio:fetchRadioUrl Error: FetchError: request to https://raw.githubusercontent.com/ChrisPanda/volumio-kradio-key/master/radiokey.json failed, reason: getaddrinfo ENOTFOUND raw.githubusercontent.com May 20 17:12:48 volumio volumio[21353]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. May 20 17:12:48 volumio volumio[21353]: info: MPD Permissions set May 20 17:12:48 volumio volumio[21353]: info: MPD Permissions set May 20 17:12:48 volumio volumio[21353]: info: VolumeController:: Volume=undefined Mute =false May 20 17:12:48 volumio volumio[21353]: info: CoreStateMachine::pushState May 20 17:12:48 volumio volumio[21353]: info: CorePlayQueue::getTrack 0 May 20 17:12:48 volumio volumio[21353]: info: CoreCommandRouter::volumioPushState May 20 17:12:48 volumio volumio[21353]: info: [squeezelite_mc] Server discovery started May 20 17:12:48 volumio volumio[21353]: info: [squeezelite_mc] Player finder started May 20 17:12:48 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:48 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:48 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 17:12:48 volumio volumio[21353]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 17:12:48 volumio volumio[21353]: info: [squeezelite_mc] Executing aplay -D hw:3 --nonblock -f MPEG /dev/zero 2>&1 || true May 20 17:12:48 volumio volumio[21353]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 17:12:48 volumio volumio[21353]: Error: send ENETUNREACH 255.255.255.255:3483 May 20 17:12:48 volumio volumio[21353]: at doSend (dgram.js:692:16) May 20 17:12:48 volumio volumio[21353]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) May 20 17:12:48 volumio volumio[21353]: at afterDns (dgram.js:638:5) May 20 17:12:48 volumio volumio[21353]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { May 20 17:12:48 volumio volumio[21353]: errno: -101, May 20 17:12:48 volumio volumio[21353]: code: 'ENETUNREACH', May 20 17:12:48 volumio volumio[21353]: syscall: 'send', May 20 17:12:48 volumio volumio[21353]: address: '255.255.255.255', May 20 17:12:48 volumio volumio[21353]: port: 3483 May 20 17:12:48 volumio volumio[21353]: } May 20 17:12:48 volumio volumio[21353]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 17:12:49 volumio dhcpcd[1238]: eth0: leased 192.168.1.7 for 86400 seconds May 20 17:12:49 volumio avahi-daemon[637]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.7. May 20 17:12:49 volumio avahi-daemon[637]: New relevant interface eth0.IPv4 for mDNS. May 20 17:12:49 volumio dhcpcd[1238]: eth0: adding route to 192.168.1.0/24 May 20 17:12:49 volumio dhcpcd[1238]: eth0: adding default route via 192.168.1.1 May 20 17:12:49 volumio avahi-daemon[637]: Registering new address record for 192.168.1.7 on eth0.IPv4. May 20 17:12:49 volumio sudo[21576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-20 17:11 May 20 17:12:49 volumio sudo[21576]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"