← Index
NYTProf Performance Profile   « line view »
For /usr/local/bin/sa-learn
  Run on Sun Nov 5 03:09:29 2017
Reported on Mon Nov 6 13:20:47 2017

Filename/usr/local/lib/perl5/site_perl/Mail/SpamAssassin/Message/Metadata.pm
StatementsExecuted 14899 statements in 88.9ms
Subroutines
Calls P F Exclusive
Time		 Inclusive
Time		 Subroutine
441391001274ms274msMail::SpamAssassin::Message::Metadata::::CORE:matchMail::SpamAssassin::Message::Metadata::CORE:match (opcode)
25852281188ms188msMail::SpamAssassin::Message::Metadata::::CORE:substMail::SpamAssassin::Message::Metadata::CORE:subst (opcode)
11765571135ms135msMail::SpamAssassin::Message::Metadata::::CORE:regcompMail::SpamAssassin::Message::Metadata::CORE:regcomp (opcode)
2341178.4ms3.75sMail::SpamAssassin::Message::Metadata::::extractMail::SpamAssassin::Message::Metadata::extract
11113.1ms175msMail::SpamAssassin::Message::Metadata::::BEGIN@59Mail::SpamAssassin::Message::Metadata::BEGIN@59
41642112.0ms12.0msMail::SpamAssassin::Message::Metadata::::CORE:substcontMail::SpamAssassin::Message::Metadata::CORE:substcont (opcode)
2341111.9ms11.9msMail::SpamAssassin::Message::Metadata::::finishMail::SpamAssassin::Message::Metadata::finish
234114.87ms4.87msMail::SpamAssassin::Message::Metadata::::newMail::SpamAssassin::Message::Metadata::new
11149µs63µsMail::SpamAssassin::Message::Metadata::::BEGIN@51Mail::SpamAssassin::Message::Metadata::BEGIN@51
11132µs188µsMail::SpamAssassin::Message::Metadata::::BEGIN@60Mail::SpamAssassin::Message::Metadata::BEGIN@60
11127µs96µsMail::SpamAssassin::Message::Metadata::::BEGIN@54Mail::SpamAssassin::Message::Metadata::BEGIN@54
11123µs664µsMail::SpamAssassin::Message::Metadata::::BEGIN@57Mail::SpamAssassin::Message::Metadata::BEGIN@57
11123µs66µsMail::SpamAssassin::Message::Metadata::::BEGIN@52Mail::SpamAssassin::Message::Metadata::BEGIN@52
11123µs30µsMail::SpamAssassin::Message::Metadata::::BEGIN@53Mail::SpamAssassin::Message::Metadata::BEGIN@53
11122µs116µsMail::SpamAssassin::Message::Metadata::::BEGIN@58Mail::SpamAssassin::Message::Metadata::BEGIN@58
11116µs16µsMail::SpamAssassin::Message::Metadata::::BEGIN@56Mail::SpamAssassin::Message::Metadata::BEGIN@56
Call graph for these subroutines as a Graphviz dot language file.
Line State
ments		 Time
on line		 Calls Time
in subs		 Code
1# <@LICENSE>
2# Licensed to the Apache Software Foundation (ASF) under one or more
3# contributor license agreements. See the NOTICE file distributed with
4# this work for additional information regarding copyright ownership.
5# The ASF licenses this file to you under the Apache License, Version 2.0
6# (the "License"); you may not use this file except in compliance with
7# the License. You may obtain a copy of the License at:
8#
9# http://www.apache.org/licenses/LICENSE-2.0
10#
11# Unless required by applicable law or agreed to in writing, software
12# distributed under the License is distributed on an "AS IS" BASIS,
13# WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
14# See the License for the specific language governing permissions and
15# limitations under the License.
16# </@LICENSE>
17
18=head1 NAME
19
20Mail::SpamAssassin::Message::Metadata - extract metadata from a message
21
22=head1 SYNOPSIS
23
24=head1 DESCRIPTION
25
26This class is tasked with extracting "metadata" from messages for use as
27Bayes tokens, fodder for eval tests, or other rules. Metadata is
28supplemental data inferred from the message, like the examples below.
29
30It is held in two forms:
31
321. as name-value pairs of strings, presented in mail header format. For
33 example, "X-Language" => "en". This is the general form for simple
34 metadata that's useful as Bayes tokens, can be added to marked-up
35 messages using "add_header", etc., such as the trusted-relay inference
36 and language detection.
37
382. as more complex data structures on the $msg->{metadata} object. This
39 is the form used for metadata like the HTML parse data, which is stored
40 there for access by eval rule code. Because it's not simple strings,
41 it's not added as a Bayes token by default (Bayes needs simple strings).
42
43=head1 PUBLIC METHODS
44
45=over 4
46
47=cut
48
49package Mail::SpamAssassin::Message::Metadata;
50
51261µs278µs
# spent 63µs (49+15) within Mail::SpamAssassin::Message::Metadata::BEGIN@51 which was called: # once (49µs+15µs) by Mail::SpamAssassin::Message::BEGIN@56 at line 51
use strict;
# spent 63µs making 1 call to Mail::SpamAssassin::Message::Metadata::BEGIN@51 # spent 15µs making 1 call to strict::import
52257µs2109µs
# spent 66µs (23+43) within Mail::SpamAssassin::Message::Metadata::BEGIN@52 which was called: # once (23µs+43µs) by Mail::SpamAssassin::Message::BEGIN@56 at line 52
use warnings;
# spent 66µs making 1 call to Mail::SpamAssassin::Message::Metadata::BEGIN@52 # spent 43µs making 1 call to warnings::import
53262µs237µs
# spent 30µs (23+7) within Mail::SpamAssassin::Message::Metadata::BEGIN@53 which was called: # once (23µs+7µs) by Mail::SpamAssassin::Message::BEGIN@56 at line 53
use bytes;
# spent 30µs making 1 call to Mail::SpamAssassin::Message::Metadata::BEGIN@53 # spent 7µs making 1 call to bytes::import
54269µs2166µs
# spent 96µs (27+70) within Mail::SpamAssassin::Message::Metadata::BEGIN@54 which was called: # once (27µs+70µs) by Mail::SpamAssassin::Message::BEGIN@56 at line 54
use re 'taint';
# spent 96µs making 1 call to Mail::SpamAssassin::Message::Metadata::BEGIN@54 # spent 70µs making 1 call to re::import
55
56260µs116µs
# spent 16µs within Mail::SpamAssassin::Message::Metadata::BEGIN@56 which was called: # once (16µs+0s) by Mail::SpamAssassin::Message::BEGIN@56 at line 56
use Mail::SpamAssassin;
# spent 16µs making 1 call to Mail::SpamAssassin::Message::Metadata::BEGIN@56
57277µs21.31ms
# spent 664µs (23+641) within Mail::SpamAssassin::Message::Metadata::BEGIN@57 which was called: # once (23µs+641µs) by Mail::SpamAssassin::Message::BEGIN@56 at line 57
use Mail::SpamAssassin::Constants qw(:sa);
# spent 664µs making 1 call to Mail::SpamAssassin::Message::Metadata::BEGIN@57 # spent 641µs making 1 call to Exporter::import
58264µs2211µs
# spent 116µs (22+94) within Mail::SpamAssassin::Message::Metadata::BEGIN@58 which was called: # once (22µs+94µs) by Mail::SpamAssassin::Message::BEGIN@56 at line 58
use Mail::SpamAssassin::Util qw(reverse_ip_address);
# spent 116µs making 1 call to Mail::SpamAssassin::Message::Metadata::BEGIN@58 # spent 94µs making 1 call to Exporter::import
592419µs1175ms
# spent 175ms (13.1+162) within Mail::SpamAssassin::Message::Metadata::BEGIN@59 which was called: # once (13.1ms+162ms) by Mail::SpamAssassin::Message::BEGIN@56 at line 59
use Mail::SpamAssassin::Message::Metadata::Received;
# spent 175ms making 1 call to Mail::SpamAssassin::Message::Metadata::BEGIN@59
602542µs2345µs
# spent 188µs (32+157) within Mail::SpamAssassin::Message::Metadata::BEGIN@60 which was called: # once (32µs+157µs) by Mail::SpamAssassin::Message::BEGIN@56 at line 60
use Mail::SpamAssassin::Logger;
# spent 188µs making 1 call to Mail::SpamAssassin::Message::Metadata::BEGIN@60 # spent 157µs making 1 call to Exporter::import
61
62=item new()
63
64=back
65
66=cut
67
68
# spent 4.87ms within Mail::SpamAssassin::Message::Metadata::new which was called 234 times, avg 21µs/call: # 234 times (4.87ms+0s) by Mail::SpamAssassin::Message::new at line 147 of Mail/SpamAssassin/Message.pm, avg 21µs/call
sub new {
69234577µs my ($class, $msg) = @_;
70234602µs $class = ref($class) || $class;
71
722341.48ms my $self = {
73 msg => $msg,
74 strings => { }
75 };
76
77234552µs bless($self,$class);
782341.84ms $self;
79}
80
81
# spent 3.75s (78.4ms+3.67) within Mail::SpamAssassin::Message::Metadata::extract which was called 234 times, avg 16.0ms/call: # 234 times (78.4ms+3.67s) by Mail::SpamAssassin::Message::extract_message_metadata at line 527 of Mail/SpamAssassin/Message.pm, avg 16.0ms/call
sub extract {
82234528µs my ($self, $msg, $permsgstatus) = @_;
83
84 # pre-chew Received headers
852342.59ms2343.48s $self->parse_received_headers ($permsgstatus, $msg);
# spent 3.48s making 234 calls to Mail::SpamAssassin::Message::Metadata::parse_received_headers, avg 14.9ms/call
86
872344.46ms foreach my $tuple (
88 [$self->{relays_trusted}, 'RELAYSTRUSTEDREVIP' ],
89 [$self->{relays_untrusted}, 'RELAYSUNTRUSTEDREVIP'],
90 [$self->{relays_internal}, 'RELAYSINTERNALREVIP' ],
91 [$self->{relays_external}, 'RELAYSEXTERNALREVIP' ])
929362.24ms { my($rly, $tag) = @$tuple;
939361.63ms my @revips;
94 @revips = map {
95301813.9ms my($ip,$revip);
9620829.59ms $ip = $_->{ip} if ref $_ && !$_->{ip_private};
97208212.0ms71454.8ms $revip = reverse_ip_address($ip) if defined $ip && $ip ne '';
# spent 54.8ms making 714 calls to Mail::SpamAssassin::Util::reverse_ip_address, avg 77µs/call
9820828.77ms defined $revip && $revip ne '' ? $revip : ();
99 } @$rly if $rly;
1009369.17ms46631.5ms $permsgstatus->set_tag($tag,
# spent 31.5ms making 466 calls to Mail::SpamAssassin::PerMsgStatus::set_tag, avg 68µs/call
101 @revips == 1 ? $revips[0] : \@revips) if @revips;
102 }
103
104 $permsgstatus->{main}->call_plugins("extract_metadata",
105 { msg => $msg, permsgstatus => $permsgstatus,
1062345.20ms2340s conf => $permsgstatus->{main}->{conf} });
# spent 100ms making 234 calls to Mail::SpamAssassin::call_plugins, avg 429µs/call, recursion: max depth 1, sum of overlapping time 100ms
107}
108
109
# spent 11.9ms within Mail::SpamAssassin::Message::Metadata::finish which was called 234 times, avg 51µs/call: # 234 times (11.9ms+0s) by Mail::SpamAssassin::Message::finish_metadata at line 605 of Mail/SpamAssassin/Message.pm, avg 51µs/call
sub finish {
110234588µs my ($self) = @_;
11146811.7ms %{$self} = ();
112}
113
11418µs1;
 
