Skip to content
New issue

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

Sign up for GitHub

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

Already on GitHub? Sign in to your account

Jump to bottom

test_pthread_c11_threads_proxied is flaky #22490

Open
sbc100 opened this issue Sep 3, 2024 · 0 comments
Open

test_pthread_c11_threads_proxied is flaky #22490

sbc100 opened this issue Sep 3, 2024 · 0 comments

Comments

@sbc100
Copy link
Collaborator

sbc100 commented Sep 3, 2024

e.g.: https://logs.chromium.org/logs/emscripten-releases/buildbucket/cr-buildbucket/8738005946718947137/+/u/Emscripten_testsuite__wasm64l_/stdout

======================================================================
FAIL: test_pthread_c11_threads_proxied (test_core.wasm64l)
----------------------------------------------------------------------
Traceback (most recent call last):
  File "/home/chrome-bot/.cache/.vpython-root/store/cpython+om91v4af6p3vd80bvh1mrrm980/contents/lib/python3.8/unittest/case.py", line 60, in testPartExecutor
    yield
  File "/home/chrome-bot/.cache/.vpython-root/store/cpython+om91v4af6p3vd80bvh1mrrm980/contents/lib/python3.8/unittest/case.py", line 676, in run
    self._callTestMethod(testMethod)
  File "/home/chrome-bot/.cache/.vpython-root/store/cpython+om91v4af6p3vd80bvh1mrrm980/contents/lib/python3.8/unittest/case.py", line 633, in _callTestMethod
    method()
  File "/b/s/w/ir/x/w/install/emscripten/test/common.py", line 771, in resulting_test
    return func(self, *args)
  File "/b/s/w/ir/x/w/install/emscripten/test/common.py", line 330, in decorated
    f(self, *args, **kwargs)
  File "/b/s/w/ir/x/w/install/emscripten/test/test_core.py", line 9131, in test_pthread_c11_threads
    self.do_run_in_out_file_test('pthread/test_pthread_c11_threads.c')
  File "/b/s/w/ir/x/w/install/emscripten/test/common.py", line 1771, in do_run_in_out_file_test
    output = self._build_and_run(srcfile, expected, **kwargs)
  File "/b/s/w/ir/x/w/install/emscripten/test/common.py", line 1809, in _build_and_run
    js_output = self.run_js(js_file, engine, args,
  File "/b/s/w/ir/x/w/install/emscripten/test/common.py", line 1404, in run_js
    self.fail('JS subprocess failed (%s): %s (expected=%s).  Output:\n%s' % (error.cmd, error.returncode, assert_returncode, ret))
  File "/home/chrome-bot/.cache/.vpython-root/store/cpython+om91v4af6p3vd80bvh1mrrm980/contents/lib/python3.8/unittest/case.py", line 753, in fail
    raise self.failureException(msg)
AssertionError: JS subprocess failed (/b/s/w/ir/cache/builder/emscripten-releases/node-v20.14.0-linux-x64/bin/node --stack-trace-limit=50 --trace-uncaught /b/s/w/ir/x/t/emtest_5lbt141g/emscripten_test_wasm64l_dr3ge4qy/test_pthread_c11_threads.js): 1 (expected=0).  Output:
locateFile: test_pthread_c11_threads.wasm scriptDirectory: /b/s/w/ir/x/t/emtest_5lbt141g/emscripten_test_wasm64l_dr3ge4qy/
asynchronously preparing wasm
run() called, but dependencies remain, so not running
initRuntime
threadInitTLS
runtimeKeepalivePush -> counter=1
createThread: 0x00012be0
Allocating a new web worker from /b/s/w/ir/x/t/emtest_5lbt141g/emscripten_test_wasm64l_dr3ge4qy/test_pthread_c11_threads.js
main thread called exit(0): keepRuntimeAlive=true (counter=1)
proc_exit: 0
handleException: unwinding: EXITSTATUS=0
run() called, but dependencies remain, so not running
worker: loading module
initRuntime
establishStackSpace: 0x000230d0 -> 0x000130d0
threadInitTLS
invokeEntryPoint: 0x00000006
thrd_current: 0x12be0
maybeExit: user callback done: runtimeKeepaliveCounter=1
createThread: 0x00024a10
createThread: 0x00024a10
Allocating a new web worker from /b/s/w/ir/x/t/emtest_5lbt141g/emscripten_test_wasm64l_dr3ge4qy/test_pthread_c11_threads.js
maybeExit: user callback done: runtimeKeepaliveCounter=1
createThread: 0x00035ba0
createThread: 0x00035ba0
Allocating a new web worker from /b/s/w/ir/x/t/emtest_5lbt141g/emscripten_test_wasm64l_dr3ge4qy/test_pthread_c11_threads.js
maybeExit: user callback done: runtimeKeepaliveCounter=1
createThread: 0x00046d30
createThread: 0x00046d30
Allocating a new web worker from /b/s/w/ir/x/t/emtest_5lbt141g/emscripten_test_wasm64l_dr3ge4qy/test_pthread_c11_threads.js
maybeExit: user callback done: runtimeKeepaliveCounter=1
createThread: 0x00057ec0
createThread: 0x00057ec0
Allocating a new web worker from /b/s/w/ir/x/t/emtest_5lbt141g/emscripten_test_wasm64l_dr3ge4qy/test_pthread_c11_threads.js
maybeExit: user callback done: runtimeKeepaliveCounter=1
run() called, but dependencies remain, so not running
worker: loading module
initRuntime
establishStackSpace: 0x00034f00 -> 0x00024f00
threadInitTLS
invokeEntryPoint: 0x00000003
in thread_main 0x24a10
maybeExit: user callback done: runtimeKeepaliveCounter=1
in do_once
maybeExit: user callback done: runtimeKeepaliveCounter=1
destructor: 0x24a10
maybeExit: user callback done: runtimeKeepaliveCounter=1
run() called, but dependencies remain, so not running
run() called, but dependencies remain, so not running
worker: loading module
initRuntime
establishStackSpace: 0x00057220 -> 0x00047220
threadInitTLS
invokeEntryPoint: 0x00000003
in thread_main 0x46d30
maybeExit: user callback done: runtimeKeepaliveCounter=1
destructor: 0x46d30
maybeExit: user callback done: runtimeKeepaliveCounter=1
worker: loading module
initRuntime
establishStackSpace: 0x00046090 -> 0x00036090
threadInitTLS
invokeEntryPoint: 0x00000003
in thread_main 0x35ba0
maybeExit: user callback done: runtimeKeepaliveCounter=1
destructor: 0x35ba0
maybeExit: user callback done: runtimeKeepaliveCounter=1
run() called, but dependencies remain, so not running
worker: loading module
initRuntime
establishStackSpace: 0x000683b0 -> 0x000583b0
threadInitTLS
invokeEntryPoint: 0x00000003
in thread_main 0x57ec0
maybeExit: user callback done: runtimeKeepaliveCounter=1
destructor: 0x57ec0
maybeExit: user callback done: runtimeKeepaliveCounter=1
_emscripten_thread_cleanup: 0x00024a10
cleanupThread: 0x00024a10
t1 joined
maybeExit: user callback done: runtimeKeepaliveCounter=1
_emscripten_thread_cleanup: 0x00035ba0
t2 joined
maybeExit: user callback done: runtimeKeepaliveCounter=1
_emscripten_thread_cleanup: 0x00046d30
cleanupThread: 0x00035ba0
cleanupThread: 0x00046d30
t3 joined
maybeExit: user callback done: runtimeKeepaliveCounter=1
_emscripten_thread_cleanup: 0x00057ec0
cleanupThread: 0x00057ec0
t4 joined
maybeExit: user callback done: runtimeKeepaliveCounter=1
createThread: 0x00024a10
createThread: 0x00024a10
maybeExit: user callback done: runtimeKeepaliveCounter=1
establishStackSpace: 0x00034f00 -> 0x00024f00
threadInitTLS
invokeEntryPoint: 0x00000004
_emscripten_thread_cleanup: 0x00024a10
createThread: 0x00034f20
createThread: 0x00034f20
maybeExit: user callback done: runtimeKeepaliveCounter=1
worker: Pthread 0x0 completed its main entry point with an 'unwind', keeping the worker alive for asynchronous operation.
cleanupThread: 0x00024a10
establishStackSpace: 0x00045410 -> 0x00035410
threadInitTLS
invokeEntryPoint: 0x00000005
in thread_main_detached 0x34f20
maybeExit: user callback done: runtimeKeepaliveCounter=1
done!
_emscripten_thread_cleanup: 0x00034f20
maybeExit: user callback done: runtimeKeepaliveCounter=1
Pthread 0x00012be0 called exit(0), posting exitOnMainThread.
cleanupThread: 0x00034f20
worker: Pthread 0x12be0 completed its main entry point with an 'unwind', keeping the worker alive for asynchronous operation.
exitOnMainThread
runtimeKeepalivePop -> counter=0
main thread called exit(0): keepRuntimeAlive=false (counter=0)
exitRuntime
terminateAllThreads
terminateWorker: undefined
terminateWorker: undefined
terminateWorker: undefined
terminateWorker: undefined
terminateWorker: undefined
proc_exit: 0
terminateAllThreads

node:internal/event_target:1099
  process.nextTick(() => { throw err; });
                           ^
ExitStatus {
  name: 'ExitStatus',
  message: 'Program terminated with exit(0)',
  status: 0
}
Thrown at:
    at node:internal/event_target:1099:28
    at processTicksAndRejections (node:internal/process/task_queues:77:11)


Node.js v20.14.0

and


======================================================================
FAIL: test_pthread_c11_threads_proxied (test_core.core0)
----------------------------------------------------------------------
Traceback (most recent call last):
  File "C:\Users\chrome-bot\AppData\Local\.vpython-root\store\cpython+ml1s5c39krmoj92702hi8ng33o\contents\bin\Lib\unittest\case.py", line 60, in testPartExecutor
    yield
  File "C:\Users\chrome-bot\AppData\Local\.vpython-root\store\cpython+ml1s5c39krmoj92702hi8ng33o\contents\bin\Lib\unittest\case.py", line 676, in run
    self._callTestMethod(testMethod)
  File "C:\Users\chrome-bot\AppData\Local\.vpython-root\store\cpython+ml1s5c39krmoj92702hi8ng33o\contents\bin\Lib\unittest\case.py", line 633, in _callTestMethod
    method()
  File "C:\b\s\w\ir\x\w\install\emscripten\test\common.py", line 771, in resulting_test
    return func(self, *args)
  File "C:\b\s\w\ir\x\w\install\emscripten\test\common.py", line 330, in decorated
    f(self, *args, **kwargs)
  File "C:\b\s\w\ir\x\w\install\emscripten\test\test_core.py", line 9131, in test_pthread_c11_threads
    self.do_run_in_out_file_test('pthread/test_pthread_c11_threads.c')
  File "C:\b\s\w\ir\x\w\install\emscripten\test\common.py", line 1771, in do_run_in_out_file_test
    output = self._build_and_run(srcfile, expected, **kwargs)
  File "C:\b\s\w\ir\x\w\install\emscripten\test\common.py", line 1809, in _build_and_run
    js_output = self.run_js(js_file, engine, args,
  File "C:\b\s\w\ir\x\w\install\emscripten\test\common.py", line 1404, in run_js
    self.fail('JS subprocess failed (%s): %s (expected=%s).  Output:\n%s' % (error.cmd, error.returncode, assert_returncode, ret))
  File "C:\Users\chrome-bot\AppData\Local\.vpython-root\store\cpython+ml1s5c39krmoj92702hi8ng33o\contents\bin\Lib\unittest\case.py", line 753, in fail
    raise self.failureException(msg)
AssertionError: JS subprocess failed (C:/b/s/w/ir/cache/builder/emscripten-releases/node-v20.14.0-win-x64/node.exe --stack-trace-limit=50 --trace-uncaught C:\b\s\w\ir\x\t\emtest_ivq2ig90\emscripten_test_core0_xqz4unt9\test_pthread_c11_threads.js): 1 (expected=0).  Output:
w:0,t:0x00000000: locateFile: test_pthread_c11_threads.wasm scriptDirectory: C:\b\s\w\ir\x\t\emtest_ivq2ig90\emscripten_test_core0_xqz4unt9/
w:0,t:0x00000000: asynchronously preparing wasm
w:0,t:0x00000000: run() called, but dependencies remain, so not running
w:0,t:0x00000000: writeStackCookie: 0x00000000
w:0,t:0x00000000: initRuntime
w:0,t:0x00000000: checkStackCookie: 0x00000000
w:0,t:0x000116a4: threadInitTLS
w:0,t:0x000116a4: checkStackCookie: 0x00000000
w:0,t:0x000116a4: runtimeKeepalivePush -> counter=1
w:0,t:0x000116a4: createThread: 0x00012870
w:0,t:0x000116a4: Allocating a new web worker from C:\b\s\w\ir\x\t\emtest_ivq2ig90\emscripten_test_core0_xqz4unt9\test_pthread_c11_threads.js
w:0,t:0x000116a4: main thread called exit(0): keepRuntimeAlive=true (counter=1)
w:0,t:0x000116a4: proc_exit: 0
w:0,t:0x000116a4: handleException: unwinding: EXITSTATUS=0
w:0,t:0x000116a4: checkStackCookie: 0x00000000
w:0,t:0x000116a4: checkStackCookie: 0x00000000
w:0,t:0x00000000: run() called, but dependencies remain, so not running
w:1,t:0x00000000: worker: loading module
w:1,t:0x00000000: initRuntime
w:1,t:0x00000000: establishStackSpace: 0x00022b00 -> 0x00012b00
w:1,t:0x00000000: writeStackCookie: 0x00012b00
w:1,t:0x00012870: threadInitTLS
w:1,t:0x00012870: invokeEntryPoint: 0x00000006
thrd_current: 0x12870
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:1,t:0x00012870: createThread: 0x000237b8
w:0,t:0x000116a4: createThread: 0x000237b8
w:0,t:0x000116a4: Allocating a new web worker from C:\b\s\w\ir\x\t\emtest_ivq2ig90\emscripten_test_core0_xqz4unt9\test_pthread_c11_threads.js
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:1,t:0x00012870: createThread: 0x000340a8
w:0,t:0x000116a4: createThread: 0x000340a8
w:0,t:0x000116a4: Allocating a new web worker from C:\b\s\w\ir\x\t\emtest_ivq2ig90\emscripten_test_core0_xqz4unt9\test_pthread_c11_threads.js
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:1,t:0x00012870: createThread: 0x00044998
w:0,t:0x000116a4: createThread: 0x00044998
w:0,t:0x000116a4: Allocating a new web worker from C:\b\s\w\ir\x\t\emtest_ivq2ig90\emscripten_test_core0_xqz4unt9\test_pthread_c11_threads.js
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:1,t:0x00012870: createThread: 0x00055288
w:0,t:0x000116a4: createThread: 0x00055288
w:0,t:0x000116a4: Allocating a new web worker from C:\b\s\w\ir\x\t\emtest_ivq2ig90\emscripten_test_core0_xqz4unt9\test_pthread_c11_threads.js
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:0,t:0x00000000: run() called, but dependencies remain, so not running
w:2,t:0x00000000: worker: loading module
w:2,t:0x00000000: initRuntime
w:2,t:0x00000000: establishStackSpace: 0x00033a50 -> 0x00023a50
w:2,t:0x00000000: writeStackCookie: 0x00023a50
w:2,t:0x000237b8: threadInitTLS
w:2,t:0x000237b8: invokeEntryPoint: 0x00000003
in thread_main 0x237b8
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
in do_once
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:2,t:0x000237b8: checkStackCookie: 0x00023a50
destructor: 0x237b8
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:0,t:0x00000000: run() called, but dependencies remain, so not running
w:3,t:0x00000000: worker: loading module
w:3,t:0x00000000: initRuntime
w:3,t:0x00000000: establishStackSpace: 0x00044340 -> 0x00034340
w:3,t:0x00000000: writeStackCookie: 0x00034340
w:3,t:0x000340a8: threadInitTLS
w:3,t:0x000340a8: invokeEntryPoint: 0x00000003
in thread_main 0x340a8
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:3,t:0x000340a8: checkStackCookie: 0x00034340
destructor: 0x340a8
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:0,t:0x00000000: run() called, but dependencies remain, so not running
w:5,t:0x00000000: worker: loading module
w:5,t:0x00000000: initRuntime
w:5,t:0x00000000: establishStackSpace: 0x00065520 -> 0x00055520
w:5,t:0x00000000: writeStackCookie: 0x00055520
w:5,t:0x00055288: threadInitTLS
w:5,t:0x00055288: invokeEntryPoint: 0x00000003
in thread_main 0x55288
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:5,t:0x00055288: checkStackCookie: 0x00055520
destructor: 0x55288
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:0,t:0x00000000: run() called, but dependencies remain, so not running
w:4,t:0x00000000: worker: loading module
w:4,t:0x00000000: initRuntime
w:4,t:0x00000000: establishStackSpace: 0x00054c30 -> 0x00044c30
w:4,t:0x00000000: writeStackCookie: 0x00044c30
w:4,t:0x00044998: threadInitTLS
w:4,t:0x00044998: invokeEntryPoint: 0x00000003
in thread_main 0x44998
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:4,t:0x00044998: checkStackCookie: 0x00044c30
w:1,t:0x00012870: _emscripten_thread_cleanup: 0x000237b8
destructor: 0x44998
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:0,t:0x000116a4: cleanupThread: 0x000237b8
t1 joined
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:1,t:0x00012870: _emscripten_thread_cleanup: 0x000340a8
w:0,t:0x000116a4: cleanupThread: 0x000340a8
t2 joined
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:1,t:0x00012870: _emscripten_thread_cleanup: 0x00044998
w:0,t:0x000116a4: cleanupThread: 0x00044998
t3 joined
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:1,t:0x00012870: _emscripten_thread_cleanup: 0x00055288
w:0,t:0x000116a4: cleanupThread: 0x00055288
t4 joined
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:1,t:0x00012870: createThread: 0x000237b8
w:0,t:0x000116a4: createThread: 0x000237b8
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:5,t:0x00000000: establishStackSpace: 0x00033a50 -> 0x00023a50
w:5,t:0x00000000: writeStackCookie: 0x00023a50
w:5,t:0x000237b8: threadInitTLS
w:5,t:0x000237b8: invokeEntryPoint: 0x00000004
w:1,t:0x00012870: _emscripten_thread_cleanup: 0x000237b8
w:1,t:0x00012870: createThread: 0x00033a60
w:5,t:0x00000000: worker: Pthread 0x0 completed its main entry point with an 'unwind', keeping the worker alive for asynchronous operation.
w:0,t:0x000116a4: cleanupThread: 0x000237b8
w:0,t:0x000116a4: createThread: 0x00033a60
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:5,t:0x00000000: establishStackSpace: 0x00043cf0 -> 0x00033cf0
w:5,t:0x00000000: writeStackCookie: 0x00033cf0
w:5,t:0x00033a60: threadInitTLS
w:5,t:0x00033a60: invokeEntryPoint: 0x00000005
in thread_main_detached 0x33a60
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:5,t:0x00033a60: checkStackCookie: 0x00033cf0
done!
w:5,t:0x00000000: _emscripten_thread_cleanup: 0x00033a60
w:1,t:0x00012870: Pthread 0x00012870 called exit(0), posting exitOnMainThread.
w:0,t:0x000116a4: maybeExit: user callback done: runtimeKeepaliveCounter=1
w:0,t:0x000116a4: cleanupThread: 0x00033a60
w:1,t:0x00012870: worker: Pthread 0x12870 completed its main entry point with an 'unwind', keeping the worker alive for asynchronous operation.
w:0,t:0x000116a4: exitOnMainThread
w:0,t:0x000116a4: runtimeKeepalivePop -> counter=0
w:0,t:0x000116a4: main thread called exit(0): keepRuntimeAlive=false (counter=0)
w:0,t:0x000116a4: exitRuntime
w:0,t:0x000116a4: checkStackCookie: 0x00000000
w:0,t:0x000116a4: terminateAllThreads
w:0,t:0x000116a4: terminateWorker: 1
w:0,t:0x000116a4: terminateWorker: 2
w:0,t:0x000116a4: terminateWorker: 3
w:0,t:0x000116a4: terminateWorker: 4
w:0,t:0x000116a4: terminateWorker: 5
w:0,t:0x00000000: proc_exit: 0
w:0,t:0x00000000: terminateAllThreads

node:internal/event_target:1099
  process.nextTick(() => { throw err; });
                           ^
ExitStatus {
  name: 'ExitStatus',
  message: 'Program terminated with exit(0)',
  status: 0
}
Thrown at:
    at node:internal/event_target:1099:28
    at processTicksAndRejections (node:internal/process/task_queues:77:11)


Node.js v20.14.0
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
1 participant
@sbc100