-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2025-02-16 11:11:00 CET. -- Feb 16 11:10:00 volumio volumio[5496]: info: Plugin ytcr is not enabled Feb 16 11:10:00 volumio volumio[5496]: info: Loading plugin "autostart"... Feb 16 11:10:00 volumio volumio[5496]: info: Applying required configuration parameters for plugin autostart Feb 16 11:10:00 volumio volumio[5496]: info: AutoStart - onVolumioStart - read config.json Feb 16 11:10:00 volumio volumio[5496]: info: Loading plugin "gpio-buttons"... Feb 16 11:10:00 volumio volumio[5496]: info: GPIO-Buttons initialized Feb 16 11:10:00 volumio volumio[5496]: info: Plugin now_playing is not enabled Feb 16 11:10:00 volumio volumio[5496]: info: Loading plugin "outputs"... Feb 16 11:10:00 volumio volumio[5496]: info: Loading plugin "albumart"... Feb 16 11:10:00 volumio volumio[5496]: info: Plugin example_plugin is not enabled Feb 16 11:10:00 volumio volumio[5496]: info: Loading plugin "inputs"... Feb 16 11:10:00 volumio volumio[5496]: info: Loading plugin "updater_comm"... Feb 16 11:10:00 volumio volumio[5496]: info: Plugin mpdemulation is not enabled Feb 16 11:10:00 volumio volumio[5496]: info: Loading plugin "rest_api"... Feb 16 11:10:00 volumio volumio[5496]: info: Loading plugin "websocket"... Feb 16 11:10:00 volumio volumio[5496]: info: Starting Socket.io Server version 2.3.0 Feb 16 11:10:00 volumio volumio[5496]: info: Loading plugin "Systeminfo"... Feb 16 11:10:01 volumio volumio[5496]: Forking 3 albumart workers Feb 16 11:10:01 volumio volumio-remote-updater[467]: [2025-02-16 11:10:01] [connect] Successful connection Feb 16 11:10:01 volumio volumio[5496]: info: Plugin peppyspectrum is not enabled Feb 16 11:10:01 volumio volumio[5496]: info: Loading plugin "randomizer"... Feb 16 11:10:01 volumio volumio[5496]: info: Applying required configuration parameters for plugin randomizer Feb 16 11:10:01 volumio volumio[5496]: info: Plugin touch_display is not enabled Feb 16 11:10:01 volumio volumio[5496]: info: Loading i18n strings for locale fr Feb 16 11:10:01 volumio volumio[5496]: Updating browse sources language Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:01 volumio volumio[5496]: Starting albumart workers Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::initPlayerControls Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: Express server listening on port 3000 Feb 16 11:10:01 volumio volumio[5496]: [Metrics] WebUI: 4s 541.60ms Feb 16 11:10:01 volumio volumio[5496]: Starting albumart workers Feb 16 11:10:01 volumio volumio[5496]: Starting albumart workers Feb 16 11:10:01 volumio volumio[5496]: info: CoreStateMachine::resetVolumioState Feb 16 11:10:01 volumio volumio[5496]: info: CoreStateMachine::getcurrentVolume Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:01 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:01 volumio volumio[5496]: info: Volumio Network Manager: Network status updated: 0 Feb 16 11:10:01 volumio volumio[5496]: info: Cannot mount NAS TPLINK at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:01 volumio volumio-remote-updater[467]: [2025-02-16 11:10:01] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739700601 101 Feb 16 11:10:01 volumio volumio[5496]: 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: 1 Feb 16 11:10:01 volumio volumio[5496]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 16 11:10:01 volumio volumio[5496]: info: Reloading queue from file Feb 16 11:10:02 volumio volumio[5496]: info: CoreStateMachine::setRepeat null single undefined Feb 16 11:10:02 volumio volumio[5496]: info: CoreStateMachine::pushState Feb 16 11:10:02 volumio volumio[5496]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:02 volumio volumio[5496]: info: CoreStateMachine::setRandom null Feb 16 11:10:02 volumio volumio[5496]: info: CoreStateMachine::pushState Feb 16 11:10:02 volumio volumio[5496]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:02 volumio volumio[5496]: info: Setting Device type: Raspberry PI Feb 16 11:10:02 volumio volumio[5496]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 16 11:10:02 volumio volumio[5496]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Feb 16 11:10:02 volumio volumio[5496]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 16 11:10:02 volumio volumio[5496]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:02 volumio volumio[5496]: info: CoreStateMachine::pushState Feb 16 11:10:02 volumio volumio[5496]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:02 volumio volumio[5496]: info: CoreStateMachine::updateTrackBlock Feb 16 11:10:02 volumio volumio[5496]: info: CorePlayQueue::getTrackBlock Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:02 volumio volumio[5496]: info: Completed loading Core Plugins Feb 16 11:10:02 volumio volumio[5496]: info: Preparing to generate the ALSA configuration file Feb 16 11:10:02 volumio volumio[5496]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:02 volumio volumio[5496]: info: CoreStateMachine::pushState Feb 16 11:10:02 volumio volumio[5496]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:02 volumio volumio[5496]: info: Asound.conf file unchanged, so no further update is needed Feb 16 11:10:02 volumio volumio[5496]: info: Output device has changed, restarting MPD Feb 16 11:10:02 volumio sudo[5661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:02 volumio sudo[5661]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:02 volumio volumio[5496]: info: ___________ START PLUGINS ___________ Feb 16 11:10:02 volumio sudo[5661]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:02 volumio volumio[5496]: info: ControllerMpd::onStart: Initializing MPD Feb 16 11:10:02 volumio volumio[5496]: info: Creating MPD Configuration file Feb 16 11:10:02 volumio sudo[5664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:02 volumio sudo[5664]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:02 volumio systemd[1]: Stopping Music Player Daemon... Feb 16 11:10:02 volumio sudo[5667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:02 volumio sudo[5667]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:02 volumio volumio[5496]: info: [1739700602268] CoreMusicLibrary::Adding element Serveurs Média Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:02 volumio sudo[5667]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:02 volumio sudo[5670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:02 volumio sudo[5670]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:02 volumio volumio[5496]: info: [1739700602284] CoreMusicLibrary::Adding element Last_100 Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:02 volumio volumio[5496]: info: [1739700602287] CoreMusicLibrary::Adding element Webradio Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:02 volumio volumio[5496]: info: Initializing BBC Radios Feb 16 11:10:02 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:02 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:02 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:02 volumio volumio[5496]: info: [squeezelite_mc] Starting proxy server... Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:02 volumio volumio[5496]: info: [1739700602367] CoreMusicLibrary::Adding element YouTube2 Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:02 volumio volumio[5496]: Cannot find translation for source YouTube2 Feb 16 11:10:02 volumio volumio[5496]: info: AutoStart - onStart Feb 16 11:10:02 volumio volumio[5496]: info: GPIO-Buttons: Reading config and creating triggers... Feb 16 11:10:02 volumio volumio[5496]: info: GPIO-Buttons: shutdown on pin 3 Feb 16 11:10:02 volumio volumio[5496]: error: Plugin gpio-buttons failed to start! Error: EINVAL: invalid argument, write Feb 16 11:10:02 volumio kernel: export_store: invalid GPIO 3 Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:02 volumio volumio[5496]: info: [1739700602388] CoreMusicLibrary::Adding element Randomizer Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:02 volumio volumio[5496]: Cannot find translation for source YouTube2 Feb 16 11:10:02 volumio volumio[5496]: Cannot find translation for source Randomizer Feb 16 11:10:02 volumio volumio[5496]: info: Volumio Calling Home Feb 16 11:10:02 volumio sudo[5673]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 11:10:02 volumio sudo[5673]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:02 volumio sudo[5673]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:02 volumio volumio[5496]: info: [squeezelite_mc] Proxy server started on port 45113 Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:02 volumio volumio[5496]: Unhandled rejection Error: No sockets available, cannot start. Feb 16 11:10:02 volumio volumio[5496]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 16 11:10:02 volumio volumio[5496]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 16 11:10:02 volumio volumio[5496]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 16 11:10:02 volumio volumio[5496]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 16 11:10:02 volumio volumio[5496]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 16 11:10:02 volumio volumio[5496]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 16 11:10:02 volumio volumio[5496]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 16 11:10:02 volumio volumio[5496]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 16 11:10:02 volumio volumio[5496]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 16 11:10:02 volumio volumio[5496]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 16 11:10:02 volumio volumio[5496]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 16 11:10:02 volumio volumio[5496]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 16 11:10:02 volumio volumio[5496]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 16 11:10:02 volumio volumio[5496]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 16 11:10:02 volumio volumio[5496]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 16 11:10:02 volumio volumio[5496]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 16 11:10:02 volumio volumio[5496]: info: MPD Permissions set Feb 16 11:10:02 volumio volumio[5496]: info: MPD Permissions set Feb 16 11:10:02 volumio volumio[5496]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 16 11:10:02 volumio volumio[5496]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:02 volumio volumio[5496]: info: CoreStateMachine::pushState Feb 16 11:10:02 volumio volumio[5496]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:02 volumio volumio[5496]: info: [squeezelite_mc] Server discovery started Feb 16 11:10:02 volumio volumio[5496]: info: [squeezelite_mc] Player finder started Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:02 volumio volumio[5496]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 16 11:10:02 volumio volumio[5496]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:02 volumio volumio[5496]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 16 11:10:02 volumio volumio[5496]: at doSend (dgram.js:692:16) Feb 16 11:10:02 volumio volumio[5496]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 16 11:10:02 volumio volumio[5496]: at afterDns (dgram.js:638:5) Feb 16 11:10:02 volumio volumio[5496]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 16 11:10:02 volumio volumio[5496]: errno: -101, Feb 16 11:10:02 volumio volumio[5496]: code: 'ENETUNREACH', Feb 16 11:10:02 volumio volumio[5496]: syscall: 'send', Feb 16 11:10:02 volumio volumio[5496]: address: '255.255.255.255', Feb 16 11:10:02 volumio volumio[5496]: port: 3483 Feb 16 11:10:02 volumio volumio[5496]: } Feb 16 11:10:02 volumio volumio[5496]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:03 volumio sudo[5748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 11:09 Feb 16 11:10:03 volumio sudo[5748]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:03 volumio sudo[5748]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:03 volumio mpd[5688]: Feb 16 11:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 16 11:10:03 volumio volumio-remote-updater[467]: [2025-02-16 11:10:03] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 16 11:10:03 volumio volumio-remote-updater[467]: [2025-02-16 11:10:03] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 16 11:10:03 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 16 11:10:03 volumio sudo[5664]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:03 volumio sudo[5670]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:03 volumio systemd[1]: Started Music Player Daemon. Feb 16 11:10:03 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 16 11:10:03 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:03 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:03 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 16 11:10:03 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 8. Feb 16 11:10:03 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:03 volumio systemd[1]: Stopped Volumio Backend Module. Feb 16 11:10:03 volumio systemd[1]: Started Volumio Backend Module. Feb 16 11:10:03 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:04 volumio volumio[5764]: info: ------------------------------------------- Feb 16 11:10:04 volumio volumio[5764]: info: ----- Volumio3 ---- Feb 16 11:10:04 volumio volumio[5764]: info: ------------------------------------------- Feb 16 11:10:04 volumio volumio[5764]: info: ----- System startup ---- Feb 16 11:10:04 volumio volumio[5764]: info: ------------------------------------------- Feb 16 11:10:05 volumio volumio[5764]: info: MYVOLUMIO Environment detected Feb 16 11:10:05 volumio volumio[5764]: info: Plugin folders cleanup Feb 16 11:10:05 volumio volumio[5764]: info: Scanning into folder /volumio/app/plugins/ Feb 16 11:10:05 volumio volumio[5764]: info: Scanning category audio_interface Feb 16 11:10:05 volumio volumio[5764]: info: Scanning category miscellanea Feb 16 11:10:05 volumio volumio[5764]: info: Scanning category music_service Feb 16 11:10:05 volumio volumio[5764]: info: Scanning category plugins.json Feb 16 11:10:05 volumio volumio[5764]: info: Scanning category system_controller Feb 16 11:10:05 volumio volumio[5764]: info: Scanning category user_interface Feb 16 11:10:05 volumio volumio[5764]: info: Scanning into folder /data/plugins/ Feb 16 11:10:05 volumio volumio[5764]: info: Scanning category music_service Feb 16 11:10:05 volumio volumio[5764]: info: Scanning category system_controller Feb 16 11:10:05 volumio volumio[5764]: info: Scanning category system_hardware Feb 16 11:10:05 volumio volumio[5764]: info: Scanning category user_interface Feb 16 11:10:05 volumio volumio[5764]: info: Plugin folders cleanup completed Feb 16 11:10:05 volumio volumio[5764]: info: ------------------------------------------- Feb 16 11:10:05 volumio volumio[5764]: info: ----- Core plugins startup ---- Feb 16 11:10:05 volumio volumio[5764]: info: ------------------------------------------- Feb 16 11:10:05 volumio volumio[5764]: info: Loading plugins from folder /volumio/app/plugins/ Feb 16 11:10:05 volumio volumio[5764]: info: Adding plugin upnp to MyMusic Plugins Feb 16 11:10:05 volumio volumio[5764]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 16 11:10:05 volumio volumio[5764]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 16 11:10:05 volumio volumio[5764]: info: Loading plugins from folder /data/plugins/ Feb 16 11:10:05 volumio volumio[5764]: info: Loading plugin "system"... Feb 16 11:10:05 volumio volumio[5764]: info: Loading plugin "appearance"... Feb 16 11:10:05 volumio volumio[5764]: info: Loading plugin "network"... Feb 16 11:10:05 volumio volumio[5764]: info: Refreshing Cached IP Addresses Feb 16 11:10:05 volumio sudo[5790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 11:10:05 volumio sudo[5790]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:05 volumio sudo[5790]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:05 volumio sudo[5792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 11:10:05 volumio volumio[5764]: info: Loading plugin "services"... Feb 16 11:10:05 volumio sudo[5792]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:05 volumio volumio[5764]: info: Loading plugin "alsa_controller"... Feb 16 11:10:05 volumio sudo[5792]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:05 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:05 volumio volumio[5764]: info: Loading plugin "wizard"... Feb 16 11:10:05 volumio volumio[5764]: info: Loading plugin "networkfs"... Feb 16 11:10:05 volumio volumio[5764]: info: Cannot mount NAS OS at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:05 volumio volumio[5764]: info: Starting Udev Watcher for removable devices Feb 16 11:10:05 volumio sudo[5815]: 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.0.1/g/Musiques /mnt/NAS/TPLINK Feb 16 11:10:05 volumio sudo[5815]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:05 volumio sudo[5815]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:05 volumio kernel: CIFS: Attempting to mount //192.168.0.1/g/Musiques Feb 16 11:10:05 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 16 11:10:05 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 16 11:10:05 volumio volumio[5764]: info: Ignoring mount for partition: RECOVERY Feb 16 11:10:05 volumio volumio[5764]: info: Ignoring mount for partition: root64 Feb 16 11:10:05 volumio volumio[5764]: info: Ignoring mount for partition: boot Feb 16 11:10:05 volumio volumio[5764]: info: Ignoring mount for partition: volumio Feb 16 11:10:05 volumio volumio[5764]: info: Ignoring mount for partition: volumio_data Feb 16 11:10:05 volumio volumio[5764]: error: Cannot associate FS Label, not mounting Feb 16 11:10:05 volumio volumio[5764]: info: Ignoring mount for partition: SETTINGS Feb 16 11:10:05 volumio volumio[5764]: info: Ignoring mount for partition: RECALBOX Feb 16 11:10:05 volumio volumio[5764]: info: Ignoring mount for partition: SHARE Feb 16 11:10:05 volumio volumio[5764]: info: Ignoring mount for partition: OVERLAY Feb 16 11:10:05 volumio volumio[5764]: info: Ignoring mount for partition: boot64 Feb 16 11:10:05 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:05 volumio volumio[5764]: info: Loading plugin "volumio_command_line_client"... Feb 16 11:10:06 volumio volumio[5764]: info: Plugin upnp is not enabled Feb 16 11:10:06 volumio volumio[5764]: info: Loading plugin "my_music"... Feb 16 11:10:06 volumio volumio[5764]: info: Loading plugin "mpd"... Feb 16 11:10:06 volumio volumio[5764]: info: Loading plugin "upnp_browser"... Feb 16 11:10:06 volumio volumio[5764]: info: Loading plugin "alarm-clock"... Feb 16 11:10:06 volumio volumio[5764]: info: Plugin airplay_emulation is not enabled Feb 16 11:10:06 volumio volumio[5764]: info: Loading plugin "last_100"... Feb 16 11:10:06 volumio volumio[5764]: info: Loading plugin "webradio"... Feb 16 11:10:06 volumio volumio[5764]: info: Loading plugin "i2s_dacs"... Feb 16 11:10:06 volumio volumio[5764]: info: I2S DAC not set, start Auto-detection Feb 16 11:10:06 volumio volumio[5764]: info: Loading plugin "volumiodiscovery"... Feb 16 11:10:06 volumio volumio[5764]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:06 volumio volumio[5764]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:06 volumio node[5764]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:06 volumio volumio[5764]: *** WARNING *** For more information see Feb 16 11:10:06 volumio volumio[5764]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:06 volumio volumio[5764]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:06 volumio volumio[5764]: *** WARNING *** For more information see Feb 16 11:10:06 volumio node[5764]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:06 volumio node[5764]: *** WARNING *** For more information see Feb 16 11:10:06 volumio node[5764]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:06 volumio node[5764]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:06 volumio node[5764]: *** WARNING *** For more information see Feb 16 11:10:06 volumio volumio[5764]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 16 11:10:06 volumio volumio[5764]: info: Discovery: Started advertising with name: Volumio Feb 16 11:10:06 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:06 volumio volumio[5764]: info: Plugin jellyfin is not enabled Feb 16 11:10:06 volumio volumio[5764]: info: Loading plugin "squeezelite_mc"... Feb 16 11:10:07 volumio volumio[5764]: info: Loading plugin "youtube2"... Feb 16 11:10:07 volumio volumio[5764]: info: Plugin ytcr is not enabled Feb 16 11:10:07 volumio volumio[5764]: info: Loading plugin "autostart"... Feb 16 11:10:07 volumio volumio[5764]: info: Applying required configuration parameters for plugin autostart Feb 16 11:10:07 volumio volumio[5764]: info: AutoStart - onVolumioStart - read config.json Feb 16 11:10:07 volumio volumio[5764]: info: Loading plugin "gpio-buttons"... Feb 16 11:10:08 volumio volumio[5764]: info: GPIO-Buttons initialized Feb 16 11:10:08 volumio volumio[5764]: info: Plugin now_playing is not enabled Feb 16 11:10:08 volumio volumio[5764]: info: Loading plugin "outputs"... Feb 16 11:10:08 volumio volumio[5764]: info: Loading plugin "albumart"... Feb 16 11:10:08 volumio volumio[5764]: info: Plugin example_plugin is not enabled Feb 16 11:10:08 volumio volumio[5764]: info: Loading plugin "inputs"... Feb 16 11:10:08 volumio volumio[5764]: info: Loading plugin "updater_comm"... Feb 16 11:10:08 volumio volumio[5764]: info: Plugin mpdemulation is not enabled Feb 16 11:10:08 volumio volumio[5764]: info: Loading plugin "rest_api"... Feb 16 11:10:08 volumio volumio[5764]: info: Loading plugin "websocket"... Feb 16 11:10:08 volumio volumio[5764]: info: Starting Socket.io Server version 2.3.0 Feb 16 11:10:08 volumio volumio[5764]: info: Loading plugin "Systeminfo"... Feb 16 11:10:08 volumio volumio-remote-updater[467]: [2025-02-16 11:10:08] [connect] Successful connection Feb 16 11:10:08 volumio volumio[5764]: Forking 3 albumart workers Feb 16 11:10:08 volumio volumio[5764]: info: Plugin peppyspectrum is not enabled Feb 16 11:10:08 volumio volumio[5764]: info: Loading plugin "randomizer"... Feb 16 11:10:08 volumio volumio[5764]: info: Applying required configuration parameters for plugin randomizer Feb 16 11:10:08 volumio volumio[5764]: info: Plugin touch_display is not enabled Feb 16 11:10:08 volumio volumio[5764]: info: Loading i18n strings for locale fr Feb 16 11:10:08 volumio volumio[5764]: Updating browse sources language Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::initPlayerControls Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: Express server listening on port 3000 Feb 16 11:10:08 volumio volumio[5764]: [Metrics] WebUI: 4s 511.55ms Feb 16 11:10:08 volumio volumio[5764]: info: CoreStateMachine::resetVolumioState Feb 16 11:10:08 volumio volumio[5764]: info: CoreStateMachine::getcurrentVolume Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:08 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:08 volumio volumio[5764]: Starting albumart workers Feb 16 11:10:08 volumio volumio[5764]: Starting albumart workers Feb 16 11:10:08 volumio volumio[5764]: Starting albumart workers Feb 16 11:10:08 volumio volumio[5764]: info: Volumio Network Manager: Network status updated: 0 Feb 16 11:10:08 volumio volumio[5764]: info: Cannot mount NAS TPLINK at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:08 volumio volumio-remote-updater[467]: [2025-02-16 11:10:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739700608 101 Feb 16 11:10:09 volumio volumio[5764]: 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: 1 Feb 16 11:10:09 volumio volumio[5764]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 16 11:10:09 volumio volumio[5764]: info: Reloading queue from file Feb 16 11:10:09 volumio volumio[5764]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:09 volumio volumio[5764]: info: CoreStateMachine::pushState Feb 16 11:10:09 volumio volumio[5764]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:09 volumio volumio[5764]: info: CoreStateMachine::updateTrackBlock Feb 16 11:10:09 volumio volumio[5764]: info: CorePlayQueue::getTrackBlock Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:09 volumio volumio[5764]: info: CoreStateMachine::setRepeat null single undefined Feb 16 11:10:09 volumio volumio[5764]: info: CoreStateMachine::pushState Feb 16 11:10:09 volumio volumio[5764]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:09 volumio volumio[5764]: info: CoreStateMachine::setRandom null Feb 16 11:10:09 volumio volumio[5764]: info: CoreStateMachine::pushState Feb 16 11:10:09 volumio volumio[5764]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:09 volumio volumio[5764]: info: Setting Device type: Raspberry PI Feb 16 11:10:09 volumio volumio[5764]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 16 11:10:09 volumio volumio[5764]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Feb 16 11:10:09 volumio volumio[5764]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 16 11:10:09 volumio volumio[5764]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:09 volumio volumio[5764]: info: CoreStateMachine::pushState Feb 16 11:10:09 volumio volumio[5764]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:09 volumio volumio[5764]: info: Completed loading Core Plugins Feb 16 11:10:09 volumio volumio[5764]: info: Preparing to generate the ALSA configuration file Feb 16 11:10:09 volumio volumio[5764]: info: Asound.conf file unchanged, so no further update is needed Feb 16 11:10:09 volumio volumio[5764]: info: Output device has changed, restarting MPD Feb 16 11:10:09 volumio sudo[5910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:09 volumio sudo[5910]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:09 volumio sudo[5910]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:09 volumio volumio[5764]: info: ___________ START PLUGINS ___________ Feb 16 11:10:09 volumio volumio[5764]: info: ControllerMpd::onStart: Initializing MPD Feb 16 11:10:09 volumio volumio[5764]: info: Creating MPD Configuration file Feb 16 11:10:09 volumio sudo[5913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:09 volumio sudo[5913]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:09 volumio systemd[1]: Stopping Music Player Daemon... Feb 16 11:10:09 volumio sudo[5916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:09 volumio sudo[5916]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:09 volumio sudo[5916]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:09 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:09 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:09 volumio sudo[5919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:09 volumio volumio[5764]: info: [1739700609503] CoreMusicLibrary::Adding element Serveurs Média Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:09 volumio sudo[5919]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:09 volumio volumio[5764]: info: [1739700609516] CoreMusicLibrary::Adding element Last_100 Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:09 volumio volumio[5764]: info: [1739700609518] CoreMusicLibrary::Adding element Webradio Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:09 volumio volumio[5764]: info: Initializing BBC Radios Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:09 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:09 volumio volumio[5764]: info: [squeezelite_mc] Starting proxy server... Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:09 volumio volumio[5764]: info: [1739700609594] CoreMusicLibrary::Adding element YouTube2 Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:09 volumio volumio[5764]: Cannot find translation for source YouTube2 Feb 16 11:10:09 volumio volumio[5764]: info: AutoStart - onStart Feb 16 11:10:09 volumio volumio[5764]: info: GPIO-Buttons: Reading config and creating triggers... Feb 16 11:10:09 volumio volumio[5764]: info: GPIO-Buttons: shutdown on pin 3 Feb 16 11:10:09 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 16 11:10:09 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:09 volumio volumio[5764]: error: Plugin gpio-buttons failed to start! Error: EINVAL: invalid argument, write Feb 16 11:10:09 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:09 volumio kernel: export_store: invalid GPIO 3 Feb 16 11:10:09 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:09 volumio volumio[5764]: info: [1739700609618] CoreMusicLibrary::Adding element Randomizer Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:09 volumio volumio[5764]: Cannot find translation for source YouTube2 Feb 16 11:10:09 volumio volumio[5764]: Cannot find translation for source Randomizer Feb 16 11:10:09 volumio volumio[5764]: info: Volumio Calling Home Feb 16 11:10:09 volumio sudo[5932]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 11:10:09 volumio volumio[5764]: info: [squeezelite_mc] Proxy server started on port 38185 Feb 16 11:10:09 volumio sudo[5932]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:09 volumio sudo[5932]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:09 volumio volumio[5764]: Unhandled rejection Error: No sockets available, cannot start. Feb 16 11:10:09 volumio volumio[5764]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 16 11:10:09 volumio volumio[5764]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 16 11:10:09 volumio volumio[5764]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 16 11:10:09 volumio volumio[5764]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 16 11:10:09 volumio volumio[5764]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 16 11:10:09 volumio volumio[5764]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 16 11:10:09 volumio volumio[5764]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 16 11:10:09 volumio volumio[5764]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 16 11:10:09 volumio volumio[5764]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 16 11:10:09 volumio volumio[5764]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 16 11:10:09 volumio volumio[5764]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 16 11:10:09 volumio volumio[5764]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 16 11:10:09 volumio volumio[5764]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 16 11:10:09 volumio volumio[5764]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 16 11:10:09 volumio volumio[5764]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 16 11:10:09 volumio volumio[5764]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 16 11:10:09 volumio volumio[5764]: info: MPD Permissions set Feb 16 11:10:09 volumio volumio[5764]: info: MPD Permissions set Feb 16 11:10:09 volumio volumio[5764]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 16 11:10:09 volumio volumio[5764]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:09 volumio volumio[5764]: info: CoreStateMachine::pushState Feb 16 11:10:09 volumio volumio[5764]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:09 volumio volumio[5764]: info: [squeezelite_mc] Server discovery started Feb 16 11:10:09 volumio volumio[5764]: info: [squeezelite_mc] Player finder started Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:09 volumio volumio[5764]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 16 11:10:09 volumio volumio[5764]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:09 volumio volumio[5764]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 16 11:10:09 volumio volumio[5764]: at doSend (dgram.js:692:16) Feb 16 11:10:09 volumio volumio[5764]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 16 11:10:09 volumio volumio[5764]: at afterDns (dgram.js:638:5) Feb 16 11:10:09 volumio volumio[5764]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 16 11:10:09 volumio volumio[5764]: errno: -101, Feb 16 11:10:09 volumio volumio[5764]: code: 'ENETUNREACH', Feb 16 11:10:09 volumio volumio[5764]: syscall: 'send', Feb 16 11:10:09 volumio volumio[5764]: address: '255.255.255.255', Feb 16 11:10:09 volumio volumio[5764]: port: 3483 Feb 16 11:10:09 volumio volumio[5764]: } Feb 16 11:10:09 volumio volumio[5764]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:10 volumio sudo[5959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 11:09 Feb 16 11:10:10 volumio sudo[5959]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:10 volumio sudo[5959]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:10 volumio mpd[5937]: Feb 16 11:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 16 11:10:10 volumio volumio-remote-updater[467]: [2025-02-16 11:10:10] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 16 11:10:10 volumio volumio-remote-updater[467]: [2025-02-16 11:10:10] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 16 11:10:10 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 16 11:10:10 volumio sudo[5913]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:10 volumio sudo[5919]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:10 volumio systemd[1]: Started Music Player Daemon. Feb 16 11:10:10 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 16 11:10:10 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:10 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:10 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 16 11:10:10 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 9. Feb 16 11:10:10 volumio systemd[1]: Stopped Volumio Backend Module. Feb 16 11:10:10 volumio systemd[1]: Started Volumio Backend Module. Feb 16 11:10:10 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:10 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:11 volumio volumio[5974]: info: ------------------------------------------- Feb 16 11:10:11 volumio volumio[5974]: info: ----- Volumio3 ---- Feb 16 11:10:11 volumio volumio[5974]: info: ------------------------------------------- Feb 16 11:10:11 volumio volumio[5974]: info: ----- System startup ---- Feb 16 11:10:11 volumio volumio[5974]: info: ------------------------------------------- Feb 16 11:10:12 volumio volumio[5974]: info: MYVOLUMIO Environment detected Feb 16 11:10:12 volumio volumio[5974]: info: Plugin folders cleanup Feb 16 11:10:12 volumio volumio[5974]: info: Scanning into folder /volumio/app/plugins/ Feb 16 11:10:12 volumio volumio[5974]: info: Scanning category audio_interface Feb 16 11:10:12 volumio volumio[5974]: info: Scanning category miscellanea Feb 16 11:10:12 volumio volumio[5974]: info: Scanning category music_service Feb 16 11:10:12 volumio volumio[5974]: info: Scanning category plugins.json Feb 16 11:10:12 volumio volumio[5974]: info: Scanning category system_controller Feb 16 11:10:12 volumio volumio[5974]: info: Scanning category user_interface Feb 16 11:10:12 volumio volumio[5974]: info: Scanning into folder /data/plugins/ Feb 16 11:10:12 volumio volumio[5974]: info: Scanning category music_service Feb 16 11:10:12 volumio volumio[5974]: info: Scanning category system_controller Feb 16 11:10:12 volumio volumio[5974]: info: Scanning category system_hardware Feb 16 11:10:12 volumio volumio[5974]: info: Scanning category user_interface Feb 16 11:10:12 volumio volumio[5974]: info: Plugin folders cleanup completed Feb 16 11:10:12 volumio volumio[5974]: info: ------------------------------------------- Feb 16 11:10:12 volumio volumio[5974]: info: ----- Core plugins startup ---- Feb 16 11:10:12 volumio volumio[5974]: info: ------------------------------------------- Feb 16 11:10:12 volumio volumio[5974]: info: Loading plugins from folder /volumio/app/plugins/ Feb 16 11:10:12 volumio volumio[5974]: info: Adding plugin upnp to MyMusic Plugins Feb 16 11:10:12 volumio volumio[5974]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 16 11:10:12 volumio volumio[5974]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 16 11:10:12 volumio volumio[5974]: info: Loading plugins from folder /data/plugins/ Feb 16 11:10:12 volumio volumio[5974]: info: Loading plugin "system"... Feb 16 11:10:12 volumio volumio[5974]: info: Loading plugin "appearance"... Feb 16 11:10:12 volumio volumio[5974]: info: Loading plugin "network"... Feb 16 11:10:12 volumio volumio[5974]: info: Refreshing Cached IP Addresses Feb 16 11:10:12 volumio sudo[6001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 11:10:12 volumio sudo[6001]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:12 volumio sudo[6001]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:12 volumio sudo[6003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 11:10:12 volumio sudo[6003]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:12 volumio volumio[5974]: info: Loading plugin "services"... Feb 16 11:10:12 volumio volumio[5974]: info: Loading plugin "alsa_controller"... Feb 16 11:10:12 volumio sudo[6003]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:13 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "wizard"... Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "networkfs"... Feb 16 11:10:13 volumio volumio[5974]: info: Cannot mount NAS OS at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:13 volumio volumio[5974]: info: Starting Udev Watcher for removable devices Feb 16 11:10:13 volumio sudo[6026]: 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.0.1/g/Musiques /mnt/NAS/TPLINK Feb 16 11:10:13 volumio sudo[6026]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:13 volumio sudo[6026]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:13 volumio kernel: CIFS: Attempting to mount //192.168.0.1/g/Musiques Feb 16 11:10:13 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 16 11:10:13 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 16 11:10:13 volumio volumio[5974]: info: Ignoring mount for partition: RECOVERY Feb 16 11:10:13 volumio volumio[5974]: info: Ignoring mount for partition: root64 Feb 16 11:10:13 volumio volumio[5974]: info: Ignoring mount for partition: boot Feb 16 11:10:13 volumio volumio[5974]: info: Ignoring mount for partition: volumio Feb 16 11:10:13 volumio volumio[5974]: info: Ignoring mount for partition: volumio_data Feb 16 11:10:13 volumio volumio[5974]: error: Cannot associate FS Label, not mounting Feb 16 11:10:13 volumio volumio[5974]: info: Ignoring mount for partition: SETTINGS Feb 16 11:10:13 volumio volumio[5974]: info: Ignoring mount for partition: RECALBOX Feb 16 11:10:13 volumio volumio[5974]: info: Ignoring mount for partition: SHARE Feb 16 11:10:13 volumio volumio[5974]: info: Ignoring mount for partition: OVERLAY Feb 16 11:10:13 volumio volumio[5974]: info: Ignoring mount for partition: boot64 Feb 16 11:10:13 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "volumio_command_line_client"... Feb 16 11:10:13 volumio volumio[5974]: info: Plugin upnp is not enabled Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "my_music"... Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "mpd"... Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "upnp_browser"... Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "alarm-clock"... Feb 16 11:10:13 volumio volumio[5974]: info: Plugin airplay_emulation is not enabled Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "last_100"... Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "webradio"... Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "i2s_dacs"... Feb 16 11:10:13 volumio volumio[5974]: info: I2S DAC not set, start Auto-detection Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "volumiodiscovery"... Feb 16 11:10:13 volumio volumio[5974]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:13 volumio volumio[5974]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:13 volumio node[5974]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:13 volumio volumio[5974]: *** WARNING *** For more information see Feb 16 11:10:13 volumio volumio[5974]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:13 volumio volumio[5974]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:13 volumio volumio[5974]: *** WARNING *** For more information see Feb 16 11:10:13 volumio node[5974]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:13 volumio node[5974]: *** WARNING *** For more information see Feb 16 11:10:13 volumio node[5974]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:13 volumio node[5974]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:13 volumio node[5974]: *** WARNING *** For more information see Feb 16 11:10:13 volumio volumio[5974]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 16 11:10:13 volumio volumio[5974]: info: Discovery: Started advertising with name: Volumio Feb 16 11:10:13 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:13 volumio volumio[5974]: info: Plugin jellyfin is not enabled Feb 16 11:10:13 volumio volumio[5974]: info: Loading plugin "squeezelite_mc"... Feb 16 11:10:14 volumio volumio[5974]: info: Loading plugin "youtube2"... Feb 16 11:10:14 volumio volumio[5974]: info: Plugin ytcr is not enabled Feb 16 11:10:14 volumio volumio[5974]: info: Loading plugin "autostart"... Feb 16 11:10:15 volumio volumio[5974]: info: Applying required configuration parameters for plugin autostart Feb 16 11:10:15 volumio volumio[5974]: info: AutoStart - onVolumioStart - read config.json Feb 16 11:10:15 volumio volumio[5974]: info: Loading plugin "gpio-buttons"... Feb 16 11:10:15 volumio volumio[5974]: info: GPIO-Buttons initialized Feb 16 11:10:15 volumio volumio[5974]: info: Plugin now_playing is not enabled Feb 16 11:10:15 volumio volumio[5974]: info: Loading plugin "outputs"... Feb 16 11:10:15 volumio volumio[5974]: info: Loading plugin "albumart"... Feb 16 11:10:15 volumio volumio[5974]: info: Plugin example_plugin is not enabled Feb 16 11:10:15 volumio volumio[5974]: info: Loading plugin "inputs"... Feb 16 11:10:15 volumio volumio[5974]: info: Loading plugin "updater_comm"... Feb 16 11:10:15 volumio volumio[5974]: info: Plugin mpdemulation is not enabled Feb 16 11:10:15 volumio volumio[5974]: info: Loading plugin "rest_api"... Feb 16 11:10:15 volumio volumio[5974]: info: Loading plugin "websocket"... Feb 16 11:10:15 volumio volumio[5974]: info: Starting Socket.io Server version 2.3.0 Feb 16 11:10:15 volumio volumio[5974]: info: Loading plugin "Systeminfo"... Feb 16 11:10:15 volumio volumio-remote-updater[467]: [2025-02-16 11:10:15] [connect] Successful connection Feb 16 11:10:15 volumio volumio[5974]: Forking 3 albumart workers Feb 16 11:10:15 volumio volumio[5974]: info: Plugin peppyspectrum is not enabled Feb 16 11:10:15 volumio volumio[5974]: info: Loading plugin "randomizer"... Feb 16 11:10:15 volumio volumio[5974]: info: Applying required configuration parameters for plugin randomizer Feb 16 11:10:15 volumio volumio[5974]: info: Plugin touch_display is not enabled Feb 16 11:10:16 volumio volumio[5974]: info: Loading i18n strings for locale fr Feb 16 11:10:16 volumio volumio[5974]: Updating browse sources language Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:16 volumio volumio[5974]: Starting albumart workers Feb 16 11:10:16 volumio volumio[5974]: Starting albumart workers Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::initPlayerControls Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: Express server listening on port 3000 Feb 16 11:10:16 volumio volumio[5974]: [Metrics] WebUI: 4s 565.40ms Feb 16 11:10:16 volumio volumio[5974]: info: CoreStateMachine::resetVolumioState Feb 16 11:10:16 volumio volumio[5974]: info: CoreStateMachine::getcurrentVolume Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: Starting albumart workers Feb 16 11:10:16 volumio volumio[5974]: info: Volumio Network Manager: Network status updated: 0 Feb 16 11:10:16 volumio volumio[5974]: info: Cannot mount NAS TPLINK at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:16 volumio volumio-remote-updater[467]: [2025-02-16 11:10:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739700615 101 Feb 16 11:10:16 volumio volumio[5974]: 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: 1 Feb 16 11:10:16 volumio volumio[5974]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 16 11:10:16 volumio volumio[5974]: info: Reloading queue from file Feb 16 11:10:16 volumio volumio[5974]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:16 volumio volumio[5974]: info: CoreStateMachine::pushState Feb 16 11:10:16 volumio volumio[5974]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:16 volumio volumio[5974]: info: CoreStateMachine::updateTrackBlock Feb 16 11:10:16 volumio volumio[5974]: info: CorePlayQueue::getTrackBlock Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:16 volumio volumio[5974]: info: CoreStateMachine::setRepeat null single undefined Feb 16 11:10:16 volumio volumio[5974]: info: CoreStateMachine::pushState Feb 16 11:10:16 volumio volumio[5974]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:16 volumio volumio[5974]: info: CoreStateMachine::setRandom null Feb 16 11:10:16 volumio volumio[5974]: info: CoreStateMachine::pushState Feb 16 11:10:16 volumio volumio[5974]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:16 volumio volumio[5974]: info: Setting Device type: Raspberry PI Feb 16 11:10:16 volumio volumio[5974]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 16 11:10:16 volumio volumio[5974]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Feb 16 11:10:16 volumio volumio[5974]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 16 11:10:16 volumio volumio[5974]: info: Completed loading Core Plugins Feb 16 11:10:16 volumio volumio[5974]: info: Preparing to generate the ALSA configuration file Feb 16 11:10:16 volumio volumio[5974]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:16 volumio volumio[5974]: info: CoreStateMachine::pushState Feb 16 11:10:16 volumio volumio[5974]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:16 volumio volumio[5974]: info: Asound.conf file unchanged, so no further update is needed Feb 16 11:10:16 volumio volumio[5974]: info: Output device has changed, restarting MPD Feb 16 11:10:16 volumio sudo[6121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:16 volumio sudo[6121]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:16 volumio sudo[6121]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:16 volumio volumio[5974]: info: ___________ START PLUGINS ___________ Feb 16 11:10:16 volumio volumio[5974]: info: ControllerMpd::onStart: Initializing MPD Feb 16 11:10:16 volumio volumio[5974]: info: Creating MPD Configuration file Feb 16 11:10:16 volumio sudo[6124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:16 volumio sudo[6124]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:16 volumio systemd[1]: Stopping Music Player Daemon... Feb 16 11:10:16 volumio sudo[6127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:16 volumio sudo[6127]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:16 volumio sudo[6127]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:16 volumio volumio[5974]: info: [1739700616769] CoreMusicLibrary::Adding element Serveurs Média Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:16 volumio sudo[6129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:16 volumio sudo[6129]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:16 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:16 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:16 volumio volumio[5974]: info: [1739700616785] CoreMusicLibrary::Adding element Last_100 Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:16 volumio volumio[5974]: info: [1739700616786] CoreMusicLibrary::Adding element Webradio Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:16 volumio volumio[5974]: info: Initializing BBC Radios Feb 16 11:10:16 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:16 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 16 11:10:16 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:16 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:16 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:16 volumio volumio[5974]: info: [squeezelite_mc] Starting proxy server... Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:16 volumio volumio[5974]: info: [1739700616869] CoreMusicLibrary::Adding element YouTube2 Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:16 volumio volumio[5974]: Cannot find translation for source YouTube2 Feb 16 11:10:16 volumio volumio[5974]: info: AutoStart - onStart Feb 16 11:10:16 volumio volumio[5974]: info: GPIO-Buttons: Reading config and creating triggers... Feb 16 11:10:16 volumio volumio[5974]: info: GPIO-Buttons: shutdown on pin 3 Feb 16 11:10:16 volumio volumio[5974]: error: Plugin gpio-buttons failed to start! Error: EINVAL: invalid argument, write Feb 16 11:10:16 volumio kernel: export_store: invalid GPIO 3 Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:16 volumio volumio[5974]: info: [1739700616891] CoreMusicLibrary::Adding element Randomizer Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:16 volumio volumio[5974]: Cannot find translation for source YouTube2 Feb 16 11:10:16 volumio volumio[5974]: Cannot find translation for source Randomizer Feb 16 11:10:16 volumio volumio[5974]: info: Volumio Calling Home Feb 16 11:10:16 volumio sudo[6140]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 11:10:16 volumio sudo[6140]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:16 volumio sudo[6140]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:16 volumio volumio[5974]: info: [squeezelite_mc] Proxy server started on port 33683 Feb 16 11:10:16 volumio volumio[5974]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:17 volumio volumio[5974]: Unhandled rejection Error: No sockets available, cannot start. Feb 16 11:10:17 volumio volumio[5974]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 16 11:10:17 volumio volumio[5974]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 16 11:10:17 volumio volumio[5974]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 16 11:10:17 volumio volumio[5974]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 16 11:10:17 volumio volumio[5974]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 16 11:10:17 volumio volumio[5974]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 16 11:10:17 volumio volumio[5974]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 16 11:10:17 volumio volumio[5974]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 16 11:10:17 volumio volumio[5974]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 16 11:10:17 volumio volumio[5974]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 16 11:10:17 volumio volumio[5974]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 16 11:10:17 volumio volumio[5974]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 16 11:10:17 volumio volumio[5974]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 16 11:10:17 volumio volumio[5974]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 16 11:10:17 volumio volumio[5974]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 16 11:10:17 volumio volumio[5974]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 16 11:10:17 volumio volumio[5974]: info: MPD Permissions set Feb 16 11:10:17 volumio volumio[5974]: info: MPD Permissions set Feb 16 11:10:17 volumio volumio[5974]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 16 11:10:17 volumio volumio[5974]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:17 volumio volumio[5974]: info: CoreStateMachine::pushState Feb 16 11:10:17 volumio volumio[5974]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:17 volumio volumio[5974]: info: [squeezelite_mc] Server discovery started Feb 16 11:10:17 volumio volumio[5974]: info: [squeezelite_mc] Player finder started Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:17 volumio volumio[5974]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 16 11:10:17 volumio volumio[5974]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:17 volumio volumio[5974]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 16 11:10:17 volumio volumio[5974]: at doSend (dgram.js:692:16) Feb 16 11:10:17 volumio volumio[5974]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 16 11:10:17 volumio volumio[5974]: at afterDns (dgram.js:638:5) Feb 16 11:10:17 volumio volumio[5974]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 16 11:10:17 volumio volumio[5974]: errno: -101, Feb 16 11:10:17 volumio volumio[5974]: code: 'ENETUNREACH', Feb 16 11:10:17 volumio volumio[5974]: syscall: 'send', Feb 16 11:10:17 volumio volumio[5974]: address: '255.255.255.255', Feb 16 11:10:17 volumio volumio[5974]: port: 3483 Feb 16 11:10:17 volumio volumio[5974]: } Feb 16 11:10:17 volumio volumio[5974]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:17 volumio sudo[6170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 11:09 Feb 16 11:10:17 volumio sudo[6170]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:17 volumio mpd[6147]: Feb 16 11:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 16 11:10:17 volumio sudo[6170]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:17 volumio systemd[1]: Started Music Player Daemon. Feb 16 11:10:17 volumio sudo[6124]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:17 volumio sudo[6129]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:17 volumio volumio-remote-updater[467]: [2025-02-16 11:10:17] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 16 11:10:17 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 16 11:10:17 volumio volumio-remote-updater[467]: [2025-02-16 11:10:17] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 16 11:10:17 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 16 11:10:17 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:17 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:17 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 16 11:10:17 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 10. Feb 16 11:10:17 volumio systemd[1]: Stopped Volumio Backend Module. Feb 16 11:10:17 volumio systemd[1]: Started Volumio Backend Module. Feb 16 11:10:17 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:17 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:18 volumio dhcpcd[5248]: timed out Feb 16 11:10:18 volumio ifplugd(eth0)[649]: client: timed out Feb 16 11:10:18 volumio dhcpcd[5248]: dhcpcd exited Feb 16 11:10:18 volumio ifplugd(eth0)[649]: client: dhcpcd exited Feb 16 11:10:18 volumio ifplugd(eth0)[649]: client: ifup: failed to bring up eth0 Feb 16 11:10:18 volumio ifplugd(eth0)[649]: client: run-parts: /etc/ifplugd/action.d//ifupdown exited with return code 1 Feb 16 11:10:18 volumio ifplugd(eth0)[649]: Program execution failed, return value is 1. Feb 16 11:10:18 volumio ifplugd(eth0)[649]: Link beat lost. Feb 16 11:10:18 volumio volumio[6185]: info: ------------------------------------------- Feb 16 11:10:18 volumio volumio[6185]: info: ----- Volumio3 ---- Feb 16 11:10:18 volumio volumio[6185]: info: ------------------------------------------- Feb 16 11:10:18 volumio volumio[6185]: info: ----- System startup ---- Feb 16 11:10:18 volumio volumio[6185]: info: ------------------------------------------- Feb 16 11:10:19 volumio volumio[6185]: info: MYVOLUMIO Environment detected Feb 16 11:10:19 volumio volumio[6185]: info: Plugin folders cleanup Feb 16 11:10:19 volumio volumio[6185]: info: Scanning into folder /volumio/app/plugins/ Feb 16 11:10:19 volumio volumio[6185]: info: Scanning category audio_interface Feb 16 11:10:19 volumio volumio[6185]: info: Scanning category miscellanea Feb 16 11:10:19 volumio volumio[6185]: info: Scanning category music_service Feb 16 11:10:19 volumio volumio[6185]: info: Scanning category plugins.json Feb 16 11:10:19 volumio volumio[6185]: info: Scanning category system_controller Feb 16 11:10:19 volumio volumio[6185]: info: Scanning category user_interface Feb 16 11:10:19 volumio volumio[6185]: info: Scanning into folder /data/plugins/ Feb 16 11:10:19 volumio volumio[6185]: info: Scanning category music_service Feb 16 11:10:19 volumio volumio[6185]: info: Scanning category system_controller Feb 16 11:10:19 volumio volumio[6185]: info: Scanning category system_hardware Feb 16 11:10:19 volumio volumio[6185]: info: Scanning category user_interface Feb 16 11:10:19 volumio volumio[6185]: info: Plugin folders cleanup completed Feb 16 11:10:19 volumio volumio[6185]: info: ------------------------------------------- Feb 16 11:10:19 volumio volumio[6185]: info: ----- Core plugins startup ---- Feb 16 11:10:19 volumio volumio[6185]: info: ------------------------------------------- Feb 16 11:10:19 volumio volumio[6185]: info: Loading plugins from folder /volumio/app/plugins/ Feb 16 11:10:19 volumio volumio[6185]: info: Adding plugin upnp to MyMusic Plugins Feb 16 11:10:19 volumio volumio[6185]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 16 11:10:19 volumio volumio[6185]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 16 11:10:19 volumio volumio[6185]: info: Loading plugins from folder /data/plugins/ Feb 16 11:10:19 volumio volumio[6185]: info: Loading plugin "system"... Feb 16 11:10:19 volumio volumio[6185]: info: Loading plugin "appearance"... Feb 16 11:10:19 volumio volumio[6185]: info: Loading plugin "network"... Feb 16 11:10:19 volumio volumio[6185]: info: Refreshing Cached IP Addresses Feb 16 11:10:19 volumio sudo[6213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 11:10:19 volumio sudo[6213]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:19 volumio sudo[6213]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:19 volumio sudo[6215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 11:10:19 volumio volumio[6185]: info: Loading plugin "services"... Feb 16 11:10:19 volumio sudo[6215]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:19 volumio volumio[6185]: info: Loading plugin "alsa_controller"... Feb 16 11:10:19 volumio sudo[6215]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:20 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "wizard"... Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "networkfs"... Feb 16 11:10:20 volumio volumio[6185]: info: Cannot mount NAS OS at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:20 volumio volumio[6185]: info: Starting Udev Watcher for removable devices Feb 16 11:10:20 volumio sudo[6238]: 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.0.1/g/Musiques /mnt/NAS/TPLINK Feb 16 11:10:20 volumio sudo[6238]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:20 volumio kernel: CIFS: Attempting to mount //192.168.0.1/g/Musiques Feb 16 11:10:20 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 16 11:10:20 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 16 11:10:20 volumio sudo[6238]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:20 volumio volumio[6185]: info: Ignoring mount for partition: RECOVERY Feb 16 11:10:20 volumio volumio[6185]: info: Ignoring mount for partition: root64 Feb 16 11:10:20 volumio volumio[6185]: info: Ignoring mount for partition: boot Feb 16 11:10:20 volumio volumio[6185]: info: Ignoring mount for partition: volumio Feb 16 11:10:20 volumio volumio[6185]: info: Ignoring mount for partition: volumio_data Feb 16 11:10:20 volumio volumio[6185]: error: Cannot associate FS Label, not mounting Feb 16 11:10:20 volumio volumio[6185]: info: Ignoring mount for partition: SETTINGS Feb 16 11:10:20 volumio volumio[6185]: info: Ignoring mount for partition: RECALBOX Feb 16 11:10:20 volumio volumio[6185]: info: Ignoring mount for partition: SHARE Feb 16 11:10:20 volumio volumio[6185]: info: Ignoring mount for partition: OVERLAY Feb 16 11:10:20 volumio volumio[6185]: info: Ignoring mount for partition: boot64 Feb 16 11:10:20 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "volumio_command_line_client"... Feb 16 11:10:20 volumio volumio[6185]: info: Plugin upnp is not enabled Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "my_music"... Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "mpd"... Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "upnp_browser"... Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "alarm-clock"... Feb 16 11:10:20 volumio volumio[6185]: info: Plugin airplay_emulation is not enabled Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "last_100"... Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "webradio"... Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "i2s_dacs"... Feb 16 11:10:20 volumio volumio[6185]: info: I2S DAC not set, start Auto-detection Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "volumiodiscovery"... Feb 16 11:10:20 volumio volumio[6185]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:20 volumio volumio[6185]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:20 volumio node[6185]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:20 volumio volumio[6185]: *** WARNING *** For more information see Feb 16 11:10:20 volumio volumio[6185]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:20 volumio volumio[6185]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:20 volumio volumio[6185]: *** WARNING *** For more information see Feb 16 11:10:20 volumio node[6185]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:20 volumio node[6185]: *** WARNING *** For more information see Feb 16 11:10:20 volumio node[6185]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:20 volumio node[6185]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:20 volumio node[6185]: *** WARNING *** For more information see Feb 16 11:10:20 volumio volumio[6185]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 16 11:10:20 volumio volumio[6185]: info: Discovery: Started advertising with name: Volumio Feb 16 11:10:20 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:20 volumio volumio[6185]: info: Plugin jellyfin is not enabled Feb 16 11:10:20 volumio volumio[6185]: info: Loading plugin "squeezelite_mc"... Feb 16 11:10:21 volumio volumio[6185]: info: Loading plugin "youtube2"... Feb 16 11:10:21 volumio volumio[6185]: info: Plugin ytcr is not enabled Feb 16 11:10:21 volumio volumio[6185]: info: Loading plugin "autostart"... Feb 16 11:10:22 volumio volumio[6185]: info: Applying required configuration parameters for plugin autostart Feb 16 11:10:22 volumio volumio[6185]: info: AutoStart - onVolumioStart - read config.json Feb 16 11:10:22 volumio volumio[6185]: info: Loading plugin "gpio-buttons"... Feb 16 11:10:22 volumio volumio[6185]: info: GPIO-Buttons initialized Feb 16 11:10:22 volumio volumio[6185]: info: Plugin now_playing is not enabled Feb 16 11:10:22 volumio volumio[6185]: info: Loading plugin "outputs"... Feb 16 11:10:22 volumio volumio[6185]: info: Loading plugin "albumart"... Feb 16 11:10:22 volumio volumio[6185]: info: Plugin example_plugin is not enabled Feb 16 11:10:22 volumio volumio[6185]: info: Loading plugin "inputs"... Feb 16 11:10:22 volumio volumio[6185]: info: Loading plugin "updater_comm"... Feb 16 11:10:22 volumio volumio[6185]: info: Plugin mpdemulation is not enabled Feb 16 11:10:22 volumio volumio[6185]: info: Loading plugin "rest_api"... Feb 16 11:10:22 volumio volumio[6185]: info: Loading plugin "websocket"... Feb 16 11:10:22 volumio volumio[6185]: info: Starting Socket.io Server version 2.3.0 Feb 16 11:10:22 volumio volumio[6185]: info: Loading plugin "Systeminfo"... Feb 16 11:10:22 volumio volumio[6185]: Forking 3 albumart workers Feb 16 11:10:22 volumio volumio[6185]: info: Plugin peppyspectrum is not enabled Feb 16 11:10:22 volumio volumio[6185]: info: Loading plugin "randomizer"... Feb 16 11:10:22 volumio ntpd[4315]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Feb 16 11:10:22 volumio volumio-remote-updater[467]: [2025-02-16 11:10:22] [connect] Successful connection Feb 16 11:10:22 volumio volumio[6185]: info: Applying required configuration parameters for plugin randomizer Feb 16 11:10:22 volumio volumio[6185]: info: Plugin touch_display is not enabled Feb 16 11:10:23 volumio volumio[6185]: info: Loading i18n strings for locale fr Feb 16 11:10:23 volumio volumio[6185]: Updating browse sources language Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:23 volumio volumio[6185]: Starting albumart workers Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::initPlayerControls Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:23 volumio volumio[6185]: Starting albumart workers Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:23 volumio volumio[6185]: Express server listening on port 3000 Feb 16 11:10:23 volumio volumio[6185]: [Metrics] WebUI: 4s 579.88ms Feb 16 11:10:23 volumio volumio[6185]: Starting albumart workers Feb 16 11:10:23 volumio volumio[6185]: info: CoreStateMachine::resetVolumioState Feb 16 11:10:23 volumio volumio[6185]: info: CoreStateMachine::getcurrentVolume Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:23 volumio volumio[6185]: info: Volumio Network Manager: Network status updated: 0 Feb 16 11:10:23 volumio volumio[6185]: info: Cannot mount NAS TPLINK at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:23 volumio volumio-remote-updater[467]: [2025-02-16 11:10:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739700622 101 Feb 16 11:10:23 volumio volumio[6185]: 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: 1 Feb 16 11:10:23 volumio volumio[6185]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 16 11:10:23 volumio volumio[6185]: info: Reloading queue from file Feb 16 11:10:23 volumio volumio[6185]: info: CoreStateMachine::setRepeat null single undefined Feb 16 11:10:23 volumio volumio[6185]: info: CoreStateMachine::pushState Feb 16 11:10:23 volumio volumio[6185]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:23 volumio volumio[6185]: info: CoreStateMachine::setRandom null Feb 16 11:10:23 volumio volumio[6185]: info: CoreStateMachine::pushState Feb 16 11:10:23 volumio volumio[6185]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:23 volumio volumio[6185]: info: Setting Device type: Raspberry PI Feb 16 11:10:23 volumio volumio[6185]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:23 volumio volumio[6185]: info: CoreStateMachine::pushState Feb 16 11:10:23 volumio volumio[6185]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:23 volumio volumio[6185]: info: CoreStateMachine::updateTrackBlock Feb 16 11:10:23 volumio volumio[6185]: info: CorePlayQueue::getTrackBlock Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:23 volumio volumio[6185]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 16 11:10:23 volumio volumio[6185]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Feb 16 11:10:23 volumio volumio[6185]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 16 11:10:23 volumio volumio[6185]: info: Completed loading Core Plugins Feb 16 11:10:23 volumio volumio[6185]: info: Preparing to generate the ALSA configuration file Feb 16 11:10:23 volumio volumio[6185]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:23 volumio volumio[6185]: info: CoreStateMachine::pushState Feb 16 11:10:23 volumio volumio[6185]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:23 volumio volumio[6185]: info: Asound.conf file unchanged, so no further update is needed Feb 16 11:10:23 volumio volumio[6185]: info: Output device has changed, restarting MPD Feb 16 11:10:23 volumio sudo[6330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:23 volumio sudo[6330]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:23 volumio sudo[6330]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:23 volumio volumio[6185]: info: ___________ START PLUGINS ___________ Feb 16 11:10:23 volumio volumio[6185]: info: ControllerMpd::onStart: Initializing MPD Feb 16 11:10:23 volumio volumio[6185]: info: Creating MPD Configuration file Feb 16 11:10:23 volumio sudo[6333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:23 volumio sudo[6333]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:23 volumio ntpd[4315]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Feb 16 11:10:23 volumio systemd[1]: Stopping Music Player Daemon... Feb 16 11:10:23 volumio sudo[6336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:23 volumio sudo[6336]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:23 volumio volumio[6185]: info: [1739700623774] CoreMusicLibrary::Adding element Serveurs Média Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:23 volumio sudo[6336]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:23 volumio sudo[6339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:23 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:23 volumio sudo[6339]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:23 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:23 volumio volumio[6185]: info: [1739700623790] CoreMusicLibrary::Adding element Last_100 Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:23 volumio volumio[6185]: info: [1739700623792] CoreMusicLibrary::Adding element Webradio Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:23 volumio volumio[6185]: info: Initializing BBC Radios Feb 16 11:10:23 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:23 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 16 11:10:23 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:23 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:23 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:23 volumio volumio[6185]: info: [squeezelite_mc] Starting proxy server... Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:23 volumio volumio[6185]: info: [1739700623886] CoreMusicLibrary::Adding element YouTube2 Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:23 volumio volumio[6185]: Cannot find translation for source YouTube2 Feb 16 11:10:23 volumio volumio[6185]: info: AutoStart - onStart Feb 16 11:10:23 volumio volumio[6185]: info: GPIO-Buttons: Reading config and creating triggers... Feb 16 11:10:23 volumio volumio[6185]: info: GPIO-Buttons: shutdown on pin 3 Feb 16 11:10:23 volumio volumio[6185]: error: Plugin gpio-buttons failed to start! Error: EINVAL: invalid argument, write Feb 16 11:10:23 volumio kernel: export_store: invalid GPIO 3 Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:23 volumio sudo[6348]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 11:10:23 volumio sudo[6348]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:23 volumio volumio[6185]: info: [1739700623910] CoreMusicLibrary::Adding element Randomizer Feb 16 11:10:23 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:23 volumio volumio[6185]: Cannot find translation for source YouTube2 Feb 16 11:10:23 volumio volumio[6185]: Cannot find translation for source Randomizer Feb 16 11:10:23 volumio volumio[6185]: info: Volumio Calling Home Feb 16 11:10:23 volumio sudo[6348]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:23 volumio volumio[6185]: info: [squeezelite_mc] Proxy server started on port 34313 Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:24 volumio volumio[6185]: Unhandled rejection Error: No sockets available, cannot start. Feb 16 11:10:24 volumio volumio[6185]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 16 11:10:24 volumio volumio[6185]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 16 11:10:24 volumio volumio[6185]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 16 11:10:24 volumio volumio[6185]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 16 11:10:24 volumio volumio[6185]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 16 11:10:24 volumio volumio[6185]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 16 11:10:24 volumio volumio[6185]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 16 11:10:24 volumio volumio[6185]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 16 11:10:24 volumio volumio[6185]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 16 11:10:24 volumio volumio[6185]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 16 11:10:24 volumio volumio[6185]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 16 11:10:24 volumio volumio[6185]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 16 11:10:24 volumio volumio[6185]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 16 11:10:24 volumio volumio[6185]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 16 11:10:24 volumio volumio[6185]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 16 11:10:24 volumio volumio[6185]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 16 11:10:24 volumio volumio[6185]: info: MPD Permissions set Feb 16 11:10:24 volumio volumio[6185]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 16 11:10:24 volumio volumio[6185]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:24 volumio volumio[6185]: info: CoreStateMachine::pushState Feb 16 11:10:24 volumio volumio[6185]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:24 volumio volumio[6185]: info: [squeezelite_mc] Server discovery started Feb 16 11:10:24 volumio volumio[6185]: info: [squeezelite_mc] Player finder started Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:24 volumio volumio[6185]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 16 11:10:24 volumio volumio[6185]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:24 volumio volumio[6185]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 16 11:10:24 volumio volumio[6185]: at doSend (dgram.js:692:16) Feb 16 11:10:24 volumio volumio[6185]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 16 11:10:24 volumio volumio[6185]: at afterDns (dgram.js:638:5) Feb 16 11:10:24 volumio volumio[6185]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 16 11:10:24 volumio volumio[6185]: errno: -101, Feb 16 11:10:24 volumio volumio[6185]: code: 'ENETUNREACH', Feb 16 11:10:24 volumio volumio[6185]: syscall: 'send', Feb 16 11:10:24 volumio volumio[6185]: address: '255.255.255.255', Feb 16 11:10:24 volumio volumio[6185]: port: 3483 Feb 16 11:10:24 volumio volumio[6185]: } Feb 16 11:10:24 volumio volumio[6185]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:24 volumio sudo[6379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 11:09 Feb 16 11:10:24 volumio sudo[6379]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:24 volumio mpd[6354]: Feb 16 11:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 16 11:10:24 volumio sudo[6379]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:24 volumio systemd[1]: Started Music Player Daemon. Feb 16 11:10:24 volumio sudo[6339]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:24 volumio sudo[6333]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:24 volumio volumio-remote-updater[467]: [2025-02-16 11:10:24] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 16 11:10:24 volumio volumio-remote-updater[467]: [2025-02-16 11:10:24] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 16 11:10:24 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 16 11:10:24 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 16 11:10:24 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:24 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:24 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 16 11:10:24 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 11. Feb 16 11:10:24 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:24 volumio systemd[1]: Stopped Volumio Backend Module. Feb 16 11:10:24 volumio systemd[1]: Started Volumio Backend Module. Feb 16 11:10:24 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:25 volumio ntpd[4315]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Feb 16 11:10:25 volumio ntpd[4315]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Feb 16 11:10:25 volumio volumio[6395]: info: ------------------------------------------- Feb 16 11:10:25 volumio volumio[6395]: info: ----- Volumio3 ---- Feb 16 11:10:25 volumio volumio[6395]: info: ------------------------------------------- Feb 16 11:10:25 volumio volumio[6395]: info: ----- System startup ---- Feb 16 11:10:25 volumio volumio[6395]: info: ------------------------------------------- Feb 16 11:10:26 volumio volumio[6395]: info: MYVOLUMIO Environment detected Feb 16 11:10:26 volumio volumio[6395]: info: Plugin folders cleanup Feb 16 11:10:26 volumio volumio[6395]: info: Scanning into folder /volumio/app/plugins/ Feb 16 11:10:26 volumio volumio[6395]: info: Scanning category audio_interface Feb 16 11:10:26 volumio volumio[6395]: info: Scanning category miscellanea Feb 16 11:10:26 volumio volumio[6395]: info: Scanning category music_service Feb 16 11:10:26 volumio volumio[6395]: info: Scanning category plugins.json Feb 16 11:10:26 volumio volumio[6395]: info: Scanning category system_controller Feb 16 11:10:26 volumio volumio[6395]: info: Scanning category user_interface Feb 16 11:10:26 volumio volumio[6395]: info: Scanning into folder /data/plugins/ Feb 16 11:10:26 volumio volumio[6395]: info: Scanning category music_service Feb 16 11:10:26 volumio volumio[6395]: info: Scanning category system_controller Feb 16 11:10:26 volumio volumio[6395]: info: Scanning category system_hardware Feb 16 11:10:26 volumio volumio[6395]: info: Scanning category user_interface Feb 16 11:10:26 volumio volumio[6395]: info: Plugin folders cleanup completed Feb 16 11:10:26 volumio volumio[6395]: info: ------------------------------------------- Feb 16 11:10:26 volumio volumio[6395]: info: ----- Core plugins startup ---- Feb 16 11:10:26 volumio volumio[6395]: info: ------------------------------------------- Feb 16 11:10:26 volumio volumio[6395]: info: Loading plugins from folder /volumio/app/plugins/ Feb 16 11:10:26 volumio volumio[6395]: info: Adding plugin upnp to MyMusic Plugins Feb 16 11:10:26 volumio volumio[6395]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 16 11:10:26 volumio volumio[6395]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 16 11:10:26 volumio volumio[6395]: info: Loading plugins from folder /data/plugins/ Feb 16 11:10:26 volumio volumio[6395]: info: Loading plugin "system"... Feb 16 11:10:26 volumio volumio[6395]: info: Loading plugin "appearance"... Feb 16 11:10:26 volumio volumio[6395]: info: Loading plugin "network"... Feb 16 11:10:26 volumio volumio[6395]: info: Refreshing Cached IP Addresses Feb 16 11:10:26 volumio sudo[6424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 11:10:26 volumio sudo[6424]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:26 volumio sudo[6424]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:26 volumio sudo[6426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 11:10:26 volumio volumio[6395]: info: Loading plugin "services"... Feb 16 11:10:26 volumio sudo[6426]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:26 volumio volumio[6395]: info: Loading plugin "alsa_controller"... Feb 16 11:10:26 volumio sudo[6426]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:27 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "wizard"... Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "networkfs"... Feb 16 11:10:27 volumio volumio[6395]: info: Cannot mount NAS OS at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:27 volumio volumio[6395]: info: Starting Udev Watcher for removable devices Feb 16 11:10:27 volumio sudo[6449]: 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.0.1/g/Musiques /mnt/NAS/TPLINK Feb 16 11:10:27 volumio sudo[6449]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:27 volumio kernel: CIFS: Attempting to mount //192.168.0.1/g/Musiques Feb 16 11:10:27 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 16 11:10:27 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 16 11:10:27 volumio sudo[6449]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:27 volumio volumio[6395]: info: Ignoring mount for partition: RECOVERY Feb 16 11:10:27 volumio volumio[6395]: info: Ignoring mount for partition: root64 Feb 16 11:10:27 volumio volumio[6395]: info: Ignoring mount for partition: boot Feb 16 11:10:27 volumio volumio[6395]: info: Ignoring mount for partition: volumio Feb 16 11:10:27 volumio volumio[6395]: info: Ignoring mount for partition: volumio_data Feb 16 11:10:27 volumio volumio[6395]: error: Cannot associate FS Label, not mounting Feb 16 11:10:27 volumio volumio[6395]: info: Ignoring mount for partition: SETTINGS Feb 16 11:10:27 volumio volumio[6395]: info: Ignoring mount for partition: RECALBOX Feb 16 11:10:27 volumio volumio[6395]: info: Ignoring mount for partition: SHARE Feb 16 11:10:27 volumio volumio[6395]: info: Ignoring mount for partition: OVERLAY Feb 16 11:10:27 volumio volumio[6395]: info: Ignoring mount for partition: boot64 Feb 16 11:10:27 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "volumio_command_line_client"... Feb 16 11:10:27 volumio volumio[6395]: info: Plugin upnp is not enabled Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "my_music"... Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "mpd"... Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "upnp_browser"... Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "alarm-clock"... Feb 16 11:10:27 volumio volumio[6395]: info: Plugin airplay_emulation is not enabled Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "last_100"... Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "webradio"... Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "i2s_dacs"... Feb 16 11:10:27 volumio volumio[6395]: info: I2S DAC not set, start Auto-detection Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "volumiodiscovery"... Feb 16 11:10:27 volumio volumio[6395]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:27 volumio node[6395]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:27 volumio node[6395]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:27 volumio volumio[6395]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:27 volumio volumio[6395]: *** WARNING *** For more information see Feb 16 11:10:27 volumio volumio[6395]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:27 volumio volumio[6395]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:27 volumio volumio[6395]: *** WARNING *** For more information see Feb 16 11:10:27 volumio node[6395]: *** WARNING *** For more information see Feb 16 11:10:27 volumio node[6395]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:27 volumio node[6395]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:27 volumio node[6395]: *** WARNING *** For more information see Feb 16 11:10:27 volumio volumio[6395]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 16 11:10:27 volumio volumio[6395]: info: Discovery: Started advertising with name: Volumio Feb 16 11:10:27 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:27 volumio volumio[6395]: info: Plugin jellyfin is not enabled Feb 16 11:10:27 volumio volumio[6395]: info: Loading plugin "squeezelite_mc"... Feb 16 11:10:28 volumio volumio[6395]: info: Loading plugin "youtube2"... Feb 16 11:10:28 volumio ifplugd(eth0)[649]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Feb 16 11:10:28 volumio ifplugd(eth0)[649]: client: ifdown: interface eth0 not configured Feb 16 11:10:28 volumio ifplugd(eth0)[649]: Program executed successfully. Feb 16 11:10:28 volumio volumio[6395]: info: Plugin ytcr is not enabled Feb 16 11:10:28 volumio volumio[6395]: info: Loading plugin "autostart"... Feb 16 11:10:29 volumio volumio[6395]: info: Applying required configuration parameters for plugin autostart Feb 16 11:10:29 volumio volumio[6395]: info: AutoStart - onVolumioStart - read config.json Feb 16 11:10:29 volumio volumio[6395]: info: Loading plugin "gpio-buttons"... Feb 16 11:10:29 volumio volumio[6395]: info: GPIO-Buttons initialized Feb 16 11:10:29 volumio volumio[6395]: info: Plugin now_playing is not enabled Feb 16 11:10:29 volumio volumio[6395]: info: Loading plugin "outputs"... Feb 16 11:10:29 volumio volumio[6395]: info: Loading plugin "albumart"... Feb 16 11:10:29 volumio volumio[6395]: info: Plugin example_plugin is not enabled Feb 16 11:10:29 volumio volumio[6395]: info: Loading plugin "inputs"... Feb 16 11:10:29 volumio volumio[6395]: info: Loading plugin "updater_comm"... Feb 16 11:10:29 volumio volumio[6395]: info: Plugin mpdemulation is not enabled Feb 16 11:10:29 volumio volumio[6395]: info: Loading plugin "rest_api"... Feb 16 11:10:29 volumio volumio[6395]: info: Loading plugin "websocket"... Feb 16 11:10:29 volumio volumio[6395]: info: Starting Socket.io Server version 2.3.0 Feb 16 11:10:29 volumio volumio[6395]: info: Loading plugin "Systeminfo"... Feb 16 11:10:29 volumio volumio[6395]: Forking 3 albumart workers Feb 16 11:10:29 volumio volumio[6395]: info: Plugin peppyspectrum is not enabled Feb 16 11:10:29 volumio volumio[6395]: info: Loading plugin "randomizer"... Feb 16 11:10:29 volumio volumio-remote-updater[467]: [2025-02-16 11:10:29] [connect] Successful connection Feb 16 11:10:29 volumio volumio[6395]: info: Applying required configuration parameters for plugin randomizer Feb 16 11:10:29 volumio volumio[6395]: info: Plugin touch_display is not enabled Feb 16 11:10:29 volumio volumio[6395]: info: Loading i18n strings for locale fr Feb 16 11:10:29 volumio volumio[6395]: Updating browse sources language Feb 16 11:10:29 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::initPlayerControls Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: Express server listening on port 3000 Feb 16 11:10:30 volumio volumio[6395]: [Metrics] WebUI: 4s 494.70ms Feb 16 11:10:30 volumio volumio[6395]: info: CoreStateMachine::resetVolumioState Feb 16 11:10:30 volumio volumio[6395]: info: CoreStateMachine::getcurrentVolume Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: Starting albumart workers Feb 16 11:10:30 volumio volumio[6395]: Starting albumart workers Feb 16 11:10:30 volumio volumio[6395]: Starting albumart workers Feb 16 11:10:30 volumio volumio[6395]: info: Volumio Network Manager: Network status updated: 0 Feb 16 11:10:30 volumio volumio[6395]: info: Cannot mount NAS TPLINK at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:30 volumio volumio-remote-updater[467]: [2025-02-16 11:10:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739700629 101 Feb 16 11:10:30 volumio volumio[6395]: 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: 1 Feb 16 11:10:30 volumio volumio[6395]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 16 11:10:30 volumio volumio[6395]: info: Reloading queue from file Feb 16 11:10:30 volumio volumio[6395]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:30 volumio volumio[6395]: info: CoreStateMachine::pushState Feb 16 11:10:30 volumio volumio[6395]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:30 volumio volumio[6395]: info: CoreStateMachine::updateTrackBlock Feb 16 11:10:30 volumio volumio[6395]: info: CorePlayQueue::getTrackBlock Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:30 volumio volumio[6395]: info: CoreStateMachine::setRepeat null single undefined Feb 16 11:10:30 volumio volumio[6395]: info: CoreStateMachine::pushState Feb 16 11:10:30 volumio volumio[6395]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:30 volumio volumio[6395]: info: CoreStateMachine::setRandom null Feb 16 11:10:30 volumio volumio[6395]: info: CoreStateMachine::pushState Feb 16 11:10:30 volumio volumio[6395]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:30 volumio volumio[6395]: info: Setting Device type: Raspberry PI Feb 16 11:10:30 volumio volumio[6395]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 16 11:10:30 volumio volumio[6395]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Feb 16 11:10:30 volumio volumio[6395]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 16 11:10:30 volumio volumio[6395]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:30 volumio volumio[6395]: info: CoreStateMachine::pushState Feb 16 11:10:30 volumio volumio[6395]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:30 volumio volumio[6395]: info: Completed loading Core Plugins Feb 16 11:10:30 volumio volumio[6395]: info: Preparing to generate the ALSA configuration file Feb 16 11:10:30 volumio volumio[6395]: info: Asound.conf file unchanged, so no further update is needed Feb 16 11:10:30 volumio volumio[6395]: info: Output device has changed, restarting MPD Feb 16 11:10:30 volumio sudo[6546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:30 volumio sudo[6546]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:30 volumio sudo[6546]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:30 volumio volumio[6395]: info: ___________ START PLUGINS ___________ Feb 16 11:10:30 volumio volumio[6395]: info: ControllerMpd::onStart: Initializing MPD Feb 16 11:10:30 volumio volumio[6395]: info: Creating MPD Configuration file Feb 16 11:10:30 volumio sudo[6549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:30 volumio sudo[6549]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:30 volumio systemd[1]: Stopping Music Player Daemon... Feb 16 11:10:30 volumio sudo[6552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:30 volumio sudo[6552]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:30 volumio volumio[6395]: info: [1739700630777] CoreMusicLibrary::Adding element Serveurs Média Feb 16 11:10:30 volumio sudo[6552]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:30 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:30 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:30 volumio sudo[6555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:30 volumio sudo[6555]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:30 volumio volumio[6395]: info: [1739700630794] CoreMusicLibrary::Adding element Last_100 Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:30 volumio volumio[6395]: info: [1739700630796] CoreMusicLibrary::Adding element Webradio Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:30 volumio volumio[6395]: info: Initializing BBC Radios Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:30 volumio volumio[6395]: info: [squeezelite_mc] Starting proxy server... Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:30 volumio volumio[6395]: info: [1739700630872] CoreMusicLibrary::Adding element YouTube2 Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:30 volumio volumio[6395]: Cannot find translation for source YouTube2 Feb 16 11:10:30 volumio volumio[6395]: info: AutoStart - onStart Feb 16 11:10:30 volumio volumio[6395]: info: GPIO-Buttons: Reading config and creating triggers... Feb 16 11:10:30 volumio volumio[6395]: info: GPIO-Buttons: shutdown on pin 3 Feb 16 11:10:30 volumio volumio[6395]: error: Plugin gpio-buttons failed to start! Error: EINVAL: invalid argument, write Feb 16 11:10:30 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:30 volumio kernel: export_store: invalid GPIO 3 Feb 16 11:10:30 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 16 11:10:30 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:30 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:30 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:30 volumio volumio[6395]: info: [1739700630896] CoreMusicLibrary::Adding element Randomizer Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:30 volumio volumio[6395]: Cannot find translation for source YouTube2 Feb 16 11:10:30 volumio volumio[6395]: Cannot find translation for source Randomizer Feb 16 11:10:30 volumio volumio[6395]: info: Volumio Calling Home Feb 16 11:10:30 volumio volumio[6395]: info: [squeezelite_mc] Proxy server started on port 37053 Feb 16 11:10:30 volumio sudo[6569]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 11:10:30 volumio sudo[6569]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:30 volumio sudo[6569]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:30 volumio volumio[6395]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:31 volumio volumio[6395]: Unhandled rejection Error: No sockets available, cannot start. Feb 16 11:10:31 volumio volumio[6395]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 16 11:10:31 volumio volumio[6395]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 16 11:10:31 volumio volumio[6395]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 16 11:10:31 volumio volumio[6395]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 16 11:10:31 volumio volumio[6395]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 16 11:10:31 volumio volumio[6395]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 16 11:10:31 volumio volumio[6395]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 16 11:10:31 volumio volumio[6395]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 16 11:10:31 volumio volumio[6395]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 16 11:10:31 volumio volumio[6395]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 16 11:10:31 volumio volumio[6395]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 16 11:10:31 volumio volumio[6395]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 16 11:10:31 volumio volumio[6395]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 16 11:10:31 volumio volumio[6395]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 16 11:10:31 volumio volumio[6395]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 16 11:10:31 volumio volumio[6395]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 16 11:10:31 volumio volumio[6395]: info: MPD Permissions set Feb 16 11:10:31 volumio volumio[6395]: info: MPD Permissions set Feb 16 11:10:31 volumio volumio[6395]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 16 11:10:31 volumio volumio[6395]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:31 volumio volumio[6395]: info: CoreStateMachine::pushState Feb 16 11:10:31 volumio volumio[6395]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:31 volumio volumio[6395]: info: [squeezelite_mc] Server discovery started Feb 16 11:10:31 volumio volumio[6395]: info: [squeezelite_mc] Player finder started Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:31 volumio volumio[6395]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 16 11:10:31 volumio volumio[6395]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:31 volumio volumio[6395]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 16 11:10:31 volumio volumio[6395]: at doSend (dgram.js:692:16) Feb 16 11:10:31 volumio volumio[6395]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 16 11:10:31 volumio volumio[6395]: at afterDns (dgram.js:638:5) Feb 16 11:10:31 volumio volumio[6395]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 16 11:10:31 volumio volumio[6395]: errno: -101, Feb 16 11:10:31 volumio volumio[6395]: code: 'ENETUNREACH', Feb 16 11:10:31 volumio volumio[6395]: syscall: 'send', Feb 16 11:10:31 volumio volumio[6395]: address: '255.255.255.255', Feb 16 11:10:31 volumio volumio[6395]: port: 3483 Feb 16 11:10:31 volumio volumio[6395]: } Feb 16 11:10:31 volumio volumio[6395]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:31 volumio sudo[6596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 11:09 Feb 16 11:10:31 volumio sudo[6596]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:31 volumio mpd[6574]: Feb 16 11:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 16 11:10:31 volumio sudo[6596]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:31 volumio volumio-remote-updater[467]: [2025-02-16 11:10:31] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 16 11:10:31 volumio volumio-remote-updater[467]: [2025-02-16 11:10:31] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 16 11:10:31 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 16 11:10:31 volumio sudo[6549]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:31 volumio systemd[1]: Started Music Player Daemon. Feb 16 11:10:31 volumio sudo[6555]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:31 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 16 11:10:31 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:31 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:32 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 16 11:10:32 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 12. Feb 16 11:10:32 volumio systemd[1]: Stopped Volumio Backend Module. Feb 16 11:10:32 volumio systemd[1]: Started Volumio Backend Module. Feb 16 11:10:32 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:32 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:33 volumio volumio[6611]: info: ------------------------------------------- Feb 16 11:10:33 volumio volumio[6611]: info: ----- Volumio3 ---- Feb 16 11:10:33 volumio volumio[6611]: info: ------------------------------------------- Feb 16 11:10:33 volumio volumio[6611]: info: ----- System startup ---- Feb 16 11:10:33 volumio volumio[6611]: info: ------------------------------------------- Feb 16 11:10:33 volumio volumio[6611]: info: MYVOLUMIO Environment detected Feb 16 11:10:33 volumio volumio[6611]: info: Plugin folders cleanup Feb 16 11:10:33 volumio volumio[6611]: info: Scanning into folder /volumio/app/plugins/ Feb 16 11:10:33 volumio volumio[6611]: info: Scanning category audio_interface Feb 16 11:10:33 volumio volumio[6611]: info: Scanning category miscellanea Feb 16 11:10:33 volumio volumio[6611]: info: Scanning category music_service Feb 16 11:10:33 volumio volumio[6611]: info: Scanning category plugins.json Feb 16 11:10:33 volumio volumio[6611]: info: Scanning category system_controller Feb 16 11:10:33 volumio volumio[6611]: info: Scanning category user_interface Feb 16 11:10:33 volumio volumio[6611]: info: Scanning into folder /data/plugins/ Feb 16 11:10:33 volumio volumio[6611]: info: Scanning category music_service Feb 16 11:10:33 volumio volumio[6611]: info: Scanning category system_controller Feb 16 11:10:33 volumio volumio[6611]: info: Scanning category system_hardware Feb 16 11:10:33 volumio volumio[6611]: info: Scanning category user_interface Feb 16 11:10:33 volumio volumio[6611]: info: Plugin folders cleanup completed Feb 16 11:10:33 volumio volumio[6611]: info: ------------------------------------------- Feb 16 11:10:33 volumio volumio[6611]: info: ----- Core plugins startup ---- Feb 16 11:10:33 volumio volumio[6611]: info: ------------------------------------------- Feb 16 11:10:33 volumio volumio[6611]: info: Loading plugins from folder /volumio/app/plugins/ Feb 16 11:10:33 volumio volumio[6611]: info: Adding plugin upnp to MyMusic Plugins Feb 16 11:10:33 volumio volumio[6611]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 16 11:10:33 volumio volumio[6611]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 16 11:10:33 volumio volumio[6611]: info: Loading plugins from folder /data/plugins/ Feb 16 11:10:33 volumio volumio[6611]: info: Loading plugin "system"... Feb 16 11:10:33 volumio volumio[6611]: info: Loading plugin "appearance"... Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "network"... Feb 16 11:10:34 volumio volumio[6611]: info: Refreshing Cached IP Addresses Feb 16 11:10:34 volumio sudo[6638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 11:10:34 volumio sudo[6638]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:34 volumio sudo[6638]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:34 volumio sudo[6640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 11:10:34 volumio sudo[6640]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "services"... Feb 16 11:10:34 volumio sudo[6640]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "alsa_controller"... Feb 16 11:10:34 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "wizard"... Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "networkfs"... Feb 16 11:10:34 volumio volumio[6611]: info: Cannot mount NAS OS at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:34 volumio volumio[6611]: info: Starting Udev Watcher for removable devices Feb 16 11:10:34 volumio sudo[6663]: 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.0.1/g/Musiques /mnt/NAS/TPLINK Feb 16 11:10:34 volumio sudo[6663]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:34 volumio kernel: CIFS: Attempting to mount //192.168.0.1/g/Musiques Feb 16 11:10:34 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 16 11:10:34 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 16 11:10:34 volumio sudo[6663]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:34 volumio volumio[6611]: info: Ignoring mount for partition: RECOVERY Feb 16 11:10:34 volumio volumio[6611]: info: Ignoring mount for partition: root64 Feb 16 11:10:34 volumio volumio[6611]: info: Ignoring mount for partition: boot Feb 16 11:10:34 volumio volumio[6611]: info: Ignoring mount for partition: volumio Feb 16 11:10:34 volumio volumio[6611]: info: Ignoring mount for partition: volumio_data Feb 16 11:10:34 volumio volumio[6611]: error: Cannot associate FS Label, not mounting Feb 16 11:10:34 volumio volumio[6611]: info: Ignoring mount for partition: SETTINGS Feb 16 11:10:34 volumio volumio[6611]: info: Ignoring mount for partition: RECALBOX Feb 16 11:10:34 volumio volumio[6611]: info: Ignoring mount for partition: SHARE Feb 16 11:10:34 volumio volumio[6611]: info: Ignoring mount for partition: OVERLAY Feb 16 11:10:34 volumio volumio[6611]: info: Ignoring mount for partition: boot64 Feb 16 11:10:34 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "volumio_command_line_client"... Feb 16 11:10:34 volumio volumio[6611]: info: Plugin upnp is not enabled Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "my_music"... Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "mpd"... Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "upnp_browser"... Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "alarm-clock"... Feb 16 11:10:34 volumio volumio[6611]: info: Plugin airplay_emulation is not enabled Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "last_100"... Feb 16 11:10:34 volumio volumio[6611]: info: Loading plugin "webradio"... Feb 16 11:10:35 volumio volumio[6611]: info: Loading plugin "i2s_dacs"... Feb 16 11:10:35 volumio volumio[6611]: info: I2S DAC not set, start Auto-detection Feb 16 11:10:35 volumio volumio[6611]: info: Loading plugin "volumiodiscovery"... Feb 16 11:10:35 volumio volumio[6611]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:35 volumio volumio[6611]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:35 volumio volumio[6611]: *** WARNING *** For more information see Feb 16 11:10:35 volumio node[6611]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:35 volumio volumio[6611]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:35 volumio volumio[6611]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:35 volumio volumio[6611]: *** WARNING *** For more information see Feb 16 11:10:35 volumio node[6611]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:35 volumio node[6611]: *** WARNING *** For more information see Feb 16 11:10:35 volumio node[6611]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:35 volumio node[6611]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:35 volumio node[6611]: *** WARNING *** For more information see Feb 16 11:10:35 volumio volumio[6611]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 16 11:10:35 volumio volumio[6611]: info: Discovery: Started advertising with name: Volumio Feb 16 11:10:35 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:35 volumio volumio[6611]: info: Plugin jellyfin is not enabled Feb 16 11:10:35 volumio volumio[6611]: info: Loading plugin "squeezelite_mc"... Feb 16 11:10:35 volumio volumio[6611]: info: Loading plugin "youtube2"... Feb 16 11:10:36 volumio volumio[6611]: info: Plugin ytcr is not enabled Feb 16 11:10:36 volumio volumio[6611]: info: Loading plugin "autostart"... Feb 16 11:10:36 volumio volumio[6611]: info: Applying required configuration parameters for plugin autostart Feb 16 11:10:36 volumio volumio[6611]: info: AutoStart - onVolumioStart - read config.json Feb 16 11:10:36 volumio volumio[6611]: info: Loading plugin "gpio-buttons"... Feb 16 11:10:36 volumio volumio[6611]: info: GPIO-Buttons initialized Feb 16 11:10:36 volumio volumio[6611]: info: Plugin now_playing is not enabled Feb 16 11:10:36 volumio volumio[6611]: info: Loading plugin "outputs"... Feb 16 11:10:36 volumio volumio[6611]: info: Loading plugin "albumart"... Feb 16 11:10:36 volumio volumio[6611]: info: Plugin example_plugin is not enabled Feb 16 11:10:36 volumio volumio[6611]: info: Loading plugin "inputs"... Feb 16 11:10:36 volumio volumio[6611]: info: Loading plugin "updater_comm"... Feb 16 11:10:36 volumio volumio[6611]: info: Plugin mpdemulation is not enabled Feb 16 11:10:36 volumio volumio[6611]: info: Loading plugin "rest_api"... Feb 16 11:10:36 volumio volumio[6611]: info: Loading plugin "websocket"... Feb 16 11:10:36 volumio volumio[6611]: info: Starting Socket.io Server version 2.3.0 Feb 16 11:10:36 volumio volumio[6611]: info: Loading plugin "Systeminfo"... Feb 16 11:10:36 volumio volumio[6611]: Forking 3 albumart workers Feb 16 11:10:36 volumio volumio-remote-updater[467]: [2025-02-16 11:10:36] [connect] Successful connection Feb 16 11:10:36 volumio volumio[6611]: info: Plugin peppyspectrum is not enabled Feb 16 11:10:36 volumio volumio[6611]: info: Loading plugin "randomizer"... Feb 16 11:10:37 volumio volumio[6611]: info: Applying required configuration parameters for plugin randomizer Feb 16 11:10:37 volumio volumio[6611]: info: Plugin touch_display is not enabled Feb 16 11:10:37 volumio volumio[6611]: info: Loading i18n strings for locale fr Feb 16 11:10:37 volumio volumio[6611]: Updating browse sources language Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::initPlayerControls Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: Express server listening on port 3000 Feb 16 11:10:37 volumio volumio[6611]: [Metrics] WebUI: 4s 500.96ms Feb 16 11:10:37 volumio volumio[6611]: Starting albumart workers Feb 16 11:10:37 volumio volumio[6611]: info: CoreStateMachine::resetVolumioState Feb 16 11:10:37 volumio volumio[6611]: info: CoreStateMachine::getcurrentVolume Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:37 volumio volumio[6611]: Starting albumart workers Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: Volumio Network Manager: Network status updated: 0 Feb 16 11:10:37 volumio volumio[6611]: info: Cannot mount NAS TPLINK at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:37 volumio volumio-remote-updater[467]: [2025-02-16 11:10:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739700636 101 Feb 16 11:10:37 volumio volumio[6611]: Starting albumart workers Feb 16 11:10:37 volumio volumio[6611]: 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: 1 Feb 16 11:10:37 volumio volumio[6611]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 16 11:10:37 volumio volumio[6611]: info: Reloading queue from file Feb 16 11:10:37 volumio volumio[6611]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:37 volumio volumio[6611]: info: CoreStateMachine::pushState Feb 16 11:10:37 volumio volumio[6611]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:37 volumio volumio[6611]: info: CoreStateMachine::updateTrackBlock Feb 16 11:10:37 volumio volumio[6611]: info: CorePlayQueue::getTrackBlock Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:37 volumio volumio[6611]: info: CoreStateMachine::setRepeat null single undefined Feb 16 11:10:37 volumio volumio[6611]: info: CoreStateMachine::pushState Feb 16 11:10:37 volumio volumio[6611]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:37 volumio volumio[6611]: info: CoreStateMachine::setRandom null Feb 16 11:10:37 volumio volumio[6611]: info: CoreStateMachine::pushState Feb 16 11:10:37 volumio volumio[6611]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:37 volumio volumio[6611]: info: Setting Device type: Raspberry PI Feb 16 11:10:37 volumio volumio[6611]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 16 11:10:37 volumio volumio[6611]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Feb 16 11:10:37 volumio volumio[6611]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 16 11:10:37 volumio volumio[6611]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:37 volumio volumio[6611]: info: CoreStateMachine::pushState Feb 16 11:10:37 volumio volumio[6611]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:37 volumio volumio[6611]: info: Completed loading Core Plugins Feb 16 11:10:37 volumio volumio[6611]: info: Preparing to generate the ALSA configuration file Feb 16 11:10:37 volumio volumio[6611]: info: Asound.conf file unchanged, so no further update is needed Feb 16 11:10:37 volumio volumio[6611]: info: Output device has changed, restarting MPD Feb 16 11:10:37 volumio sudo[6758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:37 volumio sudo[6758]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:37 volumio sudo[6758]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:37 volumio volumio[6611]: info: ___________ START PLUGINS ___________ Feb 16 11:10:37 volumio volumio[6611]: info: ControllerMpd::onStart: Initializing MPD Feb 16 11:10:37 volumio volumio[6611]: info: Creating MPD Configuration file Feb 16 11:10:37 volumio sudo[6761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:37 volumio sudo[6761]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:37 volumio systemd[1]: Stopping Music Player Daemon... Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:37 volumio volumio[6611]: info: [1739700637962] CoreMusicLibrary::Adding element Serveurs Média Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:37 volumio sudo[6764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:37 volumio sudo[6764]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:37 volumio sudo[6766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:37 volumio sudo[6766]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:37 volumio volumio[6611]: info: [1739700637978] CoreMusicLibrary::Adding element Last_100 Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:37 volumio sudo[6764]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:37 volumio volumio[6611]: info: [1739700637981] CoreMusicLibrary::Adding element Webradio Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:37 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:37 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:37 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:37 volumio volumio[6611]: info: Initializing BBC Radios Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:38 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:38 volumio volumio[6611]: info: [squeezelite_mc] Starting proxy server... Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:38 volumio volumio[6611]: info: [1739700638063] CoreMusicLibrary::Adding element YouTube2 Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:38 volumio volumio[6611]: Cannot find translation for source YouTube2 Feb 16 11:10:38 volumio volumio[6611]: info: AutoStart - onStart Feb 16 11:10:38 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 16 11:10:38 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:38 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:38 volumio volumio[6611]: info: GPIO-Buttons: Reading config and creating triggers... Feb 16 11:10:38 volumio volumio[6611]: info: GPIO-Buttons: shutdown on pin 3 Feb 16 11:10:38 volumio volumio[6611]: error: Plugin gpio-buttons failed to start! Error: EINVAL: invalid argument, write Feb 16 11:10:38 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:38 volumio kernel: export_store: invalid GPIO 3 Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:38 volumio volumio[6611]: info: [1739700638090] CoreMusicLibrary::Adding element Randomizer Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:38 volumio volumio[6611]: Cannot find translation for source YouTube2 Feb 16 11:10:38 volumio volumio[6611]: Cannot find translation for source Randomizer Feb 16 11:10:38 volumio volumio[6611]: info: Volumio Calling Home Feb 16 11:10:38 volumio sudo[6780]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 11:10:38 volumio sudo[6780]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:38 volumio volumio[6611]: info: [squeezelite_mc] Proxy server started on port 38723 Feb 16 11:10:38 volumio sudo[6780]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:38 volumio volumio[6611]: Unhandled rejection Error: No sockets available, cannot start. Feb 16 11:10:38 volumio volumio[6611]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 16 11:10:38 volumio volumio[6611]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 16 11:10:38 volumio volumio[6611]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 16 11:10:38 volumio volumio[6611]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 16 11:10:38 volumio volumio[6611]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 16 11:10:38 volumio volumio[6611]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 16 11:10:38 volumio volumio[6611]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 16 11:10:38 volumio volumio[6611]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 16 11:10:38 volumio volumio[6611]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 16 11:10:38 volumio volumio[6611]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 16 11:10:38 volumio volumio[6611]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 16 11:10:38 volumio volumio[6611]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 16 11:10:38 volumio volumio[6611]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 16 11:10:38 volumio volumio[6611]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 16 11:10:38 volumio volumio[6611]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 16 11:10:38 volumio volumio[6611]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 16 11:10:38 volumio volumio[6611]: info: MPD Permissions set Feb 16 11:10:38 volumio volumio[6611]: info: MPD Permissions set Feb 16 11:10:38 volumio volumio[6611]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 16 11:10:38 volumio volumio[6611]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:38 volumio volumio[6611]: info: CoreStateMachine::pushState Feb 16 11:10:38 volumio volumio[6611]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:38 volumio volumio[6611]: info: [squeezelite_mc] Server discovery started Feb 16 11:10:38 volumio volumio[6611]: info: [squeezelite_mc] Player finder started Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:38 volumio volumio[6611]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 16 11:10:38 volumio volumio[6611]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:38 volumio volumio[6611]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 16 11:10:38 volumio volumio[6611]: at doSend (dgram.js:692:16) Feb 16 11:10:38 volumio volumio[6611]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 16 11:10:38 volumio volumio[6611]: at afterDns (dgram.js:638:5) Feb 16 11:10:38 volumio volumio[6611]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 16 11:10:38 volumio volumio[6611]: errno: -101, Feb 16 11:10:38 volumio volumio[6611]: code: 'ENETUNREACH', Feb 16 11:10:38 volumio volumio[6611]: syscall: 'send', Feb 16 11:10:38 volumio volumio[6611]: address: '255.255.255.255', Feb 16 11:10:38 volumio volumio[6611]: port: 3483 Feb 16 11:10:38 volumio volumio[6611]: } Feb 16 11:10:38 volumio volumio[6611]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:38 volumio sudo[6807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 11:09 Feb 16 11:10:38 volumio sudo[6807]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:38 volumio mpd[6785]: Feb 16 11:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 16 11:10:38 volumio sudo[6807]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:38 volumio systemd[1]: Started Music Player Daemon. Feb 16 11:10:38 volumio sudo[6766]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:38 volumio sudo[6761]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:38 volumio volumio-remote-updater[467]: [2025-02-16 11:10:38] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 16 11:10:38 volumio volumio-remote-updater[467]: [2025-02-16 11:10:38] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 16 11:10:38 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 16 11:10:39 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 16 11:10:39 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:39 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:39 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 16 11:10:39 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 13. Feb 16 11:10:39 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:39 volumio systemd[1]: Stopped Volumio Backend Module. Feb 16 11:10:39 volumio systemd[1]: Started Volumio Backend Module. Feb 16 11:10:39 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:40 volumio volumio[6823]: info: ------------------------------------------- Feb 16 11:10:40 volumio volumio[6823]: info: ----- Volumio3 ---- Feb 16 11:10:40 volumio volumio[6823]: info: ------------------------------------------- Feb 16 11:10:40 volumio volumio[6823]: info: ----- System startup ---- Feb 16 11:10:40 volumio volumio[6823]: info: ------------------------------------------- Feb 16 11:10:40 volumio volumio[6823]: info: MYVOLUMIO Environment detected Feb 16 11:10:40 volumio volumio[6823]: info: Plugin folders cleanup Feb 16 11:10:40 volumio volumio[6823]: info: Scanning into folder /volumio/app/plugins/ Feb 16 11:10:40 volumio volumio[6823]: info: Scanning category audio_interface Feb 16 11:10:40 volumio volumio[6823]: info: Scanning category miscellanea Feb 16 11:10:40 volumio volumio[6823]: info: Scanning category music_service Feb 16 11:10:40 volumio volumio[6823]: info: Scanning category plugins.json Feb 16 11:10:40 volumio volumio[6823]: info: Scanning category system_controller Feb 16 11:10:40 volumio volumio[6823]: info: Scanning category user_interface Feb 16 11:10:40 volumio volumio[6823]: info: Scanning into folder /data/plugins/ Feb 16 11:10:40 volumio volumio[6823]: info: Scanning category music_service Feb 16 11:10:40 volumio volumio[6823]: info: Scanning category system_controller Feb 16 11:10:40 volumio volumio[6823]: info: Scanning category system_hardware Feb 16 11:10:40 volumio volumio[6823]: info: Scanning category user_interface Feb 16 11:10:40 volumio volumio[6823]: info: Plugin folders cleanup completed Feb 16 11:10:40 volumio volumio[6823]: info: ------------------------------------------- Feb 16 11:10:40 volumio volumio[6823]: info: ----- Core plugins startup ---- Feb 16 11:10:40 volumio volumio[6823]: info: ------------------------------------------- Feb 16 11:10:40 volumio volumio[6823]: info: Loading plugins from folder /volumio/app/plugins/ Feb 16 11:10:40 volumio volumio[6823]: info: Adding plugin upnp to MyMusic Plugins Feb 16 11:10:40 volumio volumio[6823]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 16 11:10:40 volumio volumio[6823]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 16 11:10:40 volumio volumio[6823]: info: Loading plugins from folder /data/plugins/ Feb 16 11:10:40 volumio volumio[6823]: info: Loading plugin "system"... Feb 16 11:10:40 volumio volumio[6823]: info: Loading plugin "appearance"... Feb 16 11:10:41 volumio volumio[6823]: info: Loading plugin "network"... Feb 16 11:10:41 volumio volumio[6823]: info: Refreshing Cached IP Addresses Feb 16 11:10:41 volumio sudo[6849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 11:10:41 volumio sudo[6849]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:41 volumio sudo[6849]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:41 volumio sudo[6851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 11:10:41 volumio volumio[6823]: info: Loading plugin "services"... Feb 16 11:10:41 volumio sudo[6851]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:41 volumio volumio[6823]: info: Loading plugin "alsa_controller"... Feb 16 11:10:41 volumio sudo[6851]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:41 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:41 volumio volumio[6823]: info: Loading plugin "wizard"... Feb 16 11:10:41 volumio volumio[6823]: info: Loading plugin "networkfs"... Feb 16 11:10:41 volumio volumio[6823]: info: Cannot mount NAS OS at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:41 volumio volumio[6823]: info: Starting Udev Watcher for removable devices Feb 16 11:10:41 volumio sudo[6874]: 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.0.1/g/Musiques /mnt/NAS/TPLINK Feb 16 11:10:41 volumio sudo[6874]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:41 volumio sudo[6874]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:41 volumio kernel: CIFS: Attempting to mount //192.168.0.1/g/Musiques Feb 16 11:10:41 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 16 11:10:41 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 16 11:10:41 volumio volumio[6823]: info: Ignoring mount for partition: RECOVERY Feb 16 11:10:41 volumio volumio[6823]: info: Ignoring mount for partition: root64 Feb 16 11:10:41 volumio volumio[6823]: info: Ignoring mount for partition: boot Feb 16 11:10:41 volumio volumio[6823]: info: Ignoring mount for partition: volumio Feb 16 11:10:41 volumio volumio[6823]: info: Ignoring mount for partition: volumio_data Feb 16 11:10:41 volumio volumio[6823]: error: Cannot associate FS Label, not mounting Feb 16 11:10:41 volumio volumio[6823]: info: Ignoring mount for partition: SETTINGS Feb 16 11:10:41 volumio volumio[6823]: info: Ignoring mount for partition: RECALBOX Feb 16 11:10:41 volumio volumio[6823]: info: Ignoring mount for partition: SHARE Feb 16 11:10:41 volumio volumio[6823]: info: Ignoring mount for partition: OVERLAY Feb 16 11:10:41 volumio volumio[6823]: info: Ignoring mount for partition: boot64 Feb 16 11:10:41 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:41 volumio volumio[6823]: info: Loading plugin "volumio_command_line_client"... Feb 16 11:10:41 volumio volumio[6823]: info: Plugin upnp is not enabled Feb 16 11:10:41 volumio volumio[6823]: info: Loading plugin "my_music"... Feb 16 11:10:41 volumio volumio[6823]: info: Loading plugin "mpd"... Feb 16 11:10:41 volumio volumio[6823]: info: Loading plugin "upnp_browser"... Feb 16 11:10:42 volumio volumio[6823]: info: Loading plugin "alarm-clock"... Feb 16 11:10:42 volumio volumio[6823]: info: Plugin airplay_emulation is not enabled Feb 16 11:10:42 volumio volumio[6823]: info: Loading plugin "last_100"... Feb 16 11:10:42 volumio volumio[6823]: info: Loading plugin "webradio"... Feb 16 11:10:42 volumio volumio[6823]: info: Loading plugin "i2s_dacs"... Feb 16 11:10:42 volumio volumio[6823]: info: I2S DAC not set, start Auto-detection Feb 16 11:10:42 volumio volumio[6823]: info: Loading plugin "volumiodiscovery"... Feb 16 11:10:42 volumio volumio[6823]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:42 volumio volumio[6823]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:42 volumio node[6823]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:42 volumio volumio[6823]: *** WARNING *** For more information see Feb 16 11:10:42 volumio volumio[6823]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:42 volumio volumio[6823]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:42 volumio volumio[6823]: *** WARNING *** For more information see Feb 16 11:10:42 volumio node[6823]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:42 volumio node[6823]: *** WARNING *** For more information see Feb 16 11:10:42 volumio node[6823]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:42 volumio node[6823]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:42 volumio node[6823]: *** WARNING *** For more information see Feb 16 11:10:42 volumio volumio[6823]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 16 11:10:42 volumio volumio[6823]: info: Discovery: Started advertising with name: Volumio Feb 16 11:10:42 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:42 volumio volumio[6823]: info: Plugin jellyfin is not enabled Feb 16 11:10:42 volumio volumio[6823]: info: Loading plugin "squeezelite_mc"... Feb 16 11:10:42 volumio volumio[6823]: info: Loading plugin "youtube2"... Feb 16 11:10:43 volumio volumio[6823]: info: Plugin ytcr is not enabled Feb 16 11:10:43 volumio volumio[6823]: info: Loading plugin "autostart"... Feb 16 11:10:43 volumio volumio[6823]: info: Applying required configuration parameters for plugin autostart Feb 16 11:10:43 volumio volumio[6823]: info: AutoStart - onVolumioStart - read config.json Feb 16 11:10:43 volumio volumio[6823]: info: Loading plugin "gpio-buttons"... Feb 16 11:10:43 volumio volumio[6823]: info: GPIO-Buttons initialized Feb 16 11:10:43 volumio volumio[6823]: info: Plugin now_playing is not enabled Feb 16 11:10:43 volumio volumio[6823]: info: Loading plugin "outputs"... Feb 16 11:10:43 volumio volumio[6823]: info: Loading plugin "albumart"... Feb 16 11:10:43 volumio volumio[6823]: info: Plugin example_plugin is not enabled Feb 16 11:10:43 volumio volumio[6823]: info: Loading plugin "inputs"... Feb 16 11:10:43 volumio volumio[6823]: info: Loading plugin "updater_comm"... Feb 16 11:10:43 volumio volumio[6823]: info: Plugin mpdemulation is not enabled Feb 16 11:10:43 volumio volumio[6823]: info: Loading plugin "rest_api"... Feb 16 11:10:43 volumio volumio[6823]: info: Loading plugin "websocket"... Feb 16 11:10:43 volumio volumio[6823]: info: Starting Socket.io Server version 2.3.0 Feb 16 11:10:43 volumio volumio[6823]: info: Loading plugin "Systeminfo"... Feb 16 11:10:43 volumio volumio[6823]: Forking 3 albumart workers Feb 16 11:10:43 volumio volumio-remote-updater[467]: [2025-02-16 11:10:43] [connect] Successful connection Feb 16 11:10:44 volumio volumio[6823]: info: Plugin peppyspectrum is not enabled Feb 16 11:10:44 volumio volumio[6823]: info: Loading plugin "randomizer"... Feb 16 11:10:44 volumio volumio[6823]: info: Applying required configuration parameters for plugin randomizer Feb 16 11:10:44 volumio volumio[6823]: info: Plugin touch_display is not enabled Feb 16 11:10:44 volumio volumio[6823]: info: Loading i18n strings for locale fr Feb 16 11:10:44 volumio volumio[6823]: Updating browse sources language Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::initPlayerControls Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: Express server listening on port 3000 Feb 16 11:10:44 volumio volumio[6823]: [Metrics] WebUI: 4s 493.25ms Feb 16 11:10:44 volumio volumio[6823]: Starting albumart workers Feb 16 11:10:44 volumio volumio[6823]: info: CoreStateMachine::resetVolumioState Feb 16 11:10:44 volumio volumio[6823]: info: CoreStateMachine::getcurrentVolume Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:44 volumio volumio[6823]: Starting albumart workers Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:44 volumio volumio[6823]: Starting albumart workers Feb 16 11:10:44 volumio volumio[6823]: info: Volumio Network Manager: Network status updated: 0 Feb 16 11:10:44 volumio volumio[6823]: info: Cannot mount NAS TPLINK at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:44 volumio volumio-remote-updater[467]: [2025-02-16 11:10:44] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739700643 101 Feb 16 11:10:44 volumio volumio[6823]: 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: 1 Feb 16 11:10:44 volumio volumio[6823]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 16 11:10:44 volumio volumio[6823]: info: Reloading queue from file Feb 16 11:10:44 volumio volumio[6823]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:44 volumio volumio[6823]: info: CoreStateMachine::pushState Feb 16 11:10:44 volumio volumio[6823]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:44 volumio volumio[6823]: info: CoreStateMachine::updateTrackBlock Feb 16 11:10:44 volumio volumio[6823]: info: CorePlayQueue::getTrackBlock Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:44 volumio volumio[6823]: info: CoreStateMachine::setRepeat null single undefined Feb 16 11:10:44 volumio volumio[6823]: info: CoreStateMachine::pushState Feb 16 11:10:44 volumio volumio[6823]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:44 volumio volumio[6823]: info: CoreStateMachine::setRandom null Feb 16 11:10:44 volumio volumio[6823]: info: CoreStateMachine::pushState Feb 16 11:10:44 volumio volumio[6823]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:44 volumio volumio[6823]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:44 volumio volumio[6823]: info: Setting Device type: Raspberry PI Feb 16 11:10:44 volumio volumio[6823]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 16 11:10:44 volumio volumio[6823]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Feb 16 11:10:44 volumio volumio[6823]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 16 11:10:45 volumio volumio[6823]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:45 volumio volumio[6823]: info: CoreStateMachine::pushState Feb 16 11:10:45 volumio volumio[6823]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:45 volumio volumio[6823]: info: Completed loading Core Plugins Feb 16 11:10:45 volumio volumio[6823]: info: Preparing to generate the ALSA configuration file Feb 16 11:10:45 volumio volumio[6823]: info: Asound.conf file unchanged, so no further update is needed Feb 16 11:10:45 volumio volumio[6823]: info: Output device has changed, restarting MPD Feb 16 11:10:45 volumio sudo[6966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:45 volumio sudo[6966]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:45 volumio sudo[6966]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:45 volumio volumio[6823]: info: ___________ START PLUGINS ___________ Feb 16 11:10:45 volumio volumio[6823]: info: ControllerMpd::onStart: Initializing MPD Feb 16 11:10:45 volumio volumio[6823]: info: Creating MPD Configuration file Feb 16 11:10:45 volumio sudo[6969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:45 volumio sudo[6969]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:45 volumio systemd[1]: Stopping Music Player Daemon... Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:45 volumio volumio[6823]: info: [1739700645183] CoreMusicLibrary::Adding element Serveurs Média Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:45 volumio sudo[6972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:45 volumio sudo[6972]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:45 volumio sudo[6974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:45 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:45 volumio sudo[6974]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:45 volumio sudo[6972]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:45 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:45 volumio volumio[6823]: info: [1739700645204] CoreMusicLibrary::Adding element Last_100 Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:45 volumio volumio[6823]: info: [1739700645206] CoreMusicLibrary::Adding element Webradio Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:45 volumio volumio[6823]: info: Initializing BBC Radios Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: [squeezelite_mc] Starting proxy server... Feb 16 11:10:45 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:45 volumio volumio[6823]: info: [1739700645287] CoreMusicLibrary::Adding element YouTube2 Feb 16 11:10:45 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 16 11:10:45 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:45 volumio volumio[6823]: Cannot find translation for source YouTube2 Feb 16 11:10:45 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:45 volumio volumio[6823]: info: AutoStart - onStart Feb 16 11:10:45 volumio volumio[6823]: info: GPIO-Buttons: Reading config and creating triggers... Feb 16 11:10:45 volumio volumio[6823]: info: GPIO-Buttons: shutdown on pin 3 Feb 16 11:10:45 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:45 volumio volumio[6823]: error: Plugin gpio-buttons failed to start! Error: EINVAL: invalid argument, write Feb 16 11:10:45 volumio kernel: export_store: invalid GPIO 3 Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:45 volumio volumio[6823]: info: [1739700645312] CoreMusicLibrary::Adding element Randomizer Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:45 volumio volumio[6823]: Cannot find translation for source YouTube2 Feb 16 11:10:45 volumio volumio[6823]: Cannot find translation for source Randomizer Feb 16 11:10:45 volumio volumio[6823]: info: Volumio Calling Home Feb 16 11:10:45 volumio sudo[6989]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 11:10:45 volumio sudo[6989]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:45 volumio sudo[6989]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:45 volumio volumio[6823]: info: [squeezelite_mc] Proxy server started on port 41929 Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:45 volumio volumio[6823]: Unhandled rejection Error: No sockets available, cannot start. Feb 16 11:10:45 volumio volumio[6823]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 16 11:10:45 volumio volumio[6823]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 16 11:10:45 volumio volumio[6823]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 16 11:10:45 volumio volumio[6823]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 16 11:10:45 volumio volumio[6823]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 16 11:10:45 volumio volumio[6823]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 16 11:10:45 volumio volumio[6823]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 16 11:10:45 volumio volumio[6823]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 16 11:10:45 volumio volumio[6823]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 16 11:10:45 volumio volumio[6823]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 16 11:10:45 volumio volumio[6823]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 16 11:10:45 volumio volumio[6823]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 16 11:10:45 volumio volumio[6823]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 16 11:10:45 volumio volumio[6823]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 16 11:10:45 volumio volumio[6823]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 16 11:10:45 volumio volumio[6823]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 16 11:10:45 volumio volumio[6823]: info: MPD Permissions set Feb 16 11:10:45 volumio volumio[6823]: info: MPD Permissions set Feb 16 11:10:45 volumio volumio[6823]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 16 11:10:45 volumio volumio[6823]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:45 volumio volumio[6823]: info: CoreStateMachine::pushState Feb 16 11:10:45 volumio volumio[6823]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:45 volumio volumio[6823]: info: [squeezelite_mc] Server discovery started Feb 16 11:10:45 volumio volumio[6823]: info: [squeezelite_mc] Player finder started Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:45 volumio volumio[6823]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 16 11:10:45 volumio volumio[6823]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:45 volumio volumio[6823]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 16 11:10:45 volumio volumio[6823]: at doSend (dgram.js:692:16) Feb 16 11:10:45 volumio volumio[6823]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 16 11:10:45 volumio volumio[6823]: at afterDns (dgram.js:638:5) Feb 16 11:10:45 volumio volumio[6823]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 16 11:10:45 volumio volumio[6823]: errno: -101, Feb 16 11:10:45 volumio volumio[6823]: code: 'ENETUNREACH', Feb 16 11:10:45 volumio volumio[6823]: syscall: 'send', Feb 16 11:10:45 volumio volumio[6823]: address: '255.255.255.255', Feb 16 11:10:45 volumio volumio[6823]: port: 3483 Feb 16 11:10:45 volumio volumio[6823]: } Feb 16 11:10:45 volumio volumio[6823]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:46 volumio sudo[7016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 11:09 Feb 16 11:10:46 volumio sudo[7016]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:46 volumio mpd[6994]: Feb 16 11:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 16 11:10:46 volumio sudo[7016]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:46 volumio systemd[1]: Started Music Player Daemon. Feb 16 11:10:46 volumio sudo[6974]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:46 volumio sudo[6969]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:46 volumio volumio-remote-updater[467]: [2025-02-16 11:10:46] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 16 11:10:46 volumio volumio-remote-updater[467]: [2025-02-16 11:10:46] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 16 11:10:46 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 16 11:10:46 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 16 11:10:46 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:46 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:46 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 16 11:10:46 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 14. Feb 16 11:10:46 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:46 volumio systemd[1]: Stopped Volumio Backend Module. Feb 16 11:10:46 volumio systemd[1]: Started Volumio Backend Module. Feb 16 11:10:46 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:47 volumio volumio[7035]: info: ------------------------------------------- Feb 16 11:10:47 volumio volumio[7035]: info: ----- Volumio3 ---- Feb 16 11:10:47 volumio volumio[7035]: info: ------------------------------------------- Feb 16 11:10:47 volumio volumio[7035]: info: ----- System startup ---- Feb 16 11:10:47 volumio volumio[7035]: info: ------------------------------------------- Feb 16 11:10:48 volumio volumio[7035]: info: MYVOLUMIO Environment detected Feb 16 11:10:48 volumio volumio[7035]: info: Plugin folders cleanup Feb 16 11:10:48 volumio volumio[7035]: info: Scanning into folder /volumio/app/plugins/ Feb 16 11:10:48 volumio volumio[7035]: info: Scanning category audio_interface Feb 16 11:10:48 volumio volumio[7035]: info: Scanning category miscellanea Feb 16 11:10:48 volumio volumio[7035]: info: Scanning category music_service Feb 16 11:10:48 volumio volumio[7035]: info: Scanning category plugins.json Feb 16 11:10:48 volumio volumio[7035]: info: Scanning category system_controller Feb 16 11:10:48 volumio volumio[7035]: info: Scanning category user_interface Feb 16 11:10:48 volumio volumio[7035]: info: Scanning into folder /data/plugins/ Feb 16 11:10:48 volumio volumio[7035]: info: Scanning category music_service Feb 16 11:10:48 volumio volumio[7035]: info: Scanning category system_controller Feb 16 11:10:48 volumio volumio[7035]: info: Scanning category system_hardware Feb 16 11:10:48 volumio volumio[7035]: info: Scanning category user_interface Feb 16 11:10:48 volumio volumio[7035]: info: Plugin folders cleanup completed Feb 16 11:10:48 volumio volumio[7035]: info: ------------------------------------------- Feb 16 11:10:48 volumio volumio[7035]: info: ----- Core plugins startup ---- Feb 16 11:10:48 volumio volumio[7035]: info: ------------------------------------------- Feb 16 11:10:48 volumio volumio[7035]: info: Loading plugins from folder /volumio/app/plugins/ Feb 16 11:10:48 volumio volumio[7035]: info: Adding plugin upnp to MyMusic Plugins Feb 16 11:10:48 volumio volumio[7035]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 16 11:10:48 volumio volumio[7035]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 16 11:10:48 volumio volumio[7035]: info: Loading plugins from folder /data/plugins/ Feb 16 11:10:48 volumio volumio[7035]: info: Loading plugin "system"... Feb 16 11:10:48 volumio volumio[7035]: info: Loading plugin "appearance"... Feb 16 11:10:48 volumio volumio[7035]: info: Loading plugin "network"... Feb 16 11:10:48 volumio volumio[7035]: info: Refreshing Cached IP Addresses Feb 16 11:10:48 volumio sudo[7061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 11:10:48 volumio sudo[7061]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:48 volumio sudo[7061]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:48 volumio sudo[7063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 11:10:48 volumio volumio[7035]: info: Loading plugin "services"... Feb 16 11:10:48 volumio sudo[7063]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:48 volumio volumio[7035]: info: Loading plugin "alsa_controller"... Feb 16 11:10:48 volumio sudo[7063]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:48 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:48 volumio volumio[7035]: info: Loading plugin "wizard"... Feb 16 11:10:48 volumio volumio[7035]: info: Loading plugin "networkfs"... Feb 16 11:10:48 volumio volumio[7035]: info: Cannot mount NAS OS at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:48 volumio volumio[7035]: info: Starting Udev Watcher for removable devices Feb 16 11:10:48 volumio sudo[7086]: 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.0.1/g/Musiques /mnt/NAS/TPLINK Feb 16 11:10:48 volumio sudo[7086]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:48 volumio sudo[7086]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:48 volumio kernel: CIFS: Attempting to mount //192.168.0.1/g/Musiques Feb 16 11:10:48 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 16 11:10:48 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 16 11:10:48 volumio volumio[7035]: info: Ignoring mount for partition: RECOVERY Feb 16 11:10:48 volumio volumio[7035]: info: Ignoring mount for partition: root64 Feb 16 11:10:48 volumio volumio[7035]: info: Ignoring mount for partition: boot Feb 16 11:10:48 volumio volumio[7035]: info: Ignoring mount for partition: volumio Feb 16 11:10:48 volumio volumio[7035]: info: Ignoring mount for partition: volumio_data Feb 16 11:10:48 volumio volumio[7035]: error: Cannot associate FS Label, not mounting Feb 16 11:10:48 volumio volumio[7035]: info: Ignoring mount for partition: SETTINGS Feb 16 11:10:48 volumio volumio[7035]: info: Ignoring mount for partition: RECALBOX Feb 16 11:10:48 volumio volumio[7035]: info: Ignoring mount for partition: SHARE Feb 16 11:10:48 volumio volumio[7035]: info: Ignoring mount for partition: OVERLAY Feb 16 11:10:48 volumio volumio[7035]: info: Ignoring mount for partition: boot64 Feb 16 11:10:48 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:48 volumio volumio[7035]: info: Loading plugin "volumio_command_line_client"... Feb 16 11:10:49 volumio volumio[7035]: info: Plugin upnp is not enabled Feb 16 11:10:49 volumio volumio[7035]: info: Loading plugin "my_music"... Feb 16 11:10:49 volumio volumio[7035]: info: Loading plugin "mpd"... Feb 16 11:10:49 volumio volumio[7035]: info: Loading plugin "upnp_browser"... Feb 16 11:10:49 volumio volumio[7035]: info: Loading plugin "alarm-clock"... Feb 16 11:10:49 volumio volumio[7035]: info: Plugin airplay_emulation is not enabled Feb 16 11:10:49 volumio volumio[7035]: info: Loading plugin "last_100"... Feb 16 11:10:49 volumio volumio[7035]: info: Loading plugin "webradio"... Feb 16 11:10:49 volumio volumio[7035]: info: Loading plugin "i2s_dacs"... Feb 16 11:10:49 volumio volumio[7035]: info: I2S DAC not set, start Auto-detection Feb 16 11:10:49 volumio volumio[7035]: info: Loading plugin "volumiodiscovery"... Feb 16 11:10:49 volumio volumio[7035]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:49 volumio volumio[7035]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:49 volumio node[7035]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:49 volumio volumio[7035]: *** WARNING *** For more information see Feb 16 11:10:49 volumio volumio[7035]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:49 volumio volumio[7035]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:49 volumio volumio[7035]: *** WARNING *** For more information see Feb 16 11:10:49 volumio node[7035]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:49 volumio node[7035]: *** WARNING *** For more information see Feb 16 11:10:49 volumio node[7035]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:49 volumio node[7035]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:49 volumio node[7035]: *** WARNING *** For more information see Feb 16 11:10:49 volumio volumio[7035]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 16 11:10:49 volumio volumio[7035]: info: Discovery: Started advertising with name: Volumio Feb 16 11:10:49 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:49 volumio volumio[7035]: info: Plugin jellyfin is not enabled Feb 16 11:10:49 volumio volumio[7035]: info: Loading plugin "squeezelite_mc"... Feb 16 11:10:50 volumio volumio[7035]: info: Loading plugin "youtube2"... Feb 16 11:10:50 volumio volumio[7035]: info: Plugin ytcr is not enabled Feb 16 11:10:50 volumio volumio[7035]: info: Loading plugin "autostart"... Feb 16 11:10:50 volumio volumio[7035]: info: Applying required configuration parameters for plugin autostart Feb 16 11:10:50 volumio volumio[7035]: info: AutoStart - onVolumioStart - read config.json Feb 16 11:10:50 volumio volumio[7035]: info: Loading plugin "gpio-buttons"... Feb 16 11:10:51 volumio volumio[7035]: info: GPIO-Buttons initialized Feb 16 11:10:51 volumio volumio[7035]: info: Plugin now_playing is not enabled Feb 16 11:10:51 volumio volumio[7035]: info: Loading plugin "outputs"... Feb 16 11:10:51 volumio volumio[7035]: info: Loading plugin "albumart"... Feb 16 11:10:51 volumio volumio[7035]: info: Plugin example_plugin is not enabled Feb 16 11:10:51 volumio volumio[7035]: info: Loading plugin "inputs"... Feb 16 11:10:51 volumio volumio[7035]: info: Loading plugin "updater_comm"... Feb 16 11:10:51 volumio volumio[7035]: info: Plugin mpdemulation is not enabled Feb 16 11:10:51 volumio volumio[7035]: info: Loading plugin "rest_api"... Feb 16 11:10:51 volumio volumio[7035]: info: Loading plugin "websocket"... Feb 16 11:10:51 volumio volumio[7035]: info: Starting Socket.io Server version 2.3.0 Feb 16 11:10:51 volumio volumio[7035]: info: Loading plugin "Systeminfo"... Feb 16 11:10:51 volumio volumio-remote-updater[467]: [2025-02-16 11:10:51] [connect] Successful connection Feb 16 11:10:51 volumio volumio[7035]: Forking 3 albumart workers Feb 16 11:10:51 volumio volumio[7035]: info: Plugin peppyspectrum is not enabled Feb 16 11:10:51 volumio volumio[7035]: info: Loading plugin "randomizer"... Feb 16 11:10:51 volumio volumio[7035]: info: Applying required configuration parameters for plugin randomizer Feb 16 11:10:51 volumio volumio[7035]: info: Plugin touch_display is not enabled Feb 16 11:10:51 volumio volumio[7035]: info: Loading i18n strings for locale fr Feb 16 11:10:51 volumio volumio[7035]: Updating browse sources language Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::initPlayerControls Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: Express server listening on port 3000 Feb 16 11:10:51 volumio volumio[7035]: [Metrics] WebUI: 4s 499.41ms Feb 16 11:10:51 volumio volumio[7035]: info: CoreStateMachine::resetVolumioState Feb 16 11:10:51 volumio volumio[7035]: info: CoreStateMachine::getcurrentVolume Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:51 volumio volumio[7035]: Starting albumart workers Feb 16 11:10:51 volumio volumio[7035]: Starting albumart workers Feb 16 11:10:51 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:51 volumio volumio[7035]: Starting albumart workers Feb 16 11:10:51 volumio volumio[7035]: info: Volumio Network Manager: Network status updated: 0 Feb 16 11:10:51 volumio volumio[7035]: info: Cannot mount NAS TPLINK at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:51 volumio volumio-remote-updater[467]: [2025-02-16 11:10:51] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739700651 101 Feb 16 11:10:52 volumio volumio[7035]: 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: 1 Feb 16 11:10:52 volumio volumio[7035]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 16 11:10:52 volumio volumio[7035]: info: Reloading queue from file Feb 16 11:10:52 volumio volumio[7035]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:52 volumio volumio[7035]: info: CoreStateMachine::pushState Feb 16 11:10:52 volumio volumio[7035]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:52 volumio volumio[7035]: info: CoreStateMachine::updateTrackBlock Feb 16 11:10:52 volumio volumio[7035]: info: CorePlayQueue::getTrackBlock Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:52 volumio volumio[7035]: info: CoreStateMachine::setRepeat null single undefined Feb 16 11:10:52 volumio volumio[7035]: info: CoreStateMachine::pushState Feb 16 11:10:52 volumio volumio[7035]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:52 volumio volumio[7035]: info: CoreStateMachine::setRandom null Feb 16 11:10:52 volumio volumio[7035]: info: CoreStateMachine::pushState Feb 16 11:10:52 volumio volumio[7035]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:52 volumio volumio[7035]: info: Setting Device type: Raspberry PI Feb 16 11:10:52 volumio volumio[7035]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 16 11:10:52 volumio volumio[7035]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Feb 16 11:10:52 volumio volumio[7035]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 16 11:10:52 volumio volumio[7035]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:52 volumio volumio[7035]: info: CoreStateMachine::pushState Feb 16 11:10:52 volumio volumio[7035]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:52 volumio volumio[7035]: info: Completed loading Core Plugins Feb 16 11:10:52 volumio volumio[7035]: info: Preparing to generate the ALSA configuration file Feb 16 11:10:52 volumio volumio[7035]: info: Asound.conf file unchanged, so no further update is needed Feb 16 11:10:52 volumio volumio[7035]: info: Output device has changed, restarting MPD Feb 16 11:10:52 volumio sudo[7170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:52 volumio sudo[7170]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:52 volumio volumio[7035]: info: ___________ START PLUGINS ___________ Feb 16 11:10:52 volumio sudo[7170]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:52 volumio volumio[7035]: info: ControllerMpd::onStart: Initializing MPD Feb 16 11:10:52 volumio volumio[7035]: info: Creating MPD Configuration file Feb 16 11:10:52 volumio sudo[7173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:52 volumio sudo[7173]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:52 volumio systemd[1]: Stopping Music Player Daemon... Feb 16 11:10:52 volumio sudo[7181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:52 volumio sudo[7181]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:52 volumio volumio[7035]: info: [1739700652447] CoreMusicLibrary::Adding element Serveurs Média Feb 16 11:10:52 volumio sudo[7181]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:52 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:52 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:52 volumio volumio[7035]: info: [1739700652465] CoreMusicLibrary::Adding element Last_100 Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:52 volumio sudo[7187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:52 volumio kernel: export_store: invalid GPIO 3 Feb 16 11:10:52 volumio sudo[7187]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:52 volumio volumio[7035]: info: [1739700652468] CoreMusicLibrary::Adding element Webradio Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:52 volumio volumio[7035]: info: Initializing BBC Radios Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: [squeezelite_mc] Starting proxy server... Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:52 volumio volumio[7035]: info: [1739700652546] CoreMusicLibrary::Adding element YouTube2 Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:52 volumio volumio[7035]: Cannot find translation for source YouTube2 Feb 16 11:10:52 volumio volumio[7035]: info: AutoStart - onStart Feb 16 11:10:52 volumio volumio[7035]: info: GPIO-Buttons: Reading config and creating triggers... Feb 16 11:10:52 volumio volumio[7035]: info: GPIO-Buttons: shutdown on pin 3 Feb 16 11:10:52 volumio volumio[7035]: error: Plugin gpio-buttons failed to start! Error: EINVAL: invalid argument, write Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:52 volumio volumio[7035]: info: [1739700652565] CoreMusicLibrary::Adding element Randomizer Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:52 volumio volumio[7035]: Cannot find translation for source YouTube2 Feb 16 11:10:52 volumio volumio[7035]: Cannot find translation for source Randomizer Feb 16 11:10:52 volumio volumio[7035]: info: Volumio Calling Home Feb 16 11:10:52 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:52 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 16 11:10:52 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:52 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:52 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:52 volumio volumio[7035]: info: [squeezelite_mc] Proxy server started on port 36591 Feb 16 11:10:52 volumio sudo[7202]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 11:10:52 volumio sudo[7202]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:52 volumio sudo[7202]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:52 volumio volumio[7035]: Unhandled rejection Error: No sockets available, cannot start. Feb 16 11:10:52 volumio volumio[7035]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 16 11:10:52 volumio volumio[7035]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 16 11:10:52 volumio volumio[7035]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 16 11:10:52 volumio volumio[7035]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 16 11:10:52 volumio volumio[7035]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 16 11:10:52 volumio volumio[7035]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 16 11:10:52 volumio volumio[7035]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 16 11:10:52 volumio volumio[7035]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 16 11:10:52 volumio volumio[7035]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 16 11:10:52 volumio volumio[7035]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 16 11:10:52 volumio volumio[7035]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 16 11:10:52 volumio volumio[7035]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 16 11:10:52 volumio volumio[7035]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 16 11:10:52 volumio volumio[7035]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 16 11:10:52 volumio volumio[7035]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 16 11:10:52 volumio volumio[7035]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 16 11:10:52 volumio volumio[7035]: info: MPD Permissions set Feb 16 11:10:52 volumio volumio[7035]: info: MPD Permissions set Feb 16 11:10:52 volumio volumio[7035]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 16 11:10:52 volumio volumio[7035]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:52 volumio volumio[7035]: info: CoreStateMachine::pushState Feb 16 11:10:52 volumio volumio[7035]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:52 volumio volumio[7035]: info: [squeezelite_mc] Server discovery started Feb 16 11:10:52 volumio volumio[7035]: info: [squeezelite_mc] Player finder started Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:52 volumio volumio[7035]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 16 11:10:52 volumio volumio[7035]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:52 volumio volumio[7035]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 16 11:10:52 volumio volumio[7035]: at doSend (dgram.js:692:16) Feb 16 11:10:52 volumio volumio[7035]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 16 11:10:52 volumio volumio[7035]: at afterDns (dgram.js:638:5) Feb 16 11:10:52 volumio volumio[7035]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 16 11:10:52 volumio volumio[7035]: errno: -101, Feb 16 11:10:52 volumio volumio[7035]: code: 'ENETUNREACH', Feb 16 11:10:52 volumio volumio[7035]: syscall: 'send', Feb 16 11:10:52 volumio volumio[7035]: address: '255.255.255.255', Feb 16 11:10:52 volumio volumio[7035]: port: 3483 Feb 16 11:10:52 volumio volumio[7035]: } Feb 16 11:10:52 volumio volumio[7035]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:10:53 volumio sudo[7227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 11:09 Feb 16 11:10:53 volumio sudo[7227]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:53 volumio sudo[7227]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:53 volumio mpd[7205]: Feb 16 11:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 16 11:10:53 volumio systemd[1]: Started Music Player Daemon. Feb 16 11:10:53 volumio sudo[7187]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:53 volumio sudo[7173]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:53 volumio volumio-remote-updater[467]: [2025-02-16 11:10:53] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 16 11:10:53 volumio volumio-remote-updater[467]: [2025-02-16 11:10:53] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 16 11:10:53 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 16 11:10:53 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 16 11:10:53 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:53 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:53 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 16 11:10:53 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 15. Feb 16 11:10:53 volumio systemd[1]: Stopped Volumio Backend Module. Feb 16 11:10:53 volumio systemd[1]: Started Volumio Backend Module. Feb 16 11:10:53 volumio systemd[1]: Started dynamicswap service. Feb 16 11:10:53 volumio systemd[1]: dynamicswap.service: Succeeded. Feb 16 11:10:54 volumio kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Feb 16 11:10:54 volumio volumio[7242]: info: ------------------------------------------- Feb 16 11:10:54 volumio volumio[7242]: info: ----- Volumio3 ---- Feb 16 11:10:54 volumio volumio[7242]: info: ------------------------------------------- Feb 16 11:10:54 volumio volumio[7242]: info: ----- System startup ---- Feb 16 11:10:54 volumio volumio[7242]: info: ------------------------------------------- Feb 16 11:10:54 volumio ifplugd(eth0)[649]: Link beat detected. Feb 16 11:10:55 volumio ifplugd(eth0)[649]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Feb 16 11:10:55 volumio dhcpcd[7282]: DUID 00:01:00:01:2d:5e:64:96:dc:a6:32:f5:8f:38 Feb 16 11:10:55 volumio dhcpcd[7282]: eth0: IAID 32:f5:8f:38 Feb 16 11:10:55 volumio dhcpcd[7282]: eth0: adding address fe80::dea6:32ff:fef5:8f38 Feb 16 11:10:55 volumio ifplugd(eth0)[649]: client: DUID 00:01:00:01:2d:5e:64:96:dc:a6:32:f5:8f:38 Feb 16 11:10:55 volumio dhcpcd[7282]: ipv6_addaddr1: Permission denied Feb 16 11:10:55 volumio ifplugd(eth0)[649]: client: eth0: IAID 32:f5:8f:38 Feb 16 11:10:55 volumio ifplugd(eth0)[649]: client: eth0: adding address fe80::dea6:32ff:fef5:8f38 Feb 16 11:10:55 volumio ifplugd(eth0)[649]: client: ipv6_addaddr1: Permission denied Feb 16 11:10:55 volumio volumio[7242]: info: MYVOLUMIO Environment detected Feb 16 11:10:55 volumio volumio[7242]: info: Plugin folders cleanup Feb 16 11:10:55 volumio volumio[7242]: info: Scanning into folder /volumio/app/plugins/ Feb 16 11:10:55 volumio volumio[7242]: info: Scanning category audio_interface Feb 16 11:10:55 volumio volumio[7242]: info: Scanning category miscellanea Feb 16 11:10:55 volumio volumio[7242]: info: Scanning category music_service Feb 16 11:10:55 volumio volumio[7242]: info: Scanning category plugins.json Feb 16 11:10:55 volumio volumio[7242]: info: Scanning category system_controller Feb 16 11:10:55 volumio volumio[7242]: info: Scanning category user_interface Feb 16 11:10:55 volumio volumio[7242]: info: Scanning into folder /data/plugins/ Feb 16 11:10:55 volumio volumio[7242]: info: Scanning category music_service Feb 16 11:10:55 volumio volumio[7242]: info: Scanning category system_controller Feb 16 11:10:55 volumio volumio[7242]: info: Scanning category system_hardware Feb 16 11:10:55 volumio volumio[7242]: info: Scanning category user_interface Feb 16 11:10:55 volumio volumio[7242]: info: Plugin folders cleanup completed Feb 16 11:10:55 volumio volumio[7242]: info: ------------------------------------------- Feb 16 11:10:55 volumio volumio[7242]: info: ----- Core plugins startup ---- Feb 16 11:10:55 volumio volumio[7242]: info: ------------------------------------------- Feb 16 11:10:55 volumio volumio[7242]: info: Loading plugins from folder /volumio/app/plugins/ Feb 16 11:10:55 volumio volumio[7242]: info: Adding plugin upnp to MyMusic Plugins Feb 16 11:10:55 volumio volumio[7242]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 16 11:10:55 volumio volumio[7242]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 16 11:10:55 volumio volumio[7242]: info: Loading plugins from folder /data/plugins/ Feb 16 11:10:55 volumio volumio[7242]: info: Loading plugin "system"... Feb 16 11:10:55 volumio volumio[7242]: info: Loading plugin "appearance"... Feb 16 11:10:55 volumio dhcpcd[7282]: eth0: soliciting a DHCP lease Feb 16 11:10:55 volumio ifplugd(eth0)[649]: client: eth0: soliciting a DHCP lease Feb 16 11:10:55 volumio dhcpcd[7282]: eth0: offered 192.168.0.104 from 192.168.0.1 Feb 16 11:10:55 volumio ifplugd(eth0)[649]: client: eth0: offered 192.168.0.104 from 192.168.0.1 Feb 16 11:10:55 volumio dhcpcd[7282]: eth0: probing address 192.168.0.104/24 Feb 16 11:10:55 volumio ifplugd(eth0)[649]: client: eth0: probing address 192.168.0.104/24 Feb 16 11:10:55 volumio dhcpcd[7282]: eth0: soliciting an IPv6 router Feb 16 11:10:55 volumio ifplugd(eth0)[649]: client: eth0: soliciting an IPv6 router Feb 16 11:10:55 volumio volumio[7242]: info: Loading plugin "network"... Feb 16 11:10:55 volumio volumio[7242]: info: Refreshing Cached IP Addresses Feb 16 11:10:55 volumio sudo[7291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 16 11:10:55 volumio sudo[7291]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:55 volumio sudo[7291]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:55 volumio sudo[7293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 16 11:10:55 volumio volumio[7242]: info: Loading plugin "services"... Feb 16 11:10:55 volumio sudo[7293]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:55 volumio volumio[7242]: info: Loading plugin "alsa_controller"... Feb 16 11:10:55 volumio sudo[7293]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:56 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "wizard"... Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "networkfs"... Feb 16 11:10:56 volumio volumio[7242]: info: Cannot mount NAS OS at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:56 volumio volumio[7242]: info: Starting Udev Watcher for removable devices Feb 16 11:10:56 volumio sudo[7316]: 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.0.1/g/Musiques /mnt/NAS/TPLINK Feb 16 11:10:56 volumio sudo[7316]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:56 volumio sudo[7316]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:56 volumio kernel: CIFS: Attempting to mount //192.168.0.1/g/Musiques Feb 16 11:10:56 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Feb 16 11:10:56 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Feb 16 11:10:56 volumio volumio[7242]: info: Ignoring mount for partition: RECOVERY Feb 16 11:10:56 volumio volumio[7242]: info: Ignoring mount for partition: root64 Feb 16 11:10:56 volumio volumio[7242]: info: Ignoring mount for partition: boot Feb 16 11:10:56 volumio volumio[7242]: info: Ignoring mount for partition: volumio Feb 16 11:10:56 volumio volumio[7242]: info: Ignoring mount for partition: volumio_data Feb 16 11:10:56 volumio volumio[7242]: error: Cannot associate FS Label, not mounting Feb 16 11:10:56 volumio volumio[7242]: info: Ignoring mount for partition: SETTINGS Feb 16 11:10:56 volumio volumio[7242]: info: Ignoring mount for partition: RECALBOX Feb 16 11:10:56 volumio volumio[7242]: info: Ignoring mount for partition: SHARE Feb 16 11:10:56 volumio volumio[7242]: info: Ignoring mount for partition: OVERLAY Feb 16 11:10:56 volumio volumio[7242]: info: Ignoring mount for partition: boot64 Feb 16 11:10:56 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "volumio_command_line_client"... Feb 16 11:10:56 volumio volumio[7242]: info: Plugin upnp is not enabled Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "my_music"... Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "mpd"... Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "upnp_browser"... Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "alarm-clock"... Feb 16 11:10:56 volumio volumio[7242]: info: Plugin airplay_emulation is not enabled Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "last_100"... Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "webradio"... Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "i2s_dacs"... Feb 16 11:10:56 volumio volumio[7242]: info: I2S DAC not set, start Auto-detection Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "volumiodiscovery"... Feb 16 11:10:56 volumio volumio[7242]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:56 volumio volumio[7242]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:56 volumio volumio[7242]: *** WARNING *** For more information see Feb 16 11:10:56 volumio node[7242]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:56 volumio volumio[7242]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:56 volumio volumio[7242]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:56 volumio volumio[7242]: *** WARNING *** For more information see Feb 16 11:10:56 volumio node[7242]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:56 volumio node[7242]: *** WARNING *** For more information see Feb 16 11:10:56 volumio node[7242]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 16 11:10:56 volumio node[7242]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 16 11:10:56 volumio node[7242]: *** WARNING *** For more information see Feb 16 11:10:56 volumio volumio[7242]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 16 11:10:56 volumio volumio[7242]: info: Discovery: Started advertising with name: Volumio Feb 16 11:10:56 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 16 11:10:56 volumio volumio[7242]: info: Plugin jellyfin is not enabled Feb 16 11:10:56 volumio volumio[7242]: info: Loading plugin "squeezelite_mc"... Feb 16 11:10:57 volumio volumio[7242]: info: Loading plugin "youtube2"... Feb 16 11:10:57 volumio volumio[7242]: info: Plugin ytcr is not enabled Feb 16 11:10:57 volumio volumio[7242]: info: Loading plugin "autostart"... Feb 16 11:10:58 volumio volumio[7242]: info: Applying required configuration parameters for plugin autostart Feb 16 11:10:58 volumio volumio[7242]: info: AutoStart - onVolumioStart - read config.json Feb 16 11:10:58 volumio volumio[7242]: info: Loading plugin "gpio-buttons"... Feb 16 11:10:58 volumio volumio[7242]: info: GPIO-Buttons initialized Feb 16 11:10:58 volumio volumio[7242]: info: Plugin now_playing is not enabled Feb 16 11:10:58 volumio volumio[7242]: info: Loading plugin "outputs"... Feb 16 11:10:58 volumio volumio[7242]: info: Loading plugin "albumart"... Feb 16 11:10:58 volumio volumio[7242]: info: Plugin example_plugin is not enabled Feb 16 11:10:58 volumio volumio[7242]: info: Loading plugin "inputs"... Feb 16 11:10:58 volumio volumio[7242]: info: Loading plugin "updater_comm"... Feb 16 11:10:58 volumio volumio[7242]: info: Plugin mpdemulation is not enabled Feb 16 11:10:58 volumio volumio[7242]: info: Loading plugin "rest_api"... Feb 16 11:10:58 volumio volumio[7242]: info: Loading plugin "websocket"... Feb 16 11:10:58 volumio volumio[7242]: info: Starting Socket.io Server version 2.3.0 Feb 16 11:10:58 volumio volumio[7242]: info: Loading plugin "Systeminfo"... Feb 16 11:10:58 volumio volumio-remote-updater[467]: [2025-02-16 11:10:58] [connect] Successful connection Feb 16 11:10:58 volumio volumio[7242]: Forking 3 albumart workers Feb 16 11:10:58 volumio volumio[7242]: info: Plugin peppyspectrum is not enabled Feb 16 11:10:58 volumio volumio[7242]: info: Loading plugin "randomizer"... Feb 16 11:10:58 volumio volumio[7242]: info: Applying required configuration parameters for plugin randomizer Feb 16 11:10:58 volumio volumio[7242]: info: Plugin touch_display is not enabled Feb 16 11:10:58 volumio volumio[7242]: info: Loading i18n strings for locale fr Feb 16 11:10:58 volumio volumio[7242]: Updating browse sources language Feb 16 11:10:58 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: Starting albumart workers Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::initPlayerControls Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: Express server listening on port 3000 Feb 16 11:10:59 volumio volumio[7242]: [Metrics] WebUI: 4s 556.35ms Feb 16 11:10:59 volumio volumio[7242]: info: CoreStateMachine::resetVolumioState Feb 16 11:10:59 volumio volumio[7242]: info: CoreStateMachine::getcurrentVolume Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:59 volumio volumio[7242]: Starting albumart workers Feb 16 11:10:59 volumio volumio[7242]: Starting albumart workers Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: info: Volumio Network Manager: Network status updated: 0 Feb 16 11:10:59 volumio volumio[7242]: info: Cannot mount NAS TPLINK at system boot, trial number 1 ,retrying in 5 seconds Feb 16 11:10:59 volumio volumio-remote-updater[467]: [2025-02-16 11:10:59] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1739700658 101 Feb 16 11:10:59 volumio volumio[7242]: 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: 1 Feb 16 11:10:59 volumio volumio[7242]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 16 11:10:59 volumio volumio[7242]: info: Reloading queue from file Feb 16 11:10:59 volumio volumio[7242]: info: CoreStateMachine::setRepeat null single undefined Feb 16 11:10:59 volumio volumio[7242]: info: CoreStateMachine::pushState Feb 16 11:10:59 volumio volumio[7242]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:59 volumio volumio[7242]: info: CoreStateMachine::setRandom null Feb 16 11:10:59 volumio volumio[7242]: info: CoreStateMachine::pushState Feb 16 11:10:59 volumio volumio[7242]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:59 volumio volumio[7242]: info: Setting Device type: Raspberry PI Feb 16 11:10:59 volumio volumio[7242]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:59 volumio volumio[7242]: info: CoreStateMachine::pushState Feb 16 11:10:59 volumio volumio[7242]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:59 volumio volumio[7242]: info: CoreStateMachine::updateTrackBlock Feb 16 11:10:59 volumio volumio[7242]: info: CorePlayQueue::getTrackBlock Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:59 volumio volumio[7242]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 16 11:10:59 volumio volumio[7242]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Feb 16 11:10:59 volumio volumio[7242]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 16 11:10:59 volumio volumio[7242]: info: Completed loading Core Plugins Feb 16 11:10:59 volumio volumio[7242]: info: Preparing to generate the ALSA configuration file Feb 16 11:10:59 volumio volumio[7242]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:10:59 volumio volumio[7242]: info: CoreStateMachine::pushState Feb 16 11:10:59 volumio volumio[7242]: info: CorePlayQueue::getTrack 0 Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioPushState Feb 16 11:10:59 volumio volumio[7242]: info: Asound.conf file unchanged, so no further update is needed Feb 16 11:10:59 volumio volumio[7242]: info: Output device has changed, restarting MPD Feb 16 11:10:59 volumio sudo[7411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:59 volumio sudo[7411]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:59 volumio volumio[7242]: info: ___________ START PLUGINS ___________ Feb 16 11:10:59 volumio sudo[7411]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:59 volumio volumio[7242]: info: ControllerMpd::onStart: Initializing MPD Feb 16 11:10:59 volumio volumio[7242]: info: Creating MPD Configuration file Feb 16 11:10:59 volumio sudo[7414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:59 volumio sudo[7414]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:59 volumio systemd[1]: Stopping Music Player Daemon... Feb 16 11:10:59 volumio sudo[7417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 16 11:10:59 volumio sudo[7417]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:59 volumio volumio[7242]: info: [1739700659730] CoreMusicLibrary::Adding element Serveurs Média Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:59 volumio sudo[7417]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:59 volumio sudo[7420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 16 11:10:59 volumio sudo[7420]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:59 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:59 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:59 volumio volumio[7242]: info: [1739700659745] CoreMusicLibrary::Adding element Last_100 Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:59 volumio volumio[7242]: info: [1739700659748] CoreMusicLibrary::Adding element Webradio Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:59 volumio volumio[7242]: info: Initializing BBC Radios Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:10:59 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:59 volumio volumio[7242]: info: [squeezelite_mc] Starting proxy server... Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:59 volumio volumio[7242]: info: [1739700659827] CoreMusicLibrary::Adding element YouTube2 Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:59 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 16 11:10:59 volumio volumio[7242]: Cannot find translation for source YouTube2 Feb 16 11:10:59 volumio systemd[1]: mpd.service: Succeeded. Feb 16 11:10:59 volumio systemd[1]: Stopped Music Player Daemon. Feb 16 11:10:59 volumio volumio[7242]: info: AutoStart - onStart Feb 16 11:10:59 volumio volumio[7242]: info: GPIO-Buttons: Reading config and creating triggers... Feb 16 11:10:59 volumio volumio[7242]: info: GPIO-Buttons: shutdown on pin 3 Feb 16 11:10:59 volumio systemd[1]: Starting Music Player Daemon... Feb 16 11:10:59 volumio volumio[7242]: error: Plugin gpio-buttons failed to start! Error: EINVAL: invalid argument, write Feb 16 11:10:59 volumio kernel: export_store: invalid GPIO 3 Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 16 11:10:59 volumio volumio[7242]: info: [1739700659850] CoreMusicLibrary::Adding element Randomizer Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 16 11:10:59 volumio volumio[7242]: Cannot find translation for source YouTube2 Feb 16 11:10:59 volumio volumio[7242]: Cannot find translation for source Randomizer Feb 16 11:10:59 volumio volumio[7242]: info: Volumio Calling Home Feb 16 11:10:59 volumio sudo[7433]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 16 11:10:59 volumio sudo[7433]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:10:59 volumio volumio[7242]: info: [squeezelite_mc] Proxy server started on port 36489 Feb 16 11:10:59 volumio sudo[7433]: pam_unix(sudo:session): session closed for user root Feb 16 11:10:59 volumio volumio[7242]: info: CoreCommandRouter::volumioRetrievevolume Feb 16 11:10:59 volumio volumio[7242]: Unhandled rejection Error: No sockets available, cannot start. Feb 16 11:10:59 volumio volumio[7242]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 16 11:10:59 volumio volumio[7242]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 16 11:10:59 volumio volumio[7242]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 16 11:10:59 volumio volumio[7242]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 16 11:10:59 volumio volumio[7242]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 16 11:10:59 volumio volumio[7242]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 16 11:10:59 volumio volumio[7242]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 16 11:10:59 volumio volumio[7242]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 16 11:10:59 volumio volumio[7242]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 16 11:10:59 volumio volumio[7242]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 16 11:10:59 volumio volumio[7242]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 16 11:10:59 volumio volumio[7242]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 16 11:10:59 volumio volumio[7242]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 16 11:10:59 volumio volumio[7242]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 16 11:10:59 volumio volumio[7242]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 16 11:10:59 volumio volumio[7242]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 16 11:11:00 volumio volumio[7242]: info: MPD Permissions set Feb 16 11:11:00 volumio volumio[7242]: info: MPD Permissions set Feb 16 11:11:00 volumio volumio[7242]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 16 11:11:00 volumio volumio[7242]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: VolumeController:: Volume=86 Mute =false Feb 16 11:11:00 volumio volumio[7242]: info: CoreStateMachine::pushState Feb 16 11:11:00 volumio volumio[7242]: info: CorePlayQueue::getTrack 0 Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::volumioPushState Feb 16 11:11:00 volumio volumio[7242]: info: [squeezelite_mc] Server discovery started Feb 16 11:11:00 volumio volumio[7242]: info: [squeezelite_mc] Player finder started Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 16 11:11:00 volumio volumio[7242]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 16 11:11:00 volumio volumio[7242]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:11:00 volumio volumio[7242]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 16 11:11:00 volumio volumio[7242]: at doSend (dgram.js:692:16) Feb 16 11:11:00 volumio volumio[7242]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 16 11:11:00 volumio volumio[7242]: at afterDns (dgram.js:638:5) Feb 16 11:11:00 volumio volumio[7242]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 16 11:11:00 volumio volumio[7242]: errno: -101, Feb 16 11:11:00 volumio volumio[7242]: code: 'ENETUNREACH', Feb 16 11:11:00 volumio volumio[7242]: syscall: 'send', Feb 16 11:11:00 volumio volumio[7242]: address: '255.255.255.255', Feb 16 11:11:00 volumio volumio[7242]: port: 3483 Feb 16 11:11:00 volumio volumio[7242]: } Feb 16 11:11:00 volumio volumio[7242]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 16 11:11:00 volumio dhcpcd[7282]: eth0: leased 192.168.0.104 for infinity Feb 16 11:11:00 volumio avahi-daemon[466]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.104. Feb 16 11:11:00 volumio avahi-daemon[466]: New relevant interface eth0.IPv4 for mDNS. Feb 16 11:11:00 volumio avahi-daemon[466]: Registering new address record for 192.168.0.104 on eth0.IPv4. Feb 16 11:11:00 volumio dhcpcd[7282]: eth0: adding route to 192.168.0.0/24 Feb 16 11:11:00 volumio dhcpcd[7282]: eth0: adding default route via 192.168.0.1 Feb 16 11:11:00 volumio ifplugd(eth0)[649]: client: eth0: leased 192.168.0.104 for infinity Feb 16 11:11:00 volumio ifplugd(eth0)[649]: client: eth0: adding route to 192.168.0.0/24 Feb 16 11:11:00 volumio ifplugd(eth0)[649]: client: eth0: adding default route via 192.168.0.1 Feb 16 11:11:00 volumio sudo[7485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-16 11:10 Feb 16 11:11:00 volumio sudo[7485]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 16 11:11:00 volumio ntpd[4315]: ntpd exiting on signal 15 (Terminated) Feb 16 11:11:00 volumio systemd[1]: Stopping Network Time Service... Feb 16 11:11:00 volumio systemd[1]: ntp.service: Succeeded. Feb 16 11:11:00 volumio systemd[1]: Stopped Network Time Service. Feb 16 11:11:00 volumio systemd[1]: Starting Network Time Service... 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"