jomjol / AI-on-the-edge-device

Easy to use device for connecting "old" measuring units (water, power, gas, ...) to the digital world
https://jomjol.github.io/AI-on-the-edge-device-docs/
5.67k stars 612 forks source link

Kamera funktioniert nicht mehr nach Update auf v10.2.0 #579

Closed ThomasCr closed 2 years ago

ThomasCr commented 2 years ago

Hi,

heute dachte ich, oh machst du mal wieder ein Update auf die aktuellste Version. Also alles wie gehabt über OTA hochgeladen und aktualisiert (Firmware und html natürlich). Alles wurde vom Webinterface als erfolgreich bestätigt.

Dann nach dem reboot kein Bild mehr (davor war es noch da). Im Logfile stand kein Fehler bzgl. Camera.... dachte versuch nochmal ein Neustart.... aber auch nach dem nichts.

Dann hab ich zur Sicherheit nochmal das OTA mit den gleichen Daten durchgeführt... selbes Problem. Es kommt kein Bild mehr.

grafik

Also habe ich die Version 10.1.0 heruntergeladen und installiert, da funktioniert die Kamera noch.

grafik

friedpa commented 2 years ago

Bei mir war genau das selbe Problem, da hilft leider derzeit nur auf die vorherige Version zurückzugehen.

muevol commented 2 years ago

Hi,

habt ihr auch die Änderungen bzgl. 10.2.0 durchgeführt ?

ATTENTION: Due to the update camera driver, the image looks different and a new setup might be needed

Update reference image
Update Alignment marks
ThomasCr commented 2 years ago

Naja, es kommt ja gar kein Bild mehr...

Oder ist das normal... also tut er nichts Ausgeben, weil das Referenz Bild nicht mehr passt?

friedpa commented 2 years ago

Ich komme ja gar nicht soweit, da der ESP ständig rebooted und nicht mehr ereichbar ist.

ThomasCr commented 2 years ago

Ein reboot Problem hab ich nicht... Aber es kommt halt kein Bild auf Overview und unter Recognition

Und im Logfile hab ich nochmal rein geschaut, da Stand aber nichts außer der üblichen Start und Timezone Meldung.

Weiter hab ich nicht geschaut gehabt....

tunip commented 2 years ago

Habe das gleiche Problem mit der 10.2.0 auf meinem Wasserzähler (bei "Take Image" erfolgt der Reboot). Hier kommt dann hin und wieder diese Meldung im Log: Camera is not working anymore - most propably hardware problem (instablility, ...). System will reboot. Zurück auf die 9.2.0 und alles funktioniert wieder wie gewohnt stabil.

Auf dem Gaszähler funktioniert zwar die Kamera mit 10.2.0. Allerdings hört dieser nach ein paar Tagen auf Daten zu senden. Auch hier, zurück auf 9.2.0 und es läuft wieder stabil (auch nach Tagen).

tschuchort commented 2 years ago

Mein Feedback: Habe gestern 3x AIOE mit 10.2.0 geupdatet, keine Probleme mit Kamera. Heute: 1x AIOE für die Wasseruhr neu gebaut, Kamera geht mit 10.2.0 nicht, 10.1.0 per OTA - Kamera geht. Keine Ahnung was da los ist.

ThomasCr commented 2 years ago

Interessant: Ich dachte ich installiere nochmal die neue Version um ein Debug.log zu erstellen. Also Firmware und HTML aktualisiert und noch vor dem Reboot das Debug.log in der ini aktiviert.

Nach dem Reboot hatte ich wieder ein Bild.

2022-01-17T15:26:03: =============================================================================================
2022-01-17T15:26:03: =================================== Main Started ============================================
2022-01-17T15:26:03: =============================================================================================
2022-01-17T15:26:09: Time zone set to CET-1CEST,M3.5.0,M10.5.0/3
2022-01-17T15:26:11: task_autodoFlow - next round - Round #1
2022-01-17T15:26:11:    FlowControll.doFlow - ClassFlowMakeImage
2022-01-17T15:26:19:    FlowControll.doFlow - ClassFlowAlignment
2022-01-17T15:26:37: download_get_handler
2022-01-17T15:26:41: info_get_handler
2022-01-17T15:26:46:    FlowControll.doFlow - ClassFlowCNNGeneral
2022-01-17T15:26:49: info_get_handler
2022-01-17T15:26:49: info_get_handler
2022-01-17T15:26:49: info_get_handler
2022-01-17T15:26:49: info_get_handler
2022-01-17T15:26:49: info_get_handler
2022-01-17T15:26:49: info_get_handler
2022-01-17T15:26:49: info_get_handler
2022-01-17T15:26:49: info_get_handler
2022-01-17T15:27:01:    FlowControll.doFlow - ClassFlowCNNGeneral
2022-01-17T15:27:10:    FlowControll.doFlow - ClassFlowPostProcessing
2022-01-17T15:27:10: PostProcessing - Raw: 02729.2434 Value: 2729.2434 Error: no error
2022-01-17T15:27:10:    FlowControll.doFlow - ClassFlowMQTT
2022-01-17T15:27:10: sent publish successful in MQTTPublish, msg_id=42762, wm2/connection, connected
2022-01-17T15:27:10: sent publish successful in MQTTPublish, msg_id=47439, wm2/uptime, 67
2022-01-17T15:27:10: sent publish successful in MQTTPublish, msg_id=29104, wm2/freeMem, 3073143
2022-01-17T15:27:10: sent publish successful in MQTTPublish, msg_id=6927, wm2/main/value, 2729.2434
2022-01-17T15:27:10: sent publish successful in MQTTPublish, msg_id=15625, wm2/main/error, no error
2022-01-17T15:27:10: sent publish successful in MQTTPublish, msg_id=52150, wm2/main/rate, 0.000000
2022-01-17T15:27:10: sent publish successful in MQTTPublish, msg_id=50549, wm2/main/raw, 02729.2434
2022-01-17T15:27:10: sent publish successful in MQTTPublish, msg_id=58512, wm2/main/timestamp, 2022-01-17T15:26:19
2022-01-17T15:27:10: sent publish successful in MQTTPublish, msg_id=43873, wm2/main/json, {"value":2729.2434,"raw":"02729.2434","error":"no error","rate":0.000000,"timestamp":"2022-01-17T15:26:19"}
2022-01-17T15:27:10: task_autodoFlow - round done
2022-01-17T15:27:10: CPU Temperature: 60.0
2022-01-17T15:28:24: download_get_handler

Also wieder in der ini das debug logfile auf false und neu gestartet und das Teil läuft immer noch.

Wirklich merkwürdig. Ich lasse es jetzt mal mit Debug.log an und bleibe auf der Version... mal sehen was sich ergibt.

ThomasCr commented 2 years ago

Jetzt wird es ganz merkwürdig. Ich wollte ja das Log aktivieren. Dazu wieder die Einstellung angepasst (über das Webgui), Neustart....

Und die Kamera wieder nicht mehr da.... also wollte ich die Daten aus dem Logfile bereitstellen, was aber auch nicht geht, da diesmal nichts rein Protokolliert wurde. Also nochmal debug geprüft, ist aber an, nochmal neustart.... Keine Kamera und kein Log......

Eben auch nochmal in die ini Direkt geschaut:

[Debug]
Logfile = true
LogfileRetentionInDays = 3
2022-01-17T15:27:10: sent publish successful in MQTTPublish, msg_id=43873, wm2/main/json, {"value":2729.2434,"raw":"02729.2434","error":"no error","rate":0.000000,"timestamp":"2022-01-17T15:26:19"}
2022-01-17T15:27:10: task_autodoFlow - round done
2022-01-17T15:27:10: CPU Temperature: 60.0
2022-01-17T15:28:24: download_get_handler
2022-01-17T15:28:28: download_get_handler
2022-01-17T15:29:20: download_get_handler
2022-01-17T15:29:28: delete_post_handler
2022-01-17T15:29:28: download_get_handler
2022-01-17T15:29:28: upload_post_handler
2022-01-17T15:29:28: download_get_handler
2022-01-17T15:29:34: handler_reboot
2022-01-17T15:29:34: Reboot in 5sec
2022-01-17T15:29:48: Time zone set to CET-1CEST,M3.5.0,M10.5.0/3
2022-01-17T15:29:48: =============================================================================================
2022-01-17T15:29:48: =================================== Main Started ============================================
2022-01-17T15:29:48: =============================================================================================
2022-01-17T15:45:42: Time zone set to CET-1CEST,M3.5.0,M10.5.0/3
2022-01-17T15:45:42: =============================================================================================
2022-01-17T15:45:42: =================================== Main Started ============================================
2022-01-17T15:45:42: =============================================================================================
2022-01-17T15:48:16: Time zone set to CET-1CEST,M3.5.0,M10.5.0/3
2022-01-17T15:48:16: =============================================================================================
2022-01-17T15:48:16: =================================== Main Started ============================================
2022-01-17T15:48:16: =============================================================================================
2022-01-17T15:49:41: Time zone set to CET-1CEST,M3.5.0,M10.5.0/3
2022-01-17T15:49:41: =============================================================================================
2022-01-17T15:49:41: =================================== Main Started ============================================
2022-01-17T15:49:41: =============================================================================================
ThomasCr commented 2 years ago

So, ich habe mal noch einen weiteren ESP32 geflasht... der lief auch nicht mit aktueller Version. Dann hab ich die alte drauf gemacht, da lief die Kamera. Da ich das dann auch gleich mit dem Serial Debugging austesten wollte, hier mal das log von der Version 10.1.0.

