Daily Usenet report

May 14 04:15:02 -- May 15 04:15:02

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

May 14 08:38:34 newsfeed nnrpd[13575]: SERVER perl filter not defined
May 14 09:00:29 newsfeed nnrpd[14351]: SERVER perl filter not defined
May 14 09:01:04 newsfeed nnrpd[14361]: SERVER perl filter not defined
May 14 10:00:25 newsfeed nnrpd[16411]: SERVER perl filter not defined
May 14 10:55:40 newsfeed nnrpd[18783]: SERVER perl filter not defined
May 14 11:01:25 newsfeed nnrpd[18913]: SERVER perl filter not defined
May 14 14:11:48 newsfeed nnrpd[25436]: SERVER perl filter not defined
May 14 14:51:24 newsfeed nnrpd[26788]: SERVER perl filter not defined
May 14 14:54:11 newsfeed nnrpd[26818]: SERVER perl filter not defined
May 14 14:58:56 newsfeed nnrpd[27058]: SERVER perl filter not defined
May 14 14:59:49 newsfeed nnrpd[27060]: SERVER perl filter not defined
May 14 15:01:34 newsfeed nnrpd[27161]: SERVER perl filter not defined
May 14 15:02:39 newsfeed nnrpd[27163]: SERVER perl filter not defined
May 14 17:32:45 newsfeed nnrpd[32303]: SERVER perl filter not defined
May 14 19:54:04 newsfeed nnrpd[4784]: SERVER perl filter not defined
May 14 22:00:08 newsfeed nnrpd[9240]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2159217 98.5%245.3 MB 98.1%
innd 18217 0.8%3.0 MB 1.2%
innfeed 7727 0.4%1.1 MB 0.5%
nnrpd 7182 0.3%783.8 KB 0.3%
TOTAL: 42192343 100.0%250.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2153675 98.2%
Negative hits 21577 1.0%
Positive hits 17201 0.8%
Cache misses 202 0.0%
TOTAL: 4 2192655 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.199 0.0%326 0.000 3.678 59.000
article cleanup00:00:24.486 0.0%2158620 0.003 0.011 0.024
article logging00:01:03.542 0.1%2158805 0.017 0.029 0.171
article parse00:47:12.253 3.3%102593529 0.017 0.028 0.054
article write00:17:34.777 1.2%2154227 0.324 0.490 1.027
artlog/artcncl00:00:00.004 0.0%321 0.000 0.012 1.000
data move00:01:23.185 0.1%115795654 0.000 0.001 0.002
hisgrep/artcncl00:00:00.190 0.0%279 0.000 0.681 15.000
hishave/artcncl00:00:00.034 0.0%326 0.000 0.104 16.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:08:31.999 0.6%2193660 0.024 0.233 5.203
history sync00:00:00.025 0.0%291 0.000 0.086 1.000
history write00:13:59.412 1.0%2154944 0.105 0.390 6.046
hiswrite/artcncl00:00:00.005 0.0%47 0.000 0.106 0.500
idle16:38:57.261 69.4%85670288 0.352 0.700 5.721
nntp read00:42:08.829 2.9%100970825 0.017 0.025 0.033
overview write00:00:13.890 0.0%2154227 0.001 0.006 0.015
perl filter04:37:37.953 19.3%2154944 5.740 7.730 9.936
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:04:14.925 0.3%4338919 0.036 0.059 0.101
TOTAL: 24:00:07.47923:33:23.969 98.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.167 0.0%30489 0.000 0.005 1.000
article prepare00:00:00.005 0.0%21122 0.000 0.000 0.083
article read00:00:00.454 0.0%5096 0.000 0.089 3.727
backlog stats00:00:00.164 0.0%270365 0.000 0.001 0.035
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.783 0.0%152071 0.000 0.012 0.097
data write00:00:04.544 0.0%127965 0.000 0.036 1.000
idle23:59:49.882100.0%270365 0.000 319.531 23376.000
status file00:00:00.154 0.0%194 0.000 0.794 2.000
TOTAL: 24:00:02.98523:59:57.153100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.013 0.0%34 0.382 0.382 0.382
idle04:01:47.705 99.9%6565 0.000 2209.856489612.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.573 0.0%14995 0.000 0.038 5.111
readart00:00:00.106 0.0%492 0.000 0.215 1.846
TOTAL: 04:02:08.10804:01:48.397 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 907 21550322150283 718 4031 99%204:55:59
2news.nask.pl 2 17132 4221 12605 306 24%24:17:04
3news.icm.edu.pl 46 334 34 233 67 10%18:51:39
4localhost 17 16 16 0 0 100%00:00:00
TOTAL: 4 972 21725142154554 13556 4404 99%248:04:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl628.9 GB108.0 MB135.5 MB629.1 GB 99%306.2 KB
2news.nask.pl25.4 MB908.2 KB1.0 MB27.3 MB 93%6.2 KB
3news.icm.edu.pl2.8 MB219.6 KB1.4 MB4.4 MB 63%44.7 KB
4localhost30.7 KB0.0 KB0.0 KB30.7 KB100%1.9 KB
TOTAL: 4628.9 GB109.1 MB137.9 MB629.2 GB 99%305.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 14 04:15:02 - 04:59:59 57841 2.7% 21.4419.9 GB 3.2%7750.16
May 14 05:00:00 - 05:59:59 71216 3.3% 19.7824.9 GB 4.0%7238.96
May 14 06:00:00 - 06:59:59 81341 3.8% 22.5927.0 GB 4.3%7859.55
May 14 07:00:00 - 07:59:59 75171 3.5% 20.8825.8 GB 4.1%7509.24
May 14 08:00:00 - 08:59:59 65567 3.0% 18.2124.1 GB 3.8%7013.11
May 14 09:00:00 - 09:59:59 76113 3.5% 21.1425.7 GB 4.1%7495.93
May 14 10:00:00 - 10:59:59 86671 4.0% 24.0826.1 GB 4.2%7607.69
May 14 11:00:00 - 11:59:59 86300 4.0% 23.9725.9 GB 4.1%7555.57
May 14 12:00:00 - 12:59:59 91497 4.2% 25.4226.0 GB 4.1%7559.80
May 14 13:00:00 - 13:59:59 98223 4.6% 27.2826.9 GB 4.3%7829.03
May 14 14:00:00 - 14:59:59 101050 4.7% 28.0726.4 GB 4.2%7695.45
May 14 15:00:00 - 15:59:59 97461 4.5% 27.0726.1 GB 4.2%7612.87
May 14 16:00:00 - 16:59:59 92538 4.3% 25.7026.9 GB 4.3%7848.49
May 14 17:00:00 - 17:59:59 108049 5.0% 30.0128.4 GB 4.5%8273.13
May 14 18:00:00 - 18:59:59 123566 5.7% 34.3229.1 GB 4.6%8476.61
May 14 19:00:00 - 19:59:59 84157 3.9% 23.3826.3 GB 4.2%7662.03
May 14 20:00:00 - 20:59:59 120048 5.6% 33.3529.8 GB 4.7%8670.10
May 14 21:00:00 - 21:59:59 105092 4.9% 29.1927.6 GB 4.4%8039.77
May 14 22:00:00 - 22:59:59 91339 4.2% 25.3726.8 GB 4.3%7793.40
May 14 23:00:00 - 23:59:59 93089 4.3% 25.8628.3 GB 4.5%8234.60
May 15 00:00:00 - 00:59:59 65008 3.0% 18.0619.0 GB 3.0%5528.02
May 15 01:00:00 - 01:59:59 67251 3.1% 18.6818.9 GB 3.0%5500.50
May 15 02:00:00 - 02:59:59 100493 4.7% 27.9129.1 GB 4.6%8481.06
May 15 03:00:00 - 03:59:59 90536 4.2% 25.1526.1 GB 4.2%7609.93
May 15 04:00:00 - 04:15:02 24702 1.1% 27.397.2 GB 1.2%8427.09
TOTAL: 24:00:00 2154319 100.0% 24.93628.3 GB 100.0%7625.61
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4193 289 0 3415 1 0 0 0 488
2news.nask.pl 317 24 0 255 16 0 0 0 22
3news.icm.edu.pl 67 0 0 6 0 0 0 0 61
TOTAL: 3 4577 313 0 3676 17 0 0 0 571

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 143
it.tlc.cellulari.android 55
de.rec.sf.startrek 29
uk.rec.cycling.moderated 23
comp.mobile.android 18
comp.sys.raspberry-pi 12
comp.mobile.ipad 9
it.comp.os.win.windows7 7
it.comp.os.win.windows8 7
alt.sex.telephones 5
hr.ponuda.hardver.komponente 4
hr.alt.cellular.gsm.iphone 1
TOTAL: 12 313

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

