-- Logs begin at Fri 2021-08-27 10:27:50 UTC, end at Fri 2021-08-27 17:52:35 UTC. -- Aug 27 17:51:00 volumio2-vk sudo[2454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Aug 27 17:51:00 volumio2-vk sudo[2454]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:00 volumio2-vk volumio[2352]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 27 17:51:00 volumio2-vk sudo[2454]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:00 volumio2-vk volumio[2352]: info: Aug 27 17:51:00 volumio2-vk volumio[2352]: ---------------------------- Client requests Volume 30 Aug 27 17:51:00 volumio2-vk volumio[2352]: info: VolumeController::SetAlsaVolume30 Aug 27 17:51:00 volumio2-vk volumio[2352]: info: CoreStateMachine::pushState Aug 27 17:51:00 volumio2-vk volumio[2352]: info: CoreStateMachine::getState Aug 27 17:51:00 volumio2-vk volumio[2352]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:00 volumio2-vk volumio[2352]: info: CoreCommandRouter::volumioPushState Aug 27 17:51:00 volumio2-vk volumio[2352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:51:01 volumio2-vk volumio[2352]: info: Reloading queue from file Aug 27 17:51:01 volumio2-vk volumio[2352]: info: Setting volume on startup at 30 Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreStateMachine::setRepeat true single undefined Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreStateMachine::pushState Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreStateMachine::getState Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreCommandRouter::volumioPushState Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreStateMachine::setRandom false Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreStateMachine::pushState Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreStateMachine::getState Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreCommandRouter::volumioPushState Aug 27 17:51:01 volumio2-vk volumio[2352]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:51:01 volumio2-vk sudo[2468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 27 17:51:01 volumio2-vk sudo[2468]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:01 volumio2-vk volumio[2352]: Discovery: adding ae7c4e99-8680-4124-847e-35035ca6085c Aug 27 17:51:01 volumio2-vk volumio[2352]: info: mDNS: Found device Volumio2-ak Aug 27 17:51:01 volumio2-vk sudo[2471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Aug 27 17:51:01 volumio2-vk systemd[1]: Started UPnP Renderer front-end to MPD. Aug 27 17:51:01 volumio2-vk sudo[2468]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:01 volumio2-vk sudo[2476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Aug 27 17:51:01 volumio2-vk sudo[2471]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:01 volumio2-vk systemd[1]: Stopping ShairportSync AirTunes receiver... Aug 27 17:51:01 volumio2-vk sudo[2476]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:01 volumio2-vk systemd[1]: Starting ShairportSync AirTunes receiver... Aug 27 17:51:01 volumio2-vk sudo[2471]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:01 volumio2-vk systemd[1]: Started ShairportSync AirTunes receiver. Aug 27 17:51:01 volumio2-vk systemd[1]: Stopping ShairportSync AirTunes receiver... Aug 27 17:51:01 volumio2-vk systemd[1]: Starting ShairportSync AirTunes receiver... Aug 27 17:51:02 volumio2-vk systemd[1]: Started ShairportSync AirTunes receiver. Aug 27 17:51:02 volumio2-vk sudo[2476]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:02 volumio2-vk shairport-sync[2494]: Successful Startup Aug 27 17:51:02 volumio2-vk volumio[2352]: info: Upmpdcli Daemon Started Aug 27 17:51:02 volumio2-vk volumio[2352]: info: Shairport-Sync Started Aug 27 17:51:02 volumio2-vk volumio[2352]: Error adding Membership: Error: addMembership EINVAL Aug 27 17:51:02 volumio2-vk volumio[2352]: info: Shairport-Sync Started Aug 27 17:51:02 volumio2-vk volumio[2352]: Discovery: adding c4e8251b-c190-4f38-99be-64a9d9148f89 Aug 27 17:51:02 volumio2-vk volumio[2352]: info: mDNS: Found device Volumio2-vk Aug 27 17:51:02 volumio2-vk sudo[2501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:51:02 volumio2-vk sudo[2501]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:02 volumio2-vk sudo[2501]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:02 volumio2-vk volumio[2352]: info: CoreCommandRouter::volumioGetState Aug 27 17:51:02 volumio2-vk volumio[2352]: info: CoreStateMachine::getState Aug 27 17:51:02 volumio2-vk volumio[2352]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:02 volumio2-vk sudo[2512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:51:02 volumio2-vk sudo[2512]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:02 volumio2-vk sudo[2512]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:03 volumio2-vk volumio[2352]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 17:51:03 volumio2-vk volumio[2352]: info: CoreCommandRouter::volumioGetState Aug 27 17:51:03 volumio2-vk volumio[2352]: info: CoreStateMachine::getState Aug 27 17:51:03 volumio2-vk volumio[2352]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:03 volumio2-vk sudo[2525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:51:03 volumio2-vk sudo[2525]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:03 volumio2-vk volumio[2352]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 27 17:51:03 volumio2-vk volumio[2352]: info: Listing playlists Aug 27 17:51:03 volumio2-vk volumio[2352]: info: CoreCommandRouter::volumioGetQueue Aug 27 17:51:03 volumio2-vk volumio[2352]: info: CoreStateMachine::getQueue Aug 27 17:51:03 volumio2-vk volumio[2352]: info: CorePlayQueue::getQueue Aug 27 17:51:03 volumio2-vk sudo[2525]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:03 volumio2-vk sudo[2530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:51:03 volumio2-vk sudo[2530]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:03 volumio2-vk sudo[2530]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:04 volumio2-vk volumio[2352]: info: Cannot mount NAS RiksStation2 at system boot, trial number 3 ,retrying in 5 seconds Aug 27 17:51:06 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:06] [connect] Successful connection Aug 27 17:51:06 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1630086666 101 Aug 27 17:51:08 volumio2-vk volumio[2352]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 27 17:51:08 volumio2-vk volumio[2352]: info: CURURI: music-library Aug 27 17:51:08 volumio2-vk volumio[2352]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 17:51:08 volumio2-vk volumio[2352]: TypeError: Cannot read property 'then' of undefined Aug 27 17:51:08 volumio2-vk volumio[2352]: at ControllerMpd.lsInfo (/volumio/app/plugins/music_service/mpd/index.js:1205:16) Aug 27 17:51:08 volumio2-vk volumio[2352]: at ControllerMpd.handleBrowseUri (/volumio/app/plugins/music_service/mpd/index.js:2893:25) Aug 27 17:51:08 volumio2-vk volumio[2352]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1018:29) Aug 27 17:51:08 volumio2-vk volumio[2352]: at CoreMusicLibrary.executeBrowseSource (/volumio/app/musiclibrary.js:329:47) Aug 27 17:51:08 volumio2-vk volumio[2352]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:363:32) Aug 27 17:51:08 volumio2-vk volumio[2352]: at emitTwo (events.js:126:13) Aug 27 17:51:08 volumio2-vk volumio[2352]: at Socket.emit (events.js:214:7) Aug 27 17:51:08 volumio2-vk volumio[2352]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Aug 27 17:51:08 volumio2-vk volumio[2352]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Aug 27 17:51:08 volumio2-vk volumio[2352]: at process._tickCallback (internal/process/next_tick.js:180:9) Aug 27 17:51:08 volumio2-vk volumio[2352]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 17:51:10 volumio2-vk sudo[2554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2021-08-27 17:50 Aug 27 17:51:10 volumio2-vk sudo[2554]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:10 volumio2-vk sudo[2554]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:10 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:10] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 27 17:51:10 volumio2-vk systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Aug 27 17:51:10 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:10] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 27 17:51:10 volumio2-vk systemd[1]: Unit volumio.service entered failed state. Aug 27 17:51:10 volumio2-vk systemd[1]: Starting dynamicswap service... Aug 27 17:51:10 volumio2-vk systemd[1]: Started dynamicswap service. Aug 27 17:51:10 volumio2-vk systemd[1]: volumio.service holdoff time over, scheduling restart. Aug 27 17:51:10 volumio2-vk systemd[1]: Starting dynamicswap service... Aug 27 17:51:10 volumio2-vk systemd[1]: Started dynamicswap service. Aug 27 17:51:10 volumio2-vk systemd[1]: Stopping Volumio Backend Module... Aug 27 17:51:10 volumio2-vk systemd[1]: Starting Volumio Backend Module... Aug 27 17:51:10 volumio2-vk systemd[1]: Started Volumio Backend Module. Aug 27 17:51:14 volumio2-vk volumio[2575]: info: ------------------------------------------- Aug 27 17:51:14 volumio2-vk volumio[2575]: info: ----- Volumio2 ---- Aug 27 17:51:14 volumio2-vk volumio[2575]: info: ------------------------------------------- Aug 27 17:51:14 volumio2-vk volumio[2575]: info: ----- System startup ---- Aug 27 17:51:14 volumio2-vk volumio[2575]: info: ------------------------------------------- Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Plugin folders cleanup Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Scanning into folder /volumio/app/plugins/ Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Scanning category audio_interface Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Scanning category miscellanea Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Scanning category music_service Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Scanning category plugins.json Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Scanning category system_controller Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Scanning category user_interface Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Scanning into folder /data/plugins/ Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Scanning category music_service Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Scanning category system_controller Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Plugin folders cleanup completed Aug 27 17:51:15 volumio2-vk volumio[2575]: info: ------------------------------------------- Aug 27 17:51:15 volumio2-vk volumio[2575]: info: ----- Core plugins startup ---- Aug 27 17:51:15 volumio2-vk volumio[2575]: info: ------------------------------------------- Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Loading plugins from folder /volumio/app/plugins/ Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Adding plugin upnp to MyMusic Plugins Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Loading plugins from folder /data/plugins/ Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Loading plugin "system"... Aug 27 17:51:15 volumio2-vk volumio[2575]: info: Loading plugin "appearance"... Aug 27 17:51:15 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:15] [connect] Successful connection Aug 27 17:51:17 volumio2-vk volumio[2575]: info: Loading plugin "network"... Aug 27 17:51:18 volumio2-vk volumio[2575]: info: Loading plugin "services"... Aug 27 17:51:18 volumio2-vk volumio[2575]: info: Loading plugin "alsa_controller"... Aug 27 17:51:18 volumio2-vk volumio[2575]: info: Loading plugin "wizard"... Aug 27 17:51:18 volumio2-vk volumio[2575]: info: Loading plugin "volumio_command_line_client"... Aug 27 17:51:18 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:18 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:18 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:18 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:18 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:18 volumio2-vk volumio[2575]: info: Loading plugin "upnp"... Aug 27 17:51:18 volumio2-vk volumio[2575]: info: [1630086678560] Starting Upmpd Daemon Aug 27 17:51:18 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 27 17:51:18 volumio2-vk volumio[2575]: info: Loading plugin "my_music"... Aug 27 17:51:18 volumio2-vk volumio[2575]: info: Loading plugin "mpd"... Aug 27 17:51:19 volumio2-vk volumio[2575]: info: Loading plugin "upnp_browser"... Aug 27 17:51:21 volumio2-vk volumio[2575]: info: Loading plugin "networkfs"... Aug 27 17:51:22 volumio2-vk volumio[2575]: info: Cannot mount NAS RiksStation2 at system boot, trial number 1 ,retrying in 5 seconds Aug 27 17:51:22 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 27 17:51:22 volumio2-vk volumio[2575]: info: Loading plugin "alarm-clock"... Aug 27 17:51:22 volumio2-vk volumio[2575]: info: Loading plugin "airplay_emulation"... Aug 27 17:51:22 volumio2-vk volumio[2575]: info: Starting Shairport Sync Aug 27 17:51:22 volumio2-vk volumio[2575]: info: Loading plugin "last_100"... Aug 27 17:51:22 volumio2-vk volumio[2575]: info: Loading plugin "webradio"... Aug 27 17:51:22 volumio2-vk volumio[2575]: info: Loading plugin "i2s_dacs"... Aug 27 17:51:22 volumio2-vk volumio[2575]: info: I2S DAC not set, start Auto-detection Aug 27 17:51:22 volumio2-vk volumio[2575]: info: Loading plugin "volumiodiscovery"... Aug 27 17:51:22 volumio2-vk volumio[2575]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 27 17:51:22 volumio2-vk node[2575]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 27 17:51:22 volumio2-vk node[2575]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 27 17:51:22 volumio2-vk node[2575]: *** WARNING *** For more information see Aug 27 17:51:22 volumio2-vk node[2575]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 27 17:51:22 volumio2-vk node[2575]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 27 17:51:22 volumio2-vk node[2575]: *** WARNING *** For more information see Aug 27 17:51:22 volumio2-vk volumio[2575]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 27 17:51:22 volumio2-vk volumio[2575]: *** WARNING *** For more information see Aug 27 17:51:22 volumio2-vk volumio[2575]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 27 17:51:22 volumio2-vk volumio[2575]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 27 17:51:22 volumio2-vk volumio[2575]: *** WARNING *** For more information see Aug 27 17:51:22 volumio2-vk volumio[2575]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 27 17:51:22 volumio2-vk volumio[2575]: Discovery: StartAdv! undefined Aug 27 17:51:22 volumio2-vk volumio[2575]: Discovery: Started advertising... Volumio2-vk - undefined Aug 27 17:51:22 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 27 17:51:22 volumio2-vk volumio[2575]: info: Loading plugin "youtube"... Aug 27 17:51:26 volumio2-vk volumio[2575]: info: Loading plugin "albumart"... Aug 27 17:51:26 volumio2-vk volumio[2575]: info: Plugin example_plugin is not enabled Aug 27 17:51:26 volumio2-vk volumio[2575]: info: Loading plugin "updater_comm"... Aug 27 17:51:26 volumio2-vk volumio[2575]: info: Plugin mpdemulation is not enabled Aug 27 17:51:26 volumio2-vk volumio[2575]: info: Loading plugin "rest_api"... Aug 27 17:51:26 volumio2-vk volumio[2575]: info: Loading plugin "websocket"... Aug 27 17:51:26 volumio2-vk volumio[2575]: info: Loading plugin "backup_restore"... Aug 27 17:51:27 volumio2-vk volumio[2575]: Forking 3 albumart workers Aug 27 17:51:27 volumio2-vk volumio[2575]: info: ___________ START PLUGINS ___________ Aug 27 17:51:27 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 17:51:27 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 27 17:51:27 volumio2-vk volumio[2575]: info: [1630086687607] CoreMusicLibrary::Adding element Media Servers Aug 27 17:51:27 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:27 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:27 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 27 17:51:27 volumio2-vk volumio[2575]: info: [1630086687710] CoreMusicLibrary::Adding element Last_100 Aug 27 17:51:27 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 27 17:51:27 volumio2-vk volumio[2575]: info: [1630086687719] CoreMusicLibrary::Adding element Webradio Aug 27 17:51:27 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 27 17:51:27 volumio2-vk volumio[2575]: info: Youtube::onStart Adding to browse sources Aug 27 17:51:27 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 27 17:51:27 volumio2-vk volumio[2575]: info: [1630086687735] CoreMusicLibrary::Adding element Youtube Aug 27 17:51:27 volumio2-vk volumio[2575]: info: ------------------------------------------- Aug 27 17:51:27 volumio2-vk volumio[2575]: info: ----- MyVolumio plugins startup ---- Aug 27 17:51:27 volumio2-vk volumio[2575]: info: ------------------------------------------- Aug 27 17:51:27 volumio2-vk volumio[2575]: info: Loading plugins from folder /myvolumio/plugins Aug 27 17:51:27 volumio2-vk volumio[2575]: info: Loading plugins from folder /data/myvolumio/plugins Aug 27 17:51:27 volumio2-vk volumio[2575]: info: Loading plugin "my_volumio"... Aug 27 17:51:28 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:28] [connect] Successful connection Aug 27 17:51:29 volumio2-vk volumio[2575]: info: Loading plugin "streaming_services"... Aug 27 17:51:29 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:51:29 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:51:29 volumio2-vk volumio[2575]: Starting albumart workers Aug 27 17:51:29 volumio2-vk volumio[2575]: Starting albumart workers Aug 27 17:51:29 volumio2-vk volumio[2575]: info: Streaming services startup Aug 27 17:51:29 volumio2-vk volumio[2575]: info: Loading i18n strings for locale en Aug 27 17:51:29 volumio2-vk volumio[2575]: Updating browse sources language Aug 27 17:51:29 volumio2-vk volumio[2575]: Cannot find translation for sourceMedia Servers Aug 27 17:51:29 volumio2-vk volumio[2575]: Cannot find translation for sourceYoutube Aug 27 17:51:29 volumio2-vk volumio[2575]: Starting albumart workers Aug 27 17:51:29 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 17:51:29 volumio2-vk volumio[2575]: info: CoreCommandRouter::initPlayerControls Aug 27 17:51:29 volumio2-vk sudo[2630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 27 17:51:30 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:30 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:30 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:30 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:30 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:30 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:30 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:30 volumio2-vk sudo[2630]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:30 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 17:51:30 volumio2-vk volumio[2575]: info: BOOT COMPLETED Aug 27 17:51:30 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:51:30 volumio2-vk systemd[1]: Stopping Volumio Streaming Daemon... Aug 27 17:51:30 volumio2-vk systemd[1]: Starting Volumio Streaming Daemon... Aug 27 17:51:30 volumio2-vk systemd[1]: Started Volumio Streaming Daemon. Aug 27 17:51:30 volumio2-vk sudo[2630]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:30 volumio2-vk volumio-streaming-daemon[2638]: ############################ Aug 27 17:51:30 volumio2-vk volumio-streaming-daemon[2638]: # Volumio Streaming Daemon # Aug 27 17:51:30 volumio2-vk volumio-streaming-daemon[2638]: # Running on port 7777 # Aug 27 17:51:30 volumio2-vk volumio-streaming-daemon[2638]: ############################ Aug 27 17:51:30 volumio2-vk kernel: usb 1-1.4: current rate 4500480 is different from the runtime rate 44100 Aug 27 17:51:35 volumio2-vk volumio[2575]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Aug 27 17:51:35 volumio2-vk volumio[2575]: info: CoreCommandRouter::Close All Modals sent Aug 27 17:51:35 volumio2-vk volumio[2575]: info: CoreCommandRouter::Close All Modals sent Aug 27 17:51:35 volumio2-vk volumio[2575]: Express server listening on port 3000 Aug 27 17:51:35 volumio2-vk volumio[2575]: Volumio Calling Home Aug 27 17:51:35 volumio2-vk volumio[2575]: info: MyVolumio not started Aug 27 17:51:35 volumio2-vk volumio[2575]: info: CoreStateMachine::resetVolumioState Aug 27 17:51:35 volumio2-vk volumio[2575]: info: CoreStateMachine::getcurrentVolume Aug 27 17:51:35 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioRetrievevolume Aug 27 17:51:35 volumio2-vk volumio[2575]: info: CoreStateMachine::updateTrackBlock Aug 27 17:51:35 volumio2-vk volumio[2575]: info: CorePlayQueue::getTrackBlock Aug 27 17:51:36 volumio2-vk volumio[2575]: info: Cannot mount NAS RiksStation2 at system boot, trial number 2 ,retrying in 5 seconds Aug 27 17:51:36 volumio2-vk sudo[2663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:51:36 volumio2-vk sudo[2663]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:36 volumio2-vk sudo[2663]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:36 volumio2-vk volumio[2575]: info: CoreStateMachine::pushState Aug 27 17:51:36 volumio2-vk volumio[2575]: info: CoreStateMachine::getState Aug 27 17:51:36 volumio2-vk volumio[2575]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:36 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioPushState Aug 27 17:51:36 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:51:36 volumio2-vk volumio[2575]: info: Setting Device type: Raspberry PI Aug 27 17:51:37 volumio2-vk volumio[2575]: info: Cannot initialize MPD Connection: MPD is not running Aug 27 17:51:37 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 27 17:51:37 volumio2-vk sudo[2675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Aug 27 17:51:37 volumio2-vk sudo[2675]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:37 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 27 17:51:37 volumio2-vk sudo[2675]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:37 volumio2-vk volumio[2575]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Aug 27 17:51:37 volumio2-vk volumio[2575]: info: Aug 27 17:51:37 volumio2-vk volumio[2575]: ---------------------------- Client requests Volume 30 Aug 27 17:51:37 volumio2-vk volumio[2575]: info: VolumeController::SetAlsaVolume30 Aug 27 17:51:37 volumio2-vk volumio[2575]: info: CoreStateMachine::pushState Aug 27 17:51:37 volumio2-vk volumio[2575]: info: CoreStateMachine::getState Aug 27 17:51:37 volumio2-vk volumio[2575]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:37 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioPushState Aug 27 17:51:37 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:51:38 volumio2-vk volumio[2575]: info: Reloading queue from file Aug 27 17:51:38 volumio2-vk volumio[2575]: info: Setting volume on startup at 30 Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreStateMachine::setRepeat true single undefined Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreStateMachine::pushState Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreStateMachine::getState Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioPushState Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreStateMachine::setRandom false Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreStateMachine::pushState Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreStateMachine::getState Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioPushState Aug 27 17:51:38 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:51:38 volumio2-vk sudo[2689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 27 17:51:38 volumio2-vk sudo[2689]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:38 volumio2-vk volumio[2575]: Discovery: adding ae7c4e99-8680-4124-847e-35035ca6085c Aug 27 17:51:38 volumio2-vk sudo[2692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Aug 27 17:51:38 volumio2-vk volumio[2575]: info: mDNS: Found device Volumio2-ak Aug 27 17:51:38 volumio2-vk systemd[1]: Started UPnP Renderer front-end to MPD. Aug 27 17:51:38 volumio2-vk sudo[2692]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:38 volumio2-vk sudo[2696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Aug 27 17:51:38 volumio2-vk sudo[2689]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:38 volumio2-vk sudo[2696]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:39 volumio2-vk systemd[1]: Stopping ShairportSync AirTunes receiver... Aug 27 17:51:39 volumio2-vk systemd[1]: Starting ShairportSync AirTunes receiver... Aug 27 17:51:39 volumio2-vk systemd[1]: Started ShairportSync AirTunes receiver. Aug 27 17:51:39 volumio2-vk sudo[2692]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:39 volumio2-vk shairport-sync[2709]: Successful Startup Aug 27 17:51:39 volumio2-vk systemd[1]: Stopping ShairportSync AirTunes receiver... Aug 27 17:51:39 volumio2-vk systemd[1]: Starting ShairportSync AirTunes receiver... Aug 27 17:51:39 volumio2-vk systemd[1]: Started ShairportSync AirTunes receiver. Aug 27 17:51:39 volumio2-vk sudo[2696]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:39 volumio2-vk shairport-sync[2716]: Successful Startup Aug 27 17:51:39 volumio2-vk volumio[2575]: info: Upmpdcli Daemon Started Aug 27 17:51:39 volumio2-vk volumio[2575]: info: Shairport-Sync Started Aug 27 17:51:39 volumio2-vk volumio[2575]: Error adding Membership: Error: addMembership EINVAL Aug 27 17:51:39 volumio2-vk volumio[2575]: info: Shairport-Sync Started Aug 27 17:51:39 volumio2-vk volumio[2575]: Discovery: adding c4e8251b-c190-4f38-99be-64a9d9148f89 Aug 27 17:51:39 volumio2-vk volumio[2575]: info: mDNS: Found device Volumio2-vk Aug 27 17:51:39 volumio2-vk sudo[2723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:51:39 volumio2-vk sudo[2723]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:39 volumio2-vk sudo[2723]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:39 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioGetState Aug 27 17:51:39 volumio2-vk volumio[2575]: info: CoreStateMachine::getState Aug 27 17:51:39 volumio2-vk volumio[2575]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:39 volumio2-vk sudo[2734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:51:39 volumio2-vk sudo[2734]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:39 volumio2-vk sudo[2734]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:41 volumio2-vk volumio[2575]: info: Cannot mount NAS RiksStation2 at system boot, trial number 3 ,retrying in 5 seconds Aug 27 17:51:42 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 17:51:42 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioGetState Aug 27 17:51:42 volumio2-vk volumio[2575]: info: CoreStateMachine::getState Aug 27 17:51:42 volumio2-vk volumio[2575]: info: CorePlayQueue::getTrack 0 Aug 27 17:51:42 volumio2-vk sudo[2747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:51:42 volumio2-vk sudo[2747]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:42 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 27 17:51:42 volumio2-vk volumio[2575]: info: Listing playlists Aug 27 17:51:42 volumio2-vk volumio[2575]: info: CoreCommandRouter::volumioGetQueue Aug 27 17:51:42 volumio2-vk volumio[2575]: info: CoreStateMachine::getQueue Aug 27 17:51:42 volumio2-vk volumio[2575]: info: CorePlayQueue::getQueue Aug 27 17:51:42 volumio2-vk sudo[2751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:51:42 volumio2-vk sudo[2747]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:42 volumio2-vk sudo[2751]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:42 volumio2-vk sudo[2751]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:43 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:43] [connect] Successful connection Aug 27 17:51:43 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:43] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1630086703 101 Aug 27 17:51:45 volumio2-vk volumio[2575]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 27 17:51:45 volumio2-vk volumio[2575]: info: CURURI: artists:// Aug 27 17:51:45 volumio2-vk volumio[2575]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 17:51:45 volumio2-vk volumio[2575]: TypeError: Cannot read property 'sendCommand' of undefined Aug 27 17:51:45 volumio2-vk volumio[2575]: at ControllerMpd.listArtists (/volumio/app/plugins/music_service/mpd/index.js:3254:17) Aug 27 17:51:45 volumio2-vk volumio[2575]: at ControllerMpd.handleBrowseUri (/volumio/app/plugins/music_service/mpd/index.js:2926:29) Aug 27 17:51:45 volumio2-vk volumio[2575]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1018:29) Aug 27 17:51:45 volumio2-vk volumio[2575]: at CoreMusicLibrary.executeBrowseSource (/volumio/app/musiclibrary.js:319:39) Aug 27 17:51:45 volumio2-vk volumio[2575]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:363:32) Aug 27 17:51:45 volumio2-vk volumio[2575]: at emitTwo (events.js:126:13) Aug 27 17:51:45 volumio2-vk volumio[2575]: at Socket.emit (events.js:214:7) Aug 27 17:51:45 volumio2-vk volumio[2575]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Aug 27 17:51:45 volumio2-vk volumio[2575]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Aug 27 17:51:45 volumio2-vk volumio[2575]: at process._tickCallback (internal/process/next_tick.js:180:9) Aug 27 17:51:45 volumio2-vk volumio[2575]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 17:51:47 volumio2-vk sudo[2776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2021-08-27 17:50 Aug 27 17:51:47 volumio2-vk sudo[2776]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:51:47 volumio2-vk sudo[2776]: pam_unix(sudo:session): session closed for user root Aug 27 17:51:48 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:48] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 27 17:51:48 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:48] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 27 17:51:48 volumio2-vk systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Aug 27 17:51:48 volumio2-vk systemd[1]: Unit volumio.service entered failed state. Aug 27 17:51:48 volumio2-vk systemd[1]: Starting dynamicswap service... Aug 27 17:51:48 volumio2-vk systemd[1]: Started dynamicswap service. Aug 27 17:51:48 volumio2-vk systemd[1]: volumio.service holdoff time over, scheduling restart. Aug 27 17:51:48 volumio2-vk systemd[1]: Starting dynamicswap service... Aug 27 17:51:48 volumio2-vk systemd[1]: Started dynamicswap service. Aug 27 17:51:48 volumio2-vk systemd[1]: Stopping Volumio Backend Module... Aug 27 17:51:48 volumio2-vk systemd[1]: Starting Volumio Backend Module... Aug 27 17:51:48 volumio2-vk systemd[1]: Started Volumio Backend Module. Aug 27 17:51:52 volumio2-vk volumio[2800]: info: ------------------------------------------- Aug 27 17:51:52 volumio2-vk volumio[2800]: info: ----- Volumio2 ---- Aug 27 17:51:52 volumio2-vk volumio[2800]: info: ------------------------------------------- Aug 27 17:51:52 volumio2-vk volumio[2800]: info: ----- System startup ---- Aug 27 17:51:52 volumio2-vk volumio[2800]: info: ------------------------------------------- Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Plugin folders cleanup Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Scanning into folder /volumio/app/plugins/ Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Scanning category audio_interface Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Scanning category miscellanea Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Scanning category music_service Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Scanning category plugins.json Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Scanning category system_controller Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Scanning category user_interface Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Scanning into folder /data/plugins/ Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Scanning category music_service Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Scanning category system_controller Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Plugin folders cleanup completed Aug 27 17:51:52 volumio2-vk volumio[2800]: info: ------------------------------------------- Aug 27 17:51:52 volumio2-vk volumio[2800]: info: ----- Core plugins startup ---- Aug 27 17:51:52 volumio2-vk volumio[2800]: info: ------------------------------------------- Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Loading plugins from folder /volumio/app/plugins/ Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Adding plugin upnp to MyMusic Plugins Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Loading plugins from folder /data/plugins/ Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Loading plugin "system"... Aug 27 17:51:52 volumio2-vk volumio[2800]: info: Loading plugin "appearance"... Aug 27 17:51:53 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:51:53] [connect] Successful connection Aug 27 17:51:55 volumio2-vk volumio[2800]: info: Loading plugin "network"... Aug 27 17:51:55 volumio2-vk volumio[2800]: info: Loading plugin "services"... Aug 27 17:51:55 volumio2-vk volumio[2800]: info: Loading plugin "alsa_controller"... Aug 27 17:51:55 volumio2-vk volumio[2800]: info: Loading plugin "wizard"... Aug 27 17:51:55 volumio2-vk volumio[2800]: info: Loading plugin "volumio_command_line_client"... Aug 27 17:51:56 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:56 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:56 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:56 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:56 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:51:56 volumio2-vk volumio[2800]: info: Loading plugin "upnp"... Aug 27 17:51:56 volumio2-vk volumio[2800]: info: [1630086716103] Starting Upmpd Daemon Aug 27 17:51:56 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 27 17:51:56 volumio2-vk volumio[2800]: info: Loading plugin "my_music"... Aug 27 17:51:56 volumio2-vk volumio[2800]: info: Loading plugin "mpd"... Aug 27 17:51:56 volumio2-vk volumio[2800]: info: Loading plugin "upnp_browser"... Aug 27 17:51:58 volumio2-vk volumio[2800]: info: Loading plugin "networkfs"... Aug 27 17:51:59 volumio2-vk volumio[2800]: info: Cannot mount NAS RiksStation2 at system boot, trial number 1 ,retrying in 5 seconds Aug 27 17:51:59 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 27 17:51:59 volumio2-vk volumio[2800]: info: Loading plugin "alarm-clock"... Aug 27 17:51:59 volumio2-vk volumio[2800]: info: Loading plugin "airplay_emulation"... Aug 27 17:52:00 volumio2-vk volumio[2800]: info: Starting Shairport Sync Aug 27 17:52:00 volumio2-vk volumio[2800]: info: Loading plugin "last_100"... Aug 27 17:52:00 volumio2-vk volumio[2800]: info: Loading plugin "webradio"... Aug 27 17:52:00 volumio2-vk volumio[2800]: info: Loading plugin "i2s_dacs"... Aug 27 17:52:00 volumio2-vk volumio[2800]: info: I2S DAC not set, start Auto-detection Aug 27 17:52:00 volumio2-vk volumio[2800]: info: Loading plugin "volumiodiscovery"... Aug 27 17:52:00 volumio2-vk volumio[2800]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 27 17:52:00 volumio2-vk node[2800]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 27 17:52:00 volumio2-vk node[2800]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 27 17:52:00 volumio2-vk node[2800]: *** WARNING *** For more information see Aug 27 17:52:00 volumio2-vk node[2800]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 27 17:52:00 volumio2-vk node[2800]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 27 17:52:00 volumio2-vk node[2800]: *** WARNING *** For more information see Aug 27 17:52:00 volumio2-vk volumio[2800]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 27 17:52:00 volumio2-vk volumio[2800]: *** WARNING *** For more information see Aug 27 17:52:00 volumio2-vk volumio[2800]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 27 17:52:00 volumio2-vk volumio[2800]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 27 17:52:00 volumio2-vk volumio[2800]: *** WARNING *** For more information see Aug 27 17:52:00 volumio2-vk volumio[2800]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 27 17:52:00 volumio2-vk volumio[2800]: Discovery: StartAdv! undefined Aug 27 17:52:00 volumio2-vk volumio[2800]: Discovery: Started advertising... Volumio2-vk - undefined Aug 27 17:52:00 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 27 17:52:00 volumio2-vk volumio[2800]: info: Loading plugin "youtube"... Aug 27 17:52:03 volumio2-vk volumio[2800]: info: Loading plugin "albumart"... Aug 27 17:52:03 volumio2-vk volumio[2800]: info: Plugin example_plugin is not enabled Aug 27 17:52:03 volumio2-vk volumio[2800]: info: Loading plugin "updater_comm"... Aug 27 17:52:04 volumio2-vk volumio[2800]: info: Plugin mpdemulation is not enabled Aug 27 17:52:04 volumio2-vk volumio[2800]: info: Loading plugin "rest_api"... Aug 27 17:52:04 volumio2-vk volumio[2800]: info: Loading plugin "websocket"... Aug 27 17:52:04 volumio2-vk volumio[2800]: info: Loading plugin "backup_restore"... Aug 27 17:52:04 volumio2-vk volumio[2800]: Forking 3 albumart workers Aug 27 17:52:04 volumio2-vk volumio[2800]: info: ___________ START PLUGINS ___________ Aug 27 17:52:04 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 17:52:04 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 27 17:52:04 volumio2-vk volumio[2800]: info: [1630086724907] CoreMusicLibrary::Adding element Media Servers Aug 27 17:52:04 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:52:05 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:52:05 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 27 17:52:05 volumio2-vk volumio[2800]: info: [1630086725003] CoreMusicLibrary::Adding element Last_100 Aug 27 17:52:05 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 27 17:52:05 volumio2-vk volumio[2800]: info: [1630086725013] CoreMusicLibrary::Adding element Webradio Aug 27 17:52:05 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 27 17:52:05 volumio2-vk volumio[2800]: info: Youtube::onStart Adding to browse sources Aug 27 17:52:05 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 27 17:52:05 volumio2-vk volumio[2800]: info: [1630086725029] CoreMusicLibrary::Adding element Youtube Aug 27 17:52:05 volumio2-vk volumio[2800]: info: ------------------------------------------- Aug 27 17:52:05 volumio2-vk volumio[2800]: info: ----- MyVolumio plugins startup ---- Aug 27 17:52:05 volumio2-vk volumio[2800]: info: ------------------------------------------- Aug 27 17:52:05 volumio2-vk volumio[2800]: info: Loading plugins from folder /myvolumio/plugins Aug 27 17:52:05 volumio2-vk volumio[2800]: info: Loading plugins from folder /data/myvolumio/plugins Aug 27 17:52:05 volumio2-vk volumio[2800]: info: Loading plugin "my_volumio"... Aug 27 17:52:05 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:52:05] [connect] Successful connection Aug 27 17:52:06 volumio2-vk volumio[2800]: info: Loading plugin "streaming_services"... Aug 27 17:52:06 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:52:06 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:52:07 volumio2-vk volumio[2800]: info: Streaming services startup Aug 27 17:52:07 volumio2-vk volumio[2800]: Starting albumart workers Aug 27 17:52:07 volumio2-vk volumio[2800]: Starting albumart workers Aug 27 17:52:07 volumio2-vk volumio[2800]: info: Loading i18n strings for locale en Aug 27 17:52:07 volumio2-vk volumio[2800]: Starting albumart workers Aug 27 17:52:07 volumio2-vk volumio[2800]: Updating browse sources language Aug 27 17:52:07 volumio2-vk volumio[2800]: Cannot find translation for sourceMedia Servers Aug 27 17:52:07 volumio2-vk volumio[2800]: Cannot find translation for sourceYoutube Aug 27 17:52:07 volumio2-vk sudo[2855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::initPlayerControls Aug 27 17:52:07 volumio2-vk sudo[2855]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:52:07 volumio2-vk systemd[1]: Stopping Volumio Streaming Daemon... Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:52:07 volumio2-vk systemd[1]: Starting Volumio Streaming Daemon... Aug 27 17:52:07 volumio2-vk systemd[1]: Started Volumio Streaming Daemon. Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 17:52:07 volumio2-vk volumio[2800]: info: BOOT COMPLETED Aug 27 17:52:07 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:52:07 volumio2-vk volumio-streaming-daemon[2861]: ############################ Aug 27 17:52:07 volumio2-vk volumio-streaming-daemon[2861]: # Volumio Streaming Daemon # Aug 27 17:52:07 volumio2-vk volumio-streaming-daemon[2861]: # Running on port 7777 # Aug 27 17:52:07 volumio2-vk volumio-streaming-daemon[2861]: ############################ Aug 27 17:52:07 volumio2-vk sudo[2855]: pam_unix(sudo:session): session closed for user root Aug 27 17:52:07 volumio2-vk kernel: usb 1-1.4: current rate 4500480 is different from the runtime rate 44100 Aug 27 17:52:12 volumio2-vk volumio[2800]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Aug 27 17:52:12 volumio2-vk volumio[2800]: info: CoreCommandRouter::Close All Modals sent Aug 27 17:52:12 volumio2-vk volumio[2800]: info: CoreCommandRouter::Close All Modals sent Aug 27 17:52:12 volumio2-vk volumio[2800]: Express server listening on port 3000 Aug 27 17:52:12 volumio2-vk volumio[2800]: Volumio Calling Home Aug 27 17:52:13 volumio2-vk volumio[2800]: info: MyVolumio not started Aug 27 17:52:13 volumio2-vk volumio[2800]: info: CoreStateMachine::resetVolumioState Aug 27 17:52:13 volumio2-vk volumio[2800]: info: CoreStateMachine::getcurrentVolume Aug 27 17:52:13 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioRetrievevolume Aug 27 17:52:13 volumio2-vk volumio[2800]: info: CoreStateMachine::updateTrackBlock Aug 27 17:52:13 volumio2-vk volumio[2800]: info: CorePlayQueue::getTrackBlock Aug 27 17:52:13 volumio2-vk volumio[2800]: info: Cannot mount NAS RiksStation2 at system boot, trial number 2 ,retrying in 5 seconds Aug 27 17:52:13 volumio2-vk sudo[2888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:52:13 volumio2-vk sudo[2888]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:52:13 volumio2-vk sudo[2888]: pam_unix(sudo:session): session closed for user root Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CoreStateMachine::pushState Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CoreStateMachine::getState Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CorePlayQueue::getTrack 0 Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioPushState Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:52:14 volumio2-vk volumio[2800]: info: Setting Device type: Raspberry PI Aug 27 17:52:14 volumio2-vk volumio[2800]: info: Cannot initialize MPD Connection: MPD is not running Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 27 17:52:14 volumio2-vk sudo[2899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Aug 27 17:52:14 volumio2-vk sudo[2899]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 27 17:52:14 volumio2-vk sudo[2899]: pam_unix(sudo:session): session closed for user root Aug 27 17:52:14 volumio2-vk volumio[2800]: info: Aug 27 17:52:14 volumio2-vk volumio[2800]: ---------------------------- Client requests Volume 30 Aug 27 17:52:14 volumio2-vk volumio[2800]: info: VolumeController::SetAlsaVolume30 Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CoreStateMachine::pushState Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CoreStateMachine::getState Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CorePlayQueue::getTrack 0 Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioPushState Aug 27 17:52:14 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:52:15 volumio2-vk volumio[2800]: info: Reloading queue from file Aug 27 17:52:15 volumio2-vk volumio[2800]: info: Setting volume on startup at 30 Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreStateMachine::setRepeat true single undefined Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreStateMachine::pushState Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreStateMachine::getState Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CorePlayQueue::getTrack 0 Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioPushState Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreStateMachine::setRandom false Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreStateMachine::pushState Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreStateMachine::getState Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CorePlayQueue::getTrack 0 Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioPushState Aug 27 17:52:15 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 27 17:52:16 volumio2-vk sudo[2913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Aug 27 17:52:16 volumio2-vk sudo[2913]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:52:16 volumio2-vk volumio[2800]: Discovery: adding ae7c4e99-8680-4124-847e-35035ca6085c Aug 27 17:52:16 volumio2-vk volumio[2800]: info: mDNS: Found device Volumio2-ak Aug 27 17:52:16 volumio2-vk sudo[2915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 27 17:52:16 volumio2-vk systemd[1]: Stopping ShairportSync AirTunes receiver... Aug 27 17:52:16 volumio2-vk sudo[2915]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:52:16 volumio2-vk sudo[2921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Aug 27 17:52:16 volumio2-vk systemd[1]: Starting ShairportSync AirTunes receiver... Aug 27 17:52:16 volumio2-vk systemd[1]: Started ShairportSync AirTunes receiver. Aug 27 17:52:16 volumio2-vk sudo[2913]: pam_unix(sudo:session): session closed for user root Aug 27 17:52:16 volumio2-vk shairport-sync[2928]: Successful Startup Aug 27 17:52:16 volumio2-vk sudo[2921]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:52:16 volumio2-vk systemd[1]: Started UPnP Renderer front-end to MPD. Aug 27 17:52:16 volumio2-vk sudo[2915]: pam_unix(sudo:session): session closed for user root Aug 27 17:52:16 volumio2-vk systemd[1]: Stopping ShairportSync AirTunes receiver... Aug 27 17:52:16 volumio2-vk systemd[1]: Starting ShairportSync AirTunes receiver... Aug 27 17:52:16 volumio2-vk systemd[1]: Started ShairportSync AirTunes receiver. Aug 27 17:52:16 volumio2-vk sudo[2921]: pam_unix(sudo:session): session closed for user root Aug 27 17:52:16 volumio2-vk shairport-sync[2941]: Successful Startup Aug 27 17:52:16 volumio2-vk volumio[2800]: info: Shairport-Sync Started Aug 27 17:52:16 volumio2-vk volumio[2800]: Error adding Membership: Error: addMembership EINVAL Aug 27 17:52:16 volumio2-vk volumio[2800]: info: Shairport-Sync Started Aug 27 17:52:16 volumio2-vk volumio[2800]: info: Upmpdcli Daemon Started Aug 27 17:52:16 volumio2-vk volumio[2800]: Discovery: adding c4e8251b-c190-4f38-99be-64a9d9148f89 Aug 27 17:52:16 volumio2-vk volumio[2800]: info: mDNS: Found device Volumio2-vk Aug 27 17:52:16 volumio2-vk sudo[2948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:52:16 volumio2-vk sudo[2948]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:52:16 volumio2-vk sudo[2948]: pam_unix(sudo:session): session closed for user root Aug 27 17:52:17 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioGetState Aug 27 17:52:17 volumio2-vk volumio[2800]: info: CoreStateMachine::getState Aug 27 17:52:17 volumio2-vk volumio[2800]: info: CorePlayQueue::getTrack 0 Aug 27 17:52:17 volumio2-vk sudo[2959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:52:17 volumio2-vk sudo[2959]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:52:17 volumio2-vk sudo[2959]: pam_unix(sudo:session): session closed for user root Aug 27 17:52:18 volumio2-vk volumio[2800]: info: Cannot mount NAS RiksStation2 at system boot, trial number 3 ,retrying in 5 seconds Aug 27 17:52:19 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 17:52:19 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioGetState Aug 27 17:52:19 volumio2-vk volumio[2800]: info: CoreStateMachine::getState Aug 27 17:52:19 volumio2-vk volumio[2800]: info: CorePlayQueue::getTrack 0 Aug 27 17:52:19 volumio2-vk sudo[2972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:52:19 volumio2-vk sudo[2972]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:52:19 volumio2-vk sudo[2972]: pam_unix(sudo:session): session closed for user root Aug 27 17:52:19 volumio2-vk sudo[2978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 17:52:19 volumio2-vk sudo[2978]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 17:52:19 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 27 17:52:19 volumio2-vk volumio[2800]: info: Listing playlists Aug 27 17:52:19 volumio2-vk sudo[2978]: pam_unix(sudo:session): session closed for user root Aug 27 17:52:19 volumio2-vk volumio[2800]: info: CoreCommandRouter::volumioGetQueue Aug 27 17:52:19 volumio2-vk volumio[2800]: info: CoreStateMachine::getQueue Aug 27 17:52:19 volumio2-vk volumio[2800]: info: CorePlayQueue::getQueue Aug 27 17:52:20 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:52:20] [connect] Successful connection Aug 27 17:52:20 volumio2-vk volumio-remote-updater[595]: [2021-08-27 17:52:20] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1630086740 101 Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 17:52:22 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 27 17:52:23 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 27 17:52:23 volumio2-vk volumio[2800]: info: Cannot mount NAS RiksStation2 at system boot, trial number 4 ,retrying in 5 seconds Aug 27 17:52:24 volumio2-vk volumio[2800]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.526&uuid=4087f5bbd16eca0a640a59234e523d27" http://updates.volumio.org:7070/downloader-v1/track-device Aug 27 17:52:24 volumio2-vk volumio[2800]: % Total % Received % Xferd Average Speed Time Time Time Current Aug 27 17:52:24 volumio2-vk volumio[2800]: Dload Upload Total Spent Left Speed Aug 27 17:52:24 volumio2-vk volumio[2800]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Aug 27 17:52:24 volumio2-vk volumio[2800]: retrying in 5 seconds, trial 0 Aug 27 17:52:24 volumio2-vk volumio[2800]: Volumio Calling Home Aug 27 17:52:26 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 27 17:52:28 volumio2-vk volumio[2800]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Aug 27 17:52:30 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 27 17:52:33 volumio2-vk volumio[2800]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Aug 27 17:52:33 volumio2-vk volumio[2800]: info: ControllerMpd::sendMpdCommand rescan Aug 27 17:52:33 volumio2-vk volumio[2800]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 17:52:33 volumio2-vk volumio[2800]: TypeError: Cannot read property 'then' of undefined Aug 27 17:52:33 volumio2-vk volumio[2800]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:343:4) Aug 27 17:52:33 volumio2-vk volumio[2800]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1820:14) Aug 27 17:52:33 volumio2-vk volumio[2800]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1018:29) Aug 27 17:52:33 volumio2-vk volumio[2800]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:964:24) Aug 27 17:52:33 volumio2-vk volumio[2800]: at emitTwo (events.js:126:13) Aug 27 17:52:33 volumio2-vk volumio[2800]: at Socket.emit (events.js:214:7) Aug 27 17:52:33 volumio2-vk volumio[2800]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Aug 27 17:52:33 volumio2-vk volumio[2800]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Aug 27 17:52:33 volumio2-vk volumio[2800]: at process._tickCallback (internal/process/next_tick.js:180:9) Aug 27 17:52:33 volumio2-vk volumio[2800]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 17:52:35 volumio2-vk sudo[3007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2021-08-27 17:51 Aug 27 17:52:35 volumio2-vk sudo[3007]: 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="91bc32a3daa69e09170e613c40f8b5c279962098" VOLUMIO_FE_VERSION="9511ab07247d3b65ded550111191469fa3626bd6" VOLUMIO_BE_VERSION="78de34390ebc5df0b086e244ca969a4e0ddc40d1" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jan 12 00:37:59 CET 2019" VOLUMIO_VERSION="2.526" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="fe6efee3fc492df251c9b38e25d0dec3"