Daily Usenet report

May 25 04:15:02 -- May 26 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

May 25 09:19:15 newsfeed overchan[5130]: input line too long, skipping
May 25 10:41:00 newsfeed nnrpd[31604]: SERVER perl filter not defined
May 25 10:53:57 newsfeed nnrpd[32081]: SERVER perl filter not defined
May 25 11:14:46 newsfeed nnrpd[316]: SERVER perl filter not defined
May 25 11:31:50 newsfeed nnrpd[967]: SERVER perl filter not defined
May 25 12:27:56 newsfeed nnrpd[2783]: SERVER perl filter not defined
May 25 15:12:49 newsfeed nnrpd[8436]: SERVER perl filter not defined
May 25 15:13:21 newsfeed nnrpd[8455]: SERVER perl filter not defined
May 25 15:15:03 newsfeed nnrpd[8525]: SERVER perl filter not defined
May 25 15:15:32 newsfeed nnrpd[8528]: SERVER perl filter not defined
May 25 15:35:03 newsfeed nnrpd[9197]: SERVER perl filter not defined
May 25 18:12:32 newsfeed nnrpd[14515]: SERVER perl filter not defined
May 25 20:39:54 newsfeed nnrpd[19526]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn1843216 98.6%211.3 MB 98.2%
innd 16576 0.9%2.7 MB 1.3%
nnrpd 7391 0.4%777.7 KB 0.4%
innfeed 2599 0.1%385.1 KB 0.2%
overchan 1 0.0%0.2 KB 0.0%
TOTAL: 51869783 100.0%215.1 MB100.0%

History cache:

