-- Logs begin at Thu 2024-04-25 01:39:13 UTC, end at Thu 2024-04-25 01:57:16 UTC. -- Apr 25 01:56:07 volumio kernel: ideapad_laptop: Unknown event: 1 Apr 25 01:56:13 volumio volumio[3133]: info: Apr 25 01:56:13 volumio volumio[3133]: ---------------------------- MPD announces state update: player Apr 25 01:56:13 volumio volumio[3133]: info: ControllerMpd::getState Apr 25 01:56:13 volumio volumio[3133]: verbose: ControllerMpd::sendMpdCommand status Apr 25 01:56:13 volumio volumio[3133]: info: sendMpdCommand status took 0 milliseconds Apr 25 01:56:13 volumio volumio[3133]: verbose: ControllerMpd::parseState Apr 25 01:56:13 volumio volumio[3133]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 25 01:56:13 volumio volumio[3133]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 25 01:56:13 volumio volumio[3133]: verbose: ControllerMpd::parseTrackInfo Apr 25 01:56:13 volumio volumio[3133]: info: ControllerMpd::pushState Apr 25 01:56:13 volumio volumio[3133]: info: CoreCommandRouter::servicePushState Apr 25 01:56:13 volumio volumio[3133]: info: CoreStateMachine::pushState Apr 25 01:56:13 volumio volumio[3133]: info: CoreCommandRouter::volumioPushState Apr 25 01:56:13 volumio volumio[3133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 01:56:13 volumio volumio[3133]: info: CorePlayQueue::getTrack 0 Apr 25 01:56:13 volumio volumio[3133]: 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":"Call My Name","artist":"Lian Ross","album":"The Maxi-Singles Collection Volume 2","uri":"http://220.169.152.211/amobile.music.tc.qq.com/M5000003hp6d2SyrHu.mp3?guid=0000000059a75988000001879df3d79f&vkey=4420564143D67386B96D5C0E037B5088680E091C972009EFE441B68CE56B9042E1A290A0696B42D662EE38C28B209AA81931213E7B2989A6&uin=1152921504679429217&redirect=1&fromtag=111042","trackType":""} Apr 25 01:56:13 volumio volumio[3133]: verbose: CURRENT POSITION 0 Apr 25 01:56:13 volumio volumio[3133]: info: CoreStateMachine::syncState stateService stop Apr 25 01:56:13 volumio volumio[3133]: info: CoreStateMachine::syncState currentStatus play Apr 25 01:56:13 volumio volumio[3133]: info: CoreStateMachine::play index undefined Apr 25 01:56:13 volumio volumio[3133]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 25 01:56:13 volumio volumio[3133]: info: CoreStateMachine::pushState Apr 25 01:56:13 volumio volumio[3133]: info: CorePlayQueue::getTrack 0 Apr 25 01:56:13 volumio volumio[3133]: info: CoreCommandRouter::volumioPushState Apr 25 01:56:13 volumio volumio[3133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 01:56:13 volumio volumio[3133]: info: CorePlayQueue::getTrack 0 Apr 25 01:56:13 volumio volumio[3133]: info: ------------------------------ 4ms Apr 25 01:56:13 volumio volumio[3133]: info: CoreCommandRouter::volumioGetQueue Apr 25 01:56:13 volumio volumio[3133]: info: CoreStateMachine::getQueue Apr 25 01:56:13 volumio volumio[3133]: info: CorePlayQueue::getQueue Apr 25 01:56:13 volumio volumio[3133]: info: Clearing queue after UPNP request Apr 25 01:56:14 volumio volumio[3133]: info: CoreStateMachine::ClearQueue Apr 25 01:56:14 volumio volumio[3133]: info: CoreStateMachine::stop Apr 25 01:56:14 volumio volumio[3133]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 25 01:56:14 volumio volumio[3133]: verbose: UNSET VOLATILE Apr 25 01:56:14 volumio volumio[3133]: info: CorePlayQueue::clearPlayQueue Apr 25 01:56:14 volumio volumio[3133]: info: CorePlayQueue::saveQueue Apr 25 01:56:14 volumio volumio[3133]: info: CoreCommandRouter::volumioPushState Apr 25 01:56:14 volumio volumio[3133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 01:56:14 volumio volumio[3133]: info: CoreCommandRouter::volumioPushQueue Apr 25 01:56:14 volumio volumio[3133]: info: Apr 25 01:56:14 volumio volumio[3133]: ---------------------------- MPD announces system playlist update Apr 25 01:56:14 volumio volumio[3133]: info: Ignoring MPD Status Update Apr 25 01:56:14 volumio volumio[3133]: error: updateQueue error: null Apr 25 01:56:14 volumio volumio[3133]: info: ------------------------------ 1ms Apr 25 01:56:14 volumio volumio[3133]: info: Starting UPNP Playback Apr 25 01:56:14 volumio volumio[3133]: info: Preparing playback through UPNP Apr 25 01:56:14 volumio volumio[3133]: info: CoreCommandRouter::volumioGetState Apr 25 01:56:14 volumio volumio[3133]: info: CorePlayQueue::getTrack 0 Apr 25 01:56:14 volumio volumio[3133]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 25 01:56:14 volumio volumio[3133]: info: Apr 25 01:56:14 volumio volumio[3133]: ---------------------------- MPD announces system playlist update Apr 25 01:56:14 volumio volumio[3133]: info: Ignoring MPD Status Update Apr 25 01:56:14 volumio volumio[3133]: info: ------------------------------ 0ms Apr 25 01:56:14 volumio volumio[3133]: info: Apr 25 01:56:14 volumio volumio[3133]: ---------------------------- MPD announces system playlist update Apr 25 01:56:14 volumio volumio[3133]: info: Ignoring MPD Status Update Apr 25 01:56:14 volumio volumio[3133]: info: ------------------------------ 0ms Apr 25 01:56:14 volumio volumio[3133]: info: Apr 25 01:56:14 volumio volumio[3133]: ---------------------------- MPD announces system playlist update Apr 25 01:56:14 volumio volumio[3133]: info: Ignoring MPD Status Update Apr 25 01:56:14 volumio volumio[3133]: info: ------------------------------ 0ms Apr 25 01:56:14 volumio volumio[3133]: info: Apr 25 01:56:14 volumio volumio[3133]: ---------------------------- MPD announces system playlist update Apr 25 01:56:14 volumio volumio[3133]: info: Ignoring MPD Status Update Apr 25 01:56:14 volumio volumio[3133]: info: ------------------------------ 0ms Apr 25 01:56:14 volumio volumio[3133]: info: Apr 25 01:56:14 volumio volumio[3133]: ---------------------------- MPD announces system playlist update Apr 25 01:56:14 volumio volumio[3133]: info: Ignoring MPD Status Update Apr 25 01:56:14 volumio volumio[3133]: info: ------------------------------ 0ms Apr 25 01:56:14 volumio volumio[3133]: info: Apr 25 01:56:14 volumio volumio[3133]: ---------------------------- MPD announces system playlist update Apr 25 01:56:14 volumio volumio[3133]: info: Ignoring MPD Status Update Apr 25 01:56:14 volumio volumio[3133]: info: ------------------------------ 1ms Apr 25 01:56:15 volumio volumio[3133]: info: Apr 25 01:56:15 volumio volumio[3133]: ---------------------------- MPD announces state update: player Apr 25 01:56:15 volumio volumio[3133]: info: ControllerMpd::getState Apr 25 01:56:15 volumio volumio[3133]: verbose: ControllerMpd::sendMpdCommand status Apr 25 01:56:15 volumio volumio[3133]: info: sendMpdCommand status took 0 milliseconds Apr 25 01:56:15 volumio volumio[3133]: verbose: ControllerMpd::parseState Apr 25 01:56:15 volumio volumio[3133]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 25 01:56:15 volumio volumio[3133]: info: Apr 25 01:56:15 volumio volumio[3133]: ---------------------------- MPD announces state update: player Apr 25 01:56:15 volumio volumio[3133]: info: ControllerMpd::getState Apr 25 01:56:15 volumio volumio[3133]: verbose: ControllerMpd::sendMpdCommand status Apr 25 01:56:15 volumio volumio[3133]: info: Apr 25 01:56:15 volumio volumio[3133]: ---------------------------- MPD announces system playlist update Apr 25 01:56:15 volumio volumio[3133]: info: Ignoring MPD Status Update Apr 25 01:56:15 volumio volumio[3133]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 25 01:56:15 volumio volumio[3133]: info: sendMpdCommand status took 0 milliseconds Apr 25 01:56:15 volumio volumio[3133]: verbose: ControllerMpd::parseTrackInfo Apr 25 01:56:15 volumio volumio[3133]: verbose: ControllerMpd::parseState Apr 25 01:56:15 volumio volumio[3133]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 25 01:56:15 volumio volumio[3133]: info: ControllerMpd::pushState Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::servicePushState Apr 25 01:56:15 volumio volumio[3133]: verbose: In UPNP mode Apr 25 01:56:15 volumio volumio[3133]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":325,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"阿嬷的歌","artist":"吉尼红美","album":"阿嬷的歌","uri":"http://220.169.152.211/amobile.music.tc.qq.com/M500002KsWHG1TZXie.mp3?guid=0000000059a75988000001879df3d79f&vkey=FBCFD4AF40709F85040E8484DF260381F3463517DA222A109AE1D12171608AE9275B26FC3FB6E0D74367D34F7171AE7D43FE971D30D4D6B0&uin=1152921504679429217&redirect=1&fromtag=111042","trackType":""} Apr 25 01:56:15 volumio volumio[3133]: verbose: CURRENT POSITION 0 Apr 25 01:56:15 volumio volumio[3133]: info: CoreStateMachine::syncState stateService play Apr 25 01:56:15 volumio volumio[3133]: info: CoreStateMachine::syncState currentStatus stop Apr 25 01:56:15 volumio volumio[3133]: info: CoreStateMachine::pushState Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::volumioPushState Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 01:56:15 volumio volumio[3133]: info: ------------------------------ 8ms Apr 25 01:56:15 volumio volumio[3133]: info: ------------------------------ 7ms Apr 25 01:56:15 volumio volumio[3133]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 25 01:56:15 volumio volumio[3133]: verbose: ControllerMpd::parseTrackInfo Apr 25 01:56:15 volumio volumio[3133]: info: ControllerMpd::pushState Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::servicePushState Apr 25 01:56:15 volumio volumio[3133]: verbose: In UPNP mode Apr 25 01:56:15 volumio volumio[3133]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":325,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"阿嬷的歌","artist":"吉尼红美","album":"阿嬷的歌","uri":"http://220.169.152.211/amobile.music.tc.qq.com/M500002KsWHG1TZXie.mp3?guid=0000000059a75988000001879df3d79f&vkey=FBCFD4AF40709F85040E8484DF260381F3463517DA222A109AE1D12171608AE9275B26FC3FB6E0D74367D34F7171AE7D43FE971D30D4D6B0&uin=1152921504679429217&redirect=1&fromtag=111042","trackType":""} Apr 25 01:56:15 volumio volumio[3133]: verbose: CURRENT POSITION 0 Apr 25 01:56:15 volumio volumio[3133]: info: CoreStateMachine::syncState stateService play Apr 25 01:56:15 volumio volumio[3133]: info: CoreStateMachine::syncState currentStatus play Apr 25 01:56:15 volumio volumio[3133]: info: Received an update from plugin. extracting info from payload Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Apr 25 01:56:15 volumio volumio[3133]: info: CoreStateMachine::pushState Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::volumioPushState Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 01:56:15 volumio volumio[3133]: info: CoreStateMachine::pushState Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::volumioPushState Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 25 01:56:15 volumio volumio[3133]: info: ------------------------------ 11ms Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::volumioGetQueue Apr 25 01:56:15 volumio volumio[3133]: info: CoreStateMachine::getQueue Apr 25 01:56:15 volumio volumio[3133]: info: CorePlayQueue::getQueue Apr 25 01:56:15 volumio volumio[3133]: info: CoreCommandRouter::volumioGetQueue Apr 25 01:56:15 volumio volumio[3133]: info: CoreStateMachine::getQueue Apr 25 01:56:15 volumio volumio[3133]: info: CorePlayQueue::getQueue Apr 25 01:56:30 volumio kernel: ideapad_laptop: Unknown event: 1 Apr 25 01:56:52 volumio kernel: ideapad_laptop: Unknown event: 1 Apr 25 01:57:14 volumio kernel: ideapad_laptop: Unknown event: 1 Apr 25 01:57:16 volumio volumio[3133]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 25 01:57:16 volumio volumio[3133]: { Error: connect ETIMEDOUT 168.143.162.42:443 Apr 25 01:57:16 volumio volumio[3133]: at Object._errnoException (util.js:1022:11) Apr 25 01:57:16 volumio volumio[3133]: at _exceptionWithHostPort (util.js:1044:20) Apr 25 01:57:16 volumio volumio[3133]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 25 01:57:16 volumio volumio[3133]: code: 'ETIMEDOUT', Apr 25 01:57:16 volumio volumio[3133]: errno: 'ETIMEDOUT', Apr 25 01:57:16 volumio volumio[3133]: syscall: 'connect', Apr 25 01:57:16 volumio volumio[3133]: address: '168.143.162.42', Apr 25 01:57:16 volumio volumio[3133]: port: 443 } Apr 25 01:57:16 volumio volumio[3133]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 25 01:57:16 volumio sudo[4756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-25 01:56 Apr 25 01:57:16 volumio sudo[4756]: 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="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"