-- Logs begin at Thu 2019-02-14 10:12:00 UTC, end at Wed 2025-07-09 05:22:25 UTC. -- Jul 09 05:21:01 volumio volumio[2186]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 05:21:01 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 09 05:21:01 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 05:21:01 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 09 05:21:01 volumio volumio[2186]: info: Getting Alsa Cards List without I2S DAC Jul 09 05:21:01 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 09 05:21:01 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 05:21:02 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 05:21:02 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 05:21:02 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 05:21:02 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 05:21:02 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 05:21:02 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 05:21:02 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 05:21:02 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 09 05:21:02 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 09 05:21:36 volumio volumio[2186]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Jul 09 05:21:36 volumio sudo[2523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 05:21:36 volumio sudo[2523]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 05:21:36 volumio sudo[2523]: pam_unix(sudo:session): session closed for user root Jul 09 05:21:36 volumio volumio[2186]: info: MPD Permissions set Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:21:36 volumio sudo[2526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 05:21:36 volumio sudo[2526]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 05:21:36 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 05:21:36 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:21:36 volumio systemd[1]: mpd.service: Succeeded. Jul 09 05:21:36 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 05:21:36 volumio systemd[1]: Starting Music Player Daemon... Jul 09 05:21:37 volumio mpd[2534]: Jul 09 05:21 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 05:21:38 volumio mpd[2534]: Jul 09 05:21 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jul 09 05:21:38 volumio mpd[2534]: Jul 09 05:21 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jul 09 05:21:38 volumio systemd[1]: Started Music Player Daemon. Jul 09 05:21:38 volumio sudo[2526]: pam_unix(sudo:session): session closed for user root Jul 09 05:21:38 volumio volumio[2186]: error: updateQueue error: null Jul 09 05:21:43 volumio volumio[2186]: info: CoreCommandRouter::volumioPause Jul 09 05:21:43 volumio volumio[2186]: info: CoreStateMachine::pause Jul 09 05:21:43 volumio volumio[2186]: info: CoreStateMachine::stPlaybackTimer Jul 09 05:21:43 volumio volumio[2186]: info: CoreStateMachine::servicePause Jul 09 05:21:43 volumio volumio[2186]: info: CorePlayQueue::getTrack 0 Jul 09 05:21:43 volumio volumio[2186]: info: CoreCommandRouter::servicePause Jul 09 05:21:43 volumio volumio[2186]: info: ControllerMpd::pause Jul 09 05:21:43 volumio volumio[2186]: verbose: ControllerMpd::sendMpdCommand pause Jul 09 05:21:43 volumio volumio[2186]: info: sendMpdCommand pause took 1 milliseconds Jul 09 05:21:44 volumio volumio[2186]: info: CoreCommandRouter::volumioPause Jul 09 05:21:44 volumio volumio[2186]: info: CoreStateMachine::pause Jul 09 05:22:00 volumio volumio[2186]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Jul 09 05:22:00 volumio sudo[2538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 05:22:00 volumio sudo[2538]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 05:22:00 volumio sudo[2538]: pam_unix(sudo:session): session closed for user root Jul 09 05:22:00 volumio volumio[2186]: info: MPD Permissions set Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:22:00 volumio sudo[2541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:22:00 volumio sudo[2541]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 05:22:00 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 05:22:00 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 05:22:00 volumio systemd[1]: mpd.service: Succeeded. Jul 09 05:22:00 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 05:22:00 volumio systemd[1]: Starting Music Player Daemon... Jul 09 05:22:01 volumio mpd[2549]: Jul 09 05:22 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 05:22:02 volumio mpd[2549]: Jul 09 05:22 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jul 09 05:22:02 volumio mpd[2549]: Jul 09 05:22 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jul 09 05:22:02 volumio systemd[1]: Started Music Player Daemon. Jul 09 05:22:02 volumio sudo[2541]: pam_unix(sudo:session): session closed for user root Jul 09 05:22:02 volumio volumio[2186]: error: updateQueue error: null Jul 09 05:22:04 volumio volumio[2186]: info: CoreCommandRouter::volumioSeek Jul 09 05:22:04 volumio volumio[2186]: info: CoreStateMachine::seek Jul 09 05:22:04 volumio volumio[2186]: info: CorePlayQueue::getTrack 0 Jul 09 05:22:04 volumio volumio[2186]: info: TRACKBLOCK {"uri":"mnt/USB/My_Passport/pop/doa-nexus/青い果実/doa - 青い果実.wav","service":"mpd","name":"doa - 青い果実.wav","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=777&web=//extralarge&path=%2FUSB%2FMy_Passport%2Fpop%2Fdoa-nexus%2F%E9%9D%92%E3%81%84%E6%9E%9C%E5%AE%9F&metadata=false","duration":630,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"wav","channels":2} Jul 09 05:22:04 volumio volumio[2186]: info: CoreStateMachine::startPlaybackTimer Jul 09 05:22:04 volumio volumio[2186]: info: CorePlayQueue::getTrack 0 Jul 09 05:22:04 volumio volumio[2186]: info: ControllerMpd::seek Jul 09 05:22:04 volumio volumio[2186]: info: CoreStateMachine::pushState Jul 09 05:22:04 volumio volumio[2186]: info: CorePlayQueue::getTrack 0 Jul 09 05:22:04 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 05:22:04 volumio volumio[2186]: info: CoreCommandRouter::volumioPushState Jul 09 05:22:04 volumio volumio[2186]: error: [2@0] {seek} Bad song index Jul 09 05:22:07 volumio volumio[2186]: info: CoreCommandRouter::volumioPlay Jul 09 05:22:07 volumio volumio[2186]: verbose: UNSET VOLATILE Jul 09 05:22:07 volumio volumio[2186]: info: CoreStateMachine::play index undefined Jul 09 05:22:07 volumio volumio[2186]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 05:22:07 volumio volumio[2186]: info: CorePlayQueue::getTrack 0 Jul 09 05:22:07 volumio volumio[2186]: info: CoreStateMachine::startPlaybackTimer Jul 09 05:22:07 volumio volumio[2186]: info: CorePlayQueue::getTrack 0 Jul 09 05:22:07 volumio volumio[2186]: info: ControllerMpd::resume Jul 09 05:22:07 volumio volumio[2186]: verbose: ControllerMpd::sendMpdCommand play Jul 09 05:22:07 volumio volumio[2186]: info: sendMpdCommand play took 1 milliseconds Jul 09 05:22:11 volumio volumio[2186]: info: CoreCommandRouter::volumioPlay Jul 09 05:22:11 volumio volumio[2186]: verbose: UNSET VOLATILE Jul 09 05:22:11 volumio volumio[2186]: info: CoreStateMachine::play index undefined Jul 09 05:22:11 volumio volumio[2186]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 05:22:11 volumio volumio[2186]: info: CorePlayQueue::getTrack 0 Jul 09 05:22:11 volumio volumio[2186]: info: CoreStateMachine::startPlaybackTimer Jul 09 05:22:11 volumio volumio[2186]: info: CorePlayQueue::getTrack 0 Jul 09 05:22:11 volumio volumio[2186]: info: ControllerMpd::resume Jul 09 05:22:11 volumio volumio[2186]: verbose: ControllerMpd::sendMpdCommand play Jul 09 05:22:11 volumio volumio[2186]: info: sendMpdCommand play took 1 milliseconds Jul 09 05:22:13 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 05:22:13 volumio volumio[2186]: info: CURURI: playlists Jul 09 05:22:13 volumio volumio[2186]: info: Listing playlists Jul 09 05:22:14 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 05:22:14 volumio volumio[2186]: info: CURURI: music-library Jul 09 05:22:15 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 05:22:15 volumio volumio[2186]: info: CURURI: music-library/USB Jul 09 05:22:17 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 05:22:17 volumio volumio[2186]: info: CURURI: music-library/USB/新加卷 Jul 09 05:22:19 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 05:22:19 volumio volumio[2186]: info: CURURI: music-library/USB/My_Passport Jul 09 05:22:21 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 05:22:21 volumio volumio[2186]: info: CURURI: music-library/USB/My_Passport/pop Jul 09 05:22:24 volumio volumio[2186]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 09 05:22:24 volumio volumio[2186]: info: CURURI: music-library/USB/My_Passport/pop/Aimer Jul 09 05:22:25 volumio volumio[2186]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 05:22:25 volumio volumio[2186]: Error: connect ETIMEDOUT 128.121.243.235:443 Jul 09 05:22:25 volumio volumio[2186]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jul 09 05:22:25 volumio volumio[2186]: errno: -110, Jul 09 05:22:25 volumio volumio[2186]: code: 'ETIMEDOUT', Jul 09 05:22:25 volumio volumio[2186]: syscall: 'connect', Jul 09 05:22:25 volumio volumio[2186]: address: '128.121.243.235', Jul 09 05:22:25 volumio volumio[2186]: port: 443 Jul 09 05:22:25 volumio volumio[2186]: } Jul 09 05:22:25 volumio volumio[2186]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 05:22:25 volumio sudo[2561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 05:21 Jul 09 05:22:25 volumio sudo[2561]: 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="543f2de901f774399af6eae9d76f06fe4162e5dd" VOLUMIO_FE_VERSION="dff19baf69ee85af3381c73e932cb6852dfe38e0" VOLUMIO_FE3_VERSION="081f1f7a36b167d793d831ee89ac02e7f8f3ee4b" VOLUMIO_BE_VERSION="1eeee4d17c356c3967f07f80a7dfdbc12de2e066" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 08 Dec 2021 12:21:52 PM CET" VOLUMIO_VERSION="3.173" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1c9433a7294bad3fb7682386561b54d4"