-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Wed 2025-11-05 10:21:48 CST. -- Nov 05 10:20:04 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:20:13 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:20:21 volumio-rpi volumio[1128]: info: Clearing queue after UPNP request Nov 05 10:20:21 volumio-rpi volumio[1128]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 05 10:20:21 volumio-rpi volumio[1128]: info: Retrying Login Due to Network Error Nov 05 10:20:21 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::ClearQueue Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::stop Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::stPlaybackTimer Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::updateTrackBlock Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrackBlock Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::serviceStop Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:21 volumio-rpi volumio[1128]: info: ControllerMpd::stop Nov 05 10:20:21 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand stop Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CorePlayQueue::clearPlayQueue Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CorePlayQueue::saveQueue Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushQueue Nov 05 10:20:21 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:21 volumio-rpi volumio[1128]: info: Nov 05 10:20:21 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:21 volumio-rpi volumio[1128]: info: sendMpdCommand stop took 77 milliseconds Nov 05 10:20:21 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:21 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:21 volumio-rpi volumio[1128]: info: Nov 05 10:20:21 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:21 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:21 volumio-rpi volumio[1128]: info: sendMpdCommand status took 20 milliseconds Nov 05 10:20:21 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:21 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 05 10:20:21 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService stop Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: No code Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:21 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:21 volumio-rpi volumio[1128]: info: ------------------------------ 43ms Nov 05 10:20:21 volumio-rpi volumio[1128]: error: updateQueue error: null Nov 05 10:20:21 volumio-rpi volumio[1128]: info: ------------------------------ 27ms Nov 05 10:20:22 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:22 volumio-rpi volumio[1128]: info: touch_display: Setting screensaver timeout to 60 seconds. Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Starting UPNP Playback Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Preparing playback through UPNP Nov 05 10:20:22 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioGetState Nov 05 10:20:22 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:22 volumio-rpi volumio[1128]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Nov 05 10:20:22 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Nov 05 10:20:22 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: ------------------------------ 3ms Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Nov 05 10:20:22 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: ------------------------------ 3ms Nov 05 10:20:22 volumio-rpi volumio[1128]: info: ------------------------------ 2ms Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Nov 05 10:20:22 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Nov 05 10:20:22 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: ------------------------------ 2ms Nov 05 10:20:22 volumio-rpi volumio[1128]: info: ------------------------------ 2ms Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Nov 05 10:20:22 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:22 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:23 volumio-rpi volumio[1128]: info: Nov 05 10:20:23 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:23 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:23 volumio-rpi volumio[1128]: info: sendMpdCommand status took 44 milliseconds Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 10:20:23 volumio-rpi volumio[1128]: info: Nov 05 10:20:23 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:23 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:23 volumio-rpi volumio[1128]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseTrackInfo Nov 05 10:20:23 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: In UPNP mode Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"95 Kbps","isStreaming":false,"title":"加州旅馆 (Live)","artist":"Eagles (Performer)","album":null,"uri":"http://lu.sycdn.kuwo.cn/00f8829600f7ac468584d02ccc95eb49/690ab465/resource/a1/75/85/1838883258.aac","trackType":"aac"} Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService play Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Nov 05 10:20:23 volumio-rpi volumio[1128]: info: ------------------------------ 53ms Nov 05 10:20:23 volumio-rpi volumio[1128]: info: sendMpdCommand status took 6 milliseconds Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 10:20:23 volumio-rpi volumio[1128]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseTrackInfo Nov 05 10:20:23 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: In UPNP mode Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":262,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"95 Kbps","isStreaming":false,"title":"加州旅馆 (Live)","artist":"Eagles (Performer)","album":null,"uri":"http://lu.sycdn.kuwo.cn/00f8829600f7ac468584d02ccc95eb49/690ab465/resource/a1/75/85/1838883258.aac","trackType":"aac"} Nov 05 10:20:23 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService play Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus play Nov 05 10:20:23 volumio-rpi volumio[1128]: info: Received an update from plugin. extracting info from payload Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:23 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:23 volumio-rpi volumio[1128]: info: ------------------------------ 48ms Nov 05 10:20:23 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:23 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:23 volumio-rpi volumio[1128]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 05 10:20:29 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:20:31 volumio-rpi volumio[1128]: info: MyVolumio login type: Token Nov 05 10:20:34 volumio-rpi volumio[1128]: info: Clearing queue after UPNP request Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::ClearQueue Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::stop Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::stPlaybackTimer Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::updateTrackBlock Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrackBlock Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::serviceStop Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:34 volumio-rpi volumio[1128]: info: ControllerMpd::stop Nov 05 10:20:34 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand stop Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CorePlayQueue::clearPlayQueue Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CorePlayQueue::saveQueue Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushQueue Nov 05 10:20:34 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:34 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:34 volumio-rpi volumio[1128]: info: Nov 05 10:20:34 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:34 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:34 volumio-rpi volumio[1128]: info: Nov 05 10:20:34 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:34 volumio-rpi volumio[1128]: info: sendMpdCommand stop took 97 milliseconds Nov 05 10:20:34 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:34 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:34 volumio-rpi volumio[1128]: error: updateQueue error: null Nov 05 10:20:34 volumio-rpi volumio[1128]: info: ------------------------------ 4ms Nov 05 10:20:34 volumio-rpi volumio[1128]: info: sendMpdCommand status took 2 milliseconds Nov 05 10:20:34 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:34 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 05 10:20:34 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService stop Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: No code Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: ------------------------------ 41ms Nov 05 10:20:34 volumio-rpi volumio[1128]: info: touch_display: Setting screensaver timeout to 60 seconds. Nov 05 10:20:34 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:34 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:34 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:34 volumio-rpi volumio[1128]: info: Starting UPNP Playback Nov 05 10:20:34 volumio-rpi volumio[1128]: info: Preparing playback through UPNP Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioGetState Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:34 volumio-rpi volumio[1128]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Nov 05 10:20:35 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Nov 05 10:20:35 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ------------------------------ 3ms Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Nov 05 10:20:35 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ------------------------------ 2ms Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Nov 05 10:20:35 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Nov 05 10:20:35 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Nov 05 10:20:35 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ------------------------------ 2ms Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ------------------------------ 2ms Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Nov 05 10:20:35 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:35 volumio-rpi volumio[1128]: info: sendMpdCommand status took 78 milliseconds Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Nov 05 10:20:35 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:35 volumio-rpi volumio[1128]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseTrackInfo Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: In UPNP mode Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"119 Kbps","isStreaming":false,"title":"加州旅馆 (Live)","artist":"Eagles (Performer)","album":null,"uri":"http://lu.sycdn.kuwo.cn/5bfbd1a06dd2f80f2984b5ddf055ce82/690ab472/resource/a1/27/8/3505812804.aac","trackType":"aac"} Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService play Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ------------------------------ 91ms Nov 05 10:20:35 volumio-rpi volumio[1128]: info: sendMpdCommand status took 7 milliseconds Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 10:20:35 volumio-rpi volumio[1128]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseTrackInfo Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: In UPNP mode Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":114,"duration":350,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"119 Kbps","isStreaming":false,"title":"加州旅馆 (Live)","artist":"Eagles (Performer)","album":null,"uri":"http://lu.sycdn.kuwo.cn/5bfbd1a06dd2f80f2984b5ddf055ce82/690ab472/resource/a1/27/8/3505812804.aac","trackType":"aac"} Nov 05 10:20:35 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService play Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus play Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Received an update from plugin. extracting info from payload Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:35 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:35 volumio-rpi volumio[1128]: info: ------------------------------ 54ms Nov 05 10:20:35 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:35 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:35 volumio-rpi volumio[1128]: info: Clearing queue after UPNP request Nov 05 10:20:35 volumio-rpi volumio[1128]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::ClearQueue Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::stop Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::stPlaybackTimer Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::updateTrackBlock Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrackBlock Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::serviceStop Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ControllerMpd::stop Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand stop Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CorePlayQueue::clearPlayQueue Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CorePlayQueue::saveQueue Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushQueue Nov 05 10:20:36 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:36 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Nov 05 10:20:36 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Nov 05 10:20:36 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:36 volumio-rpi volumio[1128]: info: sendMpdCommand stop took 88 milliseconds Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:36 volumio-rpi volumio[1128]: error: updateQueue error: null Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ------------------------------ 15ms Nov 05 10:20:36 volumio-rpi volumio[1128]: info: sendMpdCommand status took 14 milliseconds Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService stop Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: No code Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ------------------------------ 48ms Nov 05 10:20:36 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:36 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:36 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: touch_display: Setting screensaver timeout to 60 seconds. Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Starting UPNP Playback Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Preparing playback through UPNP Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioGetState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Nov 05 10:20:36 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Nov 05 10:20:36 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ------------------------------ 3ms Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Nov 05 10:20:36 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Nov 05 10:20:36 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ------------------------------ 2ms Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Nov 05 10:20:36 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ------------------------------ 2ms Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Nov 05 10:20:36 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ------------------------------ 2ms Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Nov 05 10:20:36 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Nov 05 10:20:36 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:36 volumio-rpi volumio[1128]: info: sendMpdCommand status took 45 milliseconds Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 10:20:36 volumio-rpi volumio[1128]: info: sendMpdCommand status took 6 milliseconds Nov 05 10:20:36 volumio-rpi volumio[1128]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseTrackInfo Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: In UPNP mode Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"95 Kbps","isStreaming":false,"title":"加州旅馆 (Live)","artist":"Eagles (Performer)","album":null,"uri":"http://lu.sycdn.kuwo.cn/00f8829600f7ac468584d02ccc95eb49/690ab465/resource/a1/75/85/1838883258.aac","trackType":"aac"} Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService play Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ------------------------------ 61ms Nov 05 10:20:36 volumio-rpi volumio[1128]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseTrackInfo Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: In UPNP mode Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":262,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"95 Kbps","isStreaming":false,"title":"加州旅馆 (Live)","artist":"Eagles (Performer)","album":null,"uri":"http://lu.sycdn.kuwo.cn/00f8829600f7ac468584d02ccc95eb49/690ab465/resource/a1/75/85/1838883258.aac","trackType":"aac"} Nov 05 10:20:36 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService play Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus play Nov 05 10:20:36 volumio-rpi volumio[1128]: info: Received an update from plugin. extracting info from payload Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:36 volumio-rpi volumio[1128]: info: ------------------------------ 59ms Nov 05 10:20:37 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:37 volumio-rpi volumio[1128]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 05 10:20:37 volumio-rpi volumio[1128]: info: Clearing queue after UPNP request Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreStateMachine::ClearQueue Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreStateMachine::stop Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreStateMachine::stPlaybackTimer Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreStateMachine::updateTrackBlock Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrackBlock Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreStateMachine::serviceStop Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:37 volumio-rpi volumio[1128]: info: ControllerMpd::stop Nov 05 10:20:37 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand stop Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CorePlayQueue::clearPlayQueue Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CorePlayQueue::saveQueue Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:37 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushQueue Nov 05 10:20:38 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:38 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Nov 05 10:20:38 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:38 volumio-rpi volumio[1128]: info: sendMpdCommand stop took 71 milliseconds Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Nov 05 10:20:38 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: sendMpdCommand status took 9 milliseconds Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService stop Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: No code Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ------------------------------ 40ms Nov 05 10:20:38 volumio-rpi volumio[1128]: error: updateQueue error: null Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ------------------------------ 34ms Nov 05 10:20:38 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:38 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:38 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:38 volumio-rpi volumio[1128]: info: touch_display: Setting screensaver timeout to 60 seconds. Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Starting UPNP Playback Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Preparing playback through UPNP Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioGetState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 05 10:20:38 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Nov 05 10:20:38 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Nov 05 10:20:38 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ------------------------------ 3ms Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Nov 05 10:20:38 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Nov 05 10:20:38 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Nov 05 10:20:38 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Nov 05 10:20:38 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Nov 05 10:20:38 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Nov 05 10:20:38 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:38 volumio-rpi volumio[1128]: info: sendMpdCommand status took 43 milliseconds Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 10:20:38 volumio-rpi volumio[1128]: info: sendMpdCommand status took 3 milliseconds Nov 05 10:20:38 volumio-rpi volumio[1128]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseTrackInfo Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: In UPNP mode Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":350,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"119 Kbps","isStreaming":false,"title":"加州旅馆 (Live)","artist":"Eagles (Performer)","album":null,"uri":"http://lu.sycdn.kuwo.cn/5bfbd1a06dd2f80f2984b5ddf055ce82/690ab472/resource/a1/27/8/3505812804.aac","trackType":"aac"} Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService play Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ------------------------------ 55ms Nov 05 10:20:38 volumio-rpi volumio[1128]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseTrackInfo Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: In UPNP mode Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":350,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"119 Kbps","isStreaming":false,"title":"加州旅馆 (Live)","artist":"Eagles (Performer)","album":null,"uri":"http://lu.sycdn.kuwo.cn/5bfbd1a06dd2f80f2984b5ddf055ce82/690ab472/resource/a1/27/8/3505812804.aac","trackType":"aac"} Nov 05 10:20:38 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService play Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus play Nov 05 10:20:38 volumio-rpi volumio[1128]: info: Received an update from plugin. extracting info from payload Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:38 volumio-rpi volumio[1128]: info: ------------------------------ 45ms Nov 05 10:20:38 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:38 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:39 volumio-rpi volumio[1128]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 05 10:20:43 volumio-rpi volumio[1128]: info: Clearing queue after UPNP request Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::ClearQueue Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::stop Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::stPlaybackTimer Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::updateTrackBlock Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrackBlock Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::serviceStop Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:43 volumio-rpi volumio[1128]: info: ControllerMpd::stop Nov 05 10:20:43 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand stop Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CorePlayQueue::clearPlayQueue Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CorePlayQueue::saveQueue Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushQueue Nov 05 10:20:43 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:43 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:43 volumio-rpi volumio[1128]: info: Nov 05 10:20:43 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:43 volumio-rpi volumio[1128]: info: sendMpdCommand stop took 84 milliseconds Nov 05 10:20:43 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:43 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:43 volumio-rpi volumio[1128]: info: Nov 05 10:20:43 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:43 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:43 volumio-rpi volumio[1128]: info: sendMpdCommand status took 12 milliseconds Nov 05 10:20:43 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:43 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 05 10:20:43 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService stop Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: No code Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: ------------------------------ 41ms Nov 05 10:20:43 volumio-rpi volumio[1128]: info: touch_display: Setting screensaver timeout to 60 seconds. Nov 05 10:20:43 volumio-rpi volumio[1128]: error: updateQueue error: null Nov 05 10:20:43 volumio-rpi volumio[1128]: info: ------------------------------ 36ms Nov 05 10:20:43 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:43 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:43 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:43 volumio-rpi volumio[1128]: info: Starting UPNP Playback Nov 05 10:20:43 volumio-rpi volumio[1128]: info: Preparing playback through UPNP Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioGetState Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CorePlayQueue::getTrack 0 Nov 05 10:20:43 volumio-rpi volumio[1128]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Nov 05 10:20:44 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Nov 05 10:20:44 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ------------------------------ 3ms Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ------------------------------ 2ms Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Nov 05 10:20:44 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ------------------------------ 3ms Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Nov 05 10:20:44 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Nov 05 10:20:44 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ------------------------------ 1ms Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Nov 05 10:20:44 volumio-rpi volumio[1128]: ---------------------------- MPD announces system playlist update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Ignoring MPD Status Update Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ------------------------------ 3ms Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Nov 05 10:20:44 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Nov 05 10:20:44 volumio-rpi volumio[1128]: ---------------------------- MPD announces state update: player Nov 05 10:20:44 volumio-rpi volumio[1128]: info: sendMpdCommand status took 51 milliseconds Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ControllerMpd::getState Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand status Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 10:20:44 volumio-rpi volumio[1128]: info: sendMpdCommand status took 5 milliseconds Nov 05 10:20:44 volumio-rpi volumio[1128]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseState Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseTrackInfo Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: In UPNP mode Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"95 Kbps","isStreaming":false,"title":"加州旅馆 (Live)","artist":"Eagles (Performer)","album":null,"uri":"http://lu.sycdn.kuwo.cn/00f8829600f7ac468584d02ccc95eb49/690ab465/resource/a1/75/85/1838883258.aac","trackType":"aac"} Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService play Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus stop Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ------------------------------ 67ms Nov 05 10:20:44 volumio-rpi volumio[1128]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: ControllerMpd::parseTrackInfo Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ControllerMpd::pushState Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreCommandRouter::servicePushState Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: In UPNP mode Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":262,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"95 Kbps","isStreaming":false,"title":"加州旅馆 (Live)","artist":"Eagles (Performer)","album":null,"uri":"http://lu.sycdn.kuwo.cn/00f8829600f7ac468584d02ccc95eb49/690ab465/resource/a1/75/85/1838883258.aac","trackType":"aac"} Nov 05 10:20:44 volumio-rpi volumio[1128]: verbose: CURRENT POSITION 0 Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState stateService play Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreStateMachine::syncState currentStatus play Nov 05 10:20:44 volumio-rpi volumio[1128]: info: Received an update from plugin. extracting info from payload Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreStateMachine::pushState Nov 05 10:20:44 volumio-rpi volumio[1128]: info: CoreCommandRouter::volumioPushState Nov 05 10:20:44 volumio-rpi volumio[1128]: info: ------------------------------ 45ms Nov 05 10:20:44 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:44 volumio-rpi volumio[1128]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Nov 05 10:20:44 volumio-rpi volumio[1128]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 05 10:20:46 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:20:55 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:21:01 volumio-rpi volumio[1128]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 05 10:21:01 volumio-rpi volumio[1128]: info: Retrying Login Due to Network Error Nov 05 10:21:03 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:21:11 volumio-rpi volumio[1128]: info: MyVolumio login type: Token Nov 05 10:21:12 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:21:20 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:21:29 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:21:37 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:21:41 volumio-rpi volumio[1128]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 05 10:21:41 volumio-rpi volumio[1128]: info: Retrying Login Due to Network Error Nov 05 10:21:45 volumio-rpi wpa_supplicant[909]: wlan0: Failed to initiate sched scan Nov 05 10:21:46 volumio-rpi volumio[1128]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 10:21:46 volumio-rpi volumio[1128]: Error: connect ETIMEDOUT 159.106.121.75:443 Nov 05 10:21:46 volumio-rpi volumio[1128]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Nov 05 10:21:46 volumio-rpi volumio[1128]: errno: -110, Nov 05 10:21:46 volumio-rpi volumio[1128]: code: 'ETIMEDOUT', Nov 05 10:21:46 volumio-rpi volumio[1128]: syscall: 'connect', Nov 05 10:21:46 volumio-rpi volumio[1128]: address: '159.106.121.75', Nov 05 10:21:46 volumio-rpi volumio[1128]: port: 443 Nov 05 10:21:46 volumio-rpi volumio[1128]: } Nov 05 10:21:46 volumio-rpi volumio[1128]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 05 10:21:48 volumio-rpi sudo[21318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-05 10:20 Nov 05 10:21:48 volumio-rpi sudo[21318]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"