-- Logs begin at Thu 2024-11-21 14:59:56 UTC, end at Thu 2024-11-21 15:29:01 UTC. -- Nov 21 15:28:25 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 21 15:28:28 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 21 15:28:32 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 21 15:28:32 volumio volumio[6778]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Aimer/BEST%20SELECTION%20%22blanc%22/aab1613a-b66e-45ff-a73f-b49e90e7d6cd.jpg' Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::volumioAddQueueItems Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::addQueueItems Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::addQueueItems Nov 21 15:28:34 volumio volumio[6778]: info: Adding Item to queue: upnp/folder/http://192.168.31.1:8200/ctl/ContentDir@1$6$0$0 Nov 21 15:28:34 volumio volumio[6778]: info: Exploding uri upnp/folder/http://192.168.31.1:8200/ctl/ContentDir@1$6$0$0 in service upnp_browser Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::saveQueue Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::volumioPushQueue Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::updateTrackBlock Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::getTrackBlock Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::volumioPlay Nov 21 15:28:34 volumio volumio[6778]: verbose: UNSET VOLATILE Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::play index 51 Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::stop Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 15:28:34 volumio volumio[6778]: verbose: UNSET VOLATILE Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::updateTrackBlock Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::getTrackBlock Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::stPlaybackTimer Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::getTrack 50 Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::serviceStop Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::getTrack 50 Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::serviceStop Nov 21 15:28:34 volumio volumio[6778]: info: [1732202914717] ControllerUPNPBrowser::stop Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 15:28:34 volumio volumio[6778]: info: Nov 21 15:28:34 volumio volumio[6778]: ---------------------------- MPD announces state update: player Nov 21 15:28:34 volumio volumio[6778]: info: sendMpdCommand stop took 5 milliseconds Nov 21 15:28:34 volumio volumio[6778]: info: ControllerMpd::getState Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand status Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::play index undefined Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::getTrack 51 Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::startPlaybackTimer Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::getTrack 51 Nov 21 15:28:34 volumio volumio[6778]: info: [1732202914723] ControllerUPNPBrowser::clearAddPlayTrack Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 15:28:34 volumio volumio[6778]: info: sendMpdCommand status took 13 milliseconds Nov 21 15:28:34 volumio volumio[6778]: info: sendMpdCommand stop took 11 milliseconds Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::parseState Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand clear Nov 21 15:28:34 volumio volumio[6778]: info: Nov 21 15:28:34 volumio volumio[6778]: ---------------------------- MPD announces system playlist update Nov 21 15:28:34 volumio volumio[6778]: info: Ignoring MPD Status Update Nov 21 15:28:34 volumio volumio[6778]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 21 15:28:34 volumio volumio[6778]: info: sendMpdCommand clear took 5 milliseconds Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::parseTrackInfo Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.1:8200/MediaItems/44.wav" Nov 21 15:28:34 volumio volumio[6778]: info: ControllerMpd::pushState Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::servicePushState Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::getTrack 51 Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::getTrack 51 Nov 21 15:28:34 volumio volumio[6778]: 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":"BEYOND THE TIME ～メビウスの宇宙を超えて～ (Live)","artist":"Aimer","album":"機動戦士ガンダムユニコーン RE:0096 COMPLETE BEST","uri":"http://192.168.31.1:8200/MediaItems/30.flac","trackType":"flac"} Nov 21 15:28:34 volumio volumio[6778]: verbose: CURRENT POSITION 51 Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::syncState stateService stop Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::syncState currentStatus stop Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::getTrack 51 Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:34 volumio volumio[6778]: info: No code Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:34 volumio volumio[6778]: info: CorePlayQueue::getTrack 51 Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:34 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:34 volumio volumio[6778]: info: ------------------------------ 44ms Nov 21 15:28:34 volumio volumio[6778]: error: updateQueue error: null Nov 21 15:28:34 volumio volumio[6778]: info: ------------------------------ 30ms Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.1:8200/MediaItems/44.wav" Nov 21 15:28:34 volumio volumio[6778]: info: Nov 21 15:28:34 volumio volumio[6778]: ---------------------------- MPD announces system playlist update Nov 21 15:28:34 volumio volumio[6778]: info: Ignoring MPD Status Update Nov 21 15:28:34 volumio volumio[6778]: info: sendMpdCommand add "http://192.168.31.1:8200/MediaItems/44.wav" took 15 milliseconds Nov 21 15:28:34 volumio volumio[6778]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand play Nov 21 15:28:34 volumio volumio[6778]: info: ------------------------------ 3ms Nov 21 15:28:34 volumio volumio[6778]: info: sendMpdCommand play took 1 milliseconds Nov 21 15:28:34 volumio volumio[6778]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Aimer/BEST%20SELECTION%20%22blanc%22/aab1613a-b66e-45ff-a73f-b49e90e7d6cd.jpg' Nov 21 15:28:34 volumio volumio[6778]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Aimer/BEST%20SELECTION%20%22blanc%22/aab1613a-b66e-45ff-a73f-b49e90e7d6cd.jpg' Nov 21 15:28:34 volumio volumio[6778]: info: Nov 21 15:28:34 volumio volumio[6778]: ---------------------------- MPD announces state update: player Nov 21 15:28:34 volumio volumio[6778]: info: ControllerMpd::getState Nov 21 15:28:34 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand status Nov 21 15:28:35 volumio volumio[6778]: info: Nov 21 15:28:35 volumio volumio[6778]: ---------------------------- MPD announces state update: player Nov 21 15:28:35 volumio volumio[6778]: info: sendMpdCommand status took 317 milliseconds Nov 21 15:28:35 volumio volumio[6778]: info: ControllerMpd::getState Nov 21 15:28:35 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand status Nov 21 15:28:35 volumio volumio[6778]: verbose: ControllerMpd::parseState Nov 21 15:28:35 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 15:28:35 volumio volumio[6778]: info: sendMpdCommand status took 3 milliseconds Nov 21 15:28:35 volumio volumio[6778]: verbose: ControllerMpd::parseState Nov 21 15:28:35 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 15:28:35 volumio volumio[6778]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 21 15:28:35 volumio volumio[6778]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 21 15:28:35 volumio volumio[6778]: verbose: ControllerMpd::parseTrackInfo Nov 21 15:28:35 volumio volumio[6778]: verbose: ControllerMpd::parseTrackInfo Nov 21 15:28:35 volumio volumio[6778]: info: ControllerMpd::pushState Nov 21 15:28:35 volumio volumio[6778]: info: CoreCommandRouter::servicePushState Nov 21 15:28:35 volumio volumio[6778]: info: CorePlayQueue::getTrack 51 Nov 21 15:28:35 volumio volumio[6778]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"44.wav","artist":null,"album":null,"uri":"http://192.168.31.1:8200/MediaItems/44.wav","trackType":"wav"} Nov 21 15:28:35 volumio volumio[6778]: verbose: CURRENT POSITION 51 Nov 21 15:28:35 volumio volumio[6778]: info: CoreStateMachine::syncState stateService play Nov 21 15:28:35 volumio volumio[6778]: info: CoreStateMachine::syncState currentStatus stop Nov 21 15:28:35 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:35 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:35 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:35 volumio volumio[6778]: info: ControllerMpd::pushState Nov 21 15:28:35 volumio volumio[6778]: info: CoreCommandRouter::servicePushState Nov 21 15:28:35 volumio volumio[6778]: info: CorePlayQueue::getTrack 51 Nov 21 15:28:35 volumio volumio[6778]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":330,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"44.wav","artist":null,"album":null,"uri":"http://192.168.31.1:8200/MediaItems/44.wav","trackType":"wav"} Nov 21 15:28:35 volumio volumio[6778]: verbose: CURRENT POSITION 51 Nov 21 15:28:35 volumio volumio[6778]: info: CoreStateMachine::syncState stateService play Nov 21 15:28:35 volumio volumio[6778]: info: CoreStateMachine::syncState currentStatus play Nov 21 15:28:35 volumio volumio[6778]: info: Received an update from plugin. extracting info from payload Nov 21 15:28:35 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:35 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:35 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:35 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:35 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:35 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:35 volumio volumio[6778]: info: ------------------------------ 343ms Nov 21 15:28:35 volumio volumio[6778]: info: ------------------------------ 26ms Nov 21 15:28:35 volumio volumio[6778]: info: CoreCommandRouter::volumioGetQueue Nov 21 15:28:35 volumio volumio[6778]: info: CoreStateMachine::getQueue Nov 21 15:28:35 volumio volumio[6778]: info: CorePlayQueue::getQueue Nov 21 15:28:35 volumio volumio[6778]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 21 15:28:35 volumio volumio[6778]: info: CoreCommandRouter::volumioGetState Nov 21 15:28:35 volumio volumio[6778]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Nov 21 15:28:35 volumio volumio[6778]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 21 15:28:40 volumio volumio[6778]: info: CoreCommandRouter::volumioNext Nov 21 15:28:40 volumio volumio[6778]: info: CoreStateMachine::next Nov 21 15:28:40 volumio volumio[6778]: info: ControllerMpd::next Nov 21 15:28:40 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand next Nov 21 15:28:40 volumio volumio[6778]: info: sendMpdCommand next took 109 milliseconds Nov 21 15:28:40 volumio volumio[6778]: info: Nov 21 15:28:40 volumio volumio[6778]: ---------------------------- MPD announces system playlist update Nov 21 15:28:40 volumio volumio[6778]: info: Ignoring MPD Status Update Nov 21 15:28:40 volumio volumio[6778]: info: Nov 21 15:28:40 volumio volumio[6778]: ---------------------------- MPD announces state update: player Nov 21 15:28:40 volumio volumio[6778]: info: ControllerMpd::getState Nov 21 15:28:40 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand status Nov 21 15:28:40 volumio volumio[6778]: error: updateQueue error: null Nov 21 15:28:40 volumio volumio[6778]: info: ------------------------------ 2ms Nov 21 15:28:40 volumio volumio[6778]: info: sendMpdCommand status took 1 milliseconds Nov 21 15:28:40 volumio volumio[6778]: verbose: ControllerMpd::parseState Nov 21 15:28:40 volumio volumio[6778]: info: ControllerMpd::pushState Nov 21 15:28:40 volumio volumio[6778]: info: CoreCommandRouter::servicePushState Nov 21 15:28:40 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:40 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:40 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:40 volumio volumio[6778]: info: CorePlayQueue::getTrack 51 Nov 21 15:28:40 volumio volumio[6778]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 21 15:28:40 volumio volumio[6778]: verbose: CURRENT POSITION 51 Nov 21 15:28:40 volumio volumio[6778]: info: CoreStateMachine::syncState stateService stop Nov 21 15:28:40 volumio volumio[6778]: info: CoreStateMachine::syncState currentStatus play Nov 21 15:28:40 volumio volumio[6778]: info: CoreStateMachine::play index undefined Nov 21 15:28:40 volumio volumio[6778]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:41 volumio volumio[6778]: info: CorePlayQueue::getTrack 52 Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:41 volumio volumio[6778]: info: CorePlayQueue::getTrack 52 Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::startPlaybackTimer Nov 21 15:28:41 volumio volumio[6778]: info: CorePlayQueue::getTrack 52 Nov 21 15:28:41 volumio volumio[6778]: info: [1732202921003] ControllerUPNPBrowser::clearAddPlayTrack Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand stop Nov 21 15:28:41 volumio volumio[6778]: info: ------------------------------ 17ms Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:41 volumio volumio[6778]: info: CorePlayQueue::getTrack 52 Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:41 volumio volumio[6778]: info: sendMpdCommand stop took 10 milliseconds Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand clear Nov 21 15:28:41 volumio volumio[6778]: info: Nov 21 15:28:41 volumio volumio[6778]: ---------------------------- MPD announces system playlist update Nov 21 15:28:41 volumio volumio[6778]: info: Ignoring MPD Status Update Nov 21 15:28:41 volumio volumio[6778]: info: sendMpdCommand clear took 15 milliseconds Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.1:8200/MediaItems/30.flac" Nov 21 15:28:41 volumio volumio[6778]: error: updateQueue error: null Nov 21 15:28:41 volumio volumio[6778]: info: ------------------------------ 16ms Nov 21 15:28:41 volumio volumio[6778]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.1:8200/MediaItems/30.flac" Nov 21 15:28:41 volumio volumio[6778]: info: Nov 21 15:28:41 volumio volumio[6778]: ---------------------------- MPD announces system playlist update Nov 21 15:28:41 volumio volumio[6778]: info: Ignoring MPD Status Update Nov 21 15:28:41 volumio volumio[6778]: info: sendMpdCommand add "http://192.168.31.1:8200/MediaItems/30.flac" took 3 milliseconds Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand play Nov 21 15:28:41 volumio volumio[6778]: info: ------------------------------ 6ms Nov 21 15:28:41 volumio volumio[6778]: info: sendMpdCommand play took 2 milliseconds Nov 21 15:28:41 volumio volumio[6778]: info: Nov 21 15:28:41 volumio volumio[6778]: ---------------------------- MPD announces state update: player Nov 21 15:28:41 volumio volumio[6778]: info: ControllerMpd::getState Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand status Nov 21 15:28:41 volumio volumio[6778]: info: sendMpdCommand status took 317 milliseconds Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::parseState Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 15:28:41 volumio volumio[6778]: info: Nov 21 15:28:41 volumio volumio[6778]: ---------------------------- MPD announces system playlist update Nov 21 15:28:41 volumio volumio[6778]: info: Ignoring MPD Status Update Nov 21 15:28:41 volumio volumio[6778]: info: Nov 21 15:28:41 volumio volumio[6778]: ---------------------------- MPD announces state update: player Nov 21 15:28:41 volumio volumio[6778]: info: ControllerMpd::getState Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand status Nov 21 15:28:41 volumio volumio[6778]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::parseTrackInfo Nov 21 15:28:41 volumio volumio[6778]: info: ControllerMpd::pushState Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::servicePushState Nov 21 15:28:41 volumio volumio[6778]: info: CorePlayQueue::getTrack 52 Nov 21 15:28:41 volumio volumio[6778]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":341,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BEYOND THE TIME ～メビウスの宇宙を超えて～ (Live)","artist":"Aimer","album":"機動戦士ガンダムユニコーン RE:0096 COMPLETE BEST","uri":"http://192.168.31.1:8200/MediaItems/30.flac","trackType":"flac"} Nov 21 15:28:41 volumio volumio[6778]: verbose: CURRENT POSITION 52 Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::syncState stateService play Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::syncState currentStatus stop Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:41 volumio volumio[6778]: info: ------------------------------ 330ms Nov 21 15:28:41 volumio volumio[6778]: info: ------------------------------ 13ms Nov 21 15:28:41 volumio volumio[6778]: info: sendMpdCommand status took 11 milliseconds Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::parseState Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 21 15:28:41 volumio volumio[6778]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 21 15:28:41 volumio volumio[6778]: verbose: ControllerMpd::parseTrackInfo Nov 21 15:28:41 volumio volumio[6778]: info: ControllerMpd::pushState Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::servicePushState Nov 21 15:28:41 volumio volumio[6778]: info: CorePlayQueue::getTrack 52 Nov 21 15:28:41 volumio volumio[6778]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":341,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"649 Kbps","isStreaming":false,"title":"BEYOND THE TIME ～メビウスの宇宙を超えて～ (Live)","artist":"Aimer","album":"機動戦士ガンダムユニコーン RE:0096 COMPLETE BEST","uri":"http://192.168.31.1:8200/MediaItems/30.flac","trackType":"flac"} Nov 21 15:28:41 volumio volumio[6778]: verbose: CURRENT POSITION 52 Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::syncState stateService play Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::syncState currentStatus play Nov 21 15:28:41 volumio volumio[6778]: info: Received an update from plugin. extracting info from payload Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::pushState Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::volumioPushState Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 21 15:28:41 volumio volumio[6778]: info: ------------------------------ 32ms Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::volumioGetQueue Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::getQueue Nov 21 15:28:41 volumio volumio[6778]: info: CorePlayQueue::getQueue Nov 21 15:28:41 volumio volumio[6778]: info: CoreCommandRouter::volumioGetQueue Nov 21 15:28:41 volumio volumio[6778]: info: CoreStateMachine::getQueue Nov 21 15:28:41 volumio volumio[6778]: info: CorePlayQueue::getQueue Nov 21 15:28:41 volumio volumio[6778]: info: touch_display: Setting screensaver timeout to 0 seconds. Nov 21 15:28:44 volumio sudo[8014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 21 15:28:44 volumio sudo[8014]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 15:28:44 volumio sudo[8016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 21 15:28:44 volumio sudo[8014]: pam_unix(sudo:session): session closed for user root Nov 21 15:28:44 volumio sudo[8016]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 15:28:44 volumio sudo[8016]: pam_unix(sudo:session): session closed for user root Nov 21 15:28:44 volumio sudo[8034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 21 15:28:44 volumio sudo[8034]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 15:28:44 volumio sudo[8037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 21 15:28:44 volumio sudo[8034]: pam_unix(sudo:session): session closed for user root Nov 21 15:28:44 volumio sudo[8037]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 21 15:28:44 volumio sudo[8037]: pam_unix(sudo:session): session closed for user root Nov 21 15:28:45 volumio volumio[6778]: info: CoreCommandRouter::volumioGetState Nov 21 15:28:45 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 21 15:28:45 volumio volumio[6778]: info: CoreCommandRouter::volumioGetVisibleSources Nov 21 15:28:45 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 21 15:28:45 volumio volumio[6778]: info: Listing playlists Nov 21 15:28:45 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 21 15:28:45 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 21 15:28:45 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 21 15:28:45 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 21 15:28:47 volumio volumio[6778]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 21 15:29:01 volumio volumio[6778]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 15:29:01 volumio volumio[6778]: { Error: connect ETIMEDOUT 156.233.67.243:443 Nov 21 15:29:01 volumio volumio[6778]: at Object._errnoException (util.js:1022:11) Nov 21 15:29:01 volumio volumio[6778]: at _exceptionWithHostPort (util.js:1044:20) Nov 21 15:29:01 volumio volumio[6778]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Nov 21 15:29:01 volumio volumio[6778]: code: 'ETIMEDOUT', Nov 21 15:29:01 volumio volumio[6778]: errno: 'ETIMEDOUT', Nov 21 15:29:01 volumio volumio[6778]: syscall: 'connect', Nov 21 15:29:01 volumio volumio[6778]: address: '156.233.67.243', Nov 21 15:29:01 volumio volumio[6778]: port: 443 } Nov 21 15:29:01 volumio volumio[6778]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 21 15:29:01 volumio sudo[8098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-21 15:28 Nov 21 15:29:01 volumio sudo[8098]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"