Fri Sep 28 22:13:03 UTC 2018 Description="'No audio using D50 dac on usbridge'" # cat /proc/version --------------- Linux version 3.10.38 (root@debian-cem) (gcc version 4.8.1 (Sourcery CodeBench Lite 2013.11-33) ) #4 SMP PREEMPT Fri Dec 22 11:54:41 IST 2017 # cat /etc/os-release --------------- PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="bb50b126b7ce9c472a6d2bc5081c70d6a0cc24de" VOLUMIO_FE_VERSION="5eef25b064c35dc730df3ef6fd49a4997952bfdf" VOLUMIO_BE_VERSION="01b5fe34a75e315803f7754605ac102d8defc6c6" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 20 23:26:51 CEST 2018" VOLUMIO_VERSION="2.459" VOLUMIO_HARDWARE="sparky" VOLUMIO_HASH="bb35132501d10722028b261f4f54a619" # ifconfig --------------- eth0 Link encap:Ethernet HWaddr 00:17:f7:01:09:85 inet addr:10.0.0.6 Bcast:10.0.0.255 Mask:255.255.255.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:20337 errors:0 dropped:0 overruns:0 frame:0 TX packets:13876 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:27426417 (26.1 MiB) TX bytes:1446284 (1.3 MiB) Interrupt:32 lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 UP LOOPBACK RUNNING MTU:65536 Metric:1 RX packets:1398 errors:0 dropped:0 overruns:0 frame:0 TX packets:1398 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:152446 (148.8 KiB) TX bytes:152446 (148.8 KiB) # iwconfig --------------- lo no wireless extensions. eth0 no wireless extensions. # aplay -l --------------- **** List of PLAYBACK Hardware Devices **** card 0: atm7059link [atm7059_link], device 0: ATC2603C PCM atc2603c-dai-0 [] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: atm7059link [atm7059_link], device 1: HDMI PCM atm7059-hdmi-dai-1 [] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: atm7059link [atm7059_link], device 2: SPDIF PCM atm7059-spdif-dai-2 [] Subdevices: 1/1 Subdevice #0: subdevice #0 card 1: D50 [D50], device 0: USB Audio [USB Audio] Subdevices: 0/1 Subdevice #0: subdevice #0 # ps -ef --------------- UID PID PPID C STIME TTY TIME CMD root 1 0 1 22:09 ? 00:00:03 /sbin/init root 2 0 0 22:09 ? 00:00:00 [kthreadd] root 3 2 0 22:09 ? 00:00:00 [ksoftirqd/0] root 4 2 0 22:09 ? 00:00:01 [kworker/0:0] root 5 2 0 22:09 ? 00:00:00 [kworker/0:0H] root 6 2 0 22:09 ? 00:00:00 [kworker/u8:0] root 7 2 0 22:09 ? 00:00:00 [migration/0] root 8 2 0 22:09 ? 00:00:00 [rcu_preempt] root 9 2 0 22:09 ? 00:00:00 [rcu_bh] root 10 2 0 22:09 ? 00:00:00 [rcu_sched] root 11 2 0 22:09 ? 00:00:00 [migration/1] root 12 2 0 22:09 ? 00:00:00 [ksoftirqd/1] root 13 2 0 22:09 ? 00:00:00 [kworker/1:0] root 14 2 0 22:09 ? 00:00:00 [kworker/1:0H] root 15 2 0 22:09 ? 00:00:00 [migration/2] root 16 2 0 22:09 ? 00:00:00 [ksoftirqd/2] root 17 2 0 22:09 ? 00:00:00 [kworker/2:0] root 18 2 0 22:09 ? 00:00:00 [kworker/2:0H] root 19 2 0 22:09 ? 00:00:00 [migration/3] root 20 2 0 22:09 ? 00:00:00 [ksoftirqd/3] root 21 2 0 22:09 ? 00:00:00 [kworker/3:0] root 22 2 0 22:09 ? 00:00:00 [kworker/3:0H] root 23 2 0 22:09 ? 00:00:00 [khelper] root 24 2 0 22:09 ? 00:00:00 [kdevtmpfs] root 25 2 0 22:09 ? 00:00:00 [netns] root 26 2 0 22:09 ? 00:00:00 [kworker/3:1] root 27 2 0 22:09 ? 00:00:00 [kworker/0:1] root 28 2 0 22:09 ? 00:00:00 [kworker/2:1] root 29 2 0 22:09 ? 00:00:00 [kworker/1:1] root 30 2 0 22:09 ? 00:00:00 [kworker/u8:1] root 51 2 0 22:09 ? 00:00:00 [writeback] root 52 2 0 22:09 ? 00:00:00 [bioset] root 53 2 0 22:09 ? 00:00:00 [kblockd] root 54 2 0 22:09 ? 00:00:00 [irq/215-atc2603] root 55 2 0 22:09 ? 00:00:00 [b0200000.spi] root 56 2 0 22:09 ? 00:00:00 [khubd] root 57 2 0 22:09 ? 00:00:00 [ion_fb] root 58 2 0 22:09 ? 00:00:00 [ion_system] root 59 2 0 22:09 ? 00:00:00 [cfg80211] root 60 2 0 22:09 ? 00:00:00 [cfinteractive] root 61 2 0 22:09 ? 00:00:00 [rpciod] root 62 2 0 22:09 ? 00:00:00 [khungtaskd] root 63 2 0 22:09 ? 00:00:00 [kswapd0] root 64 2 0 22:09 ? 00:00:00 [ksmd] root 65 2 0 22:09 ? 00:00:00 [fsnotify_mark] root 66 2 0 22:09 ? 00:00:00 [nfsiod] root 67 2 0 22:09 ? 00:00:00 [cifsiod] root 68 2 0 22:09 ? 00:00:00 [crypto] root 85 2 0 22:09 ? 00:00:00 [atm705a-hdmi-hd] root 86 2 0 22:09 ? 00:00:00 [aotg_start_mon_] root 87 2 0 22:09 ? 00:00:00 [kpsmoused] root 88 2 0 22:09 ? 00:00:00 [dm_bufio_cache] root 89 2 0 22:09 ? 00:00:00 [host_add_work0] root 90 2 0 22:09 ? 00:00:00 [host_add_work2] root 91 2 0 22:09 ? 00:00:00 [binder] root 92 2 0 22:09 ? 00:00:00 [kworker/0:2] root 93 2 0 22:09 ? 00:00:00 [kworker/u8:2] root 94 2 0 22:09 ? 00:00:00 [kworker/u8:3] root 95 2 0 22:09 ? 00:00:00 [kworker/u8:4] root 96 2 0 22:09 ? 00:00:00 [krfcommd] root 97 2 0 22:09 ? 00:00:01 [mmcqd/0] root 98 2 0 22:09 ? 00:00:00 [owlfb] root 99 2 0 22:09 ? 00:00:00 [deferwq] root 100 2 0 22:09 ? 00:00:00 [atc260x_charger] root 101 2 0 22:09 ? 00:00:00 [usb_monitor] root 128 2 0 22:09 ? 00:00:00 [kworker/0:1H] root 132 2 0 22:09 ? 00:00:00 [jbd2/mmcblk0p2-] root 133 2 0 22:09 ? 00:00:00 [ext4-dio-unwrit] root 139 2 0 22:09 ? 00:00:01 [loop0] root 142 2 0 22:09 ? 00:00:00 [kworker/1:1H] root 160 2 0 22:10 ? 00:00:00 [jbd2/mmcblk0p3-] root 161 2 0 22:10 ? 00:00:00 [ext4-dio-unwrit] root 168 2 0 22:10 ? 00:00:00 [kworker/3:1H] root 172 2 0 22:10 ? 00:00:00 [kworker/2:1H] root 182 2 0 22:10 ? 00:00:00 [kauditd] root 191 2 0 22:10 ? 00:00:00 [kworker/1:2] root 202 1 1 22:10 ? 00:00:02 /lib/systemd/systemd-journald root 225 1 0 22:10 ? 00:00:00 /lib/systemd/systemd-udevd root 253 2 0 22:10 ? 00:00:00 [atv5201-IRKEYPA] root 255 2 0 22:10 ? 00:00:00 [oo] root 256 2 0 22:10 ? 00:00:00 [kethernet_resum] root 258 2 0 22:10 ? 00:00:00 [ethernet_work_q] root 259 2 0 22:10 ? 00:00:00 [phy_detect_work] root 271 2 0 22:10 ? 00:00:00 [atc260x_gauge_w] root 277 2 0 22:10 ? 00:00:00 [pvr_timer] root 428 1 0 22:10 ? 00:00:00 /sbin/rpcbind -w statd 438 1 0 22:10 ? 00:00:00 /sbin/rpc.statd root 450 1 0 22:10 ? 00:00:00 /usr/sbin/rpc.idmapd root 452 1 1 22:10 ? 00:00:01 /usr/sbin/haveged --Foreground --verbose=1 --write=1024 volumio 455 1 0 22:10 ? 00:00:00 /usr/bin/udisks-glue --foreground volumio 457 1 0 22:10 ? 00:00:00 /usr/local/bin/volumio-remote-updater root 462 1 0 22:10 ? 00:00:00 /lib/systemd/systemd-logind avahi 486 1 0 22:10 ? 00:00:00 avahi-daemon: running [volumio.local] message+ 498 1 0 22:10 ? 00:00:00 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation root 519 1 0 22:10 ? 00:00:00 /usr/sbin/ifplugd -i eth0 -q -f -u0 -d10 -w -I avahi 542 486 0 22:10 ? 00:00:00 avahi-daemon: chroot helper ntp 543 1 0 22:10 ? 00:00:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 100:104 root 564 1 0 22:10 ? 00:00:00 /usr/lib/udisks/udisks-daemon --no-debug root 572 1 0 22:10 tty1 00:00:00 /sbin/agetty --noclear tty1 linux root 573 1 0 22:10 ttyS3 00:00:00 /sbin/agetty --keep-baud 115200 38400 9600 ttyS3 vt102 root 577 564 0 22:10 ? 00:00:00 udisks-daemon: not polling any devices root 591 1 0 22:10 ? 00:00:00 /usr/lib/policykit-1/polkitd --no-debug root 629 1 0 22:10 ? 00:00:00 dhcpcd eth0 root 676 2 0 22:10 ? 00:00:00 [aotg_dev0_onoff] root 677 2 0 22:10 ? 00:00:00 [aotg_dev1_onoff] volumio 741 1 11 22:10 ? 00:00:19 /usr/local/bin/node /volumio/index.js root 752 1 0 22:10 ? 00:00:00 /usr/sbin/nmbd -D root 753 752 0 22:10 ? 00:00:00 /usr/sbin/nmbd -D root 767 1 0 22:10 ? 00:00:00 /usr/sbin/winbindd root 769 767 0 22:10 ? 00:00:00 /usr/sbin/winbindd root 783 2 0 22:10 ? 00:00:00 [kworker/3:2] root 795 1 0 22:10 ? 00:00:00 /usr/sbin/smbd -D root 800 767 0 22:10 ? 00:00:00 /usr/sbin/winbindd root 801 767 0 22:10 ? 00:00:00 /usr/sbin/winbindd root 802 795 0 22:10 ? 00:00:00 /usr/sbin/smbd -D root 836 2 0 22:10 ? 00:00:00 [cifsd] volumio 841 741 0 22:10 ? 00:00:00 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 847 841 1 22:10 ? 00:00:02 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 848 841 1 22:10 ? 00:00:02 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 853 841 1 22:10 ? 00:00:02 /bin/node /volumio/app/plugins/miscellanea/albumart/serverStartup.js 3001 /data/albumart volumio 868 1 0 22:10 ? 00:00:00 /bin/bash /data/plugins/music_service/volspotconnect2/startconnect.sh volumio 869 868 0 22:10 ? 00:00:00 ./librespot -b 320 -c /tmp --name Volumio --backend alsa --device plughw:1 --disable-audio-cache --initial-volume 33 volumio 905 1 0 22:10 ? 00:00:00 /usr/bin/upmpdcli -c /tmp/upmpdcli.conf root 1499 2 0 22:11 ? 00:00:00 [kworker/2:2] mpd 1501 1 3 22:11 ? 00:00:03 /usr/bin/mpd --no-daemon volumio 1517 1 0 22:11 ? 00:00:00 /usr/local/bin/shairport-sync volumio 1955 741 0 22:13 ? 00:00:00 /bin/sh -c /usr/local/bin/node /volumio/logsubmit.js 'No audio using D50 dac on usbridge' volumio 1956 1955 48 22:13 ? 00:00:00 /usr/local/bin/node /volumio/logsubmit.js No audio using D50 dac on usbridge volumio 1981 1956 0 22:13 ? 00:00:00 /bin/sh -c ps -ef >>/tmp/logondemand 2>&1 volumio 1982 1981 0 22:13 ? 00:00:00 ps -ef # sudo journalctl -p 7 --------------- -- Logs begin at Fri 2018-09-28 22:09:30 UTC, end at Fri 2018-09-28 22:13:03 UTC. -- Sep 28 22:09:30 volumio systemd-journal[202]: Runtime journal is using 4.0M (max allowed 30.0M, trying to leave 74.2M free of 490.5M available → current limit 30.0M). Sep 28 22:09:30 volumio kernel: Booting Linux on physical CPU 0x0 Sep 28 22:09:30 volumio kernel: Initializing cgroup subsys cpu Sep 28 22:09:30 volumio kernel: Initializing cgroup subsys cpuacct Sep 28 22:09:30 volumio kernel: Linux version 3.10.38 (root@debian-cem) (gcc version 4.8.1 (Sourcery CodeBench Lite 2013.11-33) ) #4 SMP PREEMPT Fri Dec 22 11:54:41 IST 2017 Sep 28 22:09:30 volumio kernel: CPU: ARMv7 Processor [414fc091] revision 1 (ARMv7), cr=10c53c7d Sep 28 22:09:30 volumio kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Sep 28 22:09:30 volumio kernel: Machine: gs705a, model: Actions GS705A board Sep 28 22:09:30 volumio kernel: bootconsole [earlycon0] enabled Sep 28 22:09:30 volumio kernel: owl_reserve: pyhsical memory size 1073741824 bytes, end @0x2f800000 Sep 28 22:09:30 volumio kernel: find owl_fb_size=0x800000 Sep 28 22:09:30 volumio kernel: find owl_kinfo_size=0x100000 Sep 28 22:09:30 volumio kernel: find owl_ion0_size=0x100000 Sep 28 22:09:30 volumio kernel: find owl_ion1_size=0xc000000 Sep 28 22:09:30 volumio kernel: ion_reserve: ion_fb reserved base 2ee00000 size 1048576 Sep 28 22:09:30 volumio kernel: Reserved memory 193MB Sep 28 22:09:30 volumio kernel: FB: 0x2f000000, 8MB KINFO: 0x2ef00000, 1MB ION0: 0x2ee00000, 1MB ION1: 0x22e00000, 192MB Sep 28 22:09:30 volumio kernel: cma: CMA: reserved 192 MiB at 22c00000 Sep 28 22:09:30 volumio kernel: Memory policy: ECC disabled, Data cache writealloc Sep 28 22:09:30 volumio kernel: On node 0 totalpages: 262144 Sep 28 22:09:30 volumio kernel: free_area_init_node: node 0, pgdat c0d3de40, node_mem_map c0ead000 Sep 28 22:09:30 volumio kernel: Normal zone: 1520 pages used for memmap Sep 28 22:09:30 volumio kernel: Normal zone: 0 pages reserved Sep 28 22:09:30 volumio kernel: Normal zone: 194560 pages, LIFO batch:31 Sep 28 22:09:30 volumio kernel: HighMem zone: 528 pages used for memmap Sep 28 22:09:30 volumio kernel: HighMem zone: 67584 pages, LIFO batch:15 Sep 28 22:09:30 volumio kernel: owl_smp_init_cpus(): ncores 4 Sep 28 22:09:30 volumio kernel: PERCPU: Embedded 9 pages/cpu @c16c1000 s13824 r8192 d14848 u36864 Sep 28 22:09:30 volumio kernel: pcpu-alloc: s13824 r8192 d14848 u36864 alloc=9*4096 Sep 28 22:09:30 volumio kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 28 22:09:30 volumio kernel: Built 1 zonelists in Zone order, mobility grouping on. Total pages: 260624 Sep 28 22:09:30 volumio kernel: Kernel command line: console=ttyS3 earlyprintk clk_ignore_unused selinux=0 scandelay console=ttyS3,115200n8 console=tty0 loglevel=0 real_rootflag=rw root=/dev/mmcblk0p2 rootwait imgpart=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh boot_dev=sd2 Sep 28 22:09:30 volumio kernel: boot_mode_process Sep 28 22:09:30 volumio kernel: PID hash table entries: 4096 (order: 2, 16384 bytes) Sep 28 22:09:30 volumio kernel: Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Sep 28 22:09:30 volumio kernel: Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Sep 28 22:09:30 volumio kernel: allocated 2097152 bytes of page_cgroup Sep 28 22:09:30 volumio kernel: please try 'cgroup_disable=memory' option if you don't want memory cgroups Sep 28 22:09:30 volumio kernel: Memory: 1024MB = 1024MB total Sep 28 22:09:30 volumio kernel: Memory: 811148k/811148k available, 237428k reserved, 270336K highmem Sep 28 22:09:30 volumio kernel: Virtual kernel memory layout: vector : 0xffff0000 - 0xffff1000 ( 4 kB) fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB) vmalloc : 0xf0000000 - 0xff000000 ( 240 MB) lowmem : 0xc0000000 - 0xef800000 ( 760 MB) pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) modules : 0xbf000000 - 0xbfe00000 ( 14 MB) .text : 0xc0008000 - 0xc0c15ae4 (12343 kB) .init : 0xc0c16000 - 0xc0c8c600 ( 474 kB) .data : 0xc0c8e000 - 0xc0d5ac74 ( 820 kB) .bss : 0xc0d5ac74 - 0xc0eacfb4 (1353 kB) Sep 28 22:09:30 volumio kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 28 22:09:30 volumio kernel: Preemptible hierarchical RCU implementation. Sep 28 22:09:30 volumio kernel: NR_IRQS:247 Sep 28 22:09:30 volumio kernel: sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 178956ms Sep 28 22:09:30 volumio kernel: Console: colour dummy device 80x30 Sep 28 22:09:30 volumio kernel: console [tty0] enabled, bootconsole disabled Sep 28 22:09:30 volumio kernel: kmemleak: Kernel memory leak detector disabled Sep 28 22:09:30 volumio kernel: Calibrating delay loop... 1196.85 BogoMIPS (lpj=5984256) Sep 28 22:09:30 volumio kernel: pid_max: default: 32768 minimum: 301 Sep 28 22:09:30 volumio kernel: Security Framework initialized Sep 28 22:09:30 volumio kernel: SELinux: Disabled at boot. Sep 28 22:09:30 volumio kernel: AppArmor: AppArmor disabled by boot time parameter Sep 28 22:09:30 volumio kernel: Mount-cache hash table entries: 512 Sep 28 22:09:30 volumio kernel: Initializing cgroup subsys debug Sep 28 22:09:30 volumio kernel: Initializing cgroup subsys memory Sep 28 22:09:30 volumio kernel: Initializing cgroup subsys freezer Sep 28 22:09:30 volumio kernel: CPU: Testing write buffer coherency: ok Sep 28 22:09:30 volumio kernel: CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 Sep 28 22:09:30 volumio kernel: owl_smp_prepare_cpus(max_cpus:4) Sep 28 22:09:30 volumio kernel: Setting up static identity map for 0xc07e6a90 - 0xc07e6b50 Sep 28 22:09:30 volumio kernel: owl_l2x0_init() Sep 28 22:09:30 volumio kernel: L310 cache controller enabled Sep 28 22:09:30 volumio kernel: l2x0: 16 ways, CACHE_ID 0x410080c9, AUX_CTRL 0x3e050000, Cache size: 524288 B Sep 28 22:09:30 volumio kernel: ftrace: Allocated trace_printk buffers Sep 28 22:09:30 volumio kernel: cpu:1 Sep 28 22:09:30 volumio kernel: po 1 Sep 28 22:09:30 volumio kernel: wu 1 Sep 28 22:09:30 volumio kernel: CPU1: Booted secondary processor Sep 28 22:09:30 volumio kernel: pr:-1 Sep 28 22:09:30 volumio kernel: CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 Sep 28 22:09:30 volumio kernel: cpu:2 Sep 28 22:09:30 volumio kernel: po 2 Sep 28 22:09:30 volumio kernel: wu 2 Sep 28 22:09:30 volumio kernel: CPU2: Booted secondary processor Sep 28 22:09:30 volumio kernel: pr:-1 Sep 28 22:09:30 volumio kernel: CPU2: thread -1, cpu 2, socket 0, mpidr 80000002 Sep 28 22:09:30 volumio kernel: cpu:3 Sep 28 22:09:30 volumio kernel: po 3 Sep 28 22:09:30 volumio kernel: wu 3 Sep 28 22:09:30 volumio kernel: CPU3: Booted secondary processor Sep 28 22:09:30 volumio kernel: pr:-1 Sep 28 22:09:30 volumio kernel: CPU3: thread -1, cpu 3, socket 0, mpidr 80000003 Sep 28 22:09:30 volumio kernel: Brought up 4 CPUs Sep 28 22:09:30 volumio kernel: SMP: Total of 4 processors activated (4787.40 BogoMIPS). Sep 28 22:09:30 volumio kernel: CPU: All CPU(s) started in SVC mode. Sep 28 22:09:30 volumio kernel: devtmpfs: initialized Sep 28 22:09:30 volumio kernel: pinctrl core: initialized pinctrl subsystem Sep 28 22:09:30 volumio kernel: regulator-dummy: no parameters Sep 28 22:09:30 volumio kernel: NET: Registered protocol family 16 Sep 28 22:09:30 volumio kernel: DMA: preallocated 14336 KiB pool for atomic coherent allocations Sep 28 22:09:30 volumio kernel: init sirqs Sep 28 22:09:30 volumio kernel: owl_gpio_init() Sep 28 22:09:30 volumio kernel: sparky sbc spi0 registration Calling Sep 28 22:09:30 volumio kernel: owl_gpio_probe() Sep 28 22:09:30 volumio kernel: owl gpio bank0 - irq68 Sep 28 22:09:30 volumio kernel: owl gpio bank1 - irq69 Sep 28 22:09:30 volumio kernel: owl gpio bank2 - irq70 Sep 28 22:09:30 volumio kernel: owl gpio bank3 - irq71 Sep 28 22:09:30 volumio kernel: owl gpio bank4 - irq72 Sep 28 22:09:30 volumio kernel: owl_sirq_probe() Sep 28 22:09:30 volumio kernel: owl sirq bank0 - irq45 Sep 28 22:09:30 volumio kernel: owl sirq bank1 - irq46 Sep 28 22:09:30 volumio kernel: owl sirq bank2 - irq47 Sep 28 22:09:30 volumio kernel: sirq map 45 -> 213 Sep 28 22:09:30 volumio kernel: sirq map 46 -> 214 Sep 28 22:09:30 volumio kernel: sirq map 47 -> 215 Sep 28 22:09:30 volumio kernel: owl_board_init() Sep 28 22:09:30 volumio kernel: hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers. Sep 28 22:09:30 volumio kernel: hw-breakpoint: maximum watchpoint size is 4 bytes. Sep 28 22:09:30 volumio kernel: free reserve pages 256 to buddy system Sep 28 22:09:30 volumio kernel: owl_common_init() Sep 28 22:09:30 volumio kernel: [PowerGate] name: 'dma', on: 0, before SPS_PG_CTL: 0x703360 Sep 28 22:09:30 volumio kernel: [PowerGate] name: 'dma', on: 0, after SPS_PG_CTL: 0x703260 Sep 28 22:09:30 volumio kernel: pwm-owl b01b0050.pwm: Probing... Sep 28 22:09:30 volumio kernel: dmm debugfs support Sep 28 22:09:30 volumio kernel: i2c i2c-2: of_i2c: invalid reg on /i2c@b0178000/mpu6515@68 Sep 28 22:09:30 volumio kernel: bio: create slab at 0 Sep 28 22:09:30 volumio kernel: owl_pwm_bl_probe: name = backlight.2 Sep 28 22:09:30 volumio kernel: owl_dma_init Sep 28 22:09:30 volumio kernel: owl_dma_probe Sep 28 22:09:30 volumio kernel: [PowerGate] name: 'dma', on: 1, before SPS_PG_CTL: 0x702260 Sep 28 22:09:30 volumio kernel: [PowerGate] name: 'dma', on: 1, after SPS_PG_CTL: 0x703360 Sep 28 22:09:30 volumio kernel: owl_dma b0260000.dma: actions AHB DMA Controller ( cpy slave memset ), 12 channels Sep 28 22:09:30 volumio kernel: atc260x_i2c 0-0065: Probing... Sep 28 22:09:30 volumio kernel: atc260x_i2c 0-0065: atc260x_core_dev_init() enter Sep 28 22:09:30 volumio kernel: atc260x_i2c 0-0065: set bdg ctl, ret=0 value=0xd5 Sep 28 22:09:30 volumio kernel: atc260x_i2c 0-0065: detect PMU chip type 1 ver A Sep 28 22:09:30 volumio kernel: atc260x_i2c 0-0065: PMU root IRQ 215 Sep 28 22:09:30 volumio kernel: atc260x_i2c 0-0065: icm_ohm not config, use default value Sep 28 22:09:30 volumio kernel: atc260x_i2c 0-0065: auxadc icm_ohm = 20 Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-dcdc1.1: Probing atc2603c-dcdc1, id=1 Sep 28 22:09:30 volumio kernel: dcdc1: 700 <--> 1400 mV at 975 mV Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-dcdc2.2: Probing atc2603c-dcdc2, id=2 Sep 28 22:09:30 volumio kernel: dcdc2: 1300 <--> 2150 mV at 1350 mV Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-dcdc3.3: Probing atc2603c-dcdc3, id=3 Sep 28 22:09:30 volumio kernel: dcdc3: 2600 <--> 3300 mV at 3100 mV Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-ldo1.1: Probing atc2603c-ldo1, id=1 Sep 28 22:09:30 volumio kernel: ldo1: 2800 mV Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-ldo2.2: Probing atc2603c-ldo2, id=2 Sep 28 22:09:30 volumio kernel: ldo2: 2600 <--> 3300 mV at 3100 mV Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-ldo3.3: Probing atc2603c-ldo3, id=3 Sep 28 22:09:30 volumio kernel: ldo3: 1500 <--> 2000 mV at 1800 mV Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-ldo5.5: Probing atc2603c-ldo5, id=5 Sep 28 22:09:30 volumio kernel: ldo5: 2600 <--> 3300 mV at 3100 mV Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-ldo6.6: Probing atc2603c-ldo6, id=6 Sep 28 22:09:30 volumio kernel: ldo6: 700 <--> 1400 mV at 1100 mV Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-ldo7.7: Probing atc2603c-ldo7, id=7 Sep 28 22:09:30 volumio kernel: ldo7: 1800 mV Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-ldo8.8: Probing atc2603c-ldo8, id=8 Sep 28 22:09:30 volumio kernel: ldo8: 2300 <--> 3300 mV at 3100 mV Sep 28 22:09:30 volumio kernel: atc260x-regulator atc2603c-ldo11.11: Probing atc2603c-ldo11, id=11 Sep 28 22:09:30 volumio kernel: ldo11: 2600 <--> 3300 mV at 3100 mV Sep 28 22:09:30 volumio kernel: atc260x-switch-ldo atc2603c-switch1.1: Probing atc2603c-switch1, id=1 Sep 28 22:09:30 volumio kernel: atc260x-switch-ldo atc2603c-switch1.1: pmic_ver=0 Sep 28 22:09:30 volumio kernel: [SWITCH1] set switch 1 to ldo mode Version D! Sep 28 22:09:30 volumio kernel: switch1: 3000 <--> 3300 mV at 3100 mV Sep 28 22:09:30 volumio kernel: atc260x-ext-pwm-dcdc atc2603c-ext-pwm-dcdc1.1: Probing atc2603c-ext-pwm-dcdc1 Sep 28 22:09:30 volumio kernel: atc260x-ext-pwm-dcdc atc2603c-ext-pwm-dcdc1.1: table_len = 15 Sep 28 22:09:30 volumio kernel: atc260x-ext-pwm-dcdc atc2603c-ext-pwm-dcdc1.1: got init voltage selector 8 Sep 28 22:09:30 volumio kernel: vdd-gpu-dcdc: 900 <--> 1250 mV at 1100 mV normal Sep 28 22:09:30 volumio kernel: atc260x-ext-pwm-dcdc atc2603c-ext-pwm-dcdc2.2: Probing atc2603c-ext-pwm-dcdc2 Sep 28 22:09:30 volumio kernel: atc260x-ext-pwm-dcdc atc2603c-ext-pwm-dcdc2.2: table_len = 15 Sep 28 22:09:30 volumio kernel: atc260x-ext-pwm-dcdc atc2603c-ext-pwm-dcdc2.2: got init voltage selector 6 Sep 28 22:09:30 volumio kernel: vdd-core-dcdc: 900 <--> 1250 mV at 1050 mV normal Sep 28 22:09:30 volumio kernel: atc260x_i2c 0-0065: atc260x_core_dev_init() exit Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: Probing... Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: _set_s2_mode() can not get of_property s2_mode Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: _atc260x_pm_set_wakeup_src_inner() enter, mask=0x7fff src=0x706 Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: _atc260x_pm_set_wakeup_src_inner() setup reg=0x0 msk=0xffe0 val=0xe0c0 readback=0xe0cb Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: _atc260x_pm_set_wakeup_src_inner() setup reg=0x3 msk=0xc val=0x0 readback=0x4280 Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: _atc260x_pm_set_wakeup_src_inner() enter, mask=0x8 src=0x0 Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: _atc260x_pm_set_wakeup_src_inner() setup reg=0x0 msk=0x100 val=0x0 readback=0xe0cb Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: _clear_status() no need to restore old alarm Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: got support_adaptor_type: 3 Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: translated wakeup falgs: 0x0 Sep 28 22:09:30 volumio kernel: [PM] set pmic suspend ops 0xc0cdae10 Sep 28 22:09:30 volumio kernel: atc260x-pm atc2603c-pm.0: #####atc260x_pm_probe PMU_SYS_CTL0:0xe0cb #### Sep 28 22:09:30 volumio kernel: SCSI subsystem initialized Sep 28 22:09:30 volumio kernel: asoc_spi0 b0200000.spi: master is unqueued, this is deprecated Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver usbfs Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver hub Sep 28 22:09:30 volumio kernel: usbcore: registered new device driver usb Sep 28 22:09:30 volumio kernel: media: Linux media interface: v0.10 Sep 28 22:09:30 volumio kernel: Linux video capture interface: v2.00 Sep 28 22:09:30 volumio kernel: owl_ion_probe: add heap ion_fb Sep 28 22:09:30 volumio kernel: owl_ion_probe: add heap ion_pmem Sep 28 22:09:30 volumio kernel: owl_ion_probe: add heap ion_system Sep 28 22:09:30 volumio kernel: Advanced Linux Sound Architecture Driver Initialized. Sep 28 22:09:30 volumio kernel: Bluetooth: Core ver 2.16 Sep 28 22:09:30 volumio kernel: NET: Registered protocol family 31 Sep 28 22:09:30 volumio kernel: Bluetooth: HCI device and connection manager initialized Sep 28 22:09:30 volumio kernel: Bluetooth: HCI socket layer initialized Sep 28 22:09:30 volumio kernel: Bluetooth: L2CAP socket layer initialized Sep 28 22:09:30 volumio kernel: Bluetooth: SCO socket layer initialized Sep 28 22:09:30 volumio kernel: cfg80211: Calling CRDA to update world regulatory domain Sep 28 22:09:30 volumio kernel: Switching to clocksource timer0 Sep 28 22:09:30 volumio kernel: FS-Cache: Loaded Sep 28 22:09:30 volumio kernel: NET: Registered protocol family 2 Sep 28 22:09:30 volumio kernel: TCP established hash table entries: 8192 (order: 4, 65536 bytes) Sep 28 22:09:30 volumio kernel: TCP bind hash table entries: 8192 (order: 4, 65536 bytes) Sep 28 22:09:30 volumio kernel: TCP: Hash tables configured (established 8192 bind 8192) Sep 28 22:09:30 volumio kernel: TCP: reno registered Sep 28 22:09:30 volumio kernel: UDP hash table entries: 512 (order: 2, 16384 bytes) Sep 28 22:09:30 volumio kernel: UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) Sep 28 22:09:30 volumio kernel: NET: Registered protocol family 1 Sep 28 22:09:30 volumio kernel: RPC: Registered named UNIX socket transport module. Sep 28 22:09:30 volumio kernel: RPC: Registered udp transport module. Sep 28 22:09:30 volumio kernel: RPC: Registered tcp transport module. Sep 28 22:09:30 volumio kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Sep 28 22:09:30 volumio kernel: Trying to unpack rootfs image as initramfs... Sep 28 22:09:30 volumio kernel: Freeing initrd memory: 3852K (c2000000 - c23c3000) Sep 28 22:09:30 volumio kernel: hw perfevents: enabled with ARMv7_Cortex_A9 PMU driver, 7 counters available Sep 28 22:09:30 volumio kernel: owl_uart: no device is found Sep 28 22:09:30 volumio kernel: b0126000.serial: ttyS3 at MMIO 0xb0126000 (irq = 64) is a OWL_SERIAL Sep 28 22:09:30 volumio kernel: console [ttyS3] enabled Sep 28 22:09:30 volumio kernel: b012a000.serial: ttyS5 at MMIO 0xb012a000 (irq = 66) is a OWL_SERIAL Sep 28 22:09:30 volumio kernel: ## boot_dev: 0x22 Sep 28 22:09:30 volumio kernel: audit: initializing netlink socket (disabled) Sep 28 22:09:30 volumio kernel: type=2000 audit(0.850:1): initialized Sep 28 22:09:30 volumio kernel: VFS: Disk quotas dquot_6.5.2 Sep 28 22:09:30 volumio kernel: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Sep 28 22:09:30 volumio kernel: NTFS driver 2.1.30 [Flags: R/W]. Sep 28 22:09:30 volumio kernel: fuse init (API version 7.22) Sep 28 22:09:30 volumio kernel: exFAT: Core Version 1.1.3 Sep 28 22:09:30 volumio kernel: exFAT: FS Version 1.1.3 Sep 28 22:09:30 volumio kernel: msgmni has been set to 1449 Sep 28 22:09:30 volumio kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 28 22:09:30 volumio kernel: io scheduler noop registered Sep 28 22:09:30 volumio kernel: io scheduler deadline registered Sep 28 22:09:30 volumio kernel: io scheduler cfq registered (default) Sep 28 22:09:30 volumio kernel: #### insmod vde driver! Sep 28 22:09:30 volumio kernel: mali0 b0280000.vde: Probe vde device Sep 28 22:09:30 volumio kernel: info ic_type 0x5206 Sep 28 22:09:30 volumio kernel: vde->irq =52 Sep 28 22:09:30 volumio kernel: cputherm_register_notifier list 0 Sep 28 22:09:30 volumio kernel: mali0 b0280000.vde: resource: iomem: [mem 0xb0280000-0xb0280107] mapping to f8280000, irq 82 Sep 28 22:09:30 volumio kernel: sps base = 0xf81b0100 Sep 28 22:09:30 volumio kernel: cmu base = 0xf8160000 Sep 28 22:09:30 volumio kernel: SPS_PG_CTL = 0xf81b0100 Sep 28 22:09:30 volumio kernel: Share_Mem_REG = 0xf8240004 Sep 28 22:09:30 volumio kernel: CMU_COREPLL = 0xf8160000 Sep 28 22:09:30 volumio kernel: CMU_VDE_CLK = 0xf8160040 Sep 28 22:09:30 volumio kernel: CMU_DEVRST0 = 0xf81600a8 Sep 28 22:09:30 volumio kernel: CMU_DEVCLKEN0 = 0xf81600a0 Sep 28 22:09:30 volumio kernel: device_create_file ! Sep 28 22:09:30 volumio kernel: owl_dss DE: owl_de_probe, pdev = 0xe22f1600 Sep 28 22:09:30 volumio kernel: owl_dss DE: DE INITED FROM UBOOT ?? 1 Sep 28 22:09:30 volumio kernel: owl_dss DE: de irq init ok Sep 28 22:09:30 volumio kernel: owl_dss MMU: mmu_init: base 0xe3a00000 base_phys 0xc0c4165c23a00000 free_info->addr 0xe3a00000 Sep 28 22:09:30 volumio kernel: 1 portname = dsi Sep 28 22:09:30 volumio kernel: generic_dsi_panel_drv_init Sep 28 22:09:30 volumio kernel: owl_dsihw_probe Sep 28 22:09:30 volumio kernel: owl_dss DSI: error!dsihw_parse_params, fail to get lcd reset gpio Sep 28 22:09:30 volumio kernel: owl_dss DSI: owl_dsihw_probe called ok ~~~~~~~~~~~~~ Sep 28 22:09:30 volumio kernel: 1 portname = dsi Sep 28 22:09:30 volumio kernel: current type dsi Sep 28 22:09:30 volumio kernel: OWL_HDMI: Enter owldss_hdmihw_probe Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi info ic_type 0x3 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: of_get_hdmi_data Sep 28 22:09:30 volumio kernel: OWL_HDMI: of_get_hdmi_data ~~~~~~~~~~~~~ hdmi.ip_data.cfg.cm.code 0 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: base=f82c0000 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: init_display Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: ENTER hdmi_panel_probe Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_panel_probe x_res= 0 y_res = 0 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: owl_dss_device hdmi p->0xc0cd3808 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hpd_enable start Sep 28 22:09:30 volumio kernel: timings : xres 1280 yres 720 size of 40 4 Sep 28 22:09:30 volumio kernel: OWL_HDMI: owldss_hdmi_display_set_vid vid 2 ,code 4 mode 1 Sep 28 22:09:30 volumio kernel: OWL_HDMI: register irq ON! Sep 28 22:09:30 volumio kernel: Actions CEC for OWL Driver, (c) 2009 ACTIONS Electronics Sep 28 22:09:30 volumio kernel: atm7059a-hdmi-cec b02c0000.hdmi_cec: probe successful Sep 28 22:09:30 volumio kernel: brd: module loaded Sep 28 22:09:30 volumio kernel: loop: module loaded Sep 28 22:09:30 volumio kernel: misc_info_init, line 1059, Dec 22 2017 11:42:15 Sep 28 22:09:30 volumio kernel: mi_debug_init, line 372 Sep 28 22:09:30 volumio kernel: tun: Universal TUN/TAP device driver, 1.6 Sep 28 22:09:30 volumio kernel: tun: (C) 1999-2004 Max Krasnyansky Sep 28 22:09:30 volumio kernel: PPP generic driver version 2.4.2 Sep 28 22:09:30 volumio kernel: PPP BSD Compression module registered Sep 28 22:09:30 volumio kernel: PPP Deflate Compression module registered Sep 28 22:09:30 volumio kernel: PPP MPPE Compression module registered Sep 28 22:09:30 volumio kernel: NET: Registered protocol family 24 Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver rtl8150 Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver r8152 Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver ax88179_178a Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver cdc_ether Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver cdc_subset Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver cdc_ncm Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver asix Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver sr9700_android Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver CoreChips Sep 28 22:09:30 volumio kernel: port_host_plug_detect[0]:3 Sep 28 22:09:30 volumio kernel: port0_vubs_en:-1 Sep 28 22:09:30 volumio kernel: port_host_plug_detect[1]:3 Sep 28 22:09:30 volumio kernel: port1_vubs_en:116 Sep 28 22:09:30 volumio kernel: can't find aotg_udc_enable config Sep 28 22:09:30 volumio kernel: can't find aotg_udc_enable config Sep 28 22:09:30 volumio kernel: No aotg_udc being enabled! Sep 28 22:09:30 volumio kernel: ------------dwc3_clk_init-----ic=1----- Sep 28 22:09:30 volumio kernel: [PowerGate] name: 'usb3', on: 1, before SPS_PG_CTL: 0x703360 Sep 28 22:09:30 volumio kernel: [PowerGate] name: 'usb3', on: 1, after SPS_PG_CTL: 0x707760 Sep 28 22:09:30 volumio kernel: GS705A phy init for dwc3 gadget 11:51:14 Sep 28 22:09:30 volumio kernel: GS705A phy init for dwc3 gadget 11:51:14 Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver usb-storage Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver usbserial Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver option Sep 28 22:09:30 volumio kernel: usbserial: USB Serial support registered for GSM modem (1-port) Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver pl2303 Sep 28 22:09:30 volumio kernel: usbserial: USB Serial support registered for pl2303 Sep 28 22:09:30 volumio kernel: mousedev: PS/2 mouse device common for all mice Sep 28 22:09:30 volumio kernel: atc260x-onoff atc2603c-onoff.0: Probing atc2603c-onoff Sep 28 22:09:30 volumio kernel: atc260x-onoff atc2603c-onoff.0: atc260x_onoff IRQ num : 216 Sep 28 22:09:30 volumio kernel: input: atc260x_onoff as /devices/b0170000.i2c/i2c-0/0-0065/atc2603c-onoff.0/input/input0 Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver xpad Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver usb_acecad Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver aiptek Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver gtco Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver hanwang Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver kbtab Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver wacom Sep 28 22:09:30 volumio kernel: atc260x-rtc atc2603c-rtc.0: Probing... Sep 28 22:09:30 volumio kernel: no blk dev Sep 28 22:09:30 volumio kernel: read MiscInfoHeader failed Sep 28 22:09:30 volumio kernel: read Head failed Sep 28 22:09:30 volumio kernel: OWL_HDMI_ERR: failed to read hdcp key from secure storage Sep 28 22:09:30 volumio kernel: atc260x-rtc atc2603c-rtc.0: rtc core: registered atc260x-RTC as rtc0 Sep 28 22:09:30 volumio kernel: atc260x-rtc atc2603c-rtc.0: RTC alarm IRQ num : 217 Sep 28 22:09:30 volumio kernel: i2c /dev entries driver Sep 28 22:09:30 volumio kernel: IR NEC protocol handler initialized Sep 28 22:09:30 volumio kernel: IR RC5(x) protocol handler initialized Sep 28 22:09:30 volumio kernel: IR RC6 protocol handler initialized Sep 28 22:09:30 volumio kernel: IR JVC protocol handler initialized Sep 28 22:09:30 volumio kernel: IR Sony protocol handler initialized Sep 28 22:09:30 volumio kernel: IR RC5 (streamzap) protocol handler initialized Sep 28 22:09:30 volumio kernel: IR SANYO protocol handler initialized Sep 28 22:09:30 volumio kernel: IR MCE Keyboard/mouse protocol handler initialized Sep 28 22:09:30 volumio kernel: atc260x-hwmon atc2603c-hwmon.0: Probing atc2603c-hwmon Sep 28 22:09:30 volumio kernel: tmu-mem:start=0xb01b00e8 Sep 28 22:09:30 volumio kernel: owl_wdt b0020600.twd-watchdog: watchdog soft mode Sep 28 22:09:30 volumio kernel: device-mapper: uevent: version 1.0.3 Sep 28 22:09:30 volumio kernel: device-mapper: ioctl: 4.24.0-ioctl (2013-01-15) initialised: dm-devel@redhat.com Sep 28 22:09:30 volumio kernel: Bluetooth: HCI UART driver ver 2.2 Sep 28 22:09:30 volumio kernel: Bluetooth: HCI H4 protocol initialized Sep 28 22:09:30 volumio kernel: Bluetooth: HCI BCSP protocol initialized Sep 28 22:09:30 volumio kernel: Bluetooth: HCILL protocol initialized Sep 28 22:09:30 volumio kernel: Bluetooth: HCIATH3K protocol initialized Sep 28 22:09:30 volumio kernel: Bluetooth: HCI Three-wire UART (H5) protocol initialized Sep 28 22:09:30 volumio kernel: Bluetooth: Realtek h5 driver version 1.0.1 Sep 28 22:09:30 volumio kernel: Realtek h5 driver version 1.0.1 Sep 28 22:09:30 volumio kernel: Bluetooth: HCI Realtek H5 protocol registration failed Sep 28 22:09:30 volumio kernel: HCI Realtek H5 protocol registration failed Sep 28 22:09:30 volumio kernel: rtk_btusb: Realtek Bluetooth USB driver module init, version 2.21 Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver rtk_btusb Sep 28 22:09:30 volumio kernel: cpuidle: using governor ladder Sep 28 22:09:30 volumio kernel: cpuidle: using governor menu Sep 28 22:09:30 volumio kernel: ## host_id: 0 boot_dev 22 host->index: 1 Sep 28 22:09:30 volumio kernel: gl520x_mmc b0230000.mmc: using dma0chan2 for DMA transfers Sep 28 22:09:30 volumio kernel: use GPIO to detect SD/MMC card Sep 28 22:09:30 volumio kernel: host0: sure rescan mmc Sep 28 22:09:30 volumio kernel: ## host_id: 2 boot_dev 22 host->index: 0 Sep 28 22:09:30 volumio kernel: gl520x_mmc b0238000.mmc: using dma0chan3 for DMA transfers Sep 28 22:09:30 volumio kernel: hidraw: raw HID events driver (C) Jiri Kosina Sep 28 22:09:30 volumio kernel: usbcore: registered new interface driver usbhid Sep 28 22:09:30 volumio kernel: usbhid: USB HID core driver Sep 28 22:09:30 volumio kernel: zram: Created 1 device(s) ... Sep 28 22:09:30 volumio kernel: ashmem: initialized Sep 28 22:09:30 volumio kernel: logger: created 256K log 'log_main' Sep 28 22:09:30 volumio kernel: logger: created 256K log 'log_events' Sep 28 22:09:30 volumio kernel: logger: created 256K log 'log_radio' Sep 28 22:09:30 volumio kernel: logger: created 256K log 'log_system' Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: pcm512x 2-004c: Failed to reset device: -6 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: pcm512x 2-004d: Failed to reset device: -6 Sep 28 22:09:30 volumio kernel: [SNDRV]:[atm7059_pcm_init] atm7059_pcm_init!! Sep 28 22:09:30 volumio kernel: atm7059-pcm-audio atm7059-pcm-audio: atm7059_pcm_probe!! Sep 28 22:09:30 volumio kernel: atc2603a_init Sep 28 22:09:30 volumio kernel: [52B blob data] Sep 28 22:09:30 volumio kernel: [47B blob data] Sep 28 22:09:30 volumio kernel: atc2603c_init Sep 28 22:09:30 volumio kernel: [52B blob data] Sep 28 22:09:30 volumio kernel: [59B blob data] Sep 28 22:09:30 volumio kernel: [SNDRV]:[atc2603c_platform_probe] what's my lucky draw 220 Sep 28 22:09:30 volumio kernel: [SNDRV]:[atm7059_dai_probe] it's ok 0 Sep 28 22:09:30 volumio kernel: owl-audio-i2s b0100000.gl5203-audio-i2s: atm7059_dai_probe Sep 28 22:09:30 volumio kernel: atm7059-hdmi-audio atm7059-hdmi-audio: atm7059_hdmi_probe!! Sep 28 22:09:30 volumio kernel: atm7059_spdif_probe 225 Sep 28 22:09:30 volumio kernel: [SNDRV]:[atm7059_link_init] atm7059_link_init Sep 28 22:09:30 volumio kernel: [SNDRV]:[atm7059_audio_gpio_init] find i2s_switch_gpio property fail Sep 28 22:09:30 volumio kernel: [SNDRV]:[atm7059_audio_gpio_init] find earphone_detect_gpios property fail Sep 28 22:09:30 volumio kernel: [60B blob data] Sep 28 22:09:30 volumio kernel: [SNDRV]:[atm7059_link_init] maybe using irq Sep 28 22:09:30 volumio kernel: soc-audio soc-audio: ASoC: machine atm7059_link should use snd_soc_register_card() Sep 28 22:09:30 volumio kernel: [SNDRV]:[atc2603c_probe] atc2603c_probe! Sep 28 22:09:30 volumio kernel: [54B blob data] Sep 28 22:09:30 volumio kernel: host2,platfrom request already Sep 28 22:09:30 volumio kernel: atc2603c-audio atc260x-audio: ASoC: no dapm match for AOUT FL FR Mixer --> AOUT MIXER --> ADC0 Mux Sep 28 22:09:30 volumio kernel: atc2603c-audio atc260x-audio: ASoC: Failed to add route AOUT FL FR Mixer -> AOUT MIXER -> ADC0 Mux Sep 28 22:09:30 volumio kernel: [SNDRV]:[codec_hdmi_probe] codec_hdmi_probe! Sep 28 22:09:30 volumio kernel: [SNDRV]:[atm7059_link_snd_init] atm7059_link_init() called Sep 28 22:09:30 volumio kernel: soc-audio soc-audio: atc2603c-dai <-> owl-audio-i2s mapping ok Sep 28 22:09:30 volumio kernel: [SNDRV]:[atm7059_link_snd_init] atm7059_link_init() called Sep 28 22:09:30 volumio kernel: soc-audio soc-audio: atm7059-hdmi-dai <-> owl-audio-i2s mapping ok Sep 28 22:09:30 volumio kernel: [SNDRV]:[atm7059_link_snd_init] atm7059_link_init() called Sep 28 22:09:30 volumio kernel: soc-audio soc-audio: atm7059-spdif-dai <-> owl-audio-i2s mapping ok Sep 28 22:09:30 volumio kernel: u32 classifier Sep 28 22:09:30 volumio kernel: Actions configured Sep 28 22:09:30 volumio kernel: Netfilter messages via NETLINK v0.30. Sep 28 22:09:30 volumio kernel: nf_conntrack version 0.5.0 (15822 buckets, 63288 max) Sep 28 22:09:30 volumio kernel: ctnetlink v0.93: registering with nfnetlink. Sep 28 22:09:30 volumio kernel: NF_TPROXY: Transparent proxy support initialized, version 4.1.0 Sep 28 22:09:30 volumio kernel: NF_TPROXY: Copyright (c) 2006-2007 BalaBit IT Ltd. Sep 28 22:09:30 volumio kernel: xt_time: kernel timezone is -0000 Sep 28 22:09:30 volumio kernel: ip_tables: (C) 2000-2006 Netfilter Core Team Sep 28 22:09:30 volumio kernel: ipt_CLUSTERIP: ClusterIP Version 0.8 loaded successfully Sep 28 22:09:30 volumio kernel: arp_tables: (C) 2002 David S. Miller Sep 28 22:09:30 volumio kernel: TCP: cubic registered Sep 28 22:09:30 volumio kernel: Initializing XFRM netlink socket Sep 28 22:09:30 volumio kernel: NET: Registered protocol family 10 Sep 28 22:09:30 volumio kernel: mip6: Mobile IPv6 Sep 28 22:09:30 volumio kernel: ip6_tables: (C) 2000-2006 Netfilter Core Team Sep 28 22:09:30 volumio kernel: NET: Registered protocol family 17 Sep 28 22:09:30 volumio kernel: NET: Registered protocol family 15 Sep 28 22:09:30 volumio kernel: Bluetooth: RFCOMM TTY layer initialized Sep 28 22:09:30 volumio kernel: Bluetooth: RFCOMM socket layer initialized Sep 28 22:09:30 volumio kernel: Bluetooth: RFCOMM ver 1.11 Sep 28 22:09:30 volumio kernel: Bluetooth: HIDP (Human Interface Emulation) ver 1.2 Sep 28 22:09:30 volumio kernel: Bluetooth: HIDP socket layer initialized Sep 28 22:09:30 volumio kernel: l2tp_core: L2TP core driver, V2.0 Sep 28 22:09:30 volumio kernel: l2tp_ppp: PPPoL2TP kernel driver, V2.0 Sep 28 22:09:30 volumio kernel: lib80211: common routines for IEEE802.11 drivers Sep 28 22:09:30 volumio kernel: lib80211_crypt: registered algorithm 'NULL' Sep 28 22:09:30 volumio kernel: lib80211_crypt: registered algorithm 'WEP' Sep 28 22:09:30 volumio kernel: lib80211_crypt: registered algorithm 'CCMP' Sep 28 22:09:30 volumio kernel: lib80211_crypt: registered algorithm 'TKIP' Sep 28 22:09:30 volumio kernel: Key type dns_resolver registered Sep 28 22:09:30 volumio kernel: VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4 Sep 28 22:09:30 volumio kernel: ThumbEE CPU extension supported. Sep 28 22:09:30 volumio kernel: [PM] owl_pm_init() 1035 Sep 28 22:09:30 volumio kernel: train_Msize:1024, train_ces:1 Sep 28 22:09:30 volumio kernel: start:0xc0008000, end:0xc0c15ae4, checksum:0xe4551983 Sep 28 22:09:30 volumio kernel: fbdev info : xres 1280 yres 800 refresh 61 name dsi Sep 28 22:09:30 volumio kernel: fb_infos allocated Sep 28 22:09:30 volumio kernel: mmc0: BKOPS_EN bit is not set Sep 28 22:09:30 volumio kernel: mmc_init_card:ok Sep 28 22:09:30 volumio kernel: emmc init ok Sep 28 22:09:30 volumio kernel: mmc_add_card: bootdev 0x22 Sep 28 22:09:30 volumio kernel: force sd2(emmc) host emmc_boot_card Sep 28 22:09:30 volumio kernel: mmc0: new high speed DDR MMC card at address 0001 Sep 28 22:09:30 volumio kernel: ## md->name_idx: 0 Sep 28 22:09:30 volumio kernel: mmcblk0: emmc_boot_card Biwin 14.4 GiB Sep 28 22:09:30 volumio kernel: mmcblk0: p1 p2 p3 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_read_edid Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: ENTER owldss_hdmi_display_get_cable_status 0 Sep 28 22:09:30 volumio kernel: owldss_hdmi_read_edid ~~~ error hdmi not connected Sep 28 22:09:30 volumio kernel: set_par(0) Sep 28 22:09:30 volumio kernel: Console: switching to colour frame buffer device 160x50 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_over_scan Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_over_scan Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_cable_status Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: ENTER owldss_hdmi_display_get_cable_status 0 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_over_scan Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_cable_status Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: ENTER owldss_hdmi_display_get_cable_status 0 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_over_scan Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_cable_status Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: ENTER owldss_hdmi_display_get_cable_status 0 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_over_scan Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_cable_status Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: ENTER owldss_hdmi_display_get_cable_status 0 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_over_scan Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_cable_status Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: ENTER owldss_hdmi_display_get_cable_status 0 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_over_scan Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_cable_status Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: ENTER owldss_hdmi_display_get_cable_status 0 Sep 28 22:09:30 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_over_scan Sep 28 22:09:30 volumio kernel: np c16bc4f0 Sep 28 22:09:30 volumio kernel: boot_hdmi_rotate 0 Sep 28 22:09:30 volumio kernel: of_property_read_u32 is error Sep 28 22:09:30 volumio kernel: of_property_read bootrotate is error Sep 28 22:09:30 volumio kernel: boot_cvbs_enable 0 Sep 28 22:09:30 volumio kernel: boot_hdmi_rotate 0 boot_cvbs_rotate=0 Sep 28 22:09:30 volumio kernel: regulator-dummy: disabling Sep 28 22:09:30 volumio kernel: atc260x-rtc atc2603c-rtc.0: setting system clock to 2018-09-28 22:07:53 UTC (1538172473) Sep 28 22:09:30 volumio kernel: ATC260X_POWER: create sysfs for atc260x power Sep 28 22:09:30 volumio kernel: charger=e1c8c118 2705 Sep 28 22:09:30 volumio kernel: set_vbus_path=c04d4328 set_apds_vbus_pd=c04d43fc Sep 28 22:09:30 volumio kernel: clk: Not disabling unused clocks Sep 28 22:09:30 volumio kernel: ====otgvbus_gpio: num-78, active-high---detect_type=3,idpin_type=0,vbus_type=2--- Sep 28 22:09:30 volumio kernel: ALSA device list: Sep 28 22:09:30 volumio kernel: #0: atm7059_link Sep 28 22:09:30 volumio kernel: Freeing unused kernel memory: 472K (c0c16000 - c0c8c000) Sep 28 22:09:30 volumio initramfs: Booting Volumio for gs705a Sep 28 22:09:30 volumio initramfs: This script mounts rootfs RO with an overlay RW layer. Sep 28 22:09:30 volumio kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 28 22:09:30 volumio initramfs: IMGPART=/dev/mmcblk0p2 Sep 28 22:09:30 volumio initramfs: IMGFILE=/volumio_current.sqsh Sep 28 22:09:30 volumio initramfs: /dev/mmcblk0p2: Sep 28 22:09:30 volumio kernel: EXT4-fs (mmcblk0p2): recovery complete Sep 28 22:09:30 volumio kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Sep 28 22:09:30 volumio initramfs: Checking for USB updates Sep 28 22:09:30 volumio kernel: [power] No battery detected Sep 28 22:09:30 volumio initramfs: No USB device detected (when incorrect, try adding 'bootdelay=5' to your boot cmdline) Sep 28 22:09:30 volumio kernel: sndrv: speaker off Sep 28 22:09:30 volumio kernel: [atc260x_usb_get_prop] first_power_on = false! Sep 28 22:09:30 volumio kernel: ========usb_detect_plugout_event===start det!!======== Sep 28 22:09:30 volumio kernel: drivers/usb/monitor/umonitor_core.c--497, SYS_MSG_USB_B_OUT Sep 28 22:09:30 volumio kernel: ----udc_set_plugstate--PLUGSTATE_OUT-- Sep 28 22:09:30 volumio kernel: [PowerGate] name: 'usb3', on: 0, before SPS_PG_CTL: 0x717761 Sep 28 22:09:30 volumio kernel: [PowerGate] name: 'usb3', on: 0, after SPS_PG_CTL: 0x717361 Sep 28 22:09:30 volumio kernel: ------------dwc3_clk_exit---------- Sep 28 22:09:30 volumio kernel: ++++++++cpufreq ready++++++++ Sep 28 22:09:30 volumio kernel: ++++++++pdata->freq_tab[0].freq_clip_max:504000++++++++ Sep 28 22:09:30 volumio kernel: ++++++++pdata->freq_tab[1].freq_clip_max:504000++++++++ Sep 28 22:09:30 volumio kernel: ------------[ cut here ]------------ Sep 28 22:09:30 volumio kernel: WARNING: at drivers/gpio/gpiolib.c:160 gpio_ensure_requested+0x64/0xb4() Sep 28 22:09:30 volumio kernel: autorequest GPIO-114 Sep 28 22:09:30 volumio kernel: Modules linked in: nls_cp437 squashfs overlayfs Sep 28 22:09:30 volumio kernel: CPU: 0 PID: 4 Comm: kworker/0:0 Not tainted 3.10.38 #4 Sep 28 22:09:30 volumio kernel: Workqueue: events wait_cpufreq_ready Sep 28 22:09:30 volumio kernel: [] (unwind_backtrace+0x0/0x134) from [] (show_stack+0x24/0x34) Sep 28 22:09:30 volumio kernel: [] (show_stack+0x24/0x34) from [] (warn_slowpath_common+0x54/0x6c) Sep 28 22:09:30 volumio kernel: [] (warn_slowpath_common+0x54/0x6c) from [] (warn_slowpath_fmt+0x30/0x40) Sep 28 22:09:30 volumio kernel: [] (warn_slowpath_fmt+0x30/0x40) from [] (gpio_ensure_requested+0x64/0xb4) Sep 28 22:09:30 volumio kernel: [] (gpio_ensure_requested+0x64/0xb4) from [] (gpiod_direction_output+0x68/0x304) Sep 28 22:09:30 volumio kernel: [] (gpiod_direction_output+0x68/0x304) from [] (owl_tmu_read+0x160/0x1b8) Sep 28 22:09:30 volumio kernel: [] (owl_tmu_read+0x160/0x1b8) from [] (owl_get_temp+0x2c/0x58) Sep 28 22:09:30 volumio kernel: [] (owl_get_temp+0x2c/0x58) from [] (thermal_zone_get_temp+0x54/0x108) Sep 28 22:09:30 volumio kernel: [] (thermal_zone_get_temp+0x54/0x108) from [] (thermal_zone_device_update+0x24/0xd4) Sep 28 22:09:30 volumio kernel: [] (thermal_zone_device_update+0x24/0xd4) from [] (thermal_zone_device_register+0x6c8/0x7d0) Sep 28 22:09:30 volumio kernel: [] (thermal_zone_device_register+0x6c8/0x7d0) from [] (wait_cpufreq_ready+0x114/0x1c8) Sep 28 22:09:30 volumio kernel: [] (wait_cpufreq_ready+0x114/0x1c8) from [] (process_one_work+0x134/0x44c) Sep 28 22:09:30 volumio kernel: [] (process_one_work+0x134/0x44c) from [] (worker_thread+0x138/0x3d4) Sep 28 22:09:30 volumio kernel: [] (worker_thread+0x138/0x3d4) from [] (kthread+0xb4/0xb8) Sep 28 22:09:30 volumio kernel: [] (kthread+0xb4/0xb8) from [] (ret_from_fork+0x14/0x3c) Sep 28 22:09:30 volumio kernel: ---[ end trace f0868dbfc660adfc ]--- Sep 28 22:09:30 volumio kernel: OWL: Kernel Thermal management registered Sep 28 22:09:30 volumio kernel: EXT4-fs (mmcblk0p3): recovery complete Sep 28 22:09:30 volumio kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Sep 28 22:09:30 volumio initramfs: Without Option: Sep 28 22:09:30 volumio initramfs: VOLUMIO_VERSION="2.459" Sep 28 22:09:30 volumio initramfs: Finish initramfs, continue booting Volumio Sep 28 22:09:30 volumio systemd[1]: systemd 215 running in system mode. (+PAM +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ -SECCOMP -APPARMOR) Sep 28 22:09:30 volumio systemd[1]: Detected architecture 'arm'. Sep 28 22:09:30 volumio kernel: drivers/usb/monitor/umonitor_core.c--746, SYS_MSG_USB_A_IN Sep 28 22:09:30 volumio kernel: drivers/usb/monitor/umonitor_api.c--1212, wake_lock !!! Sep 28 22:09:30 volumio kernel: ----udc_set_plugstate--PLUGSTATE_IN-2-- Sep 28 22:09:30 volumio kernel: ------------dwc3_clk_init-----ic=1----- Sep 28 22:09:30 volumio kernel: [PowerGate] name: 'usb3', on: 1, before SPS_PG_CTL: 0x713361 Sep 28 22:09:30 volumio kernel: [PowerGate] name: 'usb3', on: 1, after SPS_PG_CTL: 0x717761 Sep 28 22:09:30 volumio systemd[1]: Inserted module 'autofs4' Sep 28 22:09:30 volumio systemd[1]: Set hostname to . Sep 28 22:09:30 volumio kernel: open ttyS3 Sep 28 22:09:30 volumio kernel: GS705A phy init for dwc3 gadget 11:51:14 Sep 28 22:09:30 volumio kernel: GS705A phy init for dwc3 gadget 11:51:14 Sep 28 22:09:30 volumio kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Sep 28 22:09:30 volumio kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1 Sep 28 22:09:30 volumio kernel: GS705A phy init for xhci 11:51:14 Sep 28 22:09:30 volumio kernel: xhci-hcd xhci-hcd.0.auto: irq 55, io mem 0xb0400000 Sep 28 22:09:30 volumio kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Sep 28 22:09:30 volumio kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Sep 28 22:09:30 volumio kernel: usb usb1: Product: xHCI Host Controller Sep 28 22:09:30 volumio kernel: usb usb1: Manufacturer: Linux 3.10.38 xhci-hcd Sep 28 22:09:30 volumio kernel: usb usb1: SerialNumber: xhci-hcd.0.auto Sep 28 22:09:30 volumio kernel: hub 1-0:1.0: USB hub found Sep 28 22:09:30 volumio kernel: hub 1-0:1.0: 1 port detected Sep 28 22:09:30 volumio kernel: xhci-hcd xhci-hcd.0.auto: xHCI Host Controller Sep 28 22:09:30 volumio kernel: xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2 Sep 28 22:09:30 volumio kernel: #xhci_start# Sep 28 22:09:30 volumio kernel: ss_try_next_mode:lfps_src_mode=1 Sep 28 22:09:30 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Sep 28 22:09:30 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Sep 28 22:09:30 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Sep 28 22:09:30 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Sep 28 22:09:30 volumio systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory. Sep 28 22:09:30 volumio systemd[1]: Starting Forward Password Requests to Wall Directory Watch. Sep 28 22:09:30 volumio systemd[1]: Started Forward Password Requests to Wall Directory Watch. Sep 28 22:09:30 volumio systemd[1]: Expecting device dev-ttyS3.device... Sep 28 22:09:30 volumio systemd[1]: Starting Remote File Systems (Pre). Sep 28 22:09:30 volumio systemd[1]: Reached target Remote File Systems (Pre). Sep 28 22:09:30 volumio systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Sep 28 22:09:30 volumio systemd[1]: Starting Encrypted Volumes. Sep 28 22:09:30 volumio systemd[1]: Reached target Encrypted Volumes. Sep 28 22:09:30 volumio systemd[1]: Expecting device dev-mmcblk0p1.device... Sep 28 22:09:30 volumio systemd[1]: Starting Root Slice. Sep 28 22:09:30 volumio systemd[1]: Created slice Root Slice. Sep 28 22:09:30 volumio systemd[1]: Starting User and Session Slice. Sep 28 22:09:30 volumio systemd[1]: Created slice User and Session Slice. Sep 28 22:09:30 volumio systemd[1]: Starting /dev/initctl Compatibility Named Pipe. Sep 28 22:09:30 volumio systemd[1]: Listening on /dev/initctl Compatibility Named Pipe. Sep 28 22:09:30 volumio systemd[1]: Starting Delayed Shutdown Socket. Sep 28 22:09:30 volumio systemd[1]: Listening on Delayed Shutdown Socket. Sep 28 22:09:30 volumio systemd[1]: Starting Journal Socket (/dev/log). Sep 28 22:09:30 volumio systemd[1]: Listening on Journal Socket (/dev/log). Sep 28 22:09:30 volumio systemd[1]: Starting udev Control Socket. Sep 28 22:09:30 volumio systemd[1]: Listening on udev Control Socket. Sep 28 22:09:30 volumio systemd[1]: Starting udev Kernel Socket. Sep 28 22:09:30 volumio systemd[1]: Listening on udev Kernel Socket. Sep 28 22:09:30 volumio systemd[1]: Starting Journal Socket. Sep 28 22:09:30 volumio systemd[1]: Listening on Journal Socket. Sep 28 22:09:30 volumio systemd[1]: Starting System Slice. Sep 28 22:09:30 volumio systemd[1]: Created slice System Slice. Sep 28 22:09:30 volumio systemd[1]: Starting system-systemd\x2dfsck.slice. Sep 28 22:09:30 volumio systemd[1]: Created slice system-systemd\x2dfsck.slice. Sep 28 22:09:30 volumio systemd[1]: Starting dynamicswap service... Sep 28 22:09:30 volumio systemd[1]: Started dynamicswap service. Sep 28 22:09:30 volumio systemd[1]: Starting Swap. Sep 28 22:09:30 volumio systemd[1]: Reached target Swap. Sep 28 22:09:30 volumio systemd[1]: Starting system-getty.slice. Sep 28 22:09:30 volumio systemd[1]: Created slice system-getty.slice. Sep 28 22:09:30 volumio systemd[1]: Starting system-serial\x2dgetty.slice. Sep 28 22:09:30 volumio systemd[1]: Created slice system-serial\x2dgetty.slice. Sep 28 22:09:30 volumio systemd[1]: Starting Restore / save the current clock... Sep 28 22:09:30 volumio systemd[1]: Mounted Huge Pages File System. Sep 28 22:09:30 volumio systemd[1]: Mounting POSIX Message Queue File System... Sep 28 22:09:30 volumio systemd[1]: Starting Create list of required static device nodes for the current kernel... Sep 28 22:09:30 volumio systemd[1]: Mounting Debug File System... Sep 28 22:09:30 volumio systemd[1]: Started Set Up Additional Binary Formats. Sep 28 22:09:30 volumio systemd[1]: Starting Load Kernel Modules... Sep 28 22:09:30 volumio systemd[1]: Starting udev Coldplug all Devices... Sep 28 22:09:30 volumio systemd[1]: Starting Journal Service... Sep 28 22:09:30 volumio systemd[1]: Started Journal Service. Sep 28 22:09:30 volumio kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0003 Sep 28 22:09:30 volumio kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Sep 28 22:09:30 volumio kernel: usb usb2: Product: xHCI Host Controller Sep 28 22:09:30 volumio kernel: usb usb2: Manufacturer: Linux 3.10.38 xhci-hcd Sep 28 22:09:30 volumio kernel: usb usb2: SerialNumber: xhci-hcd.0.auto Sep 28 22:09:30 volumio kernel: hub 2-0:1.0: USB hub found Sep 28 22:09:30 volumio kernel: hub 2-0:1.0: 1 port detected Sep 28 22:09:30 volumio kernel: ----monitor_wake_lock for 10s Sep 28 22:09:30 volumio kernel: read_mi_head, line 429, magic 0x0, length 0, item num 0 Sep 28 22:09:30 volumio kernel: read Head null Sep 28 22:09:30 volumio kernel: OWL_HDMI_ERR: failed to read hdcp key from secure storage Sep 28 22:09:30 volumio systemd-journal[202]: Journal started Sep 28 22:09:30 volumio systemd[1]: Starting Slices. Sep 28 22:09:30 volumio systemd[1]: Reached target Slices. Sep 28 22:09:30 volumio systemd[1]: Starting Remount Root and Kernel File Systems... Sep 28 22:09:30 volumio systemd[1]: Mounted Debug File System. Sep 28 22:09:30 volumio systemd[1]: Mounted POSIX Message Queue File System. Sep 28 22:09:30 volumio systemd-modules-load[198]: Module 'fuse' is builtin Sep 28 22:09:30 volumio systemd[1]: Started Restore / save the current clock. Sep 28 22:09:30 volumio systemd[1]: Started Create list of required static device nodes for the current kernel. Sep 28 22:09:30 volumio systemd[1]: Started Load Kernel Modules. Sep 28 22:09:30 volumio systemd[1]: Time has been changed Sep 28 22:09:30 volumio systemd[1]: Started Remount Root and Kernel File Systems. Sep 28 22:09:30 volumio systemd[1]: Started udev Coldplug all Devices. Sep 28 22:09:30 volumio systemd[1]: Started Load/Save Random Seed. Sep 28 22:09:30 volumio systemd[1]: Started Apply Kernel Variables. Sep 28 22:09:30 volumio systemd[1]: Started Create Static Device Nodes in /dev. Sep 28 22:09:30 volumio fake-hwclock[183]: Fri Sep 28 22:09:30 UTC 2018 Sep 28 22:09:30 volumio systemd[1]: Starting udev Kernel Device Manager... Sep 28 22:09:30 volumio systemd[1]: Starting Local File Systems (Pre). Sep 28 22:09:30 volumio systemd[1]: Reached target Local File Systems (Pre). Sep 28 22:09:30 volumio systemd[1]: Mounting /tmp... Sep 28 22:09:30 volumio systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Sep 28 22:09:30 volumio systemd[1]: Mounting /var/spool/cups... Sep 28 22:09:30 volumio systemd[1]: Mounting /var/log... Sep 28 22:09:30 volumio systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Sep 28 22:09:30 volumio systemd-udevd[225]: starting version 215 Sep 28 22:09:30 volumio systemd[1]: Mounted /var/spool/cups. Sep 28 22:09:30 volumio systemd[1]: Mounted /tmp. Sep 28 22:09:30 volumio systemd[1]: Started udev Kernel Device Manager. Sep 28 22:09:30 volumio systemd[1]: Mounted /var/log. Sep 28 22:09:30 volumio systemd[1]: Started Show Plymouth Boot Screen. Sep 28 22:09:30 volumio systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Sep 28 22:09:30 volumio systemd[1]: Starting Dispatch Password Requests to Console Directory Watch. Sep 28 22:09:30 volumio systemd[1]: Started Dispatch Password Requests to Console Directory Watch. Sep 28 22:09:30 volumio systemd[1]: Starting Paths. Sep 28 22:09:30 volumio systemd[1]: Reached target Paths. Sep 28 22:09:30 volumio systemd[1]: Starting Copy rules generated while the root was ro... Sep 28 22:09:30 volumio systemd[1]: Mounting /var/spool/cups/tmp... Sep 28 22:09:30 volumio systemd[1]: Started Copy rules generated while the root was ro. Sep 28 22:09:30 volumio systemd[1]: Mounted /var/spool/cups/tmp. Sep 28 22:09:30 volumio systemd[1]: Found device /dev/ttyS3. Sep 28 22:09:30 volumio kernel: [atc260x_irkeypad_probe start] Sep 28 22:09:30 volumio kernel: atc260x-irkeypad atc2603c-irkeypad.0: size = 28 Sep 28 22:09:30 volumio kernel: [66B blob data] Sep 28 22:09:30 volumio kernel: atc260x_irkeypad: ir_ch = 0 Sep 28 22:09:30 volumio kernel: atc260x-irkeypad atc2603c-irkeypad.0: user_code = 60976 Sep 28 22:09:30 volumio kernel: atc260x-irkeypad atc2603c-irkeypad.0: protocol = 1 Sep 28 22:09:30 volumio kernel: atc260x-irkeypad atc2603c-irkeypad.0: wk_code = 77 Sep 28 22:09:30 volumio kernel: atc260x-irkeypad atc2603c-irkeypad.0: period = 140 Sep 28 22:09:30 volumio kernel: gl5201_irkeypad_drv: [atc260x_irkeypad_probe] get irq: 219 Sep 28 22:09:30 volumio kernel: input: atc2603c-irkeypad as /devices/b0170000.i2c/i2c-0/0-0065/atc2603c-irkeypad.0/input/input1 Sep 28 22:09:30 volumio kernel: gl5201_irkeypad_drv: [asoc_irkeypad_open start] Sep 28 22:09:30 volumio kernel: gl5201_irkeypad_drv: [asoc_irkeypad_start start] Sep 28 22:09:30 volumio kernel: gl5201_irkeypad_drv: [asoc_irkeypad_config start] Sep 28 22:09:30 volumio kernel: gl5201_irkeypad_drv: [asoc_irkeypad_config finished] Sep 28 22:09:30 volumio kernel: gl5201_irkeypad_drv: [asoc_irkeypad_start finished] Sep 28 22:09:30 volumio kernel: gl5201_irkeypad_drv: [asoc_irkeypad_open finished] Sep 28 22:09:30 volumio kernel: [atc260x_irkeypad_probe finished] Sep 28 22:09:30 volumio kernel: ATC260X_GAUGE: ========This is a new reconstructed gauge by actions========== Sep 28 22:09:30 volumio kernel: ATC260X_GAUGE: [atc260x_gauge_init] drv name:atc260x_cap_gauge, drv version:Actions-v1-20150720151405 Sep 28 22:09:30 volumio kernel: ATC260X_GAUGE: [gauge_create_sysfs] create sysfs for gauge Sep 28 22:09:30 volumio kernel: ATC260X_GAUGE: [get_pmu_ic_type]pmu type is 1 Sep 28 22:09:30 volumio kernel: ATC260X_GAUGE: [init_gauge] PMU current ratio:3 Sep 28 22:09:30 volumio kernel: ATC260X_GAUGE: [init_gauge] first_product:0 Sep 28 22:09:30 volumio kernel: ATC260X_GAUGE: [resistor_init] inited ch_resistor : 150, inited disch_resistor:250 Sep 28 22:09:30 volumio kernel: gpio num:35, reset level:0, i2c_addr:38, irq_number:213,x_pixel:1280, y_pixel:800, max_point:5, rotate:180, i2cNum:1 Sep 28 22:09:30 volumio kernel: ft5x06_hw_init 1077 Sep 28 22:09:30 volumio kernel: bma222_probe,1765, addr:0x18 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: bma222 not found! I2c error 250 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: actions,atm7059 Sep 28 22:09:30 volumio kernel: SI paddr is f8270000res->start is : 0xb0160020,resource size is 0x4 Sep 28 22:09:30 volumio kernel: [owl_camera] (ERR) line:1935--gpio_init() no config gpios Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: [MIR3DA] Do softreset failed ! Sep 28 22:09:30 volumio kernel: [MIR3DA] chip resume fail!! Sep 28 22:09:30 volumio kernel: [MIR3DA] chip init failed ! Sep 28 22:09:30 volumio kernel: mir3da: probe of 2-0027 failed with error -1 Sep 28 22:09:30 volumio kernel: stk831x_probe: driver version:1.6.1 2013/05/24 Sep 28 22:09:30 volumio kernel: [STK831x][stk831x_probe][LINE:2239]Use Polling_mode Sep 28 22:09:30 volumio kernel: [68B blob data] Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: asoc_ethernet_init 3786 Sep 28 22:09:30 volumio kernel: found sparky chip 100e4639ca06500d provisioned Sep 28 22:09:30 volumio kernel: idx 2436 newmac 17f7010985 Sep 28 22:09:30 volumio kernel: phy_mode_str: rmii Sep 28 22:09:30 volumio kernel: phy_mode: 0 Sep 28 22:09:30 volumio kernel: target freq: 50000000 Sep 28 22:09:30 volumio kernel: pdev->name: b0310000.ethernet Sep 28 22:09:30 volumio kernel: phy_mode: 0 Sep 28 22:09:30 volumio kernel: gpio phy-power-gpios num 85 active 0 Sep 28 22:09:30 volumio kernel: gpio phy-reset-gpios num 127 active 0 Sep 28 22:09:30 volumio kernel: ethernet phy name: sr8201g Sep 28 22:09:30 volumio kernel: ethernet phy's compatible: SR8201G,sr8201g Sep 28 22:09:30 volumio kernel: phy model is sr8201g Sep 28 22:09:30 volumio kernel: phy_model: 4 Sep 28 22:09:30 volumio kernel: res->start: b0310000, ecp->hwrp: f8310000 Sep 28 22:09:30 volumio kernel: phy model: SR8201G Sep 28 22:09:30 volumio kernel: ETHERNET_BASE: 0xb0310000 Sep 28 22:09:30 volumio kernel: ecp->hwrp: 0xf8310000 Sep 28 22:09:30 volumio systemd[1]: Starting system-systemd\x2dbacklight.slice. Sep 28 22:09:30 volumio kernel: ecp->tx_bd_base:e5b30000, ecp->tx_bd_paddr:25b30000 Sep 28 22:09:30 volumio kernel: ecp->rx_bd_base:e5b31000, ecp->rx_bd_paddr:25b31000 Sep 28 22:09:30 volumio kernel: virt_to_phys(ecp->tx_bd_base):25b30000 Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio systemd[1]: Created slice system-systemd\x2dbacklight.slice. Sep 28 22:09:30 volumio systemd[1]: Starting Load/Save Screen Backlight Brightness of backlight:backlight.2... Sep 28 22:09:30 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c2] no ACK, fifostat 0x20013 Sep 28 22:09:30 volumio kernel: [drm] Initialized drm 1.1.0 20060810 Sep 28 22:09:30 volumio kernel: [31B blob data] Sep 28 22:09:30 volumio kernel: ethernet eth0 probe finish Sep 28 22:09:30 volumio kernel: STK_i2c_Tx: retry over 3 Sep 28 22:09:30 volumio kernel: STK831X_Init:failed Sep 28 22:09:30 volumio kernel: [80B blob data] Sep 28 22:09:30 volumio kernel: stk831x: probe of 2-0022 failed with error -5 Sep 28 22:09:30 volumio systemd[1]: Starting Sound Card. Sep 28 22:09:30 volumio systemd[1]: Reached target Sound Card. Sep 28 22:09:30 volumio systemd[1]: Started Load/Save Screen Backlight Brightness of backlight:backlight.2. Sep 28 22:09:31 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x20013 Sep 28 22:09:31 volumio kernel: [FT5X06-WARN]I2C read failed Sep 28 22:09:31 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x20013 Sep 28 22:09:31 volumio kernel: [FT5X06-WARN]I2C read failed Sep 28 22:09:31 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x20013 Sep 28 22:09:31 volumio kernel: [FT5X06-WARN]I2C read failed Sep 28 22:09:31 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x20013 Sep 28 22:09:31 volumio kernel: [FT5X06-WARN]I2C write failed Sep 28 22:09:31 volumio kernel: [FT5X06-WARN]read config failed Sep 28 22:09:31 volumio kernel: ft5x06: probe of 1-0038 failed with error -11 Sep 28 22:09:31 volumio kernel: i2c-core: driver [ft5x06] using legacy suspend method Sep 28 22:09:31 volumio kernel: i2c-core: driver [ft5x06] using legacy resume method Sep 28 22:09:31 volumio kernel: touch_ft5x06_init 2184 Sep 28 22:09:31 volumio kernel: mode: [0-->2] ! Sep 28 22:09:31 volumio kernel: cputherm_register_notifier list 0 Sep 28 22:09:31 volumio kernel: GPU Init success! Sep 28 22:09:31 volumio kernel: In normal mode 2 Sep 28 22:09:31 volumio kernel: omaplfb OMAPLFBInitFBDev: Device 1: Couldn't open framebuffer(-1) Sep 28 22:09:31 volumio kernel: [drm] Initialized pvrsrvkm 1.14.3625561 20110701 on minor 0 Sep 28 22:09:31 volumio systemd[1]: Found device /dev/mmcblk0p1. Sep 28 22:09:31 volumio systemd[1]: Starting File System Check on /dev/mmcblk0p1... Sep 28 22:09:31 volumio systemd[1]: Starting system-ifup.slice. Sep 28 22:09:31 volumio systemd[1]: Created slice system-ifup.slice. Sep 28 22:09:31 volumio systemd-fsck[290]: fsck.fat 3.0.27 (2014-11-12) Sep 28 22:09:31 volumio systemd-fsck[290]: /dev/mmcblk0p1: 7 files, 5060/30651 clusters Sep 28 22:09:31 volumio systemd[1]: Started File System Check on /dev/mmcblk0p1. Sep 28 22:09:31 volumio systemd[1]: Mounting /boot... Sep 28 22:09:31 volumio systemd[1]: Mounted /boot. Sep 28 22:09:31 volumio systemd[1]: Starting Local File Systems. Sep 28 22:09:31 volumio systemd[1]: Reached target Local File Systems. Sep 28 22:09:31 volumio systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Sep 28 22:09:31 volumio systemd[1]: Starting Remote File Systems. Sep 28 22:09:31 volumio systemd[1]: Reached target Remote File Systems. Sep 28 22:09:31 volumio systemd[1]: Starting Trigger Flushing of Journal to Persistent Storage... Sep 28 22:09:31 volumio systemd[1]: Starting Create Volatile Files and Directories... Sep 28 22:09:31 volumio systemd[1]: Starting LSB: Raise network interfaces.... Sep 28 22:09:31 volumio systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Sep 28 22:09:31 volumio systemd[1]: Started Create Volatile Files and Directories. Sep 28 22:09:31 volumio systemd[1]: Started Trigger Flushing of Journal to Persistent Storage. Sep 28 22:09:31 volumio systemd[1]: Starting Update UTMP about System Boot/Shutdown... Sep 28 22:09:31 volumio systemd[1]: Started Update UTMP about System Boot/Shutdown. Sep 28 22:09:31 volumio networking[302]: Configuring network interfaces...command failed: No such device (-19) Sep 28 22:09:31 volumio networking[302]: command failed: No such device (-19) Sep 28 22:09:31 volumio kernel: phy_reg_set_bits 339 write reg_val:0xb100 Sep 28 22:09:31 volumio kernel: phy_reg_set_bits 342 write after read reg_val:0x3100 Sep 28 22:09:31 volumio kernel: MII_ADVERTISE: 0x01e1 Sep 28 22:09:31 volumio kernel: phy_init 442 MII_BMCR: 0x3100 Sep 28 22:09:31 volumio kernel: phy_reg_set_bits 339 write reg_val:0x3300 Sep 28 22:09:31 volumio kernel: phy_reg_set_bits 342 write after read reg_val:0x3100 Sep 28 22:09:31 volumio kernel: start aneg... Sep 28 22:09:31 volumio kernel: phy_init 447 MII_BMCR: 0x3100 Sep 28 22:09:31 volumio kernel: link status is: false Sep 28 22:09:31 volumio kernel: eth0 link off. Sep 28 22:09:31 volumio kernel: IRQ 32 requested Sep 28 22:09:31 volumio kernel: ec_netdev_set_multicast_list 2741 Sep 28 22:09:31 volumio kernel: ec_netdev_set_multicast_list 2741 Sep 28 22:09:31 volumio kernel: ec_netdev_set_multicast_list 2741 Sep 28 22:09:31 volumio kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Sep 28 22:09:31 volumio networking[302]: done. Sep 28 22:09:31 volumio systemd[1]: Started LSB: Raise network interfaces.. Sep 28 22:09:32 volumio systemd[1]: Starting ifup for eth0... Sep 28 22:09:32 volumio systemd[1]: Started ifup for eth0. Sep 28 22:09:32 volumio systemd[1]: Starting Network. Sep 28 22:09:32 volumio systemd[1]: Reached target Network. Sep 28 22:09:32 volumio systemd[1]: Starting Network is Online. Sep 28 22:09:32 volumio systemd[1]: Reached target Network is Online. Sep 28 22:09:32 volumio systemd[1]: Starting LSB: RPC portmapper replacement... Sep 28 22:09:32 volumio ifup[390]: command failed: No such device (-19) Sep 28 22:09:32 volumio ifup[390]: dhcpcd[415]: version 6.0.5 starting Sep 28 22:09:32 volumio dhcpcd[415]: version 6.0.5 starting Sep 28 22:09:32 volumio dhcpcd[415]: eth0: waiting for carrier Sep 28 22:09:32 volumio ifup[390]: dhcpcd[415]: eth0: waiting for carrier Sep 28 22:09:32 volumio rpcbind[396]: Starting rpcbind daemon.... Sep 28 22:09:32 volumio systemd[1]: Started LSB: RPC portmapper replacement. Sep 28 22:09:32 volumio systemd[1]: Starting RPC Port Mapper. Sep 28 22:09:32 volumio systemd[1]: Reached target RPC Port Mapper. Sep 28 22:09:32 volumio systemd[1]: Starting LSB: NFS support files common to client and server... Sep 28 22:09:32 volumio rpc.statd[438]: Version 1.2.8 starting Sep 28 22:09:32 volumio sm-notify[439]: Version 1.2.8 starting Sep 28 22:09:32 volumio kernel: Installing knfsd (copyright (C) 1996 okir@monad.swb.de). Sep 28 22:09:32 volumio nfs-common[432]: Starting NFS common utilities: statd idmapd. Sep 28 22:09:32 volumio systemd[1]: Started LSB: NFS support files common to client and server. Sep 28 22:09:32 volumio systemd[1]: Starting System Initialization. Sep 28 22:09:32 volumio systemd[1]: Reached target System Initialization. Sep 28 22:09:32 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket. Sep 28 22:09:32 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Sep 28 22:09:32 volumio systemd[1]: Starting mpd.socket. Sep 28 22:09:32 volumio systemd[1]: Listening on mpd.socket. Sep 28 22:09:32 volumio systemd[1]: Starting D-Bus System Message Bus Socket. Sep 28 22:09:32 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Sep 28 22:09:32 volumio systemd[1]: Starting Sockets. Sep 28 22:09:32 volumio systemd[1]: Reached target Sockets. Sep 28 22:09:32 volumio systemd[1]: Starting Daily Cleanup of Temporary Directories. Sep 28 22:09:32 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Sep 28 22:09:32 volumio systemd[1]: Starting Timers. Sep 28 22:09:32 volumio systemd[1]: Reached target Timers. Sep 28 22:09:32 volumio systemd[1]: Started Manage Sound Card State (restore and store). Sep 28 22:09:32 volumio systemd[1]: Starting Restore Sound Card State... Sep 28 22:09:32 volumio systemd[1]: Starting Basic System. Sep 28 22:09:32 volumio systemd[1]: Reached target Basic System. Sep 28 22:09:32 volumio systemd[1]: Starting Entropy daemon using the HAVEGE algorithm... Sep 28 22:09:32 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Sep 28 22:09:32 volumio systemd[1]: Starting Volumio Iptables Module... Sep 28 22:09:32 volumio alsactl[451]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Dummy mic Gain:0' : Operation not permitted Sep 28 22:09:32 volumio alsactl[451]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Dummy earphone gain:0' : Operation not permitted Sep 28 22:09:32 volumio alsactl[451]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Dummy speaker gain:0' : Operation not permitted Sep 28 22:09:32 volumio alsactl[451]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Dummy speaker volume:0' : Operation not permitted Sep 28 22:09:32 volumio alsactl[451]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Dummy earphone volume:0' : Operation not permitted Sep 28 22:09:32 volumio alsactl[451]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Dummy mic num:0' : Operation not permitted Sep 28 22:09:32 volumio alsactl[451]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Dummy mic mode:0' : Operation not permitted Sep 28 22:09:32 volumio alsactl[451]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Dummy earphone detect method:0' : Operation not permitted Sep 28 22:09:32 volumio systemd[1]: Started Volumio Iptables Module. Sep 28 22:09:32 volumio systemd[1]: Starting mount disks automatically with standby... Sep 28 22:09:32 volumio systemd[1]: Started mount disks automatically with standby. Sep 28 22:09:32 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Sep 28 22:09:32 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 28 22:09:32 volumio systemd[1]: Starting volumio-remote-updater.service... Sep 28 22:09:32 volumio systemd[1]: Started volumio-remote-updater.service. Sep 28 22:09:32 volumio systemd[1]: Starting Volumio SSH enabler... Sep 28 22:09:32 volumio systemd[1]: Started Volumio SSH enabler. Sep 28 22:09:32 volumio systemd[1]: Starting Wireless Services... Sep 28 22:09:32 volumio systemd[1]: Starting /etc/rc.local Compatibility... Sep 28 22:09:32 volumio systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available. Sep 28 22:09:32 volumio systemd[1]: Starting Login Service... Sep 28 22:09:32 volumio systemd[1]: Starting LSB: start Winbind daemon... Sep 28 22:09:32 volumio systemd[1]: Starting LSB: start Samba daemons for the AD DC... Sep 28 22:09:32 volumio systemd[1]: Starting LSB: Start NTP daemon... Sep 28 22:09:32 volumio systemd[1]: Starting LSB: start Samba NetBIOS nameserver (nmbd)... Sep 28 22:09:32 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Sep 28 22:09:32 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Sep 28 22:09:32 volumio systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon... Sep 28 22:09:32 volumio systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support... Sep 28 22:09:33 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Sep 28 22:09:33 volumio systemd[1]: Starting Music Player Daemon... Sep 28 22:09:33 volumio systemd[1]: Starting D-Bus System Message Bus... Sep 28 22:09:33 volumio systemd[1]: Started D-Bus System Message Bus. Sep 28 22:09:33 volumio dhcpcd[480]: Not running dhcpcd because there is aleady an interface specific instance ... failed! Sep 28 22:09:33 volumio dhcpcd[480]: /var/run/dhcpcd-eth0.pid ... failed! Sep 28 22:09:33 volumio ifplugd(eth0)[519]: ifplugd 0.28 initializing. Sep 28 22:09:33 volumio ifplugd(eth0)[519]: Using interface eth0/00:17:F7:01:09:85 with driver (version: Version - 0.1) Sep 28 22:09:33 volumio ifplugd(eth0)[519]: Using detection mode: SIOCETHTOOL Sep 28 22:09:33 volumio ifplugd(eth0)[519]: Initialization complete, link beat not detected. Sep 28 22:09:33 volumio ifplugd[473]: Network Interface Plugging Daemon...start eth0...done. Sep 28 22:09:33 volumio loadcpufreq[470]: Loading cpufreq kernel modules...done (none). Sep 28 22:09:33 volumio avahi-daemon[486]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). Sep 28 22:09:33 volumio avahi-daemon[486]: Successfully dropped root privileges. Sep 28 22:09:33 volumio avahi-daemon[486]: avahi-daemon 0.6.31 starting up. Sep 28 22:09:33 volumio ntpd[526]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) Sep 28 22:09:33 volumio ntp[466]: Starting NTP server: ntpd. Sep 28 22:09:33 volumio sudo[471]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Sep 28 22:09:33 volumio ntpd[543]: proto: precision = 0.666 usec Sep 28 22:09:33 volumio ntpd[543]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Sep 28 22:09:33 volumio sudo[471]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:09:33 volumio dhcpcd[415]: eth0: carrier acquired Sep 28 22:09:33 volumio ifup[390]: dhcpcd[415]: eth0: carrier acquired Sep 28 22:09:33 volumio kernel: exit Sep 28 22:09:33 volumio kernel: ecp->autoneg:1 autoneg -> speed:100, duplex:full, pause: non-supported Sep 28 22:09:33 volumio kernel: set_mac_according_aneg Sep 28 22:09:33 volumio kernel: opmode regs old value - 0x2202 Sep 28 22:09:33 volumio kernel: old MII_BMCR: 0x3100 Sep 28 22:09:33 volumio kernel: new MII_BMCR: 0x3100 Sep 28 22:09:33 volumio kernel: hw_regs->er_opmode:0x2202 Sep 28 22:09:33 volumio kernel: link established. Sep 28 22:09:33 volumio kernel: ethernet link state:linked Sep 28 22:09:33 volumio kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Sep 28 22:09:33 volumio ntpd[543]: Listen and drop on 1 v6wildcard :: UDP 123 Sep 28 22:09:33 volumio ntpd[543]: Listen normally on 2 lo 127.0.0.1 UDP 123 Sep 28 22:09:33 volumio ntpd[543]: peers refreshed Sep 28 22:09:33 volumio ntpd[543]: Listening on routing socket on fd #19 for interface updates Sep 28 22:09:33 volumio avahi-daemon[486]: Successfully called chroot(). Sep 28 22:09:33 volumio avahi-daemon[486]: Successfully dropped remaining capabilities. Sep 28 22:09:33 volumio dbus[498]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 28 22:09:33 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Sep 28 22:09:33 volumio wifistart.sh[459]: command failed: No such device (-19) Sep 28 22:09:33 volumio sudo[471]: pam_unix(sudo:session): session closed for user root Sep 28 22:09:33 volumio systemd[1]: Starting Permit User Sessions... Sep 28 22:09:33 volumio avahi-daemon[486]: Loading service file /services/volumio.service. Sep 28 22:09:33 volumio avahi-daemon[486]: Network interface enumeration completed. Sep 28 22:09:33 volumio systemd[1]: Started Restore Sound Card State. Sep 28 22:09:33 volumio avahi-daemon[486]: Registering HINFO record with values 'ARMV7L'/'LINUX'. Sep 28 22:09:33 volumio avahi-daemon[486]: Server startup complete. Host name is volumio.local. Local service cookie is 1682037816. Sep 28 22:09:33 volumio avahi-daemon[486]: Service "Volumio" (/services/volumio.service) successfully established. Sep 28 22:09:33 volumio systemd[1]: Started /etc/rc.local Compatibility. Sep 28 22:09:33 volumio dhcpcd[415]: eth0: soliciting a DHCP lease Sep 28 22:09:33 volumio ifup[390]: dhcpcd[415]: eth0: soliciting a DHCP lease Sep 28 22:09:33 volumio systemd[1]: Started LSB: Start NTP daemon. Sep 28 22:09:33 volumio dbus[498]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service' Sep 28 22:09:33 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Sep 28 22:09:33 volumio systemd[1]: Started LSB: Brings up/down network automatically. Sep 28 22:09:33 volumio systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon. Sep 28 22:09:33 volumio systemd[1]: dhcpcd.service: control process exited, code=exited status=6 Sep 28 22:09:34 volumio systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support. Sep 28 22:09:34 volumio systemd[1]: Unit dhcpcd.service entered failed state. Sep 28 22:09:34 volumio systemd[1]: Started Permit User Sessions. Sep 28 22:09:34 volumio systemd-logind[462]: New seat seat0. Sep 28 22:09:34 volumio systemd[1]: Started Login Service. Sep 28 22:09:34 volumio systemd[1]: Starting Disk Manager (legacy version)... Sep 28 22:09:34 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Sep 28 22:09:34 volumio systemd[1]: Starting Wait for Plymouth Boot Screen to Quit... Sep 28 22:09:34 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Sep 28 22:09:34 volumio systemd[1]: Started Wait for Plymouth Boot Screen to Quit. Sep 28 22:09:34 volumio systemd[1]: Starting Getty on tty1... Sep 28 22:09:34 volumio systemd[1]: Started Getty on tty1. Sep 28 22:09:34 volumio systemd[1]: Starting Serial Getty on ttyS3... Sep 28 22:09:34 volumio systemd[1]: Started Serial Getty on ttyS3. Sep 28 22:09:34 volumio systemd[1]: Starting Login Prompts. Sep 28 22:09:34 volumio systemd[1]: Reached target Login Prompts. Sep 28 22:09:34 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Sep 28 22:09:34 volumio ifplugd(eth0)[519]: Link beat detected. Sep 28 22:09:34 volumio dbus[498]: [system] Successfully activated service 'org.freedesktop.UDisks' Sep 28 22:09:34 volumio systemd[1]: Started Disk Manager (legacy version). Sep 28 22:09:34 volumio ifplugd(eth0)[519]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Sep 28 22:09:34 volumio kernel: atc260x-rtc atc2603c-rtc.0: atc260x_rtc_settime(): 2018-09-28 22:09:34 Sep 28 22:09:34 volumio cpufrequtils[565]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Sep 28 22:09:34 volumio volumio-remote-updater[457]: Error: No active session Sep 28 22:09:34 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Sep 28 22:09:34 volumio volumio-remote-updater[457]: [2018-09-28 22:09:34] [info] asio async_connect error: system:111 (Connection refused) Sep 28 22:09:34 volumio volumio-remote-updater[457]: [2018-09-28 22:09:34] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 28 22:09:34 volumio volumio-remote-updater[457]: [2018-09-28 22:09:34] [error] handle_connect error: Underlying Transport Error Sep 28 22:09:34 volumio ifplugd(eth0)[519]: client: /sbin/ifup: interface eth0 already configured Sep 28 22:09:34 volumio dbus[498]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Sep 28 22:09:34 volumio haveged[452]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K Sep 28 22:09:34 volumio haveged[452]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 8/40; sz: 15248/74244 Sep 28 22:09:34 volumio haveged[452]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99733 Sep 28 22:09:34 volumio haveged[452]: haveged: fills: 0, generated: 0 Sep 28 22:09:34 volumio systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Sep 28 22:09:34 volumio ifplugd(eth0)[519]: Program executed successfully. Sep 28 22:09:34 volumio volumio[456]: Could not open config: /tmp/upmpdcli.conf Sep 28 22:09:34 volumio systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE Sep 28 22:09:34 volumio systemd[1]: Unit upmpdcli.service entered failed state. Sep 28 22:09:35 volumio polkitd[591]: started daemon version 0.105 using authority implementation `local' version `0.105' Sep 28 22:09:35 volumio dbus[498]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 28 22:09:35 volumio systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Sep 28 22:09:35 volumio udisks-glue[455]: Device file /dev/mmcblk0 inserted Sep 28 22:09:35 volumio udisks-glue[455]: Device file /dev/mmcblk0p3 inserted Sep 28 22:09:35 volumio ntpd[543]: Deferring DNS for 0.debian.pool.ntp.org 1 Sep 28 22:09:35 volumio ntpd[543]: Deferring DNS for 1.debian.pool.ntp.org 1 Sep 28 22:09:35 volumio ntpd[543]: Deferring DNS for 2.debian.pool.ntp.org 1 Sep 28 22:09:35 volumio ntpd[543]: Deferring DNS for 3.debian.pool.ntp.org 1 Sep 28 22:09:35 volumio ntpd[600]: signal_no_reset: signal 17 had flags 4000000 Sep 28 22:09:36 volumio dhcpcd[415]: eth0: offered 10.0.0.6 from 10.0.0.138 Sep 28 22:09:36 volumio ifup[390]: dhcpcd[415]: eth0: offered 10.0.0.6 from 10.0.0.138 Sep 28 22:09:36 volumio dhcpcd[415]: eth0: leased 10.0.0.6 for 3600 seconds Sep 28 22:09:36 volumio avahi-daemon[486]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.0.0.6. Sep 28 22:09:36 volumio avahi-daemon[486]: New relevant interface eth0.IPv4 for mDNS. Sep 28 22:09:36 volumio dhcpcd[415]: eth0: adding host route to 10.0.0.6 via 127.0.0.1 Sep 28 22:09:36 volumio avahi-daemon[486]: Registering new address record for 10.0.0.6 on eth0.IPv4. Sep 28 22:09:36 volumio dhcpcd[415]: eth0: adding route to 10.0.0.0/24 Sep 28 22:09:36 volumio dhcpcd[415]: eth0: adding default route via 10.0.0.138 Sep 28 22:09:36 volumio kernel: ec_netdev_set_multicast_list 2741 Sep 28 22:09:36 volumio ifup[390]: dhcpcd[415]: eth0: leased 10.0.0.6 for 3600 seconds Sep 28 22:09:36 volumio ifup[390]: dhcpcd[415]: eth0: adding host route to 10.0.0.6 via 127.0.0.1 Sep 28 22:09:36 volumio ifup[390]: dhcpcd[415]: eth0: adding route to 10.0.0.0/24 Sep 28 22:09:36 volumio ifup[390]: dhcpcd[415]: eth0: adding default route via 10.0.0.138 Sep 28 22:09:37 volumio ifup[390]: dhcpcd[415]: forked to background, child pid 629 Sep 28 22:09:37 volumio dhcpcd[415]: forked to background, child pid 629 Sep 28 22:09:37 volumio ntpd_intres[600]: DNS 0.debian.pool.ntp.org -> 27.124.125.251 Sep 28 22:09:37 volumio ntpd[543]: Listen normally on 3 eth0 10.0.0.6 UDP 123 Sep 28 22:09:37 volumio ntpd[543]: peers refreshed Sep 28 22:09:37 volumio wireless.js[562]: WIRELESS DAEMON: start Sep 28 22:09:37 volumio wireless.js[562]: WIRELESS: Loaded configuration Sep 28 22:09:37 volumio wireless.js[562]: Cleaning previous... Sep 28 22:09:38 volumio systemd[1]: Stopped hotspot.service. Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_0', on: 1, before SPS_PG_CTL: 0x717761 Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_0', on: 1, after SPS_PG_CTL: 0x71ff61 Sep 28 22:09:38 volumio kernel: start mon 0 ...... Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_1', on: 1, before SPS_PG_CTL: 0x71ff61 Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_1', on: 1, after SPS_PG_CTL: 0x75ff65 Sep 28 22:09:38 volumio kernel: start mon 1 ...... Sep 28 22:09:38 volumio sudo[685]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 28 22:09:38 volumio sudo[685]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:09:38 volumio sudo[685]: pam_unix(sudo:session): session closed for user root Sep 28 22:09:38 volumio wireless.js[562]: Stopped aP Sep 28 22:09:38 volumio systemd[1]: Started Music Player Daemon. Sep 28 22:09:38 volumio systemd[1]: Stopped hotspot.service. Sep 28 22:09:38 volumio sudo[702]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 28 22:09:38 volumio sudo[702]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:09:38 volumio sudo[702]: pam_unix(sudo:session): session closed for user root Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_1', on: 0, before SPS_PG_CTL: 0x75ff65 Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_1', on: 0, after SPS_PG_CTL: 0x75ff61 Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_0', on: 0, before SPS_PG_CTL: 0x71ff61 Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_0', on: 0, after SPS_PG_CTL: 0x71f761 Sep 28 22:09:38 volumio kernel: res_mem->start--end = 0xb0700000--0xb0700fff Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.1: pdev->id probe:1 Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_1', on: 1, before SPS_PG_CTL: 0x717761 Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_1', on: 1, after SPS_PG_CTL: 0x757765 Sep 28 22:09:38 volumio kernel: usb reset OK: 0. Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.1: AOTG USB Host Controller Driver Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.1: new USB bus registered, assigned bus number 3 Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.1: irq 93, io mem 0xb0700000 Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.1: start Sep 28 22:09:38 volumio kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0002 Sep 28 22:09:38 volumio kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Sep 28 22:09:38 volumio kernel: usb usb3: Product: AOTG USB Host Controller Driver Sep 28 22:09:38 volumio kernel: usb usb3: Manufacturer: Linux 3.10.38 aotg_hub_hcd Sep 28 22:09:38 volumio kernel: usb usb3: SerialNumber: aotg_hcd.1 Sep 28 22:09:38 volumio kernel: hub 3-0:1.0: USB hub found Sep 28 22:09:38 volumio kernel: hub 3-0:1.0: 1 port detected Sep 28 22:09:38 volumio kernel: USBEIEN(0xf093650b): 0x80 Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.1: hcd controller initialized. OTGIRQ: 0x01, OTGSTATE: 0x02 Sep 28 22:09:38 volumio kernel: USBEIRQ(0xf093650a): 0x00 Sep 28 22:09:38 volumio kernel: res_mem->start--end = 0xb0600000--0xb0600fff Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.0: pdev->id probe:0 Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_0', on: 1, before SPS_PG_CTL: 0x757765 Sep 28 22:09:38 volumio kernel: [PowerGate] name: 'usb2_0', on: 1, after SPS_PG_CTL: 0x75ff65 Sep 28 22:09:38 volumio kernel: usb reset OK: 0. Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.0: AOTG USB Host Controller Driver Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.0: new USB bus registered, assigned bus number 4 Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.0: irq 56, io mem 0xb0600000 Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.0: start Sep 28 22:09:38 volumio kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0002 Sep 28 22:09:38 volumio kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Sep 28 22:09:38 volumio kernel: usb usb4: Product: AOTG USB Host Controller Driver Sep 28 22:09:38 volumio kernel: usb usb4: Manufacturer: Linux 3.10.38 aotg_hub_hcd Sep 28 22:09:38 volumio kernel: usb usb4: SerialNumber: aotg_hcd.0 Sep 28 22:09:38 volumio kernel: hub 4-0:1.0: USB hub found Sep 28 22:09:38 volumio kernel: hub 4-0:1.0: 1 port detected Sep 28 22:09:38 volumio kernel: USBEIEN(0xf093850b): 0x80 Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.0: hcd controller initialized. OTGIRQ: 0x01, OTGSTATE: 0x02 Sep 28 22:09:38 volumio kernel: USBEIRQ(0xf093850a): 0x00 Sep 28 22:09:38 volumio systemd[1]: Starting hotspot.service... Sep 28 22:09:38 volumio systemd[1]: Started hotspot.service. Sep 28 22:09:38 volumio kernel: port_no:1 OTG IRQ, OTGSTATE: 0x03, USBIRQ:0x00 Sep 28 22:09:38 volumio kernel: port_no:0 OTG IRQ, OTGSTATE: 0x03, USBIRQ:0x00 Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.1: aotg_hcd.1 connection changed: 1, acthcd->inserted: 1 Sep 28 22:09:38 volumio kernel: aotg_hub_hotplug_timer:1768, dbg! Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.0: aotg_hcd.0 connection changed: 1, acthcd->inserted: 1 Sep 28 22:09:38 volumio kernel: aotg_hub_hotplug_timer:1768, dbg! Sep 28 22:09:38 volumio systemd[1]: Starting dhcpd.service... Sep 28 22:09:38 volumio systemd[1]: Starting dnsmasq.service... Sep 28 22:09:38 volumio systemd[1]: Started LSB: start Samba daemons for the AD DC. Sep 28 22:09:38 volumio systemd[1]: Started Wireless Services. Sep 28 22:09:38 volumio systemd[1]: Starting Volumio Backend Module... Sep 28 22:09:38 volumio systemd[1]: Started Volumio Backend Module. Sep 28 22:09:38 volumio dnsmasq[743]: started, version 2.72 cachesize 150 Sep 28 22:09:38 volumio dnsmasq[743]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect Sep 28 22:09:38 volumio dnsmasq[743]: reading /etc/resolv.conf Sep 28 22:09:38 volumio dnsmasq[743]: using nameserver 10.0.0.138#53 Sep 28 22:09:38 volumio dnsmasq[743]: using nameserver 208.67.222.222#53 Sep 28 22:09:38 volumio dnsmasq[743]: using nameserver 208.67.220.220#53 Sep 28 22:09:38 volumio dnsmasq[743]: read /etc/hosts - 1 addresses Sep 28 22:09:38 volumio kernel: set port reset!80 Sep 28 22:09:38 volumio kernel: USBRESET IRQ Sep 28 22:09:38 volumio kernel: aotg_hub_irq: USB device is 2 Sep 28 22:09:38 volumio systemd[1]: Started dnsmasq.service. Sep 28 22:09:38 volumio systemd[1]: Starting Host and Network Name Lookups. Sep 28 22:09:38 volumio systemd[1]: Reached target Host and Network Name Lookups. Sep 28 22:09:38 volumio dhcpd[730]: Internet Systems Consortium DHCP Server 4.3.1 Sep 28 22:09:38 volumio dhcpd[730]: Copyright 2004-2014 Internet Systems Consortium. Sep 28 22:09:38 volumio dhcpd[730]: All rights reserved. Sep 28 22:09:38 volumio dhcpd[730]: For info, please visit https://www.isc.org/software/dhcp/ Sep 28 22:09:38 volumio dhcpd[730]: Config file: /etc/dhcp/dhcpd.conf Sep 28 22:09:38 volumio dhcpd[730]: Database file: /var/lib/dhcp/dhcpd.leases Sep 28 22:09:38 volumio dhcpd[730]: PID file: /var/run/dhcpd.pid Sep 28 22:09:38 volumio kernel: USBRESET IRQ Sep 28 22:09:38 volumio kernel: aotg_hub_irq: USB device is 3 Sep 28 22:09:38 volumio hotspot[730]: Internet Systems Consortium DHCP Server 4.3.1 Sep 28 22:09:38 volumio hotspot[730]: Copyright 2004-2014 Internet Systems Consortium. Sep 28 22:09:38 volumio hotspot[730]: All rights reserved. Sep 28 22:09:38 volumio hotspot[730]: For info, please visit https://www.isc.org/software/dhcp/ Sep 28 22:09:38 volumio hotspot[730]: Config file: /etc/dhcp/dhcpd.conf Sep 28 22:09:38 volumio hotspot[730]: Database file: /var/lib/dhcp/dhcpd.leases Sep 28 22:09:38 volumio hotspot[730]: PID file: /var/run/dhcpd.pid Sep 28 22:09:38 volumio dhcpd[730]: Internet Systems Consortium DHCP Server 4.3.1 Sep 28 22:09:38 volumio dhcpd[730]: Copyright 2004-2014 Internet Systems Consortium. Sep 28 22:09:38 volumio dhcpd[730]: All rights reserved. Sep 28 22:09:38 volumio dhcpd[730]: For info, please visit https://www.isc.org/software/dhcp/ Sep 28 22:09:38 volumio dhcpd[730]: Wrote 0 leases to leases file. Sep 28 22:09:38 volumio hotspot[730]: Wrote 0 leases to leases file. Sep 28 22:09:38 volumio kernel: usb 3-1: new high-speed USB device number 2 using aotg_hcd Sep 28 22:09:38 volumio kernel: aotg_hcd aotg_hcd.1: device addr : 0x00000000 Sep 28 22:09:38 volumio kernel: set port reset!80 Sep 28 22:09:38 volumio dhcpd[730]: Sep 28 22:09:38 volumio dhcpd[730]: No subnet declaration for eth0 (10.0.0.6). Sep 28 22:09:38 volumio dhcpd[730]: ** Ignoring requests on eth0. If this is not what Sep 28 22:09:38 volumio dhcpd[730]: you want, please write a subnet declaration Sep 28 22:09:38 volumio dhcpd[730]: in your dhcpd.conf file for the network segment Sep 28 22:09:38 volumio dhcpd[730]: to which interface eth0 is attached. ** Sep 28 22:09:38 volumio dhcpd[730]: Sep 28 22:09:38 volumio dhcpd[730]: Sep 28 22:09:38 volumio dhcpd[730]: Not configured to listen on any interfaces! Sep 28 22:09:38 volumio dhcpd[730]: Sep 28 22:09:38 volumio dhcpd[730]: If you think you have received this message due to a bug rather Sep 28 22:09:38 volumio dhcpd[730]: than a configuration issue please read the section on submitting Sep 28 22:09:38 volumio dhcpd[730]: bugs on either our web page at www.isc.org or in the README file Sep 28 22:09:38 volumio dhcpd[730]: before submitting a bug. These pages explain the proper Sep 28 22:09:38 volumio dhcpd[730]: process and the information we find helpful for debugging.. Sep 28 22:09:38 volumio dhcpd[730]: Sep 28 22:09:38 volumio dhcpd[730]: exiting. Sep 28 22:09:39 volumio systemd[1]: dhcpd.service: control process exited, code=exited status=1 Sep 28 22:09:39 volumio systemd[1]: Failed to start dhcpd.service. Sep 28 22:09:39 volumio systemd[1]: Unit dhcpd.service entered failed state. Sep 28 22:09:39 volumio kernel: USBRESET IRQ Sep 28 22:09:39 volumio kernel: aotg_hub_irq: USB device is 3 Sep 28 22:09:39 volumio hotspot[730]: No subnet declaration for eth0 (10.0.0.6). Sep 28 22:09:39 volumio hotspot[730]: ** Ignoring requests on eth0. If this is not what Sep 28 22:09:39 volumio hotspot[730]: you want, please write a subnet declaration Sep 28 22:09:39 volumio hotspot[730]: in your dhcpd.conf file for the network segment Sep 28 22:09:39 volumio hotspot[730]: to which interface eth0 is attached. ** Sep 28 22:09:39 volumio hotspot[730]: Not configured to listen on any interfaces! Sep 28 22:09:39 volumio hotspot[730]: If you think you have received this message due to a bug rather Sep 28 22:09:39 volumio hotspot[730]: than a configuration issue please read the section on submitting Sep 28 22:09:39 volumio hotspot[730]: bugs on either our web page at www.isc.org or in the README file Sep 28 22:09:39 volumio hotspot[730]: before submitting a bug. These pages explain the proper Sep 28 22:09:39 volumio hotspot[730]: process and the information we find helpful for debugging.. Sep 28 22:09:39 volumio hotspot[730]: exiting. Sep 28 22:09:39 volumio kernel: aotg_hcd aotg_hcd.1: ep0 index 0 from ep [in] Sep 28 22:09:39 volumio kernel: aotg_hcd aotg_hcd.1: device addr : 0x00000002 Sep 28 22:09:39 volumio kernel: usb 3-1: New USB device found, idVendor=0424, idProduct=2412 Sep 28 22:09:39 volumio kernel: usb 3-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Sep 28 22:09:39 volumio kernel: hub 3-1:1.0: USB hub found Sep 28 22:09:39 volumio kernel: hub 3-1:1.0: 2 ports detected Sep 28 22:09:39 volumio nmbd[467]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Sep 28 22:09:39 volumio nmbd[467]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Sep 28 22:09:39 volumio nmbd[467]: Unable to setup corepath for nmbd: No such file or directory Sep 28 22:09:39 volumio nmbd[751]: [2018/09/28 22:09:39.218104, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio nmbd[751]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 28 22:09:39 volumio nmbd[751]: [2018/09/28 22:09:39.222116, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio nmbd[751]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 28 22:09:39 volumio nmbd[752]: [2018/09/28 22:09:39.236459, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Sep 28 22:09:39 volumio nmbd[752]: started asyncdns process 753 Sep 28 22:09:39 volumio systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Sep 28 22:09:39 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Sep 28 22:09:39 volumio kernel: nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead. Sep 28 22:09:39 volumio nmbd[752]: [2018/09/28 22:09:39.259831, 0] ../lib/util/become_daemon.c:124(daemon_ready) Sep 28 22:09:39 volumio nmbd[752]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Sep 28 22:09:39 volumio nmbd[467]: [2018/09/28 22:09:39, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio nmbd[467]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 28 22:09:39 volumio nmbd[467]: [2018/09/28 22:09:39, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio nmbd[467]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 28 22:09:39 volumio nmbd[467]: [2018/09/28 22:09:39, 0] ../source3/nmbd/nmbd.c:908(main) Sep 28 22:09:39 volumio nmbd[467]: nmbd version 4.2.14-Debian started. Sep 28 22:09:39 volumio nmbd[467]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Sep 28 22:09:39 volumio nmbd[467]: [2018/09/28 22:09:39.218104, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio nmbd[467]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 28 22:09:39 volumio nmbd[467]: [2018/09/28 22:09:39.222116, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio nmbd[467]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 28 22:09:39 volumio nmbd[467]: . Sep 28 22:09:39 volumio kernel: set port reset!80 Sep 28 22:09:39 volumio kernel: USBRESET IRQ Sep 28 22:09:39 volumio kernel: aotg_hub_irq: USB device is 2 Sep 28 22:09:39 volumio kernel: open ttyS3 Sep 28 22:09:39 volumio kernel: open ttyS3 Sep 28 22:09:39 volumio kernel: OWL_HDMI_DEBUG: hdmi_get_over_scan Sep 28 22:09:39 volumio kernel: USBRESET IRQ Sep 28 22:09:39 volumio kernel: aotg_hub_irq: USB device is 3 Sep 28 22:09:39 volumio kernel: open ttyS3 Sep 28 22:09:39 volumio kernel: open ttyS3 Sep 28 22:09:39 volumio winbind[463]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Sep 28 22:09:39 volumio winbind[463]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Sep 28 22:09:39 volumio winbind[463]: Unable to setup corepath for winbindd: No such file or directory Sep 28 22:09:39 volumio winbind[463]: mkdir failed on directory /var/log/samba/cores: No such file or directory Sep 28 22:09:39 volumio winbind[463]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Sep 28 22:09:39 volumio winbind[463]: Unable to setup corepath for winbindd: No such file or directory Sep 28 22:09:39 volumio winbind[463]: [2018/09/28 22:09:39, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio winbind[463]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 28 22:09:39 volumio winbind[463]: [2018/09/28 22:09:39, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio winbind[463]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 28 22:09:39 volumio winbind[463]: [2018/09/28 22:09:39, 0] ../source3/winbindd/winbindd.c:1549(main) Sep 28 22:09:39 volumio winbind[463]: winbindd version 4.2.14-Debian started. Sep 28 22:09:39 volumio winbind[463]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Sep 28 22:09:39 volumio winbind[463]: [2018/09/28 22:09:39, 0] ../lib/util/util.c:220(directory_create_or_exist) Sep 28 22:09:39 volumio winbind[463]: mkdir failed on directory /var/log/samba/cores: No such file or directory Sep 28 22:09:39 volumio winbind[463]: [2018/09/28 22:09:39, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Sep 28 22:09:39 volumio winbind[463]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Sep 28 22:09:39 volumio winbind[463]: [2018/09/28 22:09:39, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Sep 28 22:09:39 volumio winbind[463]: Unable to setup corepath for winbindd: No such file or directory Sep 28 22:09:39 volumio kernel: usb 4-1: new high-speed USB device number 2 using aotg_hcd Sep 28 22:09:39 volumio kernel: aotg_hcd aotg_hcd.0: device addr : 0x00000000 Sep 28 22:09:39 volumio kernel: set port reset!80 Sep 28 22:09:39 volumio winbindd[740]: [2018/09/28 22:09:39.386551, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio winbindd[740]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 28 22:09:39 volumio winbindd[740]: [2018/09/28 22:09:39.388670, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio winbindd[740]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 28 22:09:39 volumio systemd[1]: Started LSB: start Winbind daemon. Sep 28 22:09:39 volumio winbind[463]: [2018/09/28 22:09:39.386551, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio winbind[463]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 28 22:09:39 volumio winbind[463]: [2018/09/28 22:09:39.388670, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio winbind[463]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 28 22:09:39 volumio hotspot[728]: basename: missing operand Sep 28 22:09:39 volumio hotspot[728]: Try 'basename --help' for more information. Sep 28 22:09:39 volumio kernel: USBRESET IRQ Sep 28 22:09:39 volumio kernel: aotg_hub_irq: USB device is 3 Sep 28 22:09:39 volumio winbind[463]: . Sep 28 22:09:39 volumio winbindd[767]: [2018/09/28 22:09:39.454280, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Sep 28 22:09:39 volumio winbindd[767]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Sep 28 22:09:39 volumio hotspot[728]: /bin/hotspot.sh: line 7: [: too many arguments Sep 28 22:09:39 volumio hotspot[728]: /bin/hotspot.sh: line 10: [: too many arguments Sep 28 22:09:39 volumio hotspot[728]: Launching Ordinary Hostapd Sep 28 22:09:39 volumio winbindd[767]: [2018/09/28 22:09:39.492279, 0] ../lib/util/become_daemon.c:124(daemon_ready) Sep 28 22:09:39 volumio winbindd[767]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Sep 28 22:09:39 volumio winbindd[769]: [2018/09/28 22:09:39.502190, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:39 volumio winbindd[769]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory Sep 28 22:09:39 volumio kernel: aotg_hcd aotg_hcd.0: ep0 index 0 from ep [in] Sep 28 22:09:39 volumio kernel: aotg_hcd aotg_hcd.0: device addr : 0x00000002 Sep 28 22:09:39 volumio kernel: usb 4-1: New USB device found, idVendor=1a40, idProduct=0101 Sep 28 22:09:39 volumio kernel: usb 4-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Sep 28 22:09:39 volumio kernel: usb 4-1: Product: USB 2.0 Hub Sep 28 22:09:39 volumio kernel: hub 4-1:1.0: USB hub found Sep 28 22:09:39 volumio kernel: hub 4-1:1.0: 4 ports detected Sep 28 22:09:39 volumio volumio-remote-updater[457]: [2018-09-28 22:09:39] [info] asio async_connect error: system:111 (Connection refused) Sep 28 22:09:39 volumio volumio-remote-updater[457]: [2018-09-28 22:09:39] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 28 22:09:39 volumio volumio-remote-updater[457]: [2018-09-28 22:09:39] [error] handle_connect error: Underlying Transport Error Sep 28 22:09:39 volumio kernel: usb 3-1.1: new high-speed USB device number 3 using aotg_hcd Sep 28 22:09:39 volumio kernel: aotg_hcd aotg_hcd.1: device addr : 0x00000082 Sep 28 22:09:39 volumio hotspot[728]: Configuration file: /etc/hostapd/hostapd.conf Sep 28 22:09:39 volumio hotspot[728]: Could not read interface wlan0 flags: No such device Sep 28 22:09:39 volumio hotspot[728]: nl80211: Driver does not support authentication/association or connect commands Sep 28 22:09:39 volumio hotspot[728]: Could not read interface wlan0 flags: No such device Sep 28 22:09:39 volumio hotspot[728]: nl80211 driver initialization failed. Sep 28 22:09:39 volumio hotspot[728]: hostapd_free_hapd_data: Interface wlan0 wasn't started Sep 28 22:09:39 volumio systemd[1]: hotspot.service: main process exited, code=exited, status=1/FAILURE Sep 28 22:09:39 volumio systemd[1]: Stopping Host and Network Name Lookups. Sep 28 22:09:39 volumio systemd[1]: Stopped target Host and Network Name Lookups. Sep 28 22:09:39 volumio systemd[1]: Stopping dnsmasq.service... Sep 28 22:09:39 volumio systemd[1]: Stopped dnsmasq.service. Sep 28 22:09:39 volumio dnsmasq[743]: exiting on receipt of SIGTERM Sep 28 22:09:39 volumio hotspot[782]: Killing Hostapd Sep 28 22:09:39 volumio kernel: aotg_hcd aotg_hcd.1: ep0 index 0 from ep [in] Sep 28 22:09:39 volumio sudo[785]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall hostapd Sep 28 22:09:39 volumio sudo[785]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:09:39 volumio kernel: aotg_hcd aotg_hcd.1: device addr : 0x00000082 Sep 28 22:09:39 volumio kernel: usb 3-1.1: New USB device found, idVendor=152a, idProduct=8750 Sep 28 22:09:39 volumio kernel: usb 3-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Sep 28 22:09:39 volumio kernel: usb 3-1.1: Product: D50 Sep 28 22:09:39 volumio kernel: usb 3-1.1: Manufacturer: Topping Sep 28 22:09:39 volumio hotspot[782]: hostapd: no process found Sep 28 22:09:39 volumio sudo[785]: pam_unix(sudo:session): session closed for user root Sep 28 22:09:39 volumio hotspot[782]: Killing Dhcpd Sep 28 22:09:39 volumio sudo[787]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall dhcpd Sep 28 22:09:39 volumio sudo[787]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:09:39 volumio hotspot[782]: dhcpd: no process found Sep 28 22:09:39 volumio sudo[787]: pam_unix(sudo:session): session closed for user root Sep 28 22:09:39 volumio systemd[1]: hotspot.service: control process exited, code=exited status=1 Sep 28 22:09:39 volumio systemd[1]: Unit hotspot.service entered failed state. Sep 28 22:09:39 volumio kernel: usbcore: registered new interface driver snd-usb-audio Sep 28 22:09:40 volumio smbd[754]: Starting SMB/CIFS daemon: smbd[2018/09/28 22:09:40, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:40 volumio smbd[754]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 28 22:09:40 volumio smbd[754]: [2018/09/28 22:09:40, 0] ../lib/util/util.c:220(directory_create_or_exist) Sep 28 22:09:40 volumio smbd[754]: mkdir failed on directory /var/log/samba/cores: No such file or directory Sep 28 22:09:40 volumio smbd[754]: [2018/09/28 22:09:40, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Sep 28 22:09:40 volumio smbd[754]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Sep 28 22:09:40 volumio smbd[754]: [2018/09/28 22:09:40, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Sep 28 22:09:40 volumio smbd[754]: Unable to setup corepath for smbd: No such file or directory Sep 28 22:09:40 volumio smbd[754]: [2018/09/28 22:09:40, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:40 volumio smbd[754]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 28 22:09:40 volumio smbd[754]: [2018/09/28 22:09:40, 0] ../source3/smbd/server.c:1241(main) Sep 28 22:09:40 volumio smbd[754]: smbd version 4.2.14-Debian started. Sep 28 22:09:40 volumio smbd[754]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Sep 28 22:09:40 volumio smbd[794]: [2018/09/28 22:09:40.961040, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:40 volumio smbd[794]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 28 22:09:40 volumio smbd[794]: [2018/09/28 22:09:40.963665, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:40 volumio smbd[794]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 28 22:09:40 volumio smbd[794]: [2018/09/28 22:09:40.964089, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:40 volumio smbd[794]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 28 22:09:40 volumio smbd[754]: [2018/09/28 22:09:40.961040, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:40 volumio smbd[754]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 28 22:09:40 volumio smbd[754]: [2018/09/28 22:09:40.963665, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:40 volumio smbd[754]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 28 22:09:40 volumio smbd[754]: [2018/09/28 22:09:40.964089, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:40 volumio smbd[754]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 28 22:09:40 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Sep 28 22:09:40 volumio smbd[754]: . Sep 28 22:09:40 volumio systemd[1]: Starting Multi-User System. Sep 28 22:09:40 volumio systemd[1]: Reached target Multi-User System. Sep 28 22:09:40 volumio systemd[1]: Starting Graphical Interface. Sep 28 22:09:40 volumio systemd[1]: Reached target Graphical Interface. Sep 28 22:09:40 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Sep 28 22:09:41 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Sep 28 22:09:41 volumio systemd[1]: Startup finished in 2.455s (kernel) + 11.451s (userspace) = 13.906s. Sep 28 22:09:41 volumio winbindd[800]: [2018/09/28 22:09:41.054759, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:41 volumio winbindd[800]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Sep 28 22:09:41 volumio winbindd[801]: [2018/09/28 22:09:41.098215, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:41 volumio winbindd[801]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Sep 28 22:09:41 volumio smbd[795]: [2018/09/28 22:09:41.156661, 0] ../lib/util/become_daemon.c:124(daemon_ready) Sep 28 22:09:41 volumio smbd[795]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Sep 28 22:09:41 volumio smbd[802]: [2018/09/28 22:09:41.165043, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 28 22:09:41 volumio smbd[802]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 28 22:09:42 volumio volumio[741]: info: ------------------------------------------- Sep 28 22:09:42 volumio volumio[741]: info: ----- Volumio2 ---- Sep 28 22:09:42 volumio volumio[741]: info: ------------------------------------------- Sep 28 22:09:42 volumio volumio[741]: info: ----- System startup ---- Sep 28 22:09:42 volumio volumio[741]: info: ------------------------------------------- Sep 28 22:09:42 volumio ntpd_intres[600]: DNS 1.debian.pool.ntp.org -> 45.76.113.31 Sep 28 22:09:42 volumio volumio[741]: info: Plugin folders cleanup Sep 28 22:09:42 volumio volumio[741]: info: Scanning into folder /volumio/app/plugins/ Sep 28 22:09:42 volumio volumio[741]: info: Scanning category audio_interface Sep 28 22:09:42 volumio volumio[741]: info: Scanning category miscellanea Sep 28 22:09:42 volumio volumio[741]: info: Scanning category music_service Sep 28 22:09:42 volumio volumio[741]: info: Scanning category plugins.json Sep 28 22:09:42 volumio volumio[741]: info: Scanning category system_controller Sep 28 22:09:42 volumio volumio[741]: info: Scanning category user_interface Sep 28 22:09:42 volumio volumio[741]: info: Scanning into folder /data/plugins/ Sep 28 22:09:42 volumio volumio[741]: info: Scanning category music_service Sep 28 22:09:42 volumio volumio[741]: info: Plugin folders cleanup completed Sep 28 22:09:42 volumio volumio[741]: info: ------------------------------------------- Sep 28 22:09:42 volumio volumio[741]: info: ----- Core plugins startup ---- Sep 28 22:09:42 volumio volumio[741]: info: ------------------------------------------- Sep 28 22:09:42 volumio volumio[741]: info: Loading plugins from folder /volumio/app/plugins/ Sep 28 22:09:42 volumio volumio[741]: info: Adding plugin upnp to MyMusic Plugins Sep 28 22:09:42 volumio volumio[741]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 28 22:09:42 volumio volumio[741]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 28 22:09:42 volumio volumio[741]: info: Loading plugins from folder /data/plugins/ Sep 28 22:09:42 volumio volumio[741]: info: Loading plugin "system"... Sep 28 22:09:42 volumio volumio[741]: info: Loading plugin "appearance"... Sep 28 22:09:43 volumio ntpd_intres[600]: DNS 2.debian.pool.ntp.org -> 27.124.125.251 Sep 28 22:09:43 volumio ntpd_intres[600]: DNS 3.debian.pool.ntp.org -> 80.74.64.1 Sep 28 22:09:44 volumio volumio[741]: info: Loading plugin "network"... Sep 28 22:09:44 volumio volumio[741]: info: Loading plugin "services"... Sep 28 22:09:44 volumio volumio[741]: info: Loading plugin "alsa_controller"... Sep 28 22:10:16 volumio systemd[1]: Time has been changed Sep 28 22:10:16 volumio volumio[741]: info: Loading plugin "wizard"... Sep 28 22:10:16 volumio volumio[741]: info: Loading plugin "volumio_command_line_client"... Sep 28 22:10:16 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:10:16 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:10:16 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:10:16 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:10:16 volumio volumio[741]: info: Loading plugin "upnp"... Sep 28 22:10:16 volumio volumio[741]: info: [1538172616619] Starting Upmpd Daemon Sep 28 22:10:16 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 28 22:10:16 volumio volumio[741]: info: Loading plugin "my_music"... Sep 28 22:10:16 volumio volumio[741]: info: Loading plugin "mpd"... Sep 28 22:10:17 volumio volumio[741]: info: Loading plugin "upnp_browser"... Sep 28 22:10:18 volumio volumio[741]: info: Loading plugin "networkfs"... Sep 28 22:10:18 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 28 22:10:18 volumio volumio[741]: info: Loading plugin "alarm-clock"... Sep 28 22:10:18 volumio sudo[819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //VORTEXBOX/files /mnt/NAS/files Sep 28 22:10:18 volumio sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:18 volumio volumio-remote-updater[457]: [2018-09-28 22:10:18] [connect] Successful connection Sep 28 22:10:18 volumio sudo[819]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:18 volumio volumio[741]: info: Loading plugin "airplay_emulation"... Sep 28 22:10:18 volumio volumio[741]: info: Starting Shairport Sync Sep 28 22:10:18 volumio volumio[741]: info: Loading plugin "last_100"... Sep 28 22:10:18 volumio volumio[741]: info: Loading plugin "webradio"... Sep 28 22:10:18 volumio volumio[741]: info: Loading plugin "i2s_dacs"... Sep 28 22:10:18 volumio volumio[741]: info: I2S DAC not set, start Auto-detection Sep 28 22:10:18 volumio volumio[741]: info: Loading plugin "volumiodiscovery"... Sep 28 22:10:18 volumio volumio[741]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 28 22:10:18 volumio node[741]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 28 22:10:18 volumio node[741]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 28 22:10:18 volumio node[741]: *** WARNING *** For more information see Sep 28 22:10:18 volumio node[741]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 28 22:10:18 volumio node[741]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 28 22:10:18 volumio node[741]: *** WARNING *** For more information see Sep 28 22:10:18 volumio volumio[741]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 28 22:10:18 volumio volumio[741]: *** WARNING *** For more information see Sep 28 22:10:18 volumio volumio[741]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 28 22:10:18 volumio volumio[741]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 28 22:10:18 volumio volumio[741]: *** WARNING *** For more information see Sep 28 22:10:18 volumio volumio[741]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 28 22:10:18 volumio volumio[741]: Discovery: StartAdv! undefined Sep 28 22:10:18 volumio volumio[741]: Discovery: Started advertising... Volumio - undefined Sep 28 22:10:18 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 28 22:10:18 volumio volumio[741]: info: Loading plugin "albumart"... Sep 28 22:10:19 volumio volumio[741]: info: Plugin example_plugin is not enabled Sep 28 22:10:19 volumio volumio[741]: info: Loading plugin "updater_comm"... Sep 28 22:10:19 volumio volumio[741]: info: Plugin mpdemulation is not enabled Sep 28 22:10:19 volumio volumio[741]: info: Loading plugin "rest_api"... Sep 28 22:10:19 volumio volumio[741]: info: Loading plugin "websocket"... Sep 28 22:10:19 volumio volumio[741]: info: Plugin spop is not enabled Sep 28 22:10:19 volumio volumio[741]: info: Loading plugin "volspotconnect2"... Sep 28 22:10:19 volumio volumio[741]: Forking 3 albumart workers Sep 28 22:10:20 volumio volumio[741]: info: ___________ START PLUGINS ___________ Sep 28 22:10:20 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 28 22:10:20 volumio volumio[741]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 28 22:10:20 volumio volumio[741]: info: [1538172620872] CoreMusicLibrary::Adding element Media Servers Sep 28 22:10:20 volumio volumio[741]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 28 22:10:20 volumio volumio[741]: info: [1538172620986] CoreMusicLibrary::Adding element Last_100 Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 28 22:10:21 volumio volumio[741]: info: [1538172621002] CoreMusicLibrary::Adding element Webradio Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 28 22:10:21 volumio volumio[741]: info: ------------------------------------------- Sep 28 22:10:21 volumio volumio[741]: info: ----- MyVolumio plugins startup ---- Sep 28 22:10:21 volumio volumio[741]: info: ------------------------------------------- Sep 28 22:10:21 volumio volumio[741]: info: Loading plugins from folder /myvolumio/plugins Sep 28 22:10:21 volumio volumio[741]: info: Loading plugins from folder /data/myvolumio/plugins Sep 28 22:10:21 volumio volumio[741]: info: Loading i18n strings for locale en Sep 28 22:10:21 volumio volumio[741]: Updating browse sources language Sep 28 22:10:21 volumio volumio[741]: Cannot find translation for sourceMedia Servers Sep 28 22:10:21 volumio sudo[866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Sep 28 22:10:21 volumio sudo[866]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 28 22:10:21 volumio systemd[1]: Starting Volspotconnect2 Daemon... Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::initPlayerControls Sep 28 22:10:21 volumio systemd[1]: Started Volspotconnect2 Daemon. Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Sep 28 22:10:21 volumio sudo[866]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:10:21 volumio volumio[868]: INFO:librespot: librespot 9b85d33 (2018-05-18). Built on 2018-05-18. Build ID: u91GgpUM Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 28 22:10:21 volumio volumio[741]: info: BOOT COMPLETED Sep 28 22:10:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 28 22:10:21 volumio kernel: snd_pcm_mmap,default Sep 28 22:10:21 volumio kernel: iso_packets:0, bInterval:1, urb_interval:1, reg_con:0x4 Sep 28 22:10:21 volumio kernel: iso_packets:0, bInterval:4, urb_interval:8, reg_con:0x4 Sep 28 22:10:21 volumio volumio[868]: WARN:mdns: Failed to register IPv6 receiver: Error { repr: Os { code: 19, message: "No such device" } } Sep 28 22:10:21 volumio volumio[741]: Starting albumart workers Sep 28 22:10:21 volumio volumio[741]: Starting albumart workers Sep 28 22:10:21 volumio volumio[741]: Starting albumart workers Sep 28 22:10:26 volumio volumio[741]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Sep 28 22:10:26 volumio volumio[741]: info: CoreCommandRouter::Close All Modals sent Sep 28 22:10:26 volumio volumio[741]: info: CoreCommandRouter::Close All Modals sent Sep 28 22:10:26 volumio kernel: aotg_hub_endpoint_disable Sep 28 22:10:26 volumio kernel: aotg_hcd aotg_hcd.1: ep1 index 1 from ep [out] Sep 28 22:10:26 volumio kernel: aotg_hub_endpoint_disable Sep 28 22:10:26 volumio kernel: aotg_hcd aotg_hcd.1: ep1 index 2 from ep [in] Sep 28 22:10:26 volumio volumio[741]: Express server listening on port 3000 Sep 28 22:10:26 volumio volumio[741]: Volumio Calling Home Sep 28 22:10:26 volumio kernel: ec_netdev_set_multicast_list 2741 Sep 28 22:10:26 volumio volumio[741]: info: CoreStateMachine::resetVolumioState Sep 28 22:10:26 volumio volumio[741]: info: CoreStateMachine::getcurrentVolume Sep 28 22:10:26 volumio volumio[741]: info: CoreCommandRouter::volumioRetrievevolume Sep 28 22:10:26 volumio volumio[741]: info: CoreStateMachine::updateTrackBlock Sep 28 22:10:26 volumio volumio[741]: info: CorePlayQueue::getTrackBlock Sep 28 22:10:27 volumio sudo[884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 28 22:10:27 volumio sudo[884]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:27 volumio sudo[884]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:27 volumio volumio[741]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Sep 28 22:10:27 volumio volumio[741]: info: Setting Device type: Sparky Sep 28 22:10:27 volumio volumio[741]: info: Volspotconnect2 Daemon Started Sep 28 22:10:27 volumio volumio[741]: info: [SpConDebug] Volspotconnect2 Started Sep 28 22:10:27 volumio volumio[741]: info: [SpConDebug] Starting metadata listener Sep 28 22:10:27 volumio volumio[741]: info: MPD running with PID493 ,establishing connection Sep 28 22:10:27 volumio sudo[892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Sep 28 22:10:27 volumio sudo[892]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 28 22:10:27 volumio sudo[892]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:27 volumio volumio[741]: info: VolumeController:: Volume=96 Mute =false Sep 28 22:10:27 volumio volumio[741]: info: CoreStateMachine::pushState Sep 28 22:10:27 volumio volumio[741]: info: CoreStateMachine::getState Sep 28 22:10:27 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:10:27 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Sep 28 22:10:27 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 28 22:10:27 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 28 22:10:27 volumio volumio[741]: info: Reloading queue from file Sep 28 22:10:27 volumio volumio[741]: info: Sep 28 22:10:27 volumio volumio[741]: info: message= [50@0] {} No such directory, stack=Error: [50@0] {} No such directory Sep 28 22:10:27 volumio volumio[741]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Sep 28 22:10:27 volumio volumio[741]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Sep 28 22:10:27 volumio volumio[741]: at emitOne (events.js:116:13) Sep 28 22:10:27 volumio volumio[741]: at Socket.emit (events.js:211:7) Sep 28 22:10:27 volumio volumio[741]: at addChunk (_stream_readable.js:263:12) Sep 28 22:10:27 volumio volumio[741]: at readableAddChunk (_stream_readable.js:246:13) Sep 28 22:10:27 volumio volumio[741]: at Socket.Readable.push (_stream_readable.js:208:10) Sep 28 22:10:27 volumio volumio[741]: at Pipe.onread (net.js:607:20) Sep 28 22:10:27 volumio volumio[741]: info: Volumio called home Sep 28 22:10:27 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 28 22:10:27 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 28 22:10:27 volumio volumio[741]: info: Version has changed, forcing UI Reload Sep 28 22:10:27 volumio volumio[741]: info: CoreCommandRouter::Reload Ui Sep 28 22:10:27 volumio volumio[741]: info: CoreStateMachine::setRepeat null single undefined Sep 28 22:10:27 volumio volumio[741]: info: CoreStateMachine::pushState Sep 28 22:10:27 volumio volumio[741]: info: CoreStateMachine::getState Sep 28 22:10:27 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:10:27 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Sep 28 22:10:27 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 28 22:10:27 volumio volumio[741]: info: CoreStateMachine::setRandom null Sep 28 22:10:27 volumio volumio[741]: info: CoreStateMachine::pushState Sep 28 22:10:27 volumio volumio[741]: info: CoreStateMachine::getState Sep 28 22:10:27 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:10:27 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Sep 28 22:10:27 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 28 22:10:28 volumio sudo[898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 28 22:10:28 volumio sudo[898]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:28 volumio sudo[900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Sep 28 22:10:28 volumio sudo[900]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:28 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Sep 28 22:10:28 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 28 22:10:28 volumio sudo[898]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:28 volumio sudo[903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Sep 28 22:10:28 volumio sudo[903]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:28 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Sep 28 22:10:28 volumio systemd[1]: Started ShairportSync AirTunes receiver. Sep 28 22:10:28 volumio sudo[900]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:28 volumio sudo[903]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:28 volumio volumio[741]: Discovery: adding 880ca0b6-35ac-43e2-855f-0f6f4514b800 Sep 28 22:10:28 volumio volumio[741]: info: mDNS: Found device Volumio Sep 28 22:10:28 volumio shairport-sync[907]: Successful Startup Sep 28 22:10:28 volumio sudo[909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 28 22:10:28 volumio sudo[909]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:28 volumio sudo[909]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:28 volumio volumio[741]: info: Upmpdcli Daemon Started Sep 28 22:10:29 volumio volumio[741]: info: Shairport-Sync Started Sep 28 22:10:29 volumio volumio[741]: Error adding Membership: Error: addMembership EINVAL Sep 28 22:10:29 volumio volumio[741]: info: Shairport-Sync Started Sep 28 22:10:30 volumio volumio[741]: error: error Sep 28 22:10:30 volumio volumio[741]: error: error Sep 28 22:10:30 volumio volumio[741]: error: error Sep 28 22:10:30 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Sep 28 22:10:30 volumio volumio[741]: info: CoreStateMachine::getState Sep 28 22:10:30 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:10:30 volumio sudo[918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 28 22:10:30 volumio sudo[918]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:30 volumio sudo[918]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:31 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Sep 28 22:10:31 volumio volumio[741]: info: CoreStateMachine::getState Sep 28 22:10:31 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:10:31 volumio sudo[949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 28 22:10:31 volumio sudo[949]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:31 volumio volumio[741]: info: CoreCommandRouter::volumioGetBrowseSources Sep 28 22:10:31 volumio sudo[949]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:31 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 28 22:10:31 volumio sudo[956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 28 22:10:31 volumio volumio[741]: info: Listing playlists Sep 28 22:10:31 volumio sudo[956]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:10:31 volumio sudo[956]: pam_unix(sudo:session): session closed for user root Sep 28 22:10:33 volumio volumio-remote-updater[457]: [2018-09-28 22:10:33] [connect] Successful connection Sep 28 22:10:33 volumio volumio-remote-updater[457]: [2018-09-28 22:10:33] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1538172633 101 Sep 28 22:10:51 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 28 22:10:51 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 28 22:11:16 volumio volumio[741]: error: error Sep 28 22:11:16 volumio volumio[741]: error: error Sep 28 22:11:16 volumio volumio[741]: error: error Sep 28 22:11:33 volumio volumio[741]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 28 22:11:33 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 28 22:11:33 volumio volumio[741]: info: Received Get System Version Sep 28 22:11:33 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 28 22:11:38 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Sep 28 22:11:38 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Sep 28 22:11:40 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Sep 28 22:11:40 volumio volumio[741]: info: Loading i18n strings for locale en Sep 28 22:11:40 volumio volumio[741]: Updating browse sources language Sep 28 22:11:40 volumio volumio[741]: Cannot find translation for sourceMedia Servers Sep 28 22:11:41 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Sep 28 22:11:41 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Sep 28 22:11:41 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 28 22:11:41 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 28 22:11:41 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 28 22:11:43 volumio volumio[741]: info: Output device has changed, restarting MPD Sep 28 22:11:43 volumio volumio[741]: info: Output device has changed, restarting Shairport Sync Sep 28 22:11:43 volumio sudo[1479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 28 22:11:43 volumio sudo[1479]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:43 volumio sudo[1479]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:43 volumio sudo[1481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 28 22:11:43 volumio sudo[1481]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 28 22:11:43 volumio systemd[1]: Stopping Music Player Daemon... Sep 28 22:11:43 volumio volumio[741]: info: Setting mixer Topping Clock Selector for card D50 Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::volumioUpdateVolumeSettings Sep 28 22:11:43 volumio volumio[741]: info: Updating Volume Controller Parameters: Device: 1 Name: Cheapo S/PDIF Mixer: Topping Clock Selector Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 28 22:11:43 volumio volumio[741]: info: MPD Permissions set Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 28 22:11:43 volumio sudo[1491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 28 22:11:43 volumio sudo[1491]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:43 volumio sudo[1491]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:43 volumio systemd[1]: Starting Music Player Daemon... Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 28 22:11:43 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 28 22:11:43 volumio sudo[1505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Sep 28 22:11:43 volumio sudo[1505]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:43 volumio volumio[741]: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 28 22:11:43 volumio volumio[741]: wlan0 Interface doesn't support scanning. Sep 28 22:11:43 volumio volumio[741]: Cannot use regular scanning, forcing with ap-force Sep 28 22:11:43 volumio sudo[1507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 28 22:11:43 volumio sudo[1507]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:43 volumio systemd[1]: Stopping ShairportSync AirTunes receiver... Sep 28 22:11:43 volumio sudo[1507]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:43 volumio systemd[1]: Starting ShairportSync AirTunes receiver... Sep 28 22:11:43 volumio sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 28 22:11:43 volumio systemd[1]: Started ShairportSync AirTunes receiver. Sep 28 22:11:43 volumio sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:43 volumio sudo[1505]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:43 volumio sudo[1512]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:43 volumio volumio[741]: command failed: No such device (-19) Sep 28 22:11:43 volumio volumio[741]: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 28 22:11:43 volumio volumio[741]: command failed: No such device (-19) Sep 28 22:11:43 volumio volumio[741]: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 28 22:11:43 volumio volumio[741]: wlan0 Interface doesn't support scanning. Sep 28 22:11:43 volumio shairport-sync[1517]: Successful Startup Sep 28 22:11:43 volumio volumio[741]: Cannot use regular scanning, forcing with ap-force Sep 28 22:11:43 volumio sudo[1525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 28 22:11:43 volumio sudo[1525]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:43 volumio sudo[1525]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:43 volumio volumio[741]: command failed: No such device (-19) Sep 28 22:11:43 volumio volumio[741]: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 28 22:11:43 volumio volumio[741]: command failed: No such device (-19) Sep 28 22:11:43 volumio volumio[741]: info: Shairport-Sync Started Sep 28 22:11:43 volumio volumio[741]: error: Upnp client error: Error: This socket has been ended by the other party Sep 28 22:11:44 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 28 22:11:47 volumio systemd[1]: Started Music Player Daemon. Sep 28 22:11:47 volumio sudo[1481]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:47 volumio volumio[741]: info: Sep 28 22:11:48 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 28 22:11:48 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 28 22:11:48 volumio sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 28 22:11:48 volumio sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:48 volumio sudo[1540]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:48 volumio sudo[1542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 28 22:11:48 volumio sudo[1542]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:48 volumio volumio[741]: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 28 22:11:48 volumio volumio[741]: wlan0 Interface doesn't support scanning. Sep 28 22:11:48 volumio volumio[741]: Cannot use regular scanning, forcing with ap-force Sep 28 22:11:48 volumio sudo[1542]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:48 volumio sudo[1554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 28 22:11:48 volumio sudo[1554]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:48 volumio sudo[1554]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:48 volumio volumio[741]: command failed: No such device (-19) Sep 28 22:11:48 volumio volumio[741]: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 28 22:11:48 volumio volumio[741]: command failed: No such device (-19) Sep 28 22:11:48 volumio volumio[741]: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 28 22:11:48 volumio volumio[741]: wlan0 Interface doesn't support scanning. Sep 28 22:11:48 volumio volumio[741]: Cannot use regular scanning, forcing with ap-force Sep 28 22:11:48 volumio sudo[1561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 28 22:11:48 volumio sudo[1561]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:11:48 volumio sudo[1561]: pam_unix(sudo:session): session closed for user root Sep 28 22:11:48 volumio volumio[741]: command failed: No such device (-19) Sep 28 22:11:48 volumio volumio[741]: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 28 22:11:48 volumio volumio[741]: command failed: No such device (-19) Sep 28 22:12:06 volumio volumio[741]: error: error Sep 28 22:12:06 volumio volumio[741]: error: error Sep 28 22:12:06 volumio volumio[741]: error: error Sep 28 22:12:21 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 28 22:12:22 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Sep 28 22:12:22 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Sep 28 22:12:22 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Sep 28 22:12:28 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Sep 28 22:12:28 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Sep 28 22:12:28 volumio volumio[741]: info: Wizard terminated Successfully Sep 28 22:12:32 volumio volumio[741]: info: CoreCommandRouter::volumioPlay Sep 28 22:12:32 volumio volumio[741]: UNSET VOLATILE Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::play index undefined Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 28 22:12:32 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::startPlaybackTimer Sep 28 22:12:32 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::clearAddPlayTracks NAS/files/music/flac/Andrew LLyod Webber/very best of andrew llyod webber/1 - Memory__96000.flac Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::sendMpdCommand stop Sep 28 22:12:32 volumio volumio[741]: info: sending command... Sep 28 22:12:32 volumio volumio[741]: info: parsing response... Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::sendMpdCommand clear Sep 28 22:12:32 volumio volumio[741]: info: sending command... Sep 28 22:12:32 volumio volumio[741]: info: Sep 28 22:12:32 volumio volumio[741]: ---------------------------- MPD announces system playlist update Sep 28 22:12:32 volumio volumio[741]: info: Ignoring MPD Status Update Sep 28 22:12:32 volumio volumio[741]: info: parsing response... Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::sendMpdCommand add "NAS/files/music/flac/Andrew LLyod Webber/very best of andrew llyod webber/1 - Memory__96000.flac" Sep 28 22:12:32 volumio volumio[741]: info: sending command... Sep 28 22:12:32 volumio volumio[741]: info: Sep 28 22:12:32 volumio volumio[741]: info: Sep 28 22:12:32 volumio volumio[741]: ---------------------------- MPD announces system playlist update Sep 28 22:12:32 volumio volumio[741]: info: Ignoring MPD Status Update Sep 28 22:12:32 volumio volumio[741]: info: ------------------------------ 17ms Sep 28 22:12:32 volumio volumio[741]: info: parsing response... Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::sendMpdCommand play Sep 28 22:12:32 volumio volumio[741]: info: sending command... Sep 28 22:12:32 volumio volumio[741]: info: ------------------------------ 13ms Sep 28 22:12:32 volumio volumio[741]: info: parsing response... Sep 28 22:12:32 volumio volumio[741]: info: Sep 28 22:12:32 volumio volumio[741]: ---------------------------- MPD announces state update: player Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::getState Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::sendMpdCommand status Sep 28 22:12:32 volumio volumio[741]: info: sending command... Sep 28 22:12:32 volumio kernel: iso_packets:0, bInterval:1, urb_interval:1, reg_con:0x4 Sep 28 22:12:32 volumio kernel: iso_packets:0, bInterval:4, urb_interval:8, reg_con:0x4 Sep 28 22:12:32 volumio volumio[741]: info: parsing response... Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::parseState Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::sendMpdCommand playlistinfo Sep 28 22:12:32 volumio volumio[741]: info: sending command... Sep 28 22:12:32 volumio volumio[741]: info: Sep 28 22:12:32 volumio volumio[741]: ---------------------------- MPD announces state update: player Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::getState Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::sendMpdCommand status Sep 28 22:12:32 volumio volumio[741]: info: parsing response... Sep 28 22:12:32 volumio volumio[741]: info: sending command... Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::parseTrackInfo Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::pushState Sep 28 22:12:32 volumio volumio[741]: info: CoreCommandRouter::servicePushState Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::syncState Sep 28 22:12:32 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:12:32 volumio volumio[741]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":257,"samplerate":"96 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"1 - Memory__96000.flac","artist":null,"album":null,"uri":"NAS/files/music/flac/Andrew LLyod Webber/very best of andrew llyod webber/1 - Memory__96000.flac","trackType":"flac"} Sep 28 22:12:32 volumio volumio[741]: info: CURRENT POSITION 0 Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::syncState stateService play Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::syncState currentStatus stop Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::pushState Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::getState Sep 28 22:12:32 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:12:32 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Sep 28 22:12:32 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 28 22:12:32 volumio volumio[741]: info: ------------------------------ 145ms Sep 28 22:12:32 volumio volumio[741]: info: parsing response... Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::parseState Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::sendMpdCommand playlistinfo Sep 28 22:12:32 volumio sudo[1696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 28 22:12:32 volumio sudo[1696]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:12:32 volumio volumio[741]: info: sending command... Sep 28 22:12:32 volumio sudo[1696]: pam_unix(sudo:session): session closed for user root Sep 28 22:12:32 volumio volumio[741]: info: parsing response... Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::parseTrackInfo Sep 28 22:12:32 volumio volumio[741]: info: ControllerMpd::pushState Sep 28 22:12:32 volumio volumio[741]: info: CoreCommandRouter::servicePushState Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::syncState Sep 28 22:12:32 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:12:32 volumio volumio[741]: info: STATE SERVICE {"status":"play","position":0,"seek":496,"duration":257,"samplerate":"96 KHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"1 - Memory__96000.flac","artist":null,"album":null,"uri":"NAS/files/music/flac/Andrew LLyod Webber/very best of andrew llyod webber/1 - Memory__96000.flac","trackType":"flac"} Sep 28 22:12:32 volumio volumio[741]: info: CURRENT POSITION 0 Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::syncState stateService play Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::syncState currentStatus play Sep 28 22:12:32 volumio volumio[741]: info: Received an update from plugin. extracting info from payload Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::pushState Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::getState Sep 28 22:12:32 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:12:32 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Sep 28 22:12:32 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::pushState Sep 28 22:12:32 volumio volumio[741]: info: CoreStateMachine::getState Sep 28 22:12:32 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:12:32 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Sep 28 22:12:32 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 28 22:12:32 volumio sudo[1703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 28 22:12:32 volumio sudo[1703]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:12:32 volumio volumio[741]: info: ------------------------------ 246ms Sep 28 22:12:32 volumio sudo[1705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 28 22:12:32 volumio sudo[1705]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:12:32 volumio sudo[1703]: pam_unix(sudo:session): session closed for user root Sep 28 22:12:32 volumio sudo[1705]: pam_unix(sudo:session): session closed for user root Sep 28 22:12:54 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Sep 28 22:12:54 volumio volumio[741]: info: CoreStateMachine::getState Sep 28 22:12:54 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Sep 28 22:12:54 volumio volumio[741]: info: CoreCommandRouter::volumioGetQueue Sep 28 22:12:54 volumio volumio[741]: info: CoreStateMachine::getQueue Sep 28 22:12:54 volumio volumio[741]: info: CorePlayQueue::getQueue Sep 28 22:12:54 volumio sudo[1886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 28 22:12:54 volumio sudo[1886]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 28 22:12:54 volumio sudo[1886]: pam_unix(sudo:session): session closed for user root Sep 28 22:12:55 volumio volumio[741]: error: error Sep 28 22:12:55 volumio volumio[741]: error: error Sep 28 22:12:55 volumio volumio[741]: error: error Sep 28 22:13:03 volumio volumio[741]: info: CALLMETHOD: system_controller system sendBugReport [object Object] Sep 28 22:13:03 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , sendBugReport Sep 28 22:13:03 volumio sudo[1984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl -p 7 Sep 28 22:13:03 volumio sudo[1984]: pam_unix(sudo:session): session opened for user root by (uid=0)