Daily Usenet report

Jun 4 04:15:01 -- Jun 5 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jun 4 18:13:08 newsfeed nnrpd[3331980]: SERVER perl filter not defined
Jun 4 18:13:08 newsfeed nnrpd[3331980]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 265274 86.9%29.0 MB 88.3%
innd 22344 7.3%2.1 MB 6.5%
nnrpd 16540 5.4%1.6 MB 4.8%
innfeed 1272 0.4%165.2 KB 0.5%
overchan 2 0.0%0.3 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 6 305434 100.0%32.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 524898 98.2%
Negative hits 7128 1.3%
Cache misses 2340 0.4%
Positive hits 118 0.0%
TOTAL: 4 534484 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.248 0.0%200 0.000 1.240 15.000
article cleanup00:00:02.734 0.0%526806 0.002 0.005 0.013
article logging00:00:10.618 0.0%526890 0.011 0.020 0.036
article parse00:00:30.556 0.0%1989162 0.008 0.015 0.027
article write00:02:21.324 0.1%525552 0.197 0.269 0.464
artlog/artcncl00:00:00.006 0.0%74 0.000 0.081 1.000
data move00:00:02.762 0.0%3009570 0.000 0.001 0.002
hisgrep/artcncl00:00:00.044 0.0%274 0.000 0.161 0.889
hishave/artcncl00:00:00.000 0.0%74 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:36.146 0.0%535072 0.005 0.068 0.501
history sync00:00:00.032 0.0%674 0.000 0.047 0.500
history write00:00:54.084 0.0%525560 0.039 0.103 0.399
idle47:23:57.462 99.4%2308310 25.578 73.923 554.283
nntp read00:00:30.342 0.0%1900342 0.010 0.016 0.033
overview write00:00:01.464 0.0%525552 0.000 0.003 0.007
perl filter00:10:27.130 0.4%525560 0.813 1.193 1.803
python filter00:00:00.156 0.0%525562 0.000 0.000 0.003
site send00:00:12.220 0.0%1064366 0.007 0.011 0.021
TOTAL: 47:41:07.07647:39:47.328100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.020 0.0%13298 0.000 0.002 0.048
article prepare00:00:00.002 0.0%2528 0.000 0.001 0.250
article read00:00:00.024 0.0%632 0.000 0.038 1.000
backlog stats00:00:00.024 0.0%80826 0.000 0.000 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.366 0.0%37882 0.000 0.010 0.053
data write00:00:01.220 0.0%24592 0.000 0.050 0.179
idle47:55:31.366100.0%80826 490.821 2134.602 6390.723
status file00:00:00.126 0.0%334 0.000 0.377 2.000
TOTAL: 47:55:33.95047:55:33.148100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:45.310 46.5%8952 0.000 11.764 9822.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.330 0.1%30298 0.000 0.011 0.500
readart00:00:00.000 0.0%8 0.000 0.000 0.000
TOTAL: 00:03:46.43400:01:45.640 46.7%----

Control commands to INND:

