-- Logs begin at Mon 2024-07-22 19:38:28 CEST, end at Wed 2024-09-04 20:05:46 CEST. -- Sep 04 20:05:26 volumio-kueche ntpd[555]: receive: Unexpected origin timestamp 0xea491803.3273869c does not match aorg 0000000000.00000000 from server@49.12.125.53 xmt 0xea831fe6.5e2b9159 Sep 04 20:05:26 volumio-kueche ntpd[555]: receive: Unexpected origin timestamp 0xea491803.32929062 does not match aorg 0000000000.00000000 from server@194.50.19.117 xmt 0xea831fe6.5e1392f2 Sep 04 20:05:26 volumio-kueche ntpd[555]: receive: Unexpected origin timestamp 0xea491803.32354755 does not match aorg 0000000000.00000000 from server@94.130.184.193 xmt 0xea831fe6.5de3c7ff Sep 04 20:05:26 volumio-kueche ntpd[555]: receive: Unexpected origin timestamp 0xea491803.3285efe5 does not match aorg 0000000000.00000000 from server@116.203.96.227 xmt 0xea831fe6.5e4c6d98 Sep 04 20:05:26 volumio-kueche ntpd[555]: receive: Unexpected origin timestamp 0xea491803.3279b076 does not match aorg 0000000000.00000000 from server@185.252.140.125 xmt 0xea831fe6.5e49cbe4 Sep 04 20:05:26 volumio-kueche ntpd[555]: receive: Unexpected origin timestamp 0xea491803.32800c9c does not match aorg 0000000000.00000000 from server@85.215.166.214 xmt 0xea831fe6.5e319dec Sep 04 20:05:26 volumio-kueche ntpd[555]: receive: Unexpected origin timestamp 0xea491803.32580214 does not match aorg 0000000000.00000000 from server@80.153.195.191 xmt 0xea831fe6.5f1f9f4c Sep 04 20:05:26 volumio-kueche sudo[943]: pam_unix(sudo:session): session closed for user root Sep 04 20:05:26 volumio-kueche systemd[1]: Starting Daily apt download activities... Sep 04 20:05:27 volumio-kueche volumio[809]: info: Discovery: Connecting to remote: 192.168.178.61 Sep 04 20:05:27 volumio-kueche volumio[809]: info: Upmpdcli Daemon Started Sep 04 20:05:28 volumio-kueche volumio[809]: info: Discovery: Connected to remote: 192.168.178.61 Sep 04 20:05:28 volumio-kueche volumio[809]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 04 20:05:28 volumio-kueche volumio[809]: info: Asound.conf file unchanged, so no further update is needed Sep 04 20:05:28 volumio-kueche volumio[809]: info: Output device has changed, restarting MPD Sep 04 20:05:29 volumio-kueche volumio[809]: info: Output device has changed, restarting Shairport Sync Sep 04 20:05:29 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 20:05:29 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 20:05:29 volumio-kueche sudo[967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 20:05:29 volumio-kueche sudo[970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 20:05:29 volumio-kueche sudo[967]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 20:05:29 volumio-kueche sudo[970]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 20:05:29 volumio-kueche sudo[967]: pam_unix(sudo:session): session closed for user root Sep 04 20:05:30 volumio-kueche systemd[1]: Listening on mpd.socket. Sep 04 20:05:30 volumio-kueche systemd[1]: Starting Music Player Daemon... Sep 04 20:05:30 volumio-kueche volumio[809]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 20:05:30 volumio-kueche volumio[809]: info: ___________ START PLUGINS ___________ Sep 04 20:05:30 volumio-kueche volumio[809]: info: ControllerMpd::onStart: Initializing MPD Sep 04 20:05:30 volumio-kueche volumio[809]: info: Creating MPD Configuration file Sep 04 20:05:31 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 20:05:31 volumio-kueche volumio[809]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 04 20:05:31 volumio-kueche volumio[809]: info: [1725473131344] CoreMusicLibrary::Adding element Media Servers Sep 04 20:05:31 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 20:05:31 volumio-kueche sudo[977]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 20:05:31 volumio-kueche sudo[977]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 20:05:31 volumio-kueche sudo[977]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Sep 04 20:05:31 volumio-kueche sudo[977]: pam_unix(sudo:session): session closed for user root Sep 04 20:05:31 volumio-kueche sudo[979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 20:05:31 volumio-kueche sudo[979]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 20:05:31 volumio-kueche sudo[979]: pam_unix(sudo:session): session closed for user root Sep 04 20:05:31 volumio-kueche sudo[981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 20:05:32 volumio-kueche sudo[981]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 20:05:32 volumio-kueche nmbd[553]: [2024/09/04 20:05:32.094617, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 04 20:05:32 volumio-kueche nmbd[553]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.131 for name WORKGROUP<1d>. Sep 04 20:05:32 volumio-kueche nmbd[553]: This response was from IP 192.168.178.4, reporting an IP address of 192.168.178.4. Sep 04 20:05:32 volumio-kueche nmbd[553]: [2024/09/04 20:05:32.103548, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 04 20:05:32 volumio-kueche nmbd[553]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.178.131 for name WORKGROUP<1d>. Sep 04 20:05:32 volumio-kueche nmbd[553]: This response was from IP 192.168.178.4, reporting an IP address of 192.168.178.4. Sep 04 20:05:32 volumio-kueche nmbd[553]: [2024/09/04 20:05:32.104463, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 04 20:05:32 volumio-kueche nmbd[553]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.178.131 for name WORKGROUP<1d>. Sep 04 20:05:32 volumio-kueche nmbd[553]: This response was from IP 192.168.178.4, reporting an IP address of 192.168.178.4. Sep 04 20:05:32 volumio-kueche systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 04 20:05:32 volumio-kueche systemd[1]: mpd.service: Succeeded. Sep 04 20:05:32 volumio-kueche systemd[1]: Stopped Music Player Daemon. Sep 04 20:05:32 volumio-kueche systemd[1]: Starting Music Player Daemon... Sep 04 20:05:32 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 20:05:32 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 20:05:33 volumio-kueche kernel: Internal error: Oops - undefined instruction: 0 [#1] ARM Sep 04 20:05:33 volumio-kueche kernel: Modules linked in: 8021q garp stp llc aes_arm aes_generic cmac bnep brcmfmac brcmutil hci_uart snd_soc_rpi_simple_soundcard nft_chain_nat xt_REDIRECT nf_nat snd_soc_bcm2835_i2s btbcm nf_conntrack snd_soc_pcm5102a nf_defrag_ipv6 nf_defrag_ipv4 xt_tcpudp nft_compat nf_tables regmap_mmio bluetooth snd_soc_core nfnetlink sha256_generic libsha256 cfg80211 raspberrypi_hwmon snd_bcm2835(C) snd_compress bcm2835_codec(C) snd_pcm_dmaengine i2c_bcm2835 snd_pcm bcm2835_v4l2(C) v4l2_mem2mem bcm2835_isp(C) bcm2835_mmal_vchiq(C) videobuf2_vmalloc videobuf2_dma_contig videobuf2_memops snd_seq videobuf2_v4l2 videobuf2_common snd_seq_device snd_timer videodev ecdh_generic ecc rfkill libaes snd vc_sm_cma(C) mc raspberrypi_gpiomem uio_pdrv_genirq uio fixed i2c_dev ip_tables x_tables ipv6 uas squashfs overlay nls_iso8859_1 fuse drm drm_panel_orientation_quirks backlight Sep 04 20:05:33 volumio-kueche kernel: CPU: 0 PID: 996 Comm: sudo Tainted: G C 6.1.69+ #1710 Sep 04 20:05:33 volumio-kueche kernel: Hardware name: BCM2835 Sep 04 20:05:33 volumio-kueche kernel: PC is at linux_banner+0xc395c/0x217f84 Sep 04 20:05:33 volumio-kueche kernel: LR is at wp_page_copy+0x250/0x6e8 Sep 04 20:05:33 volumio-kueche kernel: pc : [] lr : [] psr: a0000113 Sep 04 20:05:33 volumio-kueche kernel: sp : deaf1ec0 ip : 00000000 fp : 00000873 Sep 04 20:05:33 volumio-kueche kernel: r10: 00000000 r9 : deaf1fb0 r8 : c0c7302c Sep 04 20:05:33 volumio-kueche kernel: r7 : 00000000 r6 : 00000008 r5 : b68f7000 r4 : 00000000 Sep 04 20:05:33 volumio-kueche kernel: r3 : 00000178 r2 : c32ca080 r1 : 00000000 r0 : 00000008 Sep 04 20:05:33 volumio-kueche kernel: Flags: NzCv IRQs on FIQs on Mode SVC_32 ISA ARM Segment user Sep 04 20:05:33 volumio-kueche kernel: Control: 00c5387d Table: 031fc008 DAC: 00000055 Sep 04 20:05:33 volumio-kueche kernel: Register r0 information: non-paged memory Sep 04 20:05:33 volumio-kueche kernel: Register r1 information: NULL pointer Sep 04 20:05:33 volumio-kueche kernel: Register r2 information: slab task_struct start c32ca080 pointer offset 0 Sep 04 20:05:33 volumio-kueche kernel: Register r3 information: non-paged memory Sep 04 20:05:33 volumio-kueche kernel: Register r4 information: NULL pointer Sep 04 20:05:33 volumio-kueche kernel: Register r5 information: non-paged memory Sep 04 20:05:33 volumio-kueche kernel: Register r6 information: non-paged memory Sep 04 20:05:33 volumio-kueche kernel: Register r7 information: NULL pointer Sep 04 20:05:33 volumio-kueche kernel: Register r8 information: non-slab/vmalloc memory Sep 04 20:05:33 volumio-kueche kernel: Register r9 information: 2-page vmalloc region starting at 0xdeaf0000 allocated at kernel_clone+0xac/0x31c Sep 04 20:05:33 volumio-kueche kernel: Register r10 information: NULL pointer Sep 04 20:05:33 volumio-kueche kernel: Register r11 information: non-paged memory Sep 04 20:05:33 volumio-kueche kernel: Register r12 information: NULL pointer Sep 04 20:05:33 volumio-kueche kernel: Process sudo (pid: 996, stack limit = 0xf95350ea) Sep 04 20:05:33 volumio-kueche kernel: Stack: (0xdeaf1ec0 to 0xdeaf2000) Sep 04 20:05:33 volumio-kueche kernel: 1ec0: c0c7302c ffffffff dd54d1f0 deaf1fb0 00000002 b68f7000 00000873 c08acfd8 Sep 04 20:05:33 volumio-kueche kernel: 1ee0: c0b63680 dd710360 00100cca 00000010 b68f7000 b68f7000 00000a55 c31feda0 Sep 04 20:05:33 volumio-kueche kernel: 1f00: c31feda0 085dc38f 00000000 d8cf52f0 dd7113dc dd54d1f0 00000000 e57e1287 Sep 04 20:05:33 volumio-kueche kernel: 1f20: b68f9000 deaf1fb0 00000255 dd54d1c0 b68f7f3c 0000081f 00000002 b68f7000 Sep 04 20:05:33 volumio-kueche kernel: 1f40: 00000873 c08d6604 b68f9000 c01b77e0 deaf1f74 c01b77e0 00000032 00000100 Sep 04 20:05:33 volumio-kueche kernel: 1f60: deaf1f70 c0c78c80 0000081f c08d6488 b68f7f3c deaf1fb0 be9c0c44 013abd88 Sep 04 20:05:33 volumio-kueche kernel: 1f80: be9c0bc4 c0018a28 00000000 00000002 000000c0 c0008404 b6fa45d8 a0000010 Sep 04 20:05:33 volumio-kueche kernel: 1fa0: ffffffff c32ca080 00c5387d c0008f94 013abc40 00000005 b68e6f8c b68f7f38 Sep 04 20:05:33 volumio-kueche kernel: 1fc0: 013abc20 70000025 6ffffdff 6ffffeff 00000003 be9c0c44 013abd88 be9c0bc4 Sep 04 20:05:33 volumio-kueche kernel: 1fe0: b68d7000 be9c0ac0 6fffffff b6fa45d8 a0000010 ffffffff 00000000 00000000 Sep 04 20:05:33 volumio-kueche kernel: wp_page_copy from 0xb68f7000 Sep 04 20:05:33 volumio-kueche kernel: Code: 08c069e4 ff646654 68e870ad 64665412 (f6b973ff) Sep 04 20:05:33 volumio-kueche kernel: ---[ end trace 0000000000000000 ]--- Sep 04 20:05:33 volumio-kueche kernel: note: sudo[996] exited with irqs disabled Sep 04 20:05:34 volumio-kueche volumio[809]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 20:05:34 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 20:05:34 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 20:05:34 volumio-kueche volumio[809]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 20:05:34 volumio-kueche volumio[809]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 04 20:05:34 volumio-kueche volumio[809]: info: [1725473134393] CoreMusicLibrary::Adding element Last_100 Sep 04 20:05:34 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 20:05:34 volumio-kueche volumio[809]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 04 20:05:34 volumio-kueche volumio[809]: info: [1725473134419] CoreMusicLibrary::Adding element Webradio Sep 04 20:05:34 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 20:05:34 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 20:05:34 volumio-kueche volumio[809]: info: Initializing BBC Radios Sep 04 20:05:34 volumio-kueche volumio[809]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Sep 04 20:05:34 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 20:05:34 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 20:05:34 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 20:05:35 volumio-kueche volumio[809]: info: Creating Spotify config file Sep 04 20:05:35 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 20:05:35 volumio-kueche volumio[809]: info: Loading i18n strings for locale en Sep 04 20:05:35 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 04 20:05:35 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 20:05:35 volumio-kueche volumio[809]: info: FusionDsp - mixtype--------------------- Software Sep 04 20:05:35 volumio-kueche volumio[809]: info: Volumio Calling Home Sep 04 20:05:36 volumio-kueche volumio[809]: info: Preparing to generate the ALSA configuration file Sep 04 20:05:37 volumio-kueche volumio[809]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Sep 04 20:05:37 volumio-kueche volumio[809]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Sep 04 20:05:37 volumio-kueche volumio[809]: info: Reading ALSA contributions from plugins. Sep 04 20:05:37 volumio-kueche volumio[809]: info: MPD Permissions set Sep 04 20:05:37 volumio-kueche volumio[809]: info: MPD Permissions set Sep 04 20:05:37 volumio-kueche volumio[809]: info: Volumio called home Sep 04 20:05:37 volumio-kueche volumio[809]: info: Spotify config file written Sep 04 20:05:38 volumio-kueche sudo[1027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Sep 04 20:05:38 volumio-kueche sudo[1027]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 20:05:38 volumio-kueche systemd[1]: Started go-librespot Daemon. Sep 04 20:05:38 volumio-kueche go-librespot[1034]: Librespot-go daemon starting... Sep 04 20:05:38 volumio-kueche sudo[1027]: pam_unix(sudo:session): session closed for user root Sep 04 20:05:38 volumio-kueche volumio[809]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 04 20:05:39 volumio-kueche volumio[809]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Sep 04 20:05:39 volumio-kueche volumio[809]: info: camilladsp service started and running in background, instance 1 Sep 04 20:05:39 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 20:05:39 volumio-kueche volumio[809]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 04 20:05:39 volumio-kueche volumio[809]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Sep 04 20:05:39 volumio-kueche volumio[809]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Sep 04 20:05:39 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:39+02:00" level=info msg="generated new device id: 6e8facc50dc3fc71ba9ea1a056ed819dbdc02801" Sep 04 20:05:39 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:39+02:00" level=debug msg="stored credentials found for 1124764770" Sep 04 20:05:39 volumio-kueche volumio[809]: info: FusionDsp loaded Sep 04 20:05:39 volumio-kueche volumio[809]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 20:05:39 volumio-kueche sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Sep 04 20:05:39 volumio-kueche sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 20:05:39 volumio-kueche volumio[809]: info: FusionDsp - Reporting Fusion DSP Enabled Sep 04 20:05:39 volumio-kueche volumio[809]: info: Adding Signal Path Element [object Object] Sep 04 20:05:39 volumio-kueche volumio[809]: info: Adding fusiondspeq DSP Signal Path Element Sep 04 20:05:39 volumio-kueche sudo[1057]: pam_unix(sudo:session): session closed for user root Sep 04 20:05:40 volumio-kueche volumio[809]: info: FusionDsp - ---- installed callbackRead Sep 04 20:05:40 volumio-kueche volumio[809]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 20:05:40 volumio-kueche volumio[809]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Sep 04 20:05:40 volumio-kueche volumio[809]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Sep 04 20:05:40 volumio-kueche volumio[809]: at onErrorNT (internal/child_process.js:465:16) Sep 04 20:05:40 volumio-kueche volumio[809]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Sep 04 20:05:40 volumio-kueche volumio[809]: at runNextTicks (internal/process/task_queues.js:62:3) Sep 04 20:05:40 volumio-kueche volumio[809]: at listOnTimeout (internal/timers.js:523:9) Sep 04 20:05:40 volumio-kueche volumio[809]: at processTimers (internal/timers.js:497:7) { Sep 04 20:05:40 volumio-kueche volumio[809]: errno: -2, Sep 04 20:05:40 volumio-kueche volumio[809]: code: 'ENOENT', Sep 04 20:05:40 volumio-kueche volumio[809]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Sep 04 20:05:40 volumio-kueche volumio[809]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Sep 04 20:05:40 volumio-kueche volumio[809]: spawnargs: [ Sep 04 20:05:40 volumio-kueche volumio[809]: '-p', Sep 04 20:05:40 volumio-kueche volumio[809]: 9876, Sep 04 20:05:40 volumio-kueche volumio[809]: '-o', Sep 04 20:05:40 volumio-kueche volumio[809]: '/tmp/camilladsp.log', Sep 04 20:05:40 volumio-kueche volumio[809]: '-l', Sep 04 20:05:40 volumio-kueche volumio[809]: 'warn', Sep 04 20:05:40 volumio-kueche volumio[809]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Sep 04 20:05:40 volumio-kueche volumio[809]: ] Sep 04 20:05:40 volumio-kueche volumio[809]: } Sep 04 20:05:40 volumio-kueche volumio[809]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 20:05:40 volumio-kueche systemd[1]: apt-daily.service: Succeeded. Sep 04 20:05:40 volumio-kueche systemd[1]: Started Daily apt download activities. Sep 04 20:05:40 volumio-kueche systemd[1]: Starting Daily apt upgrade and clean activities... Sep 04 20:05:43 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:43+02:00" level=debug msg="fetched new accesspoints: [ap2-gew4.spotify.com:4070 ap2-gew4.spotify.com:443 ap2-gew4.spotify.com:80 ap2-guc3.spotify.com:4070 ap2-gew1.spotify.com:443 ap2-gae2.spotify.com:80]" Sep 04 20:05:43 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:43+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Sep 04 20:05:43 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:43+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Sep 04 20:05:43 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:43+02:00" level=debug msg="zeroconf server listening on port 43887" Sep 04 20:05:43 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:43+02:00" level=debug msg="obtained new client token: AADL4BQSoUiHXAU3+G8qOyfXo7AJRrU96XXbF+Q5JNiRZ6ydz8U2hDxXUGlV5VVXZg2B24v3i7lfAhj0HFzXqmz3U+uHXvaD9+90iPCEgnyXfHF5FScWcbeDAr70KYphnxZGVHs+TbAx/tjKuI1gnjBrwIPnnEUb/ig3LJmups3+ZK6FJ+nztP2T3CSGGvub9wysbyFz8MsqBnx4TKF6LF8V22XYBz7Z8JBY+eOJIzq0ECao98BirQOT" Sep 04 20:05:44 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:44+02:00" level=debug msg="completed keyexchange" Sep 04 20:05:44 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:44+02:00" level=debug msg="completed challenge" Sep 04 20:05:44 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:44+02:00" level=debug msg="authenticated as 1124764770" Sep 04 20:05:45 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:45+02:00" level=debug msg="authenticated as 1124764770" Sep 04 20:05:45 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:45+02:00" level=debug msg="dealer connection opened" Sep 04 20:05:45 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:45+02:00" level=debug msg="initializing zeroconf session, username: 1124764770" Sep 04 20:05:45 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:45+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Sep 04 20:05:45 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:45+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Sep 04 20:05:45 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:45+02:00" level=debug msg="received connection id: NmM5N2QwMzEtNDNlNC00OGQ1LTk2NDMtMmU1NzZjYzEzMDY1K2RlYWxlcit0Y3A6Ly8wYWNhNTllMy5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMDNGRkNFREYxNUYwRTM2RDIxNUIwQUQ2OEVGOUNGRTZBM0RGN0RDQ0E4ODYwOEIxMDcwRURCMjRFNzc2NkUzNg==" Sep 04 20:05:45 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:45+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Sep 04 20:05:45 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:45+02:00" level=debug msg="put connect state because NEW_DEVICE" Sep 04 20:05:46 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:46+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Sep 04 20:05:46 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:46+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Sep 04 20:05:46 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:46+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 493" Sep 04 20:05:46 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:46+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1371" Sep 04 20:05:46 volumio-kueche go-librespot[1034]: time="2024-09-04T20:05:46+02:00" level=debug msg="autoplay enabled: false" Sep 04 20:05:46 volumio-kueche sudo[1095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 20:04 Sep 04 20:05:46 volumio-kueche sudo[1095]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"