Daily Usenet report

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

Unknown entries from news log file:

First 18 / 18 lines (100.0%)

Oct 10 06:41:47 newsfeed overchan[1447045]: input line too long, skipping
Oct 10 12:26:50 newsfeed nnrpd[1473012]: SERVER perl filter not defined
Oct 10 13:24:48 newsfeed nnrpd[1475923]: SERVER perl filter not defined
Oct 10 14:24:45 newsfeed overchan[1447045]: input line too long, skipping
Oct 10 15:19:59 newsfeed overchan[1447045]: input line too long, skipping
Oct 10 15:57:04 newsfeed overchan[1447045]: input line too long, skipping
Oct 10 16:03:33 newsfeed overchan[1447045]: input line too long, skipping
Oct 10 16:46:31 newsfeed overchan[1447045]: input line too long, skipping
Oct 10 17:37:25 newsfeed nnrpd[1491660]: SERVER perl filter not defined
Oct 10 17:37:51 newsfeed nnrpd[1491667]: SERVER perl filter not defined
Oct 10 17:38:16 newsfeed nnrpd[1491670]: SERVER perl filter not defined
Oct 10 17:38:36 newsfeed nnrpd[1491671]: SERVER perl filter not defined
Oct 10 17:38:59 newsfeed nnrpd[1491678]: SERVER perl filter not defined
Oct 10 18:22:32 newsfeed nnrpd[1493976]: SERVER perl filter not defined
Oct 10 18:29:46 newsfeed nnrpd[1494198]: SERVER perl filter not defined
Oct 10 18:46:41 newsfeed overchan[1447045]: input line too long, skipping
Oct 10 20:38:30 newsfeed overchan[1447045]: input line too long, skipping
Oct 11 00:23:50 newsfeed overchan[1447045]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 690751 95.3%76.6 MB 94.7%
innfeed 22168 3.1%2.7 MB 3.3%
innd 8753 1.2%1.3 MB 1.7%
nnrpd 3386 0.5%325.2 KB 0.4%
overchan 10 0.0%1.8 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 725069 100.0%81.0 MB100.0%

History cache:

