How to start service after wifi is connected on BeagleBone Green? After=network-online.target doesn't work

I am developing an animation server for LEDs in a bookshelf using a BeagleBone Green and a python app based on pygame. It receives input from motion-detection hardware using mosquitto/mqtt and sends output to a WLED-powered esp8266 via wifi, so wifi needs to be up before my service starts.

I set my service to start After=network-online.target because “googling stackoverflow” indicated so and it seems that would be the standard.

Still, it starts as soon as network is available, which is too early as wifi is not up and name resolution doesn’t work.

How to setup a systemd service definition so that the service starts after wifi connection is established on BeagleBone Green?

I tried the following creative solutions without success:

  • Googling for hours
  • Adding After=basic.target as that target seemed promising
  • Trying Type=idle after reading Beaglebone Debian/jessie autoinit script
  • Adding Restart=on-failure and RestartSec=10s is a lame workaround for this problem but will help me for others in the future, so I will leave it in

My service definition

debian@beaglebone:~$ systemctl cat bsw-ani.service
# /etc/systemd/system/bsw-ani.service
[Unit]
Description=BookshelfWall Animation using LEDs and pygame
Documentation=https://github.com/leobard/bookshelfwall
Requires=mosquitto.service
Requires=network-online.target
After=network-online.target
After=mosquitto.service

[Service]
Type=idle
WorkingDirectory=/opt/bsw-animation/
ExecStart=/usr/bin/python3 -m bookshelfwall.main -c /etc/bookshelfwall/bookshelfwall.ini
User=debian
KillMode=process
Restart=on-failure
RestartSec=10s

[Install]
WantedBy=multi-user.target

The output of journalctl shows that my bsw-ani service (also known as Bookshelfwall in the log file) is started multiple times, runs into socket.gaierror: [Errno -3] Temporary failure in name resolution, is restarted until successful start.

-- Logs begin at Sun 2021-05-16 10:17:36 UTC, end at Sun 2021-05-16 10:19:34 UTC. --
May 16 10:17:36 beaglebone kernel: Booting Linux on physical CPU 0x0
May 16 10:17:36 beaglebone kernel: Linux version 4.19.94-ti-r42 (voodoo@x3-am57xx-beagle-x15-2gb) (gcc version 8.3.0 (Debian 8.3.0-6)) #1buster SMP PREEMPT Tue Mar 31 19:38:29 UTC 2020
May 16 10:17:36 beaglebone kernel: CPU: ARMv7 Processor [413fc082] revision 2 (ARMv7), cr=10c5387d
May 16 10:17:36 beaglebone kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
May 16 10:17:36 beaglebone kernel: OF: fdt: Machine model: TI AM335x BeagleBone Green Wireless
May 16 10:17:36 beaglebone kernel: Memory policy: Data cache writeback
May 16 10:17:36 beaglebone kernel: cma: Reserved 48 MiB at 0x9c800000
May 16 10:17:36 beaglebone kernel: On node 0 totalpages: 130560
May 16 10:17:36 beaglebone kernel:   Normal zone: 1148 pages used for memmap
May 16 10:17:36 beaglebone kernel:   Normal zone: 0 pages reserved
May 16 10:17:36 beaglebone kernel:   Normal zone: 130560 pages, LIFO batch:31
May 16 10:17:36 beaglebone kernel: CPU: All CPU(s) started in SVC mode.
May 16 10:17:36 beaglebone kernel: AM335X ES2.1 (sgx neon)
May 16 10:17:36 beaglebone kernel: random: get_random_bytes called from start_kernel+0xac/0x4b4 with crng_init=0
May 16 10:17:36 beaglebone kernel: percpu: Embedded 17 pages/cpu s38988 r8192 d22452 u69632
May 16 10:17:36 beaglebone kernel: pcpu-alloc: s38988 r8192 d22452 u69632 alloc=17*4096
May 16 10:17:36 beaglebone kernel: pcpu-alloc: [0] 0 
May 16 10:17:36 beaglebone kernel: Built 1 zonelists, mobility grouping on.  Total pages: 129412
May 16 10:17:36 beaglebone kernel: Kernel command line: console=ttyO0,115200n8 bone_capemgr.uboot_capemgr_enabled=1 root=/dev/mmcblk1p1 ro rootfstype=ext4 rootwait coherent_pool=1M net.ifnames=0 lpj=1990656 rng_core.default_quality=100 quiet
May 16 10:17:36 beaglebone kernel: Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
May 16 10:17:36 beaglebone kernel: Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
May 16 10:17:36 beaglebone kernel: Memory: 437984K/522240K available (13312K kernel code, 1136K rwdata, 4308K rodata, 1024K init, 350K bss, 35104K reserved, 49152K cma-reserved, 0K highmem)
May 16 10:17:36 beaglebone kernel: Virtual kernel memory layout:
                                       vector  : 0xffff0000 - 0xffff1000   (   4 kB)
                                       fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
                                       vmalloc : 0xe0000000 - 0xff800000   ( 504 MB)
                                       lowmem  : 0xc0000000 - 0xdfe00000   ( 510 MB)
                                       pkmap   : 0xbfe00000 - 0xc0000000   (   2 MB)
                                       modules : 0xbf000000 - 0xbfe00000   (  14 MB)
                                         .text : 0x(ptrval) - 0x(ptrval)   (14304 kB)
                                         .init : 0x(ptrval) - 0x(ptrval)   (1024 kB)
                                         .data : 0x(ptrval) - 0x(ptrval)   (1137 kB)
                                          .bss : 0x(ptrval) - 0x(ptrval)   ( 351 kB)
