=== Test case: ct_verbosity_SUITE:possible_deadlock/1 (click for source code)

=== Config value:

    [{trace_level,50},
     {ct_opts,[]},
     {ct_node,ct@83faf2a59a6b},
     {path_dirs,["/buildroot/otp/lib/common_test/make_test_dir/common_test_test/ct_verbosity_SUITE_data/"]},
     {watchdog,<0.126311.0>},
     {tc_logfile,"/buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/ct_verbosity_suite.possible_deadlock.html"},
     {tc_group_properties,[]},
     {tc_group_path,[]},
     {data_dir,"/buildroot/otp/lib/common_test/make_test_dir/common_test_test/ct_verbosity_SUITE_data/"},
     {priv_dir,"/buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/"},
     {nodenames,[]}]

=== Current directory is "/buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58"

=== Started at 2025-03-06 21:19:26



See Common Test logs here:

/buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/all_runs.html
/buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/index.html

Event receiver <21038.1151.0> started!


[RUN #1] Calling ct:run_test([{logdir,
                                  "/buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/"},
                              {net_dir,[]},
                              {event_handler,
                                  {[ct_test_support_eh,simple_evh],
                                   [{cbm,ct_test_support},{trace_level,50}]}},
                              {suite,
                                  "/buildroot/otp/lib/common_test/make_test_dir/common_test_test/ct_verbosity_SUITE_data/io_test_SUITE"},
                              {label,possible_deadlock}]) on ct@83faf2a59a6b


Common Test starting (cwd is /buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58)


Event Handler ct_test_support_eh started with [{cbm,ct_test_support},
                                               {trace_level,50}]

Event handler simple_evh started!


Common Test: Running make in test directories...


CWD set to: "/buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/ct_run.ct@83faf2a59a6b.2025-03-06_21.19.26"


TEST INFO: 1 test(s), 9 case(s) in 1 suite(s)


Testing common_test_test.ct_verbosity_SUITE_data.io_test_SUITE: Starting test, 9 test cases


