-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sun 2024-08-18 18:13:56 UTC. -- Aug 18 18:12:04 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:12:11 rasptouch go-librespot[1257]: time="2024-08-18T18:12:11Z" level=trace msg="emitting websocket event: not_playing" Aug 18 18:12:11 rasptouch go-librespot[1257]: time="2024-08-18T18:12:11Z" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:2ipYQ6pcabz1NovVrr9LKH" Aug 18 18:12:11 rasptouch volumio[1068]: SPOTIFY: received: {"type":"not_playing","data":{"uri":"spotify:track:4qVR3CF8FuFvHN4L6vXlB1","play_origin":"playlist"}} Aug 18 18:12:11 rasptouch volumio[1068]: error: Failed to decode event: not_playing Aug 18 18:12:11 rasptouch go-librespot[1257]: time="2024-08-18T18:12:11Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 18 18:12:11 rasptouch go-librespot[1257]: time="2024-08-18T18:12:11Z" level=trace msg="emitting websocket event: will_play" Aug 18 18:12:11 rasptouch volumio[1068]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:2ipYQ6pcabz1NovVrr9LKH","play_origin":"playlist"}} Aug 18 18:12:11 rasptouch go-librespot[1257]: time="2024-08-18T18:12:11Z" level=info msg="loaded track \"Fighting Myself\" (paused: false, position: 0ms, duration: 201428ms, prefetched: true)" uri="spotify:track:2ipYQ6pcabz1NovVrr9LKH" Aug 18 18:12:11 rasptouch go-librespot[1257]: time="2024-08-18T18:12:11Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 18 18:12:11 rasptouch go-librespot[1257]: time="2024-08-18T18:12:11Z" level=trace msg="scheduling prefetch in 171s" Aug 18 18:12:11 rasptouch go-librespot[1257]: time="2024-08-18T18:12:11Z" level=trace msg="emitting websocket event: metadata" Aug 18 18:12:11 rasptouch volumio[1068]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:2ipYQ6pcabz1NovVrr9LKH","name":"Fighting Myself","artist_names":["Linkin Park"],"album_name":"Meteora 20th Anniversary Edition","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02ca2e09fd52e6330146ea9550","position":0,"duration":201428,"release_date":"year:2023 month:4 day:7","track_number":2,"disc_number":6}} Aug 18 18:12:11 rasptouch go-librespot[1257]: time="2024-08-18T18:12:11Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 18 18:12:11 rasptouch go-librespot[1257]: time="2024-08-18T18:12:11Z" level=trace msg="emitting websocket event: playing" Aug 18 18:12:11 rasptouch volumio[1068]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:2ipYQ6pcabz1NovVrr9LKH","play_origin":"playlist"}} Aug 18 18:12:11 rasptouch volumio[1068]: SPOTIFY: PUSH STATE SPOTIFY Aug 18 18:12:11 rasptouch volumio[1068]: SPOTIFY: {"status":"play","service":"spop","title":"Fighting Myself","artist":"Linkin Park","album":"Meteora 20th Anniversary Edition","albumart":"https://i.scdn.co/image/ab67616d00001e02ca2e09fd52e6330146ea9550","uri":"spotify:track:2ipYQ6pcabz1NovVrr9LKH","trackType":"spotify","seek":0,"duration":201,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 18 18:12:11 rasptouch volumio[1068]: info: CoreCommandRouter::servicePushState Aug 18 18:12:11 rasptouch volumio[1068]: info: CoreStateMachine::pushState Aug 18 18:12:11 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 18:12:11 rasptouch volumio[1068]: info: CoreCommandRouter::volumioPushState Aug 18 18:12:11 rasptouch volumio[1068]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 18 18:12:12 rasptouch volumio[1068]: SPOTIFY: PUSH STATE SPOTIFY Aug 18 18:12:12 rasptouch volumio[1068]: SPOTIFY: {"status":"play","service":"spop","title":"Fighting Myself","artist":"Linkin Park","album":"Meteora 20th Anniversary Edition","albumart":"https://i.scdn.co/image/ab67616d00001e02ca2e09fd52e6330146ea9550","uri":"spotify:track:2ipYQ6pcabz1NovVrr9LKH","trackType":"spotify","seek":0,"duration":201,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Aug 18 18:12:12 rasptouch volumio[1068]: info: CoreCommandRouter::servicePushState Aug 18 18:12:12 rasptouch volumio[1068]: info: CoreStateMachine::pushState Aug 18 18:12:12 rasptouch volumio[1068]: info: CoreCommandRouter::volumioPushState Aug 18 18:12:12 rasptouch volumio[1068]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Aug 18 18:12:12 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 18 18:12:12 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 18 18:12:17 rasptouch volumio[1068]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 18:12:24 rasptouch go-librespot[1257]: time="2024-08-18T18:12:24Z" level=debug msg="fetched chunk 4/14, size: 524288" uri="spotify:track:2ipYQ6pcabz1NovVrr9LKH" Aug 18 18:12:35 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 18 18:12:35 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 18 18:12:38 rasptouch go-librespot[1257]: time="2024-08-18T18:12:38Z" level=debug msg="fetched chunk 5/14, size: 524288" uri="spotify:track:2ipYQ6pcabz1NovVrr9LKH" Aug 18 18:12:43 rasptouch volumio[1068]: info: Enabling plugin audiophonicsonoff Aug 18 18:12:43 rasptouch volumio[1068]: info: Loading plugin "audiophonicsonoff"... Aug 18 18:12:43 rasptouch volumio[1068]: info: Applying required configuration parameters for plugin audiophonicsonoff Aug 18 18:12:43 rasptouch volumio[1068]: info: Audiophonics on/off initiated Aug 18 18:12:43 rasptouch volumio[1068]: info: PLUGIN START: audiophonicsonoff Aug 18 18:12:43 rasptouch volumio[1068]: info: Configuring GPIO pins Aug 18 18:12:43 rasptouch volumio[1068]: info: Error: Error: EBUSY: resource busy or locked, write Aug 18 18:12:47 rasptouch volumio[1068]: info: Enabling plugin touch_display Aug 18 18:12:47 rasptouch volumio[1068]: info: Loading plugin "touch_display"... Aug 18 18:12:47 rasptouch volumio[1068]: info: Applying required configuration parameters for plugin touch_display Aug 18 18:12:47 rasptouch volumio[1068]: info: PLUGIN START: touch_display Aug 18 18:12:47 rasptouch volumio[1068]: info: Loading i18n strings for locale fr Aug 18 18:12:47 rasptouch sudo[2409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Aug 18 18:12:47 rasptouch sudo[2409]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 18:12:47 rasptouch systemd[1]: Reloading. Aug 18 18:12:47 rasptouch 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. Aug 18 18:12:48 rasptouch sudo[2409]: pam_unix(sudo:session): session closed for user root Aug 18 18:12:48 rasptouch volumio[1068]: info: touch_display: systemctl daemon-reload succeeded. Aug 18 18:12:48 rasptouch sudo[2425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Aug 18 18:12:48 rasptouch sudo[2425]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 18:12:48 rasptouch systemd[1]: Started Volumio Kiosk. Aug 18 18:12:48 rasptouch sudo[2425]: pam_unix(sudo:session): session closed for user root Aug 18 18:12:48 rasptouch volumio[1068]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Aug 18 18:12:48 rasptouch volumio[1068]: info: touch_display: Volumio Kiosk started Aug 18 18:12:48 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 18 18:12:48 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:12:48 rasptouch volumio[1068]: info: Done. Aug 18 18:12:48 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:12:48 rasptouch volumio[1068]: info: touch_display: Raspberry Pi Foundation touch screen detected. Aug 18 18:12:48 rasptouch volumio[1068]: info: touch_display: Backlight module of a Raspberry Pi Foundation touch screen detected. Aug 18 18:12:48 rasptouch volumio[1068]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X Aug 18 18:12:48 rasptouch sudo[2456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/devices/platform/rpi_backlight/backlight/rpi_backlight/brightness Aug 18 18:12:48 rasptouch sudo[2456]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 18:12:48 rasptouch startx[2427]: X.Org X Server 1.20.4 Aug 18 18:12:48 rasptouch startx[2427]: X Protocol Version 11, Revision 0 Aug 18 18:12:48 rasptouch startx[2427]: Build Operating System: Linux 5.4.0-72-generic armv8l Raspbian Aug 18 18:12:48 rasptouch startx[2427]: Current Operating System: Linux rasptouch 6.1.69-v7+ #1710 SMP Thu Dec 21 13:14:13 GMT 2023 armv7l Aug 18 18:12:48 rasptouch startx[2427]: 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=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 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=UUID=133b61d2-daf2-4237-92be-25beb421aa33 imgfile=/volumio_current.sqsh bootpart=UUID=6C7C-4C43 datapart=UUID=5caf4c4e-188e-4b64-b123-95a48a4d4e8c uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 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 nodebug use_kmsg=no Aug 18 18:12:48 rasptouch startx[2427]: Build Date: 04 January 2022 10:05:34AM Aug 18 18:12:48 rasptouch startx[2427]: xorg-server 2:1.20.4-1+rpt4+deb10u4 (https://www.debian.org/support) Aug 18 18:12:48 rasptouch startx[2427]: Current version of pixman: 0.36.0 Aug 18 18:12:48 rasptouch startx[2427]: Before reporting problems, check http://wiki.x.org Aug 18 18:12:48 rasptouch startx[2427]: to make sure that you have the latest version. Aug 18 18:12:48 rasptouch startx[2427]: Markers: (--) probed, (**) from config file, (==) default setting, Aug 18 18:12:48 rasptouch startx[2427]: (++) from command line, (!!) notice, (II) informational, Aug 18 18:12:48 rasptouch startx[2427]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Aug 18 18:12:48 rasptouch startx[2427]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Aug 18 18:12:48 2024 Aug 18 18:12:48 rasptouch startx[2427]: (==) Using config directory: "/etc/X11/xorg.conf.d" Aug 18 18:12:48 rasptouch startx[2427]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Aug 18 18:12:48 rasptouch sudo[2456]: pam_unix(sudo:session): session closed for user root Aug 18 18:12:48 rasptouch volumio[1068]: info: touch_display: File permissions for backlight brightness control set. Aug 18 18:12:48 rasptouch volumio[1068]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Aug 18 18:12:48 rasptouch sudo[2452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Aug 18 18:12:48 rasptouch sudo[2452]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 18:12:48 rasptouch sudo[2452]: pam_unix(sudo:session): session closed for user root Aug 18 18:12:48 rasptouch volumio[1068]: info: touch_display: Touchscreen transformation matrix removed. Aug 18 18:12:48 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:12:48 rasptouch volumio[1068]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Aug 18 18:12:49 rasptouch volumio[1068]: info: touch_display: Setting screensaver timeout to 0 seconds. Aug 18 18:12:50 rasptouch go-librespot[1257]: time="2024-08-18T18:12:50Z" level=debug msg="fetched chunk 6/14, size: 524288" uri="spotify:track:2ipYQ6pcabz1NovVrr9LKH" Aug 18 18:12:55 rasptouch volumio[1068]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 18:12:55 rasptouch volumio[1068]: info: Loaded the previous config. Aug 18 18:12:55 rasptouch volumio[1068]: info: ## populating UI... Aug 18 18:12:55 rasptouch volumio[1068]: info: 1/1 settings loaded Aug 18 18:12:55 rasptouch volumio[1068]: info: Populated config screen. Aug 18 18:12:56 rasptouch volumio[1068]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 18 18:12:57 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 18 18:12:57 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 18 18:12:58 rasptouch volumio[1068]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 18 18:13:00 rasptouch volumio[1068]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetVisibleSources Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 18 18:13:01 rasptouch volumio[1068]: info: Received Get System Info Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 18 18:13:01 rasptouch volumio[1068]: info: Discovery: Getting this device information Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:13:01 rasptouch volumio[1068]: info: Listing playlists Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 18 18:13:01 rasptouch volumio[1068]: info: Received Get System Info Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 18 18:13:01 rasptouch volumio[1068]: info: Discovery: Getting this device information Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetVisibleSources Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 18 18:13:01 rasptouch volumio[1068]: info: Received Get System Info Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 18 18:13:01 rasptouch volumio[1068]: info: Discovery: Getting this device information Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:13:01 rasptouch volumio[1068]: info: Listing playlists Aug 18 18:13:01 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 18 18:13:03 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 18 18:13:03 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 18 18:13:03 rasptouch volumio[1068]: info: Received Get System Info Aug 18 18:13:03 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 18 18:13:03 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 18 18:13:03 rasptouch volumio[1068]: info: Discovery: Getting this device information Aug 18 18:13:03 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:13:03 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 18 18:13:04 rasptouch go-librespot[1257]: time="2024-08-18T18:13:04Z" level=debug msg="fetched chunk 7/14, size: 524288" uri="spotify:track:2ipYQ6pcabz1NovVrr9LKH" Aug 18 18:13:08 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 18 18:13:16 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 18 18:13:16 rasptouch volumio[1068]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 18 18:13:16 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 18 18:13:16 rasptouch volumio[1068]: info: Received Get System Version Aug 18 18:13:16 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 18 18:13:16 rasptouch volumio[1068]: info: Received Get System Info Aug 18 18:13:16 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 18 18:13:16 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 18 18:13:16 rasptouch volumio[1068]: info: Discovery: Getting this device information Aug 18 18:13:16 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:13:16 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 18 18:13:18 rasptouch go-librespot[1257]: time="2024-08-18T18:13:18Z" level=debug msg="fetched chunk 8/14, size: 524288" uri="spotify:track:2ipYQ6pcabz1NovVrr9LKH" Aug 18 18:13:31 rasptouch go-librespot[1257]: time="2024-08-18T18:13:31Z" level=debug msg="fetched chunk 9/14, size: 524288" uri="spotify:track:2ipYQ6pcabz1NovVrr9LKH" Aug 18 18:13:38 rasptouch volumio[1068]: info: CALLMETHOD: system_controller audiophonicsonoff updateButtonConfig [object Object] Aug 18 18:13:38 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: audiophonicsonoff , updateButtonConfig Aug 18 18:13:41 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 18 18:13:41 rasptouch volumio[1068]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 18 18:13:45 rasptouch go-librespot[1257]: time="2024-08-18T18:13:45Z" level=debug msg="fetched chunk 10/14, size: 524288" uri="spotify:track:2ipYQ6pcabz1NovVrr9LKH" Aug 18 18:13:49 rasptouch volumio[1068]: info: CoreCommandRouter::volumioGetState Aug 18 18:13:55 rasptouch volumio[1068]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Aug 18 18:13:55 rasptouch volumio[1068]: info: PLUGIN onReboot : networkfs Aug 18 18:13:55 rasptouch volumio[1068]: info: PLUGIN onReboot : audiophonicsonoff Aug 18 18:13:55 rasptouch volumio[1068]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 18:13:55 rasptouch volumio[1068]: TypeError: Cannot read property 'writeSync' of undefined Aug 18 18:13:55 rasptouch volumio[1068]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Aug 18 18:13:55 rasptouch volumio[1068]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Aug 18 18:13:55 rasptouch volumio[1068]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Aug 18 18:13:55 rasptouch volumio[1068]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Aug 18 18:13:55 rasptouch volumio[1068]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Aug 18 18:13:55 rasptouch volumio[1068]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Aug 18 18:13:55 rasptouch volumio[1068]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22) Aug 18 18:13:55 rasptouch volumio[1068]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Aug 18 18:13:55 rasptouch volumio[1068]: at Socket.emit (events.js:315:20) Aug 18 18:13:55 rasptouch volumio[1068]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 18 18:13:55 rasptouch volumio[1068]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 18 18:13:55 rasptouch volumio[1068]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 18:13:56 rasptouch sudo[2896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-18 18:12 Aug 18 18:13:56 rasptouch sudo[2896]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"