Daily Usenet report

Aug 20 04:15:02 -- Aug 21 04:15:02

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Aug 20 04:20:42 newsfeed nnrpd[4165]: mon.man.lodz.pl rejected Expiring process 4097
Aug 20 05:08:27 newsfeed overchan[3817]: input line too long, skipping
Aug 20 07:57:30 newsfeed overchan[3817]: input line too long, skipping
Aug 20 09:04:11 newsfeed nnrpd[15208]: SERVER perl filter not defined
Aug 20 13:11:19 newsfeed overchan[3817]: input line too long, skipping
Aug 20 15:48:01 newsfeed overchan[3817]: input line too long, skipping
Aug 20 15:49:18 newsfeed overchan[3817]: input line too long, skipping
Aug 20 15:55:47 newsfeed overchan[3817]: input line too long, skipping
Aug 20 15:59:55 newsfeed overchan[3817]: input line too long, skipping
Aug 20 16:14:12 newsfeed overchan[3817]: input line too long, skipping
Aug 20 16:35:25 newsfeed overchan[3817]: input line too long, skipping
Aug 20 16:37:03 newsfeed overchan[3817]: input line too long, skipping
Aug 20 16:42:21 newsfeed overchan[3817]: input line too long, skipping
Aug 20 17:24:59 newsfeed overchan[3817]: input line too long, skipping
Aug 20 19:16:38 newsfeed overchan[3817]: input line too long, skipping
Aug 20 20:13:46 newsfeed overchan[3817]: input line too long, skipping
Aug 20 20:47:24 newsfeed overchan[3817]: input line too long, skipping
Aug 20 21:30:56 newsfeed overchan[3817]: input line too long, skipping
Aug 20 22:02:02 newsfeed overchan[3817]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2545985 97.5%296.7 MB 97.2%
innfeed 41426 1.6%4.9 MB 1.6%
innd 20036 0.8%3.2 MB 1.0%
nnrpd 4748 0.2%503.2 KB 0.2%
overchan 18 0.0%3.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62612214 100.0%305.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2524741 93.6%
Positive hits 103310 3.8%
Negative hits 68192 2.5%
Cache misses 696 0.0%
TOTAL: 4 2696939 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.098 0.0%170 0.000 18.224 67.640
article cleanup00:00:28.547 0.0%2546678 0.008 0.011 0.015
article logging00:01:43.948 0.1%2547270 0.028 0.041 0.176
article parse00:36:06.271 2.5%102068490 0.013 0.021 0.036
article write00:17:53.821 1.2%2540824 0.191 0.423 1.492
artlog/artcncl00:00:00.004 0.0%170 0.000 0.024 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:02:47.608 0.2%116925402 0.001 0.001 0.002
hisgrep/artcncl00:00:01.771 0.0%163 0.000 10.865 50.360
hishave/artcncl00:00:00.159 0.0%170 0.000 0.935 13.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:35:41.783 2.5%2716245 0.181 0.789 5.442
history sync00:00:00.010 0.0%290 0.000 0.034 0.500
history write01:12:38.529 5.0%2542529 0.260 1.714 7.795
hiswrite/artcncl00:00:00.020 0.0%7 0.000 2.857 9.000
idle16:03:44.815 66.9%84180174 0.374 0.687 1.803
nntp read00:56:02.307 3.9%100286175 0.022 0.034 0.051
overview write00:00:11.034 0.0%2540824 0.003 0.004 0.006
perl filter03:42:08.127 15.4%2542528 3.354 5.242 7.395
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:20.208 0.3%5346398 0.037 0.049 0.065
TOTAL: 24:00:03.12923:33:52.060 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:01.160 0.0%531110 0.000 0.002 0.005
article prepare00:00:00.139 0.0%653892 0.000 0.000 0.001
article read00:02:37.912 0.2%155631 0.205 1.015 22.442
backlog stats00:00:02.054 0.0%2545809 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:14.532 0.0%1047586 0.008 0.014 0.023
data write00:05:35.881 0.4%1507494 0.118 0.223 0.403
idle23:40:35.744 99.3%2545809 15.968 33.481 103.010
status file00:00:12.471 0.0%16897 0.483 0.738 1.228
TOTAL: 23:50:17.37123:49:19.893 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:20.392 62.5%3021 0.000 6.750 1531.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.258 0.8%6688 0.000 0.039 1.000
readart00:00:00.094 0.3%26 0.000 3.615 6.643
TOTAL: 00:00:32.60400:00:20.744 63.6%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1290 25393692534623 2696 2050 99%378:09:09
2news.nask.pl 2 107560 4571 99204 3785 4%24:16:42
3news.icm.edu.pl 43 272 153 111 8 56%17:13:17
4localhost 2 1 1 0 0 100%00:00:00
TOTAL: 4 1337 26472022539348 102011 5843 95%419:39:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl703.6 GB24.1 MB42.2 MB703.7 GB 99%290.9 KB
2news.nask.pl38.7 MB191.0 MB204.0 MB433.7 MB 8%53.2 KB
3news.icm.edu.pl2.6 MB0.0 KB451.8 KB3.0 MB 85%19.0 KB
4localhost1.3 KB0.0 KB0.0 KB1.3 KB100%1.3 KB
TOTAL: 4703.7 GB215.2 MB246.7 MB704.1 GB 99%290.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 20 04:15:02 - 04:59:59 81627 3.2% 30.2519.1 GB 2.7%7412.09
Aug 20 05:00:00 - 05:59:59 124214 4.9% 34.5033.2 GB 4.7%9660.98
Aug 20 06:00:00 - 06:59:59 86678 3.4% 24.0827.5 GB 3.9%8015.75
Aug 20 07:00:00 - 07:59:59 97495 3.8% 27.0830.5 GB 4.3%8886.55
Aug 20 08:00:00 - 08:59:59 96961 3.8% 26.9330.1 GB 4.3%8768.53
Aug 20 09:00:00 - 09:59:59 117181 4.6% 32.5529.1 GB 4.1%8482.04
Aug 20 10:00:00 - 10:59:59 99057 3.9% 27.5227.6 GB 3.9%8028.05
Aug 20 11:00:00 - 11:59:59 102223 4.0% 28.4032.5 GB 4.6%9456.68
Aug 20 12:00:00 - 12:59:59 121277 4.8% 33.6935.6 GB 5.1%10371.88
Aug 20 13:00:00 - 13:59:59 111194 4.4% 30.8930.2 GB 4.3%8794.82
Aug 20 14:00:00 - 14:59:59 131459 5.2% 36.5234.4 GB 4.9%10033.37
Aug 20 15:00:00 - 15:59:59 167014 6.6% 46.3933.4 GB 4.7%9716.36
Aug 20 16:00:00 - 16:59:59 80929 3.2% 22.4826.5 GB 3.8%7725.01
Aug 20 17:00:00 - 17:59:59 86678 3.4% 24.0824.3 GB 3.5%7088.60
Aug 20 18:00:00 - 18:59:59 106526 4.2% 29.5933.5 GB 4.8%9760.86
Aug 20 19:00:00 - 19:59:59 113349 4.5% 31.4934.0 GB 4.8%9916.52
Aug 20 20:00:00 - 20:59:59 133942 5.3% 37.2136.0 GB 5.1%10474.74
Aug 20 21:00:00 - 21:59:59 140665 5.5% 39.0736.2 GB 5.1%10543.20
Aug 20 22:00:00 - 22:59:59 88118 3.5% 24.4823.4 GB 3.3%6824.04
Aug 20 23:00:00 - 23:59:59 57346 2.3% 15.9316.8 GB 2.4%4902.84
Aug 21 00:00:00 - 00:59:59 93696 3.7% 26.0322.7 GB 3.2%6622.26
Aug 21 01:00:00 - 01:59:59 79805 3.1% 22.1725.4 GB 3.6%7385.56
Aug 21 02:00:00 - 02:59:59 118243 4.7% 32.8531.4 GB 4.5%9132.54
Aug 21 03:00:00 - 03:59:59 82434 3.2% 22.9022.7 GB 3.2%6625.30
Aug 21 04:00:00 - 04:15:02 21233 0.8% 23.547.0 GB 1.0%8134.78
TOTAL: 24:00:00 2539344 100.0% 29.39703.2 GB 100.0%8533.73
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nask.pl 3897 5 0 2434 4 0 0 0 1454
2newsfeed.pionier.net.pl 2547 174 0 1727 8 0 0 0 638
3news.icm.edu.pl 27 0 0 0 0 0 0 0 27
TOTAL: 3 6471 179 0 4161 12 0 0 0 2119

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 99
it.tlc.cellulari.android 46
it.comp.os.win.windows10 16
comp.mobile.android 12
de.comp.office-pakete.ms-office.excel 2
hr.ponuda.hardver.komponente 1
de.comp.lang.vbclassic 1
uk.rec.cycling.moderated 1
it.tlc.cellulari.iphone 1
TOTAL: 9 179

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

