-- Logs begin at Wed 2025-07-09 19:28:13 +05, end at Wed 2025-07-09 20:47:27 +05. -- Jul 09 20:46:05 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:05 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:06 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:06 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:06 volumio volumio[1150]: info: Listing playlists Jul 09 20:46:12 volumio volumio[1150]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 20:46:15 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:15 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:15 volumio volumio[1150]: info: Listing playlists Jul 09 20:46:15 volumio volumio[1150]: info: Listing playlists Jul 09 20:46:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:22 volumio volumio[1150]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 20:46:22 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 09 20:46:22 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 09 20:46:22 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jul 09 20:46:23 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 20:46:23 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 20:46:23 volumio volumio[1150]: info: Discovery: Getting this device information Jul 09 20:46:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:23 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:23 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 20:46:23 volumio volumio[1150]: info: Received Get System Version Jul 09 20:46:23 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 20:46:23 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Jul 09 20:46:25 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:25 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:26 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:26 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:26 volumio volumio[1150]: info: Listing playlists Jul 09 20:46:26 volumio volumio[1150]: info: Listing playlists Jul 09 20:46:35 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:35 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:35 volumio volumio[1150]: info: Listing playlists Jul 09 20:46:36 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:36 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 20:46:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 20:46:45 volumio volumio[1150]: info: Discovery: Getting this device information Jul 09 20:46:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 20:46:46 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:46 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:46 volumio volumio[1150]: info: Listing playlists Jul 09 20:46:46 volumio volumio[1150]: info: Listing playlists Jul 09 20:46:52 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 20:46:52 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 20:46:52 volumio volumio[1150]: info: Discovery: Getting this device information Jul 09 20:46:52 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:52 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:52 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 20:46:55 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:55 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:46:55 volumio volumio[1150]: info: Listing playlists Jul 09 20:46:56 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:46:56 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:03 volumio volumio[1150]: info: [1752076023959] [80s80s] Pushing the next song state Richard Sanderson - Reality and getting next track. Jul 09 20:47:03 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:03 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Jul 09 20:47:03 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:03 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is3-ssl.mzstatic.com/image/thumb/Music124/v4/ba/70/db/ba70db9e-e562-4cfd-619d-1b7df8a1b0d2/source/600x600bb.jpg","name":"Richard Sanderson - Reality","title":"Reality","artist":"80s80s Real 80s Radio","album":"","streaming":true,"disableUiControls":true,"duration":"275","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jul 09 20:47:03 volumio volumio[1150]: verbose: CURRENT POSITION 0 Jul 09 20:47:03 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Jul 09 20:47:03 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Jul 09 20:47:03 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Jul 09 20:47:03 volumio volumio[1150]: info: CoreStateMachine::pushState Jul 09 20:47:03 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:03 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Jul 09 20:47:03 volumio volumio[1150]: info: CoreStateMachine::pushState Jul 09 20:47:03 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:03 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Jul 09 20:47:03 volumio volumio[1150]: info: [1752076023970] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=62&count=1 Jul 09 20:47:04 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:04 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Jul 09 20:47:04 volumio volumio[1150]: info: [1752076024173] [80s80s] received new event containing 1 songs. Jul 09 20:47:04 volumio volumio[1150]: info: [1752076024174] [80s80s] PlayNextTrack API delay: 30 Jul 09 20:47:04 volumio volumio[1150]: info: [1752076024175] [80s80s] Setting timer to: 275000 milliseconds. Jul 09 20:47:05 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:47:05 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:06 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:47:06 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:06 volumio volumio[1150]: info: Listing playlists Jul 09 20:47:06 volumio volumio[1150]: info: Listing playlists Jul 09 20:47:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 09 20:47:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 09 20:47:15 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:47:15 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:15 volumio volumio[1150]: info: Listing playlists Jul 09 20:47:15 volumio volumio[1150]: info: Listing playlists Jul 09 20:47:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:47:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:22 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 20:47:22 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 20:47:22 volumio volumio[1150]: info: Discovery: Getting this device information Jul 09 20:47:22 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:47:22 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:22 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 20:47:25 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:47:25 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:26 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Jul 09 20:47:26 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Jul 09 20:47:26 volumio volumio[1150]: info: Listing playlists Jul 09 20:47:26 volumio volumio[1150]: info: Enabling plugin peppymeterbasic Jul 09 20:47:26 volumio volumio[1150]: info: Loading plugin "peppymeterbasic"... Jul 09 20:47:26 volumio volumio[1150]: error: !!!! WARNING !!!! Jul 09 20:47:26 volumio volumio[1150]: error: The plugin user_interface/peppymeterbasic failed to load, setting it to stopped. Error: Error: Cannot find module 'universalify' Jul 09 20:47:26 volumio volumio[1150]: Require stack: Jul 09 20:47:26 volumio volumio[1150]: - /data/plugins/user_interface/peppymeterbasic/node_modules/fs-extra/lib/fs/index.js Jul 09 20:47:26 volumio volumio[1150]: - /data/plugins/user_interface/peppymeterbasic/node_modules/fs-extra/lib/index.js Jul 09 20:47:26 volumio volumio[1150]: - /data/plugins/user_interface/peppymeterbasic/index.js Jul 09 20:47:26 volumio volumio[1150]: - /volumio/app/pluginmanager.js Jul 09 20:47:26 volumio volumio[1150]: - /volumio/app/index.js Jul 09 20:47:26 volumio volumio[1150]: - /volumio/index.js Jul 09 20:47:26 volumio volumio[1150]: error: Stack trace: Error: Cannot find module 'universalify' Jul 09 20:47:26 volumio volumio[1150]: Require stack: Jul 09 20:47:26 volumio volumio[1150]: - /data/plugins/user_interface/peppymeterbasic/node_modules/fs-extra/lib/fs/index.js Jul 09 20:47:26 volumio volumio[1150]: - /data/plugins/user_interface/peppymeterbasic/node_modules/fs-extra/lib/index.js Jul 09 20:47:26 volumio volumio[1150]: - /data/plugins/user_interface/peppymeterbasic/index.js Jul 09 20:47:26 volumio volumio[1150]: - /volumio/app/pluginmanager.js Jul 09 20:47:26 volumio volumio[1150]: - /volumio/app/index.js Jul 09 20:47:26 volumio volumio[1150]: - /volumio/index.js Jul 09 20:47:26 volumio volumio[1150]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:931:15) Jul 09 20:47:26 volumio volumio[1150]: at Function.Module._load (internal/modules/cjs/loader.js:774:27) Jul 09 20:47:26 volumio volumio[1150]: at Module.require (internal/modules/cjs/loader.js:1003:19) Jul 09 20:47:26 volumio volumio[1150]: at require (internal/modules/cjs/helpers.js:107:18) Jul 09 20:47:26 volumio volumio[1150]: at Object. (/data/plugins/user_interface/peppymeterbasic/node_modules/fs-extra/lib/fs/index.js:3:11) Jul 09 20:47:26 volumio volumio[1150]: at Module._compile (internal/modules/cjs/loader.js:1114:14) Jul 09 20:47:26 volumio volumio[1150]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10) Jul 09 20:47:26 volumio volumio[1150]: at Module.load (internal/modules/cjs/loader.js:979:32) Jul 09 20:47:26 volumio volumio[1150]: at Function.Module._load (internal/modules/cjs/loader.js:819:12) Jul 09 20:47:26 volumio volumio[1150]: at Module.require (internal/modules/cjs/loader.js:1003:19) Jul 09 20:47:26 volumio volumio[1150]: at require (internal/modules/cjs/helpers.js:107:18) Jul 09 20:47:26 volumio volumio[1150]: at Object. (/data/plugins/user_interface/peppymeterbasic/node_modules/fs-extra/lib/index.js:8:12) Jul 09 20:47:26 volumio volumio[1150]: at Module._compile (internal/modules/cjs/loader.js:1114:14) Jul 09 20:47:26 volumio volumio[1150]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10) Jul 09 20:47:26 volumio volumio[1150]: at Module.load (internal/modules/cjs/loader.js:979:32) Jul 09 20:47:26 volumio volumio[1150]: at Function.Module._load (internal/modules/cjs/loader.js:819:12) Jul 09 20:47:26 volumio volumio[1150]: error: !!!! WARNING !!!! Jul 09 20:47:26 volumio volumio[1150]: info: Preparing to generate the ALSA configuration file Jul 09 20:47:26 volumio volumio[1150]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Jul 09 20:47:26 volumio volumio[1150]: info: Reading ALSA contributions from plugins. Jul 09 20:47:26 volumio volumio[1150]: info: Asound.conf file written Jul 09 20:47:26 volumio sudo[28776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 09 20:47:26 volumio sudo[28776]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 20:47:26 volumio sudo[28776]: pam_unix(sudo:session): session closed for user root Jul 09 20:47:26 volumio volumio[1150]: info: Output device has changed, restarting MPD Jul 09 20:47:26 volumio sudo[28802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 20:47:26 volumio sudo[28802]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 20:47:26 volumio sudo[28802]: pam_unix(sudo:session): session closed for user root Jul 09 20:47:26 volumio volumio[1150]: info: Output device has changed, restarting Shairport Sync Jul 09 20:47:26 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 20:47:26 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 20:47:26 volumio sudo[28805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 20:47:26 volumio sudo[28805]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 20:47:26 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 20:47:26 volumio systemd[1]: mpd.service: Succeeded. Jul 09 20:47:26 volumio systemd[1]: Stopped Music Player Daemon. Jul 09 20:47:26 volumio volumio[1150]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 20:47:26 volumio volumio[1150]: info: Done. Jul 09 20:47:26 volumio systemd[1]: Starting Music Player Daemon... Jul 09 20:47:26 volumio volumio[1150]: info: MPD Permissions set Jul 09 20:47:26 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 20:47:26 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 20:47:26 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 20:47:26 volumio sudo[28810]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 09 20:47:26 volumio sudo[28810]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 20:47:26 volumio sudo[28810]: pam_unix(sudo:session): session closed for user root Jul 09 20:47:26 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 20:47:26 volumio volumio[1150]: info: Starting Shairport Sync Jul 09 20:47:26 volumio sudo[28821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 20:47:26 volumio sudo[28821]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 20:47:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 20:47:26 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 09 20:47:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 20:47:26 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 20:47:26 volumio sudo[28821]: pam_unix(sudo:session): session closed for user root Jul 09 20:47:26 volumio volumio[1150]: info: Shairport-Sync Started Jul 09 20:47:27 volumio mpd[28818]: Jul 09 20:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 09 20:47:27 volumio systemd[1]: Started Music Player Daemon. Jul 09 20:47:27 volumio sudo[28805]: pam_unix(sudo:session): session closed for user root Jul 09 20:47:27 volumio volumio[1150]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 20:47:27 volumio volumio[1150]: TypeError: Cannot read property 'printToastMessage' of null Jul 09 20:47:27 volumio volumio[1150]: at /volumio/app/index.js:1214:32 Jul 09 20:47:27 volumio volumio[1150]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Jul 09 20:47:27 volumio volumio[1150]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Jul 09 20:47:27 volumio volumio[1150]: at CoreCommandRouter.pushToastMessage (/volumio/app/index.js:1212:13) Jul 09 20:47:27 volumio volumio[1150]: at /volumio/app/plugins/music_service/mpd/index.js:798:30 Jul 09 20:47:27 volumio volumio[1150]: at /volumio/app/plugins/music_service/mpd/index.js:942:9 Jul 09 20:47:27 volumio volumio[1150]: at ChildProcess.exithandler (child_process.js:374:7) Jul 09 20:47:27 volumio volumio[1150]: at ChildProcess.emit (events.js:400:28) Jul 09 20:47:27 volumio volumio[1150]: at maybeClose (internal/child_process.js:1088:16) Jul 09 20:47:27 volumio volumio[1150]: at Socket. (internal/child_process.js:446:11) Jul 09 20:47:27 volumio volumio[1150]: at Socket.emit (events.js:400:28) Jul 09 20:47:27 volumio volumio[1150]: at Pipe. (net.js:686:12) Jul 09 20:47:27 volumio volumio[1150]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 20:47:27 volumio sudo[28838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-09 20:46 Jul 09 20:47:27 volumio sudo[28838]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:41:06 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="097e6b8b481766e7a0f9527e4a34a29b"