-- Logs begin at Thu 2025-07-10 21:39:41 CST, end at Fri 2025-07-11 16:04:02 CST. -- Jul 11 16:03:21 smsl-n100 volumio[1194]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 16:03:21 smsl-n100 volumio[1194]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 16:03:21 smsl-n100 volumio[1194]: info: Discovery: Getting this device information Jul 11 16:03:21 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioGetState Jul 11 16:03:21 smsl-n100 volumio[1194]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 16:03:33 smsl-n100 volumio[1194]: info: Airplay started streaming, receiving metadatas Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioStop Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::stop Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::stPlaybackTimer Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::updateTrackBlock Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrackBlock Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:33 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:33 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::serviceStop Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:33 smsl-n100 volumio[1194]: info: ControllerMpd::stop Jul 11 16:03:33 smsl-n100 volumio[1194]: verbose: ControllerMpd::sendMpdCommand stop Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 16:03:33 smsl-n100 volumio[1194]: info: Airplay started streaming, receiving metadatas Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioStop Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::stop Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 16:03:33 smsl-n100 volumio[1194]: info: Airplay started streaming, receiving metadatas Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioStop Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::stop Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 16:03:33 smsl-n100 volumio[1194]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 16:03:33 smsl-n100 shairport-sync[10484]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 11 16:03:33 smsl-n100 shairport-sync[10484]: Dload Upload Total Spent Left Speed Jul 11 16:03:33 smsl-n100 volumio[1194]: info: Jul 11 16:03:33 smsl-n100 volumio[1194]: ---------------------------- MPD announces state update: player Jul 11 16:03:33 smsl-n100 volumio[1194]: info: sendMpdCommand stop took 69 milliseconds Jul 11 16:03:33 smsl-n100 volumio[1194]: info: ControllerMpd::getState Jul 11 16:03:33 smsl-n100 volumio[1194]: verbose: ControllerMpd::sendMpdCommand status Jul 11 16:03:33 smsl-n100 volumio[1194]: info: sendMpdCommand status took 3 milliseconds Jul 11 16:03:33 smsl-n100 volumio[1194]: verbose: ControllerMpd::parseState Jul 11 16:03:33 smsl-n100 volumio[1194]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 16:03:34 smsl-n100 volumio[1194]: info: Jul 11 16:03:34 smsl-n100 volumio[1194]: ---------------------------- MPD announces state update: player Jul 11 16:03:34 smsl-n100 volumio[1194]: info: ControllerMpd::getState Jul 11 16:03:34 smsl-n100 volumio[1194]: verbose: ControllerMpd::sendMpdCommand status Jul 11 16:03:34 smsl-n100 volumio[1194]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 11 16:03:34 smsl-n100 volumio[1194]: info: sendMpdCommand status took 6 milliseconds Jul 11 16:03:34 smsl-n100 volumio[1194]: verbose: ControllerMpd::parseTrackInfo Jul 11 16:03:34 smsl-n100 volumio[1194]: verbose: ControllerMpd::parseState Jul 11 16:03:34 smsl-n100 volumio[1194]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 16:03:34 smsl-n100 volumio[1194]: info: ControllerMpd::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::servicePushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: 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":"忘不了您","uri":"http://aqqmusic.tc.qq.com/F0000016yVzV2V593j.flac?guid=ffffffff8bc4e3e20000018cae37cda7&vkey=F41A1BCEC4EDD622D7B23B676F7D93BD54EA56519F1F944C770EF03A259E26FAF0EB2084FA3421AE7E2A7249C63B7330B9D77949397A2119__v2b94c3e5&uin=1152921505295316337&redirect=1&fromtag=111114","trackType":""} Jul 11 16:03:34 smsl-n100 volumio[1194]: verbose: CURRENT POSITION 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::syncState stateService stop Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::syncState currentStatus stop Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:34 smsl-n100 volumio[1194]: info: No code Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:34 smsl-n100 volumio[1194]: info: ------------------------------ 119ms Jul 11 16:03:34 smsl-n100 volumio[1194]: info: sendMpdCommand playlistinfo took 106 milliseconds Jul 11 16:03:34 smsl-n100 volumio[1194]: verbose: ControllerMpd::parseTrackInfo Jul 11 16:03:34 smsl-n100 volumio[1194]: info: ControllerMpd::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::servicePushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: 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":"忘不了您","uri":"http://aqqmusic.tc.qq.com/F0000016yVzV2V593j.flac?guid=ffffffff8bc4e3e20000018cae37cda7&vkey=F41A1BCEC4EDD622D7B23B676F7D93BD54EA56519F1F944C770EF03A259E26FAF0EB2084FA3421AE7E2A7249C63B7330B9D77949397A2119__v2b94c3e5&uin=1152921505295316337&redirect=1&fromtag=111114","trackType":""} Jul 11 16:03:34 smsl-n100 volumio[1194]: verbose: CURRENT POSITION 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::syncState stateService stop Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::syncState currentStatus stop Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:34 smsl-n100 volumio[1194]: info: No code Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:34 smsl-n100 volumio[1194]: info: ------------------------------ 193ms Jul 11 16:03:34 smsl-n100 volumio[1194]: info: Jul 11 16:03:34 smsl-n100 volumio[1194]: ---------------------------- Client requests Start Airplay PlaybackRoutine Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Jul 11 16:03:34 smsl-n100 volumio[1194]: info: Airplay playback start Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioStop Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::stop Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 16:03:34 smsl-n100 shairport-sync[10484]: [237B blob data] Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CorePlayQueue::getTrack 0 Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:34 smsl-n100 volumio[1194]: error: Serial API: Failed to decode command: 100, message: undefined Jul 11 16:03:34 smsl-n100 volumio[1194]: error: Serial API: Failed to decode command: MAXVOL, message: Jul 11 16:03:34 smsl-n100 volumio[1194]: error: Serial API: Failed to decode command: 100, message: undefined Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::servicePushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::servicePushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:34 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:35 smsl-n100 volumio[1194]: info: CoreCommandRouter::servicePushState Jul 11 16:03:35 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:35 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:35 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:35 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:35 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:35 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:35 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:35 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:35 smsl-n100 volumio[1194]: error: Serial API: Failed to decode command: 100, message: undefined Jul 11 16:03:35 smsl-n100 volumio[1194]: error: Serial API: Failed to decode command: MAXVOL, message: Jul 11 16:03:35 smsl-n100 volumio[1194]: error: Serial API: Failed to decode command: 100, message: undefined Jul 11 16:03:35 smsl-n100 volumio[1194]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jul 11 16:03:35 smsl-n100 volumio[1194]: info: CoreCommandRouter::servicePushState Jul 11 16:03:35 smsl-n100 volumio[1194]: info: CoreStateMachine::pushState Jul 11 16:03:35 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioPushState Jul 11 16:03:35 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output update for this device Jul 11 16:03:35 smsl-n100 volumio[1194]: info: MRS: Pushing multiroomSync output Jul 11 16:03:51 smsl-n100 volumio[1194]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 16:03:51 smsl-n100 volumio[1194]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 16:03:51 smsl-n100 volumio[1194]: info: Discovery: Getting this device information Jul 11 16:03:51 smsl-n100 volumio[1194]: info: CoreCommandRouter::volumioGetState Jul 11 16:03:51 smsl-n100 volumio[1194]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 16:04:01 smsl-n100 volumio[1194]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 16:04:01 smsl-n100 volumio[1194]: Error: connect ETIMEDOUT 108.160.167.156:443 Jul 11 16:04:01 smsl-n100 volumio[1194]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 11 16:04:01 smsl-n100 volumio[1194]: errno: -110, Jul 11 16:04:01 smsl-n100 volumio[1194]: code: 'ETIMEDOUT', Jul 11 16:04:01 smsl-n100 volumio[1194]: syscall: 'connect', Jul 11 16:04:01 smsl-n100 volumio[1194]: address: '108.160.167.156', Jul 11 16:04:01 smsl-n100 volumio[1194]: port: 443 Jul 11 16:04:01 smsl-n100 volumio[1194]: } Jul 11 16:04:01 smsl-n100 volumio[1194]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 16:04:02 smsl-n100 sudo[11172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-11 16:03 Jul 11 16:04:02 smsl-n100 sudo[11172]: 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="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"