----------------------------------------------------
2025-03-06 21:19:26.659
test_stats: {1,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:26.665
ct:pal(default)



----------------------------------------------------
2025-03-06 21:19:26.665
ct:pal(default,50)



----------------------------------------------------
error 2025-03-06 21:19:26.665
ct:pal(error)



----------------------------------------------------
error 2025-03-06 21:19:26.665
ct:pal(error,50)



----------------------------------------------------
2025-03-06 21:19:26.666
ct:pal(default,1)



----------------------------------------------------
error 2025-03-06 21:19:26.666
ct:pal(error,1)



----------------------------------------------------
2025-03-06 21:19:26.666
ct:pal(default,99)



----------------------------------------------------
error 2025-03-06 21:19:26.666
ct:pal(error,99)



----------------------------------------------------
2025-03-06 21:19:26.688
test_stats: {2,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:26.694
ct:print(default)



----------------------------------------------------
2025-03-06 21:19:26.694
ct:print(default,50)



----------------------------------------------------
error 2025-03-06 21:19:26.694
ct:print(error)



----------------------------------------------------
error 2025-03-06 21:19:26.695
ct:print(error,50)



----------------------------------------------------
2025-03-06 21:19:26.695
ct:print(default,1)



----------------------------------------------------
error 2025-03-06 21:19:26.695
ct:print(error,1)



----------------------------------------------------
2025-03-06 21:19:26.695
ct:print(default,99)



----------------------------------------------------
error 2025-03-06 21:19:26.695
ct:print(error,99)



----------------------------------------------------
2025-03-06 21:19:26.717
test_stats: {3,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:26.754
ct:pal(default)



----------------------------------------------------
2025-03-06 21:19:26.755
ct:print(default)



----------------------------------------------------
2025-03-06 21:19:26.755
ct:pal(default,50)



----------------------------------------------------
2025-03-06 21:19:26.755
ct:print(default,50)



----------------------------------------------------
error 2025-03-06 21:19:26.755
ct:pal(error)



----------------------------------------------------
error 2025-03-06 21:19:26.755
ct:print(error)



----------------------------------------------------
error 2025-03-06 21:19:26.755
ct:pal(error,50)



----------------------------------------------------
error 2025-03-06 21:19:26.755
ct:print(error,50)



----------------------------------------------------
2025-03-06 21:19:26.755
ct:pal(default,1)



----------------------------------------------------
2025-03-06 21:19:26.756
ct:print(default,1)



----------------------------------------------------
error 2025-03-06 21:19:26.756
ct:pal(error,1)



----------------------------------------------------
error 2025-03-06 21:19:26.756
ct:print(error,1)



----------------------------------------------------
2025-03-06 21:19:26.756
ct:print(default,99)



----------------------------------------------------
2025-03-06 21:19:26.756
ct:pal(default,99)



----------------------------------------------------
error 2025-03-06 21:19:26.756
ct:print(error,99)



----------------------------------------------------
error 2025-03-06 21:19:26.756
ct:pal(error,99)



----------------------------------------------------
2025-03-06 21:19:26.778
test_stats: {4,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:26.779
test_stats: {5,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:26.780
test_stats: {6,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:26.787
ct:pal(default)



----------------------------------------------------
2025-03-06 21:19:26.787
ct:print(default)



----------------------------------------------------
2025-03-06 21:19:26.787
ct:pal(default,50)



----------------------------------------------------
2025-03-06 21:19:26.787
ct:print(default,50)



----------------------------------------------------
error 2025-03-06 21:19:26.788
ct:pal(error)



----------------------------------------------------
error 2025-03-06 21:19:26.788
ct:print(error)



----------------------------------------------------
error 2025-03-06 21:19:26.788
ct:pal(error,50)



----------------------------------------------------
error 2025-03-06 21:19:26.788
ct:print(error,50)



----------------------------------------------------
2025-03-06 21:19:26.788
ct:print(default,1)



----------------------------------------------------
2025-03-06 21:19:26.788
ct:pal(default,1)



----------------------------------------------------
error 2025-03-06 21:19:26.789
ct:print(error,1)



----------------------------------------------------
error 2025-03-06 21:19:26.789
ct:pal(error,1)



----------------------------------------------------
2025-03-06 21:19:26.789
ct:print(default,99)



----------------------------------------------------
error 2025-03-06 21:19:26.789
ct:print(error,99)



----------------------------------------------------
2025-03-06 21:19:26.789
ct:pal(default,99)



----------------------------------------------------
error 2025-03-06 21:19:26.789
ct:pal(error,99)



----------------------------------------------------
2025-03-06 21:19:26.811
test_stats: {7,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:26.812
test_stats: {8,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:26.812
test_stats: {9,0,{0,0}}



Testing common_test_test.ct_verbosity_SUITE_data.io_test_SUITE: TEST COMPLETE, 9 ok, 0 failed of 9 test cases


Updating /buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/index.html ... 
done

Updating /buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/all_runs.html ... 
done


[RUN #1] Got return value {9,0,{0,0}} after 2234 ms

Saving start opts on ct@83faf2a59a6b: [{halt_with,
                                        {ct_test_support,ct_test_halt}},
                                       {logdir,
                                        "/buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/"},
                                       {net_dir,[]},
                                       {event_handler,
                                        {[ct_test_support_eh,simple_evh],
                                         [{cbm,ct_test_support},
                                          {trace_level,50}]}},
                                       {suite,
                                        "/buildroot/otp/lib/common_test/make_test_dir/common_test_test/ct_verbosity_SUITE_data/io_test_SUITE"},
                                       {label,possible_deadlock}]

[RUN #2] Calling ct_run:script_start() on ct@83faf2a59a6b


Common Test v1.27.7 starting (cwd is /buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58)


Event Handler ct_test_support_eh started with [{cbm,ct_test_support},
                                               {trace_level,50}]

Event handler simple_evh started!


Common Test: Running make in test directories...


CWD set to: "/buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/ct_run.ct@83faf2a59a6b.2025-03-06_21.19.28"


TEST INFO: 1 test(s), 9 case(s) in 1 suite(s)


Testing common_test_test.ct_verbosity_SUITE_data.io_test_SUITE: Starting test, 9 test cases


----------------------------------------------------
2025-03-06 21:19:28.906
test_stats: {1,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:28.913
ct:pal(default)



----------------------------------------------------
2025-03-06 21:19:28.913
ct:pal(default,50)



----------------------------------------------------
error 2025-03-06 21:19:28.913
ct:pal(error)



----------------------------------------------------
error 2025-03-06 21:19:28.913
ct:pal(error,50)



----------------------------------------------------
2025-03-06 21:19:28.913
ct:pal(default,1)



----------------------------------------------------
error 2025-03-06 21:19:28.913
ct:pal(error,1)



----------------------------------------------------
2025-03-06 21:19:28.914
ct:pal(default,99)



----------------------------------------------------
error 2025-03-06 21:19:28.914
ct:pal(error,99)



----------------------------------------------------
2025-03-06 21:19:28.936
test_stats: {2,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:28.942
ct:print(default)



----------------------------------------------------
2025-03-06 21:19:28.943
ct:print(default,50)



----------------------------------------------------
error 2025-03-06 21:19:28.943
ct:print(error)



----------------------------------------------------
error 2025-03-06 21:19:28.943
ct:print(error,50)



----------------------------------------------------
2025-03-06 21:19:28.943
ct:print(default,1)



----------------------------------------------------
error 2025-03-06 21:19:28.943
ct:print(error,1)



----------------------------------------------------
2025-03-06 21:19:28.943
ct:print(default,99)



----------------------------------------------------
error 2025-03-06 21:19:28.943
ct:print(error,99)



----------------------------------------------------
2025-03-06 21:19:28.965
test_stats: {3,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:29.004
ct:pal(default)



----------------------------------------------------
2025-03-06 21:19:29.004
ct:print(default)



----------------------------------------------------
2025-03-06 21:19:29.004
ct:pal(default,50)



----------------------------------------------------
2025-03-06 21:19:29.004
ct:print(default,50)



----------------------------------------------------
error 2025-03-06 21:19:29.005
ct:pal(error)



----------------------------------------------------
error 2025-03-06 21:19:29.005
ct:print(error)



----------------------------------------------------
error 2025-03-06 21:19:29.005
ct:print(error,50)



----------------------------------------------------
error 2025-03-06 21:19:29.005
ct:pal(error,50)



----------------------------------------------------
2025-03-06 21:19:29.005
ct:print(default,1)



----------------------------------------------------
2025-03-06 21:19:29.005
ct:pal(default,1)



----------------------------------------------------
error 2025-03-06 21:19:29.005
ct:print(error,1)



----------------------------------------------------
error 2025-03-06 21:19:29.006
ct:pal(error,1)



----------------------------------------------------
2025-03-06 21:19:29.006
ct:print(default,99)



----------------------------------------------------
2025-03-06 21:19:29.006
ct:pal(default,99)



----------------------------------------------------
error 2025-03-06 21:19:29.006
ct:print(error,99)



----------------------------------------------------
error 2025-03-06 21:19:29.006
ct:pal(error,99)



----------------------------------------------------
2025-03-06 21:19:29.025
test_stats: {4,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:29.028
test_stats: {5,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:29.029
test_stats: {6,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:29.034
ct:pal(default)



----------------------------------------------------
2025-03-06 21:19:29.034
ct:pal(default,50)



----------------------------------------------------
2025-03-06 21:19:29.034
ct:print(default)



----------------------------------------------------
error 2025-03-06 21:19:29.034
ct:pal(error)



----------------------------------------------------
2025-03-06 21:19:29.034
ct:print(default,50)



----------------------------------------------------
error 2025-03-06 21:19:29.035
ct:pal(error,50)



----------------------------------------------------
error 2025-03-06 21:19:29.035
ct:print(error)



----------------------------------------------------
2025-03-06 21:19:29.035
ct:pal(default,1)



----------------------------------------------------
error 2025-03-06 21:19:29.035
ct:print(error,50)



----------------------------------------------------
error 2025-03-06 21:19:29.035
ct:pal(error,1)



----------------------------------------------------
2025-03-06 21:19:29.035
ct:print(default,1)



----------------------------------------------------
error 2025-03-06 21:19:29.036
ct:print(error,1)



----------------------------------------------------
2025-03-06 21:19:29.036
ct:pal(default,99)



----------------------------------------------------
2025-03-06 21:19:29.036
ct:print(default,99)



----------------------------------------------------
error 2025-03-06 21:19:29.036
ct:pal(error,99)



----------------------------------------------------
error 2025-03-06 21:19:29.036
ct:print(error,99)



----------------------------------------------------
2025-03-06 21:19:29.058
test_stats: {7,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:29.059
test_stats: {8,0,{0,0}}




----------------------------------------------------
2025-03-06 21:19:29.059
test_stats: {9,0,{0,0}}



Testing common_test_test.ct_verbosity_SUITE_data.io_test_SUITE: TEST COMPLETE, 9 ok, 0 failed of 9 test cases


Updating /buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/index.html ... 
done

Updating /buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/all_runs.html ... 
done



[RUN #2] Got exit status value 0 after 3237 ms

Stopping event receiver!

Events written to logfile: /buildroot/otp/lib/common_test/make_test_dir/ct_logs/ct_run.test_server@83faf2a59a6b.2025-03-06_20.08.58/make_test_dir.common_test_test.logs/run.2025-03-06_20.09.01/log_private/possible_deadlock.events

Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc1,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc2,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc3,ok}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc1}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc2}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc3}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc1,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc2,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc3,ok}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc1}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc2}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc3}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc1,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc2,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc3,ok}}!
Found {ct_test_support_eh,test_stats,{9,0,{0,0}}}!
Found all parallel events!
Found all parallel events!
Found {ct_test_support_eh,test_done,{'DEF','STOP_TIME'}}!
Found {ct_test_support_eh,stop_logging,[]}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc1,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc2,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc3,ok}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc1}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc2}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc3}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc1,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc2,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc3,ok}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc1}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc2}}!
Found {ct_test_support_eh,tc_start,{io_test_SUITE,tc3}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc1,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc2,ok}}!
Found {ct_test_support_eh,tc_done,{io_test_SUITE,tc3,ok}}!
Found {ct_test_support_eh,test_stats,{9,0,{0,0}}}!
Found all parallel events!
Found all parallel events!
Found {ct_test_support_eh,test_done,{'DEF','STOP_TIME'}}!
Found {ct_test_support_eh,stop_logging,[]}!



=== Ended at 2025-03-06 21:19:31
=== successfully completed test case
=== === Returned value: ok