-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2024-04-19 11:39:47 CEST. -- Apr 19 11:38:00 volumiocybou mpd[1010]: Apr 19 11:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 19 11:38:01 volumiocybou systemd[1]: Started Music Player Daemon. Apr 19 11:38:01 volumiocybou sudo[1003]: pam_unix(sudo:session): session closed for user root Apr 19 11:38:01 volumiocybou sudo[993]: pam_unix(sudo:session): session closed for user root Apr 19 11:38:01 volumiocybou volumio[776]: info: Completed starting Core Plugins Apr 19 11:38:01 volumiocybou volumio[776]: info: ------------------------------------------- Apr 19 11:38:01 volumiocybou volumio[776]: info: ----- MyVolumio plugins startup ---- Apr 19 11:38:01 volumiocybou volumio[776]: info: ------------------------------------------- Apr 19 11:38:01 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 19 11:38:01 volumiocybou volumio[776]: error: MPD error: The expression evaluated to a falsy value: Apr 19 11:38:01 volumiocybou volumio[776]: assert.ok(self.idling) Apr 19 11:38:01 volumiocybou volumio[776]: error: The expression evaluated to a falsy value: Apr 19 11:38:01 volumiocybou volumio[776]: assert.ok(self.idling) Apr 19 11:38:01 volumiocybou volumio[776]: info: MPD running with PID1010 Apr 19 11:38:01 volumiocybou volumio[776]: ,establishing connection Apr 19 11:38:01 volumiocybou volumio[776]: error: updateQueue error: null Apr 19 11:38:01 volumiocybou volumio[776]: error: updateQueue error: null Apr 19 11:38:01 volumiocybou volumio[776]: info: go-librespot daemon successfully initialized Apr 19 11:38:04 volumiocybou volumio[776]: info: Initializing connection to go-librespot Websocket Apr 19 11:38:04 volumiocybou go-librespot[1020]: time="2024-04-19T11:38:04+02:00" level=debug msg="new websocket client" Apr 19 11:38:04 volumiocybou volumio[776]: info: Connection to go-librespot Websocket established Apr 19 11:38:06 volumiocybou volumio[776]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 19 11:38:07 volumiocybou volumio[776]: info: Getting Spotify volume Apr 19 11:38:08 volumiocybou volumio[776]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 51 Apr 19 11:38:08 volumiocybou volumio[776]: info: CoreCommandRouter::volumioGetState Apr 19 11:38:08 volumiocybou volumio[776]: info: CorePlayQueue::getTrack 0 Apr 19 11:38:08 volumiocybou volumio[776]: SPOTIFY: RECEIVED VOLUMIO VOLUME 0 Apr 19 11:38:08 volumiocybou volumio[776]: SPOTIFY: SPOTIFY VOLUME undefined Apr 19 11:38:08 volumiocybou volumio[776]: SPOTIFY: VOLUMIO VOLUME 0 Apr 19 11:38:08 volumiocybou volumio[776]: info: Aligning Spotify Volume to Volumio Volume Apr 19 11:38:08 volumiocybou volumio[776]: info: CoreCommandRouter::volumioGetState Apr 19 11:38:08 volumiocybou volumio[776]: info: CorePlayQueue::getTrack 0 Apr 19 11:38:08 volumiocybou volumio[776]: info: Setting Spotify Volume from Volumio: 0 Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 19 11:38:09 volumiocybou volumio[776]: info: Adding plugin bluetooth to MyMusic Plugins Apr 19 11:38:09 volumiocybou volumio[776]: info: Adding plugin multiroom to MyMusic Plugins Apr 19 11:38:09 volumiocybou volumio[776]: info: Adding plugin metavolumio to MyMusic Plugins Apr 19 11:38:09 volumiocybou volumio[776]: info: Adding plugin cd_controller to MyMusic Plugins Apr 19 11:38:09 volumiocybou volumio[776]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 19 11:38:09 volumiocybou volumio[776]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 19 11:38:09 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 19 11:38:10 volumiocybou volumio[776]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 19 11:38:10 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 19 11:38:10 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:10 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:10 volumiocybou volumio[776]: info: Starting MyVolumio Remote Streaming Endpoints Apr 19 11:38:10 volumiocybou volumio[776]: info: MyVolumio login type: Token Apr 19 11:38:10 volumiocybou volumio[776]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 19 11:38:10 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 19 11:38:12 volumiocybou volumio[776]: info: Starting Streaming Service Transparent Proxy Apr 19 11:38:12 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 19 11:38:12 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 19 11:38:12 volumiocybou volumio[776]: info: Streaming services startup Apr 19 11:38:12 volumiocybou volumio[776]: info: Starting Streaming Daemon Apr 19 11:38:12 volumiocybou sudo[1099]: volumio : unable to resolve host volumiocybou Apr 19 11:38:12 volumiocybou sudo[1099]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 19 11:38:12 volumiocybou sudo[1099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 19 11:38:12 volumiocybou sudo[1099]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 11:38:12 volumiocybou volumio[776]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 19 11:38:12 volumiocybou sudo[1099]: pam_unix(sudo:session): session closed for user root Apr 19 11:38:12 volumiocybou volumio[776]: SPOTIFY: SETTING SPOTIFY VOLUME 0 Apr 19 11:38:12 volumiocybou volumio[776]: info: Sending Spotify command with payload to local API: /player/volume Apr 19 11:38:12 volumiocybou volumio[776]: error: Cannot start Volumio Streaming Daemon Apr 19 11:38:12 volumiocybou volumio[776]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 19 11:38:12 volumiocybou volumio[776]: sudo: unable to resolve host volumiocybou: System error Apr 19 11:38:12 volumiocybou volumio[776]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 19 11:38:12 volumiocybou volumio[987]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 19 11:38:13 volumiocybou volumio[776]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 19 11:38:13 volumiocybou volumio[987]: .++++ Apr 19 11:38:13 volumiocybou volumio[776]: info: MyVolumio token set successfully Apr 19 11:38:13 volumiocybou volumio[776]: info: MYVOLUMIO: Adding device Apr 19 11:38:13 volumiocybou volumio[776]: info: MYVOLUMIO: Evaluating Server Apr 19 11:38:13 volumiocybou volumio[776]: STREAMING PROXY: Starting server on port 3245 Apr 19 11:38:13 volumiocybou volumio[776]: Node JS runtime: 14 Apr 19 11:38:13 volumiocybou volumio[776]: info: MyVolumio status changed Apr 19 11:38:13 volumiocybou volumio[776]: info: Streaming services startup Apr 19 11:38:13 volumiocybou volumio[776]: info: Starting Streaming Daemon Apr 19 11:38:13 volumiocybou volumio[776]: info: Removing browser output: myVolumio user plan is not superstar Apr 19 11:38:13 volumiocybou volumio[776]: info: Removing audio output: Apr 19 11:38:13 volumiocybou volumio[776]: info: Stoppping Tunnel 1 Apr 19 11:38:14 volumiocybou sudo[1139]: volumio : unable to resolve host volumiocybou Apr 19 11:38:14 volumiocybou sudo[1139]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 19 11:38:14 volumiocybou sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 19 11:38:14 volumiocybou sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 11:38:14 volumiocybou sudo[1141]: volumio : unable to resolve host volumiocybou Apr 19 11:38:14 volumiocybou sudo[1141]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 19 11:38:14 volumiocybou sudo[1139]: pam_unix(sudo:session): session closed for user root Apr 19 11:38:14 volumiocybou volumio[776]: error: Cannot start Volumio Streaming Daemon Apr 19 11:38:14 volumiocybou volumio[776]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 19 11:38:14 volumiocybou volumio[776]: sudo: unable to resolve host volumiocybou: System error Apr 19 11:38:14 volumiocybou volumio[776]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 19 11:38:14 volumiocybou sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 19 11:38:14 volumiocybou sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 11:38:14 volumiocybou sudo[1141]: pam_unix(sudo:session): session closed for user root Apr 19 11:38:14 volumiocybou volumio[776]: info: Remote SSH Stopped Apr 19 11:38:14 volumiocybou volumio[776]: info: Setting Geolocation for MyVolumio to eu4 Apr 19 11:38:14 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:14 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:14 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:14 volumiocybou volumio[776]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 19 11:38:15 volumiocybou volumio[776]: info: Updating MyVolumio device info Apr 19 11:38:15 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:15 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:15 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:15 volumiocybou volumio[776]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 19 11:38:16 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 19 11:38:16 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 19 11:38:17 volumiocybou ntpd[683]: Soliciting pool server 212.83.158.83 Apr 19 11:38:18 volumiocybou volumio[776]: info: MYVOLUMIO: Adding device Apr 19 11:38:18 volumiocybou volumio[776]: info: MYVOLUMIO: Evaluating Server Apr 19 11:38:18 volumiocybou ntpd[683]: Soliciting pool server 162.19.224.29 Apr 19 11:38:18 volumiocybou ntpd[683]: Soliciting pool server 195.154.226.102 Apr 19 11:38:19 volumiocybou volumio[776]: info: Setting Geolocation for MyVolumio to eu4 Apr 19 11:38:19 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:19 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:19 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:19 volumiocybou volumio[776]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 19 11:38:19 volumiocybou ntpd[683]: Soliciting pool server 194.57.169.1 Apr 19 11:38:19 volumiocybou ntpd[683]: Soliciting pool server 95.179.212.126 Apr 19 11:38:20 volumiocybou volumio[776]: info: Updating MyVolumio device info Apr 19 11:38:20 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:20 volumiocybou volumio[776]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 19 11:38:20 volumiocybou ntpd[683]: Soliciting pool server 82.65.248.56 Apr 19 11:38:20 volumiocybou ntpd[683]: Soliciting pool server 92.222.227.225 Apr 19 11:38:20 volumiocybou ntpd[683]: Soliciting pool server 162.159.200.1 Apr 19 11:38:21 volumiocybou ntpd[683]: Soliciting pool server 149.202.2.105 Apr 19 11:38:21 volumiocybou ntpd[683]: Soliciting pool server 37.59.63.125 Apr 19 11:38:21 volumiocybou ntpd[683]: Soliciting pool server 194.177.34.116 Apr 19 11:38:21 volumiocybou volumio[776]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Apr 19 11:38:22 volumiocybou volumio[987]: ................................................................++++ Apr 19 11:38:22 volumiocybou volumio[987]: e is 65537 (0x010001) Apr 19 11:38:22 volumiocybou volumio[987]: writing RSA key Apr 19 11:38:22 volumiocybou ntpd[683]: Soliciting pool server 162.159.200.123 Apr 19 11:38:22 volumiocybou ntpd[683]: Soliciting pool server 5.39.80.51 Apr 19 11:38:23 volumiocybou volumio[776]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/audiophonicsonoff/volumio/buster/armhf Apr 19 11:38:23 volumiocybou volumio[776]: info: Folder /tmp/plugins removed Apr 19 11:38:23 volumiocybou volumio[776]: info: Check plugin dependencies Apr 19 11:38:23 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 11:38:23 volumiocybou ntpd[683]: Soliciting pool server 129.250.35.251 Apr 19 11:38:23 volumiocybou ntpd[683]: Soliciting pool server 82.64.247.11 Apr 19 11:38:23 volumiocybou volumio[776]: info: Checking if plugin already exists Apr 19 11:38:23 volumiocybou volumio[776]: info: Rename folder Apr 19 11:38:23 volumiocybou volumio[776]: info: Folder /tmp/downloaded_plugin.zip removed Apr 19 11:38:23 volumiocybou volumio[776]: info: Move to category Apr 19 11:38:24 volumiocybou volumio[776]: info: Checking if install.sh is present Apr 19 11:38:24 volumiocybou volumio[776]: info: Executing install.sh Apr 19 11:38:24 volumiocybou sudo[1196]: volumio : unable to resolve host volumiocybou Apr 19 11:38:24 volumiocybou sudo[1196]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 19 11:38:24 volumiocybou sudo[1196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_controller/audiophonicsonoff/install.sh Apr 19 11:38:24 volumiocybou sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 11:38:24 volumiocybou volumio[776]: info: Installing Audiophonics on/off and its dependencies... Apr 19 11:38:24 volumiocybou sudo[1196]: pam_unix(sudo:session): session closed for user root Apr 19 11:38:24 volumiocybou volumio[776]: info: Install script completed Apr 19 11:38:24 volumiocybou volumio[776]: info: Adding reference to registry Apr 19 11:38:24 volumiocybou volumio[776]: info: Done installing plugin. Apr 19 11:38:24 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 19 11:38:24 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 19 11:38:24 volumiocybou volumio[776]: info: Folder /tmp/plugins removed Apr 19 11:38:24 volumiocybou volumio[776]: info: Folder /tmp/downloaded_plugin.zip removed Apr 19 11:38:24 volumiocybou volumio[776]: info: No packages needed, only node_modules are required Apr 19 11:38:24 volumiocybou volumio[776]: Plugin install end detected on script Apr 19 11:38:24 volumiocybou volumio[776]: info: Folder /data/temp removed Apr 19 11:38:24 volumiocybou ntpd[683]: Soliciting pool server 5.135.158.34 Apr 19 11:38:24 volumiocybou ntpd[683]: Soliciting pool server 2001:bc8:255e:200::1 Apr 19 11:38:43 volumiocybou ntpd[683]: receive: Unexpected origin timestamp 0xe9ccba10.be5ddcf5 does not match aorg 0000000000.00000000 from server@149.202.2.105 xmt 0xe9ccba23.4ea61575 Apr 19 11:38:43 volumiocybou ntpd[683]: receive: Unexpected origin timestamp 0xe9ccba10.be5c0ff2 does not match aorg 0000000000.00000000 from server@82.64.247.11 xmt 0xe9ccba23.4dbd91f2 Apr 19 11:38:43 volumiocybou ntpd[683]: receive: Unexpected origin timestamp 0xe9ccba10.be57074d does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xe9ccba23.4f7efe21 Apr 19 11:38:43 volumiocybou ntpd[683]: receive: Unexpected origin timestamp 0xe9ccba10.be61bcec does not match aorg 0000000000.00000000 from server@194.57.169.1 xmt 0xe9ccba23.4f2d67c3 Apr 19 11:38:43 volumiocybou volumio[776]: info: Enabling plugin audiophonicsonoff Apr 19 11:38:43 volumiocybou volumio[776]: info: Loading plugin "audiophonicsonoff"... Apr 19 11:38:44 volumiocybou volumio[776]: info: Audiophonics on/off initiated Apr 19 11:38:44 volumiocybou volumio[776]: info: PLUGIN START: audiophonicsonoff Apr 19 11:38:44 volumiocybou volumio[776]: info: Configuring GPIO pins Apr 19 11:38:44 volumiocybou volumio[776]: info: Error: Error: EBUSY: resource busy or locked, write Apr 19 11:38:44 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 19 11:38:44 volumiocybou volumio[776]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 52 Apr 19 11:38:44 volumiocybou volumio[776]: info: CoreCommandRouter::volumioGetState Apr 19 11:38:44 volumiocybou volumio[776]: info: CorePlayQueue::getTrack 0 Apr 19 11:38:46 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 11:38:46 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:46 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 19 11:38:46 volumiocybou volumio-remote-updater[554]: No test mode Apr 19 11:38:46 volumiocybou volumio-remote-updater[554]: No alpha test mode Apr 19 11:38:46 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 19 11:38:46 volumiocybou volumio[776]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 19 11:38:46 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 19 11:38:47 volumiocybou volumio[776]: info: Enabling plugin audiophonicsonoff Apr 19 11:38:47 volumiocybou volumio[776]: info: Loading plugin "audiophonicsonoff"... Apr 19 11:38:47 volumiocybou volumio[776]: info: Applying required configuration parameters for plugin audiophonicsonoff Apr 19 11:38:47 volumiocybou volumio[776]: info: Audiophonics on/off initiated Apr 19 11:38:47 volumiocybou volumio[776]: info: PLUGIN START: audiophonicsonoff Apr 19 11:38:47 volumiocybou volumio[776]: info: Configuring GPIO pins Apr 19 11:38:47 volumiocybou volumio[776]: info: Error: Error: EBUSY: resource busy or locked, write Apr 19 11:38:49 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 11:38:49 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 11:38:49 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 19 11:38:49 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 19 11:38:49 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 19 11:38:49 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 19 11:38:49 volumiocybou volumio[776]: info: CoreCommandRouter::volumioGetBrowseSources Apr 19 11:38:49 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 11:38:49 volumiocybou volumio[776]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 11:38:49 volumiocybou volumio[776]: info: Loaded the previous config. Apr 19 11:38:49 volumiocybou volumio[776]: info: ## populating UI... Apr 19 11:38:49 volumiocybou volumio[776]: info: 1/1 settings loaded Apr 19 11:38:49 volumiocybou volumio[776]: info: Populated config screen. Apr 19 11:38:51 volumiocybou volumio[776]: error: MyVolumio Plugin failed to authenticate in a timely fashion Apr 19 11:38:51 volumiocybou volumio[776]: info: Completed starting MyVolumio Plugin Apr 19 11:38:51 volumiocybou volumio[776]: info: BOOT COMPLETED Apr 19 11:38:51 volumiocybou volumio[776]: [Metrics] CommandRouter: 72s 102.11ms Apr 19 11:38:51 volumiocybou volumio[776]: info: CoreCommandRouter::volumiosetStartupVolume Apr 19 11:38:51 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 11:38:51 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 19 11:38:51 volumiocybou volumio[776]: info: CoreCommandRouter::Close All Modals sent Apr 19 11:38:51 volumiocybou volumio[776]: info: CoreCommandRouter::Close All Modals sent Apr 19 11:38:51 volumiocybou kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Apr 19 11:38:52 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 19 11:38:52 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 19 11:38:52 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 19 11:38:54 volumiocybou volumio[776]: info: CoreCommandRouter::volumioGetState Apr 19 11:38:54 volumiocybou volumio[776]: info: CorePlayQueue::getTrack 0 Apr 19 11:38:56 volumiocybou volumio[776]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 19 11:38:56 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 19 11:38:56 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 19 11:38:56 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 19 11:38:56 volumiocybou volumio[776]: info: Received Get System Version Apr 19 11:38:56 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 11:38:56 volumiocybou kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Apr 19 11:39:00 volumiocybou volumio[776]: info: CoreCommandRouter::volumioGetState Apr 19 11:39:00 volumiocybou volumio[776]: info: CorePlayQueue::getTrack 0 Apr 19 11:39:03 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 19 11:39:03 volumiocybou volumio[776]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 19 11:39:32 volumiocybou volumio[776]: info: Enabling plugin audiophonicsonoff Apr 19 11:39:32 volumiocybou volumio[776]: info: Loading plugin "audiophonicsonoff"... Apr 19 11:39:32 volumiocybou volumio[776]: info: Applying required configuration parameters for plugin audiophonicsonoff Apr 19 11:39:32 volumiocybou volumio[776]: info: Audiophonics on/off initiated Apr 19 11:39:32 volumiocybou volumio[776]: info: PLUGIN START: audiophonicsonoff Apr 19 11:39:32 volumiocybou volumio[776]: info: Configuring GPIO pins Apr 19 11:39:32 volumiocybou volumio[776]: info: Error: Error: EBUSY: resource busy or locked, write Apr 19 11:39:33 volumiocybou volumio[776]: info: Enabling plugin audiophonicsonoff Apr 19 11:39:33 volumiocybou volumio[776]: info: Loading plugin "audiophonicsonoff"... Apr 19 11:39:33 volumiocybou volumio[776]: info: Applying required configuration parameters for plugin audiophonicsonoff Apr 19 11:39:33 volumiocybou volumio[776]: info: Audiophonics on/off initiated Apr 19 11:39:33 volumiocybou volumio[776]: info: PLUGIN START: audiophonicsonoff Apr 19 11:39:33 volumiocybou volumio[776]: info: Configuring GPIO pins Apr 19 11:39:33 volumiocybou volumio[776]: info: Error: Error: EBUSY: resource busy or locked, write Apr 19 11:39:42 volumiocybou volumio[776]: info: CoreCommandRouter::volumioGetState Apr 19 11:39:42 volumiocybou volumio[776]: info: CorePlayQueue::getTrack 0 Apr 19 11:39:46 volumiocybou volumio[776]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Apr 19 11:39:46 volumiocybou volumio[776]: info: PLUGIN onReboot : networkfs Apr 19 11:39:46 volumiocybou sudo[1261]: volumio : unable to resolve host volumiocybou Apr 19 11:39:46 volumiocybou sudo[1261]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 19 11:39:46 volumiocybou sudo[1261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /mnt/NAS/Music Apr 19 11:39:46 volumiocybou sudo[1261]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 11:39:46 volumiocybou sudo[1261]: pam_unix(sudo:session): session closed for user root Apr 19 11:39:46 volumiocybou systemd[1]: mnt-NAS-Music.mount: Succeeded. Apr 19 11:39:46 volumiocybou volumio[776]: sudo: unable to resolve host volumiocybou: System error Apr 19 11:39:46 volumiocybou volumio[776]: info: PLUGIN onReboot : audiophonicsonoff Apr 19 11:39:46 volumiocybou volumio[776]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 11:39:46 volumiocybou volumio[776]: TypeError: Cannot read property 'writeSync' of undefined Apr 19 11:39:46 volumiocybou volumio[776]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Apr 19 11:39:46 volumiocybou volumio[776]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Apr 19 11:39:46 volumiocybou volumio[776]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Apr 19 11:39:46 volumiocybou volumio[776]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Apr 19 11:39:46 volumiocybou volumio[776]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Apr 19 11:39:46 volumiocybou volumio[776]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Apr 19 11:39:46 volumiocybou volumio[776]: at CoreCommandRouter.reboot (/volumio/app/index.js:1325:22) Apr 19 11:39:46 volumiocybou volumio[776]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:836:33) Apr 19 11:39:46 volumiocybou volumio[776]: at Socket.emit (events.js:315:20) Apr 19 11:39:46 volumiocybou volumio[776]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 19 11:39:46 volumiocybou volumio[776]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 19 11:39:46 volumiocybou volumio[776]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 11:39:47 volumiocybou sudo[1273]: volumio : unable to resolve host volumiocybou Apr 19 11:39:47 volumiocybou sudo[1273]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Apr 19 11:39:47 volumiocybou sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-19 11:38 Apr 19 11:39:47 volumiocybou sudo[1273]: 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"