Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Keine Verbindung möglich "SERVER HELP: File sending failed!" #2746

Closed
baeriwiliwonka opened this issue Dec 17, 2023 · 2 comments
Closed

Keine Verbindung möglich "SERVER HELP: File sending failed!" #2746

baeriwiliwonka opened this issue Dec 17, 2023 · 2 comments
Labels
bug Something isn't working

Comments

@baeriwiliwonka
Copy link

The Problem

Hallo,
vorab: ich habe schon viele ESP32Cams mit Ai on the edge ausgestattet.
Meine letzte Sendung an ESPs funktioniert nun aber gar nicht.

Als PSRAM kommt folgender Chip zum Einsatz:
PSRAM64H / 512021 / 1C0028G

Mit exakt gleicher Firmware und SD-Karten-Daten habe ich schon ESPs mit anderen RAMs zum Laufen gebracht, daher schätze ich es hat evtl etwas damit zu tun. In der Dokumentation kann ich exakt diesen Typ nicht finden.

In seltenen Fällen lädt ein kleiner Teil des Webinterfaces, aber nie so weit, dass ich dort irgendetwas machen könnte.

Die Logs sehen anfangs eigentlich gut aus, irgendwann kommen aber folgende Fehlermeldungen:
E (262287) SERVER HELP: File sending failed! W (267287) httpd_txrx: httpd_sock_err: error in send : 11 W (267287) httpd_txrx: httpd_resp_send_err: 500 Internal Server Error - Failed to send file W (272287) httpd_txrx: httpd_sock_err: error in send : 11 W (277287) httpd_txrx: httpd_sock_err: error in send : 11 W (277287) httpd_uri: httpd_uri: uri handler execution failed

Der komplette Log ist unten angehängt.

Danke im Voraus!

Version

15.3.0

Logfile

