I have 3 units (our custom carrier, solar charged, LiIon battery powered) with Notecards WBNA, running test firmware based on our production firmware (approximately 400 units in the field). After the battery drops below approximately 3 volts, then recharges to above 3.5 volts, the Notecard will not sync with the Notehub. The code seems to run properly, but the notecard won’t sync.
On Unit 1, I removed the battery and then plugged it back in and the unit ran fine with the Notecard syncing all 40 previous notes with the Notehub. Unit 1 would not read the time. On Unit 2, I pressed the reset button on our board (connected to ESP32 reset and to Aux3 (which is not enabled)) the unit reset, ran fine and connected to Notehub sending the 30 notes that were stored in the Notecard. Unit 2 reads the time, but the time zone is etc/UTC and has not synced with the cellular time. On Unit 3, I haven’t tried anything else to unlock the Notecard, it communicates fine with CLI and application runs fine just never syncs.
It appears that something is set in the Notecard when the battery went low and did not reset when battery voltage returned.
Any ideas on the cause or how to prevent this?
Background: Our application monitors crude oil tank levels. Our carrier board has an ESP32-S3. The unit wakes up hourly, reads the tank levels, syncs with Notehub, calculates the time until next reading, tells Notecard to wake up in that time frame, puts ESP32 in deep sleep mode.
Modifications being tested are: Notecard is typically in continuous mode from 8AM to 5PM, minimum mode the rest of the day. In battery voltage is below 3.4 volts, Notecard stay in minimum mode all day, and stops syncing with Notehub each hour, it buffers the data in Notecard until battery recharges to above 3.4 volts.
I’ve included a long debug log from Unit 1 that shows all commands issued to Notecard.
Thanks,
Karl
16:19:59:222 -> [storage.begin/SD] can't initialize SD card
16:19:59:222 -> [Logger::load] using internal flash
16:19:59:228 -> [Logger::load] log size = 29580
16:20:01:229 -> [setup] starting syncStorage
16:20:01:229 -> [network::begin] done
16:20:02:244 -> [INFO] {"req":"card.voltage","crc":"0000:D020FD9E"}
16:20:02:379 -> [INFO] {"minutes":1773,"mode":"normal","value":3.7684427164944813,"calibration":0.19771202762781838}
16:20:02:379 -> [INFO] {"req":"card.time","crc":"0001:1110F247"}
16:20:02:509 -> [INFO] {"err":"time is not yet set {no-time}","zone":"UTC,Etc/UTC","crc":"0001:515304FA"}
16:20:02:509 ->
16:20:02:509 -> [INFO] {"req":"hub.set","product":"info.iwell.karl:iwell_customers","mode":"minimum","sync":false,"crc":"0002:86C383BA"}
16:20:02:686 -> [INFO] {}
16:20:02:686 -> [INFO] {"req":"card.dfu","name":"esp32","off":true,"crc":"0003:8243357C"}
16:20:02:895 -> [INFO] {"mode":"aux","name":"esp32","off":true}
16:20:02:896 -> [INFO] {"req":"dfu.status","version":"{"org":"iWell","product":"iWell RMU","description":"2.3.0.0","firmware":"notecard-esp32-S3-2.3.0.0","version":"2.3.0","built":"Mar 31 2026 14:27:08","ver_major":2,"ver_minor":3,"ver_patch":0,"ver_build":0,"builder":""}","crc":"0004:E29E3C38"}
16:20:03:540 -> [INFO] {"status":"successful outboard firmware update","mode":"completed","on":true}
16:20:03:540 -> [setup/network::optimizeVoltage] start
16:20:03:540 -> [INFO] {"req":"card.voltage","mode":"default","crc":"0005:FF98B7FC"}
16:20:03:701 -> [INFO] {"minutes":1773,"mode":"normal","value":3.7684427164969057,"calibration":0.19771202762781838}
16:20:03:702 -> [INFO] {"req":"card.aux","mode":"gpio","usage":["off","input-pullup","off","off"],"sync":true,"file":"statechange.qo","crc":"0006:8E693CAB"}
16:20:03:925 -> [INFO] {"file":"statechange.qo","mode":"gpio","state":[{},{"high":true},{},{}],"sync":true}
16:20:03:926 -> [setupTemplate] begin
16:20:03:926 -> [INFO] {"req":"note.template","file":"sensor.qos","body":{"temp":14.1,"battery":14.1,"CL1":14.1,"CL2":14.1,"timestamp":18,"version":"10"},"crc":"0007:3D1719EC"}
16:20:04:163 -> [INFO] {"bytes":43}
16:20:04:163 -> [setupTemplate] done
16:20:04:164 -> poll time: 60 minutes
16:20:04:164 -> [INFO] {"req":"card.time","crc":"0008:1110F247"}
16:20:04:293 -> [INFO] {"err":"time is not yet set {no-time}","zone":"UTC,Etc/UTC","crc":"0008:515304FA"}
16:20:04:293 ->
16:20:04:293 -> Timestamp: 0
16:20:08:293 -> [INFO] {"req":"env.get","names":["APGConfig","APGReg","APGRegValue"],"crc":"0009:FA631598"}
16:20:08:446 -> [INFO] {"body":{}}
16:20:08:446 -> [checkAPGConfig] no need to adjust
16:20:08:446 -> [INFO] {"req":"card.wireless.penalty","crc":"000A:EB49A546"}
16:20:08:590 -> [INFO] {"seconds":259199,"status":"network: can't connect (4320.0 min remaining) {registration-failure}{network}{extended-network-failure}","count":48}
16:20:08:591 -> Count = 48
16:20:08:591 -> Seconds = 259199
16:20:08:591 -> Notecard in Penalty, resetting penalty box
16:20:08:591 -> [INFO] {"req":"card.wireless.penalty","reset":true,"crc":"000B:67A994F0"}
16:20:08:740 -> [INFO] {}
16:20:12:741 -> [readSensors/rtc/getEpoch] done
16:20:12:742 -> [INFO] {"req":"card.voltage","crc":"000C:D020FD9E"}
16:20:12:876 -> [INFO] {"minutes":1773,"mode":"normal","value":3.7682896840168044,"calibration":0.19782969961575314}
16:20:12:879 -> [state.battery] 56.83
16:20:12:879 -> [INFO] {"req":"card.temp","crc":"000D:CE0D7EDD"}
16:20:13:006 -> [INFO] {"value":22.110424054446504,"off":true,"calibration":-1}
16:20:13:006 -> [readInputs] begin
16:20:13:315 -> [readInputs] done
16:20:13:316 -> 7 0 9 0 0 0 0 0 0 0 0 53 5c 85 3f 0
16:20:13:316 -> 7 0 9 0 0 0 0 0 0 0 e0 7d 39 83 3f 0
16:20:13:317 -> [readSensors] done
16:20:13:318 -> [INFO] {"req":"note.add","file":"sensor.qos","body":{"temp":22.1,"battery":56.8,"timestamp":8,"version":"2.3.0.0","CL1":0.01,"CL2":0.008999999999999999},"sync":false,"full":true,"crc":"000E:20B45309"}
16:20:13:588 -> [INFO] {"template":true,"total":118}
16:20:13:588 -> [syncNetwork] starting
16:20:13:589 -> [INFO] {"req":"hub.status","crc":"000F:5874FEF1"}
16:20:13:720 -> [INFO] {"status":"106367s starting communications {wait-module} {connecting}"}
16:20:13:720 -> [syncNetwork] waiting connection...
16:20:13:720 -> [INFO] {"req":"hub.status","crc":"0010:5874FEF1"}
16:20:13:852 -> [INFO] {"status":"106367s starting communications {wait-module} {connecting}"}
16:20:13:852 -> [syncNetwork] Connection Status: 4
16:20:15:852 -> [INFO] {"req":"hub.status","crc":"0011:5874FEF1"}
16:20:15:984 -> [INFO] {"status":"106369s starting communications {wait-module} {connecting}"}
16:20:15:984 -> [syncNetwork] Connection Status: 4
16:20:17:984 -> [INFO] {"req":"hub.status","crc":"0012:5874FEF1"}
16:20:18:116 -> [INFO] {"status":"106371s starting communications {wait-module} {connecting}"}
16:20:18:116 -> [syncNetwork] Connection Status: 4
16:20:20:117 -> [INFO] {"req":"hub.status","crc":"0013:5874FEF1"}
16:20:20:248 -> [INFO] {"status":"106374s starting communications {wait-module} {connecting}"}
16:20:20:248 -> [syncNetwork] Connection Status: 4
16:20:22:248 -> [INFO] {"req":"hub.status","crc":"0014:5874FEF1"}
16:20:22:380 -> [INFO] {"status":"106376s starting communications {wait-module} {connecting}"}
16:20:22:380 -> [syncNetwork] Connection Status: 4
16:20:24:380 -> [INFO] {"req":"hub.status","crc":"0015:5874FEF1"}
16:20:24:512 -> [INFO] {"status":"106378s starting communications {wait-module} {connecting}"}
16:20:24:513 -> [syncNetwork] Connection Status: 4
16:20:26:512 -> [INFO] {"req":"hub.status","crc":"0016:5874FEF1"}
16:20:26:644 -> [INFO] {"status":"106380s starting communications {wait-module} {connecting}"}
16:20:26:644 -> [syncNetwork] Connection Status: 4
16:20:28:644 -> [INFO] {"req":"hub.status","crc":"0017:5874FEF1"}
16:20:28:776 -> [INFO] {"status":"106382s starting communications {wait-module} {connecting}"}
16:20:28:777 -> [syncNetwork] Connection Status: 4
16:20:30:776 -> [INFO] {"req":"hub.status","crc":"0018:5874FEF1"}
16:20:30:908 -> [INFO] {"status":"106384s starting communications {wait-module} {connecting}"}
16:20:30:908 -> [syncNetwork] Connection Status: 4
16:20:32:908 -> [INFO] {"req":"hub.status","crc":"0019:5874FEF1"}
16:20:33:040 -> [INFO] {"status":"106386s starting communications {wait-module} {connecting}"}
16:20:33:041 -> [syncNetwork] Connection Status: 4
16:20:35:040 -> [INFO] {"req":"hub.status","crc":"001A:5874FEF1"}
16:20:35:172 -> [INFO] {"status":"106388s starting communications {wait-module} {connecting}"}
16:20:35:172 -> [syncNetwork] Connection Status: 4
16:20:37:172 -> [INFO] {"req":"hub.status","crc":"001B:5874FEF1"}
16:20:37:304 -> [INFO] {"status":"106391s starting communications {wait-module} {connecting}"}
16:20:37:304 -> [syncNetwork] Connection Status: 4
16:20:39:305 -> [INFO] {"req":"hub.status","crc":"001C:5874FEF1"}
16:20:39:436 -> [INFO] {"status":"106393s starting communications {wait-module} {connecting}"}
16:20:39:436 -> [syncNetwork] Connection Status: 4
16:20:41:436 -> [INFO] {"req":"hub.status","crc":"001D:5874FEF1"}
16:20:41:568 -> [INFO] {"status":"106395s starting communications {wait-module} {connecting}"}
16:20:41:568 -> [syncNetwork] Connection Status: 4
16:20:43:568 -> [INFO] {"req":"hub.status","crc":"001E:5874FEF1"}
16:20:43:700 -> [INFO] {"status":"106397s starting communications {wait-module} {connecting}"}
16:20:43:700 -> [syncNetwork] Connection Status: 4
16:20:45:701 -> [INFO] {"req":"hub.status","crc":"001F:5874FEF1"}
16:20:45:832 -> [INFO] {"status":"106399s starting communications {wait-module} {connecting}"}
16:20:45:832 -> [syncNetwork] Connection Status: 4
16:20:47:833 -> [INFO] {"req":"hub.status","crc":"0020:5874FEF1"}
16:20:47:963 -> [INFO] {"status":"106401s starting communications {wait-module} {connecting}"}
16:20:47:964 -> [syncNetwork] Connection Status: 4
16:20:49:965 -> [INFO] {"req":"hub.status","crc":"0021:5874FEF1"}
16:20:50:096 -> [INFO] {"status":"106403s starting communications {wait-module} {connecting}"}
16:20:50:096 -> [syncNetwork] Connection Status: 4
16:20:52:096 -> [INFO] {"req":"hub.status","crc":"0022:5874FEF1"}
16:20:52:228 -> [INFO] {"status":"106406s starting communications {wait-module} {connecting}"}
16:20:52:228 -> [syncNetwork] Connection Status: 4
16:20:54:228 -> [INFO] {"req":"hub.status","crc":"0023:5874FEF1"}
16:20:54:360 -> [INFO] {"status":"106408s starting communications {wait-module} {connecting}"}
16:20:54:360 -> [syncNetwork] Connection Status: 4
16:20:56:361 -> [INFO] {"req":"hub.status","crc":"0024:5874FEF1"}
16:20:56:492 -> [INFO] {"status":"106410s starting communications {wait-module} {connecting}"}
16:20:56:492 -> [syncNetwork] Connection Status: 4
16:20:58:492 -> [INFO] {"req":"hub.status","crc":"0025:5874FEF1"}
16:20:58:624 -> [INFO] {"status":"106412s starting communications {wait-module} {connecting}"}
16:20:58:624 -> [syncNetwork] Connection Status: 4
16:21:00:624 -> [INFO] {"req":"hub.status","crc":"0026:5874FEF1"}
16:21:00:756 -> [INFO] {"status":"106414s starting communications {wait-module} {connecting}"}
16:21:00:756 -> [syncNetwork] Connection Status: 4
16:21:02:756 -> [INFO] {"req":"hub.status","crc":"0027:5874FEF1"}
16:21:02:888 -> [INFO] {"status":"106416s starting communications {wait-module} {connecting}"}
16:21:02:888 -> [syncNetwork] Connection Status: 4
16:21:04:888 -> [INFO] {"req":"hub.status","crc":"0028:5874FEF1"}
16:21:05:019 -> [INFO] {"status":"106418s starting communications {wait-module} {connecting}"}
16:21:05:020 -> [syncNetwork] Connection Status: 4
16:21:07:021 -> [INFO] {"req":"hub.status","crc":"0029:5874FEF1"}
16:21:07:152 -> [INFO] {"status":"106420s starting communications {wait-module} {connecting}"}
16:21:07:152 -> [syncNetwork] Connection Status: 4
16:21:09:152 -> [INFO] {"req":"hub.status","crc":"002A:5874FEF1"}
16:21:09:284 -> [INFO] {"status":"106423s starting communications {wait-module} {connecting}"}
16:21:09:284 -> [syncNetwork] Connection Status: 4
16:21:11:284 -> [INFO] {"req":"hub.status","crc":"002B:5874FEF1"}
16:21:11:416 -> [INFO] {"status":"106425s starting communications {wait-module} {connecting}"}
16:21:11:416 -> [syncNetwork] Connection Status: 4
16:21:13:417 -> [INFO] {"req":"hub.status","crc":"002C:5874FEF1"}
16:21:13:548 -> [INFO] {"status":"106427s starting communications {wait-module} {connecting}"}
16:21:13:548 -> [syncNetwork] Connection Status: 4
16:21:15:549 -> [INFO] {"req":"hub.status","crc":"002D:5874FEF1"}
16:21:15:680 -> [INFO] {"status":"106429s starting communications {wait-module} {connecting}"}
16:21:15:680 -> [syncNetwork] Connection Status: 4
16:21:17:680 -> [INFO] {"req":"hub.status","crc":"002E:5874FEF1"}
16:21:17:812 -> [INFO] {"status":"106431s starting communications {wait-module} {connecting}"}
16:21:17:812 -> [syncNetwork] Connection Status: 4
16:21:19:812 -> [INFO] {"req":"hub.status","crc":"002F:5874FEF1"}
16:21:19:944 -> [INFO] {"status":"106433s starting communications {wait-module} {connecting}"}
16:21:19:944 -> [syncNetwork] Connection Status: 4
16:21:21:944 -> [INFO] {"req":"hub.status","crc":"0030:5874FEF1"}
16:21:22:076 -> [INFO] {"status":"106435s starting communications {wait-module} {connecting}"}
16:21:22:076 -> [syncNetwork] Connection Status: 4
16:21:24:077 -> [INFO] {"req":"hub.status","crc":"0031:5874FEF1"}
16:21:24:207 -> [INFO] {"status":"106438s starting communications {wait-module} {connecting}"}
16:21:24:208 -> [syncNetwork] Connection Status: 4
16:21:26:209 -> [INFO] {"req":"hub.status","crc":"0032:5874FEF1"}
16:21:26:340 -> [INFO] {"status":"106440s starting communications {wait-module} {connecting}"}
16:21:26:340 -> [syncNetwork] Connection Status: 4
16:21:28:340 -> [INFO] {"req":"hub.status","crc":"0033:5874FEF1"}
16:21:28:471 -> [INFO] {"status":"106442s starting communications {wait-module} {connecting}"}
16:21:28:472 -> [syncNetwork] Connection Status: 4
16:21:30:472 -> [INFO] {"req":"hub.status","crc":"0034:5874FEF1"}
16:21:30:604 -> [INFO] {"status":"106444s starting communications {wait-module} {connecting}"}
16:21:30:604 -> [syncNetwork] Connection Status: 4
16:21:32:604 -> [INFO] {"req":"hub.status","crc":"0035:5874FEF1"}
16:21:32:736 -> [INFO] {"status":"106446s starting communications {wait-module} {connecting}"}
16:21:32:736 -> [syncNetwork] Connection Status: 4
16:21:34:736 -> [INFO] {"req":"hub.status","crc":"0036:5874FEF1"}
16:21:34:868 -> [INFO] {"status":"106448s starting communications {wait-module} {connecting}"}
16:21:34:868 -> [syncNetwork] Connection Status: 4
16:21:36:868 -> [INFO] {"req":"hub.status","crc":"0037:5874FEF1"}
16:21:37:000 -> [INFO] {"status":"106450s starting communications {wait-module} {connecting}"}
16:21:37:000 -> [syncNetwork] Connection Status: 4
16:21:39:000 -> [INFO] {"req":"hub.status","crc":"0038:5874FEF1"}
16:21:39:132 -> [INFO] {"status":"106452s starting communications {wait-module} {connecting}"}
16:21:39:132 -> [syncNetwork] Connection Status: 4
16:21:41:132 -> [INFO] {"req":"hub.status","crc":"0039:5874FEF1"}
16:21:41:264 -> [INFO] {"status":"106455s starting communications {wait-module} {connecting}"}
16:21:41:264 -> [syncNetwork] Connection Status: 4
16:21:43:265 -> [INFO] {"req":"hub.status","crc":"003A:5874FEF1"}
16:21:43:396 -> [INFO] {"status":"106457s starting communications {wait-module} {connecting}"}
16:21:43:396 -> [syncNetwork] Connection Status: 4
16:21:45:396 -> [INFO] {"req":"hub.status","crc":"003B:5874FEF1"}
16:21:45:528 -> [INFO] {"status":"106459s starting communications {wait-module} {connecting}"}
16:21:45:528 -> [syncNetwork] Connection Status: 4
16:21:47:528 -> [INFO] {"req":"hub.status","crc":"003C:5874FEF1"}
16:21:47:660 -> [INFO] {"status":"106461s starting communications {wait-module} {connecting}"}
16:21:47:660 -> [syncNetwork] Connection Status: 4
16:21:49:660 -> [INFO] {"req":"hub.status","crc":"003D:5874FEF1"}
16:21:49:792 -> [INFO] {"status":"106463s starting communications {wait-module} {connecting}"}
16:21:49:792 -> [syncNetwork] Connection Status: 4
16:21:51:792 -> [INFO] {"req":"hub.status","crc":"003E:5874FEF1"}
16:21:51:926 -> [INFO] {"status":"106465s starting communications {wait-module} {connecting}"}
16:21:51:926 -> [syncNetwork] Connection Status: 4
16:21:53:924 -> [INFO] {"req":"hub.status","crc":"003F:5874FEF1"}
16:21:54:056 -> [INFO] {"status":"106467s starting communications {wait-module} {connecting}"}
16:21:54:056 -> [syncNetwork] Connection Status: 4
16:21:56:056 -> [INFO] {"req":"hub.status","crc":"0040:5874FEF1"}
16:21:56:188 -> [INFO] {"status":"106469s starting communications {wait-module} {connecting}"}
16:21:56:188 -> [syncNetwork] Connection Status: 4
16:21:58:188 -> [INFO] {"req":"hub.status","crc":"0041:5874FEF1"}
16:21:58:320 -> [INFO] {"status":"106472s starting communications {wait-module} {connecting}"}
16:21:58:320 -> [syncNetwork] Connection Status: 4
16:22:00:320 -> [INFO] {"req":"hub.status","crc":"0042:5874FEF1"}
16:22:00:452 -> [INFO] {"status":"106474s starting communications {wait-module} {connecting}"}
16:22:00:452 -> [syncNetwork] Connection Status: 4
16:22:02:453 -> [INFO] {"req":"hub.status","crc":"0043:5874FEF1"}
16:22:02:584 -> [INFO] {"status":"106476s starting communications {wait-module} {connecting}"}
16:22:02:584 -> [syncNetwork] Connection Status: 4
16:22:04:584 -> [INFO] {"req":"hub.status","crc":"0044:5874FEF1"}
16:22:04:716 -> [INFO] {"status":"106478s starting communications {wait-module} {connecting}"}
16:22:04:716 -> [syncNetwork] Connection Status: 4
16:22:06:717 -> [INFO] {"req":"hub.status","crc":"0045:5874FEF1"}
16:22:06:848 -> [INFO] {"status":"106480s starting communications {wait-module} {connecting}"}
16:22:06:848 -> [syncNetwork] Connection Status: 4
16:22:08:849 -> [INFO] {"req":"hub.status","crc":"0046:5874FEF1"}
16:22:08:980 -> [INFO] {"status":"106482s starting communications {wait-module} {connecting}"}
16:22:08:980 -> [syncNetwork] Connection Status: 4
16:22:10:981 -> [INFO] {"req":"hub.status","crc":"0047:5874FEF1"}
16:22:11:112 -> [INFO] {"status":"106484s starting communications {wait-module} {connecting}"}
16:22:11:112 -> [syncNetwork] Connection Status: 4
16:22:13:112 -> [INFO] {"req":"hub.status","crc":"0048:5874FEF1"}
16:22:13:244 -> [INFO] {"status":"106487s starting communications {wait-module} {connecting}"}
16:22:13:244 -> [syncNetwork] Connection Status: 4
16:22:15:245 -> [INFO] {"req":"hub.status","crc":"0049:5874FEF1"}
16:22:15:376 -> [INFO] {"status":"106489s starting communications {wait-module} {connecting}"}
16:22:15:376 -> [syncNetwork] Connection Status: 4
16:22:17:376 -> [INFO] {"req":"hub.status","crc":"004A:5874FEF1"}
16:22:17:508 -> [INFO] {"status":"106491s starting communications {wait-module} {connecting}"}
16:22:17:508 -> [syncNetwork] Connection Status: 4
16:22:19:509 -> [INFO] {"req":"hub.status","crc":"004B:5874FEF1"}
16:22:19:640 -> [INFO] {"status":"106493s starting communications {wait-module} {connecting}"}
16:22:19:640 -> [syncNetwork] Connection Status: 4
16:22:21:640 -> [INFO] {"req":"hub.status","crc":"004C:5874FEF1"}
16:22:21:772 -> [INFO] {"status":"106495s starting communications {wait-module} {connecting}"}
16:22:21:772 -> [syncNetwork] Connection Status: 4
16:22:23:774 -> [INFO] {"req":"hub.status","crc":"004D:5874FEF1"}
16:22:23:908 -> [INFO] {"status":"106497s starting communications {wait-module} {connecting}"}
16:22:23:908 -> [syncNetwork] Connection Status: 4
16:22:25:905 -> [INFO] {"req":"hub.status","crc":"004E:5874FEF1"}
16:22:26:036 -> [INFO] {"status":"106499s starting communications {wait-module} {connecting}"}
16:22:26:037 -> [syncNetwork] Connection Status: 4
16:22:28:037 -> [INFO] {"req":"hub.status","crc":"004F:5874FEF1"}
16:22:28:168 -> [INFO] {"status":"106501s starting communications {wait-module} {connecting}"}
16:22:28:168 -> [syncNetwork] Connection Status: 4
16:22:30:168 -> [INFO] {"req":"hub.status","crc":"0050:5874FEF1"}
16:22:30:300 -> [INFO] {"status":"106504s starting communications {wait-module} {connecting}"}
16:22:30:300 -> [syncNetwork] Connection Status: 4
16:22:32:300 -> [INFO] {"req":"hub.status","crc":"0051:5874FEF1"}
16:22:32:432 -> [INFO] {"status":"106506s starting communications {wait-module} {connecting}"}
16:22:32:432 -> [syncNetwork] Connection Status: 4
16:22:34:433 -> [INFO] {"req":"hub.status","crc":"0052:5874FEF1"}
16:22:34:564 -> [INFO] {"status":"106508s starting communications {wait-module} {connecting}"}
16:22:34:564 -> [syncNetwork] Connection Status: 4
16:22:36:565 -> [INFO] {"req":"hub.status","crc":"0053:5874FEF1"}
16:22:36:696 -> [INFO] {"status":"106510s starting communications {wait-module} {connecting}"}
16:22:36:696 -> [syncNetwork] Connection Status: 4
16:22:38:697 -> [INFO] {"req":"hub.status","crc":"0054:5874FEF1"}
16:22:38:828 -> [INFO] {"status":"106512s starting communications {wait-module} {connecting}"}
16:22:38:828 -> [syncNetwork] Connection Status: 4
16:22:40:828 -> [INFO] {"req":"hub.status","crc":"0055:5874FEF1"}
16:22:40:960 -> [INFO] {"status":"106514s starting communications {wait-module} {connecting}"}
16:22:40:960 -> [syncNetwork] Connection Status: 4
16:22:42:961 -> [INFO] {"req":"hub.status","crc":"0056:5874FEF1"}
16:22:43:092 -> [INFO] {"status":"106516s starting communications {wait-module} {connecting}"}
16:22:43:092 -> [syncNetwork] Connection Status: 4
16:22:45:093 -> [INFO] {"req":"hub.status","crc":"0057:5874FEF1"}
16:22:45:224 -> [INFO] {"status":"106519s starting communications {wait-module} {connecting}"}
16:22:45:224 -> [syncNetwork] Connection Status: 4
16:22:47:224 -> [INFO] {"req":"hub.status","crc":"0058:5874FEF1"}
16:22:47:356 -> [INFO] {"status":"106521s starting communications {wait-module} {connecting}"}
16:22:47:356 -> [syncNetwork] Connection Status: 4
16:22:49:356 -> [INFO] {"req":"hub.status","crc":"0059:5874FEF1"}
16:22:49:488 -> [INFO] {"status":"106523s starting communications {wait-module} {connecting}"}
16:22:49:488 -> [syncNetwork] Connection Status: 4
16:22:51:488 -> [INFO] {"req":"hub.status","crc":"005A:5874FEF1"}
16:22:51:620 -> [INFO] {"status":"106525s starting communications {wait-module} {connecting}"}
16:22:51:620 -> [syncNetwork] Connection Status: 4
16:22:53:621 -> [INFO] {"req":"hub.status","crc":"005B:5874FEF1"}
16:22:53:752 -> [INFO] {"status":"106527s starting communications {wait-module} {connecting}"}
16:22:53:752 -> [syncNetwork] Connection Status: 4
16:22:55:753 -> [INFO] {"req":"hub.status","crc":"005C:5874FEF1"}
16:22:55:884 -> [INFO] {"status":"106529s starting communications {wait-module} {connecting}"}
16:22:55:884 -> [syncNetwork] Connection Status: 4
16:22:57:884 -> [INFO] {"req":"hub.status","crc":"005D:5874FEF1"}
16:22:58:016 -> [INFO] {"status":"106531s starting communications {wait-module} {connecting}"}
16:22:58:016 -> [syncNetwork] Connection Status: 4
16:23:00:016 -> [INFO] {"req":"hub.status","crc":"005E:5874FEF1"}
16:23:00:148 -> [INFO] {"status":"106533s starting communications {wait-module} {connecting}"}
16:23:00:148 -> [syncNetwork] Connection Status: 4
16:23:02:148 -> [INFO] {"req":"hub.status","crc":"005F:5874FEF1"}
16:23:02:280 -> [INFO] {"status":"106536s starting communications {wait-module} {connecting}"}
16:23:02:281 -> [syncNetwork] Connection Status: 4
16:23:04:281 -> [INFO] {"req":"hub.status","crc":"0060:5874FEF1"}
16:23:04:412 -> [INFO] {"status":"106538s starting communications {wait-module} {connecting}"}
16:23:04:412 -> [syncNetwork] Connection Status: 4
16:23:06:412 -> [INFO] {"req":"hub.status","crc":"0061:5874FEF1"}
16:23:06:544 -> [INFO] {"status":"106540s starting communications {wait-module} {connecting}"}
16:23:06:544 -> [syncNetwork] Connection Status: 4
16:23:08:544 -> [INFO] {"req":"hub.status","crc":"0062:5874FEF1"}
16:23:08:676 -> [INFO] {"status":"106542s starting communications {wait-module} {connecting}"}
16:23:08:676 -> [syncNetwork] Connection Status: 4
16:23:10:677 -> [INFO] {"req":"hub.status","crc":"0063:5874FEF1"}
16:23:10:808 -> [INFO] {"status":"106544s starting communications {wait-module} {connecting}"}
16:23:10:808 -> [syncNetwork] Connection Status: 4
16:23:12:809 -> [INFO] {"req":"hub.status","crc":"0064:5874FEF1"}
16:23:12:940 -> [INFO] {"status":"106546s starting communications {wait-module} {connecting}"}
16:23:12:940 -> [syncNetwork] Connection Status: 4
16:23:14:940 -> [INFO] {"req":"hub.status","crc":"0065:5874FEF1"}
16:23:15:131 -> [INFO] {"status":"106548s starting communications {wait-module} {connecting}"}
16:23:15:131 -> [syncNetwork] Connection Status: 4
16:23:15:131 -> [ensureSync] connection timeout
16:23:15:131 -> [INFO] {"req":"card.wireless","crc":"0066:3CE09784"}
16:23:15:202 -> [INFO] {"status":"{modem-on}","mode":"auto","net":{}}
16:23:15:202 -> response =
16:23:15:202 -> [INFO] {"req":"dfu.status","on":true,"name":"user","crc":"0067:47550344"}
16:23:15:364 -> [INFO] {"status":"successful outboard firmware update","mode":"completed","on":true}
16:23:15:364 -> [INFO] {"req":"dfu.status","on":true,"name":"card","crc":"0068:5D9F96C4"}
16:23:15:516 -> [INFO] {"mode":"idle","on":true}
16:23:15:517 -> [INFO] {"req":"card.time","crc":"0069:1110F247"}
16:23:15:646 -> [INFO] {"err":"time is not yet set {no-time}","zone":"UTC,Etc/UTC","crc":"0069:515304FA"}
16:23:15:646 ->
16:23:15:677 -> wake up in 3600 seconds
16:23:15:677 -> Before deepsleep call Pin 10 Val 1
16:23:15:678 -> [INFO] {"req":"card.attn","mode":"arm,sleep,env,auxgpio","seconds":3600,"crc":"006A:52E3553F"}
---- Closed serial port /dev/tty.usbmodem3301 due to disconnection from the machine ----
---- Reopened serial port /dev/tty.usbmodem3301 ----