Oct 17 16:31:28 volumio volumio[1518]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Oct 17 16:31:28 volumio volumio[1518]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Oct 17 16:31:28 volumio volumio[1518]: aaaaaaaaaaa 800,480 Oct 17 16:31:28 volumio volumio[1518]: info: PeppyMeterBasic ---800480 Oct 17 16:31:28 volumio volumio[1518]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Oct 17 16:31:28 volumio volumio[1518]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 16:31:28 volumio volumio[1518]: info: CoreCommandRouter::Close All Modals sent Oct 17 16:31:57 volumio volumio[1518]: info: CALLMETHOD: user_interface peppymeterbasic updatelist Oct 17 16:31:57 volumio volumio[1518]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , updatelist Oct 17 16:31:57 volumio volumio[1518]: info: PeppyMeterBasic --- wget 'https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt' Oct 17 16:31:58 volumio volumio[1518]: --2026-10-17 16:31:57-- https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt Oct 17 16:31:58 volumio volumio[1518]: Resolving github.com (github.com)... 20.205.243.166 Oct 17 16:31:58 volumio volumio[1518]: Connecting to github.com (github.com)|20.205.243.166|:443... connected. Oct 17 16:31:58 volumio volumio[1518]: HTTP request sent, awaiting response... 302 Found Oct 17 16:31:58 volumio volumio[1518]: Location: https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt [following] Oct 17 16:31:58 volumio volumio[1518]: --2026-10-17 16:31:58-- https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt Oct 17 16:31:58 volumio volumio[1518]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.109.133, 185.199.111.133, 185.199.110.133, ... Oct 17 16:31:58 volumio volumio[1518]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.109.133|:443... connected. Oct 17 16:31:58 volumio volumio[1518]: GnuTLS: Error in the pull function. Oct 17 16:31:58 volumio volumio[1518]: Unable to establish SSL connection. Oct 17 16:31:58 volumio volumio[1518]: error: PeppyMeterBasic --- failed to download file Error: Command failed: /usr/bin/wget 'https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt' -O '/data/plugins/user_interface/peppymeterbasic/meterslist.txt' Oct 17 16:31:58 volumio volumio[1518]: --2026-10-17 16:31:57-- https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt Oct 17 16:31:58 volumio volumio[1518]: Resolving github.com (github.com)... 20.205.243.166 Oct 17 16:31:58 volumio volumio[1518]: Connecting to github.com (github.com)|20.205.243.166|:443... connected. Oct 17 16:31:58 volumio volumio[1518]: HTTP request sent, awaiting response... 302 Found Oct 17 16:31:58 volumio volumio[1518]: Location: https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt [following] Oct 17 16:31:58 volumio volumio[1518]: --2026-10-17 16:31:58-- https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt Oct 17 16:31:58 volumio volumio[1518]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.109.133, 185.199.111.133, 185.199.110.133, ... Oct 17 16:31:58 volumio volumio[1518]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.109.133|:443... connected. Oct 17 16:31:58 volumio volumio[1518]: GnuTLS: Error in the pull function. Oct 17 16:31:58 volumio volumio[1518]: Unable to establish SSL connection. Oct 17 16:32:08 volumio volumio[1518]: info: CALLMETHOD: user_interface peppymeterbasic dlmeter [object Object] Oct 17 16:32:08 volumio volumio[1518]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , dlmeter Oct 17 16:32:10 volumio volumio[1518]: --2026-10-17 16:32:08-- https://github.com/balbuze/Meter-peppymeter/raw/main/Zipped-folders/800x480-test.zip Oct 17 16:32:10 volumio volumio[1518]: Resolving github.com (github.com)... 20.205.243.166 Oct 17 16:32:10 volumio volumio[1518]: Connecting to github.com (github.com)|20.205.243.166|:443... connected. Oct 17 16:32:10 volumio volumio[1518]: HTTP request sent, awaiting response... 302 Found Oct 17 16:32:10 volumio volumio[1518]: Location: https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/Zipped-folders/800x480-test.zip [following] Oct 17 16:32:10 volumio volumio[1518]: --2026-10-17 16:32:10-- https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/Zipped-folders/800x480-test.zip Oct 17 16:32:10 volumio volumio[1518]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.109.133, 185.199.111.133, 185.199.110.133, ... Oct 17 16:32:10 volumio volumio[1518]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.109.133|:443... connected. Oct 17 16:32:10 volumio volumio[1518]: GnuTLS: Error in the pull function. Oct 17 16:32:10 volumio volumio[1518]: Unable to establish SSL connection. Oct 17 16:32:10 volumio volumio[1518]: error: PeppyMeterBasic --- An error occurs while downloading or installing Meters Oct 17 16:32:10 volumio volumio[1518]: /bin/rm: cannot remove '/tmp/800x480-test.zip*': No such file or directory Oct 17 16:32:10 volumio volumio[1518]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 16:32:10 volumio volumio[1518]: Error: Command failed: /bin/rm /tmp/800x480-test.zip* Oct 17 16:32:10 volumio volumio[1518]: /bin/rm: cannot remove '/tmp/800x480-test.zip*': No such file or directory Oct 17 16:32:10 volumio volumio[1518]: at checkExecSyncError (node:child_process:887:11) Oct 17 16:32:10 volumio volumio[1518]: at execSync (node:child_process:959:15) Oct 17 16:32:10 volumio volumio[1518]: at /data/plugins/user_interface/peppymeterbasic/index.js:710:19 Oct 17 16:32:10 volumio volumio[1518]: at new Promise () Oct 17 16:32:10 volumio volumio[1518]: at peppymeterbasic.dlmeter (/data/plugins/user_interface/peppymeterbasic/index.js:685:12) Oct 17 16:32:10 volumio volumio[1518]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Oct 17 16:32:10 volumio volumio[1518]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Oct 17 16:32:10 volumio volumio[1518]: at Socket.emit (node:events:514:28) Oct 17 16:32:10 volumio volumio[1518]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 17 16:32:10 volumio volumio[1518]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Oct 17 16:32:10 volumio volumio[1518]: status: 1, Oct 17 16:32:10 volumio volumio[1518]: signal: null, Oct 17 16:32:10 volumio volumio[1518]: output: [ Oct 17 16:32:10 volumio volumio[1518]: null, Oct 17 16:32:10 volumio volumio[1518]: , Oct 17 16:32:10 volumio volumio[1518]: Oct 17 16:32:10 volumio volumio[1518]: ], Oct 17 16:32:10 volumio volumio[1518]: pid: 8996, Oct 17 16:32:10 volumio volumio[1518]: stdout: , Oct 17 16:32:10 volumio volumio[1518]: stderr: Oct 17 16:32:10 volumio volumio[1518]: } Oct 17 16:32:10 volumio volumio[1518]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 16:32:10 volumio sudo[9015]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-17 16:31' Oct 17 16:32:10 volumio sudo[9015]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:10 volumio sudo[9015]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:12 volumio volumio5-onboarding[1821]: time=2026-10-17T16:32:12.635+08:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Oct 17 16:32:12 volumio volumio-remote-updater[1091]: [2026-10-17 16:32:12] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 17 16:32:12 volumio volumio-remote-updater[1091]: [2026-10-17 16:32:12] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 17 16:32:12 volumio volumio5-onboarding[1821]: time=2026-10-17T16:32:12.644+08:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:58274->127.0.0.1:3000: read: connection reset by peer" Oct 17 16:32:12 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 17 16:32:12 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 17 16:32:12 volumio systemd[1]: volumio.service: Consumed 24.222s CPU time. Oct 17 16:32:12 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 17 16:32:12 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Oct 17 16:32:12 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Oct 17 16:32:12 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 17 16:32:12 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 17 16:32:12 volumio systemd[1]: volumio.service: Consumed 24.222s CPU time. Oct 17 16:32:12 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Oct 17 16:32:12 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Oct 17 16:32:13 volumio volumio[9039]: info: ------------------------------------------- Oct 17 16:32:13 volumio volumio[9039]: info: ----- Volumio3 ---- Oct 17 16:32:13 volumio volumio[9039]: info: ------------------------------------------- Oct 17 16:32:13 volumio volumio[9039]: info: ----- System startup ---- Oct 17 16:32:13 volumio volumio[9039]: info: ------------------------------------------- Oct 17 16:32:13 volumio volumio[9039]: info: MYVOLUMIO Environment detected Oct 17 16:32:13 volumio volumio[9039]: info: Plugin folders cleanup Oct 17 16:32:13 volumio volumio[9039]: info: Scanning into folder /volumio/app/plugins/ Oct 17 16:32:13 volumio volumio[9039]: info: Scanning category audio_interface Oct 17 16:32:13 volumio volumio[9039]: info: Scanning category miscellanea Oct 17 16:32:13 volumio volumio[9039]: info: Scanning category music_service Oct 17 16:32:13 volumio volumio[9039]: info: Scanning category plugins.json Oct 17 16:32:13 volumio volumio[9039]: info: Scanning category system_controller Oct 17 16:32:13 volumio volumio[9039]: info: Scanning category user_interface Oct 17 16:32:13 volumio volumio[9039]: info: Scanning into folder /data/plugins/ Oct 17 16:32:13 volumio volumio[9039]: info: Scanning category audio_interface Oct 17 16:32:13 volumio volumio[9039]: info: Scanning category system_hardware Oct 17 16:32:13 volumio volumio[9039]: info: Scanning category user_interface Oct 17 16:32:13 volumio volumio[9039]: info: Plugin folders cleanup completed Oct 17 16:32:13 volumio volumio[9039]: info: ------------------------------------------- Oct 17 16:32:13 volumio volumio[9039]: info: ----- Core plugins startup ---- Oct 17 16:32:13 volumio volumio[9039]: info: ------------------------------------------- Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugins from folder /volumio/app/plugins/ Oct 17 16:32:13 volumio volumio[9039]: info: Adding plugin upnp to MyMusic Plugins Oct 17 16:32:13 volumio volumio[9039]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 17 16:32:13 volumio volumio[9039]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugins from folder /data/plugins/ Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "system"... Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "appearance"... Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "network"... Oct 17 16:32:13 volumio volumio[9039]: info: Refreshing Cached IP Addresses Oct 17 16:32:13 volumio sudo[9067]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 16:32:13 volumio sudo[9067]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:13 volumio sudo[9069]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 16:32:13 volumio sudo[9069]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:13 volumio sudo[9067]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:13 volumio sudo[9069]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "services"... Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "volumio5onboarding"... Oct 17 16:32:13 volumio sudo[9076]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 17 16:32:13 volumio sudo[9076]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "alsa_controller"... Oct 17 16:32:13 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "wizard"... Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "networkfs"... Oct 17 16:32:13 volumio volumio[9039]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds Oct 17 16:32:13 volumio volumio[9039]: info: Starting Udev Watcher for removable devices Oct 17 16:32:13 volumio volumio[9039]: info: Ignoring mount for partition: boot Oct 17 16:32:13 volumio volumio[9039]: info: Ignoring mount for partition: volumio Oct 17 16:32:13 volumio volumio[9039]: info: Ignoring mount for partition: volumio_data Oct 17 16:32:13 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "volumio_command_line_client"... Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "upnp"... Oct 17 16:32:13 volumio volumio[9039]: info: [1792225933789] Starting Upmpd Daemon Oct 17 16:32:13 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "my_music"... Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "mpd"... Oct 17 16:32:13 volumio volumio[9039]: info: Loading plugin "upnp_browser"... Oct 17 16:32:14 volumio volumio[9039]: info: Starting UPNP Browser Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "alarm-clock"... Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "airplay_emulation"... Oct 17 16:32:14 volumio volumio[9039]: info: Starting Shairport Sync Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "last_100"... Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "webradio"... Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "i2s_dacs"... Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "volumiodiscovery"... Oct 17 16:32:14 volumio volumio[9039]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 17 16:32:14 volumio volumio[9039]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 16:32:14 volumio volumio[9039]: *** WARNING *** For more information see Oct 17 16:32:14 volumio volumio[9039]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 17 16:32:14 volumio volumio[9039]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 16:32:14 volumio volumio[9039]: *** WARNING *** For more information see Oct 17 16:32:14 volumio node[9039]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 17 16:32:14 volumio node[9039]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 16:32:14 volumio node[9039]: *** WARNING *** For more information see Oct 17 16:32:14 volumio node[9039]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 17 16:32:14 volumio node[9039]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 17 16:32:14 volumio node[9039]: *** WARNING *** For more information see Oct 17 16:32:14 volumio volumio[9039]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 17 16:32:14 volumio volumio[9039]: info: Discovery: Started advertising with name: Volumio Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 17 16:32:14 volumio volumio[9039]: info: Plugin now_playing is not enabled Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "outputs"... Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "albumart"... Oct 17 16:32:14 volumio volumio[9039]: info: Plugin example_plugin is not enabled Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "inputs"... Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "updater_comm"... Oct 17 16:32:14 volumio volumio[9039]: info: Plugin mpdemulation is not enabled Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "rest_api"... Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "websocket"... Oct 17 16:32:14 volumio volumio[9039]: info: Starting Socket.io Server version 1.7.4 Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "fusiondsp"... Oct 17 16:32:14 volumio volumio[9039]: info: Applying required configuration parameters for plugin fusiondsp Oct 17 16:32:14 volumio volumio[9099]: Forking 3 albumart workers Oct 17 16:32:14 volumio volumio[9039]: info: Plugin Bluetoothremote is not enabled Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "peppymeterbasic"... Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppyspectrum is not enabled Oct 17 16:32:14 volumio volumio[9039]: info: Loading plugin "touch_display"... Oct 17 16:32:14 volumio volumio[9039]: info: Applying required configuration parameters for plugin touch_display Oct 17 16:32:14 volumio volumio[9039]: info: Loading i18n strings for locale zh Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key APPLY. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key SAVE. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Oct 17 16:32:14 volumio volumio[9039]: Updating browse sources language Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::initPlayerControls Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: Express server listening on port 3000 Oct 17 16:32:14 volumio volumio[9039]: [Metrics] WebUI: 1s 283.17ms Oct 17 16:32:14 volumio volumio[9039]: info: CoreStateMachine::resetVolumioState Oct 17 16:32:14 volumio volumio[9039]: info: CoreStateMachine::getcurrentVolume Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 16:32:14 volumio volumio[9039]: info: Volumio Network Manager: Network status updated: 2 Oct 17 16:32:14 volumio volumio[9039]: verbose: New Socket.io Connection to 192.168.1.229 from 192.168.1.245 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/155.0.0.0 Safari/537.36 Edg/155.0.0.0 Engine version: 3 Transport: polling Total Clients: 1 Oct 17 16:32:14 volumio volumio[9039]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/155.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 17 16:32:14 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:14 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:14 volumio volumio[9039]: info: CoreStateMachine::updateTrackBlock Oct 17 16:32:14 volumio volumio[9039]: info: CorePlayQueue::getTrackBlock Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::volumioRetrievevolume Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: Reloading queue from file Oct 17 16:32:14 volumio volumio[9109]: Starting albumart workers Oct 17 16:32:14 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Oct 17 16:32:14 volumio volumio[9039]: info: CoreStateMachine::setRepeat false single undefined Oct 17 16:32:14 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:14 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:14 volumio volumio[9039]: info: CoreStateMachine::setRandom null Oct 17 16:32:14 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:14 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:14 volumio volumio[9110]: Starting albumart workers Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:14 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:14 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:14 volumio volumio[9039]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Oct 17 16:32:14 volumio volumio[9039]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Oct 17 16:32:14 volumio volumio[9039]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Oct 17 16:32:14 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 17 16:32:14 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 17 16:32:14 volumio volumio[9039]: info: Setting Device type: Raspberry PI Oct 17 16:32:14 volumio volumio[9039]: info: Completed loading Core Plugins Oct 17 16:32:14 volumio volumio[9039]: info: Preparing to generate the ALSA configuration file Oct 17 16:32:14 volumio volumio[9039]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 17 16:32:14 volumio volumio[9039]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 17 16:32:14 volumio volumio[9039]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Oct 17 16:32:14 volumio volumio[9039]: info: Reading ALSA contributions from plugins. Oct 17 16:32:14 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 17 16:32:14 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 17 16:32:14 volumio volumio[9111]: Starting albumart workers Oct 17 16:32:14 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 17 16:32:14 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 17 16:32:14 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 17 16:32:14 volumio volumio[9039]: info: Asound.conf file unchanged, so no further update is needed Oct 17 16:32:14 volumio volumio[9039]: info: Output device has changed, restarting MPD Oct 17 16:32:14 volumio volumio[9039]: info: Output device has changed, restarting Shairport Sync Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:14 volumio sudo[9164]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 16:32:14 volumio sudo[9164]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:14 volumio sudo[9164]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:14 volumio sudo[9166]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 16:32:14 volumio sudo[9166]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:14 volumio volumio[9039]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 16:32:14 volumio volumio[9039]: info: ___________ START PLUGINS ___________ Oct 17 16:32:14 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 17 16:32:14 volumio volumio[9039]: info: ControllerMpd::onStart: Initializing MPD Oct 17 16:32:14 volumio volumio[9039]: info: Creating MPD Configuration file Oct 17 16:32:14 volumio sudo[9174]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 17 16:32:14 volumio sudo[9174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 16:32:14 volumio volumio[9039]: info: [1792225934768] CoreMusicLibrary::Adding element 媒体服务器 Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 16:32:14 volumio volumio[9039]: info: UPNP Browser: Client initialized successfully Oct 17 16:32:14 volumio sudo[9176]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:14 volumio sudo[9176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:14 volumio sudo[9174]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:14 volumio sudo[9176]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:14 volumio sudo[9179]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 16:32:14 volumio sudo[9179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:14 volumio systemd[1]: mpd.service: Deactivated successfully. Oct 17 16:32:14 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 17 16:32:14 volumio systemd[1]: mpd.socket: Deactivated successfully. Oct 17 16:32:14 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 17 16:32:14 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 17 16:32:14 volumio volumio[9039]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 16:32:14 volumio volumio[9039]: info: [1792225934814] CoreMusicLibrary::Adding element Last_100 Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 17 16:32:14 volumio volumio[9039]: info: [1792225934815] CoreMusicLibrary::Adding element Webradio Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 16:32:14 volumio volumio[9039]: info: Initializing BBC Radios Oct 17 16:32:14 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 17 16:32:14 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Oct 17 16:32:14 volumio systemd[1]: mpd.service: Deactivated successfully. Oct 17 16:32:14 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 17 16:32:14 volumio systemd[1]: mpd.socket: Deactivated successfully. Oct 17 16:32:14 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 17 16:32:14 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 17 16:32:14 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 17 16:32:14 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: FusionDsp - CamillaDSP binary found. Oct 17 16:32:14 volumio volumio[9039]: info: Loading i18n strings for locale zh Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key APPLY. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key SAVE. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:14 volumio volumio[9039]: info: FusionDsp - mixtype--------------------- Software Oct 17 16:32:14 volumio sudo[9210]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 16:32:14 volumio sudo[9210]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 17 16:32:14 volumio sudo[9210]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 17 16:32:14 volumio volumio[9039]: info: Loading i18n strings for locale zh Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key APPLY. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key SAVE. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Oct 17 16:32:14 volumio volumio[9039]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Oct 17 16:32:14 volumio sudo[9222]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Oct 17 16:32:14 volumio sudo[9222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:14 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 16:32:14 volumio volumio[9039]: info: Volumio Calling Home Oct 17 16:32:14 volumio sudo[9222]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:14 volumio sudo[9225]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge Oct 17 16:32:14 volumio sudo[9225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:14 volumio sudo[9225]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:14 volumio volumio[9039]: info: Preparing to generate the ALSA configuration file Oct 17 16:32:14 volumio sudo[9233]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Oct 17 16:32:14 volumio sudo[9233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:14 volumio sudo[9237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Oct 17 16:32:14 volumio sudo[9237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:14 volumio sudo[9243]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 17 16:32:14 volumio sudo[9243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:14 volumio systemd[1]: Reloading. Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 17 16:32:15 volumio volumio[9039]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 17 16:32:15 volumio volumio[9039]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 17 16:32:15 volumio volumio[9039]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Oct 17 16:32:15 volumio volumio[9039]: info: Reading ALSA contributions from plugins. Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: Backlight interface detected. Oct 17 16:32:15 volumio volumio[9039]: info: snd_dummy loaded Oct 17 16:32:15 volumio volumio[9039]: info: MPD Permissions set Oct 17 16:32:15 volumio volumio[9039]: info: MPD Permissions set Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 17 16:32:15 volumio sudo[9265]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ Oct 17 16:32:15 volumio sudo[9265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 17 16:32:15 volumio sudo[9265]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: Raspberry Pi Foundation touch screen detected. Oct 17 16:32:15 volumio sudo[9280]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/11-0045/brightness Oct 17 16:32:15 volumio sudo[9280]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Oct 17 16:32:15 volumio sudo[9280]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio sudo[9284]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Oct 17 16:32:15 volumio sudo[9284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio volumio[9039]: info: Starting Shairport Sync Oct 17 16:32:15 volumio sudo[9284]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio sudo[9076]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio volumio[9039]: info: Starting Shairport Sync Oct 17 16:32:15 volumio volumio[9039]: info: Starting Shairport Sync Oct 17 16:32:15 volumio sudo[9290]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 16:32:15 volumio sudo[9290]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio sudo[9282]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Oct 17 16:32:15 volumio sudo[9282]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: File permissions for backlight brightness control set. Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: IframeKeyboardBridge extension installed successfully Oct 17 16:32:15 volumio sudo[9288]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 16:32:15 volumio sudo[9288]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Oct 17 16:32:15 volumio volumio[9039]: info: Asound.conf file unchanged, so no further update is needed Oct 17 16:32:15 volumio volumio[9039]: info: Output device has changed, restarting MPD Oct 17 16:32:15 volumio sudo[9282]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio sudo[9293]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 16:32:15 volumio sudo[9293]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio volumio[9039]: info: Output device has changed, restarting Shairport Sync Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:15 volumio sudo[9303]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 16:32:15 volumio sudo[9303]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio sudo[9300]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 16:32:15 volumio sudo[9300]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio sudo[9300]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio volumio[9039]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 16:32:15 volumio volumio[9039]: info: Preparing to generate the ALSA configuration file Oct 17 16:32:15 volumio volumio[9039]: info: Discovery: adding 7ef138ca-55cb-4439-93c2-e18587a9a71c Oct 17 16:32:15 volumio volumio[9039]: info: Discovery: Found device Volumio Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:15 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:15 volumio volumio[9039]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 17 16:32:15 volumio volumio[9039]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 17 16:32:15 volumio volumio[9039]: info: Discovery: this is already registered, 7ef138ca-55cb-4439-93c2-e18587a9a71c Oct 17 16:32:15 volumio volumio[9039]: info: Discovery: Found device Volumio Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:15 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:15 volumio volumio[9039]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Oct 17 16:32:15 volumio volumio[9039]: info: Reading ALSA contributions from plugins. Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/155.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 17 16:32:15 volumio volumio[9039]: info: MPD Permissions set Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 16:32:15 volumio volumio[9039]: info: Starting Shairport Sync Oct 17 16:32:15 volumio volumio[9039]: info: Asound.conf file unchanged, so no further update is needed Oct 17 16:32:15 volumio volumio[9039]: info: Output device has changed, restarting MPD Oct 17 16:32:15 volumio sudo[9317]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 16:32:15 volumio sudo[9317]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio volumio[9039]: info: Output device has changed, restarting Shairport Sync Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:15 volumio sudo[9317]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio sudo[9319]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 16:32:15 volumio sudo[9319]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio volumio[9039]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 16:32:15 volumio sudo[9315]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 16:32:15 volumio sudo[9315]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio sudo[9243]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:15 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 16:32:15 volumio volumio[9039]: info: Received Get System Info Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 16:32:15 volumio volumio[9039]: info: Discovery: Getting this device information Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:15 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 16:32:15 volumio systemd[1]: Reloading. Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:15 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:15 volumio volumio[9039]: info: Listing playlists Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Oct 17 16:32:15 volumio volumio[9039]: info: MPD Permissions set Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: systemctl daemon-reload succeeded. Oct 17 16:32:15 volumio sudo[9331]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Oct 17 16:32:15 volumio sudo[9331]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:15 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Oct 17 16:32:15 volumio volumio[9039]: info: Starting Shairport Sync Oct 17 16:32:15 volumio sudo[9356]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 16:32:15 volumio sudo[9356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Oct 17 16:32:15 volumio mpd[9220]: 2026-10-17T16:32:15 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Oct 17 16:32:15 volumio volumio[9039]: info: Received Get System Info Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 16:32:15 volumio volumio[9039]: info: Discovery: Getting this device information Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:15 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 17 16:32:15 volumio systemd[1]: Started mpd.service - Music Player Daemon. Oct 17 16:32:15 volumio sudo[9237]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio sudo[9179]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio sudo[9166]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: systemctl disable getty@tty1.service succeeded. Oct 17 16:32:15 volumio volumio[9039]: error: MPD error: The expression evaluated to a falsy value: Oct 17 16:32:15 volumio volumio[9039]: assert.ok(self.idling) Oct 17 16:32:15 volumio volumio[9039]: error: The expression evaluated to a falsy value: Oct 17 16:32:15 volumio volumio[9039]: assert.ok(self.idling) Oct 17 16:32:15 volumio volumio[9039]: info: MPD running with PID9220 Oct 17 16:32:15 volumio volumio[9039]: ,establishing connection Oct 17 16:32:15 volumio volumio[9039]: error: updateQueue error: null Oct 17 16:32:15 volumio volumio[9039]: error: updateQueue error: null Oct 17 16:32:15 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 17 16:32:15 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 17 16:32:15 volumio sudo[9331]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: Volumio Kiosk started. Oct 17 16:32:15 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Oct 17 16:32:15 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 17 16:32:15 volumio systemd[1]: shairport-sync.service: Consumed 1.610s CPU time. Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:15 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:15 volumio volumio[9039]: info: Completed starting Core Plugins Oct 17 16:32:15 volumio volumio[9039]: info: ------------------------------------------- Oct 17 16:32:15 volumio volumio[9039]: info: ----- MyVolumio plugins startup ---- Oct 17 16:32:15 volumio volumio[9039]: info: ------------------------------------------- Oct 17 16:32:15 volumio volumio[9039]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 17 16:32:15 volumio sudo[9233]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:15 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: systemctl stop getty@tty1.service succeeded. Oct 17 16:32:15 volumio volumio[9039]: verbose: New Socket.io Connection to 192.168.1.229 from 192.168.1.245 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/155.0.0.0 Safari/537.36 Edg/155.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 17 16:32:15 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 17 16:32:15 volumio sudo[9293]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio sudo[9288]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio sudo[9290]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio systemd[1]: mpd.service: Deactivated successfully. Oct 17 16:32:15 volumio sudo[9356]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio sudo[9315]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:15 volumio volumio[9039]: info: Shairport-Sync Started Oct 17 16:32:15 volumio volumio[9039]: Error adding Membership: Error: addMembership EINVAL Oct 17 16:32:15 volumio volumio[9039]: info: Shairport-Sync Started Oct 17 16:32:15 volumio volumio[9039]: info: Shairport-Sync Started Oct 17 16:32:15 volumio volumio[9039]: info: Shairport-Sync Started Oct 17 16:32:15 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 17 16:32:15 volumio volumio[9039]: info: Shairport-Sync Started Oct 17 16:32:15 volumio systemd[1]: mpd.socket: Deactivated successfully. Oct 17 16:32:15 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 17 16:32:15 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 17 16:32:15 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 17 16:32:15 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Oct 17 16:32:15 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 16:32:15 volumio volumio[9039]: info: touch_display: X display number found: 0 Oct 17 16:32:15 volumio sudo[9380]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 16:32:15 volumio sudo[9380]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 17 16:32:15 volumio sudo[9380]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:16 volumio volumio[9039]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Oct 17 16:32:16 volumio volumio[9039]: info: touch_display: Setting screensaver timeout to 120 seconds. Oct 17 16:32:16 volumio volumio[9039]: info: touch_display: X display number found: 0 Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::volumioGetVisibleSources Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:16 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:16 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 17 16:32:16 volumio volumio[9039]: info: Received Get System Info Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 17 16:32:16 volumio volumio[9039]: info: Discovery: Getting this device information Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:16 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:16 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:16 volumio volumio[9039]: info: Listing playlists Oct 17 16:32:16 volumio volumio[9039]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 16:32:16 volumio mpd[9382]: 2026-10-17T16:32:16 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 16:32:16 volumio systemd[1]: Started mpd.service - Music Player Daemon. Oct 17 16:32:16 volumio sudo[9319]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:16 volumio sudo[9303]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:16 volumio volumio[9039]: error: MPD error: The expression evaluated to a falsy value: Oct 17 16:32:16 volumio volumio[9039]: assert.ok(self.idling) Oct 17 16:32:16 volumio volumio[9039]: error: The expression evaluated to a falsy value: Oct 17 16:32:16 volumio volumio[9039]: assert.ok(self.idling) Oct 17 16:32:16 volumio volumio[9039]: error: updateQueue error: null Oct 17 16:32:16 volumio volumio5-onboarding[1821]: time=2026-10-17T16:32:16.617+08:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 17 16:32:16 volumio volumio[9039]: info: Volumio called home Oct 17 16:32:17 volumio volumio-remote-updater[1091]: [2026-10-17 16:32:17] [connect] Successful connection Oct 17 16:32:17 volumio volumio-remote-updater[1091]: [2026-10-17 16:32:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1792225937 101 Oct 17 16:32:17 volumio volumio[9039]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 10 Oct 17 16:32:18 volumio volumio[9039]: info: Cannot mount NAS music at system boot, trial number 2 ,retrying in 5 seconds Oct 17 16:32:20 volumio volumio[9039]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 17 16:32:23 volumio volumio[9039]: info: Cannot mount NAS music at system boot, trial number 3 ,retrying in 5 seconds Oct 17 16:32:23 volumio sudo[9415]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 17 16:32:23 volumio sudo[9415]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:23 volumio sudo[9417]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 17 16:32:23 volumio sudo[9415]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:23 volumio sudo[9417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:23 volumio sudo[9417]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:23 volumio sudo[9421]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 17 16:32:23 volumio sudo[9421]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:23 volumio sudo[9421]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:23 volumio volumio[9039]: info: Upmpdcli Daemon Started Oct 17 16:32:23 volumio volumio[9039]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 17 16:32:23 volumio volumio[9039]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Oct 17 16:32:23 volumio volumio[9039]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 17 16:32:23 volumio volumio[9039]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 17 16:32:23 volumio volumio[9039]: info: camilladsp service started and running in background, instance 1 Oct 17 16:32:23 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:23 volumio volumio[9039]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Oct 17 16:32:23 volumio volumio[9039]: info: FusionDsp loaded Oct 17 16:32:23 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 17 16:32:23 volumio volumio[9039]: info: FusionDsp - --[object Object] Oct 17 16:32:23 volumio volumio[9039]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 17 16:32:23 volumio volumio[9039]: info: Adding Signal Path Element [object Object] Oct 17 16:32:23 volumio volumio[9039]: info: Adding fusiondspeq DSP Signal Path Element Oct 17 16:32:23 volumio volumio[9039]: info: FusionDsp - ---- installed callbackRead (debounced 200ms) Oct 17 16:32:23 volumio volumio[9039]: info: FusionDsp - PEQ graph server listening on port 10015 Oct 17 16:32:23 volumio volumio[9039]: error: FusionDsp - Reload WebSocket error: [object Object] Oct 17 16:32:23 volumio volumio[9039]: warn: FusionDsp - CamillaDSP reload failed; continuing without rejecting the Promise to avoid an unhandled rejection: connect ECONNREFUSED 127.0.0.1:9876 Oct 17 16:32:23 volumio sudo[9437]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 17 16:32:23 volumio sudo[9437]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:23 volumio sudo[9437]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 17 16:32:25 volumio volumio[9039]: info: Adding plugin bluetooth to MyMusic Plugins Oct 17 16:32:25 volumio volumio[9039]: info: Adding plugin multiroom to MyMusic Plugins Oct 17 16:32:25 volumio volumio[9039]: info: Adding plugin metavolumio to MyMusic Plugins Oct 17 16:32:25 volumio volumio[9039]: info: Adding plugin cd_controller to MyMusic Plugins Oct 17 16:32:25 volumio volumio[9039]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 17 16:32:25 volumio volumio[9039]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 17 16:32:25 volumio volumio[9039]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 17 16:32:25 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:25 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:25 volumio volumio[9039]: info: Starting MyVolumio Remote Streaming Endpoints Oct 17 16:32:25 volumio volumio[9039]: info: MyVolumio not started Oct 17 16:32:25 volumio volumio[9039]: info: Initializing device activation check Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 17 16:32:25 volumio volumio[9039]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 17 16:32:26 volumio volumio[9039]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 17 16:32:26 volumio volumio[9039]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 17 16:32:26 volumio volumio[9039]: info: Streaming services startup Oct 17 16:32:26 volumio volumio[9039]: info: Starting Streaming Daemon Oct 17 16:32:26 volumio sudo[9440]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 17 16:32:26 volumio sudo[9440]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:26 volumio volumio[9039]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 17 16:32:26 volumio sudo[9440]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:26 volumio volumio[9039]: error: Cannot start Volumio Streaming Daemon Oct 17 16:32:26 volumio volumio[9039]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 17 16:32:26 volumio volumio[9039]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 17 16:32:28 volumio volumio[9039]: info: Cannot mount NAS music at system boot, trial number 4 ,retrying in 5 seconds Oct 17 16:32:31 volumio volumio[9039]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Oct 17 16:32:31 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Oct 17 16:32:31 volumio volumio[9039]: aaaaaaaaaaa 800,480 Oct 17 16:32:31 volumio volumio[9039]: info: PeppyMeterBasic ---800480 Oct 17 16:32:31 volumio volumio[9039]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Oct 17 16:32:31 volumio volumio[9039]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 16:32:31 volumio volumio[9039]: info: CoreCommandRouter::Close All Modals sent Oct 17 16:32:33 volumio volumio[9039]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Oct 17 16:32:39 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:39 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:39 volumio volumio[9039]: info: CoreCommandRouter::volumioPlay Oct 17 16:32:39 volumio volumio[9039]: info: CoreStateMachine::play index undefined Oct 17 16:32:39 volumio volumio[9039]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 16:32:39 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:39 volumio volumio[9039]: info: CoreStateMachine::startPlaybackTimer Oct 17 16:32:39 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:39 volumio volumio[9039]: verbose: ControllerMpd::clearAddPlayTracks NAS/music/王馨平《别问我是谁》1993 (国语)宝丽金[WAV+CUE]/王馨平《别问我是谁》1993 宝丽金.wav Oct 17 16:32:39 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 16:32:39 volumio volumio[9039]: info: sendMpdCommand stop took 1 milliseconds Oct 17 16:32:39 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand clear Oct 17 16:32:39 volumio volumio[9039]: info: Oct 17 16:32:39 volumio volumio[9039]: ---------------------------- MPD announces system playlist update Oct 17 16:32:39 volumio volumio[9039]: info: Ignoring MPD Status Update Oct 17 16:32:39 volumio volumio[9039]: info: sendMpdCommand clear took 1 milliseconds Oct 17 16:32:39 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand add "NAS/music/王馨平《别问我是谁》1993 (国语)宝丽金[WAV+CUE]/王馨平《别问我是谁》1993 宝丽金.wav" Oct 17 16:32:39 volumio volumio[9039]: info: Oct 17 16:32:39 volumio volumio[9039]: ---------------------------- MPD announces system playlist update Oct 17 16:32:39 volumio volumio[9039]: info: Ignoring MPD Status Update Oct 17 16:32:39 volumio volumio[9039]: error: updateQueue error: null Oct 17 16:32:39 volumio volumio[9039]: info: Oct 17 16:32:39 volumio volumio[9039]: ---------------------------- MPD announces system playlist update Oct 17 16:32:39 volumio volumio[9039]: info: Ignoring MPD Status Update Oct 17 16:32:39 volumio volumio[9039]: info: ------------------------------ 2ms Oct 17 16:32:39 volumio volumio[9039]: info: sendMpdCommand add "NAS/music/王馨平《别问我是谁》1993 (国语)宝丽金[WAV+CUE]/王馨平《别问我是谁》1993 宝丽金.wav" took 1 milliseconds Oct 17 16:32:39 volumio volumio[9039]: info: ------------------------------ 1ms Oct 17 16:32:39 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand play Oct 17 16:32:39 volumio volumio[9039]: info: Oct 17 16:32:39 volumio volumio[9039]: ---------------------------- MPD announces system playlist update Oct 17 16:32:39 volumio volumio[9039]: info: Ignoring MPD Status Update Oct 17 16:32:39 volumio volumio[9039]: info: ------------------------------ 1ms Oct 17 16:32:39 volumio volumio[9039]: info: sendMpdCommand play took 1 milliseconds Oct 17 16:32:39 volumio volumio[9039]: info: ------------------------------ 1ms Oct 17 16:32:40 volumio volumio[9039]: info: Oct 17 16:32:40 volumio volumio[9039]: ---------------------------- MPD announces state update: player Oct 17 16:32:40 volumio volumio[9039]: info: ControllerMpd::getState Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand status Oct 17 16:32:40 volumio volumio[9039]: info: Oct 17 16:32:40 volumio volumio[9039]: ---------------------------- MPD announces state update: player Oct 17 16:32:40 volumio volumio[9039]: info: ControllerMpd::getState Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand status Oct 17 16:32:40 volumio volumio[9039]: info: Oct 17 16:32:40 volumio volumio[9039]: ---------------------------- MPD announces state update: player Oct 17 16:32:40 volumio volumio[9039]: info: sendMpdCommand status took 11 milliseconds Oct 17 16:32:40 volumio volumio[9039]: info: ControllerMpd::getState Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand status Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::parseState Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 16:32:40 volumio volumio[9039]: info: Oct 17 16:32:40 volumio volumio[9039]: ---------------------------- MPD announces state update: player Oct 17 16:32:40 volumio volumio[9039]: info: ControllerMpd::getState Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand status Oct 17 16:32:40 volumio volumio[9039]: info: sendMpdCommand status took 12 milliseconds Oct 17 16:32:40 volumio volumio[9039]: info: sendMpdCommand status took 2 milliseconds Oct 17 16:32:40 volumio volumio[9039]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::parseState Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::parseState Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::parseTrackInfo Oct 17 16:32:40 volumio volumio[9039]: info: ControllerMpd::pushState Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::servicePushState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:40 volumio volumio[9039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2700,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"王馨平《别问我是谁》1993 宝丽金.wav","artist":null,"album":null,"uri":"NAS/music/王馨平《别问我是谁》1993 (国语)宝丽金[WAV+CUE]/王馨平《别问我是谁》1993 宝丽金.wav","trackType":"wav"} Oct 17 16:32:40 volumio volumio[9039]: verbose: CURRENT POSITION 0 Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::syncState stateService play Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::syncState currentStatus stop Oct 17 16:32:40 volumio volumio[9039]: info: ------------------------------ 18ms Oct 17 16:32:40 volumio volumio[9039]: info: sendMpdCommand status took 4 milliseconds Oct 17 16:32:40 volumio volumio[9039]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 17 16:32:40 volumio volumio[9039]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::parseState Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::parseTrackInfo Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::parseTrackInfo Oct 17 16:32:40 volumio volumio[9039]: info: ControllerMpd::pushState Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::servicePushState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:40 volumio volumio[9039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":2700,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"王馨平《别问我是谁》1993 宝丽金.wav","artist":null,"album":null,"uri":"NAS/music/王馨平《别问我是谁》1993 (国语)宝丽金[WAV+CUE]/王馨平《别问我是谁》1993 宝丽金.wav","trackType":"wav"} Oct 17 16:32:40 volumio volumio[9039]: verbose: CURRENT POSITION 0 Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::syncState stateService play Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::syncState currentStatus play Oct 17 16:32:40 volumio volumio[9039]: info: Received an update from plugin. extracting info from payload Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:40 volumio volumio[9039]: info: ControllerMpd::pushState Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::servicePushState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:40 volumio volumio[9039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":2700,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"王馨平《别问我是谁》1993 宝丽金.wav","artist":null,"album":null,"uri":"NAS/music/王馨平《别问我是谁》1993 (国语)宝丽金[WAV+CUE]/王馨平《别问我是谁》1993 宝丽金.wav","trackType":"wav"} Oct 17 16:32:40 volumio volumio[9039]: verbose: CURRENT POSITION 0 Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::syncState stateService play Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::syncState currentStatus play Oct 17 16:32:40 volumio volumio[9039]: info: Received an update from plugin. extracting info from payload Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:40 volumio volumio[9039]: info: ------------------------------ 36ms Oct 17 16:32:40 volumio volumio[9039]: info: ------------------------------ 27ms Oct 17 16:32:40 volumio volumio[9039]: info: camilladsp respawn in 1000 ms (attempt 1/10) Oct 17 16:32:40 volumio volumio[9039]: info: sendMpdCommand playlistinfo took 21 milliseconds Oct 17 16:32:40 volumio volumio[9039]: verbose: ControllerMpd::parseTrackInfo Oct 17 16:32:40 volumio volumio[9039]: info: ControllerMpd::pushState Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::servicePushState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:40 volumio volumio[9039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":2700,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"王馨平《别问我是谁》1993 宝丽金.wav","artist":null,"album":null,"uri":"NAS/music/王馨平《别问我是谁》1993 (国语)宝丽金[WAV+CUE]/王馨平《别问我是谁》1993 宝丽金.wav","trackType":"wav"} Oct 17 16:32:40 volumio volumio[9039]: verbose: CURRENT POSITION 0 Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::syncState stateService play Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::syncState currentStatus play Oct 17 16:32:40 volumio volumio[9039]: info: Received an update from plugin. extracting info from payload Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:40 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:40 volumio volumio[9039]: info: ------------------------------ 36ms Oct 17 16:32:40 volumio volumio[9039]: info: FusionDsp - Volumio is playing Oct 17 16:32:40 volumio volumio[9039]: warn: FusionDsp - Monitor WebSocket not open, skipping commands Oct 17 16:32:40 volumio volumio[9039]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 17 16:32:40 volumio volumio[9039]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 17 16:32:40 volumio volumio[9039]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 17 16:32:40 volumio sudo[9477]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 17 16:32:40 volumio sudo[9477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:40 volumio volumio[9039]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 17 16:32:40 volumio sudo[9482]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 17 16:32:40 volumio volumio[9039]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 17 16:32:40 volumio sudo[9479]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 17 16:32:40 volumio sudo[9482]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:40 volumio sudo[9479]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:40 volumio sudo[9486]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 17 16:32:40 volumio sudo[9486]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:40 volumio volumio[9039]: info: PeppyMeterBasic ---peppymeterbasic status play Oct 17 16:32:40 volumio sudo[9489]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 17 16:32:40 volumio volumio[9039]: error: FusionDsp - Monitor WebSocket error: [object Object] Oct 17 16:32:40 volumio volumio[9039]: info: FusionDsp - Clipping Monitor reconnecting in 2000ms Oct 17 16:32:40 volumio sudo[9489]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:40 volumio sudo[9491]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Oct 17 16:32:40 volumio sudo[9491]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:40 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Oct 17 16:32:40 volumio sudo[9479]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:40 volumio sudo[9486]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:40 volumio sudo[9477]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:40 volumio sudo[9482]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:40 volumio volumio[9039]: info: peppymeterbasic Daemon Started Oct 17 16:32:40 volumio volumio[9039]: info: peppymeterbasic Daemon Started Oct 17 16:32:40 volumio volumio[9039]: info: peppymeterbasic Daemon Started Oct 17 16:32:40 volumio volumio[9039]: info: peppymeterbasic Daemon Started Oct 17 16:32:40 volumio sudo[9489]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:40 volumio volumio[9039]: info: peppymeterbasic Daemon Started Oct 17 16:32:40 volumio volumio[9496]: Traceback (most recent call last): Oct 17 16:32:40 volumio volumio[9496]: File "/data/plugins/user_interface/peppymeterbasic/BasicPeppyMeter/peppymeter.py", line 18, in Oct 17 16:32:40 volumio volumio[9496]: import pygame Oct 17 16:32:40 volumio volumio[9496]: ModuleNotFoundError: No module named 'pygame' Oct 17 16:32:40 volumio sudo[9491]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:40 volumio volumio[9039]: info: peppymeterbasic Daemon Started Oct 17 16:32:40 volumio systemd[1]: peppymeterbasic.service: Main process exited, code=exited, status=1/FAILURE Oct 17 16:32:40 volumio systemd[1]: peppymeterbasic.service: Failed with result 'exit-code'. Oct 17 16:32:40 volumio volumio[9039]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 17 16:32:40 volumio volumio[9039]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 17 16:32:40 volumio volumio[9039]: info: camilladsp service terminated, instance 1 Oct 17 16:32:40 volumio volumio[9039]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 17 16:32:40 volumio volumio[9039]: info: camilladsp service started and running in background, instance 1 Oct 17 16:32:40 volumio volumio[9039]: info: camilladsp respawn in 1000 ms (attempt 1/10) Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 17 16:32:40 volumio volumio[9039]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Oct 17 16:32:40 volumio volumio[9039]: info: CoreCommandRouter::volumioGetState Oct 17 16:32:40 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:41 volumio volumio[9039]: info: camilladsp respawn in 2000 ms (attempt 2/10) Oct 17 16:32:41 volumio volumio[9039]: info: camilladsp respawn in 4000 ms (attempt 3/10) Oct 17 16:32:42 volumio volumio[9039]: error: FusionDsp - Monitor WebSocket error: [object Object] Oct 17 16:32:42 volumio volumio[9039]: info: FusionDsp - Clipping Monitor reconnecting in 4000ms Oct 17 16:32:43 volumio volumio[9039]: info: camilladsp respawn in 8000 ms (attempt 4/10) Oct 17 16:32:44 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 16:32:44 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:44 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 17 16:32:45 volumio volumio-remote-updater[1091]: Test mode disabled Oct 17 16:32:45 volumio volumio-remote-updater[1091]: Alpha mode disabled Oct 17 16:32:45 volumio volumio-remote-updater[1091]: Alpha legacy test mode disabled Oct 17 16:32:45 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 17 16:32:45 volumio volumio[9039]: info: camilladsp respawn in 10000 ms (attempt 5/10) Oct 17 16:32:45 volumio volumio[9039]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 17 16:32:45 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 17 16:32:45 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:45 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:45 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 17 16:32:45 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 17 16:32:45 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 17 16:32:45 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 17 16:32:45 volumio volumio[9039]: info: CoreCommandRouter::volumioGetBrowseSources Oct 17 16:32:45 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 17 16:32:46 volumio volumio[9039]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 17 16:32:46 volumio volumio[9039]: info: Completed starting MyVolumio Plugin Oct 17 16:32:46 volumio volumio[9039]: [Metrics] CommandRouter: 32s 739.39ms Oct 17 16:32:46 volumio volumio[9039]: info: CoreCommandRouter::volumiosetStartupVolume Oct 17 16:32:46 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 16:32:46 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 16:32:46 volumio volumio[9039]: info: CoreCommandRouter::Close All Modals sent Oct 17 16:32:46 volumio volumio[9039]: info: CoreCommandRouter::Close All Modals sent Oct 17 16:32:46 volumio volumio[9039]: error: FusionDsp - Monitor WebSocket error: [object Object] Oct 17 16:32:46 volumio volumio[9039]: info: FusionDsp - Clipping Monitor reconnecting in 8000ms Oct 17 16:32:46 volumio volumio[9039]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Oct 17 16:32:46 volumio volumio[9039]: info: FusionDsp - ---- read samplerate from file: 44100 Oct 17 16:32:46 volumio volumio[9039]: info: CoreCommandRouter::volumioGetQueue Oct 17 16:32:46 volumio volumio[9039]: info: CoreStateMachine::getQueue Oct 17 16:32:46 volumio volumio[9039]: info: CorePlayQueue::getQueue Oct 17 16:32:46 volumio volumio[9039]: info: FusionDsp - If filter freq >samplerate/2 then disable it Oct 17 16:32:46 volumio volumio[9039]: error: FusionDsp - Reload WebSocket error: [object Object] Oct 17 16:32:46 volumio volumio[9039]: warn: FusionDsp - CamillaDSP reload failed; continuing without rejecting the Promise to avoid an unhandled rejection: connect ECONNREFUSED 127.0.0.1:9876 Oct 17 16:32:47 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 17 16:32:47 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 17 16:32:47 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 17 16:32:51 volumio volumio[9039]: info: camilladsp respawn in 10000 ms (attempt 6/10) Oct 17 16:32:53 volumio volumio[9039]: info: BOOT COMPLETED Oct 17 16:32:54 volumio volumio[9039]: error: FusionDsp - Monitor WebSocket error: [object Object] Oct 17 16:32:54 volumio volumio[9039]: info: FusionDsp - Clipping Monitor reconnecting in 16000ms Oct 17 16:32:55 volumio volumio[9039]: info: camilladsp respawn in 10000 ms (attempt 7/10) Oct 17 16:32:56 volumio volumio[9039]: info: Preload queue cleared Oct 17 16:32:56 volumio volumio[9039]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 17 16:32:56 volumio volumio[9039]: info: CoreStateMachine::ClearQueue Oct 17 16:32:56 volumio volumio[9039]: info: CoreStateMachine::stop Oct 17 16:32:56 volumio volumio[9039]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 16:32:56 volumio volumio[9039]: info: CoreStateMachine::stPlaybackTimer Oct 17 16:32:56 volumio volumio[9039]: info: CoreStateMachine::updateTrackBlock Oct 17 16:32:56 volumio volumio[9039]: info: CorePlayQueue::getTrackBlock Oct 17 16:32:56 volumio volumio[9039]: info: CoreStateMachine::pushState Oct 17 16:32:56 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:56 volumio volumio[9039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 16:32:56 volumio volumio[9039]: info: CoreCommandRouter::volumioPushState Oct 17 16:32:56 volumio volumio[9039]: info: CoreStateMachine::serviceStop Oct 17 16:32:56 volumio volumio[9039]: info: CorePlayQueue::getTrack 0 Oct 17 16:32:56 volumio volumio[9039]: info: CoreCommandRouter::serviceStop Oct 17 16:32:56 volumio volumio[9039]: info: ControllerMpd::stop Oct 17 16:32:56 volumio volumio[9039]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 16:32:56 volumio volumio[9039]: info: CorePlayQueue::clearPlayQueue Oct 17 16:32:56 volumio volumio[9039]: info: CorePlayQueue::saveQueue Oct 17 16:32:56 volumio volumio[9039]: info: CoreCommandRouter::volumioPushQueue Oct 17 16:32:56 volumio volumio[9039]: info: CoreStateMachine::addQueueItems Oct 17 16:32:56 volumio volumio[9039]: info: CorePlayQueue::addQueueItems Oct 17 16:32:56 volumio volumio[9039]: info: Preload queue cleared Oct 17 16:32:56 volumio volumio[9039]: info: Adding Item to queue: music-library/NAS/music/《1812序曲》TELARC版柴科夫斯基[WAV+CUE] Oct 17 16:32:56 volumio volumio[9039]: info: Exploding uri music-library/NAS/music/《1812序曲》TELARC版柴科夫斯基[WAV+CUE] in service mpd Oct 17 16:32:56 volumio volumio[9039]: info: FusionDsp - Volumio is not playing Oct 17 16:32:56 volumio volumio[9039]: info: FusionDsp - Clipped samples monitor stopped Oct 17 16:32:56 volumio volumio[9039]: info: PeppyMeterBasic ---peppymeterbasic status stop Oct 17 16:32:56 volumio sudo[9593]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Oct 17 16:32:56 volumio volumio[9039]: info: Oct 17 16:32:56 volumio volumio[9039]: ---------------------------- MPD announces state update: player Oct 17 16:32:56 volumio volumio[9039]: info: ALBUMART /albumart?cacheid=409&web=Erich%20Kunzel%2C%20The%20Cincinnati%20Pops%20Orchestra/Tchaikovsky%20-%201812%20Overture/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A1812%E5%BA%8F%E6%9B%B2%E3%80%8BTELARC%E7%89%88%E6%9F%B4%E7%A7%91%E5%A4%AB%E6%96%AF%E5%9F%BA%5BWAV%2BCUE%5D%2FErich%20Kunzel%2C%20The%20Cincinnati%20Pops%20Orchestra%20-%20Tchaikovsky%20-%201812%20Overture.cue&metadata=false Oct 17 16:32:56 volumio volumio[9039]: info: URI /mnt/NAS/music/《1812序曲》TELARC版柴科夫斯基[WAV+CUE]/Erich Kunzel, The Cincinnati Pops Orchestra - Tchaikovsky - 1812 Overture.cue Oct 17 16:32:56 volumio volumio[9039]: info: ALBUMART /albumart?cacheid=409&web=Erich%20Kunzel%2C%20The%20Cincinnati%20Pops%20Orchestra/Tchaikovsky%20-%201812%20Overture/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E3%80%8A1812%E5%BA%8F%E6%9B%B2%E3%80%8BTELARC%E7%89%88%E6%9F%B4%E7%A7%91%E5%A4%AB%E6%96%AF%E5%9F%BA%5BWAV%2BCUE%5D%2FErich%20Kunzel%2C%20The%20Cincinnati%20Pops%20Orchestra%20-%20Tchaikovsky%20-%201812%20Overture.cue&metadata=false Oct 17 16:32:56 volumio volumio[9039]: info: URI /mnt/NAS/music/《1812序曲》TELARC版柴科夫斯基[WAV+CUE]/Erich Kunzel, The Cincinnati Pops Orchestra - Tchaikovsky - 1812 Overture.cue Oct 17 16:32:56 volumio sudo[9593]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 17 16:32:56 volumio volumio[9039]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 16:32:56 volumio volumio[9039]: Error: Unable to resolve or reject the same promise twice Oct 17 16:32:56 volumio volumio[9039]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 17 16:32:56 volumio volumio[9039]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Oct 17 16:32:56 volumio volumio[9039]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 17 16:32:56 volumio volumio[9039]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 17 16:32:56 volumio volumio[9039]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 17 16:32:56 volumio volumio[9039]: at Socket.emit (node:events:514:28) Oct 17 16:32:56 volumio volumio[9039]: at addChunk (node:internal/streams/readable:343:12) Oct 17 16:32:56 volumio volumio[9039]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 17 16:32:56 volumio volumio[9039]: at Readable.push (node:internal/streams/readable:253:10) Oct 17 16:32:56 volumio volumio[9039]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 17 16:32:56 volumio volumio[9039]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 16:32:56 volumio sudo[9593]: pam_unix(sudo:session): session closed for user root Oct 17 16:32:56 volumio sudo[9609]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-17 16:31' Oct 17 16:32:56 volumio sudo[9609]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"