Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioGetQueue Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::getQueue Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CorePlayQueue::getQueue Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: Mar 29 23:58:10 tikpal-volumio volumio[6806]: ---------------------------- Client requests Volumio play at index 0 Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPlay Mar 29 23:58:10 tikpal-volumio volumio[6806]: verbose: UNSET VOLATILE: Service: airplay_emulation Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: Stopping Airplay Playback and sending pause command to client via USR2 Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::play index 0 Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::stop Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::stPlaybackTimer Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::updateTrackBlock Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrackBlock Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::serviceStop Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreCommandRouter::serviceStop Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: [1774799890620] ControllerWebradio::stop Mar 29 23:58:10 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: sendMpdCommand stop took 15 milliseconds Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::play index undefined Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CoreStateMachine::startPlaybackTimer Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: [1774799890638] ControllerWebradio::clearAddPlayTrack Mar 29 23:58:10 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: sendMpdCommand stop took 5 milliseconds Mar 29 23:58:10 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: Mar 29 23:58:10 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: sendMpdCommand clear took 7 milliseconds Mar 29 23:58:10 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: Mar 29 23:58:10 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: Mar 29 23:58:10 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:10 tikpal-volumio volumio[6806]: error: updateQueue error: null Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: ------------------------------ 7ms Mar 29 23:58:10 tikpal-volumio sudo[8450]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 8172 Mar 29 23:58:10 tikpal-volumio sudo[8450]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 29 23:58:10 tikpal-volumio sudo[8450]: pam_unix(sudo:session): session closed for user root Mar 29 23:58:10 tikpal-volumio shairport-sync[8421]: {"time":1774799877299,"response":"airplayActive Success"} Mar 29 23:58:10 tikpal-volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=12/USR2 Mar 29 23:58:10 tikpal-volumio systemd[1]: shairport-sync.service: Failed with result 'signal'. Mar 29 23:58:10 tikpal-volumio systemd[1]: shairport-sync.service: Consumed 6.791s CPU time. Mar 29 23:58:10 tikpal-volumio volumio[6806]: info: Shairport-Sync paused with USR2 Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: Mar 29 23:58:11 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 533 milliseconds Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: ------------------------------ 533ms Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 29 23:58:11 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand play Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: Mar 29 23:58:11 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: ------------------------------ 535ms Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: Mar 29 23:58:11 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: ------------------------------ 8ms Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: sendMpdCommand play took 7 milliseconds Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: ------------------------------ 6ms Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: ------------------------------ 3ms Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: Restarting Shairport-Sync after stop Mar 29 23:58:11 tikpal-volumio sudo[8456]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 29 23:58:11 tikpal-volumio sudo[8456]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 29 23:58:11 tikpal-volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 29 23:58:11 tikpal-volumio sudo[8456]: pam_unix(sudo:session): session closed for user root Mar 29 23:58:11 tikpal-volumio volumio[6806]: info: Shairport-Sync retarted Mar 29 23:58:13 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioGetQueue Mar 29 23:58:13 tikpal-volumio volumio[6806]: info: CoreStateMachine::getQueue Mar 29 23:58:13 tikpal-volumio volumio[6806]: info: CorePlayQueue::getQueue Mar 29 23:58:13 tikpal-volumio volumio[6806]: info: Mar 29 23:58:13 tikpal-volumio volumio[6806]: ---------------------------- Client requests Volumio pause Mar 29 23:58:13 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPause Mar 29 23:58:13 tikpal-volumio volumio[6806]: info: CoreStateMachine::pause Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioGetQueue Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreStateMachine::getQueue Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CorePlayQueue::getQueue Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Mar 29 23:58:14 tikpal-volumio volumio[6806]: ---------------------------- Client requests Volumio play at index 0 Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPlay Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreStateMachine::play index 0 Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreStateMachine::stop Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreStateMachine::play index undefined Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreStateMachine::startPlaybackTimer Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: [1774799894883] ControllerWebradio::clearAddPlayTrack Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Mar 29 23:58:14 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: sendMpdCommand stop took 4 milliseconds Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Mar 29 23:58:14 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Mar 29 23:58:14 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Mar 29 23:58:14 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 5 milliseconds Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: sendMpdCommand clear took 5 milliseconds Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 3 milliseconds Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 3 milliseconds Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: ------------------------------ 38ms Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: ------------------------------ 36ms Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Mar 29 23:58:14 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Mar 29 23:58:14 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:14 tikpal-volumio volumio[6806]: error: updateQueue error: null Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: ------------------------------ 39ms Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 38 milliseconds Mar 29 23:58:14 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:14 tikpal-volumio volumio[6806]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Mar 29 23:58:14 tikpal-volumio volumio[6806]: info: ------------------------------ 46ms Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 231 milliseconds Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 29 23:58:15 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand play Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: Mar 29 23:58:15 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: ------------------------------ 200ms Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: ------------------------------ 199ms Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: Mar 29 23:58:15 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: Mar 29 23:58:15 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: sendMpdCommand play took 8 milliseconds Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: ------------------------------ 8ms Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: ------------------------------ 6ms Mar 29 23:58:15 tikpal-volumio volumio[6806]: info: ------------------------------ 5ms Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Mar 29 23:58:16 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Mar 29 23:58:16 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Mar 29 23:58:16 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Mar 29 23:58:16 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 10 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 9 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 8 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Mar 29 23:58:16 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Mar 29 23:58:16 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 5 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 4 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 2 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus stop Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ------------------------------ 42ms Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ------------------------------ 82ms Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ------------------------------ 81ms Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 67 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 66 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 66 milliseconds Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:16 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ------------------------------ 145ms Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ------------------------------ 142ms Mar 29 23:58:16 tikpal-volumio volumio[6806]: info: ------------------------------ 142ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 15ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Mar 29 23:58:17 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 19 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 18ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 18 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 18ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 7 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 5ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 9 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 8ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 8 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 7ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 5 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":298,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":366,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":710,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 93ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 92ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 91ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 70 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 70 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 71 milliseconds Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":710,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":710,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":710,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:17 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 151ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 150ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: ------------------------------ 149ms Mar 29 23:58:17 tikpal-volumio volumio[6806]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Mar 29 23:58:17 tikpal-volumio volumio[6806]: info: Retrying Login Due to Network Error Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Mar 29 23:58:21 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Mar 29 23:58:21 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Mar 29 23:58:21 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Mar 29 23:58:21 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Mar 29 23:58:21 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Mar 29 23:58:21 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ------------------------------ 6ms Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 6 milliseconds Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ------------------------------ 5ms Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 4 milliseconds Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ------------------------------ 4ms Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 3 milliseconds Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5467,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5467,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5467,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:21 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ------------------------------ 86ms Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ------------------------------ 86ms Mar 29 23:58:21 tikpal-volumio volumio[6806]: info: ------------------------------ 85ms Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioGetQueue Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreStateMachine::getQueue Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CorePlayQueue::getQueue Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: Mar 29 23:58:24 tikpal-volumio volumio[6806]: ---------------------------- Client requests Volumio stop Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioStop Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreStateMachine::stop Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreStateMachine::stPlaybackTimer Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreStateMachine::updateTrackBlock Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrackBlock Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreStateMachine::serviceStop Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::serviceStop Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: [1774799904469] ControllerWebradio::stop Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: Mar 29 23:58:24 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: sendMpdCommand stop took 13 milliseconds Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: Mar 29 23:58:24 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: Mar 29 23:58:24 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 8 milliseconds Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 3 milliseconds Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 2 milliseconds Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:24 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: ------------------------------ 48ms Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: ------------------------------ 45ms Mar 29 23:58:24 tikpal-volumio volumio[6806]: info: ------------------------------ 43ms Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioGetQueue Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreStateMachine::getQueue Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CorePlayQueue::getQueue Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Mar 29 23:58:27 tikpal-volumio volumio[6806]: ---------------------------- Client requests Volumio play at index 0 Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPlay Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreStateMachine::play index 0 Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreStateMachine::stop Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreStateMachine::play index undefined Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreStateMachine::startPlaybackTimer Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: [1774799907042] ControllerWebradio::clearAddPlayTrack Mar 29 23:58:27 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: sendMpdCommand stop took 4 milliseconds Mar 29 23:58:27 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: sendMpdCommand clear took 1 milliseconds Mar 29 23:58:27 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Mar 29 23:58:27 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Mar 29 23:58:27 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Mar 29 23:58:27 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 231 milliseconds Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 29 23:58:27 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand play Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Mar 29 23:58:27 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: ------------------------------ 234ms Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: ------------------------------ 232ms Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: ------------------------------ 231ms Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Mar 29 23:58:27 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Mar 29 23:58:27 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: sendMpdCommand play took 8 milliseconds Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: ------------------------------ 8ms Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: ------------------------------ 6ms Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: ------------------------------ 5ms Mar 29 23:58:27 tikpal-volumio volumio[6806]: info: MyVolumio login type: Token Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Mar 29 23:58:28 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Mar 29 23:58:28 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Mar 29 23:58:28 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Mar 29 23:58:28 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 5 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 6 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 5 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 2 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus stop Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ------------------------------ 12ms Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Mar 29 23:58:28 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Mar 29 23:58:28 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 4 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 3 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ------------------------------ 87ms Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ------------------------------ 86ms Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ------------------------------ 85ms Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 74 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 74 milliseconds Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 5791/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:28 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ------------------------------ 134ms Mar 29 23:58:28 tikpal-volumio volumio[6806]: info: ------------------------------ 133ms Mar 29 23:58:28 tikpal-volumio volumio[6806]: (node:6806) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 close listeners added to [TLSSocket]. Use emitter.setMaxListeners() to increase limit Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Mar 29 23:58:29 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Mar 29 23:58:29 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Mar 29 23:58:29 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Mar 29 23:58:29 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Mar 29 23:58:29 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Mar 29 23:58:29 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ------------------------------ 6ms Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 5 milliseconds Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ------------------------------ 4ms Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 4 milliseconds Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ------------------------------ 4ms Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 3 milliseconds Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":975,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":975,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":975,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:29 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ------------------------------ 74ms Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ------------------------------ 74ms Mar 29 23:58:29 tikpal-volumio volumio[6806]: info: ------------------------------ 72ms Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Mar 29 23:58:36 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Mar 29 23:58:36 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Mar 29 23:58:36 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Mar 29 23:58:36 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Mar 29 23:58:36 tikpal-volumio volumio[6806]: ---------------------------- MPD announces system playlist update Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Ignoring MPD Status Update Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Mar 29 23:58:36 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ------------------------------ 8ms Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 6 milliseconds Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ------------------------------ 8ms Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 7 milliseconds Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ------------------------------ 6ms Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 4 milliseconds Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7829,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ------------------------------ 52ms Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 42 milliseconds Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 42 milliseconds Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7967,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7967,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Mar 29 23:58:36 tikpal-volumio volumio[6806]: verbose: CURRENT POSITION 0 Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState stateService play Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::syncState currentStatus play Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: Received an update from plugin. extracting info from payload Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ------------------------------ 107ms Mar 29 23:58:36 tikpal-volumio volumio[6806]: info: ------------------------------ 106ms Mar 29 23:58:40 tikpal-volumio shairport-sync[8458]: warning: alsa: error -16 ("Device or resource busy") opening alsa device "volumio". Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Airplay started streaming, receiving metadatas Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioStop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::stop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::stPlaybackTimer Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::updateTrackBlock Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrackBlock Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::serviceStop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::serviceStop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: [1774799920906] ControllerWebradio::stop Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Airplay started streaming, receiving metadatas Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioStop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::stop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Airplay started streaming, receiving metadatas Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioStop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::stop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Mar 29 23:58:40 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: sendMpdCommand stop took 23 milliseconds Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Mar 29 23:58:40 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:40 tikpal-volumio shairport-sync[8596]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 29 23:58:40 tikpal-volumio shairport-sync[8596]: Dload Upload Total Spent Left Speed Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Mar 29 23:58:40 tikpal-volumio volumio[6806]: ---------------------------- MPD announces state update: player Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: ControllerMpd::getState Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand status Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 5 milliseconds Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:40 tikpal-volumio shairport-sync[8596]: [79B blob data] Mar 29 23:58:40 tikpal-volumio shairport-sync[8595]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 29 23:58:40 tikpal-volumio shairport-sync[8595]: Dload Upload Total Spent Left Speed Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 11 milliseconds Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: sendMpdCommand status took 11 milliseconds Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseState Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: ------------------------------ 36ms Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Mar 29 23:58:40 tikpal-volumio volumio[6806]: ---------------------------- Client requests Start Airplay PlaybackRoutine Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Airplay playback start Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioStop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::stop Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 29 milliseconds Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: sendMpdCommand playlistinfo took 29 milliseconds Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:40 tikpal-volumio volumio[6806]: verbose: ControllerMpd::parseTrackInfo Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:40 tikpal-volumio shairport-sync[8595]: [79B blob data] Mar 29 23:58:40 tikpal-volumio shairport-sync[8596]: [79B blob data] Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: ControllerMpd::pushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrack 0 Mar 29 23:58:40 tikpal-volumio volumio[6806]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: ------------------------------ 72ms Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: ------------------------------ 71ms Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: Mar 29 23:58:41 tikpal-volumio volumio[6806]: ---------------------------- Client requests AirplayActive Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive Mar 29 23:58:41 tikpal-volumio shairport-sync[8596]: {"time":1774799920969,"response":"startAirplayPlayback Success"} Mar 29 23:58:41 tikpal-volumio shairport-sync[8595]: [79B blob data] Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:41 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:42 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:43 tikpal-volumio shairport-sync[8595]: {"time":1774799921025,"response":"airplayActive Success"} Mar 29 23:58:43 tikpal-volumio shairport-sync[8604]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 29 23:58:43 tikpal-volumio shairport-sync[8604]: Dload Upload Total Spent Left Speed Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: Mar 29 23:58:43 tikpal-volumio volumio[6806]: ---------------------------- Client requests Stop Airplay Playback Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: Airplay playback stop Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: Airplay Playback Stopped, clearing state Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreStateMachine::resetVolumioState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreStateMachine::getcurrentVolume Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioRetrievevolume Mar 29 23:58:43 tikpal-volumio shairport-sync[8604]: [158B blob data] Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: VolumeController:: Volume=33 Mute =false Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreStateMachine::updateTrackBlock Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CorePlayQueue::getTrackBlock Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioRetrievevolume Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: VolumeController:: Volume=33 Mute =false Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:43 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:50 tikpal-volumio volumio[6806]: info: Airplay started streaming, receiving metadatas Mar 29 23:58:50 tikpal-volumio volumio[6806]: info: Airplay started streaming, receiving metadatas Mar 29 23:58:50 tikpal-volumio volumio[6806]: info: Airplay started streaming, receiving metadatas Mar 29 23:58:50 tikpal-volumio shairport-sync[8604]: {"time":1774799923199,"response":"stopAirplayPlayback Success"} Mar 29 23:58:50 tikpal-volumio shairport-sync[8632]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 29 23:58:50 tikpal-volumio shairport-sync[8632]: Dload Upload Total Spent Left Speed Mar 29 23:58:50 tikpal-volumio volumio[6806]: info: Mar 29 23:58:50 tikpal-volumio volumio[6806]: ---------------------------- Client requests Start Airplay PlaybackRoutine Mar 29 23:58:50 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Mar 29 23:58:50 tikpal-volumio volumio[6806]: info: Airplay playback start Mar 29 23:58:50 tikpal-volumio shairport-sync[8632]: [158B blob data] Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:51 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::servicePushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreStateMachine::pushState Mar 29 23:58:52 tikpal-volumio volumio[6806]: info: CoreCommandRouter::volumioPushState Mar 29 23:58:57 tikpal-volumio volumio[6806]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Mar 29 23:58:57 tikpal-volumio volumio[6806]: info: Retrying Login Due to Network Error Mar 29 23:59:02 tikpal-volumio volumio[6806]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 23:59:02 tikpal-volumio volumio[6806]: Error: connect ETIMEDOUT 199.96.59.61:443 Mar 29 23:59:02 tikpal-volumio volumio[6806]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Mar 29 23:59:02 tikpal-volumio volumio[6806]: errno: -110, Mar 29 23:59:02 tikpal-volumio volumio[6806]: code: 'ETIMEDOUT', Mar 29 23:59:02 tikpal-volumio volumio[6806]: syscall: 'connect', Mar 29 23:59:02 tikpal-volumio volumio[6806]: address: '199.96.59.61', Mar 29 23:59:02 tikpal-volumio volumio[6806]: port: 443 Mar 29 23:59:02 tikpal-volumio volumio[6806]: } Mar 29 23:59:02 tikpal-volumio volumio[6806]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 23:59:05 tikpal-volumio sudo[8664]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-29 23:58' Mar 29 23:59:05 tikpal-volumio sudo[8664]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"