search

chipsalliance / caliptra-sw

Caliptra software (ROM, FMC, runtime firmware), and libraries/tools needed to build and test
Apache License 2.0
52 stars 39 forks source link

Verilator test failure: caliptra-runtime::ecdsa ecdsa_cmd_run_wycheproof #852

Closed korran closed 10 months ago

korran commented 1 year ago

Looks to be an unexpected NMI error; maybe the watchdog firing?

The runtime should add additional instrumentation to its trap handler to make it easier to diagnose, similar to what the ROM does:

https://github.com/chipsalliance/caliptra-sw/blob/4bacc8fc47402d331d6528e245d673524a27e738/rom/dev/src/main.rs#L248

2023-09-20T06:21:48.3612914Z         FAIL [47284.303s] caliptra-runtime::ecdsa ecdsa_cmd_run_wycheproof
2023-09-20T06:21:48.3613428Z 
2023-09-20T06:21:48.3614123Z --- STDOUT:              caliptra-runtime::ecdsa ecdsa_cmd_run_wycheproof ---
2023-09-20T06:21:48.3614583Z 
2023-09-20T06:21:48.3619285Z running 1 test
2023-09-20T06:21:48.3620190Z       6,155 ready_for_fuses is high
2023-09-20T06:21:48.3620920Z       6,333 writing to cptra_bootfsm_go
2023-09-20T06:21:48.3625193Z test ecdsa_cmd_run_wycheproof has been running for over 60 seconds
2023-09-20T06:21:48.3625901Z     195,201 UART: 
2023-09-20T06:21:48.3627019Z     195,256 UART: Running Caliptra ROM ...
2023-09-20T06:21:48.3627755Z     196,662 UART: 
2023-09-20T06:21:48.3628458Z     202,819 UART: [state] CFI Enabled
2023-09-20T06:21:48.3629219Z     205,066 UART: [state] LifecycleState = Unprovisioned
2023-09-20T06:21:48.3639438Z     207,326 UART: [state] DebugLocked = No
2023-09-20T06:21:48.3640557Z     209,534 UART: [state] Watchdog Timer is not started because the device is not locked for debugging
2023-09-20T06:21:48.3642225Z     356,026 UART: ROM Digest: BBB6BA0BFBA2F1E2103A1060EB333FF6613A1F43E352AA823F62EF22650FF80F
2023-09-20T06:21:48.3643161Z     367,266 UART: [kat] ++
2023-09-20T06:21:48.3643755Z     367,778 UART: [kat] sha1
2023-09-20T06:21:48.3644622Z     376,938 UART: [kat] SHA2-256
2023-09-20T06:21:48.3645467Z     379,810 UART: [kat] SHA2-384
2023-09-20T06:21:48.3646078Z     384,075 UART: [kat] SHA2-384-ACC
2023-09-20T06:21:48.3646694Z     386,372 UART: [kat] ECC-384
2023-09-20T06:21:48.3647378Z   3,956,726 UART: [kat] HMAC-384
2023-09-20T06:21:48.3647920Z   3,967,778 UART: [kat] LMS
2023-09-20T06:21:48.3648645Z   5,069,580 UART: [kat] --
2023-09-20T06:21:48.3649427Z   5,072,497 UART: [cold-reset] ++
2023-09-20T06:21:48.3650074Z   5,075,119 UART: [idev] ++
2023-09-20T06:21:48.3650905Z   5,075,698 UART: [idev] CDI.KEYID = 6
2023-09-20T06:21:48.3651663Z   5,076,948 UART: [idev] SUBJECT.KEYID = 7
2023-09-20T06:21:48.3654781Z   5,078,420 UART: [idev] UDS.KEYID = 0
2023-09-20T06:21:48.3656179Z   5,095,715 UART: [idev] Erasing UDS.KEYID = 0
2023-09-20T06:21:48.3657037Z   8,365,879 UART: [idev] Using Sha1 for KeyId Algorithm
2023-09-20T06:21:48.3657549Z   8,387,957 UART: [idev] --
2023-09-20T06:21:48.3657811Z   8,391,516 UART: [ldev] ++
2023-09-20T06:21:48.3658110Z   8,392,109 UART: [ldev] CDI.KEYID = 6
2023-09-20T06:21:48.3658452Z   8,393,351 UART: [ldev] SUBJECT.KEYID = 5
2023-09-20T06:21:48.3658781Z   8,394,823 UART: [ldev] AUTHORITY.KEYID = 7
2023-09-20T06:21:48.3659279Z   8,396,405 UART: [ldev] FE.KEYID = 1
2023-09-20T06:21:48.3659695Z   8,410,196 UART: [ldev] Erasing FE.KEYID = 1
2023-09-20T06:21:48.3660111Z  11,696,727 UART: [ldev] Signing Cert with AUTHORITY.KEYID = 7
2023-09-20T06:21:48.3660707Z  15,292,162 UART: [ldev] PUB.X = 504D38CA45D997901F48BA333A149A2FB2668B973AAC64D3B79ECC09A663F02ED2FABA133F5FA499677AEB7687C99B25
2023-09-20T06:21:48.3661682Z  15,307,860 UART: [ldev] PUB.Y = A5CD31125698B3322C086E4398A591946BF20A3ECEA8EB7D7C23410D49FA877E7ECFBE47BD883BD53D7DA865AC217F1D
2023-09-20T06:21:48.3662439Z  15,323,930 UART: [ldev] SIG.R = 14B5D494DF875AC7CEE9FE3E9A6168A6B64BFB01171F5ECC5216C8BB945FAF957CED1BE6C7CFBB1DDB2B7F4BFD76A492
2023-09-20T06:21:48.3663160Z  15,339,842 UART: [ldev] SIG.S = 821D8CC92F40AFF934771D7652C9BC3C59D47E5635E110A8486B76F7433B02B3C6B0FD8B1B6548B5994C481547111FC5
2023-09-20T06:21:48.3663688Z  15,361,245 UART: [ldev] --
2023-09-20T06:21:48.3663972Z  15,368,037 ready_for_fw is high
2023-09-20T06:21:48.3664331Z  15,368,039 <<< Executing mbox cmd 0x46574c44 (63908 bytes) from SoC
2023-09-20T06:21:48.3664705Z  15,368,098 UART: [fwproc] Waiting for Commands...
2023-09-20T06:21:48.3665089Z  15,404,534 UART: [fwproc] Received command 0x46574c44
2023-09-20T06:21:48.3665481Z  15,407,148 UART: [fwproc] Received Image of size 63908 bytes
2023-09-20T06:21:48.3665881Z  18,126,406 UART: [fwproc] Image verified using Vendor ECC Key Index 0
2023-09-20T06:21:48.3666849Z  18,204,273 UART: [fwproc] Loading FMC at address 0x40000000 len 12964
2023-09-20T06:21:48.3667324Z  18,285,679 UART: [fwproc] Loading Runtime at address 0x40004000 len 45060
2023-09-20T06:21:48.3667684Z  18,560,324 >>> mbox cmd response: success
2023-09-20T06:21:48.3668000Z  18,564,071 UART: [afmc] ++
2023-09-20T06:21:48.3668289Z  18,564,650 UART: [afmc] CDI.KEYID = 6
2023-09-20T06:21:48.3668605Z  18,565,900 UART: [afmc] SUBJECT.KEYID = 7
2023-09-20T06:21:48.3668921Z  18,567,358 UART: [afmc] AUTHORITY.KEYID = 5
2023-09-20T06:21:48.3669301Z  21,880,120 UART: [afmc] Signing Cert with AUTHORITY.KEYID = 5
2023-09-20T06:21:48.3669700Z  24,174,793 UART: [afmc] Erasing AUTHORITY.KEYID = 5
2023-09-20T06:21:48.3670300Z  25,483,075 UART: [afmc] PUB.X = 74A2DA8F43E3CF7B034EB91F9FEBBBEBD3F2BB8B9B15CCF6B2944AE9C548D4ACDD20742598EA46075F5EE3D570A3C884
2023-09-20T06:21:48.3671081Z  25,498,863 UART: [afmc] PUB.Y = F0B6D79EFAF624F13C60ACE8287337FA10B411125D5F76A85844E286F5E554EBD2D1B41B1DFB30A078203A651EFE8C34
2023-09-20T06:21:48.3671785Z  25,514,771 UART: [afmc] SIG.R = 8C94183EECD46495965C1F58565A801C567721535D1E46E8FBD8FE28C4361A17C85DDA0427F22D62A34CAFBA60DE91CF
2023-09-20T06:21:48.3672489Z  25,530,436 UART: [afmc] SIG.S = 57083EFAA8C09D86B408ABDEB8120F3A0A87C9C1DAD6EA4940C67CDFEED457B052E07185C310A798191C6F16BBB24B74
2023-09-20T06:21:48.3673071Z  25,558,650 UART: [afmc] --
2023-09-20T06:21:48.3673443Z  25,562,645 UART: [cold-reset] --
2023-09-20T06:21:48.3673761Z  25,577,676 UART: [fht] Storing FHT @ 0x50003400
2023-09-20T06:21:48.3674223Z  25,593,564 UART: [state] Watchdog Timer is not stopped because the device is not locked for debugging
2023-09-20T06:21:48.3674646Z  25,599,650 UART: [state] Locking Datavault
2023-09-20T06:21:48.3675006Z  25,604,836 UART: [state] Locking PCR0, PCR1 and PCR31
2023-09-20T06:21:48.3675351Z  25,606,912 UART: [state] Locking ICCM
2023-09-20T06:21:48.3675667Z  25,609,168 UART: [exit] Launching FMC @ 0x40000134
2023-09-20T06:21:48.3675974Z  25,617,978 UART: 
2023-09-20T06:21:48.3676310Z  25,618,012 UART: Running Caliptra FMC ...
2023-09-20T06:21:48.3676621Z  25,618,855 UART: 
2023-09-20T06:21:48.3677085Z  25,621,847 UART: [alias rt] Extend RT PCRs
2023-09-20T06:21:48.3677640Z  25,654,931 UART: [alias rt] Extend RT PCRs Done
2023-09-20T06:21:48.3678302Z  25,655,972 UART: [alias rt] Lock RT PCRs
2023-09-20T06:21:48.3678638Z  25,656,782 UART: [alias rt] Lock RT PCRs Done
2023-09-20T06:21:48.3678966Z  25,657,761 UART: [alias rt] Populate DV
2023-09-20T06:21:48.3679289Z  25,658,660 UART: [alias rt] Populate DV Done
2023-09-20T06:21:48.3679620Z  25,659,641 UART: Handoff : FMC CDI: 6
2023-09-20T06:21:48.3680104Z  25,660,409 UART: FMC Alias Private Key: 7
2023-09-20T06:21:48.3680465Z  25,662,319 UART: [alias rt] Derive CDI
2023-09-20T06:21:48.3680787Z  25,663,061 UART: [alias rt] Store in in slot 0x4
2023-09-20T06:21:48.3681129Z  25,696,801 UART: [alias rt] Derive Key Pair
2023-09-20T06:21:48.3681487Z  25,697,709 UART: [alias rt] Store priv key in slot 0x5
2023-09-20T06:21:48.3682161Z  28,936,909 UART: [alias rt] Derive Key Pair - Done
2023-09-20T06:21:48.3682528Z  28,947,920 UART: [alias rt] Signing Cert with AUTHO
2023-09-20T06:21:48.3682867Z  28,949,087 UART:             RITY.KEYID = 7
2023-09-20T06:21:48.3683220Z  31,227,209 UART: [alias rt] Erasing AUTHORITY.KEYID = 7
2023-09-20T06:21:48.3683748Z  31,228,719 UART: [alias rt] PUB.X = DF3393787B3E9A4B786B518FCAEE494488A8356DC92A6862B160D8F9D106575593235419CF5C9E3B323F88893D7E3209
2023-09-20T06:21:48.3684486Z  31,236,122 UART: [alias rt] PUB.Y = A1F7CEA89F6EE3D4F0F87084DDD6EF4FC843E7C495A4A62388ACF801E950FE547CBB3E130E05DC9D16DE0982E90C3BB3
2023-09-20T06:21:48.3685258Z  31,243,728 UART: [alias rt] SIG.R = 5CA2D5E23848047EEA0B9C4E8BB05E80C6BED7A94841E3F9D36168EF631A04E148BA02FF24FF353BC0166F7998F01D40
2023-09-20T06:21:48.3685988Z  31,251,127 UART: [alias rt] SIG.S = 894CA02731DBF435F5DA90EF908BDD2F88DB800F1BD014CB6D16C07E0C263CDE523D4B88B58CD1207981A8277BECBEB9
2023-09-20T06:21:48.3686532Z  32,554,681 UART: 
2023-09-20T06:21:48.3686837Z  32,554,714 UART:   ____      _ _       _               ____ _____
2023-09-20T06:21:48.3687194Z  32,556,347 UART:  / ___|__ _| (_)_ __ | |_ _ __ __ _  |  _ \_   _|
2023-09-20T06:21:48.3687637Z  32,558,013 UART: | |   / _` | | | '_ \| __| '__/ _` | | |_) || |
2023-09-20T06:21:48.3687991Z  32,559,612 UART: | |__| (_| | | | |_) | |_| | | (_| | |  _ < | |
2023-09-20T06:21:48.3688340Z  32,561,211 UART:  \____\__,_|_|_| .__/ \__|_|  \__,_| |_| \_\|_|
2023-09-20T06:21:48.3688633Z  32,562,810 UART:                |_|
2023-09-20T06:21:48.3688892Z  32,563,452 UART: 
2023-09-20T06:21:48.3689227Z  32,660,050 UART: Caliptra RT listening for mailbox commands...
2023-09-20T06:21:48.3689613Z  32,661,751 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3689990Z  32,667,725 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3690349Z  33,961,854 >>> mbox cmd response data (8 bytes)
2023-09-20T06:21:48.3690718Z  33,962,007 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3691078Z  33,967,953 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3691434Z  35,261,927 >>> mbox cmd response data (8 bytes)
2023-09-20T06:21:48.3691800Z  35,262,081 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3692146Z  35,268,028 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3692488Z  35,271,563 >>> mbox cmd response: failed
2023-09-20T06:21:48.3692839Z  35,271,713 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3693191Z  35,277,651 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3693532Z  36,568,353 >>> mbox cmd response: failed
2023-09-20T06:21:48.3693885Z  36,568,505 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3694253Z  36,574,452 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3694570Z  37,865,150 >>> mbox cmd response: failed
2023-09-20T06:21:48.3694923Z  37,865,300 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3695293Z  37,871,245 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3695609Z  39,161,937 >>> mbox cmd response: failed
2023-09-20T06:21:48.3696074Z  39,162,084 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3696500Z  39,168,024 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3696814Z  40,458,717 >>> mbox cmd response: failed
2023-09-20T06:21:48.3697164Z  40,458,866 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3697531Z  40,464,813 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3697944Z  40,468,342 >>> mbox cmd response: failed
2023-09-20T06:21:48.3698281Z  40,468,493 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3698646Z  40,474,439 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3698981Z  40,478,113 >>> mbox cmd response: failed
2023-09-20T06:21:48.3699440Z  40,478,264 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3699915Z  40,484,211 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3702349Z  41,774,905 >>> mbox cmd response: failed
2023-09-20T06:21:48.3702701Z  41,775,056 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3703079Z  41,781,004 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3703434Z  43,071,699 >>> mbox cmd response: failed
2023-09-20T06:21:48.3703766Z  43,071,848 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3704135Z  43,077,795 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3704475Z  43,081,467 >>> mbox cmd response: failed
2023-09-20T06:21:48.3704825Z  43,081,614 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3705191Z  43,087,555 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3705536Z  44,378,249 >>> mbox cmd response: failed
2023-09-20T06:21:48.3705896Z  44,378,400 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3706251Z  44,384,347 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3706679Z  45,675,040 >>> mbox cmd response: failed
2023-09-20T06:21:48.3707035Z  45,675,191 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3707386Z  45,681,137 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3707720Z  46,971,828 >>> mbox cmd response: failed
2023-09-20T06:21:48.3708071Z  46,971,977 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3708423Z  46,977,915 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3708762Z  48,268,609 >>> mbox cmd response: failed
2023-09-20T06:21:48.3709119Z  48,268,756 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3709488Z  48,274,693 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3709817Z  48,278,220 >>> mbox cmd response: failed
2023-09-20T06:21:48.3710173Z  48,278,369 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3710548Z  48,284,316 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3710870Z  48,287,840 >>> mbox cmd response: failed
2023-09-20T06:21:48.3711224Z  48,287,990 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3711595Z  48,293,927 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3711913Z  48,297,450 >>> mbox cmd response: failed
2023-09-20T06:21:48.3712264Z  48,297,598 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3712634Z  48,303,538 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3712970Z  48,307,062 >>> mbox cmd response: failed
2023-09-20T06:21:48.3713308Z  48,307,209 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3713684Z  48,313,149 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3714026Z  48,316,674 >>> mbox cmd response: failed
2023-09-20T06:21:48.3714363Z  48,316,823 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3714738Z  48,322,770 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3715085Z  48,326,293 >>> mbox cmd response: failed
2023-09-20T06:21:48.3715582Z  48,326,444 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3715965Z  48,332,391 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3716313Z  48,335,915 >>> mbox cmd response: failed
2023-09-20T06:21:48.3716708Z  48,336,062 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3717061Z  48,342,003 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3717886Z  48,345,527 >>> mbox cmd response: failed
2023-09-20T06:21:48.3718553Z  48,345,676 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3718910Z  48,351,624 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3721849Z  48,355,363 >>> mbox cmd response: failed
2023-09-20T06:21:48.3722430Z  48,355,511 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3723054Z  48,361,448 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3723737Z  49,652,280 >>> mbox cmd response: failed
2023-09-20T06:21:48.3724379Z  49,652,429 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3725218Z  49,658,376 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3726021Z  50,949,205 >>> mbox cmd response: failed
2023-09-20T06:21:48.3726851Z  50,949,353 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3727206Z  50,955,293 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3727554Z  50,959,134 >>> mbox cmd response: failed
2023-09-20T06:21:48.3727910Z  50,959,284 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3728264Z  50,965,230 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3728605Z  52,256,262 >>> mbox cmd response: failed
2023-09-20T06:21:48.3728961Z  52,256,410 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3729317Z  52,262,347 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3730576Z  52,266,190 >>> mbox cmd response: failed
2023-09-20T06:21:48.3731013Z  52,266,341 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3731414Z  52,272,289 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3731753Z  52,276,008 >>> mbox cmd response: failed
2023-09-20T06:21:48.3732125Z  52,276,156 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3732522Z  52,282,094 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3732866Z  52,285,809 >>> mbox cmd response: failed
2023-09-20T06:21:48.3733246Z  52,285,959 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3733633Z  52,291,897 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3733967Z  52,295,639 >>> mbox cmd response: failed
2023-09-20T06:21:48.3734341Z  52,295,790 <<< Executing mbox cmd 0x53494756 (196 bytes) from SoC
2023-09-20T06:21:48.3734734Z  52,301,737 UART: [rt] Received command=0x53494756, len=196
2023-09-20T06:21:48.3735141Z  52,671,693 UART: RT NMI mcause=0x00000000 mscause=0x00000000 mepc=0x40005098
2023-09-20T06:21:48.3735515Z  52,673,782 UART: RT Fatal Error: 0x000E000B
2023-09-20T06:21:48.3736192Z  52,675,766 >>> mbox cmd response: failed
2023-09-20T06:21:48.3736536Z test ecdsa_cmd_run_wycheproof ... FAILED
2023-09-20T06:21:48.3736732Z 
2023-09-20T06:21:48.3736828Z failures:
2023-09-20T06:21:48.3736975Z 
2023-09-20T06:21:48.3737067Z failures:
2023-09-20T06:21:48.3737348Z     ecdsa_cmd_run_wycheproof
2023-09-20T06:21:48.3737578Z 
2023-09-20T06:21:48.3737840Z test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 47284.28s
2023-09-20T06:21:48.3738150Z 
2023-09-20T06:21:48.3738156Z 
2023-09-20T06:21:48.3738820Z --- STDERR:              caliptra-runtime::ecdsa ecdsa_cmd_run_wycheproof ---
2023-09-20T06:21:48.3745029Z thread 'ecdsa_cmd_run_wycheproof' panicked at 'called `Result::unwrap()` on an `Err` value: UnableToLockSha512Acc', runtime/tests/ecdsa.rs:80:18
2023-09-20T06:21:48.3745922Z note: run with `RUST_BACKTRACE=1` environment variable to display a backtrace
korran commented 11 months ago

Based on what I'm seeing on the FPGA, this appears to have been fixed by #938

FerralCoder commented 10 months ago

can we close this?

zhalvorsen commented 10 months ago

I agree with @korran