-- Logs begin at Wed 2024-07-17 20:36:27 CEST, end at Wed 2024-07-17 20:49:42 CEST. -- Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: Received Get System Version Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: Received Get System Info Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: Discovery: Getting this device information Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:00 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:48:06 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:48:06 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:11 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetQueue Jul 17 20:48:11 volumio-kontoret volumio[1038]: info: CoreStateMachine::getQueue Jul 17 20:48:11 volumio-kontoret volumio[1038]: info: CorePlayQueue::getQueue Jul 17 20:48:12 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 17 20:48:13 volumio-kontoret volumio[1038]: info: Preload queue cleared Jul 17 20:48:16 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 17 20:48:16 volumio-kontoret volumio[1038]: info: Preload queue cleared Jul 17 20:48:18 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 17 20:48:18 volumio-kontoret volumio[1038]: info: Preload queue cleared Jul 17 20:48:20 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 17 20:48:20 volumio-kontoret volumio[1038]: info: Preload queue cleared Jul 17 20:48:21 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:22 volumio-kontoret volumio[1038]: error: error Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: Preload queue cleared Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::ClearQueue Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::stop Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CorePlayQueue::clearPlayQueue Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CorePlayQueue::saveQueue Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushQueue Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::addQueueItems Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CorePlayQueue::addQueueItems Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: Preload queue cleared Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664 Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushQueue Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CorePlayQueue::saveQueue Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::updateTrackBlock Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrackBlock Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPlay Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::play index 0 Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::stop Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::play index undefined Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CoreStateMachine::startPlaybackTimer Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: [1721242103820] ControllerWebradio::clearAddPlayTrack Jul 17 20:48:23 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: sendMpdCommand stop took 5 milliseconds Jul 17 20:48:23 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: Jul 17 20:48:23 volumio-kontoret volumio[1038]: ---------------------------- MPD announces system playlist update Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: Ignoring MPD Status Update Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: sendMpdCommand clear took 3 milliseconds Jul 17 20:48:23 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664" Jul 17 20:48:23 volumio-kontoret volumio[1038]: error: updateQueue error: null Jul 17 20:48:23 volumio-kontoret volumio[1038]: info: ------------------------------ 5ms Jul 17 20:48:24 volumio-kontoret volumio[1038]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664" took 331 milliseconds Jul 17 20:48:24 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 17 20:48:24 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand play Jul 17 20:48:24 volumio-kontoret volumio[1038]: info: Jul 17 20:48:24 volumio-kontoret volumio[1038]: ---------------------------- MPD announces system playlist update Jul 17 20:48:24 volumio-kontoret volumio[1038]: info: Ignoring MPD Status Update Jul 17 20:48:24 volumio-kontoret volumio[1038]: info: sendMpdCommand play took 10 milliseconds Jul 17 20:48:24 volumio-kontoret volumio[1038]: info: ------------------------------ 9ms Jul 17 20:48:31 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 17 20:48:31 volumio-kontoret volumio[1038]: info: Preload queue cleared Jul 17 20:48:33 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 17 20:48:33 volumio-kontoret volumio[1038]: info: TuneIn handleBrowseUri: tunein/popular Jul 17 20:48:33 volumio-kontoret volumio[1038]: info: Preload queue cleared Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: Preload queue cleared Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CoreStateMachine::ClearQueue Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CoreStateMachine::stop Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CorePlayQueue::clearPlayQueue Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CorePlayQueue::saveQueue Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushQueue Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CoreStateMachine::addQueueItems Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CorePlayQueue::addQueueItems Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: Preload queue cleared Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s25681 Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushQueue Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CorePlayQueue::saveQueue Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CoreStateMachine::updateTrackBlock Jul 17 20:48:35 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrackBlock Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPlay Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: CoreStateMachine::play index 0 Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: CoreStateMachine::stop Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: CoreStateMachine::play index undefined Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: CoreStateMachine::startPlaybackTimer Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: [1721242116007] ControllerWebradio::clearAddPlayTrack Jul 17 20:48:36 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: Jul 17 20:48:36 volumio-kontoret volumio[1038]: ---------------------------- MPD announces state update: player Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: sendMpdCommand stop took 7 milliseconds Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: ControllerMpd::getState Jul 17 20:48:36 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Jul 17 20:48:36 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: Jul 17 20:48:36 volumio-kontoret volumio[1038]: ---------------------------- MPD announces system playlist update Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: Ignoring MPD Status Update Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: sendMpdCommand status took 5 milliseconds Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: sendMpdCommand clear took 5 milliseconds Jul 17 20:48:36 volumio-kontoret volumio[1038]: verbose: ControllerMpd::parseState Jul 17 20:48:36 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 20:48:36 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand load "https://sverigesradio.se/topsy/direkt/tunein/164-hi.mp3" Jul 17 20:48:36 volumio-kontoret volumio[1038]: error: updateQueue error: null Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: ------------------------------ 8ms Jul 17 20:48:36 volumio-kontoret volumio[1038]: error: ControllerMpd::pushError: Error: [2@0] {playlistinfo} Bad song index Jul 17 20:48:36 volumio-kontoret volumio[1038]: info: ------------------------------ 16ms Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand add "https://sverigesradio.se/topsy/direkt/tunein/164-hi.mp3" Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: Jul 17 20:48:37 volumio-kontoret volumio[1038]: ---------------------------- MPD announces system playlist update Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: Ignoring MPD Status Update Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: sendMpdCommand add "https://sverigesradio.se/topsy/direkt/tunein/164-hi.mp3" took 9 milliseconds Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand play Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: ------------------------------ 7ms Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: sendMpdCommand play took 4 milliseconds Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: Jul 17 20:48:37 volumio-kontoret volumio[1038]: ---------------------------- MPD announces state update: player Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: ControllerMpd::getState Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: Jul 17 20:48:37 volumio-kontoret volumio[1038]: ---------------------------- MPD announces system playlist update Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: Ignoring MPD Status Update Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: Jul 17 20:48:37 volumio-kontoret volumio[1038]: ---------------------------- MPD announces state update: player Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: sendMpdCommand status took 243 milliseconds Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: ControllerMpd::getState Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: ControllerMpd::parseState Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: ------------------------------ 4ms Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: sendMpdCommand status took 2 milliseconds Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: ControllerMpd::parseState Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: ControllerMpd::parseTrackInfo Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: ControllerMpd::pushState Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreCommandRouter::servicePushState Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"164-hi.mp3","artist":"p3-mp3-192","album":null,"uri":"https://sverigesradio.se/topsy/direkt/tunein/164-hi.mp3","trackType":"mp3"} Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: CURRENT POSITION 0 Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreStateMachine::syncState stateService play Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreStateMachine::syncState currentStatus stop Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: ------------------------------ 250ms Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: ControllerMpd::parseTrackInfo Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: ControllerMpd::pushState Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreCommandRouter::servicePushState Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"164-hi.mp3","artist":"p3-mp3-192","album":null,"uri":"https://sverigesradio.se/topsy/direkt/tunein/164-hi.mp3","trackType":"mp3"} Jul 17 20:48:37 volumio-kontoret volumio[1038]: verbose: CURRENT POSITION 0 Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreStateMachine::syncState stateService play Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreStateMachine::syncState currentStatus play Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: Received an update from plugin. extracting info from payload Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:48:37 volumio-kontoret volumio[1038]: info: ------------------------------ 23ms Jul 17 20:48:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:48:51 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 20:48:52 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Preparing to save Alsa Options, stopping services first Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioStop Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreStateMachine::stop Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreStateMachine::stPlaybackTimer Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreStateMachine::updateTrackBlock Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrackBlock Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreStateMachine::serviceStop Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::serviceStop Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: [1721242137166] ControllerWebradio::stop Jul 17 20:48:57 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"Headphone Jack/ Speaker"}} Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Found match in Cards Database: setting mixer DAC1 for card Headphone Jack/ Speaker Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Updating Volume Controller Parameters: Device: 1 Name: softvolume Mixer: DAC1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Disabling external Volume Control Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Enable softmixer device for audio device undefined Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Software Volume ALSA configuration written Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Preparing to generate the ALSA configuration file Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Jul 17 20:48:57 volumio-kontoret volumio[1038]: ---------------------------- MPD announces state update: player Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: sendMpdCommand stop took 506 milliseconds Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: ControllerMpd::getState Jul 17 20:48:57 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Reading ALSA contributions from plugins. Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: sendMpdCommand status took 25 milliseconds Jul 17 20:48:57 volumio-kontoret volumio[1038]: verbose: ControllerMpd::parseState Jul 17 20:48:57 volumio-kontoret volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 17 20:48:57 volumio-kontoret volumio[1038]: verbose: ControllerMpd::parseTrackInfo Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: ControllerMpd::pushState Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::servicePushState Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: ------------------------------ 57ms Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: VolumeController:: Volume=100 Mute =false Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Preparing to save Alsa Options, stopping services first Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioStop Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreStateMachine::stop Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"Headphone Jack/ Speaker"}} Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Found match in Cards Database: setting mixer DAC1 for card Headphone Jack/ Speaker Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Updating Volume Controller Parameters: Device: 1 Name: softvolume Mixer: DAC1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Disabling external Volume Control Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: Enable softmixer device for audio device undefined Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:48:57 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Asound.conf file unchanged, so no further update is needed Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Output device has changed, restarting MPD Jul 17 20:48:58 volumio-kontoret sudo[3705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 20:48:58 volumio-kontoret sudo[3705]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Output device has changed, restarting Shairport Sync Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:48:58 volumio-kontoret sudo[3705]: pam_unix(sudo:session): session closed for user root Jul 17 20:48:58 volumio-kontoret sudo[3708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 20:48:58 volumio-kontoret sudo[3708]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:48:58 volumio-kontoret systemd[1]: Stopping Music Player Daemon... Jul 17 20:48:58 volumio-kontoret systemd[1]: mpd.service: Succeeded. Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 20:48:58 volumio-kontoret systemd[1]: Stopped Music Player Daemon. Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Software Volume ALSA configuration written Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Preparing to generate the ALSA configuration file Jul 17 20:48:58 volumio-kontoret systemd[1]: Starting Music Player Daemon... Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Reading ALSA contributions from plugins. Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: MPD Permissions set Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: VolumeController:: Volume=100 Mute =false Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret sudo[3713]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 17 20:48:58 volumio-kontoret sudo[3713]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:48:58 volumio-kontoret sudo[3713]: pam_unix(sudo:session): session closed for user root Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Starting Shairport Sync Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Asound.conf file unchanged, so no further update is needed Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Output device has changed, restarting MPD Jul 17 20:48:58 volumio-kontoret sudo[3724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 20:48:58 volumio-kontoret sudo[3724]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:48:58 volumio-kontoret systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 20:48:58 volumio-kontoret systemd[1]: shairport-sync.service: Succeeded. Jul 17 20:48:58 volumio-kontoret systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 17 20:48:58 volumio-kontoret sudo[3727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 20:48:58 volumio-kontoret sudo[3727]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Output device has changed, restarting Shairport Sync Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:48:58 volumio-kontoret systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 20:48:58 volumio-kontoret sudo[3727]: pam_unix(sudo:session): session closed for user root Jul 17 20:48:58 volumio-kontoret sudo[3724]: pam_unix(sudo:session): session closed for user root Jul 17 20:48:58 volumio-kontoret sudo[3730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 20:48:58 volumio-kontoret sudo[3730]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:48:58 volumio-kontoret systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 17 20:48:58 volumio-kontoret systemd[1]: mpd.service: Succeeded. Jul 17 20:48:58 volumio-kontoret systemd[1]: Stopped Music Player Daemon. Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 20:48:58 volumio-kontoret systemd[1]: Starting Music Player Daemon... Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: MPD Permissions set Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Shairport-Sync Started Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Starting Shairport Sync Jul 17 20:48:58 volumio-kontoret sudo[3738]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 17 20:48:58 volumio-kontoret sudo[3738]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:48:58 volumio-kontoret sudo[3738]: pam_unix(sudo:session): session closed for user root Jul 17 20:48:58 volumio-kontoret sudo[3746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 20:48:58 volumio-kontoret sudo[3746]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:48:58 volumio-kontoret systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 20:48:58 volumio-kontoret systemd[1]: shairport-sync.service: Succeeded. Jul 17 20:48:58 volumio-kontoret systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 17 20:48:58 volumio-kontoret systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 20:48:58 volumio-kontoret sudo[3746]: pam_unix(sudo:session): session closed for user root Jul 17 20:48:58 volumio-kontoret volumio[1038]: info: Shairport-Sync Started Jul 17 20:48:59 volumio-kontoret mpd[3748]: Jul 17 20:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 17 20:48:59 volumio-kontoret systemd[1]: Started Music Player Daemon. Jul 17 20:48:59 volumio-kontoret sudo[3730]: pam_unix(sudo:session): session closed for user root Jul 17 20:48:59 volumio-kontoret sudo[3708]: pam_unix(sudo:session): session closed for user root Jul 17 20:48:59 volumio-kontoret volumio[1038]: error: MPD error: The expression evaluated to a falsy value: Jul 17 20:48:59 volumio-kontoret volumio[1038]: assert.ok(self.idling) Jul 17 20:48:59 volumio-kontoret volumio[1038]: error: The expression evaluated to a falsy value: Jul 17 20:48:59 volumio-kontoret volumio[1038]: assert.ok(self.idling) Jul 17 20:48:59 volumio-kontoret volumio[1038]: error: updateQueue error: null Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreStateMachine::getcurrentVolume Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioRetrievevolume Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: VolumeController:: Volume=100 Mute =false Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreStateMachine::updateTrackBlock Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrackBlock Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioRetrievevolume Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: VolumeController:: Volume=100 Mute =false Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreStateMachine::getcurrentVolume Jul 17 20:49:01 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioRetrievevolume Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: VolumeController:: Volume=100 Mute =false Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: CoreStateMachine::updateTrackBlock Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrackBlock Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioRetrievevolume Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: VolumeController:: Volume=100 Mute =false Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:02 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:07 volumio-kontoret ntpd[1289]: 147.78.228.41 local addr 10.1.1.139 -> Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Preparing to save Alsa Options, stopping services first Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioStop Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreStateMachine::stop Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"Headphone Jack/ Speaker"}} Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Found match in Cards Database: setting mixer DAC1 for card Headphone Jack/ Speaker Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Updating Volume Controller Parameters: Device: 1 Name: softvolume Mixer: DAC1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Disabling external Volume Control Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Enable softmixer device for audio device undefined Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Software Volume ALSA configuration written Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Preparing to generate the ALSA configuration file Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Reading ALSA contributions from plugins. Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Asound.conf file unchanged, so no further update is needed Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Output device has changed, restarting MPD Jul 17 20:49:09 volumio-kontoret sudo[3796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 17 20:49:09 volumio-kontoret sudo[3796]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Output device has changed, restarting Shairport Sync Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:49:09 volumio-kontoret sudo[3796]: pam_unix(sudo:session): session closed for user root Jul 17 20:49:09 volumio-kontoret sudo[3799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 17 20:49:09 volumio-kontoret sudo[3799]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:49:09 volumio-kontoret systemd[1]: Stopping Music Player Daemon... Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 17 20:49:09 volumio-kontoret systemd[1]: mpd.service: Succeeded. Jul 17 20:49:09 volumio-kontoret systemd[1]: Stopped Music Player Daemon. Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: MPD Permissions set Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: VolumeController:: Volume=100 Mute =false Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:49:09 volumio-kontoret systemd[1]: Starting Music Player Daemon... Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 17 20:49:09 volumio-kontoret volumio[1038]: info: Starting Shairport Sync Jul 17 20:49:09 volumio-kontoret sudo[3804]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 17 20:49:09 volumio-kontoret sudo[3804]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:49:09 volumio-kontoret sudo[3812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 17 20:49:09 volumio-kontoret sudo[3812]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:49:09 volumio-kontoret sudo[3804]: pam_unix(sudo:session): session closed for user root Jul 17 20:49:10 volumio-kontoret systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 17 20:49:10 volumio-kontoret systemd[1]: shairport-sync.service: Succeeded. Jul 17 20:49:10 volumio-kontoret systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 17 20:49:10 volumio-kontoret systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 17 20:49:10 volumio-kontoret sudo[3812]: pam_unix(sudo:session): session closed for user root Jul 17 20:49:10 volumio-kontoret volumio[1038]: info: Shairport-Sync Started Jul 17 20:49:10 volumio-kontoret volumio[1038]: error: Upnp client error: Error: This socket has been ended by the other party Jul 17 20:49:10 volumio-kontoret mpd[3815]: Jul 17 20:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 17 20:49:10 volumio-kontoret systemd[1]: Started Music Player Daemon. Jul 17 20:49:10 volumio-kontoret sudo[3799]: pam_unix(sudo:session): session closed for user root Jul 17 20:49:10 volumio-kontoret volumio[1038]: error: updateQueue error: null Jul 17 20:49:11 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:11 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:11 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:11 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:11 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:12 volumio-kontoret volumio[1038]: error: error Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CoreStateMachine::getcurrentVolume Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioRetrievevolume Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: VolumeController:: Volume=100 Mute =false Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CoreStateMachine::updateTrackBlock Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrackBlock Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioRetrievevolume Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: VolumeController:: Volume=100 Mute =false Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:13 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: Restoring Previous Volume level: 100 false true Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: VolumeController::SetAlsaVolume100 Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: Volume configurations have been set Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: Updating Volume Controller Parameters: Device: 1 Name: softvolume Mixer: DAC1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: Disabling external Volume Control Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:49:17 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:17 volumio-kontoret ntpd[1289]: 194.58.206.20 local addr 10.1.1.139 -> Jul 17 20:49:19 volumio-kontoret ntpd[1289]: 193.182.111.13 local addr 10.1.1.139 -> Jul 17 20:49:21 volumio-kontoret volumio[1038]: info: VolumeController::SetAlsaVolume100 Jul 17 20:49:21 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:21 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:21 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:49:21 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: Restoring Previous Volume level: 100 false true Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: VolumeController::SetAlsaVolume100 Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: Volume configurations have been set Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: Updating Volume Controller Parameters: Device: 1 Name: softvolume Mixer: DAC1 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: Disabling external Volume Control Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:49:25 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:30 volumio-kontoret volumio[1038]: info: VolumeController::SetAlsaVolume100 Jul 17 20:49:30 volumio-kontoret volumio[1038]: info: CoreStateMachine::pushState Jul 17 20:49:30 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:30 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 20:49:30 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioPushState Jul 17 20:49:30 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:49:30 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:33 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:49:33 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:38 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:49:38 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 20:49:38 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 20:49:38 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 20:49:38 volumio-kontoret volumio[1038]: info: Received Get System Version Jul 17 20:49:38 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 20:49:39 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Jul 17 20:49:39 volumio-kontoret volumio[1038]: info: CoreCommandRouter::Reload Ui Jul 17 20:49:40 volumio-kontoret sudo[3970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 17 20:49:40 volumio-kontoret sudo[3970]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:49:40 volumio-kontoret sudo[3970]: pam_unix(sudo:session): session closed for user root Jul 17 20:49:40 volumio-kontoret sudo[3973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 17 20:49:40 volumio-kontoret sudo[3973]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:49:40 volumio-kontoret sudo[3973]: pam_unix(sudo:session): session closed for user root Jul 17 20:49:40 volumio-kontoret volumio[1038]: verbose: New Socket.io Connection to 10.1.1.139 from 10.1.1.23 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetVisibleSources Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Received Get System Info Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Discovery: Getting this device information Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::volumioGetState Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CorePlayQueue::getTrack 0 Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:49:40 volumio-kontoret volumio-remote-updater[732]: No test mode Jul 17 20:49:40 volumio-kontoret volumio-remote-updater[732]: No alpha test mode Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Retrieving Cloud Streaming UI Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Getting Tidal Cloud Configuration Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Getting Qobuz Cloud Configuration Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Asking plugin for UI Config Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Getting Spotify Cloud Configuration Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Asking plugin for UI Config Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Saving Spotify Acccount Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Got Tidal Cloud Configuration Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Got it Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Got it Jul 17 20:49:40 volumio-kontoret volumio[1038]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:49:40 volumio-kontoret volumio[1038]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 17 20:49:40 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 17 20:49:41 volumio-kontoret volumio[1038]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jul 17 20:49:41 volumio-kontoret volumio[1038]: info: Loading i18n strings for locale en Jul 17 20:49:41 volumio-kontoret volumio[1038]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 20:49:41 volumio-kontoret volumio[1038]: TypeError: Cannot read property 'logger' of null Jul 17 20:49:41 volumio-kontoret volumio[1038]: at NowPlayingContext.getLogger (/data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js:70:83) Jul 17 20:49:41 volumio-kontoret volumio[1038]: at ControllerNowPlaying._ControllerNowPlaying_onVolumioLanguageChanged (/data/plugins/user_interface/now_playing/dist/index.js:1834:33) Jul 17 20:49:41 volumio-kontoret volumio[1038]: at /volumio/node_modules/v-conf/index.js:165:13 Jul 17 20:49:41 volumio-kontoret volumio[1038]: at /volumio/node_modules/multimap/index.js:150:9 Jul 17 20:49:41 volumio-kontoret volumio[1038]: at Array.forEach () Jul 17 20:49:41 volumio-kontoret volumio[1038]: at /volumio/node_modules/multimap/index.js:149:13 Jul 17 20:49:41 volumio-kontoret volumio[1038]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) Jul 17 20:49:41 volumio-kontoret volumio[1038]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5) Jul 17 20:49:41 volumio-kontoret volumio[1038]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10) Jul 17 20:49:41 volumio-kontoret volumio[1038]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20) Jul 17 20:49:41 volumio-kontoret volumio[1038]: at volumioAppearance.setLanguage (/volumio/app/plugins/miscellanea/appearance/index.js:325:35) Jul 17 20:49:41 volumio-kontoret volumio[1038]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32) Jul 17 20:49:41 volumio-kontoret volumio[1038]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1653:37) Jul 17 20:49:41 volumio-kontoret volumio[1038]: at Socket.emit (events.js:400:28) Jul 17 20:49:41 volumio-kontoret volumio[1038]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 17 20:49:41 volumio-kontoret volumio[1038]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Jul 17 20:49:41 volumio-kontoret volumio[1038]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 20:49:42 volumio-kontoret sudo[3993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-17 20:48 Jul 17 20:49:42 volumio-kontoret sudo[3993]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"