Da scheint es schon zu krachen...

handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=raw
TYPE: raw
ZW: main
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=value
TYPE: value
ZW: main        42.0134
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=prevalue
TYPE: prevalue
ZW: main        PreValue too old
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=error
TYPE: error
ZW: main
uri: /img_tmp/alg_roi.jpg
1 uri: /img_tmp/alg_roi.jpg, filename: alg_roi.jpg, filepath: /sdcardalg_roi.jpg
File to upload: alg_roi.jpg
ClassFlowControll::GetJPGStream alg_roi.jpg
I (43278) flow_controll: Sending file : alg_roi.jpg ...
E (43628) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (43628) task_wdt:  - IDLE (CPU 0)
E (43628) task_wdt: Tasks currently running:
E (43628) task_wdt: CPU 0: task_autodoFlow
E (43628) task_wdt: CPU 1: httpd
E (43628) task_wdt: Print CPU 0 (current core) backtrace

Backtrace:0x400E8C64:0x3FFB0990 0x40083CBD:0x3FFB09B0 0x4006359E:0x3FFFEB40 0x40192623:0x3FFFEB60 0x40191FC2:0x3FFFEC10 0x4018F36D:0x3FFFEC90 0x4018A1BC:0x3FFFED20 0x400FE0B1:0x3FFFEDE0 0x400FE357:0x3FFFEE30

E (43628) task_wdt: Print CPU 1 backtrace

Backtrace:0x40088119:0x3FFB0F90 0x40083CBD:0x3FFB0FB0 0x400F2970:0x3FFEB1B0 0x400F4AB9:0x3FFEB310 0x400F4E79:0x3FFEC420 0x400FD4DD:0x3FFEC440 0x400F187E:0x3FFEC470 0x4018AA83:0x3FFEC8B0 0x400FDFCB:0x3FFEC900 0x400D58CE:0x3FFEC940 0x400EAA39:0x3FFEC9D0 0x400E9D60:0x3FFECA10 0x400EA126:0x3FFECAC0 0x400E9274:0x3FFECAE0

I (44268) flow_controll: File sending complete
E (48628) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (48628) task_wdt:  - IDLE (CPU 0)
E (48628) task_wdt: Tasks currently running:
E (48628) task_wdt: CPU 0: task_autodoFlow
E (48628) task_wdt: CPU 1: IDLE
E (48628) task_wdt: Print CPU 0 (current core) backtrace

Backtrace:0x400E8C64:0x3FFB0990 0x40083CBD:0x3FFB09B0 0x40192995:0x3FFFEBD0 0x401920D1:0x3FFFEC10 0x4018F36D:0x3FFFEC90 0x4018A1BC:0x3FFFED20 0x400FE0B1:0x3FFFEDE0 0x400FE357:0x3FFFEE30

E (48628) task_wdt: Print CPU 1 backtrace

Backtrace:0x40088119:0x3FFB0F90 0x40083CBD:0x3FFB0FB0 0x4000BFED:0x3FFC4AB0 0x40092E55:0x3FFC4AC0 0x400E8E83:0x3FFC4AE0 0x400E8E8F:0x3FFC4B10 0x400E8EB6:0x3FFC4B30 0x40090EB8:0x3FFC4B50

Alignment: dx -20 - dy -17 - rot 4.483302
2022-01-17T16:27:57
General 0 - Align&Cut
General 1 - Align&Cut
General 2 - Align&Cut
/sdcard/config/dig1330s1q.tflite
open file /sdcard/config/dig1330s1q.tflite in mode rb
TFlite-Type set to Digital
General 0 - TfLite
Result General(Digit)0: 10
General 1 - TfLite
E (55968) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (55968) task_wdt:  - IDLE (CPU 0)
E (55968) task_wdt: Tasks currently running:
E (55968) task_wdt: CPU 0: task_autodoFlow
E (55968) task_wdt: CPU 1: IDLE
E (55968) task_wdt: Print CPU 0 (current core) backtrace

Backtrace:0x400E8C64:0x3FFB0990 0x40083CBD:0x3FFB09B0 0x401AC05D:0x3FFFE830 0x401D8A8F:0x3FFFEB20 0x4019689B:0x3FFFEB50 0x40192CD3:0x3FFFEB70 0x40192D96:0x3FFFEB90 0x401904C5:0x3FFFEBB0 0x401908CF:0x3FFFECC0 0x40190BC9:0x3FFFECE0 0x4018A1BC:0x3FFFED20 0x400FE0B1:0x3FFFEDE0 0x400FE357:0x3FFFEE30

E (55968) task_wdt: Print CPU 1 backtrace

Backtrace:0x40088119:0x3FFB0F90 0x40083CBD:0x3FFB0FB0 0x4000BFED:0x3FFC4AB0 0x40092E55:0x3FFC4AC0 0x400E8E83:0x3FFC4AE0 0x400E8E8F:0x3FFC4B10 0x400E8EB6:0x3FFC4B30 0x40090EB8:0x3FFC4B50

Result General(Digit)1: 10
General 2 - TfLite
Result General(Digit)2: 10
General 0 - Align&Cut
General 1 - Align&Cut
General 2 - Align&Cut
General 3 - Align&Cut
/sdcard/config/ana0910s3_longq.tflite
open file /sdcard/config/ana0910s3_longq.tflite in mode rb
TFlite-Type set to Analogue
General 0 - TfLite
Result General(Analog)0: 2.401881
General 1 - TfLite
Result General(Analog)1: 2.255367
General 2 - TfLite
E (64388) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (64388) task_wdt:  - IDLE (CPU 0)
E (64388) task_wdt: Tasks currently running:
E (64388) task_wdt: CPU 0: task_autodoFlow
E (64388) task_wdt: CPU 1: IDLE
E (64388) task_wdt: Print CPU 0 (current core) backtrace

Backtrace:0x400E8C64:0x3FFB0990 0x40083CBD:0x3FFB09B0 0x401ABDE7:0x3FFFE850 0x401D8A8F:0x3FFFEB40 0x4019689B:0x3FFFEB70 0x40192CD3:0x3FFFEB90 0x40190363:0x3FFFEBB0 0x401908CF:0x3FFFECC0 0x40190BC9:0x3FFFECE0 0x4018A1BC:0x3FFFED20 0x400FE0B1:0x3FFFEDE0 0x400FE357:0x3FFFEE30

E (64388) task_wdt: Print CPU 1 backtrace

Backtrace:0x40088119:0x3FFB0F90 0x40083CBD:0x3FFB0FB0 0x4000BFED:0x3FFC4AB0 0x40092E55:0x3FFC4AC0 0x400E8E83:0x3FFC4AE0 0x400E8E8F:0x3FFC4B10 0x400E8EB6:0x3FFC4B30 0x40090EB8:0x3FFC4B50

Result General(Analog)2: 4.330493
General 3 - TfLite
Result General(Analog)3: 2.500000
Anzahl NUMBERS: 1
UpdateNachkommaDecShift NUMBER0: Nachkomma 4, DecShift 0
I (67798) log: 0 older log files deleted. 2 current log files not deleted.
CPU Temperature: 53.33
Autoflow: sleep for : 24604ms

Dann spiel ich jetzt nochmal die 10.2.0 drauf.....

Duese123 commented 2 years ago

Bei mir das gleiche Problem. Hab auch komplett neu geflasht nicht nur OTA manchmal gehts manchmal nicht es hilft manchmal die Qualität etwas rauf zu setzen z.B. auf den Wert 5 und nach dem neustart nicht so oft den Server requesten. Bei mir lief es so einige Zeit dann wollte ich neu Alignen dann kam auch kein Bild mehr beim Abruf kommt einfach kein Bild mehr

ThomasCr commented 2 years ago

Nach dem Update auf 10.2.0 läuft die Cam mal wieder (vorher nicht).... Hier aber die gleichen Backtraces:

