Daily Usenet report

Jan 11 04:15:02 -- Jan 12 04:15:02

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Jan 11 07:20:12 newsfeed nnrpd[5311]: SERVER perl filter not defined
Jan 11 09:41:02 newsfeed nnrpd[27096]: SERVER perl filter not defined
Jan 11 09:41:33 newsfeed nnrpd[27153]: SERVER perl filter not defined
Jan 11 13:31:01 newsfeed pgpverify[30349]: pgpverify: verification failed
Jan 11 13:31:01 newsfeed controlchan[8422]: skipping newgroup y control@usenet-fr.news.eu.org (pgpverify failed) in <newgroup-fr.misc.automobile.electrique-1610367517@news.trigofacile.com>
Jan 11 14:59:33 newsfeed nnrpd[11693]: SERVER perl filter not defined
Jan 11 16:53:00 newsfeed nnrpd[29462]: SERVER perl filter not defined
Jan 11 17:43:36 newsfeed overchan[8424]: input line too long, skipping
Jan 11 20:09:08 newsfeed pgpverify[27398]: pgpverify: verification failed
Jan 12 01:38:35 newsfeed pgpverify[13877]: pgpverify: verification failed
Jan 12 01:38:35 newsfeed pgpverify[13900]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 840576 93.3%92.1 MB 92.5%
innfeed 46484 5.2%5.4 MB 5.5%
innd 10061 1.1%1.6 MB 1.6%
nnrpd 4209 0.5%426.8 KB 0.4%
controlchan 35 0.0%7.5 KB 0.0%
pgpverify 4 0.0%0.8 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
TOTAL: 7 901371 100.0%99.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 836582 99.5%
Negative hits 4148 0.5%
Positive hits 199 0.0%
Cache misses 23 0.0%
TOTAL: 4 840952 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.166 0.0%51 0.000 22.863 119.500
article cleanup00:00:10.889 0.0%840368 0.009 0.013 0.017
article logging00:00:40.291 0.0%840963 0.039 0.048 0.060
article parse00:22:02.958 1.5%86666372 0.011 0.015 0.021
article write00:08:57.314 0.6%840083 0.437 0.640 1.096
artlog/artcncl00:00:00.001 0.0%51 0.000 0.020 0.500
data move00:01:10.258 0.1%91731533 0.001 0.001 0.001
hisgrep/artcncl00:00:00.222 0.0%50 0.000 4.440 20.000
hishave/artcncl00:00:00.022 0.0%51 0.000 0.431 6.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:23:19.396 1.6%844663 0.401 1.657 6.308
history sync00:00:00.027 0.0%291 0.000 0.093 1.000
history write00:47:11.441 3.3%840343 0.533 3.369 10.805
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle19:48:12.055 82.5%86017612 0.671 0.829 1.136
nntp read00:49:25.400 3.4%86305711 0.026 0.034 0.044
overview write00:00:04.728 0.0%840083 0.003 0.006 0.008
perl filter01:14:01.341 5.1%840343 3.982 5.285 6.856
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:43.914 0.1%1697427 0.020 0.026 0.034
TOTAL: 24:00:04.32823:36:01.423 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.172 0.0%58749 0.000 0.003 0.012
article prepare00:00:00.003 0.0%6656 0.000 0.000 0.042
article read00:00:14.272 0.0%1665 0.000 8.572 59.000
backlog stats00:00:00.135 0.0%137465 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.095 0.0%68101 0.002 0.016 0.038
data write00:00:03.041 0.0%51604 0.031 0.059 0.089
idle23:52:55.808 99.9%137465 395.302 625.438 1384.772
status file00:00:56.900 0.1%17037 0.927 3.340 131.255
TOTAL: 23:54:19.37623:54:11.426100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:30:19.830 99.4%3054 0.000 595.884900070.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.235 0.0%6701 0.000 0.035 0.500
readart00:00:00.000 0.0%12 0.000 0.000 0.000
TOTAL: 00:30:31.53600:30:20.065 99.4%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org001101
gcn@news.nic.it001101
linux-admin@bofh.it001101
TOTAL003303

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 175 839889 839625 0 264 99%81:22:38
2news.icm.edu.pl 43 209 43 147 19 20%14:23:34
3localhost 1446 5 5 0 0 100%00:00:00
TOTAL: 3 1664 840103 839673 147 283 99%95:46:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl292.3 GB1.3 MB1.9 MB292.3 GB 99%364.9 KB
2news.icm.edu.pl1.5 MB27.5 KB323.6 KB1.8 MB 81%30.1 KB
3localhost7.0 KB0.0 KB0.0 KB7.0 KB100%1.4 KB
TOTAL: 3292.3 GB1.3 MB2.2 MB292.3 GB 99%364.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 11 04:15:02 - 04:59:59 22271 2.7% 8.258.0 GB 2.7%3124.77
Jan 11 05:00:00 - 05:59:59 30046 3.6% 8.3510.7 GB 3.6%3111.39
Jan 11 06:00:00 - 06:59:59 30010 3.6% 8.3410.5 GB 3.6%3062.07
Jan 11 07:00:00 - 07:59:59 31754 3.8% 8.8211.5 GB 3.9%3362.94
Jan 11 08:00:00 - 08:59:59 31649 3.8% 8.7910.3 GB 3.5%2996.19
Jan 11 09:00:00 - 09:59:59 30423 3.6% 8.4511.5 GB 3.9%3355.07
Jan 11 10:00:00 - 10:59:59 28910 3.4% 8.0311.5 GB 3.9%3339.32
Jan 11 11:00:00 - 11:59:59 38815 4.6% 10.7812.6 GB 4.3%3668.68
Jan 11 12:00:00 - 12:59:59 36798 4.4% 10.2211.7 GB 4.0%3393.32
Jan 11 13:00:00 - 13:59:59 36734 4.4% 10.2012.3 GB 4.2%3585.78
Jan 11 14:00:00 - 14:59:59 45333 5.4% 12.5912.7 GB 4.3%3695.02
Jan 11 15:00:00 - 15:59:59 32950 3.9% 9.1511.4 GB 3.9%3315.93
Jan 11 16:00:00 - 16:59:59 35445 4.2% 9.8512.3 GB 4.2%3595.71
Jan 11 17:00:00 - 17:59:59 36483 4.3% 10.1312.2 GB 4.2%3551.64
Jan 11 18:00:00 - 18:59:59 34185 4.1% 9.5011.3 GB 3.9%3305.08
Jan 11 19:00:00 - 19:59:59 36064 4.3% 10.0212.0 GB 4.1%3489.45
Jan 11 20:00:00 - 20:59:59 39930 4.8% 11.0913.8 GB 4.7%4011.54
Jan 11 21:00:00 - 21:59:59 34231 4.1% 9.5113.1 GB 4.5%3814.70
Jan 11 22:00:00 - 22:59:59 37512 4.5% 10.4214.0 GB 4.8%4070.64
Jan 11 23:00:00 - 23:59:59 40720 4.8% 11.3114.1 GB 4.8%4100.36
Jan 12 00:00:00 - 00:59:59 36358 4.3% 10.1013.2 GB 4.5%3835.24
Jan 12 01:00:00 - 01:59:59 39155 4.7% 10.8813.0 GB 4.4%3773.33
Jan 12 02:00:00 - 02:59:59 33263 4.0% 9.2413.6 GB 4.6%3947.80
Jan 12 03:00:00 - 03:59:59 33978 4.0% 9.4412.6 GB 4.3%3678.77
Jan 12 04:00:00 - 04:15:02 6627 0.8% 7.353.3 GB 1.1%3816.26
TOTAL: 24:00:00 839644 100.0% 9.72293.1 GB 100.0%3556.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 862 228 0 23 13 0 0 0 598
2news.icm.edu.pl 19 0 0 2 0 0 0 0 17
TOTAL: 2 881 228 0 25 13 0 0 0 615

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 89
comp.mobile.android 39
comp.sys.raspberry-pi 38
it.comp.os.win.windows10 20
it.tlc.cellulari.android 20
de.rec.sf.startrek 10
de.comp.lang.vbclassic 4
de.comp.lang.php 4
it.comp.os.linux.ubuntu 2
nl.comp.os.linux.techniek 2
TOTAL: 10 228

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
pl.praca.oferowana 10
pl.sci.matematyka 3
TOTAL: 2 13

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 13
Binary in non-binary group 4
TOTAL: 2 17

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 45521 568 16553 203 4 41670 1%23:59:56
2icm 25923 223 15834 244 0 0 0%23:53:44
3poznan 36 0 31 0 0 0 0%03:21:54
4okapi 0 0 0 0 0 953 0%24:05:33
5nask 0 0 0 0 0 10731 0%23:57:46
TOTAL: 5 71480 791 32418 447 4 53354 1%99:18:53
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.6 MB1.0 MB2.6 MB0.0 KB/s3.5 KB23:59:56
2icm999.6 KB74.9 MB75.8 MB0.9 KB/s166.3 KB23:53:44
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:21:54
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:33
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
TOTAL: 52.6 MB75.9 MB78.5 MB0.2 KB/s64.9 KB99:18:53
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 1211.6 KB 6 0 000:00:21
2isvcs01.man.lodz.pl 5 00.0 KB 0 5 000:00:00
TOTAL: 2 293 1211.6 KB 6 5 000:30:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 581 1211.6 KB 6 5 000:00:26
2*.dynamic.chello.pl 1 00.0 KB 0 0 000:30:00
3unresolved 101 00.0 KB 0 0 000:00:04
4*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 4 684 1211.6 KB 6 5 000:30:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
89-64-149-5.dynamic.chello.pl 0.004 0.012 0.00000:30:00
web.man.lodz.pl 1.583 3.405 0.00000:00:21
mon.man.lodz.pl 1.521 2.822 0.00000:00:03
80.111.142.213 0.028 0.038 0.00000:00:03
212.51.192.185 0.492 0.983 0.00000:00:01
isvcs01.man.lodz.pl 0.033 0.080 0.00000:00:00
scan-141.security.ipip.net 0.000 0.011 0.00000:00:00
176.113.115.160 0.007 0.003 0.00000:00:00
TOTAL: 8 3.668 7.354 0.00000:30:31

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
89-64-149-5.dynamic.chello.pl 1
176.113.115.160 1
scan-141.security.ipip.net 1
TOTAL: 6 391

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
176.113.115.160 1
TOTAL: 2 5

NNRP unrecognized commands (by command):

CommandCount
#003 1
Connection: close 1
User-Agent: HTTP Banner Detection (https... 1
Host: 212.191.2.21:119 1
GET / HTTP/1.1 1
TOTAL: 5 5

NNRP client timeouts [Top 20]:

SystemConnPeer
176.113.115.160 1 1
89-64-149-5.dynamic.chello.pl 1 0
TOTAL: 2 2 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 12100.0%
TOTAL: 1 12100.0%

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

NewsgroupCount
1pl.comp.pecet 12
TOTAL: 1 12