search

stakwork / sphinx-key

Lightning hardware signer on ESP32
29 stars 1 forks source link

Web server in Rust #2

Closed Evanfeenstra closed 2 years ago

Evanfeenstra commented 2 years ago

serve web page from rust: (from WifI access point?) to config:

Demo project that will be very helpful:

https://github.com/ivmarkov/rust-esp32-std-demo/blob/main/src/main.rs#L1127

Evanfeenstra commented 2 years ago

working! However, the process of switching from AccessPoint to Client is buggy and doesn't work every time. For now, after posting your config, you can unplug and plugin the ESP to get it to connect

https://github.com/stakwork/sphinx-key/commit/c311b74884828d2123f49c20b8fa54bfe3be0df5

Evanfeenstra commented 2 years ago

Full log:

######## flashclear
Serial port: /dev/tty.SLAB_USBtoUART
Connecting...

Chip type:         ESP32-C3 (revision 3)
Crystal frequency: 40MHz
Flash size:        4MB
Features:          WiFi
MAC address:       84:f7:03:08:16:9c
[00:00:01] ########################################      12/12      segment 0x0
[00:00:00] ########################################       1/1       segment 0x8000
[00:00:26] ########################################     241/241     segment 0x10000

Flashing has completed!
Commands:
    CTRL+R    Reset chip
    CTRL+C    Exit

�
 I�ESP-ROM:esp32c3-api1-20210207
