-- Logs begin at Sat 2026-07-11 11:55:18 UTC, end at Wed 2026-10-14 11:45:34 UTC. -- Oct 14 11:45:15 opera volumio[947]: info: Oct 14 11:45:15 opera volumio[947]: ---------------------------- MPD announces state update: player Oct 14 11:45:15 opera volumio[947]: info: ControllerMpd::getState Oct 14 11:45:15 opera volumio[947]: verbose: ControllerMpd::sendMpdCommand status Oct 14 11:45:15 opera volumio[947]: info: sendMpdCommand status took 0 milliseconds Oct 14 11:45:15 opera volumio[947]: verbose: ControllerMpd::parseState Oct 14 11:45:15 opera volumio[947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 11:45:15 opera volumio[947]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 14 11:45:15 opera volumio[947]: verbose: ControllerMpd::parseTrackInfo Oct 14 11:45:15 opera volumio[947]: info: ControllerMpd::pushState Oct 14 11:45:15 opera volumio[947]: info: CoreCommandRouter::servicePushState Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::pushState Oct 14 11:45:15 opera volumio[947]: info: CoreCommandRouter::volumioPushState Oct 14 11:45:15 opera volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 11:45:15 opera volumio[947]: info: CorePlayQueue::getTrack 0 Oct 14 11:45:15 opera volumio[947]: 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":"Cross the Line","artist":"Audiomachine/Harry Lightfoot","album":"Requiem","uri":"http://114.230.138.29/amobile.music.tc.qq.com/F0000021kXhh0RjQBI.flac?guid=000000007a88bf2200000196b6b7f7f7&vkey=BDFAF36C373E439CB7A8066CE12AB8F7A7383890083A8FE6320F4A6D9D2995FF62D4B1F9D1DADBBD56405D5751BC39BA3EA43042D7A72940__v215df3925&uin=40330101&src=F000001rYMXh0W5iLH.flac&redirect=1&fromtag=111114","trackType":""} Oct 14 11:45:15 opera volumio[947]: verbose: CURRENT POSITION 0 Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::syncState stateService stop Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::syncState currentStatus play Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::play index undefined Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::pushState Oct 14 11:45:15 opera volumio[947]: info: CorePlayQueue::getTrack 0 Oct 14 11:45:15 opera volumio[947]: info: CoreCommandRouter::volumioPushState Oct 14 11:45:15 opera volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 11:45:15 opera volumio[947]: info: CorePlayQueue::getTrack 0 Oct 14 11:45:15 opera volumio[947]: info: ------------------------------ 18ms Oct 14 11:45:15 opera volumio[947]: info: CoreCommandRouter::volumioGetQueue Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::getQueue Oct 14 11:45:15 opera volumio[947]: info: CorePlayQueue::getQueue Oct 14 11:45:15 opera volumio[947]: info: Updating RAAT Signal Path Oct 14 11:45:15 opera volumio[947]: info: Updating RAAT Signal Path Oct 14 11:45:15 opera volumio[947]: info: Clearing queue after UPNP request Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::ClearQueue Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::stop Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 11:45:15 opera volumio[947]: verbose: UNSET VOLATILE Oct 14 11:45:15 opera volumio[947]: info: CorePlayQueue::clearPlayQueue Oct 14 11:45:15 opera volumio[947]: info: CorePlayQueue::saveQueue Oct 14 11:45:15 opera volumio[947]: info: CoreCommandRouter::volumioPushState Oct 14 11:45:15 opera volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 11:45:15 opera volumio[947]: info: CoreCommandRouter::volumioPushQueue Oct 14 11:45:15 opera volumio[947]: info: Updating RAAT Signal Path Oct 14 11:45:15 opera volumio[947]: info: Oct 14 11:45:15 opera volumio[947]: ---------------------------- MPD announces system playlist update Oct 14 11:45:15 opera volumio[947]: info: Ignoring MPD Status Update Oct 14 11:45:15 opera volumio[947]: error: updateQueue error: null Oct 14 11:45:15 opera volumio[947]: info: ------------------------------ 2ms Oct 14 11:45:15 opera volumio[947]: info: Starting UPNP Playback Oct 14 11:45:15 opera volumio[947]: info: Preparing playback through UPNP Oct 14 11:45:15 opera volumio[947]: info: CoreCommandRouter::volumioGetState Oct 14 11:45:15 opera volumio[947]: info: CorePlayQueue::getTrack 0 Oct 14 11:45:15 opera volumio[947]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 14 11:45:16 opera volumio[947]: info: Oct 14 11:45:16 opera volumio[947]: ---------------------------- MPD announces system playlist update Oct 14 11:45:16 opera volumio[947]: info: Ignoring MPD Status Update Oct 14 11:45:16 opera volumio[947]: info: ------------------------------ 1ms Oct 14 11:45:16 opera volumio[947]: info: Oct 14 11:45:16 opera volumio[947]: ---------------------------- MPD announces system playlist update Oct 14 11:45:16 opera volumio[947]: info: Ignoring MPD Status Update Oct 14 11:45:16 opera volumio[947]: info: ------------------------------ 1ms Oct 14 11:45:16 opera volumio[947]: info: Oct 14 11:45:16 opera volumio[947]: ---------------------------- MPD announces system playlist update Oct 14 11:45:16 opera volumio[947]: info: Ignoring MPD Status Update Oct 14 11:45:16 opera volumio[947]: info: Oct 14 11:45:16 opera volumio[947]: ---------------------------- MPD announces system playlist update Oct 14 11:45:16 opera volumio[947]: info: Ignoring MPD Status Update Oct 14 11:45:16 opera volumio[947]: info: ------------------------------ 1ms Oct 14 11:45:16 opera volumio[947]: info: ------------------------------ 1ms Oct 14 11:45:16 opera volumio[947]: info: Oct 14 11:45:16 opera volumio[947]: ---------------------------- MPD announces system playlist update Oct 14 11:45:16 opera volumio[947]: info: Ignoring MPD Status Update Oct 14 11:45:16 opera volumio[947]: info: Oct 14 11:45:16 opera volumio[947]: ---------------------------- MPD announces system playlist update Oct 14 11:45:16 opera volumio[947]: info: Ignoring MPD Status Update Oct 14 11:45:16 opera volumio[947]: info: ------------------------------ 2ms Oct 14 11:45:16 opera volumio[947]: info: ------------------------------ 2ms Oct 14 11:45:16 opera volumio[947]: info: Oct 14 11:45:16 opera volumio[947]: ---------------------------- MPD announces state update: player Oct 14 11:45:16 opera volumio[947]: info: ControllerMpd::getState Oct 14 11:45:16 opera volumio[947]: verbose: ControllerMpd::sendMpdCommand status Oct 14 11:45:17 opera volumio[947]: info: sendMpdCommand status took 134 milliseconds Oct 14 11:45:17 opera volumio[947]: verbose: ControllerMpd::parseState Oct 14 11:45:17 opera volumio[947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 11:45:17 opera volumio[947]: info: Oct 14 11:45:17 opera volumio[947]: ---------------------------- MPD announces system playlist update Oct 14 11:45:17 opera volumio[947]: info: Ignoring MPD Status Update Oct 14 11:45:17 opera volumio[947]: info: Oct 14 11:45:17 opera volumio[947]: ---------------------------- MPD announces state update: player Oct 14 11:45:17 opera volumio[947]: info: ControllerMpd::getState Oct 14 11:45:17 opera volumio[947]: verbose: ControllerMpd::sendMpdCommand status Oct 14 11:45:17 opera volumio[947]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 11:45:17 opera volumio[947]: verbose: ControllerMpd::parseTrackInfo Oct 14 11:45:17 opera volumio[947]: info: ControllerMpd::pushState Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::servicePushState Oct 14 11:45:17 opera volumio[947]: verbose: In UPNP mode Oct 14 11:45:17 opera volumio[947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"When I Dream","artist":"Carol Kidd","album":"音乐传真 HIFI毒药","uri":"http://114.230.138.29/amobile.music.tc.qq.com/F000001x0ti62DbMiY.flac?guid=000000007a88bf2200000196b6b7f7f7&vkey=5594BAC636410A576B79427229C911674D84A4F70E4903D371B26D1AC867281B20AD04E3EE70D5918867FFE3948D18505151C37E1F5254F2__v2b9326ce&uin=40330101&redirect=1&fromtag=111114","trackType":""} Oct 14 11:45:17 opera volumio[947]: verbose: CURRENT POSITION 0 Oct 14 11:45:17 opera volumio[947]: info: CoreStateMachine::syncState stateService play Oct 14 11:45:17 opera volumio[947]: info: CoreStateMachine::syncState currentStatus stop Oct 14 11:45:17 opera volumio[947]: info: CoreStateMachine::pushState Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::volumioPushState Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 11:45:17 opera volumio[947]: info: ------------------------------ 148ms Oct 14 11:45:17 opera volumio[947]: info: ------------------------------ 19ms Oct 14 11:45:17 opera volumio[947]: info: sendMpdCommand status took 19 milliseconds Oct 14 11:45:17 opera volumio[947]: verbose: ControllerMpd::parseState Oct 14 11:45:17 opera volumio[947]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 11:45:17 opera volumio[947]: info: Updating RAAT Signal Path Oct 14 11:45:17 opera volumio[947]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 14 11:45:17 opera volumio[947]: verbose: ControllerMpd::parseTrackInfo Oct 14 11:45:17 opera volumio[947]: info: ControllerMpd::pushState Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::servicePushState Oct 14 11:45:17 opera volumio[947]: verbose: In UPNP mode Oct 14 11:45:17 opera volumio[947]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"598 Kbps","isStreaming":false,"title":"When I Dream","artist":"Carol Kidd","album":"音乐传真 HIFI毒药","uri":"http://114.230.138.29/amobile.music.tc.qq.com/F000001x0ti62DbMiY.flac?guid=000000007a88bf2200000196b6b7f7f7&vkey=5594BAC636410A576B79427229C911674D84A4F70E4903D371B26D1AC867281B20AD04E3EE70D5918867FFE3948D18505151C37E1F5254F2__v2b9326ce&uin=40330101&redirect=1&fromtag=111114","trackType":""} Oct 14 11:45:17 opera volumio[947]: verbose: CURRENT POSITION 0 Oct 14 11:45:17 opera volumio[947]: info: CoreStateMachine::syncState stateService play Oct 14 11:45:17 opera volumio[947]: info: CoreStateMachine::syncState currentStatus play Oct 14 11:45:17 opera volumio[947]: info: Received an update from plugin. extracting info from payload Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 14 11:45:17 opera volumio[947]: info: CoreStateMachine::pushState Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::volumioPushState Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 11:45:17 opera volumio[947]: info: CoreStateMachine::pushState Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::volumioPushState Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 11:45:17 opera volumio[947]: info: ------------------------------ 39ms Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::volumioGetQueue Oct 14 11:45:17 opera volumio[947]: info: CoreStateMachine::getQueue Oct 14 11:45:17 opera volumio[947]: info: CorePlayQueue::getQueue Oct 14 11:45:17 opera volumio[947]: info: CoreCommandRouter::volumioGetQueue Oct 14 11:45:17 opera volumio[947]: info: CoreStateMachine::getQueue Oct 14 11:45:17 opera volumio[947]: info: CorePlayQueue::getQueue Oct 14 11:45:17 opera volumio[947]: info: Updating RAAT Signal Path Oct 14 11:45:17 opera volumio[947]: info: Updating RAAT Signal Path Oct 14 11:45:33 opera volumio[947]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 11:45:33 opera volumio[947]: { Error: connect ETIMEDOUT 108.160.170.43:443 Oct 14 11:45:33 opera volumio[947]: at Object._errnoException (util.js:1022:11) Oct 14 11:45:33 opera volumio[947]: at _exceptionWithHostPort (util.js:1044:20) Oct 14 11:45:33 opera volumio[947]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 14 11:45:33 opera volumio[947]: code: 'ETIMEDOUT', Oct 14 11:45:33 opera volumio[947]: errno: 'ETIMEDOUT', Oct 14 11:45:33 opera volumio[947]: syscall: 'connect', Oct 14 11:45:33 opera volumio[947]: address: '108.160.170.43', Oct 14 11:45:33 opera volumio[947]: port: 443 } Oct 14 11:45:33 opera volumio[947]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 11:45:34 opera sudo[3147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-14 11:44 Oct 14 11:45:34 opera sudo[3147]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"