Daily Usenet report

Sep 10 04:15:02 -- Sep 11 04:15:01

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Sep 10 08:47:12 newsfeed nnrpd[3642]: SERVER perl filter not defined
Sep 10 09:01:25 newsfeed nnrpd[4106]: SERVER perl filter not defined
Sep 10 11:29:20 newsfeed nnrpd[9251]: SERVER perl filter not defined
Sep 10 13:50:52 newsfeed nnrpd[14176]: SERVER perl filter not defined
Sep 10 15:06:56 newsfeed nnrpd[16870]: SERVER perl filter not defined
Sep 10 15:08:01 newsfeed nnrpd[16871]: SERVER perl filter not defined
Sep 10 15:09:00 newsfeed nnrpd[16874]: SERVER perl filter not defined
Sep 10 15:10:29 newsfeed nnrpd[16952]: SERVER perl filter not defined
Sep 10 16:57:38 newsfeed nnrpd[20666]: SERVER perl filter not defined
Sep 10 19:25:35 newsfeed nnrpd[25859]: SERVER perl filter not defined
Sep 10 19:43:08 newsfeed nnrpd[26459]: SERVER perl filter not defined
Sep 10 20:24:43 newsfeed nnrpd[27866]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2518536 97.1%290.9 MB 96.7%
innfeed 47172 1.8%5.6 MB 1.9%
innd 21468 0.8%3.7 MB 1.2%
nnrpd 5458 0.2%595.0 KB 0.2%
TOTAL: 42592634 100.0%300.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2511918 98.1%
Negative hits 31180 1.2%
Positive hits 18483 0.7%
Cache misses 117 0.0%
TOTAL: 4 2561698 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:03.479 0.0%238 0.000 14.618 685.000
article cleanup00:00:28.972 0.0%2517121 0.003 0.012 0.024
article logging00:00:59.521 0.1%2517617 0.012 0.024 0.400
article parse00:50:31.584 3.5%165831726 0.011 0.018 0.049
article write00:31:53.713 2.2%2511644 0.273 0.762 4.144
artlog/artcncl00:00:00.005 0.0%238 0.000 0.021 1.000
artlog/artparse00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:01:40.381 0.1%181766707 0.000 0.001 0.002
hisgrep/artcncl00:00:00.269 0.0%200 0.000 1.345 10.333
hishave/artcncl00:00:00.126 0.0%238 0.000 0.529 37.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:24:03.207 1.7%2562995 0.063 0.563 11.407
history sync00:00:00.007 0.0%296 0.000 0.024 1.000
history write00:44:02.349 3.1%2513310 0.153 1.051 26.855
hiswrite/artcncl00:00:00.043 0.0%38 0.000 1.132 12.000
idle16:00:30.221 66.7%141216932 0.280 0.408 3.922
nntp read00:41:44.595 2.9%163935606 0.010 0.015 0.025
overview write00:00:11.823 0.0%2511644 0.000 0.005 0.014
perl filter03:59:33.214 16.6%2513307 3.175 5.719 7.803
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:59.690 0.3%5106620 0.030 0.047 0.069
TOTAL: 23:59:20.45023:19:43.199 97.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.358 0.0%148389 0.000 0.002 0.071
article prepare00:00:00.048 0.0%161382 0.000 0.000 0.036
article read00:01:08.247 0.1%40283 0.000 1.694 206.750
backlog stats00:00:00.256 0.0%416037 0.000 0.001 0.013
callbacks00:00:00.000 0.0%18 0.000 0.000 0.000
data read00:00:02.375 0.0%238002 0.000 0.010 0.069
data write00:00:17.957 0.0%159395 0.000 0.113 5.496
idle23:57:50.829 99.9%416037 61.977 207.363 931.746
status file00:00:09.736 0.0%16050 0.000 0.607 5.083
TOTAL: 23:59:42.22523:59:29.806100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle07:35:18.594 99.9%78071 0.000 349.920600130.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.377 0.0%157188 0.000 0.015 1.333
readart00:00:01.202 0.0%133 0.000 9.038 24.362
TOTAL: 07:35:38.43507:35:22.173 99.9%----

Control commands to INND:

