-- Logs begin at Sun 2024-09-01 09:16:23 UTC, end at Sun 2024-09-01 09:37:17 UTC. -- Sep 01 09:36:07 volumio volumio[2495]: info: Sep 01 09:36:07 volumio volumio[2495]: ---------------------------- MPD announces state update: player Sep 01 09:36:07 volumio volumio[2495]: info: ControllerMpd::getState Sep 01 09:36:07 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand status Sep 01 09:36:07 volumio volumio[2495]: verbose: ControllerMpd::parseState Sep 01 09:36:07 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 09:36:07 volumio volumio[2495]: verbose: ControllerMpd::parseTrackInfo Sep 01 09:36:07 volumio volumio[2495]: info: ControllerMpd::pushState Sep 01 09:36:07 volumio volumio[2495]: info: CoreCommandRouter::servicePushState Sep 01 09:36:07 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:07 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:07 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:07 volumio volumio[2495]: info: CorePlayQueue::getTrack 0 Sep 01 09:36:07 volumio volumio[2495]: 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":"Voce","artist":"Ive Mendes","album":"Ive Mendes","uri":"http://aqqmusic.tc.qq.com/M5000035Jr662wGZ3g.mp3?guid=0000000004cb49d2000001871e73f5cf&vkey=D4631825866E33ED56B70F17E3428B52ECFF175C31862FB851C06FC2DCFE01A1162287943D7665DF5A8C2E7A0610E5C47D6E1B313078C39F&uin=1259438298&redirect=1&fromtag=111042","trackType":""} Sep 01 09:36:07 volumio volumio[2495]: verbose: CURRENT POSITION 0 Sep 01 09:36:07 volumio volumio[2495]: info: CoreStateMachine::syncState stateService stop Sep 01 09:36:07 volumio volumio[2495]: info: CoreStateMachine::syncState currentStatus play Sep 01 09:36:07 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:07 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:07 volumio volumio[2495]: info: CoreStateMachine::stPlaybackTimer Sep 01 09:36:07 volumio volumio[2495]: info: ------------------------------ 26ms Sep 01 09:36:07 volumio volumio[2495]: info: CoreCommandRouter::volumioGetQueue Sep 01 09:36:07 volumio volumio[2495]: info: CoreStateMachine::getQueue Sep 01 09:36:07 volumio volumio[2495]: info: CorePlayQueue::getQueue Sep 01 09:36:07 volumio volumio[2495]: info: Clearing queue after UPNP request Sep 01 09:36:07 volumio volumio[2495]: info: CoreStateMachine::ClearQueue Sep 01 09:36:07 volumio volumio[2495]: info: CoreStateMachine::stop Sep 01 09:36:07 volumio volumio[2495]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 09:36:07 volumio volumio[2495]: UNSET VOLATILE Sep 01 09:36:07 volumio volumio[2495]: info: CorePlayQueue::clearPlayQueue Sep 01 09:36:07 volumio volumio[2495]: info: CorePlayQueue::saveQueue Sep 01 09:36:07 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:07 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:07 volumio volumio[2495]: info: CoreCommandRouter::volumioPushQueue Sep 01 09:36:07 volumio volumio[2495]: info: Sep 01 09:36:07 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:07 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:07 volumio volumio[2495]: error: updateQueue error: null Sep 01 09:36:07 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:07 volumio volumio[2495]: info: Starting UPNP Playback Sep 01 09:36:07 volumio volumio[2495]: info: Preparing playback through UPNP Sep 01 09:36:07 volumio volumio[2495]: info: CoreCommandRouter::volumioGetState Sep 01 09:36:07 volumio volumio[2495]: info: CorePlayQueue::getTrack 0 Sep 01 09:36:07 volumio volumio[2495]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 01 09:36:08 volumio volumio[2495]: info: Sep 01 09:36:08 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:08 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:08 volumio volumio[2495]: info: Sep 01 09:36:08 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:08 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:08 volumio volumio[2495]: info: ------------------------------ 2ms Sep 01 09:36:08 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:08 volumio volumio[2495]: info: Sep 01 09:36:08 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:08 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:08 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:08 volumio volumio[2495]: info: Sep 01 09:36:08 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:08 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:08 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:08 volumio volumio[2495]: info: Sep 01 09:36:08 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:08 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:08 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:08 volumio volumio[2495]: info: Sep 01 09:36:08 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:08 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:08 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:09 volumio dhcpcd[1006]: eth0: adding route to 192.168.3.0/24 Sep 01 09:36:09 volumio dhcpcd[1006]: eth0: adding default route via 192.168.3.101 Sep 01 09:36:09 volumio dhcpcd[1006]: eth0: ipv4_addroute: File exists Sep 01 09:36:09 volumio dhcpcd[1006]: eth0: removing route to 192.168.3.0/24 Sep 01 09:36:13 volumio volumio[2495]: info: Sep 01 09:36:13 volumio volumio[2495]: ---------------------------- MPD announces state update: player Sep 01 09:36:13 volumio volumio[2495]: info: ControllerMpd::getState Sep 01 09:36:13 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand status Sep 01 09:36:13 volumio volumio[2495]: verbose: ControllerMpd::parseState Sep 01 09:36:13 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 09:36:13 volumio volumio[2495]: info: Sep 01 09:36:13 volumio volumio[2495]: ---------------------------- MPD announces state update: player Sep 01 09:36:13 volumio volumio[2495]: info: ControllerMpd::getState Sep 01 09:36:13 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand status Sep 01 09:36:13 volumio volumio[2495]: info: Sep 01 09:36:13 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:13 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:14 volumio volumio[2495]: verbose: ControllerMpd::parseTrackInfo Sep 01 09:36:14 volumio volumio[2495]: verbose: ControllerMpd::parseState Sep 01 09:36:14 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 09:36:14 volumio volumio[2495]: info: ControllerMpd::pushState Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::servicePushState Sep 01 09:36:14 volumio volumio[2495]: In UPNP mode Sep 01 09:36:14 volumio volumio[2495]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":163,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nothing","artist":"Bruno Major","album":"Nothing","uri":"http://aqqmusic.tc.qq.com/M500003ikmNN1DDzWx.mp3?guid=0000000004cb49d2000001871e73f5cf&vkey=AAECA20CE19B0E40B9482A5921A722BFDAB44A3FD983888AE365FDEE65D989BAF4FA57509AFEC58F12115F49EECCEFDF73FCB073AF5D2C94&uin=1259438298&src=M500001iXK5b0FUPUv.mp3&redirect=1&fromtag=111042","trackType":""} Sep 01 09:36:14 volumio volumio[2495]: verbose: CURRENT POSITION 0 Sep 01 09:36:14 volumio volumio[2495]: info: CoreStateMachine::syncState stateService play Sep 01 09:36:14 volumio volumio[2495]: info: CoreStateMachine::syncState currentStatus stop Sep 01 09:36:14 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:14 volumio volumio[2495]: info: ------------------------------ 16ms Sep 01 09:36:14 volumio volumio[2495]: info: ------------------------------ 11ms Sep 01 09:36:14 volumio volumio[2495]: verbose: ControllerMpd::parseTrackInfo Sep 01 09:36:14 volumio volumio[2495]: info: ControllerMpd::pushState Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::servicePushState Sep 01 09:36:14 volumio volumio[2495]: In UPNP mode Sep 01 09:36:14 volumio volumio[2495]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":163,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Nothing","artist":"Bruno Major","album":"Nothing","uri":"http://aqqmusic.tc.qq.com/M500003ikmNN1DDzWx.mp3?guid=0000000004cb49d2000001871e73f5cf&vkey=AAECA20CE19B0E40B9482A5921A722BFDAB44A3FD983888AE365FDEE65D989BAF4FA57509AFEC58F12115F49EECCEFDF73FCB073AF5D2C94&uin=1259438298&src=M500001iXK5b0FUPUv.mp3&redirect=1&fromtag=111042","trackType":""} Sep 01 09:36:14 volumio volumio[2495]: verbose: CURRENT POSITION 0 Sep 01 09:36:14 volumio volumio[2495]: info: CoreStateMachine::syncState stateService play Sep 01 09:36:14 volumio volumio[2495]: info: CoreStateMachine::syncState currentStatus play Sep 01 09:36:14 volumio volumio[2495]: info: Received an update from plugin. extracting info from payload Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 01 09:36:14 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:14 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:14 volumio volumio[2495]: info: ------------------------------ 37ms Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::volumioGetQueue Sep 01 09:36:14 volumio volumio[2495]: info: CoreStateMachine::getQueue Sep 01 09:36:14 volumio volumio[2495]: info: CorePlayQueue::getQueue Sep 01 09:36:14 volumio volumio[2495]: info: CoreCommandRouter::volumioGetQueue Sep 01 09:36:14 volumio volumio[2495]: info: CoreStateMachine::getQueue Sep 01 09:36:14 volumio volumio[2495]: info: CorePlayQueue::getQueue Sep 01 09:36:14 volumio volumio[2495]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ive%20Mendes/Ive%20Mendes/7ca6960b-49bf-4f5e-8c89-775e1294e9fb.png' Sep 01 09:36:39 volumio dhcpcd[1006]: eth0: adding route to 192.168.3.0/24 Sep 01 09:36:39 volumio dhcpcd[1006]: eth0: adding default route via 192.168.3.101 Sep 01 09:36:39 volumio dhcpcd[1006]: eth0: ipv4_addroute: File exists Sep 01 09:36:39 volumio dhcpcd[1006]: eth0: removing route to 192.168.3.0/24 Sep 01 09:36:44 volumio volumio[2495]: info: Sep 01 09:36:44 volumio volumio[2495]: ---------------------------- MPD announces state update: player Sep 01 09:36:44 volumio volumio[2495]: info: ControllerMpd::getState Sep 01 09:36:44 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand status Sep 01 09:36:44 volumio volumio[2495]: verbose: ControllerMpd::parseState Sep 01 09:36:44 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 09:36:44 volumio volumio[2495]: verbose: ControllerMpd::parseTrackInfo Sep 01 09:36:44 volumio volumio[2495]: info: ControllerMpd::pushState Sep 01 09:36:44 volumio volumio[2495]: info: CoreCommandRouter::servicePushState Sep 01 09:36:44 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:44 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:44 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:44 volumio volumio[2495]: info: CorePlayQueue::getTrack 0 Sep 01 09:36:44 volumio volumio[2495]: 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":"Nothing","artist":"Bruno Major","album":"Nothing","uri":"http://aqqmusic.tc.qq.com/M500003ikmNN1DDzWx.mp3?guid=0000000004cb49d2000001871e73f5cf&vkey=AAECA20CE19B0E40B9482A5921A722BFDAB44A3FD983888AE365FDEE65D989BAF4FA57509AFEC58F12115F49EECCEFDF73FCB073AF5D2C94&uin=1259438298&src=M500001iXK5b0FUPUv.mp3&redirect=1&fromtag=111042","trackType":""} Sep 01 09:36:44 volumio volumio[2495]: verbose: CURRENT POSITION 0 Sep 01 09:36:44 volumio volumio[2495]: info: CoreStateMachine::syncState stateService stop Sep 01 09:36:44 volumio volumio[2495]: info: CoreStateMachine::syncState currentStatus play Sep 01 09:36:44 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:44 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:44 volumio volumio[2495]: info: CoreStateMachine::stPlaybackTimer Sep 01 09:36:44 volumio volumio[2495]: info: ------------------------------ 18ms Sep 01 09:36:44 volumio volumio[2495]: info: CoreCommandRouter::volumioGetQueue Sep 01 09:36:44 volumio volumio[2495]: info: CoreStateMachine::getQueue Sep 01 09:36:44 volumio volumio[2495]: info: CorePlayQueue::getQueue Sep 01 09:36:44 volumio volumio[2495]: info: Clearing queue after UPNP request Sep 01 09:36:45 volumio volumio[2495]: info: CoreStateMachine::ClearQueue Sep 01 09:36:45 volumio volumio[2495]: info: CoreStateMachine::stop Sep 01 09:36:45 volumio volumio[2495]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 09:36:45 volumio volumio[2495]: UNSET VOLATILE Sep 01 09:36:45 volumio volumio[2495]: info: CorePlayQueue::clearPlayQueue Sep 01 09:36:45 volumio volumio[2495]: info: CorePlayQueue::saveQueue Sep 01 09:36:45 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:45 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:45 volumio volumio[2495]: info: CoreCommandRouter::volumioPushQueue Sep 01 09:36:45 volumio volumio[2495]: info: Sep 01 09:36:45 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:45 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:45 volumio volumio[2495]: error: updateQueue error: null Sep 01 09:36:45 volumio volumio[2495]: info: ------------------------------ 2ms Sep 01 09:36:45 volumio volumio[2495]: info: Starting UPNP Playback Sep 01 09:36:45 volumio volumio[2495]: info: Preparing playback through UPNP Sep 01 09:36:45 volumio volumio[2495]: info: CoreCommandRouter::volumioGetState Sep 01 09:36:45 volumio volumio[2495]: info: CorePlayQueue::getTrack 0 Sep 01 09:36:45 volumio volumio[2495]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 01 09:36:45 volumio volumio[2495]: info: Sep 01 09:36:45 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:45 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:45 volumio volumio[2495]: info: Sep 01 09:36:45 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:45 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:45 volumio volumio[2495]: info: ------------------------------ 4ms Sep 01 09:36:45 volumio volumio[2495]: info: ------------------------------ 2ms Sep 01 09:36:45 volumio volumio[2495]: info: Sep 01 09:36:45 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:45 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:45 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:45 volumio volumio[2495]: info: Sep 01 09:36:45 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:45 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:45 volumio volumio[2495]: info: ------------------------------ 2ms Sep 01 09:36:45 volumio volumio[2495]: info: Sep 01 09:36:45 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:45 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:45 volumio volumio[2495]: info: ------------------------------ 2ms Sep 01 09:36:45 volumio volumio[2495]: info: Sep 01 09:36:45 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:45 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:45 volumio volumio[2495]: info: ------------------------------ 4ms Sep 01 09:36:46 volumio volumio[2495]: info: Sep 01 09:36:46 volumio volumio[2495]: ---------------------------- MPD announces state update: player Sep 01 09:36:46 volumio volumio[2495]: info: ControllerMpd::getState Sep 01 09:36:46 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand status Sep 01 09:36:46 volumio volumio[2495]: info: Sep 01 09:36:46 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:46 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:46 volumio volumio[2495]: info: Sep 01 09:36:46 volumio volumio[2495]: ---------------------------- MPD announces state update: player Sep 01 09:36:46 volumio volumio[2495]: info: ControllerMpd::getState Sep 01 09:36:46 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand status Sep 01 09:36:46 volumio volumio[2495]: verbose: ControllerMpd::parseState Sep 01 09:36:46 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 09:36:46 volumio volumio[2495]: info: ------------------------------ 2ms Sep 01 09:36:46 volumio volumio[2495]: verbose: ControllerMpd::parseState Sep 01 09:36:46 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 09:36:46 volumio volumio[2495]: verbose: ControllerMpd::parseTrackInfo Sep 01 09:36:46 volumio volumio[2495]: info: ControllerMpd::pushState Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::servicePushState Sep 01 09:36:46 volumio volumio[2495]: In UPNP mode Sep 01 09:36:46 volumio volumio[2495]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Family","artist":"小野リサ","album":"Soul & Bossa","uri":"http://aqqmusic.tc.qq.com/F000000lfIuG1SU6bY.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=4416E2CFFB78D7AFEEA1D915B6A97567BE3563297C2DF0CC7C67A6847595253D9674ADD8A27B5D8A38BEA48741A5AD91A920D2EEB19C53C7&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Sep 01 09:36:46 volumio volumio[2495]: verbose: CURRENT POSITION 0 Sep 01 09:36:46 volumio volumio[2495]: info: CoreStateMachine::syncState stateService play Sep 01 09:36:46 volumio volumio[2495]: info: CoreStateMachine::syncState currentStatus stop Sep 01 09:36:46 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:46 volumio volumio[2495]: info: ------------------------------ 21ms Sep 01 09:36:46 volumio volumio[2495]: verbose: ControllerMpd::parseTrackInfo Sep 01 09:36:46 volumio volumio[2495]: info: ControllerMpd::pushState Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::servicePushState Sep 01 09:36:46 volumio volumio[2495]: In UPNP mode Sep 01 09:36:46 volumio volumio[2495]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"790 Kbps","isStreaming":false,"title":"Family","artist":"小野リサ","album":"Soul & Bossa","uri":"http://aqqmusic.tc.qq.com/F000000lfIuG1SU6bY.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=4416E2CFFB78D7AFEEA1D915B6A97567BE3563297C2DF0CC7C67A6847595253D9674ADD8A27B5D8A38BEA48741A5AD91A920D2EEB19C53C7&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Sep 01 09:36:46 volumio volumio[2495]: verbose: CURRENT POSITION 0 Sep 01 09:36:46 volumio volumio[2495]: info: CoreStateMachine::syncState stateService play Sep 01 09:36:46 volumio volumio[2495]: info: CoreStateMachine::syncState currentStatus play Sep 01 09:36:46 volumio volumio[2495]: info: Received an update from plugin. extracting info from payload Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 01 09:36:46 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:46 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:46 volumio volumio[2495]: info: ------------------------------ 38ms Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::volumioGetQueue Sep 01 09:36:46 volumio volumio[2495]: info: CoreStateMachine::getQueue Sep 01 09:36:46 volumio volumio[2495]: info: CorePlayQueue::getQueue Sep 01 09:36:46 volumio volumio[2495]: info: CoreCommandRouter::volumioGetQueue Sep 01 09:36:46 volumio volumio[2495]: info: CoreStateMachine::getQueue Sep 01 09:36:46 volumio volumio[2495]: info: CorePlayQueue::getQueue Sep 01 09:36:47 volumio volumio[2495]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Bruno%20Major/Nothing/89ad6b37-5c7b-4abf-b5c9-ff106a9b37ba.jpg' Sep 01 09:36:53 volumio volumio[2495]: info: Sep 01 09:36:53 volumio volumio[2495]: ---------------------------- MPD announces state update: player Sep 01 09:36:53 volumio volumio[2495]: info: ControllerMpd::getState Sep 01 09:36:53 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand status Sep 01 09:36:53 volumio volumio[2495]: verbose: ControllerMpd::parseState Sep 01 09:36:53 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 09:36:53 volumio volumio[2495]: verbose: ControllerMpd::parseTrackInfo Sep 01 09:36:53 volumio volumio[2495]: info: ControllerMpd::pushState Sep 01 09:36:53 volumio volumio[2495]: info: CoreCommandRouter::servicePushState Sep 01 09:36:53 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:53 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:53 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:53 volumio volumio[2495]: info: CorePlayQueue::getTrack 0 Sep 01 09:36:53 volumio volumio[2495]: 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":"Family","artist":"小野リサ","album":"Soul & Bossa","uri":"http://aqqmusic.tc.qq.com/F000000lfIuG1SU6bY.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=4416E2CFFB78D7AFEEA1D915B6A97567BE3563297C2DF0CC7C67A6847595253D9674ADD8A27B5D8A38BEA48741A5AD91A920D2EEB19C53C7&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Sep 01 09:36:53 volumio volumio[2495]: verbose: CURRENT POSITION 0 Sep 01 09:36:53 volumio volumio[2495]: info: CoreStateMachine::syncState stateService stop Sep 01 09:36:53 volumio volumio[2495]: info: CoreStateMachine::syncState currentStatus play Sep 01 09:36:53 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:53 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:53 volumio volumio[2495]: info: CoreStateMachine::stPlaybackTimer Sep 01 09:36:53 volumio volumio[2495]: info: ------------------------------ 27ms Sep 01 09:36:53 volumio volumio[2495]: info: CoreCommandRouter::volumioGetQueue Sep 01 09:36:53 volumio volumio[2495]: info: CoreStateMachine::getQueue Sep 01 09:36:53 volumio volumio[2495]: info: CorePlayQueue::getQueue Sep 01 09:36:53 volumio volumio[2495]: info: Clearing queue after UPNP request Sep 01 09:36:54 volumio volumio[2495]: info: CoreStateMachine::ClearQueue Sep 01 09:36:54 volumio volumio[2495]: info: CoreStateMachine::stop Sep 01 09:36:54 volumio volumio[2495]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 09:36:54 volumio volumio[2495]: UNSET VOLATILE Sep 01 09:36:54 volumio volumio[2495]: info: CorePlayQueue::clearPlayQueue Sep 01 09:36:54 volumio volumio[2495]: info: CorePlayQueue::saveQueue Sep 01 09:36:54 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:54 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:54 volumio volumio[2495]: info: CoreCommandRouter::volumioPushQueue Sep 01 09:36:54 volumio volumio[2495]: info: Sep 01 09:36:54 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:54 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:54 volumio volumio[2495]: info: Starting UPNP Playback Sep 01 09:36:54 volumio volumio[2495]: info: Preparing playback through UPNP Sep 01 09:36:54 volumio volumio[2495]: info: CoreCommandRouter::volumioGetState Sep 01 09:36:54 volumio volumio[2495]: info: CorePlayQueue::getTrack 0 Sep 01 09:36:54 volumio volumio[2495]: info: CoreStateMachine::setConsumeUpdateService mpd Sep 01 09:36:54 volumio volumio[2495]: error: updateQueue error: null Sep 01 09:36:54 volumio volumio[2495]: info: ------------------------------ 3ms Sep 01 09:36:54 volumio volumio[2495]: info: Sep 01 09:36:54 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:54 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:54 volumio volumio[2495]: info: Sep 01 09:36:54 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:54 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:54 volumio volumio[2495]: info: ------------------------------ 4ms Sep 01 09:36:54 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:54 volumio volumio[2495]: info: Sep 01 09:36:54 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:54 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:54 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:54 volumio volumio[2495]: info: Sep 01 09:36:54 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:54 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:54 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:54 volumio volumio[2495]: info: Sep 01 09:36:54 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:54 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:54 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:54 volumio volumio[2495]: info: Sep 01 09:36:54 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:54 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:54 volumio volumio[2495]: info: ------------------------------ 1ms Sep 01 09:36:56 volumio volumio[2495]: info: Sep 01 09:36:56 volumio volumio[2495]: ---------------------------- MPD announces state update: player Sep 01 09:36:56 volumio volumio[2495]: info: ControllerMpd::getState Sep 01 09:36:56 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand status Sep 01 09:36:56 volumio volumio[2495]: info: Sep 01 09:36:56 volumio volumio[2495]: ---------------------------- MPD announces state update: player Sep 01 09:36:56 volumio volumio[2495]: info: ControllerMpd::getState Sep 01 09:36:56 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand status Sep 01 09:36:56 volumio volumio[2495]: verbose: ControllerMpd::parseState Sep 01 09:36:56 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 09:36:56 volumio volumio[2495]: info: Sep 01 09:36:56 volumio volumio[2495]: ---------------------------- MPD announces system playlist update Sep 01 09:36:56 volumio volumio[2495]: info: Ignoring MPD Status Update Sep 01 09:36:56 volumio volumio[2495]: verbose: ControllerMpd::parseState Sep 01 09:36:56 volumio volumio[2495]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 01 09:36:56 volumio volumio[2495]: verbose: ControllerMpd::parseTrackInfo Sep 01 09:36:56 volumio volumio[2495]: info: ControllerMpd::pushState Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::servicePushState Sep 01 09:36:56 volumio volumio[2495]: In UPNP mode Sep 01 09:36:56 volumio volumio[2495]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"693 Kbps","isStreaming":false,"title":"For Once In My Life","artist":"小野リサ","album":"Soul & Bossa","uri":"http://aqqmusic.tc.qq.com/F000000HeFiM1BfHWd.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=A8CB44A71EAB2BF2E6C4F999006FC61640042679199167347D2498CE53B96AD61C5579165CF672990C3E6CD96983E65BC6A54371EEA15F0F&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Sep 01 09:36:56 volumio volumio[2495]: verbose: CURRENT POSITION 0 Sep 01 09:36:56 volumio volumio[2495]: info: CoreStateMachine::syncState stateService play Sep 01 09:36:56 volumio volumio[2495]: info: CoreStateMachine::syncState currentStatus stop Sep 01 09:36:56 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:56 volumio volumio[2495]: info: ------------------------------ 12ms Sep 01 09:36:56 volumio volumio[2495]: info: ------------------------------ 8ms Sep 01 09:36:56 volumio volumio[2495]: verbose: ControllerMpd::parseTrackInfo Sep 01 09:36:56 volumio volumio[2495]: info: ControllerMpd::pushState Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::servicePushState Sep 01 09:36:56 volumio volumio[2495]: In UPNP mode Sep 01 09:36:56 volumio volumio[2495]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"771 Kbps","isStreaming":false,"title":"For Once In My Life","artist":"小野リサ","album":"Soul & Bossa","uri":"http://aqqmusic.tc.qq.com/F000000HeFiM1BfHWd.flac?guid=0000000004cb49d2000001871e73f5cf&vkey=A8CB44A71EAB2BF2E6C4F999006FC61640042679199167347D2498CE53B96AD61C5579165CF672990C3E6CD96983E65BC6A54371EEA15F0F&uin=1259438298&redirect=1&fromtag=111114","trackType":""} Sep 01 09:36:56 volumio volumio[2495]: verbose: CURRENT POSITION 0 Sep 01 09:36:56 volumio volumio[2495]: info: CoreStateMachine::syncState stateService play Sep 01 09:36:56 volumio volumio[2495]: info: CoreStateMachine::syncState currentStatus play Sep 01 09:36:56 volumio volumio[2495]: info: Received an update from plugin. extracting info from payload Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Sep 01 09:36:56 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:56 volumio volumio[2495]: info: CoreStateMachine::pushState Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::volumioPushState Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 09:36:56 volumio volumio[2495]: info: ------------------------------ 19ms Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::volumioGetQueue Sep 01 09:36:56 volumio volumio[2495]: info: CoreStateMachine::getQueue Sep 01 09:36:56 volumio volumio[2495]: info: CorePlayQueue::getQueue Sep 01 09:36:56 volumio volumio[2495]: info: CoreCommandRouter::volumioGetQueue Sep 01 09:36:56 volumio volumio[2495]: info: CoreStateMachine::getQueue Sep 01 09:36:56 volumio volumio[2495]: info: CorePlayQueue::getQueue Sep 01 09:37:09 volumio dhcpcd[1006]: eth0: adding route to 192.168.3.0/24 Sep 01 09:37:09 volumio dhcpcd[1006]: eth0: adding default route via 192.168.3.101 Sep 01 09:37:09 volumio dhcpcd[1006]: eth0: ipv4_addroute: File exists Sep 01 09:37:09 volumio dhcpcd[1006]: eth0: removing route to 192.168.3.0/24 Sep 01 09:37:16 volumio volumio[2495]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 09:37:16 volumio volumio[2495]: { Error: connect ETIMEDOUT 108.160.169.186:443 Sep 01 09:37:16 volumio volumio[2495]: at Object._errnoException (util.js:1022:11) Sep 01 09:37:16 volumio volumio[2495]: at _exceptionWithHostPort (util.js:1044:20) Sep 01 09:37:16 volumio volumio[2495]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Sep 01 09:37:16 volumio volumio[2495]: code: 'ETIMEDOUT', Sep 01 09:37:16 volumio volumio[2495]: errno: 'ETIMEDOUT', Sep 01 09:37:16 volumio volumio[2495]: syscall: 'connect', Sep 01 09:37:16 volumio volumio[2495]: address: '108.160.169.186', Sep 01 09:37:16 volumio volumio[2495]: port: 443 } Sep 01 09:37:16 volumio volumio[2495]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 09:37:17 volumio sudo[5558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-01 09:36 Sep 01 09:37:17 volumio sudo[5558]: 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="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 15:00:46 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="b3401e25b8d19b16b1038c2843d2deaf"