Daily Usenet report

Aug 12 04:15:02 -- Aug 13 04:15:01

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Aug 12 07:45:38 newsfeed nnrpd[2067020]: SERVER perl filter not defined
Aug 12 07:45:38 newsfeed nnrpd[2067020]: SERVER perl filter not defined
Aug 12 15:43:01 newsfeed nnrpd[2125345]: SERVER perl filter not defined
Aug 12 15:43:01 newsfeed nnrpd[2125345]: SERVER perl filter not defined
Aug 12 18:20:45 newsfeed nnrpd[2143927]: SERVER perl filter not defined
Aug 12 18:20:45 newsfeed nnrpd[2143927]: SERVER perl filter not defined
Aug 12 18:27:18 newsfeed nnrpd[2144890]: SERVER perl filter not defined
Aug 12 18:27:18 newsfeed nnrpd[2144890]: SERVER perl filter not defined
Aug 12 18:30:04 newsfeed nnrpd[2145022]: SERVER perl filter not defined
Aug 12 18:30:04 newsfeed nnrpd[2145022]: SERVER perl filter not defined
Aug 12 22:00:03 newsfeed pgpverify[2170038]: pgpverify: /usr/bin/gpg1: no such file
Aug 12 22:00:03 newsfeed pgpverify[2170038]: pgpverify: /usr/bin/gpg1: no such file
Aug 12 22:00:07 newsfeed pgpverify[2170045]: pgpverify: /usr/bin/gpg1: no such file
Aug 12 22:00:07 newsfeed pgpverify[2170045]: pgpverify: /usr/bin/gpg1: no such file

Log entries by program:

Program nameLines%LinesSize%Size
inn 233738 83.3%24.6 MB 84.8%
innd 29872 10.6%2.8 MB 9.5%
nnrpd 15878 5.7%1.5 MB 5.2%
innfeed 1202 0.4%158.8 KB 0.5%
controlchan 6 0.0%0.6 KB 0.0%
pgpverify 4 0.0%0.4 KB 0.0%
overchan 2 0.0%0.2 KB 0.0%
TOTAL: 7 280702 100.0%29.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 466508 99.9%
Negative hits 334 0.1%
Positive hits 92 0.0%
Cache misses 52 0.0%
TOTAL: 4 466986 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.066 0.0%166 0.000 0.398 1.167
article cleanup00:00:01.146 0.0%467226 0.000 0.002 0.007
article logging00:00:05.350 0.0%467278 0.005 0.011 0.022
article parse00:00:09.148 0.0%1727134 0.003 0.005 0.009
article write00:00:12.576 0.0%467226 0.016 0.027 0.046
artlog/artcncl00:00:00.000 0.0%88 0.000 0.000 0.000
data move00:00:01.372 0.0%2495916 0.000 0.001 0.002
hisgrep/artcncl00:00:00.010 0.0%254 0.000 0.039 1.000
hishave/artcncl00:00:00.000 0.0%88 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:01.382 0.0%467616 0.000 0.003 0.009
history sync00:00:00.030 0.0%600 0.000 0.050 1.000
history write00:00:22.474 0.0%467226 0.015 0.048 0.330
idle47:54:31.876 99.8%2026954 34.353 85.089 216.143
nntp read00:00:13.464 0.0%1636070 0.005 0.008 0.014
overview write00:00:00.634 0.0%467226 0.000 0.001 0.004
perl filter00:04:02.290 0.1%467226 0.375 0.519 0.711
python filter00:00:00.096 0.0%467236 0.000 0.000 0.002
site send00:00:06.202 0.0%947942 0.003 0.007 0.012
TOTAL: 48:00:35.27447:59:48.116100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%13446 0.000 0.002 0.026
article prepare00:00:00.002 0.0%1392 0.000 0.001 0.062
article read00:00:00.006 0.0%348 0.000 0.017 0.333
backlog stats00:00:00.018 0.0%82074 0.000 0.000 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.288 0.0%38408 0.000 0.007 0.049
data write00:00:00.772 0.0%24874 0.000 0.031 0.132
idle47:40:04.856100.0%82074 1170.105 2090.855 6605.088
status file00:00:00.234 0.0%308 0.000 0.760 12.000
TOTAL: 47:40:07.01647:40:06.200100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:48.596 81.4%8910 1.000 12.188 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.278 0.2%30190 0.000 0.009 0.333
readart00:00:00.000 0.0%36 0.000 0.000 0.000
TOTAL: 00:02:13.35600:01:48.874 81.6%----

Control commands to INND:

