Daily Usenet report

May 17 04:15:03 -- May 18 04:15:02

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

May 17 11:13:36 newsfeed nnrpd[22232]: SERVER perl filter not defined
May 17 13:10:04 newsfeed pgpverify[26197]: pgpverify: verification failed
May 17 17:13:33 newsfeed nnrpd[1846]: SERVER perl filter not defined
May 17 23:21:27 newsfeed nnrpd[14313]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1966769 98.4%223.6 MB 97.9%
innd 17754 0.9%2.9 MB 1.3%
innfeed 7006 0.4%1.0 MB 0.5%
nnrpd 6999 0.4%747.3 KB 0.3%
controlchan 3 0.0%0.4 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 61998532 100.0%228.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1961628 95.5%
Negative hits 57683 2.8%
Positive hits 34679 1.7%
Cache misses 261 0.0%
TOTAL: 4 2054251 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:13.648 0.0%450 0.000 30.329 741.000
article cleanup00:00:31.085 0.0%1965262 0.004 0.016 0.029
article logging00:00:56.718 0.1%1965359 0.012 0.029 0.538
article parse01:22:24.674 5.7%184490070 0.012 0.027 0.082
article write00:17:38.657 1.2%1960040 0.347 0.540 1.497
artlog/artcncl00:00:00.005 0.0%429 0.000 0.012 1.000
artlog/artparse00:00:00.001 0.0%4 0.000 0.250 1.000
data move00:03:33.745 0.2%197556803 0.001 0.001 0.014
hisgrep/artcncl00:00:01.273 0.0%326 0.000 3.905 55.000
hishave/artcncl00:00:01.302 0.0%450 0.000 2.893 57.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup02:31:54.472 10.6%2054010 0.165 4.437 12.751
history sync00:00:00.305 0.0%291 0.000 1.048 289.000
history write03:57:33.914 16.5%1961542 1.188 7.267 20.556
hiswrite/artcncl00:00:00.812 0.0%124 0.000 6.548 231.000
idle08:52:13.423 37.0%124187561 0.128 0.257 0.805
nntp read01:11:16.400 5.0%182953930 0.011 0.023 0.044
overview write00:00:12.000 0.0%1960040 0.000 0.006 0.016
perl filter04:46:38.222 19.9%1961538 6.866 8.768 10.894
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:41.439 0.3%3955484 0.033 0.056 0.095
TOTAL: 23:59:31.24323:08:52.095 96.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.141 0.0%35411 0.000 0.004 0.111
article prepare00:00:00.005 0.0%29162 0.000 0.000 0.031
article read00:00:01.424 0.0%7073 0.000 0.201 7.250
backlog stats00:00:00.232 0.0%282101 0.000 0.001 0.018
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.680 0.0%154528 0.000 0.011 0.080
data write00:00:08.475 0.0%144802 0.000 0.059 1.000
idle23:59:26.412100.0%282101 0.000 306.154 18783.000
status file00:00:00.743 0.0%227 0.000 3.273 60.250
TOTAL: 23:59:45.86423:59:39.112100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:28:18.750 98.4%15409 0.000 110.244 12360.200
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.620 0.0%32497 0.000 0.019 0.667
readart00:00:00.527 0.0%388 0.000 1.358 16.923
TOTAL: 00:28:46.05100:28:19.897 98.5%----

Control commands to INND:

