1638175491.toit-sim-4786.hardware_id-4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.firmware-v1.6.0-pre.25+c8ae5eaa0.log

$ toit serial reinstall --firmware v1.6.0-pre.25+c8ae5eaa0 -p model.cellular.enabled=1 -p model.cellular.tx=5 -p model.cellular.rx=23 -p model.cellular.rts=19 -p model.cellular.cts=18 -p model.cellular.pwr=27 -p model.cellular.monarch=1 -p cellular.apn=nbiot.tdc.dk --port=/dev/ttyUSB0
Detecting chip type. This can take up to 10s.
Reinstalling hardware with firmware: v1.6.0-pre.25+c8ae5eaa0 (using model: esp32-4mb) on port /dev/ttyUSB0
Running "/home/christian/.cache/toit/tools/esptool_linux_v3.0 --chip esp32 --port /dev/ttyUSB0 --baud 921600 --before default_reset --after hard_reset write_flash -z --flash_mode dio --flash_freq 40m --flash_size detect 0xd000 /tmp/773656812/otadata024137563 0x10000 /tmp/773656812/ota_0006403326"
esptool.py v3.0
Serial port /dev/ttyUSB0
Connecting....
Chip is ESP32-D0WDQ6 (revision 1)
Features: WiFi, BT, Dual Core, 240MHz, VRef calibration in efuse, Coding Scheme None
Crystal is 40MHz
MAC: f0:08:d1:ce:c3:b0
Uploading stub...
Running stub...
Stub running...
Changing baud rate to 921600
Changed.
Configuring flash size...
Auto-detected Flash size: 8MB
Compressed 8192 bytes to 31...
Writing at 0x0000d000... (100 %)
Wrote 8192 bytes (31 compressed) at 0x0000d000 in 0.0 seconds (effective 23060.2 kbit/s)...
Hash of data verified.
Compressed 1328096 bytes to 805206...
Writing at 0x00010000... (2 %)
Writing at 0x00014000... (4 %)
Writing at 0x00018000... (6 %)
Writing at 0x0001c000... (8 %)
Writing at 0x00020000... (10 %)
Writing at 0x00024000... (12 %)
Writing at 0x00028000... (14 %)
Writing at 0x0002c000... (16 %)
Writing at 0x00030000... (18 %)
Writing at 0x00034000... (20 %)
Writing at 0x00038000... (22 %)
Writing at 0x0003c000... (24 %)
Writing at 0x00040000... (26 %)
Writing at 0x00044000... (28 %)
Writing at 0x00048000... (30 %)
Writing at 0x0004c000... (32 %)
Writing at 0x00050000... (34 %)
Writing at 0x00054000... (36 %)
Writing at 0x00058000... (38 %)
Writing at 0x0005c000... (40 %)
Writing at 0x00060000... (42 %)
Writing at 0x00064000... (44 %)
Writing at 0x00068000... (46 %)
Writing at 0x0006c000... (48 %)
Writing at 0x00070000... (50 %)
Writing at 0x00074000... (52 %)
Writing at 0x00078000... (54 %)
Writing at 0x0007c000... (56 %)
Writing at 0x00080000... (58 %)
Writing at 0x00084000... (60 %)
Writing at 0x00088000... (62 %)
Writing at 0x0008c000... (64 %)
Writing at 0x00090000... (66 %)
Writing at 0x00094000... (68 %)
Writing at 0x00098000... (70 %)
Writing at 0x0009c000... (72 %)
Writing at 0x000a0000... (74 %)
Writing at 0x000a4000... (76 %)
Writing at 0x000a8000... (78 %)
Writing at 0x000ac000... (80 %)
Writing at 0x000b0000... (82 %)
Writing at 0x000b4000... (84 %)
Writing at 0x000b8000... (86 %)
Writing at 0x000bc000... (88 %)
Writing at 0x000c0000... (90 %)
Writing at 0x000c4000... (92 %)
Writing at 0x000c8000... (94 %)
Writing at 0x000cc000... (96 %)
Writing at 0x000d0000... (98 %)
Writing at 0x000d4000... (100 %)
Wrote 1328096 bytes (805206 compressed) at 0x00010000 in 13.1 seconds (effective 810.5 kbit/s)...
Hash of data verified.

Leaving...
Hard resetting via RTS pin...
Hardware successfully reinstalled with the Toit firmware.
The hardware has been reinstalled with the following configurations:
+------------------------+----------------+
|        SETTING         |     VALUE      |
+------------------------+----------------+
| context                | remote         |
| broker.cn              | device.toit.io |
| broker.port            | 9426           |
| model.cellular.rx      | 23             |
| model.cellular.rts     | 19             |
| model.cellular.pwr     | 27             |
| model.cellular.monarch | 1              |
| model                  | esp32-4mb      |
| broker.host            | device.toit.io |
| model.cellular.cts     | 18             |
| cellular.apn           | nbiot.tdc.dk   |
| model.cellular.enabled | 1              |
| model.cellular.tx      | 5              |
+------------------------+----------------+


$ toit serial info --output table
+-------------------------------------------------------------------------+-----------+--------------------------------------+
|                                  NAME                                   |   MODEL   |             HARDWARE ID              |
+-------------------------------------------------------------------------+-----------+--------------------------------------+
| 4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com | esp32-4mb | 4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c |
+-------------------------------------------------------------------------+-----------+--------------------------------------+


$ toit serial monitor
ets Jun  8 2016 00:22:57

