Daily Usenet report

Dec 7 04:15:02 -- Dec 8 04:15:04

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Dec 7 09:58:46 newsfeed nnrpd[17014]: SERVER perl filter not defined
Dec 7 10:25:48 newsfeed nnrpd[18031]: SERVER perl filter not defined
Dec 7 10:48:40 newsfeed nnrpd[18763]: SERVER perl filter not defined
Dec 7 10:54:45 newsfeed nnrpd[19010]: SERVER perl filter not defined
Dec 7 10:55:27 newsfeed nnrpd[19061]: SERVER perl filter not defined
Dec 7 10:56:17 newsfeed nnrpd[19064]: SERVER perl filter not defined
Dec 7 10:56:59 newsfeed nnrpd[19067]: SERVER perl filter not defined
Dec 7 10:57:38 newsfeed nnrpd[19073]: SERVER perl filter not defined
Dec 7 10:58:31 newsfeed nnrpd[19115]: SERVER perl filter not defined
Dec 7 10:59:33 newsfeed nnrpd[19116]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2657207 97.3%303.9 MB 96.9%
innfeed 44905 1.6%5.3 MB 1.7%
innd 21640 0.8%3.7 MB 1.2%
nnrpd 6389 0.2%705.0 KB 0.2%
TOTAL: 42730141 100.0%313.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2651300 98.4%
Negative hits 25652 1.0%
Positive hits 16468 0.6%
Cache misses 101 0.0%
TOTAL: 4 2693521 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.977 0.0%197 0.000 20.188 996.000
article cleanup00:00:43.965 0.1%2655162 0.004 0.017 0.034
article logging00:01:17.078 0.1%2655613 0.014 0.029 0.742
article parse01:18:31.187 5.5%283321550 0.006 0.017 0.082
article write00:22:51.953 1.6%2651582 0.291 0.517 2.885
artlog/artcncl00:00:00.003 0.0%177 0.000 0.017 0.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:06:14.603 0.4%300718325 0.000 0.001 0.009
hisgrep/artcncl00:00:00.218 0.0%164 0.000 1.329 39.000
hishave/artcncl00:00:00.062 0.0%197 0.000 0.315 10.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:29:45.005 2.1%2694321 0.019 0.663 16.258
history sync00:00:00.011 0.0%291 0.000 0.038 1.000
history write00:46:03.616 3.2%2652162 0.074 1.042 23.978
hiswrite/artcncl00:00:00.050 0.0%33 0.000 1.515 15.000
idle13:15:39.390 55.3%199017248 0.092 0.240 0.371
nntp read01:37:33.075 6.8%281203625 0.009 0.021 0.039
overview write00:00:15.736 0.0%2651582 0.000 0.006 0.020
perl filter05:12:01.787 21.7%2652162 3.839 7.059 11.392
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:15.846 0.4%5348795 0.014 0.059 0.093
TOTAL: 23:59:15.21323:16:17.562 97.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.246 0.0%99172 0.000 0.002 0.091
article prepare00:00:00.004 0.0%25172 0.000 0.000 0.125
article read00:01:12.345 0.1%6264 0.000 11.549 831.000
backlog stats00:00:00.194 0.0%261176 0.000 0.001 0.019
callbacks00:00:00.000 0.0%14 0.000 0.000 0.000
data read00:00:01.582 0.0%141495 0.000 0.011 0.144
data write00:00:05.061 0.0%98651 0.000 0.051 0.553
idle23:58:43.843 99.9%261176 50.810 330.520 1472.638
status file00:00:12.257 0.0%15621 0.167 0.785 27.333
TOTAL: 24:00:27.17824:00:15.532100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.000 0.0%1 0.000 0.000 0.000
idle10:33:16.623 99.9%177588 0.000 213.959170756.545
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:06.085 0.0%356344 0.000 0.017 3.333
readart00:00:00.785 0.0%88 0.000 8.920 17.756
TOTAL: 10:33:50.55310:33:23.493 99.9%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1171 26531792649591 384 3204 99%318:03:57
2news.nask.pl 2 16804 3495 13052 257 20%24:21:13
3news.icm.edu.pl 39 370 53 186 131 14%17:52:34
4localhost 11 10 10 0 0 100%00:00:00
TOTAL: 4 1223 26703632653149 13622 3592 99%360:17:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl806.8 GB86.8 MB118.0 MB807.0 GB 99%319.0 KB
2news.nask.pl10.7 MB732.5 KB819.2 KB12.2 MB 87%3.3 KB
3news.icm.edu.pl1.3 MB0.0 KB2.4 MB3.7 MB 34%20.6 KB
4localhost15.5 KB0.0 KB0.0 KB15.5 KB100%1.6 KB
TOTAL: 4806.8 GB87.5 MB121.2 MB807.0 GB 99%318.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 7 04:15:02 - 04:59:59 68647 2.6% 25.4421.6 GB 2.7%8403.06
Dec 7 05:00:00 - 05:59:59 95683 3.6% 26.5830.4 GB 3.8%8864.34
Dec 7 06:00:00 - 06:59:59 118997 4.5% 33.0535.4 GB 4.4%10305.05
Dec 7 07:00:00 - 07:59:59 120837 4.6% 33.5736.6 GB 4.5%10669.16
Dec 7 08:00:00 - 08:59:59 119013 4.5% 33.0636.2 GB 4.5%10540.65
Dec 7 09:00:00 - 09:59:59 120606 4.5% 33.5035.8 GB 4.4%10440.26
Dec 7 10:00:00 - 10:59:59 117284 4.4% 32.5834.8 GB 4.3%10149.66
Dec 7 11:00:00 - 11:59:59 117928 4.4% 32.7635.3 GB 4.4%10284.17
Dec 7 12:00:00 - 12:59:59 113880 4.3% 31.6335.2 GB 4.4%10256.14
Dec 7 13:00:00 - 13:59:59 106818 4.0% 29.6734.6 GB 4.3%10092.01
Dec 7 14:00:00 - 14:59:59 104330 3.9% 28.9833.5 GB 4.2%9751.31
Dec 7 15:00:00 - 15:59:59 103346 3.9% 28.7133.3 GB 4.1%9707.95
Dec 7 16:00:00 - 16:59:59 116457 4.4% 32.3536.1 GB 4.5%10510.91
Dec 7 17:00:00 - 17:59:59 111512 4.2% 30.9832.7 GB 4.1%9521.42
Dec 7 18:00:00 - 18:59:59 84636 3.2% 23.5124.8 GB 3.1%7229.56
Dec 7 19:00:00 - 19:59:59 119178 4.5% 33.1034.4 GB 4.3%10010.70
Dec 7 20:00:00 - 20:59:59 121950 4.6% 33.8835.1 GB 4.4%10216.19
Dec 7 21:00:00 - 21:59:59 140989 5.3% 39.1635.8 GB 4.4%10432.29
Dec 7 22:00:00 - 22:59:59 126804 4.8% 35.2236.2 GB 4.5%10558.44
Dec 7 23:00:00 - 23:59:59 114582 4.3% 31.8335.6 GB 4.4%10354.73
Dec 8 00:00:00 - 00:59:59 80198 3.0% 22.2828.0 GB 3.5%8149.84
Dec 8 01:00:00 - 01:59:59 84903 3.2% 23.5828.6 GB 3.5%8326.75
Dec 8 02:00:00 - 02:59:59 116657 4.4% 32.4036.2 GB 4.5%10538.37
Dec 8 03:00:00 - 03:59:59 102180 3.9% 28.3831.7 GB 3.9%9246.15
Dec 8 04:00:00 - 04:15:04 25583 1.0% 28.307.7 GB 1.0%8916.74
TOTAL: 24:00:02 2652998 100.0% 30.71805.8 GB 100.0%9778.64
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3608 213 0 2778 3 0 0 0 614
2news.nask.pl 280 1 0 223 3 0 0 0 53
3news.icm.edu.pl 144 0 0 0 1 0 0 0 143
TOTAL: 3 4032 214 0 3001 7 0 0 0 810

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 83
it.comp.os.win.windows10 59
it.tlc.cellulari.android 18
it.comp.os.win.windows7 15
comp.mobile.ipad 8
comp.mobile.android 6
hr.ponuda.hardver.komponente 5
it.comp.os.win.windows8 4
it.comp.os.linux.ubuntu 3
uk.rec.cycling.moderated 3
de.rec.sf.startrek 2
nl.comp.os.linux.techniek 2
nl.wetenschap.regulier 2
alt.os.linux.opensuse 1
hr.ponuda.hardver.periferije 1
comp.sys.raspberry-pi 1
nl.actueel 1
TOTAL: 17 214

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

