-- Logs begin at Sat 2024-07-20 18:15:55 UTC, end at Sun 2024-07-21 11:25:20 UTC. -- Jul 21 11:24:00 volumio sshd[1190]: Received disconnect from 10.100.254.30: 11: disconnected by user Jul 21 11:24:00 volumio sshd[1190]: pam_unix(sshd:session): session closed for user root Jul 21 11:24:00 volumio systemd-logind[526]: Removed session c1. Jul 21 11:24:00 volumio systemd[1]: Stopping User Manager for UID 0... Jul 21 11:24:00 volumio systemd[1194]: Stopping Default. Jul 21 11:24:00 volumio systemd[1194]: Stopped target Default. Jul 21 11:24:00 volumio systemd[1194]: Stopping Basic System. Jul 21 11:24:00 volumio systemd[1194]: Stopped target Basic System. Jul 21 11:24:00 volumio systemd[1194]: Stopping Paths. Jul 21 11:24:00 volumio systemd[1194]: Stopped target Paths. Jul 21 11:24:00 volumio systemd[1194]: Stopping Timers. Jul 21 11:24:00 volumio systemd[1194]: Stopped target Timers. Jul 21 11:24:00 volumio systemd[1194]: Stopping Sockets. Jul 21 11:24:00 volumio systemd[1194]: Stopped target Sockets. Jul 21 11:24:00 volumio systemd[1194]: Starting Shutdown. Jul 21 11:24:00 volumio systemd[1194]: Reached target Shutdown. Jul 21 11:24:00 volumio systemd[1194]: Starting Exit the Session... Jul 21 11:24:00 volumio systemd[1194]: Received SIGRTMIN+24 from PID 1217 (kill). Jul 21 11:24:00 volumio systemd[1197]: pam_unix(systemd-user:session): session closed for user root Jul 21 11:24:00 volumio systemd[1]: Stopped User Manager for UID 0. Jul 21 11:24:00 volumio systemd[1]: Stopping user-0.slice. Jul 21 11:24:00 volumio systemd[1]: Removed slice user-0.slice. Jul 21 11:24:03 volumio volumio[912]: info: No input data Jul 21 11:24:03 volumio volumio[912]: info: CoreCommandRouter::volumioGetQueue Jul 21 11:24:03 volumio volumio[912]: info: CoreStateMachine::getQueue Jul 21 11:24:03 volumio volumio[912]: info: CorePlayQueue::getQueue Jul 21 11:24:04 volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 21 11:24:04 volumio volumio[912]: info: CURURI: music-library Jul 21 11:24:04 volumio volumio[912]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 11:24:04 volumio volumio[912]: TypeError: Cannot read property 'then' of undefined Jul 21 11:24:04 volumio volumio[912]: at ControllerMpd.lsInfo (/volumio/app/plugins/music_service/mpd/index.js:1208:16) Jul 21 11:24:04 volumio volumio[912]: at ControllerMpd.handleBrowseUri (/volumio/app/plugins/music_service/mpd/index.js:2916:25) Jul 21 11:24:04 volumio volumio[912]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1023:29) Jul 21 11:24:04 volumio volumio[912]: at CoreMusicLibrary.executeBrowseSource (/volumio/app/musiclibrary.js:334:47) Jul 21 11:24:04 volumio volumio[912]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:363:32) Jul 21 11:24:04 volumio volumio[912]: at emitTwo (events.js:126:13) Jul 21 11:24:04 volumio volumio[912]: at Socket.emit (events.js:214:7) Jul 21 11:24:04 volumio volumio[912]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jul 21 11:24:04 volumio volumio[912]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jul 21 11:24:04 volumio volumio[912]: at process._tickCallback (internal/process/next_tick.js:180:9) Jul 21 11:24:04 volumio volumio[912]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 11:24:06 volumio sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 11:23 Jul 21 11:24:06 volumio sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:06 volumio sudo[1232]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:06 volumio volumio-remote-updater[518]: [2024-07-21 11:24:06] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 21 11:24:06 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Jul 21 11:24:06 volumio volumio-remote-updater[518]: [2024-07-21 11:24:06] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 21 11:24:07 volumio systemd[1]: Unit volumio.service entered failed state. Jul 21 11:24:07 volumio systemd[1]: Starting dynamicswap service... Jul 21 11:24:07 volumio systemd[1]: Started dynamicswap service. Jul 21 11:24:07 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Jul 21 11:24:07 volumio systemd[1]: Starting dynamicswap service... Jul 21 11:24:07 volumio systemd[1]: Started dynamicswap service. Jul 21 11:24:07 volumio systemd[1]: Stopping Volumio Backend Module... Jul 21 11:24:07 volumio systemd[1]: Starting Volumio Backend Module... Jul 21 11:24:07 volumio systemd[1]: Started Volumio Backend Module. Jul 21 11:24:10 volumio volumio[1256]: info: ------------------------------------------- Jul 21 11:24:10 volumio volumio[1256]: info: ----- Volumio2 ---- Jul 21 11:24:10 volumio volumio[1256]: info: ------------------------------------------- Jul 21 11:24:10 volumio volumio[1256]: info: ----- System startup ---- Jul 21 11:24:10 volumio volumio[1256]: info: ------------------------------------------- Jul 21 11:24:10 volumio volumio[1256]: info: Plugin folders cleanup Jul 21 11:24:10 volumio volumio[1256]: info: Scanning into folder /volumio/app/plugins/ Jul 21 11:24:10 volumio volumio[1256]: info: Scanning category audio_interface Jul 21 11:24:10 volumio volumio[1256]: info: Scanning category miscellanea Jul 21 11:24:10 volumio volumio[1256]: info: Scanning category music_service Jul 21 11:24:10 volumio volumio[1256]: info: Scanning category plugins.json Jul 21 11:24:10 volumio volumio[1256]: info: Scanning category system_controller Jul 21 11:24:10 volumio volumio[1256]: info: Scanning category user_interface Jul 21 11:24:10 volumio volumio[1256]: info: Scanning into folder /data/plugins/ Jul 21 11:24:10 volumio volumio[1256]: info: Scanning category miscellanea Jul 21 11:24:10 volumio volumio[1256]: info: Scanning category music_service Jul 21 11:24:10 volumio volumio[1256]: info: Plugin folders cleanup completed Jul 21 11:24:10 volumio volumio[1256]: info: ------------------------------------------- Jul 21 11:24:10 volumio volumio[1256]: info: ----- Core plugins startup ---- Jul 21 11:24:10 volumio volumio[1256]: info: ------------------------------------------- Jul 21 11:24:10 volumio volumio[1256]: info: Loading plugins from folder /volumio/app/plugins/ Jul 21 11:24:10 volumio volumio[1256]: info: Adding plugin upnp to MyMusic Plugins Jul 21 11:24:10 volumio volumio[1256]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 21 11:24:10 volumio volumio[1256]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 21 11:24:10 volumio volumio[1256]: info: Loading plugins from folder /data/plugins/ Jul 21 11:24:10 volumio volumio[1256]: info: Loading plugin "system"... Jul 21 11:24:10 volumio volumio[1256]: info: Loading plugin "appearance"... Jul 21 11:24:11 volumio volumio-remote-updater[518]: [2024-07-21 11:24:11] [connect] Successful connection Jul 21 11:24:12 volumio volumio[1256]: info: Loading plugin "network"... Jul 21 11:24:12 volumio volumio[1256]: info: Loading plugin "services"... Jul 21 11:24:12 volumio volumio[1256]: info: Loading plugin "alsa_controller"... Jul 21 11:24:12 volumio volumio[1256]: info: Loading plugin "wizard"... Jul 21 11:24:12 volumio volumio[1256]: info: Loading plugin "volumio_command_line_client"... Jul 21 11:24:12 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:12 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:12 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:12 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:12 volumio volumio[1256]: info: Loading plugin "upnp"... Jul 21 11:24:12 volumio volumio[1256]: info: [1721561052795] Starting Upmpd Daemon Jul 21 11:24:12 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 11:24:12 volumio volumio[1256]: info: Loading plugin "my_music"... Jul 21 11:24:12 volumio volumio[1256]: info: Loading plugin "mpd"... Jul 21 11:24:13 volumio volumio[1256]: info: Loading plugin "upnp_browser"... Jul 21 11:24:14 volumio volumio[1256]: info: Loading plugin "networkfs"... Jul 21 11:24:15 volumio volumio[1256]: info: Cannot mount NAS FLAC at system boot, trial number 1 ,retrying in 5 seconds Jul 21 11:24:15 volumio volumio[1256]: info: Cannot mount NAS DSD at system boot, trial number 1 ,retrying in 5 seconds Jul 21 11:24:15 volumio volumio[1256]: info: Cannot mount NAS IRINA at system boot, trial number 1 ,retrying in 5 seconds Jul 21 11:24:15 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 11:24:15 volumio volumio[1256]: info: Loading plugin "alarm-clock"... Jul 21 11:24:15 volumio volumio[1256]: info: Loading plugin "airplay_emulation"... Jul 21 11:24:15 volumio volumio[1256]: info: Starting Shairport Sync Jul 21 11:24:15 volumio volumio[1256]: info: Loading plugin "last_100"... Jul 21 11:24:15 volumio volumio[1256]: info: Loading plugin "webradio"... Jul 21 11:24:15 volumio volumio[1256]: info: Loading plugin "i2s_dacs"... Jul 21 11:24:15 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 11:24:15 volumio volumio[1256]: info: Loading plugin "volumiodiscovery"... Jul 21 11:24:15 volumio volumio[1256]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 21 11:24:15 volumio node[1256]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 21 11:24:15 volumio node[1256]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:24:15 volumio node[1256]: *** WARNING *** For more information see Jul 21 11:24:15 volumio node[1256]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 21 11:24:15 volumio node[1256]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:24:15 volumio node[1256]: *** WARNING *** For more information see Jul 21 11:24:15 volumio volumio[1256]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:24:15 volumio volumio[1256]: *** WARNING *** For more information see Jul 21 11:24:15 volumio volumio[1256]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 21 11:24:15 volumio volumio[1256]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:24:15 volumio volumio[1256]: *** WARNING *** For more information see Jul 21 11:24:15 volumio volumio[1256]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 21 11:24:15 volumio volumio[1256]: Discovery: StartAdv! undefined Jul 21 11:24:15 volumio volumio[1256]: Discovery: Started advertising... Volumio - undefined Jul 21 11:24:15 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 11:24:15 volumio volumio[1256]: info: Loading plugin "outputs"... Jul 21 11:24:15 volumio volumio[1256]: info: Loading plugin "albumart"... Jul 21 11:24:15 volumio volumio[1256]: info: Plugin example_plugin is not enabled Jul 21 11:24:15 volumio volumio[1256]: info: Loading plugin "updater_comm"... Jul 21 11:24:16 volumio volumio[1256]: info: Plugin mpdemulation is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Loading plugin "rest_api"... Jul 21 11:24:16 volumio volumio[1256]: info: Loading plugin "websocket"... Jul 21 11:24:16 volumio volumio[1256]: info: Plugin Systeminfo is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin randomizer is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin 80s80s is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin hotelradio is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin nowyswiat is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin personal_radio is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin podcast is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin rad357pl is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin radio_paradise is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin swarmstation is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin volumio-phishin is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: Plugin volusonic is not enabled Jul 21 11:24:16 volumio volumio[1256]: info: ___________ START PLUGINS ___________ Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 11:24:16 volumio volumio[1256]: info: [1721561056278] CoreMusicLibrary::Adding element Media Servers Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 11:24:16 volumio volumio[1256]: info: [1721561056341] CoreMusicLibrary::Adding element Last_100 Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 11:24:16 volumio volumio[1256]: info: [1721561056349] CoreMusicLibrary::Adding element Webradio Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 11:24:16 volumio volumio[1256]: info: Loading i18n strings for locale en Jul 21 11:24:16 volumio volumio[1256]: Updating browse sources language Jul 21 11:24:16 volumio volumio[1256]: Cannot find translation for sourceMedia Servers Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::initPlayerControls Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 11:24:16 volumio volumio[1256]: info: BOOT COMPLETED Jul 21 11:24:16 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 11:24:16 volumio volumio[1256]: Forking 3 albumart workers Jul 21 11:24:18 volumio volumio[1256]: Starting albumart workers Jul 21 11:24:18 volumio volumio[1256]: Starting albumart workers Jul 21 11:24:18 volumio volumio[1256]: Starting albumart workers Jul 21 11:24:21 volumio volumio[1256]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jul 21 11:24:21 volumio volumio[1256]: info: CoreCommandRouter::Close All Modals sent Jul 21 11:24:21 volumio volumio[1256]: info: CoreCommandRouter::Close All Modals sent Jul 21 11:24:21 volumio volumio[1256]: Express server listening on port 3000 Jul 21 11:24:21 volumio volumio[1256]: Volumio Calling Home Jul 21 11:24:22 volumio volumio[1256]: info: CoreStateMachine::resetVolumioState Jul 21 11:24:22 volumio volumio[1256]: info: CoreStateMachine::getcurrentVolume Jul 21 11:24:22 volumio volumio[1256]: info: CoreCommandRouter::volumioRetrievevolume Jul 21 11:24:22 volumio volumio[1256]: info: Cannot mount NAS FLAC at system boot, trial number 2 ,retrying in 5 seconds Jul 21 11:24:22 volumio volumio[1256]: info: Cannot mount NAS DSD at system boot, trial number 2 ,retrying in 5 seconds Jul 21 11:24:22 volumio volumio[1256]: info: Cannot mount NAS IRINA at system boot, trial number 2 ,retrying in 5 seconds Jul 21 11:24:22 volumio volumio[1256]: info: Setting Device type: Raspberry PI Jul 21 11:24:22 volumio volumio[1256]: info: Cannot initialize MPD Connection: MPD is not running Jul 21 11:24:22 volumio volumio[1256]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jul 21 11:24:22 volumio volumio[1256]: info: VolumeController:: Volume=50 Mute =false Jul 21 11:24:22 volumio volumio[1256]: info: CoreStateMachine::pushState Jul 21 11:24:22 volumio volumio[1256]: info: CoreStateMachine::getState Jul 21 11:24:22 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Jul 21 11:24:22 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Jul 21 11:24:22 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 11:24:22 volumio volumio[1256]: info: CoreStateMachine::setRepeat false single undefined Jul 21 11:24:22 volumio volumio[1256]: info: CoreStateMachine::pushState Jul 21 11:24:22 volumio volumio[1256]: info: CoreStateMachine::getState Jul 21 11:24:22 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Jul 21 11:24:22 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Jul 21 11:24:22 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 11:24:22 volumio sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:24:22 volumio volumio[1256]: info: CoreStateMachine::setRandom false Jul 21 11:24:22 volumio volumio[1256]: info: CoreStateMachine::pushState Jul 21 11:24:22 volumio volumio[1256]: info: CoreStateMachine::getState Jul 21 11:24:22 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Jul 21 11:24:22 volumio volumio[1256]: info: CoreCommandRouter::volumioPushState Jul 21 11:24:22 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 11:24:22 volumio sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:22 volumio sudo[1326]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:22 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 21 11:24:22 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 21 11:24:23 volumio sudo[1338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jul 21 11:24:23 volumio sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:23 volumio sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jul 21 11:24:23 volumio sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:23 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Jul 21 11:24:23 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jul 21 11:24:23 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jul 21 11:24:23 volumio sudo[1338]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:23 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Jul 21 11:24:23 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jul 21 11:24:23 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jul 21 11:24:23 volumio sudo[1340]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:23 volumio shairport-sync[1355]: Successful Startup Jul 21 11:24:23 volumio volumio[1256]: Discovery: adding ed715eb4-5a50-4670-86c3-fad4a9a8d9f5 Jul 21 11:24:23 volumio volumio[1256]: info: mDNS: Found device Volumio Jul 21 11:24:23 volumio volumio[1256]: error: Could not retrieve plugin audio_interface multiroom Jul 21 11:24:23 volumio volumio[1256]: info: Shairport-Sync Started Jul 21 11:24:23 volumio sudo[1362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:24:23 volumio volumio[1256]: Error adding Membership: Error: addMembership EINVAL Jul 21 11:24:23 volumio volumio[1256]: info: Shairport-Sync Started Jul 21 11:24:23 volumio sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:23 volumio sudo[1362]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:23 volumio volumio[1256]: info: CoreCommandRouter::volumioGetState Jul 21 11:24:23 volumio volumio[1256]: info: CoreStateMachine::getState Jul 21 11:24:23 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Jul 21 11:24:23 volumio sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 21 11:24:23 volumio sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:23 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jul 21 11:24:23 volumio sudo[1371]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:23 volumio sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:24:23 volumio sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:23 volumio sudo[1375]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:23 volumio volumio[1256]: info: Upmpdcli Daemon Started Jul 21 11:24:24 volumio volumio-remote-updater[518]: [2024-07-21 11:24:24] [connect] Successful connection Jul 21 11:24:24 volumio volumio-remote-updater[518]: [2024-07-21 11:24:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1721561064 101 Jul 21 11:24:25 volumio volumio[1256]: info: CoreCommandRouter::volumioGetVisibleSources Jul 21 11:24:25 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:24:25 volumio volumio[1256]: info: CoreCommandRouter::volumioGetState Jul 21 11:24:25 volumio volumio[1256]: info: CoreStateMachine::getState Jul 21 11:24:25 volumio volumio[1256]: info: CorePlayQueue::getTrack 0 Jul 21 11:24:25 volumio sudo[1390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:24:25 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 21 11:24:25 volumio volumio[1256]: error: Could not retrieve plugin audio_interface multiroom Jul 21 11:24:25 volumio volumio[1256]: info: Listing playlists Jul 21 11:24:25 volumio volumio[1256]: info: CoreCommandRouter::volumioGetQueue Jul 21 11:24:25 volumio volumio[1256]: info: CoreStateMachine::getQueue Jul 21 11:24:25 volumio volumio[1256]: info: CorePlayQueue::getQueue Jul 21 11:24:25 volumio sudo[1390]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:25 volumio sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:24:25 volumio sudo[1390]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:25 volumio sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:25 volumio sudo[1394]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:27 volumio volumio[1256]: info: Cannot mount NAS FLAC at system boot, trial number 3 ,retrying in 5 seconds Jul 21 11:24:27 volumio volumio[1256]: info: Cannot mount NAS DSD at system boot, trial number 3 ,retrying in 5 seconds Jul 21 11:24:27 volumio volumio[1256]: info: Cannot mount NAS IRINA at system boot, trial number 3 ,retrying in 5 seconds Jul 21 11:24:30 volumio volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 21 11:24:30 volumio volumio[1256]: info: CURURI: music-library Jul 21 11:24:30 volumio volumio[1256]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 11:24:31 volumio volumio[1256]: TypeError: Cannot read property 'then' of undefined Jul 21 11:24:31 volumio volumio[1256]: at ControllerMpd.lsInfo (/volumio/app/plugins/music_service/mpd/index.js:1208:16) Jul 21 11:24:31 volumio volumio[1256]: at ControllerMpd.handleBrowseUri (/volumio/app/plugins/music_service/mpd/index.js:2916:25) Jul 21 11:24:31 volumio volumio[1256]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1023:29) Jul 21 11:24:31 volumio volumio[1256]: at CoreMusicLibrary.executeBrowseSource (/volumio/app/musiclibrary.js:334:47) Jul 21 11:24:31 volumio volumio[1256]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:363:32) Jul 21 11:24:31 volumio volumio[1256]: at emitTwo (events.js:126:13) Jul 21 11:24:31 volumio volumio[1256]: at Socket.emit (events.js:214:7) Jul 21 11:24:31 volumio volumio[1256]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jul 21 11:24:31 volumio volumio[1256]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jul 21 11:24:31 volumio volumio[1256]: at process._tickCallback (internal/process/next_tick.js:180:9) Jul 21 11:24:31 volumio volumio[1256]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 11:24:32 volumio sudo[1415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 11:23 Jul 21 11:24:32 volumio sudo[1415]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:32 volumio sudo[1415]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:32 volumio volumio-remote-updater[518]: [2024-07-21 11:24:32] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 21 11:24:32 volumio volumio-remote-updater[518]: [2024-07-21 11:24:32] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 21 11:24:32 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Jul 21 11:24:32 volumio systemd[1]: Unit volumio.service entered failed state. Jul 21 11:24:32 volumio systemd[1]: Starting dynamicswap service... Jul 21 11:24:32 volumio systemd[1]: Started dynamicswap service. Jul 21 11:24:32 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Jul 21 11:24:32 volumio systemd[1]: Starting dynamicswap service... Jul 21 11:24:32 volumio systemd[1]: Started dynamicswap service. Jul 21 11:24:32 volumio systemd[1]: Stopping Volumio Backend Module... Jul 21 11:24:32 volumio systemd[1]: Starting Volumio Backend Module... Jul 21 11:24:32 volumio systemd[1]: Started Volumio Backend Module. Jul 21 11:24:35 volumio volumio[1436]: info: ------------------------------------------- Jul 21 11:24:35 volumio volumio[1436]: info: ----- Volumio2 ---- Jul 21 11:24:35 volumio volumio[1436]: info: ------------------------------------------- Jul 21 11:24:35 volumio volumio[1436]: info: ----- System startup ---- Jul 21 11:24:35 volumio volumio[1436]: info: ------------------------------------------- Jul 21 11:24:35 volumio volumio[1436]: info: Plugin folders cleanup Jul 21 11:24:35 volumio volumio[1436]: info: Scanning into folder /volumio/app/plugins/ Jul 21 11:24:35 volumio volumio[1436]: info: Scanning category audio_interface Jul 21 11:24:35 volumio volumio[1436]: info: Scanning category miscellanea Jul 21 11:24:35 volumio volumio[1436]: info: Scanning category music_service Jul 21 11:24:35 volumio volumio[1436]: info: Scanning category plugins.json Jul 21 11:24:35 volumio volumio[1436]: info: Scanning category system_controller Jul 21 11:24:35 volumio volumio[1436]: info: Scanning category user_interface Jul 21 11:24:35 volumio volumio[1436]: info: Scanning into folder /data/plugins/ Jul 21 11:24:35 volumio volumio[1436]: info: Scanning category miscellanea Jul 21 11:24:35 volumio volumio[1436]: info: Scanning category music_service Jul 21 11:24:35 volumio volumio[1436]: info: Plugin folders cleanup completed Jul 21 11:24:35 volumio volumio[1436]: info: ------------------------------------------- Jul 21 11:24:35 volumio volumio[1436]: info: ----- Core plugins startup ---- Jul 21 11:24:35 volumio volumio[1436]: info: ------------------------------------------- Jul 21 11:24:35 volumio volumio[1436]: info: Loading plugins from folder /volumio/app/plugins/ Jul 21 11:24:35 volumio volumio[1436]: info: Adding plugin upnp to MyMusic Plugins Jul 21 11:24:35 volumio volumio[1436]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 21 11:24:35 volumio volumio[1436]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 21 11:24:35 volumio volumio[1436]: info: Loading plugins from folder /data/plugins/ Jul 21 11:24:35 volumio volumio[1436]: info: Loading plugin "system"... Jul 21 11:24:35 volumio volumio[1436]: info: Loading plugin "appearance"... Jul 21 11:24:37 volumio volumio[1436]: info: Loading plugin "network"... Jul 21 11:24:37 volumio volumio-remote-updater[518]: [2024-07-21 11:24:37] [connect] Successful connection Jul 21 11:24:38 volumio volumio[1436]: info: Loading plugin "services"... Jul 21 11:24:38 volumio volumio[1436]: info: Loading plugin "alsa_controller"... Jul 21 11:24:38 volumio volumio[1436]: info: Loading plugin "wizard"... Jul 21 11:24:38 volumio volumio[1436]: info: Loading plugin "volumio_command_line_client"... Jul 21 11:24:38 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:38 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:38 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:38 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:38 volumio volumio[1436]: info: Loading plugin "upnp"... Jul 21 11:24:38 volumio volumio[1436]: info: [1721561078320] Starting Upmpd Daemon Jul 21 11:24:38 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 11:24:38 volumio volumio[1436]: info: Loading plugin "my_music"... Jul 21 11:24:38 volumio volumio[1436]: info: Loading plugin "mpd"... Jul 21 11:24:38 volumio volumio[1436]: info: Loading plugin "upnp_browser"... Jul 21 11:24:40 volumio volumio[1436]: info: Loading plugin "networkfs"... Jul 21 11:24:41 volumio volumio[1436]: info: Cannot mount NAS FLAC at system boot, trial number 1 ,retrying in 5 seconds Jul 21 11:24:41 volumio volumio[1436]: info: Cannot mount NAS DSD at system boot, trial number 1 ,retrying in 5 seconds Jul 21 11:24:41 volumio volumio[1436]: info: Cannot mount NAS IRINA at system boot, trial number 1 ,retrying in 5 seconds Jul 21 11:24:41 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "alarm-clock"... Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "airplay_emulation"... Jul 21 11:24:41 volumio volumio[1436]: info: Starting Shairport Sync Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "last_100"... Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "webradio"... Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "i2s_dacs"... Jul 21 11:24:41 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "volumiodiscovery"... Jul 21 11:24:41 volumio volumio[1436]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 21 11:24:41 volumio node[1436]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 21 11:24:41 volumio node[1436]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:24:41 volumio node[1436]: *** WARNING *** For more information see Jul 21 11:24:41 volumio node[1436]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 21 11:24:41 volumio node[1436]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:24:41 volumio node[1436]: *** WARNING *** For more information see Jul 21 11:24:41 volumio volumio[1436]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:24:41 volumio volumio[1436]: *** WARNING *** For more information see Jul 21 11:24:41 volumio volumio[1436]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 21 11:24:41 volumio volumio[1436]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:24:41 volumio volumio[1436]: *** WARNING *** For more information see Jul 21 11:24:41 volumio volumio[1436]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 21 11:24:41 volumio volumio[1436]: Discovery: StartAdv! undefined Jul 21 11:24:41 volumio volumio[1436]: Discovery: Started advertising... Volumio - undefined Jul 21 11:24:41 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "outputs"... Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "albumart"... Jul 21 11:24:41 volumio volumio[1436]: info: Plugin example_plugin is not enabled Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "updater_comm"... Jul 21 11:24:41 volumio volumio[1436]: info: Plugin mpdemulation is not enabled Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "rest_api"... Jul 21 11:24:41 volumio volumio[1436]: info: Loading plugin "websocket"... Jul 21 11:24:42 volumio volumio[1436]: info: Plugin Systeminfo is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin randomizer is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin 80s80s is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin hotelradio is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin nowyswiat is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin personal_radio is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin podcast is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin rad357pl is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin radio_paradise is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin swarmstation is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin volumio-phishin is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: Plugin volusonic is not enabled Jul 21 11:24:42 volumio volumio[1436]: info: ___________ START PLUGINS ___________ Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 11:24:42 volumio volumio[1436]: info: [1721561082058] CoreMusicLibrary::Adding element Media Servers Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 11:24:42 volumio volumio[1436]: info: [1721561082121] CoreMusicLibrary::Adding element Last_100 Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 11:24:42 volumio volumio[1436]: info: [1721561082129] CoreMusicLibrary::Adding element Webradio Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 11:24:42 volumio volumio[1436]: info: Loading i18n strings for locale en Jul 21 11:24:42 volumio volumio[1436]: Updating browse sources language Jul 21 11:24:42 volumio volumio[1436]: Cannot find translation for sourceMedia Servers Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::initPlayerControls Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 11:24:42 volumio volumio[1436]: info: BOOT COMPLETED Jul 21 11:24:42 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 11:24:42 volumio volumio[1436]: Forking 3 albumart workers Jul 21 11:24:44 volumio volumio[1436]: Starting albumart workers Jul 21 11:24:44 volumio volumio[1436]: Starting albumart workers Jul 21 11:24:44 volumio volumio[1436]: Starting albumart workers Jul 21 11:24:47 volumio volumio[1436]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jul 21 11:24:47 volumio volumio[1436]: info: CoreCommandRouter::Close All Modals sent Jul 21 11:24:47 volumio volumio[1436]: info: CoreCommandRouter::Close All Modals sent Jul 21 11:24:47 volumio volumio[1436]: Express server listening on port 3000 Jul 21 11:24:47 volumio volumio[1436]: Volumio Calling Home Jul 21 11:24:47 volumio volumio[1436]: info: CoreStateMachine::resetVolumioState Jul 21 11:24:47 volumio volumio[1436]: info: CoreStateMachine::getcurrentVolume Jul 21 11:24:47 volumio volumio[1436]: info: CoreCommandRouter::volumioRetrievevolume Jul 21 11:24:47 volumio volumio[1436]: info: Cannot mount NAS FLAC at system boot, trial number 2 ,retrying in 5 seconds Jul 21 11:24:47 volumio volumio[1436]: info: Cannot mount NAS DSD at system boot, trial number 2 ,retrying in 5 seconds Jul 21 11:24:47 volumio volumio[1436]: info: Cannot mount NAS IRINA at system boot, trial number 2 ,retrying in 5 seconds Jul 21 11:24:48 volumio volumio[1436]: info: Setting Device type: Raspberry PI Jul 21 11:24:48 volumio volumio[1436]: info: Cannot initialize MPD Connection: MPD is not running Jul 21 11:24:48 volumio volumio[1436]: info: VolumeController:: Volume=50 Mute =false Jul 21 11:24:48 volumio volumio[1436]: info: CoreStateMachine::pushState Jul 21 11:24:48 volumio volumio[1436]: info: CoreStateMachine::getState Jul 21 11:24:48 volumio volumio[1436]: info: CorePlayQueue::getTrack 0 Jul 21 11:24:48 volumio volumio[1436]: info: CoreCommandRouter::volumioPushState Jul 21 11:24:48 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 11:24:48 volumio sudo[1506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:24:48 volumio sudo[1506]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:48 volumio sudo[1506]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:48 volumio volumio[1436]: info: CoreStateMachine::setRepeat false single undefined Jul 21 11:24:48 volumio volumio[1436]: info: CoreStateMachine::pushState Jul 21 11:24:48 volumio volumio[1436]: info: CoreStateMachine::getState Jul 21 11:24:48 volumio volumio[1436]: info: CorePlayQueue::getTrack 0 Jul 21 11:24:48 volumio volumio[1436]: info: CoreCommandRouter::volumioPushState Jul 21 11:24:48 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 11:24:48 volumio volumio[1436]: info: CoreStateMachine::setRandom false Jul 21 11:24:48 volumio volumio[1436]: info: CoreStateMachine::pushState Jul 21 11:24:48 volumio volumio[1436]: info: CoreStateMachine::getState Jul 21 11:24:48 volumio volumio[1436]: info: CorePlayQueue::getTrack 0 Jul 21 11:24:48 volumio volumio[1436]: info: CoreCommandRouter::volumioPushState Jul 21 11:24:48 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 11:24:48 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 21 11:24:48 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 21 11:24:48 volumio sudo[1518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jul 21 11:24:48 volumio sudo[1518]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:48 volumio sudo[1520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jul 21 11:24:48 volumio sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:48 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Jul 21 11:24:48 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jul 21 11:24:48 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jul 21 11:24:48 volumio sudo[1518]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:48 volumio shairport-sync[1530]: Successful Startup Jul 21 11:24:48 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Jul 21 11:24:48 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jul 21 11:24:48 volumio volumio[1436]: Discovery: adding ed715eb4-5a50-4670-86c3-fad4a9a8d9f5 Jul 21 11:24:48 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jul 21 11:24:48 volumio volumio[1436]: info: mDNS: Found device Volumio Jul 21 11:24:48 volumio sudo[1520]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:49 volumio shairport-sync[1536]: Successful Startup Jul 21 11:24:49 volumio volumio[1436]: error: Could not retrieve plugin audio_interface multiroom Jul 21 11:24:49 volumio sudo[1542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:24:49 volumio sudo[1542]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:49 volumio sudo[1542]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:49 volumio volumio[1436]: info: Shairport-Sync Started Jul 21 11:24:49 volumio sudo[1552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 21 11:24:49 volumio volumio[1436]: Error adding Membership: Error: addMembership EINVAL Jul 21 11:24:49 volumio volumio[1436]: info: Shairport-Sync Started Jul 21 11:24:49 volumio sudo[1552]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:49 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jul 21 11:24:49 volumio sudo[1552]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:49 volumio volumio[1436]: info: CoreCommandRouter::volumioGetState Jul 21 11:24:49 volumio volumio[1436]: info: CoreStateMachine::getState Jul 21 11:24:49 volumio volumio[1436]: info: CorePlayQueue::getTrack 0 Jul 21 11:24:49 volumio sudo[1561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:24:49 volumio sudo[1561]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:49 volumio sudo[1561]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:49 volumio volumio[1436]: info: Upmpdcli Daemon Started Jul 21 11:24:50 volumio volumio-remote-updater[518]: [2024-07-21 11:24:50] [connect] Successful connection Jul 21 11:24:50 volumio volumio-remote-updater[518]: [2024-07-21 11:24:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1721561090 101 Jul 21 11:24:50 volumio volumio[1436]: info: CoreCommandRouter::volumioGetVisibleSources Jul 21 11:24:50 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:24:50 volumio volumio[1436]: info: CoreCommandRouter::volumioGetState Jul 21 11:24:50 volumio volumio[1436]: info: CoreStateMachine::getState Jul 21 11:24:50 volumio volumio[1436]: info: CorePlayQueue::getTrack 0 Jul 21 11:24:50 volumio sudo[1570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:24:50 volumio sudo[1570]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:50 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 21 11:24:50 volumio volumio[1436]: error: Could not retrieve plugin audio_interface multiroom Jul 21 11:24:50 volumio volumio[1436]: info: Listing playlists Jul 21 11:24:50 volumio volumio[1436]: info: CoreCommandRouter::volumioGetQueue Jul 21 11:24:50 volumio volumio[1436]: info: CoreStateMachine::getQueue Jul 21 11:24:50 volumio volumio[1436]: info: CorePlayQueue::getQueue Jul 21 11:24:50 volumio sudo[1570]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:50 volumio sudo[1574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:24:50 volumio sudo[1574]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:50 volumio sudo[1574]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:52 volumio volumio[1436]: info: Cannot mount NAS FLAC at system boot, trial number 3 ,retrying in 5 seconds Jul 21 11:24:52 volumio volumio[1436]: info: Cannot mount NAS DSD at system boot, trial number 3 ,retrying in 5 seconds Jul 21 11:24:52 volumio volumio[1436]: info: Cannot mount NAS IRINA at system boot, trial number 3 ,retrying in 5 seconds Jul 21 11:24:55 volumio volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 21 11:24:55 volumio volumio[1436]: info: CURURI: music-library Jul 21 11:24:55 volumio volumio[1436]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 11:24:55 volumio volumio[1436]: TypeError: Cannot read property 'then' of undefined Jul 21 11:24:55 volumio volumio[1436]: at ControllerMpd.lsInfo (/volumio/app/plugins/music_service/mpd/index.js:1208:16) Jul 21 11:24:55 volumio volumio[1436]: at ControllerMpd.handleBrowseUri (/volumio/app/plugins/music_service/mpd/index.js:2916:25) Jul 21 11:24:55 volumio volumio[1436]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1023:29) Jul 21 11:24:55 volumio volumio[1436]: at CoreMusicLibrary.executeBrowseSource (/volumio/app/musiclibrary.js:334:47) Jul 21 11:24:55 volumio volumio[1436]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:363:32) Jul 21 11:24:55 volumio volumio[1436]: at emitTwo (events.js:126:13) Jul 21 11:24:55 volumio volumio[1436]: at Socket.emit (events.js:214:7) Jul 21 11:24:55 volumio volumio[1436]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jul 21 11:24:55 volumio volumio[1436]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jul 21 11:24:55 volumio volumio[1436]: at process._tickCallback (internal/process/next_tick.js:180:9) Jul 21 11:24:55 volumio volumio[1436]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 11:24:56 volumio sudo[1595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 11:23 Jul 21 11:24:56 volumio sudo[1595]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:24:56 volumio sudo[1595]: pam_unix(sudo:session): session closed for user root Jul 21 11:24:57 volumio volumio-remote-updater[518]: [2024-07-21 11:24:57] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 21 11:24:57 volumio volumio-remote-updater[518]: [2024-07-21 11:24:57] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 21 11:24:57 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Jul 21 11:24:57 volumio systemd[1]: Unit volumio.service entered failed state. Jul 21 11:24:57 volumio systemd[1]: Starting dynamicswap service... Jul 21 11:24:57 volumio systemd[1]: Started dynamicswap service. Jul 21 11:24:57 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Jul 21 11:24:57 volumio systemd[1]: Starting dynamicswap service... Jul 21 11:24:57 volumio systemd[1]: Started dynamicswap service. Jul 21 11:24:57 volumio systemd[1]: Stopping Volumio Backend Module... Jul 21 11:24:57 volumio systemd[1]: Starting Volumio Backend Module... Jul 21 11:24:57 volumio systemd[1]: Started Volumio Backend Module. Jul 21 11:25:00 volumio volumio[1616]: info: ------------------------------------------- Jul 21 11:25:00 volumio volumio[1616]: info: ----- Volumio2 ---- Jul 21 11:25:00 volumio volumio[1616]: info: ------------------------------------------- Jul 21 11:25:00 volumio volumio[1616]: info: ----- System startup ---- Jul 21 11:25:00 volumio volumio[1616]: info: ------------------------------------------- Jul 21 11:25:00 volumio volumio[1616]: info: Plugin folders cleanup Jul 21 11:25:00 volumio volumio[1616]: info: Scanning into folder /volumio/app/plugins/ Jul 21 11:25:00 volumio volumio[1616]: info: Scanning category audio_interface Jul 21 11:25:00 volumio volumio[1616]: info: Scanning category miscellanea Jul 21 11:25:00 volumio volumio[1616]: info: Scanning category music_service Jul 21 11:25:00 volumio volumio[1616]: info: Scanning category plugins.json Jul 21 11:25:00 volumio volumio[1616]: info: Scanning category system_controller Jul 21 11:25:00 volumio volumio[1616]: info: Scanning category user_interface Jul 21 11:25:00 volumio volumio[1616]: info: Scanning into folder /data/plugins/ Jul 21 11:25:00 volumio volumio[1616]: info: Scanning category miscellanea Jul 21 11:25:00 volumio volumio[1616]: info: Scanning category music_service Jul 21 11:25:00 volumio volumio[1616]: info: Plugin folders cleanup completed Jul 21 11:25:00 volumio volumio[1616]: info: ------------------------------------------- Jul 21 11:25:00 volumio volumio[1616]: info: ----- Core plugins startup ---- Jul 21 11:25:00 volumio volumio[1616]: info: ------------------------------------------- Jul 21 11:25:00 volumio volumio[1616]: info: Loading plugins from folder /volumio/app/plugins/ Jul 21 11:25:00 volumio volumio[1616]: info: Adding plugin upnp to MyMusic Plugins Jul 21 11:25:00 volumio volumio[1616]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 21 11:25:00 volumio volumio[1616]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 21 11:25:00 volumio volumio[1616]: info: Loading plugins from folder /data/plugins/ Jul 21 11:25:00 volumio volumio[1616]: info: Loading plugin "system"... Jul 21 11:25:00 volumio volumio[1616]: info: Loading plugin "appearance"... Jul 21 11:25:02 volumio volumio-remote-updater[518]: [2024-07-21 11:25:02] [connect] Successful connection Jul 21 11:25:02 volumio volumio[1616]: info: Loading plugin "network"... Jul 21 11:25:02 volumio volumio[1616]: info: Loading plugin "services"... Jul 21 11:25:02 volumio volumio[1616]: info: Loading plugin "alsa_controller"... Jul 21 11:25:02 volumio volumio[1616]: info: Loading plugin "wizard"... Jul 21 11:25:02 volumio volumio[1616]: info: Loading plugin "volumio_command_line_client"... Jul 21 11:25:02 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:25:02 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:25:02 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:25:02 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:25:02 volumio volumio[1616]: info: Loading plugin "upnp"... Jul 21 11:25:02 volumio volumio[1616]: info: [1721561102849] Starting Upmpd Daemon Jul 21 11:25:02 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 11:25:02 volumio volumio[1616]: info: Loading plugin "my_music"... Jul 21 11:25:02 volumio volumio[1616]: info: Loading plugin "mpd"... Jul 21 11:25:03 volumio volumio[1616]: info: Loading plugin "upnp_browser"... Jul 21 11:25:04 volumio volumio[1616]: info: Loading plugin "networkfs"... Jul 21 11:25:05 volumio volumio[1616]: info: Cannot mount NAS FLAC at system boot, trial number 1 ,retrying in 5 seconds Jul 21 11:25:05 volumio volumio[1616]: info: Cannot mount NAS DSD at system boot, trial number 1 ,retrying in 5 seconds Jul 21 11:25:05 volumio volumio[1616]: info: Cannot mount NAS IRINA at system boot, trial number 1 ,retrying in 5 seconds Jul 21 11:25:05 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 11:25:05 volumio volumio[1616]: info: Loading plugin "alarm-clock"... Jul 21 11:25:05 volumio volumio[1616]: info: Loading plugin "airplay_emulation"... Jul 21 11:25:05 volumio volumio[1616]: info: Starting Shairport Sync Jul 21 11:25:05 volumio volumio[1616]: info: Loading plugin "last_100"... Jul 21 11:25:05 volumio volumio[1616]: info: Loading plugin "webradio"... Jul 21 11:25:05 volumio volumio[1616]: info: Loading plugin "i2s_dacs"... Jul 21 11:25:05 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 11:25:05 volumio volumio[1616]: info: Loading plugin "volumiodiscovery"... Jul 21 11:25:05 volumio volumio[1616]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 21 11:25:05 volumio node[1616]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 21 11:25:05 volumio node[1616]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:25:05 volumio node[1616]: *** WARNING *** For more information see Jul 21 11:25:05 volumio node[1616]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 21 11:25:05 volumio node[1616]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:25:05 volumio node[1616]: *** WARNING *** For more information see Jul 21 11:25:05 volumio volumio[1616]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:25:05 volumio volumio[1616]: *** WARNING *** For more information see Jul 21 11:25:05 volumio volumio[1616]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 21 11:25:05 volumio volumio[1616]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 21 11:25:05 volumio volumio[1616]: *** WARNING *** For more information see Jul 21 11:25:05 volumio volumio[1616]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 21 11:25:05 volumio volumio[1616]: Discovery: StartAdv! undefined Jul 21 11:25:05 volumio volumio[1616]: Discovery: Started advertising... Volumio - undefined Jul 21 11:25:05 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 21 11:25:05 volumio volumio[1616]: info: Loading plugin "outputs"... Jul 21 11:25:05 volumio volumio[1616]: info: Loading plugin "albumart"... Jul 21 11:25:05 volumio volumio[1616]: info: Plugin example_plugin is not enabled Jul 21 11:25:05 volumio volumio[1616]: info: Loading plugin "updater_comm"... Jul 21 11:25:06 volumio volumio[1616]: info: Plugin mpdemulation is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Loading plugin "rest_api"... Jul 21 11:25:06 volumio volumio[1616]: info: Loading plugin "websocket"... Jul 21 11:25:06 volumio volumio[1616]: info: Plugin Systeminfo is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin randomizer is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin 80s80s is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin hotelradio is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin nowyswiat is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin personal_radio is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin podcast is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin rad357pl is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin radio_paradise is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin swarmstation is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin volumio-phishin is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: Plugin volusonic is not enabled Jul 21 11:25:06 volumio volumio[1616]: info: ___________ START PLUGINS ___________ Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 11:25:06 volumio volumio[1616]: info: [1721561106307] CoreMusicLibrary::Adding element Media Servers Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 11:25:06 volumio volumio[1616]: info: [1721561106372] CoreMusicLibrary::Adding element Last_100 Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 21 11:25:06 volumio volumio[1616]: info: [1721561106381] CoreMusicLibrary::Adding element Webradio Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 21 11:25:06 volumio volumio[1616]: info: Loading i18n strings for locale en Jul 21 11:25:06 volumio volumio[1616]: Updating browse sources language Jul 21 11:25:06 volumio volumio[1616]: Cannot find translation for sourceMedia Servers Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::initPlayerControls Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 21 11:25:06 volumio volumio[1616]: Forking 3 albumart workers Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 21 11:25:06 volumio volumio[1616]: info: BOOT COMPLETED Jul 21 11:25:06 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 21 11:25:08 volumio volumio[1616]: Starting albumart workers Jul 21 11:25:08 volumio volumio[1616]: Starting albumart workers Jul 21 11:25:08 volumio volumio[1616]: Starting albumart workers Jul 21 11:25:11 volumio volumio[1616]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jul 21 11:25:11 volumio volumio[1616]: info: CoreCommandRouter::Close All Modals sent Jul 21 11:25:11 volumio volumio[1616]: info: CoreCommandRouter::Close All Modals sent Jul 21 11:25:11 volumio volumio[1616]: Express server listening on port 3000 Jul 21 11:25:11 volumio volumio[1616]: Volumio Calling Home Jul 21 11:25:12 volumio volumio[1616]: info: CoreStateMachine::resetVolumioState Jul 21 11:25:12 volumio volumio[1616]: info: CoreStateMachine::getcurrentVolume Jul 21 11:25:12 volumio volumio[1616]: info: CoreCommandRouter::volumioRetrievevolume Jul 21 11:25:12 volumio volumio[1616]: info: Cannot mount NAS FLAC at system boot, trial number 2 ,retrying in 5 seconds Jul 21 11:25:12 volumio volumio[1616]: info: Cannot mount NAS DSD at system boot, trial number 2 ,retrying in 5 seconds Jul 21 11:25:12 volumio volumio[1616]: info: Cannot mount NAS IRINA at system boot, trial number 2 ,retrying in 5 seconds Jul 21 11:25:12 volumio volumio[1616]: info: Setting Device type: Raspberry PI Jul 21 11:25:12 volumio volumio[1616]: info: Cannot initialize MPD Connection: MPD is not running Jul 21 11:25:12 volumio volumio[1616]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jul 21 11:25:12 volumio volumio[1616]: info: VolumeController:: Volume=50 Mute =false Jul 21 11:25:12 volumio volumio[1616]: info: CoreStateMachine::pushState Jul 21 11:25:12 volumio volumio[1616]: info: CoreStateMachine::getState Jul 21 11:25:12 volumio volumio[1616]: info: CorePlayQueue::getTrack 0 Jul 21 11:25:12 volumio volumio[1616]: info: CoreCommandRouter::volumioPushState Jul 21 11:25:12 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 11:25:12 volumio sudo[1686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:25:12 volumio sudo[1686]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:25:12 volumio sudo[1686]: pam_unix(sudo:session): session closed for user root Jul 21 11:25:13 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 21 11:25:13 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 21 11:25:13 volumio volumio[1616]: info: CoreStateMachine::setRepeat false single undefined Jul 21 11:25:13 volumio volumio[1616]: info: CoreStateMachine::pushState Jul 21 11:25:13 volumio volumio[1616]: info: CoreStateMachine::getState Jul 21 11:25:13 volumio volumio[1616]: info: CorePlayQueue::getTrack 0 Jul 21 11:25:13 volumio volumio[1616]: info: CoreCommandRouter::volumioPushState Jul 21 11:25:13 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 11:25:13 volumio volumio[1616]: info: CoreStateMachine::setRandom false Jul 21 11:25:13 volumio volumio[1616]: info: CoreStateMachine::pushState Jul 21 11:25:13 volumio volumio[1616]: info: CoreStateMachine::getState Jul 21 11:25:13 volumio volumio[1616]: info: CorePlayQueue::getTrack 0 Jul 21 11:25:13 volumio volumio[1616]: info: CoreCommandRouter::volumioPushState Jul 21 11:25:13 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 21 11:25:13 volumio sudo[1698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jul 21 11:25:13 volumio sudo[1698]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:25:13 volumio sudo[1700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jul 21 11:25:13 volumio sudo[1700]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:25:13 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Jul 21 11:25:13 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jul 21 11:25:13 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jul 21 11:25:13 volumio sudo[1698]: pam_unix(sudo:session): session closed for user root Jul 21 11:25:13 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Jul 21 11:25:13 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Jul 21 11:25:13 volumio systemd[1]: Started ShairportSync AirTunes receiver. Jul 21 11:25:13 volumio sudo[1700]: pam_unix(sudo:session): session closed for user root Jul 21 11:25:13 volumio shairport-sync[1715]: Successful Startup Jul 21 11:25:13 volumio volumio[1616]: Discovery: adding ed715eb4-5a50-4670-86c3-fad4a9a8d9f5 Jul 21 11:25:13 volumio volumio[1616]: info: mDNS: Found device Volumio Jul 21 11:25:13 volumio volumio[1616]: error: Could not retrieve plugin audio_interface multiroom Jul 21 11:25:13 volumio sudo[1722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:25:13 volumio sudo[1722]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:25:13 volumio sudo[1722]: pam_unix(sudo:session): session closed for user root Jul 21 11:25:13 volumio sudo[1726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 21 11:25:13 volumio sudo[1726]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:25:13 volumio sudo[1731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:25:13 volumio sudo[1726]: pam_unix(sudo:session): session closed for user root Jul 21 11:25:13 volumio sudo[1731]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:25:13 volumio sudo[1731]: pam_unix(sudo:session): session closed for user root Jul 21 11:25:13 volumio volumio[1616]: info: Shairport-Sync Started Jul 21 11:25:13 volumio sudo[1749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 21 11:25:13 volumio volumio[1616]: Error adding Membership: Error: addMembership EINVAL Jul 21 11:25:13 volumio volumio[1616]: info: Shairport-Sync Started Jul 21 11:25:13 volumio sudo[1749]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:25:13 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jul 21 11:25:13 volumio sudo[1749]: pam_unix(sudo:session): session closed for user root Jul 21 11:25:13 volumio volumio[1616]: info: CoreCommandRouter::volumioGetState Jul 21 11:25:13 volumio volumio[1616]: info: CoreStateMachine::getState Jul 21 11:25:13 volumio volumio[1616]: info: CorePlayQueue::getTrack 0 Jul 21 11:25:13 volumio sudo[1758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:25:13 volumio sudo[1758]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:25:13 volumio sudo[1758]: pam_unix(sudo:session): session closed for user root Jul 21 11:25:13 volumio volumio[1616]: info: Upmpdcli Daemon Started Jul 21 11:25:14 volumio volumio[1616]: info: CoreCommandRouter::volumioGetVisibleSources Jul 21 11:25:14 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 21 11:25:14 volumio volumio[1616]: info: CoreCommandRouter::volumioGetState Jul 21 11:25:14 volumio volumio[1616]: info: CoreStateMachine::getState Jul 21 11:25:14 volumio volumio[1616]: info: CorePlayQueue::getTrack 0 Jul 21 11:25:14 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 21 11:25:14 volumio sudo[1767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:25:14 volumio sudo[1767]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:25:14 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 21 11:25:14 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 21 11:25:14 volumio sudo[1767]: pam_unix(sudo:session): session closed for user root Jul 21 11:25:14 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 21 11:25:14 volumio volumio[1616]: error: Could not retrieve plugin audio_interface multiroom Jul 21 11:25:14 volumio volumio[1616]: info: Listing playlists Jul 21 11:25:14 volumio sudo[1776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 21 11:25:14 volumio sudo[1776]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 21 11:25:14 volumio sudo[1776]: pam_unix(sudo:session): session closed for user root Jul 21 11:25:14 volumio volumio-remote-updater[518]: [2024-07-21 11:25:14] [connect] Successful connection Jul 21 11:25:14 volumio volumio-remote-updater[518]: [2024-07-21 11:25:14] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1721561114 101 Jul 21 11:25:17 volumio volumio[1616]: info: Cannot mount NAS FLAC at system boot, trial number 3 ,retrying in 5 seconds Jul 21 11:25:17 volumio volumio[1616]: info: Cannot mount NAS DSD at system boot, trial number 3 ,retrying in 5 seconds Jul 21 11:25:17 volumio volumio[1616]: info: Cannot mount NAS IRINA at system boot, trial number 3 ,retrying in 5 seconds Jul 21 11:25:17 volumio volumio[1616]: info: CoreCommandRouter::volumioGetQueue Jul 21 11:25:17 volumio volumio[1616]: info: CoreStateMachine::getQueue Jul 21 11:25:17 volumio volumio[1616]: info: CorePlayQueue::getQueue Jul 21 11:25:18 volumio volumio[1616]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 21 11:25:18 volumio volumio[1616]: info: CURURI: albums:// Jul 21 11:25:18 volumio volumio[1616]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 11:25:18 volumio volumio[1616]: TypeError: Cannot read property 'sendCommand' of undefined Jul 21 11:25:18 volumio volumio[1616]: at /volumio/app/plugins/music_service/mpd/index.js:3021:19 Jul 21 11:25:18 volumio volumio[1616]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jul 21 11:25:18 volumio volumio[1616]: at process._tickCallback (internal/process/next_tick.js:180:9) Jul 21 11:25:18 volumio volumio[1616]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 21 11:25:20 volumio sudo[1792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-21 11:24 Jul 21 11:25:20 volumio sudo[1792]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="44b2fa85b4b3fa34b9dce1402ab445658a4a845a" VOLUMIO_FE_VERSION="d09ca6aec236a0abcd0f3fe793ad8b7dc572560b" VOLUMIO_BE_VERSION="adf0384995b68dee9fc3a8eedb9a69a90d236430" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Feb 20 14:10:26 UTC 2019" VOLUMIO_VERSION="2.555" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="99521079c49c6fa637dec4ad9cb6bd93"