[Ovmsdev] version 3.2.007: Crash on boot

Greg D. gregd2350 at gmail.com
Fri Dec 13 14:09:08 HKT 2019


An HTML attachment was scrubbed...
URL: <http://lists.openvehicles.com/pipermail/ovmsdev/attachments/20191212/c31c3354/attachment.htm>
-------------- next part --------------
=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2019.12.12 21:49:33 =~=~=~=~=~=~=~=~=~=~=~=


OVMS# 

OVMS# module reset
I (480636) script: Duktape: Compacting DukTape memory

OVMS# module reset

Resetting system...
OVMS# 
I (481876) boot: Shutting down for restart...
I (481886) esp32wifi: Stopping WIFI station
I (481886) wifi: state: run -> init (0)
I (481886) wifi: pm stop, total sleep time: 435723370 us / 476801654 us
I (481886) wifi: new:<6,0>, old:<6,0>, ap:<6,2>, sta:<6,0>, prof:6
I (481896) ovms-server-v2: Status: Disconnected
E (481896) event: system_event_ap_stop_handle_default 223 esp_wifi_internal_reg_rxcb ret=0x3014
I (481906) wifi: flush txq
I (481906) wifi: stop sw txq
I (481906) wifi: lmac stop hw txq
I (481916) esp32wifi: Powering down WIFI driver
I (481916) wifi: Deinit lldesc rx mblock:16
I (481936) sdcard: Unmounting SDCARD for reset
I (481936) simcom: State: Enter PoweringOff state
I (481936) gsm-ppp: Shutting down (soft)...
I (481946) gsm-ppp: PPP is shutdown
I (481946) gsm-nmea: Shutdown (direct)
I (481956) simcom: Power Cycle

OVMS# 
I (482966) netmanager: WIFI client stop
I (482966) netmanager: Interface priority is pp3 (0.0.0.0/255.255.255.255 gateway 0.0.0.0)
I (482966) netmanager: Set DNS#0 9.9.9.9
I (482966) netmanager: Set DNS#1 8.8.8.8
I (482966) netmanager: WIFI client down (with MODEM up): reconfigured for MODEM priority
I (482986) esp32wifi: STA disconnected with reason 8 = ASSOC_LEAVE
I (483016) netmanager: WIFI access point is down
I (483016) esp32wifi: AP stopped
I (483026) sdcard: unmount done
I (483026) netmanager: MODEM down (with WIFI client down): network connectivity has been lost
I (483036) ovms-server-v2: Status: Server is ready to start
I (483056) time: Network was reconfigured: restarting SNTP client
I (483056) ovms-server-v2: Network was reconfigured: disconnect, and reconnect in 10 seconds
I (483056) ovms-server-v2: Status: Network was reconfigured: disconnect, and reconnect in 10 seconds
I (483086) time: Stopping SNTP client
I (483146) webserver: Stopping Web Server
I (483146) ssh: Stopping SSH Server

OVMS# 
I (483626) ovms-server-v2: Status: Server is ready to start

OVMS# 
I (486626) boot: Restart in 55 seconds (1 pending)...

OVMS# 
I (491626) simcom: State timeout, transition to 1
I (491626) simcom: State: Enter CheckPowerOff state
I (491626) boot: Restart in 50 seconds (1 pending)...

OVMS# 
I (493946) gsm-ppp: StatusCallBack: User Interrupt
I (493946) gsm-ppp: PPP connection has been closed

OVMS# 
I (496626) boot: Restart in 45 seconds (1 pending)...

OVMS# 
I (501626) boot: Restart in 40 seconds (1 pending)...

OVMS# 
I (506626) simcom: State timeout, transition to 13
I (506626) simcom: State: Enter PoweredOff state
I (506626) gsm-mux: Stop MUX
I (506626) boot: Restart now

OVMS# ets Jun  8 2016 00:22:57

