-- Logs begin at Thu 2019-02-14 12:12:02 EET, end at Fri 2025-09-05 21:09:44 EEST. -- Sep 05 20:39:23 volumio systemd-timedated[996]: Changed local time to Fri Sep 5 17:39:23 2025 Sep 05 20:39:23 volumio sudo[994]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:23 volumio volumio-time-update[620]: volumio-time-update-util: System time updated successfully. Sep 05 20:39:23 volumio systemd[1]: Starting Daily apt download activities... Sep 05 20:39:23 volumio systemd[1]: Started Volumio Time Update Utility. Sep 05 20:39:29 volumio winbindd[987]: [2025/09/05 17:39:29.076503, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 05 20:39:29 volumio winbindd[987]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Sep 05 20:39:29 volumio systemd[1]: Started Samba Winbind Daemon. Sep 05 20:39:29 volumio volumio-remote-updater[621]: [2025-09-05 17:39:29] [info] asio async_connect error: system:111 (Connection refused) Sep 05 20:39:29 volumio volumio-remote-updater[621]: [2025-09-05 17:39:29] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 05 20:39:29 volumio volumio-remote-updater[621]: [2025-09-05 17:39:29] [error] handle_connect error: Underlying Transport Error Sep 05 20:39:29 volumio systemd[1]: Starting Samba SMB Daemon... Sep 05 20:39:34 volumio systemd[1]: systemd-fsckd.service: Succeeded. Sep 05 20:39:37 volumio systemd[1]: apt-daily.service: Succeeded. Sep 05 20:39:37 volumio systemd[1]: Started Daily apt download activities. Sep 05 20:39:37 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Sep 05 20:39:37 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Sep 05 20:39:37 volumio systemd[1]: Started Daily apt upgrade and clean activities. Sep 05 20:39:37 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Sep 05 20:39:39 volumio volumio-remote-updater[621]: [2025-09-05 17:39:39] [connect] Successful connection Sep 05 20:39:39 volumio smbd[1018]: [2025/09/05 17:39:39.410614, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 05 20:39:39 volumio smbd[1018]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Sep 05 20:39:39 volumio systemd[1]: Started Samba SMB Daemon. Sep 05 20:39:39 volumio systemd[1]: Reached target Multi-User System. Sep 05 20:39:39 volumio systemd[1]: Reached target Graphical Interface. Sep 05 20:39:39 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Sep 05 20:39:39 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Sep 05 20:39:39 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Sep 05 20:39:39 volumio systemd[1]: Startup finished in 1min 36.146s (kernel) + 42.433s (userspace) = 2min 18.579s. Sep 05 20:39:39 volumio volumio[910]: info: ------------------------------------------- Sep 05 20:39:39 volumio volumio[910]: info: ----- Volumio3 ---- Sep 05 20:39:39 volumio volumio[910]: info: ------------------------------------------- Sep 05 20:39:39 volumio volumio[910]: info: ----- System startup ---- Sep 05 20:39:39 volumio volumio[910]: info: ------------------------------------------- Sep 05 20:39:39 volumio firststart.sh[911]: Creating SSH2 RSA key; this may take some time ... Sep 05 20:39:39 volumio firststart.sh[911]: 2048 SHA256:ig+/rbS0sQB22F+8tUBrTBrYsBMWm2wkGx+CK2Pqpyw root@volumio (RSA) Sep 05 20:39:40 volumio volumio[910]: info: File /data/configuration/plugins.json does not exist. Copying from Volumio Sep 05 20:39:40 volumio volumio[910]: info: MYVOLUMIO Environment detected Sep 05 20:39:40 volumio volumio[910]: info: Plugin folders cleanup Sep 05 20:39:40 volumio volumio[910]: info: Scanning into folder /volumio/app/plugins/ Sep 05 20:39:40 volumio volumio[910]: info: Scanning category audio_interface Sep 05 20:39:40 volumio volumio[910]: info: Scanning category miscellanea Sep 05 20:39:40 volumio volumio[910]: info: Scanning category music_service Sep 05 20:39:40 volumio volumio[910]: info: Scanning category plugins.json Sep 05 20:39:40 volumio volumio[910]: info: Scanning category system_controller Sep 05 20:39:40 volumio volumio[910]: info: Scanning category user_interface Sep 05 20:39:40 volumio volumio[910]: info: Scanning into folder /data/plugins/ Sep 05 20:39:40 volumio volumio[910]: info: Plugin folders cleanup completed Sep 05 20:39:40 volumio volumio[910]: info: ------------------------------------------- Sep 05 20:39:40 volumio volumio[910]: info: ----- Core plugins startup ---- Sep 05 20:39:40 volumio volumio[910]: info: ------------------------------------------- Sep 05 20:39:40 volumio volumio[910]: info: Loading plugins from folder /volumio/app/plugins/ Sep 05 20:39:40 volumio volumio[910]: info: Adding plugin upnp to MyMusic Plugins Sep 05 20:39:40 volumio volumio[910]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 05 20:39:40 volumio volumio[910]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 05 20:39:40 volumio volumio[910]: info: Loading plugins from folder /data/plugins/ Sep 05 20:39:40 volumio volumio[910]: info: Loading plugin "system"... Sep 05 20:39:40 volumio volumio[910]: info: No id defined. Creating one Sep 05 20:39:40 volumio volumio[910]: info: Loading plugin "appearance"... Sep 05 20:39:41 volumio volumio[910]: info: Loading plugin "network"... Sep 05 20:39:41 volumio volumio[910]: info: Refreshing Cached IP Addresses Sep 05 20:39:41 volumio sudo[1248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:39:41 volumio sudo[1248]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:41 volumio sudo[1248]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:41 volumio sudo[1251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:39:41 volumio sudo[1251]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:41 volumio sudo[1251]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:41 volumio volumio[910]: info: Loading plugin "services"... Sep 05 20:39:41 volumio volumio[910]: info: Loading plugin "alsa_controller"... Sep 05 20:39:41 volumio sudo[1263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 05 20:39:41 volumio sudo[1263]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:41 volumio volumio[910]: warn: The ALSA output card is not set, defaulting to card [object Object] Sep 05 20:39:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:39:41 volumio volumio[910]: info: Found match in Cards Database: setting mixer PCM for card HDMI Out Sep 05 20:39:41 volumio volumio[910]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 05 20:39:41 volumio volumio[910]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 05 20:39:41 volumio volumio[910]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 05 20:39:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:39:41 volumio volumio[910]: info: Loading plugin "wizard"... Sep 05 20:39:41 volumio volumio[910]: info: Loading plugin "networkfs"... Sep 05 20:39:41 volumio volumio[910]: info: Starting Udev Watcher for removable devices Sep 05 20:39:41 volumio volumio[910]: info: Ignoring mount for partition: boot Sep 05 20:39:41 volumio volumio[910]: info: Ignoring mount for partition: volumio Sep 05 20:39:41 volumio volumio[910]: info: Ignoring mount for partition: volumio_data Sep 05 20:39:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 05 20:39:41 volumio volumio[910]: info: Loading plugin "volumio_command_line_client"... Sep 05 20:39:41 volumio volumio[910]: info: Loading plugin "upnp"... Sep 05 20:39:41 volumio volumio[910]: info: [1757093981940] Starting Upmpd Daemon Sep 05 20:39:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 05 20:39:41 volumio volumio[910]: info: Loading plugin "my_music"... Sep 05 20:39:41 volumio volumio[910]: info: Loading plugin "mpd"... Sep 05 20:39:42 volumio volumio[910]: info: Loading plugin "upnp_browser"... Sep 05 20:39:44 volumio firststart.sh[911]: Creating SSH2 DSA key; this may take some time ... Sep 05 20:39:44 volumio firststart.sh[911]: 1024 SHA256:uO5tzpmVIIisPAelQWxnk9POdu4eHHdawmmzlBaX2pI root@volumio (DSA) Sep 05 20:39:44 volumio firststart.sh[911]: Creating SSH2 ECDSA key; this may take some time ... Sep 05 20:39:44 volumio volumio[910]: info: Loading plugin "alarm-clock"... Sep 05 20:39:44 volumio firststart.sh[911]: 256 SHA256:T7gKBawTRQ5LuqtNgB6IVeCtZcj7aADof2wj9ERHhFE root@volumio (ECDSA) Sep 05 20:39:44 volumio volumio[910]: info: Loading plugin "airplay_emulation"... Sep 05 20:39:44 volumio volumio[910]: info: Starting Shairport Sync Sep 05 20:39:44 volumio volumio[910]: info: Loading plugin "last_100"... Sep 05 20:39:44 volumio volumio[910]: info: Loading plugin "webradio"... Sep 05 20:39:45 volumio volumio[910]: info: Loading plugin "i2s_dacs"... Sep 05 20:39:45 volumio volumio[910]: info: I2S DAC not set, start Auto-detection Sep 05 20:39:45 volumio volumio[910]: info: Loading plugin "volumiodiscovery"... Sep 05 20:39:45 volumio volumio[910]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 05 20:39:45 volumio volumio[910]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 05 20:39:45 volumio volumio[910]: *** WARNING *** For more information see Sep 05 20:39:45 volumio volumio[910]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 05 20:39:45 volumio node[910]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 05 20:39:45 volumio volumio[910]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 05 20:39:45 volumio volumio[910]: *** WARNING *** For more information see Sep 05 20:39:45 volumio node[910]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 05 20:39:45 volumio node[910]: *** WARNING *** For more information see Sep 05 20:39:45 volumio node[910]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 05 20:39:45 volumio node[910]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 05 20:39:45 volumio node[910]: *** WARNING *** For more information see Sep 05 20:39:45 volumio volumio[910]: info: Discovery: Started advertising with name: Volumio Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 05 20:39:45 volumio volumio[910]: info: Loading plugin "outputs"... Sep 05 20:39:45 volumio volumio[910]: info: Loading plugin "albumart"... Sep 05 20:39:45 volumio volumio[910]: info: Plugin example_plugin is not enabled Sep 05 20:39:45 volumio volumio[910]: info: Loading plugin "inputs"... Sep 05 20:39:45 volumio volumio[910]: info: Loading plugin "updater_comm"... Sep 05 20:39:45 volumio volumio[910]: info: Plugin mpdemulation is not enabled Sep 05 20:39:45 volumio volumio[910]: info: Loading plugin "rest_api"... Sep 05 20:39:45 volumio volumio[910]: Forking 3 albumart workers Sep 05 20:39:45 volumio volumio[910]: info: Loading plugin "websocket"... Sep 05 20:39:45 volumio volumio[910]: info: Starting Socket.io Server version 2.3.0 Sep 05 20:39:45 volumio volumio[910]: info: Loading i18n strings for locale en Sep 05 20:39:45 volumio volumio[910]: Updating browse sources language Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:39:45 volumio sudo[1263]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::initPlayerControls Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:39:45 volumio volumio[910]: Express server listening on port 3000 Sep 05 20:39:45 volumio volumio[910]: [Metrics] WebUI: 13s 15.89ms Sep 05 20:39:45 volumio volumio[910]: info: CoreStateMachine::resetVolumioState Sep 05 20:39:45 volumio volumio[910]: info: CoreStateMachine::getcurrentVolume Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::volumioRetrievevolume Sep 05 20:39:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:39:46 volumio systemd[1]: Reloading. Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 05 20:39:46 volumio volumio[910]: info: CoreStateMachine::getcurrentVolume Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::volumioRetrievevolume Sep 05 20:39:46 volumio volumio[910]: Starting albumart workers Sep 05 20:39:46 volumio volumio[910]: info: Cannot read play queue from file Sep 05 20:39:46 volumio volumio[910]: Starting albumart workers Sep 05 20:39:46 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. Sep 05 20:39:46 volumio volumio[910]: info: Volumio Network Manager: Network status updated: 1 Sep 05 20:39:46 volumio volumio[910]: Starting albumart workers Sep 05 20:39:46 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Sep 05 20:39:46 volumio volumio[910]: info: VolumeController:: Volume=86 Mute =false Sep 05 20:39:46 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:39:46 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:39:46 volumio volumio[910]: info: CoreStateMachine::updateTrackBlock Sep 05 20:39:46 volumio volumio[910]: info: CorePlayQueue::getTrackBlock Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::volumioRetrievevolume Sep 05 20:39:46 volumio firststart.sh[911]: rescue-ssh.target is a disabled or a static unit, not starting it. Sep 05 20:39:46 volumio volumio[910]: info: VolumeController:: Volume=86 Mute =false Sep 05 20:39:46 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:39:46 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:39:46 volumio volumio[910]: info: CoreStateMachine::updateTrackBlock Sep 05 20:39:46 volumio volumio[910]: info: CorePlayQueue::getTrackBlock Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::volumioRetrievevolume Sep 05 20:39:46 volumio volumio[910]: info: Setting Device type: Raspberry PI Sep 05 20:39:46 volumio volumio[910]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Sep 05 20:39:46 volumio volumio[910]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03111 Sep 05 20:39:46 volumio volumio[910]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Sep 05 20:39:46 volumio volumio[910]: info: VolumeController:: Volume=86 Mute =false Sep 05 20:39:46 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:39:46 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:39:46 volumio volumio[910]: info: Discovery: adding bb006ffd-17c4-471a-8f4c-8ff8cecf05ea Sep 05 20:39:46 volumio volumio[910]: info: Discovery: Found device Volumio Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:39:46 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:39:46 volumio volumio[910]: info: Discovery: this is already registered, bb006ffd-17c4-471a-8f4c-8ff8cecf05ea Sep 05 20:39:46 volumio volumio[910]: info: Discovery: Found device Volumio Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:39:46 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:39:46 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:39:46 volumio volumio[910]: info: VolumeController:: Volume=86 Mute =false Sep 05 20:39:46 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:39:46 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:39:46 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:39:47 volumio volumio[910]: info: Completed loading Core Plugins Sep 05 20:39:47 volumio volumio[910]: info: Preparing to generate the ALSA configuration file Sep 05 20:39:47 volumio firststart.sh[911]: insserv: warning: current start runlevel(s) (empty) of script `ssh' overrides LSB defaults (2 3 4 5). Sep 05 20:39:47 volumio firststart.sh[911]: insserv: warning: current stop runlevel(s) (2 3 4 5) of script `ssh' overrides LSB defaults (empty). Sep 05 20:39:47 volumio volumio[910]: info: Asound.conf file written Sep 05 20:39:47 volumio systemd[1]: Reloading. Sep 05 20:39:47 volumio sudo[1411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 05 20:39:47 volumio sudo[1411]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:47 volumio sudo[1411]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:47 volumio volumio[910]: No state is present for card b1 Sep 05 20:39:47 volumio volumio[910]: /usr/share/alsa/init/bcm2835:14: control element not found Sep 05 20:39:47 volumio volumio[910]: No state is present for card b1 Sep 05 20:39:47 volumio volumio[910]: No state is present for card Headphones Sep 05 20:39:47 volumio volumio[910]: /usr/share/alsa/init/bcm2835:20: control element not found Sep 05 20:39:47 volumio volumio[910]: No state is present for card Headphones Sep 05 20:39:47 volumio volumio[910]: info: Output device has changed, restarting MPD Sep 05 20:39:47 volumio volumio[910]: info: Output device has changed, restarting Shairport Sync Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:39:47 volumio sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 05 20:39:47 volumio sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:47 volumio sudo[1431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 05 20:39:47 volumio sudo[1431]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:47 volumio volumio[910]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 20:39:47 volumio volumio[910]: info: ___________ START PLUGINS ___________ Sep 05 20:39:47 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. Sep 05 20:39:47 volumio volumio[910]: info: Setting Hotspot Unique name on first start: Volumio-72520 Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getConfigParam] in plugin network Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::Reload Ui Sep 05 20:39:47 volumio volumio[910]: info: ControllerMpd::onStart: Initializing MPD Sep 05 20:39:47 volumio volumio[910]: info: Creating MPD Configuration file Sep 05 20:39:47 volumio sudo[1438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 05 20:39:47 volumio volumio[910]: info: [1757093987569] CoreMusicLibrary::Adding element Media Servers Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:39:47 volumio sudo[1438]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:47 volumio sudo[1440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 05 20:39:47 volumio sudo[1440]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 05 20:39:47 volumio volumio[910]: info: [1757093987652] CoreMusicLibrary::Adding element Last_100 Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 05 20:39:47 volumio volumio[910]: info: [1757093987654] CoreMusicLibrary::Adding element Webradio Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:39:47 volumio volumio[910]: info: Initializing BBC Radios Sep 05 20:39:47 volumio sudo[1438]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:47 volumio sudo[1429]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: Volumio Calling Home Sep 05 20:39:47 volumio volumio[910]: info: MPD Permissions set Sep 05 20:39:47 volumio volumio[910]: info: MPD Permissions set Sep 05 20:39:47 volumio volumio[910]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Sep 05 20:39:47 volumio systemd[1]: Stopping Music Player Daemon... Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:48 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:39:48 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:39:48 volumio volumio[910]: info: Volumio called home Sep 05 20:39:48 volumio volumio[910]: info: Starting Shairport Sync Sep 05 20:39:48 volumio systemd[1]: mpd.service: Succeeded. Sep 05 20:39:48 volumio systemd[1]: Stopped Music Player Daemon. Sep 05 20:39:48 volumio sudo[1478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 20:39:48 volumio sudo[1478]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:48 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:39:48 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:39:48 volumio volumio[910]: info: Starting Shairport Sync Sep 05 20:39:48 volumio sudo[1482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 20:39:48 volumio systemd[1]: Starting Music Player Daemon... Sep 05 20:39:48 volumio sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 20:39:48 volumio sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:48 volumio sudo[1482]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:48 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 20:39:48 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 05 20:39:48 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 20:39:48 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 20:39:48 volumio sudo[1478]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:48 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 20:39:48 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 05 20:39:48 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 05 20:39:48 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 20:39:48 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 20:39:48 volumio sudo[1482]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:48 volumio sudo[1479]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 05 20:39:48 volumio sudo[1479]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:48 volumio sudo[1484]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:48 volumio sudo[1479]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:48 volumio volumio[910]: info: Shairport-Sync Started Sep 05 20:39:48 volumio volumio[910]: Error adding Membership: Error: addMembership EINVAL Sep 05 20:39:48 volumio volumio[910]: info: Shairport-Sync Started Sep 05 20:39:48 volumio volumio[910]: info: Shairport-Sync Started Sep 05 20:39:48 volumio mpd[1490]: Sep 05 17:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 05 20:39:48 volumio systemd[1]: Started Music Player Daemon. Sep 05 20:39:48 volumio sudo[1431]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:48 volumio sudo[1440]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:52 volumio volumio[910]: info: Completed starting Core Plugins Sep 05 20:39:52 volumio volumio[910]: info: ------------------------------------------- Sep 05 20:39:52 volumio volumio[910]: info: ----- MyVolumio plugins startup ---- Sep 05 20:39:52 volumio volumio[910]: info: ------------------------------------------- Sep 05 20:39:52 volumio volumio[910]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 05 20:39:52 volumio sudo[1515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Sep 05 20:39:52 volumio sudo[1515]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:52 volumio sudo[1518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:39:52 volumio sudo[1518]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:52 volumio volumio[910]: info: MPD running with PID1490 Sep 05 20:39:52 volumio volumio[910]: ,establishing connection Sep 05 20:39:52 volumio sudo[1518]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:52 volumio sudo[1521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:39:52 volumio sudo[1521]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:52 volumio sudo[1521]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:52 volumio volumio[910]: error: MPD error: The expression evaluated to a falsy value: Sep 05 20:39:52 volumio volumio[910]: assert.ok(self.idling) Sep 05 20:39:52 volumio volumio[910]: error: The expression evaluated to a falsy value: Sep 05 20:39:52 volumio volumio[910]: assert.ok(self.idling) Sep 05 20:39:52 volumio volumio[910]: error: MPD error: The expression evaluated to a falsy value: Sep 05 20:39:52 volumio volumio[910]: assert.ok(self.idling) Sep 05 20:39:52 volumio volumio[910]: error: The expression evaluated to a falsy value: Sep 05 20:39:52 volumio volumio[910]: assert.ok(self.idling) Sep 05 20:39:52 volumio volumio[910]: error: updateQueue error: null Sep 05 20:39:52 volumio firststart.sh[911]: Enabling SSH for first boot Sep 05 20:39:52 volumio sudo[1526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 05 20:39:52 volumio sudo[1526]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:39:52 volumio systemd[1]: Starting OpenBSD Secure Shell server... Sep 05 20:39:52 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 05 20:39:52 volumio sudo[1526]: pam_unix(sudo:session): session closed for user root Sep 05 20:39:53 volumio volumio[910]: info: Upmpdcli Daemon Started Sep 05 20:39:53 volumio systemd[1]: systemd-timedated.service: Succeeded. Sep 05 20:39:54 volumio volumio-remote-updater[621]: [2025-09-05 17:39:54] [connect] Successful connection Sep 05 20:39:54 volumio volumio-remote-updater[621]: [2025-09-05 17:39:54] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1757093994 101 Sep 05 20:39:54 volumio volumio[910]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Sep 05 20:39:57 volumio volumio[910]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 05 20:40:00 volumio volumio[910]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 05 20:40:03 volumio sudo[1515]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:03 volumio volumio[910]: info: Adding plugin bluetooth to MyMusic Plugins Sep 05 20:40:03 volumio volumio[910]: info: Adding plugin multiroom to MyMusic Plugins Sep 05 20:40:03 volumio volumio[910]: info: Adding plugin metavolumio to MyMusic Plugins Sep 05 20:40:03 volumio volumio[910]: info: Adding plugin cd_controller to MyMusic Plugins Sep 05 20:40:03 volumio volumio[910]: info: Adding plugin qobuzconnect to MyMusic Plugins Sep 05 20:40:03 volumio volumio[910]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 05 20:40:03 volumio volumio[910]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 05 20:40:03 volumio volumio[910]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 05 20:40:03 volumio sshd[1546]: Server listening on 0.0.0.0 port 22. Sep 05 20:40:03 volumio sshd[1546]: Server listening on :: port 22. Sep 05 20:40:03 volumio systemd[1]: Started OpenBSD Secure Shell server. Sep 05 20:40:03 volumio firststart.sh[911]: Disabling firststart service Sep 05 20:40:03 volumio firststart.sh[911]: Removed /etc/systemd/system/multi-user.target.wants/firststart.service. Sep 05 20:40:03 volumio systemd[1]: Reloading. Sep 05 20:40:04 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. Sep 05 20:40:04 volumio firststart.sh[911]: Finalizing Sep 05 20:40:08 volumio systemd[1]: firststart.service: Succeeded. Sep 05 20:40:08 volumio volumio[910]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 05 20:40:08 volumio volumio[910]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 05 20:40:08 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:40:08 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:40:08 volumio volumio[910]: info: Starting MyVolumio Remote Streaming Endpoints Sep 05 20:40:08 volumio volumio[910]: info: MyVolumio not started Sep 05 20:40:08 volumio volumio[910]: info: Initializing device activation check Sep 05 20:40:08 volumio volumio[910]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 05 20:40:08 volumio volumio[910]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 05 20:40:09 volumio volumio[910]: info: Starting Streaming Service Transparent Proxy Sep 05 20:40:09 volumio volumio[910]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 05 20:40:09 volumio volumio[910]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 05 20:40:09 volumio volumio[910]: info: Streaming services startup Sep 05 20:40:09 volumio volumio[910]: info: Starting Streaming Daemon Sep 05 20:40:09 volumio sudo[1610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 05 20:40:09 volumio sudo[1610]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:09 volumio volumio[910]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 05 20:40:09 volumio sudo[1610]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:09 volumio volumio[910]: error: Cannot start Volumio Streaming Daemon Sep 05 20:40:09 volumio volumio[910]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 05 20:40:09 volumio volumio[910]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 05 20:40:09 volumio volumio[910]: info: Permissions for /etc/hostapd/hostapd.conf Sep 05 20:40:09 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Sep 05 20:40:09 volumio volumio[910]: info: Discovery: Restarting Advertising due to device name change Sep 05 20:40:09 volumio sudo[1618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Sep 05 20:40:09 volumio sudo[1618]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:09 volumio volumio[910]: Upnp client error: Error: This socket has been ended by the other party Sep 05 20:40:09 volumio systemd[1]: Starting Wireless Services... Sep 05 20:40:09 volumio volumio[1529]: Generating RSA private key, 4096 bit long modulus (2 primes) Sep 05 20:40:10 volumio wireless.js[1621]: Cleaning previous... Sep 05 20:40:10 volumio systemd[1]: Stopping Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Sep 05 20:40:10 volumio volumio[910]: STREAMING PROXY: Starting server on port 3245 Sep 05 20:40:10 volumio volumio[910]: Node JS runtime: 14 Sep 05 20:40:10 volumio sudo[1649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:40:10 volumio sudo[1649]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:10 volumio sudo[1649]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:10 volumio sudo[1651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:40:10 volumio sudo[1651]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:10 volumio sudo[1651]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:10 volumio volumio[910]: verbose: New Socket.io Connection to 192.168.5.100 from 192.168.5.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 3 Sep 05 20:40:10 volumio systemd[1]: hostapd.service: Succeeded. Sep 05 20:40:10 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Sep 05 20:40:10 volumio volumio[910]: info: Discovery: A device disappeared from network Sep 05 20:40:10 volumio volumio[910]: info: Discovery: Device volumio disappeared from network Sep 05 20:40:10 volumio volumio[910]: info: Discovery: A device disappeared from network Sep 05 20:40:10 volumio sudo[1655]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 05 20:40:10 volumio sudo[1655]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:10 volumio avahi-daemon[623]: Withdrawing address record for 192.168.211.1 on wlan0. Sep 05 20:40:10 volumio avahi-daemon[623]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Sep 05 20:40:10 volumio avahi-daemon[623]: Interface wlan0.IPv4 no longer relevant for mDNS. Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Sep 05 20:40:10 volumio sudo[1655]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Sep 05 20:40:10 volumio sudo[1657]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 05 20:40:10 volumio sudo[1657]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Sep 05 20:40:10 volumio volumio[910]: info: Received Get System Info Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:40:10 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:40:10 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:40:10 volumio volumio-remote-updater[621]: No test mode Sep 05 20:40:10 volumio volumio-remote-updater[621]: No alpha test mode Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:10 volumio volumio[910]: info: Retrieving Cloud Streaming UI Sep 05 20:40:10 volumio volumio[910]: info: Getting Tidal Cloud Configuration Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:10 volumio volumio[910]: info: Getting Qobuz Cloud Configuration Sep 05 20:40:10 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:10 volumio volumio[910]: info: Getting Spotify Cloud Configuration Sep 05 20:40:10 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:10 volumio volumio[910]: info: Saving Spotify Acccount Sep 05 20:40:10 volumio volumio[910]: info: Got Tidal Cloud Configuration Sep 05 20:40:10 volumio volumio[910]: info: Got it Sep 05 20:40:10 volumio volumio[910]: info: Got it Sep 05 20:40:10 volumio volumio[910]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:10 volumio volumio[910]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 05 20:40:10 volumio volumio[910]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 05 20:40:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 05 20:40:11 volumio sudo[1657]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:11 volumio wireless.js[1621]: Stopped aP Sep 05 20:40:11 volumio sudo[1668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 05 20:40:11 volumio sudo[1668]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:11 volumio sudo[1668]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:11 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 05 20:40:11 volumio sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Sep 05 20:40:11 volumio sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:11 volumio sudo[1670]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:11 volumio sudo[1677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 05 20:40:11 volumio sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:11 volumio sudo[1677]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:11 volumio sudo[1679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Sep 05 20:40:11 volumio sudo[1679]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:11 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 05 20:40:11 volumio volumio[910]: info: Loading i18n strings for locale ru Sep 05 20:40:11 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Sep 05 20:40:11 volumio volumio[910]: info: Setting timezone to Europe/Kyiv Sep 05 20:40:11 volumio sudo[1698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Sep 05 20:40:11 volumio sudo[1698]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:11 volumio sudo[1698]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:11 volumio sudo[1701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kyiv /etc/localtime Sep 05 20:40:11 volumio sudo[1701]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:11 volumio sudo[1701]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:11 volumio sudo[1704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Sep 05 20:40:11 volumio sudo[1704]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:12 volumio sudo[1704]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:12 volumio sudo[1707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kyiv Sep 05 20:40:12 volumio sudo[1707]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:12 volumio dbus-daemon[610]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.17' (uid=0 pid=1708 comm="/usr/bin/timedatectl set-timezone Europe/Kyiv ") Sep 05 20:40:12 volumio systemd[1]: Starting Time & Date Service... Sep 05 20:40:12 volumio dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 05 20:40:12 volumio systemd[1]: Started Time & Date Service. Sep 05 20:40:12 volumio sudo[1707]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:12 volumio volumio[910]: Updating browse sources language Sep 05 20:40:12 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:40:12 volumio volumio[910]: info: Fetching Streaming Services browse cache Sep 05 20:40:12 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 05 20:40:12 volumio ntpd[804]: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=54 secs Sep 05 20:40:14 volumio sudo[1679]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:14 volumio wireless.js[1621]: SETTING APPROPRIATE REG DOMAIN: US Sep 05 20:40:14 volumio sudo[1714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 05 20:40:14 volumio sudo[1714]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:14 volumio sudo[1714]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:14 volumio sudo[1716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set US Sep 05 20:40:14 volumio sudo[1716]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:14 volumio sudo[1716]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:14 volumio wireless.js[1621]: SUCCESSFULLY SET NEW REGDOMAIN: US Sep 05 20:40:14 volumio sudo[1723]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 05 20:40:14 volumio sudo[1723]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:14 volumio sudo[1723]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:14 volumio sudo[1725]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 05 20:40:14 volumio sudo[1725]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:14 volumio volumio[910]: info: Discovery: Started advertising with name: Volumio Sep 05 20:40:14 volumio sudo[1725]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:14 volumio avahi-daemon[623]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Sep 05 20:40:14 volumio avahi-daemon[623]: New relevant interface wlan0.IPv4 for mDNS. Sep 05 20:40:14 volumio avahi-daemon[623]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Sep 05 20:40:14 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 05 20:40:14 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Sep 05 20:40:14 volumio hostapd[1732]: Configuration file: /etc/hostapd/hostapd.conf Sep 05 20:40:14 volumio hostapd[1732]: wlan0: Could not connect to kernel driver Sep 05 20:40:14 volumio hostapd[1732]: Using interface wlan0 with hwaddr dc:a6:32:67:bb:fc and ssid "Volumio-72520" Sep 05 20:40:15 volumio hostapd[1732]: wlan0: interface state UNINITIALIZED->ENABLED Sep 05 20:40:15 volumio hostapd[1732]: wlan0: AP-ENABLED Sep 05 20:40:15 volumio systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Sep 05 20:40:15 volumio ntpd[804]: Soliciting pool server 193.106.144.7 Sep 05 20:40:15 volumio iwconfig[1736]: Error for wireless request "Set Power Management" (8B2C) : Sep 05 20:40:15 volumio iwconfig[1736]: SET failed on device wlan0 ; Invalid argument. Sep 05 20:40:15 volumio systemd[1]: wireless.service: Succeeded. Sep 05 20:40:15 volumio systemd[1]: Started Wireless Services. Sep 05 20:40:15 volumio sudo[1618]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:15 volumio volumio[910]: info: Discovery: adding bb006ffd-17c4-471a-8f4c-8ff8cecf05ea Sep 05 20:40:15 volumio volumio[910]: info: Discovery: Found device Volumio Sep 05 20:40:15 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:40:15 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:40:15 volumio volumio[910]: info: Discovery: this is already registered, bb006ffd-17c4-471a-8f4c-8ff8cecf05ea Sep 05 20:40:15 volumio volumio[910]: info: Discovery: Found device Volumio Sep 05 20:40:15 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:40:15 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:40:15 volumio ntpd[804]: Soliciting pool server 162.159.200.123 Sep 05 20:40:16 volumio ntpd[804]: Soliciting pool server 193.34.155.4 Sep 05 20:40:16 volumio ntpd[804]: Soliciting pool server 193.34.155.3 Sep 05 20:40:16 volumio ntpd[804]: Soliciting pool server 193.106.144.13 Sep 05 20:40:16 volumio ntpd[804]: Soliciting pool server 162.159.200.1 Sep 05 20:40:16 volumio ntpd[804]: Soliciting pool server 79.142.192.130 Sep 05 20:40:16 volumio ntpd[804]: Listen normally on 5 wlan0 192.168.211.1:123 Sep 05 20:40:16 volumio ntpd[804]: new interface(s) found: waking up resolver Sep 05 20:40:17 volumio ntpd[804]: Soliciting pool server 194.8.146.38 Sep 05 20:40:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:40:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:40:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:40:17 volumio volumio[1529]: ........................................................................................++++ Sep 05 20:40:17 volumio volumio-remote-updater[621]: No test mode Sep 05 20:40:17 volumio volumio-remote-updater[621]: No alpha test mode Sep 05 20:40:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 05 20:40:17 volumio ntpd[804]: Soliciting pool server 194.8.144.107 Sep 05 20:40:17 volumio ntpd[804]: Soliciting pool server 91.236.251.31 Sep 05 20:40:17 volumio ntpd[804]: Soliciting pool server 91.210.190.13 Sep 05 20:40:17 volumio ntpd[804]: Soliciting pool server 109.110.82.19 Sep 05 20:40:18 volumio volumio[910]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 05 20:40:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 05 20:40:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 05 20:40:18 volumio volumio[910]: info: Loading i18n strings for locale ru Sep 05 20:40:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Sep 05 20:40:18 volumio volumio[910]: info: Setting timezone to Europe/Kyiv Sep 05 20:40:18 volumio sudo[1742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Sep 05 20:40:18 volumio sudo[1742]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:18 volumio sudo[1742]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:18 volumio sudo[1745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kyiv /etc/localtime Sep 05 20:40:18 volumio sudo[1745]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:18 volumio sudo[1745]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:18 volumio sudo[1748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Sep 05 20:40:18 volumio sudo[1748]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:18 volumio sudo[1748]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:18 volumio sudo[1751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kyiv Sep 05 20:40:18 volumio sudo[1751]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:18 volumio sudo[1751]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 05 20:40:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 05 20:40:18 volumio sudo[1754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 05 20:40:18 volumio volumio[910]: Updating browse sources language Sep 05 20:40:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:40:18 volumio sudo[1754]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:18 volumio ntpd[804]: Soliciting pool server 91.236.251.34 Sep 05 20:40:18 volumio ntpd[804]: Soliciting pool server 46.173.175.211 Sep 05 20:40:18 volumio ntpd[804]: Soliciting pool server 91.231.182.17 Sep 05 20:40:19 volumio volumio[910]: info: Fetching Streaming Services browse cache Sep 05 20:40:19 volumio ntpd[804]: Soliciting pool server 91.236.251.13 Sep 05 20:40:20 volumio volumio[1529]: .......................++++ Sep 05 20:40:20 volumio volumio[1529]: e is 65537 (0x010001) Sep 05 20:40:20 volumio volumio[1529]: writing RSA key Sep 05 20:40:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Sep 05 20:40:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Sep 05 20:40:20 volumio sudo[1765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:40:20 volumio sudo[1765]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:20 volumio sudo[1765]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:20 volumio ntpd[804]: Soliciting pool server 2606:4700:f1::1 Sep 05 20:40:23 volumio ntpd[804]: receive: Unexpected origin timestamp 0xec659f05.fe4f8072 does not match aorg 0000000000.00000000 from server@194.8.144.107 xmt 0xec659f07.7df25784 Sep 05 20:40:23 volumio ntpd[804]: receive: Unexpected origin timestamp 0xec659f05.fe507ce6 does not match aorg 0000000000.00000000 from server@194.8.146.38 xmt 0xec659f07.7e5cb35f Sep 05 20:40:23 volumio ntpd[804]: receive: Unexpected origin timestamp 0xec659f05.fe516482 does not match aorg 0000000000.00000000 from server@79.142.192.130 xmt 0xec659f07.7e16b867 Sep 05 20:40:23 volumio ntpd[804]: receive: Unexpected origin timestamp 0xec659f05.fe4b9364 does not match aorg 0000000000.00000000 from server@46.173.175.211 xmt 0xec659f07.81783dff Sep 05 20:40:23 volumio ntpd[804]: receive: Unexpected origin timestamp 0xec659f05.fe4e47ea does not match aorg 0000000000.00000000 from server@91.236.251.31 xmt 0xec659f07.83c83582 Sep 05 20:40:24 volumio sudo[1754]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:25 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:40:25 volumio volumio[910]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Sep 05 20:40:25 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:40:25 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:40:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Sep 05 20:40:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Sep 05 20:40:26 volumio volumio[910]: info: Refreshing Cached IP Addresses Sep 05 20:40:26 volumio sudo[1801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Sep 05 20:40:26 volumio sudo[1801]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:26 volumio sudo[1801]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:26 volumio sudo[1804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:40:26 volumio sudo[1804]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:26 volumio sudo[1804]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:26 volumio systemd[1]: upmpdcli.service: Succeeded. Sep 05 20:40:26 volumio sudo[1806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:40:26 volumio sudo[1806]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:26 volumio sudo[1806]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:40:30 volumio volumio[910]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 05 20:40:30 volumio volumio[910]: info: Received Get System Version Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:40:30 volumio volumio[910]: info: Received Get System Info Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:40:30 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:40:30 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:40:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:40:31 volumio volumio[910]: error: MyVolumio Plugin failed to authenticate in a timely fashion Sep 05 20:40:31 volumio volumio[910]: info: Completed starting MyVolumio Plugin Sep 05 20:40:31 volumio volumio[910]: [Metrics] CommandRouter: 49s 863.48ms Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::volumiosetStartupVolume Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::Close All Modals sent Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::Close All Modals sent Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:31 volumio volumio[910]: info: Retrieving Cloud Streaming UI Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:31 volumio volumio[910]: info: Retrieving Cloud Streaming UI Sep 05 20:40:31 volumio volumio[910]: info: Getting Tidal Cloud Configuration Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:31 volumio volumio[910]: info: Getting Qobuz Cloud Configuration Sep 05 20:40:31 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:31 volumio volumio[910]: info: Getting Spotify Cloud Configuration Sep 05 20:40:31 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:31 volumio volumio[910]: info: Saving Spotify Acccount Sep 05 20:40:31 volumio volumio[910]: info: Got Tidal Cloud Configuration Sep 05 20:40:31 volumio volumio[910]: info: Got it Sep 05 20:40:31 volumio volumio[910]: info: Got it Sep 05 20:40:31 volumio volumio[910]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 20:40:31 volumio volumio[910]: info: Getting Tidal Cloud Configuration Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:31 volumio volumio[910]: info: Getting Qobuz Cloud Configuration Sep 05 20:40:31 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:31 volumio volumio[910]: info: Getting Spotify Cloud Configuration Sep 05 20:40:31 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:31 volumio volumio[910]: info: Saving Spotify Acccount Sep 05 20:40:31 volumio volumio[910]: info: Got Tidal Cloud Configuration Sep 05 20:40:31 volumio volumio[910]: info: Got it Sep 05 20:40:31 volumio volumio[910]: info: Got it Sep 05 20:40:31 volumio volumio[910]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:31 volumio volumio[910]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 05 20:40:31 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:31 volumio volumio[910]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 05 20:40:32 volumio volumio[910]: info: Version has changed, forcing UI Reload Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::Reload Ui Sep 05 20:40:32 volumio sudo[1814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:40:32 volumio sudo[1814]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:32 volumio sudo[1814]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:32 volumio sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:40:32 volumio sudo[1816]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:32 volumio sudo[1816]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:32 volumio volumio[910]: verbose: New Socket.io Connection to 192.168.5.100 from 192.168.5.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 4 Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Sep 05 20:40:32 volumio volumio[910]: info: Received Get System Info Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:40:32 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:40:32 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:32 volumio volumio-remote-updater[621]: No test mode Sep 05 20:40:32 volumio volumio[910]: info: Retrieving Cloud Streaming UI Sep 05 20:40:32 volumio volumio-remote-updater[621]: No alpha test mode Sep 05 20:40:32 volumio volumio[910]: info: Getting Tidal Cloud Configuration Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:32 volumio volumio[910]: info: Getting Qobuz Cloud Configuration Sep 05 20:40:32 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:32 volumio volumio[910]: info: Getting Spotify Cloud Configuration Sep 05 20:40:32 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:32 volumio volumio[910]: info: Saving Spotify Acccount Sep 05 20:40:32 volumio volumio[910]: info: Got Tidal Cloud Configuration Sep 05 20:40:32 volumio volumio[910]: info: Got it Sep 05 20:40:32 volumio volumio[910]: info: Got it Sep 05 20:40:32 volumio volumio[910]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:40:32 volumio volumio[910]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 05 20:40:32 volumio volumio[910]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 05 20:40:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 05 20:40:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 05 20:40:33 volumio volumio[910]: info: Loading i18n strings for locale ru Sep 05 20:40:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Sep 05 20:40:33 volumio volumio[910]: info: Setting timezone to Europe/Kyiv Sep 05 20:40:33 volumio sudo[1838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Sep 05 20:40:33 volumio sudo[1838]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:33 volumio sudo[1838]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:33 volumio sudo[1841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kyiv /etc/localtime Sep 05 20:40:33 volumio sudo[1841]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:33 volumio sudo[1841]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:33 volumio sudo[1844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Sep 05 20:40:33 volumio sudo[1844]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:33 volumio sudo[1844]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:33 volumio sudo[1847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kyiv Sep 05 20:40:33 volumio sudo[1847]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:33 volumio sudo[1847]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:34 volumio volumio[910]: Updating browse sources language Sep 05 20:40:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:40:34 volumio volumio[910]: info: Fetching Streaming Services browse cache Sep 05 20:40:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 05 20:40:36 volumio sudo[1853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:40:36 volumio sudo[1853]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:36 volumio sudo[1853]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:36 volumio sudo[1856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:40:36 volumio sudo[1856]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:36 volumio sudo[1856]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:36 volumio sudo[1859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 05 20:40:36 volumio sudo[1859]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:36 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 05 20:40:36 volumio volumio[910]: info: Loading i18n strings for locale ru Sep 05 20:40:36 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 05 20:40:36 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Sep 05 20:40:36 volumio volumio[910]: info: Setting timezone to Europe/Kyiv Sep 05 20:40:36 volumio sudo[1859]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:36 volumio sudo[1863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Sep 05 20:40:36 volumio sudo[1863]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:36 volumio sudo[1863]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:36 volumio sudo[1866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kyiv /etc/localtime Sep 05 20:40:36 volumio sudo[1866]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:36 volumio sudo[1866]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:36 volumio sudo[1869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Sep 05 20:40:36 volumio sudo[1869]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:36 volumio sudo[1869]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:36 volumio sudo[1872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kyiv Sep 05 20:40:36 volumio sudo[1872]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:36 volumio sudo[1872]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:36 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 05 20:40:36 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 05 20:40:36 volumio volumio[910]: info: Upmpdcli Daemon Started Sep 05 20:40:36 volumio sudo[1875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 05 20:40:36 volumio sudo[1875]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:40:36 volumio volumio[910]: Updating browse sources language Sep 05 20:40:36 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:40:37 volumio volumio[1861]: writing RSA key Sep 05 20:40:37 volumio volumio[910]: info: Fetching Streaming Services browse cache Sep 05 20:40:38 volumio volumio[910]: info: BOOT COMPLETED Sep 05 20:40:41 volumio sudo[1875]: pam_unix(sudo:session): session closed for user root Sep 05 20:40:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Sep 05 20:40:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:40:43 volumio volumio-remote-updater[621]: No test mode Sep 05 20:40:43 volumio volumio-remote-updater[621]: No alpha test mode Sep 05 20:40:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 05 20:40:44 volumio volumio[910]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 05 20:40:44 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 05 20:40:50 volumio volumio-remote-updater[621]: No test mode Sep 05 20:40:50 volumio volumio-remote-updater[621]: No alpha test mode Sep 05 20:40:50 volumio volumio[910]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:40:50 volumio volumio[910]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 05 20:40:50 volumio volumio[910]: info: Received Get System Version Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:40:50 volumio volumio[910]: info: Received Get System Info Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:40:50 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:40:50 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:40:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:41:03 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Sep 05 20:41:03 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:41:04 volumio volumio-remote-updater[621]: No test mode Sep 05 20:41:04 volumio volumio-remote-updater[621]: No alpha test mode Sep 05 20:41:04 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 05 20:41:04 volumio volumio[910]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 05 20:41:04 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 05 20:41:04 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Sep 05 20:41:04 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Sep 05 20:41:04 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 05 20:41:04 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:41:04 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:41:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Sep 05 20:41:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:41:06 volumio systemd[1]: systemd-timedated.service: Succeeded. Sep 05 20:41:07 volumio volumio-remote-updater[621]: No test mode Sep 05 20:41:07 volumio volumio-remote-updater[621]: No alpha test mode Sep 05 20:41:07 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 05 20:41:07 volumio volumio[910]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 05 20:41:07 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Sep 05 20:43:46 volumio volumio[910]: info: Preparing to save Alsa Options, stopping services first Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:43:46 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::volumioPause Sep 05 20:43:46 volumio volumio[910]: info: CoreStateMachine::pause Sep 05 20:43:46 volumio volumio[910]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"value":"iqaudio-amp","label":"IQaudIO Pi-DigiAMP+"},"output_device":{"value":1,"label":"IQaudIO Pi-DigiAMP+"},"disallowPush":true} Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:46 volumio volumio[910]: info: Enabling I2S DAC: IQaudIO Pi-DigiAMP+ Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:46 volumio sudo[2365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Sep 05 20:43:46 volumio sudo[2365]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:46 volumio sudo[2365]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:46 volumio volumio[910]: info: No Overlays Loaded Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:46 volumio sudo[2368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay iqaudio-dacplus Sep 05 20:43:46 volumio sudo[2368]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:46 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2s@7e203000/status Sep 05 20:43:46 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/i2c@7e804000/status Sep 05 20:43:46 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Sep 05 20:43:46 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Sep 05 20:43:46 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/mute-gpios Sep 05 20:43:46 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Sep 05 20:43:46 volumio sudo[2368]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:46 volumio volumio[910]: warn: Unable to locate the device IQaudIO Pi-DigiAMP+ a reboot may be required. Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:46 volumio volumio[910]: info: Found match in i2s Card Database: setting mixer Digital for card IQaudIO Pi-DigiAMP+ Sep 05 20:43:46 volumio systemd-udevd[2380]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 2' failed with exit code 99. Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 05 20:43:46 volumio volumio[910]: info: Updating Volume Controller Parameters: Device: 2 Name: IQaudIO Pi-DigiAMP+ Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 05 20:43:46 volumio volumio[910]: info: Disabling external Volume Control Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Sep 05 20:43:46 volumio volumio[910]: info: Preparing to generate the ALSA configuration file Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 05 20:43:46 volumio sudo[2409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 05 20:43:46 volumio sudo[2409]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:46 volumio sudo[2412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 05 20:43:46 volumio sudo[2412]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:46 volumio sudo[2412]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:46 volumio volumio[910]: info: Data script executed Sep 05 20:43:46 volumio volumio[910]: info: I2S Param [object Object] successfully enabled Sep 05 20:43:46 volumio volumio[910]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 05 20:43:46 volumio volumio[910]: wlan0 Interface doesn't support scanning : Device or resource busy Sep 05 20:43:46 volumio volumio[910]: info: Cannot use regular scanning, forcing with ap-force Sep 05 20:43:46 volumio sudo[2416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 05 20:43:46 volumio sudo[2416]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:46 volumio sudo[2416]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:46 volumio volumio[910]: command failed: Device or resource busy (-16) Sep 05 20:43:46 volumio volumio[910]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 05 20:43:46 volumio volumio[910]: command failed: Device or resource busy (-16) Sep 05 20:43:46 volumio volumio[910]: info: VolumeController:: Volume=100 Mute =false Sep 05 20:43:46 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:43:46 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:43:46 volumio volumio[910]: info: Getting Alsa Cards List without I2S DAC Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Sep 05 20:43:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 05 20:43:47 volumio volumio[910]: info: Asound.conf file written Sep 05 20:43:47 volumio sudo[2427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 05 20:43:47 volumio sudo[2427]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:47 volumio sudo[2427]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:47 volumio volumio[910]: No state is present for card b1 Sep 05 20:43:47 volumio volumio[910]: /usr/share/alsa/init/bcm2835:14: control element not found Sep 05 20:43:47 volumio volumio[910]: No state is present for card b1 Sep 05 20:43:47 volumio volumio[910]: No state is present for card Headphones Sep 05 20:43:47 volumio volumio[910]: /usr/share/alsa/init/bcm2835:20: control element not found Sep 05 20:43:47 volumio volumio[910]: No state is present for card Headphones Sep 05 20:43:47 volumio volumio[910]: No state is present for card IQaudIODAC Sep 05 20:43:47 volumio volumio[910]: Found hardware: "IQaudIODAC" "" "" "" "" Sep 05 20:43:47 volumio volumio[910]: Hardware is initialized using a generic method Sep 05 20:43:47 volumio volumio[910]: No state is present for card IQaudIODAC Sep 05 20:43:47 volumio volumio[910]: info: Output device has changed, restarting MPD Sep 05 20:43:47 volumio sudo[2432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 05 20:43:47 volumio sudo[2432]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:47 volumio volumio[910]: info: Output device has changed, restarting Shairport Sync Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:47 volumio sudo[2432]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:47 volumio sudo[2435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 05 20:43:47 volumio sudo[2435]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:47 volumio systemd[1]: Stopping Music Player Daemon... Sep 05 20:43:47 volumio volumio[910]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 20:43:47 volumio volumio[910]: info: Output device has changed, restarting MPD Sep 05 20:43:47 volumio systemd[1]: mpd.service: Succeeded. Sep 05 20:43:47 volumio systemd[1]: Stopped Music Player Daemon. Sep 05 20:43:47 volumio sudo[2442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 05 20:43:47 volumio sudo[2442]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:47 volumio volumio[910]: info: Output device has changed, restarting Shairport Sync Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:47 volumio sudo[2442]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:47 volumio sudo[2445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 05 20:43:47 volumio sudo[2445]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:47 volumio systemd[1]: Starting Music Player Daemon... Sep 05 20:43:47 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Sep 05 20:43:47 volumio systemd[1]: mpd.service: Succeeded. Sep 05 20:43:47 volumio systemd[1]: Stopped Music Player Daemon. Sep 05 20:43:47 volumio systemd[1]: Starting Music Player Daemon... Sep 05 20:43:47 volumio volumio[910]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 20:43:47 volumio volumio[910]: info: MPD Permissions set Sep 05 20:43:47 volumio volumio[910]: info: MPD Permissions set Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:43:47 volumio volumio[910]: info: Starting Shairport Sync Sep 05 20:43:47 volumio sudo[2450]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 05 20:43:47 volumio sudo[2450]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:47 volumio sudo[2450]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:47 volumio volumio[910]: info: Starting Shairport Sync Sep 05 20:43:47 volumio sudo[2461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 20:43:47 volumio sudo[2461]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:47 volumio sudo[2464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 20:43:47 volumio sudo[2464]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:47 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 20:43:47 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 05 20:43:47 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 20:43:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 20:43:47 volumio sudo[2461]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:47 volumio volumio[910]: info: Shairport-Sync Started Sep 05 20:43:47 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 20:43:47 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 05 20:43:47 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 05 20:43:47 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 20:43:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 20:43:47 volumio sudo[2464]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:47 volumio volumio[910]: info: Shairport-Sync Started Sep 05 20:43:47 volumio mpd[2462]: Sep 05 20:43 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 05 20:43:47 volumio systemd[1]: Started Music Player Daemon. Sep 05 20:43:47 volumio sudo[2445]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:47 volumio sudo[2435]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:47 volumio volumio[910]: error: MPD error: The expression evaluated to a falsy value: Sep 05 20:43:47 volumio volumio[910]: assert.ok(self.idling) Sep 05 20:43:47 volumio volumio[910]: error: The expression evaluated to a falsy value: Sep 05 20:43:47 volumio volumio[910]: assert.ok(self.idling) Sep 05 20:43:47 volumio volumio[910]: error: updateQueue error: null Sep 05 20:43:50 volumio volumio[910]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 05 20:43:50 volumio volumio[910]: info: CoreStateMachine::getcurrentVolume Sep 05 20:43:50 volumio volumio[910]: info: CoreCommandRouter::volumioRetrievevolume Sep 05 20:43:50 volumio volumio[910]: info: VolumeController:: Volume=100 Mute =false Sep 05 20:43:50 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:43:50 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:43:50 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:43:50 volumio volumio[910]: info: CoreStateMachine::updateTrackBlock Sep 05 20:43:50 volumio volumio[910]: info: CorePlayQueue::getTrackBlock Sep 05 20:43:50 volumio volumio[910]: info: CoreCommandRouter::volumioRetrievevolume Sep 05 20:43:50 volumio sudo[2409]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:50 volumio volumio[910]: info: VolumeController:: Volume=100 Mute =false Sep 05 20:43:50 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:43:50 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:43:50 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:43:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork Sep 05 20:43:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo Sep 05 20:43:57 volumio sudo[2498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:43:57 volumio sudo[2498]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:57 volumio sudo[2498]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Sep 05 20:43:57 volumio volumio[910]: info: Saving new wireless network Sep 05 20:43:57 volumio sudo[2501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Sep 05 20:43:57 volumio sudo[2501]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:58 volumio sudo[2501]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:58 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Sep 05 20:43:58 volumio volumio[910]: info: Discovery: Restarting Advertising due to device name change Sep 05 20:43:58 volumio sudo[2504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Sep 05 20:43:58 volumio sudo[2504]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:58 volumio systemd[1]: Starting Wireless Services... Sep 05 20:43:58 volumio wireless.js[2506]: Cleaning previous... Sep 05 20:43:58 volumio systemd[1]: Stopping Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Sep 05 20:43:59 volumio systemd[1]: hostapd.service: Succeeded. Sep 05 20:43:59 volumio systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Sep 05 20:43:59 volumio sudo[2520]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 05 20:43:59 volumio sudo[2520]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:59 volumio avahi-daemon[623]: Withdrawing address record for 192.168.211.1 on wlan0. Sep 05 20:43:59 volumio avahi-daemon[623]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Sep 05 20:43:59 volumio avahi-daemon[623]: Interface wlan0.IPv4 no longer relevant for mDNS. Sep 05 20:43:59 volumio sudo[2520]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:59 volumio volumio[910]: info: Discovery: A device disappeared from network Sep 05 20:43:59 volumio volumio[910]: info: Discovery: Device volumio disappeared from network Sep 05 20:43:59 volumio sudo[2522]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 05 20:43:59 volumio sudo[2522]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:59 volumio volumio[910]: info: Discovery: A device disappeared from network Sep 05 20:43:59 volumio sudo[2522]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:59 volumio wireless.js[2506]: Stopped aP Sep 05 20:43:59 volumio sudo[2529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 05 20:43:59 volumio sudo[2529]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:59 volumio sudo[2529]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:59 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 05 20:43:59 volumio sudo[2531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Sep 05 20:43:59 volumio sudo[2531]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:59 volumio sudo[2531]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:59 volumio sudo[2538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 05 20:43:59 volumio sudo[2538]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:43:59 volumio sudo[2538]: pam_unix(sudo:session): session closed for user root Sep 05 20:43:59 volumio sudo[2540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Sep 05 20:43:59 volumio sudo[2540]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:01 volumio ntpd[804]: Deleting interface #5 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=223 secs Sep 05 20:44:02 volumio sudo[2540]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:02 volumio wireless.js[2506]: SETTING APPROPRIATE REG DOMAIN: US Sep 05 20:44:02 volumio sudo[2545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Sep 05 20:44:02 volumio sudo[2545]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:02 volumio sudo[2545]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:02 volumio sudo[2547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set US Sep 05 20:44:02 volumio sudo[2547]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:02 volumio sudo[2547]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:02 volumio wireless.js[2506]: SUCCESSFULLY SET NEW REGDOMAIN: US Sep 05 20:44:02 volumio wireless.js[2506]: Start wireless flow Sep 05 20:44:02 volumio wireless.js[2506]: Stopped hotspot (if there).. Sep 05 20:44:02 volumio sudo[2552]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 05 20:44:02 volumio sudo[2552]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:02 volumio sudo[2552]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:02 volumio sudo[2554]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 05 20:44:02 volumio sudo[2554]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:03 volumio volumio[910]: info: Discovery: Started advertising with name: Volumio Sep 05 20:44:03 volumio sudo[2554]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:03 volumio wireless.js[2506]: DHCP IP Sep 05 20:44:03 volumio wireless.js[2506]: Start ap Sep 05 20:44:03 volumio wpa_supplicant[2557]: Successfully initialized wpa_supplicant Sep 05 20:44:03 volumio sudo[2558]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Sep 05 20:44:03 volumio sudo[2558]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:03 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 05 20:44:03 volumio dhcpcd[2559]: dev: loaded udev Sep 05 20:44:03 volumio dhcpcd-run-hooks[2568]: wlan0: starting wpa_supplicant Sep 05 20:44:03 volumio dhcpcd-run-hooks[2573]: wlan0: failed to start wpa_supplicant Sep 05 20:44:03 volumio dhcpcd-run-hooks[2574]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Sep 05 20:44:03 volumio dhcpcd[2559]: wlan0: connected to Access Point `' Sep 05 20:44:03 volumio dhcpcd[2559]: DUID 00:01:00:01:30:17:4e:dc:dc:a6:32:67:bb:f7 Sep 05 20:44:03 volumio dhcpcd[2559]: eth0: IAID 32:67:bb:f7 Sep 05 20:44:03 volumio dhcpcd[2559]: eth0: adding address fe80::42f3:c041:33f5:797b Sep 05 20:44:03 volumio dhcpcd[2559]: ipv6_addaddr1: Permission denied Sep 05 20:44:03 volumio dhcpcd[2559]: wlan0: waiting for carrier Sep 05 20:44:03 volumio dhcpcd[2559]: eth0: soliciting a DHCP lease Sep 05 20:44:03 volumio dhcpcd[2559]: eth0: soliciting an IPv6 router Sep 05 20:44:03 volumio dhcpcd[2559]: eth0: offered 192.168.5.100 from 192.168.5.1 Sep 05 20:44:03 volumio dhcpcd[2559]: eth0: leased 192.168.5.100 for 7200 seconds Sep 05 20:44:03 volumio dhcpcd[2559]: eth0: adding route to 192.168.5.0/24 Sep 05 20:44:03 volumio dhcpcd[2559]: eth0: adding default route via 192.168.5.1 Sep 05 20:44:03 volumio dhcpcd[2559]: forked to background, child pid 2625 Sep 05 20:44:03 volumio volumio[910]: info: Discovery: adding bb006ffd-17c4-471a-8f4c-8ff8cecf05ea Sep 05 20:44:03 volumio volumio[910]: info: Discovery: Found device Volumio Sep 05 20:44:03 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:03 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:03 volumio sudo[2558]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:04 volumio wireless.js[2506]: trying... Sep 05 20:44:04 volumio sudo[2628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:04 volumio sudo[2628]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:04 volumio sudo[2628]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:05 volumio wireless.js[2506]: trying... Sep 05 20:44:05 volumio sudo[2631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:05 volumio sudo[2631]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:05 volumio sudo[2631]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:06 volumio wireless.js[2506]: trying... Sep 05 20:44:06 volumio sudo[2634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:06 volumio sudo[2634]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:06 volumio sudo[2634]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:07 volumio wireless.js[2506]: trying... Sep 05 20:44:07 volumio sudo[2639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:07 volumio sudo[2639]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:07 volumio sudo[2639]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:07 volumio kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Sep 05 20:44:07 volumio kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Sep 05 20:44:07 volumio kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Sep 05 20:44:07 volumio kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Sep 05 20:44:08 volumio wireless.js[2506]: trying... Sep 05 20:44:08 volumio sudo[2683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:08 volumio sudo[2683]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:08 volumio sudo[2683]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:09 volumio wireless.js[2506]: trying... Sep 05 20:44:09 volumio sudo[2686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:09 volumio sudo[2686]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:09 volumio sudo[2686]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:10 volumio wpa_supplicant[2572]: wlan0: Trying to associate with SSID 'Midnight-5-sr' Sep 05 20:44:10 volumio wireless.js[2506]: trying... Sep 05 20:44:10 volumio sudo[2690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:10 volumio sudo[2690]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:10 volumio sudo[2690]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:10 volumio dhcpcd[2625]: wlan0: carrier acquired Sep 05 20:44:10 volumio dhcpcd[2625]: wlan0: connected to Access Point `Midnight-5-sr' Sep 05 20:44:10 volumio wpa_supplicant[2572]: wlan0: Associated with 48:8f:5a:28:a8:b8 Sep 05 20:44:10 volumio wpa_supplicant[2572]: wlan0: CTRL-EVENT-CONNECTED - Connection to 48:8f:5a:28:a8:b8 completed [id=0 id_str=] Sep 05 20:44:10 volumio wpa_supplicant[2572]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Sep 05 20:44:10 volumio dhcpcd[2625]: wlan0: IAID 32:67:bb:fc Sep 05 20:44:10 volumio dhcpcd[2625]: wlan0: adding address fe80::7337:9610:c9f9:6737 Sep 05 20:44:10 volumio dhcpcd[2625]: ipv6_addaddr1: Permission denied Sep 05 20:44:10 volumio dhcpcd[2625]: wlan0: carrier lost Sep 05 20:44:10 volumio dhcpcd[2625]: wlan0: carrier acquired Sep 05 20:44:10 volumio dhcpcd[2625]: wlan0: IAID 32:67:bb:fc Sep 05 20:44:10 volumio dhcpcd[2625]: wlan0: soliciting an IPv6 router Sep 05 20:44:10 volumio dhcpcd[2625]: wlan0: soliciting a DHCP lease Sep 05 20:44:11 volumio wireless.js[2506]: trying... Sep 05 20:44:11 volumio sudo[2712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:11 volumio sudo[2712]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:11 volumio sudo[2712]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:11 volumio dhcpcd[2625]: wlan0: offered 192.168.5.101 from 192.168.5.1 Sep 05 20:44:11 volumio dhcpcd[2625]: wlan0: probing address 192.168.5.101/24 Sep 05 20:44:12 volumio wireless.js[2506]: trying... Sep 05 20:44:12 volumio sudo[2716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:12 volumio sudo[2716]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:12 volumio sudo[2716]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:13 volumio wireless.js[2506]: trying... Sep 05 20:44:13 volumio sudo[2719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:13 volumio sudo[2719]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:13 volumio sudo[2719]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:14 volumio wireless.js[2506]: trying... Sep 05 20:44:14 volumio sudo[2736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:14 volumio sudo[2736]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:14 volumio sudo[2736]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:15 volumio wireless.js[2506]: trying... Sep 05 20:44:15 volumio sudo[2742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:15 volumio sudo[2742]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:15 volumio sudo[2742]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:16 volumio wireless.js[2506]: trying... Sep 05 20:44:16 volumio sudo[2746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:16 volumio sudo[2746]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:16 volumio sudo[2746]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:16 volumio dhcpcd[2625]: wlan0: leased 192.168.5.101 for 7200 seconds Sep 05 20:44:16 volumio avahi-daemon[623]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.5.101. Sep 05 20:44:16 volumio avahi-daemon[623]: New relevant interface wlan0.IPv4 for mDNS. Sep 05 20:44:16 volumio dhcpcd[2625]: wlan0: adding route to 192.168.5.0/24 Sep 05 20:44:16 volumio avahi-daemon[623]: Registering new address record for 192.168.5.101 on wlan0.IPv4. Sep 05 20:44:16 volumio dhcpcd[2625]: wlan0: adding default route via 192.168.5.1 Sep 05 20:44:16 volumio dnsmasq[901]: reading /etc/resolv.conf Sep 05 20:44:16 volumio dnsmasq[901]: using nameserver 192.168.5.1#53 Sep 05 20:44:16 volumio dnsmasq[901]: using nameserver 193.200.68.1#53 Sep 05 20:44:16 volumio dnsmasq[901]: using nameserver 208.67.222.222#53 Sep 05 20:44:16 volumio dnsmasq[901]: using nameserver 208.67.220.220#53 Sep 05 20:44:17 volumio wireless.js[2506]: trying... Sep 05 20:44:17 volumio sudo[2771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 05 20:44:17 volumio sudo[2771]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:17 volumio sudo[2771]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:17 volumio wireless.js[2506]: Connected to: ----Midnight-5-sr Sep 05 20:44:17 volumio wireless.js[2506]: ---- Sep 05 20:44:17 volumio sudo[2774]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:17 volumio sudo[2774]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:17 volumio sudo[2774]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:17 volumio wireless.js[2506]: ... joined AP, wlan0 IPv4 is 192.168.5.101, ipV6 is undefined Sep 05 20:44:17 volumio wireless.js[2506]: It's done! AP Sep 05 20:44:17 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 05 20:44:17 volumio systemd[1]: Started Wireless Services. Sep 05 20:44:17 volumio sudo[2504]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:17 volumio volumio[910]: info: Discovery: this is already registered, bb006ffd-17c4-471a-8f4c-8ff8cecf05ea Sep 05 20:44:17 volumio volumio[910]: info: Discovery: Found device Volumio Sep 05 20:44:17 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:17 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:18 volumio ntpd[804]: Listen normally on 6 wlan0 192.168.5.101:123 Sep 05 20:44:18 volumio ntpd[804]: new interface(s) found: waking up resolver Sep 05 20:44:22 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Sep 05 20:44:22 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Sep 05 20:44:22 volumio sudo[2780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:22 volumio sudo[2780]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:22 volumio sudo[2780]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:22 volumio sudo[2783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 05 20:44:22 volumio sudo[2783]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:22 volumio sudo[2783]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:23 volumio volumio[910]: info: Volumio Network Manager: Network status updated: 3 Sep 05 20:44:25 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:25 volumio volumio[910]: info: Retrieving Cloud Streaming UI Sep 05 20:44:25 volumio volumio[910]: info: Getting Tidal Cloud Configuration Sep 05 20:44:25 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:25 volumio volumio[910]: info: Getting Qobuz Cloud Configuration Sep 05 20:44:25 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:44:25 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:25 volumio volumio[910]: info: Getting Spotify Cloud Configuration Sep 05 20:44:25 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:44:25 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:25 volumio volumio[910]: info: Saving Spotify Acccount Sep 05 20:44:25 volumio volumio[910]: info: Got Tidal Cloud Configuration Sep 05 20:44:25 volumio volumio[910]: info: Got it Sep 05 20:44:25 volumio volumio[910]: info: Got it Sep 05 20:44:25 volumio volumio[910]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 20:44:25 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:25 volumio volumio[910]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 05 20:44:27 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Sep 05 20:44:27 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Sep 05 20:44:27 volumio volumio[910]: info: Refreshing Cached IP Addresses Sep 05 20:44:27 volumio sudo[2808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Sep 05 20:44:27 volumio sudo[2808]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:27 volumio sudo[2808]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:27 volumio sudo[2811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:44:27 volumio sudo[2811]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:27 volumio sudo[2811]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:27 volumio volumio[910]: error: Upnp client error: Error: This socket has been ended by the other party Sep 05 20:44:27 volumio sudo[2813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:27 volumio sudo[2813]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:27 volumio sudo[2813]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:28 volumio nmbd[754]: [2025/09/05 20:44:28.876798, 0] ../source3/libsmb/nmblib.c:917(send_udp) Sep 05 20:44:28 volumio nmbd[754]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Sep 05 20:44:29 volumio sudo[2817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:44:29 volumio sudo[2817]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:29 volumio sudo[2817]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:29 volumio sudo[2819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:29 volumio sudo[2819]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:29 volumio sudo[2819]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:29 volumio volumio[910]: verbose: New Socket.io Connection to 192.168.5.100 from 192.168.5.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 5 Sep 05 20:44:29 volumio volumio[910]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 20:44:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:44:29 volumio volumio[910]: info: Received Get System Info Sep 05 20:44:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:44:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:44:29 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:44:29 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:29 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:44:32 volumio nmbd[754]: [2025/09/05 20:44:32.882332, 0] ../source3/libsmb/nmblib.c:917(send_udp) Sep 05 20:44:32 volumio nmbd[754]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Sep 05 20:44:33 volumio sudo[2823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:44:33 volumio sudo[2823]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:33 volumio sudo[2823]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:33 volumio sudo[2825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:33 volumio sudo[2825]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:33 volumio sudo[2825]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:33 volumio volumio[910]: verbose: New Socket.io Connection to 192.168.5.100 from 192.168.5.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 5 Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Sep 05 20:44:33 volumio volumio[910]: info: Received Get System Info Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:44:33 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:33 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:44:33 volumio volumio-remote-updater[621]: No test mode Sep 05 20:44:33 volumio volumio-remote-updater[621]: No alpha test mode Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:33 volumio volumio[910]: info: Retrieving Cloud Streaming UI Sep 05 20:44:33 volumio volumio[910]: info: Getting Tidal Cloud Configuration Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:33 volumio volumio[910]: info: Getting Qobuz Cloud Configuration Sep 05 20:44:33 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:33 volumio volumio[910]: info: Getting Spotify Cloud Configuration Sep 05 20:44:33 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:33 volumio volumio[910]: info: Saving Spotify Acccount Sep 05 20:44:33 volumio volumio[910]: info: Got Tidal Cloud Configuration Sep 05 20:44:33 volumio volumio[910]: info: Got it Sep 05 20:44:33 volumio volumio[910]: info: Got it Sep 05 20:44:33 volumio volumio[910]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 20:44:33 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:33 volumio volumio[910]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 05 20:44:34 volumio volumio[910]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 05 20:44:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 05 20:44:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 05 20:44:34 volumio volumio[910]: info: Loading i18n strings for locale ru Sep 05 20:44:35 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Sep 05 20:44:35 volumio volumio[910]: info: Setting timezone to Europe/Kyiv Sep 05 20:44:35 volumio sudo[2850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Sep 05 20:44:35 volumio sudo[2850]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:35 volumio sudo[2850]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:35 volumio sudo[2853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kyiv /etc/localtime Sep 05 20:44:35 volumio sudo[2853]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:35 volumio sudo[2853]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:35 volumio sudo[2856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Sep 05 20:44:35 volumio sudo[2856]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:35 volumio sudo[2856]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:35 volumio sudo[2859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kyiv Sep 05 20:44:35 volumio sudo[2859]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:35 volumio dbus-daemon[610]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.29' (uid=0 pid=2860 comm="/usr/bin/timedatectl set-timezone Europe/Kyiv ") Sep 05 20:44:35 volumio systemd[1]: Starting Time & Date Service... Sep 05 20:44:35 volumio dbus-daemon[610]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 05 20:44:35 volumio systemd[1]: Started Time & Date Service. Sep 05 20:44:35 volumio sudo[2859]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:35 volumio volumio[910]: Updating browse sources language Sep 05 20:44:35 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:44:35 volumio volumio[910]: info: Fetching Streaming Services browse cache Sep 05 20:44:37 volumio sudo[2864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:44:37 volumio sudo[2864]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:37 volumio sudo[2864]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:37 volumio sudo[2866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:37 volumio sudo[2866]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:37 volumio sudo[2866]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:37 volumio sudo[2870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 05 20:44:37 volumio sudo[2870]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:37 volumio sudo[2870]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:37 volumio volumio[910]: info: Upmpdcli Daemon Started Sep 05 20:44:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Sep 05 20:44:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Sep 05 20:44:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 05 20:44:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:44:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Sep 05 20:44:45 volumio volumio[910]: info: Preparing to save Alsa Options, stopping services first Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:45 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::volumioPause Sep 05 20:44:45 volumio volumio[910]: info: CoreStateMachine::pause Sep 05 20:44:45 volumio volumio[910]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"label":"IQaudIO Pi-DigiAMP+"},"output_device":{"value":1,"label":"IQaudIO Pi-DigiAMP+"},"disallowPush":true} Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:44:45 volumio volumio[910]: info: Found match in i2s Card Database: setting mixer Digital for card IQaudIO Pi-DigiAMP+ Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 05 20:44:45 volumio volumio[910]: info: Updating Volume Controller Parameters: Device: 2 Name: IQaudIO Pi-DigiAMP+ Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 05 20:44:45 volumio volumio[910]: info: Disabling external Volume Control Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:45 volumio volumio[910]: info: Preparing to generate the ALSA configuration file Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:45 volumio volumio[910]: info: Retrieving Cloud Streaming UI Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:44:45 volumio volumio[910]: info: Getting Alsa Cards List without I2S DAC Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Sep 05 20:44:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 05 20:44:46 volumio volumio[910]: info: Asound.conf file unchanged, so no further update is needed Sep 05 20:44:46 volumio volumio[910]: info: Output device has changed, restarting MPD Sep 05 20:44:46 volumio sudo[2905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 05 20:44:46 volumio sudo[2905]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:46 volumio volumio[910]: info: Output device has changed, restarting Shairport Sync Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:44:46 volumio sudo[2905]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:46 volumio sudo[2907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 05 20:44:46 volumio sudo[2907]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:46 volumio systemd[1]: Stopping Music Player Daemon... Sep 05 20:44:46 volumio volumio[910]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 20:44:46 volumio volumio[910]: info: Getting Tidal Cloud Configuration Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:46 volumio volumio[910]: info: Getting Qobuz Cloud Configuration Sep 05 20:44:46 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:46 volumio volumio[910]: info: Getting Spotify Cloud Configuration Sep 05 20:44:46 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:46 volumio volumio[910]: info: Saving Spotify Acccount Sep 05 20:44:46 volumio volumio[910]: info: Got Tidal Cloud Configuration Sep 05 20:44:46 volumio volumio[910]: info: Got it Sep 05 20:44:46 volumio volumio[910]: info: Got it Sep 05 20:44:46 volumio volumio[910]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 20:44:46 volumio systemd[1]: mpd.service: Succeeded. Sep 05 20:44:46 volumio systemd[1]: Stopped Music Player Daemon. Sep 05 20:44:46 volumio volumio[910]: info: MPD Permissions set Sep 05 20:44:46 volumio volumio[910]: info: VolumeController:: Volume=100 Mute =false Sep 05 20:44:46 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:44:46 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:46 volumio systemd[1]: Starting Music Player Daemon... Sep 05 20:44:46 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:46 volumio volumio[910]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 05 20:44:46 volumio volumio[910]: info: Starting Shairport Sync Sep 05 20:44:46 volumio sudo[2920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 20:44:46 volumio sudo[2920]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 20:44:46 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 05 20:44:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 20:44:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 20:44:46 volumio sudo[2920]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:46 volumio volumio[910]: info: Shairport-Sync Started Sep 05 20:44:46 volumio sudo[2913]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 05 20:44:46 volumio sudo[2913]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:46 volumio sudo[2913]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:46 volumio mpd[2924]: Sep 05 20:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 05 20:44:46 volumio systemd[1]: Started Music Player Daemon. Sep 05 20:44:46 volumio sudo[2907]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:48 volumio volumio[910]: error: updateQueue error: null Sep 05 20:44:49 volumio volumio[910]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Sep 05 20:44:49 volumio volumio[910]: info: CoreStateMachine::getcurrentVolume Sep 05 20:44:49 volumio volumio[910]: info: CoreCommandRouter::volumioRetrievevolume Sep 05 20:44:49 volumio volumio[910]: info: VolumeController:: Volume=100 Mute =false Sep 05 20:44:49 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:44:49 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:49 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:49 volumio volumio[910]: info: CoreStateMachine::updateTrackBlock Sep 05 20:44:49 volumio volumio[910]: info: CorePlayQueue::getTrackBlock Sep 05 20:44:49 volumio volumio[910]: info: CoreCommandRouter::volumioRetrievevolume Sep 05 20:44:49 volumio volumio[910]: info: VolumeController:: Volume=100 Mute =false Sep 05 20:44:49 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:44:49 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:49 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Sep 05 20:44:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Sep 05 20:44:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Sep 05 20:44:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Sep 05 20:44:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Sep 05 20:44:56 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Sep 05 20:44:56 volumio volumio[910]: info: CoreCommandRouter::Reload Ui Sep 05 20:44:56 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Sep 05 20:44:56 volumio volumio[910]: info: Wizard terminated Successfully Sep 05 20:44:56 volumio volumio[910]: info: CoreCommandRouter::volumiosetStartupVolume Sep 05 20:44:56 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:44:56 volumio volumio[910]: info: Player Reboot required after I2S DAC has been enabled in wizard Sep 05 20:44:57 volumio sudo[2962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:44:57 volumio sudo[2962]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:57 volumio sudo[2962]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:57 volumio sudo[2964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:57 volumio sudo[2964]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:57 volumio sudo[2964]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:57 volumio volumio[910]: verbose: New Socket.io Connection to 192.168.5.100 from 192.168.5.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 4 Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:57 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 05 20:44:57 volumio volumio[910]: info: Received Get System Info Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:44:57 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:57 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:57 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:57 volumio volumio[910]: info: Listing playlists Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 05 20:44:57 volumio sudo[2969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:44:57 volumio sudo[2969]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:57 volumio sudo[2969]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:57 volumio sudo[2972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:57 volumio sudo[2972]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:57 volumio sudo[2972]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:57 volumio volumio[910]: verbose: New Socket.io Connection to 192.168.5.100 from 192.168.5.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 5 Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:57 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 05 20:44:57 volumio volumio[910]: info: Received Get System Info Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:44:57 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:57 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:57 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:57 volumio volumio[910]: info: Listing playlists Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:44:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 05 20:44:58 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:58 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:59 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 05 20:44:59 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 05 20:44:59 volumio volumio[910]: info: Received Get System Info Sep 05 20:44:59 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:44:59 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:44:59 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:44:59 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:59 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:59 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:45:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Sep 05 20:45:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:45:05 volumio systemd[1]: systemd-timedated.service: Succeeded. Sep 05 20:45:05 volumio volumio-remote-updater[621]: No test mode Sep 05 20:45:05 volumio volumio-remote-updater[621]: No alpha test mode Sep 05 20:45:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 05 20:45:05 volumio volumio[910]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 05 20:45:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 05 20:45:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Sep 05 20:45:07 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 05 20:45:11 volumio volumio[910]: info: CoreCommandRouter::Close All Modals sent Sep 05 20:45:11 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Sep 05 20:45:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:45:16 volumio volumio[910]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 05 20:45:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 05 20:45:16 volumio volumio[910]: info: Received Get System Version Sep 05 20:45:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:45:16 volumio volumio[910]: info: Received Get System Info Sep 05 20:45:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:45:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:45:16 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:45:16 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:45:16 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:45:21 volumio volumio[910]: info: Getting Alsa Cards List without I2S DAC Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 05 20:45:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 05 20:45:36 volumio ntpd[804]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 05 20:45:37 volumio volumio[910]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Sep 05 20:45:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Sep 05 20:45:37 volumio sudo[3108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 05 20:45:37 volumio sudo[3108]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:45:37 volumio sudo[3108]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:37 volumio sudo[3110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 05 20:45:37 volumio sudo[3110]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:45:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 20:45:37 volumio volumio[910]: info: MPD Permissions set Sep 05 20:45:37 volumio systemd[1]: Stopping Music Player Daemon... Sep 05 20:45:37 volumio systemd[1]: mpd.service: Succeeded. Sep 05 20:45:37 volumio systemd[1]: Stopped Music Player Daemon. Sep 05 20:45:37 volumio systemd[1]: Starting Music Player Daemon... Sep 05 20:45:38 volumio sudo[3117]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 05 20:45:38 volumio sudo[3117]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:38 volumio sudo[3117]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:38 volumio mpd[3120]: Sep 05 20:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 05 20:45:38 volumio systemd[1]: Started Music Player Daemon. Sep 05 20:45:38 volumio sudo[3110]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:38 volumio volumio[910]: error: updateQueue error: null Sep 05 20:46:09 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:46:09 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:46:13 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:46:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 05 20:46:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 05 20:46:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 05 20:46:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Sep 05 20:46:13 volumio volumio[910]: info: Received Get System Version Sep 05 20:46:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:46:42 volumio volumio[910]: info: CALLMETHOD: system_controller system savePrivacySettings [object Object] Sep 05 20:46:42 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , savePrivacySettings Sep 05 20:46:42 volumio volumio[910]: info: CoreCommandRouter::Reload Ui Sep 05 20:46:43 volumio sudo[3292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:46:43 volumio sudo[3292]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:46:43 volumio sudo[3292]: pam_unix(sudo:session): session closed for user root Sep 05 20:46:43 volumio sudo[3295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:46:43 volumio sudo[3295]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:46:43 volumio sudo[3295]: pam_unix(sudo:session): session closed for user root Sep 05 20:46:43 volumio volumio[910]: verbose: New Socket.io Connection to 192.168.5.100 from 192.168.5.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 4 Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:46:43 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 05 20:46:43 volumio volumio[910]: info: Received Get System Info Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:46:43 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:46:43 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:46:43 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:46:43 volumio volumio[910]: info: Listing playlists Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 05 20:46:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Sep 05 20:46:44 volumio volumio[910]: info: Received Get System Version Sep 05 20:46:44 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:46:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 05 20:46:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 05 20:46:45 volumio volumio[910]: info: Received Get System Info Sep 05 20:46:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:46:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:46:45 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:46:45 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:46:45 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:46:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:46:53 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 05 20:46:59 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:46:59 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:47:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:47:02 volumio volumio[910]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 05 20:47:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 05 20:47:02 volumio volumio[910]: info: Received Get System Version Sep 05 20:47:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 20:47:02 volumio volumio[910]: info: Received Get System Info Sep 05 20:47:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:47:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:47:02 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:47:02 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:47:02 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:47:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:47:02 volumio volumio[910]: info: CoreCommandRouter::volumioGetQueue Sep 05 20:47:02 volumio volumio[910]: info: CoreStateMachine::getQueue Sep 05 20:47:02 volumio volumio[910]: info: CorePlayQueue::getQueue Sep 05 20:47:08 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Sep 05 20:47:08 volumio volumio[910]: info: Preload queue cleared Sep 05 20:47:13 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:47:13 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:47:16 volumio volumio[910]: info: Retrieving Cloud Streaming UI Sep 05 20:47:16 volumio volumio[910]: info: Getting Tidal Cloud Configuration Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:47:16 volumio volumio[910]: info: Getting Qobuz Cloud Configuration Sep 05 20:47:16 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:47:16 volumio volumio[910]: info: Getting Spotify Cloud Configuration Sep 05 20:47:16 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:47:16 volumio volumio[910]: info: Saving Spotify Acccount Sep 05 20:47:16 volumio volumio[910]: info: Got Tidal Cloud Configuration Sep 05 20:47:16 volumio volumio[910]: info: Got it Sep 05 20:47:16 volumio volumio[910]: info: Got it Sep 05 20:47:16 volumio volumio[910]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:47:16 volumio volumio[910]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:47:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 05 20:47:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:47:24 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:47:28 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:47:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:47:36 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:47:40 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:47:44 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:47:48 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:47:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:47:56 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:48:00 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:48:02 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:48:02 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:48:07 volumio volumio[910]: info: VolumeController::SetAlsaVolume4 Sep 05 20:48:07 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:48:07 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:48:07 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:48:07 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:48:10 volumio volumio[910]: info: VolumeController::SetAlsaVolume7 Sep 05 20:48:10 volumio volumio[910]: info: CoreStateMachine::pushState Sep 05 20:48:10 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:48:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:48:10 volumio volumio[910]: info: CoreCommandRouter::volumioPushState Sep 05 20:48:29 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 05 20:48:30 volumio volumio[910]: info: Getting Alsa Cards List without I2S DAC Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Sep 05 20:48:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 05 20:48:34 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:48:34 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:48:52 volumio volumio[910]: info: Retrieving Cloud Streaming UI Sep 05 20:48:52 volumio volumio[910]: info: Getting Tidal Cloud Configuration Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:48:52 volumio volumio[910]: info: Getting Qobuz Cloud Configuration Sep 05 20:48:52 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:48:52 volumio volumio[910]: info: Getting Spotify Cloud Configuration Sep 05 20:48:52 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:48:52 volumio volumio[910]: info: Saving Spotify Acccount Sep 05 20:48:52 volumio volumio[910]: info: Got Tidal Cloud Configuration Sep 05 20:48:52 volumio volumio[910]: info: Got it Sep 05 20:48:52 volumio volumio[910]: info: Got it Sep 05 20:48:52 volumio volumio[910]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:48:52 volumio volumio[910]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:48:52 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 05 20:48:56 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:00 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:04 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:08 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:12 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:16 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:24 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:28 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:32 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:49 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:53 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:49:57 volumio dhcpcd[2625]: eth0: carrier lost Sep 05 20:49:57 volumio dhcpcd[960]: eth0: carrier lost Sep 05 20:49:57 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Down Sep 05 20:49:57 volumio dnsmasq[901]: reading /etc/resolv.conf Sep 05 20:49:57 volumio dnsmasq[901]: using nameserver 192.168.5.1#53 Sep 05 20:49:57 volumio dnsmasq[901]: using nameserver 193.200.68.1#53 Sep 05 20:49:57 volumio dnsmasq[901]: using nameserver 192.168.5.1#53 Sep 05 20:49:57 volumio dnsmasq[901]: using nameserver 193.200.68.1#53 Sep 05 20:49:57 volumio dnsmasq[901]: using nameserver 208.67.222.222#53 Sep 05 20:49:57 volumio dnsmasq[901]: using nameserver 208.67.220.220#53 Sep 05 20:49:57 volumio dnsmasq[901]: using nameserver 208.67.222.222#53 Sep 05 20:49:57 volumio dnsmasq[901]: using nameserver 208.67.220.220#53 Sep 05 20:49:57 volumio dhcpcd[2625]: eth0: deleting route to 192.168.5.0/24 Sep 05 20:49:57 volumio dhcpcd[2625]: eth0: deleting default route via 192.168.5.1 Sep 05 20:49:57 volumio avahi-daemon[623]: Withdrawing address record for 192.168.5.100 on eth0. Sep 05 20:49:57 volumio avahi-daemon[623]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.5.100. Sep 05 20:49:57 volumio avahi-daemon[623]: Interface eth0.IPv4 no longer relevant for mDNS. Sep 05 20:49:57 volumio volumio[910]: info: Discovery: A device disappeared from network Sep 05 20:49:58 volumio volumio[910]: info: Discovery: Device volumio disappeared from network Sep 05 20:49:58 volumio dhcpcd[960]: eth0: deleting route to 192.168.5.0/24 Sep 05 20:49:58 volumio dhcpcd[960]: eth0: deleting default route via 192.168.5.1 Sep 05 20:49:58 volumio dnsmasq[901]: reading /etc/resolv.conf Sep 05 20:49:58 volumio dnsmasq[901]: using nameserver 192.168.5.1#53 Sep 05 20:49:58 volumio dnsmasq[901]: using nameserver 193.200.68.1#53 Sep 05 20:49:58 volumio dnsmasq[901]: using nameserver 208.67.222.222#53 Sep 05 20:49:58 volumio dnsmasq[901]: using nameserver 208.67.220.220#53 Sep 05 20:49:58 volumio ifplugd(eth0)[794]: Link beat lost. Sep 05 20:49:59 volumio ntpd[804]: Deleting interface #3 eth0, 192.168.5.100#123, interface stats: received=240, sent=245, dropped=0, active_time=639 secs Sep 05 20:49:59 volumio ntpd[804]: 91.236.251.13 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 91.236.251.34 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 46.173.175.211 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 91.231.182.17 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 91.236.251.31 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 194.8.144.107 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 91.210.190.13 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 194.8.146.38 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 79.142.192.130 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 193.106.144.13 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 162.159.200.1 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 193.34.155.3 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 193.34.155.4 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 162.159.200.123 local addr 192.168.5.100 -> Sep 05 20:49:59 volumio ntpd[804]: 193.106.144.7 local addr 192.168.5.100 -> Sep 05 20:50:00 volumio ntpd[804]: 46.173.175.211 local addr 192.168.5.101 -> Sep 05 20:50:01 volumio ntpd[804]: 91.236.251.13 local addr 192.168.5.101 -> Sep 05 20:50:03 volumio ntpd[804]: 91.236.251.34 local addr 192.168.5.101 -> Sep 05 20:50:03 volumio ntpd[804]: 91.236.251.31 local addr 192.168.5.101 -> Sep 05 20:50:04 volumio volumio[910]: info: Volumio Network Manager: Network status updated: 2 Sep 05 20:50:08 volumio ifplugd(eth0)[794]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Sep 05 20:50:08 volumio dhcpcd[3966]: sending commands to master dhcpcd process Sep 05 20:50:08 volumio ifplugd(eth0)[794]: client: sending commands to master dhcpcd process Sep 05 20:50:08 volumio dhcpcd[2625]: control command: /sbin/dhcpcd -k eth0 Sep 05 20:50:08 volumio dhcpcd[2625]: eth0: removing interface Sep 05 20:50:08 volumio ifplugd(eth0)[794]: Program executed successfully. Sep 05 20:50:08 volumio kernel: bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay) Sep 05 20:50:08 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Down Sep 05 20:50:10 volumio volumio[910]: verbose: New Socket.io Connection to 192.168.5.101 from 192.168.5.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 5 Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:50:10 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:50:10 volumio ntpd[804]: Soliciting pool server 217.12.206.12 Sep 05 20:50:10 volumio volumio[910]: info: Received Get System Info Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:50:10 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:50:10 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:50:10 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:50:10 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:50:10 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 05 20:50:10 volumio volumio[910]: info: Received Get System Info Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:50:10 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:50:10 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 20:50:10 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 20:50:10 volumio volumio[910]: info: Listing playlists Sep 05 20:50:10 volumio volumio[910]: info: CoreCommandRouter::volumioGetQueue Sep 05 20:50:10 volumio volumio[910]: info: CoreStateMachine::getQueue Sep 05 20:50:10 volumio volumio[910]: info: CorePlayQueue::getQueue Sep 05 20:50:11 volumio ntpd[804]: Soliciting pool server 130.255.135.221 Sep 05 20:50:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:13 volumio ntpd[804]: Soliciting pool server 193.106.144.6 Sep 05 20:50:14 volumio ntpd[804]: Soliciting pool server 91.236.251.14 Sep 05 20:50:15 volumio ntpd[804]: Soliciting pool server 78.30.254.80 Sep 05 20:50:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:19 volumio ntpd[804]: Soliciting pool server 130.255.135.221 Sep 05 20:50:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 05 20:50:20 volumio ntpd[804]: Soliciting pool server 2001:67c:440:400::5 Sep 05 20:50:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:25 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:49 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:53 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:50:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:09 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:25 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:49 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:53 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:51:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:09 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:25 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:33 volumio systemd[1]: Starting Cleanup of Temporary Directories... Sep 05 20:52:33 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Sep 05 20:52:33 volumio systemd[1]: Started Cleanup of Temporary Directories. Sep 05 20:52:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:49 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:53 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:52:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:09 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:25 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:49 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:53 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:53:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:09 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:25 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:49 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:53 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:54:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:09 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:25 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:49 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:53 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:55:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:09 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:25 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:49 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:53 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:56:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:09 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:25 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:45 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:49 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:53 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:57:57 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:05 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:09 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:13 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:42 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:54 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:58:58 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:14 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:22 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:42 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:54 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 20:59:58 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:14 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:22 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:42 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:54 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:00:58 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:14 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:22 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:42 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:54 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:01:58 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:14 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:22 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:42 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:54 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:02:58 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:14 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:22 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:42 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:54 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:03:58 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:14 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:22 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:41 volumio ntpd[804]: 91.236.251.14 local addr 192.168.5.101 -> Sep 05 21:04:42 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:54 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:04:58 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:14 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:22 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:42 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:46 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:50 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:54 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:05:58 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:02 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:06 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:10 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:14 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:18 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 05 21:06:22 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:26 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:30 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:34 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:38 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:51 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:55 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:06:59 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:01 volumio ntpd[804]: 217.12.206.12 local addr 192.168.5.101 -> Sep 05 21:07:03 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:07 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:11 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:15 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:19 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:23 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:27 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:31 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:35 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:39 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:43 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:47 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:51 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:55 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:07:59 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:08:00 volumio sudo[6421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 21:08:00 volumio sudo[6421]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:08:00 volumio sudo[6421]: pam_unix(sudo:session): session closed for user root Sep 05 21:08:00 volumio sudo[6423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 21:08:00 volumio sudo[6423]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:08:00 volumio sudo[6423]: pam_unix(sudo:session): session closed for user root Sep 05 21:08:00 volumio volumio[910]: verbose: New Socket.io Connection to 192.168.5.101 from 192.168.5.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 4 Sep 05 21:08:01 volumio sudo[6429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 21:08:01 volumio sudo[6429]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:08:01 volumio sudo[6429]: pam_unix(sudo:session): session closed for user root Sep 05 21:08:01 volumio sudo[6432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 21:08:01 volumio sudo[6432]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:08:01 volumio sudo[6432]: pam_unix(sudo:session): session closed for user root Sep 05 21:08:01 volumio volumio[910]: verbose: New Socket.io Connection to 192.168.5.101 from 192.168.5.170 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:135.0) Gecko/20100101 Firefox/135.0 Engine version: 3 Transport: polling Total Clients: 4 Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 21:08:01 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 05 21:08:01 volumio volumio[910]: info: Received Get System Info Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 21:08:01 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 21:08:01 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 21:08:01 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 21:08:01 volumio volumio[910]: info: Listing playlists Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 21:08:01 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 05 21:08:02 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 21:08:02 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 21:08:03 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 05 21:08:03 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 05 21:08:03 volumio volumio[910]: info: Received Get System Info Sep 05 21:08:03 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 21:08:03 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 21:08:03 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 21:08:03 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 21:08:03 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 21:08:03 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 21:08:11 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 05 21:08:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 21:08:20 volumio volumio[910]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 05 21:08:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 05 21:08:20 volumio volumio[910]: info: Received Get System Version Sep 05 21:08:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 05 21:08:20 volumio volumio[910]: info: Received Get System Info Sep 05 21:08:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 21:08:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 21:08:20 volumio volumio[910]: info: Discovery: Getting this device information Sep 05 21:08:20 volumio volumio[910]: info: CoreCommandRouter::volumioGetState Sep 05 21:08:20 volumio volumio[910]: info: CorePlayQueue::getTrack 0 Sep 05 21:08:20 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 21:09:17 volumio volumio[910]: info: Retrieving Cloud Streaming UI Sep 05 21:09:17 volumio volumio[910]: info: Getting Tidal Cloud Configuration Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 21:09:17 volumio volumio[910]: info: Getting Qobuz Cloud Configuration Sep 05 21:09:17 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 21:09:17 volumio volumio[910]: info: Getting Spotify Cloud Configuration Sep 05 21:09:17 volumio volumio[910]: info: Asking plugin for UI Config Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 21:09:17 volumio volumio[910]: info: Saving Spotify Acccount Sep 05 21:09:17 volumio volumio[910]: info: Got Tidal Cloud Configuration Sep 05 21:09:17 volumio volumio[910]: info: Got it Sep 05 21:09:17 volumio volumio[910]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 21:09:17 volumio volumio[910]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::volumioGetBrowseSources Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:09:17 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 05 21:09:21 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:09:23 volumio volumio[910]: info: Disabling MyMusic plugin upnp Sep 05 21:09:23 volumio sudo[6648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Sep 05 21:09:23 volumio sudo[6648]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:09:23 volumio volumio[910]: error: Upnp client error: Error: This socket has been ended by the other party Sep 05 21:09:23 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Sep 05 21:09:25 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:09:29 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:09:33 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:09:36 volumio volumio[910]: info: Disabling MyMusic plugin airplay_emulation Sep 05 21:09:36 volumio volumio[910]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Sep 05 21:09:36 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 21:09:36 volumio volumio[910]: info: Disabling plugin airplay_emulation Sep 05 21:09:36 volumio volumio[910]: info: Done. Sep 05 21:09:36 volumio sudo[6671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Sep 05 21:09:36 volumio sudo[6671]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:09:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 21:09:36 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 05 21:09:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 21:09:36 volumio sudo[6671]: pam_unix(sudo:session): session closed for user root Sep 05 21:09:36 volumio volumio[910]: info: Shairport-Sync Stopped Sep 05 21:09:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:09:37 volumio volumio[910]: info: Disabling MyMusic plugin upnp_browser Sep 05 21:09:37 volumio volumio[910]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesМедиа-серверы Sep 05 21:09:37 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 21:09:37 volumio volumio[910]: info: Disabling plugin upnp_browser Sep 05 21:09:37 volumio volumio[910]: info: Done. Sep 05 21:09:39 volumio volumio[910]: info: Enabling MyMusic plugin airplay_emulation Sep 05 21:09:39 volumio volumio[910]: info: Enabling plugin airplay_emulation Sep 05 21:09:39 volumio volumio[910]: info: Loading plugin "airplay_emulation"... Sep 05 21:09:39 volumio volumio[910]: info: Starting Shairport Sync Sep 05 21:09:39 volumio volumio[910]: info: PLUGIN START: airplay_emulation Sep 05 21:09:39 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 21:09:39 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 21:09:39 volumio volumio[910]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 21:09:39 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 05 21:09:39 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 05 21:09:39 volumio volumio[910]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 05 21:09:39 volumio volumio[910]: info: Done. Sep 05 21:09:39 volumio volumio[910]: info: Starting Shairport Sync Sep 05 21:09:39 volumio volumio[910]: info: Starting Shairport Sync Sep 05 21:09:39 volumio sudo[6695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 21:09:39 volumio sudo[6695]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:09:39 volumio sudo[6698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 21:09:39 volumio sudo[6698]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:09:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 21:09:39 volumio sudo[6695]: pam_unix(sudo:session): session closed for user root Sep 05 21:09:39 volumio volumio[910]: info: Shairport-Sync Started Sep 05 21:09:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 21:09:39 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Sep 05 21:09:39 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 05 21:09:39 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 21:09:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 21:09:39 volumio sudo[6698]: pam_unix(sudo:session): session closed for user root Sep 05 21:09:39 volumio volumio[910]: info: Shairport-Sync Started Sep 05 21:09:40 volumio volumio[910]: info: Enabling MyMusic plugin upnp_browser Sep 05 21:09:40 volumio volumio[910]: info: Enabling plugin upnp_browser Sep 05 21:09:40 volumio volumio[910]: info: Loading plugin "upnp_browser"... Sep 05 21:09:40 volumio volumio[910]: info: PLUGIN START: upnp_browser Sep 05 21:09:40 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 05 21:09:40 volumio volumio[910]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 05 21:09:40 volumio volumio[910]: info: [1757095780587] CoreMusicLibrary::Adding element Медиа-серверы Sep 05 21:09:40 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 21:09:40 volumio volumio[910]: info: Done. Sep 05 21:09:41 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 05 21:09:42 volumio volumio[910]: info: Disabling MyMusic plugin upnp Sep 05 21:09:42 volumio sudo[6705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Sep 05 21:09:42 volumio sudo[6705]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 21:09:44 volumio volumio[910]: info: Enabling MyMusic plugin upnp Sep 05 21:09:44 volumio volumio[910]: info: Enabling plugin upnp Sep 05 21:09:44 volumio volumio[910]: info: Loading plugin "upnp"... Sep 05 21:09:44 volumio volumio[910]: info: [1757095784590] Starting Upmpd Daemon Sep 05 21:09:44 volumio volumio[910]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 05 21:09:44 volumio volumio[910]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 21:09:44 volumio volumio[910]: Error: listen EADDRINUSE: address already in use :::6599 Sep 05 21:09:44 volumio volumio[910]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Sep 05 21:09:44 volumio volumio[910]: at listenInCluster (net.js:1366:12) Sep 05 21:09:44 volumio volumio[910]: at Server.listen (net.js:1452:7) Sep 05 21:09:44 volumio volumio[910]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Sep 05 21:09:44 volumio volumio[910]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Sep 05 21:09:44 volumio volumio[910]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Sep 05 21:09:44 volumio volumio[910]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Sep 05 21:09:44 volumio volumio[910]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Sep 05 21:09:44 volumio volumio[910]: code: 'EADDRINUSE', Sep 05 21:09:44 volumio volumio[910]: errno: -98, Sep 05 21:09:44 volumio volumio[910]: syscall: 'listen', Sep 05 21:09:44 volumio volumio[910]: address: '::', Sep 05 21:09:44 volumio volumio[910]: port: 6599 Sep 05 21:09:44 volumio volumio[910]: } Sep 05 21:09:44 volumio volumio[910]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 21:09:44 volumio sudo[6716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-05 20:08 Sep 05 21:09:44 volumio sudo[6716]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"