-- Logs begin at Sat 2024-07-06 09:14:25 CEST, end at Sat 2024-07-06 11:39:38 CEST. -- Jul 06 11:38:04 volumio volumio[831]: info: Starting Uninstall of plugin user_interface - now_playing Jul 06 11:38:04 volumio volumio[831]: info: Uninstalling plugin now_playing Jul 06 11:38:12 volumio volumio[831]: info: Starting Uninstall of plugin user_interface - now_playing Jul 06 11:38:12 volumio volumio[831]: info: Uninstalling plugin now_playing Jul 06 11:38:18 volumio volumio[831]: info: Starting Uninstall of plugin user_interface - Systeminfo Jul 06 11:38:18 volumio volumio[831]: info: Uninstalling plugin Systeminfo Jul 06 11:38:28 volumio wpa_supplicant[16850]: RRM: Ignoring radio measurement request: Not RRM network Jul 06 11:38:29 volumio volumio[831]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 06 11:38:30 volumio wpa_supplicant[16850]: RRM: Ignoring radio measurement request: Not RRM network Jul 06 11:38:35 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jul 06 11:38:35 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:36 volumio volumio[16478]: [Vollibrespot] : couldn't parse packet from 192.168.2.19:5353: query type 65 is invalid Jul 06 11:38:36 volumio volumio[16478]: [Vollibrespot] : couldn't parse packet from 192.168.2.19:5353: query type 65 is invalid Jul 06 11:38:37 volumio volumio[16478]: [Vollibrespot] : couldn't parse packet from 192.168.2.19:5353: query type 65 is invalid Jul 06 11:38:37 volumio volumio[16478]: [Vollibrespot] : couldn't parse packet from 192.168.2.19:5353: query type 65 is invalid Jul 06 11:38:37 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 06 11:38:37 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 06 11:38:44 volumio volumio[831]: info: Starting Uninstall of plugin user_interface - now_playing Jul 06 11:38:44 volumio volumio[831]: info: Uninstalling plugin now_playing Jul 06 11:38:48 volumio volumio[831]: info: CoreCommandRouter::volumioPause Jul 06 11:38:48 volumio volumio[831]: info: CoreStateMachine::pause Jul 06 11:38:48 volumio volumio[831]: info: CoreStateMachine::stPlaybackTimer Jul 06 11:38:48 volumio volumio[831]: info: CoreStateMachine::servicePause Jul 06 11:38:48 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:48 volumio volumio[831]: info: CoreCommandRouter::servicePause Jul 06 11:38:48 volumio volumio[831]: info: ControllerMpd::pause Jul 06 11:38:48 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand pause Jul 06 11:38:48 volumio volumio[831]: info: Jul 06 11:38:48 volumio volumio[831]: ---------------------------- MPD announces state update: player Jul 06 11:38:48 volumio volumio[831]: info: sendMpdCommand pause took 1 milliseconds Jul 06 11:38:48 volumio volumio[831]: info: ControllerMpd::getState Jul 06 11:38:48 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Jul 06 11:38:48 volumio volumio[831]: info: Jul 06 11:38:48 volumio volumio[831]: ---------------------------- MPD announces state update: player Jul 06 11:38:48 volumio volumio[831]: info: ControllerMpd::getState Jul 06 11:38:48 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand status Jul 06 11:38:48 volumio volumio[831]: info: sendMpdCommand status took 1 milliseconds Jul 06 11:38:48 volumio volumio[831]: info: sendMpdCommand status took 1 milliseconds Jul 06 11:38:48 volumio volumio[831]: verbose: ControllerMpd::parseState Jul 06 11:38:48 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 11:38:48 volumio volumio[831]: verbose: ControllerMpd::parseState Jul 06 11:38:48 volumio volumio[831]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 06 11:38:48 volumio volumio[831]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 06 11:38:48 volumio volumio[831]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 06 11:38:48 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Jul 06 11:38:48 volumio volumio[831]: verbose: ControllerMpd::parseTrackInfo Jul 06 11:38:48 volumio volumio[831]: info: ControllerMpd::pushState Jul 06 11:38:48 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jul 06 11:38:48 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:48 volumio volumio[831]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":111264,"duration":427,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1006 Kbps","isStreaming":false,"title":"Vicarious","artist":"Tool","album":"10,000 Days","uri":"USB/496A9A2F25E6A9F9/_HIGH MUSIC/Tool/Tool - 10,000 Days/01 - Tool - Vicarious.flac","trackType":"flac"} Jul 06 11:38:48 volumio volumio[831]: verbose: CURRENT POSITION 0 Jul 06 11:38:48 volumio volumio[831]: info: CoreStateMachine::syncState stateService pause Jul 06 11:38:48 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus pause Jul 06 11:38:48 volumio volumio[831]: info: CoreStateMachine::pushState Jul 06 11:38:48 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:48 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 11:38:48 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jul 06 11:38:48 volumio volumio[831]: info: ControllerMpd::pushState Jul 06 11:38:48 volumio volumio[831]: info: CoreCommandRouter::servicePushState Jul 06 11:38:48 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:48 volumio volumio[831]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":111264,"duration":427,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1006 Kbps","isStreaming":false,"title":"Vicarious","artist":"Tool","album":"10,000 Days","uri":"USB/496A9A2F25E6A9F9/_HIGH MUSIC/Tool/Tool - 10,000 Days/01 - Tool - Vicarious.flac","trackType":"flac"} Jul 06 11:38:48 volumio volumio[831]: verbose: CURRENT POSITION 0 Jul 06 11:38:48 volumio volumio[831]: info: CoreStateMachine::syncState stateService pause Jul 06 11:38:48 volumio volumio[831]: info: CoreStateMachine::syncState currentStatus pause Jul 06 11:38:48 volumio volumio[831]: info: CoreStateMachine::pushState Jul 06 11:38:48 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:48 volumio volumio[831]: info: CoreCommandRouter::volumioPushState Jul 06 11:38:48 volumio volumio[831]: error: ControllerMpd::pushError: TypeError: Cannot read property 'pushState' of null Jul 06 11:38:48 volumio volumio[831]: error: ControllerMpd::pushError: TypeError: Cannot read property 'pushState' of null Jul 06 11:38:48 volumio volumio[831]: info: ------------------------------ 8ms Jul 06 11:38:48 volumio volumio[831]: info: ------------------------------ 7ms Jul 06 11:38:49 volumio volumio[831]: info: CoreCommandRouter::volumioPause Jul 06 11:38:49 volumio volumio[831]: info: CoreStateMachine::pause Jul 06 11:38:51 volumio volumio[831]: info: CoreCommandRouter::volumioPause Jul 06 11:38:51 volumio volumio[831]: info: CoreStateMachine::pause Jul 06 11:38:53 volumio volumio[16478]: [Vollibrespot] : couldn't parse packet from 192.168.2.19:5353: query type 65 is invalid Jul 06 11:38:53 volumio volumio[16478]: [Vollibrespot] : couldn't parse packet from 192.168.2.19:5353: query type 65 is invalid Jul 06 11:38:54 volumio sudo[17750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 06 11:38:54 volumio sudo[17750]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 11:38:54 volumio sudo[17750]: pam_unix(sudo:session): session closed for user root Jul 06 11:38:54 volumio sudo[17753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 06 11:38:54 volumio sudo[17753]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 11:38:54 volumio sudo[17753]: pam_unix(sudo:session): session closed for user root Jul 06 11:38:54 volumio volumio[831]: verbose: New Socket.io Connection to 192.168.2.81 from 192.168.2.19 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7 Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::volumioGetVisibleSources Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jul 06 11:38:54 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 06 11:38:54 volumio volumio[831]: info: Received Get System Info Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 06 11:38:54 volumio volumio[831]: info: Discovery: Getting this device information Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jul 06 11:38:54 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jul 06 11:38:54 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:54 volumio volumio[831]: info: Listing playlists Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 06 11:38:54 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 06 11:38:54 volumio volumio[16478]: [Vollibrespot] : couldn't parse packet from 192.168.2.19:5353: query type 65 is invalid Jul 06 11:38:54 volumio volumio[16478]: [Vollibrespot] : couldn't parse packet from 192.168.2.19:5353: query type 65 is invalid Jul 06 11:38:55 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 06 11:38:56 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 06 11:38:56 volumio volumio[831]: info: Received Get System Info Jul 06 11:38:56 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 06 11:38:56 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 06 11:38:56 volumio volumio[831]: info: Discovery: Getting this device information Jul 06 11:38:56 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jul 06 11:38:56 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:56 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 06 11:38:57 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 06 11:38:57 volumio volumio[831]: info: Received Get System Info Jul 06 11:38:57 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 06 11:38:57 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 06 11:38:57 volumio volumio[831]: info: Discovery: Getting this device information Jul 06 11:38:57 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jul 06 11:38:57 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:38:57 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 06 11:39:02 volumio volumio[831]: info: Starting Uninstall of plugin user_interface - now_playing Jul 06 11:39:02 volumio volumio[831]: info: Uninstalling plugin now_playing Jul 06 11:39:04 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 06 11:39:12 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 06 11:39:12 volumio volumio[831]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 06 11:39:12 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 06 11:39:12 volumio volumio[831]: error: Failed callmethod call: TypeError: Cannot read property 'broadcastMessage' of null Jul 06 11:39:12 volumio volumio[831]: info: Received Get System Version Jul 06 11:39:12 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 06 11:39:12 volumio volumio[831]: info: Received Get System Info Jul 06 11:39:12 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 06 11:39:12 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 06 11:39:12 volumio volumio[831]: info: Discovery: Getting this device information Jul 06 11:39:12 volumio volumio[831]: info: CoreCommandRouter::volumioGetState Jul 06 11:39:12 volumio volumio[831]: info: CorePlayQueue::getTrack 0 Jul 06 11:39:12 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 06 11:39:20 volumio volumio[831]: info: Starting Uninstall of plugin user_interface - Systeminfo Jul 06 11:39:20 volumio volumio[831]: info: Uninstalling plugin Systeminfo Jul 06 11:39:30 volumio volumio[831]: info: Starting Uninstall of plugin user_interface - now_playing Jul 06 11:39:30 volumio volumio[831]: info: Uninstalling plugin now_playing Jul 06 11:39:32 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 06 11:39:33 volumio volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 06 11:39:38 volumio volumio[831]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/now_playing/0.6.0/volumio/buster/armhf Jul 06 11:39:38 volumio volumio[831]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 06 11:39:38 volumio volumio[831]: TypeError: Cannot read property 'broadcastMessage' of null Jul 06 11:39:38 volumio volumio[831]: at /volumio/app/index.js:1515:32 Jul 06 11:39:38 volumio volumio[831]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Jul 06 11:39:38 volumio volumio[831]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Jul 06 11:39:38 volumio volumio[831]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1513:13) Jul 06 11:39:38 volumio volumio[831]: at PluginManager.pushMessage (/volumio/app/pluginmanager.js:1594:20) Jul 06 11:39:38 volumio volumio[831]: at PluginManager.installPlugin (/volumio/app/pluginmanager.js:776:8) Jul 06 11:39:38 volumio volumio[831]: at CoreCommandRouter.installPlugin (/volumio/app/index.js:1434:22) Jul 06 11:39:38 volumio volumio[831]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1188:47) Jul 06 11:39:38 volumio volumio[831]: at Socket.emit (events.js:315:20) Jul 06 11:39:38 volumio volumio[831]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 06 11:39:38 volumio volumio[831]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 06 11:39:38 volumio volumio[831]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 06 11:39:38 volumio sudo[17822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-06 11:38 Jul 06 11:39:38 volumio sudo[17822]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"