Daily Usenet report

Jul 30 04:15:01 -- Jul 31 04:15:02

Unknown entries from news log file:

First 13 / 13 lines (100.0%)

Jul 30 04:34:29 newsfeed overchan[175897]: input line too long, skipping
Jul 30 10:19:49 newsfeed overchan[175897]: input line too long, skipping
Jul 30 13:40:03 newsfeed nnrpd[201933]: SERVER perl filter not defined
Jul 30 15:52:25 newsfeed controlchan[175895]: skipping newgroup free.cu y 975th@cu.invalid (would be created): Empty description
Jul 30 18:25:25 newsfeed overchan[175897]: input line too long, skipping
Jul 30 18:27:42 newsfeed overchan[175897]: input line too long, skipping
Jul 30 19:03:02 newsfeed overchan[175897]: input line too long, skipping
Jul 31 00:59:55 newsfeed overchan[175897]: input line too long, skipping
Jul 31 01:08:05 newsfeed overchan[175897]: input line too long, skipping
Jul 31 01:33:23 newsfeed overchan[175897]: input line too long, skipping
Jul 31 01:47:39 newsfeed overchan[175897]: input line too long, skipping
Jul 31 03:00:12 newsfeed overchan[175897]: input line too long, skipping
Jul 31 03:48:39 newsfeed overchan[175897]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 97575 89.9%11.2 MB 91.2%
nnrpd 7652 7.1%741.6 KB 5.9%
innd 1953 1.8%217.8 KB 1.7%
innfeed 1298 1.2%142.3 KB 1.1%
overchan 12 0.0%1.0 KB 0.0%
controlchan 3 0.0%0.3 KB 0.0%
TOTAL: 6 108493 100.0%12.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 96766 98.6%
Negative hits 1132 1.2%
Positive hits 253 0.3%
Cache misses 16 0.0%
TOTAL: 4 98167 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.446 0.0%36 0.000 12.389 43.000
article cleanup00:00:00.579 0.0%97046 0.000 0.006 0.016
article logging00:00:02.345 0.0%97353 0.010 0.024 0.063
article parse00:00:03.860 0.0%654719 0.001 0.006 0.010
article write00:00:29.377 0.0%96970 0.048 0.303 14.267
artlog/artcncl00:00:00.002 0.0%36 0.000 0.056 0.500
data move00:00:00.723 0.0%881570 0.000 0.001 0.004
hisgrep/artcncl00:00:00.132 0.0%36 0.000 3.667 15.000
hishave/artcncl00:00:00.056 0.0%36 0.000 1.556 7.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:06:09.384 0.4%98401 1.658 3.754 20.227
history sync00:00:00.020 0.0%385 0.000 0.052 0.667
history write00:10:55.283 0.8%97036 3.873 6.753 19.091
idle23:40:58.411 98.6%741217 5.570 115.025 620.460
nntp read00:00:09.291 0.0%651044 0.007 0.014 0.033
overview write00:00:00.304 0.0%96970 0.000 0.003 0.014
perl filter00:01:43.459 0.1%97036 0.683 1.066 1.482
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:02.921 0.0%203179 0.004 0.014 0.034
TOTAL: 24:00:57.68524:00:36.593100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.022 0.0%9234 0.000 0.002 0.059
article prepare00:00:00.000 0.0%192 0.000 0.000 0.000
article read00:00:00.003 0.0%48 0.000 0.062 1.000
backlog stats00:00:00.029 0.0%45110 0.000 0.001 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.225 0.0%22740 0.000 0.010 0.038
data write00:00:00.584 0.0%13650 0.000 0.043 0.125
idle23:59:41.363100.0%45110 762.120 1914.905 5567.574
status file00:00:00.950 0.0%343 0.000 2.770 42.933
TOTAL: 23:59:43.92323:59:43.176100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:19.519 53.4%4185 0.000 4.664 9750.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.149 0.4%10121 0.000 0.015 0.333
readart00:00:00.000 0.0%6 0.000 0.000 0.000
TOTAL: 00:00:36.56600:00:19.668 53.8%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
975th@cu.invalid100011
TOTAL100011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 57 97149 97086 1 62 99%38:39:50
2news.icm.edu.pl 54 246 10 222 14 4%15:35:01
3localhost 2 1 1 0 0 100%00:00:00
TOTAL: 3 113 97396 97097 223 76 99%54:14:51
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.6 GB259.0 KB401.2 KB1.6 GB 99%17.4 KB
2news.icm.edu.pl380.4 KB9.1 KB470.2 KB859.7 KB 44%35.8 KB
3localhost2.0 KB0.0 KB0.0 KB2.0 KB100%2.0 KB
TOTAL: 31.6 GB268.1 KB871.4 KB1.6 GB 99%17.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 30 04:15:01 - 04:59:59 2156 2.2% 0.8016.5 MB 1.0% 6.27
Jul 30 05:00:00 - 05:59:59 2670 2.7% 0.7421.3 MB 1.3% 6.07
Jul 30 06:00:00 - 06:59:59 2222 2.3% 0.6224.1 MB 1.5% 6.86
Jul 30 07:00:00 - 07:59:59 1745 1.8% 0.4823.7 MB 1.4% 6.74
Jul 30 08:00:00 - 08:59:59 2452 2.5% 0.6857.9 MB 3.5% 16.47
Jul 30 09:00:00 - 09:59:59 2565 2.6% 0.7138.3 MB 2.3% 10.90
Jul 30 10:00:00 - 10:59:59 1649 1.7% 0.4623.0 MB 1.4% 6.53
Jul 30 11:00:00 - 11:59:59 3029 3.1% 0.8441.9 MB 2.5% 11.93
Jul 30 12:00:00 - 12:59:59 2361 2.4% 0.6627.9 MB 1.7% 7.94
Jul 30 13:00:00 - 13:59:59 4389 4.5% 1.2263.0 MB 3.8% 17.93
Jul 30 14:00:00 - 14:59:59 3668 3.8% 1.0249.2 MB 3.0% 14.01
Jul 30 15:00:00 - 15:59:59 3366 3.5% 0.9442.4 MB 2.6% 12.06
Jul 30 16:00:00 - 16:59:59 5919 6.1% 1.64132.7 MB 8.1% 37.74
Jul 30 17:00:00 - 17:59:59 3982 4.1% 1.1152.8 MB 3.2% 15.03
Jul 30 18:00:00 - 18:59:59 5124 5.3% 1.4268.0 MB 4.1% 19.35
Jul 30 19:00:00 - 19:59:59 5934 6.1% 1.6582.9 MB 5.0% 23.57
Jul 30 20:00:00 - 20:59:59 5538 5.7% 1.5481.0 MB 4.9% 23.04
Jul 30 21:00:00 - 21:59:59 4923 5.1% 1.3774.6 MB 4.5% 21.23
Jul 30 22:00:00 - 22:59:59 4490 4.6% 1.2563.6 MB 3.9% 18.09
Jul 30 23:00:00 - 23:59:59 5747 5.9% 1.6080.0 MB 4.9% 22.75
Jul 31 00:00:00 - 00:59:59 6349 6.5% 1.76143.7 MB 8.7% 40.89
Jul 31 01:00:00 - 01:59:59 7942 8.2% 2.21346.4 MB 21.0% 98.52
Jul 31 02:00:00 - 02:59:59 3361 3.5% 0.9336.7 MB 2.2% 10.43
Jul 31 03:00:00 - 03:59:59 4485 4.6% 1.2543.2 MB 2.6% 12.28
Jul 31 04:00:00 - 04:15:02 1091 1.1% 1.2113.2 MB 0.8% 14.99
TOTAL: 24:00:01 97157 100.0% 1.121.6 GB 100.0% 19.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 368 53 0 9 0 0 0 0 306
2news.icm.edu.pl 14 0 0 1 0 0 0 0 13
TOTAL: 2 382 53 0 10 0 0 0 0 319

