| line |
stmt |
bran |
cond |
sub |
pod |
time |
code |
|
1
|
|
|
|
|
|
|
package Protocol::TLS::Trace; |
|
2
|
2
|
|
|
2
|
|
10
|
use strict; |
|
|
2
|
|
|
|
|
4
|
|
|
|
2
|
|
|
|
|
48
|
|
|
3
|
2
|
|
|
2
|
|
10
|
use warnings; |
|
|
2
|
|
|
|
|
3
|
|
|
|
2
|
|
|
|
|
53
|
|
|
4
|
2
|
|
|
2
|
|
841
|
use Time::HiRes qw(time); |
|
|
2
|
|
|
|
|
1470
|
|
|
|
2
|
|
|
|
|
25
|
|
|
5
|
|
|
|
|
|
|
|
|
6
|
2
|
|
|
2
|
|
370
|
use Exporter qw(import); |
|
|
2
|
|
|
|
|
4
|
|
|
|
2
|
|
|
|
|
1351
|
|
|
7
|
|
|
|
|
|
|
our @EXPORT_OK = qw(tracer bin2hex); |
|
8
|
|
|
|
|
|
|
|
|
9
|
|
|
|
|
|
|
my %levels = ( |
|
10
|
|
|
|
|
|
|
debug => 0, |
|
11
|
|
|
|
|
|
|
info => 1, |
|
12
|
|
|
|
|
|
|
notice => 2, |
|
13
|
|
|
|
|
|
|
warning => 3, |
|
14
|
|
|
|
|
|
|
error => 4, |
|
15
|
|
|
|
|
|
|
critical => 5, |
|
16
|
|
|
|
|
|
|
alert => 6, |
|
17
|
|
|
|
|
|
|
emergency => 7, |
|
18
|
|
|
|
|
|
|
); |
|
19
|
|
|
|
|
|
|
|
|
20
|
|
|
|
|
|
|
my $tracer_sngl = Protocol::TLS::Trace->_new( |
|
21
|
|
|
|
|
|
|
min_level => ( exists $ENV{TLS_DEBUG} && exists $levels{ $ENV{TLS_DEBUG} } ) |
|
22
|
|
|
|
|
|
|
? $levels{ $ENV{TLS_DEBUG} } |
|
23
|
|
|
|
|
|
|
: $levels{error} |
|
24
|
|
|
|
|
|
|
); |
|
25
|
|
|
|
|
|
|
my $start_time = 0; |
|
26
|
|
|
|
|
|
|
|
|
27
|
|
|
|
|
|
|
sub tracer { |
|
28
|
116
|
|
|
116
|
0
|
651
|
$tracer_sngl; |
|
29
|
|
|
|
|
|
|
} |
|
30
|
|
|
|
|
|
|
|
|
31
|
|
|
|
|
|
|
sub _new { |
|
32
|
2
|
|
|
2
|
|
8
|
my ( $class, %opts ) = @_; |
|
33
|
2
|
|
|
|
|
11
|
bless {%opts}, $class; |
|
34
|
|
|
|
|
|
|
} |
|
35
|
|
|
|
|
|
|
|
|
36
|
|
|
|
|
|
|
sub _log { |
|
37
|
116
|
|
|
116
|
|
219
|
my ( $self, $level, $message ) = @_; |
|
38
|
116
|
50
|
|
|
|
560
|
if ( $level >= $self->{min_level} ) { |
|
39
|
0
|
|
|
|
|
0
|
chomp($message); |
|
40
|
0
|
|
|
|
|
0
|
my @caller = map { s/Protocol::TLS:://; $_ } |
|
|
0
|
|
|
|
|
0
|
|
|
|
0
|
|
|
|
|
0
|
|
|
41
|
|
|
|
|
|
|
( ( caller(2) )[3], ( caller(1) )[2] ); |
|
42
|
0
|
|
|
|
|
0
|
my $now = time; |
|
43
|
0
|
0
|
|
|
|
0
|
if ( $now - $start_time < 60 ) { |
|
44
|
0
|
|
|
|
|
0
|
$message =~ s/\n/\n /g; |
|
45
|
0
|
|
|
|
|
0
|
printf "[%05.3f] [%s:%s] %s\n", $now - $start_time, @caller, |
|
46
|
|
|
|
|
|
|
$message; |
|
47
|
|
|
|
|
|
|
} |
|
48
|
|
|
|
|
|
|
else { |
|
49
|
0
|
|
|
|
|
0
|
my @t = ( localtime() )[ 5, 4, 3, 2, 1, 0 ]; |
|
50
|
0
|
|
|
|
|
0
|
$t[0] += 1900; |
|
51
|
0
|
|
|
|
|
0
|
$t[1]++; |
|
52
|
0
|
|
|
|
|
0
|
$message =~ s/\n/\n /g; |
|
53
|
0
|
|
|
|
|
0
|
printf "[%4d-%02d-%02d %02d:%02d:%02d] [%s:%s] %s\n", @t, |
|
54
|
|
|
|
|
|
|
@caller, $message; |
|
55
|
0
|
|
|
|
|
0
|
$start_time = $now; |
|
56
|
|
|
|
|
|
|
} |
|
57
|
|
|
|
|
|
|
} |
|
58
|
|
|
|
|
|
|
} |
|
59
|
|
|
|
|
|
|
|
|
60
|
|
|
|
|
|
|
sub debug { |
|
61
|
116
|
|
|
116
|
0
|
334
|
shift->_log( 0, @_ ); |
|
62
|
|
|
|
|
|
|
} |
|
63
|
|
|
|
|
|
|
|
|
64
|
|
|
|
|
|
|
sub info { |
|
65
|
0
|
|
|
0
|
0
|
0
|
shift->_log( 1, @_ ); |
|
66
|
|
|
|
|
|
|
} |
|
67
|
|
|
|
|
|
|
|
|
68
|
|
|
|
|
|
|
sub notice { |
|
69
|
0
|
|
|
0
|
0
|
0
|
shift->_log( 2, @_ ); |
|
70
|
|
|
|
|
|
|
} |
|
71
|
|
|
|
|
|
|
|
|
72
|
|
|
|
|
|
|
sub warning { |
|
73
|
0
|
|
|
0
|
0
|
0
|
shift->_log( 3, @_ ); |
|
74
|
|
|
|
|
|
|
} |
|
75
|
|
|
|
|
|
|
|
|
76
|
|
|
|
|
|
|
sub error { |
|
77
|
0
|
|
|
0
|
0
|
0
|
shift->_log( 4, @_ ); |
|
78
|
|
|
|
|
|
|
} |
|
79
|
|
|
|
|
|
|
|
|
80
|
|
|
|
|
|
|
sub critical { |
|
81
|
0
|
|
|
0
|
0
|
0
|
shift->_log( 5, @_ ); |
|
82
|
|
|
|
|
|
|
} |
|
83
|
|
|
|
|
|
|
|
|
84
|
|
|
|
|
|
|
sub alert { |
|
85
|
0
|
|
|
0
|
0
|
0
|
shift->_log( 6, @_ ); |
|
86
|
|
|
|
|
|
|
} |
|
87
|
|
|
|
|
|
|
|
|
88
|
|
|
|
|
|
|
sub emergency { |
|
89
|
0
|
|
|
0
|
0
|
0
|
shift->_log( 7, @_ ); |
|
90
|
|
|
|
|
|
|
} |
|
91
|
|
|
|
|
|
|
|
|
92
|
|
|
|
|
|
|
sub bin2hex { |
|
93
|
10
|
|
|
10
|
0
|
18
|
my $bin = shift; |
|
94
|
10
|
|
|
|
|
18
|
my $c = 0; |
|
95
|
10
|
|
|
|
|
18
|
my $s; |
|
96
|
|
|
|
|
|
|
|
|
97
|
|
|
|
|
|
|
join "", map { |
|
98
|
10
|
|
|
|
|
83
|
$c++; |
|
|
200
|
|
|
|
|
246
|
|
|
99
|
200
|
100
|
|
|
|
480
|
$s = !( $c % 16 ) ? "\n" : ( $c % 2 ) ? "" : " "; |
|
|
|
100
|
|
|
|
|
|
|
100
|
200
|
|
|
|
|
456
|
$_ . $s |
|
101
|
|
|
|
|
|
|
} unpack( "(H2)*", $bin ); |
|
102
|
|
|
|
|
|
|
} |
|
103
|
|
|
|
|
|
|
|
|
104
|
|
|
|
|
|
|
1 |