rst:0xc (SW_CPU_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:4
load:0x3fff0034,len:7248
ho 0 tail 12 room 4
load:0x40078000,len:13856
load:0x40080400,len:4052
entry 0x40080688
I (31) boot: ESP-IDF 3.40100.200827 2nd stage bootloader
I (31) boot: compile time 21:55:31
I (31) boot: chip revision: 1
I (34) boot_comm: chip revision: 1, min. bootloader chip revision: 0
I (41) boot.esp32: SPI Speed      : 40MHz
I (46) boot.esp32: SPI Mode       : DIO
I (51) boot.esp32: SPI Flash Size : 4MB
I (55) boot: Enabling RNG early entropy source...
I (61) boot: Partition Table:
I (64) boot: ## Label            Usage          Type ST Offset   Length
I (71) boot:  0 nvs              WiFi data        01 02 00009000 00004000
I (79) boot:  1 otadata          OTA data         01 00 0000d000 00002000
I (86) boot:  2 phy_init         RF data          01 01 0000f000 00001000
I (94) boot:  3 ota_0            OTA app          00 10 00010000 001db000
I (101) boot:  4 ota_1            OTA app          00 11 001f0000 001db000
I (109) boot: End of partition table
I (113) boot_comm: chip revision: 1, min. application chip revision: 0
I (120) esp_image: segment 0: paddr=0x00010020 vaddr=0x3f400020 size=0x49038 (299064) map
I (259) esp_image: segment 1: paddr=0x00059060 vaddr=0x3ffb0000 size=0x04984 ( 18820) load
I (268) esp_image: segment 2: paddr=0x0005d9ec vaddr=0x40080000 size=0x0262c (  9772) load
I (273) esp_image: segment 3: paddr=0x00060020 vaddr=0x400d0020 size=0x13a1b4 (1286580) map
I (833) esp_image: segment 4: paddr=0x0019a1dc vaddr=0x4008262c size=0x19200 (102912) load
I (884) esp_image: segment 5: paddr=0x001b33e4 vaddr=0x50000000 size=0x00010 (    16) load
I (900) boot: Loaded app from partition at offset 0x10000
I (900) boot: Disabling RNG early entropy source...
I (901) psram: This chip is ESP32-D0WD
I (905) spiram: Found 64MBit SPI RAM device
I (910) spiram: SPI RAM mode: flash 40m sram 40m
I (915) spiram: PSRAM initialized, cache is in low/high (2-core) mode.
I (922) cpu_start: Pro cpu up.
I (926) cpu_start: Starting app cpu, entry point is 0x40082910
I (917) cpu_start: App cpu up.
I (1820) spiram: SPI SRAM memory test OK
I (1828) cpu_start: Pro cpu start user code
I (1828) cpu_start: cpu freq: 160000000
I (1828) cpu_start: Application information:
I (1831) cpu_start: Project name:     esp32cam-server-only
I (1837) cpu_start: App version:      0.0.9.3
I (1842) cpu_start: Compile time:     Jan 14 2022 20:30:04
I (1849) cpu_start: ELF file SHA256:  b04120accc0780f7...
I (1855) cpu_start: ESP-IDF:          4.3.1
I (1860) heap_init: Initializing. RAM available for dynamic allocation:
I (1867) heap_init: At 3FFAE6E0 len 00001920 (6 KiB): DRAM
I (1873) heap_init: At 3FFC0510 len 0001FAF0 (126 KiB): DRAM
I (1879) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM
I (1886) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
I (1892) heap_init: At 4009B82C len 000047D4 (17 KiB): IRAM
I (1899) spiram: Adding pool of 4096K of external SPI memory to heap allocator
I (1908) spi_flash: detected chip: generic
I (1911) spi_flash: flash io: dio
I (1921) cpu_start: Starting scheduler on PRO CPU.
I (0) cpu_start: Starting scheduler on APP CPU.
I (1926) spiram: Reserving pool of 32K of internal memory for DMA/internal allocations
I (1976) main: Using SDMMC peripheral
Name: SD
Type: SDHC/SDXC
Speed: 20 MHz
Size: 7618MB
I (2026) server_ota: Start CheckOTAUpdateCheck ...
Start CheckOTAUpdateCheck ...
I (2036) server_ota: SHA-256 for the partition table: : 9d4a2809ae90fb20709a8ca3dd3ac3462e1e73286bcd31b689060c91de06fa3a
I (2036) server_ota: SHA-256 for bootloader: : fcdaa822cbfd3931bcf8b49d91f2b86a98b93513bdbadb110eecd54f32d13c55
I (2056) server_ota: SHA-256 for current firmware: : 53471952973179c9007c1579a8c95d3d72f00ae63b2e63a292afe56037f09ad3
CheckOTAUpdate Partition: ESP_OK
open file /sdcard/wlan.ini in mode r
file loaded

WLan: XXXX, XXXXXXXXXXXXX
Hostename: wm1
I (2116) wifi:wifi driver task: 3ffd26b0, prio:23, stack:6656, core=0
I (2116) system_api: Base MAC address is not set
I (2116) system_api: read default base MAC address from EFUSE
I (2136) wifi:wifi firmware version: 88c8747
I (2136) wifi:wifi certification version: v7.0
I (2136) wifi:config NVS flash: enabled
I (2136) wifi:config nano formating: disabled
I (2146) wifi:Init data frame dynamic rx buffer num: 16
I (2146) wifi:Init management frame dynamic rx buffer num: 16
I (2156) wifi:Init management short buffer num: 32
I (2156) wifi:Init static tx buffer num: 16
I (2166) wifi:Init tx cache buffer num: 16
I (2166) wifi:Init static rx buffer size: 1600
I (2166) wifi:Init static rx buffer num: 10
I (2176) wifi:Init dynamic rx buffer num: 16
I (2176) wifi_init: rx ba win: 6
I (2186) wifi_init: tcpip mbox: 32
I (2186) wifi_init: udp mbox: 6
I (2186) wifi_init: tcp mbox: 6
I (2196) wifi_init: tcp tx win: 5744
I (2196) wifi_init: tcp rx win: 5744
I (2206) wifi_init: tcp mss: 1440
I (2206) wifi_init: WiFi IRAM OP enabled
I (2206) wifi_init: WiFi RX IRAM OP enabled
I (2216) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07
I (2326) wifi:mode : sta (XX:XX:bd:61:1c:30)
I (2326) wifi:enable tsf
I (2326) BLINK: Blinken - start
E (2326) wifi station: Set Hostname to:wm1
I (2326) wifi station: wifi_init_sta finished.
I (2336) wifi:new:<1,1>, old:<1,0>, ap:<255,255>, sta:<1,1>, prof:1
I (2346) wifi:state: init -> auth (b0)
I (2356) wifi:state: auth -> assoc (0)
I (2366) wifi:state: assoc -> run (10)
I (2376) wifi:connected with XXXX, aid = 2, channel 1, 40U, bssid = XX:XX:4a:9a:88:bf
I (2376) wifi:security: WPA2-PSK, phy: bgn, rssi: -87
I (2386) wifi:pm start, type: 1

I (2406) wifi:AP's beacon interval = 102400 us, DTIM period = 2
I (2526) BLINK: Blinken - done
I (3096) esp_netif_handlers: sta ip: 192.168.99.94, mask: 255.255.255.0, gw: 192.168.99.1
I (3096) wifi station: got ip:192.168.99.94
I (3096) BLINK: Blinken - start
I (3096) wifi station: connected to ap SSID:XXXX password:XXXXXXXXXXXXX
main: sleep for : 200ms
W (3336) wifi:<ba-add>idx:0 (ifx:0, XX:XX:4a:9a:88:bf), tid:0, ssn:0, winSize:64
I (5116) sntp: Time is not set yet. Connecting to WiFi and getting time over NTP.
I (5116) sntp: Initializing SNTP
I (5116) sntp: Waiting for system time to be set... (1/10)
I (7116) sntp: Waiting for system time to be set... (2/10)
I (9116) sntp: Waiting for system time to be set... (3/10)
TimeZone set to CET-1CEST,M3.5.0,M10.5.0/3
Logfile opened: /sdcard/log/message/log_2022-01-17.txt
I (11126) sntp: The current date/time in Berlin is: Mon Jan 17 16:54:05 2022
I (11126) sntp: The current date/time in Berlin is: 2022-01-17_16:54
timeist 20220117-165405
Logfile opened: /sdcard/log/message/log_2022-01-17.txt
Logfile opened: /sdcard/log/message/log_2022-01-17.txt
Logfile opened: /sdcard/log/message/log_2022-01-17.txt
time 20220117-165405
main: sleep for : 200ms
I (13106) BLINK: Blinken - done
I (13196) server-main: Starting server on port: '80'
I (13196) server-main: Registering URI handlers
I (13196) server_tflite: server_part_camera - Registering URI handlers
I (13196) server_ota: server_ota - Registering URI handlers
I (13206) server_GPIO: start GpioHandler
I (13206) server_GPIO: register GPIO Uri
I (13216) server_GPIO: server_GPIO - Registering URI handlers
vor reg server main
vor dotautostart
Do Reset Camera
I (13226) gpio: GPIO[32]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0
Init Camera
I (15236) gpio: GPIO[25]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:2
I (15236) cam_hal: cam init ok
I (15236) sccb: pin_sda 26 pin_scl 27
I (15236) gpio: GPIO[32]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0
I (15276) camera: Detected camera at address=0x30
I (15276) camera: Detected OV2640 camera
I (15276) camera: Camera PID=0x26 VER=0x42 MIDL=0x7f MIDH=0xa2
I (15366) cam_hal: buffer_size: 32768, half_buffer_size: 4096, node_buffer_size: 2048, node_cnt: 16, total_cnt: 15
I (15366) cam_hal: Allocating 61440 Byte frame buffer in PSRAM
I (15366) cam_hal: cam config ok
I (15376) ov2640: Set PLL: clk_2x: 0, clk_div: 0, pclk_auto: 0, pclk_div: 8
task_autodoFlow configMINIMAL_STACK_SIZE: 768
getESPHeapInfo:  Heap: 4155262 Min Free: 4143946 larg. Block:  2097152 SPI Heap: 4103731 NOT_SPI Heap: 51531 Internal Heap: 51531 Internal Min Heap free: 40215
task_autodoFlow: start
getESPHeapInfo:  Heap: 4118054 Min Free: 4113866 larg. Block:  2097152 SPI Heap: 4103731 NOT_SPI Heap: 14323 Internal Heap: 14323 Internal Min Heap free: 10135
open file /sdcard/config/config.ini in mode r
[MakeImage]
Start ReadParameter ([MakeImage]
)
;LogImageLocation = /log/source
WaitBeforeTakingPicture = 5
;LogfileRetentionInDays = 15
Brightness = -2
;Contrast = 0
;Saturation = 0
ImageQuality = 5
ImageSize = VGA
FixedExposure = false

[Alignment]
I (15596) ov2640: Set PLL: clk_2x: 0, clk_div: 0, pclk_auto: 0, pclk_div: 8
Start ReadParameter ([Alignment])
InitialRotate = 179
InitialMirror = false
SearchFieldX = 20
SearchFieldY = 20
AlignmentAlgo = default
FlipImageSize = false
/config/ref0.jpg 103 271
/config/ref1.jpg 442 142

[Digits]
2022-01-17T16:35:20
Start ReadParameter ([Digits])
Model = /config/dig1330s1q.tflite
;LogImageLocation = /log/digit
;LogfileRetentionInDays = 3
ModelInputSize = 20 32
main.dig1 294 126 30 54
GetGENERAL - GENERAL main - roi dig1
main.dig2 343 126 30 54
GetGENERAL - GENERAL main - roi dig2
main.dig3 391 126 30 54
GetGENERAL - GENERAL main - roi dig3

[Analog]
Start ReadParameter ([Analog])
Model = /config/ana0910s3_longq.tflite
;LogImageLocation = /log/analog
;LogfileRetentionInDays = 3
ModelInputSize = 32 32
main.ana1 432 230 92 92
GetGENERAL - GENERAL main - roi ana1
main.ana2 379 332 92 92
GetGENERAL - GENERAL main - roi ana2
main.ana3 283 374 92 92
GetGENERAL - GENERAL main - roi ana3
main.ana4 155 328 92 92
GetGENERAL - GENERAL main - roi ana4

[PostProcessing]
Start ReadParameter ([PostProcessing])
Anzahl NUMBERS: 1 - DIGITS: 1, ANALOG: 1
Number main, Anz DIG: 3, Anz ANA 4
main.DecimalShift = 0
PreValueUse = true
PreValueAgeStartup = 720
AllowNegativeRates = false
main.MaxRateValue = 0.1
;main.ExtendedResolution = false
;main.IgnoreLeadingNaN = false
ErrorMessage = true
CheckDigitIncreaseConsistency = false

;[MQTT]
Read Zeile Prevalue.ini: main   2022-01-17T16:35:00     42.2226
Read: ;Uri = mqtt://IP-ADRESS:1883
Read: ;MainTopic = wasserzaehler
Read: ;ClientID = wasser
Read: ;user = USERNAME
Read: ;password = PASSWORD
Read:
Read: ;[GPIO]
Read: ;IO0 = input disabled 10 false false
Read: ;IO1 = input disabled 10 false false
Read: ;IO3 = input disabled 10 false false
Read: ;IO4 = built-in-led disabled 10 false false
Read: ;IO12 = input-pullup disabled 10 false false
Read: ;IO13 = input-pullup disabled 10 false false
Read: LEDType = WS2812
Read: LEDNumbers = 2
Read: LEDColor = 50 50 50
Read:
Read: [AutoTimer]
Start ReadParameter ([AutoTimer]
)
AutoStart = true
Intervall = 4.85

[Debug]
Start ReadParameter ([Debug])
Logfile = false
LogfileRetentionInDays = 3

[System]
Start ReadParameter ([System])
TimeZone = CET-1CEST,M3.5.0,M10.5.0/3
TimeZone set to CET-1CEST,M3.5.0,M10.5.0/3
TimeServer = gw.XXXX.lan
Set SNTP-Server: gw.XXXX.lan
I (17386) sntp: Waiting for system time to be set... (1/10)
I (19396) sntp: Waiting for system time to be set... (2/10)
I (21396) sntp: Waiting for system time to be set... (3/10)
W (21886) wifi:<ba-add>idx:1 (ifx:0, XX:XX:4a:9a:88:bf), tid:3, ssn:0, winSize:64
Time ist 20220117-165417
;AutoAdjustSummertime = false
Hostname = wm1
SetupMode = false
END OF FILE
*************** Start GPIOHandler_Init *****************
I (23396) server_GPIO: read GPIO config and init GPIO
open file /sdcard/config/config.ini in mode r
[MakeImage]
;LogImageLocation = /log/source
WaitBeforeTakingPicture = 5
;LogfileRetentionInDays = 15
Brightness = -2
;Contrast = 0
;Saturation = 0
ImageQuality = 5
ImageSize = VGA
FixedExposure = false

[Alignment]
InitialRotate = 179
InitialMirror = false
SearchFieldX = 20
SearchFieldY = 20
AlignmentAlgo = default
FlipImageSize = false
/config/ref0.jpg 103 271
/config/ref1.jpg 442 142

[Digits]
Model = /config/dig1330s1q.tflite
;LogImageLocation = /log/digit
;LogfileRetentionInDays = 3
ModelInputSize = 20 32
main.dig1 294 126 30 54
main.dig2 343 126 30 54
main.dig3 391 126 30 54

[Analog]
Model = /config/ana0910s3_longq.tflite
;LogImageLocation = /log/analog
;LogfileRetentionInDays = 3
ModelInputSize = 32 32
main.ana1 432 230 92 92
main.ana2 379 332 92 92
main.ana3 283 374 92 92
main.ana4 155 328 92 92

[PostProcessing]
main.DecimalShift = 0
PreValueUse = true
PreValueAgeStartup = 720
AllowNegativeRates = false
main.MaxRateValue = 0.1
;main.ExtendedResolution = false
;main.IgnoreLeadingNaN = false
ErrorMessage = true
CheckDigitIncreaseConsistency = false

;[MQTT]
;Uri = mqtt://IP-ADRESS:1883
;MainTopic = wasserzaehler
;ClientID = wasser
;user = USERNAME
;password = PASSWORD

;[GPIO]
;IO0 = input disabled 10 false false
;IO1 = input disabled 10 false false
;IO3 = input disabled 10 false false
;IO4 = built-in-led disabled 10 false false
;IO12 = input-pullup disabled 10 false false
;IO13 = input-pullup disabled 10 false false
LEDType = WS2812
LEDNumbers = 2
LEDColor = 50 50 50

[AutoTimer]
AutoStart = true
Intervall = 4.85

[Debug]
Logfile = false
LogfileRetentionInDays = 3

[System]
TimeZone = CET-1CEST,M3.5.0,M10.5.0/3
TimeServer = gw.XXXX.lan
;AutoAdjustSummertime = false
Hostname = wm1
SetupMode = false
I (23566) server_GPIO: GPIO init comleted, handler is disabled
Autoflow: start
doflow - start 20220117-165417
Flashdauer: 5000
W (28576) cam_hal: NO-EOI
Image loaded from memory: 640, 480, 3
E (33736) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (33736) task_wdt:  - IDLE (CPU 0)
E (33736) task_wdt: Tasks currently running:
E (33736) task_wdt: CPU 0: task_autodoFlow
E (33736) task_wdt: CPU 1: IDLE
E (33736) task_wdt: Print CPU 0 (current core) backtrace

Backtrace:0x400E9700:0x3FFB0990 0x400837A9:0x3FFB09B0 0x40193641:0x3FFFF810 0x401936D6:0x3FFFF850 0x4018FFE5:0x3FFFF870 0x4018AE7C:0x3FFFF900 0x400FEB05:0x3FFFF9C0 0x400FEDAB:0x3FFFFA10

E (33736) task_wdt: Print CPU 1 backtrace

Backtrace:0x40087C01:0x3FFB0F90 0x400837A9:0x3FFB0FB0 0x4000BFED:0x3FFC4AC0 0x40092715:0x3FFC4AD0 0x400E991F:0x3FFC4AF0 0x400E992B:0x3FFC4B20 0x400E9952:0x3FFC4B40 0x40090778:0x3FFC4B60

Vor ft->FindTemplate(_temp1);  /sdcard/config/ref0.jpg
uri: /wasserzaehler_roi.html
1 uri: /wasserzaehler_roi.html, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/wasserzaehler_roi.html
open file /sdcard/html/wasserzaehler_roi.html in mode r
I (37696) serverhelp: Sending file : /sdcard/html/wasserzaehler_roi.html ...
I (37756) serverhelp: File sending complete
E (39306) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (39306) task_wdt:  - IDLE (CPU 0)
E (39306) task_wdt: Tasks currently running:
E (39306) task_wdt: CPU 0: task_autodoFlow
E (39306) task_wdt: CPU 1: IDLE
E (39306) task_wdt: Print CPU 0 (current core) backtrace

Backtrace:0x400E9700:0x3FFB0990 0x400837A9:0x3FFB09B0 0x401932E1:0x3FFFF740 0x40192C54:0x3FFFF7F0 0x40190025:0x3FFFF870 0x4018AE7C:0x3FFFF900 0x400FEB05:0x3FFFF9C0 0x400FEDAB:0x3FFFFA10

E (39306) task_wdt: Print CPU 1 backtrace

Backtrace:0x40087C01:0x3FFB0F90 0x400837A9:0x3FFB0FB0 0x4000BFED:0x3FFC4AC0 0x40092715:0x3FFC4AD0 0x400E991F:0x3FFC4AF0 0x400E992B:0x3FFC4B20 0x400E9952:0x3FFC4B40 0x40090778:0x3FFC4B60

Vor ft->FindTemplate(_temp2);  /sdcard/config/ref1.jpg
uri: /jquery-3.6.0.min.js
1 uri: /jquery-3.6.0.min.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/jquery-3.6.0.min.js
open file /sdcard/html/jquery-3.6.0.min.js in mode r
I (40096) serverhelp: Sending file : /sdcard/html/jquery-3.6.0.min.js ...
I (41796) serverhelp: File sending complete
uri: /gethost.js
1 uri: /gethost.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/gethost.js
open file /sdcard/html/gethost.js in mode r
I (41836) serverhelp: Sending file : /sdcard/html/gethost.js ...
I (41846) serverhelp: File sending complete
uri: /readconfigcommon.js
1 uri: /readconfigcommon.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/readconfigcommon.js
open file /sdcard/html/readconfigcommon.js in mode r
I (41886) serverhelp: Sending file : /sdcard/html/readconfigcommon.js ...
I (42446) serverhelp: File sending complete
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=prevalue
TYPE: prevalue
ZW: main        42.22260
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=value
TYPE: value
ZW: main
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=error
TYPE: error
ZW: main
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=raw
TYPE: raw
ZW: main
uri: /img_tmp/alg_roi.jpg
1 uri: /img_tmp/alg_roi.jpg, filename: alg_roi.jpg, filepath: /sdcardalg_roi.jpg
File to upload: alg_roi.jpg
ClassFlowControll::GetJPGStream alg_roi.jpg
I (42926) flow_controll: Sending file : alg_roi.jpg ...
I (44076) flow_controll: File sending complete
E (44846) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (44846) task_wdt:  - IDLE (CPU 0)
E (44846) task_wdt: Tasks currently running:
E (44846) task_wdt: CPU 0: task_autodoFlow
E (44846) task_wdt: CPU 1: IDLE
E (44846) task_wdt: Print CPU 0 (current core) backtrace

Backtrace:0x400E9700:0x3FFB0990 0x400837A9:0x3FFB09B0 0x4000264F:0x3FFFF730 0x401932E9:0x3FFFF740 0x40192C7A:0x3FFFF7F0 0x40190025:0x3FFFF870 0x4018AE7C:0x3FFFF900 0x400FEB05:0x3FFFF9C0 0x400FEDAB:0x3FFFFA10

E (44846) task_wdt: Print CPU 1 backtrace

Backtrace:0x40087C01:0x3FFB0F90 0x400837A9:0x3FFB0FB0 0x4000BFED:0x3FFC4AC0 0x40092715:0x3FFC4AD0 0x400E991F:0x3FFC4AF0 0x400E992B:0x3FFC4B20 0x400E9952:0x3FFC4B40 0x40090778:0x3FFC4B60

E (49846) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (49846) task_wdt:  - IDLE (CPU 0)
E (49846) task_wdt: Tasks currently running:
E (49846) task_wdt: CPU 0: task_autodoFlow
E (49846) task_wdt: CPU 1: IDLE
E (49846) task_wdt: Print CPU 0 (current core) backtrace

Backtrace:0x400E9700:0x3FFB0990 0x400837A9:0x3FFB09B0 0x4019364D:0x3FFFF7B0 0x40192D89:0x3FFFF7F0 0x40190025:0x3FFFF870 0x4018AE7C:0x3FFFF900 0x400FEB05:0x3FFFF9C0 0x400FEDAB:0x3FFFFA10

E (49846) task_wdt: Print CPU 1 backtrace

Backtrace:0x40087C01:0x3FFB0F90 0x400837A9:0x3FFB0FB0 0x4000BFED:0x3FFC4AC0 0x40092715:0x3FFC4AD0 0x400E991F:0x3FFC4AF0 0x400E992B:0x3FFC4B20 0x400E9952:0x3FFC4B40 0x40090778:0x3FFC4B60

Alignment: dx -20 - dy 10 - rot -1.125391
2022-01-17T16:54:46
General 0 - Align&Cut
General 1 - Align&Cut
General 2 - Align&Cut
/sdcard/config/dig1330s1q.tflite
open file /sdcard/config/dig1330s1q.tflite in mode rb
TFlite-Type set to Digital
General 0 - TfLite
Result General(Digit)0: 0
General 1 - TfLite
E (57726) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (57726) task_wdt:  - IDLE (CPU 0)
E (57726) task_wdt: Tasks currently running:
E (57726) task_wdt: CPU 0: task_autodoFlow
E (57726) task_wdt: CPU 1: IDLE
E (57726) task_wdt: Print CPU 0 (current core) backtrace

Backtrace:0x400E9700:0x3FFB0990 0x400837A9:0x3FFB09B0 0x401AF775:0x3FFFF410 0x401DC163:0x3FFFF700 0x40199FDB:0x3FFFF730 0x4019398B:0x3FFFF750 0x40193A4E:0x3FFFF770 0x4019117D:0x3FFFF790 0x40191587:0x3FFFF8A0 0x40191881:0x3FFFF8C0 0x4018AE7C:0x3FFFF900 0x400FEB05:0x3FFFF9C0 0x400FEDAB:0x3FFFFA10

E (57726) task_wdt: Print CPU 1 backtrace

Backtrace:0x40087C01:0x3FFB0F90 0x400837A9:0x3FFB0FB0 0x4000BFED:0x3FFC4AC0 0x40092715:0x3FFC4AD0 0x400E991F:0x3FFC4AF0 0x400E992B:0x3FFC4B20 0x400E9952:0x3FFC4B40 0x40090778:0x3FFC4B60

Result General(Digit)1: 10
General 2 - TfLite
Result General(Digit)2: 0
General 0 - Align&Cut
General 1 - Align&Cut
General 2 - Align&Cut
General 3 - Align&Cut
/sdcard/config/ana0910s3_longq.tflite
open file /sdcard/config/ana0910s3_longq.tflite in mode rb
TFlite-Type set to Analogue
General 0 - TfLite
Result General(Analog)0: 1.847262
General 1 - TfLite
Result General(Analog)1: 2.326277
General 2 - TfLite
E (66116) task_wdt: Task watchdog got triggered. The following tasks did not reset the watchdog in time:
E (66116) task_wdt:  - IDLE (CPU 0)
E (66116) task_wdt: Tasks currently running:
E (66116) task_wdt: CPU 0: task_autodoFlow
E (66116) task_wdt: CPU 1: IDLE
E (66116) task_wdt: Print CPU 0 (current core) backtrace

Backtrace:0x400E9700:0x3FFB0990 0x400837A9:0x3FFB09B0 0x401AF748:0x3FFFF430 0x401DC163:0x3FFFF720 0x40199FDB:0x3FFFF750 0x4019398B:0x3FFFF770 0x4019101B:0x3FFFF790 0x40191587:0x3FFFF8A0 0x40191881:0x3FFFF8C0 0x4018AE7C:0x3FFFF900 0x400FEB05:0x3FFFF9C0 0x400FEDAB:0x3FFFFA10

E (66116) task_wdt: Print CPU 1 backtrace

Backtrace:0x40087C01:0x3FFB0F90 0x400837A9:0x3FFB0FB0 0x4000BFED:0x3FFC4AC0 0x40092715:0x3FFC4AD0 0x400E991F:0x3FFC4AF0 0x400E992B:0x3FFC4B20 0x400E9952:0x3FFC4B40 0x40090778:0x3FFC4B60

Result General(Analog)2: 3.307072
General 3 - TfLite
Result General(Analog)3: 7.900999
Anzahl NUMBERS: 1
UpdateNachkommaDecShift NUMBER0: Nachkomma 4, DecShift 0
I (69516) log: 0 older log files deleted. 2 current log files not deleted.
CPU Temperature: 72.22
Autoflow: sleep for : 24505ms

EDIT: Hab das funktionierende Logfile nochmal neu generiert, damit es komplett da ist

ThomasCr commented 2 years ago

Jetzt nochmal mit Version 1.2.0 nach einem weiteren Reboot und ohne Funktion der Kamera. Hänge extra mal das komplette Boot-Log an (WLAN SSID/PW raus gefiltert)

rst:0xc (SW_CPU_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:4
load:0x3fff0034,len:7248
ho 0 tail 12 room 4
load:0x40078000,len:13856
load:0x40080400,len:4052
entry 0x40080688
I (31) boot: ESP-IDF 3.40100.200827 2nd stage bootloader
I (31) boot: compile time 21:55:31
I (31) boot: chip revision: 1
I (34) boot_comm: chip revision: 1, min. bootloader chip revision: 0
I (41) boot.esp32: SPI Speed      : 40MHz
I (46) boot.esp32: SPI Mode       : DIO
I (51) boot.esp32: SPI Flash Size : 4MB
I (55) boot: Enabling RNG early entropy source...
I (61) boot: Partition Table:
I (64) boot: ## Label            Usage          Type ST Offset   Length
I (71) boot:  0 nvs              WiFi data        01 02 00009000 00004000
I (79) boot:  1 otadata          OTA data         01 00 0000d000 00002000
I (86) boot:  2 phy_init         RF data          01 01 0000f000 00001000
I (94) boot:  3 ota_0            OTA app          00 10 00010000 001db000
I (101) boot:  4 ota_1            OTA app          00 11 001f0000 001db000
I (109) boot: End of partition table
I (113) boot_comm: chip revision: 1, min. application chip revision: 0
I (120) esp_image: segment 0: paddr=0x00010020 vaddr=0x3f400020 size=0x49038 (299064) map
I (259) esp_image: segment 1: paddr=0x00059060 vaddr=0x3ffb0000 size=0x04984 ( 18820) load
I (268) esp_image: segment 2: paddr=0x0005d9ec vaddr=0x40080000 size=0x0262c (  9772) load
I (273) esp_image: segment 3: paddr=0x00060020 vaddr=0x400d0020 size=0x13a1b4 (1286580) map
I (833) esp_image: segment 4: paddr=0x0019a1dc vaddr=0x4008262c size=0x19200 (102912) load
I (884) esp_image: segment 5: paddr=0x001b33e4 vaddr=0x50000000 size=0x00010 (    16) load
I (900) boot: Loaded app from partition at offset 0x10000
I (900) boot: Disabling RNG early entropy source...
I (901) psram: This chip is ESP32-D0WD
I (905) spiram: Found 64MBit SPI RAM device
I (910) spiram: SPI RAM mode: flash 40m sram 40m
I (915) spiram: PSRAM initialized, cache is in low/high (2-core) mode.
I (922) cpu_start: Pro cpu up.
I (926) cpu_start: Starting app cpu, entry point is 0x40082910
I (917) cpu_start: App cpu up.
I (1820) spiram: SPI SRAM memory test OK
I (1828) cpu_start: Pro cpu start user code
I (1828) cpu_start: cpu freq: 160000000
I (1828) cpu_start: Application information:
I (1831) cpu_start: Project name:     esp32cam-server-only
I (1837) cpu_start: App version:      0.0.9.3
I (1842) cpu_start: Compile time:     Jan 14 2022 20:30:04
I (1849) cpu_start: ELF file SHA256:  b04120accc0780f7...
I (1855) cpu_start: ESP-IDF:          4.3.1
I (1860) heap_init: Initializing. RAM available for dynamic allocation:
I (1867) heap_init: At 3FFAE6E0 len 00001920 (6 KiB): DRAM
I (1873) heap_init: At 3FFC0510 len 0001FAF0 (126 KiB): DRAM
I (1879) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM
I (1886) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
I (1892) heap_init: At 4009B82C len 000047D4 (17 KiB): IRAM
I (1899) spiram: Adding pool of 4096K of external SPI memory to heap allocator
I (1908) spi_flash: detected chip: generic
I (1911) spi_flash: flash io: dio
I (1921) cpu_start: Starting scheduler on PRO CPU.
I (0) cpu_start: Starting scheduler on APP CPU.
I (1926) spiram: Reserving pool of 32K of internal memory for DMA/internal allocations
I (1976) main: Using SDMMC peripheral
Name: SD
Type: SDHC/SDXC
Speed: 20 MHz
Size: 7618MB
I (2026) server_ota: Start CheckOTAUpdateCheck ...
Start CheckOTAUpdateCheck ...
I (2036) server_ota: SHA-256 for the partition table: : 9d4a2809ae90fb20709a8ca3dd3ac3462e1e73286bcd31b689060c91de06fa3a
I (2036) server_ota: SHA-256 for bootloader: : fcdaa822cbfd3931bcf8b49d91f2b86a98b93513bdbadb110eecd54f32d13c55
I (2056) server_ota: SHA-256 for current firmware: : 53471952973179c9007c1579a8c95d3d72f00ae63b2e63a292afe56037f09ad3
CheckOTAUpdate Partition: ESP_OK
open file /sdcard/wlan.ini in mode r
file loaded

WLan: XXXX, XXXXXXXXXXX
Hostename: wm1
I (2116) wifi:wifi driver task: 3ffd26b0, prio:23, stack:6656, core=0
I (2116) system_api: Base MAC address is not set
I (2116) system_api: read default base MAC address from EFUSE
I (2136) wifi:wifi firmware version: 88c8747
I (2136) wifi:wifi certification version: v7.0
I (2136) wifi:config NVS flash: enabled
I (2136) wifi:config nano formating: disabled
I (2146) wifi:Init data frame dynamic rx buffer num: 16
I (2146) wifi:Init management frame dynamic rx buffer num: 16
I (2156) wifi:Init management short buffer num: 32
I (2156) wifi:Init static tx buffer num: 16
I (2166) wifi:Init tx cache buffer num: 16
I (2166) wifi:Init static rx buffer size: 1600
I (2166) wifi:Init static rx buffer num: 10
I (2176) wifi:Init dynamic rx buffer num: 16
I (2176) wifi_init: rx ba win: 6
I (2186) wifi_init: tcpip mbox: 32
I (2186) wifi_init: udp mbox: 6
I (2186) wifi_init: tcp mbox: 6
I (2196) wifi_init: tcp tx win: 5744
I (2196) wifi_init: tcp rx win: 5744
I (2206) wifi_init: tcp mss: 1440
I (2206) wifi_init: WiFi IRAM OP enabled
I (2206) wifi_init: WiFi RX IRAM OP enabled
I (2216) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07
I (2326) wifi:mode : sta (XX:XX:bd:61:1c:30)
I (2326) wifi:enable tsf
I (2326) BLINK: Blinken - start
E (2336) wifi station: Set Hostname to:wm1
I (2336) wifi station: wifi_init_sta finished.
I (2336) wifi:new:<1,1>, old:<1,0>, ap:<255,255>, sta:<1,1>, prof:1
I (2346) wifi:state: init -> auth (b0)
I (2356) wifi:state: auth -> assoc (0)
I (2356) wifi:state: assoc -> run (10)
I (2376) wifi:connected with XXXX, aid = 2, channel 1, 40U, bssid = XX:XX:4a:9a:88:bf
I (2376) wifi:security: WPA2-PSK, phy: bgn, rssi: -85
I (2376) wifi:pm start, type: 1

I (2416) wifi:AP's beacon interval = 102400 us, DTIM period = 2
I (2526) BLINK: Blinken - done
I (3096) esp_netif_handlers: sta ip: 192.168.99.94, mask: 255.255.255.0, gw: 192.168.99.1
I (3096) wifi station: got ip:192.168.99.94
I (3096) BLINK: Blinken - start
I (3096) wifi station: connected to ap SSID:XXXX password:XXXXXXXXXXX
main: sleep for : 200ms
I (5116) sntp: Time is not set yet. Connecting to WiFi and getting time over NTP.
I (5116) sntp: Initializing SNTP
I (5116) sntp: Waiting for system time to be set... (1/10)
W (6096) wifi:<ba-add>idx:0 (ifx:0, XX:XX:4a:9a:88:bf), tid:0, ssn:0, winSize:64
TimeZone set to CET-1CEST,M3.5.0,M10.5.0/3
Logfile opened: /sdcard/log/message/log_2022-01-17.txt
I (7126) sntp: The current date/time in Berlin is: Mon Jan 17 16:38:33 2022
I (7126) sntp: The current date/time in Berlin is: 2022-01-17_16:38
timeist 20220117-163833
Logfile opened: /sdcard/log/message/log_2022-01-17.txt
Logfile opened: /sdcard/log/message/log_2022-01-17.txt
Logfile opened: /sdcard/log/message/log_2022-01-17.txt
time 20220117-163833
main: sleep for : 200ms
I (9206) server-main: Starting server on port: '80'
I (9206) server-main: Registering URI handlers
I (9206) server_tflite: server_part_camera - Registering URI handlers
I (9206) server_ota: server_ota - Registering URI handlers
I (9216) server_GPIO: start GpioHandler
I (9216) server_GPIO: register GPIO Uri
I (9226) server_GPIO: server_GPIO - Registering URI handlers
vor reg server main
vor dotautostart
Do Reset Camera
I (9236) gpio: GPIO[32]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0
uri: /wasserzaehler_roi.html
1 uri: /wasserzaehler_roi.html, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/wasserzaehler_roi.html
open file /sdcard/html/wasserzaehler_roi.html in mode r
I (9526) serverhelp: Sending file : /sdcard/html/wasserzaehler_roi.html ...
I (9546) serverhelp: File sending complete
uri: /jquery-3.6.0.min.js
1 uri: /jquery-3.6.0.min.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/jquery-3.6.0.min.js
open file /sdcard/html/jquery-3.6.0.min.js in mode r
I (9656) serverhelp: Sending file : /sdcard/html/jquery-3.6.0.min.js ...
Init Camera
I (11246) gpio: GPIO[25]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:2
I (11246) cam_hal: cam init ok
I (11246) sccb: pin_sda 26 pin_scl 27
I (11256) gpio: GPIO[32]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0
I (11286) camera: Detected camera at address=0x30
I (11286) camera: Detected OV2640 camera
I (11286) camera: Camera PID=0x26 VER=0x42 MIDL=0x7f MIDH=0xa2
I (11296) serverhelp: File sending complete
uri: /gethost.js
1 uri: /gethost.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/gethost.js
open file /sdcard/html/gethost.js in mode r
I (11326) serverhelp: Sending file : /sdcard/html/gethost.js ...
I (11336) serverhelp: File sending complete
uri: /readconfigcommon.js
1 uri: /readconfigcommon.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/readconfigcommon.js
open file /sdcard/html/readconfigcommon.js in mode r
I (11376) serverhelp: Sending file : /sdcard/html/readconfigcommon.js ...
I (11386) cam_hal: buffer_size: 32768, half_buffer_size: 4096, node_buffer_size: 2048, node_cnt: 16, total_cnt: 15
I (11386) cam_hal: Allocating 61440 Byte frame buffer in PSRAM
I (11396) cam_hal: cam config ok
I (11396) ov2640: Set PLL: clk_2x: 0, clk_div: 0, pclk_auto: 0, pclk_div: 8
I (11576) serverhelp: File sending complete
task_autodoFlow configMINIMAL_STACK_SIZE: 768
getESPHeapInfo:  Heap: 4143730 Min Free: 4131806 larg. Block:  2097152 SPI Heap: 4103731 NOT_SPI Heap: 39999 Internal Heap: 39999 Internal Min Heap free: 28075
ERROR task_autodoFlow konnte nicht erzeugt werden !!
getESPHeapInfo:  Heap: 4143730 Min Free: 4131806 larg. Block:  2097152 SPI Heap: 4103731 NOT_SPI Heap: 39999 Internal Heap: 39999 Internal Min Heap free: 28075
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=prevalue
TYPE: prevalue
ZW:
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=value
TYPE: value
ZW:
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=error
TYPE: error
ZW:
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=raw
TYPE: raw
ZW:
uri: /img_tmp/alg_roi.jpg
1 uri: /img_tmp/alg_roi.jpg, filename: alg_roi.jpg, filepath: /sdcardalg_roi.jpg
File to upload: alg_roi.jpg
ClassFlowControll::GetJPGStream alg_roi.jpg
Can't continue, flowalignment is NULL
uri: /img_tmp/alg_roi.jpg
1 uri: /img_tmp/alg_roi.jpg, filename: alg_roi.jpg, filepath: /sdcardalg_roi.jpg
File to upload: /sdcard/img_tmp/alg_roi.jpg
open file /sdcard/img_tmp/alg_roi.jpg in mode r
E (11786) serverhelp: Failed to read existing file : /sdcard/img_tmp/alg_roi.jpg
W (11786) httpd_txrx: httpd_resp_send_err: 500 Internal Server Error - Failed to read existing file
W (11796) httpd_uri: httpd_uri: uri handler execution failed
I (13106) BLINK: Blinken - done
uri: /wasserzaehler_roi.html
1 uri: /wasserzaehler_roi.html, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/wasserzaehler_roi.html
open file /sdcard/html/wasserzaehler_roi.html in mode r
I (14626) serverhelp: Sending file : /sdcard/html/wasserzaehler_roi.html ...
I (14646) serverhelp: File sending complete
uri: /readconfigcommon.js
1 uri: /readconfigcommon.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/readconfigcommon.js
open file /sdcard/html/readconfigcommon.js in mode r
I (20596) serverhelp: Sending file : /sdcard/html/readconfigcommon.js ...
I (20736) serverhelp: File sending complete
uri: /jquery-3.6.0.min.js
1 uri: /jquery-3.6.0.min.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/jquery-3.6.0.min.js
open file /sdcard/html/jquery-3.6.0.min.js in mode r
I (20756) serverhelp: Sending file : /sdcard/html/jquery-3.6.0.min.js ...
I (22546) serverhelp: File sending complete
uri: /gethost.js
1 uri: /gethost.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/gethost.js
open file /sdcard/html/gethost.js in mode r
I (22556) serverhelp: Sending file : /sdcard/html/gethost.js ...
I (22566) serverhelp: File sending complete
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=value
TYPE: value
ZW:
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=prevalue
TYPE: prevalue
ZW:
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=raw
TYPE: raw
ZW:
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=error
TYPE: error
ZW:
uri: /img_tmp/alg_roi.jpg
1 uri: /img_tmp/alg_roi.jpg, filename: alg_roi.jpg, filepath: /sdcardalg_roi.jpg
File to upload: alg_roi.jpg
ClassFlowControll::GetJPGStream alg_roi.jpg
Can't continue, flowalignment is NULL
uri: /img_tmp/alg_roi.jpg
1 uri: /img_tmp/alg_roi.jpg, filename: alg_roi.jpg, filepath: /sdcardalg_roi.jpg
File to upload: /sdcard/img_tmp/alg_roi.jpg
open file /sdcard/img_tmp/alg_roi.jpg in mode r
E (22726) serverhelp: Failed to read existing file : /sdcard/img_tmp/alg_roi.jpg
W (22726) httpd_txrx: httpd_resp_send_err: 500 Internal Server Error - Failed to read existing file
W (22736) httpd_uri: httpd_uri: uri handler execution failed
uri: /wasserzaehler_roi.html
1 uri: /wasserzaehler_roi.html, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/wasserzaehler_roi.html
open file /sdcard/html/wasserzaehler_roi.html in mode r
I (24566) serverhelp: Sending file : /sdcard/html/wasserzaehler_roi.html ...
I (24586) serverhelp: File sending complete
uri: /jquery-3.6.0.min.js
1 uri: /jquery-3.6.0.min.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/jquery-3.6.0.min.js
open file /sdcard/html/jquery-3.6.0.min.js in mode r
I (29116) serverhelp: Sending file : /sdcard/html/jquery-3.6.0.min.js ...
I (30736) serverhelp: File sending complete
uri: /readconfigcommon.js
1 uri: /readconfigcommon.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/readconfigcommon.js
open file /sdcard/html/readconfigcommon.js in mode r
I (30756) serverhelp: Sending file : /sdcard/html/readconfigcommon.js ...
I (30846) serverhelp: File sending complete
uri: /gethost.js
1 uri: /gethost.js, filename: , filepath: /sdcard
Filename:
File requested: /sdcard/html/gethost.js
open file /sdcard/html/gethost.js in mode r
I (30866) serverhelp: Sending file : /sdcard/html/gethost.js ...
I (30876) serverhelp: File sending complete
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=value
TYPE: value
ZW:
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=prevalue
TYPE: prevalue
ZW:
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=raw
TYPE: raw
ZW:
handler_wasserzaehler uri:
/wasserzaehler.html?all=true&type=error
TYPE: error
ZW:
uri: /img_tmp/alg_roi.jpg
1 uri: /img_tmp/alg_roi.jpg, filename: alg_roi.jpg, filepath: /sdcardalg_roi.jpg
File to upload: alg_roi.jpg
ClassFlowControll::GetJPGStream alg_roi.jpg
Can't continue, flowalignment is NULL
uri: /img_tmp/alg_roi.jpg
1 uri: /img_tmp/alg_roi.jpg, filename: alg_roi.jpg, filepath: /sdcardalg_roi.jpg
File to upload: /sdcard/img_tmp/alg_roi.jpg
open file /sdcard/img_tmp/alg_roi.jpg in mode r
E (31086) serverhelp: Failed to read existing file : /sdcard/img_tmp/alg_roi.jpg
W (31086) httpd_txrx: httpd_resp_send_err: 500 Internal Server Error - Failed to read existing file
W (31096) httpd_uri: httpd_uri: uri handler execution failed
ThomasCr commented 2 years ago

Interessant ist, wenn es geht kommen die Backtraces.... und wenn es nicht funktioniert, tauchen die gar nicht auf.....

Was einem noch auffällt ist, dass wenn es funktioniert, dass er die komplette ini ausgibt. Jedoch nicht wenn die Kamera nicht funktioniert....

juergen852 commented 2 years ago

Bei mir läuft die 10.2 seit einigen Tagen, kommt mir eher stabiler vor, als die 10.0.2. (Die anderen hatte ich nicht getestet.) Was ich bemerkt habe: Nach dem flashen evtl. 2-3 mal booten, manchmal bleibt der ESP initial hängen.

Zu Deinem Problem: Versuch mal eine SD-Karte mit nur 4GB Partitionsgröße zu partitionieren. (Bewusst nicht größer !). Neu formatieren, zur Version passenden SD-Inhalt neu drauf spielen, dann klappt es bei mir. Das Log sieht eher nach Schreibfehler mit anschließendem Lesefehler aus.

jomjol commented 2 years ago

Bei mir läuft die v10.2.0 extrem stabil und ohne Probleme. Ich komme jetzt deutlich über 1000 Runs ohne reboot:

grafik

Es scheint aber irgendwie an der Kameraversion zu hängen, ob sie startet. Ich könnte noch etwas and der Ansteuerfrequenz feilen, die habe ich wieder auf 20MHz gestellt (default), die Stand eine Zeitlang bei 5MHz.

Komme dazu aber erst nächste Woche. Zudem ist mir gerade ein Teil meines WLans abgeraucht (Hardwaredefekt am Router), so dass ich sowie nicht richtig arbeiten kann.

ThomasCr commented 2 years ago

@juergen852 Das mit der SD habe ich schon so gemacht, anders lässt Windows es auch nicht zu die Karte mit FAT16 zu Formatieren. Und anders wird die Karte bei mir nicht erkannt...

@jomjol Kann das evtl. auch an der CPU/Chip-ID liegen? Evtl. sind die Boards ja mal so und mal so ausgestattet. Da ich wegen der defekten Kamera noch ein weiteres Modul bestellt habe, habe ich die auch mal vom aussehen vergleichen und die sind sind fast 100 % ähnlich, nur wenn man genau hinschaut, sind da ein paar andere ICs und mehr davon verbaut... aber das nur am rande. Evtl. ist halt auch Teil ein anderer ESP Chip drauf verbaut.

Was ja auch auffällig ist, sind die backtraces die generiert werden. Und zwar auch mit der älteren Version.

jomjol commented 2 years ago

@ThomasCr : dein Logfile ist sehr spannend und aufschlusreich:

task_autodoFlow configMINIMAL_STACK_SIZE: 768
getESPHeapInfo:  Heap: 4143730 Min Free: 4131806 larg. Block:  2097152 SPI Heap: 4103731 NOT_SPI Heap: 39999 Internal Heap: 39999 Internal Min Heap free: 28075
ERROR task_autodoFlow konnte nicht erzeugt werden !!
getESPHeapInfo:  Heap: 4143730 Min Free: 4131806 larg. Block:  2097152 SPI Heap: 4103731 NOT_SPI Heap: 39999 Internal Heap: 39999 Internal Min Heap free: 28075
handler_wasserzaehler uri:

Die Zeile ERROR task_autodoFlow konnte nicht erzeugt werden !! dass der Run nicht gestartet werden konnte. Dann kommt natürlich auch kein Bild usw. An der Stelle ist der freie Speicher echt kritisch (Internal Min Heap free: 28075) 28kByte sind zu wenig. Ursache kann eigentlich nur sein, dass du vorher schon auf den Web-Server zugegriffen hast und er dabei ein paar Files gesendet hat. Dafür braucht er natürlich auch Speicher. Kannst du mal probieren, die v10.2.0 zu installieren und dann nach dem Reboot ca. 60s Warten (bis er das erste Bild aufgenommen hat) und dann erst darauf zugreifen, ob das das Problem löst. Falls ja, muss ich das im Code abfangen.

@tunip : bei dir kann anscheinend die Kamera nicht angesteuert werden Camera is not working anymore - most propably hardware problem (instablility, ...). System will reboot. Ich habe jetzt in dem Rolling branch die Frequenz auf 5MHz runter gestellt. Kannst du das mal probieren.

friedpa commented 2 years ago

Guten Morgen Josef, habe Deine Rolling 10.2.0 ausprobiert:

2022-01-18T08:19:54: Reboot in 5sec 2022-01-18T08:20:09: Time zone set to CET-1CEST,M3.5.0,M10.5.0/3 2022-01-18T08:20:09: ============================================================================================= 2022-01-18T08:20:09: =================================== Main Started ============================================ 2022-01-18T08:20:09: ============================================================================================= 2022-01-18T08:20:16: Time zone set to CEST,M3.5.0,M10.5.0/3 2022-01-18T08:20:19: task_autodoFlow - next round - Round #1 2022-01-18T08:20:19: FlowControll.doFlow - ClassFlowMakeImage 2022-01-18T08:20:32: Camera is not working anymore - most propably hardware problem (instablility, ...). System will reboot. 2022-01-18T08:20:32: Reboot in 5sec 2022-01-18T08:20:44: Time zone set to CET-1CEST,M3.5.0,M10.5.0/3 2022-01-18T08:20:44: ============================================================================================= 2022-01-18T08:20:44: =================================== Main Started ============================================ 2022-01-18T08:20:44: ============================================================================================= 2022-01-18T08:20:51: Time zone set to CEST,M3.5.0,M10.5.0/3 2022-01-18T08:20:53: task_autodoFlow - next round - Round #1 2022-01-18T08:20:53: FlowControll.doFlow - ClassFlowMakeImage 2022-01-18T08:21:02: Camera is not working anymore - most propably hardware problem (instablility, ...). System will reboot.

Musste wieder auf die 9.0.0 zurückgehen. Bitte schicke mir mal Deine HW Quelle, dann besorge ich mir die gleichen Teile. Liebe Grüße Paul

ThiloAm commented 2 years ago

EDIT: muss mich korrigieren auch mit 10.0.2 die selben Probleme. Bei mir steht "DC-26 40-v3" drauf.

Habe das selbe Problem das die Kamera (immer wieder) nicht erkannt wird. Bin jetzt auf die Version 10.0.2 zurück. Mit dieser Version habe ich bisher keine Probleme.

Fehlermeldung mit Version 10.2.0 und auch mit 10.1.0.

2022-01-18T14:36:06: task_autodoFlow - next round - Round #3 2022-01-18T14:36:06: FlowControll.doFlow - ClassFlowMakeImage 2022-01-18T14:36:12: Image with size 0 loaded --> reboot to be done! Check that your camera module is working and connected properly. 2022-01-18T14:36:12: Reboot in 5sec

jomjol commented 2 years ago

@friedpa : das Problem hängt mit der Kamera-Hardwareversion zusammen. Ich habe jetzt ein Modul, bei dem seit der Version 10.2 das Kameramodule nicht mehr funktioniert. Das nicht funktionierende hat auf dem Flex die Bezeichnung "TY-OV2" und "640-V2.0". Ich habe zwei probiert, beide tun nicht. Bis zu v9.0 war das kein Problem. Ich muss das mal länger beobachten.

EDIT: meine HW-Quelle ist Amazon oder die älteren von AliExpress. Aber habe jetzt schon länger nichts mehr gekauft.

Muss das mal systematisch untersuchen. Ist auf der ToDo-Liste für die nächsten Wochen.

muevol commented 2 years ago

Gestern zwei ESP32 von 9.2.0 auf 10.2.0 per OTA-Update geflasht, laufen jetzt seit 24 Stunden ohne Probleme.

grafik

ThiloAm commented 2 years ago

Logfile erneut untersucht 2022-01-21T21:09:43: task_autodoFlow - next round - **Round #2** 2022-01-21T21:09:43: FlowControll.doFlow - ClassFlowMakeImage 2022-01-21T21:09:49: Image with size 0 loaded --> reboot to be done! Check that your camera module is working and connected properly. 2022-01-21T21:09:49: Reboot in 5sec 2022-01-21T21:10:05: Time zone set to CET-1CEST,M3.5.0,M10.5.0/3 ... 2022-01-21T21:10:05: ==================== Main Started 2022-01-21T21:10:05: ==================== 2022-01-21T21:10:09: Failed to initialize camera module. Check that your camera module is working and connected properly.

Der höchste wert der bei "Round" erreicht wird ist 16. Über den Tag wird bis zu 32 Mal ein reboot durchgeführt. Am Schluss erfolgt kein reboot mehr. Webseite läuft, aber keine Werte und keine Logeinträge mehr. Dann hilft nur noch manuell angeschobenes Reboot. Version zur Zeit 10.0.2

ORi0N commented 2 years ago

I only started with AI-on-the-edge since this week, and used the latest version. Very erratic behavior, random reboots, wifi dropping out. Now i downgraded to v9.2.0 and everything is working way more stable. Exact same configuration files used. So I do believe there is some problem with the latest version and the board I'm using ESP32-CAM-MB

Detecting chip type... ESP32
Chip is ESP32-D0WD (revision 1)
Features: WiFi, BT, Dual Core, 240MHz, VRef calibration in efuse, Coding Scheme None
Crystal is 40MHz

I'm happy I persisted with this project as I allmost gave up on it :o

friedpa commented 2 years ago

@orion You should stay with 9.2 as long as 10.x is not working for your ESPs. There is no limitation in 9.x for you. @jomjol is working for us all to stabilize the system and will find the root cause of the problem. Development needs time unfortunately. And last but not leased this kind of systems are not "mission critical" and for me it is unbelievable what you can do with a "micro" system like the ESP, great achievement....

gerritsd commented 2 years ago

I fully agree with @friedpa, @jomjol has created an awesome tool. I’m running 10.2.0 for almost a week without reboots now, which I was not able to achieve with the older releases. So I guess this issue is HW specific which makes it hard to find the root cause.

andilee7 commented 2 years ago

I want to share my findings:

I purchased a set of two from diymore. And I had similiar issues. Reboots, cam does not work, .... So I tried downgrading as mentioned here to 9.2 and tada it seemed to work. But the web interface was still unbelievable slow and and reboots started again. So i tried 9.2 on the other ESP32 I had laying around and it worked immediatly. Fast web UI, cam is working, happy me. After that I tried updating to 10.2 and it still works.

So in my case it seems to be definitely a hardware issue and I assume, one of those is defect

jomjol commented 2 years ago

Well, after some investigations there are 3 influence factors, that influence the stability 1) Hardware - there are defenetivly differences for different cameras and maybe also ESP32CAM board 2) Power supply stability - especially version 10.2 is more sensitive. If you combine this with the internal flash LED it is getting even worse. Much less problems with WS2812B LEDs 3) Settings of the paramter ImageQuality. This should be increased from 5 to 12 for the newer versions.

