-- Logs begin at Tue 2024-11-26 10:50:17 UTC, end at Tue 2024-11-26 11:14:56 UTC. -- Nov 26 11:13:15 opera dhcpd[1429]: DHCPDISCOVER from 48:e7:da:4e:ef:61 (opera) via wlan0 Nov 26 11:13:16 opera dhcpd[1429]: DHCPOFFER on 192.168.211.4 to 48:e7:da:4e:ef:61 (opera) via wlan0 Nov 26 11:13:57 opera volumio[2403]: info: CoreCommandRouter::volumioNext Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::next Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::stop Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:13:57 opera volumio[2403]: verbose: UNSET VOLATILE Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::stPlaybackTimer Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::updateTrackBlock Nov 26 11:13:57 opera volumio[2403]: info: CorePlayQueue::getTrackBlock Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:13:57 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:13:57 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:13:57 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::serviceStop Nov 26 11:13:57 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:13:57 opera volumio[2403]: info: CoreCommandRouter::serviceStop Nov 26 11:13:57 opera volumio[2403]: info: ControllerMpd::stop Nov 26 11:13:57 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 11:13:57 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:13:57 opera volumio[2403]: info: sendMpdCommand stop took 44 milliseconds Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::play index undefined Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:13:57 opera volumio[2403]: info: CorePlayQueue::getTrack 1 Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::startPlaybackTimer Nov 26 11:13:57 opera volumio[2403]: info: CorePlayQueue::getTrack 1 Nov 26 11:13:57 opera volumio[2403]: verbose: ControllerMpd::clearAddPlayTracks USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/002-J.S.バッハ：アルマンド(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より).dsf Nov 26 11:13:57 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 11:13:57 opera volumio[2403]: info: CoreStateMachine::updateTrackBlock Nov 26 11:13:57 opera volumio[2403]: info: CorePlayQueue::getTrackBlock Nov 26 11:13:57 opera volumio[2403]: info: Nov 26 11:13:57 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:13:57 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:13:57 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:13:57 opera volumio[2403]: info: sendMpdCommand stop took 3 milliseconds Nov 26 11:13:57 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 11:13:57 opera volumio[2403]: info: Nov 26 11:13:57 opera volumio[2403]: ---------------------------- MPD announces system playlist update Nov 26 11:13:57 opera volumio[2403]: info: Ignoring MPD Status Update Nov 26 11:13:57 opera volumio[2403]: info: sendMpdCommand status took 4 milliseconds Nov 26 11:13:57 opera volumio[2403]: info: sendMpdCommand clear took 3 milliseconds Nov 26 11:13:57 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:13:57 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:13:57 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand add "USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/002-J.S.バッハ：アルマンド(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より).dsf" Nov 26 11:13:57 opera volumio[2403]: error: updateQueue error: null Nov 26 11:13:57 opera volumio[2403]: info: Nov 26 11:13:57 opera volumio[2403]: ---------------------------- MPD announces system playlist update Nov 26 11:13:57 opera volumio[2403]: info: Ignoring MPD Status Update Nov 26 11:13:57 opera volumio[2403]: info: ------------------------------ 4ms Nov 26 11:13:57 opera volumio[2403]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 11:13:57 opera volumio[2403]: info: sendMpdCommand add "USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/002-J.S.バッハ：アルマンド(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より).dsf" took 2 milliseconds Nov 26 11:13:57 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:13:57 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand play Nov 26 11:13:57 opera volumio[2403]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 26 11:13:57 opera volumio[2403]: info: ------------------------------ 10ms Nov 26 11:13:57 opera volumio[2403]: info: ------------------------------ 4ms Nov 26 11:13:57 opera volumio[2403]: info: sendMpdCommand play took 2 milliseconds Nov 26 11:13:58 opera volumio[2403]: info: Nov 26 11:13:58 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:13:58 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:13:58 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:13:58 opera volumio[2403]: info: sendMpdCommand status took 3 milliseconds Nov 26 11:13:58 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:13:58 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:13:58 opera volumio[2403]: info: Nov 26 11:13:58 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:13:58 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:13:58 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:13:58 opera volumio[2403]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 11:13:58 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:13:58 opera volumio[2403]: info: ControllerMpd::pushState Nov 26 11:13:58 opera volumio[2403]: info: CoreCommandRouter::servicePushState Nov 26 11:13:58 opera volumio[2403]: info: CorePlayQueue::getTrack 1 Nov 26 11:13:58 opera volumio[2403]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":147,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"J.S.バッハ：アルマンド(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より)","artist":"木ノ脇道元(フルート)","album":"\"美オト Be-oto\"Special Selection vol.1","uri":"USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/002-J.S.バッハ：アルマンド(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より).dsf","trackType":"dsf"} Nov 26 11:13:58 opera volumio[2403]: verbose: CURRENT POSITION 1 Nov 26 11:13:58 opera volumio[2403]: info: CoreStateMachine::syncState stateService play Nov 26 11:13:58 opera volumio[2403]: info: CoreStateMachine::syncState currentStatus stop Nov 26 11:13:58 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:13:58 opera volumio[2403]: info: CorePlayQueue::getTrack 1 Nov 26 11:13:58 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:13:58 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:13:58 opera volumio[2403]: info: ------------------------------ 30ms Nov 26 11:13:58 opera volumio[2403]: info: sendMpdCommand status took 27 milliseconds Nov 26 11:13:58 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:13:58 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:13:58 opera volumio[2403]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 26 11:13:58 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:13:58 opera volumio[2403]: info: ControllerMpd::pushState Nov 26 11:13:58 opera volumio[2403]: info: CoreCommandRouter::servicePushState Nov 26 11:13:58 opera volumio[2403]: info: CorePlayQueue::getTrack 1 Nov 26 11:13:58 opera volumio[2403]: verbose: STATE SERVICE {"status":"play","position":0,"seek":162,"duration":147,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"J.S.バッハ：アルマンド(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より)","artist":"木ノ脇道元(フルート)","album":"\"美オト Be-oto\"Special Selection vol.1","uri":"USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/002-J.S.バッハ：アルマンド(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より).dsf","trackType":"dsf"} Nov 26 11:13:58 opera volumio[2403]: verbose: CURRENT POSITION 1 Nov 26 11:13:58 opera volumio[2403]: info: CoreStateMachine::syncState stateService play Nov 26 11:13:58 opera volumio[2403]: info: CoreStateMachine::syncState currentStatus play Nov 26 11:13:58 opera volumio[2403]: info: Received an update from plugin. extracting info from payload Nov 26 11:13:58 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:13:58 opera volumio[2403]: info: CorePlayQueue::getTrack 1 Nov 26 11:13:58 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:13:58 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:13:58 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:13:58 opera volumio[2403]: info: CorePlayQueue::getTrack 1 Nov 26 11:13:58 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:13:58 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:13:58 opera volumio[2403]: info: ------------------------------ 60ms Nov 26 11:13:58 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:13:58 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:13:58 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::volumioNext Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::next Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::stop Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:05 opera volumio[2403]: verbose: UNSET VOLATILE Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::stPlaybackTimer Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::updateTrackBlock Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrackBlock Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 1 Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::serviceStop Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 1 Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::serviceStop Nov 26 11:14:05 opera volumio[2403]: info: ControllerMpd::stop Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 11:14:05 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:05 opera volumio[2403]: info: Nov 26 11:14:05 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand stop took 11 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::play index undefined Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 2 Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::startPlaybackTimer Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 2 Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::clearAddPlayTracks USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/003-J.S.バッハ：ジーグ(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より).dsf Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::updateTrackBlock Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrackBlock Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand status took 6 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand stop took 4 milliseconds Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 11:14:05 opera volumio[2403]: info: Nov 26 11:14:05 opera volumio[2403]: ---------------------------- MPD announces system playlist update Nov 26 11:14:05 opera volumio[2403]: info: Ignoring MPD Status Update Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand clear took 3 milliseconds Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand add "USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/003-J.S.バッハ：ジーグ(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より).dsf" Nov 26 11:14:05 opera volumio[2403]: info: ControllerMpd::pushState Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::servicePushState Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 2 Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 2 Nov 26 11:14:05 opera volumio[2403]: 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":"J.S.バッハ：アルマンド(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より)","artist":"木ノ脇道元(フルート)","album":"\"美オト Be-oto\"Special Selection vol.1","uri":"USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/002-J.S.バッハ：アルマンド(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より).dsf","trackType":"dsf"} Nov 26 11:14:05 opera volumio[2403]: verbose: CURRENT POSITION 2 Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::syncState stateService stop Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::syncState currentStatus stop Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 2 Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:05 opera volumio[2403]: info: No code Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 2 Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:05 opera volumio[2403]: info: ------------------------------ 29ms Nov 26 11:14:05 opera volumio[2403]: error: updateQueue error: null Nov 26 11:14:05 opera volumio[2403]: info: Nov 26 11:14:05 opera volumio[2403]: ---------------------------- MPD announces system playlist update Nov 26 11:14:05 opera volumio[2403]: info: Ignoring MPD Status Update Nov 26 11:14:05 opera volumio[2403]: info: ------------------------------ 22ms Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand add "USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/003-J.S.バッハ：ジーグ(「無伴奏ヴァイオリンのためのパルティータ第2番ニ短調 BWV1004」より).dsf" took 21 milliseconds Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand play Nov 26 11:14:05 opera volumio[2403]: info: ------------------------------ 5ms Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand play took 5 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:05 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:05 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::volumioNext Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::next Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::stop Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:05 opera volumio[2403]: verbose: UNSET VOLATILE Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::play index undefined Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 3 Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::startPlaybackTimer Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 3 Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::clearAddPlayTracks USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/004-ドビュッシー：シリンクス.dsf Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::updateTrackBlock Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrackBlock Nov 26 11:14:05 opera volumio[2403]: info: Nov 26 11:14:05 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:05 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:05 opera volumio[2403]: info: Nov 26 11:14:05 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand stop took 26 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 11:14:05 opera volumio[2403]: info: Nov 26 11:14:05 opera volumio[2403]: ---------------------------- MPD announces system playlist update Nov 26 11:14:05 opera volumio[2403]: info: Ignoring MPD Status Update Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand status took 22 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand status took 3 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand clear took 2 milliseconds Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand add "USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/004-ドビュッシー：シリンクス.dsf" Nov 26 11:14:05 opera volumio[2403]: error: updateQueue error: null Nov 26 11:14:05 opera volumio[2403]: info: Nov 26 11:14:05 opera volumio[2403]: ---------------------------- MPD announces system playlist update Nov 26 11:14:05 opera volumio[2403]: info: Ignoring MPD Status Update Nov 26 11:14:05 opera volumio[2403]: info: ------------------------------ 6ms Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand add "USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/004-ドビュッシー：シリンクス.dsf" took 3 milliseconds Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand play Nov 26 11:14:05 opera volumio[2403]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 26 11:14:05 opera volumio[2403]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 26 11:14:05 opera volumio[2403]: info: ------------------------------ 32ms Nov 26 11:14:05 opera volumio[2403]: info: ------------------------------ 12ms Nov 26 11:14:05 opera volumio[2403]: info: ------------------------------ 5ms Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand play took 2 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: Nov 26 11:14:05 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:05 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:05 opera volumio[2403]: info: Nov 26 11:14:05 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand status took 4 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand status took 3 milliseconds Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:05 opera volumio[2403]: info: ControllerMpd::pushState Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::servicePushState Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 3 Nov 26 11:14:05 opera volumio[2403]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ドビュッシー：シリンクス","artist":"木ノ脇道元(フルート)","album":"\"美オト Be-oto\"Special Selection vol.1","uri":"USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/004-ドビュッシー：シリンクス.dsf","trackType":"dsf"} Nov 26 11:14:05 opera volumio[2403]: verbose: CURRENT POSITION 3 Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::syncState stateService play Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::syncState currentStatus stop Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 3 Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:05 opera volumio[2403]: info: ------------------------------ 19ms Nov 26 11:14:05 opera volumio[2403]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 26 11:14:05 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:05 opera volumio[2403]: info: ControllerMpd::pushState Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::servicePushState Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 3 Nov 26 11:14:05 opera volumio[2403]: verbose: STATE SERVICE {"status":"play","position":0,"seek":368,"duration":184,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"ドビュッシー：シリンクス","artist":"木ノ脇道元(フルート)","album":"\"美オト Be-oto\"Special Selection vol.1","uri":"USB/Elements/DSD/dsd128/_美オト Be-oto_Special Selection vol.1/004-ドビュッシー：シリンクス.dsf","trackType":"dsf"} Nov 26 11:14:05 opera volumio[2403]: verbose: CURRENT POSITION 3 Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::syncState stateService play Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::syncState currentStatus play Nov 26 11:14:05 opera volumio[2403]: info: Received an update from plugin. extracting info from payload Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 3 Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:05 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:05 opera volumio[2403]: info: CorePlayQueue::getTrack 3 Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:05 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:05 opera volumio[2403]: info: ------------------------------ 32ms Nov 26 11:14:05 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:05 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:05 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::ClearQueue Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::stop Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:09 opera volumio[2403]: verbose: UNSET VOLATILE Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::stPlaybackTimer Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::updateTrackBlock Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrackBlock Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrack 3 Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::serviceStop Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrack 3 Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::serviceStop Nov 26 11:14:09 opera volumio[2403]: info: ControllerMpd::stop Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::clearPlayQueue Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::saveQueue Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::volumioPushQueue Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::addQueueItems Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::addQueueItems Nov 26 11:14:09 opera volumio[2403]: info: Adding Item to queue: albums://Karl-Andreas%20Kolly/J.S.BACH%3A%20Inventionen%20und%20Sinfonien Nov 26 11:14:09 opera volumio[2403]: info: Exploding uri albums://Karl-Andreas%20Kolly/J.S.BACH%3A%20Inventionen%20und%20Sinfonien in service mpd Nov 26 11:14:09 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:09 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::saveQueue Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::volumioPushQueue Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::updateTrackBlock Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrackBlock Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::volumioPlay Nov 26 11:14:09 opera volumio[2403]: verbose: UNSET VOLATILE Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::play index 0 Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::stop Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:09 opera volumio[2403]: verbose: UNSET VOLATILE Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::play index undefined Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::startPlaybackTimer Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::clearAddPlayTracks USB/Elements/DSD/dsd128/【SONY·DSD】Karl-Andreas Kolly - 巴赫：二部创意曲和三部创意曲【2018】[DSD128]/01.Inventionen No.1 C-Dur BWV 772.dsf Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 11:14:09 opera volumio[2403]: info: Nov 26 11:14:09 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand stop took 114 milliseconds Nov 26 11:14:09 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand stop took 71 milliseconds Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 11:14:09 opera volumio[2403]: info: Nov 26 11:14:09 opera volumio[2403]: ---------------------------- MPD announces system playlist update Nov 26 11:14:09 opera volumio[2403]: info: Ignoring MPD Status Update Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand status took 6 milliseconds Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand clear took 4 milliseconds Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand add "USB/Elements/DSD/dsd128/【SONY·DSD】Karl-Andreas Kolly - 巴赫：二部创意曲和三部创意曲【2018】[DSD128]/01.Inventionen No.1 C-Dur BWV 772.dsf" Nov 26 11:14:09 opera volumio[2403]: error: updateQueue error: null Nov 26 11:14:09 opera volumio[2403]: info: Nov 26 11:14:09 opera volumio[2403]: ---------------------------- MPD announces system playlist update Nov 26 11:14:09 opera volumio[2403]: info: Ignoring MPD Status Update Nov 26 11:14:09 opera volumio[2403]: info: ------------------------------ 12ms Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand add "USB/Elements/DSD/dsd128/【SONY·DSD】Karl-Andreas Kolly - 巴赫：二部创意曲和三部创意曲【2018】[DSD128]/01.Inventionen No.1 C-Dur BWV 772.dsf" took 9 milliseconds Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand play Nov 26 11:14:09 opera volumio[2403]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 26 11:14:09 opera volumio[2403]: info: ------------------------------ 29ms Nov 26 11:14:09 opera volumio[2403]: info: ------------------------------ 14ms Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand play took 5 milliseconds Nov 26 11:14:09 opera volumio[2403]: info: Nov 26 11:14:09 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:09 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:09 opera volumio[2403]: info: Nov 26 11:14:09 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:09 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand status took 3 milliseconds Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand status took 3 milliseconds Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 26 11:14:09 opera volumio[2403]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:09 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:09 opera volumio[2403]: info: ControllerMpd::pushState Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::servicePushState Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:09 opera volumio[2403]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104,"duration":78,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Inventionen No.1: C-Dur BWV 772","artist":"Karl-Andreas Kolly","album":"J.S.BACH: Inventionen und Sinfonien","uri":"USB/Elements/DSD/dsd128/【SONY·DSD】Karl-Andreas Kolly - 巴赫：二部创意曲和三部创意曲【2018】[DSD128]/01.Inventionen No.1 C-Dur BWV 772.dsf","trackType":"dsf"} Nov 26 11:14:09 opera volumio[2403]: verbose: CURRENT POSITION 0 Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::syncState stateService play Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::syncState currentStatus stop Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:09 opera volumio[2403]: info: ControllerMpd::pushState Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::servicePushState Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:09 opera volumio[2403]: verbose: STATE SERVICE {"status":"play","position":0,"seek":206,"duration":78,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Inventionen No.1: C-Dur BWV 772","artist":"Karl-Andreas Kolly","album":"J.S.BACH: Inventionen und Sinfonien","uri":"USB/Elements/DSD/dsd128/【SONY·DSD】Karl-Andreas Kolly - 巴赫：二部创意曲和三部创意曲【2018】[DSD128]/01.Inventionen No.1 C-Dur BWV 772.dsf","trackType":"dsf"} Nov 26 11:14:09 opera volumio[2403]: verbose: CURRENT POSITION 0 Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::syncState stateService play Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::syncState currentStatus play Nov 26 11:14:09 opera volumio[2403]: info: Received an update from plugin. extracting info from payload Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:09 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:09 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:09 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:09 opera volumio[2403]: info: ------------------------------ 41ms Nov 26 11:14:09 opera volumio[2403]: info: ------------------------------ 38ms Nov 26 11:14:09 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:09 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:09 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:20 opera dhcpd[1429]: DHCPDISCOVER from 48:e7:da:4e:ef:61 (opera) via wlan0 Nov 26 11:14:21 opera dhcpd[1429]: DHCPOFFER on 192.168.211.4 to 48:e7:da:4e:ef:61 (opera) via wlan0 Nov 26 11:14:47 opera volumio[2403]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Adele/19/f5800fca-15db-4644-9820-f1fa7e643bbd.jpg' Nov 26 11:14:47 opera volumio[2403]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eagles/Hotel%20California/ee54e88b-11ed-44d4-b0a5-098aff85c1c9.jpg' Nov 26 11:14:54 opera volumio[2403]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::ClearQueue Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::stop Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:54 opera volumio[2403]: verbose: UNSET VOLATILE Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::stPlaybackTimer Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::updateTrackBlock Nov 26 11:14:54 opera volumio[2403]: info: CorePlayQueue::getTrackBlock Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:54 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:54 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:54 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::serviceStop Nov 26 11:14:54 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:54 opera volumio[2403]: info: CoreCommandRouter::serviceStop Nov 26 11:14:54 opera volumio[2403]: info: ControllerMpd::stop Nov 26 11:14:54 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 11:14:54 opera volumio[2403]: info: CorePlayQueue::clearPlayQueue Nov 26 11:14:54 opera volumio[2403]: info: CorePlayQueue::saveQueue Nov 26 11:14:54 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:54 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:54 opera volumio[2403]: info: CoreCommandRouter::volumioPushQueue Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::addQueueItems Nov 26 11:14:54 opera volumio[2403]: info: CorePlayQueue::addQueueItems Nov 26 11:14:54 opera volumio[2403]: info: Adding Item to queue: albums://Yasuhiro%20Otsuka%2C%20Cloverbellfriens%2C%20Jun-ichi%20Ozawa%2C%20Andante%2C%20Alfa/66%20tones%20English%20Handbell%20Works Nov 26 11:14:54 opera volumio[2403]: info: Exploding uri albums://Yasuhiro%20Otsuka%2C%20Cloverbellfriens%2C%20Jun-ichi%20Ozawa%2C%20Andante%2C%20Alfa/66%20tones%20English%20Handbell%20Works in service mpd Nov 26 11:14:54 opera volumio[2403]: info: CorePlayQueue::saveQueue Nov 26 11:14:54 opera volumio[2403]: info: CoreCommandRouter::volumioPushQueue Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::updateTrackBlock Nov 26 11:14:54 opera volumio[2403]: info: CorePlayQueue::getTrackBlock Nov 26 11:14:54 opera volumio[2403]: info: CoreCommandRouter::volumioPlay Nov 26 11:14:54 opera volumio[2403]: verbose: UNSET VOLATILE Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::play index 0 Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::stop Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:54 opera volumio[2403]: verbose: UNSET VOLATILE Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::play index undefined Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 26 11:14:54 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:54 opera volumio[2403]: info: CoreStateMachine::startPlaybackTimer Nov 26 11:14:54 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:54 opera volumio[2403]: verbose: ControllerMpd::clearAddPlayTracks USB/Elements/DSD/dsd128/66声手摇铃作品集（5.6MHz DSD）/01.Water Music.dsf Nov 26 11:14:54 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand stop Nov 26 11:14:54 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:54 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:54 opera volumio[2403]: info: Nov 26 11:14:54 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:54 opera volumio[2403]: info: sendMpdCommand stop took 88 milliseconds Nov 26 11:14:54 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:54 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:54 opera volumio[2403]: info: sendMpdCommand stop took 68 milliseconds Nov 26 11:14:54 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand clear Nov 26 11:14:54 opera volumio[2403]: info: sendMpdCommand status took 3 milliseconds Nov 26 11:14:54 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:54 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:54 opera volumio[2403]: info: Nov 26 11:14:54 opera volumio[2403]: ---------------------------- MPD announces system playlist update Nov 26 11:14:54 opera volumio[2403]: info: Ignoring MPD Status Update Nov 26 11:14:54 opera volumio[2403]: info: sendMpdCommand clear took 3 milliseconds Nov 26 11:14:54 opera volumio[2403]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 11:14:54 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand add "USB/Elements/DSD/dsd128/66声手摇铃作品集（5.6MHz DSD）/01.Water Music.dsf" Nov 26 11:14:54 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:54 opera volumio[2403]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 26 11:14:54 opera volumio[2403]: info: ------------------------------ 9ms Nov 26 11:14:54 opera volumio[2403]: error: updateQueue error: null Nov 26 11:14:54 opera volumio[2403]: info: Nov 26 11:14:54 opera volumio[2403]: ---------------------------- MPD announces system playlist update Nov 26 11:14:54 opera volumio[2403]: info: Ignoring MPD Status Update Nov 26 11:14:54 opera volumio[2403]: info: ------------------------------ 4ms Nov 26 11:14:54 opera volumio[2403]: info: sendMpdCommand add "USB/Elements/DSD/dsd128/66声手摇铃作品集（5.6MHz DSD）/01.Water Music.dsf" took 4 milliseconds Nov 26 11:14:54 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand play Nov 26 11:14:54 opera volumio[2403]: info: ------------------------------ 2ms Nov 26 11:14:54 opera volumio[2403]: info: sendMpdCommand play took 2 milliseconds Nov 26 11:14:55 opera volumio[2403]: info: Nov 26 11:14:55 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:55 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:55 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:55 opera volumio[2403]: info: Nov 26 11:14:55 opera volumio[2403]: ---------------------------- MPD announces state update: player Nov 26 11:14:55 opera volumio[2403]: info: sendMpdCommand status took 4 milliseconds Nov 26 11:14:55 opera volumio[2403]: info: ControllerMpd::getState Nov 26 11:14:55 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand status Nov 26 11:14:55 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:55 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:55 opera volumio[2403]: info: sendMpdCommand status took 4 milliseconds Nov 26 11:14:55 opera volumio[2403]: verbose: ControllerMpd::parseState Nov 26 11:14:55 opera volumio[2403]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 11:14:55 opera volumio[2403]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 26 11:14:55 opera volumio[2403]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 26 11:14:55 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:55 opera volumio[2403]: verbose: ControllerMpd::parseTrackInfo Nov 26 11:14:55 opera volumio[2403]: info: ControllerMpd::pushState Nov 26 11:14:55 opera volumio[2403]: info: CoreCommandRouter::servicePushState Nov 26 11:14:55 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:55 opera volumio[2403]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":205,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Water Music","artist":"Yasuhiro Otsuka, Cloverbellfriends","album":"66 tones English Handbell Works","uri":"USB/Elements/DSD/dsd128/66声手摇铃作品集（5.6MHz DSD）/01.Water Music.dsf","trackType":"dsf"} Nov 26 11:14:55 opera volumio[2403]: verbose: CURRENT POSITION 0 Nov 26 11:14:55 opera volumio[2403]: info: CoreStateMachine::syncState stateService play Nov 26 11:14:55 opera volumio[2403]: info: CoreStateMachine::syncState currentStatus stop Nov 26 11:14:55 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:55 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:55 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:55 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:55 opera volumio[2403]: info: ControllerMpd::pushState Nov 26 11:14:55 opera volumio[2403]: info: CoreCommandRouter::servicePushState Nov 26 11:14:55 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:55 opera volumio[2403]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2,"duration":205,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Water Music","artist":"Yasuhiro Otsuka, Cloverbellfriends","album":"66 tones English Handbell Works","uri":"USB/Elements/DSD/dsd128/66声手摇铃作品集（5.6MHz DSD）/01.Water Music.dsf","trackType":"dsf"} Nov 26 11:14:55 opera volumio[2403]: verbose: CURRENT POSITION 0 Nov 26 11:14:55 opera volumio[2403]: info: CoreStateMachine::syncState stateService play Nov 26 11:14:55 opera volumio[2403]: info: CoreStateMachine::syncState currentStatus play Nov 26 11:14:55 opera volumio[2403]: info: Received an update from plugin. extracting info from payload Nov 26 11:14:55 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:55 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:55 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:55 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:55 opera volumio[2403]: info: CoreStateMachine::pushState Nov 26 11:14:55 opera volumio[2403]: info: CorePlayQueue::getTrack 0 Nov 26 11:14:55 opera volumio[2403]: info: CoreCommandRouter::volumioPushState Nov 26 11:14:55 opera volumio[2403]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 11:14:55 opera volumio[2403]: info: ------------------------------ 51ms Nov 26 11:14:55 opera volumio[2403]: info: ------------------------------ 46ms Nov 26 11:14:55 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:55 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:55 opera volumio[2403]: info: Updating RAAT Signal Path Nov 26 11:14:55 opera volumio[2403]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 11:14:55 opera volumio[2403]: { Error: connect ETIMEDOUT 69.63.184.30:443 Nov 26 11:14:55 opera volumio[2403]: at Object._errnoException (util.js:1022:11) Nov 26 11:14:55 opera volumio[2403]: at _exceptionWithHostPort (util.js:1044:20) Nov 26 11:14:55 opera volumio[2403]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Nov 26 11:14:55 opera volumio[2403]: code: 'ETIMEDOUT', Nov 26 11:14:55 opera volumio[2403]: errno: 'ETIMEDOUT', Nov 26 11:14:55 opera volumio[2403]: syscall: 'connect', Nov 26 11:14:55 opera volumio[2403]: address: '69.63.184.30', Nov 26 11:14:55 opera volumio[2403]: port: 443 } Nov 26 11:14:55 opera volumio[2403]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 11:14:56 opera sudo[5736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 11:13 Nov 26 11:14:56 opera sudo[5736]: 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"