Daily Usenet report

Oct 3 04:15:02 -- Oct 4 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Oct 3 13:50:30 newsfeed nnrpd[1032]: SERVER perl filter not defined
Oct 3 14:24:06 newsfeed nnrpd[2338]: SERVER perl filter not defined
Oct 3 15:28:32 newsfeed overchan[11725]: input line too long, skipping
Oct 3 15:42:18 newsfeed nnrpd[5060]: SERVER perl filter not defined
Oct 3 15:56:57 newsfeed overchan[11725]: input line too long, skipping
Oct 3 15:58:54 newsfeed overchan[11725]: input line too long, skipping
Oct 3 16:01:24 newsfeed overchan[11725]: input line too long, skipping
Oct 3 16:02:06 newsfeed overchan[11725]: input line too long, skipping
Oct 3 16:16:57 newsfeed overchan[11725]: input line too long, skipping
Oct 3 17:54:17 newsfeed overchan[11725]: input line too long, skipping
Oct 3 17:58:48 newsfeed overchan[11725]: input line too long, skipping
Oct 3 18:33:18 newsfeed overchan[11725]: input line too long, skipping
Oct 3 20:08:04 newsfeed nnrpd[14786]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2259982 96.8%263.3 MB 96.5%
innfeed 45005 1.9%5.3 MB 2.0%
innd 24555 1.1%3.8 MB 1.4%
nnrpd 4910 0.2%524.0 KB 0.2%
overchan 10 0.0%1.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62334463 100.0%272.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2211117 92.8%
Negative hits 136652 5.7%
Positive hits 35523 1.5%
Cache misses 126 0.0%
TOTAL: 4 2383418 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.191 0.0%245 0.000 13.024 97.000
article cleanup00:00:29.530 0.0%2254526 0.010 0.013 0.018
article logging00:01:10.647 0.1%2255341 0.023 0.031 0.060
article parse00:56:37.491 3.9%201726510 0.008 0.017 0.027
article write00:16:57.356 1.2%2229321 0.327 0.456 0.924
artlog/artcncl00:00:00.002 0.0%236 0.000 0.008 0.056
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:04:10.796 0.3%216699514 0.000 0.001 0.002
hisgrep/artcncl00:00:00.357 0.0%243 0.000 1.469 13.000
hishave/artcncl00:00:00.057 0.0%245 0.000 0.233 2.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:39:51.756 2.8%2426274 0.079 0.986 3.927
history sync00:00:00.014 0.0%290 0.000 0.048 0.500
history write01:53:39.173 7.9%2238786 0.469 3.046 11.855
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle13:38:33.380 56.8%156307575 0.216 0.314 0.544
nntp read01:25:15.561 5.9%200097080 0.012 0.026 0.036
overview write00:00:10.510 0.0%2229321 0.003 0.005 0.007
perl filter04:15:47.443 17.8%2238786 5.456 6.855 8.669
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:19.631 0.2%4510367 0.035 0.044 0.063
TOTAL: 24:00:02.44223:16:06.895 96.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.359 0.0%182481 0.000 0.002 0.010
article prepare00:00:00.013 0.0%29876 0.000 0.000 0.013
article read00:01:40.484 0.1%7244 0.692 13.871 211.867
backlog stats00:00:00.251 0.0%403983 0.000 0.001 0.003
callbacks00:00:00.000 0.0%16 0.000 0.000 0.000
data read00:00:03.099 0.0%227028 0.001 0.014 0.038
data write00:00:09.351 0.0%180159 0.014 0.052 0.164
idle23:51:05.610 99.8%403983 31.950 212.548 712.577
status file00:00:12.989 0.0%15983 0.542 0.813 1.533
TOTAL: 23:53:26.24823:53:12.156100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:07:48.149 99.9%3149 0.000 3578.326348975.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.174 0.0%7060 0.000 0.025 0.667
readart00:00:00.926 0.0%39 0.000 23.744 245.333
TOTAL: 03:08:04.36903:07:49.249 99.9%----

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 1001 22402692216689 5743 17837 98%346:00:08
2news.nask.pl 2 40736 18141 16247 6348 44%23:40:55
3news.icm.edu.pl 42 331 43 260 28 12%16:58:26
4localhost 5 4 4 0 0 100%00:00:00
TOTAL: 4 1050 22813402234877 22250 24213 97%386:39:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl730.3 GB3.0 GB3.7 GB737.0 GB 99%345.9 KB
2news.nask.pl2.9 GB253.5 MB679.1 MB3.8 GB 76%164.4 KB
3news.icm.edu.pl1.1 MB29.5 KB424.8 KB1.5 MB 71%22.1 KB
4localhost6.4 KB0.0 KB0.0 KB6.4 KB100%1.6 KB
TOTAL: 4733.2 GB3.3 GB4.4 GB740.9 GB 98%343.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 3 04:15:02 - 04:59:59 46377 2.1% 17.1916.3 GB 2.2%6353.92
Oct 3 05:00:00 - 05:59:59 45179 2.0% 12.5516.6 GB 2.3%4833.72
Oct 3 06:00:00 - 06:59:59 47849 2.1% 13.2917.6 GB 2.4%5132.98
Oct 3 07:00:00 - 07:59:59 51499 2.3% 14.3117.7 GB 2.4%5147.55
Oct 3 08:00:00 - 08:59:59 48108 2.2% 13.3616.1 GB 2.2%4699.37
Oct 3 09:00:00 - 09:59:59 49466 2.2% 13.7417.5 GB 2.4%5096.66
Oct 3 10:00:00 - 10:59:59 53721 2.4% 14.9217.8 GB 2.4%5182.06
Oct 3 11:00:00 - 11:59:59 53199 2.4% 14.7817.1 GB 2.3%4982.42
Oct 3 12:00:00 - 12:59:59 54720 2.4% 15.2019.9 GB 2.7%5792.00
Oct 3 13:00:00 - 13:59:59 123782 5.5% 34.3837.5 GB 5.1%10923.68
Oct 3 14:00:00 - 14:59:59 125709 5.6% 34.9241.2 GB 5.6%12010.24
Oct 3 15:00:00 - 15:59:59 105034 4.7% 29.1834.2 GB 4.7%9974.80
Oct 3 16:00:00 - 16:59:59 131817 5.9% 36.6239.8 GB 5.4%11600.44
Oct 3 17:00:00 - 17:59:59 117942 5.3% 32.7637.8 GB 5.2%11020.66
Oct 3 18:00:00 - 18:59:59 100209 4.5% 27.8431.8 GB 4.3%9248.27
Oct 3 19:00:00 - 19:59:59 125118 5.6% 34.7641.4 GB 5.7%12048.72
Oct 3 20:00:00 - 20:59:59 127158 5.7% 35.3241.5 GB 5.7%12075.33
Oct 3 21:00:00 - 21:59:59 122187 5.5% 33.9440.1 GB 5.5%11667.95
Oct 3 22:00:00 - 22:59:59 118317 5.3% 32.8737.5 GB 5.1%10908.87
Oct 3 23:00:00 - 23:59:59 111087 5.0% 30.8635.3 GB 4.8%10285.62
Oct 4 00:00:00 - 00:59:59 95971 4.3% 26.6630.8 GB 4.2%8984.95
Oct 4 01:00:00 - 01:59:59 118619 5.3% 32.9540.4 GB 5.5%11772.98
Oct 4 02:00:00 - 02:59:59 118013 5.3% 32.7840.0 GB 5.5%11648.38
Oct 4 03:00:00 - 03:59:59 113403 5.1% 31.5036.4 GB 5.0%10594.29
Oct 4 04:00:00 - 04:15:02 30261 1.4% 33.559.6 GB 1.3%11136.95
TOTAL: 24:00:00 2234745 100.0% 25.87731.9 GB 100.0%8882.68
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 18207 181 0 14130 0 0 0 0 3896
2news.nask.pl 6764 23 0 1281 1 0 0 0 5459
3news.icm.edu.pl 30 0 0 2 0 0 0 0 28
TOTAL: 3 25001 204 0 15413 1 0 0 0 9383

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 125
it.tlc.cellulari.android 23
de.rec.sf.startrek 23
it.comp.os.win.windows10 22
de.comp.lang.php 4
it.comp.os.win.windows7 2
comp.sys.mac.vintage 1
alt.sex.telephones 1
hr.ponuda.hardver.komponente 1
it.comp.os.win.windows8 1
hr.rec.glazba.hifi 1
TOTAL: 11 204

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

