-- Logs begin at Fri 2025-02-14 09:15:34 UTC, end at Sat 2025-02-15 07:10:46 UTC. --
Feb 15 07:09:00 opera volumio[1698]: 84
Feb 15 07:09:00 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:00 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:00 opera volumio[5537]: info:
Feb 15 07:09:00 opera volumio[5537]: ---------------------------- Client requests Volume 84
Feb 15 07:09:00 opera volumio[5537]: info: VolumeController::SetAlsaVolume84
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:00 opera volumio[1698]: [155B blob data]
Feb 15 07:09:00 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:00 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:00 opera volumio[1698]: {"time":1739603340463,"response":"volume Success"}84
Feb 15 07:09:00 opera volumio[1698]: 82
Feb 15 07:09:00 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:00 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:00 opera volumio[5537]: info:
Feb 15 07:09:00 opera volumio[5537]: ---------------------------- Client requests Volume 82
Feb 15 07:09:00 opera volumio[5537]: info: VolumeController::SetAlsaVolume82
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:00 opera volumio[1698]: [155B blob data]
Feb 15 07:09:00 opera volumio[1698]: {"time":1739603340520,"response":"volume Success"}82
Feb 15 07:09:00 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:00 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:00 opera volumio[1698]: 75
Feb 15 07:09:00 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:00 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:00 opera volumio[5537]: info:
Feb 15 07:09:00 opera volumio[5537]: ---------------------------- Client requests Volume 75
Feb 15 07:09:00 opera volumio[5537]: info: VolumeController::SetAlsaVolume75
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:00 opera volumio[1698]: [155B blob data]
Feb 15 07:09:00 opera volumio[1698]: {"time":1739603340584,"response":"volume Success"}75
Feb 15 07:09:00 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:00 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:00 opera volumio[1698]: 70
Feb 15 07:09:00 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:00 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:00 opera volumio[5537]: info:
Feb 15 07:09:00 opera volumio[5537]: ---------------------------- Client requests Volume 70
Feb 15 07:09:00 opera volumio[5537]: info: VolumeController::SetAlsaVolume70
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:00 opera volumio[1698]: [155B blob data]
Feb 15 07:09:00 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:00 opera volumio[1698]: {"time":1739603340723,"response":"volume Success"}70
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:00 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:00 opera volumio[1698]: 65
Feb 15 07:09:00 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:00 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:00 opera volumio[5537]: info:
Feb 15 07:09:00 opera volumio[5537]: ---------------------------- Client requests Volume 65
Feb 15 07:09:00 opera volumio[5537]: info: VolumeController::SetAlsaVolume65
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:00 opera volumio[1698]: [155B blob data]
Feb 15 07:09:00 opera volumio[1698]: {"time":1739603340851,"response":"volume Success"}65
Feb 15 07:09:00 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:00 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:00 opera volumio[1698]: 60
Feb 15 07:09:00 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:00 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:00 opera volumio[5537]: info:
Feb 15 07:09:00 opera volumio[5537]: ---------------------------- Client requests Volume 60
Feb 15 07:09:00 opera volumio[5537]: info: VolumeController::SetAlsaVolume60
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:00 opera volumio[1698]: [155B blob data]
Feb 15 07:09:00 opera volumio[1698]: {"time":1739603340921,"response":"volume Success"}60
Feb 15 07:09:00 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:00 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:00 opera volumio[1698]: 55
Feb 15 07:09:00 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:00 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:00 opera volumio[5537]: info:
Feb 15 07:09:00 opera volumio[5537]: ---------------------------- Client requests Volume 55
Feb 15 07:09:00 opera volumio[5537]: info: VolumeController::SetAlsaVolume55
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:00 opera volumio[1698]: [155B blob data]
Feb 15 07:09:00 opera volumio[1698]: {"time":1739603340970,"response":"volume Success"}55
Feb 15 07:09:00 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:00 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:00 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:00 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:01 opera volumio[1698]: 46
Feb 15 07:09:01 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:01 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:01 opera volumio[5537]: info:
Feb 15 07:09:01 opera volumio[5537]: ---------------------------- Client requests Volume 46
Feb 15 07:09:01 opera volumio[5537]: info: VolumeController::SetAlsaVolume46
Feb 15 07:09:01 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:01 opera volumio[1698]: [155B blob data]
Feb 15 07:09:01 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:01 opera volumio[1698]: {"time":1739603341049,"response":"volume Success"}46
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:01 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:01 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:01 opera volumio[1698]: 39
Feb 15 07:09:01 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:01 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:01 opera volumio[5537]: info:
Feb 15 07:09:01 opera volumio[5537]: ---------------------------- Client requests Volume 39
Feb 15 07:09:01 opera volumio[5537]: info: VolumeController::SetAlsaVolume39
Feb 15 07:09:01 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:01 opera volumio[1698]: [155B blob data]
Feb 15 07:09:01 opera volumio[1698]: {"time":1739603341100,"response":"volume Success"}39
Feb 15 07:09:01 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:01 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:01 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:01 opera volumio[1698]: 34
Feb 15 07:09:01 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:01 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:01 opera volumio[5537]: info:
Feb 15 07:09:01 opera volumio[5537]: ---------------------------- Client requests Volume 34
Feb 15 07:09:01 opera volumio[5537]: info: VolumeController::SetAlsaVolume34
Feb 15 07:09:01 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:01 opera volumio[1698]: [155B blob data]
Feb 15 07:09:01 opera volumio[1698]: {"time":1739603341231,"response":"volume Success"}34
Feb 15 07:09:01 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:01 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:01 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:01 opera volumio[1698]: 29
Feb 15 07:09:01 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:01 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:01 opera volumio[5537]: info:
Feb 15 07:09:01 opera volumio[5537]: ---------------------------- Client requests Volume 29
Feb 15 07:09:01 opera volumio[5537]: info: VolumeController::SetAlsaVolume29
Feb 15 07:09:01 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:01 opera volumio[1698]: [155B blob data]
Feb 15 07:09:01 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:01 opera volumio[1698]: {"time":1739603341384,"response":"volume Success"}29
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:01 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:01 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:01 opera volumio[1698]: 25
Feb 15 07:09:01 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:01 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:01 opera volumio[5537]: info:
Feb 15 07:09:01 opera volumio[5537]: ---------------------------- Client requests Volume 25
Feb 15 07:09:01 opera volumio[5537]: info: VolumeController::SetAlsaVolume25
Feb 15 07:09:01 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:01 opera volumio[1698]: [155B blob data]
Feb 15 07:09:01 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:01 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:01 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:01 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:01 opera volumio[1698]: {"time":1739603341452,"response":"volume Success"}25
Feb 15 07:09:02 opera volumio[1698]: 21
Feb 15 07:09:02 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:02 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:02 opera volumio[5537]: info:
Feb 15 07:09:02 opera volumio[5537]: ---------------------------- Client requests Volume 21
Feb 15 07:09:02 opera volumio[5537]: info: VolumeController::SetAlsaVolume21
Feb 15 07:09:02 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:02 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:02 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:02 opera volumio[1698]: [155B blob data]
Feb 15 07:09:02 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:02 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:02 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:02 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:02 opera volumio[1698]: {"time":1739603342511,"response":"volume Success"}21
Feb 15 07:09:03 opera volumio[5537]: info:
Feb 15 07:09:03 opera volumio[5537]: ---------------------------- MPD announces state update: player
Feb 15 07:09:03 opera volumio[5537]: info: ControllerMpd::getState
Feb 15 07:09:03 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand status
Feb 15 07:09:03 opera volumio[5537]: info: sendMpdCommand status took 0 milliseconds
Feb 15 07:09:03 opera volumio[5537]: verbose: ControllerMpd::parseState
Feb 15 07:09:03 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 15 07:09:03 opera volumio[5537]: info: sendMpdCommand playlistinfo took 0 milliseconds
Feb 15 07:09:03 opera volumio[5537]: verbose: ControllerMpd::parseTrackInfo
Feb 15 07:09:03 opera volumio[5537]: info: ControllerMpd::pushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:03 opera volumio[5537]: verbose: In UPNP mode
Feb 15 07:09:03 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3111,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","uri":"http://116.31.99.205/amobile.music.tc.qq.com/M5000002fKJq07c0AN.mp3?guid=7141208BD8964BFE905C7D2794E1C916&vkey=1FF3628F3C7F10005D6E5D3F2FFAE45ADCB1FF6D08B69247432A6AF02A8B3021442E3A77334934C0E0B01345FFAD858C8D6ADF75E5E3545E__v2b94c1bd&uin=&src=M500004KITug0Qbyaq.mp3&fromtag=118042","trackType":""}
Feb 15 07:09:03 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:03 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:03 opera volumio[5537]: info: ------------------------------ 10ms
Feb 15 07:09:03 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:03 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:03 opera volumio[5537]: verbose: In UPNP mode
Feb 15 07:09:03 opera volumio[5537]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received airplay_emulation
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:03 opera volumio[5537]: verbose: In UPNP mode
Feb 15 07:09:03 opera volumio[5537]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received airplay_emulation
Feb 15 07:09:03 opera shairport-sync[14263]: Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory
Feb 15 07:09:03 opera systemd-journal[245]: Suppressed 1877 messages from /system.slice/shairport-sync.service
Feb 15 07:09:03 opera shairport-sync[14263]: alsa: error -16 ("Device or resource busy") opening alsa device "plughw:5,0".
Feb 15 07:09:03 opera volumio[5537]: info: Airplay started streaming, receiving metadatas
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioStop
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::stop
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:03 opera volumio[5537]: verbose: UNSET VOLATILE
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::stPlaybackTimer
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::updateTrackBlock
Feb 15 07:09:03 opera shairport-sync[14263]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:03 opera shairport-sync[14263]: Dload Upload Total Spent Left Speed
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrackBlock
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::serviceStop
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: info: ControllerMpd::stop
Feb 15 07:09:03 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:03 opera volumio[5537]: info: Airplay started streaming, receiving metadatas
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioStop
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::stop
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:03 opera volumio[5537]: verbose: UNSET VOLATILE
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:03 opera shairport-sync[14263]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:03 opera shairport-sync[14263]: Dload Upload Total Spent Left Speed
Feb 15 07:09:03 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:03 opera volumio[5537]: info:
Feb 15 07:09:03 opera volumio[5537]: ---------------------------- Client requests Start Airplay PlaybackRoutine
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback
Feb 15 07:09:03 opera volumio[5537]: info: Airplay playback start
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioStop
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::stop
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:03 opera volumio[5537]: verbose: UNSET VOLATILE
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:03 opera volumio[5537]: info:
Feb 15 07:09:03 opera volumio[5537]: ---------------------------- Client requests AirplayActive
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive
Feb 15 07:09:03 opera shairport-sync[14263]: [155B blob data]
Feb 15 07:09:03 opera shairport-sync[14263]: [143B blob data]
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":null,"duration":null,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:03 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus stop
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":null,"duration":null,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:03 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:03 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:03 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:03 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:03 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:03 opera volumio[5537]: info: sendMpdCommand stop took 111 milliseconds
Feb 15 07:09:03 opera volumio[5537]: info:
Feb 15 07:09:03 opera volumio[5537]: ---------------------------- MPD announces state update: player
Feb 15 07:09:03 opera volumio[5537]: info: ControllerMpd::getState
Feb 15 07:09:03 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand status
Feb 15 07:09:03 opera volumio[5537]: info: sendMpdCommand status took 1 milliseconds
Feb 15 07:09:03 opera volumio[5537]: verbose: ControllerMpd::parseState
Feb 15 07:09:03 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 15 07:09:03 opera volumio[5537]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 15 07:09:03 opera volumio[5537]: verbose: ControllerMpd::parseTrackInfo
Feb 15 07:09:03 opera volumio[5537]: info: ControllerMpd::pushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:03 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:03 opera volumio[5537]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","uri":"http://116.31.99.205/amobile.music.tc.qq.com/M5000002fKJq07c0AN.mp3?guid=7141208BD8964BFE905C7D2794E1C916&vkey=1FF3628F3C7F10005D6E5D3F2FFAE45ADCB1FF6D08B69247432A6AF02A8B3021442E3A77334934C0E0B01345FFAD858C8D6ADF75E5E3545E__v2b94c1bd&uin=&src=M500004KITug0Qbyaq.mp3&fromtag=118042","trackType":""}
Feb 15 07:09:03 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:03 opera volumio[5537]: info: CoreStateMachine::syncState stateService stop
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::stPlaybackTimer
Feb 15 07:09:04 opera volumio[5537]: info: ------------------------------ 13ms
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: verbose: STATE SERVICE {"status":"pause","service":"airplay_emulation","title":"Baptized In Fear - The Weeknd (威肯)","artist":"Baptized In Fear — The Weeknd","album":"Hurry Up Tomorrow","albumart":"/albumart?cacheid=367&web=Baptized%20In%20Fear%20%E2%80%94%20The%20Weeknd/Hurry%20Up%20Tomorrow/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":null,"duration":null,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:04 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState stateService pause
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus stop
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: verbose: STATE SERVICE {"status":"pause","service":"airplay_emulation","title":"Baptized In Fear - The Weeknd (威肯)","artist":"Baptized In Fear — The Weeknd","album":"Hurry Up Tomorrow","albumart":"/albumart?cacheid=367&web=Baptized%20In%20Fear%20%E2%80%94%20The%20Weeknd/Hurry%20Up%20Tomorrow/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":null,"duration":null,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:04 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState stateService pause
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus stop
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","albumart":"/albumart?cacheid=367&web=The%20Weeknd/Hurry%20Up%20Tomorrow/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":null,"duration":null,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:04 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus stop
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","albumart":"/albumart?cacheid=367&web=The%20Weeknd/Hurry%20Up%20Tomorrow/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":null,"duration":null,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:04 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:04 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","albumart":"/albumart?cacheid=367&web=The%20Weeknd/Hurry%20Up%20Tomorrow/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:04 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:04 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","albumart":"/albumart?cacheid=367&web=The%20Weeknd/Hurry%20Up%20Tomorrow/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:04 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:04 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","albumart":"/albumart?cacheid=367&web=The%20Weeknd/Hurry%20Up%20Tomorrow/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:04 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:04 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","albumart":"/albumart?cacheid=367&web=The%20Weeknd/Hurry%20Up%20Tomorrow/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:04 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:04 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","albumart":"/albumart?cacheid=367&web=The%20Weeknd/Hurry%20Up%20Tomorrow/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":4000,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:04 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:04 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","albumart":"/albumart?cacheid=367&web=The%20Weeknd/Hurry%20Up%20Tomorrow/extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":4000,"duration":232,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:04 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:04 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:04 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:04 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:04 opera volumio[5537]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Weeknd/Hurry%20Up%20Tomorrow/c6917a1b-a9ea-4aa9-b3da-b19c443fc4dd.jpg'
Feb 15 07:09:04 opera volumio[5537]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Weeknd/Hurry%20Up%20Tomorrow/c6917a1b-a9ea-4aa9-b3da-b19c443fc4dd.jpg'
Feb 15 07:09:05 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:05 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:05 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:05 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:05 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:05 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:05 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:05 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:05 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:05 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:07 opera volumio[5537]: info: Clearing queue after UPNP request
Feb 15 07:09:07 opera volumio[5537]: verbose: UNSET VOLATILE
Feb 15 07:09:07 opera volumio[5537]: info: Stopping Airplay Playback and sending pause command to client via USR2
Feb 15 07:09:07 opera sudo[14453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 14263
Feb 15 07:09:07 opera sudo[14453]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 07:09:07 opera sudo[14453]: pam_unix(sudo:session): session closed for user root
Feb 15 07:09:07 opera volumio[5537]: info: Shairport-Sync paused with USR2
Feb 15 07:09:07 opera shairport-sync[14263]: {"time":1739603343888,"response":"airplayActive Success"}
Feb 15 07:09:07 opera systemd[1]: shairport-sync.service: main process exited, code=killed, status=12/USR2
Feb 15 07:09:07 opera systemd[1]: Unit shairport-sync.service entered failed state.
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::ClearQueue
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::stop
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:08 opera volumio[5537]: verbose: UNSET VOLATILE
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::updateTrackBlock
Feb 15 07:09:08 opera volumio[5537]: info: CorePlayQueue::getTrackBlock
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::stPlaybackTimer
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:08 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::serviceStop
Feb 15 07:09:08 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:08 opera volumio[5537]: info: ControllerMpd::stop
Feb 15 07:09:08 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand stop
Feb 15 07:09:08 opera volumio[5537]: info: CorePlayQueue::clearPlayQueue
Feb 15 07:09:08 opera volumio[5537]: info: CorePlayQueue::saveQueue
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::volumioPushQueue
Feb 15 07:09:08 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:08 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:08 opera volumio[5537]: info:
Feb 15 07:09:08 opera volumio[5537]: ---------------------------- MPD announces system playlist update
Feb 15 07:09:08 opera volumio[5537]: info: Ignoring MPD Status Update
Feb 15 07:09:08 opera volumio[5537]: info: sendMpdCommand stop took 16 milliseconds
Feb 15 07:09:08 opera volumio[5537]: error: updateQueue error: null
Feb 15 07:09:08 opera volumio[5537]: info: ------------------------------ 1ms
Feb 15 07:09:08 opera volumio[5537]: info: Starting UPNP Playback
Feb 15 07:09:08 opera volumio[5537]: info: Preparing playback through UPNP
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::volumioGetState
Feb 15 07:09:08 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 15 07:09:08 opera volumio[5537]: info:
Feb 15 07:09:08 opera volumio[5537]: ---------------------------- MPD announces system playlist update
Feb 15 07:09:08 opera volumio[5537]: info: Ignoring MPD Status Update
Feb 15 07:09:08 opera volumio[5537]: info: ------------------------------ 1ms
Feb 15 07:09:08 opera volumio[5537]: info:
Feb 15 07:09:08 opera volumio[5537]: ---------------------------- MPD announces system playlist update
Feb 15 07:09:08 opera volumio[5537]: info: Ignoring MPD Status Update
Feb 15 07:09:08 opera volumio[5537]: info: ------------------------------ 1ms
Feb 15 07:09:08 opera volumio[5537]: info:
Feb 15 07:09:08 opera volumio[5537]: ---------------------------- MPD announces system playlist update
Feb 15 07:09:08 opera volumio[5537]: info: Ignoring MPD Status Update
Feb 15 07:09:08 opera volumio[5537]: info:
Feb 15 07:09:08 opera volumio[5537]: ---------------------------- MPD announces system playlist update
Feb 15 07:09:08 opera volumio[5537]: info: Ignoring MPD Status Update
Feb 15 07:09:08 opera volumio[5537]: info: ------------------------------ 1ms
Feb 15 07:09:08 opera volumio[5537]: info: ------------------------------ 1ms
Feb 15 07:09:08 opera volumio[5537]: info:
Feb 15 07:09:08 opera volumio[5537]: ---------------------------- MPD announces system playlist update
Feb 15 07:09:08 opera volumio[5537]: info: Ignoring MPD Status Update
Feb 15 07:09:08 opera volumio[5537]: info: ------------------------------ 0ms
Feb 15 07:09:08 opera volumio[5537]: info:
Feb 15 07:09:08 opera volumio[5537]: ---------------------------- MPD announces system playlist update
Feb 15 07:09:08 opera volumio[5537]: info: Ignoring MPD Status Update
Feb 15 07:09:08 opera volumio[5537]: info: ------------------------------ 0ms
Feb 15 07:09:08 opera volumio[5537]: info:
Feb 15 07:09:08 opera volumio[5537]: ---------------------------- MPD announces state update: player
Feb 15 07:09:08 opera volumio[5537]: info: ControllerMpd::getState
Feb 15 07:09:08 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand status
Feb 15 07:09:08 opera volumio[5537]: info: sendMpdCommand status took 2 milliseconds
Feb 15 07:09:08 opera volumio[5537]: verbose: ControllerMpd::parseState
Feb 15 07:09:08 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 15 07:09:08 opera volumio[5537]: info:
Feb 15 07:09:08 opera volumio[5537]: ---------------------------- MPD announces system playlist update
Feb 15 07:09:08 opera volumio[5537]: info: Ignoring MPD Status Update
Feb 15 07:09:08 opera volumio[5537]: info:
Feb 15 07:09:08 opera volumio[5537]: ---------------------------- MPD announces state update: player
Feb 15 07:09:08 opera volumio[5537]: info: ControllerMpd::getState
Feb 15 07:09:08 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand status
Feb 15 07:09:08 opera volumio[5537]: info: sendMpdCommand playlistinfo took 1 milliseconds
Feb 15 07:09:08 opera volumio[5537]: verbose: ControllerMpd::parseTrackInfo
Feb 15 07:09:08 opera volumio[5537]: info: ControllerMpd::pushState
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:08 opera volumio[5537]: verbose: In UPNP mode
Feb 15 07:09:08 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","uri":"http://116.31.99.205/amobile.music.tc.qq.com/M5000002fKJq07c0AN.mp3?guid=7141208BD8964BFE905C7D2794E1C916&vkey=1FF3628F3C7F10005D6E5D3F2FFAE45ADCB1FF6D08B69247432A6AF02A8B3021442E3A77334934C0E0B01345FFAD858C8D6ADF75E5E3545E__v2b94c1bd&uin=&src=M500004KITug0Qbyaq.mp3&fromtag=118042","trackType":""}
Feb 15 07:09:08 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus stop
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:08 opera volumio[5537]: info: ------------------------------ 9ms
Feb 15 07:09:08 opera volumio[5537]: info: ------------------------------ 6ms
Feb 15 07:09:08 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:08 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:08 opera volumio[5537]: info: sendMpdCommand status took 29 milliseconds
Feb 15 07:09:08 opera volumio[5537]: verbose: ControllerMpd::parseState
Feb 15 07:09:08 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 15 07:09:08 opera volumio[5537]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 15 07:09:08 opera volumio[5537]: verbose: ControllerMpd::parseTrackInfo
Feb 15 07:09:08 opera volumio[5537]: info: ControllerMpd::pushState
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:08 opera volumio[5537]: verbose: In UPNP mode
Feb 15 07:09:08 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","position":0,"seek":116,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","uri":"http://116.31.99.205/amobile.music.tc.qq.com/M5000002fKJq07c0AN.mp3?guid=7141208BD8964BFE905C7D2794E1C916&vkey=1FF3628F3C7F10005D6E5D3F2FFAE45ADCB1FF6D08B69247432A6AF02A8B3021442E3A77334934C0E0B01345FFAD858C8D6ADF75E5E3545E__v2b94c1bd&uin=&src=M500004KITug0Qbyaq.mp3&fromtag=118042","trackType":""}
Feb 15 07:09:08 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:08 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:08 opera volumio[5537]: info: ------------------------------ 45ms
Feb 15 07:09:08 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:08 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:08 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:08 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:08 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:08 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:08 opera volumio[5537]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Weeknd/Hurry%20Up%20Tomorrow/c6917a1b-a9ea-4aa9-b3da-b19c443fc4dd.jpg'
Feb 15 07:09:08 opera volumio[5537]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Weeknd/Hurry%20Up%20Tomorrow/c6917a1b-a9ea-4aa9-b3da-b19c443fc4dd.jpg'
Feb 15 07:09:08 opera volumio[5537]: info: Restarting Shairport-Sync after stop
Feb 15 07:09:08 opera sudo[14478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 15 07:09:08 opera sudo[14478]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 15 07:09:08 opera systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Feb 15 07:09:08 opera systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 15 07:09:08 opera sudo[14478]: pam_unix(sudo:session): session closed for user root
Feb 15 07:09:08 opera volumio[5537]: info: Shairport-Sync retarted
Feb 15 07:09:09 opera volumio[5537]: info:
Feb 15 07:09:09 opera volumio[5537]: ---------------------------- MPD announces state update: player
Feb 15 07:09:09 opera volumio[5537]: info: ControllerMpd::getState
Feb 15 07:09:09 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand status
Feb 15 07:09:09 opera volumio[5537]: info: sendMpdCommand status took 1 milliseconds
Feb 15 07:09:09 opera volumio[5537]: verbose: ControllerMpd::parseState
Feb 15 07:09:09 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 15 07:09:09 opera volumio[5537]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 15 07:09:09 opera volumio[5537]: verbose: ControllerMpd::parseTrackInfo
Feb 15 07:09:09 opera volumio[5537]: info: ControllerMpd::pushState
Feb 15 07:09:09 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:09 opera volumio[5537]: verbose: In UPNP mode
Feb 15 07:09:09 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3000,"duration":232,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","uri":"http://116.31.99.205/amobile.music.tc.qq.com/M5000002fKJq07c0AN.mp3?guid=7141208BD8964BFE905C7D2794E1C916&vkey=1FF3628F3C7F10005D6E5D3F2FFAE45ADCB1FF6D08B69247432A6AF02A8B3021442E3A77334934C0E0B01345FFAD858C8D6ADF75E5E3545E__v2b94c1bd&uin=&src=M500004KITug0Qbyaq.mp3&fromtag=118042","trackType":""}
Feb 15 07:09:09 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:09 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:09 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:09 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:09 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Feb 15 07:09:09 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:09 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:09 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:09 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:09 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:09 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:09 opera volumio[5537]: info: ------------------------------ 37ms
Feb 15 07:09:09 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:09 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:09 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:09 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:09 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:09 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:09 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:09 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:26 opera volumio[1698]: 87
Feb 15 07:09:26 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:26 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:26 opera volumio[5537]: info:
Feb 15 07:09:26 opera volumio[5537]: ---------------------------- Client requests Volume 87
Feb 15 07:09:26 opera volumio[5537]: info: VolumeController::SetAlsaVolume87
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:26 opera volumio[1698]: [155B blob data]
Feb 15 07:09:26 opera volumio[1698]: {"time":1739603366113,"response":"volume Success"}87
Feb 15 07:09:26 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:26 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:26 opera volumio[1698]: 85
Feb 15 07:09:26 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:26 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:26 opera volumio[5537]: info:
Feb 15 07:09:26 opera volumio[5537]: ---------------------------- Client requests Volume 85
Feb 15 07:09:26 opera volumio[5537]: info: VolumeController::SetAlsaVolume85
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:26 opera volumio[1698]: [155B blob data]
Feb 15 07:09:26 opera volumio[1698]: {"time":1739603366198,"response":"volume Success"}85
Feb 15 07:09:26 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:26 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:26 opera volumio[1698]: 83
Feb 15 07:09:26 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:26 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:26 opera volumio[5537]: info:
Feb 15 07:09:26 opera volumio[5537]: ---------------------------- Client requests Volume 83
Feb 15 07:09:26 opera volumio[5537]: info: VolumeController::SetAlsaVolume83
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:26 opera volumio[1698]: [155B blob data]
Feb 15 07:09:26 opera volumio[1698]: {"time":1739603366251,"response":"volume Success"}83
Feb 15 07:09:26 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:26 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:26 opera volumio[1698]: 78
Feb 15 07:09:26 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:26 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:26 opera volumio[5537]: info:
Feb 15 07:09:26 opera volumio[5537]: ---------------------------- Client requests Volume 78
Feb 15 07:09:26 opera volumio[5537]: info: VolumeController::SetAlsaVolume78
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:26 opera volumio[1698]: [155B blob data]
Feb 15 07:09:26 opera volumio[1698]: {"time":1739603366541,"response":"volume Success"}78
Feb 15 07:09:26 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:26 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:26 opera volumio[1698]: 72
Feb 15 07:09:26 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:26 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:26 opera volumio[5537]: info:
Feb 15 07:09:26 opera volumio[5537]: ---------------------------- Client requests Volume 72
Feb 15 07:09:26 opera volumio[5537]: info: VolumeController::SetAlsaVolume72
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:26 opera volumio[1698]: [155B blob data]
Feb 15 07:09:26 opera volumio[1698]: {"time":1739603366649,"response":"volume Success"}72
Feb 15 07:09:26 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:26 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:26 opera volumio[1698]: 66
Feb 15 07:09:26 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:26 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:26 opera volumio[5537]: info:
Feb 15 07:09:26 opera volumio[5537]: ---------------------------- Client requests Volume 66
Feb 15 07:09:26 opera volumio[5537]: info: VolumeController::SetAlsaVolume66
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:26 opera volumio[1698]: [155B blob data]
Feb 15 07:09:26 opera volumio[1698]: {"time":1739603366725,"response":"volume Success"}66
Feb 15 07:09:26 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:26 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:26 opera volumio[1698]: 61
Feb 15 07:09:26 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:26 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:26 opera volumio[5537]: info:
Feb 15 07:09:26 opera volumio[5537]: ---------------------------- Client requests Volume 61
Feb 15 07:09:26 opera volumio[5537]: info: VolumeController::SetAlsaVolume61
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:26 opera volumio[1698]: [155B blob data]
Feb 15 07:09:26 opera volumio[1698]: {"time":1739603366799,"response":"volume Success"}61
Feb 15 07:09:26 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:26 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:26 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:26 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:27 opera volumio[1698]: 55
Feb 15 07:09:27 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:27 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:27 opera volumio[5537]: info:
Feb 15 07:09:27 opera volumio[5537]: ---------------------------- Client requests Volume 55
Feb 15 07:09:27 opera volumio[5537]: info: VolumeController::SetAlsaVolume55
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:27 opera volumio[1698]: [155B blob data]
Feb 15 07:09:27 opera volumio[1698]: {"time":1739603367096,"response":"volume Success"}55
Feb 15 07:09:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:27 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:27 opera volumio[1698]: 50
Feb 15 07:09:27 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:27 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:27 opera volumio[5537]: info:
Feb 15 07:09:27 opera volumio[5537]: ---------------------------- Client requests Volume 50
Feb 15 07:09:27 opera volumio[5537]: info: VolumeController::SetAlsaVolume50
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:27 opera volumio[1698]: [155B blob data]
Feb 15 07:09:27 opera volumio[1698]: {"time":1739603367174,"response":"volume Success"}50
Feb 15 07:09:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:27 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:27 opera volumio[1698]: 48
Feb 15 07:09:27 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:27 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:27 opera volumio[5537]: info:
Feb 15 07:09:27 opera volumio[5537]: ---------------------------- Client requests Volume 48
Feb 15 07:09:27 opera volumio[5537]: info: VolumeController::SetAlsaVolume48
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:27 opera volumio[1698]: [155B blob data]
Feb 15 07:09:27 opera volumio[1698]: {"time":1739603367235,"response":"volume Success"}48
Feb 15 07:09:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:27 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:27 opera volumio[1698]: 43
Feb 15 07:09:27 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:27 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:27 opera volumio[5537]: info:
Feb 15 07:09:27 opera volumio[5537]: ---------------------------- Client requests Volume 43
Feb 15 07:09:27 opera volumio[5537]: info: VolumeController::SetAlsaVolume43
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:27 opera volumio[1698]: [155B blob data]
Feb 15 07:09:27 opera volumio[1698]: {"time":1739603367314,"response":"volume Success"}43
Feb 15 07:09:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:27 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:27 opera volumio[1698]: 37
Feb 15 07:09:27 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:27 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:27 opera volumio[5537]: info:
Feb 15 07:09:27 opera volumio[5537]: ---------------------------- Client requests Volume 37
Feb 15 07:09:27 opera volumio[5537]: info: VolumeController::SetAlsaVolume37
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:27 opera volumio[1698]: [155B blob data]
Feb 15 07:09:27 opera volumio[1698]: {"time":1739603367603,"response":"volume Success"}37
Feb 15 07:09:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:27 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:27 opera volumio[1698]: 32
Feb 15 07:09:27 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:27 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:27 opera volumio[5537]: info:
Feb 15 07:09:27 opera volumio[5537]: ---------------------------- Client requests Volume 32
Feb 15 07:09:27 opera volumio[5537]: info: VolumeController::SetAlsaVolume32
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:27 opera volumio[1698]: [234B blob data]
Feb 15 07:09:27 opera volumio[1698]: {"time":1739603367667,"response":"volume Success"}32
Feb 15 07:09:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:27 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:27 opera volumio[1698]: 27
Feb 15 07:09:27 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:27 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:27 opera volumio[5537]: info:
Feb 15 07:09:27 opera volumio[5537]: ---------------------------- Client requests Volume 27
Feb 15 07:09:27 opera volumio[5537]: info: VolumeController::SetAlsaVolume27
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:27 opera volumio[1698]: [155B blob data]
Feb 15 07:09:27 opera volumio[1698]: {"time":1739603367759,"response":"volume Success"}27
Feb 15 07:09:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:27 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:27 opera volumio[1698]: 22
Feb 15 07:09:27 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:27 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:27 opera volumio[5537]: info:
Feb 15 07:09:27 opera volumio[5537]: ---------------------------- Client requests Volume 22
Feb 15 07:09:27 opera volumio[5537]: info: VolumeController::SetAlsaVolume22
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:27 opera volumio[1698]: [155B blob data]
Feb 15 07:09:27 opera volumio[1698]: {"time":1739603367837,"response":"volume Success"}22
Feb 15 07:09:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:27 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:27 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:27 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 17
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 17
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume17
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368116,"response":"volume Success"}17
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 11
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 11
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume11
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368197,"response":"volume Success"}11
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 7
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 7
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume7
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368250,"response":"volume Success"}7
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 0
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 1
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume1
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368310,"response":"volume Success"}1
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 9
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 9
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume9
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368371,"response":"volume Success"}9
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 15
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 15
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume15
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368661,"response":"volume Success"}15
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 26
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 26
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume26
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368709,"response":"volume Success"}26
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 31
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 31
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume31
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368765,"response":"volume Success"}31
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 36
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 36
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume36
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368815,"response":"volume Success"}36
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 42
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 42
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume42
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368864,"response":"volume Success"}42
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:28 opera volumio[1698]: 47
Feb 15 07:09:28 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:28 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:28 opera volumio[5537]: info:
Feb 15 07:09:28 opera volumio[5537]: ---------------------------- Client requests Volume 47
Feb 15 07:09:28 opera volumio[5537]: info: VolumeController::SetAlsaVolume47
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:28 opera volumio[1698]: [155B blob data]
Feb 15 07:09:28 opera volumio[1698]: {"time":1739603368923,"response":"volume Success"}47
Feb 15 07:09:28 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:28 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:28 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:28 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:29 opera volumio[1698]: 53
Feb 15 07:09:29 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:29 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:29 opera volumio[5537]: info:
Feb 15 07:09:29 opera volumio[5537]: ---------------------------- Client requests Volume 53
Feb 15 07:09:29 opera volumio[5537]: info: VolumeController::SetAlsaVolume53
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:29 opera volumio[1698]: [155B blob data]
Feb 15 07:09:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:29 opera volumio[1698]: {"time":1739603369154,"response":"volume Success"}53
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:29 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:29 opera volumio[1698]: 58
Feb 15 07:09:29 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:29 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:29 opera volumio[5537]: info:
Feb 15 07:09:29 opera volumio[5537]: ---------------------------- Client requests Volume 58
Feb 15 07:09:29 opera volumio[5537]: info: VolumeController::SetAlsaVolume58
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:29 opera volumio[1698]: [155B blob data]
Feb 15 07:09:29 opera volumio[1698]: {"time":1739603369211,"response":"volume Success"}58
Feb 15 07:09:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:29 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:29 opera volumio[1698]: 63
Feb 15 07:09:29 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:29 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:29 opera volumio[5537]: info:
Feb 15 07:09:29 opera volumio[5537]: ---------------------------- Client requests Volume 63
Feb 15 07:09:29 opera volumio[5537]: info: VolumeController::SetAlsaVolume63
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:29 opera volumio[1698]: [155B blob data]
Feb 15 07:09:29 opera volumio[1698]: {"time":1739603369289,"response":"volume Success"}63
Feb 15 07:09:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:29 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:29 opera volumio[1698]: 69
Feb 15 07:09:29 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:29 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:29 opera volumio[5537]: info:
Feb 15 07:09:29 opera volumio[5537]: ---------------------------- Client requests Volume 69
Feb 15 07:09:29 opera volumio[5537]: info: VolumeController::SetAlsaVolume69
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:29 opera volumio[1698]: [155B blob data]
Feb 15 07:09:29 opera volumio[1698]: {"time":1739603369349,"response":"volume Success"}69
Feb 15 07:09:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:29 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:29 opera volumio[1698]: 77
Feb 15 07:09:29 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:29 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:29 opera volumio[5537]: info:
Feb 15 07:09:29 opera volumio[5537]: ---------------------------- Client requests Volume 77
Feb 15 07:09:29 opera volumio[5537]: info: VolumeController::SetAlsaVolume77
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:29 opera volumio[1698]: [155B blob data]
Feb 15 07:09:29 opera volumio[1698]: {"time":1739603369405,"response":"volume Success"}77
Feb 15 07:09:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:29 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:29 opera volumio[1698]: 85
Feb 15 07:09:29 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:29 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:29 opera volumio[5537]: info:
Feb 15 07:09:29 opera volumio[5537]: ---------------------------- Client requests Volume 85
Feb 15 07:09:29 opera volumio[5537]: info: VolumeController::SetAlsaVolume85
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:29 opera volumio[1698]: [155B blob data]
Feb 15 07:09:29 opera volumio[1698]: {"time":1739603369679,"response":"volume Success"}85
Feb 15 07:09:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:29 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:29 opera volumio[1698]: 90
Feb 15 07:09:29 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:29 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:29 opera volumio[5537]: info:
Feb 15 07:09:29 opera volumio[5537]: ---------------------------- Client requests Volume 90
Feb 15 07:09:29 opera volumio[5537]: info: VolumeController::SetAlsaVolume90
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:29 opera volumio[1698]: [155B blob data]
Feb 15 07:09:29 opera volumio[1698]: {"time":1739603369752,"response":"volume Success"}90
Feb 15 07:09:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:29 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:29 opera volumio[1698]: 85
Feb 15 07:09:29 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:29 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:29 opera volumio[5537]: info:
Feb 15 07:09:29 opera volumio[5537]: ---------------------------- Client requests Volume 85
Feb 15 07:09:29 opera volumio[5537]: info: VolumeController::SetAlsaVolume85
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:29 opera volumio[1698]: [155B blob data]
Feb 15 07:09:29 opera volumio[1698]: {"time":1739603369841,"response":"volume Success"}85
Feb 15 07:09:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:29 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:29 opera volumio[1698]: 79
Feb 15 07:09:29 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:29 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:29 opera volumio[5537]: info:
Feb 15 07:09:29 opera volumio[5537]: ---------------------------- Client requests Volume 79
Feb 15 07:09:29 opera volumio[5537]: info: VolumeController::SetAlsaVolume79
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:29 opera volumio[1698]: [155B blob data]
Feb 15 07:09:29 opera volumio[1698]: {"time":1739603369899,"response":"volume Success"}79
Feb 15 07:09:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:29 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:29 opera volumio[1698]: 73
Feb 15 07:09:29 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:29 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:29 opera volumio[5537]: info:
Feb 15 07:09:29 opera volumio[5537]: ---------------------------- Client requests Volume 73
Feb 15 07:09:29 opera volumio[5537]: info: VolumeController::SetAlsaVolume73
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:29 opera volumio[1698]: [155B blob data]
Feb 15 07:09:29 opera volumio[1698]: {"time":1739603369957,"response":"volume Success"}73
Feb 15 07:09:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:29 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:29 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:29 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:30 opera volumio[1698]: 67
Feb 15 07:09:30 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:30 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:30 opera volumio[5537]: info:
Feb 15 07:09:30 opera volumio[5537]: ---------------------------- Client requests Volume 67
Feb 15 07:09:30 opera volumio[5537]: info: VolumeController::SetAlsaVolume67
Feb 15 07:09:30 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:30 opera volumio[1698]: [155B blob data]
Feb 15 07:09:30 opera volumio[1698]: {"time":1739603370222,"response":"volume Success"}67
Feb 15 07:09:30 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:30 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:30 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:30 opera volumio[1698]: 64
Feb 15 07:09:30 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:30 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:30 opera volumio[5537]: info:
Feb 15 07:09:30 opera volumio[5537]: ---------------------------- Client requests Volume 64
Feb 15 07:09:30 opera volumio[5537]: info: VolumeController::SetAlsaVolume64
Feb 15 07:09:30 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:30 opera volumio[1698]: [155B blob data]
Feb 15 07:09:30 opera volumio[1698]: {"time":1739603370280,"response":"volume Success"}64
Feb 15 07:09:30 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:30 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:30 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:30 opera volumio[1698]: 71
Feb 15 07:09:30 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:30 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:30 opera volumio[5537]: info:
Feb 15 07:09:30 opera volumio[5537]: ---------------------------- Client requests Volume 71
Feb 15 07:09:30 opera volumio[5537]: info: VolumeController::SetAlsaVolume71
Feb 15 07:09:30 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:30 opera volumio[1698]: [155B blob data]
Feb 15 07:09:30 opera volumio[1698]: {"time":1739603370436,"response":"volume Success"}71
Feb 15 07:09:30 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:30 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:30 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:30 opera volumio[1698]: 76
Feb 15 07:09:30 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:30 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:30 opera volumio[5537]: info:
Feb 15 07:09:30 opera volumio[5537]: ---------------------------- Client requests Volume 76
Feb 15 07:09:30 opera volumio[5537]: info: VolumeController::SetAlsaVolume76
Feb 15 07:09:30 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:30 opera volumio[1698]: [155B blob data]
Feb 15 07:09:30 opera volumio[1698]: {"time":1739603370726,"response":"volume Success"}76
Feb 15 07:09:30 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:30 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:30 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:30 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:31 opera volumio[1698]: 76
Feb 15 07:09:31 opera volumio[1698]: % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:31 opera volumio[1698]: Dload Upload Total Spent Left Speed
Feb 15 07:09:31 opera volumio[5537]: info:
Feb 15 07:09:31 opera volumio[5537]: ---------------------------- Client requests Volume 76
Feb 15 07:09:31 opera volumio[5537]: info: VolumeController::SetAlsaVolume76
Feb 15 07:09:31 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:31 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:31 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:31 opera volumio[1698]: [155B blob data]
Feb 15 07:09:31 opera volumio[1698]: {"time":1739603371897,"response":"volume Success"}76
Feb 15 07:09:31 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:31 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:31 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:31 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:48 opera volumio[5537]: info:
Feb 15 07:09:48 opera volumio[5537]: ---------------------------- MPD announces state update: player
Feb 15 07:09:48 opera volumio[5537]: info: ControllerMpd::getState
Feb 15 07:09:48 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand status
Feb 15 07:09:48 opera volumio[5537]: info: sendMpdCommand status took 2 milliseconds
Feb 15 07:09:48 opera volumio[5537]: verbose: ControllerMpd::parseState
Feb 15 07:09:48 opera volumio[5537]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 15 07:09:48 opera volumio[5537]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 15 07:09:48 opera volumio[5537]: verbose: ControllerMpd::parseTrackInfo
Feb 15 07:09:48 opera volumio[5537]: info: ControllerMpd::pushState
Feb 15 07:09:48 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:48 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:48 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:48 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:48 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:48 opera volumio[5537]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Baptized In Fear","artist":"The Weeknd","album":"Hurry Up Tomorrow","uri":"http://116.31.99.205/amobile.music.tc.qq.com/M5000002fKJq07c0AN.mp3?guid=7141208BD8964BFE905C7D2794E1C916&vkey=1FF3628F3C7F10005D6E5D3F2FFAE45ADCB1FF6D08B69247432A6AF02A8B3021442E3A77334934C0E0B01345FFAD858C8D6ADF75E5E3545E__v2b94c1bd&uin=&src=M500004KITug0Qbyaq.mp3&fromtag=118042","trackType":""}
Feb 15 07:09:48 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:48 opera volumio[5537]: info: CoreStateMachine::syncState stateService stop
Feb 15 07:09:48 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:48 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:48 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:48 opera volumio[5537]: info: CoreStateMachine::stPlaybackTimer
Feb 15 07:09:48 opera volumio[5537]: info: ------------------------------ 19ms
Feb 15 07:09:48 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:48 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:48 opera volumio[5537]: info: CoreCommandRouter::volumioGetQueue
Feb 15 07:09:48 opera volumio[5537]: info: CoreStateMachine::getQueue
Feb 15 07:09:48 opera volumio[5537]: info: CorePlayQueue::getQueue
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:55 opera volumio[5537]: verbose: In UPNP mode
Feb 15 07:09:55 opera volumio[5537]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received airplay_emulation
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:55 opera volumio[5537]: verbose: In UPNP mode
Feb 15 07:09:55 opera volumio[5537]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received airplay_emulation
Feb 15 07:09:55 opera shairport-sync[14485]: Failed to create secure directory (/home/shairport-sync/.config/pulse): No such file or directory
Feb 15 07:09:55 opera shairport-sync[14485]: % Total % Received % Xferd Average Speed % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:09:55 opera shairport-sync[14485]: Dload Upload Total Spent Left Speed
Feb 15 07:09:55 opera volumio[5537]: info:
Feb 15 07:09:55 opera volumio[5537]: ---------------------------- Client requests Start Airplay PlaybackRoutine
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback
Feb 15 07:09:55 opera volumio[5537]: info: Airplay playback start
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::volumioStop
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::stop
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:55 opera volumio[5537]: verbose: UNSET VOLATILE
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:55 opera shairport-sync[14485]: [173B blob data]
Feb 15 07:09:55 opera volumio[5537]: info: Airplay started streaming, receiving metadatas
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::volumioStop
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::stop
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:55 opera volumio[5537]: verbose: UNSET VOLATILE
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:55 opera volumio[5537]: info: Airplay started streaming, receiving metadatas
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::volumioStop
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::stop
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:55 opera volumio[5537]: verbose: UNSET VOLATILE
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 15 07:09:55 opera shairport-sync[14485]: {"time":1739603395203,"response":"startAirplayPlayback Success"} Time Current
Feb 15 07:09:55 opera shairport-sync[14485]: Dload Upload Total Spent Left Speed
Feb 15 07:09:55 opera shairport-sync[14485]: [155B blob data]
Feb 15 07:09:55 opera volumio[5537]: info:
Feb 15 07:09:55 opera volumio[5537]: ---------------------------- Client requests AirplayActive
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , setAirplayActive
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":null,"duration":null,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:55 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus stop
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"airplay","seek":null,"duration":null,"samplerate":"","bitdepth":"","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:55 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:55 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:55 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:55 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:55 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Baptized In Fear","artist":"Yeah yeah yeah ooh","album":"","albumart":"/albumart?cacheid=367&web=Yeah%20yeah%20yeah%20ooh//extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":null,"duration":null,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:55 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:55 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: verbose: STATE SERVICE {"status":"play","service":"airplay_emulation","title":"Baptized In Fear","artist":"Yeah yeah yeah ooh","album":"","albumart":"/albumart?cacheid=367&web=Yeah%20yeah%20yeah%20ooh//extralarge&path=&metadata=false","uri":"","trackType":"airplay","seek":null,"duration":null,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"disableUiControls":true,"stream":false,"repeatMode":"all"}
Feb 15 07:09:55 opera volumio[5537]: verbose: CURRENT POSITION 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::syncState stateService play
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::syncState currentStatus play
Feb 15 07:09:55 opera volumio[5537]: info: Received an update from plugin. extracting info from payload
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:55 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:55 opera volumio[5537]: info: CorePlayQueue::getTrack 0
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:55 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:55 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:55 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:55 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:55 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:56 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:56 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:56 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:56 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:56 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:56 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:56 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:56 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:56 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:56 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:56 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:56 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:56 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:56 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:56 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:59 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:59 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:09:59 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:09:59 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:09:59 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:03 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:03 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:03 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:03 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:03 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:12 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:12 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:12 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:12 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:12 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:19 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:19 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:19 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:19 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:19 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:23 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:23 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:23 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:23 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:23 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:25 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:25 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:25 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:25 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:25 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:27 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:27 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:29 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:29 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:31 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:31 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:31 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:31 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:31 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:33 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:33 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:33 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:33 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:33 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:35 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:35 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:35 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:35 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:35 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:37 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:37 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:37 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:37 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:37 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:38 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:38 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:38 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:38 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:38 opera volumio[5537]: info: CoreCommandRouter::servicePushState
Feb 15 07:10:38 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:38 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:38 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:38 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:38 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:38 opera shairport-sync[14485]: {"time":1739603395213,"response":"airplayActive Success"} % Total % Received % Xferd Average Speed Time Time Time Current
Feb 15 07:10:38 opera shairport-sync[14485]: Dload Upload Total Spent Left Speed
Feb 15 07:10:38 opera volumio[5537]: info:
Feb 15 07:10:38 opera volumio[5537]: ---------------------------- Client requests Stop Airplay Playback
Feb 15 07:10:38 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback
Feb 15 07:10:38 opera volumio[5537]: info: Airplay playback stop
Feb 15 07:10:38 opera volumio[5537]: info: Airplay Playback Stopped, clearing state
Feb 15 07:10:38 opera volumio[5537]: info: CoreStateMachine::resetVolumioState
Feb 15 07:10:38 opera volumio[5537]: info: CoreStateMachine::getcurrentVolume
Feb 15 07:10:38 opera volumio[5537]: info: CoreCommandRouter::volumioRetrievevolume
Feb 15 07:10:38 opera shairport-sync[14485]: [155B blob data]
Feb 15 07:10:38 opera volumio[5537]: info: CoreStateMachine::pushState
Feb 15 07:10:38 opera volumio[5537]: info: CoreCommandRouter::volumioPushState
Feb 15 07:10:38 opera volumio[5537]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 15 07:10:38 opera volumio[5537]: info: Updating RAAT Signal Path
Feb 15 07:10:46 opera volumio[5537]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 15 07:10:46 opera volumio[5537]: { Error: connect ETIMEDOUT 104.244.46.71:443
Feb 15 07:10:46 opera volumio[5537]: at Object._errnoException (util.js:1022:11)
Feb 15 07:10:46 opera volumio[5537]: at _exceptionWithHostPort (util.js:1044:20)
Feb 15 07:10:46 opera volumio[5537]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Feb 15 07:10:46 opera volumio[5537]: code: 'ETIMEDOUT',
Feb 15 07:10:46 opera volumio[5537]: errno: 'ETIMEDOUT',
Feb 15 07:10:46 opera volumio[5537]: syscall: 'connect',
Feb 15 07:10:46 opera volumio[5537]: address: '104.244.46.71',
Feb 15 07:10:46 opera volumio[5537]: port: 443 }
Feb 15 07:10:46 opera volumio[5537]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 15 07:10:46 opera sudo[14882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-15 07:09
Feb 15 07:10:46 opera sudo[14882]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828"
VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="opera"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022"
VOLUMIO_VERSION="1.033"
VOLUMIO_HARDWARE="tinkerboard"
VOLUMIO_VENDOR="Opera Consonance"
VOLUMIO_MODEL="X5"
VOLUMIO_VENDOR_MODEL="Opera X5"
VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"