ThiloAm commented 2 years ago

@jomjol I already ruled out the power supply, but it's always a problem.

Set ImageQuality to 12 and now it runs much better. 2022-01-29T13:11:33: task_autodoFlow - next round - Round #214

I keep watching it

Supi!

friedpa commented 2 years ago

@jomjol I think you did the magic trick now, upgraded to version 10.3.0 (before config.in -> ImageQuality = 12) and no more reboots since then, I will nevertheless keep an eye on it, but congrats to you for that major improvement!

jomjol commented 2 years ago

@friedpa Thanks a lot! The last 3 weeks did cost quite some effort. Unfortunately the ImageQuality was folded with a partially broken ESP32CAM. So I tested and changed quite a lot, until I yesterday realisted that 95% of the last weeks were waste, because my working horse ESP32CAM on the watermeter, working for 4 year (!) very stable, is about to die - unfortunately very slowly :-(.

friedpa commented 2 years ago

@All: before there are a lot of questions: If you upgrade from 9.2.0 to 10.3.0 and you are using MQTT:

Duese123 commented 2 years ago

: If you upgrade from 9.2.0 to 10.3.0 and

Yep. I hat also noch reboots!! Magic is test what I realized also at the very beginning. Reise the Image quality number....

jomjol commented 2 years ago

Problems seems to be solved with v10.3.0 - closing the issue