CommandNumber
L 1
flush 24
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 190

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 1037 25130922508010 453 4629 99%288:34:28
2news.nask.pl 2 18951 4217 14110 624 22%24:42:02
3news.icm.edu.pl 39 489 37 226 226 7%19:07:55
4localhost 13 12 12 0 0 100%00:00:00
TOTAL: 4 1091 25325442512276 14789 5479 99%332:24:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl749.8 GB12.1 MB92.5 MB749.9 GB 99%313.0 KB
2news.nask.pl14.6 MB1.7 MB1.8 MB18.1 MB 80%3.8 KB
3news.icm.edu.pl829.7 KB85.7 KB22.3 MB23.2 MB 3%90.4 KB
4localhost18.4 KB0.0 KB0.0 KB18.4 KB100%1.5 KB
TOTAL: 4749.9 GB13.9 MB116.7 MB750.0 GB 99%312.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 10 04:15:02 - 04:59:59 62302 2.5% 23.0918.1 GB 2.4%7025.27
Sep 10 05:00:00 - 05:59:59 115528 4.6% 32.0930.9 GB 4.1%8990.83
Sep 10 06:00:00 - 06:59:59 101278 4.0% 28.1329.0 GB 3.9%8460.05
Sep 10 07:00:00 - 07:59:59 94188 3.7% 26.1630.1 GB 4.0%8770.20
Sep 10 08:00:00 - 08:59:59 81279 3.2% 22.5825.9 GB 3.5%7556.88
Sep 10 09:00:00 - 09:59:59 98037 3.9% 27.2330.3 GB 4.0%8835.21
Sep 10 10:00:00 - 10:59:59 102078 4.1% 28.3633.1 GB 4.4%9654.97
Sep 10 11:00:00 - 11:59:59 118288 4.7% 32.8633.8 GB 4.5%9837.10
Sep 10 12:00:00 - 12:59:59 117058 4.7% 32.5233.7 GB 4.5%9807.13
Sep 10 13:00:00 - 13:59:59 104497 4.2% 29.0333.9 GB 4.5%9868.60
Sep 10 14:00:00 - 14:59:59 94831 3.8% 26.3432.1 GB 4.3%9343.79
Sep 10 15:00:00 - 15:59:59 101834 4.1% 28.2933.2 GB 4.4%9672.62
Sep 10 16:00:00 - 16:59:59 116309 4.6% 32.3134.9 GB 4.7%10161.92
Sep 10 17:00:00 - 17:59:59 104074 4.1% 28.9130.6 GB 4.1%8924.62
Sep 10 18:00:00 - 18:59:59 87173 3.5% 24.2127.1 GB 3.6%7890.70
Sep 10 19:00:00 - 19:59:59 87330 3.5% 24.2627.7 GB 3.7%8072.82
Sep 10 20:00:00 - 20:59:59 98493 3.9% 27.3632.0 GB 4.3%9324.20
Sep 10 21:00:00 - 21:59:59 80944 3.2% 22.4825.9 GB 3.5%7551.23
Sep 10 22:00:00 - 22:59:59 133659 5.3% 37.1336.3 GB 4.8%10578.26
Sep 10 23:00:00 - 23:59:59 146094 5.8% 40.5838.2 GB 5.1%11114.94
Sep 11 00:00:00 - 00:59:59 102397 4.1% 28.4427.8 GB 3.7%8097.66
Sep 11 01:00:00 - 01:59:59 146168 5.8% 40.6038.3 GB 5.1%11163.30
Sep 11 02:00:00 - 02:59:59 99120 3.9% 27.5329.8 GB 4.0%8692.55
Sep 11 03:00:00 - 03:59:59 101376 4.0% 28.1630.6 GB 4.1%8920.00
Sep 11 04:00:00 - 04:15:01 17988 0.7% 19.965.6 GB 0.7%6471.92
TOTAL: 23:59:59 2512323 100.0% 29.08749.0 GB 100.0%9090.71
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 5060 263 0 3207 1 0 0 0 1589
2news.nask.pl 689 13 0 600 10 0 0 0 66
3news.icm.edu.pl 226 0 0 6 0 0 0 0 220
TOTAL: 3 5975 276 0 3813 11 0 0 0 1875

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 82
it.comp.os.win.windows10 68
comp.mobile.ipad 42
it.tlc.cellulari.android 38
uk.rec.cycling.moderated 9
it.comp.os.win.windows7 8
comp.sys.raspberry-pi 5
de.comp.lang.php 4
comp.sys.mac.vintage 4
uk.net.providers.gradwell 3
hr.alt.cellular.gsm.android 2
hr.alt.cellular.gsm.iphone 2
de.comp.office-pakete.ms-office.excel 2
alt.sex.telephones 2
hr.ponuda.hardver.komponente 1
it.comp.os.linux.ubuntu 1
hr.ponuda.hardver.periferije 1
comp.mobile.android 1
de.comp.lang.perl 1
TOTAL: 19 276

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