rst:0xc (SW_CPU_RESET),boot:0x3b (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:0x3fff0018,len:4
load:0x3fff001c,len:4796
load:0x40078000,len:0
load:0x40078000,len:14896
entry 0x40078d74
I (920) psram: This chip is ESP32-D0WD
I (920) spiram: Found 32MBit SPI RAM device
I (920) spiram: SPI RAM mode: flash 40m sram 40m
I (923) spiram: PSRAM initialized, cache is in low/high (2-core) mode.
I (930) cpu_start: Pro cpu up.
I (934) cpu_start: Application information:
I (939) cpu_start: Project name:     ovms3
I (943) cpu_start: App version:      3.2.007-102-g07440970
I (950) cpu_start: Compile time:     Dec 12 2019 11:58:47
I (956) cpu_start: ELF file SHA256:  d151e36378c6be55...
I (962) cpu_start: ESP-IDF:          v3.3-beta3-774-g6652269e1
I (968) cpu_start: Starting app cpu, entry point is 0x40081820
I (960) cpu_start: App cpu up.
I (1853) spiram: SPI SRAM memory test OK
I (1854) heap_init: Initializing. RAM available for dynamic allocation:
I (1854) heap_init: At 3FFAE6E0 len 00001920 (6 KiB): DRAM
I (1861) heap_init: At 3FFBED50 len 000212B0 (132 KiB): DRAM
I (1866) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM
I (1873) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
I (1880) heap_init: At 4009918C len 00006E74 (27 KiB): IRAM
I (1886) cpu_start: Pro cpu start user code
I (1890) spiram: Adding pool of 4096K of external SPI memory to heap allocator
I (19) ovms_main: Set default logging level for * to INFO
I (20) command: Initialising COMMAND (1000)
I (21) boot: Initialising BOOT (1100)
I (24) boot: Boot #50 reasons for CPU0=12 and CPU1=12
I (29) boot: Reset reason Exception/panic (4)
I (35) boot: Soft reset by user
I (38) events: Initialising EVENTS (1200)
I (43) config: Initialising CONFIG (1400)
I (48) time: Initialising TIME (1500)
I (53) script: Initialising SCRIPTS (1600)
I (57) script: Using DUKTAPE javascript engine
I (63) metrics: Initialising METRICS (1810)
I (67) metrics: Expanding DUKTAPE javascript engine
I (77) notify: Initialising NOTIFICATIONS (1820)
I (79) notify: Registered notification type info
I (83) notify: Registered notification type error
I (88) notify: Registered notification type alert
I (94) notify: Registered notification type data
I (99) notify: Registered notification type stream
I (104) notify: Expanding DUKTAPE javascript engine
I (110) location: Initialising LOCATIONS (1900)
I (117) location: Expanding DUKTAPE javascript engine
I (121) vehicle: Initialising VEHICLE Factory (2000)
I (128) pcp: Initialising POWER (4000)
I (131) max7317: Initialising MAX7317 EGPIO (4200)
I (137) sdcard: Initialising SD CARD (4400)
I (142) ota: Initialising OTA (4400)
I (146) canformat: Initialising CAN Format Factory (4500)
I (152) canformat-crtd: Registering CAN Format: CRTD (4505)
I (158) canformat-gvret: Registering CAN Format: GVRET (4505)
I (164) canformat-lawricel: Registering CAN Format: LAWRICEL (4505)
I (171) canformat-pcap: Registering CAN Format: PCAP (4505)
I (178) canformat-raw: Registering CAN Format: RAW (4505)
I (184) can: Initialising CAN (4510)
I (191) dbc-app: Initialising DBC (4520)
I (194) canlog: Initialising CAN logging (4550)
I (198) canlog-monitor: Initialising CAN logging to MONITOR (4560)
I (205) canlog-tcpclient: Initialising CAN logging as TCP client (4560)
I (213) canlog-tcpserver: Initialising CAN logging as TCP server (4560)
I (220) canlog-vfs: Initialising CAN logging to VFS (4560)
I (226) canplay: Initialising CAN play framework (4570)
I (231) canplay-vfs: Initialising CAN playing from VFS (4580)
I (238) simcom: Initialising SIMCOM (4600)
I (243) test: Initialising TEST (5000)
I (247) module: Initialising MODULE (5100)
I (252) vfs: Initialising VFS (5200)
I (256) ovms-server: Initialising OVMS Server (6000)
I (262) ovms-server-v2: Initialising OVMS V2 Server (6100)
I (268) ovms-server-v3: Initialising OVMS V3 Server (6200)
I (274) obd2ecu: Initialising OBD2ECU (7000)
I (279) canopen: Initialising CANopen (7000)
I (285) esp32wifi: Initialising ESP32WIFI (8000)
I (289) ovms-mdns: Initialising MDNS (8100)
I (294) webserver: Initialising WEBSERVER (8200)
I (302) ssh: Initialising SSH (8300)
I (304) powermgmt: Initialising POWERMGMT (8500)
I (309) re: Initialising RE Tools (8800)
I (315) pushover: Initialising Pushover client (8800)
I (320) netmanager: Initialising NETMANAGER (8999)
I (328) v-zeva: Registering Vehicle: ZEVA (9000)
I (330) v-voltampera: Registering Vehicle: Volt/Ampera (9000)
I (336) v-track: Registering Vehicle: TRACK (9000)
I (342) v-thinkcity: Registering Vehicle: THINK CITY (9000)
I (348) v-teslaroadster: Registering Vehicle: Tesla Roadster (9000)
I (355) v-teslamodels: Registering Vehicle: Tesla Model S (9000)
I (362) v-teslamodel3: Registering Vehicle: Tesla Model 3 (9000)
I (368) v-smarteq: Registering Vehicle: SMART EQ (9000)
I (374) v-smarted: Registering Vehicle: SMART ED (9000)
I (380) v-zoe: Registering Vehicle: Renault Zoe (9000)
I (386) v-twizy: Registering Vehicle: Renault Twizy (9000)
I (392) v-obdii: Registering Vehicle: OBDII (9000)
I (398) v-none: Registering Vehicle: NONE (9000)
I (403) v-nissanleaf: Registering Vehicle: Nissan Leaf (9000)
I (409) v-mitsubishi: Registering Vehicle: Mitsubishi iMiEV, Citroen C-Zero, Peugeot iOn (9000)
I (419) v-kiasoulev: Registering Vehicle: Kia Soul EV (9000)
I (425) v-kianiroev: Registering Vehicle: Kia Niro / Hyundai Kona EV (9000)
I (433) v-fiat500e: Registering Vehicle: FIAT 500e (9000)
I (439) v-demo: Registering Vehicle: DEMO (9000)
I (444) vehicle_dbc: Registering Vehicle: DBC based vehicle (9000)
I (451) version: Initialising Versioning (9900)
I (460) cpu_start: Starting scheduler on PRO CPU.
I (0) cpu_start: Starting scheduler on APP CPU.
I (0) script: Duktape: Scripting task is running
I (546) ovms_main: Executing on CPU core 0
I (546) ovms_main: Mounting CONFIG...
I (596) ovms_main: Configure logging...
W (606) webserver: UpdateGlobalAuthFile: no password set => no auth for web console
I (606) ovms_main: Registering default configs...
I (606) ovms_main: Starting HOUSEKEEPING...
I (616) housekeeping: Initialising HOUSEKEEPING Framework...
I (616) housekeeping: Executing on CPU core 1
I (626) housekeeping: reset_reason: cpu0=12, cpu1=12
I (626) housekeeping: Initialising WATCHDOG...
I (636) housekeeping: Starting PERIPHERALS...
I (636) peripherals: Initialising OVMS Peripherals...
I (646) peripherals:   TCP/IP Adaptor
I (646) peripherals:   ESP32 system
I (656) peripherals:   SPI bus
I (656) peripherals:   MAX7317 I/O Expander
I (666) peripherals:   ESP32 CAN
I (666) peripherals:   ESP32 WIFI
E (666) can: can1: intr=1 rxpkt=0 txpkt=0 errflags=0x40caa rxerr=1 txerr=0 rxovr=0 txovr=0 txdelay=0 wdgreset=0 errreset=0
I (676) peripherals:   ESP32 ADC
I (686) peripherals:   MCP2515 CAN 1/2
I (686) mcp2515: can2: SetPowerMode off
I (776) peripherals:   MCP2515 CAN 2/2
I (776) mcp2515: can3: SetPowerMode off
I (856) peripherals:   SD CARD
I (856) peripherals:   SIMCOM MODEM
I (856) gpio: GPIO[13]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0 
I (866) gpio: GPIO[4]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0 
I (876) uart: queue free spaces: 50
I (876) ext12v: Powering off external 12V devices
I (886) housekeeping: Auto init max7317 (free: 182492 bytes)
I (886) housekeeping: Auto init ext12v (free: 182492 bytes)
I (896) ext12v: Powering on external 12V devices
I (896) housekeeping: Auto init dbc (free: 182492 bytes)
I (906) housekeeping: Auto init wifi (free: 182492 bytes)
I (916) esp32wifi: Powering up WIFI driver
I (946) wifi: wifi driver task: 3ffd44fc, prio:23, stack:3584, core=0
I (946) system_api: Base MAC address is not set, read default base MAC address from BLK0 of EFUSE
I (956) system_api: Base MAC address is not set, read default base MAC address from BLK0 of EFUSE
I (976) wifi: wifi firmware version: aeed694
I (976) wifi: config NVS flash: enabled
I (976) wifi: config nano formating: disabled
I (976) wifi: Init dynamic tx buffer num: 16
I (986) wifi: Init data frame dynamic rx buffer num: 16
I (986) wifi: Init management frame dynamic rx buffer num: 16
I (996) wifi: Init management short buffer num: 32
I (996) wifi: Init static rx buffer size: 2212
I (1006) wifi: Init static rx buffer num: 16
I (1006) wifi: Init dynamic rx buffer num: 16
I (1816) phy: phy_version: 4102, 2fa7a43, Jul 15 2019, 13:06:06, 0, 0
I (1816) wifi: mode : sta (30:ae:a4:43:92:88) + softAP (30:ae:a4:43:92:89)
I (1826) wifi: Total power save buffer number: 8
I (1826) wifi: Init max length of beacon: 752/752
I (1836) wifi: Init max length of beacon: 752/752
I (1836) housekeeping: Auto init modem (free: 131860 bytes)
I (1846) simcom: State: Enter PoweringOn state
I (1846) simcom: Power Cycle
I (2846) housekeeping: Auto init vehicle (free: 131068 bytes)
I (2846) v-teslaroadster: Tesla Roadster v1.x, v2.x and v3.0 vehicle module
I (2856) housekeeping: Auto init obd2ecu (free: 120368 bytes)
I (2956) mcp2515: can3: SetPowerMode on
E (2966) can: can1: intr=7 rxpkt=6 txpkt=0 errflags=0x80c00 rxerr=0 txerr=0 rxovr=0 txovr=0 txdelay=0 wdgreset=0 errreset=0
I (3056) housekeeping: Auto init server v2 (free: 113148 bytes)
I (3056) ovms-server-v2: OVMS Server V2 registered metric modifier is #1
I (3066) ovms-server-v2: Status: Server has been started
I (3066) ovms-server-v2: OVMS Server v2 running
I (3076) housekeeping: Auto init server v3 (free: 113040 bytes)
I (3076) housekeeping: Auto init javascript (free: 113040 bytes)
I (3086) housekeeping: Auto init done (free: 113040 bytes)
I (3096) housekeeping: Starting USB console...
I (3096) uart: queue free spaces: 100

Welcome to the Open Vehicle Monitoring System (OVMS) - Async Console
Firmware: 3.2.007-102-g07440970/ota_1/main
Hardware: OVMS WIFI BLE BT cores=2 rev=ESP32/1


OVMS# 
I (3116) script: Duktape: Creating heap
I (3116) script: Duktape: Initialising module system
E (3206) events: SignalEvent: queue overflow, event 'notify.info.charge.done' dropped
E (3206) events: SignalEvent: queue overflow, event 'vehicle.charge.mode' dropped
E (3236) events: SignalEvent: queue overflow, event 'vehicle.charge.prepare' dropped
E (3236) events: SignalEvent: queue overflow, event 'vehicle.charge.pilot.on' dropped

OVMS# 
I (3436) netmanager: WIFI access point is up
I (3436) esp32wifi: AP started with SSID: OVMS, MAC: 30:ae:a4:43:92:89, IP: 192.168.4.1
I (3496) ovms-mdns: Starting MDNS
I (3526) webserver: Launching Web Server
I (3526) ssh: Launching SSH Server

OVMS# 
I (4286) wifi: ap channel adjust o:1,1 n:6,2
I (4286) wifi: new:<6,0>, old:<1,0>, ap:<6,2>, sta:<6,0>, prof:1

OVMS# 
I (5006) wifi: state: init -> auth (b0)
I (5006) wifi: state: auth -> assoc (0)
I (5016) wifi: state: assoc -> run (10)
I (5046) wifi: connected with gregnet, channel 6, HT20, bssid = 40:b0:76:32:ea:70
I (5046) wifi: pm start, type: 1
I (5056) esp32wifi: STA connected with SSID: gregnet, BSSID: 40:b0:76:32:ea:70, Channel: 6, Auth: WPA2
I (5056) event: sta ip: 10.30.1.105, mask: 255.255.255.0, gw: 10.30.1.1
I (5066) netmanager: WIFI client got IP
I (5076) esp32wifi: STA got IP with SSID 'gregnet' AP 40:b0:76:32:ea:70: MAC: 30:ae:a4:43:92:88, IP: 10.30.1.105, mask: 255.255.255.0, gw: 10.30.1.1

OVMS# 
I (5626) sdcard: SD CARD has been inserted
I (5716) sdcard: mount done

OVMS# 
I (8626) netmanager: WIFI client has good signal quality (-85.0 dBm); connect
I (8626) netmanager: Interface priority is st1 (10.30.1.105/255.255.255.0 gateway 10.30.1.1)
I (8626) simcom: State: Enter PoweredOn state
I (8636) netmanager: Set DNS#0 9.9.9.9
I (8636) netmanager: Set DNS#1 8.8.8.8
I (8636) netmanager: WIFI client up (with MODEM down): starting network with WIFI client
I (8666) time: Starting SNTP client
I (8676) ovms-server-v2: Status: Network is up, so attempt network connection

OVMS# 
I (10626) ovms-server-v2: Connection is api.openvehicles.com:6867 ROADSTER834B
I (10626) ovms-server-v2: Status: Connecting...

OVMS# 
I (10976) housekeeping: System considered stable (RAM: 8b=71304-71432 32b=27560)

OVMS# 
I (11276) ovms-server-v2: Connection successful
I (11276) ovms-server-v2: Status: Logging in...
I (11276) ovms-server-v2: Sending server login: MP-C 0 v1t3wM96P8dMQuxap8ztnc HryerO1CXBZ9fRTgydB05w== ROADSTER834B

OVMS# 
I (11586) ovms-server-v2: Got server response: MP-S 0 2ljIfUTLHiFXAfCMeaDRB+ KPfCHSPZqweGw3SGo1AqFQ==
I (11586) ovms-server-v2: Server token is 2ljIfUTLHiFXAfCMeaDRB+ and digest is KPfCHSPZqweGw3SGo1AqFQ==
I (11586) ovms-server-v2: Status: Server authentication ok. Now priming crypto.
I (11586) ovms-server-v2: Shared secret key is 2ljIfUTLHiFXAfCMeaDRB+v1t3wM96P8dMQuxap8ztnc (44 bytes)
I (11586) ovms-server-v2: Status: OVMS V2 login successful, and crypto channel established
I (11606) ovms-server-v2: Incoming Msg: MP-0 Z0
I (11636) ovms-server-v2: Send MP-0 S93.0,M,1,0,done,standard,157,139,24,0,0,180,0,4,0,0,0,0,0.00,0,0,0,0,0,0,0,0,0,0,0,0,0.00,0.00,0
I (11636) ovms-server-v2: Send MP-0 D78,0,5,27,23,24,8067,529655,0,11,18,2,0,0,12.97,0,12.6,0,27,0,0
I (11646) ovms-server-v2: Send MP-0 L28.538242,-130.302567,251,0,0,0,0,8067,0,0.398,0,0
I (11646) ovms-server-v2: Send MP-0 W0,0,0,0,0,0,0,0,0
I (11646) ovms-server-v2: Send MP-0 F3.2.007-102-g07440970/ota_1/main (build idf v3.3-beta3-774-g6652269e1 Dec 12 2019 11:59:14),5YJRE1A16A1000834,17,1,TR2N,gregnet
I (11656) ovms-server-v2: Send MP-0 PINot charging|SOC: -|ODO: 52965.5M

OVMS# 
I (28626) simcom: State: Enter MuxStart state
I (28636) gsm-mux: Start MUX
I (28636) gsm-mux: Channel #0 is open
I (28646) gsm-mux: Channel #1 is open
I (28646) gsm-mux: Channel #2 is open
I (28656) gsm-mux: Channel #3 is open
I (28656) gsm-mux: Channel #4 is open

OVMS# 
I (29626) simcom: State: Enter NetWait state

OVMS# 
I (39706) simcom: CREG Network Registration: RegisteredRoaming

OVMS# 
I (40626) simcom: State: Enter NetStart state

OVMS# 
I (41656) simcom: PPP Connection is ready to start

OVMS# 
I (42626) simcom: State: Enter NetMode state
I (42626) gsm-ppp: Initialising...

OVMS# 
I (45186) gsm-ppp: StatusCallBack: None
I (45186) gsm-ppp: status_cb: Connected
I (45186) gsm-ppp:    our_ipaddr  = 10.52.33.103
I (45186) gsm-ppp:    his_ipaddr  = 10.64.64.64
I (45186) gsm-ppp:    netmask     = 255.255.255.255
I (45186) gsm-ppp:    DNS#0       = 212.9.0.135
I (45186) gsm-ppp:    DNS#1       = 212.9.0.136
I (45186) gsm-ppp:    our6_ipaddr = ::
I (45226) netmanager: MODEM up (with WIFI client up): staying with WIFI client priority

OVMS# 
I (60636) script: Duktape: Compacting DukTape memory

OVMS# 

OVMS# 

OVMS#          <----------- OBDII module attached at this time.  Removed after crash / Reboot

OVMS# 

OVMS# 

OVMS# Guru Meditation Error: Core  0 panic'ed (InstrFetchProhibited). Exception was unhandled.
Core 0 register dump:
PC      : 0x3ffcfda0  PS      : 0x00060b30  A0      : 0x800da765  A1      : 0x3ffc87a0  
A2      : 0x3ffdf764  A3      : 0x3ffc8818  A4      : 0x00000001  A5      : 0x3ffc8818  
A6      : 0x18004106  A7      : 0x55010019  A8      : 0x800da749  A9      : 0x3ffc8780  
A10     : 0x3ffdf764  A11     : 0x3ffc87a0  A12     : 0x3ffc87a4  A13     : 0x3f40c391  
A14     : 0x18004106  A15     : 0x55010019  SAR     : 0x00000003  EXCCAUSE: 0x00000014  
EXCVADDR: 0x3ffcfda0  LBEG    : 0x400908e0  LEND    : 0x4009090e  LCOUNT  : 0x00000000  

ELF file SHA256: d151e36378c6be55a27f666546ffda83f5bb9782230cd43031c731f46d49d0b2

Backtrace: 0x3ffcfda0:0x3ffc87a0 0x400da762:0x3ffc87d0 0x400da95b:0x3ffc87f0 0x400da901:0x3ffc8810

Rebooting...
ets Jun  8 2016 00:22:57

rst:0xc (SW_CPU_RESET),boot:0x3b (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:0x3fff0018,len:4
load:0x3fff001c,len:4796
load:0x40078000,len:0
load:0x40078000,len:14896
entry 0x40078d74
I (919) psram: This chip is ESP32-D0WD
I (920) spiram: Found 32MBit SPI RAM device
I (920) spiram: SPI RAM mode: flash 40m sram 40m
I (923) spiram: PSRAM initialized, cache is in low/high (2-core) mode.
I (930) cpu_start: Pro cpu up.
I (934) cpu_start: Application information:
I (938) cpu_start: Project name:     ovms3
I (943) cpu_start: App version:      3.2.007-102-g07440970
I (949) cpu_start: Compile time:     Dec 12 2019 11:58:47
I (956) cpu_start: ELF file SHA256:  d151e36378c6be55...
I (961) cpu_start: ESP-IDF:          v3.3-beta3-774-g6652269e1
I (968) cpu_start: Starting app cpu, entry point is 0x40081820
I (960) cpu_start: App cpu up.
I (1853) spiram: SPI SRAM memory test OK
I (1853) heap_init: Initializing. RAM available for dynamic allocation:
I (1854) heap_init: At 3FFAE6E0 len 00001920 (6 KiB): DRAM
I (1860) heap_init: At 3FFBED50 len 000212B0 (132 KiB): DRAM
I (1866) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM
I (1873) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
I (1880) heap_init: At 4009918C len 00006E74 (27 KiB): IRAM
I (1885) cpu_start: Pro cpu start user code
I (1890) spiram: Adding pool of 4096K of external SPI memory to heap allocator
I (19) ovms_main: Set default logging level for * to INFO
I (20) command: Initialising COMMAND (1000)
I (21) boot: Initialising BOOT (1100)
I (24) boot: Boot #51 reasons for CPU0=12 and CPU1=12
I (29) boot: Reset reason Exception/panic (4)
E (34) boot: Crash #1 detected
I (38) events: Initialising EVENTS (1200)
I (43) config: Initialising CONFIG (1400)
I (48) time: Initialising TIME (1500)
I (53) script: Initialising SCRIPTS (1600)
I (57) script: Using DUKTAPE javascript engine
I (63) metrics: Initialising METRICS (1810)
I (67) metrics: Expanding DUKTAPE javascript engine
I (77) notify: Initialising NOTIFICATIONS (1820)
I (78) notify: Registered notification type info
I (83) notify: Registered notification type error
I (88) notify: Registered notification type alert
I (93) notify: Registered notification type data
I (99) notify: Registered notification type stream
I (104) notify: Expanding DUKTAPE javascript engine
I (110) location: Initialising LOCATIONS (1900)
I (117) location: Expanding DUKTAPE javascript engine
I (121) vehicle: Initialising VEHICLE Factory (2000)
I (128) pcp: Initialising POWER (4000)
I (131) max7317: Initialising MAX7317 EGPIO (4200)
I (137) sdcard: Initialising SD CARD (4400)
I (141) ota: Initialising OTA (4400)
I (146) canformat: Initialising CAN Format Factory (4500)
I (151) canformat-crtd: Registering CAN Format: CRTD (4505)
I (158) canformat-gvret: Registering CAN Format: GVRET (4505)
I (164) canformat-lawricel: Registering CAN Format: LAWRICEL (4505)
I (171) canformat-pcap: Registering CAN Format: PCAP (4505)
I (177) canformat-raw: Registering CAN Format: RAW (4505)
I (183) can: Initialising CAN (4510)
I (190) dbc-app: Initialising DBC (4520)
I (194) canlog: Initialising CAN logging (4550)
I (198) canlog-monitor: Initialising CAN logging to MONITOR (4560)
I (205) canlog-tcpclient: Initialising CAN logging as TCP client (4560)
I (213) canlog-tcpserver: Initialising CAN logging as TCP server (4560)
I (220) canlog-vfs: Initialising CAN logging to VFS (4560)
I (225) canplay: Initialising CAN play framework (4570)
I (231) canplay-vfs: Initialising CAN playing from VFS (4580)
I (238) simcom: Initialising SIMCOM (4600)
I (243) test: Initialising TEST (5000)
I (247) module: Initialising MODULE (5100)
I (252) vfs: Initialising VFS (5200)
I (256) ovms-server: Initialising OVMS Server (6000)
I (261) ovms-server-v2: Initialising OVMS V2 Server (6100)
I (268) ovms-server-v3: Initialising OVMS V3 Server (6200)
I (274) obd2ecu: Initialising OBD2ECU (7000)
I (279) canopen: Initialising CANopen (7000)
I (285) esp32wifi: Initialising ESP32WIFI (8000)
I (289) ovms-mdns: Initialising MDNS (8100)
I (294) webserver: Initialising WEBSERVER (8200)
I (302) ssh: Initialising SSH (8300)
I (304) powermgmt: Initialising POWERMGMT (8500)
I (309) re: Initialising RE Tools (8800)
I (314) pushover: Initialising Pushover client (8800)
I (320) netmanager: Initialising NETMANAGER (8999)
I (328) v-zeva: Registering Vehicle: ZEVA (9000)
I (330) v-voltampera: Registering Vehicle: Volt/Ampera (9000)
I (336) v-track: Registering Vehicle: TRACK (9000)
I (341) v-thinkcity: Registering Vehicle: THINK CITY (9000)
I (348) v-teslaroadster: Registering Vehicle: Tesla Roadster (9000)
I (355) v-teslamodels: Registering Vehicle: Tesla Model S (9000)
I (361) v-teslamodel3: Registering Vehicle: Tesla Model 3 (9000)
I (368) v-smarteq: Registering Vehicle: SMART EQ (9000)
I (374) v-smarted: Registering Vehicle: SMART ED (9000)
I (380) v-zoe: Registering Vehicle: Renault Zoe (9000)
I (386) v-twizy: Registering Vehicle: Renault Twizy (9000)
I (392) v-obdii: Registering Vehicle: OBDII (9000)
I (397) v-none: Registering Vehicle: NONE (9000)
I (403) v-nissanleaf: Registering Vehicle: Nissan Leaf (9000)
I (409) v-mitsubishi: Registering Vehicle: Mitsubishi iMiEV, Citroen C-Zero, Peugeot iOn (9000)
I (418) v-kiasoulev: Registering Vehicle: Kia Soul EV (9000)
I (425) v-kianiroev: Registering Vehicle: Kia Niro / Hyundai Kona EV (9000)
I (432) v-fiat500e: Registering Vehicle: FIAT 500e (9000)
I (438) v-demo: Registering Vehicle: DEMO (9000)
I (444) vehicle_dbc: Registering Vehicle: DBC based vehicle (9000)
I (451) version: Initialising Versioning (9900)
I (460) cpu_start: Starting scheduler on PRO CPU.
I (0) cpu_start: Starting scheduler on APP CPU.
I (0) script: Duktape: Scripting task is running
I (546) ovms_main: Executing on CPU core 0
I (546) ovms_main: Mounting CONFIG...
I (596) ovms_main: Configure logging...
W (606) webserver: UpdateGlobalAuthFile: no password set => no auth for web console
I (606) ovms_main: Registering default configs...
I (606) ovms_main: Starting HOUSEKEEPING...
I (616) housekeeping: Initialising HOUSEKEEPING Framework...
I (616) housekeeping: Executing on CPU core 1
I (626) housekeeping: reset_reason: cpu0=12, cpu1=12
I (626) housekeeping: Initialising WATCHDOG...
I (636) housekeeping: Starting PERIPHERALS...
I (636) peripherals: Initialising OVMS Peripherals...
I (646) peripherals:   TCP/IP Adaptor
I (646) peripherals:   ESP32 system
I (656) peripherals:   SPI bus
I (656) peripherals:   MAX7317 I/O Expander
I (666) peripherals:   ESP32 CAN
I (666) peripherals:   ESP32 WIFI
I (676) peripherals:   ESP32 ADC
I (676) peripherals:   MCP2515 CAN 1/2
I (676) mcp2515: can2: SetPowerMode off
I (766) peripherals:   MCP2515 CAN 2/2
I (766) mcp2515: can3: SetPowerMode off
I (846) peripherals:   SD CARD
I (846) peripherals:   SIMCOM MODEM
I (846) gpio: GPIO[13]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0 
I (856) gpio: GPIO[4]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0 
I (866) uart: queue free spaces: 50
I (866) ext12v: Powering off external 12V devices
I (876) housekeeping: Auto init max7317 (free: 182492 bytes)
I (876) housekeeping: Auto init ext12v (free: 182492 bytes)
I (886) ext12v: Powering on external 12V devices
I (886) housekeeping: Auto init dbc (free: 182492 bytes)
I (896) housekeeping: Auto init wifi (free: 182492 bytes)
I (906) esp32wifi: Powering up WIFI driver
I (936) wifi: wifi driver task: 3ffd44fc, prio:23, stack:3584, core=0
I (936) system_api: Base MAC address is not set, read default base MAC address from BLK0 of EFUSE
I (936) system_api: Base MAC address is not set, read default base MAC address from BLK0 of EFUSE
I (966) wifi: wifi firmware version: aeed694
I (966) wifi: config NVS flash: enabled
I (966) wifi: config nano formating: disabled
I (966) wifi: Init dynamic tx buffer num: 16
I (976) wifi: Init data frame dynamic rx buffer num: 16
I (976) wifi: Init management frame dynamic rx buffer num: 16
I (986) wifi: Init management short buffer num: 32
I (986) wifi: Init static rx buffer size: 2212
I (996) wifi: Init static rx buffer num: 16
I (996) wifi: Init dynamic rx buffer num: 16
I (1806) phy: phy_version: 4102, 2fa7a43, Jul 15 2019, 13:06:06, 0, 0
I (1816) wifi: mode : sta (30:ae:a4:43:92:88) + softAP (30:ae:a4:43:92:89)
I (1816) wifi: Total power save buffer number: 8
I (1816) wifi: Init max length of beacon: 752/752
I (1826) wifi: Init max length of beacon: 752/752
I (1826) housekeeping: Auto init modem (free: 131860 bytes)
I (1836) simcom: State: Enter PoweringOn state
I (1836) simcom: Power Cycle
I (2506) simcom: State: Enter PoweredOn state
I (2846) housekeeping: Auto init vehicle (free: 131068 bytes)
I (2846) v-teslaroadster: Tesla Roadster v1.x, v2.x and v3.0 vehicle module
I (2856) housekeeping: Auto init obd2ecu (free: 120368 bytes)
I (2956) mcp2515: can3: SetPowerMode on
I (3056) housekeeping: Auto init server v2 (free: 113148 bytes)
I (3056) ovms-server-v2: OVMS Server V2 registered metric modifier is #1
I (3066) ovms-server-v2: Status: Server has been started
I (3066) ovms-server-v2: OVMS Server v2 running
I (3076) housekeeping: Auto init server v3 (free: 113040 bytes)
E (3076) can: can1: intr=6 rxpkt=5 txpkt=0 errflags=0x80c00 rxerr=0 txerr=0 rxovr=0 txovr=0 txdelay=0 wdgreset=0 errreset=0
I (3076) housekeeping: Auto init javascript (free: 113040 bytes)
I (3096) housekeeping: Auto init done (free: 113040 bytes)
I (3106) housekeeping: Starting USB console...
I (3106) uart: queue free spaces: 100

Welcome to the Open Vehicle Monitoring System (OVMS) - Async Console
Firmware: 3.2.007-102-g07440970/ota_1/main
Hardware: OVMS WIFI BLE BT cores=2 rev=ESP32/1


OVMS# 
I (3126) script: Duktape: Creating heap
I (3126) script: Duktape: Initialising module system

OVMS# 
I (3426) netmanager: WIFI access point is up
I (3426) esp32wifi: AP started with SSID: OVMS, MAC: 30:ae:a4:43:92:89, IP: 192.168.4.1
I (3486) ovms-mdns: Starting MDNS
I (3516) webserver: Launching Web Server
I (3516) ssh: Launching SSH Server

OVMS# 
I (4276) wifi: ap channel adjust o:1,1 n:6,2
I (4276) wifi: new:<6,0>, old:<1,0>, ap:<6,2>, sta:<6,0>, prof:1

OVMS# 
I (4996) wifi: state: init -> auth (b0)
I (5006) wifi: state: auth -> assoc (0)
I (5016) wifi: state: assoc -> run (10)
I (5036) wifi: connected with gregnet, channel 6, HT20, bssid = 40:b0:76:32:ea:70
I (5036) wifi: pm start, type: 1
I (5046) esp32wifi: STA connected with SSID: gregnet, BSSID: 40:b0:76:32:ea:70, Channel: 6, Auth: WPA2
I (5056) event: sta ip: 10.30.1.105, mask: 255.255.255.0, gw: 10.30.1.1
I (5066) netmanager: WIFI client got IP
I (5066) esp32wifi: STA got IP with SSID 'gregnet' AP 40:b0:76:32:ea:70: MAC: 30:ae:a4:43:92:88, IP: 10.30.1.105, mask: 255.255.255.0, gw: 10.30.1.1

OVMS# 
I (5626) sdcard: SD CARD has been inserted
I (5716) sdcard: mount done

OVMS# 
I (7626) netmanager: WIFI client has good signal quality (-86.4 dBm); connect
I (7626) netmanager: Interface priority is st1 (10.30.1.105/255.255.255.0 gateway 10.30.1.1)
I (7636) netmanager: Set DNS#0 9.9.9.9
I (7636) netmanager: Set DNS#1 8.8.8.8
I (7636) netmanager: WIFI client up (with MODEM down): starting network with WIFI client
I (7676) time: Starting SNTP client
I (7686) ovms-server-v2: Status: Network is up, so attempt network connection

OVMS# 
I (9626) ovms-server-v2: Connection is api.openvehicles.com:6867 ROADSTER834B
I (9626) ovms-server-v2: Status: Connecting...

OVMS# 
I (10096) ovms-server-v2: Connection successful
I (10106) ovms-server-v2: Status: Logging in...
I (10106) ovms-server-v2: Sending server login: MP-C 0 GVOcBBICxKcLy+SD4s/fD5 YfmEjLfGzvoXXZGuw01D6Q== ROADSTER834B

OVMS# 
I (10406) ovms-server-v2: Got server response: MP-S 0 qWTLyMqCU4TMRzDXBGb24H GWKItB3ws/s2NJAM2v959A==
I (10406) ovms-server-v2: Server token is qWTLyMqCU4TMRzDXBGb24H and digest is GWKItB3ws/s2NJAM2v959A==
I (10416) ovms-server-v2: Status: Server authentication ok. Now priming crypto.
I (10416) ovms-server-v2: Shared secret key is qWTLyMqCU4TMRzDXBGb24HGVOcBBICxKcLy+SD4s/fD5 (44 bytes)
I (10416) ovms-server-v2: Status: OVMS V2 login successful, and crypto channel established
I (10436) ovms-server-v2: Incoming Msg: MP-0 Z0
I (10626) ovms-server-v2: Send MP-0 S93.0,M,1,0,done,standard,157,139,24,0,0,180,0,4,0,0,0,0,0.00,0,0,0,0,0,0,0,0,0,0,0,0,0.00,0.00,0
I (10636) ovms-server-v2: Send MP-0 D78,0,5,0,0,0,8067,529655,0,10,0,2,0,0,13.01,0,12.6,0,0,0,0
I (10636) ovms-server-v2: Send MP-0 L28.538242,-130.302567,251,0,0,0,0,8067,0,0.398,0,0
I (10636) ovms-server-v2: Send MP-0 W0,0,0,0,0,0,0,0,0
I (10646) ovms-server-v2: Send MP-0 F3.2.007-102-g07440970/ota_1/main (build idf v3.3-beta3-774-g6652269e1 Dec 12 2019 11:59:14),5YJRE1A16A1000834,17,1,TR2N,gregnet
I (10646) ovms-server-v2: Send MP-0 PINot charging|SOC: -
I (10676) housekeeping: System considered stable (RAM: 8b=71432-71868 32b=27560)

OVMS# 
I (11626) ovms-server-v2: Send MP-0 h1,0,*-OVM-DebugCrash,0,2592000,3.2.007-102-g07440970/ota_1/main (build idf v3.3-beta3-774-g6652269e1 Dec 12 2019 11:59:14),51,Crash,12,12,1,0,InstrFetchProhibited,0,0x3ffcfda0 0x00060b30 0x800da765 0x3ffc87a0 0x3ffdf764 0x3ffc8818 0x00000001 0x3ffc8818 0x18004106 0x55010019 0x800da749 0x3ffc8780 0x3ffdf764 0x3ffc87a0 0x3ffc87a4 0x3f40c391 0x18004106 0x55010019 0x00000003 0x00000014 0x3ffcfda0 0x400908e0 0x4009090e 0x00000000 ,0x3ffcfda0 0x400da762 0x400da95b 0x400da901 ,4,Exception/panic

OVMS# 
I (11946) ovms-server-v2: Incoming Msg: MP-0 h1

OVMS# 
I (20626) simcom: State timeout, transition to 2
I (20626) simcom: State: Enter PoweringOn state
I (20626) simcom: Power Cycle

OVMS# 
I (27416) simcom: State: Enter PoweredOn state

OVMS# 


More information about the OvmsDev mailing list