2.344 crashing RPI3

[zehnm]

I have the exact same problem on a fresh RPI3 install with nothing more attached than ethernet, hdmi and a logitech keyboard dongle.
The beginning of the startup sound plays in a loop, after about 2 minutes the end of the startup sound is played. Until then the web frontend doesn’t load at all and the node process is around 100% cpu on one core. Now there’s a 20-60 second window to use the web frontend until the loop starts again and the web is no longer accessible!
Tried with volumio-2.346-2017-12-19-pi.img but still the same issue.
Tried to remove /usr/bin/upmpdcli but it wasn’t the culprit.
Disabled upnp_browser, audio_interface/upnp plugins in /volumio/app/plugins/plugins.json but didn’t help either.
Tried to upload bug report during the short window where volumio frontend was accessible with volumio.local/dev but not sure if it succeeded…

According to /var/log/volumio.log volumio hangs after “Upmpdcli Daemon Started”:

volumio@volumio:~$ tail -f -n 500 /var/log/volumio.log 
2017-12-22T09:01:13.284Z - info: -------------------------------------------
2017-12-22T09:01:13.291Z - info: -----            Volumio2              ----
2017-12-22T09:01:13.291Z - info: -------------------------------------------
2017-12-22T09:01:13.292Z - info: -----          System startup          ----
2017-12-22T09:01:13.292Z - info: -------------------------------------------
2017-12-22T09:01:13.511Z - info: Plugin folders cleanup
2017-12-22T09:01:13.512Z - info: Scanning into folder /volumio/app/plugins/
2017-12-22T09:01:13.513Z - info: Scanning category audio_interface
2017-12-22T09:01:13.514Z - info: Scanning category miscellanea
2017-12-22T09:01:13.516Z - info: Scanning category music_service
2017-12-22T09:01:13.517Z - info: Scanning category plugins.json
2017-12-22T09:01:13.519Z - info: Scanning category system_controller
2017-12-22T09:01:13.523Z - info: Scanning category user_interface
2017-12-22T09:01:13.524Z - info: Scanning into folder /data/plugins/
2017-12-22T09:01:13.526Z - info: Plugin folders cleanup completed
2017-12-22T09:01:13.529Z - info: Loading plugins from folder /volumio/app/plugins/
2017-12-22T09:01:13.536Z - info: Loading plugins from folder /data/plugins/
2017-12-22T09:01:13.540Z - info: Loading plugin "system"...
2017-12-22T09:01:13.580Z - info: Loading plugin "appearance"...
2017-12-22T09:01:15.711Z - info: Loading plugin "network"...
2017-12-22T09:01:15.870Z - info: Loading plugin "services"...
2017-12-22T09:01:15.876Z - info: Loading plugin "alsa_controller"...
2017-12-22T09:01:16.017Z - info: Loading plugin "wizard"...
2017-12-22T09:01:16.033Z - info: Loading plugin "volumio_command_line_client"...
2017-12-22T09:01:16.043Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:01:16.045Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:01:16.047Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:01:16.047Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:01:16.087Z - info: Loading plugin "upnp"...
2017-12-22T09:01:16.096Z - info: [1513933276095] Starting Upmpd Daemon
2017-12-22T09:01:16.101Z - info: CoreCommandRouter::executeOnPlugin: system , registerCallback
2017-12-22T09:01:16.104Z - info: Loading plugin "mpd"...
2017-12-22T09:01:16.327Z - info: Loading plugin "upnp_browser"...
2017-12-22T09:01:17.290Z - info: Loading plugin "networkfs"...
2017-12-22T09:01:17.315Z - info: CoreCommandRouter::executeOnPlugin: system , registerCallback
2017-12-22T09:01:17.316Z - info: Loading plugin "alarm-clock"...
2017-12-22T09:01:17.564Z - info: Loading plugin "airplay_emulation"...
2017-12-22T09:01:17.592Z - info: [1513933277591] Starting Shairport Sync
2017-12-22T09:01:17.596Z - info: Loading plugin "last_100"...
2017-12-22T09:01:17.604Z - info: Loading plugin "webradio"...
2017-12-22T09:01:17.626Z - info: Loading plugin "i2s_dacs"...
2017-12-22T09:01:17.641Z - info: I2S DAC not set, start Auto-detection
2017-12-22T09:01:17.662Z - info: Loading plugin "volumiodiscovery"...
2017-12-22T09:01:17.731Z - info: Applying required configuration parameters for plugin volumiodiscovery
2017-12-22T09:01:17.771Z - info: CoreCommandRouter::executeOnPlugin: system , registerCallback
2017-12-22T09:01:17.774Z - info: Loading plugin "albumart"...
2017-12-22T09:01:18.155Z - info: Plugin example_plugin is not enabled
2017-12-22T09:01:18.156Z - info: Loading plugin "updater_comm"...
2017-12-22T09:01:18.684Z - info: Plugin mpdemulation is not enabled
2017-12-22T09:01:18.685Z - info: Loading plugin "rest_api"...
2017-12-22T09:01:18.702Z - info: Loading plugin "websocket"...
2017-12-22T09:01:18.745Z - info: ___________ START PLUGINS ___________
2017-12-22T09:01:18.748Z - info: PLUGIN START: appearance
2017-12-22T09:01:18.751Z - info: PLUGIN START: wizard
2017-12-22T09:01:18.753Z - info: PLUGIN START: upnp_browser
2017-12-22T09:01:18.755Z - info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
2017-12-22T09:01:18.757Z - info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
2017-12-22T09:01:18.759Z - info: [1513933278758] CoreMusicLibrary::Adding element Media Servers
2017-12-22T09:01:18.783Z - info: PLUGIN START: last_100
2017-12-22T09:01:18.785Z - info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
2017-12-22T09:01:18.786Z - info: [1513933278785] CoreMusicLibrary::Adding element Last_100
2017-12-22T09:01:18.789Z - info: PLUGIN START: webradio
2017-12-22T09:01:18.791Z - info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
2017-12-22T09:01:18.792Z - info: [1513933278791] CoreMusicLibrary::Adding element Webradio
2017-12-22T09:01:18.795Z - info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
2017-12-22T09:01:18.799Z - info: Loading i18n strings for locale en
2017-12-22T09:01:18.844Z - info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
2017-12-22T09:01:18.849Z - info: CoreCommandRouter::initPlayerControls
2017-12-22T09:01:18.867Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:01:18.869Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
2017-12-22T09:01:18.906Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:01:18.909Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:01:18.911Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:01:18.913Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:01:18.915Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:01:18.931Z - info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
2017-12-22T09:01:18.937Z - info: BOOT COMPLETED
2017-12-22T09:01:18.940Z - info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
2017-12-22T09:01:18.960Z - info: CoreCommandRouter::Close All Modals sent
2017-12-22T09:01:19.099Z - info: [1513933279098] CoreStateMachine::resetVolumioState
2017-12-22T09:01:19.101Z - info: [1513933279100] CoreStateMachine::getcurrentVolume
2017-12-22T09:01:19.102Z - info: CoreCommandRouter::volumioRetrievevolume
2017-12-22T09:01:19.122Z - info: [1513933279121] CoreStateMachine::updateTrackBlock
2017-12-22T09:01:19.125Z - info: [1513933279124] CorePlayQueue::getTrackBlock
2017-12-22T09:01:19.181Z - info: Cannot read play queue from file
2017-12-22T09:01:19.385Z - info: Setting Device type: Raspberry PI
2017-12-22T09:01:19.417Z - info: MPD running with PID688 ,establishing connection
2017-12-22T09:01:19.671Z - info: [1513933279670] VolumeController:: Volume=40 Mute =false
2017-12-22T09:01:19.674Z - info: [1513933279673] CoreStateMachine::pushState
2017-12-22T09:01:19.677Z - info: [1513933279676] CoreStateMachine::getState
2017-12-22T09:01:19.678Z - info: [1513933279677] CorePlayQueue::getTrack 0
2017-12-22T09:01:19.680Z - info: CoreCommandRouter::volumioPushState
2017-12-22T09:01:19.680Z - info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
2017-12-22T09:01:19.684Z - info: [1513933279683] interfaceApi::pushState
2017-12-22T09:01:19.685Z - info: [1513933279685] InterfaceWebUI::pushState
2017-12-22T09:01:19.695Z - info: Volumio called home
2017-12-22T09:01:19.722Z - info: Pushing Favourites {"service":"mpd","uri":"","favourite":false}
2017-12-22T09:01:20.020Z - info: 
2017-12-22T09:01:20.281Z - info: [1513933280280] CoreStateMachine::setRepeat null single undefined
2017-12-22T09:01:20.282Z - info: [1513933280281] CoreStateMachine::pushState
2017-12-22T09:01:20.283Z - info: [1513933280283] CoreStateMachine::getState
2017-12-22T09:01:20.284Z - info: [1513933280284] CorePlayQueue::getTrack 0
2017-12-22T09:01:20.286Z - info: CoreCommandRouter::volumioPushState
2017-12-22T09:01:20.286Z - info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
2017-12-22T09:01:20.288Z - info: [1513933280288] interfaceApi::pushState
2017-12-22T09:01:20.290Z - info: [1513933280289] InterfaceWebUI::pushState
2017-12-22T09:01:20.294Z - info: [1513933280293] CoreStateMachine::setRandom null
2017-12-22T09:01:20.295Z - info: [1513933280294] CoreStateMachine::pushState
2017-12-22T09:01:20.296Z - info: [1513933280295] CoreStateMachine::getState
2017-12-22T09:01:20.296Z - info: [1513933280296] CorePlayQueue::getTrack 0
2017-12-22T09:01:20.297Z - info: CoreCommandRouter::volumioPushState
2017-12-22T09:01:20.298Z - info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
2017-12-22T09:01:20.299Z - info: [1513933280298] interfaceApi::pushState
2017-12-22T09:01:20.300Z - info: [1513933280299] InterfaceWebUI::pushState
2017-12-22T09:01:20.380Z - info: Pushing Favourites {"service":"mpd","uri":"","favourite":false}
2017-12-22T09:01:20.384Z - info: Pushing Favourites {"service":"mpd","uri":"","favourite":false}
2017-12-22T09:01:20.538Z - info: mDNS: Found device Volumio
2017-12-22T09:01:20.580Z - info: [1513933280578] Shairport-Sync Started
2017-12-22T09:01:20.606Z - info: mDNS: Found device Volumio
2017-12-22T09:01:20.884Z - info: CoreCommandRouter::volumioGetState
2017-12-22T09:01:20.884Z - info: [1513933280884] CoreStateMachine::getState
2017-12-22T09:01:20.887Z - info: [1513933280887] CorePlayQueue::getTrack 0
2017-12-22T09:01:20.889Z - info: 
[1513933280888] ---------------------------- Client requests Volumio state
2017-12-22T09:01:20.891Z - info: [1513933280890] InterfaceWebUI::pushState
2017-12-22T09:01:20.917Z - info: [1513933280916] ------------------------------ 33ms
2017-12-22T09:01:20.929Z - info: 
[1513933280928] ---------------------------- Client requests Menu Items
2017-12-22T09:01:20.957Z - info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
2017-12-22T09:01:20.959Z - info: [1513933280958] Listing playlists
2017-12-22T09:01:21.182Z - info: [1513933281181] ------------------------------ 253ms
2017-12-22T09:01:21.651Z - info: CoreCommandRouter::volumioGetState
2017-12-22T09:01:21.652Z - info: [1513933281651] CoreStateMachine::getState
2017-12-22T09:01:21.655Z - info: [1513933281652] CorePlayQueue::getTrack 0
2017-12-22T09:01:21.656Z - info: 
[1513933281656] ---------------------------- Client requests Volumio state
2017-12-22T09:01:21.657Z - info: [1513933281657] InterfaceWebUI::pushState
2017-12-22T09:01:21.676Z - info: [1513933281675] ------------------------------ 25ms
2017-12-22T09:01:21.705Z - info: 
[1513933281704] ---------------------------- Client requests Menu Items
2017-12-22T09:01:21.743Z - info: [1513933281743] ------------------------------ 39ms
2017-12-22T09:01:21.747Z - info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
2017-12-22T09:01:21.755Z - info: [1513933281752] Listing playlists
2017-12-22T09:01:21.964Z - info: CoreCommandRouter::volumioGetState
2017-12-22T09:01:21.965Z - info: [1513933281964] CoreStateMachine::getState
2017-12-22T09:01:21.965Z - info: [1513933281965] CorePlayQueue::getTrack 0
2017-12-22T09:01:21.966Z - info: 
[1513933281965] ---------------------------- Client requests Volumio state
2017-12-22T09:01:21.967Z - info: [1513933281967] InterfaceWebUI::pushState
2017-12-22T09:01:21.985Z - info: [1513933281984] ------------------------------ 21ms
2017-12-22T09:01:24.262Z - info: CoreCommandRouter::Close All Modals sent
2017-12-22T09:01:26.248Z - info: Upmpdcli Daemon Started
2017-12-22T09:01:32.683Z - info: CoreCommandRouter::getUIConfigOnPlugin
2017-12-22T09:01:32.686Z - info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
2017-12-22T09:01:32.813Z - info: Received Get System Version
2017-12-22T09:01:32.814Z - info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
2017-12-22T09:01:47.962Z - info: []
2017-12-22T09:01:59.363Z - info: CoreCommandRouter::volumioGetBrowseSources
2017-12-22T09:01:59.369Z - info: CoreCommandRouter::volumioGetQueue
2017-12-22T09:01:59.371Z - info: [1513933319370] CoreStateMachine::getQueue
2017-12-22T09:01:59.372Z - info: [1513933319371] CorePlayQueue::getQueue
2017-12-22T09:01:59.373Z - info: 
[1513933319372] ---------------------------- Client requests Volumio queue
2017-12-22T09:01:59.375Z - info: [1513933319374] InterfaceWebUI::pushQueue
2017-12-22T09:01:59.377Z - info: [1513933319376] ------------------------------ 7ms
2017-12-22T09:02:11.578Z - info: -------------------------------------------
2017-12-22T09:02:18.806Z - info: -------------------------------------------
2017-12-22T09:02:26.112Z - info: -------------------------------------------
2017-12-22T09:02:40.856Z - info: -------------------------------------------
2017-12-22T09:02:48.086Z - info: -------------------------------------------
2017-12-22T09:02:55.323Z - info: -------------------------------------------
2017-12-22T09:03:02.554Z - info: -------------------------------------------
2017-12-22T09:03:17.085Z - info: -------------------------------------------
2017-12-22T09:03:31.569Z - info: -------------------------------------------
2017-12-22T09:03:46.093Z - info: -------------------------------------------
2017-12-22T09:04:00.554Z - info: -------------------------------------------
2017-12-22T09:04:00.561Z - info: -----            Volumio2              ----
2017-12-22T09:04:00.561Z - info: -------------------------------------------
2017-12-22T09:04:00.562Z - info: -----          System startup          ----
2017-12-22T09:04:00.562Z - info: -------------------------------------------
2017-12-22T09:04:00.647Z - info: Plugin folders cleanup
2017-12-22T09:04:00.647Z - info: Scanning into folder /volumio/app/plugins/
2017-12-22T09:04:00.648Z - info: Scanning category audio_interface
2017-12-22T09:04:00.650Z - info: Scanning category miscellanea
2017-12-22T09:04:00.651Z - info: Scanning category music_service
2017-12-22T09:04:00.652Z - info: Scanning category plugins.json
2017-12-22T09:04:00.654Z - info: Scanning category system_controller
2017-12-22T09:04:00.656Z - info: Scanning category user_interface
2017-12-22T09:04:00.657Z - info: Scanning into folder /data/plugins/
2017-12-22T09:04:00.658Z - info: Plugin folders cleanup completed
2017-12-22T09:04:00.661Z - info: Loading plugins from folder /volumio/app/plugins/
2017-12-22T09:04:00.668Z - info: Loading plugins from folder /data/plugins/
2017-12-22T09:04:00.671Z - info: Loading plugin "system"...
2017-12-22T09:04:00.704Z - info: Loading plugin "appearance"...
2017-12-22T09:04:01.930Z - info: Loading plugin "network"...
2017-12-22T09:04:02.015Z - info: Loading plugin "services"...
2017-12-22T09:04:02.019Z - info: Loading plugin "alsa_controller"...
2017-12-22T09:04:02.136Z - info: Loading plugin "wizard"...
2017-12-22T09:04:02.145Z - info: Loading plugin "volumio_command_line_client"...
2017-12-22T09:04:02.151Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:04:02.153Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:04:02.154Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:04:02.155Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:04:02.194Z - info: Loading plugin "upnp"...
2017-12-22T09:04:02.201Z - info: [1513933442200] Starting Upmpd Daemon
2017-12-22T09:04:02.206Z - info: CoreCommandRouter::executeOnPlugin: system , registerCallback
2017-12-22T09:04:02.209Z - info: Loading plugin "mpd"...
2017-12-22T09:04:02.381Z - info: Loading plugin "upnp_browser"...
2017-12-22T09:04:03.071Z - info: Loading plugin "networkfs"...
2017-12-22T09:04:03.087Z - info: CoreCommandRouter::executeOnPlugin: system , registerCallback
2017-12-22T09:04:03.089Z - info: Loading plugin "alarm-clock"...
2017-12-22T09:04:03.270Z - info: Loading plugin "airplay_emulation"...
2017-12-22T09:04:03.291Z - info: [1513933443291] Starting Shairport Sync
2017-12-22T09:04:03.295Z - info: Loading plugin "last_100"...
2017-12-22T09:04:03.301Z - info: Loading plugin "webradio"...
2017-12-22T09:04:03.316Z - info: Loading plugin "i2s_dacs"...
2017-12-22T09:04:03.328Z - info: I2S DAC not set, start Auto-detection
2017-12-22T09:04:03.350Z - info: Loading plugin "volumiodiscovery"...
2017-12-22T09:04:03.397Z - info: Applying required configuration parameters for plugin volumiodiscovery
2017-12-22T09:04:03.437Z - info: CoreCommandRouter::executeOnPlugin: system , registerCallback
2017-12-22T09:04:03.441Z - info: Loading plugin "albumart"...
2017-12-22T09:04:03.463Z - info: Plugin example_plugin is not enabled
2017-12-22T09:04:03.465Z - info: Loading plugin "updater_comm"...
2017-12-22T09:04:03.880Z - info: Plugin mpdemulation is not enabled
2017-12-22T09:04:03.882Z - info: Loading plugin "rest_api"...
2017-12-22T09:04:03.900Z - info: Loading plugin "websocket"...
2017-12-22T09:04:03.943Z - info: ___________ START PLUGINS ___________
2017-12-22T09:04:03.947Z - info: PLUGIN START: appearance
2017-12-22T09:04:03.949Z - info: PLUGIN START: wizard
2017-12-22T09:04:03.952Z - info: PLUGIN START: upnp_browser
2017-12-22T09:04:03.954Z - info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
2017-12-22T09:04:03.956Z - info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
2017-12-22T09:04:03.957Z - info: [1513933443957] CoreMusicLibrary::Adding element Media Servers
2017-12-22T09:04:03.981Z - info: PLUGIN START: last_100
2017-12-22T09:04:03.983Z - info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
2017-12-22T09:04:03.985Z - info: [1513933443984] CoreMusicLibrary::Adding element Last_100
2017-12-22T09:04:03.988Z - info: PLUGIN START: webradio
2017-12-22T09:04:03.989Z - info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
2017-12-22T09:04:03.990Z - info: [1513933443989] CoreMusicLibrary::Adding element Webradio
2017-12-22T09:04:03.993Z - info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
2017-12-22T09:04:03.997Z - info: Loading i18n strings for locale en
2017-12-22T09:04:04.030Z - info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
2017-12-22T09:04:04.033Z - info: CoreCommandRouter::initPlayerControls
2017-12-22T09:04:04.047Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:04:04.048Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
2017-12-22T09:04:04.080Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:04:04.081Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:04:04.082Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:04:04.083Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:04:04.084Z - info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
2017-12-22T09:04:04.096Z - info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
2017-12-22T09:04:04.100Z - info: BOOT COMPLETED
2017-12-22T09:04:04.102Z - info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
2017-12-22T09:04:04.119Z - info: CoreCommandRouter::Close All Modals sent
2017-12-22T09:04:04.253Z - info: [1513933444252] CoreStateMachine::resetVolumioState
2017-12-22T09:04:04.255Z - info: [1513933444254] CoreStateMachine::getcurrentVolume
2017-12-22T09:04:04.257Z - info: CoreCommandRouter::volumioRetrievevolume
2017-12-22T09:04:04.277Z - info: [1513933444276] CoreStateMachine::updateTrackBlock
2017-12-22T09:04:04.279Z - info: [1513933444278] CorePlayQueue::getTrackBlock
2017-12-22T09:04:04.334Z - info: Cannot read play queue from file
2017-12-22T09:04:04.484Z - info: Setting Device type: Raspberry PI
2017-12-22T09:04:04.517Z - info: MPD running with PID688 ,establishing connection
2017-12-22T09:04:04.810Z - info: Volumio called home
2017-12-22T09:04:04.902Z - info: [1513933444901] VolumeController:: Volume=40 Mute =false
2017-12-22T09:04:04.906Z - info: [1513933444905] CoreStateMachine::pushState
2017-12-22T09:04:04.910Z - info: [1513933444909] CoreStateMachine::getState
2017-12-22T09:04:04.912Z - info: [1513933444911] CorePlayQueue::getTrack 0
2017-12-22T09:04:04.915Z - info: CoreCommandRouter::volumioPushState
2017-12-22T09:04:04.915Z - info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
2017-12-22T09:04:04.920Z - info: [1513933444919] interfaceApi::pushState
2017-12-22T09:04:04.922Z - info: [1513933444921] InterfaceWebUI::pushState
2017-12-22T09:04:04.971Z - info: Pushing Favourites {"service":"mpd","uri":"","favourite":false}
2017-12-22T09:04:04.995Z - info: 
2017-12-22T09:04:05.071Z - info: [1513933445071] CoreStateMachine::setRepeat null single undefined
2017-12-22T09:04:05.072Z - info: [1513933445072] CoreStateMachine::pushState
2017-12-22T09:04:05.074Z - info: [1513933445073] CoreStateMachine::getState
2017-12-22T09:04:05.075Z - info: [1513933445074] CorePlayQueue::getTrack 0
2017-12-22T09:04:05.076Z - info: CoreCommandRouter::volumioPushState
2017-12-22T09:04:05.079Z - info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
2017-12-22T09:04:05.081Z - info: [1513933445080] interfaceApi::pushState
2017-12-22T09:04:05.083Z - info: [1513933445081] InterfaceWebUI::pushState
2017-12-22T09:04:05.088Z - info: [1513933445088] CoreStateMachine::setRandom null
2017-12-22T09:04:05.090Z - info: [1513933445089] CoreStateMachine::pushState
2017-12-22T09:04:05.091Z - info: [1513933445090] CoreStateMachine::getState
2017-12-22T09:04:05.092Z - info: [1513933445091] CorePlayQueue::getTrack 0
2017-12-22T09:04:05.100Z - info: CoreCommandRouter::volumioPushState
2017-12-22T09:04:05.101Z - info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
2017-12-22T09:04:05.103Z - info: [1513933445102] interfaceApi::pushState
2017-12-22T09:04:05.104Z - info: [1513933445103] InterfaceWebUI::pushState
2017-12-22T09:04:05.153Z - info: Pushing Favourites {"service":"mpd","uri":"","favourite":false}
2017-12-22T09:04:05.159Z - info: Pushing Favourites {"service":"mpd","uri":"","favourite":false}
2017-12-22T09:04:05.340Z - info: mDNS: Found device Volumio
2017-12-22T09:04:05.410Z - info: mDNS: Found device Volumio
2017-12-22T09:04:05.485Z - info: [1513933445483] Shairport-Sync Started
2017-12-22T09:04:05.609Z - info: CoreCommandRouter::volumioGetState
2017-12-22T09:04:05.611Z - info: [1513933445610] CoreStateMachine::getState
2017-12-22T09:04:05.613Z - info: [1513933445611] CorePlayQueue::getTrack 0
2017-12-22T09:04:05.616Z - info: 
[1513933445614] ---------------------------- Client requests Volumio state
2017-12-22T09:04:05.619Z - info: [1513933445618] InterfaceWebUI::pushState
2017-12-22T09:04:05.642Z - info: [1513933445640] ------------------------------ 33ms
2017-12-22T09:04:05.668Z - info: 
[1513933445666] ---------------------------- Client requests Menu Items
2017-12-22T09:04:05.689Z - info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
2017-12-22T09:04:05.695Z - info: [1513933445693] Listing playlists
2017-12-22T09:04:05.698Z - info: CoreCommandRouter::volumioGetBrowseSources
2017-12-22T09:04:05.701Z - info: CoreCommandRouter::volumioGetQueue
2017-12-22T09:04:05.703Z - info: [1513933445702] CoreStateMachine::getQueue
2017-12-22T09:04:05.709Z - info: [1513933445705] CorePlayQueue::getQueue
2017-12-22T09:04:05.710Z - info: 
[1513933445710] ---------------------------- Client requests Volumio queue
2017-12-22T09:04:05.715Z - info: [1513933445714] InterfaceWebUI::pushQueue
2017-12-22T09:04:05.717Z - info: [1513933445716] ------------------------------ 17ms
2017-12-22T09:04:05.837Z - info: [1513933445836] ------------------------------ 170ms
2017-12-22T09:04:05.841Z - info: CoreCommandRouter::volumioGetState
2017-12-22T09:04:05.842Z - info: [1513933445841] CoreStateMachine::getState
2017-12-22T09:04:05.842Z - info: [1513933445842] CorePlayQueue::getTrack 0
2017-12-22T09:04:05.843Z - info: 
[1513933445842] ---------------------------- Client requests Volumio state
2017-12-22T09:04:05.850Z - info: [1513933445849] InterfaceWebUI::pushState
2017-12-22T09:04:05.869Z - info: [1513933445867] ------------------------------ 28ms
2017-12-22T09:04:05.885Z - info: 
[1513933445885] ---------------------------- Client requests Menu Items
2017-12-22T09:04:05.903Z - info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
2017-12-22T09:04:05.905Z - info: [1513933445904] Listing playlists
2017-12-22T09:04:05.952Z - info: [1513933445952] ------------------------------ 67ms
2017-12-22T09:04:07.131Z - info: CoreCommandRouter::volumioGetState
2017-12-22T09:04:07.133Z - info: [1513933447131] CoreStateMachine::getState
2017-12-22T09:04:07.135Z - info: [1513933447133] CorePlayQueue::getTrack 0
2017-12-22T09:04:07.137Z - info: 
[1513933447135] ---------------------------- Client requests Volumio state
2017-12-22T09:04:07.139Z - info: [1513933447137] InterfaceWebUI::pushState
2017-12-22T09:04:07.161Z - info: [1513933447159] ------------------------------ 32ms
2017-12-22T09:04:09.406Z - info: CoreCommandRouter::Close All Modals sent
2017-12-22T09:04:12.411Z - info: Upmpdcli Daemon Started
2017-12-22T09:04:44.882Z - info: []
2017-12-22T09:04:56.858Z - info: -------------------------------------------
2017-12-22T09:05:25.866Z - info: -------------------------------------------
2017-12-22T09:05:33.069Z - info: -------------------------------------------
2017-12-22T09:05:40.308Z - info: -------------------------------------------
2017-12-22T09:05:47.610Z - info: -------------------------------------------
2017-12-22T09:05:54.816Z - info: -------------------------------------------
2017-12-22T09:06:02.331Z - info: -------------------------------------------
2017-12-22T09:06:09.618Z - info: -------------------------------------------
2017-12-22T09:06:23.819Z - info: -------------------------------------------
2017-12-22T09:06:31.082Z - info: -------------------------------------------
2017-12-22T09:06:31.088Z - info: -----            Volumio2              ----
2017-12-22T09:06:31.089Z - info: -------------------------------------------
2017-12-22T09:06:31.090Z - info: -----          System startup          ----
2017-12-22T09:06:31.090Z - info: -------------------------------------------
2017-12-22T09:06:31.176Z - info: Plugin folders cleanup