GroupsCount
pl.praca.oferowana 4
pl.sci.matematyka 1
bit.listserv.catholic 1
pl.sci.historia 1
TOTAL: 4 7

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 203
EMP (md5) 126
Too many newsgroups 19
EMP (fsl) 7
Scoring filter (8) 1
Scoring filter (9) 1
HTML post 1
Scoring filter (14) 1
TOTAL: 8 359

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 62422 1680 34093 784 28 62353 2%24:00:11
2icm 56551 657 37782 2139 0 27 1%24:02:05
3poznan 5164 133 3262 51 0 0 2%23:59:34
4okapi 0 0 0 0 0 2945 0%24:00:03
5nask 0 0 0 0 0 26549 0%24:00:03
TOTAL: 5 124137 2470 75137 2974 28 91874 1%120:01:56
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm93.9 MB493.5 MB587.4 MB7.0 KB/s215.1 KB24:02:05
2panorama9.1 MB6.3 MB15.4 MB0.2 KB/s6.4 KB24:00:11
3poznan497.8 KB167.5 KB665.4 KB0.0 KB/s3.6 KB23:59:34
4okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:03
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:03
TOTAL: 5103.5 MB499.9 MB603.4 MB1.4 KB/s113.5 KB120:01:56
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4240.9 KB 19 0 000:00:33
2lze200.lze.lodz.pl 6 4188.6 KB 4 0 000:30:55
3159-205-141-139.adsl.inetia.pl 1 54.2 KB 1 0 000:31:18
4isvcs01.man.lodz.pl 10 00.0 KB 0 10 000:00:00
TOTAL: 4 305 88133.7 KB 24 10 010:33:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 970 4240.9 KB 19 10 000:00:41
2*.lze.lodz.pl 6 4188.6 KB 4 0 000:30:55
3*.adsl.inetia.pl 1 54.2 KB 1 0 000:31:18
4unresolved 7 00.0 KB 0 0 009:28:24
5*.elsnet.pl 2 00.0 KB 0 0 000:00:11
6*.dynamic.chello.pl 1 00.0 KB 0 0 000:00:03
7*.toya.net.pl 71 00.0 KB 0 0 000:02:15
TOTAL: 71058 88133.7 KB 24 10 010:33:50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
185.48.195.155 10.109 11.348 0.00009:27:08
159-205-141-139.adsl.inetia.pl 0.029 0.016 0.00000:31:18
lze200.lze.lodz.pl 0.030 0.073 0.00000:30:55
staticline17008.toya.net.pl 0.007 0.021 0.00000:02:11
212.51.203.199 0.006 0.006 0.00000:01:15
web.man.lodz.pl 1.093 2.869 0.00000:00:33
host227.elsnet.pl 0.000 0.029 0.00000:00:11
mon.man.lodz.pl 1.817 5.411 0.00000:00:06
staticline41435.toya.net.pl 0.210 0.643 0.00000:00:03
89-68-1-39.dynamic.chello.pl 0.000 0.009 0.00000:00:03
david.man.lodz.pl 0.334 0.918 0.00000:00:00
isvcs01.man.lodz.pl 0.066 0.115 0.00000:00:00
? 0.007 0.007 0.00000:00:00
TOTAL: 13 13.708 21.465 0.00010:33:50

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 576
david.man.lodz.pl 96
staticline41435.toya.net.pl 69
185.48.195.155 5
212.51.203.199 2
staticline17008.toya.net.pl 2
host227.elsnet.pl 2
89-68-1-39.dynamic.chello.pl 1
TOTAL: 8 753

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
185.48.195.155 2 0
159-205-141-139.adsl.inetia.pl 1 0
TOTAL: 2 3 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 83 94.3%
2lodzman 5 5.7%
TOTAL: 2 88100.0%

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

NewsgroupCount
1pl.comp.pecet 47
2pl.misc.telefonia.gsm 21
3pl.rec.dom 9
4pl.rec.kuchnia 6
5lodzman.test 5
TOTAL: 5 88