May 16 10:17:36 beaglebone kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
May 16 10:17:36 beaglebone kernel: ftrace: allocating 42043 entries in 124 pages
May 16 10:17:36 beaglebone kernel: rcu: Preemptible hierarchical RCU implementation.
May 16 10:17:36 beaglebone kernel: rcu:         RCU restricting CPUs from NR_CPUS=2 to nr_cpu_ids=1.
May 16 10:17:36 beaglebone kernel:         Tasks RCU enabled.
May 16 10:17:36 beaglebone kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
May 16 10:17:36 beaglebone kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
May 16 10:17:36 beaglebone kernel: IRQ: Found an INTC at 0x(ptrval) (revision 5.0) with 128 interrupts
May 16 10:17:36 beaglebone kernel: OMAP clockevent source: timer2 at 24000000 Hz
May 16 10:17:36 beaglebone kernel: sched_clock: 32 bits at 24MHz, resolution 41ns, wraps every 89478484971ns
May 16 10:17:36 beaglebone kernel: clocksource: timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 79635851949 ns
May 16 10:17:36 beaglebone kernel: OMAP clocksource: timer1 at 24000000 Hz
May 16 10:17:36 beaglebone kernel: timer_probe: no matching timers found
May 16 10:17:36 beaglebone kernel: Console: colour dummy device 80x30
May 16 10:17:36 beaglebone kernel: WARNING: Your 'console=ttyO0' has been replaced by 'ttyS0'
May 16 10:17:36 beaglebone kernel: This ensures that you still see kernel messages. Please
May 16 10:17:36 beaglebone kernel: update your kernel commandline.
May 16 10:17:36 beaglebone kernel: Calibrating delay loop (skipped) preset value.. 995.32 BogoMIPS (lpj=1990656)
May 16 10:17:36 beaglebone kernel: pid_max: default: 32768 minimum: 301
May 16 10:17:36 beaglebone kernel: Security Framework initialized
May 16 10:17:36 beaglebone kernel: Yama: becoming mindful.
May 16 10:17:36 beaglebone kernel: AppArmor: AppArmor initialized
May 16 10:17:36 beaglebone kernel: Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
May 16 10:17:36 beaglebone kernel: Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
May 16 10:17:36 beaglebone kernel: CPU: Testing write buffer coherency: ok
May 16 10:17:36 beaglebone kernel: CPU0: Spectre v2: using BPIALL workaround
May 16 10:17:36 beaglebone kernel: CPU0: thread -1, cpu 0, socket -1, mpidr 0
May 16 10:17:36 beaglebone kernel: Setting up static identity map for 0x80100000 - 0x80100060
May 16 10:17:36 beaglebone kernel: rcu: Hierarchical SRCU implementation.
May 16 10:17:36 beaglebone kernel: smp: Bringing up secondary CPUs ...
May 16 10:17:36 beaglebone kernel: smp: Brought up 1 node, 1 CPU
May 16 10:17:36 beaglebone kernel: SMP: Total of 1 processors activated (995.32 BogoMIPS).
May 16 10:17:36 beaglebone kernel: CPU: All CPU(s) started in SVC mode.
May 16 10:17:36 beaglebone kernel: devtmpfs: initialized
May 16 10:17:36 beaglebone kernel: VFP support v0.3: implementor 41 architecture 3 part 30 variant c rev 3
May 16 10:17:36 beaglebone kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
May 16 10:17:36 beaglebone kernel: futex hash table entries: 256 (order: 2, 16384 bytes)
May 16 10:17:36 beaglebone kernel: xor: automatically using best checksumming function   neon      
May 16 10:17:36 beaglebone kernel: pinctrl core: initialized pinctrl subsystem
May 16 10:17:36 beaglebone kernel: NET: Registered protocol family 16
May 16 10:17:36 beaglebone kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations
May 16 10:17:36 beaglebone kernel: l4_wkup_cm:clk:0010:0: failed to disable
May 16 10:17:36 beaglebone kernel: audit: initializing netlink subsys (disabled)
May 16 10:17:36 beaglebone kernel: audit: type=2000 audit(0.224:1): state=initialized audit_enabled=0 res=1
May 16 10:17:36 beaglebone kernel: OMAP GPIO hardware version 0.1
May 16 10:17:36 beaglebone kernel: GPIO line 61 (LS_BUF_EN) hogged as output/high
May 16 10:17:36 beaglebone kernel: GPIO line 112 (MCASP0_AHCLKR) hogged as output/low
May 16 10:17:36 beaglebone kernel: hw-breakpoint: debug architecture 0x4 unsupported.
May 16 10:17:36 beaglebone kernel: raid6: using algorithm neonx8 gen() 0 MB/s
May 16 10:17:36 beaglebone kernel: raid6: .... xor() 0 MB/s, rmw enabled
May 16 10:17:36 beaglebone kernel: raid6: using neon recovery algorithm
May 16 10:17:36 beaglebone kernel: edma 49000000.edma: TI EDMA DMA engine driver
May 16 10:17:36 beaglebone kernel: SCSI subsystem initialized
May 16 10:17:36 beaglebone kernel: libata version 3.00 loaded.
May 16 10:17:36 beaglebone kernel: usbcore: registered new interface driver usbfs
May 16 10:17:36 beaglebone kernel: usbcore: registered new interface driver hub
May 16 10:17:36 beaglebone kernel: usbcore: registered new device driver usb
May 16 10:17:36 beaglebone kernel: omap_i2c 4802a000.i2c: bus 1 rev0.11 at 100 kHz
May 16 10:17:36 beaglebone kernel: omap_i2c 4819c000.i2c: bus 2 rev0.11 at 100 kHz
May 16 10:17:36 beaglebone kernel: pps_core: LinuxPPS API ver. 1 registered
May 16 10:17:36 beaglebone kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
May 16 10:17:36 beaglebone kernel: PTP clock support registered
May 16 10:17:36 beaglebone kernel: omap-mailbox 480c8000.mailbox: omap mailbox rev 0x400
May 16 10:17:36 beaglebone kernel: Advanced Linux Sound Architecture Driver Initialized.
May 16 10:17:36 beaglebone kernel: NetLabel: Initializing
May 16 10:17:36 beaglebone kernel: NetLabel:  domain hash size = 128
May 16 10:17:36 beaglebone kernel: NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
May 16 10:17:36 beaglebone kernel: NetLabel:  unlabeled traffic allowed by default
May 16 10:17:36 beaglebone kernel: clocksource: Switched to clocksource timer1
May 16 10:17:36 beaglebone kernel: VFS: Disk quotas dquot_6.6.0
May 16 10:17:36 beaglebone kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
May 16 10:17:36 beaglebone kernel: AppArmor: AppArmor Filesystem Enabled
May 16 10:17:36 beaglebone kernel: NET: Registered protocol family 2
May 16 10:17:36 beaglebone kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes)
May 16 10:17:36 beaglebone kernel: TCP established hash table entries: 4096 (order: 2, 16384 bytes)
May 16 10:17:36 beaglebone kernel: TCP bind hash table entries: 4096 (order: 3, 32768 bytes)
May 16 10:17:36 beaglebone kernel: TCP: Hash tables configured (established 4096 bind 4096)
May 16 10:17:36 beaglebone kernel: UDP hash table entries: 256 (order: 1, 8192 bytes)
May 16 10:17:36 beaglebone kernel: UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
May 16 10:17:36 beaglebone kernel: NET: Registered protocol family 1
May 16 10:17:36 beaglebone kernel: RPC: Registered named UNIX socket transport module.
May 16 10:17:36 beaglebone kernel: RPC: Registered udp transport module.
May 16 10:17:36 beaglebone kernel: RPC: Registered tcp transport module.
May 16 10:17:36 beaglebone kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
May 16 10:17:36 beaglebone kernel: Unpacking initramfs...
May 16 10:17:36 beaglebone kernel: Freeing initrd memory: 6884K
May 16 10:17:36 beaglebone kernel: hw perfevents: enabled with armv7_cortex_a8 PMU driver, 5 counters available
May 16 10:17:36 beaglebone kernel: Initialise system trusted keyrings
May 16 10:17:36 beaglebone kernel: workingset: timestamp_bits=14 max_order=17 bucket_order=3
May 16 10:17:36 beaglebone kernel: zbud: loaded
May 16 10:17:36 beaglebone kernel: NFS: Registering the id_resolver key type
May 16 10:17:36 beaglebone kernel: Key type id_resolver registered
May 16 10:17:36 beaglebone kernel: Key type id_legacy registered
May 16 10:17:36 beaglebone kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
May 16 10:17:36 beaglebone kernel: fuse init (API version 7.27)
May 16 10:17:36 beaglebone kernel: Key type asymmetric registered
May 16 10:17:36 beaglebone kernel: Asymmetric key parser 'x509' registered
May 16 10:17:36 beaglebone kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246)
May 16 10:17:36 beaglebone kernel: io scheduler noop registered
May 16 10:17:36 beaglebone kernel: io scheduler deadline registered
May 16 10:17:36 beaglebone kernel: io scheduler cfq registered (default)
May 16 10:17:36 beaglebone kernel: io scheduler mq-deadline registered
May 16 10:17:36 beaglebone kernel: pinctrl-single 44e10800.pinmux: 142 pins, size 568
May 16 10:17:36 beaglebone kernel: gpio-of-helper ocp:cape-universal: ready
May 16 10:17:36 beaglebone kernel: Serial: 8250/16550 driver, 6 ports, IRQ sharing disabled
May 16 10:17:36 beaglebone kernel: 44e09000.serial: ttyS0 at MMIO 0x44e09000 (irq = 30, base_baud = 3000000) is a 8250
May 16 10:17:36 beaglebone kernel: console [ttyS0] enabled
May 16 10:17:36 beaglebone kernel: 48022000.serial: ttyS1 at MMIO 0x48022000 (irq = 31, base_baud = 3000000) is a 8250
May 16 10:17:36 beaglebone kernel: 48024000.serial: ttyS2 at MMIO 0x48024000 (irq = 32, base_baud = 3000000) is a 8250
May 16 10:17:36 beaglebone kernel: 481a6000.serial: ttyS3 at MMIO 0x481a6000 (irq = 33, base_baud = 3000000) is a 8250
May 16 10:17:36 beaglebone kernel: 481a8000.serial: ttyS4 at MMIO 0x481a8000 (irq = 34, base_baud = 3000000) is a 8250
May 16 10:17:36 beaglebone kernel: 481aa000.serial: ttyS5 at MMIO 0x481aa000 (irq = 35, base_baud = 3000000) is a 8250
May 16 10:17:36 beaglebone kernel: omap_rng 48310000.rng: Random Number Generator ver. 20
May 16 10:17:36 beaglebone kernel: sdhci: Secure Digital Host Controller Interface driver
May 16 10:17:36 beaglebone kernel: sdhci: Copyright(c) Pierre Ossman
May 16 10:17:36 beaglebone kernel: omap_gpio 44e07000.gpio: Could not set line 6 debounce to 200000 microseconds (-22)
May 16 10:17:36 beaglebone kernel: omap_hsmmc 48060000.mmc: Got CD GPIO
May 16 10:17:36 beaglebone kernel: omap_hsmmc 48060000.mmc: Linked as a consumer to regulator.2
May 16 10:17:36 beaglebone kernel: random: fast init done
May 16 10:17:36 beaglebone kernel: random: crng init done
May 16 10:17:36 beaglebone kernel: omap_hsmmc 481d8000.mmc: Linked as a consumer to regulator.2
May 16 10:17:36 beaglebone kernel: omap_hsmmc 47810000.mmc: Linked as a consumer to regulator.1
May 16 10:17:36 beaglebone kernel: mmc1: new high speed MMC card at address 0001
May 16 10:17:36 beaglebone kernel: mmcblk1: mmc1:0001 Q2J54A 3.64 GiB 
May 16 10:17:36 beaglebone kernel: mmcblk1boot0: mmc1:0001 Q2J54A partition 1 2.00 MiB
May 16 10:17:36 beaglebone kernel: mmcblk1boot1: mmc1:0001 Q2J54A partition 2 2.00 MiB
May 16 10:17:36 beaglebone kernel: mmcblk1rpmb: mmc1:0001 Q2J54A partition 3 512 KiB, chardev (245:0)
May 16 10:17:36 beaglebone kernel:  mmcblk1: p1
May 16 10:17:36 beaglebone kernel: sdhci-pltfm: SDHCI platform and OF driver helper
May 16 10:17:36 beaglebone kernel: omap_hsmmc 47810000.mmc: card claims to support voltages below defined range
May 16 10:17:36 beaglebone kernel: mmc2: new high speed SDIO card at address 0001
May 16 10:17:36 beaglebone kernel: eqep 48300180.eqep: ver. 1.0
May 16 10:17:36 beaglebone kernel: eqep 48300180.eqep: count_mode:0
May 16 10:17:36 beaglebone kernel: eqep 48300180.eqep: invert_qa:1
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: invert_qb:1
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: invert_qi:0
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: invert_qs:0
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: swap_inputs:0
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: QDECCTL:0x0180
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: QPOSINIT:0x00000000
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: QPOSMAX:0xffffffff
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: QPOSCNT:0x00000000
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: omit_interrupt:0
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: QEINT:0x0800
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: QUPRD:0x05f5e100
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: QEPCTL:0x009e write
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: QEPCTL:0x009e read
May 16 10:17:37 beaglebone kernel: eqep 48300180.eqep: irq:128, clk_rate:100000000
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: ver. 1.0
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: count_mode:0
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: invert_qa:1
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: invert_qb:1
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: invert_qi:0
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: invert_qs:0
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: swap_inputs:0
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: QDECCTL:0x0180
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: QPOSINIT:0x00000000
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: QPOSMAX:0xffffffff
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: QPOSCNT:0x00000000
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: omit_interrupt:0
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: QEINT:0x0800
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: QUPRD:0x05f5e100
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: QEPCTL:0x009e write
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: QEPCTL:0x009e read
May 16 10:17:37 beaglebone kernel: eqep 48302180.eqep: irq:130, clk_rate:100000000
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: ver. 1.0
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: count_mode:0
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: invert_qa:1
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: invert_qb:1
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: invert_qi:0
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: invert_qs:0
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: swap_inputs:0
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: QDECCTL:0x0180
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: QPOSINIT:0x00000000
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: QPOSMAX:0xffffffff
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: QPOSCNT:0x00000000
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: omit_interrupt:0
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: QEINT:0x0800
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: QUPRD:0x05f5e100
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: QEPCTL:0x009e write
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: QEPCTL:0x009e read
May 16 10:17:37 beaglebone kernel: eqep 48304180.eqep: irq:132, clk_rate:100000000
May 16 10:17:37 beaglebone kernel: libphy: Fixed MDIO Bus: probed
May 16 10:17:37 beaglebone kernel: CAN device driver interface
May 16 10:17:37 beaglebone kernel: c_can_platform 481cc000.can: c_can_platform device registered (regs=a33d372e, irq=43)
May 16 10:17:37 beaglebone kernel: c_can_platform 481d0000.can: c_can_platform device registered (regs=76d6967c, irq=44)
May 16 10:17:37 beaglebone kernel: usbcore: registered new interface driver smsc95xx
May 16 10:17:37 beaglebone kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
May 16 10:17:37 beaglebone kernel: ehci-platform: EHCI generic platform driver
May 16 10:17:37 beaglebone kernel: ehci-omap: OMAP-EHCI Host Controller driver
May 16 10:17:37 beaglebone kernel: usbcore: registered new interface driver usb-storage
May 16 10:17:37 beaglebone kernel: am335x-phy-driver 47401300.usb-phy: 47401300.usb-phy supply vcc not found, using dummy regulator
May 16 10:17:37 beaglebone kernel: am335x-phy-driver 47401300.usb-phy: Linked as a consumer to regulator.0
May 16 10:17:37 beaglebone kernel: am335x-phy-driver 47401b00.usb-phy: 47401b00.usb-phy supply vcc not found, using dummy regulator
May 16 10:17:37 beaglebone kernel: am335x-phy-driver 47401b00.usb-phy: Linked as a consumer to regulator.0
May 16 10:17:37 beaglebone kernel: musb-hdrc musb-hdrc.1: MUSB HDRC host driver
May 16 10:17:37 beaglebone kernel: musb-hdrc musb-hdrc.1: new USB bus registered, assigned bus number 1
May 16 10:17:37 beaglebone kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
May 16 10:17:37 beaglebone kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
May 16 10:17:37 beaglebone kernel: usb usb1: Product: MUSB HDRC host driver
May 16 10:17:37 beaglebone kernel: usb usb1: Manufacturer: Linux 4.19.94-ti-r42 musb-hcd
May 16 10:17:37 beaglebone kernel: usb usb1: SerialNumber: musb-hdrc.1
May 16 10:17:37 beaglebone kernel: hub 1-0:1.0: USB hub found
May 16 10:17:37 beaglebone kernel: hub 1-0:1.0: 1 port detected
May 16 10:17:37 beaglebone kernel: omap_rtc 44e3e000.rtc: already running
May 16 10:17:37 beaglebone kernel: omap_rtc 44e3e000.rtc: registered as rtc0
May 16 10:17:37 beaglebone kernel: i2c /dev entries driver
May 16 10:17:37 beaglebone kernel: omap_wdt: OMAP Watchdog Timer Rev 0x01: initial timeout 60 sec
May 16 10:17:37 beaglebone kernel: softdog: initialized. soft_noboot=0 soft_margin=60 sec soft_panic=0 (nowayout=0)
May 16 10:17:37 beaglebone kernel: ledtrig-cpu: registered to indicate activity on CPUs
May 16 10:17:37 beaglebone kernel: omap-aes 53500000.aes: OMAP AES hw accel rev: 3.2
May 16 10:17:37 beaglebone kernel: omap-aes 53500000.aes: will run requests pump with realtime priority
May 16 10:17:37 beaglebone kernel: omap-sham 53100000.sham: hw accel on OMAP rev 4.3
May 16 10:17:37 beaglebone kernel: hidraw: raw HID events driver (C) Jiri Kosina
May 16 10:17:37 beaglebone kernel: gnss: GNSS driver registered with major 242
May 16 10:17:37 beaglebone kernel: NET: Registered protocol family 10
May 16 10:17:37 beaglebone kernel: Segment Routing with IPv6
May 16 10:17:37 beaglebone kernel: mip6: Mobile IPv6
May 16 10:17:37 beaglebone kernel: NET: Registered protocol family 17
May 16 10:17:37 beaglebone kernel: can: controller area network core (rev 20170425 abi 9)
May 16 10:17:37 beaglebone kernel: NET: Registered protocol family 29
May 16 10:17:37 beaglebone kernel: 8021q: 802.1Q VLAN Support v1.8
May 16 10:17:37 beaglebone kernel: Key type dns_resolver registered
May 16 10:17:37 beaglebone kernel: mpls_gso: MPLS GSO support
May 16 10:17:37 beaglebone kernel: ThumbEE CPU extension supported.
May 16 10:17:37 beaglebone kernel: Registering SWP/SWPB emulation handler
May 16 10:17:37 beaglebone kernel: omap_voltage_late_init: Voltage driver support not added
May 16 10:17:37 beaglebone kernel: registered taskstats version 1
May 16 10:17:37 beaglebone kernel: Loading compiled-in X.509 certificates
May 16 10:17:37 beaglebone kernel: zswap: loaded using pool lzo/zbud
May 16 10:17:37 beaglebone kernel: Btrfs loaded, crc32c=crc32c-generic
May 16 10:17:37 beaglebone kernel: AppArmor: AppArmor sha1 policy hashing enabled
May 16 10:17:37 beaglebone kernel: tps6521x_pwrbutton tps65217-pwrbutton: DMA mask not set
May 16 10:17:37 beaglebone kernel: input: tps65217_pwr_but as /devices/platform/ocp/44e0b000.i2c/i2c-0/0-0024/tps65217-pwrbutton/input/input0
May 16 10:17:37 beaglebone kernel: tps65217 0-0024: TPS65217 ID 0xe version 1.2
May 16 10:17:37 beaglebone kernel: at24 0-0050: 32768 byte 24c256 EEPROM, writable, 1 bytes/write
May 16 10:17:37 beaglebone kernel: omap_i2c 44e0b000.i2c: bus 0 rev0.11 at 400 kHz
May 16 10:17:37 beaglebone kernel: cpu cpu0: Linked as a consumer to regulator.4
May 16 10:17:37 beaglebone kernel: cpu cpu0: Dropping the link to regulator.4
May 16 10:17:37 beaglebone kernel: cpu cpu0: Linked as a consumer to regulator.4
May 16 10:17:37 beaglebone kernel: omap_rtc 44e3e000.rtc: setting system clock to 2021-05-16 10:17:26 UTC (1621160246)
May 16 10:17:37 beaglebone kernel: ALSA device list:
May 16 10:17:37 beaglebone kernel:   No soundcards found.
May 16 10:17:37 beaglebone kernel: Freeing unused kernel memory: 1024K
May 16 10:17:37 beaglebone kernel: Run /init as init process
May 16 10:17:37 beaglebone kernel: usb 1-1: new high-speed USB device number 2 using musb-hdrc
May 16 10:17:37 beaglebone kernel: usb 1-1: New USB device found, idVendor=05e3, idProduct=0610, bcdDevice=32.98
May 16 10:17:37 beaglebone kernel: usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
May 16 10:17:37 beaglebone kernel: usb 1-1: Product: USB2.0 Hub
May 16 10:17:37 beaglebone kernel: hub 1-1:1.0: USB hub found
May 16 10:17:37 beaglebone kernel: hub 1-1:1.0: 4 ports detected
May 16 10:17:37 beaglebone kernel: usb 1-1.3: new high-speed USB device number 3 using musb-hdrc
May 16 10:17:37 beaglebone kernel: usb 1-1.3: New USB device found, idVendor=1307, idProduct=0165, bcdDevice= 1.00
May 16 10:17:37 beaglebone kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
May 16 10:17:37 beaglebone kernel: usb 1-1.3: Product: USB Mass Storage Device
May 16 10:17:37 beaglebone kernel: usb 1-1.3: Manufacturer: P Technology
May 16 10:17:37 beaglebone kernel: usb 1-1.3: SerialNumber: 000000000002C0
May 16 10:17:37 beaglebone kernel: usb-storage 1-1.3:1.0: USB Mass Storage device detected
May 16 10:17:37 beaglebone kernel: scsi host0: usb-storage 1-1.3:1.0
May 16 10:17:37 beaglebone kernel: usbcore: registered new interface driver uas
May 16 10:17:37 beaglebone kernel: scsi 0:0:0:0: Direct-Access     UT165    USB Flash Disk   0.00 PQ: 0 ANSI: 2
May 16 10:17:37 beaglebone kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0
May 16 10:17:37 beaglebone kernel: sd 0:0:0:0: [sda] 1974272 512-byte logical blocks: (1.01 GB/964 MiB)
May 16 10:17:37 beaglebone kernel: sd 0:0:0:0: [sda] Write Protect is off
May 16 10:17:37 beaglebone kernel: sd 0:0:0:0: [sda] Mode Sense: 00 00 00 00
May 16 10:17:37 beaglebone kernel: sd 0:0:0:0: [sda] Asking for cache data failed
May 16 10:17:37 beaglebone kernel: sd 0:0:0:0: [sda] Assuming drive cache: write through
May 16 10:17:37 beaglebone kernel:  sda:
May 16 10:17:37 beaglebone kernel: sd 0:0:0:0: [sda] Attached SCSI removable disk
May 16 10:17:37 beaglebone kernel: EXT4-fs (mmcblk1p1): mounted filesystem with ordered data mode. Opts: (null)
May 16 10:17:37 beaglebone systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
May 16 10:17:37 beaglebone systemd[1]: Detected architecture arm.
May 16 10:17:37 beaglebone systemd[1]: Set hostname to <beaglebone>.
May 16 10:17:37 beaglebone systemd[1]: /lib/systemd/system/rc_battery_monitor.service:5: PIDFile= references path below legacy directory /var/run/, updating /var/run/rc_battery_monitor.pid → /run/rc_battery_monitor.pid; please update the unit file accordingly.
May 16 10:17:37 beaglebone systemd[1]: Listening on udev Control Socket.
May 16 10:17:37 beaglebone systemd[1]: Listening on initctl Compatibility Named Pipe.
May 16 10:17:37 beaglebone systemd[1]: Listening on Syslog Socket.
May 16 10:17:37 beaglebone systemd[1]: Created slice system-getty.slice.
May 16 10:17:37 beaglebone systemd[1]: Listening on udev Kernel Socket.
May 16 10:17:37 beaglebone systemd[1]: Reached target Swap.
May 16 10:17:37 beaglebone kernel: EXT4-fs (mmcblk1p1): re-mounted. Opts: errors=remount-ro
May 16 10:17:37 beaglebone kernel: remoteproc remoteproc0: 4a334000.pru is available
May 16 10:17:37 beaglebone kernel: pru-rproc 4a334000.pru: PRU rproc node pru@4a334000 probed successfully
May 16 10:17:37 beaglebone kernel: remoteproc remoteproc1: 4a338000.pru is available
May 16 10:17:37 beaglebone kernel: pru-rproc 4a338000.pru: PRU rproc node pru@4a338000 probed successfully
May 16 10:17:37 beaglebone systemd-journald[675]: Journal started
May 16 10:17:37 beaglebone systemd-journald[675]: Runtime journal (/run/log/journal/506fc39436539d3f9c403ffd5e8b2e48) is 620.0K, max 4.8M, 4.2M free.
May 16 10:17:36 beaglebone systemd-modules-load[677]: Module 'pwm_tiehrpwm' is builtin
May 16 10:17:36 beaglebone systemd-modules-load[677]: Module 'tieqep' is builtin
May 16 10:17:37 beaglebone systemd-modules-load[677]: Inserted module 'pru_rproc'
May 16 10:17:37 beaglebone fake-hwclock[667]: Current system time: 2021-05-16 10:17:36
May 16 10:17:37 beaglebone fake-hwclock[667]: fake-hwclock saved clock information is in the past: 2021-05-16 10:17:18
May 16 10:17:37 beaglebone fake-hwclock[667]: To set system time to this saved clock anyway, use "force"
May 16 10:17:37 beaglebone systemd-modules-load[677]: Inserted module 'pruss_soc_bus'
May 16 10:17:37 beaglebone systemd-udevd[686]: Network interface NamePolicy= disabled on kernel command line, ignoring.
May 16 10:17:37 beaglebone systemd[1]: Starting Flush Journal to Persistent Storage...
May 16 10:17:38 beaglebone systemd[1]: Started udev Kernel Device Manager.
May 16 10:17:38 beaglebone systemd-journald[675]: Runtime journal (/run/log/journal/506fc39436539d3f9c403ffd5e8b2e48) is 620.0K, max 4.8M, 4.2M free.
May 16 10:17:38 beaglebone systemd[1]: Started Flush Journal to Persistent Storage.
May 16 10:17:38 beaglebone systemd[1]: Starting Create Volatile Files and Directories...
May 16 10:17:38 beaglebone systemd[1]: Started Create Volatile Files and Directories.
May 16 10:17:38 beaglebone systemd[1]: Started Entropy daemon using the HAVEGE algorithm.
May 16 10:17:38 beaglebone systemd[1]: Starting Update UTMP about System Boot/Shutdown...
May 16 10:17:39 beaglebone systemd[1]: Starting Network Time Synchronization...
May 16 10:17:39 beaglebone systemd[1]: Started Update UTMP about System Boot/Shutdown.
May 16 10:17:39 beaglebone systemd[1]: Started udev Coldplug all Devices.
May 16 10:17:39 beaglebone systemd[1]: Starting Helper to synchronize boot up for ifupdown...
May 16 10:17:39 beaglebone systemd[1]: Started Helper to synchronize boot up for ifupdown.
May 16 10:17:39 beaglebone systemd[1]: Starting Raise network interfaces...
May 16 10:17:40 beaglebone systemd[1]: Started Network Time Synchronization.
May 16 10:17:40 beaglebone systemd[1]: Reached target System Initialization.
May 16 10:17:40 beaglebone systemd[1]: Listening on Node-RED Socket.
May 16 10:17:40 beaglebone systemd[1]: Listening on D-Bus System Message Bus Socket.
May 16 10:17:40 beaglebone systemd[1]: Started Daily Cleanup of Temporary Directories.
May 16 10:17:40 beaglebone systemd[1]: Listening on bonescript.socket.
May 16 10:17:40 beaglebone systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
May 16 10:17:40 beaglebone systemd[1]: Listening on Cloud9 Socket.
May 16 10:17:40 beaglebone systemd[1]: Reached target Sockets.
May 16 10:17:40 beaglebone systemd[1]: Reached target Basic System.
May 16 10:17:40 beaglebone systemd[1]: Started Bonescript autorun.
May 16 10:17:40 beaglebone systemd[1]: Starting Login Service...
May 16 10:17:40 beaglebone systemd[1]: Started D-Bus System Message Bus.
May 16 10:17:41 beaglebone systemd[1]: Starting Connection service...
May 16 10:17:41 beaglebone systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling...
May 16 10:17:41 beaglebone systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped.
May 16 10:17:41 beaglebone systemd[1]: Starting System Logging Service...
May 16 10:17:41 beaglebone systemd[1]: Starting rc_battery_monitor...
May 16 10:17:41 beaglebone systemd[1]: Starting BB WL18xx wlan0 Service...
May 16 10:17:41 beaglebone systemd-logind[730]: New seat seat0.
May 16 10:17:41 beaglebone systemd[1]: Starting Avahi mDNS/DNS-SD Stack...
May 16 10:17:42 beaglebone rsyslogd[743]: imuxsock: Acquired UNIX socket '/run/systemd/journal/syslog' (fd 3) from systemd.  [v8.1901.0]
May 16 10:17:42 beaglebone rsyslogd[743]:  [origin software="rsyslogd" swVersion="8.1901.0" x-pid="743" x-info="https://www.rsyslog.com"] start
May 16 10:17:42 beaglebone systemd[1]: Started Regular background program processing daemon.
May 16 10:17:42 beaglebone cron[753]: (CRON) INFO (pidfile fd = 3)
May 16 10:17:42 beaglebone systemd[1]: Starting WPA supplicant...
May 16 10:17:42 beaglebone cron[753]: (CRON) INFO (Running @reboot jobs)
May 16 10:17:42 beaglebone systemd[1]: Starting robotcontrol...
May 16 10:17:42 beaglebone systemd[1]: Reached target System Time Synchronized.
May 16 10:17:42 beaglebone systemd[1]: Started Daily rotation of log files.
May 16 10:17:42 beaglebone systemd[1]: Reached target Timers.
May 16 10:17:42 beaglebone avahi-daemon[750]: Found user 'avahi' (UID 107) and group 'avahi' (GID 115).
May 16 10:17:42 beaglebone systemd[1]: Started System Logging Service.
May 16 10:17:42 beaglebone connmand[737]: Connection Manager version 1.36
May 16 10:17:42 beaglebone systemd[1]: Started Raise network interfaces.
May 16 10:17:42 beaglebone systemd[1]: Started rc_battery_monitor.
May 16 10:17:42 beaglebone bb-wl18xx-wlan0[749]: wlan_0_mac=[00:00:00:00:00:00], this forces internal wl18xx mac address...
May 16 10:17:42 beaglebone wpa_supplicant[755]: Successfully initialized wpa_supplicant
May 16 10:17:43 beaglebone dbus-daemon[732]: [system] Successfully activated service 'org.freedesktop.systemd1'
May 16 10:17:43 beaglebone rc_startup_routine[760]: robotcontrol service can only run on BB Blue, Black, and Black wireless when the robotcontrol device tree is in use.
May 16 10:17:43 beaglebone systemd[1]: Started robotcontrol.
May 16 10:17:43 beaglebone systemd[783]: robotcontrol.service: Executable /etc/robotcontrol/link_to_startup_program missing, skipping: No such file or directory
May 16 10:17:43 beaglebone rc_battery_monitor[763]: rc_battery_monitor can only run on BB Blue, Black, and Black wireless when the roboticscape device tree is in use.
May 16 10:17:43 beaglebone rc_kill[791]: No existing robot control program is running.
May 16 10:17:43 beaglebone systemd[1]: robotcontrol.service: Succeeded.
May 16 10:17:43 beaglebone systemd[1]: rc_battery_monitor.service: Succeeded.
May 16 10:17:43 beaglebone avahi-daemon[750]: Successfully dropped root privileges.
May 16 10:17:43 beaglebone avahi-daemon[750]: avahi-daemon 0.7 starting up.
May 16 10:17:43 beaglebone systemd[1]: Started Login Service.
May 16 10:17:43 beaglebone systemd[1]: Started Connection service.
May 16 10:17:43 beaglebone systemd[1]: Started WPA supplicant.
May 16 10:17:43 beaglebone systemd[1]: Reached target Network.
May 16 10:17:43 beaglebone systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
May 16 10:17:43 beaglebone avahi-daemon[750]: Successfully called chroot().
May 16 10:17:43 beaglebone avahi-daemon[750]: Successfully dropped remaining capabilities.
May 16 10:17:43 beaglebone avahi-daemon[808]: chroot.c: open() failed: No such file or directory
May 16 10:17:43 beaglebone avahi-daemon[750]: Failed to open /etc/resolv.conf: Invalid argument
May 16 10:17:43 beaglebone avahi-daemon[750]: Loading service file /services/cloud9.service.
May 16 10:17:43 beaglebone avahi-daemon[750]: Loading service file /services/nodered.service.
May 16 10:17:44 beaglebone systemd[1]: Starting Generic Board Startup...
May 16 10:17:44 beaglebone avahi-daemon[750]: Network interface enumeration completed.
May 16 10:17:44 beaglebone avahi-daemon[750]: Server startup complete. Host name is beaglebone.local. Local service cookie is 3683701642.
May 16 10:17:44 beaglebone avahi-daemon[750]: Service "Node-RED for beaglebone" (/services/nodered.service) successfully established.
May 16 10:17:44 beaglebone avahi-daemon[750]: Service "Cloud9 IDE for beaglebone" (/services/cloud9.service) successfully established.
May 16 10:17:44 beaglebone sh[812]: generic-board-startup: start
May 16 10:17:44 beaglebone systemd[1]: Starting OpenBSD Secure Shell server...
May 16 10:17:44 beaglebone sh[812]: generic-board-startup: ssh
May 16 10:17:44 beaglebone sh[812]: generic-board-startup: efi
May 16 10:17:44 beaglebone sh[812]: generic-board-startup: gpio
May 16 10:17:44 beaglebone connmand[737]: Checking loopback interface settings
May 16 10:17:44 beaglebone connmand[737]: System hostname is beaglebone
May 16 10:17:44 beaglebone systemd[1]: Starting Permit User Sessions...
May 16 10:17:44 beaglebone bb-wl18xx-wlan0[749]: /lib/firmware/ti-connectivity/wl1271-nvs.bin=[00:00:00:00:00:00]
May 16 10:17:44 beaglebone systemd[1]: Starting A high performance web server and a reverse proxy server...
May 16 10:17:44 beaglebone systemd[1]: Reached target Network is Online.
May 16 10:17:44 beaglebone rfkill[834]: unblock set for all
May 16 10:17:44 beaglebone systemd[1]: Starting Mosquitto MQTT v3.1/v3.1.1 Broker...
May 16 10:17:44 beaglebone sh[812]: generic-board-startup: leds
May 16 10:17:44 beaglebone systemd[1]: Started Avahi mDNS/DNS-SD Stack.
May 16 10:17:45 beaglebone connmand[737]: lo {newlink} index 1 address 00:00:00:00:00:00 mtu 65536
May 16 10:17:45 beaglebone connmand[737]: lo {newlink} index 1 operstate 0 <UNKNOWN>
May 16 10:17:45 beaglebone connmand[737]: can0 {newlink} index 2 address 00:00:00:00:00:00 mtu 16
May 16 10:17:45 beaglebone connmand[737]: can0 {newlink} index 2 operstate 2 <DOWN>
May 16 10:17:45 beaglebone connmand[737]: can1 {newlink} index 3 address 00:00:00:00:00:00 mtu 16
May 16 10:17:45 beaglebone connmand[737]: can1 {newlink} index 3 operstate 2 <DOWN>
May 16 10:17:45 beaglebone connmand[737]: The name net.connman.vpn was not provided by any .service files
May 16 10:17:45 beaglebone dbus-daemon[732]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.3' (uid=0 pid=737 comm="/usr/sbin/connmand -n --nodnsproxy ")
May 16 10:17:45 beaglebone sh[812]: generic-board-startup: model
May 16 10:17:45 beaglebone sh[812]: generic-board-startup: [model=TI_AM335x_BeagleBone_Green_Wireless]
May 16 10:17:45 beaglebone sh[812]: generic-board-startup: [startup script=/opt/scripts/boot/am335x_evm.sh]
May 16 10:17:45 beaglebone systemd[1]: Started Permit User Sessions.
May 16 10:17:45 beaglebone loadcpufreq[741]: Loading cpufreq kernel modules...done (none).
May 16 10:17:45 beaglebone systemd[1]: Started Getty on tty1.
May 16 10:17:46 beaglebone systemd[1]: Starting Hostname Service...
May 16 10:17:46 beaglebone systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling.
May 16 10:17:46 beaglebone systemd[1]: Started Mosquitto MQTT v3.1/v3.1.1 Broker.
May 16 10:17:46 beaglebone sshd[855]: Server listening on 0.0.0.0 port 22.
May 16 10:17:46 beaglebone sshd[855]: Server listening on :: port 22.
May 16 10:17:46 beaglebone systemd[1]: Started OpenBSD Secure Shell server.
May 16 10:17:46 beaglebone systemd[1]: Started BookshelfWall Animation using LEDs and pygame.
May 16 10:17:46 beaglebone sh[812]: am335x_evm: usb_image_file=[/var/cache/doc-beaglebone-getting-started/beaglebone-getting-started-2019-10-31.img]
May 16 10:17:46 beaglebone systemd[1]: Starting LSB: set CPUFreq kernel parameters...
May 16 10:17:47 beaglebone cpufrequtils[883]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...done.
May 16 10:17:47 beaglebone systemd[1]: Started LSB: set CPUFreq kernel parameters.
May 16 10:17:48 beaglebone dbus-daemon[732]: [system] Successfully activated service 'org.freedesktop.hostname1'
May 16 10:17:48 beaglebone systemd[1]: Started Hostname Service.
May 16 10:17:48 beaglebone systemd[1]: Started A high performance web server and a reverse proxy server.
May 16 10:17:48 beaglebone sh[812]: bb_generate_mac.sh /etc/cpsw_0_mac: [0C:1C:57:06:C5:0D]
May 16 10:17:48 beaglebone sh[812]: bb_generate_mac.sh /etc/cpsw_1_mac: [0C:1C:57:06:C5:0F]
May 16 10:17:48 beaglebone sh[812]: bb_generate_mac.sh /etc/cpsw_2_mac: [0C:1C:57:06:C5:10]
May 16 10:17:48 beaglebone sh[812]: bb_generate_mac.sh /etc/cpsw_3_mac: [0C:1C:57:06:C5:11]
May 16 10:17:48 beaglebone sh[812]: bb_generate_mac.sh /etc/cpsw_4_mac: [0C:1C:57:06:C5:12]
May 16 10:17:48 beaglebone sh[812]: bb_generate_mac.sh /etc/cpsw_5_mac: [0C:1C:57:06:C5:13]
May 16 10:17:49 beaglebone sh[812]: am335x_evm: use_libcomposite
May 16 10:17:49 beaglebone sh[812]: am335x_evm: modprobe libcomposite
May 16 10:17:49 beaglebone sh[812]: am335x_evm: Creating g_multi
May 16 10:17:49 beaglebone kernel: using random self ethernet address
May 16 10:17:49 beaglebone kernel: using random host ethernet address
May 16 10:17:49 beaglebone sh[812]: /opt/scripts/boot/am335x_evm.sh: 440: echo: echo: I/O error
May 16 10:17:49 beaglebone sh[812]: am335x_evm: enable USB mass_storage /var/local/bb_usb_mass_storage.img
May 16 10:17:50 beaglebone kernel: Mass Storage Function, version: 2009/09/11
May 16 10:17:50 beaglebone kernel: LUN: removable file: (no medium)
May 16 10:17:50 beaglebone sh[812]: ln: failed to create symbolic link 'os_desc/c.1': File exists
May 16 10:17:50 beaglebone sh[812]: mkdir: cannot create directory ‘functions/rndis.usb0/os_desc/interface.rndis/Icons’: File exists
May 16 10:17:50 beaglebone sh[812]: mkdir: cannot create directory ‘functions/rndis.usb0/os_desc/interface.rndis/Label’: File exists
May 16 10:17:50 beaglebone sh[812]: ln: failed to create symbolic link 'configs/c.1/rndis.usb0': File exists
May 16 10:17:50 beaglebone kernel: using random self ethernet address
May 16 10:17:50 beaglebone kernel: using random host ethernet address
May 16 10:17:50 beaglebone connmand[737]: usb0 {create} index 4 type 1 <ETHER>
May 16 10:17:50 beaglebone connmand[737]: usb0 {update} flags 4098 <DOWN>
May 16 10:17:50 beaglebone connmand[737]: usb0 {newlink} index 4 address 00:00:00:00:00:00 mtu 1500
May 16 10:17:50 beaglebone connmand[737]: usb0 {newlink} index 4 operstate 2 <DOWN>
May 16 10:17:50 beaglebone kernel: usb0: HOST MAC 0c:1c:57:06:c5:10
May 16 10:17:50 beaglebone kernel: usb0: MAC 0c:1c:57:06:c5:0f
May 16 10:17:50 beaglebone connmand[737]: Ignoring interface usb0 (filtered)
May 16 10:17:50 beaglebone kernel: usb1: HOST MAC 0c:1c:57:06:c5:12
May 16 10:17:50 beaglebone kernel: usb1: MAC 0c:1c:57:06:c5:13
May 16 10:17:50 beaglebone connmand[737]: Adding interface usb0 [ gadget ]
May 16 10:17:50 beaglebone sh[812]: am335x_evm: g_multi Created
May 16 10:17:50 beaglebone sh[812]: am335x_evm: Starting usb0 network
May 16 10:17:50 beaglebone connmand[737]: usb0 {newlink} index 4 address 0C:1C:57:06:C5:0F mtu 1500
May 16 10:17:50 beaglebone connmand[737]: usb0 {newlink} index 4 operstate 2 <DOWN>
May 16 10:17:50 beaglebone connmand[737]: Ignoring interface usb0 (filtered)
May 16 10:17:50 beaglebone connmand[737]: usb1 {create} index 5 type 1 <ETHER>
May 16 10:17:50 beaglebone connmand[737]: usb1 {update} flags 4098 <DOWN>
May 16 10:17:50 beaglebone connmand[737]: usb1 {newlink} index 5 address 00:00:00:00:00:00 mtu 1500
May 16 10:17:50 beaglebone connmand[737]: usb1 {newlink} index 5 operstate 2 <DOWN>
May 16 10:17:50 beaglebone connmand[737]: Ignoring interface usb1 (filtered)
May 16 10:17:50 beaglebone connmand[737]: Adding interface usb1 [ gadget ]
May 16 10:17:50 beaglebone connmand[737]: usb1 {newlink} index 5 address 0C:1C:57:06:C5:13 mtu 1500
May 16 10:17:50 beaglebone connmand[737]: usb1 {newlink} index 5 operstate 2 <DOWN>
May 16 10:17:50 beaglebone connmand[737]: Ignoring interface usb1 (filtered)
May 16 10:17:51 beaglebone connmand[737]: usb0 {add} address 192.168.7.2/24 label usb0 family 2
May 16 10:17:51 beaglebone connmand[737]: usb0 {update} flags 4099 <UP>
May 16 10:17:51 beaglebone connmand[737]: usb0 {newlink} index 4 address 0C:1C:57:06:C5:0F mtu 1500
May 16 10:17:51 beaglebone connmand[737]: usb0 {newlink} index 4 operstate 2 <DOWN>
May 16 10:17:51 beaglebone connmand[737]: Ignoring interface usb0 (filtered)
May 16 10:17:51 beaglebone avahi-daemon[750]: Joining mDNS multicast group on interface usb0.IPv4 with address 192.168.7.2.
May 16 10:17:51 beaglebone kernel: IPv6: ADDRCONF(NETDEV_UP): usb0: link is not ready
May 16 10:17:51 beaglebone sh[812]: am335x_evm: Starting usb1 network
May 16 10:17:51 beaglebone connmand[737]: usb0 {add} route 192.168.7.0 gw 0.0.0.0 scope 253 <LINK>
May 16 10:17:51 beaglebone avahi-daemon[750]: New relevant interface usb0.IPv4 for mDNS.
May 16 10:17:51 beaglebone avahi-daemon[750]: Registering new address record for 192.168.7.2 on usb0.IPv4.
May 16 10:17:51 beaglebone connmand[737]: usb1 {add} address 192.168.6.2/24 label usb1 family 2
May 16 10:17:51 beaglebone connmand[737]: usb1 {update} flags 4163 <UP,RUNNING>
May 16 10:17:51 beaglebone connmand[737]: usb1 {newlink} index 5 address 0C:1C:57:06:C5:13 mtu 1500
May 16 10:17:51 beaglebone connmand[737]: usb1 {newlink} index 5 operstate 0 <UNKNOWN>
May 16 10:17:51 beaglebone connmand[737]: Ignoring interface usb1 (filtered)
May 16 10:17:51 beaglebone avahi-daemon[750]: Joining mDNS multicast group on interface usb1.IPv4 with address 192.168.6.2.
May 16 10:17:51 beaglebone kernel: IPv6: ADDRCONF(NETDEV_UP): usb1: link is not ready
May 16 10:17:51 beaglebone connmand[737]: usb1 {add} route 192.168.6.0 gw 0.0.0.0 scope 253 <LINK>
May 16 10:17:51 beaglebone avahi-daemon[750]: New relevant interface usb1.IPv4 for mDNS.
May 16 10:17:51 beaglebone avahi-daemon[750]: Registering new address record for 192.168.6.2 on usb1.IPv4.
May 16 10:17:51 beaglebone connmand[737]: usb1 {update} flags 4099 <UP>
May 16 10:17:51 beaglebone connmand[737]: usb1 {newlink} index 5 address 0C:1C:57:06:C5:13 mtu 1500
May 16 10:17:51 beaglebone connmand[737]: usb1 {newlink} index 5 operstate 2 <DOWN>
May 16 10:17:51 beaglebone connmand[737]: Ignoring interface usb1 (filtered)
May 16 10:17:52 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether waiting for /sys/class/net/wlan0
May 16 10:17:55 beaglebone systemd[1]: Found device /dev/ttyS0.
May 16 10:17:55 beaglebone systemd[1]: Started Serial Getty on ttyS0.
May 16 10:17:56 beaglebone haveged[698]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K
May 16 10:17:56 beaglebone haveged[698]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848
May 16 10:17:56 beaglebone haveged[698]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B):  last entropy estimate 8.00178
May 16 10:17:56 beaglebone haveged[698]: haveged: fills: 0, generated: 0
May 16 10:17:56 beaglebone kernel: wlan-en-regulator: disabling
May 16 10:17:57 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether waiting for /sys/class/net/wlan0
May 16 10:18:02 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether waiting for /sys/class/net/wlan0
May 16 10:18:02 beaglebone python3[877]: INFO:sacn:Bind sender thread to IP:0.0.0.0 Port:5568
May 16 10:18:02 beaglebone python3[877]: INFO:bookshelfwall.output.sacn:starting... . Dryrun: False
May 16 10:18:02 beaglebone python3[877]: INFO:sacn:Started sACN sending/sender thread
May 16 10:18:02 beaglebone python3[877]: INFO:bookshelfwall.output.sacn:initialized sender for host 192.168.1.14 universe 1
May 16 10:18:02 beaglebone python3[877]: INFO:bookshelfwall.output.sacn:initialized sender for host 192.168.1.15 universe 2
May 16 10:18:03 beaglebone python3[877]: ALSA lib pcm_dmix.c:1108:(snd_pcm_dmix_open) unable to open slave
May 16 10:18:03 beaglebone python3[877]: INFO:root:Initializing pygame: 5 successes and 1 failures.
May 16 10:18:03 beaglebone python3[877]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.black
May 16 10:18:03 beaglebone python3[877]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.motion
May 16 10:18:03 beaglebone python3[877]: INFO:bookshelfwall.input.mqttclient:Starting MQTT Client...
May 16 10:18:03 beaglebone python3[877]: ERROR:root:Exception in main loop
May 16 10:18:03 beaglebone python3[877]: Traceback (most recent call last):
May 16 10:18:03 beaglebone python3[877]:   File "/home/debian/BookshelfWall/bsw-animation/bookshelfwall/main.py", line 210, in <module>
May 16 10:18:03 beaglebone python3[877]:     animation1 = loadAnimation(config['bookshelfwall.animation']['animation1'])
May 16 10:18:03 beaglebone python3[877]:   File "/home/debian/BookshelfWall/bsw-animation/bookshelfwall/main.py", line 199, in loadAnimation
May 16 10:18:03 beaglebone python3[877]:     mqttglue.start()
May 16 10:18:03 beaglebone python3[877]:   File "/home/debian/BookshelfWall/bsw-animation/bookshelfwall/input/mqttclient.py", line 65, in start
May 16 10:18:03 beaglebone python3[877]:     self.mqttclient.connect(self.host)
May 16 10:18:03 beaglebone python3[877]:   File "/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py", line 941, in connect
May 16 10:18:03 beaglebone python3[877]:     return self.reconnect()
May 16 10:18:03 beaglebone python3[877]:   File "/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py", line 1075, in reconnect
May 16 10:18:03 beaglebone python3[877]:     sock = self._create_socket_connection()
May 16 10:18:03 beaglebone python3[877]:   File "/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py", line 3546, in _create_socket_connection
May 16 10:18:03 beaglebone python3[877]:     return socket.create_connection(addr, source_address=source, timeout=self._keepalive)
May 16 10:18:03 beaglebone python3[877]:   File "/usr/lib/python3.7/socket.py", line 707, in create_connection
May 16 10:18:03 beaglebone python3[877]:     for res in getaddrinfo(host, port, 0, SOCK_STREAM):
May 16 10:18:03 beaglebone python3[877]:   File "/usr/lib/python3.7/socket.py", line 748, in getaddrinfo
May 16 10:18:03 beaglebone python3[877]:     for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
May 16 10:18:03 beaglebone python3[877]: socket.gaierror: [Errno -3] Temporary failure in name resolution
May 16 10:18:03 beaglebone python3[877]: INFO:root:Stopping SACN output ...
May 16 10:18:03 beaglebone python3[877]: INFO:bookshelfwall.output.sacn:stopped
May 16 10:18:03 beaglebone python3[877]: INFO:bookshelfwall.input.mqttclient:Stopping MQTT Client...
May 16 10:18:03 beaglebone python3[877]: INFO:sacn:Stopped sACN sending/sender thread
May 16 10:18:03 beaglebone python3[877]: INFO:bookshelfwall.input.mqttclient:MQTT Client Client stopped.
May 16 10:18:03 beaglebone python3[877]: INFO:root:Exited the game loop. Game will quit...
May 16 10:18:03 beaglebone python3[877]: pygame 1.9.4.post1
May 16 10:18:03 beaglebone python3[877]: Hello from the pygame community. https://www.pygame.org/contribute.html
May 16 10:18:04 beaglebone systemd[1]: bsw-ani.service: Main process exited, code=exited, status=1/FAILURE
May 16 10:18:04 beaglebone systemd[1]: bsw-ani.service: Failed with result 'exit-code'.
May 16 10:18:06 beaglebone systemd-logind[730]: Watching system buttons on /dev/input/event0 (tps65217_pwr_but)
May 16 10:18:07 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether waiting for /sys/class/net/wlan0
May 16 10:18:12 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether waiting for /sys/class/net/wlan0
May 16 10:18:14 beaglebone systemd[1]: bsw-ani.service: Service RestartSec=10s expired, scheduling restart.
May 16 10:18:14 beaglebone systemd[1]: bsw-ani.service: Scheduled restart job, restart counter is at 1.
May 16 10:18:14 beaglebone systemd[1]: Stopped BookshelfWall Animation using LEDs and pygame.
May 16 10:18:14 beaglebone systemd[1]: Started BookshelfWall Animation using LEDs and pygame.
May 16 10:18:15 beaglebone systemd-udevd[694]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
May 16 10:18:15 beaglebone systemd-udevd[690]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
May 16 10:18:17 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether waiting for /sys/class/net/wlan0
May 16 10:18:17 beaglebone bonescript-autorun[727]: info: Starting bonescript autorun service
May 16 10:18:18 beaglebone systemd[1]: systemd-hostnamed.service: Succeeded.
May 16 10:18:22 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether waiting for /sys/class/net/wlan0
May 16 10:18:26 beaglebone bonescript-autorun[727]: info: add: /var/lib/cloud9/autorun/.gitignore
May 16 10:18:27 beaglebone python3[1500]: INFO:sacn:Bind sender thread to IP:0.0.0.0 Port:5568
May 16 10:18:27 beaglebone python3[1500]: INFO:bookshelfwall.output.sacn:starting... . Dryrun: False
May 16 10:18:27 beaglebone python3[1500]: INFO:sacn:Started sACN sending/sender thread
May 16 10:18:27 beaglebone python3[1500]: INFO:bookshelfwall.output.sacn:initialized sender for host 192.168.1.14 universe 1
May 16 10:18:27 beaglebone python3[1500]: INFO:bookshelfwall.output.sacn:initialized sender for host 192.168.1.15 universe 2
May 16 10:18:27 beaglebone python3[1500]: ALSA lib pcm_dmix.c:1108:(snd_pcm_dmix_open) unable to open slave
May 16 10:18:27 beaglebone python3[1500]: INFO:root:Initializing pygame: 5 successes and 1 failures.
May 16 10:18:27 beaglebone python3[1500]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.black
May 16 10:18:27 beaglebone python3[1500]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.motion
May 16 10:18:27 beaglebone python3[1500]: INFO:bookshelfwall.input.mqttclient:Starting MQTT Client...
May 16 10:18:27 beaglebone python3[1500]: ERROR:root:Exception in main loop
May 16 10:18:27 beaglebone python3[1500]: Traceback (most recent call last):
May 16 10:18:27 beaglebone python3[1500]:   File "/home/debian/BookshelfWall/bsw-animation/bookshelfwall/main.py", line 210, in <module>
May 16 10:18:27 beaglebone python3[1500]:     animation1 = loadAnimation(config['bookshelfwall.animation']['animation1'])
May 16 10:18:27 beaglebone python3[1500]:   File "/home/debian/BookshelfWall/bsw-animation/bookshelfwall/main.py", line 199, in loadAnimation
May 16 10:18:27 beaglebone python3[1500]:     mqttglue.start()
May 16 10:18:27 beaglebone python3[1500]:   File "/home/debian/BookshelfWall/bsw-animation/bookshelfwall/input/mqttclient.py", line 65, in start
May 16 10:18:27 beaglebone python3[1500]:     self.mqttclient.connect(self.host)
May 16 10:18:27 beaglebone python3[1500]:   File "/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py", line 941, in connect
May 16 10:18:27 beaglebone python3[1500]:     return self.reconnect()
May 16 10:18:27 beaglebone python3[1500]:   File "/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py", line 1075, in reconnect
May 16 10:18:27 beaglebone python3[1500]:     sock = self._create_socket_connection()
May 16 10:18:27 beaglebone python3[1500]:   File "/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py", line 3546, in _create_socket_connection
May 16 10:18:27 beaglebone python3[1500]:     return socket.create_connection(addr, source_address=source, timeout=self._keepalive)
May 16 10:18:27 beaglebone python3[1500]:   File "/usr/lib/python3.7/socket.py", line 707, in create_connection
May 16 10:18:27 beaglebone python3[1500]:     for res in getaddrinfo(host, port, 0, SOCK_STREAM):
May 16 10:18:27 beaglebone python3[1500]:   File "/usr/lib/python3.7/socket.py", line 748, in getaddrinfo
May 16 10:18:27 beaglebone python3[1500]:     for res in _socket.getaddrinfo(host, port, family, type, proto, flags):
May 16 10:18:27 beaglebone python3[1500]: socket.gaierror: [Errno -3] Temporary failure in name resolution
May 16 10:18:27 beaglebone python3[1500]: INFO:root:Stopping SACN output ...
May 16 10:18:27 beaglebone python3[1500]: INFO:bookshelfwall.output.sacn:stopped
May 16 10:18:27 beaglebone python3[1500]: INFO:bookshelfwall.input.mqttclient:Stopping MQTT Client...
May 16 10:18:27 beaglebone python3[1500]: INFO:bookshelfwall.input.mqttclient:MQTT Client Client stopped.
May 16 10:18:27 beaglebone python3[1500]: INFO:root:Exited the game loop. Game will quit...
May 16 10:18:27 beaglebone python3[1500]: INFO:sacn:Stopped sACN sending/sender thread
May 16 10:18:27 beaglebone python3[1500]: pygame 1.9.4.post1
May 16 10:18:27 beaglebone python3[1500]: Hello from the pygame community. https://www.pygame.org/contribute.html
May 16 10:18:27 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether waiting for /sys/class/net/wlan0
May 16 10:18:28 beaglebone systemd[1]: bsw-ani.service: Main process exited, code=exited, status=1/FAILURE
May 16 10:18:28 beaglebone systemd[1]: bsw-ani.service: Failed with result 'exit-code'.
May 16 10:18:31 beaglebone systemd-udevd[694]: Process '/bin/ln -sT '/sys/class/remoteproc/remoteproc0' /dev/remoteproc/pruss-core0' failed with exit code 1.
May 16 10:18:31 beaglebone systemd-udevd[695]: Process '/bin/ln -sT '/sys/class/remoteproc/remoteproc1' /dev/remoteproc/pruss-core1' failed with exit code 1.
May 16 10:18:32 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether waiting for /sys/class/net/wlan0
May 16 10:18:33 beaglebone kernel: wkup_m3_ipc 44e11324.wkup_m3_ipc: could not get rproc handle
May 16 10:18:34 beaglebone kernel: PM: Cannot get wkup_m3_ipc handle
May 16 10:18:34 beaglebone kernel: remoteproc remoteproc2: wkup_m3 is available
May 16 10:18:34 beaglebone kernel: PM: Cannot get wkup_m3_ipc handle
May 16 10:18:34 beaglebone kernel: remoteproc remoteproc2: powering up wkup_m3
May 16 10:18:34 beaglebone kernel: remoteproc remoteproc2: Booting fw image am335x-pm-firmware.elf, size 217168
May 16 10:18:34 beaglebone kernel: remoteproc remoteproc2: remote processor wkup_m3 is now up
May 16 10:18:34 beaglebone kernel: wkup_m3_ipc 44e11324.wkup_m3_ipc: CM3 Firmware Version = 0x193
May 16 10:18:34 beaglebone systemd-udevd[688]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
May 16 10:18:34 beaglebone systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
May 16 10:18:35 beaglebone systemd-udevd[692]: Using default interface naming scheme 'v240'.
May 16 10:18:35 beaglebone systemd-udevd[692]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
May 16 10:18:35 beaglebone systemd-udevd[691]: Using default interface naming scheme 'v240'.
May 16 10:18:35 beaglebone systemd[1]: Found device /dev/ttyGS0.
May 16 10:18:35 beaglebone systemd-udevd[691]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
May 16 10:18:35 beaglebone systemd[1]: Started Serial Getty on ttyGS0.
May 16 10:18:35 beaglebone systemd[1]: Reached target Login Prompts.
May 16 10:18:35 beaglebone systemd[1]: generic-board-startup.service: Succeeded.
May 16 10:18:35 beaglebone systemd[1]: Started Generic Board Startup.
May 16 10:18:35 beaglebone systemd[1]: Starting BB WL18xx Bluetooth Service...
May 16 10:18:36 beaglebone bb-wl18xx-bluetooth[2090]: Found a Texas Instruments' chip!
May 16 10:18:36 beaglebone bb-wl18xx-bluetooth[2090]: Firmware file : /lib/firmware/ti-connectivity/TIInit_11.8.32.bts
May 16 10:18:36 beaglebone bb-wl18xx-bluetooth[2090]: Loaded BTS script version 1
May 16 10:18:36 beaglebone bb-wl18xx-bluetooth[2090]: texas: changing baud rate to 3000000, flow control to 1
May 16 10:18:36 beaglebone kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
May 16 10:18:36 beaglebone kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
May 16 10:18:36 beaglebone kernel: platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
May 16 10:18:36 beaglebone kernel: cfg80211: failed to load regulatory.db
May 16 10:18:36 beaglebone kernel: Bluetooth: Core ver 2.22
May 16 10:18:36 beaglebone kernel: NET: Registered protocol family 31
May 16 10:18:36 beaglebone kernel: Bluetooth: HCI device and connection manager initialized
May 16 10:18:36 beaglebone kernel: Bluetooth: HCI socket layer initialized
May 16 10:18:36 beaglebone kernel: Bluetooth: L2CAP socket layer initialized
May 16 10:18:36 beaglebone kernel: Bluetooth: SCO socket layer initialized
May 16 10:18:36 beaglebone kernel: Bluetooth: HCI UART driver ver 2.3
May 16 10:18:36 beaglebone kernel: Bluetooth: HCI UART protocol H4 registered
May 16 10:18:36 beaglebone kernel: Bluetooth: HCI UART protocol LL registered
May 16 10:18:36 beaglebone kernel: Bluetooth: HCI UART protocol ATH3K registered
May 16 10:18:36 beaglebone kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered
May 16 10:18:36 beaglebone systemd[1]: Starting Load/Save RF Kill Switch Status...
May 16 10:18:37 beaglebone systemd[1]: Starting Bluetooth service...
May 16 10:18:37 beaglebone systemd[1]: Started Load/Save RF Kill Switch Status.
May 16 10:18:37 beaglebone bluetoothd[2107]: Bluetooth daemon 5.50
May 16 10:18:37 beaglebone systemd[1]: Started Bluetooth service.
May 16 10:18:37 beaglebone bluetoothd[2107]: Starting SDP server
May 16 10:18:37 beaglebone kernel: PM: bootloader does not support rtc-only!
May 16 10:18:37 beaglebone systemd[1]: Started BluezALSA proxy.
May 16 10:18:37 beaglebone systemd[1]: Reached target Bluetooth.
May 16 10:18:37 beaglebone kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
May 16 10:18:37 beaglebone kernel: Bluetooth: BNEP filters: protocol multicast
May 16 10:18:37 beaglebone kernel: Bluetooth: BNEP socket layer initialized
May 16 10:18:37 beaglebone bluetoothd[2107]: Bluetooth management interface 1.14 initialized
May 16 10:18:37 beaglebone dbus-daemon[732]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.13' (uid=0 pid=2107 comm="/usr/lib/bluetooth/bluetoothd ")
May 16 10:18:37 beaglebone bluetoothd[2107]: Sap driver initialization failed.
May 16 10:18:37 beaglebone bluetoothd[2107]: sap-server: Operation not permitted (1)
May 16 10:18:37 beaglebone bluetoothd[2107]: Endpoint registered: sender=:1.14 path=/org/bluez/hci0/A2DP/SBC/Source/1
May 16 10:18:37 beaglebone bluetoothd[2107]: Endpoint registered: sender=:1.14 path=/org/bluez/hci0/A2DP/SBC/Source/2
May 16 10:18:37 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether waiting for /sys/class/net/wlan0
May 16 10:18:37 beaglebone systemd[1]: Starting Hostname Service...
May 16 10:18:37 beaglebone bb-wl18xx-bluetooth[2090]: Device setup complete
May 16 10:18:37 beaglebone systemd[1]: Started BB WL18xx Bluetooth Service.
May 16 10:18:37 beaglebone kernel: wlcore: wl18xx HW: 183x or 180x, PG 2.2 (ROM 0x11)
May 16 10:18:37 beaglebone connmand[737]: wlan0 {create} index 6 type 1 <ETHER>
May 16 10:18:37 beaglebone connmand[737]: wlan0 {update} flags 4098 <DOWN>
May 16 10:18:37 beaglebone kernel: wlcore: loaded
May 16 10:18:37 beaglebone connmand[737]: wlan0 {newlink} index 6 address A8:10:87:59:3B:2E mtu 1500
May 16 10:18:38 beaglebone kernel: Bluetooth: RFCOMM TTY layer initialized
May 16 10:18:38 beaglebone kernel: Bluetooth: RFCOMM socket layer initialized
May 16 10:18:38 beaglebone kernel: Bluetooth: RFCOMM ver 1.11
May 16 10:18:37 beaglebone connmand[737]: wlan0 {newlink} index 6 operstate 2 <DOWN>
May 16 10:18:38 beaglebone dbus-daemon[732]: [system] Successfully activated service 'org.freedesktop.hostname1'
May 16 10:18:38 beaglebone systemd[1]: Started Hostname Service.
May 16 10:18:38 beaglebone kernel: wlcore: PHY firmware version: Rev 8.2.0.0.242
May 16 10:18:38 beaglebone kernel: wlcore: firmware booted (Rev 8.9.0.0.79)
May 16 10:18:38 beaglebone kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
May 16 10:18:38 beaglebone systemd-udevd[691]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
May 16 10:18:38 beaglebone systemd[1]: bsw-ani.service: Service RestartSec=10s expired, scheduling restart.
May 16 10:18:38 beaglebone systemd[1]: bsw-ani.service: Scheduled restart job, restart counter is at 2.
May 16 10:18:38 beaglebone connmand[737]: Adding interface wlan0 [ wifi ]
May 16 10:18:38 beaglebone systemd[1]: Stopped BookshelfWall Animation using LEDs and pygame.
May 16 10:18:38 beaglebone connmand[737]: wlan0 {update} flags 36931 <UP,RUNNING>
May 16 10:18:38 beaglebone connmand[737]: wlan0 {newlink} index 6 address A8:10:87:59:3B:2E mtu 1500
May 16 10:18:38 beaglebone connmand[737]: wlan0 {newlink} index 6 operstate 0 <UNKNOWN>
May 16 10:18:38 beaglebone connmand[737]: wlan0 {update} flags 36867 <UP>
May 16 10:18:38 beaglebone connmand[737]: wlan0 {newlink} index 6 address A8:10:87:59:3B:2E mtu 1500
May 16 10:18:38 beaglebone connmand[737]: wlan0 {newlink} index 6 operstate 2 <DOWN>
May 16 10:18:38 beaglebone connmand[737]: wlan0 {newlink} index 6 address A8:10:87:59:3B:2E mtu 1500
May 16 10:18:38 beaglebone connmand[737]: wlan0 {newlink} index 6 operstate 2 <DOWN>
May 16 10:18:38 beaglebone systemd[1]: Started BookshelfWall Animation using LEDs and pygame.
May 16 10:18:38 beaglebone wpa_supplicant[755]: WPS: Converting push_button to virtual_push_button for WPS 2.0 compliance
May 16 10:18:39 beaglebone wpa_supplicant[755]: wlan0: SME: Trying to authenticate with fc:ec:da:8d:3b:8c (SSID='kanaan_family' freq=2437 MHz)
May 16 10:18:39 beaglebone kernel: wlan0: authenticate with fc:ec:da:8d:3b:8c
May 16 10:18:39 beaglebone kernel: wlan0: send auth to fc:ec:da:8d:3b:8c (try 1/3)
May 16 10:18:39 beaglebone wpa_supplicant[755]: wlan0: Trying to associate with fc:ec:da:8d:3b:8c (SSID='kanaan_family' freq=2437 MHz)
May 16 10:18:39 beaglebone kernel: wlan0: authenticated
May 16 10:18:39 beaglebone kernel: wlan0: associate with fc:ec:da:8d:3b:8c (try 1/3)
May 16 10:18:39 beaglebone kernel: wlan0: RX AssocResp from fc:ec:da:8d:3b:8c (capab=0x31 status=0 aid=4)
May 16 10:18:39 beaglebone connmand[737]: wlan0 {RX} 1 packets 113 bytes
May 16 10:18:39 beaglebone kernel: wlan0: associated
May 16 10:18:39 beaglebone connmand[737]: wlan0 {TX} 0 packets 0 bytes
May 16 10:18:39 beaglebone connmand[737]: wlan0 {update} flags 102403 <UP,LOWER_UP>
May 16 10:18:39 beaglebone connmand[737]: wlan0 {newlink} index 6 address A8:10:87:59:3B:2E mtu 1500
May 16 10:18:39 beaglebone connmand[737]: wlan0 {newlink} index 6 operstate 5 <DORMANT>
May 16 10:18:39 beaglebone wpa_supplicant[755]: wlan0: Associated with fc:ec:da:8d:3b:8c
May 16 10:18:39 beaglebone wpa_supplicant[755]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
May 16 10:18:39 beaglebone kernel: cryptd: max_cpu_qlen set to 1000
May 16 10:18:40 beaglebone wpa_supplicant[755]: wlan0: WPA: Key negotiation completed with fc:ec:da:8d:3b:8c [PTK=CCMP GTK=CCMP]
May 16 10:18:40 beaglebone wpa_supplicant[755]: wlan0: CTRL-EVENT-CONNECTED - Connection to fc:ec:da:8d:3b:8c completed [id=0 id_str=]
May 16 10:18:40 beaglebone kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
May 16 10:18:40 beaglebone connmand[737]: wlan0 {add} route fe80:: gw :: scope 0 <UNIVERSE>
May 16 10:18:40 beaglebone connmand[737]: wlan0 {RX} 2 packets 282 bytes
May 16 10:18:40 beaglebone connmand[737]: wlan0 {TX} 2 packets 288 bytes
May 16 10:18:40 beaglebone connmand[737]: wlan0 {update} flags 102467 <UP,RUNNING,LOWER_UP>
May 16 10:18:40 beaglebone kernel: wlcore: Association completed.
May 16 10:18:40 beaglebone connmand[737]: wlan0 {newlink} index 6 address A8:10:87:59:3B:2E mtu 1500
May 16 10:18:40 beaglebone connmand[737]: wlan0 {newlink} index 6 operstate 6 <UP>
May 16 10:18:40 beaglebone avahi-daemon[750]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.17.
May 16 10:18:40 beaglebone avahi-daemon[750]: New relevant interface wlan0.IPv4 for mDNS.
May 16 10:18:40 beaglebone avahi-daemon[750]: Registering new address record for 192.168.1.17 on wlan0.IPv4.
May 16 10:18:40 beaglebone connmand[737]: wlan0 {add} address 192.168.1.17/24 label wlan0 family 2
May 16 10:18:40 beaglebone connmand[737]: wlan0 {add} route 192.168.1.0 gw 0.0.0.0 scope 253 <LINK>
May 16 10:18:40 beaglebone connmand[737]: wlan0 {add} route 192.168.1.1 gw 0.0.0.0 scope 253 <LINK>
May 16 10:18:40 beaglebone connmand[737]: wlan0 {add} route 0.0.0.0 gw 192.168.1.1 scope 0 <UNIVERSE>
May 16 10:18:40 beaglebone connmand[737]: wlan0 {add} route 0.0.0.0 gw 192.168.1.1 scope 0 <UNIVERSE>
May 16 10:18:40 beaglebone connmand[737]: wlan0 {add} route 82.165.8.211 gw 192.168.1.1 scope 0 <UNIVERSE>
May 16 10:18:41 beaglebone avahi-daemon[750]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::aa10:87ff:fe59:3b2e.
May 16 10:18:41 beaglebone avahi-daemon[750]: New relevant interface wlan0.IPv6 for mDNS.
May 16 10:18:41 beaglebone avahi-daemon[750]: Registering new address record for fe80::aa10:87ff:fe59:3b2e on wlan0.*.
May 16 10:18:41 beaglebone wpa_supplicant[755]: wlan0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-48 noise=9999 txrate=144400
May 16 10:18:40 beaglebone systemd-timesyncd[700]: Synchronized to time server for the first time 206.108.0.132:123 (0.debian.pool.ntp.org).
May 16 10:18:42 beaglebone bb-wl18xx-wlan0[749]: wl18xx:wlan0:Power Management:off
May 16 10:18:42 beaglebone python3[2125]: INFO:sacn:Bind sender thread to IP:0.0.0.0 Port:5568
May 16 10:18:42 beaglebone python3[2125]: INFO:bookshelfwall.output.sacn:starting... . Dryrun: False
May 16 10:18:42 beaglebone python3[2125]: INFO:sacn:Started sACN sending/sender thread
May 16 10:18:42 beaglebone python3[2125]: INFO:bookshelfwall.output.sacn:initialized sender for host 192.168.1.14 universe 1
May 16 10:18:42 beaglebone python3[2125]: INFO:bookshelfwall.output.sacn:initialized sender for host 192.168.1.15 universe 2
May 16 10:18:42 beaglebone python3[2125]: ALSA lib pcm_dmix.c:1108:(snd_pcm_dmix_open) unable to open slave
May 16 10:18:42 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether [iw phy phy0 interface add SoftAp0 type managed]
May 16 10:18:42 beaglebone python3[2125]: INFO:root:Initializing pygame: 5 successes and 1 failures.
May 16 10:18:42 beaglebone python3[2125]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.black
May 16 10:18:42 beaglebone python3[2125]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.motion
May 16 10:18:42 beaglebone systemd[1]: systemd-rfkill.service: Succeeded.
May 16 10:18:42 beaglebone python3[2125]: INFO:bookshelfwall.input.mqttclient:Starting MQTT Client...
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {create} index 7 type 1 <ETHER>
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {update} flags 4098 <DOWN>
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {newlink} index 7 address AA:10:87:59:3B:2E mtu 1500
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {newlink} index 7 operstate 2 <DOWN>
May 16 10:18:42 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether [phy0 created]
May 16 10:18:42 beaglebone systemd-udevd[688]: Using default interface naming scheme 'v240'.
May 16 10:18:42 beaglebone connmand[737]: Ignoring interface SoftAp0 (filtered)
May 16 10:18:42 beaglebone systemd-udevd[688]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.
May 16 10:18:42 beaglebone connmand[737]: Adding interface SoftAp0 [ wifi ]
May 16 10:18:42 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether [ip link set dev SoftAp0 down]
May 16 10:18:42 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether [ip link set dev SoftAp0 address 0C:1C:57:06:C5:0D]
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {newlink} index 7 address 0C:1C:57:06:C5:0D mtu 1500
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {newlink} index 7 operstate 2 <DOWN>
May 16 10:18:42 beaglebone connmand[737]: Ignoring interface SoftAp0 (filtered)
May 16 10:18:42 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether [ip link set dev SoftAp0 up]
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {update} flags 4163 <UP,RUNNING>
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {newlink} index 7 address 0C:1C:57:06:C5:0D mtu 1500
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {newlink} index 7 operstate 0 <UNKNOWN>
May 16 10:18:42 beaglebone connmand[737]: Ignoring interface SoftAp0 (filtered)
May 16 10:18:42 beaglebone kernel: IPv6: ADDRCONF(NETDEV_UP): SoftAp0: link is not ready
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {update} flags 4099 <UP>
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {newlink} index 7 address 0C:1C:57:06:C5:0D mtu 1500
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {newlink} index 7 operstate 2 <DOWN>
May 16 10:18:42 beaglebone connmand[737]: Ignoring interface SoftAp0 (filtered)
May 16 10:18:42 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether [ip addr add 192.168.8.1/24 broadcast 192.168.8.255 dev SoftAp0]
May 16 10:18:42 beaglebone connmand[737]: SoftAp0 {add} address 192.168.8.1/24 label SoftAp0 family 2
May 16 10:18:42 beaglebone avahi-daemon[750]: Joining mDNS multicast group on interface SoftAp0.IPv4 with address 192.168.8.1.
May 16 10:18:43 beaglebone connmand[737]: SoftAp0 {add} route 192.168.8.0 gw 0.0.0.0 scope 253 <LINK>
May 16 10:18:43 beaglebone avahi-daemon[750]: New relevant interface SoftAp0.IPv4 for mDNS.
May 16 10:18:43 beaglebone avahi-daemon[750]: Registering new address record for 192.168.8.1 on SoftAp0.IPv4.
May 16 10:18:43 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether [iptables -w -t nat -A POSTROUTING -o wlan0 -j MASQUERADE]
May 16 10:18:43 beaglebone python3[2125]: INFO:bookshelfwall.input.mqttclient:MQTT Client connected to mqttserver-hostname-replaced-for-security-purposes-before-posting-on-forum.example.com
May 16 10:18:43 beaglebone python3[2125]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.image
May 16 10:18:43 beaglebone python3[2125]: INFO:bookshelfwall.input.mqttclient:MQTT connect: subscribing to topics bsw/heatsensor1
May 16 10:18:43 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether [iptables -w -A FORWARD -i wlan0 -o SoftAp0 -m state --state RELATED,ESTABLISHED -j ACCEPT]
May 16 10:18:43 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether [iptables -w -A FORWARD -i SoftAp0 -o wlan0 -j ACCEPT]
May 16 10:18:44 beaglebone systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server...
May 16 10:18:44 beaglebone dnsmasq[2199]: dnsmasq: syntax check OK.
May 16 10:18:44 beaglebone python3[2125]: ERROR:root:Exception in main loop
May 16 10:18:44 beaglebone python3[2125]: Traceback (most recent call last):
May 16 10:18:44 beaglebone python3[2125]:   File "/home/debian/BookshelfWall/bsw-animation/bookshelfwall/main.py", line 238, in <module>
May 16 10:18:44 beaglebone python3[2125]:     animation1.update(gamescreen, dt)
May 16 10:18:44 beaglebone python3[2125]:   File "/home/debian/BookshelfWall/bsw-animation/bookshelfwall/animation/motion.py", line 44, in update
May 16 10:18:44 beaglebone python3[2125]:     historysum = self.humanhistorysum[x+y*8]
May 16 10:18:44 beaglebone python3[2125]: IndexError: list index out of range
May 16 10:18:44 beaglebone python3[2125]: INFO:root:Stopping SACN output ...
May 16 10:18:44 beaglebone python3[2125]: INFO:bookshelfwall.output.sacn:stopped
May 16 10:18:44 beaglebone python3[2125]: INFO:bookshelfwall.input.mqttclient:Stopping MQTT Client...
May 16 10:18:44 beaglebone python3[2125]: INFO:bookshelfwall.input.mqttclient:MQTT Client Client stopped.
May 16 10:18:44 beaglebone python3[2125]: INFO:root:Exited the game loop. Game will quit...
May 16 10:18:44 beaglebone python3[2125]: INFO:sacn:Stopped sACN sending/sender thread
May 16 10:18:44 beaglebone python3[2125]: pygame 1.9.4.post1
May 16 10:18:44 beaglebone python3[2125]: Hello from the pygame community. https://www.pygame.org/contribute.html
May 16 10:18:44 beaglebone python3[2125]: Running... more debug: see logging
May 16 10:18:44 beaglebone dnsmasq[2204]: started, version 2.80 cachesize 2048
May 16 10:18:44 beaglebone dnsmasq[2204]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile
May 16 10:18:44 beaglebone dnsmasq-dhcp[2204]: DHCP, IP range 192.168.6.1 -- 192.168.6.1, lease time 20m
May 16 10:18:44 beaglebone dnsmasq-dhcp[2204]: DHCP, IP range 192.168.7.1 -- 192.168.7.1, lease time 20m
May 16 10:18:44 beaglebone dnsmasq-dhcp[2204]: DHCP, IP range 192.168.8.50 -- 192.168.8.150, lease time 1h
May 16 10:18:44 beaglebone dnsmasq[2204]: reading /etc/resolv.conf
May 16 10:18:44 beaglebone dnsmasq[2204]: using nameserver 192.168.1.1#53
May 16 10:18:44 beaglebone dnsmasq[2204]: read /etc/hosts - 5 addresses
May 16 10:18:44 beaglebone systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server.
May 16 10:18:44 beaglebone systemd[1]: Reached target Host and Network Name Lookups.
May 16 10:18:44 beaglebone bb-wl18xx-wlan0[749]: wl18xx:tether /usr/sbin/hostapd -B /tmp/hostapd-wl18xx.conf
May 16 10:18:45 beaglebone bb-wl18xx-wlan0[749]: Configuration file: /tmp/hostapd-wl18xx.conf
May 16 10:18:45 beaglebone kernel: wlcore: down
May 16 10:18:45 beaglebone bb-wl18xx-wlan0[749]: Using interface SoftAp0 with hwaddr 0c:1c:57:06:c5:0d and ssid "BeagleBone-C50D"
May 16 10:18:45 beaglebone kernel: IPv6: ADDRCONF(NETDEV_CHANGE): SoftAp0: link becomes ready
May 16 10:18:45 beaglebone connmand[737]: SoftAp0 {add} route fe80:: gw :: scope 0 <UNIVERSE>
May 16 10:18:45 beaglebone connmand[737]: SoftAp0 {update} flags 69699 <UP,RUNNING,LOWER_UP>
May 16 10:18:45 beaglebone connmand[737]: SoftAp0 {newlink} index 7 address 0C:1C:57:06:C5:0D mtu 1500
May 16 10:18:45 beaglebone connmand[737]: SoftAp0 {newlink} index 7 operstate 6 <UP>
May 16 10:18:45 beaglebone connmand[737]: Ignoring interface SoftAp0 (filtered)
May 16 10:18:45 beaglebone bb-wl18xx-wlan0[749]: SoftAp0: interface state UNINITIALIZED->ENABLED
May 16 10:18:45 beaglebone bb-wl18xx-wlan0[749]: SoftAp0: AP-ENABLED
May 16 10:18:45 beaglebone connmand[737]: wlan0 {del} route 82.165.8.211 gw 192.168.1.1 scope 0 <UNIVERSE>
May 16 10:18:45 beaglebone systemd[1]: Started BB WL18xx wlan0 Service.
May 16 10:18:45 beaglebone systemd[1]: Reached target Multi-User System.
May 16 10:18:45 beaglebone systemd[1]: Reached target Graphical Interface.
May 16 10:18:45 beaglebone systemd[1]: Starting Update UTMP about System Runlevel Changes...
May 16 10:18:45 beaglebone systemd[1]: bsw-ani.service: Main process exited, code=exited, status=1/FAILURE
May 16 10:18:45 beaglebone systemd[1]: bsw-ani.service: Failed with result 'exit-code'.
May 16 10:18:45 beaglebone systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
May 16 10:18:45 beaglebone systemd[1]: Started Update UTMP about System Runlevel Changes.
May 16 10:18:45 beaglebone systemd[1]: Startup finished in 9.279s (kernel) + 1min 12.060s (userspace) = 1min 21.339s.
May 16 10:18:46 beaglebone avahi-daemon[750]: Joining mDNS multicast group on interface SoftAp0.IPv6 with address fe80::e1c:57ff:fe06:c50d.
May 16 10:18:46 beaglebone avahi-daemon[750]: New relevant interface SoftAp0.IPv6 for mDNS.
May 16 10:18:46 beaglebone avahi-daemon[750]: Registering new address record for fe80::e1c:57ff:fe06:c50d on SoftAp0.*.
May 16 10:18:55 beaglebone systemd[1]: bsw-ani.service: Service RestartSec=10s expired, scheduling restart.
May 16 10:18:55 beaglebone systemd[1]: bsw-ani.service: Scheduled restart job, restart counter is at 3.
May 16 10:18:55 beaglebone systemd[1]: Stopped BookshelfWall Animation using LEDs and pygame.
May 16 10:18:55 beaglebone systemd[1]: Started BookshelfWall Animation using LEDs and pygame.
May 16 10:18:58 beaglebone python3[2217]: INFO:sacn:Bind sender thread to IP:0.0.0.0 Port:5568
May 16 10:18:58 beaglebone python3[2217]: INFO:bookshelfwall.output.sacn:starting... . Dryrun: False
May 16 10:18:58 beaglebone python3[2217]: INFO:sacn:Started sACN sending/sender thread
May 16 10:18:58 beaglebone python3[2217]: INFO:bookshelfwall.output.sacn:initialized sender for host 192.168.1.14 universe 1
May 16 10:18:58 beaglebone python3[2217]: INFO:bookshelfwall.output.sacn:initialized sender for host 192.168.1.15 universe 2
May 16 10:18:58 beaglebone python3[2217]: ALSA lib pcm_dmix.c:1108:(snd_pcm_dmix_open) unable to open slave
May 16 10:18:58 beaglebone python3[2217]: INFO:root:Initializing pygame: 5 successes and 1 failures.
May 16 10:18:58 beaglebone python3[2217]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.black
May 16 10:18:58 beaglebone python3[2217]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.motion
May 16 10:18:58 beaglebone python3[2217]: INFO:bookshelfwall.input.mqttclient:Starting MQTT Client...
May 16 10:18:58 beaglebone python3[2217]: INFO:bookshelfwall.input.mqttclient:MQTT Client connected to mqttserver-hostname-replaced-for-security-purposes-before-posting-on-forum.example.com
May 16 10:18:58 beaglebone python3[2217]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.image
May 16 10:18:58 beaglebone python3[2217]: INFO:bookshelfwall.input.mqttclient:MQTT connect: subscribing to topics bsw/heatsensor1
May 16 10:19:07 beaglebone systemd[1]: systemd-hostnamed.service: Succeeded.
May 16 10:19:07 beaglebone python3[2217]: ERROR:root:Exception in main loop
May 16 10:19:07 beaglebone python3[2217]: Traceback (most recent call last):
May 16 10:19:07 beaglebone python3[2217]:   File "/home/debian/BookshelfWall/bsw-animation/bookshelfwall/main.py", line 238, in <module>
May 16 10:19:07 beaglebone python3[2217]:     animation1.update(gamescreen, dt)
May 16 10:19:07 beaglebone python3[2217]:   File "/home/debian/BookshelfWall/bsw-animation/bookshelfwall/animation/motion.py", line 44, in update
May 16 10:19:07 beaglebone python3[2217]:     historysum = self.humanhistorysum[x+y*8]
May 16 10:19:07 beaglebone python3[2217]: IndexError: list index out of range
May 16 10:19:07 beaglebone python3[2217]: INFO:root:Stopping SACN output ...
May 16 10:19:07 beaglebone python3[2217]: INFO:bookshelfwall.output.sacn:stopped
May 16 10:19:07 beaglebone python3[2217]: INFO:bookshelfwall.input.mqttclient:Stopping MQTT Client...
May 16 10:19:07 beaglebone python3[2217]: INFO:bookshelfwall.input.mqttclient:MQTT Client Client stopped.
May 16 10:19:07 beaglebone python3[2217]: INFO:root:Exited the game loop. Game will quit...
May 16 10:19:07 beaglebone python3[2217]: INFO:sacn:Stopped sACN sending/sender thread
May 16 10:19:07 beaglebone python3[2217]: pygame 1.9.4.post1
May 16 10:19:07 beaglebone python3[2217]: Hello from the pygame community. https://www.pygame.org/contribute.html
May 16 10:19:07 beaglebone python3[2217]: Running... more debug: see logging
May 16 10:19:08 beaglebone systemd[1]: bsw-ani.service: Main process exited, code=exited, status=1/FAILURE
May 16 10:19:08 beaglebone systemd[1]: bsw-ani.service: Failed with result 'exit-code'.
May 16 10:19:18 beaglebone systemd[1]: bsw-ani.service: Service RestartSec=10s expired, scheduling restart.
May 16 10:19:18 beaglebone systemd[1]: bsw-ani.service: Scheduled restart job, restart counter is at 4.
May 16 10:19:18 beaglebone systemd[1]: Stopped BookshelfWall Animation using LEDs and pygame.
May 16 10:19:18 beaglebone systemd[1]: Started BookshelfWall Animation using LEDs and pygame.
May 16 10:19:20 beaglebone python3[2225]: INFO:sacn:Bind sender thread to IP:0.0.0.0 Port:5568
May 16 10:19:20 beaglebone python3[2225]: INFO:bookshelfwall.output.sacn:starting... . Dryrun: False
May 16 10:19:20 beaglebone python3[2225]: INFO:sacn:Started sACN sending/sender thread
May 16 10:19:20 beaglebone python3[2225]: INFO:bookshelfwall.output.sacn:initialized sender for host 192.168.1.14 universe 1
May 16 10:19:20 beaglebone python3[2225]: INFO:bookshelfwall.output.sacn:initialized sender for host 192.168.1.15 universe 2
May 16 10:19:21 beaglebone python3[2225]: ALSA lib pcm_dmix.c:1108:(snd_pcm_dmix_open) unable to open slave
May 16 10:19:21 beaglebone python3[2225]: INFO:root:Initializing pygame: 5 successes and 1 failures.
May 16 10:19:21 beaglebone python3[2225]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.black
May 16 10:19:21 beaglebone python3[2225]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.motion
May 16 10:19:21 beaglebone python3[2225]: INFO:bookshelfwall.input.mqttclient:Starting MQTT Client...
May 16 10:19:21 beaglebone python3[2225]: INFO:bookshelfwall.input.mqttclient:MQTT Client connected to mqttserver-hostname-replaced-for-security-purposes-before-posting-on-forum.example.com
May 16 10:19:21 beaglebone python3[2225]: INFO:root:loadAnimation: animationclassname: bookshelfwall.animation.image
May 16 10:19:21 beaglebone python3[2225]: INFO:bookshelfwall.input.mqttclient:MQTT connect: subscribing to topics bsw/heatsensor1