-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Mon 2025-11-03 19:03:09 UTC. -- Nov 03 19:02:25 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 19:02:25 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 19:02:25 volumio volumio[3872]: info: Discovery: Getting this device information Nov 03 19:02:25 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:25 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:25 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 19:02:25 volumio volumio[3872]: verbose: New Socket.io Connection to 192.168.0.102:3000 from 192.168.0.104 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Nov 03 19:02:25 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:25 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:25 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 03 19:02:25 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 03 19:02:26 volumio volumio[3872]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: Mozilla/5.0 (Linux; Android 13; SM-T970 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 03 19:02:26 volumio volumio[3872]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: Mozilla/5.0 (Linux; Android 13; SM-T970 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:26 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::volumioGetQueue Nov 03 19:02:26 volumio volumio[3872]: info: CoreStateMachine::getQueue Nov 03 19:02:26 volumio volumio[3872]: info: CorePlayQueue::getQueue Nov 03 19:02:26 volumio volumio[3872]: info: Listing playlists Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 19:02:26 volumio volumio[3872]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 03 19:02:26 volumio volumio[3872]: info: Received Get System Info Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 19:02:26 volumio volumio[3872]: info: Discovery: Getting this device information Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:26 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:26 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 19:02:26 volumio volumio[3872]: info: Discovery: Getting this device information Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:26 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:26 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 19:02:28 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:28 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:28 volumio volumio[3872]: verbose: New Socket.io Connection to 192.168.0.102:3000 from 192.168.0.104 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Nov 03 19:02:28 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:28 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:28 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 03 19:02:28 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 03 19:02:28 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:28 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:28 volumio sudo[10211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 19:02:28 volumio sudo[10211]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 19:02:28 volumio sudo[10211]: pam_unix(sudo:session): session closed for user root Nov 03 19:02:28 volumio sudo[10214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 19:02:28 volumio sudo[10214]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 19:02:28 volumio sudo[10214]: pam_unix(sudo:session): session closed for user root Nov 03 19:02:28 volumio volumio[3872]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: Mozilla/5.0 (Linux; Android 13; SM-T970 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Nov 03 19:02:29 volumio sudo[10217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 19:02:29 volumio sudo[10217]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 19:02:29 volumio sudo[10217]: pam_unix(sudo:session): session closed for user root Nov 03 19:02:29 volumio sudo[10220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 19:02:29 volumio sudo[10220]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 19:02:29 volumio sudo[10220]: pam_unix(sudo:session): session closed for user root Nov 03 19:02:29 volumio volumio[3872]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: Mozilla/5.0 (Linux; Android 13; SM-T970 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:29 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::volumioGetQueue Nov 03 19:02:29 volumio volumio[3872]: info: CoreStateMachine::getQueue Nov 03 19:02:29 volumio volumio[3872]: info: CorePlayQueue::getQueue Nov 03 19:02:29 volumio volumio[3872]: info: Listing playlists Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 19:02:29 volumio volumio[3872]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 03 19:02:29 volumio volumio[3872]: info: Received Get System Info Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 19:02:29 volumio volumio[3872]: info: Discovery: Getting this device information Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:29 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:29 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 03 19:02:29 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 19:02:31 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 19:02:31 volumio volumio[3872]: info: Received Get System Info Nov 03 19:02:31 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 19:02:31 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 19:02:31 volumio volumio[3872]: info: Discovery: Getting this device information Nov 03 19:02:31 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:31 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:31 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 19:02:31 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 03 19:02:32 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 19:02:32 volumio volumio[3872]: info: Received Get System Info Nov 03 19:02:32 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 19:02:32 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 19:02:32 volumio volumio[3872]: info: Discovery: Getting this device information Nov 03 19:02:32 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:32 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:32 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 19:02:40 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 03 19:02:48 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 19:02:48 volumio volumio[3872]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 03 19:02:48 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 03 19:02:48 volumio volumio[3872]: info: Received Get System Version Nov 03 19:02:48 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 19:02:48 volumio volumio[3872]: info: Received Get System Info Nov 03 19:02:48 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 19:02:48 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 19:02:48 volumio volumio[3872]: info: Discovery: Getting this device information Nov 03 19:02:48 volumio volumio[3872]: info: CoreCommandRouter::volumioGetState Nov 03 19:02:48 volumio volumio[3872]: info: CorePlayQueue::getTrack 2 Nov 03 19:02:48 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 19:02:52 volumio volumio[3872]: Searching all installed plugins Nov 03 19:02:52 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 19:02:52 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: , search Nov 03 19:02:52 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: mpd , search Nov 03 19:02:52 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Nov 03 19:02:52 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Nov 03 19:02:52 volumio volumio[3872]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Nov 03 19:02:52 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: webradio , search Nov 03 19:02:52 volumio volumio[3872]: info: CoreCommandRouter::executeOnPlugin: calmradio , search Nov 03 19:02:52 volumio volumio[3872]: info: [1762196572192] ControllerCalmRadio::searchCategories Nov 03 19:02:52 volumio volumio[3872]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 19:02:52 volumio volumio[3872]: TypeError: Cannot read property 'cats' of undefined Nov 03 19:02:52 volumio volumio[3872]: at ControllerCalmRadio.searchCategories (/data/plugins/music_service/calmradio/index.js:615:42) Nov 03 19:02:52 volumio volumio[3872]: at ControllerCalmRadio.search (/data/plugins/music_service/calmradio/index.js:665:28) Nov 03 19:02:52 volumio volumio[3872]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Nov 03 19:02:52 volumio volumio[3872]: at CoreMusicLibrary.searchOnPlugin (/volumio/app/musiclibrary.js:668:44) Nov 03 19:02:52 volumio volumio[3872]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:455:27) Nov 03 19:02:52 volumio volumio[3872]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Nov 03 19:02:52 volumio volumio[3872]: at Socket.emit (events.js:315:20) Nov 03 19:02:52 volumio volumio[3872]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 03 19:02:52 volumio volumio[3872]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Nov 03 19:02:52 volumio volumio[3872]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 19:02:52 volumio sudo[10277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-03 19:01 Nov 03 19:02:52 volumio sudo[10277]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 19:02:52 volumio sudo[10277]: pam_unix(sudo:session): session closed for user root Nov 03 19:02:52 volumio vtcs[4347]: [2025-11-03 19:02:52.944] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Nov 03 19:02:52 volumio qobuz-connect[4291]: 20251103 19:02:52.945 [4291.4291] INFO SampleApp: Socket closed Nov 03 19:02:52 volumio volumio-remote-updater[633]: [2025-11-03 19:02:52] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Nov 03 19:02:52 volumio volumio-remote-updater[633]: [2025-11-03 19:02:52] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Nov 03 19:02:52 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 03 19:02:52 volumio ntfs-3g[3931]: Unmounting /dev/sda1 (Elements) Nov 03 19:02:52 volumio systemd[1]: media-Elements.mount: Succeeded. Nov 03 19:02:52 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 03 19:02:53 volumio systemd[1]: Started dynamicswap service. Nov 03 19:02:53 volumio systemd[1]: dynamicswap.service: Succeeded. Nov 03 19:02:53 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 03 19:02:53 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5. Nov 03 19:02:53 volumio systemd[1]: Stopped Volumio Backend Module. Nov 03 19:02:53 volumio systemd[1]: Started Volumio Backend Module. Nov 03 19:02:53 volumio systemd[1]: Started dynamicswap service. Nov 03 19:02:53 volumio systemd[1]: dynamicswap.service: Succeeded. Nov 03 19:02:55 volumio volumio[10288]: info: ------------------------------------------- Nov 03 19:02:55 volumio volumio[10288]: info: ----- Volumio3 ---- Nov 03 19:02:55 volumio volumio[10288]: info: ------------------------------------------- Nov 03 19:02:55 volumio volumio[10288]: info: ----- System startup ---- Nov 03 19:02:55 volumio volumio[10288]: info: ------------------------------------------- Nov 03 19:02:55 volumio volumio[10288]: info: MYVOLUMIO Environment detected Nov 03 19:02:55 volumio volumio[10288]: info: Plugin folders cleanup Nov 03 19:02:55 volumio volumio[10288]: info: Scanning into folder /volumio/app/plugins/ Nov 03 19:02:55 volumio volumio[10288]: info: Scanning category audio_interface Nov 03 19:02:55 volumio volumio[10288]: info: Scanning category miscellanea Nov 03 19:02:55 volumio volumio[10288]: info: Scanning category music_service Nov 03 19:02:55 volumio volumio[10288]: info: Scanning category plugins.json Nov 03 19:02:55 volumio volumio[10288]: info: Scanning category system_controller Nov 03 19:02:55 volumio volumio[10288]: info: Scanning category user_interface Nov 03 19:02:55 volumio volumio[10288]: info: Scanning into folder /data/plugins/ Nov 03 19:02:55 volumio volumio[10288]: info: Scanning category music_service Nov 03 19:02:55 volumio volumio[10288]: info: Scanning category system_hardware Nov 03 19:02:55 volumio volumio[10288]: info: Scanning category user_interface Nov 03 19:02:55 volumio volumio[10288]: info: Plugin folders cleanup completed Nov 03 19:02:55 volumio volumio[10288]: info: ------------------------------------------- Nov 03 19:02:55 volumio volumio[10288]: info: ----- Core plugins startup ---- Nov 03 19:02:55 volumio volumio[10288]: info: ------------------------------------------- Nov 03 19:02:55 volumio volumio[10288]: info: Loading plugins from folder /volumio/app/plugins/ Nov 03 19:02:55 volumio volumio[10288]: info: Adding plugin upnp to MyMusic Plugins Nov 03 19:02:55 volumio volumio[10288]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 03 19:02:55 volumio volumio[10288]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 03 19:02:55 volumio volumio[10288]: info: Loading plugins from folder /data/plugins/ Nov 03 19:02:55 volumio volumio[10288]: info: Loading plugin "system"... Nov 03 19:02:55 volumio volumio[10288]: info: Loading plugin "appearance"... Nov 03 19:02:56 volumio volumio[10288]: info: Loading plugin "network"... Nov 03 19:02:57 volumio volumio[10288]: info: Refreshing Cached IP Addresses Nov 03 19:02:57 volumio sudo[10315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 19:02:57 volumio sudo[10315]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 19:02:57 volumio sudo[10315]: pam_unix(sudo:session): session closed for user root Nov 03 19:02:57 volumio sudo[10317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 19:02:57 volumio sudo[10317]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 19:02:57 volumio sudo[10317]: pam_unix(sudo:session): session closed for user root Nov 03 19:02:57 volumio volumio[10288]: info: Loading plugin "services"... Nov 03 19:02:57 volumio volumio[10288]: info: Loading plugin "alsa_controller"... Nov 03 19:02:57 volumio sudo[10330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 03 19:02:57 volumio sudo[10330]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 19:02:57 volumio sudo[10330]: pam_unix(sudo:session): session closed for user root Nov 03 19:02:57 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 19:02:57 volumio volumio[10288]: info: Loading plugin "wizard"... Nov 03 19:02:57 volumio volumio[10288]: info: Loading plugin "networkfs"... Nov 03 19:02:57 volumio volumio[10288]: info: Starting Udev Watcher for removable devices Nov 03 19:02:57 volumio volumio[10288]: info: Ignoring mount for partition: boot Nov 03 19:02:57 volumio volumio[10288]: info: Ignoring mount for partition: volumio Nov 03 19:02:57 volumio volumio[10288]: info: Ignoring mount for partition: volumio_data Nov 03 19:02:57 volumio volumio[10288]: info: Mounting Device Elements Nov 03 19:02:57 volumio sudo[10344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Elements -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 03 19:02:57 volumio sudo[10344]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 19:02:57 volumio volumio-remote-updater[633]: [2025-11-03 19:02:57] [connect] Successful connection Nov 03 19:03:03 volumio ntfs-3g[10350]: Version 2017.3.23AR.3 integrated FUSE 28 Nov 03 19:03:03 volumio ntfs-3g[10350]: Mounted /dev/sda1 (Read-Write, label "Elements", NTFS 3.1) Nov 03 19:03:03 volumio ntfs-3g[10350]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 03 19:03:03 volumio ntfs-3g[10350]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Nov 03 19:03:03 volumio ntfs-3g[10350]: Global ownership and permissions enforced, configuration type 7 Nov 03 19:03:03 volumio sudo[10344]: pam_unix(sudo:session): session closed for user root Nov 03 19:03:03 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 03 19:03:03 volumio volumio[10288]: info: Loading plugin "volumio_command_line_client"... Nov 03 19:03:03 volumio volumio[10288]: info: Loading plugin "upnp"... Nov 03 19:03:03 volumio volumio[10288]: info: [1762196583619] Starting Upmpd Daemon Nov 03 19:03:03 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 03 19:03:03 volumio volumio[10288]: info: Loading plugin "my_music"... Nov 03 19:03:03 volumio volumio[10288]: info: Loading plugin "mpd"... Nov 03 19:03:03 volumio volumio[10288]: info: Loading plugin "upnp_browser"... Nov 03 19:03:04 volumio volumio[10288]: info: Loading plugin "alarm-clock"... Nov 03 19:03:04 volumio volumio[10288]: info: Loading plugin "airplay_emulation"... Nov 03 19:03:04 volumio volumio[10288]: info: Starting Shairport Sync Nov 03 19:03:04 volumio volumio[10288]: info: Loading plugin "last_100"... Nov 03 19:03:04 volumio volumio[10288]: info: Loading plugin "webradio"... Nov 03 19:03:04 volumio volumio[10288]: info: Loading plugin "i2s_dacs"... Nov 03 19:03:04 volumio volumio[10288]: info: Loading plugin "volumiodiscovery"... Nov 03 19:03:04 volumio volumio[10288]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 03 19:03:04 volumio volumio[10288]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 03 19:03:04 volumio volumio[10288]: *** WARNING *** For more information see Nov 03 19:03:04 volumio volumio[10288]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 03 19:03:04 volumio volumio[10288]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 03 19:03:04 volumio volumio[10288]: *** WARNING *** For more information see Nov 03 19:03:04 volumio node[10288]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 03 19:03:04 volumio node[10288]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 03 19:03:04 volumio node[10288]: *** WARNING *** For more information see Nov 03 19:03:04 volumio node[10288]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 03 19:03:04 volumio node[10288]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 03 19:03:04 volumio node[10288]: *** WARNING *** For more information see Nov 03 19:03:04 volumio volumio[10288]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 03 19:03:04 volumio volumio[10288]: info: Discovery: Started advertising with name: Volumio Nov 03 19:03:04 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 03 19:03:04 volumio volumio[10288]: info: Plugin bandcamp is not enabled Nov 03 19:03:04 volumio volumio[10288]: info: Loading plugin "calmradio"... Nov 03 19:03:05 volumio volumio[10288]: info: Plugin jellyfin is not enabled Nov 03 19:03:05 volumio volumio[10288]: info: Loading plugin "outputs"... Nov 03 19:03:05 volumio volumio[10288]: info: Loading plugin "albumart"... Nov 03 19:03:05 volumio volumio[10288]: info: Plugin example_plugin is not enabled Nov 03 19:03:05 volumio volumio[10288]: info: Loading plugin "inputs"... Nov 03 19:03:05 volumio volumio[10288]: info: Loading plugin "updater_comm"... Nov 03 19:03:05 volumio volumio[10288]: info: Plugin mpdemulation is not enabled Nov 03 19:03:05 volumio volumio[10288]: info: Loading plugin "rest_api"... Nov 03 19:03:05 volumio volumio[10288]: info: Loading plugin "websocket"... Nov 03 19:03:05 volumio volumio[10288]: info: Starting Socket.io Server version 2.3.0 Nov 03 19:03:05 volumio volumio[10288]: info: Loading plugin "80s80s"... Nov 03 19:03:06 volumio volumio[10288]: Forking 3 albumart workers Nov 03 19:03:06 volumio volumio[10288]: info: Applying required configuration parameters for plugin 80s80s Nov 03 19:03:06 volumio volumio[10288]: info: [1762196586201] [80s80s] API delay: 30 Nov 03 19:03:06 volumio volumio[10288]: info: Loading plugin "controradio"... Nov 03 19:03:06 volumio volumio[10288]: error: !!!! WARNING !!!! Nov 03 19:03:06 volumio volumio[10288]: error: The plugin music_service/controradio failed to load, setting it to stopped. Error: Error: Cannot find module 'fast-xml-parser' Nov 03 19:03:06 volumio volumio[10288]: Require stack: Nov 03 19:03:06 volumio volumio[10288]: - /data/plugins/music_service/controradio/index.js Nov 03 19:03:06 volumio volumio[10288]: - /volumio/app/pluginmanager.js Nov 03 19:03:06 volumio volumio[10288]: - /volumio/app/index.js Nov 03 19:03:06 volumio volumio[10288]: - /volumio/index.js Nov 03 19:03:06 volumio volumio[10288]: error: Stack trace: Error: Cannot find module 'fast-xml-parser' Nov 03 19:03:06 volumio volumio[10288]: Require stack: Nov 03 19:03:06 volumio volumio[10288]: - /data/plugins/music_service/controradio/index.js Nov 03 19:03:06 volumio volumio[10288]: - /volumio/app/pluginmanager.js Nov 03 19:03:06 volumio volumio[10288]: - /volumio/app/index.js Nov 03 19:03:06 volumio volumio[10288]: - /volumio/index.js Nov 03 19:03:06 volumio volumio[10288]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:880:15) Nov 03 19:03:06 volumio volumio[10288]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) Nov 03 19:03:06 volumio volumio[10288]: at Module.require (internal/modules/cjs/loader.js:952:19) Nov 03 19:03:06 volumio volumio[10288]: at require (internal/modules/cjs/helpers.js:88:18) Nov 03 19:03:06 volumio volumio[10288]: at Object. (/data/plugins/music_service/controradio/index.js:5:21) Nov 03 19:03:06 volumio volumio[10288]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 03 19:03:06 volumio volumio[10288]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 03 19:03:06 volumio volumio[10288]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 03 19:03:06 volumio volumio[10288]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 03 19:03:06 volumio volumio[10288]: at Module.require (internal/modules/cjs/loader.js:952:19) Nov 03 19:03:06 volumio volumio[10288]: at require (internal/modules/cjs/helpers.js:88:18) Nov 03 19:03:06 volumio volumio[10288]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Nov 03 19:03:06 volumio volumio[10288]: at /volumio/app/pluginmanager.js:338:34 Nov 03 19:03:06 volumio volumio[10288]: at Array.forEach () Nov 03 19:03:06 volumio volumio[10288]: at HashMap. (/volumio/app/pluginmanager.js:337:20) Nov 03 19:03:06 volumio volumio[10288]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Nov 03 19:03:06 volumio volumio[10288]: error: !!!! WARNING !!!! Nov 03 19:03:06 volumio volumio[10288]: info: Plugin hotelradio is not enabled Nov 03 19:03:06 volumio volumio[10288]: info: Loading plugin "motherearthradio"... Nov 03 19:03:06 volumio volumio[10288]: info: Applying required configuration parameters for plugin motherearthradio Nov 03 19:03:06 volumio volumio[10288]: info: [1762196586777] [MotherEarth] API delay: 5 Nov 03 19:03:06 volumio volumio[10288]: info: Plugin pandora is not enabled Nov 03 19:03:06 volumio volumio[10288]: info: Loading plugin "personal_radio"... Nov 03 19:03:07 volumio volumio[10288]: Starting albumart workers Nov 03 19:03:07 volumio volumio[10288]: Starting albumart workers Nov 03 19:03:07 volumio volumio[10288]: Starting albumart workers Nov 03 19:03:07 volumio volumio[10288]: info: ControllerPersonalRadio::constructor Nov 03 19:03:07 volumio volumio[10288]: info: Plugin rad357pl is not enabled Nov 03 19:03:07 volumio volumio[10288]: info: Loading plugin "radio_paradise"... Nov 03 19:03:07 volumio volumio[10288]: info: Applying required configuration parameters for plugin radio_paradise Nov 03 19:03:07 volumio volumio[10288]: info: [1762196587869] [RadioParadise] API delay: 5 Nov 03 19:03:07 volumio volumio[10288]: info: Loading plugin "remotepi"... Nov 03 19:03:08 volumio volumio[10288]: info: Applying required configuration parameters for plugin remotepi Nov 03 19:03:08 volumio volumio[10288]: info: Plugin lastfm is not enabled Nov 03 19:03:08 volumio volumio[10288]: info: Plugin randomizer is not enabled Nov 03 19:03:08 volumio volumio[10288]: info: Loading i18n strings for locale cs Nov 03 19:03:08 volumio volumio[10288]: error: remotepi: Fetching language file: Error: i18n file complementing the system language not found. Nov 03 19:03:08 volumio volumio[10288]: Updating browse sources language Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::initPlayerControls Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: Express server listening on port 3000 Nov 03 19:03:08 volumio volumio[10288]: [Metrics] WebUI: 13s 828.85ms Nov 03 19:03:08 volumio volumio[10288]: info: CoreStateMachine::resetVolumioState Nov 03 19:03:08 volumio volumio[10288]: info: CoreStateMachine::getcurrentVolume Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::volumioRetrievevolume Nov 03 19:03:08 volumio volumio[10288]: info: CoreStateMachine::pushState Nov 03 19:03:08 volumio volumio[10288]: info: CorePlayQueue::getTrack 0 Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::volumioPushState Nov 03 19:03:08 volumio volumio[10288]: info: Volumio Network Manager: Network status updated: 1 Nov 03 19:03:08 volumio volumio[10288]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Nov 03 19:03:08 volumio volumio[10288]: wlan0 Interface doesn't support scanning : Network is down Nov 03 19:03:08 volumio volumio[10288]: info: Cannot use regular scanning, forcing with ap-force Nov 03 19:03:08 volumio sudo[10426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Nov 03 19:03:08 volumio sudo[10426]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 19:03:08 volumio sudo[10426]: pam_unix(sudo:session): session closed for user root Nov 03 19:03:08 volumio volumio[10288]: command failed: Network is down (-100) Nov 03 19:03:08 volumio volumio[10288]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Nov 03 19:03:08 volumio volumio[10288]: command failed: Network is down (-100) Nov 03 19:03:08 volumio volumio[10288]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: Mozilla/5.0 (Linux; Android 13; SM-T970 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Nov 03 19:03:08 volumio volumio[10288]: verbose: New Socket.io Connection to 192.168.0.102:3000 from 192.168.0.104 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Nov 03 19:03:08 volumio volumio[10288]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: Mozilla/5.0 (Linux; Android 13; SM-T970 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Nov 03 19:03:08 volumio volumio[10288]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: Mozilla/5.0 (Linux; Android 13; SM-T970 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 03 19:03:08 volumio volumio[10288]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: Mozilla/5.0 (Linux; Android 13; SM-T970 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 03 19:03:08 volumio volumio[10288]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: Mozilla/5.0 (Linux; Android 13; SM-T970 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Nov 03 19:03:08 volumio volumio[10288]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.104 UA: Mozilla/5.0 (Linux; Android 13; SM-T970 Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 19:03:08 volumio volumio[10288]: info: Discovery: Getting this device information Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::volumioGetState Nov 03 19:03:08 volumio volumio[10288]: info: CorePlayQueue::getTrack 0 Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 19:03:08 volumio volumio[10288]: info: Reloading queue from file Nov 03 19:03:08 volumio volumio[10288]: Searching all installed plugins Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: , search Nov 03 19:03:08 volumio volumio[10288]: info: CoreCommandRouter::executeOnPlugin: mpd , search Nov 03 19:03:08 volumio volumio[10288]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 19:03:08 volumio volumio[10288]: TypeError: Cannot read property 'then' of undefined Nov 03 19:03:08 volumio volumio[10288]: at ControllerMpd.search (/volumio/app/plugins/music_service/mpd/index.js:1583:17) Nov 03 19:03:08 volumio volumio[10288]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Nov 03 19:03:08 volumio volumio[10288]: at CoreMusicLibrary.searchOnPlugin (/volumio/app/musiclibrary.js:668:44) Nov 03 19:03:08 volumio volumio[10288]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:455:27) Nov 03 19:03:08 volumio volumio[10288]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Nov 03 19:03:08 volumio volumio[10288]: at Socket.emit (events.js:315:20) Nov 03 19:03:08 volumio volumio[10288]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 03 19:03:08 volumio volumio[10288]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Nov 03 19:03:08 volumio volumio[10288]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 19:03:09 volumio sudo[10441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-03 19:02 Nov 03 19:03:09 volumio sudo[10441]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"