CommandNumber
flush 54
flushlogs 4
go 4
logmode 4
lowmark 2
mode 300
name 6
pause 4
paused 4
reload 4
reserve 4
TOTAL: 11 390

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org000400
TOTAL000400

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 74 467190 467190 0 0 100%57:03:08
2localhost 12 10 10 0 0 100%00:00:00
3news.icm.edu.pl 44 56 0 56 0 0%08:16:50
TOTAL: 3 130 467256 467200 56 0 99%65:19:58
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl5.1 GB0.0 KB0.0 KB5.1 GB100%11.4 KB
2localhost16.2 KB0.0 KB0.0 KB16.2 KB100%1.6 KB
3news.icm.edu.pl0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 35.1 GB0.0 KB0.0 KB5.1 GB100%11.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 12 04:15:02 - 04:59:59 4328 1.9% 1.6049.5 MB 1.9% 18.77
Aug 12 05:00:00 - 05:59:59 5344 2.3% 1.4864.0 MB 2.5% 18.19
Aug 12 06:00:00 - 06:59:59 5603 2.4% 1.5661.6 MB 2.4% 17.52
Aug 12 07:00:00 - 07:59:59 6850 2.9% 1.9068.7 MB 2.7% 19.54
Aug 12 08:00:00 - 08:59:59 7544 3.2% 2.1082.5 MB 3.2% 23.47
Aug 12 09:00:00 - 09:59:59 12017 5.1% 3.34131.1 MB 5.1% 37.30
Aug 12 10:00:00 - 10:59:59 13895 5.9% 3.86156.4 MB 6.0% 44.48
Aug 12 11:00:00 - 11:59:59 15652 6.7% 4.35187.5 MB 7.2% 53.32
Aug 12 12:00:00 - 12:59:59 14735 6.3% 4.09156.0 MB 6.0% 44.38
Aug 12 13:00:00 - 13:59:59 15145 6.5% 4.21163.4 MB 6.3% 46.47
Aug 12 14:00:00 - 14:59:59 12041 5.2% 3.34127.9 MB 4.9% 36.38
Aug 12 15:00:00 - 15:59:59 12318 5.3% 3.42132.8 MB 5.1% 37.77
Aug 12 16:00:00 - 16:59:59 15968 6.8% 4.44188.9 MB 7.3% 53.74
Aug 12 17:00:00 - 17:59:59 11749 5.0% 3.26152.0 MB 5.9% 43.22
Aug 12 18:00:00 - 18:59:59 10034 4.3% 2.79131.5 MB 5.1% 37.41
Aug 12 19:00:00 - 19:59:59 9947 4.3% 2.7689.5 MB 3.5% 25.46
Aug 12 20:00:00 - 20:59:59 9173 3.9% 2.55100.7 MB 3.9% 28.64
Aug 12 21:00:00 - 21:59:59 7432 3.2% 2.0685.6 MB 3.3% 24.36
Aug 12 22:00:00 - 22:59:59 10968 4.7% 3.05103.8 MB 4.0% 29.53
Aug 12 23:00:00 - 23:59:59 7378 3.2% 2.0590.1 MB 3.5% 25.64
Aug 13 00:00:00 - 00:59:59 6483 2.8% 1.8062.3 MB 2.4% 17.71
Aug 13 01:00:00 - 01:59:59 5296 2.3% 1.4765.2 MB 2.5% 18.56
Aug 13 02:00:00 - 02:59:59 6062 2.6% 1.6862.3 MB 2.4% 17.73
Aug 13 03:00:00 - 03:59:59 6292 2.7% 1.7564.9 MB 2.5% 18.46
Aug 13 04:00:00 - 04:15:01 1414 0.6% 1.5713.8 MB 0.5% 15.73
TOTAL: 23:59:59 233668 100.0% 2.702.5 GB 100.0% 30.72
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 26 0 0 0 0 0 0 0 26
TOTAL: 1 26 0 0 0 0 0 0 0 26

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 25044 326 13130 22 0 0 1%47:59:54
2poznan 0 0 0 0 0 0 0%00:20:00
TOTAL: 2 25044 326 13130 22 0 0 1%48:19:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm979.3 KB68.0 KB1.0 MB0.0 KB/s3.0 KB47:59:54
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:20:00
TOTAL: 2979.3 KB68.0 KB1.0 MB0.0 KB/s3.0 KB48:19:54
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-098-095.res.spectrum.com 8 2022.7 KB 2 0 000:00:14
2172.16.2.4 576 1622.0 KB 8 0 000:00:33
3isvcs01.man.lodz.pl 10 00.0 KB 0 10 000:00:00
TOTAL: 3 594 3644.8 KB 10 10 000:02:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 8 2022.7 KB 2 0 000:00:14
2unresolved 594 1622.0 KB 8 0 000:00:58
3*.man.lodz.pl2894 00.0 KB 0 10 000:00:35
4*.stretchoid.com 4 00.0 KB 0 0 000:00:20
5*.bstnma.fios.verizon.net 12 00.0 KB 0 0 000:00:05
TOTAL: 53512 3644.8 KB 10 10 000:02:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
172.16.2.4 1.248 3.052 0.00000:00:33
nms1.man.lodz.pl 5.826 14.278 0.00000:00:22
azpdss5f5wtr.stretchoid.com 0.012 0.016 0.00000:00:20
syn-066-061-098-095.res.spectrum.com 0.018 0.042 0.00000:00:14
pc-tom.man.lodz.pl 0.008 0.022 0.00000:00:12
167.94.146.59 0.072 0.028 0.00000:00:11
198.235.24.5 0.002 0.014 0.00000:00:06
80.111.142.213 0.008 0.056 0.00000:00:05
pool-173-48-159-36.bstnma.fios.verizon.net 0.094 0.060 0.00000:00:05
198.235.24.254 0.000 0.014 0.00000:00:01
isvcs01.man.lodz.pl 0.028 0.074 0.00000:00:00
TOTAL: 11 7.316 17.656 0.00000:02:14

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 2880
pool-173-48-159-36.bstnma.fios.verizon.net 12
80.111.142.213 8
167.94.146.59 6
azpdss5f5wtr.stretchoid.com 4
pc-tom.man.lodz.pl 4
198.235.24.5 2
198.235.24.254 2
TOTAL: 8 2918

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

SystemConn
azpdss5f5wtr.stretchoid.com 2
167.94.146.59 2
TOTAL: 2 4

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

CommandCount
EHLO www.censys.io 2
MGLNDD_212.191.2.21_119 2
TOTAL: 2 4

NNRP client timeouts [Top 20]:

SystemConnPeer
pool-173-48-159-36.bstnma.fios.verizon.net 12 12
167.94.146.59 2 4
TOTAL: 2 14 20

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1lodman 20 55.6%
2pl 16 44.4%
TOTAL: 2 36100.0%

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

NewsgroupCount
1lodman.info 20
2pl.comp.os.ms-windows.winnt 16
TOTAL: 2 36