Apr 03 17:06:00 volumio volumio[69399]: info: Refreshing Cached IP Addresses Apr 03 17:06:00 volumio sudo[69434]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 03 17:06:00 volumio sudo[69434]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:00 volumio sudo[69436]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 17:06:00 volumio sudo[69436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:00 volumio sudo[69436]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:00 volumio sudo[69434]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:00 volumio volumio[69399]: info: Loading plugin "services"... Apr 03 17:06:00 volumio volumio[69399]: info: Loading plugin "volumio5onboarding"... Apr 03 17:06:00 volumio sudo[69445]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 03 17:06:00 volumio sudo[69445]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:00 volumio volumio[69399]: info: Loading plugin "alsa_controller"... Apr 03 17:06:00 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 17:06:00 volumio volumio[69399]: info: Loading plugin "wizard"... Apr 03 17:06:00 volumio volumio[69399]: info: Loading plugin "networkfs"... Apr 03 17:06:00 volumio volumio[69399]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Apr 03 17:06:00 volumio volumio[69399]: info: Starting Udev Watcher for removable devices Apr 03 17:06:00 volumio volumio[69399]: info: Ignoring mount for partition: boot Apr 03 17:06:00 volumio volumio[69399]: info: Ignoring mount for partition: volumio Apr 03 17:06:00 volumio volumio[69399]: info: Ignoring mount for partition: volumio_data Apr 03 17:06:00 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 03 17:06:00 volumio volumio[69399]: info: Loading plugin "volumio_command_line_client"... Apr 03 17:06:00 volumio volumio[69399]: info: Plugin upnp is not enabled Apr 03 17:06:00 volumio volumio[69399]: info: Loading plugin "my_music"... Apr 03 17:06:00 volumio volumio[69399]: info: Loading plugin "mpd"... Apr 03 17:06:01 volumio volumio[69399]: info: Plugin upnp_browser is not enabled Apr 03 17:06:01 volumio volumio[69399]: info: Loading plugin "alarm-clock"... Apr 03 17:06:01 volumio volumio[69399]: info: Loading plugin "airplay_emulation"... Apr 03 17:06:01 volumio volumio[69399]: info: Starting Shairport Sync Apr 03 17:06:01 volumio volumio[69399]: info: Loading plugin "last_100"... Apr 03 17:06:01 volumio volumio[69399]: info: Loading plugin "webradio"... Apr 03 17:06:02 volumio volumio[69399]: info: Loading plugin "i2s_dacs"... Apr 03 17:06:02 volumio volumio[69399]: info: I2S DAC not set, start Auto-detection Apr 03 17:06:02 volumio volumio[69399]: info: Loading plugin "volumiodiscovery"... Apr 03 17:06:03 volumio volumio[69399]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 03 17:06:03 volumio volumio[69399]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 03 17:06:03 volumio volumio[69399]: *** WARNING *** For more information see Apr 03 17:06:03 volumio volumio[69399]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 03 17:06:03 volumio node[69399]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 03 17:06:03 volumio volumio[69399]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 03 17:06:03 volumio volumio[69399]: *** WARNING *** For more information see Apr 03 17:06:03 volumio node[69399]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 03 17:06:03 volumio node[69399]: *** WARNING *** For more information see Apr 03 17:06:03 volumio node[69399]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 03 17:06:03 volumio node[69399]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 03 17:06:03 volumio node[69399]: *** WARNING *** For more information see Apr 03 17:06:03 volumio volumio[69399]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 03 17:06:03 volumio volumio[69399]: info: Discovery: Started advertising with name: Volumio Apr 03 17:06:03 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 03 17:06:03 volumio volumio[69399]: info: Loading plugin "squeezelite_mc"... Apr 03 17:06:03 volumio startx[69344]: xinit: giving up Apr 03 17:06:03 volumio startx[69344]: xinit: unable to connect to X server: Cannot assign requested address Apr 03 17:06:03 volumio startx[69344]: xinit: server error Apr 03 17:06:03 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Apr 03 17:06:03 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Apr 03 17:06:04 volumio volumio[69399]: info: Loading plugin "now_playing"... Apr 03 17:06:06 volumio sudo[69445]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:06 volumio volumio5-onboarding[1601]: time=2026-04-03T17:06:06.542+02:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:39118->127.0.0.1:3000: i/o timeout" Apr 03 17:06:07 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1161. Apr 03 17:06:07 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 17:06:07 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 17:06:07 volumio upmpdcli[69476]: Could not open config: /tmp/upmpdcli.conf Apr 03 17:06:07 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 17:06:07 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 17:06:07 volumio volumio[69399]: info: Loading plugin "stylish_player"... Apr 03 17:06:07 volumio volumio[69399]: info: Loading plugin "outputs"... Apr 03 17:06:07 volumio volumio[69399]: info: Loading plugin "albumart"... Apr 03 17:06:07 volumio volumio[69399]: info: Plugin example_plugin is not enabled Apr 03 17:06:07 volumio volumio[69399]: info: Loading plugin "inputs"... Apr 03 17:06:08 volumio volumio[69399]: info: Loading plugin "updater_comm"... Apr 03 17:06:08 volumio volumio[69477]: Forking 1 albumart workers Apr 03 17:06:08 volumio volumio[69399]: info: Plugin mpdemulation is not enabled Apr 03 17:06:08 volumio volumio[69399]: info: Loading plugin "rest_api"... Apr 03 17:06:08 volumio volumio[69399]: info: Loading plugin "websocket"... Apr 03 17:06:08 volumio volumio[69399]: info: Starting Socket.io Server version 1.7.4 Apr 03 17:06:08 volumio volumio[69399]: info: Loading plugin "RoonBridge"... Apr 03 17:06:08 volumio systemd[1]: volumio-kiosk.service: Scheduled restart job, restart counter is at 775. Apr 03 17:06:08 volumio systemd[1]: Stopped volumio-kiosk.service - Start Volumio Kiosk. Apr 03 17:06:08 volumio systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk. Apr 03 17:06:08 volumio volumio[69399]: info: Applying required configuration parameters for plugin RoonBridge Apr 03 17:06:08 volumio volumio[69399]: info: Loading plugin "display_configuration"... Apr 03 17:06:08 volumio startx[69520]: X.Org X Server 1.21.1.7 Apr 03 17:06:08 volumio startx[69520]: X Protocol Version 11, Revision 0 Apr 03 17:06:08 volumio startx[69520]: Current Operating System: Linux volumio 6.12.57-volumio #2 SMP PREEMPT_DYNAMIC Thu Nov 13 17:08:37 CET 2025 x86_64 Apr 03 17:06:08 volumio startx[69520]: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=cf910561-1d44-4877-9f78-123e8c799de7 bootpart=UUID=9EE8-B65A datapart=UUID=afe8532e-510d-4a5f-ae48-965db99841c8 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=native net.ifnames=0 use_kmsg=no initrd=volumio.initrd Apr 03 17:06:08 volumio startx[69520]: xorg-server 2:21.1.7-3+deb12u11 (https://www.debian.org/support) Apr 03 17:06:08 volumio startx[69520]: Current version of pixman: 0.42.2 Apr 03 17:06:08 volumio startx[69520]: Before reporting problems, check http://wiki.x.org Apr 03 17:06:08 volumio startx[69520]: to make sure that you have the latest version. Apr 03 17:06:08 volumio startx[69520]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 03 17:06:08 volumio startx[69520]: (++) from command line, (!!) notice, (II) informational, Apr 03 17:06:08 volumio startx[69520]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 03 17:06:08 volumio startx[69520]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Apr 3 17:06:08 2026 Apr 03 17:06:09 volumio startx[69520]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 03 17:06:09 volumio startx[69520]: (EE) Apr 03 17:06:09 volumio startx[69520]: Fatal server error: Apr 03 17:06:09 volumio startx[69520]: (EE) AddScreen/ScreenInit failed for driver 0 Apr 03 17:06:09 volumio startx[69520]: (EE) Apr 03 17:06:09 volumio startx[69520]: (EE) Apr 03 17:06:09 volumio startx[69520]: Please consult the The X.Org Foundation support Apr 03 17:06:09 volumio startx[69520]: at http://wiki.x.org Apr 03 17:06:09 volumio startx[69520]: for help. Apr 03 17:06:09 volumio startx[69520]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information. Apr 03 17:06:09 volumio startx[69520]: (EE) Apr 03 17:06:09 volumio startx[69520]: (EE) Server terminated with error (1). Closing log file. Apr 03 17:06:09 volumio volumio[69488]: Starting albumart workers Apr 03 17:06:10 volumio volumio[69399]: info: Loading i18n strings for locale ru Apr 03 17:06:10 volumio volumio[69399]: Updating browse sources language Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::initPlayerControls Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: Express server listening on port 3000 Apr 03 17:06:10 volumio volumio[69399]: [Metrics] WebUI: 14s 609.16ms Apr 03 17:06:10 volumio volumio[69399]: info: Setting Device type: x86 Apr 03 17:06:10 volumio volumio[69399]: info: CoreStateMachine::resetVolumioState Apr 03 17:06:10 volumio volumio[69399]: info: CoreStateMachine::getcurrentVolume Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::volumioRetrievevolume Apr 03 17:06:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:10 volumio volumio[69399]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds Apr 03 17:06:10 volumio volumio[69399]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 03 17:06:10 volumio volumio[69399]: info: Completed loading Core Plugins Apr 03 17:06:10 volumio volumio[69399]: info: Preparing to generate the ALSA configuration file Apr 03 17:06:10 volumio volumio[69399]: info: The plugin stylish_player has an ALSA contribution file sp_in.sp_out.7.conf Apr 03 17:06:10 volumio volumio[69399]: info: Reading ALSA contributions from plugins. Apr 03 17:06:10 volumio volumio[69399]: info: Volumio Network Manager: Network status updated: 2 Apr 03 17:06:11 volumio volumio[69399]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 03 17:06:11 volumio volumio[69399]: verbose: New Socket.io Connection to 192.168.178.71 from 192.168.178.125 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 1 Apr 03 17:06:11 volumio volumio[69399]: verbose: New Socket.io Connection to 192.168.178.71 from 192.168.178.125 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 2 Apr 03 17:06:11 volumio volumio[69399]: info: Reloading queue from file Apr 03 17:06:11 volumio volumio[69399]: info: CoreStateMachine::setRepeat null single undefined Apr 03 17:06:11 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:11 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:11 volumio volumio[69399]: info: CoreStateMachine::setRandom null Apr 03 17:06:11 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:11 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:11 volumio volumio[69399]: verbose: New Socket.io Connection to 192.168.178.71 from 192.168.178.125 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 3 Apr 03 17:06:11 volumio volumio[69399]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Apr 03 17:06:11 volumio volumio[69399]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Apr 03 17:06:11 volumio volumio[69399]: info: Received Get System Info Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 17:06:11 volumio volumio[69399]: info: Discovery: Getting this device information Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:11 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 17:06:11 volumio volumio[69399]: verbose: New Socket.io Connection to 192.168.178.71 from 192.168.178.125 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 5 Apr 03 17:06:11 volumio volumio[69399]: info: Asound.conf file unchanged, so no further update is needed Apr 03 17:06:11 volumio volumio[69399]: info: Output device has changed, restarting MPD Apr 03 17:06:11 volumio volumio[69399]: info: Output device has changed, restarting Shairport Sync Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:11 volumio sudo[69552]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 03 17:06:11 volumio sudo[69552]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:11 volumio sudo[69552]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:11 volumio volumio[69399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 03 17:06:11 volumio sudo[69554]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 03 17:06:11 volumio volumio[69399]: info: ___________ START PLUGINS ___________ Apr 03 17:06:11 volumio sudo[69554]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:11 volumio volumio[69399]: info: ControllerMpd::onStart: Initializing MPD Apr 03 17:06:11 volumio volumio[69399]: info: Creating MPD Configuration file Apr 03 17:06:11 volumio sudo[69562]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Apr 03 17:06:11 volumio sudo[69562]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:11 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Apr 03 17:06:11 volumio volumio-remote-updater[735]: [2026-04-03 17:06:11] [connect] Successful connection Apr 03 17:06:11 volumio sudo[69565]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:11 volumio sudo[69565]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:11 volumio sudo[69562]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:11 volumio sudo[69565]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:11 volumio sudo[69567]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 03 17:06:11 volumio sudo[69567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:11 volumio volumio[69399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:11 volumio volumio[69399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 03 17:06:11 volumio volumio[69399]: info: [1775228771991] CoreMusicLibrary::Adding element Last_100 Apr 03 17:06:11 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 17:06:12 volumio volumio[69399]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 03 17:06:12 volumio volumio[69399]: info: [1775228772004] CoreMusicLibrary::Adding element Webradio Apr 03 17:06:12 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 17:06:12 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 17:06:12 volumio volumio[69399]: info: Initializing BBC Radios Apr 03 17:06:12 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 17:06:12 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:12 volumio volumio[69399]: info: [squeezelite_mc] Starting proxy server... Apr 03 17:06:12 volumio volumio[69399]: info: [now-playing] ConfigUpdater: config is up to date. Apr 03 17:06:12 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 03 17:06:12 volumio volumio[69399]: /usr/bin/mkfifo: cannot create fifo '/tmp/stream.mp3': File exists Apr 03 17:06:12 volumio volumio[69399]: error: ----failed to create fifo :Error: Command failed: /usr/bin/mkfifo -m 646 /tmp/stream.mp3 Apr 03 17:06:12 volumio volumio[69399]: /usr/bin/mkfifo: cannot create fifo '/tmp/stream.mp3': File exists Apr 03 17:06:12 volumio volumio[69399]: info: Stylish Player: Found process ID Apr 03 17:06:12 volumio volumio[69399]: info: Stylish Player: Starting audio server on port 9993 Apr 03 17:06:12 volumio sudo[69601]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Apr 03 17:06:12 volumio sudo[69601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:12 volumio volumio[69399]: info: Display-configuration --- loadI18nStrings: loading from /data/plugins/user_interface/display_configuration/i18n/strings_en.json Apr 03 17:06:12 volumio volumio[69399]: info: Display-configuration --- loadI18nStrings: loaded 52 keys Apr 03 17:06:12 volumio volumio[69399]: warn: Display-configuration --- Failed to load ru translations, using English Apr 03 17:06:12 volumio sudo[69601]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:12 volumio volumio[69399]: info: Volumio Calling Home Apr 03 17:06:12 volumio sudo[69605]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/bash -c 'if [ -f /root/.Xauthority ]; then cp /root/.Xauthority /home/volumio/ && chown volumio:volumio /home/volumio/.Xauthority; fi' Apr 03 17:06:12 volumio sudo[69605]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:12 volumio volumio[69399]: info: [squeezelite_mc] Proxy server started on port 42361 Apr 03 17:06:12 volumio volumio[69399]: info: Preparing to generate the ALSA configuration file Apr 03 17:06:12 volumio volumio[69399]: info: Stylish Player: Resilient Audio Streamer on port 9993 Apr 03 17:06:12 volumio volumio[69399]: info: Stylish Player: FIFO sentinel opened Apr 03 17:06:12 volumio volumio[69399]: info: Stylish Player: No stream clients — draining FIFO to keep ALSA unblocked Apr 03 17:06:12 volumio volumio[69399]: info: Stylish Player: Server listening on port 3339 Apr 03 17:06:12 volumio sudo[69605]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:13 volumio volumio[69399]: info: CoreCommandRouter::volumioRetrievevolume Apr 03 17:06:13 volumio volumio[69399]: info: [now-playing] App is listening on port 4004. Apr 03 17:06:13 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:13 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:13 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:13 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:13 volumio volumio[69399]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Apr 03 17:06:13 volumio volumio[69399]: info: [squeezelite_mc] Server discovery started Apr 03 17:06:13 volumio volumio[69399]: info: [squeezelite_mc] Player finder started Apr 03 17:06:13 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:13 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:13 volumio volumio[69399]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Apr 03 17:06:13 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 03 17:06:13 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 03 17:06:13 volumio volumio[69399]: info: Discovery: adding cd580391-eb6f-48a8-8db2-110f2c16bb9f Apr 03 17:06:13 volumio volumio[69399]: info: Discovery: Found device Volumio Apr 03 17:06:13 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:13 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:13 volumio volumio[69399]: info: The plugin stylish_player has an ALSA contribution file sp_in.sp_out.7.conf Apr 03 17:06:13 volumio volumio[69399]: info: Reading ALSA contributions from plugins. Apr 03 17:06:13 volumio volumio5-onboarding[1601]: time=2026-04-03T17:06:13.251+02:00 level=INFO msg="enabling BLE discovery" Apr 03 17:06:13 volumio volumio5-onboarding[1601]: time=2026-04-03T17:06:13.259+02:00 level=ERROR msg="failed to enable BLE discovery" error="failed to listen for BLE connections: failed to add service to adapter: Method \"RegisterApplication\" with signature \"oa{sv}\" on interface \"org.bluez.GattManager1\" doesn't exist\n" Apr 03 17:06:13 volumio systemd[1]: mpd.service: Deactivated successfully. Apr 03 17:06:13 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Apr 03 17:06:13 volumio systemd[1]: mpd.service: Consumed 3h 48min 33.294s CPU time. Apr 03 17:06:13 volumio systemd[1]: mpd.socket: Deactivated successfully. Apr 03 17:06:13 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Apr 03 17:06:13 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Apr 03 17:06:13 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 03 17:06:13 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Apr 03 17:06:13 volumio volumio[69399]: info: Discovery: this is already registered, cd580391-eb6f-48a8-8db2-110f2c16bb9f Apr 03 17:06:13 volumio volumio[69399]: info: Discovery: Found device Volumio Apr 03 17:06:13 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:13 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:13 volumio volumio[69399]: info: [squeezelite_mc] Card 5 supports the following ALSA formats: ["S32_LE","SPECIAL","S24_3LE","DSD_U32_BE"] Apr 03 17:06:13 volumio volumio[69399]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"volumio","dsdFormat":"DSD_U32_BE","card":"5","mixerType":"None","mixer":null} Apr 03 17:06:13 volumio volumio[69399]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Apr 03 17:06:13 volumio volumio[69399]: info: Display-configuration --- fixXauthority: /home/volumio/.Xauthority updated Apr 03 17:06:13 volumio volumio[69399]: info: MPD Permissions set Apr 03 17:06:13 volumio volumio[69399]: info: MPD Permissions set Apr 03 17:06:13 volumio volumio-remote-updater[735]: [2026-04-03 17:06:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1775228771 101 Apr 03 17:06:13 volumio sudo[69629]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Apr 03 17:06:14 volumio sudo[69629]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:14 volumio volumio[69399]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 6 Apr 03 17:06:14 volumio volumio5-onboarding[1601]: time=2026-04-03T17:06:14.025+02:00 level=INFO msg="service successfully established" component=discovery/localnet Apr 03 17:06:14 volumio volumio[69399]: info: [squeezelite_mc] Server discovered: {"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"} Apr 03 17:06:14 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 1/30)... Apr 03 17:06:14 volumio volumio[69399]: info: Volumio called home Apr 03 17:06:14 volumio sudo[69629]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:14 volumio sudo[69626]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 03 17:06:14 volumio sudo[69626]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 03 17:06:14 volumio sudo[69626]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:14 volumio volumio[69399]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Apr 03 17:06:14 volumio volumio[69399]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Apr 03 17:06:14 volumio sudo[69652]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Apr 03 17:06:14 volumio sudo[69652]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:14 volumio volumio[69399]: verbose: New Socket.io Connection to 192.168.178.71 from 192.168.178.125 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 9 Apr 03 17:06:14 volumio volumio[69399]: info: Starting Shairport Sync Apr 03 17:06:14 volumio volumio[69399]: info: Starting Shairport Sync Apr 03 17:06:14 volumio volumio[69399]: info: Starting Shairport Sync Apr 03 17:06:14 volumio sudo[69652]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:14 volumio volumio[69399]: info: Asound.conf file unchanged, so no further update is needed Apr 03 17:06:14 volumio volumio[69399]: info: Output device has changed, restarting MPD Apr 03 17:06:14 volumio volumio[69399]: info: Output device has changed, restarting Shairport Sync Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:14 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:14 volumio sudo[69660]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 03 17:06:14 volumio sudo[69656]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 03 17:06:14 volumio sudo[69664]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 03 17:06:14 volumio sudo[69664]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:14 volumio sudo[69662]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 03 17:06:14 volumio sudo[69656]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:14 volumio sudo[69658]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 03 17:06:14 volumio sudo[69658]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:14 volumio sudo[69662]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:14 volumio sudo[69660]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:14 volumio sudo[69662]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:14 volumio systemd[1]: mpd.service: Deactivated successfully. Apr 03 17:06:14 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Apr 03 17:06:14 volumio volumio[69399]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 03 17:06:14 volumio systemd[1]: mpd.socket: Deactivated successfully. Apr 03 17:06:14 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Apr 03 17:06:14 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:15 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:15 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 03 17:06:15 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Apr 03 17:06:15 volumio volumio[69399]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Apr 03 17:06:15 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 03 17:06:15 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Apr 03 17:06:15 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 03 17:06:15 volumio systemd[1]: shairport-sync.service: Consumed 2min 47.064s CPU time. Apr 03 17:06:15 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 03 17:06:15 volumio sudo[69656]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:15 volumio sudo[69660]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:15 volumio sudo[69658]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:15 volumio sudo[69680]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Apr 03 17:06:15 volumio sudo[69680]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:15 volumio sudo[69680]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:15 volumio volumio[69399]: info: Received Get System Info Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 17:06:15 volumio volumio[69399]: info: Discovery: Getting this device information Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:15 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:15 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:15 volumio volumio[69399]: info: Received Get System Info Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 17:06:15 volumio volumio[69399]: info: Discovery: Getting this device information Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:15 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:15 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:15 volumio sudo[69676]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 03 17:06:15 volumio sudo[69676]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 17:06:15 volumio sudo[69676]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:15 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:15 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 03 17:06:15 volumio volumio[69399]: info: Received Get System Info Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 17:06:15 volumio volumio[69399]: info: Discovery: Getting this device information Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:15 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:15 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:15 volumio volumio[69399]: info: Listing playlists Apr 03 17:06:15 volumio volumio[69399]: info: CoreCommandRouter::volumioGetQueue Apr 03 17:06:15 volumio volumio[69399]: info: CoreStateMachine::getQueue Apr 03 17:06:15 volumio volumio[69399]: info: CorePlayQueue::getQueue Apr 03 17:06:16 volumio volumio[69399]: info: Received Get System Info Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 17:06:16 volumio volumio[69399]: info: Discovery: Getting this device information Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:16 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:16 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:16 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:16 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 03 17:06:16 volumio volumio[69399]: info: Received Get System Info Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 17:06:16 volumio volumio[69399]: info: Discovery: Getting this device information Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:16 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:16 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:16 volumio volumio[69399]: info: Listing playlists Apr 03 17:06:16 volumio volumio[69399]: info: CoreCommandRouter::volumioGetQueue Apr 03 17:06:16 volumio volumio[69399]: info: CoreStateMachine::getQueue Apr 03 17:06:16 volumio volumio[69399]: info: CorePlayQueue::getQueue Apr 03 17:06:17 volumio volumio[69399]: info: Received Get System Info Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 17:06:17 volumio volumio[69399]: info: Discovery: Getting this device information Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:17 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:17 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:17 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:17 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 03 17:06:17 volumio volumio[69399]: info: Received Get System Info Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 17:06:17 volumio volumio[69399]: info: Discovery: Getting this device information Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:17 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:17 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:17 volumio volumio[69399]: info: Listing playlists Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::volumioGetQueue Apr 03 17:06:17 volumio volumio[69399]: info: CoreStateMachine::getQueue Apr 03 17:06:17 volumio volumio[69399]: info: CorePlayQueue::getQueue Apr 03 17:06:17 volumio volumio[69399]: info: Received Get System Info Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 17:06:17 volumio volumio[69399]: info: Discovery: Getting this device information Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:17 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 17:06:17 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:17 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:18 volumio volumio[69399]: info: MPD Permissions set Apr 03 17:06:18 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:18 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:18 volumio volumio[69399]: info: Cannot mount NAS Music at system boot, trial number 3 ,retrying in 5 seconds Apr 03 17:06:18 volumio volumio[69399]: info: [squeezelite_mc] Notification listener started Apr 03 17:06:18 volumio volumio[69399]: info: [squeezelite_mc] Getting players connected to daphile (192.168.178.23) Apr 03 17:06:18 volumio volumio[69399]: info: Shairport-Sync Started Apr 03 17:06:18 volumio volumio[69399]: Error adding Membership: Error: addMembership EINVAL Apr 03 17:06:18 volumio volumio[69399]: info: Shairport-Sync Started Apr 03 17:06:18 volumio volumio[69399]: info: Shairport-Sync Started Apr 03 17:06:18 volumio volumio[69399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Apr 03 17:06:18 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 2/30)... Apr 03 17:06:18 volumio sudo[69705]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 03 17:06:18 volumio sudo[69705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:19 volumio systemd[1]: Reloading. Apr 03 17:06:19 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:19 volumio volumio[69399]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 17:06:19 volumio volumio[69399]: info: CoreStateMachine::ClearQueue Apr 03 17:06:19 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:19 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:19 volumio volumio[69399]: info: CorePlayQueue::clearPlayQueue Apr 03 17:06:19 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:19 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:19 volumio volumio[69399]: info: CoreStateMachine::addQueueItems Apr 03 17:06:19 volumio volumio[69399]: info: CorePlayQueue::addQueueItems Apr 03 17:06:19 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:19 volumio volumio[69399]: info: Adding Item to queue: music-library/NAS/Music/100% Open Your Ears - The Ultimate Test Disc For Headphones (2018) [WAV] Apr 03 17:06:19 volumio volumio[69399]: info: Exploding uri music-library/NAS/Music/100% Open Your Ears - The Ultimate Test Disc For Headphones (2018) [WAV] in service mpd Apr 03 17:06:19 volumio volumio[69399]: error: Failed to stat '/mnt/NAS/Music/100% Open Your Ears - The Ultimate Test Disc For Headphones (2018) [WAV]' Apr 03 17:06:19 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:20 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:20 volumio volumio[69399]: info: CoreStateMachine::updateTrackBlock Apr 03 17:06:20 volumio volumio[69399]: info: CorePlayQueue::getTrackBlock Apr 03 17:06:20 volumio volumio[69399]: info: CoreCommandRouter::volumioPlay Apr 03 17:06:20 volumio volumio[69399]: info: CoreStateMachine::play index 0 Apr 03 17:06:20 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:20 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:20 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:20 volumio volumio[69399]: info: CoreStateMachine::play index undefined Apr 03 17:06:20 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:20 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:20 volumio volumio[69399]: info: [squeezelite_mc] Players connected to daphile (192.168.178.23): [{"id":"80:0a:80:5d:66:b8","uuid":null,"ip":"192.168.178.175","name":"DMP-A6","server":{"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"}},{"id":"10:0b:a9:59:82:b4","uuid":null,"ip":"192.168.178.71","name":"volumio","server":{"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"}},{"id":"b8:27:eb:24:e4:47","uuid":null,"ip":"192.168.178.58","name":"RoPieee","server":{"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"}},{"id":"00:22:6c:3d:a8:6a","uuid":null,"ip":"192.168.178.36","name":"Büro","server":{"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"}}] Apr 03 17:06:20 volumio volumio[69399]: info: [squeezelite_mc] Player found: {"id":"10:0b:a9:59:82:b4","uuid":null,"ip":"192.168.178.71","name":"volumio","server":{"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"}} Apr 03 17:06:21 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 3/30)... Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:21 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 03 17:06:21 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:06:22 volumio systemd[1]: /lib/systemd/system/roonbridge.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 17:06:22 volumio systemd[1]: /lib/systemd/system/roonbridge.service:8: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 17:06:23 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1162. Apr 03 17:06:23 volumio sudo[69705]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:23 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 17:06:23 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 17:06:23 volumio startx[69519]: xinit: giving up Apr 03 17:06:23 volumio startx[69519]: xinit: unable to connect to X server: Cannot assign requested address Apr 03 17:06:23 volumio startx[69519]: xinit: server error Apr 03 17:06:23 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Apr 03 17:06:23 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Apr 03 17:06:24 volumio upmpdcli[69759]: Could not open config: /tmp/upmpdcli.conf Apr 03 17:06:24 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 17:06:24 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 17:06:24 volumio mpd[69686]: 2026-04-03T17:06:24 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 03 17:06:24 volumio volumio[69399]: info: Cannot mount NAS Music at system boot, trial number 4 ,retrying in 5 seconds Apr 03 17:06:24 volumio systemd[1]: Started mpd.service - Music Player Daemon. Apr 03 17:06:24 volumio sudo[69554]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:24 volumio sudo[69567]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:24 volumio sudo[69664]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:25 volumio volumio[69399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 03 17:06:25 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 4/30)... Apr 03 17:06:25 volumio sudo[69767]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 03 17:06:25 volumio sudo[69767]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:25 volumio sudo[69767]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:26 volumio volumio[69399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true Apr 03 17:06:26 volumio volumio[69399]: info: Starting Shairport Sync Apr 03 17:06:26 volumio sudo[69773]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite Apr 03 17:06:26 volumio sudo[69773]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:26 volumio systemd[1]: Stopping squeezelite.service - Squeezelite lightweight headless Squeezebox emulator... Apr 03 17:06:26 volumio sudo[69778]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 03 17:06:26 volumio sudo[69778]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:26 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 03 17:06:26 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Apr 03 17:06:26 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 03 17:06:26 volumio systemd[1]: shairport-sync.service: Consumed 1.403s CPU time. Apr 03 17:06:26 volumio volumio[69399]: error: MPD error: The expression evaluated to a falsy value: Apr 03 17:06:26 volumio volumio[69399]: assert.ok(self.idling) Apr 03 17:06:26 volumio volumio[69399]: error: The expression evaluated to a falsy value: Apr 03 17:06:26 volumio volumio[69399]: assert.ok(self.idling) Apr 03 17:06:26 volumio volumio[69399]: error: MPD error: The expression evaluated to a falsy value: Apr 03 17:06:26 volumio volumio[69399]: assert.ok(self.idling) Apr 03 17:06:26 volumio volumio[69399]: error: The expression evaluated to a falsy value: Apr 03 17:06:26 volumio volumio[69399]: assert.ok(self.idling) Apr 03 17:06:26 volumio volumio[69399]: info: MPD running with PID69686 Apr 03 17:06:26 volumio volumio[69399]: ,establishing connection Apr 03 17:06:27 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 03 17:06:27 volumio volumio[69399]: error: updateQueue error: null Apr 03 17:06:27 volumio volumio[69399]: info: [squeezelite_mc] 'client' notification received from daphile (192.168.178.23); type is 'disconnect' Apr 03 17:06:27 volumio sudo[69778]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:27 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:27 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:27 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 5/30)... Apr 03 17:06:27 volumio volumio[69399]: info: Shairport-Sync Started Apr 03 17:06:27 volumio volumio[69399]: error: updateQueue error: null Apr 03 17:06:27 volumio systemd[1]: squeezelite.service: Deactivated successfully. Apr 03 17:06:27 volumio systemd[1]: Stopped squeezelite.service - Squeezelite lightweight headless Squeezebox emulator. Apr 03 17:06:27 volumio systemd[1]: squeezelite.service: Consumed 1min 48.252s CPU time. Apr 03 17:06:27 volumio sudo[69773]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:27 volumio volumio[69399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 03 17:06:27 volumio sudo[69797]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 03 17:06:27 volumio sudo[69797]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:27 volumio sudo[69797]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:27 volumio volumio[69399]: info: [squeezelite_mc] Executing rm /tmp/squeezelite.log Apr 03 17:06:27 volumio sudo[69801]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm /tmp/squeezelite.log Apr 03 17:06:27 volumio sudo[69801]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:27 volumio sudo[69801]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:27 volumio volumio[69399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true Apr 03 17:06:28 volumio sudo[69804]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Apr 03 17:06:28 volumio sudo[69804]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:28 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 6/30)... Apr 03 17:06:28 volumio systemd[1]: Starting squeezelite.service - Squeezelite lightweight headless Squeezebox emulator... Apr 03 17:06:28 volumio systemd[1]: Started squeezelite.service - Squeezelite lightweight headless Squeezebox emulator. Apr 03 17:06:28 volumio sudo[69804]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:28 volumio volumio[69399]: info: [squeezelite_mc] 'client' notification received from daphile (192.168.178.23); type is 'connect' Apr 03 17:06:28 volumio volumio[69399]: info: [squeezelite_mc] Getting players connected to daphile (192.168.178.23) Apr 03 17:06:28 volumio volumio[69399]: info: [squeezelite_mc] Players connected to daphile (192.168.178.23): [{"id":"80:0a:80:5d:66:b8","uuid":null,"ip":"192.168.178.175","name":"DMP-A6","server":{"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"}},{"id":"10:0b:a9:59:82:b4","uuid":null,"ip":"192.168.178.71","name":"volumio","server":{"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"}},{"id":"b8:27:eb:24:e4:47","uuid":null,"ip":"192.168.178.58","name":"RoPieee","server":{"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"}},{"id":"00:22:6c:3d:a8:6a","uuid":null,"ip":"192.168.178.36","name":"Büro","server":{"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"}}] Apr 03 17:06:28 volumio volumio[69399]: info: [squeezelite_mc] Player found: {"id":"10:0b:a9:59:82:b4","uuid":null,"ip":"192.168.178.71","name":"volumio","server":{"ip":"192.168.178.23","name":"daphile","ver":"9.0.3","uuid":"847b7210-3398-4587-bc6a-47fe300b3a73","jsonPort":"9000","cliPort":"9090"}} Apr 03 17:06:28 volumio volumio[69399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 03 17:06:28 volumio sudo[69814]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 03 17:06:28 volumio sudo[69814]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:28 volumio sudo[69814]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:29 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 7/30)... Apr 03 17:06:29 volumio systemd[1]: volumio-kiosk.service: Scheduled restart job, restart counter is at 776. Apr 03 17:06:29 volumio systemd[1]: Stopped volumio-kiosk.service - Start Volumio Kiosk. Apr 03 17:06:29 volumio systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk. Apr 03 17:06:29 volumio volumio[69399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 03 17:06:29 volumio sudo[69841]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 03 17:06:29 volumio sudo[69841]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:29 volumio sudo[69841]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:29 volumio startx[69843]: X.Org X Server 1.21.1.7 Apr 03 17:06:29 volumio startx[69843]: X Protocol Version 11, Revision 0 Apr 03 17:06:29 volumio startx[69843]: Current Operating System: Linux volumio 6.12.57-volumio #2 SMP PREEMPT_DYNAMIC Thu Nov 13 17:08:37 CET 2025 x86_64 Apr 03 17:06:29 volumio startx[69843]: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=cf910561-1d44-4877-9f78-123e8c799de7 bootpart=UUID=9EE8-B65A datapart=UUID=afe8532e-510d-4a5f-ae48-965db99841c8 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=native net.ifnames=0 use_kmsg=no initrd=volumio.initrd Apr 03 17:06:29 volumio startx[69843]: xorg-server 2:21.1.7-3+deb12u11 (https://www.debian.org/support) Apr 03 17:06:29 volumio startx[69843]: Current version of pixman: 0.42.2 Apr 03 17:06:29 volumio startx[69843]: Before reporting problems, check http://wiki.x.org Apr 03 17:06:29 volumio startx[69843]: to make sure that you have the latest version. Apr 03 17:06:29 volumio startx[69843]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 03 17:06:29 volumio startx[69843]: (++) from command line, (!!) notice, (II) informational, Apr 03 17:06:29 volumio startx[69843]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 03 17:06:29 volumio startx[69843]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Apr 3 17:06:29 2026 Apr 03 17:06:29 volumio startx[69843]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 03 17:06:29 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:29 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:29 volumio volumio[69399]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Apr 03 17:06:30 volumio volumio[69399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 03 17:06:30 volumio sudo[69846]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 03 17:06:30 volumio sudo[69846]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:30 volumio sudo[69846]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:30 volumio volumio[69399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 03 17:06:30 volumio startx[69843]: (EE) Apr 03 17:06:30 volumio startx[69843]: Fatal server error: Apr 03 17:06:30 volumio startx[69843]: (EE) AddScreen/ScreenInit failed for driver 0 Apr 03 17:06:30 volumio startx[69843]: (EE) Apr 03 17:06:30 volumio startx[69843]: (EE) Apr 03 17:06:30 volumio startx[69843]: Please consult the The X.Org Foundation support Apr 03 17:06:30 volumio startx[69843]: at http://wiki.x.org Apr 03 17:06:30 volumio startx[69843]: for help. Apr 03 17:06:30 volumio startx[69843]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information. Apr 03 17:06:30 volumio startx[69843]: (EE) Apr 03 17:06:30 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 8/30)... Apr 03 17:06:30 volumio startx[69843]: (EE) Server terminated with error (1). Closing log file. Apr 03 17:06:30 volumio sudo[69852]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 03 17:06:30 volumio sudo[69852]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:30 volumio sudo[69852]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:31 volumio volumio[69399]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Apr 03 17:06:31 volumio sudo[69869]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Apr 03 17:06:31 volumio sudo[69869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:31 volumio sudo[69869]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:31 volumio volumio[69399]: info: Completed starting Core Plugins Apr 03 17:06:31 volumio volumio[69399]: info: ------------------------------------------- Apr 03 17:06:31 volumio volumio[69399]: info: ----- MyVolumio plugins startup ---- Apr 03 17:06:31 volumio volumio[69399]: info: ------------------------------------------- Apr 03 17:06:31 volumio volumio[69399]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 03 17:06:31 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 9/30)... Apr 03 17:06:32 volumio volumio[69399]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 03 17:06:34 volumio volumio[69399]: Cannot compose Albumart path Apr 03 17:06:34 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 10/30)... Apr 03 17:06:35 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:35 volumio volumio[69399]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::ClearQueue Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:35 volumio volumio[69399]: info: CorePlayQueue::clearPlayQueue Apr 03 17:06:35 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:35 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::addQueueItems Apr 03 17:06:35 volumio volumio[69399]: info: CorePlayQueue::addQueueItems Apr 03 17:06:35 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:35 volumio volumio[69399]: info: Adding Item to queue: music-library/NAS/Music/100% Open Your Ears - The Ultimate Test Disc For Headphones (2018) [WAV] Apr 03 17:06:35 volumio volumio[69399]: info: Using cached record of: music-library/NAS/Music/100% Open Your Ears - The Ultimate Test Disc For Headphones (2018) [WAV] Apr 03 17:06:35 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:35 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::updateTrackBlock Apr 03 17:06:35 volumio volumio[69399]: info: CorePlayQueue::getTrackBlock Apr 03 17:06:35 volumio volumio[69399]: info: CoreCommandRouter::volumioPlay Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::play index 0 Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::play index undefined Apr 03 17:06:35 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:35 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:35 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 11/30)... Apr 03 17:06:36 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 12/30)... Apr 03 17:06:37 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 13/30)... Apr 03 17:06:38 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 14/30)... Apr 03 17:06:39 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1163. Apr 03 17:06:39 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 17:06:39 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 17:06:39 volumio upmpdcli[69894]: Could not open config: /tmp/upmpdcli.conf Apr 03 17:06:39 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 17:06:39 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 03 17:06:39 volumio volumio[69399]: info: Adding plugin bluetooth to MyMusic Plugins Apr 03 17:06:39 volumio volumio[69399]: info: Adding plugin multiroom to MyMusic Plugins Apr 03 17:06:39 volumio volumio[69399]: info: Adding plugin metavolumio to MyMusic Plugins Apr 03 17:06:39 volumio volumio[69399]: info: Adding plugin cd_controller to MyMusic Plugins Apr 03 17:06:39 volumio volumio[69399]: info: Adding plugin qobuzconnect to MyMusic Plugins Apr 03 17:06:39 volumio volumio[69399]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 03 17:06:39 volumio volumio[69399]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 03 17:06:39 volumio volumio[69399]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 03 17:06:41 volumio volumio[69399]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 03 17:06:41 volumio volumio[69399]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 03 17:06:41 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:41 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:41 volumio volumio[69399]: info: Starting MyVolumio Remote Streaming Endpoints Apr 03 17:06:41 volumio volumio[69399]: info: MyVolumio login type: Token Apr 03 17:06:41 volumio volumio[69399]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 03 17:06:41 volumio volumio[69399]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 03 17:06:43 volumio volumio[69399]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 03 17:06:43 volumio volumio[69399]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 03 17:06:43 volumio volumio[69399]: info: Streaming services startup Apr 03 17:06:43 volumio volumio[69399]: info: Starting Streaming Daemon Apr 03 17:06:43 volumio sudo[69913]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 03 17:06:43 volumio sudo[69913]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:43 volumio volumio[69399]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 03 17:06:43 volumio sudo[69913]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 03 17:06:43 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::ClearQueue Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::clearPlayQueue Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::addQueueItems Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::addQueueItems Apr 03 17:06:43 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:43 volumio volumio[69399]: info: Adding Item to queue: music-library/NAS/Music/100% Open Your Ears - The Ultimate Test Disc For Headphones (2018) [WAV] Apr 03 17:06:43 volumio volumio[69399]: info: Using cached record of: music-library/NAS/Music/100% Open Your Ears - The Ultimate Test Disc For Headphones (2018) [WAV] Apr 03 17:06:43 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::ClearQueue Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::clearPlayQueue Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::addQueueItems Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::addQueueItems Apr 03 17:06:43 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:43 volumio volumio[69399]: info: Adding Item to queue: music-library/NAS/Music/10cc Apr 03 17:06:43 volumio volumio[69399]: info: Exploding uri music-library/NAS/Music/10cc in service mpd Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::updateTrackBlock Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::getTrackBlock Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::volumioPlay Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::play index 0 Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::play index undefined Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:43 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 15/30)... Apr 03 17:06:43 volumio volumio[69399]: error: Cannot start Volumio Streaming Daemon Apr 03 17:06:43 volumio volumio[69399]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 03 17:06:43 volumio volumio[69399]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F01%20-%2010cc%20-%20Age%20Of%20Consent.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F02%20-%2010cc%20-%20Code%20Of%20Silence.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/02 - 10cc - Code Of Silence.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F03%20-%2010cc%20-%20Everything%20Is%20Not%20Enough.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/03 - 10cc - Everything Is Not Enough.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F04%20-%2010cc%20-%20Margo%20Wants%20The%20Mustard.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/04 - 10cc - Margo Wants The Mustard.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F05%20-%20Eric%20Stewart%20-%20More%20And%20More%20Each%20Day.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/05 - Eric Stewart - More And More Each Day.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F06%20-%20Eric%20Stewart%20-%20A%20Human%20Being.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/06 - Eric Stewart - A Human Being.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F07%20-%2010cc%20-%20Yvonne's%20The%20One.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/07 - 10cc - Yvonne's The One.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F08%20-%20Eric%20Stewart%20-%20You%20Are%20Not%20Me.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/08 - Eric Stewart - You Are Not Me.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F09%20-%20Eric%20Stewart%20-%20A%20Friend%20In%20Need.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/09 - Eric Stewart - A Friend In Need.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F10%20-%20Eric%20Stewart%20-%20You%20Can't%20Take%20It%20With%20You.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/10 - Eric Stewart - You Can't Take It With You.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F11%20-%20Eric%20Stewart%20-%20This%20Must%20Be%20Heaven.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/11 - Eric Stewart - This Must Be Heaven.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD1%2F12%20-%20Eric%20Stewart%20-%20Heaven%20Knows.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/12 - Eric Stewart - Heaven Knows.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F01%20-%20Eric%20Stewart%20-%20Do%20The%20Books.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/01 - Eric Stewart - Do The Books.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F02%20-%20Eric%20Stewart%20-%20Girls.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/02 - Eric Stewart - Girls.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F03%20-%20Eric%20Stewart%20-%20Viva%20La%20Difference.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/03 - Eric Stewart - Viva La Difference.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F04%20-%20Eric%20Stewart%20-%20We're%20Not%20Alone.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/04 - Eric Stewart - We're Not Alone.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F05%20-%20Eric%20Stewart%20-%20Word%20Of%20The%20Mouth.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/05 - Eric Stewart - Word Of The Mouth.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F06%20-%20Eric%20Stewart%20-%20Sleep%20At%20Night.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/06 - Eric Stewart - Sleep At Night.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F07%20-%20Eric%20Stewart%20-%20Can't%20Get%20Enough.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/07 - Eric Stewart - Can't Get Enough.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F08%20-%20Eric%20Stewart%20-%20It's%20In%20The%20Blood.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/08 - Eric Stewart - It's In The Blood.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F09%20-%20Eric%20Stewart%20-%20Friends%20Like%20These.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/09 - Eric Stewart - Friends Like These.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F10%20-%20Eric%20Stewart%20-%20Do%20Not%20Bend.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/10 - Eric Stewart - Do Not Bend.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Eric%20Stewart/Anthology/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Anthology%20%5B149317596%5D%20%5B2017%5D%2FCD2%2F11%20-%20Eric%20Stewart%20-%20No%2C%20No%2C%20Nettie.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD2/11 - Eric Stewart - No, No, Nettie.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F01%20-%2010cc%20-%20Good%20Morning%20Judge.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/01 - 10cc - Good Morning Judge.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F02%20-%2010cc%20-%20The%20Things%20We%20Do%20For%20Love.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/02 - 10cc - The Things We Do For Love.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F03%20-%2010cc%20-%20Marriage%20Bureau%20Rendezvous.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/03 - 10cc - Marriage Bureau Rendezvous.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F04%20-%2010cc%20-%20People%20In%20Love.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/04 - 10cc - People In Love.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F05%20-%2010cc%20-%20Modern%20Man%20Blues.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/05 - 10cc - Modern Man Blues.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F06%20-%2010cc%20-%20Honeymoon%20With%20B%20Troop.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/06 - 10cc - Honeymoon With B Troop.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F07%20-%2010cc%20-%20I%20Bought%20A%20Flat%20Guitar%20Tutor.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/07 - 10cc - I Bought A Flat Guitar Tutor.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F08%20-%2010cc%20-%20You've%20Got%20A%20Cold.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/08 - 10cc - You've Got A Cold.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F09%20-%2010cc%20-%20Feel%20The%20Benefit%20((Pts.%201%2C%202%20%26%203)).flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/09 - 10cc - Feel The Benefit ((Pts. 1, 2 & 3)).flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F10%20-%2010cc%20-%20Hot%20To%20Trot.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/10 - 10cc - Hot To Trot.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F11%20-%2010cc%20-%20Don't%20Squeeze%20Me%20Like%20Toothpaste.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/11 - 10cc - Don't Squeeze Me Like Toothpaste.flac Apr 03 17:06:43 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=10cc/Deceptive%20Bends/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F10cc%2F%5BM%5D%20Deceptive%20Bends%20%5B2570032%5D%20%5B1977%5D%2F12%20-%2010cc%20-%20I'm%20So%20Laid%20Back%2C%20I'm%20Laid%20Out.flac&metadata=false Apr 03 17:06:43 volumio volumio[69399]: info: URI /mnt/NAS/Music/10cc/[M] Deceptive Bends [2570032] [1977]/12 - 10cc - I'm So Laid Back, I'm Laid Out.flac Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::updateTrackBlock Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::getTrackBlock Apr 03 17:06:43 volumio volumio[69399]: info: CoreCommandRouter::volumioPlay Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::play index 0 Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::play index undefined Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:43 volumio volumio[69399]: info: CoreStateMachine::startPlaybackTimer Apr 03 17:06:43 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:43 volumio volumio[69399]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac Apr 03 17:06:43 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 17:06:43 volumio volumio[69399]: info: sendMpdCommand stop took 12 milliseconds Apr 03 17:06:43 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:43 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:43 volumio volumio[69399]: info: sendMpdCommand clear took 9 milliseconds Apr 03 17:06:43 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac" Apr 03 17:06:43 volumio volumio[69399]: error: updateQueue error: null Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:43 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:43 volumio volumio[69399]: info: ------------------------------ 10ms Apr 03 17:06:43 volumio volumio[69399]: info: sendMpdCommand add "NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac" took 7 milliseconds Apr 03 17:06:43 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand play Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:43 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:43 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:43 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:43 volumio volumio[69399]: info: ------------------------------ 34ms Apr 03 17:06:43 volumio volumio[69399]: info: sendMpdCommand play took 30 milliseconds Apr 03 17:06:43 volumio volumio[69399]: info: ------------------------------ 29ms Apr 03 17:06:43 volumio volumio[69399]: info: ------------------------------ 27ms Apr 03 17:06:43 volumio volumio[69399]: info: ------------------------------ 24ms Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:43 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:43 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:43 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:43 volumio volumio[69399]: info: ------------------------------ 47ms Apr 03 17:06:43 volumio volumio[69399]: info: ------------------------------ 45ms Apr 03 17:06:43 volumio volumio[69399]: info: ------------------------------ 44ms Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:43 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:43 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:43 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:43 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:43 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:43 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:43 volumio volumio[69399]: info: Apr 03 17:06:43 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:43 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:43 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:44 volumio volumio[69399]: error: MyVolumio Custom Token format not valid, refreshing it Apr 03 17:06:44 volumio volumio[69399]: info: Apr 03 17:06:44 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand status took 313 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand status took 259 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand status took 250 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand status took 247 milliseconds Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:44 volumio volumio[69399]: info: Apr 03 17:06:44 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:44 volumio volumio[69399]: info: Apr 03 17:06:44 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:44 volumio volumio[69399]: info: Apr 03 17:06:44 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand status took 185 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 169 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 163 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 163 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 162 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand status took 149 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand status took 142 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand status took 151 milliseconds Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:44 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus stop Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:44 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:44 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio startx[69842]: xinit: giving up Apr 03 17:06:44 volumio startx[69842]: xinit: unable to connect to X server: Cannot assign requested address Apr 03 17:06:44 volumio startx[69842]: xinit: server error Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:44 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:44 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:44 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:44 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:44 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio systemd[1]: volumio-kiosk.service: Consumed 1.369s CPU time. Apr 03 17:06:44 volumio volumio[69399]: info: ------------------------------ 736ms Apr 03 17:06:44 volumio volumio[69399]: info: ------------------------------ 786ms Apr 03 17:06:44 volumio volumio[69399]: info: ------------------------------ 782ms Apr 03 17:06:44 volumio volumio[69399]: info: ------------------------------ 775ms Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 309 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 298 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 297 milliseconds Apr 03 17:06:44 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 296 milliseconds Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:44 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1209,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"715 Kbps","isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:44 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:44 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1209,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"715 Kbps","isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:44 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:44 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1209,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"715 Kbps","isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:44 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:44 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1209,"duration":345,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"715 Kbps","isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:44 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:44 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:44 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:44 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:44 volumio volumio[69399]: info: ------------------------------ 725ms Apr 03 17:06:44 volumio volumio[69399]: info: ------------------------------ 684ms Apr 03 17:06:44 volumio volumio[69399]: info: ------------------------------ 679ms Apr 03 17:06:44 volumio volumio[69399]: info: ------------------------------ 672ms Apr 03 17:06:44 volumio volumio-remote-updater[735]: Test mode disabled Apr 03 17:06:44 volumio volumio-remote-updater[735]: Alpha mode disabled Apr 03 17:06:44 volumio volumio-remote-updater[735]: Alpha legacy test mode disabled Apr 03 17:06:44 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 03 17:06:45 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 16/30)... Apr 03 17:06:45 volumio volumio[69399]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 03 17:06:45 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 03 17:06:45 volumio volumio[69399]: info: MyVolumio login type: Token Apr 03 17:06:46 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 17/30)... Apr 03 17:06:46 volumio volumio[69399]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 03 17:06:47 volumio volumio[69399]: info: MyVolumio token set successfully Apr 03 17:06:47 volumio volumio[69399]: info: MYVOLUMIO: Adding device Apr 03 17:06:47 volumio volumio[69399]: info: MYVOLUMIO: Evaluating Server Apr 03 17:06:47 volumio volumio[69399]: info: MyVolumio status changed Apr 03 17:06:47 volumio volumio[69399]: info: Streaming services startup Apr 03 17:06:47 volumio volumio[69399]: info: Starting Streaming Daemon Apr 03 17:06:47 volumio volumio[69399]: info: Removing browser output: myVolumio user plan is not superstar Apr 03 17:06:47 volumio volumio[69399]: info: Removing audio output: Apr 03 17:06:47 volumio volumio[69399]: info: Stoppping Tunnel 1 Apr 03 17:06:47 volumio sudo[69963]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 03 17:06:47 volumio sudo[69963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:47 volumio sudo[69965]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 03 17:06:47 volumio sudo[69965]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:06:47 volumio sudo[69963]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:47 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 18/30)... Apr 03 17:06:48 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::ClearQueue Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::stPlaybackTimer Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::updateTrackBlock Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrackBlock Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::serviceStop Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::serviceStop Apr 03 17:06:48 volumio volumio[69399]: info: ControllerMpd::stop Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::clearPlayQueue Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::addQueueItems Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::addQueueItems Apr 03 17:06:48 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:48 volumio volumio[69399]: info: Adding Item to queue: music-library/NAS/Music/100% Open Your Ears - The Ultimate Test Disc For Headphones (2018) [WAV] Apr 03 17:06:48 volumio volumio[69399]: info: Using cached record of: music-library/NAS/Music/100% Open Your Ears - The Ultimate Test Disc For Headphones (2018) [WAV] Apr 03 17:06:48 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:48 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::updateTrackBlock Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrackBlock Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPlay Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::play index 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::play index undefined Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 17:06:48 volumio volumio[69399]: info: Setting Geolocation for MyVolumio to eu4 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:48 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:48 volumio volumio[69399]: error: Cannot start Volumio Streaming Daemon Apr 03 17:06:48 volumio volumio[69399]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 03 17:06:48 volumio volumio[69399]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 03 17:06:48 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 17:06:48 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 03 17:06:48 volumio volumio[69399]: info: Apr 03 17:06:48 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:48 volumio volumio[69399]: info: sendMpdCommand stop took 126 milliseconds Apr 03 17:06:48 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:48 volumio volumio[69399]: info: Apr 03 17:06:48 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:48 volumio sudo[69965]: pam_unix(sudo:session): session closed for user root Apr 03 17:06:48 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:48 volumio volumio[69399]: info: Apr 03 17:06:48 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:48 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:48 volumio volumio[69399]: info: Apr 03 17:06:48 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:48 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:48 volumio volumio[69399]: info: sendMpdCommand status took 26 milliseconds Apr 03 17:06:48 volumio volumio[69399]: info: sendMpdCommand status took 16 milliseconds Apr 03 17:06:48 volumio volumio[69399]: info: sendMpdCommand status took 10 milliseconds Apr 03 17:06:48 volumio volumio[69399]: info: sendMpdCommand status took 6 milliseconds Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:48 volumio volumio[69399]: info: Remote SSH Stopped Apr 03 17:06:48 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 03 17:06:48 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 03 17:06:48 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 03 17:06:48 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:48 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:48 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:48 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::syncState stateService stop Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus stop Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: No code Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:48 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::syncState stateService stop Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus stop Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: No code Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:48 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::syncState stateService stop Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus stop Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: No code Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Age Of Consent","artist":"10cc","album":"Anthology","uri":"NAS/Music/10cc/[M] Anthology [149317596] [2017]/CD1/01 - 10cc - Age Of Consent.flac","trackType":"flac"} Apr 03 17:06:48 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::syncState stateService stop Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus stop Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: No code Apr 03 17:06:48 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:48 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:48 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:48 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:48 volumio volumio[69399]: info: ------------------------------ 276ms Apr 03 17:06:48 volumio volumio[69399]: info: ------------------------------ 270ms Apr 03 17:06:48 volumio volumio[69399]: info: ------------------------------ 259ms Apr 03 17:06:48 volumio volumio[69399]: info: ------------------------------ 254ms Apr 03 17:06:48 volumio volumio[69399]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 03 17:06:48 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 19/30)... Apr 03 17:06:49 volumio volumio[69399]: info: Updating MyVolumio device info Apr 03 17:06:49 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:49 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:49 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:49 volumio volumio[69399]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 03 17:06:49 volumio systemd[1]: volumio-kiosk.service: Scheduled restart job, restart counter is at 777. Apr 03 17:06:49 volumio systemd[1]: Stopped volumio-kiosk.service - Start Volumio Kiosk. Apr 03 17:06:49 volumio systemd[1]: volumio-kiosk.service: Consumed 1.369s CPU time. Apr 03 17:06:49 volumio systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk. Apr 03 17:06:49 volumio startx[69994]: X.Org X Server 1.21.1.7 Apr 03 17:06:49 volumio startx[69994]: X Protocol Version 11, Revision 0 Apr 03 17:06:49 volumio startx[69994]: Current Operating System: Linux volumio 6.12.57-volumio #2 SMP PREEMPT_DYNAMIC Thu Nov 13 17:08:37 CET 2025 x86_64 Apr 03 17:06:49 volumio startx[69994]: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=cf910561-1d44-4877-9f78-123e8c799de7 bootpart=UUID=9EE8-B65A datapart=UUID=afe8532e-510d-4a5f-ae48-965db99841c8 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=native net.ifnames=0 use_kmsg=no initrd=volumio.initrd Apr 03 17:06:49 volumio startx[69994]: xorg-server 2:21.1.7-3+deb12u11 (https://www.debian.org/support) Apr 03 17:06:49 volumio startx[69994]: Current version of pixman: 0.42.2 Apr 03 17:06:49 volumio startx[69994]: Before reporting problems, check http://wiki.x.org Apr 03 17:06:49 volumio startx[69994]: to make sure that you have the latest version. Apr 03 17:06:49 volumio startx[69994]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 03 17:06:49 volumio startx[69994]: (++) from command line, (!!) notice, (II) informational, Apr 03 17:06:49 volumio startx[69994]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 03 17:06:49 volumio startx[69994]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Apr 3 17:06:49 2026 Apr 03 17:06:49 volumio startx[69994]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 03 17:06:50 volumio startx[69994]: (EE) Apr 03 17:06:50 volumio startx[69994]: Fatal server error: Apr 03 17:06:50 volumio startx[69994]: (EE) AddScreen/ScreenInit failed for driver 0 Apr 03 17:06:50 volumio startx[69994]: (EE) Apr 03 17:06:50 volumio startx[69994]: (EE) Apr 03 17:06:50 volumio startx[69994]: Please consult the The X.Org Foundation support Apr 03 17:06:50 volumio startx[69994]: at http://wiki.x.org Apr 03 17:06:50 volumio startx[69994]: for help. Apr 03 17:06:50 volumio startx[69994]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information. Apr 03 17:06:50 volumio startx[69994]: (EE) Apr 03 17:06:50 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 20/30)... Apr 03 17:06:50 volumio startx[69994]: (EE) Server terminated with error (1). Closing log file. Apr 03 17:06:51 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 21/30)... Apr 03 17:06:52 volumio volumio[69399]: info: MYVOLUMIO: Adding device Apr 03 17:06:52 volumio volumio[69399]: info: MYVOLUMIO: Evaluating Server Apr 03 17:06:52 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 22/30)... Apr 03 17:06:53 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:53 volumio volumio[69399]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 03 17:06:53 volumio volumio[69399]: info: CoreStateMachine::ClearQueue Apr 03 17:06:53 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:53 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:53 volumio volumio[69399]: info: CorePlayQueue::clearPlayQueue Apr 03 17:06:53 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:53 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:53 volumio volumio[69399]: info: CoreStateMachine::addQueueItems Apr 03 17:06:53 volumio volumio[69399]: info: CorePlayQueue::addQueueItems Apr 03 17:06:53 volumio volumio[69399]: info: Preload queue cleared Apr 03 17:06:53 volumio volumio[69399]: info: Adding Item to queue: music-library/NAS/Music/60 Hits - 60 Jahre Deutschland Apr 03 17:06:53 volumio volumio[69399]: info: Exploding uri music-library/NAS/Music/60 Hits - 60 Jahre Deutschland in service mpd Apr 03 17:06:53 volumio volumio[69399]: info: Setting Geolocation for MyVolumio to eu7 Apr 03 17:06:53 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:53 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:53 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Manuela/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F01%20-%20Manuela%20-%20Schuld%20war%20nur%20der%20Bossa%20Nova.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Katja%20Ebstein/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F02%20-%20Katja%20Ebstein%20-%20Wunder%20gibt%20es%20immer%20wieder.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/02 - Katja Ebstein - Wunder gibt es immer wieder.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Juliane%20Werding/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F03%20-%20Juliane%20Werding%20-%20Am%20Tag%2C%20als%20Conny%20Kramer%20starb.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/03 - Juliane Werding - Am Tag, als Conny Kramer starb.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Michael%20Holm/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F04%20-%20Michael%20Holm%20-%20Tr%C3%A4nen%20l%C3%BCgen%20nicht.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/04 - Michael Holm - Tränen lügen nicht.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Marianne%20Rosenberg/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F05%20-%20Marianne%20Rosenberg%20-%20Lieder%20der%20Nacht.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/05 - Marianne Rosenberg - Lieder der Nacht.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Boney%20M./60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F06%20-%20Boney%20M-%20-%20Daddy%20Cool.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/06 - Boney M- - Daddy Cool.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Costa%20Cordalis/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F07%20-%20Costa%20Cordalis%20-%20Anita.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/07 - Costa Cordalis - Anita.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Puhdys/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F08%20-%20Puhdys%20-%20Alt%20wie%20ein%20Baum.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/08 - Puhdys - Alt wie ein Baum.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=City/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F09%20-%20City%20-%20Am%20Fenster.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/09 - City - Am Fenster.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Boney%20M./60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F10%20-%20Boney%20M-%20-%20Ma%20Baker%20(Radio%20Edit).flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/10 - Boney M- - Ma Baker (Radio Edit).flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Dschinghis%20Khan/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F11%20-%20Dschinghis%20Khan%20-%20Moskau.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/11 - Dschinghis Khan - Moskau.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Karat/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F12%20-%20Karat%20-%20%C3%9Cber%20sieben%20Br%C3%BCcken%20musst%20du%20geh'n.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/12 - Karat - Über sieben Brücken musst du geh'n.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Bernie%20Paul/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F13%20-%20Bernie%20Paul%20-%20Oh%20No%20No.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/13 - Bernie Paul - Oh No No.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Andreas%20Martin/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F14%20-%20Andreas%20Martin%20-%20Amore%20mio.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/14 - Andreas Martin - Amore mio.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Falco/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F15%20-%20Falco%20-%20Der%20Kommissar.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/15 - Falco - Der Kommissar.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Markus/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F16%20-%20Markus%20-%20Ich%20will%20Spass.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/16 - Markus - Ich will Spass.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Nicole/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F17%20-%20Nicole%20-%20Ein%20bisschen%20Frieden.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/17 - Nicole - Ein bisschen Frieden.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Spliff/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F18%20-%20Spliff%20-%20Carbonara.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/18 - Spliff - Carbonara.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Karat/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F19%20-%20Karat%20-%20Jede%20Stunde.flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/19 - Karat - Jede Stunde.flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=D%C3%B6f/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD1%2F20%20-%20D%C3%B6f%20-%20Codo%20(...d%C3%BCse%20im%20Sauseschritt).flac&metadata=false Apr 03 17:06:53 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/20 - Döf - Codo (...düse im Sauseschritt).flac Apr 03 17:06:53 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Geier%20Sturzflug/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F01%20-%20Geier%20Sturzflug%20-%20Bruttosozialprodukt.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/01 - Geier Sturzflug - Bruttosozialprodukt.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Roland%20Kaiser/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F03%20-%20Roland%20Kaiser%20-%20Joana.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/03 - Roland Kaiser - Joana.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Blue%20System/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F05%20-%20Blue%20System%20-%20Sorry%20Little%20Sarah.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/05 - Blue System - Sorry Little Sarah.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Modern%20Talking/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F06%20-%20Modern%20Talking%20-%20Jet%20Airliner.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/06 - Modern Talking - Jet Airliner.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Milli%20Vanilli/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F07%20-%20Milli%20Vanilli%20-%20Girl%20You%20Know%20It's%20True.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/07 - Milli Vanilli - Girl You Know It's True.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Pankow/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F08%20-%20Pankow%20-%20Langeweile.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/08 - Pankow - Langeweile.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Keimzeit/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F09%20-%20Keimzeit%20-%20Irrenhaus.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/09 - Keimzeit - Irrenhaus.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Hape%20Kerkeling/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F10%20-%20Hape%20Kerkeling%20-%20Das%20ganze%20Leben%20ist%20ein%20Quiz.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/10 - Hape Kerkeling - Das ganze Leben ist ein Quiz.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Die%20Fantastischen%20Vier/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F11%20-%20Die%20Fantastischen%20Vier%20-%20Die%20Da!-!.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/11 - Die Fantastischen Vier - Die Da!-!.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Wolfgang%20Petry/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F12%20-%20Wolfgang%20Petry%20-%20Verlieben%2C%20verloren%2C%20vergessen%2C%20verzeih'n.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/12 - Wolfgang Petry - Verlieben, verloren, vergessen, verzeih'n.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Selig/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F13%20-%20Selig%20-%20Ohne%20dich.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/13 - Selig - Ohne dich.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Silly/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F14%20-%20Silly%20-%20Halloween%20in%20Ostberlin.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/14 - Silly - Halloween in Ostberlin.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Die%20Doofen/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F15%20-%20Die%20Doofen%20-%20MIEF!%20(Nimm%20mich%20jetzt%2C%20auch%20wenn%20ich%20stinke)%20(Vid.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/15 - Die Doofen - MIEF! (Nimm mich jetzt, auch wenn ich stinke) (Vid.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Creme%2021/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F16%20-%20Creme%2021%20-%20Wann%20wird's%20mal%20wieder%20richtig%20Sommer.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/16 - Creme 21 - Wann wird's mal wieder richtig Sommer.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Rockhaus/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F17%20-%20Rockhaus%20-%20Bonbons%20und%20Schokolade.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/17 - Rockhaus - Bonbons und Schokolade.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Freundeskreis/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F19%20-%20Freundeskreis%20-%20A-N-N-A%20(Radio%20Version%2096).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/19 - Freundeskreis - A-N-N-A (Radio Version 96).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Guano%20Apes/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD2%2F20%20-%20Guano%20Apes%20-%20Open%20Your%20Eyes.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD2/20 - Guano Apes - Open Your Eyes.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Blumentopf/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F01%20-%20Blumentopf%20-%206%20Meter%2090%20(Single%20Mix).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/01 - Blumentopf - 6 Meter 90 (Single Mix).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Joachim%20Witt/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F02%20-%20Joachim%20Witt%2C%20Heppner%20-%20Die%20Flut%20(Radio%20Edit).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/02 - Joachim Witt, Heppner - Die Flut (Radio Edit).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Afrob/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F03%20-%20Afrob%2C%20Ferris%20MC%20-%20Reimemonster%20(feat.%20Ferris%20MC)%20(Radio%20Version).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/03 - Afrob, Ferris MC - Reimemonster (feat. Ferris MC) (Radio Version).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Oli.P/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F04%20-%20Oli.P%20-%20So%20bist%20Du%20(Missing%20Shots%20TMTQ%20Cut).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/04 - Oli.P - So bist Du (Missing Shots TMTQ Cut).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Christian/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F05%20-%20Christian%20-%20Es%20ist%20geil%20ein%20Arschloch%20zu%20sein%20(Radio%20Version).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/05 - Christian - Es ist geil ein Arschloch zu sein (Radio Version).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Zlatko/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F06%20-%20Zlatko%20-%20Ich%20vermiss'%20Dich...%20(wie%20die%20H%C3%B6lle)%20(Radio%20Mix).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/06 - Zlatko - Ich vermiss' Dich... (wie die Hölle) (Radio Mix).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Zlatko/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F07%20-%20Zlatko%2C%20J%C3%BCrgen%20-%20Gro%C3%9Fer%20Bruder%20(Single%20Mix).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/07 - Zlatko, Jürgen - Großer Bruder (Single Mix).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Die%20Prinzen/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F08%20-%20Die%20Prinzen%20-%20Deutschland%20(Radio%20Mix).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/08 - Die Prinzen - Deutschland (Radio Mix).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Deutschland%20sucht%20den%20Superstar/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F10%20-%20Deutschland%20sucht%20den%20Superstar%20-%20We%20Have%20a%20Dream%20(Radio%20Edit).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/10 - Deutschland sucht den Superstar - We Have a Dream (Radio Edit).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Alexander%20Klaws/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F11%20-%20Alexander%20Klaws%20-%20Take%20Me%20Tonight%20(Radio%20Edit).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/11 - Alexander Klaws - Take Me Tonight (Radio Edit).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Laith%20Al-Deen/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F12%20-%20Laith%20Al-Deen%20-%20Leb%20den%20Tag%20(Radio%20Mix).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/12 - Laith Al-Deen - Leb den Tag (Radio Mix).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Revolverheld/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F13%20-%20Revolverheld%20-%20Roboter.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/13 - Revolverheld - Roboter.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Mia./60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F14%20-%20Mia-%20-%20Tanz%20der%20Molek%C3%BCle%20(Single%20Version).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/14 - Mia- - Tanz der Moleküle (Single Version).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Tobias%20Regner/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F15%20-%20Tobias%20Regner%20-%20I%20Still%20Burn%20(Radio%20Version).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/15 - Tobias Regner - I Still Burn (Radio Version).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Mark%20Medlock/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F16%20-%20Mark%20Medlock%20-%20Now%20or%20Never%20(Single%20Version).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/16 - Mark Medlock - Now or Never (Single Version).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Boney%20M./60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F17%20-%20Boney%20M.%2C%20Sherita%20O.%2C%20Yulee%20B-%20-%20Felicidad%20America%20(Obama%20-%20Obama)%20(feat.%20Sherita%20O.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/17 - Boney M., Sherita O., Yulee B- - Felicidad America (Obama - Obama) (feat. Sherita O.flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Mark%20Medlock/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F18%20-%20Mark%20Medlock%20-%20Summer%20Love%20(Radio%20Version).flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/18 - Mark Medlock - Summer Love (Radio Version).flac Apr 03 17:06:54 volumio volumio[69399]: info: ALBUMART /albumart?cacheid=816&web=Thomas%20Godoj/60%20Hits%20-%2060%20Jahre%20Deutschland/extralarge&path=%2Fmnt%2FNAS%2FMusic%2F60%20Hits%20-%2060%20Jahre%20Deutschland%2FCD3%2F19%20-%20Thomas%20Godoj%20-%20Autopilot.flac&metadata=false Apr 03 17:06:54 volumio volumio[69399]: info: URI /mnt/NAS/Music/60 Hits - 60 Jahre Deutschland/CD3/19 - Thomas Godoj - Autopilot.flac Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::updateTrackBlock Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrackBlock Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPlay Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::play index 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::play index undefined Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::startPlaybackTimer Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand stop took 22 milliseconds Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 17:06:54 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 23/30)... Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:54 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand clear took 16 milliseconds Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac" Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:54 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:54 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:54 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:54 volumio volumio[69399]: error: updateQueue error: null Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:54 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 18ms Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand add "NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac" took 14 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 12ms Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 9ms Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 8ms Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand play Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:54 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:54 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces system playlist update Apr 03 17:06:54 volumio volumio[69399]: info: Ignoring MPD Status Update Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 13ms Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand play took 10 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 8ms Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 6ms Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 6ms Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:54 volumio volumio[69399]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand status took 58 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand status took 40 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand status took 25 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand status took 19 milliseconds Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:54 volumio volumio[69399]: info: Apr 03 17:06:54 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand status took 51 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 41 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 39 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 38 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 36 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand status took 30 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand status took 19 milliseconds Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:06:54 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus stop Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:06:54 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:54 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:54 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:54 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:06:54 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:54 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:54 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:54 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:06:54 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:54 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:54 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:54 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 207ms Apr 03 17:06:54 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1164. Apr 03 17:06:54 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 17:06:54 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 341ms Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 325ms Apr 03 17:06:54 volumio volumio[69399]: info: ------------------------------ 323ms Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand status took 279 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 272 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 268 milliseconds Apr 03 17:06:54 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 268 milliseconds Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:54 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:06:54 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:54 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:54 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:54 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:54 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":136,"duration":145,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"197 Kbps","isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:06:54 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:54 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:54 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:54 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:54 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:54 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:55 volumio upmpdcli[70040]: Could not open config: /tmp/upmpdcli.conf Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:55 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 17:06:55 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 17:06:55 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:55 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:55 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:55 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":844,"duration":145,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"850 Kbps","isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:06:55 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:55 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:55 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:55 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:55 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:55 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:55 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:55 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:55 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:55 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:55 volumio volumio[69399]: info: ------------------------------ 789ms Apr 03 17:06:55 volumio volumio[69399]: info: ------------------------------ 764ms Apr 03 17:06:55 volumio volumio[69399]: info: ------------------------------ 764ms Apr 03 17:06:55 volumio volumio[69399]: info: Updating MyVolumio device info Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:06:55 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 543 milliseconds Apr 03 17:06:55 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:06:55 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:06:55 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:55 volumio volumio[69399]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1209,"duration":145,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"917 Kbps","isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:06:55 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:06:55 volumio volumio[69399]: info: CoreStateMachine::syncState stateService play Apr 03 17:06:55 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus play Apr 03 17:06:55 volumio volumio[69399]: info: Received an update from plugin. extracting info from payload Apr 03 17:06:55 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:55 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:55 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:55 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:06:55 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:55 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:06:55 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:06:55 volumio volumio[69399]: info: ------------------------------ 908ms Apr 03 17:06:55 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 24/30)... Apr 03 17:06:55 volumio volumio[69399]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 03 17:06:56 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 03 17:06:56 volumio volumio[69399]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Apr 03 17:06:56 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:06:56 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:06:56 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 25/30)... Apr 03 17:06:57 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 26/30)... Apr 03 17:06:58 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 27/30)... Apr 03 17:06:59 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 28/30)... Apr 03 17:07:00 volumio volumio[69399]: info: Display-configuration --- Waiting for X server (attempt 29/30)... Apr 03 17:07:01 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:07:01 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:07:01 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 03 17:07:01 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 03 17:07:01 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 03 17:07:01 volumio volumio[69399]: info: CoreCommandRouter::volumioGetBrowseSources Apr 03 17:07:01 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 17:07:01 volumio volumio[69399]: warn: Display-configuration --- X server not ready after 30 attempts, proceeding anyway Apr 03 17:07:02 volumio volumio[69399]: info: Display-configuration --- X server not accessible, restarting kiosk service... Apr 03 17:07:02 volumio sudo[70080]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-kiosk.service Apr 03 17:07:02 volumio sudo[70080]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:07:02 volumio startx[69993]: xinit: giving up Apr 03 17:07:02 volumio startx[69993]: xinit: unable to connect to X server: Cannot assign requested address Apr 03 17:07:02 volumio startx[69993]: xinit: unexpected signal 15 Apr 03 17:07:02 volumio systemd[1]: Stopping volumio-kiosk.service - Start Volumio Kiosk... Apr 03 17:07:02 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Apr 03 17:07:02 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Apr 03 17:07:02 volumio systemd[1]: Stopped volumio-kiosk.service - Start Volumio Kiosk. Apr 03 17:07:02 volumio systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk. Apr 03 17:07:02 volumio sudo[70080]: pam_unix(sudo:session): session closed for user root Apr 03 17:07:02 volumio volumio[69399]: info: Display-configuration --- Kiosk service restarted, waiting for X server... Apr 03 17:07:02 volumio startx[70108]: X.Org X Server 1.21.1.7 Apr 03 17:07:02 volumio startx[70108]: X Protocol Version 11, Revision 0 Apr 03 17:07:02 volumio startx[70108]: Current Operating System: Linux volumio 6.12.57-volumio #2 SMP PREEMPT_DYNAMIC Thu Nov 13 17:08:37 CET 2025 x86_64 Apr 03 17:07:02 volumio startx[70108]: Kernel command line: BOOT_IMAGE=vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=cf910561-1d44-4877-9f78-123e8c799de7 bootpart=UUID=9EE8-B65A datapart=UUID=afe8532e-510d-4a5f-ae48-965db99841c8 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=native net.ifnames=0 use_kmsg=no initrd=volumio.initrd Apr 03 17:07:02 volumio startx[70108]: xorg-server 2:21.1.7-3+deb12u11 (https://www.debian.org/support) Apr 03 17:07:02 volumio startx[70108]: Current version of pixman: 0.42.2 Apr 03 17:07:02 volumio startx[70108]: Before reporting problems, check http://wiki.x.org Apr 03 17:07:02 volumio startx[70108]: to make sure that you have the latest version. Apr 03 17:07:02 volumio startx[70108]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 03 17:07:02 volumio startx[70108]: (++) from command line, (!!) notice, (II) informational, Apr 03 17:07:02 volumio startx[70108]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 03 17:07:02 volumio startx[70108]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Apr 3 17:07:02 2026 Apr 03 17:07:02 volumio startx[70108]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 03 17:07:03 volumio volumio[69399]: error: MyVolumio Plugin failed to authenticate in a timely fashion Apr 03 17:07:03 volumio volumio[69399]: info: Completed starting MyVolumio Plugin Apr 03 17:07:03 volumio volumio[69399]: [Metrics] CommandRouter: 66s 391.90ms Apr 03 17:07:03 volumio volumio[69399]: info: CoreCommandRouter::volumiosetStartupVolume Apr 03 17:07:03 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 17:07:03 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 03 17:07:03 volumio volumio[69399]: info: CoreCommandRouter::Close All Modals sent Apr 03 17:07:03 volumio volumio[69399]: info: CoreCommandRouter::Close All Modals sent Apr 03 17:07:03 volumio volumio[69399]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Apr 03 17:07:03 volumio volumio[69399]: aplay: main:831: audio open error: Device or resource busy Apr 03 17:07:03 volumio startx[70108]: (EE) Apr 03 17:07:03 volumio startx[70108]: Fatal server error: Apr 03 17:07:03 volumio startx[70108]: (EE) AddScreen/ScreenInit failed for driver 0 Apr 03 17:07:03 volumio startx[70108]: (EE) Apr 03 17:07:03 volumio startx[70108]: (EE) Apr 03 17:07:03 volumio startx[70108]: Please consult the The X.Org Foundation support Apr 03 17:07:03 volumio startx[70108]: at http://wiki.x.org Apr 03 17:07:03 volumio startx[70108]: for help. Apr 03 17:07:03 volumio startx[70108]: (EE) Please also check the log file at "/var/log/Xorg.0.log" for additional information. Apr 03 17:07:03 volumio startx[70108]: (EE) Apr 03 17:07:03 volumio startx[70108]: (EE) Server terminated with error (1). Closing log file. Apr 03 17:07:04 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 03 17:07:04 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 03 17:07:04 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 03 17:07:04 volumio sudo[70118]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/bash -c 'if [ -f /root/.Xauthority ]; then cp /root/.Xauthority /home/volumio/ && chown volumio:volumio /home/volumio/.Xauthority; fi' Apr 03 17:07:04 volumio sudo[70118]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 17:07:04 volumio sudo[70118]: pam_unix(sudo:session): session closed for user root Apr 03 17:07:04 volumio volumio[69399]: info: Display-configuration --- fixXauthority: /home/volumio/.Xauthority updated Apr 03 17:07:06 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:07:06 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:09 volumio volumio[69399]: info: CoreCommandRouter::volumioClearQueue Apr 03 17:07:09 volumio volumio[69399]: info: CoreStateMachine::ClearQueue Apr 03 17:07:09 volumio volumio[69399]: info: CoreStateMachine::stop Apr 03 17:07:09 volumio volumio[69399]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 17:07:09 volumio volumio[69399]: info: CoreStateMachine::stPlaybackTimer Apr 03 17:07:09 volumio volumio[69399]: info: CoreStateMachine::updateTrackBlock Apr 03 17:07:09 volumio volumio[69399]: info: CorePlayQueue::getTrackBlock Apr 03 17:07:09 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:09 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:09 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:07:09 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:09 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:09 volumio volumio[69399]: info: CoreStateMachine::serviceStop Apr 03 17:07:09 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:09 volumio volumio[69399]: info: CoreCommandRouter::serviceStop Apr 03 17:07:09 volumio volumio[69399]: info: ControllerMpd::stop Apr 03 17:07:09 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 17:07:09 volumio volumio[69399]: info: CorePlayQueue::clearPlayQueue Apr 03 17:07:09 volumio volumio[69399]: info: CorePlayQueue::saveQueue Apr 03 17:07:09 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:09 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:09 volumio volumio[69399]: info: CoreCommandRouter::volumioPushQueue Apr 03 17:07:10 volumio volumio[69399]: info: Apr 03 17:07:10 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:07:10 volumio volumio[69399]: info: sendMpdCommand stop took 139 milliseconds Apr 03 17:07:10 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:07:10 volumio volumio[69399]: info: Apr 03 17:07:10 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:07:10 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:07:10 volumio volumio[69399]: info: Apr 03 17:07:10 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:07:10 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:07:10 volumio volumio[69399]: info: Apr 03 17:07:10 volumio volumio[69399]: ---------------------------- MPD announces state update: player Apr 03 17:07:10 volumio volumio[69399]: info: ControllerMpd::getState Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand status Apr 03 17:07:10 volumio volumio[69399]: info: sendMpdCommand status took 18 milliseconds Apr 03 17:07:10 volumio volumio[69399]: info: sendMpdCommand status took 15 milliseconds Apr 03 17:07:10 volumio volumio[69399]: info: sendMpdCommand status took 13 milliseconds Apr 03 17:07:10 volumio volumio[69399]: info: sendMpdCommand status took 10 milliseconds Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::parseState Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 17:07:10 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 03 17:07:10 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 03 17:07:10 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 03 17:07:10 volumio volumio[69399]: info: sendMpdCommand playlistinfo took 25 milliseconds Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:07:10 volumio volumio[69399]: verbose: ControllerMpd::parseTrackInfo Apr 03 17:07:10 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:07:10 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::syncState stateService stop Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus stop Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: No code Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:07:10 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::syncState stateService stop Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus stop Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: No code Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:07:10 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::syncState stateService stop Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus stop Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: No code Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: ControllerMpd::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::servicePushState Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Schuld war nur der Bossa Nova","artist":"Manuela","album":"60 Hits - 60 Jahre Deutschland","uri":"NAS/Music/60 Hits - 60 Jahre Deutschland/CD1/01 - Manuela - Schuld war nur der Bossa Nova.flac","trackType":"flac"} Apr 03 17:07:10 volumio volumio[69399]: verbose: CURRENT POSITION 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::syncState stateService stop Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::syncState currentStatus stop Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio volumio[69399]: info: No code Apr 03 17:07:10 volumio volumio[69399]: info: CoreStateMachine::pushState Apr 03 17:07:10 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:10 volumio volumio[69399]: info: CoreCommandRouter::volumioPushState Apr 03 17:07:10 volumio volumio[69399]: info: Stylish Player: pushState → fmt=s16le rate=44100 isDSD=false Apr 03 17:07:10 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1165. Apr 03 17:07:10 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 17:07:10 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 03 17:07:10 volumio upmpdcli[70140]: Could not open config: /tmp/upmpdcli.conf Apr 03 17:07:10 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Apr 03 17:07:10 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Apr 03 17:07:10 volumio volumio[69399]: info: ------------------------------ 481ms Apr 03 17:07:10 volumio volumio[69399]: info: ------------------------------ 477ms Apr 03 17:07:10 volumio volumio[69399]: info: ------------------------------ 475ms Apr 03 17:07:10 volumio volumio[69399]: info: ------------------------------ 474ms Apr 03 17:07:10 volumio volumio[69399]: info: BOOT COMPLETED Apr 03 17:07:13 volumio volumio[69399]: info: CoreCommandRouter::volumioGetState Apr 03 17:07:13 volumio volumio[69399]: info: CorePlayQueue::getTrack 0 Apr 03 17:07:17 volumio startx[70107]: xinit: giving up Apr 03 17:07:17 volumio startx[70107]: xinit: unable to connect to X server: Cannot assign requested address Apr 03 17:07:17 volumio startx[70107]: xinit: server error Apr 03 17:07:17 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Apr 03 17:07:17 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Apr 03 17:07:17 volumio volumio[69399]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 17:07:17 volumio volumio[69399]: URIError: URI malformed Apr 03 17:07:17 volumio volumio[69399]: at decodeURIComponent () Apr 03 17:07:17 volumio volumio[69399]: at /data/plugins/music_service/squeezelite_mc/node_modules/lms-cli-notifications/dist/cjs/NotificationListener.js:188:39 Apr 03 17:07:17 volumio volumio[69399]: at Array.map () Apr 03 17:07:17 volumio volumio[69399]: at NotificationListener._NotificationListener_deduceNotification (/data/plugins/music_service/squeezelite_mc/node_modules/lms-cli-notifications/dist/cjs/NotificationListener.js:188:28) Apr 03 17:07:17 volumio volumio[69399]: at NotificationListener._NotificationListener_handleIncomingData (/data/plugins/music_service/squeezelite_mc/node_modules/lms-cli-notifications/dist/cjs/NotificationListener.js:202:130) Apr 03 17:07:17 volumio volumio[69399]: at Telnet.emit (node:events:526:35) Apr 03 17:07:17 volumio volumio[69399]: at Socket. (/data/plugins/music_service/squeezelite_mc/node_modules/telnet-client/lib/index.js:145:26) Apr 03 17:07:17 volumio volumio[69399]: at Socket.emit (node:events:514:28) Apr 03 17:07:17 volumio volumio[69399]: at addChunk (node:internal/streams/readable:343:12) Apr 03 17:07:17 volumio volumio[69399]: at readableAddChunk (node:internal/streams/readable:316:9) Apr 03 17:07:17 volumio volumio[69399]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 17:07:18 volumio sudo[70194]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-03 17:06' Apr 03 17:07:18 volumio sudo[70194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"