-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Thu 2024-02-22 03:47:26 +07. -- Feb 22 03:46:04 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:46:10 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:46:10 volumio ntpd[652]: Soliciting pool server 2001:c38:2000:180:d82a:1aff:fe38:f84b Feb 22 03:46:10 volumio ntpd[652]: Soliciting pool server 203.113.174.44 Feb 22 03:46:10 volumio volumio[907]: info: VolumeController::SetAlsaVolume76 Feb 22 03:46:10 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:10 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:10 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:10 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:10 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Feb 22 03:46:10 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 71 Feb 22 03:46:10 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 76 Feb 22 03:46:10 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 22 03:46:10 volumio volumio[907]: info: Setting Spotify Volume from Volumio: 76 Feb 22 03:46:12 volumio ntpd[652]: Soliciting pool server 203.113.174.44 Feb 22 03:46:12 volumio volumio[907]: info: VolumeController::SetAlsaVolume82 Feb 22 03:46:12 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:12 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:12 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:12 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:12 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Feb 22 03:46:12 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 76 Feb 22 03:46:12 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 82 Feb 22 03:46:12 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 22 03:46:12 volumio volumio[907]: info: Setting Spotify Volume from Volumio: 82 Feb 22 03:46:13 volumio volumio[907]: SPOTIFY: SETTING SPOTIFY VOLUME 82 Feb 22 03:46:13 volumio volumio[907]: info: Sending Spotify command with payload to local API: /player/volume Feb 22 03:46:15 volumio ntpd[652]: Soliciting pool server 203.113.174.44 Feb 22 03:46:15 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:46:17 volumio volumio[907]: info: VolumeController::SetAlsaVolume96 Feb 22 03:46:17 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:17 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:17 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:17 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:17 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 96 Feb 22 03:46:17 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 82 Feb 22 03:46:17 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 96 Feb 22 03:46:17 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 22 03:46:17 volumio volumio[907]: info: Setting Spotify Volume from Volumio: 96 Feb 22 03:46:18 volumio volumio[907]: SPOTIFY: SETTING SPOTIFY VOLUME 96 Feb 22 03:46:18 volumio volumio[907]: info: Sending Spotify command with payload to local API: /player/volume Feb 22 03:46:21 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:46:21 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:21 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:21 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:21 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:21 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:21 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 95 Feb 22 03:46:21 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 96 Feb 22 03:46:21 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 95 Feb 22 03:46:21 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 22 03:46:21 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:21 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:21 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:21 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:21 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 94 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 96 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 94 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 22 03:46:22 volumio volumio[907]: info: Setting Spotify Volume from Volumio: 94 Feb 22 03:46:22 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:22 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:22 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:22 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:22 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 94 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 93 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 22 03:46:22 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:22 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:22 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:22 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:22 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 92 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 94 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 92 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 22 03:46:22 volumio volumio[907]: info: Setting Spotify Volume from Volumio: 92 Feb 22 03:46:22 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:22 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:22 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:22 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:22 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 91 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 92 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 91 Feb 22 03:46:22 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 22 03:46:23 volumio volumio[907]: SPOTIFY: SETTING SPOTIFY VOLUME 92 Feb 22 03:46:23 volumio volumio[907]: info: Sending Spotify command with payload to local API: /player/volume Feb 22 03:46:25 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:25 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:25 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:25 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:25 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:25 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90 Feb 22 03:46:25 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 92 Feb 22 03:46:25 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 90 Feb 22 03:46:25 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 22 03:46:25 volumio volumio[907]: info: Setting Spotify Volume from Volumio: 90 Feb 22 03:46:26 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:26 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:26 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:26 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:26 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:26 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:46:26 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 89 Feb 22 03:46:26 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 90 Feb 22 03:46:26 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 89 Feb 22 03:46:26 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 22 03:46:26 volumio volumio[907]: SPOTIFY: SETTING SPOTIFY VOLUME 90 Feb 22 03:46:26 volumio volumio[907]: info: Sending Spotify command with payload to local API: /player/volume Feb 22 03:46:27 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:27 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:27 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:27 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:27 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 88 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 90 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 88 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 22 03:46:27 volumio volumio[907]: info: Setting Spotify Volume from Volumio: 88 Feb 22 03:46:27 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:27 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:27 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:27 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:27 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 87 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 88 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 87 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 22 03:46:27 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:27 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:27 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:27 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:27 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 88 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 86 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 22 03:46:27 volumio volumio[907]: info: Setting Spotify Volume from Volumio: 86 Feb 22 03:46:27 volumio volumio[907]: info: VolumeController::SetAlsaVolume- Feb 22 03:46:27 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:27 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:27 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:27 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 85 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 86 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 85 Feb 22 03:46:27 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 22 03:46:28 volumio volumio[907]: SPOTIFY: SETTING SPOTIFY VOLUME 86 Feb 22 03:46:28 volumio volumio[907]: info: Sending Spotify command with payload to local API: /player/volume Feb 22 03:46:30 volumio volumio[907]: info: VolumeController::SetAlsaVolume60 Feb 22 03:46:30 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:30 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:30 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:30 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:30 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:30 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 86 Feb 22 03:46:30 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 60 Feb 22 03:46:30 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: true Feb 22 03:46:30 volumio volumio[907]: info: Setting Spotify Volume from Volumio: 60 Feb 22 03:46:32 volumio volumio[907]: SPOTIFY: SETTING SPOTIFY VOLUME 60 Feb 22 03:46:32 volumio volumio[907]: info: Sending Spotify command with payload to local API: /player/volume Feb 22 03:46:32 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioNext Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::next Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::stop Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::stPlaybackTimer Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::updateTrackBlock Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrackBlock Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::serviceStop Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 0 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::serviceStop Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::stop Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces state update: player Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand stop took 11 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::getState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::play index undefined Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::startPlaybackTimer Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC/Audio Space - Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)/02 - Phương Phương Thảo - Ga Chiều Phố Nhỏ.flac Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::updateTrackBlock Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrackBlock Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand status took 10 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand stop took 6 milliseconds Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand clear Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces state update: player Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::getState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces state update: player Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::getState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces system playlist update Feb 22 03:46:34 volumio volumio[907]: info: Ignoring MPD Status Update Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand clear took 10 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand status took 7 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand status took 5 milliseconds Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseTrackInfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC/Audio Space - Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)/02 - Phương Phương Thảo - Ga Chiều Phố Nhỏ.flac" Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseState Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::pushState Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::servicePushState Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: 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":"Một Mình","artist":"PHUONG PHUONG THAO - VINHSTUDIO - DAC & MUSIC WORLD","album":"Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)","uri":"USB/MUSIC/Audio Space - Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)/01 - Phương Phương Thảo - Một Mình.flac","trackType":"flac"} Feb 22 03:46:34 volumio volumio[907]: verbose: CURRENT POSITION 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState stateService stop Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus stop Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: No code Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::pushState Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::servicePushState Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 03:46:34 volumio volumio[907]: verbose: CURRENT POSITION 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState stateService stop Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus stop Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: No code Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::pushState Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::servicePushState Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 03:46:34 volumio volumio[907]: verbose: CURRENT POSITION 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState stateService stop Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus stop Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: No code Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 114ms Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 100ms Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 98ms Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces system playlist update Feb 22 03:46:34 volumio volumio[907]: info: Ignoring MPD Status Update Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces system playlist update Feb 22 03:46:34 volumio volumio[907]: info: Ignoring MPD Status Update Feb 22 03:46:34 volumio volumio[907]: error: updateQueue error: null Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces system playlist update Feb 22 03:46:34 volumio volumio[907]: info: Ignoring MPD Status Update Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 108ms Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand add "USB/MUSIC/Audio Space - Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)/02 - Phương Phương Thảo - Ga Chiều Phố Nhỏ.flac" took 103 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 12ms Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 10ms Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand play Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces system playlist update Feb 22 03:46:34 volumio volumio[907]: info: Ignoring MPD Status Update Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces system playlist update Feb 22 03:46:34 volumio volumio[907]: info: Ignoring MPD Status Update Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 13ms Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand play took 10 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 9ms Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 7ms Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces state update: player Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::getState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Feb 22 03:46:34 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces state update: player Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::getState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces state update: player Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::getState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces state update: player Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::getState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand status took 18 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand status took 11 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand status took 9 milliseconds Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces state update: player Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::getState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Feb 22 03:46:34 volumio volumio[907]: info: Feb 22 03:46:34 volumio volumio[907]: ---------------------------- MPD announces state update: player Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::getState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand status Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand status took 28 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand playlistinfo took 24 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand playlistinfo took 24 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand status took 10 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand status took 7 milliseconds Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseTrackInfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseTrackInfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseTrackInfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseState Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::pushState Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::servicePushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":360,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ga Chiều Phố Nhỏ","artist":"PHUONG PHUONG THAO - VINHSTUDIO - DAC & MUSIC WORLD","album":"Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)","uri":"USB/MUSIC/Audio Space - Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)/02 - Phương Phương Thảo - Ga Chiều Phố Nhỏ.flac","trackType":"flac"} Feb 22 03:46:34 volumio volumio[907]: verbose: CURRENT POSITION 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState stateService play Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus stop Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::pushState Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::servicePushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":360,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ga Chiều Phố Nhỏ","artist":"PHUONG PHUONG THAO - VINHSTUDIO - DAC & MUSIC WORLD","album":"Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)","uri":"USB/MUSIC/Audio Space - Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)/02 - Phương Phương Thảo - Ga Chiều Phố Nhỏ.flac","trackType":"flac"} Feb 22 03:46:34 volumio volumio[907]: verbose: CURRENT POSITION 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState stateService play Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus play Feb 22 03:46:34 volumio volumio[907]: info: Received an update from plugin. extracting info from payload Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::pushState Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::servicePushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":360,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ga Chiều Phố Nhỏ","artist":"PHUONG PHUONG THAO - VINHSTUDIO - DAC & MUSIC WORLD","album":"Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)","uri":"USB/MUSIC/Audio Space - Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)/02 - Phương Phương Thảo - Ga Chiều Phố Nhỏ.flac","trackType":"flac"} Feb 22 03:46:34 volumio volumio[907]: verbose: CURRENT POSITION 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState stateService play Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus play Feb 22 03:46:34 volumio volumio[907]: info: Received an update from plugin. extracting info from payload Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 88ms Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 102ms Feb 22 03:46:34 volumio volumio[907]: info: ------------------------------ 100ms Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand playlistinfo took 62 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand playlistinfo took 59 milliseconds Feb 22 03:46:34 volumio volumio[907]: info: sendMpdCommand playlistinfo took 59 milliseconds Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseTrackInfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseTrackInfo Feb 22 03:46:34 volumio volumio[907]: verbose: ControllerMpd::parseTrackInfo Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::pushState Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::servicePushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":360,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ga Chiều Phố Nhỏ","artist":"PHUONG PHUONG THAO - VINHSTUDIO - DAC & MUSIC WORLD","album":"Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)","uri":"USB/MUSIC/Audio Space - Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)/02 - Phương Phương Thảo - Ga Chiều Phố Nhỏ.flac","trackType":"flac"} Feb 22 03:46:34 volumio volumio[907]: verbose: CURRENT POSITION 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState stateService play Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus play Feb 22 03:46:34 volumio volumio[907]: info: Received an update from plugin. extracting info from payload Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::pushState Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::servicePushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":360,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1543 Kbps","isStreaming":false,"title":"Ga Chiều Phố Nhỏ","artist":"PHUONG PHUONG THAO - VINHSTUDIO - DAC & MUSIC WORLD","album":"Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)","uri":"USB/MUSIC/Audio Space - Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)/02 - Phương Phương Thảo - Ga Chiều Phố Nhỏ.flac","trackType":"flac"} Feb 22 03:46:34 volumio volumio[907]: verbose: CURRENT POSITION 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState stateService play Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus play Feb 22 03:46:34 volumio volumio[907]: info: Received an update from plugin. extracting info from payload Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: ControllerMpd::pushState Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::servicePushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":360,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1543 Kbps","isStreaming":false,"title":"Ga Chiều Phố Nhỏ","artist":"PHUONG PHUONG THAO - VINHSTUDIO - DAC & MUSIC WORLD","album":"Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)","uri":"USB/MUSIC/Audio Space - Phương Phương Thảo- Cho Người Tình Lỡ (24bit-MQA)/02 - Phương Phương Thảo - Ga Chiều Phố Nhỏ.flac","trackType":"flac"} Feb 22 03:46:34 volumio volumio[907]: verbose: CURRENT POSITION 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState stateService play Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::syncState currentStatus play Feb 22 03:46:34 volumio volumio[907]: info: Received an update from plugin. extracting info from payload Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:34 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:34 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:34 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:35 volumio volumio[907]: info: ------------------------------ 175ms Feb 22 03:46:35 volumio volumio[907]: info: ------------------------------ 155ms Feb 22 03:46:35 volumio volumio[907]: info: ------------------------------ 152ms Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:35 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Feb 22 03:46:38 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:46:42 volumio volumio[907]: info: VolumeController::SetAlsaVolume+ Feb 22 03:46:42 volumio volumio[907]: info: CoreStateMachine::pushState Feb 22 03:46:42 volumio volumio[907]: info: CorePlayQueue::getTrack 1 Feb 22 03:46:42 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 03:46:42 volumio volumio[907]: info: CoreCommandRouter::volumioPushState Feb 22 03:46:42 volumio volumio[907]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Feb 22 03:46:42 volumio volumio[907]: SPOTIFY: SPOTIFY VOLUME 60 Feb 22 03:46:42 volumio volumio[907]: SPOTIFY: VOLUMIO VOLUME 61 Feb 22 03:46:42 volumio volumio[907]: SPOTIFY: DELTA VOLUME ENOUGH: false Feb 22 03:46:43 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:46:49 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:46:51 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 22 03:46:51 volumio volumio[907]: info: CURURI: artists:// Feb 22 03:46:52 volumio volumio[907]: info: Preload queue cleared Feb 22 03:46:53 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 22 03:46:53 volumio volumio[907]: info: CURURI: artists://Ph%C6%B0%C6%A1ng%20Ph%C6%B0%C6%A1ng%20Th%E1%BA%A3o Feb 22 03:46:53 volumio volumio[907]: info: Preload queue cleared Feb 22 03:46:53 volumio volumio[907]: info: Preload queue cleared Feb 22 03:46:53 volumio volumio[907]: info: No valid Plugin REST Endpoint Feb 22 03:46:53 volumio volumio[907]: info: No valid Plugin REST Endpoint Feb 22 03:46:55 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:47:00 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 22 03:47:00 volumio volumio[907]: info: CURURI: albums:// Feb 22 03:47:00 volumio volumio[907]: info: listAlbums - loading Albums from cache Feb 22 03:47:00 volumio volumio[907]: info: Preload queue cleared Feb 22 03:47:00 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:47:06 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:47:07 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 22 03:47:07 volumio volumio[907]: info: Preload queue cleared Feb 22 03:47:09 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 22 03:47:09 volumio volumio[907]: info: Preload queue cleared Feb 22 03:47:11 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:47:13 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 22 03:47:13 volumio volumio[907]: info: Preload queue cleared Feb 22 03:47:15 volumio ntpd[652]: Soliciting pool server 2001:1490:0:800::43 Feb 22 03:47:15 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 22 03:47:15 volumio volumio[907]: info: Preload queue cleared Feb 22 03:47:15 volumio volumio[907]: info: Preloading song: upnp/http://192.168.0.102:8200/ctl/ContentDir@1$4$0 Feb 22 03:47:15 volumio volumio[907]: info: Preloading song: upnp/http://192.168.0.102:8200/ctl/ContentDir@1$4$1 Feb 22 03:47:15 volumio volumio[907]: info: Preloading song: upnp/http://192.168.0.102:8200/ctl/ContentDir@1$4$2 Feb 22 03:47:15 volumio volumio[907]: info: Preloading song: upnp/http://192.168.0.102:8200/ctl/ContentDir@1$4$3 Feb 22 03:47:15 volumio volumio[907]: info: Exploding uri upnp/http://192.168.0.102:8200/ctl/ContentDir@1$4$0 in service upnp_browser Feb 22 03:47:15 volumio volumio[907]: info: Exploding uri upnp/http://192.168.0.102:8200/ctl/ContentDir@1$4$1 in service upnp_browser Feb 22 03:47:15 volumio volumio[907]: info: Exploding uri upnp/http://192.168.0.102:8200/ctl/ContentDir@1$4$2 in service upnp_browser Feb 22 03:47:15 volumio volumio[907]: info: Exploding uri upnp/http://192.168.0.102:8200/ctl/ContentDir@1$4$3 in service upnp_browser Feb 22 03:47:16 volumio ntpd[652]: Soliciting pool server 103.130.217.41 Feb 22 03:47:17 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:47:18 volumio ntpd[652]: Soliciting pool server 103.130.217.41 Feb 22 03:47:21 volumio ntpd[652]: Soliciting pool server 103.130.217.41 Feb 22 03:47:23 volumio wpa_supplicant[744]: wlan0: Failed to initiate sched scan Feb 22 03:47:24 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 22 03:47:24 volumio volumio[907]: info: Preload queue cleared Feb 22 03:47:25 volumio volumio[907]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 22 03:47:25 volumio volumio[907]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 03:47:25 volumio volumio[907]: TypeError: Cannot read property 'length' of undefined Feb 22 03:47:25 volumio volumio[907]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Feb 22 03:47:25 volumio volumio[907]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Feb 22 03:47:25 volumio volumio[907]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Feb 22 03:47:25 volumio volumio[907]: at Parser.emit (events.js:315:20) Feb 22 03:47:25 volumio volumio[907]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Feb 22 03:47:25 volumio volumio[907]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Feb 22 03:47:25 volumio volumio[907]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Feb 22 03:47:25 volumio volumio[907]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Feb 22 03:47:25 volumio volumio[907]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Feb 22 03:47:25 volumio volumio[907]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Feb 22 03:47:25 volumio volumio[907]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Feb 22 03:47:25 volumio volumio[907]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Feb 22 03:47:25 volumio volumio[907]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Feb 22 03:47:25 volumio volumio[907]: at IncomingMessage.emit (events.js:327:22) Feb 22 03:47:25 volumio volumio[907]: at endReadableNT (internal/streams/readable.js:1327:12) Feb 22 03:47:25 volumio volumio[907]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Feb 22 03:47:25 volumio volumio[907]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 03:47:26 volumio sudo[1690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-02-22 03:46 Feb 22 03:47:26 volumio sudo[1690]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"