-- Logs begin at Wed 2026-03-25 08:20:34 UTC, end at Thu 2026-03-26 08:27:25 UTC. -- Mar 26 08:26:00 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 08:26:00 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 08:26:00 volumio volumio[1019]: info: Discovery: Getting this device information Mar 26 08:26:00 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Mar 26 08:26:00 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:00 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Mar 26 08:26:00 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 26 08:26:00 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 26 08:26:00 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 26 08:26:00 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 26 08:26:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 08:26:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 08:26:01 volumio volumio[1019]: info: Discovery: Getting this device information Mar 26 08:26:01 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Mar 26 08:26:01 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Mar 26 08:26:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 26 08:26:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 26 08:26:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 26 08:26:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 26 08:26:02 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 08:26:02 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 08:26:02 volumio volumio[1019]: info: Discovery: Getting this device information Mar 26 08:26:02 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Mar 26 08:26:02 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:02 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Mar 26 08:26:02 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 26 08:26:02 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 26 08:26:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 08:26:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 08:26:04 volumio volumio[1019]: info: Discovery: Getting this device information Mar 26 08:26:04 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Mar 26 08:26:04 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Mar 26 08:26:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 26 08:26:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getConf Mar 26 08:26:16 volumio sudo[5150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 26 08:26:16 volumio sudo[5152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 26 08:26:16 volumio sudo[5152]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 08:26:16 volumio sudo[5150]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 26 08:26:16 volumio sudo[5152]: pam_unix(sudo:session): session closed for user root Mar 26 08:26:16 volumio sudo[5150]: pam_unix(sudo:session): session closed for user root Mar 26 08:26:17 volumio volumio[1019]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 26 08:26:17 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 26 08:26:17 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 26 08:26:17 volumio volumio[1019]: info: CoreCommandRouter::volumioGetState Mar 26 08:26:17 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:17 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 26 08:26:17 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 26 08:26:17 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 26 08:26:17 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 26 08:26:17 volumio volumio[1019]: info: Received Get System Version Mar 26 08:26:17 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 26 08:26:22 volumio volumio[1019]: info: Listing playlists Mar 26 08:26:33 volumio volumio[1019]: info: CoreCommandRouter::volumioSeek Mar 26 08:26:33 volumio volumio[1019]: info: CoreStateMachine::seek Mar 26 08:26:33 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:33 volumio volumio[1019]: info: TRACKBLOCK {"uri":"mnt/USB/My Passport/музыка/Кино (Виктор Цой) - Коллекция (4LP)-1988, 1988, 1989, 1991/Kino (Виктор Цой) - Le Dernier Des Heros 1989 (1991)/Kino (Виктор Цой) - Le Dernier Des Heros_(Side A) 1989.flac","service":"mpd","name":"Kino (Виктор Цой) - Le Dernier Des Heros_(Side A) 1989.flac","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=281&web=//extralarge&path=%2FUSB%2FMy%20Passport%2F%D0%BC%D1%83%D0%B7%D1%8B%D0%BA%D0%B0%2F%D0%9A%D0%B8%D0%BD%D0%BE%20(%D0%92%D0%B8%D0%BA%D1%82%D0%BE%D1%80%20%D0%A6%D0%BE%D0%B9)%20-%20%D0%9A%D0%BE%D0%BB%D0%BB%D0%B5%D0%BA%D1%86%D0%B8%D1%8F%20(4LP)-1988%2C%201988%2C%201989%2C%201991%2FKino%20(%D0%92%D0%B8%D0%BA%D1%82%D0%BE%D1%80%20%D0%A6%D0%BE%D0%B9)%20-%20Le%20Dernier%20Des%20Heros%201989%20(1991)&metadata=false","duration":1309,"samplerate":"192 kHz","bitdepth":"24 bit","trackType":"flac","channels":2} Mar 26 08:26:33 volumio volumio[1019]: info: CoreStateMachine::startPlaybackTimer Mar 26 08:26:33 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:33 volumio volumio[1019]: info: ControllerMpd::seek Mar 26 08:26:33 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:33 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:33 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:33 volumio volumio[1019]: error: null Mar 26 08:26:33 volumio volumio[1019]: info: Mar 26 08:26:33 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:26:33 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:26:33 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:26:33 volumio volumio[1019]: info: sendMpdCommand status took 3 milliseconds Mar 26 08:26:33 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:26:33 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:26:33 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 26 08:26:33 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:26:33 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:26:33 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:26:33 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:33 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":583085,"duration":1309,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4865 Kbps","isStreaming":false,"title":"Kino (Виктор Цой) - Le Dernier Des Heros_(Side A) 1989.flac","artist":null,"album":null,"uri":"USB/My Passport/музыка/Кино (Виктор Цой) - Коллекция (4LP)-1988, 1988, 1989, 1991/Kino (Виктор Цой) - Le Dernier Des Heros 1989 (1991)/Kino (Виктор Цой) - Le Dernier Des Heros_(Side A) 1989.flac","trackType":"flac"} Mar 26 08:26:33 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:26:33 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:26:33 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Mar 26 08:26:33 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Mar 26 08:26:33 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:33 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:33 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:33 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:33 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:33 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:33 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:33 volumio volumio[1019]: info: ------------------------------ 37ms Mar 26 08:26:35 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 26 08:26:35 volumio volumio[1019]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 26 08:26:35 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 26 08:26:35 volumio volumio[1019]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Mar 26 08:26:35 volumio volumio[1019]: info: Received Get System Version Mar 26 08:26:35 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 26 08:26:38 volumio volumio[1019]: info: CoreCommandRouter::volumioPause Mar 26 08:26:38 volumio volumio[1019]: info: CoreStateMachine::pause Mar 26 08:26:38 volumio volumio[1019]: info: CoreStateMachine::stPlaybackTimer Mar 26 08:26:38 volumio volumio[1019]: info: CoreStateMachine::servicePause Mar 26 08:26:38 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:38 volumio volumio[1019]: info: CoreCommandRouter::servicePause Mar 26 08:26:38 volumio volumio[1019]: info: ControllerMpd::pause Mar 26 08:26:38 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand pause Mar 26 08:26:38 volumio volumio[1019]: info: Mar 26 08:26:38 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:26:38 volumio volumio[1019]: info: sendMpdCommand pause took 63 milliseconds Mar 26 08:26:38 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:26:38 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:26:38 volumio volumio[1019]: info: sendMpdCommand status took 1 milliseconds Mar 26 08:26:38 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:26:38 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:26:38 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 26 08:26:38 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:26:38 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:26:38 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:26:38 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:38 volumio volumio[1019]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":588583,"duration":1309,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5343 Kbps","isStreaming":false,"title":"Kino (Виктор Цой) - Le Dernier Des Heros_(Side A) 1989.flac","artist":null,"album":null,"uri":"USB/My Passport/музыка/Кино (Виктор Цой) - Коллекция (4LP)-1988, 1988, 1989, 1991/Kino (Виктор Цой) - Le Dernier Des Heros 1989 (1991)/Kino (Виктор Цой) - Le Dernier Des Heros_(Side A) 1989.flac","trackType":"flac"} Mar 26 08:26:38 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:26:38 volumio volumio[1019]: info: CoreStateMachine::syncState stateService pause Mar 26 08:26:38 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus pause Mar 26 08:26:38 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:38 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:38 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:38 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:38 volumio volumio[1019]: info: CoreStateMachine::stPlaybackTimer Mar 26 08:26:38 volumio volumio[1019]: info: ------------------------------ 20ms Mar 26 08:26:38 volumio volumio[1019]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 26 08:26:39 volumio volumio[1019]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 26 08:26:39 volumio volumio[1019]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Mar 26 08:26:41 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay Mar 26 08:26:41 volumio volumio[1019]: verbose: UNSET VOLATILE Mar 26 08:26:41 volumio volumio[1019]: info: CoreStateMachine::play index undefined Mar 26 08:26:41 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 08:26:41 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:41 volumio volumio[1019]: info: CoreStateMachine::startPlaybackTimer Mar 26 08:26:41 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:41 volumio volumio[1019]: info: ControllerMpd::resume Mar 26 08:26:41 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand play Mar 26 08:26:41 volumio volumio[1019]: info: Mar 26 08:26:41 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:26:41 volumio volumio[1019]: info: sendMpdCommand play took 12 milliseconds Mar 26 08:26:41 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:26:41 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:26:41 volumio volumio[1019]: info: sendMpdCommand status took 1 milliseconds Mar 26 08:26:41 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:26:41 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:26:41 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 26 08:26:41 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:26:41 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:26:41 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:26:41 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:41 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":588946,"duration":1309,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5109 Kbps","isStreaming":false,"title":"Kino (Виктор Цой) - Le Dernier Des Heros_(Side A) 1989.flac","artist":null,"album":null,"uri":"USB/My Passport/музыка/Кино (Виктор Цой) - Коллекция (4LP)-1988, 1988, 1989, 1991/Kino (Виктор Цой) - Le Dernier Des Heros 1989 (1991)/Kino (Виктор Цой) - Le Dernier Des Heros_(Side A) 1989.flac","trackType":"flac"} Mar 26 08:26:41 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:26:41 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:26:41 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus pause Mar 26 08:26:41 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:41 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:41 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:41 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:41 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:41 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:41 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:41 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:41 volumio volumio[1019]: info: ------------------------------ 33ms Mar 26 08:26:44 volumio volumio[1019]: info: VolumeController::SetAlsaVolume90 Mar 26 08:26:44 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:44 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:44 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:44 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:44 volumio volumio[1019]: info: VolumeController::SetAlsaVolume75 Mar 26 08:26:44 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:44 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:44 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:44 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:44 volumio volumio[1019]: info: VolumeController::SetAlsaVolume65 Mar 26 08:26:44 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:44 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:44 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:44 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:45 volumio volumio[1019]: info: VolumeController::SetAlsaVolume60 Mar 26 08:26:45 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:45 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:45 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:45 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:46 volumio volumio[1019]: info: VolumeController::SetAlsaVolume50 Mar 26 08:26:46 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:46 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:46 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:46 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:46 volumio volumio[1019]: info: VolumeController::SetAlsaVolume25 Mar 26 08:26:46 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:26:46 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:26:46 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:26:46 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:26:51 volumio volumio[1019]: info: CoreCommandRouter::volumioGetVisibleSources Mar 26 08:26:51 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 26 08:26:51 volumio volumio[1019]: info: CoreCommandRouter::volumioGetQueue Mar 26 08:26:51 volumio volumio[1019]: info: CoreStateMachine::getQueue Mar 26 08:26:51 volumio volumio[1019]: info: CorePlayQueue::getQueue Mar 26 08:26:52 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 26 08:26:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 26 08:26:57 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 26 08:27:01 volumio volumio[1019]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::ClearQueue Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::stop Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 08:27:01 volumio volumio[1019]: verbose: UNSET VOLATILE Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::stPlaybackTimer Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock Mar 26 08:27:01 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:01 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:01 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::serviceStop Mar 26 08:27:01 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:01 volumio volumio[1019]: info: CoreCommandRouter::serviceStop Mar 26 08:27:01 volumio volumio[1019]: info: ControllerMpd::stop Mar 26 08:27:01 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 08:27:01 volumio volumio[1019]: info: CorePlayQueue::clearPlayQueue Mar 26 08:27:01 volumio volumio[1019]: info: CorePlayQueue::saveQueue Mar 26 08:27:01 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:01 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::addQueueItems Mar 26 08:27:01 volumio volumio[1019]: info: CorePlayQueue::addQueueItems Mar 26 08:27:01 volumio volumio[1019]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012 Mar 26 08:27:01 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 26 08:27:01 volumio volumio[1019]: info: CorePlayQueue::saveQueue Mar 26 08:27:01 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock Mar 26 08:27:01 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock Mar 26 08:27:01 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay Mar 26 08:27:01 volumio volumio[1019]: verbose: UNSET VOLATILE Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::play index 0 Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::stop Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 08:27:01 volumio volumio[1019]: verbose: UNSET VOLATILE Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::play index undefined Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 08:27:01 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:01 volumio volumio[1019]: info: CoreStateMachine::startPlaybackTimer Mar 26 08:27:01 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:01 volumio volumio[1019]: info: [1774513621310] ControllerWebradio::clearAddPlayTrack Mar 26 08:27:01 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 08:27:01 volumio volumio[1019]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 26 08:27:01 volumio volumio[1019]: info: Mar 26 08:27:01 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:01 volumio volumio[1019]: info: sendMpdCommand stop took 94 milliseconds Mar 26 08:27:01 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:01 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:01 volumio volumio[1019]: info: sendMpdCommand stop took 74 milliseconds Mar 26 08:27:01 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clear Mar 26 08:27:01 volumio volumio[1019]: info: Mar 26 08:27:01 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:01 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:01 volumio volumio[1019]: info: sendMpdCommand status took 10 milliseconds Mar 26 08:27:01 volumio volumio[1019]: info: sendMpdCommand clear took 5 milliseconds Mar 26 08:27:01 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:01 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:01 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" Mar 26 08:27:01 volumio volumio[1019]: error: updateQueue error: null Mar 26 08:27:01 volumio volumio[1019]: info: ------------------------------ 11ms Mar 26 08:27:01 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 26 08:27:01 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:01 volumio volumio[1019]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 26 08:27:01 volumio volumio[1019]: info: ------------------------------ 24ms Mar 26 08:27:02 volumio volumio[1019]: info: Mar 26 08:27:02 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:02 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:02 volumio volumio[1019]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" took 928 milliseconds Mar 26 08:27:02 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 26 08:27:02 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand play Mar 26 08:27:02 volumio volumio[1019]: info: ------------------------------ 5ms Mar 26 08:27:02 volumio volumio[1019]: info: sendMpdCommand play took 3 milliseconds Mar 26 08:27:04 volumio volumio[1019]: info: Mar 26 08:27:04 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:04 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:04 volumio volumio[1019]: info: Mar 26 08:27:04 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:04 volumio volumio[1019]: info: sendMpdCommand status took 2 milliseconds Mar 26 08:27:04 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:04 volumio volumio[1019]: info: Mar 26 08:27:04 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:04 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:04 volumio volumio[1019]: info: sendMpdCommand status took 3 milliseconds Mar 26 08:27:04 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:04 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:27:04 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:04 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"rockantenne","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 08:27:04 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:04 volumio volumio[1019]: info: ------------------------------ 29ms Mar 26 08:27:04 volumio volumio[1019]: info: ------------------------------ 24ms Mar 26 08:27:04 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:04 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:27:04 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:04 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"rockantenne","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 08:27:04 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Mar 26 08:27:04 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:04 volumio volumio[1019]: info: ------------------------------ 49ms Mar 26 08:27:04 volumio volumio[1019]: info: Mar 26 08:27:04 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:04 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:04 volumio volumio[1019]: info: Mar 26 08:27:04 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:04 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:04 volumio volumio[1019]: info: ------------------------------ 9ms Mar 26 08:27:04 volumio volumio[1019]: info: sendMpdCommand status took 7 milliseconds Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:04 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 26 08:27:04 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:04 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:27:04 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:04 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 08:27:04 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Mar 26 08:27:04 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:04 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:04 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:04 volumio volumio[1019]: info: ------------------------------ 35ms Mar 26 08:27:05 volumio volumio[1019]: info: Mar 26 08:27:05 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:05 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:05 volumio volumio[1019]: info: Mar 26 08:27:05 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:05 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:05 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:05 volumio volumio[1019]: info: ------------------------------ 4ms Mar 26 08:27:05 volumio volumio[1019]: info: sendMpdCommand status took 4 milliseconds Mar 26 08:27:05 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:05 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:05 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 26 08:27:05 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:05 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:27:05 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:27:05 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:05 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1480,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 08:27:05 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:27:05 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:27:05 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Mar 26 08:27:05 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Mar 26 08:27:05 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 08:27:05 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:05 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:05 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:05 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:05 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:05 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:05 volumio volumio[1019]: info: ------------------------------ 30ms Mar 26 08:27:05 volumio volumio[1019]: info: Mar 26 08:27:05 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:05 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:05 volumio volumio[1019]: info: Mar 26 08:27:05 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:05 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:05 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:05 volumio volumio[1019]: info: ------------------------------ 4ms Mar 26 08:27:05 volumio volumio[1019]: info: sendMpdCommand status took 3 milliseconds Mar 26 08:27:05 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:05 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:05 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 26 08:27:05 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:05 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:27:05 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:27:05 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:06 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2278,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 08:27:06 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:27:06 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:27:06 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Mar 26 08:27:06 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 08:27:06 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:06 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:06 volumio volumio[1019]: info: ------------------------------ 28ms Mar 26 08:27:06 volumio volumio[1019]: info: Mar 26 08:27:06 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:06 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:06 volumio volumio[1019]: info: Mar 26 08:27:06 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:06 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:06 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:06 volumio volumio[1019]: info: ------------------------------ 3ms Mar 26 08:27:06 volumio volumio[1019]: info: sendMpdCommand status took 2 milliseconds Mar 26 08:27:06 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:06 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:06 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 26 08:27:06 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:06 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:27:06 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:06 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ROCK ANTENNE - Der beste Rock nonstop!","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 26 08:27:06 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:27:06 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:27:06 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Mar 26 08:27:06 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 08:27:06 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:06 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:06 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:06 volumio volumio[1019]: info: ------------------------------ 27ms Mar 26 08:27:21 volumio volumio[1019]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::ClearQueue Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::stop Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 08:27:21 volumio volumio[1019]: verbose: UNSET VOLATILE Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::stPlaybackTimer Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock Mar 26 08:27:21 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:21 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:21 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:21 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::serviceStop Mar 26 08:27:21 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:21 volumio volumio[1019]: info: CoreCommandRouter::serviceStop Mar 26 08:27:21 volumio volumio[1019]: info: [1774513641078] ControllerWebradio::stop Mar 26 08:27:21 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 08:27:21 volumio volumio[1019]: info: CorePlayQueue::clearPlayQueue Mar 26 08:27:21 volumio volumio[1019]: info: CorePlayQueue::saveQueue Mar 26 08:27:21 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:21 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:21 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::addQueueItems Mar 26 08:27:21 volumio volumio[1019]: info: CorePlayQueue::addQueueItems Mar 26 08:27:21 volumio volumio[1019]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Mar 26 08:27:21 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 26 08:27:21 volumio volumio[1019]: info: CorePlayQueue::saveQueue Mar 26 08:27:21 volumio volumio[1019]: info: CoreCommandRouter::volumioPushQueue Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::updateTrackBlock Mar 26 08:27:21 volumio volumio[1019]: info: CorePlayQueue::getTrackBlock Mar 26 08:27:21 volumio volumio[1019]: info: CoreCommandRouter::volumioPlay Mar 26 08:27:21 volumio volumio[1019]: verbose: UNSET VOLATILE Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::play index 0 Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::stop Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 08:27:21 volumio volumio[1019]: verbose: UNSET VOLATILE Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::play index undefined Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 08:27:21 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::startPlaybackTimer Mar 26 08:27:21 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:21 volumio volumio[1019]: info: [1774513641110] ControllerWebradio::clearAddPlayTrack Mar 26 08:27:21 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 08:27:21 volumio volumio[1019]: info: touch_display: Setting screensaver timeout to 120 seconds. Mar 26 08:27:21 volumio volumio[1019]: info: Mar 26 08:27:21 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:21 volumio volumio[1019]: info: sendMpdCommand stop took 110 milliseconds Mar 26 08:27:21 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:21 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:21 volumio volumio[1019]: info: sendMpdCommand stop took 79 milliseconds Mar 26 08:27:21 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand clear Mar 26 08:27:21 volumio volumio[1019]: info: Mar 26 08:27:21 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:21 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:21 volumio volumio[1019]: info: sendMpdCommand status took 4 milliseconds Mar 26 08:27:21 volumio volumio[1019]: info: sendMpdCommand clear took 3 milliseconds Mar 26 08:27:21 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:21 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:21 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Mar 26 08:27:21 volumio volumio[1019]: error: updateQueue error: null Mar 26 08:27:21 volumio volumio[1019]: info: ------------------------------ 7ms Mar 26 08:27:21 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 26 08:27:21 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:21 volumio volumio[1019]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 26 08:27:21 volumio volumio[1019]: info: ------------------------------ 14ms Mar 26 08:27:21 volumio volumio[1019]: info: Mar 26 08:27:21 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:21 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:21 volumio volumio[1019]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 162 milliseconds Mar 26 08:27:21 volumio volumio[1019]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 26 08:27:21 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand play Mar 26 08:27:21 volumio volumio[1019]: info: ------------------------------ 3ms Mar 26 08:27:21 volumio volumio[1019]: info: sendMpdCommand play took 1 milliseconds Mar 26 08:27:22 volumio volumio[1019]: info: Mar 26 08:27:22 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:22 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:22 volumio volumio[1019]: info: sendMpdCommand status took 2 milliseconds Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:22 volumio volumio[1019]: info: Mar 26 08:27:22 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:22 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:22 volumio volumio[1019]: info: Mar 26 08:27:22 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:22 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:22 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:22 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:27:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:22 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"dance.mp3","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 08:27:22 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus stop Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:22 volumio volumio[1019]: info: ------------------------------ 23ms Mar 26 08:27:22 volumio volumio[1019]: info: ------------------------------ 20ms Mar 26 08:27:22 volumio volumio[1019]: info: sendMpdCommand status took 19 milliseconds Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:22 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:22 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:27:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:22 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"dance.mp3","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 08:27:22 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Mar 26 08:27:22 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:22 volumio volumio[1019]: info: ------------------------------ 53ms Mar 26 08:27:22 volumio volumio[1019]: info: Mar 26 08:27:22 volumio volumio[1019]: ---------------------------- MPD announces system playlist update Mar 26 08:27:22 volumio volumio[1019]: info: Ignoring MPD Status Update Mar 26 08:27:22 volumio volumio[1019]: info: Mar 26 08:27:22 volumio volumio[1019]: ---------------------------- MPD announces state update: player Mar 26 08:27:22 volumio volumio[1019]: info: ControllerMpd::getState Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand status Mar 26 08:27:22 volumio volumio[1019]: info: ------------------------------ 15ms Mar 26 08:27:22 volumio volumio[1019]: info: sendMpdCommand status took 13 milliseconds Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::parseState Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 08:27:22 volumio volumio[1019]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 26 08:27:22 volumio volumio[1019]: verbose: ControllerMpd::parseTrackInfo Mar 26 08:27:22 volumio volumio[1019]: info: ControllerMpd::pushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::servicePushState Mar 26 08:27:22 volumio volumio[1019]: info: CorePlayQueue::getTrack 0 Mar 26 08:27:22 volumio volumio[1019]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 26 08:27:22 volumio volumio[1019]: verbose: CURRENT POSITION 0 Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::syncState stateService play Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::syncState currentStatus play Mar 26 08:27:22 volumio volumio[1019]: info: Received an update from plugin. extracting info from payload Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:22 volumio volumio[1019]: info: CoreStateMachine::pushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::volumioPushState Mar 26 08:27:22 volumio volumio[1019]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 08:27:22 volumio volumio[1019]: info: ------------------------------ 39ms Mar 26 08:27:24 volumio volumio[1019]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 08:27:24 volumio volumio[1019]: TypeError: Cannot read property 'slice' of null Mar 26 08:27:24 volumio volumio[1019]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:714:41) Mar 26 08:27:24 volumio volumio[1019]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:724:7) Mar 26 08:27:24 volumio volumio[1019]: at Object.onceWrapper (events.js:315:30) Mar 26 08:27:24 volumio volumio[1019]: at emitOne (events.js:116:13) Mar 26 08:27:24 volumio volumio[1019]: at ClientRequest.emit (events.js:211:7) Mar 26 08:27:24 volumio volumio[1019]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:551:21) Mar 26 08:27:24 volumio volumio[1019]: at HTTPParser.parserOnHeadersComplete (_http_common.js:115:23) Mar 26 08:27:24 volumio volumio[1019]: at TLSSocket.socketOnData (_http_client.js:440:20) Mar 26 08:27:24 volumio volumio[1019]: at emitOne (events.js:116:13) Mar 26 08:27:24 volumio volumio[1019]: at TLSSocket.emit (events.js:211:7) Mar 26 08:27:24 volumio volumio[1019]: at addChunk (_stream_readable.js:263:12) Mar 26 08:27:24 volumio volumio[1019]: at readableAddChunk (_stream_readable.js:250:11) Mar 26 08:27:24 volumio volumio[1019]: at TLSSocket.Readable.push (_stream_readable.js:208:10) Mar 26 08:27:24 volumio volumio[1019]: at TLSWrap.onread (net.js:607:20) Mar 26 08:27:24 volumio volumio[1019]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 08:27:25 volumio sudo[5366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-26 08:26 Mar 26 08:27:25 volumio sudo[5366]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"