GroupsCount
pl.sci.matematyka 10
bit.listserv.catholic 1
pl.praca.oferowana 1
TOTAL: 3 12

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1206
Binary in non-binary group 205
EMP (phl) 46
Scoring filter (9) 20
Scoring filter (16) 16
Scoring filter (8) 15
Too many newsgroups 5
Scoring filter (10) 4
Scoring filter (18) 3
EMP (fsl) 3
HTML post 2
Scoring filter (11) 1
TOTAL: 12 1526

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Article posted in the future
newsfeed.pionier.net.pl 1
TOTAL: 1 1
Including strange strings
newsfeed.pionier.net.pl 489
news.nask.pl 101
news.icm.edu.pl 2
TOTAL: 3 592
TOTAL: 2 593

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nask 322903 150331 100504 8 0 1558 46%23:59:58
2panorama 288932 1174 259241 372 12 271658 0%23:59:58
3poznan 6474 70 4514 24 0 0 1%23:59:54
4icm 337583 42 251900 12073 0 6 0%23:59:58
5okapi 0 0 0 0 0 1248 0%23:57:51
TOTAL: 5 955892 151617 616159 12477 12 274470 15%119:57:39
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask79.6 GB2.9 MB79.6 GB965.8 KB/s555.0 KB23:59:58
2panorama48.6 MB28.7 MB77.3 MB0.9 KB/s51.2 KB23:59:58
3icm7.2 MB5.2 GB5.2 GB63.5 KB/s453.0 KB23:59:58
4poznan307.9 KB63.8 KB371.8 KB0.0 KB/s4.0 KB23:59:54
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 579.6 GB5.3 GB84.9 GB206.1 KB/s542.4 KB119:57:39
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama2.4 MB
TOTAL: 12.4 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1ool-4578089a.dyn.optonline.net 1 148.8 KB 1 0 000:00:05
2web.man.lodz.pl 288 1212.0 KB 6 0 000:00:20
3isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 3 290 2620.8 KB 7 1 000:00:32

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dyn.optonline.net 1 148.8 KB 1 0 000:00:05
2*.man.lodz.pl 674 1212.0 KB 6 1 000:00:25
3unresolved 1 00.0 KB 0 0 000:00:01
TOTAL: 3 676 2620.8 KB 7 1 000:00:32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.340 4.220 0.00000:00:20
ool-4578089a.dyn.optonline.net 0.020 0.012 0.00000:00:05
mon.man.lodz.pl 1.096 3.064 0.00000:00:03
125.212.217.215 0.004 0.016 0.00000:00:01
david.man.lodz.pl 0.404 1.192 0.00000:00:01
isvcs01.man.lodz.pl 0.008 0.012 0.00000:00:00
TOTAL: 6 2.872 8.516 0.00000:00:32

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 289
david.man.lodz.pl 96
125.212.217.215 1
TOTAL: 3 386

Newsgroup request counts (by category):

CategoryCountPct
1lodman 14 53.8%
2pl 12 46.2%
TOTAL: 2 26100.0%

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

NewsgroupCount
1lodman.info 14
2pl.comp.pecet 8
3pl.comp.os.ms-windows.winnt 4
TOTAL: 3 26