Thu Mar 18 18:15:16 UTC 2021 Description="'No info available'" # cat /proc/version --------------- Linux version 4.9.230+ (odroidn2@busteros) (gcc version 6.3.1 20170109 (Linaro GCC 6.3-2017.02) ) #3 SMP PREEMPT Wed Jul 22 18:31:26 CEST 2020 # cat /etc/os-release --------------- PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 00:22:40 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="odroidn2" VOLUMIO_HASH="c1522ff658bf5a90848081f8a21615e2" # ifconfig --------------- eth0 Link encap:Ethernet HWaddr 00:1e:06:42:58:18 inet addr:192.168.1.4 Bcast:192.168.1.255 Mask:255.255.255.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:3037 errors:0 dropped:0 overruns:0 frame:0 TX packets:1777 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:3514916 (3.3 MiB) TX bytes:503980 (492.1 KiB) Interrupt:22 lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 UP LOOPBACK RUNNING MTU:65536 Metric:1 RX packets:4680 errors:0 dropped:0 overruns:0 frame:0 TX packets:4680 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1 RX bytes:580886 (567.2 KiB) TX bytes:580886 (567.2 KiB) # sudo iwconfig --------------- eth0 no wireless extensions. lo no wireless extensions. # aplay -l --------------- **** List of PLAYBACK Hardware Devices **** card 0: AMLAUGESOUND [AML-AUGESOUND], device 0: SPDIF-B-dit-hifi dit-hifi-0 [] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: AMLAUGESOUND [AML-AUGESOUND], device 1: TDM-C-T9015-audio-hifi T9015-audio-hifi-1 [] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: AMLAUGESOUND [AML-AUGESOUND], device 2: SPDIF-dit-hifi dit-hifi-2 [] Subdevices: 1/1 Subdevice #0: subdevice #0 # ps -ef --------------- UID PID PPID C STIME TTY TIME CMD root 1 0 0 18:10 ? 00:00:01 /sbin/init root 2 0 0 18:10 ? 00:00:00 [kthreadd] root 3 2 0 18:10 ? 00:00:00 [ksoftirqd/0] root 4 2 0 18:10 ? 00:00:00 [kworker/0:0] root 5 2 0 18:10 ? 00:00:00 [kworker/0:0H] root 6 2 0 18:10 ? 00:00:00 [kworker/u12:0] root 7 2 0 18:10 ? 00:00:00 [rcu_preempt] root 8 2 0 18:10 ? 00:00:00 [rcu_sched] root 9 2 0 18:10 ? 00:00:00 [rcu_bh] root 10 2 0 18:10 ? 00:00:00 [migration/0] root 11 2 0 18:10 ? 00:00:00 [lru-add-drain] root 12 2 0 18:10 ? 00:00:00 [watchdog/0] root 13 2 0 18:10 ? 00:00:00 [cpuhp/0] root 14 2 0 18:10 ? 00:00:00 [cpuhp/1] root 15 2 0 18:10 ? 00:00:00 [watchdog/1] root 16 2 0 18:10 ? 00:00:00 [migration/1] root 17 2 0 18:10 ? 00:00:00 [ksoftirqd/1] root 18 2 0 18:10 ? 00:00:00 [kworker/1:0] root 19 2 0 18:10 ? 00:00:00 [kworker/1:0H] root 20 2 0 18:10 ? 00:00:00 [cpuhp/2] root 21 2 0 18:10 ? 00:00:00 [watchdog/2] root 22 2 0 18:10 ? 00:00:00 [migration/2] root 23 2 0 18:10 ? 00:00:00 [ksoftirqd/2] root 24 2 0 18:10 ? 00:00:00 [kworker/2:0] root 25 2 0 18:10 ? 00:00:00 [kworker/2:0H] root 26 2 0 18:10 ? 00:00:00 [cpuhp/3] root 27 2 0 18:10 ? 00:00:00 [watchdog/3] root 28 2 0 18:10 ? 00:00:00 [migration/3] root 29 2 0 18:10 ? 00:00:00 [ksoftirqd/3] root 30 2 0 18:10 ? 00:00:00 [kworker/3:0] root 31 2 0 18:10 ? 00:00:00 [kworker/3:0H] root 32 2 0 18:10 ? 00:00:00 [cpuhp/4] root 33 2 0 18:10 ? 00:00:00 [watchdog/4] root 34 2 0 18:10 ? 00:00:00 [migration/4] root 35 2 0 18:10 ? 00:00:00 [ksoftirqd/4] root 36 2 0 18:10 ? 00:00:00 [kworker/4:0] root 37 2 0 18:10 ? 00:00:00 [kworker/4:0H] root 38 2 0 18:10 ? 00:00:00 [cpuhp/5] root 39 2 0 18:10 ? 00:00:00 [watchdog/5] root 40 2 0 18:10 ? 00:00:00 [migration/5] root 41 2 0 18:10 ? 00:00:00 [ksoftirqd/5] root 42 2 0 18:10 ? 00:00:00 [kworker/5:0] root 43 2 0 18:10 ? 00:00:00 [kworker/5:0H] root 44 2 0 18:10 ? 00:00:00 [kdevtmpfs] root 45 2 0 18:10 ? 00:00:00 [netns] root 46 2 0 18:10 ? 00:00:00 [kworker/u12:1] root 76 2 0 18:10 ? 00:00:00 [kworker/u12:2] root 222 2 0 18:10 ? 00:00:00 [kworker/u12:3] root 433 2 0 18:10 ? 00:00:00 [kworker/u12:4] root 1176 2 0 18:10 ? 00:00:00 [khungtaskd] root 1177 2 0 18:10 ? 00:00:00 [oom_reaper] root 1178 2 0 18:10 ? 00:00:00 [writeback] root 1180 2 0 18:10 ? 00:00:00 [kcompactd0] root 1181 2 0 18:10 ? 00:00:00 [crypto] root 1182 2 0 18:10 ? 00:00:00 [bioset] root 1184 2 0 18:10 ? 00:00:00 [kblockd] root 1211 2 0 18:10 ? 00:00:00 [devfreq_wq] root 1259 2 0 18:10 ? 00:00:00 [kworker/0:1] root 1260 2 0 18:10 ? 00:00:00 [cfg80211] root 1264 2 0 18:10 ? 00:00:00 [watchdogd] root 1351 2 0 18:10 ? 00:00:00 [gp_pll] root 1356 2 0 18:10 ? 00:00:00 [kworker/3:1] root 1362 2 0 18:10 ? 00:00:00 [kworker/5:1] root 1395 2 0 18:10 ? 00:00:00 [kswapd0] root 1396 2 0 18:10 ? 00:00:00 [vmstat] root 1465 2 0 18:10 ? 00:00:00 [kworker/u13:0] root 1540 2 0 18:10 ? 00:00:00 [hwrng] root 1551 2 0 18:10 ? 00:00:00 [kbase_job_fault] root 1553 2 0 18:10 ? 00:00:00 [kworker/u13:1] root 1557 2 0 18:10 ? 00:00:00 [bioset] root 1560 2 0 18:10 ? 00:00:00 [bioset] root 1563 2 0 18:10 ? 00:00:00 [bioset] root 1566 2 0 18:10 ? 00:00:00 [bioset] root 1569 2 0 18:10 ? 00:00:00 [bioset] root 1572 2 0 18:10 ? 00:00:00 [bioset] root 1575 2 0 18:10 ? 00:00:00 [bioset] root 1578 2 0 18:10 ? 00:00:00 [bioset] root 1600 2 0 18:10 ? 00:00:00 [eth_moniter_tx_] root 1630 2 0 18:10 ? 00:00:00 [kworker/2:1] root 1640 2 0 18:10 ? 00:00:00 [cfinteractive] root 1702 2 0 18:10 ? 00:00:00 [null] root 1703 2 0 18:10 ? 00:00:00 [null] root 1704 2 0 18:10 ? 00:00:00 [cpu_hogplug_thr] root 1717 2 0 18:10 ? 00:00:00 [vmalloc_ion] root 1718 2 0 18:10 ? 00:00:00 [codec_mm_ion] root 1722 2 0 18:10 ? 00:00:00 [ge2d_monitor] root 1733 2 0 18:10 ? 00:00:00 [kworker/0:1H] root 1738 2 0 18:10 ? 00:00:00 [kthread_hdcp] root 1745 2 0 18:10 ? 00:00:00 [kthread_di] root 1782 2 0 18:10 ? 00:00:00 [videosync] root 1789 2 0 18:10 ? 00:00:00 [gdc_monitor] root 1792 2 0 18:10 ? 00:00:00 [irq/55-meson-am] root 1794 2 0 18:10 ? 00:00:00 [irq/56-meson-am] root 1796 2 0 18:10 ? 00:00:00 [kworker/0:2] root 1804 2 0 18:10 ? 00:00:00 [cec_work] root 1828 2 0 18:10 ? 00:00:00 [irq/26-meson-g1] root 1829 2 0 18:10 ? 00:00:00 [cma_task0] root 1834 2 0 18:10 ? 00:00:00 [cma_task1] root 1835 2 0 18:10 ? 00:00:00 [cma_task2] root 1836 2 0 18:10 ? 00:00:00 [cma_task3] root 1837 2 0 18:10 ? 00:00:00 [cma_task4] root 1838 2 0 18:10 ? 00:00:00 [cma_task5] root 1891 2 0 18:10 ? 00:00:00 [kworker/4:1] root 1911 2 0 18:10 ? 00:00:00 [dwc_otg] root 1930 2 0 18:10 ? 00:00:00 [kworker/5:2] root 1931 2 0 18:10 ? 00:00:00 [kworker/3:2] root 1932 2 0 18:10 ? 00:00:00 [kworker/1:1] root 1934 2 0 18:10 ? 00:00:00 [bioset] root 1935 2 0 18:10 ? 00:00:00 [mmcqd/1] root 1964 2 0 18:10 ? 00:00:00 [scsi_eh_0] root 1965 2 0 18:10 ? 00:00:00 [scsi_tmf_0] root 1966 2 0 18:10 ? 00:00:00 [usb-storage] root 1970 2 0 18:10 ? 00:00:00 [bioset] root 2016 2 0 18:10 ? 00:00:00 [jbd2/mmcblk1p2-] root 2017 2 0 18:10 ? 00:00:00 [ext4-rsv-conver] root 2034 2 0 18:10 ? 00:00:00 [loop0] root 2054 2 0 18:10 ? 00:00:00 [jbd2/mmcblk1p3-] root 2055 2 0 18:10 ? 00:00:00 [ext4-rsv-conver] root 2068 2 0 18:10 ? 00:00:00 [kworker/1:1H] root 2069 2 0 18:10 ? 00:00:00 [kworker/5:1H] root 2070 2 0 18:10 ? 00:00:00 [kworker/4:1H] root 2071 2 0 18:10 ? 00:00:00 [kworker/2:1H] root 2077 2 0 18:10 ? 00:00:00 [ipv6_addrconf] root 2091 2 0 18:10 ? 00:00:00 [kauditd] root 2100 1 0 18:10 ? 00:00:00 /lib/systemd/systemd-journald root 2101 2 0 18:10 ? 00:00:00 [kworker/3:1H] root 2499 2 0 18:10 ? 00:00:00 [kworker/4:2] root 2898 2 0 18:10 ? 00:00:00 [kworker/2:2] root 2899 1 0 18:10 ? 00:00:00 /lib/systemd/systemd-udevd root 3032 2 0 18:10 ? 00:00:00 [kworker/1:2] root 3143 1 0 18:10 ? 00:00:00 /sbin/rpcbind -w statd 3154 1 0 18:10 ? 00:00:00 /sbin/rpc.statd root 3159 2 0 18:10 ? 00:00:00 [rpciod] root 3161 2 0 18:10 ? 00:00:00 [xprtiod] root 3169 2 0 18:10 ? 00:00:00 [nfsiod] root 3188 1 0 18:10 ? 00:00:00 /usr/sbin/rpc.idmapd root 3190 1 0 18:10 ? 00:00:00 /usr/sbin/haveged --Foreground --verbose=1 --write=1024 volumio 3193 1 0 18:10 ? 00:00:00 /usr/bin/udisks-glue --foreground volumio 3195 1 0 18:10 ? 00:00:00 /usr/local/bin/volumio-remote-updater root 3196 1 0 18:10 ? 00:00:00 /bin/bash /bin/volumiologrotate root 3203 1 0 18:10 ? 00:00:00 /lib/systemd/systemd-logind avahi 3219 1 0 18:10 ? 00:00:00 avahi-daemon: running [volumio.local] message+ 3224 1 0 18:10 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation nobody 3284 1 0 18:10 ? 00:00:00 /usr/sbin/thd --daemon --triggers /etc/triggerhappy/triggers.d/ --socket /var/run/thd.socket --pidfile /var/run/thd.pid --user nobody /dev/input/event0 /dev/input/event1 /dev/input/event2 root 3302 1 0 18:10 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I avahi 3309 3219 0 18:10 ? 00:00:00 avahi-daemon: chroot helper root 3321 2 0 18:10 ? 00:00:00 [rc0] ntp 3351 1 0 18:10 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 100:104 root 3389 1 0 18:10 ? 00:00:00 /usr/sbin/sshd -D root 3402 1 0 18:10 ? 00:00:00 /usr/lib/udisks/udisks-daemon --no-debug root 3411 1 0 18:10 tty1 00:00:00 /sbin/agetty --noclear tty1 linux root 3413 1 0 18:10 ttyS0 00:00:00 /sbin/agetty --keep-baud 115200 38400 9600 ttyS0 vt102 root 3430 3402 0 18:10 ? 00:00:00 udisks-daemon: not polling any devices root 3451 1 0 18:10 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug volumio 3488 1 3 18:10 ? 00:00:09 /usr/local/bin/node /volumio/index.js root 3511 1 0 18:10 ? 00:00:00 /usr/sbin/winbindd root 3512 1 0 18:10 ? 00:00:00 /usr/sbin/nmbd -D root 3513 3512 0 18:10 ? 00:00:00 /usr/sbin/nmbd -D root 3520 3511 0 18:10 ? 00:00:00 /usr/sbin/winbindd root 3527 1 3 18:10 ? 00:00:10 /sbin/mount.ntfs /dev/sda1 /media/SAMSUNG_EMO -o rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks root 3532 1 0 18:10 ? 00:00:00 /usr/sbin/smbd -D root 3538 3511 0 18:10 ? 00:00:00 /usr/sbin/winbindd root 3540 3511 0 18:10 ? 00:00:00 /usr/sbin/winbindd root 3541 3532 0 18:10 ? 00:00:00 /usr/sbin/smbd -D root 3598 1 0 18:10 ? 00:00:00 dhcpcd eth0 volumio 3686 3488 0 18:10 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 3692 3686 0 18:10 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 3693 3686 0 18:10 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 3698 3686 0 18:10 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 3703 3686 0 18:10 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 3708 3686 0 18:10 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 3827 1 0 18:10 ? 00:00:00 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf volumio 3850 1 0 18:10 ? 00:00:00 /bin/streaming-daemon volumio 4021 3488 0 18:11 ? 00:00:00 /bin/journalctl --output cat -f mpd 4274 1 0 18:13 ? 00:00:00 /usr/bin/mpd --no-daemon shairpo+ 4296 1 1 18:13 ? 00:00:01 /usr/local/bin/shairport-sync --configfile=/tmp/shairport-sync.conf root 4384 3196 0 18:14 ? 00:00:00 sleep 60 volumio 4477 3488 0 18:15 ? 00:00:00 /bin/sh -c /usr/local/bin/node /volumio/logsubmit.js 'No info available' volumio 4479 4477 0 18:15 ? 00:00:00 /usr/local/bin/node /volumio/logsubmit.js No info available volumio 4498 4479 0 18:15 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 4499 4498 0 18:15 ? 00:00:00 ps -ef # df -h --------------- Filesystem Size Used Avail Use% Mounted on /dev/mmcblk1p2 2.2G 628M 1.5G 31% /imgpart /dev/loop0 300M 300M 0 100% /static overlay 114G 16M 108G 1% / devtmpfs 929M 0 929M 0% /dev tmpfs 934M 0 934M 0% /dev/shm tmpfs 934M 4.7M 929M 1% /run tmpfs 5.0M 4.0K 5.0M 1% /run/lock tmpfs 934M 0 934M 0% /sys/fs/cgroup tmpfs 934M 44K 933M 1% /tmp tmpfs 934M 0 934M 0% /var/spool/cups tmpfs 20M 12K 20M 1% /var/log tmpfs 934M 0 934M 0% /var/spool/cups/tmp /dev/mmcblk1p1 60M 13M 48M 21% /boot /dev/sda1 932G 790G 142G 85% /media/SAMSUNG_EMO # mount --------------- /dev/mmcblk1p2 on /imgpart type ext4 (rw,relatime,data=ordered) /dev/loop0 on /static type squashfs (ro,relatime) overlay on / type overlay (rw,relatime,lowerdir=/mnt/static,upperdir=/mnt/ext/dyn,workdir=/mnt/ext/work) sysfs on /sys type sysfs (rw,nosuid,nodev,noexec,relatime) proc on /proc type proc (rw,relatime) devtmpfs on /dev type devtmpfs (rw,nosuid,size=951100k,nr_inodes=237775,mode=755) securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime) selinuxfs on /sys/fs/selinux type selinuxfs (rw,relatime) tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev,noexec) devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000) tmpfs on /run type tmpfs (rw,nosuid,nodev,mode=755) tmpfs on /run/lock type tmpfs (rw,nosuid,nodev,noexec,relatime,size=5120k) tmpfs on /sys/fs/cgroup type tmpfs (ro,nosuid,nodev,noexec,mode=755) cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,release_agent=/lib/systemd/systemd-cgroups-agent,name=systemd) pstore on /sys/fs/pstore type pstore (rw,nosuid,nodev,noexec,relatime) cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset) cgroup on /sys/fs/cgroup/cpu,cpuacct type cgroup (rw,nosuid,nodev,noexec,relatime,cpu,cpuacct) cgroup on /sys/fs/cgroup/memory type cgroup (rw,nosuid,nodev,noexec,relatime,memory) cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices) cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer) cgroup on /sys/fs/cgroup/net_cls type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls) cgroup on /sys/fs/cgroup/pids type cgroup (rw,nosuid,nodev,noexec,relatime,pids) cgroup on /sys/fs/cgroup/debug type cgroup (rw,nosuid,nodev,noexec,relatime,debug) systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=22,pgrp=1,timeout=300,minproto=5,maxproto=5,direct) debugfs on /sys/kernel/debug type debugfs (rw,relatime) mqueue on /dev/mqueue type mqueue (rw,relatime) configfs on /sys/kernel/config type configfs (rw,relatime) fusectl on /sys/fs/fuse/connections type fusectl (rw,relatime) tmpfs on /tmp type tmpfs (rw,noatime,mode=755) tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755) tmpfs on /var/log type tmpfs (rw,nodev,relatime,size=20480k,mode=777,uid=1000,gid=4) tmpfs on /var/spool/cups/tmp type tmpfs (rw,noatime,mode=755) /dev/mmcblk1p1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=iso8859-1,shortname=mixed,utf8,errors=remount-ro) rpc_pipefs on /run/rpc_pipefs type rpc_pipefs (rw,relatime) /dev/sda1 on /media/SAMSUNG_EMO type fuseblk (rw,nosuid,nodev,noatime,user_id=0,group_id=0,default_permissions,allow_other,blksize=4096,uhelper=udisks) # sudo journalctl -p 7 --------------- -- Logs begin at Thu 2021-03-18 18:09:59 UTC, end at Thu 2021-03-18 18:15:16 UTC. -- Mar 18 18:09:59 volumio systemd-journal[2100]: Runtime journal is using 4.0M (max allowed 30.0M, trying to leave 139.9M free of 928.8M available → current limit 30.0M). Mar 18 18:09:59 volumio kernel: Booting Linux on physical CPU 0x0 Mar 18 18:09:59 volumio kernel: Linux version 4.9.230+ (odroidn2@busteros) (gcc version 6.3.1 20170109 (Linaro GCC 6.3-2017.02) ) #3 SMP PREEMPT Wed Jul 22 18:31:26 CEST 2020 Mar 18 18:09:59 volumio kernel: Boot CPU: AArch64 Processor [410fd034] Mar 18 18:09:59 volumio kernel: Machine model: Hardkernel ODROID-N2Plus Mar 18 18:09:59 volumio kernel: efi: Getting EFI parameters from FDT: Mar 18 18:09:59 volumio kernel: efi: UEFI not found. Mar 18 18:09:59 volumio kernel: __reserved_mem_alloc_size, start:0x000000007f800000, end:0x0000000080000000, len:8 MiB Mar 18 18:09:59 volumio kernel: failed to allocate memory for node linux,meson-fb, size:8 MB Mar 18 18:09:59 volumio kernel: 70000000 - 78000000, 131072 KB, linux,ion-dev Mar 18 18:09:59 volumio kernel: 6d800000 - 70000000, 40960 KB, linux,di_cma Mar 18 18:09:59 volumio kernel: Reserved memory: created DMA memory pool at 0x000000006d800000, size 0 MiB Mar 18 18:09:59 volumio kernel: 6d800000 - 6d800000, 0 KB, linux,ppmgr Mar 18 18:09:59 volumio kernel: 5a400000 - 6d800000, 315392 KB, linux,codec_mm_cma Mar 18 18:09:59 volumio kernel: 5a400000 - 5a400000, 0 KB, linux,codec_mm_reserved Mar 18 18:09:59 volumio kernel: __reserved_mem_alloc_size, start:0x0000000005000000, end:0x0000000005400000, len:4 MiB Mar 18 18:09:59 volumio kernel: 05000000 - 05400000, 4096 KB, linux,secmon Mar 18 18:09:59 volumio kernel: cma: Reserved 8 MiB at 0x0000000059c00000 Mar 18 18:09:59 volumio kernel: On node 0 totalpages: 491520 Mar 18 18:09:59 volumio kernel: DMA zone: 7680 pages used for memmap Mar 18 18:09:59 volumio kernel: DMA zone: 0 pages reserved Mar 18 18:09:59 volumio kernel: DMA zone: 491520 pages, LIFO batch:31 Mar 18 18:09:59 volumio kernel: psci: probing for conduit method from DT. Mar 18 18:09:59 volumio kernel: psci: PSCIv1.0 detected in firmware. Mar 18 18:09:59 volumio kernel: psci: Using standard PSCI v0.2 function IDs Mar 18 18:09:59 volumio kernel: psci: MIGRATE_INFO_TYPE not supported. Mar 18 18:09:59 volumio kernel: psci: SMC Calling Convention v1.1 Mar 18 18:09:59 volumio kernel: percpu: Embedded 21 pages/cpu s47960 r8192 d29864 u86016 Mar 18 18:09:59 volumio kernel: pcpu-alloc: s47960 r8192 d29864 u86016 alloc=21*4096 Mar 18 18:09:59 volumio kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [0] 4 [0] 5 Mar 18 18:09:59 volumio kernel: Detected VIPT I-cache on CPU0 Mar 18 18:09:59 volumio kernel: CPU features: enabling workaround for ARM erratum 845719 Mar 18 18:09:59 volumio kernel: Built 1 zonelists in Zone order, mobility grouping on. Total pages: 483840 Mar 18 18:09:59 volumio kernel: Kernel command line: imgpart=UUID=5ca9619e-3d80-453f-b991-614df61cdaec imgfile=/volumio_current.sqsh hwdevice=Odroid-N2 bootpart=UUID=DCAA-C703 datapart=UUID=5ab55925-e584-46df-ade9-96e9acb1c390 bootconfig=boot.ini loglevel=0 rootwait rw console=ttyS0,115200n8 no_console_suspend fsck.repair=yes net.ifnames=0 elevator=noop hdmimode=custombuilt cvbsmode=576cvbs max_freq_a53=1908 max_freq_a73=2208 maxcpus=6 voutmode=hdmi modeline=1920,540,74250,33750,60,1920,2008,2052,2200,540,542,547,562,1,1,0 disablehpd=false cvbscable=0 overscan=100 monitor_onoff=false logo=osd0,loaded hdmitx=cec3f sdrmode=auto consoleblank=0 loglevel=0 Mar 18 18:09:59 volumio kernel: vout: get hdmimode: custombuilt Mar 18 18:09:59 volumio kernel: vout: get cvbsmode: 576cvbs Mar 18 18:09:59 volumio kernel: max cpufreq of cluster0 : 1908000kHz Mar 18 18:09:59 volumio kernel: max cpufreq of cluster1 : 2208000kHz Mar 18 18:09:59 volumio kernel: hdmitx: voutmode : 1 Mar 18 18:09:59 volumio kernel: fmt_para.timing Mar 18 18:09:59 volumio kernel: - pixel_freq 74250, frac_freq 74250 Mar 18 18:09:59 volumio kernel: - h_freq 33750, v_freq 60000 Mar 18 18:09:59 volumio kernel: - hsync_polarity 1, vsync_polarity 1 Mar 18 18:09:59 volumio kernel: - h_active 1920, h_total 2200 Mar 18 18:09:59 volumio kernel: - h_blank 280, h_front 88, h_sync 44, h_back 148 Mar 18 18:09:59 volumio kernel: - v_active 540, v_total 562 Mar 18 18:09:59 volumio kernel: - v_blank 22, v_front 2, v_sync 5, v_back 15 Mar 18 18:09:59 volumio kernel: - v_sync_ln 1 Mar 18 18:09:59 volumio kernel: fmt_para.hdmitx_vinfo Mar 18 18:09:59 volumio kernel: - name custombuilt, mode 0 Mar 18 18:09:59 volumio kernel: - width 1920, height 540, field_height 540 Mar 18 18:09:59 volumio kernel: - aspect_ratio_num 16, aspect_ratio_den 9 Mar 18 18:09:59 volumio kernel: - video_clk 74250000 Mar 18 18:09:59 volumio kernel: - htotal 2200, vtotal 562 Mar 18 18:09:59 volumio kernel: - viu_color_fmt 2, viu_mux 2 Mar 18 18:09:59 volumio kernel: fb: osd0 Mar 18 18:09:59 volumio kernel: fb: loaded Mar 18 18:09:59 volumio kernel: PID hash table entries: 4096 (order: 3, 32768 bytes) Mar 18 18:09:59 volumio kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) Mar 18 18:09:59 volumio kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) Mar 18 18:09:59 volumio kernel: Memory: 1402492K/1966080K available (11964K kernel code, 1786K rwdata, 5160K rodata, 4992K init, 1419K bss, 63876K reserved, 499712K cma-reserved) Mar 18 18:09:59 volumio kernel: Virtual kernel memory layout: Mar 18 18:09:59 volumio kernel: modules : 0xffffff8000000000 - 0xffffff8008000000 ( 128 MB) Mar 18 18:09:59 volumio kernel: vmalloc : 0xffffff8008000000 - 0xffffffbebfff0000 ( 250 GB) Mar 18 18:09:59 volumio kernel: .text : 0xffffff8009080000 - 0xffffff8009c30000 ( 11968 KB) Mar 18 18:09:59 volumio kernel: .rodata : 0xffffff8009c30000 - 0xffffff800a140000 ( 5184 KB) Mar 18 18:09:59 volumio kernel: .init : 0xffffff800a140000 - 0xffffff800a620000 ( 4992 KB) Mar 18 18:09:59 volumio kernel: .data : 0xffffff800a620000 - 0xffffff800a7dea00 ( 1787 KB) Mar 18 18:09:59 volumio kernel: .bss : 0xffffff800a7dea00 - 0xffffff800a94187c ( 1420 KB) Mar 18 18:09:59 volumio kernel: fixed : 0xffffffbefe7fd000 - 0xffffffbefec00000 ( 4108 KB) Mar 18 18:09:59 volumio kernel: PCI I/O : 0xffffffbefee00000 - 0xffffffbeffe00000 ( 16 MB) Mar 18 18:09:59 volumio kernel: vmemmap : 0xffffffbf00000000 - 0xffffffc000000000 ( 4 GB maximum) Mar 18 18:09:59 volumio kernel: 0xffffffbf00000000 - 0xffffffbf01e00000 ( 30 MB actual) Mar 18 18:09:59 volumio kernel: memory : 0xffffffc000000000 - 0xffffffc078000000 ( 1920 MB) Mar 18 18:09:59 volumio kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=6, Nodes=1 Mar 18 18:09:59 volumio kernel: Preemptible hierarchical RCU implementation. Mar 18 18:09:59 volumio kernel: Build-time adjustment of leaf fanout to 64. Mar 18 18:09:59 volumio kernel: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=6. Mar 18 18:09:59 volumio kernel: RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=6 Mar 18 18:09:59 volumio kernel: NR_IRQS:64 nr_irqs:64 0 Mar 18 18:09:59 volumio kernel: GPIO-INTC: support to detect double-edge trigger signal Mar 18 18:09:59 volumio kernel: g12a_aoclkc_init: register ao clk ok! Mar 18 18:09:59 volumio kernel: Meson chip version = RevC (29:C - 40:0) Mar 18 18:09:59 volumio kernel: meson_g12a_sdemmc_init: register amlogic sdemmc clk Mar 18 18:09:59 volumio kernel: meson_g12a_sdemmc_init: register amlogic sdemmc clk Mar 18 18:09:59 volumio kernel: meson_g12a_gpu_init: register meson gpu clk Mar 18 18:09:59 volumio kernel: meson_g12a_media_init: register meson media clk Mar 18 18:09:59 volumio kernel: meson_g12a_misc_init: register amlogic g12a misc clks Mar 18 18:09:59 volumio kernel: meson_g12a_misc_init: done. Mar 18 18:09:59 volumio kernel: g12a_clkc_init initialization complete Mar 18 18:09:59 volumio kernel: arm_arch_timer: Architected cp15 timer(s) running at 24.00MHz (phys). Mar 18 18:09:59 volumio kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns Mar 18 18:09:59 volumio kernel: sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns Mar 18 18:09:59 volumio kernel: meson_bc_timer: mclk->mux_reg =ffffff800800c190,mclk->reg =ffffff800800e194 Mar 18 18:09:59 volumio kernel: Console: colour dummy device 80x25 Mar 18 18:09:59 volumio kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000) Mar 18 18:09:59 volumio kernel: pid_max: default: 32768 minimum: 301 Mar 18 18:09:59 volumio kernel: Security Framework initialized Mar 18 18:09:59 volumio kernel: SELinux: Initializing. Mar 18 18:09:59 volumio kernel: SELinux: Starting in permissive mode Mar 18 18:09:59 volumio kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) Mar 18 18:09:59 volumio kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) Mar 18 18:09:59 volumio kernel: ftrace: allocating 39793 entries in 156 pages Mar 18 18:09:59 volumio kernel: sched-energy: Sched-energy-costs installed from DT Mar 18 18:09:59 volumio kernel: CPU0: update cpu_capacity 631 Mar 18 18:09:59 volumio kernel: ASID allocator initialised with 65536 entries Mar 18 18:09:59 volumio kernel: secmon: clear_range:5100000 200000 Mar 18 18:09:59 volumio kernel: EFI services will not be available. Mar 18 18:09:59 volumio kernel: Detected VIPT I-cache on CPU1 Mar 18 18:09:59 volumio kernel: CPU1: update cpu_capacity 631 Mar 18 18:09:59 volumio kernel: CPU1: Booted secondary processor [410fd034] Mar 18 18:09:59 volumio kernel: Detected VIPT I-cache on CPU2 Mar 18 18:09:59 volumio kernel: CPU2: update cpu_capacity 1192 Mar 18 18:09:59 volumio kernel: CPU2: Booted secondary processor [410fd092] Mar 18 18:09:59 volumio kernel: Detected VIPT I-cache on CPU3 Mar 18 18:09:59 volumio kernel: CPU3: update cpu_capacity 1192 Mar 18 18:09:59 volumio kernel: CPU3: Booted secondary processor [410fd092] Mar 18 18:09:59 volumio kernel: Detected VIPT I-cache on CPU4 Mar 18 18:09:59 volumio kernel: CPU4: update cpu_capacity 1192 Mar 18 18:09:59 volumio kernel: CPU4: Booted secondary processor [410fd092] Mar 18 18:09:59 volumio kernel: Detected VIPT I-cache on CPU5 Mar 18 18:09:59 volumio kernel: CPU5: update cpu_capacity 1192 Mar 18 18:09:59 volumio kernel: CPU5: Booted secondary processor [410fd092] Mar 18 18:09:59 volumio kernel: Brought up 6 CPUs Mar 18 18:09:59 volumio kernel: SMP: Total of 6 processors activated. Mar 18 18:09:59 volumio kernel: CPU features: detected feature: 32-bit EL0 Support Mar 18 18:09:59 volumio kernel: CPU: All CPU(s) started at EL2 Mar 18 18:09:59 volumio kernel: alternatives: patching kernel code Mar 18 18:09:59 volumio kernel: devtmpfs: initialized Mar 18 18:09:59 volumio kernel: DMI not present or invalid. Mar 18 18:09:59 volumio kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Mar 18 18:09:59 volumio kernel: futex hash table entries: 2048 (order: 5, 131072 bytes) Mar 18 18:09:59 volumio kernel: pinctrl core: initialized pinctrl subsystem Mar 18 18:09:59 volumio kernel: NET: Registered protocol family 16 Mar 18 18:09:59 volumio kernel: schedtune: init normalization constants... Mar 18 18:09:59 volumio kernel: schedtune: CLUSTER[0-1] min_pwr: 0 max_pwr: 42 Mar 18 18:09:59 volumio kernel: schedtune: CPU[0] min_pwr: 0 max_pwr: 279 Mar 18 18:09:59 volumio kernel: schedtune: CPU[1] min_pwr: 0 max_pwr: 279 Mar 18 18:09:59 volumio kernel: schedtune: CLUSTER[2-5] min_pwr: 0 max_pwr: 110 Mar 18 18:09:59 volumio kernel: schedtune: CPU[2] min_pwr: 0 max_pwr: 1048 Mar 18 18:09:59 volumio kernel: schedtune: CPU[3] min_pwr: 0 max_pwr: 1048 Mar 18 18:09:59 volumio kernel: schedtune: CPU[4] min_pwr: 0 max_pwr: 1048 Mar 18 18:09:59 volumio kernel: schedtune: CPU[5] min_pwr: 0 max_pwr: 1048 Mar 18 18:09:59 volumio kernel: schedtune: SYSTEM min_pwr: 0 max_pwr: 4902 Mar 18 18:09:59 volumio kernel: schedtune: using normalization constants mul: 2882587190 sh1: 1 sh2: 12 Mar 18 18:09:59 volumio kernel: schedtune: verify normalization constants... Mar 18 18:09:59 volumio kernel: schedtune: max_pwr/2^0: 4902 => norm_pwr: 1024 Mar 18 18:09:59 volumio kernel: schedtune: max_pwr/2^1: 2451 => norm_pwr: 512 Mar 18 18:09:59 volumio kernel: schedtune: max_pwr/2^2: 1225 => norm_pwr: 255 Mar 18 18:09:59 volumio kernel: schedtune: max_pwr/2^3: 612 => norm_pwr: 127 Mar 18 18:09:59 volumio kernel: schedtune: max_pwr/2^4: 306 => norm_pwr: 63 Mar 18 18:09:59 volumio kernel: schedtune: max_pwr/2^5: 153 => norm_pwr: 31 Mar 18 18:09:59 volumio kernel: schedtune: configured to support global boosting only Mar 18 18:09:59 volumio kernel: cpuidle: using governor menu Mar 18 18:09:59 volumio kernel: register canvas platform driver Mar 18 18:09:59 volumio kernel: register rdma platform driver Mar 18 18:09:59 volumio kernel: vdso: 2 pages (1 code @ ffffff8009c37000, 1 data @ ffffff800a625000) Mar 18 18:09:59 volumio kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Mar 18 18:09:59 volumio kernel: DMA: preallocated 2048 KiB pool for atomic allocations Mar 18 18:09:59 volumio kernel: clkmsr: clkmsr: driver init Mar 18 18:09:59 volumio kernel: codec_mm_module_init Mar 18 18:09:59 volumio kernel: media_configs_system_init Mar 18 18:09:59 volumio kernel: aml_iomap: amlogic iomap probe done Mar 18 18:09:59 volumio kernel: vpu: driver version: v20190329(8-g12b) Mar 18 18:09:59 volumio kernel: vpu: load vpu_clk: 666666667Hz(7) Mar 18 18:09:59 volumio kernel: vpu: clktree_init Mar 18 18:09:59 volumio kernel: vpu: vpu_probe OK Mar 18 18:09:59 volumio kernel: clkmsr: msr_clk_reg0=ffffff800823a004,msr_clk_reg2=ffffff800823c00c Mar 18 18:09:59 volumio kernel: clkmsr ffd18004.meson_clk_msr: failed to get msr ring reg0 Mar 18 18:09:59 volumio kernel: audio_clocks: audio_clocks_probe done Mar 18 18:09:59 volumio kernel: aml_vdac_config_probe: cpu_id:4, name:meson-g12ab-vdac Mar 18 18:09:59 volumio kernel: aml_vdac_probe: ok Mar 18 18:09:59 volumio kernel: canvas_probe reg=00000000ff638000,size=2000 Mar 18 18:09:59 volumio kernel: canvas maped reg_base =ffffff8008268000 Mar 18 18:09:59 volumio kernel: rdma_probe,cpu_type:0, ver:0, len:8 Mar 18 18:09:59 volumio kernel: rdma_register, rdma_table_addr ffffff8008277000 rdma_table_addr_phy 59e00000 reg_buf ffffffc056de8000 Mar 18 18:09:59 volumio kernel: rdma_register success, handle 1 table_size 32768 Mar 18 18:09:59 volumio kernel: set_rdma_handle video rdma handle = 1. Mar 18 18:09:59 volumio kernel: classs created ok Mar 18 18:09:59 volumio kernel: classs file created ok Mar 18 18:09:59 volumio kernel: aml_snd_reg_map[0], reg:ff640000, size:2000 Mar 18 18:09:59 volumio kernel: aml_snd_reg_map[1], reg:ff642000, size:2000 Mar 18 18:09:59 volumio kernel: aml_snd_reg_map[2], reg:ff64a000, size:2000 Mar 18 18:09:59 volumio kernel: aml_snd_reg_map[3], reg:ff656000, size:1800 Mar 18 18:09:59 volumio kernel: aml_snd_reg_map[4], reg:ffd01000, size:1000 Mar 18 18:09:59 volumio kernel: amlogic auge_snd_iomap probe done Mar 18 18:09:59 volumio kernel: codec_mm codec_mm: assigned reserved memory node linux,codec_mm_cma Mar 18 18:09:59 volumio kernel: codec_mm codec_mm: assigned reserved memory node linux,codec_mm_cma Mar 18 18:09:59 volumio kernel: codec_mm_probe ok Mar 18 18:09:59 volumio kernel: cvbs_out: cvbsout_probe, cpu_id:5,name:meson-g12b-cvbsout Mar 18 18:09:59 volumio kernel: cvbs_out: clk path:0 Mar 18 18:09:59 volumio kernel: cvbs_out: cvbs trimming.1.v5: 0xa0, 0x0 Mar 18 18:09:59 volumio kernel: vout: vout1: register server: cvbs_vout_server Mar 18 18:09:59 volumio kernel: cvbs_out: register cvbs module server ok Mar 18 18:09:59 volumio kernel: vout: vout2: register server: cvbs_vout2_server Mar 18 18:09:59 volumio kernel: cvbs_out: register cvbs module vout2 server ok Mar 18 18:09:59 volumio kernel: cvbs_out: chrdev devno 264241152 for disp Mar 18 18:09:59 volumio kernel: cvbs_out: create cdev cvbs Mar 18 18:09:59 volumio kernel: cvbs_out: cvbsout_probe OK Mar 18 18:09:59 volumio kernel: SCSI subsystem initialized Mar 18 18:09:59 volumio kernel: usbcore: registered new interface driver usbfs Mar 18 18:09:59 volumio kernel: usbcore: registered new interface driver hub Mar 18 18:09:59 volumio kernel: usbcore: registered new device driver usb Mar 18 18:09:59 volumio kernel: media: Linux media interface: v0.10 Mar 18 18:09:59 volumio kernel: Linux video capture interface: v2.00 Mar 18 18:09:59 volumio kernel: pps_core: LinuxPPS API ver. 1 registered Mar 18 18:09:59 volumio kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Mar 18 18:09:59 volumio kernel: PTP clock support registered Mar 18 18:09:59 volumio kernel: dmi: Firmware registration failed. Mar 18 18:09:59 volumio kernel: secmon: reserve_mem_size:0x300000 Mar 18 18:09:59 volumio kernel: secmon secmon: assigned reserved memory node linux,secmon Mar 18 18:09:59 volumio kernel: secmon: get page:ffffffbf00140000, 5000 Mar 18 18:09:59 volumio kernel: secmon: share in base: 0xffffffc0050fe000, share out base: 0xffffffc0050ff000 Mar 18 18:09:59 volumio kernel: secmon: phy_in_base: 0x50fe000, phy_out_base: 0x50ff000 Mar 18 18:09:59 volumio kernel: hdmitx: system: amhdmitx_probe start Mar 18 18:09:59 volumio kernel: hdmitx: system: Ver: 20190815 Mar 18 18:09:59 volumio kernel: hdmitx: system: hdmitx_device.chip_type : 11 Mar 18 18:09:59 volumio kernel: hdmitx: system: not find match pwr-ctl Mar 18 18:09:59 volumio kernel: hdmitx: system: not find drm_amhdmitx Mar 18 18:09:59 volumio kernel: hdmitx: system: hpd irq = 41 Mar 18 18:09:59 volumio kernel: hdmitx: system: hdcp22_tx_skp failed to probe Mar 18 18:09:59 volumio kernel: hdmitx: system: hdcp22_tx_esm failed to probe Mar 18 18:09:59 volumio kernel: vout: vout1: register server: hdmitx_vout_server Mar 18 18:09:59 volumio kernel: vout: vout2: register server: hdmitx_vout2_server Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xffd00000 Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff634400 Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff900000 Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff800000 Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff63c000 Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xffd00000 Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff608000 Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xff600000 Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx20: Mapped PHY: 0xffe01000 Mar 18 18:09:59 volumio kernel: hdmitx: hw: hdmitx_get_format:0x0 Mar 18 18:09:59 volumio kernel: hdmitx: hw: P_HHI_HDMI_CLK_CNTL :0x100 Mar 18 18:09:59 volumio kernel: hdmitx: hw: P_HHI_HDMI_PLL_CNTL :0x2b160453 Mar 18 18:09:59 volumio kernel: hdmitx: hw: avmute set to 1 Mar 18 18:09:59 volumio kernel: hdmitx: system: fmt_attr default Mar 18 18:09:59 volumio kernel: hdmitx: system: amhdmitx_probe end Mar 18 18:09:59 volumio kernel: vout: create vout attribute OK Mar 18 18:09:59 volumio kernel: vout: vout_fops_create OK Mar 18 18:09:59 volumio kernel: vout: vout1: register server: nulldisp_vout_server Mar 18 18:09:59 volumio kernel: hdmitx: system: irq 2 0 Mar 18 18:09:59 volumio kernel: vout: tvout monitor interval:500(ms), timeout cnt:20 Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx_set_current_vmode[3881] Mar 18 18:09:59 volumio kernel: hdmitx: system: recalc before custombuilt 60 1 Mar 18 18:09:59 volumio kernel: hdmitx: system: recalc after custombuilt 60 1 Mar 18 18:09:59 volumio kernel: hdmitx: system: get current mode: custombuilt Mar 18 18:09:59 volumio kernel: hdmitx: system: update rx hdr info 0 Mar 18 18:09:59 volumio kernel: hdmitx: system: update physcial size: 16 9 Mar 18 18:09:59 volumio kernel: hdmitx: video: already init VIC = 0 Now VIC = 116 Mar 18 18:09:59 volumio kernel: hdmitx: video: rx edid only support RGB format Mar 18 18:09:59 volumio kernel: hdmitx: hw: div40: 0 Mar 18 18:09:59 volumio kernel: hdmitx: this mode doesn't have frac_rate Mar 18 18:09:59 volumio kernel: hdmitx: frac_rate = 1 Mar 18 18:09:59 volumio kernel: hdmitx: [N2][hdmitx_set_clk_] vic == HDMI_CUSTOMBUILT, frac_freq 74250 Mar 18 18:09:59 volumio kernel: hdmitx: [N2] hpll_clk_out 2970000, od1 4, od2 1, od3 2 Mar 18 18:09:59 volumio kernel: hdmitx: config HPLL = 2970000 frac_rate = 0 Mar 18 18:09:59 volumio kernel: hdmitx: pll[0x4000320] reset 1 times Mar 18 18:09:59 volumio kernel: hdmitx: HPLL: 0xdb00047b Mar 18 18:09:59 volumio kernel: hdmitx: config HPLL done Mar 18 18:09:59 volumio kernel: hdmitx: set_hpll_od3_clk_div[643] div = 6 Mar 18 18:09:59 volumio kernel: hdmitx: j = 14 vid_clk_div = 1 Mar 18 18:09:59 volumio kernel: hdmitx: hw: config hdmitx IP vic = 116 cd:4 cs: 0 Mar 18 18:09:59 volumio kernel: hdmitx: video: Sink is HDMI device Mar 18 18:09:59 volumio kernel: hdmitx: hw: set audio Mar 18 18:09:59 volumio kernel: hdmitx: hw: hdmitx tx_aud_src = 0 Mar 18 18:09:59 volumio kernel: hdmitx: fs = 0, cd = 4, tmds_clk = 74250 Mar 18 18:09:59 volumio kernel: hdmitx: hw: aud_n_para = 6144 Mar 18 18:09:59 volumio kernel: hdmitx: hw: set channel status Mar 18 18:09:59 volumio kernel: vout: init mode custombuilt set ok Mar 18 18:09:59 volumio kernel: vout: aml_tvout_mode_monitor Mar 18 18:09:59 volumio kernel: vout: aml_vout_probe OK Mar 18 18:09:59 volumio kernel: chip type:0x29 Mar 18 18:09:59 volumio kernel: MEMORY:[0+78000000] Mar 18 18:09:59 volumio kernel: ramdump_probe, storage device:data Mar 18 18:09:59 volumio kernel: NO valid ramdump args:0 0 Mar 18 18:09:59 volumio kernel: ramdump_probe, set sticky to 8780 Mar 18 18:09:59 volumio kernel: Advanced Linux Sound Architecture Driver Initialized. Mar 18 18:09:59 volumio kernel: NetLabel: Initializing Mar 18 18:09:59 volumio kernel: NetLabel: domain hash size = 128 Mar 18 18:09:59 volumio kernel: NetLabel: protocols = UNLABELED CIPSOv4 Mar 18 18:09:59 volumio kernel: NetLabel: unlabeled traffic allowed by default Mar 18 18:09:59 volumio kernel: clocksource: Switched to clocksource arch_sys_counter Mar 18 18:09:59 volumio kernel: VFS: Disk quotas dquot_6.6.0 Mar 18 18:09:59 volumio kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Mar 18 18:09:59 volumio kernel: NET: Registered protocol family 2 Mar 18 18:09:59 volumio kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes) Mar 18 18:09:59 volumio kernel: TCP bind hash table entries: 16384 (order: 6, 262144 bytes) Mar 18 18:09:59 volumio kernel: TCP: Hash tables configured (established 16384 bind 16384) Mar 18 18:09:59 volumio kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes) Mar 18 18:09:59 volumio kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes) Mar 18 18:09:59 volumio kernel: NET: Registered protocol family 1 Mar 18 18:09:59 volumio kernel: PCI: CLS 0 bytes, default 64 Mar 18 18:09:59 volumio kernel: Unpacking initramfs... Mar 18 18:09:59 volumio kernel: Freeing initrd memory: 3596K Mar 18 18:09:59 volumio kernel: hw perfevents: clusterb_enabled = 1 Mar 18 18:09:59 volumio kernel: hw perfevents: cpumasks 0x3, 0x3c Mar 18 18:09:59 volumio kernel: hw perfevents: cluster A irq = 18 Mar 18 18:09:59 volumio kernel: hw perfevents: cluster B irq = 19 Mar 18 18:09:59 volumio kernel: hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available Mar 18 18:09:59 volumio kernel: audit: initializing netlink subsys (disabled) Mar 18 18:09:59 volumio kernel: audit: type=2000 audit(0.672:1): initialized Mar 18 18:09:59 volumio kernel: workingset: timestamp_bits=46 max_order=19 bucket_order=0 Mar 18 18:09:59 volumio kernel: Registering sdcardfs 0.1 Mar 18 18:09:59 volumio kernel: SELinux: Registering netfilter hooks Mar 18 18:09:59 volumio kernel: NET: Registered protocol family 38 Mar 18 18:09:59 volumio kernel: Key type asymmetric registered Mar 18 18:09:59 volumio kernel: Asymmetric key parser 'x509' registered Mar 18 18:09:59 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) Mar 18 18:09:59 volumio kernel: io scheduler noop registered (default) Mar 18 18:09:59 volumio kernel: io scheduler deadline registered Mar 18 18:09:59 volumio kernel: io scheduler cfq registered Mar 18 18:09:59 volumio kernel: pwm-gpio pwmgpio: 1 gpio pwms loaded Mar 18 18:09:59 volumio kernel: meson-pwm ff802000.pwm: pwm pinmux : can't get pinctrl Mar 18 18:09:59 volumio kernel: meson-pwm ffd1b000.pwm: pwm pinmux : can't get pinctrl Mar 18 18:09:59 volumio kernel: random: fast init done Mar 18 18:09:59 volumio kernel: random: crng init done Mar 18 18:09:59 volumio kernel: gpiomem-aml ff634000.gpiomem: Initialised: GPIO register area is 1 Mar 18 18:09:59 volumio kernel: gpiomem-aml ff634000.gpiomem: Initialised: Registers at start:0xff634000 end:0xff634fff size:0x00000fff Mar 18 18:09:59 volumio kernel: [drm] Initialized Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: Continuing without Mali regulator control Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: max pp is 2 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: set min pp to default 1 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: min pp is 1 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: min clk is 4 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: hiu io source 0xffffff80083c1000 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: hiu io source 0xffffff80083c3000 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: num of pp used most of time 1 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: clock dvfs cfg table size is 6 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: max clk set 4 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: max clk is 4 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: turbo clk set to 5 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: turbo clk is 5 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: default clk set to 4 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: default clk is 4 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: ====================0==================== clk_freq= 285714285, clk_parent=fclk_div7, voltage=1150, keep_count=5, threshod=<100 190>, clk_sample=285 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: ====================1==================== clk_freq= 400000000, clk_parent=fclk_div5, voltage=1150, keep_count=5, threshod=<152 207>, clk_sample=400 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: ====================2==================== clk_freq= 500000000, clk_parent=fclk_div4, voltage=1150, keep_count=5, threshod=<180 220>, clk_sample=500 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: ====================3==================== clk_freq= 666666666, clk_parent=fclk_div3, voltage=1150, keep_count=5, threshod=<210 236>, clk_sample=666 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: ====================4==================== clk_freq= 800000000, clk_parent=fclk_div2p5, voltage=1150, keep_count=5, threshod=<230 255>, clk_sample=800 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: ====================5==================== clk_freq= 800000000, clk_parent=fclk_div2p5, voltage=1150, keep_count=5, threshod=<230 255>, clk_sample=800 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: clock dvfs table size is 6 Mar 18 18:09:59 volumio kernel: mali_plat=ffffff800a6b0a58 Mar 18 18:09:59 volumio kernel: meson_gcooldev is null, no set min status Mar 18 18:09:59 volumio kernel: gpu cooling register okay with err=0 Mar 18 18:09:59 volumio kernel: meson_gcooldev is null, no set min status Mar 18 18:09:59 volumio kernel: gpu core cooling register okay with err=0 Mar 18 18:09:59 volumio kernel: shader_present=3, tiler_present=1, l2_present=1 Mar 18 18:09:59 volumio kernel: Mali_pwr_on:gpu_irq : 200 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: GPU identified as 0x2 arch 7.2.1 r0p0 status 0 Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: Using coherency mode 0 set from dtb Mar 18 18:09:59 volumio kernel: mali ffe40000.bifrost: Probed as mali0 Mar 18 18:09:59 volumio kernel: Unable to detect cache hierarchy for CPU 0 Mar 18 18:09:59 volumio kernel: loop: module loaded Mar 18 18:09:59 volumio kernel: mtdoops: mtd device (mtddev=name/number) must be supplied Mar 18 18:09:59 volumio kernel: libphy: Fixed MDIO Bus: probed Mar 18 18:09:59 volumio kernel: REG0:Addr = ffffff80083c7540 Mar 18 18:09:59 volumio kernel: ee eth reset:Addr = ffffff80083c9008 Mar 18 18:09:59 volumio kernel: read auto_cali_idx fail Mar 18 18:09:59 volumio kernel: Not set cali_val for REG1 Mar 18 18:09:59 volumio kernel: meson6-dwmac ff3f0000.ethernet: no reset control found Mar 18 18:09:59 volumio kernel: stmmac - user ID: 0x11, Synopsys ID: 0x37 Mar 18 18:09:59 volumio kernel: Ring mode enabled Mar 18 18:09:59 volumio kernel: DMA HW capability register supported Mar 18 18:09:59 volumio kernel: Normal descriptors Mar 18 18:09:59 volumio kernel: RX Checksum Offload Engine supported Mar 18 18:09:59 volumio kernel: COE Type 2 Mar 18 18:09:59 volumio kernel: TX Checksum insertion supported Mar 18 18:09:59 volumio kernel: Wake-Up On Lan supported Mar 18 18:09:59 volumio kernel: eth%d: device MAC address 00:1e:06:42:58:18 Mar 18 18:09:59 volumio kernel: Enable RX Mitigation via HW Watchdog Timer Mar 18 18:09:59 volumio kernel: libphy: stmmac: probed Mar 18 18:09:59 volumio kernel: eth%d: PHY ID 001cc916 at 0 IRQ POLL (stmmac-0:00) active Mar 18 18:09:59 volumio kernel: eth%d: PHY ID 001cc916 at 7 IRQ POLL (stmmac-0:07) Mar 18 18:09:59 volumio kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Mar 18 18:09:59 volumio kernel: ehci-pci: EHCI PCI platform driver Mar 18 18:09:59 volumio kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Mar 18 18:09:59 volumio kernel: usbcore: registered new interface driver cdc_acm Mar 18 18:09:59 volumio kernel: cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters Mar 18 18:09:59 volumio kernel: usbcore: registered new interface driver usb-storage Mar 18 18:09:59 volumio kernel: usbcore: registered new interface driver usbserial Mar 18 18:09:59 volumio kernel: usbcore: registered new interface driver usbserial_generic Mar 18 18:09:59 volumio kernel: usbserial: USB Serial support registered for generic Mar 18 18:09:59 volumio kernel: mousedev: PS/2 mouse device common for all mice Mar 18 18:09:59 volumio kernel: i2c /dev entries driver Mar 18 18:09:59 volumio kernel: lirc_helper: wakeupkey 0xffffffff, protocol 0x1 Mar 18 18:09:59 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Mar 18 18:09:59 volumio kernel: hidraw: raw HID events driver (C) Jiri Kosina Mar 18 18:09:59 volumio kernel: usbcore: registered new interface driver usbhid Mar 18 18:09:59 volumio kernel: usbhid: USB HID core driver Mar 18 18:09:59 volumio kernel: meson_cpufreq_init: ignor dsu clk! Mar 18 18:09:59 volumio kernel: meson_cpufreq_init: ignor dsu pre parent clk! Mar 18 18:09:59 volumio kernel: value of voltage_tolerance 0 Mar 18 18:09:59 volumio kernel: meson_cpufreq_init:don't find the node Mar 18 18:09:59 volumio kernel: value of gp1_clk_target 0 Mar 18 18:09:59 volumio kernel: dvfs [meson_cpufreq_init] - cluster 0 freq 2016000 Mar 18 18:09:59 volumio kernel: cpu cpu0: meson_cpufreq_init: CPU 0 initialized Mar 18 18:09:59 volumio kernel: meson_cpufreq_init: ignor dsu clk! Mar 18 18:09:59 volumio kernel: meson_cpufreq_init: ignor dsu pre parent clk! Mar 18 18:09:59 volumio kernel: value of voltage_tolerance 0 Mar 18 18:09:59 volumio kernel: meson_cpufreq_init:don't find the node Mar 18 18:09:59 volumio kernel: value of gp1_clk_target 0 Mar 18 18:09:59 volumio kernel: dvfs [meson_cpufreq_init] - cluster 1 freq 2304000 Mar 18 18:09:59 volumio kernel: dvfs [meson_cpufreq_init] - cluster 1 freq 2400000 Mar 18 18:09:59 volumio kernel: cpu cpu2: meson_cpufreq_init: CPU 2 initialized Mar 18 18:09:59 volumio kernel: cpufreq: cpufreq_online: CPU2: Running at unlisted freq: 999999 KHz Mar 18 18:09:59 volumio kernel: cpufreq: cpufreq_online: CPU2: Unlisted initial frequency changed to: 1000000 KHz Mar 18 18:09:59 volumio kernel: ff803000.serial: clock gate not found Mar 18 18:09:59 volumio kernel: meson_uart ff803000.serial: ==uart0 reg addr = ffffff80083e1000 Mar 18 18:09:59 volumio kernel: ff803000.serial: ttyS0 at MMIO 0xff803000 (irq = 31, base_baud = 1500000) is a meson_uart Mar 18 18:09:59 volumio kernel: meson_uart ff803000.serial: ttyS0 use xtal(24M) 24000000 change 0 to 115200 Mar 18 18:09:59 volumio kernel: console [ttyS0] enabled Mar 18 18:09:59 volumio kernel: amlogic-new-usb2-v2 ffe09000.usb2phy: USB2 phy probe:phy_mem:0xffe09000, iomap phy_base:0xffffff80083e3000 Mar 18 18:09:59 volumio kernel: amlogic-new-usb3-v2 ffe09080.usb3phy: USB3 phy probe:phy_mem:0xffe09080, iomap phy_base:0xffffff80083ef080 Mar 18 18:09:59 volumio kernel: aml_dma ff63e000.aml_dma: Aml dma Mar 18 18:09:59 volumio kernel: aml_aes_dma ff63e000.aml_dma:aml_aes: Aml AES_dma Mar 18 18:09:59 volumio kernel: aml_tdes_dma ff63e000.aml_dma:aml_tdes: Aml TDES_dma Mar 18 18:09:59 volumio kernel: aml_sha_dma ff63e000.aml_dma:aml_sha: Aml SHA1/SHA224/SHA256 dma Mar 18 18:09:59 volumio kernel: gpio-keypad: probe of ff800000.gpio_keypad failed with error -22 Mar 18 18:09:59 volumio kernel: efusekeynum: 1 Mar 18 18:09:59 volumio kernel: efusekeyname: uuid offset: 0 size: 32 Mar 18 18:09:59 volumio kernel: efuse efuse: probe OK! Mar 18 18:09:59 volumio kernel: ion_dev soc:ion_dev: assigned reserved memory node linux,ion-dev Mar 18 18:09:59 volumio kernel: ge2d: ge2d_init_module Mar 18 18:09:59 volumio kernel: ge2d: ge2d_dev major:236 Mar 18 18:09:59 volumio kernel: ge2d: clock source clk_ge2d_gate ffffffc056b2a9c0 Mar 18 18:09:59 volumio kernel: ge2d: clock clk_ge2d source ffffffc056b2a0c0 Mar 18 18:09:59 volumio kernel: ge2d: clock source clk_vapb_0 ffffffc056b2aa00 Mar 18 18:09:59 volumio kernel: ge2d: ge2d init clock is 500000000 HZ, VPU clock is 666666656 HZ Mar 18 18:09:59 volumio kernel: ge2d: ge2d clock is 499 MHZ Mar 18 18:09:59 volumio kernel: ge2d: find address resource Mar 18 18:09:59 volumio kernel: ge2d: map io source 0x00000000ff940000,size=65536 to 0xffffff8008590000 Mar 18 18:09:59 volumio kernel: ge2d: reserved mem init failed Mar 18 18:09:59 volumio kernel: ge2d: ge2d: pdev=ffffffc056e45400, irq=44, clk=ffffffc056b2a9c0 Mar 18 18:09:59 volumio kernel: ge2d: ge2d start monitor Mar 18 18:09:59 volumio kernel: ge2d: ge2d workqueue monitor start Mar 18 18:09:59 volumio kernel: [tsync_pcr_init]init success. Mar 18 18:09:59 volumio kernel: amvideom vsync irq: 45 Mar 18 18:09:59 volumio kernel: create_ge2d_work_queue video task ok Mar 18 18:09:59 volumio kernel: fb: osd_init_module Mar 18 18:09:59 volumio kernel: fb: viu vsync irq: 45 Mar 18 18:09:59 volumio kernel: fb: viu2 vsync irq: 54 Mar 18 18:09:59 volumio kernel: 0x000000db:Y=db,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000dc:Y=dc,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000dd:Y=dd,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000de:Y=de,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000df:Y=df,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000e0:Y=e0,U=0,V=0 Mar 18 18:09:59 volumio kernel: fb: osd_rdma_init: rdma_table p=0x59e08000,op=0x59e08000 , v=0xffffff80083f9000 Mar 18 18:09:59 volumio kernel: rdma_register, rdma_table_addr ffffff80083fb000 rdma_table_addr_phy 59e09000 reg_buf ffffffc056fb0000 Mar 18 18:09:59 volumio kernel: rdma_register success, handle 2 table_size 4096 Mar 18 18:09:59 volumio kernel: fb: osd_rdma_init:osd rdma handle = 2. Mar 18 18:09:59 volumio kernel: fb: mem_size: 0x800000 Mar 18 18:09:59 volumio kernel: fb: mem_size: 0x4b80000 Mar 18 18:09:59 volumio kernel: fb: mem_size: 0x100000 Mar 18 18:09:59 volumio kernel: fb: mem_size: 0x100000 Mar 18 18:09:59 volumio kernel: fb: mem_size: 0x800000 Mar 18 18:09:59 volumio kernel: fb: failed to init reserved memory Mar 18 18:09:59 volumio kernel: fb: fb def : 1920 540 1920 1080 32 Mar 18 18:09:59 volumio kernel: fb: init fbdev bpp is:32 Mar 18 18:09:59 volumio kernel: fb: malloc_osd_memory, cma:ffffff800a899ad8 Mar 18 18:09:59 volumio kernel: fb: malloc_osd_memory, 1236, base:0x0000000059c00000, size:8388608 Mar 18 18:09:59 volumio kernel: fb: use ion buffer for fb memory, fb_index=0 Mar 18 18:09:59 volumio kernel: fb: OSD0 as afbcd mode,afbc_type=2 Mar 18 18:09:59 volumio kernel: meson-fb meson-fb: create ion_client ffffffc04a7b6e40, handle=ffffffc056ccf3c0 Mar 18 18:09:59 volumio kernel: meson-fb meson-fb: ion memory(0): created fb at 0x0000000070000000, size 75 MiB Mar 18 18:09:59 volumio kernel: fb: 0, phy: 0x0000000070000000, vir:0xffffff800a947000, size=77312K Mar 18 18:09:59 volumio kernel: fb: Frame buffer memory assigned at Mar 18 18:09:59 volumio kernel: fb: 0, phy: 0x0000000070000000, vir:0xffffff800a947000, size=77312K Mar 18 18:09:59 volumio kernel: fb: 0, phy: 0x0000000070000000, vir:0xffffff800a947000, size=77312K Mar 18 18:09:59 volumio kernel: fb: logo_index=0,fb_index=0 Mar 18 18:09:59 volumio kernel: fb: ---------------clear fb0 memory ffffff800a947000 Mar 18 18:09:59 volumio kernel: fb: osd[0] canvas.idx =0x40 Mar 18 18:09:59 volumio kernel: fb: osd[0] canvas.addr=0x70000000 Mar 18 18:09:59 volumio kernel: fb: osd[0] canvas.width=7680 Mar 18 18:09:59 volumio kernel: fb: osd[0] canvas.height=540 Mar 18 18:09:59 volumio kernel: fb: osd[0] frame.width=1920 Mar 18 18:09:59 volumio kernel: fb: osd[0] frame.height=540 Mar 18 18:09:59 volumio kernel: fb: osd[0] out_addr_id =0x1 Mar 18 18:09:59 volumio kernel: fb: outputmode changed to custombuilt, reset osd0, (0, 0, 639, 479) -> (0, 0, 1919, 539) Mar 18 18:09:59 volumio kernel: fb: osd_update_disp_axis_hw:pan_data(0,0,0,0) Mar 18 18:09:59 volumio kernel: fb: osd_update_disp_axis_hw:dispdata(0,0,1919,539) Mar 18 18:09:59 volumio kernel: clear:53400000, free:53400000, tick:301792 us Mar 18 18:09:59 volumio kernel: fb: osd[0] enable: 1 (swapper/0) Mar 18 18:09:59 volumio kernel: Console: switching to colour frame buffer device 240x33 Mar 18 18:09:59 volumio kernel: fb: osd[0] enable: 1 (swapper/0) Mar 18 18:09:59 volumio kernel: hdmitx: system: plugin Mar 18 18:09:59 volumio kernel: fb: set osd0 reverse as NONE Mar 18 18:09:59 volumio kernel: fb: osd probe OK Mar 18 18:09:59 volumio kernel: hdmitx: hdcp: hdmitx_hdcp_init Mar 18 18:09:59 volumio kernel: vout: vout2: create vout2 attribute OK Mar 18 18:09:59 volumio kernel: vout: vout2: vout2_fops_create OK Mar 18 18:09:59 volumio kernel: vout: vout2: clktree_init Mar 18 18:09:59 volumio kernel: vout: vout2: register server: nulldisp_vout2_server Mar 18 18:09:59 volumio kernel: vout: vout2: init mode null set ok Mar 18 18:09:59 volumio kernel: vout: vout2: aml_vout2_probe OK Mar 18 18:09:59 volumio kernel: DI: di_module_init ok. Mar 18 18:09:59 volumio kernel: DI: di_probe: Mar 18 18:09:59 volumio kernel: DI: di_probe: major 510 Mar 18 18:09:59 volumio kernel: deinterlace deinterlace: assigned reserved memory node linux,di_cma Mar 18 18:09:59 volumio kernel: di:flag_cma=1 Mar 18 18:09:59 volumio kernel: DI: CMA size 0x2800000. Mar 18 18:09:59 volumio kernel: pre_irq:68 Mar 18 18:09:59 volumio kernel: post_irq:69 Mar 18 18:09:59 volumio kernel: DI: di_probe allocate rdma channel 0. Mar 18 18:09:59 volumio kernel: di_get_vpu_clkb: get clk vpu error. Mar 18 18:09:59 volumio kernel: DI: vpu clkb <334000000, 667000000> Mar 18 18:09:59 volumio kernel: get clkb rate:333333328 Mar 18 18:09:59 volumio kernel: DI:enable vpu clkb. Mar 18 18:09:59 volumio kernel: 0x000000e1:Y=e1,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000e2:Y=e2,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000e3:Y=e3,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000f0:Y=f0,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000f1:Y=f1,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000f2:Y=f2,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000f3:Y=f3,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000f4:Y=f4,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000f5:Y=f5,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000f6:Y=f6,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000f7:Y=f7,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000f8:Y=f8,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000f9:Y=f9,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000fa:Y=fa,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000fb:Y=fb,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000fc:Y=fc,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000fd:Y=fd,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000fe:Y=fe,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x000000ff:Y=ff,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x0000003a:Y=3a,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x0000003b:Y=3b,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x0000003c:Y=3c,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x0000003d:Y=3d,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x0000003e:Y=3e,U=0,V=0 Mar 18 18:09:59 volumio kernel: 0x0000003f:Y=3f,U=0,V=0 Mar 18 18:09:59 volumio kernel: DI: support multi decoding 61~62~63. Mar 18 18:09:59 volumio kernel: DI: di_probe:Di use HRTIMER Mar 18 18:09:59 volumio kernel: DI: di_probe:ok Mar 18 18:09:59 volumio kernel: dim:dim_module_init Mar 18 18:09:59 volumio kernel: dim:dim_module_init finish Mar 18 18:09:59 volumio kernel: dil:dil_init. Mar 18 18:09:59 volumio kernel: dil:dil_init ok. Mar 18 18:09:59 volumio kernel: vdin_drv_init: major 509 Mar 18 18:09:59 volumio kernel: vdin_drv_init: vdin driver init done Mar 18 18:09:59 volumio kernel: [viuin..]viuin_init_module viuin module init Mar 18 18:09:59 volumio kernel: [viuin..]viuin_probe probe ok. Mar 18 18:09:59 volumio kernel: [RX]-hdmirx: hdmirx_init. Mar 18 18:09:59 volumio kernel: ESM HLD: Initializing... Mar 18 18:09:59 volumio kernel: amlvid:info: amlvideo_init called Mar 18 18:09:59 volumio kernel: amlvid:info: amlvideo_create_instance called Mar 18 18:09:59 volumio kernel: amlvid:info: v4l2_dev.name=:amlvideo-000 Mar 18 18:09:59 volumio kernel: amlvideo-000: V4L2 device registered as video10 Mar 18 18:09:59 volumio kernel: amlvid:info: amlvideo_create_instance called Mar 18 18:09:59 volumio kernel: amlvid:info: v4l2_dev.name=:amlvideo-001 Mar 18 18:09:59 volumio kernel: amlvideo-001: V4L2 device registered as video23 Mar 18 18:09:59 volumio kernel: PPMGRDRV: warn: ppmgr module init func called Mar 18 18:09:59 volumio kernel: PPMGRDRV: info: ppmgr_driver_probe called Mar 18 18:09:59 volumio kernel: Reserved memory: failed to init DMA memory pool at 0x000000006d800000, size 0 MiB Mar 18 18:09:59 volumio kernel: PPMGRDRV: info: ppmgr_dev major:507 Mar 18 18:09:59 volumio kernel: ionvideo-000: V4L2 device registered as video13 Mar 18 18:09:59 volumio kernel: ionvideo-001: V4L2 device registered as video14 Mar 18 18:09:59 volumio kernel: ionvideo-002: V4L2 device registered as video15 Mar 18 18:09:59 volumio kernel: ionvideo-003: V4L2 device registered as video16 Mar 18 18:09:59 volumio kernel: ionvideo-004: V4L2 device registered as video17 Mar 18 18:09:59 volumio kernel: ionvideo-005: V4L2 device registered as video18 Mar 18 18:09:59 volumio kernel: ionvideo-006: V4L2 device registered as video19 Mar 18 18:09:59 volumio kernel: ionvideo-007: V4L2 device registered as video20 Mar 18 18:09:59 volumio kernel: ionvideo-008: V4L2 device registered as video21 Mar 18 18:09:59 volumio kernel: ionvid: info: Video Technology Magazine Ion Video Mar 18 18:09:59 volumio kernel: ionvid: info: Capture Board ver 1.0 successfully loaded Mar 18 18:09:59 volumio kernel: videosync_create_instance dev_s ffffffc021054000,dev_s->dev ffffffc04a636480 Mar 18 18:09:59 volumio kernel: videosync_create_instance reg videosync.0 Mar 18 18:09:59 volumio kernel: aml_vecm_init:module init Mar 18 18:09:59 volumio kernel: VECM probe start Mar 18 18:09:59 volumio kernel: videosync_thread started Mar 18 18:09:59 volumio kernel: Can't find detect_colorbar. Mar 18 18:09:59 volumio kernel: Can't find detect_face. Mar 18 18:09:59 volumio kernel: Can't find detect_corn. Mar 18 18:09:59 volumio kernel: Can't find wb_sel. Mar 18 18:09:59 volumio kernel: hdr:Can't find cfg_en_osd_100. Mar 18 18:09:59 volumio kernel: Can't find tx_op_color_primary. Mar 18 18:09:59 volumio kernel: amlogic, vecm Mar 18 18:09:59 volumio kernel: vlock dt support: 1 Mar 18 18:09:59 volumio kernel: vlock dt new_fsm: 0 Mar 18 18:09:59 volumio kernel: vlock dt hwver: 0 Mar 18 18:09:59 volumio kernel: vlock dt phlock_en: 0 Mar 18 18:09:59 volumio kernel: Can't find vlock_en. Mar 18 18:09:59 volumio kernel: Can't find vlock_mode. Mar 18 18:09:59 volumio kernel: Can't find vlock_pll_m_limit. Mar 18 18:09:59 volumio kernel: Can't find vlock_line_limit. Mar 18 18:09:59 volumio kernel: param_config vlock_en:1 md=0x4 Mar 18 18:09:59 volumio kernel: vlock: maxLine 524,maxPixel 1715 Mar 18 18:09:59 volumio kernel: vlock_status_init vlock_en:1 Mar 18 18:09:59 volumio kernel: aml_vecm_probe: ok Mar 18 18:09:59 volumio kernel: amdolby_vision_init:module init Mar 18 18:09:59 volumio kernel: amdolby_vision probe start & ver: 20181220 Mar 18 18:09:59 volumio kernel: cpu_id=2 tvmode=0 Mar 18 18:09:59 volumio kernel: dolby_vision_init_receiver(dvel) Mar 18 18:09:59 volumio kernel: dolby_vision_init_receiver: dvel Mar 18 18:09:59 volumio kernel: amdolby_vision_probe: ok Mar 18 18:09:59 volumio kernel: dovi disable in uboot Mar 18 18:09:59 volumio kernel: reg base = ffffff8008589000 Mar 18 18:09:59 volumio kernel: meson-mmc: mmc driver version: 3.02, 2017-05-15: New Emmc Host Controller Mar 18 18:09:59 volumio kernel: meson-mmc: >>>>>>>>hostbase ffffff80085a3000, dmode Mar 18 18:09:59 volumio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Mar 18 18:09:59 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx_set_drm_pkt: tf=1, cf=1, colormetry=0 Mar 18 18:09:59 volumio kernel: meson-mmc: meson_mmc_probe() : success! Mar 18 18:09:59 volumio kernel: meson-mmc: >>>>>>>>hostbase ffffff80085ac000, dmode Mar 18 18:09:59 volumio kernel: meson-mmc: gpio_cd = 1ca Mar 18 18:09:59 volumio kernel: meson-mmc: emmc: resp_timeout,vstat:0x9dbf0800,virqc:3fff Mar 18 18:09:59 volumio kernel: meson-mmc: emmc: err: wait for desc write back, bus_fsm:0x7 Mar 18 18:09:59 volumio kernel: meson-mmc: meson_mmc_irq_thread_v3() 653: set 1st retry! Mar 18 18:09:59 volumio kernel: meson-mmc: retry cmd 1 the 3-th time(s) Mar 18 18:09:59 volumio kernel: meson-mmc: emmc: resp_timeout,vstat:0x9dbf0800,virqc:3fff Mar 18 18:09:59 volumio kernel: meson-mmc: emmc: err: wait for desc write back, bus_fsm:0x7 Mar 18 18:09:59 volumio kernel: meson-mmc: retry cmd 1 the 2-th time(s) Mar 18 18:09:59 volumio kernel: meson-mmc: emmc: resp_timeout,vstat:0x9dbf0800,virqc:3fff Mar 18 18:09:59 volumio kernel: meson-mmc: emmc: err: wait for desc write back, bus_fsm:0x7 Mar 18 18:09:59 volumio kernel: meson-mmc: retry cmd 1 the 1-th time(s) Mar 18 18:09:59 volumio kernel: meson-mmc: emmc: resp_timeout,vstat:0x9dbf0800,virqc:3fff Mar 18 18:09:59 volumio kernel: meson-mmc: emmc: err: wait for desc write back, bus_fsm:0x7 Mar 18 18:09:59 volumio kernel: meson-mmc: Command retried failed line:675, cmd:1 Mar 18 18:09:59 volumio kernel: meson-mmc: meson_mmc_probe() : success! Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: cec driver date:2019/10/22: finetune ARB rising time Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: compatible:amlogic, aocec-g12a Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: cecb_ver:0x1 Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: line_reg:0x1 Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: line_bit:0x3 Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: ee_to_ao:0x1 Mar 18 18:09:59 volumio kernel: input: cec_input as /devices/virtual/input/input0 Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: not find 'port_num' Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: using cec:1 Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: no hdmirx regs Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: no hhi regs Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: not find 'output' Mar 18 18:09:59 volumio kernel: irq cnt:2, a:43, b42 Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: wakeup_reason:0x0 Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: cev val1: 0x0;val2: 0x0 Mar 18 18:09:59 volumio kernel: cectx ff80023c.aocec: aml_cec_probe success end Mar 18 18:09:59 volumio kernel: unifykey: storage in base: 0xffffffc005000000 Mar 18 18:09:59 volumio kernel: unifykey: storage out base: 0xffffffc005040000 Mar 18 18:09:59 volumio kernel: unifykey: storage block base: 0xffffffc005080000 Mar 18 18:09:59 volumio kernel: unifykey: probe done! Mar 18 18:09:59 volumio kernel: unifykey: aml_unifykeys_init done! Mar 18 18:09:59 volumio kernel: meson ts init Mar 18 18:09:59 volumio kernel: tsensor id: 0 Mar 18 18:09:59 volumio kernel: r1p1_tsensor_read valid cnt is 0 Mar 18 18:09:59 volumio kernel: tsensor trim info: 0xfa008172! Mar 18 18:09:59 volumio kernel: tsensor hireboot: 0xc0ff2b50 Mar 18 18:09:59 volumio kernel: meson ts init Mar 18 18:09:59 volumio kernel: tsensor id: 1 Mar 18 18:09:59 volumio kernel: r1p1_tsensor_read valid cnt is 0 Mar 18 18:09:59 volumio kernel: tsensor trim info: 0xfa008102! Mar 18 18:09:59 volumio kernel: tsensor hireboot: 0xc0ff2b00 Mar 18 18:09:59 volumio kernel: audio_dsp: [dsp]register dsp to char divece(257) Mar 18 18:09:59 volumio kernel: amaudio: amaudio: driver amaudio init! Mar 18 18:09:59 volumio kernel: amaudio: amaudio_init - amaudio: driver amaudio succuess! Mar 18 18:09:59 volumio kernel: amlkaraoke init success! Mar 18 18:09:59 volumio kernel: sysled: module init Mar 18 18:09:59 volumio kernel: meson_wdt ffd0f0d0.watchdog: start watchdog Mar 18 18:09:59 volumio kernel: meson_wdt ffd0f0d0.watchdog: creat work queue for watch dog Mar 18 18:09:59 volumio kernel: meson_wdt ffd0f0d0.watchdog: AML Watchdog Timer probed done Mar 18 18:09:59 volumio kernel: meson-saradc ff809000.saradc: set delay per tick to <1ms> by default. Mar 18 18:09:59 volumio kernel: meson-saradc ff809000.saradc: set ticks per period to <1> by default. Mar 18 18:09:59 volumio kernel: dmc_monitor_probe Mar 18 18:09:59 volumio kernel: atv_demod: aml_atvdemod_init: OK, atv demod version: V2.15. Mar 18 18:09:59 volumio kernel: defendkey ff630218.defendkey: Reserved memory is not enough! Mar 18 18:09:59 volumio kernel: defendkey: probe of ff630218.defendkey failed with error -22 Mar 18 18:09:59 volumio kernel: usbcore: registered new interface driver snd-usb-audio Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: aml_T9015_audio_codec_probe Mar 18 18:09:59 volumio kernel: T9015 acodec used by auge, tdmout:2 Mar 18 18:09:59 volumio kernel: hdmitx: edid: EDID Parser: Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx: reach vesa idx MAX Mar 18 18:09:59 volumio kernel: [RX]-up_phy_addr = 53 Mar 18 18:09:59 volumio kernel: hdmitx: edid: get dtd0 vic: 4 Mar 18 18:09:59 volumio kernel: hdmitx: hdmitx: get PMT vic: 5 Mar 18 18:09:59 volumio kernel: hdmitx: edid: find IEEEOUT Mar 18 18:09:59 volumio kernel: hdmitx: edid: check sum valid Mar 18 18:09:59 volumio kernel: hdmitx: edid: check sum valid Mar 18 18:09:59 volumio kernel: hdmitx: edid: update rx hdr info 0 at edid parsing Mar 18 18:09:59 volumio kernel: hdmitx: edid: check sum valid Mar 18 18:09:59 volumio kernel: hdmitx: edid: check sum valid Mar 18 18:09:59 volumio kernel: hdmitx: edid: blk0 raw data Mar 18 18:09:59 volumio kernel: hdmitx: edid: 00ffffffffffff0011ee600001010101001c010380502d780a0dc9a057479827 12484c20000001010101010101010101010101010101011d8018711c1620582c 2500c48e2100009e011d80d0721c1620102c2580c48e2100009e000000fc0044 454e4f4e2d41565248440a20000000fd00313d0f440f000a2020202020200130 Mar 18 18:09:59 volumio kernel: hdmitx: edid: blk1 raw data Mar 18 18:09:59 volumio kernel: hdmitx: edid: 02034971588514041302031112101f2006071516010e230f241d251e26380f7f 073d1ec01507505f7e03570603677e034d02005f7e01835f000067030c003500 b82de61146d0007000011d007251d01e206e285500c48e2100001e011d00bc52 d01e20b8285540c48e2100001e0000000000000000000000000000000000005c Mar 18 18:09:59 volumio kernel: hdmitx: system: update physcial size: 800 450 Mar 18 18:09:59 volumio kernel: hdmitx: video: Sink is HDMI device Mar 18 18:09:59 volumio kernel: hdmitx: hw: set audio Mar 18 18:09:59 volumio kernel: hdmitx: hw: hdmitx tx_aud_src = 0 Mar 18 18:09:59 volumio kernel: hdmitx: fs = 0, cd = 4, tmds_clk = 74250 Mar 18 18:09:59 volumio kernel: hdmitx: hw: aud_n_para = 6144 Mar 18 18:09:59 volumio kernel: hdmitx: hw: set channel status Mar 18 18:09:59 volumio kernel: hdmitx: system: get current mode: custombuilt Mar 18 18:09:59 volumio kernel: hdmitx: system: update rx hdr info 0 Mar 18 18:09:59 volumio kernel: hdmitx: system: update physcial size: 800 450 Mar 18 18:09:59 volumio kernel: hdmitx: system: [set_disp_mode_auto] ALREADY init VIC = 116 Mar 18 18:09:59 volumio kernel: hdmitx: system: change to HDMI mode Mar 18 18:09:59 volumio kernel: Error: Driver 'spdif-dit' is already registered, aborting... Mar 18 18:09:59 volumio kernel: asoc debug: aml_audio_controller_probe-130 Mar 18 18:09:59 volumio kernel: aml_tdm_platform_probe, tdm ID = 2, lane_cnt = 4 Mar 18 18:09:59 volumio kernel: TDM id 2 i2s2hdmi:0 Mar 18 18:09:59 volumio kernel: snd_tdm ff642000.audiobus:tdmc: lane_mask_out = 1, lane_oe_mask_out = 0 Mar 18 18:09:59 volumio kernel: snd_tdm ff642000.audiobus:tdmc: neither mclk_pad nor mclk2pad set Mar 18 18:09:59 volumio kernel: snd_tdm ff642000.audiobus:tdmc: aml_tdm_get_pins error! Mar 18 18:09:59 volumio kernel: aml_tdm_platform_probe(), share en = 1 Mar 18 18:09:59 volumio kernel: No channel mask node Channel_Mask Mar 18 18:09:59 volumio kernel: aml_spdif_platform_probe, spdif ID = 0 Mar 18 18:09:59 volumio kernel: SPDIF id 0 asrc_id:0 auto_asrc:0 Mar 18 18:09:59 volumio kernel: spdifout_play_with_zerodata, spdif id:0 enable:0 Mar 18 18:09:59 volumio kernel: spdif_a fifo ctrl, frddr:0 type:3, 32 bits, chmask 0x3, swap 0x10 Mar 18 18:09:59 volumio kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 Mar 18 18:09:59 volumio kernel: hdmitx: audio: aout notify format CT_PCM Mar 18 18:09:59 volumio kernel: hdmitx: hw: set audio Mar 18 18:09:59 volumio kernel: hdmitx: hw: hdmitx tx_aud_src = 0 Mar 18 18:09:59 volumio kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 74250 Mar 18 18:09:59 volumio kernel: hdmitx: hw: aud_n_para = 6144 Mar 18 18:09:59 volumio kernel: hdmitx: hw: set channel status Mar 18 18:09:59 volumio kernel: hdmitx: audio: Audio Type: PCM Mar 18 18:09:59 volumio kernel: hdmitx: audio: set audio param Mar 18 18:09:59 volumio kernel: spdif_a is set to enable Mar 18 18:09:59 volumio kernel: aml_spdif_platform_probe, register soc platform Mar 18 18:09:59 volumio kernel: aml_spdif_platform_probe, spdif ID = 1 Mar 18 18:09:59 volumio kernel: spdifout_play_with_zerodata, spdif id:1 enable:0 Mar 18 18:09:59 volumio kernel: spdif_b fifo ctrl, frddr:0 type:3, 32 bits, chmask 0x3, swap 0x10 Mar 18 18:09:59 volumio kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 Mar 18 18:09:59 volumio kernel: spdif_b is set to enable Mar 18 18:09:59 volumio kernel: aml_spdif_platform_probe, register soc platform Mar 18 18:09:59 volumio kernel: audio-ddr-manager ff642000.audiobus:ddr_manager: 0, irqs toddr 32, frddr 35 Mar 18 18:09:59 volumio kernel: audio-ddr-manager ff642000.audiobus:ddr_manager: 1, irqs toddr 33, frddr 36 Mar 18 18:09:59 volumio kernel: audio-ddr-manager ff642000.audiobus:ddr_manager: 2, irqs toddr 34, frddr 37 Mar 18 18:09:59 volumio kernel: audiolocker_platform_probe Mar 18 18:09:59 volumio kernel: Register vad Mar 18 18:09:59 volumio kernel: meson-mmc: card IN Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: no source widget found for Left DAC Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: Failed to add route Left DAC -> LOLP_SEL_DACL -> Lineout left P switch Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: no source widget found for Left DAC Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: Failed to add route Left DAC -> LOLP_SEL_DACL_INV -> Lineout left P switch Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: no source widget found for Left DAC Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: Failed to add route Left DAC -> LOLN_SEL_DACL_INV -> Lineout left N switch Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: no source widget found for Left DAC Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: Failed to add route Left DAC -> LOLN_SEL_DACL -> Lineout left N switch Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: no source widget found for Right DAC Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: Failed to add route Right DAC -> LORP_SEL_DACR -> Lineout right P switch Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: no source widget found for Right DAC Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: Failed to add route Right DAC -> LORP_SEL_DACR_INV -> Lineout right P switch Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: no source widget found for Right DAC Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: Failed to add route Right DAC -> LORN_SEL_DACR_INV -> Lineout right N switch Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: no source widget found for Right DAC Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: Failed to add route Right DAC -> LORN_SEL_DACR -> Lineout right N switch Mar 18 18:09:59 volumio kernel: aml_dai_spdif_probe Mar 18 18:09:59 volumio kernel: aml_dai_spdif_probe Mar 18 18:09:59 volumio kernel: set normal 512 fs /4 fs Mar 18 18:09:59 volumio kernel: set spdifout clk:6144000, mpll:24576000 Mar 18 18:09:59 volumio kernel: get spdifout clk:6143997, mpll:24575987 Mar 18 18:09:59 volumio kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Mar 18 18:09:59 volumio kernel: aml_spdif_new spdif_b, clk continuous:1 Mar 18 18:09:59 volumio kernel: spdifout_play_with_zerodata_free, spdif id:1 Mar 18 18:09:59 volumio kernel: asoc-aml-card auge_sound: dit-hifi <-> SPDIF-B mapping ok Mar 18 18:09:59 volumio kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 Mar 18 18:09:59 volumio kernel: aml_dai_set_tdm_slot(), txmask(0x3), rxmask(0x3) Mar 18 18:09:59 volumio kernel: lanes_out_cnt(1), lanes_in_cnt(1) Mar 18 18:09:59 volumio kernel: lanes_lb_cnt(0) Mar 18 18:09:59 volumio kernel: slots(2), slot_width(32) Mar 18 18:09:59 volumio kernel: lanes_oe_out_cnt(0), lanes_oe_in_cnt(0) Mar 18 18:09:59 volumio kernel: asoc aml_dai_set_tdm_fmt, 0x4011, ffffffc04a5d9a18, id(2), clksel(2) Mar 18 18:09:59 volumio kernel: master_mode(1), binv(1), finv(1) out_skew(2), in_skew(3) Mar 18 18:09:59 volumio kernel: asoc-aml-card auge_sound: T9015-audio-hifi <-> TDM-C mapping ok Mar 18 18:09:59 volumio kernel: set normal 512 fs /4 fs Mar 18 18:09:59 volumio kernel: set spdifout clk:6144000, mpll:24576000 Mar 18 18:09:59 volumio kernel: get spdifout clk:6143997, mpll:24575987 Mar 18 18:09:59 volumio kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Mar 18 18:09:59 volumio kernel: aml_spdif_new spdif_a, clk continuous:1 Mar 18 18:09:59 volumio kernel: spdifout_play_with_zerodata_free, spdif id:0 Mar 18 18:09:59 volumio kernel: asoc-aml-card auge_sound: dit-hifi <-> SPDIF mapping ok Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: mux Lineout left P switch has no paths Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: mux Lineout left N switch has no paths Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: mux Lineout right P switch has no paths Mar 18 18:09:59 volumio kernel: aml_codec_T9015 ff632000.t9015: ASoC: mux Lineout right N switch has no paths Mar 18 18:09:59 volumio kernel: snd_card_add_kcontrols card:ffffffc04a73f818 Mar 18 18:09:59 volumio kernel: effect_v2 is not init Mar 18 18:09:59 volumio kernel: Not init vad Mar 18 18:09:59 volumio kernel: Failed to add VAD controls Mar 18 18:09:59 volumio kernel: eq/drc v1 function enable Mar 18 18:09:59 volumio kernel: Netfilter messages via NETLINK v0.30. Mar 18 18:09:59 volumio kernel: Initializing XFRM netlink socket Mar 18 18:09:59 volumio kernel: NET: Registered protocol family 17 Mar 18 18:09:59 volumio kernel: Key type dns_resolver registered Mar 18 18:09:59 volumio kernel: Registered swp emulation handler Mar 18 18:09:59 volumio kernel: Registered cp15_barrier emulation handler Mar 18 18:09:59 volumio kernel: Registered setend emulation handler Mar 18 18:09:59 volumio kernel: registered taskstats version 1 Mar 18 18:09:59 volumio kernel: dwc3 ff500000.dwc3: Configuration mismatch. dr_mode forced to host Mar 18 18:09:59 volumio kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Mar 18 18:09:59 volumio kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1 Mar 18 18:09:59 volumio kernel: usb: xhci: determined sg_tablesize: 4294967295 Mar 18 18:09:59 volumio kernel: xhci-hcd xhci-hcd.0.auto: hcc params 0x0228fe6c hci version 0x110 quirks 0x20010010 Mar 18 18:09:59 volumio kernel: xhci-hcd xhci-hcd.0.auto: irq 23, io mem 0xff500000 Mar 18 18:09:59 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Mar 18 18:09:59 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 18 18:09:59 volumio kernel: usb usb1: Product: xHCI Host Controller Mar 18 18:09:59 volumio kernel: usb usb1: Manufacturer: Linux 4.9.230+ xhci-hcd Mar 18 18:09:59 volumio kernel: usb usb1: SerialNumber: xhci-hcd.0.auto Mar 18 18:09:59 volumio kernel: hub 1-0:1.0: USB hub found Mar 18 18:09:59 volumio kernel: hub 1-0:1.0: 2 ports detected Mar 18 18:09:59 volumio kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Mar 18 18:09:59 volumio kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2 Mar 18 18:09:59 volumio kernel: usb: xhci: determined sg_tablesize: 4294967295 Mar 18 18:09:59 volumio kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Mar 18 18:09:59 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003 Mar 18 18:09:59 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Mar 18 18:09:59 volumio kernel: usb usb2: Product: xHCI Host Controller Mar 18 18:09:59 volumio kernel: usb usb2: Manufacturer: Linux 4.9.230+ xhci-hcd Mar 18 18:09:59 volumio kernel: usb usb2: SerialNumber: xhci-hcd.0.auto Mar 18 18:09:59 volumio kernel: hub 2-0:1.0: USB hub found Mar 18 18:09:59 volumio kernel: hub 2-0:1.0: 1 port detected Mar 18 18:09:59 volumio kernel: hctosys: unable to open rtc device (rtc0) Mar 18 18:09:59 volumio kernel: dwc_otg ff400000.dwc2_a: dwc_otg_driver_probe(ffffffc0577c0800) Mar 18 18:09:59 volumio kernel: dwc_otg: usb0: type: 2 speed: 0, config: 0, dma: 0, id: 0, phy: ffe09000, ctrl: 0 Mar 18 18:09:59 volumio kernel: dwc_otg ff400000.dwc2_a: base=0xffffff8008c00000 Mar 18 18:09:59 volumio kernel: dwc_otg ff400000.dwc2_a: dwc_otg_device=0xffffffc04a777800 Mar 18 18:09:59 volumio kernel: meson-mmc: normal card in Mar 18 18:09:59 volumio kernel: dwc_otg: Core Release: 3.30a Mar 18 18:09:59 volumio kernel: dwc_otg: Setting default values for core params Mar 18 18:09:59 volumio kernel: dwc_otg: curmode: 0, host_only: 0 Mar 18 18:09:59 volumio kernel: dwc_otg ff400000.dwc2_a: DMA config: BURST_DEFAULT Mar 18 18:09:59 volumio kernel: dwc_otg: Using Buffer DMA mode Mar 18 18:09:59 volumio kernel: dwc_otg: OTG VER PARAM: 1, OTG VER FLAG: 1 Mar 18 18:09:59 volumio kernel: dwc_otg: Working on port type = SLAVE Mar 18 18:09:59 volumio kernel: dwc_otg: Dedicated Tx FIFOs mode Mar 18 18:09:59 volumio kernel: meson_cdev probe Mar 18 18:09:59 volumio kernel: meson_cdev index: 0 Mar 18 18:09:59 volumio kernel: thermal thermal_zone0: binding zone soc_thermal with cdev thermal-cpufreq-0 failed:-22 Mar 18 18:09:59 volumio kernel: meson_cdev index: 1 Mar 18 18:09:59 volumio kernel: thermal: no cluster id, cpucore as one cooldev Mar 18 18:09:59 volumio kernel: meson_cdev index: 2 Mar 18 18:09:59 volumio kernel: cpucore_cooling_register, max_cpu_core_num:6 Mar 18 18:09:59 volumio kernel: cpucore_cooling_register, clutser[1] core num:4 Mar 18 18:09:59 volumio kernel: cpucore_cooling_register, clutser[0] core num:2 Mar 18 18:09:59 volumio kernel: meson_cdev index: 3 Mar 18 18:09:59 volumio kernel: meson_cdev index: 4 Mar 18 18:09:59 volumio kernel: find tzd id: 0 Mar 18 18:09:59 volumio kernel: find tzd id: 0 Mar 18 18:09:59 volumio kernel: find tzd id: 0 Mar 18 18:09:59 volumio kernel: meson_cdev probe done Mar 18 18:09:59 volumio kernel: gxbb_pm: enter meson_pm_probe! Mar 18 18:09:59 volumio kernel: no vddio3v3_en pin Mar 18 18:09:59 volumio kernel: pm-meson aml_pm: Can't get switch_clk81 Mar 18 18:09:59 volumio kernel: gxbb_pm: meson_pm_probe done Mar 18 18:09:59 volumio kernel: ALSA device list: Mar 18 18:09:59 volumio kernel: #0: AML-AUGESOUND Mar 18 18:09:59 volumio kernel: meson_uart ff803000.serial: ttyS0 use xtal(24M) 24000000 change 115200 to 115200 Mar 18 18:09:59 volumio kernel: Freeing unused kernel memory: 4992K Mar 18 18:09:59 volumio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Mar 18 18:09:59 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c Mar 18 18:09:59 volumio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Mar 18 18:09:59 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c Mar 18 18:09:59 volumio kernel: meson-aml-mmc ffe05000.sd: divider requested rate 200000000 != actual rate 199999997: ret=0 Mar 18 18:09:59 volumio kernel: meson-mmc: actual_clock :199999997, HHI_nand: 0x80 Mar 18 18:09:59 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000245 Mar 18 18:09:59 volumio kernel: meson-mmc: Data 1 aligned delay is 0 Mar 18 18:09:59 volumio kernel: meson-mmc: sd: clk 199999997 tuning start Mar 18 18:09:59 volumio kernel: meson-mmc: sd: adj_win: < 1 2 3 4 > Mar 18 18:09:59 volumio kernel: meson-mmc: step:4, delay1:0x4104104, delay2:0x4004104 Mar 18 18:09:59 volumio kernel: meson-mmc: sd: adj_win: < 1 2 3 4 > Mar 18 18:09:59 volumio kernel: meson-mmc: step:8, delay1:0x8208208, delay2:0x8008208 Mar 18 18:09:59 volumio kernel: meson-mmc: sd: adj_win: < 1 2 3 4 > Mar 18 18:09:59 volumio kernel: meson-mmc: step:12, delay1:0xc30c30c, delay2:0xc00c30c Mar 18 18:09:59 volumio kernel: meson-mmc: sd: adj_win: < 1 2 3 4 > Mar 18 18:09:59 volumio kernel: meson-mmc: step:16, delay1:0x10410410, delay2:0x10010410 Mar 18 18:09:59 volumio kernel: meson-mmc: sd: adj_win: < 0 1 2 3 4 > Mar 18 18:09:59 volumio kernel: meson-mmc: step:20, delay1:0x14514514, delay2:0x14014514 Mar 18 18:09:59 volumio kernel: usb 1-1: new high-speed USB device number 2 using xhci-hcd Mar 18 18:09:59 volumio kernel: meson-mmc: sd: adj_win: < 0 1 2 3 4 > Mar 18 18:09:59 volumio kernel: meson-mmc: step:24, delay1:0x18618618, delay2:0x18018618 Mar 18 18:09:59 volumio kernel: meson-mmc: sd: adj_win: < 0 2 3 4 > Mar 18 18:09:59 volumio kernel: meson-mmc: left:3, right:0, mid:4, size:4 Mar 18 18:09:59 volumio kernel: meson-mmc: step:0, delay1:0x0, delay2:0x0 Mar 18 18:09:59 volumio kernel: meson-mmc: sd: sd_emmc_regs->gclock=0x10000245,sd_emmc_regs->gadjust=0x32000 Mar 18 18:09:59 volumio kernel: meson-mmc: delay1:0x0, delay2:0x0 Mar 18 18:09:59 volumio kernel: sd: new ultra high speed SDR104 SDXC card at address aaaa Mar 18 18:09:59 volumio kernel: sd: clock 199999997, 4-bit-bus-width Mar 18 18:09:59 volumio kernel: mmcblk1: sd:aaaa SN128 119 GiB Mar 18 18:09:59 volumio kernel: mmcblk1: p1 p2 p3 Mar 18 18:09:59 volumio kernel: usb 1-1: New USB device found, idVendor=05e3, idProduct=0610 Mar 18 18:09:59 volumio kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Mar 18 18:09:59 volumio kernel: usb 1-1: Product: USB2.1 Hub Mar 18 18:09:59 volumio kernel: usb 1-1: Manufacturer: GenesysLogic Mar 18 18:09:59 volumio kernel: hub 1-1:1.0: USB hub found Mar 18 18:09:59 volumio kernel: hub 1-1:1.0: 4 ports detected Mar 18 18:09:59 volumio kernel: usb 2-1: new SuperSpeed USB device number 2 using xhci-hcd Mar 18 18:09:59 volumio kernel: usb 2-1: New USB device found, idVendor=05e3, idProduct=0620 Mar 18 18:09:59 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Mar 18 18:09:59 volumio kernel: usb 2-1: Product: USB3.1 Hub Mar 18 18:09:59 volumio kernel: usb 2-1: Manufacturer: GenesysLogic Mar 18 18:09:59 volumio kernel: hub 2-1:1.0: USB hub found Mar 18 18:09:59 volumio kernel: hub 2-1:1.0: 4 ports detected Mar 18 18:09:59 volumio kernel: usb 1-1.1: new low-speed USB device number 3 using xhci-hcd Mar 18 18:09:59 volumio kernel: usb 1-1.1: New USB device found, idVendor=04f2, idProduct=1516 Mar 18 18:09:59 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Mar 18 18:09:59 volumio kernel: usb 1-1.1: Product: USB Keyboard Mar 18 18:09:59 volumio kernel: usb 1-1.1: Manufacturer: Chicony Mar 18 18:09:59 volumio kernel: input: Chicony USB Keyboard as /devices/platform/ff500000.dwc3/xhci-hcd.0.auto/usb1/1-1/1-1.1/1-1.1:1.0/0003:04F2:1516.0001/input/input1 Mar 18 18:09:59 volumio kernel: hid-generic 0003:04F2:1516.0001: input,hidraw0: USB HID v1.11 Keyboard [Chicony USB Keyboard] on usb-xhci-hcd.0.auto-1.1/input0 Mar 18 18:09:59 volumio kernel: input: Chicony USB Keyboard as /devices/platform/ff500000.dwc3/xhci-hcd.0.auto/usb1/1-1/1-1.1/1-1.1:1.1/0003:04F2:1516.0002/input/input2 Mar 18 18:09:59 volumio kernel: hid-generic 0003:04F2:1516.0002: input,hidraw1: USB HID v1.11 Device [Chicony USB Keyboard] on usb-xhci-hcd.0.auto-1.1/input1 Mar 18 18:09:59 volumio kernel: usb 1-1.2: new high-speed USB device number 4 using xhci-hcd Mar 18 18:09:59 volumio kernel: usb 1-1.2: New USB device found, idVendor=04e8, idProduct=1f08 Mar 18 18:09:59 volumio kernel: usb 1-1.2: New USB device strings: Mfr=1, Product=11, SerialNumber=3 Mar 18 18:09:59 volumio kernel: usb 1-1.2: Product: Samsung S2 Portable Mar 18 18:09:59 volumio kernel: usb 1-1.2: Manufacturer: JMicron Mar 18 18:09:59 volumio kernel: usb 1-1.2: SerialNumber: 00000011E09310500617 Mar 18 18:09:59 volumio kernel: usb-storage 1-1.2:1.0: USB Mass Storage device detected Mar 18 18:09:59 volumio kernel: scsi host0: usb-storage 1-1.2:1.0 Mar 18 18:09:59 volumio kernel: scsi 0:0:0:0: Direct-Access Samsung S2 Portable PQ: 0 ANSI: 2 CCS Mar 18 18:09:59 volumio kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Mar 18 18:09:59 volumio kernel: sd 0:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) Mar 18 18:09:59 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off Mar 18 18:09:59 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 3c 00 00 00 Mar 18 18:09:59 volumio kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Mar 18 18:09:59 volumio kernel: sda: sda1 Mar 18 18:09:59 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk Mar 18 18:09:59 volumio initramfs: Booting Volumio for Odroid-N2 Mar 18 18:09:59 volumio initramfs: This script mounts rootfs RO with an overlay RW layer. Mar 18 18:09:59 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 18 18:09:59 volumio kernel: fuse init (API version 7.26) Mar 18 18:09:59 volumio initramfs: IMGPART=/dev/mmcblk1p2 Mar 18 18:09:59 volumio initramfs: IMGFILE=/volumio_current.sqsh Mar 18 18:09:59 volumio initramfs: DATAPART=/dev/mmcblk1p3 Mar 18 18:09:59 volumio initramfs: BOOTPART=/dev/mmcblk1p1 Mar 18 18:09:59 volumio initramfs: BOOTCONFIG=/boot/boot.ini Mar 18 18:09:59 volumio kernel: EXT4-fs (mmcblk1p2): recovery complete Mar 18 18:09:59 volumio kernel: EXT4-fs (mmcblk1p2): mounted filesystem with ordered data mode. Opts: (null) Mar 18 18:09:59 volumio initramfs: Checking for USB updates if you did not boot from USB... Mar 18 18:09:59 volumio kernel: F2FS-fs (sda1): Magic Mismatch, valid(0xf2f52010) - read(0xc0856600) Mar 18 18:09:59 volumio kernel: F2FS-fs (sda1): Can't find valid F2FS filesystem in 1th superblock Mar 18 18:09:59 volumio kernel: F2FS-fs (sda1): Magic Mismatch, valid(0xf2f52010) - read(0x0) Mar 18 18:09:59 volumio kernel: F2FS-fs (sda1): Can't find valid F2FS filesystem in 2th superblock Mar 18 18:09:59 volumio kernel: F2FS-fs (sda1): Magic Mismatch, valid(0xf2f52010) - read(0xc0856600) Mar 18 18:09:59 volumio kernel: F2FS-fs (sda1): Can't find valid F2FS filesystem in 1th superblock Mar 18 18:09:59 volumio kernel: F2FS-fs (sda1): Magic Mismatch, valid(0xf2f52010) - read(0x0) Mar 18 18:09:59 volumio kernel: F2FS-fs (sda1): Can't find valid F2FS filesystem in 2th superblock Mar 18 18:09:59 volumio kernel: EXT4-fs (mmcblk1p3): recovery complete Mar 18 18:09:59 volumio kernel: EXT4-fs (mmcblk1p3): mounted filesystem with ordered data mode. Opts: (null) Mar 18 18:09:59 volumio initramfs: With Option: Mar 18 18:09:59 volumio initramfs: found fstab entry with UUID=DCAA-C703 for /boot Mar 18 18:09:59 volumio initramfs: VOLUMIO_VERSION="2.857" Mar 18 18:09:59 volumio initramfs: Finish initramfs, continue booting Volumio Mar 18 18:09:59 volumio kernel: meson_uart ff803000.serial: ttyS0 use xtal(24M) 24000000 change 115200 to 115200 Mar 18 18:09:59 volumio systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR) Mar 18 18:09:59 volumio systemd[1]: Detected architecture 'arm64'. Mar 18 18:09:59 volumio kernel: NET: Registered protocol family 10 Mar 18 18:09:59 volumio systemd[1]: Inserted module 'ipv6' Mar 18 18:09:59 volumio systemd[1]: Set hostname to . Mar 18 18:09:59 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Mar 18 18:09:59 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Mar 18 18:09:59 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Mar 18 18:09:59 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Mar 18 18:09:59 volumio systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory. Mar 18 18:09:59 volumio systemd[1]: Starting Forward Password Requests to Wall Directory Watch. Mar 18 18:09:59 volumio kernel: Removed cp15_barrier emulation handler Mar 18 18:09:59 volumio kernel: Enabled cp15_barrier support Mar 18 18:09:59 volumio systemd-journal[2100]: Journal started Mar 18 18:09:59 volumio systemd[1]: Starting Slices. Mar 18 18:09:59 volumio systemd[1]: Reached target Slices. Mar 18 18:09:59 volumio systemd[1]: Starting Remount Root and Kernel File Systems... Mar 18 18:09:59 volumio systemd[1]: Started Create list of required static device nodes for the current kernel. Mar 18 18:09:59 volumio systemd[1]: Mounted Debug File System. Mar 18 18:09:59 volumio systemd[1]: Starting Create Static Device Nodes in /dev... Mar 18 18:09:59 volumio systemd[1]: Mounted POSIX Message Queue File System. Mar 18 18:09:59 volumio systemd[1]: Started Load Kernel Modules. Mar 18 18:09:59 volumio systemd[1]: Mounting FUSE Control File System... Mar 18 18:09:59 volumio systemd[1]: Mounting Configuration File System... Mar 18 18:09:59 volumio systemd[1]: Starting Apply Kernel Variables... Mar 18 18:09:59 volumio systemd[1]: Started Apply Kernel Variables. Mar 18 18:09:59 volumio systemd[1]: Started udev Coldplug all Devices. Mar 18 18:09:59 volumio systemd[1]: Time has been changed Mar 18 18:09:59 volumio fake-hwclock[2092]: Thu Mar 18 18:09:59 UTC 2021 Mar 18 18:09:59 volumio systemd[1]: Starting udev Kernel Device Manager... Mar 18 18:09:59 volumio systemd[1]: Started Various fixups to make systemd work better on Debian. Mar 18 18:09:59 volumio systemd[1]: Starting Load/Save Random Seed... Mar 18 18:09:59 volumio systemd[1]: Starting Local File Systems (Pre). Mar 18 18:09:59 volumio systemd[1]: Reached target Local File Systems (Pre). Mar 18 18:09:59 volumio systemd[1]: Mounting /tmp... Mar 18 18:09:59 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Mar 18 18:09:59 volumio systemd[1]: Mounting /var/spool/cups... Mar 18 18:09:59 volumio systemd[1]: Mounting /var/log... Mar 18 18:09:59 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Mar 18 18:09:59 volumio systemd[1]: Started udev Kernel Device Manager. Mar 18 18:09:59 volumio systemd-udevd[2899]: starting version 215 Mar 18 18:09:59 volumio systemd[1]: Mounted /tmp. Mar 18 18:09:59 volumio systemd[1]: Started Show Plymouth Boot Screen. Mar 18 18:09:59 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Mar 18 18:09:59 volumio systemd[1]: Starting Dispatch Password Requests to Console Directory Watch. Mar 18 18:09:59 volumio systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Mar 18 18:09:59 volumio systemd[1]: Starting Paths. Mar 18 18:09:59 volumio systemd[1]: Reached target Paths. Mar 18 18:09:59 volumio systemd[1]: Starting Copy rules generated while the root was ro... Mar 18 18:09:59 volumio systemd[1]: Started Load/Save Random Seed. Mar 18 18:09:59 volumio systemd[1]: Mounted /var/spool/cups. Mar 18 18:09:59 volumio systemd[1]: Mounted /var/log. Mar 18 18:09:59 volumio systemd[1]: Mounting /var/spool/cups/tmp... Mar 18 18:09:59 volumio systemd[1]: Mounted /var/spool/cups/tmp. Mar 18 18:09:59 volumio systemd[1]: Started Copy rules generated while the root was ro. Mar 18 18:09:59 volumio systemd[1]: Starting Sound Card. Mar 18 18:09:59 volumio systemd[1]: Reached target Sound Card. Mar 18 18:09:59 volumio systemd[1]: Found device /dev/ttyS0. Mar 18 18:09:59 volumio kernel: rtc-pcf8563 1-0051: rtc core: registered rtc-pcf8563 as rtc0 Mar 18 18:09:59 volumio kernel: ionvid: dbg: ionvideo open Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close!!!! Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close Mar 18 18:09:59 volumio kernel: ionvid: dbg: ionvideo open Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close!!!! Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close Mar 18 18:09:59 volumio kernel: ionvid: dbg: ionvideo open Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close!!!! Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close Mar 18 18:09:59 volumio kernel: ionvid: dbg: ionvideo open Mar 18 18:09:59 volumio kernel: ionvid: dbg: ionvideo open Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close!!!! Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close!!!! Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close Mar 18 18:09:59 volumio kernel: ionvid: dbg: ionvideo open Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close!!!! Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close Mar 18 18:09:59 volumio kernel: ionvid: dbg: ionvideo open Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close!!!! Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close Mar 18 18:09:59 volumio kernel: ionvid: dbg: ionvideo open Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close!!!! Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close Mar 18 18:09:59 volumio kernel: ionvid: dbg: ionvideo open Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close!!!! Mar 18 18:09:59 volumio kernel: ionvid: dbg: vidioc_close Mar 18 18:09:59 volumio systemd[1]: Starting system-ifup.slice. Mar 18 18:09:59 volumio systemd[1]: Created slice system-ifup.slice. Mar 18 18:09:59 volumio systemd[1]: Found device /dev/disk/by-uuid/DCAA-C703. Mar 18 18:09:59 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/DCAA-C703... Mar 18 18:09:59 volumio kernel: out of value, fixed it Mar 18 18:09:59 volumio kernel: id=0 set inskew=0 Mar 18 18:09:59 volumio kernel: AED req_sel0 module:TDMOUT_B Mar 18 18:09:59 volumio kernel: spk_mute_set: mute flag = 0 Mar 18 18:09:59 volumio systemd-fsck[3007]: fsck.fat 3.0.27 (2014-11-12) Mar 18 18:09:59 volumio systemd-fsck[3007]: /dev/mmcblk1p1: 14 files, 6339/30651 clusters Mar 18 18:09:59 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/DCAA-C703. Mar 18 18:09:59 volumio systemd[1]: Mounting /boot... Mar 18 18:09:59 volumio systemd[1]: Mounted /boot. Mar 18 18:09:59 volumio systemd[1]: Starting Local File Systems. Mar 18 18:09:59 volumio systemd[1]: Reached target Local File Systems. Mar 18 18:09:59 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Mar 18 18:09:59 volumio systemd[1]: Starting Remote File Systems. Mar 18 18:09:59 volumio systemd[1]: Reached target Remote File Systems. Mar 18 18:09:59 volumio systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Mar 18 18:09:59 volumio systemd[1]: Starting Create Volatile Files and Directories... Mar 18 18:09:59 volumio systemd[1]: Starting LSB: Raise network interfaces.... Mar 18 18:09:59 volumio systemd[1]: Started Create Volatile Files and Directories. Mar 18 18:09:59 volumio systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Mar 18 18:09:59 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Mar 18 18:09:59 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Mar 18 18:09:59 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Mar 18 18:09:59 volumio networking[3019]: Configuring network interfaces...command failed: No such device (-19) Mar 18 18:09:59 volumio networking[3019]: command failed: No such device (-19) Mar 18 18:09:59 volumio networking[3019]: done. Mar 18 18:09:59 volumio systemd[1]: Started LSB: Raise network interfaces.. Mar 18 18:09:59 volumio kernel: meson6-dwmac ff3f0000.ethernet eth0: fail to init PTP. Mar 18 18:09:59 volumio systemd[1]: Starting ifup for eth0... Mar 18 18:09:59 volumio systemd[1]: Started ifup for eth0. Mar 18 18:10:00 volumio systemd[1]: Starting Network. Mar 18 18:10:00 volumio systemd[1]: Reached target Network. Mar 18 18:10:00 volumio systemd[1]: Starting Network is Online. Mar 18 18:10:00 volumio systemd[1]: Reached target Network is Online. Mar 18 18:10:00 volumio systemd[1]: Starting LSB: RPC portmapper replacement... Mar 18 18:10:00 volumio ifup[3107]: command failed: No such device (-19) Mar 18 18:10:00 volumio ifup[3107]: dhcpcd[3132]: version 6.0.5 starting Mar 18 18:10:00 volumio dhcpcd[3132]: version 6.0.5 starting Mar 18 18:10:00 volumio ifup[3107]: dhcpcd[3132]: eth0: waiting for carrier Mar 18 18:10:00 volumio dhcpcd[3132]: eth0: waiting for carrier Mar 18 18:10:00 volumio systemd[1]: Started LSB: RPC portmapper replacement. Mar 18 18:10:00 volumio systemd[1]: Starting RPC Port Mapper. Mar 18 18:10:00 volumio systemd[1]: Reached target RPC Port Mapper. Mar 18 18:10:00 volumio systemd[1]: Starting LSB: NFS support files common to client and server... Mar 18 18:10:00 volumio rpcbind[3109]: Starting rpcbind daemon.... Mar 18 18:10:00 volumio rpc.statd[3154]: Version 1.2.8 starting Mar 18 18:10:00 volumio sm-notify[3155]: Version 1.2.8 starting Mar 18 18:10:00 volumio kernel: RPC: Registered named UNIX socket transport module. Mar 18 18:10:00 volumio kernel: RPC: Registered udp transport module. Mar 18 18:10:00 volumio kernel: RPC: Registered tcp transport module. Mar 18 18:10:00 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Mar 18 18:10:00 volumio kernel: FS-Cache: Loaded Mar 18 18:10:00 volumio kernel: FS-Cache: Netfs 'nfs' registered for caching Mar 18 18:10:00 volumio kernel: Installing knfsd (copyright (C) 1996 okir@monad.swb.de). Mar 18 18:10:00 volumio nfs-common[3148]: Starting NFS common utilities: statd idmapd. Mar 18 18:10:00 volumio systemd[1]: Started LSB: NFS support files common to client and server. Mar 18 18:10:00 volumio systemd[1]: Starting System Initialization. Mar 18 18:10:00 volumio systemd[1]: Reached target System Initialization. Mar 18 18:10:00 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket. Mar 18 18:10:00 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Mar 18 18:10:00 volumio systemd[1]: Starting mpd.socket. Mar 18 18:10:00 volumio systemd[1]: Listening on mpd.socket. Mar 18 18:10:00 volumio systemd[1]: Starting D-Bus System Message Bus Socket. Mar 18 18:10:00 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Mar 18 18:10:00 volumio systemd[1]: Starting Sockets. Mar 18 18:10:00 volumio systemd[1]: Reached target Sockets. Mar 18 18:10:00 volumio systemd[1]: Starting Daily Cleanup of Temporary Directories. Mar 18 18:10:00 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Mar 18 18:10:00 volumio systemd[1]: Starting Timers. Mar 18 18:10:00 volumio systemd[1]: Reached target Timers. Mar 18 18:10:00 volumio systemd[1]: Started Manage Sound Card State (restore and store). Mar 18 18:10:00 volumio systemd[1]: Starting Restore Sound Card State... Mar 18 18:10:00 volumio systemd[1]: Starting Basic System. Mar 18 18:10:00 volumio systemd[1]: Reached target Basic System. Mar 18 18:10:00 volumio systemd[1]: Starting Entropy daemon using the HAVEGE algorithm... Mar 18 18:10:00 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Mar 18 18:10:00 volumio systemd[1]: Starting cd.service... Mar 18 18:10:00 volumio systemd[1]: Started cd.service. Mar 18 18:10:00 volumio systemd[1]: Starting Volumio Iptables Module... Mar 18 18:10:00 volumio systemd[1]: Started Volumio Iptables Module. Mar 18 18:10:00 volumio systemd[1]: Starting mount disks automatically with standby... Mar 18 18:10:00 volumio systemd[1]: Started mount disks automatically with standby. Mar 18 18:10:00 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Mar 18 18:10:00 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 18 18:10:00 volumio systemd[1]: Starting volumio-remote-updater.service... Mar 18 18:10:00 volumio systemd[1]: Started volumio-remote-updater.service. Mar 18 18:10:00 volumio systemd[1]: Starting Volumio Log Rotation Service... Mar 18 18:10:00 volumio systemd[1]: Started Volumio Log Rotation Service. Mar 18 18:10:00 volumio volumio[3191]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Mar 18 18:10:00 volumio systemd[1]: Starting Volumio SSH enabler... Mar 18 18:10:00 volumio systemd[1]: Started Volumio SSH enabler. Mar 18 18:10:00 volumio systemd[1]: Starting Wireless Services... Mar 18 18:10:00 volumio alsactl[3189]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Mar 18 18:10:00 volumio alsactl[3189]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Mar 18 18:10:00 volumio alsactl[3189]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Mar 18 18:10:00 volumio kernel: out of value, fixed it Mar 18 18:10:00 volumio kernel: id=0 set inskew=0 Mar 18 18:10:00 volumio kernel: AED req_sel0 module:TDMOUT_B Mar 18 18:10:00 volumio kernel: spk_mute_set: mute flag = 0 Mar 18 18:10:00 volumio systemd[1]: Starting OpenBSD Secure Shell server... Mar 18 18:10:00 volumio systemd[1]: Starting /etc/rc.local Compatibility... Mar 18 18:10:00 volumio systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available. Mar 18 18:10:00 volumio systemd[1]: Starting Login Service... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: start Winbind daemon... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: triggerhappy hotkey daemon... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: start Samba daemons for the AD DC... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: Start NTP daemon... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: start Samba NetBIOS nameserver (nmbd)... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: Starts LIRC daemon.... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support... Mar 18 18:10:00 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Mar 18 18:10:00 volumio systemd[1]: Starting Music Player Daemon... Mar 18 18:10:00 volumio systemd[1]: Starting D-Bus System Message Bus... Mar 18 18:10:00 volumio systemd[1]: Started D-Bus System Message Bus. Mar 18 18:10:00 volumio kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Mar 18 18:10:00 volumio dhcpcd[3217]: Not running dhcpcd because there is aleady an interface specific instance ... failed! Mar 18 18:10:00 volumio dhcpcd[3217]: /var/run/dhcpcd-eth0.pid ... failed! Mar 18 18:10:00 volumio triggerhappy[3206]: Unable to parse trigger line: Mar 18 18:10:00 volumio triggerhappy[3206]: Unable to parse trigger line: Mar 18 18:10:00 volumio triggerhappy[3206]: Unable to parse trigger line: Mar 18 18:10:00 volumio triggerhappy[3206]: Unable to parse trigger line: Mar 18 18:10:00 volumio triggerhappy[3206]: Unable to parse trigger line: Mar 18 18:10:00 volumio triggerhappy[3206]: Unable to parse trigger line: Mar 18 18:10:00 volumio triggerhappy[3206]: Unable to parse trigger line: Mar 18 18:10:00 volumio kernel: nf_conntrack version 0.5.0 (16384 buckets, 65536 max) Mar 18 18:10:00 volumio ifplugd(eth0)[3302]: ifplugd 0.28 initializing. Mar 18 18:10:00 volumio ifplugd(eth0)[3302]: Using interface eth0/00:1E:06:42:58:18 with driver (version: Jan_2016) Mar 18 18:10:00 volumio ifplugd(eth0)[3302]: Using detection mode: SIOCETHTOOL Mar 18 18:10:00 volumio ifplugd(eth0)[3302]: Initialization complete, link beat not detected. Mar 18 18:10:00 volumio avahi-daemon[3219]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). Mar 18 18:10:00 volumio avahi-daemon[3219]: Successfully dropped root privileges. Mar 18 18:10:00 volumio avahi-daemon[3219]: avahi-daemon 0.6.31 starting up. Mar 18 18:10:00 volumio ntpd[3277]: ntpd 4.2.6p5@1.2349-o Fri Jul 22 17:59:22 UTC 2016 (1) Mar 18 18:10:00 volumio lirc[3213]: Loading LIRC modules:. Mar 18 18:10:00 volumio kernel: Registered IR keymap rc-empty Mar 18 18:10:00 volumio kernel: input: meson-ir as /devices/platform/ff808040.meson-ir/rc/rc0/input3 Mar 18 18:10:00 volumio kernel: rc rc0: meson-ir as /devices/platform/ff808040.meson-ir/rc/rc0 Mar 18 18:10:00 volumio kernel: meson-ir ff808040.meson-ir: AO_RTI_PIN_MUX : 0x100011 Mar 18 18:10:00 volumio kernel: meson-ir ff808040.meson-ir: receiver initialized Mar 18 18:10:00 volumio kernel: lirc_dev: IR Remote Control driver registered, major 501 Mar 18 18:10:00 volumio kernel: rc rc0: lirc_dev: driver ir-lirc-codec (meson-ir) registered at minor = 0 Mar 18 18:10:00 volumio kernel: IR LIRC bridge handler initialized Mar 18 18:10:00 volumio sudo[3209]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Mar 18 18:10:00 volumio ntp[3210]: Starting NTP server: ntpd. Mar 18 18:10:00 volumio ntpd[3351]: proto: precision = 0.250 usec Mar 18 18:10:00 volumio ntpd[3351]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Mar 18 18:10:00 volumio sudo[3209]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:10:00 volumio lircd-0.9.0-pre1[3358]: lircd(default) ready, using /var/run/lirc/lircd Mar 18 18:10:00 volumio kernel: input: lircd as /devices/virtual/input/input4 Mar 18 18:10:00 volumio lirc[3213]: Starting remote control daemon(s) : LIRC :. Mar 18 18:10:00 volumio wifistart.sh[3199]: command failed: No such device (-19) Mar 18 18:10:00 volumio sudo[3209]: pam_unix(sudo:session): session closed for user root Mar 18 18:10:00 volumio ntpd[3351]: Listen and drop on 1 v6wildcard :: UDP 123 Mar 18 18:10:00 volumio ntpd[3351]: Listen normally on 2 lo 127.0.0.1 UDP 123 Mar 18 18:10:00 volumio ntpd[3351]: peers refreshed Mar 18 18:10:00 volumio ntpd[3351]: Listening on routing socket on fd #19 for interface updates Mar 18 18:10:00 volumio avahi-daemon[3219]: Successfully called chroot(). Mar 18 18:10:00 volumio avahi-daemon[3219]: Successfully dropped remaining capabilities. Mar 18 18:10:00 volumio avahi-daemon[3219]: No service file found in /etc/avahi/services. Mar 18 18:10:00 volumio ifplugd[3214]: Network Interface Plugging Daemon...start eth0...done. Mar 18 18:10:00 volumio dbus[3224]: [system] Successfully activated service 'org.freedesktop.systemd1' Mar 18 18:10:00 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Mar 18 18:10:00 volumio avahi-daemon[3219]: Network interface enumeration completed. Mar 18 18:10:00 volumio avahi-daemon[3219]: Registering HINFO record with values 'AARCH64'/'LINUX'. Mar 18 18:10:00 volumio avahi-daemon[3219]: Server startup complete. Host name is volumio.local. Local service cookie is 3620111182. Mar 18 18:10:00 volumio systemd[1]: Starting Permit User Sessions... Mar 18 18:10:00 volumio systemd[1]: Started Restore Sound Card State. Mar 18 18:10:00 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Mar 18 18:10:00 volumio lircd-0.9.0-pre1[3358]: accepted new client on /var/run/lirc/lircd Mar 18 18:10:00 volumio systemd[1]: Unit cd.service entered failed state. Mar 18 18:10:00 volumio lirc[3213]: Starting execution daemon: irexec:. Mar 18 18:10:00 volumio systemd[1]: Started /etc/rc.local Compatibility. Mar 18 18:10:00 volumio systemd[1]: Started LSB: triggerhappy hotkey daemon. Mar 18 18:10:00 volumio dbus[3224]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service' Mar 18 18:10:00 volumio systemd[1]: Started LSB: Start NTP daemon. Mar 18 18:10:00 volumio systemd[1]: Started LSB: Starts LIRC daemon.. Mar 18 18:10:00 volumio systemd[1]: Started LSB: Brings up/down network automatically. Mar 18 18:10:00 volumio systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon. Mar 18 18:10:00 volumio loadcpufreq[3212]: Loading cpufreq kernel modules...done (none). Mar 18 18:10:00 volumio systemd[1]: Started OpenBSD Secure Shell server. Mar 18 18:10:00 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Mar 18 18:10:00 volumio systemd[1]: dhcpcd.service: control process exited, code=exited status=6 Mar 18 18:10:00 volumio systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support. Mar 18 18:10:00 volumio systemd[1]: Unit dhcpcd.service entered failed state. Mar 18 18:10:00 volumio systemd[1]: Started Permit User Sessions. Mar 18 18:10:00 volumio sshd[3389]: Server listening on 0.0.0.0 port 22. Mar 18 18:10:00 volumio sshd[3389]: Server listening on :: port 22. Mar 18 18:10:00 volumio systemd-logind[3203]: New seat seat0. Mar 18 18:10:00 volumio systemd[1]: Started Login Service. Mar 18 18:10:00 volumio systemd[1]: Starting Disk Manager (legacy version)... Mar 18 18:10:00 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Mar 18 18:10:00 volumio systemd[1]: Starting Wait for Plymouth Boot Screen to Quit... Mar 18 18:10:00 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Mar 18 18:10:00 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Mar 18 18:10:00 volumio systemd[1]: Stopping cd.service... Mar 18 18:10:00 volumio systemd[1]: Starting cd.service... Mar 18 18:10:00 volumio systemd[1]: Started cd.service. Mar 18 18:10:00 volumio systemd[1]: Stopping LSB: Starts LIRC daemon.... Mar 18 18:10:00 volumio systemd[1]: Started Wait for Plymouth Boot Screen to Quit. Mar 18 18:10:00 volumio systemd[1]: Starting Getty on tty1... Mar 18 18:10:00 volumio systemd[1]: Started Getty on tty1. Mar 18 18:10:00 volumio systemd[1]: Starting Serial Getty on ttyS0... Mar 18 18:10:00 volumio systemd[1]: Started Serial Getty on ttyS0. Mar 18 18:10:00 volumio systemd[1]: Starting Login Prompts. Mar 18 18:10:00 volumio systemd[1]: Reached target Login Prompts. Mar 18 18:10:00 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Mar 18 18:10:00 volumio volumio[3409]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Mar 18 18:10:00 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Mar 18 18:10:00 volumio systemd[1]: Unit cd.service entered failed state. Mar 18 18:10:00 volumio volumio-remote-updater[3195]: Error: No active session Mar 18 18:10:00 volumio volumio-remote-updater[3195]: [2021-03-18 18:10:00] [info] asio async_connect error: system:111 (Connection refused) Mar 18 18:10:00 volumio volumio-remote-updater[3195]: [2021-03-18 18:10:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 18 18:10:00 volumio volumio-remote-updater[3195]: [2021-03-18 18:10:00] [error] handle_connect error: Underlying Transport Error Mar 18 18:10:00 volumio lircd-0.9.0-pre1[3358]: removed client Mar 18 18:10:00 volumio lirc[3410]: Stopping execution daemon: irexec:. Mar 18 18:10:00 volumio lircd-0.9.0-pre1[3358]: caught signal Mar 18 18:10:00 volumio lirc[3410]: Stopping remote control daemon(s): LIRC:. Mar 18 18:10:00 volumio systemd[1]: Starting LSB: Starts LIRC daemon.... Mar 18 18:10:00 volumio dbus[3224]: [system] Successfully activated service 'org.freedesktop.UDisks' Mar 18 18:10:00 volumio systemd[1]: Started Disk Manager (legacy version). Mar 18 18:10:00 volumio cpufrequtils[3403]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...CPU4...CPU5...done. Mar 18 18:10:00 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Mar 18 18:10:00 volumio lirc[3431]: Loading LIRC modules:. Mar 18 18:10:00 volumio volumio[3194]: Could not open config: /tmp/upmpdcli.conf Mar 18 18:10:00 volumio systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE Mar 18 18:10:00 volumio systemd[1]: Unit upmpdcli.service entered failed state. Mar 18 18:10:00 volumio lirc[3431]: Starting remote control daemon(s) : LIRC :. Mar 18 18:10:00 volumio dbus[3224]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Mar 18 18:10:00 volumio lirc[3431]: Starting execution daemon: irexec: failed! Mar 18 18:10:00 volumio systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Mar 18 18:10:00 volumio systemd[1]: Started LSB: Starts LIRC daemon.. Mar 18 18:10:00 volumio haveged[3190]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K Mar 18 18:10:00 volumio haveged[3190]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 9/40; sz: 15780/68380 Mar 18 18:10:00 volumio haveged[3190]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99999 Mar 18 18:10:00 volumio haveged[3190]: haveged: fills: 0, generated: 0 Mar 18 18:10:00 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Mar 18 18:10:00 volumio systemd[1]: Stopping cd.service... Mar 18 18:10:00 volumio systemd[1]: Starting cd.service... Mar 18 18:10:00 volumio systemd[1]: Started cd.service. Mar 18 18:10:00 volumio polkitd[3451]: started daemon version 0.105 using authority implementation `local' version `0.105' Mar 18 18:10:00 volumio dbus[3224]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Mar 18 18:10:00 volumio systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Mar 18 18:10:00 volumio volumio[3458]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Mar 18 18:10:00 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Mar 18 18:10:00 volumio systemd[1]: Unit cd.service entered failed state. Mar 18 18:10:01 volumio udisks-glue[3193]: Device file /dev/mmcblk1 inserted Mar 18 18:10:01 volumio udisks-glue[3193]: Device file /dev/sda inserted Mar 18 18:10:01 volumio udisks-glue[3193]: Device file /dev/mmcblk1p3 inserted Mar 18 18:10:01 volumio udisks-glue[3193]: Device file /dev/sda1 inserted Mar 18 18:10:01 volumio udisks-glue[3193]: Trying to automount /dev/sda1... Mar 18 18:10:01 volumio ntpd[3351]: Deferring DNS for 0.debian.pool.ntp.org 1 Mar 18 18:10:01 volumio ntpd[3351]: Deferring DNS for 1.debian.pool.ntp.org 1 Mar 18 18:10:01 volumio ntpd[3351]: Deferring DNS for 2.debian.pool.ntp.org 1 Mar 18 18:10:01 volumio ntpd[3351]: Deferring DNS for 3.debian.pool.ntp.org 1 Mar 18 18:10:01 volumio ntpd[3467]: signal_no_reset: signal 17 had flags 4000000 Mar 18 18:10:01 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Mar 18 18:10:01 volumio systemd[1]: Stopping cd.service... Mar 18 18:10:01 volumio systemd[1]: Starting cd.service... Mar 18 18:10:01 volumio systemd[1]: Started cd.service. Mar 18 18:10:01 volumio volumio[3469]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Mar 18 18:10:01 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Mar 18 18:10:01 volumio systemd[1]: Unit cd.service entered failed state. Mar 18 18:10:01 volumio systemd[1]: Started Music Player Daemon. Mar 18 18:10:01 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Mar 18 18:10:01 volumio systemd[1]: Stopping cd.service... Mar 18 18:10:01 volumio systemd[1]: Starting cd.service... Mar 18 18:10:01 volumio systemd[1]: Started cd.service. Mar 18 18:10:01 volumio volumio[3481]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Mar 18 18:10:01 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Mar 18 18:10:01 volumio systemd[1]: Unit cd.service entered failed state. Mar 18 18:10:01 volumio wireless.js[3381]: WIRELESS: No wireless interface, exiting Mar 18 18:10:01 volumio systemd[1]: wireless.service: control process exited, code=exited status=1 Mar 18 18:10:01 volumio systemd[1]: Failed to start Wireless Services. Mar 18 18:10:01 volumio systemd[1]: Unit wireless.service entered failed state. Mar 18 18:10:01 volumio systemd[1]: Starting Volumio Backend Module... Mar 18 18:10:01 volumio systemd[1]: Started Volumio Backend Module. Mar 18 18:10:01 volumio systemd[1]: Starting Volumio Streaming Daemon... Mar 18 18:10:01 volumio systemd[1]: Started Volumio Streaming Daemon. Mar 18 18:10:01 volumio systemd[1]: Started LSB: start Samba daemons for the AD DC. Mar 18 18:10:01 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Mar 18 18:10:01 volumio systemd[1]: Stopping cd.service... Mar 18 18:10:01 volumio systemd[1]: Starting cd.service... Mar 18 18:10:01 volumio systemd[1]: cd.service start request repeated too quickly, refusing to start. Mar 18 18:10:01 volumio systemd[1]: Failed to start cd.service. Mar 18 18:10:01 volumio systemd[1]: Unit cd.service entered failed state. Mar 18 18:10:01 volumio volumio-streaming-daemon[3489]: ############################ Mar 18 18:10:01 volumio volumio-streaming-daemon[3489]: # Volumio Streaming Daemon # Mar 18 18:10:01 volumio volumio-streaming-daemon[3489]: # Running on port 7777 # Mar 18 18:10:01 volumio volumio-streaming-daemon[3489]: ############################ Mar 18 18:10:01 volumio volumio-streaming-daemon[3489]: Environment: production Mar 18 18:10:01 volumio winbind[3204]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Mar 18 18:10:01 volumio winbind[3204]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Mar 18 18:10:01 volumio winbind[3204]: Unable to setup corepath for winbindd: No such file or directory Mar 18 18:10:01 volumio winbind[3204]: mkdir failed on directory /var/log/samba/cores: No such file or directory Mar 18 18:10:01 volumio winbind[3204]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Mar 18 18:10:01 volumio winbind[3204]: Unable to setup corepath for winbindd: No such file or directory Mar 18 18:10:01 volumio winbind[3204]: [2021/03/18 18:10:01, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio winbind[3204]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Mar 18 18:10:01 volumio winbind[3204]: [2021/03/18 18:10:01, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio winbind[3204]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Mar 18 18:10:01 volumio winbind[3204]: [2021/03/18 18:10:01, 0] ../source3/winbindd/winbindd.c:1549(main) Mar 18 18:10:01 volumio winbind[3204]: winbindd version 4.2.14-Debian started. Mar 18 18:10:01 volumio winbind[3204]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Mar 18 18:10:01 volumio winbind[3204]: [2021/03/18 18:10:01, 0] ../lib/util/util.c:220(directory_create_or_exist) Mar 18 18:10:01 volumio winbind[3204]: mkdir failed on directory /var/log/samba/cores: No such file or directory Mar 18 18:10:01 volumio winbind[3204]: [2021/03/18 18:10:01, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Mar 18 18:10:01 volumio winbind[3204]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Mar 18 18:10:01 volumio winbind[3204]: [2021/03/18 18:10:01, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Mar 18 18:10:01 volumio winbind[3204]: Unable to setup corepath for winbindd: No such file or directory Mar 18 18:10:01 volumio winbindd[3508]: [2021/03/18 18:10:01.831630, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio winbindd[3508]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Mar 18 18:10:01 volumio winbindd[3508]: [2021/03/18 18:10:01.832071, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio winbindd[3508]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Mar 18 18:10:01 volumio nmbd[3510]: [2021/03/18 18:10:01.835556, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio nmbd[3510]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Mar 18 18:10:01 volumio nmbd[3510]: [2021/03/18 18:10:01.836790, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio nmbd[3510]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Mar 18 18:10:01 volumio nmbd[3512]: [2021/03/18 18:10:01.839040, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Mar 18 18:10:01 volumio nmbd[3512]: started asyncdns process 3513 Mar 18 18:10:01 volumio systemd[1]: Started LSB: start Winbind daemon. Mar 18 18:10:01 volumio systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Mar 18 18:10:01 volumio winbindd[3511]: [2021/03/18 18:10:01.840903, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Mar 18 18:10:01 volumio winbindd[3511]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 18 18:10:01 volumio nmbd[3512]: [2021/03/18 18:10:01.841229, 0] ../lib/util/become_daemon.c:135(daemon_status) Mar 18 18:10:01 volumio nmbd[3512]: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Mar 18 18:10:01 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Mar 18 18:10:01 volumio winbind[3204]: [2021/03/18 18:10:01.831630, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio winbind[3204]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Mar 18 18:10:01 volumio winbind[3204]: [2021/03/18 18:10:01.832071, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio winbind[3204]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Mar 18 18:10:01 volumio nmbd[3211]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Mar 18 18:10:01 volumio nmbd[3211]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Mar 18 18:10:01 volumio nmbd[3211]: Unable to setup corepath for nmbd: No such file or directory Mar 18 18:10:01 volumio nmbd[3211]: [2021/03/18 18:10:01, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio nmbd[3211]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Mar 18 18:10:01 volumio nmbd[3211]: [2021/03/18 18:10:01, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio nmbd[3211]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Mar 18 18:10:01 volumio nmbd[3211]: [2021/03/18 18:10:01, 0] ../source3/nmbd/nmbd.c:908(main) Mar 18 18:10:01 volumio nmbd[3211]: nmbd version 4.2.14-Debian started. Mar 18 18:10:01 volumio nmbd[3211]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Mar 18 18:10:01 volumio nmbd[3211]: [2021/03/18 18:10:01.835556, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio nmbd[3211]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Mar 18 18:10:01 volumio nmbd[3211]: [2021/03/18 18:10:01.836790, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio nmbd[3211]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Mar 18 18:10:01 volumio winbind[3204]: . Mar 18 18:10:01 volumio nmbd[3211]: . Mar 18 18:10:01 volumio winbindd[3511]: [2021/03/18 18:10:01.856426, 0] ../lib/util/become_daemon.c:124(daemon_ready) Mar 18 18:10:01 volumio winbindd[3511]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 18 18:10:01 volumio winbindd[3520]: [2021/03/18 18:10:01.859636, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:01 volumio winbindd[3520]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory Mar 18 18:10:02 volumio ntfs-3g[3527]: Version 2014.2.15AR.2 integrated FUSE 28 Mar 18 18:10:02 volumio ntfs-3g[3527]: Mounted /dev/sda1 (Read-Write, label "SAMSUNG_EMO", NTFS 3.1) Mar 18 18:10:02 volumio ntfs-3g[3527]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Mar 18 18:10:02 volumio ntfs-3g[3527]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 18 18:10:02 volumio ntfs-3g[3527]: Global ownership and permissions enforced, configuration type 7 Mar 18 18:10:02 volumio udisks-glue[3193]: Successfully automounted /dev/sda1 at /media/SAMSUNG_EMO Mar 18 18:10:02 volumio udisks-glue[3193]: Device file /dev/sda1 mounted at /media/SAMSUNG_EMO Mar 18 18:10:02 volumio udisks-glue[3193]: Updating DB (#1) ... Mar 18 18:10:02 volumio udisks-glue[3193]: volume: n/a repeat: off random: off single: off consume: off Mar 18 18:10:02 volumio smbd[3514]: Starting SMB/CIFS daemon: smbd[2021/03/18 18:10:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio smbd[3514]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Mar 18 18:10:02 volumio smbd[3514]: [2021/03/18 18:10:02, 0] ../lib/util/util.c:220(directory_create_or_exist) Mar 18 18:10:02 volumio smbd[3514]: mkdir failed on directory /var/log/samba/cores: No such file or directory Mar 18 18:10:02 volumio smbd[3514]: [2021/03/18 18:10:02, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Mar 18 18:10:02 volumio smbd[3514]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Mar 18 18:10:02 volumio smbd[3514]: [2021/03/18 18:10:02, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Mar 18 18:10:02 volumio smbd[3514]: Unable to setup corepath for smbd: No such file or directory Mar 18 18:10:02 volumio smbd[3514]: [2021/03/18 18:10:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio smbd[3514]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Mar 18 18:10:02 volumio smbd[3514]: [2021/03/18 18:10:02, 0] ../source3/smbd/server.c:1241(main) Mar 18 18:10:02 volumio smbd[3514]: smbd version 4.2.14-Debian started. Mar 18 18:10:02 volumio smbd[3514]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Mar 18 18:10:02 volumio smbd[3528]: [2021/03/18 18:10:02.229120, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio smbd[3528]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Mar 18 18:10:02 volumio smbd[3528]: [2021/03/18 18:10:02.229652, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio smbd[3528]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Mar 18 18:10:02 volumio smbd[3528]: [2021/03/18 18:10:02.229712, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio smbd[3528]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Mar 18 18:10:02 volumio smbd[3514]: [2021/03/18 18:10:02.229120, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio smbd[3514]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Mar 18 18:10:02 volumio smbd[3514]: [2021/03/18 18:10:02.229652, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio smbd[3514]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Mar 18 18:10:02 volumio smbd[3514]: [2021/03/18 18:10:02.229712, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio smbd[3514]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Mar 18 18:10:02 volumio smbd[3514]: . Mar 18 18:10:02 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Mar 18 18:10:02 volumio systemd[1]: Starting Multi-User System. Mar 18 18:10:02 volumio systemd[1]: Reached target Multi-User System. Mar 18 18:10:02 volumio systemd[1]: Starting Graphical Interface. Mar 18 18:10:02 volumio systemd[1]: Reached target Graphical Interface. Mar 18 18:10:02 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 18 18:10:02 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 18 18:10:02 volumio systemd[1]: Startup finished in 7.224s (kernel) + 3.453s (userspace) = 10.678s. Mar 18 18:10:02 volumio winbindd[3538]: [2021/03/18 18:10:02.258628, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio winbindd[3538]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Mar 18 18:10:02 volumio winbindd[3540]: [2021/03/18 18:10:02.293748, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio winbindd[3540]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Mar 18 18:10:02 volumio smbd[3532]: [2021/03/18 18:10:02.303610, 0] ../lib/util/become_daemon.c:124(daemon_ready) Mar 18 18:10:02 volumio smbd[3532]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 18 18:10:02 volumio smbd[3541]: [2021/03/18 18:10:02.305834, 0] ../lib/util/debug.c:603(reopen_logs_internal) Mar 18 18:10:02 volumio smbd[3541]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Mar 18 18:10:02 volumio volumio[3488]: info: ------------------------------------------- Mar 18 18:10:02 volumio volumio[3488]: info: ----- Volumio2 ---- Mar 18 18:10:02 volumio volumio[3488]: info: ------------------------------------------- Mar 18 18:10:02 volumio volumio[3488]: info: ----- System startup ---- Mar 18 18:10:02 volumio volumio[3488]: info: ------------------------------------------- Mar 18 18:10:02 volumio kernel: vout: aml_tvout_mode_work: monitor_timeout Mar 18 18:10:03 volumio ntpd_intres[3467]: host name not found: 0.debian.pool.ntp.org Mar 18 18:10:03 volumio ntpd_intres[3467]: host name not found: 1.debian.pool.ntp.org Mar 18 18:10:03 volumio ntpd_intres[3467]: host name not found: 2.debian.pool.ntp.org Mar 18 18:10:03 volumio ntpd_intres[3467]: host name not found: 3.debian.pool.ntp.org Mar 18 18:10:03 volumio volumio[3488]: info: MYVOLUMIO Environment detected Mar 18 18:10:03 volumio volumio[3488]: info: Plugin folders cleanup Mar 18 18:10:03 volumio volumio[3488]: info: Scanning into folder /volumio/app/plugins/ Mar 18 18:10:03 volumio volumio[3488]: info: Scanning category audio_interface Mar 18 18:10:03 volumio volumio[3488]: info: Scanning category miscellanea Mar 18 18:10:03 volumio volumio[3488]: info: Scanning category music_service Mar 18 18:10:03 volumio volumio[3488]: info: Scanning category plugins.json Mar 18 18:10:03 volumio volumio[3488]: info: Scanning category system_controller Mar 18 18:10:03 volumio volumio[3488]: info: Scanning category user_interface Mar 18 18:10:03 volumio volumio[3488]: info: Scanning into folder /data/plugins/ Mar 18 18:10:03 volumio volumio[3488]: info: Scanning category miscellanea Mar 18 18:10:03 volumio volumio[3488]: info: Plugin folders cleanup completed Mar 18 18:10:03 volumio volumio[3488]: info: ------------------------------------------- Mar 18 18:10:03 volumio volumio[3488]: info: ----- Core plugins startup ---- Mar 18 18:10:03 volumio volumio[3488]: info: ------------------------------------------- Mar 18 18:10:03 volumio volumio[3488]: info: Loading plugins from folder /volumio/app/plugins/ Mar 18 18:10:03 volumio volumio[3488]: info: Adding plugin upnp to MyMusic Plugins Mar 18 18:10:03 volumio volumio[3488]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 18 18:10:03 volumio volumio[3488]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 18 18:10:03 volumio volumio[3488]: info: Loading plugins from folder /data/plugins/ Mar 18 18:10:03 volumio volumio[3488]: info: Loading plugin "system"... Mar 18 18:10:03 volumio volumio[3488]: info: Loading plugin "appearance"... Mar 18 18:10:03 volumio volumio[3488]: info: Loading plugin "network"... Mar 18 18:10:03 volumio volumio[3488]: info: Refreshing Cached IP Addresses Mar 18 18:10:03 volumio sudo[3554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 18 18:10:03 volumio sudo[3554]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:10:03 volumio volumio[3488]: info: Loading plugin "services"... Mar 18 18:10:03 volumio volumio[3488]: info: Loading plugin "alsa_controller"... Mar 18 18:10:03 volumio sudo[3554]: pam_unix(sudo:session): session closed for user root Mar 18 18:10:04 volumio sudo[3557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 18 18:10:04 volumio sudo[3557]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:10:04 volumio sudo[3557]: pam_unix(sudo:session): session closed for user root Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "wizard"... Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "volumio_command_line_client"... Mar 18 18:10:04 volumio dhcpcd[3132]: eth0: carrier acquired Mar 18 18:10:04 volumio ifup[3107]: dhcpcd[3132]: eth0: carrier acquired Mar 18 18:10:04 volumio kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "upnp"... Mar 18 18:10:04 volumio volumio[3488]: info: [1616091004094] Starting Upmpd Daemon Mar 18 18:10:04 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "my_music"... Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "mpd"... Mar 18 18:10:04 volumio dhcpcd[3132]: eth0: soliciting a DHCP lease Mar 18 18:10:04 volumio ifup[3107]: dhcpcd[3132]: eth0: soliciting a DHCP lease Mar 18 18:10:04 volumio dhcpcd[3132]: eth0: offered 192.168.1.4 from 192.168.1.1 Mar 18 18:10:04 volumio ifup[3107]: dhcpcd[3132]: eth0: offered 192.168.1.4 from 192.168.1.1 Mar 18 18:10:04 volumio dhcpcd[3132]: eth0: leased 192.168.1.4 for 43200 seconds Mar 18 18:10:04 volumio avahi-daemon[3219]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.4. Mar 18 18:10:04 volumio dhcpcd[3132]: eth0: adding host route to 192.168.1.4 via 127.0.0.1 Mar 18 18:10:04 volumio avahi-daemon[3219]: New relevant interface eth0.IPv4 for mDNS. Mar 18 18:10:04 volumio dhcpcd[3132]: eth0: adding route to 192.168.1.0/24 Mar 18 18:10:04 volumio dhcpcd[3132]: eth0: adding default route via 192.168.1.1 Mar 18 18:10:04 volumio avahi-daemon[3219]: Registering new address record for 192.168.1.4 on eth0.IPv4. Mar 18 18:10:04 volumio ifup[3107]: dhcpcd[3132]: eth0: leased 192.168.1.4 for 43200 seconds Mar 18 18:10:04 volumio ifup[3107]: dhcpcd[3132]: eth0: adding host route to 192.168.1.4 via 127.0.0.1 Mar 18 18:10:04 volumio ifup[3107]: dhcpcd[3132]: eth0: adding route to 192.168.1.0/24 Mar 18 18:10:04 volumio ifup[3107]: dhcpcd[3132]: eth0: adding default route via 192.168.1.1 Mar 18 18:10:04 volumio dhcpcd[3132]: forked to background, child pid 3598 Mar 18 18:10:04 volumio ifup[3107]: dhcpcd[3132]: forked to background, child pid 3598 Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "upnp_browser"... Mar 18 18:10:04 volumio systemd[1]: Reloading OpenBSD Secure Shell server. Mar 18 18:10:04 volumio sshd[3389]: Received SIGHUP; restarting. Mar 18 18:10:04 volumio systemd[1]: Reloaded OpenBSD Secure Shell server. Mar 18 18:10:04 volumio sshd[3389]: Server listening on 0.0.0.0 port 22. Mar 18 18:10:04 volumio sshd[3389]: Server listening on :: port 22. Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "networkfs"... Mar 18 18:10:04 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "alarm-clock"... Mar 18 18:10:04 volumio ifplugd(eth0)[3302]: Link beat detected. Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "airplay_emulation"... Mar 18 18:10:04 volumio volumio[3488]: info: Starting Shairport Sync Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "last_100"... Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "webradio"... Mar 18 18:10:04 volumio ifplugd(eth0)[3302]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "i2s_dacs"... Mar 18 18:10:04 volumio volumio[3488]: info: I2S DAC not set, start Auto-detection Mar 18 18:10:04 volumio ifplugd(eth0)[3302]: client: /sbin/ifup: interface eth0 already configured Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "volumiodiscovery"... Mar 18 18:10:04 volumio volumio[3488]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 18 18:10:04 volumio node[3488]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 18 18:10:04 volumio node[3488]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 18 18:10:04 volumio node[3488]: *** WARNING *** For more information see Mar 18 18:10:04 volumio node[3488]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 18 18:10:04 volumio node[3488]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 18 18:10:04 volumio node[3488]: *** WARNING *** For more information see Mar 18 18:10:04 volumio volumio[3488]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 18 18:10:04 volumio volumio[3488]: *** WARNING *** For more information see Mar 18 18:10:04 volumio volumio[3488]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 18 18:10:04 volumio volumio[3488]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 18 18:10:04 volumio volumio[3488]: *** WARNING *** For more information see Mar 18 18:10:04 volumio volumio[3488]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 18 18:10:04 volumio volumio[3488]: Discovery: StartAdv! undefined Mar 18 18:10:04 volumio volumio[3488]: Discovery: Started advertising... Volumio - undefined Mar 18 18:10:04 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "outputs"... Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "albumart"... Mar 18 18:10:04 volumio volumio[3488]: info: Plugin example_plugin is not enabled Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "inputs"... Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "updater_comm"... Mar 18 18:10:04 volumio ifplugd(eth0)[3302]: Program executed successfully. Mar 18 18:10:04 volumio volumio[3488]: info: Plugin mpdemulation is not enabled Mar 18 18:10:04 volumio volumio[3488]: info: Loading plugin "rest_api"... Mar 18 18:10:05 volumio volumio[3488]: info: Loading plugin "websocket"... Mar 18 18:10:05 volumio volumio[3488]: info: Loading plugin "Systeminfo"... Mar 18 18:10:05 volumio volumio[3488]: Forking 5 albumart workers Mar 18 18:10:05 volumio volumio[3488]: info: ___________ START PLUGINS ___________ Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 18 18:10:05 volumio volumio[3488]: info: [1616091005348] CoreMusicLibrary::Adding element Media Servers Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 18:10:05 volumio volumio[3488]: Starting albumart workers Mar 18 18:10:05 volumio volumio[3488]: Starting albumart workers Mar 18 18:10:05 volumio volumio[3488]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 18 18:10:05 volumio volumio[3488]: Starting albumart workers Mar 18 18:10:05 volumio volumio[3488]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 18 18:10:05 volumio volumio[3488]: info: [1616091005467] CoreMusicLibrary::Adding element Last_100 Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 18 18:10:05 volumio volumio[3488]: info: [1616091005469] CoreMusicLibrary::Adding element Webradio Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 18:10:05 volumio volumio[3488]: info: ------------------------------------------- Mar 18 18:10:05 volumio volumio[3488]: info: ----- MyVolumio plugins startup ---- Mar 18 18:10:05 volumio volumio[3488]: info: ------------------------------------------- Mar 18 18:10:05 volumio volumio[3488]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 18 18:10:05 volumio volumio[3488]: info: Loading i18n strings for locale en Mar 18 18:10:05 volumio volumio[3488]: Updating browse sources language Mar 18 18:10:05 volumio volumio[3488]: Cannot find translation for sourceMedia Servers Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 18:10:05 volumio volumio[3488]: Starting albumart workers Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::initPlayerControls Mar 18 18:10:05 volumio volumio[3488]: Starting albumart workers Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:10:05 volumio volumio[3488]: info: BOOT COMPLETED Mar 18 18:10:05 volumio volumio[3488]: [Metrics] CommandRouter: 2s 810.33ms Mar 18 18:10:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 18:10:05 volumio ntpd[3351]: Listen normally on 3 eth0 192.168.1.4 UDP 123 Mar 18 18:10:05 volumio ntpd[3351]: peers refreshed Mar 18 18:10:05 volumio kernel: aml_spdif_open Mar 18 18:10:05 volumio kernel: audio_ddr_mngr: frddrs[0] registered by device ff642000.audiobus:spdif_b Mar 18 18:10:05 volumio kernel: set normal 512 fs /4 fs Mar 18 18:10:05 volumio kernel: set spdifout clk:5644800, mpll:22579200 Mar 18 18:10:05 volumio kernel: get spdifout clk:5644797, mpll:22579186 Mar 18 18:10:05 volumio kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Mar 18 18:10:05 volumio kernel: set normal 512 fs /4 fs Mar 18 18:10:05 volumio kernel: set spdifout clk:5644800, mpll:22579200 Mar 18 18:10:05 volumio kernel: get spdifout clk:5644797, mpll:22579186 Mar 18 18:10:05 volumio kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Mar 18 18:10:05 volumio kernel: hdmitx: hw: set audio Mar 18 18:10:05 volumio kernel: hdmitx: hw: hdmitx tx_aud_src = 0 Mar 18 18:10:05 volumio kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 74250 Mar 18 18:10:05 volumio kernel: hdmitx: hw: aud_n_para = 6272 Mar 18 18:10:05 volumio kernel: hdmitx: hw: set channel status Mar 18 18:10:05 volumio kernel: hdmitx: audio: Audio Type: PCM Mar 18 18:10:05 volumio kernel: hdmitx: audio: set audio param Mar 18 18:10:05 volumio kernel: aml_spdif_fifo_ctrl, bit depth:16, frddr type:1, toddr:type:1 Mar 18 18:10:05 volumio kernel: asoc-aml-card auge_sound: S/PDIF Playback enable Mar 18 18:10:05 volumio volumio-remote-updater[3195]: [2021-03-18 18:10:05] [connect] Successful connection Mar 18 18:10:06 volumio nmbd[3512]: [2021/03/18 18:10:06.844304, 0] ../lib/util/become_daemon.c:124(daemon_ready) Mar 18 18:10:06 volumio nmbd[3512]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 18 18:10:07 volumio ntpd_intres[3467]: DNS 0.debian.pool.ntp.org -> 185.117.82.66 Mar 18 18:10:07 volumio ntpd_intres[3467]: DNS 1.debian.pool.ntp.org -> 162.159.200.1 Mar 18 18:10:07 volumio ntpd_intres[3467]: DNS 2.debian.pool.ntp.org -> 84.43.191.2 Mar 18 18:10:07 volumio ntpd_intres[3467]: DNS 3.debian.pool.ntp.org -> 195.238.84.84 Mar 18 18:10:10 volumio volumio[3488]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Mar 18 18:10:10 volumio volumio[3488]: info: CoreCommandRouter::Close All Modals sent Mar 18 18:10:10 volumio kernel: asoc-aml-card auge_sound: S/PDIF Playback disable Mar 18 18:10:10 volumio kernel: spdif_b keep clk continuous Mar 18 18:10:10 volumio kernel: aml_spdif_close Mar 18 18:10:10 volumio kernel: audio_ddr_mngr: frddrs[0] released by device ff642000.audiobus:spdif_b Mar 18 18:10:10 volumio volumio[3488]: info: CoreCommandRouter::Close All Modals sent Mar 18 18:10:10 volumio volumio[3488]: Express server listening on port 3000 Mar 18 18:10:10 volumio volumio[3488]: [Metrics] WebUI: 8s 457.39ms Mar 18 18:10:10 volumio volumio[3488]: Volumio Calling Home Mar 18 18:10:10 volumio volumio[3488]: info: CoreStateMachine::resetVolumioState Mar 18 18:10:10 volumio volumio[3488]: info: CoreStateMachine::getcurrentVolume Mar 18 18:10:10 volumio volumio[3488]: info: CoreCommandRouter::volumioRetrievevolume Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 18:10:11 volumio volumio[3488]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Mar 18 18:10:11 volumio volumio[3488]: Unable to parse: Mar 18 18:10:11 volumio volumio[3488]: Simple mixer control 'Audio hdmi-out mute',0 Mar 18 18:10:11 volumio volumio[3488]: Capabilities: pswitch pswitch-joined Mar 18 18:10:11 volumio volumio[3488]: Playback channels: Mono Mar 18 18:10:11 volumio volumio[3488]: Mono: Playback [on] Mar 18 18:10:11 volumio volumio[3488]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 18 18:10:11 volumio volumio[3488]: info: MPD running with PID3221 Mar 18 18:10:11 volumio volumio[3488]: ,establishing connection Mar 18 18:10:11 volumio sudo[3784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Mar 18 18:10:11 volumio sudo[3784]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:10:11 volumio sudo[3784]: pam_unix(sudo:session): session closed for user root Mar 18 18:10:11 volumio volumio[3488]: Unable to parse: Mar 18 18:10:11 volumio volumio[3488]: Simple mixer control 'Audio hdmi-out mute',0 Mar 18 18:10:11 volumio volumio[3488]: Capabilities: pswitch pswitch-joined Mar 18 18:10:11 volumio volumio[3488]: Playback channels: Mono Mar 18 18:10:11 volumio volumio[3488]: Mono: Playback [on] Mar 18 18:10:11 volumio volumio[3488]: info: VolumeController:: Volume=undefined Mute =false Mar 18 18:10:11 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:10:11 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:10:11 volumio volumio[3488]: info: CoreStateMachine::updateTrackBlock Mar 18 18:10:11 volumio volumio[3488]: info: CorePlayQueue::getTrackBlock Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::volumioRetrievevolume Mar 18 18:10:11 volumio volumio[3488]: Unable to parse: Mar 18 18:10:11 volumio volumio[3488]: Simple mixer control 'Audio hdmi-out mute',0 Mar 18 18:10:11 volumio volumio[3488]: Capabilities: pswitch pswitch-joined Mar 18 18:10:11 volumio volumio[3488]: Playback channels: Mono Mar 18 18:10:11 volumio volumio[3488]: Mono: Playback [on] Mar 18 18:10:11 volumio volumio[3488]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 18:10:11 volumio volumio[3488]: info: Reloading queue from file Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::volumioGetState Mar 18 18:10:11 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:10:11 volumio volumio[3488]: error: updateQueue error: null Mar 18 18:10:11 volumio volumio[3488]: info: CoreStateMachine::setRepeat null single undefined Mar 18 18:10:11 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:10:11 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:10:11 volumio volumio[3488]: info: CoreStateMachine::setRandom null Mar 18 18:10:11 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:10:11 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::volumioGetQueue Mar 18 18:10:11 volumio volumio[3488]: info: CoreStateMachine::getQueue Mar 18 18:10:11 volumio volumio[3488]: info: CorePlayQueue::getQueue Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Mar 18 18:10:11 volumio volumio[3488]: Unable to parse: Mar 18 18:10:11 volumio volumio[3488]: Simple mixer control 'Audio hdmi-out mute',0 Mar 18 18:10:11 volumio volumio[3488]: Capabilities: pswitch pswitch-joined Mar 18 18:10:11 volumio volumio[3488]: Playback channels: Mono Mar 18 18:10:11 volumio volumio[3488]: Mono: Playback [on] Mar 18 18:10:11 volumio volumio[3488]: info: VolumeController:: Volume=undefined Mute =false Mar 18 18:10:11 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:10:11 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:10:11 volumio volumio[3488]: info: Starting Shairport Sync Mar 18 18:10:11 volumio volumio[3488]: info: Starting Shairport Sync Mar 18 18:10:11 volumio sudo[3790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 18 18:10:11 volumio sudo[3790]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:10:11 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 18 18:10:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 18 18:10:11 volumio sudo[3790]: pam_unix(sudo:session): session closed for user root Mar 18 18:10:11 volumio sudo[3793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 18 18:10:11 volumio sudo[3793]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:10:11 volumio volumio[3488]: Discovery: adding 2bbf488d-a4a6-40e0-b9bf-1891e4ff9302 Mar 18 18:10:11 volumio volumio[3488]: info: mDNS: Found device Volumio Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::volumioGetState Mar 18 18:10:11 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:10:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 18 18:10:11 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 18 18:10:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 18 18:10:11 volumio sudo[3793]: pam_unix(sudo:session): session closed for user root Mar 18 18:10:11 volumio volumio[3488]: info: Shairport-Sync Started Mar 18 18:10:11 volumio volumio[3488]: Error adding Membership: Error: addMembership EINVAL Mar 18 18:10:11 volumio volumio[3488]: info: Shairport-Sync Started Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::volumioGetState Mar 18 18:10:11 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 18 18:10:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 18 18:10:14 volumio sudo[3818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 18 18:10:14 volumio sudo[3818]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:10:14 volumio sudo[3819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 18 18:10:14 volumio sudo[3819]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:10:14 volumio sudo[3819]: pam_unix(sudo:session): session closed for user root Mar 18 18:10:14 volumio sudo[3821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 18 18:10:14 volumio sudo[3821]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:10:14 volumio sudo[3818]: pam_unix(sudo:session): session closed for user root Mar 18 18:10:14 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Mar 18 18:10:14 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 18 18:10:14 volumio sudo[3821]: pam_unix(sudo:session): session closed for user root Mar 18 18:10:14 volumio volumio[3488]: info: Upmpdcli Daemon Started Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 18 18:10:14 volumio volumio[3488]: info: Adding plugin bluetooth to MyMusic Plugins Mar 18 18:10:14 volumio volumio[3488]: info: Adding plugin cd_controller to MyMusic Plugins Mar 18 18:10:14 volumio volumio[3488]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 18 18:10:14 volumio volumio[3488]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 18 18:10:45 volumio systemd[1]: Time has been changed Mar 18 18:10:45 volumio volumio[3488]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 18 18:10:46 volumio volumio[3488]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 18 18:10:46 volumio volumio[3488]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 18 18:10:46 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 18:10:46 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 18:10:46 volumio volumio[3488]: info: Starting MyVolumio Remote Streaming Endpoints Mar 18 18:10:46 volumio volumio[3488]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 18 18:10:46 volumio volumio[3488]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 18 18:10:46 volumio volumio[3488]: info: Streaming services startup Mar 18 18:10:46 volumio volumio[3488]: info: Starting Streaming Daemon Mar 18 18:10:46 volumio sudo[3843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 18 18:10:46 volumio sudo[3843]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:10:46 volumio systemd[1]: Stopping Volumio Streaming Daemon... Mar 18 18:10:46 volumio systemd[1]: Starting Volumio Streaming Daemon... Mar 18 18:10:46 volumio systemd[1]: Started Volumio Streaming Daemon. Mar 18 18:10:46 volumio sudo[3843]: pam_unix(sudo:session): session closed for user root Mar 18 18:10:46 volumio volumio[3488]: info: MyVolumio not started Mar 18 18:10:46 volumio volumio-streaming-daemon[3850]: ############################ Mar 18 18:10:46 volumio volumio-streaming-daemon[3850]: # Volumio Streaming Daemon # Mar 18 18:10:46 volumio volumio-streaming-daemon[3850]: # Running on port 7777 # Mar 18 18:10:46 volumio volumio-streaming-daemon[3850]: ############################ Mar 18 18:10:46 volumio volumio[3488]: info: Initializing device activation check Mar 18 18:10:46 volumio volumio-streaming-daemon[3850]: Environment: production Mar 18 18:10:46 volumio volumio[3488]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 18 18:10:46 volumio volumio[3488]: info: CoreCommandRouter::volumioGetState Mar 18 18:10:46 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:10:46 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 18 18:10:46 volumio volumio[3488]: info: CoreCommandRouter::volumioGetVisibleSources Mar 18 18:10:46 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 18:10:46 volumio volumio[3488]: info: Listing playlists Mar 18 18:10:48 volumio volumio-remote-updater[3195]: [2021-03-18 18:10:48] [connect] Successful connection Mar 18 18:10:48 volumio volumio-remote-updater[3195]: [2021-03-18 18:10:48] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1616091048 101 Mar 18 18:10:48 volumio volumio-streaming-daemon[3850]: Environment: production Mar 18 18:10:48 volumio volumio[3488]: info: Fetching Streaming Services browse cache Mar 18 18:10:51 volumio volumio[3488]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=odroidn2&variante=volumio&version=2.857&uuid=8f749d3f9df766b76420e8cd7dd890ab" http://updates.volumio.org:7070/downloader-v1/track-device Mar 18 18:10:51 volumio volumio[3488]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 18 18:10:51 volumio volumio[3488]: Dload Upload Total Spent Left Speed Mar 18 18:10:51 volumio volumio[3488]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 18 18:10:51 volumio volumio[3488]: retrying in 5 seconds, trial 0 Mar 18 18:10:51 volumio volumio[3488]: Volumio Calling Home Mar 18 18:11:01 volumio volumio[3488]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=odroidn2&variante=volumio&version=2.857&uuid=8f749d3f9df766b76420e8cd7dd890ab" http://updates.volumio.org:7070/downloader-v1/track-device Mar 18 18:11:01 volumio volumio[3488]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 18 18:11:01 volumio volumio[3488]: Dload Upload Total Spent Left Speed Mar 18 18:11:01 volumio volumio[3488]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 18 18:11:01 volumio volumio[3488]: retrying in 5 seconds, trial 1 Mar 18 18:11:01 volumio volumio[3488]: Volumio Calling Home Mar 18 18:11:04 volumio kernel: sd 0:0:0:0: [sda] tag#0 FAILED Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Mar 18 18:11:04 volumio kernel: sd 0:0:0:0: [sda] tag#0 Sense Key : Medium Error [current] Mar 18 18:11:04 volumio kernel: sd 0:0:0:0: [sda] tag#0 Add. Sense: Unrecovered read error Mar 18 18:11:04 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: Read(10) 28 00 01 c3 46 a9 00 00 40 00 Mar 18 18:11:04 volumio kernel: blk_update_request: critical medium error, dev sda, sector 29574825 Mar 18 18:11:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 18:11:05 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 18:11:06 volumio ntfs-3g[3527]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 18 18:11:06 volumio ntfs-3g[3527]: ntfs_attr_pread error reading '/Videos/POCO/VID_20190427_143722.mp4' at offset 0: 32768 <> -1: Input/output error Mar 18 18:11:06 volumio kernel: sd 0:0:0:0: [sda] tag#0 FAILED Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Mar 18 18:11:06 volumio kernel: sd 0:0:0:0: [sda] tag#0 Sense Key : Medium Error [current] Mar 18 18:11:06 volumio kernel: sd 0:0:0:0: [sda] tag#0 Add. Sense: Unrecovered read error Mar 18 18:11:06 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: Read(10) 28 00 01 c3 46 a9 00 00 08 00 Mar 18 18:11:06 volumio kernel: blk_update_request: critical medium error, dev sda, sector 29574825 Mar 18 18:11:06 volumio kernel: Buffer I/O error on dev sda1, logical block 3694845, async page read Mar 18 18:11:08 volumio kernel: sd 0:0:0:0: [sda] tag#0 FAILED Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE Mar 18 18:11:08 volumio kernel: sd 0:0:0:0: [sda] tag#0 Sense Key : Medium Error [current] Mar 18 18:11:08 volumio kernel: sd 0:0:0:0: [sda] tag#0 Add. Sense: Unrecovered read error Mar 18 18:11:08 volumio kernel: sd 0:0:0:0: [sda] tag#0 CDB: Read(10) 28 00 01 c3 46 a9 00 00 08 00 Mar 18 18:11:08 volumio kernel: blk_update_request: critical medium error, dev sda, sector 29574825 Mar 18 18:11:08 volumio kernel: Buffer I/O error on dev sda1, logical block 3694845, async page read Mar 18 18:11:08 volumio ntfs-3g[3527]: ntfs_attr_pread_i: ntfs_pread failed: Input/output error Mar 18 18:11:08 volumio ntfs-3g[3527]: ntfs_attr_pread error reading '/Videos/POCO/VID_20190427_143722.mp4' at offset 0: 4096 <> -1: Input/output error Mar 18 18:11:09 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:11:09 volumio volumio[3488]: info: Mar 18 18:11:09 volumio volumio[3488]: ---------------------------- MPD announces state update: update Mar 18 18:11:09 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:11:09 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:11:09 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:11:09 volumio volumio[3488]: info: Command Router : Notfying DB Updatefalse Mar 18 18:11:09 volumio volumio[3488]: info: CoreCommandRouter::Close All Modals sent Mar 18 18:11:09 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:11:09 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:11:09 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:11:09 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:11:09 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:11:09 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:11:09 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:11:09 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:11:09 volumio volumio[3488]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 18 18:11:09 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:11:09 volumio volumio[3488]: info: CoreStateMachine::syncState stateService stop Mar 18 18:11:09 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus stop Mar 18 18:11:09 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:11:09 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:11:09 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:11:09 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:11:09 volumio volumio[3488]: info: No code Mar 18 18:11:09 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:11:09 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:11:09 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:11:09 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:11:09 volumio volumio[3488]: info: ------------------------------ 372ms Mar 18 18:11:11 volumio volumio[3488]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=odroidn2&variante=volumio&version=2.857&uuid=8f749d3f9df766b76420e8cd7dd890ab" http://updates.volumio.org:7070/downloader-v1/track-device Mar 18 18:11:11 volumio volumio[3488]: % Total % Received % Xferd Average Speed Time Time Time Current Mar 18 18:11:11 volumio volumio[3488]: Dload Upload Total Spent Left Speed Mar 18 18:11:11 volumio volumio[3488]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Mar 18 18:11:11 volumio volumio[3488]: retrying in 5 seconds, trial 2 Mar 18 18:11:11 volumio volumio[3488]: Volumio Calling Home Mar 18 18:11:24 volumio kernel: fb: mem_free_work, free memory: addr:800000 Mar 18 18:11:35 volumio volumio[3488]: info: CoreCommandRouter::volumioGetState Mar 18 18:11:35 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:11:35 volumio volumio[3488]: info: CoreCommandRouter::volumioGetQueue Mar 18 18:11:35 volumio volumio[3488]: info: CoreStateMachine::getQueue Mar 18 18:11:35 volumio volumio[3488]: info: CorePlayQueue::getQueue Mar 18 18:11:35 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Mar 18 18:11:42 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 18 18:11:42 volumio volumio[3488]: info: CoreCommandRouter::volumioGetQueue Mar 18 18:11:42 volumio volumio[3488]: info: CoreStateMachine::getQueue Mar 18 18:11:42 volumio volumio[3488]: info: CorePlayQueue::getQueue Mar 18 18:11:45 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::ClearQueue Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::stop Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:11:48 volumio volumio[3488]: UNSET VOLATILE Mar 18 18:11:48 volumio volumio[3488]: info: CorePlayQueue::clearPlayQueue Mar 18 18:11:48 volumio volumio[3488]: info: CorePlayQueue::saveQueue Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::volumioPushQueue Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::addQueueItems Mar 18 18:11:48 volumio volumio[3488]: info: CorePlayQueue::addQueueItems Mar 18 18:11:48 volumio volumio[3488]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1817772 Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 18 18:11:48 volumio volumio[3488]: info: CorePlayQueue::saveQueue Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::volumioPushQueue Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::updateTrackBlock Mar 18 18:11:48 volumio volumio[3488]: info: CorePlayQueue::getTrackBlock Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::volumioPlay Mar 18 18:11:48 volumio volumio[3488]: UNSET VOLATILE Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::play index 0 Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::stop Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:11:48 volumio volumio[3488]: UNSET VOLATILE Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::play index undefined Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:11:48 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::startPlaybackTimer Mar 18 18:11:48 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:11:48 volumio volumio[3488]: info: [1616091108110] ControllerWebradio::clearAddPlayTrack Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand clear Mar 18 18:11:48 volumio volumio[3488]: info: Mar 18 18:11:48 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:11:48 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1817772" Mar 18 18:11:48 volumio volumio[3488]: error: updateQueue error: null Mar 18 18:11:48 volumio volumio[3488]: info: ------------------------------ 3ms Mar 18 18:11:48 volumio volumio[3488]: info: Mar 18 18:11:48 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:11:48 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand play Mar 18 18:11:48 volumio volumio[3488]: info: ------------------------------ 5ms Mar 18 18:11:48 volumio kernel: aml_spdif_open Mar 18 18:11:48 volumio kernel: audio_ddr_mngr: frddrs[0] registered by device ff642000.audiobus:spdif_b Mar 18 18:11:48 volumio kernel: set normal 512 fs /4 fs Mar 18 18:11:48 volumio kernel: set spdifout clk:5644800, mpll:22579200 Mar 18 18:11:48 volumio kernel: get spdifout clk:5644797, mpll:22579186 Mar 18 18:11:48 volumio kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Mar 18 18:11:48 volumio kernel: set normal 512 fs /4 fs Mar 18 18:11:48 volumio kernel: set spdifout clk:5644800, mpll:22579200 Mar 18 18:11:48 volumio kernel: get spdifout clk:5644797, mpll:22579186 Mar 18 18:11:48 volumio kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Mar 18 18:11:48 volumio kernel: hdmitx: hw: set audio Mar 18 18:11:48 volumio kernel: hdmitx: hw: hdmitx tx_aud_src = 0 Mar 18 18:11:48 volumio kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 74250 Mar 18 18:11:48 volumio kernel: hdmitx: hw: aud_n_para = 6272 Mar 18 18:11:48 volumio kernel: hdmitx: hw: set channel status Mar 18 18:11:48 volumio kernel: hdmitx: audio: Audio Type: PCM Mar 18 18:11:48 volumio kernel: hdmitx: audio: set audio param Mar 18 18:11:48 volumio kernel: aml_spdif_fifo_ctrl, bit depth:24, frddr type:4, toddr:type:4 Mar 18 18:11:48 volumio volumio[3488]: info: Mar 18 18:11:48 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:11:48 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:11:48 volumio kernel: asoc-aml-card auge_sound: S/PDIF Playback enable Mar 18 18:11:48 volumio volumio[3488]: info: Mar 18 18:11:48 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:11:48 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:11:48 volumio volumio[3488]: info: Mar 18 18:11:48 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:11:48 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:11:48 volumio volumio[3488]: info: Mar 18 18:11:48 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:11:48 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:11:48 volumio volumio[3488]: info: Mar 18 18:11:48 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:11:48 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:11:48 volumio volumio[3488]: info: ------------------------------ 17ms Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:11:48 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:11:48 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:11:48 volumio volumio[3488]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miguel Migs - This Melody","artist":"Dance Wave!","album":null,"uri":"http://62.141.38.36:8080/dance.mp3","trackType":"mp3"} Mar 18 18:11:48 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::syncState stateService play Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus stop Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:11:48 volumio volumio[3488]: info: ------------------------------ 29ms Mar 18 18:11:48 volumio volumio[3488]: info: ------------------------------ 7ms Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:11:48 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:11:48 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:11:48 volumio volumio[3488]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miguel Migs - This Melody","artist":"Dance Wave!","album":null,"uri":"http://62.141.38.36:8080/dance.mp3","trackType":"mp3"} Mar 18 18:11:48 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::syncState stateService play Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus play Mar 18 18:11:48 volumio volumio[3488]: info: Received an update from plugin. extracting info from payload Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:11:48 volumio volumio[3488]: info: ------------------------------ 24ms Mar 18 18:11:48 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:11:48 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:11:48 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:11:48 volumio volumio[3488]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Miguel Migs - This Melody","artist":"Dance Wave!","album":null,"uri":"http://62.141.38.36:8080/dance.mp3","trackType":"mp3"} Mar 18 18:11:48 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::syncState stateService play Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus play Mar 18 18:11:48 volumio volumio[3488]: info: Received an update from plugin. extracting info from payload Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:11:48 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:11:48 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:11:48 volumio volumio[3488]: info: ------------------------------ 19ms Mar 18 18:11:52 volumio volumio[3488]: info: CALLMETHOD: system_controller system enableLiveLog true Mar 18 18:11:52 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog Mar 18 18:11:52 volumio volumio[3488]: info: Launching a new LiveLog session Mar 18 18:12:01 volumio volumio[3488]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 18 18:12:01 volumio volumio[3488]: info: CoreStateMachine::ClearQueue Mar 18 18:12:01 volumio volumio[3488]: info: CoreStateMachine::stop Mar 18 18:12:01 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:12:01 volumio volumio[3488]: UNSET VOLATILE Mar 18 18:12:01 volumio volumio[3488]: info: CoreStateMachine::stPlaybackTimer Mar 18 18:12:01 volumio volumio[3488]: info: CoreStateMachine::updateTrackBlock Mar 18 18:12:01 volumio volumio[3488]: info: CorePlayQueue::getTrackBlock Mar 18 18:12:01 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:12:01 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:12:01 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:12:01 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::serviceStop Mar 18 18:12:02 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:12:02 volumio volumio[3488]: info: CoreCommandRouter::serviceStop Mar 18 18:12:02 volumio volumio[3488]: info: [1616091122007] ControllerWebradio::stop Mar 18 18:12:02 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 18:12:02 volumio volumio[3488]: info: CorePlayQueue::clearPlayQueue Mar 18 18:12:02 volumio volumio[3488]: info: CorePlayQueue::saveQueue Mar 18 18:12:02 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:12:02 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:12:02 volumio volumio[3488]: info: CoreCommandRouter::volumioPushQueue Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::addQueueItems Mar 18 18:12:02 volumio volumio[3488]: info: CorePlayQueue::addQueueItems Mar 18 18:12:02 volumio volumio[3488]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012 Mar 18 18:12:02 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 18 18:12:02 volumio volumio[3488]: info: CorePlayQueue::saveQueue Mar 18 18:12:02 volumio volumio[3488]: info: CoreCommandRouter::volumioPushQueue Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::updateTrackBlock Mar 18 18:12:02 volumio volumio[3488]: info: CorePlayQueue::getTrackBlock Mar 18 18:12:02 volumio volumio[3488]: info: CoreCommandRouter::volumioPlay Mar 18 18:12:02 volumio volumio[3488]: UNSET VOLATILE Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::play index 0 Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::stop Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:12:02 volumio volumio[3488]: UNSET VOLATILE Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::play index undefined Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:12:02 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::startPlaybackTimer Mar 18 18:12:02 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:12:02 volumio volumio[3488]: info: [1616091122015] ControllerWebradio::clearAddPlayTrack Mar 18 18:12:02 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 18:12:02 volumio volumio[3488]: info: Mar 18 18:12:02 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:12:02 volumio kernel: asoc-aml-card auge_sound: S/PDIF Playback disable Mar 18 18:12:02 volumio kernel: spdif_b keep clk continuous Mar 18 18:12:02 volumio kernel: aml_spdif_close Mar 18 18:12:02 volumio kernel: audio_ddr_mngr: frddrs[0] released by device ff642000.audiobus:spdif_b Mar 18 18:12:02 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:12:02 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:12:02 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand clear Mar 18 18:12:02 volumio volumio[3488]: info: Mar 18 18:12:02 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:12:02 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:12:02 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:12:02 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:12:02 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" Mar 18 18:12:02 volumio volumio[3488]: error: updateQueue error: null Mar 18 18:12:02 volumio volumio[3488]: info: ------------------------------ 3ms Mar 18 18:12:02 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:12:02 volumio volumio[3488]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 18 18:12:02 volumio volumio[3488]: info: ------------------------------ 5ms Mar 18 18:12:02 volumio volumio[3488]: info: Mar 18 18:12:02 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:12:02 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:12:02 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 18 18:12:02 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand play Mar 18 18:12:02 volumio volumio[3488]: info: ------------------------------ 4ms Mar 18 18:12:03 volumio volumio[3488]: info: Mar 18 18:12:03 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:12:03 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:12:03 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:12:03 volumio kernel: aml_spdif_open Mar 18 18:12:03 volumio kernel: audio_ddr_mngr: frddrs[0] registered by device ff642000.audiobus:spdif_b Mar 18 18:12:03 volumio kernel: set normal 512 fs /4 fs Mar 18 18:12:03 volumio kernel: set spdifout clk:5644800, mpll:22579200 Mar 18 18:12:03 volumio kernel: get spdifout clk:5644797, mpll:22579186 Mar 18 18:12:03 volumio kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Mar 18 18:12:03 volumio kernel: set normal 512 fs /4 fs Mar 18 18:12:03 volumio kernel: set spdifout clk:5644800, mpll:22579200 Mar 18 18:12:03 volumio kernel: get spdifout clk:5644797, mpll:22579186 Mar 18 18:12:03 volumio kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Mar 18 18:12:03 volumio kernel: aml_spdif_fifo_ctrl, bit depth:24, frddr type:4, toddr:type:4 Mar 18 18:12:03 volumio kernel: asoc-aml-card auge_sound: S/PDIF Playback enable Mar 18 18:12:03 volumio volumio[3488]: info: Mar 18 18:12:03 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:12:03 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:12:03 volumio volumio[3488]: info: Mar 18 18:12:03 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:12:03 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:12:03 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:12:03 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:12:03 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:12:03 volumio volumio[3488]: info: ------------------------------ 9ms Mar 18 18:12:03 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:12:03 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:12:03 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:12:03 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:12:03 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:12:03 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:12:03 volumio volumio[3488]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"rockantenne","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 18 18:12:03 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:12:03 volumio volumio[3488]: info: CoreStateMachine::syncState stateService play Mar 18 18:12:03 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus stop Mar 18 18:12:03 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:12:03 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:12:03 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:12:03 volumio volumio[3488]: info: ------------------------------ 25ms Mar 18 18:12:03 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:12:03 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:12:03 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:12:03 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:12:03 volumio volumio[3488]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"rockantenne","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 18 18:12:03 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:12:03 volumio volumio[3488]: info: CoreStateMachine::syncState stateService play Mar 18 18:12:03 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus play Mar 18 18:12:03 volumio volumio[3488]: info: Received an update from plugin. extracting info from payload Mar 18 18:12:03 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 18 18:12:03 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:12:03 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:12:03 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:12:03 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:12:03 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:12:03 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:12:03 volumio volumio[3488]: info: ------------------------------ 20ms Mar 18 18:13:30 volumio volumio[3488]: info: CoreCommandRouter::volumioStop Mar 18 18:13:30 volumio volumio[3488]: info: CoreStateMachine::stop Mar 18 18:13:30 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:13:30 volumio volumio[3488]: UNSET VOLATILE Mar 18 18:13:30 volumio volumio[3488]: info: CoreStateMachine::stPlaybackTimer Mar 18 18:13:30 volumio volumio[3488]: info: CoreStateMachine::updateTrackBlock Mar 18 18:13:30 volumio volumio[3488]: info: CorePlayQueue::getTrackBlock Mar 18 18:13:30 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:13:30 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:13:30 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:13:30 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:13:30 volumio volumio[3488]: info: CoreStateMachine::serviceStop Mar 18 18:13:30 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:13:30 volumio volumio[3488]: info: CoreCommandRouter::serviceStop Mar 18 18:13:30 volumio volumio[3488]: info: [1616091210382] ControllerWebradio::stop Mar 18 18:13:30 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 18:13:30 volumio kernel: asoc-aml-card auge_sound: S/PDIF Playback disable Mar 18 18:13:30 volumio kernel: spdif_b keep clk continuous Mar 18 18:13:30 volumio kernel: aml_spdif_close Mar 18 18:13:30 volumio kernel: audio_ddr_mngr: frddrs[0] released by device ff642000.audiobus:spdif_b Mar 18 18:13:30 volumio volumio[3488]: info: Mar 18 18:13:30 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:13:30 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:13:30 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:13:30 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:13:30 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:13:30 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:13:30 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:13:30 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:13:30 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:13:30 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:13:30 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:13:30 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:13:30 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:13:30 volumio volumio[3488]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 18 18:13:30 volumio volumio[3488]: info: ------------------------------ 25ms Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 18 18:13:31 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 18 18:13:34 volumio volumio[3488]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 18 18:13:34 volumio volumio[3488]: info: Output device has changed, restarting MPD Mar 18 18:13:34 volumio sudo[4264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 18 18:13:34 volumio sudo[4264]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:13:34 volumio sudo[4264]: pam_unix(sudo:session): session closed for user root Mar 18 18:13:34 volumio volumio[3488]: info: Output device has changed, restarting Shairport Sync Mar 18 18:13:34 volumio sudo[4267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 18 18:13:34 volumio sudo[4267]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:13:34 volumio systemd[1]: Stopping Music Player Daemon... Mar 18 18:13:34 volumio volumio[3488]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 18 18:13:34 volumio systemd[1]: Starting Music Player Daemon... Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 18 18:13:34 volumio volumio[3488]: info: Found match in Cards Database: setting mixer for card HDMI Audio Mar 18 18:13:34 volumio volumio[3488]: info: Setting mixer Audio hdmi-out mute for card HDMI Audio Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 18 18:13:34 volumio volumio[3488]: info: Updating Volume Controller Parameters: Device: 0,0 Name: Mixer: Audio hdmi-out mute Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 18:13:34 volumio volumio[3488]: info: MPD Permissions set Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 18 18:13:34 volumio volumio[3488]: Unable to parse: Mar 18 18:13:34 volumio volumio[3488]: Simple mixer control 'Audio hdmi-out mute',0 Mar 18 18:13:34 volumio volumio[3488]: Capabilities: pswitch pswitch-joined Mar 18 18:13:34 volumio volumio[3488]: Playback channels: Mono Mar 18 18:13:34 volumio volumio[3488]: Mono: Playback [on] Mar 18 18:13:34 volumio volumio[3488]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 18 18:13:34 volumio volumio[3488]: info: Starting Shairport Sync Mar 18 18:13:34 volumio volumio[3488]: Unable to parse: Mar 18 18:13:34 volumio volumio[3488]: Simple mixer control 'Audio hdmi-out mute',0 Mar 18 18:13:34 volumio volumio[3488]: Capabilities: pswitch pswitch-joined Mar 18 18:13:34 volumio volumio[3488]: Playback channels: Mono Mar 18 18:13:34 volumio volumio[3488]: Mono: Playback [on] Mar 18 18:13:34 volumio sudo[4293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 18 18:13:34 volumio sudo[4293]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:13:34 volumio volumio[3488]: info: VolumeController:: Volume=undefined Mute =false Mar 18 18:13:34 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:13:34 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:13:34 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:13:34 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 18 18:13:34 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Mar 18 18:13:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 18 18:13:34 volumio sudo[4293]: pam_unix(sudo:session): session closed for user root Mar 18 18:13:34 volumio volumio[3488]: info: Shairport-Sync Started Mar 18 18:13:34 volumio systemd[1]: Started Music Player Daemon. Mar 18 18:13:34 volumio sudo[4267]: pam_unix(sudo:session): session closed for user root Mar 18 18:13:34 volumio volumio[3488]: error: updateQueue error: null Mar 18 18:13:35 volumio volumio[3488]: error: Upnp client error: Error: This socket has been ended by the other party Mar 18 18:13:37 volumio volumio[3488]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 18 18:13:37 volumio volumio[3488]: info: CoreStateMachine::getcurrentVolume Mar 18 18:13:37 volumio volumio[3488]: info: CoreCommandRouter::volumioRetrievevolume Mar 18 18:13:37 volumio volumio[3488]: Unable to parse: Mar 18 18:13:37 volumio volumio[3488]: Simple mixer control 'Audio hdmi-out mute',0 Mar 18 18:13:37 volumio volumio[3488]: Capabilities: pswitch pswitch-joined Mar 18 18:13:37 volumio volumio[3488]: Playback channels: Mono Mar 18 18:13:37 volumio volumio[3488]: Mono: Playback [on] Mar 18 18:13:37 volumio volumio[3488]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 18 18:13:37 volumio volumio[3488]: Unable to parse: Mar 18 18:13:37 volumio volumio[3488]: Simple mixer control 'Audio hdmi-out mute',0 Mar 18 18:13:37 volumio volumio[3488]: Capabilities: pswitch pswitch-joined Mar 18 18:13:37 volumio volumio[3488]: Playback channels: Mono Mar 18 18:13:37 volumio volumio[3488]: Mono: Playback [on] Mar 18 18:13:37 volumio volumio[3488]: info: VolumeController:: Volume=undefined Mute =false Mar 18 18:13:37 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:13:37 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:13:37 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:13:37 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:13:37 volumio volumio[3488]: info: CoreStateMachine::updateTrackBlock Mar 18 18:13:37 volumio volumio[3488]: info: CorePlayQueue::getTrackBlock Mar 18 18:13:37 volumio volumio[3488]: info: CoreCommandRouter::volumioRetrievevolume Mar 18 18:13:37 volumio volumio[3488]: Unable to parse: Mar 18 18:13:37 volumio volumio[3488]: Simple mixer control 'Audio hdmi-out mute',0 Mar 18 18:13:37 volumio volumio[3488]: Capabilities: pswitch pswitch-joined Mar 18 18:13:37 volumio volumio[3488]: Playback channels: Mono Mar 18 18:13:37 volumio volumio[3488]: Mono: Playback [on] Mar 18 18:13:37 volumio volumio[3488]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 18 18:13:37 volumio volumio[3488]: Unable to parse: Mar 18 18:13:37 volumio volumio[3488]: Simple mixer control 'Audio hdmi-out mute',0 Mar 18 18:13:37 volumio volumio[3488]: Capabilities: pswitch pswitch-joined Mar 18 18:13:37 volumio volumio[3488]: Playback channels: Mono Mar 18 18:13:37 volumio volumio[3488]: Mono: Playback [on] Mar 18 18:13:37 volumio volumio[3488]: info: VolumeController:: Volume=undefined Mute =false Mar 18 18:13:37 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:13:37 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:13:37 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:13:37 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::volumioPlay Mar 18 18:14:08 volumio volumio[3488]: UNSET VOLATILE Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::play index undefined Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:14:08 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::startPlaybackTimer Mar 18 18:14:08 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:08 volumio volumio[3488]: info: [1616091248119] ControllerWebradio::clearAddPlayTrack Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand clear Mar 18 18:14:08 volumio volumio[3488]: info: Mar 18 18:14:08 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:14:08 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99498012" Mar 18 18:14:08 volumio volumio[3488]: error: updateQueue error: null Mar 18 18:14:08 volumio volumio[3488]: info: ------------------------------ 4ms Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand play Mar 18 18:14:08 volumio volumio[3488]: info: Mar 18 18:14:08 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:14:08 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:14:08 volumio volumio[3488]: info: ------------------------------ 2ms Mar 18 18:14:08 volumio volumio[3488]: info: Mar 18 18:14:08 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:14:08 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:14:08 volumio kernel: aml_spdif_open Mar 18 18:14:08 volumio kernel: audio_ddr_mngr: frddrs[0] registered by device ff642000.audiobus:spdif_b Mar 18 18:14:08 volumio kernel: set normal 512 fs /4 fs Mar 18 18:14:08 volumio kernel: set spdifout clk:5644800, mpll:22579200 Mar 18 18:14:08 volumio kernel: get spdifout clk:5644797, mpll:22579186 Mar 18 18:14:08 volumio kernel: aml_dai_set_spdif_fmt , fmt 0x4010 Mar 18 18:14:08 volumio kernel: set normal 512 fs /4 fs Mar 18 18:14:08 volumio kernel: set spdifout clk:5644800, mpll:22579200 Mar 18 18:14:08 volumio kernel: get spdifout clk:5644797, mpll:22579186 Mar 18 18:14:08 volumio kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Mar 18 18:14:08 volumio kernel: aml_spdif_fifo_ctrl, bit depth:24, frddr type:4, toddr:type:4 Mar 18 18:14:08 volumio kernel: asoc-aml-card auge_sound: S/PDIF Playback enable Mar 18 18:14:08 volumio volumio[3488]: info: Mar 18 18:14:08 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:14:08 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:14:08 volumio volumio[3488]: info: Mar 18 18:14:08 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:14:08 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:14:08 volumio volumio[3488]: info: Mar 18 18:14:08 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:14:08 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:14:08 volumio volumio[3488]: info: Mar 18 18:14:08 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:14:08 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:14:08 volumio volumio[3488]: info: ------------------------------ 9ms Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:14:08 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:14:08 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:08 volumio volumio[3488]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"R.E.M. - Man on the moon","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 18 18:14:08 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::syncState stateService play Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus stop Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:08 volumio volumio[3488]: info: ------------------------------ 29ms Mar 18 18:14:08 volumio volumio[3488]: info: ------------------------------ 17ms Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:14:08 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:14:08 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:08 volumio volumio[3488]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"R.E.M. - Man on the moon","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 18 18:14:08 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::syncState stateService play Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus play Mar 18 18:14:08 volumio volumio[3488]: info: Received an update from plugin. extracting info from payload Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:08 volumio volumio[3488]: info: ------------------------------ 27ms Mar 18 18:14:08 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:14:08 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:14:08 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:08 volumio volumio[3488]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"R.E.M. - Man on the moon","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 18 18:14:08 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::syncState stateService play Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus play Mar 18 18:14:08 volumio volumio[3488]: info: Received an update from plugin. extracting info from payload Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:08 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:08 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:08 volumio volumio[3488]: info: ------------------------------ 27ms Mar 18 18:14:10 volumio volumio[3488]: info: Mar 18 18:14:10 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:14:10 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:14:10 volumio volumio[3488]: info: Mar 18 18:14:10 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:14:10 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:14:10 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:14:10 volumio volumio[3488]: info: ------------------------------ 10ms Mar 18 18:14:10 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:14:10 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:14:10 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:14:10 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:14:10 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:14:10 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:10 volumio volumio[3488]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1985,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"R.E.M. - Man on the moon","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 18 18:14:10 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:14:10 volumio volumio[3488]: info: CoreStateMachine::syncState stateService play Mar 18 18:14:10 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus play Mar 18 18:14:10 volumio volumio[3488]: info: Received an update from plugin. extracting info from payload Mar 18 18:14:10 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 18 18:14:10 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:10 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:10 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:10 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:10 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:10 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:10 volumio volumio[3488]: info: ------------------------------ 35ms Mar 18 18:14:11 volumio volumio[3488]: info: Mar 18 18:14:11 volumio volumio[3488]: ---------------------------- MPD announces system playlist update Mar 18 18:14:11 volumio volumio[3488]: info: Ignoring MPD Status Update Mar 18 18:14:11 volumio volumio[3488]: info: Mar 18 18:14:11 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:14:11 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:14:11 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:14:11 volumio volumio[3488]: info: ------------------------------ 9ms Mar 18 18:14:11 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:14:11 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:14:11 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:14:11 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:14:11 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:14:11 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:11 volumio volumio[3488]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2737,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"R.E.M. - Man on the moon","artist":"ROCK ANTENNE","album":null,"uri":"http://stream.antenne.de:80/rockantenne","trackType":""} Mar 18 18:14:11 volumio volumio[3488]: verbose: CURRENT POSITION 0 Mar 18 18:14:11 volumio volumio[3488]: info: CoreStateMachine::syncState stateService play Mar 18 18:14:11 volumio volumio[3488]: info: CoreStateMachine::syncState currentStatus play Mar 18 18:14:11 volumio volumio[3488]: info: Received an update from plugin. extracting info from payload Mar 18 18:14:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 18 18:14:11 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:11 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:11 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:11 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:11 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:11 volumio volumio[3488]: info: ------------------------------ 28ms Mar 18 18:14:24 volumio volumio[3488]: info: CoreCommandRouter::volumioStop Mar 18 18:14:24 volumio volumio[3488]: info: CoreStateMachine::stop Mar 18 18:14:24 volumio volumio[3488]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 18 18:14:24 volumio volumio[3488]: UNSET VOLATILE Mar 18 18:14:24 volumio volumio[3488]: info: CoreStateMachine::stPlaybackTimer Mar 18 18:14:24 volumio volumio[3488]: info: CoreStateMachine::updateTrackBlock Mar 18 18:14:24 volumio volumio[3488]: info: CorePlayQueue::getTrackBlock Mar 18 18:14:24 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:24 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:24 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:24 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:24 volumio volumio[3488]: info: CoreStateMachine::serviceStop Mar 18 18:14:24 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:24 volumio volumio[3488]: info: CoreCommandRouter::serviceStop Mar 18 18:14:24 volumio volumio[3488]: info: [1616091264908] ControllerWebradio::stop Mar 18 18:14:24 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand stop Mar 18 18:14:24 volumio kernel: asoc-aml-card auge_sound: S/PDIF Playback disable Mar 18 18:14:24 volumio kernel: spdif_b keep clk continuous Mar 18 18:14:24 volumio kernel: aml_spdif_close Mar 18 18:14:24 volumio kernel: audio_ddr_mngr: frddrs[0] released by device ff642000.audiobus:spdif_b Mar 18 18:14:24 volumio volumio[3488]: info: Mar 18 18:14:24 volumio volumio[3488]: ---------------------------- MPD announces state update: player Mar 18 18:14:24 volumio volumio[3488]: info: ControllerMpd::getState Mar 18 18:14:24 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand status Mar 18 18:14:24 volumio volumio[3488]: verbose: ControllerMpd::parseState Mar 18 18:14:24 volumio volumio[3488]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 18 18:14:24 volumio volumio[3488]: verbose: ControllerMpd::parseTrackInfo Mar 18 18:14:24 volumio volumio[3488]: info: ControllerMpd::pushState Mar 18 18:14:24 volumio volumio[3488]: info: CoreCommandRouter::servicePushState Mar 18 18:14:24 volumio volumio[3488]: info: CoreStateMachine::pushState Mar 18 18:14:24 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:24 volumio volumio[3488]: info: CoreCommandRouter::volumioPushState Mar 18 18:14:24 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 18:14:24 volumio volumio[3488]: info: CorePlayQueue::getTrack 0 Mar 18 18:14:24 volumio volumio[3488]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 18 18:14:24 volumio volumio[3488]: info: ------------------------------ 7ms Mar 18 18:15:16 volumio volumio[3488]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Mar 18 18:15:16 volumio volumio[3488]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Mar 18 18:15:16 volumio sudo[4494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig Mar 18 18:15:16 volumio sudo[4494]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 18:15:16 volumio sudo[4494]: pam_unix(sudo:session): session closed for user root Mar 18 18:15:16 volumio sudo[4505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Mar 18 18:15:16 volumio sudo[4505]: pam_unix(sudo:session): session opened for user root by (uid=0) # cat /var/log/mpd.log --------------- Mar 18 18:10 : zeroconf: No global port, disabling zeroconf Mar 18 18:10 : exception: Failed to register /var/lib/mpd/music/USB/SAMSUNG_EMO: inotify_add_watch() has failed: Permission denied Mar 18 18:10 : client: [0] opened from local Mar 18 18:10 : exception: Failed to read mixer for 'alsa': no such mixer control: PCM Mar 18 18:10 : client: [0] closed Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : client: [1] opened from local Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : client: [2] opened from 127.0.0.1:41206 Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/avi: max_analyze_duration 5000000 reached Mar 18 18:10 : ffmpeg/avi: max_analyze_duration 5000000 reached Mar 18 18:10 : ffmpeg/avi: max_analyze_duration 5000000 reached Mar 18 18:10 : ffmpeg/avi: max_analyze_duration 5000000 reached Mar 18 18:10 : ffmpeg/swf: Estimating duration from bitrate, this may be inaccurate Mar 18 18:10 : ffmpeg/avi: max_analyze_duration 5000000 reached Mar 18 18:10 : ffmpeg/avi: max_analyze_duration 5000000 reached Mar 18 18:10 : ffmpeg/avi: max_analyze_duration 5000000 reached Mar 18 18:10 : ffmpeg/avi: max_analyze_duration 5000000 reached Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:10 : ffmpeg/swf: Compressed SWF format not supported Mar 18 18:11 : exception: Failed to read from /var/lib/mpd/music/USB/SAMSUNG_EMO/Videos/POCO/VID_20190427_143722.mp4: Input/output error Mar 18 18:11 : exception: Failed to open mixer for 'alsa': no such mixer control: PCM Mar 18 18:12 : player: played "http://62.141.38.36:8080/dance.mp3" Mar 18 18:12 : exception: Failed to open mixer for 'alsa': no such mixer control: PCM Mar 18 18:13 : player: played "http://stream.antenne.de:80/rockantenne" Mar 18 18:13 : zeroconf: No global port, disabling zeroconf Mar 18 18:13 : client: [0] opened from local Mar 18 18:14 : client: [1] opened from 127.0.0.1:41328 Mar 18 18:14 : exception: Failed to read mixer for 'alsa': no such mixer control: PCM Mar 18 18:14 : exception: Failed to open mixer for 'alsa': no such mixer control: PCM Mar 18 18:14 : player: played "http://stream.antenne.de:80/rockantenne"