CommandNumber
flush 54
flushlogs 4
go 4
logmode 4
lowmark 2
mode 296
name 4
pause 4
paused 4
reload 4
reserve 4
TOTAL: 11 384

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 72 531508 529226 1032 1250 99%67:14:36
2news.icm.edu.pl 74 120 6 106 8 5%14:53:26
3localhost 4 2 2 0 0 100%00:00:00
TOTAL: 3 150 531630 529234 1138 1258 99%82:08:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl6.4 GB16.9 MB0.0 KB6.4 GB 99%12.6 KB
2news.icm.edu.pl101.7 KB0.0 KB898.5 KB1000.2 KB 10%71.4 KB
3localhost4.7 KB0.0 KB0.0 KB4.7 KB100%2.4 KB
TOTAL: 36.4 GB16.9 MB898.5 KB6.4 GB 99%12.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 4 04:15:01 - 04:59:59 8474 3.2% 3.14107.2 MB 3.3% 40.66
Jun 4 05:00:00 - 05:59:59 9069 3.4% 2.52125.6 MB 3.9% 35.72
Jun 4 06:00:00 - 06:59:59 8340 3.2% 2.32117.2 MB 3.6% 33.32
Jun 4 07:00:00 - 07:59:59 8320 3.1% 2.31115.7 MB 3.5% 32.90
Jun 4 08:00:00 - 08:59:59 10976 4.1% 3.05144.2 MB 4.4% 41.02
Jun 4 09:00:00 - 09:59:59 15095 5.7% 4.19195.8 MB 6.0% 55.68
Jun 4 10:00:00 - 10:59:59 10610 4.0% 2.95135.7 MB 4.2% 38.59
Jun 4 11:00:00 - 11:59:59 10671 4.0% 2.96132.9 MB 4.1% 37.79
Jun 4 12:00:00 - 12:59:59 13971 5.3% 3.88155.1 MB 4.8% 44.12
Jun 4 13:00:00 - 13:59:59 16610 6.3% 4.61174.7 MB 5.4% 49.69
Jun 4 14:00:00 - 14:59:59 11144 4.2% 3.10140.6 MB 4.3% 39.98
Jun 4 15:00:00 - 15:59:59 10404 3.9% 2.89110.4 MB 3.4% 31.39
Jun 4 16:00:00 - 16:59:59 10976 4.1% 3.05134.7 MB 4.1% 38.32
Jun 4 17:00:00 - 17:59:59 11437 4.3% 3.18147.1 MB 4.5% 41.84
Jun 4 18:00:00 - 18:59:59 11099 4.2% 3.08124.3 MB 3.8% 35.36
Jun 4 19:00:00 - 19:59:59 8669 3.3% 2.41108.4 MB 3.3% 30.85
Jun 4 20:00:00 - 20:59:59 8717 3.3% 2.42112.8 MB 3.5% 32.07
Jun 4 21:00:00 - 21:59:59 10231 3.9% 2.84124.1 MB 3.8% 35.30
Jun 4 22:00:00 - 22:59:59 10903 4.1% 3.03128.5 MB 3.9% 36.56
Jun 4 23:00:00 - 23:59:59 9925 3.8% 2.76127.5 MB 3.9% 36.27
Jun 5 00:00:00 - 00:59:59 10498 4.0% 2.92122.9 MB 3.8% 34.95
Jun 5 01:00:00 - 01:59:59 15260 5.8% 4.24197.1 MB 6.0% 56.05
Jun 5 02:00:00 - 02:59:59 9309 3.5% 2.59118.9 MB 3.6% 33.82
Jun 5 03:00:00 - 03:59:59 10601 4.0% 2.94116.9 MB 3.6% 33.25
Jun 5 04:00:00 - 04:15:01 3257 1.2% 3.6143.3 MB 1.3% 49.22
TOTAL: 24:00:00 264566 100.0% 3.063.2 GB 100.0% 38.65
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 667 0 0 625 0 0 0 0 42
2news.icm.edu.pl 4 0 0 0 0 0 0 0 4
TOTAL: 2 671 0 0 625 0 0 0 0 46

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 8
TOTAL: 1 8

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 42
TOTAL: 1 42
TOTAL: 1 42

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 24692 608 12680 24 0 0 2%47:59:54
2poznan 8 0 6 0 0 0 0%01:20:10
TOTAL: 2 24700 608 12686 24 0 0 2%49:20:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.7 MB124.5 KB1.9 MB0.0 KB/s3.0 KB47:59:54
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:20:10
TOTAL: 21.7 MB124.5 KB1.9 MB0.0 KB/s3.0 KB49:20:04
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1172.16.2.4 576 811.1 KB 4 0 000:00:34
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 578 811.1 KB 4 2 000:03:46

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 804 811.1 KB 4 0 000:02:52
2*.man.lodz.pl2882 00.0 KB 0 2 000:00:31
3*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
4*.stretchoid.com 2 00.0 KB 0 0 000:00:19
TOTAL: 43690 811.1 KB 4 2 000:03:46

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
206.168.34.125 0.100 0.084 0.00000:01:31
172.16.2.4 2.192 4.394 0.00000:00:34
nms1.man.lodz.pl 10.800 20.614 0.00000:00:31
azpdes10fqes.stretchoid.com 0.006 0.008 0.00000:00:19
116.172.200.187 0.006 0.012 0.00000:00:15
199.45.155.73 0.120 0.042 0.00000:00:08
167.94.138.116 0.086 0.030 0.00000:00:07
205.210.31.172 0.004 0.012 0.00000:00:05
80.111.142.213 0.024 0.066 0.00000:00:04
healthy.monitoring.internet-measurement.com 0.008 0.020 0.00000:00:03
212.51.192.185 0.720 1.356 0.00000:00:02
198.235.24.131 0.004 0.012 0.00000:00:00
isvcs01.man.lodz.pl 0.018 0.018 0.00000:00:00
TOTAL: 13 14.088 26.668 0.00000:03:46

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 2880
212.51.192.185 192
206.168.34.125 10
80.111.142.213 8
167.94.138.116 6
199.45.155.73 6
205.210.31.172 2
healthy.monitoring.internet-measurement.com 2
116.172.200.187 2
azpdes10fqes.stretchoid.com 2
198.235.24.131 2
TOTAL: 11 3112

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
206.168.34.125 6
167.94.138.116 2
199.45.155.73 2
TOTAL: 3 10

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
EHLO www.censys.io 6
GET / HTTP/1.1 2
Host: 212.191.2.21:119 2
TOTAL: 3 10

NNRP client timeouts [Top 20]:

SystemConnPeer
206.168.34.125 4 4
199.45.155.73 2 4
167.94.138.116 2 4
TOTAL: 3 8 16

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1pl 8100.0%
TOTAL: 1 8100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1pl.comp.os.ms-windows.winnt 8
TOTAL: 1 8