--- idf_monitor on /dev/cu.usbserial-0200D385 115200 ---
--- Quit: Ctrl+] | Menu: Ctrl+T | Help: Ctrl+T followed by Ctrl+H ---
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:4
load:0x3fff0034,len:7080
load:0x40078000,len:13964
load:0x40080400,len:4816
0x40080400: _init at ??:?
entry 0x400806f4
I (29) boot: ESP-IDF v4.2-rc-5-g511965b26 2nd stage bootloader
I (29) boot: compile time 15:51:14
I (29) boot: chip revision: 1
I (33) boot_comm: chip revision: 1, min. bootloader chip revision: 0
I (40) boot.esp32: SPI Speed : 40MHz
I (45) boot.esp32: SPI Mode : DIO
I (49) boot.esp32: SPI Flash Size : 4MB
I (54) boot: Enabling RNG early entropy source...
I (59) boot: Partition Table:
I (63) boot: ## Label Usage Type ST Offset Length
I (70) boot: 0 nvs WiFi data 01 02 00009000 00006000
I (78) boot: 1 phy_init RF data 01 01 0000f000 00001000
I (85) boot: 2 factory factory app 00 00 00010000 00200000
I (93) boot: 3 vfs Unknown data 01 81 00210000 001f0000
I (100) boot: End of partition table
I (104) boot_comm: chip revision: 1, min. application chip revision: 0
I (111) esp_image: segment 0: paddr=0x00010020 vaddr=0x3f400020 size=0x25b10 (154384) map
I (187) esp_image: segment 1: paddr=0x00035b38 vaddr=0x3ffb0000 size=0x03b6c ( 15212) load
I (195) esp_image: segment 2: paddr=0x000396ac vaddr=0x40080000 size=0x00404 ( 1028) load
0x40080000: _WindowOverflow4 at /Users/xeijin/esp-idf/components/freertos/xtensa/xtensa_vectors.S:1730
I (195) esp_image: segment 3: paddr=0x00039ab8 vaddr=0x40080404 size=0x06560 ( 25952) load
I (216) esp_image: segment 4: paddr=0x00040020 vaddr=0x400d0020 size=0xa28e4 (665828) map
0x400d0020: _stext at ??:?
I (504) esp_image: segment 5: paddr=0x000e290c vaddr=0x40086964 size=0x0df38 ( 57144) load
0x40086964: wifi_bt_common_module_enable at /Users/xeijin/esp-idf/components/driver/periph_ctrl.c:55
I (532) esp_image: segment 6: paddr=0x000f084c vaddr=0x400c0000 size=0x0006c ( 108) load
I (544) boot: Loaded app from partition at offset 0x10000
I (545) boot: Disabling RNG early entropy source...
I (546) psram: This chip is ESP32-D0WD
I (551) spiram: Found 64MBit SPI RAM device
I (554) spiram: SPI RAM mode: flash 40m sram 40m
I (559) spiram: PSRAM initialized, cache is in low/high (2-core) mode.
I (567) cpu_start: Pro cpu up.
I (570) cpu_start: Application information:
I (575) cpu_start: Project name: cale-epd
I (580) cpu_start: App version: b2c7997
I (585) cpu_start: Compile time: Nov 28 2020 18:47:34
I (591) cpu_start: ELF file SHA256: aeff39f7f2bfb6e3...
I (597) cpu_start: ESP-IDF: v4.2-rc-5-g511965b26
I (603) cpu_start: Starting app cpu, entry point is 0x40081e98
0x40081e98: call_start_cpu1 at /Users/xeijin/esp-idf/components/esp32/cpu_start.c:287
I (0) cpu_start: App cpu up.
I (1495) spiram: SPI SRAM memory test OK
I (1497) heap_init: Initializing. RAM available for dynamic allocation:
I (1497) heap_init: At 3FFAE6E0 len 00001920 (6 KiB): DRAM
I (1502) heap_init: At 3FFDC058 len 00003FA8 (15 KiB): DRAM
I (1508) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM
I (1515) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
I (1521) heap_init: At 4009489C len 0000B764 (45 KiB): IRAM
I (1527) cpu_start: Pro cpu start user code
I (1532) spiram: Adding pool of 4082K of external SPI memory to heap allocator
CalEPD component version 1.0
Wave12I48() constructor injects IO and extends Adafruit_GFX(1304,984) Pix Buffer[160392]
Available heap after Epd bootstrap:4194000
I (1559) spi_flash: detected chip: generic
I (1563) spi_flash: flash io: dio
I (1567) cpu_start: Starting scheduler on PRO CPU.
I (0) cpu_start: Starting scheduler on APP CPU.
I (1577) spiram: Reserving pool of 32K of internal memory for DMA/internal allocations
CalEPD version: 1.0
I (1677) CALE: ESP_WIFI_MODE_STA
I (1697) wifi:wifi driver task: 3ffe8044, prio:23, stack:6656, core=0
I (1697) system_api: Base MAC address is not set
I (1697) system_api: read default base MAC address from EFUSE
I (1747) wifi:wifi firmware version: 1865b55
I (1747) wifi:wifi certification version: v7.0
I (1747) wifi:config NVS flash: enabled
I (1747) wifi:config nano formating: disabled
I (1747) wifi:Init data frame dynamic rx buffer num: 16
I (1757) wifi:Init management frame dynamic rx buffer num: 16
I (1757) wifi:Init management short buffer num: 32
I (1767) wifi:Init static tx buffer num: 16
I (1767) wifi:Init tx cache buffer num: 32
I (1777) wifi:Init static rx buffer size: 1600
I (1777) wifi:Init static rx buffer num: 10
I (1777) wifi:Init dynamic rx buffer num: 16
I (1787) wifi_init: rx ba win: 16
I (1787) wifi_init: tcpip mbox: 32
I (1797) wifi_init: udp mbox: 6
I (1797) wifi_init: tcp mbox: 6
I (1797) wifi_init: tcp tx win: 5744
I (1807) wifi_init: tcp rx win: 5744
I (1807) wifi_init: tcp mss: 1440
I (1937) phy: phy_version: 4500, 0cd6843, Sep 17 2020, 15:37:07, 0, 0
I (1937) wifi:mode : sta (c4:4f:33:57:6d:49)
I (1937) CALE: wifi_init_sta finished.
I (2057) wifi:new:<1,0>, old:<1,0>, ap:<255,255>, sta:<1,0>, prof:1
I (2067) wifi:state: init -> auth (b0)
I (2077) wifi:state: auth -> assoc (0)
I (2077) wifi:state: assoc -> run (10)
I (2107) wifi:connected with MY-NET, aid = 21, channel 1, BW20, bssid = 7c:4c:a5:aa:89:f1
I (2107) wifi:security: WPA2-PSK, phy: bgn, rssi: -59
I (2117) wifi:pm start, type: 1
I (2157) wifi:AP's beacon interval = 102400 us, DTIM period = 1
I (2677) esp_netif_handlers: sta ip: 10.10.100.183, mask: 255.255.255.0, gw: 10.10.100.1
I (2687) CALE: got ip: 10.10.100.183
I (2687) CALE: connected to ap SSID:MY-WLAN password:********
PIN SETUP:
SPI_M1_CS:23 <- all set as output GPIOs
SPI_S1_CS:22
SPI_M2_CS:26
SPI_S2_CS:19
SPI_M1_BUSY:32 <- all set as input,pullup GPIOs
SPI_S1_BUSY:21
SPI_M2_BUSY:18
SPI_S2_BUSY:4
M1S1_DC:25 <- all set as output GPIOs
M2S2_DC:27
M1S1_RST:33
M2S2_RST:5
Available heap after Epd init:4185952
Free heap: 4185952 (After epaper instantiation)
DRAM : 4187268
POST data: ip=10.10.100.183
Bearer:
I (2937) CALE: HTTP_EVENT_ON_CONNECTED
I (2947) CALE: HTTP_EVENT_HEADER_SENT
I (5047) CALE: HTTP_EVENT_ON_HEADER, key=Date, value=Sat, 28 Nov 2020 18:48:04 GMT
I (5057) CALE: HTTP_EVENT_ON_HEADER, key=Server, value=Apache/2.4.46 (Amazon) OpenSSL/1.0.2k-fips PHP/7.2.34
I (5057) CALE: HTTP_EVENT_ON_HEADER, key=Vary, value=Authorization
I (5067) CALE: HTTP_EVENT_ON_HEADER, key=X-Powered-By, value=PHP/7.2.34
I (5077) CALE: HTTP_EVENT_ON_HEADER, key=Cache-Control, value=no-cache, private, max-age=172800
I (5087) CALE: HTTP_EVENT_ON_HEADER, key=Content-Length, value=161438
I (5087) CALE: HTTP_EVENT_ON_HEADER, key=Expires, value=Mon, 30 Nov 2020 18:48:04 GMT
I (5097) CALE: HTTP_EVENT_ON_HEADER, key=Connection, value=keep-alive
I (5107) CALE: HTTP_EVENT_ON_HEADER, key=Content-Type, value=image/bmp
I (5117) CALE: BMP HEADERS
filesize:161438
offset:62
W:1304
H:984
planes:1
depth:1
format:0
I (5127) CALE: BMP isPaddingAware: 1 bit depth are 4 bit padded. Wikipedia gave me a lesson.
Offset comes in first DATA callback. bPointer: 62 == bmp.imageOffset
I (5457) CALE: 10 len:1024
I (5827) CALE: 20 len:1024
I (6167) CALE: 30 len:1024
I (6527) CALE: 40 len:1024
I (6887) CALE: 50 len:1024
I (7247) CALE: 60 len:1024
I (7617) CALE: 70 len:1024
I (7977) CALE: 80 len:1024
I (8337) CALE: 90 len:1024
I (8697) CALE: 100 len:1024
I (9067) CALE: 110 len:1024
I (9437) CALE: 120 len:1024
I (9807) CALE: 130 len:1024
I (10167) CALE: 140 len:1024
I (10517) CALE: 150 len:1024
I (10877) CALE: HTTP_EVENT_ON_FINISH
Download took: 5763 ms
Refresh and go to sleep 60 minutes
Resolution setting
Sending a buffer[160392] via SPI
Available heap after Epd update: 4182592 bytes
STATS (ms)
888 _wakeUp settings+send Buffer
696 _powerOn
1584 total time in millis