-- Logs begin at Thu 2019-02-14 19:12:00 JST, end at Tue 2024-05-07 21:29:46 JST. -- May 07 21:28:05 volumio3-es9038b volumio[1124]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 07 21:28:08 volumio3-es9038b ntpd[689]: Soliciting pool server 172.105.204.105 May 07 21:28:09 volumio3-es9038b ntpd[689]: Soliciting pool server 133.130.121.141 May 07 21:28:10 volumio3-es9038b ntpd[689]: Soliciting pool server 133.243.238.243 May 07 21:28:10 volumio3-es9038b ntpd[689]: Soliciting pool server 133.243.238.163 May 07 21:28:11 volumio3-es9038b ntpd[689]: Soliciting pool server 129.250.35.250 May 07 21:28:11 volumio3-es9038b ntpd[689]: Soliciting pool server 45.76.218.37 May 07 21:28:12 volumio3-es9038b ntpd[689]: Soliciting pool server 129.250.35.251 May 07 21:28:12 volumio3-es9038b ntpd[689]: Soliciting pool server 202.181.103.212 May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::volumioGetBrowseSources May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::volumioGetBrowseSources May 07 21:28:12 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::volumioGetBrowseSources May 07 21:28:13 volumio3-es9038b ntpd[689]: Soliciting pool server 160.16.113.133 May 07 21:28:13 volumio3-es9038b ntpd[689]: Soliciting pool server 20.210.25.42 May 07 21:28:13 volumio3-es9038b ntpd[689]: Soliciting pool server 162.159.200.123 May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 07 21:28:14 volumio3-es9038b ntpd[689]: Soliciting pool server 45.76.221.157 May 07 21:28:14 volumio3-es9038b volumio[1124]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion May 07 21:28:14 volumio3-es9038b volumio[1124]: info: Preparing to generate the ALSA configuration file May 07 21:28:14 volumio3-es9038b volumio[1124]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 07 21:28:14 volumio3-es9038b volumio[1124]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 07 21:28:14 volumio3-es9038b volumio[1124]: info: Reading ALSA contributions from plugins. May 07 21:28:14 volumio3-es9038b volumio[1124]: info: Asound.conf file unchanged, so no further update is needed May 07 21:28:14 volumio3-es9038b volumio[1124]: info: Output device has changed, restarting MPD May 07 21:28:14 volumio3-es9038b sudo[1333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 07 21:28:14 volumio3-es9038b sudo[1333]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:14 volumio3-es9038b volumio[1124]: info: Output device has changed, restarting Shairport Sync May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:28:14 volumio3-es9038b sudo[1333]: pam_unix(sudo:session): session closed for user root May 07 21:28:14 volumio3-es9038b sudo[1336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 07 21:28:14 volumio3-es9038b sudo[1336]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:14 volumio3-es9038b volumio[1124]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 21:28:14 volumio3-es9038b volumio[1124]: info: ___________ START PLUGINS ___________ May 07 21:28:14 volumio3-es9038b volumio[1124]: info: ControllerMpd::onStart: Initializing MPD May 07 21:28:14 volumio3-es9038b volumio[1124]: info: Creating MPD Configuration file May 07 21:28:14 volumio3-es9038b sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 07 21:28:14 volumio3-es9038b sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 07 21:28:14 volumio3-es9038b volumio[1124]: info: [1715084894885] CoreMusicLibrary::Adding element メディアサーバー May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:28:14 volumio3-es9038b systemd[1]: Listening on mpd.socket. May 07 21:28:14 volumio3-es9038b sudo[1343]: pam_unix(sudo:session): session closed for user root May 07 21:28:14 volumio3-es9038b systemd[1]: Starting Music Player Daemon... May 07 21:28:14 volumio3-es9038b sudo[1345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 07 21:28:14 volumio3-es9038b sudo[1345]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:28:14 volumio3-es9038b systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 07 21:28:14 volumio3-es9038b systemd[1]: mpd.service: Succeeded. May 07 21:28:14 volumio3-es9038b systemd[1]: Stopped Music Player Daemon. May 07 21:28:14 volumio3-es9038b systemd[1]: Starting Music Player Daemon... May 07 21:28:14 volumio3-es9038b volumio[1124]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:14 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 07 21:28:15 volumio3-es9038b volumio[1124]: info: [1715084895040] CoreMusicLibrary::Adding element Last_100 May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 07 21:28:15 volumio3-es9038b volumio[1124]: info: [1715084895044] CoreMusicLibrary::Adding element Webradio May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 07 21:28:15 volumio3-es9038b volumio[1124]: info: [1715084895069] CoreMusicLibrary::Adding element YouTube2 May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:28:15 volumio3-es9038b volumio[1124]: Cannot find translation for source YouTube2 May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Loading i18n strings for locale ja May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: mixtype--------------------- Software May 07 21:28:15 volumio3-es9038b sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart logitechmediaserver May 07 21:28:15 volumio3-es9038b sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 07 21:28:15 volumio3-es9038b volumio[1124]: info: [1715084895168] CoreMusicLibrary::Adding element Personal Radio May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:28:15 volumio3-es9038b volumio[1124]: Cannot find translation for source YouTube2 May 07 21:28:15 volumio3-es9038b volumio[1124]: Cannot find translation for source Personal Radio May 07 21:28:15 volumio3-es9038b systemd[1]: Stopping Logitech Media Server Daemon... May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Volumio Calling Home May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Preparing to generate the ALSA configuration file May 07 21:28:15 volumio3-es9038b squeezeboxserver[674]: [24-05-07 21:27:21.6099] Slim::Formats::XML::gotErrorViaHTTP (343) Error: getting https://www.mysqueezebox.com/api/sounds/v1/opml May 07 21:28:15 volumio3-es9038b squeezeboxserver[674]: Couldn't resolve IP address for: www.mysqueezebox.com May 07 21:28:15 volumio3-es9038b squeezeboxserver[674]: [24-05-07 21:27:21.6110] Slim::Plugin::Sounds::Plugin::_gotSoundsError (82) Error: Unable to cache Sounds & Effects menu from SN: Couldn't resolve IP address for: www.mysqueezebox.com May 07 21:28:15 volumio3-es9038b squeezeboxserver[674]: [24-05-07 21:27:58.5768] Slim::Utils::SQLiteHelper::postConnect (377) Optimizing DB because of missing or empty sqlite_stat1 table May 07 21:28:15 volumio3-es9038b squeezeboxserver[674]: [24-05-07 21:27:59.2823] Slim::Schema::forceCommit (2177) Warning: Trying to commit transactions before DB is initialized! May 07 21:28:15 volumio3-es9038b ntpd[689]: Soliciting pool server 2406:da14:10c4:9aa0:123:: May 07 21:28:15 volumio3-es9038b volumio[1124]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 07 21:28:15 volumio3-es9038b volumio[1124]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Reading ALSA contributions from plugins. May 07 21:28:15 volumio3-es9038b volumio[1124]: info: MPD Permissions set May 07 21:28:15 volumio3-es9038b volumio[1124]: info: MPD Permissions set May 07 21:28:15 volumio3-es9038b volumio[1124]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 May 07 21:28:15 volumio3-es9038b systemd[1]: logitechmediaserver.service: Succeeded. May 07 21:28:15 volumio3-es9038b systemd[1]: Stopped Logitech Media Server Daemon. May 07 21:28:15 volumio3-es9038b systemd[1]: Starting Logitech Media Server Daemon... May 07 21:28:15 volumio3-es9038b systemd[1]: Started Logitech Media Server Daemon. May 07 21:28:15 volumio3-es9038b sudo[1357]: pam_unix(sudo:session): session closed for user root May 07 21:28:15 volumio3-es9038b volumio[1124]: info: logitechmediaserver started May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Starting Shairport Sync May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Starting Shairport Sync May 07 21:28:15 volumio3-es9038b sudo[1374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 21:28:15 volumio3-es9038b sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:15 volumio3-es9038b systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 07 21:28:15 volumio3-es9038b sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 21:28:15 volumio3-es9038b systemd[1]: shairport-sync.service: Succeeded. May 07 21:28:15 volumio3-es9038b systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 07 21:28:15 volumio3-es9038b sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:15 volumio3-es9038b systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Starting Shairport Sync May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Asound.conf file unchanged, so no further update is needed May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Output device has changed, restarting MPD May 07 21:28:15 volumio3-es9038b volumio[1124]: info: Output device has changed, restarting Shairport Sync May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:15 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:28:15 volumio3-es9038b sudo[1381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 21:28:15 volumio3-es9038b sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 07 21:28:15 volumio3-es9038b sudo[1381]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:15 volumio3-es9038b sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:15 volumio3-es9038b sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 07 21:28:15 volumio3-es9038b sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:15 volumio3-es9038b sudo[1374]: pam_unix(sudo:session): session closed for user root May 07 21:28:16 volumio3-es9038b sudo[1385]: pam_unix(sudo:session): session closed for user root May 07 21:28:16 volumio3-es9038b volumio[1124]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 21:28:16 volumio3-es9038b systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 07 21:28:16 volumio3-es9038b systemd[1]: shairport-sync.service: Succeeded. May 07 21:28:16 volumio3-es9038b systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 07 21:28:16 volumio3-es9038b volumio[1124]: (node:1124) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. May 07 21:28:16 volumio3-es9038b volumio[1124]: (Use `node --trace-deprecation ...` to show where the warning was created) May 07 21:28:16 volumio3-es9038b volumio[1124]: (node:1124) [DEP0106] DeprecationWarning: crypto.createDecipher is deprecated. May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::volumioGetState May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CorePlayQueue::getTrack 0 May 07 21:28:16 volumio3-es9038b volumio[1124]: info: MPD Permissions set May 07 21:28:16 volumio3-es9038b volumio[1124]: info: Shairport-Sync Started May 07 21:28:16 volumio3-es9038b volumio[1124]: Error adding Membership: Error: addMembership EINVAL May 07 21:28:16 volumio3-es9038b volumio[1124]: info: Volumio called home May 07 21:28:16 volumio3-es9038b systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 07 21:28:16 volumio3-es9038b sudo[1381]: pam_unix(sudo:session): session closed for user root May 07 21:28:16 volumio3-es9038b systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 07 21:28:16 volumio3-es9038b systemd[1]: mpd.service: Succeeded. May 07 21:28:16 volumio3-es9038b systemd[1]: Stopped Music Player Daemon. May 07 21:28:16 volumio3-es9038b sudo[1377]: pam_unix(sudo:session): session closed for user root May 07 21:28:16 volumio3-es9038b volumio[1124]: info: Shairport-Sync Started May 07 21:28:16 volumio3-es9038b volumio[1124]: info: Shairport-Sync Started May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:16 volumio3-es9038b systemd[1]: Starting Music Player Daemon... May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:28:16 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:28:16 volumio3-es9038b volumio[1124]: info: Starting Shairport Sync May 07 21:28:16 volumio3-es9038b sudo[1403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 21:28:16 volumio3-es9038b sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:28:16 volumio3-es9038b systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 07 21:28:16 volumio3-es9038b systemd[1]: shairport-sync.service: Succeeded. May 07 21:28:16 volumio3-es9038b systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 07 21:29:44 volumio3-es9038b systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 07 21:29:44 volumio3-es9038b sudo[1403]: pam_unix(sudo:session): session closed for user root May 07 21:29:44 volumio3-es9038b volumio[1124]: info: Shairport-Sync Started May 07 21:29:45 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:29:45 volumio3-es9038b volumio[1124]: info: AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 <-AAAAAAAAAAAAA May 07 21:29:45 volumio3-es9038b volumio[1124]: info: FusionDsp loaded May 07 21:29:45 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:29:45 volumio3-es9038b sudo[1414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 07 21:29:45 volumio3-es9038b sudo[1414]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:29:45 volumio3-es9038b volumio[1124]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 May 07 21:29:45 volumio3-es9038b volumio[1124]: error: File size not found in array! May 07 21:29:45 volumio3-es9038b volumio[1124]: info: eq1: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 25 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq2: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 40 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq3: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 63 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq4: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 100 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq5: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 160 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq6: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 250 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq7: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 400 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq8: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 630 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq9: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 1000 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq10: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 1600 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq11: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 2500 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq12: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 4000 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq13: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 6300 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq14: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 10000 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: eq15: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Biquad May 07 21:29:45 volumio3-es9038b volumio[1124]: parameters: May 07 21:29:45 volumio3-es9038b volumio[1124]: type: Peaking May 07 21:29:45 volumio3-es9038b volumio[1124]: freq: 16000 May 07 21:29:45 volumio3-es9038b volumio[1124]: q: 1.85 May 07 21:29:45 volumio3-es9038b volumio[1124]: gain: 0 May 07 21:29:45 volumio3-es9038b volumio[1124]: error: WebSocket error: [object Object] May 07 21:29:45 volumio3-es9038b systemd[1]: Started FusionDsp Daemon. May 07 21:29:45 volumio3-es9038b sudo[1414]: pam_unix(sudo:session): session closed for user root May 07 21:29:45 volumio3-es9038b volumio[1124]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 07 21:29:45 volumio3-es9038b volumio[1124]: verbose: ControllerMpd::sendMpdCommand update May 07 21:29:45 volumio3-es9038b volumio[1124]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 21:29:45 volumio3-es9038b volumio[1124]: TypeError: Cannot read property 'then' of undefined May 07 21:29:45 volumio3-es9038b volumio[1124]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6) May 07 21:29:45 volumio3-es9038b volumio[1124]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1898:15) May 07 21:29:45 volumio3-es9038b volumio[1124]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) May 07 21:29:45 volumio3-es9038b volumio[1124]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1049:26) May 07 21:29:45 volumio3-es9038b volumio[1124]: at Socket.emit (events.js:315:20) May 07 21:29:45 volumio3-es9038b volumio[1124]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 07 21:29:45 volumio3-es9038b volumio[1124]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 07 21:29:45 volumio3-es9038b volumio[1124]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 21:29:46 volumio3-es9038b sudo[1426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-07 21:28 May 07 21:29:46 volumio3-es9038b sudo[1426]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"