-- Logs begin at Mon 2025-07-07 16:05:22 HKT, end at Mon 2025-07-07 16:41:51 HKT. -- Jul 07 16:40:28 volumio volumio[694]: error: Upnp client error: Error: This socket has been ended by the other party Jul 07 16:40:30 volumio volumio[694]: info: Jul 07 16:40:30 volumio volumio[694]: ---------------------------- MPD announces state update: player Jul 07 16:40:30 volumio volumio[694]: info: ControllerMpd::getState Jul 07 16:40:30 volumio volumio[694]: verbose: ControllerMpd::sendMpdCommand status Jul 07 16:40:30 volumio volumio[694]: info: sendMpdCommand status took 2 milliseconds Jul 07 16:40:30 volumio volumio[694]: verbose: ControllerMpd::parseState Jul 07 16:40:30 volumio volumio[694]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 07 16:40:30 volumio volumio[694]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 07 16:40:30 volumio volumio[694]: verbose: ControllerMpd::parseTrackInfo Jul 07 16:40:30 volumio volumio[694]: info: ControllerMpd::pushState Jul 07 16:40:30 volumio volumio[694]: info: CoreCommandRouter::servicePushState Jul 07 16:40:30 volumio volumio[694]: info: CoreStateMachine::pushState Jul 07 16:40:30 volumio volumio[694]: info: CoreCommandRouter::volumioPushState Jul 07 16:40:30 volumio volumio[694]: info: CorePlayQueue::getTrack 0 Jul 07 16:40:30 volumio volumio[694]: 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":"点燃一根烟","artist":"林玉英","album":null,"uri":"http://aqqmusic.tc.qq.com/M500001viM2f2alzSo.mp3?guid=0000000000650f6100000197d9fbe7af&vkey=F58C88EBA83E983F057EFA41D2C7FE723FFCBCEDDB35A3AF4B4D339076DE35E7D08882E58954FDBCB1A2457E6F6608C96D8AF79EA5AA80EC__v21530b7ce&uin=1152921504711373713&src=M500004JOQP733SZx9.mp3&redirect=1&fromtag=111042","trackType":""} Jul 07 16:40:30 volumio volumio[694]: verbose: CURRENT POSITION 0 Jul 07 16:40:30 volumio volumio[694]: info: CoreStateMachine::syncState stateService stop Jul 07 16:40:30 volumio volumio[694]: info: CoreStateMachine::syncState currentStatus play Jul 07 16:40:30 volumio volumio[694]: info: CoreCommandRouter::volumioPushState Jul 07 16:40:30 volumio volumio[694]: info: CoreStateMachine::stPlaybackTimer Jul 07 16:40:30 volumio volumio[694]: info: ------------------------------ 28ms Jul 07 16:40:30 volumio volumio[694]: info: Clearing queue after UPNP request Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::ClearQueue Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::stop Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 07 16:40:31 volumio volumio[694]: info: CorePlayQueue::clearPlayQueue Jul 07 16:40:31 volumio volumio[694]: info: CorePlayQueue::saveQueue Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioPushState Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioPushQueue Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces system playlist update Jul 07 16:40:31 volumio volumio[694]: info: Ignoring MPD Status Update Jul 07 16:40:31 volumio volumio[694]: error: updateQueue error: null Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 3ms Jul 07 16:40:31 volumio volumio[694]: info: Starting UPNP Playback Jul 07 16:40:31 volumio volumio[694]: info: Preparing playback through UPNP Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioGetState Jul 07 16:40:31 volumio volumio[694]: info: CorePlayQueue::getTrack 0 Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces system playlist update Jul 07 16:40:31 volumio volumio[694]: info: Ignoring MPD Status Update Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces system playlist update Jul 07 16:40:31 volumio volumio[694]: info: Ignoring MPD Status Update Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 4ms Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 3ms Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces system playlist update Jul 07 16:40:31 volumio volumio[694]: info: Ignoring MPD Status Update Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 3ms Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces system playlist update Jul 07 16:40:31 volumio volumio[694]: info: Ignoring MPD Status Update Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 2ms Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces system playlist update Jul 07 16:40:31 volumio volumio[694]: info: Ignoring MPD Status Update Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 2ms Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces system playlist update Jul 07 16:40:31 volumio volumio[694]: info: Ignoring MPD Status Update Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 2ms Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces state update: player Jul 07 16:40:31 volumio volumio[694]: info: ControllerMpd::getState Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::sendMpdCommand status Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces state update: player Jul 07 16:40:31 volumio volumio[694]: info: ControllerMpd::getState Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::sendMpdCommand status Jul 07 16:40:31 volumio volumio[694]: info: sendMpdCommand status took 3 milliseconds Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::parseState Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 07 16:40:31 volumio volumio[694]: info: sendMpdCommand status took 4 milliseconds Jul 07 16:40:31 volumio volumio[694]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::parseState Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::parseTrackInfo Jul 07 16:40:31 volumio volumio[694]: info: ControllerMpd::pushState Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::servicePushState Jul 07 16:40:31 volumio volumio[694]: verbose: In UPNP mode Jul 07 16:40:31 volumio volumio[694]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"问情","artist":"蔡幸娟","album":"蔡幸娟精粹集2","uri":"http://aqqmusic.tc.qq.com/M500002fJ1hD1FfbmI.mp3?guid=0000000000650f6100000197d9fbe7af&vkey=2848B8FAE3D4B6A9CD525702C3DFFDE6621A85544BDAF2C60186D19CDF35D33934BF36157628CCC79743209CAC4C332683560B0BD55816EF__v215257dfd&uin=1152921504711373713&redirect=1&fromtag=111042","trackType":""} Jul 07 16:40:31 volumio volumio[694]: verbose: CURRENT POSITION 0 Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::syncState stateService play Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::syncState currentStatus stop Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 16ms Jul 07 16:40:31 volumio volumio[694]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::parseTrackInfo Jul 07 16:40:31 volumio volumio[694]: info: ControllerMpd::pushState Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::servicePushState Jul 07 16:40:31 volumio volumio[694]: verbose: In UPNP mode Jul 07 16:40:31 volumio volumio[694]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"问情","artist":"蔡幸娟","album":"蔡幸娟精粹集2","uri":"http://aqqmusic.tc.qq.com/M500002fJ1hD1FfbmI.mp3?guid=0000000000650f6100000197d9fbe7af&vkey=2848B8FAE3D4B6A9CD525702C3DFFDE6621A85544BDAF2C60186D19CDF35D33934BF36157628CCC79743209CAC4C332683560B0BD55816EF__v215257dfd&uin=1152921504711373713&redirect=1&fromtag=111042","trackType":""} Jul 07 16:40:31 volumio volumio[694]: verbose: CURRENT POSITION 0 Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::syncState stateService play Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::syncState currentStatus play Jul 07 16:40:31 volumio volumio[694]: info: Received an update from plugin. extracting info from payload Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::pushState Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioPushState Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::pushState Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioPushState Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 40ms Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces system playlist update Jul 07 16:40:31 volumio volumio[694]: info: Ignoring MPD Status Update Jul 07 16:40:31 volumio volumio[694]: info: Jul 07 16:40:31 volumio volumio[694]: ---------------------------- MPD announces state update: player Jul 07 16:40:31 volumio volumio[694]: info: ControllerMpd::getState Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::sendMpdCommand status Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioGetQueue Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::getQueue Jul 07 16:40:31 volumio volumio[694]: info: CorePlayQueue::getQueue Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioGetQueue Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::getQueue Jul 07 16:40:31 volumio volumio[694]: info: CorePlayQueue::getQueue Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 21ms Jul 07 16:40:31 volumio volumio[694]: info: sendMpdCommand status took 19 milliseconds Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::parseState Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 07 16:40:31 volumio volumio[694]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 07 16:40:31 volumio volumio[694]: verbose: ControllerMpd::parseTrackInfo Jul 07 16:40:31 volumio volumio[694]: info: ControllerMpd::pushState Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::servicePushState Jul 07 16:40:31 volumio volumio[694]: verbose: In UPNP mode Jul 07 16:40:31 volumio volumio[694]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":255,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"问情","artist":"蔡幸娟","album":"蔡幸娟精粹集2","uri":"http://aqqmusic.tc.qq.com/M500002fJ1hD1FfbmI.mp3?guid=0000000000650f6100000197d9fbe7af&vkey=2848B8FAE3D4B6A9CD525702C3DFFDE6621A85544BDAF2C60186D19CDF35D33934BF36157628CCC79743209CAC4C332683560B0BD55816EF__v215257dfd&uin=1152921504711373713&redirect=1&fromtag=111042","trackType":""} Jul 07 16:40:31 volumio volumio[694]: verbose: CURRENT POSITION 0 Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::syncState stateService play Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::syncState currentStatus play Jul 07 16:40:31 volumio volumio[694]: info: Received an update from plugin. extracting info from payload Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::pushState Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioPushState Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::pushState Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioPushState Jul 07 16:40:31 volumio volumio[694]: info: ------------------------------ 56ms Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioGetQueue Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::getQueue Jul 07 16:40:31 volumio volumio[694]: info: CorePlayQueue::getQueue Jul 07 16:40:31 volumio volumio[694]: info: CoreCommandRouter::volumioGetQueue Jul 07 16:40:31 volumio volumio[694]: info: CoreStateMachine::getQueue Jul 07 16:40:31 volumio volumio[694]: info: CorePlayQueue::getQueue Jul 07 16:40:37 volumio volumio[1033]: 30 Jul 07 16:40:38 volumio volumio[1033]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 07 16:40:38 volumio volumio[1033]: Dload Upload Total Spent Left Speed Jul 07 16:40:38 volumio volumio[694]: info: Jul 07 16:40:38 volumio volumio[694]: ---------------------------- Client requests Volume 30 Jul 07 16:40:38 volumio volumio[694]: info: VolumeController::SetAlsaVolume30 Jul 07 16:40:38 volumio volumio[694]: info: CoreStateMachine::pushState Jul 07 16:40:38 volumio volumio[694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 16:40:38 volumio volumio[694]: info: CoreCommandRouter::volumioPushState Jul 07 16:40:38 volumio volumio[694]: info: CoreCommandRouter::volumioGetQueue Jul 07 16:40:38 volumio volumio[694]: info: CoreStateMachine::getQueue Jul 07 16:40:38 volumio volumio[694]: info: CorePlayQueue::getQueue Jul 07 16:40:38 volumio volumio[1033]: [237B blob data] Jul 07 16:40:38 volumio volumio[1033]: {"time":1751877638044,"response":"volume Success"}30 Jul 07 16:40:39 volumio volumio[1033]: 40 Jul 07 16:40:39 volumio volumio[1033]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 07 16:40:39 volumio volumio[1033]: Dload Upload Total Spent Left Speed Jul 07 16:40:39 volumio volumio[694]: info: Jul 07 16:40:39 volumio volumio[694]: ---------------------------- Client requests Volume 40 Jul 07 16:40:39 volumio volumio[694]: info: VolumeController::SetAlsaVolume40 Jul 07 16:40:39 volumio volumio[694]: info: CoreStateMachine::pushState Jul 07 16:40:39 volumio volumio[694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 16:40:39 volumio volumio[694]: info: CoreCommandRouter::volumioPushState Jul 07 16:40:39 volumio volumio[1033]: [158B blob data] Jul 07 16:40:39 volumio volumio[694]: info: CoreCommandRouter::volumioGetQueue Jul 07 16:40:39 volumio volumio[694]: info: CoreStateMachine::getQueue Jul 07 16:40:39 volumio volumio[694]: info: CorePlayQueue::getQueue Jul 07 16:40:39 volumio volumio[1033]: {"time":1751877639678,"response":"volume Success"}40 Jul 07 16:41:14 volumio nmbd[654]: [2025/07/07 16:41:14.583140, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 07 16:41:14 volumio nmbd[654]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.20 for name WORKGROUP<1d>. Jul 07 16:41:14 volumio nmbd[654]: This response was from IP 192.168.1.1, reporting an IP address of 192.168.1.1. Jul 07 16:41:51 volumio volumio[694]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 16:41:51 volumio volumio[694]: Error: connect ETIMEDOUT 31.13.68.169:80 Jul 07 16:41:51 volumio volumio[694]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 07 16:41:51 volumio volumio[694]: errno: -110, Jul 07 16:41:51 volumio volumio[694]: code: 'ETIMEDOUT', Jul 07 16:41:51 volumio volumio[694]: syscall: 'connect', Jul 07 16:41:51 volumio volumio[694]: address: '31.13.68.169', Jul 07 16:41:51 volumio volumio[694]: port: 80 Jul 07 16:41:51 volumio volumio[694]: } Jul 07 16:41:51 volumio volumio[694]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 16:41:51 volumio sudo[2771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-07 16:40 Jul 07 16:41:51 volumio sudo[2771]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 04:09:51 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="2fe933ffb50e198f3245fc325fd10b17"