Jun 07 12:04:03 muzyka volumio[1200]: info: CoreCommandRouter::volumioGetState
Jun 07 12:04:04 muzyka wpa_supplicant[1097]: RRM: Ignoring radio measurement request: Not RRM network
Jun 07 12:04:05 muzyka volumio[1200]: info: Executing endpoint metavolumio
Jun 07 12:04:05 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 07 12:04:05 muzyka volumio[1200]: info: Executing endpoint metavolumio
Jun 07 12:04:05 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 07 12:04:05 muzyka volumio[1200]: info: Executing endpoint metavolumio
Jun 07 12:04:05 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 07 12:04:06 muzyka volumio[1200]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 07 12:04:06 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jun 07 12:04:06 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 07 12:04:06 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jun 07 12:04:06 muzyka volumio[1200]: info: Getting Alsa Cards List without I2S DAC
Jun 07 12:04:06 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber
Jun 07 12:04:06 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 07 12:04:07 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 07 12:04:07 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 07 12:04:07 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 07 12:04:07 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 07 12:04:07 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 07 12:04:07 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 07 12:04:07 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 07 12:04:07 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jun 07 12:04:07 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jun 07 12:04:14 muzyka wpa_supplicant[1097]: RRM: Ignoring radio measurement request: Not RRM network
Jun 07 12:04:19 muzyka volumio[1200]: info: CoreCommandRouter::volumioGetState
Jun 07 12:04:21 muzyka wpa_supplicant[1097]: RRM: Ignoring radio measurement request: Not RRM network
Jun 07 12:04:21 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jun 07 12:04:21 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Jun 07 12:04:21 muzyka volumio[1200]: info: Executing endpoint metavolumio
Jun 07 12:04:21 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 07 12:04:21 muzyka volumio[1200]: info: Executing endpoint metavolumio
Jun 07 12:04:21 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 07 12:04:21 muzyka volumio[1200]: info: Executing endpoint metavolumio
Jun 07 12:04:21 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 07 12:04:28 muzyka wpa_supplicant[1097]: RRM: Ignoring radio measurement request: Not RRM network
Jun 07 12:04:28 muzyka systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
Jun 07 12:04:28 muzyka dbus-daemon[614]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.54' (uid=0 pid=4026 comm="timedatectl show --property=NTPSynchronized --valu")
Jun 07 12:04:28 muzyka systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Jun 07 12:04:28 muzyka dbus-daemon[614]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 07 12:04:28 muzyka systemd[1]: Started systemd-timedated.service - Time & Date Service.
Jun 07 12:04:28 muzyka setdatetime-helper.sh[4025]: Time is already synchronized.
Jun 07 12:04:28 muzyka systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
Jun 07 12:04:28 muzyka systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
Jun 07 12:04:31 muzyka volumio[1200]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 07 12:04:32 muzyka volumio[1200]: info: CALLMETHOD: user_interface Systeminfo getsysteminfo undefined
Jun 07 12:04:32 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: Systeminfo , getsysteminfo
Jun 07 12:04:32 muzyka sudo[4032]: pam_unix(sudo:auth): conversation failed
Jun 07 12:04:32 muzyka sudo[4032]: pam_unix(sudo:auth): auth could not identify password for [volumio]
Jun 07 12:04:33 muzyka dbus-daemon[614]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.56' (uid=1000 pid=4137 comm="hostnamectl --json short")
Jun 07 12:04:33 muzyka systemd[1]: Starting systemd-hostnamed.service - Hostname Service...
Jun 07 12:04:33 muzyka dbus-daemon[614]: [system] Successfully activated service 'org.freedesktop.hostname1'
Jun 07 12:04:33 muzyka systemd[1]: Started systemd-hostnamed.service - Hostname Service.
Jun 07 12:04:33 muzyka dbus-daemon[614]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.57' (uid=0 pid=4140 comm="/lib/systemd/systemd-hostnamed")
Jun 07 12:04:33 muzyka systemd[1]: Starting polkit.service - Authorization Manager...
Jun 07 12:04:33 muzyka polkitd[4156]: Started polkitd version 122
Jun 07 12:04:33 muzyka polkitd[4156]: Loading rules from directory /etc/polkit-1/rules.d
Jun 07 12:04:33 muzyka polkitd[4156]: Loading rules from directory /usr/share/polkit-1/rules.d
Jun 07 12:04:33 muzyka polkitd[4156]: Finished loading, compiling and executing 2 rules
Jun 07 12:04:33 muzyka dbus-daemon[614]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Jun 07 12:04:33 muzyka systemd[1]: Started polkit.service - Authorization Manager.
Jun 07 12:04:33 muzyka polkitd[4156]: Acquired the name org.freedesktop.PolicyKit1 on the system bus
Jun 07 12:04:33 muzyka dbus-daemon[614]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.57" (uid=0 pid=4140 comm="/lib/systemd/systemd-hostnamed") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.InteractiveAuthorizationRequired" requested_reply="0" destination=":1.56" (uid=1000 pid=4137 comm="hostnamectl --json short")
Jun 07 12:04:34 muzyka volumio[1200]: info: board is Raspberry Pi 4 Model B Rev 1.4
Jun 07 12:04:34 muzyka volumio[1200]: Storage info 51377M 1263M 47374M
Jun 07 12:04:34 muzyka volumio[1200]: Storage info 51377M 1263M 47374M
Jun 07 12:04:34 muzyka volumio[1200]: BBBBBBBBBBBBBB-CPU Temp 40 °C
Jun 07 12:04:34 muzyka volumio[1200]: info: Firmware detection failed: Error: Command failed: sudo vcgencmd bootloader_version
Jun 07 12:04:34 muzyka volumio[1200]: sudo: a terminal is required to read the password; either use the -S option to read from standard input or configure an askpass helper
Jun 07 12:04:34 muzyka volumio[1200]: sudo: a password is required
Jun 07 12:04:35 muzyka wpa_supplicant[1097]: RRM: Ignoring radio measurement request: Not RRM network
Jun 07 12:04:35 muzyka volumio[1200]: info: failed Error: Command failed: /data/plugins/user_interface/Systeminfo/hw_params hw:2 >/data/configuration/user_interface/Systeminfo/config.json
Jun 07 12:04:35 muzyka volumio[1200]: cannot open device 'hw:2': Device or resource busy
Jun 07 12:04:37 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 07 12:04:42 muzyka wpa_supplicant[1097]: RRM: Ignoring radio measurement request: Not RRM network
Jun 07 12:04:42 muzyka volumio[1200]: info: CoreCommandRouter::Close All Modals sent
Jun 07 12:04:45 muzyka volumio[1200]: info: CoreCommandRouter::volumioGetState
Jun 07 12:04:47 muzyka volumio[1200]: info: Executing endpoint metavolumio
Jun 07 12:04:47 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 07 12:04:47 muzyka volumio[1200]: info: Executing endpoint metavolumio
Jun 07 12:04:47 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 07 12:04:47 muzyka volumio[1200]: info: Executing endpoint metavolumio
Jun 07 12:04:47 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 07 12:04:49 muzyka wpa_supplicant[1097]: RRM: Ignoring radio measurement request: Not RRM network
Jun 07 12:04:58 muzyka systemd[1]: systemd-timedated.service: Deactivated successfully.
Jun 07 12:05:03 muzyka systemd[1]: systemd-hostnamed.service: Deactivated successfully.
Jun 07 12:05:06 muzyka volumio[1200]: info: Executing endpoint metavolumio
Jun 07 12:05:06 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 07 12:05:07 muzyka wpa_supplicant[1097]: RRM: Ignoring radio measurement request: Not RRM network
Jun 07 12:05:11 muzyka volumio[1200]: Searching all installed plugins
Jun 07 12:05:11 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 07 12:05:11 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: , search
Jun 07 12:05:11 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jun 07 12:05:11 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: last_100 , search
Jun 07 12:05:11 muzyka volumio[1200]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100
Jun 07 12:05:11 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: webradio , search
Jun 07 12:05:11 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search
Jun 07 12:05:11 muzyka volumio[1200]: info: [ytmusic] InnertubeLoader: creating Innertube instance...
Jun 07 12:05:11 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search
Jun 07 12:05:11 muzyka volumio[1200]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Jun 07 12:05:11 muzyka volumio[1200]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 07 12:05:11 muzyka volumio[1200]: TypeError: Cannot read properties of undefined (reading 'length')
Jun 07 12:05:11 muzyka volumio[1200]: at /volumio/node_modules/libxmljs/dist/lib/parse.js:186:126
Jun 07 12:05:11 muzyka volumio[1200]: at Object.parseXml (/volumio/node_modules/libxmljs/dist/lib/parse.js:185:49)
Jun 07 12:05:11 muzyka volumio[1200]: at /volumio/app/plugins/music_service/webradio/index.js:949:31
Jun 07 12:05:11 muzyka volumio[1200]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Jun 07 12:05:11 muzyka volumio[1200]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 07 12:05:12 muzyka sudo[4798]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-07 12:04'
Jun 07 12:05:12 muzyka sudo[4798]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jun 07 12:05:12 muzyka sudo[4798]: pam_unix(sudo:session): session closed for user root
Jun 07 12:05:12 muzyka volumio-remote-updater[636]: [2025-06-07 12:05:12] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 07 12:05:12 muzyka volumio-remote-updater[636]: [2025-06-07 12:05:12] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 07 12:05:12 muzyka systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 07 12:05:13 muzyka systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 07 12:05:13 muzyka systemd[1]: volumio.service: Consumed 17min 49.084s CPU time.
Jun 07 12:05:13 muzyka systemd[1]: Started dynamicswap.service - dynamicswap service.
Jun 07 12:05:13 muzyka systemd[1]: dynamicswap.service: Deactivated successfully.
Jun 07 12:05:13 muzyka systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1.
Jun 07 12:05:13 muzyka systemd[1]: Started dynamicswap.service - dynamicswap service.
Jun 07 12:05:13 muzyka systemd[1]: Stopped volumio.service - Volumio Backend Module.
Jun 07 12:05:13 muzyka systemd[1]: volumio.service: Consumed 17min 49.084s CPU time.
Jun 07 12:05:13 muzyka systemd[1]: Started volumio.service - Volumio Backend Module.
Jun 07 12:05:13 muzyka systemd[1]: dynamicswap.service: Deactivated successfully.
Jun 07 12:05:14 muzyka volumio[4824]: info: -------------------------------------------
Jun 07 12:05:14 muzyka volumio[4824]: info: ----- Volumio3 ----
Jun 07 12:05:14 muzyka volumio[4824]: info: -------------------------------------------
Jun 07 12:05:14 muzyka volumio[4824]: info: ----- System startup ----
Jun 07 12:05:14 muzyka volumio[4824]: info: -------------------------------------------
Jun 07 12:05:14 muzyka wpa_supplicant[1097]: RRM: Ignoring radio measurement request: Not RRM network
Jun 07 12:05:14 muzyka volumio[4824]: info: MYVOLUMIO Environment detected
Jun 07 12:05:14 muzyka volumio[4824]: info: Plugin folders cleanup
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning into folder /volumio/app/plugins/
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning category audio_interface
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning category miscellanea
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning category music_service
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning category plugins.json
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning category system_controller
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning category user_interface
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning into folder /data/plugins/
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning category audio_interface
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning category music_service
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning category system_controller
Jun 07 12:05:14 muzyka volumio[4824]: info: Scanning category user_interface
Jun 07 12:05:14 muzyka volumio[4824]: info: Plugin folders cleanup completed
Jun 07 12:05:14 muzyka volumio[4824]: info: -------------------------------------------
Jun 07 12:05:14 muzyka volumio[4824]: info: ----- Core plugins startup ----
Jun 07 12:05:14 muzyka volumio[4824]: info: -------------------------------------------
Jun 07 12:05:14 muzyka volumio[4824]: info: Loading plugins from folder /volumio/app/plugins/
Jun 07 12:05:14 muzyka volumio[4824]: info: Adding plugin upnp to MyMusic Plugins
Jun 07 12:05:14 muzyka volumio[4824]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 07 12:05:14 muzyka volumio[4824]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 07 12:05:14 muzyka volumio[4824]: info: Loading plugins from folder /data/plugins/
Jun 07 12:05:14 muzyka volumio[4824]: info: Loading plugin "system"...
Jun 07 12:05:14 muzyka volumio[4824]: info: Loading plugin "appearance"...
Jun 07 12:05:15 muzyka volumio[4824]: info: Loading plugin "network"...
Jun 07 12:05:15 muzyka volumio[4824]: info: Refreshing Cached IP Addresses
Jun 07 12:05:15 muzyka sudo[4852]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 07 12:05:15 muzyka sudo[4852]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jun 07 12:05:15 muzyka sudo[4854]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 07 12:05:15 muzyka sudo[4854]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jun 07 12:05:15 muzyka sudo[4852]: pam_unix(sudo:session): session closed for user root
Jun 07 12:05:15 muzyka volumio[4824]: info: Loading plugin "services"...
Jun 07 12:05:15 muzyka volumio[4824]: info: Loading plugin "alsa_controller"...
Jun 07 12:05:15 muzyka sudo[4854]: pam_unix(sudo:session): session closed for user root
Jun 07 12:05:15 muzyka sudo[4866]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 07 12:05:15 muzyka sudo[4866]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jun 07 12:05:15 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 07 12:05:15 muzyka volumio[4824]: info: Loading plugin "wizard"...
Jun 07 12:05:15 muzyka volumio[4824]: info: Loading plugin "networkfs"...
Jun 07 12:05:15 muzyka volumio[4824]: info: Starting Udev Watcher for removable devices
Jun 07 12:05:15 muzyka volumio[4824]: info: Ignoring mount for partition: boot
Jun 07 12:05:15 muzyka volumio[4824]: info: Ignoring mount for partition: volumio
Jun 07 12:05:15 muzyka volumio[4824]: info: Ignoring mount for partition: volumio_data
Jun 07 12:05:15 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 07 12:05:15 muzyka volumio[4824]: info: Loading plugin "volumio_command_line_client"...
Jun 07 12:05:15 muzyka volumio[4824]: info: Plugin upnp is not enabled
Jun 07 12:05:15 muzyka volumio[4824]: info: Loading plugin "my_music"...
Jun 07 12:05:15 muzyka volumio[4824]: info: Loading plugin "mpd"...
Jun 07 12:05:15 muzyka volumio[4824]: info: Plugin upnp_browser is not enabled
Jun 07 12:05:15 muzyka volumio[4824]: info: Loading plugin "alarm-clock"...
Jun 07 12:05:16 muzyka volumio[4824]: info: Plugin airplay_emulation is not enabled
Jun 07 12:05:16 muzyka volumio[4824]: info: Loading plugin "last_100"...
Jun 07 12:05:16 muzyka volumio[4824]: info: Loading plugin "webradio"...
Jun 07 12:05:16 muzyka volumio[4824]: info: Loading plugin "i2s_dacs"...
Jun 07 12:05:16 muzyka volumio[4824]: info: Loading plugin "volumiodiscovery"...
Jun 07 12:05:16 muzyka volumio[4824]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 07 12:05:16 muzyka volumio[4824]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 07 12:05:16 muzyka volumio[4824]: *** WARNING *** For more information see
Jun 07 12:05:16 muzyka volumio[4824]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 07 12:05:16 muzyka volumio[4824]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 07 12:05:16 muzyka volumio[4824]: *** WARNING *** For more information see
Jun 07 12:05:16 muzyka node[4824]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 07 12:05:16 muzyka node[4824]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 07 12:05:16 muzyka node[4824]: *** WARNING *** For more information see
Jun 07 12:05:16 muzyka node[4824]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jun 07 12:05:16 muzyka node[4824]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 07 12:05:16 muzyka node[4824]: *** WARNING *** For more information see
Jun 07 12:05:16 muzyka volumio[4824]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 07 12:05:16 muzyka volumio[4824]: info: Discovery: Started advertising with name: muzyka
Jun 07 12:05:16 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 07 12:05:16 muzyka volumio[4824]: info: Loading plugin "ytmusic"...
Jun 07 12:05:17 muzyka volumio-remote-updater[636]: [2025-06-07 12:05:17] [connect] Successful connection
Jun 07 12:05:18 muzyka volumio[4824]: info: Loading plugin "autostart"...
Jun 07 12:05:18 muzyka volumio[4824]: info: Applying required configuration parameters for plugin autostart
Jun 07 12:05:18 muzyka volumio[4824]: info: AutoStart - onVolumioStart - read config.json
Jun 07 12:05:18 muzyka volumio[4824]: info: Loading plugin "outputs"...
Jun 07 12:05:18 muzyka volumio[4824]: info: Loading plugin "albumart"...
Jun 07 12:05:18 muzyka volumio[4824]: info: Plugin example_plugin is not enabled
Jun 07 12:05:18 muzyka volumio[4824]: info: Loading plugin "inputs"...
Jun 07 12:05:18 muzyka volumio[4824]: info: Loading plugin "updater_comm"...
Jun 07 12:05:18 muzyka volumio[4824]: info: Plugin mpdemulation is not enabled
Jun 07 12:05:18 muzyka volumio[4824]: info: Loading plugin "rest_api"...
Jun 07 12:05:18 muzyka volumio[4824]: info: Loading plugin "websocket"...
Jun 07 12:05:18 muzyka volumio[4824]: info: Starting Socket.io Server version 1.7.4
Jun 07 12:05:18 muzyka volumio[4824]: info: Loading plugin "fusiondsp"...
Jun 07 12:05:18 muzyka volumio[4824]: info: Applying required configuration parameters for plugin fusiondsp
Jun 07 12:05:18 muzyka volumio[4885]: Forking 3 albumart workers
Jun 07 12:05:18 muzyka volumio[4824]: info: Plugin mpdoutput is not enabled
Jun 07 12:05:18 muzyka volumio[4824]: info: Loading plugin "80s80s"...
Jun 07 12:05:18 muzyka volumio[4824]: info: Applying required configuration parameters for plugin 80s80s
Jun 07 12:05:18 muzyka volumio[4824]: info: [1749290718913] [80s80s] API delay: 5
Jun 07 12:05:18 muzyka volumio[4824]: info: Loading plugin "backup_restore"...
Jun 07 12:05:19 muzyka volumio[4824]: info: Applying required configuration parameters for plugin backup_restore
Jun 07 12:05:19 muzyka volumio[4824]: info: Loading plugin "Systeminfo"...
Jun 07 12:05:19 muzyka sudo[4866]: pam_unix(sudo:session): session closed for user root
Jun 07 12:05:19 muzyka volumio[4824]: info: Loading plugin "touch_display"...
Jun 07 12:05:19 muzyka volumio[4897]: Starting albumart workers
Jun 07 12:05:19 muzyka volumio[4824]: info: Applying required configuration parameters for plugin touch_display
Jun 07 12:05:19 muzyka volumio[4895]: Starting albumart workers
Jun 07 12:05:19 muzyka volumio[4824]: info: Loading i18n strings for locale pl
Jun 07 12:05:19 muzyka volumio[4824]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found.
Jun 07 12:05:19 muzyka volumio[4824]: Updating browse sources language
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 07 12:05:19 muzyka volumio[4896]: Starting albumart workers
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::initPlayerControls
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 07 12:05:19 muzyka volumio[4824]: Express server listening on port 3000
Jun 07 12:05:19 muzyka volumio[4824]: [Metrics] WebUI: 5s 679.61ms
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreStateMachine::resetVolumioState
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreStateMachine::getcurrentVolume
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::volumioRetrievevolume
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreStateMachine::pushState
Jun 07 12:05:19 muzyka volumio[4824]: info: CorePlayQueue::getTrack 0
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 07 12:05:19 muzyka volumio[4824]: info: CoreCommandRouter::volumioPushState
Jun 07 12:05:19 muzyka volumio[4824]: info: Volumio Network Manager: Network status updated: 2
Jun 07 12:05:20 muzyka volumio[4824]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Jun 07 12:05:20 muzyka volumio[4824]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 07 12:05:20 muzyka volumio[4824]: info: Reloading queue from file
Jun 07 12:05:20 muzyka volumio[4824]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreStateMachine::setRepeat null single undefined
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreStateMachine::pushState
Jun 07 12:05:20 muzyka volumio[4824]: info: CorePlayQueue::getTrack 0
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreCommandRouter::volumioPushState
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreStateMachine::setRandom null
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreStateMachine::pushState
Jun 07 12:05:20 muzyka volumio[4824]: info: CorePlayQueue::getTrack 0
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreCommandRouter::volumioPushState
Jun 07 12:05:20 muzyka volumio[4824]: info: Setting Device type: Raspberry PI
Jun 07 12:05:20 muzyka volumio[4824]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 07 12:05:20 muzyka volumio[4824]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03114
Jun 07 12:05:20 muzyka volumio[4824]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 07 12:05:20 muzyka volumio-remote-updater[636]: [2025-06-07 12:05:20] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1749290717 101
Jun 07 12:05:20 muzyka volumio[4824]: 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: 4
Jun 07 12:05:20 muzyka volumio[4824]: info: Completed loading Core Plugins
Jun 07 12:05:20 muzyka volumio[4824]: info: Preparing to generate the ALSA configuration file
Jun 07 12:05:20 muzyka volumio[4824]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 07 12:05:20 muzyka volumio[4824]: info: Reading ALSA contributions from plugins.
Jun 07 12:05:20 muzyka volumio[4824]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Jun 07 12:05:20 muzyka volumio[4824]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Jun 07 12:05:20 muzyka volumio[4824]: Searching all installed plugins
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: , search
Jun 07 12:05:20 muzyka volumio[4824]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jun 07 12:05:20 muzyka volumio[4824]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 07 12:05:20 muzyka volumio[4824]: TypeError: Cannot read properties of undefined (reading 'then')
Jun 07 12:05:20 muzyka volumio[4824]: at ControllerMpd.search (/volumio/app/plugins/music_service/mpd/index.js:1583:17)
Jun 07 12:05:20 muzyka volumio[4824]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32)
Jun 07 12:05:20 muzyka volumio[4824]: at CoreMusicLibrary.searchOnPlugin (/volumio/app/musiclibrary.js:668:44)
Jun 07 12:05:20 muzyka volumio[4824]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:455:27)
Jun 07 12:05:20 muzyka volumio[4824]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44)
Jun 07 12:05:20 muzyka volumio[4824]: at Socket.emit (node:events:514:28)
Jun 07 12:05:20 muzyka volumio[4824]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Jun 07 12:05:20 muzyka volumio[4824]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11)
Jun 07 12:05:20 muzyka volumio[4824]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 07 12:05:20 muzyka sudo[4966]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-07 12:04'
Jun 07 12:05:20 muzyka sudo[4966]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="4a70cb031e64a8e498efc3e29470650871ff7d54"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025"
VOLUMIO_VERSION="4.005"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"