CommandNumber
L 1
flush 24
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 189

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newsmaster@carnet.hr000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1012 19556571951164 1027 3466 99%330:23:51
2news.task.gda.pl 27 25444 5072 19328 1044 19%46:05:18
3news.nask.pl 2 15671 4264 10714 693 27%23:18:11
4localhost 4 3 3 0 0 100%00:00:00
5news.icm.edu.pl 47 242 1 215 26 0%17:57:15
TOTAL: 5 1092 19970171960504 31284 5229 98%417:44:35
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl660.7 GB43.0 MB91.9 MB660.9 GB 99%354.5 KB
2news.nask.pl18.1 MB2.1 MB2.2 MB22.3 MB 80%4.6 KB
3news.task.gda.pl9.9 MB51.9 KB3.2 MB13.1 MB 75%2.2 KB
4news.icm.edu.pl58.0 KB91.8 KB1.2 MB1.3 MB 4%49.6 KB
5localhost4.3 KB0.0 KB0.0 KB4.3 KB100%1.4 KB
TOTAL: 5660.8 GB45.2 MB98.4 MB660.9 GB 99%352.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 17 04:15:03 - 04:59:59 57493 2.9% 21.3222.7 GB 3.4%8839.98
May 17 05:00:00 - 05:59:59 73223 3.7% 20.3429.4 GB 4.5%8569.76
May 17 06:00:00 - 06:59:59 71537 3.6% 19.8729.6 GB 4.5%8629.95
May 17 07:00:00 - 07:59:59 79595 4.1% 22.1129.5 GB 4.5%8600.04
May 17 08:00:00 - 08:59:59 93237 4.8% 25.9031.7 GB 4.8%9233.23
May 17 09:00:00 - 09:59:59 75377 3.8% 20.9425.6 GB 3.9%7470.13
May 17 10:00:00 - 10:59:59 65941 3.4% 18.3222.2 GB 3.4%6463.07
May 17 11:00:00 - 11:59:59 55758 2.8% 15.4919.1 GB 2.9%5577.66
May 17 12:00:00 - 12:59:59 65120 3.3% 18.0922.2 GB 3.4%6469.38
May 17 13:00:00 - 13:59:59 68581 3.5% 19.0523.4 GB 3.5%6830.05
May 17 14:00:00 - 14:59:59 90684 4.6% 25.1931.9 GB 4.8%9289.31
May 17 15:00:00 - 15:59:59 77660 4.0% 21.5727.4 GB 4.1%7981.65
May 17 16:00:00 - 16:59:59 68421 3.5% 19.0124.3 GB 3.7%7081.26
May 17 17:00:00 - 17:59:59 82470 4.2% 22.9127.7 GB 4.2%8076.03
May 17 18:00:00 - 18:59:59 93307 4.8% 25.9230.2 GB 4.6%8809.17
May 17 19:00:00 - 19:59:59 105757 5.4% 29.3830.9 GB 4.7%8997.89
May 17 20:00:00 - 20:59:59 91056 4.6% 25.2929.4 GB 4.4%8549.33
May 17 21:00:00 - 21:59:59 90042 4.6% 25.0128.5 GB 4.3%8291.99
May 17 22:00:00 - 22:59:59 94892 4.8% 26.3630.3 GB 4.6%8825.87
May 17 23:00:00 - 23:59:59 86867 4.4% 24.1328.1 GB 4.2%8173.58
May 18 00:00:00 - 00:59:59 73335 3.7% 20.3724.2 GB 3.7%7058.19
May 18 01:00:00 - 01:59:59 71404 3.6% 19.8323.4 GB 3.5%6811.36
May 18 02:00:00 - 02:59:59 91175 4.6% 25.3330.9 GB 4.7%9004.77
May 18 03:00:00 - 03:59:59 107915 5.5% 29.9830.1 GB 4.6%8757.94
May 18 04:00:00 - 04:15:02 30170 1.5% 33.457.9 GB 1.2%9143.32
TOTAL: 23:59:59 1961017 100.0% 22.70660.8 GB 100.0%8019.47
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3547 162 0 2996 2 0 0 0 387
2news.task.gda.pl 1024 837 0 28 0 0 0 0 159
3news.nask.pl 726 5 0 698 8 0 0 0 15
4news.icm.edu.pl 26 0 0 2 0 0 0 0 24
TOTAL: 4 5323 1004 0 3724 10 0 0 0 585

Unwanted newsgroups [Top 20]:

NewsgroupCount
mailing.freebsd.svn-ports-all 108
mailing.freebsd.svn-ports-head 106
mailing.freebsd.svn-src-all 96
fa.freebsd.cvs-all 92
uk.railway 72
fr.usenet.abus.nocem 50
mailing.openbsd.source-changes 47
mailing.freebsd.svn-src-head 34
mailing.gcc.gcc-cvs 30
alt.politics.scorched-earth 29
it.tlc.cellulari.android 29
mailing.freebsd.ports-bugs 26
mailing.freebsd.ports 22
it.comp.os.win.windows7 20
alt.windows7.general 19
mailing.freebsd.current 14
mailing.unix.dovecot 12
mailing.postfix.users 11
comp.sys.raspberry-pi 11
mailing.dragonflybsd.commits 10
TOTAL: 64 1004

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

