-- Logs begin at Thu 2019-02-14 08:11:59 -02, end at Tue 2024-11-19 12:46:45 -03. -- Nov 19 12:46:02 volumio kernel: usb usb2: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Nov 19 12:46:02 volumio kernel: usb usb2: SerialNumber: 1c1a400.usb Nov 19 12:46:02 volumio kernel: hub 2-0:1.0: USB hub found Nov 19 12:46:02 volumio kernel: hub 2-0:1.0: 1 port detected Nov 19 12:46:02 volumio kernel: usbcore: registered new interface driver usb-storage Nov 19 12:46:02 volumio kernel: sun6i-rtc 1f00000.rtc: registered as rtc0 Nov 19 12:46:02 volumio kernel: sun6i-rtc 1f00000.rtc: setting system clock to 1970-01-01T00:00:14 UTC (14) Nov 19 12:46:02 volumio kernel: sun6i-rtc 1f00000.rtc: RTC enabled Nov 19 12:46:02 volumio kernel: i2c_dev: i2c /dev entries driver Nov 19 12:46:02 volumio kernel: sun8i-h3-r-pinctrl 1f02c00.pinctrl: supply vcc-pl not found, using dummy regulator Nov 19 12:46:02 volumio kernel: sunxi-wdt 1c20ca0.watchdog: Watchdog enabled (timeout=16 sec, nowayout=0) Nov 19 12:46:02 volumio kernel: sun8i-h3-pinctrl 1c20800.pinctrl: supply vcc-pf not found, using dummy regulator Nov 19 12:46:02 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Nov 19 12:46:02 volumio kernel: sunxi-mmc 1c0f000.mmc: Got CD GPIO Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Set mod clock to 50000000 (50 Mhz) from 24000000 (24 Mhz) Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: will run requests pump with realtime priority Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register cbc(aes) Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register ecb(aes) Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register cbc(des3_ede) Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register ecb(des3_ede) Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register md5 Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register sha1 Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register sha224 Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register sha256 Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register sha384 Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register sha512 Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: Register stdrng Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: TRNG not supported Nov 19 12:46:02 volumio kernel: sun8i-ce 1c15000.crypto: CryptoEngine Die ID 1 Nov 19 12:46:02 volumio kernel: hid: raw HID events driver (C) Jiri Kosina Nov 19 12:46:02 volumio kernel: usbcore: registered new interface driver usbhid Nov 19 12:46:02 volumio kernel: usbhid: USB HID core driver Nov 19 12:46:02 volumio kernel: debugfs: Directory '1c22c00.codec' with parent 'H3 Audio Codec' already present! Nov 19 12:46:02 volumio kernel: Initializing XFRM netlink socket Nov 19 12:46:02 volumio kernel: NET: Registered PF_INET6 protocol family Nov 19 12:46:02 volumio kernel: sunxi-mmc 1c0f000.mmc: initialized, max. request size: 16384 KB Nov 19 12:46:02 volumio kernel: Segment Routing with IPv6 Nov 19 12:46:02 volumio kernel: In-situ OAM (IOAM) with IPv6 Nov 19 12:46:02 volumio kernel: NET: Registered PF_PACKET protocol family Nov 19 12:46:02 volumio kernel: NET: Registered PF_KEY protocol family Nov 19 12:46:02 volumio kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 19 12:46:02 volumio kernel: 8021q: 802.1Q VLAN Support v1.8 Nov 19 12:46:02 volumio kernel: Key type dns_resolver registered Nov 19 12:46:02 volumio kernel: Registering SWP/SWPB emulation handler Nov 19 12:46:02 volumio kernel: registered taskstats version 1 Nov 19 12:46:02 volumio kernel: Loading compiled-in X.509 certificates Nov 19 12:46:02 volumio kernel: Loaded X.509 cert 'Build time autogenerated kernel key: 8f8e38801ad26e1c5752b0545ce65e141a715a7d' Nov 19 12:46:02 volumio kernel: mmc0: host does not support reading read-only switch, assuming write-enable Nov 19 12:46:02 volumio kernel: zswap: loaded using pool zstd/z3fold Nov 19 12:46:02 volumio kernel: mmc0: new high speed SDHC card at address aaaa Nov 19 12:46:02 volumio kernel: mmcblk0: mmc0:aaaa SU08G 7.40 GiB Nov 19 12:46:02 volumio kernel: Key type .fscrypt registered Nov 19 12:46:02 volumio kernel: Key type fscrypt-provisioning registered Nov 19 12:46:02 volumio kernel: mmcblk0: p1 p2 p3 Nov 19 12:46:02 volumio kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=yes Nov 19 12:46:02 volumio kernel: Key type encrypted registered Nov 19 12:46:02 volumio kernel: AppArmor: AppArmor sha1 policy hashing enabled Nov 19 12:46:02 volumio kernel: sun8i-h3-pinctrl 1c20800.pinctrl: supply vcc-pg not found, using dummy regulator Nov 19 12:46:02 volumio kernel: sun4i-drm display-engine: bound 1100000.mixer (ops 0xc0aa3538) Nov 19 12:46:02 volumio kernel: sun4i-drm display-engine: bound 1c0c000.lcd-controller (ops 0xc0a9f46c) Nov 19 12:46:02 volumio kernel: sun8i-dw-hdmi 1ee0000.hdmi: supply hvcc not found, using dummy regulator Nov 19 12:46:02 volumio kernel: sun8i-dw-hdmi 1ee0000.hdmi: Detected HDMI TX controller v1.32a with HDCP (sun8i_dw_hdmi_phy) Nov 19 12:46:02 volumio kernel: sun8i-dw-hdmi 1ee0000.hdmi: registered DesignWare HDMI I2C bus driver Nov 19 12:46:02 volumio kernel: sun4i-drm display-engine: bound 1ee0000.hdmi (ops 0xc0aa2aec) Nov 19 12:46:02 volumio kernel: [drm] Initialized sun4i-drm 1.0.0 20150629 for display-engine on minor 0 Nov 19 12:46:02 volumio kernel: sun4i-drm display-engine: [drm] Cannot find any crtc or sizes Nov 19 12:46:02 volumio kernel: ehci-platform 1c1b000.usb: EHCI Host Controller Nov 19 12:46:02 volumio kernel: ehci-platform 1c1b000.usb: new USB bus registered, assigned bus number 3 Nov 19 12:46:02 volumio kernel: sun4i-drm display-engine: [drm] Cannot find any crtc or sizes Nov 19 12:46:02 volumio kernel: ehci-platform 1c1b000.usb: irq 37, io mem 0x01c1b000 Nov 19 12:46:02 volumio kernel: ehci-platform 1c1b000.usb: USB 2.0 started, EHCI 1.00 Nov 19 12:46:02 volumio kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Nov 19 12:46:02 volumio kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 19 12:46:02 volumio kernel: usb usb3: Product: EHCI Host Controller Nov 19 12:46:02 volumio kernel: usb usb3: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Nov 19 12:46:02 volumio kernel: usb usb3: SerialNumber: 1c1b000.usb Nov 19 12:46:02 volumio kernel: hub 3-0:1.0: USB hub found Nov 19 12:46:02 volumio kernel: hub 3-0:1.0: 1 port detected Nov 19 12:46:02 volumio kernel: ehci-platform 1c1c000.usb: EHCI Host Controller Nov 19 12:46:02 volumio kernel: ehci-platform 1c1c000.usb: new USB bus registered, assigned bus number 4 Nov 19 12:46:02 volumio kernel: ehci-platform 1c1c000.usb: irq 39, io mem 0x01c1c000 Nov 19 12:46:02 volumio kernel: ehci-platform 1c1c000.usb: USB 2.0 started, EHCI 1.00 Nov 19 12:46:02 volumio kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Nov 19 12:46:02 volumio kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 19 12:46:02 volumio kernel: usb usb4: Product: EHCI Host Controller Nov 19 12:46:02 volumio kernel: usb usb4: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Nov 19 12:46:02 volumio kernel: usb usb4: SerialNumber: 1c1c000.usb Nov 19 12:46:02 volumio kernel: hub 4-0:1.0: USB hub found Nov 19 12:46:02 volumio kernel: hub 4-0:1.0: 1 port detected Nov 19 12:46:02 volumio kernel: ehci-platform 1c1d000.usb: EHCI Host Controller Nov 19 12:46:02 volumio kernel: ehci-platform 1c1d000.usb: new USB bus registered, assigned bus number 5 Nov 19 12:46:02 volumio kernel: ehci-platform 1c1d000.usb: irq 41, io mem 0x01c1d000 Nov 19 12:46:02 volumio kernel: ehci-platform 1c1d000.usb: USB 2.0 started, EHCI 1.00 Nov 19 12:46:02 volumio kernel: usb usb5: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Nov 19 12:46:02 volumio kernel: usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 19 12:46:02 volumio kernel: usb usb5: Product: EHCI Host Controller Nov 19 12:46:02 volumio kernel: usb usb5: Manufacturer: Linux 5.15.93-sunxi ehci_hcd Nov 19 12:46:02 volumio kernel: usb usb5: SerialNumber: 1c1d000.usb Nov 19 12:46:02 volumio kernel: hub 5-0:1.0: USB hub found Nov 19 12:46:02 volumio kernel: hub 5-0:1.0: 1 port detected Nov 19 12:46:02 volumio kernel: ohci-platform 1c1b400.usb: Generic Platform OHCI controller Nov 19 12:46:02 volumio kernel: ohci-platform 1c1b400.usb: new USB bus registered, assigned bus number 6 Nov 19 12:46:02 volumio kernel: ohci-platform 1c1b400.usb: irq 38, io mem 0x01c1b400 Nov 19 12:46:02 volumio kernel: usb usb6: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Nov 19 12:46:02 volumio kernel: usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 19 12:46:02 volumio kernel: usb usb6: Product: Generic Platform OHCI controller Nov 19 12:46:02 volumio kernel: usb usb6: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Nov 19 12:46:02 volumio kernel: usb usb6: SerialNumber: 1c1b400.usb Nov 19 12:46:02 volumio kernel: hub 6-0:1.0: USB hub found Nov 19 12:46:02 volumio kernel: hub 6-0:1.0: 1 port detected Nov 19 12:46:02 volumio kernel: ohci-platform 1c1c400.usb: Generic Platform OHCI controller Nov 19 12:46:02 volumio kernel: ohci-platform 1c1c400.usb: new USB bus registered, assigned bus number 7 Nov 19 12:46:02 volumio kernel: ohci-platform 1c1c400.usb: irq 40, io mem 0x01c1c400 Nov 19 12:46:02 volumio kernel: usb usb7: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Nov 19 12:46:02 volumio kernel: usb usb7: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 19 12:46:02 volumio kernel: usb usb7: Product: Generic Platform OHCI controller Nov 19 12:46:02 volumio kernel: usb usb7: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Nov 19 12:46:02 volumio kernel: usb usb7: SerialNumber: 1c1c400.usb Nov 19 12:46:02 volumio kernel: hub 7-0:1.0: USB hub found Nov 19 12:46:02 volumio kernel: hub 7-0:1.0: 1 port detected Nov 19 12:46:02 volumio kernel: ohci-platform 1c1d400.usb: Generic Platform OHCI controller Nov 19 12:46:02 volumio kernel: ohci-platform 1c1d400.usb: new USB bus registered, assigned bus number 8 Nov 19 12:46:02 volumio kernel: ohci-platform 1c1d400.usb: irq 42, io mem 0x01c1d400 Nov 19 12:46:02 volumio kernel: usb usb8: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.15 Nov 19 12:46:02 volumio kernel: usb usb8: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 19 12:46:02 volumio kernel: usb usb8: Product: Generic Platform OHCI controller Nov 19 12:46:02 volumio kernel: usb usb8: Manufacturer: Linux 5.15.93-sunxi ohci_hcd Nov 19 12:46:02 volumio kernel: usb usb8: SerialNumber: 1c1d400.usb Nov 19 12:46:02 volumio kernel: hub 8-0:1.0: USB hub found Nov 19 12:46:02 volumio kernel: hub 8-0:1.0: 1 port detected Nov 19 12:46:02 volumio kernel: of_cfs_init Nov 19 12:46:02 volumio kernel: of_cfs_init: OK Nov 19 12:46:02 volumio kernel: ALSA device list: Nov 19 12:46:02 volumio kernel: #0: H3 Audio Codec Nov 19 12:46:02 volumio kernel: Freeing unused kernel image (initmem) memory: 1024K Nov 19 12:46:02 volumio kernel: Run /init as init process Nov 19 12:46:02 volumio kernel: with arguments: Nov 19 12:46:02 volumio kernel: /init Nov 19 12:46:02 volumio kernel: splash Nov 19 12:46:02 volumio kernel: with environment: Nov 19 12:46:02 volumio kernel: HOME=/ Nov 19 12:46:02 volumio kernel: TERM=linux Nov 19 12:46:02 volumio kernel: ubootpart=01101494-01 Nov 19 12:46:02 volumio kernel: ubootsource=mmc Nov 19 12:46:02 volumio kernel: imgpart=/dev/mmcblk0p2 Nov 19 12:46:02 volumio kernel: imgfile=/volumio_current.sqsh Nov 19 12:46:02 volumio kernel: hwver=orangepi Nov 19 12:46:02 volumio kernel: sunxi_ve_mem_reserve=0 Nov 19 12:46:02 volumio kernel: sunxi_g2d_mem_reserve=0 Nov 19 12:46:02 volumio kernel: sunxi_fb_mem_reserve=16 Nov 19 12:46:02 volumio kernel: cgroup_enable=memory Nov 19 12:46:02 volumio kernel: usb 4-1: new high-speed USB device number 2 using ehci-platform Nov 19 12:46:02 volumio kernel: usb 4-1: New USB device found, idVendor=148f, idProduct=5370, bcdDevice= 1.01 Nov 19 12:46:02 volumio kernel: usb 4-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Nov 19 12:46:02 volumio kernel: usb 4-1: Product: 802.11 n WLAN Nov 19 12:46:02 volumio kernel: usb 4-1: Manufacturer: Ralink Nov 19 12:46:02 volumio kernel: usb 4-1: SerialNumber: 1.0 Nov 19 12:46:02 volumio kernel: input: r_gpio_keys as /devices/platform/r_gpio_keys/input/input0 Nov 19 12:46:02 volumio kernel: usb_phy_generic usb_phy_generic.3.auto: supply vcc not found, using dummy regulator Nov 19 12:46:02 volumio kernel: usb_phy_generic usb_phy_generic.3.auto: dummy supplies not allowed for exclusive requests Nov 19 12:46:02 volumio kernel: musb-hdrc musb-hdrc.4.auto: MUSB HDRC host driver Nov 19 12:46:02 volumio kernel: musb-hdrc musb-hdrc.4.auto: new USB bus registered, assigned bus number 9 Nov 19 12:46:02 volumio kernel: usb usb9: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.15 Nov 19 12:46:02 volumio kernel: usb usb9: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Nov 19 12:46:02 volumio kernel: usb usb9: Product: MUSB HDRC host driver Nov 19 12:46:02 volumio kernel: usb usb9: Manufacturer: Linux 5.15.93-sunxi musb-hcd Nov 19 12:46:02 volumio kernel: usb usb9: SerialNumber: musb-hdrc.4.auto Nov 19 12:46:02 volumio kernel: hub 9-0:1.0: USB hub found Nov 19 12:46:02 volumio kernel: hub 9-0:1.0: 1 port detected Nov 19 12:46:02 volumio kernel: lima 1c40000.gpu: gp - mali400 version major 1 minor 1 Nov 19 12:46:02 volumio kernel: lima 1c40000.gpu: pp0 - mali400 version major 1 minor 1 Nov 19 12:46:02 volumio kernel: lima 1c40000.gpu: pp1 - mali400 version major 1 minor 1 Nov 19 12:46:02 volumio kernel: lima 1c40000.gpu: l2 cache 64K, 4-way, 64byte cache line, 64bit external bus Nov 19 12:46:02 volumio kernel: lima 1c40000.gpu: bus rate = 200000000 Nov 19 12:46:02 volumio kernel: lima 1c40000.gpu: mod rate = 297000000 Nov 19 12:46:02 volumio kernel: lima 1c40000.gpu: dev_pm_opp_set_regulators: no regulator (mali) found: -19 Nov 19 12:46:02 volumio kernel: lima 1c40000.gpu: Failed to register cooling device Nov 19 12:46:02 volumio kernel: [drm] Initialized lima 1.2.0 20200215 for 1c40000.gpu on minor 1 Nov 19 12:46:02 volumio kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Nov 19 12:46:02 volumio kernel: EXT4-fs (mmcblk0p2): recovery complete Nov 19 12:46:02 volumio kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Nov 19 12:46:02 volumio kernel: loop0: detected capacity change from 0 to 823560 Nov 19 12:46:02 volumio kernel: EXT4-fs (mmcblk0p3): recovery complete Nov 19 12:46:02 volumio kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Nov 19 12:46:02 volumio systemd[1]: System time before build time, advancing clock. Nov 19 12:46:02 volumio systemd[1]: Inserted module 'autofs4' Nov 19 12:46:02 volumio systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Nov 19 12:46:02 volumio systemd[1]: Detected architecture arm. Nov 19 12:46:02 volumio systemd[1]: Set hostname to . Nov 19 12:46:02 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 19 12:46:02 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 19 12:46:02 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 19 12:46:02 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 19 12:46:02 volumio systemd[1]: Created slice User and Session Slice. Nov 19 12:46:02 volumio systemd[1]: Listening on udev Control Socket. Nov 19 12:46:02 volumio systemd[1]: Listening on udev Kernel Socket. Nov 19 12:46:02 volumio systemd[1]: Reached target Slices. Nov 19 12:46:02 volumio systemd[1]: Listening on fsck to fsckd communication Socket. Nov 19 12:46:02 volumio systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Nov 19 12:46:02 volumio kernel: RPC: Registered named UNIX socket transport module. Nov 19 12:46:02 volumio kernel: RPC: Registered udp transport module. Nov 19 12:46:02 volumio kernel: RPC: Registered tcp transport module. Nov 19 12:46:02 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 19 12:46:02 volumio systemd-journald[426]: Journal started Nov 19 12:46:02 volumio systemd-journald[426]: Runtime journal (/run/log/journal/b8e23c24fa1d772592f70e9d6664bf5c) is 7.5M, max 30.0M, 22.5M free. Nov 19 12:46:02 volumio fake-hwclock[431]: Tue Nov 19 15:46:02 UTC 2024 Nov 19 12:46:02 volumio systemd[1]: Started Create Static Device Nodes in /dev. Nov 19 12:46:02 volumio systemd[1]: Reached target Local File Systems (Pre). Nov 19 12:46:02 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Nov 19 12:46:02 volumio systemd[1]: Mounting /tmp... Nov 19 12:46:02 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Nov 19 12:46:02 volumio systemd[1]: Mounting /var/log... Nov 19 12:46:02 volumio systemd[1]: Mounting /var/spool/cups... Nov 19 12:46:02 volumio systemd[1]: Starting udev Kernel Device Manager... Nov 19 12:46:02 volumio systemd[1]: Mounted /tmp. Nov 19 12:46:02 volumio systemd[1]: Mounted /var/log. Nov 19 12:46:02 volumio systemd[1]: Mounted /var/spool/cups. Nov 19 12:46:02 volumio systemd[1]: Mounting /var/spool/cups/tmp... Nov 19 12:46:02 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Nov 19 12:46:02 volumio systemd[1]: Mounted /var/spool/cups/tmp. Nov 19 12:46:02 volumio systemd-udevd[460]: Network interface NamePolicy= disabled on kernel command line, ignoring. Nov 19 12:46:02 volumio systemd-journald[426]: Runtime journal (/run/log/journal/b8e23c24fa1d772592f70e9d6664bf5c) is 7.5M, max 30.0M, 22.5M free. Nov 19 12:46:02 volumio systemd[1]: Started udev Kernel Device Manager. Nov 19 12:46:02 volumio systemd[1]: Started Flush Journal to Persistent Storage. Nov 19 12:46:02 volumio systemd[1]: Started udev Coldplug all Devices. Nov 19 12:46:02 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Nov 19 12:46:02 volumio systemd[1]: Starting Show Plymouth Boot Screen... Nov 19 12:46:02 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 19 12:46:02 volumio kernel: random: systemd-journal: uninitialized urandom read (16 bytes read) Nov 19 12:46:02 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 19 12:46:02 volumio systemd[1]: plymouth-start.service: Succeeded. Nov 19 12:46:02 volumio systemd[1]: Started Show Plymouth Boot Screen. Nov 19 12:46:02 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Nov 19 12:46:02 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Nov 19 12:46:02 volumio systemd[1]: Reached target Paths. Nov 19 12:46:02 volumio systemd[1]: Reached target Local Encrypted Volumes. Nov 19 12:46:03 volumio kernel: sunxi_cedrus: module is from the staging directory, the quality is unknown, you have been warned. Nov 19 12:46:03 volumio kernel: cedrus 1c0e000.video-codec: Device registered as /dev/video0 Nov 19 12:46:03 volumio systemd-udevd[466]: Using default interface naming scheme 'v240'. Nov 19 12:46:03 volumio systemd-udevd[466]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 19 12:46:03 volumio systemd-udevd[466]: link_config: could not get ethtool features for eth0 Nov 19 12:46:03 volumio systemd-udevd[466]: Could not set offload features of eth0: Device or resource busy Nov 19 12:46:03 volumio kernel: debugfs: File 'Capture' in directory 'dapm' already present! Nov 19 12:46:03 volumio kernel: Registered IR keymap rc-empty Nov 19 12:46:03 volumio kernel: rc rc0: sunxi-ir as /devices/platform/soc/1f02000.ir/rc/rc0 Nov 19 12:46:03 volumio kernel: rc rc0: lirc_dev: driver sunxi-ir registered at minor = 0, raw IR receiver, no transmitter Nov 19 12:46:03 volumio kernel: input: sunxi-ir as /devices/platform/soc/1f02000.ir/rc/rc0/input1 Nov 19 12:46:03 volumio kernel: sunxi-ir 1f02000.ir: initialized sunXi IR driver Nov 19 12:46:03 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 19 12:46:03 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 19 12:46:03 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 19 12:46:03 volumio kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Nov 19 12:46:03 volumio kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Nov 19 12:46:03 volumio kernel: platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 Nov 19 12:46:03 volumio kernel: platform regulatory.0: Falling back to sysfs fallback for: regulatory.db Nov 19 12:46:04 volumio systemd-udevd[465]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 19 12:46:04 volumio kernel: cfg80211: failed to load regulatory.db Nov 19 12:46:04 volumio systemd-udevd[465]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Nov 19 12:46:04 volumio systemd-udevd[472]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Nov 19 12:46:04 volumio kernel: usb 4-1: reset high-speed USB device number 2 using ehci-platform Nov 19 12:46:04 volumio systemd[1]: Found device /dev/ttyS0. Nov 19 12:46:04 volumio kernel: ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 5390, rev 0502 detected Nov 19 12:46:04 volumio systemd[1]: Found device /dev/mmcblk0p1. Nov 19 12:46:04 volumio kernel: ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 5370 detected Nov 19 12:46:04 volumio kernel: ieee80211 phy0: Selected rate control algorithm 'minstrel_ht' Nov 19 12:46:04 volumio kernel: usbcore: registered new interface driver rt2800usb Nov 19 12:46:04 volumio kernel: random: systemd: uninitialized urandom read (16 bytes read) Nov 19 12:46:04 volumio systemd-udevd[472]: Using default interface naming scheme 'v240'. Nov 19 12:46:04 volumio systemd-udevd[472]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Nov 19 12:46:04 volumio systemd[1]: Condition check resulted in /sys/subsystem/net/devices/eth0 being skipped. Nov 19 12:46:04 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Nov 19 12:46:04 volumio systemd[1]: Starting File System Check on /dev/mmcblk0p1... Nov 19 12:46:04 volumio systemd[1]: Starting Show Plymouth Boot Screen... Nov 19 12:46:04 volumio systemd[1]: Condition check resulted in Huge Pages File System being skipped. Nov 19 12:46:04 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Nov 19 12:46:04 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Nov 19 12:46:05 volumio systemd[1]: Starting Load/Save RF Kill Switch Status... Nov 19 12:46:05 volumio systemd[1]: plymouth-start.service: Succeeded. Nov 19 12:46:05 volumio systemd[1]: Started Show Plymouth Boot Screen. Nov 19 12:46:05 volumio systemd[1]: Started File System Check Daemon to report status. Nov 19 12:46:05 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Nov 19 12:46:05 volumio systemd[1]: Found device RT5370 Wireless Adapter. Nov 19 12:46:05 volumio systemd[1]: Started Load/Save RF Kill Switch Status. Nov 19 12:46:05 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Nov 19 12:46:05 volumio systemd-fsck[683]: fsck.fat 4.1 (2017-01-24) Nov 19 12:46:05 volumio systemd-fsck[683]: 0x41: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Nov 19 12:46:05 volumio systemd-fsck[683]: Automatically removing dirty bit. Nov 19 12:46:05 volumio systemd-fsck[683]: Performing changes. Nov 19 12:46:05 volumio systemd-fsck[683]: /dev/mmcblk0p1: 256 files, 65582/120958 clusters Nov 19 12:46:05 volumio systemd[1]: Started File System Check on /dev/mmcblk0p1. Nov 19 12:46:05 volumio systemd[1]: Mounting /boot... Nov 19 12:46:05 volumio systemd[1]: Mounted /boot. Nov 19 12:46:05 volumio systemd[1]: Reached target Local File Systems. Nov 19 12:46:05 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Nov 19 12:46:05 volumio systemd[1]: Starting Create Volatile Files and Directories... Nov 19 12:46:05 volumio systemd[1]: Started ifup for eth0. Nov 19 12:46:05 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Nov 19 12:46:05 volumio systemd[1]: Starting Preprocess NFS configuration... Nov 19 12:46:05 volumio systemd[1]: Started ifup for wlan0. Nov 19 12:46:05 volumio systemd[1]: Starting Raise network interfaces... Nov 19 12:46:05 volumio systemd[1]: plymouth-read-write.service: Succeeded. Nov 19 12:46:05 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Nov 19 12:46:05 volumio systemd[1]: Received SIGRTMIN+20 from PID 328 (plymouthd). Nov 19 12:46:05 volumio systemd[1]: nfs-config.service: Succeeded. Nov 19 12:46:05 volumio systemd[1]: Started Preprocess NFS configuration. Nov 19 12:46:05 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Nov 19 12:46:05 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Nov 19 12:46:05 volumio systemd[1]: Reached target NFS client services. Nov 19 12:46:05 volumio systemd[1]: Started Create Volatile Files and Directories. Nov 19 12:46:05 volumio systemd[1]: Starting RPC bind portmap service... Nov 19 12:46:05 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Nov 19 12:46:05 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Nov 19 12:46:05 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Nov 19 12:46:05 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Nov 19 12:46:05 volumio systemd[1]: Reached target System Initialization. Nov 19 12:46:05 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Nov 19 12:46:05 volumio systemd[1]: Listening on triggerhappy.socket. Nov 19 12:46:05 volumio systemd[1]: apt-daily.timer: Not using persistent file timestamp Thu 2024-11-21 16:06:04 -03 as it is in the future. Nov 19 12:46:05 volumio systemd[1]: Started Daily apt download activities. Nov 19 12:46:05 volumio systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Thu 2024-11-21 16:06:04 -03 as it is in the future. Nov 19 12:46:05 volumio systemd[1]: Started Daily apt upgrade and clean activities. Nov 19 12:46:05 volumio systemd[1]: Reached target Timers. Nov 19 12:46:05 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Nov 19 12:46:05 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Nov 19 12:46:05 volumio systemd[1]: Reached target Sockets. Nov 19 12:46:05 volumio systemd[1]: Reached target Basic System. Nov 19 12:46:05 volumio systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Nov 19 12:46:05 volumio systemd[1]: Starting triggerhappy global hotkey daemon... Nov 19 12:46:05 volumio systemd[1]: Starting Wireless Services... Nov 19 12:46:05 volumio systemd[1]: Started volumio-remote-updater.service. Nov 19 12:46:05 volumio systemd[1]: Starting DHCP Client Daemon... Nov 19 12:46:05 volumio kernel: ieee80211 phy0: rt2x00lib_request_firmware: Info - Loading firmware file 'rt2870.bin' Nov 19 12:46:05 volumio systemd[1]: Started Manage Sound Card State (restore and store). Nov 19 12:46:05 volumio systemd[1]: Starting Save/Restore Sound Card State... Nov 19 12:46:05 volumio alsactl[768]: alsactl 1.1.8 daemon started Nov 19 12:46:05 volumio kernel: ieee80211 phy0: rt2x00lib_request_firmware: Info - Firmware detected - version: 0.36 Nov 19 12:46:05 volumio thd[764]: Unable to parse trigger line: Nov 19 12:46:05 volumio thd[764]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Nov 19 12:46:05 volumio thd[764]: Unable to parse trigger line: Nov 19 12:46:05 volumio systemd[1]: Started Volumio Log Rotation Service. Nov 19 12:46:05 volumio systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Nov 19 12:46:05 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Nov 19 12:46:05 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Nov 19 12:46:05 volumio systemd[1]: Starting Login Service... Nov 19 12:46:05 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Nov 19 12:46:05 volumio systemd[1]: Started Volumio Iptables Module. Nov 19 12:46:05 volumio systemd[1]: Started D-Bus System Message Bus. Nov 19 12:46:05 volumio systemd[1]: Starting WPA supplicant... Nov 19 12:46:05 volumio systemd[1]: Started Save/Restore Sound Card State. Nov 19 12:46:05 volumio systemd[1]: Reached target Sound Card. Nov 19 12:46:06 volumio systemd-logind[773]: New seat seat0. Nov 19 12:46:06 volumio systemd-logind[773]: Watching system buttons on /dev/input/event0 (r_gpio_keys) Nov 19 12:46:06 volumio dhcpcd[767]: cat: /run/dhcpcd/resolv.conf.eth0.link: No such file or directory Nov 19 12:46:06 volumio kernel: dwmac-sun8i 1c30000.ethernet eth0: PHY [0.1:01] driver [Generic PHY] (irq=POLL) Nov 19 12:46:06 volumio kernel: dwmac-sun8i 1c30000.ethernet eth0: Register MEM_TYPE_PAGE_POOL RxQ-0 Nov 19 12:46:06 volumio kernel: dwmac-sun8i 1c30000.ethernet eth0: No Safety Features support found Nov 19 12:46:06 volumio kernel: dwmac-sun8i 1c30000.ethernet eth0: No MAC Management Counters available Nov 19 12:46:06 volumio kernel: dwmac-sun8i 1c30000.ethernet eth0: PTP not supported by HW Nov 19 12:46:06 volumio kernel: dwmac-sun8i 1c30000.ethernet eth0: configuring for phy/mii link mode Nov 19 12:46:06 volumio sh[695]: eth0: waiting for carrier Nov 19 12:46:06 volumio sh[695]: eth0: carrier acquired Nov 19 12:46:06 volumio dhcpcd[745]: eth0: waiting for carrier Nov 19 12:46:06 volumio dhcpcd[745]: eth0: carrier acquired Nov 19 12:46:06 volumio thd[764]: Found socket passed from systemd Nov 19 12:46:06 volumio sh[695]: DUID 00:01:00:01:2d:f7:7c:5e:02:81:47:88:34:4d Nov 19 12:46:06 volumio sh[695]: eth0: IAID 47:88:34:4d Nov 19 12:46:06 volumio sh[695]: eth0: adding address fe80::81:47ff:fe88:344d Nov 19 12:46:06 volumio sh[695]: ipv6_addaddr1: Permission denied Nov 19 12:46:06 volumio dhcpcd[745]: DUID 00:01:00:01:2d:f7:7c:5e:02:81:47:88:34:4d Nov 19 12:46:06 volumio dhcpcd[745]: eth0: IAID 47:88:34:4d Nov 19 12:46:06 volumio dhcpcd[745]: eth0: adding address fe80::81:47ff:fe88:344d Nov 19 12:46:06 volumio dhcpcd[745]: ipv6_addaddr1: Permission denied Nov 19 12:46:06 volumio dhcpcd[767]: DUID 00:01:00:01:2d:f7:7c:5e:02:81:47:88:34:4d Nov 19 12:46:06 volumio dhcpcd[767]: wlan0: IAID ef:c5:07:4e Nov 19 12:46:06 volumio dhcpcd[767]: wlan0: adding address fe80::213:efff:fec5:74e Nov 19 12:46:06 volumio dhcpcd[767]: ipv6_addaddr1: Permission denied Nov 19 12:46:06 volumio dhcpcd[767]: wlan0: probing address 192.168.15.203/24 Nov 19 12:46:06 volumio dhcpcd[767]: DUID 00:01:00:01:2d:f7:7c:5e:02:81:47:88:34:4d Nov 19 12:46:06 volumio dhcpcd[767]: wlan0: IAID ef:c5:07:4e Nov 19 12:46:06 volumio dhcpcd[767]: wlan0: adding address fe80::213:efff:fec5:74e Nov 19 12:46:06 volumio dhcpcd[767]: ipv6_addaddr1: Permission denied Nov 19 12:46:06 volumio dhcpcd[767]: wlan0: probing address 192.168.15.203/24 Nov 19 12:46:06 volumio avahi-daemon[771]: Found user 'avahi' (UID 111) and group 'avahi' (GID 113). Nov 19 12:46:06 volumio avahi-daemon[771]: Successfully dropped root privileges. Nov 19 12:46:06 volumio avahi-daemon[771]: avahi-daemon 0.7 starting up. Nov 19 12:46:06 volumio dhcpcd[767]: eth0: waiting for carrier Nov 19 12:46:06 volumio dhcpcd[767]: wlan0: carrier lost Nov 19 12:46:06 volumio dhcpcd[767]: eth0: waiting for carrier Nov 19 12:46:06 volumio dhcpcd[767]: wlan0: carrier lost Nov 19 12:46:06 volumio dhcpcd[767]: eth0: carrier acquired Nov 19 12:46:06 volumio dhcpcd[767]: eth0: carrier acquired Nov 19 12:46:06 volumio dhcpcd[767]: eth0: IAID 47:88:34:4d Nov 19 12:46:06 volumio dhcpcd[767]: eth0: adding address fe80::81:47ff:fe88:344d Nov 19 12:46:06 volumio dhcpcd[767]: ipv6_addaddr1: Permission denied Nov 19 12:46:06 volumio dhcpcd[767]: eth0: IAID 47:88:34:4d Nov 19 12:46:06 volumio dhcpcd[767]: eth0: adding address fe80::81:47ff:fe88:344d Nov 19 12:46:06 volumio dhcpcd[767]: ipv6_addaddr1: Permission denied Nov 19 12:46:06 volumio systemd[1]: Started Login Service. Nov 19 12:46:06 volumio systemd[1]: Started RPC bind portmap service. Nov 19 12:46:06 volumio systemd[1]: Started triggerhappy global hotkey daemon. Nov 19 12:46:06 volumio avahi-daemon[771]: Successfully called chroot(). Nov 19 12:46:06 volumio avahi-daemon[771]: Successfully dropped remaining capabilities. Nov 19 12:46:06 volumio avahi-daemon[771]: No service file found in /etc/avahi/services. Nov 19 12:46:06 volumio avahi-daemon[771]: Network interface enumeration completed. Nov 19 12:46:06 volumio avahi-daemon[771]: Server startup complete. Host name is volumio.local. Local service cookie is 3240375488. Nov 19 12:46:06 volumio ifup[701]: ifup: waiting for lock on /run/network/ifstate.wlan0 Nov 19 12:46:06 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Nov 19 12:46:06 volumio systemd[1]: Reached target RPC Port Mapper. Nov 19 12:46:06 volumio systemd[1]: Reached target Remote File Systems (Pre). Nov 19 12:46:06 volumio systemd[1]: Reached target Remote File Systems. Nov 19 12:46:06 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Nov 19 12:46:06 volumio sh[699]: wlan0=wlan0 Nov 19 12:46:06 volumio haveged[742]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Nov 19 12:46:06 volumio haveged[742]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Nov 19 12:46:06 volumio haveged[742]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00237 Nov 19 12:46:06 volumio haveged[742]: haveged: fills: 0, generated: 0 Nov 19 12:46:07 volumio kernel: random: crng init done Nov 19 12:46:07 volumio kernel: random: 216 urandom warning(s) missed due to ratelimiting Nov 19 12:46:07 volumio sh[695]: eth0: rebinding lease of 192.168.0.183 Nov 19 12:46:07 volumio sh[695]: eth0: soliciting an IPv6 router Nov 19 12:46:07 volumio dhcpcd[745]: eth0: rebinding lease of 192.168.0.183 Nov 19 12:46:07 volumio dhcpcd[745]: eth0: soliciting an IPv6 router Nov 19 12:46:07 volumio dhcpcd[767]: eth0: carrier lost Nov 19 12:46:07 volumio dhcpcd[767]: eth0: carrier lost Nov 19 12:46:07 volumio sh[695]: eth0: carrier lost Nov 19 12:46:07 volumio dhcpcd[745]: eth0: carrier lost Nov 19 12:46:07 volumio systemd[1]: Started Raise network interfaces. Nov 19 12:46:07 volumio wpa_supplicant[780]: Successfully initialized wpa_supplicant Nov 19 12:46:07 volumio systemd[1]: Started WPA supplicant. Nov 19 12:46:08 volumio systemd[1]: Reached target Network. Nov 19 12:46:08 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Nov 19 12:46:08 volumio systemd[1]: Starting Network Time Service... Nov 19 12:46:08 volumio systemd[1]: Starting Permit User Sessions... Nov 19 12:46:08 volumio systemd[1]: Reached target Network is Online. Nov 19 12:46:08 volumio systemd[1]: Starting Samba NMB Daemon... Nov 19 12:46:08 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Nov 19 12:46:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 19 12:46:08 volumio systemd[1]: Starting /etc/rc.local Compatibility... Nov 19 12:46:08 volumio systemd[1]: Started /etc/rc.local Compatibility. Nov 19 12:46:08 volumio systemd[1]: Started Permit User Sessions. Nov 19 12:46:08 volumio systemd[1]: iptables.service: Succeeded. Nov 19 12:46:08 volumio systemd[1]: Starting Hold until boot process finishes up... Nov 19 12:46:08 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Nov 19 12:46:08 volumio systemd[1]: Received SIGRTMIN+21 from PID 328 (plymouthd). Nov 19 12:46:08 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Nov 19 12:46:08 volumio systemd[1]: Started Hold until boot process finishes up. Nov 19 12:46:08 volumio systemd[1]: plymouth-quit.service: Succeeded. Nov 19 12:46:08 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Nov 19 12:46:08 volumio systemd[1]: Received SIGRTMIN+21 from PID 328 (n/a). Nov 19 12:46:08 volumio systemd[1]: Started Getty on tty1. Nov 19 12:46:08 volumio systemd[1]: Started Serial Getty on ttyS0. Nov 19 12:46:08 volumio systemd[1]: Reached target Login Prompts. Nov 19 12:46:08 volumio ifplugd(eth0)[962]: ifplugd 0.28 initializing. Nov 19 12:46:08 volumio ifplugd(eth0)[962]: Using interface eth0/02:81:47:88:34:4D with driver (version: Jan_2016) Nov 19 12:46:08 volumio ifplugd(eth0)[962]: Using detection mode: SIOCETHTOOL Nov 19 12:46:08 volumio ifplugd(eth0)[962]: Initialization complete, link beat not detected. Nov 19 12:46:08 volumio ifplugd[926]: Network Interface Plugging Daemon...start eth0...done. Nov 19 12:46:08 volumio systemd[1]: Started LSB: Brings up/down network automatically. Nov 19 12:46:08 volumio loadcpufreq[865]: Loading cpufreq kernel modules...done (none). Nov 19 12:46:08 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Nov 19 12:46:08 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Nov 19 12:46:08 volumio ntpd[921]: ntpd 4.2.8p12@1.3728-o (1): Starting Nov 19 12:46:08 volumio ntpd[921]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Nov 19 12:46:08 volumio systemd[1]: Started Network Time Service. Nov 19 12:46:08 volumio cpufrequtils[984]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Nov 19 12:46:08 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Nov 19 12:46:09 volumio ntpd[994]: proto: precision = 0.791 usec (-20) Nov 19 12:46:09 volumio ntpd[994]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Nov 19 12:46:09 volumio ntpd[994]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Nov 19 12:46:09 volumio ntpd[994]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 693 days ago Nov 19 12:46:09 volumio ntpd[994]: Listen and drop on 0 v6wildcard [::]:123 Nov 19 12:46:09 volumio ntpd[994]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 19 12:46:09 volumio ntpd[994]: Listen normally on 2 lo 127.0.0.1:123 Nov 19 12:46:09 volumio ntpd[994]: Listening on routing socket on fd #19 for interface updates Nov 19 12:46:09 volumio ntpd[994]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 19 12:46:09 volumio volumio-remote-updater[766]: Error: No active session Nov 19 12:46:09 volumio ntpd[994]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 19 12:46:09 volumio volumio-remote-updater[766]: [2024-11-19 12:46:09] [info] asio async_connect error: system:111 (Connection refused) Nov 19 12:46:09 volumio volumio-remote-updater[766]: [2024-11-19 12:46:09] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 19 12:46:09 volumio volumio-remote-updater[766]: [2024-11-19 12:46:09] [error] handle_connect error: Underlying Transport Error Nov 19 12:46:10 volumio systemd[1]: systemd-rfkill.service: Succeeded. Nov 19 12:46:10 volumio ntpd[994]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Nov 19 12:46:11 volumio ntpd[994]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 19 12:46:11 volumio volumio[772]: Could not open config: /tmp/upmpdcli.conf Nov 19 12:46:11 volumio nmbd[939]: [2024/11/19 12:46:11.866191, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Nov 19 12:46:11 volumio nmbd[939]: started asyncdns process 1002 Nov 19 12:46:11 volumio nmbd[939]: [2024/11/19 12:46:11.871136, 0] ../lib/util/become_daemon.c:149(daemon_status) Nov 19 12:46:11 volumio nmbd[939]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Nov 19 12:46:11 volumio nmbd[939]: [2024/11/19 12:46:11.871502, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Nov 19 12:46:11 volumio nmbd[939]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Nov 19 12:46:12 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Nov 19 12:46:12 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Nov 19 12:46:12 volumio ntpd[994]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 19 12:46:13 volumio ntpd[994]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Nov 19 12:46:14 volumio wireless.js[765]: Cleaning previous... Nov 19 12:46:14 volumio sudo[1016]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 19 12:46:14 volumio sudo[1016]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:14 volumio sudo[1016]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:14 volumio sudo[1018]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Nov 19 12:46:14 volumio sudo[1018]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:14 volumio volumio-remote-updater[766]: [2024-11-19 12:46:14] [info] asio async_connect error: system:111 (Connection refused) Nov 19 12:46:14 volumio volumio-remote-updater[766]: [2024-11-19 12:46:14] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 19 12:46:14 volumio volumio-remote-updater[766]: [2024-11-19 12:46:14] [error] handle_connect error: Underlying Transport Error Nov 19 12:46:14 volumio sudo[1018]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:15 volumio wireless.js[765]: Stopped aP Nov 19 12:46:15 volumio sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 19 12:46:15 volumio sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:15 volumio sudo[1025]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:15 volumio sudo[1027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Nov 19 12:46:15 volumio sudo[1027]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:15 volumio sudo[1027]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:15 volumio sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Nov 19 12:46:15 volumio sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:15 volumio sudo[1034]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:15 volumio sudo[1036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Nov 19 12:46:15 volumio sudo[1036]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:16 volumio sudo[1036]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:16 volumio wireless.js[765]: Start wireless flow Nov 19 12:46:16 volumio wireless.js[765]: Stopped hotspot (if there).. Nov 19 12:46:16 volumio sudo[1041]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Nov 19 12:46:16 volumio sudo[1041]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:16 volumio sudo[1041]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:16 volumio sudo[1043]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Nov 19 12:46:16 volumio sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:17 volumio sudo[1043]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:17 volumio wireless.js[765]: DHCP IP Nov 19 12:46:17 volumio wireless.js[765]: Start ap Nov 19 12:46:17 volumio wpa_supplicant[1045]: Successfully initialized wpa_supplicant Nov 19 12:46:17 volumio sudo[1046]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Nov 19 12:46:17 volumio sudo[1046]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:17 volumio dhcpcd[1047]: sending commands to master dhcpcd process Nov 19 12:46:17 volumio dhcpcd[767]: control command: /sbin/dhcpcd Nov 19 12:46:17 volumio dhcpcd[767]: control command: /sbin/dhcpcd Nov 19 12:46:17 volumio sudo[1046]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:18 volumio wireless.js[765]: trying... Nov 19 12:46:18 volumio sudo[1050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 19 12:46:18 volumio sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:18 volumio sudo[1050]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:18 volumio wpa_supplicant[1048]: wlan0: SME: Trying to authenticate with c0:3d:d9:c1:ec:10 (SSID='LED-DONIZETE' freq=2412 MHz) Nov 19 12:46:18 volumio kernel: wlan0: authenticate with c0:3d:d9:c1:ec:10 Nov 19 12:46:18 volumio kernel: wlan0: send auth to c0:3d:d9:c1:ec:10 (try 1/3) Nov 19 12:46:18 volumio wpa_supplicant[1048]: wlan0: Trying to associate with c0:3d:d9:c1:ec:10 (SSID='LED-DONIZETE' freq=2412 MHz) Nov 19 12:46:18 volumio kernel: wlan0: authenticated Nov 19 12:46:18 volumio kernel: wlan0: associating with AP with corrupt probe response Nov 19 12:46:18 volumio kernel: wlan0: associate with c0:3d:d9:c1:ec:10 (try 1/3) Nov 19 12:46:18 volumio kernel: wlan0: RX AssocResp from c0:3d:d9:c1:ec:10 (capab=0x1031 status=0 aid=4) Nov 19 12:46:18 volumio wpa_supplicant[1048]: wlan0: Associated with c0:3d:d9:c1:ec:10 Nov 19 12:46:18 volumio wpa_supplicant[1048]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Nov 19 12:46:18 volumio kernel: wlan0: associated Nov 19 12:46:18 volumio wpa_supplicant[1048]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=BR Nov 19 12:46:18 volumio kernel: wlan0: Limiting TX power to 20 (20 - 0) dBm as advertised by c0:3d:d9:c1:ec:10 Nov 19 12:46:19 volumio wireless.js[765]: trying... Nov 19 12:46:19 volumio sudo[1055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 19 12:46:19 volumio sudo[1055]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:19 volumio sudo[1055]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:20 volumio wpa_supplicant[1048]: wlan0: WPA: Key negotiation completed with c0:3d:d9:c1:ec:10 [PTK=CCMP GTK=CCMP] Nov 19 12:46:20 volumio wpa_supplicant[1048]: wlan0: CTRL-EVENT-CONNECTED - Connection to c0:3d:d9:c1:ec:10 completed [id=0 id_str=] Nov 19 12:46:20 volumio dhcpcd[767]: wlan0: carrier acquired Nov 19 12:46:20 volumio dhcpcd[767]: wlan0: carrier acquired Nov 19 12:46:20 volumio dhcpcd[767]: wlan0: IAID ef:c5:07:4e Nov 19 12:46:20 volumio dhcpcd[767]: wlan0: probing address 192.168.15.203/24 Nov 19 12:46:20 volumio dhcpcd[767]: wlan0: IAID ef:c5:07:4e Nov 19 12:46:20 volumio dhcpcd[767]: wlan0: probing address 192.168.15.203/24 Nov 19 12:46:20 volumio wireless.js[765]: trying... Nov 19 12:46:20 volumio sudo[1079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 19 12:46:20 volumio sudo[1079]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:20 volumio sudo[1079]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:20 volumio dhcpcd[767]: wlan0: soliciting an IPv6 router Nov 19 12:46:20 volumio dhcpcd[767]: wlan0: soliciting an IPv6 router Nov 19 12:46:21 volumio wireless.js[765]: trying... Nov 19 12:46:21 volumio sudo[1082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 19 12:46:21 volumio sudo[1082]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:21 volumio sudo[1082]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:22 volumio wireless.js[765]: trying... Nov 19 12:46:22 volumio sudo[1085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 19 12:46:22 volumio sudo[1085]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:22 volumio sudo[1085]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:22 volumio volumio-remote-updater[766]: [2024-11-19 12:46:22] [info] asio async_connect error: system:111 (Connection refused) Nov 19 12:46:22 volumio volumio-remote-updater[766]: [2024-11-19 12:46:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 19 12:46:22 volumio volumio-remote-updater[766]: [2024-11-19 12:46:22] [error] handle_connect error: Underlying Transport Error Nov 19 12:46:23 volumio wireless.js[765]: trying... Nov 19 12:46:23 volumio sudo[1088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 19 12:46:23 volumio sudo[1088]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:23 volumio sudo[1088]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:24 volumio wireless.js[765]: trying... Nov 19 12:46:24 volumio sudo[1091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 19 12:46:24 volumio sudo[1091]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:24 volumio sudo[1091]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:25 volumio dhcpcd[767]: wlan0: using static address 192.168.15.203/24 Nov 19 12:46:25 volumio dhcpcd[767]: wlan0: adding route to 192.168.15.0/24 Nov 19 12:46:25 volumio dhcpcd[767]: wlan0: adding default route via 192.168.15.1 Nov 19 12:46:25 volumio dhcpcd[767]: wlan0: using static address 192.168.15.203/24 Nov 19 12:46:25 volumio avahi-daemon[771]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.15.203. Nov 19 12:46:25 volumio dhcpcd[767]: wlan0: adding route to 192.168.15.0/24 Nov 19 12:46:25 volumio avahi-daemon[771]: New relevant interface wlan0.IPv4 for mDNS. Nov 19 12:46:25 volumio avahi-daemon[771]: Registering new address record for 192.168.15.203 on wlan0.IPv4. Nov 19 12:46:25 volumio wireless.js[765]: trying... Nov 19 12:46:25 volumio dhcpcd[767]: wlan0: adding default route via 192.168.15.1 Nov 19 12:46:25 volumio sudo[1097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 19 12:46:25 volumio sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:25 volumio sudo[1097]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:25 volumio wireless.js[765]: Connected to: ----LED-DONIZETE Nov 19 12:46:25 volumio wireless.js[765]: ---- Nov 19 12:46:25 volumio dhcpcd[767]: forked to background, child pid 1116 Nov 19 12:46:25 volumio dhcpcd[767]: forked to background, child pid 1116 Nov 19 12:46:25 volumio systemd[1]: Started DHCP Client Daemon. Nov 19 12:46:25 volumio sudo[1112]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 12:46:25 volumio sudo[1112]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:25 volumio sudo[1112]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:25 volumio wireless.js[765]: ... joined AP, wlan0 IPv4 is 192.168.15.203, ipV6 is undefined Nov 19 12:46:25 volumio wireless.js[765]: It's done! AP Nov 19 12:46:25 volumio systemd[1]: Started Wireless Services. Nov 19 12:46:25 volumio systemd[1]: Started Volumio Backend Module. Nov 19 12:46:25 volumio systemd[1]: Started Volumio Cpu Tweaker. Nov 19 12:46:25 volumio systemd[1]: Started First Start. Nov 19 12:46:25 volumio firststart.sh[1123]: Volumio first start configuration script Nov 19 12:46:25 volumio firststart.sh[1123]: Configuring unconfigured packages Nov 19 12:46:25 volumio volumio-cpu-tweak[1122]: Setting RT Priority for mpd Nov 19 12:46:25 volumio volumio-cpu-tweak[1122]: pid 35's current scheduling policy: SCHED_OTHER Nov 19 12:46:25 volumio volumio-cpu-tweak[1122]: pid 35's current scheduling priority: 0 Nov 19 12:46:25 volumio volumio-cpu-tweak[1122]: Setting MPD Affinity Nov 19 12:46:25 volumio volumio-cpu-tweak[1122]: pid 3's current affinity mask: f Nov 19 12:46:25 volumio volumio-cpu-tweak[1122]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Nov 19 12:46:25 volumio volumio-cpu-tweak[1122]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Nov 19 12:46:25 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Nov 19 12:46:26 volumio ntpd[994]: Listen normally on 3 wlan0 192.168.15.203:123 Nov 19 12:46:26 volumio ntpd[994]: new interface(s) found: waking up resolver Nov 19 12:46:26 volumio firststart.sh[1123]: Creating /var/log/samba/cores folder Nov 19 12:46:26 volumio firststart.sh[1123]: Removing default SSH host keys Nov 19 12:46:26 volumio firststart.sh[1123]: rm: cannot remove '/etc/ssh/ssh_host_*': No such file or directory Nov 19 12:46:26 volumio systemd[1]: firststart.service: Main process exited, code=exited, status=1/FAILURE Nov 19 12:46:26 volumio systemd[1]: firststart.service: Failed with result 'exit-code'. Nov 19 12:46:26 volumio kernel: vcc3v0: disabling Nov 19 12:46:26 volumio kernel: vcc5v0: disabling Nov 19 12:46:27 volumio nmbd[939]: [2024/11/19 12:46:27.130216, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 19 12:46:27 volumio nmbd[939]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 19 12:46:27 volumio systemd[1]: Started Samba NMB Daemon. Nov 19 12:46:27 volumio systemd[1]: Starting Samba Winbind Daemon... Nov 19 12:46:27 volumio winbindd[1144]: [2024/11/19 12:46:27.825955, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 19 12:46:27 volumio winbindd[1144]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 19 12:46:27 volumio winbindd[1144]: [2024/11/19 12:46:27.851019, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 19 12:46:27 volumio winbindd[1144]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 19 12:46:27 volumio systemd[1]: Started Samba Winbind Daemon. Nov 19 12:46:27 volumio systemd[1]: Starting Samba SMB Daemon... Nov 19 12:46:29 volumio winbindd[1144]: [2024/11/19 12:46:29.865460, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Nov 19 12:46:29 volumio winbindd[1144]: res_names->count = 3, expected 4 Nov 19 12:46:29 volumio smbd[1152]: [2024/11/19 12:46:29.915506, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 19 12:46:29 volumio smbd[1152]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 19 12:46:29 volumio systemd[1]: Started Samba SMB Daemon. Nov 19 12:46:29 volumio systemd[1]: Reached target Multi-User System. Nov 19 12:46:29 volumio systemd[1]: Reached target Graphical Interface. Nov 19 12:46:29 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 19 12:46:29 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 19 12:46:29 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 19 12:46:29 volumio systemd[1]: Startup finished in 7.509s (kernel) + 29.562s (userspace) = 37.071s. Nov 19 12:46:31 volumio volumio[1121]: info: ------------------------------------------- Nov 19 12:46:31 volumio volumio[1121]: info: ----- Volumio3 ---- Nov 19 12:46:31 volumio volumio[1121]: info: ------------------------------------------- Nov 19 12:46:31 volumio volumio[1121]: info: ----- System startup ---- Nov 19 12:46:31 volumio volumio[1121]: info: ------------------------------------------- Nov 19 12:46:32 volumio volumio-remote-updater[766]: [2024-11-19 12:46:32] [connect] Successful connection Nov 19 12:46:33 volumio volumio[1121]: info: MYVOLUMIO Environment detected Nov 19 12:46:33 volumio volumio[1121]: info: Plugin folders cleanup Nov 19 12:46:33 volumio volumio[1121]: info: Scanning into folder /volumio/app/plugins/ Nov 19 12:46:33 volumio volumio[1121]: info: Scanning category audio_interface Nov 19 12:46:33 volumio volumio[1121]: info: Scanning category miscellanea Nov 19 12:46:33 volumio volumio[1121]: info: Scanning category music_service Nov 19 12:46:33 volumio volumio[1121]: info: Scanning category plugins.json Nov 19 12:46:33 volumio volumio[1121]: info: Scanning category system_controller Nov 19 12:46:33 volumio volumio[1121]: info: Scanning category user_interface Nov 19 12:46:33 volumio volumio[1121]: info: Scanning into folder /data/plugins/ Nov 19 12:46:33 volumio volumio[1121]: info: Scanning category audio_interface Nov 19 12:46:33 volumio volumio[1121]: info: Plugin folders cleanup completed Nov 19 12:46:33 volumio volumio[1121]: info: ------------------------------------------- Nov 19 12:46:33 volumio volumio[1121]: info: ----- Core plugins startup ---- Nov 19 12:46:33 volumio volumio[1121]: info: ------------------------------------------- Nov 19 12:46:33 volumio volumio[1121]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 12:46:33 volumio volumio[1121]: info: Adding plugin upnp to MyMusic Plugins Nov 19 12:46:33 volumio volumio[1121]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 12:46:33 volumio volumio[1121]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 12:46:33 volumio volumio[1121]: info: Loading plugins from folder /data/plugins/ Nov 19 12:46:33 volumio volumio[1121]: info: Loading plugin "system"... Nov 19 12:46:33 volumio volumio[1121]: info: Loading plugin "appearance"... Nov 19 12:46:35 volumio systemd[1]: systemd-fsckd.service: Succeeded. Nov 19 12:46:35 volumio volumio[1121]: info: Loading plugin "network"... Nov 19 12:46:35 volumio volumio[1121]: info: Refreshing Cached IP Addresses Nov 19 12:46:35 volumio sudo[1175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 12:46:35 volumio volumio[1121]: info: Loading plugin "services"... Nov 19 12:46:35 volumio sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:35 volumio sudo[1177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 12:46:35 volumio sudo[1177]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:35 volumio sudo[1175]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:35 volumio sudo[1177]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:35 volumio volumio[1121]: info: Loading plugin "alsa_controller"... Nov 19 12:46:35 volumio sudo[1179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 12:46:35 volumio sudo[1179]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:35 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 12:46:35 volumio volumio[1121]: info: Loading plugin "wizard"... Nov 19 12:46:35 volumio volumio[1121]: info: Loading plugin "networkfs"... Nov 19 12:46:36 volumio volumio[1121]: info: Starting Udev Watcher for removable devices Nov 19 12:46:36 volumio volumio[1121]: info: Ignoring mount for partition: boot Nov 19 12:46:36 volumio volumio[1121]: info: Ignoring mount for partition: volumio Nov 19 12:46:36 volumio volumio[1121]: info: Ignoring mount for partition: volumio_data Nov 19 12:46:36 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 12:46:36 volumio volumio[1121]: info: Loading plugin "volumio_command_line_client"... Nov 19 12:46:36 volumio volumio[1121]: info: Loading plugin "upnp"... Nov 19 12:46:36 volumio volumio[1121]: info: [1732031196073] Starting Upmpd Daemon Nov 19 12:46:36 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 12:46:36 volumio volumio[1121]: info: Loading plugin "my_music"... Nov 19 12:46:36 volumio volumio[1121]: info: Loading plugin "mpd"... Nov 19 12:46:36 volumio sh[695]: timed out Nov 19 12:46:36 volumio dhcpcd[745]: timed out Nov 19 12:46:36 volumio sh[695]: dhcpcd exited Nov 19 12:46:36 volumio dhcpcd[745]: dhcpcd exited Nov 19 12:46:36 volumio sh[695]: ifup: failed to bring up eth0 Nov 19 12:46:36 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Nov 19 12:46:36 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Nov 19 12:46:36 volumio volumio[1121]: info: Loading plugin "upnp_browser"... Nov 19 12:46:37 volumio volumio[1121]: info: Loading plugin "alarm-clock"... Nov 19 12:46:37 volumio volumio[1121]: info: Loading plugin "airplay_emulation"... Nov 19 12:46:37 volumio volumio[1121]: info: Starting Shairport Sync Nov 19 12:46:37 volumio volumio[1121]: info: Loading plugin "last_100"... Nov 19 12:46:37 volumio volumio[1121]: info: Loading plugin "webradio"... Nov 19 12:46:38 volumio volumio[1121]: info: Loading plugin "i2s_dacs"... Nov 19 12:46:38 volumio volumio[1121]: info: I2S DAC not set, start Auto-detection Nov 19 12:46:38 volumio volumio[1121]: info: Loading plugin "volumiodiscovery"... Nov 19 12:46:38 volumio volumio[1121]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 12:46:38 volumio volumio[1121]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 12:46:38 volumio node[1121]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 12:46:38 volumio volumio[1121]: *** WARNING *** For more information see Nov 19 12:46:38 volumio volumio[1121]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 12:46:38 volumio volumio[1121]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 12:46:38 volumio volumio[1121]: *** WARNING *** For more information see Nov 19 12:46:38 volumio node[1121]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 12:46:38 volumio node[1121]: *** WARNING *** For more information see Nov 19 12:46:38 volumio node[1121]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 12:46:38 volumio node[1121]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 12:46:38 volumio node[1121]: *** WARNING *** For more information see Nov 19 12:46:38 volumio volumio[1121]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 12:46:38 volumio volumio[1121]: info: Discovery: Started advertising with name: Volumio Nov 19 12:46:38 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 12:46:38 volumio volumio[1121]: info: Loading plugin "outputs"... Nov 19 12:46:38 volumio volumio[1121]: info: Loading plugin "albumart"... Nov 19 12:46:38 volumio volumio[1121]: info: Plugin example_plugin is not enabled Nov 19 12:46:38 volumio volumio[1121]: info: Loading plugin "inputs"... Nov 19 12:46:38 volumio volumio[1121]: info: Loading plugin "updater_comm"... Nov 19 12:46:38 volumio volumio[1121]: info: Plugin mpdemulation is not enabled Nov 19 12:46:38 volumio volumio[1121]: info: Loading plugin "rest_api"... Nov 19 12:46:38 volumio volumio[1121]: info: Loading plugin "websocket"... Nov 19 12:46:38 volumio volumio[1121]: info: Starting Socket.io Server version 2.3.0 Nov 19 12:46:38 volumio volumio[1121]: info: Loading plugin "fusiondsp"... Nov 19 12:46:38 volumio volumio[1121]: Forking 3 albumart workers Nov 19 12:46:39 volumio volumio[1121]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 12:46:39 volumio volumio[1121]: info: Loading i18n strings for locale en Nov 19 12:46:39 volumio volumio[1121]: Updating browse sources language Nov 19 12:46:39 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 12:46:40 volumio sudo[1179]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::initPlayerControls Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: Express server listening on port 3000 Nov 19 12:46:40 volumio volumio[1121]: [Metrics] WebUI: 10s 395.21ms Nov 19 12:46:40 volumio volumio[1121]: Starting albumart workers Nov 19 12:46:40 volumio volumio[1121]: Starting albumart workers Nov 19 12:46:40 volumio volumio[1121]: Starting albumart workers Nov 19 12:46:40 volumio volumio[1121]: info: CoreStateMachine::resetVolumioState Nov 19 12:46:40 volumio volumio[1121]: info: CoreStateMachine::getcurrentVolume Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::volumioRetrievevolume Nov 19 12:46:40 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 19 12:46:40 volumio volumio[1121]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 19 12:46:40 volumio volumio[1121]: info: Completed loading Core Plugins Nov 19 12:46:40 volumio volumio[1121]: info: Preparing to generate the ALSA configuration file Nov 19 12:46:41 volumio volumio[1121]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 19 12:46:41 volumio volumio[1121]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 19 12:46:41 volumio volumio[1121]: info: Reading ALSA contributions from plugins. Nov 19 12:46:41 volumio volumio[1121]: info: CoreStateMachine::pushState Nov 19 12:46:41 volumio volumio[1121]: info: CorePlayQueue::getTrack 0 Nov 19 12:46:41 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 19 12:46:41 volumio volumio[1121]: info: CoreCommandRouter::volumioPushState Nov 19 12:46:41 volumio volumio[1121]: info: CoreStateMachine::updateTrackBlock Nov 19 12:46:41 volumio volumio[1121]: info: CorePlayQueue::getTrackBlock Nov 19 12:46:41 volumio volumio[1121]: info: CoreCommandRouter::volumioRetrievevolume Nov 19 12:46:41 volumio volumio[1121]: info: CoreCommandRouter::volumioGetState Nov 19 12:46:41 volumio volumio[1121]: info: CorePlayQueue::getTrack 0 Nov 19 12:46:41 volumio volumio[1121]: info: Reloading queue from file Nov 19 12:46:41 volumio volumio[1121]: info: CoreStateMachine::pushState Nov 19 12:46:41 volumio volumio[1121]: info: CorePlayQueue::getTrack 0 Nov 19 12:46:41 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 19 12:46:41 volumio volumio[1121]: info: CoreCommandRouter::volumioPushState Nov 19 12:46:41 volumio volumio[1121]: info: CoreStateMachine::setRepeat null single undefined Nov 19 12:46:41 volumio volumio[1121]: info: CoreStateMachine::pushState Nov 19 12:46:41 volumio volumio[1121]: info: CorePlayQueue::getTrack 0 Nov 19 12:46:41 volumio volumio[1121]: info: CoreCommandRouter::volumioPushState Nov 19 12:46:41 volumio volumio[1121]: info: CoreStateMachine::setRandom null Nov 19 12:46:41 volumio volumio[1121]: info: CoreStateMachine::pushState Nov 19 12:46:41 volumio volumio[1121]: info: CorePlayQueue::getTrack 0 Nov 19 12:46:41 volumio volumio[1121]: info: CoreCommandRouter::volumioPushState Nov 19 12:46:41 volumio volumio[1121]: info: Listing playlists Nov 19 12:46:41 volumio volumio[1121]: info: Listing playlists Nov 19 12:46:41 volumio volumio[1121]: info: Asound.conf file unchanged, so no further update is needed Nov 19 12:46:41 volumio volumio[1121]: info: Output device has changed, restarting MPD Nov 19 12:46:41 volumio volumio[1121]: info: Output device has changed, restarting Shairport Sync Nov 19 12:46:41 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:41 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 19 12:46:41 volumio sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 12:46:41 volumio sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:41 volumio sudo[1237]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:41 volumio sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 12:46:41 volumio sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:41 volumio volumio[1121]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 19 12:46:41 volumio volumio[1121]: info: ___________ START PLUGINS ___________ Nov 19 12:46:42 volumio volumio[1121]: info: ControllerMpd::onStart: Initializing MPD Nov 19 12:46:42 volumio volumio[1121]: info: Creating MPD Configuration file Nov 19 12:46:42 volumio systemd[1]: Listening on mpd.socket. Nov 19 12:46:42 volumio systemd[1]: Starting Music Player Daemon... Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 19 12:46:42 volumio volumio[1121]: info: [1732031202077] CoreMusicLibrary::Adding element Media Servers Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 12:46:42 volumio sudo[1268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 12:46:42 volumio sudo[1268]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:42 volumio sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 12:46:42 volumio sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:42 volumio sudo[1268]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 19 12:46:42 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 19 12:46:42 volumio systemd[1]: mpd.service: Succeeded. Nov 19 12:46:42 volumio systemd[1]: Stopped Music Player Daemon. Nov 19 12:46:42 volumio systemd[1]: Starting Music Player Daemon... Nov 19 12:46:42 volumio volumio[1121]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 19 12:46:42 volumio volumio[1121]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 19 12:46:42 volumio volumio[1121]: info: [1732031202354] CoreMusicLibrary::Adding element Last_100 Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 19 12:46:42 volumio volumio[1121]: info: [1732031202360] CoreMusicLibrary::Adding element Webradio Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 12:46:42 volumio volumio[1121]: info: Initializing BBC Radios Nov 19 12:46:42 volumio sudo[1277]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 19 12:46:42 volumio sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:42 volumio sudo[1277]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Nov 19 12:46:42 volumio sudo[1277]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 19 12:46:42 volumio volumio[1121]: info: Loading i18n strings for locale en Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 19 12:46:42 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:42 volumio volumio[1121]: info: FusionDsp - mixtype--------------------- Software Nov 19 12:46:42 volumio volumio[1121]: info: Volumio Calling Home Nov 19 12:46:42 volumio volumio[1121]: info: Preparing to generate the ALSA configuration file Nov 19 12:46:43 volumio volumio[1121]: info: Discovery: adding a463ea0a-4d90-4cf8-8afa-d2db3f88478a Nov 19 12:46:43 volumio volumio[1121]: info: Discovery: Found device Volumio Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::volumioGetState Nov 19 12:46:43 volumio volumio[1121]: info: CorePlayQueue::getTrack 0 Nov 19 12:46:43 volumio volumio[1121]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Nov 19 12:46:43 volumio volumio[1121]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 19 12:46:43 volumio volumio[1121]: info: Reading ALSA contributions from plugins. Nov 19 12:46:43 volumio volumio[1121]: info: MPD Permissions set Nov 19 12:46:43 volumio volumio[1121]: info: MPD Permissions set Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::volumioGetState Nov 19 12:46:43 volumio volumio[1121]: info: CorePlayQueue::getTrack 0 Nov 19 12:46:43 volumio volumio[1121]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 19 12:46:43 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:43 volumio volumio[1121]: info: Starting Shairport Sync Nov 19 12:46:43 volumio volumio[1121]: info: Starting Shairport Sync Nov 19 12:46:43 volumio volumio[1121]: info: Starting Shairport Sync Nov 19 12:46:43 volumio sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 19 12:46:43 volumio sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:44 volumio sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 19 12:46:44 volumio sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::volumioGetState Nov 19 12:46:44 volumio volumio[1121]: info: CorePlayQueue::getTrack 0 Nov 19 12:46:44 volumio sudo[1317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 19 12:46:44 volumio sudo[1317]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 19 12:46:44 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 19 12:46:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 19 12:46:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 19 12:46:44 volumio volumio[1121]: info: Volumio called home Nov 19 12:46:44 volumio volumio[1121]: info: Asound.conf file unchanged, so no further update is needed Nov 19 12:46:44 volumio sudo[1311]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:44 volumio sudo[1313]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:44 volumio volumio[1121]: info: Output device has changed, restarting MPD Nov 19 12:46:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 19 12:46:44 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 19 12:46:44 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 19 12:46:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 19 12:46:44 volumio volumio[1121]: info: Output device has changed, restarting Shairport Sync Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 19 12:46:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 19 12:46:44 volumio sudo[1317]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:44 volumio sudo[1321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 12:46:44 volumio sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:44 volumio sudo[1321]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:44 volumio sudo[1324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 12:46:44 volumio sudo[1324]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:44 volumio volumio[1121]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 19 12:46:44 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 19 12:46:44 volumio systemd[1]: mpd.service: Succeeded. Nov 19 12:46:44 volumio systemd[1]: Stopped Music Player Daemon. Nov 19 12:46:44 volumio systemd[1]: Starting Music Player Daemon... Nov 19 12:46:44 volumio volumio[1121]: info: MPD Permissions set Nov 19 12:46:44 volumio volumio[1121]: info: Shairport-Sync Started Nov 19 12:46:44 volumio volumio[1121]: Error adding Membership: Error: addMembership EINVAL Nov 19 12:46:44 volumio volumio[1121]: info: Shairport-Sync Started Nov 19 12:46:44 volumio volumio[1121]: info: Shairport-Sync Started Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 19 12:46:44 volumio sudo[1331]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 19 12:46:44 volumio sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:44 volumio sudo[1331]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Nov 19 12:46:44 volumio sudo[1331]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Nov 19 12:46:44 volumio volumio[1121]: info: camilladsp service started and running in background, instance 1 Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 12:46:44 volumio volumio[1121]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 19 12:46:44 volumio volumio[1121]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 19 12:46:44 volumio volumio[1121]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Nov 19 12:46:44 volumio volumio[1121]: info: FusionDsp loaded Nov 19 12:46:44 volumio volumio[1121]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 19 12:46:44 volumio sudo[1352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 19 12:46:44 volumio sudo[1352]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 12:46:44 volumio volumio[1121]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 19 12:46:44 volumio volumio[1121]: info: Adding Signal Path Element [object Object] Nov 19 12:46:44 volumio volumio[1121]: info: Adding fusiondspeq DSP Signal Path Element Nov 19 12:46:44 volumio volumio[1121]: info: FusionDsp - ---- installed callbackRead Nov 19 12:46:44 volumio sudo[1352]: pam_unix(sudo:session): session closed for user root Nov 19 12:46:44 volumio volumio[1121]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 12:46:44 volumio volumio[1121]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Nov 19 12:46:44 volumio volumio[1121]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Nov 19 12:46:44 volumio volumio[1121]: at onErrorNT (internal/child_process.js:472:16) Nov 19 12:46:44 volumio volumio[1121]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Nov 19 12:46:44 volumio volumio[1121]: at runNextTicks (internal/process/task_queues.js:64:3) Nov 19 12:46:44 volumio volumio[1121]: at listOnTimeout (internal/timers.js:526:9) Nov 19 12:46:44 volumio volumio[1121]: at processTimers (internal/timers.js:500:7) { Nov 19 12:46:44 volumio volumio[1121]: errno: -2, Nov 19 12:46:44 volumio volumio[1121]: code: 'ENOENT', Nov 19 12:46:44 volumio volumio[1121]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Nov 19 12:46:44 volumio volumio[1121]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Nov 19 12:46:44 volumio volumio[1121]: spawnargs: [ Nov 19 12:46:44 volumio volumio[1121]: '-p', Nov 19 12:46:44 volumio volumio[1121]: 9876, Nov 19 12:46:44 volumio volumio[1121]: '-o', Nov 19 12:46:44 volumio volumio[1121]: '/tmp/camilladsp.log', Nov 19 12:46:44 volumio volumio[1121]: '-l', Nov 19 12:46:44 volumio volumio[1121]: 'warn', Nov 19 12:46:44 volumio volumio[1121]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Nov 19 12:46:44 volumio volumio[1121]: ] Nov 19 12:46:44 volumio volumio[1121]: } Nov 19 12:46:44 volumio volumio[1121]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 12:46:45 volumio sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-19 12:45 Nov 19 12:46:45 volumio sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 10:15:17 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="orangepipc" VOLUMIO_DEVICENAME="Orange Pi PC" VOLUMIO_HASH="49ee0b71bdee95489f79b31a5db4cbdb"