You are not logged in.
Pages: 1
I encountered this issue rebuilding libevent. Reverting https://github.com/libevent/libevent/co … 14a01a2cf9 but would like to understand what has triggered the failure and what the test is doing.
It seems to be sending a 1000 DNS requests for foobar.bazquux.example.com and errors out when it received a 1000 responses. It then repeats the failure 10 times.
libevent-2.1.12-1-x86_64-check.log
Running tests...
Test project /build/libevent/src/libevent-2.1.12-stable/build
Start 1: test-changelist__timerfd_EPOLL
1/54 Test #1: test-changelist__timerfd_EPOLL .............. Passed 1.50 sec
Start 2: test-eof__timerfd_EPOLL
2/54 Test #2: test-eof__timerfd_EPOLL ..................... Passed 0.00 sec
Start 3: test-closed__timerfd_EPOLL
3/54 Test #3: test-closed__timerfd_EPOLL .................. Passed 0.00 sec
Start 4: test-fdleak__timerfd_EPOLL
4/54 Test #4: test-fdleak__timerfd_EPOLL .................. Passed 0.04 sec
Start 5: test-init__timerfd_EPOLL
5/54 Test #5: test-init__timerfd_EPOLL .................... Passed 0.00 sec
Start 6: test-time__timerfd_EPOLL
6/54 Test #6: test-time__timerfd_EPOLL .................... Passed 1.00 sec
Start 7: test-weof__timerfd_EPOLL
7/54 Test #7: test-weof__timerfd_EPOLL .................... Passed 0.00 sec
Start 8: test-dumpevents__timerfd_EPOLL
8/54 Test #8: test-dumpevents__timerfd_EPOLL .............. Passed 0.00 sec
Start 9: regress__timerfd_EPOLL
9/54 Test #9: regress__timerfd_EPOLL ......................***Failed 90.40 sec
Start 10: regress__timerfd_EPOLL_debug
10/54 Test #10: regress__timerfd_EPOLL_debug ................***Failed 85.41 sec
Start 11: test-changelist__changelist_EPOLL
11/54 Test #11: test-changelist__changelist_EPOLL ........... Passed 1.50 sec
Start 12: test-eof__changelist_EPOLL
12/54 Test #12: test-eof__changelist_EPOLL .................. Passed 0.00 sec
Start 13: test-closed__changelist_EPOLL
13/54 Test #13: test-closed__changelist_EPOLL ............... Passed 0.00 sec
Start 14: test-fdleak__changelist_EPOLL
14/54 Test #14: test-fdleak__changelist_EPOLL ............... Passed 0.04 sec
Start 15: test-init__changelist_EPOLL
15/54 Test #15: test-init__changelist_EPOLL ................. Passed 0.00 sec
Start 16: test-time__changelist_EPOLL
16/54 Test #16: test-time__changelist_EPOLL ................. Passed 0.12 sec
Start 17: test-weof__changelist_EPOLL
17/54 Test #17: test-weof__changelist_EPOLL ................. Passed 0.00 sec
Start 18: test-dumpevents__changelist_EPOLL
18/54 Test #18: test-dumpevents__changelist_EPOLL ........... Passed 0.00 sec
Start 19: regress__changelist_EPOLL
19/54 Test #19: regress__changelist_EPOLL ...................***Failed 85.48 sec
Start 20: regress__changelist_EPOLL_debug
20/54 Test #20: regress__changelist_EPOLL_debug .............***Failed 85.47 sec
Start 21: test-changelist__timerfd_changelist_EPOLL
21/54 Test #21: test-changelist__timerfd_changelist_EPOLL ... Passed 1.50 sec
Start 22: test-eof__timerfd_changelist_EPOLL
22/54 Test #22: test-eof__timerfd_changelist_EPOLL .......... Passed 0.00 sec
Start 23: test-closed__timerfd_changelist_EPOLL
23/54 Test #23: test-closed__timerfd_changelist_EPOLL ....... Passed 0.00 sec
Start 24: test-fdleak__timerfd_changelist_EPOLL
24/54 Test #24: test-fdleak__timerfd_changelist_EPOLL ....... Passed 0.04 sec
Start 25: test-init__timerfd_changelist_EPOLL
25/54 Test #25: test-init__timerfd_changelist_EPOLL ......... Passed 0.00 sec
Start 26: test-time__timerfd_changelist_EPOLL
26/54 Test #26: test-time__timerfd_changelist_EPOLL ......... Passed 1.00 sec
Start 27: test-weof__timerfd_changelist_EPOLL
27/54 Test #27: test-weof__timerfd_changelist_EPOLL ......... Passed 0.00 sec
Start 28: test-dumpevents__timerfd_changelist_EPOLL
28/54 Test #28: test-dumpevents__timerfd_changelist_EPOLL ... Passed 0.00 sec
Start 29: regress__timerfd_changelist_EPOLL
29/54 Test #29: regress__timerfd_changelist_EPOLL ...........***Failed 85.38 sec
Start 30: regress__timerfd_changelist_EPOLL_debug
30/54 Test #30: regress__timerfd_changelist_EPOLL_debug .....***Failed 85.42 sec
Start 31: test-changelist__SELECT
31/54 Test #31: test-changelist__SELECT ..................... Passed 1.50 sec
Start 32: test-eof__SELECT
32/54 Test #32: test-eof__SELECT ............................ Passed 0.00 sec
Start 33: test-closed__SELECT
33/54 Test #33: test-closed__SELECT ......................... Passed 0.00 sec
Start 34: test-fdleak__SELECT
34/54 Test #34: test-fdleak__SELECT ......................... Passed 0.04 sec
Start 35: test-init__SELECT
35/54 Test #35: test-init__SELECT ........................... Passed 0.00 sec
Start 36: test-time__SELECT
36/54 Test #36: test-time__SELECT ........................... Passed 1.10 sec
Start 37: test-weof__SELECT
37/54 Test #37: test-weof__SELECT ........................... Passed 0.00 sec
Start 38: test-dumpevents__SELECT
38/54 Test #38: test-dumpevents__SELECT ..................... Passed 0.00 sec
Start 39: regress__SELECT
39/54 Test #39: regress__SELECT .............................***Failed 85.47 sec
Start 40: regress__SELECT_debug
40/54 Test #40: regress__SELECT_debug .......................***Failed 85.47 sec
Start 41: test-changelist__POLL
41/54 Test #41: test-changelist__POLL ....................... Passed 1.50 sec
Start 42: test-eof__POLL
42/54 Test #42: test-eof__POLL .............................. Passed 0.00 sec
Start 43: test-closed__POLL
43/54 Test #43: test-closed__POLL ........................... Passed 0.00 sec
Start 44: test-fdleak__POLL
44/54 Test #44: test-fdleak__POLL ........................... Passed 0.04 sec
Start 45: test-init__POLL
45/54 Test #45: test-init__POLL ............................. Passed 0.00 sec
Start 46: test-time__POLL
46/54 Test #46: test-time__POLL ............................. Passed 1.15 sec
Start 47: test-weof__POLL
47/54 Test #47: test-weof__POLL ............................. Passed 0.00 sec
Start 48: test-dumpevents__POLL
48/54 Test #48: test-dumpevents__POLL ....................... Passed 0.00 sec
Start 49: regress__POLL
49/54 Test #49: regress__POLL ...............................***Failed 85.47 sec
Start 50: regress__POLL_debug
50/54 Test #50: regress__POLL_debug .........................***Failed 85.49 sec
Start 51: test-ratelim__group_lim
51/54 Test #51: test-ratelim__group_lim ..................... Passed 5.30 sec
Start 52: test-ratelim__con_lim
52/54 Test #52: test-ratelim__con_lim ....................... Passed 5.30 sec
Start 53: test-ratelim__group_con_lim
53/54 Test #53: test-ratelim__group_con_lim ................. Passed 5.30 sec
Start 54: test-ratelim__group_con_lim_drain
54/54 Test #54: test-ratelim__group_con_lim_drain ........... Passed 5.30 sec
81% tests passed, 10 tests failed out of 54
Total Test time (real) = 892.77 sec
The following tests FAILED:
9 - regress__timerfd_EPOLL (Failed)
10 - regress__timerfd_EPOLL_debug (Failed)
19 - regress__changelist_EPOLL (Failed)
20 - regress__changelist_EPOLL_debug (Failed)
29 - regress__timerfd_changelist_EPOLL (Failed)
30 - regress__timerfd_changelist_EPOLL_debug (Failed)
39 - regress__SELECT (Failed)
40 - regress__SELECT_debug (Failed)
49 - regress__POLL (Failed)
50 - regress__POLL_debug (Failed)
Errors while running CTest
Output from these tests are in: /build/libevent/src/libevent-2.1.12-stable/build/Testing/Temporary/LastTest.log
Use "--rerun-failed --output-on-failure" to re-run the failed cases verbosely.
make: *** [Makefile:71: test] Error 8LastTest.log
Start testing: Apr 01 15:07 UTC
----------------------------------------------------------
1/54 Testing: test-changelist__timerfd_EPOLL
1/54 Test: test-changelist__timerfd_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-changelist"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-changelist__timerfd_EPOLL" start time: Apr 01 15:07 UTC
Output:
----------------------------------------------------------
write callback. should only see this once
timeout fired, time to end test
usec used=39, usec passed=1500038, cpu usage=0.00%
<end of output>
Test time = 1.50 sec
----------------------------------------------------------
Test Passed.
"test-changelist__timerfd_EPOLL" end time: Apr 01 15:07 UTC
"test-changelist__timerfd_EPOLL" time elapsed: 00:00:01
----------------------------------------------------------
2/54 Testing: test-eof__timerfd_EPOLL
2/54 Test: test-eof__timerfd_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-eof"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-eof__timerfd_EPOLL" start time: Apr 01 15:07 UTC
Output:
----------------------------------------------------------
read_cb: read 12
read_cb: read 0 - means EOF
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-eof__timerfd_EPOLL" end time: Apr 01 15:07 UTC
"test-eof__timerfd_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
3/54 Testing: test-closed__timerfd_EPOLL
3/54 Test: test-closed__timerfd_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-closed"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-closed__timerfd_EPOLL" start time: Apr 01 15:07 UTC
Output:
----------------------------------------------------------
closed_cb: detected socket close with success
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-closed__timerfd_EPOLL" end time: Apr 01 15:07 UTC
"test-closed__timerfd_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
4/54 Testing: test-fdleak__timerfd_EPOLL
4/54 Test: test-fdleak__timerfd_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-fdleak"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-fdleak__timerfd_EPOLL" start time: Apr 01 15:07 UTC
Output:
----------------------------------------------------------
<end of output>
Test time = 0.04 sec
----------------------------------------------------------
Test Passed.
"test-fdleak__timerfd_EPOLL" end time: Apr 01 15:07 UTC
"test-fdleak__timerfd_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
5/54 Testing: test-init__timerfd_EPOLL
5/54 Test: test-init__timerfd_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-init"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-init__timerfd_EPOLL" start time: Apr 01 15:07 UTC
Output:
----------------------------------------------------------
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-init__timerfd_EPOLL" end time: Apr 01 15:07 UTC
"test-init__timerfd_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
6/54 Testing: test-time__timerfd_EPOLL
6/54 Test: test-time__timerfd_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-time"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-time__timerfd_EPOLL" start time: Apr 01 15:07 UTC
Output:
----------------------------------------------------------
event_base_dispatch=1, called=209032, EVENT=20000
<end of output>
Test time = 1.00 sec
----------------------------------------------------------
Test Passed.
"test-time__timerfd_EPOLL" end time: Apr 01 15:07 UTC
"test-time__timerfd_EPOLL" time elapsed: 00:00:01
----------------------------------------------------------
7/54 Testing: test-weof__timerfd_EPOLL
7/54 Test: test-weof__timerfd_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-weof"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-weof__timerfd_EPOLL" start time: Apr 01 15:07 UTC
Output:
----------------------------------------------------------
write_cb: write 12
write_cb: write -1
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-weof__timerfd_EPOLL" end time: Apr 01 15:07 UTC
"test-weof__timerfd_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
8/54 Testing: test-dumpevents__timerfd_EPOLL
8/54 Test: test-dumpevents__timerfd_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-dumpevents" "|" "/usr/bin/python3" "/build/libevent/src/libevent-2.1.12-stable/test/check-dumpevents.py"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-dumpevents__timerfd_EPOLL" start time: Apr 01 15:07 UTC
Output:
----------------------------------------------------------
=====expected
Now= 1648825658.421619
Inserted:
0x557b7061a940 [fd 4] Write
0x557b7061a9d0 [fd 5] Read Persist Timeout=T+1
0x557b7061aa60 [fd 6] Write Persist Timeout=T+1
0x557b7061aaf0 [fd 7] Read Timeout=T+2.5
0x557b7061ab80 [fd -1] Timeout=T+1
0x557b7061ac10 [fd -1] Timeout=T+1
0x557b7061aca0 [fd -1] Timeout=T+1
0x557b7061ad30 [fd -1] Persist Timeout=T+2.5
0x557b7061adc0 [fd -1] Persist Timeout=T+1
0x557b7061ae50 [fd -1] Persist Timeout=T+2.5
0x557b7061b000 [sig 2] Signal Persist
Active:
0x557b7061aee0 [fd -1, priority=0] Read active
0x557b7061af70 [fd -1, priority=0] Read Write Timeout active
0x557b7061a9d0 [fd 5, priority=0] Read active
======received
Inserted events:
0x557b7061a940 [fd 4] Write
0x557b7061a9d0 [fd 5] Read Persist Timeout=1648825659.421616
0x557b7061aa60 [fd 6] Write Persist Timeout=1648825659.421617
0x557b7061aaf0 [fd 7] Read Timeout=1648825660.921618
0x557b7061a308 [fd 10] Read Persist Internal
0x557b7061b000 [sig 2] Signal Persist
0x557b7061a800 [fd -1] Internal Timeout=1648825659.421617
0x557b7061a8b0 [fd -1] Internal Timeout=1648825660.921618
0x557b7061aca0 [fd -1] Timeout=1648825659.421618
0x557b7061ae50 [fd -1] Persist Timeout=1648825660.921618
0x557b7061ab80 [fd -1] Timeout=1648825659.421618
0x557b7061ac10 [fd -1] Timeout=1648825659.421618
0x557b7061adc0 [fd -1] Persist Timeout=1648825659.421618
0x557b7061ad30 [fd -1] Persist Timeout=1648825660.921618
Active events:
0x557b7061a9d0 [fd 5, priority=0] Read active
0x557b7061aee0 [fd -1, priority=0] Read active
0x557b7061af70 [fd -1, priority=0] Read Write Timeout active
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-dumpevents__timerfd_EPOLL" end time: Apr 01 15:07 UTC
"test-dumpevents__timerfd_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
9/54 Testing: regress__timerfd_EPOLL
9/54 Test: regress__timerfd_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/regress" "--quiet"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"regress__timerfd_EPOLL" start time: Apr 01 15:07 UTC
Output:
----------------------------------------------------------
FAIL /build/libevent/src/libevent-2.1.12-stable/test/regress_dns.c:2105: assert(gaic_freed != 1000): 1000 vs 1000dns/getaddrinfo_cancel_stress:
[getaddrinfo_cancel_stress FAILED]
1/353 TESTS FAILED. (37 skipped)
<end of output>
Test time = 90.40 sec
----------------------------------------------------------
Test Failed.
"regress__timerfd_EPOLL" end time: Apr 01 15:09 UTC
"regress__timerfd_EPOLL" time elapsed: 00:01:30
----------------------------------------------------------
10/54 Testing: regress__timerfd_EPOLL_debug
10/54 Test: regress__timerfd_EPOLL_debug
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/regress" "--quiet"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"regress__timerfd_EPOLL_debug" start time: Apr 01 15:09 UTC
Output:
----------------------------------------------------------
FAIL /build/libevent/src/libevent-2.1.12-stable/test/regress_dns.c:2105: assert(gaic_freed != 1000): 1000 vs 1000dns/getaddrinfo_cancel_stress:
[getaddrinfo_cancel_stress FAILED]
1/353 TESTS FAILED. (37 skipped)
<end of output>
Test time = 85.41 sec
----------------------------------------------------------
Test Failed.
"regress__timerfd_EPOLL_debug" end time: Apr 01 15:10 UTC
"regress__timerfd_EPOLL_debug" time elapsed: 00:01:25
----------------------------------------------------------
11/54 Testing: test-changelist__changelist_EPOLL
11/54 Test: test-changelist__changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-changelist"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-changelist__changelist_EPOLL" start time: Apr 01 15:10 UTC
Output:
----------------------------------------------------------
write callback. should only see this once
timeout fired, time to end test
usec used=53, usec passed=1501539, cpu usage=0.00%
<end of output>
Test time = 1.50 sec
----------------------------------------------------------
Test Passed.
"test-changelist__changelist_EPOLL" end time: Apr 01 15:10 UTC
"test-changelist__changelist_EPOLL" time elapsed: 00:00:01
----------------------------------------------------------
12/54 Testing: test-eof__changelist_EPOLL
12/54 Test: test-eof__changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-eof"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-eof__changelist_EPOLL" start time: Apr 01 15:10 UTC
Output:
----------------------------------------------------------
read_cb: read 12
read_cb: read 0 - means EOF
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-eof__changelist_EPOLL" end time: Apr 01 15:10 UTC
"test-eof__changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
13/54 Testing: test-closed__changelist_EPOLL
13/54 Test: test-closed__changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-closed"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-closed__changelist_EPOLL" start time: Apr 01 15:10 UTC
Output:
----------------------------------------------------------
closed_cb: detected socket close with success
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-closed__changelist_EPOLL" end time: Apr 01 15:10 UTC
"test-closed__changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
14/54 Testing: test-fdleak__changelist_EPOLL
14/54 Test: test-fdleak__changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-fdleak"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-fdleak__changelist_EPOLL" start time: Apr 01 15:10 UTC
Output:
----------------------------------------------------------
<end of output>
Test time = 0.04 sec
----------------------------------------------------------
Test Passed.
"test-fdleak__changelist_EPOLL" end time: Apr 01 15:10 UTC
"test-fdleak__changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
15/54 Testing: test-init__changelist_EPOLL
15/54 Test: test-init__changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-init"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-init__changelist_EPOLL" start time: Apr 01 15:10 UTC
Output:
----------------------------------------------------------
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-init__changelist_EPOLL" end time: Apr 01 15:10 UTC
"test-init__changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
16/54 Testing: test-time__changelist_EPOLL
16/54 Test: test-time__changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-time"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-time__changelist_EPOLL" start time: Apr 01 15:10 UTC
Output:
----------------------------------------------------------
event_base_dispatch=1, called=22289, EVENT=20000
<end of output>
Test time = 0.12 sec
----------------------------------------------------------
Test Passed.
"test-time__changelist_EPOLL" end time: Apr 01 15:10 UTC
"test-time__changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
17/54 Testing: test-weof__changelist_EPOLL
17/54 Test: test-weof__changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-weof"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-weof__changelist_EPOLL" start time: Apr 01 15:10 UTC
Output:
----------------------------------------------------------
write_cb: write 12
write_cb: write -1
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-weof__changelist_EPOLL" end time: Apr 01 15:10 UTC
"test-weof__changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
18/54 Testing: test-dumpevents__changelist_EPOLL
18/54 Test: test-dumpevents__changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-dumpevents" "|" "/usr/bin/python3" "/build/libevent/src/libevent-2.1.12-stable/test/check-dumpevents.py"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-dumpevents__changelist_EPOLL" start time: Apr 01 15:10 UTC
Output:
----------------------------------------------------------
=====expected
Now= 1648825835.890084
Inserted:
0x556cd2cc1940 [fd 4] Write
0x556cd2cc19d0 [fd 5] Read Persist Timeout=T+1
0x556cd2cc1a60 [fd 6] Write Persist Timeout=T+1
0x556cd2cc1af0 [fd 7] Read Timeout=T+2.5
0x556cd2cc1b80 [fd -1] Timeout=T+1
0x556cd2cc1c10 [fd -1] Timeout=T+1
0x556cd2cc1ca0 [fd -1] Timeout=T+1
0x556cd2cc1d30 [fd -1] Persist Timeout=T+2.5
0x556cd2cc1dc0 [fd -1] Persist Timeout=T+1
0x556cd2cc1e50 [fd -1] Persist Timeout=T+2.5
0x556cd2cc2000 [sig 2] Signal Persist
Active:
0x556cd2cc1ee0 [fd -1, priority=0] Read active
0x556cd2cc1f70 [fd -1, priority=0] Read Write Timeout active
0x556cd2cc19d0 [fd 5, priority=0] Read active
======received
Inserted events:
0x556cd2cc1940 [fd 4] Write
0x556cd2cc19d0 [fd 5] Read Persist Timeout=1648825836.890073
0x556cd2cc1a60 [fd 6] Write Persist Timeout=1648825836.890073
0x556cd2cc1af0 [fd 7] Read Timeout=1648825838.390073
0x556cd2cc1308 [fd 9] Read Persist Internal
0x556cd2cc2000 [sig 2] Signal Persist
0x556cd2cc1800 [fd -1] Internal Timeout=1648825836.890073
0x556cd2cc18b0 [fd -1] Internal Timeout=1648825838.390073
0x556cd2cc1ca0 [fd -1] Timeout=1648825836.890073
0x556cd2cc1e50 [fd -1] Persist Timeout=1648825838.390073
0x556cd2cc1b80 [fd -1] Timeout=1648825836.890073
0x556cd2cc1c10 [fd -1] Timeout=1648825836.890073
0x556cd2cc1dc0 [fd -1] Persist Timeout=1648825836.890073
0x556cd2cc1d30 [fd -1] Persist Timeout=1648825838.390073
Active events:
0x556cd2cc19d0 [fd 5, priority=0] Read active
0x556cd2cc1ee0 [fd -1, priority=0] Read active
0x556cd2cc1f70 [fd -1, priority=0] Read Write Timeout active
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-dumpevents__changelist_EPOLL" end time: Apr 01 15:10 UTC
"test-dumpevents__changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
19/54 Testing: regress__changelist_EPOLL
19/54 Test: regress__changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/regress" "--quiet"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"regress__changelist_EPOLL" start time: Apr 01 15:10 UTC
Output:
----------------------------------------------------------
FAIL /build/libevent/src/libevent-2.1.12-stable/test/regress_dns.c:2105: assert(gaic_freed != 1000): 1000 vs 1000dns/getaddrinfo_cancel_stress:
[getaddrinfo_cancel_stress FAILED]
1/353 TESTS FAILED. (37 skipped)
<end of output>
Test time = 85.48 sec
----------------------------------------------------------
Test Failed.
"regress__changelist_EPOLL" end time: Apr 01 15:12 UTC
"regress__changelist_EPOLL" time elapsed: 00:01:25
----------------------------------------------------------
20/54 Testing: regress__changelist_EPOLL_debug
20/54 Test: regress__changelist_EPOLL_debug
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/regress" "--quiet"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"regress__changelist_EPOLL_debug" start time: Apr 01 15:12 UTC
Output:
----------------------------------------------------------
FAIL /build/libevent/src/libevent-2.1.12-stable/test/regress_dns.c:2105: assert(gaic_freed != 1000): 1000 vs 1000dns/getaddrinfo_cancel_stress:
[getaddrinfo_cancel_stress FAILED]
1/353 TESTS FAILED. (37 skipped)
<end of output>
Test time = 85.47 sec
----------------------------------------------------------
Test Failed.
"regress__changelist_EPOLL_debug" end time: Apr 01 15:13 UTC
"regress__changelist_EPOLL_debug" time elapsed: 00:01:25
----------------------------------------------------------
21/54 Testing: test-changelist__timerfd_changelist_EPOLL
21/54 Test: test-changelist__timerfd_changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-changelist"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-changelist__timerfd_changelist_EPOLL" start time: Apr 01 15:13 UTC
Output:
----------------------------------------------------------
write callback. should only see this once
timeout fired, time to end test
usec used=65, usec passed=1500203, cpu usage=0.00%
<end of output>
Test time = 1.50 sec
----------------------------------------------------------
Test Passed.
"test-changelist__timerfd_changelist_EPOLL" end time: Apr 01 15:13 UTC
"test-changelist__timerfd_changelist_EPOLL" time elapsed: 00:00:01
----------------------------------------------------------
22/54 Testing: test-eof__timerfd_changelist_EPOLL
22/54 Test: test-eof__timerfd_changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-eof"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-eof__timerfd_changelist_EPOLL" start time: Apr 01 15:13 UTC
Output:
----------------------------------------------------------
read_cb: read 12
read_cb: read 0 - means EOF
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-eof__timerfd_changelist_EPOLL" end time: Apr 01 15:13 UTC
"test-eof__timerfd_changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
23/54 Testing: test-closed__timerfd_changelist_EPOLL
23/54 Test: test-closed__timerfd_changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-closed"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-closed__timerfd_changelist_EPOLL" start time: Apr 01 15:13 UTC
Output:
----------------------------------------------------------
closed_cb: detected socket close with success
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-closed__timerfd_changelist_EPOLL" end time: Apr 01 15:13 UTC
"test-closed__timerfd_changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
24/54 Testing: test-fdleak__timerfd_changelist_EPOLL
24/54 Test: test-fdleak__timerfd_changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-fdleak"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-fdleak__timerfd_changelist_EPOLL" start time: Apr 01 15:13 UTC
Output:
----------------------------------------------------------
<end of output>
Test time = 0.04 sec
----------------------------------------------------------
Test Passed.
"test-fdleak__timerfd_changelist_EPOLL" end time: Apr 01 15:13 UTC
"test-fdleak__timerfd_changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
25/54 Testing: test-init__timerfd_changelist_EPOLL
25/54 Test: test-init__timerfd_changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-init"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-init__timerfd_changelist_EPOLL" start time: Apr 01 15:13 UTC
Output:
----------------------------------------------------------
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-init__timerfd_changelist_EPOLL" end time: Apr 01 15:13 UTC
"test-init__timerfd_changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
26/54 Testing: test-time__timerfd_changelist_EPOLL
26/54 Test: test-time__timerfd_changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-time"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-time__timerfd_changelist_EPOLL" start time: Apr 01 15:13 UTC
Output:
----------------------------------------------------------
event_base_dispatch=1, called=209006, EVENT=20000
<end of output>
Test time = 1.00 sec
----------------------------------------------------------
Test Passed.
"test-time__timerfd_changelist_EPOLL" end time: Apr 01 15:13 UTC
"test-time__timerfd_changelist_EPOLL" time elapsed: 00:00:01
----------------------------------------------------------
27/54 Testing: test-weof__timerfd_changelist_EPOLL
27/54 Test: test-weof__timerfd_changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-weof"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-weof__timerfd_changelist_EPOLL" start time: Apr 01 15:13 UTC
Output:
----------------------------------------------------------
write_cb: write 12
write_cb: write -1
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-weof__timerfd_changelist_EPOLL" end time: Apr 01 15:13 UTC
"test-weof__timerfd_changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
28/54 Testing: test-dumpevents__timerfd_changelist_EPOLL
28/54 Test: test-dumpevents__timerfd_changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-dumpevents" "|" "/usr/bin/python3" "/build/libevent/src/libevent-2.1.12-stable/test/check-dumpevents.py"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-dumpevents__timerfd_changelist_EPOLL" start time: Apr 01 15:13 UTC
Output:
----------------------------------------------------------
=====expected
Now= 1648826009.397702
Inserted:
0x560f122db940 [fd 4] Write
0x560f122db9d0 [fd 5] Read Persist Timeout=T+1
0x560f122dba60 [fd 6] Write Persist Timeout=T+1
0x560f122dbaf0 [fd 7] Read Timeout=T+2.5
0x560f122dbb80 [fd -1] Timeout=T+1
0x560f122dbc10 [fd -1] Timeout=T+1
0x560f122dbca0 [fd -1] Timeout=T+1
0x560f122dbd30 [fd -1] Persist Timeout=T+2.5
0x560f122dbdc0 [fd -1] Persist Timeout=T+1
0x560f122dbe50 [fd -1] Persist Timeout=T+2.5
0x560f122dc000 [sig 2] Signal Persist
Active:
0x560f122dbee0 [fd -1, priority=0] Read active
0x560f122dbf70 [fd -1, priority=0] Read Write Timeout active
0x560f122db9d0 [fd 5, priority=0] Read active
======received
Inserted events:
0x560f122db940 [fd 4] Write
0x560f122db9d0 [fd 5] Read Persist Timeout=1648826010.397700
0x560f122dba60 [fd 6] Write Persist Timeout=1648826010.397700
0x560f122dbaf0 [fd 7] Read Timeout=1648826011.897700
0x560f122db308 [fd 10] Read Persist Internal
0x560f122dc000 [sig 2] Signal Persist
0x560f122db800 [fd -1] Internal Timeout=1648826010.397700
0x560f122db8b0 [fd -1] Internal Timeout=1648826011.897700
0x560f122dbca0 [fd -1] Timeout=1648826010.397701
0x560f122dbe50 [fd -1] Persist Timeout=1648826011.897701
0x560f122dbb80 [fd -1] Timeout=1648826010.397700
0x560f122dbc10 [fd -1] Timeout=1648826010.397701
0x560f122dbdc0 [fd -1] Persist Timeout=1648826010.397701
0x560f122dbd30 [fd -1] Persist Timeout=1648826011.897701
Active events:
0x560f122db9d0 [fd 5, priority=0] Read active
0x560f122dbee0 [fd -1, priority=0] Read active
0x560f122dbf70 [fd -1, priority=0] Read Write Timeout active
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-dumpevents__timerfd_changelist_EPOLL" end time: Apr 01 15:13 UTC
"test-dumpevents__timerfd_changelist_EPOLL" time elapsed: 00:00:00
----------------------------------------------------------
29/54 Testing: regress__timerfd_changelist_EPOLL
29/54 Test: regress__timerfd_changelist_EPOLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/regress" "--quiet"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"regress__timerfd_changelist_EPOLL" start time: Apr 01 15:13 UTC
Output:
----------------------------------------------------------
FAIL /build/libevent/src/libevent-2.1.12-stable/test/regress_dns.c:2105: assert(gaic_freed != 1000): 1000 vs 1000dns/getaddrinfo_cancel_stress:
[getaddrinfo_cancel_stress FAILED]
1/353 TESTS FAILED. (37 skipped)
<end of output>
Test time = 85.38 sec
----------------------------------------------------------
Test Failed.
"regress__timerfd_changelist_EPOLL" end time: Apr 01 15:14 UTC
"regress__timerfd_changelist_EPOLL" time elapsed: 00:01:25
----------------------------------------------------------
30/54 Testing: regress__timerfd_changelist_EPOLL_debug
30/54 Test: regress__timerfd_changelist_EPOLL_debug
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/regress" "--quiet"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"regress__timerfd_changelist_EPOLL_debug" start time: Apr 01 15:14 UTC
Output:
----------------------------------------------------------
FAIL /build/libevent/src/libevent-2.1.12-stable/test/regress_dns.c:2105: assert(gaic_freed != 1000): 1000 vs 1000dns/getaddrinfo_cancel_stress:
[getaddrinfo_cancel_stress FAILED]
1/353 TESTS FAILED. (37 skipped)
<end of output>
Test time = 85.42 sec
----------------------------------------------------------
Test Failed.
"regress__timerfd_changelist_EPOLL_debug" end time: Apr 01 15:16 UTC
"regress__timerfd_changelist_EPOLL_debug" time elapsed: 00:01:25
----------------------------------------------------------
31/54 Testing: test-changelist__SELECT
31/54 Test: test-changelist__SELECT
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-changelist"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-changelist__SELECT" start time: Apr 01 15:16 UTC
Output:
----------------------------------------------------------
write callback. should only see this once
timeout fired, time to end test
usec used=55, usec passed=1501596, cpu usage=0.00%
<end of output>
Test time = 1.50 sec
----------------------------------------------------------
Test Passed.
"test-changelist__SELECT" end time: Apr 01 15:16 UTC
"test-changelist__SELECT" time elapsed: 00:00:01
----------------------------------------------------------
32/54 Testing: test-eof__SELECT
32/54 Test: test-eof__SELECT
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-eof"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-eof__SELECT" start time: Apr 01 15:16 UTC
Output:
----------------------------------------------------------
read_cb: read 12
read_cb: read 0 - means EOF
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-eof__SELECT" end time: Apr 01 15:16 UTC
"test-eof__SELECT" time elapsed: 00:00:00
----------------------------------------------------------
33/54 Testing: test-closed__SELECT
33/54 Test: test-closed__SELECT
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-closed"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-closed__SELECT" start time: Apr 01 15:16 UTC
Output:
----------------------------------------------------------
[warn] event_base_new_with_config: no event mechanism available
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-closed__SELECT" end time: Apr 01 15:16 UTC
"test-closed__SELECT" time elapsed: 00:00:00
----------------------------------------------------------
34/54 Testing: test-fdleak__SELECT
34/54 Test: test-fdleak__SELECT
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-fdleak"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-fdleak__SELECT" start time: Apr 01 15:16 UTC
Output:
----------------------------------------------------------
<end of output>
Test time = 0.04 sec
----------------------------------------------------------
Test Passed.
"test-fdleak__SELECT" end time: Apr 01 15:16 UTC
"test-fdleak__SELECT" time elapsed: 00:00:00
----------------------------------------------------------
35/54 Testing: test-init__SELECT
35/54 Test: test-init__SELECT
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-init"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-init__SELECT" start time: Apr 01 15:16 UTC
Output:
----------------------------------------------------------
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-init__SELECT" end time: Apr 01 15:16 UTC
"test-init__SELECT" time elapsed: 00:00:00
----------------------------------------------------------
36/54 Testing: test-time__SELECT
36/54 Test: test-time__SELECT
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-time"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-time__SELECT" start time: Apr 01 15:16 UTC
Output:
----------------------------------------------------------
event_base_dispatch=1, called=208980, EVENT=20000
<end of output>
Test time = 1.10 sec
----------------------------------------------------------
Test Passed.
"test-time__SELECT" end time: Apr 01 15:16 UTC
"test-time__SELECT" time elapsed: 00:00:01
----------------------------------------------------------
37/54 Testing: test-weof__SELECT
37/54 Test: test-weof__SELECT
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-weof"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-weof__SELECT" start time: Apr 01 15:16 UTC
Output:
----------------------------------------------------------
write_cb: write 12
write_cb: write -1
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-weof__SELECT" end time: Apr 01 15:16 UTC
"test-weof__SELECT" time elapsed: 00:00:00
----------------------------------------------------------
38/54 Testing: test-dumpevents__SELECT
38/54 Test: test-dumpevents__SELECT
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-dumpevents" "|" "/usr/bin/python3" "/build/libevent/src/libevent-2.1.12-stable/test/check-dumpevents.py"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-dumpevents__SELECT" start time: Apr 01 15:16 UTC
Output:
----------------------------------------------------------
=====expected
Now= 1648826182.835686
Inserted:
0x55d985b9c810 [fd 4] Write
0x55d985b9c8a0 [fd 5] Read Persist Timeout=T+1
0x55d985b9c930 [fd 6] Write Persist Timeout=T+1
0x55d985b9c9c0 [fd 7] Read Timeout=T+2.5
0x55d985b9ca50 [fd -1] Timeout=T+1
0x55d985b9cae0 [fd -1] Timeout=T+1
0x55d985b9cb70 [fd -1] Timeout=T+1
0x55d985b9cc00 [fd -1] Persist Timeout=T+2.5
0x55d985b9cc90 [fd -1] Persist Timeout=T+1
0x55d985b9cd20 [fd -1] Persist Timeout=T+2.5
0x55d985b9ced0 [sig 2] Signal Persist
Active:
0x55d985b9cdb0 [fd -1, priority=0] Read active
0x55d985b9ce40 [fd -1, priority=0] Read Write Timeout active
0x55d985b9c8a0 [fd 5, priority=0] Read active
======received
Inserted events:
0x55d985b9c810 [fd 4] Write
0x55d985b9c8a0 [fd 5] Read Persist Timeout=1648826183.835672
0x55d985b9c930 [fd 6] Write Persist Timeout=1648826183.835672
0x55d985b9c9c0 [fd 7] Read Timeout=1648826185.335672
0x55d985b9c308 [fd 8] Read Persist Internal
0x55d985b9ced0 [sig 2] Signal Persist
0x55d985b9c6d0 [fd -1] Internal Timeout=1648826183.835672
0x55d985b9c780 [fd -1] Internal Timeout=1648826185.335672
0x55d985b9cb70 [fd -1] Timeout=1648826183.835672
0x55d985b9cd20 [fd -1] Persist Timeout=1648826185.335672
0x55d985b9ca50 [fd -1] Timeout=1648826183.835672
0x55d985b9cae0 [fd -1] Timeout=1648826183.835672
0x55d985b9cc90 [fd -1] Persist Timeout=1648826183.835672
0x55d985b9cc00 [fd -1] Persist Timeout=1648826185.335672
Active events:
0x55d985b9c8a0 [fd 5, priority=0] Read active
0x55d985b9cdb0 [fd -1, priority=0] Read active
0x55d985b9ce40 [fd -1, priority=0] Read Write Timeout active
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-dumpevents__SELECT" end time: Apr 01 15:16 UTC
"test-dumpevents__SELECT" time elapsed: 00:00:00
----------------------------------------------------------
39/54 Testing: regress__SELECT
39/54 Test: regress__SELECT
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/regress" "--quiet"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"regress__SELECT" start time: Apr 01 15:16 UTC
Output:
----------------------------------------------------------
FAIL /build/libevent/src/libevent-2.1.12-stable/test/regress_dns.c:2105: assert(gaic_freed != 1000): 1000 vs 1000dns/getaddrinfo_cancel_stress:
[getaddrinfo_cancel_stress FAILED]
1/344 TESTS FAILED. (46 skipped)
<end of output>
Test time = 85.47 sec
----------------------------------------------------------
Test Failed.
"regress__SELECT" end time: Apr 01 15:17 UTC
"regress__SELECT" time elapsed: 00:01:25
----------------------------------------------------------
40/54 Testing: regress__SELECT_debug
40/54 Test: regress__SELECT_debug
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/regress" "--quiet"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"regress__SELECT_debug" start time: Apr 01 15:17 UTC
Output:
----------------------------------------------------------
FAIL /build/libevent/src/libevent-2.1.12-stable/test/regress_dns.c:2105: assert(gaic_freed != 1000): 1000 vs 1000dns/getaddrinfo_cancel_stress:
[getaddrinfo_cancel_stress FAILED]
1/344 TESTS FAILED. (46 skipped)
<end of output>
Test time = 85.47 sec
----------------------------------------------------------
Test Failed.
"regress__SELECT_debug" end time: Apr 01 15:19 UTC
"regress__SELECT_debug" time elapsed: 00:01:25
----------------------------------------------------------
41/54 Testing: test-changelist__POLL
41/54 Test: test-changelist__POLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-changelist"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-changelist__POLL" start time: Apr 01 15:19 UTC
Output:
----------------------------------------------------------
write callback. should only see this once
timeout fired, time to end test
usec used=56, usec passed=1501787, cpu usage=0.00%
<end of output>
Test time = 1.50 sec
----------------------------------------------------------
Test Passed.
"test-changelist__POLL" end time: Apr 01 15:19 UTC
"test-changelist__POLL" time elapsed: 00:00:01
----------------------------------------------------------
42/54 Testing: test-eof__POLL
42/54 Test: test-eof__POLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-eof"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-eof__POLL" start time: Apr 01 15:19 UTC
Output:
----------------------------------------------------------
read_cb: read 12
read_cb: read 0 - means EOF
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-eof__POLL" end time: Apr 01 15:19 UTC
"test-eof__POLL" time elapsed: 00:00:00
----------------------------------------------------------
43/54 Testing: test-closed__POLL
43/54 Test: test-closed__POLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-closed"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-closed__POLL" start time: Apr 01 15:19 UTC
Output:
----------------------------------------------------------
closed_cb: detected socket close with success
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-closed__POLL" end time: Apr 01 15:19 UTC
"test-closed__POLL" time elapsed: 00:00:00
----------------------------------------------------------
44/54 Testing: test-fdleak__POLL
44/54 Test: test-fdleak__POLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-fdleak"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-fdleak__POLL" start time: Apr 01 15:19 UTC
Output:
----------------------------------------------------------
<end of output>
Test time = 0.04 sec
----------------------------------------------------------
Test Passed.
"test-fdleak__POLL" end time: Apr 01 15:19 UTC
"test-fdleak__POLL" time elapsed: 00:00:00
----------------------------------------------------------
45/54 Testing: test-init__POLL
45/54 Test: test-init__POLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-init"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-init__POLL" start time: Apr 01 15:19 UTC
Output:
----------------------------------------------------------
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-init__POLL" end time: Apr 01 15:19 UTC
"test-init__POLL" time elapsed: 00:00:00
----------------------------------------------------------
46/54 Testing: test-time__POLL
46/54 Test: test-time__POLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-time"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-time__POLL" start time: Apr 01 15:19 UTC
Output:
----------------------------------------------------------
event_base_dispatch=1, called=209020, EVENT=20000
<end of output>
Test time = 1.15 sec
----------------------------------------------------------
Test Passed.
"test-time__POLL" end time: Apr 01 15:19 UTC
"test-time__POLL" time elapsed: 00:00:01
----------------------------------------------------------
47/54 Testing: test-weof__POLL
47/54 Test: test-weof__POLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-weof"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-weof__POLL" start time: Apr 01 15:19 UTC
Output:
----------------------------------------------------------
write_cb: write 12
write_cb: write -1
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-weof__POLL" end time: Apr 01 15:19 UTC
"test-weof__POLL" time elapsed: 00:00:00
----------------------------------------------------------
48/54 Testing: test-dumpevents__POLL
48/54 Test: test-dumpevents__POLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-dumpevents" "|" "/usr/bin/python3" "/build/libevent/src/libevent-2.1.12-stable/test/check-dumpevents.py"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-dumpevents__POLL" start time: Apr 01 15:19 UTC
Output:
----------------------------------------------------------
=====expected
Now= 1648826356.476418
Inserted:
0x560d4238b7c0 [fd 4] Write
0x560d4238b850 [fd 5] Read Persist Timeout=T+1
0x560d4238b8e0 [fd 6] Write Persist Timeout=T+1
0x560d4238b970 [fd 7] Read Timeout=T+2.5
0x560d4238ba00 [fd -1] Timeout=T+1
0x560d4238ba90 [fd -1] Timeout=T+1
0x560d4238bb20 [fd -1] Timeout=T+1
0x560d4238bbb0 [fd -1] Persist Timeout=T+2.5
0x560d4238bc40 [fd -1] Persist Timeout=T+1
0x560d4238bcd0 [fd -1] Persist Timeout=T+2.5
0x560d4238be80 [sig 2] Signal Persist
Active:
0x560d4238bd60 [fd -1, priority=0] Read active
0x560d4238bdf0 [fd -1, priority=0] Read Write Timeout active
0x560d4238b850 [fd 5, priority=0] Read active
======received
Inserted events:
0x560d4238b7c0 [fd 4] Write
0x560d4238b850 [fd 5] Read Persist Timeout=1648826357.476402
0x560d4238b8e0 [fd 6] Write Persist Timeout=1648826357.476402
0x560d4238b970 [fd 7] Read Timeout=1648826358.976402
0x560d4238b308 [fd 8] Read Persist Internal
0x560d4238be80 [sig 2] Signal Persist
0x560d4238b680 [fd -1] Internal Timeout=1648826357.476402
0x560d4238b730 [fd -1] Internal Timeout=1648826358.976402
0x560d4238bb20 [fd -1] Timeout=1648826357.476402
0x560d4238bcd0 [fd -1] Persist Timeout=1648826358.976402
0x560d4238ba00 [fd -1] Timeout=1648826357.476402
0x560d4238ba90 [fd -1] Timeout=1648826357.476402
0x560d4238bc40 [fd -1] Persist Timeout=1648826357.476402
0x560d4238bbb0 [fd -1] Persist Timeout=1648826358.976402
Active events:
0x560d4238b850 [fd 5, priority=0] Read active
0x560d4238bd60 [fd -1, priority=0] Read active
0x560d4238bdf0 [fd -1, priority=0] Read Write Timeout active
<end of output>
Test time = 0.00 sec
----------------------------------------------------------
Test Passed.
"test-dumpevents__POLL" end time: Apr 01 15:19 UTC
"test-dumpevents__POLL" time elapsed: 00:00:00
----------------------------------------------------------
49/54 Testing: regress__POLL
49/54 Test: regress__POLL
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/regress" "--quiet"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"regress__POLL" start time: Apr 01 15:19 UTC
Output:
----------------------------------------------------------
FAIL /build/libevent/src/libevent-2.1.12-stable/test/regress_dns.c:2105: assert(gaic_freed != 1000): 1000 vs 1000dns/getaddrinfo_cancel_stress:
[getaddrinfo_cancel_stress FAILED]
1/349 TESTS FAILED. (41 skipped)
<end of output>
Test time = 85.47 sec
----------------------------------------------------------
Test Failed.
"regress__POLL" end time: Apr 01 15:20 UTC
"regress__POLL" time elapsed: 00:01:25
----------------------------------------------------------
50/54 Testing: regress__POLL_debug
50/54 Test: regress__POLL_debug
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/regress" "--quiet"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"regress__POLL_debug" start time: Apr 01 15:20 UTC
Output:
----------------------------------------------------------
FAIL /build/libevent/src/libevent-2.1.12-stable/test/regress_dns.c:2105: assert(gaic_freed != 1000): 1000 vs 1000dns/getaddrinfo_cancel_stress:
[getaddrinfo_cancel_stress FAILED]
1/349 TESTS FAILED. (41 skipped)
<end of output>
Test time = 85.49 sec
----------------------------------------------------------
Test Failed.
"regress__POLL_debug" end time: Apr 01 15:22 UTC
"regress__POLL_debug" time elapsed: 00:01:25
----------------------------------------------------------
51/54 Testing: test-ratelim__group_lim
51/54 Test: test-ratelim__group_lim
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-ratelim" "-g" "30000" "-n" "30" "-t" "100" "--check-grouplimit" "1000" "--check-stddev" "100"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-ratelim__group_lim" start time: Apr 01 15:22 UTC
Output:
----------------------------------------------------------
CPU is fast enough, timers bias is 0.396000
waiting for 30 conns
Average group read bucket level: 2958.591837
Average group write bucket level: 2958.591837
1: 1032.800000 per second
2: 1025.200000 per second
3: 1009.800000 per second
4: 1025.800000 per second
5: 1031.200000 per second
6: 1061.600000 per second
7: 1074.800000 per second
8: 1073.800000 per second
9: 1074.000000 per second
10: 978.000000 per second
11: 968.800000 per second
12: 930.600000 per second
13: 904.600000 per second
14: 977.400000 per second
15: 967.800000 per second
15: 1017.800000 per second
17: 982.400000 per second
18: 974.000000 per second
19: 971.800000 per second
20: 988.400000 per second
21: 959.600000 per second
22: 963.600000 per second
23: 967.400000 per second
24: 970.600000 per second
25: 1007.800000 per second
26: 1036.600000 per second
27: 1022.800000 per second
28: 1025.800000 per second
29: 991.000000 per second
30: 988.600000 per second
total: 30004.400000 per second
[Off by -4.400000]
average: 1000.146667 per second
[Off by -0.146667]
stddev: 41.066383 per second
<end of output>
Test time = 5.30 sec
----------------------------------------------------------
Test Passed.
"test-ratelim__group_lim" end time: Apr 01 15:22 UTC
"test-ratelim__group_lim" time elapsed: 00:00:05
----------------------------------------------------------
52/54 Testing: test-ratelim__con_lim
52/54 Test: test-ratelim__con_lim
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-ratelim" "-c" "1000" "-n" "30" "-t" "100" "--check-connlimit" "50" "--check-stddev" "50"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-ratelim__con_lim" start time: Apr 01 15:22 UTC
Output:
----------------------------------------------------------
CPU is fast enough, timers bias is 0.464000
waiting for 30 conns
Average read bucket level: 100.000000
Average write bucket level: 100.000000
Highest read bucket level: 100.000000
Highest write bucket level: 100.000000
Average max-to-read: 100.000000
Average max-to-write: 100.000000
Average group read bucket level: 0.000000
Average group write bucket level: 0.000000
1: 1000.000000 per second
2: 1000.000000 per second
3: 1000.000000 per second
4: 1000.000000 per second
5: 1000.000000 per second
6: 1000.000000 per second
7: 1000.000000 per second
8: 1000.000000 per second
9: 1000.000000 per second
10: 1000.000000 per second
11: 1000.000000 per second
12: 1000.000000 per second
13: 1000.000000 per second
14: 1000.000000 per second
15: 1000.000000 per second
15: 1000.000000 per second
17: 1000.000000 per second
18: 1000.000000 per second
19: 1000.000000 per second
20: 1000.000000 per second
21: 1000.000000 per second
22: 1000.000000 per second
23: 1000.000000 per second
24: 1000.000000 per second
25: 1000.000000 per second
26: 1000.000000 per second
27: 1000.000000 per second
28: 1000.000000 per second
29: 1000.000000 per second
30: 1000.000000 per second
total: 30000.000000 per second
average: 1000.000000 per second
[Off by 0.000000]
stddev: 0.000000 per second
<end of output>
Test time = 5.30 sec
----------------------------------------------------------
Test Passed.
"test-ratelim__con_lim" end time: Apr 01 15:22 UTC
"test-ratelim__con_lim" time elapsed: 00:00:05
----------------------------------------------------------
53/54 Testing: test-ratelim__group_con_lim
53/54 Test: test-ratelim__group_con_lim
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-ratelim" "-c" "1000" "-g" "30000" "-n" "30" "-t" "100" "--check-grouplimit" "1000" "--check-connlimit" "50" "--check-stddev" "50"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-ratelim__group_con_lim" start time: Apr 01 15:22 UTC
Output:
----------------------------------------------------------
CPU is fast enough, timers bias is 0.377000
waiting for 30 conns
Average read bucket level: 100.000000
Average write bucket level: 100.000000
Highest read bucket level: 100.000000
Highest write bucket level: 100.000000
Average max-to-read: 100.000000
Average max-to-write: 100.000000
Average group read bucket level: 3000.000000
Average group write bucket level: 3000.000000
1: 1000.000000 per second
2: 1000.000000 per second
3: 1000.000000 per second
4: 1000.000000 per second
5: 1000.000000 per second
6: 1000.000000 per second
7: 1000.000000 per second
8: 1000.000000 per second
9: 1000.000000 per second
10: 1000.000000 per second
11: 1000.000000 per second
12: 1000.000000 per second
13: 1000.000000 per second
14: 1000.000000 per second
15: 1000.000000 per second
15: 1000.000000 per second
17: 1000.000000 per second
18: 1000.000000 per second
19: 1000.000000 per second
20: 1000.000000 per second
21: 1000.000000 per second
22: 1000.000000 per second
23: 1000.000000 per second
24: 1000.000000 per second
25: 1000.000000 per second
26: 1000.000000 per second
27: 1000.000000 per second
28: 1000.000000 per second
29: 1000.000000 per second
30: 1000.000000 per second
total: 30000.000000 per second
[Off by 0.000000]
average: 1000.000000 per second
[Off by 0.000000]
stddev: 0.000000 per second
<end of output>
Test time = 5.30 sec
----------------------------------------------------------
Test Passed.
"test-ratelim__group_con_lim" end time: Apr 01 15:22 UTC
"test-ratelim__group_con_lim" time elapsed: 00:00:05
----------------------------------------------------------
54/54 Testing: test-ratelim__group_con_lim_drain
54/54 Test: test-ratelim__group_con_lim_drain
Command: "/build/libevent/src/libevent-2.1.12-stable/build/bin/test-ratelim" "-c" "1000" "-g" "35000" "-n" "30" "-t" "100" "-G" "500" "--check-grouplimit" "1000" "--check-connlimit" "50" "--check-stddev" "50"
Directory: /build/libevent/src/libevent-2.1.12-stable/build
"test-ratelim__group_con_lim_drain" start time: Apr 01 15:22 UTC
Output:
----------------------------------------------------------
CPU is fast enough, timers bias is 0.438000
waiting for 30 conns
Average read bucket level: 100.000000
Average write bucket level: 100.000000
Highest read bucket level: 100.000000
Highest write bucket level: 100.000000
Average max-to-read: 100.000000
Average max-to-write: 100.000000
Average group read bucket level: 3500.000000
Average group write bucket level: 3500.000000
1: 1000.000000 per second
2: 1000.000000 per second
3: 1000.000000 per second
4: 1000.000000 per second
5: 1000.000000 per second
6: 1000.000000 per second
7: 1000.000000 per second
8: 1000.000000 per second
9: 1000.000000 per second
10: 1000.000000 per second
11: 1000.000000 per second
12: 1000.000000 per second
13: 1000.000000 per second
14: 1000.000000 per second
15: 1000.000000 per second
15: 1000.000000 per second
17: 1000.000000 per second
18: 1000.000000 per second
19: 1000.000000 per second
20: 1000.000000 per second
21: 1000.000000 per second
22: 1000.000000 per second
23: 1000.000000 per second
24: 1000.000000 per second
25: 1000.000000 per second
26: 1000.000000 per second
27: 1000.000000 per second
28: 1000.000000 per second
29: 1000.000000 per second
30: 1000.000000 per second
total: 30000.000000 per second
average: 1000.000000 per second
[Off by 0.000000]
stddev: 0.000000 per second
<end of output>
Test time = 5.30 sec
----------------------------------------------------------
Test Passed.
"test-ratelim__group_con_lim_drain" end time: Apr 01 15:22 UTC
"test-ratelim__group_con_lim_drain" time elapsed: 00:00:05
----------------------------------------------------------
End testing: Apr 01 15:22 UTCEdit:
https://github.com/libevent/libevent/issues/1271
Last edited by loqs (2022-04-24 19:29:33)
Offline
Pages: 1