-- Logs begin at Wed 2024-11-20 13:46:45 CET, end at Wed 2024-11-20 19:15:55 CET. -- Nov 20 19:14:03 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:14:11 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:14:18 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:14:26 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:14:30 volumio-vd volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 20 19:14:30 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 20 19:14:30 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Nov 20 19:14:30 volumio-vd sudo[2985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Nov 20 19:14:30 volumio-vd sudo[2985]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 19:14:30 volumio-vd sudo[2985]: pam_unix(sudo:session): session closed for user root Nov 20 19:14:30 volumio-vd sudo[2992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 20 19:14:30 volumio-vd sudo[2992]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 19:14:30 volumio-vd sudo[2992]: pam_unix(sudo:session): session closed for user root Nov 20 19:14:30 volumio-vd sudo[2999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 20 19:14:30 volumio-vd sudo[2999]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 19:14:30 volumio-vd sudo[2999]: pam_unix(sudo:session): session closed for user root Nov 20 19:14:30 volumio-vd sudo[3005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 20 19:14:30 volumio-vd sudo[3005]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 19:14:30 volumio-vd sudo[3005]: pam_unix(sudo:session): session closed for user root Nov 20 19:14:30 volumio-vd sudo[3011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 20 19:14:30 volumio-vd sudo[3011]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 19:14:30 volumio-vd sudo[3011]: pam_unix(sudo:session): session closed for user root Nov 20 19:14:30 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 20 19:14:30 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 20 19:14:30 volumio-vd sudo[3014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 20 19:14:30 volumio-vd sudo[3014]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 19:14:30 volumio-vd sudo[3014]: pam_unix(sudo:session): session closed for user root Nov 20 19:14:30 volumio-vd sudo[3017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 20 19:14:30 volumio-vd sudo[3017]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 20 19:14:35 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:14:35 volumio-vd sudo[3017]: pam_unix(sudo:session): session closed for user root Nov 20 19:14:43 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:14:50 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioGetQueue Nov 20 19:14:50 volumio-vd volumio[1038]: info: CoreStateMachine::getQueue Nov 20 19:14:50 volumio-vd volumio[1038]: info: CorePlayQueue::getQueue Nov 20 19:14:51 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:14:58 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:15:06 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:15:08 volumio-vd volumio[1038]: info: Nov 20 19:15:08 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:08 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:08 volumio-vd volumio[1038]: info: Nov 20 19:15:08 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:08 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:08 volumio-vd volumio[1038]: info: Nov 20 19:15:08 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:08 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:08 volumio-vd volumio[1038]: info: Nov 20 19:15:08 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:08 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:08 volumio-vd volumio[1038]: info: Nov 20 19:15:08 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:08 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:08 volumio-vd volumio[1038]: info: ------------------------------ 5ms Nov 20 19:15:08 volumio-vd volumio[1038]: info: ------------------------------ 4ms Nov 20 19:15:08 volumio-vd volumio[1038]: info: ------------------------------ 4ms Nov 20 19:15:08 volumio-vd volumio[1038]: info: ------------------------------ 3ms Nov 20 19:15:08 volumio-vd volumio[1038]: info: Nov 20 19:15:08 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:08 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:08 volumio-vd volumio[1038]: info: Nov 20 19:15:08 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:08 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:08 volumio-vd volumio[1038]: info: Nov 20 19:15:08 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:08 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:08 volumio-vd volumio[1038]: info: sendMpdCommand status took 5 milliseconds Nov 20 19:15:08 volumio-vd volumio[1038]: info: sendMpdCommand status took 4 milliseconds Nov 20 19:15:08 volumio-vd volumio[1038]: info: sendMpdCommand status took 3 milliseconds Nov 20 19:15:08 volumio-vd volumio[1038]: info: sendMpdCommand status took 2 milliseconds Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:08 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 20 19:15:08 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 20 19:15:08 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 20 19:15:08 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:08 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 0 Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":326272,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Jade Imagine - Remote Control","artist":"60 North Radio","album":null,"uri":"https://cdn1.zetcast.net/stream","trackType":"net/stream"} Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: CURRENT POSITION 0 Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:08 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 0 Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":326272,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Jade Imagine - Remote Control","artist":"60 North Radio","album":null,"uri":"https://cdn1.zetcast.net/stream","trackType":"net/stream"} Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: CURRENT POSITION 0 Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:08 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 0 Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":326272,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Jade Imagine - Remote Control","artist":"60 North Radio","album":null,"uri":"https://cdn1.zetcast.net/stream","trackType":"net/stream"} Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: CURRENT POSITION 0 Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:08 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 0 Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":326272,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Jade Imagine - Remote Control","artist":"60 North Radio","album":null,"uri":"https://cdn1.zetcast.net/stream","trackType":"net/stream"} Nov 20 19:15:08 volumio-vd volumio[1038]: verbose: CURRENT POSITION 0 Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:08 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:08 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:09 volumio-vd volumio[1038]: info: ------------------------------ 98ms Nov 20 19:15:09 volumio-vd volumio[1038]: info: ------------------------------ 97ms Nov 20 19:15:09 volumio-vd volumio[1038]: info: ------------------------------ 96ms Nov 20 19:15:09 volumio-vd volumio[1038]: info: ------------------------------ 95ms Nov 20 19:15:09 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:09 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:09 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:09 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:09 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:09 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:09 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:09 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:09 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:09 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:09 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:09 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:09 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:09 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:09 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:09 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:13 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPlay Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::play index 94 Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::stop Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::stPlaybackTimer Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::updateTrackBlock Nov 20 19:15:19 volumio-vd volumio[1038]: info: CorePlayQueue::getTrackBlock Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:19 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 0 Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::serviceStop Nov 20 19:15:19 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 0 Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreCommandRouter::serviceStop Nov 20 19:15:19 volumio-vd volumio[1038]: info: [1732126519770] ControllerWebradio::stop Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand stop Nov 20 19:15:19 volumio-vd volumio[1038]: info: [ASDebug] CurState: stop PrevState: play Nov 20 19:15:19 volumio-vd volumio[1038]: info: [ASDebug] InitTimeout - Amp off in: 4800 ms Nov 20 19:15:19 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:19 volumio-vd volumio[1038]: info: Nov 20 19:15:19 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand stop took 47 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::play index undefined Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 20 19:15:19 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::startPlaybackTimer Nov 20 19:15:19 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:19 volumio-vd volumio[1038]: info: [1732126519819] ControllerWebradio::clearAddPlayTrack Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand stop Nov 20 19:15:19 volumio-vd volumio[1038]: info: Nov 20 19:15:19 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:19 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:19 volumio-vd volumio[1038]: info: Nov 20 19:15:19 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:19 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:19 volumio-vd volumio[1038]: info: Nov 20 19:15:19 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:19 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand status took 9 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand stop took 8 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand status took 6 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand status took 4 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand status took 3 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand clear Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:19 volumio-vd volumio[1038]: info: Nov 20 19:15:19 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:19 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand clear took 6 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand load "http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3" Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:19 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:19 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:19 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 19:15:19 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:19 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:19 volumio-vd volumio[1038]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 20 19:15:19 volumio-vd volumio[1038]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 20 19:15:19 volumio-vd volumio[1038]: info: ------------------------------ 46ms Nov 20 19:15:19 volumio-vd volumio[1038]: info: ------------------------------ 41ms Nov 20 19:15:19 volumio-vd volumio[1038]: info: ------------------------------ 39ms Nov 20 19:15:19 volumio-vd volumio[1038]: info: ------------------------------ 38ms Nov 20 19:15:19 volumio-vd volumio[1038]: info: Nov 20 19:15:19 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:19 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:19 volumio-vd volumio[1038]: info: Nov 20 19:15:19 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:19 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:19 volumio-vd volumio[1038]: info: Nov 20 19:15:19 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:19 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:19 volumio-vd volumio[1038]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 20 19:15:19 volumio-vd volumio[1038]: error: updateQueue error: null Nov 20 19:15:19 volumio-vd volumio[1038]: info: ------------------------------ 41ms Nov 20 19:15:19 volumio-vd volumio[1038]: info: [ASDebug] CurState: stop PrevState: play Nov 20 19:15:19 volumio-vd volumio[1038]: info: [ASDebug] InitTimeout - Amp off in: 4800 ms Nov 20 19:15:19 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:20 volumio-vd volumio[1038]: info: camilladsp spawned new process with pid 3168, instance 1, run: true Nov 20 19:15:20 volumio-vd kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Nov 20 19:15:21 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:15:23 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand add "http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3" Nov 20 19:15:23 volumio-vd volumio[1038]: error: updateQueue error: null Nov 20 19:15:23 volumio-vd volumio[1038]: error: updateQueue error: null Nov 20 19:15:23 volumio-vd volumio[1038]: error: updateQueue error: null Nov 20 19:15:23 volumio-vd volumio[1038]: info: ------------------------------ 3820ms Nov 20 19:15:23 volumio-vd volumio[1038]: info: ------------------------------ 3813ms Nov 20 19:15:23 volumio-vd volumio[1038]: info: ------------------------------ 3812ms Nov 20 19:15:23 volumio-vd volumio[1038]: Upnp client error: Error: This socket has been ended by the other party Nov 20 19:15:23 volumio-vd volumio[1038]: info: Nov 20 19:15:23 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:23 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:23 volumio-vd volumio[1038]: info: sendMpdCommand add "http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3" took 3 milliseconds Nov 20 19:15:23 volumio-vd volumio[1038]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 20 19:15:23 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand play Nov 20 19:15:23 volumio-vd volumio[1038]: info: Nov 20 19:15:23 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:23 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:23 volumio-vd volumio[1038]: info: Nov 20 19:15:23 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:23 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:23 volumio-vd volumio[1038]: info: Nov 20 19:15:23 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:23 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:23 volumio-vd volumio[1038]: info: ------------------------------ 3ms Nov 20 19:15:23 volumio-vd volumio[1038]: info: sendMpdCommand play took 4 milliseconds Nov 20 19:15:23 volumio-vd volumio[1038]: info: ------------------------------ 3ms Nov 20 19:15:23 volumio-vd volumio[1038]: info: ------------------------------ 2ms Nov 20 19:15:23 volumio-vd volumio[1038]: info: ------------------------------ 2ms Nov 20 19:15:24 volumio-vd volumio[1038]: info: [ASDebug] Togle GPIO: OFF Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Nov 20 19:15:26 volumio-vd volumio[1038]: info: FusionDsp - ---- read samplerate from file: 48000 Nov 20 19:15:26 volumio-vd volumio[1038]: info: camilladsp stopping service pid 3168... Nov 20 19:15:26 volumio-vd volumio[1038]: info: camilladsp service terminated, instance 1 Nov 20 19:15:26 volumio-vd volumio[1038]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 20 19:15:26 volumio-vd volumio[1038]: info: camilladsp service started and running in background, instance 1 Nov 20 19:15:26 volumio-vd volumio[1038]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Nov 20 19:15:26 volumio-vd volumio[1038]: info: FusionDsp - ---- read samplerate from file: 48000 Nov 20 19:15:26 volumio-vd volumio[1038]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:26 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 53 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 53 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 52 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 51 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 13 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 16ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 13 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 14 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 14 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 14 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 15 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 15 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 13 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 11 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd 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":null,"isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus stop Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd 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":null,"isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd 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":null,"isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd 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":null,"isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 105ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 154ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 157ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 157ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:26 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:26 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:26 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:26 volumio-vd volumio[1038]: info: Nov 20 19:15:26 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:26 volumio-vd volumio[1038]: error: FusionDsp - WebSocket error: [object Object] Nov 20 19:15:26 volumio-vd volumio[1038]: info: camilladsp spawned new process with pid 3189, instance 1, run: true Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 121 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 120 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 118 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 118 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 117 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 40ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 39 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 38ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 37 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 38ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand status took 36 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":860,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":860,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":860,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":860,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":860,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 270ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 270ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 265ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 264ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 262ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: stop Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] Togle GPIO: ON Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 233 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 232 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 232 milliseconds Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":860,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":860,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":860,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"-","artist":"Vinyl STO","album":null,"uri":"http://tx-bauerse.sharp-stream.com/http_live.php?i=vinylfm_instream_se_mp3","trackType":""} Nov 20 19:15:26 volumio-vd volumio[1038]: verbose: CURRENT POSITION 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:26 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 342ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 341ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: ------------------------------ 341ms Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:26 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:27 volumio-vd volumio[1038]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 20 19:15:29 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPlay Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::play index 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::stop Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::stPlaybackTimer Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::updateTrackBlock Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrackBlock Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::serviceStop Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 94 Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::serviceStop Nov 20 19:15:36 volumio-vd volumio[1038]: info: [1732126536037] ControllerWebradio::stop Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand stop Nov 20 19:15:36 volumio-vd volumio[1038]: info: [ASDebug] CurState: stop PrevState: play Nov 20 19:15:36 volumio-vd volumio[1038]: info: [ASDebug] InitTimeout - Amp off in: 4800 ms Nov 20 19:15:36 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:36 volumio-vd volumio[1038]: info: Nov 20 19:15:36 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:36 volumio-vd volumio[1038]: info: sendMpdCommand stop took 15 milliseconds Nov 20 19:15:36 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::play index undefined Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::startPlaybackTimer Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: [1732126536057] ControllerWebradio::clearAddPlayTrack Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand stop Nov 20 19:15:36 volumio-vd volumio[1038]: info: sendMpdCommand status took 4 milliseconds Nov 20 19:15:36 volumio-vd volumio[1038]: info: sendMpdCommand stop took 1 milliseconds Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand clear Nov 20 19:15:36 volumio-vd volumio[1038]: info: Nov 20 19:15:36 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:36 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:36 volumio-vd volumio[1038]: info: Nov 20 19:15:36 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:36 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:36 volumio-vd volumio[1038]: info: Nov 20 19:15:36 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:36 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:36 volumio-vd volumio[1038]: info: Nov 20 19:15:36 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:36 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:36 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 30 milliseconds Nov 20 19:15:36 volumio-vd volumio[1038]: info: sendMpdCommand clear took 30 milliseconds Nov 20 19:15:36 volumio-vd volumio[1038]: info: sendMpdCommand status took 28 milliseconds Nov 20 19:15:36 volumio-vd volumio[1038]: info: sendMpdCommand status took 28 milliseconds Nov 20 19:15:36 volumio-vd volumio[1038]: info: sendMpdCommand status took 30 milliseconds Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand load "https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn" Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:36 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:36 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 20 19:15:36 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 20 19:15:36 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 20 19:15:36 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:36 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:36 volumio-vd volumio[1038]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 20 19:15:36 volumio-vd volumio[1038]: info: ------------------------------ 96ms Nov 20 19:15:36 volumio-vd volumio[1038]: info: ------------------------------ 89ms Nov 20 19:15:36 volumio-vd volumio[1038]: info: ------------------------------ 89ms Nov 20 19:15:36 volumio-vd volumio[1038]: info: ------------------------------ 89ms Nov 20 19:15:36 volumio-vd volumio[1038]: info: Nov 20 19:15:36 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:36 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:36 volumio-vd volumio[1038]: info: Nov 20 19:15:36 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:36 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:36 volumio-vd volumio[1038]: info: Nov 20 19:15:36 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:36 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:36 volumio-vd volumio[1038]: error: updateQueue error: null Nov 20 19:15:36 volumio-vd volumio[1038]: info: ------------------------------ 72ms Nov 20 19:15:36 volumio-vd volumio[1038]: info: [ASDebug] CurState: stop PrevState: play Nov 20 19:15:36 volumio-vd volumio[1038]: info: [ASDebug] InitTimeout - Amp off in: 4800 ms Nov 20 19:15:36 volumio-vd volumio[1038]: info: [ASDebug] CurState: stop PrevState: play Nov 20 19:15:36 volumio-vd volumio[1038]: info: [ASDebug] InitTimeout - Amp off in: 4800 ms Nov 20 19:15:36 volumio-vd volumio[1038]: info: [ASDebug] CurState: stop PrevState: play Nov 20 19:15:36 volumio-vd volumio[1038]: info: [ASDebug] InitTimeout - Amp off in: 4800 ms Nov 20 19:15:36 volumio-vd volumio[1038]: info: [ASDebug] CurState: stop PrevState: play Nov 20 19:15:36 volumio-vd volumio[1038]: info: [ASDebug] InitTimeout - Amp off in: 4800 ms Nov 20 19:15:36 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:36 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:36 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:36 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:36 volumio-vd volumio[1038]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 20 19:15:36 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:15:36 volumio-vd volumio[1038]: info: camilladsp spawned new process with pid 3224, instance 1, run: true Nov 20 19:15:36 volumio-vd kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Nov 20 19:15:39 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand add "https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn" Nov 20 19:15:39 volumio-vd volumio[1038]: error: updateQueue error: null Nov 20 19:15:39 volumio-vd volumio[1038]: error: updateQueue error: null Nov 20 19:15:39 volumio-vd volumio[1038]: error: updateQueue error: null Nov 20 19:15:39 volumio-vd volumio[1038]: info: Nov 20 19:15:39 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:39 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:39 volumio-vd volumio[1038]: info: ------------------------------ 3364ms Nov 20 19:15:39 volumio-vd volumio[1038]: info: ------------------------------ 3362ms Nov 20 19:15:39 volumio-vd volumio[1038]: info: ------------------------------ 3362ms Nov 20 19:15:39 volumio-vd volumio[1038]: info: sendMpdCommand add "https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn" took 3 milliseconds Nov 20 19:15:39 volumio-vd volumio[1038]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 20 19:15:39 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand play Nov 20 19:15:39 volumio-vd volumio[1038]: Upnp client error: Error: This socket has been ended by the other party Nov 20 19:15:39 volumio-vd volumio[1038]: info: Nov 20 19:15:39 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:39 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:39 volumio-vd volumio[1038]: info: Nov 20 19:15:39 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:39 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:39 volumio-vd volumio[1038]: info: Nov 20 19:15:39 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:39 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:39 volumio-vd volumio[1038]: info: ------------------------------ 8ms Nov 20 19:15:39 volumio-vd volumio[1038]: info: sendMpdCommand play took 5 milliseconds Nov 20 19:15:39 volumio-vd volumio[1038]: info: ------------------------------ 4ms Nov 20 19:15:39 volumio-vd volumio[1038]: info: ------------------------------ 4ms Nov 20 19:15:39 volumio-vd volumio[1038]: info: ------------------------------ 3ms Nov 20 19:15:40 volumio-vd volumio[1038]: info: [ASDebug] Togle GPIO: OFF Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:41 volumio-vd volumio[1038]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Nov 20 19:15:41 volumio-vd volumio[1038]: info: FusionDsp - ---- read samplerate from file: 48000 Nov 20 19:15:41 volumio-vd volumio[1038]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:41 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand status took 16 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand status took 17 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand status took 16 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand status took 16 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:41 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:41 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces system playlist update Nov 20 19:15:41 volumio-vd volumio[1038]: info: Ignoring MPD Status Update Nov 20 19:15:41 volumio-vd volumio[1038]: info: Nov 20 19:15:41 volumio-vd volumio[1038]: ---------------------------- MPD announces state update: player Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::getState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand status Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 17ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand status took 14 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 12 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 12 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 10ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand status took 10 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 9ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand status took 7 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 8ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand status took 6 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseState Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd 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":null,"isStreaming":false,"title":"http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","artist":null,"album":null,"uri":"https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","trackType":""} Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: CURRENT POSITION 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus stop Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":136,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","artist":null,"album":null,"uri":"https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","trackType":""} Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: CURRENT POSITION 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:41 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":315,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","artist":null,"album":null,"uri":"https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","trackType":""} Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: CURRENT POSITION 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:41 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":367,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","artist":null,"album":null,"uri":"https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","trackType":""} Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: CURRENT POSITION 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:41 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 65ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 124ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 124ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 124ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 93 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 92 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: info: sendMpdCommand playlistinfo took 91 milliseconds Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: ControllerMpd::parseTrackInfo Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","artist":null,"album":null,"uri":"https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","trackType":""} Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: CURRENT POSITION 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:41 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","artist":null,"album":null,"uri":"https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","trackType":""} Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: CURRENT POSITION 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:41 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","artist":null,"album":null,"uri":"https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","trackType":""} Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: CURRENT POSITION 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:41 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: ControllerMpd::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::servicePushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1354,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","artist":null,"album":null,"uri":"https://tx.planetradio.co.uk/http_live_bauerno.php?i=vinyl_no_mp3&aw_0_1st.playerid=BMUK_TuneIn","trackType":""} Nov 20 19:15:41 volumio-vd volumio[1038]: verbose: CURRENT POSITION 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState stateService play Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::syncState currentStatus play Nov 20 19:15:41 volumio-vd volumio[1038]: info: Received an update from plugin. extracting info from payload Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CorePlayQueue::getTrack 95 Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreStateMachine::pushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: CoreCommandRouter::volumioPushState Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 261ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 254ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 251ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: ------------------------------ 250ms Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: stop Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] Togle GPIO: ON Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: info: [ASDebug] CurState: play PrevState: play Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Nov 20 19:15:41 volumio-vd volumio[1038]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 20 19:15:41 volumio-vd volumio[1038]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 20 19:15:44 volumio-vd wpa_supplicant[883]: wlan0: Failed to initiate sched scan Nov 20 19:15:44 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 20 19:15:44 volumio-vd volumio[1038]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 20 19:15:44 volumio-vd volumio[1038]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 20 19:15:51 volumio-vd volumio[1038]: info: [ASDebug] Port: 24 Nov 20 19:15:51 volumio-vd volumio[1038]: info: [ASDebug] Inverted: false Nov 20 19:15:51 volumio-vd volumio[1038]: info: [ASDebug] Delay: 4800 Nov 20 19:15:51 volumio-vd wpa_supplicant[883]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="wifi0" Nov 20 19:15:51 volumio-vd wpa_supplicant[883]: wlan0: Trying to associate with SSID 'wifi0' Nov 20 19:15:54 volumio-vd wpa_supplicant[883]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Nov 20 19:15:54 volumio-vd wpa_supplicant[883]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="wifi0" auth_failures=7 duration=135 reason=CONN_FAILED Nov 20 19:15:55 volumio-vd volumio[1038]: info: [ASDebug] Port: 24 Nov 20 19:15:55 volumio-vd volumio[1038]: info: [ASDebug] Inverted: false Nov 20 19:15:55 volumio-vd volumio[1038]: info: [ASDebug] Delay: 4800 Nov 20 19:15:55 volumio-vd volumio[1038]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 20 19:15:55 volumio-vd volumio[1038]: Error: EBADF: bad file descriptor, close Nov 20 19:15:55 volumio-vd volumio[1038]: at Object.closeSync (fs.js:439:3) Nov 20 19:15:55 volumio-vd volumio[1038]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20) Nov 20 19:15:55 volumio-vd volumio[1038]: at Object.closeSync (/data/plugins/system_hardware/gpio-buttons/node_modules/graceful-fs/graceful-fs.js:51:27) Nov 20 19:15:55 volumio-vd volumio[1038]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8) Nov 20 19:15:55 volumio-vd volumio[1038]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:234:19) Nov 20 19:15:55 volumio-vd volumio[1038]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:84:10) Nov 20 19:15:55 volumio-vd volumio[1038]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Nov 20 19:15:55 volumio-vd volumio[1038]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Nov 20 19:15:55 volumio-vd volumio[1038]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1537:29) Nov 20 19:15:55 volumio-vd volumio[1038]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1387:47) Nov 20 19:15:55 volumio-vd volumio[1038]: at Socket.emit (events.js:315:20) Nov 20 19:15:55 volumio-vd volumio[1038]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 20 19:15:55 volumio-vd volumio[1038]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Nov 20 19:15:55 volumio-vd volumio[1038]: errno: -9, Nov 20 19:15:55 volumio-vd volumio[1038]: syscall: 'close', Nov 20 19:15:55 volumio-vd volumio[1038]: code: 'EBADF' Nov 20 19:15:55 volumio-vd volumio[1038]: } Nov 20 19:15:55 volumio-vd volumio[1038]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 20 19:15:55 volumio-vd sudo[3287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-20 19:14 Nov 20 19:15:55 volumio-vd sudo[3287]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"