Daily Usenet report

Oct 12 04:15:01 -- Oct 13 04:15:01

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Oct 12 07:49:54 newsfeed nnrpd[2234]: SERVER perl filter not defined
Oct 12 09:17:26 newsfeed nnrpd[15241]: SERVER perl filter not defined
Oct 12 12:38:46 newsfeed nnrpd[13263]: SERVER perl filter not defined
Oct 12 12:39:22 newsfeed nnrpd[13367]: SERVER perl filter not defined
Oct 12 12:40:36 newsfeed nnrpd[13562]: SERVER perl filter not defined
Oct 12 12:40:54 newsfeed nnrpd[13671]: SERVER perl filter not defined
Oct 12 14:51:34 newsfeed overchan[1505]: input line too long, skipping
Oct 12 14:53:24 newsfeed overchan[1505]: input line too long, skipping
Oct 12 15:20:43 newsfeed overchan[1505]: input line too long, skipping
Oct 12 16:22:25 newsfeed overchan[1505]: input line too long, skipping
Oct 12 16:35:44 newsfeed overchan[1505]: input line too long, skipping
Oct 12 16:47:08 newsfeed overchan[1505]: input line too long, skipping
Oct 12 18:27:00 newsfeed overchan[1505]: input line too long, skipping
Oct 12 19:58:38 newsfeed overchan[1505]: input line too long, skipping
Oct 12 20:00:34 newsfeed overchan[1505]: input line too long, skipping
Oct 12 20:08:01 newsfeed overchan[1505]: input line too long, skipping
Oct 12 20:09:45 newsfeed overchan[1505]: input line too long, skipping
Oct 12 20:37:22 newsfeed overchan[1505]: input line too long, skipping
Oct 12 22:38:10 newsfeed nnrpd[5651]: SERVER perl filter not defined
Oct 13 01:08:50 newsfeed nnrpd[28401]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 547884 90.0%60.4 MB 89.1%
innfeed 48093 7.9%5.7 MB 8.3%
innd 9558 1.6%1.5 MB 2.2%
nnrpd 3384 0.6%317.8 KB 0.5%
overchan 13 0.0%2.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 608933 100.0%67.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 545035 99.1%
Negative hits 4662 0.8%
Positive hits 296 0.1%
Cache misses 21 0.0%
TOTAL: 4 550014 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.842 0.0%78 0.000 23.615 113.000
article cleanup00:00:03.091 0.0%548173 0.003 0.006 0.013
article logging00:00:09.729 0.0%548595 0.010 0.018 0.029
article parse00:06:17.183 0.4%96152291 0.002 0.004 0.006
article write00:02:42.429 0.2%547816 0.145 0.297 0.519
artlog/artcncl00:00:00.001 0.0%75 0.000 0.013 1.000
data move00:00:19.517 0.0%100315793 0.000 0.000 0.000
hisgrep/artcncl00:00:00.274 0.0%77 0.000 3.558 111.000
hishave/artcncl00:00:00.062 0.0%78 0.000 0.795 5.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:27:50.820 1.9%553098 0.332 3.021 13.214
history sync00:00:00.008 0.0%290 0.000 0.028 0.500
history write00:38:23.342 2.7%548129 0.841 4.202 12.858
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle22:03:42.264 91.9%93663290 0.578 0.848 1.425
nntp read00:11:08.406 0.8%95777607 0.005 0.007 0.009
overview write00:00:01.232 0.0%547816 0.000 0.002 0.006
perl filter00:21:24.916 1.5%548129 1.699 2.344 3.507
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:08.842 0.0%1107974 0.006 0.008 0.012
TOTAL: 24:00:02.01723:52:13.958 99.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.037 0.0%49038 0.000 0.001 0.008
article prepare00:00:00.000 0.0%8666 0.000 0.000 0.000
article read00:00:05.356 0.0%2163 0.000 2.476 21.429
backlog stats00:00:00.053 0.0%115413 0.000 0.000 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.322 0.0%55315 0.000 0.006 0.049
data write00:00:00.709 0.0%43300 0.000 0.016 0.043
idle23:53:44.612 99.9%115413 385.590 745.363 1213.267
status file00:01:02.052 0.1%16951 0.232 3.661 157.264
TOTAL: 23:54:55.58623:54:53.141100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:08.574 60.5%2822 0.000 3.038 1184.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.048 0.3%5956 0.000 0.008 0.500
readart00:00:00.001 0.0%36 0.000 0.028 0.167
TOTAL: 00:00:14.17200:00:08.623 60.8%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 416 547429 547120 1 308 99%138:37:01
2news.icm.edu.pl 38 300 80 170 50 26%16:11:07
3localhost 1449 8 8 0 0 100%00:00:00
TOTAL: 3 1903 547737 547208 171 358 99%154:48:08
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl231.0 GB3.6 MB4.3 MB231.0 GB 99%442.5 KB
2news.icm.edu.pl4.8 MB0.0 KB610.0 KB5.4 MB 88%42.6 KB
3localhost15.5 KB0.0 KB0.0 KB15.5 KB100%1.9 KB
TOTAL: 3231.0 GB3.6 MB4.9 MB231.0 GB 99%442.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 12 04:15:01 - 04:59:59 13500 2.5% 5.007.2 GB 3.1%2804.64
Oct 12 05:00:00 - 05:59:59 17193 3.1% 4.789.1 GB 3.9%2639.38
Oct 12 06:00:00 - 06:59:59 18637 3.4% 5.188.8 GB 3.8%2549.82
Oct 12 07:00:00 - 07:59:59 18935 3.5% 5.269.4 GB 4.1%2745.15
Oct 12 08:00:00 - 08:59:59 20890 3.8% 5.8010.7 GB 4.6%3104.18
Oct 12 09:00:00 - 09:59:59 20065 3.7% 5.5710.5 GB 4.6%3069.77
Oct 12 10:00:00 - 10:59:59 19911 3.6% 5.539.0 GB 3.9%2611.53
Oct 12 11:00:00 - 11:59:59 21042 3.8% 5.849.3 GB 4.0%2709.16
Oct 12 12:00:00 - 12:59:59 23090 4.2% 6.419.6 GB 4.2%2799.30
Oct 12 13:00:00 - 13:59:59 23684 4.3% 6.589.5 GB 4.1%2777.73
Oct 12 14:00:00 - 14:59:59 27176 5.0% 7.559.6 GB 4.2%2797.49
Oct 12 15:00:00 - 15:59:59 39020 7.1% 10.849.7 GB 4.2%2821.69
Oct 12 16:00:00 - 16:59:59 38390 7.0% 10.669.5 GB 4.1%2760.12
Oct 12 17:00:00 - 17:59:59 22505 4.1% 6.2510.1 GB 4.4%2945.08
Oct 12 18:00:00 - 18:59:59 21785 4.0% 6.0510.1 GB 4.4%2944.66
Oct 12 19:00:00 - 19:59:59 24036 4.4% 6.6811.3 GB 4.9%3284.03
Oct 12 20:00:00 - 20:59:59 18817 3.4% 5.238.9 GB 3.9%2594.37
Oct 12 21:00:00 - 21:59:59 18264 3.3% 5.079.3 GB 4.0%2720.46
Oct 12 22:00:00 - 22:59:59 24149 4.4% 6.719.2 GB 4.0%2690.42
Oct 12 23:00:00 - 23:59:59 19255 3.5% 5.359.3 GB 4.0%2708.77
Oct 13 00:00:00 - 00:59:59 26259 4.8% 7.2911.5 GB 5.0%3363.47
Oct 13 01:00:00 - 01:59:59 30131 5.5% 8.379.8 GB 4.2%2853.89
Oct 13 02:00:00 - 02:59:59 23360 4.3% 6.4910.8 GB 4.7%3141.87
Oct 13 03:00:00 - 03:59:59 13593 2.5% 3.787.3 GB 3.2%2122.71
Oct 13 04:00:00 - 04:15:01 3342 0.6% 3.711.6 GB 0.7%1807.09
TOTAL: 24:00:00 547029 100.0% 6.33231.1 GB 100.0%2804.58
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 729 250 0 44 10 0 0 0 425
2news.icm.edu.pl 50 0 0 0 0 0 0 0 50
TOTAL: 2 779 250 0 44 10 0 0 0 475

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 178
it.comp.os.win.windows10 27
it.tlc.cellulari.android 20
comp.mobile.android 15
alt.comp.software.seamonkey 6
it.comp.os.win.windows8 1
de.rec.sf.startrek 1
alt.comp.software.firefox 1
de.comp.lang.perl 1
TOTAL: 9 250

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

