-- Logs begin at Sat 2024-03-23 00:39:59 UTC, end at Wed 2024-10-09 14:44:35 UTC. -- Oct 09 14:44:17 volumio-shd systemd[1]: Time has been changed Oct 09 14:44:19 volumio-shd volumio[798]: info: Loading plugin "updater_comm"... Oct 09 14:44:20 volumio-shd volumio[798]: info: Plugin mpdemulation is not enabled Oct 09 14:44:20 volumio-shd volumio[798]: info: Loading plugin "rest_api"... Oct 09 14:44:20 volumio-shd volumio[798]: info: Loading plugin "websocket"... Oct 09 14:44:20 volumio-shd volumio[798]: info: Plugin Systeminfo is not enabled Oct 09 14:44:20 volumio-shd volumio[798]: info: Loading plugin "squeezelite"... Oct 09 14:44:20 volumio-shd volumio[798]: info: [Squeezelite] Initiated plugin Oct 09 14:44:20 volumio-shd volumio[798]: info: ___________ START PLUGINS ___________ Oct 09 14:44:20 volumio-shd volumio[798]: info: Adding METAVOLUMIO REST API Endpoints Oct 09 14:44:20 volumio-shd volumio[798]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Oct 09 14:44:20 volumio-shd volumio[798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 09 14:44:20 volumio-shd volumio[798]: info: [1728485060910] CoreMusicLibrary::Adding element Last_100 Oct 09 14:44:20 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 14:44:20 volumio-shd volumio[798]: info: Streaming services startup Oct 09 14:44:20 volumio-shd volumio[798]: info: Starting Streaming Daemon Oct 09 14:44:20 volumio-shd sudo[933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 09 14:44:20 volumio-shd sudo[933]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 14:44:21 volumio-shd systemd[1]: Stopping Volumio Streaming Daemon... Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 09 14:44:21 volumio-shd volumio[798]: info: [1728485061020] CoreMusicLibrary::Adding element Webradio Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 09 14:44:21 volumio-shd systemd[1]: Starting Volumio Streaming Daemon... Oct 09 14:44:21 volumio-shd systemd[1]: Started Volumio Streaming Daemon. Oct 09 14:44:21 volumio-shd sudo[933]: pam_unix(sudo:session): session closed for user root Oct 09 14:44:21 volumio-shd volumio-streaming-daemon[940]: ############################ Oct 09 14:44:21 volumio-shd volumio-streaming-daemon[940]: # Volumio Streaming Daemon # Oct 09 14:44:21 volumio-shd volumio-streaming-daemon[940]: # Running on port 7777 # Oct 09 14:44:21 volumio-shd volumio-streaming-daemon[940]: ############################ Oct 09 14:44:21 volumio-shd volumio[798]: error: Hi Res Audio Failed Login: Missing Login Data Oct 09 14:44:21 volumio-shd volumio-streaming-daemon[940]: Checking variant in static cache Oct 09 14:44:21 volumio-shd volumio-streaming-daemon[940]: Enabled services: Oct 09 14:44:21 volumio-shd volumio-streaming-daemon[940]: 1) tidal Oct 09 14:44:21 volumio-shd volumio-streaming-daemon[940]: 2) qobuz Oct 09 14:44:21 volumio-shd sudo[948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 09 14:44:21 volumio-shd sudo[948]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 14:44:21 volumio-shd volumio[798]: info: Loading i18n strings for locale en Oct 09 14:44:21 volumio-shd volumio[798]: Updating browse sources language Oct 09 14:44:21 volumio-shd systemd[1]: Reloading. Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::initPlayerControls Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 09 14:44:21 volumio-shd systemd[1]: [/lib/systemd/system/volumio-remote-updater-push.service:6] Failed to parse usec_t value, ignoring: infinity Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 09 14:44:21 volumio-shd volumio[798]: info: BOOT COMPLETED Oct 09 14:44:21 volumio-shd volumio[798]: [Metrics] CommandRouter: 16s 87.90ms Oct 09 14:44:21 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 09 14:44:21 volumio-shd sudo[948]: pam_unix(sudo:session): session closed for user root Oct 09 14:44:22 volumio-shd volumio-remote-updater[625]: [2024-10-09 14:44:22] [connect] Successful connection Oct 09 14:44:26 volumio-shd volumio[798]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 09 14:44:26 volumio-shd volumio[798]: info: CoreCommandRouter::Close All Modals sent Oct 09 14:44:26 volumio-shd volumio[798]: info: CoreCommandRouter::Close All Modals sent Oct 09 14:44:26 volumio-shd volumio[798]: Express server listening on port 3000 Oct 09 14:44:26 volumio-shd volumio[798]: [Metrics] WebUI: 22s 856.97ms Oct 09 14:44:26 volumio-shd volumio[798]: Volumio Calling Home Oct 09 14:44:26 volumio-shd volumio[798]: info: CoreStateMachine::resetVolumioState Oct 09 14:44:26 volumio-shd volumio[798]: info: CoreStateMachine::getcurrentVolume Oct 09 14:44:26 volumio-shd volumio[798]: info: CoreCommandRouter::volumioRetrievevolume Oct 09 14:44:26 volumio-shd volumio[798]: info: Stopping AccessToken refresher cron for QOBUZ Oct 09 14:44:26 volumio-shd volumio[798]: info: AccessToken refresher cron started for QOBUZ Oct 09 14:44:26 volumio-shd volumio[798]: info: Stopping AccessToken refresher cron Oct 09 14:44:27 volumio-shd volumio[798]: info: AccessToken refresher cron started Oct 09 14:44:27 volumio-shd volumio[798]: info: CoreStateMachine::pushState Oct 09 14:44:27 volumio-shd volumio[798]: info: CorePlayQueue::getTrack 0 Oct 09 14:44:27 volumio-shd volumio[798]: info: CoreCommandRouter::volumioPushState Oct 09 14:44:27 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 14:44:29 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 09 14:44:29 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 09 14:44:29 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 14:44:29 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 09 14:44:29 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 09 14:44:29 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 09 14:44:29 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 09 14:44:29 volumio-shd volumio[798]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 09 14:44:29 volumio-shd volumio[798]: info: Cannot read play queue from file Oct 09 14:44:29 volumio-shd volumio[798]: info: Serial port opened successfully Oct 09 14:44:30 volumio-shd volumio[798]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Hardware Oct 09 14:44:30 volumio-shd volumio[798]: info: squeezelite reloaded Oct 09 14:44:30 volumio-shd volumio[798]: info: [Squeezelite] Read MAC address - 0e:00:13:e3:d0:56 Oct 09 14:44:30 volumio-shd sudo[974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart squeezelite Oct 09 14:44:30 volumio-shd sudo[974]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 14:44:30 volumio-shd volumio[798]: error: Cannot initialize MPD Connection: MPD is not running Oct 09 14:44:30 volumio-shd sudo[976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Oct 09 14:44:30 volumio-shd sudo[976]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 09 14:44:30 volumio-shd sudo[976]: pam_unix(sudo:session): session closed for user root Oct 09 14:44:30 volumio-shd volumio[798]: info: Volumio called home Oct 09 14:44:33 volumio-shd systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Oct 09 14:44:33 volumio-shd systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreCommandRouter::volumioStop Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreStateMachine::stop Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 14:44:33 volumio-shd volumio[798]: verbose: UNSET VOLATILE Oct 09 14:44:33 volumio-shd volumio[798]: info: Notifying Active Input {"status":"play","service":"inputs","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"","seek":0,"duration":0,"samplerate":"","bitdepth":"","stream":"","disableUiControls":false,"channels":2,"dirac":""} Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 09 14:44:33 volumio-shd volumio[798]: [28B blob data] Oct 09 14:44:33 volumio-shd volumio[798]: PUSH MODEL 1 Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat Oct 09 14:44:33 volumio-shd volumio[798]: error: Could not retrieve plugin music_service raat Oct 09 14:44:33 volumio-shd volumio[798]: info: Adding MINIDSP Inputs Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 09 14:44:33 volumio-shd volumio[798]: info: [1728485073786] CoreMusicLibrary::Adding element Inputs Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 09 14:44:33 volumio-shd volumio[798]: info: [1728485073809] CoreMusicLibrary::Adding element Presets Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 14:44:33 volumio-shd sudo[974]: pam_unix(sudo:session): session closed for user root Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreCommandRouter::servicePushState Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreStateMachine::pushState Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreCommandRouter::volumioPushState Oct 09 14:44:33 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreStateMachine::setRepeat null single undefined Oct 09 14:44:34 volumio-shd volumio[798]: info: WARNING: No repeat method for plugin inputs Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreStateMachine::setRandom null Oct 09 14:44:34 volumio-shd volumio[798]: info: WARNING: No random method for plugin inputs Oct 09 14:44:34 volumio-shd volumio[798]: [27B blob data] Oct 09 14:44:34 volumio-shd volumio[798]: PUSH MUTE FALSE Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreStateMachine::pushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::volumioPushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Oct 09 14:44:34 volumio-shd volumio[798]: error: Could not retrieve plugin music_service raat Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::servicePushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreStateMachine::pushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::volumioPushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 14:44:34 volumio-shd volumio[798]: info: [inputs] - Error getting samplerate Oct 09 14:44:34 volumio-shd volumio[798]: info: [inputs] - Error getting bitdepth Oct 09 14:44:34 volumio-shd volumio[798]: info: squeezelite started Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::servicePushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreStateMachine::pushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::volumioPushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 14:44:34 volumio-shd volumio[798]: [29B blob data] Oct 09 14:44:34 volumio-shd volumio[798]: PUSH SOURCE 7 Oct 09 14:44:34 volumio-shd volumio[798]: GET DSP Oct 09 14:44:34 volumio-shd volumio[798]: PUSH DSP 1111111 Oct 09 14:44:34 volumio-shd volumio[798]: GET PRESET Oct 09 14:44:34 volumio-shd volumio[798]: PUSH PRESET 1 Oct 09 14:44:34 volumio-shd volumio[798]: GET MVOL Oct 09 14:44:34 volumio-shd volumio[798]: PUSH MVOL Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: minidspshd-input-defaults , setDefaultValues Oct 09 14:44:34 volumio-shd volumio[798]: error: Could not retrieve plugin audio_interface minidspshd-input-defaults Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::volumiosetSourceActiveno-source Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: raat , updateDSP Oct 09 14:44:34 volumio-shd volumio[798]: error: Could not retrieve plugin music_service raat Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreStateMachine::pushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::volumioPushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Oct 09 14:44:34 volumio-shd volumio[798]: error: Could not retrieve plugin music_service raat Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::servicePushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreStateMachine::pushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::volumioPushState Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 09 14:44:34 volumio-shd volumio[798]: info: mDNS: A device disapperared from network Oct 09 14:44:34 volumio-shd volumio[798]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Oct 09 14:44:34 volumio-shd volumio[798]: info: [inputs] - Error getting bitdepth Oct 09 14:44:34 volumio-shd volumio[798]: info: [inputs] - Error getting samplerate Oct 09 14:44:34 volumio-shd volumio[798]: info: [inputs] - Error getting bitdepth Oct 09 14:44:34 volumio-shd volumio[798]: info: [inputs] - Error getting samplerate Oct 09 14:44:34 volumio-shd volumio[798]: info: [inputs] - Error getting bitdepth Oct 09 14:44:34 volumio-shd volumio[798]: info: [inputs] - Error getting samplerate Oct 09 14:44:34 volumio-shd volumio[798]: Discovery: adding 8005427a-47f0-485f-85ec-0ee64dd4be46 Oct 09 14:44:34 volumio-shd volumio[798]: info: mDNS: Found device Volumio-shd Oct 09 14:44:34 volumio-shd volumio[798]: info: CoreCommandRouter::volumioGetState Oct 09 14:44:34 volumio-shd volumio[798]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 14:44:34 volumio-shd volumio[798]: Error: The value NaN is not a number Oct 09 14:44:34 volumio-shd volumio[798]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Oct 09 14:44:34 volumio-shd volumio[798]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Oct 09 14:44:34 volumio-shd volumio[798]: at ControllerVolumioDiscovery.pushMultiRoomStatusUpdate (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:287:25) Oct 09 14:44:34 volumio-shd volumio[798]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:10) Oct 09 14:44:34 volumio-shd volumio[798]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:202:12) Oct 09 14:44:34 volumio-shd volumio[798]: at emitTwo (events.js:126:13) Oct 09 14:44:34 volumio-shd volumio[798]: at Browser.emit (events.js:214:7) Oct 09 14:44:34 volumio-shd volumio[798]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Oct 09 14:44:34 volumio-shd volumio[798]: at next (/volumio/node_modules/mdns/lib/browser.js:104:7) Oct 09 14:44:34 volumio-shd volumio[798]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Oct 09 14:44:34 volumio-shd volumio[798]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 09 14:44:35 volumio-shd sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-09 14:43 Oct 09 14:44:35 volumio-shd sudo[1025]: 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="e5ce74e254a237ac98580c4437c4ed223c7d5cd9" VOLUMIO_BE_VERSION="0cf482c24e7a7ab87af1081ea7d6d953621249a4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 23 09:46:56 CET 2022" VOLUMIO_VERSION="1.121" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="3b38c3dd18bd314d1ea0ffe96c6cfafa"