Unwanted newsgroups [Top 20]:

NewsgroupCount
comp.mobile.android 24
uk.railway 19
de.comp.lang.vbclassic 3
comp.sys.raspberry-pi 3
alt.comp.software.firefox 2
it.discussioni.energia 1
de.rec.sf.startrek 1
TOTAL: 7 53

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 9
Scoring filter (9) 4
TOTAL: 2 13

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 13470 7 9147 41 0 0 0%23:59:24
2poznan 14 0 10 0 0 0 0%01:40:16
3panorama 0 0 0 0 0 9236 0%23:57:48
4nask 0 0 0 0 0 6237 0%23:57:48
5okapi 0 0 0 0 0 660 0%23:57:48
TOTAL: 5 13484 7 9157 41 0 16133 0%97:33:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm18.5 KB776.8 KB795.2 KB0.0 KB/s16.6 KB23:59:24
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:40:16
3panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 518.5 KB776.8 KB795.2 KB0.0 KB/s16.6 KB97:33:04
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 289 64.9 KB 3 0 000:00:08
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 290 64.9 KB 3 1 000:00:37

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1730 64.9 KB 3 1 000:00:22
2unresolved 104 00.0 KB 0 0 000:00:13
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 31835 64.9 KB 3 1 000:00:37

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
nms2.man.lodz.pl 4.207 6.019 0.00000:00:13
162.243.133.47 0.006 0.003 0.00000:00:09
web.man.lodz.pl 0.921 1.357 0.00000:00:08
80.111.142.213 0.013 0.027 0.00000:00:02
212.51.192.185 0.293 0.471 0.00000:00:01
scanner-08.ch1.censys-scanner.com 0.017 0.000 0.00000:00:00
192.241.204.79 0.003 0.007 0.00000:00:00
94.102.61.41 0.006 0.000 0.00000:00:00
45.227.254.48 0.005 0.005 0.00000:00:00
isvcs01.man.lodz.pl 0.008 0.008 0.00000:00:00
TOTAL: 10 5.479 7.897 0.00000:00:37

Curious NNRP server explorers [Top 20]:

SystemConn
nms2.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
45.227.254.48 1
scanner-08.ch1.censys-scanner.com 1
162.243.133.47 1
94.102.61.41 1
192.241.204.79 1
TOTAL: 8 1545

NNRP unrecognized commands (by host):

SystemConn
94.102.61.41 5
192.241.204.79 1
scanner-08.ch1.censys-scanner.com 1
45.227.254.48 1
TOTAL: 4 8

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
Accept-Encoding: gzip 1
GET / HTTP/1.1 1
Accept: */* 1
MGLNDD_212.191.2.21_119 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
#003 1
Host: 212.191.2.21:119 1
TOTAL: 8 8

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.48 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 6100.0%
TOTAL: 1 6100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 4
2pl.comp.pecet 2
TOTAL: 2 6