-- Logs begin at Thu 2019-02-14 19:11:59 JST, end at Sun 2024-10-06 03:17:27 JST. -- Oct 06 03:16:01 volumio volumio[6822]: info: ------------------------------------------- Oct 06 03:16:01 volumio volumio[6822]: info: ----- Volumio3 ---- Oct 06 03:16:01 volumio volumio[6822]: info: ------------------------------------------- Oct 06 03:16:01 volumio volumio[6822]: info: ----- System startup ---- Oct 06 03:16:01 volumio volumio[6822]: info: ------------------------------------------- Oct 06 03:16:02 volumio volumio[6822]: info: MYVOLUMIO Environment detected Oct 06 03:16:02 volumio volumio[6822]: info: Plugin folders cleanup Oct 06 03:16:02 volumio volumio[6822]: info: Scanning into folder /volumio/app/plugins/ Oct 06 03:16:02 volumio volumio[6822]: info: Scanning category audio_interface Oct 06 03:16:02 volumio volumio[6822]: info: Scanning category miscellanea Oct 06 03:16:02 volumio volumio[6822]: info: Scanning category music_service Oct 06 03:16:02 volumio volumio[6822]: info: Scanning category plugins.json Oct 06 03:16:02 volumio volumio[6822]: info: Scanning category system_controller Oct 06 03:16:02 volumio volumio[6822]: info: Scanning category user_interface Oct 06 03:16:02 volumio volumio[6822]: info: Scanning into folder /data/plugins/ Oct 06 03:16:02 volumio volumio[6822]: info: Scanning category music_service Oct 06 03:16:02 volumio volumio[6822]: info: Plugin folders cleanup completed Oct 06 03:16:02 volumio volumio[6822]: info: ------------------------------------------- Oct 06 03:16:02 volumio volumio[6822]: info: ----- Core plugins startup ---- Oct 06 03:16:02 volumio volumio[6822]: info: ------------------------------------------- Oct 06 03:16:02 volumio volumio[6822]: info: Loading plugins from folder /volumio/app/plugins/ Oct 06 03:16:02 volumio volumio[6822]: info: Adding plugin upnp to MyMusic Plugins Oct 06 03:16:02 volumio volumio[6822]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 06 03:16:02 volumio volumio[6822]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 06 03:16:02 volumio volumio[6822]: info: Loading plugins from folder /data/plugins/ Oct 06 03:16:02 volumio volumio[6822]: info: Loading plugin "system"... Oct 06 03:16:02 volumio volumio[6822]: info: Loading plugin "appearance"... Oct 06 03:16:02 volumio dhcpcd[1138]: wlan0: using IPv4LL address 169.254.97.89 Oct 06 03:16:02 volumio avahi-daemon[494]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.97.89. Oct 06 03:16:02 volumio avahi-daemon[494]: New relevant interface wlan0.IPv4 for mDNS. Oct 06 03:16:02 volumio dhcpcd[1138]: wlan0: adding route to 169.254.0.0/16 Oct 06 03:16:02 volumio avahi-daemon[494]: Registering new address record for 169.254.97.89 on wlan0.IPv4. Oct 06 03:16:02 volumio dhcpcd[1138]: wlan0: adding default route Oct 06 03:16:02 volumio dhcpcd[1138]: wlan0: leased 192.168.3.7 for 86400 seconds Oct 06 03:16:03 volumio volumio[6822]: info: Loading plugin "network"... Oct 06 03:16:03 volumio volumio[6822]: info: Refreshing Cached IP Addresses Oct 06 03:16:03 volumio volumio[6822]: info: Loading plugin "services"... Oct 06 03:16:03 volumio volumio[6822]: info: Loading plugin "alsa_controller"... Oct 06 03:16:03 volumio volumio[6822]: info: Loading plugin "wizard"... Oct 06 03:16:03 volumio volumio[6822]: info: Loading plugin "volumio_command_line_client"... Oct 06 03:16:03 volumio volumio[6822]: info: Loading plugin "upnp"... Oct 06 03:16:03 volumio volumio[6822]: info: [1728152163576] Starting Upmpd Daemon Oct 06 03:16:03 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 06 03:16:03 volumio volumio[6822]: info: Loading plugin "my_music"... Oct 06 03:16:03 volumio volumio[6822]: info: Loading plugin "mpd"... Oct 06 03:16:03 volumio volumio[6822]: info: Creating MPD Configuration file Oct 06 03:16:03 volumio volumio[6822]: info: Loading plugin "upnp_browser"... Oct 06 03:16:04 volumio avahi-daemon[494]: Registering new address record for 192.168.3.7 on wlan0.IPv4. Oct 06 03:16:04 volumio dhcpcd[1138]: wlan0: adding route to 192.168.3.0/24 Oct 06 03:16:04 volumio dhcpcd[1138]: wlan0: changing default route via 192.168.3.1 Oct 06 03:16:04 volumio sudo[6860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 03:16:04 volumio sudo[6860]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:04 volumio sudo[6868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 06 03:16:04 volumio sudo[6858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 03:16:04 volumio sudo[6868]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:04 volumio sudo[6862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 06 03:16:04 volumio sudo[6862]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:04 volumio sudo[6868]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:04 volumio sudo[6870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 06 03:16:04 volumio sudo[6870]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:04 volumio sudo[6858]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:04 volumio sudo[6860]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:04 volumio systemd[1]: Stopping Music Player Daemon... Oct 06 03:16:04 volumio sudo[6858]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:04 volumio volumio[6822]: info: Loading plugin "networkfs"... Oct 06 03:16:04 volumio systemd[1]: mpd.service: Succeeded. Oct 06 03:16:04 volumio systemd[1]: Stopped Music Player Daemon. Oct 06 03:16:04 volumio systemd[1]: Starting Music Player Daemon... Oct 06 03:16:04 volumio avahi-daemon[494]: Withdrawing address record for 169.254.97.89 on wlan0. Oct 06 03:16:04 volumio avahi-daemon[494]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.97.89. Oct 06 03:16:04 volumio avahi-daemon[494]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.7. Oct 06 03:16:04 volumio dhcpcd[1138]: wlan0: deleting route to 169.254.0.0/16 Oct 06 03:16:04 volumio volumio-remote-updater[485]: [2024-10-06 03:16:04] [connect] Successful connection Oct 06 03:16:04 volumio dhcpcd[1138]: wlan0: pid 1138 deleted default route via 192.168.3.1 Oct 06 03:16:04 volumio volumio[6822]: info: Starting Udev Watcher for removable devices Oct 06 03:16:04 volumio volumio[6822]: info: Ignoring mount for partition: boot Oct 06 03:16:04 volumio volumio[6822]: info: Ignoring mount for partition: volumio Oct 06 03:16:04 volumio volumio[6822]: info: Ignoring mount for partition: volumio_data Oct 06 03:16:04 volumio volumio[6822]: error: Cannot associate FS Label, not mounting Oct 06 03:16:04 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 06 03:16:04 volumio volumio[6822]: info: Loading plugin "alarm-clock"... Oct 06 03:16:05 volumio volumio[6822]: info: Loading plugin "airplay_emulation"... Oct 06 03:16:05 volumio volumio[6822]: info: Starting Shairport Sync Oct 06 03:16:05 volumio volumio[6822]: info: Loading plugin "last_100"... Oct 06 03:16:05 volumio volumio[6822]: info: Loading plugin "webradio"... Oct 06 03:16:05 volumio volumio[6822]: info: Loading plugin "i2s_dacs"... Oct 06 03:16:05 volumio volumio[6822]: info: Loading plugin "volumiodiscovery"... Oct 06 03:16:05 volumio volumio[6822]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 06 03:16:05 volumio volumio[6822]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 03:16:05 volumio node[6822]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 06 03:16:05 volumio volumio[6822]: *** WARNING *** For more information see Oct 06 03:16:05 volumio volumio[6822]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 06 03:16:05 volumio volumio[6822]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 03:16:05 volumio volumio[6822]: *** WARNING *** For more information see Oct 06 03:16:05 volumio node[6822]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 03:16:05 volumio node[6822]: *** WARNING *** For more information see Oct 06 03:16:05 volumio node[6822]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 06 03:16:05 volumio node[6822]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 03:16:05 volumio node[6822]: *** WARNING *** For more information see Oct 06 03:16:05 volumio volumio[6822]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 06 03:16:05 volumio volumio[6822]: info: Discovery: Started advertising with name: Volumio Oct 06 03:16:05 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 06 03:16:05 volumio volumio[6822]: info: Loading plugin "lmsde"... Oct 06 03:16:05 volumio volumio[6822]: info: Loading plugin "squeezelite_mc"... Oct 06 03:16:05 volumio mpd[6917]: Oct 06 03:16 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 06 03:16:05 volumio mpd[6917]: Oct 06 03:16 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Oct 06 03:16:05 volumio mpd[6917]: Oct 06 03:16 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Oct 06 03:16:06 volumio volumio[6822]: info: Loading plugin "youtube2"... Oct 06 03:16:06 volumio ntpd[930]: Listen normally on 6 wlan0 192.168.3.7:123 Oct 06 03:16:06 volumio ntpd[930]: new interface(s) found: waking up resolver Oct 06 03:16:06 volumio systemd[1]: Started Music Player Daemon. Oct 06 03:16:06 volumio sudo[6870]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:06 volumio sudo[6862]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:07 volumio volumio[6822]: info: Loading plugin "outputs"... Oct 06 03:16:07 volumio volumio[6822]: info: Loading plugin "albumart"... Oct 06 03:16:07 volumio volumio[6822]: info: Plugin example_plugin is not enabled Oct 06 03:16:07 volumio volumio[6822]: info: Loading plugin "inputs"... Oct 06 03:16:07 volumio volumio[6822]: info: Loading plugin "updater_comm"... Oct 06 03:16:08 volumio volumio[6822]: info: Plugin mpdemulation is not enabled Oct 06 03:16:08 volumio volumio[6822]: info: Loading plugin "rest_api"... Oct 06 03:16:08 volumio volumio[6822]: info: Loading plugin "websocket"... Oct 06 03:16:08 volumio volumio[6822]: info: Loading i18n strings for locale ja Oct 06 03:16:08 volumio volumio[6822]: Updating browse sources language Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::initPlayerControls Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: Express server listening on port 3000 Oct 06 03:16:08 volumio volumio[6822]: [Metrics] WebUI: 7s 271.44ms Oct 06 03:16:08 volumio volumio[6822]: info: CoreStateMachine::resetVolumioState Oct 06 03:16:08 volumio volumio[6822]: info: CoreStateMachine::getcurrentVolume Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::volumioRetrievevolume Oct 06 03:16:08 volumio volumio[6822]: Forking 3 albumart workers Oct 06 03:16:08 volumio volumio[6822]: info: MPD Permissions set Oct 06 03:16:08 volumio volumio-remote-updater[485]: [2024-10-06 03:16:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1728152164 101 Oct 06 03:16:08 volumio volumio[6822]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Oct 06 03:16:08 volumio volumio[6822]: info: MPD running with PID6917 Oct 06 03:16:08 volumio volumio[6822]: ,establishing connection Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:08 volumio volumio[6822]: info: Executing start script for DAC IQaudIO DAC Plus Oct 06 03:16:08 volumio volumio[6822]: info: Reloading queue from file Oct 06 03:16:08 volumio volumio[6822]: error: updateQueue error: null Oct 06 03:16:08 volumio volumio[6822]: info: CoreStateMachine::setRepeat false single undefined Oct 06 03:16:08 volumio volumio[6822]: info: CoreStateMachine::pushState Oct 06 03:16:08 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::volumioPushState Oct 06 03:16:08 volumio volumio[6822]: info: CoreStateMachine::setRandom null Oct 06 03:16:08 volumio volumio[6822]: info: CoreStateMachine::pushState Oct 06 03:16:08 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::volumioPushState Oct 06 03:16:08 volumio volumio[6822]: info: Setting Device type: Raspberry PI Oct 06 03:16:08 volumio volumio[6822]: info: DAC script executed Oct 06 03:16:08 volumio volumio[6822]: info: Completed loading Core Plugins Oct 06 03:16:08 volumio volumio[6822]: info: Preparing to generate the ALSA configuration file Oct 06 03:16:08 volumio volumio[6822]: info: VolumeController:: Volume=79 Mute =false Oct 06 03:16:08 volumio volumio[6822]: info: CoreStateMachine::pushState Oct 06 03:16:08 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::volumioPushState Oct 06 03:16:08 volumio volumio[6822]: info: CoreStateMachine::updateTrackBlock Oct 06 03:16:08 volumio volumio[6822]: info: CorePlayQueue::getTrackBlock Oct 06 03:16:08 volumio volumio[6822]: info: CoreCommandRouter::volumioRetrievevolume Oct 06 03:16:09 volumio volumio[6822]: error: updateQueue error: null Oct 06 03:16:09 volumio volumio[6822]: info: Discovery: adding 18bcd961-2cad-4825-9d0c-cefd458c8c21 Oct 06 03:16:09 volumio volumio[6822]: info: mDNS: Found device Volumio Oct 06 03:16:09 volumio volumio[6822]: Starting albumart workers Oct 06 03:16:09 volumio volumio[6822]: info: CoreCommandRouter::volumioGetState Oct 06 03:16:09 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:09 volumio volumio[6822]: info: Asound.conf file unchanged, so no further update is needed Oct 06 03:16:09 volumio volumio[6822]: info: Output device has changed, restarting MPD Oct 06 03:16:09 volumio volumio[6822]: Starting albumart workers Oct 06 03:16:09 volumio volumio[6822]: Starting albumart workers Oct 06 03:16:09 volumio volumio[6822]: info: Output device has changed, restarting Shairport Sync Oct 06 03:16:09 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:09 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:09 volumio sudo[6976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 06 03:16:09 volumio sudo[6976]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:09 volumio sudo[6977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 06 03:16:09 volumio sudo[6977]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:09 volumio sudo[6976]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:09 volumio volumio[6822]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 06 03:16:09 volumio volumio[6822]: info: ___________ START PLUGINS ___________ Oct 06 03:16:09 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 03:16:09 volumio volumio[6822]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 03:16:09 volumio volumio[6822]: info: [1728152169710] CoreMusicLibrary::Adding element Media Servers Oct 06 03:16:09 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 03:16:09 volumio volumio[6822]: Cannot find translation for sourceMedia Servers Oct 06 03:16:09 volumio systemd[1]: Stopping Music Player Daemon... Oct 06 03:16:09 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:09 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:09 volumio systemd[1]: mpd.service: Succeeded. Oct 06 03:16:09 volumio systemd[1]: Stopped Music Player Daemon. Oct 06 03:16:09 volumio systemd[1]: Starting Music Player Daemon... Oct 06 03:16:09 volumio volumio[6822]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 06 03:16:09 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:09 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:09 volumio volumio[6822]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 03:16:10 volumio volumio[6822]: info: [1728152170003] CoreMusicLibrary::Adding element Last_100 Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 03:16:10 volumio volumio[6822]: Cannot find translation for sourceMedia Servers Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 03:16:10 volumio volumio[6822]: info: [1728152170018] CoreMusicLibrary::Adding element Webradio Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 03:16:10 volumio volumio[6822]: Cannot find translation for sourceMedia Servers Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 06 03:16:10 volumio volumio[6822]: info: [lmsde] Executing script: /opt/lmsde/lms.sh start Oct 06 03:16:10 volumio volumio[6822]: info: [squeezelite_mc] Starting proxy server... Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 03:16:10 volumio volumio[6822]: info: [1728152170115] CoreMusicLibrary::Adding element YouTube2 Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 03:16:10 volumio volumio[6822]: Cannot find translation for sourceMedia Servers Oct 06 03:16:10 volumio volumio[6822]: Cannot find translation for sourceYouTube2 Oct 06 03:16:10 volumio volumio[6822]: info: Volumio Calling Home Oct 06 03:16:10 volumio volumio[6822]: info: [squeezelite_mc] Proxy server started on port 42273 Oct 06 03:16:10 volumio sudo[6993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/opt/lmsde/lms.sh start Oct 06 03:16:10 volumio sudo[6993]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::volumioRetrievevolume Oct 06 03:16:10 volumio volumio[6822]: info: Discovery: this is already registered, 18bcd961-2cad-4825-9d0c-cefd458c8c21 Oct 06 03:16:10 volumio volumio[6822]: info: mDNS: Found device Volumio Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::volumioGetState Oct 06 03:16:10 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:10 volumio volumio[6822]: info: MPD Permissions set Oct 06 03:16:10 volumio volumio[6822]: info: VolumeController:: Volume=79 Mute =false Oct 06 03:16:10 volumio volumio[6822]: info: CoreStateMachine::pushState Oct 06 03:16:10 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::volumioPushState Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:10 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:10 volumio volumio[6822]: info: Volumio called home Oct 06 03:16:10 volumio volumio[6822]: info: Starting Shairport Sync Oct 06 03:16:10 volumio volumio[6822]: info: Starting Shairport Sync Oct 06 03:16:10 volumio volumio[6822]: info: Starting Shairport Sync Oct 06 03:16:11 volumio volumio[6822]: info: VolumeController:: Volume=79 Mute =false Oct 06 03:16:11 volumio volumio[6822]: info: CoreStateMachine::pushState Oct 06 03:16:11 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:11 volumio volumio[6822]: info: CoreCommandRouter::volumioPushState Oct 06 03:16:11 volumio ntpd[930]: Soliciting pool server 129.250.35.250 Oct 06 03:16:11 volumio mpd[6995]: Oct 06 03:16 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 06 03:16:11 volumio volumio[6822]: info: [squeezelite_mc] Server discovery started Oct 06 03:16:11 volumio mpd[6995]: Oct 06 03:16 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Oct 06 03:16:11 volumio mpd[6995]: Oct 06 03:16 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Oct 06 03:16:11 volumio volumio[6822]: info: [squeezelite_mc] Player finder started Oct 06 03:16:11 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:11 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:11 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:11 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 03:16:11 volumio systemd[1]: Started Music Player Daemon. Oct 06 03:16:11 volumio sudo[7037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 06 03:16:11 volumio sudo[7037]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:11 volumio volumio[6822]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true Oct 06 03:16:11 volumio sudo[7034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 06 03:16:11 volumio sudo[6977]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:11 volumio sudo[7034]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:11 volumio sudo[7038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 06 03:16:11 volumio sudo[7038]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 06 03:16:11 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 06 03:16:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 06 03:16:11 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Oct 06 03:16:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 06 03:16:11 volumio sudo[7034]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:11 volumio volumio[6822]: info: [squeezelite_mc] Server discovered: {"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"} Oct 06 03:16:11 volumio sudo[7037]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:11 volumio sudo[7038]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:11 volumio volumio[6822]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Oct 06 03:16:11 volumio volumio[6822]: info: Shairport-Sync Started Oct 06 03:16:11 volumio volumio[6822]: Error adding Membership: Error: addMembership EINVAL Oct 06 03:16:11 volumio volumio[6822]: info: Shairport-Sync Started Oct 06 03:16:11 volumio volumio[6822]: info: [squeezelite_mc] Card 2 supports the following ALSA formats: ["S16_LE","S24_LE","S32_LE"] Oct 06 03:16:11 volumio volumio[6822]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"volumio","card":"2","mixerType":"Hardware","mixer":"Digital","dsdFormat":null} Oct 06 03:16:11 volumio volumio[6822]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Oct 06 03:16:12 volumio volumio[6822]: error: updateQueue error: null Oct 06 03:16:12 volumio volumio[6822]: info: Shairport-Sync Started Oct 06 03:16:12 volumio sudo[7053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Oct 06 03:16:12 volumio sudo[7053]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:12 volumio sudo[7053]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:12 volumio volumio[6822]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Oct 06 03:16:12 volumio volumio[6822]: info: CoreCommandRouter::volumioGetState Oct 06 03:16:12 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:12 volumio sudo[7057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Oct 06 03:16:12 volumio sudo[7057]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:12 volumio sudo[7057]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:12 volumio volumio[6822]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Oct 06 03:16:12 volumio sudo[7060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 06 03:16:12 volumio sudo[7060]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:12 volumio systemd[1]: Reloading. Oct 06 03:16:12 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Oct 06 03:16:12 volumio sudo[6993]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:12 volumio volumio[6822]: info: [lmsde] Executed /opt/lmsde/lms.sh start Oct 06 03:16:13 volumio volumio[6822]: info: [squeezelite_mc] Notification listener started Oct 06 03:16:13 volumio volumio[6822]: info: [squeezelite_mc] Getting players connected to volumio (192.168.3.7) Oct 06 03:16:13 volumio volumio[6822]: info: [squeezelite_mc] Players connected to volumio (192.168.3.7): [{"id":"b8:27:eb:ba:e8:23","uuid":null,"ip":"192.168.3.7","name":"volumio","server":{"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}}] Oct 06 03:16:13 volumio volumio[6822]: info: [squeezelite_mc] Player found: {"id":"b8:27:eb:ba:e8:23","uuid":null,"ip":"192.168.3.7","name":"volumio","server":{"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}} Oct 06 03:16:13 volumio sudo[7060]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:13 volumio volumio[6822]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 06 03:16:13 volumio systemd[1]: Starting Daily apt download activities... Oct 06 03:16:14 volumio volumio[6822]: info: CoreCommandRouter::volumioGetState Oct 06 03:16:14 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:14 volumio sudo[7085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 06 03:16:14 volumio sudo[7106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 03:16:14 volumio sudo[7106]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:14 volumio sudo[7103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 03:16:14 volumio sudo[7085]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:14 volumio sudo[7103]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:14 volumio sudo[7103]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:14 volumio sudo[7109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 06 03:16:14 volumio sudo[7109]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:14 volumio sudo[7106]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:14 volumio sudo[7109]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:14 volumio volumio[6822]: info: Upmpdcli Daemon Started Oct 06 03:16:14 volumio sudo[7085]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:14 volumio volumio[6822]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true Oct 06 03:16:14 volumio ntpd[930]: Soliciting pool server 122.215.240.51 Oct 06 03:16:14 volumio sudo[7115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite Oct 06 03:16:14 volumio sudo[7115]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:14 volumio systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Oct 06 03:16:14 volumio volumio[6822]: info: [squeezelite_mc] 'client' notification received from volumio (192.168.3.7); type is 'disconnect' Oct 06 03:16:14 volumio volumio[6822]: info: CoreCommandRouter::volumioGetState Oct 06 03:16:14 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:14 volumio systemd[1]: squeezelite.service: Succeeded. Oct 06 03:16:14 volumio systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Oct 06 03:16:14 volumio sudo[7115]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:15 volumio volumio[6822]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 06 03:16:15 volumio systemd[1]: apt-daily.service: Succeeded. Oct 06 03:16:15 volumio systemd[1]: Started Daily apt download activities. Oct 06 03:16:16 volumio sudo[7147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 06 03:16:16 volumio sudo[7147]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:16 volumio sudo[7147]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:16 volumio volumio[6822]: info: [squeezelite_mc] Executing rm /tmp/squeezelite.log Oct 06 03:16:16 volumio sudo[7151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /tmp/squeezelite.log Oct 06 03:16:16 volumio sudo[7151]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:16 volumio sudo[7151]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:16 volumio volumio[6822]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true Oct 06 03:16:16 volumio sudo[7154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Oct 06 03:16:16 volumio sudo[7154]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:16 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Oct 06 03:16:16 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Oct 06 03:16:16 volumio sudo[7154]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:16 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Oct 06 03:16:17 volumio volumio[6822]: info: [squeezelite_mc] 'client' notification received from volumio (192.168.3.7); type is 'connect' Oct 06 03:16:17 volumio volumio[6822]: info: [squeezelite_mc] Getting players connected to volumio (192.168.3.7) Oct 06 03:16:17 volumio volumio[6822]: info: [squeezelite_mc] Players connected to volumio (192.168.3.7): [{"id":"b8:27:eb:ba:e8:23","uuid":null,"ip":"192.168.3.7","name":"volumio","server":{"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}}] Oct 06 03:16:17 volumio volumio[6822]: info: [squeezelite_mc] Player found: {"id":"b8:27:eb:ba:e8:23","uuid":null,"ip":"192.168.3.7","name":"volumio","server":{"ip":"192.168.3.7","name":"volumio","ver":"8.2.1","uuid":"0898b45c-b024-47df-abd3-3ffd3a18f44f","jsonPort":"9000","cliPort":"9090"}} Oct 06 03:16:17 volumio volumio[6822]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 06 03:16:17 volumio sudo[7161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 06 03:16:17 volumio sudo[7161]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:17 volumio sudo[7161]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:18 volumio volumio[6822]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 06 03:16:18 volumio volumio[6822]: info: CoreCommandRouter::volumioGetState Oct 06 03:16:18 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:19 volumio sudo[7164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 06 03:16:19 volumio sudo[7164]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:19 volumio sudo[7164]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:19 volumio volumio[6822]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 06 03:16:19 volumio sudo[7167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 06 03:16:19 volumio sudo[7167]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:19 volumio sudo[7167]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:20 volumio volumio[6822]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 06 03:16:21 volumio sudo[7170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 06 03:16:21 volumio sudo[7170]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:21 volumio sudo[7170]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:22 volumio volumio[6822]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Oct 06 03:16:22 volumio sudo[7173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Oct 06 03:16:22 volumio sudo[7173]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:22 volumio sudo[7173]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:22 volumio volumio[6822]: info: Completed starting Core Plugins Oct 06 03:16:22 volumio volumio[6822]: info: ------------------------------------------- Oct 06 03:16:22 volumio volumio[6822]: info: ----- MyVolumio plugins startup ---- Oct 06 03:16:22 volumio volumio[6822]: info: ------------------------------------------- Oct 06 03:16:22 volumio volumio[6822]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 06 03:16:23 volumio ntpd[930]: Soliciting pool server 2400:8902::f03c:91ff:fe50:f5f0 Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 06 03:16:32 volumio volumio[6822]: info: Adding plugin bluetooth to MyMusic Plugins Oct 06 03:16:32 volumio volumio[6822]: info: Adding plugin multiroom to MyMusic Plugins Oct 06 03:16:32 volumio volumio[6822]: info: Adding plugin metavolumio to MyMusic Plugins Oct 06 03:16:32 volumio volumio[6822]: info: Adding plugin cd_controller to MyMusic Plugins Oct 06 03:16:32 volumio volumio[6822]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 06 03:16:32 volumio volumio[6822]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 06 03:16:32 volumio volumio[6822]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 06 03:16:33 volumio volumio[6822]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 06 03:16:33 volumio volumio[6822]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 06 03:16:33 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:33 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:33 volumio volumio[6822]: info: Starting MyVolumio Remote Streaming Endpoints Oct 06 03:16:33 volumio volumio[6822]: info: MyVolumio login type: Token Oct 06 03:16:33 volumio volumio[6822]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 06 03:16:33 volumio volumio[6822]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 06 03:16:33 volumio volumio[6822]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 06 03:16:33 volumio volumio[6822]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 06 03:16:33 volumio volumio[6822]: info: Streaming services startup Oct 06 03:16:33 volumio volumio[6822]: info: Starting Streaming Daemon Oct 06 03:16:34 volumio sudo[7178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 06 03:16:34 volumio sudo[7178]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:34 volumio systemd[1]: Stopping Volumio Streaming Daemon... Oct 06 03:16:34 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=killed, status=15/TERM Oct 06 03:16:34 volumio systemd[1]: volumio-streaming-daemon.service: Succeeded. Oct 06 03:16:34 volumio systemd[1]: Stopped Volumio Streaming Daemon. Oct 06 03:16:34 volumio systemd[1]: Started Volumio Streaming Daemon. Oct 06 03:16:34 volumio sudo[7178]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:34 volumio volumio-streaming-daemon[7184]: ############################ Oct 06 03:16:34 volumio volumio-streaming-daemon[7184]: # Volumio Streaming Daemon # Oct 06 03:16:34 volumio volumio-streaming-daemon[7184]: # Running on port 7777 # Oct 06 03:16:34 volumio volumio-streaming-daemon[7184]: ############################ Oct 06 03:16:34 volumio volumio-streaming-daemon[7184]: Environment: production Oct 06 03:16:34 volumio volumio[6822]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 06 03:16:34 volumio volumio[6822]: info: MYVOLUMIO: Adding device Oct 06 03:16:34 volumio volumio[6822]: info: MYVOLUMIO: Evaluating Server Oct 06 03:16:36 volumio volumio[6822]: info: MyVolumio status changed Oct 06 03:16:36 volumio volumio[6822]: info: Streaming services startup Oct 06 03:16:36 volumio volumio[6822]: info: Re-Starting Streaming Daemon Oct 06 03:16:36 volumio volumio[6822]: info: Removing browser output: myVolumio user plan is not superstar Oct 06 03:16:36 volumio volumio[6822]: info: Removing audio output: Oct 06 03:16:36 volumio volumio[6822]: info: Stoppping Tunnel 1 Oct 06 03:16:36 volumio volumio-streaming-daemon[7184]: Restarting daemon Oct 06 03:16:36 volumio volumio-streaming-daemon[7184]: Environment: production Oct 06 03:16:36 volumio volumio-streaming-daemon[7184]: Environment: production Oct 06 03:16:36 volumio volumio[6822]: info: Fetching Streaming Services browse cache Oct 06 03:16:36 volumio sudo[7206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 06 03:16:36 volumio sudo[7206]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:16:36 volumio sudo[7206]: pam_unix(sudo:session): session closed for user root Oct 06 03:16:36 volumio volumio-streaming-daemon[7184]: Environment: production Oct 06 03:16:36 volumio volumio[6822]: info: Remote SSH Stopped Oct 06 03:16:36 volumio volumio[6822]: info: Fetching Streaming Services browse cache Oct 06 03:16:37 volumio volumio[6822]: info: Setting Geolocation for MyVolumio to as1 Oct 06 03:16:37 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:37 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:37 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:38 volumio volumio[6822]: info: Updating MyVolumio device info Oct 06 03:16:38 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:38 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:40 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 06 03:16:40 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:53 volumio volumio[6822]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 06 03:16:53 volumio volumio[6822]: info: Completed starting MyVolumio Plugin Oct 06 03:16:53 volumio volumio[6822]: info: BOOT COMPLETED Oct 06 03:16:53 volumio volumio[6822]: [Metrics] CommandRouter: 52s 150.81ms Oct 06 03:16:53 volumio volumio[6822]: info: CoreCommandRouter::volumiosetStartupVolume Oct 06 03:16:53 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:16:53 volumio volumio[6822]: info: VolumeController:: Setting startup Volume 80 Oct 06 03:16:53 volumio volumio[6822]: info: VolumeController::SetAlsaVolume80 Oct 06 03:16:53 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:16:53 volumio volumio[6822]: info: CoreCommandRouter::Close All Modals sent Oct 06 03:16:53 volumio volumio[6822]: info: CoreCommandRouter::Close All Modals sent Oct 06 03:16:53 volumio volumio[6822]: info: [squeezelite_mc] Setting Squeezelite volume to 80 Oct 06 03:16:53 volumio volumio[6822]: info: CoreStateMachine::pushState Oct 06 03:16:53 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:53 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 03:16:53 volumio volumio[6822]: info: CoreCommandRouter::volumioPushState Oct 06 03:16:53 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Oct 06 03:16:53 volumio volumio[6822]: info: CoreCommandRouter::volumioGetState Oct 06 03:16:53 volumio volumio[6822]: info: CorePlayQueue::getTrack 0 Oct 06 03:16:54 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 06 03:16:54 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 06 03:16:54 volumio volumio[6822]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 06 03:17:01 volumio CRON[7220]: pam_unix(cron:session): session opened for user root by (uid=0) Oct 06 03:17:01 volumio CRON[7221]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) Oct 06 03:17:01 volumio CRON[7220]: pam_unix(cron:session): session closed for user root Oct 06 03:17:06 volumio wpa_supplicant[1108]: wlan0: CTRL-EVENT-DISCONNECTED bssid=a0:95:7f:89:1b:70 reason=0 locally_generated=1 Oct 06 03:17:06 volumio dhcpcd[1138]: wlan0: carrier lost Oct 06 03:17:06 volumio wpa_supplicant[1108]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 06 03:17:07 volumio avahi-daemon[494]: Withdrawing address record for 192.168.3.7 on wlan0. Oct 06 03:17:07 volumio avahi-daemon[494]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.7. Oct 06 03:17:07 volumio avahi-daemon[494]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 06 03:17:07 volumio dhcpcd[1138]: wlan0: deleting route to 192.168.3.0/24 Oct 06 03:17:07 volumio volumio[6822]: info: mDNS: A device disapperared from network Oct 06 03:17:07 volumio volumio[6822]: info: mDNS: Device volumio disapperared from network Oct 06 03:17:09 volumio ntpd[930]: Deleting interface #6 wlan0, 192.168.3.7#123, interface stats: received=27, sent=27, dropped=0, active_time=63 secs Oct 06 03:17:09 volumio ntpd[930]: 122.215.240.51 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 129.250.35.250 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 202.181.103.212 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 202.182.111.234 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 133.243.238.243 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 45.76.218.37 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 160.16.113.133 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 133.243.238.163 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 172.105.204.105 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 167.179.119.205 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 45.77.20.103 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: 129.250.35.251 local addr 192.168.3.7 -> Oct 06 03:17:09 volumio ntpd[930]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Oct 06 03:17:11 volumio volumio[6822]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 03:17:11 volumio volumio[6822]: Error: send ENETUNREACH 255.255.255.255:3483 Oct 06 03:17:11 volumio volumio[6822]: at doSend (dgram.js:692:16) Oct 06 03:17:11 volumio volumio[6822]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Oct 06 03:17:11 volumio volumio[6822]: at afterDns (dgram.js:638:5) Oct 06 03:17:11 volumio volumio[6822]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Oct 06 03:17:11 volumio volumio[6822]: errno: -101, Oct 06 03:17:11 volumio volumio[6822]: code: 'ENETUNREACH', Oct 06 03:17:11 volumio volumio[6822]: syscall: 'send', Oct 06 03:17:11 volumio volumio[6822]: address: '255.255.255.255', Oct 06 03:17:11 volumio volumio[6822]: port: 3483 Oct 06 03:17:11 volumio volumio[6822]: } Oct 06 03:17:11 volumio volumio[6822]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 03:17:12 volumio sudo[7268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-06 03:16 Oct 06 03:17:12 volumio sudo[7268]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:17:12 volumio sudo[7268]: pam_unix(sudo:session): session closed for user root Oct 06 03:17:12 volumio volumio-remote-updater[485]: [2024-10-06 03:17:12] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 06 03:17:12 volumio volumio-remote-updater[485]: [2024-10-06 03:17:12] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 06 03:17:12 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 06 03:17:12 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 06 03:17:12 volumio systemd[1]: Started dynamicswap service. Oct 06 03:17:12 volumio systemd[1]: dynamicswap.service: Succeeded. Oct 06 03:17:12 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 06 03:17:12 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Oct 06 03:17:12 volumio systemd[1]: Started dynamicswap service. Oct 06 03:17:12 volumio systemd[1]: Stopped Volumio Backend Module. Oct 06 03:17:12 volumio systemd[1]: Started Volumio Backend Module. Oct 06 03:17:12 volumio systemd[1]: dynamicswap.service: Succeeded. Oct 06 03:17:14 volumio wpa_supplicant[1108]: wlan0: Trying to associate with SSID 'A0957F891B71-2G' Oct 06 03:17:14 volumio volumio[7282]: info: ------------------------------------------- Oct 06 03:17:14 volumio volumio[7282]: info: ----- Volumio3 ---- Oct 06 03:17:14 volumio volumio[7282]: info: ------------------------------------------- Oct 06 03:17:14 volumio volumio[7282]: info: ----- System startup ---- Oct 06 03:17:14 volumio volumio[7282]: info: ------------------------------------------- Oct 06 03:17:15 volumio dhcpcd[1138]: wlan0: carrier acquired Oct 06 03:17:15 volumio wpa_supplicant[1108]: wlan0: Associated with a0:95:7f:89:1b:70 Oct 06 03:17:15 volumio wpa_supplicant[1108]: wlan0: CTRL-EVENT-CONNECTED - Connection to a0:95:7f:89:1b:70 completed [id=0 id_str=] Oct 06 03:17:15 volumio wpa_supplicant[1108]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 06 03:17:15 volumio wpa_supplicant[1108]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP Oct 06 03:17:15 volumio dhcpcd[1138]: wlan0: IAID eb:ba:e8:23 Oct 06 03:17:15 volumio dhcpcd[1138]: wlan0: carrier lost Oct 06 03:17:15 volumio dhcpcd[1138]: wlan0: carrier acquired Oct 06 03:17:15 volumio dhcpcd[1138]: wlan0: IAID eb:ba:e8:23 Oct 06 03:17:15 volumio volumio[7282]: info: MYVOLUMIO Environment detected Oct 06 03:17:15 volumio volumio[7282]: info: Plugin folders cleanup Oct 06 03:17:15 volumio volumio[7282]: info: Scanning into folder /volumio/app/plugins/ Oct 06 03:17:15 volumio volumio[7282]: info: Scanning category audio_interface Oct 06 03:17:15 volumio volumio[7282]: info: Scanning category miscellanea Oct 06 03:17:15 volumio volumio[7282]: info: Scanning category music_service Oct 06 03:17:15 volumio volumio[7282]: info: Scanning category plugins.json Oct 06 03:17:15 volumio volumio[7282]: info: Scanning category system_controller Oct 06 03:17:15 volumio volumio[7282]: info: Scanning category user_interface Oct 06 03:17:15 volumio volumio[7282]: info: Scanning into folder /data/plugins/ Oct 06 03:17:15 volumio volumio[7282]: info: Scanning category music_service Oct 06 03:17:15 volumio volumio[7282]: info: Plugin folders cleanup completed Oct 06 03:17:15 volumio volumio[7282]: info: ------------------------------------------- Oct 06 03:17:15 volumio volumio[7282]: info: ----- Core plugins startup ---- Oct 06 03:17:15 volumio volumio[7282]: info: ------------------------------------------- Oct 06 03:17:15 volumio volumio[7282]: info: Loading plugins from folder /volumio/app/plugins/ Oct 06 03:17:15 volumio volumio[7282]: info: Adding plugin upnp to MyMusic Plugins Oct 06 03:17:15 volumio volumio[7282]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 06 03:17:15 volumio volumio[7282]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 06 03:17:15 volumio volumio[7282]: info: Loading plugins from folder /data/plugins/ Oct 06 03:17:15 volumio volumio[7282]: info: Loading plugin "system"... Oct 06 03:17:15 volumio volumio[7282]: info: Loading plugin "appearance"... Oct 06 03:17:15 volumio dhcpcd[1138]: wlan0: rebinding lease of 192.168.3.7 Oct 06 03:17:16 volumio dhcpcd[1138]: wlan0: soliciting an IPv6 router Oct 06 03:17:16 volumio volumio[7282]: info: Loading plugin "network"... Oct 06 03:17:16 volumio volumio[7282]: info: Refreshing Cached IP Addresses Oct 06 03:17:16 volumio volumio[7282]: info: Loading plugin "services"... Oct 06 03:17:16 volumio volumio[7282]: info: Loading plugin "alsa_controller"... Oct 06 03:17:16 volumio volumio[7282]: info: Loading plugin "wizard"... Oct 06 03:17:16 volumio volumio[7282]: info: Loading plugin "volumio_command_line_client"... Oct 06 03:17:16 volumio volumio[7282]: info: Loading plugin "upnp"... Oct 06 03:17:16 volumio volumio[7282]: info: [1728152236887] Starting Upmpd Daemon Oct 06 03:17:16 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 06 03:17:16 volumio volumio[7282]: info: Loading plugin "my_music"... Oct 06 03:17:16 volumio volumio[7282]: info: Loading plugin "mpd"... Oct 06 03:17:16 volumio sudo[7321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 06 03:17:16 volumio sudo[7319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 06 03:17:16 volumio sudo[7317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 06 03:17:16 volumio sudo[7317]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:17:16 volumio sudo[7319]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:17:16 volumio sudo[7319]: pam_unix(sudo:session): session closed for user root Oct 06 03:17:16 volumio sudo[7317]: pam_unix(sudo:session): session closed for user root Oct 06 03:17:16 volumio sudo[7321]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:17:17 volumio volumio[7282]: info: Creating MPD Configuration file Oct 06 03:17:17 volumio ntpd[930]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Oct 06 03:17:17 volumio volumio[7282]: info: Loading plugin "upnp_browser"... Oct 06 03:17:17 volumio sudo[7330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 06 03:17:17 volumio sudo[7330]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:17:17 volumio sudo[7330]: pam_unix(sudo:session): session closed for user root Oct 06 03:17:17 volumio sudo[7332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 06 03:17:17 volumio sudo[7332]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:17:17 volumio systemd[1]: Stopping Music Player Daemon... Oct 06 03:17:17 volumio systemd[1]: mpd.service: Succeeded. Oct 06 03:17:17 volumio systemd[1]: Stopped Music Player Daemon. Oct 06 03:17:17 volumio systemd[1]: Starting Music Player Daemon... Oct 06 03:17:17 volumio volumio-remote-updater[485]: [2024-10-06 03:17:17] [connect] Successful connection Oct 06 03:17:17 volumio volumio[7282]: info: Loading plugin "networkfs"... Oct 06 03:17:17 volumio volumio[7282]: info: Starting Udev Watcher for removable devices Oct 06 03:17:17 volumio sudo[7321]: pam_unix(sudo:session): session closed for user root Oct 06 03:17:18 volumio volumio[7282]: info: Ignoring mount for partition: boot Oct 06 03:17:18 volumio volumio[7282]: info: Ignoring mount for partition: volumio Oct 06 03:17:18 volumio volumio[7282]: info: Ignoring mount for partition: volumio_data Oct 06 03:17:18 volumio volumio[7282]: error: Cannot associate FS Label, not mounting Oct 06 03:17:18 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 06 03:17:18 volumio volumio[7282]: info: Loading plugin "alarm-clock"... Oct 06 03:17:18 volumio volumio[7282]: info: Loading plugin "airplay_emulation"... Oct 06 03:17:18 volumio volumio[7282]: info: Starting Shairport Sync Oct 06 03:17:18 volumio volumio[7282]: info: Loading plugin "last_100"... Oct 06 03:17:18 volumio volumio[7282]: info: Loading plugin "webradio"... Oct 06 03:17:18 volumio volumio[7282]: info: Loading plugin "i2s_dacs"... Oct 06 03:17:18 volumio volumio[7282]: info: Loading plugin "volumiodiscovery"... Oct 06 03:17:18 volumio volumio[7282]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 06 03:17:18 volumio node[7282]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 06 03:17:18 volumio volumio[7282]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 03:17:18 volumio node[7282]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 03:17:18 volumio volumio[7282]: *** WARNING *** For more information see Oct 06 03:17:18 volumio node[7282]: *** WARNING *** For more information see Oct 06 03:17:18 volumio volumio[7282]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 06 03:17:18 volumio node[7282]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 06 03:17:18 volumio volumio[7282]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 03:17:18 volumio node[7282]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 06 03:17:18 volumio volumio[7282]: *** WARNING *** For more information see Oct 06 03:17:18 volumio node[7282]: *** WARNING *** For more information see Oct 06 03:17:18 volumio volumio[7282]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 06 03:17:18 volumio volumio[7282]: info: Discovery: Started advertising with name: Volumio Oct 06 03:17:18 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 06 03:17:18 volumio volumio[7282]: info: Loading plugin "lmsde"... Oct 06 03:17:18 volumio mpd[7337]: Oct 06 03:17 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 06 03:17:18 volumio volumio[7282]: info: Loading plugin "squeezelite_mc"... Oct 06 03:17:19 volumio mpd[7337]: Oct 06 03:17 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Oct 06 03:17:19 volumio mpd[7337]: Oct 06 03:17 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Oct 06 03:17:19 volumio systemd[1]: Started Music Player Daemon. Oct 06 03:17:19 volumio sudo[7332]: pam_unix(sudo:session): session closed for user root Oct 06 03:17:19 volumio volumio[7282]: info: Loading plugin "youtube2"... Oct 06 03:17:20 volumio dhcpcd[1138]: wlan0: probing for an IPv4LL address Oct 06 03:17:20 volumio dhcpcd[1138]: wlan0: DHCP lease expired Oct 06 03:17:20 volumio dhcpcd[1138]: wlan0: soliciting a DHCP lease Oct 06 03:17:20 volumio dhcpcd[1138]: wlan0: offered 192.168.3.7 from 192.168.3.1 Oct 06 03:17:20 volumio dhcpcd[1138]: wlan0: probing address 192.168.3.7/24 Oct 06 03:17:21 volumio volumio[7282]: info: Loading plugin "outputs"... Oct 06 03:17:21 volumio volumio[7282]: info: Loading plugin "albumart"... Oct 06 03:17:21 volumio volumio[7282]: info: Plugin example_plugin is not enabled Oct 06 03:17:21 volumio volumio[7282]: info: Loading plugin "inputs"... Oct 06 03:17:21 volumio volumio[7282]: info: Loading plugin "updater_comm"... Oct 06 03:17:21 volumio volumio[7282]: info: Plugin mpdemulation is not enabled Oct 06 03:17:21 volumio volumio[7282]: info: Loading plugin "rest_api"... Oct 06 03:17:21 volumio volumio[7282]: info: Loading plugin "websocket"... Oct 06 03:17:21 volumio volumio[7282]: info: Loading i18n strings for locale ja Oct 06 03:17:21 volumio volumio[7282]: Updating browse sources language Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::initPlayerControls Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: Express server listening on port 3000 Oct 06 03:17:21 volumio volumio[7282]: [Metrics] WebUI: 7s 222.68ms Oct 06 03:17:21 volumio volumio[7282]: info: CoreStateMachine::resetVolumioState Oct 06 03:17:21 volumio volumio[7282]: info: CoreStateMachine::getcurrentVolume Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::volumioRetrievevolume Oct 06 03:17:21 volumio volumio[7282]: info: MPD Permissions set Oct 06 03:17:21 volumio volumio[7282]: Forking 3 albumart workers Oct 06 03:17:21 volumio volumio-remote-updater[485]: [2024-10-06 03:17:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1728152237 101 Oct 06 03:17:21 volumio volumio[7282]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Oct 06 03:17:21 volumio volumio[7282]: info: MPD running with PID7337 Oct 06 03:17:21 volumio volumio[7282]: ,establishing connection Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:17:21 volumio volumio[7282]: info: Executing start script for DAC IQaudIO DAC Plus Oct 06 03:17:21 volumio volumio[7282]: info: Reloading queue from file Oct 06 03:17:21 volumio volumio[7282]: error: updateQueue error: null Oct 06 03:17:22 volumio volumio[7282]: info: CoreStateMachine::setRepeat false single undefined Oct 06 03:17:22 volumio volumio[7282]: info: CoreStateMachine::pushState Oct 06 03:17:22 volumio volumio[7282]: info: CorePlayQueue::getTrack 0 Oct 06 03:17:22 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 03:17:22 volumio volumio[7282]: info: CoreCommandRouter::volumioPushState Oct 06 03:17:22 volumio volumio[7282]: info: CoreStateMachine::setRandom null Oct 06 03:17:22 volumio volumio[7282]: info: CoreStateMachine::pushState Oct 06 03:17:22 volumio volumio[7282]: info: CorePlayQueue::getTrack 0 Oct 06 03:17:22 volumio volumio[7282]: info: CoreCommandRouter::volumioPushState Oct 06 03:17:22 volumio volumio[7282]: info: Setting Device type: Raspberry PI Oct 06 03:17:22 volumio volumio[7282]: info: DAC script executed Oct 06 03:17:22 volumio volumio[7282]: info: Completed loading Core Plugins Oct 06 03:17:22 volumio volumio[7282]: info: Preparing to generate the ALSA configuration file Oct 06 03:17:22 volumio volumio[7282]: info: VolumeController:: Volume=79 Mute =false Oct 06 03:17:22 volumio volumio[7282]: info: CoreStateMachine::pushState Oct 06 03:17:22 volumio volumio[7282]: info: CorePlayQueue::getTrack 0 Oct 06 03:17:22 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 03:17:22 volumio volumio[7282]: info: CoreCommandRouter::volumioPushState Oct 06 03:17:22 volumio volumio[7282]: info: CoreStateMachine::updateTrackBlock Oct 06 03:17:22 volumio volumio[7282]: info: CorePlayQueue::getTrackBlock Oct 06 03:17:22 volumio volumio[7282]: info: CoreCommandRouter::volumioRetrievevolume Oct 06 03:17:22 volumio ntpd[930]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Oct 06 03:17:22 volumio volumio[7282]: error: updateQueue error: null Oct 06 03:17:22 volumio volumio[7282]: Starting albumart workers Oct 06 03:17:22 volumio volumio[7282]: Starting albumart workers Oct 06 03:17:22 volumio volumio[7282]: Starting albumart workers Oct 06 03:17:22 volumio volumio[7282]: info: Asound.conf file unchanged, so no further update is needed Oct 06 03:17:22 volumio volumio[7282]: info: Output device has changed, restarting MPD Oct 06 03:17:22 volumio volumio[7282]: info: Output device has changed, restarting Shairport Sync Oct 06 03:17:22 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:22 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:17:22 volumio sudo[7404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 06 03:17:22 volumio sudo[7404]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:17:22 volumio sudo[7404]: pam_unix(sudo:session): session closed for user root Oct 06 03:17:23 volumio volumio[7282]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 06 03:17:23 volumio volumio[7282]: info: ___________ START PLUGINS ___________ Oct 06 03:17:23 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 03:17:23 volumio volumio[7282]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 03:17:23 volumio volumio[7282]: info: [1728152243065] CoreMusicLibrary::Adding element Media Servers Oct 06 03:17:23 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 03:17:23 volumio volumio[7282]: Cannot find translation for sourceMedia Servers Oct 06 03:17:24 volumio sudo[7408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 06 03:17:24 volumio sudo[7408]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:17:24 volumio systemd[1]: Stopping Music Player Daemon... Oct 06 03:17:24 volumio systemd[1]: mpd.service: Succeeded. Oct 06 03:17:24 volumio systemd[1]: Stopped Music Player Daemon. Oct 06 03:17:24 volumio systemd[1]: Starting Music Player Daemon... Oct 06 03:17:24 volumio volumio[7282]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:17:24 volumio volumio[7282]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 03:17:24 volumio volumio[7282]: info: [1728152244635] CoreMusicLibrary::Adding element Last_100 Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 03:17:24 volumio volumio[7282]: Cannot find translation for sourceMedia Servers Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 03:17:24 volumio volumio[7282]: info: [1728152244639] CoreMusicLibrary::Adding element Webradio Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 03:17:24 volumio volumio[7282]: Cannot find translation for sourceMedia Servers Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 06 03:17:24 volumio volumio[7282]: info: [lmsde] Executing script: /opt/lmsde/lms.sh start Oct 06 03:17:24 volumio volumio[7282]: info: [squeezelite_mc] Starting proxy server... Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 06 03:17:24 volumio volumio[7282]: info: [1728152244731] CoreMusicLibrary::Adding element YouTube2 Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 06 03:17:24 volumio volumio[7282]: Cannot find translation for sourceMedia Servers Oct 06 03:17:24 volumio volumio[7282]: Cannot find translation for sourceYouTube2 Oct 06 03:17:24 volumio volumio[7282]: info: Volumio Calling Home Oct 06 03:17:24 volumio sudo[7445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/opt/lmsde/lms.sh start Oct 06 03:17:24 volumio sudo[7445]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:17:24 volumio volumio[7282]: info: [squeezelite_mc] Proxy server started on port 36099 Oct 06 03:17:24 volumio volumio[7282]: info: CoreCommandRouter::volumioRetrievevolume Oct 06 03:17:25 volumio volumio[7282]: info: Discovery: adding 18bcd961-2cad-4825-9d0c-cefd458c8c21 Oct 06 03:17:25 volumio volumio[7282]: info: mDNS: Found device Volumio Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::volumioGetState Oct 06 03:17:25 volumio volumio[7282]: info: CorePlayQueue::getTrack 0 Oct 06 03:17:25 volumio volumio[7282]: Unhandled rejection Error: No sockets available, cannot start. Oct 06 03:17:25 volumio volumio[7282]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Oct 06 03:17:25 volumio volumio[7282]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Oct 06 03:17:25 volumio volumio[7282]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Oct 06 03:17:25 volumio volumio[7282]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Oct 06 03:17:25 volumio volumio[7282]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Oct 06 03:17:25 volumio volumio[7282]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Oct 06 03:17:25 volumio volumio[7282]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Oct 06 03:17:25 volumio volumio[7282]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Oct 06 03:17:25 volumio volumio[7282]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Oct 06 03:17:25 volumio volumio[7282]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Oct 06 03:17:25 volumio volumio[7282]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Oct 06 03:17:25 volumio volumio[7282]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Oct 06 03:17:25 volumio volumio[7282]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Oct 06 03:17:25 volumio volumio[7282]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Oct 06 03:17:25 volumio volumio[7282]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Oct 06 03:17:25 volumio volumio[7282]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 06 03:17:25 volumio volumio[7282]: info: MPD Permissions set Oct 06 03:17:25 volumio volumio[7282]: info: VolumeController:: Volume=79 Mute =false Oct 06 03:17:25 volumio volumio[7282]: info: CoreStateMachine::pushState Oct 06 03:17:25 volumio volumio[7282]: info: CorePlayQueue::getTrack 0 Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::volumioPushState Oct 06 03:17:25 volumio volumio[7282]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: VolumeController:: Volume=79 Mute =false Oct 06 03:17:25 volumio volumio[7282]: info: CoreStateMachine::pushState Oct 06 03:17:25 volumio volumio[7282]: info: CorePlayQueue::getTrack 0 Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::volumioPushState Oct 06 03:17:25 volumio volumio[7282]: info: [squeezelite_mc] Server discovery started Oct 06 03:17:25 volumio volumio[7282]: info: [squeezelite_mc] Player finder started Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 06 03:17:25 volumio volumio[7282]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true Oct 06 03:17:25 volumio volumio[7282]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 03:17:25 volumio volumio[7282]: Error: send ENETUNREACH 255.255.255.255:3483 Oct 06 03:17:25 volumio volumio[7282]: at doSend (dgram.js:692:16) Oct 06 03:17:25 volumio volumio[7282]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Oct 06 03:17:25 volumio volumio[7282]: at afterDns (dgram.js:638:5) Oct 06 03:17:25 volumio volumio[7282]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Oct 06 03:17:25 volumio volumio[7282]: errno: -101, Oct 06 03:17:25 volumio volumio[7282]: code: 'ENETUNREACH', Oct 06 03:17:25 volumio volumio[7282]: syscall: 'send', Oct 06 03:17:25 volumio volumio[7282]: address: '255.255.255.255', Oct 06 03:17:25 volumio volumio[7282]: port: 3483 Oct 06 03:17:25 volumio volumio[7282]: } Oct 06 03:17:25 volumio volumio[7282]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 03:17:25 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Oct 06 03:17:25 volumio dhcpcd[1138]: wlan0: leased 192.168.3.7 for 86400 seconds Oct 06 03:17:26 volumio mpd[7455]: exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 06 03:17:26 volumio mpd[7455]: output: No 'audio_output' defined in config file Oct 06 03:17:26 volumio mpd[7455]: output: Attempt to detect audio output device Oct 06 03:17:26 volumio mpd[7455]: output: Attempting to detect a alsa audio device Oct 06 03:17:26 volumio mpd[7455]: output: Successfully detected a alsa audio device Oct 06 03:17:26 volumio mpd[7455]: exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Oct 06 03:17:26 volumio mpd[7455]: exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Oct 06 03:17:26 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Oct 06 03:17:26 volumio avahi-daemon[494]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.7. Oct 06 03:17:26 volumio dhcpcd[1138]: wlan0: adding route to 192.168.3.0/24 Oct 06 03:17:26 volumio dhcpcd[1138]: wlan0: adding default route via 192.168.3.1 Oct 06 03:17:26 volumio mpd[7455]: zeroconf: No global port, disabling zeroconf Oct 06 03:17:26 volumio systemd[1]: Started Music Player Daemon. Oct 06 03:17:27 volumio sudo[7408]: pam_unix(sudo:session): session closed for user root Oct 06 03:17:27 volumio avahi-daemon[494]: New relevant interface wlan0.IPv4 for mDNS. Oct 06 03:17:27 volumio avahi-daemon[494]: Registering new address record for 192.168.3.7 on wlan0.IPv4. Oct 06 03:17:27 volumio sudo[7475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-06 03:16 Oct 06 03:17:27 volumio sudo[7475]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 06 03:17:27 volumio sudo[7445]: pam_unix(sudo:session): session closed for user root 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="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b" VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9" VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1" VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 02:51:41 PM CEST" VOLUMIO_VERSION="3.251" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e83cc5fcd68eb3ee4105ab0b8b3779ea"