ReasonCount%Count
Do not exist 1837791 97.6%
Negative hits 28329 1.5%
Positive hits 15870 0.8%
Cache misses 161 0.0%
TOTAL: 4 1882151 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.532 0.0%368 0.000 4.163 82.000
article cleanup00:00:22.890 0.0%1843361 0.003 0.012 0.026
article logging00:00:56.835 0.1%1843496 0.016 0.031 0.120
article parse00:50:13.596 3.5%102678564 0.022 0.029 0.070
article write00:19:58.915 1.4%1838705 0.402 0.652 2.213
artlog/artcncl00:00:00.008 0.0%329 0.000 0.024 1.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:03:11.263 0.2%115000799 0.000 0.002 0.005
hisgrep/artcncl00:00:00.324 0.0%313 0.000 1.035 17.000
hishave/artcncl00:00:00.256 0.0%368 0.000 0.696 12.056
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:09:37.713 0.7%1883359 0.028 0.307 6.904
history sync00:00:00.012 0.0%300 0.000 0.040 1.000
history write00:15:19.062 1.1%1839239 0.059 0.500 9.386
hiswrite/artcncl00:00:00.010 0.0%55 0.000 0.182 1.000
idle16:32:13.538 68.9%82792757 0.419 0.719 2.855
nntp read00:48:37.031 3.4%101377680 0.020 0.029 0.048
overview write00:00:11.529 0.0%1838705 0.000 0.006 0.028
perl filter04:34:47.292 19.1%1839238 7.225 8.964 12.689
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:03:38.289 0.3%3718159 0.038 0.059 0.160
TOTAL: 24:00:18.87823:39:10.095 98.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.167 0.0%40740 0.000 0.004 0.143
article prepare00:00:00.001 0.0%18356 0.000 0.000 0.042
article read00:00:00.317 0.0%4469 0.000 0.071 2.500
backlog stats00:00:00.136 0.0%189828 0.000 0.001 0.027
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.617 0.0%107854 0.000 0.015 1.957
data write00:00:03.167 0.0%67545 0.000 0.047 1.024
idle23:59:32.520100.0%189828 30.332 455.004 3455.833
status file00:00:00.272 0.0%258 0.250 1.054 14.000
TOTAL: 23:59:43.84523:59:38.197100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:00.015 0.0%119 0.118 0.126 0.130
idle08:03:37.061 99.9%57856 0.000 501.539450034.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.393 0.0%118165 0.000 0.020 6.333
readart00:00:03.667 0.0%752 0.000 4.876 22.000
TOTAL: 08:04:01.38908:03:43.136 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 911 18386631833651 684 4328 99%226:31:33
2news.nask.pl 2 15581 4883 10418 280 31%23:22:34
3news.icm.edu.pl 46 257 17 188 52 6%14:58:15
4localhost 13 12 12 0 0 100%00:00:00
TOTAL: 4 972 18545131838563 11290 4660 99%264:52:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl653.5 GB17.7 MB38.9 MB653.5 GB 99%372.8 KB
2news.nask.pl25.2 MB677.9 KB805.2 KB26.7 MB 94%5.3 KB
3news.icm.edu.pl496.1 KB22.5 KB695.9 KB1.2 MB 40%17.6 KB
4localhost20.8 KB0.0 KB0.0 KB20.8 KB100%1.7 KB
TOTAL: 4653.5 GB18.3 MB40.4 MB653.6 GB 99%371.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 25 04:15:02 - 04:59:59 60000 3.3% 22.2423.5 GB 3.6%9118.55
May 25 05:00:00 - 05:59:59 74255 4.0% 20.6331.1 GB 4.8%9056.38
May 25 06:00:00 - 06:59:59 65651 3.6% 18.2429.9 GB 4.6%8710.84
May 25 07:00:00 - 07:59:59 70960 3.9% 19.7127.9 GB 4.3%8131.29
May 25 08:00:00 - 08:59:59 67913 3.7% 18.8622.9 GB 3.5%6658.23
May 25 09:00:00 - 09:59:59 55157 3.0% 15.3221.2 GB 3.2%6169.72
May 25 10:00:00 - 10:59:59 61647 3.4% 17.1224.3 GB 3.7%7073.90
May 25 11:00:00 - 11:59:59 74044 4.0% 20.5727.3 GB 4.2%7955.92
May 25 12:00:00 - 12:59:59 68752 3.7% 19.1025.7 GB 3.9%7478.28
May 25 13:00:00 - 13:59:59 72528 3.9% 20.1524.9 GB 3.8%7243.72
May 25 14:00:00 - 14:59:59 102397 5.6% 28.4432.0 GB 4.9%9313.71
May 25 15:00:00 - 15:59:59 97395 5.3% 27.0534.0 GB 5.2%9900.68
May 25 16:00:00 - 16:59:59 91971 5.0% 25.5533.0 GB 5.0%9619.41
May 25 17:00:00 - 17:59:59 96645 5.3% 26.8532.6 GB 5.0%9501.46
May 25 18:00:00 - 18:59:59 91808 5.0% 25.5030.1 GB 4.6%8762.14
May 25 19:00:00 - 19:59:59 103943 5.7% 28.8736.1 GB 5.5%10519.71
May 25 20:00:00 - 20:59:59 85056 4.6% 23.6329.7 GB 4.5%8654.74
May 25 21:00:00 - 21:59:59 44578 2.4% 12.3815.4 GB 2.4%4483.64
May 25 22:00:00 - 22:59:59 46270 2.5% 12.8516.1 GB 2.5%4679.70
May 25 23:00:00 - 23:59:59 44411 2.4% 12.3416.1 GB 2.5%4675.48
May 26 00:00:00 - 00:59:59 77973 4.2% 21.6627.5 GB 4.2%7999.49
May 26 01:00:00 - 01:59:59 101989 5.5% 28.3333.1 GB 5.1%9649.17
May 26 02:00:00 - 02:59:59 88494 4.8% 24.5828.2 GB 4.3%8216.28
May 26 03:00:00 - 03:59:59 83206 4.5% 23.1127.7 GB 4.2%8077.68
May 26 04:00:00 - 04:15:02 11054 0.6% 12.254.0 GB 0.6%4599.49
TOTAL: 24:00:00 1838097 100.0% 21.27654.1 GB 100.0%7938.24
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 4435 189 0 3858 1 0 0 0 387
2news.nask.pl 310 12 0 261 1 0 0 0 36
3news.icm.edu.pl 45 0 0 2 0 0 0 0 43
TOTAL: 3 4790 201 0 4121 2 0 0 0 466

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 136
it.tlc.cellulari.android 25
comp.mobile.android 8
uk.rec.cycling.moderated 7
it.comp.os.win.windows7 5
comp.sys.mac.vintage 4
alt.sex.telephones 3
hr.ponuda.hardver.komponente 2
comp.sys.raspberry-pi 2
hr.rec.glazba.hifi 2
alt.sex.telephone.alt 2
it.comp.os.win.windows8 2
de.comp.lang.php 1
it.discussioni.energia 1
hr.ponuda.hardver.konfiguracije 1
TOTAL: 15 201

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

