-- Logs begin at Thu 2025-04-24 08:18:43 UTC, end at Thu 2025-04-24 09:55:38 UTC. --
Apr 24 09:54:00 volumiowerk volumio[3122]: info: MYVOLUMIO Environment detected
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Plugin folders cleanup
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning into folder /volumio/app/plugins/
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning category audio_interface
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning category miscellanea
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning category music_service
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning category plugins.json
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning category system_controller
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning category user_interface
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning into folder /data/plugins/
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning category miscellanea
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning category music_service
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Scanning category system_controller
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Plugin folders cleanup completed
Apr 24 09:54:00 volumiowerk volumio[3122]: info: -------------------------------------------
Apr 24 09:54:00 volumiowerk volumio[3122]: info: ----- Core plugins startup ----
Apr 24 09:54:00 volumiowerk volumio[3122]: info: -------------------------------------------
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Loading plugins from folder /volumio/app/plugins/
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Adding plugin upnp to MyMusic Plugins
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Loading plugins from folder /data/plugins/
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Loading plugin "system"...
Apr 24 09:54:00 volumiowerk volumio[3122]: info: Loading plugin "appearance"...
Apr 24 09:54:02 volumiowerk volumio[3122]: info: Loading plugin "network"...
Apr 24 09:54:02 volumiowerk volumio[3122]: info: Refreshing Cached IP Addresses
Apr 24 09:54:02 volumiowerk sudo[3144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 24 09:54:02 volumiowerk volumio[3122]: info: Loading plugin "touch_display"...
Apr 24 09:54:02 volumiowerk sudo[3144]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:02 volumiowerk sudo[3144]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:02 volumiowerk sudo[3148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 24 09:54:02 volumiowerk sudo[3148]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:02 volumiowerk sudo[3148]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:02 volumiowerk volumio-remote-updater[619]: [2025-04-24 09:54:02] [connect] Successful connection
Apr 24 09:54:02 volumiowerk volumio[3122]: info: Applying required configuration parameters for plugin touch_display
Apr 24 09:54:02 volumiowerk volumio[3122]: info: Loading plugin "services"...
Apr 24 09:54:02 volumiowerk volumio[3122]: info: Loading plugin "alsa_controller"...
Apr 24 09:54:02 volumiowerk volumio[3122]: info: Loading plugin "wizard"...
Apr 24 09:54:02 volumiowerk volumio[3122]: info: Loading plugin "volumio_command_line_client"...
Apr 24 09:54:03 volumiowerk volumio[3122]: info: Loading plugin "upnp"...
Apr 24 09:54:03 volumiowerk volumio[3122]: info: [1745488443042] Starting Upmpd Daemon
Apr 24 09:54:03 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 24 09:54:03 volumiowerk volumio[3122]: info: Loading plugin "my_music"...
Apr 24 09:54:03 volumiowerk volumio[3122]: info: Loading plugin "mpd"...
Apr 24 09:54:03 volumiowerk volumio[3122]: info: Loading plugin "upnp_browser"...
Apr 24 09:54:03 volumiowerk volumio[3122]: info: Loading plugin "networkfs"...
Apr 24 09:54:03 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 24 09:54:03 volumiowerk volumio[3122]: info: Loading plugin "alarm-clock"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "airplay_emulation"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Starting Shairport Sync
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "last_100"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "webradio"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "i2s_dacs"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "volumiodiscovery"...
Apr 24 09:54:04 volumiowerk volumio[3122]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 24 09:54:04 volumiowerk node[3122]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 24 09:54:04 volumiowerk node[3122]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 09:54:04 volumiowerk node[3122]: *** WARNING *** For more information see
Apr 24 09:54:04 volumiowerk node[3122]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 24 09:54:04 volumiowerk node[3122]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 09:54:04 volumiowerk node[3122]: *** WARNING *** For more information see
Apr 24 09:54:04 volumiowerk volumio[3122]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 09:54:04 volumiowerk volumio[3122]: *** WARNING *** For more information see
Apr 24 09:54:04 volumiowerk volumio[3122]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 24 09:54:04 volumiowerk volumio[3122]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 09:54:04 volumiowerk volumio[3122]: *** WARNING *** For more information see
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 24 09:54:04 volumiowerk volumio[3122]: Discovery: StartAdv! undefined
Apr 24 09:54:04 volumiowerk volumio[3122]: Discovery: Started advertising... Volumiowerk - undefined
Apr 24 09:54:04 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "auto_play"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "outputs"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "albumart"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Plugin example_plugin is not enabled
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "inputs"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "updater_comm"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Plugin mpdemulation is not enabled
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "rest_api"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "websocket"...
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "radio_paradise"...
Apr 24 09:54:04 volumiowerk volumio[3122]: Forking 3 albumart workers
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Applying required configuration parameters for plugin radio_paradise
Apr 24 09:54:04 volumiowerk volumio[3122]: info: [1745488444945] [RadioParadise] API delay: 5
Apr 24 09:54:04 volumiowerk volumio[3122]: info: Loading plugin "backup_restore"...
Apr 24 09:54:05 volumiowerk volumio[3122]: info: ___________ START PLUGINS ___________
Apr 24 09:54:05 volumiowerk volumio[3122]: info: Loading i18n strings for locale nl
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 09:54:05 volumiowerk volumio[3122]: info: [1745488445378] CoreMusicLibrary::Adding element Media Servers
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 09:54:05 volumiowerk sudo[3196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Apr 24 09:54:05 volumiowerk sudo[3196]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:05 volumiowerk systemd[1]: Reloading.
Apr 24 09:54:05 volumiowerk volumio[3122]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 24 09:54:05 volumiowerk volumio[3122]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 09:54:05 volumiowerk volumio[3122]: info: [1745488445672] CoreMusicLibrary::Adding element Last_100
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 09:54:05 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service'
Apr 24 09:54:05 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service'
Apr 24 09:54:05 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service'
Apr 24 09:54:05 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service'
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 09:54:05 volumiowerk volumio[3122]: info: [1745488445705] CoreMusicLibrary::Adding element Webradio
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 24 09:54:05 volumiowerk volumio[3122]: Starting albumart workers
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 09:54:05 volumiowerk volumio[3122]: info: [1745488445730] CoreMusicLibrary::Adding element Radio Paradise
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 09:54:05 volumiowerk volumio[3122]: info: -------------------------------------------
Apr 24 09:54:05 volumiowerk volumio[3122]: info: ----- MyVolumio plugins startup ----
Apr 24 09:54:05 volumiowerk volumio[3122]: info: -------------------------------------------
Apr 24 09:54:05 volumiowerk volumio[3122]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 24 09:54:05 volumiowerk volumio[3122]: info: Loading i18n strings for locale nl
Apr 24 09:54:05 volumiowerk volumio[3122]: Starting albumart workers
Apr 24 09:54:05 volumiowerk volumio[3122]: Updating browse sources language
Apr 24 09:54:05 volumiowerk volumio[3122]: Cannot find translation for sourceMedia Servers
Apr 24 09:54:05 volumiowerk volumio[3122]: Cannot find translation for sourceRadio Paradise
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 09:54:05 volumiowerk sudo[3196]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::initPlayerControls
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Apr 24 09:54:05 volumiowerk volumio[3122]: Starting albumart workers
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 24 09:54:05 volumiowerk volumio[3122]: info: BOOT COMPLETED
Apr 24 09:54:05 volumiowerk volumio[3122]: [Metrics] CommandRouter: 6s 302.56ms
Apr 24 09:54:05 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 09:54:06 volumiowerk kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Apr 24 09:54:11 volumiowerk volumio[3122]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreCommandRouter::Close All Modals sent
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreCommandRouter::Close All Modals sent
Apr 24 09:54:11 volumiowerk volumio[3122]: Express server listening on port 3000
Apr 24 09:54:11 volumiowerk volumio[3122]: [Metrics] WebUI: 12s 95.97ms
Apr 24 09:54:11 volumiowerk volumio[3122]: Volumio Calling Home
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreStateMachine::resetVolumioState
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreStateMachine::getcurrentVolume
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioRetrievevolume
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:54:11 volumiowerk volumio[3122]: info: Volumio called home
Apr 24 09:54:11 volumiowerk volumio[3122]: info: Setting Device type: Raspberry PI
Apr 24 09:54:11 volumiowerk volumio[3122]: info: touch_display: systemctl daemon-reload succeeded.
Apr 24 09:54:11 volumiowerk volumio[3122]: info: MPD running with PID689
Apr 24 09:54:11 volumiowerk volumio[3122]: ,establishing connection
Apr 24 09:54:11 volumiowerk sudo[3261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Apr 24 09:54:11 volumiowerk volumio[3122]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:54:11 volumiowerk sudo[3261]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:11 volumiowerk systemd[1]: Started Volumio Kiosk.
Apr 24 09:54:11 volumiowerk sudo[3261]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:11 volumiowerk volumio[3122]: info: VolumeController:: Volume=54 Mute =false
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreStateMachine::pushState
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CorePlayQueue::getTrack 0
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioPushState
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreStateMachine::updateTrackBlock
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CorePlayQueue::getTrackBlock
Apr 24 09:54:11 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioRetrievevolume
Apr 24 09:54:12 volumiowerk volumio[3122]: info:
Apr 24 09:54:12 volumiowerk volumio[3122]: ---------------------------- Client requests Volume 55
Apr 24 09:54:12 volumiowerk volumio[3122]: info: VolumeController::SetAlsaVolume55
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreStateMachine::pushState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CorePlayQueue::getTrack 0
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioPushState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 09:54:12 volumiowerk volumio[3122]: info: touch_display: systemctl start volumio-kiosk.service succeeded.
Apr 24 09:54:12 volumiowerk volumio[3122]: info: touch_display: Volumio Kiosk started
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioGetState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CorePlayQueue::getTrack 0
Apr 24 09:54:12 volumiowerk volumio[3122]: info: Reloading queue from file
Apr 24 09:54:12 volumiowerk volumio[3122]: info: Setting volume on startup at 55
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreStateMachine::setRepeat null single undefined
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreStateMachine::pushState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CorePlayQueue::getTrack 0
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioPushState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreStateMachine::setRandom null
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreStateMachine::pushState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CorePlayQueue::getTrack 0
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioPushState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 09:54:12 volumiowerk volumio[3122]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Apr 24 09:54:12 volumiowerk volumio[3122]: info: VolumeController:: Volume=54 Mute =false
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreStateMachine::pushState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CorePlayQueue::getTrack 0
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioPushState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 24 09:54:12 volumiowerk volumio[3122]: info: Starting Shairport Sync
Apr 24 09:54:12 volumiowerk volumio[3122]: info: Starting Shairport Sync
Apr 24 09:54:12 volumiowerk sudo[3276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 24 09:54:12 volumiowerk sudo[3276]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:12 volumiowerk sudo[3280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 24 09:54:12 volumiowerk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 24 09:54:12 volumiowerk systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Apr 24 09:54:12 volumiowerk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 24 09:54:12 volumiowerk sudo[3276]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:12 volumiowerk sudo[3280]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:12 volumiowerk volumio[3122]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Apr 24 09:54:12 volumiowerk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 24 09:54:12 volumiowerk systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Apr 24 09:54:12 volumiowerk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 24 09:54:12 volumiowerk sudo[3280]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:12 volumiowerk sudo[3305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf
Apr 24 09:54:12 volumiowerk volumio[3122]: info: Shairport-Sync Started
Apr 24 09:54:12 volumiowerk sudo[3305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:12 volumiowerk volumio[3122]: Error adding Membership: Error: addMembership EINVAL
Apr 24 09:54:12 volumiowerk sudo[3305]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:12 volumiowerk volumio[3122]: info: Shairport-Sync Started
Apr 24 09:54:12 volumiowerk volumio[3122]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Apr 24 09:54:12 volumiowerk volumio[3122]: info: touch_display: Setting screensaver timeout to 120 seconds.
Apr 24 09:54:12 volumiowerk volumio[3122]: info: touch_display: Touchscreen transformation matrix removed.
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioGetState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CorePlayQueue::getTrack 0
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioGetState
Apr 24 09:54:12 volumiowerk volumio[3122]: info: CorePlayQueue::getTrack 0
Apr 24 09:54:13 volumiowerk sudo[3332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 24 09:54:13 volumiowerk sudo[3332]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:13 volumiowerk sudo[3337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 24 09:54:13 volumiowerk sudo[3332]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:13 volumiowerk sudo[3337]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:13 volumiowerk sudo[3346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 24 09:54:13 volumiowerk sudo[3337]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:13 volumiowerk sudo[3346]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:13 volumiowerk systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 24 09:54:13 volumiowerk sudo[3346]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:13 volumiowerk volumio[3122]: info: Upmpdcli Daemon Started
Apr 24 09:54:14 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioGetState
Apr 24 09:54:14 volumiowerk volumio[3122]: info: CorePlayQueue::getTrack 0
Apr 24 09:54:14 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 24 09:54:14 volumiowerk volumio[3122]: info: Listing playlists
Apr 24 09:54:15 volumiowerk volumio-remote-updater[619]: [2025-04-24 09:54:15] [connect] Successful connection
Apr 24 09:54:15 volumiowerk volumio-remote-updater[619]: [2025-04-24 09:54:15] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1745488455 101
Apr 24 09:54:16 volumiowerk volumio[3122]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:54:21 volumiowerk volumio[3122]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:54:25 volumiowerk smbd[3381]: [2025/04/24 09:54:25.010940, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:25 volumiowerk smbd[3381]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:26 volumiowerk smbd[3382]: [2025/04/24 09:54:26.019567, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:26 volumiowerk smbd[3382]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:26 volumiowerk smbd[3382]: [2025/04/24 09:54:26.032118, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:26 volumiowerk smbd[3382]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:26 volumiowerk smbd[3382]: [2025/04/24 09:54:26.032409, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:26 volumiowerk smbd[3382]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:26 volumiowerk smbd[3382]: [2025/04/24 09:54:26.032659, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:26 volumiowerk smbd[3382]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:26 volumiowerk smbd[3382]: [2025/04/24 09:54:26.041797, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:26 volumiowerk smbd[3382]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:26 volumiowerk smbd[3382]: [2025/04/24 09:54:26.059564, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:26 volumiowerk smbd[3382]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:26 volumiowerk smbd[3382]: [2025/04/24 09:54:26.079656, 0] ../auth/gensec/gensec.c:257(gensec_verify_dcerpc_auth_level)
Apr 24 09:54:26 volumiowerk smbd[3382]: Did not manage to negotiate mandetory feature SIGN for dcerpc auth_level 6
Apr 24 09:54:26 volumiowerk avahi-daemon[681]: Invalid response packet from host 10.6.1.151.
Apr 24 09:54:26 volumiowerk volumio[3122]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:54:27 volumiowerk avahi-daemon[681]: Invalid response packet from host 10.6.1.151.
Apr 24 09:54:31 volumiowerk volumio[3122]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:54:35 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 24 09:54:35 volumiowerk volumio[3122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 09:54:36 volumiowerk volumio[3122]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:54:40 volumiowerk smbd[3388]: [2025/04/24 09:54:40.277301, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:40 volumiowerk smbd[3388]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:40 volumiowerk smbd[3388]: [2025/04/24 09:54:40.280907, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:40 volumiowerk smbd[3388]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:40 volumiowerk smbd[3388]: [2025/04/24 09:54:40.281167, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:40 volumiowerk smbd[3388]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:40 volumiowerk smbd[3388]: [2025/04/24 09:54:40.281403, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:40 volumiowerk smbd[3388]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:40 volumiowerk smbd[3388]: [2025/04/24 09:54:40.287462, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:40 volumiowerk smbd[3388]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:40 volumiowerk smbd[3388]: [2025/04/24 09:54:40.292370, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Apr 24 09:54:40 volumiowerk smbd[3388]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Apr 24 09:54:40 volumiowerk volumio[3122]: Discovery: adding 0d0b458b-95fd-491e-b7c3-17e450230262
Apr 24 09:54:40 volumiowerk volumio[3122]: info: mDNS: Found device Volumiowerk
Apr 24 09:54:40 volumiowerk volumio[3122]: info: CoreCommandRouter::volumioGetState
Apr 24 09:54:40 volumiowerk volumio[3122]: info: CorePlayQueue::getTrack 0
Apr 24 09:54:41 volumiowerk volumio[3122]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:54:43 volumiowerk volumio[3122]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 24 09:54:43 volumiowerk volumio[3122]: { Error: connect ETIMEDOUT 127.0.0.1:6600
Apr 24 09:54:43 volumiowerk volumio[3122]: at Object._errnoException (util.js:1022:11)
Apr 24 09:54:43 volumiowerk volumio[3122]: at _exceptionWithHostPort (util.js:1044:20)
Apr 24 09:54:43 volumiowerk volumio[3122]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Apr 24 09:54:43 volumiowerk volumio[3122]: code: 'ETIMEDOUT',
Apr 24 09:54:43 volumiowerk volumio[3122]: errno: 'ETIMEDOUT',
Apr 24 09:54:43 volumiowerk volumio[3122]: syscall: 'connect',
Apr 24 09:54:43 volumiowerk volumio[3122]: address: '127.0.0.1',
Apr 24 09:54:43 volumiowerk volumio[3122]: port: 6600 }
Apr 24 09:54:43 volumiowerk volumio[3122]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 24 09:54:44 volumiowerk sudo[3397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-24 09:53
Apr 24 09:54:44 volumiowerk sudo[3397]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:54:44 volumiowerk sudo[3397]: pam_unix(sudo:session): session closed for user root
Apr 24 09:54:55 volumiowerk volumio-remote-updater[619]: [2025-04-24 09:54:55] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Apr 24 09:54:55 volumiowerk volumio-remote-updater[619]: [2025-04-24 09:54:55] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Apr 24 09:54:55 volumiowerk systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Apr 24 09:54:55 volumiowerk systemd[1]: Unit volumio.service entered failed state.
Apr 24 09:54:55 volumiowerk systemd[1]: Starting dynamicswap service...
Apr 24 09:54:55 volumiowerk systemd[1]: Started dynamicswap service.
Apr 24 09:54:56 volumiowerk systemd[1]: volumio.service holdoff time over, scheduling restart.
Apr 24 09:54:56 volumiowerk systemd[1]: Starting dynamicswap service...
Apr 24 09:54:56 volumiowerk systemd[1]: Started dynamicswap service.
Apr 24 09:54:56 volumiowerk systemd[1]: Stopping Volumio Backend Module...
Apr 24 09:54:56 volumiowerk systemd[1]: Starting Volumio Backend Module...
Apr 24 09:54:56 volumiowerk systemd[1]: Started Volumio Backend Module.
Apr 24 09:54:57 volumiowerk volumio[3422]: info: -------------------------------------------
Apr 24 09:54:57 volumiowerk volumio[3422]: info: ----- Volumio2 ----
Apr 24 09:54:57 volumiowerk volumio[3422]: info: -------------------------------------------
Apr 24 09:54:57 volumiowerk volumio[3422]: info: ----- System startup ----
Apr 24 09:54:57 volumiowerk volumio[3422]: info: -------------------------------------------
Apr 24 09:54:58 volumiowerk volumio[3422]: info: MYVOLUMIO Environment detected
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Plugin folders cleanup
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning into folder /volumio/app/plugins/
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning category audio_interface
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning category miscellanea
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning category music_service
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning category plugins.json
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning category system_controller
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning category user_interface
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning into folder /data/plugins/
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning category miscellanea
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning category music_service
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Scanning category system_controller
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Plugin folders cleanup completed
Apr 24 09:54:58 volumiowerk volumio[3422]: info: -------------------------------------------
Apr 24 09:54:58 volumiowerk volumio[3422]: info: ----- Core plugins startup ----
Apr 24 09:54:58 volumiowerk volumio[3422]: info: -------------------------------------------
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Loading plugins from folder /volumio/app/plugins/
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Adding plugin upnp to MyMusic Plugins
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Loading plugins from folder /data/plugins/
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Loading plugin "system"...
Apr 24 09:54:58 volumiowerk volumio[3422]: info: Loading plugin "appearance"...
Apr 24 09:55:00 volumiowerk volumio[3422]: info: Loading plugin "network"...
Apr 24 09:55:00 volumiowerk volumio[3422]: info: Refreshing Cached IP Addresses
Apr 24 09:55:00 volumiowerk sudo[3447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 24 09:55:00 volumiowerk volumio[3422]: info: Loading plugin "touch_display"...
Apr 24 09:55:00 volumiowerk sudo[3447]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:55:00 volumiowerk sudo[3447]: pam_unix(sudo:session): session closed for user root
Apr 24 09:55:00 volumiowerk sudo[3451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 24 09:55:00 volumiowerk sudo[3451]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:55:00 volumiowerk sudo[3451]: pam_unix(sudo:session): session closed for user root
Apr 24 09:55:00 volumiowerk volumio-remote-updater[619]: [2025-04-24 09:55:00] [connect] Successful connection
Apr 24 09:55:00 volumiowerk volumio[3422]: info: Applying required configuration parameters for plugin touch_display
Apr 24 09:55:00 volumiowerk volumio[3422]: info: Loading plugin "services"...
Apr 24 09:55:00 volumiowerk volumio[3422]: info: Loading plugin "alsa_controller"...
Apr 24 09:55:00 volumiowerk volumio[3422]: info: Loading plugin "wizard"...
Apr 24 09:55:00 volumiowerk volumio[3422]: info: Loading plugin "volumio_command_line_client"...
Apr 24 09:55:01 volumiowerk volumio[3422]: info: Loading plugin "upnp"...
Apr 24 09:55:01 volumiowerk volumio[3422]: info: [1745488501044] Starting Upmpd Daemon
Apr 24 09:55:01 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 24 09:55:01 volumiowerk volumio[3422]: info: Loading plugin "my_music"...
Apr 24 09:55:01 volumiowerk volumio[3422]: info: Loading plugin "mpd"...
Apr 24 09:55:01 volumiowerk volumio[3422]: info: Loading plugin "upnp_browser"...
Apr 24 09:55:01 volumiowerk volumio[3422]: info: Loading plugin "networkfs"...
Apr 24 09:55:01 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 24 09:55:01 volumiowerk volumio[3422]: info: Loading plugin "alarm-clock"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "airplay_emulation"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Starting Shairport Sync
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "last_100"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "webradio"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "i2s_dacs"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "volumiodiscovery"...
Apr 24 09:55:02 volumiowerk volumio[3422]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 24 09:55:02 volumiowerk node[3422]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 24 09:55:02 volumiowerk node[3422]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 09:55:02 volumiowerk node[3422]: *** WARNING *** For more information see
Apr 24 09:55:02 volumiowerk node[3422]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 24 09:55:02 volumiowerk node[3422]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 09:55:02 volumiowerk node[3422]: *** WARNING *** For more information see
Apr 24 09:55:02 volumiowerk volumio[3422]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 09:55:02 volumiowerk volumio[3422]: *** WARNING *** For more information see
Apr 24 09:55:02 volumiowerk volumio[3422]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 24 09:55:02 volumiowerk volumio[3422]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 09:55:02 volumiowerk volumio[3422]: *** WARNING *** For more information see
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 24 09:55:02 volumiowerk volumio[3422]: Discovery: StartAdv! undefined
Apr 24 09:55:02 volumiowerk volumio[3422]: Discovery: Started advertising... Volumiowerk - undefined
Apr 24 09:55:02 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "auto_play"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "outputs"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "albumart"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Plugin example_plugin is not enabled
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "inputs"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "updater_comm"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Plugin mpdemulation is not enabled
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "rest_api"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "websocket"...
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "radio_paradise"...
Apr 24 09:55:02 volumiowerk volumio[3422]: Forking 3 albumart workers
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Applying required configuration parameters for plugin radio_paradise
Apr 24 09:55:02 volumiowerk volumio[3422]: info: [1745488502850] [RadioParadise] API delay: 5
Apr 24 09:55:02 volumiowerk volumio[3422]: info: Loading plugin "backup_restore"...
Apr 24 09:55:03 volumiowerk volumio[3422]: info: ___________ START PLUGINS ___________
Apr 24 09:55:03 volumiowerk volumio[3422]: info: Loading i18n strings for locale nl
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 09:55:03 volumiowerk volumio[3422]: info: [1745488503194] CoreMusicLibrary::Adding element Media Servers
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 09:55:03 volumiowerk sudo[3499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Apr 24 09:55:03 volumiowerk sudo[3499]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:55:03 volumiowerk systemd[1]: Reloading.
Apr 24 09:55:03 volumiowerk volumio[3422]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 24 09:55:03 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service'
Apr 24 09:55:03 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service'
Apr 24 09:55:03 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service'
Apr 24 09:55:03 volumiowerk systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service'
Apr 24 09:55:03 volumiowerk volumio[3422]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 09:55:03 volumiowerk volumio[3422]: info: [1745488503475] CoreMusicLibrary::Adding element Last_100
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 09:55:03 volumiowerk volumio[3422]: info: [1745488503512] CoreMusicLibrary::Adding element Webradio
Apr 24 09:55:03 volumiowerk sudo[3499]: pam_unix(sudo:session): session closed for user root
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 09:55:03 volumiowerk volumio[3422]: info: [1745488503542] CoreMusicLibrary::Adding element Radio Paradise
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 09:55:03 volumiowerk volumio[3422]: info: -------------------------------------------
Apr 24 09:55:03 volumiowerk volumio[3422]: info: ----- MyVolumio plugins startup ----
Apr 24 09:55:03 volumiowerk volumio[3422]: info: -------------------------------------------
Apr 24 09:55:03 volumiowerk volumio[3422]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 24 09:55:03 volumiowerk volumio[3422]: info: Loading i18n strings for locale nl
Apr 24 09:55:03 volumiowerk volumio[3422]: Updating browse sources language
Apr 24 09:55:03 volumiowerk volumio[3422]: Cannot find translation for sourceMedia Servers
Apr 24 09:55:03 volumiowerk volumio[3422]: Cannot find translation for sourceRadio Paradise
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::initPlayerControls
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Apr 24 09:55:03 volumiowerk volumio[3422]: Starting albumart workers
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 24 09:55:03 volumiowerk volumio[3422]: info: BOOT COMPLETED
Apr 24 09:55:03 volumiowerk volumio[3422]: [Metrics] CommandRouter: 6s 33.12ms
Apr 24 09:55:03 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 09:55:03 volumiowerk volumio[3422]: Starting albumart workers
Apr 24 09:55:03 volumiowerk kernel: pcm512x 1-004d: No SCLK, using BCLK: -2
Apr 24 09:55:03 volumiowerk volumio[3422]: Starting albumart workers
Apr 24 09:55:09 volumiowerk volumio[3422]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::Close All Modals sent
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::Close All Modals sent
Apr 24 09:55:09 volumiowerk volumio[3422]: Express server listening on port 3000
Apr 24 09:55:09 volumiowerk volumio[3422]: [Metrics] WebUI: 11s 842.23ms
Apr 24 09:55:09 volumiowerk volumio[3422]: Volumio Calling Home
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreStateMachine::resetVolumioState
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreStateMachine::getcurrentVolume
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioRetrievevolume
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 09:55:09 volumiowerk volumio[3422]: info: Setting Device type: Raspberry PI
Apr 24 09:55:09 volumiowerk volumio[3422]: info: touch_display: systemctl daemon-reload succeeded.
Apr 24 09:55:09 volumiowerk volumio[3422]: info: MPD running with PID689
Apr 24 09:55:09 volumiowerk volumio[3422]: ,establishing connection
Apr 24 09:55:09 volumiowerk sudo[3565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Apr 24 09:55:09 volumiowerk volumio[3422]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:55:09 volumiowerk sudo[3565]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:55:09 volumiowerk systemd[1]: Started Volumio Kiosk.
Apr 24 09:55:09 volumiowerk sudo[3565]: pam_unix(sudo:session): session closed for user root
Apr 24 09:55:09 volumiowerk volumio[3422]: info: VolumeController:: Volume=54 Mute =false
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreStateMachine::pushState
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CorePlayQueue::getTrack 0
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioPushState
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreStateMachine::updateTrackBlock
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CorePlayQueue::getTrackBlock
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioRetrievevolume
Apr 24 09:55:09 volumiowerk volumio[3422]: info:
Apr 24 09:55:09 volumiowerk volumio[3422]: ---------------------------- Client requests Volume 55
Apr 24 09:55:09 volumiowerk volumio[3422]: info: VolumeController::SetAlsaVolume55
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreStateMachine::pushState
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CorePlayQueue::getTrack 0
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioPushState
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 09:55:09 volumiowerk volumio[3422]: info: touch_display: systemctl start volumio-kiosk.service succeeded.
Apr 24 09:55:09 volumiowerk volumio[3422]: info: touch_display: Volumio Kiosk started
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioGetState
Apr 24 09:55:09 volumiowerk volumio[3422]: info: CorePlayQueue::getTrack 0
Apr 24 09:55:09 volumiowerk volumio[3422]: info: Reloading queue from file
Apr 24 09:55:10 volumiowerk volumio[3422]: info: Setting volume on startup at 55
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreStateMachine::setRepeat null single undefined
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreStateMachine::pushState
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CorePlayQueue::getTrack 0
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioPushState
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreStateMachine::setRandom null
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreStateMachine::pushState
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CorePlayQueue::getTrack 0
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioPushState
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 09:55:10 volumiowerk volumio[3422]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 24 09:55:10 volumiowerk volumio[3422]: info: VolumeController:: Volume=54 Mute =false
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreStateMachine::pushState
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CorePlayQueue::getTrack 0
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioPushState
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 09:55:10 volumiowerk volumio[3422]: info: Starting Shairport Sync
Apr 24 09:55:10 volumiowerk volumio[3422]: info: Starting Shairport Sync
Apr 24 09:55:10 volumiowerk sudo[3580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 24 09:55:10 volumiowerk sudo[3580]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:55:10 volumiowerk sudo[3583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 24 09:55:10 volumiowerk sudo[3583]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:55:10 volumiowerk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 24 09:55:10 volumiowerk systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Apr 24 09:55:10 volumiowerk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 24 09:55:10 volumiowerk sudo[3580]: pam_unix(sudo:session): session closed for user root
Apr 24 09:55:10 volumiowerk volumio[3422]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Apr 24 09:55:10 volumiowerk systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 24 09:55:10 volumiowerk systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Apr 24 09:55:10 volumiowerk systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 24 09:55:10 volumiowerk sudo[3583]: pam_unix(sudo:session): session closed for user root
Apr 24 09:55:10 volumiowerk volumio[3422]: info: Shairport-Sync Started
Apr 24 09:55:10 volumiowerk volumio[3422]: Error adding Membership: Error: addMembership EINVAL
Apr 24 09:55:10 volumiowerk sudo[3609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf
Apr 24 09:55:10 volumiowerk sudo[3609]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:55:10 volumiowerk sudo[3609]: pam_unix(sudo:session): session closed for user root
Apr 24 09:55:10 volumiowerk volumio[3422]: info: Shairport-Sync Started
Apr 24 09:55:10 volumiowerk volumio[3422]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Apr 24 09:55:10 volumiowerk volumio[3422]: info: touch_display: Setting screensaver timeout to 120 seconds.
Apr 24 09:55:10 volumiowerk volumio[3422]: info: touch_display: Touchscreen transformation matrix removed.
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioGetState
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CorePlayQueue::getTrack 0
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioGetState
Apr 24 09:55:10 volumiowerk volumio[3422]: info: CorePlayQueue::getTrack 0
Apr 24 09:55:11 volumiowerk sudo[3637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 24 09:55:11 volumiowerk sudo[3637]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:55:11 volumiowerk sudo[3637]: pam_unix(sudo:session): session closed for user root
Apr 24 09:55:11 volumiowerk sudo[3644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 24 09:55:11 volumiowerk sudo[3644]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:55:11 volumiowerk sudo[3644]: pam_unix(sudo:session): session closed for user root
Apr 24 09:55:11 volumiowerk sudo[3652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 24 09:55:11 volumiowerk sudo[3652]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 09:55:11 volumiowerk systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 24 09:55:11 volumiowerk sudo[3652]: pam_unix(sudo:session): session closed for user root
Apr 24 09:55:11 volumiowerk volumio[3422]: info: Upmpdcli Daemon Started
Apr 24 09:55:13 volumiowerk volumio-remote-updater[619]: [2025-04-24 09:55:13] [connect] Successful connection
Apr 24 09:55:13 volumiowerk volumio-remote-updater[619]: [2025-04-24 09:55:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1745488513 101
Apr 24 09:55:13 volumiowerk volumio[3422]: info: CoreCommandRouter::volumioGetState
Apr 24 09:55:13 volumiowerk volumio[3422]: info: CorePlayQueue::getTrack 0
Apr 24 09:55:13 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 24 09:55:13 volumiowerk volumio[3422]: info: Listing playlists
Apr 24 09:55:14 volumiowerk volumio[3422]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:55:19 volumiowerk volumio[3422]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:55:24 volumiowerk volumio[3422]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:55:29 volumiowerk volumio[3422]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:55:33 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 24 09:55:33 volumiowerk volumio[3422]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 09:55:34 volumiowerk volumio[3422]: error: MPD error: Error: connect EAGAIN /run/mpd/socket
Apr 24 09:55:37 volumiowerk volumio[3422]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 24 09:55:37 volumiowerk volumio[3422]: TypeError: Cannot create property 'type' on string 'invalid server key'
Apr 24 09:55:37 volumiowerk volumio[3422]: at WebSocket.onError (/volumio/node_modules/engine.io-client/node_modules/ws/lib/WebSocket.js:450:16)
Apr 24 09:55:37 volumiowerk volumio[3422]: at emitOne (events.js:116:13)
Apr 24 09:55:37 volumiowerk volumio[3422]: at WebSocket.emit (events.js:211:7)
Apr 24 09:55:37 volumiowerk volumio[3422]: at ClientRequest.upgrade (/volumio/node_modules/engine.io-client/node_modules/ws/lib/WebSocket.js:738:12)
Apr 24 09:55:37 volumiowerk volumio[3422]: at Object.onceWrapper (events.js:319:30)
Apr 24 09:55:37 volumiowerk volumio[3422]: at emitThree (events.js:136:13)
Apr 24 09:55:37 volumiowerk volumio[3422]: at ClientRequest.emit (events.js:217:7)
Apr 24 09:55:37 volumiowerk volumio[3422]: at Socket.socketOnData (_http_client.js:472:11)
Apr 24 09:55:37 volumiowerk volumio[3422]: at emitOne (events.js:116:13)
Apr 24 09:55:37 volumiowerk volumio[3422]: at Socket.emit (events.js:211:7)
Apr 24 09:55:37 volumiowerk volumio[3422]: at addChunk (_stream_readable.js:263:12)
Apr 24 09:55:37 volumiowerk volumio[3422]: at readableAddChunk (_stream_readable.js:250:11)
Apr 24 09:55:37 volumiowerk volumio[3422]: at Socket.Readable.push (_stream_readable.js:208:10)
Apr 24 09:55:37 volumiowerk volumio[3422]: at TCP.onread (net.js:607:20)
Apr 24 09:55:37 volumiowerk volumio[3422]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 24 09:55:38 volumiowerk sudo[3696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-24 09:54
Apr 24 09:55:38 volumiowerk sudo[3696]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae"
VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021"
VOLUMIO_VERSION="2.917"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"