Daily Usenet report

Apr 17 04:15:01 -- Apr 18 04:15:03

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Apr 17 09:03:02 newsfeed nnrpd[16871]: SERVER perl filter not defined
Apr 17 09:06:26 newsfeed nnrpd[16966]: SERVER perl filter not defined
Apr 17 10:07:27 newsfeed overchan[5772]: input line too long, skipping
Apr 17 13:10:02 newsfeed pgpverify[26174]: pgpverify: verification failed
Apr 17 14:08:20 newsfeed overchan[5772]: input line too long, skipping
Apr 17 15:20:59 newsfeed overchan[5772]: input line too long, skipping
Apr 17 15:28:14 newsfeed overchan[5772]: input line too long, skipping
Apr 17 16:00:38 newsfeed overchan[5772]: input line too long, skipping
Apr 17 16:15:57 newsfeed nnrpd[373]: SERVER perl filter not defined
Apr 17 17:06:58 newsfeed overchan[5772]: input line too long, skipping
Apr 17 17:25:53 newsfeed nnrpd[2979]: SERVER perl filter not defined
Apr 17 20:46:07 newsfeed overchan[5772]: input line too long, skipping
Apr 17 20:54:16 newsfeed overchan[5772]: input line too long, skipping
Apr 17 22:01:44 newsfeed overchan[5772]: input line too long, skipping
Apr 17 22:54:39 newsfeed overchan[5772]: input line too long, skipping
Apr 17 23:17:32 newsfeed overchan[5772]: input line too long, skipping
Apr 18 00:29:24 newsfeed overchan[5772]: input line too long, skipping
Apr 18 03:40:51 newsfeed overchan[5772]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn3237800 97.8%361.3 MB 97.5%
innfeed 44448 1.3%5.2 MB 1.4%
innd 22575 0.7%3.7 MB 1.0%
nnrpd 4783 0.1%506.2 KB 0.1%
overchan 14 0.0%2.5 KB 0.0%
controlchan 4 0.0%0.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 73309625 100.0%370.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 3216278 96.5%
Negative hits 106267 3.2%
Positive hits 11440 0.3%
Cache misses 106 0.0%
TOTAL: 4 3334091 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.999 0.0%198 0.000 15.146 423.000
article cleanup00:00:35.256 0.0%3236096 0.008 0.011 0.014
article logging00:02:09.491 0.1%3236652 0.031 0.040 0.225
article parse00:38:19.776 2.7%94717394 0.017 0.024 0.032
article write00:16:58.132 1.2%3232156 0.215 0.315 0.529
artlog/artcncl00:00:00.005 0.0%197 0.000 0.025 0.143
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:37.763 0.1%111280928 0.001 0.001 0.002
hisgrep/artcncl00:00:01.251 0.0%194 0.000 6.448 418.500
hishave/artcncl00:00:00.727 0.0%198 0.000 3.672 83.857
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:45:31.017 3.2%3354063 0.036 0.814 6.055
history sync00:00:00.016 0.0%290 0.000 0.055 0.500
history write02:06:18.300 8.8%3234357 0.191 2.343 7.671
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle14:39:00.713 61.0%74656984 0.537 0.706 2.683
nntp read00:45:53.743 3.2%92262460 0.024 0.030 0.040
overview write00:00:14.677 0.0%3232156 0.003 0.005 0.007
perl filter04:11:47.701 17.5%3234357 3.439 4.671 6.135
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:39.103 0.4%6482698 0.036 0.052 0.068
TOTAL: 24:00:05.26523:34:10.670 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.114 0.0%55845 0.000 0.002 0.015
article prepare00:00:00.000 0.0%8686 0.000 0.000 0.000
article read00:00:33.156 0.0%2171 0.000 15.272 120.000
backlog stats00:00:00.143 0.0%166740 0.000 0.001 0.004
callbacks00:00:00.000 0.0%5 0.000 0.000 0.000
data read00:00:01.341 0.0%87013 0.003 0.015 0.034
data write00:00:02.961 0.0%68884 0.015 0.043 0.085
idle23:53:27.707 99.9%166740 312.912 515.819 1035.864
status file00:00:13.826 0.0%16653 0.542 0.830 1.374
TOTAL: 23:54:28.44323:54:19.248100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:40.506 79.9%3065 0.000 13.216 10040.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.203 0.4%6727 0.000 0.030 0.667
readart00:00:00.000 0.0%20 0.000 0.000 0.000
TOTAL: 00:00:50.69600:00:40.709 80.3%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
newsmaster@carnet.hr000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 949 32330273223275 7915 1837 99%398:54:37
2news.nask.pl 2 13381 9772 1511 2098 73%24:02:05
3news.icm.edu.pl 47 300 28 266 6 9%17:02:09
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 1003 32467123233079 9692 3941 99%439:58:51
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl736.6 GB15.1 MB23.1 MB736.6 GB 99%239.5 KB
2news.nask.pl36.6 MB523.6 KB21.4 MB58.5 MB 62%5.1 KB
3news.icm.edu.pl910.1 KB19.7 KB151.6 KB1.1 MB 84%31.8 KB
4localhost6.0 KB0.0 KB0.0 KB6.0 KB100%1.5 KB
TOTAL: 4736.6 GB15.6 MB44.7 MB736.7 GB 99%238.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 17 04:15:01 - 04:59:59 78321 2.4% 29.0221.6 GB 2.9%8379.88
Apr 17 05:00:00 - 05:59:59 106326 3.3% 29.5429.7 GB 4.0%8636.25
Apr 17 06:00:00 - 06:59:59 104217 3.2% 28.9529.7 GB 4.0%8650.92
Apr 17 07:00:00 - 07:59:59 114741 3.5% 31.8729.5 GB 4.0%8605.45
Apr 17 08:00:00 - 08:59:59 118325 3.7% 32.8728.9 GB 3.9%8431.57
Apr 17 09:00:00 - 09:59:59 122264 3.8% 33.9632.2 GB 4.4%9387.82
Apr 17 10:00:00 - 10:59:59 140287 4.3% 38.9733.3 GB 4.5%9707.58
Apr 17 11:00:00 - 11:59:59 130983 4.1% 36.3833.2 GB 4.5%9674.17
Apr 17 12:00:00 - 12:59:59 137224 4.2% 38.1235.4 GB 4.8%10307.29
Apr 17 13:00:00 - 13:59:59 128303 4.0% 35.6434.0 GB 4.6%9908.35
Apr 17 14:00:00 - 14:59:59 126438 3.9% 35.1233.1 GB 4.5%9647.86
Apr 17 15:00:00 - 15:59:59 139032 4.3% 38.6233.6 GB 4.6%9794.15
Apr 17 16:00:00 - 16:59:59 155047 4.8% 43.0733.9 GB 4.6%9871.50
Apr 17 17:00:00 - 17:59:59 200780 6.2% 55.7734.6 GB 4.7%10067.01
Apr 17 18:00:00 - 18:59:59 142111 4.4% 39.4832.0 GB 4.4%9332.69
Apr 17 19:00:00 - 19:59:59 185070 5.7% 51.4131.4 GB 4.3%9157.72
Apr 17 20:00:00 - 20:59:59 186310 5.8% 51.7533.2 GB 4.5%9684.39
Apr 17 21:00:00 - 21:59:59 175871 5.4% 48.8533.5 GB 4.6%9770.94
Apr 17 22:00:00 - 22:59:59 138973 4.3% 38.6031.0 GB 4.2%9037.60
Apr 17 23:00:00 - 23:59:59 172784 5.3% 48.0033.3 GB 4.5%9710.34
Apr 18 00:00:00 - 00:59:59 80401 2.5% 22.3315.2 GB 2.1%4418.48
Apr 18 01:00:00 - 01:59:59 99141 3.1% 27.5423.3 GB 3.2%6799.25
Apr 18 02:00:00 - 02:59:59 117129 3.6% 32.5427.0 GB 3.7%7877.28
Apr 18 03:00:00 - 03:59:59 104400 3.2% 29.0025.7 GB 3.5%7479.31
Apr 18 04:00:00 - 04:15:03 28633 0.9% 31.717.6 GB 1.0%8834.08
TOTAL: 24:00:02 3233111 100.0% 37.42736.3 GB 100.0%8935.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 2303 46 0 166 2 0 0 0 2089
2newsfeed.pionier.net.pl 2183 196 0 1567 2 0 0 0 418
3news.icm.edu.pl 6 0 0 2 0 0 0 0 4
TOTAL: 3 4492 242 0 1735 4 0 0 0 2511

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 133
comp.sys.raspberry-pi 46
it.tlc.cellulari.android 30
it.comp.os.win.windows10 25
it.comp.os.linux.ubuntu 3
de.rec.sf.startrek 2
comp.mobile.ipad 1
de.comm.provider.telefonie 1
comp.mobile.android 1
TOTAL: 9 242

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