GroupsCount
pl.praca.oferowana 11
TOTAL: 1 11

INND Perl filter [Top 20]:

ReasonCount
EMP (fsl) 998
Binary in non-binary group 290
EMP (md5) 74
HTML post 12
Scoring filter (8) 1
Scoring filter (9) 1
TOTAL: 6 1376

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 74061 24784 24031 11285 1 61 33%23:52:10
2panorama 73917 2357 44141 778 40 101007 3%23:59:54
3poznan 6275 63 4020 30 0 0 1%24:01:54
4nask 0 0 0 0 0 14792 0%24:00:01
5okapi 0 0 0 0 0 2376 0%24:00:01
TOTAL: 5 154253 27204 72192 12093 41 118236 17%119:54:00
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm3.7 GB2.4 GB6.1 GB74.4 KB/s177.2 KB23:52:10
2panorama11.4 MB3.4 MB14.8 MB0.2 KB/s4.8 KB23:59:54
3poznan229.2 KB99.4 KB328.6 KB0.0 KB/s3.5 KB24:01:54
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 53.7 GB2.4 GB6.1 GB14.8 KB/s163.0 KB119:54:00
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama3.8 MB
okapi488.4 KB
TOTAL: 24.3 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-212-51-218-225.p.lodz.pl 18 68135.7 KB 10 0 004:20:36
2web.man.lodz.pl 287 3828.0 KB 18 0 000:00:29
3auriga.rz.izeto.pl 2 2740.3 KB 2 0 000:01:41
4isvcs01.man.lodz.pl 12 00.0 KB 0 12 000:00:00
TOTAL: 4 319 133204.0 KB 30 12 007:35:38

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.p.lodz.pl 18 68135.7 KB 10 0 004:20:36
2*.man.lodz.pl 683 3828.0 KB 18 12 000:00:33
3*.rz.izeto.pl 2 2740.3 KB 2 0 000:01:41
4*.toya.net.pl 116 00.0 KB 0 0 000:00:05
5*.elsnet.pl 6 00.0 KB 0 0 000:00:18
6unresolved 2 00.0 KB 0 0 003:12:22
TOTAL: 6 827 133204.0 KB 30 12 007:35:38

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-212-51-218-225.p.lodz.pl 0.069 0.254 0.00004:20:36
185.48.192.92 3.392 4.059 0.00003:12:22
auriga.rz.izeto.pl 0.016 0.020 0.00000:01:41
web.man.lodz.pl 0.736 3.860 0.00000:00:29
host227.elsnet.pl 0.014 0.081 0.00000:00:18
staticline41435.toya.net.pl 0.313 1.641 0.00000:00:05
mon.man.lodz.pl 0.818 4.094 0.00000:00:02
isvcs01.man.lodz.pl 0.059 0.201 0.00000:00:00
david.man.lodz.pl 0.257 1.302 0.00000:00:00
? 0.000 0.014 0.00000:00:00
TOTAL: 10 5.674 15.526 0.00007:35:38

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
staticline41435.toya.net.pl 116
david.man.lodz.pl 96
host227.elsnet.pl 6
185.48.192.92 2
TOTAL: 5 508

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 3 0
TOTAL: 1 3 0

Newsgroup request counts (by category):

CategoryCountPct
1pl 106 79.7%
2lodman 27 20.3%
TOTAL: 2 133100.0%

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

NewsgroupCount
1pl.misc.elektronika 39
2pl.misc.kolej 29
3lodman.info 27
4pl.comp.pecet 24
5pl.comp.os.ms-windows.winnt 12
6pl.internet.polip 2
TOTAL: 6 133
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>