LastTest.log

LastTest.log (text/plain), 9.77 KB, created by Toralf Förster on 2020-12-04 13:37:06 UTC

Start testing: Dec 04 14:05 CET
----------------------------------------------------------
1/8 Testing: test_pfx
1/8 Test: test_pfx
Command: "/var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build/tests/test_pfx"
Directory: /var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build
"test_pfx" start time: Dec 04 14:05 CET
Output:
----------------------------------------------------------
pfx_table_test() successful
remove_src_test() successful
Inserting 196560 records
validating..
removing records
mass_test() successful
Adding to table one
Adding to table two
Computing diff
+ 3.3.3.3                                     24 -  24            3
- 1.1.1.1                                     24 -  24            1
Freeing table one
Freeing table two
<end of output>
Test time =   0.55 sec
----------------------------------------------------------
Test Passed.
"test_pfx" end time: Dec 04 14:05 CET
"test_pfx" time elapsed: 00:00:00
----------------------------------------------------------

2/8 Testing: test_trie
2/8 Test: test_trie
Command: "/var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build/tests/test_trie"
Directory: /var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build
"test_trie" start time: Dec 04 14:05 CET
Output:
----------------------------------------------------------
Test successful
<end of output>
Test time =   0.00 sec
----------------------------------------------------------
Test Passed.
"test_trie" end time: Dec 04 14:05 CET
"test_trie" time elapsed: 00:00:00
----------------------------------------------------------

3/8 Testing: test_ht_spkitable
3/8 Test: test_ht_spkitable
Command: "/var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build/tests/test_ht_spkitable"
Directory: /var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build
"test_ht_spkitable" start time: Dec 04 14:05 CET
Output:
----------------------------------------------------------
test_ht_1() complete
test_ht_2() complete
test_ht_3 complete
test_ht_4() complete
test_ht_5() complete
test_ht_6() complete
test_ht_7() complete
test_table_swap() complete
Adding to table 1
Adding to table 2
Calculating diff
+ ASN: 3
SKI:  1e:00:00:00:1f:00:00:00:20:00:00:00:21:00:00:00:22:00:00:00
  SPKI: 2c:01:00:00:2d:01:00:00:2e:01:00:00:2f:01:00:00:30:01:00:00:31:01:00:00:32:01:00:00:33:01:00:00:34:01:00:00:35:01:00:00:
	36:01:00:00:37:01:00:00:38:01:00:00:39:01:00:00:3a:01:00:00:3b:01:00:00:3c:01:00:00:3d:01:00:00:3e:01:00:00:3f:01:00:00:
	40:01:00:00:41:01:00:00:00:00:00
- ASN: 1
SKI:  0a:00:00:00:0b:00:00:00:0c:00:00:00:0d:00:00:00:0e:00:00:00
  SPKI: 64:00:00:00:65:00:00:00:66:00:00:00:67:00:00:00:68:00:00:00:69:00:00:00:6a:00:00:00:6b:00:00:00:6c:00:00:00:6d:00:00:00:
	6e:00:00:00:6f:00:00:00:70:00:00:00:71:00:00:00:72:00:00:00:73:00:00:00:74:00:00:00:75:00:00:00:76:00:00:00:77:00:00:00:
	78:00:00:00:79:00:00:00:00:00:00
Freeing tables
test_table_diff() complete
<end of output>
Test time =   0.73 sec
----------------------------------------------------------
Test Passed.
"test_ht_spkitable" end time: Dec 04 14:05 CET
"test_ht_spkitable" time elapsed: 00:00:00
----------------------------------------------------------

4/8 Testing: test_ht_spkitable_locks
4/8 Test: test_ht_spkitable_locks
Command: "/var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build/tests/test_ht_spkitable_locks"
Directory: /var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build
"test_ht_spkitable_locks" start time: Dec 04 14:05 CET
Output:
----------------------------------------------------------
Add 10000 records: ASN [0..9999]
Add 10000 records: ASN [30000..39999]
Add 10000 records: ASN [20000..29999]
Add 10000 records: ASN [70000..79999]
Add 10000 records: ASN [140000..149999]
Add 10000 records: ASN [10000..19999]
Add 10000 records: ASN [150000..159999]
Add 10000 records: ASN [160000..169999]
Add 10000 records: ASN [180000..189999]
Add 10000 records: ASN [190000..199999]
Add 10000 records: ASN [40000..49999]
Add 10000 records: ASN [90000..99999]
Add 10000 records: ASN [80000..89999]
Add 10000 records: ASN [100000..109999]
Add 10000 records: ASN [110000..119999]
Add 10000 records: ASN [50000..59999]
Add 10000 records: ASN [120000..129999]
Add 10000 records: ASN [130000..139999]
Add 10000 records: ASN [170000..179999]
Add 10000 records: ASN [60000..69999]
Thread 0 returned
Thread 1 returned
Thread 2 returned
Thread 3 returned
Thread 4 returned
Thread 5 returned
Thread 6 returned
Thread 7 returned
Thread 8 returned
Thread 9 returned
Thread 10 returned
Thread 11 returned
Thread 12 returned
Thread 13 returned
Thread 14 returned
Thread 15 returned
Thread 16 returned
Thread 17 returned
Thread 18 returned
Thread 19 returned
Remove 10000 records: ASN [0..9999]
Remove 10000 records: ASN [10000..19999]
Remove 10000 records: ASN [20000..29999]
Remove 10000 records: ASN [30000..39999]
Remove 10000 records: ASN [40000..49999]
Remove 10000 records: ASN [50000..59999]
Remove 10000 records: ASN [60000..69999]
Remove 10000 records: ASN [80000..89999]
Remove 10000 records: ASN [180000..189999]
Remove 10000 records: ASN [170000..179999]
Remove 10000 records: ASN [160000..169999]
Remove 10000 records: ASN [150000..159999]
Remove 10000 records: ASN [190000..199999]
Remove 10000 records: ASN [140000..149999]
Remove 10000 records: ASN [70000..79999]
Remove 10000 records: ASN [100000..109999]
Remove 10000 records: ASN [110000..119999]
Remove 10000 records: ASN [130000..139999]
Remove 10000 records: ASN [90000..99999]
Remove 10000 records: ASN [120000..129999]
Thread 0 returned
Thread 1 returned
Thread 2 returned
Thread 3 returned
Thread 4 returned
Thread 5 returned
Thread 6 returned
Thread 7 returned
Thread 8 returned
Thread 9 returned
Thread 10 returned
Thread 11 returned
Thread 12 returned
Thread 13 returned
Thread 14 returned
Thread 15 returned
Thread 16 returned
Thread 17 returned
Thread 18 returned
Thread 19 returned
lock_test1() complete
<end of output>
Test time =   1.26 sec
----------------------------------------------------------
Test Passed.
"test_ht_spkitable_locks" end time: Dec 04 14:05 CET
"test_ht_spkitable_locks" time elapsed: 00:00:01
----------------------------------------------------------

