boot hangs

[s0m3body]

Hi,

I'm watching a problem during boot of my A20-OLinuXino-MICRO-4GB, running 4.6.3-sunxi #7 SMP Tue Jul 5 16:23:41 CEST 2016 armv7l GNU/Linux It seems to hang an multiple points and needs 417 seconds at all.

It looks like a problem with initializing /dev/random and network configuration

 

Here the entire log:

Aug 30 00:23:49 autokino kernel: [    7.624658] rt2800usb 1-1:1.0 wlan0: renamed from rename4
Aug 30 00:23:49 autokino kernel: [    8.917512] random: mktemp urandom read with 96 bits of entropy available
Aug 30 00:23:49 autokino kernel: [    9.142494] EXT4-fs (mmcblk0p1): re-mounted. Opts: data=writeback,commit=600,errors=remount-ro
Aug 30 00:23:49 autokino kernel: [    9.540278] Ethernet Channel Bonding Driver: v3.7.1 (April 27, 2011)
Aug 30 00:23:49 autokino kernel: [   11.831662] Adding 131068k swap on /var/swap.  Priority:-1 extents:2 across:139260k SSFS
Aug 30 00:23:49 autokino kernel: [   12.267136] BTRFS info (device sda1): disk space caching is enabled
Aug 30 00:23:49 autokino kernel: [   14.295623]  RX IPC Checksum Offload disabled
Aug 30 00:23:49 autokino kernel: [   14.295665]  No MAC Management Counters available
Aug 30 00:23:49 autokino kernel: [   14.296059] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Aug 30 00:23:49 autokino kernel: [   16.353295] sun7i-dwmac 1c50000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx
Aug 30 00:23:49 autokino kernel: [   16.353406] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Aug 30 00:23:49 autokino kernel: [   36.360978] random: nonblocking pool is initialized
Aug 30 00:23:49 autokino kernel: [  150.328053] ieee80211 phy1: rt2x00lib_request_firmware: Info - Loading firmware file 'rt2870.bin'
Aug 30 00:23:49 autokino kernel: [  150.329706] ieee80211 phy1: rt2x00lib_request_firmware: Info - Firmware detected - version: 0.33
Aug 30 00:23:49 autokino kernel: [  150.650190] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Aug 30 00:23:49 autokino kernel: [  152.431899] wlan0: authenticate with 5c:49:79:21:2b:d3
Aug 30 00:23:49 autokino kernel: [  152.494813] wlan0: send auth to 5c:49:79:21:2b:d3 (try 1/3)
Aug 30 00:23:49 autokino kernel: [  152.498227] wlan0: authenticated
Aug 30 00:23:49 autokino kernel: [  152.503090] wlan0: associate with 5c:49:79:21:2b:d3 (try 1/3)
Aug 30 00:23:49 autokino kernel: [  152.530590] wlan0: RX AssocResp from 5c:49:79:21:2b:d3 (capab=0x431 status=0 aid=1)
Aug 30 00:23:49 autokino kernel: [  152.543793] wlan0: associated
Aug 30 00:23:49 autokino kernel: [  152.544084] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Aug 30 00:23:49 autokino kernel: [  285.154641] rtl8192cu: MAC auto ON okay!
Aug 30 00:23:49 autokino kernel: [  285.187781] rtl8192cu: Tx queue select: 0x05
Aug 30 00:23:49 autokino kernel: [  285.674737] IPv6: ADDRCONF(NETDEV_UP): wlan1: link is not ready
Aug 30 00:23:49 autokino acpid: starting up with netlink and the input layer
Aug 30 00:23:49 autokino acpid: 1 rule loaded
Aug 30 00:23:49 autokino acpid: 1 rule loaded
Aug 30 00:23:49 autokino acpid: waiting for events: event logging is off
Aug 30 00:23:49 autokino named[7001]: starting BIND 9.8.4-rpz2+rl005.12-P1 -u bind
Aug 30 00:23:49 autokino named[7001]: built with '--prefix=/usr' '--mandir=/usr/share/man' '--infodir=/usr/share/info' '--sysconfdir=/etc/bind' '--localstatedir=/var' '--enable-threads' '--enable-largefile' '--with-libtool' '--enable-shared' '--enable-static' '--with-openssl=/usr' '--with-gssapi=/usr' '--with-gnu-ld' '--with-geoip=/usr' '--enable-ipv6' 'CFLAGS=-fno-strict-aliasing -DDIG_SIGCHASE -O2'
Aug 30 00:23:49 autokino named[7001]: ----------------------------------------------------
Aug 30 00:23:49 autokino named[7001]: BIND 9 is maintained by Internet Systems Consortium,
Aug 30 00:23:49 autokino named[7001]: Inc. (ISC), a non-profit 501©(3) public-benefit
Aug 30 00:23:49 autokino named[7001]: corporation.  Support and training for BIND 9 are
Aug 30 00:23:49 autokino named[7001]: available at https://www.isc.org/support
Aug 30 00:23:49 autokino named[7001]: ----------------------------------------------------
Aug 30 00:23:49 autokino named[7001]: adjusted limit on open files from 4096 to 1048576
Aug 30 00:23:49 autokino named[7001]: found 2 CPUs, using 2 worker threads
Aug 30 00:23:49 autokino named[7001]: using up to 4096 sockets
Aug 30 00:23:49 autokino named[7001]: loading configuration from '/etc/bind/named.conf'
Aug 30 00:23:49 autokino named[7001]: reading built-in trusted keys from file '/etc/bind/bind.keys'
Aug 30 00:23:49 autokino named[7001]: using default UDP/IPv4 port range: [1024, 65535]
Aug 30 00:23:49 autokino named[7001]: using default UDP/IPv6 port range: [1024, 65535]
Aug 30 00:23:49 autokino named[7001]: listening on IPv6 interfaces, port 53
Aug 30 00:23:49 autokino haveged: haveged starting up
Aug 30 00:23:49 autokino named[7001]: listening on IPv4 interface lo, 127.0.0.1#53
Aug 30 00:23:49 autokino named[7001]: listening on IPv4 interface eth0, 192.168.178.29#53
Aug 30 00:23:49 autokino named[7001]: listening on IPv4 interface wlan1, 192.168.27.1#53
Aug 30 00:23:49 autokino named[7001]: listening on IPv4 interface wlan0, 192.168.178.30#53
Aug 30 00:23:49 autokino named[7001]: generating session key for dynamic DNS
Aug 30 00:23:50 autokino named[7001]: sizing zone task pool based on 7 zones
Aug 30 00:23:50 autokino named[7001]: set up managed keys zone for view _default, file 'managed-keys.bind'
Aug 30 00:23:50 autokino named[7001]: Warning: 'empty-zones-enable/disable-empty-zone' not set: disabling RFC 1918 empty zones
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: 254.169.IN-ADDR.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: 2.0.192.IN-ADDR.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: 100.51.198.IN-ADDR.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: 113.0.203.IN-ADDR.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: 255.255.255.255.IN-ADDR.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: 0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: 1.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.0.IP6.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: D.F.IP6.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: 8.E.F.IP6.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: 9.E.F.IP6.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: A.E.F.IP6.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: B.E.F.IP6.ARPA
Aug 30 00:23:50 autokino named[7001]: automatic empty zone: 8.B.D.0.1.0.0.2.IP6.ARPA
Aug 30 00:23:50 autokino named[7001]: command channel listening on 127.0.0.1#953
Aug 30 00:23:50 autokino named[7001]: command channel listening on ::1#953
Aug 30 00:23:50 autokino named[7001]: zone 0.in-addr.arpa/IN: loaded serial 1
Aug 30 00:23:50 autokino named[7001]: zone 127.in-addr.arpa/IN: loaded serial 1
Aug 30 00:23:50 autokino named[7001]: zone 27.168.192.in-addr.arpa/IN: loaded serial 15060902
Aug 30 00:23:50 autokino named[7001]: zone 255.in-addr.arpa/IN: loaded serial 1
Aug 30 00:23:50 autokino named[7001]: /etc/bind/db.autokino.fritz.box:13: ignoring out-of-zone data (ns1.fritz.box)
Aug 30 00:23:50 autokino named[7001]: zone autokino.fritz.box/IN: loaded serial 3
Aug 30 00:23:50 autokino named[7001]: zone localhost/IN: loaded serial 2
Aug 30 00:23:50 autokino named[7001]: managed-keys-zone ./IN: loaded serial 33
Aug 30 00:23:50 autokino named[7001]: zone 27.168.192.in-addr.arpa/IN: sending notifies (serial 15060902)
Aug 30 00:23:50 autokino bluetoothd[7057]: Bluetooth daemon 4.99
Aug 30 00:23:50 autokino bluetoothd[7057]: Starting SDP server
Aug 30 00:23:50 autokino kernel: [  417.282361] Bluetooth: Core ver 2.21
Aug 30 00:23:50 autokino kernel: [  417.282537] NET: Registered protocol family 31
Aug 30 00:23:50 autokino kernel: [  417.282548] Bluetooth: HCI device and connection manager initialized
Aug 30 00:23:50 autokino kernel: [  417.282579] Bluetooth: HCI socket layer initialized
Aug 30 00:23:50 autokino kernel: [  417.282599] Bluetooth: L2CAP socket layer initialized
Aug 30 00:23:50 autokino kernel: [  417.282667] Bluetooth: SCO socket layer initialized
Aug 30 00:23:50 autokino bluetoothd[7057]: Failed to init alert plugin
Aug 30 00:23:50 autokino bluetoothd[7057]: Failed to init time plugin
Aug 30 00:23:50 autokino bluetoothd[7057]: Failed to init gatt_example plugin
Aug 30 00:23:50 autokino kernel: [  417.333333] Bluetooth: RFCOMM TTY layer initialized
Aug 30 00:23:50 autokino kernel: [  417.333399] Bluetooth: RFCOMM socket layer initialized
Aug 30 00:23:50 autokino kernel: [  417.333446] Bluetooth: RFCOMM ver 1.11
Aug 30 00:23:50 autokino kernel: [  417.336358] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Aug 30 00:23:50 autokino kernel: [  417.336387] Bluetooth: BNEP filters: protocol multicast
Aug 30 00:23:50 autokino kernel: [  417.336421] Bluetooth: BNEP socket layer initialized
 

Do you have an idea what I can do to get it a little bit faster? I've no problem with an insecure initialized /dev/random.

 

Thanks for any suggestions.

Bye