GroupsCount
pl.sci.matematyka 3
bit.listserv.catholic 1
TOTAL: 2 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1693
Binary in non-binary group 169
EMP (phl) 32
Scoring filter (16) 13
Scoring filter (8) 9
Scoring filter (11) 9
Scoring filter (9) 9
HTML post 6
Too many newsgroups 5
EMP (fsl) 3
Scoring filter (10) 3
Scoring filter (18) 3
Scoring filter (12) 1
TOTAL: 13 1955

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 348
news.nask.pl 208
TOTAL: 2 556
TOTAL: 1 556

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 42174 919 13331 185 19 41502 2%23:59:59
2poznan 16207 209 9531 25 0 1 1%23:59:59
3icm 25215 50 18041 41 0 0 0%23:59:59
4nask 3408 3 2450 0 0 0 0%23:58:45
5okapi 0 0 0 0 0 1085 0%23:57:52
TOTAL: 5 87004 1181 43353 251 19 42588 1%119:56:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm4.8 MB11.3 MB16.1 MB0.2 KB/s180.8 KB23:59:59
2panorama3.1 MB564.1 KB3.6 MB0.0 KB/s3.4 KB23:59:59
3poznan653.8 KB140.0 KB793.7 KB0.0 KB/s3.4 KB23:59:59
4nask5.6 KB0.0 KB5.6 KB0.0 KB/s1.9 KB23:58:45
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
TOTAL: 58.5 MB12.0 MB20.5 MB0.0 KB/s14.6 KB119:56:34
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 289 2028.8 KB 9 0 000:00:20
2isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:00
TOTAL: 2 293 2028.8 KB 9 4 000:00:50

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 677 2028.8 KB 9 4 000:00:25
2unresolved 3 00.0 KB 0 0 000:00:24
TOTAL: 2 680 2028.8 KB 9 4 000:00:50

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.436 5.064 0.00000:00:20
185.48.193.90 0.004 0.040 0.00000:00:15
107.170.253.114 0.000 0.012 0.00000:00:09
mon.man.lodz.pl 1.228 4.800 0.00000:00:03
david.man.lodz.pl 0.292 1.516 0.00000:00:01
isvcs01.man.lodz.pl 0.024 0.068 0.00000:00:00
TOTAL: 6 2.984 11.500 0.00000:00:50

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
185.48.193.90 2
107.170.253.114 1
TOTAL: 4 387

NNRP client timeouts [Top 20]:

SystemConnPeer
185.48.193.90 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 20100.0%
TOTAL: 1 20100.0%

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

NewsgroupCount
1pl.comp.pecet 12
2pl.comp.os.ms-windows.winnt 8
TOTAL: 2 20