dotnet / runtime

.NET is a cross-platform runtime for cloud, mobile, desktop, and IoT apps.
https://docs.microsoft.com/dotnet/core/
MIT License
15.06k stars 4.69k forks source link

[browser][MT] fail in System.Reflection.RuntimeMethodInfo.InternalInvoke #100831

Open pavelsavara opened 5 months ago

pavelsavara commented 5 months ago

Log

[15:39:24] fail: [0x04b98030-long 15:39:24.608] [MONO] * Assertion at /__w/1/s/src/mono/mono/metadata/loader.c:1821, condition `<disabled>' not met

                 Error
                     at cu (http://127.0.0.1:41877/_framework/dotnet.runtime.js:3:200949)
                     at wasm_trace_logger (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[199]:0x14a9a)
                     at eglib_log_adapter (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[693]:0x4bd37)
                     at monoeg_g_logv_nofree (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[615]:0x4a148)
                     at monoeg_assertion_message (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[619]:0x4a269)
                     at mono_assertion_message (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[621]:0x4a2ac)
                     at mono_assertion_message_disabled (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[620]:0x4a27f)
                     at mono_method_signature_checked_slow (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[2272]:0xbc715)
                     at mono_method_get_name_full (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[1741]:0x9c0c8)
                     at mono_method_full_name (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[1742]:0x9c2c2)
                     at mono_interp_exec_method (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[258]:0x186da)
                     at interp_runtime_invoke (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[297]:0x270dc)
                     at mono_jit_runtime_invoke (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[3348]:0xfd83c)
                     at do_runtime_invoke (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[2628]:0xd00ba)
                     at mono_runtime_invoke_checked (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[2627]:0xd004a)
                     at ves_icall_InternalInvoke_raw (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[1985]:0xaaa68)
                     at do_icall (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[338]:0x28e9d)
                     at do_icall_wrapper (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[267]:0x2644e)
                     at mono_interp_exec_method (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[258]:0x18d0c)
                     at interp_runtime_invoke (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[297]:0x270dc)
                     at mono_jit_runtime_invoke (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[3348]:0xfd83c)
                     at do_runtime_invoke (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[2628]:0xd00ba)
                     at mono_runtime_invoke_checked (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[2627]:0xd004a)
                     at start_wrapper (http://127.0.0.1:41877/_framework/dotnet.native.wasm:wasm-function[2776]:0xd7263)
                     at Object.invokeEntryPoint (http://127.0.0.1:41877/_framework/dotnet.native.js:8:69009)
                     at handleMessage (http://127.0.0.1:41877/_framework/dotnet.native.worker.js:1:2306)
[15:39:24] info: [PASS] System.ComponentModel.TypeConverterTests.SizeConverterTests.ConvertFromString
[15:39:24] info: [PASS] System.ComponentModel.TypeConverterTests.PointConverterTests.ConvertTo_NotSupportedException
[15:39:24] info: [PASS] System.ComponentModel.TypeConverterTests.PointConverterTests.ConvertTo_NotSupportedException
[15:39:24] info: [PASS] System.ComponentModel.TypeConverterTests.SizeConverterTests.ConvertFromString
[15:39:24] fail: 
[15:39:24] fail: ".NET Long Running Task" tid=0x4b98030 this=0x25b9040 , thread handle : 0x4ae8498, state : not waiting
[15:39:24] fail:   at <unknown> <0xffffffff>
[15:39:24] fail:   at (wrapper managed-to-native) System.Reflection.RuntimeMethodInfo.InternalInvoke (object,intptr*,System.Exception&) [0x0000c] in <58a57e6b50e74990b5e98f755629bb6f>:0
[15:39:24] fail:   at System.Reflection.MethodBaseInvoker.InterpretedInvoke_Method (object,intptr*) [0x00000] in <58a57e6b50e74990b5e98f755629bb6f>:0
[15:39:24] fail:   at System.Reflection.MethodBaseInvoker.InvokeDirectByRefWithFewArgs (object,System.Span`1<object>,System.Reflection.BindingFlags) [0x0007e] in <58a57e6b50e74990b5e98f755629bb6f>:0
[15:39:24] fail:   at System.Reflection.MethodBaseInvoker.InvokeWithFewArgs (object,System.Reflection.BindingFlags,System.Reflection.Binder,object[],System.Globalization.CultureInfo) [0x000bd] in <58a57e6b50e74990b5e98f755629bb6f>:0
[15:39:24] fail:   at System.Reflection.RuntimeMethodInfo.Invoke (object,System.Reflection.BindingFlags,System.Reflection.Binder,object[],System.Globalization.CultureInfo) [0x0007d] in <58a57e6b50e74990b5e98f755629bb6f>:0
[15:39:24] fail:   at Xunit.Sdk.TestInvoker`1<Xunit.Sdk.IXunitTestCase>.CallTestMethod (object) [0x0000d] in <db5648acc12e4b9da4b8c0adf0ec56ab>:0

Another Log

[15:39:10] fail: [0x05d50040-long 15:39:10.068] [MONO] /__w/1/s/src/mono/mono/mini/interp/interp.c:3737 <disabled>
                 Error
                     at cu (http://127.0.0.1:42115/_framework/dotnet.runtime.js:3:200949)
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[199]:0x14a9a
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[693]:0x4bd37
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[615]:0x4a148
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[617]:0x4a20b
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[618]:0x4a23e
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[258]:0x2525a
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[297]:0x270dc
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[3348]:0xfd83c
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[2628]:0xd00ba
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[2627]:0xd004a
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[1985]:0xaaa68
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[338]:0x28e9d
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[267]:0x2644e
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[258]:0x18d0c
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[297]:0x270dc
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[3348]:0xfd83c
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[2628]:0xd00ba
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[2627]:0xd004a
                     at http://127.0.0.1:42115/_framework/dotnet.native.wasm:wasm-function[2776]:0xd7263
                     at Object.invokeEntryPoint (http://127.0.0.1:42115/_framework/dotnet.native.js:8:69009)
                     at handleMessage (http://127.0.0.1:42115/_framework/dotnet.native.worker.js:1:2306)
                     at self.startWorker (http://127.0.0.1:42115/_framework/dotnet.native.worker.js:1:1514)
                     at run (http://127.0.0.1:42115/_framework/dotnet.native.js:8:181730)
                     at runCaller (http://127.0.0.1:42115/_framework/dotnet.native.js:8:181564)
                     at removeRunDependency (http://127.0.0.1:42115/_framework/dotnet.native.js:8:11270)
                     at http://127.0.0.1:42115/_framework/dotnet.native.js:8:14113
                     at Object.loadWasmModuleToAllWorkers (http://127.0.0.1:42115/_framework/dotnet.native.js:8:67153)
                     at receiveInstance (http://127.0.0.1:42115/_framework/dotnet.native.js:8:14082)
                     at Object.gu [as instantiateWasm] (http://127.0.0.1:42115/_framework/dotnet.runtime.js:3:234829)
[15:39:10] info: [PASS] Microsoft.Extensions.Http.DefaultHttpClientFactoryTest.Factory_CreateClient_WithExpiry_CanExpire
[15:39:10] info: [PASS] Microsoft.Extensions.DependencyInjection.HttpClientFactoryServiceCollectionExtensionsTest.AddHttpClient_WithTypedClient_AndDelegate_ConfiguresNamedClient
[15:39:10] fail: 
[15:39:10] fail: ".NET Long Running Task" tid=0x5d50040 this=0x257dd70 , thread handle : 0x4cf3d50, state : not waiting
[15:39:10] fail:   at <unknown> <0xffffffff>
[15:39:10] fail:   at (wrapper managed-to-native) System.Reflection.RuntimeMethodInfo.InternalInvoke (object,intptr*,System.Exception&) [0x0000c] in <58a57e6b50e74990b5e98f755629bb6f>:0
[15:39:10] fail:   at System.Reflection.MethodBaseInvoker.InterpretedInvoke_Method (object,intptr*) [0x00000] in <58a57e6b50e74990b5e98f755629bb6f>:0
[15:39:10] fail:   at System.Reflection.MethodBaseInvoker.InvokeWithNoArgs (object,System.Reflection.BindingFlags) [0x00024] in <58a57e6b50e74990b5e98f755629bb6f>:0
[15:39:10] fail:   at System.Reflection.RuntimeMethodInfo.Invoke (object,System.Reflection.BindingFlags,System.Reflection.Binder,object[],System.Globalization.CultureInfo) [0x0005b] in <58a57e6b50e74990b5e98f755629bb6f>:0
[15:39:10] fail:   at System.Reflection.MethodBase.Invoke (object,object[]) [0x00000] in <58a57e6b50e74990b5e98f755629bb6f>:0
[15:39:10] fail:   at Xunit.Sdk.TestInvoker`1<Xunit.Sdk.IXunitTestCase>.CallTestMethod (object) [0x00000] in <db5648acc12e4b9da4b8c0adf0ec56ab>:0
[15:39:10] fail:   at Xunit.Sdk.TestInvoker`1/<>c__DisplayClass48_0/<<InvokeTestMethodAsync>b__1>d<Xunit.Sdk.IXunitTestCase>.MoveNext () [0x00125] in <db5648acc12e4b9da4b8c0adf0ec56ab>:0

Build Information

Build: https://dev.azure.com/dnceng-public/public/_build/results?buildId=636336 Build error leg or test failing:

Error Message

Fill the error message using step by step known issues guidance.

{
  "ErrorMessage": "at (wrapper managed-to-native) System.Reflection.RuntimeMethodInfo.InternalInvoke",
  "BuildRetry": false,
  "ExcludeConsoleLog": false
}

Known issue validation

Build: :mag_right: https://dev.azure.com/dnceng-public/public/_build/results?buildId=636336 Error message validated: [at (wrapper managed-to-native) System.Reflection.RuntimeMethodInfo.InternalInvoke] Result validation: :white_check_mark: Known issue matched with the provided build. Validation performed at: 4/9/2024 5:57:07 PM UTC

Report

Build Definition Test Pull Request
827681 dotnet/runtime WasmTestOnChrome-MT-System.IO.FileSystem.Tests.WorkItemExecution
822595 dotnet/runtime WasmTestOnChrome-MT-System.Threading.Timer.Tests.WorkItemExecution dotnet/runtime#108370
822341 dotnet/runtime WasmTestOnFirefox-MT-System.Threading.Timer.Tests.WorkItemExecution dotnet/runtime#108370
822338 dotnet/runtime WasmTestOnChrome-MT-System.Threading.Tasks.Tests.WorkItemExecution dotnet/runtime#108370
815249 dotnet/runtime WasmTestOnFirefox-MT-System.Data.DataSetExtensions.Tests.WorkItemExecution
808884 dotnet/runtime WasmTestOnFirefox-MT-System.ComponentModel.TypeConverter.Tests.WorkItemExecution
807070 dotnet/runtime WasmTestOnChrome-MT-System.Net.WebSockets.Client.Tests.WorkItemExecution dotnet/runtime#107769
803799 dotnet/runtime WasmTestOnFirefox-MT-System.ServiceModel.Syndication.Tests.WorkItemExecution dotnet/runtime#107593
802262 dotnet/runtime WasmTestOnFirefox-MT-Microsoft.Extensions.Http.Tests.WorkItemExecution dotnet/runtime#107401
803056 dotnet/runtime WasmTestOnFirefox-MT-System.Net.Http.Json.Unit.Tests.WorkItemExecution dotnet/runtime#107593

Summary

24-Hour Hit Count 7-Day Hit Count 1-Month Count
1 4 10
dotnet-policy-service[bot] commented 5 months ago

Tagging subscribers to 'arch-wasm': @lewing See info in area-owners.md if you want to be subscribed.

pavelsavara commented 5 months ago

@kg any ideas what this is or what would be next step to investigate ?

kg commented 5 months ago

That error message pattern is probably too broad, I think it will match almost any wasm failure.

pavelsavara commented 1 week ago

Log

[21:11:08] warn: [0x01573b30-dpty 21:11:08.317] [MONO] Can't find custom attr constructor image: System.ComponentModel.TypeConverter.dll mtoken: 0x0a0003c5 due to: Could not load file or assembly 'System.Runtime.Loader, Version=9.0.0.0, Culture=neutral, PublicKeyToken=b03f5f7f11d50a3a' or one of its dependencies.
[21:11:08] fail: [0x01573b30-dpty 21:11:08.368] [MONO] * Assertion at /__w/1/s/src/mono/mono/metadata/assembly.c:1673, condition `is_ok (error)' not met, function:mono_assembly_load_friends, Could not load file or assembly 'System.Runtime.Loader, Version=9.0.0.0, Culture=neutral, PublicKeyToken=b03f5f7f11d50a3a' or one of its dependencies.

                 Wl<@mono_wasm_synchronization_context_pump (http://127.0.0.1:37751/_framework/dotnet.runtime.js:3:199500