-- Logs begin at Thu 2025-07-03 00:18:50 -03, end at Thu 2025-07-03 00:33:42 -03. -- Jul 03 00:32:03 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioGetState Jul 03 00:32:10 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:32:10 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:32:12 volumio-cambridge volumio[933]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Jul 03 00:32:12 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioGetState Jul 03 00:32:12 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 03 00:32:12 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 03 00:32:27 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:32:29 volumio-cambridge volumio[933]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Jul 03 00:32:29 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioGetState Jul 03 00:32:30 volumio-cambridge volumio[933]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/now_playing/volumio/buster/amd64 Jul 03 00:32:32 volumio-cambridge volumio[933]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/now_playing/volumio/buster/amd64 Jul 03 00:32:32 volumio-cambridge volumio[933]: info: Folder /tmp/plugins removed Jul 03 00:32:32 volumio-cambridge volumio[933]: info: Check plugin dependencies Jul 03 00:32:32 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 03 00:32:32 volumio-cambridge volumio[933]: info: Checking if plugin already exists Jul 03 00:32:32 volumio-cambridge volumio[933]: info: Rename folder Jul 03 00:32:32 volumio-cambridge volumio[933]: info: Folder /tmp/downloaded_plugin.zip removed Jul 03 00:32:32 volumio-cambridge volumio[933]: info: Move to category Jul 03 00:32:32 volumio-cambridge volumio[933]: info: Checking if install.sh is present Jul 03 00:32:32 volumio-cambridge volumio[933]: info: Executing install.sh Jul 03 00:32:32 volumio-cambridge sudo[5746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/now_playing/install.sh Jul 03 00:32:32 volumio-cambridge sudo[5746]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 03 00:32:32 volumio-cambridge volumio[933]: info: Installing geo-tz node dependency Jul 03 00:32:44 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:32:44 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:32:45 volumio-cambridge volumio[933]: info: + geo-tz@8.1.4 Jul 03 00:32:45 volumio-cambridge volumio[933]: info: added 29 packages from 33 contributors and audited 354 packages in 11.521s Jul 03 00:32:45 volumio-cambridge volumio[933]: info: Jul 03 00:32:45 volumio-cambridge volumio[933]: info: 22 packages are looking for funding Jul 03 00:32:45 volumio-cambridge volumio[933]: info: run `npm fund` for details Jul 03 00:32:45 volumio-cambridge volumio[933]: info: Jul 03 00:32:45 volumio-cambridge volumio[933]: info: found 6 vulnerabilities (4 low, 2 high) Jul 03 00:32:45 volumio-cambridge volumio[933]: info: run `npm audit fix` to fix them, or `npm audit` for details Jul 03 00:32:46 volumio-cambridge volumio[933]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Jul 03 00:32:46 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioGetState Jul 03 00:32:47 volumio-cambridge volumio[933]: info: + point-in-polygon-hao@1.1.0 Jul 03 00:32:47 volumio-cambridge volumio[933]: info: removed 1 package, updated 1 package and audited 354 packages in 1.565s Jul 03 00:32:47 volumio-cambridge volumio[933]: info: Jul 03 00:32:47 volumio-cambridge volumio[933]: info: 22 packages are looking for funding Jul 03 00:32:47 volumio-cambridge volumio[933]: info: run `npm fund` for details Jul 03 00:32:47 volumio-cambridge volumio[933]: info: Jul 03 00:32:47 volumio-cambridge volumio[933]: info: found 6 vulnerabilities (4 low, 2 high) Jul 03 00:32:47 volumio-cambridge volumio[933]: info: run `npm audit fix` to fix them, or `npm audit` for details Jul 03 00:32:47 volumio-cambridge volumio[933]: info: Creating user directories (if not exist) Jul 03 00:32:47 volumio-cambridge sudo[5746]: pam_unix(sudo:session): session closed for user root Jul 03 00:32:47 volumio-cambridge volumio[933]: info: Now Playing plugin installed Jul 03 00:32:47 volumio-cambridge volumio[933]: Plugin install end detected on script Jul 03 00:32:47 volumio-cambridge volumio[933]: info: Install script completed Jul 03 00:32:47 volumio-cambridge volumio[933]: info: Adding reference to registry Jul 03 00:32:47 volumio-cambridge volumio[933]: info: Done installing plugin. Jul 03 00:32:47 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 03 00:32:47 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 03 00:32:47 volumio-cambridge volumio[933]: info: Folder /tmp/plugins removed Jul 03 00:32:47 volumio-cambridge volumio[933]: info: Folder /tmp/downloaded_plugin.zip removed Jul 03 00:32:47 volumio-cambridge volumio[933]: info: Folder /data/temp removed Jul 03 00:32:53 volumio-cambridge volumio[933]: info: Enabling plugin now_playing Jul 03 00:32:53 volumio-cambridge volumio[933]: info: Loading plugin "now_playing"... Jul 03 00:32:54 volumio-cambridge volumio[933]: info: PLUGIN START: now_playing Jul 03 00:32:54 volumio-cambridge volumio[933]: info: [now-playing] ConfigUpdater: config version unavailable. Either this is the first time the plugin is installed, or the previous version is < 0.3.0). Config will not be updated. Jul 03 00:32:54 volumio-cambridge volumio[933]: info: [now-playing] ConfigUpdater: updated config version to 0.7.5 Jul 03 00:32:54 volumio-cambridge volumio[933]: info: [now-playing] App is listening on port 4004. Jul 03 00:32:54 volumio-cambridge volumio[933]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jul 03 00:32:54 volumio-cambridge volumio[933]: info: Done. Jul 03 00:32:56 volumio-cambridge volumio[933]: info: Enabling plugin now_playing Jul 03 00:32:56 volumio-cambridge volumio[933]: info: Loading plugin "now_playing"... Jul 03 00:32:56 volumio-cambridge volumio[933]: info: PLUGIN START: now_playing Jul 03 00:32:56 volumio-cambridge volumio[933]: info: [now-playing] ConfigUpdater: config is up to date. Jul 03 00:32:56 volumio-cambridge volumio[933]: info: [now-playing] App already started Jul 03 00:32:56 volumio-cambridge volumio[933]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jul 03 00:32:56 volumio-cambridge volumio[933]: info: Done. Jul 03 00:33:01 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:33:01 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:33:03 volumio-cambridge volumio[933]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Jul 03 00:33:03 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioGetState Jul 03 00:33:03 volumio-cambridge volumio[933]: info: Enabling plugin now_playing Jul 03 00:33:03 volumio-cambridge volumio[933]: info: Loading plugin "now_playing"... Jul 03 00:33:03 volumio-cambridge volumio[933]: info: PLUGIN START: now_playing Jul 03 00:33:03 volumio-cambridge volumio[933]: info: [now-playing] ConfigUpdater: config is up to date. Jul 03 00:33:03 volumio-cambridge volumio[933]: info: [now-playing] App already started Jul 03 00:33:03 volumio-cambridge volumio[933]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jul 03 00:33:03 volumio-cambridge volumio[933]: info: Done. Jul 03 00:33:04 volumio-cambridge volumio[933]: info: Enabling plugin now_playing Jul 03 00:33:04 volumio-cambridge volumio[933]: info: Loading plugin "now_playing"... Jul 03 00:33:04 volumio-cambridge volumio[933]: info: PLUGIN START: now_playing Jul 03 00:33:04 volumio-cambridge volumio[933]: info: [now-playing] ConfigUpdater: config is up to date. Jul 03 00:33:04 volumio-cambridge volumio[933]: info: [now-playing] App already started Jul 03 00:33:04 volumio-cambridge volumio[933]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Jul 03 00:33:04 volumio-cambridge volumio[933]: info: Done. Jul 03 00:33:09 volumio-cambridge volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 03 00:33:09 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 03 00:33:09 volumio-cambridge volumio[933]: info: Discovery: Getting this device information Jul 03 00:33:09 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioGetState Jul 03 00:33:09 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 03 00:33:18 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:33:18 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:33:20 volumio-cambridge volumio[933]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Jul 03 00:33:20 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioGetState Jul 03 00:33:35 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:33:35 volumio-cambridge sudo[2015]: libpng warning: iCCP: known incorrect sRGB profile Jul 03 00:33:37 volumio-cambridge volumio[933]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Jul 03 00:33:37 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioGetState Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 03 00:33:38 volumio-cambridge volumio[933]: info: Jul 03 00:33:38 volumio-cambridge volumio[933]: ---------------------------- MPD announces system playlist update Jul 03 00:33:38 volumio-cambridge volumio[933]: info: Ignoring MPD Status Update Jul 03 00:33:38 volumio-cambridge volumio[933]: info: Jul 03 00:33:38 volumio-cambridge volumio[933]: ---------------------------- MPD announces state update: player Jul 03 00:33:38 volumio-cambridge volumio[933]: info: ControllerMpd::getState Jul 03 00:33:38 volumio-cambridge volumio[933]: verbose: ControllerMpd::sendMpdCommand status Jul 03 00:33:38 volumio-cambridge volumio[933]: info: ------------------------------ 0ms Jul 03 00:33:38 volumio-cambridge volumio[933]: info: sendMpdCommand status took 0 milliseconds Jul 03 00:33:38 volumio-cambridge volumio[933]: verbose: ControllerMpd::parseState Jul 03 00:33:38 volumio-cambridge volumio[933]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 03 00:33:38 volumio-cambridge volumio[933]: info: sendMpdCommand playlistinfo took 0 milliseconds Jul 03 00:33:38 volumio-cambridge volumio[933]: verbose: ControllerMpd::parseTrackInfo Jul 03 00:33:38 volumio-cambridge volumio[933]: info: ControllerMpd::pushState Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreCommandRouter::servicePushState Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CorePlayQueue::getTrack 0 Jul 03 00:33:38 volumio-cambridge volumio[933]: verbose: STATE SERVICE {"status":"play","position":0,"seek":210174,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Robert Cristian - Belong To You (Original Mix)","artist":"Indie Dance - DI.FM Premium","album":null,"uri":"http://prem1.di.fm:80/indiedance_hi?34f78332abcaf9a7f5","trackType":""} Jul 03 00:33:38 volumio-cambridge volumio[933]: verbose: CURRENT POSITION 0 Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreStateMachine::syncState stateService play Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreStateMachine::syncState currentStatus play Jul 03 00:33:38 volumio-cambridge volumio[933]: info: Received an update from plugin. extracting info from payload Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreStateMachine::pushState Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioPushState Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreStateMachine::pushState Jul 03 00:33:38 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioPushState Jul 03 00:33:38 volumio-cambridge volumio[933]: info: ------------------------------ 8ms Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CoreStateMachine::stop Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CoreStateMachine::stPlaybackTimer Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CoreStateMachine::updateTrackBlock Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CorePlayQueue::getTrackBlock Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CoreStateMachine::pushState Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CorePlayQueue::getTrack 0 Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CoreCommandRouter::volumioPushState Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CoreStateMachine::serviceStop Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CorePlayQueue::getTrack 0 Jul 03 00:33:42 volumio-cambridge volumio[933]: info: CoreCommandRouter::serviceStop Jul 03 00:33:42 volumio-cambridge volumio[933]: info: [1751513622423] ControllerWebradio::stop Jul 03 00:33:42 volumio-cambridge volumio[933]: verbose: ControllerMpd::sendMpdCommand stop Jul 03 00:33:42 volumio-cambridge volumio[933]: info: Disabling plugin peppy_screensaver Jul 03 00:33:42 volumio-cambridge volumio[933]: info: Preparing to generate the ALSA configuration file Jul 03 00:33:42 volumio-cambridge volumio[933]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 03 00:33:42 volumio-cambridge volumio[933]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Jul 03 00:33:42 volumio-cambridge volumio[933]: at Object.readdirSync (fs.js:1048:3) Jul 03 00:33:42 volumio-cambridge volumio[933]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Jul 03 00:33:42 volumio-cambridge volumio[933]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Jul 03 00:33:42 volumio-cambridge volumio[933]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Jul 03 00:33:42 volumio-cambridge volumio[933]: errno: -20, Jul 03 00:33:42 volumio-cambridge volumio[933]: syscall: 'scandir', Jul 03 00:33:42 volumio-cambridge volumio[933]: code: 'ENOTDIR', Jul 03 00:33:42 volumio-cambridge volumio[933]: path: '/tmp/peppyrunning' Jul 03 00:33:42 volumio-cambridge volumio[933]: } Jul 03 00:33:42 volumio-cambridge volumio[933]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 03 00:33:42 volumio-cambridge sudo[6033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-03 00:32 Jul 03 00:33:42 volumio-cambridge sudo[6033]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"