[17:04:33][D][esp32_ble_server:155]: BLE Client connected [17:04:33][D][esp-idf:000][BTU_TASK]: W (26799) BT_GATT: format mismatch [17:04:33] [17:04:57][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 1x, time = 100 ms [17:04:58][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 2x, time = 100 ms [17:04:59][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 4x, time = 100 ms [17:05:00][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 8x, time = 100 ms [17:05:01][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 48x, time = 100 ms [17:05:02][D][ltr_als_ps:450]: Illuminance is sufficient. [17:05:02][D][sensor:094]: 'Ambient light': Sending state 156.27995 lx with 1 decimals of accuracy [17:05:08][D][sensor:094]: 'Temperature': Sending state 31.66740 °C with 2 decimals of accuracy [17:05:08][D][sensor:094]: 'Humidity': Sending state 42.22324 % with 2 decimals of accuracy [17:05:09][I][safe_mode:041]: Boot seems successful; resetting boot loop counter [17:05:09][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:05:09][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:05:42][D][binary_sensor:036]: 'Button Left (HW Mute)': Sending state ON [17:05:42][D][media_player:080]: 'Sat1 Media Player' - Setting [17:05:42][D][media_player:093]: Announcement: yes [17:05:42][D][switch:055]: 'Mute Microphones': Sending state ON [17:05:42][D][light:036]: 'voice_assistant_leds' Setting: [17:05:42][D][light:051]: Brightness: 66% [17:05:42][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:05:42][D][ring_buffer:034]: Created ring buffer with size 48000 [17:05:42][D][ring_buffer:034]: Created ring buffer with size 48000 [17:05:42][D][ring_buffer:034]: Created ring buffer with size 16384 [17:05:42][D][i2s_audio:067][speaker_task]: Install driver requested by Writer [17:05:42][D][esp-idf:000][speaker_task]: I (95145) I2S: DMA Malloc info, datalen=blocksize=4088, dma_buf_count=6 [17:05:42] [17:05:42][D][esp-idf:000][speaker_task]: I (95148) I2S: DMA Malloc info, datalen=blocksize=4088, dma_buf_count=6 [17:05:42] [17:05:42][D][i2s_audio:077][speaker_task]: Installing driver : yes [17:05:42][D][ring_buffer:034]: Created ring buffer with size 131072 [17:05:42][D][ring_buffer:034]: Created ring buffer with size 65536 [17:05:42][D][nabu_media_player:427]: Starting Media Player Speaker [17:05:42][D][nabu_media_player:430]: Started Media Player Speaker [17:05:42][D][nabu_media_player.pipeline:176]: Reading FLAC file type [17:05:42][D][nabu_media_player.pipeline:410][ann_decode]: Creating and starting new AudioDecoder [17:05:42][D][nabu_media_player.decoder:056][ann_decode]: Starting AudioDecoder. [17:05:42][D][nabu_media_player.pipeline:186]: Decoded audio has 1 channels, 48000 Hz sample rate, and 16 bits per sample [17:05:42][D][nabu_media_player.pipeline:197]: Converting mono channel audio to stereo channel audio [17:05:42][D][nabu_media_player.decoder:149][ann_decode]: skip decoding: buffer: 0, failed: 0, to-read: 32768 read: 0 avail: 0 [17:05:46][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:05:46][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:05:57][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 1x, time = 100 ms [17:05:58][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 2x, time = 100 ms [17:05:59][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 4x, time = 100 ms [17:06:00][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 8x, time = 100 ms [17:06:01][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 48x, time = 100 ms [17:06:02][D][ltr_als_ps:450]: Illuminance is sufficient. [17:06:02][D][sensor:094]: 'Ambient light': Sending state 158.37630 lx with 1 decimals of accuracy [17:06:08][D][sensor:094]: 'Temperature': Sending state 31.79366 °C with 2 decimals of accuracy [17:06:08][D][sensor:094]: 'Humidity': Sending state 42.07285 % with 2 decimals of accuracy [17:06:50][D][binary_sensor:036]: 'Button Right (Action)': Sending state ON [17:06:50][D][light:036]: 'voice_assistant_leds' Setting: [17:06:50][D][light:051]: Brightness: 66% [17:06:50][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:06:50][D][light:036]: 'voice_assistant_leds' Setting: [17:06:50][D][light:051]: Brightness: 66% [17:06:50][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:06:50][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:06:50][D][esp32_improv.component:307]: Received Improv Wi-Fi settings ssid=HomeNet, password=*Securelargegate649[redacted] [17:06:50][W][component:157]: Component wifi set Warning flag: associating to network [17:06:50][D][binary_sensor:036]: 'Button Right (Action)': Sending state OFF [17:06:50][D][light:036]: 'voice_assistant_leds' Setting: [17:06:50][D][light:051]: Brightness: 66% [17:06:50][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:06:57][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 1x, time = 100 ms [17:06:58][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 2x, time = 100 ms [17:06:59][D][esp-idf:000][wifi]: I (171943) wifi: [17:06:59][D][esp-idf:000][wifi]: new:<11,0>, old:<1,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:06:59][D][esp-idf:000][wifi]: [17:06:59] [17:06:59][D][esp-idf:000][wifi]: I (171946) wifi: [17:06:59][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:06:59][D][esp-idf:000][wifi]: [17:06:59] [17:06:59][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 4x, time = 100 ms [17:07:00][D][esp-idf:000][wifi]: I (173010) wifi: [17:07:00][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:07:00][D][esp-idf:000][wifi]: [17:07:00] [17:07:00][D][esp-idf:000][wifi]: E (173022) wifi: [17:07:00][D][esp-idf:000][wifi]: Set status to INIT [17:07:00][D][esp-idf:000][wifi]: [17:07:00] [17:07:00][D][esp-idf:000][wifi]: I (173024) wifi: [17:07:00][D][esp-idf:000][wifi]: state: assoc -> init (1e10) [17:07:00][D][esp-idf:000][wifi]: [17:07:00] [17:07:00][D][esp-idf:000][wifi]: I (173027) wifi: [17:07:00][D][esp-idf:000][wifi]: Coexist: Wi-Fi connect fail, apply reconnect coex policy [17:07:00] [17:07:00][D][esp-idf:000][wifi]: [17:07:00] [17:07:00][D][esp-idf:000][wifi]: I (173031) wifi: [17:07:00][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:07:00][D][esp-idf:000][wifi]: [17:07:00] [17:07:00][D][esp-idf:000][wifi]: I (173033) wifi: [17:07:00][D][esp-idf:000][wifi]: new:<6,0>, old:<11,0>, ap:<255,255>, sta:<6,0>, prof:1 [17:07:00][D][esp-idf:000][wifi]: [17:07:00] [17:07:00][D][esp-idf:000][wifi]: I (173037) wifi: [17:07:00][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:07:00][D][esp-idf:000][wifi]: [17:07:00] [17:07:00][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 8x, time = 100 ms [17:07:01][D][esp-idf:000][wifi]: I (174098) wifi: [17:07:01][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:07:01][D][esp-idf:000][wifi]: [17:07:01] [17:07:01][D][esp-idf:000][wifi]: I (174108) wifi: [17:07:01][D][esp-idf:000][wifi]: state: assoc -> run (10) [17:07:01][D][esp-idf:000][wifi]: [17:07:01] [17:07:01][D][esp-idf:000][wifi]: I (174141) wifi: [17:07:01][D][esp-idf:000][wifi]: connected with HomeNet, aid = 2, channel 6, BW20, bssid = 0a:18:d6:e1:ce:27 [17:07:01][D][esp-idf:000][wifi]: [17:07:01] [17:07:01][D][esp-idf:000][wifi]: I (174144) wifi: [17:07:01][D][esp-idf:000][wifi]: security: WPA3-SAE, phy: bgn, rssi: -81 [17:07:01][D][esp-idf:000][wifi]: [17:07:01] [17:07:01][D][esp-idf:000][wifi]: I (174146) wifi: [17:07:01][D][esp-idf:000][wifi]: pm start, type: 1 [17:07:01] [17:07:01][D][esp-idf:000][wifi]: [17:07:01] [17:07:01][D][esp-idf:000][wifi]: I (174149) wifi: [17:07:01][D][esp-idf:000][wifi]: set rx beacon pti, rx_bcn_pti: 14, bcn_timeout: 14, mt_pti: 25000, mt_time: 10000 [17:07:01][D][esp-idf:000][wifi]: [17:07:01] [17:07:01][D][esp-idf:000][wifi]: I (174159) wifi: [17:07:01][D][esp-idf:000][wifi]: idx:0 (ifx:0, 0a:18:d6:e1:ce:27), tid:6, ssn:2, winSize:64 [17:07:01][D][esp-idf:000][wifi]: [17:07:01] [17:07:01][D][esp-idf:000][wifi]: I (174162) wifi: [17:07:01][D][esp-idf:000][wifi]: AP's beacon interval = 102400 us, DTIM period = 1 [17:07:01][D][esp-idf:000][wifi]: [17:07:01] [17:07:01][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 48x, time = 100 ms [17:07:02][D][esp-idf:000][sys_evt]: I (175153) esp_netif_handlers: sta ip: 192.168.3.215, mask: 255.255.255.0, gw: 192.168.3.1 [17:07:02] [17:07:02][I][wifi:617]: WiFi Connected! [17:07:02][C][wifi:428]: Local MAC: D8:3B:DA:40:78:70 [17:07:02][C][wifi:433]: SSID: 'HomeNet'[redacted] [17:07:02][C][wifi:436]: IP Address: 192.168.3.215 [17:07:02][C][wifi:440]: BSSID: 0A:18:D6:E1:CE:27[redacted] [17:07:02][C][wifi:441]: Hostname: 'satellite1-407870' [17:07:02][C][wifi:443]: Signal strength: -81 dB ▂▄▆█ [17:07:02][C][wifi:447]: Channel: 6 [17:07:02][C][wifi:448]: Subnet: 255.255.255.0 [17:07:02][C][wifi:449]: Gateway: 192.168.3.1 [17:07:02][C][wifi:450]: DNS1: 192.168.3.152 [17:07:02][C][wifi:451]: DNS2: 0.0.0.0 [17:07:02][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:07:02][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:07:02][D][light:036]: 'voice_assistant_leds' Setting: [17:07:02][D][light:051]: Brightness: 66% [17:07:02][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:07:02][W][component:170]: Component wifi cleared Warning flag [17:07:02][D][ltr_als_ps:450]: Illuminance is sufficient. [17:07:02][D][sensor:094]: 'Ambient light': Sending state 157.09319 lx with 1 decimals of accuracy [17:07:03][D][light:036]: 'voice_assistant_leds' Setting: [17:07:03][D][light:051]: Brightness: 66% [17:07:03][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:07:03][D][esp-idf:000][BTU_TASK]: W (176207) BT_BTM: data exceed max adv packet length [17:07:03] [17:07:03][D][esp-idf:000][wifi]: I (176417) wifi: [17:07:03][D][esp-idf:000][wifi]: idx:1 (ifx:0, 0a:18:d6:e1:ce:27), tid:0, ssn:0, winSize:64 [17:07:03][D][esp-idf:000][wifi]: [17:07:03] [17:07:03][D][api:103]: Accepted 192.168.3.100 [17:07:03][W][component:170]: Component api cleared Warning flag [17:07:03][D][api.connection:1446]: Home Assistant 2025.2.1 (192.168.3.100): Connected successfully [17:07:03][D][light:036]: 'voice_assistant_leds' Setting: [17:07:03][D][light:051]: Brightness: 76% [17:07:03][D][light:109]: Effect: 'Muted or Silent' [17:07:07][D][light:036]: 'voice_assistant_leds' Setting: [17:07:07][D][light:051]: Brightness: 76% [17:07:08][D][sensor:094]: 'Temperature': Sending state 31.95979 °C with 2 decimals of accuracy [17:07:08][D][sensor:094]: 'Humidity': Sending state 41.87429 % with 2 decimals of accuracy [17:07:12][D][light:036]: 'voice_assistant_leds' Setting: [17:07:12][D][light:051]: Brightness: 76% [17:07:12][D][esp32_ble:269]: Disabling BLE... [17:07:12][D][esp-idf:000][BTU_TASK]: W (185219) BT_HCI: hci cmd send: disconnect: hdl 0x1, rsn:0x13 [17:07:12] [17:07:12][D][esp-idf:000][BTU_TASK]: W (185240) BT_HCI: hcif disc complete: hdl 0x1, rsn 0x16 [17:07:12] [17:07:13][W][component:237]: Component esp32_ble took a long time for an operation (1037 ms). [17:07:13][W][component:238]: Components should block for at most 30 ms. [17:07:14][D][micro_wake_word:379]: Starting wake word detection [17:07:14][D][light:036]: 'voice_assistant_leds' Setting: [17:07:14][D][light:051]: Brightness: 76% [17:07:14][D][i2s_audio:067][microphone_task]: Install driver requested by Reader [17:07:14][D][i2s_audio.microphone:322]: Starting I2S Audio Microphne [17:07:14][D][i2s_audio.microphone:326]: Started I2S Audio Microphone [17:07:14][D][micro_wake_word:418]: State changed from IDLE to DETECTING_WAKE_WORD [17:07:35][D][binary_sensor:036]: 'Button Left (HW Mute)': Sending state OFF [17:07:35][D][media_player:080]: 'Sat1 Media Player' - Setting [17:07:35][D][media_player:093]: Announcement: yes [17:07:35][D][switch:055]: 'Mute Microphones': Sending state OFF [17:07:35][D][light:036]: 'voice_assistant_leds' Setting: [17:07:35][D][light:047]: State: OFF [17:07:35][D][light:109]: Effect: 'None' [17:07:35][D][nabu_media_player.pipeline:176]: Reading FLAC file type [17:07:35][D][nabu_media_player.pipeline:186]: Decoded audio has 1 channels, 48000 Hz sample rate, and 16 bits per sample [17:07:35][D][nabu_media_player.pipeline:197]: Converting mono channel audio to stereo channel audio [17:07:36][D][nabu_media_player.decoder:149][ann_decode]: skip decoding: buffer: 0, failed: 0, to-read: 32768 read: 0 avail: 0 [17:07:38][D][micro_wake_word:357]: Detected 'Hey Jarvis' with sliding average probability is 0.99 and max probability is 1.00 [17:07:38][D][media_player:080]: 'Sat1 Media Player' - Setting [17:07:38][D][media_player:084]: Command: STOP [17:07:38][D][media_player:093]: Announcement: yes [17:07:38][D][media_player:080]: 'Sat1 Media Player' - Setting [17:07:38][D][media_player:093]: Announcement: yes [17:07:39][D][nabu_media_player.pipeline:176]: Reading FLAC file type [17:07:39][D][nabu_media_player.pipeline:410][ann_decode]: Creating and starting new AudioDecoder [17:07:39][D][nabu_media_player.decoder:056][ann_decode]: Starting AudioDecoder. [17:07:39][D][nabu_media_player.pipeline:186]: Decoded audio has 1 channels, 48000 Hz sample rate, and 16 bits per sample [17:07:39][D][nabu_media_player.pipeline:197]: Converting mono channel audio to stereo channel audio [17:07:39][D][voice_assistant:516]: State changed from IDLE to START_MICROPHONE [17:07:39][D][voice_assistant:522]: Desired state set to START_PIPELINE [17:07:39][D][voice_assistant:225]: Starting Microphone [17:07:39][D][ring_buffer:034]: Created ring buffer with size 16384 [17:07:39][D][voice_assistant:516]: State changed from START_MICROPHONE to STARTING_MICROPHONE [17:07:39][D][voice_assistant:516]: State changed from STARTING_MICROPHONE to START_PIPELINE [17:07:39][D][voice_assistant:280]: Requesting start... [17:07:39][D][voice_assistant:516]: State changed from START_PIPELINE to STARTING_PIPELINE [17:07:39][D][nabu_media_player.decoder:149][ann_decode]: skip decoding: buffer: 0, failed: 0, to-read: 32768 read: 0 avail: 0 [17:07:39][D][voice_assistant:537]: Client started, streaming microphone [17:07:39][D][voice_assistant:516]: State changed from STARTING_PIPELINE to STREAMING_MICROPHONE [17:07:39][D][voice_assistant:522]: Desired state set to STREAMING_MICROPHONE [17:07:39][D][voice_assistant:639]: Event Type: 1 [17:07:39][D][voice_assistant:642]: Assist Pipeline running [17:07:39][D][voice_assistant:639]: Event Type: 3 [17:07:39][D][voice_assistant:653]: STT started [17:07:39][D][light:036]: 'voice_assistant_leds' Setting: [17:07:39][D][light:047]: State: ON [17:07:39][D][light:051]: Brightness: 66% [17:07:39][D][light:109]: Effect: 'Waiting for Command' [17:07:41][D][voice_assistant:639]: Event Type: 11 [17:07:41][D][voice_assistant:802]: Starting STT by VAD [17:07:41][D][light:036]: 'voice_assistant_leds' Setting: [17:07:41][D][light:051]: Brightness: 66% [17:07:41][D][light:109]: Effect: 'Listening For Command' [17:07:43][D][voice_assistant:639]: Event Type: 12 [17:07:43][D][voice_assistant:806]: STT by VAD end [17:07:43][D][voice_assistant:516]: State changed from STREAMING_MICROPHONE to STOP_MICROPHONE [17:07:43][D][voice_assistant:522]: Desired state set to AWAITING_RESPONSE [17:07:43][D][voice_assistant:516]: State changed from STOP_MICROPHONE to STOPPING_MICROPHONE [17:07:43][D][light:036]: 'voice_assistant_leds' Setting: [17:07:43][D][light:051]: Brightness: 66% [17:07:43][D][light:109]: Effect: 'Thinking' [17:07:43][D][voice_assistant:516]: State changed from STOPPING_MICROPHONE to AWAITING_RESPONSE [17:07:43][D][voice_assistant:516]: State changed from AWAITING_RESPONSE to AWAITING_RESPONSE [17:07:43][D][voice_assistant:639]: Event Type: 4 [17:07:43][D][voice_assistant:667]: Speech recognised as: " Tell me a short story." [17:07:43][D][voice_assistant:639]: Event Type: 5 [17:07:43][D][voice_assistant:672]: Intent started [17:07:46][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:07:46][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:07:47][D][voice_assistant:639]: Event Type: 6 [17:07:47][D][voice_assistant:639]: Event Type: 7 [17:07:47][D][voice_assistant:695]: Response: "Once, in a small village nestled between two great mountains, there lived an old man named Kaito. Kaito was known throughout the village for his extraordinary ability to hear the whispers of the wind. [17:07:47] [17:07:47]As a child, Kaito had always been fascinated by the gentle rustling of leaves and the soft caress of breeze on his skin. He would spend hours sitting by the window, listening intently to the whispers that seemed to carry secrets from far-off lands. [17:07:47] [17:07:47]As he grew olde [17:07:47][D][light:036]: 'voice_assistant_leds' Setting: [17:07:47][D][light:051]: Brightness: 66% [17:07:47][D][light:109]: Effect: 'Replying' [17:07:47][D][voice_assistant:639]: Event Type: 8 [17:07:47][D][voice_assistant:717]: Response URL: "https://mikejulie4us.duckdns.org:8123/api/tts_proxy/X42PE2pS_9EEUms18JiHlA.flac" [17:07:47][D][voice_assistant:516]: State changed from AWAITING_RESPONSE to STREAMING_RESPONSE [17:07:47][D][voice_assistant:522]: Desired state set to STREAMING_RESPONSE [17:07:47][D][media_player:080]: 'Sat1 Media Player' - Setting [17:07:47][D][media_player:087]: Media URL: https://mikejulie4us.duckdns.org:8123/api/tts_proxy/X42PE2pS_9EEUms18JiHlA.flac [17:07:47][D][media_player:093]: Announcement: yes [17:07:47][D][voice_assistant:639]: Event Type: 2 [17:07:47][D][voice_assistant:731]: Assist Pipeline ended [17:07:47] [17:07:47]***ERROR*** A stack overflow in task ann_read has been detected. [17:07:47] [17:07:47] [17:07:47]Backtrace: 0x403783e2:0x3fcde0e0 0x40381ce5:0x3fcde100 0x4038590a:0x3fcde120 0x40383944:0x3fcde1a0 0x40381d9c:0x3fcde1d0 0x40381d92:0x3fcde1e0 0x733ffffc:0x420deb5c |<-CORRUPTED [17:07:47] [17:07:47] [17:07:47] [17:07:47] [17:07:47]ELF file SHA256: 79423943e134e5c9 [17:07:47] [17:07:47]Rebooting... [17:07:47]ESP-ROM:esp32s3-20210327 [17:07:47]Build:Mar 27 2021 [17:07:47]rst:0xc (RTC_SW_CPU_RST),boot:0x2b (SPI_FAST_FLASH_BOOT) [17:07:47]Saved PC:0x42163c4a [17:07:47]SPIWP:0xee [17:07:47]mode:DIO, clock div:1 [17:07:47]load:0x3fce3808,len:0x16c4 [17:07:47]load:0x403c9700,len:0xbc0 [17:07:47]load:0x403cc700,len:0x2e90 [17:07:47]entry 0x403c9950 [17:07:47]I (24) boot: ESP-IDF 4.4.8 2nd stage bootloader [17:07:47]I (24) boot: compile time 19:04:16 [17:07:47]I (24) boot: Multicore bootloader [17:07:47]I (26) boot: chip revision: v0.2 [17:07:47]I (30) boot.esp32s3: Boot SPI Speed : 80MHz [17:07:47]I (35) boot.esp32s3: SPI Mode : DIO [17:07:47]I (39) boot.esp32s3: SPI Flash Size : 16MB [17:07:47]I (44) boot: Enabling RNG early entropy source... [17:07:47]I (50) boot: Partition Table: [17:07:47]I (53) boot: ## Label Usage Type ST Offset Length [17:07:47]I (60) boot: 0 otadata OTA data 01 00 00009000 00002000 [17:07:47]I (68) boot: 1 phy_init RF data 01 01 0000b000 00001000 [17:07:47]I (75) boot: 2 app0 OTA app 00 10 00010000 007c0000 [17:07:47]I (83) boot: 3 app1 OTA app 00 11 007d0000 007c0000 [17:07:47]I (90) boot: 4 nvs WiFi data 01 02 00f90000 0006d000 [17:07:47]I (98) boot: End of partition table [17:07:47]I (102) esp_image: segment 0: paddr=00010020 vaddr=3c170020 size=1469b4h (1337780) map [17:07:47]I (352) esp_image: segment 1: paddr=001569dc vaddr=3fc9dc70 size=04974h ( 18804) load [17:07:47]I (356) esp_image: segment 2: paddr=0015b358 vaddr=40374000 size=04cc0h ( 19648) load [17:07:47]I (362) esp_image: segment 3: paddr=00160020 vaddr=42000020 size=16cf90h (1494928) map [17:07:47]I (635) esp_image: segment 4: paddr=002ccfb8 vaddr=40378cc0 size=14fa8h ( 85928) load [17:07:47]I (664) boot: Loaded app from partition at offset 0x10000 [17:07:47]I (665) boot: Disabling RNG early entropy source... [17:07:47]I (665) cpu_start: Multicore app [17:07:47]I (669) opi psram: vendor id : 0x0d (AP) [17:07:47]I (673) opi psram: dev id : 0x02 (generation 3) [17:07:47]I (679) opi psram: density : 0x03 (64 Mbit) [17:07:47]I (684) opi psram: good-die : 0x01 (Pass) [17:07:47]I (689) opi psram: Latency : 0x01 (Fixed) [17:07:47]I (693) opi psram: VCC : 0x01 (3V) [17:07:47]I (698) opi psram: SRF : 0x01 (Fast Refresh) [17:07:47]I (704) opi psram: BurstType : 0x01 (Hybrid Wrap) [17:07:47]I (709) opi psram: BurstLen : 0x01 (32 Byte) [17:07:47]I (714) opi psram: Readlatency : 0x02 (10 cycles@Fixed) [17:07:47]I (720) opi psram: DriveStrength: 0x00 (1/1) [17:07:47]I (726) MSPI Timing: PSRAM timing tuning index: 5 [17:07:48]I (730) spiram: Found 64MBit SPI RAM device [17:07:48]I (735) spiram: SPI RAM mode: sram 80m [17:07:48]I (740) spiram: PSRAM initialized, cache is in normal (1-core) mode. [17:07:48]I (747) cpu_start: Pro cpu up. [17:07:48]I (750) cpu_start: Starting app cpu, entry point is 0x403779a8 [17:07:48]I (739) cpu_start: App cpu up. [17:07:48]I (1183) spiram: SPI SRAM memory test OK [17:07:48]I (1192) cpu_start: Pro cpu start user code [17:07:48]I (1192) cpu_start: cpu freq: 160000000 [17:07:48]I (1192) cpu_start: Application information: [17:07:48]I (1192) cpu_start: Project name: satellite1 [17:07:48]I (1192) cpu_start: App version: 2024.11.2 [17:07:48]I (1192) cpu_start: Compile time: Dec 6 2024 18:59:28 [17:07:48]I (1193) cpu_start: ELF file SHA256: 79423943e134e5c9... [17:07:48]I (1193) cpu_start: ESP-IDF: 4.4.8 [17:07:48]I (1193) cpu_start: Min chip rev: v0.0 [17:07:48]I (1193) cpu_start: Max chip rev: v0.99 [17:07:48]I (1194) cpu_start: Chip rev: v0.2 [17:07:48]I (1194) heap_init: Initializing. RAM available for dynamic allocation: [17:07:48]I (1194) heap_init: At 3FCA91A0 len 00040570 (257 KiB): D/IRAM [17:07:48]I (1195) heap_init: At 3FCE9710 len 00005724 (21 KiB): STACK/DIRAM [17:07:48]I (1195) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM [17:07:48]I (1195) heap_init: At 600FE000 len 00002000 (8 KiB): RTCRAM [17:07:48]I (1196) spiram: Adding pool of 8192K of external SPI memory to heap allocator [17:07:48]I (1196) spi_flash: detected chip: gd [17:07:48]I (1197) spi_flash: flash io: dio [17:07:48]I (1200) sleep: Configure to isolate all GPIO pins in sleep state [17:07:48]I (1200) sleep: Enable automatic switching of GPIO sleep configuration [17:07:48]I (1201) coexist: coexist rom version e7ae62f [17:07:48]I (1201) cpu_start: Starting scheduler on PRO CPU. [17:07:48]I (0) cpu_start: Starting scheduler on APP CPU. [17:07:48][I][logger:171]: Log initialized [17:07:48][C][status_led:014]: Setting up Status LED... [17:07:48][D][esp-idf:000]: I (181) gpio: GPIO[45]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:07:48] [17:07:48][C][safe_mode:079]: There have been 0 suspected unsuccessful boot attempts [17:07:48][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:07:48][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:07:48][I][app:029]: Running through setup()... [17:07:48][C][i2c.idf:017]: Setting up I2C bus... [17:07:48][I][i2c.idf:252]: Performing I2C bus recovery [17:07:48][D][esp-idf:000]: I (1628) gpio: GPIO[6]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:07:48] [17:07:48][D][esp-idf:000]: I (1630) gpio: GPIO[5]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:07:48] [17:07:48][D][spi:035]: Setting up SPI bus... [17:07:48][D][spi_device:362]: mode 3, data_rate 8000kHz [17:07:48][D][esp-idf:000]: I (1647) gpio: GPIO[10]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:07:48] [17:07:48][D][esp-idf:000]: I (1649) gpio: GPIO[4]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:07:48] [17:07:48][I][Satellite1:172]: XMOS Firmware Version: 6.0.7 [17:07:48][D][number:012]: 'Offset Temperature': Sending state 0.000000 [17:07:48][D][number:012]: 'Offset Humidity': Sending state 0.000000 [17:07:48][D][fusb302b:360]: reported device id: 145 [17:07:48][D][fusb302b:133]: FUSB302 found, initializing... [17:07:48][C][esp32_rmt_led_strip:021]: Setting up ESP32 LED Strip... [17:07:48][D][binary_sensor:034]: 'Button Left (HW Mute)': Sending initial state OFF [17:07:48][D][binary_sensor:034]: 'Button Up (Vol+)': Sending initial state OFF [17:07:48][D][binary_sensor:034]: 'Button Down (Vol-)': Sending initial state OFF [17:07:48][D][esp-idf:000]: I (1866) gpio: GPIO[0]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0 [17:07:48] [17:07:48][D][binary_sensor:034]: 'Button Right (Action)': Sending initial state OFF [17:07:48][C][light:021]: Setting up light 'hw_led_ring'... [17:07:48][D][light:036]: 'hw_led_ring' Setting: [17:07:48][D][light:041]: Color mode: RGB [17:07:48][D][light:085]: Transition length: 1.0s [17:07:48][C][light:021]: Setting up light 'LED Ring'... [17:07:48][D][light:036]: 'LED Ring' Setting: [17:07:48][D][light:041]: Color mode: RGB [17:07:48][D][light:051]: Brightness: 66% [17:07:49][D][light:055]: Color brightness: 100% [17:07:49][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:07:49][C][light:021]: Setting up light 'voice_assistant_leds'... [17:07:49][D][light:036]: 'voice_assistant_leds' Setting: [17:07:49][D][light:041]: Color mode: RGB [17:07:49][D][template.switch:046]: Restored state ON [17:07:49][D][switch:012]: 'Wake sound' Turning ON. [17:07:49][D][switch:055]: 'Wake sound': Sending state ON [17:07:49][D][template.switch:046]: Restored state OFF [17:07:49][D][switch:016]: 'Mute Microphones' Turning OFF. [17:07:49][D][switch:055]: 'Mute Microphones': Sending state OFF [17:07:49][D][light:036]: 'voice_assistant_leds' Setting: [17:07:49][D][light:047]: State: ON [17:07:49][D][light:051]: Brightness: 66% [17:07:49][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:07:49][D][template.switch:046]: Restored state OFF [17:07:49][D][switch:016]: 'timer_ringing' Turning OFF. [17:07:49][D][switch:055]: 'timer_ringing': Sending state OFF [17:07:49][D][light:036]: 'voice_assistant_leds' Setting: [17:07:49][D][light:051]: Brightness: 66% [17:07:49][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:07:49][D][template.switch:046]: Restored state OFF [17:07:49][D][switch:016]: 'Beta firmware' Turning OFF. [17:07:49][D][switch:055]: 'Beta firmware': Sending state OFF [17:07:49][D][main:103]: OTA updates set to use Production firmware [17:07:49][C][i2s_audio:024]: Setting up I2S Audio... [17:07:49][C][aht10:046]: Setting up AHT20 [17:07:49][C][ltr_als_ps:066]: Setting up LTR-303/329/55x/659 [17:07:49][D][pcm5122:021]: PCM5122 chip found. [17:07:49][D][tas2780:041]: TAS2780 chip found. [17:07:49][D][tas2780:042]: Reg 0x68: 127. [17:07:49][D][tas2780:043]: Reg 0x02: 26. [17:07:49][C][i2s_audio.microphone:075]: Setting up I2S Audio Microphone... [17:07:49][D][ring_buffer:034]: Created ring buffer with size 6144 [17:07:49][D][ring_buffer:034]: Created ring buffer with size 6144 [17:07:49][D][main:779]: FutureProofHomes Satellite1 Core version v1.0.0-beta.1 running ESP firmware: v0.0.4 and XMOS firmware: v1.0.1-alpha.33 [17:07:49][D][light:036]: 'voice_assistant_leds' Setting: [17:07:49][D][light:051]: Brightness: 66% [17:07:49][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:07:49][C][esp32_ble:032]: Setting up BLE... [17:07:49][C][wifi:048]: Setting up WiFi... [17:07:49][D][esp-idf:000]: I (1986) pp: pp rom version: e7ae62f [17:07:49] [17:07:49][D][esp-idf:000]: I (1987) net80211: net80211 rom version: e7ae62f [17:07:49] [17:07:49][D][esp-idf:000]: I (1989) wifi: [17:07:49][D][esp-idf:000]: wifi driver task: 3fcb5a10, prio:23, stack:6656, core=0 [17:07:49][D][esp-idf:000]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (1991) system_api: Base MAC address is not set [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (1992) system_api: read default base MAC address from EFUSE [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (1995) wifi: [17:07:49][D][esp-idf:000][wifi]: wifi firmware version: ff661c3 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (1997) wifi: [17:07:49][D][esp-idf:000][wifi]: wifi certification version: v7.0 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (1999) wifi: [17:07:49][D][esp-idf:000][wifi]: config NVS flash: enabled [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (2001) wifi: [17:07:49][D][esp-idf:000][wifi]: config nano formating: disabled [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (2003) wifi: [17:07:49][D][esp-idf:000][wifi]: Init data frame dynamic rx buffer num: 32 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (2005) wifi: [17:07:49][D][esp-idf:000][wifi]: Init static rx mgmt buffer num: 5 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (2007) wifi: [17:07:49][D][esp-idf:000][wifi]: Init management short buffer num: 32 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (2009) wifi: [17:07:49][D][esp-idf:000][wifi]: Init dynamic tx buffer num: 32 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (2012) wifi: [17:07:49][D][esp-idf:000][wifi]: Init tx cache buffer num: 32 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (2014) wifi: [17:07:49][D][esp-idf:000][wifi]: Init static tx FG buffer num: 2 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (2016) wifi: [17:07:49][D][esp-idf:000][wifi]: Init static rx buffer size: 1600 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (2018) wifi: [17:07:49][D][esp-idf:000][wifi]: Init static rx buffer num: 16 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000][wifi]: I (2020) wifi: [17:07:49][D][esp-idf:000][wifi]: Init dynamic rx buffer num: 32 [17:07:49][D][esp-idf:000][wifi]: [17:07:49] [17:07:49][D][esp-idf:000]: I (2022) wifi_init: rx ba win: 16 [17:07:49] [17:07:49][D][esp-idf:000]: I (2023) wifi_init: tcpip mbox: 32 [17:07:49] [17:07:49][D][esp-idf:000]: I (2024) wifi_init: udp mbox: 6 [17:07:49] [17:07:49][D][esp-idf:000]: I (2025) wifi_init: tcp mbox: 6 [17:07:49] [17:07:49][D][esp-idf:000]: I (2026) wifi_init: tcp tx win: 5760 [17:07:49] [17:07:49][D][esp-idf:000]: I (2026) wifi_init: tcp rx win: 5760 [17:07:49] [17:07:49][D][esp-idf:000]: I (2027) wifi_init: tcp mss: 1440 [17:07:49] [17:07:49][D][esp-idf:000]: I (2028) wifi_init: WiFi/LWIP prefer SPIRAM [17:07:49] [17:07:49][D][esp-idf:000]: I (2029) wifi_init: WiFi IRAM OP enabled [17:07:49] [17:07:49][D][esp-idf:000]: I (2030) wifi_init: WiFi RX IRAM OP enabled [17:07:49] [17:07:49][C][wifi:061]: Starting WiFi... [17:07:49][C][wifi:062]: Local MAC: D8:3B:DA:40:78:70 [17:07:49][D][wifi:074]: Loaded saved wifi settings: HomeNet [17:07:49][D][esp-idf:000][wifi]: I (2035) phy_init: phy_version 670,b7bc9b9,Apr 30 2024,10:54:13 [17:07:50] [17:07:50][D][esp-idf:000][wifi]: I (2073) wifi: [17:07:50][D][esp-idf:000][wifi]: mode : sta (d8:3b:da:40:78:70) [17:07:50][D][esp-idf:000][wifi]: [17:07:50] [17:07:50][D][esp-idf:000][wifi]: I (2075) wifi: [17:07:50][D][esp-idf:000][wifi]: enable tsf [17:07:50][D][esp-idf:000][wifi]: [17:07:50] [17:07:50][D][esp-idf:000][wifi]: I (2078) wifi: [17:07:50][D][esp-idf:000][wifi]: Set ps type: 1 [17:07:50] [17:07:50][D][esp-idf:000][wifi]: [17:07:50] [17:07:50][D][wifi:482]: Starting scan... [17:07:50][D][esp32.preferences:114]: Saving 4 preferences to flash... [17:07:50][D][esp32.preferences:143]: Saving 4 preferences to flash: 4 cached, 0 written, 0 failed [17:07:50][D][aht10:115]: ATH10 Unrealistic humidity (0x0), retrying... [17:07:50][D][esp-idf:000][wifi]: I (2092) wifi: [17:07:50][D][esp-idf:000][wifi]: Set ps type: 1 [17:07:50] [17:07:50][D][esp-idf:000][wifi]: [17:07:50] [17:07:50][W][component:157]: Component wifi set Warning flag: scanning for networks [17:07:50][I][Satellite1:172]: XMOS Firmware Version: 0.0.7 [17:07:50][D][esp32_ble:284]: Enabling BLE... [17:07:50][D][esp-idf:000]: I (2116) BLE_INIT: BT controller compile version [ba3b3e3] [17:07:50] [17:07:50][D][esp-idf:000][btController]: I (2118) BLE_INIT: Bluetooth MAC: d8:3b:da:40:78:72 [17:07:50] [17:07:50] [17:07:50][D][aht10:097]: Read attempt 2 at 688ms [17:07:50][D][aht10:124]: Success at 690ms [17:07:50][D][sensor:094]: 'Temperature': Sending state 32.15854 °C with 2 decimals of accuracy [17:07:50][D][sensor:094]: 'Humidity': Sending state 41.60154 % with 2 decimals of accuracy [17:07:50][D][esp32_ble_server:077]: BLE server setup successfully [17:07:50][D][esp32_improv.component:082]: Creating Improv service [17:07:50][D][light:036]: 'voice_assistant_leds' Setting: [17:07:50][D][light:051]: Brightness: 66% [17:07:50][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:07:50][D][text_sensor:064]: 'XMOS Firmware': Sending state 'v0.0.7' [17:07:57][D][wifi:497]: Found networks: [17:07:57][I][wifi:541]: - 'HomeNet' (1E:E8:29:91:CA:92) [redacted]▂▄▆█ [17:07:57][D][wifi:542]: Channel: 11 [17:07:57][D][wifi:543]: RSSI: -59 dB [17:07:57][I][wifi:541]: - 'HomeNet' (0A:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:07:57][D][wifi:542]: Channel: 6 [17:07:57][D][wifi:543]: RSSI: -81 dB [17:07:57][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:92) [redacted]▂▄▆█ [17:07:57][D][wifi:546]: - ''[redacted] (88:DE:A9:35:1B:7F) [redacted]▂▄▆█ [17:07:57][D][wifi:546]: - 'IotWifi'[redacted] (04:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:07:57][D][wifi:546]: - ''[redacted] (BE:D7:D4:34:FA:3F) [redacted]▂▄▆█ [17:07:57][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:1F) [redacted]▂▄▆█ [17:07:57][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:07:57][D][esp-idf:000][wifi]: I (10573) wifi: [17:07:57][D][esp-idf:000][wifi]: new:<11,0>, old:<1,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:07:57][D][esp-idf:000][wifi]: [17:07:57] [17:07:57][D][esp-idf:000][wifi]: I (10577) wifi: [17:07:57][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:07:57][D][esp-idf:000][wifi]: [17:07:57] [17:07:58][D][esp-idf:000][wifi]: I (11558) wifi: [17:07:58][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:07:58][D][esp-idf:000][wifi]: [17:07:58] [17:07:58][D][esp-idf:000][wifi]: I (11567) wifi: [17:07:58][D][esp-idf:000][wifi]: state: assoc -> run (10) [17:07:58][D][esp-idf:000][wifi]: [17:07:58] [17:07:58][D][esp-idf:000][wifi]: I (11604) wifi: [17:07:58][D][esp-idf:000][wifi]: connected with HomeNet, aid = 4, channel 11, BW20, bssid = 1e:e8:29:91:ca:92 [17:07:58][D][esp-idf:000][wifi]: [17:07:58] [17:07:58][D][esp-idf:000][wifi]: I (11607) wifi: [17:07:58][D][esp-idf:000][wifi]: security: WPA3-SAE, phy: bgn, rssi: -58 [17:07:58][D][esp-idf:000][wifi]: [17:07:58] [17:07:58][D][esp-idf:000][wifi]: I (11609) wifi: [17:07:58][D][esp-idf:000][wifi]: pm start, type: 1 [17:07:58] [17:07:58][D][esp-idf:000][wifi]: [17:07:58] [17:07:58][D][esp-idf:000][wifi]: I (11611) wifi: [17:07:58][D][esp-idf:000][wifi]: set rx beacon pti, rx_bcn_pti: 14, bcn_timeout: 14, mt_pti: 25000, mt_time: 10000 [17:07:58][D][esp-idf:000][wifi]: [17:07:58] [17:07:58][D][esp-idf:000][wifi]: I (11621) wifi: [17:07:58][D][esp-idf:000][wifi]: idx:0 (ifx:0, 1e:e8:29:91:ca:92), tid:6, ssn:2, winSize:64 [17:07:58][D][esp-idf:000][wifi]: [17:07:58] [17:07:58][D][esp-idf:000][wifi]: I (11625) wifi: [17:07:58][D][esp-idf:000][wifi]: AP's beacon interval = 102400 us, DTIM period = 1 [17:07:58][D][esp-idf:000][wifi]: [17:07:58] [17:07:59][D][esp-idf:000][sys_evt]: I (12615) esp_netif_handlers: sta ip: 192.168.3.215, mask: 255.255.255.0, gw: 192.168.3.1 [17:07:59] [17:07:59][I][wifi:617]: WiFi Connected! [17:07:59][C][wifi:428]: Local MAC: D8:3B:DA:40:78:70 [17:07:59][C][wifi:433]: SSID: 'HomeNet'[redacted] [17:07:59][C][wifi:436]: IP Address: 192.168.3.215 [17:07:59][C][wifi:440]: BSSID: 1E:E8:29:91:CA:92[redacted] [17:07:59][C][wifi:441]: Hostname: 'satellite1-407870' [17:07:59][C][wifi:443]: Signal strength: -59 dB ▂▄▆█ [17:07:59][C][wifi:447]: Channel: 11 [17:07:59][C][wifi:448]: Subnet: 255.255.255.0 [17:07:59][C][wifi:449]: Gateway: 192.168.3.1 [17:07:59][C][wifi:450]: DNS1: 192.168.3.152 [17:07:59][C][wifi:451]: DNS2: 0.0.0.0 [17:07:59][C][api:026]: Setting up Home Assistant API server... [17:07:59][C][micro_wake_word:083]: Setting up microWakeWord... [17:07:59][C][micro_wake_word:109]: Micro Wake Word initialized [17:07:59][I][nabu_media_player:138]: Set up nabu media player [17:07:59][I][app:062]: setup() finished successfully! [17:07:59][D][esp-idf:000][wifi]: I (12655) wifi: [17:07:59][D][esp-idf:000][wifi]: idx:1 (ifx:0, 1e:e8:29:91:ca:92), tid:0, ssn:0, winSize:64 [17:07:59][D][esp-idf:000][wifi]: [17:07:59] [17:07:59][D][esp-idf:000]: I (12817) esp-x509-crt-bundle: Certificate validated [17:07:59] [17:08:00][D][update:011]: 'Satellite1 407870' - Publishing: [17:08:00][D][update:012]: Current Version: v0.0.4 [17:08:00][D][update:015]: Latest Version: v0.0.4 [17:08:00][D][update:018]: Firmware URL: https://raw.githubusercontent.com/FutureProofHomes/Documentation/refs/heads/main/assets/firmware/esphome/production/satellite1-esp32s3.ota.bin [17:08:00][D][update:021]: Title: ESPHome Firmware for Satellite1-Core-Board [17:08:00][D][update:023]: Summary: ESPHome Firmware for satellite1-esp32s3 [17:08:00][D][update:026]: Release URL: https://github.com/FutureProofHomes/Satellite1-ESPHome/releases/tag/v0.0.4/ [17:08:00][W][component:237]: Component http_request.update took a long time for an operation (850 ms). [17:08:00][W][component:238]: Components should block for at most 30 ms. [17:08:00][D][light:036]: 'voice_assistant_leds' Setting: [17:08:00][D][light:051]: Brightness: 66% [17:08:00][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:08:00][D][light:109]: Effect: 'Twinkle' [17:08:00][W][component:170]: Component wifi cleared Warning flag [17:08:00][W][component:157]: Component api set Warning flag: unspecified [17:08:00][I][app:100]: ESPHome version 2024.11.2 compiled on Dec 6 2024, 18:59:28 [17:08:00][I][app:102]: Project FutureProofHomes.Satellite1 version v0.0.4 [17:08:00][C][status_led:019]: Status LED: [17:08:00][C][status_led:020]: Pin: GPIO45 [17:08:00][C][wifi:600]: WiFi: [17:08:00][C][wifi:428]: Local MAC: D8:3B:DA:40:78:70 [17:08:00][C][wifi:433]: SSID: 'HomeNet'[redacted] [17:08:00][C][wifi:436]: IP Address: 192.168.3.215 [17:08:00][C][wifi:440]: BSSID: 1E:E8:29:91:CA:92[redacted] [17:08:00][C][wifi:441]: Hostname: 'satellite1-407870' [17:08:00][C][wifi:443]: Signal strength: -59 dB ▂▄▆█ [17:08:00][C][wifi:447]: Channel: 11 [17:08:00][C][wifi:448]: Subnet: 255.255.255.0 [17:08:00][C][wifi:449]: Gateway: 192.168.3.1 [17:08:00][C][wifi:450]: DNS1: 192.168.3.152 [17:08:00][C][wifi:451]: DNS2: 0.0.0.0 [17:08:00][C][logger:185]: Logger: [17:08:00][C][logger:186]: Level: DEBUG [17:08:00][C][logger:188]: Log Baud Rate: 115200 [17:08:00][C][logger:189]: Hardware UART: USB_SERIAL_JTAG [17:08:00][C][i2c.idf:075]: I2C Bus: [17:08:00][C][i2c.idf:076]: SDA Pin: GPIO5 [17:08:00][C][i2c.idf:077]: SCL Pin: GPIO6 [17:08:00][C][i2c.idf:078]: Frequency: 400000 Hz [17:08:00][C][i2c.idf:084]: Recovery: bus successfully recovered [17:08:00][I][i2c.idf:094]: Results from i2c bus scan: [17:08:01][I][i2c.idf:100]: Found i2c device at address 0x22 [17:08:01][I][i2c.idf:100]: Found i2c device at address 0x29 [17:08:01][I][i2c.idf:100]: Found i2c device at address 0x38 [17:08:01][I][i2c.idf:100]: Found i2c device at address 0x3F [17:08:01][I][i2c.idf:100]: Found i2c device at address 0x4D [17:08:01][C][spi:064]: SPI bus: [17:08:01][C][spi:065]: CLK Pin: GPIO12 [17:08:01][C][spi:066]: SDI Pin: GPIO13 [17:08:01][C][spi:067]: SDO Pin: GPIO11 [17:08:01][C][spi:072]: Using HW SPI: SPI2_HOST [17:08:01][C][Satellite1:027]: Satellite1 config: [17:08:01][C][template.number:050]: Template Number 'Offset Temperature' [17:08:01][C][template.number:050]: Icon: 'mdi:thermometer' [17:08:01][C][template.number:050]: Unit of Measurement: '°C' [17:08:01][C][template.number:051]: Optimistic: YES [17:08:01][C][template.number:052]: Update Interval: never [17:08:01][C][template.number:050]: Template Number 'Offset Humidity' [17:08:01][C][template.number:050]: Icon: 'mdi:water-percent' [17:08:01][C][template.number:050]: Unit of Measurement: '%' [17:08:01][C][template.number:051]: Optimistic: YES [17:08:01][C][template.number:052]: Update Interval: never [17:08:01][C][template.text_sensor:020]: Template Sensor 'USB-C Power Draw' [17:08:01][C][template.text_sensor:020]: Icon: 'mdi:usb-c-port' [17:08:01][C][template.text_sensor:020]: Template Sensor 'XMOS Firmware' [17:08:01][C][template.text_sensor:020]: Icon: 'mdi:memory' [17:08:01][C][esp32_rmt_led_strip:187]: ESP32 RMT LED Strip: [17:08:01][C][esp32_rmt_led_strip:188]: Pin: 21 [17:08:01][C][esp32_rmt_led_strip:189]: Channel: 1 [17:08:01][C][esp32_rmt_led_strip:214]: RGB Order: GRB [17:08:01][C][esp32_rmt_led_strip:215]: Max refresh rate: 0 [17:08:01][C][esp32_rmt_led_strip:216]: Number of LEDs: 24 [17:08:01][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Left (HW Mute)' [17:08:01][C][gpio.binary_sensor:016]: Pin: [17:08:01][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Up (Vol+)' [17:08:01][C][gpio.binary_sensor:016]: Pin: [17:08:01][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Down (Vol-)' [17:08:01][C][gpio.binary_sensor:016]: Pin: [17:08:01][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Right (Action)' [17:08:01][C][gpio.binary_sensor:016]: Pin: GPIO0 [17:08:01][C][light:092]: Light 'hw_led_ring' [17:08:01][C][light:094]: Default Transition Length: 1.0s [17:08:01][C][light:095]: Gamma Correct: 2.80 [17:08:01][C][light:092]: Light 'LED Ring' [17:08:01][C][light:094]: Default Transition Length: 0.0s [17:08:01][C][light:095]: Gamma Correct: 2.80 [17:08:01][C][light:092]: Light 'voice_assistant_leds' [17:08:01][C][light:094]: Default Transition Length: 0.0s [17:08:01][C][light:095]: Gamma Correct: 2.80 [17:08:01][C][template.switch:068]: Template Switch 'Wake sound' [17:08:01][C][template.switch:070]: Icon: 'mdi:bullhorn' [17:08:01][C][template.switch:091]: Restore Mode: restore defaults to ON [17:08:01][C][template.switch:057]: Optimistic: YES [17:08:01][C][template.switch:068]: Template Switch 'Mute Microphones' [17:08:01][C][template.switch:070]: Icon: 'mdi:microphone-off' [17:08:01][C][template.switch:091]: Restore Mode: restore defaults to OFF [17:08:01][C][template.switch:057]: Optimistic: NO [17:08:01][C][template.switch:068]: Template Switch 'timer_ringing' [17:08:01][C][template.switch:091]: Restore Mode: always OFF [17:08:01][C][template.switch:057]: Optimistic: YES [17:08:01][C][template.switch:068]: Template Switch 'Beta firmware' [17:08:01][C][template.switch:070]: Icon: 'mdi:test-tube' [17:08:01][C][template.switch:091]: Restore Mode: restore defaults to OFF [17:08:01][C][template.switch:057]: Optimistic: YES [17:08:01][C][psram:020]: PSRAM: [17:08:01][C][psram:021]: Available: YES [17:08:01][C][psram:024]: Size: 8191 KB [17:08:01][C][i2s_audio:028]: I2SController: [17:08:01][C][i2s_audio:029]: AccessMode: duplex [17:08:01][C][i2s_audio:030]: Port: 0 [17:08:01][C][i2s_audio:032]: Reader registered. [17:08:01][C][i2s_audio:035]: Writer registered. [17:08:01][C][aht10:162]: AHT10: [17:08:01][C][aht10:163]: Address: 0x38 [17:08:02][C][aht10:167]: Temperature 'Temperature' [17:08:02][C][aht10:167]: Device Class: 'temperature' [17:08:02][C][aht10:167]: State Class: 'measurement' [17:08:02][C][aht10:167]: Unit of Measurement: '°C' [17:08:02][C][aht10:167]: Accuracy Decimals: 2 [17:08:02][C][aht10:168]: Humidity 'Humidity' [17:08:02][C][aht10:168]: Device Class: 'humidity' [17:08:02][C][aht10:168]: State Class: 'measurement' [17:08:02][C][aht10:168]: Unit of Measurement: '%' [17:08:02][C][aht10:168]: Accuracy Decimals: 2 [17:08:02][C][ltr_als_ps:085]: Address: 0x29 [17:08:02][C][ltr_als_ps:086]: Device type: ALS only [17:08:02][C][ltr_als_ps:088]: Automatic mode: ON [17:08:02][C][ltr_als_ps:089]: Gain: 1x [17:08:02][C][ltr_als_ps:090]: Integration time: 100 ms [17:08:02][C][ltr_als_ps:091]: Measurement repeat rate: 500 ms [17:08:02][C][ltr_als_ps:092]: Glass attenuation factor: 1.000000 [17:08:02][C][ltr_als_ps:093]: ALS calculated lux 'Ambient light' [17:08:02][C][ltr_als_ps:093]: Device Class: 'illuminance' [17:08:02][C][ltr_als_ps:093]: State Class: 'measurement' [17:08:02][C][ltr_als_ps:093]: Unit of Measurement: 'lx' [17:08:02][C][ltr_als_ps:093]: Accuracy Decimals: 1 [17:08:02][C][ltr_als_ps:093]: Icon: 'mdi:brightness-6' [17:08:02][C][ltr_als_ps:105]: Update Interval: 60.0s [17:08:02][C][restart.button:017]: Restart Button 'Restart Sat1' [17:08:02][C][restart.button:017]: Icon: 'mdi:restart' [17:08:02][C][factory_reset.button:011]: Factory Reset Button 'Factory Reset ESP32 FW' [17:08:02][C][factory_reset.button:011]: Icon: 'mdi:restart-alert' [17:08:02][C][i2s_audio:143]: I2S-Reader (Fixed-CFG): [17:08:02][C][i2s_audio:148]: clk_mode: external [17:08:02][C][i2s_audio:149]: sample-rate: 48000 bits_per_sample: 32 [17:08:02][C][i2s_audio:150]: channel_fmt: 0 channels: 2 [17:08:02][C][i2s_audio:151]: use_apll: no, use_pdm: no [17:08:02][C][memory_flasher:014]: Embedded Image: [17:08:02][C][memory_flasher:016]: Version: 1.0.1 [17:08:02][C][esp32_ble:391]: ESP32 BLE: [17:08:02][C][esp32_ble:393]: MAC address: D8:3B:DA:40:78:72 [17:08:02][C][esp32_ble:394]: IO Capability: none [17:08:02][C][esp32_ble_server:200]: ESP32 BLE Server: [17:08:02][C][esp32_improv.component:269]: ESP32 Improv: [17:08:02][C][esp32_improv.component:271]: Authorizer 'Button Right (Action)' [17:08:02][C][mdns:116]: mDNS: [17:08:02][C][mdns:117]: Hostname: satellite1-407870 [17:08:02][C][esphome.ota:073]: Over-The-Air updates: [17:08:02][C][esphome.ota:074]: Address: satellite1.local:3232 [17:08:02][C][esphome.ota:075]: Version: 2 [17:08:02][C][safe_mode:018]: Safe Mode: [17:08:02][C][safe_mode:020]: Boot considered successful after 60 seconds [17:08:02][C][safe_mode:021]: Invoke after 10 boot attempts [17:08:02][C][safe_mode:023]: Remain in safe mode for 300 seconds [17:08:02][C][http_request.ota:026]: Over-The-Air updates via HTTP request [17:08:02][C][api:140]: API Server: [17:08:02][C][api:141]: Address: satellite1.local:6053 [17:08:02][C][api:145]: Using noise encryption: NO [17:08:02][C][improv_serial:032]: Improv Serial: [17:08:02][C][http_request:013]: HTTP Request: [17:08:02][C][http_request:014]: Timeout: 4500ms [17:08:02][C][http_request:015]: User-Agent: ESPHome/2024.11.2 (https://esphome.io) [17:08:02][C][http_request:016]: Follow redirects: YES [17:08:02][C][http_request:017]: Redirect limit: 3 [17:08:02][C][http_request.idf:022]: Buffer Size RX: 512 [17:08:02][C][http_request.idf:023]: Buffer Size TX: 512 [17:08:02][C][micro_wake_word:072]: microWakeWord: [17:08:02][C][micro_wake_word:073]: models: [17:08:02][C][micro_wake_word:015]: - Wake Word: Hey Jarvis [17:08:02][C][micro_wake_word:016]: Probability cutoff: 0.97 [17:08:02][C][micro_wake_word:017]: Sliding window size: 5 [17:08:02][C][micro_wake_word:015]: - Wake Word: Okay Nabu [17:08:03][C][micro_wake_word:016]: Probability cutoff: 0.97 [17:08:03][C][micro_wake_word:017]: Sliding window size: 5 [17:08:03][C][micro_wake_word:015]: - Wake Word: Stop [17:08:03][C][micro_wake_word:016]: Probability cutoff: 0.50 [17:08:03][C][micro_wake_word:017]: Sliding window size: 5 [17:08:03][C][micro_wake_word:021]: - VAD Model [17:08:03][C][micro_wake_word:022]: Probability cutoff: 0.50 [17:08:03][C][micro_wake_word:023]: Sliding window size: 5 [17:08:03][C][i2s_audio:146]: I2S-Writer (Initial-CFG): [17:08:03][C][i2s_audio:148]: clk_mode: external [17:08:03][C][i2s_audio:149]: sample-rate: 48000 bits_per_sample: 32 [17:08:03][C][i2s_audio:150]: channel_fmt: 0 channels: 2 [17:08:03][C][i2s_audio:151]: use_apll: no, use_pdm: no [17:08:05][D][light:036]: 'voice_assistant_leds' Setting: [17:08:05][D][light:051]: Brightness: 66% [17:08:05][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:08:10][D][light:036]: 'voice_assistant_leds' Setting: [17:08:10][D][light:051]: Brightness: 66% [17:08:10][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:08:10][D][esp32_ble:269]: Disabling BLE... [17:08:10][D][esp-idf:000][BTU_TASK]: W (23535) BT_APPL: bta_dm_disable BTA_DISABLE_DELAY set to 200 ms [17:08:10] [17:08:10][W][component:237]: Component esp32_ble took a long time for an operation (213 ms). [17:08:10][W][component:238]: Components should block for at most 30 ms. [17:08:23][D][sensor:094]: 'Temperature': Sending state 32.37483 °C with 2 decimals of accuracy [17:08:23][D][sensor:094]: 'Humidity': Sending state 40.97517 % with 2 decimals of accuracy [17:08:23][D][api:103]: Accepted 192.168.3.100 [17:08:23][W][component:170]: Component api cleared Warning flag [17:08:24][D][api.connection:1446]: Home Assistant 2025.2.1 (192.168.3.100): Connected successfully [17:08:26][D][micro_wake_word:379]: Starting wake word detection [17:08:26][D][light:036]: 'voice_assistant_leds' Setting: [17:08:26][D][light:047]: State: OFF [17:08:26][D][light:109]: Effect: 'None' [17:08:26][D][i2s_audio:067][microphone_task]: Install driver requested by Reader [17:08:26][D][esp-idf:000][microphone_task]: I (39389) I2S: DMA Malloc info, datalen=blocksize=4088, dma_buf_count=6 [17:08:26] [17:08:26][D][esp-idf:000][microphone_task]: I (39392) I2S: DMA Malloc info, datalen=blocksize=4088, dma_buf_count=6 [17:08:26] [17:08:26][D][i2s_audio:077][microphone_task]: Installing driver : yes [17:08:26][D][i2s_audio.microphone:322]: Starting I2S Audio Microphne [17:08:26][D][i2s_audio.microphone:326]: Started I2S Audio Microphone [17:08:26][D][micro_wake_word:418]: State changed from IDLE to DETECTING_WAKE_WORD [17:08:32][D][micro_wake_word:357]: Detected 'Hey Jarvis' with sliding average probability is 0.99 and max probability is 1.00 [17:08:32][D][media_player:080]: 'Sat1 Media Player' - Setting [17:08:32][D][media_player:084]: Command: STOP [17:08:32][D][media_player:093]: Announcement: yes [17:08:32][D][media_player:080]: 'Sat1 Media Player' - Setting [17:08:32][D][media_player:093]: Announcement: yes [17:08:32][D][ring_buffer:034]: Created ring buffer with size 48000 [17:08:32][D][ring_buffer:034]: Created ring buffer with size 48000 [17:08:32][D][ring_buffer:034]: Created ring buffer with size 16384 [17:08:32][D][i2s_audio:067][speaker_task]: Install driver requested by Writer [17:08:32][D][ring_buffer:034]: Created ring buffer with size 131072 [17:08:32][D][ring_buffer:034]: Created ring buffer with size 65536 [17:08:32][D][nabu_media_player:427]: Starting Media Player Speaker [17:08:32][D][nabu_media_player:430]: Started Media Player Speaker [17:08:32][D][nabu_media_player.pipeline:176]: Reading FLAC file type [17:08:32][D][nabu_media_player.pipeline:410][ann_decode]: Creating and starting new AudioDecoder [17:08:32][D][nabu_media_player.decoder:056][ann_decode]: Starting AudioDecoder. [17:08:32][D][nabu_media_player.pipeline:186]: Decoded audio has 1 channels, 48000 Hz sample rate, and 16 bits per sample [17:08:32][D][nabu_media_player.pipeline:197]: Converting mono channel audio to stereo channel audio [17:08:33][D][voice_assistant:516]: State changed from IDLE to START_MICROPHONE [17:08:33][D][voice_assistant:522]: Desired state set to START_PIPELINE [17:08:33][D][voice_assistant:225]: Starting Microphone [17:08:33][D][ring_buffer:034]: Created ring buffer with size 16384 [17:08:33][D][voice_assistant:516]: State changed from START_MICROPHONE to STARTING_MICROPHONE [17:08:33][D][voice_assistant:516]: State changed from STARTING_MICROPHONE to START_PIPELINE [17:08:33][D][voice_assistant:280]: Requesting start... [17:08:33][D][voice_assistant:516]: State changed from START_PIPELINE to STARTING_PIPELINE [17:08:33][D][voice_assistant:537]: Client started, streaming microphone [17:08:33][D][voice_assistant:516]: State changed from STARTING_PIPELINE to STREAMING_MICROPHONE [17:08:33][D][voice_assistant:522]: Desired state set to STREAMING_MICROPHONE [17:08:33][D][voice_assistant:639]: Event Type: 1 [17:08:33][D][voice_assistant:642]: Assist Pipeline running [17:08:33][D][voice_assistant:639]: Event Type: 3 [17:08:33][D][voice_assistant:653]: STT started [17:08:33][D][light:036]: 'voice_assistant_leds' Setting: [17:08:33][D][light:047]: State: ON [17:08:33][D][light:051]: Brightness: 66% [17:08:33][D][light:109]: Effect: 'Waiting for Command' [17:08:34][D][nabu_media_player.decoder:149][ann_decode]: skip decoding: buffer: 0, failed: 0, to-read: 32768 read: 0 avail: 0 [17:08:34][D][voice_assistant:639]: Event Type: 11 [17:08:34][D][voice_assistant:802]: Starting STT by VAD [17:08:34][D][light:036]: 'voice_assistant_leds' Setting: [17:08:34][D][light:051]: Brightness: 66% [17:08:34][D][light:109]: Effect: 'Listening For Command' [17:08:35][D][voice_assistant:639]: Event Type: 12 [17:08:35][D][voice_assistant:806]: STT by VAD end [17:08:35][D][voice_assistant:516]: State changed from STREAMING_MICROPHONE to STOP_MICROPHONE [17:08:35][D][voice_assistant:522]: Desired state set to AWAITING_RESPONSE [17:08:35][D][voice_assistant:516]: State changed from STOP_MICROPHONE to STOPPING_MICROPHONE [17:08:35][D][light:036]: 'voice_assistant_leds' Setting: [17:08:35][D][light:051]: Brightness: 66% [17:08:35][D][light:109]: Effect: 'Thinking' [17:08:35][D][voice_assistant:516]: State changed from STOPPING_MICROPHONE to AWAITING_RESPONSE [17:08:35][D][voice_assistant:516]: State changed from AWAITING_RESPONSE to AWAITING_RESPONSE [17:08:35][D][voice_assistant:639]: Event Type: 4 [17:08:35][D][voice_assistant:667]: Speech recognised as: " Tell me, joke." [17:08:35][D][voice_assistant:639]: Event Type: 5 [17:08:35][D][voice_assistant:672]: Intent started [17:08:37][D][voice_assistant:639]: Event Type: 6 [17:08:37][D][voice_assistant:639]: Event Type: 7 [17:08:37][D][voice_assistant:695]: Response: "Why couldn't the bicycle stand up by itself? [17:08:37] [17:08:37](Wait for it...) [17:08:37] [17:08:37]Because it was two-tired! (get it?)" [17:08:37][D][light:036]: 'voice_assistant_leds' Setting: [17:08:37][D][light:051]: Brightness: 66% [17:08:37][D][light:109]: Effect: 'Replying' [17:08:37][D][voice_assistant:639]: Event Type: 8 [17:08:37][D][voice_assistant:717]: Response URL: "https://mikejulie4us.duckdns.org:8123/api/tts_proxy/TVC81X0qQYQZt-hJrluiSA.flac" [17:08:37][D][voice_assistant:516]: State changed from AWAITING_RESPONSE to STREAMING_RESPONSE [17:08:37][D][voice_assistant:522]: Desired state set to STREAMING_RESPONSE [17:08:38][D][media_player:080]: 'Sat1 Media Player' - Setting [17:08:38][D][media_player:087]: Media URL: https://mikejulie4us.duckdns.org:8123/api/tts_proxy/TVC81X0qQYQZt-hJrluiSA.flac [17:08:38][D][media_player:093]: Announcement: yes [17:08:38][D][voice_assistant:639]: Event Type: 2 [17:08:38][D][voice_assistant:731]: Assist Pipeline ended [17:08:38] [17:08:38]***ERROR*** A stack overflow in task ann_read has been detected. [17:08:38] [17:08:38] [17:08:38]Backtrace: 0x403783e2:0x3fcbf3b0 0x40381ce5:0x3fcbf3d0 0x4038590a:0x3fcbf3f0 0x40383944:0x3fcbf470 0x40381d9c:0x3fcbf4a0 0x40381d92:0x00000000 |<-CORRUPTED [17:08:38] [17:08:38] [17:08:38] [17:08:38] [17:08:38]ELF file SHA256: 79423943e134e5c9 [17:08:38] [17:08:38]Rebooting... [17:08:38]ESP-ROM:esp32s3-20210327 [17:08:38]Build:Mar 27 2021 [17:08:38]rst:0xc (RTC_SW_CPU_RST),boot:0x2b (SPI_FAST_FLASH_BOOT) [17:08:38]Saved PC:0x40377ff0 [17:08:38]SPIWP:0xee [17:08:38]mode:DIO, clock div:1 [17:08:38]load:0x3fce3808,len:0x16c4 [17:08:38]load:0x403c9700,len:0xbc0 [17:08:38]load:0x403cc700,len:0x2e90 [17:08:38]entry 0x403c9950 [17:08:38]I (24) boot: ESP-IDF 4.4.8 2nd stage bootloader [17:08:38]I (24) boot: compile time 19:04:16 [17:08:38]I (24) boot: Multicore bootloader [17:08:38]I (26) boot: chip revision: v0.2 [17:08:38]I (30) boot.esp32s3: Boot SPI Speed : 80MHz [17:08:38]I (35) boot.esp32s3: SPI Mode : DIO [17:08:38]I (39) boot.esp32s3: SPI Flash Size : 16MB [17:08:38]I (44) boot: Enabling RNG early entropy source... [17:08:38]I (50) boot: Partition Table: [17:08:38]I (53) boot: ## Label Usage Type ST Offset Length [17:08:38]I (60) boot: 0 otadata OTA data 01 00 00009000 00002000 [17:08:38]I (68) boot: 1 phy_init RF data 01 01 0000b000 00001000 [17:08:38]I (75) boot: 2 app0 OTA app 00 10 00010000 007c0000 [17:08:38]I (83) boot: 3 app1 OTA app 00 11 007d0000 007c0000 [17:08:38]I (90) boot: 4 nvs WiFi data 01 02 00f90000 0006d000 [17:08:38]I (98) boot: End of partition table [17:08:38]I (102) esp_image: segment 0: paddr=00010020 vaddr=3c170020 size=1469b4h (1337780) map [17:08:38]I (350) esp_image: segment 1: paddr=001569dc vaddr=3fc9dc70 size=04974h ( 18804) load [17:08:38]I (355) esp_image: segment 2: paddr=0015b358 vaddr=40374000 size=04cc0h ( 19648) load [17:08:38]I (361) esp_image: segment 3: paddr=00160020 vaddr=42000020 size=16cf90h (1494928) map [17:08:38]I (633) esp_image: segment 4: paddr=002ccfb8 vaddr=40378cc0 size=14fa8h ( 85928) load [17:08:38]I (662) boot: Loaded app from partition at offset 0x10000 [17:08:38]I (662) boot: Disabling RNG early entropy source... [17:08:38]I (663) cpu_start: Multicore app [17:08:38]I (667) opi psram: vendor id : 0x0d (AP) [17:08:38]I (671) opi psram: dev id : 0x02 (generation 3) [17:08:38]I (676) opi psram: density : 0x03 (64 Mbit) [17:08:38]I (681) opi psram: good-die : 0x01 (Pass) [17:08:38]I (686) opi psram: Latency : 0x01 (Fixed) [17:08:38]I (691) opi psram: VCC : 0x01 (3V) [17:08:39]I (696) opi psram: SRF : 0x01 (Fast Refresh) [17:08:39]I (701) opi psram: BurstType : 0x01 (Hybrid Wrap) [17:08:39]I (707) opi psram: BurstLen : 0x01 (32 Byte) [17:08:39]I (712) opi psram: Readlatency : 0x02 (10 cycles@Fixed) [17:08:39]I (718) opi psram: DriveStrength: 0x00 (1/1) [17:08:39]I (723) MSPI Timing: PSRAM timing tuning index: 5 [17:08:39]I (728) spiram: Found 64MBit SPI RAM device [17:08:39]I (733) spiram: SPI RAM mode: sram 80m [17:08:39]I (737) spiram: PSRAM initialized, cache is in normal (1-core) mode. [17:08:39]I (744) cpu_start: Pro cpu up. [17:08:39]I (748) cpu_start: Starting app cpu, entry point is 0x403779a8 [17:08:39]I (737) cpu_start: App cpu up. [17:08:39]I (1181) spiram: SPI SRAM memory test OK [17:08:39]I (1189) cpu_start: Pro cpu start user code [17:08:39]I (1189) cpu_start: cpu freq: 160000000 [17:08:39]I (1190) cpu_start: Application information: [17:08:39]I (1190) cpu_start: Project name: satellite1 [17:08:39]I (1190) cpu_start: App version: 2024.11.2 [17:08:39]I (1190) cpu_start: Compile time: Dec 6 2024 18:59:28 [17:08:39]I (1190) cpu_start: ELF file SHA256: 79423943e134e5c9... [17:08:39]I (1191) cpu_start: ESP-IDF: 4.4.8 [17:08:39]I (1191) cpu_start: Min chip rev: v0.0 [17:08:39]I (1191) cpu_start: Max chip rev: v0.99 [17:08:39]I (1191) cpu_start: Chip rev: v0.2 [17:08:39]I (1192) heap_init: Initializing. RAM available for dynamic allocation: [17:08:39]I (1192) heap_init: At 3FCA91A0 len 00040570 (257 KiB): D/IRAM [17:08:39]I (1192) heap_init: At 3FCE9710 len 00005724 (21 KiB): STACK/DIRAM [17:08:39]I (1192) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM [17:08:39]I (1193) heap_init: At 600FE000 len 00002000 (8 KiB): RTCRAM [17:08:39]I (1193) spiram: Adding pool of 8192K of external SPI memory to heap allocator [17:08:39]I (1194) spi_flash: detected chip: gd [17:08:39]I (1195) spi_flash: flash io: dio [17:08:39]I (1197) sleep: Configure to isolate all GPIO pins in sleep state [17:08:39]I (1198) sleep: Enable automatic switching of GPIO sleep configuration [17:08:39]I (1198) coexist: coexist rom version e7ae62f [17:08:39]I (1199) cpu_start: Starting scheduler on PRO CPU. [17:08:39]I (0) cpu_start: Starting scheduler on APP CPU. [17:08:39][I][logger:171]: Log initialized [17:08:39][C][status_led:014]: Setting up Status LED... [17:08:39][D][esp-idf:000]: I (181) gpio: GPIO[45]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:08:39] [17:08:39][C][safe_mode:079]: There have been 1 suspected unsuccessful boot attempts [17:08:39][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:08:39][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:08:39][I][app:029]: Running through setup()... [17:08:39][C][i2c.idf:017]: Setting up I2C bus... [17:08:39][I][i2c.idf:252]: Performing I2C bus recovery [17:08:39][D][esp-idf:000]: I (1635) gpio: GPIO[6]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:08:39] [17:08:39][D][esp-idf:000]: I (1636) gpio: GPIO[5]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:08:39] [17:08:39][D][spi:035]: Setting up SPI bus... [17:08:40][D][spi_device:362]: mode 3, data_rate 8000kHz [17:08:40][D][esp-idf:000]: I (1654) gpio: GPIO[10]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:08:40] [17:08:40][D][esp-idf:000]: I (1656) gpio: GPIO[4]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:08:40] [17:08:40][I][Satellite1:172]: XMOS Firmware Version: 6.0.7 [17:08:40][D][number:012]: 'Offset Temperature': Sending state 0.000000 [17:08:40][D][number:012]: 'Offset Humidity': Sending state 0.000000 [17:08:40][D][fusb302b:360]: reported device id: 145 [17:08:40][D][fusb302b:133]: FUSB302 found, initializing... [17:08:40][C][esp32_rmt_led_strip:021]: Setting up ESP32 LED Strip... [17:08:40][D][binary_sensor:034]: 'Button Left (HW Mute)': Sending initial state OFF [17:08:40][D][binary_sensor:034]: 'Button Up (Vol+)': Sending initial state OFF [17:08:40][D][binary_sensor:034]: 'Button Down (Vol-)': Sending initial state OFF [17:08:40][D][esp-idf:000]: I (1872) gpio: GPIO[0]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0 [17:08:40] [17:08:40][D][binary_sensor:034]: 'Button Right (Action)': Sending initial state OFF [17:08:40][C][light:021]: Setting up light 'hw_led_ring'... [17:08:40][D][light:036]: 'hw_led_ring' Setting: [17:08:40][D][light:041]: Color mode: RGB [17:08:40][D][light:085]: Transition length: 1.0s [17:08:40][C][light:021]: Setting up light 'LED Ring'... [17:08:40][D][light:036]: 'LED Ring' Setting: [17:08:40][D][light:041]: Color mode: RGB [17:08:40][D][light:051]: Brightness: 66% [17:08:40][D][light:055]: Color brightness: 100% [17:08:40][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:08:40][C][light:021]: Setting up light 'voice_assistant_leds'... [17:08:40][D][light:036]: 'voice_assistant_leds' Setting: [17:08:40][D][light:041]: Color mode: RGB [17:08:40][D][template.switch:046]: Restored state ON [17:08:40][D][switch:012]: 'Wake sound' Turning ON. [17:08:40][D][switch:055]: 'Wake sound': Sending state ON [17:08:40][D][template.switch:046]: Restored state OFF [17:08:40][D][switch:016]: 'Mute Microphones' Turning OFF. [17:08:40][D][switch:055]: 'Mute Microphones': Sending state OFF [17:08:40][D][light:036]: 'voice_assistant_leds' Setting: [17:08:40][D][light:047]: State: ON [17:08:40][D][light:051]: Brightness: 66% [17:08:40][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:08:40][D][template.switch:046]: Restored state OFF [17:08:40][D][switch:016]: 'timer_ringing' Turning OFF. [17:08:40][D][switch:055]: 'timer_ringing': Sending state OFF [17:08:40][D][light:036]: 'voice_assistant_leds' Setting: [17:08:40][D][light:051]: Brightness: 66% [17:08:40][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:08:40][D][template.switch:046]: Restored state OFF [17:08:40][D][switch:016]: 'Beta firmware' Turning OFF. [17:08:41][D][switch:055]: 'Beta firmware': Sending state OFF [17:08:41][D][main:103]: OTA updates set to use Production firmware [17:08:41][C][i2s_audio:024]: Setting up I2S Audio... [17:08:41][C][aht10:046]: Setting up AHT20 [17:08:41][C][ltr_als_ps:066]: Setting up LTR-303/329/55x/659 [17:08:41][D][pcm5122:021]: PCM5122 chip found. [17:08:41][D][tas2780:041]: TAS2780 chip found. [17:08:41][D][tas2780:042]: Reg 0x68: 127. [17:08:41][D][tas2780:043]: Reg 0x02: 26. [17:08:41][C][i2s_audio.microphone:075]: Setting up I2S Audio Microphone... [17:08:41][D][ring_buffer:034]: Created ring buffer with size 6144 [17:08:41][D][ring_buffer:034]: Created ring buffer with size 6144 [17:08:41][D][main:779]: FutureProofHomes Satellite1 Core version v1.0.0-beta.1 running ESP firmware: v0.0.4 and XMOS firmware: v1.0.1-alpha.33 [17:08:41][D][light:036]: 'voice_assistant_leds' Setting: [17:08:41][D][light:051]: Brightness: 66% [17:08:41][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:08:41][C][esp32_ble:032]: Setting up BLE... [17:08:41][C][wifi:048]: Setting up WiFi... [17:08:41][D][esp-idf:000]: I (1992) pp: pp rom version: e7ae62f [17:08:41] [17:08:41][D][esp-idf:000]: I (1993) net80211: net80211 rom version: e7ae62f [17:08:41] [17:08:41][D][esp-idf:000]: I (1995) wifi: [17:08:41][D][esp-idf:000]: wifi driver task: 3fcb5a10, prio:23, stack:6656, core=0 [17:08:41][D][esp-idf:000]: [17:08:41] [17:08:41][D][esp-idf:000][wifi]: I (1997) system_api: Base MAC address is not set [17:08:41] [17:08:41][D][esp-idf:000][wifi]: I (1998) system_api: read default base MAC address from EFUSE [17:08:41] [17:08:41][D][esp-idf:000][wifi]: I (2001) wifi: [17:08:41][D][esp-idf:000][wifi]: wifi firmware version: ff661c3 [17:08:41][D][esp-idf:000][wifi]: [17:08:41] [17:08:41][D][esp-idf:000][wifi]: I (2003) wifi: [17:08:41][D][esp-idf:000][wifi]: wifi certification version: v7.0 [17:08:41][D][esp-idf:000][wifi]: [17:08:41] [17:08:41][D][esp-idf:000][wifi]: I (2005) wifi: [17:08:41][D][esp-idf:000][wifi]: config NVS flash: enabled [17:08:41][D][esp-idf:000][wifi]: [17:08:41] [17:08:41][D][esp-idf:000][wifi]: I (2007) wifi: [17:08:41][D][esp-idf:000][wifi]: config nano formating: disabled [17:08:41][D][esp-idf:000][wifi]: [17:08:41] [17:08:41][D][esp-idf:000][wifi]: I (2009) wifi: [17:08:41][D][esp-idf:000][wifi]: Init data frame dynamic rx buffer num: 32 [17:08:41][D][esp-idf:000][wifi]: [17:08:41] [17:08:42][D][esp-idf:000][wifi]: I (2011) wifi: [17:08:42][D][esp-idf:000][wifi]: Init static rx mgmt buffer num: 5 [17:08:42][D][esp-idf:000][wifi]: [17:08:42] [17:08:42][D][esp-idf:000][wifi]: I (2013) wifi: [17:08:42][D][esp-idf:000][wifi]: Init management short buffer num: 32 [17:08:42][D][esp-idf:000][wifi]: [17:08:42] [17:08:42][D][esp-idf:000][wifi]: I (2015) wifi: [17:08:42][D][esp-idf:000][wifi]: Init dynamic tx buffer num: 32 [17:08:42][D][esp-idf:000][wifi]: [17:08:42] [17:08:42][D][esp-idf:000][wifi]: I (2018) wifi: [17:08:42][D][esp-idf:000][wifi]: Init tx cache buffer num: 32 [17:08:42][D][esp-idf:000][wifi]: [17:08:42] [17:08:42][D][esp-idf:000][wifi]: I (2020) wifi: [17:08:42][D][esp-idf:000][wifi]: Init static tx FG buffer num: 2 [17:08:42][D][esp-idf:000][wifi]: [17:08:42] [17:08:42][D][esp-idf:000][wifi]: I (2022) wifi: [17:08:42][D][esp-idf:000][wifi]: Init static rx buffer size: 1600 [17:08:42][D][esp-idf:000][wifi]: [17:08:42] [17:08:42][D][esp-idf:000][wifi]: I (2024) wifi: [17:08:42][D][esp-idf:000][wifi]: Init static rx buffer num: 16 [17:08:42][D][esp-idf:000][wifi]: [17:08:42] [17:08:42][D][esp-idf:000][wifi]: I (2026) wifi: [17:08:42][D][esp-idf:000][wifi]: Init dynamic rx buffer num: 32 [17:08:42][D][esp-idf:000][wifi]: [17:08:42] [17:08:42][D][esp-idf:000]: I (2028) wifi_init: rx ba win: 16 [17:08:42] [17:08:42][D][esp-idf:000]: I (2029) wifi_init: tcpip mbox: 32 [17:08:42] [17:08:42][D][esp-idf:000]: I (2030) wifi_init: udp mbox: 6 [17:08:42] [17:08:42][D][esp-idf:000]: I (2031) wifi_init: tcp mbox: 6 [17:08:42] [17:08:42][D][esp-idf:000]: I (2032) wifi_init: tcp tx win: 5760 [17:08:42] [17:08:42][D][esp-idf:000]: I (2032) wifi_init: tcp rx win: 5760 [17:08:42] [17:08:43][D][esp-idf:000]: I (2033) wifi_init: tcp mss: 1440 [17:08:43] [17:08:43][D][esp-idf:000]: I (2034) wifi_init: WiFi/LWIP prefer SPIRAM [17:08:43] [17:08:43][D][esp-idf:000]: I (2035) wifi_init: WiFi IRAM OP enabled [17:08:43] [17:08:43][D][esp-idf:000]: I (2036) wifi_init: WiFi RX IRAM OP enabled [17:08:43] [17:08:43][C][wifi:061]: Starting WiFi... [17:08:43][C][wifi:062]: Local MAC: D8:3B:DA:40:78:70 [17:08:43][D][wifi:074]: Loaded saved wifi settings: HomeNet [17:08:43][D][esp-idf:000][wifi]: I (2041) phy_init: phy_version 670,b7bc9b9,Apr 30 2024,10:54:13 [17:08:43] [17:08:43][D][esp-idf:000][wifi]: I (2078) wifi: [17:08:43][D][esp-idf:000][wifi]: mode : sta (d8:3b:da:40:78:70) [17:08:43][D][esp-idf:000][wifi]: [17:08:43] [17:08:43][D][esp-idf:000][wifi]: I (2081) wifi: [17:08:43][D][esp-idf:000][wifi]: enable tsf [17:08:43][D][esp-idf:000][wifi]: [17:08:43] [17:08:43][D][esp-idf:000][wifi]: I (2083) wifi: [17:08:43][D][esp-idf:000][wifi]: Set ps type: 1 [17:08:43] [17:08:43][D][esp-idf:000][wifi]: [17:08:43] [17:08:43][D][wifi:482]: Starting scan... [17:08:43][D][esp32.preferences:114]: Saving 4 preferences to flash... [17:08:43][D][esp32.preferences:143]: Saving 4 preferences to flash: 4 cached, 0 written, 0 failed [17:08:43][D][aht10:115]: ATH10 Unrealistic humidity (0x0), retrying... [17:08:43][D][esp-idf:000][wifi]: I (2097) wifi: [17:08:43][D][esp-idf:000][wifi]: Set ps type: 1 [17:08:43] [17:08:43][D][esp-idf:000][wifi]: [17:08:43] [17:08:43][W][component:157]: Component wifi set Warning flag: scanning for networks [17:08:43][I][Satellite1:172]: XMOS Firmware Version: 0.0.7 [17:08:43][D][esp32_ble:284]: Enabling BLE... [17:08:43][D][esp-idf:000]: I (2122) BLE_INIT: BT controller compile version [ba3b3e3] [17:08:43] [17:08:43][D][esp-idf:000][btController]: I (2124) BLE_INIT: Bluetooth MAC: d8:3b:da:40:78:72 [17:08:43] [17:08:43] [17:08:44][D][aht10:097]: Read attempt 2 at 688ms [17:08:44][D][aht10:124]: Success at 689ms [17:08:44][D][sensor:094]: 'Temperature': Sending state 32.31971 °C with 2 decimals of accuracy [17:08:44][D][sensor:094]: 'Humidity': Sending state 41.02695 % with 2 decimals of accuracy [17:08:44][D][esp32_ble_server:077]: BLE server setup successfully [17:08:44][D][esp32_improv.component:082]: Creating Improv service [17:08:44][D][light:036]: 'voice_assistant_leds' Setting: [17:08:44][D][light:051]: Brightness: 66% [17:08:44][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:08:44][D][text_sensor:064]: 'XMOS Firmware': Sending state 'v0.0.7' [17:08:48][D][wifi:497]: Found networks: [17:08:48][I][wifi:541]: - 'HomeNet' (1E:E8:29:91:CA:92) [redacted]▂▄▆█ [17:08:48][D][wifi:542]: Channel: 11 [17:08:48][D][wifi:543]: RSSI: -58 dB [17:08:48][I][wifi:541]: - 'HomeNet' (0A:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:08:48][D][wifi:542]: Channel: 6 [17:08:48][D][wifi:543]: RSSI: -85 dB [17:08:48][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:92) [redacted]▂▄▆█ [17:08:48][D][wifi:546]: - ''[redacted] (88:DE:A9:35:1B:7F) [redacted]▂▄▆█ [17:08:48][D][wifi:546]: - 'IotWifi'[redacted] (04:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:08:48][D][wifi:546]: - ''[redacted] (BE:D7:D4:34:FA:3F) [redacted]▂▄▆█ [17:08:48][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:1F) [redacted]▂▄▆█ [17:08:48][D][wifi:546]: - ''[redacted] (22:EF:BD:FC:27:B0) [redacted]▂▄▆█ [17:08:48][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:08:48][D][esp-idf:000][wifi]: I (10579) wifi: [17:08:48][D][esp-idf:000][wifi]: new:<11,0>, old:<1,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:08:48][D][esp-idf:000][wifi]: [17:08:48] [17:08:48][D][esp-idf:000][wifi]: I (10583) wifi: [17:08:48][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:08:48][D][esp-idf:000][wifi]: [17:08:48] [17:08:49][D][esp-idf:000][wifi]: I (11560) wifi: [17:08:49][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:08:49][D][esp-idf:000][wifi]: [17:08:49] [17:08:49][D][esp-idf:000][wifi]: E (11569) wifi: [17:08:49][D][esp-idf:000][wifi]: Set status to INIT [17:08:49][D][esp-idf:000][wifi]: [17:08:49] [17:08:49][D][esp-idf:000][wifi]: I (11571) wifi: [17:08:49][D][esp-idf:000][wifi]: state: assoc -> init (1e10) [17:08:49][D][esp-idf:000][wifi]: [17:08:49] [17:08:49][D][esp-idf:000][wifi]: I (11574) wifi: [17:08:49][D][esp-idf:000][wifi]: Coexist: Wi-Fi connect fail, apply reconnect coex policy [17:08:49] [17:08:49][D][esp-idf:000][wifi]: [17:08:49] [17:08:49][D][esp-idf:000][wifi]: I (11576) wifi: [17:08:49][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:08:49][D][esp-idf:000][wifi]: [17:08:49] [17:08:49][W][wifi_esp32:712]: Event: Disconnected ssid='HomeNet' bssid=1E:E8:29:91:CA:92[redacted] reason='Association Failed' [17:08:49][W][wifi:653]: Error while connecting to network. [17:08:49][D][wifi:697]: Retrying with hidden networks... [17:08:49][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:08:49][D][esp-idf:000][wifi]: I (11602) wifi: [17:08:49][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:08:49][D][esp-idf:000][wifi]: [17:08:49] [17:08:49][D][esp-idf:000][wifi]: I (11605) wifi: [17:08:49][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:08:49][D][esp-idf:000][wifi]: [17:08:49] [17:08:50][D][esp-idf:000][wifi]: I (12583) wifi: [17:08:50][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:08:50][D][esp-idf:000][wifi]: [17:08:50] [17:08:50][D][esp-idf:000][wifi]: E (12593) wifi: [17:08:50][D][esp-idf:000][wifi]: Set status to INIT [17:08:50][D][esp-idf:000][wifi]: [17:08:50] [17:08:50][D][esp-idf:000][wifi]: I (12595) wifi: [17:08:50][D][esp-idf:000][wifi]: state: assoc -> init (1e10) [17:08:50][D][esp-idf:000][wifi]: [17:08:50] [17:08:50][D][esp-idf:000][wifi]: I (12597) wifi: [17:08:50][D][esp-idf:000][wifi]: Coexist: Wi-Fi connect fail, apply reconnect coex policy [17:08:50] [17:08:50][D][esp-idf:000][wifi]: [17:08:50] [17:08:50][D][esp-idf:000][wifi]: I (12600) wifi: [17:08:50][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:08:50][D][esp-idf:000][wifi]: [17:08:50] [17:08:50][W][wifi_esp32:712]: Event: Disconnected ssid='HomeNet' bssid=1E:E8:29:91:CA:92[redacted] reason='Association Failed' [17:08:50][W][wifi:653]: Error while connecting to network. [17:08:50][D][wifi:697]: Retrying with hidden networks... [17:08:55][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:09:03][D][esp-idf:000][wifi]: I (26401) wifi: [17:09:03][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:09:04][D][esp-idf:000][wifi]: [17:09:04] [17:09:04][D][esp-idf:000][wifi]: I (26404) wifi: [17:09:04][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:09:04][D][esp-idf:000][wifi]: [17:09:04] [17:09:04][D][esp-idf:000][wifi]: I (27385) wifi: [17:09:04][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:09:05][D][esp-idf:000][wifi]: [17:09:05] [17:09:05][D][esp-idf:000][wifi]: I (27400) wifi: [17:09:05][D][esp-idf:000][wifi]: state: assoc -> run (10) [17:09:05][D][esp-idf:000][wifi]: [17:09:05] [17:09:05][D][esp-idf:000][wifi]: I (27429) wifi: [17:09:05][D][esp-idf:000][wifi]: connected with HomeNet, aid = 4, channel 11, BW20, bssid = 1e:e8:29:91:ca:92 [17:09:05][D][esp-idf:000][wifi]: [17:09:05] [17:09:05][D][esp-idf:000][wifi]: I (27432) wifi: [17:09:05][D][esp-idf:000][wifi]: security: WPA3-SAE, phy: bgn, rssi: -57 [17:09:05][D][esp-idf:000][wifi]: [17:09:05] [17:09:05][D][esp-idf:000][wifi]: I (27434) wifi: [17:09:05][D][esp-idf:000][wifi]: pm start, type: 1 [17:09:05] [17:09:05][D][esp-idf:000][wifi]: [17:09:05] [17:09:05][D][esp-idf:000][wifi]: I (27436) wifi: [17:09:05][D][esp-idf:000][wifi]: set rx beacon pti, rx_bcn_pti: 14, bcn_timeout: 14, mt_pti: 25000, mt_time: 10000 [17:09:05][D][esp-idf:000][wifi]: [17:09:05] [17:09:05][D][esp-idf:000][wifi]: I (27447) wifi: [17:09:05][D][esp-idf:000][wifi]: idx:0 (ifx:0, 1e:e8:29:91:ca:92), tid:6, ssn:2, winSize:64 [17:09:05][D][esp-idf:000][wifi]: [17:09:05] [17:09:05][D][esp-idf:000][wifi]: I (27502) wifi: [17:09:05][D][esp-idf:000][wifi]: AP's beacon interval = 102400 us, DTIM period = 1 [17:09:05][D][esp-idf:000][wifi]: [17:09:05] [17:09:06][D][esp-idf:000][sys_evt]: I (28440) esp_netif_handlers: sta ip: 192.168.3.215, mask: 255.255.255.0, gw: 192.168.3.1 [17:09:06] [17:09:06][I][wifi:617]: WiFi Connected! [17:09:06][C][wifi:428]: Local MAC: D8:3B:DA:40:78:70 [17:09:06][C][wifi:433]: SSID: 'HomeNet'[redacted] [17:09:06][C][wifi:436]: IP Address: 192.168.3.215 [17:09:06][C][wifi:440]: BSSID: 1E:E8:29:91:CA:92[redacted] [17:09:06][C][wifi:441]: Hostname: 'satellite1-407870' [17:09:06][C][wifi:443]: Signal strength: -56 dB ▂▄▆█ [17:09:06][C][wifi:447]: Channel: 11 [17:09:06][C][wifi:448]: Subnet: 255.255.255.0 [17:09:06][C][wifi:449]: Gateway: 192.168.3.1 [17:09:06][C][wifi:450]: DNS1: 192.168.3.152 [17:09:06][C][wifi:451]: DNS2: 0.0.0.0 [17:09:06][C][api:026]: Setting up Home Assistant API server... [17:09:06][C][micro_wake_word:083]: Setting up microWakeWord... [17:09:06][C][micro_wake_word:109]: Micro Wake Word initialized [17:09:06][I][nabu_media_player:138]: Set up nabu media player [17:09:06][I][app:062]: setup() finished successfully! [17:09:06][D][esp-idf:000][wifi]: I (28527) wifi: [17:09:06][D][esp-idf:000][wifi]: idx:1 (ifx:0, 1e:e8:29:91:ca:92), tid:0, ssn:1, winSize:64 [17:09:06][D][esp-idf:000][wifi]: [17:09:06] [17:09:06][D][esp-idf:000]: I (28708) esp-x509-crt-bundle: Certificate validated [17:09:06] [17:09:06][D][update:011]: 'Satellite1 407870' - Publishing: [17:09:06][D][update:012]: Current Version: v0.0.4 [17:09:06][D][update:015]: Latest Version: v0.0.4 [17:09:06][D][update:018]: Firmware URL: https://raw.githubusercontent.com/FutureProofHomes/Documentation/refs/heads/main/assets/firmware/esphome/production/satellite1-esp32s3.ota.bin [17:09:06][D][update:021]: Title: ESPHome Firmware for Satellite1-Core-Board [17:09:06][D][update:023]: Summary: ESPHome Firmware for satellite1-esp32s3 [17:09:07][D][update:026]: Release URL: https://github.com/FutureProofHomes/Satellite1-ESPHome/releases/tag/v0.0.4/ [17:09:07][W][component:237]: Component http_request.update took a long time for an operation (899 ms). [17:09:07][W][component:238]: Components should block for at most 30 ms. [17:09:07][D][light:036]: 'voice_assistant_leds' Setting: [17:09:07][D][light:051]: Brightness: 66% [17:09:07][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:09:07][D][light:109]: Effect: 'Twinkle' [17:09:07][W][component:170]: Component wifi cleared Warning flag [17:09:07][W][component:157]: Component api set Warning flag: unspecified [17:09:07][I][app:100]: ESPHome version 2024.11.2 compiled on Dec 6 2024, 18:59:28 [17:09:07][I][app:102]: Project FutureProofHomes.Satellite1 version v0.0.4 [17:09:07][C][status_led:019]: Status LED: [17:09:07][C][status_led:020]: Pin: GPIO45 [17:09:07][C][wifi:600]: WiFi: [17:09:07][C][wifi:428]: Local MAC: D8:3B:DA:40:78:70 [17:09:07][C][wifi:433]: SSID: 'HomeNet'[redacted] [17:09:07][C][wifi:436]: IP Address: 192.168.3.215 [17:09:07][C][wifi:440]: BSSID: 1E:E8:29:91:CA:92[redacted] [17:09:07][C][wifi:441]: Hostname: 'satellite1-407870' [17:09:07][C][wifi:443]: Signal strength: -56 dB ▂▄▆█ [17:09:07][C][wifi:447]: Channel: 11 [17:09:07][C][wifi:448]: Subnet: 255.255.255.0 [17:09:07][C][wifi:449]: Gateway: 192.168.3.1 [17:09:07][C][wifi:450]: DNS1: 192.168.3.152 [17:09:07][C][wifi:451]: DNS2: 0.0.0.0 [17:09:07][C][logger:185]: Logger: [17:09:07][C][logger:186]: Level: DEBUG [17:09:07][C][logger:188]: Log Baud Rate: 115200 [17:09:07][C][logger:189]: Hardware UART: USB_SERIAL_JTAG [17:09:07][C][i2c.idf:075]: I2C Bus: [17:09:07][C][i2c.idf:076]: SDA Pin: GPIO5 [17:09:07][C][i2c.idf:077]: SCL Pin: GPIO6 [17:09:07][C][i2c.idf:078]: Frequency: 400000 Hz [17:09:07][C][i2c.idf:084]: Recovery: bus successfully recovered [17:09:07][I][i2c.idf:094]: Results from i2c bus scan: [17:09:07][I][i2c.idf:100]: Found i2c device at address 0x22 [17:09:07][I][i2c.idf:100]: Found i2c device at address 0x29 [17:09:07][I][i2c.idf:100]: Found i2c device at address 0x38 [17:09:07][I][i2c.idf:100]: Found i2c device at address 0x3F [17:09:07][I][i2c.idf:100]: Found i2c device at address 0x4D [17:09:07][C][spi:064]: SPI bus: [17:09:07][C][spi:065]: CLK Pin: GPIO12 [17:09:07][C][spi:066]: SDI Pin: GPIO13 [17:09:07][C][spi:067]: SDO Pin: GPIO11 [17:09:07][C][spi:072]: Using HW SPI: SPI2_HOST [17:09:07][C][Satellite1:027]: Satellite1 config: [17:09:07][C][template.number:050]: Template Number 'Offset Temperature' [17:09:07][C][template.number:050]: Icon: 'mdi:thermometer' [17:09:07][C][template.number:050]: Unit of Measurement: '°C' [17:09:07][C][template.number:051]: Optimistic: YES [17:09:07][C][template.number:052]: Update Interval: never [17:09:07][C][template.number:050]: Template Number 'Offset Humidity' [17:09:07][C][template.number:050]: Icon: 'mdi:water-percent' [17:09:07][C][template.number:050]: Unit of Measurement: '%' [17:09:07][C][template.number:051]: Optimistic: YES [17:09:07][C][template.number:052]: Update Interval: never [17:09:07][C][template.text_sensor:020]: Template Sensor 'USB-C Power Draw' [17:09:07][C][template.text_sensor:020]: Icon: 'mdi:usb-c-port' [17:09:07][C][template.text_sensor:020]: Template Sensor 'XMOS Firmware' [17:09:07][C][template.text_sensor:020]: Icon: 'mdi:memory' [17:09:07][C][esp32_rmt_led_strip:187]: ESP32 RMT LED Strip: [17:09:07][C][esp32_rmt_led_strip:188]: Pin: 21 [17:09:07][C][esp32_rmt_led_strip:189]: Channel: 1 [17:09:07][C][esp32_rmt_led_strip:214]: RGB Order: GRB [17:09:07][C][esp32_rmt_led_strip:215]: Max refresh rate: 0 [17:09:07][C][esp32_rmt_led_strip:216]: Number of LEDs: 24 [17:09:08][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Left (HW Mute)' [17:09:08][C][gpio.binary_sensor:016]: Pin: [17:09:08][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Up (Vol+)' [17:09:08][C][gpio.binary_sensor:016]: Pin: [17:09:08][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Down (Vol-)' [17:09:08][C][gpio.binary_sensor:016]: Pin: [17:09:08][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Right (Action)' [17:09:08][C][gpio.binary_sensor:016]: Pin: GPIO0 [17:09:08][C][light:092]: Light 'hw_led_ring' [17:09:08][C][light:094]: Default Transition Length: 1.0s [17:09:08][C][light:095]: Gamma Correct: 2.80 [17:09:08][C][light:092]: Light 'LED Ring' [17:09:08][C][light:094]: Default Transition Length: 0.0s [17:09:08][C][light:095]: Gamma Correct: 2.80 [17:09:08][C][light:092]: Light 'voice_assistant_leds' [17:09:08][C][light:094]: Default Transition Length: 0.0s [17:09:08][C][light:095]: Gamma Correct: 2.80 [17:09:08][C][template.switch:068]: Template Switch 'Wake sound' [17:09:08][C][template.switch:070]: Icon: 'mdi:bullhorn' [17:09:08][C][template.switch:091]: Restore Mode: restore defaults to ON [17:09:08][C][template.switch:057]: Optimistic: YES [17:09:08][C][template.switch:068]: Template Switch 'Mute Microphones' [17:09:08][C][template.switch:070]: Icon: 'mdi:microphone-off' [17:09:08][C][template.switch:091]: Restore Mode: restore defaults to OFF [17:09:08][C][template.switch:057]: Optimistic: NO [17:09:08][C][template.switch:068]: Template Switch 'timer_ringing' [17:09:08][C][template.switch:091]: Restore Mode: always OFF [17:09:08][C][template.switch:057]: Optimistic: YES [17:09:08][D][api:103]: Accepted 192.168.3.100 [17:09:08][W][component:170]: Component api cleared Warning flag [17:09:08][C][template.switch:068]: Template Switch 'Beta firmware' [17:09:08][C][template.switch:070]: Icon: 'mdi:test-tube' [17:09:08][C][template.switch:091]: Restore Mode: restore defaults to OFF [17:09:08][C][template.switch:057]: Optimistic: YES [17:09:08][D][api.connection:1446]: Home Assistant 2025.2.1 (192.168.3.100): Connected successfully [17:09:08][C][psram:020]: PSRAM: [17:09:08][C][psram:021]: Available: YES [17:09:08][C][psram:024]: Size: 8191 KB [17:09:08][C][i2s_audio:028]: I2SController: [17:09:08][C][i2s_audio:029]: AccessMode: duplex [17:09:08][C][i2s_audio:030]: Port: 0 [17:09:08][C][i2s_audio:032]: Reader registered. [17:09:08][C][i2s_audio:035]: Writer registered. [17:09:08][C][aht10:162]: AHT10: [17:09:08][C][aht10:163]: Address: 0x38 [17:09:08][C][aht10:167]: Temperature 'Temperature' [17:09:08][C][aht10:167]: Device Class: 'temperature' [17:09:08][C][aht10:167]: State Class: 'measurement' [17:09:08][C][aht10:167]: Unit of Measurement: '°C' [17:09:08][C][aht10:167]: Accuracy Decimals: 2 [17:09:08][C][aht10:168]: Humidity 'Humidity' [17:09:08][C][aht10:168]: Device Class: 'humidity' [17:09:08][C][aht10:168]: State Class: 'measurement' [17:09:08][C][aht10:168]: Unit of Measurement: '%' [17:09:08][C][aht10:168]: Accuracy Decimals: 2 [17:09:08][C][ltr_als_ps:085]: Address: 0x29 [17:09:08][C][ltr_als_ps:086]: Device type: ALS only [17:09:08][C][ltr_als_ps:088]: Automatic mode: ON [17:09:08][C][ltr_als_ps:089]: Gain: 1x [17:09:08][C][ltr_als_ps:090]: Integration time: 100 ms [17:09:08][C][ltr_als_ps:091]: Measurement repeat rate: 500 ms [17:09:08][C][ltr_als_ps:092]: Glass attenuation factor: 1.000000 [17:09:08][C][ltr_als_ps:093]: ALS calculated lux 'Ambient light' [17:09:08][C][ltr_als_ps:093]: Device Class: 'illuminance' [17:09:08][C][ltr_als_ps:093]: State Class: 'measurement' [17:09:08][C][ltr_als_ps:093]: Unit of Measurement: 'lx' [17:09:08][C][ltr_als_ps:093]: Accuracy Decimals: 1 [17:09:09][C][ltr_als_ps:093]: Icon: 'mdi:brightness-6' [17:09:09][C][ltr_als_ps:105]: Update Interval: 60.0s [17:09:09][C][restart.button:017]: Restart Button 'Restart Sat1' [17:09:09][C][restart.button:017]: Icon: 'mdi:restart' [17:09:09][C][factory_reset.button:011]: Factory Reset Button 'Factory Reset ESP32 FW' [17:09:09][C][factory_reset.button:011]: Icon: 'mdi:restart-alert' [17:09:09][C][i2s_audio:143]: I2S-Reader (Fixed-CFG): [17:09:09][C][i2s_audio:148]: clk_mode: external [17:09:09][C][i2s_audio:149]: sample-rate: 48000 bits_per_sample: 32 [17:09:09][C][i2s_audio:150]: channel_fmt: 0 channels: 2 [17:09:09][C][i2s_audio:151]: use_apll: no, use_pdm: no [17:09:09][C][memory_flasher:014]: Embedded Image: [17:09:09][C][memory_flasher:016]: Version: 1.0.1 [17:09:09][C][esp32_ble:391]: ESP32 BLE: [17:09:09][C][esp32_ble:393]: MAC address: D8:3B:DA:40:78:72 [17:09:09][C][esp32_ble:394]: IO Capability: none [17:09:09][C][esp32_ble_server:200]: ESP32 BLE Server: [17:09:09][C][esp32_improv.component:269]: ESP32 Improv: [17:09:09][C][esp32_improv.component:271]: Authorizer 'Button Right (Action)' [17:09:09][C][mdns:116]: mDNS: [17:09:09][C][mdns:117]: Hostname: satellite1-407870 [17:09:09][C][esphome.ota:073]: Over-The-Air updates: [17:09:09][C][esphome.ota:074]: Address: satellite1.local:3232 [17:09:09][C][esphome.ota:075]: Version: 2 [17:09:09][C][safe_mode:018]: Safe Mode: [17:09:09][C][safe_mode:020]: Boot considered successful after 60 seconds [17:09:09][C][safe_mode:021]: Invoke after 10 boot attempts [17:09:09][C][safe_mode:023]: Remain in safe mode for 300 seconds [17:09:09][C][http_request.ota:026]: Over-The-Air updates via HTTP request [17:09:09][C][api:140]: API Server: [17:09:09][C][api:141]: Address: satellite1.local:6053 [17:09:09][C][api:145]: Using noise encryption: NO [17:09:09][C][improv_serial:032]: Improv Serial: [17:09:09][C][http_request:013]: HTTP Request: [17:09:09][C][http_request:014]: Timeout: 4500ms [17:09:09][C][http_request:015]: User-Agent: ESPHome/2024.11.2 (https://esphome.io) [17:09:09][C][http_request:016]: Follow redirects: YES [17:09:09][C][http_request:017]: Redirect limit: 3 [17:09:09][C][http_request.idf:022]: Buffer Size RX: 512 [17:09:09][C][http_request.idf:023]: Buffer Size TX: 512 [17:09:09][C][micro_wake_word:072]: microWakeWord: [17:09:09][C][micro_wake_word:073]: models: [17:09:09][C][micro_wake_word:015]: - Wake Word: Hey Jarvis [17:09:09][C][micro_wake_word:016]: Probability cutoff: 0.97 [17:09:09][C][micro_wake_word:017]: Sliding window size: 5 [17:09:09][C][micro_wake_word:015]: - Wake Word: Okay Nabu [17:09:09][C][micro_wake_word:016]: Probability cutoff: 0.97 [17:09:09][C][micro_wake_word:017]: Sliding window size: 5 [17:09:09][C][micro_wake_word:015]: - Wake Word: Stop [17:09:09][C][micro_wake_word:016]: Probability cutoff: 0.50 [17:09:09][C][micro_wake_word:017]: Sliding window size: 5 [17:09:09][C][micro_wake_word:021]: - VAD Model [17:09:09][C][micro_wake_word:022]: Probability cutoff: 0.50 [17:09:09][C][micro_wake_word:023]: Sliding window size: 5 [17:09:09][C][i2s_audio:146]: I2S-Writer (Initial-CFG): [17:09:09][C][i2s_audio:148]: clk_mode: external [17:09:09][C][i2s_audio:149]: sample-rate: 48000 bits_per_sample: 32 [17:09:09][C][i2s_audio:150]: channel_fmt: 0 channels: 2 [17:09:09][C][i2s_audio:151]: use_apll: no, use_pdm: no [17:09:16][D][esp32_ble:269]: Disabling BLE... [17:09:16][D][esp-idf:000][BTU_TASK]: W (39396) BT_APPL: bta_dm_disable BTA_DISABLE_DELAY set to 200 ms [17:09:16] [17:09:17][W][component:237]: Component esp32_ble took a long time for an operation (212 ms). [17:09:17][W][component:238]: Components should block for at most 30 ms. [17:09:18][D][micro_wake_word:379]: Starting wake word detection [17:09:18][D][light:036]: 'voice_assistant_leds' Setting: [17:09:18][D][light:047]: State: OFF [17:09:19][D][light:109]: Effect: 'None' [17:09:19][D][i2s_audio:067][microphone_task]: Install driver requested by Reader [17:09:19][D][esp-idf:000][microphone_task]: I (41415) I2S: DMA Malloc info, datalen=blocksize=4088, dma_buf_count=6 [17:09:19] [17:09:19][D][i2s_audio.microphone:322]: Starting I2S Audio Microphne [17:09:19][D][micro_wake_word:418]: State changed from IDLE to DETECTING_WAKE_WORD [17:09:19][D][i2s_audio.microphone:326]: Started I2S Audio Microphone [17:09:23][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:09:23][D][esp32.preferences:143]: Saving 1 preferences to flash: 1 cached, 0 written, 0 failed [17:09:26][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 1x, time = 100 ms [17:09:27][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 2x, time = 100 ms [17:09:28][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 4x, time = 100 ms [17:09:29][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 8x, time = 100 ms [17:09:30][D][sensor:094]: 'Temperature': Sending state 32.76584 °C with 2 decimals of accuracy [17:09:30][D][sensor:094]: 'Humidity': Sending state 40.19096 % with 2 decimals of accuracy [17:09:30][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 48x, time = 100 ms [17:09:31][D][ltr_als_ps:450]: Illuminance is sufficient. [17:09:31][D][sensor:094]: 'Ambient light': Sending state 177.70854 lx with 1 decimals of accuracy [17:09:35][D][micro_wake_word:357]: Detected 'Hey Jarvis' with sliding average probability is 1.00 and max probability is 1.00 [17:09:35][D][media_player:080]: 'Sat1 Media Player' - Setting [17:09:35][D][media_player:084]: Command: STOP [17:09:35][D][media_player:093]: Announcement: yes [17:09:35][D][media_player:080]: 'Sat1 Media Player' - Setting [17:09:36][D][media_player:093]: Announcement: yes [17:09:36][D][ring_buffer:034]: Created ring buffer with size 48000 [17:09:36][D][ring_buffer:034]: Created ring buffer with size 48000 [17:09:36][D][ring_buffer:034]: Created ring buffer with size 16384 [17:09:36][D][i2s_audio:067][speaker_task]: Install driver requested by Writer [17:09:36][D][ring_buffer:034]: Created ring buffer with size 131072 [17:09:36][D][ring_buffer:034]: Created ring buffer with size 65536 [17:09:36][D][nabu_media_player:427]: Starting Media Player Speaker [17:09:36][D][nabu_media_player:430]: Started Media Player Speaker [17:09:36][D][nabu_media_player.pipeline:176]: Reading FLAC file type [17:09:36][D][nabu_media_player.pipeline:410][ann_decode]: Creating and starting new AudioDecoder [17:09:36][D][nabu_media_player.decoder:056][ann_decode]: Starting AudioDecoder. [17:09:36][D][nabu_media_player.pipeline:186]: Decoded audio has 1 channels, 48000 Hz sample rate, and 16 bits per sample [17:09:36][D][nabu_media_player.pipeline:197]: Converting mono channel audio to stereo channel audio [17:09:36][D][voice_assistant:516]: State changed from IDLE to START_MICROPHONE [17:09:36][D][voice_assistant:522]: Desired state set to START_PIPELINE [17:09:36][D][voice_assistant:225]: Starting Microphone [17:09:36][D][ring_buffer:034]: Created ring buffer with size 16384 [17:09:36][D][voice_assistant:516]: State changed from START_MICROPHONE to STARTING_MICROPHONE [17:09:36][D][voice_assistant:516]: State changed from STARTING_MICROPHONE to START_PIPELINE [17:09:36][D][voice_assistant:280]: Requesting start... [17:09:36][D][voice_assistant:516]: State changed from START_PIPELINE to STARTING_PIPELINE [17:09:36][D][voice_assistant:537]: Client started, streaming microphone [17:09:36][D][voice_assistant:516]: State changed from STARTING_PIPELINE to STREAMING_MICROPHONE [17:09:36][D][voice_assistant:522]: Desired state set to STREAMING_MICROPHONE [17:09:36][D][voice_assistant:639]: Event Type: 1 [17:09:36][D][voice_assistant:642]: Assist Pipeline running [17:09:36][D][nabu_media_player.decoder:149][ann_decode]: skip decoding: buffer: 0, failed: 0, to-read: 32768 read: 0 avail: 0 [17:09:36][D][light:036]: 'voice_assistant_leds' Setting: [17:09:36][D][light:047]: State: ON [17:09:37][D][light:051]: Brightness: 66% [17:09:37][D][light:109]: Effect: 'Waiting for Command' [17:09:37][D][voice_assistant:639]: Event Type: 11 [17:09:37][D][voice_assistant:802]: Starting STT by VAD [17:09:37][D][light:036]: 'voice_assistant_leds' Setting: [17:09:37][D][light:051]: Brightness: 66% [17:09:37][D][light:109]: Effect: 'Listening For Command' [17:09:38][D][voice_assistant:639]: Event Type: 12 [17:09:38][D][voice_assistant:806]: STT by VAD end [17:09:38][D][voice_assistant:516]: State changed from STREAMING_MICROPHONE to STOP_MICROPHONE [17:09:38][D][voice_assistant:522]: Desired state set to AWAITING_RESPONSE [17:09:38][D][voice_assistant:516]: State changed from STOP_MICROPHONE to STOPPING_MICROPHONE [17:09:38][D][light:036]: 'voice_assistant_leds' Setting: [17:09:38][D][light:051]: Brightness: 66% [17:09:38][D][light:109]: Effect: 'Thinking' [17:09:38][D][voice_assistant:516]: State changed from STOPPING_MICROPHONE to AWAITING_RESPONSE [17:09:39][D][voice_assistant:516]: State changed from AWAITING_RESPONSE to AWAITING_RESPONSE [17:09:39][D][voice_assistant:639]: Event Type: 4 [17:09:39][D][voice_assistant:667]: Speech recognised as: " Tell me, joke." [17:09:39][D][voice_assistant:639]: Event Type: 5 [17:09:39][D][voice_assistant:672]: Intent started [17:09:39][I][safe_mode:041]: Boot seems successful; resetting boot loop counter [17:09:39][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:09:39][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:09:40][D][voice_assistant:639]: Event Type: 6 [17:09:40][D][voice_assistant:639]: Event Type: 7 [17:09:40][D][voice_assistant:695]: Response: "Why don't eggs tell jokes? [17:09:40] [17:09:40]Because they'd crack each other up! (get it?)" [17:09:40][D][light:036]: 'voice_assistant_leds' Setting: [17:09:40][D][light:051]: Brightness: 66% [17:09:40][D][light:109]: Effect: 'Replying' [17:09:40][D][voice_assistant:639]: Event Type: 8 [17:09:40][D][voice_assistant:717]: Response URL: "https://mikejulie4us.duckdns.org:8123/api/tts_proxy/8gRAzDJHGOG02N_XoTRcGQ.flac" [17:09:40][D][voice_assistant:516]: State changed from AWAITING_RESPONSE to STREAMING_RESPONSE [17:09:41][D][voice_assistant:522]: Desired state set to STREAMING_RESPONSE [17:09:41][D][media_player:080]: 'Sat1 Media Player' - Setting [17:09:41][D][media_player:087]: Media URL: https://mikejulie4us.duckdns.org:8123/api/tts_proxy/8gRAzDJHGOG02N_XoTRcGQ.flac [17:09:41][D][media_player:093]: Announcement: yes [17:09:41][D][voice_assistant:639]: Event Type: 2 [17:09:41][D][voice_assistant:731]: Assist Pipeline ended [17:09:41] [17:09:41]***ERROR*** A stack overflow in task ann_read has been detected. [17:09:41] [17:09:41] [17:09:41]Backtrace: 0x403783e2:0x3fcbf750 0x40381ce5:0x3fcbf770 0x4038590a:0x3fcbf790 0x40383944:0x3fcbf810 0x40381d9c:0x3fcbf840 0x40381d92:0x00000000 |<-CORRUPTED [17:09:41] [17:09:41] [17:09:41] [17:09:41] [17:09:41]ELF file SHA256: 79423943e134e5c9 [17:09:41] [17:09:41]Rebooting... [17:09:41]ESP-ROM:esp32s3-20210327 [17:09:41]Build:Mar 27 2021 [17:09:41]rst:0xc (RTC_SW_CPU_RST),boot:0x2b (SPI_FAST_FLASH_BOOT) [17:09:41]Saved PC:0x40377ff0 [17:09:41]SPIWP:0xee [17:09:41]mode:DIO, clock div:1 [17:09:41]load:0x3fce3808,len:0x16c4 [17:09:41]load:0x403c9700,len:0xbc0 [17:09:41]load:0x403cc700,len:0x2e90 [17:09:41]entry 0x403c9950 [17:09:41]I (24) boot: ESP-IDF 4.4.8 2nd stage bootloader [17:09:41]I (24) boot: compile time 19:04:16 [17:09:41]I (24) boot: Multicore bootloader [17:09:42]I (26) boot: chip revision: v0.2 [17:09:42]I (30) boot.esp32s3: Boot SPI Speed : 80MHz [17:09:42]I (35) boot.esp32s3: SPI Mode : DIO [17:09:42]I (39) boot.esp32s3: SPI Flash Size : 16MB [17:09:42]I (44) boot: Enabling RNG early entropy source... [17:09:42]I (50) boot: Partition Table: [17:09:42]I (53) boot: ## Label Usage Type ST Offset Length [17:09:42]I (60) boot: 0 otadata OTA data 01 00 00009000 00002000 [17:09:42]I (68) boot: 1 phy_init RF data 01 01 0000b000 00001000 [17:09:42]I (75) boot: 2 app0 OTA app 00 10 00010000 007c0000 [17:09:42]I (83) boot: 3 app1 OTA app 00 11 007d0000 007c0000 [17:09:42]I (90) boot: 4 nvs WiFi data 01 02 00f90000 0006d000 [17:09:42]I (98) boot: End of partition table [17:09:42]I (102) esp_image: segment 0: paddr=00010020 vaddr=3c170020 size=1469b4h (1337780) map [17:09:42]I (350) esp_image: segment 1: paddr=001569dc vaddr=3fc9dc70 size=04974h ( 18804) load [17:09:42]I (355) esp_image: segment 2: paddr=0015b358 vaddr=40374000 size=04cc0h ( 19648) load [17:09:42]I (361) esp_image: segment 3: paddr=00160020 vaddr=42000020 size=16cf90h (1494928) map [17:09:42]I (633) esp_image: segment 4: paddr=002ccfb8 vaddr=40378cc0 size=14fa8h ( 85928) load [17:09:42]I (662) boot: Loaded app from partition at offset 0x10000 [17:09:42]I (662) boot: Disabling RNG early entropy source... [17:09:42]I (663) cpu_start: Multicore app [17:09:42]I (667) opi psram: vendor id : 0x0d (AP) [17:09:42]I (671) opi psram: dev id : 0x02 (generation 3) [17:09:42]I (676) opi psram: density : 0x03 (64 Mbit) [17:09:42]I (681) opi psram: good-die : 0x01 (Pass) [17:09:42]I (686) opi psram: Latency : 0x01 (Fixed) [17:09:42]I (691) opi psram: VCC : 0x01 (3V) [17:09:42]I (696) opi psram: SRF : 0x01 (Fast Refresh) [17:09:43]I (701) opi psram: BurstType : 0x01 (Hybrid Wrap) [17:09:43]I (707) opi psram: BurstLen : 0x01 (32 Byte) [17:09:43]I (712) opi psram: Readlatency : 0x02 (10 cycles@Fixed) [17:09:43]I (718) opi psram: DriveStrength: 0x00 (1/1) [17:09:43]I (723) MSPI Timing: PSRAM timing tuning index: 11 [17:09:43]I (728) spiram: Found 64MBit SPI RAM device [17:09:43]I (733) spiram: SPI RAM mode: sram 80m [17:09:43]I (737) spiram: PSRAM initialized, cache is in normal (1-core) mode. [17:09:43]I (744) cpu_start: Pro cpu up. [17:09:43]I (748) cpu_start: Starting app cpu, entry point is 0x403779a8 [17:09:43]I (737) cpu_start: App cpu up. [17:09:43]I (1181) spiram: SPI SRAM memory test OK [17:09:43]I (1189) cpu_start: Pro cpu start user code [17:09:43]I (1189) cpu_start: cpu freq: 160000000 [17:09:43]I (1190) cpu_start: Application information: [17:09:43]I (1190) cpu_start: Project name: satellite1 [17:09:43]I (1190) cpu_start: App version: 2024.11.2 [17:09:43]I (1190) cpu_start: Compile time: Dec 6 2024 18:59:28 [17:09:43]I (1191) cpu_start: ELF file SHA256: 79423943e134e5c9... [17:09:43]I (1191) cpu_start: ESP-IDF: 4.4.8 [17:09:43]I (1191) cpu_start: Min chip rev: v0.0 [17:09:43]I (1191) cpu_start: Max chip rev: v0.99 [17:09:43]I (1191) cpu_start: Chip rev: v0.2 [17:09:43]I (1192) heap_init: Initializing. RAM available for dynamic allocation: [17:09:43]I (1192) heap_init: At 3FCA91A0 len 00040570 (257 KiB): D/IRAM [17:09:43]I (1192) heap_init: At 3FCE9710 len 00005724 (21 KiB): STACK/DIRAM [17:09:43]I (1193) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM [17:09:43]I (1193) heap_init: At 600FE000 len 00002000 (8 KiB): RTCRAM [17:09:43]I (1193) spiram: Adding pool of 8192K of external SPI memory to heap allocator [17:09:44]I (1194) spi_flash: detected chip: gd [17:09:44]I (1195) spi_flash: flash io: dio [17:09:44]I (1197) sleep: Configure to isolate all GPIO pins in sleep state [17:09:44]I (1198) sleep: Enable automatic switching of GPIO sleep configuration [17:09:44]I (1198) coexist: coexist rom version e7ae62f [17:09:44]I (1199) cpu_start: Starting scheduler on PRO CPU. [17:09:44]I (0) cpu_start: Starting scheduler on APP CPU. [17:09:44][I][logger:171]: Log initialized [17:09:44][C][status_led:014]: Setting up Status LED... [17:09:44][D][esp-idf:000]: I (181) gpio: GPIO[45]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:09:44] [17:09:44][C][safe_mode:079]: There have been 0 suspected unsuccessful boot attempts [17:09:44][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:09:44][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:09:44][I][app:029]: Running through setup()... [17:09:44][C][i2c.idf:017]: Setting up I2C bus... [17:09:44][I][i2c.idf:252]: Performing I2C bus recovery [17:09:44][D][esp-idf:000]: I (1629) gpio: GPIO[6]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:09:44] [17:09:44][D][esp-idf:000]: I (1630) gpio: GPIO[5]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:09:44] [17:09:44][D][spi:035]: Setting up SPI bus... [17:09:44][D][spi_device:362]: mode 3, data_rate 8000kHz [17:09:44][D][esp-idf:000]: I (1648) gpio: GPIO[10]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:09:44] [17:09:44][D][esp-idf:000]: I (1650) gpio: GPIO[4]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:09:44] [17:09:44][I][Satellite1:172]: XMOS Firmware Version: 6.0.7 [17:09:44][D][number:012]: 'Offset Temperature': Sending state 0.000000 [17:09:44][D][number:012]: 'Offset Humidity': Sending state 0.000000 [17:09:45][D][fusb302b:360]: reported device id: 145 [17:09:45][D][fusb302b:133]: FUSB302 found, initializing... [17:09:45][C][esp32_rmt_led_strip:021]: Setting up ESP32 LED Strip... [17:09:45][D][binary_sensor:034]: 'Button Left (HW Mute)': Sending initial state OFF [17:09:45][D][binary_sensor:034]: 'Button Up (Vol+)': Sending initial state OFF [17:09:45][D][binary_sensor:034]: 'Button Down (Vol-)': Sending initial state OFF [17:09:45][D][esp-idf:000]: I (1867) gpio: GPIO[0]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0 [17:09:45] [17:09:45][D][binary_sensor:034]: 'Button Right (Action)': Sending initial state OFF [17:09:45][C][light:021]: Setting up light 'hw_led_ring'... [17:09:45][D][light:036]: 'hw_led_ring' Setting: [17:09:45][D][light:041]: Color mode: RGB [17:09:45][D][light:085]: Transition length: 1.0s [17:09:45][C][light:021]: Setting up light 'LED Ring'... [17:09:45][D][light:036]: 'LED Ring' Setting: [17:09:45][D][light:041]: Color mode: RGB [17:09:45][D][light:051]: Brightness: 66% [17:09:45][D][light:055]: Color brightness: 100% [17:09:45][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:09:45][C][light:021]: Setting up light 'voice_assistant_leds'... [17:09:45][D][light:036]: 'voice_assistant_leds' Setting: [17:09:45][D][light:041]: Color mode: RGB [17:09:45][D][template.switch:046]: Restored state ON [17:09:45][D][switch:012]: 'Wake sound' Turning ON. [17:09:45][D][switch:055]: 'Wake sound': Sending state ON [17:09:45][D][template.switch:046]: Restored state OFF [17:09:45][D][switch:016]: 'Mute Microphones' Turning OFF. [17:09:46][D][switch:055]: 'Mute Microphones': Sending state OFF [17:09:46][D][light:036]: 'voice_assistant_leds' Setting: [17:09:46][D][light:047]: State: ON [17:09:46][D][light:051]: Brightness: 66% [17:09:46][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:09:46][D][template.switch:046]: Restored state OFF [17:09:46][D][switch:016]: 'timer_ringing' Turning OFF. [17:09:46][D][switch:055]: 'timer_ringing': Sending state OFF [17:09:46][D][light:036]: 'voice_assistant_leds' Setting: [17:09:46][D][light:051]: Brightness: 66% [17:09:46][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:09:46][D][template.switch:046]: Restored state OFF [17:09:46][D][switch:016]: 'Beta firmware' Turning OFF. [17:09:46][D][switch:055]: 'Beta firmware': Sending state OFF [17:09:46][D][main:103]: OTA updates set to use Production firmware [17:09:46][C][i2s_audio:024]: Setting up I2S Audio... [17:09:46][C][aht10:046]: Setting up AHT20 [17:09:46][C][ltr_als_ps:066]: Setting up LTR-303/329/55x/659 [17:09:46][D][pcm5122:021]: PCM5122 chip found. [17:09:46][D][tas2780:041]: TAS2780 chip found. [17:09:46][D][tas2780:042]: Reg 0x68: 127. [17:09:46][D][tas2780:043]: Reg 0x02: 26. [17:09:46][C][i2s_audio.microphone:075]: Setting up I2S Audio Microphone... [17:09:46][D][ring_buffer:034]: Created ring buffer with size 6144 [17:09:46][D][ring_buffer:034]: Created ring buffer with size 6144 [17:09:46][D][main:779]: FutureProofHomes Satellite1 Core version v1.0.0-beta.1 running ESP firmware: v0.0.4 and XMOS firmware: v1.0.1-alpha.33 [17:09:47][D][light:036]: 'voice_assistant_leds' Setting: [17:09:47][D][light:051]: Brightness: 66% [17:09:47][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:09:47][C][esp32_ble:032]: Setting up BLE... [17:09:47][C][wifi:048]: Setting up WiFi... [17:09:47][D][esp-idf:000]: I (1987) pp: pp rom version: e7ae62f [17:09:47] [17:09:47][D][esp-idf:000]: I (1988) net80211: net80211 rom version: e7ae62f [17:09:47] [17:09:47][D][esp-idf:000]: I (1990) wifi: [17:09:47][D][esp-idf:000]: wifi driver task: 3fcb5a10, prio:23, stack:6656, core=0 [17:09:47][D][esp-idf:000]: [17:09:47] [17:09:47][D][esp-idf:000][wifi]: I (1992) system_api: Base MAC address is not set [17:09:47] [17:09:47][D][esp-idf:000][wifi]: I (1993) system_api: read default base MAC address from EFUSE [17:09:47] [17:09:47][D][esp-idf:000][wifi]: I (1996) wifi: [17:09:47][D][esp-idf:000][wifi]: wifi firmware version: ff661c3 [17:09:47][D][esp-idf:000][wifi]: [17:09:47] [17:09:47][D][esp-idf:000][wifi]: I (1998) wifi: [17:09:47][D][esp-idf:000][wifi]: wifi certification version: v7.0 [17:09:47][D][esp-idf:000][wifi]: [17:09:47] [17:09:47][D][esp-idf:000][wifi]: I (2000) wifi: [17:09:47][D][esp-idf:000][wifi]: config NVS flash: enabled [17:09:48][D][esp-idf:000][wifi]: [17:09:48] [17:09:48][D][esp-idf:000][wifi]: I (2002) wifi: [17:09:48][D][esp-idf:000][wifi]: config nano formating: disabled [17:09:48][D][esp-idf:000][wifi]: [17:09:48] [17:09:48][D][esp-idf:000][wifi]: I (2004) wifi: [17:09:48][D][esp-idf:000][wifi]: Init data frame dynamic rx buffer num: 32 [17:09:48][D][esp-idf:000][wifi]: [17:09:48] [17:09:48][D][esp-idf:000][wifi]: I (2006) wifi: [17:09:48][D][esp-idf:000][wifi]: Init static rx mgmt buffer num: 5 [17:09:48][D][esp-idf:000][wifi]: [17:09:48] [17:09:48][D][esp-idf:000][wifi]: I (2008) wifi: [17:09:48][D][esp-idf:000][wifi]: Init management short buffer num: 32 [17:09:48][D][esp-idf:000][wifi]: [17:09:48] [17:09:48][D][esp-idf:000][wifi]: I (2010) wifi: [17:09:48][D][esp-idf:000][wifi]: Init dynamic tx buffer num: 32 [17:09:48][D][esp-idf:000][wifi]: [17:09:48] [17:09:48][D][esp-idf:000][wifi]: I (2013) wifi: [17:09:48][D][esp-idf:000][wifi]: Init tx cache buffer num: 32 [17:09:48][D][esp-idf:000][wifi]: [17:09:48] [17:09:49][D][esp-idf:000][wifi]: I (2015) wifi: [17:09:49][D][esp-idf:000][wifi]: Init static tx FG buffer num: 2 [17:09:49][D][esp-idf:000][wifi]: [17:09:49] [17:09:49][D][esp-idf:000][wifi]: I (2017) wifi: [17:09:49][D][esp-idf:000][wifi]: Init static rx buffer size: 1600 [17:09:49][D][esp-idf:000][wifi]: [17:09:49] [17:09:49][D][esp-idf:000][wifi]: I (2019) wifi: [17:09:49][D][esp-idf:000][wifi]: Init static rx buffer num: 16 [17:09:49][D][esp-idf:000][wifi]: [17:09:49] [17:09:49][D][esp-idf:000][wifi]: I (2021) wifi: [17:09:49][D][esp-idf:000][wifi]: Init dynamic rx buffer num: 32 [17:09:49][D][esp-idf:000][wifi]: [17:09:49] [17:09:49][D][esp-idf:000]: I (2023) wifi_init: rx ba win: 16 [17:09:49] [17:09:49][D][esp-idf:000]: I (2024) wifi_init: tcpip mbox: 32 [17:09:49] [17:09:49][D][esp-idf:000]: I (2025) wifi_init: udp mbox: 6 [17:09:49] [17:09:49][D][esp-idf:000]: I (2026) wifi_init: tcp mbox: 6 [17:09:49] [17:09:49][D][esp-idf:000]: I (2027) wifi_init: tcp tx win: 5760 [17:09:50] [17:09:50][D][esp-idf:000]: I (2027) wifi_init: tcp rx win: 5760 [17:09:50] [17:09:50][D][esp-idf:000]: I (2028) wifi_init: tcp mss: 1440 [17:09:50] [17:09:50][D][esp-idf:000]: I (2029) wifi_init: WiFi/LWIP prefer SPIRAM [17:09:50] [17:09:50][D][esp-idf:000]: I (2030) wifi_init: WiFi IRAM OP enabled [17:09:50] [17:09:50][D][esp-idf:000]: I (2031) wifi_init: WiFi RX IRAM OP enabled [17:09:50] [17:09:50][C][wifi:061]: Starting WiFi... [17:09:50][C][wifi:062]: Local MAC: D8:3B:DA:40:78:70 [17:09:50][D][wifi:074]: Loaded saved wifi settings: HomeNet [17:09:50][D][esp-idf:000][wifi]: I (2036) phy_init: phy_version 670,b7bc9b9,Apr 30 2024,10:54:13 [17:09:50] [17:09:50][D][esp-idf:000][wifi]: I (2073) wifi: [17:09:50][D][esp-idf:000][wifi]: mode : sta (d8:3b:da:40:78:70) [17:09:50][D][esp-idf:000][wifi]: [17:09:50] [17:09:50][D][esp-idf:000][wifi]: I (2076) wifi: [17:09:50][D][esp-idf:000][wifi]: enable tsf [17:09:50][D][esp-idf:000][wifi]: [17:09:50] [17:09:50][D][esp-idf:000][wifi]: I (2078) wifi: [17:09:50][D][esp-idf:000][wifi]: Set ps type: 1 [17:09:51] [17:09:51][D][esp-idf:000][wifi]: [17:09:51] [17:09:51][D][wifi:482]: Starting scan... [17:09:51][D][esp32.preferences:114]: Saving 4 preferences to flash... [17:09:51][D][esp32.preferences:143]: Saving 4 preferences to flash: 4 cached, 0 written, 0 failed [17:09:51][D][aht10:115]: ATH10 Unrealistic humidity (0x0), retrying... [17:09:51][D][esp-idf:000][wifi]: I (2092) wifi: [17:09:51][D][esp-idf:000][wifi]: Set ps type: 1 [17:09:51] [17:09:51][D][esp-idf:000][wifi]: [17:09:51] [17:09:51][W][component:157]: Component wifi set Warning flag: scanning for networks [17:09:51][I][Satellite1:172]: XMOS Firmware Version: 0.0.7 [17:09:51]0;36m[D][wifi:497]: Found networks: [17:09:51][I][wifi:541]: - 'HomeNet' (1E:E8:29:91:CA:92) [redacted]▂▄▆█ [17:09:51][D][wifi:542]: Channel: 11 [17:09:51][D][wifi:543]: RSSI: -58 dB [17:09:51][I][wifi:541]: - 'HomeNet' (0A:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:09:51][D][wifi:542]: Channel: 6 [17:09:51][D][wifi:543]: RSSI: -83 dB [17:09:51][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:92) [redacted]▂▄▆█ [17:09:51][D][wifi:546]: - ''[redacted] (88:DE:A9:35:1B:7F) [redacted]▂▄▆█ [17:09:51][D][wifi:546]: - 'IotWifi'[redacted] (04:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:09:51][D][wifi:546]: - ''[redacted] (AC:3A:7A:37:BA:E1) [redacted]▂▄▆█ [17:09:52][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:1F) [redacted]▂▄▆█ [17:09:52][D][wifi:546]: - ''[redacted] (22:EF:BD:FC:27:B0) [redacted]▂▄▆█ [17:09:52][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:09:52][D][esp-idf:000][wifi]: I (10276) wifi: [17:09:52][D][esp-idf:000][wifi]: new:<11,0>, old:<1,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:09:52][D][esp-idf:000][wifi]: [17:09:52] [17:09:52][D][esp-idf:000][wifi]: I (10280) wifi: [17:09:52][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:09:52][D][esp-idf:000][wifi]: [17:09:52] [17:09:52][D][esp-idf:000][wifi]: I (11270) wifi: [17:09:52][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:09:52][D][esp-idf:000][wifi]: [17:09:52] [17:09:52][D][esp-idf:000][wifi]: E (11281) wifi: [17:09:52][D][esp-idf:000][wifi]: Set status to INIT [17:09:52][D][esp-idf:000][wifi]: [17:09:52] [17:09:52][D][esp-idf:000][wifi]: I (11283) wifi: [17:09:52][D][esp-idf:000][wifi]: state: assoc -> init (1e10) [17:09:52][D][esp-idf:000][wifi]: [17:09:52] [17:09:53][D][esp-idf:000][wifi]: I (11285) wifi: [17:09:53][D][esp-idf:000][wifi]: Coexist: Wi-Fi connect fail, apply reconnect coex policy [17:09:53] [17:09:53][D][esp-idf:000][wifi]: [17:09:53] [17:09:53][D][esp-idf:000][wifi]: I (11288) wifi: [17:09:53][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:09:53][D][esp-idf:000][wifi]: [17:09:53] [17:09:53][W][wifi_esp32:712]: Event: Disconnected ssid='HomeNet' bssid=1E:E8:29:91:CA:92[redacted] reason='Association Failed' [17:09:53][W][wifi:653]: Error while connecting to network. [17:09:53][D][wifi:697]: Retrying with hidden networks... [17:09:53][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:09:53][D][esp-idf:000][wifi]: I (11315) wifi: [17:09:53][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:09:53][D][esp-idf:000][wifi]: [17:09:53] [17:09:53][D][esp-idf:000][wifi]: I (11318) wifi: [17:09:53][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:09:53][D][esp-idf:000][wifi]: [17:09:53] [17:09:53][D][esp-idf:000][wifi]: I (12291) wifi: [17:09:53][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:09:53][D][esp-idf:000][wifi]: [17:09:53] [17:09:54][D][esp-idf:000][wifi]: E (12298) wifi: [17:09:54][D][esp-idf:000][wifi]: Set status to INIT [17:09:54][D][esp-idf:000][wifi]: [17:09:54] [17:09:54][D][esp-idf:000][wifi]: I (12300) wifi: [17:09:54][D][esp-idf:000][wifi]: state: assoc -> init (1e10) [17:09:54][D][esp-idf:000][wifi]: [17:09:54] [17:09:54][D][esp-idf:000][wifi]: I (12302) wifi: [17:09:54][D][esp-idf:000][wifi]: Coexist: Wi-Fi connect fail, apply reconnect coex policy [17:09:54] [17:09:54][D][esp-idf:000][wifi]: [17:09:54] [17:09:54][D][esp-idf:000][wifi]: I (12305) wifi: [17:09:54][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:09:54][D][esp-idf:000][wifi]: [17:09:54] [17:09:54][W][wifi_esp32:712]: Event: Disconnected ssid='HomeNet' bssid=1E:E8:29:91:CA:92[redacted] reason='Association Failed' [17:09:54][W][wifi:653]: Error while connecting to network. [17:09:54][D][wifi:697]: Retrying with hidden networks... [17:09:54]ESP-ROM:esp32s3-20210327 [17:09:55]Build:Mar 27 2021 [17:09:55]rst:0x15 (USB_UART_CHIP_RESET),boot:0x2b (SPI_FAST_FLASH_BOOT) [17:09:55]Saved PC:0x4216aaae [17:09:55]SPIWP:0xee [17:09:55]mode:DIO, clock div:1 [17:09:55]load:0x3fce3808,len:0x16c4 [17:09:55]load:0x403c9700,len:0xbc0 [17:09:55]load:0x403cc700,len:0x2e90 [17:09:55]entry 0x403c9950 [17:09:55]I (24) boot: ESP-IDF 4.4.8 2nd stage bootloader [17:09:55]I (24) boot: compile time 19:04:16 [17:09:55]I (25) boot: Multicore bootloader [17:09:55]I (26) boot: chip revision: v0.2 [17:09:55]I (30) boot.esp32s3: Boot SPI Speed : 80MHz [17:09:55]I (35) boot.esp32s3: SPI Mode : DIO [17:09:55]I (40) boot.esp32s3: SPI Flash Size : 16MB [17:09:55]I (45) boot: Enabling RNG early entropy source... [17:09:55]I (50) boot: Partition Table: [17:09:55]I (54) boot: ## Label Usage Type ST Offset Length [17:09:55]I (61) boot: 0 otadata OTA data 01 00 00009000 00002000 [17:09:55]I (68) boot: 1 phy_init RF data 01 01 0000b000 00001000 [17:09:55]I (76) boot: 2 app0 OTA app 00 10 00010000 007c0000 [17:09:56]I (83) boot: 3 app1 OTA app 00 11 007d0000 007c0000 [17:09:56]I (91) boot: 4 nvs WiFi data 01 02 00f90000 0006d000 [17:09:56]I (98) boot: End of partition table [17:09:56]I (102) esp_image: segment 0: paddr=00010020 vaddr=3c170020 size=1469b4h (1337780) map [17:09:56]I (351) esp_image: segment 1: paddr=001569dc vaddr=3fc9dc70 size=04974h ( 18804) load [17:09:56]I (355) esp_image: segment 2: paddr=0015b358 vaddr=40374000 size=04cc0h ( 19648) load [17:09:56]I (361) esp_image: segment 3: paddr=00160020 vaddr=42000020 size=16cf90h (1494928) map [17:09:56]I (633) esp_image: segment 4: paddr=002ccfb8 vaddr=40378cc0 size=14fa8h ( 85928) load [17:09:56]I (663) boot: Loaded app from partition at offset 0x10000 [17:09:56]I (663) boot: Disabling RNG early entropy source... [17:09:56]I (663) cpu_start: Multicore app [17:09:56]I (667) opi psram: vendor id : 0x0d (AP) [17:09:56]I (671) opi psram: dev id : 0x02 (generation 3) [17:09:56]I (677) opi psram: density : 0x03 (64 Mbit) [17:09:56]I (682) opi psram: good-die : 0x01 (Pass) [17:09:56]I (687) opi psram: Latency : 0x01 (Fixed) [17:09:56]I (692) opi psram: VCC : 0x01 (3V) [17:09:56]I (696) opi psram: SRF : 0x01 (Fast Refresh) [17:09:56]I (702) opi psram: BurstType : 0x01 (Hybrid Wrap) [17:09:56]I (707) opi psram: BurstLen : 0x01 (32 Byte) [17:09:56]I (712) opi psram: Readlatency : 0x02 (10 cycles@Fixed) [17:09:56]I (718) opi psram: DriveStrength: 0x00 (1/1) [17:09:56]I (724) MSPI Timing: PSRAM timing tuning index: 5 [17:09:56]I (728) spiram: Found 64MBit SPI RAM device [17:09:57]I (733) spiram: SPI RAM mode: sram 80m [17:09:57]I (738) spiram: PSRAM initialized, cache is in normal (1-core) mode. [17:09:57]I (745) cpu_start: Pro cpu up. [17:09:57]I (748) cpu_start: Starting app cpu, entry point is 0x403779a8 [17:09:57]I (0) cpu_start: App cpu up. [17:09:57]I (1181) spiram: SPI SRAM memory test OK [17:09:57]I (1190) cpu_start: Pro cpu start user code [17:09:57]I (1190) cpu_start: cpu freq: 160000000 [17:09:57]I (1190) cpu_start: Application information: [17:09:57]I (1190) cpu_start: Project name: satellite1 [17:09:57]I (1190) cpu_start: App version: 2024.11.2 [17:09:57]I (1191) cpu_start: Compile time: Dec 6 2024 18:59:28 [17:09:57]I (1191) cpu_start: ELF file SHA256: 79423943e134e5c9... [17:09:57]I (1191) cpu_start: ESP-IDF: 4.4.8 [17:09:57]I (1191) cpu_start: Min chip rev: v0.0 [17:09:57]I (1192) cpu_start: Max chip rev: v0.99 [17:09:57]I (1192) cpu_start: Chip rev: v0.2 [17:09:57]I (1192) heap_init: Initializing. RAM available for dynamic allocation: [17:09:57]I (1192) heap_init: At 3FCA91A0 len 00040570 (257 KiB): D/IRAM [17:09:57]I (1193) heap_init: At 3FCE9710 len 00005724 (21 KiB): STACK/DIRAM [17:09:57]I (1193) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM [17:09:58]I (1193) heap_init: At 600FE000 len 00002000 (8 KiB): RTCRAM [17:09:58]I (1194) spiram: Adding pool of 8192K of external SPI memory to heap allocator [17:09:58]I (1195) spi_flash: detected chip: gd [17:09:58]I (1195) spi_flash: flash io: dio [17:09:58]I (1198) sleep: Configure to isolate all GPIO pins in sleep state [17:09:58]I (1198) sleep: Enable automatic switching of GPIO sleep configuration [17:09:58]I (1199) coexist: coexist rom version e7ae62f [17:09:58]I (1200) cpu_start: Starting scheduler on PRO CPU. [17:09:58]I (0) cpu_start: Starting scheduler on APP CPU. [17:09:58][I][logger:171]: Log initialized [17:09:58][C][status_led:014]: Setting up Status LED... [17:09:58][D][esp-idf:000]: I (181) gpio: GPIO[45]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:09:58] [17:09:58][C][safe_mode:079]: There have been 1 suspected unsuccessful boot attempts [17:09:58][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:09:58][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:09:58][I][app:029]: Running through setup()... [17:09:58][C][i2c.idf:017]: Setting up I2C bus... [17:09:58][I][i2c.idf:252]: Performing I2C bus recovery [17:09:58][D][esp-idf:000]: I (1632) gpio: GPIO[6]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:09:58] [17:09:58][D][esp-idf:000]: I (1633) gpio: GPIO[5]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:09:58] [17:09:59][D][spi:035]: Setting up SPI bus... [17:09:59][D][spi_device:362]: mode 3, data_rate 8000kHz [17:09:59][D][esp-idf:000]: I (1651) gpio: GPIO[10]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:09:59] [17:09:59][D][esp-idf:000]: I (1653) gpio: GPIO[4]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:09:59] [17:09:59][I][Satellite1:172]: XMOS Firmware Version: 6.0.7 [17:09:59][D][number:012]: 'Offset Temperature': Sending state 0.000000 [17:09:59][D][number:012]: 'Offset Humidity': Sending state 0.000000 [17:09:59][D][fusb302b:360]: reported device id: 145 [17:09:59][D][fusb302b:133]: FUSB302 found, initializing... [17:09:59][C][esp32_rmt_led_strip:021]: Setting up ESP32 LED Strip... [17:09:59][D][binary_sensor:034]: 'Button Left (HW Mute)': Sending initial state OFF [17:09:59][D][binary_sensor:034]: 'Button Up (Vol+)': Sending initial state OFF [17:09:59][D][binary_sensor:034]: 'Button Down (Vol-)': Sending initial state OFF [17:09:59][D][esp-idf:000]: I (1869) gpio: GPIO[0]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0 [17:09:59] [17:09:59][D][binary_sensor:034]: 'Button Right (Action)': Sending initial state OFF [17:09:59][C][light:021]: Setting up light 'hw_led_ring'... [17:09:59][D][light:036]: 'hw_led_ring' Setting: [17:09:59][D][light:041]: Color mode: RGB [17:09:59][D][light:085]: Transition length: 1.0s [17:09:59][C][light:021]: Setting up light 'LED Ring'... [17:10:00][D][light:036]: 'LED Ring' Setting: [17:10:00][D][light:041]: Color mode: RGB [17:10:00][D][light:051]: Brightness: 66% [17:10:00][D][light:055]: Color brightness: 100% [17:10:00][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:10:00][C][light:021]: Setting up light 'voice_assistant_leds'... [17:10:00][D][light:036]: 'voice_assistant_leds' Setting: [17:10:00][D][light:041]: Color mode: RGB [17:10:00][D][template.switch:046]: Restored state ON [17:10:00][D][switch:012]: 'Wake sound' Turning ON. [17:10:00][D][switch:055]: 'Wake sound': Sending state ON [17:10:00][D][template.switch:046]: Restored state OFF [17:10:00][D][switch:016]: 'Mute Microphones' Turning OFF. [17:10:00][D][switch:055]: 'Mute Microphones': Sending state OFF [17:10:00][D][light:036]: 'voice_assistant_leds' Setting: [17:10:00][D][light:047]: State: ON [17:10:00][D][light:051]: Brightness: 66% [17:10:00][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:10:00][D][template.switch:046]: Restored state OFF [17:10:00][D][switch:016]: 'timer_ringing' Turning OFF. [17:10:00][D][switch:055]: 'timer_ringing': Sending state OFF [17:10:00][D][light:036]: 'voice_assistant_leds' Setting: [17:10:01][D][light:051]: Brightness: 66% [17:10:01][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:10:01][D][template.switch:046]: Restored state OFF [17:10:01][D][switch:016]: 'Beta firmware' Turning OFF. [17:10:01][D][switch:055]: 'Beta firmware': Sending state OFF [17:10:01][D][main:103]: OTA updates set to use Production firmware [17:10:01][C][i2s_audio:024]: Setting up I2S Audio... [17:10:01][C][aht10:046]: Setting up AHT20 [17:10:01][C][ltr_als_ps:066]: Setting up LTR-303/329/55x/659 [17:10:01][D][pcm5122:021]: PCM5122 chip found. [17:10:01][D][tas2780:041]: TAS2780 chip found. [17:10:01][D][tas2780:042]: Reg 0x68: 127. [17:10:01][D][tas2780:043]: Reg 0x02: 26. [17:10:01][C][i2s_audio.microphone:075]: Setting up I2S Audio Microphone... [17:10:01][D][ring_buffer:034]: Created ring buffer with size 6144 [17:10:01][D][ring_buffer:034]: Created ring buffer with size 6144 [17:10:01][D][main:779]: FutureProofHomes Satellite1 Core version v1.0.0-beta.1 running ESP firmware: v0.0.4 and XMOS firmware: v1.0.1-alpha.33 [17:10:01][D][light:036]: 'voice_assistant_leds' Setting: [17:10:01][D][light:051]: Brightness: 66% [17:10:01][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:10:01][C][esp32_ble:032]: Setting up BLE... [17:10:01][C][wifi:048]: Setting up WiFi... [17:10:02][D][esp-idf:000]: I (1989) pp: pp rom version: e7ae62f [17:10:02] [17:10:02][D][esp-idf:000]: I (1990) net80211: net80211 rom version: e7ae62f [17:10:02] [17:10:02][D][esp-idf:000]: I (1992) wifi: [17:10:02][D][esp-idf:000]: wifi driver task: 3fcb5a10, prio:23, stack:6656, core=0 [17:10:02][D][esp-idf:000]: [17:10:02] [17:10:02][D][esp-idf:000][wifi]: I (1994) system_api: Base MAC address is not set [17:10:02] [17:10:02][D][esp-idf:000][wifi]: I (1995) system_api: read default base MAC address from EFUSE [17:10:02] [17:10:02][D][esp-idf:000][wifi]: I (1998) wifi: [17:10:02][D][esp-idf:000][wifi]: wifi firmware version: ff661c3 [17:10:02][D][esp-idf:000][wifi]: [17:10:02] [17:10:02][D][esp-idf:000][wifi]: I (2000) wifi: [17:10:02][D][esp-idf:000][wifi]: wifi certification version: v7.0 [17:10:02][D][esp-idf:000][wifi]: [17:10:02] [17:10:02][D][esp-idf:000][wifi]: I (2002) wifi: [17:10:03][D][esp-idf:000][wifi]: config NVS flash: enabled [17:10:03][D][esp-idf:000][wifi]: [17:10:03] [17:10:03][D][esp-idf:000][wifi]: I (2004) wifi: [17:10:03][D][esp-idf:000][wifi]: config nano formating: disabled [17:10:03][D][esp-idf:000][wifi]: [17:10:03] [17:10:03][D][esp-idf:000][wifi]: I (2006) wifi: [17:10:03][D][esp-idf:000][wifi]: Init data frame dynamic rx buffer num: 32 [17:10:03][D][esp-idf:000][wifi]: [17:10:03] [17:10:03][D][esp-idf:000][wifi]: I (2008) wifi: [17:10:03][D][esp-idf:000][wifi]: Init static rx mgmt buffer num: 5 [17:10:03][D][esp-idf:000][wifi]: [17:10:03] [17:10:03][D][esp-idf:000][wifi]: I (2010) wifi: [17:10:03][D][esp-idf:000][wifi]: Init management short buffer num: 32 [17:10:03][D][esp-idf:000][wifi]: [17:10:03] [17:10:03][D][esp-idf:000][wifi]: I (2012) wifi: [17:10:03][D][esp-idf:000][wifi]: Init dynamic tx buffer num: 32 [17:10:04][D][esp-idf:000][wifi]: [17:10:04] [17:10:04][D][esp-idf:000][wifi]: I (2015) wifi: [17:10:04][D][esp-idf:000][wifi]: Init tx cache buffer num: 32 [17:10:04][D][esp-idf:000][wifi]: [17:10:04] [17:10:04][D][esp-idf:000][wifi]: I (2017) wifi: [17:10:04][D][esp-idf:000][wifi]: Init static tx FG buffer num: 2 [17:10:04][D][esp-idf:000][wifi]: [17:10:04] [17:10:04][D][esp-idf:000][wifi]: I (2019) wifi: [17:10:04][D][esp-idf:000][wifi]: Init static rx buffer size: 1600 [17:10:04][D][esp-idf:000][wifi]: [17:10:04] [17:10:04][D][esp-idf:000][wifi]: I (2021) wifi: [17:10:04][D][esp-idf:000][wifi]: Init static rx buffer num: 16 [17:10:04][D][esp-idf:000][wifi]: [17:10:04] [17:10:04][D][esp-idf:000][wifi]: I (2023) wifi: [17:10:04][D][esp-idf:000][wifi]: Init dynamic rx buffer num: 32 [17:10:04][D][esp-idf:000][wifi]: [17:10:04] [17:10:05][D][esp-idf:000]: I (2025) wifi_init: rx ba win: 16 [17:10:05] [17:10:05][D][esp-idf:000]: I (2026) wifi_init: tcpip mbox: 32 [17:10:05] [17:10:05][D][esp-idf:000]: I (2027) wifi_init: udp mbox: 6 [17:10:05] [17:10:05][D][esp-idf:000]: I (2028) wifi_init: tcp mbox: 6 [17:10:05] [17:10:05][D][esp-idf:000]: I (2029) wifi_init: tcp tx win: 5760 [17:10:05] [17:10:05][D][esp-idf:000]: I (2029) wifi_init: tcp rx win: 5760 [17:10:05] [17:10:05][D][esp-idf:000]: I (2030) wifi_init: tcp mss: 1440 [17:10:05] [17:10:05][D][esp-idf:000]: I (2031) wifi_init: WiFi/LWIP prefer SPIRAM [17:10:05] [17:10:05][D][esp-idf:000]: I (2032) wifi_init: WiFi IRAM OP enabled [17:10:05] [17:10:05][D][esp-idf:000]: I (2033) wifi_init: WiFi RX IRAM OP enabled [17:10:05] [17:10:06][C][wifi:061]: Starting WiFi... [17:10:06][C][wifi:062]: Local MAC: D8:3B:DA:40:78:70 [17:10:06][D][wifi:074]: Loaded saved wifi settings: HomeNet [17:10:06][D][esp-idf:000][wifi]: I (2038) phy_init: phy_version 670,b7bc9b9,Apr 30 2024,10:54:13 [17:10:06] [17:10:06][D][esp-idf:000][wifi]: I (2075) wifi: [17:10:06][D][esp-idf:000][wifi]: mode : sta (d8:3b:da:40:78:70) [17:10:06][D][esp-idf:000][wifi]: [17:10:06] [17:10:06][D][esp-idf:000][wifi]: I (2078) wifi: [17:10:06][D][esp-idf:000][wifi]: enable tsf [17:10:06][D][esp-idf:000][wifi]: [17:10:06] [17:10:06][D][esp-idf:000][wifi]: I (2081) wifi: [17:10:06][D][esp-idf:000][wifi]: Set ps type: 1 [17:10:06] [17:10:06][D][esp-idf:000][wifi]: [17:10:06] [17:10:06][D][wifi:482]: Starting scan... [17:10:06][D][esp32.preferences:114]: Saving 4 preferences to flash... [17:10:07][D][esp32.preferences:143]: Saving 4 preferences to flash: 4 cached, 0 written, 0 failed [17:10:07][D][aht10:115]: ATH10 Unrealistic humidity (0x0), retrying... [17:10:07][D][esp-idf:000][wifi]: I (2094) wifi: [17:10:07][D][esp-idf:000][wifi]: Set ps type: 1 [17:10:07] [17:10:07][D][esp-idf:000][wifi]: [17:10:07] [17:10:07][W][component:157]: Component wifi set Warning flag: scanning for networks [17:10:07][I][Satellite1:172]: XMOS Firmware Version: 0.0.7 [17:10:07][D][esp32_ble:284]: Enabling BLE... [17:10:07][D][esp-idf:000]: I (2118) BLE_INIT: BT controller compile version [ba3b3e3] [17:10:07] [17:10:07][D][esp-idf:000][btController]: I (2120) BLE_INIT: Bluetooth MAC: d8:3b:da:40:78:72 [17:10:07] [17:10:07] [17:10:07][D][aht10:097]: Read attempt 2 at 686ms [17:10:07][D][aht10:124]: Success at 688ms [17:10:07][D][sensor:094]: 'Temperature': Sending state 33.08723 °C with 2 decimals of accuracy [17:10:07][D][sensor:094]: 'Humidity': Sending state 40.38399 % with 2 decimals of accuracy [17:10:07][D][esp32_ble_server:077]: BLE server setup successfully [17:10:07][D][esp32_improv.component:082]: Creating Improv service [17:10:07][D][light:036]: 'voice_assistant_leds' Setting: [17:10:08][D][light:051]: Brightness: 66% [17:10:08][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:10:08][D][text_sensor:064]: 'XMOS Firmware': Sending state 'v0.0.7' [17:10:08][D][wifi:497]: Found networks: [17:10:08][I][wifi:541]: - 'HomeNet' (1E:E8:29:91:CA:92) [redacted]▂▄▆█ [17:10:08][D][wifi:542]: Channel: 11 [17:10:08][D][wifi:543]: RSSI: -60 dB [17:10:08][I][wifi:541]: - 'HomeNet' (0A:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:10:08][D][wifi:542]: Channel: 6 [17:10:08][D][wifi:543]: RSSI: -83 dB [17:10:08][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:92) [redacted]▂▄▆█ [17:10:08][D][wifi:546]: - ''[redacted] (88:DE:A9:35:1B:7F) [redacted]▂▄▆█ [17:10:08][D][wifi:546]: - 'IotWifi'[redacted] (04:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:10:08][D][wifi:546]: - ''[redacted] (AC:3A:7A:37:BA:E1) [redacted]▂▄▆█ [17:10:08][D][wifi:546]: - ''[redacted] (BE:D7:D4:34:FA:3F) [redacted]▂▄▆█ [17:10:08][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:1F) [redacted]▂▄▆█ [17:10:08][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:10:08][D][esp-idf:000][wifi]: I (10578) wifi: [17:10:08][D][esp-idf:000][wifi]: new:<11,0>, old:<1,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:10:08][D][esp-idf:000][wifi]: [17:10:09] [17:10:09][D][esp-idf:000][wifi]: I (10582) wifi: [17:10:09][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:10:09][D][esp-idf:000][wifi]: [17:10:09] [17:10:09][D][esp-idf:000][wifi]: I (11561) wifi: [17:10:09][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:10:09][D][esp-idf:000][wifi]: [17:10:09] [17:10:09][D][esp-idf:000][wifi]: I (11567) wifi: [17:10:09][D][esp-idf:000][wifi]: state: assoc -> run (10) [17:10:09][D][esp-idf:000][wifi]: [17:10:09] [17:10:09][D][esp-idf:000][wifi]: I (11599) wifi: [17:10:09][D][esp-idf:000][wifi]: connected with HomeNet, aid = 4, channel 11, BW20, bssid = 1e:e8:29:91:ca:92 [17:10:09][D][esp-idf:000][wifi]: [17:10:09] [17:10:09][D][esp-idf:000][wifi]: I (11601) wifi: [17:10:09][D][esp-idf:000][wifi]: security: WPA3-SAE, phy: bgn, rssi: -58 [17:10:10][D][esp-idf:000][wifi]: [17:10:10] [17:10:10][D][esp-idf:000][wifi]: I (11604) wifi: [17:10:10][D][esp-idf:000][wifi]: pm start, type: 1 [17:10:10] [17:10:10][D][esp-idf:000][wifi]: [17:10:10] [17:10:10][D][esp-idf:000][wifi]: I (11606) wifi: [17:10:10][D][esp-idf:000][wifi]: set rx beacon pti, rx_bcn_pti: 14, bcn_timeout: 14, mt_pti: 25000, mt_time: 10000 [17:10:10][D][esp-idf:000][wifi]: [17:10:10] [17:10:10][D][esp-idf:000][wifi]: I (11688) wifi: [17:10:10][D][esp-idf:000][wifi]: AP's beacon interval = 102400 us, DTIM period = 1 [17:10:10][D][esp-idf:000][wifi]: [17:10:10] [17:10:10][D][esp-idf:000][sys_evt]: I (12611) esp_netif_handlers: sta ip: 192.168.3.215, mask: 255.255.255.0, gw: 192.168.3.1 [17:10:10] [17:10:10][I][wifi:617]: WiFi Connected! [17:10:10][C][wifi:428]: Local MAC: D8:3B:DA:40:78:70 [17:10:10][C][wifi:433]: SSID: 'HomeNet'[redacted] [17:10:10][C][wifi:436]: IP Address: 192.168.3.215 [17:10:10][C][wifi:440]: BSSID: 1E:E8:29:91:CA:92[redacted] [17:10:10][C][wifi:441]: Hostname: 'satellite1-407870' [17:10:11][C][wifi:443]: Signal strength: -56 dB ▂▄▆█ [17:10:11][C][wifi:447]: Channel: 11 [17:10:11][C][wifi:448]: Subnet: 255.255.255.0 [17:10:11][C][wifi:449]: Gateway: 192.168.3.1 [17:10:11][C][wifi:450]: DNS1: 192.168.3.152 [17:10:11][C][wifi:451]: DNS2: 0.0.0.0 [17:10:11][C][api:026]: Setting up Home Assistant API server... [17:10:11][C][micro_wake_word:083]: Setting up microWakeWord... [17:10:11][C][micro_wake_word:109]: Micro Wake Word initialized [17:10:11][I][nabu_media_player:138]: Set up nabu media player [17:10:11][I][app:062]: setup() finished successfully! [17:10:11][D][esp-idf:000][wifi]: I (12708) wifi: [17:10:11][D][esp-idf:000][wifi]: idx:0 (ifx:0, 1e:e8:29:91:ca:92), tid:0, ssn:0, winSize:64 [17:10:11][D][esp-idf:000][wifi]: [17:10:11] [17:10:11][D][esp-idf:000]: I (12875) esp-x509-crt-bundle: Certificate validated [17:10:11] [17:10:11][D][update:011]: 'Satellite1 407870' - Publishing: [17:10:11][D][update:012]: Current Version: v0.0.4 [17:10:11][D][update:015]: Latest Version: v0.0.4 [17:10:12][D][update:018]: Firmware URL: https://raw.githubusercontent.com/FutureProofHomes/Documentation/refs/heads/main/assets/firmware/esphome/production/satellite1-esp32s3.ota.bin [17:10:12][D][update:021]: Title: ESPHome Firmware for Satellite1-Core-Board [17:10:12][D][update:023]: Summary: ESPHome Firmware for satellite1-esp32s3 [17:10:12][D][update:026]: Release URL: https://github.com/FutureProofHomes/Satellite1-ESPHome/releases/tag/v0.0.4/ [17:10:12][W][component:237]: Component http_request.update took a long time for an operation (901 ms). [17:10:12][W][component:238]: Components should block for at most 30 ms. [17:10:12][D][light:036]: 'voice_assistant_leds' Setting: [17:10:12][D][light:051]: Brightness: 66% [17:10:12][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:10:12][D][light:109]: Effect: 'Twinkle' [17:10:12][W][component:170]: Component wifi cleared Warning flag [17:10:12][D][api:103]: Accepted 192.168.3.100 [17:10:12][I][app:100]: ESPHome version 2024.11.2 compiled on Dec 6 2024, 18:59:28 [17:10:12][I][app:102]: Project FutureProofHomes.Satellite1 version v0.0.4 [17:10:12][C][status_led:019]: Status LED: [17:10:12][C][status_led:020]: Pin: GPIO45 [17:10:12][D][api.connection:1446]: Home Assistant 2025.2.1 (192.168.3.100): Connected successfully [17:10:12][C][wifi:600]: WiFi: [17:10:12][C][wifi:428]: Local MAC: D8:3B:DA:40:78:70 [17:10:13][C][wifi:433]: SSID: 'HomeNet'[redacted] [17:10:13][C][wifi:436]: IP Address: 192.168.3.215 [17:10:13][C][wifi:440]: BSSID: 1E:E8:29:91:CA:92[redacted] [17:10:13][C][wifi:441]: Hostname: 'satellite1-407870' [17:10:13][C][wifi:443]: Signal strength: -56 dB ▂▄▆█ [17:10:13][C][wifi:447]: Channel: 11 [17:10:13][C][wifi:448]: Subnet: 255.255.255.0 [17:10:13][C][wifi:449]: Gateway: 192.168.3.1 [17:10:13][C][wifi:450]: DNS1: 192.168.3.152 [17:10:13][C][wifi:451]: DNS2: 0.0.0.0 [17:10:13][C][logger:185]: Logger: [17:10:13][C][logger:186]: Level: DEBUG [17:10:13][C][logger:188]: Log Baud Rate: 115200 [17:10:13][C][logger:189]: Hardware UART: USB_SERIAL_JTAG [17:10:13][C][i2c.idf:075]: I2C Bus: [17:10:13][C][i2c.idf:076]: SDA Pin: GPIO5 [17:10:13][C][i2c.idf:077]: SCL Pin: GPIO6 [17:10:13][C][i2c.idf:078]: Frequency: 400000 Hz [17:10:13][C][i2c.idf:084]: Recovery: bus successfully recovered [17:10:13][I][i2c.idf:094]: Results from i2c bus scan: [17:10:14][I][i2c.idf:100]: Found i2c device at address 0x22 [17:10:14][I][i2c.idf:100]: Found i2c device at address 0x29 [17:10:14][I][i2c.idf:100]: Found i2c device at address 0x38 [17:10:14][I][i2c.idf:100]: Found i2c device at address 0x3F [17:10:14][I][i2c.idf:100]: Found i2c device at address 0x4D [17:10:14][C][spi:064]: SPI bus: [17:10:14][C][spi:065]: CLK Pin: GPIO12 [17:10:14][C][spi:066]: SDI Pin: GPIO13 [17:10:14][C][spi:067]: SDO Pin: GPIO11 [17:10:14][C][spi:072]: Using HW SPI: SPI2_HOST [17:10:14][C][Satellite1:027]: Satellite1 config: [17:10:14][C][template.number:050]: Template Number 'Offset Temperature' [17:10:14][C][template.number:050]: Icon: 'mdi:thermometer' [17:10:14][C][template.number:050]: Unit of Measurement: '°C' [17:10:14][C][template.number:051]: Optimistic: YES [17:10:14][C][template.number:052]: Update Interval: never [17:10:14][C][template.number:050]: Template Number 'Offset Humidity' [17:10:14][C][template.number:050]: Icon: 'mdi:water-percent' [17:10:15][C][template.number:050]: Unit of Measurement: '%' [17:10:15][C][template.number:051]: Optimistic: YES [17:10:15][C][template.number:052]: Update Interval: never [17:10:15][C][template.text_sensor:020]: Template Sensor 'USB-C Power Draw' [17:10:15][C][template.text_sensor:020]: Icon: 'mdi:usb-c-port' [17:10:15][C][template.text_sensor:020]: Template Sensor 'XMOS Firmware' [17:10:15][C][template.text_sensor:020]: Icon: 'mdi:memory' [17:10:15][C][esp32_rmt_led_strip:187]: ESP32 RMT LED Strip: [17:10:15][C][esp32_rmt_led_strip:188]: Pin: 21 [17:10:15][C][esp32_rmt_led_strip:189]: Channel: 1 [17:10:15][C][esp32_rmt_led_strip:214]: RGB Order: GRB [17:10:15][C][esp32_rmt_led_strip:215]: Max refresh rate: 0 [17:10:15][C][esp32_rmt_led_strip:216]: Number of LEDs: 24 [17:10:15][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Left (HW Mute)' [17:10:15][C][gpio.binary_sensor:016]: Pin: [17:10:15][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Up (Vol+)' [17:10:15][C][gpio.binary_sensor:016]: Pin: [17:10:15][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Down (Vol-)' [17:10:16][C][gpio.binary_sensor:016]: Pin: [17:10:16][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Right (Action)' [17:10:16][C][gpio.binary_sensor:016]: Pin: GPIO0 [17:10:16][C][light:092]: Light 'hw_led_ring' [17:10:16][C][light:094]: Default Transition Length: 1.0s [17:10:16][C][light:095]: Gamma Correct: 2.80 [17:10:16][C][light:092]: Light 'LED Ring' [17:10:16][C][light:094]: Default Transition Length: 0.0s [17:10:16][C][light:095]: Gamma Correct: 2.80 [17:10:16][C][light:092]: Light 'voice_assistant_leds' [17:10:16][C][light:094]: Default Transition Length: 0.0s [17:10:16][C][light:095]: Gamma Correct: 2.80 [17:10:16][C][template.switch:068]: Template Switch 'Wake sound' [17:10:16][C][template.switch:070]: Icon: 'mdi:bullhorn' [17:10:16][C][template.switch:091]: Restore Mode: restore defaults to ON [17:10:16][C][template.switch:057]: Optimistic: YES [17:10:16][C][template.switch:068]: Template Switch 'Mute Microphones' [17:10:16][C][template.switch:070]: Icon: 'mdi:microphone-off' [17:10:17][C][template.switch:091]: Restore Mode: restore defaults to OFF [17:10:17][C][template.switch:057]: Optimistic: NO [17:10:17][C][template.switch:068]: Template Switch 'timer_ringing' [17:10:17][C][template.switch:091]: Restore Mode: always OFF [17:10:17][C][template.switch:057]: Optimistic: YES [17:10:17][C][template.switch:068]: Template Switch 'Beta firmware' [17:10:17][C][template.switch:070]: Icon: 'mdi:test-tube' [17:10:17][C][template.switch:091]: Restore Mode: restore defaults to OFF [17:10:17][C][template.switch:057]: Optimistic: YES [17:10:17][C][psram:020]: PSRAM: [17:10:17][C][psram:021]: Available: YES [17:10:17][C][psram:024]: Size: 8191 KB [17:10:17][C][i2s_audio:028]: I2SController: [17:10:17][C][i2s_audio:029]: AccessMode: duplex [17:10:17][C][i2s_audio:030]: Port: 0 [17:10:17][C][i2s_audio:032]: Reader registered. [17:10:17][C][i2s_audio:035]: Writer registered. [17:10:17][C][aht10:162]: AHT10: [17:10:18][C][aht10:163]: Address: 0x38 [17:10:18][C][aht10:167]: Temperature 'Temperature' [17:10:18][C][aht10:167]: Device Class: 'temperature' [17:10:18][C][aht10:167]: State Class: 'measurement' [17:10:18][C][aht10:167]: Unit of Measurement: '°C' [17:10:18][C][aht10:167]: Accuracy Decimals: 2 [17:10:18][C][aht10:168]: Humidity 'Humidity' [17:10:18][C][aht10:168]: Device Class: 'humidity' [17:10:18][C][aht10:168]: State Class: 'measurement' [17:10:18][C][aht10:168]: Unit of Measurement: '%' [17:10:18][C][aht10:168]: Accuracy Decimals: 2 [17:10:18][C][ltr_als_ps:085]: Address: 0x29 [17:10:18][C][ltr_als_ps:086]: Device type: ALS only [17:10:18][C][ltr_als_ps:088]: Automatic mode: ON [17:10:18][C][ltr_als_ps:089]: Gain: 1x [17:10:18][C][ltr_als_ps:090]: Integration time: 100 ms [17:10:18][C][ltr_als_ps:091]: Measurement repeat rate: 500 ms [17:10:18][C][ltr_als_ps:092]: Glass attenuation factor: 1.000000 [17:10:19][C][ltr_als_ps:093]: ALS calculated lux 'Ambient light' [17:10:19][C][ltr_als_ps:093]: Device Class: 'illuminance' [17:10:19][C][ltr_als_ps:093]: State Class: 'measurement' [17:10:19][C][ltr_als_ps:093]: Unit of Measurement: 'lx' [17:10:19][C][ltr_als_ps:093]: Accuracy Decimals: 1 [17:10:19][C][ltr_als_ps:093]: Icon: 'mdi:brightness-6' [17:10:19][C][ltr_als_ps:105]: Update Interval: 60.0s [17:10:19][C][restart.button:017]: Restart Button 'Restart Sat1' [17:10:19][C][restart.button:017]: Icon: 'mdi:restart' [17:10:19][C][factory_reset.button:011]: Factory Reset Button 'Factory Reset ESP32 FW' [17:10:19][C][factory_reset.button:011]: Icon: 'mdi:restart-alert' [17:10:19][C][i2s_audio:143]: I2S-Reader (Fixed-CFG): [17:10:19][C][i2s_audio:148]: clk_mode: external [17:10:19][C][i2s_audio:149]: sample-rate: 48000 bits_per_sample: 32 [17:10:19][C][i2s_audio:150]: channel_fmt: 0 channels: 2 [17:10:19][C][i2s_audio:151]: use_apll: no, use_pdm: no [17:10:19][C][memory_flasher:014]: Embedded Image: [17:10:19][C][memory_flasher:016]: Version: 1.0.1 [17:10:20][C][esp32_ble:391]: ESP32 BLE: [17:10:20][C][esp32_ble:393]: MAC address: D8:3B:DA:40:78:72 [17:10:20][C][esp32_ble:394]: IO Capability: none [17:10:20][C][esp32_ble_server:200]: ESP32 BLE Server: [17:10:20][C][esp32_improv.component:269]: ESP32 Improv: [17:10:20][C][esp32_improv.component:271]: Authorizer 'Button Right (Action)' [17:10:20][C][mdns:116]: mDNS: [17:10:20][C][mdns:117]: Hostname: satellite1-407870 [17:10:20][C][esphome.ota:073]: Over-The-Air updates: [17:10:20][C][esphome.ota:074]: Address: satellite1.local:3232 [17:10:20][C][esphome.ota:075]: Version: 2 [17:10:20][C][safe_mode:018]: Safe Mode: [17:10:20][C][safe_mode:020]: Boot considered successful after 60 seconds [17:10:20][C][safe_mode:021]: Invoke after 10 boot attempts [17:10:20][C][safe_mode:023]: Remain in safe mode for 300 seconds [17:10:20][C][http_request.ota:026]: Over-The-Air updates via HTTP request [17:10:20][C][api:140]: API Server: [17:10:20][C][api:141]: Address: satellite1.local:6053 [17:10:21][C][api:145]: Using noise encryption: NO [17:10:21][C][improv_serial:032]: Improv Serial: [17:10:21][C][http_request:013]: HTTP Request: [17:10:21][C][http_request:014]: Timeout: 4500ms [17:10:21][C][http_request:015]: User-Agent: ESPHome/2024.11.2 (https://esphome.io) [17:10:21][C][http_request:016]: Follow redirects: YES [17:10:21][C][http_request:017]: Redirect limit: 3 [17:10:21][C][http_request.idf:022]: Buffer [D][esp32_ble:269]: Disabling BLE... [17:10:21][D][esp-idf:000][BTU_TASK]: W (23567) BT_APPL: bta_dm_disable BTA_DISABLE_DELAY set to 200 ms [17:10:21] [17:10:21][W][component:237]: Component esp32_ble took a long time for an operation (212 ms). [17:10:21][W][component:238]: Components should block for at most 30 ms. [17:10:21][D][micro_wake_word:379]: Starting wake word detection [17:10:21][D][light:036]: 'voice_assistant_leds' Setting: [17:10:21][D][light:047]: State: OFF [17:10:21][D][light:109]: Effect: 'None' [17:10:21][D][i2s_audio:067][microphone_task]: Install driver requested by Reader [17:10:22][D][esp-idf:000][microphone_task]: I (25589) I2S: DMA Malloc info, datalen=blocksize=4088, dma_buf_count=6 [17:10:22] [17:10:22][D][esp-idf:000][microphone_task]: I (25592) I2S: DMA Malloc info, datalen=blocksize=4088, dma_buf_count=6 [17:10:22] [17:10:22][D][i2s_audio:077][microphone_task]: Installing driver : yes [17:10:22][D][i2s_audio.microphone:322]: Starting I2S Audio Microphne [17:10:22][D][i2s_audio.microphone:326]: Started I2S Audio Microphone [17:10:22][D][micro_wake_word:418]: State changed from IDLE to DETECTING_WAKE_WORD [17:10:35][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:10:35][D][esp32.preferences:143]: Saving 1 preferences to flash: 1 cached, 0 written, 0 failed [17:10:37][D][micro_wake_word:357]: Detected 'Hey Jarvis' with sliding average probability is 0.98 and max probability is 1.00 [17:10:37][D][media_player:080]: 'Sat1 Media Player' - Setting [17:10:37][D][media_player:084]: Command: STOP [17:10:37][D][media_player:093]: Announcement: yes [17:10:37][D][media_player:080]: 'Sat1 Media Player' - Setting [17:10:37][D][media_player:093]: Announcement: yes [17:10:37][D][ring_buffer:034]: Created ring buffer with size 48000 [17:10:37][D][ring_buffer:034]: Created ring buffer with size 48000 [17:10:37][D][ring_buffer:034]: Created ring buffer with size 16384 [17:10:38][D][i2s_audio:067][speaker_task]: Install driver requested by Writer [17:10:38][D][ring_buffer:034]: Created ring buffer with size 131072 [17:10:38][D][ring_buffer:034]: Created ring buffer with size 65536 [17:10:38][D][nabu_media_player:427]: Starting Media Player Speaker [17:10:38][D][nabu_media_player:430]: Started Media Player Speaker [17:10:38][D][nabu_media_player.pipeline:176]: Reading FLAC file type [17:10:38][D][nabu_media_player.pipeline:410][ann_decode]: Creating and starting new AudioDecoder [17:10:38][D][nabu_media_player.decoder:056][ann_decode]: Starting AudioDecoder. [17:10:38][D][nabu_media_player.pipeline:186]: Decoded audio has 1 channels, 48000 Hz sample rate, and 16 bits per sample [17:10:38][D][nabu_media_player.pipeline:197]: Converting mono channel audio to stereo channel audio [17:10:38][D][voice_assistant:516]: State changed from IDLE to START_MICROPHONE [17:10:38][D][voice_assistant:522]: Desired state set to START_PIPELINE [17:10:38][D][voice_assistant:225]: Starting Microphone [17:10:38][D][ring_buffer:034]: Created ring buffer with size 16384 [17:10:38][D][voice_assistant:516]: State changed from START_MICROPHONE to STARTING_MICROPHONE [17:10:38][D][voice_assistant:516]: State changed from STARTING_MICROPHONE to START_PIPELINE [17:10:38][D][voice_assistant:280]: Requesting start... [17:10:38][D][voice_assistant:516]: State changed from START_PIPELINE to STARTING_PIPELINE [17:10:39][D][voice_assistant:537]: Client started, streaming microphone [17:10:39][D][voice_assistant:516]: State changed from STARTING_PIPELINE to STREAMING_MICROPHONE [17:10:39][D][voice_assistant:522]: Desired state set to STREAMING_MICROPHONE [17:10:39][D][voice_assistant:639]: Event Type: 1 [17:10:39][D][voice_assistant:642]: Assist Pipeline running [17:10:39][D][voice_assistant:639]: Event Type: 3 [17:10:39][D][voice_assistant:653]: STT started [17:10:39][D][nabu_media_player.decoder:149][ann_decode]: skip decoding: buffer: 0, failed: 0, to-read: 32768 read: 0 avail: 0 [17:10:39][D][voice_assistant:639]: Event Type: 11 [17:10:39][D][voice_assistant:802]: Starting STT by VAD [17:10:39][D][light:036]: 'voice_assistant_leds' Setting: [17:10:39][D][light:051]: Brightness: 66% [17:10:39][D][light:109]: Effect: 'Listening For Command' [17:10:40][D][voice_assistant:639]: Event Type: 12 [17:10:40][D][voice_assistant:806]: STT by VAD end [17:10:40][D][voice_assistant:516]: State changed from STREAMING_MICROPHONE to STOP_MICROPHONE [17:10:40][D][voice_assistant:522]: Desired state set to AWAITING_RESPONSE [17:10:40][D][voice_assistant:516]: State changed from STOP_MICROPHONE to STOPPING_MICROPHONE [17:10:40][D][light:036]: 'voice_assistant_leds' Setting: [17:10:40][D][light:051]: Brightness: 66% [17:10:40][D][light:109]: Effect: 'Thinking' [17:10:40][D][voice_assistant:516]: State changed from STOPPING_MICROPHONE to AWAITING_RESPONSE [17:10:40][D][voice_assistant:516]: State changed from AWAITING_RESPONSE to AWAITING_RESPONSE [17:10:41][D][voice_assistant:639]: Event Type: 4 [17:10:41][D][voice_assistant:667]: Speech recognised as: " Tell me a joke." [17:10:41][D][voice_assistant:639]: Event Type: 5 [17:10:41][D][voice_assistant:672]: Intent started [17:10:41][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 1x, time = 100 ms [17:10:42][D][ltr_als_ps:185]: Reconfiguring sensitivity: gain = 2x, time = 100 ms [17:10:42][D][voice_assistant:639]: Event Type: 6 [17:10:42][D][voice_assistant:639]: Event Type: 7 [17:10:42][D][voice_assistant:695]: Response: "Here's one: [17:10:42] [17:10:42]What do you call a fake noodle? [17:10:42] [17:10:42]An impasta! [17:10:43] [17:10:43]I hope that made you smile!" [17:10:43][D][light:036]: 'voice_assistant_leds' Setting: [17:10:43][D][light:051]: Brightness: 66% [17:10:43][D][light:109]: Effect: 'Replying' [17:10:43][D][voice_assistant:639]: Event Type: 8 [17:10:43][D][voice_assistant:717]: Response URL: "https://mikejulie4us.duckdns.org:8123/api/tts_proxy/uuYkKg-KxlY3t8E7G_lTTw.flac" [17:10:43][D][voice_assistant:516]: State changed from AWAITING_RESPONSE to STREAMING_RESPONSE [17:10:43][D][voice_assistant:522]: Desired state set to STREAMING_RESPONSE [17:10:43][D][media_player:080]: 'Sat1 Media Player' - Setting [17:10:43][D][media_player:087]: Media URL: https://mikejulie4us.duckdns.org:8123/api/tts_proxy/uuYkKg-KxlY3t8E7G_lTTw.flac [17:10:43][D][media_player:093]: Announcement: yes [17:10:43][D][voice_assistant:639]: Event Type: 2 [17:10:43][D][voice_assistant:731]: Assist Pipeline ended [17:10:43] [17:10:43]***ERROR*** A stack overflow in task ann_read has been detected. [17:10:43] [17:10:43] [17:10:44]Backtrace: 0x403783e2:0x3fcbf320 0x40381ce5:0x3fcbf340 0x4038590a:0x3fcbf360 0x40383944:0x3fcbf3e0 0x40381d9c:0x3fcbf410 0x40381d92:0x00000000 |<-CORRUPTED [17:10:44] [17:10:44] [17:10:44] [17:10:44] [17:10:44]ELF file SHA256: 79423943e134e5c9 [17:10:44] [17:10:44]Rebooting... [17:10:44]ESP-ROM:esp32s3-20210327 [17:10:44]Build:Mar 27 2021 [17:10:44]rst:0xc (RTC_SW_CPU_RST),boot:0x2b (SPI_FAST_FLASH_BOOT) [17:10:44]Saved PC:0x40377ff0 [17:10:44]SPIWP:0xee [17:10:44]mode:DIO, clock div:1 [17:10:44]load:0x3fce3808,len:0x16c4 [17:10:44]load:0x403c9700,len:0xbc0 [17:10:44]load:0x403cc700,len:0x2e90 [17:10:44]entry 0x403c9950 [17:10:45]I (24) boot: ESP-IDF 4.4.8 2nd stage bootloader [17:10:45]I (24) boot: compile time 19:04:16 [17:10:45]I (24) boot: Multicore bootloader [17:10:45]I (26) boot: chip revision: v0.2 [17:10:45]I (30) boot.esp32s3: Boot SPI Speed : 80MHz [17:10:45]I (35) boot.esp32s3: SPI Mode : DIO [17:10:45]I (39) boot.esp32s3: SPI Flash Size : 16MB [17:10:45]I (44) boot: Enabling RNG early entropy source... [17:10:45]I (50) boot: Partition Table: [17:10:45]I (53) boot: ## Label Usage Type ST Offset Length [17:10:45]I (60) boot: 0 otadata OTA data 01 00 00009000 00002000 [17:10:45]I (68) boot: 1 phy_init RF data 01 01 0000b000 00001000 [17:10:45]I (75) boot: 2 app0 OTA app 00 10 00010000 007c0000 [17:10:45]I (83) boot: 3 app1 OTA app 00 11 007d0000 007c0000 [17:10:45]I (90) boot: 4 nvs WiFi data 01 02 00f90000 0006d000 [17:10:45]I (98) boot: End of partition table [17:10:45]I (102) esp_image: segment 0: paddr=00010020 vaddr=3c170020 size=1469b4h (1337780) map [17:10:46]I (350) esp_image: segment 1: paddr=001569dc vaddr=3fc9dc70 size=04974h ( 18804) load [17:10:46]I (355) esp_image: segment 2: paddr=0015b358 vaddr=40374000 size=04cc0h ( 19648) load [17:10:46]I (361) esp_image: segment 3: paddr=00160020 vaddr=42000020 size=16cf90h (1494928) map [17:10:46]I (633) esp_image: segment 4: paddr=002ccfb8 vaddr=40378cc0 size=14fa8h ( 85928) load [17:10:46]I (662) boot: Loaded app from partition at offset 0x10000 [17:10:46]I (662) boot: Disabling RNG early entropy source... [17:10:46]I (663) cpu_start: Multicore app [17:10:46]I (667) opi psram: vendor id : 0x0d (AP) [17:10:46]I (671) opi psram: dev id : 0x02 (generation 3) [17:10:46]I (676) opi psram: density : 0x03 (64 Mbit) [17:10:46]I (681) opi psram: good-die : 0x01 (Pass) [17:10:46]I (686) opi psram: Latency : 0x01 (Fixed) [17:10:46]I (691) opi psram: VCC : 0x01 (3V) [17:10:46]I (696) opi psram: SRF : 0x01 (Fast Refresh) [17:10:46]I (701) opi psram: BurstType : 0x01 (Hybrid Wrap) [17:10:46]I (707) opi psram: BurstLen : 0x01 (32 Byte) [17:10:46]I (712) opi psram: Readlatency : 0x02 (10 cycles@Fixed) [17:10:47]I (718) opi psram: DriveStrength: 0x00 (1/1) [17:10:47]I (723) MSPI Timing: PSRAM timing tuning index: 5 [17:10:47]I (728) spiram: Found 64MBit SPI RAM device [17:10:47]I (733) spiram: SPI RAM mode: sram 80m [17:10:47]I (737) spiram: PSRAM initialized, cache is in normal (1-core) mode. [17:10:47]I (744) cpu_start: Pro cpu up. [17:10:47]I (748) cpu_start: Starting app cpu, entry point is 0x403779a8 [17:10:47]I (737) cpu_start: App cpu up. [17:10:47]I (1181) spiram: SPI SRAM memory test OK [17:10:47]I (1189) cpu_start: Pro cpu start user code [17:10:47]I (1189) cpu_start: cpu freq: 160000000 [17:10:47]I (1190) cpu_start: Application information: [17:10:47]I (1190) cpu_start: Project name: satellite1 [17:10:47]I (1190) cpu_start: App version: 2024.11.2 [17:10:47]I (1190) cpu_start: Compile time: Dec 6 2024 18:59:28 [17:10:47]I (1190) cpu_start: ELF file SHA256: 79423943e134e5c9... [17:10:47]I (1191) cpu_start: ESP-IDF: 4.4.8 [17:10:48]I (1191) cpu_start: Min chip rev: v0.0 [17:10:48]I (1191) cpu_start: Max chip rev: v0.99 [17:10:48]I (1191) cpu_start: Chip rev: v0.2 [17:10:48]I (1192) heap_init: Initializing. RAM available for dynamic allocation: [17:10:48]I (1192) heap_init: At 3FCA91A0 len 00040570 (257 KiB): D/IRAM [17:10:48]I (1192) heap_init: At 3FCE9710 len 00005724 (21 KiB): STACK/DIRAM [17:10:48]I (1192) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM [17:10:48]I (1193) heap_init: At 600FE000 len 00002000 (8 KiB): RTCRAM [17:10:48]I (1193) spiram: Adding pool of 8192K of external SPI memory to heap allocator [17:10:48]I (1194) spi_flash: detected chip: gd [17:10:48]I (1194) spi_flash: flash io: dio [17:10:48]I (1197) sleep: Configure to isolate all GPIO pins in sleep state [17:10:48]I (1198) sleep: Enable automatic switching of GPIO sleep configuration [17:10:48]I (1198) coexist: coexist rom version e7ae62f [17:10:48]I (1199) cpu_start: Starting scheduler on PRO CPU. [17:10:48]I (0) cpu_start: Starting scheduler on APP CPU. [17:10:49][I][logger:171]: Log initialized [17:10:49][C][status_led:014]: Setting up Status LED... [17:10:49][D][esp-idf:000]: I (181) gpio: GPIO[45]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:10:49] [17:10:49][C][safe_mode:079]: There have been 2 suspected unsuccessful boot attempts [17:10:49][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:10:49][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:10:49][I][app:029]: Running through setup()... [17:10:49][C][i2c.idf:017]: Setting up I2C bus... [17:10:49][I][i2c.idf:252]: Performing I2C bus recovery [17:10:49][D][esp-idf:000]: I (1629) gpio: GPIO[6]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:10:49] [17:10:49][D][esp-idf:000]: I (1630) gpio: GPIO[5]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:10:49] [17:10:49][D][spi:035]: Setting up SPI bus... [17:10:49][D][spi_device:362]: mode 3, data_rate 8000kHz [17:10:49][D][esp-idf:000]: I (1648) gpio: GPIO[10]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:10:50] [17:10:50][D][esp-idf:000]: I (1650) gpio: GPIO[4]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:10:50] [17:10:50][I][Satellite1:172]: XMOS Firmware Version: 6.0.7 [17:10:50][D][number:012]: 'Offset Temperature': Sending state 0.000000 [17:10:50][D][number:012]: 'Offset Humidity': Sending state 0.000000 [17:10:50][D][fusb302b:360]: reported device id: 145 [17:10:50][D][fusb302b:133]: FUSB302 found, initializing... [17:10:50][C][esp32_rmt_led_strip:021]: Setting up ESP32 LED Strip... [17:10:50][D][binary_sensor:034]: 'Button Left (HW Mute)': Sending initial state OFF [17:10:50][D][binary_sensor:034]: 'Button Up (Vol+)': Sending initial state OFF [17:10:50][D][binary_sensor:034]: 'Button Down (Vol-)': Sending initial state OFF [17:10:50][D][esp-idf:000]: I (1867) gpio: GPIO[0]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0 [17:10:50] [17:10:50][D][binary_sensor:034]: 'Button Right (Action)': Sending initial state OFF [17:10:50][C][light:021]: Setting up light 'hw_led_ring'... [17:10:50][D][light:036]: 'hw_led_ring' Setting: [17:10:51][D][light:041]: Color mode: RGB [17:10:51][D][light:085]: Transition length: 1.0s [17:10:51][C][light:021]: Setting up light 'LED Ring'... [17:10:51][D][light:036]: 'LED Ring' Setting: [17:10:51][D][light:041]: Color mode: RGB [17:10:51][D][light:051]: Brightness: 66% [17:10:51][D][light:055]: Color brightness: 100% [17:10:51][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:10:51][C][light:021]: Setting up light 'voice_assistant_leds'... [17:10:51][D][light:036]: 'voice_assistant_leds' Setting: [17:10:51][D][light:041]: Color mode: RGB [17:10:51][D][template.switch:046]: Restored state ON [17:10:51][D][switch:012]: 'Wake sound' Turning ON. [17:10:51][D][switch:055]: 'Wake sound': Sending state ON [17:10:51][D][template.switch:046]: Restored state OFF [17:10:51][D][switch:016]: 'Mute Microphones' Turning OFF. [17:10:52][D][switch:055]: 'Mute Microphones': Sending state OFF [17:10:52][D][light:036]: 'voice_assistant_leds' Setting: [17:10:52][D][light:047]: State: ON [17:10:52][D][light:051]: Brightness: 66% [17:10:52][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:10:52][D][template.switch:046]: Restored state OFF [17:10:52][D][switch:016]: 'timer_ringing' Turning OFF. [17:10:52][D][switch:055]: 'timer_ringing': Sending state OFF [17:10:52][D][light:036]: 'voice_assistant_leds' Setting: [17:10:52][D][light:051]: Brightness: 66% [17:10:52][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:10:52][D][template.switch:046]: Restored state OFF [17:10:52][D][switch:016]: 'Beta firmware' Turning OFF. [17:10:52][D][switch:055]: 'Beta firmware': Sending state OFF [17:10:52][D][main:103]: OTA updates set to use Production firmware [17:10:53][C][i2s_audio:024]: Setting up I2S Audio... [17:10:53][C][aht10:046]: Setting up AHT20 [17:10:53][C][ltr_als_ps:066]: Setting up LTR-303/329/55x/659 [17:10:53][D][pcm5122:021]: PCM5122 chip found. [17:10:53][D][tas2780:041]: TAS2780 chip found. [17:10:53][D][tas2780:042]: Reg 0x68: 127. [17:10:53][D][tas2780:043]: Reg 0x02: 26. [17:10:53][C][i2s_audio.microphone:075]: Setting up I2S Audio Microphone... [17:10:53][D][ring_buffer:034]: Created ring buffer with size 6144 [17:10:53][D][ring_buffer:034]: Created ring buffer with size 6144 [17:10:53][D][main:779]: FutureProofHomes Satellite1 Core version v1.0.0-beta.1 running ESP firmware: v0.0.4 and XMOS firmware: v1.0.1-alpha.33 [17:10:53][D][light:036]: 'voice_assistant_leds' Setting: [17:10:53][D][light:051]: Brightness: 66% [17:10:53][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:10:53][C][esp32_ble:032]: Setting up BLE... [17:10:53][C][wifi:048]: Setting up WiFi... [17:10:54][D][esp-idf:000]: I (1987) pp: pp rom version: e7ae62f [17:10:54] [17:10:54][D][esp-idf:000]: I (1988) net80211: net80211 rom version: e7ae62f [17:10:54] [17:10:54][D][esp-idf:000]: I (1990) wifi: [17:10:54][D][esp-idf:000]: wifi driver task: 3fcb5a10, prio:23, stack:6656, core=0 [17:10:54][D][esp-idf:000]: [17:10:54] [17:10:54][D][esp-idf:000][wifi]: I (1992) system_api: Base MAC address is not set [17:10:54] [17:10:54][D][esp-idf:000][wifi]: I (1993) system_api: read default base MAC address from EFUSE [17:10:54] [17:10:54][D][esp-idf:000][wifi]: I (1996) wifi: [17:10:54][D][esp-idf:000][wifi]: wifi firmware version: ff661c3 [17:10:54][D][esp-idf:000][wifi]: [17:10:55] [17:10:55][D][esp-idf:000][wifi]: I (1998) wifi: [17:10:55][D][esp-idf:000][wifi]: wifi certification version: v7.0 [17:10:55][D][esp-idf:000][wifi]: [17:10:55] [17:10:55][D][esp-idf:000][wifi]: I (2000) wifi: [17:10:55][D][esp-idf:000][wifi]: config NVS flash: enabled [17:10:55][D][esp-idf:000][wifi]: [17:10:55] [17:10:55][D][esp-idf:000][wifi]: I (2002) wifi: [17:10:55][D][esp-idf:000][wifi]: config nano formating: disabled [17:10:55][D][esp-idf:000][wifi]: [17:10:55] [17:10:55][D][esp-idf:000][wifi]: I (2004) wifi: [17:10:55][D][esp-idf:000][wifi]: Init data frame dynamic rx buffer num: 32 [17:10:56][D][esp-idf:000][wifi]: [17:10:56] [17:10:56][D][esp-idf:000][wifi]: I (2006) wifi: [17:10:56][D][esp-idf:000][wifi]: Init static rx mgmt buffer num: 5 [17:10:56][D][esp-idf:000][wifi]: [17:10:56] [17:10:56][D][esp-idf:000][wifi]: I (2008) wifi: [17:10:56][D][esp-idf:000][wifi]: Init management short buffer num: 32 [17:10:56][D][esp-idf:000][wifi]: [17:10:56] [17:10:56][D][esp-idf:000][wifi]: I (2010) wifi: [17:10:56][D][esp-idf:000][wifi]: Init dynamic tx buffer num: 32 [17:10:56][D][esp-idf:000][wifi]: [17:10:56] [17:10:56][D][esp-idf:000][wifi]: I (2013) wifi: [17:10:56][D][esp-idf:000][wifi]: Init tx cache buffer num: 32 [17:10:57][D][esp-idf:000][wifi]: [17:10:57] [17:10:57][D][esp-idf:000][wifi]: I (2015) wifi: [17:10:57][D][esp-idf:000][wifi]: Init static tx FG buffer num: 2 [17:10:57][D][esp-idf:000][wifi]: [17:10:57] [17:10:57][D][esp-idf:000][wifi]: I (2017) wifi: [17:10:57][D][esp-idf:000][wifi]: Init static rx buffer size: 1600 [17:10:57][D][esp-idf:000][wifi]: [17:10:57] [17:10:57][D][esp-idf:000][wifi]: I (2019) wifi: [17:10:57][D][esp-idf:000][wifi]: Init static rx buffer num: 16 [17:10:57][D][esp-idf:000][wifi]: [17:10:57] [17:10:57][D][esp-idf:000][wifi]: I (2021) wifi: [17:10:58][D][esp-idf:000][wifi]: Init dynamic rx buffer num: 32 [17:10:58][D][esp-idf:000][wifi]: [17:10:58] [17:10:58][D][esp-idf:000]: I (2023) wifi_init: rx ba win: 16 [17:10:58] [17:10:58][D][esp-idf:000]: I (2024) wifi_init: tcpip mbox: 32 [17:10:58] [17:10:58][D][esp-idf:000]: I (2025) wifi_init: udp mbox: 6 [17:10:58] [17:10:58][D][esp-idf:000]: I (2026) wifi_init: tcp mbox: 6 [17:10:58] [17:10:58][D][esp-idf:000]: I (2027) wifi_init: tcp tx win: 5760 [17:10:58] [17:10:58][D][esp-idf:000]: I (2027) wifi_init: tcp rx win: 5760 [17:10:58] [17:10:58][D][esp-idf:000]: I (2028) wifi_init: tcp mss: 1440 [17:10:59] [17:10:59][D][esp-idf:000]: I (2029) wifi_init: WiFi/LWIP prefer SPIRAM [17:10:59] [17:10:59][D][esp-idf:000]: I (2030) wifi_init: WiFi IRAM OP enabled [17:10:59] [17:10:59][D][esp-idf:000]: I (2031) wifi_init: WiFi RX IRAM O[D][esp-idf:000][wifi]: I (2122) wifi: [17:10:59][D][esp-idf:000][wifi]: mode : sta (d8:3b:da:40:78:70) [17:10:59][D][esp-idf:000][wifi]: [17:10:59] [17:10:59][D][esp-idf:000][wifi]: I (2124) wifi: [17:10:59][D][esp-idf:000][wifi]: enable tsf [17:10:59][D][esp-idf:000][wifi]: [17:10:59] [17:10:59][D][esp-idf:000][wifi]: I (2127) wifi: [17:11:00][D][esp-idf:000][wifi]: Set ps type: 1 [17:11:00] [17:11:00][D][esp-idf:000][wifi]: [17:11:00] [17:11:00][D][wifi:482]: Starting scan... [17:11:00][D][esp32.preferences:114]: Saving 4 preferences to flash... [17:11:00][D][esp32.preferences:143]: Saving 4 preferences to flash: 4 cached, 0 written, 0 failed [17:11:00][D][aht10:115]: ATH10 Unrealistic humidity (0x0), retrying... [17:11:00][D][esp-idf:000][wifi]: I (2140) wifi: [17:11:00][D][esp-idf:000][wifi]: Set ps type: 1 [17:11:00] [17:11:00][D][esp-idf:000][wifi]: [17:11:00] [17:11:00][W][component:157]: Component wifi set Warning flag: scanning for networks [17:11:01][I][Satellite1:172]: XMOS Firmware Version: 0.0.7 [17:11:01][D][esp32_ble:284]: Enabling BLE... [17:11:01][D][esp-idf:000]: I (2165) BLE_INIT: BT controller compile version [ba3b3e3] [17:11:01] [17:11:01][D][esp-idf:000][btController]: I (2167) BLE_INIT: Bluetooth MAC: d8:3b:da:40:78:72 [17:11:01] [17:11:01] [17:11:01][D][aht10:097]: Read attempt 2 at 736ms [17:11:01][D][aht10:124]: Success at 737ms [17:11:01][D][sensor:094]: 'Temperature': Sending state 32.85281 °C with 2 decimals of accuracy [17:11:01][D][sensor:094]: 'Humidity': Sending state 40.03561 % with 2 decimals of accuracy [17:11:01][D][esp32_ble_server:077]: BLE server setup successfully [17:11:01][D][esp32_improv.component:082]: Creating Improv service [17:11:01][D][light:036]: 'voice_assistant_leds' Setting: [17:11:01][D][light:051]: Brightness: 66% [17:11:01][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:11:02][D][text_sensor:064]: 'XMOS Firmware': Sending state 'v0.0.7' [17:11:02][D][wifi:497]: Found networks: [17:11:02][I][wifi:541]: - 'HomeNet' (1E:E8:29:91:CA:92) [redacted]▂▄▆█ [17:11:02][D][wifi:542]: Channel: 11 [17:11:02][D][wifi:543]: RSSI: -57 dB [17:11:02][I][wifi:541]: - 'HomeNet' (0A:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:11:02][D][wifi:542]: Channel: 6 [17:11:02][D][wifi:543]: RSSI: -83 dB [17:11:02][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:92) [redacted]▂▄▆█ [17:11:02][D][wifi:546]: - ''[redacted] (88:DE:A9:35:1B:7F) [redacted]▂▄▆█ [17:11:02][D][wifi:546]: - 'IotWifi'[redacted] (04:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:11:02][D][wifi:546]: - ''[redacted] (BE:D7:D4:34:FA:3F) [redacted]▂▄▆█ [17:11:02][D][wifi:546]: - ''[redacted] (AC:3A:7A:37:BA:E1) [redacted]▂▄▆█ [17:11:02][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:1F) [redacted]▂▄▆█ [17:11:03][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:11:03][D][esp-idf:000][wifi]: I (10623) wifi: [17:11:03][D][esp-idf:000][wifi]: new:<11,0>, old:<1,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:11:03][D][esp-idf:000][wifi]: [17:11:03] [17:11:03][D][esp-idf:000][wifi]: I (10627) wifi: [17:11:03][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:11:03][D][esp-idf:000][wifi]: [17:11:03] [17:11:03][D][esp-idf:000][wifi]: I (11608) wifi: [17:11:03][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:11:03][D][esp-idf:000][wifi]: [17:11:03] [17:11:04][D][esp-idf:000][wifi]: E (11618) wifi: [17:11:04][D][esp-idf:000][wifi]: Set status to INIT [17:11:04][D][esp-idf:000][wifi]: [17:11:04] [17:11:04][D][esp-idf:000][wifi]: I (11620) wifi: [17:11:04][D][esp-idf:000][wifi]: state: assoc -> init (1e10) [17:11:04][D][esp-idf:000][wifi]: [17:11:04] [17:11:04][D][esp-idf:000][wifi]: I (11622) wifi: [17:11:04][D][esp-idf:000][wifi]: Coexist: Wi-Fi connect fail, apply reconnect coex policy [17:11:04] [17:11:04][D][esp-idf:000][wifi]: [17:11:04] [17:11:04][D][esp-idf:000][wifi]: I (11625) wifi: [17:11:05][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:11:05][D][esp-idf:000][wifi]: [17:11:05] [17:11:05][W][wifi_esp32:712]: Event: Disconnected ssid='HomeNet' bssid=1E:E8:29:91:CA:92[redacted] reason='Association Failed' [17:11:05][W][wifi:653]: Error while connecting to network. [17:11:05][D][wifi:697]: Retrying with hidden networks... [17:11:05][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:11:05][D][esp-idf:000][wifi]: I (11692) wifi: [17:11:05][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:11:05][D][esp-idf:000][wifi]: [17:11:05] [17:11:05][D][esp-idf:000][wifi]: I (11695) wifi: [17:11:05][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:11:05][D][esp-idf:000][wifi]: [17:11:06] [17:11:06][D][esp-idf:000][wifi]: I (12684) wifi: [17:11:06][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:11:06][D][esp-idf:000][wifi]: [17:11:06] [17:11:06][D][esp-idf:000][wifi]: I (12690) wifi: [17:11:06][D][esp-idf:000][wifi]: state: assoc -> init (9c0) [17:11:06][D][esp-idf:000][wifi]: [17:11:06] [17:11:06][D][esp-idf:000][wifi]: I (12692) wifi: [17:11:06][D][esp-idf:000][wifi]: Coexist: Wi-Fi connect fail, apply reconnect coex policy [17:11:06] [17:11:06][D][esp-idf:000][wifi]: [17:11:06] [17:11:06][D][esp-idf:000][wifi]: I (12695) wifi: [17:11:07][D][esp-idf:000][wifi]: new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:11:07][D][esp-idf:000][wifi]: [17:11:07] [17:11:07][W][wifi_esp32:712]: Event: Disconnected ssid='HomeNet' bssid=1E:E8:29:91:CA:92[redacted] reason='Association Failed' [17:11:07][W][wifi:653]: Error while connecting to network. [17:11:07][D][wifi:697]: Retrying with hidden networks... [17:11:07][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:11:07]ESP-ROM:esp32s3-20210327 [17:11:08]Build:Mar 27 2021 [17:11:08]rst:0x15 (USB_UART_CHIP_RESET),boot:0x2b (SPI_FAST_FLASH_BOOT) [17:11:08]Saved PC:0x4216aaae [17:11:08]SPIWP:0xee [17:11:08]mode:DIO, clock div:1 [17:11:08]load:0x3fce3808,len:0x16c4 [17:11:08]load:0x403c9700,len:0xbc0 [17:11:08]load:0x403cc700,len:0x2e90 [17:11:08]entry 0x403c9950 [17:11:08]I (24) boot: ESP-IDF 4.4.8 2nd stage bootloader [17:11:08]I (24) boot: compile time 19:04:16 [17:11:08]I (25) boot: Multicore bootloader [17:11:08]I (26) boot: chip revision: v0.2 [17:11:08]I (30) boot.esp32s3: Boot SPI Speed : 80MHz [17:11:08]I (35) boot.esp32s3: SPI Mode : DIO [17:11:09]I (40) boot.esp32s3: SPI Flash Size : 16MB [17:11:09]I (45) boot: Enabling RNG early entropy source... [17:11:09]I (50) boot: Partition Table: [17:11:09]I (54) boot: ## Label Usage Type ST Offset Length [17:11:09]I (61) boot: 0 otadata OTA data 01 00 00009000 00002000 [17:11:09]I (68) boot: 1 phy_init RF data 01 01 0000b000 00001000 [17:11:09]I (76) boot: 2 app0 OTA app 00 10 00010000 007c0000 [17:11:09]I (83) boot: 3 app1 OTA app 00 11 007d0000 007c0000 [17:11:09]I (91) boot: 4 nvs WiFi data 01 02 00f90000 0006d000 [17:11:09]I (98) boot: End of partition table [17:11:09]I (102) esp_image: segment 0: paddr=00010020 vaddr=3c170020 size=1469b4h (1337780) map [17:11:09]I (351) esp_image: segment 1: paddr=001569dc vaddr=3fc9dc70 size=04974h ( 18804) load [17:11:09]I (355) esp_image: segment 2: paddr=0015b358 vaddr=40374000 size=04cc0h ( 19648) load [17:11:09]I (361) esp_image: segment 3: paddr=00160020 vaddr=42000020 size=16cf90h (1494928) map [17:11:09]I (633) esp_image: segment 4: paddr=002ccfb8 vaddr=40378cc0 size=14fa8h ( 85928) load [17:11:10]I (663) boot: Loaded app from partition at offset 0x10000 [17:11:10]I (663) boot: Disabling RNG early entropy source... [17:11:10]I (663) cpu_start: Multicore app [17:11:10]I (667) opi psram: vendor id : 0x0d (AP) [17:11:10]I (671) opi psram: dev id : 0x02 (generation 3) [17:11:10]I (677) opi psram: density : 0x03 (64 Mbit) [17:11:10]I (682) opi psram: good-die : 0x01 (Pass) [17:11:10]I (687) opi psram: Latency : 0x01 (Fixed) [17:11:10]I (692) opi psram: VCC : 0x01 (3V) [17:11:10]I (696) opi psram: SRF : 0x01 (Fast Refresh) [17:11:10]I (702) opi psram: BurstType : 0x01 (Hybrid Wrap) [17:11:10]I (707) opi psram: BurstLen : 0x01 (32 Byte) [17:11:10]I (712) opi psram: Readlatency : 0x02 (10 cycles@Fixed) [17:11:10]I (718) opi psram: DriveStrength: 0x00 (1/1) [17:11:10]I (724) MSPI Timing: PSRAM timing tuning index: 5 [17:11:10]I (728) spiram: Found 64MBit SPI RAM device [17:11:11]I (733) spiram: SPI RAM mode: sram 80m [17:11:11]I (738) spiram: PSRAM initialized, cache is in normal (1-core) mode. [17:11:11]I (745) cpu_start: Pro cpu up. [17:11:11]I (748) cpu_start: Starting app cpu, entry point is 0x403779a8 [17:11:11]I (0) cpu_start: App cpu up. [17:11:11]I (1181) spiram: SPI SRAM memory test OK [17:11:11]I (1190) cpu_start: Pro cpu start user code [17:11:11]I (1190) cpu_start: cpu freq: 160000000 [17:11:11]I (1190) cpu_start: Application information: [17:11:11]I (1190) cpu_start: Project name: satellite1 [17:11:11]I (1190) cpu_start: App version: 2024.11.2 [17:11:11]I (1191) cpu_start: Compile time: Dec 6 2024 18:59:28 [17:11:11]I (1191) cpu_start: ELF file SHA256: 79423943e134e5c9... [17:11:11]I (1191) cpu_start: ESP-IDF: 4.4.8 [17:11:11]I (1191) cpu_start: Min chip rev: v0.0 [17:11:12]I (1192) cpu_start: Max chip rev: v0.99 [17:11:12]I (1192) cpu_start: Chip rev: v0.2 [17:11:12]I (1192) heap_init: Initializing. RAM available for dynamic allocation: [17:11:12]I (1193) heap_init: At 3FCA91A0 len 00040570 (257 KiB): D/IRAM [17:11:12]I (1193) heap_init: At 3FCE9710 len 00005724 (21 KiB): STACK/DIRAM [17:11:12]I (1193) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM [17:11:12]I (1193) heap_init: At 600FE000 len 00002000 (8 KiB): RTCRAM [17:11:12]I (1194) spiram: Adding pool of 8192K of external SPI memory to heap allocator [17:11:12]I (1195) spi_flash: detected chip: gd [17:11:12]I (1195) spi_flash: flash io: dio [17:11:12]I (1198) sleep: Configure to isolate all GPIO pins in sleep state [17:11:12]I (1198) sleep: Enable automatic switching of GPIO sleep configuration [17:11:12]I (1199) coexist: coexist rom version e7ae62f [17:11:12]I (1200) cpu_start: Starting scheduler on PRO CPU. [17:11:12]I (0) cpu_start: Starting scheduler on APP CPU. [17:11:13][I][logger:171]: Log initialized [17:11:13][C][status_led:014]: Setting up Status LED... [17:11:13][D][esp-idf:000]: I (181) gpio: GPIO[45]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:11:13] [17:11:13][C][safe_mode:079]: There have been 3 suspected unsuccessful boot attempts [17:11:13][D][esp32.preferences:114]: Saving 1 preferences to flash... [17:11:13][D][esp32.preferences:143]: Saving 1 preferences to flash: 0 cached, 1 written, 0 failed [17:11:13][I][app:029]: Running through setup()... [17:11:13][C][i2c.idf:017]: Setting up I2C bus... [17:11:13][I][i2c.idf:252]: Performing I2C bus recovery [17:11:13][D][esp-idf:000]: I (1630) gpio: GPIO[6]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:11:13] [17:11:13][D][esp-idf:000]: I (1631) gpio: GPIO[5]| InputEn: 1| OutputEn: 1| OpenDrain: 1| Pullup: 1| Pulldown: 0| Intr:0 [17:11:13] [17:11:13][D][spi:035]: Setting up SPI bus... [17:11:14][D][spi_device:362]: mode 3, data_rate 8000kHz [17:11:14][D][esp-idf:000]: I (1649) gpio: GPIO[10]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:11:14] [17:11:14][D][esp-idf:000]: I (1651) gpio: GPIO[4]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 [17:11:14] [17:11:14][I][Satellite1:172]: XMOS Firmware Version: 6.0.7 [17:11:14][D][number:012]: 'Offset Temperature': Sending state 0.000000 [17:11:14][D][number:012]: 'Offset Humidity': Sending state 0.000000 [17:11:14][D][fusb302b:360]: reported device id: 145 [17:11:14][D][fusb302b:133]: FUSB302 found, initializing... [17:11:14][C][esp32_rmt_led_strip:021]: Setting up ESP32 LED Strip... [17:11:14][D][binary_sensor:034]: 'Button Left (HW Mute)': Sending initial state OFF [17:11:14][D][binary_sensor:034]: 'Button Up (Vol+)': Sending initial state OFF [17:11:14][D][binary_sensor:034]: 'Button Down (Vol-)': Sending initial state OFF [17:11:15][D][esp-idf:000]: I (1868) gpio: GPIO[0]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0 [17:11:15] [17:11:15][D][binary_sensor:034]: 'Button Right (Action)': Sending initial state OFF [17:11:15][C][light:021]: Setting up light 'hw_led_ring'... [17:11:15][D][light:036]: 'hw_led_ring' Setting: [17:11:15][D][light:041]: Color mode: RGB [17:11:15][D][light:085]: Transition length: 1.0s [17:11:15][C][light:021]: Setting up light 'LED Ring'... [17:11:15][D][light:036]: 'LED Ring' Setting: [17:11:15][D][light:041]: Color mode: RGB [17:11:15][D][light:051]: Brightness: 66% [17:11:15][D][light:055]: Color brightness: 100% [17:11:15][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:11:15][C][light:021]: Setting up light 'voice_assistant_leds'... [17:11:16][D][light:036]: 'voice_assistant_leds' Setting: [17:11:16][D][light:041]: Color mode: RGB [17:11:16][D][template.switch:046]: Restored state ON [17:11:16][D][switch:012]: 'Wake sound' Turning ON. [17:11:16][D][switch:055]: 'Wake sound': Sending state ON [17:11:16][D][template.switch:046]: Restored state OFF [17:11:16][D][switch:016]: 'Mute Microphones' Turning OFF. [17:11:16][D][switch:055]: 'Mute Microphones': Sending state OFF [17:11:16][D][light:036]: 'voice_assistant_leds' Setting: [17:11:16][D][light:047]: State: ON [17:11:16][D][light:051]: Brightness: 66% [17:11:16][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:11:16][D][template.switch:046]: Restored state OFF [17:11:16][D][switch:016]: 'timer_ringing' Turning OFF. [17:11:16][D][switch:055]: 'timer_ringing': Sending state OFF [17:11:17][D][light:036]: 'voice_assistant_leds' Setting: [17:11:17][D][light:051]: Brightness: 66% [17:11:17][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:11:17][D][template.switch:046]: Restored state OFF [17:11:17][D][switch:016]: 'Beta firmware' Turning OFF. [17:11:17][D][switch:055]: 'Beta firmware': Sending state OFF [17:11:17][D][main:103]: OTA updates set to use Production firmware [17:11:17][C][i2s_audio:024]: Setting up I2S Audio... [17:11:17][C][aht10:046]: Setting up AHT20 [17:11:17][C][ltr_als_ps:066]: Setting up LTR-303/329/55x/659 [17:11:17][D][pcm5122:021]: PCM5122 chip found. [17:11:17][D][tas2780:041]: TAS2780 chip found. [17:11:17][D][tas2780:042]: Reg 0x68: 127. [17:11:17][D][tas2780:043]: Reg 0x02: 26. [17:11:18][C][i2s_audio.microphone:075]: Setting up I2S Audio Microphone... [17:11:18][D][ring_buffer:034]: Created ring buffer with size 6144 [17:11:18][D][ring_buffer:034]: Created ring buffer with size 6144 [17:11:18][D][main:779]: FutureProofHomes Satellite1 Core version v1.0.0-beta.1 running ESP firmware: v0.0.4 and XMOS firmware: v1.0.1-alpha.33 [17:11:18][D][light:036]: 'voice_assistant_leds' Setting: [17:11:18][D][light:051]: Brightness: 66% [17:11:18][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:11:18][C][esp32_ble:032]: Setting up BLE... [17:11:18][C][wifi:048]: Setting up WiFi... [17:11:18][D][esp-idf:000]: I (1988) pp: pp rom version: e7ae62f [17:11:18] [17:11:18][D][esp-idf:000]: I (1989) net80211: net80211 rom version: e7ae62f [17:11:18] [17:11:18][D][esp-idf:000]: I (1991) wifi: [17:11:19][D][esp-idf:000]: wifi driver task: 3fcb5a10, prio:23, stack:6656, core=0 [17:11:19][D][esp-idf:000]: [17:11:19] [17:11:19][D][esp-idf:000][wifi]: I (1993) system_api: Base MAC address is not set [17:11:19] [17:11:19][D][esp-idf:000][wifi]: I (1994) system_api: read default base MAC address from EFUSE [17:11:19] [17:11:19][D][esp-idf:000][wifi]: I (1997) wifi: [17:11:19][D][esp-idf:000][wifi]: wifi firmware version: ff661c3 [17:11:19][D][esp-idf:000][wifi]: [17:11:19] [17:11:19][D][esp-idf:000][wifi]: I (1999) wifi: [17:11:19][D][esp-idf:000][wifi]: wifi certification version: v7.0 [17:11:19][D][esp-idf:000][wifi]: [17:11:19] [17:11:20][D][esp-idf:000][wifi]: I (2001) wifi: [17:11:20][D][esp-idf:000][wifi]: config NVS flash: enabled [17:11:20][D][esp-idf:000][wifi]: [17:11:20] [17:11:20][D][esp-idf:000][wifi]: I (2003) wifi: [17:11:20][D][esp-idf:000][wifi]: config nano formating: disabled [17:11:20][D][esp-idf:000][wifi]: [17:11:20] [17:11:20][D][esp-idf:000][wifi]: I (2005) wifi: [17:11:20][D][esp-idf:000][wifi]: Init data frame dynamic rx buffer num: 32 [17:11:20][D][esp-idf:000][wifi]: [17:11:20] [17:11:20][D][esp-idf:000][wifi]: I (2007) wifi: [17:11:20][D][esp-idf:000][wifi]: Init static rx mgmt buffer num: 5 [17:11:21][D][esp-idf:000][wifi]: [17:11:21] [17:11:21][D][esp-idf:000][wifi]: I (2009) wifi: [17:11:21][D][esp-idf:000][wifi]: Init management short buffer num: 32 [17:11:21][D][esp-idf:000][wifi]: [17:11:21] [17:11:21][D][esp-idf:000][wifi]: I (2011) wifi: [17:11:21][D][esp-idf:000][wifi]: Init dynamic tx buffer num: 32 [17:11:21][D][esp-idf:000][wifi]: [17:11:21] [17:11:21][D][esp-idf:000][wifi]: I (2014) wifi: [17:11:21][D][esp-idf:000][wifi]: Init tx cache buffer num: 32 [17:11:21][D][esp-idf:000][wifi]: [17:11:21] [17:11:22][D][esp-idf:000][wifi]: I (2016) wifi: [17:11:22][D][esp-idf:000][wifi]: Init static tx FG buffer num: 2 [17:11:22][D][esp-idf:000][wifi]: [17:11:22] [17:11:22][D][esp-idf:000][wifi]: I (2018) wifi: [17:11:22][D][esp-idf:000][wifi]: Init static rx buffer size: 1600 [17:11:22][D][esp-idf:000][wifi]: [17:11:22] [17:11:22][D][esp-idf:000][wifi]: I (2020) wifi: [17:11:22][D][esp-idf:000][wifi]: Init static rx buffer num: 16 [17:11:22][D][esp-idf:000][wifi]: [17:11:22] [17:11:22][D][esp-idf:000][wifi]: I (2022) wifi: [17:11:22][D][esp-idf:000][wifi]: Init dynamic rx buffer num: 32 [17:11:23][D][esp-idf:000][wifi]: [17:11:23] [17:11:23][D][esp-idf:000]: I (2024) wifi_init: rx ba win: 16 [17:11:23] [17:11:23][D][esp-idf:000]: I (2025) wifi_init: tcpip mbox: 32 [17:11:23] [17:11:23][D][esp-idf:000]: I (2026) wifi_init: udp mbox: 6 [17:11:23] [17:11:23][D][esp-idf:000]: I (2027) wifi_init: tcp mbox: 6 [17:11:23] [17:11:23][D][esp-idf:000]: I (2028) wifi_init: tcp tx win: 5760 [17:11:23] [17:11:23][D][esp-idf:000]: I (2028) wifi_init: tcp rx win: 5760 [17:11:23] [17:11:24][D][esp-idf:000]: I (2029) wifi_init: tcp mss: 1440 [17:11:24] [17:11:24][D][esp-idf:000]: I (2030) wifi_init: WiFi/LWIP prefer SPIRAM [17:11:24] [17:11:24][D][esp-idf:000]: I (2031) wifi_init: WiFi IRAM OP enabled [17:11:24] [17:11:24][D][esp-idf:000]: I (2032) wifi_init: WiFi RX IRAM OP enabled [17:11:24] [17:11:24][C][wifi:061]: Starting WiFi... [17:11:24][C][wifi:062]: Local MAC: D8:3B:DA:40:78:70 [17:11:24][D][wifi:074]: Loaded saved wifi settings: HomeNet [17:11:24][D][esp-idf:000][wifi]: I (2037) phy_init: phy_version 670,b7bc9b9,Apr 30 2024,10:54:13 [17:11:24] [17:11:24][D][esp-idf:000][wifi]: I (2077) wifi: [17:11:25][D][esp-idf:000][wifi]: mode : sta (d8:3b:da:40:78:70) [17:11:25][D][esp-idf:000][wifi]: [17:11:25] [17:11:25][D][esp-idf:000][wifi]: I (2080) wifi: [17:11:25][D][esp-idf:000][wifi]: enable tsf [17:11:25][D][esp-idf:000][wifi]: [17:11:25] [17:11:25][D][esp-idf:000][wifi]: I (2083) wifi: [17:11:25][D][esp-idf:000][wifi]: Set ps type: 1 [17:11:25] [17:11:25][D][esp-idf:000][wifi]: [17:11:25] [17:11:25][D][wifi:482]: Starting scan... [17:11:26][D][esp32.preferences:114]: Saving 4 preferences to flash... [17:11:26][D][esp32.preferences:143]: Saving 4 preferences to flash: 4 cached, 0 written, 0 failed [17:11:26][D][aht10:115]: ATH10 Unrealistic humidity (0x0), retrying... [17:11:26][D][esp-idf:000][wifi]: I (2097) wifi: [17:11:26][D][esp-idf:000][wifi]: Set ps type: 1 [17:11:26] [17:11:26][D][esp-idf:000][wifi]: [17:11:26] [17:11:26][W][component:157]: Component wifi set Warning flag: scanning for networks [17:11:26][I][Satellite1:172]: XMOS Firmware Version: 0.0.7 [17:11:26][D][esp32_ble:284]: Enabling BLE... [17:11:26][D][esp-idf:000]: I (2121) BLE_INIT: BT controller compile version [ba3b3e3] [17:11:26] [17:11:26][D][esp-idf:000][btController]: I (2123) BLE_INIT: Bluetooth MAC: d8:3b:da:40:78:72 [17:11:27] [17:11:27] [17:11:27][D][aht10:097]: Read attempt 2 at 691ms [17:11:27][D][aht10:124]: Success at 692ms [17:11:27][D][sensor:094]: 'Temperature': Sending state 33.54232 °C with 2 decimals of accuracy [17:11:27][D][sensor:094]: 'Humidity': Sending state 39.60798 % with 2 decimals of accuracy [17:11:27][D][esp32_ble_server:077]: BLE server setup successfully [17:11:27][D][esp32_improv.component:082]: Creating Improv service [17:11:27][D][light:036]: 'voice_assistant_leds' Setting: [17:11:27][D][light:051]: Brightness: 66% [17:11:27][D][light:059]: Red: 100%, Green: 89%, Blue: 71% [17:11:27][D][text_sensor:064]: 'XMOS Firmware': Sending state 'v0.0.7' [17:11:27][D][wifi:497]: Found networks: [17:11:27][I][wifi:541]: - 'HomeNet' (1E:E8:29:91:CA:92) [redacted]▂▄▆█ [17:11:28][D][wifi:542]: Channel: 11 [17:11:28][D][wifi:543]: RSSI: -56 dB [17:11:28][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:92) [redacted]▂▄▆█ [17:11:28][D][wifi:546]: - ''[redacted] (88:DE:A9:35:1B:7F) [redacted]▂▄▆█ [17:11:28][D][wifi:546]: - 'IotWifi'[redacted] (04:18:D6:E1:CE:27) [redacted]▂▄▆█ [17:11:28][D][wifi:546]: - ''[redacted] (AC:3A:7A:37:BA:E1) [redacted]▂▄▆█ [17:11:28][D][wifi:546]: - ''[redacted] (BE:D7:D4:34:FA:3F) [redacted]▂▄▆█ [17:11:28][D][wifi:546]: - ''[redacted] (22:EF:BD:FC:27:B0) [redacted]▂▄▆█ [17:11:28][D][wifi:546]: - 'IotWifi'[redacted] (18:E8:29:91:CA:1F) [redacted]▂▄▆█ [17:11:28][I][wifi:313]: WiFi Connecting to 'HomeNet'... [17:11:28][D][esp-idf:000][wifi]: I (10579) wifi: [17:11:28][D][esp-idf:000][wifi]: new:<11,0>, old:<1,0>, ap:<255,255>, sta:<11,0>, prof:1 [17:11:28][D][esp-idf:000][wifi]: [17:11:29] [17:11:29][D][esp-idf:000][wifi]: I (10582) wifi: [17:11:29][D][esp-idf:000][wifi]: state: init -> auth (b0) [17:11:29][D][esp-idf:000][wifi]: [17:11:29] [17:11:29][D][esp-idf:000][wifi]: I (11567) wifi: [17:11:29][D][esp-idf:000][wifi]: state: auth -> assoc (0) [17:11:29][D][esp-idf:000][wifi]: [17:11:29] [17:11:29][D][esp-idf:000][wifi]: I (11577) wifi: [17:11:29][D][esp-idf:000][wifi]: state: assoc -> run (10) [17:11:29][D][esp-idf:000][wifi]: [17:11:29] [17:11:29][D][esp-idf:000][wifi]: I (11616) wifi: [17:11:30][D][esp-idf:000][wifi]: connected with HomeNet, aid = 4, channel 11, BW20, bssid = 1e:e8:29:91:ca:92 [17:11:30][D][esp-idf:000][wifi]: [17:11:30] [17:11:30][D][esp-idf:000][wifi]: I (11619) wifi: [17:11:30][D][esp-idf:000][wifi]: security: WPA3-SAE, phy: bgn, rssi: -55 [17:11:30][D][esp-idf:000][wifi]: [17:11:30] [17:11:30][D][esp-idf:000][wifi]: I (11622) wifi: [17:11:30][D][esp-idf:000][wifi]: pm start, type: 1 [17:11:30] [17:11:30][D][esp-idf:000][wifi]: [17:11:30] [17:11:30][D][esp-idf:000][wifi]: I (11624) wifi: [17:11:30][D][esp-idf:000][wifi]: set rx beacon pti, rx_bcn_pti: 14, bcn_timeout: 14, mt_pti: 25000, mt_time: 10000 [17:11:31][D][esp-idf:000][wifi]: [17:11:31] [17:11:31][D][esp-idf:000][wifi]: I (11635) wifi: [17:11:31][D][esp-idf:000][wifi]: idx:0 (ifx:0, 1e:e8:29:91:ca:92), tid:6, ssn:2, winSize:64 [17:11:31][D][esp-idf:000][wifi]: [17:11:31] [17:11:31][D][esp-idf:000][wifi]: I (11694) wifi: [17:11:31][D][esp-idf:000][wifi]: AP's beacon interval = 102400 us, DTIM period = 1 [17:11:31][D][esp-idf:000][wifi]: [17:11:31] [17:11:31][D][esp-idf:000][sys_evt]: I (12629) esp_netif_handlers: sta ip: 192.168.3.215, mask: 255.255.255.0, gw: 192.168.3.1 [17:11:31] [17:11:31][I][wifi:617]: WiFi Connected! [17:11:32][C][wifi:428]: Local MAC: D8:3B:DA:40:78:70 [17:11:32][C][wifi:433]: SSID: 'HomeNet'[redacted] [17:11:32][C][wifi:436]: IP Address: 192.168.3.215 [17:11:32][C][wifi:440]: BSSID: 1E:E8:29:91:CA:92[redacted] [17:11:32][C][wifi:441]: Hostname: 'satellite1-407870' [17:11:32][C][wifi:443]: Signal strength: -58 dB ▂▄▆█ [17:11:32][C][wifi:447]: Channel: 11 [17:11:32][C][wifi:448]: Subnet: 255.255.255.0 [17:11:32][C][wifi:449]: Gateway: 192.168.3.1 [17:11:32][C][wifi:450]: DNS1: 192.168.3.152 [17:11:32][C][wifi:451]: DNS2: 0.0.0.0 [17:11:32][C][api:026]: Setting up Home Assistant API server... [17:11:32][C][micro_wake_word:083]: Setting up microWakeWord... [17:11:32][C][micro_wake_word:109]: Micro Wake Word initialized [17:11:33][I][nabu_media_player:138]: Set up nabu media player [17:11:33][I][app:062]: setup() finished successfully! [17:11:33][D][esp-idf:000][wifi]: I (12714) wifi: [17:11:33][D][esp-idf:000][wifi]: idx:1 (ifx:0, 1e:e8:29:91:ca:92), tid:0, ssn:0, winSize:64 [17:11:33][D][esp-idf:000][wifi]: [17:11:33] [17:11:33][D][esp-idf:000]: I (12885) esp-x509-crt-bundle: Certificate validated [17:11:33] [17:11:33][D][update:011]: 'Satellite1 407870' - Publishing: [17:11:33][D][update:012]: Current Version: v0.0.4 [17:11:33][D][update:015]: Latest Version: v0.0.4 [17:11:33][D][update:018]: Firmware URL: https://raw.githubusercontent.com/FutureProofHomes/Documentation/refs/heads/main/assets/firmware/esphome/production/satellite1-esp32s3.ota.bin [17:11:33][D][update:021]: Title: ESPHome Firmware for Satellite1-Core-Board [17:11:34][D][update:023]: Summary: ESPHome Firmware for satellite1-esp32s3 [17:11:34][D][update:026]: Release URL: https://github.com/FutureProofHomes/Satellite1-ESPHome/releases/tag/v0.0.4/ [17:11:34][W][component:237]: Component http_request.update took a long time for an operation (891 ms). [17:11:34][W][component:238]: Components should block for at most 30 ms. [17:11:34][D][light:036]: 'voice_assistant_leds' Setting: [17:11:34][D][light:051]: Brightness: 66% [17:11:34][D][light:059]: Red: 10%, Green: 77%, Blue: 100% [17:11:34][D][light:109]: Effect: 'Twinkle' [17:11:34][W][component:170]: Component wifi cleared Warning flag [17:11:34][W][component:157]: Component api set Warning flag: unspecified [17:11:34][I][app:100]: ESPHome version 2024.11.2 compiled on Dec 6 2024, 18:59:28 [17:11:34][I][app:102]: Project FutureProofHomes.Satellite1 version v0.0.4 [17:11:34][C][status_led:019]: Status LED: [17:11:35][C][status_led:020]: Pin: GPIO45 [17:11:35][C][wifi:600]: WiFi: [17:11:35][C][wifi:428]: Local MAC: D8:3B:DA:40:78:70 [17:11:35][C][wifi:433]: SSID: 'HomeNet'[redacted] [17:11:35][C][wifi:436]: IP Address: 192.168.3.215 [17:11:35][C][wifi:440]: BSSID: 1E:E8:29:91:CA:92[redacted] [17:11:35][C][wifi:441]: Hostname: 'satellite1-407870' [17:11:35][C][wifi:443]: Signal strength: -58 dB ▂▄▆█ [17:11:35][C][wifi:447]: Channel: 11 [17:11:35][C][wifi:448]: Subnet: 255.255.255.0 [17:11:35][C][wifi:449]: Gateway: 192.168.3.1 [17:11:35][C][wifi:450]: DNS1: 192.168.3.152 [17:11:35][C][wifi:451]: DNS2: 0.0.0.0 [17:11:36][C][logger:185]: Logger: [17:11:36][C][logger:186]: Level: DEBUG [17:11:36][C][logger:188]: Log Baud Rate: 115200 [17:11:36][C][logger:189]: Hardware UART: USB_SERIAL_JTAG [17:11:36][C][i2c.idf:075]: I2C Bus: [17:11:36][C][i2c.idf:076]: SDA Pin: GPIO5 [17:11:36][C][i2c.idf:077]: SCL Pin: GPIO6 [17:11:36][C][i2c.idf:078]: Frequency: 400000 Hz [17:11:36][C][i2c.idf:084]: Recovery: bus successfully recovered [17:11:36][I][i2c.idf:094]: Results from i2c bus scan: [17:11:36][I][i2c.idf:100]: Found i2c device at address 0x22 [17:11:36][I][i2c.idf:100]: Found i2c device at address 0x29 [17:11:36][I][i2c.idf:100]: Found i2c device at address 0x38 [17:11:37][I][i2c.idf:100]: Found i2c device at address 0x3F [17:11:37][I][i2c.idf:100]: Found i2c device at address 0x4D [17:11:37][C][spi:064]: SPI bus: [17:11:37][C][spi:065]: CLK Pin: GPIO12 [17:11:37][C][spi:066]: SDI Pin: GPIO13 [17:11:37][C][spi:067]: SDO Pin: GPIO11 [17:11:37][C][spi:072]: Using HW SPI: SPI2_HOST [17:11:37][C][Satellite1:027]: Satellite1 config: [17:11:37][C][template.number:050]: Template Number 'Offset Temperature' [17:11:37][C][template.number:050]: Icon: 'mdi:thermometer' [17:11:37][C][template.number:050]: Unit of Measurement: '°C' [17:11:37][C][template.number:051]: Optimistic: YES [17:11:37][C][template.number:052]: Update Interval: never [17:11:37][C][template.number:050]: Template Number 'Offset Humidity' [17:11:38][C][template.number:050]: Icon: 'mdi:water-percent' [17:11:38][C][template.number:050]: Unit of Measurement: '%' [17:11:38][C][template.number:051]: Optimistic: YES [17:11:38][C][template.number:052]: Update Interval: never [17:11:38][C][template.text_sensor:020]: Template Sensor 'USB-C Power Draw' [17:11:38][C][template.text_sensor:020]: Icon: 'mdi:usb-c-port' [17:11:38][C][template.text_sensor:020]: Template Sensor 'XMOS Firmware' [17:11:38][C][template.text_sensor:020]: Icon: 'mdi:memory' [17:11:38][C][esp32_rmt_led_strip:187]: ESP32 RMT LED Strip: [17:11:38][C][esp32_rmt_led_strip:188]: Pin: 21 [17:11:38][C][esp32_rmt_led_strip:189]: Channel: 1 [17:11:38][C][esp32_rmt_led_strip:214]: RGB Order: GRB [17:11:38][C][esp32_rmt_led_strip:215]: Max refresh rate: 0 [17:11:39][C][esp32_rmt_led_strip:216]: Number of LEDs: 24 [17:11:39][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Left (HW Mute)' [17:11:39][C][gpio.binary_sensor:016]: Pin: [17:11:39][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Up (Vol+)' [17:11:39][C][gpio.binary_sensor:016]: Pin: [17:11:39][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Down (Vol-)' [17:11:39][C][gpio.binary_sensor:016]: Pin: [17:11:39][C][gpio.binary_sensor:015]: GPIO Binary Sensor 'Button Right (Action)' [17:11:39][C][gpio.binary_sensor:016]: Pin: GPIO0 [17:11:39][C][light:092]: Light 'hw_led_ring' [17:11:39][C][light:094]: Default Transition Length: 1.0s [17:11:39][C][light:095]: Gamma Correct: 2.80 [17:11:39][C][light:092]: Light 'LED Ring' [17:11:40][C][light:094]: Default Transition Length: 0.0s [17:11:40][C][light:095]: Gamma Correct: 2.80 [17:11:40][C][light:092]: Light 'voice_assistant_leds' [17:11:40][C][light:094]: Default Transition Length: 0.0s [17:11:40][C][light:095]: Gamma Correct: 2.80 [17:11:40][C][template.switch:068]: Template Switch 'Wake sound' [17:11:40][C][template.switch:070]: Icon: 'mdi:bullhorn' [17:11:40][C][template.switch:091]: Restore Mode: restore defaults to ON [17:11:40][C][template.switch:057]: Optimistic: YES [17:11:40][C][template.switch:068]: Template Switch 'Mute Microphones' [17:11:40][C][template.switch:070]: Icon: 'mdi:microphone-off' [17:11:40][C][template.switch:091]: Restore Mode: restore defaults to OFF [17:11:41][C][template.switch:057]: Optimistic: NO [17:11:41][C][template.switch:068]: Template Switch 'timer_ringing' [17:11:41][C][template.switch:091]: Restore Mode: always OFF [17:11:41][C][template.switch:057]: Optimistic: YES [17:11:41][C][template.switch:068]: Template Switch 'Beta firmware' [17:11:41][C][template.switch:070]: Icon: 'mdi:test-tube' [17:11:41][C][template.switch:091]: Restore Mode: restore defaults to OFF [17:11:41][C][template.switch:057]: Optimistic: YES [17:11:41][C][psram:020]: PSRAM: [17:11:41][C][psram:021]: Available: YES [17:11:41][C][psram:024]: Size: 8191 KB [17:11:41][C][i2s_audio:028]: I2SController: [17:11:41][C][i2s_audio:029]: AccessMode: duplex [17:11:42][C][i2s_audio:030]: Port: 0 [17:11:42][C][i2s_audio:032]: Reader registered. [17:11:42][C][i2s_audio:035]: Writer registered. [17:11:42][C][aht10:162]: AHT10: [17:11:42][C][aht10:163]: Address: 0x38 [17:11:42][C][aht10:167]: Temperature 'Temperature' [17:11:42][C][aht10:167]: Device Class: 'temperature' [17:11:42][C][aht10:167]: State Class: 'measurement' [17:11:42][C][aht10:167]: Unit of Measurement: '°C' [17:11:42][C][aht10:167]: Accuracy Decimals: 2 [17:11:42][C][aht10:168]: Humidity 'Humidity' [17:11:42][C][aht10:168]: Device Class: 'humidity' [17:11:43][C][aht10:168]: State Class: 'measurement' [17:11:43][C][aht10:168]: Unit of Measurement: '%' [17:11:43][C][aht10:168]: Accuracy Decimals: 2 [17:11:43][C][ltr_als_ps:085]: Address: 0x29 [17:11:43][C][ltr_als_ps:086]: Device type: ALS only [17:11:43][C][ltr_als_ps:088]: Automatic mode: ON [17:11:43][C][ltr_als_ps:089]: Gain: 1x [17:11:43][C][ltr_als_ps:090]: Integration time: 100 ms [17:11:43][C][ltr_als_ps:091]: Measurement repeat rate: 500 ms [17:11:43][C][ltr_als_ps:092]: Glass attenuation factor: 1.000000 [17:11:43][C][ltr_als_ps:093]: ALS calculated lux 'Ambient light' [17:11:43][C][ltr_als_ps:093]: Device Class: 'illuminance' [17:11:43][C][ltr_als_ps:093]: State Class: 'measurement' [17:11:43][C][ltr_als_ps:093]: Unit of Measurement: 'lx' [17:11:44][C][ltr_als_ps:093]: Accuracy Decimals: 1 [17:11:44][C][ltr_als_ps:093]: Icon: 'mdi:brightness-6' [17:11:44][C][ltr_als_ps:105]: Update Interval: 60.0s [17:11:44][C][restart.button:017]: Restart Button 'Restart Sat1' [17:11:44][C][restart.button:017]: Icon: 'mdi:restart' [17:11:44][C][factory_reset.button:011]: Factory Reset Button 'Factory Reset ESP32 FW' [17:11:44][C][factory_reset.button:011]: Icon: 'mdi:restart-alert' [17:11:44][C][i2s_audio:143]: I2S-Reader (Fixed-CFG): [17:11:44][C][i2s_audio:148]: clk_mode: external [17:11:44][C][i2s_audio:149]: sample-rate: 48000 bits_per_sample: 32 [17:11:44][C][i2s_audio:150]: channel_fmt: 0 channels: 2 [17:11:44][C][i2s_audio:151]: use_apll: no, use_pdm: no [17:11:45][C][memory_flasher:014]: Embedded Image: [17:11:45][C][memory_flasher:016]: Version: 1.0.1 [17:11:45][C][esp32_ble:391]: ESP32 BLE: [17:11:45][C][esp32_ble:393]: MAC address: D8:3B:DA:40:78:72 [17:11:45][C][esp32_ble:394]: IO Capability: none [17:11:45][C][esp32_ble_server:200]: ESP32 BLE Server: [17:11:45][C][esp32_improv.component:269]: ESP32 Improv: [17:11:45][C][esp32_improv.component:271]: Authorizer 'Button Right (Action)' [17:11:45][C][mdns:116]: mDNS: [17:11:45][C][mdns:117]: Hostname: satellite1-407870 [17:11:45][C][esphome.ota:073]: Over-The-Air updates: [17:11:45][C][esphome.ota:074]: Address: satellite1.local:3232 [17:11:46][C][esphome.ota:075]: Version: 2 [17:11:46][C][safe_mode:018]: Safe Mode: [17:11:46][C][safe_mode:020]: Boot considered successful after 60 seconds [17:11:46][C][safe_mode:021]: Invoke after 10 boot attempts [17:11:46][C][safe_mode:023]: Remain in safe mode for 300 seconds [17:11:46][W][safe_mode:029]: Last reset occurred too quickly; safe mode will be invoked in 7 restarts [17:11:46][C][http_request.ota:026]: Over-The-Air updates via HTTP request [17:11:46][C][api:140]: API Server: [17:11:46][C][api:141]: Address: satellite1.local:6053 [17:11:46][C][api:145]: Using noise encryption: NO [17:11:46][C][improv_serial:032]: Improv Serial: [17:11:46][C][http_request:013]: HTTP Request: [17:11:46][C][http_request:014]: Timeout: 4500ms [17:11:47][C][http_request:015]: User-Agent: ESPHome/2024.11.2 (https://esphome.io) [17:11:47][C][http_request:016]: Follow redirects: YES [17:11:47][C][http_request:017]: Redirect limit: 3 [17:11:47][C][http_request.idf:022]: Buffer Size RX: 512 [17:11:47][C][http_request.idf:023]: Buffer Size TX: 512 [17:11:47][C][micro_wake_word:072]: microWakeWord: [17:11:47][C][micro_wake_word:073]: models: [17:11:47][C][micro_wake_word:015]: - Wake Word: Hey Jarvis [17:11:47][C][micro_wake_word:016]: Probability cutoff: 0.97 [17:11:47][C][micro_wake_word:017]: Sliding window size: 5 [17:11:47][C][micro_wake_word:015]: - Wake Word: Okay Nabu [17:11:47][C][micro_wake_word:016]: Probability cutoff: 0.97 [17:11:48][C][micro_wake_word:017]: Sliding window size: 5 [17:11:48][C][micro_wake_word:015]: - Wake Word: Stop [17:11:48][C][micro_wake_word:016]: Probability cutoff: 0.50 [17:11:48][C][micro_wake_word:017]: Sliding window size: 5 [17:11:48][C][micro_wake_word:021]: - VAD Model [17:11:48][C][micro_wake_word:022]: Probability cutoff: 0.50 [17:11:48][C][micro_wake_word:023]: Sliding window size: 5 [17:11:48][C][i2s_audio:146]: I2S-Writer (Initial-CFG): [17:11:48][C][i2s_audio:148]: clk_mode: external [17:11:48][C][i2s_audio:149]: sample-rate: 48000 bits_per_sample: 32 [17:11:48][C][i2s_audio:150]: channel_fmt: 0 channels: 2 [17:11:48][C][i2s_audio:151]: use_apll: no, use_pdm: no [17:11:48][D][api:103]: Accepted 192.168.3.100 [17:11:49][W][component:170]: Component api cleared Warning flag [17:11:49][D][api.connection:1446]: Home Assistant 2025.2.1 (192.168.3.100): Connected successfully [17:11:49][D][esp32_ble:269]: Disabling BLE... [17:11:49][D][esp-idf:000][BTU_TASK]: W (23575) BT_APPL: bta_dm_disable BTA_DISABLE_DELAY set to 200 ms [17:11:49] [17:11:49][W][component:237]: Component esp32_ble took a long time for an operation (212 ms). [17:11:49][W][component:238]: Components should block for at most 30 ms. [17:11:49][D][micro_wake_word:379]: Starting wake word detection [17:11:49][D][light:036]: 'voice_assistant_leds' Setting: [17:11:49][D][light:047]: State: OFF [17:11:49][D][light:109]: Effect: 'None' [17:11:49][D][i2s_audio:067][microphone_task]: Install driver requested by Reader [17:11:49][D][esp-idf:000][microphone_task]: I (25593) I2S: DMA Malloc info, datalen=blocksize=4088, dma_buf_count=6 [17:11:50] [17:11:50][D][esp-idf:000][microphone_task]: I (25596) I2S: DMA Malloc info, datalen=blocksize=4088, dma_buf_count=6 [17:11:50] [17:11:50][D][i2s_audio:077][microphone_task]: Installing driver : yes [17:11:50][D][i2s_audio.microphone:322]: Starting I2S Audio Microphne [17:11:50][D][i2s_audio.microphone:326]: Started I2S Audio Microphone [17:11:50][D][micro_wake_word:418]: State changed from IDLE to DETECTING_WAKE_WORD