Build:Feb  7 2021
rst:0x1 (POWERON),boot:0xc (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fcd6100,len:0x172c
load:0x403ce000 [_iram_data_start:??:??],len:0x928
load:0x403d0000 [_iram_data_start:??:??],len:0x2ce0
entry 0x403ce000 [_iram_data_start:??:??]
I (30) boot: ESP-IDF v4.4-dev-2825-gb63ec47238 2nd stage bootloader
I (30) boot: compile time 12:10:40
I (30) boot: chip revision: 3
I (33) boot_comm: chip revision: 3, min. bootloader chip revision: 0
I (41) boot.esp32c3: SPI Speed      : 80MHz
I (45) boot.esp32c3: SPI Mode       : DIO
I (50) boot.esp32c3: SPI Flash Size : 4MB
I (55) boot: Enabling RNG early entropy source...
I (60) boot: Partition Table:
I (64) boot: ## Label            Usage          Type ST Offset   Length
I (71) boot:  0 nvs              WiFi data        01 02 00009000 00006000
I (78) boot:  1 phy_init         RF data          01 01 0000f000 00001000
I (86) boot:  2 factory          factory app      00 00 00010000 003f0000
I (93) boot: End of partition table
I (98) boot_comm: chip revision: 3, min. application chip revision: 0
I (105) esp_image: segment 0: paddr=00010020 vaddr=3c060020 size=1daa8h (121512) map
I (131) esp_image: segment 1: paddr=0002dad0 vaddr=3fc8a200 size=0157ch (  5500) load
I (133) esp_image: segment 2: paddr=0002f054 vaddr=40380000 size=00fc4h (  4036) load
I (138) esp_image: segment 3: paddr=00030020 vaddr=42000020 size=529d8h (338392) map
I (196) esp_image: segment 4: paddr=00082a00 vaddr=40380fc4 size=09070h ( 36976) load
I (203) esp_image: segment 5: paddr=0008ba78 vaddr=50000010 size=00010h (    16) load
I (207) boot: Loaded app from partition at offset 0x10000
I (208) boot: Disabling RNG early entropy source...
I (225) cpu_start: Pro cpu up.
I (234) cpu_start: Pro cpu start user code
I (234) cpu_start: cpu freq: 160000000
I (234) cpu_start: Application information:
I (236) cpu_start: Project name:     libespidf
I (242) cpu_start: App version:      1
I (246) cpu_start: Compile time:     May 23 2022 14:18:58
I (252) cpu_start: ELF file SHA256:  0000000000000000...
I (258) cpu_start: ESP-IDF:          c5deb7a
I (263) heap_init: Initializing. RAM available for dynamic allocation:
I (270) heap_init: At 3FC8C6F0 len 00033910 (206 KiB): DRAM
I (276) heap_init: At 3FCC0000 len 0001F060 (124 KiB): STACK/DRAM
I (283) heap_init: At 50000020 len 00001FE0 (7 KiB): RTCRAM
I (290) spi_flash: detected chip: generic
I (294) spi_flash: flash io: dio
I (299) sleep: Configure to isolate all GPIO pins in sleep state
I (305) sleep: Enable automatic switching of GPIO sleep configuration
I (312) cpu_start: Starting scheduler.
NVS cleared!
######## clear

######## flashkey
Serial port: /dev/tty.SLAB_USBtoUART
Connecting...

Chip type:         ESP32-C3 (revision 3)
Crystal frequency: 40MHz
Flash size:        4MB
Features:          WiFi
MAC address:       84:f7:03:08:16:9c
[00:00:01] ########################################      12/12      segment 0x0
[00:00:00] ########################################       1/1       segment 0x8000
[00:01:05] ########################################     594/594     segment 0x10000

Flashing has completed!
Commands:
    CTRL+R    Reset chip
    CTRL+C    Exit

�
 I�ESP-ROM:esp32c3-api1-20210207
Build:Feb  7 2021
rst:0x1 (POWERON),boot:0xc (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fcd6100,len:0x172c
load:0x403ce000 [_iram_bss_start:??:??],len:0x928
load:0x403d0000 [_iram_bss_start:??:??],len:0x2ce0
entry 0x403ce000 [_iram_bss_start:??:??]
I (30) boot: ESP-IDF v4.4-dev-2825-gb63ec47238 2nd stage bootloader
I (30) boot: compile time 12:10:40
I (30) boot: chip revision: 3
I (33) boot_comm: chip revision: 3, min. bootloader chip revision: 0
I (41) boot.esp32c3: SPI Speed      : 80MHz
I (45) boot.esp32c3: SPI Mode       : DIO
I (50) boot.esp32c3: SPI Flash Size : 4MB
I (55) boot: Enabling RNG early entropy source...
I (60) boot: Partition Table:
I (64) boot: ## Label            Usage          Type ST Offset   Length
I (71) boot:  0 nvs              WiFi data        01 02 00009000 00006000
I (78) boot:  1 phy_init         RF data          01 01 0000f000 00001000
I (86) boot:  2 factory          factory app      00 00 00010000 003f0000
I (93) boot: End of partition table
I (98) boot_comm: chip revision: 3, min. application chip revision: 0
I (105) esp_image: segment 0: paddr=00010020 vaddr=3c0d0020 size=38130h (229680) map
I (148) esp_image: segment 1: paddr=00048158 vaddr=3fc8da00 size=02ca8h ( 11432) load
I (150) esp_image: segment 2: paddr=0004ae08 vaddr=40380000 size=05210h ( 21008) load
I (157) esp_image: segment 3: paddr=00050020 vaddr=42000020 size=cd40ch (840716) map
I (288) esp_image: segment 4: paddr=0011d434 vaddr=40385210 size=08710h ( 34576) load
I (295) esp_image: segment 5: paddr=00125b4c vaddr=50000010 size=00010h (    16) load
I (299) boot: Loaded app from partition at offset 0x10000
I (300) boot: Disabling RNG early entropy source...
I (317) cpu_start: Pro cpu up.
I (325) cpu_start: Pro cpu start user code
I (325) cpu_start: cpu freq: 160000000
I (325) cpu_start: Application information:
I (328) cpu_start: Project name:     libespidf
I (333) cpu_start: App version:      1
I (338) cpu_start: Compile time:     May 23 2022 14:18:58
I (344) cpu_start: ELF file SHA256:  0000000000000000...
I (350) cpu_start: ESP-IDF:          c5deb7a
I (355) heap_init: Initializing. RAM available for dynamic allocation:
I (362) heap_init: At 3FC946B0 len 0002B950 (174 KiB): DRAM
I (368) heap_init: At 3FCC0000 len 0001F060 (124 KiB): STACK/DRAM
I (375) heap_init: At 50000020 len 00001FE0 (7 KiB): RTCRAM
I (382) spi_flash: detected chip: generic
I (386) spi_flash: flash io: dio
I (390) sleep: Configure to isolate all GPIO pins in sleep state
I (397) sleep: Enable automatic switching of GPIO sleep configuration
I (404) cpu_start: Starting scheduler.
hi from signer module!
=============> START SERVER NOW AND WAIT <==============
I (1419) pp: pp rom version: 9387209
I (1419) net80211: net80211 rom version: 9387209
I (1439) wifi:wifi driver task: 3fc9e654, prio:23, stack:6656, core=0
I (1439) system_api: Base MAC address is not set
I (1439) system_api: read default base MAC address from EFUSE
I (1449) wifi:wifi firmware version: 195d59c
I (1449) wifi:wifi certification version: v7.0
I (1449) wifi:config NVS flash: enabled
I (1459) wifi:config nano formating: disabled
I (1459) wifi:Init data frame dynamic rx buffer num: 32
I (1459) wifi:Init management frame dynamic rx buffer num: 32
I (1469) wifi:Init management short buffer num: 32
I (1469) wifi:Init dynamic tx buffer num: 32
I (1479) wifi:Init static tx FG buffer num: 2
I (1479) wifi:Init static rx buffer size: 1600
I (1489) wifi:Init static rx buffer num: 10
I (1489) wifi:Init dynamic rx buffer num: 32
I (1499) wifi_init: rx ba win: 6
I (1499) wifi_init: tcpip mbox: 32
I (1499) wifi_init: udp mbox: 6
I (1509) wifi_init: tcp mbox: 6
I (1509) wifi_init: tcp tx win: 5744
I (1509) wifi_init: tcp rx win: 5744
I (1519) wifi_init: tcp mss: 1440
I (1519) wifi_init: WiFi IRAM OP enabled
I (1529) wifi_init: WiFi RX IRAM OP enabled
I (1529) esp_idf_svc::wifi: Driver initialized
I (1539) esp_idf_svc::wifi: Event handlers registered
I (1539) esp_idf_svc::wifi: Initialization complete
I (1549) esp_idf_svc::wifi: Setting configuration: AccessPoint(AccessPointConfiguration { ssid: "sphinxkey", ssid_hidden: false, channel: 6, secondary_channel: None, protocols: EnumSet(P802D11B | P802D11BG | P802D11BGN), auth_method: None, password: "", max_connections: 255, ip_conf: Some(RouterConfiguration { subnet: Subnet { gateway: 192.168.71.1, mask: Mask(24) }, dhcp_enabled: true, dns: Some(8.8.8.8), secondary_dns: Some(8.8.4.4) }) })
I (1589) esp_idf_svc::wifi: Stopping
I (1589) esp_idf_svc::wifi: Disconnect requested
I (1599) esp_idf_svc::wifi: Stop requested
I (1599) esp_idf_svc::wifi: Stopped
I (1619) esp_idf_svc::wifi: Wifi mode AP set
I (1619) esp_idf_svc::wifi: Setting AP configuration: AccessPointConfiguration { ssid: "sphinxkey", ssid_hidden: false, channel: 6, secondary_channel: None, protocols: EnumSet(P802D11B | P802D11BG | P802D11BGN), auth_method: None, password: "", max_connections: 255, ip_conf: Some(RouterConfiguration { subnet: Subnet { gateway: 192.168.71.1, mask: Mask(24) }, dhcp_enabled: true, dns: Some(8.8.8.8), secondary_dns: Some(8.8.4.4) }) }
I (1649) esp_idf_svc::wifi: Setting AP interface configuration: InterfaceConfiguration { key: "WIFI_AP_DEF", description: "ap", route_priority: 10, ip_configuration: Router(RouterConfiguration { subnet: Subnet { gateway: 192.168.71.1, mask: Mask(24) }, dhcp_enabled: true, dns: Some(8.8.8.8), secondary_dns: Some(8.8.4.4) }), interface_stack: Ap }
I (1679) esp_idf_svc::wifi: AP IP configuration done
I (1689) esp_idf_svc::wifi: AP configuration done
I (1689) esp_idf_svc::wifi: Starting with status: Status(Stopped, Starting)
I (1699) esp_idf_svc::wifi: Status is of operating type, starting
I (1709) phy_init: phy_version 909,aa05aec,Apr 16 2022,13:42:08
I (1809) wifi:mode : softAP (84:f7:03:08:16:9d)
I (1809) wifi:Total power save buffer number: 16
I (1809) wifi:Init max length of beacon: 752/752
I (1809) phy: chan:1,max_power:80
I (1809) phy: chan:2,max_power:80
I (1819) phy: chan:3,max_power:80
I (1819) phy: chan:4,max_power:80
I (1829) phy: chan:5,max_power:80
I (1829) phy: chan:6,max_power:80
I (1829) phy: chan:7,max_power:80
I (1839) phy: chan:8,max_power:80
I (1839) phy: chan:9,max_power:80
I (1849) phy: chan:10,max_power:80
I (1849) phy: chan:11,max_power:80
I (1849) phy: chan:12,max_power:80
I (1859) phy: chan:13,max_power:80
I (1859) phy: chan:14,max_power:80
I (1869) wifi:Init max length of beacon: 752/752
I (1869) esp_idf_svc::wifi: Start requested
I (1879) esp_idf_svc::wifi: STA netif is not allocated
I (1879) esp_idf_svc::wifi: AP netif status: EspNetif(EspNetifStack(PrivateData), 0x3fca3aec), index: 1, name: lo0, ifkey: WIFI_AP_DEF
I (1889) esp_idf_svc::wifi: Got wifi event: ApStarted
I (1899) esp_idf_svc::wifi: STA event ApStarted handled, set status: Status(Stopped, Started(Done))
I (1909) esp_idf_svc::wifi: Configuration set
I (1919) sphinx_key::conn::wifi: Wifi configuration set, about to get status
I (1919) esp_idf_svc::wifi: About to wait 20s for status
I (1929) esp_idf_svc::wifi: Waiting for status done - success
I (1939) esp_idf_svc::wifi: Providing status: Status(Stopped, Started(Done))
I (1939) sphinx_key::conn::wifi: Wifi started!
I (1949) esp_idf_svc::httpd: Started Httpd IDF server with config Configuration { http_port: 80, https_port: 443 }
I (1959) esp_idf_svc::httpd: Registered Httpd IDF server handler Get for URI "/"
I (1969) esp_idf_svc::httpd: Registered Httpd IDF server handler Post for URI "/config"
I (25999) wifi:new:<6,0>, old:<6,1>, ap:<6,1>, sta:<255,255>, prof:6
I (25999) wifi:station: 20:c9:d0:7b:48:cd join, AID=1, bgn, 20
I (25999) esp_idf_svc::wifi: Got wifi event: ApStaConnected
I (26009) esp_idf_svc::wifi: STA event ApStaConnected skipped
W (26029) wifi:<ba-add>idx:2 (ifx:1, 20:c9:d0:7b:48:cd), tid:0, ssn:0, winSize:64
I (26029) esp_netif_lwip: DHCP server assigned IP to a station, IP is: 192.168.71.2
I (38209) esp_idf_svc::httpd: About to handle query string Some("broker=52.91.253.115%3A1883")
I (38209) esp_idf_svc::httpd: Request handled with status 200 (None)
I (62359) esp_idf_svc::httpd: About to handle query string Some("config=%7B%22ssid%22%3A%22Fios-Vq7Qy%22%2C%22pass%22%3A%22maul39urea57sile%22%2C%22broker%22%3A%2252.91.253.115%3A1883%22%7D")
bod "config=%7B%22ssid%22%3A%22Fios-Vq7Qy%22%2C%22pass%22%3A%22maul39urea57sile%22%2C%22broker%22%3A%2252.91.253.115%3A1883%22%7D"
I (62379) esp_idf_svc::httpd: Request handled with status 200 (None)
I (62389) esp_idf_svc::httpd: Unregistered Httpd IDF server handler 3 for URI "/config"
I (62389) esp_idf_svc::httpd: Unregistered Httpd IDF server handler 1 for URI "/"
I (62409) esp_idf_svc::httpd: Httpd IDF server stopped
===> config! Config { broker: "52.91.253.115:1883", ssid: "Fios-Vq7Qy", pass: "maul39urea57sile" }
CONFIG SAVED
I (62429) esp_idf_svc::wifi: Stopping
thread 'main' panicked at 'called `Result::unwrap()` on an `Err` value: EspError(-1)', /Users/beraf/.cargo/registry/src/github.com-1ecc6299db9ec823/esp-idf-svc-0.41.3/src/wifi.rs:798:30
note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace
abort() was called at PC 0x420402bb [panic_abort::__rust_start_panic::abort:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/panic_abort/src/lib.rs:43] on core 0
Core  0 register dump:
MEPC    : 0x4038082c [panic_abort:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/esp_system/panic.c:402]  RA      : 0x40386190 [__ubsan_include:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/esp_system/ubsan.c:294]  SP      : 0x3fc98090  GP      : 0x3fc8e200  
TP      : 0x3fc61b0c  T0      : 0x37363534  T1      : 0x7271706f  T2      : 0x33323130  
S0/FP   : 0x3fc980cc  S1      : 0x3fc980cc  A0      : 0x3fc980cc  A1      : 0x3fc980ae  
A2      : 0x00000000  A3      : 0x3fc980f9  A4      : 0x3fc9381c  A5      : 0x3fc93824  
A6      : 0x7a797877  A7      : 0x76757473  S2      : 0x3fc980b0  S3      : 0x3fc981d0  
S4      : 0x00000001  S5      : 0x3c0d4d0c  S6      : 0x00000000  S7      : 0x00000000  
S8      : 0x00000000  S9      : 0x00000000  S10     : 0x00000000  S11     : 0x00000000  
T3      : 0x6e6d6c6b  T4      : 0x6a696867  T5      : 0x66656463  T6      : 0x62613938  
MSTATUS : 0x00001801  MTVEC   : 0x40380001 [_vector_table:??:??]  MCAUSE  : 0x00000007  MTVAL   : 0x00000000  
MHARTID : 0x00000000  
Stack memory:
3fc98090: 0x00000000 0x4204fce6 [<&T as core::fmt::Display>::fmt:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/core/src/fmt/mod.rs:2134] 0x3fc980cc 0x4038bbe4 [__assert_func:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/newlib/assert.c:41] 0x00000000 0x00000003 0x3fc98128 0x40380030 [_vector_table:??:??]
3fc980b0: 0x34303234 0x62623230 0x3fca8900 0x3fc8fbf4 0x3fc980b0 0x3fc8fc10 0x3fc980ac 0x726f6261
3fc980d0: 0x20292874 0x20736177 0x6c6c6163 0x61206465 0x43502074 [_instruction_reserved_end:??:??] 0x34783020 0x30343032 0x20626232
3fc980f0: 0x63206e6f 0x2065726f 0x00000030 0x3fc90000 0x3c0e3be4 0x00000001 0x00000000 0x420402be [panic_abort::__rust_start_panic::abort:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/panic_abort/src/lib.rs:43]
3fc98110: 0x3fc981d0 0x3c0e3be4 0x3fca568c 0x40380436 [pthread_mutex_unlock:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/pthread/pthread.c:709] 0x3fca5680 0x00000000 0x3fca567c 0x4205c90c [pthread_rwlock_unlock:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/pthread/pthread_rwlock.c:255]
3fc98130: 0x3c0e3be4 0x00000001 0x00000000 0x4202fc32 [std::sys::unix::locks::pthread_rwlock::RwLock::raw_unlock:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/std/src/sys/unix/locks/pthread_rwlock.rs:114] 0x3c0ecfb4 0x00000002 0x00000000 0x00000000
3fc98150: 0x3fc98270 0x00000001 0x3fc8dd08 0x4202b71e [std::sys::unix::locks::pthread_rwlock::RwLock::read_unlock:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/std/src/sys/unix/locks/pthread_rwlock.rs:121] 0x3c0e3be4 0x00000001 0x00000000 0x4202f70c [std::panicking::rust_panic_with_hook:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/std/src/panicking.rs:716]
3fc98170: 0x3fc8dd08 0x00000000 0x00000001 0x00000001 0x00000001 0x00000001 0x3fc93e50 0x600c2000
3fc98190: 0xa0000000 0x0000000a 0x3fc981d4 0x3c0e0b04 0x3fc98258 0x3c0d4d0c 0x00000001 0x00000000
3fc981b0: 0x00000000 0x3fc9aea4 0x3fc9bf74 0x3fc9bf80 0x3c0d4d0c 0x3fc98228 0x3fc98258 0x42038e2e [std::panicking::begin_panic_handler::{{closure}}:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/std/src/panicking.rs:??]
3fc981d0: 0x3fc98258 0x3fca8478 0x00000056 0x00000039 0x3fc98398 0x3c0d4d0c 0x3fc98228 0x42038cae [std::sys_common::backtrace::__rust_end_short_backtrace:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/std/src/sys_common/backtrace.rs:138]
3fc981f0: 0x3fc98258 0x3fc98228 0x3c0d4d0c 0x3fc9bf80 0x00000001 0x3fca38b8 0x3fc98258 0x3fc98228
3fc98210: 0x3c0d4d0c 0x3fc8da00 0xffffffff 0x4204ff5a [core::panicking::panic_fmt:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/core/src/panicking.rs:142] 0xffffffff 0x3fca86a4 0x3c0ebc14 0x3c0ebd2c
3fc98230: 0x3fc98258 0x3c0d4d0c 0x3fca8601 0x420a195c [ieee80211_ioctl:??:??] 0x00000001 0x3fca38b8 0x3c0d411c 0x0000002b
3fc98250: 0x3fc98298 0x3c0d4148 0x3c0ecfb4 0x00000002 0x00000000 0x00000001 0x3fc98270 0x00000002
3fc98270: 0x3fc98248 0x4204fce6 [<&T as core::fmt::Display>::fmt:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/core/src/fmt/mod.rs:2134] 0x3fc98250 0x4204fc02 [<&T as core::fmt::Debug>::fmt:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/core/src/fmt/mod.rs:2134] 0x00000004 0x3fca8a0c 0x3fca5724 0x3fc8da00
3fc98290: 0x0000004d 0x00000000 0xffffffff 0x00000007 0x3fca8534 0x0000004d 0x3c0d251c 0x00000001
3fc982b0: 0x00000000 0x3fca39e8 0x3fca39e8 0x4200378a [core::ptr::non_null::NonNull<T>::as_ref:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/core/src/ptr/non_null.rs:381] 0x3fca39e8 0x00000000 0x3fca39e8 0x42001902 [sphinx_key::main:/Users/beraf/summer_2022/sphinx-key/sphinx-key/src/main.rs:55]
3fc982d0: 0x00000000 0x3fc995e0 0x00000000 0x3fc995e0 0x00000001 0x3fc946c4 0x00000000 0x00000000
3fc982f0: 0x3fc99b08 0x3fc946b0 0x4038b81c [multi_heap_free_impl:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/heap/multi_heap.c:223] 0x3fc982a8 0x3fc99b08 0x00000007 0x42003a24 [<alloc::alloc::Global as core::alloc::Allocator>::deallocate:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/alloc/src/alloc.rs:246] 0x40380b1a [heap_caps_malloc:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/heap/heap_caps.c:167]
3fc98310: 0x00000000 0x3fca39e8 0x3fca3a24 0x00000012 0x00000012 0x3fca86c0 0x0000000a 0x0000000a
3fc98330: 0x3fca83d0 0x00000010 0x00000010 0x4038037e [pthread_mutex_lock:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/pthread/pthread.c:647] 0x3fc995e0 0x3fc9aea4 0x3fc9be54 0x3fc9bf58
3fc98350: 0x3fca3a24 0x00000012 0x00000012 0x3fca86c0 0x0000000a 0x0000000a 0x3fca83d0 0x00000010
3fc98370: 0x00000010 0x00000000 0x00000000 0x40380b1a [heap_caps_malloc:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/heap/heap_caps.c:167] 0x00000000 0x3fca4cf0 0x3fca8478 0x00000004
3fc98390: 0x00000002 0x3fc9bf68 0x3fca39e8 0x00000001 0x00000000 0x3fca86c0 0x3c0d23fc 0x00000000
3fc983b0: 0x3fca83d0 0x00000010 0x00000010 0x00000000 0x00000000 0x00000000 0x00000000 0x00000000
3fc983d0: 0x00000000 0x3fc98418 0x3c0d3438 0x42006656 [std::sys_common::backtrace::__rust_begin_short_backtrace:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/std/src/sys_common/backtrace.rs:128] 0x00000000 0x0000000c 0x00000000 0x42006860 [std::rt::lang_start::{{closure}}:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/std/src/rt.rs:145]
3fc983f0: 0x00000000 0x3fc93f04 0x3fc98638 0x4202588a [core::ops::function::impls::<impl core::ops::function::FnOnce<A> for &F>::call_once:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/core/src/ops/function.rs:280] 0x00000000 0x00000000 0x00000000 0x4200684c [std::rt::lang_start:/Users/beraf/.rustup/toolchains/nightly-x86_64-apple-darwin/lib/rustlib/src/rust/library/std/src/rt.rs:150]
3fc98410: 0x00000000 0x00000000 0x420013bc [sphinx_key::main:/Users/beraf/summer_2022/sphinx-key/sphinx-key/src/main.rs:26] 0x420cd08a [main_task:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/freertos/port/port_common.c:131] 0x00000000 0x00000000 0x00000000 0x40388dca [_prvTaskExitError:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/freertos/port/riscv/port.c:164]
3fc98430: 0x00000000 0x00000000 0x00000000 0x00000000 0x00000000 0xa5a5a5a5 0xa5a5a5a5 0xa5a5a5a5
3fc98450: 0x27146414 0x01010107 0x00000001 0xffffffff 0x7fefffff 0x00000000 0x3fc00000 0x00000000
3fc98470: 0x40300000 [chip726_phyrom_version_num:??:??] 0x00000000 0x3fe00000 0x00000000 0x3ff80000 0x636f4361 0x3fd287a7 0x8b60c8b3
ELF file SHA256: 0000000000000000
Rebooting...
ESP-ROM:esp32c3-api1-20210207
Build:Feb  7 2021
rst:0x3 (RTC_SW_SYS_RST),boot:0xc (SPI_FAST_FLASH_BOOT)
Saved PC:0x403806a2 [esp_restart_noos_dig:/Users/beraf/summer_2022/sphinx-key/sphinx-key/.embuild/espressif/esp-idf/release-v4.4/components/esp_system/esp_system.c:44]
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fcd6100,len:0x172c
load:0x403ce000 [_iram_bss_start:??:??],len:0x928
load:0x403d0000 [_iram_bss_start:??:??],len:0x2ce0
entry 0x403ce000 [_iram_bss_start:??:??]
I (35) boot: ESP-IDF v4.4-dev-2825-gb63ec47238 2nd stage bootloader
I (35) boot: compile time 12:10:40
I (35) boot: chip revision: 3
I (38) boot_comm: chip revision: 3, min. bootloader chip revision: 0
I (45) boot.esp32c3: SPI Speed      : 80MHz
I (50) boot.esp32c3: SPI Mode       : DIO
I (55) boot.esp32c3: SPI Flash Size : 4MB
I (60) boot: Enabling RNG early entropy source...
I (65) boot: Partition Table:
I (69) boot: ## Label            Usage          Type ST Offset   Length
I (76) boot:  0 nvs              WiFi data        01 02 00009000 00006000
I (83) boot:  1 phy_init         RF data          01 01 0000f000 00001000
I (91) boot:  2 factory          factory app      00 00 00010000 003f0000
I (98) boot: End of partition table
I (102) boot_comm: chip revision: 3, min. application chip revision: 0
I (110) esp_image: segment 0: paddr=00010020 vaddr=3c0d0020 size=38130h (229680) map
I (153) esp_image: segment 1: paddr=00048158 vaddr=3fc8da00 size=02ca8h ( 11432) load
I (155) esp_image: segment 2: paddr=0004ae08 vaddr=40380000 size=05210h ( 21008) load
I (162) esp_image: segment 3: paddr=00050020 vaddr=42000020 size=cd40ch (840716) map
I (293) esp_image: segment 4: paddr=0011d434 vaddr=40385210 size=08710h ( 34576) load
I (300) esp_image: segment 5: paddr=00125b4c vaddr=50000010 size=00010h (    16) load
I (304) boot: Loaded app from partition at offset 0x10000
I (305) boot: Disabling RNG early entropy source...
I (322) cpu_start: Pro cpu up.
I (330) cpu_start: Pro cpu start user code
I (330) cpu_start: cpu freq: 160000000
I (330) cpu_start: Application information:
I (333) cpu_start: Project name:     libespidf
I (338) cpu_start: App version:      1
I (343) cpu_start: Compile time:     May 23 2022 14:18:58
I (349) cpu_start: ELF file SHA256:  0000000000000000...
I (355) cpu_start: ESP-IDF:          c5deb7a
I (360) heap_init: Initializing. RAM available for dynamic allocation:
I (367) heap_init: At 3FC946B0 len 0002B950 (174 KiB): DRAM
I (373) heap_init: At 3FCC0000 len 0001F060 (124 KiB): STACK/DRAM
I (380) heap_init: At 50000020 len 00001FE0 (7 KiB): RTCRAM
I (387) spi_flash: detected chip: generic
I (391) spi_flash: flash io: dio
I (395) sleep: Configure to isolate all GPIO pins in sleep state
I (402) sleep: Enable automatic switching of GPIO sleep configuration
I (409) cpu_start: Starting scheduler.
hi from signer module!
=============> START CLIENT NOW <============== Config { broker: "52.91.253.115:1883", ssid: "Fios-Vq7Qy", pass: "maul39urea57sile" }
I (1435) pp: pp rom version: 9387209
I (1435) net80211: net80211 rom version: 9387209
I (1445) wifi:wifi driver task: 3fc9e5ec, prio:23, stack:6656, core=0
I (1445) system_api: Base MAC address is not set
I (1455) system_api: read default base MAC address from EFUSE
I (1465) wifi:wifi firmware version: 195d59c
I (1465) wifi:wifi certification version: v7.0
I (1465) wifi:config NVS flash: enabled
I (1465) wifi:config nano formating: disabled
I (1475) wifi:Init data frame dynamic rx buffer num: 32
I (1475) wifi:Init management frame dynamic rx buffer num: 32
I (1485) wifi:Init management short buffer num: 32
I (1485) wifi:Init dynamic tx buffer num: 32
I (1495) wifi:Init static tx FG buffer num: 2
I (1495) wifi:Init static rx buffer size: 1600
I (1495) wifi:Init static rx buffer num: 10
I (1505) wifi:Init dynamic rx buffer num: 32
I (1505) wifi_init: rx ba win: 6
I (1515) wifi_init: tcpip mbox: 32
I (1515) wifi_init: udp mbox: 6
I (1515) wifi_init: tcp mbox: 6
I (1525) wifi_init: tcp tx win: 5744
I (1525) wifi_init: tcp rx win: 5744
I (1535) wifi_init: tcp mss: 1440
I (1535) wifi_init: WiFi IRAM OP enabled
I (1545) wifi_init: WiFi RX IRAM OP enabled
I (1545) esp_idf_svc::wifi: Driver initialized
I (1555) esp_idf_svc::wifi: Event handlers registered
I (1555) esp_idf_svc::wifi: Initialization complete
I (1565) esp_idf_svc::wifi: About to scan for access points
I (1565) esp_idf_svc::wifi: Stopping
I (1575) esp_idf_svc::wifi: Disconnect requested
I (1575) esp_idf_svc::wifi: Stop requested
I (1585) esp_idf_svc::wifi: About to wait for status
I (1585) esp_idf_svc::wifi: Waiting for status done - success
I (1595) esp_idf_svc::wifi: Stopped
I (1605) phy_init: phy_version 909,aa05aec,Apr 16 2022,13:42:08
I (1695) wifi:mode : sta (84:f7:03:08:16:9c)
I (1695) wifi:enable tsf
I (1705) esp_idf_svc::wifi: Got wifi event: StaStarted
I (1705) esp_idf_svc::wifi: STA event StaStarted handled, set status: Status(Started(Disconnected), Stopped)
I (3755) esp_idf_svc::wifi: Got wifi event: ScanDone
I (3755) esp_idf_svc::wifi: STA event ScanDone skipped
I (3815) esp_idf_svc::wifi: Found 2 access points
I (3815) esp_idf_svc::wifi: About to get info for found access points
I (3815) esp_idf_svc::wifi: Got info for 2 access points
I (3815) esp_idf_svc::wifi: Found access point AccessPointInfo { ssid: "DIRECT-AjDD-G4010series", bssid: [54, 159, 123, 17, 162, 221], channel: 1, secondary_channel: None, signal_strength: 197, protocols: EnumSet(), auth_method: WPA2Personal }
I (3845) esp_idf_svc::wifi: Found access point AccessPointInfo { ssid: "Fios-Vq7Qy", bssid: [184, 248, 83, 10, 249, 78], channel: 1, secondary_channel: None, signal_strength: 183, protocols: EnumSet(), auth_method: WPA2Personal }
I (3865) sphinx_key::conn::wifi: Found configured access point Fios-Vq7Qy on channel 1
I (3875) esp_idf_svc::wifi: Setting configuration: Client(ClientConfiguration { ssid: "Fios-Vq7Qy", bssid: None, auth_method: WPA2Personal, password: "maul39urea57sile", channel: Some(1), ip_conf: Some(DHCP(DHCPClientSettings { hostname: None })) })
I (3895) esp_idf_svc::wifi: Stopping
I (3895) esp_idf_svc::wifi: Disconnect requested
I (3905) wifi:flush txq
I (3905) wifi:stop sw txq
I (3905) wifi:lmac stop hw txq
I (3905) esp_idf_svc::wifi: Stop requested
I (3915) esp_idf_svc::wifi: Got wifi event: StaStopped
I (3925) esp_idf_svc::wifi: STA event StaStopped handled, set status: Status(Stopped, Stopped)
I (3925) esp_idf_svc::wifi: Stopped
I (3935) esp_idf_svc::wifi: Wifi mode STA set
I (3935) esp_idf_svc::wifi: Setting STA configuration: ClientConfiguration { ssid: "Fios-Vq7Qy", bssid: None, auth_method: WPA2Personal, password: "maul39urea57sile", channel: Some(1), ip_conf: Some(DHCP(DHCPClientSettings { hostname: None })) }
I (3965) esp_idf_svc::wifi: Setting STA interface configuration: InterfaceConfiguration { key: "WIFI_STA_DEF", description: "sta", route_priority: 100, ip_configuration: Client(DHCP(DHCPClientSettings { hostname: None })), interface_stack: Sta }
I (3985) esp_idf_svc::wifi: STA IP configuration done
I (3985) esp_idf_svc::wifi: STA configuration done
I (3995) esp_idf_svc::wifi: Starting with status: Status(Starting, Stopped)
I (4005) esp_idf_svc::wifi: Status is of operating type, starting
I (4005) wifi:mode : sta (84:f7:03:08:16:9c)
I (4015) wifi:enable tsf
I (4015) esp_idf_svc::wifi: Start requested
I (4025) esp_idf_svc::wifi: STA netif status: EspNetif(EspNetifStack(PrivateData), 0x3fca3b54), index: 1, name: lo0, ifkey: WIFI_STA_DEF
I (4035) esp_idf_svc::wifi: AP netif is not allocated
I (4035) esp_idf_svc::wifi: Got wifi event: StaStarted
I (4045) esp_idf_svc::wifi: Reconnecting
I (4055) esp_idf_svc::wifi: STA event StaStarted handled, set status: Status(Started(Connecting), Stopped)
I (4055) wifi:new:<1,0>, old:<1,0>, ap:<255,255>, sta:<1,0>, prof:6
I (4065) wifi:state: init -> auth (b0)
I (4065) esp_idf_svc::wifi: Configuration set
I (4075) wifi:state: auth -> assoc (0)
I (4075) sphinx_key::conn::wifi: Wifi client configuration set, about to get status
I (4085) wifi:state: assoc -> run (10)
I (4085) esp_idf_svc::wifi: About to wait 20s for status
I (4095) esp_idf_svc::wifi: Timeout while waiting for status
W (4105) sphinx_key::conn::wifi: Unexpected Wifi status: Status(Started(Connecting), Stopped)
I (4115) esp_idf_svc::wifi: Providing status: Status(Started(Connecting), Stopped)
I (4115) wifi:connected with Fios-Vq7Qy, aid = 17, channel 1, BW20, bssid = b8:f8:53:0a:f9:4e
I (4125) wifi:security: WPA2-PSK, phy: bgn, rssi: -75
I (4135) wifi:pm start, type: 1
I (4135) wifi:set rx beacon pti, rx_bcn_pti: 0, bcn_timeout: 0, mt_pti: 25000, mt_time: 10000
I (4145) esp_idf_svc::wifi: Got wifi event: StaConnected
I (4145) esp_idf_svc::wifi: STA event StaConnected handled, set status: Status(Started(Connected(Waiting)), Stopped)
I (4145) wifi:BcnInt:102400, DTIM:3
=> wifi STATUS 1 Status(Started(Connecting), Stopped)
I (4165) sphinx_key::conn::wifi: ...Wifi client configuration set, AGAIN get status
I (4175) esp_idf_svc::wifi: About to wait 20s for status
I (4185) esp_idf_svc::wifi: Timeout while waiting for status
W (4185) sphinx_key::conn::wifi: Unexpected Wifi status: Status(Started(Connected(Waiting)), Stopped)
I (4195) esp_idf_svc::wifi: Providing status: Status(Started(Connected(Waiting)), Stopped)
=> wifi STATUS Status(Started(Connected(Waiting)), Stopped)
=> is transitional? true
W (5275) wifi:<ba-add>idx:0 (ifx:0, b8:f8:53:0a:f9:4e), tid:0, ssn:0, winSize:64
I (5925) esp_idf_svc::wifi: Got STA IP event: DhcpIpAssigned(DhcpIpAssignment { netif_handle: 0x3fca3b54, ip_settings: ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }, ip_changed: true })
I (5935) esp_idf_svc::wifi: STA IP event DhcpIpAssigned(DhcpIpAssignment { netif_handle: 0x3fca3b54, ip_settings: ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }, ip_changed: true }) handled, set status: Status(Started(Connected(Done(ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }))), Stopped)
I (5975) esp_netif_handlers: sta ip: 192.168.1.151, mask: 255.255.255.0, gw: 192.168.1.1
I (17215) esp_idf_svc::wifi: Stopping
I (17215) wifi:state: run -> init (0)
I (17215) wifi:pm stop, total sleep time: 10973222 us / 13077383 us
W (17215) wifi:<ba-del>idx
I (17215) wifi:new:<1,0>, old:<1,0>, ap:<255,255>, sta:<1,0>, prof:6
I (17225) esp_idf_svc::wifi: Disconnect requested
I (17225) wifi:flush txq
I (17235) wifi:stop sw txq
I (17235) wifi:lmac stop hw txq
I (17235) esp_idf_svc::wifi: Stop requested
I (17245) esp_idf_svc::wifi: About to wait for status
I (17245) esp_idf_svc::wifi: Got wifi event: StaDisconnected
I (17255) esp_idf_svc::wifi: STA event StaDisconnected handled, set status: Status(Started(Disconnected), Stopped)
I (17265) esp_idf_svc::wifi: Got wifi event: StaStopped
I (17265) esp_idf_svc::wifi: STA event StaStopped handled, set status: Status(Stopped, Stopped)
I (17275) esp_idf_svc::wifi: Waiting for status done - success
I (17285) esp_idf_svc::wifi: Stopped
I (17295) esp_idf_svc::wifi: Event handlers deregistered
I (17295) wifi:Deinit lldesc rx mblock:10
I (17305) esp_idf_svc::wifi: Driver deinitialized
I (17305) esp_idf_svc::wifi: Deinitialization complete
I (17315) esp_idf_svc::wifi: Dropped
I (17315) esp_idf_svc::eventloop: Dropped
I (17315) esp_idf_svc::netif: Dropped
E (17325) sphinx_key: CLIENT ERROR Unexpected Client Wifi status: Status(Started(Connected(Waiting)), Stopped)
I (17335) esp_idf_svc::nvs: Dropped
ESP-ROM:esp32c3-api1-20210207
Build:Feb  7 2021
rst:0x1 (POWERON),boot:0xc (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fcd6100,len:0x172c
load:0x403ce000 [_iram_bss_start:??:??],len:0x928
load:0x403d0000 [_iram_bss_start:??:??],len:0x2ce0
entry 0x403ce000 [_iram_bss_start:??:??]
I (30) boot: ESP-IDF v4.4-dev-2825-gb63ec47238 2nd stage bootloader
I (30) boot: compile time 12:10:40
I (30) boot: chip revision: 3
I (33) boot_comm: chip revision: 3, min. bootloader chip revision: 0
I (40) boot.esp32c3: SPI Speed      : 80MHz
I (45) boot.esp32c3: SPI Mode       : DIO
I (50) boot.esp32c3: SPI Flash Size : 4MB
I (55) boot: Enabling RNG early entropy source...
I (60) boot: Partition Table:
I (64) boot: ## Label            Usage          Type ST Offset   Length
I (71) boot:  0 nvs              WiFi data        01 02 00009000 00006000
I (78) boot:  1 phy_init         RF data          01 01 0000f000 00001000
I (86) boot:  2 factory          factory app      00 00 00010000 003f0000
I (93) boot: End of partition table
I (98) boot_comm: chip revision: 3, min. application chip revision: 0
I (105) esp_image: segment 0: paddr=00010020 vaddr=3c0d0020 size=38130h (229680) map
I (148) esp_image: segment 1: paddr=00048158 vaddr=3fc8da00 size=02ca8h ( 11432) load
I (150) esp_image: segment 2: paddr=0004ae08 vaddr=40380000 size=05210h ( 21008) load
I (157) esp_image: segment 3: paddr=00050020 vaddr=42000020 size=cd40ch (840716) map
I (288) esp_image: segment 4: paddr=0011d434 vaddr=40385210 size=08710h ( 34576) load
I (295) esp_image: segment 5: paddr=00125b4c vaddr=50000010 size=00010h (    16) load
I (299) boot: Loaded app from partition at offset 0x10000
I (300) boot: Disabling RNG early entropy source...
I (317) cpu_start: Pro cpu up.
I (325) cpu_start: Pro cpu start user code
I (325) cpu_start: cpu freq: 160000000
I (325) cpu_start: Application information:
I (328) cpu_start: Project name:     libespidf
I (333) cpu_start: App version:      1
I (338) cpu_start: Compile time:     May 23 2022 14:18:58
I (344) cpu_start: ELF file SHA256:  0000000000000000...
I (350) cpu_start: ESP-IDF:          c5deb7a
I (355) heap_init: Initializing. RAM available for dynamic allocation:
I (362) heap_init: At 3FC946B0 len 0002B950 (174 KiB): DRAM
I (368) heap_init: At 3FCC0000 len 0001F060 (124 KiB): STACK/DRAM
I (375) heap_init: At 50000020 len 00001FE0 (7 KiB): RTCRAM
I (382) spi_flash: detected chip: generic
I (386) spi_flash: flash io: dio
I (390) sleep: Configure to isolate all GPIO pins in sleep state
I (397) sleep: Enable automatic switching of GPIO sleep configuration
I (404) cpu_start: Starting scheduler.
hi from signer module!
=============> START CLIENT NOW <============== Config { broker: "52.91.253.115:1883", ssid: "Fios-Vq7Qy", pass: "maul39urea57sile" }
I (1430) pp: pp rom version: 9387209
I (1430) net80211: net80211 rom version: 9387209
I (1440) wifi:wifi driver task: 3fc9e5ec, prio:23, stack:6656, core=0
I (1440) system_api: Base MAC address is not set
I (1450) system_api: read default base MAC address from EFUSE
I (1460) wifi:wifi firmware version: 195d59c
I (1460) wifi:wifi certification version: v7.0
I (1460) wifi:config NVS flash: enabled
I (1460) wifi:config nano formating: disabled
I (1470) wifi:Init data frame dynamic rx buffer num: 32
I (1470) wifi:Init management frame dynamic rx buffer num: 32
I (1480) wifi:Init management short buffer num: 32
I (1480) wifi:Init dynamic tx buffer num: 32
I (1490) wifi:Init static tx FG buffer num: 2
I (1490) wifi:Init static rx buffer size: 1600
I (1490) wifi:Init static rx buffer num: 10
I (1500) wifi:Init dynamic rx buffer num: 32
I (1500) wifi_init: rx ba win: 6
I (1510) wifi_init: tcpip mbox: 32
I (1510) wifi_init: udp mbox: 6
I (1510) wifi_init: tcp mbox: 6
I (1520) wifi_init: tcp tx win: 5744
I (1520) wifi_init: tcp rx win: 5744
I (1530) wifi_init: tcp mss: 1440
I (1530) wifi_init: WiFi IRAM OP enabled
I (1540) wifi_init: WiFi RX IRAM OP enabled
I (1540) esp_idf_svc::wifi: Driver initialized
I (1550) esp_idf_svc::wifi: Event handlers registered
I (1550) esp_idf_svc::wifi: Initialization complete
I (1560) esp_idf_svc::wifi: About to scan for access points
I (1560) esp_idf_svc::wifi: Stopping
I (1570) esp_idf_svc::wifi: Disconnect requested
I (1570) esp_idf_svc::wifi: Stop requested
I (1580) esp_idf_svc::wifi: About to wait for status
I (1580) esp_idf_svc::wifi: Waiting for status done - success
I (1590) esp_idf_svc::wifi: Stopped
I (1590) phy_init: phy_version 909,aa05aec,Apr 16 2022,13:42:08
I (1690) wifi:mode : sta (84:f7:03:08:16:9c)
I (1690) wifi:enable tsf
I (1700) esp_idf_svc::wifi: Got wifi event: StaStarted
I (1700) esp_idf_svc::wifi: STA event StaStarted handled, set status: Status(Started(Disconnected), Stopped)
I (3750) esp_idf_svc::wifi: Got wifi event: ScanDone
I (3750) esp_idf_svc::wifi: STA event ScanDone skipped
I (3810) esp_idf_svc::wifi: Found 4 access points
I (3810) esp_idf_svc::wifi: About to get info for found access points
I (3810) esp_idf_svc::wifi: Got info for 4 access points
I (3810) esp_idf_svc::wifi: Found access point AccessPointInfo { ssid: "DIRECT-AjDD-G4010series", bssid: [54, 159, 123, 17, 162, 221], channel: 1, secondary_channel: None, signal_strength: 210, protocols: EnumSet(), auth_method: WPA2Personal }
I (3840) esp_idf_svc::wifi: Found access point AccessPointInfo { ssid: "Fios-Vq7Qy", bssid: [184, 248, 83, 10, 249, 78], channel: 1, secondary_channel: None, signal_strength: 184, protocols: EnumSet(), auth_method: WPA2Personal }
I (3860) esp_idf_svc::wifi: Found access point AccessPointInfo { ssid: "Wahoowa", bssid: [216, 7, 182, 111, 2, 126], channel: 9, secondary_channel: Below, signal_strength: 174, protocols: EnumSet(), auth_method: WPA2Personal }
I (3880) esp_idf_svc::wifi: Found access point AccessPointInfo { ssid: "Wahoowa", bssid: [216, 7, 182, 111, 2, 122], channel: 9, secondary_channel: Below, signal_strength: 173, protocols: EnumSet(), auth_method: WPA2Personal }
I (3900) sphinx_key::conn::wifi: Found configured access point Fios-Vq7Qy on channel 1
I (3910) esp_idf_svc::wifi: Setting configuration: Client(ClientConfiguration { ssid: "Fios-Vq7Qy", bssid: None, auth_method: WPA2Personal, password: "maul39urea57sile", channel: Some(1), ip_conf: Some(DHCP(DHCPClientSettings { hostname: None })) })
I (3930) esp_idf_svc::wifi: Stopping
I (3930) esp_idf_svc::wifi: Disconnect requested
I (3940) wifi:flush txq
I (3940) wifi:stop sw txq
I (3940) wifi:lmac stop hw txq
I (3950) esp_idf_svc::wifi: Stop requested
I (3950) esp_idf_svc::wifi: Got wifi event: StaStopped
I (3960) esp_idf_svc::wifi: STA event StaStopped handled, set status: Status(Stopped, Stopped)
I (3970) esp_idf_svc::wifi: Stopped
I (3970) esp_idf_svc::wifi: Wifi mode STA set
I (3980) esp_idf_svc::wifi: Setting STA configuration: ClientConfiguration { ssid: "Fios-Vq7Qy", bssid: None, auth_method: WPA2Personal, password: "maul39urea57sile", channel: Some(1), ip_conf: Some(DHCP(DHCPClientSettings { hostname: None })) }
I (4000) esp_idf_svc::wifi: Setting STA interface configuration: InterfaceConfiguration { key: "WIFI_STA_DEF", description: "sta", route_priority: 100, ip_configuration: Client(DHCP(DHCPClientSettings { hostname: None })), interface_stack: Sta }
I (4020) esp_idf_svc::wifi: STA IP configuration done
I (4030) esp_idf_svc::wifi: STA configuration done
I (4030) esp_idf_svc::wifi: Starting with status: Status(Starting, Stopped)
I (4040) esp_idf_svc::wifi: Status is of operating type, starting
I (4050) wifi:mode : sta (84:f7:03:08:16:9c)
I (4050) wifi:enable tsf
I (4050) esp_idf_svc::wifi: Start requested
I (4060) esp_idf_svc::wifi: STA netif status: EspNetif(EspNetifStack(PrivateData), 0x3fca3b54), index: 1, name: lo0, ifkey: WIFI_STA_DEF
I (4070) esp_idf_svc::wifi: AP netif is not allocated
I (4080) esp_idf_svc::wifi: Got wifi event: StaStarted
I (4080) esp_idf_svc::wifi: Reconnecting
I (4090) esp_idf_svc::wifi: STA event StaStarted handled, set status: Status(Started(Connecting), Stopped)
I (4090) wifi:new:<1,0>, old:<1,0>, ap:<255,255>, sta:<1,0>, prof:6
I (4100) wifi:state: init -> auth (b0)
I (4110) esp_idf_svc::wifi: Configuration set
I (4110) wifi:state: auth -> assoc (0)
I (4110) sphinx_key::conn::wifi: Wifi client configuration set, about to get status
I (4120) wifi:state: assoc -> run (10)
I (4130) esp_idf_svc::wifi: About to wait 20s for status
I (4150) wifi:connected with Fios-Vq7Qy, aid = 19, channel 1, BW20, bssid = b8:f8:53:0a:f9:4e
I (4150) wifi:security: WPA2-PSK, phy: bgn, rssi: -74
I (4160) wifi:pm start, type: 1
I (4160) wifi:set rx beacon pti, rx_bcn_pti: 0, bcn_timeout: 0, mt_pti: 25000, mt_time: 10000
I (4170) esp_idf_svc::wifi: Got wifi event: StaConnected
I (4170) esp_idf_svc::wifi: STA event StaConnected handled, set status: Status(Started(Connected(Waiting)), Stopped)
I (4170) wifi:BcnInt:102400, DTIM:3
W (4190) wifi:<ba-add>idx:0 (ifx:0, b8:f8:53:0a:f9:4e), tid:0, ssn:0, winSize:64
I (4920) esp_idf_svc::wifi: Got STA IP event: DhcpIpAssigned(DhcpIpAssignment { netif_handle: 0x3fca3b54, ip_settings: ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }, ip_changed: true })
I (4930) esp_idf_svc::wifi: STA IP event DhcpIpAssigned(DhcpIpAssignment { netif_handle: 0x3fca3b54, ip_settings: ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }, ip_changed: true }) handled, set status: Status(Started(Connected(Done(ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }))), Stopped)
I (4970) esp_netif_handlers: sta ip: 192.168.1.151, mask: 255.255.255.0, gw: 192.168.1.1
I (4980) esp_idf_svc::wifi: Waiting for status done - success
I (4990) esp_idf_svc::wifi: Providing status: Status(Started(Connected(Done(ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }))), Stopped)
=> wifi STATUS 1 Status(Started(Connected(Done(ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }))), Stopped)
I (5020) sphinx_key::conn::wifi: ...Wifi client configuration set, AGAIN get status
I (5030) esp_idf_svc::wifi: About to wait 20s for status
I (5040) esp_idf_svc::wifi: Waiting for status done - success
I (5040) esp_idf_svc::wifi: Providing status: Status(Started(Connected(Done(ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }))), Stopped)
=> wifi STATUS Status(Started(Connected(Done(ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }))), Stopped)
=> is transitional? false
I (5080) sphinx_key::conn::wifi: Wifi started!
I (5090) sphinx_key::conn::wifi: About to do some pings for ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }
I (5100) esp_idf_svc::ping: About to run a summary ping 192.168.1.1 with configuration Configuration { count: 5, interval: 1s, timeout: 1s, data_size: 56, tos: 0 }
I (5120) esp_idf_svc::ping: Ping session established, got handle 0x3fca4a48
I (5130) esp_idf_svc::ping: Ping session started
I (5130) esp_idf_svc::ping: Waiting for the ping session to complete
I (5140) esp_idf_svc::ping: Ping success callback invoked
I (5140) esp_idf_svc::ping: From 192.168.1.1 icmp_seq=1 ttl=64 time=9ms bytes=56
I (6130) esp_idf_svc::ping: Ping success callback invoked
I (6130) esp_idf_svc::ping: From 192.168.1.1 icmp_seq=2 ttl=64 time=2ms bytes=56
I (7130) esp_idf_svc::ping: Ping success callback invoked
I (7130) esp_idf_svc::ping: From 192.168.1.1 icmp_seq=3 ttl=64 time=2ms bytes=56
I (8130) esp_idf_svc::ping: Ping success callback invoked
I (8130) esp_idf_svc::ping: From 192.168.1.1 icmp_seq=4 ttl=64 time=1ms bytes=56
I (9130) esp_idf_svc::ping: Ping success callback invoked
I (9130) esp_idf_svc::ping: From 192.168.1.1 icmp_seq=5 ttl=64 time=1ms bytes=56
I (10130) esp_idf_svc::ping: Ping end callback invoked
I (10130) esp_idf_svc::ping: 5 packets transmitted, 5 received, time 15ms
I (10130) esp_idf_svc::ping: Ping session stopped
I (10130) esp_idf_svc::ping: Ping session 0x3fca4a48 removed
I (10140) sphinx_key::conn::wifi: Pinging done
I (10140) sphinx_key::conn::wifi: wifi::start_client Ok(())
I (10150) esp_idf_svc::wifi: Providing status: Status(Started(Connected(Done(ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }))), Stopped)
CLIENT CONNECTED!!!!!! Status(Started(Connected(Done(ClientSettings { ip: 192.168.1.151, subnet: Subnet { gateway: 192.168.1.1, mask: Mask(24) }, dns: None, secondary_dns: None }))), Stopped)
wait forever... 1
wait forever... 2
wait forever... 3