GroupsCount
pl.sci.matematyka 7
pl.sci.historia 2
bit.listserv.catholic 1
TOTAL: 3 10

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 242
EMP (fsl) 136
Attached HTML file 64
EMP (md5) 31
Scoring filter (8) 7
EMP (phl) 3
HTML post 1
TOTAL: 7 484

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 49375 2215 26316 2642 9 0 4%23:56:01
2panorama 39333 1867 33337 305 0 0 4%23:59:35
3task 1340 133 630 8 0 0 9%22:15:27
4poznan 11317 66 9314 23 0 2 0%24:04:07
5nask 19670 20 12759 0 0 0 0%24:05:25
6okapi 0 0 0 0 0 1710 0%24:00:01
TOTAL: 6 121035 4301 82356 2978 9 1712 3%142:20:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm137.3 MB1.3 GB1.5 GB17.9 KB/s318.3 KB23:56:01
2panorama8.7 MB1.1 MB9.8 MB0.1 KB/s4.6 KB23:59:35
3task333.9 KB10.5 KB344.3 KB0.0 KB/s2.4 KB22:15:27
4poznan222.6 KB37.7 KB260.3 KB0.0 KB/s2.9 KB24:04:07
5nask59.9 KB0.0 KB59.9 KB0.0 KB/s3.0 KB24:05:25
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 6146.6 MB1.3 GB1.5 GB3.0 KB/s213.9 KB142:20:36
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-skrzep2.cm.p.lodz.pl 288 324504.2 KB 288 0 000:00:10
2web.man.lodz.pl 288 6464.8 KB 29 0 000:00:26
3isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 3 579 388569.0 KB 317 3 000:28:45

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 324504.2 KB 288 0 000:00:10
2*.man.lodz.pl 675 6464.8 KB 29 3 000:00:34
3*.191.14.62.static.jazztel.es 4 00.0 KB 0 0 000:25:23
4*.pa.nsw.optusnet.com.au 41 00.0 KB 0 0 000:01:12
5*.ssp.dialog.net.pl 1 00.0 KB 0 0 000:00:22
6*.shodan.io 2 00.0 KB 0 0 000:00:00
7unresolved 1 00.0 KB 0 0 000:01:01
TOTAL: 71012 388569.0 KB 317 3 000:28:45

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
242.191.14.62.static.jazztel.es 0.528 0.816 0.00000:25:23
pa49-181-246-68.pa.nsw.optusnet.com.au 0.124 0.548 0.00000:01:12
194.33.77.50 0.000 0.020 0.00000:01:01
web.man.lodz.pl 0.644 4.460 0.00000:00:26
dynamic-78-8-143-15.ssp.dialog.net.pl 0.032 0.020 0.00000:00:22
pc-skrzep2.cm.p.lodz.pl 0.808 3.860 0.00000:00:10
mon.man.lodz.pl 0.640 3.956 0.00000:00:05
david.man.lodz.pl 0.224 1.300 0.00000:00:01
isvcs01.man.lodz.pl 0.008 0.064 0.00000:00:00
census2.shodan.io 0.004 0.012 0.00000:00:00
census6.shodan.io 0.004 0.012 0.00000:00:00
TOTAL: 11 3.016 15.068 0.00000:28:45

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
pa49-181-246-68.pa.nsw.optusnet.com.au 41
242.191.14.62.static.jazztel.es 4
census2.shodan.io 1
census6.shodan.io 1
dynamic-78-8-143-15.ssp.dialog.net.pl 1
194.33.77.50 1
TOTAL: 8 433

NNRP client timeouts [Top 20]:

SystemConnPeer
242.191.14.62.static.jazztel.es 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1lodman 324 83.5%
2pl 64 16.5%
TOTAL: 2 388100.0%

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

NewsgroupCount
1lodman.info 324
2pl.comp.pecet 48
3pl.comp.os.ms-windows.winnt 16
TOTAL: 3 388