Daily Usenet report

Oct 19 04:15:01 -- Oct 20 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Oct 19 04:45:22 newsfeed overchan[22100]: input line too long, skipping
Oct 19 09:58:25 newsfeed nnrpd[10593]: SERVER perl filter not defined
Oct 19 10:57:02 newsfeed overchan[22100]: input line too long, skipping
Oct 19 11:24:17 newsfeed overchan[22100]: input line too long, skipping
Oct 19 11:39:58 newsfeed overchan[22100]: input line too long, skipping
Oct 19 14:16:20 newsfeed nnrpd[17930]: SERVER perl filter not defined
Oct 19 14:29:16 newsfeed overchan[22100]: input line too long, skipping
Oct 19 21:06:26 newsfeed overchan[22100]: input line too long, skipping
Oct 19 22:14:01 newsfeed overchan[22100]: input line too long, skipping
Oct 19 22:17:31 newsfeed overchan[22100]: input line too long, skipping
Oct 19 22:22:26 newsfeed overchan[22100]: input line too long, skipping
Oct 19 22:31:48 newsfeed overchan[22100]: input line too long, skipping
Oct 20 01:17:33 newsfeed overchan[22100]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 630735 91.3%69.4 MB 90.5%
innfeed 46579 6.7%5.5 MB 7.2%
innd 8977 1.3%1.4 MB 1.8%
nnrpd 4300 0.6%432.9 KB 0.6%
overchan 12 0.0%2.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 690604 100.0%76.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 626524 99.7%
Negative hits 1506 0.2%
Positive hits 229 0.0%
Cache misses 27 0.0%
TOTAL: 4 628286 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.315 0.0%81 0.000 16.235 63.000
article cleanup00:00:11.672 0.0%630057 0.012 0.019 0.025
article logging00:00:32.165 0.0%630528 0.041 0.051 0.063
article parse00:25:34.445 1.8%79096425 0.011 0.019 0.029
article write00:08:54.594 0.6%629776 0.587 0.849 1.087
artlog/artcncl00:00:00.001 0.0%81 0.000 0.012 0.500
data move00:01:03.547 0.1%84070054 0.001 0.001 0.001
hisgrep/artcncl00:00:00.394 0.0%81 0.000 4.864 31.714
hishave/artcncl00:00:00.122 0.0%81 0.000 1.506 8.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:33:31.695 2.3%631873 0.402 3.184 12.067
history sync00:00:00.027 0.0%290 0.000 0.093 1.000
history write00:15:39.759 1.1%630025 0.552 1.492 7.683
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle20:02:08.230 83.5%78307455 0.618 0.921 2.234
nntp read00:51:28.574 3.6%78722035 0.027 0.039 0.047
overview write00:00:03.491 0.0%629776 0.003 0.006 0.009
perl filter01:13:53.127 5.1%630025 4.868 7.036 8.864
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:35.189 0.0%1274621 0.022 0.028 0.034
TOTAL: 24:00:02.47523:33:38.347 98.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.143 0.0%52726 0.000 0.003 0.015
article prepare00:00:00.001 0.0%5456 0.000 0.000 0.050
article read00:00:14.480 0.0%1357 0.000 10.671 78.000
backlog stats00:00:00.107 0.0%122234 0.000 0.001 0.005
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:01.126 0.0%60459 0.003 0.019 0.036
data write00:00:02.823 0.0%45523 0.023 0.062 0.192
idle23:53:14.739 99.9%122234 416.142 703.526 1288.976
status file00:00:44.212 0.1%16827 0.835 2.627 60.979
TOTAL: 23:54:25.60023:54:17.631100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:31:20.419 98.8%3138 0.000 599.241900021.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.580 0.0%6951 0.000 0.083 10.316
readart00:00:00.002 0.0%46 0.000 0.043 0.500
TOTAL: 00:31:42.76900:31:21.001 98.9%----

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 158 630180 629959 0 221 99%84:42:33
2news.icm.edu.pl 48 278 52 168 58 18%17:03:11
3localhost 1443 2 2 0 0 100%00:00:00
TOTAL: 3 1649 630460 630013 168 279 99%101:45:44
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl309.0 GB1.7 MB2.2 MB309.0 GB 99%514.2 KB
2news.icm.edu.pl2.4 MB14.8 KB2.5 MB4.8 MB 48%45.1 KB
3localhost3.7 KB0.0 KB0.0 KB3.7 KB100%1.8 KB
TOTAL: 3309.0 GB1.7 MB4.6 MB309.0 GB 99%514.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 19 04:15:01 - 04:59:59 16436 2.6% 6.099.6 GB 3.1%3739.42
Oct 19 05:00:00 - 05:59:59 21273 3.4% 5.9112.2 GB 3.9%3539.92
Oct 19 06:00:00 - 06:59:59 25764 4.1% 7.1614.5 GB 4.7%4209.10
Oct 19 07:00:00 - 07:59:59 25283 4.0% 7.0213.5 GB 4.4%3934.02
Oct 19 08:00:00 - 08:59:59 25456 4.0% 7.0713.5 GB 4.4%3940.21
Oct 19 09:00:00 - 09:59:59 28674 4.6% 7.9614.7 GB 4.8%4286.48
Oct 19 10:00:00 - 10:59:59 29765 4.7% 8.2714.0 GB 4.5%4080.44
Oct 19 11:00:00 - 11:59:59 27629 4.4% 7.6713.9 GB 4.5%4062.35
Oct 19 12:00:00 - 12:59:59 27764 4.4% 7.7114.5 GB 4.7%4216.17
Oct 19 13:00:00 - 13:59:59 25509 4.0% 7.0912.8 GB 4.1%3730.16
Oct 19 14:00:00 - 14:59:59 26907 4.3% 7.4711.3 GB 3.6%3283.98
Oct 19 15:00:00 - 15:59:59 23941 3.8% 6.6511.4 GB 3.7%3312.24
Oct 19 16:00:00 - 16:59:59 31549 5.0% 8.7613.6 GB 4.4%3962.25
Oct 19 17:00:00 - 17:59:59 28746 4.6% 7.9912.4 GB 4.0%3610.03
Oct 19 18:00:00 - 18:59:59 30088 4.8% 8.3613.6 GB 4.4%3964.96
Oct 19 19:00:00 - 19:59:59 30343 4.8% 8.4314.0 GB 4.5%4078.36
Oct 19 20:00:00 - 20:59:59 28634 4.5% 7.9513.5 GB 4.3%3918.32
Oct 19 21:00:00 - 21:59:59 23949 3.8% 6.6512.3 GB 4.0%3587.24
Oct 19 22:00:00 - 22:59:59 25345 4.0% 7.0412.2 GB 3.9%3554.05
Oct 19 23:00:00 - 23:59:59 26159 4.2% 7.2712.3 GB 4.0%3579.45
Oct 20 00:00:00 - 00:59:59 25385 4.0% 7.0512.7 GB 4.1%3690.41
Oct 20 01:00:00 - 01:59:59 25343 4.0% 7.0412.4 GB 4.0%3598.79
Oct 20 02:00:00 - 02:59:59 22260 3.5% 6.1811.4 GB 3.7%3321.91
Oct 20 03:00:00 - 03:59:59 21798 3.5% 6.0510.3 GB 3.3%3009.25
Oct 20 04:00:00 - 04:15:02 5905 0.9% 6.553.2 GB 1.0%3729.66
TOTAL: 24:00:01 629905 100.0% 7.29309.7 GB 100.0%3758.63
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 696 180 0 29 12 0 0 0 475
2news.icm.edu.pl 58 0 0 0 0 0 0 0 58
TOTAL: 2 754 180 0 29 12 0 0 0 533