GroupsCount
bit.listserv.catholic 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 5934
EMP (md5) 2427
Scoring filter (11) 55
EMP (phl) 43
Scoring filter (8) 42
Scoring filter (9) 28
Scoring filter (10) 18
Scoring filter (13) 8
Scoring filter (16) 5
Scoring filter (12) 3
EMP (fsl) 2
HTML post 1
Scoring filter (14) 1
Too many newsgroups (low_xpost) 1
TOTAL: 14 8568

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news.nask.pl 442
newsfeed.pionier.net.pl 371
news.icm.edu.pl 2
TOTAL: 3 815
TOTAL: 1 815

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 139724 3187 109224 617 40 69591 2%23:59:57
2nask 34093 2024 20795 2 0 0 5%23:59:57
3poznan 15813 171 9526 33 0 0 1%23:59:57
4icm 59353 62 47743 452 0 0 0%23:59:57
5okapi 0 0 0 0 0 1118 0%23:57:50
TOTAL: 5 248983 5444 187288 1104 40 70709 2%119:57:38
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nask697.5 MB356.2 KB697.8 MB8.3 KB/s352.7 KB23:59:57
2panorama22.6 MB3.1 MB25.7 MB0.3 KB/s6.9 KB23:59:57
3icm1.0 MB155.0 MB156.0 MB1.8 KB/s310.7 KB23:59:57
4poznan850.0 KB509.4 KB1.3 MB0.0 KB/s6.7 KB23:59:57
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
TOTAL: 5721.9 MB159.0 MB880.9 MB2.1 KB/s137.8 KB119:57:38
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2420.3 KB 10 0 000:00:23
278-11-59-253.static.ip.netia.com.pl 24 1321.8 KB 8 0 002:40:10
3ip-209-5.ap-media.pl 2 23.0 KB 1 0 000:16:45
4isvcs01.man.lodz.pl 4 00.0 KB 0 4 000:00:03
TOTAL: 4 318 3945.1 KB 19 4 003:08:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 676 2420.3 KB 10 4 000:00:31
2*.static.ip.netia.com.pl 24 1321.8 KB 8 0 002:40:10
3*.ap-media.pl 2 23.0 KB 1 0 000:16:45
4*.neoplus.adsl.tpnet.pl 3 00.0 KB 0 0 000:10:35
TOTAL: 4 705 3945.1 KB 19 4 003:08:03

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
78-11-59-253.static.ip.netia.com.pl 0.264 0.384 0.00002:40:10
ip-209-5.ap-media.pl 0.016 0.036 0.00000:16:45
abkh114.neoplus.adsl.tpnet.pl 0.060 0.036 0.00000:06:03
acnr145.neoplus.adsl.tpnet.pl 0.016 0.008 0.00000:04:32
web.man.lodz.pl 1.156 4.384 0.00000:00:23
mon.man.lodz.pl 1.032 4.628 0.00000:00:03
isvcs01.man.lodz.pl 0.040 0.076 0.00000:00:03
david.man.lodz.pl 0.356 1.476 0.00000:00:01
TOTAL: 8 2.940 11.028 0.00003:08:03

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
abkh114.neoplus.adsl.tpnet.pl 2
acnr145.neoplus.adsl.tpnet.pl 1
TOTAL: 4 387

NNRP client timeouts [Top 20]:

SystemConnPeer
78-11-59-253.static.ip.netia.com.pl 1 0
TOTAL: 1 1 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 24 61.5%
2lodman 15 38.5%
TOTAL: 2 39100.0%

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

NewsgroupCount
1pl.comp.pecet 24
2lodman.info 13
3lodman.test 2
TOTAL: 3 39