Jan 26 04:27:01 volumio volumio[1214]: info: BOOT COMPLETED Jan 26 04:27:04 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:04 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:04 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:04 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:04 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:09 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:09 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:09 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:09 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:09 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:14 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:14 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:14 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:14 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:14 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:15 volumio volumio[1214]: info: CoreCommandRouter::volumioGetState Jan 26 04:27:19 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:19 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:19 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:19 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:19 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:21 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 04:27:21 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 26 04:27:25 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:25 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:25 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:25 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:25 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:30 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:30 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:30 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:30 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:30 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:35 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:35 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:35 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:35 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:35 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:40 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:40 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:40 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:40 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:40 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:46 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:46 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:46 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:46 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:46 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:51 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:51 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:51 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:51 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:51 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:56 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:56 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:56 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:27:56 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:27:56 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:27:59 volumio volumio[1214]: info: Jan 26 04:27:59 volumio volumio[1214]: ---------------------------- MPD announces system playlist update Jan 26 04:27:59 volumio volumio[1214]: info: Ignoring MPD Status Update Jan 26 04:27:59 volumio volumio[1214]: info: Jan 26 04:27:59 volumio volumio[1214]: ---------------------------- MPD announces state update: player Jan 26 04:27:59 volumio volumio[1214]: info: ControllerMpd::getState Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status Jan 26 04:27:59 volumio volumio[1214]: info: Jan 26 04:27:59 volumio volumio[1214]: ---------------------------- MPD announces system playlist update Jan 26 04:27:59 volumio volumio[1214]: info: Ignoring MPD Status Update Jan 26 04:27:59 volumio volumio[1214]: info: Jan 26 04:27:59 volumio volumio[1214]: ---------------------------- MPD announces state update: player Jan 26 04:27:59 volumio volumio[1214]: info: ControllerMpd::getState Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status Jan 26 04:27:59 volumio volumio[1214]: info: Jan 26 04:27:59 volumio volumio[1214]: ---------------------------- MPD announces system playlist update Jan 26 04:27:59 volumio volumio[1214]: info: Ignoring MPD Status Update Jan 26 04:27:59 volumio volumio[1214]: info: Jan 26 04:27:59 volumio volumio[1214]: ---------------------------- MPD announces state update: player Jan 26 04:27:59 volumio volumio[1214]: info: ControllerMpd::getState Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status Jan 26 04:27:59 volumio volumio[1214]: info: ------------------------------ 58ms Jan 26 04:27:59 volumio volumio[1214]: info: sendMpdCommand status took 53 milliseconds Jan 26 04:27:59 volumio volumio[1214]: info: ------------------------------ 57ms Jan 26 04:27:59 volumio volumio[1214]: info: sendMpdCommand status took 60 milliseconds Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::parseState Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::parseState Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 04:27:59 volumio volumio[1214]: info: ------------------------------ 47ms Jan 26 04:27:59 volumio volumio[1214]: info: sendMpdCommand status took 45 milliseconds Jan 26 04:27:59 volumio volumio[1214]: info: sendMpdCommand playlistinfo took 22 milliseconds Jan 26 04:27:59 volumio volumio[1214]: info: sendMpdCommand playlistinfo took 19 milliseconds Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::parseState Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo Jan 26 04:27:59 volumio volumio[1214]: info: ControllerMpd::pushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::servicePushState Jan 26 04:27:59 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 Jan 26 04:27:59 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":83228,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"Radio Italo4you to nie tylko Radio styl lat 80","artist":"Radio Italo4you","album":null,"uri":"http://91.232.4.33:8018/Italo4you","trackType":""} Jan 26 04:27:59 volumio volumio[1214]: verbose: CURRENT POSITION 0 Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play Jan 26 04:27:59 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:27:59 volumio volumio[1214]: info: ControllerMpd::pushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::servicePushState Jan 26 04:27:59 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 Jan 26 04:27:59 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":83228,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"Radio Italo4you to nie tylko Radio styl lat 80","artist":"Radio Italo4you","album":null,"uri":"http://91.232.4.33:8018/Italo4you","trackType":""} Jan 26 04:27:59 volumio volumio[1214]: verbose: CURRENT POSITION 0 Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play Jan 26 04:27:59 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:27:59 volumio volumio[1214]: info: ------------------------------ 344ms Jan 26 04:27:59 volumio volumio[1214]: info: ------------------------------ 353ms Jan 26 04:27:59 volumio volumio[1214]: info: sendMpdCommand playlistinfo took 250 milliseconds Jan 26 04:27:59 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo Jan 26 04:27:59 volumio volumio[1214]: info: ControllerMpd::pushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::servicePushState Jan 26 04:27:59 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 Jan 26 04:27:59 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":83228,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"Radio Italo4you to nie tylko Radio styl lat 80","artist":"Radio Italo4you","album":null,"uri":"http://91.232.4.33:8018/Italo4you","trackType":""} Jan 26 04:27:59 volumio volumio[1214]: verbose: CURRENT POSITION 0 Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play Jan 26 04:27:59 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:27:59 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:27:59 volumio volumio[1214]: info: ------------------------------ 452ms Jan 26 04:28:01 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:01 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:01 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:01 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:01 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:28:06 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:06 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:06 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:06 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:06 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:28:12 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:12 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:12 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:12 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:12 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:28:12 volumio volumio[1214]: info: CoreCommandRouter::volumioGetState Jan 26 04:28:15 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 04:28:15 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 26 04:28:17 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:17 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:17 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:17 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:17 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:28:18 volumio volumio[1214]: info: Jan 26 04:28:18 volumio volumio[1214]: ---------------------------- MPD announces system playlist update Jan 26 04:28:18 volumio volumio[1214]: info: Ignoring MPD Status Update Jan 26 04:28:18 volumio volumio[1214]: info: Jan 26 04:28:18 volumio volumio[1214]: ---------------------------- MPD announces state update: player Jan 26 04:28:18 volumio volumio[1214]: info: ControllerMpd::getState Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status Jan 26 04:28:18 volumio volumio[1214]: info: Jan 26 04:28:18 volumio volumio[1214]: ---------------------------- MPD announces system playlist update Jan 26 04:28:18 volumio volumio[1214]: info: Ignoring MPD Status Update Jan 26 04:28:18 volumio volumio[1214]: info: Jan 26 04:28:18 volumio volumio[1214]: ---------------------------- MPD announces state update: player Jan 26 04:28:18 volumio volumio[1214]: info: ControllerMpd::getState Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status Jan 26 04:28:18 volumio volumio[1214]: info: Jan 26 04:28:18 volumio volumio[1214]: ---------------------------- MPD announces system playlist update Jan 26 04:28:18 volumio volumio[1214]: info: Ignoring MPD Status Update Jan 26 04:28:18 volumio volumio[1214]: info: Jan 26 04:28:18 volumio volumio[1214]: ---------------------------- MPD announces state update: player Jan 26 04:28:18 volumio volumio[1214]: info: ControllerMpd::getState Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand status Jan 26 04:28:18 volumio volumio[1214]: info: ------------------------------ 46ms Jan 26 04:28:18 volumio volumio[1214]: info: sendMpdCommand status took 44 milliseconds Jan 26 04:28:18 volumio volumio[1214]: info: ------------------------------ 23ms Jan 26 04:28:18 volumio volumio[1214]: info: sendMpdCommand status took 13 milliseconds Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::parseState Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::parseState Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 04:28:18 volumio volumio[1214]: info: ------------------------------ 61ms Jan 26 04:28:18 volumio volumio[1214]: info: sendMpdCommand status took 59 milliseconds Jan 26 04:28:18 volumio volumio[1214]: info: sendMpdCommand playlistinfo took 22 milliseconds Jan 26 04:28:18 volumio volumio[1214]: info: sendMpdCommand playlistinfo took 20 milliseconds Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::parseState Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo Jan 26 04:28:18 volumio volumio[1214]: info: ControllerMpd::pushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::servicePushState Jan 26 04:28:18 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 Jan 26 04:28:18 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":101975,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"Modern Talking - Slow Motion","artist":"Radio Italo4you","album":null,"uri":"http://91.232.4.33:8018/Italo4you","trackType":""} Jan 26 04:28:18 volumio volumio[1214]: verbose: CURRENT POSITION 0 Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play Jan 26 04:28:18 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:28:18 volumio volumio[1214]: info: ControllerMpd::pushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::servicePushState Jan 26 04:28:18 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 Jan 26 04:28:18 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":101975,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"Modern Talking - Slow Motion","artist":"Radio Italo4you","album":null,"uri":"http://91.232.4.33:8018/Italo4you","trackType":""} Jan 26 04:28:18 volumio volumio[1214]: verbose: CURRENT POSITION 0 Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play Jan 26 04:28:18 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:28:18 volumio volumio[1214]: info: ------------------------------ 417ms Jan 26 04:28:18 volumio volumio[1214]: info: ------------------------------ 395ms Jan 26 04:28:18 volumio volumio[1214]: info: sendMpdCommand playlistinfo took 375 milliseconds Jan 26 04:28:18 volumio volumio[1214]: verbose: ControllerMpd::parseTrackInfo Jan 26 04:28:18 volumio volumio[1214]: info: ControllerMpd::pushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::servicePushState Jan 26 04:28:18 volumio volumio[1214]: info: CorePlayQueue::getTrack 0 Jan 26 04:28:18 volumio volumio[1214]: verbose: STATE SERVICE {"status":"play","position":0,"seek":102101,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"Modern Talking - Slow Motion","artist":"Radio Italo4you","album":null,"uri":"http://91.232.4.33:8018/Italo4you","trackType":""} Jan 26 04:28:18 volumio volumio[1214]: verbose: CURRENT POSITION 0 Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::syncState stateService play Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::syncState currentStatus play Jan 26 04:28:18 volumio volumio[1214]: info: Received an update from plugin. extracting info from payload Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreStateMachine::pushState Jan 26 04:28:18 volumio volumio[1214]: info: CoreCommandRouter::volumioPushState Jan 26 04:28:18 volumio volumio[1214]: info: ------------------------------ 611ms Jan 26 04:28:22 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:22 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:22 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:22 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:22 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:28:27 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:27 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:27 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:27 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:27 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:28:33 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:33 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:33 volumio volumio[1214]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Jan 26 04:28:33 volumio volumio[1214]: info: Discovery: Restarting Browsing Jan 26 04:28:33 volumio volumio[1214]: info: Discovery: Restart already pending, ignoring duplicate call Jan 26 04:28:34 volumio sudo[2193]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Jan 26 04:28:34 volumio sudo[2191]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Jan 26 04:28:34 volumio sudo[2191]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 04:28:34 volumio sudo[2193]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 04:28:34 volumio sudo[2191]: pam_unix(sudo:session): session closed for user root Jan 26 04:28:34 volumio volumio[1214]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Jan 26 04:28:34 volumio systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 26 04:28:34 volumio volumio[1214]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 04:28:34 volumio sudo[2195]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Jan 26 04:28:34 volumio sudo[2195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 04:28:34 volumio sudo[2198]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Jan 26 04:28:34 volumio sudo[2198]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 26 04:28:34 volumio volumio[1214]: TypeError: Cannot read properties of undefined (reading 'split') Jan 26 04:28:34 volumio volumio[1214]: at /data/plugins/user_interface/touch_display/index.js:1298:37 Jan 26 04:28:34 volumio volumio[1214]: at ChildProcess.exithandler (node:child_process:413:7) Jan 26 04:28:34 volumio volumio[1214]: at ChildProcess.emit (node:events:514:28) Jan 26 04:28:34 volumio volumio[1214]: at maybeClose (node:internal/child_process:1105:16) Jan 26 04:28:34 volumio volumio[1214]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) Jan 26 04:28:34 volumio volumio[1214]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 04:28:34 volumio systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 26 04:28:34 volumio sudo[2193]: pam_unix(sudo:session): session closed for user root Jan 26 04:28:35 volumio sudo[2198]: pam_unix(sudo:session): session closed for user root Jan 26 04:28:35 volumio systemd[1]: Reloading. Jan 26 04:28:36 volumio sudo[2195]: pam_unix(sudo:session): session closed for user root Jan 26 04:28:41 volumio sudo[2248]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-26 04:27' Jan 26 04:28:41 volumio sudo[2248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"