1637847211.maturix-sim-9690.hardware_id-a966ebf8-6407-4964-9685-95ac15170168.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/430571154/otadata400800457 0x10000 /tmp/430571154/ota_0203571092"
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:cf:a4:30
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 23661.7 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.4 seconds (effective 793.1 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.port            | 9426           |
| model.cellular.rts     | 19             |
| model.cellular.monarch | 1              |
| cellular.apn           | internet       |
| model.cellular.enabled | 1              |
| broker.host            | device.toit.io |
| model.cellular.rx      | 23             |
| model.cellular.cts     | 18             |
| model.cellular.pwr     | 27             |
| model.cellular.tx      | 5              |
| model                  | esp32-4mb      |
| broker.cn              | device.toit.io |
+------------------------+----------------+


$ toit serial info --output table
+-------------------------------------------------------------------------+-----------+--------------------------------------+
|                                  NAME                                   |   MODEL   |             HARDWARE ID              |
+-------------------------------------------------------------------------+-----------+--------------------------------------+
| a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com | esp32-4mb | a966ebf8-6407-4964-9685-95ac15170168 |
+-------------------------------------------------------------------------+-----------+--------------------------------------+


$ 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=a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015876) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020853) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.505340) [toit.state] INFO: starting new session {session_id: 1, session_time: 0.512517}
[gc @ 0x3ffcf9f0* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcf9f0* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.153ms]
(0.594769) [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.707394) [toit.console_sync] INFO: loaded last console sync {time: null}
(0.719350) [toit.scheduler] INFO: running job {job: console_sync}
(0.722248) [toit.scheduler] INFO: running job {job: flush_metrics}
(0.724427) [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.729347) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.758206) [toit.console] INFO: waiting for console connection to be established
(0.762572) [toit.network] DEBUG: connecting {network: Cellular (internet)}
(0.769879) [toit.metrics] INFO: persisting metrics
(0.773019) [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.118820) [toit] INFO: -> AT
(1.129494) [toit] INFO: <- OK
(1.234961) [toit] INFO: -> ATE0
(1.245067) [toit] INFO: <- OK
(1.267937) [toit] INFO: -> AT+CMEE=2
(1.274571) [toit] INFO: <- OK
[gc @ 0x3ffcf9f0* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 20 (heap)]
[gc @ 0x3ffcf9f0* | heap: 44kb -> 24kb | external: 0kb -> 0kb | free: 6kb->6kb 2.208ms]
(1.296989) [toit] INFO: -> AT+CGMM
(1.302835) [toit] INFO: <- FiPy
(1.306017) [toit] INFO: <- OK
(1.328190) [toit] INFO: -> AT+CGMR
(1.351067) [toit] INFO: <- UE5.4.0.2
(1.353748) [toit] INFO: <- OK
(1.375937) [toit] INFO: -> AT+SQNCCID?
(1.382166) [toit] INFO: <- +SQNCCID: "",""
(1.384860) [toit] INFO: <- OK
(1.391511) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(1.407912) [toit] INFO: -> AT+CFUN=4
(1.476827) [toit] INFO: <- OK
(1.499345) [toit] INFO: -> AT+CPIN?
(1.505782) [toit] INFO: <- +CME ERROR: SIM not inserted
(1.760390) [toit] INFO: -> AT+CPIN?
(1.766567) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.021109) [toit] INFO: -> AT+CPIN?
(2.095469) [toit] INFO: <- +CPIN: READY
(2.098198) [toit] INFO: <- OK
(2.120679) [toit] INFO: -> AT+CPSMS=0
(2.129065) [toit] INFO: <- OK
(2.151724) [toit] INFO: -> AT+CEDRXS=0
(2.159993) [toit] INFO: <- OK
(2.182659) [toit] INFO: -> AT+SQNIBRCFG=0
(2.204865) [toit] INFO: <- OK
(2.227720) [toit] INFO: -> AT+SQNIPSCFG=1,100
(2.247609) [toit] INFO: <- OK
(2.270474) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(2.347024) [toit] INFO: <- +SQNBANDSEL: <custom>
(2.349902) [toit] INFO: <- OK
(2.372743) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(2.381243) [toit] INFO: <- +CME ERROR: operation not supported
(2.403732) [toit] INFO: -> AT+CGDCONT?
(2.477988) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0,0,,0
(2.481155) [toit] INFO: <- OK
(2.503498) [toit] INFO: -> AT+CFUN=1
(2.579168) [toit] INFO: <- OK
�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=a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015876) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020853) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.060535) [toit.state] INFO: starting new session {session_id: 2, session_time: 0.068004}
[gc @ 0x3ffcf9f0* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcf9f0* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.041ms]
(0.078245) [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.118791) [toit.console_sync] INFO: loaded last console sync {time: null}
(0.132146) [toit.scheduler] INFO: running job {job: console_sync}
(0.135024) [toit.scheduler] INFO: running job {job: flush_metrics}
[gc @ 0x3ffcf9f0* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcf9f0* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.712ms]
(0.148467) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.154963) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.164876) [toit.console] INFO: waiting for console connection to be established
(0.169146) [toit.network] DEBUG: connecting {network: Cellular (internet)}
(0.176449) [toit.metrics] INFO: persisting metrics
(0.179596) [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.960ms]
(0.448970) [toit] INFO: -> AT
(0.712991) [toit] INFO: -> AT
(0.948590) [toit] INFO: <- *ignored* [URC] +SYSSTART []
(0.974067) [toit] INFO: -> AT
(1.234990) [toit] INFO: -> AT
(1.495721) [toit] INFO: -> AT
[gc @ 0x3ffcf9f0* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcf9f0* | heap: 44kb -> 24kb | external: 0kb -> 0kb | free: 6kb->6kb 2.293ms]
(1.759961) [toit] INFO: -> AT
(1.847048) [toit] INFO: <- OK
(1.951467) [toit] INFO: -> ATE0
(1.959174) [toit] INFO: <- OK
(1.982031) [toit] INFO: -> AT+CMEE=2
(1.987716) [toit] INFO: <- OK
(2.010430) [toit] INFO: -> AT+CGMM
(2.016034) [toit] INFO: <- FiPy
(2.019023) [toit] INFO: <- OK
(2.041248) [toit] INFO: -> AT+CGMR
(2.061956) [toit] INFO: <- UE5.4.0.2
(2.064861) [toit] INFO: <- OK
(2.087633) [toit] INFO: -> AT+SQNCCID?
(2.093448) [toit] INFO: <- +SQNCCID: "",""
(2.096166) [toit] INFO: <- OK
(2.103222) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.123102) [toit] INFO: -> AT+CFUN=4
(2.188814) [toit] INFO: <- OK
(2.211351) [toit] INFO: -> AT+CPIN?
(2.217117) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.471893) [toit] INFO: -> AT+CPIN?
(2.477734) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.732240) [toit] INFO: -> AT+CPIN?
(2.786673) [toit] INFO: <- +CPIN: READY
(2.789388) [toit] INFO: <- OK
(2.811859) [toit] INFO: -> AT+CPSMS=0
(2.819476) [toit] INFO: <- OK
(2.842339) [toit] INFO: -> AT+CEDRXS=0
(2.849869) [toit] INFO: <- OK
(2.872523) [toit] INFO: -> AT+SQNIBRCFG=0
(2.884742) [toit] INFO: <- OK
(2.907606) [toit] INFO: -> AT+SQNIPSCFG=1,100
(2.925038) [toit] INFO: <- OK
(2.948110) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.016895) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.019778) [toit] INFO: <- OK
(3.042413) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.050294) [toit] INFO: <- +CME ERROR: operation not supported
(3.072838) [toit] INFO: -> AT+CGDCONT?
(3.168070) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0,0,,0
(3.171241) [toit] INFO: <- OK
(3.193836) [toit] INFO: -> AT+CFUN=1
(3.616563) [toit] INFO: <- OK
[gc @ 0x3ffcf9f0* | soft limit reached (53276 >= 49194)]
[gc @ 0x3ffcf9f0* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.195ms]
(8.181400) [toit] INFO: -> AT+CFUN=4
(8.249924) [toit] INFO: <- OK
(8.252937) [toit.cellular] DEBUG: failed, detach from network
(8.270383) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(8.277251) [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
(8.361841) [toit] INFO: -> AT+CFUN=0
(8.368077) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.371797) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.373831) [toit.metrics] INFO: persisting metrics
[gc @ 0x3ffcf9f0* | soft limit reached (49624 >= 49194)]
[gc @ 0x3ffcf9f0* | byte array allocation failed, length = 68 (heap)]
[gc @ 0x3ffcf9f0* | heap: 48kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.411ms]
(8.879215) [toit] INFO: <- OK
(8.987389) [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=a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015873) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020850) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.052703) [toit.state] INFO: resumed session {session_id: 2, session_time: 14.102111}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.053ms]
(0.069943) [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.110139) [toit.console_sync] INFO: loaded last console sync {time: 8.353221}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.714ms]
(0.129389) [toit.scheduler] INFO: running job {job: console_sync}
(0.132382) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.138148) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.148016) [toit.console] INFO: waiting for console connection to be established
(0.152253) [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.922ms]
(0.194812) [toit] INFO: -> AT
(0.456217) [toit] INFO: -> AT
(0.717747) [toit] INFO: -> AT
(0.978438) [toit] INFO: -> AT
(1.239275) [toit] INFO: -> AT
(1.499988) [toit] INFO: -> AT
(1.760703) [toit] INFO: -> AT
(1.926615) [toit] INFO: <- OK
(2.032603) [toit] INFO: -> ATE0
(2.040459) [toit] INFO: <- OK
(2.063196) [toit] INFO: -> AT+CMEE=2
(2.069081) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.231ms]
(2.091612) [toit] INFO: -> AT+CGMM
(2.109057) [toit] INFO: <- FiPy
(2.111991) [toit] INFO: <- OK
(2.134229) [toit] INFO: -> AT+CGMR
(2.154789) [toit] INFO: <- UE5.4.0.2
(2.157722) [toit] INFO: <- OK
(2.179917) [toit] INFO: -> AT+SQNCCID?
(2.185553) [toit] INFO: <- +SQNCCID: "",""
(2.188256) [toit] INFO: <- OK
(2.190810) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.210735) [toit] INFO: -> AT+CFUN=4
(2.276186) [toit] INFO: <- OK
(2.306020) [toit] INFO: -> AT+CPIN?
(2.311811) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.566698) [toit] INFO: -> AT+CPIN?
(2.572485) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.827681) [toit] INFO: -> AT+CPIN?
(2.861472) [toit] INFO: <- +CPIN: READY
(2.864143) [toit] INFO: <- OK
(2.886630) [toit] INFO: -> AT+CPSMS=0
(2.894119) [toit] INFO: <- OK
(2.917038) [toit] INFO: -> AT+CEDRXS=0
(2.924686) [toit] INFO: <- OK
(2.947373) [toit] INFO: -> AT+SQNIBRCFG=0
(2.967272) [toit] INFO: <- OK
(2.990145) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.007724) [toit] INFO: <- OK
(3.030766) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.099804) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.102619) [toit] INFO: <- OK
(3.125252) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.133153) [toit] INFO: <- +CME ERROR: operation not supported
(3.155603) [toit] INFO: -> AT+CGDCONT?
(3.627582) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0,0,,0
(3.630839) [toit] INFO: <- OK
(3.653503) [toit] INFO: -> AT+CFUN=1
(3.725289) [toit] INFO: <- OK
(8.638292) [toit] INFO: -> AT+CFUN=4
(8.714445) [toit] INFO: <- OK
(8.717094) [toit.cellular] DEBUG: failed, detach from network
(8.730867) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(8.738524) [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 (53720 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.380ms]
(8.839018) [toit] INFO: -> AT+CFUN=0
(8.844883) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.848816) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.850849) [toit.metrics] INFO: persisting metrics
(9.338250) [toit] INFO: <- OK
(9.446245) [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=a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015873) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020850) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.052527) [toit.state] INFO: resumed session {session_id: 2, session_time: 28.597991}
[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.068ms]
(0.076337) [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.119887) [toit.console_sync] INFO: loaded last console sync {time: 22.867602}
(0.136082) [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.146334) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.153068) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.163080) [toit.console] INFO: waiting for console connection to be established
(0.167174) [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.210605) [toit] INFO: -> AT
(0.472005) [toit] INFO: -> AT
(0.732584) [toit] INFO: -> AT
(0.993282) [toit] INFO: -> AT
(1.254311) [toit] INFO: -> AT
(1.514877) [toit] INFO: -> AT
(1.775558) [toit] INFO: -> AT
(1.944443) [toit] INFO: <- OK
(2.050439) [toit] INFO: -> ATE0
(2.058297) [toit] INFO: <- OK
(2.080923) [toit] INFO: -> AT+CMEE=2
(2.086857) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | free: 10kb->10kb 2.147ms]
(2.114960) [toit] INFO: -> AT+CGMM
(2.120413) [toit] INFO: <- FiPy
(2.123378) [toit] INFO: <- OK
(2.145593) [toit] INFO: -> AT+CGMR
(2.166199) [toit] INFO: <- UE5.4.0.2
(2.168880) [toit] INFO: <- OK
(2.191115) [toit] INFO: -> AT+SQNCCID?
(2.196733) [toit] INFO: <- +SQNCCID: "",""
(2.199405) [toit] INFO: <- OK
(2.201986) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.221929) [toit] INFO: -> AT+CFUN=4
(2.287744) [toit] INFO: <- OK
(2.314776) [toit] INFO: -> AT+CPIN?
(2.320517) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.575435) [toit] INFO: -> AT+CPIN?
(2.581263) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.835803) [toit] INFO: -> AT+CPIN?
(2.879831) [toit] INFO: <- +CPIN: READY
(2.882487) [toit] INFO: <- OK
(2.904999) [toit] INFO: -> AT+CPSMS=0
(2.919432) [toit] INFO: <- OK
(2.942323) [toit] INFO: -> AT+CEDRXS=0
(2.950218) [toit] INFO: <- OK
(2.972920) [toit] INFO: -> AT+SQNIBRCFG=0
(2.992803) [toit] INFO: <- OK
(3.015781) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.035499) [toit] INFO: <- OK
(3.058413) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.127784) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.130571) [toit] INFO: <- OK
(3.153181) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.300993) [toit] INFO: <- +CME ERROR: operation not supported
(3.323485) [toit] INFO: -> AT+CGDCONT?
(3.329788) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0,0,,0
(3.332951) [toit] INFO: <- OK
(3.355414) [toit] INFO: -> AT+CFUN=1
(3.767027) [toit] INFO: <- OK
(8.339973) [toit] INFO: -> AT+CFUN=4
(8.423082) [toit] INFO: <- OK
(8.425884) [toit.cellular] DEBUG: failed, detach from network
(8.440324) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | string allocation failed, length = 30 (heap)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.209ms]
(8.462338) [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
(8.564279) [toit] INFO: -> AT+CFUN=0
(8.570357) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.574308) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.576348) [toit.metrics] INFO: persisting metrics
(9.347158) [toit] INFO: <- OK
(9.455196) [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=a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015873) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020850) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.052368) [toit.state] INFO: resumed session {session_id: 2, session_time: 43.100605}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.037ms]
(0.069015) [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.110307) [toit.console_sync] INFO: loaded last console sync {time: 37.087585}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 6 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.740ms]
(0.126630) [toit.scheduler] INFO: running job {job: console_sync}
(0.142624) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.149200) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.159177) [toit.console] INFO: waiting for console connection to be established
(0.163345) [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.894ms]
(0.207779) [toit] INFO: -> AT
(0.469180) [toit] INFO: -> AT
(0.729736) [toit] INFO: -> AT
(0.990424) [toit] INFO: -> AT
(1.251246) [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.259ms]
(1.516353) [toit] INFO: -> AT
(1.778009) [toit] INFO: -> AT
(1.942280) [toit] INFO: <- OK
(2.048268) [toit] INFO: -> ATE0
(2.056220) [toit] INFO: <- OK
(2.078891) [toit] INFO: -> AT+CMEE=2
(2.085069) [toit] INFO: <- OK
(2.107776) [toit] INFO: -> AT+CGMM
(2.113244) [toit] INFO: <- FiPy
(2.116175) [toit] INFO: <- OK
(2.138351) [toit] INFO: -> AT+CGMR
(2.158845) [toit] INFO: <- UE5.4.0.2
(2.161757) [toit] INFO: <- OK
(2.184015) [toit] INFO: -> AT+SQNCCID?
(2.189676) [toit] INFO: <- +SQNCCID: "",""
(2.192367) [toit] INFO: <- OK
(2.194912) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.214891) [toit] INFO: -> AT+CFUN=4
(2.280798) [toit] INFO: <- OK
(2.306032) [toit] INFO: -> AT+CPIN?
(2.311771) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.566426) [toit] INFO: -> AT+CPIN?
(2.572195) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.826681) [toit] INFO: -> AT+CPIN?
(2.860279) [toit] INFO: <- +CPIN: READY
(2.862951) [toit] INFO: <- OK
(2.885440) [toit] INFO: -> AT+CPSMS=0
(2.892831) [toit] INFO: <- OK
(2.915548) [toit] INFO: -> AT+CEDRXS=0
(2.923183) [toit] INFO: <- OK
(2.946068) [toit] INFO: -> AT+SQNIBRCFG=0
(2.966062) [toit] INFO: <- OK
(2.988950) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.006482) [toit] INFO: <- OK
(3.029547) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.098036) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.100854) [toit] INFO: <- OK
(3.123748) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.130895) [toit] INFO: <- +CME ERROR: operation not supported
(3.153182) [toit] INFO: -> AT+CGDCONT?
(3.209744) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0,0,,0
(3.212914) [toit] INFO: <- OK
(3.235418) [toit] INFO: -> AT+CFUN=1
(3.307122) [toit] INFO: <- OK
(8.219687) [toit] INFO: -> AT+CFUN=4
(8.443888) [toit] INFO: <- OK
(8.446691) [toit.cellular] DEBUG: failed, detach from network
(8.460326) [toit.network] DEBUG: error connecting {network: Cellular (internet), 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 | free: 10kb->10kb 2.258ms]
(8.480880) [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
(8.584553) [toit] INFO: -> AT+CFUN=0
(8.590632) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.594584) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.596717) [toit.metrics] INFO: persisting metrics
(8.993007) [toit] INFO: <- OK
(9.101903) [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=a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015873) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020849) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.052193) [toit.state] INFO: resumed session {session_id: 2, session_time: 57.252492}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.037ms]
(0.068839) [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.110386) [toit.console_sync] INFO: loaded last console sync {time: 51.612369}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.715ms]
(0.129969) [toit.scheduler] INFO: running job {job: console_sync}
(0.132957) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.138731) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.148614) [toit.console] INFO: waiting for console connection to be established
(0.152837) [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.197952) [toit] INFO: -> AT
(0.459343) [toit] INFO: -> AT
(0.719932) [toit] INFO: -> AT
(0.980632) [toit] INFO: -> AT
(1.241471) [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.261ms]
(1.502186) [toit] INFO: -> AT
(1.763034) [toit] INFO: -> AT
(1.934716) [toit] INFO: <- OK
(2.040718) [toit] INFO: -> ATE0
(2.048571) [toit] INFO: <- OK
(2.071225) [toit] INFO: -> AT+CMEE=2
(2.077410) [toit] INFO: <- OK
(2.105994) [toit] INFO: -> AT+CGMM
(2.111526) [toit] INFO: <- FiPy
(2.114456) [toit] INFO: <- OK
(2.136655) [toit] INFO: -> AT+CGMR
(2.157087) [toit] INFO: <- UE5.4.0.2
(2.160011) [toit] INFO: <- OK
(2.182260) [toit] INFO: -> AT+SQNCCID?
(2.187860) [toit] INFO: <- +SQNCCID: "",""
(2.190562) [toit] INFO: <- OK
(2.193104) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.213067) [toit] INFO: -> AT+CFUN=4
(2.278803) [toit] INFO: <- OK
(2.306037) [toit] INFO: -> AT+CPIN?
(2.311853) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.566510) [toit] INFO: -> AT+CPIN?
(2.572367) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.827697) [toit] INFO: -> AT+CPIN?
(2.874860) [toit] INFO: <- +CPIN: READY
(2.877544) [toit] INFO: <- OK
(2.906354) [toit] INFO: -> AT+CPSMS=0
(2.913915) [toit] INFO: <- OK
(2.936536) [toit] INFO: -> AT+CEDRXS=0
(2.944190) [toit] INFO: <- OK
(2.967076) [toit] INFO: -> AT+SQNIBRCFG=0
(2.987126) [toit] INFO: <- OK
(3.010101) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.030804) [toit] INFO: <- OK
(3.053686) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.123215) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.125994) [toit] INFO: <- OK
(3.148623) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.212266) [toit] INFO: <- +CME ERROR: operation not supported
(3.234515) [toit] INFO: -> AT+CGDCONT?
(3.240801) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0,0,,0
(3.243971) [toit] INFO: <- OK
(3.266498) [toit] INFO: -> AT+CFUN=1
(3.337694) [toit] INFO: <- OK
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=a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015876) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020853) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.060539) [toit.state] INFO: starting new session {session_id: 3, session_time: 0.068028}
[gc @ 0x3ffcf9f0* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcf9f0* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 0.976ms]
(0.078130) [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.120143) [toit.console_sync] INFO: loaded last console sync {time: null}
[gc @ 0x3ffcf9f0* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcf9f0* | string allocation failed, length = 6 (heap)]
[gc @ 0x3ffcf9f0* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.723ms]
(0.133855) [toit.scheduler] INFO: running job {job: console_sync}
(0.149342) [toit.scheduler] INFO: running job {job: flush_metrics}
(0.155055) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.161838) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.171749) [toit.console] INFO: waiting for console connection to be established
(0.176057) [toit.network] DEBUG: connecting {network: Cellular (internet)}
(0.183336) [toit.metrics] INFO: persisting metrics
(0.186511) [toit.metrics] INFO: flushing metrics
[gc @ 0x3ffcf9f0* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcf9f0* | heap: 36kb -> 20kb | external: 0kb -> 0kb | free: 12kb->12kb 1.979ms]
[gc @ 0x3ffcf9f0* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcf9f0* | heap: 44kb -> 20kb | external: 0kb -> 0kb | free: 6kb->6kb 2.095ms]
(0.407676) [toit] INFO: -> AT
(0.413916) [toit] INFO: <- OK
(0.518979) [toit] INFO: -> ATE0
(0.524737) [toit] INFO: <- OK
(0.547896) [toit] INFO: -> AT+CMEE=2
(0.553514) [toit] INFO: <- OK
(0.575993) [toit] INFO: -> AT+CGMM
(0.581363) [toit] INFO: <- FiPy
(0.584297) [toit] INFO: <- OK
(0.606492) [toit] INFO: -> AT+CGMR
(0.611320) [toit] INFO: <- UE5.4.0.2
(0.614236) [toit] INFO: <- OK
(0.636491) [toit] INFO: -> AT+SQNCCID?
(0.642078) [toit] INFO: <- +SQNCCID: "89450100200903189690",""
(0.644794) [toit] INFO: <- OK
(0.647356) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: 89450100200903189690}
(0.667894) [toit] INFO: -> AT+CFUN=4
(0.738437) [toit] INFO: <- OK
(0.762937) [toit] INFO: -> AT+CPIN?
(0.768793) [toit] INFO: <- +CPIN: READY
(0.771409) [toit] INFO: <- OK
(0.793883) [toit] INFO: -> AT+CPSMS=0
(0.801248) [toit] INFO: <- OK
(0.823990) [toit] INFO: -> AT+CEDRXS=0
(0.831885) [toit] INFO: <- OK
(0.854604) [toit] INFO: -> AT+SQNIBRCFG=0
(0.866617) [toit] INFO: <- OK
(0.889534) [toit] INFO: -> AT+SQNIPSCFG=1,100
(0.906292) [toit] INFO: <- OK
(0.929214) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(0.994613) [toit] INFO: <- +SQNBANDSEL: <custom>
(0.997844) [toit] INFO: <- OK
[gc @ 0x3ffcf9f0* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcf9f0* | string allocation failed, length = 17 (heap)]
[gc @ 0x3ffcf9f0* | heap: 44kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.252ms]
(1.029266) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(1.040013) [toit] INFO: <- +CME ERROR: operation not supported
(1.062911) [toit] INFO: -> AT+CGDCONT?
(1.070004) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0,0,,0
(1.072846) [toit] INFO: <- OK
(1.095330) [toit] INFO: -> AT+CFUN=1
(1.170966) [toit] INFO: <- OK
(6.080414) [toit] INFO: -> AT+CFUN=4
(6.618848) [toit] INFO: <- OK
(6.621496) [toit.cellular] DEBUG: failed, detach from network
(6.640933) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(6.647802) [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
(6.742918) [toit] INFO: -> AT+CFUN=0
(6.748893) [toit.scheduler] INFO: changing run level {run_level: 0}
(6.752594) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
[gc @ 0x3ffcf9f0* | soft limit reached (49624 >= 49194)]
[gc @ 0x3ffcf9f0* | heap: 48kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.477ms]
(6.754623) [toit.metrics] INFO: persisting metrics
(7.039696) [toit] INFO: <- OK
(7.147637) [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=a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015873) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020849) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.052440) [toit.state] INFO: resumed session {session_id: 3, session_time: 12.270944}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.038ms]
(0.069130) [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.110542) [toit.console_sync] INFO: loaded last console sync {time: 6.742085}
(0.126911) [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.730ms]
(0.137524) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.143871) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.153804) [toit.console] INFO: waiting for console connection to be established
(0.157995) [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.908ms]
(0.200310) [toit] INFO: -> AT
(0.461707) [toit] INFO: -> AT
(0.722282) [toit] INFO: -> AT
(0.982980) [toit] INFO: -> AT
(1.243819) [toit] INFO: -> AT
(1.504534) [toit] INFO: -> AT
(1.765243) [toit] INFO: -> AT
(1.941952) [toit] INFO: <- OK
(2.048142) [toit] INFO: -> ATE0
(2.055996) [toit] INFO: <- OK
(2.078748) [toit] INFO: -> AT+CMEE=2
(2.084692) [toit] INFO: <- OK
[gc @ 0x3ffcfa58* | soft limit reached (45084 >= 43050)]
[gc @ 0x3ffcfa58* | heap: 44kb -> 20kb | external: 0kb -> 0kb | free: 10kb->10kb 2.228ms]
(2.107525) [toit] INFO: -> AT+CGMM
(2.117247) [toit] INFO: <- FiPy
(2.120181) [toit] INFO: <- OK
(2.142426) [toit] INFO: -> AT+CGMR
(2.163388) [toit] INFO: <- UE5.4.0.2
(2.166313) [toit] INFO: <- OK
(2.188518) [toit] INFO: -> AT+SQNCCID?
(2.194123) [toit] INFO: <- +SQNCCID: "",""
(2.196832) [toit] INFO: <- OK
(2.199417) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.219371) [toit] INFO: -> AT+CFUN=4
(2.285309) [toit] INFO: <- OK
(2.307817) [toit] INFO: -> AT+CPIN?
(2.313582) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.568245) [toit] INFO: -> AT+CPIN?
(2.574029) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.828570) [toit] INFO: -> AT+CPIN?
(2.880134) [toit] INFO: <- +CPIN: READY
(2.882805) [toit] INFO: <- OK
(2.906305) [toit] INFO: -> AT+CPSMS=0
(2.913717) [toit] INFO: <- OK
(2.936438) [toit] INFO: -> AT+CEDRXS=0
(2.944050) [toit] INFO: <- OK
(2.966933) [toit] INFO: -> AT+SQNIBRCFG=0
(2.987125) [toit] INFO: <- OK
(3.010081) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.027807) [toit] INFO: <- OK
(3.050684) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.119382) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.122173) [toit] INFO: <- OK
(3.144752) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.151617) [toit] INFO: <- +CME ERROR: operation not supported
(3.173844) [toit] INFO: -> AT+CGDCONT?
(3.722575) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0,0,,0
(3.725750) [toit] INFO: <- OK
(3.748247) [toit] INFO: -> AT+CFUN=1
(3.820284) [toit] INFO: <- OK
(8.732887) [toit] INFO: -> AT+CFUN=4
(9.169443) [toit] INFO: <- OK
(9.172284) [toit.cellular] DEBUG: failed, detach from network
(9.190330) [toit.network] DEBUG: error connecting {network: Cellular (internet), 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 | free: 10kb->10kb 2.232ms]
(9.215701) [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
(9.314382) [toit] INFO: -> AT+CFUN=0
(9.320468) [toit.scheduler] INFO: changing run level {run_level: 0}
(9.324197) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(9.326238) [toit.metrics] INFO: persisting metrics
(9.664051) [toit] INFO: <- OK
(9.772029) [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=a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015869) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020846) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.052258) [toit.state] INFO: resumed session {session_id: 3, session_time: 27.091359}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.030ms]
(0.069011) [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.112375) [toit.console_sync] INFO: loaded last console sync {time: 21.510812}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 12kb->12kb 1.711ms]
(0.131916) [toit.scheduler] INFO: running job {job: console_sync}
(0.135890) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.142482) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.152346) [toit.console] INFO: waiting for console connection to be established
(0.156619) [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.932ms]
(0.199738) [toit] INFO: -> AT
(0.461139) [toit] INFO: -> AT
(0.721721) [toit] INFO: -> AT
(0.982420) [toit] INFO: -> AT
(1.243440) [toit] INFO: -> AT
(1.503973) [toit] INFO: -> AT
(1.764679) [toit] INFO: -> AT
(1.933778) [toit] INFO: <- OK
(2.039772) [toit] INFO: -> ATE0
(2.047714) [toit] INFO: <- OK
(2.070340) [toit] INFO: -> AT+CMEE=2
(2.076260) [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 | free: 10kb->10kb 2.133ms]
(2.098789) [toit] INFO: -> AT+CGMM
(2.104242) [toit] INFO: <- FiPy
(2.107496) [toit] INFO: <- OK
(2.129675) [toit] INFO: -> AT+CGMR
(2.150145) [toit] INFO: <- UE5.4.0.2
(2.152838) [toit] INFO: <- OK
(2.175065) [toit] INFO: -> AT+SQNCCID?
(2.180729) [toit] INFO: <- +SQNCCID: "",""
(2.183431) [toit] INFO: <- OK
(2.185989) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.206266) [toit] INFO: -> AT+CFUN=4
(2.272134) [toit] INFO: <- OK
(2.294917) [toit] INFO: -> AT+CPIN?
(2.306316) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.561092) [toit] INFO: -> AT+CPIN?
(2.567209) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.821804) [toit] INFO: -> AT+CPIN?
(2.849350) [toit] INFO: <- +CPIN: READY
(2.852077) [toit] INFO: <- OK
(2.874474) [toit] INFO: -> AT+CPSMS=0
(2.881949) [toit] INFO: <- OK
(2.904798) [toit] INFO: -> AT+CEDRXS=0
(2.912368) [toit] INFO: <- OK
(2.935055) [toit] INFO: -> AT+SQNIBRCFG=0
(2.954968) [toit] INFO: <- OK
(2.977975) [toit] INFO: -> AT+SQNIPSCFG=1,100
(2.995298) [toit] INFO: <- OK
(3.026836) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.095408) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.106837) [toit] INFO: <- OK
(3.129477) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.136396) [toit] INFO: <- +CME ERROR: operation not supported
(3.158645) [toit] INFO: -> AT+CGDCONT?
(3.213622) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0,0,,0
(3.216746) [toit] INFO: <- OK
(3.239270) [toit] INFO: -> AT+CFUN=1
(3.310668) [toit] INFO: <- OK
(8.223836) [toit] INFO: -> AT+CFUN=4
(8.306506) [toit] INFO: <- OK
(8.309312) [toit.cellular] DEBUG: failed, detach from network
(8.320318) [toit.network] DEBUG: error connecting {network: Cellular (internet), error: DEADLINE_EXCEEDED}
(8.328091) [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 (53720 >= 49194)]
[gc @ 0x3ffcfa58* | heap: 52kb -> 24kb | external: 0kb -> 0kb | free: 10kb->10kb 2.396ms]
(8.437988) [toit] INFO: -> AT+CFUN=0
(8.444043) [toit.scheduler] INFO: changing run level {run_level: 0}
(8.448053) [toit.scheduler] INFO: going into deep sleep {ms: 4989}
(8.450098) [toit.metrics] INFO: persisting metrics
(8.925402) [toit] INFO: <- OK
(9.033494) [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=a966ebf8-6407-4964-9685-95ac15170168.743.2021-09-26.device.toitware.com,model=esp32-4mb
(0.015870) [toit] INFO: booting toit {sdk: v1.5.0-rc.1, model: esp32-4mb}
(0.020847) [toit.scheduler] INFO: set initial run_level {run_level: 4}
(0.053298) [toit.state] INFO: resumed session {session_id: 3, session_time: 41.176115}
[gc @ 0x3ffcfa58* | soft limit reached (20480 >= 18432)]
[gc @ 0x3ffcfa58* | heap: 20kb -> 8kb | external: 0kb -> 0kb | free: 9kb->9kb 1.031ms]
(0.070847) [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.110720) [toit.console_sync] INFO: loaded last console sync {time: 35.456962}
[gc @ 0x3ffcfa58* | soft limit reached (24576 >= 24576)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 24kb -> 16kb | external: 0kb -> 0kb | free: 8kb->8kb 1.640ms]
(0.136926) [toit.scheduler] INFO: running job {job: console_sync}
(0.139979) [toit.scheduler] INFO: running job {job: poll_metric_flash_usage}
(0.144054) [toit.scheduler] INFO: running job {job: poll_metric_memory_profile}
(0.153735) [toit.console] INFO: waiting for console connection to be established
(0.157955) [toit.network] DEBUG: connecting {network: Cellular (internet)}
[gc @ 0x3ffcfa58* | soft limit reached (36892 >= 36864)]
[gc @ 0x3ffcfa58* | byte array allocation failed, length = 511 (heap)]
[gc @ 0x3ffcfa58* | heap: 36kb -> 20kb | external: 0kb -> 0kb | free: 12kb->12kb 1.947ms]
(0.207868) [toit] INFO: -> AT
(0.469268) [toit] INFO: -> AT
(0.729848) [toit] INFO: -> AT
(0.990549) [toit] INFO: -> AT
(1.251387) [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.263ms]
(1.516369) [toit] INFO: -> AT
(1.778005) [toit] INFO: -> AT
(1.943800) [toit] INFO: <- OK
(2.049802) [toit] INFO: -> ATE0
(2.057664) [toit] INFO: <- OK
(2.080549) [toit] INFO: -> AT+CMEE=2
(2.086496) [toit] INFO: <- OK
(2.108988) [toit] INFO: -> AT+CGMM
(2.114439) [toit] INFO: <- FiPy
(2.117400) [toit] INFO: <- OK
(2.139535) [toit] INFO: -> AT+CGMR
(2.160028) [toit] INFO: <- UE5.4.0.2
(2.162933) [toit] INFO: <- OK
(2.185159) [toit] INFO: -> AT+SQNCCID?
(2.190798) [toit] INFO: <- +SQNCCID: "",""
(2.193504) [toit] INFO: <- OK
(2.196042) [toit.cellular] DEBUG: initialized {model: FiPy, version: UE5.4.0.2, iccid: }
(2.216025) [toit] INFO: -> AT+CFUN=4
(2.281906) [toit] INFO: <- OK
(2.306037) [toit] INFO: -> AT+CPIN?
(2.311832) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.566684) [toit] INFO: -> AT+CPIN?
(2.572753) [toit] INFO: <- +CME ERROR: SIM not inserted
(2.827693) [toit] INFO: -> AT+CPIN?
(2.859756) [toit] INFO: <- +CPIN: READY
(2.862423) [toit] INFO: <- OK
(2.884922) [toit] INFO: -> AT+CPSMS=0
(2.892359) [toit] INFO: <- OK
(2.915265) [toit] INFO: -> AT+CEDRXS=0
(2.922916) [toit] INFO: <- OK
(2.945609) [toit] INFO: -> AT+SQNIBRCFG=0
(2.965571) [toit] INFO: <- OK
(2.988470) [toit] INFO: -> AT+SQNIPSCFG=1,100
(3.005904) [toit] INFO: <- OK
(3.028963) [toit] INFO: -> AT+SQNBANDSEL=0,"standard","20"
(3.098907) [toit] INFO: <- +SQNBANDSEL: <custom>
(3.101720) [toit] INFO: <- OK
(3.124634) [toit] INFO: -> AT+SQNBANDSEL=1,"standard","20"
(3.132471) [toit] INFO: <- +CME ERROR: operation not supported
(3.155007) [toit] INFO: -> AT+CGDCONT?
(3.293736) [toit] INFO: <- +CGDCONT: 1,"IP","internet",,,,0,0,0,0,0,0,0,,0
(3.305522) [toit] INFO: <- OK
(3.328082) [toit] INFO: -> AT+CFUN=1
(3.715760) [toit] INFO: <- OK