GroupsCount
pl.sci.historia 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 277
EMP (md5) 52
Attached HTML file 1
TOTAL: 3 330

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 56077 3664 36350 783 0 0 6%24:04:38
2poznan 7655 93 4860 49 0 0 1%24:03:14
3okapi 0 0 0 0 0 2397 0%24:00:01
4icm 0 0 0 0 0 39737 0%24:00:00
5nask 0 0 0 0 0 11525 0%24:00:01
TOTAL: 5 63732 3757 41210 832 0 53659 5%120:07:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama17.2 MB112.5 MB129.7 MB1.5 KB/s29.9 KB24:04:38
2poznan4.8 MB677.1 KB5.4 MB0.1 KB/s39.2 KB24:03:14
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
4icm0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 521.9 MB113.2 MB135.1 MB0.3 KB/s30.1 KB120:07:54
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1pc-skrzep2.cm.p.lodz.pl 288 412705.4 KB 288 0 000:00:07
2pc-212-51-218-225.p.lodz.pl 13 187398.6 KB 12 0 003:42:52
3dmcs2.p.lodz.pl 15 75172.1 KB 11 0 001:52:27
4web.man.lodz.pl 288 5243.1 KB 25 0 000:00:29
5lze200.lze.lodz.pl 6 2029.3 KB 3 0 000:06:33
6auriga.rz.izeto.pl 2 610.2 KB 2 0 000:22:56
7isvcs01.man.lodz.pl 12 00.0 KB 0 12 000:00:00
TOTAL: 7 624 7521.3 MB 341 12 008:04:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 412705.4 KB 288 0 000:00:07
2*.p.lodz.pl 28 262570.7 KB 23 0 005:35:19
3*.man.lodz.pl 684 5243.1 KB 25 12 000:00:34
4*.lze.lodz.pl 6 2029.3 KB 3 0 000:06:33
5*.rz.izeto.pl 2 610.2 KB 2 0 000:22:56
6unresolved 8 00.0 KB 0 0 001:58:25
7*.toya.net.pl 52 00.0 KB 0 0 000:00:03
TOTAL: 71068 7521.3 MB 341 12 008:04:00

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pc-212-51-218-225.p.lodz.pl 0.069 0.227 0.00003:42:52
185.48.195.96 2.960 4.071 0.00001:58:25
dmcs2.p.lodz.pl 0.057 0.156 0.00001:52:27
auriga.rz.izeto.pl 0.004 0.032 0.00000:22:56
lze200.lze.lodz.pl 0.029 0.078 0.00000:06:33
web.man.lodz.pl 0.954 3.169 0.00000:00:29
pc-skrzep2.cm.p.lodz.pl 1.107 3.069 0.00000:00:07
mon.man.lodz.pl 1.008 3.117 0.00000:00:03
staticline41435.toya.net.pl 0.164 0.603 0.00000:00:03
isvcs01.man.lodz.pl 0.075 0.159 0.00000:00:00
david.man.lodz.pl 0.345 1.066 0.00000:00:00
? 0.000 0.024 0.00000:00:00
TOTAL: 12 6.772 15.771 0.00008:04:00

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
david.man.lodz.pl 96
staticline41435.toya.net.pl 52
185.48.195.96 8
TOTAL: 4 444

NNRP gethostbyaddr failures [Top 20]:

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

NNRP client timeouts [Top 20]:

SystemConnPeer
pc-212-51-218-225.p.lodz.pl 6 1
185.48.195.96 3 1
TOTAL: 2 9 2

Newsgroup request counts (by category):

CategoryCountPct
1lodman 418 55.6%
2pl 334 44.4%
TOTAL: 2 752100.0%

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

NewsgroupCount
1lodman.info 418
2pl.misc.elektronika 178
3pl.misc.kolej 84
4pl.comp.pecet 47
5pl.comp.os.ms-windows.winnt 20
6pl.misc.telefonia.gsm 5
TOTAL: 6 752