-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2024-09-17 17:08:00 CEST. -- Sep 17 17:07:00 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Sep 17 17:07:00 volumio systemd[1]: Started WPA supplicant. Sep 17 17:07:00 volumio kernel: ax88179_178a 1-1.3:1.0 eth0: Current addr: 00 17 f7 00 a9 d4 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 Sep 17 17:07:00 volumio kernel: ax88179_178a 1-1.3:1.0 eth0: Expected addr: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 Sep 17 17:07:00 volumio kernel: ------------[ cut here ]------------ Sep 17 17:07:00 volumio kernel: WARNING: CPU: 2 PID: 579 at net/core/dev_addr_lists.c:519 dev_addr_check+0x108/0x138 Sep 17 17:07:00 volumio kernel: netdevice: eth0: Incorrect netdev->dev_addr Sep 17 17:07:00 volumio kernel: Modules linked in: xt_tcpudp nft_compat nf_tables 8021q garp nfnetlink stp llc sha256_generic cfg80211 rfkill snd_usb_audio snd_hwdep snd_usbmidi_lib snd_seq_midi snd_seq_midi_event snd_rawmidi snd_bcm2835(C) snd_pcm ax88179_178a raspberrypi_hwmon bcm2835_codec(C) bcm2835_isp(C) bcm2835_v4l2(C) v4l2_mem2mem bcm2835_mmal_vchiq(C) videobuf2_vmalloc snd_seq videobuf2_dma_contig snd_seq_device videobuf2_memops videobuf2_v4l2 snd_timer videobuf2_common i2c_bcm2835 videodev snd mc raspberrypi_gpiomem vc_sm_cma(C) uio_pdrv_genirq fixed uio i2c_dev ip_tables x_tables ipv6 uas squashfs overlay nls_iso8859_1 fuse drm drm_panel_orientation_quirks backlight Sep 17 17:07:00 volumio kernel: CPU: 2 PID: 579 Comm: dhcpcd Tainted: G C 6.1.69-v7+ #1710 Sep 17 17:07:00 volumio kernel: Hardware name: BCM2835 Sep 17 17:07:00 volumio kernel: unwind_backtrace from show_stack+0x18/0x1c Sep 17 17:07:00 volumio kernel: show_stack from dump_stack_lvl+0x68/0x8c Sep 17 17:07:00 volumio kernel: dump_stack_lvl from __warn+0x84/0x124 Sep 17 17:07:00 volumio kernel: __warn from warn_slowpath_fmt+0x11c/0x184 Sep 17 17:07:00 volumio kernel: warn_slowpath_fmt from dev_addr_check+0x108/0x138 Sep 17 17:07:00 volumio kernel: dev_addr_check from __dev_open+0x40/0x1a4 Sep 17 17:07:00 volumio kernel: __dev_open from __dev_change_flags+0x170/0x1e0 Sep 17 17:07:00 volumio kernel: __dev_change_flags from dev_change_flags+0x1c/0x4c Sep 17 17:07:00 volumio kernel: dev_change_flags from devinet_ioctl+0x720/0x750 Sep 17 17:07:00 volumio kernel: devinet_ioctl from inet_ioctl+0x1b0/0x278 Sep 17 17:07:00 volumio kernel: inet_ioctl from sock_ioctl+0x278/0x354 Sep 17 17:07:00 volumio kernel: sock_ioctl from sys_ioctl+0x120/0x984 Sep 17 17:07:00 volumio kernel: sys_ioctl from ret_fast_syscall+0x0/0x1c Sep 17 17:07:00 volumio kernel: Exception stack(0xb8ad1fa8 to 0xb8ad1ff0) Sep 17 17:07:00 volumio kernel: 1fa0: 01b09c68 00001043 00000007 00008914 7ee699f4 7ee69ad0 Sep 17 17:07:00 volumio kernel: 1fc0: 01b09c68 00001043 0005dca0 00000036 431bde83 000f423f 3b9aca00 01b04660 Sep 17 17:07:00 volumio kernel: 1fe0: 0005dea4 7ee699ec 0001ba6c 76e79e3c Sep 17 17:07:00 volumio kernel: ---[ end trace 0000000000000000 ]--- Sep 17 17:07:00 volumio systemd[1]: Started Raise network interfaces. Sep 17 17:07:00 volumio systemd[1]: Reached target Network. Sep 17 17:07:00 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Sep 17 17:07:00 volumio systemd[1]: Starting Permit User Sessions... Sep 17 17:07:00 volumio systemd[1]: Starting Network Time Service... Sep 17 17:07:00 volumio systemd[1]: Reached target Network is Online. Sep 17 17:07:00 volumio systemd[1]: Starting Samba NMB Daemon... Sep 17 17:07:00 volumio systemd[1]: Starting /etc/rc.local Compatibility... Sep 17 17:07:00 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Sep 17 17:07:00 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 17 17:07:00 volumio sh[502]: eth0: waiting for carrier Sep 17 17:07:00 volumio sh[502]: eth0: carrier acquired Sep 17 17:07:00 volumio dhcpcd[579]: eth0: waiting for carrier Sep 17 17:07:00 volumio dhcpcd[579]: eth0: carrier acquired Sep 17 17:07:00 volumio sh[502]: DUID 00:01:00:01:2e:7c:57:95:00:17:f7:00:a9:d4 Sep 17 17:07:00 volumio sh[502]: eth0: IAID f7:00:a9:d4 Sep 17 17:07:00 volumio sh[502]: eth0: adding address fe80::e8c6:1732:5643:14d8 Sep 17 17:07:00 volumio sh[502]: ipv6_addaddr1: Permission denied Sep 17 17:07:00 volumio sh[502]: eth0: carrier lost Sep 17 17:07:00 volumio dhcpcd[579]: DUID 00:01:00:01:2e:7c:57:95:00:17:f7:00:a9:d4 Sep 17 17:07:00 volumio dhcpcd[579]: eth0: IAID f7:00:a9:d4 Sep 17 17:07:00 volumio dhcpcd[579]: eth0: adding address fe80::e8c6:1732:5643:14d8 Sep 17 17:07:00 volumio dhcpcd[579]: ipv6_addaddr1: Permission denied Sep 17 17:07:00 volumio dhcpcd[579]: eth0: carrier lost Sep 17 17:07:00 volumio systemd[1]: Started Permit User Sessions. Sep 17 17:07:00 volumio systemd[1]: Started /etc/rc.local Compatibility. Sep 17 17:07:00 volumio systemd[1]: iptables.service: Succeeded. Sep 17 17:07:00 volumio loadcpufreq[562]: Loading cpufreq kernel modules...done (none). Sep 17 17:07:00 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Sep 17 17:07:00 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Sep 17 17:07:00 volumio systemd[1]: Starting Hold until boot process finishes up... Sep 17 17:07:00 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Sep 17 17:07:00 volumio systemd[1]: Received SIGRTMIN+21 from PID 212 (plymouthd). Sep 17 17:07:00 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Sep 17 17:07:00 volumio systemd[1]: Started Hold until boot process finishes up. Sep 17 17:07:00 volumio systemd[1]: plymouth-quit.service: Succeeded. Sep 17 17:07:00 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Sep 17 17:07:00 volumio systemd[1]: Received SIGRTMIN+21 from PID 212 (n/a). Sep 17 17:07:00 volumio systemd[1]: Started Serial Getty on ttyAMA0. Sep 17 17:07:00 volumio ntpd[674]: ntpd 4.2.8p12@1.3728-o (1): Starting Sep 17 17:07:00 volumio ntpd[674]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Sep 17 17:07:00 volumio systemd[1]: Started Getty on tty1. Sep 17 17:07:00 volumio systemd[1]: Reached target Login Prompts. Sep 17 17:07:00 volumio systemd[1]: Started Network Time Service. Sep 17 17:07:01 volumio ntpd[729]: proto: precision = 1.354 usec (-19) Sep 17 17:07:01 volumio ntpd[729]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Sep 17 17:07:01 volumio ntpd[729]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2024-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Sep 17 17:07:01 volumio ntpd[729]: Listen and drop on 0 v6wildcard [::]:123 Sep 17 17:07:01 volumio ntpd[729]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 17 17:07:01 volumio ntpd[729]: Listen normally on 2 lo 127.0.0.1:123 Sep 17 17:07:01 volumio ntpd[729]: Listening on routing socket on fd #19 for interface updates Sep 17 17:07:01 volumio ntpd[729]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 17 17:07:01 volumio ntpd[729]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 17 17:07:01 volumio ifplugd(eth0)[747]: ifplugd 0.28 initializing. Sep 17 17:07:01 volumio ifplugd(eth0)[747]: Using interface eth0/00:17:F7:00:A9:D4 with driver (version: v2.0.0) Sep 17 17:07:01 volumio ifplugd(eth0)[747]: Using detection mode: SIOCETHTOOL Sep 17 17:07:01 volumio ifplugd(eth0)[747]: Initialization complete, link beat not detected. Sep 17 17:07:01 volumio ifplugd[685]: Network Interface Plugging Daemon...start eth0...done. Sep 17 17:07:01 volumio systemd[1]: Started LSB: Brings up/down network automatically. Sep 17 17:07:01 volumio cpufrequtils[711]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Sep 17 17:07:01 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Sep 17 17:07:01 volumio haveged[528]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Sep 17 17:07:01 volumio haveged[528]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Sep 17 17:07:01 volumio haveged[528]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00122 Sep 17 17:07:01 volumio haveged[528]: haveged: fills: 0, generated: 0 Sep 17 17:07:01 volumio nmbd[696]: [2024/09/17 17:07:01.853148, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Sep 17 17:07:01 volumio nmbd[696]: started asyncdns process 757 Sep 17 17:07:01 volumio nmbd[696]: [2024/09/17 17:07:01.861828, 0] ../lib/util/become_daemon.c:149(daemon_status) Sep 17 17:07:01 volumio nmbd[696]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Sep 17 17:07:01 volumio nmbd[696]: [2024/09/17 17:07:01.862060, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Sep 17 17:07:01 volumio nmbd[696]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Sep 17 17:07:02 volumio ntpd[729]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Sep 17 17:07:02 volumio wireless.js[548]: WIRELESS: No wireless interface, exiting Sep 17 17:07:02 volumio iw[762]: command failed: No such device (-19) Sep 17 17:07:02 volumio iwconfig[765]: Error for wireless request "Set Power Management" (8B2C) : Sep 17 17:07:02 volumio iwconfig[765]: SET failed on device wlan0 ; No such device. Sep 17 17:07:02 volumio systemd[1]: wireless.service: Succeeded. Sep 17 17:07:02 volumio systemd[1]: Started Wireless Services. Sep 17 17:07:02 volumio systemd[1]: Started Volumio Backend Module. Sep 17 17:07:02 volumio systemd[1]: Started Volumio Cpu Tweaker. Sep 17 17:07:02 volumio volumio-cpu-tweak[769]: Setting RT Priority for mpd Sep 17 17:07:02 volumio volumio-cpu-tweak[769]: pid 35's current scheduling policy: SCHED_OTHER Sep 17 17:07:02 volumio volumio-cpu-tweak[769]: pid 35's current scheduling priority: 0 Sep 17 17:07:02 volumio volumio-cpu-tweak[769]: Setting MPD Affinity Sep 17 17:07:02 volumio volumio-cpu-tweak[769]: pid 3's current affinity mask: f Sep 17 17:07:02 volumio volumio-cpu-tweak[769]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Sep 17 17:07:02 volumio volumio-cpu-tweak[769]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Sep 17 17:07:02 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Sep 17 17:07:02 volumio ntpd[729]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Sep 17 17:07:03 volumio sh[502]: eth0: carrier acquired Sep 17 17:07:03 volumio dhcpcd[579]: eth0: carrier acquired Sep 17 17:07:03 volumio kernel: ax88179_178a 1-1.3:1.0 eth0: link up, 1000Mbps, full-duplex, lpa 0xC5E1 Sep 17 17:07:03 volumio sh[502]: eth0: IAID f7:00:a9:d4 Sep 17 17:07:03 volumio dhcpcd[579]: eth0: IAID f7:00:a9:d4 Sep 17 17:07:03 volumio sh[502]: eth0: soliciting an IPv6 router Sep 17 17:07:03 volumio dhcpcd[579]: eth0: soliciting an IPv6 router Sep 17 17:07:03 volumio ntpd[729]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Sep 17 17:07:04 volumio ifplugd(eth0)[747]: Link beat detected. Sep 17 17:07:04 volumio ifplugd(eth0)[747]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Sep 17 17:07:04 volumio ifplugd(eth0)[747]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Sep 17 17:07:04 volumio sh[502]: eth0: rebinding lease of 192.168.0.33 Sep 17 17:07:04 volumio dhcpcd[579]: eth0: rebinding lease of 192.168.0.33 Sep 17 17:07:04 volumio sh[502]: eth0: NAK: from 192.168.0.254 Sep 17 17:07:04 volumio dhcpcd[579]: eth0: NAK: from 192.168.0.254 Sep 17 17:07:04 volumio sh[502]: eth0: soliciting a DHCP lease Sep 17 17:07:04 volumio dhcpcd[579]: eth0: soliciting a DHCP lease Sep 17 17:07:04 volumio volumio-remote-updater[553]: [2024-09-17 17:07:04] [connect] Successful connection Sep 17 17:07:04 volumio sh[502]: eth0: offered 192.168.0.33 from 192.168.0.254 Sep 17 17:07:04 volumio dhcpcd[579]: eth0: offered 192.168.0.33 from 192.168.0.254 Sep 17 17:07:04 volumio ntpd[729]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Sep 17 17:07:05 volumio volumio[768]: info: ------------------------------------------- Sep 17 17:07:05 volumio volumio[768]: info: ----- Volumio3 ---- Sep 17 17:07:05 volumio volumio[768]: info: ------------------------------------------- Sep 17 17:07:05 volumio volumio[768]: info: ----- System startup ---- Sep 17 17:07:05 volumio volumio[768]: info: ------------------------------------------- Sep 17 17:07:06 volumio sh[502]: eth0: probing address 192.168.0.33/24 Sep 17 17:07:06 volumio dhcpcd[579]: eth0: probing address 192.168.0.33/24 Sep 17 17:07:06 volumio volumio[768]: info: MYVOLUMIO Environment detected Sep 17 17:07:06 volumio volumio[768]: info: Plugin folders cleanup Sep 17 17:07:06 volumio volumio[768]: info: Scanning into folder /volumio/app/plugins/ Sep 17 17:07:06 volumio volumio[768]: info: Scanning category audio_interface Sep 17 17:07:06 volumio volumio[768]: info: Scanning category miscellanea Sep 17 17:07:06 volumio volumio[768]: info: Scanning category music_service Sep 17 17:07:06 volumio volumio[768]: info: Scanning category plugins.json Sep 17 17:07:06 volumio volumio[768]: info: Scanning category system_controller Sep 17 17:07:06 volumio volumio[768]: info: Scanning category user_interface Sep 17 17:07:06 volumio volumio[768]: info: Scanning into folder /data/plugins/ Sep 17 17:07:06 volumio volumio[768]: info: Plugin folders cleanup completed Sep 17 17:07:06 volumio volumio[768]: info: ------------------------------------------- Sep 17 17:07:06 volumio volumio[768]: info: ----- Core plugins startup ---- Sep 17 17:07:06 volumio volumio[768]: info: ------------------------------------------- Sep 17 17:07:06 volumio volumio[768]: info: Loading plugins from folder /volumio/app/plugins/ Sep 17 17:07:06 volumio volumio[768]: info: Adding plugin upnp to MyMusic Plugins Sep 17 17:07:06 volumio volumio[768]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 17 17:07:06 volumio volumio[768]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 17 17:07:06 volumio volumio[768]: info: Loading plugins from folder /data/plugins/ Sep 17 17:07:06 volumio volumio[768]: info: Loading plugin "system"... Sep 17 17:07:06 volumio volumio[768]: info: Loading plugin "appearance"... Sep 17 17:07:08 volumio volumio[768]: info: Loading plugin "network"... Sep 17 17:07:08 volumio volumio[768]: info: Refreshing Cached IP Addresses Sep 17 17:07:08 volumio volumio[768]: info: Loading plugin "services"... Sep 17 17:07:08 volumio volumio[768]: info: Loading plugin "alsa_controller"... Sep 17 17:07:08 volumio sudo[814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 17:07:08 volumio sudo[814]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:08 volumio sudo[816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 17:07:08 volumio sudo[818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 17 17:07:08 volumio sudo[818]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:08 volumio sudo[816]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:08 volumio sudo[814]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:08 volumio volumio[768]: warn: Unable to locate the audio output device Combo384 Amanero. Please configure a valid output device. Sep 17 17:07:08 volumio sudo[816]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:08 volumio sudo[818]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:08 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 17 17:07:08 volumio volumio[768]: info: Loading plugin "wizard"... Sep 17 17:07:08 volumio volumio[768]: info: Loading plugin "networkfs"... Sep 17 17:07:08 volumio volumio[768]: info: Starting Udev Watcher for removable devices Sep 17 17:07:08 volumio volumio[768]: info: Ignoring mount for partition: boot Sep 17 17:07:08 volumio volumio[768]: info: Ignoring mount for partition: volumio Sep 17 17:07:08 volumio volumio[768]: info: Ignoring mount for partition: volumio_data Sep 17 17:07:08 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 17 17:07:08 volumio volumio[768]: info: Loading plugin "volumio_command_line_client"... Sep 17 17:07:08 volumio volumio[768]: info: Loading plugin "upnp"... Sep 17 17:07:08 volumio volumio[768]: info: [1726585628710] Starting Upmpd Daemon Sep 17 17:07:08 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 17 17:07:08 volumio volumio[768]: info: Loading plugin "my_music"... Sep 17 17:07:08 volumio volumio[768]: info: Loading plugin "mpd"... Sep 17 17:07:09 volumio volumio[768]: info: Loading plugin "upnp_browser"... Sep 17 17:07:09 volumio volumio[768]: info: Loading plugin "alarm-clock"... Sep 17 17:07:09 volumio volumio[768]: info: Loading plugin "airplay_emulation"... Sep 17 17:07:09 volumio volumio[768]: info: Starting Shairport Sync Sep 17 17:07:09 volumio volumio[768]: info: Loading plugin "last_100"... Sep 17 17:07:09 volumio volumio[768]: info: Loading plugin "webradio"... Sep 17 17:07:10 volumio volumio[768]: info: Loading plugin "i2s_dacs"... Sep 17 17:07:10 volumio volumio[768]: info: I2S DAC not set, start Auto-detection Sep 17 17:07:10 volumio volumio[768]: info: Loading plugin "volumiodiscovery"... Sep 17 17:07:10 volumio volumio[768]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 17 17:07:10 volumio volumio[768]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 17:07:10 volumio volumio[768]: *** WARNING *** For more information see Sep 17 17:07:10 volumio volumio[768]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 17 17:07:10 volumio node[768]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 17 17:07:10 volumio volumio[768]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 17:07:10 volumio volumio[768]: *** WARNING *** For more information see Sep 17 17:07:10 volumio node[768]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 17:07:10 volumio node[768]: *** WARNING *** For more information see Sep 17 17:07:10 volumio node[768]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 17 17:07:10 volumio node[768]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 17 17:07:10 volumio node[768]: *** WARNING *** For more information see Sep 17 17:07:10 volumio volumio[768]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 17 17:07:10 volumio volumio[768]: info: Discovery: Started advertising with name: Volumio Sep 17 17:07:10 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 17 17:07:10 volumio volumio[768]: info: Loading plugin "outputs"... Sep 17 17:07:10 volumio volumio[768]: info: Loading plugin "albumart"... Sep 17 17:07:10 volumio volumio[768]: info: Plugin example_plugin is not enabled Sep 17 17:07:10 volumio volumio[768]: info: Loading plugin "inputs"... Sep 17 17:07:10 volumio volumio[768]: info: Loading plugin "updater_comm"... Sep 17 17:07:10 volumio volumio[768]: info: Plugin mpdemulation is not enabled Sep 17 17:07:10 volumio volumio[768]: info: Loading plugin "rest_api"... Sep 17 17:07:10 volumio volumio[768]: info: Loading plugin "websocket"... Sep 17 17:07:10 volumio volumio[768]: info: Starting Socket.io Server version 2.3.0 Sep 17 17:07:10 volumio volumio[768]: info: Loading i18n strings for locale fr Sep 17 17:07:10 volumio volumio[768]: Updating browse sources language Sep 17 17:07:10 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 17:07:10 volumio volumio[768]: Forking 3 albumart workers Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::initPlayerControls Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:11 volumio sh[502]: eth0: leased 192.168.0.33 for 43200 seconds Sep 17 17:07:11 volumio sh[502]: eth0: adding route to 192.168.0.0/24 Sep 17 17:07:11 volumio sh[502]: eth0: adding default route via 192.168.0.254 Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:11 volumio dhcpcd[579]: eth0: leased 192.168.0.33 for 43200 seconds Sep 17 17:07:11 volumio dhcpcd[579]: eth0: adding route to 192.168.0.0/24 Sep 17 17:07:11 volumio dhcpcd[579]: eth0: adding default route via 192.168.0.254 Sep 17 17:07:11 volumio avahi-daemon[545]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.33. Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:11 volumio avahi-daemon[545]: New relevant interface eth0.IPv4 for mDNS. Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:11 volumio avahi-daemon[545]: Registering new address record for 192.168.0.33 on eth0.IPv4. Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 17 17:07:11 volumio volumio[768]: Express server listening on port 3000 Sep 17 17:07:11 volumio volumio[768]: [Metrics] WebUI: 6s 719.69ms Sep 17 17:07:11 volumio volumio[768]: info: CoreStateMachine::resetVolumioState Sep 17 17:07:11 volumio volumio[768]: info: CoreStateMachine::getcurrentVolume Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::volumioRetrievevolume Sep 17 17:07:11 volumio sh[502]: forked to background, child pid 885 Sep 17 17:07:11 volumio dhcpcd[579]: forked to background, child pid 885 Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:11 volumio volumio[768]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 17 17:07:11 volumio volumio[768]: wlan0 Interface doesn't support scanning. Sep 17 17:07:11 volumio volumio[768]: info: Cannot use regular scanning, forcing with ap-force Sep 17 17:07:11 volumio sudo[906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 17 17:07:11 volumio sudo[906]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:11 volumio sudo[906]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:11 volumio ifplugd(eth0)[747]: client: ifup: interface eth0 already configured Sep 17 17:07:11 volumio volumio[768]: command failed: No such device (-19) Sep 17 17:07:11 volumio sh[502]: eth0=eth0 Sep 17 17:07:11 volumio volumio[768]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 17 17:07:11 volumio volumio[768]: command failed: No such device (-19) Sep 17 17:07:11 volumio ifplugd(eth0)[747]: Program executed successfully. Sep 17 17:07:11 volumio volumio[768]: info: VolumeController:: Volume=41 Mute =false Sep 17 17:07:11 volumio volumio[768]: info: CoreStateMachine::pushState Sep 17 17:07:11 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::volumioPushState Sep 17 17:07:11 volumio volumio[768]: info: CoreStateMachine::updateTrackBlock Sep 17 17:07:11 volumio volumio[768]: info: CorePlayQueue::getTrackBlock Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::volumioRetrievevolume Sep 17 17:07:11 volumio volumio[768]: info: Reloading queue from file Sep 17 17:07:11 volumio volumio[768]: info: Setting Device type: Raspberry PI Sep 17 17:07:11 volumio volumio[768]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Sep 17 17:07:11 volumio volumio[768]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a02100 Sep 17 17:07:11 volumio volumio[768]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Sep 17 17:07:11 volumio volumio[768]: info: CoreStateMachine::setRepeat false single undefined Sep 17 17:07:11 volumio volumio[768]: info: CoreStateMachine::pushState Sep 17 17:07:11 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::volumioPushState Sep 17 17:07:11 volumio volumio[768]: info: CoreStateMachine::setRandom null Sep 17 17:07:11 volumio volumio[768]: info: CoreStateMachine::pushState Sep 17 17:07:11 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::volumioPushState Sep 17 17:07:11 volumio volumio[768]: info: Completed loading Core Plugins Sep 17 17:07:11 volumio volumio[768]: info: Preparing to generate the ALSA configuration file Sep 17 17:07:11 volumio volumio[768]: Starting albumart workers Sep 17 17:07:11 volumio volumio[768]: info: VolumeController:: Volume=41 Mute =false Sep 17 17:07:11 volumio volumio[768]: info: CoreStateMachine::pushState Sep 17 17:07:11 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:11 volumio volumio[768]: info: CoreCommandRouter::volumioPushState Sep 17 17:07:11 volumio volumio[768]: info: Asound.conf file written Sep 17 17:07:11 volumio nmbd[696]: [2024/09/17 17:07:11.868036, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 17 17:07:11 volumio systemd[1]: Started Samba NMB Daemon. Sep 17 17:07:11 volumio nmbd[696]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Sep 17 17:07:11 volumio volumio[768]: Starting albumart workers Sep 17 17:07:11 volumio sudo[925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Sep 17 17:07:11 volumio sudo[925]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:11 volumio sudo[925]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:11 volumio systemd[1]: Starting Samba Winbind Daemon... Sep 17 17:07:11 volumio volumio[768]: No state is present for card T22F36 Sep 17 17:07:11 volumio volumio[768]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:86ef" "" "" Sep 17 17:07:11 volumio volumio[768]: Hardware is initialized using a generic method Sep 17 17:07:11 volumio volumio[768]: No state is present for card T22F36 Sep 17 17:07:11 volumio volumio[768]: info: Output device has changed, restarting MPD Sep 17 17:07:12 volumio volumio[768]: Starting albumart workers Sep 17 17:07:12 volumio volumio[768]: info: Output device has changed, restarting Shairport Sync Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:12 volumio sudo[933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 17 17:07:12 volumio sudo[934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 17 17:07:12 volumio sudo[933]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:12 volumio sudo[934]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:12 volumio sudo[933]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:12 volumio volumio[768]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 17 17:07:12 volumio volumio[768]: info: ___________ START PLUGINS ___________ Sep 17 17:07:12 volumio volumio[768]: info: ControllerMpd::onStart: Initializing MPD Sep 17 17:07:12 volumio volumio[768]: info: Creating MPD Configuration file Sep 17 17:07:12 volumio systemd[1]: Listening on mpd.socket. Sep 17 17:07:12 volumio systemd[1]: Starting Music Player Daemon... Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 17 17:07:12 volumio volumio[768]: info: [1726585632307] CoreMusicLibrary::Adding element Serveurs Média Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 17:07:12 volumio sudo[943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 17 17:07:12 volumio sudo[943]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:12 volumio sudo[943]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:12 volumio sudo[941]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 17 17:07:12 volumio sudo[941]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:12 volumio sudo[941]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Sep 17 17:07:12 volumio sudo[941]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:12 volumio sudo[945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 17 17:07:12 volumio sudo[945]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:12 volumio winbindd[926]: [2024/09/17 17:07:12.405834, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Sep 17 17:07:12 volumio systemd[1]: Started Samba Winbind Daemon. Sep 17 17:07:12 volumio winbindd[926]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Sep 17 17:07:12 volumio winbindd[926]: [2024/09/17 17:07:12.434113, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 17 17:07:12 volumio winbindd[926]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Sep 17 17:07:12 volumio systemd[1]: Starting Samba SMB Daemon... Sep 17 17:07:12 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 17 17:07:12 volumio systemd[1]: mpd.service: Succeeded. Sep 17 17:07:12 volumio systemd[1]: Stopped Music Player Daemon. Sep 17 17:07:12 volumio systemd[1]: Starting Music Player Daemon... Sep 17 17:07:12 volumio volumio[768]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:12 volumio sudo[956]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 17 17:07:12 volumio sudo[956]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:12 volumio sudo[956]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Sep 17 17:07:12 volumio sudo[956]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:12 volumio volumio[768]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 17 17:07:12 volumio volumio[768]: info: [1726585632728] CoreMusicLibrary::Adding element Last_100 Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 17 17:07:12 volumio volumio[768]: info: [1726585632733] CoreMusicLibrary::Adding element Webradio Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 17:07:12 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 17 17:07:12 volumio volumio[768]: info: Initializing BBC Radios Sep 17 17:07:12 volumio ntpd[729]: Listen normally on 3 eth0 192.168.0.33:123 Sep 17 17:07:12 volumio ntpd[729]: new interface(s) found: waking up resolver Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: Volumio Calling Home Sep 17 17:07:13 volumio smbd[957]: [2024/09/17 17:07:13.341306, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 17 17:07:13 volumio systemd[1]: Started Samba SMB Daemon. Sep 17 17:07:13 volumio smbd[957]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Sep 17 17:07:13 volumio systemd[1]: Reached target Multi-User System. Sep 17 17:07:13 volumio systemd[1]: Reached target Graphical Interface. Sep 17 17:07:13 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Sep 17 17:07:13 volumio volumio[768]: info: MPD Permissions set Sep 17 17:07:13 volumio volumio[768]: info: MPD Permissions set Sep 17 17:07:13 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Sep 17 17:07:13 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Sep 17 17:07:13 volumio volumio[768]: info: Discovery: adding bf644723-2dc6-49cb-8ca5-a0e797393e99 Sep 17 17:07:13 volumio volumio[768]: info: Discovery: Found device Volumio Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:13 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:13 volumio volumio[768]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Sep 17 17:07:13 volumio volumio[768]: info: Volumio called home Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:13 volumio volumio[768]: info: Discovery: Getting this device information Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:13 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:13 volumio volumio[768]: verbose: New Socket.io Connection to 192.168.0.33:3000 from 192.168.0.11 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Sep 17 17:07:13 volumio volumio[768]: info: Starting Shairport Sync Sep 17 17:07:13 volumio volumio[768]: info: Starting Shairport Sync Sep 17 17:07:13 volumio volumio[768]: info: Starting Shairport Sync Sep 17 17:07:13 volumio sudo[1017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 17 17:07:13 volumio sudo[1017]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:13 volumio sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 17 17:07:13 volumio sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 17 17:07:13 volumio sudo[1022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 17 17:07:13 volumio sudo[1022]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:13 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 17 17:07:13 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 17 17:07:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:13 volumio volumio[768]: info: Discovery: Getting this device information Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:13 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:13 volumio volumio[768]: verbose: New Socket.io Connection to 192.168.0.33:3000 from 192.168.0.11 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Sep 17 17:07:13 volumio volumio[768]: verbose: New Socket.io Connection to 192.168.0.33:3000 from 192.168.0.11 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:13 volumio volumio[768]: info: Discovery: Getting this device information Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:13 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:13 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 17 17:07:13 volumio sudo[1019]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:14 volumio sudo[1017]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:14 volumio sudo[1022]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:14 volumio volumio[768]: info: Shairport-Sync Started Sep 17 17:07:14 volumio volumio[768]: Error adding Membership: Error: addMembership EINVAL Sep 17 17:07:14 volumio volumio[768]: info: Shairport-Sync Started Sep 17 17:07:14 volumio volumio[768]: info: Shairport-Sync Started Sep 17 17:07:16 volumio mpd[962]: Sep 17 17:07 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 17 17:07:16 volumio systemd[1]: Started Music Player Daemon. Sep 17 17:07:16 volumio systemd[1]: Startup finished in 15.609s (kernel) + 24.139s (userspace) = 39.749s. Sep 17 17:07:16 volumio sudo[934]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:16 volumio sudo[945]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:16 volumio volumio[768]: info: Completed starting Core Plugins Sep 17 17:07:16 volumio volumio[768]: info: ------------------------------------------- Sep 17 17:07:16 volumio volumio[768]: info: ----- MyVolumio plugins startup ---- Sep 17 17:07:16 volumio volumio[768]: info: ------------------------------------------- Sep 17 17:07:16 volumio volumio[768]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 17 17:07:16 volumio volumio[768]: error: MPD error: The expression evaluated to a falsy value: Sep 17 17:07:16 volumio volumio[768]: assert.ok(self.idling) Sep 17 17:07:16 volumio volumio[768]: error: The expression evaluated to a falsy value: Sep 17 17:07:16 volumio volumio[768]: assert.ok(self.idling) Sep 17 17:07:16 volumio volumio[768]: error: updateQueue error: null Sep 17 17:07:16 volumio volumio[768]: info: MPD running with PID962 Sep 17 17:07:16 volumio volumio[768]: ,establishing connection Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:16 volumio volumio[768]: info: Discovery: Getting this device information Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:16 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:16 volumio volumio[768]: error: updateQueue error: null Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Sep 17 17:07:16 volumio sudo[1033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Sep 17 17:07:16 volumio sudo[1033]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:16 volumio sudo[1038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 17 17:07:16 volumio sudo[1038]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:16 volumio sudo[1033]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:16 volumio sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 17 17:07:16 volumio sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:16 volumio sudo[1053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 17 17:07:16 volumio sudo[1061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 17:07:16 volumio sudo[1038]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:16 volumio sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:16 volumio sudo[1062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 17:07:16 volumio sudo[1053]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:16 volumio sudo[1062]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:16 volumio sudo[1061]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:16 volumio sudo[1062]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:16 volumio sudo[1045]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:16 volumio sudo[1053]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:16 volumio volumio[768]: info: Discovery: Getting this device information Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:16 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:16 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 17 17:07:16 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 17 17:07:17 volumio volumio-remote-updater[553]: [2024-09-17 17:07:17] [connect] Successful connection Sep 17 17:07:17 volumio volumio-remote-updater[553]: [2024-09-17 17:07:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1726585637 101 Sep 17 17:07:17 volumio volumio[768]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Sep 17 17:07:17 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:17 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:17 volumio volumio[768]: info: Discovery: Getting this device information Sep 17 17:07:17 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:17 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:17 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:18 volumio volumio[768]: verbose: New Socket.io Connection to 192.168.0.33:3000 from 192.168.0.11 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 17 17:07:18 volumio sudo[1079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 17:07:18 volumio sudo[1079]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:18 volumio sudo[1079]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:18 volumio sudo[1081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 17:07:18 volumio sudo[1081]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:18 volumio sudo[1081]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:18 volumio volumio[768]: verbose: New Socket.io Connection to 192.168.0.33 from 192.168.0.11 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 4 Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::volumioGetVisibleSources Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:18 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 17 17:07:18 volumio volumio[768]: info: Received Get System Info Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:18 volumio volumio[768]: info: Discovery: Getting this device information Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:18 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:18 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:18 volumio volumio[768]: info: Listing playlists Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 17 17:07:18 volumio sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 17:07:18 volumio sudo[1087]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:18 volumio sudo[1087]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:18 volumio sudo[1089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 17:07:18 volumio sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:18 volumio sudo[1092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 17 17:07:18 volumio sudo[1092]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:18 volumio sudo[1092]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:18 volumio sudo[1096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 17 17:07:18 volumio sudo[1096]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:18 volumio sudo[1089]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:18 volumio sudo[1096]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:18 volumio volumio[768]: verbose: New Socket.io Connection to 192.168.0.33 from 192.168.0.11 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 4 Sep 17 17:07:18 volumio sudo[1103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 17 17:07:18 volumio sudo[1103]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::volumioGetVisibleSources Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:18 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 17 17:07:18 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 17 17:07:18 volumio volumio[768]: info: Received Get System Info Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:18 volumio volumio[768]: info: Discovery: Getting this device information Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:18 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:18 volumio sudo[1103]: pam_unix(sudo:session): session closed for user root Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:18 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:18 volumio volumio[768]: info: Listing playlists Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 17 17:07:18 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 17 17:07:18 volumio volumio[768]: info: Upmpdcli Daemon Started Sep 17 17:07:19 volumio volumio[1105]: Generating RSA private key, 4096 bit long modulus (2 primes) Sep 17 17:07:20 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 17 17:07:20 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 17 17:07:20 volumio volumio[768]: info: Received Get System Info Sep 17 17:07:20 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:20 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:20 volumio volumio[768]: info: Discovery: Getting this device information Sep 17 17:07:20 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:20 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:20 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:21 volumio volumio[768]: Cannot compose Albumart path Sep 17 17:07:27 volumio systemd[1]: systemd-fsckd.service: Succeeded. Sep 17 17:07:28 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 17 17:07:30 volumio volumio[1105]: ................................................................................++++ Sep 17 17:07:33 volumio volumio[768]: info: CoreCommandRouter::volumioPlay Sep 17 17:07:33 volumio volumio[768]: info: CoreStateMachine::play index undefined Sep 17 17:07:33 volumio volumio[768]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 17:07:33 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:34 volumio volumio[768]: info: CoreStateMachine::startPlaybackTimer Sep 17 17:07:34 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:36 volumio volumio[768]: error: MyVolumio Plugin failed to start in a timely fashion Sep 17 17:07:36 volumio volumio[768]: info: BOOT COMPLETED Sep 17 17:07:36 volumio volumio[768]: [Metrics] CommandRouter: 30s 826.11ms Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::volumiosetStartupVolume Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::Close All Modals sent Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::Close All Modals sent Sep 17 17:07:36 volumio volumio[768]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Sep 17 17:07:36 volumio volumio[768]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Sep 17 17:07:36 volumio volumio[768]: aplay: main:828: audio open error: No such device Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 17 17:07:36 volumio volumio[768]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 17 17:07:36 volumio volumio[768]: info: Received Get System Version Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 17 17:07:36 volumio volumio[768]: info: Received Get System Info Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 17 17:07:36 volumio volumio[768]: info: Discovery: Getting this device information Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::volumioGetState Sep 17 17:07:36 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:36 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 17 17:07:37 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 17 17:07:37 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 17 17:07:37 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 17 17:07:41 volumio volumio[1105]: ....................................................................................++++ Sep 17 17:07:41 volumio volumio[1105]: e is 65537 (0x010001) Sep 17 17:07:41 volumio volumio[1105]: writing RSA key Sep 17 17:07:43 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 17 17:07:43 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 17 17:07:43 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 17 17:07:43 volumio volumio[768]: info: CoreCommandRouter::volumioPlay Sep 17 17:07:43 volumio volumio[768]: info: CoreStateMachine::play index undefined Sep 17 17:07:43 volumio volumio[768]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 17:07:43 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:43 volumio volumio[768]: info: CoreStateMachine::startPlaybackTimer Sep 17 17:07:43 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:45 volumio volumio[768]: info: CoreCommandRouter::volumioPlay Sep 17 17:07:45 volumio volumio[768]: info: CoreStateMachine::play index undefined Sep 17 17:07:45 volumio volumio[768]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 17 17:07:45 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:45 volumio volumio[768]: info: CoreStateMachine::startPlaybackTimer Sep 17 17:07:45 volumio volumio[768]: info: CorePlayQueue::getTrack 0 Sep 17 17:07:52 volumio volumio[768]: info: CoreCommandRouter::volumioGetQueue Sep 17 17:07:52 volumio volumio[768]: info: CoreStateMachine::getQueue Sep 17 17:07:52 volumio volumio[768]: info: CorePlayQueue::getQueue Sep 17 17:07:59 volumio volumio[768]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 17 17:07:59 volumio volumio[768]: info: CURURI: albums:// Sep 17 17:07:59 volumio volumio[768]: info: listAlbums - loading Albums from cache Sep 17 17:07:59 volumio volumio[768]: info: Preload queue cleared Sep 17 17:07:59 volumio volumio[768]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 17:07:59 volumio volumio[768]: Error: certificate is not yet valid Sep 17 17:07:59 volumio volumio[768]: at TLSSocket.onConnectSecure (_tls_wrap.js:1497:34) Sep 17 17:07:59 volumio volumio[768]: at TLSSocket.emit (events.js:315:20) Sep 17 17:07:59 volumio volumio[768]: at TLSSocket._finishInit (_tls_wrap.js:932:8) Sep 17 17:07:59 volumio volumio[768]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:706:12) { Sep 17 17:07:59 volumio volumio[768]: code: 'CERT_NOT_YET_VALID' Sep 17 17:07:59 volumio volumio[768]: } Sep 17 17:07:59 volumio volumio[768]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 17 17:08:00 volumio sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-17 17:07 Sep 17 17:08:00 volumio sudo[1191]: 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"