Unwanted newsgroups [Top 20]:

NewsgroupCount
it.tlc.cellulari.android 65
uk.railway 63
it.comp.os.win.windows10 25
comp.sys.raspberry-pi 10
de.rec.sf.startrek 6
it.comp.os.win.windows7 5
comp.mobile.android 4
de.comp.lang.vbclassic 1
hr.rec.glazba.hifi 1
TOTAL: 9 180

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

GroupsCount
pl.praca.oferowana 8
pl.sci.matematyka 4
TOTAL: 2 12

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 49
Binary in non-binary group 7
Too many newsgroups 1
TOTAL: 3 57

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 41377 502 12870 191 4 39284 1%24:00:17
2icm 22487 146 14715 6 0 1 0%24:09:45
3poznan 36 0 30 0 0 0 0%03:32:16
4nask 0 0 0 0 0 9951 0%24:05:33
5okapi 0 0 0 0 0 1145 0%24:05:35
TOTAL: 5 63900 648 27615 197 4 50381 1%99:53:26
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.3 MB894.5 KB2.2 MB0.0 KB/s3.2 KB24:00:17
2icm585.9 KB9.3 KB595.2 KB0.0 KB/s3.9 KB24:09:45
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s003:32:16
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:33
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:35
TOTAL: 51.9 MB903.9 KB2.8 MB0.0 KB/s3.3 KB99:53:26
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4243.9 KB 17 0 000:00:22
2109.63.165.59 7 23.7 KB 2 0 000:01:02
3isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 3 297 4447.6 KB 19 2 000:31:42

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 578 4243.9 KB 17 2 000:00:31
2unresolved 109 23.7 KB 2 0 000:31:10
3*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 3 688 4447.6 KB 19 2 000:31:42

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
115.233.218.203 0.003 0.006 0.00000:30:00
109.63.165.59 0.048 0.096 0.00000:01:02
web.man.lodz.pl 2.059 4.223 0.00000:00:22
mon.man.lodz.pl 2.374 6.006 0.00000:00:08
80.111.142.213 0.026 0.046 0.00000:00:04
45.141.84.171 0.000 0.008 0.00000:00:01
212.51.192.185 0.404 0.925 0.00000:00:01
scan-141.security.ipip.net 0.005 0.010 0.00000:00:00
isvcs01.man.lodz.pl 0.016 0.042 0.00000:00:00
TOTAL: 9 4.935 11.362 0.00000:31:42

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
scan-141.security.ipip.net 1
45.141.84.171 1
115.233.218.203 1
TOTAL: 6 391

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
45.141.84.171 1
115.233.218.203 1
TOTAL: 3 6

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 1
#003 1
Connection: close 1
Host: 212.191.2.21:119 1
GET / HTTP/1.0 1
User-Agent: HTTP Banner Detection (https... 1
TOTAL: 6 6

NNRP client timeouts [Top 20]:

SystemConnPeer
115.233.218.203 1 0
45.141.84.171 1 1
TOTAL: 2 2 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 42 95.5%
2lodman 2 4.5%
TOTAL: 2 44100.0%

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

NewsgroupCount
1pl.comp.pecet 40
2pl.comp.os.ms-windows.winnt 2
3lodman.info 2
TOTAL: 3 44