-- Logs begin at Tue 2024-09-17 17:06:54 CEST, end at Mon 2024-10-07 19:08:56 CEST. -- Oct 07 19:07:06 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 19:07:06 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 19:07:06 volumio volumio[901]: info: Discovery: Getting this device information Oct 07 19:07:06 volumio volumio[901]: info: CoreCommandRouter::volumioGetState Oct 07 19:07:06 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:07:06 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 19:07:13 volumio volumio[901]: 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: 8 Oct 07 19:07:13 volumio volumio[901]: info: Downloading plugin at http://127.0.0.1:3000/plugin-serve/rotaryencoder.zip Oct 07 19:07:13 volumio volumio[901]: info: END DOWNLOAD: http://127.0.0.1:3000/plugin-serve/rotaryencoder.zip Oct 07 19:07:13 volumio volumio[901]: info: Folder /tmp/plugins removed Oct 07 19:07:13 volumio volumio[901]: info: Check plugin dependencies Oct 07 19:07:13 volumio volumio[901]: 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":3286,"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)"} Oct 07 19:07:13 volumio volumio[901]: info: Checking if plugin already exists Oct 07 19:07:13 volumio volumio[901]: info: Rename folder Oct 07 19:07:13 volumio volumio[901]: info: Folder /tmp/downloaded_plugin.zip removed Oct 07 19:07:13 volumio volumio[901]: info: Move to category Oct 07 19:07:14 volumio volumio[901]: info: Checking if install.sh is present Oct 07 19:07:14 volumio volumio[901]: info: Executing install.sh Oct 07 19:07:14 volumio sudo[3296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/rotaryencoder/install.sh Oct 07 19:07:14 volumio sudo[3296]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 19:07:14 volumio sudo[3296]: pam_unix(sudo:session): session closed for user root Oct 07 19:07:14 volumio volumio[901]: info: Install script completed Oct 07 19:07:14 volumio volumio[901]: info: Adding reference to registry Oct 07 19:07:14 volumio volumio[901]: info: Done installing plugin. Oct 07 19:07:14 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 19:07:14 volumio volumio[901]: info: Installing Rotary Encoder and its dependencies Oct 07 19:07:14 volumio volumio[901]: info: No additional packages needed. Oct 07 19:07:14 volumio volumio[901]: info: Continuing... Oct 07 19:07:14 volumio volumio[901]: Plugin install end detected on script Oct 07 19:07:14 volumio volumio[901]: info: Folder /tmp/plugins removed Oct 07 19:07:14 volumio volumio[901]: info: Folder /tmp/downloaded_plugin.zip removed Oct 07 19:07:14 volumio volumio[901]: info: Folder /data/temp removed Oct 07 19:07:36 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 19:07:36 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 19:07:36 volumio volumio[901]: info: Discovery: Getting this device information Oct 07 19:07:36 volumio volumio[901]: info: CoreCommandRouter::volumioGetState Oct 07 19:07:36 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:07:36 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 19:08:06 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 19:08:06 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 19:08:06 volumio volumio[901]: info: Discovery: Getting this device information Oct 07 19:08:06 volumio volumio[901]: info: CoreCommandRouter::volumioGetState Oct 07 19:08:06 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:08:06 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 19:08:23 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 19:08:23 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 19:08:23 volumio volumio[901]: info: Discovery: Getting this device information Oct 07 19:08:23 volumio volumio[901]: info: CoreCommandRouter::volumioGetState Oct 07 19:08:23 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:08:23 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 19:08:23 volumio volumio[901]: verbose: New Socket.io Connection to 192.168.1.93:3000 from 192.168.1.231 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Oct 07 19:08:23 volumio volumio[901]: info: CoreCommandRouter::volumioGetState Oct 07 19:08:23 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:08:23 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 07 19:08:23 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 07 19:08:28 volumio sudo[3461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 07 19:08:28 volumio sudo[3461]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 19:08:28 volumio sudo[3461]: pam_unix(sudo:session): session closed for user root Oct 07 19:08:28 volumio sudo[3463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 07 19:08:28 volumio sudo[3463]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 19:08:28 volumio sudo[3463]: pam_unix(sudo:session): session closed for user root Oct 07 19:08:28 volumio volumio[901]: verbose: New Socket.io Connection to 192.168.1.93 from 192.168.1.231 UA: Mozilla/5.0 (Linux; Android 9; SM-J730F Build/PPR1.180610.011; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/128.0.6613.127 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 07 19:08:29 volumio volumio[901]: info: CoreCommandRouter::volumioGetVisibleSources Oct 07 19:08:29 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 07 19:08:29 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 07 19:08:29 volumio volumio[901]: info: CoreCommandRouter::volumioGetState Oct 07 19:08:29 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:08:29 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 07 19:08:29 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 07 19:08:29 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 07 19:08:29 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 07 19:08:29 volumio sudo[3467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 07 19:08:29 volumio sudo[3467]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 19:08:29 volumio sudo[3467]: pam_unix(sudo:session): session closed for user root Oct 07 19:08:29 volumio sudo[3470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 07 19:08:29 volumio sudo[3470]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 19:08:29 volumio sudo[3470]: pam_unix(sudo:session): session closed for user root Oct 07 19:08:29 volumio volumio[901]: verbose: New Socket.io Connection to 192.168.1.93 from 192.168.1.231 UA: Mozilla/5.0 (Linux; Android 9; SM-J730F Build/PPR1.180610.011; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/128.0.6613.127 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 07 19:08:30 volumio volumio[901]: info: CoreCommandRouter::volumioGetState Oct 07 19:08:30 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:08:30 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 07 19:08:30 volumio volumio[901]: info: Listing playlists Oct 07 19:08:30 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 07 19:08:30 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 07 19:08:30 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 07 19:08:30 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 07 19:08:32 volumio volumio[901]: info: CoreCommandRouter::volumioPlay Oct 07 19:08:32 volumio volumio[901]: info: CoreStateMachine::play index undefined Oct 07 19:08:32 volumio volumio[901]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 07 19:08:32 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:08:32 volumio volumio[901]: info: CoreStateMachine::startPlaybackTimer Oct 07 19:08:32 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:08:32 volumio volumio[901]: info: [1728320912369] ControllerWebradio::clearAddPlayTrack Oct 07 19:08:32 volumio volumio[901]: verbose: ControllerMpd::sendMpdCommand stop Oct 07 19:08:32 volumio volumio[901]: error: MPD error: Error: This socket has been ended by the other party Oct 07 19:08:32 volumio volumio[901]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 07 19:08:32 volumio volumio[901]: error: MPD error: Error: This socket has been ended by the other party Oct 07 19:08:32 volumio volumio[901]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 07 19:08:32 volumio volumio[901]: error: MPD error: Error: This socket has been ended by the other party Oct 07 19:08:32 volumio volumio[901]: error: This socket has been ended by the other party {"code":"EPIPE"} Oct 07 19:08:36 volumio volumio[901]: info: CoreCommandRouter::volumioGetQueue Oct 07 19:08:36 volumio volumio[901]: info: CoreStateMachine::getQueue Oct 07 19:08:36 volumio volumio[901]: info: CorePlayQueue::getQueue Oct 07 19:08:41 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 19:08:41 volumio volumio[901]: info: Received Get System Info Oct 07 19:08:41 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 19:08:41 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 19:08:41 volumio volumio[901]: info: Discovery: Getting this device information Oct 07 19:08:41 volumio volumio[901]: info: CoreCommandRouter::volumioGetState Oct 07 19:08:41 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:08:41 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 19:08:41 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 19:08:43 volumio volumio[901]: info: CoreCommandRouter::Close All Modals sent Oct 07 19:08:46 volumio volumio[901]: info: Enabling plugin rotaryencoder Oct 07 19:08:46 volumio volumio[901]: info: Loading plugin "rotaryencoder"... Oct 07 19:08:46 volumio volumio[901]: error: !!!! WARNING !!!! Oct 07 19:08:46 volumio volumio[901]: error: The plugin user_interface/rotaryencoder failed to load, setting it to stopped. Error: Error: Cannot find module 'kew' Oct 07 19:08:46 volumio volumio[901]: Require stack: Oct 07 19:08:46 volumio volumio[901]: - /data/plugins/user_interface/rotaryencoder/index.js Oct 07 19:08:46 volumio volumio[901]: - /volumio/app/pluginmanager.js Oct 07 19:08:46 volumio volumio[901]: - /volumio/app/index.js Oct 07 19:08:46 volumio volumio[901]: - /volumio/index.js Oct 07 19:08:46 volumio volumio[901]: error: Stack trace: Error: Cannot find module 'kew' Oct 07 19:08:46 volumio volumio[901]: Require stack: Oct 07 19:08:46 volumio volumio[901]: - /data/plugins/user_interface/rotaryencoder/index.js Oct 07 19:08:46 volumio volumio[901]: - /volumio/app/pluginmanager.js Oct 07 19:08:46 volumio volumio[901]: - /volumio/app/index.js Oct 07 19:08:46 volumio volumio[901]: - /volumio/index.js Oct 07 19:08:46 volumio volumio[901]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:880:15) Oct 07 19:08:46 volumio volumio[901]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) Oct 07 19:08:46 volumio volumio[901]: at Module.require (internal/modules/cjs/loader.js:952:19) Oct 07 19:08:46 volumio volumio[901]: at require (internal/modules/cjs/helpers.js:88:18) Oct 07 19:08:46 volumio volumio[901]: at Object. (/data/plugins/user_interface/rotaryencoder/index.js:3:12) Oct 07 19:08:46 volumio volumio[901]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Oct 07 19:08:46 volumio volumio[901]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Oct 07 19:08:46 volumio volumio[901]: at Module.load (internal/modules/cjs/loader.js:928:32) Oct 07 19:08:46 volumio volumio[901]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Oct 07 19:08:46 volumio volumio[901]: at Module.require (internal/modules/cjs/loader.js:952:19) Oct 07 19:08:46 volumio volumio[901]: at require (internal/modules/cjs/helpers.js:88:18) Oct 07 19:08:46 volumio volumio[901]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Oct 07 19:08:46 volumio volumio[901]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 07 19:08:46 volumio volumio[901]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 07 19:08:46 volumio volumio[901]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 07 19:08:46 volumio volumio[901]: error: !!!! WARNING !!!! Oct 07 19:08:46 volumio volumio[901]: info: Done. Oct 07 19:08:47 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 07 19:08:47 volumio volumio[901]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 07 19:08:47 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 07 19:08:47 volumio volumio[901]: error: Failed callmethod call: TypeError: Cannot read property 'broadcastMessage' of null Oct 07 19:08:47 volumio volumio[901]: info: Received Get System Version Oct 07 19:08:47 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 07 19:08:47 volumio volumio[901]: info: Received Get System Info Oct 07 19:08:47 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 19:08:47 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 19:08:47 volumio volumio[901]: info: Discovery: Getting this device information Oct 07 19:08:47 volumio volumio[901]: info: CoreCommandRouter::volumioGetState Oct 07 19:08:47 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:08:47 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 19:08:50 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 07 19:08:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 19:08:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 19:08:53 volumio volumio[901]: info: Discovery: Getting this device information Oct 07 19:08:53 volumio volumio[901]: info: CoreCommandRouter::volumioGetState Oct 07 19:08:53 volumio volumio[901]: info: CorePlayQueue::getTrack 0 Oct 07 19:08:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 19:08:54 volumio volumio[901]: 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: 8 Oct 07 19:08:54 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 19:08:55 volumio volumio[901]: 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 Oct 07 19:08:55 volumio volumio[901]: info: Downloading plugin at http://127.0.0.1:3000/plugin-serve/youtube2.zip Oct 07 19:08:55 volumio volumio[901]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 07 19:08:55 volumio volumio[901]: TypeError: Cannot read property 'broadcastMessage' of null Oct 07 19:08:55 volumio volumio[901]: at /volumio/app/index.js:1515:32 Oct 07 19:08:55 volumio volumio[901]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Oct 07 19:08:55 volumio volumio[901]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Oct 07 19:08:55 volumio volumio[901]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1513:13) Oct 07 19:08:55 volumio volumio[901]: at PluginManager.pushMessage (/volumio/app/pluginmanager.js:1594:20) Oct 07 19:08:55 volumio volumio[901]: at PluginManager.installPlugin (/volumio/app/pluginmanager.js:776:8) Oct 07 19:08:55 volumio volumio[901]: at CoreCommandRouter.installPlugin (/volumio/app/index.js:1434:22) Oct 07 19:08:55 volumio volumio[901]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1195:47) Oct 07 19:08:55 volumio volumio[901]: at Socket.emit (events.js:315:20) Oct 07 19:08:55 volumio volumio[901]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 07 19:08:55 volumio volumio[901]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 07 19:08:55 volumio volumio[901]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 07 19:08:56 volumio sudo[3544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-07 19:07 Oct 07 19:08:56 volumio sudo[3544]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"