Daily Usenet report

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

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Feb 17 07:06:41 newsfeed overchan[2375]: input line too long, skipping
Feb 17 09:02:30 newsfeed nnrpd[15123]: SERVER perl filter not defined
Feb 17 09:03:55 newsfeed nnrpd[15130]: SERVER perl filter not defined
Feb 17 09:34:03 newsfeed nnrpd[16113]: SERVER perl filter not defined
Feb 17 10:14:43 newsfeed nnrpd[17460]: SERVER perl filter not defined
Feb 17 10:44:09 newsfeed nnrpd[18434]: SERVER perl filter not defined
Feb 17 10:44:49 newsfeed nnrpd[18442]: SERVER perl filter not defined
Feb 17 12:37:05 newsfeed overchan[2375]: input line too long, skipping
Feb 17 12:39:32 newsfeed overchan[2375]: input line too long, skipping
Feb 17 13:10:04 newsfeed pgpverify[23359]: pgpverify: verification failed
Feb 17 18:31:30 newsfeed nnrpd[1500]: SERVER perl filter not defined
Feb 17 23:20:40 newsfeed nnrpd[11212]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 846043 97.2%100.4 MB 96.8%
innd 10331 1.2%1.7 MB 1.6%
nnrpd 7192 0.8%746.9 KB 0.7%
innfeed 6604 0.8%932.7 KB 0.9%
controlchan 3 0.0%0.4 KB 0.0%
overchan 3 0.0%0.3 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 870177 100.0%103.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 786620 95.2%
Negative hits 22664 2.7%
Positive hits 15356 1.9%
Cache misses 1327 0.2%
TOTAL: 4 825967 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:09.795 0.0%427 0.000 22.939 1074.000
article cleanup00:00:11.405 0.0%790675 0.000 0.014 0.052
article logging00:00:20.795 0.0%845000 0.000 0.025 0.118
article parse00:27:16.917 1.9%56706283 0.008 0.029 0.048
article write00:08:25.497 0.6%786199 0.147 0.643 5.292
artlog/artcncl00:00:00.005 0.0%424 0.000 0.012 1.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:01:08.431 0.1%61325677 0.000 0.001 0.002
hisgrep/artcncl00:00:02.056 0.0%416 0.000 4.942 183.000
hishave/artcncl00:00:00.646 0.0%427 0.000 1.513 21.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:47:45.771 3.3%826195 0.966 3.469 15.048
history sync00:00:00.021 0.0%494 0.000 0.043 1.000
history write01:32:38.436 6.4%787235 1.194 7.061 24.655
hiswrite/artcncl00:00:00.070 0.0%11 0.000 6.364 10.000
idle18:33:29.048 77.3%40887501 0.475 1.634 19.011
nntp read00:24:52.322 1.7%56149438 0.013 0.027 0.040
overview write00:00:05.080 0.0%786199 0.000 0.006 0.049
perl filter01:43:01.717 7.2%787234 3.615 7.852 10.091
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:01:31.103 0.1%1610508 0.031 0.057 0.147
TOTAL: 23:59:34.89123:40:59.115 98.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.145 0.0%38241 0.000 0.004 1.000
article prepare00:00:00.002 0.0%9692 0.000 0.000 0.083
article read00:00:00.190 0.0%2368 0.000 0.080 1.000
backlog stats00:00:00.109 0.0%214754 0.000 0.001 1.000
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.277 0.0%138283 0.000 0.009 1.000
data write00:00:03.575 0.0%100642 0.000 0.036 1.000
idle23:59:56.664100.0%214754 0.000 402.305 15218.000
status file00:00:00.383 0.0%200 0.000 1.915 40.333
TOTAL: 24:00:07.31924:00:02.345100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:35:01.877 99.6%4359 0.000 1308.070189770.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.582 0.0%10611 0.000 0.055 4.800
readart00:00:00.632 0.0%469 0.000 1.348 107.000
TOTAL: 01:35:23.78101:35:03.091 99.6%----

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 328 788125 783759 1103 3263 99%166:50:14
2news.nask.pl 2 15621 2729 11716 1176 17%24:24:40
3news.icm.edu.pl 53 290 23 212 55 7%18:00:16
4localhost 9 8 8 0 0 100%00:00:00
TOTAL: 4 392 804044 786519 13031 4494 97%209:15:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl212.1 GB39.3 MB127.2 MB212.3 GB 99%282.9 KB
2news.nask.pl7.9 MB2.8 MB2.8 MB13.5 MB 58%3.5 KB
3news.icm.edu.pl2.4 MB26.7 KB5.0 MB7.5 MB 32%97.9 KB
4localhost17.6 KB0.0 KB0.0 KB17.6 KB100%2.2 KB
TOTAL: 4212.2 GB42.1 MB135.0 MB212.3 GB 99%281.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 17 04:15:02 - 04:59:59 26019 3.3% 9.647.0 GB 3.3%2709.67
Feb 17 05:00:00 - 05:59:59 11202 1.4% 3.111.8 GB 0.9% 529.40
Feb 17 06:00:00 - 06:59:59 9470 1.2% 2.631.2 GB 0.6% 340.33
Feb 17 07:00:00 - 07:59:59 7565 1.0% 2.10995.6 MB 0.5% 283.19
Feb 17 08:00:00 - 08:59:59 6714 0.9% 1.86851.3 MB 0.4% 242.14
Feb 17 09:00:00 - 09:59:59 7959 1.0% 2.21992.6 MB 0.5% 282.35
Feb 17 10:00:00 - 10:59:59 7759 1.0% 2.16952.2 MB 0.4% 270.86
Feb 17 11:00:00 - 11:59:59 8610 1.1% 2.39977.5 MB 0.4% 278.03
Feb 17 12:00:00 - 12:59:59 11554 1.5% 3.211.2 GB 0.6% 356.13
Feb 17 13:00:00 - 13:59:59 14547 1.8% 4.041.6 GB 0.8% 475.11
Feb 17 14:00:00 - 14:59:59 14361 1.8% 3.991.6 GB 0.7% 459.95
Feb 17 15:00:00 - 15:59:59 15491 2.0% 4.301.8 GB 0.9% 528.64
Feb 17 16:00:00 - 16:59:59 13544 1.7% 3.761.8 GB 0.8% 512.05
Feb 17 17:00:00 - 17:59:59 12971 1.6% 3.601.6 GB 0.8% 466.50
Feb 17 18:00:00 - 18:59:59 12572 1.6% 3.491.6 GB 0.7% 460.90
Feb 17 19:00:00 - 19:59:59 39614 5.0% 11.009.9 GB 4.6%2874.24
Feb 17 20:00:00 - 20:59:59 59523 7.6% 16.5318.7 GB 8.8%5452.49
Feb 17 21:00:00 - 21:59:59 70319 8.9% 19.5323.3 GB 11.0%6797.64
Feb 17 22:00:00 - 22:59:59 85920 10.9% 23.8725.2 GB 11.9%7351.47
Feb 17 23:00:00 - 23:59:59 88811 11.3% 24.6726.2 GB 12.4%7643.29
Feb 18 00:00:00 - 00:59:59 56837 7.2% 15.7916.4 GB 7.7%4772.62
Feb 18 01:00:00 - 01:59:59 68020 8.6% 18.8922.2 GB 10.5%6463.97
Feb 18 02:00:00 - 02:59:59 66559 8.5% 18.4921.6 GB 10.2%6299.01
Feb 18 03:00:00 - 03:59:59 51772 6.6% 14.3816.6 GB 7.8%4848.94
Feb 18 04:00:00 - 04:15:03 19147 2.4% 21.206.2 GB 2.9%7216.82
TOTAL: 24:00:01 786860 100.0% 9.11212.3 GB 100.0%2576.23
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 57531 243 0 2298 2 0 0 054988
2news.nask.pl 1173 7 0 1140 11 0 0 0 15
3news.icm.edu.pl 55 0 0 1 0 0 0 0 54
TOTAL: 3 58759 250 0 3439 13 0 0 055057

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 116
uk.rec.cycling.moderated 35
it.tlc.cellulari.android 28
comp.sys.raspberry-pi 14
comp.mobile.android 9
hr.ponuda.hardver.komponente 9
nl.comp.os.linux.techniek 7
it.comp.os.win.windows8 7
hr.alt.cellular.gsm.android 5
it.comp.os.win.windows7 4
it.discussioni.energia 4
alt.sex.telephones 3
de.comp.lang.vbclassic 3
de.rec.sf.startrek 1
nl.wetenschap.regulier 1
it.comp.os.linux.ubuntu 1
dk.test.utf8-æøå 1
hr.rec.glazba.hifi 1
hr.alt.cellular.gsm.iphone 1
TOTAL: 19 250

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

