-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Thu 2026-04-02 16:45:03 MSK. --
Apr 02 16:44:17 volumio volumio[1217]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Apr 02 16:44:17 volumio volumio[1217]: info: Downloading plugin at http://127.0.0.1:3000/plugin-serve/rotaryencoder.zip
Apr 02 16:44:17 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:17.570+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:17 volumio volumio[1217]: info: END DOWNLOAD: http://127.0.0.1:3000/plugin-serve/rotaryencoder.zip
Apr 02 16:44:17 volumio volumio[1217]: info: Folder /tmp/plugins removed
Apr 02 16:44:17 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:17.606+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:17 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:17.637+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:17 volumio volumio[1217]: info: Check plugin dependencies
Apr 02 16:44:17 volumio volumio[1217]: error: Error finding native modules: Command failed: find /data/temp/downloaded_plugin/node_modules -name obj.target -prune -false -o -type f -name "*.node" 2>/dev/null {"status":1,"signal":null,"output":[null,"",""],"pid":4151,"stdout":"","stderr":"","stack":"Error: Command failed: find /data/temp/downloaded_plugin/node_modules -name obj.target -prune -false -o -type f -name \"*.node\" 2>/dev/null\n at checkExecSyncError (child_process.js:616:11)\n at execSync (child_process.js:652:15)\n at PluginManager.checkPluginDependencies (/volumio/app/pluginmanager.js:1149:26)\n at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)\n at processTicksAndRejections (internal/process/task_queues.js:75:11)"}
Apr 02 16:44:17 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:17.666+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:17 volumio volumio[1217]: info: Checking if plugin already exists
Apr 02 16:44:17 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:17.673+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:17 volumio volumio[1217]: info: Rename folder
Apr 02 16:44:17 volumio volumio[1217]: info: Folder /tmp/downloaded_plugin.zip removed
Apr 02 16:44:17 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:17.699+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:17 volumio volumio[1217]: info: Move to category
Apr 02 16:44:18 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:18.714+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:18 volumio volumio[1217]: info: Checking if install.sh is present
Apr 02 16:44:18 volumio volumio[1217]: info: Executing install.sh
Apr 02 16:44:18 volumio sudo[4162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/rotaryencoder/install.sh
Apr 02 16:44:18 volumio sudo[4162]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 02 16:44:18 volumio sudo[4162]: pam_unix(sudo:session): session closed for user root
Apr 02 16:44:18 volumio volumio[1217]: info: Installing Rotary Encoder and its dependencies
Apr 02 16:44:18 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:18.800+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:18 volumio volumio[1217]: info: No additional packages needed.
Apr 02 16:44:18 volumio volumio[1217]: info: Continuing...
Apr 02 16:44:18 volumio volumio[1217]: Plugin install end detected on script
Apr 02 16:44:18 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:18.809+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:18 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:18.810+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:18 volumio volumio[1217]: info: Install script completed
Apr 02 16:44:18 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:18.818+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:18 volumio volumio[1217]: info: Adding reference to registry
Apr 02 16:44:18 volumio volumio5-onboarding[1582]: time=2026-04-02T16:44:18.827+03:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Apr 02 16:44:18 volumio volumio[1217]: info: Done installing plugin.
Apr 02 16:44:18 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 02 16:44:18 volumio volumio[1217]: info: Folder /tmp/plugins removed
Apr 02 16:44:18 volumio volumio[1217]: info: Folder /tmp/downloaded_plugin.zip removed
Apr 02 16:44:18 volumio volumio[1217]: info: Folder /data/temp removed
Apr 02 16:44:38 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 02 16:44:40 volumio volumio[1217]: info: CoreCommandRouter::Close All Modals sent
Apr 02 16:44:43 volumio volumio[1217]: info: Enabling plugin rotaryencoder
Apr 02 16:44:43 volumio volumio[1217]: info: Loading plugin "rotaryencoder"...
Apr 02 16:44:43 volumio volumio[1217]: error: !!!! WARNING !!!!
Apr 02 16:44:43 volumio volumio[1217]: error: The plugin user_interface/rotaryencoder failed to load, setting it to stopped. Error: Error: Cannot find module 'kew'
Apr 02 16:44:43 volumio volumio[1217]: Require stack:
Apr 02 16:44:43 volumio volumio[1217]: - /data/plugins/user_interface/rotaryencoder/index.js
Apr 02 16:44:43 volumio volumio[1217]: - /volumio/app/pluginmanager.js
Apr 02 16:44:43 volumio volumio[1217]: - /volumio/app/index.js
Apr 02 16:44:43 volumio volumio[1217]: - /volumio/index.js
Apr 02 16:44:43 volumio volumio[1217]: error: Stack trace: Error: Cannot find module 'kew'
Apr 02 16:44:43 volumio volumio[1217]: Require stack:
Apr 02 16:44:43 volumio volumio[1217]: - /data/plugins/user_interface/rotaryencoder/index.js
Apr 02 16:44:43 volumio volumio[1217]: - /volumio/app/pluginmanager.js
Apr 02 16:44:43 volumio volumio[1217]: - /volumio/app/index.js
Apr 02 16:44:43 volumio volumio[1217]: - /volumio/index.js
Apr 02 16:44:43 volumio volumio[1217]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:880:15)
Apr 02 16:44:43 volumio volumio[1217]: at Function.Module._load (internal/modules/cjs/loader.js:725:27)
Apr 02 16:44:43 volumio volumio[1217]: at Module.require (internal/modules/cjs/loader.js:952:19)
Apr 02 16:44:43 volumio volumio[1217]: at require (internal/modules/cjs/helpers.js:88:18)
Apr 02 16:44:43 volumio volumio[1217]: at Object. (/data/plugins/user_interface/rotaryencoder/index.js:3:12)
Apr 02 16:44:43 volumio volumio[1217]: at Module._compile (internal/modules/cjs/loader.js:1063:30)
Apr 02 16:44:43 volumio volumio[1217]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10)
Apr 02 16:44:43 volumio volumio[1217]: at Module.load (internal/modules/cjs/loader.js:928:32)
Apr 02 16:44:43 volumio volumio[1217]: at Function.Module._load (internal/modules/cjs/loader.js:769:14)
Apr 02 16:44:43 volumio volumio[1217]: at Module.require (internal/modules/cjs/loader.js:952:19)
Apr 02 16:44:43 volumio volumio[1217]: at require (internal/modules/cjs/helpers.js:88:18)
Apr 02 16:44:43 volumio volumio[1217]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29)
Apr 02 16:44:43 volumio volumio[1217]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Apr 02 16:44:43 volumio volumio[1217]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 02 16:44:43 volumio volumio[1217]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Apr 02 16:44:43 volumio volumio[1217]: error: !!!! WARNING !!!!
Apr 02 16:44:43 volumio volumio[1217]: info: Done.
Apr 02 16:44:45 volumio ntpd[818]: 89.188.118.150 local addr 172.17.57.62 ->
Apr 02 16:44:56 volumio volumio[1217]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 02 16:45:00 volumio volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 02 16:45:02 volumio volumio[1217]: info: CoreCommandRouter::Close All Modals sent
Apr 02 16:45:02 volumio volumio[1217]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 02 16:45:02 volumio volumio[1217]: TypeError: Cannot read property 'broadcastMessage' of null
Apr 02 16:45:02 volumio volumio[1217]: at /volumio/app/index.js:1534:32
Apr 02 16:45:02 volumio volumio[1217]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17)
Apr 02 16:45:02 volumio volumio[1217]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12)
Apr 02 16:45:02 volumio volumio[1217]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1532:13)
Apr 02 16:45:02 volumio volumio[1217]: at CoreCommandRouter.closeModals (/volumio/app/index.js:1954:15)
Apr 02 16:45:02 volumio volumio[1217]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1975:26)
Apr 02 16:45:02 volumio volumio[1217]: at Socket.emit (events.js:315:20)
Apr 02 16:45:02 volumio volumio[1217]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Apr 02 16:45:02 volumio volumio[1217]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Apr 02 16:45:02 volumio volumio[1217]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 02 16:45:03 volumio sudo[4273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-02 16:44
Apr 02 16:45:03 volumio sudo[4273]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET"
VOLUMIO_VERSION="3.912"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"