1637845392.toit-sim-4786.hardware_id-e1ddb74a-18cb-4b55-8fdf-f214061b6327.firmware-v1.5.0-rc.1.log

$ toit serial reinstall --firmware v1.5.0-rc.1 -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=internet --port=/dev/ttyUSB0
Detecting chip type. This can take up to 10s.
Reinstalling hardware with firmware: v1.5.0-rc.1 (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/652478058/otadata968224449 0x10000 /tmp/652478058/ota_0545660716"
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: 24:0a:c4:c7:26:10
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 22581.0 kbit/s)...
Hash of data verified.
Compressed 1323840 bytes to 804568...
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 1323840 bytes (804568 compressed) at 0x00010000 in 13.2 seconds (effective 800.7 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.host            | device.toit.io |
| broker.port            | 9426           |
| model.cellular.cts     | 18             |
| model.cellular.rts     | 19             |
| model.cellular.pwr     | 27             |
| broker.cn              | device.toit.io |
| model.cellular.monarch | 1              |
| cellular.apn           | internet       |
| model.cellular.enabled | 1              |
| model.cellular.tx      | 5              |
| model.cellular.rx      | 23             |
| model                  | esp32-4mb      |
+------------------------+----------------+


$ toit serial info --output table
+-------------------------------------------------------------------------+-----------+--------------------------------------+
|                                  NAME                                   |   MODEL   |             HARDWARE ID              |
+-------------------------------------------------------------------------+-----------+--------------------------------------+
| e1ddb74a-18cb-4b55-8fdf-f214061b6327.457.2021-09-26.device.toitware.com | esp32-4mb | e1ddb74a-18cb-4b55-8fdf-f214061b6327 |
+-------------------------------------------------------------------------+-----------+--------------------------------------+


$ 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=e1ddb74a-18cb-4b55-8fdf-f214061b6327.457.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015893) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020877) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.485345) [toit.state] INFO: starting new session {session_id: 1, session_time: 0.492458}
[gc @ 0x3ffcf9f0* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcf9f0* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.153ms]
(0.584771) [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.687371) [toit.console_sync] INFO: loaded last console sync {time: null}
(0.699407) [toit.scheduler] INFO: running job {job: console_sync}
(0.702305) [toit.scheduler] INFO: running job {job: flush_metrics}
(0.704484) [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 | free: 12kb->12kb 1.774ms]
(0.709404) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.738259) [toit.console] INFO: waiting for console connection to be established
(0.742630) [toit.network] DEBUG: connecting {network: Cellular (internet)}
(0.749936) [toit.metrics] INFO: persisting metrics
(0.753076) [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 | free: 12kb->12kb 1.978ms]
(1.108824) [toit] INFO: -> AT
(1.370196) [toit] INFO: -> AT
(1.630785) [toit] INFO: -> AT
(1.891492) [toit] INFO: -> AT
(2.152272) [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 | free: 6kb->6kb 2.311ms]
(2.412953) [toit] INFO: -> AT
(2.673809) [toit] INFO: -> AT
(2.934390) [toit] INFO: -> AT
(3.195204) [toit] INFO: -> AT
(3.455889) [toit] INFO: -> AT
(3.716673) [toit] INFO: -> AT
(3.977925) [toit] INFO: -> AT
(4.238703) [toit] INFO: -> AT
(4.243558) [toit] INFO: <- OK
(4.347942) [toit] INFO: -> ATE0
(4.352086) [toit] INFO: <- OK
(4.374996) [toit] INFO: -> AT+CMEE=2
(4.384908) [toit] INFO: <- OK
(4.407554) [toit] INFO: -> AT+CGMM
(4.412106) [toit] INFO: <- FiPy
(4.415016) [toit] INFO: <- OK
(4.437684) [toit] INFO: -> AT+CGMR
(4.510184) [toit] INFO: <- UE5.0.0.0d
(4.513153) [toit] INFO: <- OK
(4.535291) [toit] INFO: -> AT+SQNCCID?
(4.540636) [toit] INFO: <- +SQNCCID: "89882390000069114786",""
(4.542903) [toit] INFO: <- OK
(4.545387) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.0.0.0d, iccid: 89882390000069114786}
(4.565503) [toit] INFO: -> AT+CFUN=4
(4.785936) [toit] INFO: <- OK
(4.808660) [toit] INFO: -> AT+CPIN?
(4.812905) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.917536) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(5.067952) [toit] INFO: -> AT+CPIN?
(5.073450) [toit] INFO: <- +CPIN: READY
(5.076145) [toit] INFO: <- OK
(5.105998) [toit] INFO: -> AT+CPSMS=0
(5.158082) [toit] INFO: <- OK
(5.180937) [toit] INFO: -> AT+CEDRXS=0
(5.185174) [toit] INFO: <- OK
(5.208073) [toit] INFO: -> AT+SQNIBRCFG=0
(5.300855) [toit] INFO: <- OK
(5.323607) [toit] INFO: -> AT+SQNIPSCFG=1,100
(5.501925) [toit] INFO: <- OK
(5.524846) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(5.529586) [toit] INFO: <- +CME ERROR: operation not supported
(5.552146) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(5.556585) [toit] INFO: <- +CME ERROR: operation not supported
(5.578800) [toit] INFO: -> AT+CGDCONT?
(5.585271) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0
(5.587976) [toit] INFO: <- OK
(5.610370) [toit] INFO: -> AT+CFUN=1
(6.052536) [toit] INFO: <- OK
(10.594998) [toit] INFO: -> AT+CFUN=4
(10.694640) [toit.scheduler] INFO: running job {job: persist_metrics}
(10.698081) [toit.metrics] INFO: persisting metrics
[gc @ 0x3ffcf9f0* | soft limit reached (57372 >= 55338)]
[gc @ 0x3ffcf9f0* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcf9f0* | heap: 56kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.306ms]
(10.988578) [toit] INFO: <- OK
(11.001698) [toit] INFO: <- +CEREG: 0
(11.004667) [toit] INFO: <- *ignored* [URC] +CEREG [0]
(11.009612) [toit.cellular] DEBUG: failed, detach from network
(11.030383) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(11.038093) [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 WyNVBVVYU1ULdjEuNS4wLXJjLjFTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKppVsjVQNVRlUBbAACqQJbI1UDVUZVAmwAAqWOWyNVA1VGVQNJJNhbI1UDVUZVBEkk7VsjVQNVRlUFSSRyWyNVA1VGVQZsAAKly1sjVQNVRlUHbAACpWdbI1UDVUZVCGwAAQFHWyNVA1VGVQlsAAGcN1sjVQNVRlUKbAABEVdbI1UDVUZVC2wAARFwWyNVA1VGVQxsAAEQ7VsjVQNVRlUNSSTYWyNVA1VGVQ5JJO1bI1UDVUZVD0kkylsjVQNVRlUQbAABEQZbI1UDVUZVEWwAAREcWyNVA1VGVRJJMfNbI1UDVUZVE2wAAkdwWyNVA1VGVRRJJNhbI1UDVUZVFUkk7VsjVQNVRlUWSSRyWyNVA1VGVRdsAAJHhVsjVQNVRlUYbAACR5xbI1UDVUZVGUkxiFsjVQNVRlUaSTIj
(11.132337) [toit] INFO: -> AT+CFUN=0
(11.138427) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(11.150044) [toit.scheduler] INFO: changing run level {run_level: 0}
(11.153828) [toit.scheduler] INFO: going into deep sleep {ms: 4978}
(11.155834) [toit.metrics] INFO: persisting metrics
(11.331587) [toit] INFO: <- OK
[gc @ 0x3ffcf9f0* | soft limit reached (49624 >= 49194)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 590 (heap)]
[gc @ 0x3ffcf9f0* | heap: 48kb -> 20kb | external: 0kb -> 0kb | free: 15kb->16kb 2.348ms]
(11.449388) [toit] INFO: entering deep sleep {ms: 4978}
Entering deep sleep for 4978ms
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=e1ddb74a-18cb-4b55-8fdf-f214061b6327.457.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015886) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020871) [toit.scheduler�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=e1ddb74a-18cb-4b55-8fdf-f214061b6327.457.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015893) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020877) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.060540) [toit.state] INFO: starting new session {session_id: 2, session_time: 0.068046}
[gc @ 0x3ffcf9f0* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcf9f0* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.064ms]
(0.079024) [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.119814) [toit.console_sync] INFO: loaded last console sync {time: null}
(0.133039) [toit.scheduler] INFO: running job {job: console_sync}
(0.135920) [toit.scheduler] INFO: running job {job: flush_metrics}
[gc @ 0x3ffcf9f0* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcf9f0* | string allocation failed, length = 76 (heap)]
[gc @ 0x3ffcf9f0* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.766ms]
(0.138080) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.161659) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.171557) [toit.console] INFO: waiting for console connection to be established
(0.175834) [toit.network] DEBUG: connecting {network: Cellular (internet)}
(0.183109) [toit.metrics] INFO: persisting metrics
(0.186281) [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 | free: 12kb->12kb 1.976ms]
[gc @ 0x3ffcf9f0* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcf9f0* | heap: 44kb -> 24kb | external: 0kb -> 0kb | free: 6kb->6kb 2.185ms]
(0.547994) [toit] INFO: -> AT
(0.812982) [toit] INFO: -> AT
(1.073691) [toit] INFO: -> AT
(1.334374) [toit] INFO: -> AT
(1.595103) [toit] INFO: -> AT
(1.855785) [toit] INFO: -> AT
(2.116690) [toit] INFO: -> AT
(2.377916) [toit] INFO: -> AT
(2.638632) [toit] INFO: -> AT
(2.899333) [toit] INFO: -> AT
(3.160170) [toit] INFO: -> AT
(3.420879) [toit] INFO: -> AT
(3.681609) [toit] INFO: -> AT
(3.686525) [toit] INFO: <- OK
(3.790997) [toit] INFO: -> ATE0
(3.795154) [toit] INFO: <- OK
(3.822220) [toit] INFO: -> AT+CMEE=2
(3.826570) [toit] INFO: <- OK
(3.849245) [toit] INFO: -> AT+CGMM
(3.853754) [toit] INFO: <- FiPy
(3.856682) [toit] INFO: <- OK
(3.878784) [toit] INFO: -> AT+CGMR
(3.952197) [toit] INFO: <- UE5.0.0.0d
(3.955143) [toit] INFO: <- OK
(3.977637) [toit] INFO: -> AT+SQNCCID?
(3.983058) [toit] INFO: <- +SQNCCID: "89882390000069114786",""
(3.985333) [toit] INFO: <- OK
(3.987815) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.0.0.0d, iccid: 89882390000069114786}
(4.007907) [toit] INFO: -> AT+CFUN=4
(4.301938) [toit] INFO: <- OK
(4.325326) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(4.345594) [toit] INFO: -> AT+CPIN?
(4.350017) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.604734) [toit] INFO: -> AT+CPIN?
(4.608983) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.863522) [toit] INFO: -> AT+CPIN?
(4.867837) [toit] INFO: <- +CME ERROR: SIM not inserted
(5.122328) [toit] INFO: -> AT+CPIN?
(5.450116) [toit] INFO: <- +CPIN: READY
(5.452515) [toit] INFO: <- OK
(5.474887) [toit] INFO: -> AT+CPSMS=0
(5.525311) [toit] INFO: <- OK
(5.548191) [toit] INFO: -> AT+CEDRXS=0
(5.554112) [toit] INFO: <- OK
(5.577900) [toit] INFO: -> AT+SQNIBRCFG=0
(5.669243) [toit] INFO: <- OK
(5.692317) [toit] INFO: -> AT+SQNIPSCFG=1,100
(5.917674) [toit] INFO: <- OK
[gc @ 0x3ffcf9f0* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcf9f0* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcf9f0* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.276ms]
(5.940525) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(5.958291) [toit] INFO: <- +CME ERROR: operation not supported
(5.981233) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(5.986039) [toit] INFO: <- +CME ERROR: operation not supported
(6.008332) [toit] INFO: -> AT+CGDCONT?
(6.013686) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0
(6.016585) [toit] INFO: <- OK
(6.039112) [toit] INFO: -> AT+CFUN=1
(6.419650) [toit] INFO: <- OK
(10.142404) [toit.scheduler] INFO: running job {job: persist_metrics}
(10.146315) [toit.metrics] INFO: persisting metrics
(10.554317) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(11.024130) [toit] INFO: -> AT+CFUN=4
(11.584304) [toit] INFO: <- OK
(11.587098) [toit] INFO: <- +CEREG: 0
(11.589091) [toit] INFO: <- *ignored* [URC] +CEREG [0]
(11.591082) [toit.cellular] DEBUG: failed, detach from network
(11.610928) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(11.618668) [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 WyNVBVVYU1ULdjEuNS4wLXJjLjFTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKppVsjVQNVRlUBbAACqQJbI1UDVUZVAmwAAqWOWyNVA1VGVQNJJNhbI1UDVUZVBEkk7VsjVQNVRlUFSSRyWyNVA1VGVQZsAAKly1sjVQNVRlUHbAACpWdbI1UDVUZVCGwAAQFHWyNVA1VGVQlsAAGcN1sjVQNVRlUKbAABEVdbI1UDVUZVC2wAARFwWyNVA1VGVQxsAAEQ7VsjVQNVRlUNSSTYWyNVA1VGVQ5JJO1bI1UDVUZVD0kkylsjVQNVRlUQbAABEQZbI1UDVUZVEWwAAREcWyNVA1VGVRJJMfNbI1UDVUZVE2wAAkdwWyNVA1VGVRRJJNhbI1UDVUZVFUkk7VsjVQNVRlUWSSRyWyNVA1VGVRdsAAJHhVsjVQNVRlUYbAACR5xbI1UDVUZVGUkxiFsjVQNVRlUaSTIj
[gc @ 0x3ffcf9f0* | soft limit reached (49624 >= 49194)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcf9f0* | heap: 48kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.382ms]
(11.731963) [toit] INFO: -> AT+CFUN=0
(11.738932) [toit.scheduler] INFO: changing run level {run_level: 0}
(11.742620) [toit.scheduler] INFO: going into deep sleep {ms: 4979}
(11.744643) [toit.metrics] INFO: persisting metrics
(11.931969) [toit] INFO: <- OK
(12.040157) [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=e1ddb74a-18cb-4b55-8fdf-f214061b6327.457.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015890) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020874) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.052552) [toit.state] INFO: resumed session {session_id: 2, session_time: 17.136171}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 20 (heap)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.067ms]
(0.076357) [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.119877) [toit.console_sync] INFO: loaded last console sync {time: 11.704411}
(0.135986) [toit.scheduler] INFO: running job {job: console_sync}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.745ms]
(0.138982) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.152990) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.162961) [toit.console] INFO: waiting for console connection to be established
(0.167067) [toit.network] DEBUG: connecting {network: Cellular (internet)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | free: 12kb->12kb 1.919ms]
(0.209699) [toit] INFO: -> AT
(0.471098) [toit] INFO: -> AT
(0.731677) [toit] INFO: -> AT
(0.992375) [toit] INFO: -> AT
(1.253215) [toit] INFO: -> AT
(1.516458) [toit] INFO: -> AT
(1.777863) [toit] INFO: -> AT
(2.038661) [toit] INFO: -> AT
(2.299358) [toit] INFO: -> AT
(2.560093) [toit] INFO: -> AT
(2.820837) [toit] INFO: -> AT
(3.081653) [toit] INFO: -> AT
(3.342341) [toit] INFO: -> AT
(3.603101) [toit] INFO: -> AT
(3.608056) [toit] INFO: <- OK
(3.712393) [toit] INFO: -> ATE0
(3.716696) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 8 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.301ms]
(3.739392) [toit] INFO: -> AT+CMEE=2
(3.743830) [toit] INFO: <- OK
(3.766411) [toit] INFO: -> AT+CGMM
(3.770839) [toit] INFO: <- FiPy
(3.773793) [toit] INFO: <- OK
(3.796008) [toit] INFO: -> AT+CGMR
(3.869408) [toit] INFO: <- UE5.0.0.0d
(3.872102) [toit] INFO: <- OK
(3.894309) [toit] INFO: -> AT+SQNCCID?
(3.906647) [toit] INFO: <- +SQNCCID: "89882390000069114786",""
(3.909086) [toit] INFO: <- OK
(3.911530) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.0.0.0d, iccid: 89882390000069114786}
(3.931458) [toit] INFO: -> AT+CFUN=4
(4.224671) [toit] INFO: <- OK
(4.247536) [toit] INFO: -> AT+CPIN?
(4.251806) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.262547) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(4.506627) [toit] INFO: -> AT+CPIN?
(4.511106) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.765875) [toit] INFO: -> AT+CPIN?
(4.774178) [toit] INFO: <- +CME ERROR: SIM not inserted
(5.028902) [toit] INFO: -> AT+CPIN?
(5.373303) [toit] INFO: <- +CPIN: READY
(5.375547) [toit] INFO: <- OK
(5.398218) [toit] INFO: -> AT+CPSMS=0
(5.448926) [toit] INFO: <- OK
(5.471883) [toit] INFO: -> AT+CEDRXS=0
(5.476350) [toit] INFO: <- OK
(5.499517) [toit] INFO: -> AT+SQNIBRCFG=0
(5.592159) [toit] INFO: <- OK
(5.615320) [toit] INFO: -> AT+SQNIPSCFG=1,100
(6.066540) [toit] INFO: <- OK
(6.089460) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(6.094622) [toit] INFO: <- +CME ERROR: operation not supported
(6.117967) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(6.122476) [toit] INFO: <- +CME ERROR: operation not supported
(6.144765) [toit] INFO: -> AT+CGDCONT?
(6.149859) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0
(6.152763) [toit] INFO: <- OK
(6.175241) [toit] INFO: -> AT+CFUN=1
(7.048805) [toit] INFO: <- OK
(10.153041) [toit.scheduler] INFO: running job {job: persist_metrics}
(10.156587) [toit.metrics] INFO: persisting metrics
(10.229371) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.239ms]
(11.159630) [toit] INFO: -> AT+CFUN=4
(11.760076) [toit] INFO: <- OK
(11.763009) [toit] INFO: <- +CEREG: 0
(11.764998) [toit] INFO: <- *ignored* [URC] +CEREG [0]
(11.766967) [toit.cellular] DEBUG: failed, detach from network
(11.780323) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(11.787689) [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 WyNVBVVYU1ULdjEuNS4wLXJjLjFTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKppVsjVQNVRlUBbAACqQJbI1UDVUZVAmwAAqWOWyNVA1VGVQNJJNhbI1UDVUZVBEkk7VsjVQNVRlUFSSRyWyNVA1VGVQZsAAKly1sjVQNVRlUHbAACpWdbI1UDVUZVCGwAAQFHWyNVA1VGVQlsAAGcN1sjVQNVRlUKbAABEVdbI1UDVUZVC2wAARFwWyNVA1VGVQxsAAEQ7VsjVQNVRlUNSSTYWyNVA1VGVQ5JJO1bI1UDVUZVD0kkylsjVQNVRlUQbAABEQZbI1UDVUZVEWwAAREcWyNVA1VGVRJJMfNbI1UDVUZVE2wAAkdwWyNVA1VGVRRJJNhbI1UDVUZVFUkk7VsjVQNVRlUWSSRyWyNVA1VGVRdsAAJHhVsjVQNVRlUYbAACR5xbI1UDVUZVGUkxiFsjVQNVRlUaSTIj
[gc @ 0x3ffcfa58* | soft limit reached (49624 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 11.171ms]
(11.907004) [toit] INFO: -> AT+CFUN=0
(11.913791) [toit.scheduler] INFO: changing run level {run_level: 0}
(11.917463) [toit.scheduler] INFO: going into deep sleep {ms: 4976}
(11.919497) [toit.metrics] INFO: persisting metrics
(12.105705) [toit] INFO: <- OK
(12.213729) [toit] INFO: entering deep sleep {ms: 4976}
Entering deep sleep for 4976ms
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=e1ddb74a-18cb-4b55-8fdf-f214061b6327.457.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015890) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020874) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.052403) [toit.state] INFO: resumed session {session_id: 2, session_time: 34.369084}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.037ms]
(0.069042) [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.110305) [toit.console_sync] INFO: loaded last console sync {time: 28.939725}
(0.126544) [toit.scheduler] INFO: running job {job: console_sync}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.732ms]
(0.137165) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.143503) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.153457) [toit.console] INFO: waiting for console connection to be established
(0.157632) [toit.network] DEBUG: connecting {network: Cellular (internet)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | free: 12kb->12kb 1.910ms]
(0.200979) [toit] INFO: -> AT
(0.462383) [toit] INFO: -> AT
(0.722954) [toit] INFO: -> AT
(0.983652) [toit] INFO: -> AT
(1.244680) [toit] INFO: -> AT
(1.505223) [toit] INFO: -> AT
(1.765920) [toit] INFO: -> AT
(2.027708) [toit] INFO: -> AT
(2.288392) [toit] INFO: -> AT
(2.549130) [toit] INFO: -> AT
(2.816406) [toit] INFO: -> AT
(3.077961) [toit] INFO: -> AT
(3.082898) [toit] INFO: <- OK
(3.187885) [toit] INFO: -> ATE0
(3.192115) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 64 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.252ms]
(3.223529) [toit] INFO: -> AT+CMEE=2
(3.228688) [toit] INFO: <- OK
(3.251174) [toit] INFO: -> AT+CGMM
(3.255770) [toit] INFO: <- FiPy
(3.258702) [toit] INFO: <- OK
(3.280826) [toit] INFO: -> AT+CGMR
(3.353898) [toit] INFO: <- UE5.0.0.0d
(3.356844) [toit] INFO: <- OK
(3.379054) [toit] INFO: -> AT+SQNCCID?
(3.384465) [toit] INFO: <- +SQNCCID: "89882390000069114786",""
(3.386710) [toit] INFO: <- OK
(3.389198) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.0.0.0d, iccid: 89882390000069114786}
(3.409216) [toit] INFO: -> AT+CFUN=4
(4.245014) [toit] INFO: <- OK
(4.267836) [toit] INFO: -> AT+CPIN?
(4.272139) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.293146) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(4.527858) [toit] INFO: -> AT+CPIN?
(5.069283) [toit] INFO: <- +CME ERROR: SIM not inserted
(5.324293) [toit] INFO: -> AT+CPIN?
(5.668214) [toit] INFO: <- +CPIN: READY
(5.670910) [toit] INFO: <- OK
(5.693484) [toit] INFO: -> AT+CPSMS=0
(5.744168) [toit] INFO: <- OK
(5.767744) [toit] INFO: -> AT+CEDRXS=0
(5.772182) [toit] INFO: <- OK
(5.795048) [toit] INFO: -> AT+SQNIBRCFG=0
(5.895791) [toit] INFO: <- OK
(5.918843) [toit] INFO: -> AT+SQNIPSCFG=1,100
(6.327867) [toit] INFO: <- OK
(6.350789) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(6.355629) [toit] INFO: <- +CME ERROR: operation not supported
(6.378225) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(6.382994) [toit] INFO: <- +CME ERROR: operation not supported
(6.406146) [toit] INFO: -> AT+CGDCONT?
(6.411359) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0
(6.414049) [toit] INFO: <- OK
(6.436506) [toit] INFO: -> AT+CFUN=1
(6.545815) [toit] INFO: <- OK
(10.138843) [toit.scheduler] INFO: running job {job: persist_metrics}
(10.142745) [toit.metrics] INFO: persisting metrics
(10.215776) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.232ms]
(11.420992) [toit] INFO: -> AT+CFUN=4
(12.033851) [toit] INFO: <- OK
(12.037059) [toit] INFO: <- +CEREG: 0
(12.039118) [toit] INFO: <- *ignored* [URC] +CEREG [0]
(12.041070) [toit.cellular] DEBUG: failed, detach from network
(12.060871) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(12.068407) [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 WyNVBVVYU1ULdjEuNS4wLXJjLjFTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKppVsjVQNVRlUBbAACqQJbI1UDVUZVAmwAAqWOWyNVA1VGVQNJJNhbI1UDVUZVBEkk7VsjVQNVRlUFSSRyWyNVA1VGVQZsAAKly1sjVQNVRlUHbAACpWdbI1UDVUZVCGwAAQFHWyNVA1VGVQlsAAGcN1sjVQNVRlUKbAABEVdbI1UDVUZVC2wAARFwWyNVA1VGVQxsAAEQ7VsjVQNVRlUNSSTYWyNVA1VGVQ5JJO1bI1UDVUZVD0kkylsjVQNVRlUQbAABEQZbI1UDVUZVEWwAAREcWyNVA1VGVRJJMfNbI1UDVUZVE2wAAkdwWyNVA1VGVRRJJNhbI1UDVUZVFUkk7VsjVQNVRlUWSSRyWyNVA1VGVRdsAAJHhVsjVQNVRlUYbAACR5xbI1UDVUZVGUkxiFsjVQNVRlUaSTIj
(12.165607) [toit] INFO: -> AT+CFUN=0
(12.172369) [toit.scheduler] INFO: changing run level {run_level: 0}
(12.176062) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(12.178100) [toit.metrics] INFO: persisting metrics
[gc @ 0x3ffcfa58* | soft limit reached (49624 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.320ms]
(12.366678) [toit] INFO: <- OK
(12.474549) [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=e1ddb74a-18cb-4b55-8fdf-f214061b6327.457.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015888) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020872) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.052226) [toit.state] INFO: resumed session {session_id: 2, session_time: 51.880416}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.036ms]
(0.068866) [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.110381) [toit.console_sync] INFO: loaded last console sync {time: 46.448393}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.705ms]
(0.129765) [toit.scheduler] INFO: running job {job: console_sync}
(0.135368) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.141937) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.151945) [toit.console] INFO: waiting for console connection to be established
(0.156098) [toit.network] DEBUG: connecting {network: Cellular (internet)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | free: 12kb->12kb 1.916ms]
(0.200607) [toit] INFO: -> AT
(0.462013) [toit] INFO: -> AT
(0.722593) [toit] INFO: -> AT
(0.983291) [toit] INFO: -> AT
(1.244130) [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 | free: 6kb->6kb 2.273ms]
(1.504845) [toit] INFO: -> AT
(1.765694) [toit] INFO: -> AT
(2.026362) [toit] INFO: -> AT
(2.287850) [toit] INFO: -> AT
(2.548570) [toit] INFO: -> AT
(2.816412) [toit] INFO: -> AT
(3.078130) [toit] INFO: -> AT
(3.338628) [toit] INFO: -> AT
(3.599368) [toit] INFO: -> AT
(3.604306) [toit] INFO: <- OK
(3.708533) [toit] INFO: -> ATE0
(3.713359) [toit] INFO: <- OK
(3.736307) [toit] INFO: -> AT+CMEE=2
(3.740441) [toit] INFO: <- OK
(3.763107) [toit] INFO: -> AT+CGMM
(3.767480) [toit] INFO: <- FiPy
(3.770439) [toit] INFO: <- OK
(3.792696) [toit] INFO: -> AT+CGMR
(3.865757) [toit] INFO: <- UE5.0.0.0d
(3.868697) [toit] INFO: <- OK
(3.890926) [toit] INFO: -> AT+SQNCCID?
(3.896347) [toit] INFO: <- +SQNCCID: "89882390000069114786",""
(3.907235) [toit] INFO: <- OK
(3.909767) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.0.0.0d, iccid: 89882390000069114786}
(3.915509) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(3.936290) [toit] INFO: -> AT+CFUN=4
(4.029118) [toit] INFO: <- OK
(4.052008) [toit] INFO: -> AT+CPIN?
(4.056203) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.310992) [toit] INFO: -> AT+CPIN?
(4.315380) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.569817) [toit] INFO: -> AT+CPIN?
(4.576829) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.831151) [toit] INFO: -> AT+CPIN?
(5.175649) [toit] INFO: <- +CPIN: READY
(5.178293) [toit] INFO: <- OK
(5.206762) [toit] INFO: -> AT+CPSMS=0
(5.257206) [toit] INFO: <- OK
(5.280193) [toit] INFO: -> AT+CEDRXS=0
(5.284338) [toit] INFO: <- OK
(5.307836) [toit] INFO: -> AT+SQNIBRCFG=0
(5.400778) [toit] INFO: <- OK
(5.423859) [toit] INFO: -> AT+SQNIPSCFG=1,100
(5.802488) [toit] INFO: <- OK
(5.825427) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(5.830550) [toit] INFO: <- +CME ERROR: operation not supported
(5.853246) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(5.857789) [toit] INFO: <- +CME ERROR: operation not supported
(5.880025) [toit] INFO: -> AT+CGDCONT?
(5.885307) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0
(5.887959) [toit] INFO: <- OK
(5.910431) [toit] INFO: -> AT+CFUN=1
(6.019855) [toit] INFO: <- OK
(10.135764) [toit.scheduler] INFO: running job {job: persist_metrics}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.257ms]
(10.139502) [toit.metrics] INFO: persisting metrics
(10.212410) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(10.895217) [toit] INFO: -> AT+CFUN=4
(11.531481) [toit] INFO: <- OK
(11.534626) [toit] INFO: <- +CEREG: 0
(11.536655) [toit] INFO: <- *ignored* [URC] +CEREG [0]
(11.538596) [toit.cellular] DEBUG: failed, detach from network
(11.550861) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(11.558865) [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 WyNVBVVYU1ULdjEuNS4wLXJjLjFTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKppVsjVQNVRlUBbAACqQJbI1UDVUZVAmwAAqWOWyNVA1VGVQNJJNhbI1UDVUZVBEkk7VsjVQNVRlUFSSRyWyNVA1VGVQZsAAKly1sjVQNVRlUHbAACpWdbI1UDVUZVCGwAAQFHWyNVA1VGVQlsAAGcN1sjVQNVRlUKbAABEVdbI1UDVUZVC2wAARFwWyNVA1VGVQxsAAEQ7VsjVQNVRlUNSSTYWyNVA1VGVQ5JJO1bI1UDVUZVD0kkylsjVQNVRlUQbAABEQZbI1UDVUZVEWwAAREcWyNVA1VGVRJJMfNbI1UDVUZVE2wAAkdwWyNVA1VGVRRJJNhbI1UDVUZVFUkk7VsjVQNVRlUWSSRyWyNVA1VGVRdsAAJHhVsjVQNVRlUYbAACR5xbI1UDVUZVGUkxiFsjVQNVRlUaSTIj
[gc @ 0x3ffcfa58* | soft limit reached (49624 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 20kb | external: 0kb -> 0kb | free: 10kb->6kb 2.272ms]
(11.659272) [toit] INFO: -> AT+CFUN=0
(11.665985) [toit.scheduler] INFO: changing run level {run_level: 0}
(11.669890) [toit.scheduler] INFO: going into deep sleep {ms: 4985}
(11.671902) [toit.metrics] INFO: persisting metrics
(11.858770) [toit] INFO: <- OK
(11.966997) [toit] INFO: entering deep sleep {ms: 4985}
Entering deep sleep for 4985ms
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=e1ddb74a-18cb-4b55-8fdf-f214061b6327.457.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015890) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020874) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.052052) [toit.state] INFO: resumed session {session_id: 2, session_time: 68.886057}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.036ms]
(0.068699) [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.110478) [toit.console_sync] INFO: loaded last console sync {time: 63.455470}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.715ms]
(0.130100) [toit.scheduler] INFO: running job {job: console_sync}
(0.133088) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.138861) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.148731) [toit.console] INFO: waiting for console connection to be established
(0.152966) [toit.network] DEBUG: connecting {network: Cellular (internet)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | free: 12kb->12kb 1.910ms]
(0.198093) [toit] INFO: -> AT
(0.459485) [toit] INFO: -> AT
(0.720074) [toit] INFO: -> AT
(0.980775) [toit] INFO: -> AT
(1.241605) [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 | free: 6kb->6kb 2.260ms]
(1.502320) [toit] INFO: -> AT
(1.763168) [toit] INFO: -> AT
(2.023837) [toit] INFO: -> AT
(2.284517) [toit] INFO: -> AT
(2.545244) [toit] INFO: -> AT
(2.806008) [toit] INFO: -> AT
(3.067699) [toit] INFO: -> AT
(3.328376) [toit] INFO: -> AT
(3.333420) [toit] INFO: <- OK
(3.437897) [toit] INFO: -> ATE0
(3.442310) [toit] INFO: <- OK
(3.465036) [toit] INFO: -> AT+CMEE=2
(3.469095) [toit] INFO: <- OK
(3.491582) [toit] INFO: -> AT+CGMM
(3.496211) [toit] INFO: <- FiPy
(3.507850) [toit] INFO: <- OK
(3.529973) [toit] INFO: -> AT+CGMR
(3.533548) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(3.606034) [toit] INFO: <- UE5.0.0.0d
(3.608360) [toit] INFO: <- OK
(3.630627) [toit] INFO: -> AT+SQNCCID?
(3.635893) [toit] INFO: <- +SQNCCID: "89882390000069114786",""
(3.638126) [toit] INFO: <- OK
(3.640595) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.0.0.0d, iccid: 89882390000069114786}
(3.660705) [toit] INFO: -> AT+CFUN=4
(3.753140) [toit] INFO: <- OK
(3.775863) [toit] INFO: -> AT+CPIN?
(3.779977) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.034855) [toit] INFO: -> AT+CPIN?
(4.039012) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.293508) [toit] INFO: -> AT+CPIN?
(4.305722) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.560202) [toit] INFO: -> AT+CPIN?
(4.904183) [toit] INFO: <- +CPIN: READY
(4.906862) [toit] INFO: <- OK
(4.929330) [toit] INFO: -> AT+CPSMS=0
(4.979734) [toit] INFO: <- OK
(5.002921) [toit] INFO: -> AT+CEDRXS=0
(5.007471) [toit] INFO: <- OK
(5.030406) [toit] INFO: -> AT+SQNIBRCFG=0
(5.122916) [toit] INFO: <- OK
(5.145987) [toit] INFO: -> AT+SQNIPSCFG=1,100
(5.325472) [toit] INFO: <- OK
(5.348535) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(5.354400) [toit] INFO: <- +CME ERROR: operation not supported
(5.377079) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(5.382162) [toit] INFO: <- +CME ERROR: operation not supported
(5.404369) [toit] INFO: -> AT+CGDCONT?
(5.409523) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0
(5.412174) [toit] INFO: <- OK
(5.434773) [toit] INFO: -> AT+CFUN=1
(5.773955) [toit] INFO: <- OK
(10.140619) [toit.scheduler] INFO: running job {job: persist_metrics}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.253ms]
(10.143971) [toit.metrics] INFO: persisting metrics
(10.214757) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(10.419402) [toit] INFO: -> AT+CFUN=4
(10.917891) [toit] INFO: <- OK
(10.920741) [toit] INFO: <- +CEREG: 0
(10.922723) [toit] INFO: <- *ignored* [URC] +CEREG [0]
(10.924694) [toit.cellular] DEBUG: failed, detach from network
(10.940329) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(10.948469) [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 WyNVBVVYU1ULdjEuNS4wLXJjLjFTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKppVsjVQNVRlUBbAACqQJbI1UDVUZVAmwAAqWOWyNVA1VGVQNJJNhbI1UDVUZVBEkk7VsjVQNVRlUFSSRyWyNVA1VGVQZsAAKly1sjVQNVRlUHbAACpWdbI1UDVUZVCGwAAQFHWyNVA1VGVQlsAAGcN1sjVQNVRlUKbAABEVdbI1UDVUZVC2wAARFwWyNVA1VGVQxsAAEQ7VsjVQNVRlUNSSTYWyNVA1VGVQ5JJO1bI1UDVUZVD0kkylsjVQNVRlUQbAABEQZbI1UDVUZVEWwAAREcWyNVA1VGVRJJMfNbI1UDVUZVE2wAAkdwWyNVA1VGVRRJJNhbI1UDVUZVFUkk7VsjVQNVRlUWSSRyWyNVA1VGVRdsAAJHhVsjVQNVRlUYbAACR5xbI1UDVUZVGUkxiFsjVQNVRlUaSTIj
[gc @ 0x3ffcfa58* | soft limit reached (49624 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 20kb | external: 0kb -> 0kb | free: 10kb->6kb 2.273ms]
(11.049005) [toit] INFO: -> AT+CFUN=0
(11.055785) [toit.scheduler] INFO: changing run level {run_level: 0}
(11.059797) [toit.scheduler] INFO: going into deep sleep {ms: 4985}
(11.061811) [toit.metrics] INFO: persisting metrics
(11.247484) [toit] INFO: <- OK
(11.355435) [toit] INFO: entering deep sleep {ms: 4985}
Entering deep sleep for 4985ms
ets Jun2016 0�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=e1ddb74a-18cb-4b55-8fdf-f214061b6327.457.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015893) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020877) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.060542) [toit.state] INFO: starting new session {session_id: 3, session_time: 0.068062}
[gc @ 0x3ffcf9f0* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcf9f0* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.021ms]
(0.078404) [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.120308) [toit.console_sync] INFO: loaded last console sync {time: null}
[gc @ 0x3ffcf9f0* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcf9f0* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.632ms]
(0.143239) [toit.scheduler] INFO: running job {job: console_sync}
(0.146160) [toit.scheduler] INFO: running job {job: flush_metrics}
(0.151642) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.158441) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.168347) [toit.console] INFO: waiting for console connection to be established
(0.172640) [toit.network] DEBUG: connecting {network: Cellular (internet)}
(0.179929) [toit.metrics] INFO: persisting metrics
(0.183102) [toit.metrics] INFO: flushing metrics
[gc @ 0x3ffcf9f0* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 16 (heap)]
[gc @ 0x3ffcf9f0* | heap: 36kb -> 20kb | external: 0kb -> 0kb | free: 12kb->12kb 1.965ms]
[gc @ 0x3ffcf9f0* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcf9f0* | heap: 44kb -> 24kb | external: 0kb -> 0kb | free: 12kb->12kb 2.022ms]
(0.477726) [toit] INFO: -> AT
(0.739069) [toit] INFO: -> AT
(0.999738) [toit] INFO: -> AT
(1.260580) [toit] INFO: -> AT
(1.521501) [toit] INFO: -> AT
(1.782007) [toit] INFO: -> AT
(2.042796) [toit] INFO: -> AT
(2.303486) [toit] INFO: -> AT
(2.564231) [toit] INFO: -> AT
(2.824914) [toit] INFO: -> AT
(3.085761) [toit] INFO: -> AT
(3.346468) [toit] INFO: -> AT
(3.607961) [toit] INFO: -> AT
(3.612933) [toit] INFO: <- OK
(3.717953) [toit] INFO: -> ATE0
(3.722369) [toit] INFO: <- OK
(3.745010) [toit] INFO: -> AT+CMEE=2
(3.749205) [toit] INFO: <- OK
(3.771730) [toit] INFO: -> AT+CGMM
(3.776500) [toit] INFO: <- FiPy
(3.779436) [toit] INFO: <- OK
(3.801552) [toit] INFO: -> AT+CGMR
(3.875117) [toit] INFO: <- UE5.0.0.0d
(3.878049) [toit] INFO: <- OK
(3.894240) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(3.914644) [toit] INFO: -> AT+SQNCCID?
(3.920256) [toit] INFO: <- +SQNCCID: "89882390000069114786",""
(3.922520) [toit] INFO: <- OK
(3.924988) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.0.0.0d, iccid: 89882390000069114786}
(3.945129) [toit] INFO: -> AT+CFUN=4
(4.037690) [toit] INFO: <- OK
(4.064191) [toit] INFO: -> AT+CPIN?
(4.068375) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.323204) [toit] INFO: -> AT+CPIN?
(4.327294) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.581837) [toit] INFO: -> AT+CPIN?
(4.589016) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.843472) [toit] INFO: -> AT+CPIN?
[gc @ 0x3ffcf9f0* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 14 (heap)]
[gc @ 0x3ffcf9f0* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.199ms]
(5.196749) [toit] INFO: <- +CPIN: READY
(5.199678) [toit] INFO: <- OK
(5.222982) [toit] INFO: -> AT+CPSMS=0
(5.273497) [toit] INFO: <- OK
(5.296608) [toit] INFO: -> AT+CEDRXS=0
(5.300760) [toit] INFO: <- OK
(5.323641) [toit] INFO: -> AT+SQNIBRCFG=0
(5.415853) [toit] INFO: <- OK
(5.438952) [toit] INFO: -> AT+SQNIPSCFG=1,100
(5.624600) [toit] INFO: <- OK
(5.647701) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(5.653418) [toit] INFO: <- +CME ERROR: operation not supported
(5.676060) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(5.681066) [toit] INFO: <- +CME ERROR: operation not supported
(5.703483) [toit] INFO: -> AT+CGDCONT?
(5.708603) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0
(5.711270) [toit] INFO: <- OK
(5.733791) [toit] INFO: -> AT+CFUN=1
(6.097293) [toit] INFO: <- OK
(10.147755) [toit.scheduler] INFO: running job {job: persist_metrics}
(10.151341) [toit.metrics] INFO: persisting metrics
(10.489164) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(10.719660) [toit] INFO: -> AT+CFUN=4
(11.006662) [toit] INFO: <- OK
(11.009539) [toit] INFO: <- +CEREG: 0
(11.011549) [toit] INFO: <- *ignored* [URC] +CEREG [0]
(11.013552) [toit.cellular] DEBUG: failed, detach from network
(11.032045) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(11.039460) [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 (53720 >= 49194)]
[gc @ 0x3ffcf9f0* | string allocation failed, length = 591 (heap)]
[gc @ 0x3ffcf9f0* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.314ms]
toit serial decode WyNVBVVYU1ULdjEuNS4wLXJjLjFTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKppVsjVQNVRlUBbAACqQJbI1UDVUZVAmwAAqWOWyNVA1VGVQNJJNhbI1UDVUZVBEkk7VsjVQNVRlUFSSRyWyNVA1VGVQZsAAKly1sjVQNVRlUHbAACpWdbI1UDVUZVCGwAAQFHWyNVA1VGVQlsAAGcN1sjVQNVRlUKbAABEVdbI1UDVUZVC2wAARFwWyNVA1VGVQxsAAEQ7VsjVQNVRlUNSSTYWyNVA1VGVQ5JJO1bI1UDVUZVD0kkylsjVQNVRlUQbAABEQZbI1UDVUZVEWwAAREcWyNVA1VGVRJJMfNbI1UDVUZVE2wAAkdwWyNVA1VGVRRJJNhbI1UDVUZVFUkk7VsjVQNVRlUWSSRyWyNVA1VGVRdsAAJHhVsjVQNVRlUYbAACR5xbI1UDVUZVGUkxiFsjVQNVRlUaSTIj
(11.152720) [toit] INFO: -> AT+CFUN=0
(11.159759) [toit.scheduler] INFO: changing run level {run_level: 0}
(11.163452) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(11.165466) [toit.metrics] INFO: persisting metrics
(11.620685) [toit] INFO: <- OK
(11.729488) [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=e1ddb74a-18cb-4b55-8fdf-f214061b6327.457.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015888) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020872) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.053485) [toit.state] INFO: resumed session {session_id: 3, session_time: 16.831976}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.023ms]
(0.071016) [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.110692) [toit.console_sync] INFO: loaded last console sync {time: 11.130995}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.686ms]
(0.130318) [toit.scheduler] INFO: running job {job: console_sync}
(0.133326) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.138381) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.148264) [toit.console] INFO: waiting for console connection to be established
(0.152494) [toit.network] DEBUG: connecting {network: Cellular (internet)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | free: 12kb->12kb 1.930ms]
(0.194887) [toit] INFO: -> AT
(0.456286) [toit] INFO: -> AT
(0.717736) [toit] INFO: -> AT
(0.978427) [toit] INFO: -> AT
(1.239264) [toit] INFO: -> AT
(1.499977) [toit] INFO: -> AT
(1.760692) [toit] INFO: -> AT
(2.021494) [toit] INFO: -> AT
(2.282182) [toit] INFO: -> AT
(2.542922) [toit] INFO: -> AT
(2.803682) [toit] INFO: -> AT
(3.064501) [toit] INFO: -> AT
(3.325190) [toit] INFO: -> AT
(3.330127) [toit] INFO: <- OK
(3.434480) [toit] INFO: -> ATE0
(3.438682) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.286ms]
(3.461339) [toit] INFO: -> AT+CMEE=2
(3.476319) [toit] INFO: <- OK
(3.499195) [toit] INFO: -> AT+CGMM
(3.503980) [toit] INFO: <- FiPy
(3.506693) [toit] INFO: <- OK
(3.528971) [toit] INFO: -> AT+CGMR
(3.602793) [toit] INFO: <- UE5.0.0.0d
(3.605492) [toit] INFO: <- OK
(3.627761) [toit] INFO: -> AT+SQNCCID?
(3.633098) [toit] INFO: <- +SQNCCID: "89882390000069114786",""
(3.635417) [toit] INFO: <- OK
(3.637914) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.0.0.0d, iccid: 89882390000069114786}
(3.657936) [toit] INFO: -> AT+CFUN=4
(3.661607) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(3.752510) [toit] INFO: <- OK
(3.775411) [toit] INFO: -> AT+CPIN?
(3.779687) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.034565) [toit] INFO: -> AT+CPIN?
(4.038864) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.293468) [toit] INFO: -> AT+CPIN?
(4.306342) [toit] INFO: <- +CME ERROR: SIM not inserted
(4.560708) [toit] INFO: -> AT+CPIN?
(4.906816) [toit] INFO: <- +CPIN: READY
(4.909128) [toit] INFO: <- OK
(4.931478) [toit] INFO: -> AT+CPSMS=0
(4.981924) [toit] INFO: <- OK
(5.006367) [toit] INFO: -> AT+CEDRXS=0
(5.010734) [toit] INFO: <- OK
(5.033498) [toit] INFO: -> AT+SQNIBRCFG=0
(5.126040) [toit] INFO: <- OK
(5.149121) [toit] INFO: -> AT+SQNIPSCFG=1,100
(5.329576) [toit] INFO: <- OK
(5.352616) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(5.358448) [toit] INFO: <- +CME ERROR: operation not supported
(5.381146) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(5.386063) [toit] INFO: <- +CME ERROR: operation not supported
(5.408297) [toit] INFO: -> AT+CGDCONT?
(5.413543) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0
(5.416210) [toit] INFO: <- OK
(5.438625) [toit] INFO: -> AT+CFUN=1
(5.858565) [toit] INFO: <- OK
(10.138885) [toit.scheduler] INFO: running job {job: persist_metrics}
(10.142787) [toit.metrics] INFO: persisting metrics
(10.208963) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
[gc @ 0x3ffcfa58* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.204ms]
(10.423653) [toit] INFO: -> AT+CFUN=4
(11.039106) [toit] INFO: <- OK
(11.042345) [toit] INFO: <- +CEREG: 0
(11.044402) [toit] INFO: <- *ignored* [URC] +CEREG [0]
(11.046358) [toit.cellular] DEBUG: failed, detach from network
(11.060856) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(11.068482) [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 WyNVBVVYU1ULdjEuNS4wLXJjLjFTVQllc3AzMi00bWJbJFUjVRAAAAAAAAAAAAAAAAAAAAAAWyNVBFVFU1UJRVhDRVBUSU9OU1URRkFJTEVEIFRPIENPTk5FQ1RbI1UCVVNbI1UbWyNVA1VGVQBsAAKppVsjVQNVRlUBbAACqQJbI1UDVUZVAmwAAqWOWyNVA1VGVQNJJNhbI1UDVUZVBEkk7VsjVQNVRlUFSSRyWyNVA1VGVQZsAAKly1sjVQNVRlUHbAACpWdbI1UDVUZVCGwAAQFHWyNVA1VGVQlsAAGcN1sjVQNVRlUKbAABEVdbI1UDVUZVC2wAARFwWyNVA1VGVQxsAAEQ7VsjVQNVRlUNSSTYWyNVA1VGVQ5JJO1bI1UDVUZVD0kkylsjVQNVRlUQbAABEQZbI1UDVUZVEWwAAREcWyNVA1VGVRJJMfNbI1UDVUZVE2wAAkdwWyNVA1VGVRRJJNhbI1UDVUZVFUkk7VsjVQNVRlUWSSRyWyNVA1VGVRdsAAJHhVsjVQNVRlUYbAACR5xbI1UDVUZVGUkxiFsjVQNVRlUaSTIj
(11.165111) [toit] INFO: -> AT+CFUN=0
(11.171895) [toit.scheduler] INFO: changing run level {run_level: 0}
(11.175573) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(11.177610) [toit.metrics] INFO: persisting metrics
[gc @ 0x3ffcfa58* | soft limit reached (49624 >= 49194)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 68 (heap)]
[gc @ 0x3ffcfa58* | heap: 48kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.404ms]
(11.373055) [toit] INFO: <- OK
(11.481043) [toit] INFO: entering deep sleep {ms: 4989}
Entering deep sleep for 4989ms