rst:0x1 (POWERON_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
clearing RTC memory: RTC memory is in inconsistent state
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015330) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021534) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.535297) [toit.state] INFO: starting new session {session_id: 1, session_time: 0.542471}
[gc @ 0x3ffcf9f0* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcf9f0* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 94kb | free: 9kb->149kb (largest 108kb) 1.286ms]
(0.616434) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.727110) [toit.console_sync] INFO: loaded last console sync {time: null}
(0.738646) [toit.scheduler] INFO: running job {job: console_sync}
(0.741314) [toit.scheduler] INFO: running job {job: flush_metrics}
(0.743172) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
[gc @ 0x3ffcf9f0* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 6 (heap)]
[gc @ 0x3ffcf9f0* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 12kb->140kb (largest 108kb) 1.905ms]
(0.748424) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.779894) [toit.console] INFO: waiting for console connection to be established
(0.784441) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
(0.792119) [toit.metrics] INFO: persisting metrics
(0.795301) [toit.metrics] INFO: flushing metrics
[gc @ 0x3ffcf9f0* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcf9f0* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 127kb | free: 12kb->116kb (largest 104kb) 2.142ms]
(1.002897) [toit] INFO: -> AT
(1.264228) [toit] INFO: -> AT
(1.524710) [toit] INFO: -> AT
(1.785297) [toit] INFO: -> AT
(2.045911) [toit] INFO: -> AT
[gc @ 0x3ffcf9f0* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcf9f0* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcf9f0* | heap: 44kb -> 28kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.475ms]
(2.306484) [toit] INFO: -> AT
(2.567863) [toit] INFO: -> AT
(2.740218) [toit] INFO: <- OK
(2.845234) [toit] INFO: -> ATE0
(2.852888) [toit] INFO: <- OK
(2.875268) [toit] INFO: -> AT+CMEE=2
(2.881072) [toit] INFO: <- OK
(2.903455) [toit] INFO: -> AT+CGMM
(2.909134) [toit] INFO: <- FiPy
(2.911772) [toit] INFO: <- OK
(2.933633) [toit] INFO: -> AT+CGMR
(2.954395) [toit] INFO: <- UE5.4.0.2
(2.957061) [toit] INFO: <- OK
(2.979010) [toit] INFO: -> AT+SQNCCID?
(2.984551) [toit] INFO: <- +SQNCCID: "",""
(2.987126) [toit] INFO: <- OK
(2.989645) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(3.009391) [toit] INFO: -> AT+CFUN=4
(3.075952) [toit] INFO: <- OK
(3.098236) [toit] INFO: -> AT+CPIN?
(3.103979) [toit] INFO: <- +CME ERROR: SIM not inserted
(3.358579) [toit] INFO: -> AT+CPIN?
(3.364247) [toit] INFO: <- +CME ERROR: SIM not inserted
(3.618574) [toit] INFO: -> AT+CPIN?
(3.738380) [toit] INFO: <- +CPIN: READY
(3.740843) [toit] INFO: <- OK
(3.763041) [toit] INFO: -> AT+CPSMS=0
(3.770448) [toit] INFO: <- OK
(3.793072) [toit] INFO: -> AT+CEDRXS=0
(3.801007) [toit] INFO: <- OK
(3.823402) [toit] INFO: -> AT+SQNIBRCFG=0
(3.843236) [toit] INFO: <- OK
(3.865786) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.883550) [toit] INFO: <- OK
(3.906111) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.975918) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.978496) [toit] INFO: <- OK
(4.000843) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(4.008686) [toit] INFO: <- +CME ERROR: operation not supported
(4.030748) [toit] INFO: -> AT+CGDCONT?
(4.037047) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(4.039857) [toit] INFO: <- OK
(4.062071) [toit] INFO: -> AT+CFUN=1,1
(4.121336) [toit] INFO: <- OK
(4.176838) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.840490) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(9.046558) [toit] INFO: -> AT+CFUN=4
(9.949139) [toit] INFO: <- OK
(9.951936) [toit.cellular] DEBUG: failed, detach from network
(9.970322) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(9.977480) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
[gc @ 0x3ffcf9f0* | soft limit reached (57828 >= 55338)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 441 (heap)]
[gc @ 0x3ffcf9f0* | heap: 56kb -> 24kb | external: 0kb -> 0kb | used: 173kb | free: 10kb->70kb (largest 60kb) 2.492ms]
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(10.096857) [toit] INFO: -> AT+CFUN=0
(10.102575) [toit.scheduler] INFO: changing run level {run_level: 0}
(10.106042) [toit.scheduler] INFO: going into deep sleep {ms: 4984}
(10.108017) [toit.metrics] INFO: persisting metrics
(10.350752) [toit] INFO: <- OK
(10.459359) [toit] INFO: entering deep sleep {ms: 4984}
Entering deep sleep for 4984ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054469) [toit.state] INFO: resumed session {session_id: 1, session_time: 15.571689}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.208ms]
(0.073476) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.110030) [toit.console_sync] INFO: loaded last console sync {time: 10.083517}
(0.125710) [toit.scheduler] INFO: running job {job: console_sync}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.864ms]
(0.128491) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.145388) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.154941) [toit.console] INFO: waiting for console connection to be established
(0.159494) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.029ms]
(0.206708) [toit] INFO: -> AT
(0.468640) [toit] INFO: -> AT
(0.729128) [toit] INFO: -> AT
(0.989708) [toit] INFO: -> AT
(1.250410) [toit] INFO: -> AT
(1.516182) [toit] INFO: -> AT
(1.777698) [toit] INFO: -> AT
(2.038313) [toit] INFO: -> AT
(2.298923) [toit] INFO: -> AT
(2.559511) [toit] INFO: -> AT
(2.820150) [toit] INFO: -> AT
(2.847323) [toit] INFO: <- OK
(2.952353) [toit] INFO: -> ATE0
(2.960028) [toit] INFO: <- OK
(2.982436) [toit] INFO: -> AT+CMEE=2
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 2 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 10kb->94kb (largest 84kb) 2.447ms]
(3.005794) [toit] INFO: <- OK
(3.028052) [toit] INFO: -> AT+CGMM
(3.033575) [toit] INFO: <- FiPy
(3.036217) [toit] INFO: <- OK
(3.058086) [toit] INFO: -> AT+CGMR
(3.079310) [toit] INFO: <- UE5.4.0.2
(3.081932) [toit] INFO: <- OK
(3.103918) [toit] INFO: -> AT+SQNCCID?
(3.109595) [toit] INFO: <- +SQNCCID: "",""
(3.112120) [toit] INFO: <- OK
(3.114588) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(3.134336) [toit] INFO: -> AT+CFUN=4
(3.201293) [toit] INFO: <- OK
(3.223844) [toit] INFO: -> AT+CPIN?
(3.229535) [toit] INFO: <- +CME ERROR: SIM not inserted
(3.483950) [toit] INFO: -> AT+CPIN?
(3.489627) [toit] INFO: <- +CME ERROR: SIM not inserted
(3.743953) [toit] INFO: -> AT+CPIN?
(3.866344) [toit] INFO: <- +CPIN: READY
(3.869066) [toit] INFO: <- OK
(3.891244) [toit] INFO: -> AT+CPSMS=0
(3.905946) [toit] INFO: <- OK
(3.928538) [toit] INFO: -> AT+CEDRXS=0
(3.935944) [toit] INFO: <- OK
(3.958332) [toit] INFO: -> AT+SQNIBRCFG=0
(3.977759) [toit] INFO: <- OK
(4.000313) [toit] INFO: -> AT+SQNIPSCFG=1,100
(4.017690) [toit] INFO: <- OK
(4.040330) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(4.109306) [toit] INFO: <- +SQNBANDSEL: <custom>
(4.112062) [toit] INFO: <- OK
(4.134389) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(4.142079) [toit] INFO: <- +CME ERROR: operation not supported
(4.164045) [toit] INFO: -> AT+CGDCONT?
(4.170517) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(4.172969) [toit] INFO: <- OK
(4.195525) [toit] INFO: -> AT+CFUN=1,1
(4.323843) [toit] INFO: <- OK
(4.684849) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(6.406803) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(9.179592) [toit] INFO: -> AT+CFUN=4
(9.406384) [toit] INFO: <- OK
(9.408950) [toit.cellular] DEBUG: failed, detach from network
(9.420281) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(9.428217) [toit.network] WARN: failed to connect to any network
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 68 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.423ms]
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(9.544140) [toit] INFO: -> AT+CFUN=0
(9.549890) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.553624) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(9.555502) [toit.metrics] INFO: persisting metrics
(9.804499) [toit] INFO: <- OK
(9.912240) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015317) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021521) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054313) [toit.state] INFO: resumed session {session_id: 1, session_time: 30.523158}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.194ms]
(0.073391) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.110128) [toit.console_sync] INFO: loaded last console sync {time: 25.030823}
(0.125972) [toit.scheduler] INFO: running job {job: console_sync}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.838ms]
(0.138959) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.145550) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.155185) [toit.console] INFO: waiting for console connection to be established
(0.159755) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.034ms]
(0.208061) [toit] INFO: -> AT
(0.469417) [toit] INFO: -> AT
(0.729901) [toit] INFO: -> AT
(0.990481) [toit] INFO: -> AT
(1.251373) [toit] INFO: -> AT
(1.516188) [toit] INFO: -> AT
(1.777697) [toit] INFO: -> AT
(1.948590) [toit] INFO: <- OK
(2.053828) [toit] INFO: -> ATE0
(2.061607) [toit] INFO: <- OK
(2.084092) [toit] INFO: -> AT+CMEE=2
(2.089685) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 64 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 149kb | free: 10kb->94kb (largest 84kb) 2.351ms]
(2.123500) [toit] INFO: -> AT+CGMM
(2.129581) [toit] INFO: <- FiPy
(2.132123) [toit] INFO: <- OK
(2.154075) [toit] INFO: -> AT+CGMR
(2.174756) [toit] INFO: <- UE5.4.0.2
(2.177343) [toit] INFO: <- OK
(2.206008) [toit] INFO: -> AT+SQNCCID?
(2.211393) [toit] INFO: <- +SQNCCID: "",""
(2.213731) [toit] INFO: <- OK
(2.216176) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.235922) [toit] INFO: -> AT+CFUN=4
(2.302134) [toit] INFO: <- OK
(2.324388) [toit] INFO: -> AT+CPIN?
(2.330046) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.584738) [toit] INFO: -> AT+CPIN?
(2.590349) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.844661) [toit] INFO: -> AT+CPIN?
(2.969301) [toit] INFO: <- +CPIN: READY
(2.971637) [toit] INFO: <- OK
(2.993833) [toit] INFO: -> AT+CPSMS=0
(3.001072) [toit] INFO: <- OK
(3.023857) [toit] INFO: -> AT+CEDRXS=0
(3.031009) [toit] INFO: <- OK
(3.053445) [toit] INFO: -> AT+SQNIBRCFG=0
(3.073039) [toit] INFO: <- OK
(3.095632) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.121390) [toit] INFO: <- OK
(3.144017) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.216990) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.219418) [toit] INFO: <- OK
(3.241781) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.249366) [toit] INFO: <- +CME ERROR: operation not supported
(3.271586) [toit] INFO: -> AT+CGDCONT?
(3.278236) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.280775) [toit] INFO: <- OK
(3.303248) [toit] INFO: -> AT+CFUN=1,1
(3.362414) [toit] INFO: <- OK
(3.417728) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.221785) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.287788) [toit] INFO: -> AT+CFUN=4
(9.231435) [toit] INFO: <- OK
(9.233694) [toit.cellular] DEBUG: failed, detach from network
(9.250804) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 10kb->94kb (largest 84kb) 2.402ms]
(9.276934) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(9.374722) [toit] INFO: -> AT+CFUN=0
(9.380425) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.383873) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(9.385751) [toit.metrics] INFO: persisting metrics
(9.631454) [toit] INFO: <- OK
(9.739444) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015332) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021536) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054199) [toit.state] INFO: resumed session {session_id: 1, session_time: 45.309801}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.185ms]
(0.073526) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.110215) [toit.console_sync] INFO: loaded last console sync {time: 39.820683}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.752ms]
(0.131857) [toit.scheduler] INFO: running job {job: console_sync}
(0.134663) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.140121) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.149794) [toit.console] INFO: waiting for console connection to be established
(0.154359) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.052ms]
(0.203743) [toit] INFO: -> AT
(0.465097) [toit] INFO: -> AT
(0.725593) [toit] INFO: -> AT
(0.986170) [toit] INFO: -> AT
(1.247797) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.431ms]
(1.516178) [toit] INFO: -> AT
(1.777809) [toit] INFO: -> AT
(1.946534) [toit] INFO: <- OK
(2.051764) [toit] INFO: -> ATE0
(2.059436) [toit] INFO: <- OK
(2.082202) [toit] INFO: -> AT+CMEE=2
(2.087700) [toit] INFO: <- OK
(2.110203) [toit] INFO: -> AT+CGMM
(2.115577) [toit] INFO: <- FiPy
(2.118151) [toit] INFO: <- OK
(2.140091) [toit] INFO: -> AT+CGMR
(2.160776) [toit] INFO: <- UE5.4.0.2
(2.163330) [toit] INFO: <- OK
(2.185341) [toit] INFO: -> AT+SQNCCID?
(2.190677) [toit] INFO: <- +SQNCCID: "",""
(2.193071) [toit] INFO: <- OK
(2.195531) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.215335) [toit] INFO: -> AT+CFUN=4
(2.281552) [toit] INFO: <- OK
(2.305977) [toit] INFO: -> AT+CPIN?
(2.311618) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.566234) [toit] INFO: -> AT+CPIN?
(2.571820) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.826055) [toit] INFO: -> AT+CPIN?
(2.946793) [toit] INFO: <- +CPIN: READY
(2.949144) [toit] INFO: <- OK
(2.971320) [toit] INFO: -> AT+CPSMS=0
(2.978669) [toit] INFO: <- OK
(3.006529) [toit] INFO: -> AT+CEDRXS=0
(3.013796) [toit] INFO: <- OK
(3.036222) [toit] INFO: -> AT+SQNIBRCFG=0
(3.055842) [toit] INFO: <- OK
(3.078396) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.095614) [toit] INFO: <- OK
(3.118305) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.187958) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.190397) [toit] INFO: <- OK
(3.212745) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.220496) [toit] INFO: <- +CME ERROR: operation not supported
(3.242478) [toit] INFO: -> AT+CGDCONT?
(3.249205) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.251740) [toit] INFO: <- OK
(3.274071) [toit] INFO: -> AT+CFUN=1,1
(3.333635) [toit] INFO: <- OK
(3.388934) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.020990) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.259090) [toit] INFO: -> AT+CFUN=4
(9.774878) [toit] INFO: <- OK
(9.777451) [toit.cellular] DEBUG: failed, detach from network
(9.790808) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.415ms]
(9.816976) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(9.915669) [toit] INFO: -> AT+CFUN=0
(9.921219) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.924964) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(9.926843) [toit.metrics] INFO: persisting metrics
(10.172474) [toit] INFO: <- OK
(10.280177) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.053999) [toit.state] INFO: resumed session {session_id: 1, session_time: 60.629178}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 20 (heap)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 94kb | free: 9kb->149kb (largest 108kb) 1.201ms]
(0.079897) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.119986) [toit.console_sync] INFO: loaded last console sync {time: 55.140531}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.862ms]
(0.136188) [toit.scheduler] INFO: running job {job: console_sync}
(0.148446) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.154959) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.164724) [toit.console] INFO: waiting for console connection to be established
(0.169216) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.022ms]
(0.219945) [toit] INFO: -> AT
(0.481309) [toit] INFO: -> AT
(0.741795) [toit] INFO: -> AT
(1.006069) [toit] INFO: -> AT
(1.267565) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.424ms]
(1.528150) [toit] INFO: -> AT
(1.788850) [toit] INFO: -> AT
(1.964034) [toit] INFO: <- OK
(2.069273) [toit] INFO: -> ATE0
(2.077151) [toit] INFO: <- OK
(2.106325) [toit] INFO: -> AT+CMEE=2
(2.112262) [toit] INFO: <- OK
(2.134323) [toit] INFO: -> AT+CGMM
(2.139621) [toit] INFO: <- FiPy
(2.142191) [toit] INFO: <- OK
(2.164089) [toit] INFO: -> AT+CGMR
(2.184928) [toit] INFO: <- UE5.4.0.2
(2.187487) [toit] INFO: <- OK
(2.209493) [toit] INFO: -> AT+SQNCCID?
(2.214842) [toit] INFO: <- +SQNCCID: "",""
(2.217244) [toit] INFO: <- OK
(2.219713) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.239505) [toit] INFO: -> AT+CFUN=4
(2.305740) [toit] INFO: <- OK
(2.327997) [toit] INFO: -> AT+CPIN?
(2.333585) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.588188) [toit] INFO: -> AT+CPIN?
(2.593766) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.848005) [toit] INFO: -> AT+CPIN?
(2.973598) [toit] INFO: <- +CPIN: READY
(2.975946) [toit] INFO: <- OK
(3.006392) [toit] INFO: -> AT+CPSMS=0
(3.013674) [toit] INFO: <- OK
(3.036250) [toit] INFO: -> AT+CEDRXS=0
(3.043411) [toit] INFO: <- OK
(3.065834) [toit] INFO: -> AT+SQNIBRCFG=0
(3.085400) [toit] INFO: <- OK
(3.108045) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.125051) [toit] INFO: <- OK
(3.147967) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.217979) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.220395) [toit] INFO: <- OK
(3.242759) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.250544) [toit] INFO: <- +CME ERROR: operation not supported
(3.272515) [toit] INFO: -> AT+CGDCONT?
(3.279287) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.281826) [toit] INFO: <- OK
(3.304236) [toit] INFO: -> AT+CFUN=1,1
(3.363652) [toit] INFO: <- OK
(3.510080) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.629040) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.289138) [toit] INFO: -> AT+CFUN=4
(9.150994) [toit] INFO: <- OK
(9.153237) [toit.cellular] DEBUG: failed, detach from network
(9.170814) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.411ms]
(9.197198) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(9.295649) [toit] INFO: -> AT+CFUN=0
(9.301555) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.305040) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(9.306941) [toit.metrics] INFO: persisting metrics
(9.887320) [toit] INFO: <- OK
(9.995036) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015332) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021536) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.053853) [toit.state] INFO: resumed session {session_id: 1, session_time: 75.674914}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.128ms]
(0.072426) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.110435) [toit.console_sync] INFO: loaded last console sync {time: 69.844418}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.817ms]
(0.132332) [toit.scheduler] INFO: running job {job: console_sync}
(0.135102) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.141443) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.151094) [toit.console] INFO: waiting for console connection to be established
(0.155684) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.036ms]
(0.206979) [toit] INFO: -> AT
(0.468635) [toit] INFO: -> AT
(0.729128) [toit] INFO: -> AT
(0.989704) [toit] INFO: -> AT
(1.250406) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.432ms]
(1.516161) [toit] INFO: -> AT
(1.777810) [toit] INFO: -> AT
(1.952512) [toit] INFO: <- OK
(2.057933) [toit] INFO: -> ATE0
(2.065730) [toit] INFO: <- OK
(2.088255) [toit] INFO: -> AT+CMEE=2
(2.094144) [toit] INFO: <- OK
(2.116311) [toit] INFO: -> AT+CGMM
(2.121623) [toit] INFO: <- FiPy
(2.124197) [toit] INFO: <- OK
(2.146094) [toit] INFO: -> AT+CGMR
(2.166824) [toit] INFO: <- UE5.4.0.2
(2.169379) [toit] INFO: <- OK
(2.191376) [toit] INFO: -> AT+SQNCCID?
(2.196725) [toit] INFO: <- +SQNCCID: "",""
(2.199154) [toit] INFO: <- OK
(2.201645) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.221360) [toit] INFO: -> AT+CFUN=4
(2.564337) [toit] INFO: <- OK
(2.586596) [toit] INFO: -> AT+CPIN?
(2.592215) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.847574) [toit] INFO: -> AT+CPIN?
(2.949311) [toit] INFO: <- +CPIN: READY
(2.951699) [toit] INFO: <- OK
(2.973869) [toit] INFO: -> AT+CPSMS=0
(2.980990) [toit] INFO: <- OK
(3.006311) [toit] INFO: -> AT+CEDRXS=0
(3.013600) [toit] INFO: <- OK
(3.036003) [toit] INFO: -> AT+SQNIBRCFG=0
(3.055203) [toit] INFO: <- OK
(3.078081) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.095310) [toit] INFO: <- OK
(3.118018) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.187884) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.190304) [toit] INFO: <- OK
(3.212697) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.220381) [toit] INFO: <- +CME ERROR: operation not supported
(3.242600) [toit] INFO: -> AT+CGDCONT?
(3.249165) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.252031) [toit] INFO: <- OK
(3.274438) [toit] INFO: -> AT+CFUN=1,1
(3.333570) [toit] INFO: <- OK
(3.725004) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.448984) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.259441) [toit] INFO: -> AT+CFUN=4
(8.955388) [toit] INFO: <- OK
(8.957922) [toit.cellular] DEBUG: failed, detach from network
(8.970812) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.419ms]
(8.995145) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(9.095791) [toit] INFO: -> AT+CFUN=0
(9.101629) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.105434) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(9.107329) [toit.metrics] INFO: persisting metrics
(9.348582) [toit] INFO: <- OK
(9.456273) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.053711) [toit.state] INFO: resumed session {session_id: 1, session_time: 90.176783}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.132ms]
(0.072284) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.110534) [toit.console_sync] INFO: loaded last console sync {time: 84.692437}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.784ms]
(0.132777) [toit.scheduler] INFO: running job {job: console_sync}
(0.135576) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.141428) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.151085) [toit.console] INFO: waiting for console connection to be established
(0.155669) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.037ms]
(0.208040) [toit] INFO: -> AT
(0.469393) [toit] INFO: -> AT
(0.729882) [toit] INFO: -> AT
(0.990457) [toit] INFO: -> AT
(1.251145) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.428ms]
(1.516178) [toit] INFO: -> AT
(1.777806) [toit] INFO: -> AT
(1.950865) [toit] INFO: <- OK
(2.056094) [toit] INFO: -> ATE0
(2.063889) [toit] INFO: <- OK
(2.086411) [toit] INFO: -> AT+CMEE=2
(2.092291) [toit] INFO: <- OK
(2.114444) [toit] INFO: -> AT+CGMM
(2.119830) [toit] INFO: <- FiPy
(2.122403) [toit] INFO: <- OK
(2.144300) [toit] INFO: -> AT+CGMR
(2.165016) [toit] INFO: <- UE5.4.0.2
(2.167578) [toit] INFO: <- OK
(2.189576) [toit] INFO: -> AT+SQNCCID?
(2.194926) [toit] INFO: <- +SQNCCID: "",""
(2.197348) [toit] INFO: <- OK
(2.199842) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.219561) [toit] INFO: -> AT+CFUN=4
(2.285939) [toit] INFO: <- OK
(2.308253) [toit] INFO: -> AT+CPIN?
(2.313892) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.568489) [toit] INFO: -> AT+CPIN?
(2.574065) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.828307) [toit] INFO: -> AT+CPIN?
(2.949115) [toit] INFO: <- +CPIN: READY
(2.951463) [toit] INFO: <- OK
(2.973643) [toit] INFO: -> AT+CPSMS=0
(2.981034) [toit] INFO: <- OK
(3.006538) [toit] INFO: -> AT+CEDRXS=0
(3.013835) [toit] INFO: <- OK
(3.036243) [toit] INFO: -> AT+SQNIBRCFG=0
(3.055507) [toit] INFO: <- OK
(3.078126) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.095575) [toit] INFO: <- OK
(3.118218) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.187996) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.190432) [toit] INFO: <- OK
(3.212774) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.220574) [toit] INFO: <- +CME ERROR: operation not supported
(3.242549) [toit] INFO: -> AT+CGDCONT?
(3.249356) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.251891) [toit] INFO: <- OK
(3.274074) [toit] INFO: -> AT+CFUN=1,1
(3.333644) [toit] INFO: <- OK
(3.388836) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(4.996428) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.259105) [toit] INFO: -> AT+CFUN=4
(8.844099) [toit] INFO: <- OK
(8.846666) [toit.cellular] DEBUG: failed, detach from network
(8.862459) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.420ms]
(8.890135) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(8.996959) [toit] INFO: -> AT+CFUN=0
(9.003091) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.006568) [toit.scheduler] INFO: going into deep sleep {ms: 4988}
(9.008457) [toit.metrics] INFO: persisting metrics
(9.252473) [toit] INFO: <- OK
(9.360180) [toit] INFO: entering deep sleep {ms: 4988}
Entering deep sleep for 4988ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015332) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021536) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054877) [toit.state] INFO: resumed session {session_id: 1, session_time: 104.576917}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.140ms]
(0.073529) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.110586) [toit.console_sync] INFO: loaded last console sync {time: 99.089295}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.763ms]
(0.139098) [toit.scheduler] INFO: running job {job: console_sync}
(0.141901) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.146126) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.155754) [toit.console] INFO: waiting for console connection to be established
(0.160372) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.088ms]
(0.221137) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.402ms]
(0.482740) [toit] INFO: -> AT
(0.743094) [toit] INFO: -> AT
(1.004056) [toit] INFO: -> AT
(1.264724) [toit] INFO: -> AT
(1.525321) [toit] INFO: -> AT
(1.785908) [toit] INFO: -> AT
(1.962696) [toit] INFO: <- OK
(2.067933) [toit] INFO: -> ATE0
(2.075717) [toit] INFO: <- OK
(2.106333) [toit] INFO: -> AT+CMEE=2
(2.111940) [toit] INFO: <- OK
(2.134001) [toit] INFO: -> AT+CGMM
(2.139485) [toit] INFO: <- FiPy
(2.142067) [toit] INFO: <- OK
(2.163928) [toit] INFO: -> AT+CGMR
(2.184717) [toit] INFO: <- UE5.4.0.2
(2.187233) [toit] INFO: <- OK
(2.209233) [toit] INFO: -> AT+SQNCCID?
(2.214591) [toit] INFO: <- +SQNCCID: "",""
(2.216954) [toit] INFO: <- OK
(2.219428) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.239212) [toit] INFO: -> AT+CFUN=4
(2.720722) [toit] INFO: <- OK
(2.742975) [toit] INFO: -> AT+CPIN?
(2.748653) [toit] INFO: <- +CME ERROR: SIM busy
(3.003312) [toit] INFO: -> AT+CPIN?
(3.008889) [toit] INFO: <- +CPIN: READY
(3.011296) [toit] INFO: <- OK
(3.033487) [toit] INFO: -> AT+CPSMS=0
(3.040598) [toit] INFO: <- OK
(3.063048) [toit] INFO: -> AT+CEDRXS=0
(3.070323) [toit] INFO: <- OK
(3.092734) [toit] INFO: -> AT+SQNIBRCFG=0
(3.111847) [toit] INFO: <- OK
(3.134431) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.151739) [toit] INFO: <- OK
(3.174556) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.243877) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.246305) [toit] INFO: <- OK
(3.268683) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.276372) [toit] INFO: <- +CME ERROR: operation not supported
(3.306293) [toit] INFO: -> AT+CGDCONT?
(3.312885) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.315435) [toit] INFO: <- OK
(3.337767) [toit] INFO: -> AT+CFUN=1,1
(3.491344) [toit] INFO: <- OK
(3.877388) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.506693) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.322813) [toit] INFO: -> AT+CFUN=4
(8.488893) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 8 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.354ms]
(8.504158) [toit.cellular] DEBUG: failed, detach from network
(8.520806) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(8.530006) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(8.626552) [toit] INFO: -> AT+CFUN=0
(8.632271) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.635713) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.637590) [toit.metrics] INFO: persisting metrics
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 5 (heap)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 68kb) 2.472ms]
(8.892570) [toit] INFO: <- OK
(9.000763) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054698) [toit.state] INFO: resumed session {session_id: 1, session_time: 118.628620}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.140ms]
(0.073352) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.110747) [toit.console_sync] INFO: loaded last console sync {time: 113.129567}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.766ms]
(0.139658) [toit.scheduler] INFO: running job {job: console_sync}
(0.142461) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.146467) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.155862) [toit.console] INFO: waiting for console connection to be established
(0.160481) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.090ms]
(0.216110) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.386ms]
(0.478004) [toit] INFO: -> AT
(0.738354) [toit] INFO: -> AT
(0.999114) [toit] INFO: -> AT
(1.259778) [toit] INFO: -> AT
(1.520378) [toit] INFO: -> AT
(1.780961) [toit] INFO: -> AT
(1.967074) [toit] INFO: <- OK
(2.072317) [toit] INFO: -> ATE0
(2.079969) [toit] INFO: <- OK
(2.106340) [toit] INFO: -> AT+CMEE=2
(2.111919) [toit] INFO: <- OK
(2.133983) [toit] INFO: -> AT+CGMM
(2.139367) [toit] INFO: <- FiPy
(2.141942) [toit] INFO: <- OK
(2.163879) [toit] INFO: -> AT+CGMR
(2.184597) [toit] INFO: <- UE5.4.0.2
(2.187139) [toit] INFO: <- OK
(2.209141) [toit] INFO: -> AT+SQNCCID?
(2.214853) [toit] INFO: <- +SQNCCID: "",""
(2.217226) [toit] INFO: <- OK
(2.219690) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.239480) [toit] INFO: -> AT+CFUN=4
(2.305742) [toit] INFO: <- OK
(2.327997) [toit] INFO: -> AT+CPIN?
(2.333704) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.588301) [toit] INFO: -> AT+CPIN?
(2.593943) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.848228) [toit] INFO: -> AT+CPIN?
(2.958853) [toit] INFO: <- +CPIN: READY
(2.961204) [toit] INFO: <- OK
(2.983390) [toit] INFO: -> AT+CPSMS=0
(2.990678) [toit] INFO: <- OK
(3.013416) [toit] INFO: -> AT+CEDRXS=0
(3.021090) [toit] INFO: <- OK
(3.043507) [toit] INFO: -> AT+SQNIBRCFG=0
(3.063051) [toit] INFO: <- OK
(3.085650) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.103121) [toit] INFO: <- OK
(3.125779) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.195469) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.197948) [toit] INFO: <- OK
(3.220303) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.228105) [toit] INFO: <- +CME ERROR: operation not supported
(3.250340) [toit] INFO: -> AT+CGDCONT?
(3.257195) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.259730) [toit] INFO: <- OK
(3.281852) [toit] INFO: -> AT+CFUN=1,1
(3.341011) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 55 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.365ms]
(3.396320) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.111051) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.266971) [toit] INFO: -> AT+CFUN=4
(8.611083) [toit] INFO: <- OK
(8.613825) [toit.cellular] DEBUG: failed, detach from network
(8.630811) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(8.640214) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(8.737443) [toit] INFO: -> AT+CFUN=0
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 68kb) 2.509ms]
(8.742976) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.762684) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.767058) [toit.metrics] INFO: persisting metrics
(9.405773) [toit] INFO: <- OK
(9.513488) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054543) [toit.state] INFO: resumed session {session_id: 1, session_time: 133.188429}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.145ms]
(0.073271) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.110851) [toit.console_sync] INFO: loaded last console sync {time: 127.288363}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.767ms]
(0.139986) [toit.scheduler] INFO: running job {job: console_sync}
(0.142789) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.146571) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.155965) [toit.console] INFO: waiting for console connection to be established
(0.160584) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.073ms]
(0.230140) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.390ms]
(0.491737) [toit] INFO: -> AT
(0.752098) [toit] INFO: -> AT
(1.012944) [toit] INFO: -> AT
(1.273514) [toit] INFO: -> AT
(1.534115) [toit] INFO: -> AT
(1.794698) [toit] INFO: -> AT
(1.980754) [toit] INFO: <- OK
(2.085996) [toit] INFO: -> ATE0
(2.093775) [toit] INFO: <- OK
(2.116259) [toit] INFO: -> AT+CMEE=2
(2.121739) [toit] INFO: <- OK
(2.143871) [toit] INFO: -> AT+CGMM
(2.149277) [toit] INFO: <- FiPy
(2.151848) [toit] INFO: <- OK
(2.173696) [toit] INFO: -> AT+CGMR
(2.194459) [toit] INFO: <- UE5.4.0.2
(2.197008) [toit] INFO: <- OK
(2.219023) [toit] INFO: -> AT+SQNCCID?
(2.224375) [toit] INFO: <- +SQNCCID: "",""
(2.226738) [toit] INFO: <- OK
(2.229211) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.249002) [toit] INFO: -> AT+CFUN=4
(2.603239) [toit] INFO: <- OK
(2.625523) [toit] INFO: -> AT+CPIN?
(2.631201) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.885756) [toit] INFO: -> AT+CPIN?
(2.978856) [toit] INFO: <- +CPIN: READY
(2.981255) [toit] INFO: <- OK
(3.006437) [toit] INFO: -> AT+CPSMS=0
(3.014023) [toit] INFO: <- OK
(3.036389) [toit] INFO: -> AT+CEDRXS=0
(3.043991) [toit] INFO: <- OK
(3.066405) [toit] INFO: -> AT+SQNIBRCFG=0
(3.085526) [toit] INFO: <- OK
(3.108353) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.125821) [toit] INFO: <- OK
(3.148453) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.218441) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.220880) [toit] INFO: <- OK
(3.243244) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.250924) [toit] INFO: <- +CME ERROR: operation not supported
(3.273154) [toit] INFO: -> AT+CGDCONT?
(3.280077) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.282624) [toit] INFO: <- OK
(3.305042) [toit] INFO: -> AT+CFUN=1,1
(3.364509) [toit] INFO: <- OK
(3.710740) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.355614) [toit] INFO: <- *ignored* [URC] +SYSSTART []
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.434ms]
(8.290127) [toit] INFO: -> AT+CFUN=4
(8.599326) [toit] INFO: <- OK
(8.601596) [toit.cellular] DEBUG: failed, detach from network
(8.620813) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(8.630407) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(8.726775) [toit] INFO: -> AT+CFUN=0
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 68kb) 2.513ms]
(8.732484) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.752018) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.756402) [toit.metrics] INFO: persisting metrics
(8.984397) [toit] INFO: <- OK
(9.092121) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054411) [toit.state] INFO: resumed session {session_id: 1, session_time: 147.332465}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.161ms]
(0.073916) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.110937) [toit.console_sync] INFO: loaded last console sync {time: 141.842462}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.751ms]
(0.141430) [toit.scheduler] INFO: running job {job: console_sync}
(0.144253) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.146524) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.156160) [toit.console] INFO: waiting for console connection to be established
(0.160778) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 10 (heap)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 127kb | free: 12kb->116kb (largest 104kb) 2.080ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 148kb | free: 6kb->94kb (largest 88kb) 2.345ms]
(0.235761) [toit] INFO: -> AT
(0.498014) [toit] INFO: -> AT
(0.758480) [toit] INFO: -> AT
(1.019156) [toit] INFO: -> AT
(1.279749) [toit] INFO: -> AT
(1.540337) [toit] INFO: -> AT
(1.800952) [toit] INFO: -> AT
(1.980281) [toit] INFO: <- OK
(2.085521) [toit] INFO: -> ATE0
(2.093185) [toit] INFO: <- OK
(2.115628) [toit] INFO: -> AT+CMEE=2
(2.121108) [toit] INFO: <- OK
(2.143211) [toit] INFO: -> AT+CGMM
(2.148602) [toit] INFO: <- FiPy
(2.151168) [toit] INFO: <- OK
(2.173006) [toit] INFO: -> AT+CGMR
(2.193848) [toit] INFO: <- UE5.4.0.2
(2.196367) [toit] INFO: <- OK
(2.218404) [toit] INFO: -> AT+SQNCCID?
(2.223741) [toit] INFO: <- +SQNCCID: "",""
(2.226112) [toit] INFO: <- OK
(2.228567) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.248370) [toit] INFO: -> AT+CFUN=4
(2.675585) [toit] INFO: <- OK
(2.706001) [toit] INFO: -> AT+CPIN?
(2.711679) [toit] INFO: <- +CME ERROR: SIM busy
(2.965997) [toit] INFO: -> AT+CPIN?
(2.979341) [toit] INFO: <- +CPIN: READY
(2.981724) [toit] INFO: <- OK
(3.006420) [toit] INFO: -> AT+CPSMS=0
(3.013507) [toit] INFO: <- OK
(3.035950) [toit] INFO: -> AT+CEDRXS=0
(3.043143) [toit] INFO: <- OK
(3.065555) [toit] INFO: -> AT+SQNIBRCFG=0
(3.084583) [toit] INFO: <- OK
(3.107125) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.124192) [toit] INFO: <- OK
(3.147024) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.216983) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.219412) [toit] INFO: <- OK
(3.241839) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.249564) [toit] INFO: <- +CME ERROR: operation not supported
(3.271784) [toit] INFO: -> AT+CGDCONT?
(3.278785) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.281647) [toit] INFO: <- OK
(3.303907) [toit] INFO: -> AT+CFUN=1,1
(3.538336) [toit] INFO: <- OK
(3.863903) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.482761) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.289315) [toit] INFO: -> AT+CFUN=4
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 5 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.347ms]
(9.045772) [toit] INFO: <- OK
(9.049232) [toit.cellular] DEBUG: failed, detach from network
(9.070815) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(9.080643) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(9.177463) [toit] INFO: -> AT+CFUN=0
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 68kb) 2.513ms]
(9.183156) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.202711) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(9.207070) [toit.metrics] INFO: persisting metrics
(9.437669) [toit] INFO: <- OK
(9.545370) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054269) [toit.state] INFO: resumed session {session_id: 1, session_time: 161.925537}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.159ms]
(0.073895) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.111044) [toit.console_sync] INFO: loaded last console sync {time: 156.433374}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.751ms]
(0.141666) [toit.scheduler] INFO: running job {job: console_sync}
(0.144488) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.146632) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.156266) [toit.console] INFO: waiting for console connection to be established
(0.160885) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.049ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 148kb | free: 6kb->94kb (largest 88kb) 2.151ms]
(0.225707) [toit] INFO: -> AT
(0.487788) [toit] INFO: -> AT
(0.748262) [toit] INFO: -> AT
(1.009094) [toit] INFO: -> AT
(1.269870) [toit] INFO: -> AT
(1.530269) [toit] INFO: -> AT
(1.790851) [toit] INFO: -> AT
(1.967677) [toit] INFO: <- OK
(2.072914) [toit] INFO: -> ATE0
(2.080566) [toit] INFO: <- OK
(2.106332) [toit] INFO: -> AT+CMEE=2
(2.111908) [toit] INFO: <- OK
(2.133961) [toit] INFO: -> AT+CGMM
(2.139202) [toit] INFO: <- FiPy
(2.142030) [toit] INFO: <- OK
(2.163904) [toit] INFO: -> AT+CGMR
(2.184637) [toit] INFO: <- UE5.4.0.2
(2.186904) [toit] INFO: <- OK
(2.208843) [toit] INFO: -> AT+SQNCCID?
(2.214627) [toit] INFO: <- +SQNCCID: "",""
(2.217014) [toit] INFO: <- OK
(2.219473) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.239262) [toit] INFO: -> AT+CFUN=4
(2.305450) [toit] INFO: <- OK
(2.327728) [toit] INFO: -> AT+CPIN?
(2.333331) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.588003) [toit] INFO: -> AT+CPIN?
(2.593587) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.847825) [toit] INFO: -> AT+CPIN?
(2.954715) [toit] INFO: <- +CPIN: READY
(2.957051) [toit] INFO: <- OK
(2.979234) [toit] INFO: -> AT+CPSMS=0
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.359ms]
(2.986573) [toit] INFO: <- OK
(3.015495) [toit] INFO: -> AT+CEDRXS=0
(3.022689) [toit] INFO: <- OK
(3.045163) [toit] INFO: -> AT+SQNIBRCFG=0
(3.064872) [toit] INFO: <- OK
(3.087473) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.104499) [toit] INFO: <- OK
(3.127150) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.200090) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.202837) [toit] INFO: <- OK
(3.225265) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.232763) [toit] INFO: <- +CME ERROR: operation not supported
(3.254990) [toit] INFO: -> AT+CGDCONT?
(3.261699) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.264230) [toit] INFO: <- OK
(3.286354) [toit] INFO: -> AT+CFUN=1,1
(3.345906) [toit] INFO: <- OK
(3.400719) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.113802) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.271672) [toit] INFO: -> AT+CFUN=4
(9.773611) [toit] INFO: <- OK
(9.776198) [toit.cellular] DEBUG: failed, detach from network
(9.791090) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(9.801150) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 68 (heap)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 76kb) 2.633ms]
(9.922748) [toit] INFO: -> AT+CFUN=0
(9.928302) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.932045) [toit.scheduler] INFO: going into deep sleep {ms: 4986}
(9.933916) [toit.metrics] INFO: persisting metrics
(10.350469) [toit] INFO: <- OK
(10.458180) [toit] INFO: entering deep sleep {ms: 4986}
Entering deep sleep for 4986ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054182) [toit.state] INFO: resumed session {session_id: 1, session_time: 177.430675}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 12 (heap)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.149ms]
(0.079679) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.122402) [toit.console_sync] INFO: loaded last console sync {time: 171.770685}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 23 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 12kb->140kb (largest 108kb) 1.714ms]
(0.153884) [toit.scheduler] INFO: running job {job: console_sync}
(0.156703) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.158615) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.167567) [toit.console] INFO: waiting for console connection to be established
(0.172191) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 119kb | free: 12kb->124kb (largest 108kb) 2.036ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 143kb | free: 12kb->100kb (largest 88kb) 2.119ms]
(0.256066) [toit] INFO: -> AT
(0.517869) [toit] INFO: -> AT
(0.778333) [toit] INFO: -> AT
(1.039024) [toit] INFO: -> AT
(1.299628) [toit] INFO: -> AT
(1.560214) [toit] INFO: -> AT
(1.820801) [toit] INFO: -> AT
(2.006835) [toit] INFO: <- OK
(2.112006) [toit] INFO: -> ATE0
(2.119604) [toit] INFO: <- OK
(2.142061) [toit] INFO: -> AT+CMEE=2
(2.147667) [toit] INFO: <- OK
(2.170054) [toit] INFO: -> AT+CGMM
(2.175256) [toit] INFO: <- FiPy
(2.177803) [toit] INFO: <- OK
(2.205983) [toit] INFO: -> AT+CGMR
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 1 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 10kb->94kb (largest 84kb) 2.342ms]
(2.226754) [toit] INFO: <- UE5.4.0.2
(2.242008) [toit] INFO: <- OK
(2.264505) [toit] INFO: -> AT+SQNCCID?
(2.269899) [toit] INFO: <- +SQNCCID: "",""
(2.272298) [toit] INFO: <- OK
(2.274766) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.294546) [toit] INFO: -> AT+CFUN=4
(2.361129) [toit] INFO: <- OK
(2.383354) [toit] INFO: -> AT+CPIN?
(2.389283) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.643918) [toit] INFO: -> AT+CPIN?
(2.649524) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.903910) [toit] INFO: -> AT+CPIN?
(3.024926) [toit] INFO: <- +CPIN: READY
(3.027319) [toit] INFO: <- OK
(3.049591) [toit] INFO: -> AT+CPSMS=0
(3.056728) [toit] INFO: <- OK
(3.079397) [toit] INFO: -> AT+CEDRXS=0
(3.086635) [toit] INFO: <- OK
(3.108997) [toit] INFO: -> AT+SQNIBRCFG=0
(3.128615) [toit] INFO: <- OK
(3.151185) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.168361) [toit] INFO: <- OK
(3.190965) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.260489) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.262928) [toit] INFO: <- OK
(3.285277) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.292799) [toit] INFO: <- +CME ERROR: operation not supported
(3.315057) [toit] INFO: -> AT+CGDCONT?
(3.321310) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.324017) [toit] INFO: <- OK
(3.346294) [toit] INFO: -> AT+CFUN=1,1
(3.405441) [toit] INFO: <- OK
(3.461092) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.176079) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.331232) [toit] INFO: -> AT+CFUN=4
(10.153430) [toit.scheduler] INFO: running job {job: persist_metrics}
(10.156723) [toit.metrics] INFO: persisting metrics
(10.274166) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(12.032537) [toit] INFO: <- OK
(12.035236) [toit.cellular] DEBUG: failed, detach from network
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.380ms]
(12.060810) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(12.071034) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(12.178727) [toit] INFO: -> AT+CFUN=0
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 68kb) 2.525ms]
(12.185112) [toit.scheduler] INFO: changing run level {run_level: 0}
(12.198357) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(12.202848) [toit.metrics] INFO: persisting metrics
(12.434343) [toit] INFO: <- OK
(12.542059) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.055282) [toit.state] INFO: resumed session {session_id: 1, session_time: 195.007702}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.161ms]
(0.075047) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.120870) [toit.console_sync] INFO: loaded last console sync {time: 189.518667}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.728ms]
(0.146695) [toit.scheduler] INFO: running job {job: console_sync}
(0.149527) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.151428) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.160452) [toit.console] INFO: waiting for console connection to be established
(0.165015) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 118kb | free: 12kb->124kb (largest 108kb) 2.041ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 117 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.115ms]
(0.251599) [toit] INFO: -> AT
(0.517779) [toit] INFO: -> AT
(0.778253) [toit] INFO: -> AT
(1.038929) [toit] INFO: -> AT
(1.299539) [toit] INFO: -> AT
(1.560118) [toit] INFO: -> AT
(1.820716) [toit] INFO: -> AT
(2.005806) [toit] INFO: <- OK
(2.111582) [toit] INFO: -> ATE0
(2.119142) [toit] INFO: <- OK
(2.141547) [toit] INFO: -> AT+CMEE=2
(2.147379) [toit] INFO: <- OK
(2.169596) [toit] INFO: -> AT+CGMM
(2.175087) [toit] INFO: <- FiPy
(2.177735) [toit] INFO: <- OK
(2.199561) [toit] INFO: -> AT+CGMR
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 10kb->94kb (largest 84kb) 2.377ms]
(2.220453) [toit] INFO: <- UE5.4.0.2
(2.236128) [toit] INFO: <- OK
(2.258440) [toit] INFO: -> AT+SQNCCID?
(2.263992) [toit] INFO: <- +SQNCCID: "",""
(2.266395) [toit] INFO: <- OK
(2.268888) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.288607) [toit] INFO: -> AT+CFUN=4
(2.811466) [toit] INFO: <- OK
(2.833992) [toit] INFO: -> AT+CPIN?
(2.840145) [toit] INFO: <- +CME ERROR: SIM busy
(3.094847) [toit] INFO: -> AT+CPIN?
(3.100715) [toit] INFO: <- +CPIN: READY
(3.103194) [toit] INFO: <- OK
(3.125328) [toit] INFO: -> AT+CPSMS=0
(3.132777) [toit] INFO: <- OK
(3.155192) [toit] INFO: -> AT+CEDRXS=0
(3.162661) [toit] INFO: <- OK
(3.185028) [toit] INFO: -> AT+SQNIBRCFG=0
(3.204513) [toit] INFO: <- OK
(3.227260) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.246017) [toit] INFO: <- OK
(3.268600) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.337612) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.340119) [toit] INFO: <- OK
(3.362430) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.369382) [toit] INFO: <- +CME ERROR: operation not supported
(3.391646) [toit] INFO: -> AT+CGDCONT?
(3.398252) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.400703) [toit] INFO: <- OK
(3.423143) [toit] INFO: -> AT+CFUN=1,1
(3.782280) [toit] INFO: <- OK
(3.837301) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.321980) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.409293) [toit] INFO: -> AT+CFUN=4
(8.605078) [toit] INFO: <- OK
(8.611642) [toit.cellular] DEBUG: failed, detach from network
(8.630281) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(8.640712) [toit.network] WARN: failed to connect to any network
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 24 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.395ms]
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(8.768066) [toit] INFO: -> AT+CFUN=0
(8.773803) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.777322) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.779193) [toit.metrics] INFO: persisting metrics
(9.240931) [toit] INFO: <- OK
(9.349500) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.055145) [toit.state] INFO: resumed session {session_id: 1, session_time: 209.401086}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.156ms]
(0.075017) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.120969) [toit.console_sync] INFO: loaded last console sync {time: 203.694638}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.719ms]
(0.147005) [toit.scheduler] INFO: running job {job: console_sync}
(0.149839) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.151740) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.160727) [toit.console] INFO: waiting for console connection to be established
(0.165315) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 118kb | free: 12kb->124kb (largest 108kb) 2.041ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.111ms]
(0.253074) [toit] INFO: -> AT
(0.517780) [toit] INFO: -> AT
(0.778266) [toit] INFO: -> AT
(1.038950) [toit] INFO: -> AT
(1.299560) [toit] INFO: -> AT
(1.560148) [toit] INFO: -> AT
(1.820743) [toit] INFO: -> AT
(2.004456) [toit] INFO: <- OK
(2.109835) [toit] INFO: -> ATE0
(2.117404) [toit] INFO: <- OK
(2.139799) [toit] INFO: -> AT+CMEE=2
(2.145610) [toit] INFO: <- OK
(2.167945) [toit] INFO: -> AT+CGMM
(2.173161) [toit] INFO: <- FiPy
(2.175791) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 34 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 10kb->94kb (largest 84kb) 2.359ms]
(2.197671) [toit] INFO: -> AT+CGMR
(2.232244) [toit] INFO: <- UE5.4.0.2
(2.234621) [toit] INFO: <- OK
(2.256627) [toit] INFO: -> AT+SQNCCID?
(2.262389) [toit] INFO: <- +SQNCCID: "",""
(2.264787) [toit] INFO: <- OK
(2.267275) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.287005) [toit] INFO: -> AT+CFUN=4
(2.353950) [toit] INFO: <- OK
(2.376167) [toit] INFO: -> AT+CPIN?
(2.382290) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.637609) [toit] INFO: -> AT+CPIN?
(2.643368) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.897796) [toit] INFO: -> AT+CPIN?
(3.013377) [toit] INFO: <- +CPIN: READY
(3.015827) [toit] INFO: <- OK
(3.038040) [toit] INFO: -> AT+CPSMS=0
(3.045534) [toit] INFO: <- OK
(3.067925) [toit] INFO: -> AT+CEDRXS=0
(3.075802) [toit] INFO: <- OK
(3.098198) [toit] INFO: -> AT+SQNIBRCFG=0
(3.117752) [toit] INFO: <- OK
(3.140312) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.157885) [toit] INFO: <- OK
(3.180453) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.250159) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.252666) [toit] INFO: <- OK
(3.275254) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.282990) [toit] INFO: <- +CME ERROR: operation not supported
(3.305246) [toit] INFO: -> AT+CGDCONT?
(3.312362) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.314817) [toit] INFO: <- OK
(3.337729) [toit] INFO: -> AT+CFUN=1,1
(3.397261) [toit] INFO: <- OK
(3.452449) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.057595) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.322191) [toit] INFO: -> AT+CFUN=4
(9.054220) [toit] INFO: <- OK
(9.057027) [toit.cellular] DEBUG: failed, detach from network
(9.070284) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(9.081071) [toit.network] WARN: failed to connect to any network
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 68 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.437ms]
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(9.211134) [toit] INFO: -> AT+CFUN=0
(9.216794) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.220542) [toit.scheduler] INFO: going into deep sleep {ms: 4987}
(9.222428) [toit.metrics] INFO: persisting metrics
(9.465681) [toit] INFO: <- OK
(9.573418) [toit] INFO: entering deep sleep {ms: 4987}
Entering deep sleep for 4987ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054967) [toit.state] INFO: resumed session {session_id: 1, session_time: 224.018282}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 16 (heap)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.146ms]
(0.080723) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.121080) [toit.console_sync] INFO: loaded last console sync {time: 218.530142}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.730ms]
(0.147801) [toit.scheduler] INFO: running job {job: console_sync}
(0.150636) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.152540) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.161708) [toit.console] INFO: waiting for console connection to be established
(0.166116) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcfa58* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 118kb | free: 12kb->124kb (largest 108kb) 1.999ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.098ms]
(0.252891) [toit] INFO: -> AT
(0.517783) [toit] INFO: -> AT
(0.778253) [toit] INFO: -> AT
(1.038933) [toit] INFO: -> AT
(1.299742) [toit] INFO: -> AT
(1.560118) [toit] INFO: -> AT
(1.820711) [toit] INFO: -> AT
(1.997280) [toit] INFO: <- OK
(2.106826) [toit] INFO: -> ATE0
(2.114741) [toit] INFO: <- OK
(2.137232) [toit] INFO: -> AT+CMEE=2
(2.142820) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 148kb | free: 10kb->94kb (largest 84kb) 2.309ms]
(2.164897) [toit] INFO: -> AT+CGMM
(2.170301) [toit] INFO: <- FiPy
(2.173211) [toit] INFO: <- OK
(2.195121) [toit] INFO: -> AT+CGMR
(2.224339) [toit] INFO: <- UE5.4.0.2
(2.226632) [toit] INFO: <- OK
(2.248548) [toit] INFO: -> AT+SQNCCID?
(2.253984) [toit] INFO: <- +SQNCCID: "",""
(2.256338) [toit] INFO: <- OK
(2.258806) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.278603) [toit] INFO: -> AT+CFUN=4
(2.689437) [toit] INFO: <- OK
(2.711707) [toit] INFO: -> AT+CPIN?
(2.717695) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.972090) [toit] INFO: -> AT+CPIN?
(3.010057) [toit] INFO: <- +CPIN: READY
(3.012440) [toit] INFO: <- OK
(3.034702) [toit] INFO: -> AT+CPSMS=0
(3.041776) [toit] INFO: <- OK
(3.064214) [toit] INFO: -> AT+CEDRXS=0
(3.071412) [toit] INFO: <- OK
(3.093826) [toit] INFO: -> AT+SQNIBRCFG=0
(3.113449) [toit] INFO: <- OK
(3.136058) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.153268) [toit] INFO: <- OK
(3.175888) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.245785) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.248229) [toit] INFO: <- OK
(3.270592) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.278259) [toit] INFO: <- +CME ERROR: operation not supported
(3.306383) [toit] INFO: -> AT+CGDCONT?
(3.312839) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.315662) [toit] INFO: <- OK
(3.337827) [toit] INFO: -> AT+CFUN=1,1
(3.405917) [toit] INFO: <- OK
(3.517644) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.582856) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.323670) [toit] INFO: -> AT+CFUN=4
(9.079678) [toit] INFO: <- OK
(9.081925) [toit.cellular] DEBUG: failed, detach from network
(9.100813) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(9.112018) [toit.network] WARN: failed to connect to any network
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.458ms]
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(9.239708) [toit] INFO: -> AT+CFUN=0
(9.245391) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.248828) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(9.250706) [toit.metrics] INFO: persisting metrics
(9.499407) [toit] INFO: <- OK
(9.607066) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015332) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021536) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054830) [toit.state] INFO: resumed session {session_id: 1, session_time: 238.669618}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.143ms]
(0.074886) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.121172) [toit.console_sync] INFO: loaded last console sync {time: 233.177337}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 25 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.698ms]
(0.155408) [toit.scheduler] INFO: running job {job: console_sync}
(0.158242) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.160130) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.169353) [toit.console] INFO: waiting for console connection to be established
(0.173734) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcfa58* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 118kb | free: 12kb->124kb (largest 108kb) 2.002ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.099ms]
(0.261910) [toit] INFO: -> AT
(0.523287) [toit] INFO: -> AT
(0.783754) [toit] INFO: -> AT
(1.044436) [toit] INFO: -> AT
(1.305254) [toit] INFO: -> AT
(1.565624) [toit] INFO: -> AT
(1.826211) [toit] INFO: -> AT
(2.006703) [toit] INFO: <- OK
(2.112128) [toit] INFO: -> ATE0
(2.119629) [toit] INFO: <- OK
(2.142108) [toit] INFO: -> AT+CMEE=2
(2.147864) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 148kb | free: 10kb->94kb (largest 84kb) 2.350ms]
(2.170048) [toit] INFO: -> AT+CGMM
(2.175526) [toit] INFO: <- FiPy
(2.178465) [toit] INFO: <- OK
(2.200337) [toit] INFO: -> AT+CGMR
(2.221104) [toit] INFO: <- UE5.4.0.2
(2.223473) [toit] INFO: <- OK
(2.245317) [toit] INFO: -> AT+SQNCCID?
(2.250795) [toit] INFO: <- +SQNCCID: "",""
(2.253231) [toit] INFO: <- OK
(2.255699) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.275436) [toit] INFO: -> AT+CFUN=4
(2.341937) [toit] INFO: <- OK
(2.364166) [toit] INFO: -> AT+CPIN?
(2.370147) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.624588) [toit] INFO: -> AT+CPIN?
(2.630333) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.884760) [toit] INFO: -> AT+CPIN?
(3.003753) [toit] INFO: <- +CPIN: READY
(3.006208) [toit] INFO: <- OK
(3.028716) [toit] INFO: -> AT+CPSMS=0
(3.036238) [toit] INFO: <- OK
(3.058698) [toit] INFO: -> AT+CEDRXS=0
(3.066611) [toit] INFO: <- OK
(3.089039) [toit] INFO: -> AT+SQNIBRCFG=0
(3.108556) [toit] INFO: <- OK
(3.131119) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.148879) [toit] INFO: <- OK
(3.171468) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.241276) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.243823) [toit] INFO: <- OK
(3.266430) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.274221) [toit] INFO: <- +CME ERROR: operation not supported
(3.297433) [toit] INFO: -> AT+CGDCONT?
(3.304041) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.306477) [toit] INFO: <- OK
(3.329103) [toit] INFO: -> AT+CFUN=1,1
(3.388422) [toit] INFO: <- OK
(3.443721) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.227175) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.314005) [toit] INFO: -> AT+CFUN=4
(8.903413) [toit] INFO: <- OK
(8.906230) [toit.cellular] DEBUG: failed, detach from network
(8.930281) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(8.941838) [toit.network] WARN: failed to connect to any network
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.446ms]
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(9.069890) [toit] INFO: -> AT+CFUN=0
(9.075483) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.079033) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(9.080922) [toit.metrics] INFO: persisting metrics
(9.752493) [toit] INFO: <- OK
(9.860224) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015332) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021536) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.054668) [toit.state] INFO: resumed session {session_id: 1, session_time: 253.580984}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.123ms]
(0.074925) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.121273) [toit.console_sync] INFO: loaded last console sync {time: 247.665213}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.701ms]
(0.155891) [toit.scheduler] INFO: running job {job: console_sync}
(0.158732) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.160852) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.169647) [toit.console] INFO: waiting for console connection to be established
(0.174216) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcfa58* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 118kb | free: 12kb->124kb (largest 108kb) 2.017ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.110ms]
(0.263615) [toit] INFO: -> AT
(0.525008) [toit] INFO: -> AT
(0.785479) [toit] INFO: -> AT
(1.046161) [toit] INFO: -> AT
(1.316176) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.447ms]
(1.577698) [toit] INFO: -> AT
(1.838382) [toit] INFO: -> AT
(2.009399) [toit] INFO: <- OK
(2.114586) [toit] INFO: -> ATE0
(2.122408) [toit] INFO: <- OK
(2.144849) [toit] INFO: -> AT+CMEE=2
(2.150348) [toit] INFO: <- OK
(2.172627) [toit] INFO: -> AT+CGMM
(2.178106) [toit] INFO: <- FiPy
(2.180676) [toit] INFO: <- OK
(2.206010) [toit] INFO: -> AT+CGMR
(2.226778) [toit] INFO: <- UE5.4.0.2
(2.229297) [toit] INFO: <- OK
(2.251306) [toit] INFO: -> AT+SQNCCID?
(2.256728) [toit] INFO: <- +SQNCCID: "",""
(2.259117) [toit] INFO: <- OK
(2.261565) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.281348) [toit] INFO: -> AT+CFUN=4
(2.347589) [toit] INFO: <- OK
(2.369804) [toit] INFO: -> AT+CPIN?
(2.375464) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.630064) [toit] INFO: -> AT+CPIN?
(2.635663) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.889895) [toit] INFO: -> AT+CPIN?
(2.998983) [toit] INFO: <- +CPIN: READY
(3.001348) [toit] INFO: <- OK
(3.023630) [toit] INFO: -> AT+CPSMS=0
(3.030731) [toit] INFO: <- OK
(3.053400) [toit] INFO: -> AT+CEDRXS=0
(3.060532) [toit] INFO: <- OK
(3.082949) [toit] INFO: -> AT+SQNIBRCFG=0
(3.102351) [toit] INFO: <- OK
(3.124961) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.141995) [toit] INFO: <- OK
(3.164608) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.234101) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.236537) [toit] INFO: <- OK
(3.258871) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.266983) [toit] INFO: <- +CME ERROR: operation not supported
(3.289173) [toit] INFO: -> AT+CGDCONT?
(3.295909) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.307416) [toit] INFO: <- OK
(3.329766) [toit] INFO: -> AT+CFUN=1,1
(3.388848) [toit] INFO: <- OK
(3.444073) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.466115) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.315311) [toit] INFO: -> AT+CFUN=4
(10.163454) [toit.scheduler] INFO: running job {job: persist_metrics}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.402ms]
(10.176162) [toit.metrics] INFO: persisting metrics
(10.275999) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(11.529039) [toit] INFO: <- OK
(11.531831) [toit.cellular] DEBUG: failed, detach from network
(11.550283) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(11.561812) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 68kb) 2.428ms]
(11.771467) [toit] INFO: -> AT+CFUN=0
(11.778032) [toit.scheduler] INFO: changing run level {run_level: 0}
(11.781789) [toit.scheduler] INFO: going into deep sleep {ms: 4979}
(11.783669) [toit.metrics] INFO: persisting metrics
(12.029296) [toit] INFO: <- OK
(12.137075) [toit] INFO: entering deep sleep {ms: 4979}
Entering deep sleep for 4979ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.055830) [toit.state] INFO: resumed session {session_id: 1, session_time: 270.750956}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.138ms]
(0.076629) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.121375) [toit.console_sync] INFO: loaded last console sync {time: 265.259108}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.714ms]
(0.156560) [toit.scheduler] INFO: running job {job: console_sync}
(0.159626) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.161543) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.170309) [toit.console] INFO: waiting for console connection to be established
(0.174883) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.066ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.114ms]
(0.260947) [toit] INFO: -> AT
(0.522317) [toit] INFO: -> AT
(0.782791) [toit] INFO: -> AT
(1.043473) [toit] INFO: -> AT
(1.304084) [toit] INFO: -> AT
(1.564674) [toit] INFO: -> AT
(1.825269) [toit] INFO: -> AT
(2.006785) [toit] INFO: <- OK
(2.112194) [toit] INFO: -> ATE0
(2.119933) [toit] INFO: <- OK
(2.142390) [toit] INFO: -> AT+CMEE=2
(2.148002) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 148kb | free: 10kb->94kb (largest 84kb) 2.322ms]
(2.170058) [toit] INFO: -> AT+CGMM
(2.175630) [toit] INFO: <- FiPy
(2.178314) [toit] INFO: <- OK
(2.205976) [toit] INFO: -> AT+CGMR
(2.227008) [toit] INFO: <- UE5.4.0.2
(2.229274) [toit] INFO: <- OK
(2.251227) [toit] INFO: -> AT+SQNCCID?
(2.256556) [toit] INFO: <- +SQNCCID: "",""
(2.258923) [toit] INFO: <- OK
(2.261384) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.281077) [toit] INFO: -> AT+CFUN=4
(2.737143) [toit] INFO: <- OK
(2.759426) [toit] INFO: -> AT+CPIN?
(2.765456) [toit] INFO: <- +CME ERROR: SIM busy
(3.019887) [toit] INFO: -> AT+CPIN?
(3.026447) [toit] INFO: <- +CPIN: READY
(3.028835) [toit] INFO: <- OK
(3.051000) [toit] INFO: -> AT+CPSMS=0
(3.058065) [toit] INFO: <- OK
(3.080483) [toit] INFO: -> AT+CEDRXS=0
(3.087575) [toit] INFO: <- OK
(3.109970) [toit] INFO: -> AT+SQNIBRCFG=0
(3.129450) [toit] INFO: <- OK
(3.152060) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.169063) [toit] INFO: <- OK
(3.191660) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.261535) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.263959) [toit] INFO: <- OK
(3.286306) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.294035) [toit] INFO: <- +CME ERROR: operation not supported
(3.316244) [toit] INFO: -> AT+CGDCONT?
(3.323599) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.326702) [toit] INFO: <- OK
(3.349077) [toit] INFO: -> AT+CFUN=1,1
(3.807554) [toit] INFO: <- OK
(3.862729) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.336204) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.334916) [toit] INFO: -> AT+CFUN=4
(8.431519) [toit] INFO: <- OK
(8.433766) [toit.cellular] DEBUG: failed, detach from network
(8.450810) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(8.462808) [toit.network] WARN: failed to connect to any network
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.459ms]
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(8.590568) [toit] INFO: -> AT+CFUN=0
(8.596269) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.599850) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.601744) [toit.metrics] INFO: persisting metrics
(8.846158) [toit] INFO: <- OK
(8.953864) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.055663) [toit.state] INFO: resumed session {session_id: 1, session_time: 284.751698}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.152ms]
(0.076855) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.697ms]
(0.133231) [toit.console_sync] INFO: loaded last console sync {time: 279.262589}
(0.153126) [toit.scheduler] INFO: running job {job: console_sync}
(0.155893) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.158041) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.166768) [toit.console] INFO: waiting for console connection to be established
[gc @ 0x3ffcfa58* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcfa58* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 118kb | free: 12kb->124kb (largest 108kb) 2.006ms]
(0.171338) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.108ms]
(0.263501) [toit] INFO: -> AT
(0.524862) [toit] INFO: -> AT
(0.785345) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 64 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.453ms]
(1.057337) [toit] INFO: -> AT
(1.307617) [toit] INFO: -> AT
(1.568208) [toit] INFO: -> AT
(1.828781) [toit] INFO: -> AT
(2.006903) [toit] INFO: <- OK
(2.112728) [toit] INFO: -> ATE0
(2.120357) [toit] INFO: <- OK
(2.142814) [toit] INFO: -> AT+CMEE=2
(2.148490) [toit] INFO: <- OK
(2.170842) [toit] INFO: -> AT+CGMM
(2.176218) [toit] INFO: <- FiPy
(2.178773) [toit] INFO: <- OK
(2.206012) [toit] INFO: -> AT+CGMR
(2.227030) [toit] INFO: <- UE5.4.0.2
(2.229545) [toit] INFO: <- OK
(2.251542) [toit] INFO: -> AT+SQNCCID?
(2.256888) [toit] INFO: <- +SQNCCID: "",""
(2.259254) [toit] INFO: <- OK
(2.261702) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.281480) [toit] INFO: -> AT+CFUN=4
(2.643649) [toit] INFO: <- OK
(2.665877) [toit] INFO: -> AT+CPIN?
(2.671499) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.926030) [toit] INFO: -> AT+CPIN?
(3.004766) [toit] INFO: <- +CPIN: READY
(3.007167) [toit] INFO: <- OK
(3.029404) [toit] INFO: -> AT+CPSMS=0
(3.036548) [toit] INFO: <- OK
(3.058991) [toit] INFO: -> AT+CEDRXS=0
(3.066162) [toit] INFO: <- OK
(3.088582) [toit] INFO: -> AT+SQNIBRCFG=0
(3.108008) [toit] INFO: <- OK
(3.130809) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.147859) [toit] INFO: <- OK
(3.170484) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.240343) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.242771) [toit] INFO: <- OK
(3.265119) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.272791) [toit] INFO: <- +CME ERROR: operation not supported
(3.295015) [toit] INFO: -> AT+CGDCONT?
(3.306487) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.309056) [toit] INFO: <- OK
(3.331202) [toit] INFO: -> AT+CFUN=1,1
(3.709035) [toit] INFO: <- OK
(3.763939) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.419429) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.317441) [toit] INFO: -> AT+CFUN=4
(8.896382) [toit] INFO: <- OK
(8.898640) [toit.cellular] DEBUG: failed, detach from network
(8.910810) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.443ms]
(8.941004) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 68kb) 2.457ms]
(9.055464) [toit] INFO: -> AT+CFUN=0
(9.061045) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.064477) [toit.scheduler] INFO: going into deep sleep {ms: 4984}
(9.068818) [toit.metrics] INFO: persisting metrics
(9.318011) [toit] INFO: <- OK
(9.425719) [toit] INFO: entering deep sleep {ms: 4984}
Entering deep sleep for 4984ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015332) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021536) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.055543) [toit.state] INFO: resumed session {session_id: 1, session_time: 299.214577}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.152ms]
(0.076789) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.643ms]
(0.127152) [toit.console_sync] INFO: loaded last console sync {time: 293.718953}
(0.146214) [toit.scheduler] INFO: running job {job: console_sync}
(0.148996) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.151142) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.159873) [toit.console] INFO: waiting for console connection to be established
[gc @ 0x3ffcfa58* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcfa58* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 118kb | free: 12kb->124kb (largest 108kb) 1.984ms]
(0.164452) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.099ms]
(0.256300) [toit] INFO: -> AT
(0.517881) [toit] INFO: -> AT
(0.778337) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 64 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.438ms]
(1.050343) [toit] INFO: -> AT
(1.299675) [toit] INFO: -> AT
(1.560264) [toit] INFO: -> AT
(1.820839) [toit] INFO: -> AT
(1.999202) [toit] INFO: <- OK
(2.106391) [toit] INFO: -> ATE0
(2.114037) [toit] INFO: <- OK
(2.136490) [toit] INFO: -> AT+CMEE=2
(2.142182) [toit] INFO: <- OK
(2.164590) [toit] INFO: -> AT+CGMM
(2.169912) [toit] INFO: <- FiPy
(2.172458) [toit] INFO: <- OK
(2.194292) [toit] INFO: -> AT+CGMR
(2.214956) [toit] INFO: <- UE5.4.0.2
(2.217513) [toit] INFO: <- OK
(2.239489) [toit] INFO: -> AT+SQNCCID?
(2.244850) [toit] INFO: <- +SQNCCID: "",""
(2.247222) [toit] INFO: <- OK
(2.249678) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.269444) [toit] INFO: -> AT+CFUN=4
(2.752085) [toit] INFO: <- OK
(2.774323) [toit] INFO: -> AT+CPIN?
(2.779960) [toit] INFO: <- +CME ERROR: SIM busy
(3.034509) [toit] INFO: -> AT+CPIN?
(3.039892) [toit] INFO: <- +CPIN: READY
(3.042235) [toit] INFO: <- OK
(3.064382) [toit] INFO: -> AT+CPSMS=0
(3.071499) [toit] INFO: <- OK
(3.093938) [toit] INFO: -> AT+CEDRXS=0
(3.101067) [toit] INFO: <- OK
(3.123491) [toit] INFO: -> AT+SQNIBRCFG=0
(3.142561) [toit] INFO: <- OK
(3.165136) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.182408) [toit] INFO: <- OK
(3.206714) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.280186) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.282586) [toit] INFO: <- OK
(3.306493) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.314168) [toit] INFO: <- +CME ERROR: operation not supported
(3.336398) [toit] INFO: -> AT+CGDCONT?
(3.342947) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.345486) [toit] INFO: <- OK
(3.367787) [toit] INFO: -> AT+CFUN=1,1
(3.762159) [toit] INFO: <- OK
(3.817175) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.435646) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.353857) [toit] INFO: -> AT+CFUN=4
(8.509650) [toit] INFO: <- OK
(8.511881) [toit.cellular] DEBUG: failed, detach from network
(8.530808) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.443ms]
(8.560290) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 20kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 68kb) 2.456ms]
(8.676430) [toit] INFO: -> AT+CFUN=0
(8.682003) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.685712) [toit.scheduler] INFO: going into deep sleep {ms: 4984}
(8.689503) [toit.metrics] INFO: persisting metrics
(8.930717) [toit] INFO: <- OK
(9.038435) [toit] INFO: entering deep sleep {ms: 4984}
Entering deep sleep for 4984ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.055388) [toit.state] INFO: resumed session {session_id: 1, session_time: 313.290631}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.153ms]
(0.076633) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.645ms]
(0.127253) [toit.console_sync] INFO: loaded last console sync {time: 307.803149}
(0.146478) [toit.scheduler] INFO: running job {job: console_sync}
(0.149268) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.151445) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.160147) [toit.console] INFO: waiting for console connection to be established
[gc @ 0x3ffcfa58* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcfa58* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 118kb | free: 12kb->124kb (largest 108kb) 1.984ms]
(0.164724) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.102ms]
(0.257647) [toit] INFO: -> AT
(0.518999) [toit] INFO: -> AT
(0.779476) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 64 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.434ms]
(1.051478) [toit] INFO: -> AT
(1.300823) [toit] INFO: -> AT
(1.561410) [toit] INFO: -> AT
(1.821985) [toit] INFO: -> AT
(2.082808) [toit] INFO: -> AT
(2.343190) [toit] INFO: -> AT