GroupsCount
pl.praca.oferowana 11
pl.sci.historia 5
bit.listserv.catholic 1
TOTAL: 3 17

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 254
EMP (md5) 132
TOTAL: 2 386

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 42645 3210 26894 364 0 1 7%23:59:46
2icm 42757 473 28625 143 1 26 1%24:01:54
3nask 26703 61 13973 974 0 1 0%23:55:11
4poznan 6425 48 4115 11 0 0 0%23:55:11
5okapi 0 0 0 0 0 2344 0%24:00:02
TOTAL: 5 118530 3792 73607 1492 1 2372 3%119:52:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama20.7 MB1.1 MB21.9 MB0.3 KB/s6.3 KB23:59:46
2icm19.2 MB6.5 MB25.7 MB0.3 KB/s42.8 KB24:01:54
3poznan6.6 MB1.2 MB7.8 MB0.1 KB/s134.5 KB23:55:11
4nask408.1 KB229.0 MB229.4 MB2.7 KB/s226.9 KB23:55:11
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:02
TOTAL: 546.9 MB237.8 MB284.7 MB0.7 KB/s55.2 KB119:52:04
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-skrzep2.cm.p.lodz.pl 288 440833.8 KB 288 0 000:00:07
2pc-212-51-218-225.p.lodz.pl 7 3157.2 KB 7 0 002:05:47
3web.man.lodz.pl 288 1816.0 KB 9 0 000:00:31
4dmcs2.p.lodz.pl 7 35.2 KB 2 0 001:50:03
5isvcs01.man.lodz.pl 16 00.0 KB 0 16 000:00:01
TOTAL: 5 606 492912.1 KB 306 16 004:02:07

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 440833.8 KB 288 0 000:00:07
2*.p.lodz.pl 14 3462.3 KB 9 0 003:55:50
3*.man.lodz.pl 688 1816.0 KB 9 16 000:00:37
4*.elsnet.pl 2 00.0 KB 0 0 000:00:24
5unresolved 2 00.0 KB 0 0 000:05:03
6*.toya.net.pl 50 00.0 KB 0 0 000:00:03
TOTAL: 61044 492912.1 KB 306 16 004:02:07

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-212-51-218-225.p.lodz.pl 0.028 0.094 0.00002:05:47
dmcs2.p.lodz.pl 0.020 0.088 0.00001:50:03
185.48.195.96 0.140 0.177 0.00000:05:03
web.man.lodz.pl 1.193 3.270 0.00000:00:31
host227.elsnet.pl 0.010 0.019 0.00000:00:24
pc-skrzep2.cm.p.lodz.pl 1.241 3.399 0.00000:00:07
mon.man.lodz.pl 1.083 3.289 0.00000:00:03
staticline41435.toya.net.pl 0.155 0.574 0.00000:00:03
david.man.lodz.pl 0.352 1.089 0.00000:00:01
isvcs01.man.lodz.pl 0.128 0.217 0.00000:00:01
TOTAL: 10 4.350 12.216 0.00004:02:07

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 50
host227.elsnet.pl 2
185.48.195.96 2
TOTAL: 5 438

NNRP client timeouts [Top 20]:

SystemConnPeer
pc-212-51-218-225.p.lodz.pl 3 0
dmcs2.p.lodz.pl 2 0
TOTAL: 2 5 0

Newsgroup request counts (by category):

CategoryCountPct
1lodman 440 89.4%
2pl 52 10.6%
TOTAL: 2 492100.0%

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

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