Tue Aug 18 20:23:43 UTC 2020 Description="'No plugins in Nuc8i3BEH with version Volumio Buster x86 version 2.775'" # cat /proc/version --------------- Linux version 4.19.106+ (x86@busteros) (gcc version 8.3.0 (Debian 8.3.0-6)) #1 SMP Mon Feb 17 12:34:48 CET 2020 # cat /etc/os-release --------------- PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7817391029e18b6f37d6157135ec1307dfa1ce44" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="b2e85b2e8facd2d741f2fc40be426a34804b56fc" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumiobuster" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu May 7 23:06:44 CEST 2020" VOLUMIO_VERSION="2.775" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="01f787eadd83d34516fbccb7bca627ce" # ifconfig --------------- eth0: flags=4163 mtu 1500 inet 192.168.1.5 netmask 255.255.255.0 broadcast 192.168.1.255 ether 1c:69:7a:05:1a:ae txqueuelen 1000 (Ethernet) RX packets 3363 bytes 700510 (684.0 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 3596 bytes 2291191 (2.1 MiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 device interrupt 16 memory 0x91100000-91120000 lo: flags=73 mtu 65536 inet 127.0.0.1 netmask 255.0.0.0 loop txqueuelen 1000 (Local Loopback) RX packets 7915 bytes 3504786 (3.3 MiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 7915 bytes 3504786 (3.3 MiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 wlan0: flags=4099 mtu 1500 inet 192.168.211.1 netmask 255.255.255.0 broadcast 192.168.211.255 ether 98:2c:bc:e8:a7:56 txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 13 bytes 2996 (2.9 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 # sudo iwconfig --------------- lo no wireless extensions. eth0 no wireless extensions. wlan0 IEEE 802.11 Mode:Master Tx-Power=22 dBm Retry short limit:7 RTS thr:off Fragment thr:off Power Management:off # aplay -l --------------- **** List of PLAYBACK Hardware Devices **** card 0: PCH [HDA Intel PCH], device 0: ALC233 Analog [ALC233 Analog] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: PCH [HDA Intel PCH], device 3: HDMI 0 [HDMI 0] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: PCH [HDA Intel PCH], device 7: HDMI 1 [HDMI 1] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: PCH [HDA Intel PCH], device 8: HDMI 2 [HDMI 2] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: PCH [HDA Intel PCH], device 9: HDMI 3 [HDMI 3] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: PCH [HDA Intel PCH], device 10: HDMI 4 [HDMI 4] Subdevices: 1/1 Subdevice #0: subdevice #0 # ps -ef --------------- UID PID PPID C STIME TTY TIME CMD root 1 0 0 19:56 ? 00:00:03 /sbin/init root 2 0 0 19:56 ? 00:00:00 [kthreadd] root 3 2 0 19:56 ? 00:00:00 [rcu_gp] root 4 2 0 19:56 ? 00:00:00 [rcu_par_gp] root 6 2 0 19:56 ? 00:00:00 [kworker/0:0H-kblockd] root 7 2 0 19:56 ? 00:00:01 [kworker/u8:0-flush-8:0] root 8 2 0 19:56 ? 00:00:00 [mm_percpu_wq] root 9 2 0 19:56 ? 00:00:00 [ksoftirqd/0] root 10 2 0 19:56 ? 00:00:00 [rcu_sched] root 11 2 0 19:56 ? 00:00:00 [rcu_bh] root 12 2 0 19:56 ? 00:00:00 [migration/0] root 14 2 0 19:56 ? 00:00:00 [cpuhp/0] root 15 2 0 19:56 ? 00:00:00 [cpuhp/1] root 16 2 0 19:56 ? 00:00:00 [migration/1] root 17 2 0 19:56 ? 00:00:01 [ksoftirqd/1] root 19 2 0 19:56 ? 00:00:00 [kworker/1:0H-kblockd] root 20 2 0 19:56 ? 00:00:00 [cpuhp/2] root 21 2 0 19:56 ? 00:00:00 [migration/2] root 22 2 0 19:56 ? 00:00:01 [ksoftirqd/2] root 24 2 0 19:56 ? 00:00:00 [kworker/2:0H-kblockd] root 25 2 0 19:56 ? 00:00:00 [cpuhp/3] root 26 2 0 19:56 ? 00:00:00 [migration/3] root 27 2 0 19:56 ? 00:00:01 [ksoftirqd/3] root 29 2 0 19:56 ? 00:00:00 [kworker/3:0H-kblockd] root 30 2 0 19:56 ? 00:00:00 [kdevtmpfs] root 31 2 0 19:56 ? 00:00:00 [netns] root 32 2 0 19:56 ? 00:00:00 [kauditd] root 33 2 0 19:56 ? 00:00:00 [khungtaskd] root 34 2 0 19:56 ? 00:00:00 [oom_reaper] root 35 2 0 19:56 ? 00:00:00 [writeback] root 36 2 0 19:56 ? 00:00:00 [kcompactd0] root 37 2 0 19:56 ? 00:00:00 [ksmd] root 38 2 0 19:56 ? 00:00:00 [khugepaged] root 39 2 0 19:56 ? 00:00:00 [crypto] root 40 2 0 19:56 ? 00:00:00 [kintegrityd] root 41 2 0 19:56 ? 00:00:00 [kblockd] root 42 2 0 19:56 ? 00:00:00 [ata_sff] root 43 2 0 19:56 ? 00:00:00 [edac-poller] root 44 2 0 19:56 ? 00:00:00 [devfreq_wq] root 45 2 0 19:56 ? 00:00:00 [watchdogd] root 46 2 0 19:56 ? 00:00:00 [kworker/3:1-mm_percpu_wq] root 47 2 0 19:56 ? 00:00:03 [kswapd0] root 49 2 0 19:56 ? 00:00:00 [kworker/1:1-cgroup_destroy] root 64 2 0 19:56 ? 00:00:00 [kthrotld] root 65 2 0 19:56 ? 00:00:00 [scsi_eh_0] root 66 2 0 19:56 ? 00:00:00 [scsi_tmf_0] root 67 2 0 19:56 ? 00:00:00 [scsi_eh_1] root 68 2 0 19:56 ? 00:00:00 [scsi_tmf_1] root 69 2 0 19:56 ? 00:00:00 [scsi_eh_2] root 70 2 0 19:56 ? 00:00:00 [scsi_tmf_2] root 73 2 0 19:56 ? 00:00:00 [ipv6_addrconf] root 79 2 0 19:56 ? 00:00:00 [nvme-wq] root 80 2 0 19:56 ? 00:00:00 [nvme-reset-wq] root 81 2 0 19:56 ? 00:00:00 [nvme-delete-wq] root 125 2 0 19:56 ? 00:00:00 [scsi_eh_3] root 126 2 0 19:56 ? 00:00:00 [scsi_tmf_3] root 127 2 0 19:56 ? 00:00:09 [usb-storage] root 136 2 0 19:56 ? 00:00:00 [kworker/0:1H-kblockd] root 137 2 0 19:56 ? 00:00:00 [kworker/2:1H-kblockd] root 138 2 0 19:56 ? 00:00:00 [kworker/1:1H-kblockd] root 155 2 0 19:56 ? 00:00:00 [jbd2/sda2-8] root 156 2 0 19:56 ? 00:00:00 [ext4-rsv-conver] root 162 2 0 19:56 ? 00:00:00 [kworker/3:1H-kblockd] root 220 2 0 20:01 ? 00:00:00 [kworker/0:2-events_power_efficient] root 235 2 0 20:02 ? 00:00:00 [kworker/3:2-mm_percpu_wq] root 247 2 0 20:02 ? 00:00:00 [loop0] root 255 2 0 20:02 ? 00:00:00 [jbd2/sda3-8] root 256 2 0 20:02 ? 00:00:00 [ext4-rsv-conver] root 257 2 0 20:02 ? 00:00:00 [ext4lazyinit] root 293 1 0 20:02 ? 00:00:00 /lib/systemd/systemd-journald root 304 2 0 20:02 ? 00:00:00 [rpciod] root 305 2 0 20:02 ? 00:00:00 [kworker/u9:0-rb_allocator] root 306 2 0 20:02 ? 00:00:00 [xprtiod] root 320 1 0 20:03 ? 00:00:00 /lib/systemd/systemd-udevd root 340 2 0 20:03 ? 00:00:00 [acpi_thermal_pm] root 342 2 0 20:03 ? 00:00:00 [irq/128-mei_me] root 355 2 0 20:03 ? 00:00:00 [cfg80211] root 363 2 0 20:03 ? 00:00:00 [irq/130-iwlwifi] root 365 2 0 20:03 ? 00:00:00 [irq/131-iwlwifi] root 366 2 0 20:03 ? 00:00:00 [irq/132-iwlwifi] root 367 2 0 20:03 ? 00:00:00 [irq/133-iwlwifi] root 368 2 0 20:03 ? 00:00:00 [irq/134-iwlwifi] root 369 2 0 20:03 ? 00:00:00 [irq/135-iwlwifi] root 385 2 0 20:03 ? 00:00:00 [kworker/u8:1-i915] root 393 2 0 20:03 ? 00:00:00 [kworker/u9:1] root 424 2 0 20:03 ? 00:00:00 [i915/signal:0] root 425 2 0 20:03 ? 00:00:00 [i915/signal:1] root 426 2 0 20:03 ? 00:00:00 [i915/signal:2] root 427 2 0 20:03 ? 00:00:00 [i915/signal:3] root 428 2 0 20:03 ? 00:00:00 [i915/signal:6] _rpc 583 1 0 20:03 ? 00:00:00 /sbin/rpcbind -f -w message+ 588 1 0 20:03 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation --syslog-only volumio 589 1 0 20:03 ? 00:00:00 /usr/local/bin/volumio-remote-updater root 590 1 0 20:03 ? 00:00:00 /usr/lib/udisks2/udisksd root 591 1 0 20:03 ? 00:00:00 /lib/systemd/systemd-logind root 592 1 0 20:03 ? 00:00:00 /sbin/wpa_supplicant -u -s -O /run/wpa_supplicant root 596 1 0 20:03 ? 00:00:00 /usr/sbin/alsactl -E HOME=/run/alsa -s -n 19 -c rdaemon avahi 599 1 0 20:03 ? 00:00:00 avahi-daemon: running [volumio.local] avahi 611 599 0 20:03 ? 00:00:00 avahi-daemon: chroot helper root 627 1 0 20:03 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 670 1 0 20:03 ? 00:00:00 /usr/sbin/dhcpcd root 721 1 0 20:03 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I root 768 1 0 20:03 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug root 824 1 0 20:03 ? 00:00:00 /usr/sbin/hostapd -B -P /run/hostapd.pid -B /etc/hostapd/hostapd.conf root 860 1 0 20:03 ? 00:00:00 /sbin/netplugd -p /var/run/netplugd.pid root 1041 1 0 20:03 tty1 00:00:00 /sbin/agetty -o -p -- \u --noclear tty1 linux ntp 1051 1 0 20:03 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 root 1053 1 0 20:03 ? 00:00:00 /sbin/dhcpcd eth0 root 1080 627 0 20:03 ? 00:00:00 /usr/sbin/nmbd --foreground --no-process-group root 1081 1 0 20:03 ? 00:00:00 /usr/sbin/winbindd --foreground --no-process-group volumio 1170 1 0 20:03 ? 00:00:06 /usr/local/bin/node /volumio/index.js volumio 1172 1 0 20:03 ? 00:00:00 /bin/sh /usr/bin/startx /etc/X11/Xsession /opt/volumiokiosk.sh volumio 1200 1172 0 20:03 ? 00:00:00 xinit /etc/X11/Xsession /opt/volumiokiosk.sh -- /etc/X11/xinit/xserverrc :0 -auth /tmp/serverauth.UHvWJH3k2o root 1201 1200 4 20:03 tty2 00:00:53 /usr/lib/xorg/Xorg -nolisten tcp :0 -auth /tmp/serverauth.UHvWJH3k2o root 1210 1081 0 20:03 ? 00:00:00 winbindd: domain child [VOLUMIO] root 1211 1 0 20:03 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 1224 1211 0 20:03 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 1225 1211 0 20:03 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group root 1261 1081 0 20:03 ? 00:00:00 winbindd: idmap child root 1262 1081 0 20:03 ? 00:00:00 winbindd: domain child [BUILTIN] root 1264 1211 0 20:03 ? 00:00:00 /usr/sbin/smbd --foreground --no-process-group volumio 1295 1200 0 20:03 ? 00:00:00 /bin/bash /opt/volumiokiosk.sh volumio 1387 1295 0 20:03 ? 00:00:00 /usr/bin/unclutter -idle 1 -root volumio 1409 1295 0 20:03 ? 00:00:00 /usr/bin/ssh-agent /opt/volumiokiosk.sh volumio 1413 1295 0 20:03 ? 00:00:01 /usr/bin/openbox --startup /usr/lib/i386-linux-gnu/openbox-autostart OPENBOX volumio 1415 1295 0 20:03 ? 00:00:03 /usr/lib/chromium/chromium --show-component-extension-options --enable-gpu-rasterization --no-default-browser-check --disable-pings --media-router=0 --enable-remote-extensions --load-extension= --disable-session-crashed-bubble --disable-infobars --kiosk --no-first-run http://localhost:3000 volumio 1437 1415 0 20:03 ? 00:00:00 /usr/lib/chromium/chromium --type=zygote volumio 1454 1437 0 20:03 ? 00:00:00 /usr/lib/chromium/chromium --type=zygote root 1565 2 0 20:03 ? 00:00:00 [jbd2/nvme0n1p2-] root 1566 2 0 20:03 ? 00:00:00 [ext4-rsv-conver] volumio 1572 1170 0 20:03 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1598 1572 0 20:03 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1603 1572 0 20:03 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 1604 1572 0 20:03 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart root 1689 1 0 20:04 ? 00:00:00 /usr/lib/bluetooth/bluetoothd --noplugin=sap volumio 1720 1415 20 20:04 ? 00:03:56 /usr/lib/chromium/chromium --type=gpu-process --field-trial-handle=14359412090757672517,12152547330964633233,131072 --enable-gpu-rasterization --gpu-preferences=KAAAAAAAAAAgAAAgAAAAAAAAYAAAAAAAEAAAAAAAAAAAAAAAAAAAAAgAAAAAAAAA --service-request-channel-token=5650485658815089252 volumio 1724 1415 0 20:04 ? 00:00:02 /usr/lib/chromium/chromium --type=utility --field-trial-handle=14359412090757672517,12152547330964633233,131072 --lang=en-US --service-sandbox-type=network --disable-webrtc-apm-in-audio-service --service-request-channel-token=5949630924335953332 --shared-files=v8_context_snapshot_data:100,v8_natives_data:101 volumio 1760 1454 0 20:04 ? 00:00:00 /usr/lib/chromium/chromium --type=renderer --disable-webrtc-apm-in-audio-service --field-trial-handle=14359412090757672517,12152547330964633233,131072 --lang=en-US --disable-oor-cors --enable-auto-reload --num-raster-threads=2 --enable-main-frame-before-activation --service-request-channel-token=6423475870764990720 --renderer-client-id=5 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100,v8_natives_data:101 volumio 1761 1454 25 20:04 ? 00:05:01 /usr/lib/chromium/chromium --type=renderer --disable-webrtc-apm-in-audio-service --field-trial-handle=14359412090757672517,12152547330964633233,131072 --lang=en-US --disable-oor-cors --enable-auto-reload --num-raster-threads=2 --enable-main-frame-before-activation --service-request-channel-token=15446739186513731244 --renderer-client-id=4 --no-v8-untrusted-code-mitigations --shared-files=v8_context_snapshot_data:100,v8_natives_data:101 volumio 1809 1 0 20:04 ? 00:00:00 /bin/streaming-daemon mpd 2072 1 0 20:07 ? 00:00:00 /usr/bin/mpd --no-daemon volumio 2150 1170 0 20:08 ? 00:00:00 /bin/sh -c tail -f /tmp/install_progress volumio 2151 2150 0 20:08 ? 00:00:00 tail -f /tmp/install_progress root 2181 2 0 20:10 ? 00:00:00 [kworker/2:2-events] root 2194 2 0 20:10 ? 00:00:00 [kworker/1:0-mm_percpu_wq] root 2210 2 0 20:13 ? 00:00:00 [kworker/0:1-events_power_efficient] root 2239 2 0 20:18 ? 00:00:00 [kworker/2:0-events_freezable_power_] root 2280 2 0 20:23 ? 00:00:00 [kworker/2:1-events] volumio 2281 1170 0 20:23 ? 00:00:00 /bin/sh -c /usr/local/bin/node /volumio/logsubmit.js 'No plugins in Nuc8i3BEH with version Volumio Buster x86 version 2.775' volumio 2282 2281 0 20:23 ? 00:00:00 /usr/local/bin/node /volumio/logsubmit.js No plugins in Nuc8i3BEH with version Volumio Buster x86 version 2.775 volumio 2301 2282 0 20:23 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 2302 2301 0 20:23 ? 00:00:00 ps -ef # df -h --------------- Filesystem Size Used Avail Use% Mounted on /dev/sda2 2.7G 1.6G 959M 63% /imgpart /dev/loop0 769M 769M 0 100% /static overlay 4.3G 33M 4.0G 1% / devtmpfs 915M 0 915M 0% /dev tmpfs 932M 32M 901M 4% /dev/shm tmpfs 932M 5.6M 926M 1% /run tmpfs 5.0M 4.0K 5.0M 1% /run/lock tmpfs 932M 0 932M 0% /sys/fs/cgroup tmpfs 932M 0 932M 0% /var/spool/cups tmpfs 932M 108K 932M 1% /tmp tmpfs 20M 52K 20M 1% /var/log tmpfs 932M 0 932M 0% /var/spool/cups/tmp /dev/sda1 487M 43M 444M 9% /boot /dev/nvme0n1p1 487M 43M 444M 9% /media/volumioboot /dev/nvme0n1p2 2.7G 2.6G 0 100% /media/volumioimg # mount --------------- /dev/sda2 on /imgpart type ext4 (rw,relatime,stripe=1024) /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=936356k,nr_inodes=207269,mode=755) securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime) tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev) 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) cgroup2 on /sys/fs/cgroup/unified type cgroup2 (rw,nosuid,nodev,noexec,relatime,nsdelegate) cgroup on /sys/fs/cgroup/systemd type cgroup (rw,nosuid,nodev,noexec,relatime,xattr,name=systemd) pstore on /sys/fs/pstore type pstore (rw,nosuid,nodev,noexec,relatime) cgroup on /sys/fs/cgroup/blkio type cgroup (rw,nosuid,nodev,noexec,relatime,blkio) cgroup on /sys/fs/cgroup/devices type cgroup (rw,nosuid,nodev,noexec,relatime,devices) cgroup on /sys/fs/cgroup/net_cls,net_prio type cgroup (rw,nosuid,nodev,noexec,relatime,net_cls,net_prio) 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/perf_event type cgroup (rw,nosuid,nodev,noexec,relatime,perf_event) cgroup on /sys/fs/cgroup/cpuset type cgroup (rw,nosuid,nodev,noexec,relatime,cpuset) cgroup on /sys/fs/cgroup/freezer type cgroup (rw,nosuid,nodev,noexec,relatime,freezer) systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=40,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=9989) mqueue on /dev/mqueue type mqueue (rw,relatime) hugetlbfs on /dev/hugepages type hugetlbfs (rw,relatime,pagesize=4M) debugfs on /sys/kernel/debug type debugfs (rw,relatime) sunrpc on /run/rpc_pipefs type rpc_pipefs (rw,relatime) tmpfs on /var/spool/cups type tmpfs (rw,noatime,mode=755) tmpfs on /tmp 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/sda1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=utf8,shortname=mixed,utf8,errors=remount-ro,user) /dev/sda1 on /media/volumioboot type vfat (rw,noatime,fmask=0111,dmask=0000,allow_utime=0022,codepage=437,iocharset=utf8,shortname=mixed,utf8,errors=remount-ro) /dev/sda2 on /media/volumioimg type ext4 (rw,noatime,stripe=1024) /dev/nvme0n1p1 on /media/volumioboot type vfat (rw,noatime,fmask=0000,dmask=0000,allow_utime=0022,codepage=437,iocharset=utf8,shortname=mixed,errors=remount-ro) /dev/nvme0n1p2 on /media/volumioimg type ext4 (rw,noatime,stripe=1024) # sudo journalctl -p 7 --------------- -- Logs begin at Tue 2020-08-18 20:02:47 UTC, end at Tue 2020-08-18 20:23:43 UTC. -- Aug 18 20:02:47 volumio kernel: Linux version 4.19.106+ (x86@busteros) (gcc version 8.3.0 (Debian 8.3.0-6)) #1 SMP Mon Feb 17 12:34:48 CET 2020 Aug 18 20:02:47 volumio kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Aug 18 20:02:47 volumio kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Aug 18 20:02:47 volumio kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Aug 18 20:02:47 volumio kernel: x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers' Aug 18 20:02:47 volumio kernel: x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR' Aug 18 20:02:47 volumio kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Aug 18 20:02:47 volumio kernel: x86/fpu: xstate_offset[3]: 832, xstate_sizes[3]: 64 Aug 18 20:02:47 volumio kernel: x86/fpu: xstate_offset[4]: 896, xstate_sizes[4]: 64 Aug 18 20:02:47 volumio kernel: x86/fpu: Enabled xstate features 0x1f, context size is 960 bytes, using 'compacted' format. Aug 18 20:02:47 volumio kernel: BIOS-provided physical RAM map: Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009efff] usable Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x000000000009f000-0x00000000000fffff] reserved Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x0000000000100000-0x0000000079b00fff] usable Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x0000000079b01000-0x0000000079f61fff] reserved Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x0000000079f62000-0x0000000079fdefff] ACPI data Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x0000000079fdf000-0x000000007a3ebfff] ACPI NVS Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x000000007a3ec000-0x000000007ac52fff] reserved Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x000000007ac53000-0x000000007ad0dfff] type 20 Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x000000007ad0e000-0x000000007ad0efff] usable Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x000000007ad0f000-0x000000007fffffff] reserved Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x00000000fe000000-0x00000000fe010fff] reserved Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x00000000fed00000-0x00000000fed03fff] reserved Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x00000000ff000000-0x00000000ffffffff] reserved Aug 18 20:02:47 volumio kernel: BIOS-e820: [mem 0x0000000100000000-0x000000027dffffff] usable Aug 18 20:02:47 volumio kernel: Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel! Aug 18 20:02:47 volumio kernel: efi: EFI v2.70 by American Megatrends Aug 18 20:02:47 volumio kernel: efi: ACPI 2.0=0x79f7b000 ACPI=0x79f7b000 SMBIOS=0x7aaa7000 SMBIOS 3.0=0x7aaa6000 MEMATTR=0x779dc418 ESRT=0x7aad3f18 Aug 18 20:02:47 volumio kernel: efi: No EFI runtime due to 32/64-bit mismatch with kernel Aug 18 20:02:47 volumio kernel: SMBIOS 3.2.1 present. Aug 18 20:02:47 volumio kernel: DMI: Intel(R) Client Systems NUC8i3BEH/NUC8BEB, BIOS BECFL357.86A.0073.2019.0618.1409 06/18/2019 Aug 18 20:02:47 volumio kernel: tsc: Detected 3000.000 MHz processor Aug 18 20:02:47 volumio kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Aug 18 20:02:47 volumio kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Aug 18 20:02:47 volumio kernel: last_pfn = 0x7ad0f max_arch_pfn = 0x100000 Aug 18 20:02:47 volumio kernel: MTRR default type: write-back Aug 18 20:02:47 volumio kernel: MTRR fixed ranges enabled: Aug 18 20:02:47 volumio kernel: 00000-9FFFF write-back Aug 18 20:02:47 volumio kernel: A0000-BFFFF uncachable Aug 18 20:02:47 volumio kernel: C0000-FFFFF write-protect Aug 18 20:02:47 volumio kernel: MTRR variable ranges enabled: Aug 18 20:02:47 volumio kernel: 0 base 0080000000 mask 7F80000000 uncachable Aug 18 20:02:47 volumio kernel: 1 base 007C000000 mask 7FFC000000 uncachable Aug 18 20:02:47 volumio kernel: 2 base 007B800000 mask 7FFF800000 uncachable Aug 18 20:02:47 volumio kernel: 3 base 2000000000 mask 6000000000 uncachable Aug 18 20:02:47 volumio kernel: 4 base 1000000000 mask 7000000000 uncachable Aug 18 20:02:47 volumio kernel: 5 base 0800000000 mask 7800000000 uncachable Aug 18 20:02:47 volumio kernel: 6 base 0400000000 mask 7C00000000 uncachable Aug 18 20:02:47 volumio kernel: 7 base 4000000000 mask 4000000000 uncachable Aug 18 20:02:47 volumio kernel: 8 disabled Aug 18 20:02:47 volumio kernel: 9 disabled Aug 18 20:02:47 volumio kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Aug 18 20:02:47 volumio kernel: esrt: Reserving ESRT space from 0x7aad3f18 to 0x7aad3f50. Aug 18 20:02:47 volumio kernel: initial memory mapped: [mem 0x00000000-0x01ffffff] Aug 18 20:02:47 volumio kernel: BRK [0x01a4f000, 0x01a4ffff] PGTABLE Aug 18 20:02:47 volumio kernel: Secure boot could not be determined Aug 18 20:02:47 volumio kernel: RAMDISK: [mem 0x33d0f000-0x35e7efff] Aug 18 20:02:47 volumio kernel: ACPI: Early table checksum verification disabled Aug 18 20:02:47 volumio kernel: ACPI: RSDP 0x0000000079F7B000 000024 (v02 INTEL ) Aug 18 20:02:47 volumio kernel: ACPI: XSDT 0x0000000079F7B0A0 0000C4 (v01 INTEL NUC8i3BE 00000049 AMI 00010013) Aug 18 20:02:47 volumio kernel: ACPI: FACP 0x0000000079FBDCF0 000114 (v06 INTEL NUC8i3BE 00000049 AMI 00010013) Aug 18 20:02:47 volumio kernel: ACPI: DSDT 0x0000000079F7B1F8 042AF7 (v02 INTEL NUC8i3BE 00000049 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: FACS 0x000000007A3EB080 000040 Aug 18 20:02:47 volumio kernel: ACPI: APIC 0x0000000079FBDE08 000084 (v04 INTEL NUC8i3BE 00000049 AMI 00010013) Aug 18 20:02:47 volumio kernel: ACPI: FPDT 0x0000000079FBDE90 000044 (v01 INTEL NUC8i3BE 00000049 AMI 00010013) Aug 18 20:02:47 volumio kernel: ACPI: FIDT 0x0000000079FBDED8 00009C (v01 INTEL NUC8i3BE 00000049 AMI 00010013) Aug 18 20:02:47 volumio kernel: ACPI: MCFG 0x0000000079FBDF78 00003C (v01 INTEL NUC8i3BE 00000049 MSFT 00000097) Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x0000000079FBDFB8 001B1C (v02 INTEL NUC8i3BE 00000049 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x0000000079FBFAD8 0031C6 (v02 INTEL NUC8i3BE 00000049 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: HPET 0x0000000079FC2CA0 000038 (v01 INTEL NUC8i3BE 00000049 01000013) Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x0000000079FC2CD8 000FAE (v02 INTEL NUC8i3BE 00000049 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x0000000079FC3C88 003048 (v02 INTEL NUC8i3BE 00000049 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: UEFI 0x0000000079FC6CD0 000042 (v01 INTEL NUC8i3BE 00000049 01000013) Aug 18 20:02:47 volumio kernel: ACPI: LPIT 0x0000000079FC6D18 00005C (v01 INTEL NUC8i3BE 00000049 01000013) Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x0000000079FC6D78 0027DE (v02 INTEL NUC8i3BE 00000049 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x0000000079FC9558 0008B8 (v02 INTEL NUC8i3BE 00000049 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: DBGP 0x0000000079FC9E10 000034 (v01 INTEL NUC8i3BE 00000049 01000013) Aug 18 20:02:47 volumio kernel: ACPI: DBG2 0x0000000079FC9E48 000054 (v00 INTEL NUC8i3BE 00000049 01000013) Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x0000000079FC9EA0 000144 (v02 INTEL NUC8i3BE 00000049 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: NHLT 0x0000000079FC9FE8 00002D (v00 INTEL NUC8i3BE 00000049 01000013) Aug 18 20:02:47 volumio kernel: ACPI: BGRT 0x0000000079FCA018 000038 (v01 INTEL NUC8i3BE 00000049 AMI 00010013) Aug 18 20:02:47 volumio kernel: ACPI: WSMT 0x0000000079FCA050 000028 (v01 INTEL NUC8i3BE 00000049 AMI 00010013) Aug 18 20:02:47 volumio kernel: ACPI: Local APIC address 0xfee00000 Aug 18 20:02:47 volumio kernel: 1085MB HIGHMEM available. Aug 18 20:02:47 volumio kernel: 879MB LOWMEM available. Aug 18 20:02:47 volumio kernel: mapped low ram: 0 - 36ffe000 Aug 18 20:02:47 volumio kernel: low ram: 0 - 36ffe000 Aug 18 20:02:47 volumio kernel: BRK [0x01a50000, 0x01a50fff] PGTABLE Aug 18 20:02:47 volumio kernel: Zone ranges: Aug 18 20:02:47 volumio kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Aug 18 20:02:47 volumio kernel: Normal [mem 0x0000000001000000-0x0000000036ffdfff] Aug 18 20:02:47 volumio kernel: HighMem [mem 0x0000000036ffe000-0x000000007ad0efff] Aug 18 20:02:47 volumio kernel: Movable zone start for each node Aug 18 20:02:47 volumio kernel: Early memory node ranges Aug 18 20:02:47 volumio kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Aug 18 20:02:47 volumio kernel: node 0: [mem 0x0000000000100000-0x0000000079b00fff] Aug 18 20:02:47 volumio kernel: node 0: [mem 0x000000007ad0e000-0x000000007ad0efff] Aug 18 20:02:47 volumio kernel: Zeroed struct page in unavailable ranges: 9568 pages Aug 18 20:02:47 volumio kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007ad0efff] Aug 18 20:02:47 volumio kernel: On node 0 totalpages: 498336 Aug 18 20:02:47 volumio kernel: DMA zone: 36 pages used for memmap Aug 18 20:02:47 volumio kernel: DMA zone: 0 pages reserved Aug 18 20:02:47 volumio kernel: DMA zone: 3998 pages, LIFO batch:0 Aug 18 20:02:47 volumio kernel: Normal zone: 1944 pages used for memmap Aug 18 20:02:47 volumio kernel: Normal zone: 221182 pages, LIFO batch:63 Aug 18 20:02:47 volumio kernel: HighMem zone: 273156 pages, LIFO batch:63 Aug 18 20:02:47 volumio kernel: Using APIC driver default Aug 18 20:02:47 volumio kernel: Reserving Intel graphics memory at [mem 0x7c000000-0x7fffffff] Aug 18 20:02:47 volumio kernel: ACPI: PM-Timer IO Port: 0x1808 Aug 18 20:02:47 volumio kernel: ACPI: Local APIC address 0xfee00000 Aug 18 20:02:47 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1]) Aug 18 20:02:47 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x02] high edge lint[0x1]) Aug 18 20:02:47 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x03] high edge lint[0x1]) Aug 18 20:02:47 volumio kernel: ACPI: LAPIC_NMI (acpi_id[0x04] high edge lint[0x1]) Aug 18 20:02:47 volumio kernel: IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-119 Aug 18 20:02:47 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Aug 18 20:02:47 volumio kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Aug 18 20:02:47 volumio kernel: ACPI: IRQ0 used by override. Aug 18 20:02:47 volumio kernel: ACPI: IRQ9 used by override. Aug 18 20:02:47 volumio kernel: Using ACPI (MADT) for SMP configuration information Aug 18 20:02:47 volumio kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Aug 18 20:02:47 volumio kernel: e820: update [mem 0x75bc2000-0x75c23fff] usable ==> reserved Aug 18 20:02:47 volumio kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Aug 18 20:02:47 volumio kernel: PM: Registered nosave memory: [mem 0x00000000-0x00000fff] Aug 18 20:02:47 volumio kernel: PM: Registered nosave memory: [mem 0x0009f000-0x000fffff] Aug 18 20:02:47 volumio kernel: PM: Registered nosave memory: [mem 0x75bc2000-0x75c23fff] Aug 18 20:02:47 volumio kernel: PM: Registered nosave memory: [mem 0x79b01000-0x79f61fff] Aug 18 20:02:47 volumio kernel: PM: Registered nosave memory: [mem 0x79f62000-0x79fdefff] Aug 18 20:02:47 volumio kernel: PM: Registered nosave memory: [mem 0x79fdf000-0x7a3ebfff] Aug 18 20:02:47 volumio kernel: PM: Registered nosave memory: [mem 0x7a3ec000-0x7ac52fff] Aug 18 20:02:47 volumio kernel: PM: Registered nosave memory: [mem 0x7ac53000-0x7ad0dfff] Aug 18 20:02:47 volumio kernel: [mem 0x80000000-0xdfffffff] available for PCI devices Aug 18 20:02:47 volumio kernel: Booting paravirtualized kernel on bare hardware Aug 18 20:02:47 volumio kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Aug 18 20:02:47 volumio kernel: efi: Setup done, disabling due to 32/64-bit mismatch Aug 18 20:02:47 volumio kernel: random: get_random_bytes called from start_kernel+0x79/0x43d with crng_init=0 Aug 18 20:02:47 volumio kernel: setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:4 nr_node_ids:1 Aug 18 20:02:47 volumio kernel: percpu: Embedded 28 pages/cpu s83900 r0 d30788 u114688 Aug 18 20:02:47 volumio kernel: pcpu-alloc: s83900 r0 d30788 u114688 alloc=28*4096 Aug 18 20:02:47 volumio kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 18 20:02:47 volumio kernel: Built 1 zonelists, mobility grouping on. Total pages: 496356 Aug 18 20:02:47 volumio kernel: Kernel command line: BOOT_IMAGE=/vmlinuz-4.19.106+ imgpart=UUID=eefd3f2b-9ece-443f-9b90-100fb6931f3f ro net.ifnames=0 biosdevname=0 bootpart=UUID=873E-E5FA datapart=UUID=44ebc161-ff65-40bd-9b36-8adc7b16122c imgfile=volumio_current.sqsh plymouth.ignore-serial-consoles vt.global_cursor_default=0 loglevel=8 Aug 18 20:02:47 volumio kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Aug 18 20:02:47 volumio kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Aug 18 20:02:47 volumio kernel: BRK [0x01a51000, 0x01a51fff] PGTABLE Aug 18 20:02:47 volumio kernel: Initializing CPU#0 Aug 18 20:02:47 volumio kernel: Initializing HighMem for node 0 (00036ffe:0007ad0f) Aug 18 20:02:47 volumio kernel: Initializing Movable for node 0 (00000000:00000000) Aug 18 20:02:47 volumio kernel: Memory: 1872684K/1993344K available (6610K kernel code, 643K rwdata, 1980K rodata, 792K init, 384K bss, 120660K reserved, 0K cma-reserved, 1043636K highmem) Aug 18 20:02:47 volumio kernel: virtual kernel memory layout: fixmap : 0xfff15000 - 0xfffff000 ( 936 kB) cpu_entry : 0xff800000 - 0xff939000 (1252 kB) pkmap : 0xff000000 - 0xff400000 (4096 kB) vmalloc : 0xf77fe000 - 0xfeffe000 ( 120 MB) lowmem : 0xc0000000 - 0xf6ffe000 ( 879 MB) .init : 0xc1919000 - 0xc19df000 ( 792 kB) .data : 0xc1674a00 - 0xc1909d10 (2644 kB) .text : 0xc1000000 - 0xc1674a00 (6610 kB) Aug 18 20:02:47 volumio kernel: Checking if this processor honours the WP bit even in supervisor mode...Ok. Aug 18 20:02:47 volumio kernel: ftrace: allocating 28378 entries in 56 pages Aug 18 20:02:47 volumio kernel: rcu: Hierarchical RCU implementation. Aug 18 20:02:47 volumio kernel: rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. Aug 18 20:02:47 volumio kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 18 20:02:47 volumio kernel: NR_IRQS: 2304, nr_irqs: 1024, preallocated irqs: 16 Aug 18 20:02:47 volumio kernel: CPU 0 irqstacks, hard=(ptrval) soft=(ptrval) Aug 18 20:02:47 volumio kernel: Console: colour dummy device 80x25 Aug 18 20:02:47 volumio kernel: console [tty0] enabled Aug 18 20:02:47 volumio kernel: ACPI: Core revision 20180810 Aug 18 20:02:47 volumio kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635855245 ns Aug 18 20:02:47 volumio kernel: hpet clockevent registered Aug 18 20:02:47 volumio kernel: APIC: Switch to symmetric I/O mode setup Aug 18 20:02:47 volumio kernel: Enabling APIC mode: Flat. Using 1 I/O APICs Aug 18 20:02:47 volumio kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Aug 18 20:02:47 volumio kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2b3e459bf4c, max_idle_ns: 440795289890 ns Aug 18 20:02:47 volumio kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 6000.00 BogoMIPS (lpj=12000000) Aug 18 20:02:47 volumio kernel: pid_max: default: 32768 minimum: 301 Aug 18 20:02:47 volumio kernel: Security Framework initialized Aug 18 20:02:47 volumio kernel: Yama: becoming mindful. Aug 18 20:02:47 volumio kernel: AppArmor: AppArmor disabled by boot time parameter Aug 18 20:02:47 volumio kernel: Mount-cache hash table entries: 2048 (order: 1, 8192 bytes) Aug 18 20:02:47 volumio kernel: Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes) Aug 18 20:02:47 volumio kernel: ENERGY_PERF_BIAS: Set to 'normal', was 'performance' Aug 18 20:02:47 volumio kernel: ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8) Aug 18 20:02:47 volumio kernel: CPU0: Thermal monitoring enabled (TM1) Aug 18 20:02:47 volumio kernel: process: using mwait in idle threads Aug 18 20:02:47 volumio kernel: Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8 Aug 18 20:02:47 volumio kernel: Last level dTLB entries: 4KB 64, 2MB 0, 4MB 0, 1GB 4 Aug 18 20:02:47 volumio kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Aug 18 20:02:47 volumio kernel: Spectre V2 : Mitigation: Full generic retpoline Aug 18 20:02:47 volumio kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Aug 18 20:02:47 volumio kernel: Spectre V2 : Enabling Restricted Speculation for firmware calls Aug 18 20:02:47 volumio kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Aug 18 20:02:47 volumio kernel: Spectre V2 : User space: Mitigation: STIBP via seccomp and prctl Aug 18 20:02:47 volumio kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl and seccomp Aug 18 20:02:47 volumio kernel: L1TF: Kernel not compiled for PAE. No mitigation for L1TF Aug 18 20:02:47 volumio kernel: MDS: Mitigation: Clear CPU buffers Aug 18 20:02:47 volumio kernel: Freeing SMP alternatives memory: 28K Aug 18 20:02:47 volumio kernel: TSC deadline timer enabled Aug 18 20:02:47 volumio kernel: smpboot: CPU0: Intel(R) Core(TM) i3-8109U CPU @ 3.00GHz (family: 0x6, model: 0x8e, stepping: 0xa) Aug 18 20:02:47 volumio kernel: Performance Events: PEBS fmt3+, Skylake events, 32-deep LBR, full-width counters, Intel PMU driver. Aug 18 20:02:47 volumio kernel: ... version: 4 Aug 18 20:02:47 volumio kernel: ... bit width: 48 Aug 18 20:02:47 volumio kernel: ... generic registers: 4 Aug 18 20:02:47 volumio kernel: ... value mask: 0000ffffffffffff Aug 18 20:02:47 volumio kernel: ... max period: 00007fffffffffff Aug 18 20:02:47 volumio kernel: ... fixed-purpose events: 3 Aug 18 20:02:47 volumio kernel: ... event mask: 000000070000000f Aug 18 20:02:47 volumio kernel: rcu: Hierarchical SRCU implementation. Aug 18 20:02:47 volumio kernel: NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. Aug 18 20:02:47 volumio kernel: smp: Bringing up secondary CPUs ... Aug 18 20:02:47 volumio kernel: CPU 1 irqstacks, hard=c7f806e7 soft=f84e4917 Aug 18 20:02:47 volumio kernel: x86: Booting SMP configuration: Aug 18 20:02:47 volumio kernel: .... node #0, CPUs: #1 Aug 18 20:02:47 volumio kernel: Initializing CPU#1 Aug 18 20:02:47 volumio kernel: CPU 2 irqstacks, hard=43f95e7c soft=cb61c2fc Aug 18 20:02:47 volumio kernel: #2 Aug 18 20:02:47 volumio kernel: Initializing CPU#2 Aug 18 20:02:47 volumio kernel: MDS CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/mds.html for more details. Aug 18 20:02:47 volumio kernel: CPU 3 irqstacks, hard=d1ec10f3 soft=664d5a53 Aug 18 20:02:47 volumio kernel: #3 Aug 18 20:02:47 volumio kernel: Initializing CPU#3 Aug 18 20:02:47 volumio kernel: smp: Brought up 1 node, 4 CPUs Aug 18 20:02:47 volumio kernel: smpboot: Max logical packages: 1 Aug 18 20:02:47 volumio kernel: smpboot: Total of 4 processors activated (24000.00 BogoMIPS) Aug 18 20:02:47 volumio kernel: devtmpfs: initialized Aug 18 20:02:47 volumio kernel: PM: Registering ACPI NVS region [mem 0x79fdf000-0x7a3ebfff] (4247552 bytes) Aug 18 20:02:47 volumio kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Aug 18 20:02:47 volumio kernel: futex hash table entries: 1024 (order: 2, 16384 bytes) Aug 18 20:02:47 volumio kernel: pinctrl core: initialized pinctrl subsystem Aug 18 20:02:47 volumio kernel: NET: Registered protocol family 16 Aug 18 20:02:47 volumio kernel: audit: initializing netlink subsys (disabled) Aug 18 20:02:47 volumio kernel: audit: type=2000 audit(1597780589.028:1): state=initialized audit_enabled=0 res=1 Aug 18 20:02:47 volumio kernel: cpuidle: using governor ladder Aug 18 20:02:47 volumio kernel: cpuidle: using governor menu Aug 18 20:02:47 volumio kernel: KVM setup pv remote TLB flush Aug 18 20:02:47 volumio kernel: ACPI FADT declares the system doesn't support PCIe ASPM, so disable it Aug 18 20:02:47 volumio kernel: ACPI: bus type PCI registered Aug 18 20:02:47 volumio kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 18 20:02:47 volumio kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000) Aug 18 20:02:47 volumio kernel: PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in E820 Aug 18 20:02:47 volumio kernel: PCI: Using MMCONFIG for extended config space Aug 18 20:02:47 volumio kernel: PCI: Using configuration type 1 for base access Aug 18 20:02:47 volumio kernel: HugeTLB registered 4.00 MiB page size, pre-allocated 0 pages Aug 18 20:02:47 volumio kernel: ACPI: Added _OSI(Module Device) Aug 18 20:02:47 volumio kernel: ACPI: Added _OSI(Processor Device) Aug 18 20:02:47 volumio kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Aug 18 20:02:47 volumio kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 18 20:02:47 volumio kernel: ACPI: Added _OSI(Linux-Dell-Video) Aug 18 20:02:47 volumio kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Aug 18 20:02:47 volumio kernel: ACPI: 8 ACPI AML tables successfully acquired and loaded Aug 18 20:02:47 volumio kernel: ACPI: Dynamic OEM Table Load: Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x00000000F32F8500 0000F4 (v02 PmRef Cpu0Psd 00003000 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: \_SB_.PR00: _OSC native thermal LVT Acked Aug 18 20:02:47 volumio kernel: ACPI: Dynamic OEM Table Load: Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x00000000F335F400 000400 (v02 PmRef Cpu0Cst 00003001 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: Dynamic OEM Table Load: Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x00000000F280D800 000689 (v02 PmRef Cpu0Ist 00003000 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: Dynamic OEM Table Load: Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x00000000F330E200 00011B (v02 PmRef Cpu0Hwp 00003000 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: Dynamic OEM Table Load: Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x00000000F280D000 000724 (v02 PmRef HwpLvt 00003000 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: Dynamic OEM Table Load: Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x00000000F2813800 0005FC (v02 PmRef ApIst 00003000 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: Dynamic OEM Table Load: Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x00000000F280AC00 000317 (v02 PmRef ApHwp 00003000 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: Dynamic OEM Table Load: Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x00000000F2815000 000AB0 (v02 PmRef ApPsd 00003000 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: Dynamic OEM Table Load: Aug 18 20:02:47 volumio kernel: ACPI: SSDT 0x00000000F280A800 00030A (v02 PmRef ApCst 00003000 INTL 20160527) Aug 18 20:02:47 volumio kernel: ACPI: EC: EC started Aug 18 20:02:47 volumio kernel: ACPI: EC: interrupt blocked Aug 18 20:02:47 volumio kernel: ACPI: \_SB_.PCI0.LPCB.H_EC: Used as first EC Aug 18 20:02:47 volumio kernel: ACPI: \_SB_.PCI0.LPCB.H_EC: GPE=0x14, EC_CMD/EC_SC=0x66, EC_DATA=0x62 Aug 18 20:02:47 volumio kernel: ACPI: \_SB_.PCI0.LPCB.H_EC: Used as boot DSDT EC to handle transactions Aug 18 20:02:47 volumio kernel: ACPI: Interpreter enabled Aug 18 20:02:47 volumio kernel: ACPI: (supports S0 S3 S4 S5) Aug 18 20:02:47 volumio kernel: ACPI: Using IOAPIC for interrupt routing Aug 18 20:02:47 volumio kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Aug 18 20:02:47 volumio kernel: ACPI: Enabled 8 GPEs in block 00 to 7F Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [USBC] (on) Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [V0PR] (on) Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [V1PR] (on) Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [V2PR] (on) Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [WRST] (on) Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [FN00] (off) Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [FN01] (off) Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [FN02] (off) Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [FN03] (off) Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [FN04] (off) Aug 18 20:02:47 volumio kernel: ACPI: Power Resource [PIN] (off) Aug 18 20:02:47 volumio kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-fe]) Aug 18 20:02:47 volumio kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI] Aug 18 20:02:47 volumio kernel: acpi PNP0A08:00: _OSC: platform does not support [AER] Aug 18 20:02:47 volumio kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug SHPCHotplug PME PCIeCapability LTR] Aug 18 20:02:47 volumio kernel: acpi PNP0A08:00: FADT indicates ASPM is unsupported, using BIOS configuration Aug 18 20:02:47 volumio kernel: acpi resource window ([0x4000000000-0x7fffffffff] ignored, not CPU addressable) Aug 18 20:02:47 volumio kernel: PCI host bridge to bus 0000:00 Aug 18 20:02:47 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Aug 18 20:02:47 volumio kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Aug 18 20:02:47 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Aug 18 20:02:47 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000e0000-0x000e3fff window] Aug 18 20:02:47 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000e4000-0x000e7fff window] Aug 18 20:02:47 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000e8000-0x000ebfff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x000ec000-0x000effff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xdfffffff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: root bus resource [mem 0xfc800000-0xfe7fffff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: root bus resource [bus 00-fe] Aug 18 20:02:48 volumio kernel: pci 0000:00:00.0: [8086:3ecc] type 00 class 0x060000 Aug 18 20:02:48 volumio kernel: pci 0000:00:02.0: [8086:3ea5] type 00 class 0x030000 Aug 18 20:02:48 volumio kernel: pci 0000:00:02.0: reg 0x10: [mem 0x90000000-0x90ffffff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:02.0: reg 0x18: [mem 0x80000000-0x8fffffff 64bit pref] Aug 18 20:02:48 volumio kernel: pci 0000:00:02.0: reg 0x20: [io 0x3000-0x303f] Aug 18 20:02:48 volumio kernel: pci 0000:00:02.0: BAR 2: assigned to efifb Aug 18 20:02:48 volumio kernel: pci 0000:00:08.0: [8086:1911] type 00 class 0x088000 Aug 18 20:02:48 volumio kernel: pci 0000:00:08.0: reg 0x10: can't handle BAR above 4GB (bus address 0x400011a000) Aug 18 20:02:48 volumio kernel: pci 0000:00:08.0: reg 0x10: [mem size 0x00001000 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:12.0: [8086:9df9] type 00 class 0x118000 Aug 18 20:02:48 volumio kernel: pci 0000:00:12.0: reg 0x10: can't handle BAR above 4GB (bus address 0x4000119000) Aug 18 20:02:48 volumio kernel: pci 0000:00:12.0: reg 0x10: [mem size 0x00001000 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:14.0: [8086:9ded] type 00 class 0x0c0330 Aug 18 20:02:48 volumio kernel: pci 0000:00:14.0: reg 0x10: can't handle BAR above 4GB (bus address 0x4000100000) Aug 18 20:02:48 volumio kernel: pci 0000:00:14.0: reg 0x10: [mem size 0x00010000 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:14.0: PME# supported from D3hot D3cold Aug 18 20:02:48 volumio kernel: pci 0000:00:14.2: [8086:9def] type 00 class 0x050000 Aug 18 20:02:48 volumio kernel: pci 0000:00:14.2: reg 0x10: can't handle BAR above 4GB (bus address 0x4000114000) Aug 18 20:02:48 volumio kernel: pci 0000:00:14.2: reg 0x10: [mem size 0x00002000 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:14.2: reg 0x18: can't handle BAR above 4GB (bus address 0x4000118000) Aug 18 20:02:48 volumio kernel: pci 0000:00:14.2: reg 0x18: [mem size 0x00001000 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:14.3: [8086:9df0] type 00 class 0x028000 Aug 18 20:02:48 volumio kernel: pci 0000:00:14.3: reg 0x10: can't handle BAR above 4GB (bus address 0x4000110000) Aug 18 20:02:48 volumio kernel: pci 0000:00:14.3: reg 0x10: [mem size 0x00004000 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:14.3: PME# supported from D0 D3hot D3cold Aug 18 20:02:48 volumio kernel: pci 0000:00:16.0: [8086:9de0] type 00 class 0x078000 Aug 18 20:02:48 volumio kernel: pci 0000:00:16.0: reg 0x10: can't handle BAR above 4GB (bus address 0x4000117000) Aug 18 20:02:48 volumio kernel: pci 0000:00:16.0: reg 0x10: [mem size 0x00001000 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:16.0: PME# supported from D3hot Aug 18 20:02:48 volumio kernel: pci 0000:00:17.0: [8086:9dd3] type 00 class 0x010601 Aug 18 20:02:48 volumio kernel: pci 0000:00:17.0: reg 0x10: [mem 0x91124000-0x91125fff] Aug 18 20:02:48 volumio kernel: pci 0000:00:17.0: reg 0x14: [mem 0x91127000-0x911270ff] Aug 18 20:02:48 volumio kernel: pci 0000:00:17.0: reg 0x18: [io 0x3090-0x3097] Aug 18 20:02:48 volumio kernel: pci 0000:00:17.0: reg 0x1c: [io 0x3080-0x3083] Aug 18 20:02:48 volumio kernel: pci 0000:00:17.0: reg 0x20: [io 0x3060-0x307f] Aug 18 20:02:48 volumio kernel: pci 0000:00:17.0: reg 0x24: [mem 0x91126000-0x911267ff] Aug 18 20:02:48 volumio kernel: pci 0000:00:17.0: PME# supported from D3hot Aug 18 20:02:48 volumio kernel: pci 0000:00:1d.0: [8086:9db0] type 01 class 0x060400 Aug 18 20:02:48 volumio kernel: pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.0: [8086:9d84] type 00 class 0x060100 Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.3: [8086:9dc8] type 00 class 0x040380 Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.3: reg 0x10: [mem 0x91120000-0x91123fff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.3: reg 0x20: can't handle BAR above 4GB (bus address 0x4000000000) Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.3: reg 0x20: [mem size 0x00100000 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.3: PME# supported from D3hot D3cold Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.4: [8086:9da3] type 00 class 0x0c0500 Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.4: reg 0x10: can't handle BAR above 4GB (bus address 0x4000116000) Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.4: reg 0x10: [mem size 0x00000100 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.4: reg 0x20: [io 0xefa0-0xefbf] Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.5: [8086:9da4] type 00 class 0x0c8000 Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.5: reg 0x10: [mem 0xfe010000-0xfe010fff] Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.6: [8086:15be] type 00 class 0x020000 Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.6: reg 0x10: [mem 0x91100000-0x9111ffff] Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.6: PME# supported from D0 D3hot D3cold Aug 18 20:02:48 volumio kernel: pci 0000:01:00.0: [1cc1:8201] type 00 class 0x010802 Aug 18 20:02:48 volumio kernel: pci 0000:01:00.0: reg 0x10: [mem 0x91000000-0x91003fff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:1d.0: PCI bridge to [bus 01] Aug 18 20:02:48 volumio kernel: pci 0000:00:1d.0: bridge window [mem 0x91000000-0x910fffff] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: on NUMA node 0 Aug 18 20:02:48 volumio kernel: ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 10 11 12 14 15) *0 Aug 18 20:02:48 volumio kernel: ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 10 11 12 14 15) *1 Aug 18 20:02:48 volumio kernel: ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 10 11 12 14 15) *0 Aug 18 20:02:48 volumio kernel: ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 10 11 12 14 15) *0 Aug 18 20:02:48 volumio kernel: ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 10 11 12 14 15) *0 Aug 18 20:02:48 volumio kernel: ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 10 11 12 14 15) *0 Aug 18 20:02:48 volumio kernel: ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 10 11 12 14 15) *0 Aug 18 20:02:48 volumio kernel: ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 10 11 12 14 15) *0 Aug 18 20:02:48 volumio kernel: ACPI: EC: interrupt unblocked Aug 18 20:02:48 volumio kernel: ACPI: EC: event unblocked Aug 18 20:02:48 volumio kernel: ACPI: \_SB_.PCI0.LPCB.H_EC: GPE=0x14, EC_CMD/EC_SC=0x66, EC_DATA=0x62 Aug 18 20:02:48 volumio kernel: ACPI: \_SB_.PCI0.LPCB.H_EC: Used as boot DSDT EC to handle transactions and events Aug 18 20:02:48 volumio kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Aug 18 20:02:48 volumio kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Aug 18 20:02:48 volumio kernel: pci 0000:00:02.0: vgaarb: bridge control possible Aug 18 20:02:48 volumio kernel: vgaarb: loaded Aug 18 20:02:48 volumio kernel: SCSI subsystem initialized Aug 18 20:02:48 volumio kernel: libata version 3.00 loaded. Aug 18 20:02:48 volumio kernel: EDAC MC: Ver: 3.0.0 Aug 18 20:02:48 volumio kernel: Registered efivars operations Aug 18 20:02:48 volumio kernel: PCI: Using ACPI for IRQ routing Aug 18 20:02:48 volumio kernel: PCI: pci_cache_line_size set to 64 bytes Aug 18 20:02:48 volumio kernel: e820: reserve RAM buffer [mem 0x0009f000-0x0009ffff] Aug 18 20:02:48 volumio kernel: e820: reserve RAM buffer [mem 0x75bc2000-0x77ffffff] Aug 18 20:02:48 volumio kernel: e820: reserve RAM buffer [mem 0x79b01000-0x7bffffff] Aug 18 20:02:48 volumio kernel: e820: reserve RAM buffer [mem 0x7ad0f000-0x7bffffff] Aug 18 20:02:48 volumio kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0 Aug 18 20:02:48 volumio kernel: hpet0: 8 comparators, 64-bit 24.000000 MHz counter Aug 18 20:02:48 volumio kernel: clocksource: Switched to clocksource tsc-early Aug 18 20:02:48 volumio kernel: VFS: Disk quotas dquot_6.6.0 Aug 18 20:02:48 volumio kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Aug 18 20:02:48 volumio kernel: pnp: PnP ACPI init Aug 18 20:02:48 volumio kernel: system 00:00: [mem 0x40000000-0x403fffff] could not be reserved Aug 18 20:02:48 volumio kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active) Aug 18 20:02:48 volumio kernel: system 00:01: [io 0x0a00-0x0a1f] has been reserved Aug 18 20:02:48 volumio kernel: system 00:01: [io 0x0a20-0x0a2f] has been reserved Aug 18 20:02:48 volumio kernel: system 00:01: [io 0x0a30-0x0a3f] has been reserved Aug 18 20:02:48 volumio kernel: system 00:01: [io 0x0a40-0x0a4f] has been reserved Aug 18 20:02:48 volumio kernel: system 00:01: [io 0x0a50-0x0a5f] has been reserved Aug 18 20:02:48 volumio kernel: system 00:01: [io 0x0a60-0x0a6f] has been reserved Aug 18 20:02:48 volumio kernel: system 00:01: Plug and Play ACPI device, IDs PNP0c02 (active) Aug 18 20:02:48 volumio kernel: system 00:02: [io 0x0680-0x069f] has been reserved Aug 18 20:02:48 volumio kernel: system 00:02: [io 0x164e-0x164f] has been reserved Aug 18 20:02:48 volumio kernel: system 00:02: Plug and Play ACPI device, IDs PNP0c02 (active) Aug 18 20:02:48 volumio kernel: system 00:03: [io 0x1854-0x1857] has been reserved Aug 18 20:02:48 volumio kernel: system 00:03: Plug and Play ACPI device, IDs INT3f0d PNP0c02 (active) Aug 18 20:02:48 volumio kernel: system 00:04: [mem 0xfed10000-0xfed17fff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:04: [mem 0xfed18000-0xfed18fff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:04: [mem 0xfed19000-0xfed19fff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:04: [mem 0xe0000000-0xefffffff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:04: [mem 0xfed20000-0xfed3ffff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:04: [mem 0xfed90000-0xfed93fff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:04: [mem 0xfed45000-0xfed8ffff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:04: [mem 0xfee00000-0xfeefffff] could not be reserved Aug 18 20:02:48 volumio kernel: system 00:04: Plug and Play ACPI device, IDs PNP0c02 (active) Aug 18 20:02:48 volumio kernel: system 00:05: [io 0x1800-0x18fe] could not be reserved Aug 18 20:02:48 volumio kernel: system 00:05: [mem 0xfd000000-0xfd69ffff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:05: [mem 0xfd6b0000-0xfd6cffff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:05: [mem 0xfd6f0000-0xfdffffff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:05: [mem 0xfe000000-0xfe01ffff] could not be reserved Aug 18 20:02:48 volumio kernel: system 00:05: [mem 0xfe200000-0xfe7fffff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:05: [mem 0xff000000-0xffffffff] has been reserved Aug 18 20:02:48 volumio kernel: system 00:05: Plug and Play ACPI device, IDs PNP0c02 (active) Aug 18 20:02:48 volumio kernel: system 00:06: [io 0x2000-0x20fe] has been reserved Aug 18 20:02:48 volumio kernel: system 00:06: Plug and Play ACPI device, IDs PNP0c02 (active) Aug 18 20:02:48 volumio kernel: system 00:07: Plug and Play ACPI device, IDs PNP0c02 (active) Aug 18 20:02:48 volumio kernel: pnp: PnP ACPI: found 8 devices Aug 18 20:02:48 volumio kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.3: BAR 4: assigned [mem 0x91200000-0x912fffff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:14.0: BAR 0: assigned [mem 0x91130000-0x9113ffff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:14.3: BAR 0: assigned [mem 0x91128000-0x9112bfff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:14.2: BAR 0: assigned [mem 0x9112c000-0x9112dfff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:08.0: BAR 0: assigned [mem 0x9112e000-0x9112efff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:12.0: BAR 0: assigned [mem 0x9112f000-0x9112ffff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:14.2: BAR 2: assigned [mem 0x91140000-0x91140fff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:16.0: BAR 0: assigned [mem 0x91141000-0x91141fff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:1f.4: BAR 0: assigned [mem 0x91126800-0x911268ff 64bit] Aug 18 20:02:48 volumio kernel: pci 0000:00:1d.0: PCI bridge to [bus 01] Aug 18 20:02:48 volumio kernel: pci 0000:00:1d.0: bridge window [mem 0x91000000-0x910fffff] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: resource 7 [mem 0x000e0000-0x000e3fff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: resource 8 [mem 0x000e4000-0x000e7fff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: resource 9 [mem 0x000e8000-0x000ebfff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: resource 10 [mem 0x000ec000-0x000effff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: resource 11 [mem 0x80000000-0xdfffffff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:00: resource 12 [mem 0xfc800000-0xfe7fffff window] Aug 18 20:02:48 volumio kernel: pci_bus 0000:01: resource 1 [mem 0x91000000-0x910fffff] Aug 18 20:02:48 volumio kernel: NET: Registered protocol family 2 Aug 18 20:02:48 volumio kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes) Aug 18 20:02:48 volumio kernel: TCP established hash table entries: 8192 (order: 3, 32768 bytes) Aug 18 20:02:48 volumio kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes) Aug 18 20:02:48 volumio kernel: TCP: Hash tables configured (established 8192 bind 8192) Aug 18 20:02:48 volumio kernel: UDP hash table entries: 512 (order: 2, 16384 bytes) Aug 18 20:02:48 volumio kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) Aug 18 20:02:48 volumio kernel: NET: Registered protocol family 1 Aug 18 20:02:48 volumio kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Aug 18 20:02:48 volumio kernel: PCI: CLS 64 bytes, default 64 Aug 18 20:02:48 volumio kernel: Unpacking initramfs... Aug 18 20:02:48 volumio kernel: Freeing initrd memory: 34240K Aug 18 20:02:48 volumio kernel: RAPL PMU: API unit is 2^-32 Joules, 5 fixed counters, 655360 ms ovfl timer Aug 18 20:02:48 volumio kernel: RAPL PMU: hw unit of domain pp0-core 2^-14 Joules Aug 18 20:02:48 volumio kernel: RAPL PMU: hw unit of domain package 2^-14 Joules Aug 18 20:02:48 volumio kernel: RAPL PMU: hw unit of domain dram 2^-14 Joules Aug 18 20:02:48 volumio kernel: RAPL PMU: hw unit of domain pp1-gpu 2^-14 Joules Aug 18 20:02:48 volumio kernel: RAPL PMU: hw unit of domain psys 2^-14 Joules Aug 18 20:02:48 volumio kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2b3e459bf4c, max_idle_ns: 440795289890 ns Aug 18 20:02:48 volumio kernel: clocksource: Switched to clocksource tsc Aug 18 20:02:48 volumio kernel: platform rtc_cmos: registered platform RTC device (no PNP device found) Aug 18 20:02:48 volumio kernel: simple-framebuffer simple-framebuffer.0: framebuffer at 0x80000000, 0x1d5000 bytes, mapped to 0x57d9e6bb Aug 18 20:02:48 volumio kernel: simple-framebuffer simple-framebuffer.0: format=a8r8g8b8, mode=800x600x32, linelength=3200 Aug 18 20:02:48 volumio kernel: Console: switching to colour frame buffer device 100x37 Aug 18 20:02:48 volumio kernel: simple-framebuffer simple-framebuffer.0: fb0: simplefb registered! Aug 18 20:02:48 volumio kernel: Initialise system trusted keyrings Aug 18 20:02:48 volumio kernel: workingset: timestamp_bits=14 max_order=19 bucket_order=5 Aug 18 20:02:48 volumio kernel: zbud: loaded Aug 18 20:02:48 volumio kernel: Key type asymmetric registered Aug 18 20:02:48 volumio kernel: Asymmetric key parser 'x509' registered Aug 18 20:02:48 volumio kernel: bounce: pool size: 64 pages Aug 18 20:02:48 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Aug 18 20:02:48 volumio kernel: io scheduler noop registered Aug 18 20:02:48 volumio kernel: io scheduler deadline registered Aug 18 20:02:48 volumio kernel: io scheduler cfq registered (default) Aug 18 20:02:48 volumio kernel: io scheduler mq-deadline registered Aug 18 20:02:48 volumio kernel: io scheduler kyber registered Aug 18 20:02:48 volumio kernel: pcieport 0000:00:1d.0: Signaling PME with IRQ 120 Aug 18 20:02:48 volumio kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 Aug 18 20:02:48 volumio kernel: intel_idle: MWAIT substates: 0x11142120 Aug 18 20:02:48 volumio kernel: intel_idle: v0.4.1 model 0x8E Aug 18 20:02:48 volumio kernel: intel_idle: lapic_timer_reliable_states 0xffffffff Aug 18 20:02:48 volumio kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 18 20:02:48 volumio kernel: Linux agpgart interface v0.103 Aug 18 20:02:48 volumio kernel: ahci 0000:00:17.0: version 3.0 Aug 18 20:02:48 volumio kernel: ahci 0000:00:17.0: AHCI 0001.0301 32 slots 1 ports 6 Gbps 0x4 impl SATA mode Aug 18 20:02:48 volumio kernel: ahci 0000:00:17.0: flags: 64bit ncq sntf pm clo only pio slum part deso sadm sds apst Aug 18 20:02:48 volumio kernel: scsi host0: ahci Aug 18 20:02:48 volumio kernel: scsi host1: ahci Aug 18 20:02:48 volumio kernel: scsi host2: ahci Aug 18 20:02:48 volumio kernel: ata1: DUMMY Aug 18 20:02:48 volumio kernel: ata2: DUMMY Aug 18 20:02:48 volumio kernel: ata3: SATA max UDMA/133 abar m2048@0x91126000 port 0x91126200 irq 121 Aug 18 20:02:48 volumio kernel: i8042: PNP: No PS/2 controller found. Aug 18 20:02:48 volumio kernel: i8042: Probing ports directly. Aug 18 20:02:48 volumio kernel: i8042: No controller found Aug 18 20:02:48 volumio kernel: ata3: SATA link down (SStatus 4 SControl 300) Aug 18 20:02:48 volumio kernel: mousedev: PS/2 mouse device common for all mice Aug 18 20:02:48 volumio kernel: rtc_cmos rtc_cmos: RTC can wake from S4 Aug 18 20:02:48 volumio kernel: rtc_cmos rtc_cmos: registered as rtc0 Aug 18 20:02:48 volumio kernel: rtc_cmos rtc_cmos: alarms up to one month, y3k, 114 bytes nvram, hpet irqs Aug 18 20:02:48 volumio kernel: intel_pstate: Intel P-state driver initializing Aug 18 20:02:48 volumio kernel: intel_pstate: HWP enabled Aug 18 20:02:48 volumio kernel: ledtrig-cpu: registered to indicate activity on CPUs Aug 18 20:02:48 volumio kernel: NET: Registered protocol family 10 Aug 18 20:02:48 volumio kernel: Segment Routing with IPv6 Aug 18 20:02:48 volumio kernel: mip6: Mobile IPv6 Aug 18 20:02:48 volumio kernel: NET: Registered protocol family 17 Aug 18 20:02:48 volumio kernel: mpls_gso: MPLS GSO support Aug 18 20:02:48 volumio kernel: mce: Using 9 MCE banks Aug 18 20:02:48 volumio kernel: microcode: sig=0x806ea, pf=0x40, revision=0xb4 Aug 18 20:02:48 volumio kernel: microcode: Microcode Update Driver: v2.2. Aug 18 20:02:48 volumio kernel: Using IPI No-Shortcut mode Aug 18 20:02:48 volumio kernel: sched_clock: Marking stable (3218193541, 808842)->(3223921702, -4919319) Aug 18 20:02:48 volumio kernel: registered taskstats version 1 Aug 18 20:02:48 volumio kernel: Loading compiled-in X.509 certificates Aug 18 20:02:48 volumio kernel: zswap: loaded using pool lzo/zbud Aug 18 20:02:48 volumio kernel: rtc_cmos rtc_cmos: setting system clock to 2020-08-18 19:56:32 UTC (1597780592) Aug 18 20:02:48 volumio kernel: Freeing unused kernel image memory: 792K Aug 18 20:02:48 volumio kernel: Write protecting the kernel text: 6612k Aug 18 20:02:48 volumio kernel: Write protecting the kernel read-only data: 2000k Aug 18 20:02:48 volumio kernel: Run /init as init process Aug 18 20:02:48 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 18 20:02:48 volumio kernel: nvme nvme0: pci function 0000:01:00.0 Aug 18 20:02:48 volumio kernel: nvme nvme0: missing or invalid SUBNQN field. Aug 18 20:02:48 volumio kernel: nvme0n1: p1 p2 p3 Aug 18 20:02:48 volumio kernel: ACPI: bus type USB registered Aug 18 20:02:48 volumio kernel: usbcore: registered new interface driver usbfs Aug 18 20:02:48 volumio kernel: usbcore: registered new interface driver hub Aug 18 20:02:48 volumio kernel: usbcore: registered new device driver usb Aug 18 20:02:48 volumio kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Aug 18 20:02:48 volumio kernel: ehci-pci: EHCI PCI platform driver Aug 18 20:02:48 volumio kernel: uhci_hcd: USB Universal Host Controller Interface driver Aug 18 20:02:48 volumio kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Aug 18 20:02:48 volumio kernel: ohci-pci: OHCI PCI platform driver Aug 18 20:02:48 volumio kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller Aug 18 20:02:48 volumio kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1 Aug 18 20:02:48 volumio kernel: xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x110 quirks 0x0000000000009810 Aug 18 20:02:48 volumio kernel: xhci_hcd 0000:00:14.0: cache line size of 64 is not supported Aug 18 20:02:48 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19 Aug 18 20:02:48 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Aug 18 20:02:48 volumio kernel: usb usb1: Product: xHCI Host Controller Aug 18 20:02:48 volumio kernel: usb usb1: Manufacturer: Linux 4.19.106+ xhci-hcd Aug 18 20:02:48 volumio kernel: usb usb1: SerialNumber: 0000:00:14.0 Aug 18 20:02:48 volumio kernel: hub 1-0:1.0: USB hub found Aug 18 20:02:48 volumio kernel: hub 1-0:1.0: 12 ports detected Aug 18 20:02:48 volumio kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller Aug 18 20:02:48 volumio kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2 Aug 18 20:02:48 volumio kernel: xhci_hcd 0000:00:14.0: Host supports USB 3.1 Enhanced SuperSpeed Aug 18 20:02:48 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 4.19 Aug 18 20:02:48 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Aug 18 20:02:48 volumio kernel: usb usb2: Product: xHCI Host Controller Aug 18 20:02:48 volumio kernel: usb usb2: Manufacturer: Linux 4.19.106+ xhci-hcd Aug 18 20:02:48 volumio kernel: usb usb2: SerialNumber: 0000:00:14.0 Aug 18 20:02:48 volumio kernel: hub 2-0:1.0: USB hub found Aug 18 20:02:48 volumio kernel: hub 2-0:1.0: 6 ports detected Aug 18 20:02:48 volumio kernel: usb: port power management may be unreliable Aug 18 20:02:48 volumio kernel: sdhci: Secure Digital Host Controller Interface driver Aug 18 20:02:48 volumio kernel: sdhci: Copyright(c) Pierre Ossman Aug 18 20:02:48 volumio kernel: hidraw: raw HID events driver (C) Jiri Kosina Aug 18 20:02:48 volumio kernel: usbcore: registered new interface driver usbhid Aug 18 20:02:48 volumio kernel: usbhid: USB HID core driver Aug 18 20:02:48 volumio kernel: loop: module loaded Aug 18 20:02:48 volumio kernel: usbcore: registered new interface driver usb-storage Aug 18 20:02:48 volumio kernel: usb 1-3: new low-speed USB device number 2 using xhci_hcd Aug 18 20:02:48 volumio kernel: usb 1-3: New USB device found, idVendor=04f2, idProduct=0116, bcdDevice= 3.00 Aug 18 20:02:48 volumio kernel: usb 1-3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Aug 18 20:02:48 volumio kernel: usb 1-3: Product: USB Keyboard Aug 18 20:02:48 volumio kernel: usb 1-3: Manufacturer: CHICONY Aug 18 20:02:48 volumio kernel: input: CHICONY USB Keyboard as /devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3:1.0/0003:04F2:0116.0001/input/input0 Aug 18 20:02:48 volumio kernel: hid-generic 0003:04F2:0116.0001: input,hidraw0: USB HID v1.10 Keyboard [CHICONY USB Keyboard] on usb-0000:00:14.0-3/input0 Aug 18 20:02:48 volumio kernel: usb 1-4: new high-speed USB device number 3 using xhci_hcd Aug 18 20:02:48 volumio kernel: usb 1-4: New USB device found, idVendor=058f, idProduct=6387, bcdDevice= 1.04 Aug 18 20:02:48 volumio kernel: usb 1-4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Aug 18 20:02:48 volumio kernel: usb 1-4: Product: Mass Storage Aug 18 20:02:48 volumio kernel: usb 1-4: Manufacturer: Generic Aug 18 20:02:48 volumio kernel: usb 1-4: SerialNumber: 1CBE36CE Aug 18 20:02:48 volumio kernel: usb-storage 1-4:1.0: USB Mass Storage device detected Aug 18 20:02:48 volumio kernel: scsi host3: usb-storage 1-4:1.0 Aug 18 20:02:48 volumio kernel: scsi 3:0:0:0: Direct-Access Generic Flash Disk 8.07 PQ: 0 ANSI: 4 Aug 18 20:02:48 volumio kernel: sd 3:0:0:0: [sda] 15974400 512-byte logical blocks: (8.18 GB/7.62 GiB) Aug 18 20:02:48 volumio kernel: sd 3:0:0:0: [sda] Write Protect is off Aug 18 20:02:48 volumio kernel: sd 3:0:0:0: [sda] Mode Sense: 23 00 00 00 Aug 18 20:02:48 volumio kernel: sd 3:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Aug 18 20:02:48 volumio kernel: sda: sda1 sda2 sda3 Aug 18 20:02:48 volumio kernel: sd 3:0:0:0: [sda] Attached SCSI removable disk Aug 18 20:02:48 volumio kernel: random: fast init done Aug 18 20:02:48 volumio kernel: EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null) Aug 18 20:02:48 volumio kernel: random: crng init done Aug 18 20:02:48 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Aug 18 20:02:48 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Aug 18 20:02:48 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Aug 18 20:02:48 volumio kernel: EXT4-fs (sda3): mounted filesystem with ordered data mode. Opts: (null) Aug 18 20:02:48 volumio systemd[1]: Inserted module 'autofs4' Aug 18 20:02:48 volumio systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid) Aug 18 20:02:48 volumio systemd[1]: Detected architecture x86. Aug 18 20:02:48 volumio systemd[1]: Set hostname to . Aug 18 20:02:48 volumio systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling. Aug 18 20:02:48 volumio systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.) Aug 18 20:02:48 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 18 20:02:48 volumio systemd[1]: /lib/systemd/system/smbd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/smbd.pid → /run/samba/smbd.pid; please update the unit file accordingly. Aug 18 20:02:48 volumio systemd[1]: /lib/systemd/system/nmbd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/nmbd.pid → /run/samba/nmbd.pid; please update the unit file accordingly. Aug 18 20:02:48 volumio systemd[1]: Created slice system-systemd\x2dfsck.slice. Aug 18 20:02:48 volumio systemd[1]: Listening on Journal Socket. Aug 18 20:02:48 volumio systemd-journald[293]: Journal started Aug 18 20:02:48 volumio systemd-journald[293]: Runtime journal (/run/log/journal/60adf0872fd213a9cb9504ad5eb4784d) is 3.7M, max 30.0M, 26.2M free. Aug 18 20:02:48 volumio systemd-sysusers[301]: Creating group systemd-coredump with gid 999. Aug 18 20:02:48 volumio systemd-sysusers[301]: Creating user systemd-coredump (systemd Core Dumper) with uid 999 and gid 999. Aug 18 20:02:48 volumio systemd[1]: Mounted RPC Pipe File System. Aug 18 20:02:48 volumio systemd[1]: Started udev Coldplug all Devices. Aug 18 20:02:48 volumio systemd[1]: Starting Helper to synchronize boot up for ifupdown... Aug 18 20:02:52 volumio systemd[1]: Started Helper to synchronize boot up for ifupdown. Aug 18 20:02:52 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 18 20:03:03 volumio systemd[1]: Started Create System Users. Aug 18 20:03:03 volumio systemd[1]: Starting Create Static Device Nodes in /dev... Aug 18 20:03:03 volumio systemd[1]: Started Create Static Device Nodes in /dev. Aug 18 20:03:03 volumio systemd[1]: Reached target Local File Systems (Pre). Aug 18 20:03:03 volumio systemd[1]: Mounting /var/spool/cups... Aug 18 20:03:03 volumio systemd[1]: Mounting /tmp... Aug 18 20:03:03 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Aug 18 20:03:03 volumio systemd[1]: Mounting /var/log... Aug 18 20:03:03 volumio systemd[1]: Starting udev Kernel Device Manager... Aug 18 20:03:03 volumio systemd[1]: Mounted /var/spool/cups. Aug 18 20:03:03 volumio systemd[1]: Mounted /tmp. Aug 18 20:03:03 volumio systemd[1]: Mounted /var/log. Aug 18 20:03:03 volumio systemd[1]: Starting Flush Journal to Persistent Storage... Aug 18 20:03:03 volumio systemd[1]: Mounting /var/spool/cups/tmp... Aug 18 20:03:03 volumio systemd[1]: Mounted /var/spool/cups/tmp. Aug 18 20:03:03 volumio systemd-udevd[320]: Network interface NamePolicy= disabled on kernel command line, ignoring. Aug 18 20:03:03 volumio systemd-journald[293]: Runtime journal (/run/log/journal/60adf0872fd213a9cb9504ad5eb4784d) is 3.7M, max 30.0M, 26.2M free. Aug 18 20:03:03 volumio systemd[1]: Started udev Kernel Device Manager. Aug 18 20:03:03 volumio systemd[1]: Started Flush Journal to Persistent Storage. Aug 18 20:03:03 volumio systemd[1]: Starting Show Plymouth Boot Screen... Aug 18 20:03:03 volumio systemd[1]: Received SIGRTMIN+20 from PID 338 (plymouthd). Aug 18 20:03:04 volumio systemd[1]: Started Show Plymouth Boot Screen. Aug 18 20:03:04 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Aug 18 20:03:04 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 18 20:03:04 volumio systemd[1]: Reached target Local Encrypted Volumes. Aug 18 20:03:04 volumio systemd[1]: Reached target Paths. Aug 18 20:03:04 volumio systemd-udevd[334]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 18 20:03:04 volumio systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Aug 18 20:03:04 volumio systemd[1]: Starting Load/Save RF Kill Switch Status... Aug 18 20:03:04 volumio systemd[1]: Found device Flash_Disk volumioboot. Aug 18 20:03:04 volumio systemd-udevd[335]: Using default interface naming scheme 'v240'. Aug 18 20:03:04 volumio systemd[1]: Starting File System Check on /dev/disk/by-uuid/873E-E5FA... Aug 18 20:03:04 volumio systemd-udevd[327]: Using default interface naming scheme 'v240'. Aug 18 20:03:04 volumio systemd[1]: Started Load/Save RF Kill Switch Status. Aug 18 20:03:04 volumio systemd[1]: Started File System Check Daemon to report status. Aug 18 20:03:04 volumio systemd-udevd[327]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 18 20:03:04 volumio systemd-udevd[335]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Aug 18 20:03:05 volumio systemd-fsck[407]: fsck.fat 4.1 (2017-01-24) Aug 18 20:03:05 volumio systemd-fsck[407]: /dev/sda1: 18 files, 10776/124424 clusters Aug 18 20:03:05 volumio systemd[1]: Started File System Check on /dev/disk/by-uuid/873E-E5FA. Aug 18 20:03:05 volumio systemd[1]: Mounting /boot... Aug 18 20:03:05 volumio systemd[1]: Condition check resulted in FUSE Control File System being skipped. Aug 18 20:03:05 volumio systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Aug 18 20:03:05 volumio systemd[1]: Condition check resulted in Kernel Configuration File System being skipped. Aug 18 20:03:05 volumio systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Aug 18 20:03:05 volumio systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Aug 18 20:03:05 volumio systemd[1]: Found device Ethernet Connection (6) I219-V. Aug 18 20:03:05 volumio systemd[1]: Found device Cannon Point-LP CNVi [Wireless-AC]. Aug 18 20:03:05 volumio systemd-udevd[324]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 0' failed with exit code 99. Aug 18 20:03:06 volumio systemd[1]: Mounted /boot. Aug 18 20:03:06 volumio systemd[1]: Reached target Local File Systems. Aug 18 20:03:06 volumio systemd[1]: Starting Create Volatile Files and Directories... Aug 18 20:03:06 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Aug 18 20:03:06 volumio systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Aug 18 20:03:06 volumio systemd[1]: Started ifup for wlan0. Aug 18 20:03:06 volumio systemd[1]: Started ifup for eth0. Aug 18 20:03:06 volumio systemd[1]: Starting Preprocess NFS configuration... Aug 18 20:03:06 volumio systemd[1]: Starting Raise network interfaces... Aug 18 20:03:06 volumio systemd[1]: Received SIGRTMIN+20 from PID 338 (plymouthd). Aug 18 20:03:06 volumio systemd[1]: plymouth-read-write.service: Succeeded. Aug 18 20:03:06 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Aug 18 20:03:07 volumio systemd[1]: nfs-config.service: Succeeded. Aug 18 20:03:07 volumio systemd[1]: Started Preprocess NFS configuration. Aug 18 20:03:07 volumio systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Aug 18 20:03:07 volumio systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Aug 18 20:03:07 volumio systemd[1]: Reached target NFS client services. Aug 18 20:03:09 volumio systemd[1]: systemd-rfkill.service: Succeeded. Aug 18 20:03:10 volumio systemd[1]: Started Raise network interfaces. Aug 18 20:03:10 volumio sh[447]: wlan0=wlan0 Aug 18 20:03:12 volumio systemd[1]: Started Create Volatile Files and Directories. Aug 18 20:03:12 volumio systemd[1]: Starting RPC bind portmap service... Aug 18 20:03:12 volumio systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Aug 18 20:03:12 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Aug 18 20:03:14 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Aug 18 20:03:14 volumio systemd[1]: Reached target System Initialization. Aug 18 20:03:14 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Aug 18 20:03:14 volumio systemd[1]: Started Daily man-db regeneration. Aug 18 20:03:14 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Aug 18 20:03:14 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Aug 18 20:03:14 volumio systemd[1]: Listening on mpd.socket. Aug 18 20:03:14 volumio systemd[1]: Reached target Sockets. Aug 18 20:03:14 volumio systemd[1]: Reached target Basic System. Aug 18 20:03:14 volumio systemd[1]: Started Volumio Log Rotation Service. Aug 18 20:03:14 volumio systemd[587]: volumiologrotate.service: Failed to execute command: No such file or directory Aug 18 20:03:14 volumio systemd[587]: volumiologrotate.service: Failed at step EXEC spawning /bin/volumiologrotate: No such file or directory Aug 18 20:03:14 volumio systemd[1]: Started D-Bus System Message Bus. Aug 18 20:03:14 volumio systemd[1]: Started volumio-remote-updater.service. Aug 18 20:03:14 volumio systemd[1]: Starting Disk Manager... Aug 18 20:03:14 volumio systemd[1]: Starting Login Service... Aug 18 20:03:14 volumio systemd[1]: Starting WPA supplicant... Aug 18 20:03:14 volumio systemd[1]: Started Volumio SSH enabler. Aug 18 20:03:14 volumio systemd[1]: Started Xbindrc. Aug 18 20:03:14 volumio systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Aug 18 20:03:14 volumio systemd[1]: Started Volumio Iptables Module. Aug 18 20:03:14 volumio systemd[1]: Started Manage Sound Card State (restore and store). Aug 18 20:03:14 volumio systemd[1]: Starting Save/Restore Sound Card State... Aug 18 20:03:14 volumio alsactl[596]: alsactl 1.1.8 daemon started Aug 18 20:03:14 volumio alsactl[597]: No state is present for card PCH Aug 18 20:03:14 volumio alsactl[597]: Found hardware: "HDA-Intel" "Realtek ALC233" "HDA:10ec0235,80862074,00100002 HDA:8086280b,80860101,00100000" "0x8086" "0x2074" Aug 18 20:03:14 volumio alsactl[597]: Hardware is initialized using a generic method Aug 18 20:03:14 volumio alsactl[597]: No state is present for card PCH Aug 18 20:03:14 volumio alsactl[596]: No state is present for card PCH Aug 18 20:03:14 volumio alsactl[596]: Found hardware: "HDA-Intel" "Realtek ALC233" "HDA:10ec0235,80862074,00100002 HDA:8086280b,80860101,00100000" "0x8086" "0x2074" Aug 18 20:03:14 volumio alsactl[596]: Hardware is initialized using a generic method Aug 18 20:03:14 volumio systemd[1]: Started cd.service. Aug 18 20:03:14 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Aug 18 20:03:14 volumio systemd[1]: Started Daily apt download activities. Aug 18 20:03:14 volumio systemd[1]: Started Daily apt upgrade and clean activities. Aug 18 20:03:14 volumio systemd[1]: Reached target Timers. Aug 18 20:03:14 volumio systemd[1]: Starting DHCP Client Daemon... Aug 18 20:03:14 volumio systemd[1]: Starting Wireless Services... Aug 18 20:03:14 volumio systemd[1]: volumiologrotate.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:03:14 volumio systemd[1]: volumiologrotate.service: Failed with result 'exit-code'. Aug 18 20:03:14 volumio systemd[1]: volumiossh.service: Succeeded. Aug 18 20:03:14 volumio systemd[1]: Started Save/Restore Sound Card State. Aug 18 20:03:14 volumio systemd[1]: Reached target Sound Card. Aug 18 20:03:14 volumio alsactl[596]: No state is present for card PCH Aug 18 20:03:14 volumio systemd-logind[591]: New seat seat0. Aug 18 20:03:14 volumio systemd-logind[591]: Watching system buttons on /dev/input/event3 (Power Button) Aug 18 20:03:14 volumio avahi-daemon[599]: Found user 'avahi' (UID 111) and group 'avahi' (GID 112). Aug 18 20:03:14 volumio avahi-daemon[599]: Successfully dropped root privileges. Aug 18 20:03:14 volumio avahi-daemon[599]: avahi-daemon 0.7 starting up. Aug 18 20:03:14 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Aug 18 20:03:14 volumio avahi-daemon[599]: Successfully called chroot(). Aug 18 20:03:14 volumio avahi-daemon[599]: Successfully dropped remaining capabilities. Aug 18 20:03:14 volumio avahi-daemon[599]: No service file found in /etc/avahi/services. Aug 18 20:03:15 volumio systemd-logind[591]: Watching system buttons on /dev/input/event2 (Power Button) Aug 18 20:03:15 volumio systemd-logind[591]: Watching system buttons on /dev/input/event1 (Sleep Button) Aug 18 20:03:15 volumio systemd-logind[591]: Watching system buttons on /dev/input/event0 (CHICONY USB Keyboard) Aug 18 20:03:15 volumio volumio[598]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Aug 18 20:03:15 volumio systemd[1]: cd.service: Main process exited, code=exited, status=127/n/a Aug 18 20:03:15 volumio systemd[1]: cd.service: Failed with result 'exit-code'. Aug 18 20:03:15 volumio systemd[1]: Started WPA supplicant. Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:15 volumio wpa_supplicant[592]: Successfully initialized wpa_supplicant Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Scheduled restart job, restart counter is at 1. Aug 18 20:03:15 volumio systemd[1]: Stopped Volumio Log Rotation Service. Aug 18 20:03:15 volumio systemd[1]: Started Volumio Log Rotation Service. Aug 18 20:03:15 volumio systemd[1]: Reached target Network. Aug 18 20:03:15 volumio systemd[1]: Reached target Network is Online. Aug 18 20:03:15 volumio systemd[614]: volumiologrotate.service: Failed to execute command: No such file or directory Aug 18 20:03:15 volumio systemd[614]: volumiologrotate.service: Failed at step EXEC spawning /bin/volumiologrotate: No such file or directory Aug 18 20:03:15 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Aug 18 20:03:15 volumio systemd[1]: Starting Network Time Service... Aug 18 20:03:15 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 20:03:15 volumio systemd[617]: shairport-sync.service: Failed to execute command: No such file or directory Aug 18 20:03:15 volumio systemd[617]: shairport-sync.service: Failed at step EXEC spawning /usr/local/bin/shairport-sync: No such file or directory Aug 18 20:03:15 volumio systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Aug 18 20:03:15 volumio systemd[1]: Starting /etc/rc.local Compatibility... Aug 18 20:03:15 volumio systemd[1]: Starting Samba NMB Daemon... Aug 18 20:03:15 volumio systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Aug 18 20:03:15 volumio systemd[1]: Starting Music Player Daemon... Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Failed with result 'exit-code'. Aug 18 20:03:15 volumio systemd[1]: shairport-sync.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:03:15 volumio systemd[1]: shairport-sync.service: Failed with result 'exit-code'. Aug 18 20:03:15 volumio udisksd[590]: udisks daemon version 2.8.1 starting Aug 18 20:03:15 volumio sh[448]: eth0: waiting for carrier Aug 18 20:03:15 volumio dhcpcd[498]: eth0: waiting for carrier Aug 18 20:03:15 volumio systemd[1]: Started RPC bind portmap service. Aug 18 20:03:15 volumio systemd[1]: cd.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:15 volumio systemd[1]: cd.service: Scheduled restart job, restart counter is at 1. Aug 18 20:03:15 volumio systemd[1]: Stopped cd.service. Aug 18 20:03:15 volumio systemd[1]: Started cd.service. Aug 18 20:03:15 volumio systemd[1]: Reached target Remote File Systems (Pre). Aug 18 20:03:15 volumio systemd[1]: Reached target Remote File Systems. Aug 18 20:03:15 volumio avahi-daemon[599]: Network interface enumeration completed. Aug 18 20:03:15 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Aug 18 20:03:15 volumio avahi-daemon[599]: Server startup complete. Host name is volumio.local. Local service cookie is 1708389147. Aug 18 20:03:15 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Aug 18 20:03:15 volumio volumio[643]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Aug 18 20:03:15 volumio systemd[1]: Starting Permit User Sessions... Aug 18 20:03:15 volumio systemd[1]: Started mount disks automatically with standby. Aug 18 20:03:15 volumio systemd[1]: Reached target RPC Port Mapper. Aug 18 20:03:15 volumio systemd[1]: cd.service: Main process exited, code=exited, status=127/n/a Aug 18 20:03:15 volumio systemd[1]: cd.service: Failed with result 'exit-code'. Aug 18 20:03:15 volumio systemd[659]: udisks-glue.service: Failed to execute command: No such file or directory Aug 18 20:03:15 volumio systemd[659]: udisks-glue.service: Failed at step EXEC spawning /usr/bin/udisks-glue: No such file or directory Aug 18 20:03:15 volumio dhcpcd[600]: no interfaces have a carrier Aug 18 20:03:15 volumio dhcpcd[600]: no interfaces have a carrier Aug 18 20:03:15 volumio dhcpcd[670]: eth0: waiting for carrier Aug 18 20:03:15 volumio dhcpcd[670]: wlan0: waiting for carrier Aug 18 20:03:15 volumio dhcpcd[600]: forked to background, child pid 670 Aug 18 20:03:15 volumio dhcpcd[600]: forked to background, child pid 670 Aug 18 20:03:15 volumio systemd[1]: Started DHCP Client Daemon. Aug 18 20:03:15 volumio systemd[1]: udisks-glue.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:03:15 volumio systemd[1]: udisks-glue.service: Failed with result 'exit-code'. Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Scheduled restart job, restart counter is at 2. Aug 18 20:03:15 volumio systemd[1]: Started Permit User Sessions. Aug 18 20:03:15 volumio systemd[1]: Stopped Volumio Log Rotation Service. Aug 18 20:03:15 volumio systemd[1]: Started Volumio Log Rotation Service. Aug 18 20:03:15 volumio ntpd[616]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 18 20:03:15 volumio ntpd[616]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Aug 18 20:03:15 volumio systemd[1]: Started Network Time Service. Aug 18 20:03:15 volumio systemd[694]: volumiologrotate.service: Failed to execute command: No such file or directory Aug 18 20:03:15 volumio systemd[694]: volumiologrotate.service: Failed at step EXEC spawning /bin/volumiologrotate: No such file or directory Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Failed with result 'exit-code'. Aug 18 20:03:15 volumio ntpd[696]: proto: precision = 0.114 usec (-23) Aug 18 20:03:15 volumio ntpd[696]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 18 20:03:15 volumio ntpd[696]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2020-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 18 20:03:15 volumio ntpd[696]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 52 days ago Aug 18 20:03:15 volumio hostapd[622]: Configuration file: /etc/hostapd/hostapd.conf Aug 18 20:03:15 volumio ifplugd(eth0)[721]: ifplugd 0.28 initializing. Aug 18 20:03:15 volumio ifplugd(eth0)[721]: Using interface eth0/1C:69:7A:05:1A:AE with driver (version: 3.2.6-k) Aug 18 20:03:15 volumio ifplugd(eth0)[721]: Using detection mode: SIOCETHTOOL Aug 18 20:03:15 volumio ifplugd(eth0)[721]: Initialization complete, link beat not detected. Aug 18 20:03:15 volumio sudo[602]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Aug 18 20:03:15 volumio sudo[602]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:15 volumio ntpd[696]: Listen and drop on 0 v6wildcard [::]:123 Aug 18 20:03:15 volumio ntpd[696]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 18 20:03:15 volumio udisksd[590]: failed to load module crypto: libbd_crypto.so.2: cannot open shared object file: No such file or directory Aug 18 20:03:15 volumio udisksd[590]: failed to load module mdraid: libbd_mdraid.so.2: cannot open shared object file: No such file or directory Aug 18 20:03:15 volumio sudo[602]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:15 volumio systemd[1]: cd.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:15 volumio systemd[1]: cd.service: Scheduled restart job, restart counter is at 2. Aug 18 20:03:15 volumio systemd[1]: Stopped cd.service. Aug 18 20:03:15 volumio systemd[1]: Started cd.service. Aug 18 20:03:15 volumio systemd[1]: iptables.service: Succeeded. Aug 18 20:03:15 volumio systemd[1]: Started Login Service. Aug 18 20:03:15 volumio ifplugd[653]: Network Interface Plugging Daemon...start eth0...done. Aug 18 20:03:15 volumio systemd[1]: Started LSB: Brings up/down network automatically. Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Scheduled restart job, restart counter is at 3. Aug 18 20:03:15 volumio systemd[1]: Stopped Volumio Log Rotation Service. Aug 18 20:03:15 volumio systemd[1]: Started Volumio Log Rotation Service. Aug 18 20:03:15 volumio systemd[751]: volumiologrotate.service: Failed to execute command: No such file or directory Aug 18 20:03:15 volumio systemd[751]: volumiologrotate.service: Failed at step EXEC spawning /bin/volumiologrotate: No such file or directory Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Failed with result 'exit-code'. Aug 18 20:03:15 volumio ntpd[696]: Listen normally on 2 lo 127.0.0.1:123 Aug 18 20:03:15 volumio ntpd[696]: Listening on routing socket on fd #19 for interface updates Aug 18 20:03:15 volumio ntpd[696]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 18 20:03:15 volumio ntpd[696]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 18 20:03:15 volumio hostapd[622]: Using interface wlan0 with hwaddr 98:2c:bc:e8:a7:56 and ssid "Volumio" Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Scheduled restart job, restart counter is at 4. Aug 18 20:03:15 volumio systemd[1]: Stopped Volumio Log Rotation Service. Aug 18 20:03:15 volumio systemd[1]: Started Volumio Log Rotation Service. Aug 18 20:03:15 volumio systemd[753]: volumiologrotate.service: Failed to execute command: No such file or directory Aug 18 20:03:15 volumio systemd[753]: volumiologrotate.service: Failed at step EXEC spawning /bin/volumiologrotate: No such file or directory Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Failed with result 'exit-code'. Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Scheduled restart job, restart counter is at 5. Aug 18 20:03:15 volumio systemd[1]: Stopped Volumio Log Rotation Service. Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Start request repeated too quickly. Aug 18 20:03:15 volumio systemd[1]: volumiologrotate.service: Failed with result 'exit-code'. Aug 18 20:03:15 volumio systemd[1]: Failed to start Volumio Log Rotation Service. Aug 18 20:03:17 volumio sh[448]: eth0: carrier acquired Aug 18 20:03:17 volumio dhcpcd[670]: eth0: carrier acquired Aug 18 20:03:17 volumio dhcpcd[498]: eth0: carrier acquired Aug 18 20:03:17 volumio ntpd[696]: error resolving pool 0.debian.pool.ntp.org: Name or service not known (-2) Aug 18 20:03:17 volumio systemd[1]: xbindkeysrc.service: Succeeded. Aug 18 20:03:17 volumio udisksd[590]: Failed to load the 'mdraid' libblockdev plugin Aug 18 20:03:17 volumio dbus-daemon[588]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.3' (uid=0 pid=590 comm="/usr/lib/udisks2/udisksd ") Aug 18 20:03:17 volumio udisksd[590]: Failed to load the 'crypto' libblockdev plugin Aug 18 20:03:17 volumio systemd[1]: Starting Authorization Manager... Aug 18 20:03:17 volumio volumio[741]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Aug 18 20:03:17 volumio systemd[1]: cd.service: Main process exited, code=exited, status=127/n/a Aug 18 20:03:17 volumio systemd[1]: cd.service: Failed with result 'exit-code'. Aug 18 20:03:17 volumio dhcpcd[670]: wlan0: carrier acquired Aug 18 20:03:17 volumio volumio-remote-updater[589]: Error: No active session Aug 18 20:03:17 volumio volumio-remote-updater[589]: [2020-08-18 20:03:17] [info] asio async_connect error: system:111 (Connection refused) Aug 18 20:03:17 volumio volumio-remote-updater[589]: [2020-08-18 20:03:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 18 20:03:17 volumio volumio-remote-updater[589]: [2020-08-18 20:03:17] [error] handle_connect error: Underlying Transport Error Aug 18 20:03:17 volumio hostapd[622]: wlan0: interface state UNINITIALIZED->ENABLED Aug 18 20:03:17 volumio hostapd[622]: wlan0: AP-ENABLED Aug 18 20:03:17 volumio systemd[1]: hostapd.service: Can't open PID file /run/hostapd.pid (yet?) after start: No such file or directory Aug 18 20:03:17 volumio systemd[1]: Started Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Aug 18 20:03:17 volumio polkitd[768]: started daemon version 0.105 using authority implementation `local' version `0.105' Aug 18 20:03:17 volumio dbus-daemon[588]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Aug 18 20:03:17 volumio systemd[1]: Started Authorization Manager. Aug 18 20:03:17 volumio systemd[1]: xbindkeysrc.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:17 volumio systemd[1]: xbindkeysrc.service: Scheduled restart job, restart counter is at 1. Aug 18 20:03:17 volumio systemd[1]: Stopped Xbindrc. Aug 18 20:03:17 volumio systemd[1]: Started Xbindrc. Aug 18 20:03:17 volumio loadcpufreq[644]: Loading cpufreq kernel modules...done (acpi-cpufreq). Aug 18 20:03:17 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Aug 18 20:03:17 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Aug 18 20:03:17 volumio netplugd[861]: /etc/netplug/netplug eth0 in -> pid 861 Aug 18 20:03:17 volumio systemd[1]: Started LSB: Brings up/down network automatically. Aug 18 20:03:17 volumio systemd[1]: xbindkeysrc.service: Succeeded. Aug 18 20:03:17 volumio systemd[1]: cd.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:17 volumio systemd[1]: cd.service: Scheduled restart job, restart counter is at 3. Aug 18 20:03:17 volumio systemd[1]: Stopped cd.service. Aug 18 20:03:17 volumio systemd[1]: Started cd.service. Aug 18 20:03:18 volumio dhcpcd[670]: eth0: soliciting a DHCP lease Aug 18 20:03:18 volumio systemd[1]: xbindkeysrc.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:18 volumio systemd[1]: xbindkeysrc.service: Scheduled restart job, restart counter is at 2. Aug 18 20:03:18 volumio systemd[1]: Stopped Xbindrc. Aug 18 20:03:18 volumio systemd[1]: Started Xbindrc. Aug 18 20:03:18 volumio ntpd[696]: error resolving pool 1.debian.pool.ntp.org: Name or service not known (-2) Aug 18 20:03:18 volumio ifplugd(eth0)[721]: Link beat detected. Aug 18 20:03:18 volumio ifplugd(eth0)[721]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Aug 18 20:03:18 volumio sh[448]: eth0: soliciting a DHCP lease Aug 18 20:03:18 volumio dhcpcd[498]: eth0: soliciting a DHCP lease Aug 18 20:03:18 volumio sh[448]: eth0: offered 192.168.1.5 from 192.168.1.1 Aug 18 20:03:18 volumio dhcpcd[498]: eth0: offered 192.168.1.5 from 192.168.1.1 Aug 18 20:03:18 volumio sh[448]: eth0: leased 192.168.1.5 for 86400 seconds Aug 18 20:03:18 volumio dhcpcd[498]: eth0: leased 192.168.1.5 for 86400 seconds Aug 18 20:03:19 volumio dhcpcd[670]: wlan0: soliciting a DHCP lease Aug 18 20:03:19 volumio dhcpcd[498]: eth0: adding route to 192.168.1.0/24 Aug 18 20:03:19 volumio sh[448]: eth0: adding route to 192.168.1.0/24 Aug 18 20:03:19 volumio sh[448]: eth0: adding default route via 192.168.1.1 Aug 18 20:03:19 volumio avahi-daemon[599]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.5. Aug 18 20:03:19 volumio dhcpcd[498]: eth0: adding default route via 192.168.1.1 Aug 18 20:03:19 volumio avahi-daemon[599]: New relevant interface eth0.IPv4 for mDNS. Aug 18 20:03:19 volumio avahi-daemon[599]: Registering new address record for 192.168.1.5 on eth0.IPv4. Aug 18 20:03:19 volumio ntpd[696]: Soliciting pool server 200.25.3.17 Aug 18 20:03:20 volumio ntpd[696]: Listen normally on 3 eth0 192.168.1.5:123 Aug 18 20:03:20 volumio ntpd[696]: new interface(s) found: waking up resolver Aug 18 20:03:20 volumio ntpd[696]: Soliciting pool server 162.159.200.1 Aug 18 20:03:21 volumio ntpd[696]: Soliciting pool server 162.159.200.123 Aug 18 20:03:21 volumio ifplugd(eth0)[721]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Aug 18 20:03:21 volumio volumio[867]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Aug 18 20:03:21 volumio systemd[1]: cd.service: Main process exited, code=exited, status=127/n/a Aug 18 20:03:21 volumio systemd[1]: cd.service: Failed with result 'exit-code'. Aug 18 20:03:21 volumio systemd[1]: xbindkeysrc.service: Succeeded. Aug 18 20:03:21 volumio cpufrequtils[849]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Aug 18 20:03:21 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Aug 18 20:03:21 volumio systemd[1]: cd.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:21 volumio systemd[1]: cd.service: Scheduled restart job, restart counter is at 4. Aug 18 20:03:21 volumio systemd[1]: xbindkeysrc.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:21 volumio systemd[1]: xbindkeysrc.service: Scheduled restart job, restart counter is at 3. Aug 18 20:03:21 volumio systemd[1]: Stopped Xbindrc. Aug 18 20:03:21 volumio systemd[1]: Started Xbindrc. Aug 18 20:03:21 volumio systemd[1]: Stopped cd.service. Aug 18 20:03:21 volumio systemd[1]: Started cd.service. Aug 18 20:03:21 volumio volumio[978]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Aug 18 20:03:21 volumio systemd[1]: cd.service: Main process exited, code=exited, status=127/n/a Aug 18 20:03:21 volumio systemd[1]: cd.service: Failed with result 'exit-code'. Aug 18 20:03:21 volumio systemd[1]: xbindkeysrc.service: Succeeded. Aug 18 20:03:21 volumio dhcpcd[670]: eth0: offered 192.168.1.5 from 192.168.1.1 Aug 18 20:03:21 volumio dhcpcd[670]: eth0: leased 192.168.1.5 for 86400 seconds Aug 18 20:03:21 volumio dhcpcd[670]: eth0: adding route to 192.168.1.0/24 Aug 18 20:03:21 volumio dhcpcd[670]: eth0: adding default route via 192.168.1.1 Aug 18 20:03:21 volumio systemd[1]: cd.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:21 volumio systemd[1]: cd.service: Scheduled restart job, restart counter is at 5. Aug 18 20:03:21 volumio systemd[1]: xbindkeysrc.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:21 volumio systemd[1]: xbindkeysrc.service: Scheduled restart job, restart counter is at 4. Aug 18 20:03:21 volumio systemd[1]: Stopped Xbindrc. Aug 18 20:03:21 volumio systemd[1]: Started Xbindrc. Aug 18 20:03:21 volumio systemd[1]: Stopped cd.service. Aug 18 20:03:21 volumio systemd[1]: cd.service: Start request repeated too quickly. Aug 18 20:03:21 volumio systemd[1]: cd.service: Failed with result 'exit-code'. Aug 18 20:03:21 volumio systemd[1]: Failed to start cd.service. Aug 18 20:03:21 volumio systemd[1]: xbindkeysrc.service: Succeeded. Aug 18 20:03:22 volumio systemd[1]: xbindkeysrc.service: Service RestartSec=100ms expired, scheduling restart. Aug 18 20:03:22 volumio systemd[1]: xbindkeysrc.service: Scheduled restart job, restart counter is at 5. Aug 18 20:03:22 volumio systemd[1]: Stopped Xbindrc. Aug 18 20:03:22 volumio systemd[1]: xbindkeysrc.service: Start request repeated too quickly. Aug 18 20:03:22 volumio systemd[1]: xbindkeysrc.service: Failed with result 'start-limit-hit'. Aug 18 20:03:22 volumio systemd[1]: Failed to start Xbindrc. Aug 18 20:03:22 volumio ntpd[696]: Soliciting pool server 212.7.1.131 Aug 18 20:03:22 volumio systemd[1]: Started /etc/rc.local Compatibility. Aug 18 20:03:22 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Aug 18 20:03:22 volumio systemd[1]: Starting Hold until boot process finishes up... Aug 18 20:03:22 volumio systemd[1]: Received SIGRTMIN+21 from PID 338 (plymouthd). Aug 18 20:03:22 volumio ntpd[696]: ntpd exiting on signal 15 (Terminated) Aug 18 20:03:22 volumio ntpd[696]: 162.159.200.1 local addr 192.168.1.5 -> Aug 18 20:03:22 volumio systemd[1]: Stopping Network Time Service... Aug 18 20:03:22 volumio ntpd[696]: 162.159.200.123 local addr 192.168.1.5 -> Aug 18 20:03:22 volumio ntpd[696]: 212.7.1.131 local addr 192.168.1.5 -> Aug 18 20:03:22 volumio systemd[1]: Received SIGRTMIN+21 from PID 338 (plymouthd). Aug 18 20:03:22 volumio systemd[1]: plymouth-start.service: Succeeded. Aug 18 20:03:22 volumio systemd[1]: plymouth-quit.service: Succeeded. Aug 18 20:03:22 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Aug 18 20:03:22 volumio systemd[1]: plymouth-quit-wait.service: Succeeded. Aug 18 20:03:22 volumio systemd[1]: Started Hold until boot process finishes up. Aug 18 20:03:22 volumio systemd[1]: Started Getty on tty1. Aug 18 20:03:22 volumio systemd[1]: Reached target Login Prompts. Aug 18 20:03:22 volumio systemd[1]: ntp.service: Succeeded. Aug 18 20:03:22 volumio systemd[1]: Stopped Network Time Service. Aug 18 20:03:22 volumio systemd[1]: Starting Network Time Service... Aug 18 20:03:22 volumio ntpd[1044]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 18 20:03:22 volumio ntpd[1044]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Aug 18 20:03:22 volumio systemd[1]: Started Network Time Service. Aug 18 20:03:22 volumio ntpd[1051]: proto: precision = 0.102 usec (-23) Aug 18 20:03:22 volumio ntpd[1051]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 18 20:03:22 volumio ntpd[1051]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2020-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 18 20:03:22 volumio ntpd[1051]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 52 days ago Aug 18 20:03:22 volumio ntpd[1051]: Listen and drop on 0 v6wildcard [::]:123 Aug 18 20:03:22 volumio ntpd[1051]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 18 20:03:22 volumio ntpd[1051]: Listen normally on 2 lo 127.0.0.1:123 Aug 18 20:03:22 volumio ntpd[1051]: Listen normally on 3 eth0 192.168.1.5:123 Aug 18 20:03:22 volumio ntpd[1051]: Listening on routing socket on fd #20 for interface updates Aug 18 20:03:22 volumio ntpd[1051]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 18 20:03:22 volumio ntpd[1051]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 18 20:03:22 volumio sh[448]: forked to background, child pid 1053 Aug 18 20:03:22 volumio dhcpcd[498]: forked to background, child pid 1053 Aug 18 20:03:22 volumio systemd[1]: Started Disk Manager. Aug 18 20:03:22 volumio udisksd[590]: Acquired the name org.freedesktop.UDisks2 on the system message bus Aug 18 20:03:22 volumio volumio-remote-updater[589]: [2020-08-18 20:03:22] [info] asio async_connect error: system:111 (Connection refused) Aug 18 20:03:22 volumio volumio-remote-updater[589]: [2020-08-18 20:03:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 18 20:03:22 volumio volumio-remote-updater[589]: [2020-08-18 20:03:22] [error] handle_connect error: Underlying Transport Error Aug 18 20:03:23 volumio nmbd[627]: mkdir failed on directory /var/log/samba/cores: No such file or directory Aug 18 20:03:23 volumio nmbd[627]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Aug 18 20:03:23 volumio nmbd[627]: Unable to setup corepath for nmbd: No such file or directory Aug 18 20:03:23 volumio nmbd[627]: [2020/08/18 20:03:23.215103, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:23 volumio nmbd[627]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Aug 18 20:03:23 volumio nmbd[627]: [2020/08/18 20:03:23.215103, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:23 volumio nmbd[627]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Aug 18 20:03:24 volumio nmbd[627]: [2020/08/18 20:03:24.411670, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:24 volumio nmbd[627]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Aug 18 20:03:24 volumio nmbd[627]: [2020/08/18 20:03:24.411670, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:24 volumio nmbd[627]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Aug 18 20:03:24 volumio nmbd[627]: [2020/08/18 20:03:24.412057, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Aug 18 20:03:24 volumio nmbd[627]: started asyncdns process 1080 Aug 18 20:03:24 volumio nmbd[627]: [2020/08/18 20:03:24.422987, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 18 20:03:24 volumio systemd[1]: Started Samba NMB Daemon. Aug 18 20:03:24 volumio nmbd[627]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Aug 18 20:03:24 volumio systemd[1]: Starting Samba Winbind Daemon... Aug 18 20:03:27 volumio winbindd[1081]: mkdir failed on directory /var/log/samba/cores: No such file or directory Aug 18 20:03:27 volumio winbindd[1081]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Aug 18 20:03:27 volumio winbindd[1081]: Unable to setup corepath for winbindd: No such file or directory Aug 18 20:03:27 volumio winbindd[1081]: mkdir failed on directory /var/log/samba/cores: No such file or directory Aug 18 20:03:27 volumio winbindd[1081]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Aug 18 20:03:27 volumio winbindd[1081]: Unable to setup corepath for winbindd: No such file or directory Aug 18 20:03:27 volumio winbindd[1081]: [2020/08/18 20:03:27.026245, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:27 volumio winbindd[1081]: [2020/08/18 20:03:27.026245, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:27 volumio winbindd[1081]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Aug 18 20:03:27 volumio winbindd[1081]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Aug 18 20:03:27 volumio winbindd[1081]: [2020/08/18 20:03:27.026779, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:27 volumio winbindd[1081]: [2020/08/18 20:03:27.026779, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:27 volumio winbindd[1081]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Aug 18 20:03:27 volumio winbindd[1081]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Aug 18 20:03:27 volumio winbindd[1081]: [2020/08/18 20:03:27.033681, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Aug 18 20:03:27 volumio winbindd[1081]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Aug 18 20:03:27 volumio ifplugd(eth0)[721]: client: ifup: interface eth0 already configured Aug 18 20:03:27 volumio netplugd[860]: eth0: state INNING pid 861 exited status 0 Aug 18 20:03:27 volumio sh[448]: eth0=eth0 Aug 18 20:03:27 volumio ifplugd(eth0)[721]: Program executed successfully. Aug 18 20:03:27 volumio ntpd[1051]: Soliciting pool server 62.202.141.23 Aug 18 20:03:27 volumio ntpd[1051]: Soliciting pool server 195.113.20.2 Aug 18 20:03:28 volumio wireless.js[740]: Cleaning previous... Aug 18 20:03:28 volumio ntpd[1051]: Soliciting pool server 129.70.132.35 Aug 18 20:03:29 volumio ntpd[1051]: Soliciting pool server 94.154.96.7 Aug 18 20:03:30 volumio volumio-remote-updater[589]: [2020-08-18 20:03:30] [info] asio async_connect error: system:111 (Connection refused) Aug 18 20:03:30 volumio volumio-remote-updater[589]: [2020-08-18 20:03:30] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 18 20:03:30 volumio volumio-remote-updater[589]: [2020-08-18 20:03:30] [error] handle_connect error: Underlying Transport Error Aug 18 20:03:30 volumio mpd[629]: config_file: config parameter "gapless_mp3_playback" on line 19 is deprecated Aug 18 20:03:30 volumio mpd[629]: config_file: config parameter "buffer_before_play" on line 66 is deprecated Aug 18 20:03:30 volumio mpd[629]: config_file: config parameter "id3v1_encoding" on line 80 is deprecated Aug 18 20:03:30 volumio mpd[629]: Aug 18 20:03 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 18 20:03:30 volumio mpd[629]: Aug 18 20:03 : exception: Database corrupted Aug 18 20:03:30 volumio systemd[1]: Started Music Player Daemon. Aug 18 20:03:31 volumio ntpd[1051]: Soliciting pool server 213.251.52.202 Aug 18 20:03:31 volumio ntpd[1051]: Soliciting pool server 91.209.0.20 Aug 18 20:03:31 volumio ntpd[1051]: Soliciting pool server 162.159.200.1 Aug 18 20:03:31 volumio ntpd[1051]: Soliciting pool server 193.182.111.12 Aug 18 20:03:32 volumio ntpd[1051]: Soliciting pool server 158.174.65.248 Aug 18 20:03:32 volumio ntpd[1051]: Soliciting pool server 192.36.143.130 Aug 18 20:03:33 volumio sudo[1115]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 18 20:03:33 volumio sudo[1115]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:33 volumio sudo[1115]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:33 volumio sudo[1120]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 18 20:03:33 volumio sudo[1120]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:33 volumio dhcpcd[670]: wlan0: carrier lost Aug 18 20:03:33 volumio sudo[1120]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:33 volumio wireless.js[740]: Stopped aP Aug 18 20:03:33 volumio sudo[1159]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 18 20:03:33 volumio sudo[1159]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:33 volumio sudo[1159]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:33 volumio sudo[1161]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 18 20:03:33 volumio sudo[1161]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:33 volumio sudo[1161]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:33 volumio avahi-daemon[599]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Aug 18 20:03:33 volumio avahi-daemon[599]: New relevant interface wlan0.IPv4 for mDNS. Aug 18 20:03:33 volumio avahi-daemon[599]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Aug 18 20:03:33 volumio dhcpcd[670]: wlan0: carrier acquired Aug 18 20:03:33 volumio systemd[1]: Started hotspot.service. Aug 18 20:03:33 volumio systemd[1]: Starting dhcpd.service... Aug 18 20:03:33 volumio systemd[1]: Starting dnsmasq.service... Aug 18 20:03:33 volumio systemd[1]: wireless.service: Succeeded. Aug 18 20:03:33 volumio systemd[1]: Started Wireless Services. Aug 18 20:03:33 volumio systemd[1]: Started Volumio Backend Module. Aug 18 20:03:33 volumio systemd[1]: Started Volumio Streaming Daemon. Aug 18 20:03:33 volumio systemd[1]: Started Start Volumio Kiosk. Aug 18 20:03:33 volumio systemd[1]: Started First Start. Aug 18 20:03:33 volumio ntpd[1051]: Soliciting pool server 83.168.200.198 Aug 18 20:03:33 volumio ntpd[1051]: Soliciting pool server 83.168.200.199 Aug 18 20:03:33 volumio dhcpcd[670]: wlan0: soliciting a DHCP lease Aug 18 20:03:34 volumio dnsmasq[1189]: started, version 2.80 cachesize 150 Aug 18 20:03:34 volumio dnsmasq[1189]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile Aug 18 20:03:34 volumio systemd[1]: Started dnsmasq.service. Aug 18 20:03:34 volumio dnsmasq[1189]: reading /etc/resolv.conf Aug 18 20:03:34 volumio dnsmasq[1189]: using nameserver 192.168.1.1#53 Aug 18 20:03:34 volumio dnsmasq[1189]: using nameserver 208.67.222.222#53 Aug 18 20:03:34 volumio dnsmasq[1189]: using nameserver 208.67.220.220#53 Aug 18 20:03:34 volumio dnsmasq[1189]: read /etc/hosts - 4 addresses Aug 18 20:03:34 volumio startx[1172]: xauth: file /home/volumio/.Xauthority does not exist Aug 18 20:03:34 volumio ntpd[1051]: Soliciting pool server 2001:67c:2e74:1::20 Aug 18 20:03:34 volumio ntpd[1051]: Listen normally on 4 wlan0 192.168.211.1:123 Aug 18 20:03:34 volumio ntpd[1051]: new interface(s) found: waking up resolver Aug 18 20:03:35 volumio systemd[1]: systemd-fsckd.service: Succeeded. Aug 18 20:03:35 volumio ntpd[1051]: Soliciting pool server 193.182.111.143 Aug 18 20:03:35 volumio ntpd[1051]: Soliciting pool server 91.209.0.17 Aug 18 20:03:36 volumio firststart.sh[1177]: Volumio first start configuration script Aug 18 20:03:36 volumio firststart.sh[1177]: configuring unconfigured packages Aug 18 20:03:36 volumio ntpd[1051]: Soliciting pool server 81.170.175.117 Aug 18 20:03:37 volumio ntpd[1051]: Soliciting pool server 193.182.111.14 Aug 18 20:03:38 volumio systemd[1]: Started Samba Winbind Daemon. Aug 18 20:03:38 volumio systemd[1]: Starting Samba SMB Daemon... Aug 18 20:03:38 volumio winbindd[1081]: [2020/08/18 20:03:38.122564, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 18 20:03:38 volumio winbindd[1081]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Aug 18 20:03:38 volumio winbindd[1210]: [2020/08/18 20:03:38.131992, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:38 volumio winbindd[1210]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory Aug 18 20:03:38 volumio startx[1172]: X.Org X Server 1.20.4 Aug 18 20:03:38 volumio startx[1172]: X Protocol Version 11, Revision 0 Aug 18 20:03:38 volumio startx[1172]: Build Operating System: Linux 4.9.0-8-amd64 i686 Debian Aug 18 20:03:38 volumio startx[1172]: Current Operating System: Linux volumio 4.19.106+ #1 SMP Mon Feb 17 12:34:48 CET 2020 i686 Aug 18 20:03:38 volumio startx[1172]: Kernel command line: BOOT_IMAGE=/vmlinuz-4.19.106+ imgpart=UUID=eefd3f2b-9ece-443f-9b90-100fb6931f3f ro net.ifnames=0 biosdevname=0 bootpart=UUID=873E-E5FA datapart=UUID=44ebc161-ff65-40bd-9b36-8adc7b16122c imgfile=volumio_current.sqsh plymouth.ignore-serial-consoles vt.global_cursor_default=0 loglevel=8 Aug 18 20:03:38 volumio startx[1172]: Build Date: 05 March 2019 08:11:12PM Aug 18 20:03:38 volumio startx[1172]: xorg-server 2:1.20.4-1 (https://www.debian.org/support) Aug 18 20:03:38 volumio startx[1172]: Current version of pixman: 0.36.0 Aug 18 20:03:38 volumio startx[1172]: Before reporting problems, check http://wiki.x.org Aug 18 20:03:38 volumio startx[1172]: to make sure that you have the latest version. Aug 18 20:03:38 volumio startx[1172]: Markers: (--) probed, (**) from config file, (==) default setting, Aug 18 20:03:38 volumio startx[1172]: (++) from command line, (!!) notice, (II) informational, Aug 18 20:03:38 volumio startx[1172]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Aug 18 20:03:38 volumio startx[1172]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Aug 18 20:03:38 2020 Aug 18 20:03:38 volumio startx[1172]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Aug 18 20:03:38 volumio dhcpd[1207]: Internet Systems Consortium DHCP Server 4.4.1 Aug 18 20:03:38 volumio hotspot[1168]: Internet Systems Consortium DHCP Server 4.4.1 Aug 18 20:03:38 volumio hotspot[1168]: Copyright 2004-2018 Internet Systems Consortium. Aug 18 20:03:38 volumio hotspot[1168]: All rights reserved. Aug 18 20:03:38 volumio hotspot[1168]: For info, please visit https://www.isc.org/software/dhcp/ Aug 18 20:03:38 volumio dhcpd[1207]: Copyright 2004-2018 Internet Systems Consortium. Aug 18 20:03:38 volumio dhcpd[1207]: All rights reserved. Aug 18 20:03:38 volumio dhcpd[1207]: For info, please visit https://www.isc.org/software/dhcp/ Aug 18 20:03:38 volumio dhcpd[1207]: Config file: /etc/dhcp/dhcpd.conf Aug 18 20:03:38 volumio hotspot[1168]: Config file: /etc/dhcp/dhcpd.conf Aug 18 20:03:38 volumio hotspot[1168]: Database file: /var/lib/dhcp/dhcpd.leases Aug 18 20:03:38 volumio hotspot[1168]: PID file: /var/run/dhcpd.pid Aug 18 20:03:38 volumio dhcpd[1207]: Database file: /var/lib/dhcp/dhcpd.leases Aug 18 20:03:38 volumio dhcpd[1207]: PID file: /var/run/dhcpd.pid Aug 18 20:03:38 volumio dhcpd[1207]: Internet Systems Consortium DHCP Server 4.4.1 Aug 18 20:03:38 volumio hotspot[1168]: Can't open lease database /var/lib/dhcp/dhcpd.leases: No such file or directory -- Aug 18 20:03:38 volumio hotspot[1168]: check for failed database rewrite attempt! Aug 18 20:03:38 volumio hotspot[1168]: Please read the dhcpd.leases manual page if you Aug 18 20:03:38 volumio hotspot[1168]: don't know what to do about this. Aug 18 20:03:38 volumio hotspot[1168]: If you think you have received this message due to a bug rather Aug 18 20:03:38 volumio hotspot[1168]: than a configuration issue please read the section on submitting Aug 18 20:03:38 volumio hotspot[1168]: bugs on either our web page at www.isc.org or in the README file Aug 18 20:03:38 volumio hotspot[1168]: before submitting a bug. These pages explain the proper Aug 18 20:03:38 volumio hotspot[1168]: process and the information we find helpful for debugging. Aug 18 20:03:38 volumio hotspot[1168]: exiting. Aug 18 20:03:38 volumio dhcpd[1207]: Copyright 2004-2018 Internet Systems Consortium. Aug 18 20:03:38 volumio dhcpd[1207]: All rights reserved. Aug 18 20:03:38 volumio dhcpd[1207]: For info, please visit https://www.isc.org/software/dhcp/ Aug 18 20:03:38 volumio dhcpd[1207]: Can't open lease database /var/lib/dhcp/dhcpd.leases: No such file or directory -- Aug 18 20:03:38 volumio dhcpd[1207]: check for failed database rewrite attempt! Aug 18 20:03:38 volumio dhcpd[1207]: Please read the dhcpd.leases manual page if you Aug 18 20:03:38 volumio dhcpd[1207]: don't know what to do about this. Aug 18 20:03:38 volumio dhcpd[1207]: Aug 18 20:03:38 volumio systemd[1]: dhcpd.service: Control process exited, code=exited, status=1/FAILURE Aug 18 20:03:38 volumio dhcpd[1207]: If you think you have received this message due to a bug rather Aug 18 20:03:38 volumio systemd[1]: dhcpd.service: Failed with result 'exit-code'. Aug 18 20:03:38 volumio dhcpd[1207]: than a configuration issue please read the section on submitting Aug 18 20:03:38 volumio systemd[1]: Failed to start dhcpd.service. Aug 18 20:03:38 volumio dhcpd[1207]: bugs on either our web page at www.isc.org or in the README file Aug 18 20:03:38 volumio dhcpd[1207]: before submitting a bug. These pages explain the proper Aug 18 20:03:38 volumio dhcpd[1207]: process and the information we find helpful for debugging. Aug 18 20:03:38 volumio dhcpd[1207]: Aug 18 20:03:38 volumio dhcpd[1207]: exiting. Aug 18 20:03:38 volumio volumio-streaming-daemon[1171]: ############################ Aug 18 20:03:38 volumio volumio-streaming-daemon[1171]: # Volumio Streaming Daemon # Aug 18 20:03:38 volumio volumio-streaming-daemon[1171]: # Running on port 7777 # Aug 18 20:03:38 volumio volumio-streaming-daemon[1171]: ############################ Aug 18 20:03:38 volumio volumio-streaming-daemon[1171]: Environment: Aug 18 20:03:38 volumio smbd[1211]: [2020/08/18 20:03:38.261460, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:38 volumio smbd[1211]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 20:03:38 volumio smbd[1211]: [2020/08/18 20:03:38.261899, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:38 volumio smbd[1211]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 20:03:38 volumio smbd[1211]: [2020/08/18 20:03:38.261943, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:38 volumio smbd[1211]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 20:03:38 volumio smbd[1211]: [2020/08/18 20:03:38.261460, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:38 volumio smbd[1211]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 20:03:38 volumio smbd[1211]: [2020/08/18 20:03:38.261899, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:38 volumio smbd[1211]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 20:03:38 volumio smbd[1211]: [2020/08/18 20:03:38.261943, 0] ../lib/util/debug.c:1063(reopen_logs_internal) Aug 18 20:03:38 volumio smbd[1211]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 20:03:38 volumio firststart.sh[1177]: Creating /var/log/samba folder Aug 18 20:03:38 volumio firststart.sh[1177]: Creating /boot/userconfig.txt Aug 18 20:03:38 volumio firststart.sh[1177]: Removing default SSH host keys Aug 18 20:03:38 volumio firststart.sh[1177]: removed '/etc/ssh/ssh_host_ecdsa_key' Aug 18 20:03:38 volumio firststart.sh[1177]: removed '/etc/ssh/ssh_host_ecdsa_key.pub' Aug 18 20:03:38 volumio firststart.sh[1177]: removed '/etc/ssh/ssh_host_ed25519_key' Aug 18 20:03:38 volumio firststart.sh[1177]: removed '/etc/ssh/ssh_host_ed25519_key.pub' Aug 18 20:03:38 volumio firststart.sh[1177]: removed '/etc/ssh/ssh_host_rsa_key' Aug 18 20:03:38 volumio firststart.sh[1177]: removed '/etc/ssh/ssh_host_rsa_key.pub' Aug 18 20:03:38 volumio firststart.sh[1177]: Generating SSH host keys Aug 18 20:03:38 volumio hotspot[1167]: /bin/hotspot.sh: line 4: warning: command substitution: ignored null byte in input Aug 18 20:03:39 volumio hotspot[1167]: Launching Ordinary Hostapd Aug 18 20:03:39 volumio hotspot[1167]: Configuration file: /etc/hostapd/hostapd.conf Aug 18 20:03:39 volumio hotspot[1167]: nl80211: Could not configure driver mode Aug 18 20:03:39 volumio hotspot[1167]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Aug 18 20:03:39 volumio dhcpcd[670]: wlan0: carrier lost Aug 18 20:03:39 volumio hotspot[1167]: nl80211 driver initialization failed. Aug 18 20:03:39 volumio hotspot[1167]: wlan0: interface state UNINITIALIZED->DISABLED Aug 18 20:03:39 volumio hotspot[1167]: wlan0: AP-DISABLED Aug 18 20:03:39 volumio hotspot[1167]: wlan0: CTRL-EVENT-TERMINATING Aug 18 20:03:39 volumio hotspot[1167]: hostapd_free_hapd_data: Interface wlan0 wasn't started Aug 18 20:03:39 volumio systemd[1]: hotspot.service: Main process exited, code=exited, status=1/FAILURE Aug 18 20:03:39 volumio systemd[1]: hotspot.service: Failed with result 'exit-code'. Aug 18 20:03:39 volumio dnsmasq[1189]: exiting on receipt of SIGTERM Aug 18 20:03:39 volumio systemd[1]: Stopping dnsmasq.service... Aug 18 20:03:39 volumio systemd[1]: dnsmasq.service: Succeeded. Aug 18 20:03:39 volumio systemd[1]: Stopped dnsmasq.service. Aug 18 20:03:40 volumio volumio-remote-updater[589]: [2020-08-18 20:03:40] [info] asio async_connect error: system:111 (Connection refused) Aug 18 20:03:40 volumio volumio-remote-updater[589]: [2020-08-18 20:03:40] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 18 20:03:40 volumio volumio-remote-updater[589]: [2020-08-18 20:03:40] [error] handle_connect error: Underlying Transport Error Aug 18 20:03:40 volumio ntpd[1051]: Deleting interface #4 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=6 secs Aug 18 20:03:42 volumio systemd[1]: Started Samba SMB Daemon. Aug 18 20:03:42 volumio systemd[1]: Reached target Multi-User System. Aug 18 20:03:42 volumio systemd[1]: Reached target Graphical Interface. Aug 18 20:03:42 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 18 20:03:42 volumio smbd[1211]: [2020/08/18 20:03:42.161118, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 18 20:03:42 volumio smbd[1211]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 18 20:03:42 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 18 20:03:42 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 18 20:03:42 volumio systemd[1]: Startup finished in 6min 17.250s (kernel) + 55.636s (userspace) = 7min 12.887s. Aug 18 20:03:42 volumio startx[1172]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Aug 18 20:03:44 volumio firststart.sh[1177]: debconf: unable to initialize frontend: Dialog Aug 18 20:03:44 volumio firststart.sh[1177]: debconf: (TERM is not set, so the dialog frontend is not usable.) Aug 18 20:03:44 volumio firststart.sh[1177]: debconf: falling back to frontend: Readline Aug 18 20:03:44 volumio firststart.sh[1177]: debconf: unable to initialize frontend: Readline Aug 18 20:03:44 volumio firststart.sh[1177]: debconf: (This frontend requires a controlling tty.) Aug 18 20:03:44 volumio firststart.sh[1177]: debconf: falling back to frontend: Teletype Aug 18 20:03:44 volumio volumio[1170]: info: ------------------------------------------- Aug 18 20:03:44 volumio volumio[1170]: info: ----- Volumio2 ---- Aug 18 20:03:44 volumio volumio[1170]: info: ------------------------------------------- Aug 18 20:03:44 volumio volumio[1170]: info: ----- System startup ---- Aug 18 20:03:44 volumio volumio[1170]: info: ------------------------------------------- Aug 18 20:03:44 volumio volumio[1170]: info: File /data/configuration/plugins.json does not exist. Copying from Volumio Aug 18 20:03:45 volumio volumio[1170]: info: MYVOLUMIO Environment detected Aug 18 20:03:45 volumio volumio[1170]: info: Plugin folders cleanup Aug 18 20:03:45 volumio volumio[1170]: info: Scanning into folder /volumio/app/plugins/ Aug 18 20:03:45 volumio volumio[1170]: info: Scanning category audio_interface Aug 18 20:03:45 volumio volumio[1170]: info: Scanning category miscellanea Aug 18 20:03:45 volumio volumio[1170]: info: Scanning category music_service Aug 18 20:03:45 volumio volumio[1170]: info: Scanning category plugins.json Aug 18 20:03:45 volumio volumio[1170]: info: Scanning category system_controller Aug 18 20:03:45 volumio volumio[1170]: info: Scanning category user_interface Aug 18 20:03:45 volumio volumio[1170]: info: Scanning into folder /data/plugins/ Aug 18 20:03:45 volumio volumio[1170]: info: Plugin folders cleanup completed Aug 18 20:03:45 volumio volumio[1170]: info: ------------------------------------------- Aug 18 20:03:45 volumio volumio[1170]: info: ----- Core plugins startup ---- Aug 18 20:03:45 volumio volumio[1170]: info: ------------------------------------------- Aug 18 20:03:45 volumio volumio[1170]: info: Loading plugins from folder /volumio/app/plugins/ Aug 18 20:03:45 volumio volumio[1170]: info: Adding plugin upnp to MyMusic Plugins Aug 18 20:03:45 volumio volumio[1170]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 18 20:03:45 volumio volumio[1170]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 18 20:03:45 volumio volumio[1170]: info: Loading plugins from folder /data/plugins/ Aug 18 20:03:45 volumio volumio[1170]: info: Loading plugin "system"... Aug 18 20:03:45 volumio volumio[1170]: No id defined. Creating one Aug 18 20:03:45 volumio volumio[1170]: info: Loading plugin "appearance"... Aug 18 20:03:45 volumio firststart.sh[1177]: Creating SSH2 RSA key; this may take some time ... Aug 18 20:03:45 volumio firststart.sh[1177]: 2048 SHA256:tQvofL4gAdnpZFJQnlCNvI52rKCn+1Qwg6FV/BnO28w root@volumio (RSA) Aug 18 20:03:46 volumio volumio[1170]: info: Loading plugin "network"... Aug 18 20:03:46 volumio volumio[1170]: info: Refreshing Cached IP Addresses Aug 18 20:03:46 volumio sudo[1439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 18 20:03:46 volumio sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:46 volumio sudo[1439]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:46 volumio firststart.sh[1177]: Creating SSH2 DSA key; this may take some time ... Aug 18 20:03:46 volumio volumio[1170]: info: Loading plugin "services"... Aug 18 20:03:46 volumio volumio[1170]: info: Loading plugin "alsa_controller"... Aug 18 20:03:46 volumio sudo[1442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 18 20:03:46 volumio sudo[1442]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:46 volumio firststart.sh[1177]: 1024 SHA256:vrpS8wD0smixKdGNIRZznspdOVlRTmgbcuOv6T0Uzgc root@volumio (DSA) Aug 18 20:03:46 volumio sudo[1442]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:46 volumio firststart.sh[1177]: Creating SSH2 ECDSA key; this may take some time ... Aug 18 20:03:46 volumio firststart.sh[1177]: 256 SHA256:WW/rQVf75qa8mYVXibILIGZd9PDhlpaLOG+10hXgFII root@volumio (ECDSA) Aug 18 20:03:46 volumio volumio[1170]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 18 20:03:46 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 20:03:46 volumio volumio[1170]: info: Setting mixer Master for card Aug 18 20:03:46 volumio volumio[1170]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 18 20:03:46 volumio volumio[1170]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 18 20:03:46 volumio volumio[1170]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 18 20:03:46 volumio volumio[1170]: info: Loading plugin "wizard"... Aug 18 20:03:46 volumio volumio[1170]: info: Loading plugin "volumio_command_line_client"... Aug 18 20:03:46 volumio volumio[1170]: info: Loading plugin "upnp"... Aug 18 20:03:46 volumio volumio[1170]: info: [1597781026275] Starting Upmpd Daemon Aug 18 20:03:46 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 18 20:03:46 volumio volumio[1170]: info: Loading plugin "my_music"... Aug 18 20:03:46 volumio volumio[1170]: info: Loading plugin "mpd"... Aug 18 20:03:46 volumio volumio[1170]: info: Loading plugin "upnp_browser"... Aug 18 20:03:46 volumio systemd[1]: Reloading. Aug 18 20:03:46 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 18 20:03:46 volumio systemd[1]: /lib/systemd/system/smbd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/smbd.pid → /run/samba/smbd.pid; please update the unit file accordingly. Aug 18 20:03:46 volumio systemd[1]: /lib/systemd/system/nmbd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/nmbd.pid → /run/samba/nmbd.pid; please update the unit file accordingly. Aug 18 20:03:46 volumio volumio[1170]: info: Loading plugin "networkfs"... Aug 18 20:03:46 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Aug 18 20:03:46 volumio volumio[1170]: info: Starting Udev Watcher for removable devices Aug 18 20:03:46 volumio firststart.sh[1177]: rescue-ssh.target is a disabled or a static unit, not starting it. Aug 18 20:03:46 volumio volumio[1170]: info: Mounting Device volumioboot Aug 18 20:03:46 volumio sudo[1530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/volumioboot -o noatime,dmask=0000,fmask=0000 Aug 18 20:03:46 volumio sudo[1530]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:46 volumio firststart.sh[1177]: insserv: warning: current start runlevel(s) (empty) of script `ssh' overrides LSB defaults (2 3 4 5). Aug 18 20:03:46 volumio firststart.sh[1177]: insserv: warning: current stop runlevel(s) (2 3 4 5) of script `ssh' overrides LSB defaults (empty). Aug 18 20:03:46 volumio systemd[1]: Reloading. Aug 18 20:03:46 volumio sudo[1530]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:46 volumio volumio[1170]: info: Mounting Device volumioimg Aug 18 20:03:46 volumio sudo[1549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/volumioimg -o noatime Aug 18 20:03:46 volumio sudo[1549]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:46 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 18 20:03:46 volumio systemd[1]: /lib/systemd/system/smbd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/smbd.pid → /run/samba/smbd.pid; please update the unit file accordingly. Aug 18 20:03:46 volumio systemd[1]: /lib/systemd/system/nmbd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/nmbd.pid → /run/samba/nmbd.pid; please update the unit file accordingly. Aug 18 20:03:48 volumio sudo[1549]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:48 volumio volumio[1170]: info: Ignoring mount for partition: volumio_data Aug 18 20:03:48 volumio volumio[1170]: info: Mounting Device volumioboot Aug 18 20:03:48 volumio sudo[1560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/nvme0n1p1 /mnt/USB/volumioboot -o noatime,dmask=0000,fmask=0000 Aug 18 20:03:48 volumio sudo[1560]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:48 volumio sudo[1560]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:48 volumio volumio[1170]: info: Mounting Device volumioimg Aug 18 20:03:48 volumio sudo[1563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/nvme0n1p2 /mnt/USB/volumioimg -o noatime Aug 18 20:03:48 volumio sudo[1563]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:03:48 volumio sudo[1563]: pam_unix(sudo:session): session closed for user root Aug 18 20:03:48 volumio volumio[1170]: info: Ignoring mount for partition: volumio_data Aug 18 20:03:48 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 18 20:03:48 volumio volumio[1170]: info: Loading plugin "alarm-clock"... Aug 18 20:03:50 volumio volumio-remote-updater[589]: [2020-08-18 20:03:50] [connect] Successful connection Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "airplay_emulation"... Aug 18 20:03:50 volumio volumio[1170]: info: Starting Shairport Sync Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "last_100"... Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "webradio"... Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "i2s_dacs"... Aug 18 20:03:50 volumio volumio[1170]: info: I2S DAC not set, start Auto-detection Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "volumiodiscovery"... Aug 18 20:03:50 volumio volumio[1170]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 18 20:03:50 volumio volumio[1170]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 20:03:50 volumio volumio[1170]: *** WARNING *** For more information see Aug 18 20:03:50 volumio volumio[1170]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 18 20:03:50 volumio volumio[1170]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 20:03:50 volumio volumio[1170]: *** WARNING *** For more information see Aug 18 20:03:50 volumio node[1170]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 18 20:03:50 volumio node[1170]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 20:03:50 volumio node[1170]: *** WARNING *** For more information see Aug 18 20:03:50 volumio node[1170]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 18 20:03:50 volumio node[1170]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 20:03:50 volumio node[1170]: *** WARNING *** For more information see Aug 18 20:03:50 volumio volumio[1170]: Discovery: StartAdv! undefined Aug 18 20:03:50 volumio volumio[1170]: Discovery: Started advertising... Volumio - undefined Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "outputs"... Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "albumart"... Aug 18 20:03:50 volumio firststart.sh[1177]: Disabling firststart service Aug 18 20:03:50 volumio volumio[1170]: info: Plugin example_plugin is not enabled Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "inputs"... Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "updater_comm"... Aug 18 20:03:50 volumio firststart.sh[1177]: Removed /etc/systemd/system/multi-user.target.wants/firststart.service. Aug 18 20:03:50 volumio systemd[1]: Reloading. Aug 18 20:03:50 volumio volumio[1170]: info: Plugin mpdemulation is not enabled Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "rest_api"... Aug 18 20:03:50 volumio volumio[1170]: info: Loading plugin "websocket"... Aug 18 20:03:50 volumio volumio[1170]: info: ___________ START PLUGINS ___________ Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 18 20:03:50 volumio volumio[1170]: info: [1597781030707] CoreMusicLibrary::Adding element Media Servers Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 20:03:50 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 18 20:03:50 volumio systemd[1]: /lib/systemd/system/smbd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/smbd.pid → /run/samba/smbd.pid; please update the unit file accordingly. Aug 18 20:03:50 volumio systemd[1]: /lib/systemd/system/nmbd.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/nmbd.pid → /run/samba/nmbd.pid; please update the unit file accordingly. Aug 18 20:03:50 volumio volumio[1170]: Forking 3 albumart workers Aug 18 20:03:50 volumio volumio[1170]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 20:03:50 volumio volumio[1170]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 18 20:03:50 volumio volumio[1170]: info: [1597781030746] CoreMusicLibrary::Adding element Last_100 Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 18 20:03:50 volumio volumio[1170]: info: [1597781030757] CoreMusicLibrary::Adding element Webradio Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 18 20:03:50 volumio volumio[1170]: info: ------------------------------------------- Aug 18 20:03:50 volumio volumio[1170]: info: ----- MyVolumio plugins startup ---- Aug 18 20:03:50 volumio volumio[1170]: info: ------------------------------------------- Aug 18 20:03:50 volumio volumio[1170]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 18 20:03:50 volumio volumio[1170]: info: Loading i18n strings for locale en Aug 18 20:03:50 volumio volumio[1170]: Updating browse sources language Aug 18 20:03:50 volumio volumio[1170]: Cannot find translation for sourceMedia Servers Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 20:03:50 volumio firststart.sh[1177]: Finalizing Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::initPlayerControls Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:03:50 volumio volumio[1170]: info: BOOT COMPLETED Aug 18 20:03:50 volumio volumio[1170]: [Metrics] CommandRouter: 5s 866.81ms Aug 18 20:03:50 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 20:03:53 volumio volumio[1170]: Starting albumart workers Aug 18 20:03:53 volumio volumio[1170]: Starting albumart workers Aug 18 20:03:53 volumio volumio[1170]: Starting albumart workers Aug 18 20:04:00 volumio volumio[1170]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Aug 18 20:04:00 volumio volumio[1170]: underrun!!! (at least 1140.216 ms long) Aug 18 20:04:00 volumio volumio[1170]: underrun!!! (at least 1571.961 ms long) Aug 18 20:04:00 volumio volumio[1170]: underrun!!! (at least 2695.325 ms long) Aug 18 20:04:00 volumio volumio[1170]: underrun!!! (at least 1249.381 ms long) Aug 18 20:04:00 volumio volumio[1170]: info: CoreCommandRouter::Close All Modals sent Aug 18 20:04:00 volumio volumio[1170]: info: CoreCommandRouter::Close All Modals sent Aug 18 20:04:00 volumio volumio[1170]: Express server listening on port 3000 Aug 18 20:04:00 volumio volumio[1170]: [Metrics] WebUI: 18s 471.62ms Aug 18 20:04:00 volumio volumio[1170]: info: Setting Device type: x86 Aug 18 20:04:00 volumio volumio[1170]: Volumio Calling Home Aug 18 20:04:00 volumio volumio[1170]: info: CoreStateMachine::resetVolumioState Aug 18 20:04:00 volumio volumio[1170]: info: CoreStateMachine::getcurrentVolume Aug 18 20:04:00 volumio volumio[1170]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::getcurrentVolume Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 20:04:01 volumio sudo[1658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 18 20:04:01 volumio sudo[1658]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:04:01 volumio sudo[1660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 18 20:04:01 volumio sudo[1660]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:04:01 volumio sudo[1658]: pam_unix(sudo:session): session closed for user root Aug 18 20:04:01 volumio sudo[1660]: pam_unix(sudo:session): session closed for user root Aug 18 20:04:01 volumio volumio[1170]: info: Scanning new location : "volumioboot" Aug 18 20:04:01 volumio volumio[1170]: info: Scanning new location : "volumioimg" Aug 18 20:04:01 volumio volumio[1170]: info: Scanning new location : "volumioboot" Aug 18 20:04:01 volumio volumio[1170]: info: Scanning new location : "volumioimg" Aug 18 20:04:01 volumio volumio[1170]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 18 20:04:01 volumio volumio[1170]: info: Cannot read play queue from file Aug 18 20:04:01 volumio volumio[1170]: info: MPD running with PID629 Aug 18 20:04:01 volumio volumio[1170]: ,establishing connection Aug 18 20:04:01 volumio sudo[1678]: pam_unix(sudo:auth): conversation failed Aug 18 20:04:01 volumio sudo[1678]: pam_unix(sudo:auth): auth could not identify password for [volumio] Aug 18 20:04:01 volumio volumio[1170]: info: VolumeController:: Volume=41 Mute =false Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::pushState Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:04:01 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::updateTrackBlock Aug 18 20:04:01 volumio volumio[1170]: info: CorePlayQueue::getTrackBlock Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 20:04:01 volumio volumio[1170]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Aug 18 20:04:01 volumio volumio[1170]: We trust you have received the usual lecture from the local System Aug 18 20:04:01 volumio volumio[1170]: Administrator. It usually boils down to these three things: Aug 18 20:04:01 volumio volumio[1170]: #1) Respect the privacy of others. Aug 18 20:04:01 volumio volumio[1170]: #2) Think before you type. Aug 18 20:04:01 volumio volumio[1170]: #3) With great power comes great responsibility. Aug 18 20:04:01 volumio volumio[1170]: sudo: no tty present and no askpass program specified Aug 18 20:04:01 volumio volumio[1170]: info: VolumeController:: Volume=41 Mute =false Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::pushState Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:04:01 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::updateTrackBlock Aug 18 20:04:01 volumio volumio[1170]: info: CorePlayQueue::getTrackBlock Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 20:04:01 volumio volumio[1170]: info: null Aug 18 20:04:01 volumio volumio[1170]: info: [50@0] {lsinfo} No such directory Aug 18 20:04:01 volumio volumio[1170]: info: VolumeController:: Volume=41 Mute =false Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::pushState Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:04:01 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 20:04:01 volumio volumio[1170]: info: VolumeController:: Volume=41 Mute =false Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::pushState Aug 18 20:04:01 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:04:01 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 18 20:04:01 volumio volumio[1170]: info: Version has changed, forcing UI Reload Aug 18 20:04:01 volumio volumio[1170]: info: CoreCommandRouter::Reload Ui Aug 18 20:04:05 volumio volumio-remote-updater[589]: [2020-08-18 20:04:05] [connect] Successful connection Aug 18 20:04:06 volumio dbus-daemon[588]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.12' (uid=1000 pid=1415 comm="/usr/lib/chromium/chromium --show-component-extens") Aug 18 20:04:06 volumio systemd[1]: Starting Bluetooth service... Aug 18 20:04:06 volumio bluetoothd[1689]: Bluetooth daemon 5.50 Aug 18 20:04:06 volumio bluetoothd[1689]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Aug 18 20:04:06 volumio dbus-daemon[588]: [system] Successfully activated service 'org.bluez' Aug 18 20:04:06 volumio systemd[1]: Started Bluetooth service. Aug 18 20:04:06 volumio bluetoothd[1689]: Starting SDP server Aug 18 20:04:06 volumio bluetoothd[1689]: Excluding (cli) sap Aug 18 20:04:06 volumio bluetoothd[1689]: Bluetooth management interface 1.14 initialized Aug 18 20:04:06 volumio dbus-daemon[588]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.13' (uid=0 pid=1689 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Aug 18 20:04:06 volumio systemd[1]: Starting Hostname Service... Aug 18 20:04:13 volumio volumio[1170]: info: Starting Shairport Sync Aug 18 20:04:13 volumio sudo[1748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 18 20:04:13 volumio sudo[1748]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:04:13 volumio volumio[1170]: info: Starting Shairport Sync Aug 18 20:04:13 volumio dbus-daemon[588]: [system] Successfully activated service 'org.freedesktop.hostname1' Aug 18 20:04:13 volumio sudo[1750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 20:04:13 volumio sudo[1750]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:04:13 volumio systemd[1]: Started Hostname Service. Aug 18 20:04:13 volumio volumio[1170]: Discovery: adding 64c868d6-ffbc-48ca-b29d-06d1ac32e47f Aug 18 20:04:13 volumio volumio[1170]: info: mDNS: Found device Volumio Aug 18 20:04:13 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Aug 18 20:04:13 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:04:13 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:04:13 volumio volumio[1170]: Discovery: this is already registered, 64c868d6-ffbc-48ca-b29d-06d1ac32e47f Aug 18 20:04:13 volumio volumio[1170]: info: mDNS: Found device Volumio Aug 18 20:04:13 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Aug 18 20:04:13 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:04:13 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:04:13 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Aug 18 20:04:13 volumio systemd[1755]: upmpdcli.service: Failed to execute command: No such file or directory Aug 18 20:04:13 volumio systemd[1755]: upmpdcli.service: Failed at step EXEC spawning /usr/bin/upmpdcli: No such file or directory Aug 18 20:04:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 20:04:13 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:04:13 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Aug 18 20:04:13 volumio systemd[1756]: shairport-sync.service: Failed to execute command: No such file or directory Aug 18 20:04:13 volumio systemd[1756]: shairport-sync.service: Failed at step EXEC spawning /usr/local/bin/shairport-sync: No such file or directory Aug 18 20:04:13 volumio systemd[1]: shairport-sync.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:04:13 volumio systemd[1]: shairport-sync.service: Failed with result 'exit-code'. Aug 18 20:04:13 volumio sudo[1750]: pam_unix(sudo:session): session closed for user root Aug 18 20:04:13 volumio sudo[1748]: pam_unix(sudo:session): session closed for user root Aug 18 20:04:13 volumio sudo[1754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 20:04:13 volumio sudo[1754]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:04:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 20:04:13 volumio systemd[1758]: shairport-sync.service: Failed to execute command: No such file or directory Aug 18 20:04:13 volumio systemd[1758]: shairport-sync.service: Failed at step EXEC spawning /usr/local/bin/shairport-sync: No such file or directory Aug 18 20:04:13 volumio systemd[1]: shairport-sync.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:04:13 volumio systemd[1]: shairport-sync.service: Failed with result 'exit-code'. Aug 18 20:04:13 volumio sudo[1754]: pam_unix(sudo:session): session closed for user root Aug 18 20:04:13 volumio volumio[1170]: info: Volumio called home Aug 18 20:04:13 volumio volumio[1170]: info: Shairport-Sync Started Aug 18 20:04:13 volumio volumio[1170]: Error adding Membership: Error: addMembership EINVAL Aug 18 20:04:13 volumio volumio[1170]: info: Shairport-Sync Started Aug 18 20:04:13 volumio volumio[1170]: info: Upmpdcli Daemon Started Aug 18 20:04:13 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Aug 18 20:04:13 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:04:13 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:04:13 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:04:13 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:04:14 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 18 20:04:14 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 18 20:04:14 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 18 20:04:14 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 18 20:04:14 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 18 20:04:14 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 18 20:04:14 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 18 20:04:14 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 18 20:04:14 volumio volumio[1170]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 18 20:04:14 volumio volumio[1170]: info: Adding plugin bluetooth to MyMusic Plugins Aug 18 20:04:14 volumio volumio[1170]: info: Adding plugin cd_controller to MyMusic Plugins Aug 18 20:04:19 volumio volumio[1170]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 18 20:04:19 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 18 20:04:20 volumio volumio-remote-updater[589]: [2020-08-18 20:04:20] [connect] Successful connection Aug 18 20:04:35 volumio volumio-remote-updater[589]: [2020-08-18 20:04:35] [connect] Successful connection Aug 18 20:04:38 volumio volumio[1170]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 18 20:04:41 volumio volumio[1170]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 18 20:04:41 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 18 20:04:41 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 20:04:41 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 20:04:41 volumio volumio[1170]: info: Starting MyVolumio Remote Streaming Endpoints Aug 18 20:04:41 volumio volumio[1170]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 18 20:04:41 volumio volumio[1170]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 18 20:04:41 volumio volumio[1170]: info: Streaming services startup Aug 18 20:04:41 volumio volumio[1170]: info: Starting Streaming Daemon Aug 18 20:04:41 volumio volumio[1170]: info: MyVolumio not started Aug 18 20:04:41 volumio volumio[1170]: info: Initializing device activation check Aug 18 20:04:41 volumio sudo[1807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 18 20:04:41 volumio sudo[1807]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:04:41 volumio volumio[1170]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 18 20:04:41 volumio systemd[1]: Stopping Volumio Streaming Daemon... Aug 18 20:04:41 volumio systemd[1]: volumio-streaming-daemon.service: Main process exited, code=killed, status=15/TERM Aug 18 20:04:41 volumio systemd[1]: volumio-streaming-daemon.service: Succeeded. Aug 18 20:04:41 volumio systemd[1]: Stopped Volumio Streaming Daemon. Aug 18 20:04:41 volumio systemd[1]: Started Volumio Streaming Daemon. Aug 18 20:04:41 volumio sudo[1807]: pam_unix(sudo:session): session closed for user root Aug 18 20:04:41 volumio volumio-streaming-daemon[1809]: ############################ Aug 18 20:04:41 volumio volumio-streaming-daemon[1809]: # Volumio Streaming Daemon # Aug 18 20:04:41 volumio volumio-streaming-daemon[1809]: # Running on port 7777 # Aug 18 20:04:41 volumio volumio-streaming-daemon[1809]: ############################ Aug 18 20:04:41 volumio volumio-streaming-daemon[1809]: Environment: production Aug 18 20:04:41 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 18 20:04:41 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 20:04:41 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:04:43 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Aug 18 20:04:48 volumio volumio-streaming-daemon[1809]: Environment: production Aug 18 20:04:48 volumio volumio[1170]: info: Fetching Streaming Services browse cache Aug 18 20:04:48 volumio volumio[1170]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Aug 18 20:04:48 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 20:04:48 volumio volumio[1170]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Aug 18 20:04:48 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 20:04:50 volumio volumio-remote-updater[589]: [2020-08-18 20:04:50] [connect] Successful connection Aug 18 20:04:50 volumio volumio-remote-updater[589]: [2020-08-18 20:04:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1597781090 101 Aug 18 20:05:01 volumio systemd[1]: firststart.service: Succeeded. Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::volumioGetVisibleSources Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Aug 18 20:05:31 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:05:31 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 18 20:05:31 volumio volumio[1170]: info: Listing playlists Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Aug 18 20:05:31 volumio volumio[1170]: info: Could not detect Volumio Device: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 20:05:31 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Aug 18 20:05:33 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 18 20:05:47 volumio sudo[2014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 18 20:05:47 volumio sudo[2012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 18 20:05:47 volumio sudo[2014]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:05:47 volumio sudo[2012]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:05:47 volumio sudo[2012]: pam_unix(sudo:session): session closed for user root Aug 18 20:05:47 volumio sudo[2014]: pam_unix(sudo:session): session closed for user root Aug 18 20:05:49 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Aug 18 20:05:49 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:05:49 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:05:49 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 18 20:05:49 volumio volumio[1170]: info: CoreCommandRouter::volumioGetVisibleSources Aug 18 20:05:49 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 20:05:49 volumio volumio[1170]: info: Listing playlists Aug 18 20:05:51 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 18 20:06:07 volumio sudo[2020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 18 20:06:07 volumio sudo[2020]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:06:07 volumio sudo[2020]: pam_unix(sudo:session): session closed for user root Aug 18 20:06:07 volumio sudo[2022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 18 20:06:07 volumio sudo[2022]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:06:07 volumio sudo[2022]: pam_unix(sudo:session): session closed for user root Aug 18 20:06:08 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Aug 18 20:06:08 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:06:08 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:06:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 18 20:06:08 volumio volumio[1170]: info: CoreCommandRouter::volumioGetVisibleSources Aug 18 20:06:08 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 20:06:08 volumio volumio[1170]: info: Listing playlists Aug 18 20:06:19 volumio sudo[2026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 18 20:06:19 volumio sudo[2026]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:06:19 volumio sudo[2026]: pam_unix(sudo:session): session closed for user root Aug 18 20:06:19 volumio sudo[2028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 18 20:06:19 volumio sudo[2028]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:06:19 volumio sudo[2028]: pam_unix(sudo:session): session closed for user root Aug 18 20:06:20 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Aug 18 20:06:20 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:06:20 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:06:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 18 20:06:20 volumio volumio[1170]: info: CoreCommandRouter::volumioGetVisibleSources Aug 18 20:06:20 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 20:06:20 volumio volumio[1170]: info: Listing playlists Aug 18 20:06:20 volumio volumio[1170]: info: Error Parsing Plugins JSON Aug 18 20:06:36 volumio volumio[1170]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 20:06:36 volumio volumio[1170]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 20:06:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 18 20:06:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 18 20:06:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 18 20:06:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 18 20:06:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:06:36 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:06:36 volumio volumio[1170]: info: CoreCommandRouter::volumioGetBrowseSources Aug 18 20:06:37 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 18 20:06:37 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 18 20:06:41 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 18 20:06:45 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 18 20:06:49 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 18 20:06:53 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:06:55 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 18 20:07:01 volumio volumio[1170]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 20:07:01 volumio volumio[1170]: info: Output device has changed, restarting MPD Aug 18 20:07:01 volumio volumio[1170]: info: Output device has changed, restarting Shairport Sync Aug 18 20:07:01 volumio sudo[2039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 20:07:01 volumio sudo[2039]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:07:01 volumio sudo[2041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 20:07:01 volumio sudo[2041]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:07:01 volumio volumio[1170]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 20:07:01 volumio volumio[1170]: info: Found match in Cards Database: setting mixer for card HDMI Aug 18 20:07:01 volumio volumio[1170]: info: Found match in Cards Database: setting mixer for card HDMI Aug 18 20:07:01 volumio volumio[1170]: info: Found match in Cards Database: setting mixer for card HDMI Aug 18 20:07:01 volumio volumio[1170]: info: Found match in Cards Database: setting mixer for card HDMI Aug 18 20:07:01 volumio volumio[1170]: info: Found match in Cards Database: setting mixer for card HDMI Aug 18 20:07:01 volumio volumio[1170]: info: Setting mixer Master for card HDMI Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 18 20:07:01 volumio volumio[1170]: info: Updating Volume Controller Parameters: Device: 0,3 Name: Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 20:07:01 volumio volumio[1170]: info: Starting Shairport Sync Aug 18 20:07:01 volumio volumio[1170]: info: VolumeController:: Volume=41 Mute =false Aug 18 20:07:01 volumio volumio[1170]: info: CoreStateMachine::pushState Aug 18 20:07:01 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:07:01 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Aug 18 20:07:01 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 20:07:01 volumio sudo[2064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 20:07:01 volumio sudo[2064]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:07:02 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 20:07:02 volumio systemd[1]: Stopping Music Player Daemon... Aug 18 20:07:02 volumio systemd[2067]: shairport-sync.service: Failed to execute command: No such file or directory Aug 18 20:07:02 volumio systemd[2067]: shairport-sync.service: Failed at step EXEC spawning /usr/local/bin/shairport-sync: No such file or directory Aug 18 20:07:02 volumio systemd[1]: shairport-sync.service: Main process exited, code=exited, status=203/EXEC Aug 18 20:07:02 volumio systemd[1]: shairport-sync.service: Failed with result 'exit-code'. Aug 18 20:07:02 volumio sudo[2064]: pam_unix(sudo:session): session closed for user root Aug 18 20:07:02 volumio volumio[1170]: info: Shairport-Sync Started Aug 18 20:07:03 volumio sudo[2039]: pam_unix(sudo:session): session closed for user root Aug 18 20:07:03 volumio volumio[1170]: info: MPD Permissions set Aug 18 20:07:03 volumio volumio[1170]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 18 20:07:03 volumio volumio[1170]: info: CoreStateMachine::getcurrentVolume Aug 18 20:07:03 volumio volumio[1170]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 20:07:03 volumio volumio[1170]: info: VolumeController:: Volume=41 Mute =false Aug 18 20:07:03 volumio volumio[1170]: info: CoreStateMachine::pushState Aug 18 20:07:03 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:07:03 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:07:03 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Aug 18 20:07:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 20:07:03 volumio volumio[1170]: info: CoreStateMachine::updateTrackBlock Aug 18 20:07:03 volumio volumio[1170]: info: CorePlayQueue::getTrackBlock Aug 18 20:07:03 volumio volumio[1170]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 20:07:03 volumio volumio[1170]: info: VolumeController:: Volume=41 Mute =false Aug 18 20:07:03 volumio volumio[1170]: info: CoreStateMachine::pushState Aug 18 20:07:03 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:07:03 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:07:03 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Aug 18 20:07:03 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 20:07:06 volumio systemd[1]: mpd.service: Succeeded. Aug 18 20:07:06 volumio systemd[1]: Stopped Music Player Daemon. Aug 18 20:07:06 volumio systemd[1]: Starting Music Player Daemon... Aug 18 20:07:08 volumio mpd[2072]: config_file: config parameter "gapless_mp3_playback" on line 19 is deprecated Aug 18 20:07:08 volumio mpd[2072]: config_file: config parameter "buffer_before_play" on line 85 is deprecated Aug 18 20:07:08 volumio mpd[2072]: config_file: config parameter "id3v1_encoding" on line 99 is deprecated Aug 18 20:07:08 volumio mpd[2072]: Aug 18 20:07 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 18 20:07:08 volumio systemd[1]: Started Music Player Daemon. Aug 18 20:07:08 volumio sudo[2041]: pam_unix(sudo:session): session closed for user root Aug 18 20:07:08 volumio volumio[1170]: info: null Aug 18 20:07:26 volumio volumio[1170]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Aug 18 20:07:26 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:07:26 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:07:26 volumio volumio[1170]: info: Restoring Previous Volume level: 41 false false Aug 18 20:07:26 volumio volumio[1170]: info: Volume configurations have been set Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 18 20:07:26 volumio volumio[1170]: info: Updating Volume Controller Parameters: Device: 0,3 Name: Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 18 20:07:26 volumio volumio[1170]: info: VolumeController:: Volume=41 Mute =false Aug 18 20:07:26 volumio volumio[1170]: info: CoreStateMachine::pushState Aug 18 20:07:26 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:07:26 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Aug 18 20:07:26 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 20:07:30 volumio volumio[1170]: info: VolumeController::SetAlsaVolume41 Aug 18 20:07:30 volumio volumio[1170]: info: CoreStateMachine::pushState Aug 18 20:07:30 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:07:30 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:07:30 volumio volumio[1170]: info: CoreCommandRouter::volumioPushState Aug 18 20:07:30 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 20:07:39 volumio volumio[1170]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 20:07:39 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 18 20:07:40 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Aug 18 20:07:40 volumio sudo[2090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Aug 18 20:07:40 volumio sudo[2090]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:07:40 volumio sudo[2095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Aug 18 20:07:40 volumio sudo[2095]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:07:40 volumio sudo[2090]: pam_unix(sudo:session): session closed for user root Aug 18 20:07:40 volumio sudo[2095]: pam_unix(sudo:session): session closed for user root Aug 18 20:07:40 volumio sudo[2102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Aug 18 20:07:40 volumio sudo[2102]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:07:40 volumio sudo[2109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Aug 18 20:07:40 volumio sudo[2109]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:07:40 volumio sudo[2102]: pam_unix(sudo:session): session closed for user root Aug 18 20:07:40 volumio sudo[2109]: pam_unix(sudo:session): session closed for user root Aug 18 20:07:40 volumio sudo[2116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 18 20:07:40 volumio sudo[2116]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:07:40 volumio sudo[2116]: pam_unix(sudo:session): session closed for user root Aug 18 20:07:40 volumio sudo[2118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 18 20:07:40 volumio sudo[2118]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:07:40 volumio sudo[2118]: pam_unix(sudo:session): session closed for user root Aug 18 20:07:40 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Aug 18 20:07:40 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Aug 18 20:07:40 volumio sudo[2122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 18 20:07:40 volumio sudo[2122]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:07:43 volumio sudo[2122]: pam_unix(sudo:session): session closed for user root Aug 18 20:07:52 volumio volumio[1170]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 20:07:52 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 18 20:07:52 volumio volumio[1170]: info: Received Get System Version Aug 18 20:07:52 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 18 20:08:05 volumio volumio-remote-updater[589]: No test mode Aug 18 20:08:09 volumio volumio[1170]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 18 20:08:24 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , installToDisk Aug 18 20:08:24 volumio sudo[2149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dcfldd if=/dev/sda of=/dev/nvme0n1 bs=1M status=on sizeprobe=if statusinterval=10 Aug 18 20:08:24 volumio sudo[2149]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:09:14 volumio ntpd[1051]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 18 20:11:59 volumio systemd[1]: Starting Cleanup of Temporary Directories... Aug 18 20:18:27 volumio sudo[2149]: pam_unix(sudo:session): session closed for user root Aug 18 20:18:27 volumio volumio[1170]: info: Successfully cloned system Aug 18 20:18:27 volumio sudo[2244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/nvme0n11 /tmp/boot -o rw,uid=1000,gid=1000 Aug 18 20:18:27 volumio sudo[2244]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:18:27 volumio sudo[2244]: pam_unix(sudo:session): session closed for user root Aug 18 20:18:27 volumio volumio[1170]: mount: /tmp/boot: special device /dev/nvme0n11 does not exist. Aug 18 20:18:27 volumio volumio[1170]: error: Cannot prepare system for resize Aug 18 20:18:27 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Aug 18 20:18:27 volumio systemd[1]: Started Cleanup of Temporary Directories. Aug 18 20:19:27 volumio volumio[1170]: info: Error Parsing Plugins JSON Aug 18 20:21:27 volumio volumio[1170]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 20:21:27 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 18 20:21:27 volumio volumio[1170]: info: Received Get System Version Aug 18 20:21:27 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 18 20:22:25 volumio volumio[1170]: info: CoreCommandRouter::volumioGetState Aug 18 20:22:25 volumio volumio[1170]: info: CoreStateMachine::getState Aug 18 20:22:25 volumio volumio[1170]: info: CorePlayQueue::getTrack 0 Aug 18 20:22:25 volumio volumio[1170]: info: CoreCommandRouter::volumioGetQueue Aug 18 20:22:25 volumio volumio[1170]: info: CoreStateMachine::getQueue Aug 18 20:22:25 volumio volumio[1170]: info: CorePlayQueue::getQueue Aug 18 20:22:25 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Aug 18 20:23:43 volumio volumio[1170]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Aug 18 20:23:43 volumio volumio[1170]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Aug 18 20:23:43 volumio sudo[2297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig Aug 18 20:23:43 volumio sudo[2297]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 20:23:43 volumio sudo[2297]: pam_unix(sudo:session): session closed for user root Aug 18 20:23:43 volumio sudo[2308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Aug 18 20:23:43 volumio sudo[2308]: pam_unix(sudo:session): session opened for user root by (uid=0) # cat /var/log/mpd.log --------------- Aug 18 20:03 : zeroconf: No global port, disabling zeroconf Aug 18 20:04 : client: [0] opened from local Aug 18 20:04 : exception: Failed to read mixer for 'alsa': no such mixer control: PCM Aug 18 20:04 : client: [0] closed Aug 18 20:04 : client: [1] opened from local Aug 18 20:04 : client: [1] closed Aug 18 20:04 : client: [2] opened from local Aug 18 20:04 : client: [2] closed Aug 18 20:04 : client: [3] opened from local Aug 18 20:04 : client: [3] closed Aug 18 20:04 : client: [4] opened from local Aug 18 20:04 : exception: No such directory Aug 18 20:07 : zeroconf: No global port, disabling zeroconf Aug 18 20:07 : client: [0] opened from local