# spent 274ms within Mail::SpamAssassin::Message::Metadata::CORE:match which was called 44139 times, avg 6µs/call: # 12528 times (61.4ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 408 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 6070 times (20.0ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 476 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 2117 times (16.1ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 390 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 8µs/call # 1139 times (10.7ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 358 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 9µs/call # 1067 times (3.21ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 468 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 1063 times (19.4ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 453 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 18µs/call # 1063 times (9.25ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 386 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 9µs/call # 1063 times (8.92ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 367 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 8µs/call # 1063 times (8.22ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 396 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 8µs/call # 1063 times (3.31ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 362 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 1063 times (3.20ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 460 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 1041 times (10.7ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1350 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 10µs/call # 1041 times (4.06ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1292 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 634 times (2.43ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 636 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 632 times (6.39ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 656 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 10µs/call # 632 times (1.76ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 648 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 560 times (6.49ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 599 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 12µs/call # 481 times (23.1ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 765 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 48µs/call # 481 times (3.46ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 690 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 7µs/call # 481 times (3.35ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 698 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 7µs/call # 481 times (3.32ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 721 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 7µs/call # 481 times (3.10ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 672 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 481 times (2.41ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 678 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 481 times (2.36ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 731 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 481 times (2.25ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 684 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 481 times (2.18ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 716 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 481 times (1.74ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 707 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 395 times (2.41ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 808 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 395 times (1.81ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 802 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 395 times (1.74ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 813 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 395 times (1.06ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 797 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 394 times (2.18ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 820 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 386 times (4.88ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 835 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 13µs/call # 386 times (1.72ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 825 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 342 times (2.97ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 766 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 9µs/call # 145 times (621µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 610 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 103 times (635µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 844 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 100 times (1.03ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 856 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 10µs/call # 55 times (677µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 897 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 12µs/call # 55 times (341µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 882 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 55 times (312µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 865 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 55 times (206µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 873 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 41 times (146µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 938 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 40 times (465µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1069 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 12µs/call # 40 times (442µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1021 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 11µs/call # 40 times (377µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 951 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 9µs/call # 40 times (300µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1040 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 8µs/call # 40 times (237µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1035 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 40 times (237µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1001 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 40 times (224µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 981 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 40 times (212µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 971 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 40 times (202µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1080 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 40 times (165µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1050 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 40 times (164µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 995 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 40 times (163µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1045 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 40 times (161µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 963 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 40 times (152µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 988 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 40 times (151µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 930 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 40 times (144µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1007 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 40 times (141µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 909 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 40 times (140µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1029 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 40 times (138µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1056 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 40 times (129µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1061 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 40 times (127µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 944 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 40 times (125µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1013 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 40 times (124µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 917 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 40 times (119µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 957 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 40 times (118µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 923 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 36 times (253µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1088 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 7µs/call # 36 times (146µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1114 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 36 times (137µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1097 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 36 times (129µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1108 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 29 times (645µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 489 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 22µs/call # 29 times (84µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 495 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 28 times (189µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1202 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 7µs/call # 28 times (172µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1151 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 28 times (146µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1138 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 28 times (144µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1147 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 28 times (131µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1124 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 28 times (113µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1154 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 28 times (106µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1129 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 28 times (91µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1135 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 28 times (90µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1161 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 28 times (90µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1191 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 28 times (89µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1182 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 28 times (87µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1132 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 28 times (85µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1168 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 28 times (84µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1157 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 28 times (79µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1165 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 28 times (72µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1141 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 28 times (71µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1176 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 19 times (142µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1257 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 7µs/call # 19 times (97µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1206 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # 19 times (63µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1209 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 17 times (182µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 521 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 11µs/call # 17 times (75µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 516 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 12 times (67µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1213 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 8 times (167µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_headers at line 129 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 21µs/call # 3 times (16µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 536 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 5µs/call # once (9µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 540 of Mail/SpamAssassin/Message/Metadata/Received.pm
sub Mail::SpamAssassin::Message::Metadata::CORE:match; # opcode
# spent 135ms within Mail::SpamAssassin::Message::Metadata::CORE:regcomp which was called 11765 times, avg 11µs/call: # 1043 times (12.1ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 408 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 12µs/call # 1041 times (1.86ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1350 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 2µs/call # 632 times (5.58ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 656 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 9µs/call # 560 times (5.76ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 599 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 10µs/call # 481 times (5.19ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 716 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 11µs/call # 481 times (5.14ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 765 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 11µs/call # 481 times (5.11ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 678 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 11µs/call # 481 times (5.05ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 731 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 10µs/call # 481 times (4.92ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 690 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 10µs/call # 481 times (4.91ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 698 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 10µs/call # 481 times (4.89ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 684 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 10µs/call # 481 times (4.89ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 721 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 10µs/call # 481 times (4.31ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 672 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 9µs/call # 395 times (4.62ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 802 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 12µs/call # 395 times (4.35ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 808 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 11µs/call # 395 times (4.28ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 813 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 11µs/call # 394 times (4.32ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 820 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 11µs/call # 386 times (4.55ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 835 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 12µs/call # 386 times (4.46ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 825 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 12µs/call # 342 times (4.63ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 766 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 14µs/call # 145 times (2.05ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 610 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 14µs/call # 103 times (1.78ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 844 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 17µs/call # 100 times (1.67ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 856 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 17µs/call # 55 times (1.09ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 882 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 20µs/call # 55 times (1.07ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 865 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 19µs/call # 55 times (1.04ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 897 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 19µs/call # 40 times (1.02ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 963 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 25µs/call # 40 times (1.01ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1069 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 25µs/call # 40 times (996µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1040 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 25µs/call # 40 times (976µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 951 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 24µs/call # 40 times (965µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 981 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 24µs/call # 40 times (956µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1021 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 24µs/call # 40 times (955µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1061 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 24µs/call # 40 times (916µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1056 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 23µs/call # 40 times (909µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 995 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 23µs/call # 40 times (908µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1001 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 23µs/call # 40 times (899µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 930 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 22µs/call # 40 times (884µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1045 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 22µs/call # 40 times (873µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1050 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 22µs/call # 40 times (873µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1080 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 22µs/call # 40 times (867µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1029 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 22µs/call # 40 times (861µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1035 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 22µs/call # 36 times (890µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1108 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 25µs/call # 36 times (862µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1097 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 24µs/call # 36 times (849µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1088 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 24µs/call # 29 times (772µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 489 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 27µs/call # 28 times (966µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1147 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 34µs/call # 28 times (546µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1124 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 19µs/call # 28 times (411µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1154 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 15µs/call # 28 times (344µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1151 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 12µs/call # 19 times (563µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1257 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 30µs/call # 17 times (668µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 516 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 39µs/call # 17 times (531µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 521 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 31µs/call # 8 times (704µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_headers at line 129 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 88µs/call # 2 times (977µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 636 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 489µs/call # once (486µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 540 of Mail/SpamAssassin/Message/Metadata/Received.pm # once (470µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 938 of Mail/SpamAssassin/Message/Metadata/Received.pm
sub Mail::SpamAssassin::Message::Metadata::CORE:regcomp; # opcode
# spent 188ms within Mail::SpamAssassin::Message::Metadata::CORE:subst which was called 25852 times, avg 7µs/call: # 2082 times (16.8ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1307 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 8µs/call # 2082 times (4.81ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1297 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 2µs/call # 1139 times (40.9ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 322 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 36µs/call # 1139 times (10.1ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 324 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 9µs/call # 1139 times (4.26ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_headers at line 145 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 1139 times (2.81ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 323 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 2µs/call # 1139 times (2.78ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 327 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 2µs/call # 1063 times (31.8ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 373 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 30µs/call # 1063 times (10.1ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 451 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 9µs/call # 1063 times (3.57ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 376 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 1041 times (9.31ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_headers at line 236 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 9µs/call # 1041 times (7.42ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_headers at line 237 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 7µs/call # 1041 times (6.84ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1314 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 7µs/call # 1041 times (5.94ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1316 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 1041 times (5.88ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1317 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 1041 times (5.74ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1308 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 6µs/call # 1041 times (4.19ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1315 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 1041 times (4.05ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1296 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 1041 times (3.68ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1305 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 4µs/call # 1041 times (2.63ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1300 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 1041 times (2.12ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1319 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 2µs/call # 1041 times (1.87ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1318 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 2µs/call # 151 times (435µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 659 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 151 times (427µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 660 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 4 times (34µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1082 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 9µs/call # 4 times (13µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 1083 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # once (8µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 542 of Mail/SpamAssassin/Message/Metadata/Received.pm # once (4µs+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_line at line 543 of Mail/SpamAssassin/Message/Metadata/Received.pm
sub Mail::SpamAssassin::Message::Metadata::CORE:subst; # opcode
# spent 12.0ms within Mail::SpamAssassin::Message::Metadata::CORE:substcont which was called 4164 times, avg 3µs/call: # 2082 times (6.91ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_headers at line 236 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 3µs/call # 2082 times (5.11ms+0s) by Mail::SpamAssassin::Message::Metadata::parse_received_headers at line 237 of Mail/SpamAssassin/Message/Metadata/Received.pm, avg 2µs/call
sub Mail::SpamAssassin::Message::Metadata::CORE:substcont; # opcode
Report produced by the NYTProf 6.04 Perl profiler, developed by Tim Bunce based on work by Adam Kaplan and Salvador Fandiño García.