-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Thu 2025-03-13 13:11:09 UTC. -- Mar 13 13:10:11 volumio volumio[1089]: info: Mar 13 13:10:11 volumio volumio[1089]: ---------------------------- MPD announces system playlist update Mar 13 13:10:11 volumio volumio[1089]: info: Ignoring MPD Status Update Mar 13 13:10:11 volumio volumio[1089]: info: Mar 13 13:10:11 volumio volumio[1089]: ---------------------------- MPD announces state update: player Mar 13 13:10:11 volumio volumio[1089]: info: ControllerMpd::getState Mar 13 13:10:11 volumio volumio[1089]: verbose: ControllerMpd::sendMpdCommand status Mar 13 13:10:11 volumio volumio[1089]: info: ------------------------------ 3ms Mar 13 13:10:11 volumio volumio[1089]: info: sendMpdCommand status took 2 milliseconds Mar 13 13:10:11 volumio volumio[1089]: verbose: ControllerMpd::parseState Mar 13 13:10:11 volumio volumio[1089]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 13:10:11 volumio volumio[1089]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 13 13:10:11 volumio volumio[1089]: verbose: ControllerMpd::parseTrackInfo Mar 13 13:10:11 volumio volumio[1089]: info: ControllerMpd::pushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::servicePushState Mar 13 13:10:11 volumio volumio[1089]: verbose: In UPNP mode Mar 13 13:10:11 volumio volumio[1089]: verbose: STATE SERVICE {"status":"play","position":3,"seek":298468,"duration":299,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"original.mp3?DeviceProfileId=ff387ae2ba8c4a998d5e432840380d8b&DeviceId=uuid:548a2cb5-2925-37ea-1818-1008b1ff18f3&MediaSourceId=mediasource_68333&PlaySessionId=2c0675c4436b41918cb622bd5b4b8f18&api_key=a00844bbb51d4d58b96af7f73212d064","artist":"Éî¶ÈÒôÀÖ¹¤×÷ÊÒ","album":"HiFiÁ¢Ìå»·ÈÆÒôÖÊ","uri":"http://192.168.1.250:8096/audio/68333/original.mp3?DeviceProfileId=ff387ae2ba8c4a998d5e432840380d8b&DeviceId=uuid:548a2cb5-2925-37ea-1818-1008b1ff18f3&MediaSourceId=mediasource_68333&PlaySessionId=2c0675c4436b41918cb622bd5b4b8f18&api_key=a00844bbb51d4d58b96af7f73212d064","trackType":""} Mar 13 13:10:11 volumio volumio[1089]: verbose: CURRENT POSITION 0 Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::syncState stateService play Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::syncState currentStatus play Mar 13 13:10:11 volumio volumio[1089]: info: Received an update from plugin. extracting info from payload Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::pushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::pushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Mar 13 13:10:11 volumio volumio[1089]: info: ------------------------------ 31ms Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::getQueue Mar 13 13:10:11 volumio volumio[1089]: info: CorePlayQueue::getQueue Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::getQueue Mar 13 13:10:11 volumio volumio[1089]: info: CorePlayQueue::getQueue Mar 13 13:10:11 volumio volumio[1089]: info: Mar 13 13:10:11 volumio volumio[1089]: ---------------------------- MPD announces system playlist update Mar 13 13:10:11 volumio volumio[1089]: info: Ignoring MPD Status Update Mar 13 13:10:11 volumio volumio[1089]: info: Mar 13 13:10:11 volumio volumio[1089]: ---------------------------- MPD announces state update: player Mar 13 13:10:11 volumio volumio[1089]: info: ControllerMpd::getState Mar 13 13:10:11 volumio volumio[1089]: verbose: ControllerMpd::sendMpdCommand status Mar 13 13:10:11 volumio volumio[1089]: info: ------------------------------ 3ms Mar 13 13:10:11 volumio volumio[1089]: info: sendMpdCommand status took 2 milliseconds Mar 13 13:10:11 volumio volumio[1089]: verbose: ControllerMpd::parseState Mar 13 13:10:11 volumio volumio[1089]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 13 13:10:11 volumio volumio[1089]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 13 13:10:11 volumio volumio[1089]: verbose: ControllerMpd::parseTrackInfo Mar 13 13:10:11 volumio volumio[1089]: info: ControllerMpd::pushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::servicePushState Mar 13 13:10:11 volumio volumio[1089]: verbose: In UPNP mode Mar 13 13:10:11 volumio volumio[1089]: verbose: STATE SERVICE {"status":"play","position":4,"seek":11,"duration":249,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"original.mp3?DeviceProfileId=ff387ae2ba8c4a998d5e432840380d8b&DeviceId=uuid:548a2cb5-2925-37ea-1818-1008b1ff18f3&MediaSourceId=mediasource_68397&PlaySessionId=686fdb921ed64c09860cc881e0a192e8&api_key=a00844bbb51d4d58b96af7f73212d064","artist":"深度音乐工作室","album":"HiFi立体环绕音质","uri":"http://192.168.1.250:8096/audio/68397/original.mp3?DeviceProfileId=ff387ae2ba8c4a998d5e432840380d8b&DeviceId=uuid:548a2cb5-2925-37ea-1818-1008b1ff18f3&MediaSourceId=mediasource_68397&PlaySessionId=686fdb921ed64c09860cc881e0a192e8&api_key=a00844bbb51d4d58b96af7f73212d064","trackType":""} Mar 13 13:10:11 volumio volumio[1089]: verbose: CURRENT POSITION 0 Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::syncState stateService play Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::syncState currentStatus play Mar 13 13:10:11 volumio volumio[1089]: info: Received an update from plugin. extracting info from payload Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::pushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::pushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Mar 13 13:10:11 volumio volumio[1089]: info: ------------------------------ 24ms Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::getQueue Mar 13 13:10:11 volumio volumio[1089]: info: CorePlayQueue::getQueue Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::getQueue Mar 13 13:10:11 volumio volumio[1089]: info: CorePlayQueue::getQueue Mar 13 13:10:11 volumio volumio[1089]: info: Mar 13 13:10:11 volumio volumio[1089]: ---------------------------- MPD announces system playlist update Mar 13 13:10:11 volumio volumio[1089]: info: Ignoring MPD Status Update Mar 13 13:10:11 volumio volumio[1089]: info: Mar 13 13:10:11 volumio volumio[1089]: ---------------------------- MPD announces state update: player Mar 13 13:10:11 volumio volumio[1089]: info: ControllerMpd::getState Mar 13 13:10:11 volumio volumio[1089]: verbose: ControllerMpd::sendMpdCommand status Mar 13 13:10:11 volumio volumio[1089]: info: Starting UPNP Playback Mar 13 13:10:11 volumio volumio[1089]: info: Preparing playback through UPNP Mar 13 13:10:11 volumio volumio[1089]: info: Consume mode Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioGetState Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 13 13:10:11 volumio volumio[1089]: info: ------------------------------ 5ms Mar 13 13:10:11 volumio volumio[1089]: info: sendMpdCommand status took 4 milliseconds Mar 13 13:10:11 volumio volumio[1089]: verbose: ControllerMpd::parseState Mar 13 13:10:11 volumio volumio[1089]: info: ControllerMpd::pushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::servicePushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::pushState Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Mar 13 13:10:11 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Mar 13 13:10:11 volumio volumio[1089]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 13 13:10:11 volumio volumio[1089]: verbose: CURRENT POSITION 0 Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::syncState stateService stop Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::syncState currentStatus play Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::play index undefined Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::pushState Mar 13 13:10:11 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioPushState Mar 13 13:10:11 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Mar 13 13:10:11 volumio volumio[1089]: info: ------------------------------ 39ms Mar 13 13:10:11 volumio volumio[1089]: info: CoreCommandRouter::volumioGetQueue Mar 13 13:10:11 volumio volumio[1089]: info: CoreStateMachine::getQueue Mar 13 13:10:11 volumio volumio[1089]: info: CorePlayQueue::getQueue Mar 13 13:10:12 volumio volumio[1089]: info: Mar 13 13:10:12 volumio volumio[1089]: ---------------------------- MPD announces system playlist update Mar 13 13:10:12 volumio volumio[1089]: info: Ignoring MPD Status Update Mar 13 13:10:12 volumio volumio[1089]: info: ------------------------------ 2ms Mar 13 13:10:12 volumio volumio[1089]: info: Mar 13 13:10:12 volumio volumio[1089]: ---------------------------- MPD announces system playlist update Mar 13 13:10:12 volumio volumio[1089]: info: Ignoring MPD Status Update Mar 13 13:10:12 volumio volumio[1089]: info: ------------------------------ 4ms Mar 13 13:10:12 volumio volumio[1089]: info: Mar 13 13:10:12 volumio volumio[1089]: ---------------------------- MPD announces system playlist update Mar 13 13:10:12 volumio volumio[1089]: info: Ignoring MPD Status Update Mar 13 13:10:12 volumio volumio[1089]: info: ------------------------------ 4ms Mar 13 13:10:12 volumio volumio[1089]: info: Mar 13 13:10:12 volumio volumio[1089]: ---------------------------- MPD announces system playlist update Mar 13 13:10:12 volumio volumio[1089]: info: Ignoring MPD Status Update Mar 13 13:10:12 volumio volumio[1089]: info: ------------------------------ 4ms Mar 13 13:10:12 volumio volumio[1089]: info: Mar 13 13:10:12 volumio volumio[1089]: ---------------------------- MPD announces system playlist update Mar 13 13:10:12 volumio volumio[1089]: info: Ignoring MPD Status Update Mar 13 13:10:12 volumio volumio[1089]: info: ------------------------------ 3ms Mar 13 13:10:12 volumio volumio[1089]: info: Mar 13 13:10:12 volumio volumio[1089]: ---------------------------- MPD announces system playlist update Mar 13 13:10:12 volumio volumio[1089]: info: Ignoring MPD Status Update Mar 13 13:10:12 volumio volumio[1089]: info: ------------------------------ 10ms Mar 13 13:10:47 volumio volumio[1089]: info: CoreCommandRouter::volumioPlay Mar 13 13:10:47 volumio volumio[1089]: info: CoreStateMachine::play index undefined Mar 13 13:10:47 volumio volumio[1089]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 13 13:10:47 volumio volumio[1089]: info: CorePlayQueue::getTrack 0 Mar 13 13:11:08 volumio volumio[1089]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 13 13:11:08 volumio volumio[1089]: Error: connect ETIMEDOUT 128.121.243.75:80 Mar 13 13:11:08 volumio volumio[1089]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 13 13:11:08 volumio volumio[1089]: errno: -110, Mar 13 13:11:08 volumio volumio[1089]: code: 'ETIMEDOUT', Mar 13 13:11:08 volumio volumio[1089]: syscall: 'connect', Mar 13 13:11:08 volumio volumio[1089]: address: '128.121.243.75', Mar 13 13:11:08 volumio volumio[1089]: port: 80 Mar 13 13:11:08 volumio volumio[1089]: } Mar 13 13:11:08 volumio volumio[1089]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 13 13:11:09 volumio sudo[9686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-13 13:10 Mar 13 13:11:09 volumio sudo[9686]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"