5/8 Testing: test_live_validation
5/8 Test: test_live_validation
Command: "/var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build/tests/test_live_validation"
Directory: /var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build
"test_live_validation" start time: Dec 04 14:05 CET
Output:
----------------------------------------------------------
(2020/12/04 14:05:41:226505): RTR_MGR: rtr_mgr_start()
(2020/12/04 14:05:41:226620): RTR Socket: State: RTR_CONNECTING
(2020/12/04 14:05:41:227166): TCP Transport(rpki-validator.realmv6.org:8283): getaddrinfo error, Unknown error
(2020/12/04 14:05:41:227182): RTR_MGR: Group(1) status changed to: RTR_MGR_ERROR
(2020/12/04 14:05:41:227188): RTR_MGR: No other inactive groups found
(2020/12/04 14:05:41:227193): RTR Socket: State: RTR_ERROR_TRANSPORT
(2020/12/04 14:05:41:227198): TCP Transport(rpki-validator.realmv6.org:8283): Socket closed
(2020/12/04 14:05:41:227203): RTR_MGR: Group(1) status changed to: RTR_MGR_ERROR
(2020/12/04 14:05:41:227208): RTR Socket: Waiting 600
<end of output>
Test time =   1.01 sec
----------------------------------------------------------
Test Failed.
"test_live_validation" end time: Dec 04 14:05 CET
"test_live_validation" time elapsed: 00:00:01
----------------------------------------------------------

6/8 Testing: test_ipaddr
6/8 Test: test_ipaddr
Command: "/var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build/tests/test_ipaddr"
Directory: /var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build
"test_ipaddr" start time: Dec 04 14:05 CET
Output:
----------------------------------------------------------
Test successful
<end of output>
Test time =   0.00 sec
----------------------------------------------------------
Test Passed.
"test_ipaddr" end time: Dec 04 14:05 CET
"test_ipaddr" time elapsed: 00:00:00
----------------------------------------------------------

7/8 Testing: test_getbits
7/8 Test: test_getbits
Command: "/var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build/tests/test_getbits"
Directory: /var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build
"test_getbits" start time: Dec 04 14:05 CET
Output:
----------------------------------------------------------
Test successful
<end of output>
Test time =   0.00 sec
----------------------------------------------------------
Test Passed.
"test_getbits" end time: Dec 04 14:05 CET
"test_getbits" time elapsed: 00:00:00
----------------------------------------------------------

8/8 Testing: test_dynamic_groups
8/8 Test: test_dynamic_groups
Command: "/var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build/tests/test_dynamic_groups"
Directory: /var/tmp/portage/net-libs/rtrlib-0.7.0/work/rtrlib-0.7.0_build
"test_dynamic_groups" start time: Dec 04 14:05 CET
Output:
----------------------------------------------------------
(2020/12/04 14:05:42:240393): RTR_MGR: rtr_mgr_start()
(2020/12/04 14:05:42:240504): RTR Socket: State: RTR_CONNECTING
(2020/12/04 14:05:42:241019): TCP Transport(rpki-validator.realmv6.org:8283): getaddrinfo error, Unknown error
(2020/12/04 14:05:42:241035): RTR_MGR: Group(1) status changed to: RTR_MGR_ERROR
(2020/12/04 14:05:42:241042): RTR_MGR: No other inactive groups found
(2020/12/04 14:05:42:241047): RTR Socket: State: RTR_ERROR_TRANSPORT
(2020/12/04 14:05:42:241052): TCP Transport(rpki-validator.realmv6.org:8283): Socket closed
(2020/12/04 14:05:42:241058): RTR_MGR: Group(1) status changed to: RTR_MGR_ERROR
(2020/12/04 14:05:42:241064): RTR Socket: Waiting 600
<end of output>
Test time =   1.00 sec
----------------------------------------------------------
Test Failed.
"test_dynamic_groups" end time: Dec 04 14:05 CET
"test_dynamic_groups" time elapsed: 00:00:01
----------------------------------------------------------

End testing: Dec 04 14:05 CET