-- Logs begin at Fri 2025-05-09 19:04:02 CST, end at Fri 2025-05-09 21:03:30 CST. -- May 09 21:02:04 volumio volumio[31584]: info: MyVolumio login type: Token May 09 21:02:05 volumio volumio[31584]: info: CoreCommandRouter::volumioSeek May 09 21:02:05 volumio volumio[31584]: info: CoreStateMachine::seek May 09 21:02:05 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:05 volumio volumio[31584]: [542B blob data] May 09 21:02:05 volumio volumio[31584]: info: CoreStateMachine::startPlaybackTimer May 09 21:02:05 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:05 volumio volumio[31584]: info: [1746795725353] ControllerUPNPBrowser::seek May 09 21:02:05 volumio volumio[31584]: info: ControllerMpd::seek May 09 21:02:05 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:05 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 21:02:05 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:05 volumio volumio[31584]: error: null May 09 21:02:05 volumio volumio[31584]: info: May 09 21:02:05 volumio volumio[31584]: ---------------------------- MPD announces state update: player May 09 21:02:05 volumio volumio[31584]: info: ControllerMpd::getState May 09 21:02:05 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand status May 09 21:02:05 volumio volumio[31584]: info: sendMpdCommand status took 1 milliseconds May 09 21:02:05 volumio volumio[31584]: verbose: ControllerMpd::parseState May 09 21:02:05 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 21:02:05 volumio volumio[31584]: info: sendMpdCommand playlistinfo took 0 milliseconds May 09 21:02:05 volumio volumio[31584]: verbose: ControllerMpd::parseTrackInfo May 09 21:02:05 volumio volumio[31584]: info: ControllerMpd::pushState May 09 21:02:05 volumio volumio[31584]: info: CoreCommandRouter::servicePushState May 09 21:02:05 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:05 volumio volumio[31584]: [405B blob data] May 09 21:02:05 volumio volumio[31584]: verbose: CURRENT POSITION 0 May 09 21:02:05 volumio volumio[31584]: info: CoreStateMachine::syncState stateService play May 09 21:02:05 volumio volumio[31584]: info: CoreStateMachine::syncState currentStatus play May 09 21:02:05 volumio volumio[31584]: info: Received an update from plugin. extracting info from payload May 09 21:02:05 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:05 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:05 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:05 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:05 volumio volumio[31584]: info: ------------------------------ 7ms May 09 21:02:06 volumio volumio[31584]: info: CoreCommandRouter::volumioSeek May 09 21:02:06 volumio volumio[31584]: info: CoreStateMachine::seek May 09 21:02:06 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:06 volumio volumio[31584]: [542B blob data] May 09 21:02:06 volumio volumio[31584]: info: CoreStateMachine::startPlaybackTimer May 09 21:02:06 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:06 volumio volumio[31584]: info: [1746795726506] ControllerUPNPBrowser::seek May 09 21:02:06 volumio volumio[31584]: info: ControllerMpd::seek May 09 21:02:06 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:06 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:06 volumio volumio[31584]: error: null May 09 21:02:06 volumio volumio[31584]: info: May 09 21:02:06 volumio volumio[31584]: ---------------------------- MPD announces state update: player May 09 21:02:06 volumio volumio[31584]: info: ControllerMpd::getState May 09 21:02:06 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand status May 09 21:02:06 volumio volumio[31584]: info: sendMpdCommand status took 0 milliseconds May 09 21:02:06 volumio volumio[31584]: verbose: ControllerMpd::parseState May 09 21:02:06 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 21:02:06 volumio volumio[31584]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 21:02:06 volumio volumio[31584]: verbose: ControllerMpd::parseTrackInfo May 09 21:02:06 volumio volumio[31584]: info: ControllerMpd::pushState May 09 21:02:06 volumio volumio[31584]: info: CoreCommandRouter::servicePushState May 09 21:02:06 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:06 volumio volumio[31584]: [405B blob data] May 09 21:02:06 volumio volumio[31584]: verbose: CURRENT POSITION 0 May 09 21:02:06 volumio volumio[31584]: info: CoreStateMachine::syncState stateService play May 09 21:02:06 volumio volumio[31584]: info: CoreStateMachine::syncState currentStatus play May 09 21:02:06 volumio volumio[31584]: info: Received an update from plugin. extracting info from payload May 09 21:02:06 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:06 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:06 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:06 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:06 volumio volumio[31584]: info: ------------------------------ 7ms May 09 21:02:11 volumio volumio[31584]: info: CoreCommandRouter::volumioGetState May 09 21:02:31 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 09 21:02:31 volumio volumio[31584]: info: Preload queue cleared May 09 21:02:31 volumio volumio[31584]: info: Preloading song: upnp/http://192.168.1.42:8200/ctl/ContentDir@1$7$43$0 May 09 21:02:31 volumio volumio[31584]: info: Preloading song: upnp/http://192.168.1.42:8200/ctl/ContentDir@1$7$43$1 May 09 21:02:31 volumio volumio[31584]: info: Exploding uri upnp/http://192.168.1.42:8200/ctl/ContentDir@1$7$43$0 in service upnp_browser May 09 21:02:31 volumio volumio[31584]: info: Exploding uri upnp/http://192.168.1.42:8200/ctl/ContentDir@1$7$43$1 in service upnp_browser May 09 21:02:31 volumio volumio[31584]: info: No valid Plugin REST Endpoint May 09 21:02:31 volumio volumio[31584]: info: No valid Plugin REST Endpoint May 09 21:02:33 volumio volumio[31584]: info: Preload queue cleared May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioReplaceandPlayItems May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::ClearQueue May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::stop May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::stPlaybackTimer May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::updateTrackBlock May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getTrackBlock May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::serviceStop May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::serviceStop May 09 21:02:33 volumio volumio[31584]: info: [1746795753492] ControllerUPNPBrowser::stop May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand stop May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::clearPlayQueue May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::saveQueue May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioPushQueue May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::addQueueItems May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::addQueueItems May 09 21:02:33 volumio volumio[31584]: info: Preload queue cleared May 09 21:02:33 volumio volumio[31584]: info: Adding Item to queue: upnp/folder/http://192.168.1.42:8200/ctl/ContentDir@1$7$43 May 09 21:02:33 volumio volumio[31584]: info: Exploding uri upnp/folder/http://192.168.1.42:8200/ctl/ContentDir@1$7$43 in service upnp_browser May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioPushQueue May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::saveQueue May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::updateTrackBlock May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getTrackBlock May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioPlay May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::play index 0 May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::stop May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::play index undefined May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::startPlaybackTimer May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:33 volumio volumio[31584]: info: [1746795753502] ControllerUPNPBrowser::clearAddPlayTrack May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand stop May 09 21:02:33 volumio volumio[31584]: info: May 09 21:02:33 volumio volumio[31584]: ---------------------------- MPD announces state update: player May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand stop took 11 milliseconds May 09 21:02:33 volumio volumio[31584]: info: ControllerMpd::getState May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand status May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand stop took 1 milliseconds May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand clear May 09 21:02:33 volumio volumio[31584]: info: May 09 21:02:33 volumio volumio[31584]: ---------------------------- MPD announces system playlist update May 09 21:02:33 volumio volumio[31584]: info: Ignoring MPD Status Update May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand status took 1 milliseconds May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand clear took 1 milliseconds May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::parseState May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.42:8200/MediaItems/796.mp3" May 09 21:02:33 volumio volumio[31584]: error: updateQueue error: null May 09 21:02:33 volumio volumio[31584]: info: ------------------------------ 1ms May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::parseTrackInfo May 09 21:02:33 volumio volumio[31584]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 09 21:02:33 volumio volumio[31584]: info: ------------------------------ 2ms May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.42:8200/MediaItems/796.mp3" May 09 21:02:33 volumio volumio[31584]: info: May 09 21:02:33 volumio volumio[31584]: ---------------------------- MPD announces system playlist update May 09 21:02:33 volumio volumio[31584]: info: Ignoring MPD Status Update May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand add "http://192.168.1.42:8200/MediaItems/796.mp3" took 1 milliseconds May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::setConsumeUpdateService mpd May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand play May 09 21:02:33 volumio volumio[31584]: info: ------------------------------ 0ms May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand play took 0 milliseconds May 09 21:02:33 volumio volumio[31584]: info: May 09 21:02:33 volumio volumio[31584]: ---------------------------- MPD announces state update: player May 09 21:02:33 volumio volumio[31584]: info: ControllerMpd::getState May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand status May 09 21:02:33 volumio kernel: cma_alloc: 2 callbacks suppressed May 09 21:02:33 volumio kernel: cma: cma_alloc: linux,cma: alloc failed, req-size: 2 pages, ret: -12 May 09 21:02:33 volumio kernel: cma: cma_alloc: linux,cma: alloc failed, req-size: 2 pages, ret: -12 May 09 21:02:33 volumio kernel: cma: cma_alloc: linux,cma: alloc failed, req-size: 2 pages, ret: -12 May 09 21:02:33 volumio kernel: cma: cma_alloc: linux,cma: alloc failed, req-size: 2 pages, ret: -12 May 09 21:02:33 volumio kernel: cma: cma_alloc: linux,cma: alloc failed, req-size: 2 pages, ret: -12 May 09 21:02:33 volumio kernel: cma: cma_alloc: linux,cma: alloc failed, req-size: 2 pages, ret: -12 May 09 21:02:33 volumio kernel: cma: cma_alloc: linux,cma: alloc failed, req-size: 2 pages, ret: -12 May 09 21:02:33 volumio kernel: cma: cma_alloc: linux,cma: alloc failed, req-size: 2 pages, ret: -12 May 09 21:02:33 volumio kernel: cma: cma_alloc: linux,cma: alloc failed, req-size: 2 pages, ret: -12 May 09 21:02:33 volumio kernel: cma: cma_alloc: linux,cma: alloc failed, req-size: 2 pages, ret: -12 May 09 21:02:33 volumio volumio[31584]: info: May 09 21:02:33 volumio volumio[31584]: ---------------------------- MPD announces state update: player May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand status took 6 milliseconds May 09 21:02:33 volumio volumio[31584]: info: ControllerMpd::getState May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand status May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::parseState May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand status took 0 milliseconds May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand playlistinfo took 0 milliseconds May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::parseState May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::parseTrackInfo May 09 21:02:33 volumio volumio[31584]: info: ControllerMpd::pushState May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::servicePushState May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:33 volumio volumio[31584]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"796.mp3","artist":null,"album":null,"uri":"http://192.168.1.42:8200/MediaItems/796.mp3","trackType":"mp3"} May 09 21:02:33 volumio volumio[31584]: verbose: CURRENT POSITION 0 May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::syncState stateService play May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::syncState currentStatus stop May 09 21:02:33 volumio volumio[31584]: info: ------------------------------ 8ms May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand playlistinfo took 1 milliseconds May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::parseTrackInfo May 09 21:02:33 volumio volumio[31584]: info: ControllerMpd::pushState May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::servicePushState May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:33 volumio volumio[31584]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"796.mp3","artist":null,"album":null,"uri":"http://192.168.1.42:8200/MediaItems/796.mp3","trackType":"mp3"} May 09 21:02:33 volumio volumio[31584]: verbose: CURRENT POSITION 0 May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::syncState stateService play May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::syncState currentStatus play May 09 21:02:33 volumio volumio[31584]: info: Received an update from plugin. extracting info from payload May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:33 volumio volumio[31584]: info: ------------------------------ 8ms May 09 21:02:33 volumio volumio[31584]: info: May 09 21:02:33 volumio volumio[31584]: ---------------------------- MPD announces system playlist update May 09 21:02:33 volumio volumio[31584]: info: Ignoring MPD Status Update May 09 21:02:33 volumio volumio[31584]: info: May 09 21:02:33 volumio volumio[31584]: ---------------------------- MPD announces state update: player May 09 21:02:33 volumio volumio[31584]: info: ControllerMpd::getState May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand status May 09 21:02:33 volumio volumio[31584]: info: ------------------------------ 2ms May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand status took 2 milliseconds May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::parseState May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 09 21:02:33 volumio volumio[31584]: info: sendMpdCommand playlistinfo took 0 milliseconds May 09 21:02:33 volumio volumio[31584]: verbose: ControllerMpd::parseTrackInfo May 09 21:02:33 volumio volumio[31584]: info: ControllerMpd::pushState May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::servicePushState May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getTrack 0 May 09 21:02:33 volumio volumio[31584]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":272,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"出嫁","artist":"张清芳","album":"一人一首成名曲(港台版)CD4","uri":"http://192.168.1.42:8200/MediaItems/796.mp3","trackType":"mp3"} May 09 21:02:33 volumio volumio[31584]: verbose: CURRENT POSITION 0 May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::syncState stateService play May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::syncState currentStatus play May 09 21:02:33 volumio volumio[31584]: info: Received an update from plugin. extracting info from payload May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::pushState May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioPushState May 09 21:02:33 volumio volumio[31584]: info: ------------------------------ 12ms May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioGetQueue May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::getQueue May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getQueue May 09 21:02:33 volumio volumio[31584]: info: CoreCommandRouter::volumioGetQueue May 09 21:02:33 volumio volumio[31584]: info: CoreStateMachine::getQueue May 09 21:02:33 volumio volumio[31584]: info: CorePlayQueue::getQueue May 09 21:02:34 volumio volumio[31584]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 09 21:02:34 volumio volumio[31584]: info: Retrying Login Due to Network Error May 09 21:02:44 volumio volumio[31584]: info: MyVolumio login type: Token May 09 21:03:14 volumio volumio[31584]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 09 21:03:14 volumio volumio[31584]: info: Retrying Login Due to Network Error May 09 21:03:19 volumio dhcpcd[1073]: eth0: carrier lost May 09 21:03:19 volumio dhcpcd[1333]: eth0: carrier lost May 09 21:03:19 volumio kernel: macb 1f00100000.ethernet eth0: Link is Down May 09 21:03:19 volumio dhcpcd[1073]: eth0: deleting route to 192.168.1.0/24 May 09 21:03:19 volumio avahi-daemon[758]: Withdrawing address record for 192.168.1.43 on eth0. May 09 21:03:19 volumio avahi-daemon[758]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.43. May 09 21:03:19 volumio avahi-daemon[758]: Interface eth0.IPv4 no longer relevant for mDNS. May 09 21:03:19 volumio volumio[31584]: info: Discovery: A device disappeared from network May 09 21:03:19 volumio volumio[31584]: info: Discovery: Device volumio disappeared from network May 09 21:03:19 volumio dhcpcd[1333]: eth0: deleting route to 192.168.1.0/24 May 09 21:03:19 volumio ifplugd(eth0)[963]: Link beat lost. May 09 21:03:20 volumio ntpd[945]: Deleting interface #3 eth0, 192.168.1.43#123, interface stats: received=432, sent=473, dropped=0, active_time=11410 secs May 09 21:03:20 volumio ntpd[945]: 116.203.151.74 local addr 192.168.1.43 -> May 09 21:03:20 volumio ntpd[945]: 162.159.200.1 local addr 192.168.1.43 -> May 09 21:03:20 volumio ntpd[945]: 211.68.71.26 local addr 192.168.1.43 -> May 09 21:03:20 volumio ntpd[945]: 193.182.111.14 local addr 192.168.1.43 -> May 09 21:03:20 volumio ntpd[945]: 119.28.206.193 local addr 192.168.1.43 -> May 09 21:03:20 volumio ntpd[945]: 193.182.111.142 local addr 192.168.1.43 -> May 09 21:03:21 volumio ntpd[945]: Soliciting pool server 240e:980:b65:e900:bd10:673a:3f2a:f0e2 May 09 21:03:22 volumio dhcpcd[1073]: eth0: carrier acquired May 09 21:03:22 volumio dhcpcd[1333]: eth0: carrier acquired May 09 21:03:22 volumio kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control tx May 09 21:03:22 volumio dhcpcd[1073]: eth0: IAID 67:f5:6a:71 May 09 21:03:22 volumio dhcpcd[1333]: eth0: IAID 67:f5:6a:71 May 09 21:03:22 volumio dhcpcd[1333]: eth0: rebinding lease of 192.168.1.43 May 09 21:03:22 volumio dhcpcd[1333]: eth0: probing address 192.168.1.43/24 May 09 21:03:22 volumio dhcpcd[1073]: eth0: rebinding lease of 192.168.1.43 May 09 21:03:22 volumio dhcpcd[1333]: eth0: soliciting an IPv6 router May 09 21:03:22 volumio dhcpcd[1073]: eth0: probing address 192.168.1.43/24 May 09 21:03:23 volumio ifplugd(eth0)[963]: Link beat detected. May 09 21:03:23 volumio dhcpcd[1073]: eth0: soliciting an IPv6 router May 09 21:03:24 volumio volumio[31584]: info: Volumio Network Manager: Network status updated: 2 May 09 21:03:24 volumio volumio[31584]: info: MyVolumio login type: Token May 09 21:03:27 volumio dhcpcd[1333]: eth0: leased 192.168.1.43 for 259200 seconds May 09 21:03:27 volumio dhcpcd[1333]: eth0: adding route to 192.168.1.0/24 May 09 21:03:27 volumio dhcpcd[1333]: eth0: adding default route via 192.168.1.1 May 09 21:03:27 volumio avahi-daemon[758]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.43. May 09 21:03:27 volumio avahi-daemon[758]: New relevant interface eth0.IPv4 for mDNS. May 09 21:03:27 volumio avahi-daemon[758]: Registering new address record for 192.168.1.43 on eth0.IPv4. May 09 21:03:27 volumio dhcpcd[1073]: eth0: leased 192.168.1.43 for 259200 seconds May 09 21:03:27 volumio dhcpcd[1073]: eth0: adding route to 192.168.1.0/24 May 09 21:03:27 volumio dhcpcd[1073]: eth0: adding default route via 192.168.1.1 May 09 21:03:28 volumio ntpd[945]: receive: Unexpected origin timestamp 0xebc87b9f.f5dad45a does not match aorg 0000000000.00000000 from server@119.28.206.193 xmt 0xebc87b9f.e265f68e May 09 21:03:28 volumio ntpd[945]: receive: Unexpected origin timestamp 0xebc87b9f.f5da6212 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xebc87b9f.f3cad62a May 09 21:03:28 volumio ntpd[945]: receive: Unexpected origin timestamp 0xebc87b9f.f5d74d8d does not match aorg 0000000000.00000000 from server@116.203.151.74 xmt 0xebc87b9f.faadf2b0 May 09 21:03:28 volumio volumio[31584]: info: Discovery: adding ed840cff-2e00-4435-93b8-078dd1d0064e May 09 21:03:28 volumio volumio[31584]: info: Discovery: Found device Volumio May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::volumioGetState May 09 21:03:28 volumio volumio[31584]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.8 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 May 09 21:03:28 volumio volumio[31584]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.8 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 May 09 21:03:28 volumio volumio[31584]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.8 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 May 09 21:03:28 volumio volumio[31584]: verbose: New Socket.io Connection to 192.168.1.44 from 192.168.1.8 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 7 May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::volumioGetState May 09 21:03:28 volumio volumio[31584]: info: Received Get System Info May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 21:03:28 volumio volumio[31584]: info: Discovery: Getting this device information May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::volumioGetState May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::volumioGetState May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::volumioGetVisibleSources May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::volumioGetState May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::volumioGetState May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 09 21:03:28 volumio volumio[31584]: info: Received Get System Info May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 21:03:28 volumio volumio[31584]: info: Discovery: Getting this device information May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::volumioGetState May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::volumioGetState May 09 21:03:28 volumio volumio[31584]: info: Listing playlists May 09 21:03:28 volumio volumio[31584]: info: CoreCommandRouter::volumioGetQueue May 09 21:03:28 volumio volumio[31584]: info: CoreStateMachine::getQueue May 09 21:03:28 volumio volumio[31584]: info: CorePlayQueue::getQueue May 09 21:03:28 volumio ntpd[945]: Listen normally on 5 eth0 192.168.1.43:123 May 09 21:03:28 volumio ntpd[945]: 211.68.71.26 local addr 192.168.1.44 -> 192.168.1.43 May 09 21:03:28 volumio ntpd[945]: 193.182.111.14 local addr 192.168.1.44 -> 192.168.1.43 May 09 21:03:28 volumio ntpd[945]: 193.182.111.142 local addr 192.168.1.44 -> 192.168.1.43 May 09 21:03:28 volumio ntpd[945]: new interface(s) found: waking up resolver May 09 21:03:29 volumio volumio[31584]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 21:03:29 volumio volumio[31584]: Error: connect ETIMEDOUT 185.60.219.36:443 May 09 21:03:29 volumio volumio[31584]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 09 21:03:29 volumio volumio[31584]: errno: -110, May 09 21:03:29 volumio volumio[31584]: code: 'ETIMEDOUT', May 09 21:03:29 volumio volumio[31584]: syscall: 'connect', May 09 21:03:29 volumio volumio[31584]: address: '185.60.219.36', May 09 21:03:29 volumio volumio[31584]: port: 443 May 09 21:03:29 volumio volumio[31584]: } May 09 21:03:29 volumio volumio[31584]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 21:03:30 volumio sudo[812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-09 21:02 May 09 21:03:30 volumio sudo[812]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"