-- Logs begin at Sun 2024-11-24 16:17:31 CET, end at Sun 2024-11-24 16:20:45 CET. -- Nov 24 16:19:00 volumio volumio[876]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 24 16:19:01 volumio sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 24 16:19:01 volumio sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:01 volumio sudo[1260]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:01 volumio sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 24 16:19:01 volumio sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:01 volumio sudo[1262]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:01 volumio sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 24 16:19:01 volumio sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:01 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Nov 24 16:19:01 volumio sudo[1265]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:01 volumio volumio[876]: info: Upmpdcli Daemon Started Nov 24 16:19:02 volumio volumio[1269]: Generating RSA private key, 4096 bit long modulus (2 primes) Nov 24 16:19:03 volumio volumio[876]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Nov 24 16:19:06 volumio systemd[1]: systemd-fsckd.service: Succeeded. Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 24 16:19:07 volumio volumio[876]: info: Adding plugin bluetooth to MyMusic Plugins Nov 24 16:19:07 volumio volumio[876]: info: Adding plugin multiroom to MyMusic Plugins Nov 24 16:19:07 volumio volumio[876]: info: Adding plugin metavolumio to MyMusic Plugins Nov 24 16:19:07 volumio volumio[876]: info: Adding plugin cd_controller to MyMusic Plugins Nov 24 16:19:07 volumio volumio[876]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 24 16:19:07 volumio volumio[876]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 24 16:19:07 volumio volumio[876]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 24 16:19:08 volumio volumio[1269]: ............................................++++ Nov 24 16:19:08 volumio volumio[876]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 24 16:19:08 volumio volumio[876]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 24 16:19:08 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 16:19:08 volumio volumio[876]: info: Starting MyVolumio Remote Streaming Endpoints Nov 24 16:19:08 volumio volumio[876]: info: MyVolumio login type: Token Nov 24 16:19:09 volumio volumio[876]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 24 16:19:09 volumio volumio[876]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 24 16:19:10 volumio volumio[876]: info: Starting Streaming Service Transparent Proxy Nov 24 16:19:10 volumio volumio[876]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 24 16:19:10 volumio volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 24 16:19:10 volumio volumio[876]: info: Streaming services startup Nov 24 16:19:10 volumio volumio[876]: info: Starting Streaming Daemon Nov 24 16:19:11 volumio volumio[876]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 24 16:19:11 volumio sudo[1412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 24 16:19:11 volumio sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:11 volumio sudo[1412]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:11 volumio volumio[876]: error: MyVolumio Custom Token format not valid, refreshing it Nov 24 16:19:11 volumio volumio[876]: error: Cannot start Volumio Streaming Daemon Nov 24 16:19:11 volumio volumio[876]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 24 16:19:11 volumio volumio[876]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 24 16:19:12 volumio volumio[876]: info: MyVolumio login type: Token Nov 24 16:19:12 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Nov 24 16:19:12 volumio volumio[876]: STREAMING PROXY: Starting server on port 3245 Nov 24 16:19:12 volumio volumio[876]: Node JS runtime: 14 Nov 24 16:19:12 volumio volumio[876]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 24 16:19:13 volumio volumio[876]: info: MyVolumio token set successfully Nov 24 16:19:13 volumio volumio[876]: info: MYVOLUMIO: Adding device Nov 24 16:19:13 volumio volumio[876]: info: MYVOLUMIO: Evaluating Server Nov 24 16:19:14 volumio volumio[876]: info: MyVolumio Plan changed: virtuoso Nov 24 16:19:14 volumio volumio[876]: info: [MyVolumio PluginManager] Subscribed plan changed to virtuoso Nov 24 16:19:14 volumio volumio[876]: info: Removing browser output: myVolumio user plan is not superstar Nov 24 16:19:14 volumio volumio[876]: info: Removing audio output: Nov 24 16:19:14 volumio volumio[876]: info: MYVOLUMIO: Adding device Nov 24 16:19:14 volumio volumio[876]: info: MYVOLUMIO: Evaluating Server Nov 24 16:19:14 volumio volumio[876]: info: Remote config written successfully Nov 24 16:19:14 volumio volumio[876]: info: Starting Tunnel 1 Nov 24 16:19:14 volumio volumio[876]: info: Starting Tunnel Connection Checker Nov 24 16:19:14 volumio volumio[876]: info: Completed starting MyVolumio Plugin Nov 24 16:19:14 volumio volumio[876]: info: MYVolumio Device enabled Nov 24 16:19:14 volumio volumio[876]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Nov 24 16:19:14 volumio volumio[876]: info: MyVolumio status changed Nov 24 16:19:14 volumio volumio[876]: info: Streaming services startup Nov 24 16:19:14 volumio volumio[876]: info: Starting Streaming Daemon Nov 24 16:19:14 volumio volumio[876]: info: Setting Geolocation for MyVolumio to eu3 Nov 24 16:19:14 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 16:19:14 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Nov 24 16:19:14 volumio sudo[1481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 24 16:19:14 volumio volumio[876]: error: [MyVolumio PluginManager] Cache data is invalid! Nov 24 16:19:14 volumio sudo[1481]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:14 volumio sudo[1481]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:14 volumio volumio[876]: error: Cannot start Volumio Streaming Daemon Nov 24 16:19:14 volumio volumio[876]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 24 16:19:14 volumio volumio[876]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 24 16:19:14 volumio volumio[876]: info: Setting Geolocation for MyVolumio to eu3 Nov 24 16:19:14 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 16:19:14 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 16:19:14 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 16:19:14 volumio volumio[876]: info: Successfully Added MyVolumio device Nov 24 16:19:15 volumio volumio[876]: info: Successfully Added MyVolumio device Nov 24 16:19:15 volumio volumio[876]: info: Updating MyVolumio device info Nov 24 16:19:15 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 16:19:15 volumio volumio[876]: info: Updating MyVolumio device info Nov 24 16:19:15 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 16:19:15 volumio volumio[876]: info: Successfully Updated MyVolumio device Nov 24 16:19:15 volumio volumio[876]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Nov 24 16:19:16 volumio volumio[876]: info: [1732461556269] Starting BluetoothController Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Plugin bluetooth disabled by user. Not starting Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Nov 24 16:19:16 volumio volumio[876]: info: Preparing CD Folders Nov 24 16:19:16 volumio volumio[876]: info: Adding CD REST API Endpoints Nov 24 16:19:16 volumio volumio[876]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Nov 24 16:19:16 volumio volumio[876]: info: Starting UDEV Watcher for CD Nov 24 16:19:16 volumio volumio[876]: info: Detecting CD presence with UDEV Nov 24 16:19:16 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Nov 24 16:19:16 volumio volumio[876]: info: Refreshing QOBUZ token Nov 24 16:19:16 volumio volumio[876]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Nov 24 16:19:16 volumio volumio[876]: info: Stopping AccessToken refresher cron Nov 24 16:19:16 volumio sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 24 16:19:16 volumio sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:16 volumio volumio[876]: info: AccessToken refresher cron started Nov 24 16:19:16 volumio volumio[876]: info: Adding TIDAL REST API Endpoints Nov 24 16:19:16 volumio volumio[876]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Nov 24 16:19:16 volumio sudo[1484]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:16 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Nov 24 16:19:16 volumio volumio[876]: info: Successfully Updated MyVolumio device Nov 24 16:19:16 volumio volumio[876]: info: Access Token successfully retrieved Nov 24 16:19:16 volumio volumio[876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 24 16:19:16 volumio volumio[876]: info: [1732461556914] CoreMusicLibrary::Adding element QOBUZ Nov 24 16:19:16 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 16:19:16 volumio volumio[876]: Cannot find translation for source QOBUZ Nov 24 16:19:16 volumio volumio[876]: info: Stopping AccessToken refresher cron for QOBUZ Nov 24 16:19:16 volumio volumio[876]: info: AccessToken refresher cron started for QOBUZ Nov 24 16:19:16 volumio volumio[876]: info: Adding QOBUZ REST API Endpoints Nov 24 16:19:16 volumio volumio[876]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Nov 24 16:19:17 volumio volumio[876]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 24 16:19:18 volumio volumio[876]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 24 16:19:19 volumio sudo[1495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Nov 24 16:19:19 volumio sudo[1495]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:19 volumio systemd[1]: Started MyVolumio SSH Tunnel. Nov 24 16:19:19 volumio sudo[1495]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:19 volumio volumio[876]: info: Remote SSH Started Nov 24 16:19:19 volumio autossh[1498]: port set to 0, monitoring disabled Nov 24 16:19:19 volumio autossh[1498]: starting ssh (count 1) Nov 24 16:19:19 volumio autossh[1498]: ssh child pid is 1501 Nov 24 16:19:19 volumio volumiossh-tunnel[1497]: Warning: Permanently added '[eu3.myvolumio.org]:2222,[167.71.136.233]:2222' (RSA) to the list of known hosts. Nov 24 16:19:19 volumio volumio[876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Nov 24 16:19:19 volumio volumio[876]: info: TidalConnect service stoped! Nov 24 16:19:19 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:19 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:19 volumio volumio[876]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Nov 24 16:19:20 volumio volumio[876]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Nov 24 16:19:20 volumio sudo[1511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Nov 24 16:19:20 volumio sudo[1511]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:20 volumio volumio[1269]: ......................................................................................++++ Nov 24 16:19:20 volumio systemd[1]: Started Volumio Tidal Connect Service. Nov 24 16:19:20 volumio volumio[1269]: e is 65537 (0x010001) Nov 24 16:19:20 volumio sudo[1511]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:20 volumio volumio[1269]: writing RSA key Nov 24 16:19:21 volumio systemd[1]: systemd-timedated.service: Succeeded. Nov 24 16:19:21 volumio volumio[876]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Nov 24 16:19:21 volumio volumio[876]: info: Executing endpoint tc_getconfig Nov 24 16:19:21 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Nov 24 16:19:21 volumio vtcs[1513]: STARTING TidalConnect services, version: 1.4.0.34 Nov 24 16:19:21 volumio vtcs[1513]: STARTED TidalConnect services. Nov 24 16:19:21 volumio volumio[876]: info: Executing endpoint tc_connect Nov 24 16:19:21 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Nov 24 16:19:21 volumio volumio[876]: info: Connecting to TidalConnect Nov 24 16:19:21 volumio volumio[876]: info: CoreCommandRouter::servicePushState Nov 24 16:19:21 volumio volumio[876]: info: CoreStateMachine::pushState Nov 24 16:19:21 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:21 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Nov 24 16:19:21 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:21 volumio volumio[876]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Nov 24 16:19:21 volumio volumio[876]: info: CoreCommandRouter::servicePushState Nov 24 16:19:21 volumio volumio[876]: info: CoreStateMachine::pushState Nov 24 16:19:21 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:21 volumio volumio[876]: info: CoreCommandRouter::volumioPushState Nov 24 16:19:21 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:21 volumio volumio[876]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Nov 24 16:19:23 volumio volumio[876]: info: TidalConnect service started! Nov 24 16:19:23 volumio volumio[876]: [Metrics] CommandRouter: 35s 196.35ms Nov 24 16:19:23 volumio volumio[876]: info: CoreCommandRouter::volumiosetStartupVolume Nov 24 16:19:23 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 16:19:23 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 16:19:23 volumio volumio[876]: info: CoreCommandRouter::Close All Modals sent Nov 24 16:19:23 volumio volumio[876]: info: CoreCommandRouter::Close All Modals sent Nov 24 16:19:23 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 24 16:19:23 volumio volumio[876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Nov 24 16:19:24 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:24 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:24 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 24 16:19:24 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 24 16:19:24 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 24 16:19:24 volumio volumio[876]: info: Version has changed, forcing UI Reload Nov 24 16:19:24 volumio volumio[876]: info: CoreCommandRouter::Reload Ui Nov 24 16:19:25 volumio volumio[876]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetVisibleSources Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:25 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 24 16:19:25 volumio volumio[876]: info: Received Get System Info Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:19:25 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:25 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:25 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:25 volumio volumio[876]: info: Listing playlists Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 24 16:19:25 volumio volumio[876]: info: Received Get System Info Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:19:25 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:25 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetVisibleSources Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:25 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 24 16:19:25 volumio volumio[876]: info: Received Get System Info Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:19:25 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:25 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:25 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:25 volumio volumio[876]: info: Listing playlists Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 24 16:19:25 volumio volumio[876]: info: Received Get System Info Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:19:25 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:25 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:25 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:19:26 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 16:19:26 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 24 16:19:26 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 24 16:19:26 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 24 16:19:26 volumio volumio-remote-updater[605]: No test mode Nov 24 16:19:26 volumio volumio-remote-updater[605]: No alpha test mode Nov 24 16:19:26 volumio volumio[876]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 24 16:19:26 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 24 16:19:27 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 24 16:19:28 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 24 16:19:28 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 16:19:28 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 24 16:19:28 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 24 16:19:28 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 24 16:19:28 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 24 16:19:28 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 24 16:19:28 volumio volumio[876]: info: CoreCommandRouter::volumioGetBrowseSources Nov 24 16:19:28 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 16:19:30 volumio volumio[876]: info: BOOT COMPLETED Nov 24 16:19:36 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 24 16:19:36 volumio volumio[876]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 24 16:19:36 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 24 16:19:36 volumio volumio[876]: info: Received Get System Version Nov 24 16:19:36 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 16:19:36 volumio volumio[876]: info: Received Get System Info Nov 24 16:19:36 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:19:36 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:19:36 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:19:36 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:36 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:36 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:19:41 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:19:41 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:19:41 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:19:41 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:41 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:41 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:19:41 volumio volumio[876]: verbose: New Socket.io Connection to 192.168.1.10:3000 from 192.168.1.33 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Nov 24 16:19:41 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:41 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:41 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 24 16:19:41 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 24 16:19:42 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:19:42 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:19:42 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:19:42 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:42 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:42 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:19:47 volumio sudo[1833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 24 16:19:47 volumio sudo[1833]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:47 volumio sudo[1833]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:47 volumio sudo[1835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 24 16:19:47 volumio sudo[1835]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:47 volumio sudo[1835]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:48 volumio volumio[876]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 13; 2201117TY Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Nov 24 16:19:48 volumio sudo[1842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 24 16:19:48 volumio sudo[1842]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:48 volumio sudo[1842]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:48 volumio sudo[1844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 24 16:19:48 volumio sudo[1844]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:19:48 volumio sudo[1844]: pam_unix(sudo:session): session closed for user root Nov 24 16:19:48 volumio volumio[876]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 13; 2201117TY Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Nov 24 16:19:48 volumio ntpd[827]: Soliciting pool server 212.83.158.83 Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::volumioGetVisibleSources Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:49 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 24 16:19:49 volumio volumio[876]: info: Received Get System Info Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:19:49 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:49 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:49 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:49 volumio volumio[876]: info: Listing playlists Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 24 16:19:49 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 24 16:19:49 volumio ntpd[827]: Soliciting pool server 37.59.63.125 Nov 24 16:19:49 volumio ntpd[827]: Soliciting pool server 195.154.226.102 Nov 24 16:19:50 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 24 16:19:50 volumio volumio[876]: info: Received Get System Info Nov 24 16:19:50 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:19:50 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:19:50 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:19:50 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:50 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:50 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:19:50 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 24 16:19:50 volumio ntpd[827]: Soliciting pool server 51.195.104.188 Nov 24 16:19:50 volumio ntpd[827]: Soliciting pool server 51.210.104.72 Nov 24 16:19:51 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 24 16:19:51 volumio volumio[876]: info: Received Get System Info Nov 24 16:19:51 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:19:51 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:19:51 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:19:51 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:19:51 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:19:51 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:19:51 volumio ntpd[827]: Soliciting pool server 95.179.212.126 Nov 24 16:19:51 volumio ntpd[827]: Soliciting pool server 37.187.102.143 Nov 24 16:19:51 volumio ntpd[827]: Soliciting pool server 151.80.168.4 Nov 24 16:19:52 volumio ntpd[827]: Soliciting pool server 164.132.80.137 Nov 24 16:19:52 volumio ntpd[827]: Soliciting pool server 82.64.42.185 Nov 24 16:19:52 volumio ntpd[827]: Soliciting pool server 195.83.132.135 Nov 24 16:19:53 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 24 16:19:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 24 16:19:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 24 16:19:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 24 16:19:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Nov 24 16:19:53 volumio volumio[876]: info: Received Get System Version Nov 24 16:19:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 16:19:53 volumio ntpd[827]: Soliciting pool server 82.64.81.218 Nov 24 16:19:54 volumio ntpd[827]: Soliciting pool server 82.65.141.217 Nov 24 16:19:55 volumio ntpd[827]: Soliciting pool server 2001:41d0:701:1100::1ecc Nov 24 16:19:57 volumio ntpd[827]: receive: Unexpected origin timestamp 0xeaedc29c.c2fcd49f does not match aorg 0000000000.00000000 from server@95.179.212.126 xmt 0xeaedc29d.22f10906 Nov 24 16:19:57 volumio ntpd[827]: receive: Unexpected origin timestamp 0xeaedc29c.c2f8fcac does not match aorg 0000000000.00000000 from server@164.132.80.137 xmt 0xeaedc29d.22edcc1a Nov 24 16:19:57 volumio ntpd[827]: receive: Unexpected origin timestamp 0xeaedc29c.c2faa102 does not match aorg 0000000000.00000000 from server@151.80.168.4 xmt 0xeaedc29d.232b4333 Nov 24 16:19:57 volumio ntpd[827]: receive: Unexpected origin timestamp 0xeaedc29c.c30339db does not match aorg 0000000000.00000000 from server@37.59.63.125 xmt 0xeaedc29d.23499fe6 Nov 24 16:19:57 volumio ntpd[827]: receive: Unexpected origin timestamp 0xeaedc29c.c2fef8a1 does not match aorg 0000000000.00000000 from server@51.195.104.188 xmt 0xeaedc29d.2389e7fc Nov 24 16:19:57 volumio ntpd[827]: receive: Unexpected origin timestamp 0xeaedc29c.c2ef7ef6 does not match aorg 0000000000.00000000 from server@82.64.81.218 xmt 0xeaedc29d.253fcbb8 Nov 24 16:19:57 volumio ntpd[827]: receive: Unexpected origin timestamp 0xeaedc29c.c2f47d64 does not match aorg 0000000000.00000000 from server@195.83.132.135 xmt 0xeaedc29d.247a1800 Nov 24 16:19:59 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 24 16:19:59 volumio volumio-remote-updater[605]: No test mode Nov 24 16:19:59 volumio volumio-remote-updater[605]: No alpha test mode Nov 24 16:19:59 volumio volumio[876]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 24 16:19:59 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 24 16:20:01 volumio volumio[876]: info: CoreCommandRouter::Close All Modals sent Nov 24 16:20:07 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 24 16:20:07 volumio volumio[876]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 24 16:20:07 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 24 16:20:07 volumio volumio[876]: info: Received Get System Version Nov 24 16:20:07 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 16:20:07 volumio volumio[876]: info: Received Get System Info Nov 24 16:20:07 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:20:07 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:20:07 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:20:07 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:07 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:07 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:20:08 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:20:08 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:20:08 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:20:08 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:08 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:08 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:20:08 volumio volumio[876]: verbose: New Socket.io Connection to 192.168.1.10:3000 from 192.168.1.33 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Nov 24 16:20:08 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:08 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:08 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 24 16:20:08 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 24 16:20:10 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:20:10 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:20:10 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:20:10 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:10 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:10 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:20:12 volumio sudo[1911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 24 16:20:12 volumio sudo[1911]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:20:12 volumio sudo[1911]: pam_unix(sudo:session): session closed for user root Nov 24 16:20:12 volumio sudo[1913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 24 16:20:12 volumio sudo[1913]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:20:12 volumio sudo[1913]: pam_unix(sudo:session): session closed for user root Nov 24 16:20:12 volumio volumio[876]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 13; 2201117TY Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Nov 24 16:20:13 volumio sudo[1917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 24 16:20:13 volumio sudo[1917]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:20:13 volumio sudo[1917]: pam_unix(sudo:session): session closed for user root Nov 24 16:20:13 volumio sudo[1919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 24 16:20:13 volumio sudo[1919]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 24 16:20:13 volumio sudo[1919]: pam_unix(sudo:session): session closed for user root Nov 24 16:20:13 volumio volumio[876]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.33 UA: Mozilla/5.0 (Linux; Android 13; 2201117TY Build/TKQ1.221114.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/130.0.6723.107 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::volumioGetVisibleSources Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:13 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 24 16:20:13 volumio volumio[876]: info: Received Get System Info Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:20:13 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:13 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:13 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:13 volumio volumio[876]: info: Listing playlists Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 24 16:20:13 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 24 16:20:14 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 24 16:20:14 volumio volumio[876]: info: Received Get System Info Nov 24 16:20:14 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:20:14 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:20:14 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:20:14 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:14 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:14 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:20:15 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 24 16:20:15 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 24 16:20:15 volumio volumio[876]: info: Received Get System Info Nov 24 16:20:15 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:20:15 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:20:15 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:20:15 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:15 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:15 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:20:16 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 24 16:20:16 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 24 16:20:17 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 24 16:20:17 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 24 16:20:17 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Nov 24 16:20:17 volumio volumio[876]: info: Received Get System Version Nov 24 16:20:17 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 16:20:21 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 24 16:20:21 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 24 16:20:23 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 24 16:20:31 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 24 16:20:31 volumio volumio[876]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 24 16:20:31 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 24 16:20:31 volumio volumio[876]: info: Received Get System Version Nov 24 16:20:31 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 24 16:20:31 volumio volumio[876]: info: Received Get System Info Nov 24 16:20:31 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:20:31 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:20:31 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:20:31 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:31 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:31 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:20:38 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 24 16:20:38 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 24 16:20:38 volumio volumio[876]: info: Discovery: Getting this device information Nov 24 16:20:38 volumio volumio[876]: info: CoreCommandRouter::volumioGetState Nov 24 16:20:38 volumio volumio[876]: info: CorePlayQueue::getTrack 0 Nov 24 16:20:38 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 24 16:20:44 volumio volumio[876]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Nov 24 16:20:44 volumio volumio[876]: info: PLUGIN onReboot : networkfs Nov 24 16:20:44 volumio volumio[876]: info: PLUGIN onReboot : audiophonicsonoff Nov 24 16:20:44 volumio volumio[876]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 24 16:20:44 volumio volumio[876]: TypeError: Cannot read property 'writeSync' of undefined Nov 24 16:20:44 volumio volumio[876]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Nov 24 16:20:44 volumio volumio[876]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Nov 24 16:20:44 volumio volumio[876]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Nov 24 16:20:44 volumio volumio[876]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Nov 24 16:20:44 volumio volumio[876]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Nov 24 16:20:44 volumio volumio[876]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Nov 24 16:20:44 volumio volumio[876]: at CoreCommandRouter.reboot (/volumio/app/index.js:1345:22) Nov 24 16:20:44 volumio volumio[876]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Nov 24 16:20:44 volumio volumio[876]: at Socket.emit (events.js:315:20) Nov 24 16:20:44 volumio volumio[876]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 24 16:20:44 volumio volumio[876]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Nov 24 16:20:44 volumio volumio[876]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 24 16:20:45 volumio sudo[2037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-24 16:19 Nov 24 16:20:45 volumio sudo[2037]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"