-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Wed 2024-11-27 07:46:13 CST. -- Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::volumioNext Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::next Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::stop Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::stPlaybackTimer Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::updateTrackBlock Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrackBlock Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::pushState Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 1 Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::serviceStop Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 1 Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::serviceStop Nov 27 07:45:00 volumio volumio[968]: info: ControllerMpd::stop Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 07:45:00 volumio volumio[968]: info: Nov 27 07:45:00 volumio volumio[968]: ---------------------------- MPD announces state update: player Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand stop took 9 milliseconds Nov 27 07:45:00 volumio volumio[968]: info: ControllerMpd::getState Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::play index undefined Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 2 Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::startPlaybackTimer Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 2 Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::clearAddPlayTracks USB/sd/音乐/美丽安之声/03心碎（江智民）.wav Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::updateTrackBlock Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrackBlock Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand status took 3 milliseconds Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand stop took 2 milliseconds Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::parseState Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand clear Nov 27 07:45:00 volumio volumio[968]: info: Nov 27 07:45:00 volumio volumio[968]: ---------------------------- MPD announces system playlist update Nov 27 07:45:00 volumio volumio[968]: info: Ignoring MPD Status Update Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand clear took 1 milliseconds Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::parseTrackInfo Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand add "USB/sd/音乐/美丽安之声/03心碎（江智民）.wav" Nov 27 07:45:00 volumio volumio[968]: info: ControllerMpd::pushState Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::servicePushState Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::pushState Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 2 Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 2 Nov 27 07:45:00 volumio volumio[968]: 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":"02分手在那个秋天（雷婷）.wav","artist":null,"album":null,"uri":"USB/sd/音乐/美丽安之声/02分手在那个秋天（雷婷）.wav","trackType":"wav"} Nov 27 07:45:00 volumio volumio[968]: verbose: CURRENT POSITION 2 Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::syncState stateService stop Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::pushState Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 2 Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Nov 27 07:45:00 volumio volumio[968]: info: No code Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::pushState Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 2 Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Nov 27 07:45:00 volumio volumio[968]: info: ------------------------------ 35ms Nov 27 07:45:00 volumio volumio[968]: error: updateQueue error: null Nov 27 07:45:00 volumio volumio[968]: info: Nov 27 07:45:00 volumio volumio[968]: ---------------------------- MPD announces system playlist update Nov 27 07:45:00 volumio volumio[968]: info: Ignoring MPD Status Update Nov 27 07:45:00 volumio volumio[968]: info: ------------------------------ 30ms Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand add "USB/sd/音乐/美丽安之声/03心碎（江智民）.wav" took 29 milliseconds Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand play Nov 27 07:45:00 volumio volumio[968]: info: Nov 27 07:45:00 volumio volumio[968]: ---------------------------- MPD announces state update: player Nov 27 07:45:00 volumio volumio[968]: info: ------------------------------ 5ms Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand play took 4 milliseconds Nov 27 07:45:00 volumio volumio[968]: info: ControllerMpd::getState Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Nov 27 07:45:00 volumio volumio[968]: info: Nov 27 07:45:00 volumio volumio[968]: ---------------------------- MPD announces state update: player Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand status took 17 milliseconds Nov 27 07:45:00 volumio volumio[968]: info: ControllerMpd::getState Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand status Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::parseState Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand status took 8 milliseconds Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::parseState Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 27 07:45:00 volumio volumio[968]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::parseTrackInfo Nov 27 07:45:00 volumio volumio[968]: verbose: ControllerMpd::parseTrackInfo Nov 27 07:45:00 volumio volumio[968]: info: ControllerMpd::pushState Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::servicePushState Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 2 Nov 27 07:45:00 volumio volumio[968]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03心碎（江智民）.wav","artist":null,"album":null,"uri":"USB/sd/音乐/美丽安之声/03心碎（江智民）.wav","trackType":"wav"} Nov 27 07:45:00 volumio volumio[968]: verbose: CURRENT POSITION 2 Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::syncState stateService play Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus stop Nov 27 07:45:00 volumio volumio[968]: info: ControllerMpd::pushState Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::servicePushState Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 2 Nov 27 07:45:00 volumio volumio[968]: verbose: STATE SERVICE {"status":"play","position":0,"seek":800,"duration":260,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03心碎（江智民）.wav","artist":null,"album":null,"uri":"USB/sd/音乐/美丽安之声/03心碎（江智民）.wav","trackType":"wav"} Nov 27 07:45:00 volumio volumio[968]: verbose: CURRENT POSITION 2 Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::syncState stateService play Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::syncState currentStatus play Nov 27 07:45:00 volumio volumio[968]: info: Received an update from plugin. extracting info from payload Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::pushState Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 2 Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Nov 27 07:45:00 volumio volumio[968]: info: CoreStateMachine::pushState Nov 27 07:45:00 volumio volumio[968]: info: CorePlayQueue::getTrack 2 Nov 27 07:45:00 volumio volumio[968]: info: CoreCommandRouter::volumioPushState Nov 27 07:45:00 volumio volumio[968]: info: ------------------------------ 47ms Nov 27 07:45:00 volumio volumio[968]: info: ------------------------------ 43ms Nov 27 07:45:01 volumio kernel: hwmon hwmon1: Voltage normalised Nov 27 07:45:57 volumio kernel: hwmon hwmon1: Undervoltage detected! Nov 27 07:46:02 volumio kernel: hwmon hwmon1: Voltage normalised Nov 27 07:46:06 volumio kernel: hwmon hwmon1: Undervoltage detected! Nov 27 07:46:12 volumio kernel: hwmon hwmon1: Voltage normalised Nov 27 07:46:13 volumio volumio[968]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 07:46:13 volumio volumio[968]: Error: connect ETIMEDOUT 103.214.168.106:80 Nov 27 07:46:13 volumio volumio[968]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Nov 27 07:46:13 volumio volumio[968]: errno: -110, Nov 27 07:46:13 volumio volumio[968]: code: 'ETIMEDOUT', Nov 27 07:46:13 volumio volumio[968]: syscall: 'connect', Nov 27 07:46:13 volumio volumio[968]: address: '103.214.168.106', Nov 27 07:46:13 volumio volumio[968]: port: 80 Nov 27 07:46:13 volumio volumio[968]: } Nov 27 07:46:13 volumio volumio[968]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 07:46:13 volumio sudo[6734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-27 07:45 Nov 27 07:46:13 volumio sudo[6734]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"