-- Logs begin at Mon 2024-03-25 15:04:43 UTC, end at Wed 2024-05-01 12:32:22 UTC. -- May 01 12:31:35 opera volumio[27230]: info: May 01 12:31:35 opera volumio[27230]: ---------------------------- MPD announces state update: player May 01 12:31:35 opera volumio[27230]: info: ControllerMpd::getState May 01 12:31:35 opera volumio[27230]: verbose: ControllerMpd::sendMpdCommand status May 01 12:31:35 opera volumio[27230]: info: sendMpdCommand status took 1 milliseconds May 01 12:31:35 opera volumio[27230]: verbose: ControllerMpd::parseState May 01 12:31:35 opera volumio[27230]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:31:35 opera volumio[27230]: info: sendMpdCommand playlistinfo took 1 milliseconds May 01 12:31:35 opera volumio[27230]: verbose: ControllerMpd::parseTrackInfo May 01 12:31:35 opera volumio[27230]: info: ControllerMpd::pushState May 01 12:31:35 opera volumio[27230]: info: CoreCommandRouter::servicePushState May 01 12:31:35 opera volumio[27230]: info: CoreStateMachine::pushState May 01 12:31:35 opera volumio[27230]: info: CoreCommandRouter::volumioPushState May 01 12:31:35 opera volumio[27230]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:31:35 opera volumio[27230]: info: CorePlayQueue::getTrack 0 May 01 12:31:35 opera volumio[27230]: 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://fsandroid.hw.kugou.com/202405012030/bc4503764627ea8f9a5edf257a8785f2/v3/58e14780988c9bf57d2a86910f451183/yp/full/a1005_u860592677_d4wnj4u2gie822yw49b1sa8ph_p2_mx28235043_qflac_s596449452.flac","trackType":"flac"} May 01 12:31:35 opera volumio[27230]: verbose: CURRENT POSITION 0 May 01 12:31:35 opera volumio[27230]: info: CoreStateMachine::syncState stateService stop May 01 12:31:35 opera volumio[27230]: info: CoreStateMachine::syncState currentStatus play May 01 12:31:35 opera volumio[27230]: info: CoreCommandRouter::volumioPushState May 01 12:31:35 opera volumio[27230]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:31:35 opera volumio[27230]: info: CoreStateMachine::stPlaybackTimer May 01 12:31:35 opera volumio[27230]: info: ------------------------------ 23ms May 01 12:31:35 opera volumio[27230]: info: CoreCommandRouter::volumioGetQueue May 01 12:31:35 opera volumio[27230]: info: CoreStateMachine::getQueue May 01 12:31:35 opera volumio[27230]: info: CorePlayQueue::getQueue May 01 12:31:35 opera volumio[27230]: info: Updating RAAT Signal Path May 01 12:31:35 opera volumio[27230]: info: Updating RAAT Signal Path May 01 12:31:36 opera volumio[27230]: info: Clearing queue after UPNP request May 01 12:31:36 opera volumio[27230]: info: CoreStateMachine::ClearQueue May 01 12:31:36 opera volumio[27230]: info: CoreStateMachine::stop May 01 12:31:36 opera volumio[27230]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:31:36 opera volumio[27230]: verbose: UNSET VOLATILE May 01 12:31:36 opera volumio[27230]: info: CorePlayQueue::clearPlayQueue May 01 12:31:36 opera volumio[27230]: info: CorePlayQueue::saveQueue May 01 12:31:36 opera volumio[27230]: info: CoreCommandRouter::volumioPushState May 01 12:31:36 opera volumio[27230]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:31:36 opera volumio[27230]: info: CoreCommandRouter::volumioPushQueue May 01 12:31:36 opera volumio[27230]: info: Updating RAAT Signal Path May 01 12:31:36 opera volumio[27230]: info: May 01 12:31:36 opera volumio[27230]: ---------------------------- MPD announces system playlist update May 01 12:31:36 opera volumio[27230]: info: Ignoring MPD Status Update May 01 12:31:36 opera volumio[27230]: error: updateQueue error: null May 01 12:31:36 opera volumio[27230]: info: ------------------------------ 4ms May 01 12:31:36 opera volumio[27230]: info: Starting UPNP Playback May 01 12:31:36 opera volumio[27230]: info: Preparing playback through UPNP May 01 12:31:36 opera volumio[27230]: info: CoreCommandRouter::volumioGetState May 01 12:31:36 opera volumio[27230]: info: CorePlayQueue::getTrack 0 May 01 12:31:36 opera volumio[27230]: info: CoreStateMachine::setConsumeUpdateService mpd May 01 12:31:37 opera volumio[27230]: info: May 01 12:31:37 opera volumio[27230]: ---------------------------- MPD announces system playlist update May 01 12:31:37 opera volumio[27230]: info: Ignoring MPD Status Update May 01 12:31:37 opera volumio[27230]: info: ------------------------------ 3ms May 01 12:31:37 opera volumio[27230]: info: May 01 12:31:37 opera volumio[27230]: ---------------------------- MPD announces system playlist update May 01 12:31:37 opera volumio[27230]: info: Ignoring MPD Status Update May 01 12:31:37 opera volumio[27230]: info: ------------------------------ 1ms May 01 12:31:37 opera volumio[27230]: info: May 01 12:31:37 opera volumio[27230]: ---------------------------- MPD announces system playlist update May 01 12:31:37 opera volumio[27230]: info: Ignoring MPD Status Update May 01 12:31:37 opera volumio[27230]: info: ------------------------------ 1ms May 01 12:31:37 opera volumio[27230]: info: May 01 12:31:37 opera volumio[27230]: ---------------------------- MPD announces system playlist update May 01 12:31:37 opera volumio[27230]: info: Ignoring MPD Status Update May 01 12:31:37 opera volumio[27230]: info: ------------------------------ 1ms May 01 12:31:37 opera volumio[27230]: info: May 01 12:31:37 opera volumio[27230]: ---------------------------- MPD announces system playlist update May 01 12:31:37 opera volumio[27230]: info: Ignoring MPD Status Update May 01 12:31:37 opera volumio[27230]: info: ------------------------------ 1ms May 01 12:31:37 opera volumio[27230]: info: May 01 12:31:37 opera volumio[27230]: ---------------------------- MPD announces system playlist update May 01 12:31:37 opera volumio[27230]: info: Ignoring MPD Status Update May 01 12:31:37 opera volumio[27230]: info: ------------------------------ 1ms May 01 12:31:37 opera volumio[27230]: info: May 01 12:31:37 opera volumio[27230]: ---------------------------- MPD announces state update: player May 01 12:31:37 opera volumio[27230]: info: ControllerMpd::getState May 01 12:31:37 opera volumio[27230]: verbose: ControllerMpd::sendMpdCommand status May 01 12:31:37 opera volumio[27230]: info: May 01 12:31:37 opera volumio[27230]: ---------------------------- MPD announces state update: player May 01 12:31:37 opera volumio[27230]: info: sendMpdCommand status took 3 milliseconds May 01 12:31:37 opera volumio[27230]: info: ControllerMpd::getState May 01 12:31:37 opera volumio[27230]: verbose: ControllerMpd::sendMpdCommand status May 01 12:31:37 opera volumio[27230]: verbose: ControllerMpd::parseState May 01 12:31:37 opera volumio[27230]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:31:37 opera volumio[27230]: info: May 01 12:31:37 opera volumio[27230]: ---------------------------- MPD announces system playlist update May 01 12:31:37 opera volumio[27230]: info: Ignoring MPD Status Update May 01 12:31:37 opera volumio[27230]: info: sendMpdCommand status took 3 milliseconds May 01 12:31:37 opera volumio[27230]: info: sendMpdCommand playlistinfo took 2 milliseconds May 01 12:31:37 opera volumio[27230]: verbose: ControllerMpd::parseState May 01 12:31:37 opera volumio[27230]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:31:37 opera volumio[27230]: verbose: ControllerMpd::parseTrackInfo May 01 12:31:37 opera volumio[27230]: info: ControllerMpd::pushState May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::servicePushState May 01 12:31:37 opera volumio[27230]: verbose: In UPNP mode May 01 12:31:37 opera volumio[27230]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":237,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"726 Kbps","isStreaming":false,"title":"长得很","artist":"周启生","album":"独醉之后 日本三菱MT版","uri":"http://fsandroid.hw.kugou.com/202405012031/958fb75113709f210fca979d53bc3c7a/v3/bb35e52a7dda577c36b15afd3a6168cb/yp/full/a1005_u860592677_d4wnj4u2gie822yw49b1sa8ph_p2_mx39570502_qflac_s1861114635.flac","trackType":"flac"} May 01 12:31:37 opera volumio[27230]: verbose: CURRENT POSITION 0 May 01 12:31:37 opera volumio[27230]: info: CoreStateMachine::syncState stateService play May 01 12:31:37 opera volumio[27230]: info: CoreStateMachine::syncState currentStatus stop May 01 12:31:37 opera volumio[27230]: info: CoreStateMachine::pushState May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::volumioPushState May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:31:37 opera volumio[27230]: info: ------------------------------ 39ms May 01 12:31:37 opera volumio[27230]: info: ------------------------------ 34ms May 01 12:31:37 opera volumio[27230]: info: sendMpdCommand playlistinfo took 32 milliseconds May 01 12:31:37 opera volumio[27230]: verbose: ControllerMpd::parseTrackInfo May 01 12:31:37 opera volumio[27230]: info: ControllerMpd::pushState May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::servicePushState May 01 12:31:37 opera volumio[27230]: verbose: In UPNP mode May 01 12:31:37 opera volumio[27230]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":237,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"726 Kbps","isStreaming":false,"title":"长得很","artist":"周启生","album":"独醉之后 日本三菱MT版","uri":"http://fsandroid.hw.kugou.com/202405012031/958fb75113709f210fca979d53bc3c7a/v3/bb35e52a7dda577c36b15afd3a6168cb/yp/full/a1005_u860592677_d4wnj4u2gie822yw49b1sa8ph_p2_mx39570502_qflac_s1861114635.flac","trackType":"flac"} May 01 12:31:37 opera volumio[27230]: verbose: CURRENT POSITION 0 May 01 12:31:37 opera volumio[27230]: info: CoreStateMachine::syncState stateService play May 01 12:31:37 opera volumio[27230]: info: CoreStateMachine::syncState currentStatus play May 01 12:31:37 opera volumio[27230]: info: Received an update from plugin. extracting info from payload May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 01 12:31:37 opera volumio[27230]: info: CoreStateMachine::pushState May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::volumioPushState May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:31:37 opera volumio[27230]: info: CoreStateMachine::pushState May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::volumioPushState May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:31:37 opera volumio[27230]: info: ------------------------------ 49ms May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::volumioGetQueue May 01 12:31:37 opera volumio[27230]: info: CoreStateMachine::getQueue May 01 12:31:37 opera volumio[27230]: info: CorePlayQueue::getQueue May 01 12:31:37 opera volumio[27230]: info: CoreCommandRouter::volumioGetQueue May 01 12:31:37 opera volumio[27230]: info: CoreStateMachine::getQueue May 01 12:31:37 opera volumio[27230]: info: CorePlayQueue::getQueue May 01 12:31:37 opera volumio[27230]: info: Updating RAAT Signal Path May 01 12:31:37 opera volumio[27230]: info: Updating RAAT Signal Path May 01 12:31:37 opera volumio[27230]: info: Updating RAAT Signal Path May 01 12:31:37 opera volumio[27230]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%85%B3%E6%B7%91%E6%80%A1/%E9%9A%BE%E5%BE%97%E6%9C%89%E6%83%85%E4%BA%BA/cffd83df-77ec-44e8-859a-daaf87cb18f2.png' May 01 12:32:21 opera volumio[27230]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 12:32:21 opera volumio[27230]: { Error: connect ETIMEDOUT 203.111.254.117:443 May 01 12:32:21 opera volumio[27230]: at Object._errnoException (util.js:1022:11) May 01 12:32:21 opera volumio[27230]: at _exceptionWithHostPort (util.js:1044:20) May 01 12:32:21 opera volumio[27230]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 01 12:32:21 opera volumio[27230]: code: 'ETIMEDOUT', May 01 12:32:21 opera volumio[27230]: errno: 'ETIMEDOUT', May 01 12:32:21 opera volumio[27230]: syscall: 'connect', May 01 12:32:21 opera volumio[27230]: address: '203.111.254.117', May 01 12:32:21 opera volumio[27230]: port: 443 } May 01 12:32:21 opera volumio[27230]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 12:32:22 opera sudo[28966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 12:31 May 01 12:32:22 opera sudo[28966]: 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"