NEWS
CCU reagiert nicht mehr
-
… nutzt Ihr CCU.IO und ioBroker parallel? D.h. zwei Controller fragen permanent die schwachbrüstige CCU ab. Dies war bei mir die Ursache.
-
Es läuft nur ioBroker sonst nix weiter und wenn ioBroker gestartet schießt er die CCU2 komplett ab.
Somit liegt Ursache ganz klar im ioBroker.
-
Das log von iobroker zum Zeitpunkt wenn die ccu einfriert wäre hilfreich bei der fehlersuche. Läuft iobroker einfach nur so mit oder habt ihr scripte die Aktionen Ausführen bei denen auf homematic geräte zu gegriffen wird? Falls ja legt sie auf Eis und schaut ob es weiterhin passiert. Wenn das nichts hilft deaktviert mal alle anderen Adapter.
Gesendet von meinem Jolla mit Tapatalk
-
Hab den Fehler wahrscheinlich gefunden, werde es mir nochmal genau ansehen und berichten.
-
Hi!
Sorry, dass ich mich so spät erst wieder melde.
Ich habe nicht CCU.IO und ioBroker parallel lauifen, ich wollte komplett neu starten. Daher habe ich zuvor ein Backup der SD-Karte gemacht und habe es anschließend durch ein Image von ioBroker ersetzt. Insgesamt habe ich ioBroker inzwischen diverse Male neu aufgesetzt, immer auf andere Art und Weise: per Image, mit frischem Raspbian, einmal mit Jessy und einmal mit Wheezy und momentan aktuell, eine Wheezy Minimalinstallation bei der ich alle benötigten Komponenten nachträglich ergänzt habe, da ich es so schlank wie möglich haben wollte (ganz ohne X etc.).
Einzelne io.Prozesse scheinen jedoch weiterzulaufen, der "Hauptprozess" (iobroker.js-con) jedoch schmiert irgendwann weg. Da ich tagsüber nicht zu Hause bin, kriege ich es immer erst abends mit. Es vergeht allerdings kein Tag ohne Absturz. Momentan ist daher mein ioBroker offline. Im Log (/opt/iobroker/log/) steht Folgendes:
! 2016-01-12 14:40:33.519 - debug: inMem message * system.adapter.hm-rega.0.connected val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452547815
! 2016-01-12 14:40:33.531 - debug: inMem message * system.adapter.hm-rega.0.memRss val=73.97, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452604293
! 2016-01-12 14:40:33.534 - debug: inMem message * system.adapter.hm-rega.0.memHeapTotal val=44.35, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452557388
! 2016-01-12 14:40:33.537 - debug: inMem message * system.adapter.hm-rega.0.memHeapUsed val=26.37, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452606034
! 2016-01-12 14:40:33.539 - debug: inMem message * system.adapter.hm-rega.0.uptime val=58224, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452606034
! 2016-01-12 14:40:33.555 - debug: inMem message * hm-rega.0.alarms val=0, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452354933
! 2016-01-12 14:40:33.562 - debug: inMem message * hm-rega.0.maintenance val=0, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452606020
! 2016-01-12 14:40:33.569 - debug: inMem message * hm-rega.0.950 val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452354940
! 2016-01-12 14:40:33.603 - debug: inMem message * hm-rega.0.1233 val=false, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=0
! 2016-01-12 14:40:33.607 - debug: inMem message * hm-rega.0.1586 val=false, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452469239
! 2016-01-12 14:40:33.609 - debug: inMem message * hm-rega.0.2245 val=false, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452469239
! 2016-01-12 14:40:33.612 - debug: inMem message * hm-rega.0.2311 val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452546207
! 2016-01-12 14:40:33.615 - debug: inMem message * hm-rega.0.3321 val=2156.199997, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452458999
! 2016-01-12 14:40:33.617 - debug: inMem message * hm-rega.0.3740 val=h_29A8163E-B14C-4BD2-B6E1-EA270E43E560, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:40:33.620 - debug: inMem message * hm-rega.0.3741 val=Waschmaschine ist fertig!, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452464749
! 2016-01-12 14:40:33.623 - debug: inMem message * hm-rega.0.3755 val=3, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:40:33.625 - debug: inMem message * hm-rega.0.3821 val=0, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452467657
! 2016-01-12 14:40:33.628 - debug: inMem message * hm-rega.0.3927 val=JSC, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452556584
! 2016-01-12 14:40:33.631 - debug: inMem message * hm-rega.0.4416 val=385.100006, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452458144
! 2016-01-12 14:40:33.634 - debug: inMem message * hm-rega.0.4417 val=1452467473, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:40:33.636 - debug: inMem message * hm-rega.0.4472 val=4178.899994, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452389458
! 2016-01-12 14:40:33.639 - debug: inMem message * hm-rega.0.5049 val=1:48:11, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452398818
! 2016-01-12 14:40:33.805 - debug: inMem message * hm-rega.0.1482.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.813 - debug: inMem message * hm-rega.0.1525.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.818 - debug: inMem message * hm-rega.0.1560.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.838 - debug: inMem message * hm-rega.0.1751.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.841 - debug: inMem message * hm-rega.0.1912.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.844 - debug: inMem message * hm-rega.0.2370.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.847 - debug: inMem message * hm-rega.0.2398.Active val=false, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.850 - debug: inMem message * hm-rega.0.2602.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.852 - debug: inMem message * hm-rega.0.2613.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.855 - debug: inMem message * hm-rega.0.2624.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.859 - debug: inMem message * hm-rega.0.2677.Active val=false, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.878 - debug: inMem message * hm-rega.0.3117.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.882 - debug: inMem message * hm-rega.0.3156.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.885 - debug: inMem message * hm-rega.0.3270.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.889 - debug: inMem message * hm-rega.0.3281.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.892 - debug: inMem message * hm-rega.0.3669.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.894 - debug: inMem message * hm-rega.0.3742.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.897 - debug: inMem message * hm-rega.0.3767.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.900 - debug: inMem message * hm-rega.0.3928.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:33.903 - debug: inMem message * hm-rega.0.4941.Active val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:34.051 - debug: inMem message * system.adapter.hm-rpc.0.alive val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rpc.0, lc=1452547810
! 2016-01-12 14:40:34.056 - debug: inMem message * system.adapter.hm-rpc.0.connected val=true, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rpc.0, lc=1452547810
! 2016-01-12 14:40:34.087 - debug: inMem message * system.adapter.hm-rpc.0.memRss val=65.26, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rpc.0, lc=1452589613
! 2016-01-12 14:40:34.091 - debug: inMem message * system.adapter.hm-rpc.0.memHeapTotal val=51.15, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rpc.0, lc=1452551967
! 2016-01-12 14:40:34.095 - debug: inMem message * system.adapter.hm-rpc.0.memHeapUsed val=18.36, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rpc.0, lc=1452606034
! 2016-01-12 14:40:34.098 - debug: inMem message * system.adapter.hm-rpc.0.uptime val=58228, ack=true, ts=1452606034, q=0, from=system.adapter.hm-rpc.0, lc=1452606034
! 2016-01-12 14:40:35.729 - debug: inMem message * system.adapter.hmm.0.alive val=true, ack=true, ts=1452606036, q=0, from=system.adapter.hmm.0, lc=1452547818
! 2016-01-12 14:40:35.747 - debug: inMem message * system.adapter.hmm.0.connected val=true, ack=true, ts=1452606036, q=0, from=system.adapter.hmm.0, lc=1452547818
! 2016-01-12 14:40:35.752 - debug: inMem message * system.adapter.hmm.0.memRss val=42.3, ack=true, ts=1452606036, q=0, from=system.adapter.hmm.0, lc=1452605570
! 2016-01-12 14:40:35.756 - debug: inMem message * system.adapter.hmm.0.memHeapTotal val=30.81, ack=true, ts=1452606036, q=0, from=system.adapter.hmm.0, lc=1452600451
! 2016-01-12 14:40:35.760 - debug: inMem message * system.adapter.hmm.0.memHeapUsed val=12.45, ack=true, ts=1452606036, q=0, from=system.adapter.hmm.0, lc=1452606036
! 2016-01-12 14:40:35.763 - debug: inMem message * system.adapter.hmm.0.uptime val=58222, ack=true, ts=1452606036, q=0, from=system.adapter.hmm.0, lc=1452606036
! 2016-01-12 14:40:38.925 - debug: inMem message * system.adapter.fritzbox.0.alive val=true, ack=true, ts=1452606039, q=0, from=system.adapter.fritzbox.0, lc=1452547822
! 2016-01-12 14:40:38.938 - debug: inMem message * system.adapter.fritzbox.0.connected val=true, ack=true, ts=1452606039, q=0, from=system.adapter.fritzbox.0, lc=1452547822
! 2016-01-12 14:40:38.962 - debug: inMem message * system.adapter.fritzbox.0.memRss val=44.31, ack=true, ts=1452606039, q=0, from=system.adapter.fritzbox.0, lc=1452604988
! 2016-01-12 14:40:38.967 - debug: inMem message * system.adapter.fritzbox.0.memHeapTotal val=30.81, ack=true, ts=1452606039, q=0, from=system.adapter.fritzbox.0, lc=1452597947
! 2016-01-12 14:40:38.971 - debug: inMem message * system.adapter.fritzbox.0.memHeapUsed val=17, ack=true, ts=1452606039, q=0, from=system.adapter.fritzbox.0, lc=1452606039
! 2016-01-12 14:40:38.974 - debug: inMem message * system.adapter.fritzbox.0.uptime val=58221, ack=true, ts=1452606039, q=0, from=system.adapter.fritzbox.0, lc=1452606039
! 2016-01-12 14:40:43.092 - debug: inMem message * system.adapter.web.0.alive val=true, ack=true, ts=1452606043, q=0, from=system.adapter.web.0, lc=1452547826
! 2016-01-12 14:40:43.095 - debug: inMem message * system.adapter.web.0.connected val=true, ack=true, ts=1452606043, q=0, from=system.adapter.web.0, lc=1452547826
! 2016-01-12 14:40:43.105 - debug: inMem message * system.adapter.web.0.memRss val=87.26, ack=true, ts=1452606043, q=0, from=system.adapter.web.0, lc=1452605968
! 2016-01-12 14:40:43.108 - debug: inMem message * system.adapter.web.0.memHeapTotal val=63.71, ack=true, ts=1452606043, q=0, from=system.adapter.web.0, lc=1452597996
! 2016-01-12 14:40:43.110 - debug: inMem message * system.adapter.web.0.memHeapUsed val=49.68, ack=true, ts=1452606043, q=0, from=system.adapter.web.0, lc=1452606043
! 2016-01-12 14:40:43.112 - debug: inMem message * system.adapter.web.0.uptime val=58221, ack=true, ts=1452606043, q=0, from=system.adapter.web.0, lc=1452606043
! 2016-01-12 14:40:43.561 - debug: inMem message * hm-rega.0.alarms val=0, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452354933
! 2016-01-12 14:40:43.570 - debug: inMem message * hm-rega.0.maintenance val=0, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452606020
! 2016-01-12 14:40:43.577 - debug: inMem message * hm-rega.0.950 val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452354940
! 2016-01-12 14:40:43.588 - debug: inMem message * hm-rega.0.1233 val=false, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=0
! 2016-01-12 14:40:43.591 - debug: inMem message * hm-rega.0.1586 val=false, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452469239
! 2016-01-12 14:40:43.601 - debug: inMem message * hm-rega.0.2245 val=false, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452469239
! 2016-01-12 14:40:43.638 - debug: inMem message * hm-rega.0.2311 val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452546207
! 2016-01-12 14:40:43.642 - debug: inMem message * hm-rega.0.3321 val=2156.199997, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452458999
! 2016-01-12 14:40:43.645 - debug: inMem message * hm-rega.0.3740 val=h_29A8163E-B14C-4BD2-B6E1-EA270E43E560, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:40:43.649 - debug: inMem message * hm-rega.0.3741 val=Waschmaschine ist fertig!, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452464749
! 2016-01-12 14:40:43.652 - debug: inMem message * hm-rega.0.3755 val=3, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:40:43.654 - debug: inMem message * hm-rega.0.3821 val=0, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452467657
! 2016-01-12 14:40:43.657 - debug: inMem message * hm-rega.0.3927 val=JSC, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452556584
! 2016-01-12 14:40:43.659 - debug: inMem message * hm-rega.0.4416 val=385.100006, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452458144
! 2016-01-12 14:40:43.661 - debug: inMem message * hm-rega.0.4417 val=1452467473, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:40:43.664 - debug: inMem message * hm-rega.0.4472 val=4178.899994, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452389458
! 2016-01-12 14:40:43.667 - debug: inMem message * hm-rega.0.5049 val=1:48:11, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452398818
! 2016-01-12 14:40:43.816 - debug: inMem message * hm-rega.0.1482.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.823 - debug: inMem message * hm-rega.0.1525.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.839 - debug: inMem message * hm-rega.0.1560.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.843 - debug: inMem message * hm-rega.0.1751.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.846 - debug: inMem message * hm-rega.0.1912.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.849 - debug: inMem message * hm-rega.0.2370.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.851 - debug: inMem message * hm-rega.0.2398.Active val=false, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.855 - debug: inMem message * hm-rega.0.2602.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.893 - debug: inMem message * hm-rega.0.2613.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.897 - debug: inMem message * hm-rega.0.2624.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.900 - debug: inMem message * hm-rega.0.2677.Active val=false, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.903 - debug: inMem message * hm-rega.0.3117.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.907 - debug: inMem message * hm-rega.0.3156.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.909 - debug: inMem message * hm-rega.0.3270.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.912 - debug: inMem message * hm-rega.0.3281.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.914 - debug: inMem message * hm-rega.0.3669.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.916 - debug: inMem message * hm-rega.0.3742.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.918 - debug: inMem message * hm-rega.0.3767.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.920 - debug: inMem message * hm-rega.0.3928.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:43.922 - debug: inMem message * hm-rega.0.4941.Active val=true, ack=true, ts=1452606044, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:44.069 - debug: inMem message * system.adapter.history.0.alive val=true, ack=true, ts=1452606044, q=0, from=system.adapter.history.0, lc=1452555607
! 2016-01-12 14:40:44.075 - debug: inMem message * system.adapter.history.0.connected val=true, ack=true, ts=1452606044, q=0, from=system.adapter.history.0, lc=1452555607
! 2016-01-12 14:40:44.090 - debug: inMem message * system.adapter.history.0.memRss val=40.95, ack=true, ts=1452606044, q=0, from=system.adapter.history.0, lc=1452605819
! 2016-01-12 14:40:44.096 - debug: inMem message * system.adapter.history.0.memHeapTotal val=29.84, ack=true, ts=1452606044, q=0, from=system.adapter.history.0, lc=1452590358
! 2016-01-12 14:40:44.100 - debug: inMem message * system.adapter.history.0.memHeapUsed val=11.73, ack=true, ts=1452606044, q=0, from=system.adapter.history.0, lc=1452606044
! 2016-01-12 14:40:44.103 - debug: inMem message * system.adapter.history.0.uptime val=50440, ack=true, ts=1452606044, q=0, from=system.adapter.history.0, lc=1452606044
! 2016-01-12 14:40:44.728 - debug: inMem message * system.host.raspberrypi.alive val=true, ack=true, ts=1452606045, q=0, from=system.host.raspberrypi, lc=1452547802
! 2016-01-12 14:40:44.746 - debug: inMem message * system.host.raspberrypi.load val=0, ack=true, ts=1452606045, q=0, from=system.host.raspberrypi, lc=1452606030
! 2016-01-12 14:40:44.752 - debug: inMem message * system.host.raspberrypi.mem val=1, ack=true, ts=1452606045, q=0, from=system.host.raspberrypi, lc=1452579657
! 2016-01-12 14:40:44.756 - debug: inMem message * system.host.raspberrypi.memRss val=111.87, ack=true, ts=1452606045, q=0, from=system.host.raspberrypi, lc=1452603176
! 2016-01-12 14:40:44.760 - debug: inMem message * system.host.raspberrypi.memHeapTotal val=55.32, ack=true, ts=1452606045, q=0, from=system.host.raspberrypi, lc=1452559308
! 2016-01-12 14:40:44.763 - debug: inMem message * system.host.raspberrypi.memHeapUsed val=30.12, ack=true, ts=1452606045, q=0, from=system.host.raspberrypi, lc=1452606045
! 2016-01-12 14:40:44.766 - debug: inMem message * system.host.raspberrypi.uptime val=58251, ack=true, ts=1452606045, q=0, from=system.host.raspberrypi, lc=1452606045
! 2016-01-12 14:40:45.494 - debug: inMem message * system.adapter.node-red.0.alive val=true, ack=true, ts=1452606045, q=0, from=system.adapter.node-red.0, lc=1452547875
! 2016-01-12 14:40:45.517 - debug: inMem message * system.adapter.node-red.0.connected val=true, ack=true, ts=1452606045, q=0, from=system.adapter.node-red.0, lc=1452547875
! 2016-01-12 14:40:45.521 - debug: inMem message * system.adapter.node-red.0.memRss val=46.68, ack=true, ts=1452606046, q=0, from=system.adapter.node-red.0, lc=1452605760
! 2016-01-12 14:40:45.525 - debug: inMem message * system.adapter.node-red.0.memHeapTotal val=33.72, ack=true, ts=1452606046, q=0, from=system.adapter.node-red.0, lc=1452605385
! 2016-01-12 14:40:45.530 - debug: inMem message * system.adapter.node-red.0.memHeapUsed val=18.4, ack=true, ts=1452606046, q=0, from=system.adapter.node-red.0, lc=1452606046
! 2016-01-12 14:40:45.535 - debug: inMem message * system.adapter.node-red.0.uptime val=58176, ack=true, ts=1452606046, q=0, from=system.adapter.node-red.0, lc=1452606046
! 2016-01-12 14:40:45.659 - debug: inMem message * system.adapter.hm-rpc.0.connected val=true, ack=false, ts=1452606046, q=0, lc=1452547810
! 2016-01-12 14:40:45.668 - debug: inMem message * hm-rpc.0.CENTRAL.PONG val=hm-rpc.0, ack=true, ts=1452606046, q=0, from=system.adapter.hm-rpc.0, lc=1452457831
! 2016-01-12 14:40:45.981 - debug: inMem message * system.adapter.sayit.0.alive val=true, ack=true, ts=1452606046, q=0, from=system.adapter.sayit.0, lc=1452547829
! 2016-01-12 14:40:45.991 - debug: inMem message * system.adapter.sayit.0.connected val=true, ack=true, ts=1452606046, q=0, from=system.adapter.sayit.0, lc=1452547829
! 2016-01-12 14:40:46.009 - debug: inMem message * system.adapter.sayit.0.memRss val=42.79, ack=true, ts=1452606046, q=0, from=system.adapter.sayit.0, lc=1452605445
! 2016-01-12 14:40:46.014 - debug: inMem message * system.adapter.sayit.0.memHeapTotal val=30.81, ack=true, ts=1452606046, q=0, from=system.adapter.sayit.0, lc=1452600522
! 2016-01-12 14:40:46.019 - debug: inMem message * system.adapter.sayit.0.memHeapUsed val=12.72, ack=true, ts=1452606046, q=0, from=system.adapter.sayit.0, lc=1452606046
! 2016-01-12 14:40:46.022 - debug: inMem message * system.adapter.sayit.0.uptime val=58220, ack=true, ts=1452606046, q=0, from=system.adapter.sayit.0, lc=1452606046
! 2016-01-12 14:40:46.295 - debug: inMem message * system.adapter.admin.0.alive val=true, ack=true, ts=1452606046, q=0, from=system.adapter.admin.0, lc=1452547809
! 2016-01-12 14:40:46.314 - debug: inMem message * system.adapter.admin.0.connected val=true, ack=true, ts=1452606046, q=0, from=system.adapter.admin.0, lc=1452547809
! 2016-01-12 14:40:46.320 - debug: inMem message * system.adapter.admin.0.memRss val=106.6, ack=true, ts=1452606046, q=0, from=system.adapter.admin.0, lc=1452588865
! 2016-01-12 14:40:46.323 - debug: inMem message * system.adapter.admin.0.memHeapTotal val=52.1, ack=true, ts=1452606046, q=0, from=system.adapter.admin.0, lc=1452561344
! 2016-01-12 14:40:46.327 - debug: inMem message * system.adapter.admin.0.memHeapUsed val=16.13, ack=true, ts=1452606046, q=0, from=system.adapter.admin.0, lc=1452606046
! 2016-01-12 14:40:46.330 - debug: inMem message * system.adapter.admin.0.uptime val=58244, ack=true, ts=1452606046, q=0, from=system.adapter.admin.0, lc=1452606046
! 2016-01-12 14:40:46.342 - debug: inMem message * system.adapter.javascript.0.alive val=true, ack=true, ts=1452606046, q=0, from=system.adapter.javascript.0, lc=1452547872
! 2016-01-12 14:40:46.348 - debug: inMem message * system.adapter.javascript.0.connected val=true, ack=true, ts=1452606046, q=0, from=system.adapter.javascript.0, lc=1452547872
! 2016-01-12 14:40:46.364 - debug: inMem message * system.adapter.javascript.0.memRss val=82.41, ack=true, ts=1452606046, q=0, from=system.adapter.javascript.0, lc=1452572524
! 2016-01-12 14:40:46.369 - debug: inMem message * system.adapter.javascript.0.memHeapTotal val=43.39, ack=true, ts=1452606046, q=0, from=system.adapter.javascript.0, lc=1452561030
! 2016-01-12 14:40:46.374 - debug: inMem message * system.adapter.javascript.0.memHeapUsed val=19.52, ack=true, ts=1452606046, q=0, from=system.adapter.javascript.0, lc=1452606046
! 2016-01-12 14:40:46.377 - debug: inMem message * system.adapter.javascript.0.uptime val=58180, ack=true, ts=1452606046, q=0, from=system.adapter.javascript.0, lc=1452606046
! 2016-01-12 14:40:48.518 - debug: inMem message * system.adapter.hm-rega.0.alive val=true, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rega.0, lc=1452547815
! 2016-01-12 14:40:48.531 - debug: inMem message * system.adapter.hm-rega.0.connected val=true, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rega.0, lc=1452547815
! 2016-01-12 14:40:48.535 - debug: inMem message * system.adapter.hm-rega.0.memRss val=73.97, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rega.0, lc=1452604293
! 2016-01-12 14:40:48.538 - debug: inMem message * system.adapter.hm-rega.0.memHeapTotal val=44.35, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rega.0, lc=1452557388
! 2016-01-12 14:40:48.540 - debug: inMem message * system.adapter.hm-rega.0.memHeapUsed val=20.02, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rega.0, lc=1452606049
! 2016-01-12 14:40:48.542 - debug: inMem message * system.adapter.hm-rega.0.uptime val=58239, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rega.0, lc=1452606049
! 2016-01-12 14:40:49.056 - debug: inMem message * system.adapter.hm-rpc.0.alive val=true, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rpc.0, lc=1452547810
! 2016-01-12 14:40:49.070 - debug: inMem message * system.adapter.hm-rpc.0.connected val=true, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rpc.0, lc=1452547810
! 2016-01-12 14:40:49.087 - debug: inMem message * system.adapter.hm-rpc.0.memRss val=65.26, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rpc.0, lc=1452589613
! 2016-01-12 14:40:49.092 - debug: inMem message * system.adapter.hm-rpc.0.memHeapTotal val=51.15, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rpc.0, lc=1452551967
! 2016-01-12 14:40:49.099 - debug: inMem message * system.adapter.hm-rpc.0.memHeapUsed val=18.59, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rpc.0, lc=1452606049
! 2016-01-12 14:40:49.103 - debug: inMem message * system.adapter.hm-rpc.0.uptime val=58243, ack=true, ts=1452606049, q=0, from=system.adapter.hm-rpc.0, lc=1452606049
! 2016-01-12 14:40:50.749 - debug: inMem message * system.adapter.hmm.0.alive val=true, ack=true, ts=1452606051, q=0, from=system.adapter.hmm.0, lc=1452547818
! 2016-01-12 14:40:50.771 - debug: inMem message * system.adapter.hmm.0.connected val=true, ack=true, ts=1452606051, q=0, from=system.adapter.hmm.0, lc=1452547818
! 2016-01-12 14:40:50.776 - debug: inMem message * system.adapter.hmm.0.memRss val=42.3, ack=true, ts=1452606051, q=0, from=system.adapter.hmm.0, lc=1452605570
! 2016-01-12 14:40:50.779 - debug: inMem message * system.adapter.hmm.0.memHeapTotal val=30.81, ack=true, ts=1452606051, q=0, from=system.adapter.hmm.0, lc=1452600451
! 2016-01-12 14:40:50.782 - debug: inMem message * system.adapter.hmm.0.memHeapUsed val=12.46, ack=true, ts=1452606051, q=0, from=system.adapter.hmm.0, lc=1452606051
! 2016-01-12 14:40:50.785 - debug: inMem message * system.adapter.hmm.0.uptime val=58237, ack=true, ts=1452606051, q=0, from=system.adapter.hmm.0, lc=1452606051
! 2016-01-12 14:40:53.566 - debug: inMem message * hm-rega.0.alarms val=0, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452354933
! 2016-01-12 14:40:53.583 - debug: inMem message * hm-rega.0.maintenance val=0, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452606020
! 2016-01-12 14:40:53.586 - debug: inMem message * hm-rega.0.950 val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452354940
! 2016-01-12 14:40:53.593 - debug: inMem message * hm-rega.0.1233 val=false, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=0
! 2016-01-12 14:40:53.596 - debug: inMem message * hm-rega.0.1586 val=false, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452469239
! 2016-01-12 14:40:53.599 - debug: inMem message * hm-rega.0.2245 val=false, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452469239
! 2016-01-12 14:40:53.601 - debug: inMem message * hm-rega.0.2311 val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452546207
! 2016-01-12 14:40:53.604 - debug: inMem message * hm-rega.0.3321 val=2156.199997, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452458999
! 2016-01-12 14:40:53.607 - debug: inMem message * hm-rega.0.3740 val=h_29A8163E-B14C-4BD2-B6E1-EA270E43E560, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:40:53.627 - debug: inMem message * hm-rega.0.3741 val=Waschmaschine ist fertig!, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452464749
! 2016-01-12 14:40:53.630 - debug: inMem message * hm-rega.0.3755 val=3, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:40:53.632 - debug: inMem message * hm-rega.0.3821 val=0, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452467657
! 2016-01-12 14:40:53.635 - debug: inMem message * hm-rega.0.3927 val=JSC, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452556584
! 2016-01-12 14:40:53.644 - debug: inMem message * hm-rega.0.4416 val=385.100006, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452458144
! 2016-01-12 14:40:53.647 - debug: inMem message * hm-rega.0.4417 val=1452467473, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:40:53.649 - debug: inMem message * hm-rega.0.4472 val=4178.899994, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452389458
! 2016-01-12 14:40:53.650 - debug: inMem message * hm-rega.0.5049 val=1:48:11, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452398818
! 2016-01-12 14:40:53.818 - debug: inMem message * hm-rega.0.1482.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.826 - debug: inMem message * hm-rega.0.1525.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.831 - debug: inMem message * hm-rega.0.1560.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.859 - debug: inMem message * hm-rega.0.1751.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.864 - debug: inMem message * hm-rega.0.1912.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.867 - debug: inMem message * hm-rega.0.2370.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.870 - debug: inMem message * hm-rega.0.2398.Active val=false, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.873 - debug: inMem message * hm-rega.0.2602.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.877 - debug: inMem message * hm-rega.0.2613.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.879 - debug: inMem message * hm-rega.0.2624.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.882 - debug: inMem message * hm-rega.0.2677.Active val=false, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.884 - debug: inMem message * hm-rega.0.3117.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.888 - debug: inMem message * hm-rega.0.3156.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.890 - debug: inMem message * hm-rega.0.3270.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.898 - debug: inMem message * hm-rega.0.3281.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.902 - debug: inMem message * hm-rega.0.3669.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.905 - debug: inMem message * hm-rega.0.3742.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.907 - debug: inMem message * hm-rega.0.3767.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.910 - debug: inMem message * hm-rega.0.3928.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.912 - debug: inMem message * hm-rega.0.4941.Active val=true, ack=true, ts=1452606054, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:40:53.943 - debug: inMem message * system.adapter.fritzbox.0.alive val=true, ack=true, ts=1452606054, q=0, from=system.adapter.fritzbox.0, lc=1452547822
! 2016-01-12 14:40:53.954 - debug: inMem message * system.adapter.fritzbox.0.connected val=true, ack=true, ts=1452606054, q=0, from=system.adapter.fritzbox.0, lc=1452547822
! 2016-01-12 14:40:53.958 - debug: inMem message * system.adapter.fritzbox.0.memRss val=44.31, ack=true, ts=1452606054, q=0, from=system.adapter.fritzbox.0, lc=1452604988
! 2016-01-12 14:40:53.961 - debug: inMem message * system.adapter.fritzbox.0.memHeapTotal val=30.81, ack=true, ts=1452606054, q=0, from=system.adapter.fritzbox.0, lc=1452597947
! 2016-01-12 14:40:53.963 - debug: inMem message * system.adapter.fritzbox.0.memHeapUsed val=17.01, ack=true, ts=1452606054, q=0, from=system.adapter.fritzbox.0, lc=1452606054
! 2016-01-12 14:40:53.965 - debug: inMem message * system.adapter.fritzbox.0.uptime val=58236, ack=true, ts=1452606054, q=0, from=system.adapter.fritzbox.0, lc=1452606054
! 2016-01-12 14:40:58.111 - debug: inMem message * system.adapter.web.0.alive val=true, ack=true, ts=1452606058, q=0, from=system.adapter.web.0, lc=1452547826
! 2016-01-12 14:40:58.127 - debug: inMem message * system.adapter.web.0.connected val=true, ack=true, ts=1452606058, q=0, from=system.adapter.web.0, lc=1452547826
! 2016-01-12 14:40:58.133 - debug: inMem message * system.adapter.web.0.memRss val=87.26, ack=true, ts=1452606058, q=0, from=system.adapter.web.0, lc=1452605968
! 2016-01-12 14:40:58.138 - debug: inMem message * system.adapter.web.0.memHeapTotal val=63.71, ack=true, ts=1452606058, q=0, from=system.adapter.web.0, lc=1452597996
! 2016-01-12 14:40:58.142 - debug: inMem message * system.adapter.web.0.memHeapUsed val=49.7, ack=true, ts=1452606058, q=0, from=system.adapter.web.0, lc=1452606058
! 2016-01-12 14:40:58.161 - debug: inMem message * system.adapter.web.0.uptime val=58236, ack=true, ts=1452606058, q=0, from=system.adapter.web.0, lc=1452606058
! 2016-01-12 14:40:59.077 - debug: inMem message * system.adapter.history.0.alive val=true, ack=true, ts=1452606059, q=0, from=system.adapter.history.0, lc=1452555607
! 2016-01-12 14:40:59.100 - debug: inMem message * system.adapter.history.0.connected val=true, ack=true, ts=1452606059, q=0, from=system.adapter.history.0, lc=1452555607
! 2016-01-12 14:40:59.106 - debug: inMem message * system.adapter.history.0.memRss val=40.95, ack=true, ts=1452606059, q=0, from=system.adapter.history.0, lc=1452605819
! 2016-01-12 14:40:59.111 - debug: inMem message * system.adapter.history.0.memHeapTotal val=29.84, ack=true, ts=1452606059, q=0, from=system.adapter.history.0, lc=1452590358
! 2016-01-12 14:40:59.114 - debug: inMem message * system.adapter.history.0.memHeapUsed val=11.74, ack=true, ts=1452606059, q=0, from=system.adapter.history.0, lc=1452606059
! 2016-01-12 14:40:59.117 - debug: inMem message * system.adapter.history.0.uptime val=50455, ack=true, ts=1452606059, q=0, from=system.adapter.history.0, lc=1452606059
! 2016-01-12 14:40:59.747 - debug: inMem message * system.host.raspberrypi.alive val=true, ack=true, ts=1452606060, q=0, from=system.host.raspberrypi, lc=1452547802
! 2016-01-12 14:40:59.764 - debug: inMem message * system.host.raspberrypi.load val=0, ack=true, ts=1452606060, q=0, from=system.host.raspberrypi, lc=1452606030
! 2016-01-12 14:40:59.770 - debug: inMem message * system.host.raspberrypi.mem val=1, ack=true, ts=1452606060, q=0, from=system.host.raspberrypi, lc=1452579657
! 2016-01-12 14:40:59.773 - debug: inMem message * system.host.raspberrypi.memRss val=111.87, ack=true, ts=1452606060, q=0, from=system.host.raspberrypi, lc=1452603176
! 2016-01-12 14:40:59.777 - debug: inMem message * system.host.raspberrypi.memHeapTotal val=55.32, ack=true, ts=1452606060, q=0, from=system.host.raspberrypi, lc=1452559308
! 2016-01-12 14:40:59.781 - debug: inMem message * system.host.raspberrypi.memHeapUsed val=31.48, ack=true, ts=1452606060, q=0, from=system.host.raspberrypi, lc=1452606060
! 2016-01-12 14:40:59.784 - debug: inMem message * system.host.raspberrypi.uptime val=58266, ack=true, ts=1452606060, q=0, from=system.host.raspberrypi, lc=1452606060
! 2016-01-12 14:41:00.497 - debug: inMem message * system.adapter.node-red.0.alive val=true, ack=true, ts=1452606060, q=0, from=system.adapter.node-red.0, lc=1452547875
! 2016-01-12 14:41:00.517 - debug: inMem message * system.adapter.node-red.0.connected val=true, ack=true, ts=1452606060, q=0, from=system.adapter.node-red.0, lc=1452547875
! 2016-01-12 14:41:00.522 - debug: inMem message * system.adapter.node-red.0.memRss val=46.68, ack=true, ts=1452606061, q=0, from=system.adapter.node-red.0, lc=1452605760
! 2016-01-12 14:41:00.526 - debug: inMem message * system.adapter.node-red.0.memHeapTotal val=33.72, ack=true, ts=1452606061, q=0, from=system.adapter.node-red.0, lc=1452605385
! 2016-01-12 14:41:00.529 - debug: inMem message * system.adapter.node-red.0.memHeapUsed val=18.43, ack=true, ts=1452606061, q=0, from=system.adapter.node-red.0, lc=1452606061
! 2016-01-12 14:41:00.533 - debug: inMem message * system.adapter.node-red.0.uptime val=58191, ack=true, ts=1452606061, q=0, from=system.adapter.node-red.0, lc=1452606061
! 2016-01-12 14:41:01.002 - debug: inMem message * system.adapter.sayit.0.alive val=true, ack=true, ts=1452606061, q=0, from=system.adapter.sayit.0, lc=1452547829
! 2016-01-12 14:41:01.024 - debug: inMem message * system.adapter.sayit.0.connected val=true, ack=true, ts=1452606061, q=0, from=system.adapter.sayit.0, lc=1452547829
! 2016-01-12 14:41:01.029 - debug: inMem message * system.adapter.sayit.0.memRss val=42.79, ack=true, ts=1452606061, q=0, from=system.adapter.sayit.0, lc=1452605445
! 2016-01-12 14:41:01.033 - debug: inMem message * system.adapter.sayit.0.memHeapTotal val=30.81, ack=true, ts=1452606061, q=0, from=system.adapter.sayit.0, lc=1452600522
! 2016-01-12 14:41:01.038 - debug: inMem message * system.adapter.sayit.0.memHeapUsed val=12.73, ack=true, ts=1452606061, q=0, from=system.adapter.sayit.0, lc=1452606061
! 2016-01-12 14:41:01.041 - debug: inMem message * system.adapter.sayit.0.uptime val=58235, ack=true, ts=1452606061, q=0, from=system.adapter.sayit.0, lc=1452606061
! 2016-01-12 14:41:01.294 - debug: inMem message * system.adapter.admin.0.alive val=true, ack=true, ts=1452606061, q=0, from=system.adapter.admin.0, lc=1452547809
! 2016-01-12 14:41:01.307 - debug: inMem message * system.adapter.admin.0.connected val=true, ack=true, ts=1452606061, q=0, from=system.adapter.admin.0, lc=1452547809
! 2016-01-12 14:41:01.324 - debug: inMem message * system.adapter.admin.0.memRss val=106.6, ack=true, ts=1452606061, q=0, from=system.adapter.admin.0, lc=1452588865
! 2016-01-12 14:41:01.329 - debug: inMem message * system.adapter.admin.0.memHeapTotal val=52.1, ack=true, ts=1452606061, q=0, from=system.adapter.admin.0, lc=1452561344
! 2016-01-12 14:41:01.334 - debug: inMem message * system.adapter.admin.0.memHeapUsed val=16.86, ack=true, ts=1452606061, q=0, from=system.adapter.admin.0, lc=1452606061
! 2016-01-12 14:41:01.337 - debug: inMem message * system.adapter.admin.0.uptime val=58259, ack=true, ts=1452606061, q=0, from=system.adapter.admin.0, lc=1452606061
! 2016-01-12 14:41:01.348 - debug: inMem message * system.adapter.javascript.0.alive val=true, ack=true, ts=1452606061, q=0, from=system.adapter.javascript.0, lc=1452547872
! 2016-01-12 14:41:01.354 - debug: inMem message * system.adapter.javascript.0.connected val=true, ack=true, ts=1452606061, q=0, from=system.adapter.javascript.0, lc=1452547872
! 2016-01-12 14:41:01.370 - debug: inMem message * system.adapter.javascript.0.memRss val=82.41, ack=true, ts=1452606061, q=0, from=system.adapter.javascript.0, lc=1452572524
! 2016-01-12 14:41:01.376 - debug: inMem message * system.adapter.javascript.0.memHeapTotal val=43.39, ack=true, ts=1452606061, q=0, from=system.adapter.javascript.0, lc=1452561030
! 2016-01-12 14:41:01.380 - debug: inMem message * system.adapter.javascript.0.memHeapUsed val=13.46, ack=true, ts=1452606061, q=0, from=system.adapter.javascript.0, lc=1452606061
! 2016-01-12 14:41:01.383 - debug: inMem message * system.adapter.javascript.0.uptime val=58195, ack=true, ts=1452606061, q=0, from=system.adapter.javascript.0, lc=1452606061
! 2016-01-12 14:41:03.529 - debug: inMem message * system.adapter.hm-rega.0.alive val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452547815
! 2016-01-12 14:41:03.537 - debug: inMem message * system.adapter.hm-rega.0.connected val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452547815
! 2016-01-12 14:41:03.546 - debug: inMem message * system.adapter.hm-rega.0.memRss val=73.97, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452604293
! 2016-01-12 14:41:03.554 - debug: inMem message * system.adapter.hm-rega.0.memHeapTotal val=44.35, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452557388
! 2016-01-12 14:41:03.557 - debug: inMem message * system.adapter.hm-rega.0.memHeapUsed val=20.54, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452606064
! 2016-01-12 14:41:03.558 - debug: inMem message * system.adapter.hm-rega.0.uptime val=58254, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452606064
! 2016-01-12 14:41:03.573 - debug: inMem message * hm-rega.0.alarms val=0, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452354933
! 2016-01-12 14:41:03.580 - debug: inMem message * hm-rega.0.maintenance val=0, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452606020
! 2016-01-12 14:41:03.594 - debug: inMem message * hm-rega.0.950 val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452354940
! 2016-01-12 14:41:03.598 - debug: inMem message * hm-rega.0.1233 val=false, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=0
! 2016-01-12 14:41:03.600 - debug: inMem message * hm-rega.0.1586 val=false, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452469239
! 2016-01-12 14:41:03.603 - debug: inMem message * hm-rega.0.2245 val=false, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452469239
! 2016-01-12 14:41:03.610 - debug: inMem message * hm-rega.0.2311 val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452546207
! 2016-01-12 14:41:03.635 - debug: inMem message * hm-rega.0.3321 val=2156.199997, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452458999
! 2016-01-12 14:41:03.639 - debug: inMem message * hm-rega.0.3740 val=h_29A8163E-B14C-4BD2-B6E1-EA270E43E560, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:41:03.641 - debug: inMem message * hm-rega.0.3741 val=Waschmaschine ist fertig!, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452464749
! 2016-01-12 14:41:03.644 - debug: inMem message * hm-rega.0.3755 val=3, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:41:03.647 - debug: inMem message * hm-rega.0.3821 val=0, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452467657
! 2016-01-12 14:41:03.649 - debug: inMem message * hm-rega.0.3927 val=JSC, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452556584
! 2016-01-12 14:41:03.652 - debug: inMem message * hm-rega.0.4416 val=385.100006, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452458144
! 2016-01-12 14:41:03.654 - debug: inMem message * hm-rega.0.4417 val=1452467473, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452354931
! 2016-01-12 14:41:03.657 - debug: inMem message * hm-rega.0.4472 val=4178.899994, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452389458
! 2016-01-12 14:41:03.660 - debug: inMem message * hm-rega.0.5049 val=1:48:11, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452398818
! 2016-01-12 14:41:03.823 - debug: inMem message * hm-rega.0.1482.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.831 - debug: inMem message * hm-rega.0.1525.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.837 - debug: inMem message * hm-rega.0.1560.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.858 - debug: inMem message * hm-rega.0.1751.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.861 - debug: inMem message * hm-rega.0.1912.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.864 - debug: inMem message * hm-rega.0.2370.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.868 - debug: inMem message * hm-rega.0.2398.Active val=false, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.871 - debug: inMem message * hm-rega.0.2602.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.874 - debug: inMem message * hm-rega.0.2613.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.876 - debug: inMem message * hm-rega.0.2624.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.880 - debug: inMem message * hm-rega.0.2677.Active val=false, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.898 - debug: inMem message * hm-rega.0.3117.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.902 - debug: inMem message * hm-rega.0.3156.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.905 - debug: inMem message * hm-rega.0.3270.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.908 - debug: inMem message * hm-rega.0.3281.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.911 - debug: inMem message * hm-rega.0.3669.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.914 - debug: inMem message * hm-rega.0.3742.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.916 - debug: inMem message * hm-rega.0.3767.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.919 - debug: inMem message * hm-rega.0.3928.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:03.920 - debug: inMem message * hm-rega.0.4941.Active val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rega.0, lc=1452457749
! 2016-01-12 14:41:04.082 - debug: inMem message * system.adapter.hm-rpc.0.alive val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rpc.0, lc=1452547810
! 2016-01-12 14:41:04.090 - debug: inMem message * system.adapter.hm-rpc.0.connected val=true, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rpc.0, lc=1452547810
! 2016-01-12 14:41:04.103 - debug: inMem message * system.adapter.hm-rpc.0.memRss val=65.26, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rpc.0, lc=1452589613
! 2016-01-12 14:41:04.109 - debug: inMem message * system.adapter.hm-rpc.0.memHeapTotal val=51.15, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rpc.0, lc=1452551967
! 2016-01-12 14:41:04.115 - debug: inMem message * system.adapter.hm-rpc.0.memHeapUsed val=18.6, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rpc.0, lc=1452606064
! 2016-01-12 14:41:04.121 - debug: inMem message * system.adapter.hm-rpc.0.uptime val=58258, ack=true, ts=1452606064, q=0, from=system.adapter.hm-rpc.0, lc=1452606064
! 2016-01-12 14:41:05.761 - debug: inMem message * system.adapter.hmm.0.alive val=true, ack=true, ts=1452606066, q=0, from=system.adapter.hmm.0, lc=1452547818
! 2016-01-12 14:41:05.780 - debug: inMem message * system.adapter.hmm.0.connected val=true, ack=true, ts=1452606066, q=0, from=system.adapter.hmm.0, lc=1452547818
! 2016-01-12 14:41:05.785 - debug: inMem message * system.adapter.hmm.0.memRss val=42.3, ack=true, ts=1452606066, q=0, from=system.adapter.hmm.0, lc=1452605570
! 2016-01-12 14:41:05.790 - debug: inMem message * system.adapter.hmm.0.memHeapTotal val=30.81, ack=true, ts=1452606066, q=0, from=system.adapter.hmm.0, lc=1452600451
! 2016-01-12 14:41:05.793 - debug: inMem message * system.adapter.hmm.0.memHeapUsed val=12.49, ack=true, ts=1452606066, q=0, from=system.adapter.hmm.0, lc=1452606066
! 2016-01-12 14:41:05.796 - debug: inMem message * system.adapter.hmm.0.uptime val=58252, ack=true, ts=1452606066, q=0, from=system.adapter.hmm.0, lc=1452606066
! 2016-01-12 14:41:08.961 - debug: inMem message * system.adapter.fritzbox.0.alive val=true, ack=true, ts=1452606069, q=0, from=system.adapter.fritzbox.0, lc=1452547822
! 2016-01-12 14:41:08.983 - debug: inMem message * system.adapter.fritzbox.0.connected val=true, ack=true, ts=1452606069, q=0, from=system.adapter.fritzbox.0, lc=1452547822
! 2016-01-12 14:41:08.990 - debug: inMem message * system.adapter.fritzbox.0.memRss val=44.31, ack=true, ts=1452606069, q=0, from=system.adapter.fritzbox.0, lc=1452604988
! 2016-01-12 14:41:08.994 - debug: inMem message * system.adapter.fritzbox.0.memHeapTotal val=30.81, ack=true, ts=1452606069, q=0, from=system.adapter.fritzbox.0, lc=1452597947
! 2016-01-12 14:41:08.999 - debug: inMem message * system.adapter.fritzbox.0.memHeapUsed val=17.04, ack=true, ts=1452606069, q=0, from=system.adapter.fritzbox.0, lc=1452606069
! 2016-01-12 14:41:09.002 - debug: inMem message * system.adapter.fritzbox.0.uptime val=58251, ack=true, ts=1452606069, q=0, from=system.adapter.fritzbox.0, lc=1452606069
! 2016-01-12 14:41:09.868 - debug: transport close
! 2016-01-12 16:15:14.080 - info: node-red.0 node-red exited with null
! 2016-01-12 16:15:19.100 - info: node-red.0 Starting node-red: /opt/iobroker/node_modules/iobroker.node-red/node_modules/node-red/red.js -v –settings /opt/iobroker/iobroker-data/node-red/settings.js
! 2016-01-12 17:21:05.087 - warn: hm-rega.0 Pending request for more than 25000 ms
! 2016-01-12 17:21:05.549 - error: hm-rega.0 post request error: connect EHOSTUNREACH
! 2016-01-12 17:21:05.736 - info: hm-rpc.0 binrpc <- system.listMethods ["hm-rpc.0"]
! 2016-01-12 17:21:05.800 - info: hm-rpc.0 binrpc <- listDevices ["hm-rpc.0"]
! 2016-01-12 17:46:33.484 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 17:48:03.492 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 17:49:33.495 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 17:51:03.498 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 17:52:33.501 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 17:54:03.503 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 17:55:33.506 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 17:57:03.508 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 17:58:33.510 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:00:03.512 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:01:33.514 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:03:03.516 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:04:33.519 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:06:03.524 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:07:33.528 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:09:03.531 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:10:33.533 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:12:03.536 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:13:33.538 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:15:03.540 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:16:33.542 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:18:03.544 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:19:33.546 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:21:03.549 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:22:33.551 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:24:03.553 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:25:33.556 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:27:03.558 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:28:33.560 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:30:03.562 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:31:33.575 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:33:50.465 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:36:57.950 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:37:00.386 - warn: hm-rega.0 Pending request for more than 25000 ms
! 2016-01-12 18:37:01.117 - error: hm-rega.0 post request error: connect EHOSTUNREACH
! 2016-01-12 18:38:28.089 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:39:58.092 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:41:28.094 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:42:58.095 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:44:28.099 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:45:58.101 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:47:28.103 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:48:58.104 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:50:28.107 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:51:58.108 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:53:28.110 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:54:58.112 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:56:28.115 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:57:58.116 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 18:59:28.120 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:00:58.122 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:02:28.126 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:03:58.128 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:05:28.130 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:06:58.132 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:08:28.134 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:09:58.137 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:11:28.139 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:12:58.143 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:14:28.148 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:15:58.154 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:17:28.156 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:18:58.157 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:20:28.160 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:21:58.161 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:23:28.163 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:24:58.168 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:26:28.171 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:27:58.173 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:29:28.176 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:30:58.178 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:32:28.180 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:33:58.185 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:35:28.189 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:36:58.191 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:38:28.194 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:39:58.196 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:41:28.198 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:42:58.201 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:44:14.012 - warn: hm-rega.0 Pending request for more than 25000 ms
! 2016-01-12 19:44:21.033 - warn: hm-rega.0 Pending request for more than 50000 ms
! 2016-01-12 19:44:26.043 - warn: hm-rega.0 Pending request for more than 75000 ms
! 2016-01-12 19:44:28.203 - error: hm-rpc.0 Error: You are sending too fast
! 2016-01-12 19:44:30.517 - warn: hm-rega.0 Pending request for more than 100000 ms
! 2016-01-12 19:44:34.052 - warn: hm-rega.0 Pending request for more than 125000 ms
! 2016-01-12 19:44:37.755 - warn: hm-rega.0 Pending request for more than 150000 ms
! 2016-01-12 19:44:40.777 - warn: hm-rega.0 Pending request for more than 175000 ms
! 2016-01-12 19:44:43.541 - warn: hm-rega.0 Pending request for more than 200000 ms
! 2016-01-12 19:44:46.296 - warn: hm-rega.0 Pending request for more than 225000 ms
! 2016-01-12 19:44:49.075 - warn2016-01-12 19:18:15.364 - info: host.raspberrypi iobroker.js-controller version 0.8.2 js-controller starting
! 2016-01-12 19:18:15.385 - info: host.raspberrypi Copyright 2014-2015 bluefox, hobbyquaker
! 2016-01-12 19:18:15.388 - info: host.raspberrypi hostname: raspberrypi
! 2016-01-12 19:18:15.389 - info: host.raspberrypi ip addresses: 10.10.100.81 fe80::76da:38ff:fe62:2ad7
! 2016-01-12 19:18:15.476 - info: inMem-states listening on port 9000
! 2016-01-12 19:18:15.781 - info: inMem-objects listening on port 9001
! 2016-01-12 19:18:15.801 - info: host.raspberrypi InMemoryDB connected
! 2016-01-12 19:18:15.831 - info: host.raspberrypi 23 instances found
! 2016-01-12 19:18:15.837 - info: host.raspberrypi starting 18 instances
! 2016-01-12 19:18:15.907 - info: host.raspberrypi instance system.adapter.admin.0 started with pid 2042
! --EOF--Das gesamte Log befindet sich hier: http://cloud.gohres.de/index.php/s/hElRm7ztumQCalz
Momentan habe ich auch nur testweise 1 Skript, welches mir Bescheid gibt, wenn die Waschmaschine fertig ist
> Hab den Fehler wahrscheinlich gefunden, werde es mir nochmal genau ansehen und berichten.
Das klingt schon einmal nicht schlecht, was hast du für einen Verdacht?Grüße,
Zeebo
-
Hi,
bei mir hängt sie die CCU2 auch auf nachdem ich iobroker in Betrieb genommen habe.
Ein ansprechen der CCU über das Web Interface ist nicht mehr möglich und die Programme laufen auch nicht mehr.
Es hilft dann nur ein Neustart der CCU über Stecker ziehen.
Ich benutze ein Raspberry Pi2, iobroker habe ich schon mehrmals frisch aufgespielt, weil ich dachte es liegt an der Installation.
Sobald ich den iobroker aktiviere Dauer es keinen Tag und die CCU hängt sich weg.
Log file der CCU kann ich dann leider nicht mehr auslesen.
Das log vom iobroker habe ich angehängt werde aber aus den Meldungen nicht schlau was das Problem sein könnte.
Die ganzen „Pending Request“ Meldungen führe ich darauf zurück das CCU2 zu dem Zeitpunkt schon hängt.
Es laufen weder auf dem iobroker und der CCU irgendwelche scripte.
Habe ich alle schon gelöscht weil ich dachte es würde an denen liegen.
Es scheint also ein generelles Kommunikation Problem zu sein.
@ tritonmuc
Hast du bei dir rausgefunden was das Problem ist/war?
Kann es mit dem RPC-Adapter Protocol zu tun haben?
Ich verwende das vor eingestellte BIN-RPC.
Welches nehmt ihr XML-RPC oder BIN-RPC?
Bin am Verzweifeln da ich keine Idee habe wo ich anfangen soll zu suchen.
Im Moment ist iobroker aus damit ich wenigsten die homematic wiederverwenden kann.
-
ich habe bei mir das XML-RPC
Verbindungscheck Interval auf 180 sec
daemon: rfd
Homematic Port 2001
eingestellt.
Ich hatte noch niemals Ausfälle in der CCU. Und es laufen etliche Scripte und Adapter
-
Im rpc adapter hab ich xml-rpc ausgewählt.
Mich würde interressieren welche Firmware auf der CCU bei den Betroffenen so läuft. Bei mir läuft die 2.15.2.
Ich hab mein ioBroker system vor nicht ganz 3 Wochen neu auf gesetzt und keinerlei Probleme. Auch davor nie ein Problem mit der CCU.
Da Betroffene ihr System auch neu aufgesetzt haben und trotzdem probleme haben, liegt die Vermutung nahe das es eine andere fehlerquelle gibt.
Auch wie der iobroker host mit dem Netzwerk verbunden ist, wäre interessant. Bei mir ist der Pi2 per LAN über einen switch zusammen mit der CCU ans Netzwerk angeschlossen. Der switch ist nötig weil sich die CCU immer wieder mal aufgehängt hat wenn sie direkt mit der FritzBox verbunden war.
Gesendet von meinem Jolla mit Tapatalk
-
ich hatte FW2.15.5 aus Verzweifelung habe ich auch andere ausprobiert war aber immer das selbe.
Aktuell habe ich sogar 2.17.4 laufen.
Bei mir sind Pi2 und CCU beide direkt über LAN an der Fritzbox.
Du brauchst einen Switch weil die CCU hängen geblieben ist das ist interessant wie hast du das den festgestellt.
Gruß
-
Ist ein bekannter bug, der in Verbindung mit der Energisparfunktion an den LAN ports auftritt. Davon hab ich im Homematic Forum gelesen. Allerdings hat es bei mir, nicht wie dort beschrieben, ausgereicht diese funktion für den 1Gbit Anschluss der FritzBox aus zu schalten bzw auf einen 100Mbit Anschluss der FritzBox zu wechseln. Erst seit ich den switch habe ist ruhe. Übrigens trat das Problem meisstens nur beim Booten der CCU auf, manchmal aber auch im normal betrieb.
Gesendet von meinem Jolla mit Tapatalk
-
ok danke scheint dann ein anderes Problem zu sein.
PI2 und CCU hängen bei mir beide an 100Mbit
Habe jetzt erst einmal auf xml-rpc umgeschaltet, mal sehen wie lange es läuft.
-
Hallo!
Mein Raspberry war schon über verschiedene Wege angeschlossen, weil ich auch hier schon Fehlerquellen eliminieren wollte:
1) [Raspberry Pi 2]---[Netzwerkdose]===[Patchfeld]===[Switch]---[Firewall]---[Fritzbox]---[WWW] [CCU2]---| 2) [Raspberry Pi 2]---[Switch]---[Firewall]---[Fritzbox]---[WWW] [CCU2]---| 3) [CCU2]---[Switch]---[Firewall]---[Fritzbox]---[WWW] |-[WLAN Access Point] ((( ))) [Raspberry Pi 2]
Auch ich verwende das voreingestelltle BIN-RPC. Ansonsten sind alle anderen Einstellungen "default".
Vielleicht von Interesse: Ich habe im Raspi-Config-Menü "Overclock" das Preset "Pi2" ausgewählt.
975_rega.png
975_rpc.png
975_hmm.png -
Hallo,
wenn du anstelle der CCU2 den PI neu startest, ist das Problem dann behoben?
Wenn ja, dann schau dir mal meine Beiträge dazu an.
1. Schritt: Ausschalten History-Adapter und dann testen.
-
Hallo,
wenn du anstelle der CCU2 den PI neu startest, ist das Problem dann behoben?
Wenn ja, dann schau dir mal meine Beiträge dazu an.
1. Schritt: Ausschalten History-Adapter und dann testen. `
nein, leider nicht. Bisher hat sich die CCU2 davon nicht wieder erholt. Kommt aber vielleicht darauf an, wie lange die CCU2 "penetriert" wurde.Aber ich werde dennoch den History-Adapter ausschalten und das Ganze erneut testen.
-
Kleines Update: Auch ich habe testweise als Protokoll "XML-RPC" anstelle von "BIN-RPC" ausgewählt - dies bringt allerdings keine Besserung.
Nun habe ich, wie versprochen, den History-Adapter deaktiviert. Zusätzlich habe ich in den Raspi-Config-Menü "Overclock" das Preset "None" selektiert.
Gibt es irgendwas, dass ich tun kann oder was ich euch an Daten etc. weiterhin zur Verfügung stellen kann, damit ihr weiterkommt?
Ich würde mich gerne weiter mit einbringen um den Fehler zu identifizieren und beheben zu können und dieses Projekt zu unterstützen.
-
Hast du mal versucht einen Minimal-ioBroker laufen zu lassen? Spackt die CCU dann auch noch ab?
Ich meine auch irgendwo gelesen zu haben, dass bei jemanden der HMM die CCU zum Absturz gebracht hat. Nach deinem Log läuft der ja bei dir auch.
Und wie schauts mit der CCU selbst aus? Läuft da noch was drauf, was nicht zum Lieferumfang gehört?
MfG, Andre
-
Nein, ein Minimal-ioBroker hatte ich noch nicht getestet. Aber das kann ich gerne als nächstes testen. Ich will jetzt nur nicht zuviel auf einmal ändern, sonst funktioniert es nachher und man weiß nicht, was die ausschlaggebende Änderung war. Auf der CCU2 selbst läuft, außer das zum Lieferumfang gehörende, zusätzlich XML-API. Oder benötige ich das nicht mehr für ioBroker?
-
Kann mir nicht vorstellen, dass das XML-Api Addon Probleme machen kann. Läuft bei mir auch schon seit Jahren. Ob es für ioBroker gebraucht wird weiß ich gar nicht. In der Installationsanleitung steht nichts davon.
Iobroker minimal laufen lassen ist ja schnell gemacht. Würde einfach die Adapter mal deaktivieren und falls es läuft Stück für Stück wieder aktivieren.
MfG, André
Gesendet mit Tapatalk.
-
seit dem ich auf xml-rpc umgestellt habe läuft es jetzt erst einmal.
Mal schauen wie lange.
Mir ist aufgefallen als ich zeitgleich eine iobroker Installation auf dem PC laufen hatte mit bin-rpc.
Das die CCU sich aufgehängt hatte. Nachdem ich die PC Installation deaktiviert hatte ging es wieder.
Normalerweise fängt die CCU sich bei mir nicht wieder wenn ich die iobroker Installation deaktiviere.
Wie auch immer muss es noch weiter beobachten um eine Zusammenhang zu beweisen.
-
Hier mal ein aktuelles Log, history ist deaktiviert. Zu sehen ist, dass aufgrund von "out of memory" der Prozess "io.javascript.0" beendet wurde.
Dies tritt in Logs von heute Vormittag und gestern auch immer wieder auf, allerdings mit diversen io.-Prozessen.
Inzwischen habe ich auch hmm und node-red deaktiviert.
!
Jan 16 17:22:49 raspberrypi kernel: [64081.110273] INFO: task kworker/u8:0:3464 blocked for more than 120 seconds. Jan 16 17:22:54 raspberrypi kernel: [64081.117377] Not tainted 4.1.15-v7+ #830 Jan 16 17:22:58 raspberrypi kernel: [64081.121870] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jan 16 17:23:00 raspberrypi kernel: [64081.129822] kworker/u8:0 D 80553e00 0 3464 2 0x00000000 Jan 16 17:23:00 raspberrypi kernel: [64081.136374] Workqueue: kmmcd mmc_rescan Jan 16 17:23:03 raspberrypi kernel: [64081.140356] [<80553e00>] (__schedule) from [<805542c8>] (schedule+0x4c/0xa4) Jan 16 17:23:07 raspberrypi kernel: [64081.147531] [<805542c8>] (schedule) from [<8041db64>] (__mmc_claim_host+0xb4/0x19c) Jan 16 17:23:10 raspberrypi kernel: [64081.155363] [<8041db64>] (__mmc_claim_host) from [<8041dc6c>] (mmc_get_card+0x20/0x24) Jan 16 17:23:14 raspberrypi kernel: [64081.163432] [<8041dc6c>] (mmc_get_card) from [<804250e8>] (mmc_sd_detect+0x2c/0x80) Jan 16 17:23:16 raspberrypi kernel: [64081.171242] [<804250e8>] (mmc_sd_detect) from [<8041ffc4>] (mmc_rescan+0xc8/0x324) Jan 16 17:23:21 raspberrypi kernel: [64081.178947] [<8041ffc4>] (mmc_rescan) from [<8003ce34>] (process_one_work+0x144/0x3b8) Jan 16 17:23:24 raspberrypi kernel: [64081.187026] [<8003ce34>] (process_one_work) from [<8003d0ec>] (worker_thread+0x44/0x50c) Jan 16 17:23:28 raspberrypi kernel: [64081.195269] [<8003d0ec>] (worker_thread) from [<800426d0>] (kthread+0xe8/0x104) Jan 16 17:23:34 raspberrypi kernel: [64081.202742] [<800426d0>] (kthread) from [<8000f858>] (ret_from_fork+0x14/0x3c) Jan 16 17:23:36 raspberrypi kernel: [64127.837671] io.web.0 invoked oom-killer: gfp_mask=0x201da, order=0, oom_score_adj=0 Jan 16 17:23:36 raspberrypi kernel: [64127.845519] io.web.0 cpuset=/ mems_allowed=0 Jan 16 17:23:36 raspberrypi kernel: [64127.849919] CPU: 1 PID: 2110 Comm: io.web.0 Not tainted 4.1.15-v7+ #830 Jan 16 17:23:36 raspberrypi kernel: [64127.856659] Hardware name: BCM2709 Jan 16 17:23:36 raspberrypi kernel: [64127.860161] [<800180c0>] (unwind_backtrace) from [<80013b88>] (show_stack+0x20/0x24) Jan 16 17:23:36 raspberrypi kernel: [64127.868085] [<80013b88>] (show_stack) from [<8055292c>] (dump_stack+0x80/0x98) Jan 16 17:23:36 raspberrypi kernel: [64127.875488] [<8055292c>] (dump_stack) from [<80550558>] (dump_header+0xc0/0x204) Jan 16 17:23:36 raspberrypi kernel: [64127.883069] [<80550558>] (dump_header) from [<800f462c>] (oom_kill_process+0x23c/0x46c) Jan 16 17:23:36 raspberrypi kernel: [64127.891271] [<800f462c>] (oom_kill_process) from [<800f4b54>] (__out_of_memory+0x278/0x378) Jan 16 17:23:36 raspberrypi kernel: [64127.899762] [<800f4b54>] (__out_of_memory) from [<800f4e18>] (out_of_memory+0x60/0x80) Jan 16 17:23:36 raspberrypi kernel: [64127.907871] [<800f4e18>] (out_of_memory) from [<800f9528>] (__alloc_pages_nodemask+0x854/0x8e0) Jan 16 17:23:36 raspberrypi kernel: [64127.916747] [<800f9528>] (__alloc_pages_nodemask) from [<800f30e0>] (filemap_fault+0x224/0x4ac) Jan 16 17:23:36 raspberrypi kernel: [64127.925621] [<800f30e0>] (filemap_fault) from [<80118264>] (__do_fault+0x4c/0xb4) Jan 16 17:23:36 raspberrypi kernel: [64127.933266] [<80118264>] (__do_fault) from [<8011b93c>] (handle_mm_fault+0x7fc/0x1004) Jan 16 17:23:36 raspberrypi kernel: [64127.941345] [<8011b93c>] (handle_mm_fault) from [<80558da0>] (do_page_fault+0x298/0x3b0) Jan 16 17:23:36 raspberrypi kernel: [64127.949570] [<80558da0>] (do_page_fault) from [<800092a8>] (do_PrefetchAbort+0x44/0xa8) Jan 16 17:23:36 raspberrypi kernel: [64127.957740] [<800092a8>] (do_PrefetchAbort) from [<805589a4>] (ret_from_exception+0x0/0x1c) Jan 16 17:23:36 raspberrypi kernel: [64127.966245] Exception stack(0xbae0bfb0 to 0xbae0bff8) Jan 16 17:23:36 raspberrypi kernel: [64127.971410] bfa0: 0000020a 7ee2b73c 7ee2b740 7ee2b744 Jan 16 17:23:36 raspberrypi kernel: [64127.979715] bfc0: 7ee2b73c 00000000 01453750 7ee2b740 7ee2b744 00000001 012364dc 7ee2b70c Jan 16 17:23:36 raspberrypi kernel: [64127.988055] bfe0: 011dd410 7ee2b6c8 00695ce4 00566590 60000010 ffffffff Jan 16 17:23:36 raspberrypi kernel: [64127.994828] Mem-Info: Jan 16 17:23:36 raspberrypi kernel: [64127.997178] active_anon:239758 inactive_anon:54 isolated_anon:0 Jan 16 17:23:36 raspberrypi kernel: [64127.997178] active_file:226 inactive_file:279 isolated_file:0 Jan 16 17:23:36 raspberrypi kernel: [64127.997178] unevictable:0 dirty:1 writeback:0 unstable:0 Jan 16 17:23:36 raspberrypi kernel: [64127.997178] slab_reclaimable:1139 slab_unreclaimable:1861 Jan 16 17:23:36 raspberrypi kernel: [64127.997178] mapped:221 shmem:60 pagetables:1252 bounce:0 Jan 16 17:23:36 raspberrypi kernel: [64127.997178] free:1267 free_pcp:338 free_cma:0 Jan 16 17:23:36 raspberrypi kernel: [64128.030112] Normal free:4696kB min:3992kB low:4988kB high:5988kB active_anon:959032kB inactive_anon:216kB active_file:1192kB inactive_file:1380kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:1015808kB managed:996872kB mlocked:0kB dirty:4kB writeback:0kB mapped:1180kB shmem:240kB slab_reclaimable:4556kB slab_unreclaimable:7444kB kernel_stack:1568kB pagetables:5008kB unstable:0kB bounce:0kB free_pcp:1364kB local_pcp:464kB free_cma:0kB writeback_tmp:0kB pages_scanned:15516 all_unreclaimable? yes Jan 16 17:23:36 raspberrypi kernel: [64128.075819] lowmem_reserve[]: 0 0 Jan 16 17:23:36 raspberrypi kernel: [64128.079256] Normal: 345*4kB (UEM) 39*8kB (ER) 2*16kB (ER) 1*32kB (R) 0*64kB 1*128kB (R) 1*256kB (R) 1*512kB (R) 0*1024kB 1*2048kB (R) 0*4096kB = 4700kB Jan 16 17:23:36 raspberrypi kernel: [64128.093416] 830 total pagecache pages Jan 16 17:23:36 raspberrypi kernel: [64128.097135] 0 pages in swap cache Jan 16 17:23:36 raspberrypi kernel: [64128.100543] Swap cache stats: add 0, delete 0, find 0/0 Jan 16 17:23:36 raspberrypi kernel: [64128.105849] Free swap = 0kB Jan 16 17:23:36 raspberrypi kernel: [64128.108777] Total swap = 0kB Jan 16 17:23:36 raspberrypi kernel: [64128.111732] 253952 pages RAM Jan 16 17:23:36 raspberrypi kernel: [64128.114665] 0 pages HighMem/MovableOnly Jan 16 17:23:36 raspberrypi kernel: [64128.118563] 2686 pages reserved Jan 16 17:23:36 raspberrypi kernel: [64128.121784] 2048 pages cma reserved Jan 16 17:23:36 raspberrypi kernel: [64128.125330] [ pid ] uid tgid total_vm rss nr_ptes nr_pmds swapents oom_score_adj name Jan 16 17:23:36 raspberrypi kernel: [64128.141147] [ 172] 0 172 686 95 6 0 0 -1000 udevd Jan 16 17:23:36 raspberrypi kernel: [64128.156995] [ 1438] 0 1438 685 96 5 0 0 -1000 udevd Jan 16 17:23:36 raspberrypi kernel: [64128.172800] [ 1461] 0 1461 1404 89 6 0 0 -1000 wpa_supplicant Jan 16 17:23:36 raspberrypi kernel: [64128.189452] [ 1519] 0 1519 1218 429 6 0 0 -1000 dhclient Jan 16 17:23:36 raspberrypi kernel: [64128.205604] [ 1575] 0 1575 1218 428 6 0 0 0 dhclient Jan 16 17:23:36 raspberrypi kernel: [64128.221774] [ 1797] 65534 1797 497 27 4 0 0 0 thd Jan 16 17:23:36 raspberrypi kernel: [64128.237421] [ 1812] 0 1812 6987 111 7 0 0 0 rsyslogd Jan 16 17:23:36 raspberrypi kernel: [64128.253429] [ 1913] 0 1913 942 40 5 0 0 0 cron Jan 16 17:23:36 raspberrypi kernel: [64128.269084] [ 1920] 101 1920 1374 109 6 0 0 0 ntpd Jan 16 17:23:36 raspberrypi kernel: [64128.284710] [ 1987] 103 1987 789 53 5 0 0 0 dbus-daemon Jan 16 17:23:36 raspberrypi kernel: [64128.300891] [ 2018] 0 2018 1548 106 7 0 0 -1000 sshd Jan 16 17:23:36 raspberrypi kernel: [64128.316443] [ 2040] 0 2040 44542 28933 109 0 0 0 iobroker.js-con Jan 16 17:23:36 raspberrypi kernel: [64128.333023] [ 2052] 0 2052 55180 39697 173 0 0 0 io.admin.0 Jan 16 17:23:36 raspberrypi kernel: [64128.349154] [ 2057] 0 2057 433 19 3 0 0 0 login Jan 16 17:23:36 raspberrypi kernel: [64128.364901] [ 2058] 0 2058 930 33 5 0 0 0 getty Jan 16 17:23:36 raspberrypi kernel: [64128.380551] [ 2059] 0 2059 930 33 6 0 0 0 getty Jan 16 17:23:36 raspberrypi kernel: [64128.396098] [ 2060] 0 2060 930 33 6 0 0 0 getty Jan 16 17:23:36 raspberrypi kernel: [64128.411555] [ 2061] 0 2061 930 33 5 0 0 0 getty Jan 16 17:23:36 raspberrypi kernel: [64128.426995] [ 2062] 0 2062 930 33 6 0 0 0 getty Jan 16 17:23:36 raspberrypi kernel: [64128.442360] [ 2063] 0 2063 685 96 5 0 0 -1000 udevd Jan 16 17:23:36 raspberrypi kernel: [64128.457747] [ 2069] 0 2069 31222 16054 80 0 0 0 io.hm-rpc.0 Jan 16 17:23:36 raspberrypi kernel: [64128.473573] [ 2074] 0 2074 32136 16695 78 0 0 0 io.hm-rega.0 Jan 16 17:23:36 raspberrypi kernel: [64128.489354] [ 2083] 0 2083 23079 8351 53 0 0 0 io.hmm.0 Jan 16 17:23:36 raspberrypi kernel: [64128.504784] [ 2096] 0 2096 23511 8940 55 0 0 0 io.fritzbox.0 Jan 16 17:23:36 raspberrypi kernel: [64128.520604] [ 2105] 0 2105 33267 18065 92 0 0 0 node Jan 16 17:23:36 raspberrypi kernel: [64128.535715] [ 2110] 0 2110 25712 9953 60 0 0 0 io.web.0 Jan 16 17:23:36 raspberrypi kernel: [64128.551109] [ 2119] 0 2119 23454 8840 53 0 0 0 io.sayit.0 Jan 16 17:23:36 raspberrypi kernel: [64128.566602] [ 2164] 0 2164 55435 39838 177 0 0 0 io.javascript.0 Jan 16 17:23:36 raspberrypi kernel: [64128.582492] [ 2169] 0 2169 24187 9501 56 0 0 0 io.node-red.0 Jan 16 17:23:36 raspberrypi kernel: [64128.598107] [ 2182] 0 2182 48348 32815 150 0 0 0 node-red Jan 16 17:23:36 raspberrypi kernel: [64128.613268] [ 3608] 0 3608 694 39 6 0 0 0 dhclient-script Jan 16 17:23:36 raspberrypi kernel: [64128.629110] [ 3610] 0 3610 1387 40 5 0 0 0 sshd Jan 16 17:23:36 raspberrypi kernel: [64128.643957] Out of memory: Kill process 2164 (io.javascript.0) score 155 or sacrifice child Jan 16 17:23:36 raspberrypi kernel: [64128.658706] Killed process 2164 (io.javascript.0) total-vm:221740kB, anon-rss:159352kB, file-rss:0kB Jan 16 18:56:49 raspberrypi kernel: [69721.244861] INFO: task kworker/u8:2:3700 blocked for more than 120 seconds. Jan 16 18:56:53 raspberrypi kernel: [69721.251969] Not tainted 4.1.15-v7+ #830 Jan 16 18:56:55 raspberrypi kernel: [69721.256457] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jan 16 18:56:57 raspberrypi kernel: [69721.264411] kworker/u8:2 D 80553e00 0 3700 2 0x00000000 Jan 16 18:56:59 raspberrypi kernel: [69721.270941] Workqueue: kmmcd mmc_rescan Jan 16 18:57:01 raspberrypi kernel: [69721.274888] [<80553e00>] (__schedule) from [<805542c8>] (schedule+0x4c/0xa4) Jan 16 18:57:02 raspberrypi kernel: [69721.282053] [<805542c8>] (schedule) from [<8041db64>] (__mmc_claim_host+0xb4/0x19c) Jan 16 18:57:04 raspberrypi kernel: [69721.289848] [<8041db64>] (__mmc_claim_host) from [<8041dc6c>] (mmc_get_card+0x20/0x24) Jan 16 18:57:05 raspberrypi kernel: [69721.297909] [<8041dc6c>] (mmc_get_card) from [<804250e8>] (mmc_sd_detect+0x2c/0x80) Jan 16 18:57:06 raspberrypi kernel: [69721.305723] [<804250e8>] (mmc_sd_detect) from [<8041ffc4>] (mmc_rescan+0xc8/0x324) Jan 16 18:57:08 raspberrypi kernel: [69721.313430] [<8041ffc4>] (mmc_rescan) from [<8003ce34>] (process_one_work+0x144/0x3b8) Jan 16 18:57:09 raspberrypi kernel: [69721.321514] [<8003ce34>] (process_one_work) from [<8003d0ec>] (worker_thread+0x44/0x50c) Jan 16 18:57:11 raspberrypi kernel: [69721.329766] [<8003d0ec>] (worker_thread) from [<800426d0>] (kthread+0xe8/0x104) Jan 16 18:57:11 raspberrypi kernel: [69721.337217] [<800426d0>] (kthread) from [<8000f858>] (ret_from_fork+0x14/0x3c) Jan 16 18:58:49 raspberrypi kernel: [69841.335614] INFO: task kworker/u8:2:3700 blocked for more than 120 seconds. Jan 16 18:58:55 raspberrypi kernel: [69841.342713] Not tainted 4.1.15-v7+ #830 Jan 16 18:59:01 raspberrypi kernel: [69841.347193] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jan 16 18:59:05 raspberrypi kernel: [69841.355144] kworker/u8:2 D 80553e00 0 3700 2 0x00000000 Jan 16 18:59:06 raspberrypi kernel: [69841.361678] Workqueue: kmmcd mmc_rescan Jan 16 18:59:08 raspberrypi kernel: [69841.365653] [<80553e00>] (__schedule) from [<805542c8>] (schedule+0x4c/0xa4) Jan 16 18:59:09 raspberrypi kernel: [69841.372823] [<805542c8>] (schedule) from [<8041db64>] (__mmc_claim_host+0xb4/0x19c) Jan 16 18:59:11 raspberrypi kernel: [69841.380624] [<8041db64>] (__mmc_claim_host) from [<8041dc6c>] (mmc_get_card+0x20/0x24) Jan 16 18:59:12 raspberrypi kernel: [69841.388700] [<8041dc6c>] (mmc_get_card) from [<804250e8>] (mmc_sd_detect+0x2c/0x80) Jan 16 18:59:14 raspberrypi kernel: [69841.396517] [<804250e8>] (mmc_sd_detect) from [<8041ffc4>] (mmc_rescan+0xc8/0x324) Jan 16 18:59:16 raspberrypi kernel: [69841.404219] [<8041ffc4>] (mmc_rescan) from [<8003ce34>] (process_one_work+0x144/0x3b8) Jan 16 18:59:18 raspberrypi kernel: [69841.412306] [<8003ce34>] (process_one_work) from [<8003d0ec>] (worker_thread+0x44/0x50c) Jan 16 18:59:22 raspberrypi kernel: [69841.420558] [<8003d0ec>] (worker_thread) from [<800426d0>] (kthread+0xe8/0x104) Jan 16 18:59:26 raspberrypi kernel: [69841.428019] [<800426d0>] (kthread) from [<8000f858>] (ret_from_fork+0x14/0x3c) Jan 16 19:00:49 raspberrypi kernel: [69961.426375] INFO: task kworker/u8:2:3700 blocked for more than 120 seconds. Jan 16 19:00:50 raspberrypi kernel: [69961.433504] Not tainted 4.1.15-v7+ #830 Jan 16 19:00:52 raspberrypi kernel: [69961.438003] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jan 16 19:00:57 raspberrypi kernel: [69961.445959] kworker/u8:2 D 80553e00 0 3700 2 0x00000000 Jan 16 19:01:00 raspberrypi kernel: [69961.452492] Workqueue: kmmcd mmc_rescan Jan 16 19:01:01 raspberrypi kernel: [69961.456468] [<80553e00>] (__schedule) from [<805542c8>] (schedule+0x4c/0xa4) Jan 16 19:01:01 raspberrypi kernel: [69961.463630] [<805542c8>] (schedule) from [<8041db64>] (__mmc_claim_host+0xb4/0x19c) Jan 16 19:01:03 raspberrypi kernel: [69961.471432] [<8041db64>] (__mmc_claim_host) from [<8041dc6c>] (mmc_get_card+0x20/0x24) Jan 16 19:01:07 raspberrypi kernel: [69961.479501] [<8041dc6c>] (mmc_get_card) from [<804250e8>] (mmc_sd_detect+0x2c/0x80) Jan 16 19:01:09 raspberrypi kernel: [69961.487320] [<804250e8>] (mmc_sd_detect) from [<8041ffc4>] (mmc_rescan+0xc8/0x324) Jan 16 19:01:12 raspberrypi kernel: [69961.495017] [<8041ffc4>] (mmc_rescan) from [<8003ce34>] (process_one_work+0x144/0x3b8) Jan 16 19:01:15 raspberrypi kernel: [69961.503093] [<8003ce34>] (process_one_work) from [<8003d0ec>] (worker_thread+0x44/0x50c) Jan 16 19:01:17 raspberrypi kernel: [69961.511336] [<8003d0ec>] (worker_thread) from [<800426d0>] (kthread+0xe8/0x104) Jan 16 19:01:20 raspberrypi kernel: [69961.518791] [<800426d0>] (kthread) from [<8000f858>] (ret_from_fork+0x14/0x3c) Jan 16 19:02:50 raspberrypi kernel: [70081.517139] INFO: task kworker/u8:2:3700 blocked for more than 120 seconds. Jan 16 19:02:55 raspberrypi kernel: [70081.524235] Not tainted 4.1.15-v7+ #830 Jan 16 19:02:58 raspberrypi kernel: [70081.528713] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jan 16 19:02:59 raspberrypi kernel: [70081.536666] kworker/u8:2 D 80553e00 0 3700 2 0x00000000 Jan 16 19:03:03 raspberrypi kernel: [70081.543210] Workqueue: kmmcd mmc_rescan Jan 16 19:03:08 raspberrypi kernel: [70081.547162] [<80553e00>] (__schedule) from [<805542c8>] (schedule+0x4c/0xa4) Jan 16 19:03:10 raspberrypi kernel: [70081.554335] [<805542c8>] (schedule) from [<8041db64>] (__mmc_claim_host+0xb4/0x19c) Jan 16 19:03:12 raspberrypi kernel: [70081.562153] [<8041db64>] (__mmc_claim_host) from [<8041dc6c>] (mmc_get_card+0x20/0x24) Jan 16 19:03:14 raspberrypi kernel: [70081.570233] [<8041dc6c>] (mmc_get_card) from [<804250e8>] (mmc_sd_detect+0x2c/0x80) Jan 16 19:03:21 raspberrypi kernel: [70081.578033] [<804250e8>] (mmc_sd_detect) from [<8041ffc4>] (mmc_rescan+0xc8/0x324) Jan 16 19:03:26 raspberrypi kernel: [70081.585726] [<8041ffc4>] (mmc_rescan) from [<8003ce34>] (process_one_work+0x144/0x3b8) Jan 16 19:03:29 raspberrypi kernel: [70081.593798] [<8003ce34>] (process_one_work) from [<8003d0ec>] (worker_thread+0x44/0x50c) Jan 16 19:03:35 raspberrypi kernel: [70081.602035] [<8003d0ec>] (worker_thread) from [<800426d0>] (kthread+0xe8/0x104) Jan 16 19:03:39 raspberrypi kernel: [70081.609483] [<800426d0>] (kthread) from [<8000f858>] (ret_from_fork+0x14/0x3c) Jan 16 19:04:50 raspberrypi kernel: [70201.607895] INFO: task kworker/u8:2:3700 blocked for more than 120 seconds. Jan 16 19:04:51 raspberrypi kernel: [70201.615011] Not tainted 4.1.15-v7+ #830 Jan 16 19:04:52 raspberrypi kernel: [70201.619489] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jan 16 19:04:54 raspberrypi kernel: [70201.627433] kworker/u8:2 D 80553e00 0 3700 2 0x00000000 Jan 16 19:04:59 raspberrypi kernel: [70201.633955] Workqueue: kmmcd mmc_rescan Jan 16 19:05:01 raspberrypi kernel: [70201.644138] [<80553e00>] (__schedule) from [<805542c8>] (schedule+0x4c/0xa4) Jan 16 19:05:05 raspberrypi kernel: [70201.657508] [<805542c8>] (schedule) from [<8041db64>] (__mmc_claim_host+0xb4/0x19c) Jan 16 19:05:08 raspberrypi kernel: [70201.671449] [<8041db64>] (__mmc_claim_host) from [<8041dc6c>] (mmc_get_card+0x20/0x24) Jan 16 19:05:12 raspberrypi kernel: [70201.685581] [<8041dc6c>] (mmc_get_card) from [<804250e8>] (mmc_sd_detect+0x2c/0x80) Jan 16 19:05:15 raspberrypi kernel: [70201.699449] [<804250e8>] (mmc_sd_detect) from [<8041ffc4>] (mmc_rescan+0xc8/0x324) Jan 16 19:05:16 raspberrypi kernel: [70201.713124] [<8041ffc4>] (mmc_rescan) from [<8003ce34>] (process_one_work+0x144/0x3b8) Jan 16 19:05:20 raspberrypi kernel: [70201.727088] [<8003ce34>] (process_one_work) from [<8003d0ec>] (worker_thread+0x44/0x50c) Jan 16 19:05:24 raspberrypi kernel: [70201.741255] [<8003d0ec>] (worker_thread) from [<800426d0>] (kthread+0xe8/0x104) Jan 16 19:05:28 raspberrypi kernel: [70201.754709] [<800426d0>] (kthread) from [<8000f858>] (ret_from_fork+0x14/0x3c) Jan 16 19:05:59 raspberrypi kernel: [70271.114435] rtw_tkip_decrypt(wlan0) no_gkey_bc_cnt:3, no_gkey_mc_cnt:0 Jan 16 19:06:01 raspberrypi kernel: [70273.059673] rtw_tkip_decrypt(wlan0) no_gkey_bc_cnt:2, no_gkey_mc_cnt:0 Jan 16 19:06:49 raspberrypi kernel: [70321.768674] INFO: task kworker/u8:2:3700 blocked for more than 120 seconds. Jan 16 19:06:52 raspberrypi kernel: [70321.781756] Not tainted 4.1.15-v7+ #830 Jan 16 19:06:54 raspberrypi kernel: [70321.792154] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jan 16 19:06:58 raspberrypi kernel: [70321.806172] kworker/u8:2 D 80553e00 0 3700 2 0x00000000 Jan 16 19:06:59 raspberrypi kernel: [70321.818637] Workqueue: kmmcd mmc_rescan Jan 16 19:07:01 raspberrypi kernel: [70321.828494] [<80553e00>] (__schedule) from [<805542c8>] (schedule+0x4c/0xa4) Jan 16 19:07:02 raspberrypi kernel: [70321.841651] [<805542c8>] (schedule) from [<8041db64>] (__mmc_claim_host+0xb4/0x19c) Jan 16 19:07:05 raspberrypi kernel: [70321.855331] [<8041db64>] (__mmc_claim_host) from [<8041dc6c>] (mmc_get_card+0x20/0x24) Jan 16 19:07:07 raspberrypi kernel: [70321.869208] [<8041dc6c>] (mmc_get_card) from [<804250e8>] (mmc_sd_detect+0x2c/0x80) Jan 16 19:07:08 raspberrypi kernel: [70321.882845] [<804250e8>] (mmc_sd_detect) from [<8041ffc4>] (mmc_rescan+0xc8/0x324) Jan 16 19:07:10 raspberrypi kernel: [70321.896458] [<8041ffc4>] (mmc_rescan) from [<8003ce34>] (process_one_work+0x144/0x3b8) Jan 16 19:07:12 raspberrypi kernel: [70321.910410] [<8003ce34>] (process_one_work) from [<8003d0ec>] (worker_thread+0x44/0x50c) Jan 16 19:07:13 raspberrypi kernel: [70321.924634] [<8003d0ec>] (worker_thread) from [<800426d0>] (kthread+0xe8/0x104) Jan 16 19:07:16 raspberrypi kernel: [70321.937963] [<800426d0>] (kthread) from [<8000f858>] (ret_from_fork+0x14/0x3c) Jan 16 19:08:50 raspberrypi kernel: [70441.949433] INFO: task kworker/u8:2:3700 blocked for more than 120 seconds. Jan 16 19:08:55 raspberrypi kernel: [70441.962968] Not tainted 4.1.15-v7+ #830 Jan 16 19:09:00 raspberrypi kernel: [70441.973731] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jan 16 19:09:04 raspberrypi kernel: [70441.987982] kworker/u8:2 D 80553e00 0 3700 2 0x00000000 Jan 16 19:09:08 raspberrypi kernel: [70442.000982] Workqueue: kmmcd mmc_rescan Jan 16 19:09:15 raspberrypi kernel: [70442.011271] [<80553e00>] (__schedule) from [<805542c8>] (schedule+0x4c/0xa4) Jan 16 19:09:20 raspberrypi kernel: [70442.024806] [<805542c8>] (schedule) from [<8041db64>] (__mmc_claim_host+0xb4/0x19c) Jan 16 19:09:25 raspberrypi kernel: [70442.038811] [<8041db64>] (__mmc_claim_host) from [<8041dc6c>] (mmc_get_card+0x20/0x24) Jan 16 19:09:30 raspberrypi kernel: [70442.053058] [<8041dc6c>] (mmc_get_card) from [<804250e8>] (mmc_sd_detect+0x2c/0x80) Jan 16 19:09:33 raspberrypi kernel: [70442.067087] [<804250e8>] (mmc_sd_detect) from [<8041ffc4>] (mmc_rescan+0xc8/0x324) Jan 16 19:09:36 raspberrypi kernel: [70442.081105] [<8041ffc4>] (mmc_rescan) from [<8003ce34>] (process_one_work+0x144/0x3b8) Jan 16 19:09:41 raspberrypi kernel: [70442.095414] [<8003ce34>] (process_one_work) from [<8003d0ec>] (worker_thread+0x44/0x50c) Jan 16 19:09:45 raspberrypi kernel: [70442.109912] [<8003d0ec>] (worker_thread) from [<800426d0>] (kthread+0xe8/0x104) Jan 16 19:09:50 raspberrypi kernel: [70442.123676] [<800426d0>] (kthread) from [<8000f858>] (ret_from_fork+0x14/0x3c) Jan 16 19:10:50 raspberrypi kernel: [70562.130196] INFO: task kworker/u8:2:3700 blocked for more than 120 seconds. Jan 16 19:10:52 raspberrypi kernel: [70562.137988] Not tainted 4.1.15-v7+ #830 Jan 16 19:10:52 raspberrypi kernel: [70562.143425] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jan 16 19:10:52 raspberrypi kernel: [70562.152314] kworker/u8:2 D 80553e00 0 3700 2 0x00000000 Jan 16 19:10:52 raspberrypi kernel: [70562.159829] Workqueue: kmmcd mmc_rescan Jan 16 19:10:53 raspberrypi kernel: [70562.164879] [<80553e00>] (__schedule) from [<805542c8>] (schedule+0x4c/0xa4) Jan 16 19:10:54 raspberrypi kernel: [70562.173177] [<805542c8>] (schedule) from [<8041db64>] (__mmc_claim_host+0xb4/0x19c) Jan 16 19:10:59 raspberrypi kernel: [70562.182267] [<8041db64>] (__mmc_claim_host) from [<8041dc6c>] (mmc_get_card+0x20/0x24) Jan 16 19:11:01 raspberrypi kernel: [70562.191643] [<8041dc6c>] (mmc_get_card) from [<804250e8>] (mmc_sd_detect+0x2c/0x80) Jan 16 19:11:05 raspberrypi kernel: [70562.200864] [<804250e8>] (mmc_sd_detect) from [<8041ffc4>] (mmc_rescan+0xc8/0x324) Jan 16 19:11:09 raspberrypi kernel: [70562.210095] [<8041ffc4>] (mmc_rescan) from [<8003ce34>] (process_one_work+0x144/0x3b8) Jan 16 19:11:12 raspberrypi kernel: [70562.219685] [<8003ce34>] (process_one_work) from [<8003d0ec>] (worker_thread+0x44/0x50c) Jan 16 19:11:17 raspberrypi kernel: [70562.229647] [<8003d0ec>] (worker_thread) from [<800426d0>] (kthread+0xe8/0x104) Jan 16 18:18:10 raspberrypi kernel: imklog 5.8.11, log source = /proc/kmsg started. Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Booting Linux on physical CPU 0xf00 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Initializing cgroup subsys cpuset Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Initializing cgroup subsys cpu Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Initializing cgroup subsys cpuacct Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Linux version 4.1.15-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.8.3 20140303 (prerelease) (crosstool-NG linaro-1.13.1+bzr2650 - Linaro GCC 2014.03) ) #830 SMP Tue Dec 15 17:02:45 GMT 2015 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] CPU: ARMv7 Processor [410fc075] revision 5 (ARMv7), cr=10c5387d Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Machine model: Raspberry Pi 2 Model B Rev 1.1 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] cma: Reserved 8 MiB at 0x3d800000 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Memory policy: Data cache writealloc Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] On node 0 totalpages: 253952 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] free_area_init_node: node 0, pgdat 8085cec0, node_mem_map bcf3a000 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Normal zone: 2232 pages used for memmap Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Normal zone: 0 pages reserved Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Normal zone: 253952 pages, LIFO batch:31 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] [bcm2709_smp_init_cpus] enter (9420->f3003010) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] [bcm2709_smp_init_cpus] ncores=4 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] PERCPU: Embedded 12 pages/cpu @bcefc000 s20416 r8192 d20544 u49152 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] pcpu-alloc: s20416 r8192 d20544 u49152 alloc=12*4096 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 251720 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Kernel command line: dma.dmachans=0x7f35 bcm2708_fb.fbwidth=1280 bcm2708_fb.fbheight=1024 bcm2709.boardrev=0x2a01041 bcm2709.serial=0xd6695a83 smsc95xx.macaddr=B8:27:EB:69:5A:83 bcm2708_fb.fbswap=1 bcm2709.disk_led_gpio=47 bcm2709.disk_led_active_low=0 sdhci-bcm2708.emmc_clock_freq=250000000 vc_mem.mem_base=0x3ea00000 vc_mem.mem_size=0x3f000000 dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 elevator=deadline root=/dev/mmcblk0p2 rootfstype=ext4 rootwait Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Memory: 988240K/1015808K available (5935K kernel code, 534K rwdata, 1652K rodata, 440K init, 757K bss, 19376K reserved, 8192K cma-reserved) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Virtual kernel memory layout: Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] vmalloc : 0xbe800000 - 0xff000000 (1032 MB) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] lowmem : 0x80000000 - 0xbe000000 ( 992 MB) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] modules : 0x7f000000 - 0x80000000 ( 16 MB) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] .text : 0x80008000 - 0x80771090 (7589 kB) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] .init : 0x80772000 - 0x807e0000 ( 440 kB) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] .data : 0x807e0000 - 0x80865a28 ( 535 kB) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] .bss : 0x80868000 - 0x8092575c ( 758 kB) Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Hierarchical RCU implementation. Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Additional per-CPU info printed with stalls. Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] NR_IRQS:608 Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] Architected cp15 timer(s) running at 19.20MHz (phys). Jan 16 18:18:10 raspberrypi kernel: [ 0.000000] clocksource arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns Jan 16 18:18:10 raspberrypi kernel: [ 0.000011] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns Jan 16 18:18:10 raspberrypi kernel: [ 0.000032] Switching to timer-based delay loop, resolution 52ns Jan 16 18:18:10 raspberrypi kernel: [ 0.000313] Console: colour dummy device 80x30 Jan 16 18:18:10 raspberrypi kernel: [ 0.001537] console [tty1] enabled Jan 16 18:18:10 raspberrypi kernel: [ 0.001594] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000) Jan 16 18:18:10 raspberrypi kernel: [ 0.001670] pid_max: default: 32768 minimum: 301 Jan 16 18:18:10 raspberrypi kernel: [ 0.002038] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.002092] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.003355] Initializing cgroup subsys blkio Jan 16 18:18:10 raspberrypi kernel: [ 0.003424] Initializing cgroup subsys memory Jan 16 18:18:10 raspberrypi kernel: [ 0.003483] Initializing cgroup subsys devices Jan 16 18:18:10 raspberrypi kernel: [ 0.003540] Initializing cgroup subsys freezer Jan 16 18:18:10 raspberrypi kernel: [ 0.003603] Initializing cgroup subsys net_cls Jan 16 18:18:10 raspberrypi kernel: [ 0.003702] CPU: Testing write buffer coherency: ok Jan 16 18:18:10 raspberrypi kernel: [ 0.003811] ftrace: allocating 20250 entries in 60 pages Jan 16 18:18:10 raspberrypi kernel: [ 0.053988] CPU0: update cpu_capacity 1024 Jan 16 18:18:10 raspberrypi kernel: [ 0.054068] CPU0: thread -1, cpu 0, socket 15, mpidr 80000f00 Jan 16 18:18:10 raspberrypi kernel: [ 0.054109] [bcm2709_smp_prepare_cpus] enter Jan 16 18:18:10 raspberrypi kernel: [ 0.054269] Setting up static identity map for 0x8240 - 0x8274 Jan 16 18:18:10 raspberrypi kernel: [ 0.056821] [bcm2709_boot_secondary] cpu:1 started (0) 18 Jan 16 18:18:10 raspberrypi kernel: [ 0.057261] [bcm2709_secondary_init] enter cpu:1 Jan 16 18:18:10 raspberrypi kernel: [ 0.057317] CPU1: update cpu_capacity 1024 Jan 16 18:18:10 raspberrypi kernel: [ 0.057325] CPU1: thread -1, cpu 1, socket 15, mpidr 80000f01 Jan 16 18:18:10 raspberrypi kernel: [ 0.057902] [bcm2709_boot_secondary] cpu:2 started (0) 18 Jan 16 18:18:10 raspberrypi kernel: [ 0.058260] [bcm2709_secondary_init] enter cpu:2 Jan 16 18:18:10 raspberrypi kernel: [ 0.058292] CPU2: update cpu_capacity 1024 Jan 16 18:18:10 raspberrypi kernel: [ 0.058300] CPU2: thread -1, cpu 2, socket 15, mpidr 80000f02 Jan 16 18:18:10 raspberrypi kernel: [ 0.058843] [bcm2709_boot_secondary] cpu:3 started (0) 18 Jan 16 18:18:10 raspberrypi kernel: [ 0.059100] [bcm2709_secondary_init] enter cpu:3 Jan 16 18:18:10 raspberrypi kernel: [ 0.059129] CPU3: update cpu_capacity 1024 Jan 16 18:18:10 raspberrypi kernel: [ 0.059138] CPU3: thread -1, cpu 3, socket 15, mpidr 80000f03 Jan 16 18:18:10 raspberrypi kernel: [ 0.059226] Brought up 4 CPUs Jan 16 18:18:10 raspberrypi kernel: [ 0.059338] SMP: Total of 4 processors activated (153.60 BogoMIPS). Jan 16 18:18:10 raspberrypi kernel: [ 0.059372] CPU: All CPU(s) started in HYP mode. Jan 16 18:18:10 raspberrypi kernel: [ 0.059401] CPU: Virtualization extensions available. Jan 16 18:18:10 raspberrypi kernel: [ 0.060385] devtmpfs: initialized Jan 16 18:18:10 raspberrypi kernel: [ 0.084162] VFP support v0.3: implementor 41 architecture 2 part 30 variant 7 rev 5 Jan 16 18:18:10 raspberrypi kernel: [ 0.084533] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns Jan 16 18:18:10 raspberrypi kernel: [ 0.085653] pinctrl core: initialized pinctrl subsystem Jan 16 18:18:10 raspberrypi kernel: [ 0.086478] NET: Registered protocol family 16 Jan 16 18:18:10 raspberrypi kernel: [ 0.092184] DMA: preallocated 4096 KiB pool for atomic coherent allocations Jan 16 18:18:10 raspberrypi kernel: [ 0.093470] bcm2709.uart_clock = 3000000 Jan 16 18:18:10 raspberrypi kernel: [ 0.098484] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers. Jan 16 18:18:10 raspberrypi kernel: [ 0.098544] hw-breakpoint: maximum watchpoint size is 8 bytes. Jan 16 18:18:10 raspberrypi kernel: [ 0.098759] Serial: AMBA PL011 UART driver Jan 16 18:18:10 raspberrypi kernel: [ 0.098974] 3f201000.uart: ttyAMA0 at MMIO 0x3f201000 (irq = 83, base_baud = 0) is a PL011 rev2 Jan 16 18:18:10 raspberrypi kernel: [ 0.604589] console [ttyAMA0] enabled Jan 16 18:18:10 raspberrypi kernel: [ 0.608867] bcm2835-mbox 3f00b880.mailbox: mailbox enabled Jan 16 18:18:10 raspberrypi kernel: [ 0.689271] bcm2708-dmaengine 3f007000.dma: DMA legacy API manager at f3007000, dmachans=0xf35 Jan 16 18:18:10 raspberrypi kernel: [ 0.698004] bcm2708-dmaengine 3f007000.dma: Initialized 7 DMA channels (+ 1 legacy) Jan 16 18:18:10 raspberrypi kernel: [ 0.706413] bcm2708-dmaengine 3f007000.dma: Load BCM2835 DMA engine driver Jan 16 18:18:10 raspberrypi kernel: [ 0.713327] bcm2708-dmaengine 3f007000.dma: dma_debug:0 Jan 16 18:18:10 raspberrypi kernel: [ 0.719301] SCSI subsystem initialized Jan 16 18:18:10 raspberrypi kernel: [ 0.723311] usbcore: registered new interface driver usbfs Jan 16 18:18:10 raspberrypi kernel: [ 0.728944] usbcore: registered new interface driver hub Jan 16 18:18:10 raspberrypi kernel: [ 0.734431] usbcore: registered new device driver usb Jan 16 18:18:10 raspberrypi kernel: [ 0.740189] raspberrypi-firmware soc:firmware: Attached to firmware from 2016-01-06 20:08 Jan 16 18:18:10 raspberrypi kernel: [ 0.775733] Switched to clocksource arch_sys_counter Jan 16 18:18:10 raspberrypi kernel: [ 0.827870] FS-Cache: Loaded Jan 16 18:18:10 raspberrypi kernel: [ 0.831132] CacheFiles: Loaded Jan 16 18:18:10 raspberrypi kernel: [ 0.845481] NET: Registered protocol family 2 Jan 16 18:18:10 raspberrypi kernel: [ 0.851173] TCP established hash table entries: 8192 (order: 3, 32768 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.858421] TCP bind hash table entries: 8192 (order: 4, 65536 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.865073] TCP: Hash tables configured (established 8192 bind 8192) Jan 16 18:18:10 raspberrypi kernel: [ 0.871647] UDP hash table entries: 512 (order: 2, 16384 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.877674] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.884658] NET: Registered protocol family 1 Jan 16 18:18:10 raspberrypi kernel: [ 0.889517] RPC: Registered named UNIX socket transport module. Jan 16 18:18:10 raspberrypi kernel: [ 0.895458] RPC: Registered udp transport module. Jan 16 18:18:10 raspberrypi kernel: [ 0.900207] RPC: Registered tcp transport module. Jan 16 18:18:10 raspberrypi kernel: [ 0.904925] RPC: Registered tcp NFSv4.1 backchannel transport module. Jan 16 18:18:10 raspberrypi kernel: [ 0.912561] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 5 counters available Jan 16 18:18:10 raspberrypi kernel: [ 0.922126] futex hash table entries: 1024 (order: 4, 65536 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.944400] VFS: Disk quotas dquot_6.6.0 Jan 16 18:18:10 raspberrypi kernel: [ 0.948787] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) Jan 16 18:18:10 raspberrypi kernel: [ 0.958358] FS-Cache: Netfs 'nfs' registered for caching Jan 16 18:18:10 raspberrypi kernel: [ 0.964849] NFS: Registering the id_resolver key type Jan 16 18:18:10 raspberrypi kernel: [ 0.970008] Key type id_resolver registered Jan 16 18:18:10 raspberrypi kernel: [ 0.974208] Key type id_legacy registered Jan 16 18:18:10 raspberrypi kernel: [ 0.981055] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) Jan 16 18:18:10 raspberrypi kernel: [ 0.988727] io scheduler noop registered Jan 16 18:18:10 raspberrypi kernel: [ 0.992679] io scheduler deadline registered (default) Jan 16 18:18:10 raspberrypi kernel: [ 0.998182] io scheduler cfq registered Jan 16 18:18:10 raspberrypi kernel: [ 1.004496] BCM2708FB: allocated DMA memory fdc00000 Jan 16 18:18:10 raspberrypi kernel: [ 1.009547] BCM2708FB: allocated DMA channel 0 @ f3007000 Jan 16 18:18:10 raspberrypi kernel: [ 1.036830] Console: switching to colour frame buffer device 160x64 Jan 16 18:18:10 raspberrypi kernel: [ 1.056913] Serial: 8250/16550 driver, 0 ports, IRQ sharing disabled Jan 16 18:18:10 raspberrypi kernel: [ 1.063944] KGDB: Registered I/O driver kgdboc Jan 16 18:18:10 raspberrypi kernel: [ 1.096549] vc-cma: Videocore CMA driver Jan 16 18:18:10 raspberrypi kernel: [ 1.100553] vc-cma: vc_cma_base = 0x00000000 Jan 16 18:18:10 raspberrypi kernel: [ 1.105336] vc-cma: vc_cma_size = 0x00000000 (0 MiB) Jan 16 18:18:10 raspberrypi kernel: [ 1.110851] vc-cma: vc_cma_initial = 0x00000000 (0 MiB) Jan 16 18:18:10 raspberrypi kernel: [ 1.116589] vc-mem: phys_addr:0x00000000 mem_base=0x3ea00000 mem_size:0x3f000000(1008 MiB) Jan 16 18:18:10 raspberrypi kernel: [ 1.140777] brd: module loaded Jan 16 18:18:10 raspberrypi kernel: [ 1.152925] loop: module loaded Jan 16 18:18:10 raspberrypi kernel: [ 1.157272] vchiq: vchiq_init_state: slot_zero = 0xbdc80000, is_master = 0 Jan 16 18:18:10 raspberrypi kernel: [ 1.166064] Loading iSCSI transport class v2.0-870. Jan 16 18:18:10 raspberrypi kernel: [ 1.172026] usbcore: registered new interface driver smsc95xx Jan 16 18:18:10 raspberrypi kernel: [ 1.178005] dwc_otg: version 3.00a 10-AUG-2012 (platform bus) Jan 16 18:18:10 raspberrypi kernel: [ 1.384257] Core Release: 2.80a Jan 16 18:18:10 raspberrypi kernel: [ 1.387507] Setting default values for core params Jan 16 18:18:10 raspberrypi kernel: [ 1.392420] Finished setting default values for core params Jan 16 18:18:10 raspberrypi kernel: [ 1.598528] Using Buffer DMA mode Jan 16 18:18:10 raspberrypi kernel: [ 1.601909] Periodic Transfer Interrupt Enhancement - disabled Jan 16 18:18:10 raspberrypi kernel: [ 1.607859] Multiprocessor Interrupt Enhancement - disabled Jan 16 18:18:10 raspberrypi kernel: [ 1.613524] OTG VER PARAM: 0, OTG VER FLAG: 0 Jan 16 18:18:10 raspberrypi kernel: [ 1.617982] Dedicated Tx FIFOs mode Jan 16 18:18:10 raspberrypi kernel: [ 1.621898] WARN::dwc_otg_hcd_init:1047: FIQ DMA bounce buffers: virt = 0xbdc14000 dma = 0xfdc14000 len=9024 Jan 16 18:18:10 raspberrypi kernel: [ 1.631946] FIQ FSM acceleration enabled for : Jan 16 18:18:10 raspberrypi kernel: [ 1.631946] Non-periodic Split Transactions Jan 16 18:18:10 raspberrypi kernel: [ 1.631946] Periodic Split Transactions Jan 16 18:18:10 raspberrypi kernel: [ 1.631946] High-Speed Isochronous Endpoints Jan 16 18:18:10 raspberrypi kernel: [ 1.648935] dwc_otg: Microframe scheduler enabled Jan 16 18:18:10 raspberrypi kernel: [ 1.649009] WARN::hcd_init_fiq:412: FIQ on core 1 at 0x803fbc80 Jan 16 18:18:10 raspberrypi kernel: [ 1.655038] WARN::hcd_init_fiq:413: FIQ ASM at 0x803fbfdc length 36 Jan 16 18:18:10 raspberrypi kernel: [ 1.661413] WARN::hcd_init_fiq:438: MPHI regs_base at 0xbe89a000 Jan 16 18:18:10 raspberrypi kernel: [ 1.672199] dwc_otg 3f980000.usb: DWC OTG Controller Jan 16 18:18:10 raspberrypi kernel: [ 1.681977] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1 Jan 16 18:18:10 raspberrypi kernel: [ 1.694140] dwc_otg 3f980000.usb: irq 32, io mem 0x00000000 Jan 16 18:18:10 raspberrypi kernel: [ 1.704519] Init: Port Power? op_state=1 Jan 16 18:18:10 raspberrypi kernel: [ 1.713166] Init: Power Port (0) Jan 16 18:18:10 raspberrypi kernel: [ 1.721352] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Jan 16 18:18:10 raspberrypi kernel: [ 1.732889] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 16 18:18:10 raspberrypi kernel: [ 1.744839] usb usb1: Product: DWC OTG Controller Jan 16 18:18:10 raspberrypi kernel: [ 1.754231] usb usb1: Manufacturer: Linux 4.1.15-v7+ dwc_otg_hcd Jan 16 18:18:10 raspberrypi kernel: [ 1.764949] usb usb1: SerialNumber: 3f980000.usb Jan 16 18:18:10 raspberrypi kernel: [ 1.775191] hub 1-0:1.0: USB hub found Jan 16 18:18:10 raspberrypi kernel: [ 1.783802] hub 1-0:1.0: 1 port detected Jan 16 18:18:10 raspberrypi kernel: [ 1.792956] dwc_otg: FIQ enabled Jan 16 18:18:10 raspberrypi kernel: [ 1.792968] dwc_otg: NAK holdoff enabled Jan 16 18:18:10 raspberrypi kernel: [ 1.792978] dwc_otg: FIQ split-transaction FSM enabled Jan 16 18:18:10 raspberrypi kernel: [ 1.793018] Module dwc_common_port init Jan 16 18:18:10 raspberrypi kernel: [ 1.793405] usbcore: registered new interface driver usb-storage Jan 16 18:18:10 raspberrypi kernel: [ 1.804456] mousedev: PS/2 mouse device common for all mice Jan 16 18:18:10 raspberrypi kernel: [ 1.815577] bcm2835-cpufreq: min=600000 max=700000 Jan 16 18:18:10 raspberrypi kernel: [ 1.825455] sdhci: Secure Digital Host Controller Interface driver Jan 16 18:18:10 raspberrypi kernel: [ 1.836312] sdhci: Copyright(c) Pierre Ossman Jan 16 18:18:10 raspberrypi kernel: [ 1.925776] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1) Jan 16 18:18:10 raspberrypi kernel: [ 1.956441] sdhci-pltfm: SDHCI platform and OF driver helper Jan 16 18:18:10 raspberrypi kernel: [ 1.967431] ledtrig-cpu: registered to indicate activity on CPUs Jan 16 18:18:10 raspberrypi kernel: [ 1.978327] hidraw: raw HID events driver (C) Jiri Kosina Jan 16 18:18:10 raspberrypi kernel: [ 1.985878] Indeed it is in host mode hprt0 = 00021501 Jan 16 18:18:10 raspberrypi kernel: [ 1.992902] mmc0: host does not support reading read-only switch, assuming write-enable Jan 16 18:18:10 raspberrypi kernel: [ 1.994838] mmc0: new high speed SDHC card at address 0007 Jan 16 18:18:10 raspberrypi kernel: [ 1.995470] mmcblk0: mmc0:0007 SL16G 14.4 GiB Jan 16 18:18:10 raspberrypi kernel: [ 2.030399] usbcore: registered new interface driver usbhid Jan 16 18:18:10 raspberrypi kernel: [ 2.040714] usbhid: USB HID core driver Jan 16 18:18:10 raspberrypi kernel: [ 2.047304] mmcblk0: p1 p2 Jan 16 18:18:10 raspberrypi kernel: [ 2.057112] Initializing XFRM netlink socket Jan 16 18:18:10 raspberrypi kernel: [ 2.066155] NET: Registered protocol family 17 Jan 16 18:18:10 raspberrypi kernel: [ 2.075428] Key type dns_resolver registered Jan 16 18:18:10 raspberrypi kernel: [ 2.084831] Registering SWP/SWPB emulation handler Jan 16 18:18:10 raspberrypi kernel: [ 2.095325] registered taskstats version 1 Jan 16 18:18:10 raspberrypi kernel: [ 2.104367] vc-sm: Videocore shared memory driver Jan 16 18:18:10 raspberrypi kernel: [ 2.113782] [vc_sm_connected_init]: start Jan 16 18:18:10 raspberrypi kernel: [ 2.122866] vc_vchi_sm_init: failed to open VCHI service (-1) Jan 16 18:18:10 raspberrypi kernel: [ 2.128607] [vc_sm_connected_init]: failed to initialize shared memory service Jan 16 18:18:10 raspberrypi kernel: [ 2.145366] [vc_sm_connected_init]: end - returning -1 Jan 16 18:18:10 raspberrypi kernel: [ 2.165804] usb 1-1: new high-speed USB device number 2 using dwc_otg Jan 16 18:18:10 raspberrypi kernel: [ 2.177257] Indeed it is in host mode hprt0 = 00001101 Jan 16 18:18:10 raspberrypi kernel: [ 2.204832] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem Jan 16 18:18:10 raspberrypi kernel: [ 2.216966] EXT4-fs (mmcblk0p2): write access will be enabled during recovery Jan 16 18:18:10 raspberrypi kernel: [ 2.386143] usb 1-1: New USB device found, idVendor=0424, idProduct=9514 Jan 16 18:18:10 raspberrypi kernel: [ 2.397790] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Jan 16 18:18:10 raspberrypi kernel: [ 2.410906] hub 1-1:1.0: USB hub found Jan 16 18:18:10 raspberrypi kernel: [ 2.419771] hub 1-1:1.0: 5 ports detected Jan 16 18:18:10 raspberrypi kernel: [ 2.705777] usb 1-1.1: new high-speed USB device number 3 using dwc_otg Jan 16 18:18:10 raspberrypi kernel: [ 2.816108] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00 Jan 16 18:18:10 raspberrypi kernel: [ 2.827813] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 Jan 16 18:18:10 raspberrypi kernel: [ 2.842806] smsc95xx v1.0.4 Jan 16 18:18:10 raspberrypi kernel: [ 2.909801] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:69:5a:83 Jan 16 18:18:10 raspberrypi kernel: [ 3.005776] usb 1-1.3: new high-speed USB device number 4 using dwc_otg Jan 16 18:18:10 raspberrypi kernel: [ 3.117289] usb 1-1.3: New USB device found, idVendor=7392, idProduct=7811 Jan 16 18:18:10 raspberrypi kernel: [ 3.129087] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 16 18:18:10 raspberrypi kernel: [ 3.141326] usb 1-1.3: Product: 802.11n WLAN Adapter Jan 16 18:18:10 raspberrypi kernel: [ 3.151230] usb 1-1.3: Manufacturer: Realtek Jan 16 18:18:10 raspberrypi kernel: [ 3.160400] usb 1-1.3: SerialNumber: 00e04c000001 Jan 16 18:18:10 raspberrypi kernel: [ 3.265766] usb 1-1.5: new full-speed USB device number 5 using dwc_otg Jan 16 18:18:10 raspberrypi kernel: [ 3.382258] usb 1-1.5: New USB device found, idVendor=046d, idProduct=c52b Jan 16 18:18:10 raspberrypi kernel: [ 3.394113] usb 1-1.5: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Jan 16 18:18:10 raspberrypi kernel: [ 3.406376] usb 1-1.5: Product: USB Receiver Jan 16 18:18:10 raspberrypi kernel: [ 3.415540] usb 1-1.5: Manufacturer: Logitech Jan 16 18:18:10 raspberrypi kernel: [ 3.431923] input: Logitech USB Receiver as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.5/1-1.5:1.0/0003:046D:C52B.0001/input/input0 Jan 16 18:18:10 raspberrypi kernel: [ 3.506091] hid-generic 0003:046D:C52B.0001: input,hidraw0: USB HID v1.11 Keyboard [Logitech USB Receiver] on usb-3f980000.usb-1.5/input0 Jan 16 18:18:10 raspberrypi kernel: [ 3.532360] input: Logitech USB Receiver as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.5/1-1.5:1.1/0003:046D:C52B.0002/input/input1 Jan 16 18:18:10 raspberrypi kernel: [ 3.606505] hid-generic 0003:046D:C52B.0002: input,hiddev0,hidraw1: USB HID v1.11 Mouse [Logitech USB Receiver] on usb-3f980000.usb-1.5/input1 Jan 16 18:18:10 raspberrypi kernel: [ 3.633486] hid-generic 0003:046D:C52B.0003: hiddev0,hidraw2: USB HID v1.11 Device [Logitech USB Receiver] on usb-3f980000.usb-1.5/input2 Jan 16 18:18:10 raspberrypi kernel: [ 12.491745] EXT4-fs (mmcblk0p2): recovery complete Jan 16 18:18:10 raspberrypi kernel: [ 12.508736] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) Jan 16 18:18:10 raspberrypi kernel: [ 12.522481] VFS: Mounted root (ext4 filesystem) readonly on device 179:2. Jan 16 18:18:10 raspberrypi kernel: [ 12.539740] devtmpfs: mounted Jan 16 18:18:10 raspberrypi kernel: [ 12.549055] Freeing unused kernel memory: 440K (80772000 - 807e0000) Jan 16 18:18:10 raspberrypi kernel: [ 12.737142] random: nonblocking pool is initialized Jan 16 18:18:10 raspberrypi kernel: [ 13.930044] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000 Jan 16 18:18:10 raspberrypi kernel: [ 14.337848] usbcore: registered new interface driver rtl8192cu Jan 16 18:18:10 raspberrypi kernel: [ 15.506195] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null) Jan 16 18:18:10 raspberrypi kernel: [ 15.720336] EXT4-fs (mmcblk0p2): re-mounted. Opts: errors=remount-ro Jan 16 18:18:10 raspberrypi kernel: [ 18.381762] FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Jan 16 18:18:10 raspberrypi kernel: [ 19.801650] NET: Registered protocol family 10 Jan 16 18:18:10 raspberrypi kernel: [ 20.028757] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Jan 16 18:18:10 raspberrypi kernel: [ 20.042765] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Jan 16 18:18:10 raspberrypi kernel: [ 21.420764] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready Jan 16 18:18:10 raspberrypi kernel: [ 22.885905] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready !