-- Logs begin at Mon 2024-12-16 09:35:29 CET, end at Wed 2025-01-15 09:38:58 CET. -- Jan 15 09:37:36 volumio-ddc systemd-timedated[943]: Changed local time to Wed Jan 15 09:37:36 2025 Jan 15 09:37:36 volumio-ddc sudo[940]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:36 volumio-ddc volumio-time-update[529]: volumio-time-update-util: System time updated successfully. Jan 15 09:37:36 volumio-ddc systemd[1]: Started Volumio Time Update Utility. Jan 15 09:37:36 volumio-ddc systemd[1]: Reached target Multi-User System. Jan 15 09:37:36 volumio-ddc systemd[1]: Reached target Graphical Interface. Jan 15 09:37:36 volumio-ddc systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 15 09:37:36 volumio-ddc systemd[1]: Starting Daily apt download activities... Jan 15 09:37:36 volumio-ddc systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 15 09:37:36 volumio-ddc systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 15 09:37:36 volumio-ddc volumio-remote-updater[556]: [2025-01-15 09:37:36] [info] asio async_connect error: system:111 (Connection refused) Jan 15 09:37:36 volumio-ddc volumio-remote-updater[556]: [2025-01-15 09:37:36] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 15 09:37:36 volumio-ddc volumio-remote-updater[556]: [2025-01-15 09:37:36] [error] handle_connect error: Underlying Transport Error Jan 15 09:37:39 volumio-ddc volumio[912]: info: ------------------------------------------- Jan 15 09:37:39 volumio-ddc volumio[912]: info: ----- Volumio3 ---- Jan 15 09:37:39 volumio-ddc volumio[912]: info: ------------------------------------------- Jan 15 09:37:39 volumio-ddc volumio[912]: info: ----- System startup ---- Jan 15 09:37:39 volumio-ddc volumio[912]: info: ------------------------------------------- Jan 15 09:37:40 volumio-ddc systemd[1]: systemd-fsckd.service: Succeeded. Jan 15 09:37:42 volumio-ddc systemd[1]: apt-daily.service: Succeeded. Jan 15 09:37:42 volumio-ddc systemd[1]: Started Daily apt download activities. Jan 15 09:37:42 volumio-ddc systemd[1]: Starting Daily apt upgrade and clean activities... Jan 15 09:37:42 volumio-ddc sh[438]: timed out Jan 15 09:37:42 volumio-ddc dhcpcd[487]: timed out Jan 15 09:37:43 volumio-ddc sh[438]: dhcpcd exited Jan 15 09:37:43 volumio-ddc dhcpcd[487]: dhcpcd exited Jan 15 09:37:43 volumio-ddc systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jan 15 09:37:43 volumio-ddc sh[438]: ifup: failed to bring up eth0 Jan 15 09:37:43 volumio-ddc systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jan 15 09:37:43 volumio-ddc volumio[912]: info: MYVOLUMIO Environment detected Jan 15 09:37:43 volumio-ddc volumio[912]: info: Plugin folders cleanup Jan 15 09:37:43 volumio-ddc volumio[912]: info: Scanning into folder /volumio/app/plugins/ Jan 15 09:37:43 volumio-ddc volumio[912]: info: Scanning category audio_interface Jan 15 09:37:43 volumio-ddc volumio[912]: info: Scanning category miscellanea Jan 15 09:37:43 volumio-ddc volumio[912]: info: Scanning category music_service Jan 15 09:37:43 volumio-ddc volumio[912]: info: Scanning category plugins.json Jan 15 09:37:43 volumio-ddc volumio[912]: info: Scanning category system_controller Jan 15 09:37:43 volumio-ddc volumio[912]: info: Scanning category user_interface Jan 15 09:37:43 volumio-ddc volumio[912]: info: Scanning into folder /data/plugins/ Jan 15 09:37:43 volumio-ddc volumio[912]: info: Plugin folders cleanup completed Jan 15 09:37:43 volumio-ddc volumio[912]: info: ------------------------------------------- Jan 15 09:37:43 volumio-ddc volumio[912]: info: ----- Core plugins startup ---- Jan 15 09:37:43 volumio-ddc volumio[912]: info: ------------------------------------------- Jan 15 09:37:43 volumio-ddc volumio[912]: info: Loading plugins from folder /volumio/app/plugins/ Jan 15 09:37:43 volumio-ddc volumio[912]: info: Adding plugin upnp to MyMusic Plugins Jan 15 09:37:43 volumio-ddc volumio[912]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 15 09:37:43 volumio-ddc volumio[912]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 15 09:37:43 volumio-ddc volumio[912]: info: Loading plugins from folder /data/plugins/ Jan 15 09:37:43 volumio-ddc volumio[912]: info: Loading plugin "system"... Jan 15 09:37:43 volumio-ddc volumio[912]: info: Loading plugin "appearance"... Jan 15 09:37:46 volumio-ddc volumio-remote-updater[556]: [2025-01-15 09:37:46] [connect] Successful connection Jan 15 09:37:46 volumio-ddc systemd[1]: apt-daily-upgrade.service: Succeeded. Jan 15 09:37:46 volumio-ddc systemd[1]: Started Daily apt upgrade and clean activities. Jan 15 09:37:46 volumio-ddc systemd[1]: Startup finished in 15.083s (kernel) + 42.726s (userspace) = 57.809s. Jan 15 09:37:47 volumio-ddc volumio[912]: info: Loading plugin "network"... Jan 15 09:37:47 volumio-ddc volumio[912]: info: Refreshing Cached IP Addresses Jan 15 09:37:48 volumio-ddc sudo[1068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 15 09:37:48 volumio-ddc sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:48 volumio-ddc sudo[1070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 15 09:37:48 volumio-ddc sudo[1068]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:48 volumio-ddc sudo[1070]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:48 volumio-ddc volumio[912]: info: Loading plugin "services"... Jan 15 09:37:48 volumio-ddc sudo[1070]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:48 volumio-ddc volumio[912]: info: Loading plugin "alsa_controller"... Jan 15 09:37:48 volumio-ddc sudo[1078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 15 09:37:48 volumio-ddc sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:48 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 15 09:37:48 volumio-ddc volumio[912]: info: Loading plugin "wizard"... Jan 15 09:37:48 volumio-ddc volumio[912]: info: Loading plugin "networkfs"... Jan 15 09:37:48 volumio-ddc volumio[912]: info: Starting Udev Watcher for removable devices Jan 15 09:37:48 volumio-ddc sudo[1096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.1/Samsung_M3Portable_1_9895 /mnt/NAS/MUSICA-VOLUMIO Jan 15 09:37:48 volumio-ddc sudo[1096]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:48 volumio-ddc volumio[912]: info: Ignoring mount for partition: boot Jan 15 09:37:48 volumio-ddc volumio[912]: info: Ignoring mount for partition: volumio Jan 15 09:37:48 volumio-ddc volumio[912]: info: Ignoring mount for partition: volumio_data Jan 15 09:37:48 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 15 09:37:48 volumio-ddc volumio[912]: info: Loading plugin "volumio_command_line_client"... Jan 15 09:37:48 volumio-ddc volumio[912]: info: Loading plugin "upnp"... Jan 15 09:37:48 volumio-ddc volumio[912]: info: [1736930268879] Starting Upmpd Daemon Jan 15 09:37:48 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 15 09:37:48 volumio-ddc volumio[912]: info: Loading plugin "my_music"... Jan 15 09:37:48 volumio-ddc volumio[912]: info: Loading plugin "mpd"... Jan 15 09:37:49 volumio-ddc kernel: Key type cifs.spnego registered Jan 15 09:37:49 volumio-ddc kernel: Key type cifs.idmap registered Jan 15 09:37:49 volumio-ddc kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Jan 15 09:37:49 volumio-ddc kernel: CIFS: Attempting to mount //192.168.1.1/Samsung_M3Portable_1_9895 Jan 15 09:37:50 volumio-ddc volumio[912]: info: Loading plugin "upnp_browser"... Jan 15 09:37:51 volumio-ddc volumio[912]: info: Loading plugin "alarm-clock"... Jan 15 09:37:52 volumio-ddc volumio[912]: info: Loading plugin "airplay_emulation"... Jan 15 09:37:52 volumio-ddc volumio[912]: info: Starting Shairport Sync Jan 15 09:37:52 volumio-ddc volumio[912]: info: Loading plugin "last_100"... Jan 15 09:37:52 volumio-ddc volumio[912]: info: Loading plugin "webradio"... Jan 15 09:37:52 volumio-ddc volumio[912]: info: Loading plugin "i2s_dacs"... Jan 15 09:37:52 volumio-ddc volumio[912]: info: Loading plugin "volumiodiscovery"... Jan 15 09:37:52 volumio-ddc volumio[912]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 15 09:37:52 volumio-ddc volumio[912]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 15 09:37:52 volumio-ddc volumio[912]: *** WARNING *** For more information see Jan 15 09:37:52 volumio-ddc volumio[912]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 15 09:37:52 volumio-ddc volumio[912]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 15 09:37:52 volumio-ddc volumio[912]: *** WARNING *** For more information see Jan 15 09:37:52 volumio-ddc node[912]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 15 09:37:52 volumio-ddc node[912]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 15 09:37:52 volumio-ddc node[912]: *** WARNING *** For more information see Jan 15 09:37:52 volumio-ddc node[912]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 15 09:37:52 volumio-ddc node[912]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 15 09:37:52 volumio-ddc node[912]: *** WARNING *** For more information see Jan 15 09:37:53 volumio-ddc volumio[912]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 15 09:37:53 volumio-ddc volumio[912]: info: Discovery: Started advertising with name: VOLUMIO-DDC Jan 15 09:37:53 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 15 09:37:53 volumio-ddc volumio[912]: info: Loading plugin "outputs"... Jan 15 09:37:53 volumio-ddc volumio[912]: info: Loading plugin "albumart"... Jan 15 09:37:53 volumio-ddc volumio[912]: info: Plugin example_plugin is not enabled Jan 15 09:37:53 volumio-ddc volumio[912]: info: Loading plugin "inputs"... Jan 15 09:37:53 volumio-ddc volumio[912]: info: Loading plugin "updater_comm"... Jan 15 09:37:53 volumio-ddc sudo[1078]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:53 volumio-ddc volumio[912]: info: Plugin mpdemulation is not enabled Jan 15 09:37:53 volumio-ddc volumio[912]: info: Loading plugin "rest_api"... Jan 15 09:37:54 volumio-ddc volumio[912]: info: Loading plugin "websocket"... Jan 15 09:37:54 volumio-ddc volumio[912]: info: Starting Socket.io Server version 2.3.0 Jan 15 09:37:54 volumio-ddc volumio[912]: info: Loading i18n strings for locale it Jan 15 09:37:54 volumio-ddc volumio[912]: Updating browse sources language Jan 15 09:37:54 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 15 09:37:54 volumio-ddc volumio[912]: Forking 3 albumart workers Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::initPlayerControls Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 15 09:37:55 volumio-ddc volumio[912]: Express server listening on port 3000 Jan 15 09:37:55 volumio-ddc volumio[912]: [Metrics] WebUI: 18s 105.89ms Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreStateMachine::resetVolumioState Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreStateMachine::getcurrentVolume Jan 15 09:37:55 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioRetrievevolume Jan 15 09:37:55 volumio-ddc volumio[912]: info: Volumio Network Manager: Network status updated: 2 Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 15 09:37:56 volumio-ddc volumio[912]: info: Reloading queue from file Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreStateMachine::setRepeat null single undefined Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreStateMachine::pushState Jan 15 09:37:56 volumio-ddc volumio[912]: info: CorePlayQueue::getTrack 0 Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioPushState Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreStateMachine::setRandom null Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreStateMachine::pushState Jan 15 09:37:56 volumio-ddc volumio[912]: info: CorePlayQueue::getTrack 0 Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioPushState Jan 15 09:37:56 volumio-ddc volumio[912]: info: Setting Device type: Raspberry PI Jan 15 09:37:56 volumio-ddc volumio[912]: info: VolumeController:: Volume=100 Mute =false Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreStateMachine::pushState Jan 15 09:37:56 volumio-ddc volumio[912]: info: CorePlayQueue::getTrack 0 Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioPushState Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreStateMachine::updateTrackBlock Jan 15 09:37:56 volumio-ddc volumio[912]: info: CorePlayQueue::getTrackBlock Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioRetrievevolume Jan 15 09:37:56 volumio-ddc volumio[912]: info: VolumeController:: Volume=100 Mute =false Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreStateMachine::pushState Jan 15 09:37:56 volumio-ddc volumio[912]: info: CorePlayQueue::getTrack 0 Jan 15 09:37:56 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioPushState Jan 15 09:37:57 volumio-ddc volumio[912]: Starting albumart workers Jan 15 09:37:57 volumio-ddc sudo[1182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 15 09:37:57 volumio-ddc sudo[1180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 15 09:37:57 volumio-ddc sudo[1180]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:57 volumio-ddc sudo[1182]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:57 volumio-ddc sudo[1180]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:57 volumio-ddc sudo[1182]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:57 volumio-ddc volumio[912]: Starting albumart workers Jan 15 09:37:57 volumio-ddc volumio[912]: Starting albumart workers Jan 15 09:37:57 volumio-ddc volumio[912]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetVisibleSources Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetState Jan 15 09:37:58 volumio-ddc volumio[912]: info: CorePlayQueue::getTrack 0 Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 15 09:37:58 volumio-ddc sudo[1194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 15 09:37:58 volumio-ddc sudo[1194]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:58 volumio-ddc sudo[1194]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:58 volumio-ddc sudo[1201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 15 09:37:58 volumio-ddc sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:58 volumio-ddc sudo[1201]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:58 volumio-ddc volumio[912]: verbose: New Socket.io Connection to 192.168.1.191 from 192.168.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetState Jan 15 09:37:58 volumio-ddc volumio[912]: info: CorePlayQueue::getTrack 0 Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetVisibleSources Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 15 09:37:58 volumio-ddc volumio[912]: info: Listing playlists Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 15 09:37:58 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 15 09:37:59 volumio-ddc sudo[1222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 15 09:37:59 volumio-ddc sudo[1222]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:59 volumio-ddc sudo[1222]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:59 volumio-ddc sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 15 09:37:59 volumio-ddc sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:59 volumio-ddc sudo[1224]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:59 volumio-ddc sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 15 09:37:59 volumio-ddc sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:37:59 volumio-ddc systemd[1]: Started UPnP Renderer front-end to MPD. Jan 15 09:37:59 volumio-ddc sudo[1232]: pam_unix(sudo:session): session closed for user root Jan 15 09:37:59 volumio-ddc volumio[912]: info: Upmpdcli Daemon Started Jan 15 09:37:59 volumio-ddc volumio[1238]: Generating RSA private key, 4096 bit long modulus (2 primes) Jan 15 09:38:01 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 15 09:38:01 volumio-ddc volumio[912]: info: Received Get System Info Jan 15 09:38:01 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 15 09:38:01 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 15 09:38:01 volumio-ddc volumio[912]: info: Discovery: Getting this device information Jan 15 09:38:01 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetState Jan 15 09:38:01 volumio-ddc volumio[912]: info: CorePlayQueue::getTrack 0 Jan 15 09:38:01 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 15 09:38:01 volumio-ddc volumio-remote-updater[556]: [2025-01-15 09:38:01] [connect] Successful connection Jan 15 09:38:01 volumio-ddc volumio-remote-updater[556]: [2025-01-15 09:38:01] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1736930281 101 Jan 15 09:38:01 volumio-ddc volumio[912]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Jan 15 09:38:01 volumio-ddc volumio[912]: info: Discovery: adding 089cfaca-291c-4e8d-ad4a-689c587a0883 Jan 15 09:38:01 volumio-ddc volumio[912]: info: Discovery: Found device VOLUMIO-DDC Jan 15 09:38:01 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetState Jan 15 09:38:01 volumio-ddc volumio[912]: info: CorePlayQueue::getTrack 0 Jan 15 09:38:02 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 15 09:38:02 volumio-ddc volumio[912]: info: CURURI: music-library Jan 15 09:38:02 volumio-ddc volumio[912]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Jan 15 09:38:02 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetQueue Jan 15 09:38:02 volumio-ddc volumio[912]: info: CoreStateMachine::getQueue Jan 15 09:38:02 volumio-ddc volumio[912]: info: CorePlayQueue::getQueue Jan 15 09:38:06 volumio-ddc systemd[1]: systemd-timedated.service: Succeeded. Jan 15 09:38:16 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 15 09:38:16 volumio-ddc volumio[912]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 15 09:38:16 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 15 09:38:16 volumio-ddc volumio[912]: info: Received Get System Version Jan 15 09:38:16 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 15 09:38:16 volumio-ddc volumio[912]: info: Received Get System Info Jan 15 09:38:16 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 15 09:38:16 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 15 09:38:16 volumio-ddc volumio[912]: info: Discovery: Getting this device information Jan 15 09:38:16 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetState Jan 15 09:38:16 volumio-ddc volumio[912]: info: CorePlayQueue::getTrack 0 Jan 15 09:38:16 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 15 09:38:21 volumio-ddc ntpd[657]: Soliciting pool server 217.61.62.224 Jan 15 09:38:22 volumio-ddc ntpd[657]: Soliciting pool server 79.10.113.170 Jan 15 09:38:23 volumio-ddc ntpd[657]: Soliciting pool server 89.46.74.148 Jan 15 09:38:23 volumio-ddc ntpd[657]: Soliciting pool server 212.6.50.243 Jan 15 09:38:24 volumio-ddc volumio[912]: error: Plugin system_controller networkfs failed to complete 'onVolumioStart' in a timely fashion Jan 15 09:38:24 volumio-ddc volumio[912]: info: Preparing to generate the ALSA configuration file Jan 15 09:38:24 volumio-ddc volumio[912]: info: Asound.conf file unchanged, so no further update is needed Jan 15 09:38:24 volumio-ddc volumio[912]: info: Output device has changed, restarting MPD Jan 15 09:38:24 volumio-ddc volumio[912]: info: Output device has changed, restarting Shairport Sync Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 15 09:38:24 volumio-ddc sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 15 09:38:24 volumio-ddc sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:24 volumio-ddc sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 15 09:38:24 volumio-ddc sudo[1332]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:24 volumio-ddc sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:24 volumio-ddc systemd[1]: Stopping Music Player Daemon... Jan 15 09:38:24 volumio-ddc volumio[912]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 15 09:38:24 volumio-ddc volumio[912]: info: ___________ START PLUGINS ___________ Jan 15 09:38:24 volumio-ddc volumio[912]: info: ControllerMpd::onStart: Initializing MPD Jan 15 09:38:24 volumio-ddc volumio[912]: info: Creating MPD Configuration file Jan 15 09:38:24 volumio-ddc ntpd[657]: Soliciting pool server 212.45.144.3 Jan 15 09:38:24 volumio-ddc ntpd[657]: Soliciting pool server 85.199.214.99 Jan 15 09:38:24 volumio-ddc ntpd[657]: Soliciting pool server 162.159.200.1 Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 15 09:38:24 volumio-ddc volumio[912]: info: [1736930304512] CoreMusicLibrary::Adding element Server multimediali Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 15 09:38:24 volumio-ddc sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 15 09:38:24 volumio-ddc sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:24 volumio-ddc sudo[1341]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:24 volumio-ddc sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 15 09:38:24 volumio-ddc sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 15 09:38:24 volumio-ddc volumio[912]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 15 09:38:24 volumio-ddc volumio[912]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 15 09:38:24 volumio-ddc volumio[912]: info: [1736930304935] CoreMusicLibrary::Adding element Last_100 Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 15 09:38:24 volumio-ddc volumio[912]: info: [1736930304946] CoreMusicLibrary::Adding element Webradio Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 15 09:38:24 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 15 09:38:24 volumio-ddc volumio[912]: info: Initializing BBC Radios Jan 15 09:38:25 volumio-ddc systemd[1]: mpd.service: Succeeded. Jan 15 09:38:25 volumio-ddc systemd[1]: Stopped Music Player Daemon. Jan 15 09:38:25 volumio-ddc systemd[1]: Starting Music Player Daemon... Jan 15 09:38:25 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 15 09:38:25 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 15 09:38:25 volumio-ddc volumio[912]: info: Volumio Calling Home Jan 15 09:38:25 volumio-ddc ntpd[657]: Soliciting pool server 151.22.209.90 Jan 15 09:38:25 volumio-ddc ntpd[657]: Soliciting pool server 93.94.88.50 Jan 15 09:38:25 volumio-ddc sudo[1358]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 15 09:38:25 volumio-ddc sudo[1358]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:25 volumio-ddc sudo[1358]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:25 volumio-ddc ntpd[657]: Soliciting pool server 212.45.144.206 Jan 15 09:38:25 volumio-ddc volumio[912]: info: MPD Permissions set Jan 15 09:38:25 volumio-ddc volumio[912]: info: MPD Permissions set Jan 15 09:38:25 volumio-ddc volumio[912]: info: Volumio called home Jan 15 09:38:26 volumio-ddc volumio[912]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 15 09:38:26 volumio-ddc ntpd[657]: Soliciting pool server 162.159.200.123 Jan 15 09:38:26 volumio-ddc ntpd[657]: Soliciting pool server 95.110.254.234 Jan 15 09:38:26 volumio-ddc volumio[912]: info: Starting Shairport Sync Jan 15 09:38:26 volumio-ddc volumio[912]: info: Starting Shairport Sync Jan 15 09:38:26 volumio-ddc volumio[912]: info: Starting Shairport Sync Jan 15 09:38:26 volumio-ddc sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 15 09:38:26 volumio-ddc sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:26 volumio-ddc sudo[1379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 15 09:38:26 volumio-ddc sudo[1379]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:26 volumio-ddc sudo[1381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 15 09:38:26 volumio-ddc sudo[1381]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:26 volumio-ddc systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 15 09:38:26 volumio-ddc systemd[1]: shairport-sync.service: Succeeded. Jan 15 09:38:26 volumio-ddc systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 15 09:38:26 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetState Jan 15 09:38:26 volumio-ddc volumio[912]: info: CorePlayQueue::getTrack 0 Jan 15 09:38:26 volumio-ddc systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 15 09:38:27 volumio-ddc sudo[1377]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:27 volumio-ddc sudo[1379]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:27 volumio-ddc volumio[912]: info: Shairport-Sync Started Jan 15 09:38:27 volumio-ddc volumio[912]: Error adding Membership: Error: addMembership EINVAL Jan 15 09:38:27 volumio-ddc volumio[912]: info: Shairport-Sync Started Jan 15 09:38:27 volumio-ddc systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 15 09:38:27 volumio-ddc systemd[1]: shairport-sync.service: Succeeded. Jan 15 09:38:27 volumio-ddc systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 15 09:38:27 volumio-ddc systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 15 09:38:27 volumio-ddc sudo[1381]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:27 volumio-ddc volumio[912]: info: Shairport-Sync Started Jan 15 09:38:27 volumio-ddc ntpd[657]: Soliciting pool server 37.247.53.178 Jan 15 09:38:27 volumio-ddc ntpd[657]: Soliciting pool server 2a00:dcc0:dead:a5b2::123 Jan 15 09:38:28 volumio-ddc ntpd[657]: Soliciting pool server 93.94.88.51 Jan 15 09:38:29 volumio-ddc mpd[1367]: Jan 15 09:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 15 09:38:32 volumio-ddc systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 15 09:38:32 volumio-ddc systemd[1]: mpd.service: Failed with result 'protocol'. Jan 15 09:38:32 volumio-ddc systemd[1]: Failed to start Music Player Daemon. Jan 15 09:38:32 volumio-ddc sudo[1343]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:32 volumio-ddc sudo[1334]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:32 volumio-ddc volumio[912]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Jan 15 09:38:32 volumio-ddc volumio[912]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Jan 15 09:38:32 volumio-ddc volumio[912]: See "systemctl status mpd.service" and "journalctl -xe" for details. Jan 15 09:38:32 volumio-ddc volumio[912]: info: Completed starting Core Plugins Jan 15 09:38:32 volumio-ddc volumio[912]: info: ------------------------------------------- Jan 15 09:38:32 volumio-ddc volumio[912]: info: ----- MyVolumio plugins startup ---- Jan 15 09:38:32 volumio-ddc volumio[912]: info: ------------------------------------------- Jan 15 09:38:32 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 15 09:38:32 volumio-ddc volumio[912]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Jan 15 09:38:32 volumio-ddc volumio[912]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Jan 15 09:38:32 volumio-ddc volumio[912]: See "systemctl status mpd.service" and "journalctl -xe" for details. Jan 15 09:38:32 volumio-ddc systemd[1]: Starting Music Player Daemon... Jan 15 09:38:33 volumio-ddc sudo[1409]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 15 09:38:33 volumio-ddc sudo[1409]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:33 volumio-ddc sudo[1409]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:36 volumio-ddc mpd[1411]: Jan 15 09:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetBrowseSources Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetBrowseSources Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::volumioGetBrowseSources Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 15 09:38:38 volumio-ddc volumio[912]: error: MPD error: The expression evaluated to a falsy value: Jan 15 09:38:38 volumio-ddc volumio[912]: assert.ok(self.idling) Jan 15 09:38:38 volumio-ddc volumio[912]: error: The expression evaluated to a falsy value: Jan 15 09:38:38 volumio-ddc volumio[912]: assert.ok(self.idling) Jan 15 09:38:38 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 15 09:38:40 volumio-ddc systemd[1]: Started Music Player Daemon. Jan 15 09:38:40 volumio-ddc mpd_monitor.sh[555]: MPD restarted due to no mpc output. Jan 15 09:38:40 volumio-ddc volumio[912]: error: MPD error: The expression evaluated to a falsy value: Jan 15 09:38:40 volumio-ddc volumio[912]: assert.ok(self.idling) Jan 15 09:38:40 volumio-ddc volumio[912]: error: The expression evaluated to a falsy value: Jan 15 09:38:40 volumio-ddc volumio[912]: assert.ok(self.idling) Jan 15 09:38:40 volumio-ddc volumio[912]: error: updateQueue error: null Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 15 09:38:41 volumio-ddc volumio[912]: info: Adding plugin bluetooth to MyMusic Plugins Jan 15 09:38:41 volumio-ddc volumio[912]: info: Adding plugin multiroom to MyMusic Plugins Jan 15 09:38:41 volumio-ddc volumio[912]: info: Adding plugin metavolumio to MyMusic Plugins Jan 15 09:38:41 volumio-ddc volumio[912]: info: Adding plugin cd_controller to MyMusic Plugins Jan 15 09:38:41 volumio-ddc volumio[912]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 15 09:38:41 volumio-ddc volumio[912]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 15 09:38:41 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 15 09:38:45 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 15 09:38:45 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 15 09:38:45 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 15 09:38:45 volumio-ddc volumio[912]: info: Starting MyVolumio Remote Streaming Endpoints Jan 15 09:38:45 volumio-ddc volumio[912]: info: MyVolumio not started Jan 15 09:38:45 volumio-ddc volumio[912]: info: Initializing device activation check Jan 15 09:38:45 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 15 09:38:45 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 15 09:38:49 volumio-ddc volumio[912]: info: Starting Streaming Service Transparent Proxy Jan 15 09:38:49 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 15 09:38:49 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 15 09:38:49 volumio-ddc volumio[912]: info: Streaming services startup Jan 15 09:38:49 volumio-ddc volumio[912]: info: Starting Streaming Daemon Jan 15 09:38:49 volumio-ddc sudo[1439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 15 09:38:49 volumio-ddc sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:49 volumio-ddc volumio[912]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 15 09:38:49 volumio-ddc sudo[1439]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:49 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 15 09:38:49 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jan 15 09:38:49 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 15 09:38:49 volumio-ddc volumio[912]: error: Cannot start Volumio Streaming Daemon Jan 15 09:38:49 volumio-ddc volumio[912]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 15 09:38:49 volumio-ddc volumio[912]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 15 09:38:50 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 15 09:38:50 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 15 09:38:51 volumio-ddc kernel: CIFS: VFS: \\192.168.1.1\Samsung_M3Portable_1_9895 error -2 on ioctl to get interface list Jan 15 09:38:51 volumio-ddc sudo[1096]: pam_unix(sudo:session): session closed for user root Jan 15 09:38:51 volumio-ddc volumio[912]: info: Cannot mount NAS MUSICA-VOLUMIO at system boot, trial number 1 ,retrying in 5 seconds Jan 15 09:38:52 volumio-ddc systemd[1]: Stopping Music Player Daemon... Jan 15 09:38:52 volumio-ddc volumio[912]: STREAMING PROXY: Starting server on port 3245 Jan 15 09:38:52 volumio-ddc volumio[912]: Node JS runtime: 14 Jan 15 09:38:54 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 15 09:38:56 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 15 09:38:56 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 15 09:38:56 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 15 09:38:56 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jan 15 09:38:56 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jan 15 09:38:56 volumio-ddc volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jan 15 09:38:56 volumio-ddc volumio-remote-updater[556]: No test mode Jan 15 09:38:56 volumio-ddc volumio-remote-updater[556]: No alpha test mode Jan 15 09:38:56 volumio-ddc volumio[912]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 09:38:56 volumio-ddc volumio[912]: TypeError: Cannot read property 'replace' of undefined Jan 15 09:38:56 volumio-ddc volumio[912]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Jan 15 09:38:56 volumio-ddc volumio[912]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Jan 15 09:38:56 volumio-ddc volumio[912]: at listOnTimeout (internal/timers.js:554:17) Jan 15 09:38:56 volumio-ddc volumio[912]: at processTimers (internal/timers.js:497:7) Jan 15 09:38:56 volumio-ddc volumio[912]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 09:38:58 volumio-ddc sudo[1481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-15 09:37 Jan 15 09:38:58 volumio-ddc sudo[1481]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 15 09:38:58 volumio-ddc systemd[1]: mpd.service: Succeeded. Jan 15 09:38:58 volumio-ddc systemd[1]: Stopped Music Player Daemon. 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"