-- Logs begin at Fri 2024-10-18 12:09:32 CEST, end at Sat 2024-10-19 23:39:17 CEST. -- Oct 19 23:38:27 volumio volumio[980]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" but was never pressed. Did you set the correct Push Button logic? Oct 19 23:38:35 volumio volumio[980]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. Oct 19 23:38:35 volumio volumio[980]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. Oct 19 23:38:46 volumio volumio[980]: info: CALLMETHOD: system_hardware rotaryencoder2 updateEncoder [object Object] Oct 19 23:38:46 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: rotaryencoder2 , updateEncoder Oct 19 23:38:46 volumio volumio[980]: error: [ROTARYENCODER2] detachListener: could not kill handler process [object Object] Oct 19 23:38:46 volumio sudo[24252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Oct 19 23:38:46 volumio sudo[24252]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:38:46 volumio sudo[24252]: pam_unix(sudo:session): session closed for user root Oct 19 23:38:46 volumio sudo[24255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r 0 Oct 19 23:38:46 volumio sudo[24255]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:38:46 volumio kernel: OF: ERROR: memory leak, expected refcount 1 instead of 2, of_node_get()/of_node_put() unbalanced - destroy cset entry: attach overlay node /rotary@17 Oct 19 23:38:46 volumio kernel: ------------[ cut here ]------------ Oct 19 23:38:46 volumio kernel: WARNING: CPU: 0 PID: 23046 at lib/refcount.c:25 kobject_get+0xa0/0xa4 Oct 19 23:38:46 volumio kernel: refcount_t: addition on 0; use-after-free. Oct 19 23:38:46 volumio kernel: Modules linked in: rotary_encoder cmac bnep nft_chain_nat xt_REDIRECT nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 xt_tcpudp nft_compat nf_tables nfnetlink 8021q garp stp llc snd_usb_audio snd_hwdep snd_usbmidi_lib snd_seq_midi joydev snd_seq_midi_event snd_rawmidi sg hci_uart hid_multitouch brcmfmac snd_bcm2835(C) btbcm bluetooth snd_pcm brcmutil snd_seq cfg80211 rpivid_hevc(C) bcm2835_codec(C) ecdh_generic bcm2835_isp(C) ecc v4l2_mem2mem bcm2835_v4l2(C) snd_seq_device bcm2835_mmal_vchiq(C) snd_timer videobuf2_vmalloc videobuf2_dma_contig videobuf2_memops videobuf2_v4l2 rfkill videobuf2_common vc_sm_cma(C) snd videodev i2c_bcm2835 raspberrypi_hwmon mc raspberrypi_gpiomem ir_rc6_decoder uio_pdrv_genirq gpio_ir_recv nvmem_rmem uio i2c_dev ip_tables x_tables ipv6 squashfs overlay nls_iso8859_1 fuse drm drm_panel_orientation_quirks backlight Oct 19 23:38:46 volumio kernel: CPU: 0 PID: 23046 Comm: kworker/0:2 Tainted: G C 6.1.69-v7l+ #1710 Oct 19 23:38:46 volumio kernel: Hardware name: BCM2711 Oct 19 23:38:46 volumio kernel: Workqueue: events_long device_link_release_fn Oct 19 23:38:46 volumio kernel: unwind_backtrace from show_stack+0x18/0x1c Oct 19 23:38:46 volumio kernel: show_stack from dump_stack_lvl+0x68/0x8c Oct 19 23:38:46 volumio kernel: dump_stack_lvl from __warn+0x84/0x124 Oct 19 23:38:46 volumio kernel: __warn from warn_slowpath_fmt+0x11c/0x184 Oct 19 23:38:46 volumio kernel: warn_slowpath_fmt from kobject_get+0xa0/0xa4 Oct 19 23:38:46 volumio kernel: kobject_get from of_node_get+0x1c/0x24 Oct 19 23:38:46 volumio kernel: of_node_get from of_fwnode_get+0x3c/0x48 Oct 19 23:38:46 volumio kernel: of_fwnode_get from fwnode_full_name_string+0x34/0xa0 Oct 19 23:38:46 volumio kernel: fwnode_full_name_string from device_node_string+0x298/0x4f0 Oct 19 23:38:46 volumio kernel: device_node_string from pointer+0x3e8/0x5f0 Oct 19 23:38:46 volumio kernel: pointer from vsnprintf+0x114/0x3b0 Oct 19 23:38:46 volumio kernel: vsnprintf from vprintk_store+0x124/0x460 Oct 19 23:38:46 volumio kernel: vprintk_store from vprintk_emit+0x140/0x324 Oct 19 23:38:46 volumio kernel: vprintk_emit from vprintk_default+0x28/0x30 Oct 19 23:38:46 volumio kernel: vprintk_default from _printk+0x38/0x5c Oct 19 23:38:46 volumio kernel: _printk from kobject_put+0x98/0x100 Oct 19 23:38:46 volumio kernel: kobject_put from platform_device_release+0x18/0x44 Oct 19 23:38:46 volumio kernel: platform_device_release from device_release+0x38/0xa8 Oct 19 23:38:46 volumio kernel: device_release from kobject_put+0x98/0x100 Oct 19 23:38:46 volumio kernel: kobject_put from device_link_release_fn+0x4c/0xb0 Oct 19 23:38:46 volumio kernel: device_link_release_fn from process_one_work+0x244/0x508 Oct 19 23:38:46 volumio kernel: process_one_work from worker_thread+0x48/0x558 Oct 19 23:38:46 volumio kernel: worker_thread from kthread+0xe4/0x100 Oct 19 23:38:46 volumio kernel: kthread from ret_from_fork+0x14/0x30 Oct 19 23:38:46 volumio kernel: Exception stack(0xf3a49fb0 to 0xf3a49ff8) Oct 19 23:38:46 volumio kernel: 9fa0: 00000000 00000000 00000000 00000000 Oct 19 23:38:46 volumio kernel: 9fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Oct 19 23:38:46 volumio kernel: 9fe0: 00000000 00000000 00000000 00000000 00000013 00000000 Oct 19 23:38:46 volumio kernel: ---[ end trace 0000000000000000 ]--- Oct 19 23:38:46 volumio kernel: ------------[ cut here ]------------ Oct 19 23:38:46 volumio kernel: WARNING: CPU: 0 PID: 23046 at lib/refcount.c:28 fwnode_full_name_string+0x8c/0xa0 Oct 19 23:38:46 volumio kernel: refcount_t: underflow; use-after-free. Oct 19 23:38:46 volumio kernel: Modules linked in: rotary_encoder cmac bnep nft_chain_nat xt_REDIRECT nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 xt_tcpudp nft_compat nf_tables nfnetlink 8021q garp stp llc snd_usb_audio snd_hwdep snd_usbmidi_lib snd_seq_midi joydev snd_seq_midi_event snd_rawmidi sg hci_uart hid_multitouch brcmfmac snd_bcm2835(C) btbcm bluetooth snd_pcm brcmutil snd_seq cfg80211 rpivid_hevc(C) bcm2835_codec(C) ecdh_generic bcm2835_isp(C) ecc v4l2_mem2mem bcm2835_v4l2(C) snd_seq_device bcm2835_mmal_vchiq(C) snd_timer videobuf2_vmalloc videobuf2_dma_contig videobuf2_memops videobuf2_v4l2 rfkill videobuf2_common vc_sm_cma(C) snd videodev i2c_bcm2835 raspberrypi_hwmon mc raspberrypi_gpiomem ir_rc6_decoder uio_pdrv_genirq gpio_ir_recv nvmem_rmem uio i2c_dev ip_tables x_tables ipv6 squashfs overlay nls_iso8859_1 fuse drm drm_panel_orientation_quirks backlight Oct 19 23:38:46 volumio kernel: CPU: 0 PID: 23046 Comm: kworker/0:2 Tainted: G WC 6.1.69-v7l+ #1710 Oct 19 23:38:46 volumio kernel: Hardware name: BCM2711 Oct 19 23:38:46 volumio kernel: Workqueue: events_long device_link_release_fn Oct 19 23:38:46 volumio kernel: unwind_backtrace from show_stack+0x18/0x1c Oct 19 23:38:46 volumio kernel: show_stack from dump_stack_lvl+0x68/0x8c Oct 19 23:38:46 volumio kernel: dump_stack_lvl from __warn+0x84/0x124 Oct 19 23:38:46 volumio kernel: __warn from warn_slowpath_fmt+0x11c/0x184 Oct 19 23:38:46 volumio kernel: warn_slowpath_fmt from fwnode_full_name_string+0x8c/0xa0 Oct 19 23:38:46 volumio kernel: fwnode_full_name_string from device_node_string+0x298/0x4f0 Oct 19 23:38:46 volumio kernel: device_node_string from pointer+0x3e8/0x5f0 Oct 19 23:38:46 volumio kernel: pointer from vsnprintf+0x114/0x3b0 Oct 19 23:38:46 volumio kernel: vsnprintf from vprintk_store+0x124/0x460 Oct 19 23:38:46 volumio kernel: vprintk_store from vprintk_emit+0x140/0x324 Oct 19 23:38:46 volumio kernel: vprintk_emit from vprintk_default+0x28/0x30 Oct 19 23:38:46 volumio kernel: vprintk_default from _printk+0x38/0x5c Oct 19 23:38:46 volumio kernel: _printk from kobject_put+0x98/0x100 Oct 19 23:38:46 volumio kernel: kobject_put from platform_device_release+0x18/0x44 Oct 19 23:38:46 volumio kernel: platform_device_release from device_release+0x38/0xa8 Oct 19 23:38:46 volumio kernel: device_release from kobject_put+0x98/0x100 Oct 19 23:38:46 volumio kernel: kobject_put from device_link_release_fn+0x4c/0xb0 Oct 19 23:38:46 volumio kernel: device_link_release_fn from process_one_work+0x244/0x508 Oct 19 23:38:46 volumio kernel: process_one_work from worker_thread+0x48/0x558 Oct 19 23:38:46 volumio kernel: worker_thread from kthread+0xe4/0x100 Oct 19 23:38:46 volumio kernel: kthread from ret_from_fork+0x14/0x30 Oct 19 23:38:46 volumio kernel: Exception stack(0xf3a49fb0 to 0xf3a49ff8) Oct 19 23:38:46 volumio kernel: 9fa0: 00000000 00000000 00000000 00000000 Oct 19 23:38:46 volumio kernel: 9fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Oct 19 23:38:46 volumio kernel: 9fe0: 00000000 00000000 00000000 00000000 00000013 00000000 Oct 19 23:38:46 volumio kernel: ---[ end trace 0000000000000000 ]--- Oct 19 23:38:46 volumio kernel: OF: ERROR: memory leak before free overlay changeset, /rotary@17 Oct 19 23:38:46 volumio kernel: ------------[ cut here ]------------ Oct 19 23:38:46 volumio kernel: WARNING: CPU: 0 PID: 23046 at lib/refcount.c:22 kobject_get+0x8c/0xa4 Oct 19 23:38:46 volumio kernel: refcount_t: saturated; leaking memory. Oct 19 23:38:46 volumio kernel: Modules linked in: rotary_encoder cmac bnep nft_chain_nat xt_REDIRECT nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 xt_tcpudp nft_compat nf_tables nfnetlink 8021q garp stp llc snd_usb_audio snd_hwdep snd_usbmidi_lib snd_seq_midi joydev snd_seq_midi_event snd_rawmidi sg hci_uart hid_multitouch brcmfmac snd_bcm2835(C) btbcm bluetooth snd_pcm brcmutil snd_seq cfg80211 rpivid_hevc(C) bcm2835_codec(C) ecdh_generic bcm2835_isp(C) ecc v4l2_mem2mem bcm2835_v4l2(C) snd_seq_device bcm2835_mmal_vchiq(C) snd_timer videobuf2_vmalloc videobuf2_dma_contig videobuf2_memops videobuf2_v4l2 rfkill videobuf2_common vc_sm_cma(C) snd videodev i2c_bcm2835 raspberrypi_hwmon mc raspberrypi_gpiomem ir_rc6_decoder uio_pdrv_genirq gpio_ir_recv nvmem_rmem uio i2c_dev ip_tables x_tables ipv6 squashfs overlay nls_iso8859_1 fuse drm drm_panel_orientation_quirks backlight Oct 19 23:38:46 volumio kernel: CPU: 0 PID: 23046 Comm: kworker/0:2 Tainted: G WC 6.1.69-v7l+ #1710 Oct 19 23:38:46 volumio kernel: Hardware name: BCM2711 Oct 19 23:38:46 volumio kernel: Workqueue: events_long device_link_release_fn Oct 19 23:38:46 volumio kernel: unwind_backtrace from show_stack+0x18/0x1c Oct 19 23:38:46 volumio kernel: show_stack from dump_stack_lvl+0x68/0x8c Oct 19 23:38:46 volumio kernel: dump_stack_lvl from __warn+0x84/0x124 Oct 19 23:38:46 volumio kernel: __warn from warn_slowpath_fmt+0x11c/0x184 Oct 19 23:38:46 volumio kernel: warn_slowpath_fmt from kobject_get+0x8c/0xa4 Oct 19 23:38:46 volumio kernel: kobject_get from of_node_get+0x1c/0x24 Oct 19 23:38:46 volumio kernel: of_node_get from of_fwnode_get+0x3c/0x48 Oct 19 23:38:46 volumio kernel: of_fwnode_get from fwnode_full_name_string+0x34/0xa0 Oct 19 23:38:46 volumio kernel: fwnode_full_name_string from device_node_string+0x298/0x4f0 Oct 19 23:38:46 volumio kernel: device_node_string from pointer+0x3e8/0x5f0 Oct 19 23:38:46 volumio kernel: pointer from vsnprintf+0x114/0x3b0 Oct 19 23:38:46 volumio kernel: vsnprintf from vscnprintf+0x14/0x28 Oct 19 23:38:46 volumio kernel: vscnprintf from printk_sprint+0x24/0x164 Oct 19 23:38:46 volumio kernel: printk_sprint from vprintk_store+0x3c4/0x460 Oct 19 23:38:46 volumio kernel: vprintk_store from vprintk_emit+0x140/0x324 Oct 19 23:38:46 volumio kernel: vprintk_emit from vprintk_default+0x28/0x30 Oct 19 23:38:46 volumio kernel: vprintk_default from _printk+0x38/0x5c Oct 19 23:38:46 volumio kernel: _printk from kobject_put+0x98/0x100 Oct 19 23:38:46 volumio kernel: kobject_put from platform_device_release+0x18/0x44 Oct 19 23:38:46 volumio kernel: platform_device_release from device_release+0x38/0xa8 Oct 19 23:38:46 volumio kernel: device_release from kobject_put+0x98/0x100 Oct 19 23:38:46 volumio kernel: kobject_put from device_link_release_fn+0x4c/0xb0 Oct 19 23:38:46 volumio kernel: device_link_release_fn from process_one_work+0x244/0x508 Oct 19 23:38:46 volumio kernel: process_one_work from worker_thread+0x48/0x558 Oct 19 23:38:46 volumio kernel: worker_thread from kthread+0xe4/0x100 Oct 19 23:38:46 volumio kernel: kthread from ret_from_fork+0x14/0x30 Oct 19 23:38:46 volumio kernel: Exception stack(0xf3a49fb0 to 0xf3a49ff8) Oct 19 23:38:46 volumio kernel: 9fa0: 00000000 00000000 00000000 00000000 Oct 19 23:38:46 volumio kernel: 9fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000 Oct 19 23:38:46 volumio kernel: 9fe0: 00000000 00000000 00000000 00000000 00000013 00000000 Oct 19 23:38:46 volumio kernel: ---[ end trace 0000000000000000 ]--- Oct 19 23:38:46 volumio sudo[24255]: pam_unix(sudo:session): session closed for user root Oct 19 23:38:46 volumio sudo[24268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Oct 19 23:38:46 volumio sudo[24268]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:38:46 volumio sudo[24268]: pam_unix(sudo:session): session closed for user root Oct 19 23:38:46 volumio sudo[24271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=4 Oct 19 23:38:46 volumio sudo[24271]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:38:46 volumio kernel: rotary-encoder rotary@17: gray Oct 19 23:38:46 volumio kernel: input: rotary@17 as /devices/platform/rotary@17/input/input5 Oct 19 23:38:46 volumio sudo[24271]: pam_unix(sudo:session): session closed for user root Oct 19 23:38:46 volumio systemd-udevd[24263]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Oct 19 23:38:54 volumio volumio[980]: info: CoreCommandRouter::volumioGetState Oct 19 23:38:54 volumio volumio[980]: info: CorePlayQueue::getTrack 12 Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 19 23:39:04 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 19 23:39:11 volumio volumio[980]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::volumioGetState Oct 19 23:39:11 volumio volumio[980]: info: CorePlayQueue::getTrack 12 Oct 19 23:39:11 volumio volumio[980]: info: Restoring Previous Volume level: 100 false true Oct 19 23:39:11 volumio volumio[980]: info: VolumeController::SetAlsaVolume100 Oct 19 23:39:11 volumio volumio[980]: info: Enable softmixer device for audio device number 5 Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::volumioStop Oct 19 23:39:11 volumio volumio[980]: info: CoreStateMachine::stop Oct 19 23:39:11 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 23:39:11 volumio volumio[980]: info: CoreStateMachine::stPlaybackTimer Oct 19 23:39:11 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock Oct 19 23:39:11 volumio volumio[980]: info: CorePlayQueue::getTrackBlock Oct 19 23:39:11 volumio volumio[980]: info: CoreStateMachine::pushState Oct 19 23:39:11 volumio volumio[980]: info: CorePlayQueue::getTrack 12 Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Oct 19 23:39:11 volumio volumio[980]: info: CoreStateMachine::serviceStop Oct 19 23:39:11 volumio volumio[980]: info: CorePlayQueue::getTrack 12 Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::serviceStop Oct 19 23:39:11 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 19 23:39:11 volumio volumio[980]: info: ControllerMpd::stop Oct 19 23:39:11 volumio volumio[980]: verbose: ControllerMpd::sendMpdCommand stop Oct 19 23:39:11 volumio volumio[980]: info: Enable softmixer device for audio device undefined Oct 19 23:39:11 volumio volumio[980]: info: Output device has changed, restarting MPD Oct 19 23:39:11 volumio sudo[24347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 19 23:39:11 volumio sudo[24347]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:11 volumio sudo[24347]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:11 volumio volumio[980]: info: Output device has changed, restarting Shairport Sync Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 23:39:11 volumio sudo[24351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 19 23:39:11 volumio sudo[24351]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:11 volumio systemd[1]: Stopping Music Player Daemon... Oct 19 23:39:11 volumio volumio[980]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 19 23:39:11 volumio volumio[980]: info: Volume configurations have been set Oct 19 23:39:11 volumio systemd[1]: mpd.service: Succeeded. Oct 19 23:39:11 volumio systemd[1]: Stopped Music Player Daemon. Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 19 23:39:11 volumio volumio[980]: info: Updating Volume Controller Parameters: Device: 5 Name: Combo384 Amanero Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 19 23:39:11 volumio volumio[980]: info: Disabling external Volume Control Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 19 23:39:11 volumio volumio[980]: info: CoreStateMachine::pushState Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Oct 19 23:39:11 volumio volumio[980]: error: MPD error: Error: write EPIPE Oct 19 23:39:11 volumio volumio[980]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Oct 19 23:39:11 volumio volumio[980]: info: [ASDebug] CurState: stop PrevState: play Oct 19 23:39:11 volumio volumio[980]: info: [ASDebug] InitTimeout - Amp off in: 0 ms Oct 19 23:39:11 volumio volumio[980]: info: [ASDebug] CurState: play PrevState: play Oct 19 23:39:11 volumio systemd[1]: Starting Music Player Daemon... Oct 19 23:39:11 volumio sudo[24358]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 19 23:39:11 volumio sudo[24358]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:11 volumio volumio[980]: info: CoreStateMachine::pushState Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Oct 19 23:39:11 volumio sudo[24358]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:11 volumio volumio[980]: info: MPD Permissions set Oct 19 23:39:11 volumio volumio[980]: info: [ASDebug] CurState: play PrevState: play Oct 19 23:39:11 volumio volumio[980]: info: touch_display: Setting screensaver timeout to 600 seconds. Oct 19 23:39:11 volumio volumio[980]: info: Software Volume ALSA configuration written Oct 19 23:39:11 volumio volumio[980]: info: Preparing to generate the ALSA configuration file Oct 19 23:39:11 volumio volumio[980]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 19 23:39:11 volumio volumio[980]: info: Reading ALSA contributions from plugins. Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:11 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 19 23:39:12 volumio volumio[980]: info: touch_display: Setting screensaver timeout to 0 seconds. Oct 19 23:39:12 volumio volumio[980]: info: Starting Shairport Sync Oct 19 23:39:12 volumio volumio[980]: info: Asound.conf file written Oct 19 23:39:12 volumio sudo[24383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 19 23:39:12 volumio sudo[24383]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:12 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 19 23:39:12 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 19 23:39:12 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 19 23:39:12 volumio sudo[24386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 19 23:39:12 volumio sudo[24386]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 19 23:39:12 volumio sudo[24386]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:12 volumio sudo[24383]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:12 volumio volumio[980]: info: Output device has changed, restarting MPD Oct 19 23:39:12 volumio sudo[24394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 19 23:39:12 volumio sudo[24394]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:12 volumio volumio[980]: info: Output device has changed, restarting Shairport Sync Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:12 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 23:39:12 volumio sudo[24394]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:12 volumio sudo[24397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 19 23:39:12 volumio sudo[24397]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:12 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 19 23:39:12 volumio systemd[1]: mpd.service: Succeeded. Oct 19 23:39:12 volumio systemd[1]: Stopped Music Player Daemon. Oct 19 23:39:12 volumio volumio[980]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 19 23:39:12 volumio systemd[1]: Starting Music Player Daemon... Oct 19 23:39:12 volumio sudo[24402]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 19 23:39:12 volumio sudo[24402]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:12 volumio sudo[24402]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:13 volumio mpd[24407]: Oct 19 23:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 19 23:39:13 volumio systemd[1]: Started Music Player Daemon. Oct 19 23:39:13 volumio sudo[24397]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:13 volumio sudo[24351]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:14 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 9 Oct 19 23:39:14 volumio kernel: xhci_hcd 0000:01:00.0: @000000042a119130 00000000 00000000 0e000000 020a8001 Oct 19 23:39:14 volumio volumio[980]: Playing WAVE '/volumio/app/silence.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 19 23:39:14 volumio volumio[980]: info: Output device has changed, restarting MPD Oct 19 23:39:14 volumio sudo[24413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 19 23:39:14 volumio sudo[24413]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:14 volumio sudo[24413]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:14 volumio volumio[980]: info: Output device has changed, restarting Shairport Sync Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 23:39:14 volumio sudo[24416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 19 23:39:14 volumio sudo[24416]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:14 volumio systemd[1]: Stopping Music Player Daemon... Oct 19 23:39:14 volumio volumio[980]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 19 23:39:14 volumio systemd[1]: mpd.service: Succeeded. Oct 19 23:39:14 volumio systemd[1]: Stopped Music Player Daemon. Oct 19 23:39:14 volumio systemd[1]: Starting Music Player Daemon... Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 19 23:39:14 volumio volumio[980]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 19 23:39:14 volumio volumio[980]: info: Disabling external Volume Control Oct 19 23:39:14 volumio volumio[980]: error: Upnp client error: Error: This socket has been ended by the other party Oct 19 23:39:14 volumio volumio[980]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Oct 19 23:39:14 volumio volumio[980]: info: MPD Permissions set Oct 19 23:39:14 volumio sudo[24421]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 19 23:39:14 volumio sudo[24421]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:14 volumio volumio[980]: info: MPD Permissions set Oct 19 23:39:14 volumio volumio[980]: info: Shairport-Sync Started Oct 19 23:39:14 volumio sudo[24421]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:14 volumio volumio[980]: info: CoreStateMachine::pushState Oct 19 23:39:14 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Oct 19 23:39:14 volumio volumio[980]: info: [ASDebug] CurState: play PrevState: play Oct 19 23:39:14 volumio volumio[980]: info: Starting Shairport Sync Oct 19 23:39:14 volumio volumio[980]: info: Starting Shairport Sync Oct 19 23:39:14 volumio sudo[24442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 19 23:39:14 volumio sudo[24442]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 19 23:39:14 volumio sudo[24445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 19 23:39:14 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 19 23:39:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 19 23:39:14 volumio sudo[24445]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 19 23:39:14 volumio sudo[24442]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:14 volumio volumio[980]: info: Shairport-Sync Started Oct 19 23:39:14 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 19 23:39:14 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 19 23:39:14 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 19 23:39:14 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 19 23:39:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 19 23:39:14 volumio sudo[24445]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:14 volumio volumio[980]: info: Shairport-Sync Started Oct 19 23:39:15 volumio mpd[24432]: Oct 19 23:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 19 23:39:15 volumio systemd[1]: Started Music Player Daemon. Oct 19 23:39:15 volumio sudo[24416]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:15 volumio volumio[980]: error: MPD error: The expression evaluated to a falsy value: Oct 19 23:39:15 volumio volumio[980]: assert.ok(self.idling) Oct 19 23:39:15 volumio volumio[980]: error: The expression evaluated to a falsy value: Oct 19 23:39:15 volumio volumio[980]: assert.ok(self.idling) Oct 19 23:39:15 volumio volumio[980]: error: updateQueue error: null Oct 19 23:39:15 volumio volumio[980]: error: updateQueue error: null Oct 19 23:39:15 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 19 23:39:15 volumio sudo[24457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 19 23:39:15 volumio sudo[24457]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:15 volumio systemd[1]: Stopping Music Player Daemon... Oct 19 23:39:15 volumio systemd[1]: mpd.service: Succeeded. Oct 19 23:39:15 volumio systemd[1]: Stopped Music Player Daemon. Oct 19 23:39:15 volumio systemd[1]: Starting Music Player Daemon... Oct 19 23:39:15 volumio sudo[24459]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 19 23:39:15 volumio sudo[24459]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 19 23:39:15 volumio sudo[24459]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:16 volumio volumio[980]: error: Upnp client error: Error: This socket has been ended by the other party Oct 19 23:39:16 volumio volumio[980]: info: VolumeController::SetAlsaVolume100 Oct 19 23:39:16 volumio volumio[980]: info: CoreStateMachine::pushState Oct 19 23:39:16 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 23:39:16 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Oct 19 23:39:16 volumio volumio[980]: info: [ASDebug] CurState: play PrevState: play Oct 19 23:39:16 volumio volumio[980]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. Oct 19 23:39:16 volumio mpd[24462]: Oct 19 23:39 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 19 23:39:16 volumio systemd[1]: Started Music Player Daemon. Oct 19 23:39:16 volumio sudo[24457]: pam_unix(sudo:session): session closed for user root Oct 19 23:39:16 volumio volumio[980]: error: updateQueue error: null Oct 19 23:39:16 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 19 23:39:17 volumio volumio[980]: info: CoreCommandRouter::volumioPlay Oct 19 23:39:17 volumio volumio[980]: info: CoreStateMachine::play index undefined Oct 19 23:39:17 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 19 23:39:17 volumio volumio[980]: info: CorePlayQueue::getTrack 12 Oct 19 23:39:17 volumio volumio[980]: info: CoreStateMachine::startPlaybackTimer Oct 19 23:39:17 volumio volumio[980]: info: CorePlayQueue::getTrack 12 Oct 19 23:39:17 volumio volumio[980]: info: [ytmusic-play] clearAddPlayTrack: ytmusic/video@explodeTrackData:o=%7B%22type%22%3A%22video%22%2C%22title%22%3A%22Drive%20(Live)%22%2C%22artist%22%3A%22R.E.M.%22%2C%22album%22%3A%22Automatic%20For%20The%20People%20(25th%20Anniversary%20Edition)%22%2C%22albumart%22%3A%22https%3A%2F%2Flh3.googleusercontent.com%2F86Z15pLGKfK-u7jHf_VFHqWZjeDrqrZBpeQ4yjrgHDNnA7eZCPJFHnfCkM7oTc4qQDb_cpax0fOqlpSy%3Dw701-h701-l90-rj%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%22hTUXaOQmnCs%22%2C%22playlistId%22%3A%22OLAK5uy_mtV-Ju0RsfTRQrtA5XRVo5rOB3a4w8Du8%22%2C%22params%22%3A%22OAHyAQIIAZIEI1FQWUM1S2JkZjlkaXFSd1JDVWJnc1RQZzRZdXdPS3F1MHpf%22%2C%22index%22%3A12%2C%22playlistSetVideoId%22%3A%22ABBCAC58C151BACD%22%7D%2C%22musicVideoType%22%3A%22MUSIC_VIDEO_TYPE_ATV%22%7D%2C%22autoplayContext%22%3A%7B%22fetchEndpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22playlistId%22%3A%22OLAK5uy_mtV-Ju0RsfTRQrtA5XRVo5rOB3a4w8Du8%22%2C%22params%22%3A%22OAHyAQIIAZIEI1FQWUM1S2JkZjlkaXFSd1JDVWJnc1RQZzRZdXdPS3F1MHpf%22%2C%22videoId%22%3A%22MjK8Si0t0ik%22%7D%7D%7D%7D Oct 19 23:39:17 volumio volumio[980]: warn: [ROTARYENCODER2] Push Button 1 signalled "released" without intermediate "pressed". You may be suffering from bouncy buttons. Oct 19 23:39:17 volumio volumio[980]: info: VolumeController::SetAlsaVolume+ Oct 19 23:39:17 volumio volumio[980]: info: CoreStateMachine::pushState Oct 19 23:39:17 volumio volumio[980]: info: CorePlayQueue::getTrack 12 Oct 19 23:39:17 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 19 23:39:17 volumio volumio[980]: info: CoreCommandRouter::volumioPushState Oct 19 23:39:17 volumio volumio[980]: info: [ASDebug] CurState: stop PrevState: play Oct 19 23:39:17 volumio volumio[980]: info: [ASDebug] InitTimeout - Amp off in: 0 ms Oct 19 23:39:17 volumio volumio[980]: info: [ASDebug] Togle GPIO: OFF Oct 19 23:39:17 volumio volumio[980]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 23:39:17 volumio volumio[980]: Error: EPERM: operation not permitted, write Oct 19 23:39:17 volumio volumio[980]: at Object.writeSync (fs.js:711:3) Oct 19 23:39:17 volumio volumio[980]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8) Oct 19 23:39:17 volumio volumio[980]: at AmpSwitchController.off (/data/plugins/system_controller/ampswitch/index.js:213:23) Oct 19 23:39:17 volumio volumio[980]: at Timeout._onTimeout (/data/plugins/system_controller/ampswitch/index.js:187:88) Oct 19 23:39:17 volumio volumio[980]: at listOnTimeout (internal/timers.js:554:17) Oct 19 23:39:17 volumio volumio[980]: at processTimers (internal/timers.js:497:7) { Oct 19 23:39:17 volumio volumio[980]: errno: -1, Oct 19 23:39:17 volumio volumio[980]: syscall: 'write', Oct 19 23:39:17 volumio volumio[980]: code: 'EPERM' Oct 19 23:39:17 volumio volumio[980]: } Oct 19 23:39:17 volumio volumio[980]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 19 23:39:17 volumio sudo[24476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-19 23:38 Oct 19 23:39:17 volumio sudo[24476]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"