Daily Usenet report

Apr 9 04:15:03 -- Apr 10 04:15:01

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Apr 9 09:24:14 newsfeed nnrpd[30949]: SERVER perl filter not defined
Apr 9 09:25:35 newsfeed nnrpd[31148]: SERVER perl filter not defined
Apr 9 09:29:53 newsfeed overchan[2371]: input line too long, skipping
Apr 9 09:32:17 newsfeed nnrpd[31245]: SERVER perl filter not defined
Apr 9 12:50:41 newsfeed nnrpd[5453]: SERVER perl filter not defined
Apr 9 12:52:59 newsfeed nnrpd[5462]: SERVER perl filter not defined
Apr 9 12:55:56 newsfeed nnrpd[5690]: SERVER perl filter not defined
Apr 9 12:56:42 newsfeed nnrpd[5697]: SERVER perl filter not defined
Apr 9 12:57:18 newsfeed nnrpd[5698]: SERVER perl filter not defined
Apr 9 12:59:06 newsfeed nnrpd[5726]: SERVER perl filter not defined
Apr 9 13:49:10 newsfeed nnrpd[7386]: SERVER perl filter not defined
Apr 9 14:03:29 newsfeed nnrpd[7802]: SERVER perl filter not defined
Apr 9 14:05:11 newsfeed nnrpd[8028]: SERVER perl filter not defined
Apr 9 16:48:03 newsfeed nnrpd[13360]: SERVER perl filter not defined
Apr 9 19:49:12 newsfeed nnrpd[19337]: SERVER perl filter not defined
Apr 9 20:25:26 newsfeed nnrpd[20637]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 630941 96.5%72.2 MB 95.8%
innd 9074 1.4%1.5 MB 2.0%
nnrpd 7145 1.1%736.8 KB 1.0%
innfeed 6712 1.0%954.1 KB 1.2%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 653873 100.0%75.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 626325 95.0%
Negative hits 16660 2.5%
Positive hits 16056 2.4%
Cache misses 131 0.0%
TOTAL: 4 659172 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:06.418 0.0%267 0.000 24.037 304.500
article cleanup00:00:11.443 0.0%630029 0.000 0.018 0.070
article logging00:00:22.819 0.0%630243 0.000 0.036 0.094
article parse00:19:21.186 1.3%53054854 0.010 0.022 0.048
article write00:12:06.427 0.8%626737 0.147 1.159 5.204
artlog/artcncl00:00:00.005 0.0%261 0.000 0.019 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:01:01.305 0.1%56708854 0.000 0.001 0.016
hisgrep/artcncl00:00:01.759 0.0%238 0.000 7.391 64.111
hishave/artcncl00:00:00.594 0.0%267 0.000 2.225 284.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:31:43.516 2.2%660310 0.012 2.883 10.979
history sync00:00:00.043 0.0%503 0.000 0.085 1.000
history write01:21:21.343 5.7%627495 0.080 7.779 27.116
hiswrite/artcncl00:00:01.037 0.0%29 0.000 35.759 291.000
idle19:38:14.641 81.8%42938595 0.451 1.646 26.987
nntp read00:20:42.845 1.4%52659366 0.014 0.024 0.039
overview write00:00:04.713 0.0%626737 0.000 0.008 0.035
perl filter01:13:51.689 5.1%627495 3.514 7.063 9.537
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:01:38.739 0.1%1319294 0.039 0.075 0.156
TOTAL: 23:59:53.92723:40:50.522 98.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.239 0.0%65826 0.000 0.004 0.111
article prepare00:00:00.007 0.0%17384 0.000 0.000 0.125
article read00:00:00.404 0.0%4208 0.000 0.096 1.000
backlog stats00:00:00.169 0.0%306340 0.000 0.001 0.014
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.226 0.0%198415 0.000 0.011 0.057
data write00:00:07.652 0.0%132958 0.000 0.058 9.000
idle24:00:11.834100.0%306340 0.000 282.078 19095.000
status file00:00:02.146 0.0%193 0.000 11.119 215.500
TOTAL: 24:00:31.87924:00:24.677100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:48:03.418 99.8%4421 0.000 3095.096450027.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.382 0.0%10808 0.000 0.035 3.889
readart00:00:01.837 0.0%561 0.000 3.275 42.692
TOTAL: 03:48:24.55403:48:05.637 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 290 627007 624220 320 2467 99%142:28:23
2news.nask.pl 2 15979 2504 12654 821 15%23:21:08
3localhost 16 15 15 0 0 100%00:00:00
4news.icm.edu.pl 47 225 10 209 6 4%16:32:39
TOTAL: 4 355 643226 626749 13183 3294 97%182:22:10
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl155.1 GB8.6 MB35.5 MB155.2 GB 99%259.6 KB
2news.nask.pl10.2 MB2.1 MB2.1 MB14.4 MB 70%4.4 KB
3news.icm.edu.pl405.0 KB8.2 KB110.8 KB524.1 KB 77%32.8 KB
4localhost31.8 KB0.0 KB0.0 KB31.8 KB100%2.1 KB
TOTAL: 4155.1 GB10.7 MB37.7 MB155.2 GB 99%258.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 9 04:15:03 - 04:59:59 38008 6.1% 14.0910.3 GB 6.6%4010.76
Apr 9 05:00:00 - 05:59:59 46483 7.4% 12.9113.1 GB 8.4%3804.75
Apr 9 06:00:00 - 06:59:59 43763 7.0% 12.1612.7 GB 8.2%3698.90
Apr 9 07:00:00 - 07:59:59 43070 6.9% 11.9612.7 GB 8.2%3703.02
Apr 9 08:00:00 - 08:59:59 40461 6.5% 11.2411.4 GB 7.3%3314.74
Apr 9 09:00:00 - 09:59:59 10503 1.7% 2.921.7 GB 1.1% 495.85
Apr 9 10:00:00 - 10:59:59 12231 2.0% 3.401.8 GB 1.2% 525.56
Apr 9 11:00:00 - 11:59:59 10283 1.6% 2.862.0 GB 1.3% 570.43
Apr 9 12:00:00 - 12:59:59 10791 1.7% 3.001.6 GB 1.0% 452.24
Apr 9 13:00:00 - 13:59:59 13358 2.1% 3.711.7 GB 1.1% 487.08
Apr 9 14:00:00 - 14:59:59 12319 2.0% 3.421.6 GB 1.0% 463.54
Apr 9 15:00:00 - 15:59:59 13986 2.2% 3.882.2 GB 1.4% 626.24
Apr 9 16:00:00 - 16:59:59 12598 2.0% 3.501.9 GB 1.2% 549.67
Apr 9 17:00:00 - 17:59:59 14085 2.2% 3.912.0 GB 1.3% 582.42
Apr 9 18:00:00 - 18:59:59 16012 2.6% 4.452.2 GB 1.4% 628.69
Apr 9 19:00:00 - 19:59:59 13799 2.2% 3.831.6 GB 1.0% 457.52
Apr 9 20:00:00 - 20:59:59 11037 1.8% 3.071.3 GB 0.8% 373.33
Apr 9 21:00:00 - 21:59:59 10504 1.7% 2.921.2 GB 0.8% 348.00
Apr 9 22:00:00 - 22:59:59 11140 1.8% 3.091.6 GB 1.0% 456.07
Apr 9 23:00:00 - 23:59:59 25932 4.1% 7.206.3 GB 4.0%1823.36
Apr 10 00:00:00 - 00:59:59 50606 8.1% 14.0615.2 GB 9.8%4415.86
Apr 10 01:00:00 - 01:59:59 55621 8.9% 15.4516.2 GB 10.4%4714.43
Apr 10 02:00:00 - 02:59:59 60652 9.7% 16.8517.7 GB 11.4%5160.22
Apr 10 03:00:00 - 03:59:59 36383 5.8% 10.1111.1 GB 7.2%3245.90
Apr 10 04:00:00 - 04:15:01 13552 2.2% 15.044.6 GB 2.9%5329.52
TOTAL: 23:59:58 627177 100.0% 7.26155.3 GB 100.0%1884.89
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 2676 361 0 1736 10 0 0 0 569
2news.nask.pl 821 9 0 794 11 0 0 0 7
3news.icm.edu.pl 6 0 0 1 0 0 0 0 5
TOTAL: 3 3503 370 0 2531 21 0 0 0 581

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 195
it.tlc.cellulari.android 99
de.comp.office-pakete.ms-office.excel 14
it.comp.os.win.windows8 12
uk.rec.cycling.moderated 8
de.comp.lang.php 7
comp.mobile.android 7
comp.sys.raspberry-pi 6
de.rec.sf.startrek 5
comp.mobile.ipad 3
hr.alt.cellular.gsm.iphone 3
alt.sex.telephones 2
it.comp.os.linux.ubuntu 2
hr.rec.glazba.hifi 2
it.comp.os.win.windows7 2
nl.comp.os.linux.techniek 1
hr.ponuda.hardver.komponente 1
hr.ponuda.hardver.konfiguracije 1
TOTAL: 18 370

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

GroupsCount
pl.praca.oferowana 17
pl.sci.historia 2
bit.listserv.catholic 1
pl.sci.matematyka 1
TOTAL: 4 21

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 358
EMP (md5) 6
HTML post 3
TOTAL: 3 367

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 66549 1099 64601 169 0 0 1%24:00:56
2icm 38531 929 24888 2063 0 14 2%23:59:17
3nask 21815 68 14311 1 0 1 0%23:58:14
4poznan 3185 4 2281 7 0 0 0%23:59:27
5okapi 0 0 0 0 0 2512 0%24:00:01
TOTAL: 5 130080 2100 106081 2240 0 2527 1%119:57:55
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm4.1 MB361.2 MB365.4 MB4.3 KB/s125.1 KB23:59:17
2panorama3.6 MB1.3 MB4.9 MB0.1 KB/s4.0 KB24:00:56
3nask351.2 KB5.7 KB356.9 KB0.0 KB/s5.2 KB23:58:14
4poznan9.9 KB11.2 KB21.1 KB0.0 KB/s1.9 KB23:59:27
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 58.1 MB362.6 MB370.7 MB0.9 KB/s87.5 KB119:57:55
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-skrzep2.cm.p.lodz.pl 288 418823.5 KB 288 0 000:00:07
2pc-212-51-218-225.p.lodz.pl 13 55130.2 KB 8 0 003:29:19
3web.man.lodz.pl 287 4842.1 KB 21 0 000:00:26
4lze200.lze.lodz.pl 4 4074.2 KB 6 0 000:17:17
5isvcs01.man.lodz.pl 15 00.0 KB 0 15 000:00:01
TOTAL: 5 607 5611.0 MB 323 15 003:48:24

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 418823.5 KB 288 0 000:00:07
2*.p.lodz.pl 13 55130.2 KB 8 0 003:29:19
3*.man.lodz.pl 686 4842.1 KB 21 15 000:00:32
4*.lze.lodz.pl 4 4074.2 KB 6 0 000:17:17
5*.elsnet.pl 2 00.0 KB 0 0 000:00:44
6unresolved 2 00.0 KB 0 0 000:00:20
7*.toya.net.pl 28 00.0 KB 0 0 000:00:01
TOTAL: 71023 5611.0 MB 323 15 003:48:24

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-212-51-218-225.p.lodz.pl 0.038 0.229 0.00003:29:19
lze200.lze.lodz.pl 0.028 0.091 0.00000:17:17
host227.elsnet.pl 0.003 0.038 0.00000:00:44
web.man.lodz.pl 1.083 5.460 0.00000:00:26
50.34.211.225 0.011 0.036 0.00000:00:20
pc-skrzep2.cm.p.lodz.pl 1.040 5.087 0.00000:00:07
mon.man.lodz.pl 1.044 4.787 0.00000:00:03
staticline41435.toya.net.pl 0.094 0.484 0.00000:00:01
david.man.lodz.pl 0.379 1.605 0.00000:00:01
isvcs01.man.lodz.pl 0.138 0.237 0.00000:00:01
? 0.000 0.018 0.00000:00:00
TOTAL: 11 3.858 18.072 0.00003:48:24

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 28
host227.elsnet.pl 2
50.34.211.225 2
TOTAL: 5 416

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
pc-212-51-218-225.p.lodz.pl 4 1
TOTAL: 1 4 1

Newsgroup request counts (by category):

CategoryCountPct
1lodman 418 74.5%
2pl 143 25.5%
TOTAL: 2 561100.0%

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

NewsgroupCount
1lodman.info 418
2pl.comp.pecet 48
3pl.misc.kolej 47
4pl.misc.telefonia.gsm 24
5pl.misc.elektronika 8
6pl.comp.os.linux 7
7pl.rec.kuchnia 6
8pl.comp.os.ms-windows.winnt 3
TOTAL: 8 561