Files
Keyboard_lights_2/build/log/idf_py_stdout_output_6640
2025-05-22 16:26:07 +10:00

617 lines
39 KiB
Plaintext
Raw Blame History

This file contains invisible Unicode characters
This file contains invisible Unicode characters that are indistinguishable to humans but may be processed differently by a computer. If you think that this is intentional, you can safely ignore this warning. Use the Escape button to reveal them.
<EFBFBD><EFBFBD><EFBFBD><EFBFBD> <20>ESP-ROM:esp32s3-20210327
Build:Mar 27 2021
rst:0x1 (POWERON),boot:0x8 (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fce2810,len:0x15a0
load:0x403c8700,len:0x4
load:0x403c8704,len:0xd20
load:0x403cb700,len:0x2f00
entry 0x403c8928
I (27) boot: ESP-IDF v5.4.1 2nd stage bootloader
I (27) boot: compile time May 21 2025 14:32:48
I (27) boot: Multicore bootloader
I (27) boot: chip revision: v0.2
I (30) boot: efuse block revision: v1.3
I (33) boot.esp32s3: Boot SPI Speed : 80MHz
I (37) boot.esp32s3: SPI Mode : DIO
I (41) boot.esp32s3: SPI Flash Size : 2MB
I (45) boot: Enabling RNG early entropy source...
I (49) boot: Partition Table:
I (52) boot: ## Label Usage Type ST Offset Length
I (58) boot: 0 nvs WiFi data 01 02 00009000 00006000
I (65) boot: 1 phy_init RF data 01 01 0000f000 00001000
I (71) boot: 2 factory factory app 00 00 00010000 00100000
I (78) boot: End of partition table
I (81) esp_image: segment 0: paddr=00010020 vaddr=3c0c0020 size=24aa4h (150180) map
I (115) esp_image: segment 1: paddr=00034acc vaddr=3fc9bb00 size=04a84h ( 19076) load
I (119) esp_image: segment 2: paddr=00039558 vaddr=40374000 size=06ac0h ( 27328) load
I (125) esp_image: segment 3: paddr=00040020 vaddr=42000020 size=b17a4h (726948) map
I (254) esp_image: segment 4: paddr=000f17cc vaddr=4037aac0 size=10f68h ( 69480) load
I (270) esp_image: segment 5: paddr=0010273c vaddr=50000000 size=00018h ( 24) load
I (270) esp_image: segment 6: paddr=0010275c vaddr=600fe000 size=00100h ( 256) load
I (274) esp_image: segment 7: paddr=00102864 vaddr=600fe100 size=00020h ( 32) load
I (290) boot: Loaded app from partition at offset 0x10000
I (291) boot: Disabling RNG early entropy source...
I (303) cpu_start: Multicore app
I (312) cpu_start: Pro cpu start user code
I (312) cpu_start: cpu freq: 160000000 Hz
I (312) app_init: Application information:
I (312) app_init: Project name: Keyboard_lights_2
I (317) app_init: App version: 40f8561
I (321) app_init: Compile time: May 21 2025 14:27:23
I (326) app_init: ELF file SHA256: fe82ff3f6...
I (330) app_init: ESP-IDF: v5.4.1
I (334) efuse_init: Min chip rev: v0.0
I (338) efuse_init: Max chip rev: v0.99 
I (342) efuse_init: Chip rev: v0.2
I (345) heap_init: Initializing. RAM available for dynamic allocation:
I (352) heap_init: At 3FCA4980 len 00044D90 (275 KiB): RAM
I (357) heap_init: At 3FCE9710 len 00005724 (21 KiB): RAM
I (362) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM
I (367) heap_init: At 600FE120 len 00001EC8 (7 KiB): RTCRAM
I (374) spi_flash: detected chip: generic
I (376) spi_flash: flash io: dio
W (379) spi_flash: Detected size(16384k) larger than the size in the binary image header(2048k). Using the size in the binary image header.
I (392) sleep_gpio: Configure to isolate all GPIO pins in sleep state
I (398) sleep_gpio: Enable automatic switching of GPIO sleep configuration
I (405) main_task: Started on CPU0
I (425) main_task: Calling app_main()
I (445) hid_mqtt_light: Fresh boot or invalid RTC data. Initializing defaults.
I (445) hid_mqtt_light: Initial/Restored state: Target 0 (sam_bed), Mode Brightness
I (455) hid_mqtt_light: Light 0 (sam_bed): On=0, Bright=5, HueIdx=0
I (455) hid_mqtt_light: Light 1 (jo_bed): On=0, Bright=5, HueIdx=0
I (465) hid_mqtt_light: Light 2 (main_light): On=0, Bright=5, HueIdx=0
I (475) pp: pp rom version: e7ae62f
I (475) net80211: net80211 rom version: e7ae62f
I (485) wifi:wifi driver task: 3fcaf48c, prio:23, stack:6656, core=0
I (495) wifi:wifi firmware version: 79fa3f41ba
I (495) wifi:wifi certification version: v7.0
I (495) wifi:config NVS flash: enabled
I (495) wifi:config nano formatting: disabled
I (505) wifi:Init data frame dynamic rx buffer num: 32
I (505) wifi:Init static rx mgmt buffer num: 5
I (515) wifi:Init management short buffer num: 32
I (515) wifi:Init dynamic tx buffer num: 32
I (515) wifi:Init static tx FG buffer num: 2
I (525) wifi:Init static rx buffer size: 1600
I (525) wifi:Init static rx buffer num: 10
I (535) wifi:Init dynamic rx buffer num: 32
I (535) wifi_init: rx ba win: 6
I (535) wifi_init: accept mbox: 6
I (545) wifi_init: tcpip mbox: 32
I (545) wifi_init: udp mbox: 6
I (545) wifi_init: tcp mbox: 6
I (545) wifi_init: tcp tx win: 5760
I (555) wifi_init: tcp rx win: 5760
I (555) wifi_init: tcp mss: 1440
I (555) wifi_init: WiFi IRAM OP enabled
I (565) wifi_init: WiFi RX IRAM OP enabled
W (565) wifi:Password length matches WPA2 standards, authmode threshold changes from OPEN to WPA2
I (575) phy_init: phy_version 700,8582a7fd,Feb 10 2025,20:13:11
I (615) phy_init: Saving new calibration data due to checksum failure or outdated calibration data, mode(0)
I (645) wifi:mode : sta (98:a3:16:e2:6c:54)
I (645) wifi:enable tsf
I (645) hid_mqtt_light: wifi_init_sta finished. Connecting to AP...
I (645) hid_mqtt_light: WIFI_EVENT_STA_START, connecting...
I (655) hid_mqtt_light: Installing USB Host...
I (655) wifi:new:<6,0>, old:<1,0>, ap:<255,255>, sta:<6,0>, prof:1, snd_ch_cfg:0x0
I (665) wifi:state: init -> auth (0xb0)
I (675) wifi:state: auth -> assoc (0x0)
I (675) wifi:state: assoc -> run (0x10)
I (685) hid_mqtt_light: USB Host installed.
I (685) hid_mqtt_light: Installing HID Host driver...
I (685) hid_mqtt_light: HID Host driver installed.
I (685) hid_mqtt_light: Application started. Waiting for HID Device connection or events...
I (785) wifi:connected with Aussie Broadband 8729, aid = 41, channel 6, BW20, bssid = d0:db:b7:9f:56:a8
I (785) wifi:security: WPA2-PSK, phy: bgn, rssi: -55
I (795) wifi:pm start, type: 1
I (795) wifi:dp: 1, bi: 102400, li: 3, scale listen interval from 307200 us to 307200 us
I (795) wifi:set rx beacon pti, rx_bcn_pti: 0, bcn_timeout: 25000, mt_pti: 0, mt_time: 10000
I (885) wifi:AP's beacon interval = 102400 us, DTIM period = 1
I (995) wifi:<ba-add>idx:0 (ifx:0, d0:db:b7:9f:56:a8), tid:0, ssn:0, winSize:64
I (1065) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 1 Subclass 1
I (1065) hid_mqtt_light: HID device started successfully.
I (1065) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 0 Subclass 0
W (1075) hid_mqtt_light: Keyboard report too short (0 bytes)
W (1075) hid_mqtt_light: Ignoring connected HID device - not a Boot Protocol Keyboard.
I (1085) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 2 Subclass 1
W (1095) hid_mqtt_light: Ignoring connected HID device - not a Boot Protocol Keyboard.
I (14195) hid_mqtt_light: Key pressed: c
I (14195) hid_mqtt_light: Light main_light turned ON.
I (14195) hid_mqtt_light: publish_light_state: WiFi has IP: NO, MQTT Globally Connected: NO
W (14205) hid_mqtt_light: MQTT client not ready or WiFi disconnected. Cannot publish. (g_mqtt_connected: 0, wifi_has_ip: 0)
I (14215) hid_mqtt_light: Current Target: main_light
I (21255) hid_mqtt_light: Key pressed: d
I (21255) hid_mqtt_light: publish_light_state: WiFi has IP: NO, MQTT Globally Connected: NO
W (21255) hid_mqtt_light: MQTT client not ready or WiFi disconnected. Cannot publish. (g_mqtt_connected: 0, wifi_has_ip: 0)
I (21265) hid_mqtt_light: Light 2 (main_light): Brightness 4, Hue Index 0
E (24565) hid-host: Transfer failed, status 1
W (24565) hid_mqtt_light: HID Device, Protocol '1' TRANSFER_ERROR
E (24615) hid-host: hid_host_interface_release_and_free_transfer(604): Unable to release HID Interface
E (24615) hid-host: hid_host_device_close(1213): Unable to release HID Interface
E (24615) hid_mqtt_light: Failed to close device on transfer error: ESP_ERR_INVALID_STATE
I (51255) hid_mqtt_light: Inactivity timeout. Entering deep sleep.
I (51255) wifi:state: run -> init (0x0)
I (51265) wifi:pm stop, total sleep time: 43939688 us / 50469774 us
I (51265) wifi:<ba-del>idx:0, tid:0
I (51265) wifi:new:<6,0>, old:<6,0>, ap:<255,255>, sta:<6,0>, prof:1, snd_ch_cfg:0x0
W (51265) hid_mqtt_light: WiFi disconnected, reason: 8. Trying to reconnect...
I (51305) wifi:flush txq
I (51305) wifi:stop sw txq
I (51305) wifi:lmac stop hw txq
I (51305) wifi:Deinit lldesc rx mblock:10
I (51315) hid_mqtt_light: Preparing for deep sleep.
ESP-ROM:esp32s3-20210327
Build:Mar 27 2021
rst:0x1 (POWERON),boot:0x2b (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fce2810,len:0x15a0
load:0x403c8700,len:0x4
load:0x403c8704,len:0xd20
load:0x403cb700,len:0x2f00
entry 0x403c8928
I (27) boot: ESP-IDF v5.4.1 2nd stage bootloader
I (27) boot: compile time May 21 2025 14:32:48
I (27) boot: Multicore bootloader
I (27) boot: chip revision: v0.2
I (30) boot: efuse block revision: v1.3
I (34) boot.esp32s3: Boot SPI Speed : 80MHz
I (37) boot.esp32s3: SPI Mode : DIO
I (41) boot.esp32s3: SPI Flash Size : 2MB
I (45) boot: Enabling RNG early entropy source...
I (49) boot: Partition Table:
I (52) boot: ## Label Usage Type ST Offset Length
I (58) boot: 0 nvs WiFi data 01 02 00009000 00006000
I (65) boot: 1 phy_init RF data 01 01 0000f000 00001000
I (71) boot: 2 factory factory app 00 00 00010000 00100000
I (78) boot: End of partition table
I (81) esp_image: segment 0: paddr=00010020 vaddr=3c0c0020 size=24aa4h (150180) map
I (115) esp_image: segment 1: paddr=00034acc vaddr=3fc9bb00 size=04a84h ( 19076) load
I (119) esp_image: segment 2: paddr=00039558 vaddr=40374000 size=06ac0h ( 27328) load
I (125) esp_image: segment 3: paddr=00040020 vaddr=42000020 size=b17a4h (726948) map
I (255) esp_image: segment 4: paddr=000f17cc vaddr=4037aac0 size=10f68h ( 69480) load
I (270) esp_image: segment 5: paddr=0010273c vaddr=50000000 size=00018h ( 24) load
I (270) esp_image: segment 6: paddr=0010275c vaddr=600fe000 size=00100h ( 256) load
I (274) esp_image: segment 7: paddr=00102864 vaddr=600fe100 size=00020h ( 32) load
I (290) boot: Loaded app from partition at offset 0x10000
I (291) boot: Disabling RNG early entropy source...
I (303) cpu_start: Multicore app
I (312) cpu_start: Pro cpu start user code
I (312) cpu_start: cpu freq: 160000000 Hz
I (312) app_init: Application information:
I (312) app_init: Project name: Keyboard_lights_2
I (317) app_init: App version: 40f8561
I (321) app_init: Compile time: May 21 2025 14:27:23
I (326) app_init: ELF file SHA256: fe82ff3f6...
I (330) app_init: ESP-IDF: v5.4.1
I (334) efuse_init: Min chip rev: v0.0
I (338) efuse_init: Max chip rev: v0.99 
I (342) efuse_init: Chip rev: v0.2
I (346) heap_init: Initializing. RAM available for dynamic allocation:
I (352) heap_init: At 3FCA4980 len 00044D90 (275 KiB): RAM
I (357) heap_init: At 3FCE9710 len 00005724 (21 KiB): RAM
I (362) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM
I (367) heap_init: At 600FE120 len 00001EC8 (7 KiB): RTCRAM
I (374) spi_flash: detected chip: generic
I (376) spi_flash: flash io: dio
W (379) spi_flash: Detected size(16384k) larger than the size in the binary image header(2048k). Using the size in the binary image header.
I (392) sleep_gpio: Configure to isolate all GPIO pins in sleep state
I (398) sleep_gpio: Enable automatic switching of GPIO sleep configuration
I (405) main_task: Started on CPU0
I (425) main_task: Calling app_main()
I (445) hid_mqtt_light: Fresh boot or invalid RTC data. Initializing defaults.
I (445) hid_mqtt_light: Initial/Restored state: Target 0 (sam_bed), Mode Brightness
I (455) hid_mqtt_light: Light 0 (sam_bed): On=0, Bright=5, HueIdx=0
I (455) hid_mqtt_light: Light 1 (jo_bed): On=0, Bright=5, HueIdx=0
I (465) hid_mqtt_light: Light 2 (main_light): On=0, Bright=5, HueIdx=0
I (475) pp: pp rom version: e7ae62f
I (475) net80211: net80211 rom version: e7ae62f
I (485) wifi:wifi driver task: 3fcaf48c, prio:23, stack:6656, core=0
I (495) wifi:wifi firmware version: 79fa3f41ba
I (495) wifi:wifi certification version: v7.0
I (495) wifi:config NVS flash: enabled
I (495) wifi:config nano formatting: disabled
I (505) wifi:Init data frame dynamic rx buffer num: 32
I (505) wifi:Init static rx mgmt buffer num: 5
I (515) wifi:Init management short buffer num: 32
I (515) wifi:Init dynamic tx buffer num: 32
I (515) wifi:Init static tx FG buffer num: 2
I (525) wifi:Init static rx buffer size: 1600
I (525) wifi:Init static rx buffer num: 10
I (535) wifi:Init dynamic rx buffer num: 32
I (535) wifi_init: rx ba win: 6
I (535) wifi_init: accept mbox: 6
I (545) wifi_init: tcpip mbox: 32
I (545) wifi_init: udp mbox: 6
I (545) wifi_init: tcp mbox: 6
I (545) wifi_init: tcp tx win: 5760
I (555) wifi_init: tcp rx win: 5760
I (555) wifi_init: tcp mss: 1440
I (555) wifi_init: WiFi IRAM OP enabled
I (565) wifi_init: WiFi RX IRAM OP enabled
W (565) wifi:Password length matches WPA2 standards, authmode threshold changes from OPEN to WPA2
I (575) phy_init: phy_version 700,8582a7fd,Feb 10 2025,20:13:11
I (625) phy_init: Saving new calibration data due to checksum failure or outdated calibration data, mode(0)
I (645) wifi:mode : sta (98:a3:16:e2:6c:54)
I (645) wifi:enable tsf
I (645) hid_mqtt_light: wifi_init_sta finished. Connecting to AP...
I (645) hid_mqtt_light: WIFI_EVENT_STA_START, connecting...
I (655) hid_mqtt_light: Installing USB Host...
I (655) wifi:new:<6,0>, old:<1,0>, ap:<255,255>, sta:<6,0>, prof:1, snd_ch_cfg:0x0
I (665) wifi:state: init -> auth (0xb0)
I (675) wifi:state: auth -> assoc (0x0)
I (685) hid_mqtt_light: USB Host installed.
I (685) hid_mqtt_light: Installing HID Host driver...
I (685) hid_mqtt_light: HID Host driver installed.
I (685) hid_mqtt_light: Application started. Waiting for HID Device connection or events...
I (685) wifi:state: assoc -> run (0x10)
I (755) wifi:connected with Aussie Broadband 8729, aid = 17, channel 6, BW20, bssid = d0:db:b7:9f:56:a8
I (755) wifi:security: WPA2-PSK, phy: bgn, rssi: -58
I (765) wifi:pm start, type: 1
I (765) wifi:dp: 1, bi: 102400, li: 3, scale listen interval from 307200 us to 307200 us
I (775) wifi:set rx beacon pti, rx_bcn_pti: 0, bcn_timeout: 25000, mt_pti: 0, mt_time: 10000
I (785) wifi:AP's beacon interval = 102400 us, DTIM period = 1
I (905) wifi:<ba-add>idx:0 (ifx:0, d0:db:b7:9f:56:a8), tid:0, ssn:0, winSize:64
I (1065) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 1 Subclass 1
I (1065) hid_mqtt_light: HID device started successfully.
I (1065) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 0 Subclass 0
I (1075) hid_mqtt_light: Key pressed: d
I (1075) hid_mqtt_light: Light 0 (sam_bed): Brightness 4, Hue Index 0
W (1085) hid_mqtt_light: Ignoring connected HID device - not a Boot Protocol Keyboard.
I (1085) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 2 Subclass 1
W (1095) hid_mqtt_light: Ignoring connected HID device - not a Boot Protocol Keyboard.
I (1935) esp_netif_handlers: sta ip: 192.168.20.45, mask: 255.255.255.0, gw: 192.168.20.1
I (1935) hid_mqtt_light: Got IP:192.168.20.45
I (1935) hid_mqtt_light: Other event id:7
I (2025) hid_mqtt_light: MQTT_EVENT_CONNECTED
E (4315) hid-host: Transfer failed, status 1
W (4315) hid_mqtt_light: HID Device, Protocol '1' TRANSFER_ERROR
E (4365) hid-host: hid_host_interface_release_and_free_transfer(604): Unable to release HID Interface
E (4365) hid-host: hid_host_device_close(1213): Unable to release HID Interface
E (4365) hid_mqtt_light: Failed to close device on transfer error: ESP_ERR_INVALID_STATE
ESP-ROM:esp32s3-20210327
Build:Mar 27 2021
rst:0x1 (POWERON),boot:0x2b (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fce2810,len:0x15a0
load:0x403c8700,len:0x4
load:0x403c8704,len:0xd20
load:0x403cb700,len:0x2f00
entry 0x403c8928
I (27) boot: ESP-IDF v5.4.1 2nd stage bootloader
I (27) boot: compile time May 21 2025 14:32:48
I (27) boot: Multicore bootloader
I (27) boot: chip revision: v0.2
I (30) boot: efuse block revision: v1.3
I (34) boot.esp32s3: Boot SPI Speed : 80MHz
I (37) boot.esp32s3: SPI Mode : DIO
I (41) boot.esp32s3: SPI Flash Size : 2MB
I (45) boot: Enabling RNG early entropy source...
I (49) boot: Partition Table:
I (52) boot: ## Label Usage Type ST Offset Length
I (58) boot: 0 nvs WiFi data 01 02 00009000 00006000
I (65) boot: 1 phy_init RF data 01 01 0000f000 00001000
I (71) boot: 2 factory factory app 00 00 00010000 00100000
I (78) boot: End of partition table
I (81) esp_image: segment 0: paddr=00010020 vaddr=3c0c0020 size=24aa4h (150180) map
I (115) esp_image: segment 1: paddr=00034acc vaddr=3fc9bb00 size=04a84h ( 19076) load
I (119) esp_image: segment 2: paddr=00039558 vaddr=40374000 size=06ac0h ( 27328) load
I (125) esp_image: segment 3: paddr=00040020 vaddr=42000020 size=b17a4h (726948) map
I (255) esp_image: segment 4: paddr=000f17cc vaddr=4037aac0 size=10f68h ( 69480) load
I (270) esp_image: segment 5: paddr=0010273c vaddr=50000000 size=00018h ( 24) load
I (270) esp_image: segment 6: paddr=0010275c vaddr=600fe000 size=00100h ( 256) load
I (274) esp_image: segment 7: paddr=00102864 vaddr=600fe100 size=00020h ( 32) load
I (290) boot: Loaded app from partition at offset 0x10000
I (291) boot: Disabling RNG early entropy source...
I (303) cpu_start: Multicore app
I (312) cpu_start: Pro cpu start user code
I (312) cpu_start: cpu freq: 160000000 Hz
I (312) app_init: Application information:
I (312) app_init: Project name: Keyboard_lights_2
I (317) app_init: App version: 40f8561
I (321) app_init: Compile time: May 21 2025 14:27:23
I (326) app_init: ELF file SHA256: fe82ff3f6...
I (330) app_init: ESP-IDF: v5.4.1
I (334) efuse_init: Min chip rev: v0.0
I (338) efuse_init: Max chip rev: v0.99 
I (342) efuse_init: Chip rev: v0.2
I (346) heap_init: Initializing. RAM available for dynamic allocation:
I (352) heap_init: At 3FCA4980 len 00044D90 (275 KiB): RAM
I (357) heap_init: At 3FCE9710 len 00005724 (21 KiB): RAM
I (362) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM
I (367) heap_init: At 600FE120 len 00001EC8 (7 KiB): RTCRAM
I (374) spi_flash: detected chip: generic
I (376) spi_flash: flash io: dio
W (379) spi_flash: Detected size(16384k) larger than the size in the binary image header(2048k). Using the size in the binary image header.
I (392) sleep_gpio: Configure to isolate all GPIO pins in sleep state
I (398) sleep_gpio: Enable automatic switching of GPIO sleep configuration
I (405) main_task: Started on CPU0
I (425) main_task: Calling app_main()
I (445) hid_mqtt_light: Fresh boot or invalid RTC data. Initializing defaults.
I (445) hid_mqtt_light: Initial/Restored state: Target 0 (sam_bed), Mode Brightness
I (455) hid_mqtt_light: Light 0 (sam_bed): On=0, Bright=5, HueIdx=0
I (455) hid_mqtt_light: Light 1 (jo_bed): On=0, Bright=5, HueIdx=0
I (465) hid_mqtt_light: Light 2 (main_light): On=0, Bright=5, HueIdx=0
I (475) pp: pp rom version: e7ae62f
I (475) net80211: net80211 rom version: e7ae62f
I (485) wifi:wifi driver task: 3fcaf510, prio:23, stack:6656, core=0
I (495) wifi:wifi firmware version: 79fa3f41ba
I (495) wifi:wifi certification version: v7.0
I (495) wifi:config NVS flash: enabled
I (495) wifi:config nano formatting: disabled
I (505) wifi:Init data frame dynamic rx buffer num: 32
I (505) wifi:Init static rx mgmt buffer num: 5
I (515) wifi:Init management short buffer num: 32
I (515) wifi:Init dynamic tx buffer num: 32
I (515) wifi:Init static tx FG buffer num: 2
I (525) wifi:Init static rx buffer size: 1600
I (525) wifi:Init static rx buffer num: 10
I (535) wifi:Init dynamic rx buffer num: 32
I (535) wifi_init: rx ba win: 6
I (535) wifi_init: accept mbox: 6
I (545) wifi_init: tcpip mbox: 32
I (545) wifi_init: udp mbox: 6
I (545) wifi_init: tcp mbox: 6
I (545) wifi_init: tcp tx win: 5760
I (555) wifi_init: tcp rx win: 5760
I (555) wifi_init: tcp mss: 1440
I (555) wifi_init: WiFi IRAM OP enabled
I (565) wifi_init: WiFi RX IRAM OP enabled
W (565) wifi:Password length matches WPA2 standards, authmode threshold changes from OPEN to WPA2
I (575) phy_init: phy_version 700,8582a7fd,Feb 10 2025,20:13:11
I (625) phy_init: Saving new calibration data due to checksum failure or outdated calibration data, mode(0)
I (645) wifi:mode : sta (98:a3:16:e2:6c:54)
I (645) wifi:enable tsf
I (645) hid_mqtt_light: wifi_init_sta finished. Connecting to AP...
I (645) hid_mqtt_light: WIFI_EVENT_STA_START, connecting...
I (655) hid_mqtt_light: Installing USB Host...
I (655) wifi:new:<6,0>, old:<1,0>, ap:<255,255>, sta:<6,0>, prof:1, snd_ch_cfg:0x0
I (665) wifi:state: init -> auth (0xb0)
I (675) wifi:state: auth -> assoc (0x0)
I (685) hid_mqtt_light: USB Host installed.
I (685) hid_mqtt_light: Installing HID Host driver...
I (685) hid_mqtt_light: HID Host driver installed.
I (685) hid_mqtt_light: Application started. Waiting for HID Device connection or events...
I (685) wifi:state: assoc -> run (0x10)
I (725) wifi:state: run -> init (0x2c0)
I (745) wifi:new:<6,0>, old:<6,0>, ap:<255,255>, sta:<6,0>, prof:1, snd_ch_cfg:0x0
W (745) hid_mqtt_light: WiFi disconnected, reason: 2. Trying to reconnect...
I (1065) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 1 Subclass 1
I (1065) hid_mqtt_light: HID device started successfully.
I (1065) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 0 Subclass 0
I (1075) hid_mqtt_light: Key pressed: c
I (1075) hid_mqtt_light: Light main_light turned ON.
I (1075) hid_mqtt_light: publish_light_state: WiFi has IP: NO, MQTT Globally Connected: NO
W (1085) hid_mqtt_light: MQTT client not ready or WiFi disconnected. Cannot publish. (g_mqtt_connected: 0, wifi_has_ip: 0)
I (1095) hid_mqtt_light: Current Target: main_light
W (1105) hid_mqtt_light: Ignoring connected HID device - not a Boot Protocol Keyboard.
I (1115) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 2 Subclass 1
W (1115) hid_mqtt_light: Ignoring connected HID device - not a Boot Protocol Keyboard.
W (3155) hid_mqtt_light: WiFi disconnected, reason: 205. Trying to reconnect...
I (3235) wifi:new:<6,0>, old:<6,0>, ap:<255,255>, sta:<6,0>, prof:1, snd_ch_cfg:0x0
I (3245) wifi:state: init -> auth (0xb0)
I (3275) wifi:state: auth -> assoc (0x0)
I (3295) wifi:state: assoc -> run (0x10)
I (3335) wifi:connected with Aussie Broadband 8729, aid = 49, channel 6, BW20, bssid = d0:db:b7:9f:56:a8
I (3335) wifi:security: WPA2-PSK, phy: bgn, rssi: -75
I (3345) wifi:pm start, type: 1
I (3345) wifi:dp: 1, bi: 102400, li: 3, scale listen interval from 307200 us to 307200 us
I (3355) wifi:set rx beacon pti, rx_bcn_pti: 0, bcn_timeout: 25000, mt_pti: 0, mt_time: 10000
I (3355) wifi:AP's beacon interval = 102400 us, DTIM period = 1
I (3395) wifi:<ba-add>idx:0 (ifx:0, d0:db:b7:9f:56:a8), tid:0, ssn:0, winSize:64
I (4415) esp_netif_handlers: sta ip: 192.168.20.45, mask: 255.255.255.0, gw: 192.168.20.1
I (4415) hid_mqtt_light: Got IP:192.168.20.45
I (4415) hid_mqtt_light: Other event id:7
I (4445) hid_mqtt_light: MQTT_EVENT_CONNECTED
I (7505) hid_mqtt_light: Key pressed: c
I (7505) hid_mqtt_light: Light main_light turned OFF.
I (7505) hid_mqtt_light: publish_light_state: WiFi has IP: YES, MQTT Globally Connected: YES
I (7505) hid_mqtt_light: Publishing to homeassistant/light/main_light/set: {"state":"OFF"}
I (7515) hid_mqtt_light: Current Target: main_light
I (7525) hid_mqtt_light: MQTT_EVENT_PUBLISHED, msg_id=47515
I (14795) hid_mqtt_light: Key pressed: c
I (14795) hid_mqtt_light: Light main_light turned ON.
I (14795) hid_mqtt_light: publish_light_state: WiFi has IP: YES, MQTT Globally Connected: YES
I (14795) hid_mqtt_light: Publishing to homeassistant/light/main_light/set: {"state":"ON","brightness":128,"color_temp":2200,"xy_color":[0.53032141923904419,0.41342452168464661]}
I (14815) hid_mqtt_light: Current Target: main_light
I (14825) hid_mqtt_light: MQTT_EVENT_PUBLISHED, msg_id=55872
E (23965) hid-host: Transfer failed, status 1
W (23965) hid_mqtt_light: HID Device, Protocol '1' TRANSFER_ERROR
E (24015) hid-host: hid_host_interface_release_and_free_transfer(604): Unable to release HID Interface
E (24015) hid-host: hid_host_device_close(1213): Unable to release HID Interface
E (24015) hid_mqtt_light: Failed to close device on transfer error: ESP_ERR_INVALID_STATE
I (44795) hid_mqtt_light: Inactivity timeout. Entering deep sleep.
I (44795) mqtt_client: Client asked to disconnect
I (44795) wifi:state: run -> init (0x0)
I (44805) wifi:pm stop, total sleep time: 35720911 us / 41458382 us
I (44805) wifi:<ba-del>idx:0, tid:0
I (44805) wifi:new:<6,0>, old:<6,0>, ap:<255,255>, sta:<6,0>, prof:1, snd_ch_cfg:0x0
W (44815) hid_mqtt_light: WiFi disconnected, reason: 8. Trying to reconnect...
I (44845) wifi:flush txq
I (44845) wifi:stop sw txq
I (44845) wifi:lmac stop hw txq
I (44845) wifi:Deinit lldesc rx mblock:10
I (44855) hid_mqtt_light: Preparing for deep sleep.
ESP-ROM:esp32s3-20210327
Build:Mar 27 2021
rst:0x1 (POWERON),boot:0x8 (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fce2810,len:0x15a0
load:0x403c8700,len:0x4
load:0x403c8704,len:0xd20
load:0x403cb700,len:0x2f00
entry 0x403c8928
I (27) boot: ESP-IDF v5.4.1 2nd stage bootloader
I (27) boot: compile time May 21 2025 14:32:48
I (27) boot: Multicore bootloader
I (27) boot: chip revision: v0.2
I (30) boot: efuse block revision: v1.3
I (33) boot.esp32s3: Boot SPI Speed : 80MHz
I (37) boot.esp32s3: SPI Mode : DIO
I (41) boot.esp32s3: SPI Flash Size : 2MB
I (45) boot: Enabling RNG early entropy source...
I (49) boot: Partition Table:
I (52) boot: ## Label Usage Type ST Offset Length
I (58) boot: 0 nvs WiFi data 01 02 00009000 00006000
I (65) boot: 1 phy_init RF data 01 01 0000f000 00001000
I (71) boot: 2 factory factory app 00 00 00010000 00100000
I (78) boot: End of partition table
I (81) esp_image: segment 0: paddr=00010020 vaddr=3c0c0020 size=24aa4h (150180) map
I (115) esp_image: segment 1: paddr=00034acc vaddr=3fc9bb00 size=04a84h ( 19076) load
I (119) esp_image: segment 2: paddr=00039558 vaddr=40374000 size=06ac0h ( 27328) load
I (125) esp_image: segment 3: paddr=00040020 vaddr=42000020 size=b17a4h (726948) map
I (254) esp_image: segment 4: paddr=000f17cc vaddr=4037aac0 size=10f68h ( 69480) load
I (270) esp_image: segment 5: paddr=0010273c vaddr=50000000 size=00018h ( 24) load
I (270) esp_image: segment 6: paddr=0010275c vaddr=600fe000 size=00100h ( 256) load
I (274) esp_image: segment 7: paddr=00102864 vaddr=600fe100 size=00020h ( 32) load
I (290) boot: Loaded app from partition at offset 0x10000
I (291) boot: Disabling RNG early entropy source...
I (303) cpu_start: Multicore app
I (312) cpu_start: Pro cpu start user code
I (312) cpu_start: cpu freq: 160000000 Hz
I (312) app_init: Application information:
I (312) app_init: Project name: Keyboard_lights_2
I (317) app_init: App version: 40f8561
I (321) app_init: Compile time: May 21 2025 14:27:23
I (326) app_init: ELF file SHA256: fe82ff3f6...
I (330) app_init: ESP-IDF: v5.4.1
I (334) efuse_init: Min chip rev: v0.0
I (338) efuse_init: Max chip rev: v0.99 
I (342) efuse_init: Chip rev: v0.2
I (345) heap_init: Initializing. RAM available for dynamic allocation:
I (352) heap_init: At 3FCA4980 len 00044D90 (275 KiB): RAM
I (357) heap_init: At 3FCE9710 len 00005724 (21 KiB): RAM
I (362) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM
I (367) heap_init: At 600FE120 len 00001EC8 (7 KiB): RTCRAM
I (374) spi_flash: detected chip: generic
I (376) spi_flash: flash io: dio
W (379) spi_flash: Detected size(16384k) larger than the size in the binary image header(2048k). Using the size in the binary image header.
I (392) sleep_gpio: Configure to isolate all GPIO pins in sleep state
I (398) sleep_gpio: Enable automatic switching of GPIO sleep configuration
I (405) main_task: Started on CPU0
I (425) main_task: Calling app_main()
I (445) hid_mqtt_light: Fresh boot or invalid RTC data. Initializing defaults.
I (445) hid_mqtt_light: Initial/Restored state: Target 0 (sam_bed), Mode Brightness
I (455) hid_mqtt_light: Light 0 (sam_bed): On=0, Bright=5, HueIdx=0
I (455) hid_mqtt_light: Light 1 (jo_bed): On=0, Bright=5, HueIdx=0
I (465) hid_mqtt_light: Light 2 (main_light): On=0, Bright=5, HueIdx=0
I (475) pp: pp rom version: e7ae62f
I (475) net80211: net80211 rom version: e7ae62f
I (485) wifi:wifi driver task: 3fcaf510, prio:23, stack:6656, core=0
I (495) wifi:wifi firmware version: 79fa3f41ba
I (495) wifi:wifi certification version: v7.0
I (495) wifi:config NVS flash: enabled
I (495) wifi:config nano formatting: disabled
I (505) wifi:Init data frame dynamic rx buffer num: 32
I (505) wifi:Init static rx mgmt buffer num: 5
I (505) wifi:Init management short buffer num: 32
I (515) wifi:Init dynamic tx buffer num: 32
I (515) wifi:Init static tx FG buffer num: 2
I (525) wifi:Init static rx buffer size: 1600
I (525) wifi:Init static rx buffer num: 10
I (525) wifi:Init dynamic rx buffer num: 32
I (535) wifi_init: rx ba win: 6
I (535) wifi_init: accept mbox: 6
I (535) wifi_init: tcpip mbox: 32
I (545) wifi_init: udp mbox: 6
I (545) wifi_init: tcp mbox: 6
I (545) wifi_init: tcp tx win: 5760
I (555) wifi_init: tcp rx win: 5760
I (555) wifi_init: tcp mss: 1440
I (555) wifi_init: WiFi IRAM OP enabled
I (565) wifi_init: WiFi RX IRAM OP enabled
W (565) wifi:Password length matches WPA2 standards, authmode threshold changes from OPEN to WPA2
I (575) phy_init: phy_version 700,8582a7fd,Feb 10 2025,20:13:11
I (625) phy_init: Saving new calibration data due to checksum failure or outdated calibration data, mode(0)
I (785) wifi:mode : sta (98:a3:16:e2:6c:54)
I (785) wifi:enable tsf
I (785) hid_mqtt_light: wifi_init_sta finished. Connecting to AP...
I (785) hid_mqtt_light: WIFI_EVENT_STA_START, connecting...
I (785) hid_mqtt_light: Installing USB Host...
I (795) wifi:new:<6,0>, old:<1,0>, ap:<255,255>, sta:<6,0>, prof:1, snd_ch_cfg:0x0
I (795) wifi:state: init -> auth (0xb0)
I (815) wifi:state: auth -> assoc (0x0)
I (815) wifi:state: assoc -> run (0x10)
I (825) hid_mqtt_light: USB Host installed.
I (825) hid_mqtt_light: Installing HID Host driver...
I (825) hid_mqtt_light: HID Host driver installed.
I (825) hid_mqtt_light: Application started. Waiting for HID Device connection or events...
I (875) wifi:connected with Aussie Broadband 8729, aid = 53, channel 6, BW20, bssid = d0:db:b7:9f:56:a8
I (875) wifi:security: WPA2-PSK, phy: bgn, rssi: -52
I (875) wifi:pm start, type: 1
I (875) wifi:dp: 1, bi: 102400, li: 3, scale listen interval from 307200 us to 307200 us
I (885) wifi:set rx beacon pti, rx_bcn_pti: 0, bcn_timeout: 25000, mt_pti: 0, mt_time: 10000
I (895) wifi:AP's beacon interval = 102400 us, DTIM period = 1
I (915) wifi:<ba-add>idx:0 (ifx:0, d0:db:b7:9f:56:a8), tid:0, ssn:0, winSize:64
I (1205) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 1 Subclass 1
I (1205) hid_mqtt_light: HID device started successfully.
I (1205) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 0 Subclass 0
W (1215) hid_mqtt_light: Keyboard report too short (0 bytes)
W (1215) hid_mqtt_light: Ignoring connected HID device - not a Boot Protocol Keyboard.
I (1225) hid_mqtt_light: HID Device CONNECTED (Driver Event): Protocol 2 Subclass 1
W (1235) hid_mqtt_light: Ignoring connected HID device - not a Boot Protocol Keyboard.
I (1945) esp_netif_handlers: sta ip: 192.168.20.45, mask: 255.255.255.0, gw: 192.168.20.1
I (1945) hid_mqtt_light: Got IP:192.168.20.45
I (1945) hid_mqtt_light: Other event id:7
I (1975) hid_mqtt_light: MQTT_EVENT_CONNECTED
I (4995) hid_mqtt_light: Key pressed: c
I (4995) hid_mqtt_light: Light main_light turned ON.
I (4995) hid_mqtt_light: publish_light_state: WiFi has IP: YES, MQTT Globally Connected: YES
I (5005) hid_mqtt_light: Publishing to homeassistant/light/main_light/set: {"state":"ON","brightness":128,"color_temp":2200,"xy_color":[0.53032141923904419,0.41342452168464661]}
I (5015) hid_mqtt_light: Current Target: main_light
I (5035) hid_mqtt_light: MQTT_EVENT_PUBLISHED, msg_id=18569
I (14855) hid_mqtt_light: Key pressed: c
I (14855) hid_mqtt_light: Light main_light turned OFF.
I (14855) hid_mqtt_light: publish_light_state: WiFi has IP: YES, MQTT Globally Connected: YES
I (14865) hid_mqtt_light: Publishing to homeassistant/light/main_light/set: {"state":"OFF"}
I (14875) hid_mqtt_light: Current Target: main_light
I (14885) hid_mqtt_light: MQTT_EVENT_PUBLISHED, msg_id=17355
I (17615) hid_mqtt_light: Key pressed: c
I (17615) hid_mqtt_light: Light main_light turned ON.
I (17615) hid_mqtt_light: publish_light_state: WiFi has IP: YES, MQTT Globally Connected: YES
I (17615) hid_mqtt_light: Publishing to homeassistant/light/main_light/set: {"state":"ON","brightness":128,"color_temp":2200,"xy_color":[0.53032141923904419,0.41342452168464661]}
I (17635) hid_mqtt_light: Current Target: main_light
I (17645) hid_mqtt_light: MQTT_EVENT_PUBLISHED, msg_id=21313
E (20195) hid-host: Transfer failed, status 1
W (20195) hid_mqtt_light: HID Device, Protocol '1' TRANSFER_ERROR
E (20245) hid-host: hid_host_interface_release_and_free_transfer(604): Unable to release HID Interface
E (20245) hid-host: hid_host_device_close(1213): Unable to release HID Interface
E (20245) hid_mqtt_light: Failed to close device on transfer error: ESP_ERR_INVALID_STATE
I (47615) hid_mqtt_light: Inactivity timeout. Entering deep sleep.
I (47615) mqtt_client: Client asked to disconnect
I (47625) wifi:state: run -> init (0x0)
I (47635) wifi:pm stop, total sleep time: 38052296 us / 46753454 us
I (47635) wifi:<ba-del>idx:0, tid:0
I (47635) wifi:new:<6,0>, old:<6,0>, ap:<255,255>, sta:<6,0>, prof:1, snd_ch_cfg:0x0
W (47635) hid_mqtt_light: WiFi disconnected, reason: 8. Trying to reconnect...
I (47765) wifi:flush txq
I (47765) wifi:stop sw txq
I (47765) wifi:lmac stop hw txq
I (47765) wifi:Deinit lldesc rx mblock:10
I (47775) hid_mqtt_light: Preparing for deep sleep.
ESP-ROM:esp32s3-20210327
Build:Mar 27 2021
rst:0x1 (POWERON),boot:0x8 (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fce2810,len:0x15a0
load:0x403c8700,len:0x4
load:0x403c8704,len:0xd20
load:0x403cb700,len:0x2f00
entry 0x403c8928
I (27) boot: ESP-IDF v5.4.1 2nd stage bootloader
I (27) boot: compile time May 21 2025 14:32:48
I (27) boot: Multicore bootloader
I (27) boot: chip revision: v0.2
I (30) boot: efuse bl