Open TheSomeMan opened 2 months ago
I (51152) http_server: [http_server/1] Request from 192.168.1.145 to 192.168.1.127 (Host: ruuvigateway9c2c.local): POST /ruuvi.json I (51163) http_server: [http_server/1] POST /ruuvi.json, params= I (51164) http_server: [http_server/1] http_server_cb_on_post: Clear all saved TLS session tickets I (51170) transport_base: [http_server] [network.ruuvi.com] Clear TLS session ticket (slot 1) I (51179) transport_base: [http_server] Free TLS saved session, session=0x3ffebb20: network.ruuvi.com I (51192) gw_cfg: [http_server/1] Gateway SETTINGS (via HTTP): W (51202) gw_cfg: [http_server/1] Can't find key 'company_id' in config-json W (51205) gw_cfg: [http_server/1] Can't find key 'coordinates' in config-json W (51211) gw_cfg: [http_server/1] Can't find key 'fw_update_url' in config-json I (51219) gw_cfg: [http_server/1] config: use remote cfg: 0 I (51225) gw_cfg: [http_server/1] config: remote cfg: URL: I (51232) gw_cfg: [http_server/1] config: remote cfg: auth_type: none I (51239) gw_cfg: [http_server/1] config: remote cfg: use SSL client cert: 0 I (51247) gw_cfg: [http_server/1] config: remote cfg: use SSL server cert: 0 I (51254) gw_cfg: [http_server/1] config: remote cfg: refresh_interval_minutes: 0 I (51262) gw_cfg: [http_server/1] config: use http ruuvi: 1 I (51269) gw_cfg: [http_server/1] config: use http: 0 I (51274) gw_cfg: [http_server/1] config: use http_stat: 1 I (51281) gw_cfg: [http_server/1] config: http_stat url: https://network.ruuvi.com/status I (51289) gw_cfg: [http_server/1] config: http_stat user: I (51296) gw_cfg: [http_server/1] config: http_stat pass: ******** I (51302) gw_cfg: [http_server/1] config: http_stat: use SSL client cert: 0 I (51310) gw_cfg: [http_server/1] config: http_stat: use SSL server cert: 0 I (51318) gw_cfg: [http_server/1] config: use mqtt: 0 I (51323) gw_cfg: [http_server/1] config: mqtt disable retained messages: 0 I (51331) gw_cfg: [http_server/1] config: mqtt transport: TCP I (51338) gw_cfg: [http_server/1] config: mqtt data format: ruuvi_raw I (51345) gw_cfg: [http_server/1] config: mqtt server: test.mosquitto.org I (51352) gw_cfg: [http_server/1] config: mqtt port: 1883 I (51358) gw_cfg: [http_server/1] config: mqtt sending interval: 0 I (51365) gw_cfg: [http_server/1] config: mqtt prefix: ruuvi/C8:25:2D:8E:9C:2C/ I (51373) gw_cfg: [http_server/1] config: mqtt client id: C8:25:2D:8E:9C:2C I (51381) gw_cfg: [http_server/1] config: mqtt user: I (51386) gw_cfg: [http_server/1] config: mqtt password: ******** I (51393) gw_cfg: [http_server/1] config: mqtt: use SSL client cert: 0 I (51400) gw_cfg: [http_server/1] config: mqtt: use SSL server cert: 0 I (51408) gw_cfg: [http_server/1] config: LAN auth type: lan_auth_default I (51415) gw_cfg: [http_server/1] config: LAN auth user: Admin I (51422) gw_cfg: [http_server/1] config: LAN auth pass: ******** I (51428) gw_cfg: [http_server/1] config: LAN auth API key: ******** I (51435) gw_cfg: [http_server/1] config: LAN auth API key (RW): ******** I (51443) gw_cfg: [http_server/1] config: Auto update cycle: regular I (51450) gw_cfg: [http_server/1] config: Auto update weekdays_bitmask: 0x7f I (51458) gw_cfg: [http_server/1] config: Auto update interval: 00:00..24:00 I (51465) gw_cfg: [http_server/1] config: Auto update TZ: UTC+3 I (51472) gw_cfg: [http_server/1] config: NTP: Use: yes I (51478) gw_cfg: [http_server/1] config: NTP: Use DHCP: no I (51484) gw_cfg: [http_server/1] config: NTP: Server1: time.google.com I (51491) gw_cfg: [http_server/1] config: NTP: Server2: time.cloudflare.com I (51499) gw_cfg: [http_server/1] config: NTP: Server3: pool.ntp.org I (51506) gw_cfg: [http_server/1] config: NTP: Server4: time.ruuvi.com I (51513) gw_cfg: [http_server/1] config: use company id filter: 1 I (51520) gw_cfg: [http_server/1] config: company id: 0x0499 I (51526) gw_cfg: [http_server/1] config: use scan coded phy: 0 I (51533) gw_cfg: [http_server/1] config: use scan 1mbit/phy: 1 I (51540) gw_cfg: [http_server/1] config: use scan extended payload: 0 I (51547) gw_cfg: [http_server/1] config: use scan channel 37: 1 I (51553) gw_cfg: [http_server/1] config: use scan channel 38: 1 I (51560) gw_cfg: [http_server/1] config: use scan channel 39: 1 I (51567) gw_cfg: [http_server/1] config: use scan filter: no I (51573) gw_cfg: [http_server/1] config: coordinates: I (51579) gw_cfg: [http_server/1] config: fw_update: url: https://network.ruuvi.com/firmwareupdate I (51590) GW_CFG: [http_server/1] event_mgr_notify: EVENT_MGR_EV_GW_CFG_CHANGED_RUUVI I (51597) LEDS: [leds_task/8] LEDS_TASK_SIG_ON_EV_CFG_CHANGED_RUUVI I (51604) ruuvi_gateway: [http_server/8] ruuvi_cb_on_change_cfg: settings_save_to_flash I (51629) settings: [http_server/8] ### Save config to NVS: successfully updated I (51630) ruuvi_gateway: [http_server/8] ruuvi_cb_on_change_cfg: http_server_set_auth: lan_auth_default I (51637) ADV_MQTT_TASK: [adv_mqtt_task/6] Got ADV_MQTT_SIG_GW_CFG_CHANGED_RUUVI I (51645) ADV_POST_TASK: [adv_post_task/5] Got ADV_POST_SIG_GW_CFG_CHANGED_RUUVI I (51653) ruuvi_gateway: [adv_post_task/5] ### sending settings to NRF: use filter: 1, company id: 0x0499,use scan coded phy: 0,use scan 1mbit/phy: 1,use scan extended payload: 0,use scan channel 37: 1,use scan channel 38: 1,use scan channel 39: 1 I (51676) ADV_POST_TASK: [adv_post_task/5] Start timer for advs1 retransmission I (51683) ADV_POST_TASK: [adv_post_task/5] Stop timer for advs2 retransmission I (51691) ADV_POST_TASK: [adv_post_task/5] Stop timer for relaying to MQTT I (51699) ADV_POST_TASK: [adv_post_task/5] Relaunch timer to send statistics I (51707) ADV_POST_TASK: [adv_post_task/5] Clear adv_table I (51713) TIME: [time_task/1] Got TIME_TASK_SIG_GW_CFG_CHANGED_RUUVI I (51714) ruuvi_gateway: [http_server/1] ### Start timer for deactivation of configuration mode after timeout (5 seconds) I (51721) TIME: [time_task/1] ### Deactivate SNTP time synchronization I (51739) TIME: [time_task/1] Reconfigure SNTP I (51744) TIME: [time_task/1] ### Configure SNTP to not use DHCP I (51750) TIME: [time_task/1] Add time server 0: time.google.com I (51757) TIME: [time_task/1] Add time server 1: time.cloudflare.com I (51764) TIME: [time_task/1] Add time server 2: pool.ntp.org I (51770) TIME: [time_task/1] Add time server 3: time.ruuvi.com I (51777) TIME: [time_task/1] ### Activate SNTP time synchronization I (51831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 5 I (51831) ruuvi_gateway: [main/1] free heap: 104200 .. 116464 I (52734) http_server: [http_server/1] Response: OK I (52831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 7 I (53831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 7 I (54489) TIME: [tiT/18] ### Time has been synchronized: 2024-04-07 16:55:47.895 I (54490) ADV_POST_TASK: [adv_post_task/5] Force pending advs1 retransmission I (54494) ADV_POST_TASK: [adv_post_task/5] Force pending statistics retransmission I (54831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 7 I (55831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 3 I (56733) ruuvi_gateway: [main/1] MAIN_TASK_SIG_DEACTIVATE_CFG_MODE I (56733) ruuvi_gateway: [main/1] ### Stop the timer for the deactivation of Configuration Mode I (56738) ruuvi_gateway: [main/1] DEACTIVATE_CFG_MODE: Gateway is configured to use Ethernet, start Ethernet I (56749) ruuvi_gateway: [main/1] DEACTIVATE_CFG_MODE: Ethernet is already active I (56757) ruuvi_gateway: [main/1] DEACTIVATE_CFG_MODE: Send signal to restart services I (56765) ruuvi_gateway: [main/1] DEACTIVATE_CFG_MODE: Send notification: EV_CFG_MODE_DEACTIVATED I (56775) ADV_MQTT_TASK: [adv_mqtt_task/6] Got ADV_MQTT_SIG_CFG_MODE_DEACTIVATED I (56783) ADV_POST_TASK: [adv_post_task/5] Got ADV_POST_SIG_CFG_MODE_DEACTIVATED I (56791) ADV_POST_TASK: [adv_post_task/5] Start network watchdog timer I (56799) ruuvi_gateway: [adv_post_task/5] ### sending settings to NRF: use filter: 1, company id: 0x0499,use scan coded phy: 0,use scan 1mbit/phy: 1,use scan extended payload: 0,use scan channel 37: 1,use scan channel 38: 1,use scan channel 39: 1 I (56821) ADV_POST_TASK: [adv_post_task/5] Start timer for advs1 retransmission I (56829) ADV_POST_TASK: [adv_post_task/5] Stop timer for advs2 retransmission I (56837) ADV_POST_TASK: [adv_post_task/5] Stop timer for relaying to MQTT I (56845) ADV_POST_TASK: [adv_post_task/5] Relaunch timer to send statistics I (56852) ADV_POST_TASK: [adv_post_task/5] Clear adv_table I (56859) ruuvi_gateway: [main/1] DEACTIVATE_CFG_MODE: Resume relaying I (56860) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 8 I (56871) gw_status: [main/1] RESUME RELAYING I (56876) gw_status: [main/1] Set GW_STATUS_HTTP_RELAYING_CMD_BIT I (56883) gw_status: [main/1] Set GW_STATUS_MQTT_RELAYING_CMD_BIT I (56890) ADV_MQTT_TASK: [adv_mqtt_task/6] Got ADV_MQTT_SIG_RELAYING_MODE_CHANGED I (56898) ADV_POST_TASK: [adv_post_task/5] ADV_POST_SIG_RELAYING_MODE_CHANGED: flag_relaying_enabled=1 I (56908) gw_status: [adv_post_task/5] Clear GW_STATUS_HTTP_RELAYING_CMD_BIT I (56916) ruuvi_gateway: [main/1] Restart services I (56917) ADV_POST_TASK: [adv_post_task/5] Advertisements in table for target=HTTP(Ruuvi) (num=0): I (56932) transport_base: [adv_post_task] [<NULL>] Configure size of TLS I/O buffers: in_content_len=8192, out_content_len=4096 I (56946) http: [adv_post_task/5] ### HTTP POST to URL=https://network.ruuvi.com/record I (56952) http: [adv_post_task/5] HTTP POST DATA len=146: I (56958) http: [adv_post_task/5] HTTP POST DATA: { "data": { "coordinates": "", "timestamp": 1712508950, "nonce": 3218984449, "gw_mac": "C8:25:2D:8E:9C:2C", "tags": {} } } I (56977) MQTT: [main/1] mqtt_app_stop I (56981) gw_status: [main/1] MQTT stopped I (56983) transport_base: [adv_post_task] [network.ruuvi.com] Get TLS saved session for ssl=0x3ffec234: not found I (56987) MQTT: [main/5] Free memory, allocated for certificates I (56998) transport_base: [adv_post_task] [network.ruuvi.com] There is no saved TLS session ticket for host I (57014) esp-tls: [adv_post_task] esp_tls_init: tls=0x3ffe9f64 I (57021) esp-tls: [adv_post_task] Hostname 'network.ruuvi.com' resolved to 52.57.174.232 I (57030) esp-tls: [adv_post_task] esp_tls_tcp_connect: Open socket 54 for 52.57.174.232:443 I (57042) ruuvi_gateway: [main/1] ### Reading of the configuration from the remote server is not active I (57049) ruuvi_gateway: [main/1] Restarting services: Restart firmware auto-updating, run next check after 2400 seconds I (57060) ruuvi_gateway: [main/1] ### Start timer: Check for firmware updates I (57068) ruuvi_gateway: [main/1] Relaying mode changed I (57074) MQTT: [main/1] mqtt_app_stop I (57078) gw_status: [main/1] MQTT stopped I (57083) MQTT: [main/1] Free memory, allocated for certificates I (57090) gw_status: [main/1] Clear GW_STATUS_MQTT_RELAYING_CMD_BIT I (57098) runtime_stat: [main/1] ======== totalTime 18166212 ============================================================== I (57109) runtime_stat: [main/1] | # | Task name | Pri | Stat| cnt | % | Stack | Stack free | I (57120) runtime_stat: [main/1] |-----|------------------|-----|-----|-----------|-----|--------------------|------------| I (57132) runtime_stat: [main/1] | 3 | IDLE0 | 0 | Rdy | 15975697 | 88% | 732 of 1532 (47%)| 800 | I (57144) runtime_stat: [main/1] | 2 | main | 1 | Rdy | 366548 | 2% | 3060 of 3964 (77%)| 904 | I (57156) runtime_stat: [main/1] | 6 | reset_task | 1 | Sus | 1992 | <1% | 2024 of 2812 (71%)| 788 | I (57169) runtime_stat: [main/1] | 10 | time_task | 1 | Sus | 57780 | <1% | 2208 of 3068 (71%)| 860 | I (57179) runtime_stat: [main/1] | 13 | http_server | 1 | Blk | 1053805 | 6% | 5864 of 7676 (76%)| 1812 | I (57191) runtime_stat: [main/1] | 18 | mdns | 1 | Blk | 7072 | <1% | 2172 of 3068 (70%)| 896 | I (57203) runtime_stat: [main/1] | 8 | adv_post_task | 5 | Sus | 304820 | 2% | 4320 of 6140 (70%)| 1820 | I (57215) runtime_stat: [main/1] | 15 | wifi_manager | 5 | Blk | 1944 | <1% | 2176 of 4092 (53%)| 1916 | I (57227) runtime_stat: [main/1] | 7 | adv_mqtt_task | 6 | Sus | 28907 | <1% | 2064 of 4092 (50%)| 2028 | I (57239) runtime_stat: [main/1] | 5 | leds_task | 8 | Sus | 37483 | <1% | 2084 of 3068 (67%)| 984 | I (57243) esp-tls-mbedtls: [adv_post_task]: [network.ruuvi.com] Configure size of TLS I/O buffers: in_content_len=8192, out_content_len=4096 I (57576) runtime_stat: [main/1] | 9 | uart_rx_task | 9 | Blk | 101521 | 1% | 2320 of 4092 (56%)| 1772 | I (57579) runtime_stat: [main/1] | 16 | emac_rx | 15 | Sus | 23629 | <1% | 1220 of 3068 (39%)| 1848 | I (57591) runtime_stat: [main/1] | 12 | tiT | 18 | Blk | 140027 | 1% | 2324 of 3836 (60%)| 1512 | I (57603) runtime_stat: [main/1] | 11 | sys_evt | 20 | Blk | 0 | 0% | 2336 of 2812 (83%)| 476 | I (57614) runtime_stat: [main/1] | 1 | esp_timer | 22 | Blk | 23669 | <1% | 924 of 2556 (36%)| 1632 | I (57628) runtime_stat: [main/1] | 14 | wifi | 23 | Blk | 8561 | <1% | 2340 of 6652 (35%)| 4312 | I (57638) runtime_stat: [main/1] | 4 | Tmr Svc | 24 | Blk | 28513 | <1% | 2084 of 3068 (67%)| 984 | I (57650) runtime_stat: [main/1] ========================================================================================== I (57952) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 6 I (58930) esp-x509-crt-bundle: Certificate validated I (58989) esp-tls-mbedtls: [adv_post_task]: [network.ruuvi.com] SSL handshake success, TLS version: TLSv1.3 I (58990) transport_base: [adv_post_task] [network.ruuvi.com] Unlock TLS saved session for ssl=0x3ffec234, session=0x0 I (59007) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 7 W (59520) esp-tls-mbedtls: esp_mbedtls_read: RECEIVED_NEW_SESSION_TICKET I (59521) transport_base: Cur free heap: 75052 I (59525) transport_base: [adv_post_task] [network.ruuvi.com] Got new TLS session ticket, save it to an empty slot (slot 0) I (59534) transport_base: Cur free heap: 72068 I (59545) http: [adv_post_task/5] ### HTTP POST to URL=https://network.ruuvi.com/record: STATUS=200 I (59554) LEDS: [adv_post_task/5] Notify: HTTP(1) data sent successfully I (59557) LEDS: [leds_task/8] LEDS_TASK_SIG_ON_EV_HTTP1_DATA_SENT_SUCCESSFULLY (ready=1) I (59566) ADV_POST_TASK: [adv_post_task/5] Cur free heap: 116124 I (59573) runtime_stat: [adv_post_task/5] ======== totalTime 2475354 ============================================================== I (59585) runtime_stat: [adv_post_task/5] | # | Task name | Pri | Stat| cnt | % | Stack | Stack free | I (59597) runtime_stat: [adv_post_task/5] |-----|------------------|-----|-----|-----------|-----|--------------------|------------| I (59610) runtime_stat: [adv_post_task/5] | 3 | IDLE0 | 0 | Rdy | 1398400 | 56% | 732 of 1532 (47%)| 800 | I (59622) runtime_stat: [adv_post_task/5] | 2 | main | 1 | Rdy | 227681 | 9% | 3060 of 3964 (77%)| 904 | I (59635) runtime_stat: [adv_post_task/5] | 6 | reset_task | 1 | Sus | 342 | <1% | 2024 of 2812 (71%)| 788 | I (59647) runtime_stat: [adv_post_task/5] | 10 | time_task | 1 | Sus | 0 | 0% | 2208 of 3068 (71%)| 860 | I (59660) runtime_stat: [adv_post_task/5] | 13 | http_server | 1 | Rdy | 3403 | <1% | 5864 of 7676 (76%)| 1812 | I (59673) runtime_stat: [adv_post_task/5] | 18 | mdns | 1 | Blk | 4368 | <1% | 2172 of 3068 (70%)| 896 | I (59685) runtime_stat: [adv_post_task/5] | 8 | adv_post_task | 5 | Rdy | 751113 | 30% | 4320 of 6140 (70%)| 1820 | I (59698) runtime_stat: [adv_post_task/5] | 15 | wifi_manager | 5 | Blk | 365 | <1% | 2176 of 4092 (53%)| 1916 | I (59710) runtime_stat: [adv_post_task/5] | 7 | adv_mqtt_task | 6 | Sus | 1443 | <1% | 2064 of 4092 (50%)| 2028 | I (59723) runtime_stat: [adv_post_task/5] | 5 | leds_task | 8 | Sus | 15987 | 1% | 2084 of 3068 (67%)| 984 | I (59736) runtime_stat: [adv_post_task/5] | 9 | uart_rx_task | 9 | Blk | 20949 | 1% | 2320 of 4092 (56%)| 1772 | I (59748) runtime_stat: [adv_post_task/5] | 16 | emac_rx | 15 | Sus | 7015 | <1% | 1220 of 3068 (39%)| 1848 | I (59761) runtime_stat: [adv_post_task/5] | 12 | tiT | 18 | Blk | 28131 | 1% | 2324 of 3836 (60%)| 1512 | I (59773) runtime_stat: [adv_post_task/5] | 11 | sys_evt | 20 | Blk | 0 | 0% | 2336 of 2812 (83%)| 476 | I (59786) runtime_stat: [adv_post_task/5] | 1 | esp_timer | 22 | Blk | 4612 | <1% | 924 of 2556 (36%)| 1632 | I (59799) runtime_stat: [adv_post_task/5] | 14 | wifi | 23 | Blk | 1539 | <1% | 2340 of 6652 (35%)| 4312 | I (59811) runtime_stat: [adv_post_task/5] | 4 | Tmr Svc | 24 | Blk | 7425 | <1% | 2084 of 3068 (67%)| 984 | I (59824) runtime_stat: [adv_post_task/5] ========================================================================================== I (59846) transport_base: [adv_post_task] [<NULL>] Configure size of TLS I/O buffers: in_content_len=8192, out_content_len=4096 I (59854) http: [adv_post_task/5] ### HTTP POST to URL=https://network.ruuvi.com/status I (59857) http: [adv_post_task/5] HTTP POST DATA: { "DEVICE_ADDR": "C8:25:2D:8E:9C:2C", "ESP_FW": "v1.15.0", "NRF_FW": "v1.0.0", "NRF_STATUS": true, "UPTIME": "58", "NONCE": "469141141", "CONNECTION": "ETHERNET", "NUM_CONN_LOST": "0", "RESET_REASON": "POWER_ON", "RESET_CNT": "1", "RESET_INFO": "", "SENSORS_SEEN": "9", "ACTIVE_SENSORS": [{ "MAC": "C6:A5:B9:E0:AD:06", "COUNTER": "3" }, { "MAC": "E0:52:B0:23:3B:50", "COUNTER": "1" }, { "MAC": "D5:8B:AD:CB:63:6C", "COUNTER": "2" }, { "MAC": "D1:90:7E:DE:1F:3C", "COUNTER": "2" }, { "MAC": "DD:CD:A2:29:2E:63", "COUNTER": "2" }, { "MAC": "E3:75:CF:37:4E:23", "COUNTER": "2" }, { "MAC": "E6:89:B9:2D:F9:88", "COUNTER": "2" }, { "MAC": "F4:1F:0C:28:CB:D6", "COUNTER": "2" }, { "MAC": "DB:50:4B:2A:65:6A", "COUNTER": "2" }], "INACTIVE_SENSORS": [], "TASKS": [{ "TASK_NAME": "IDLE0", "MIN_FREE_STACK_SIZE": 800 }, { "TASK_NAME": "main", "MIN_FREE_STACK_SIZE": 904 }, { "TASK_NAME": "reset_task", "MIN_FREE_STACK_SIZE": 788 }, { "TASK_NAME": "time_task", "MIN_FREE_STACK_SIZE": 860 }, { "TASK_NAME": "http_server", "MIN_FREE_STACK_SIZE": 1812 }, { "TASK_NAME": "wpsT", "MIN_FREE_STACK_SIZE": 8992 }, { "TASK_NAME": "adv_post_task", "MIN_FREE_STACK_SIZE": 1820 }, { "TASK_NAME": "wifi_manager", "MIN_FREE_STACK_SIZE": 1916 }, { "TASK_NAME": "adv_mqtt_task", "MIN_FREE_STACK_SIZE": 2028 }, { "TASK_NAME": "leds_task", "MIN_FREE_STACK_SIZE": 984 }, { "TASK_NAME": "uart_rx_task", "MIN_FREE_STACK_SIZE": 1772 }, { "TASK_NAME": "emac_rx", "MIN_FREE_STACK_SIZE": 1848 }, { "TASK_NAME": "tiT", "MIN_FREE_STACK_SIZE": 1512 }, { "TASK_NAME": "sys_evt", "MIN_FREE_STACK_SIZE": 476 }, { "TASK_NAME": "esp_timer", "MIN_FREE_STACK_SIZE": 1632 }, { "TASK_NAME": "wifi", "MIN_FREE_STACK_SIZE": 4312 }, { "TASK_NAME": "Tmr Svc", "MIN_FREE_STACK_SIZE": 984 }, { "TASK_NAME": "mdns", "MIN_FREE_STACK_SIZE": 896 }] } I (60048) transport_base: [adv_post_task] [network.ruuvi.com] Get TLS saved session for ssl=0x3ffebf34: found at idx=0 I (60058) transport_base: [adv_post_task] [network.ruuvi.com] Reuse saved TLS session ticket for host I (60068) esp-tls: [adv_post_task] esp_tls_init: tls=0x3ffe6e00 I (60075) esp-tls: [adv_post_task] Hostname 'network.ruuvi.com' resolved to 52.57.174.232 I (60084) esp-tls: [adv_post_task] esp_tls_tcp_connect: Open socket 54 for 52.57.174.232:443 I (60097) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 7 I (60298) esp-tls-mbedtls: [adv_post_task]: [network.ruuvi.com] Configure size of TLS I/O buffers: in_content_len=8192, out_content_len=4096 I (60831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 5 I (61028) esp-tls-mbedtls: [adv_post_task]: [network.ruuvi.com] SSL handshake success, TLS version: TLSv1.3 I (61028) transport_base: [adv_post_task] [network.ruuvi.com] Unlock TLS saved session for ssl=0x3ffebf34, session=0x3ffeb6b8 I (61039) transport_base: [adv_post_task] Free TLS saved session for ssl=0x3ffebf34, session=0x3ffeb6b8: network.ruuvi.com W (61321) esp-tls-mbedtls: esp_mbedtls_read: RECEIVED_NEW_SESSION_TICKET I (61322) transport_base: Cur free heap: 87308 I (61325) transport_base: [adv_post_task] [network.ruuvi.com] Got new TLS session ticket, save it to an empty slot (slot 1) I (61335) transport_base: Cur free heap: 84328 I (61548) http: [adv_post_task/5] ### HTTP POST to URL=https://network.ruuvi.com/status: STATUS=200 I (61555) ADV_POST_TASK: [adv_post_task/5] Cur free heap: 116120 I (61831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 7 I (62831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 8 I (63431) ruuvi_gateway: [main/1] free heap: 71940 .. 119480 I (63831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 7 I (64670) ADV_POST_TASK: [adv_post_task/5] Got ADV_POST_SIG_RETRANSMIT I (64671) ADV_POST_TASK: [adv_post_task/5] Advertisements in table for target=HTTP(Ruuvi) (num=9): I (64676) ADV_POST_TASK: [adv_post_task/5] i: 0, tag: C6:A5:B9:E0:AD:06, rssi: -51, timestamp: 1712508955: I (64686) ADV_POST_TASK: [adv_post_task/5] 0000: 02 01 06 1B FF 99 04 05 17 4D 67 CA C6 0B 00 58 | .........Mg....X I (64697) ADV_POST_TASK: [adv_post_task/5] 0010: 00 0C 04 14 59 36 C7 37 C2 C6 A5 B9 E0 AD 06 | ....Y6.7....... I (64711) ADV_POST_TASK: [adv_post_task/5] i: 1, tag: DB:50:4B:2A:65:6A, rssi: -26, timestamp: 1712508955: I (64717) ADV_POST_TASK: [adv_post_task/5] 0000: 02 01 06 1B FF 99 04 05 14 C4 4A 3E C5 E8 00 04 | ..........J>.... I (64727) ADV_POST_TASK: [adv_post_task/5] 0010: FF E4 04 08 A4 D6 E4 B8 3A DB 50 4B 2A 65 6A | ........:.PK*ej I (64742) ADV_POST_TASK: [adv_post_task/5] i: 2, tag: E3:75:CF:37:4E:23, rssi: -53, timestamp: 1712508957: I (64747) ADV_POST_TASK: [adv_post_task/5] 0000: 02 01 06 1B FF 99 04 05 17 E2 79 49 C5 CB 04 04 | ..........yI.... I (64758) ADV_POST_TASK: [adv_post_task/5] 0010: FF 34 00 00 64 B6 82 37 4D E3 75 CF 37 4E 23 | .4..d..7M.u.7N# I (64772) ADV_POST_TASK: [adv_post_task/5] i: 3, tag: DD:CD:A2:29:2E:63, rssi: -63, timestamp: 1712508957: I (64778) ADV_POST_TASK: [adv_post_task/5] 0000: 02 01 06 1B FF 99 04 05 14 62 5E 98 C5 EE 00 A4 | .........b^..... I (64788) ADV_POST_TASK: [adv_post_task/5] 0010: 01 B8 FC 84 A9 B6 B8 3C C2 DD CD A2 29 2E 63 | .......<....).c I (64803) ADV_POST_TASK: [adv_post_task/5] i: 4, tag: F4:1F:0C:28:CB:D6, rssi: -42, timestamp: 1712508956: I (64809) ADV_POST_TASK: [adv_post_task/5] 0000: 02 01 06 1B FF 99 04 05 14 7A 51 32 C6 33 00 00 | .........zQ2.3.. I (64819) ADV_POST_TASK: [adv_post_task/5] 0010: FF EC 03 E8 AE 16 F9 3A 29 F4 1F 0C 28 CB D6 | .......:)...(.. I (64834) ADV_POST_TASK: [adv_post_task/5] i: 5, tag: D1:90:7E:DE:1F:3C, rssi: -45, timestamp: 1712508957: I (64839) ADV_POST_TASK: [adv_post_task/5] 0000: 02 01 06 1B FF 99 04 05 14 6B 5A 46 C5 E5 00 34 | .........kZF...4 I (64849) ADV_POST_TASK: [adv_post_task/5] 0010: FF FC 03 E0 7F F6 C2 63 06 D1 90 7E DE 1F 3C | .......c...~..< I (64864) ADV_POST_TASK: [adv_post_task/5] i: 6, tag: E6:89:B9:2D:F9:88, rssi: -63, timestamp: 1712508956: I (64870) ADV_POST_TASK: [adv_post_task/5] 0000: 02 01 06 1B FF 99 04 05 15 28 45 3C C5 CD 00 68 | .........(E<...h I (64880) ADV_POST_TASK: [adv_post_task/5] 0010: 00 10 04 30 AE 76 E1 01 35 E6 89 B9 2D F9 88 | ...0.v..5...-.. I (64895) ADV_POST_TASK: [adv_post_task/5] i: 7, tag: D5:8B:AD:CB:63:6C, rssi: -82, timestamp: 1712508957: I (64900) ADV_POST_TASK: [adv_post_task/5] 0000: 02 01 06 1B FF 99 04 05 17 BF 65 03 C6 32 00 24 | ..........e..2.$ I (64910) ADV_POST_TASK: [adv_post_task/5] 0010: FF F0 03 E8 A9 B6 D7 36 EF D5 8B AD CB 63 6C | .......6.....cl I (64925) ADV_POST_TASK: [adv_post_task/5] i: 8, tag: E0:52:B0:23:3B:50, rssi: -47, timestamp: 1712508955: I (64931) ADV_POST_TASK: [adv_post_task/5] 0000: 02 01 06 1B FF 99 04 05 14 10 4F A4 FF FF 00 14 | ..........O..... I (64941) ADV_POST_TASK: [adv_post_task/5] 0010: 00 00 04 10 AA 96 4D 24 7A E0 52 B0 23 3B 50 | ......M$z.R.#;P I (64957) transport_base: [adv_post_task] [<NULL>] Configure size of TLS I/O buffers: in_content_len=8192, out_content_len=4096 I (64972) http: [adv_post_task/5] ### HTTP POST to URL=https://network.ruuvi.com/record I (64978) http: [adv_post_task/5] HTTP POST DATA len=1707: I (64981) http: [adv_post_task/5] HTTP POST DATA: { "data": { "coordinates": "", "timestamp": 1712508958, "nonce": 3218984450, "gw_mac": "C8:25:2D:8E:9C:2C", "tags": { "C6:A5:B9:E0:AD:06": { "rssi": -51, "timestamp": 1712508955, "data": "0201061BFF990405174D67CAC60B0058000C04145936C737C2C6A5B9E0AD06" }, "DB:50:4B:2A:65:6A": { "rssi": -26, "timestamp": 1712508955, "data": "0201061BFF99040514C44A3EC5E80004FFE40408A4D6E4B83ADB504B2A656A" }, "E3:75:CF:37:4E:23": { "rssi": -53, "timestamp": 1712508957, "data": "0201061BFF99040517E27949C5CB0404FF34000064B682374DE375CF374E23" }, "DD:CD:A2:29:2E:63": { "rssi": -63, "timestamp": 1712508957 I (65057) http: [adv_post_task/5] HTTP POST DATA: , "data": "0201061BFF99040514625E98C5EE00A401B8FC84A9B6B83CC2DDCDA2292E63" }, "F4:1F:0C:28:CB:D6": { "rssi": -42, "timestamp": 1712508956, "data": "0201061BFF990405147A5132C6330000FFEC03E8AE16F93A29F41F0C28CBD6" }, "D1:90:7E:DE:1F:3C": { "rssi": -45, "timestamp": 1712508957, "data": "0201061BFF990405146B5A46C5E50034FFFC03E07FF6C26306D1907EDE1F3C" }, "E6:89:B9:2D:F9:88": { "rssi": -63, "timestamp": 1712508956, "data": "0201061BFF9904051528453CC5CD006800100430AE76E10135E689B92DF988" }, "D5:8B:AD:CB:63:6C": { "rssi": -82, "timestamp": 1712508957 I (65123) http: [adv_post_task/5] HTTP POST DATA: , "data": "0201061BFF99040517BF6503C6320024FFF003E8A9B6D736EFD58BADCB636C" }, "E0:52:B0:23:3B:50": { "rssi": -47, "timestamp": 1712508955, "data": "0201061BFF99040514104FA4FFFF001400000410AA964D247AE052B0233B50" } } } } I (65152) transport_base: [adv_post_task] [network.ruuvi.com] Get TLS saved session for ssl=0x3ffeb998: found at idx=1 I (65159) transport_base: [adv_post_task] [network.ruuvi.com] Reuse saved TLS session ticket for host I (65169) esp-tls: [adv_post_task] esp_tls_init: tls=0x3ffe6de4 I (65175) esp-tls: [adv_post_task] Hostname 'network.ruuvi.com' resolved to 52.57.174.232 I (65185) esp-tls: [adv_post_task] esp_tls_tcp_connect: Open socket 54 for 52.57.174.232:443 I (65198) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 9 I (65397) esp-tls-mbedtls: [adv_post_task]: [network.ruuvi.com] Configure size of TLS I/O buffers: in_content_len=8192, out_content_len=4096 I (65831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 4 I (66110) esp-tls-mbedtls: [adv_post_task]: [network.ruuvi.com] SSL handshake success, TLS version: TLSv1.3 I (66111) transport_base: [adv_post_task] [network.ruuvi.com] Unlock TLS saved session for ssl=0x3ffeb998, session=0x3ffeae00 I (66122) transport_base: [adv_post_task] Free TLS saved session for ssl=0x3ffeb998, session=0x3ffeae00: network.ruuvi.com W (66514) esp-tls-mbedtls: esp_mbedtls_read: RECEIVED_NEW_SESSION_TICKET I (66515) transport_base: Cur free heap: 83596 I (66519) transport_base: [adv_post_task] [network.ruuvi.com] Got new TLS session ticket, save it to an empty slot (slot 0) I (66528) transport_base: Cur free heap: 80624 E (66741) http: [adv_post_task/5] ./main/http.c:111 {http_post_event_handler_on_data}: HTTP_EVENT_ON_DATA, len=87: { "result": "error", "error": "Gateway throttled", "code": "ER_THROTTLED" } E (66750) http: [adv_post_task/5] ./main/http.c:567 {http_async_poll_handle_resp_err}: ### HTTP POST to URL=https://network.ruuvi.com/record: STATUS=429 I (66768) LEDS: [adv_post_task/5] Notify: HTTP(1) data sent fail W (66771) LEDS: [leds_task/8] LEDS_TASK_SIG_ON_EV_HTTP1_DATA_SENT_FAIL (ready=1) I (66779) ADV_POST_TASK: [adv_post_task/5] advs1: restart timer with period 67000 ms I (66788) ADV_POST_TASK: [adv_post_task/5] Cur free heap: 116120 I (66831) ADV_POST_TASK: [adv_post_task/5] Advs cnt: 6 I (66851) LEDS: [leds_task/8] LEDS: New blinking mode: RRRRR-----
TheSomeMan
commented
2 months ago TheSomeMan
commented
2 months ago