-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Thu 2024-04-11 16:22:28 BST. -- Apr 11 16:21:00 boobs sh[439]: timed out Apr 11 16:21:00 boobs dhcpcd[482]: timed out Apr 11 16:21:00 boobs sh[439]: dhcpcd exited Apr 11 16:21:00 boobs dhcpcd[482]: dhcpcd exited Apr 11 16:21:00 boobs sh[439]: ifup: failed to bring up eth0 Apr 11 16:21:00 boobs systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Apr 11 16:21:00 boobs systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Apr 11 16:21:02 boobs systemd[1]: systemd-hostnamed.service: Succeeded. Apr 11 16:21:25 boobs volumio[864]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion Apr 11 16:21:25 boobs volumio[864]: info: Preparing to generate the ALSA configuration file Apr 11 16:21:25 boobs volumio[864]: info: Asound.conf file unchanged, so no further update is needed Apr 11 16:21:25 boobs volumio[864]: info: Output device has changed, restarting MPD Apr 11 16:21:25 boobs sudo[989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 16:21:25 boobs sudo[989]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:25 boobs volumio[864]: info: ___________ START PLUGINS ___________ Apr 11 16:21:25 boobs sudo[989]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:25 boobs volumio[864]: info: ControllerMpd::onStart: Initializing MPD Apr 11 16:21:25 boobs volumio[864]: info: Creating MPD Configuration file Apr 11 16:21:25 boobs sudo[992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 16:21:25 boobs sudo[992]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:25 boobs sudo[995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 16:21:25 boobs sudo[995]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:25 boobs sudo[995]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:25 boobs volumio[864]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:21:25 boobs volumio[864]: info: [1712848885822] CoreMusicLibrary::Adding element Last_100 Apr 11 16:21:25 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:21:25 boobs volumio[864]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:21:25 boobs volumio[864]: info: [1712848885833] CoreMusicLibrary::Adding element Webradio Apr 11 16:21:25 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:21:25 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:21:25 boobs sudo[998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 16:21:25 boobs sudo[998]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:25 boobs volumio[864]: info: [now-playing] ConfigUpdater: config is up to date. Apr 11 16:21:25 boobs volumio[864]: info: Loading i18n strings for locale en Apr 11 16:21:25 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:21:25 boobs volumio[864]: info: Volumio Calling Home Apr 11 16:21:25 boobs systemd[1]: Listening on mpd.socket. Apr 11 16:21:25 boobs systemd[1]: Starting Music Player Daemon... Apr 11 16:21:25 boobs systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 11 16:21:25 boobs systemd[1]: mpd.service: Succeeded. Apr 11 16:21:25 boobs systemd[1]: Stopped Music Player Daemon. Apr 11 16:21:25 boobs systemd[1]: Starting Music Player Daemon... Apr 11 16:21:25 boobs sudo[1007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Apr 11 16:21:25 boobs sudo[1007]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:25 boobs sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Apr 11 16:21:25 boobs sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:25 boobs sudo[1013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 11 16:21:25 boobs sudo[1013]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:26 boobs volumio[864]: info: [now-playing] App is listening on port 4004. Apr 11 16:21:26 boobs volumio[864]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Apr 11 16:21:26 boobs systemd[1]: Reloading. Apr 11 16:21:26 boobs volumio[864]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Apr 11 16:21:26 boobs volumio[864]: info: MPD Permissions set Apr 11 16:21:26 boobs volumio[864]: info: MPD Permissions set Apr 11 16:21:26 boobs volumio[864]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Apr 11 16:21:26 boobs volumio[864]: info: Volumio called home Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:26 boobs volumio[864]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Apr 11 16:21:26 boobs sudo[1037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Apr 11 16:21:26 boobs sudo[1037]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:26 boobs sudo[1037]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:26 boobs volumio[864]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Apr 11 16:21:26 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:26 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:26 boobs systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 11 16:21:26 boobs sudo[1013]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:26 boobs systemd[1]: Reloading. Apr 11 16:21:26 boobs volumio[864]: info: touch_display: systemctl daemon-reload succeeded. Apr 11 16:21:26 boobs sudo[1040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 11 16:21:26 boobs sudo[1040]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:26 boobs systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 11 16:21:27 boobs sudo[1009]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:27 boobs volumio[864]: info: touch_display: systemctl disable getty@tty1.service succeeded. Apr 11 16:21:27 boobs sudo[1007]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:27 boobs volumio[864]: info: touch_display: systemctl stop getty@tty1.service succeeded. Apr 11 16:21:27 boobs systemd[1]: Started Volumio Kiosk. Apr 11 16:21:27 boobs sudo[1040]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:27 boobs volumio[864]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Apr 11 16:21:27 boobs volumio[864]: info: touch_display: Volumio Kiosk started. Apr 11 16:21:27 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:27 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:27 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:27 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:27 boobs volumio[864]: info: touch_display: X display number found: Apr 11 16:21:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:21:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:21:27 boobs startx[1055]: X.Org X Server 1.20.4 Apr 11 16:21:27 boobs startx[1055]: X Protocol Version 11, Revision 0 Apr 11 16:21:27 boobs startx[1055]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Apr 11 16:21:27 boobs startx[1055]: Current Operating System: Linux boobs 6.1.69-v7l+ #1710 SMP Thu Dec 21 13:17:38 GMT 2023 armv7l Apr 11 16:21:27 boobs startx[1055]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:75:87:A3 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 Apr 11 16:21:27 boobs startx[1055]: Build Date: 04 April 2023 07:50:56AM Apr 11 16:21:27 boobs startx[1055]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Apr 11 16:21:27 boobs startx[1055]: Current version of pixman: 0.36.0 Apr 11 16:21:27 boobs startx[1055]: Before reporting problems, check http://wiki.x.org Apr 11 16:21:27 boobs startx[1055]: to make sure that you have the latest version. Apr 11 16:21:27 boobs startx[1055]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 11 16:21:27 boobs startx[1055]: (++) from command line, (!!) notice, (II) informational, Apr 11 16:21:27 boobs startx[1055]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 11 16:21:27 boobs startx[1055]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Apr 11 16:21:27 2024 Apr 11 16:21:27 boobs startx[1055]: (==) Using config directory: "/etc/X11/xorg.conf.d" Apr 11 16:21:27 boobs startx[1055]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 11 16:21:27 boobs mpd[1005]: Apr 11 16:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 16:21:27 boobs systemd[1]: Started Music Player Daemon. Apr 11 16:21:27 boobs sudo[998]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:27 boobs sudo[992]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:27 boobs volumio[864]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 11 16:21:27 boobs volumio[864]: info: Completed starting Core Plugins Apr 11 16:21:27 boobs volumio[864]: info: ------------------------------------------- Apr 11 16:21:27 boobs volumio[864]: info: ----- MyVolumio plugins startup ---- Apr 11 16:21:27 boobs volumio[864]: info: ------------------------------------------- Apr 11 16:21:27 boobs volumio[864]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 11 16:21:27 boobs volumio[864]: info: MPD running with PID1005 Apr 11 16:21:27 boobs volumio[864]: ,establishing connection Apr 11 16:21:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:21:27 boobs volumio[864]: error: MPD error: The expression evaluated to a falsy value: Apr 11 16:21:27 boobs volumio[864]: assert.ok(self.idling) Apr 11 16:21:27 boobs volumio[864]: error: The expression evaluated to a falsy value: Apr 11 16:21:27 boobs volumio[864]: assert.ok(self.idling) Apr 11 16:21:27 boobs volumio[864]: error: MPD error: The expression evaluated to a falsy value: Apr 11 16:21:27 boobs volumio[864]: assert.ok(self.idling) Apr 11 16:21:27 boobs volumio[864]: error: The expression evaluated to a falsy value: Apr 11 16:21:27 boobs volumio[864]: assert.ok(self.idling) Apr 11 16:21:27 boobs volumio[864]: error: updateQueue error: null Apr 11 16:21:29 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:29 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:29 boobs volumio[864]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 11 16:21:32 boobs volumio[864]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 11 16:21:36 boobs volumio[864]: info: Adding plugin bluetooth to MyMusic Plugins Apr 11 16:21:36 boobs volumio[864]: info: Adding plugin multiroom to MyMusic Plugins Apr 11 16:21:36 boobs volumio[864]: info: Adding plugin metavolumio to MyMusic Plugins Apr 11 16:21:36 boobs volumio[864]: info: Adding plugin cd_controller to MyMusic Plugins Apr 11 16:21:36 boobs volumio[864]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 11 16:21:36 boobs volumio[864]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 11 16:21:36 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 11 16:21:36 boobs ntpd[686]: Soliciting pool server 176.58.110.22 Apr 11 16:21:37 boobs volumio[864]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 11 16:21:37 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 11 16:21:37 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:37 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:37 boobs volumio[864]: info: Starting MyVolumio Remote Streaming Endpoints Apr 11 16:21:37 boobs volumio[864]: info: MyVolumio login type: Token Apr 11 16:21:37 boobs volumio[864]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 11 16:21:37 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 11 16:21:37 boobs ntpd[686]: Soliciting pool server 178.62.68.79 Apr 11 16:21:38 boobs volumio[864]: info: Starting Streaming Service Transparent Proxy Apr 11 16:21:38 boobs volumio[864]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 11 16:21:38 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 11 16:21:38 boobs volumio[864]: info: Streaming services startup Apr 11 16:21:38 boobs volumio[864]: info: Starting Streaming Daemon Apr 11 16:21:38 boobs sudo[1331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 11 16:21:38 boobs sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:38 boobs sudo[1331]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:38 boobs volumio[864]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 11 16:21:38 boobs volumio[864]: error: Cannot start Volumio Streaming Daemon Apr 11 16:21:38 boobs volumio[864]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 11 16:21:38 boobs volumio[864]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 11 16:21:38 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:21:38 boobs volumio[864]: info: Discovery: Getting this device information Apr 11 16:21:38 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:38 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:38 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:21:38 boobs ntpd[686]: Soliciting pool server 109.74.206.120 Apr 11 16:21:38 boobs ntpd[686]: Soliciting pool server 193.57.144.50 Apr 11 16:21:39 boobs volumio[864]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 11 16:21:39 boobs volumio[864]: STREAMING PROXY: Starting server on port 3245 Apr 11 16:21:39 boobs volumio[864]: Node JS runtime: 14 Apr 11 16:21:39 boobs volumio[864]: info: MyVolumio token set successfully Apr 11 16:21:39 boobs volumio[864]: info: MYVOLUMIO: Adding device Apr 11 16:21:39 boobs volumio[864]: info: MYVOLUMIO: Evaluating Server Apr 11 16:21:39 boobs ntpd[686]: Soliciting pool server 129.250.35.251 Apr 11 16:21:39 boobs ntpd[686]: Soliciting pool server 93.93.131.118 Apr 11 16:21:40 boobs volumio[864]: info: MyVolumio Plan changed: premium Apr 11 16:21:40 boobs volumio[864]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Apr 11 16:21:40 boobs volumio[864]: info: Removing browser output: myVolumio user plan is not superstar Apr 11 16:21:40 boobs volumio[864]: info: Removing audio output: Apr 11 16:21:40 boobs volumio[864]: info: MYVOLUMIO: Adding device Apr 11 16:21:40 boobs volumio[864]: info: MYVOLUMIO: Evaluating Server Apr 11 16:21:40 boobs volumio[864]: info: Remote config written successfully Apr 11 16:21:40 boobs volumio[864]: info: Starting Tunnel 1 Apr 11 16:21:40 boobs volumio[864]: info: Starting Tunnel Connection Checker Apr 11 16:21:40 boobs volumio[864]: info: Completed starting MyVolumio Plugin Apr 11 16:21:40 boobs volumio[864]: info: MYVolumio Device enabled Apr 11 16:21:40 boobs volumio[864]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Apr 11 16:21:40 boobs volumio[864]: info: MyVolumio status changed Apr 11 16:21:40 boobs volumio[864]: info: Streaming services startup Apr 11 16:21:40 boobs volumio[864]: info: Starting Streaming Daemon Apr 11 16:21:40 boobs sudo[1382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 11 16:21:40 boobs sudo[1382]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:40 boobs volumio[864]: info: Setting Geolocation for MyVolumio to eu3 Apr 11 16:21:40 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:40 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:40 boobs sudo[1382]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:40 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:40 boobs volumio[864]: verbose: New Socket.io Connection to localhost: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 Total Clients: 5 Apr 11 16:21:40 boobs volumio[864]: error: Cannot start Volumio Streaming Daemon Apr 11 16:21:40 boobs volumio[864]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 11 16:21:40 boobs volumio[864]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 11 16:21:40 boobs volumio[864]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates. Apr 11 16:21:40 boobs volumio[864]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:106:19) Apr 11 16:21:40 boobs volumio[864]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:113:37) Apr 11 16:21:40 boobs volumio[864]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:47:13 Apr 11 16:21:40 boobs volumio[864]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Apr 11 16:21:40 boobs volumio[864]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:144:13) Apr 11 16:21:40 boobs volumio[864]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:114:3) Apr 11 16:21:40 boobs volumio[864]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Apr 11 16:21:40 boobs volumio[864]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15 Apr 11 16:21:40 boobs volumio[864]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14) Apr 11 16:21:40 boobs volumio[864]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14) Apr 11 16:21:40 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 11 16:21:40 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Apr 11 16:21:40 boobs ntpd[686]: Soliciting pool server 162.159.200.123 Apr 11 16:21:40 boobs ntpd[686]: Soliciting pool server 212.71.250.89 Apr 11 16:21:40 boobs ntpd[686]: Soliciting pool server 134.0.16.1 Apr 11 16:21:41 boobs volumio[864]: info: [1712848901119] Starting BluetoothController Apr 11 16:21:41 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Apr 11 16:21:41 boobs ntpd[686]: Soliciting pool server 139.143.5.31 Apr 11 16:21:41 boobs ntpd[686]: Soliciting pool server 178.62.18.76 Apr 11 16:21:41 boobs ntpd[686]: Soliciting pool server 185.103.119.60 Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Apr 11 16:21:42 boobs sudo[1386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Apr 11 16:21:42 boobs sudo[1386]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs sudo[1386]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:42 boobs volumio[864]: info: MRS: MultiRoom plugin initialized Apr 11 16:21:42 boobs volumio[864]: info: MRS: STOPPING SNAPCLIENT Apr 11 16:21:42 boobs volumio[864]: info: MRS: Snap server stop Apr 11 16:21:42 boobs sudo[1402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Apr 11 16:21:42 boobs sudo[1402]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs volumio[864]: info: MRS: STOPPING volumioStreaming Apr 11 16:21:42 boobs sudo[1405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Apr 11 16:21:42 boobs sudo[1405]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs sudo[1402]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:42 boobs sudo[1407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Apr 11 16:21:42 boobs sudo[1407]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Apr 11 16:21:42 boobs sudo[1410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Apr 11 16:21:42 boobs sudo[1410]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs sudo[1410]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:42 boobs sudo[1405]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Apr 11 16:21:42 boobs sudo[1407]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Apr 11 16:21:42 boobs volumio[864]: info: Preparing to generate the ALSA configuration file Apr 11 16:21:42 boobs volumio[864]: info: Updating MyVolumio device info Apr 11 16:21:42 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:42 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:42 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:42 boobs volumio[864]: info: Setting Geolocation for MyVolumio to eu3 Apr 11 16:21:42 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:42 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:42 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:42 boobs volumio[864]: info: MRS: Removed streaming files Apr 11 16:21:42 boobs volumio[864]: info: MRS: volumioStreaming STOPPED Apr 11 16:21:42 boobs volumio[864]: info: MRS: SNAPSERVER STOPPED Apr 11 16:21:42 boobs volumio[864]: info: MRS: SNAPCLIENT STOPPED Apr 11 16:21:42 boobs sudo[1415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 11 16:21:42 boobs sudo[1415]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs sudo[1415]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:42 boobs sudo[1417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 11 16:21:42 boobs sudo[1417]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs volumio[864]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Apr 11 16:21:42 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Apr 11 16:21:42 boobs volumio[864]: info: Asound.conf file unchanged, so no further update is needed Apr 11 16:21:42 boobs volumio[864]: info: Output device has changed, restarting MPD Apr 11 16:21:42 boobs sudo[1417]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:42 boobs volumio[864]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 11 16:21:42 boobs sudo[1420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 16:21:42 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:42 boobs sudo[1420]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs sudo[1422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 16:21:42 boobs sudo[1422]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs sudo[1420]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Apr 11 16:21:42 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 11 16:21:42 boobs systemd[1]: Stopping Music Player Daemon... Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Plugin multiroom disabled by user. Not starting Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Apr 11 16:21:42 boobs volumio[864]: info: Adding METAVOLUMIO REST API Endpoints Apr 11 16:21:42 boobs volumio[864]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 11 16:21:42 boobs volumio[864]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Apr 11 16:21:42 boobs volumio[864]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Apr 11 16:21:42 boobs volumio[864]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Apr 11 16:21:42 boobs systemd[1]: mpd.service: Succeeded. Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Apr 11 16:21:42 boobs systemd[1]: Stopped Music Player Daemon. Apr 11 16:21:42 boobs volumio[864]: info: Adding Manifest REST API Endpoints Apr 11 16:21:42 boobs volumio[864]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Apr 11 16:21:42 boobs volumio[864]: info: Preparing CD Folders Apr 11 16:21:42 boobs volumio[864]: info: Adding CD REST API Endpoints Apr 11 16:21:42 boobs volumio[864]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Apr 11 16:21:42 boobs volumio[864]: info: Starting UDEV Watcher for CD Apr 11 16:21:42 boobs volumio[864]: info: Detecting CD presence with UDEV Apr 11 16:21:42 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Apr 11 16:21:42 boobs sudo[1428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Boobs Apr 11 16:21:42 boobs sudo[1428]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Plugin smart_inputs disabled by user. Not starting Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Apr 11 16:21:42 boobs volumio[864]: error: Hi Res Audio Failed Login: Missing Login Data Apr 11 16:21:42 boobs volumio[864]: info: Adding HIGHRESAUDIO REST API Endpoints Apr 11 16:21:42 boobs volumio[864]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Apr 11 16:21:42 boobs volumio[864]: info: Refreshing TIDAL token Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Apr 11 16:21:42 boobs volumio[864]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Apr 11 16:21:42 boobs volumio[864]: info: Stopping AccessToken refresher cron for QOBUZ Apr 11 16:21:42 boobs sudo[1428]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:42 boobs systemd[1]: Starting Music Player Daemon... Apr 11 16:21:42 boobs ntpd[686]: Soliciting pool server 178.62.250.107 Apr 11 16:21:42 boobs ntpd[686]: Soliciting pool server 85.199.214.99 Apr 11 16:21:42 boobs sudo[1433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 11 16:21:42 boobs sudo[1433]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:42 boobs volumio[864]: info: AccessToken refresher cron started for QOBUZ Apr 11 16:21:42 boobs volumio[864]: info: Adding QOBUZ REST API Endpoints Apr 11 16:21:42 boobs volumio[864]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Apr 11 16:21:42 boobs sudo[1433]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:43 boobs volumio[864]: info: Listing playlists Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::volumioGetQueue Apr 11 16:21:43 boobs volumio[864]: info: CoreStateMachine::getQueue Apr 11 16:21:43 boobs volumio[864]: info: CorePlayQueue::getQueue Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::volumioGetVisibleSources Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:43 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:43 boobs volumio[864]: info: Successfully Added MyVolumio device Apr 11 16:21:43 boobs volumio[864]: info: Bluetooth name changed to Boobs Apr 11 16:21:43 boobs volumio[864]: info: MPD Permissions set Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:21:43 boobs volumio[864]: verbose: New Socket.io Connection to 192.168.4.132 from 192.168.4.134 UA: okhttp/4.9.2 Total Clients: 6 Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::volumioGetVisibleSources Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:43 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 11 16:21:43 boobs volumio[864]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 11 16:21:43 boobs volumio[864]: info: Received Get System Info Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:21:43 boobs volumio[864]: info: Discovery: Getting this device information Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:43 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:43 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:43 boobs volumio[864]: info: Listing playlists Apr 11 16:21:43 boobs volumio[864]: info: Successfully Updated MyVolumio device Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 11 16:21:43 boobs volumio[864]: info: Access Token successfully retrieved Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 11 16:21:43 boobs volumio[864]: info: Successfully retrieved User Session From TIDAL Apr 11 16:21:43 boobs mpd[1429]: Apr 11 16:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 16:21:43 boobs systemd[1]: Started Music Player Daemon. Apr 11 16:21:43 boobs sudo[1422]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:43 boobs volumio[864]: error: updateQueue error: null Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:21:43 boobs volumio[864]: info: Discovery: Getting this device information Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:43 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:21:43 boobs volumio[864]: info: Successfully retrieved User Subscription From TIDAL Apr 11 16:21:43 boobs volumio[864]: info: Adding TIDAL to Browse Sources Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:21:43 boobs volumio[864]: info: [1712848903655] CoreMusicLibrary::Adding element TIDAL Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:21:43 boobs volumio[864]: Cannot find translation for source TIDAL Apr 11 16:21:43 boobs volumio[864]: info: Stopping AccessToken refresher cron Apr 11 16:21:43 boobs volumio[864]: info: AccessToken refresher cron started Apr 11 16:21:43 boobs volumio[864]: info: Adding TIDAL REST API Endpoints Apr 11 16:21:43 boobs volumio[864]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Apr 11 16:21:43 boobs volumio[864]: info: Updating MyVolumio device info Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 11 16:21:43 boobs volumio[864]: info: Received Get System Info Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:21:43 boobs volumio[864]: info: Discovery: Getting this device information Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:43 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:43 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:21:43 boobs ntpd[686]: Soliciting pool server 62.3.77.1 Apr 11 16:21:43 boobs ntpd[686]: Soliciting pool server 77.104.162.218 Apr 11 16:21:43 boobs volumio[864]: info: Successfully Updated MyVolumio device Apr 11 16:21:44 boobs volumio[864]: info: Successfully Added MyVolumio device Apr 11 16:21:44 boobs ntpd[686]: Soliciting pool server 2606:4700:f1::123 Apr 11 16:21:45 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 11 16:21:45 boobs volumio[864]: info: Received Get System Info Apr 11 16:21:45 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:21:45 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:21:45 boobs volumio[864]: info: Discovery: Getting this device information Apr 11 16:21:45 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:45 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:45 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:21:45 boobs sudo[1447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 11 16:21:45 boobs sudo[1447]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:45 boobs systemd[1]: Started MyVolumio SSH Tunnel. Apr 11 16:21:45 boobs sudo[1447]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:45 boobs volumio[864]: info: Remote SSH Started Apr 11 16:21:45 boobs autossh[1450]: port set to 0, monitoring disabled Apr 11 16:21:45 boobs autossh[1450]: starting ssh (count 1) Apr 11 16:21:45 boobs autossh[1450]: ssh child pid is 1453 Apr 11 16:21:45 boobs volumio[864]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Apr 11 16:21:45 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:21:45 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:45 boobs volumiossh-tunnel[1449]: Warning: Permanently added '[eu3.myvolumio.org]:2222,[167.71.136.233]:2222' (RSA) to the list of known hosts. Apr 11 16:21:45 boobs sudo[1455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Apr 11 16:21:45 boobs sudo[1455]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:46 boobs volumio[864]: info: TidalConnect service stoped! Apr 11 16:21:46 boobs systemd[1]: Started Volumio Bluetooth Module. Apr 11 16:21:46 boobs sudo[1455]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:46 boobs volumio[864]: info: Volumio BT Module successfully started Apr 11 16:21:46 boobs volumio[864]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 11 16:21:46 boobs volumio[864]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 11 16:21:46 boobs sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Apr 11 16:21:46 boobs sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:46 boobs volumiobt[1457]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Apr 11 16:21:46 boobs sudo[1463]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:46 boobs sudo[1470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 11 16:21:46 boobs sudo[1470]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:21:46 boobs systemd[1]: Started Volumio Tidal Connect Service. Apr 11 16:21:46 boobs sudo[1470]: pam_unix(sudo:session): session closed for user root Apr 11 16:21:46 boobs volumio[864]: info: Executing endpoint tc_getconfig Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 11 16:21:46 boobs vtcs[1472]: STARTING TidalConnect services, version: 1.3.0.19 Apr 11 16:21:46 boobs vtcs[1472]: STARTED TidalConnect services. Apr 11 16:21:46 boobs volumio[864]: info: Executing endpoint tc_connect Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 11 16:21:46 boobs volumio[864]: info: Connecting to TidalConnect Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::servicePushState Apr 11 16:21:46 boobs volumio[864]: info: CoreStateMachine::pushState Apr 11 16:21:46 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::volumioPushState Apr 11 16:21:46 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:46 boobs volumio[864]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 11 16:21:46 boobs volumio[864]: verbose: CURRENT POSITION 0 Apr 11 16:21:46 boobs volumio[864]: info: CoreStateMachine::syncState stateService stop Apr 11 16:21:46 boobs volumio[864]: info: CoreStateMachine::syncState currentStatus stop Apr 11 16:21:46 boobs volumio[864]: info: CoreStateMachine::pushState Apr 11 16:21:46 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::volumioPushState Apr 11 16:21:46 boobs volumio[864]: info: No code Apr 11 16:21:46 boobs volumio[864]: info: CoreStateMachine::pushState Apr 11 16:21:46 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::volumioPushState Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::servicePushState Apr 11 16:21:46 boobs volumio[864]: info: CoreStateMachine::pushState Apr 11 16:21:46 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::volumioPushState Apr 11 16:21:46 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:46 boobs volumio[864]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 11 16:21:46 boobs volumio[864]: verbose: CURRENT POSITION 0 Apr 11 16:21:46 boobs volumio[864]: info: CoreStateMachine::syncState stateService stop Apr 11 16:21:46 boobs volumio[864]: info: CoreStateMachine::syncState currentStatus stop Apr 11 16:21:46 boobs volumio[864]: info: CoreStateMachine::pushState Apr 11 16:21:46 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::volumioPushState Apr 11 16:21:46 boobs volumio[864]: info: No code Apr 11 16:21:46 boobs volumio[864]: info: CoreStateMachine::pushState Apr 11 16:21:46 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:21:46 boobs volumio[864]: info: CoreCommandRouter::volumioPushState Apr 11 16:22:13 boobs ntpd[686]: receive: Unexpected origin timestamp 0xe9c27e8a.f23bb01f does not match aorg 0000000000.00000000 from server@212.71.250.89 xmt 0xe9c27ea5.448351f2 Apr 11 16:22:13 boobs ntpd[686]: receive: Unexpected origin timestamp 0xe9c27e8a.f240ec8b does not match aorg 0000000000.00000000 from server@109.74.206.120 xmt 0xe9c27ea5.4466d066 Apr 11 16:22:13 boobs ntpd[686]: receive: Unexpected origin timestamp 0xe9c27e8a.f235fca5 does not match aorg 0000000000.00000000 from server@178.62.18.76 xmt 0xe9c27ea5.447d64fe Apr 11 16:22:13 boobs ntpd[686]: receive: Unexpected origin timestamp 0xe9c27e8a.f238f7cb does not match aorg 0000000000.00000000 from server@134.0.16.1 xmt 0xe9c27ea5.44855a45 Apr 11 16:22:13 boobs ntpd[686]: receive: Unexpected origin timestamp 0xe9c27e8a.f231fc92 does not match aorg 0000000000.00000000 from server@178.62.250.107 xmt 0xe9c27ea5.44540fae Apr 11 16:22:13 boobs ntpd[686]: receive: Unexpected origin timestamp 0xe9c27e8a.f226b039 does not match aorg 0000000000.00000000 from server@77.104.162.218 xmt 0xe9c27ea5.46315de2 Apr 11 16:22:13 boobs ntpd[686]: receive: Unexpected origin timestamp 0xe9c27e8a.f22c6346 does not match aorg 0000000000.00000000 from server@62.3.77.1 xmt 0xe9c27ea5.4b77c633 Apr 11 16:22:13 boobs sudo[1490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Apr 11 16:22:13 boobs sudo[1490]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:13 boobs volumiobt[1457]: pulseaudio: no process found Apr 11 16:22:13 boobs sudo[1490]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:13 boobs dbus-daemon[556]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.23' (uid=1000 pid=1494 comm="/usr/bin/pulseaudio --high-priority=true ") Apr 11 16:22:13 boobs systemd[1]: Starting RealtimeKit Scheduling Policy Service... Apr 11 16:22:13 boobs volumio[864]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 11 16:22:13 boobs dbus-daemon[556]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Apr 11 16:22:13 boobs systemd[1]: Started RealtimeKit Scheduling Policy Service. Apr 11 16:22:13 boobs rtkit-daemon[1495]: Successfully called chroot. Apr 11 16:22:13 boobs rtkit-daemon[1495]: Successfully dropped privileges. Apr 11 16:22:13 boobs rtkit-daemon[1495]: Successfully limited resources. Apr 11 16:22:13 boobs rtkit-daemon[1495]: Running. Apr 11 16:22:13 boobs rtkit-daemon[1495]: Canary thread running. Apr 11 16:22:13 boobs rtkit-daemon[1495]: Watchdog thread running. Apr 11 16:22:13 boobs dbus-daemon[556]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.24' (uid=0 pid=1495 comm="/usr/lib/rtkit/rtkit-daemon ") Apr 11 16:22:13 boobs systemd[1]: Starting Authorization Manager... Apr 11 16:22:13 boobs volumio[864]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 11 16:22:13 boobs polkitd[1498]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 11 16:22:13 boobs dbus-daemon[556]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 11 16:22:13 boobs systemd[1]: Started Authorization Manager. Apr 11 16:22:13 boobs pulseaudio[1494]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 11 16:22:13 boobs pulseaudio[1494]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Apr 11 16:22:13 boobs volumiobt[1457]: Applying permissions Apr 11 16:22:13 boobs volumiobt[1457]: Setting BT discoverable and pairable Apr 11 16:22:13 boobs bluetoothd[679]: Endpoint registered: sender=:1.44 path=/MediaEndpoint/A2DPSource Apr 11 16:22:13 boobs bluetoothd[679]: Endpoint registered: sender=:1.44 path=/MediaEndpoint/A2DPSink Apr 11 16:22:13 boobs pulseaudio[1494]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Apr 11 16:22:13 boobs kernel: Bluetooth: RFCOMM TTY layer initialized Apr 11 16:22:13 boobs kernel: Bluetooth: RFCOMM socket layer initialized Apr 11 16:22:13 boobs kernel: Bluetooth: RFCOMM ver 1.11 Apr 11 16:22:13 boobs volumiobt[1457]: [CHG] Controller DC:A6:32:75:87:A5 Class: 0x0008041c Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [91B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [55B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [117B blob data] Apr 11 16:22:13 boobs volumiobt[1457]: [bluetooth]# -e power on Apr 11 16:22:13 boobs volumiobt[1457]: Invalid command in menu main: -e Apr 11 16:22:13 boobs volumiobt[1457]: Apr 11 16:22:13 boobs volumiobt[1457]: Use "help" for a list of available commands in a menu. Apr 11 16:22:13 boobs volumiobt[1457]: Use "menu " if you want to enter any submenu. Apr 11 16:22:13 boobs volumiobt[1457]: Use "back" if you want to return to menu main. Apr 11 16:22:13 boobs volumiobt[1457]: [bluetooth]# agent on Apr 11 16:22:13 boobs volumiobt[1457]: Agent is already registered Apr 11 16:22:13 boobs volumiobt[1457]: [bluetooth]# discoverable on Apr 11 16:22:13 boobs volumiobt[1457]: [bluetooth]# pairable on Apr 11 16:22:13 boobs volumiobt[1457]: [bluetooth]# agent NoInputNoOutput Apr 11 16:22:13 boobs volumiobt[1457]: Agent is already registered Apr 11 16:22:13 boobs volumiobt[1457]: [bluetooth]# default-agent Apr 11 16:22:13 boobs volumiobt[1457]: [bluetooth]# quit Apr 11 16:22:13 boobs volumiobt[1457]: [59B blob data] Apr 11 16:22:14 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 11 16:22:14 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 11 16:22:15 boobs volumio[864]: info: TidalConnect service started! Apr 11 16:22:15 boobs volumio[864]: info: BOOT COMPLETED Apr 11 16:22:15 boobs volumio[864]: [Metrics] CommandRouter: 59s 33.17ms Apr 11 16:22:15 boobs volumio[864]: info: CoreCommandRouter::volumiosetStartupVolume Apr 11 16:22:15 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:22:15 boobs volumio[864]: info: VolumeController:: Setting startup Volume 100 Apr 11 16:22:15 boobs volumio[864]: info: VolumeController::SetAlsaVolume100 Apr 11 16:22:15 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:22:15 boobs volumio[864]: info: CoreCommandRouter::Close All Modals sent Apr 11 16:22:15 boobs volumio[864]: info: CoreCommandRouter::Close All Modals sent Apr 11 16:22:15 boobs volumio[864]: info: CoreStateMachine::pushState Apr 11 16:22:15 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:22:15 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 16:22:15 boobs volumio[864]: info: CoreCommandRouter::volumioPushState Apr 11 16:22:15 boobs volumio[864]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 11 16:22:16 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 11 16:22:16 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 16:22:16 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 11 16:22:18 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 11 16:22:18 boobs volumio[864]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 11 16:22:18 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:22:18 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:22:19 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:22:19 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:22:19 boobs volumio[864]: info: Discovery: Getting this device information Apr 11 16:22:19 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:22:19 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:22:19 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:22:20 boobs sudo[1692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Apr 11 16:22:20 boobs sudo[1692]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:20 boobs sudo[1692]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:20 boobs sudo[1695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Apr 11 16:22:20 boobs sudo[1695]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:20 boobs sudo[1698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Apr 11 16:22:20 boobs sudo[1698]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:20 boobs volumio[864]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Apr 11 16:22:20 boobs systemd[1]: Created slice system-getty.slice. Apr 11 16:22:20 boobs sudo[1701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Apr 11 16:22:20 boobs sudo[1701]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:20 boobs systemd[1]: Started Getty on tty1. Apr 11 16:22:20 boobs sudo[1695]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:20 boobs volumio[864]: info: touch_display: systemctl start getty@tty1.service succeeded. Apr 11 16:22:20 boobs startx[1055]: xinit: connection to X server lost Apr 11 16:22:20 boobs startx[1055]: [1B blob data] Apr 11 16:22:20 boobs systemd[1]: Stopping Volumio Kiosk... Apr 11 16:22:20 boobs systemd[1]: Reloading. Apr 11 16:22:20 boobs volumio[864]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 11 16:22:20 boobs startx[1055]: waiting for X server to shut down (II) Server terminated successfully (0). Closing log file. Apr 11 16:22:20 boobs sudo[1719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Apr 11 16:22:20 boobs sudo[1719]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:20 boobs sudo[1719]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:20 boobs sudo[1720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Apr 11 16:22:20 boobs sudo[1720]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:20 boobs sudo[1723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Apr 11 16:22:20 boobs volumio[864]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Apr 11 16:22:20 boobs sudo[1723]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:20 boobs sudo[1726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Apr 11 16:22:20 boobs sudo[1726]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:20 boobs systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 11 16:22:20 boobs kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 1 Apr 11 16:22:20 boobs kernel: xhci_hcd 0000:01:00.0: @000000042a1131a0 00000000 00000000 0e000000 02028000 Apr 11 16:22:21 boobs systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Apr 11 16:22:21 boobs sudo[1698]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:21 boobs volumio[864]: info: touch_display: systemctl enable getty@tty1.service succeeded. Apr 11 16:22:21 boobs systemd[1]: Reloading. Apr 11 16:22:21 boobs volumio[864]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 11 16:22:21 boobs systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 11 16:22:21 boobs startx[1055]: xinit: unexpected signal 15 Apr 11 16:22:21 boobs systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Apr 11 16:22:21 boobs systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Apr 11 16:22:21 boobs systemd[1]: Stopped Volumio Kiosk. Apr 11 16:22:21 boobs sudo[1723]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:21 boobs sudo[1701]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:21 boobs volumio[864]: info: touch_display: systemctl enable getty@tty1.service succeeded. Apr 11 16:22:21 boobs sudo[1720]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:21 boobs sudo[1726]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:21 boobs volumio[864]: info: touch_display: systemctl stop volumio-kiosk.service succeeded. Apr 11 16:22:21 boobs volumio[864]: info: Disabling plugin touch_display Apr 11 16:22:21 boobs volumio[864]: info: Done. Apr 11 16:22:21 boobs volumio[864]: info: touch_display: systemctl start getty@tty1.service succeeded. Apr 11 16:22:21 boobs volumio[864]: info: touch_display: systemctl stop volumio-kiosk.service succeeded. Apr 11 16:22:21 boobs volumio[864]: info: Disabling plugin touch_display Apr 11 16:22:21 boobs volumio[864]: info: Done. Apr 11 16:22:22 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:22:22 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:22:22 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 11 16:22:22 boobs volumio-remote-updater[555]: No test mode Apr 11 16:22:22 boobs volumio-remote-updater[555]: No alpha test mode Apr 11 16:22:22 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 11 16:22:22 boobs volumio[864]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 11 16:22:22 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 11 16:22:22 boobs volumio[864]: info: Enabling plugin touch_display Apr 11 16:22:22 boobs volumio[864]: info: Loading plugin "touch_display"... Apr 11 16:22:22 boobs volumio[864]: info: Applying required configuration parameters for plugin touch_display Apr 11 16:22:22 boobs volumio[864]: info: PLUGIN START: touch_display Apr 11 16:22:22 boobs volumio[864]: info: Loading i18n strings for locale en Apr 11 16:22:22 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:22:22 boobs sudo[1749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Apr 11 16:22:22 boobs sudo[1749]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:22 boobs systemd[1]: Stopping Getty on tty1... Apr 11 16:22:22 boobs sudo[1752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Apr 11 16:22:22 boobs sudo[1752]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:22 boobs volumio[864]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Apr 11 16:22:22 boobs volumio[864]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 11 16:22:22 boobs systemd[1]: getty@tty1.service: Main process exited, code=killed, status=15/TERM Apr 11 16:22:22 boobs systemd[1]: getty@tty1.service: Succeeded. Apr 11 16:22:22 boobs systemd[1]: Stopped Getty on tty1. Apr 11 16:22:22 boobs sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 11 16:22:22 boobs sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:22 boobs sudo[1749]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:22 boobs volumio[864]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Apr 11 16:22:22 boobs systemd[1]: Reloading. Apr 11 16:22:22 boobs sudo[1758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Apr 11 16:22:22 boobs sudo[1758]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:22 boobs sudo[1758]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:22 boobs volumio[864]: info: touch_display: systemctl stop getty@tty1.service succeeded. Apr 11 16:22:22 boobs volumio[864]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Apr 11 16:22:22 boobs sudo[1761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Apr 11 16:22:22 boobs sudo[1761]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:22 boobs sudo[1761]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:22 boobs volumio[864]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Apr 11 16:22:23 boobs volumio[864]: info: Enabling plugin touch_display Apr 11 16:22:23 boobs volumio[864]: info: Loading plugin "touch_display"... Apr 11 16:22:23 boobs volumio[864]: info: Applying required configuration parameters for plugin touch_display Apr 11 16:22:23 boobs volumio[864]: info: PLUGIN START: touch_display Apr 11 16:22:23 boobs volumio[864]: info: Loading i18n strings for locale en Apr 11 16:22:23 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:22:23 boobs sudo[1777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Apr 11 16:22:23 boobs sudo[1777]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:23 boobs sudo[1780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Apr 11 16:22:23 boobs volumio[864]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Apr 11 16:22:23 boobs sudo[1780]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:23 boobs sudo[1782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 11 16:22:23 boobs sudo[1782]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:23 boobs volumio[864]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Apr 11 16:22:23 boobs sudo[1786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Apr 11 16:22:23 boobs sudo[1786]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:23 boobs systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 11 16:22:23 boobs sudo[1786]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:23 boobs volumio[864]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Apr 11 16:22:23 boobs sudo[1789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Apr 11 16:22:23 boobs sudo[1789]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:23 boobs sudo[1789]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:23 boobs volumio[864]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Apr 11 16:22:23 boobs sudo[1752]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:23 boobs volumio[864]: info: touch_display: systemctl disable getty@tty1.service succeeded. Apr 11 16:22:23 boobs systemd[1]: Reloading. Apr 11 16:22:23 boobs volumio[864]: info: Enabling plugin touch_display Apr 11 16:22:23 boobs volumio[864]: info: Loading plugin "touch_display"... Apr 11 16:22:23 boobs volumio[864]: info: Applying required configuration parameters for plugin touch_display Apr 11 16:22:23 boobs volumio[864]: info: PLUGIN START: touch_display Apr 11 16:22:23 boobs volumio[864]: info: Loading i18n strings for locale en Apr 11 16:22:23 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:22:23 boobs sudo[1792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Apr 11 16:22:23 boobs sudo[1792]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:23 boobs volumio[864]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Apr 11 16:22:23 boobs sudo[1808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Apr 11 16:22:23 boobs sudo[1808]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:23 boobs volumio[864]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Apr 11 16:22:23 boobs sudo[1810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 11 16:22:23 boobs sudo[1810]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:23 boobs sudo[1815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Apr 11 16:22:23 boobs sudo[1815]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:23 boobs sudo[1815]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:23 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:22:23 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:22:23 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 11 16:22:23 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 11 16:22:23 boobs sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Apr 11 16:22:23 boobs sudo[1816]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:23 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 11 16:22:23 boobs volumio[864]: info: CoreCommandRouter::volumioGetBrowseSources Apr 11 16:22:23 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:22:23 boobs sudo[1816]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:23 boobs volumio[864]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Apr 11 16:22:23 boobs volumio[864]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Apr 11 16:22:23 boobs systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 11 16:22:24 boobs volumio[864]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 11 16:22:24 boobs sudo[1755]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:24 boobs volumio[864]: info: touch_display: systemctl daemon-reload succeeded. Apr 11 16:22:24 boobs sudo[1820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 11 16:22:24 boobs sudo[1820]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:24 boobs systemd[1]: Reloading. Apr 11 16:22:24 boobs systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 11 16:22:24 boobs sudo[1782]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:24 boobs volumio[864]: info: touch_display: systemctl daemon-reload succeeded. Apr 11 16:22:24 boobs systemd[1]: Reloading. Apr 11 16:22:24 boobs sudo[1836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 11 16:22:24 boobs sudo[1836]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:24 boobs systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 11 16:22:25 boobs sudo[1780]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:25 boobs volumio[864]: info: touch_display: systemctl disable getty@tty1.service succeeded. Apr 11 16:22:25 boobs systemd[1]: Reloading. Apr 11 16:22:25 boobs volumio[864]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 11 16:22:25 boobs systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 11 16:22:25 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 11 16:22:25 boobs volumio[864]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 11 16:22:25 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 11 16:22:25 boobs volumio[864]: info: Received Get System Version Apr 11 16:22:25 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:22:25 boobs volumio[864]: info: Received Get System Info Apr 11 16:22:25 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:22:25 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:22:25 boobs volumio[864]: info: Discovery: Getting this device information Apr 11 16:22:25 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:22:25 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:22:25 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:22:25 boobs systemd[1]: Reloading. Apr 11 16:22:25 boobs sudo[1808]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:25 boobs volumio[864]: info: touch_display: systemctl disable getty@tty1.service succeeded. Apr 11 16:22:26 boobs systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 11 16:22:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 11 16:22:26 boobs volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 11 16:22:26 boobs sudo[1810]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:26 boobs systemd[1]: Started Volumio Kiosk. Apr 11 16:22:26 boobs volumio[864]: info: touch_display: systemctl daemon-reload succeeded. Apr 11 16:22:26 boobs sudo[1820]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:26 boobs sudo[1836]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:26 boobs volumio[864]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 11 16:22:26 boobs volumio[864]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Apr 11 16:22:26 boobs volumio[864]: info: touch_display: Volumio Kiosk started. Apr 11 16:22:26 boobs sudo[1887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 11 16:22:26 boobs sudo[1887]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:22:26 boobs sudo[1792]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:26 boobs sudo[1777]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:26 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:22:26 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:22:26 boobs volumio[864]: info: Done. Apr 11 16:22:26 boobs volumio[864]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Apr 11 16:22:26 boobs volumio[864]: info: touch_display: Volumio Kiosk started. Apr 11 16:22:26 boobs sudo[1887]: pam_unix(sudo:session): session closed for user root Apr 11 16:22:26 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:22:26 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:22:26 boobs volumio[864]: info: Done. Apr 11 16:22:26 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:22:26 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:22:26 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:22:26 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:22:26 boobs startx[1877]: X.Org X Server 1.20.4 Apr 11 16:22:26 boobs startx[1877]: X Protocol Version 11, Revision 0 Apr 11 16:22:26 boobs startx[1877]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Apr 11 16:22:26 boobs startx[1877]: Current Operating System: Linux boobs 6.1.69-v7l+ #1710 SMP Thu Dec 21 13:17:38 GMT 2023 armv7l Apr 11 16:22:26 boobs startx[1877]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:75:87:A3 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 Apr 11 16:22:26 boobs startx[1877]: Build Date: 04 April 2023 07:50:56AM Apr 11 16:22:26 boobs startx[1877]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Apr 11 16:22:26 boobs startx[1877]: Current version of pixman: 0.36.0 Apr 11 16:22:26 boobs startx[1877]: Before reporting problems, check http://wiki.x.org Apr 11 16:22:26 boobs startx[1877]: to make sure that you have the latest version. Apr 11 16:22:26 boobs startx[1877]: Markers: (--) probed, (**) from config file, (==) default setting, Apr 11 16:22:26 boobs startx[1877]: (++) from command line, (!!) notice, (II) informational, Apr 11 16:22:26 boobs startx[1877]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Apr 11 16:22:26 boobs startx[1877]: (==) Log file: "/var/log/Xorg.0.log", Time: Thu Apr 11 16:22:26 2024 Apr 11 16:22:26 boobs startx[1877]: (==) Using config directory: "/etc/X11/xorg.conf.d" Apr 11 16:22:26 boobs startx[1877]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: Apr 11 16:22:26 boobs volumio[864]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Apr 11 16:22:26 boobs volumio[864]: info: touch_display: Volumio Kiosk started. Apr 11 16:22:26 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:22:26 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:22:26 boobs volumio[864]: info: Done. Apr 11 16:22:26 boobs volumio[864]: info: touch_display: systemctl stop getty@tty1.service succeeded. Apr 11 16:22:26 boobs volumio[864]: info: touch_display: systemctl stop getty@tty1.service succeeded. Apr 11 16:22:26 boobs volumio[864]: info: CoreCommandRouter::volumioGetState Apr 11 16:22:26 boobs volumio[864]: info: CorePlayQueue::getTrack 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:26 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:27 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:28 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:28 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:28 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:28 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:28 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:28 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:28 boobs volumio[864]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 11 16:22:28 boobs volumio[864]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 11 16:22:28 boobs volumio[864]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 11 16:22:28 boobs volumio[864]: info: touch_display: X display number found: 0 Apr 11 16:22:28 boobs volumio[864]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 16:22:28 boobs volumio[864]: Error: connect EISCONN /tmp/.X11-unix/X0 Apr 11 16:22:28 boobs volumio[864]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 11 16:22:28 boobs volumio[864]: errno: -106, Apr 11 16:22:28 boobs volumio[864]: code: 'EISCONN', Apr 11 16:22:28 boobs volumio[864]: syscall: 'connect', Apr 11 16:22:28 boobs volumio[864]: address: '/tmp/.X11-unix/X0' Apr 11 16:22:28 boobs volumio[864]: } Apr 11 16:22:28 boobs volumio[864]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 16:22:28 boobs sudo[2135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-11 16:21 Apr 11 16:22:28 boobs sudo[2135]: 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"