rst:0x1 (POWERON_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:3396
load:0x40078000,len:15012
load:0x40080400,len:3104
entry 0x400805a0
I (743) quad_psram: This chip is ESP32-D0WD
I (743) esp_psram: Found 8MB PSRAM device
I (743) esp_psram: Speed: 40MHz
I (743) esp_psram: PSRAM initialized, cache is in low/high (2-core) mode.
W (749) esp_psram: Virtual address not enough for PSRAM, map as much as we can. 4MB is mapped
I (757) cpu_start: Pro cpu up.
I (759) cpu_start: Starting app cpu, entry point is 0x40082e48
I (0) cpu_start: App cpu up.
I (1653) esp_psram: SPI SRAM memory test OK
I (1662) cpu_start: Pro cpu start user code
I (1662) cpu_start: cpu freq: 160000000 Hz
I (1663) cpu_start: Application information:
I (1663) cpu_start: Project name:     AI-on-the-edge
I (1668) cpu_start: App version:      v15.3.0
I (1672) cpu_start: Compile time:     Jul 22 2023 09:43:02
I (1677) cpu_start: ELF file SHA256:  29d38f3fa1a9857c...
I (1682) cpu_start: ESP-IDF:          5.0.2
I (1686) cpu_start: Min chip rev:     v0.0
I (1690) cpu_start: Max chip rev:     v3.99 
I (1694) cpu_start: Chip rev:         v3.1
I (1698) heap_init: Initializing. RAM available for dynamic allocation:
I (1704) heap_init: At 3FFAE6E0 len 00001920 (6 KiB): DRAM
I (1709) heap_init: At 3FFBD890 len 00022770 (137 KiB): DRAM
I (1714) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM
I (1720) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
I (1726) heap_init: At 4009A554 len 00005AAC (22 KiB): IRAM
I (1731) esp_psram: Adding pool of 4083K of PSRAM memory to heap allocator
I (1739) spi_flash: detected chip: generic
I (1741) spi_flash: flash io: dio
I (1756) cpu_start: Starting scheduler on PRO CPU.
I (0) cpu_start: Starting scheduler on APP CPU.
I (1757) esp_psram: Reserving pool of 40K of internal memory for DMA/internal allocations
I (1757) MAIN: 

================ Start app_main =================
I (1847) MAIN: =================================================
I (1867) MAIN: ==================== Start ======================
I (1897) MAIN: =================================================
I (1917) MAIN: PSRAM size: 8388608 byte (8MB / 64MBit)
I (1937) MAIN: Total heap: 4376891 byte
I (1967) gpio: GPIO[32]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 
I (3967) gpio: GPIO[25]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:2 
I (3967) cam_hal: cam init ok
I (3967) sccb: pin_sda 26 pin_scl 27
I (3967) sccb: sccb_i2c_port=1


I (3967) gpio: GPIO[32]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 
I (4007) camera: Detected camera at address=0x30
I (4007) camera: Detected OV2640 camera
I (4007) camera: Camera PID=0x26 VER=0x42 MIDL=0x7f MIDH=0xa2
I (4097) cam_hal: buffer_size: 32768, half_buffer_size: 4096, node_buffer_size: 2048, node_cnt: 16, total_cnt: 15
I (4097) cam_hal: Allocating 61440 Byte frame buffer in PSRAM
I (4097) cam_hal: cam config ok
I (4097) ov2640: Set PLL: clk_2x: 0, clk_div: 0, pclk_auto: 0, pclk_div: 8
I (6177) MAIN: Camera info: PID: 0x26, VER: 0x42, MIDL: 0x7f, MIDH: 0xa2
I (6197) SDCARD: Basic R/W check started...
I (6257) SDCARD: Basic R/W check successful
I (6307) SNTP: TimeServer not defined, using default: pool.ntp.org
I (6337) SNTP: Configuring NTP Client...
I (6357) SNTP: Time zone set to CET-1CEST,M3.5.0,M10.5.0/3
I (6387) SNTP: The local time is unknown, starting with 1970-01-01 01:00:04
I (6407) SNTP: Once the NTP server provides a time, we will switch to that one
I (6447) MAIN: CPU frequency: 160 MHz
I (6467) OTA: Start CheckOTAUpdateCheck...
I (6477) OTA: SHA-256 for the partition table: : 9d4a2809ae90fb20709a8ca3dd3ac3462e1e73286bcd31b689060c91de06fa3a
I (6497) OTA: SHA-256 for bootloader: : abccbbdde2e069c1d4a7c5539aa334c16d99acfbd9f73cd082cb8791ccf77ce5
I (6977) OTA: SHA-256 for current firmware: : b64a22854eb1e33763bde88abf63d86bb137038b818f619734b7e59e5fc8e6b6
I (7017) SDCARD: Folder/file presence check started...
I (7057) SDCARD: Folder/file presence check successful
I (7097) MAIN: Tag: 'v15.3.0', Release: v15.3.0 (Commit: 3fbff0a), Date/Time: 2023-07-22 09:42, Web UI: Release: v15.3.0 (Commit: 3fbff0a)
I (7137) MAIN: Reset reason: Power-on event (or reset button)
I (7157) WLANINI: SSID: MyAccessPoint
I (7187) WLANINI: Password: XXXXXXXX
I (7207) WLANINI: Hostname: watermeter
I (7237) WLANINI: IP-Address: 192.168.20.92
I (7257) WLANINI: Gateway: 192.168.20.1
I (7277) WLANINI: Netmask: 255.255.255.0
I (7307) WLANINI: RSSIThreshold: 0
I (7327) MAIN: WLAN config loaded, init WIFI...
I (7357) WIFI: Manual interface config -> IP: 192.168.20.92, Gateway: 192.168.20.1, Netmask: 255.255.255.0
I (7387) wifi:wifi driver task: 3ffd10a0, prio:23, stack:6144, core=0
I (7387) system_api: Base MAC address is not set
I (7387) system_api: read default base MAC address from EFUSE
I (7397) wifi:wifi firmware version: 57982fe
I (7407) wifi:wifi certification version: v7.0
I (7407) wifi:config NVS flash: enabled
I (7407) wifi:config nano formating: enabled
I (7407) wifi:Init data frame dynamic rx buffer num: 16
I (7407) wifi:Init management frame dynamic rx buffer num: 16
I (7417) wifi:Init management short buffer num: 32
I (7427) wifi:Init static tx buffer num: 16
I (7427) wifi:Init tx cache buffer num: 16
I (7427) wifi:Init static rx buffer size: 1600
I (7437) wifi:Init static rx buffer num: 16
I (7437) wifi:Init dynamic rx buffer num: 16
I (7447) wifi_init: rx ba win: 16
I (7447) wifi_init: tcpip mbox: 32
I (7447) wifi_init: udp mbox: 6
I (7447) wifi_init: tcp mbox: 6
I (7457) wifi_init: tcp tx win: 5744
I (7457) wifi_init: tcp rx win: 5744
I (7457) wifi_init: tcp mss: 1440
I (7467) wifi_init: WiFi/LWIP prefer SPIRAM
I (7467) wifi_init: WiFi IRAM OP enabled
I (7467) wifi_init: WiFi RX IRAM OP enabled
I (7477) WIFI: No DNS server, use gateway
I (7527) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07
I (7617) wifi:mode : sta (a0:b7:65:50:c2:7c)
I (7617) wifi:enable tsf
I (7627) WIFI: Set hostname to: watermeter
I (7657) WIFI: Init successful
I (10037) wifi:new:<11,0>, old:<1,0>, ap:<255,255>, sta:<11,0>, prof:1
I (10757) wifi:state: init -> auth (b0)
I (10827) wifi:state: auth -> init (8a0)
I (10827) wifi:new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1
W (10837) WIFI: Disconnected (202, Auth fail)
W (13277) WIFI: Disconnected (205)
I (15707) wifi:new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1
I (15707) wifi:state: init -> auth (b0)
I (15857) wifi:state: auth -> assoc (0)
I (15897) wifi:state: assoc -> run (10)
I (16077) wifi:connected with MyAccessPoint, aid = 19, channel 11, BW20, bssid = 34:31:c4:fe:e8:24
I (16077) wifi:security: WPA2-PSK, phy: bgn, rssi: -78
I (16087) wifi:pm start, type: 1

I (16087) WIFI: Connected to: MyAccessPoint, RSSI: -78
I (16117) esp_netif_handlers: sta ip: 192.168.20.92, mask: 255.255.255.0, gw: 192.168.20.1
I (16117) WIFI: Assigned IP: 192.168.20.92
I (16577) wifi:AP's beacon interval = 102400 us, DTIM period = 1
I (20047) wifi:state: run -> init (2a0)
I (20047) wifi:pm stop, total sleep time: lu us / lu us

I (20047) wifi:new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1
W (20047) WIFI: Disconnected (2, Auth fail)
I (22487) wifi:new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1
I (22497) wifi:state: init -> auth (b0)
I (22507) wifi:state: auth -> assoc (0)
I (22607) wifi:state: assoc -> run (10)
I (22907) wifi:connected with MyAccessPoint, aid = 19, channel 11, BW20, bssid = 34:31:c4:fe:e8:24
I (22907) wifi:security: WPA2-PSK, phy: bgn, rssi: -82
I (22917) wifi:pm start, type: 1

I (22917) WIFI: Connected to: MyAccessPoint, RSSI: -82
I (22937) esp_netif_handlers: sta ip: 192.168.20.92, mask: 255.255.255.0, gw: 192.168.20.1
I (22937) WIFI: Assigned IP: 192.168.20.92
I (23137) wifi:AP's beacon interval = 102400 us, DTIM period = 1
I (26807) wifi:<ba-add>idx:0 (ifx:0, 34:31:c4:fe:e8:24), tid:0, ssn:0, winSize:64
I (27677) MAIN: Device info: CPU cores: 2, Chip revision: 301
I (27697) MAIN: SD card info: Name: , Capacity: 3840MB, Free: 3831MB
I (29707) MAIN SERVER: Starting server on port: '80'
I (29707) MAIN SERVER: Registering URI handlers
I (29707) MAINCTRL: server_main_flow_task - Registering URI handlers
I (29707) OTA: Registering URI handlers
I (29707) GPIO: start GpioHandler
I (29717) GPIO: register GPIO Uri
I (29717) GPIO: server_GPIO - Registering URI handlers
I (29727) MAIN: Initialization completed successfully
I (29757) ov2640: Set PLL: clk_2x: 0, clk_div: 0, pclk_auto: 0, pclk_div: 8
E (31327) TFLITE: Model file doesn't exist: /sdcard/config/dig-cont_0600_s3.tflite!
E (31367) CNN: Can't load tflite model /config/dig-cont_0600_s3.tflite -> Init aborted!
E (31387) CNN: An error occured on setting up the Network -> Disabling it!
E (31417) TFLITE: Model file doesn't exist: /sdcard/config/ana-cont_11.3.1_s2.tflite!
E (31447) CNN: Can't load tflite model /config/ana-cont_11.3.1_s2.tflite -> Init aborted!
E (31467) CNN: An error occured on setting up the Network -> Disabling it!
I (31527) LOGFILE: Set log level to ERROR
I (31547) GPIO: read GPIO config and init GPIO
I (31557) GPIO: Enable GPIO12 in external-flash-ws281x mode
I (31557) gpio: GPIO[12]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0 
I (31567) GPIO: GPIO init completed, is enabled
I (31567) MAINCTRL: We are in Setup Mode -> Not starting Auto Flow!
I (33097) GPIO: init SmartLed: LEDNumber=1, GPIO=12
I (41027) MAINCTRL: Autostart is not enabled -> Not starting Flow
W (88687) httpd_txrx: httpd_sock_err: error in send : 11
E (88687) SERVER HELP: File sending failed!
W (89987) httpd_txrx: httpd_resp_send_err: 500 Internal Server Error - Failed to send file
W (89987) httpd_uri: httpd_uri: uri handler execution failed
W (100687) httpd_txrx: httpd_sock_err: error in send : 11
E (100687) SERVER HELP: File sending failed!
W (105687) httpd_txrx: httpd_sock_err: error in send : 11
W (105687) httpd_txrx: httpd_resp_send_err: 500 Internal Server Error - Failed to send file
W (110687) httpd_txrx: httpd_sock_err: error in send : 11
I (113897) SNTP: =================================================
I (113897) SNTP: ==================== Start ======================
I (113897) SNTP: == Logs before time sync -> log_1970-01-01.txt ==
I (113897) SNTP: Time is synced with NTP Server pool.ntp.org: 2023-12-17 12:03:46
W (115687) httpd_txrx: httpd_sock_err: error in send : 11
W (115687) httpd_uri: httpd_uri: uri handler execution failed

Expected Behavior

Zugriff auf Webinterface sollte möglich sein

Screenshots

No response

Additional Context

No response
@baeriwiliwonka baeriwiliwonka added the bug Something isn't working label Dec 17, 2023
@Slider0007
Copy link
Collaborator

Slider0007 commented Dec 17, 2023 •
edited
Loading

Dies liegt mit großer Sicherheit an der Hardware, entweder Netzteil zu schwach, Toleranz Antennendesign (zum Test Finger auf die Platine beim Stecker zur Kamera (auf die kleinen Widerstände etc) verbessert den Nerzwerkdurchsatz/Reaktionszeit bzw. #2609 (comment) bzw. Test alternativer WLAN Kanal) oder an der SD Karte. Hierzu gibt es vermehrt bei den Rev03 Boards Probleme -> siehe diverse Diskussionen

@baeriwiliwonka
Copy link
Author

Problem "gelöst" - mit einem mobilen Hotspot hat alles geklappt, es muss also irgendwo an meiner FritzBox klemmen.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug Something isn't working
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@baeriwiliwonka @Slider0007