�ets Jun  8 2016 00:22:57

rst:0x1 (POWERON_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
clearing RTC memory: RTC memory is in inconsistent state
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015330) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021534) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.060477) [toit.state] INFO: starting new session {session_id: 2, session_time: 0.067880}
[gc @ 0x3ffcf9f0* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcf9f0* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.173ms]
(0.082058) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
[gc @ 0x3ffcf9f0* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcf9f0* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.645ms]
(0.127341) [toit.console_sync] INFO: loaded last console sync {time: null}
(0.143956) [toit.scheduler] INFO: running job {job: console_sync}
(0.146660) [toit.scheduler] INFO: running job {job: flush_metrics}
(0.148753) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.153766) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.163447) [toit.console] INFO: waiting for console connection to be established
[gc @ 0x3ffcf9f0* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcf9f0* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 118kb | free: 12kb->124kb (largest 108kb) 1.991ms]
(0.168078) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
(0.191486) [toit.metrics] INFO: persisting metrics
(0.194583) [toit.metrics] INFO: flushing metrics
[gc @ 0x3ffcf9f0* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcf9f0* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.119ms]
[gc @ 0x3ffcf9f0* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcf9f0* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 143kb | free: 12kb->100kb (largest 88kb) 2.233ms]
(0.519955) [toit] INFO: -> AT
(0.660311) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(0.780868) [toit] INFO: -> AT
(1.041668) [toit] INFO: -> AT
(1.302268) [toit] INFO: -> AT
(1.554441) [toit] INFO: <- OK
(1.576801) [toit] INFO: -> AT
(1.581464) [toit] INFO: <- OK
(1.685372) [toit] INFO: -> ATE0
(1.692751) [toit] INFO: <- OK
(1.715148) [toit] INFO: -> AT+CMEE=2
(1.720584) [toit] INFO: <- OK
(1.742694) [toit] INFO: -> AT+CGMM
(1.747659) [toit] INFO: <- FiPy
(1.750261) [toit] INFO: <- OK
(1.772199) [toit] INFO: -> AT+CGMR
(1.792952) [toit] INFO: <- UE5.4.0.2
(1.795254) [toit] INFO: <- OK
(1.817530) [toit] INFO: -> AT+SQNCCID?
(1.822892) [toit] INFO: <- +SQNCCID: "",""
(1.825254) [toit] INFO: <- OK
(1.827709) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(1.847839) [toit] INFO: -> AT+CFUN=4
(2.366645) [toit] INFO: <- OK
(2.388950) [toit] INFO: -> AT+CPIN?
(2.394583) [toit] INFO: <- +CME ERROR: SIM busy
(2.649253) [toit] INFO: -> AT+CPIN?
(2.655000) [toit] INFO: <- +CPIN: READY
(2.657388) [toit] INFO: <- OK
(2.679591) [toit] INFO: -> AT+CPSMS=0
(2.686638) [toit] INFO: <- OK
(2.709058) [toit] INFO: -> AT+CEDRXS=0
(2.716247) [toit] INFO: <- OK
(2.738650) [toit] INFO: -> AT+SQNIBRCFG=0
(2.750485) [toit] INFO: <- OK
(2.773267) [toit] INFO: -> AT+SQNIPSCFG=1,100
(2.790563) [toit] INFO: <- OK
(2.813189) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(2.882140) [toit] INFO: <- +SQNBANDSEL: <custom>
(2.884580) [toit] INFO: <- OK
(2.907001) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(2.914761) [toit] INFO: <- +CME ERROR: operation not supported
(2.937464) [toit] INFO: -> AT+CGDCONT?
(2.944048) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
[gc @ 0x3ffcf9f0* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcf9f0* | string allocation failed, length = 29 (heap)]
[gc @ 0x3ffcf9f0* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.439ms]
(2.946579) [toit] INFO: <- OK
(2.986190) [toit] INFO: -> AT+CFUN=1,1
(3.045752) [toit] INFO: <- OK
(3.100507) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(4.576037) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(7.972429) [toit] INFO: -> AT+CFUN=4
(8.047600) [toit] INFO: <- OK
(8.050171) [toit.cellular] DEBUG: failed, detach from network
(8.060855) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(8.068031) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(8.162490) [toit] INFO: -> AT+CFUN=0
(8.168412) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.171903) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.173783) [toit.metrics] INFO: persisting metrics
(8.423439) [toit] INFO: <- OK
[gc @ 0x3ffcf9f0* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 350 (heap)]
[gc @ 0x3ffcf9f0* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 151kb | free: 15kb->92kb (largest 68kb) 2.513ms]
(8.531106) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015316) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021520) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.056523) [toit.state] INFO: resumed session {session_id: 2, session_time: 13.644132}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.151ms]
(0.077722) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.112122) [toit.console_sync] INFO: loaded last console sync {time: 8.148742}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.712ms]
(0.138392) [toit.scheduler] INFO: running job {job: console_sync}
(0.141223) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.143115) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.152076) [toit.console] INFO: waiting for console connection to be established
(0.156707) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.112ms]
(0.205130) [toit] INFO: -> AT
(0.466482) [toit] INFO: -> AT
(0.727727) [toit] INFO: -> AT
(0.988300) [toit] INFO: -> AT
(1.248994) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.458ms]
(1.516190) [toit] INFO: -> AT
(1.777802) [toit] INFO: -> AT
(1.948429) [toit] INFO: <- OK
(2.053658) [toit] INFO: -> ATE0
(2.061327) [toit] INFO: <- OK
(2.084019) [toit] INFO: -> AT+CMEE=2
(2.089623) [toit] INFO: <- OK
(2.111784) [toit] INFO: -> AT+CGMM
(2.117202) [toit] INFO: <- FiPy
(2.119776) [toit] INFO: <- OK
(2.141663) [toit] INFO: -> AT+CGMR
(2.162383) [toit] INFO: <- UE5.4.0.2
(2.164912) [toit] INFO: <- OK
(2.187470) [toit] INFO: -> AT+SQNCCID?
(2.192809) [toit] INFO: <- +SQNCCID: "",""
(2.195179) [toit] INFO: <- OK
(2.197676) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.217814) [toit] INFO: -> AT+CFUN=4
(2.545795) [toit] INFO: <- OK
(2.568055) [toit] INFO: -> AT+CPIN?
(2.573691) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.828265) [toit] INFO: -> AT+CPIN?
(2.946096) [toit] INFO: <- +CPIN: READY
(2.948485) [toit] INFO: <- OK
(2.970665) [toit] INFO: -> AT+CPSMS=0
(2.977948) [toit] INFO: <- OK
(3.006335) [toit] INFO: -> AT+CEDRXS=0
(3.013571) [toit] INFO: <- OK
(3.035973) [toit] INFO: -> AT+SQNIBRCFG=0
(3.055802) [toit] INFO: <- OK
(3.078613) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.095703) [toit] INFO: <- OK
(3.118403) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.191783) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.194222) [toit] INFO: <- OK
(3.216659) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.224329) [toit] INFO: <- +CME ERROR: operation not supported
(3.247403) [toit] INFO: -> AT+CGDCONT?
(3.254102) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.256652) [toit] INFO: <- OK
(3.279280) [toit] INFO: -> AT+CFUN=1,1
(3.338892) [toit] INFO: <- OK
(3.677103) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.386795) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.265114) [toit] INFO: -> AT+CFUN=4
(8.339494) [toit] INFO: <- OK
(8.341749) [toit.cellular] DEBUG: failed, detach from network
(8.360816) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.437ms]
(8.379602) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(8.474627) [toit] INFO: -> AT+CFUN=0
(8.480335) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.484076) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.485951) [toit.metrics] INFO: persisting metrics
(8.760339) [toit] INFO: <- OK
(8.868047) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015317) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021521) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.056399) [toit.state] INFO: resumed session {session_id: 2, session_time: 27.557051}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.155ms]
(0.077605) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.112214) [toit.console_sync] INFO: loaded last console sync {time: 22.037658}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.716ms]
(0.145378) [toit.scheduler] INFO: running job {job: console_sync}
(0.148219) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.150107) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.159263) [toit.console] INFO: waiting for console connection to be established
(0.163703) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.107ms]
(0.226164) [toit] INFO: -> AT
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 6kb->94kb (largest 88kb) 2.412ms]
(0.488014) [toit] INFO: -> AT
(0.748380) [toit] INFO: -> AT
(1.009233) [toit] INFO: -> AT
(1.269805) [toit] INFO: -> AT
(1.530400) [toit] INFO: -> AT
(1.790987) [toit] INFO: -> AT
(1.975821) [toit] INFO: <- OK
(2.081067) [toit] INFO: -> ATE0
(2.088846) [toit] INFO: <- OK
(2.111339) [toit] INFO: -> AT+CMEE=2
(2.116997) [toit] INFO: <- OK
(2.139085) [toit] INFO: -> AT+CGMM
(2.144455) [toit] INFO: <- FiPy
(2.147010) [toit] INFO: <- OK
(2.168874) [toit] INFO: -> AT+CGMR
(2.189663) [toit] INFO: <- UE5.4.0.2
(2.192182) [toit] INFO: <- OK
(2.214191) [toit] INFO: -> AT+SQNCCID?
(2.219576) [toit] INFO: <- +SQNCCID: "",""
(2.221923) [toit] INFO: <- OK
(2.224387) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.244178) [toit] INFO: -> AT+CFUN=4
(2.700682) [toit] INFO: <- OK
(2.722956) [toit] INFO: -> AT+CPIN?
(2.728624) [toit] INFO: <- +CME ERROR: SIM busy
(2.983124) [toit] INFO: -> AT+CPIN?
(2.991926) [toit] INFO: <- +CPIN: READY
(2.994293) [toit] INFO: <- OK
(3.016542) [toit] INFO: -> AT+CPSMS=0
(3.023717) [toit] INFO: <- OK
(3.046165) [toit] INFO: -> AT+CEDRXS=0
(3.053323) [toit] INFO: <- OK
(3.075748) [toit] INFO: -> AT+SQNIBRCFG=0
(3.095126) [toit] INFO: <- OK
(3.117867) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.135095) [toit] INFO: <- OK
(3.158222) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.228120) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.230520) [toit] INFO: <- OK
(3.252908) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.260566) [toit] INFO: <- +CME ERROR: operation not supported
(3.282783) [toit] INFO: -> AT+CGDCONT?
(3.289138) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.291857) [toit] INFO: <- OK
(3.314079) [toit] INFO: -> AT+CFUN=1,1
(3.439410) [toit] INFO: <- OK
(3.860466) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.509704) [toit] INFO: <- *ignored* [URC] +SYSSTART []
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 610 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.382ms]
(8.312034) [toit] INFO: -> AT+CFUN=4
(8.424544) [toit] INFO: <- OK
(8.427026) [toit.cellular] DEBUG: failed, detach from network
(8.440282) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(8.448148) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(8.604508) [toit] INFO: -> AT+CFUN=0
(8.618648) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.622113) [toit.scheduler] INFO: going into deep sleep {ms: 4981}
(8.623988) [toit.metrics] INFO: persisting metrics
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 5 (heap)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 68kb) 2.502ms]
(9.268395) [toit] INFO: <- OK
(9.376717) [toit] INFO: entering deep sleep {ms: 4981}
Entering deep sleep for 4981ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015332) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021536) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.057409) [toit.state] INFO: resumed session {session_id: 2, session_time: 41.965371}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.168ms]
(0.078866) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.121961) [toit.console_sync] INFO: loaded last console sync {time: 36.074733}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.726ms]
(0.155596) [toit.scheduler] INFO: running job {job: console_sync}
(0.158441) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.160330) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.169346) [toit.console] INFO: waiting for console connection to be established
(0.173921) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.116ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 148kb | free: 6kb->94kb (largest 88kb) 2.398ms]
(0.242056) [toit] INFO: -> AT
(0.503288) [toit] INFO: -> AT
(0.763762) [toit] INFO: -> AT
(1.024448) [toit] INFO: -> AT
(1.285039) [toit] INFO: -> AT
(1.545632) [toit] INFO: -> AT
(1.806234) [toit] INFO: -> AT
(1.986291) [toit] INFO: <- OK
(2.091521) [toit] INFO: -> ATE0
(2.099195) [toit] INFO: <- OK
(2.121660) [toit] INFO: -> AT+CMEE=2
(2.127194) [toit] INFO: <- OK
(2.149280) [toit] INFO: -> AT+CGMM
(2.154530) [toit] INFO: <- FiPy
(2.157349) [toit] INFO: <- OK
(2.179240) [toit] INFO: -> AT+CGMR
(2.199871) [toit] INFO: <- UE5.4.0.2
(2.202162) [toit] INFO: <- OK
(2.224115) [toit] INFO: -> AT+SQNCCID?
(2.229481) [toit] INFO: <- +SQNCCID: "",""
(2.231831) [toit] INFO: <- OK
(2.234280) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.254062) [toit] INFO: -> AT+CFUN=4
(2.320492) [toit] INFO: <- OK
(2.342695) [toit] INFO: -> AT+CPIN?
(2.348331) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.603040) [toit] INFO: -> AT+CPIN?
(2.608641) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.862939) [toit] INFO: -> AT+CPIN?
(2.982368) [toit] INFO: <- +CPIN: READY
(2.984692) [toit] INFO: <- OK
(3.007011) [toit] INFO: -> AT+CPSMS=0
(3.014319) [toit] INFO: <- OK
(3.036943) [toit] INFO: -> AT+CEDRXS=0
(3.044255) [toit] INFO: <- OK
(3.066684) [toit] INFO: -> AT+SQNIBRCFG=0
(3.086091) [toit] INFO: <- OK
(3.108677) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.125669) [toit] INFO: <- OK
(3.148302) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.217803) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.220211) [toit] INFO: <- OK
(3.242536) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.250890) [toit] INFO: <- +CME ERROR: operation not supported
(3.273104) [toit] INFO: -> AT+CGDCONT?
(3.279781) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.282623) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 6kb->78kb (largest 72kb) 2.394ms]
(3.304950) [toit] INFO: -> AT+CFUN=1,1
(3.364495) [toit] INFO: <- OK
(3.419505) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(4.906795) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.306926) [toit] INFO: -> AT+CFUN=4
(8.688289) [toit] INFO: <- OK
(8.690860) [toit.cellular] DEBUG: failed, detach from network
(8.701181) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(8.709799) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(8.805993) [toit] INFO: -> AT+CFUN=0
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 157kb | free: 10kb->86kb (largest 72kb) 2.535ms]
(8.811533) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.831231) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.835618) [toit.metrics] INFO: persisting metrics
(9.421262) [toit] INFO: <- OK
(9.529689) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015332) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021536) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.057368) [toit.state] INFO: resumed session {session_id: 2, session_time: 56.542752}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.168ms]
(0.078836) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.122051) [toit.console_sync] INFO: loaded last console sync {time: 50.691481}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.732ms]
(0.150140) [toit.scheduler] INFO: running job {job: console_sync}
(0.152963) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.155099) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.163847) [toit.console] INFO: waiting for console connection to be established
(0.168443) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | used: 126kb | free: 12kb->116kb (largest 104kb) 2.126ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 148kb | free: 6kb->94kb (largest 88kb) 2.383ms]
(0.234524) [toit] INFO: -> AT
(0.495735) [toit] INFO: -> AT
(0.756218) [toit] INFO: -> AT
(1.017618) [toit] INFO: -> AT
(1.278199) [toit] INFO: -> AT
(1.538791) [toit] INFO: -> AT
(1.799397) [toit] INFO: -> AT
(1.979280) [toit] INFO: <- OK
(2.084514) [toit] INFO: -> ATE0
(2.092171) [toit] INFO: <- OK
(2.114635) [toit] INFO: -> AT+CMEE=2
(2.120098) [toit] INFO: <- OK
(2.142241) [toit] INFO: -> AT+CGMM
(2.147520) [toit] INFO: <- FiPy
(2.150321) [toit] INFO: <- OK
(2.172217) [toit] INFO: -> AT+CGMR
(2.192971) [toit] INFO: <- UE5.4.0.2
(2.195218) [toit] INFO: <- OK
(2.217462) [toit] INFO: -> AT+SQNCCID?
(2.222767) [toit] INFO: <- +SQNCCID: "",""
(2.225106) [toit] INFO: <- OK
(2.227553) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.247810) [toit] INFO: -> AT+CFUN=4
(2.313978) [toit] INFO: <- OK
(2.336228) [toit] INFO: -> AT+CPIN?
(2.341901) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.605143) [toit] INFO: -> AT+CPIN?
(2.610720) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.864949) [toit] INFO: -> AT+CPIN?
(2.977552) [toit] INFO: <- +CPIN: READY
(2.979876) [toit] INFO: <- OK
(3.006417) [toit] INFO: -> AT+CPSMS=0
(3.013629) [toit] INFO: <- OK
(3.036219) [toit] INFO: -> AT+CEDRXS=0
(3.043508) [toit] INFO: <- OK
(3.065927) [toit] INFO: -> AT+SQNIBRCFG=0
(3.085147) [toit] INFO: <- OK
(3.107865) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.125337) [toit] INFO: <- OK
(3.148011) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.217683) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.220071) [toit] INFO: <- OK
(3.242444) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.250287) [toit] INFO: <- +CME ERROR: operation not supported
(3.272494) [toit] INFO: -> AT+CGDCONT?
(3.279273) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.281801) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 6kb->78kb (largest 72kb) 2.393ms]
(3.308099) [toit] INFO: -> AT+CFUN=1,1
(3.367701) [toit] INFO: <- OK
(3.423147) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.177136) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.308829) [toit] INFO: -> AT+CFUN=4
(8.615543) [toit] INFO: <- OK
(8.618376) [toit.cellular] DEBUG: failed, detach from network
(8.630280) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
(8.639008) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
[gc @ 0x3ffcfa58* | soft limit reached (49636 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | used: 156kb | free: 6kb->86kb (largest 72kb) 2.472ms]
(8.740684) [toit] INFO: -> AT+CFUN=0
(8.746232) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.749756) [toit.scheduler] INFO: going into deep sleep {ms: 4984}
(8.754064) [toit.metrics] INFO: persisting metrics
(8.997281) [toit] INFO: <- OK
(9.108159) [toit] INFO: entering deep sleep {ms: 4984}
Entering deep sleep for 4984ms
ets Jun  8 2016 00:22:57

