Project

General

Profile

Regression #11316 » unbound-crash-2021-08-11-corrected.log

Akom Benevolent, 08/11/2021 03:19 PM

 
1
Jul  9 13:59:29 router unbound[47761]: [47761:0] info: start of service (unbound 1.12.0).
2
Aug 11 15:09:27 router unbound[94261]: [94261:0] notice: init module 0: iterator
3
Aug 11 15:09:27 router unbound[94261]: [94261:0] info: start of service (unbound 1.12.0).
4
Aug 11 15:09:27 router unbound[94261]: [94261:0] info: service stopped (unbound 1.12.0).
5
Aug 11 15:09:27 router unbound[94261]: [94261:0] info: server stats for thread 0: 36 queries, 5 answers from cache, 31 recursions, 0 prefetch, 0 rejected by ip ratelimiting
6
Aug 11 15:09:27 router unbound[94261]: [94261:0] info: server stats for thread 0: requestlist max 29 avg 15.3548 exceeded 0 jostled 0
7
Aug 11 15:09:27 router unbound[94261]: [94261:0] info: server stats for thread 1: 145 queries, 8 answers from cache, 137 recursions, 0 prefetch, 0 rejected by ip ratelimiting
8
Aug 11 15:09:27 router unbound[94261]: [94261:0] info: server stats for thread 1: requestlist max 104 avg 56.8467 exceeded 0 jostled 0
9
Aug 11 15:09:27 router unbound[94261]: [94261:0] notice: Restart of unbound 1.12.0.
10
Aug 11 15:09:32 router unbound[94261]: [94261:0] notice: init module 0: iterator
11
Aug 11 15:09:32 router unbound[94261]: [94261:0] info: start of service (unbound 1.12.0).
12
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: service stopped (unbound 1.12.0).
13
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: server stats for thread 0: 92 queries, 70 answers from cache, 22 recursions, 0 prefetch, 0 rejected by ip ratelimiting
14
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: server stats for thread 0: requestlist max 9 avg 2.18182 exceeded 0 jostled 0
15
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: average recursion processing time 0.093130 sec
16
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: histogram of recursion processing times
17
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: [25%]=0.03072 median[50%]=0.077824 [75%]=0.120832
18
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: lower(secs) upper(secs) recursions
19
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.016384    0.032768 6
20
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.032768    0.065536 3
21
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.065536    0.131072 8
22
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.131072    0.262144 2
23
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.262144    0.524288 2
24
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: server stats for thread 1: 268 queries, 56 answers from cache, 212 recursions, 0 prefetch, 0 rejected by ip ratelimiting
25
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: server stats for thread 1: requestlist max 127 avg 70.1415 exceeded 0 jostled 0
26
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: average recursion processing time 0.651326 sec
27
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: histogram of recursion processing times
28
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: [25%]=0.597879 median[50%]=0.737176 [75%]=0.876473
29
Aug 11 15:09:47 router unbound[94261]: [94261:0] info: lower(secs) upper(secs) recursions
30
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.004096    0.008192 1
31
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.016384    0.032768 2
32
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.032768    0.065536 5
33
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.065536    0.131072 5
34
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.262144    0.524288 12
35
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    0.524288    1.000000 181
36
Aug 11 15:09:47 router unbound[94261]: [94261:0] info:    1.000000    2.000000 6
37
Aug 11 15:09:47 router unbound[94261]: [94261:0] notice: Restart of unbound 1.12.0.
38
Aug 11 15:09:52 router unbound[94261]: [94261:0] notice: init module 0: iterator
39
Aug 11 15:09:52 router unbound[94261]: [94261:0] info: start of service (unbound 1.12.0).
40
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: service stopped (unbound 1.12.0).
41
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: server stats for thread 0: 48 queries, 12 answers from cache, 36 recursions, 0 prefetch, 0 rejected by ip ratelimiting
42
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: server stats for thread 0: requestlist max 15 avg 1.47222 exceeded 0 jostled 0
43
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: average recursion processing time 0.148183 sec
44
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: histogram of recursion processing times
45
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: [25%]=0.0514926 median[50%]=0.101283 [75%]=0.189326
46
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: lower(secs) upper(secs) recursions
47
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.016384    0.032768 5
48
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.032768    0.065536 7
49
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.065536    0.131072 11
50
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.131072    0.262144 9
51
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.262144    0.524288 3
52
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    1.000000    2.000000 1
53
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: server stats for thread 1: 49 queries, 17 answers from cache, 32 recursions, 0 prefetch, 0 rejected by ip ratelimiting
54
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: server stats for thread 1: requestlist max 10 avg 0.8125 exceeded 0 jostled 0
55
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: average recursion processing time 0.118400 sec
56
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: histogram of recursion processing times
57
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: [25%]=0.0278528 median[50%]=0.065536 [75%]=0.174763
58
Aug 11 15:11:32 router unbound[94261]: [94261:0] info: lower(secs) upper(secs) recursions
59
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.000000    0.000001 1
60
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.016384    0.032768 10
61
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.032768    0.065536 5
62
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.065536    0.131072 6
63
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.131072    0.262144 6
64
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.262144    0.524288 3
65
Aug 11 15:11:32 router unbound[94261]: [94261:0] info:    0.524288    1.000000 1
66
Aug 11 15:11:32 router unbound[94261]: [94261:0] notice: Restart of unbound 1.12.0.
67
Aug 11 15:11:37 router unbound[94261]: [94261:0] notice: init module 0: iterator
68
Aug 11 15:11:37 router unbound[94261]: [94261:0] info: start of service (unbound 1.12.0).
69
Aug 11 15:18:48 router unbound[94261]: [94261:0] info: service stopped (unbound 1.12.0).
70
Aug 11 15:18:48 router unbound[94261]: [94261:0] info: server stats for thread 0: 117 queries, 61 answers from cache, 56 recursions, 0 prefetch, 0 rejected by ip ratelimiting
71
Aug 11 15:18:48 router unbound[94261]: [94261:0] info: server stats for thread 0: requestlist max 15 avg 0.535714 exceeded 0 jostled 0
72
Aug 11 15:18:48 router unbound[94261]: [94261:0] info: average recursion processing time 0.093517 sec
73
Aug 11 15:18:48 router unbound[94261]: [94261:0] info: histogram of recursion processing times
74
Aug 11 15:18:48 router unbound[94261]: [94261:0] info: [25%]=0.028672 median[50%]=0.069632 [75%]=0.126976
75
Aug 11 15:18:48 router unbound[94261]: [94261:0] info: lower(secs) upper(secs) recursions
76

    
(6-6/6)