ReasonCount%Count
Do not exist 689160 99.7%
Negative hits 1795 0.3%
Positive hits 156 0.0%
Cache misses 20 0.0%
TOTAL: 4 691131 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.605 0.0%45 0.000 13.444 55.000
article cleanup00:00:05.206 0.0%690209 0.005 0.008 0.012
article logging00:00:16.791 0.0%690703 0.018 0.024 0.034
article parse00:09:00.636 0.6%86359084 0.005 0.006 0.009
article write00:05:48.044 0.4%689920 0.318 0.504 0.640
artlog/artcncl00:00:00.000 0.0%45 0.000 0.000 0.000
data move00:01:14.338 0.1%91827700 0.000 0.001 0.001
hisgrep/artcncl00:00:00.132 0.0%42 0.000 3.143 18.000
hishave/artcncl00:00:00.055 0.0%45 0.000 1.222 8.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:23:01.286 1.6%692381 0.131 1.995 15.210
history sync00:00:00.009 0.0%296 0.000 0.030 0.500
history write00:34:15.279 2.4%690204 0.257 2.978 12.058
hiswrite/artcncl00:00:00.011 0.0%3 1.000 3.667 5.000
idle21:30:08.981 89.6%85796722 0.664 0.902 2.048
nntp read00:27:17.264 1.9%85883234 0.015 0.019 0.025
overview write00:00:01.959 0.0%689920 0.001 0.003 0.006
perl filter00:39:10.909 2.7%690204 2.616 3.406 4.035
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:20.083 0.0%1390079 0.011 0.014 0.018
TOTAL: 24:00:05.78223:50:41.588 99.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.038 0.0%29290 0.000 0.001 0.010
article prepare00:00:00.003 0.0%14792 0.000 0.000 0.016
article read00:00:12.279 0.0%3716 0.000 3.304 29.444
backlog stats00:00:00.057 0.0%84227 0.000 0.001 0.007
callbacks00:00:00.000 0.0%22 0.000 0.000 0.000
data read00:00:00.406 0.0%40612 0.000 0.010 0.037
data write00:00:01.001 0.0%30817 0.000 0.032 0.093
idle23:56:26.367100.0%84227 637.373 1023.263 2098.861
status file00:00:05.041 0.0%7146 0.383 0.705 7.577
TOTAL: 23:56:49.64923:56:45.192100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:18.658 74.1%2808 0.000 6.645 9773.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.079 0.3%5928 0.000 0.013 0.500
readart00:00:00.001 0.0%30 0.000 0.033 0.500
TOTAL: 00:00:25.16800:00:18.738 74.5%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 78 690177 689904 0 273 99%61:47:55
2localhost 1385 9 9 0 0 100%00:00:01
3news.icm.edu.pl 44 151 5 130 16 3%13:02:18
TOTAL: 3 1507 690337 689918 130 289 99%74:50:14
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl340.5 GB317.2 KB1.1 MB340.5 GB 99%517.4 KB
2news.icm.edu.pl326.4 KB85.6 KB348.1 KB760.1 KB 42%36.2 KB
3localhost12.8 KB0.0 KB0.0 KB12.8 KB100%1.4 KB
TOTAL: 3340.5 GB402.8 KB1.5 MB340.5 GB 99%517.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 10 04:15:02 - 04:59:59 18200 2.6% 6.7510.2 GB 3.0%3970.83
Oct 10 05:00:00 - 05:59:59 26143 3.8% 7.2614.4 GB 4.2%4199.70
Oct 10 06:00:00 - 06:59:59 27212 3.9% 7.5614.0 GB 4.1%4067.92
Oct 10 07:00:00 - 07:59:59 28082 4.1% 7.8014.1 GB 4.1%4108.56
Oct 10 08:00:00 - 08:59:59 29573 4.3% 8.2115.0 GB 4.4%4357.45
Oct 10 09:00:00 - 09:59:59 28926 4.2% 8.0414.9 GB 4.4%4343.54
Oct 10 10:00:00 - 10:59:59 26844 3.9% 7.4613.5 GB 4.0%3939.42
Oct 10 11:00:00 - 11:59:59 27201 3.9% 7.5613.7 GB 4.0%3986.32
Oct 10 12:00:00 - 12:59:59 31358 4.5% 8.7116.0 GB 4.7%4666.07
Oct 10 13:00:00 - 13:59:59 28064 4.1% 7.8013.9 GB 4.1%4049.84
Oct 10 14:00:00 - 14:59:59 46186 6.7% 12.8315.9 GB 4.7%4640.43
Oct 10 15:00:00 - 15:59:59 32051 4.6% 8.9015.6 GB 4.6%4536.45
Oct 10 16:00:00 - 16:59:59 29610 4.3% 8.2215.2 GB 4.5%4420.64
Oct 10 17:00:00 - 17:59:59 25716 3.7% 7.1413.7 GB 4.0%3986.16
Oct 10 18:00:00 - 18:59:59 25479 3.7% 7.0813.5 GB 4.0%3930.07
Oct 10 19:00:00 - 19:59:59 25524 3.7% 7.0913.1 GB 3.8%3805.74
Oct 10 20:00:00 - 20:59:59 25996 3.8% 7.2214.1 GB 4.2%4119.03
Oct 10 21:00:00 - 21:59:59 26469 3.8% 7.3514.0 GB 4.1%4073.56
Oct 10 22:00:00 - 22:59:59 29860 4.3% 8.2914.1 GB 4.1%4110.09
Oct 10 23:00:00 - 23:59:59 28016 4.1% 7.7814.0 GB 4.1%4067.76
Oct 11 00:00:00 - 00:59:59 26827 3.9% 7.4514.6 GB 4.3%4241.76
Oct 11 01:00:00 - 01:59:59 27252 4.0% 7.5714.2 GB 4.2%4135.87
Oct 11 02:00:00 - 02:59:59 32070 4.6% 8.9113.1 GB 3.8%3809.51
Oct 11 03:00:00 - 03:59:59 27975 4.1% 7.7712.3 GB 3.6%3596.90
Oct 11 04:00:00 - 04:15:01 9289 1.3% 10.313.5 GB 1.0%4130.32
TOTAL: 23:59:59 689923 100.0% 7.99340.6 GB 100.0%4133.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 766 266 0 4 3 0 0 0 493
2news.icm.edu.pl 17 0 0 1 0 0 0 0 16
TOTAL: 2 783 266 0 5 3 0 0 0 509

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 191
comp.sys.raspberry-pi 18
it.tlc.cellulari.android 15
alt.comp.software.firefox 12
it.comp.os.win.windows10 9
comp.mobile.android 6
alt.comp.software.seamonkey 6
nl.comp.os.linux.techniek 4
it.discussioni.energia 3
de.rec.sf.startrek 1
it.comp.os.linux.ubuntu 1
TOTAL: 11 266

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