rst:0x5 (DEEPSLEEP_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:188
ho 0 tail 12 room 4
load:0x40078000,len:12180
load:0x40080400,len:2944
entry 0x400805c8
[flash reg] address 0x3f46c000, size 0x00134000
[IDENTITY] name=4c2a0869-49c3-4fe7-834e-ce3a6a9e2b7c.744.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015332) [toit] INFO: booting toit {sdk: v1.6.0-pre.25+c8ae5eaa0, model: esp32-4mb}
(0.021536) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.057392) [toit.state] INFO: resumed session {session_id: 2, session_time: 70.693886}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | used: 93kb | free: 9kb->149kb (largest 108kb) 1.178ms]
(0.078901) [toit.kernel] INFO: using model parameters {cellular.cts: 18, cellular.enabled: 1, cellular.monarch: 1, cellular.pwr: 27, cellular.rts: 19, cellular.rx: 23, cellular.tx: 5}
(0.122318) [toit.console_sync] INFO: loaded last console sync {time: 65.198354}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 12kb | external: 0kb -> 0kb | used: 102kb | free: 8kb->140kb (largest 108kb) 1.730ms]
(0.157606) [toit.scheduler] INFO: running job {job: console_sync}
(0.160437) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.162574) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.171312) [toit.console] INFO: waiting for console connection to be established
(0.175910) [toit.network] DEBUG: connecting {network: Cellular (nbiot.tdc.dk)}
[gc @ 0x3ffcfa58* | soft limit reached (32796 >= 30720)]
[gc @ 0x3ffcfa58* | heap: 32kb -> 20kb | external: 0kb -> 0kb | used: 118kb | free: 12kb->124kb (largest 108kb) 2.034ms]
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | used: 142kb | free: 12kb->100kb (largest 88kb) 2.169ms]
(0.250033) [toit] INFO: -> AT
(0.517780) [toit] INFO: -> AT
(0.778258) [toit] INFO: -> AT
(1.038946) [toit] INFO: -> AT
(1.299556) [toit] INFO: -> AT
(1.560135) [toit] INFO: -> AT
(1.820729) [toit] INFO: -> AT
(1.997628) [toit] INFO: <- OK
(2.106827) [toit] INFO: -> ATE0
(2.114717) [toit] INFO: <- OK
(2.137184) [toit] INFO: -> AT+CMEE=2
(2.142762) [toit] INFO: <- OK
(2.165006) [toit] INFO: -> AT+CGMM
(2.170272) [toit] INFO: <- FiPy
(2.173094) [toit] INFO: <- OK
(2.194982) [toit] INFO: -> AT+CGMR
(2.215736) [toit] INFO: <- UE5.4.0.2
(2.218040) [toit] INFO: <- OK
(2.239946) [toit] INFO: -> AT+SQNCCID?
(2.245605) [toit] INFO: <- +SQNCCID: "",""
(2.247986) [toit] INFO: <- OK
(2.250427) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.270228) [toit] INFO: -> AT+CFUN=4
(2.556054) [toit] INFO: <- OK
(2.578383) [toit] INFO: -> AT+CPIN?
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 31 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | used: 149kb | free: 10kb->94kb (largest 84kb) 2.355ms]
(2.595598) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.853271) [toit] INFO: -> AT+CPIN?
(2.985669) [toit] INFO: <- +CPIN: READY
(2.988502) [toit] INFO: <- OK
(3.010836) [toit] INFO: -> AT+CPSMS=0
(3.018095) [toit] INFO: <- OK
(3.040604) [toit] INFO: -> AT+CEDRXS=0
(3.047780) [toit] INFO: <- OK
(3.070229) [toit] INFO: -> AT+SQNIBRCFG=0
(3.089922) [toit] INFO: <- OK
(3.112522) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.129808) [toit] INFO: <- OK
(3.152432) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.222432) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.224872) [toit] INFO: <- OK
(3.247240) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.254928) [toit] INFO: <- +CME ERROR: operation not supported
(3.276971) [toit] INFO: -> AT+CGDCONT?
(3.283493) [toit] INFO: <- +CGDCONT: 1,"IP","nbiot.tdc.dk",,,,0,0,0,0,0,0,0,,0
(3.286283) [toit] INFO: <- OK
(3.308671) [toit] INFO: -> AT+CFUN=1,1
(3.367629) [toit] INFO: <- OK
(3.423151) [toit] INFO: <- *ignored* [URC] +SHUTDOWN []
(5.187064) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(8.294675) [toit] INFO: -> AT+CFUN=4
(10.169479) [toit.scheduler] INFO: running job {job: persist_metrics}
(10.172768) [toit.metrics] INFO: persisting metrics
(10.259971) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(10.729332) [toit] INFO: <- OK
(10.731995) [toit.cellular] DEBUG: failed, detach from network
(10.750808) [toit.network] DEBUG: error connecting {network: Cellular (nbiot.tdc.dk), error: DEADLINE_EXCEEDED}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | used: 165kb | free: 10kb->78kb (largest 68kb) 2.464ms]
(10.774273) [toit.network] WARN: failed to connect to any network
----
Received a Toit system message but unable to send it to the Toit console for decoding.
Executing the command below will make it human readable:
----
toit serial decode WyNVBVVYU1UXdjEuNi4wLXByZS4yNStjOGFlNWVhYTBTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKuMVsjVQNVRlUBbAACrY5bI1UDVUZVAmwAAqoaWyNVA1VGVQNJJWhbI1UDVUZVBEklfVsjVQNVRlUFSSUCWyNVA1VGVQZsAAKqV1sjVQNVRlUHbAACqfNbI1UDVUZVCGwAAQP4WyNVA1VGVQlsAAGg+FsjVQNVRlUKbAABFD5bI1UDVUZVC2wAARRXWyNVA1VGVQxsAAET1FsjVQNVRlUNSSVoWyNVA1VGVQ5JJX1bI1UDVUZVD0klWlsjVQNVRlUQbAABE+1bI1UDVUZVEWwAARQDWyNVA1VGVRJJMqlbI1UDVUZVE2wAAkxYWyNVA1VGVRRJJWhbI1UDVUZVFUklfVsjVQNVRlUWSSUCWyNVA1VGVRdsAAJMbVsjVQNVRlUYbAACTIRbI1UDVUZVGUkyPlsjVQNVRlUaSTLZ
(10.876427) [toit] INFO: -> AT+CFUN=0
(10.882867) [toit.scheduler] INFO: changing run level {run_level: 0}
(10.886602) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(10.888490) [toit.metrics] INFO: persisting metrics
(11.497115) [toit] INFO: <- OK
(11.604857) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms