Daily Usenet report

May 4 04:15:02 -- May 5 04:15:03

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

May 4 08:59:36 newsfeed nnrpd[4422]: SERVER perl filter not defined
May 4 09:05:48 newsfeed nnrpd[4614]: SERVER perl filter not defined
May 4 09:21:22 newsfeed nnrpd[5251]: SERVER perl filter not defined
May 4 10:11:25 newsfeed overchan[25409]: input line too long, skipping
May 4 10:19:50 newsfeed overchan[25409]: input line too long, skipping
May 4 10:31:39 newsfeed nnrpd[7836]: SERVER perl filter not defined
May 4 10:42:39 newsfeed nnrpd[8204]: SERVER perl filter not defined
May 4 10:59:07 newsfeed overchan[25409]: input line too long, skipping
May 4 11:20:25 newsfeed nnrpd[9688]: SERVER perl filter not defined
May 4 14:39:23 newsfeed overchan[25409]: input line too long, skipping
May 4 15:55:23 newsfeed overchan[25409]: input line too long, skipping
May 4 17:07:37 newsfeed overchan[25409]: input line too long, skipping
May 4 18:30:42 newsfeed overchan[25409]: input line too long, skipping
May 4 18:35:08 newsfeed overchan[25409]: input line too long, skipping
May 4 22:53:21 newsfeed overchan[25409]: input line too long, skipping
May 4 23:10:01 newsfeed overchan[25409]: input line too long, skipping
May 5 03:21:34 newsfeed overchan[25409]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn2733787 98.0%312.2 MB 97.7%
innfeed 28998 1.0%3.4 MB 1.1%
innd 21625 0.8%3.4 MB 1.1%
nnrpd 4852 0.2%514.0 KB 0.2%
overchan 12 0.0%1.9 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 62789275 100.0%319.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2719316 96.4%
Negative hits 92216 3.3%
Positive hits 10332 0.4%
Cache misses 89 0.0%
TOTAL: 4 2821953 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.618 0.0%169 0.000 9.574 196.000
article cleanup00:00:38.715 0.0%2732584 0.009 0.014 0.018
article logging00:02:08.062 0.1%2733059 0.032 0.047 0.083
article parse00:48:24.454 3.4%79798366 0.019 0.036 0.048
article write00:20:25.399 1.4%2726880 0.219 0.449 0.928
artlog/artcncl00:00:00.008 0.0%159 0.000 0.050 0.500
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:03:56.962 0.3%94403017 0.001 0.003 0.004
hisgrep/artcncl00:00:00.155 0.0%162 0.000 0.957 14.000
hishave/artcncl00:00:00.149 0.0%169 0.000 0.882 8.429
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup01:09:49.745 4.8%2833443 0.043 1.479 9.704
history sync00:00:00.009 0.0%290 0.000 0.031 0.500
history write00:57:07.731 4.0%2729972 0.313 1.256 3.730
hiswrite/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
idle14:10:02.839 59.0%60575156 0.510 0.842 3.213
nntp read01:05:00.997 4.5%77747775 0.030 0.050 0.075
overview write00:00:15.842 0.0%2726880 0.003 0.006 0.008
perl filter04:48:11.098 20.0%2729971 4.149 6.334 8.801
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:05:52.747 0.4%5472632 0.046 0.064 0.089
TOTAL: 24:00:02.84823:31:56.530 98.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.121 0.0%42834 0.000 0.003 0.016
article prepare00:00:00.000 0.0%4610 0.000 0.000 0.000
article read00:00:28.423 0.0%1165 0.000 24.397 268.167
backlog stats00:00:00.138 0.0%138863 0.000 0.001 0.004
callbacks00:00:00.000 0.0%14 0.000 0.000 0.000
data read00:00:01.436 0.0%74233 0.004 0.019 0.045
data write00:00:03.439 0.0%55516 0.013 0.062 0.119
idle23:53:54.308 99.9%138863 321.012 619.563 1287.704
status file00:00:09.020 0.0%9969 0.459 0.905 1.574
TOTAL: 23:54:49.74023:54:36.885100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:07:30.468 98.4%14657 0.000 521.967450111.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.579 0.0%29953 0.000 0.086 60.545
readart00:01:46.270 1.4%11518 0.000 9.226 9.235
TOTAL: 02:09:34.87002:09:19.317 99.8%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1112 27285942719373 5629 3592 99%405:26:29
2news.nask.pl 3 12152 8194 1871 2087 67%24:04:32
3news.icm.edu.pl 47 263 15 235 13 5%15:23:55
4localhost 7 6 6 0 0 100%00:00:00
TOTAL: 4 1169 27410152727588 7735 5692 99%444:54:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl693.5 GB18.9 MB195.5 MB693.8 GB 99%267.2 KB
2news.nask.pl29.7 MB1.1 MB18.9 MB49.7 MB 59%5.0 KB
3news.icm.edu.pl267.1 KB0.0 KB477.9 KB745.0 KB 35%26.6 KB
4localhost8.3 KB0.0 KB0.0 KB8.3 KB100%1.4 KB
TOTAL: 4693.6 GB20.0 MB214.8 MB693.8 GB 99%266.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 4 04:15:02 - 04:59:59 51341 1.9% 19.0319.6 GB 2.8%7627.74
May 4 05:00:00 - 05:59:59 71501 2.6% 19.8626.5 GB 3.8%7710.58
May 4 06:00:00 - 06:59:59 89198 3.3% 24.7832.9 GB 4.7%9575.39
May 4 07:00:00 - 07:59:59 105521 3.9% 29.3136.3 GB 5.2%10564.90
May 4 08:00:00 - 08:59:59 82126 3.0% 22.8127.7 GB 4.0%8068.54
May 4 09:00:00 - 09:59:59 68834 2.5% 19.1223.2 GB 3.3%6771.17
May 4 10:00:00 - 10:59:59 98087 3.6% 27.2531.0 GB 4.5%9042.25
May 4 11:00:00 - 11:59:59 160628 5.9% 44.6233.3 GB 4.8%9708.84
May 4 12:00:00 - 12:59:59 144465 5.3% 40.1327.2 GB 3.9%7913.72
May 4 13:00:00 - 13:59:59 180583 6.6% 50.1632.0 GB 4.6%9310.72
May 4 14:00:00 - 14:59:59 93312 3.4% 25.9219.5 GB 2.8%5673.17
May 4 15:00:00 - 15:59:59 71785 2.6% 19.9426.0 GB 3.7%7569.75
May 4 16:00:00 - 16:59:59 123949 4.5% 34.4326.7 GB 3.8%7766.44
May 4 17:00:00 - 17:59:59 80458 2.9% 22.3520.6 GB 3.0%6001.26
May 4 18:00:00 - 18:59:59 98136 3.6% 27.2626.4 GB 3.8%7677.08
May 4 19:00:00 - 19:59:59 145645 5.3% 40.4638.9 GB 5.6%11321.84
May 4 20:00:00 - 20:59:59 152427 5.6% 42.3439.2 GB 5.6%11425.71
May 4 21:00:00 - 21:59:59 166106 6.1% 46.1427.0 GB 3.9%7867.32
May 4 22:00:00 - 22:59:59 184210 6.8% 51.1730.6 GB 4.4%8922.52
May 4 23:00:00 - 23:59:59 131882 4.8% 36.6332.3 GB 4.6%9397.61
May 5 00:00:00 - 00:59:59 98178 3.6% 27.2724.1 GB 3.5%7026.92
May 5 01:00:00 - 01:59:59 114577 4.2% 31.8329.6 GB 4.3%8618.71
May 5 02:00:00 - 02:59:59 90933 3.3% 25.2629.0 GB 4.2%8459.49
May 5 03:00:00 - 03:59:59 103468 3.8% 28.7428.3 GB 4.1%8248.49
May 5 04:00:00 - 04:15:03 20086 0.7% 22.246.6 GB 1.0%7696.16
TOTAL: 24:00:01 2727436 100.0% 31.57694.5 GB 100.0%8428.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 3913 210 0 2360 3 0 0 0 1340
2news.nask.pl 2268 9 0 267 1 0 0 0 1991
3news.icm.edu.pl 12 0 0 0 0 0 0 0 12
TOTAL: 3 6193 219 0 2627 4 0 0 0 3343

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 129
it.comp.os.win.windows10 42
it.tlc.cellulari.android 16
it.comp.os.win.windows7 11
uk.rec.cycling.moderated 9
de.rec.sf.startrek 5
de.comp.lang.php 3
comp.mobile.android 3
comp.sys.raspberry-pi 1
TOTAL: 9 219

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