GroupsCount
pl.praca.oferowana 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11
Scoring filter (9) 1
Too many newsgroups 1
Binary in non-binary group 1
Scoring filter (8) 1
TOTAL: 5 15

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 493
news.icm.edu.pl 1
TOTAL: 2 494
TOTAL: 1 494

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 16386 2753 6818 335 0 0 16%23:59:37
2panorama 19232 158 7176 153 40 21831 0%23:59:24
3nask 0 0 0 0 0 6714 0%23:57:44
4poznan 1 0 1 0 0 0 0%00:20:00
5okapi 0 0 0 0 0 727 0%23:57:46
TOTAL: 5 35619 2911 13995 488 40 29272 8%96:14:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm10.2 MB40.0 MB50.2 MB0.6 KB/s16.7 KB23:59:37
2panorama630.4 KB2.7 MB3.3 MB0.0 KB/s11.0 KB23:59:24
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:44
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s000:20:00
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
TOTAL: 510.9 MB42.7 MB53.6 MB0.2 KB/s16.1 KB96:14:31
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 287 3039.3 KB 13 0 000:00:09
2isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:00
TOTAL: 2 296 3039.3 KB 13 9 000:00:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 296 3039.3 KB 13 9 000:00:09
2unresolved 104 00.0 KB 0 0 000:00:13
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 3 401 3039.3 KB 13 9 000:00:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.241.218.88 0.000 0.007 0.00000:00:09
web.man.lodz.pl 0.831 1.639 0.00000:00:09
fun.monitoring.internet-measurement.com 0.009 0.000 0.00000:00:01
80.111.142.213 0.020 0.015 0.00000:00:01
212.51.192.185 0.229 0.517 0.00000:00:01
194.165.16.37 0.010 0.007 0.00000:00:00
isvcs01.man.lodz.pl 0.038 0.063 0.00000:00:00
192.241.215.125 0.000 0.008 0.00000:00:00
? 0.003 0.003 0.00000:00:00
TOTAL: 9 1.140 2.259 0.00000:00:25

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
194.165.16.37 2
192.241.218.88 1
fun.monitoring.internet-measurement.com 1
192.241.215.125 1
TOTAL: 6 105

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
194.165.16.37 2
192.241.215.125 1
TOTAL: 2 3

NNRP unrecognized commands (by command):

CommandCount
#003 2
MGLNDD_212.191.2.21_119 1
TOTAL: 2 3

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.37 2 2
TOTAL: 1 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 30100.0%
TOTAL: 1 30100.0%

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

NewsgroupCount
1pl.comp.pecet 16
2pl.comp.os.ms-windows.winnt 14
TOTAL: 2 30
Valid XHTML 1.1 Strict CSS is valid!
innreport 3.1.0 (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>