-- Logs begin at Tue 2024-09-17 23:32:23 CST, end at Tue 2024-10-01 15:30:52 CST. -- Oct 01 15:29:04 volumio sudo[3179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 01 15:29:04 volumio sudo[3179]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 15:29:04 volumio sudo[3182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 01 15:29:04 volumio sudo[3182]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 15:29:04 volumio sudo[3182]: pam_unix(sudo:session): session closed for user root Oct 01 15:29:04 volumio sudo[3179]: pam_unix(sudo:session): session closed for user root Oct 01 15:29:04 volumio volumio[864]: verbose: New Socket.io Connection to 192.168.88.49 from 192.168.88.228 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/94.0.4606.71 Safari/537.36 SE 2.X MetaSr 1.0 Engine version: 3 Transport: polling Total Clients: 5 Oct 01 15:29:04 volumio volumio[864]: info: CoreCommandRouter::volumioGetVisibleSources Oct 01 15:29:04 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 01 15:29:04 volumio volumio[864]: info: CoreCommandRouter::volumioGetState Oct 01 15:29:04 volumio volumio[864]: info: CorePlayQueue::getTrack 0 Oct 01 15:29:04 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 01 15:29:04 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 01 15:29:04 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 01 15:29:04 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 01 15:29:05 volumio sudo[3187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 01 15:29:05 volumio sudo[3187]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 15:29:05 volumio sudo[3187]: pam_unix(sudo:session): session closed for user root Oct 01 15:29:05 volumio sudo[3189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 01 15:29:05 volumio sudo[3189]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 15:29:05 volumio sudo[3189]: pam_unix(sudo:session): session closed for user root Oct 01 15:29:05 volumio volumio[864]: verbose: New Socket.io Connection to 192.168.88.49 from 192.168.88.228 UA: Mozilla/5.0 (Windows NT 10.0; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/94.0.4606.71 Safari/537.36 SE 2.X MetaSr 1.0 Engine version: 3 Transport: polling Total Clients: 5 Oct 01 15:29:05 volumio volumio[864]: info: CoreCommandRouter::volumioGetState Oct 01 15:29:05 volumio volumio[864]: info: CorePlayQueue::getTrack 0 Oct 01 15:29:05 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 01 15:29:05 volumio volumio[864]: info: Listing playlists Oct 01 15:29:05 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 01 15:29:05 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 01 15:29:05 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 01 15:29:05 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 01 15:29:05 volumio volumio[864]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/A-Mei/f891112d-37b7-4870-a756-439fc564d274.jpg' Oct 01 15:29:07 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 01 15:29:07 volumio volumio[864]: info: Received Get System Info Oct 01 15:29:07 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 01 15:29:07 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 01 15:29:07 volumio volumio[864]: info: Discovery: Getting this device information Oct 01 15:29:07 volumio volumio[864]: info: CoreCommandRouter::volumioGetState Oct 01 15:29:07 volumio volumio[864]: info: CorePlayQueue::getTrack 0 Oct 01 15:29:07 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 01 15:29:54 volumio volumio[864]: info: CoreCommandRouter::volumioPause Oct 01 15:29:54 volumio volumio[864]: info: CoreStateMachine::pause Oct 01 15:29:54 volumio volumio[864]: info: CoreStateMachine::stPlaybackTimer Oct 01 15:29:54 volumio volumio[864]: info: CoreStateMachine::servicePause Oct 01 15:29:54 volumio volumio[864]: info: CorePlayQueue::getTrack 0 Oct 01 15:29:54 volumio volumio[864]: info: CoreCommandRouter::servicePause Oct 01 15:29:54 volumio volumio[864]: info: ControllerMpd::pause Oct 01 15:29:54 volumio volumio[864]: verbose: ControllerMpd::sendMpdCommand pause Oct 01 15:29:54 volumio volumio[864]: info: Oct 01 15:29:54 volumio volumio[864]: ---------------------------- MPD announces state update: player Oct 01 15:29:54 volumio volumio[864]: info: sendMpdCommand pause took 1 milliseconds Oct 01 15:29:54 volumio volumio[864]: info: ControllerMpd::getState Oct 01 15:29:54 volumio volumio[864]: verbose: ControllerMpd::sendMpdCommand status Oct 01 15:29:54 volumio volumio[864]: info: sendMpdCommand status took 0 milliseconds Oct 01 15:29:54 volumio volumio[864]: verbose: ControllerMpd::parseState Oct 01 15:29:54 volumio volumio[864]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 15:29:54 volumio volumio[864]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 15:29:54 volumio volumio[864]: verbose: ControllerMpd::parseTrackInfo Oct 01 15:29:54 volumio volumio[864]: info: ControllerMpd::pushState Oct 01 15:29:54 volumio volumio[864]: info: CoreCommandRouter::servicePushState Oct 01 15:29:54 volumio volumio[864]: info: CorePlayQueue::getTrack 0 Oct 01 15:29:54 volumio volumio[864]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":56119,"duration":284,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Jie Tuo","artist":"A-Mei","album":null,"uri":"NAS/Music/dsf/05 - 解脱.dsf","trackType":"dsf"} Oct 01 15:29:54 volumio volumio[864]: verbose: CURRENT POSITION 0 Oct 01 15:29:54 volumio volumio[864]: info: CoreStateMachine::syncState stateService pause Oct 01 15:29:54 volumio volumio[864]: info: CoreStateMachine::syncState currentStatus pause Oct 01 15:29:54 volumio volumio[864]: info: CoreStateMachine::pushState Oct 01 15:29:54 volumio volumio[864]: info: CorePlayQueue::getTrack 0 Oct 01 15:29:54 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 15:29:54 volumio volumio[864]: info: CoreCommandRouter::volumioPushState Oct 01 15:29:54 volumio volumio[864]: info: CoreStateMachine::stPlaybackTimer Oct 01 15:29:54 volumio volumio[864]: info: ------------------------------ 14ms Oct 01 15:30:02 volumio volumio[864]: info: CoreCommandRouter::volumioGetVisibleSources Oct 01 15:30:02 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 01 15:30:02 volumio volumio[864]: info: CoreCommandRouter::volumioGetQueue Oct 01 15:30:02 volumio volumio[864]: info: CoreStateMachine::getQueue Oct 01 15:30:02 volumio volumio[864]: info: CorePlayQueue::getQueue Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 01 15:30:17 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 01 15:30:34 volumio volumio[864]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] Oct 01 15:30:34 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts Oct 01 15:30:34 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Oct 01 15:30:34 volumio sudo[3471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 01 15:30:34 volumio sudo[3471]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 15:30:34 volumio sudo[3471]: pam_unix(sudo:session): session closed for user root Oct 01 15:30:34 volumio volumio[864]: info: MPD Permissions set Oct 01 15:30:34 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 15:30:34 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 15:30:34 volumio sudo[3473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 01 15:30:34 volumio sudo[3473]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 15:30:34 volumio systemd[1]: Stopping Music Player Daemon... Oct 01 15:30:34 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 01 15:30:34 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 01 15:30:34 volumio systemd[1]: mpd.service: Succeeded. Oct 01 15:30:34 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 01 15:30:34 volumio systemd[1]: Stopped Music Player Daemon. Oct 01 15:30:34 volumio systemd[1]: Starting Music Player Daemon... Oct 01 15:30:34 volumio sudo[3483]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 01 15:30:34 volumio sudo[3483]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 01 15:30:34 volumio sudo[3483]: pam_unix(sudo:session): session closed for user root Oct 01 15:30:34 volumio volumio[864]: error: Upnp client error: Error: This socket has been ended by the other party Oct 01 15:30:35 volumio mpd[3486]: Oct 01 15:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 01 15:30:35 volumio systemd[1]: Started Music Player Daemon. Oct 01 15:30:35 volumio sudo[3473]: pam_unix(sudo:session): session closed for user root Oct 01 15:30:35 volumio volumio[864]: error: updateQueue error: null Oct 01 15:30:52 volumio volumio[864]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 15:30:52 volumio volumio[864]: Error: connect ETIMEDOUT 173.252.108.21:443 Oct 01 15:30:52 volumio volumio[864]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 01 15:30:52 volumio volumio[864]: errno: -110, Oct 01 15:30:52 volumio volumio[864]: code: 'ETIMEDOUT', Oct 01 15:30:52 volumio volumio[864]: syscall: 'connect', Oct 01 15:30:52 volumio volumio[864]: address: '173.252.108.21', Oct 01 15:30:52 volumio volumio[864]: port: 443 Oct 01 15:30:52 volumio volumio[864]: } Oct 01 15:30:52 volumio volumio[864]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 15:30:52 volumio sudo[3531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-01 15:29 Oct 01 15:30:52 volumio sudo[3531]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"