GroupsCount
pl.sci.matematyka 6
pl.praca.oferowana 4
TOTAL: 2 10

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 47
Binary in non-binary group 6
TOTAL: 2 53

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 422
TOTAL: 1 422
TOTAL: 1 422

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 19426 1121 10709 103 0 1 5%23:55:43
2panorama 39650 430 11132 107 1 37519 1%24:00:22
3nask 0 0 0 0 0 8271 0%23:57:47
4poznan 76 0 65 0 0 0 0%05:04:01
5okapi 0 0 0 0 0 1104 0%23:57:47
TOTAL: 5 59152 1551 21906 210 1 46895 2%100:55:40
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm3.5 MB13.8 MB17.3 MB0.2 KB/s14.4 KB23:55:43
2panorama1.4 MB386.8 KB1.8 MB0.0 KB/s3.4 KB24:00:22
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s005:04:01
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 54.9 MB14.2 MB19.0 MB0.1 KB/s11.1 KB100:55:40
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3644.6 KB 14 0 000:00:07
2isvcs01.man.lodz.pl 8 00.0 KB 0 8 000:00:01
TOTAL: 2 296 3644.6 KB 14 8 000:00:14

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 296 3644.6 KB 14 8 000:00:08
2unresolved 102 00.0 KB 0 0 000:00:03
3*.50-31-21.static.steadfastdns.net 2 00.0 KB 0 0 000:00:01
TOTAL: 3 400 3644.6 KB 14 8 000:00:14

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.561 1.293 0.00000:00:07
80.111.142.213 0.007 0.019 0.00000:00:02
ip10.50-31-21.static.steadfastdns.net 0.005 0.005 0.00000:00:01
isvcs01.man.lodz.pl 0.026 0.064 0.00000:00:01
212.51.192.185 0.188 0.389 0.00000:00:00
45.93.201.9 0.000 0.011 0.00000:00:00
TOTAL: 6 0.787 1.781 0.00000:00:14

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
45.93.201.9 2
ip10.50-31-21.static.steadfastdns.net 2
TOTAL: 4 104

NNRP unrecognized commands (by host):

SystemConn
45.93.201.9 2
TOTAL: 1 2

NNRP unrecognized commands (by command):

CommandCount
#003 2
TOTAL: 1 2

NNRP client timeouts [Top 20]:

SystemConnPeer
45.93.201.9 2 2
TOTAL: 1 2 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 36100.0%
TOTAL: 1 36100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 36
TOTAL: 1 36