GroupsCount
pl.sci.historia 10
pl.sci.matematyka 3
TOTAL: 2 13

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 715
EMP (md5) 54
Attached HTML file 3
Scoring filter (8) 1
TOTAL: 4 773

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 38184 963 36444 154 0 0 2%24:00:17
2icm 37834 376 26371 837 0 5 0%23:56:31
3nask 19408 37 13334 0 0 0 0%24:02:21
4poznan 3254 22 2317 22 0 0 0%23:52:41
5okapi 0 0 0 0 0 2333 0%24:00:03
TOTAL: 5 98680 1398 78466 1013 0 2338 1%119:51:53
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama2.8 MB432.8 KB3.2 MB0.0 KB/s2.9 KB24:00:17
2icm2.2 MB146.5 MB148.6 MB1.8 KB/s125.5 KB23:56:31
3nask165.8 KB0.0 KB165.8 KB0.0 KB/s4.5 KB24:02:21
4poznan71.0 KB61.9 KB132.9 KB0.0 KB/s3.0 KB23:52:41
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:03
TOTAL: 55.1 MB147.0 MB152.1 MB0.4 KB/s64.6 KB119:51:53
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-skrzep2.cm.p.lodz.pl 288 364783.8 KB 288 0 000:00:07
2lze200.lze.lodz.pl 12 73149.6 KB 10 0 001:34:26
3web.man.lodz.pl 288 3233.5 KB 15 0 000:00:17
4isvcs01.man.lodz.pl 8 00.0 KB 0 8 000:00:01
TOTAL: 4 596 469966.9 KB 313 8 001:35:23

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 364783.8 KB 288 0 000:00:07
2*.lze.lodz.pl 12 73149.6 KB 10 0 001:34:26
3*.man.lodz.pl 680 3233.5 KB 15 8 000:00:24
4*.elsnet.pl 6 00.0 KB 0 0 000:00:22
5*.toya.net.pl 64 00.0 KB 0 0 000:00:03
TOTAL: 51050 469966.9 KB 313 8 001:35:23

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
lze200.lze.lodz.pl 0.058 0.139 0.00001:34:26
host227.elsnet.pl 0.014 0.067 0.00000:00:22
web.man.lodz.pl 1.104 2.872 0.00000:00:17
pc-skrzep2.cm.p.lodz.pl 1.064 3.121 0.00000:00:07
mon.man.lodz.pl 1.033 2.803 0.00000:00:03
staticline41435.toya.net.pl 0.216 0.697 0.00000:00:03
isvcs01.man.lodz.pl 0.065 0.081 0.00000:00:01
david.man.lodz.pl 0.347 0.896 0.00000:00:01
? 0.014 0.017 0.00000:00:00
TOTAL: 9 3.915 10.693 0.00001:35:23

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 64
host227.elsnet.pl 6
TOTAL: 4 454

NNRP gethostbyaddr failures [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1lodman 364 77.6%
2pl 105 22.4%
TOTAL: 2 469100.0%

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

NewsgroupCount
1lodman.info 364
2pl.rec.kuchnia 51
3pl.comp.os.ms-windows.winnt 22
4pl.rec.dom 17
5pl.comp.pecet 13
6pl.misc.telefonia.gsm 2
TOTAL: 6 469