-- Logs begin at Wed 2024-04-17 15:00:52 UTC, end at Wed 2024-04-17 15:53:43 UTC. -- Apr 17 15:52:02 volumiooffice volumio[598]: verbose: New Socket.io Connection to 192.168.88.187 from 192.168.88.44 UA: okhttp/4.9.2 Total Clients: 3 Apr 17 15:52:04 volumiooffice volumio[598]: verbose: New Socket.io Connection to 192.168.88.187 from 192.168.88.44 UA: okhttp/4.9.2 Total Clients: 4 Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::volumioGetVisibleSources Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::volumioGetState Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 17 15:52:04 volumiooffice volumio[598]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 17 15:52:04 volumiooffice volumio[598]: info: Received Get System Info Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 17 15:52:04 volumiooffice volumio[598]: info: Discovery: Getting this device information Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::volumioGetState Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::volumioGetState Apr 17 15:52:04 volumiooffice volumio[598]: info: Listing playlists Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::volumioGetQueue Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreStateMachine::getQueue Apr 17 15:52:04 volumiooffice volumio[598]: info: CorePlayQueue::getQueue Apr 17 15:52:04 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 17 15:52:06 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 17 15:52:06 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 17 15:52:06 volumiooffice volumio[598]: info: Discovery: Getting this device information Apr 17 15:52:06 volumiooffice volumio[598]: info: CoreCommandRouter::volumioGetState Apr 17 15:52:06 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 17 15:52:06 volumiooffice volumio[598]: verbose: New Socket.io Connection to 192.168.88.187 from 192.168.88.44 UA: okhttp/4.9.2 Total Clients: 5 Apr 17 15:52:06 volumiooffice volumio[598]: info: CoreCommandRouter::volumioGetState Apr 17 15:52:06 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 17 15:52:06 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 17 15:52:10 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 17 15:52:10 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 17 15:52:18 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 17 15:52:23 volumiooffice volumio[598]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/mpd_oled/1.0.18/volumio/buster/armhf Apr 17 15:52:26 volumiooffice volumio[598]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/mpd_oled/1.0.18/volumio/buster/armhf Apr 17 15:52:26 volumiooffice volumio[598]: info: Folder /tmp/plugins removed Apr 17 15:52:26 volumiooffice volumio[598]: info: Check plugin dependencies Apr 17 15:52:26 volumiooffice volumio[598]: warn: Plugin mpd_oled has native modules version miss match! Current 14 != plugin 8 effected modules: {"0":"/data/temp/downloaded_plugin/node_modules/sleep/build/Release/node_sleep.node"} Apr 17 15:52:26 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 17 15:52:26 volumiooffice volumio[598]: info: An error occurred installing the plugin. Rolling back config Apr 17 15:52:26 volumiooffice volumio[598]: info: Plugin folders cleanup Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning into folder /volumio/app/plugins/ Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning category audio_interface Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning category miscellanea Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning category music_service Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning category plugins.json Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning category system_controller Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning category user_interface Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning into folder /data/plugins/ Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning category music_service Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning category system_hardware Apr 17 15:52:26 volumiooffice volumio[598]: info: Scanning category user_interface Apr 17 15:52:26 volumiooffice volumio[598]: info: Plugin folders cleanup completed Apr 17 15:52:26 volumiooffice volumio[598]: info: Error: Error Apr 17 15:52:26 volumiooffice volumio[598]: info: Folder /tmp/plugins removed Apr 17 15:52:26 volumiooffice volumio[598]: info: Folder /tmp/downloaded_plugin.zip removed Apr 17 15:52:26 volumiooffice volumio[598]: info: Folder /tmp/downloaded_plugin.zip removed Apr 17 15:52:26 volumiooffice volumio[598]: info: Folder /data/temp removed Apr 17 15:52:40 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 17 15:52:43 volumiooffice volumio[598]: info: Tunnel connection is inactive, restarting it Apr 17 15:52:43 volumiooffice volumio[598]: info: Starting Tunnel 1 Apr 17 15:52:43 volumiooffice volumio[598]: info: Starting Tunnel Connection Checker Apr 17 15:52:44 volumiooffice sudo[5091]: volumio : unable to resolve host volumiooffice Apr 17 15:52:44 volumiooffice sudo[5091]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 17 15:52:44 volumiooffice sudo[5091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 17 15:52:44 volumiooffice volumiossh-tunnel[4910]: connect_to localhost: unknown host (Device or resource busy) Apr 17 15:52:44 volumiooffice sudo[5091]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 15:52:44 volumiooffice autossh[4913]: received signal to exit (15) Apr 17 15:52:44 volumiooffice systemd[1]: Stopping MyVolumio SSH Tunnel... Apr 17 15:52:44 volumiooffice systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Apr 17 15:52:44 volumiooffice systemd[1]: sshtunnel.service: Succeeded. Apr 17 15:52:44 volumiooffice systemd[1]: Stopped MyVolumio SSH Tunnel. Apr 17 15:52:44 volumiooffice volumio[598]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 17 15:52:44 volumiooffice volumio[598]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 17 15:52:44 volumiooffice systemd[1]: Started MyVolumio SSH Tunnel. Apr 17 15:52:44 volumiooffice sudo[5091]: pam_unix(sudo:session): session closed for user root Apr 17 15:52:44 volumiooffice volumio[598]: info: Remote SSH Started Apr 17 15:52:44 volumiooffice autossh[5095]: port set to 0, monitoring disabled Apr 17 15:52:44 volumiooffice autossh[5095]: starting ssh (count 1) Apr 17 15:52:44 volumiooffice autossh[5095]: ssh child pid is 5098 Apr 17 15:52:44 volumiooffice volumiossh-tunnel[5093]: Warning: Permanently added '[eu5.myvolumio.org]:2222,[185.14.184.111]:2222' (RSA) to the list of known hosts. Apr 17 15:52:47 volumiooffice volumio[598]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/mpd_oled/1.1.1/volumio/buster/armhf Apr 17 15:52:49 volumiooffice volumio[598]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/mpd_oled/1.1.1/volumio/buster/armhf Apr 17 15:52:49 volumiooffice volumio[598]: info: Folder /tmp/plugins removed Apr 17 15:52:50 volumiooffice volumio[598]: info: Check plugin dependencies Apr 17 15:52:50 volumiooffice volumio[598]: warn: Plugin mpd_oled has native modules version miss match! Current 14 != plugin 8 effected modules: {"0":"/data/temp/downloaded_plugin/node_modules/sleep/build/Release/node_sleep.node"} Apr 17 15:52:50 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 17 15:52:50 volumiooffice volumio[598]: info: An error occurred installing the plugin. Rolling back config Apr 17 15:52:50 volumiooffice volumio[598]: info: Plugin folders cleanup Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning into folder /volumio/app/plugins/ Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning category audio_interface Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning category miscellanea Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning category music_service Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning category plugins.json Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning category system_controller Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning category user_interface Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning into folder /data/plugins/ Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning category music_service Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning category system_hardware Apr 17 15:52:50 volumiooffice volumio[598]: info: Scanning category user_interface Apr 17 15:52:50 volumiooffice volumio[598]: info: Plugin folders cleanup completed Apr 17 15:52:50 volumiooffice volumio[598]: info: Error: Error Apr 17 15:52:50 volumiooffice volumio[598]: info: Folder /tmp/plugins removed Apr 17 15:52:50 volumiooffice volumio[598]: info: Folder /tmp/downloaded_plugin.zip removed Apr 17 15:52:50 volumiooffice volumio[598]: info: Folder /tmp/downloaded_plugin.zip removed Apr 17 15:52:50 volumiooffice volumio[598]: info: Folder /data/temp removed Apr 17 15:53:10 volumiooffice volumio[598]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 15:53:10 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 17 15:53:10 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 17 15:53:10 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 17 15:53:11 volumiooffice volumio[598]: info: Received Get System Version Apr 17 15:53:11 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 17 15:53:11 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 17 15:53:11 volumiooffice volumio[598]: info: Received Get System Info Apr 17 15:53:11 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 17 15:53:11 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 17 15:53:11 volumiooffice volumio[598]: info: Discovery: Getting this device information Apr 17 15:53:11 volumiooffice volumio[598]: info: CoreCommandRouter::volumioGetState Apr 17 15:53:11 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 17 15:53:15 volumiooffice volumio-remote-updater[419]: No test mode Apr 17 15:53:15 volumiooffice volumio-remote-updater[419]: No alpha test mode Apr 17 15:53:15 volumiooffice volumio[598]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 17 15:53:15 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 17 15:53:17 volumiooffice volumio[598]: info: CoreCommandRouter::Close All Modals sent Apr 17 15:53:34 volumiooffice volumio[598]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object] Apr 17 15:53:34 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI Apr 17 15:53:36 volumiooffice volumio[598]: info: CoreCommandRouter::Reload Ui Apr 17 15:53:38 volumiooffice sudo[5180]: volumio : unable to resolve host volumiooffice Apr 17 15:53:38 volumiooffice sudo[5180]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 17 15:53:38 volumiooffice sudo[5180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 17 15:53:38 volumiooffice sudo[5180]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 15:53:38 volumiooffice sudo[5182]: volumio : unable to resolve host volumiooffice Apr 17 15:53:38 volumiooffice sudo[5182]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 17 15:53:38 volumiooffice sudo[5180]: pam_unix(sudo:session): session closed for user root Apr 17 15:53:38 volumiooffice sudo[5182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 17 15:53:38 volumiooffice sudo[5182]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 15:53:38 volumiooffice sudo[5182]: pam_unix(sudo:session): session closed for user root Apr 17 15:53:38 volumiooffice volumio[598]: verbose: New Socket.io Connection to 192.168.88.187 from 192.168.88.44 UA: okhttp/4.9.2 Total Clients: 5 Apr 17 15:53:38 volumiooffice volumio[598]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 15:53:38 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 17 15:53:38 volumiooffice volumio[598]: info: CoreCommandRouter::volumioGetState Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 17 15:53:39 volumiooffice volumio[598]: info: Received Get System Version Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Apr 17 15:53:39 volumiooffice volumio[598]: xcb_connection_has_error() returned true Apr 17 15:53:39 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Apr 17 15:53:40 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 17 15:53:41 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 17 15:53:41 volumiooffice volumio[598]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Apr 17 15:53:41 volumiooffice volumio[598]: info: Loading i18n strings for locale en Apr 17 15:53:42 volumiooffice volumio[598]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 17 15:53:42 volumiooffice volumio[598]: TypeError: Cannot read property 'logger' of null Apr 17 15:53:42 volumiooffice volumio[598]: at NowPlayingContext.getLogger (/data/plugins/user_interface/now_playing/dist/lib/NowPlayingContext.js:70:83) Apr 17 15:53:42 volumiooffice volumio[598]: at ControllerNowPlaying._ControllerNowPlaying_onVolumioLanguageChanged (/data/plugins/user_interface/now_playing/dist/index.js:1834:33) Apr 17 15:53:42 volumiooffice volumio[598]: at /volumio/node_modules/v-conf/index.js:165:13 Apr 17 15:53:42 volumiooffice volumio[598]: at /volumio/node_modules/multimap/index.js:150:9 Apr 17 15:53:42 volumiooffice volumio[598]: at Array.forEach () Apr 17 15:53:42 volumiooffice volumio[598]: at /volumio/node_modules/multimap/index.js:149:13 Apr 17 15:53:42 volumiooffice volumio[598]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) Apr 17 15:53:42 volumiooffice volumio[598]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5) Apr 17 15:53:42 volumiooffice volumio[598]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10) Apr 17 15:53:42 volumiooffice volumio[598]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20) Apr 17 15:53:42 volumiooffice volumio[598]: at volumioAppearance.setLanguage (/volumio/app/plugins/miscellanea/appearance/index.js:325:35) Apr 17 15:53:42 volumiooffice volumio[598]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) Apr 17 15:53:42 volumiooffice volumio[598]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1605:37) Apr 17 15:53:42 volumiooffice volumio[598]: at Socket.emit (events.js:315:20) Apr 17 15:53:42 volumiooffice volumio[598]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 17 15:53:42 volumiooffice volumio[598]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 17 15:53:42 volumiooffice volumio[598]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 17 15:53:43 volumiooffice sudo[5214]: volumio : unable to resolve host volumiooffice Apr 17 15:53:43 volumiooffice sudo[5214]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 17 15:53:43 volumiooffice sudo[5214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-17 15:52 Apr 17 15:53:43 volumiooffice sudo[5214]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"