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

39 KiB
Raw Permalink Blame History

<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