GroupsCount
pl.praca.oferowana 4
TOTAL: 1 4

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 1594
Binary in non-binary group 1152
Scoring filter (8) 54
Poison newsgroup 20
Scoring filter (9) 18
EMP (phl) 9
HTML post 7
Scoring filter (10) 3
EMP (fsl) 3
Scoring filter (11) 2
Scoring filter (18) 1
MID-Bot 1
TOTAL: 12 2864

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 309
news.nask.pl 169
TOTAL: 2 478
TOTAL: 1 478

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 25335 478 8173 127 27 34156 1%23:59:58
2poznan 13161 59 8078 11 0 2 0%23:59:58
3icm 24066 32 17104 4 0 2 0%23:59:53
4nask 4152 5 2836 0 0 0 0%23:59:49
5okapi 0 0 0 0 0 909 0%23:57:51
TOTAL: 5 66714 574 36191 142 27 35069 0%119:57:29
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm4.2 MB10.7 KB4.2 MB0.1 KB/s120.1 KB23:59:53
2panorama1.3 MB437.7 KB1.7 MB0.0 KB/s2.9 KB23:59:58
3poznan323.1 KB53.1 KB376.1 KB0.0 KB/s5.4 KB23:59:58
4nask8.6 KB0.0 KB8.6 KB0.0 KB/s1.7 KB23:59:49
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:51
TOTAL: 55.8 MB501.4 KB6.3 MB0.0 KB/s9.0 KB119:57:29
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 108.5 KB 5 0 000:00:27
20890788407.static.corbina.ru 3 79.5 KB 1 0 000:12:53
3176.105.135.22 2 11.5 KB 1 0 001:00:27
4isvcs01.man.lodz.pl 6 00.0 KB 0 6 000:00:00
TOTAL: 4 299 1819.5 KB 7 6 002:09:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 678 108.5 KB 5 6 000:00:32
2*.static.corbina.ru 3 79.5 KB 1 0 000:12:53
3unresolved 2 11.5 KB 1 0 001:00:27
4*.neoplus.adsl.tpnet.pl 2 00.0 KB 0 0 000:00:01
5*.ip25.fastwebnet.it 5 00.0 KB 0 0 000:55:38
TOTAL: 5 690 1819.5 KB 7 6 002:09:33

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
176.105.135.22 0.024 0.044 0.00001:00:27
93-62-250-82.ip25.fastwebnet.it 0.096 0.128 0.00000:55:38
0890788407.static.corbina.ru 1.208 3.072 0.00000:12:53
web.man.lodz.pl 1.696 6.036 0.00000:00:27
mon.man.lodz.pl 1.416 5.688 0.00000:00:03
aabw124.neoplus.adsl.tpnet.pl 0.052 0.088 0.00000:00:01
david.man.lodz.pl 0.492 1.856 0.00000:00:01
isvcs01.man.lodz.pl 0.056 0.156 0.00000:00:00
TOTAL: 8 5.040 17.068 0.00002:09:33

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
93-62-250-82.ip25.fastwebnet.it 5
aabw124.neoplus.adsl.tpnet.pl 2
TOTAL: 4 391

NNRP client timeouts [Top 20]:

SystemConnPeer
176.105.135.22 2 0
93-62-250-82.ip25.fastwebnet.it 1 0
TOTAL: 2 3 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 10 55.6%
2lodman 8 44.4%
TOTAL: 2 18100.0%

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

NewsgroupCount
1lodman.info 8
2pl.comp.pecet 6
3pl.comp.os.ms-windows.winnt 4
TOTAL: 3 18
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>