Something is definitely wrong with the new features. I had no issues with an older release.
Is there a way to completely disable dlna/upnp?

[sinch]

I got the same problem.

On the network:
NAS (not configured on volumio)
iPad
iPhone
Android phone

Tried turning them off and didn’t fix the problem. Volumio keeps restarting.

Is it possible to download previous version?

[andib]

Same here: some screens about the load … i think something is going wrong …

i’m going back to 2.323 in the next days … no chance to stay … allways this screen …

[andib]

[meierzwo]

Version 346 seems to have Problems with WiFi. WiFi is OFF but it shows all WLAN SSIDs. Trying to connect to a WiFi Network does Multiple Restarts of the Network but no Connect and the WLAN Overview is empty - as it should be at WiFi OFF. But switching WiFI ON does also Multiple Restarts of the Network and the WLAN List stays empty. Version 344 does fine with WiFi. And no problems with 344 as described in this Thread. Two Installations, one Update from a previous Version and one fresh Install.

[zehnm]

Still the same issues with today’s 2.348
Logs were sent successfully this time though…
The following error keeps repeating:

Dec 23 12:43:02 volumio sudo[7939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1
Dec 23 12:43:02 volumio sudo[7939]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 23 12:43:02 volumio volumio[7876]: /volumio/app/plugins/music_service/upnp_browser/index.js:64
Dec 23 12:43:02 volumio volumio[7876]: var urlraw = headers.LOCATION.replace('http://', '').split('/')[0].split(':');
Dec 23 12:43:02 volumio volumio[7876]: ^
Dec 23 12:43:02 volumio volumio[7876]: TypeError: Cannot read property 'replace' of undefined
Dec 23 12:43:02 volumio volumio[7876]: at SsdpClient.responseHandler (/volumio/app/plugins/music_service/upnp_browser/index.js:64:32)
Dec 23 12:43:02 volumio volumio[7876]: at emitThree (events.js:116:13)
Dec 23 12:43:02 volumio volumio[7876]: at SsdpClient.emit (events.js:194:7)
Dec 23 12:43:02 volumio volumio[7876]: at SsdpClient.parseResponse [as _parseResponse] (/volumio/node_modules/node-ssdp/lib/index.js:436:8)
Dec 23 12:43:02 volumio volumio[7876]: at SsdpClient.SSDP._parseMessage (/volumio/node_modules/node-ssdp/lib/index.js:279:10)
Dec 23 12:43:02 volumio volumio[7876]: at Socket.onSocketMessage (/volumio/node_modules/node-ssdp/lib/index.js:231:12)
Dec 23 12:43:02 volumio volumio[7876]: at emitTwo (events.js:106:13)
Dec 23 12:43:02 volumio volumio[7876]: at Socket.emit (events.js:191:7)
Dec 23 12:43:02 volumio volumio[7876]: at UDP.onMessage (dgram.js:548:8)
Dec 23 12:43:02 volumio sudo[7939]: pam_unix(sudo:session): session closed for user root
Dec 23 12:43:02 volumio volumio-remote-updater[696]: [2017-12-23 12:43:02] [info] asio async_read_at_least error: system:104 (Connection reset by peer)
Dec 23 12:43:02 volumio volumio-remote-updater[696]: [2017-12-23 12:43:02] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error)
Dec 23 12:43:02 volumio volumio-remote-updater[696]: [2017-12-23 12:43:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Dec 23 12:43:02 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Dec 23 12:43:02 volumio systemd[1]: Unit volumio.service entered failed state.
Dec 23 12:43:02 volumio systemd[1]: Starting dynamicswap service...
Dec 23 12:43:02 volumio systemd[1]: Started dynamicswap service.
Dec 23 12:43:02 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.