-- Logs begin at Thu 2024-11-28 05:41:26 IST, end at Thu 2024-11-28 05:44:26 IST. -- Nov 28 05:43:00 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 28 05:43:00 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 28 05:43:00 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 28 05:43:00 music-hall volumio[1028]: SPOTIFY: SETTING SPOTIFY VOLUME 50 Nov 28 05:43:00 music-hall volumio[1028]: info: Sending Spotify command with payload to local API: /player/volume Nov 28 05:43:01 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 28 05:43:01 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 28 05:43:01 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 28 05:43:01 music-hall volumio-remote-updater[703]: No test mode Nov 28 05:43:01 music-hall volumio-remote-updater[703]: No alpha test mode Nov 28 05:43:01 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 28 05:43:01 music-hall volumio[1028]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 28 05:43:01 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 28 05:43:03 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 05:43:03 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 05:43:03 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 28 05:43:03 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 28 05:43:03 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 28 05:43:03 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 28 05:43:03 music-hall volumio[1028]: info: CoreCommandRouter::volumioGetBrowseSources Nov 28 05:43:03 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 28 05:43:04 music-hall ntpd[834]: Soliciting pool server 139.84.137.53 Nov 28 05:43:04 music-hall ntpd[834]: Soliciting pool server 192.46.211.253 Nov 28 05:43:05 music-hall ntpd[834]: Soliciting pool server 152.70.69.232 Nov 28 05:43:05 music-hall ntpd[834]: Soliciting pool server 192.46.215.60 Nov 28 05:43:06 music-hall ntpd[834]: Soliciting pool server 172.105.60.167 Nov 28 05:43:06 music-hall ntpd[834]: Soliciting pool server 192.46.210.39 Nov 28 05:43:06 music-hall ntpd[834]: Soliciting pool server 162.159.200.123 Nov 28 05:43:06 music-hall volumio[1028]: info: BOOT COMPLETED Nov 28 05:43:07 music-hall ntpd[834]: Soliciting pool server 162.159.200.1 Nov 28 05:43:07 music-hall ntpd[834]: Soliciting pool server 15.207.248.194 Nov 28 05:43:07 music-hall ntpd[834]: Soliciting pool server 157.245.102.2 Nov 28 05:43:07 music-hall ntpd[834]: Soliciting pool server 139.59.55.93 Nov 28 05:43:08 music-hall ntpd[834]: Soliciting pool server 144.24.146.96 Nov 28 05:43:08 music-hall ntpd[834]: Soliciting pool server 65.0.119.56 Nov 28 05:43:08 music-hall ntpd[834]: Soliciting pool server 139.59.15.185 Nov 28 05:43:08 music-hall ntpd[834]: Soliciting pool server 14.139.60.106 Nov 28 05:43:09 music-hall ntpd[834]: Soliciting pool server 17.253.18.99 Nov 28 05:43:09 music-hall ntpd[834]: Soliciting pool server 95.216.192.15 Nov 28 05:43:09 music-hall ntpd[834]: Soliciting pool server 40.81.94.65 Nov 28 05:43:09 music-hall ntpd[834]: Soliciting pool server 3.6.43.90 Nov 28 05:43:12 music-hall ntpd[834]: receive: Unexpected origin timestamp 0xeaf23418.261288ac does not match aorg 0000000000.00000000 from server@192.46.215.60 xmt 0xeaf23418.b6613364 Nov 28 05:43:12 music-hall ntpd[834]: receive: Unexpected origin timestamp 0xeaf23418.26116b6e does not match aorg 0000000000.00000000 from server@152.70.69.232 xmt 0xeaf23418.b72ab20d Nov 28 05:43:12 music-hall ntpd[834]: receive: Unexpected origin timestamp 0xeaf23418.260ce8b4 does not match aorg 0000000000.00000000 from server@14.139.60.106 xmt 0xeaf23418.b6ba5655 Nov 28 05:43:12 music-hall ntpd[834]: receive: Unexpected origin timestamp 0xeaf23418.26025599 does not match aorg 0000000000.00000000 from server@95.216.192.15 xmt 0xeaf23418.ca778dd0 Nov 28 05:43:56 music-hall volumiologrotate[675]: ls: cannot access '/var/log/samba/log.wb-MUSIC': No such file or directory Nov 28 05:43:56 music-hall volumiologrotate[675]: ls: cannot access 'HALL': No such file or directory Nov 28 05:44:09 music-hall volumio[1028]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 05:44:09 music-hall volumio[1028]: info: Retrieving Cloud Streaming UI Nov 28 05:44:09 music-hall volumio[1028]: info: Getting Tidal Cloud Configuration Nov 28 05:44:09 music-hall volumio[1028]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 05:44:09 music-hall volumio[1028]: info: Getting Qobuz Cloud Configuration Nov 28 05:44:09 music-hall volumio[1028]: info: Asking plugin for UI Config Nov 28 05:44:09 music-hall volumio[1028]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 05:44:09 music-hall volumio[1028]: info: Getting Spotify Cloud Configuration Nov 28 05:44:09 music-hall volumio[1028]: info: Asking plugin for UI Config Nov 28 05:44:09 music-hall volumio[1028]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 05:44:09 music-hall volumio[1028]: info: Saving Spotify Acccount Nov 28 05:44:09 music-hall volumio[1028]: info: Got it Nov 28 05:44:09 music-hall volumio[1028]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 28 05:44:09 music-hall volumio[1028]: info: Got Tidal Cloud Configuration Nov 28 05:44:10 music-hall volumio[1028]: info: Got it Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::volumioGetBrowseSources Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::volumioGetBrowseSources Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::volumioGetBrowseSources Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 28 05:44:10 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 28 05:44:14 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 28 05:44:14 music-hall volumio[1028]: info: Disabling MyMusic plugin airplay_emulation Nov 28 05:44:14 music-hall volumio[1028]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Nov 28 05:44:14 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 05:44:14 music-hall volumio[1028]: Cannot find translation for source YouTube2 Nov 28 05:44:14 music-hall volumio[1028]: Cannot find translation for source YouTube Music Nov 28 05:44:14 music-hall volumio[1028]: Cannot find translation for source QOBUZ Nov 28 05:44:14 music-hall volumio[1028]: info: Disabling plugin airplay_emulation Nov 28 05:44:14 music-hall volumio[1028]: info: Done. Nov 28 05:44:14 music-hall sudo[1855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Nov 28 05:44:14 music-hall sudo[1855]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 05:44:14 music-hall systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 28 05:44:14 music-hall systemd[1]: shairport-sync.service: Succeeded. Nov 28 05:44:14 music-hall systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 28 05:44:14 music-hall sudo[1855]: pam_unix(sudo:session): session closed for user root Nov 28 05:44:14 music-hall volumio[1028]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 28 05:44:14 music-hall volumio[1028]: info: Shairport-Sync Stopped Nov 28 05:44:17 music-hall volumio[1028]: info: Enabling MyMusic plugin airplay_emulation Nov 28 05:44:17 music-hall volumio[1028]: info: Enabling plugin airplay_emulation Nov 28 05:44:17 music-hall volumio[1028]: info: Loading plugin "airplay_emulation"... Nov 28 05:44:17 music-hall volumio[1028]: info: Starting Shairport Sync Nov 28 05:44:17 music-hall volumio[1028]: info: PLUGIN START: airplay_emulation Nov 28 05:44:17 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 05:44:17 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 28 05:44:18 music-hall volumio[1028]: xcb_connection_has_error() returned true Nov 28 05:44:18 music-hall volumio[1028]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 28 05:44:18 music-hall volumio[1028]: xcb_connection_has_error() returned true Nov 28 05:44:18 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 28 05:44:18 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 28 05:44:18 music-hall volumio[1028]: xcb_connection_has_error() returned true Nov 28 05:44:18 music-hall volumio[1028]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 28 05:44:18 music-hall volumio[1028]: xcb_connection_has_error() returned true Nov 28 05:44:18 music-hall volumio[1028]: info: Done. Nov 28 05:44:18 music-hall volumio[1028]: info: Starting Shairport Sync Nov 28 05:44:18 music-hall volumio[1028]: info: Starting Shairport Sync Nov 28 05:44:18 music-hall sudo[1867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 28 05:44:18 music-hall sudo[1867]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 05:44:18 music-hall sudo[1870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 28 05:44:18 music-hall sudo[1870]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 05:44:18 music-hall systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 28 05:44:18 music-hall sudo[1867]: pam_unix(sudo:session): session closed for user root Nov 28 05:44:18 music-hall systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 28 05:44:18 music-hall systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 28 05:44:18 music-hall systemd[1]: shairport-sync.service: Succeeded. Nov 28 05:44:18 music-hall systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 28 05:44:18 music-hall systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 28 05:44:18 music-hall sudo[1870]: pam_unix(sudo:session): session closed for user root Nov 28 05:44:18 music-hall volumio[1028]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 28 05:44:18 music-hall volumio[1028]: info: Shairport-Sync Started Nov 28 05:44:18 music-hall volumio[1028]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 28 05:44:18 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 28 05:44:18 music-hall volumio[1028]: info: Shairport-Sync Started Nov 28 05:44:20 music-hall volumio[1028]: info: Disabling MyMusic plugin upnp Nov 28 05:44:20 music-hall sudo[1891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Nov 28 05:44:20 music-hall sudo[1891]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 05:44:20 music-hall systemd[1]: Stopping UPnP Renderer front-end to MPD... Nov 28 05:44:20 music-hall volumio[1028]: error: Upnp client error: Error: This socket has been ended by the other party Nov 28 05:44:20 music-hall volumio[1028]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 28 05:44:22 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 28 05:44:25 music-hall volumio[1028]: info: Enabling MyMusic plugin upnp Nov 28 05:44:25 music-hall volumio[1028]: info: Enabling plugin upnp Nov 28 05:44:25 music-hall volumio[1028]: info: Loading plugin "upnp"... Nov 28 05:44:25 music-hall volumio[1028]: info: [1732752865414] Starting Upmpd Daemon Nov 28 05:44:25 music-hall volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 28 05:44:25 music-hall volumio[1028]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 05:44:25 music-hall volumio[1028]: Error: listen EADDRINUSE: address already in use :::6599 Nov 28 05:44:25 music-hall volumio[1028]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 28 05:44:25 music-hall volumio[1028]: at listenInCluster (net.js:1366:12) Nov 28 05:44:25 music-hall volumio[1028]: at Server.listen (net.js:1452:7) Nov 28 05:44:25 music-hall volumio[1028]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Nov 28 05:44:25 music-hall volumio[1028]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Nov 28 05:44:25 music-hall volumio[1028]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Nov 28 05:44:25 music-hall volumio[1028]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Nov 28 05:44:25 music-hall volumio[1028]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Nov 28 05:44:25 music-hall volumio[1028]: code: 'EADDRINUSE', Nov 28 05:44:25 music-hall volumio[1028]: errno: -98, Nov 28 05:44:25 music-hall volumio[1028]: syscall: 'listen', Nov 28 05:44:25 music-hall volumio[1028]: address: '::', Nov 28 05:44:25 music-hall volumio[1028]: port: 6599 Nov 28 05:44:25 music-hall volumio[1028]: } Nov 28 05:44:25 music-hall volumio[1028]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 05:44:26 music-hall sudo[1905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-28 05:43 Nov 28 05:44:26 music-hall sudo[1905]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"