Daily Usenet report

Oct 20 04:15:02 -- Oct 21 04:15:02

Unknown entries from news log file:

First 28 / 28 lines (100.0%)

Oct 20 06:01:00 newsfeed nnrpd[2146]: unable to get certificate from '/etc/news/cert.pem'
Oct 20 06:01:00 newsfeed nnrpd[2146]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Oct 20 08:10:51 newsfeed overchan[18057]: input line too long, skipping
Oct 20 08:34:51 newsfeed overchan[18057]: input line too long, skipping
Oct 20 09:10:30 newsfeed overchan[18057]: input line too long, skipping
Oct 20 09:25:18 newsfeed nnrpd[1535]: SERVER perl filter not defined
Oct 20 13:01:00 newsfeed nnrpd[2579]: SERVER perl filter not defined
Oct 20 13:01:45 newsfeed nnrpd[2833]: SERVER perl filter not defined
Oct 20 16:31:36 newsfeed nnrpd[2429]: SERVER perl filter not defined
Oct 20 16:31:56 newsfeed overchan[18057]: input line too long, skipping
Oct 20 17:36:15 newsfeed nnrpd[10269]: SERVER perl filter not defined
Oct 20 17:36:58 newsfeed nnrpd[10380]: SERVER perl filter not defined
Oct 20 18:14:16 newsfeed overchan[1255]: input line too long, skipping
Oct 20 18:29:32 newsfeed nnrpd[18373]: unable to get certificate from '/etc/news/cert.pem'
Oct 20 18:29:32 newsfeed nnrpd[18373]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Oct 20 19:13:00 newsfeed overchan[1255]: input line too long, skipping
Oct 20 20:07:13 newsfeed overchan[1255]: input line too long, skipping
Oct 20 20:25:35 newsfeed nnrpd[3862]: SERVER perl filter not defined
Oct 20 20:38:40 newsfeed overchan[1255]: input line too long, skipping
Oct 20 20:55:07 newsfeed overchan[1255]: input line too long, skipping
Oct 20 21:03:35 newsfeed overchan[1255]: input line too long, skipping
Oct 20 21:34:34 newsfeed nnrpd[14381]: SERVER perl filter not defined
Oct 20 21:47:48 newsfeed nnrpd[16444]: SERVER perl filter not defined
Oct 21 00:02:24 newsfeed overchan[1255]: input line too long, skipping
Oct 21 00:07:57 newsfeed nnrpd[5671]: SERVER perl filter not defined
Oct 21 00:08:33 newsfeed nnrpd[5695]: SERVER perl filter not defined
Oct 21 00:57:01 newsfeed overchan[1255]: input line too long, skipping
Oct 21 01:15:40 newsfeed overchan[1255]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 692466 92.9%76.0 MB 92.2%
innfeed 39464 5.3%4.6 MB 5.6%
innd 8865 1.2%1.4 MB 1.7%
nnrpd 4429 0.6%446.5 KB 0.5%
overchan 13 0.0%2.2 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 6 745239 100.0%82.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 689070 99.7%
Negative hits 2149 0.3%
Positive hits 226 0.0%
Cache misses 37 0.0%
TOTAL: 4 691482 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.386 0.0%83 0.000 28.747 251.000
article cleanup00:00:09.662 0.0%691952 0.010 0.014 0.019
article logging00:00:31.970 0.0%692403 0.031 0.046 0.064
article parse00:19:08.272 1.3%73926604 0.008 0.016 0.037
article write00:07:38.228 0.5%691706 0.394 0.662 0.926
artlog/artcncl00:00:00.001 0.0%82 0.000 0.012 0.111
data move00:00:45.111 0.1%78731099 0.000 0.001 0.001
hisgrep/artcncl00:00:00.414 0.0%82 0.000 5.049 19.000
hishave/artcncl00:00:00.010 0.0%83 0.000 0.120 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:09:51.380 0.7%694278 0.306 0.852 4.905
history sync00:00:00.020 0.0%290 0.000 0.069 0.500
history write00:14:23.441 1.0%691932 0.439 1.248 6.383
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle21:06:57.207 88.0%73622035 0.567 1.033 2.633
nntp read00:39:31.698 2.7%73592173 0.022 0.032 0.058
overview write00:00:03.688 0.0%691706 0.002 0.005 0.009
perl filter01:07:38.939 4.7%691932 3.976 5.866 8.037
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:36.056 0.0%1398218 0.020 0.026 0.035
TOTAL: 24:00:03.44023:47:18.483 99.1%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.150 0.0%48792 0.000 0.003 0.012
article prepare00:00:00.000 0.0%7558 0.000 0.000 0.000
article read00:00:13.019 0.0%1891 0.000 6.885 62.200
backlog stats00:00:00.096 0.0%121477 0.000 0.001 0.005
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:00.984 0.0%59103 0.000 0.017 0.036
data write00:00:02.568 0.0%44919 0.019 0.057 0.113
idle23:42:56.837 99.9%121477 410.327 702.823 1467.650
status file00:00:37.108 0.0%13091 0.660 2.835 125.675
TOTAL: 23:43:57.35823:43:50.762100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:13.589 90.8%3246 0.000 59.639 14862.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.351 0.2%7112 0.000 0.049 4.667
readart00:00:00.009 0.0%46 0.000 0.196 1.000
TOTAL: 00:03:33.22200:03:13.949 91.0%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 151
name 3
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 196

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 50 691863 691649 0 214 99%54:13:30
2news.icm.edu.pl 51 217 27 156 34 12%14:20:08
3localhost 1452 11 11 0 0 100%00:00:00
TOTAL: 3 1553 692091 691687 156 248 99%68:33:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl292.7 GB1008.4 KB1.4 MB292.7 GB 99%443.6 KB
2news.icm.edu.pl1.5 MB45.6 KB2.1 MB3.6 MB 41%60.4 KB
3localhost16.6 KB0.0 KB0.0 KB16.6 KB100%1.5 KB
TOTAL: 3292.7 GB1.0 MB3.5 MB292.7 GB 99%443.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 20 04:15:02 - 04:59:59 19191 2.8% 7.119.9 GB 3.4%3846.97
Oct 20 05:00:00 - 05:59:59 24678 3.6% 6.8613.2 GB 4.5%3832.14
Oct 20 06:00:00 - 06:59:59 24971 3.6% 6.9413.4 GB 4.6%3911.85
Oct 20 07:00:00 - 07:59:59 24906 3.6% 6.9212.7 GB 4.3%3688.26
Oct 20 08:00:00 - 08:59:59 24878 3.6% 6.9112.0 GB 4.1%3490.22
Oct 20 09:00:00 - 09:59:59 27183 3.9% 7.5511.6 GB 3.9%3366.42
Oct 20 10:00:00 - 10:59:59 24277 3.5% 6.7410.9 GB 3.7%3163.83
Oct 20 11:00:00 - 11:59:59 25215 3.6% 7.0011.1 GB 3.8%3228.50
Oct 20 12:00:00 - 12:59:59 26170 3.8% 7.2712.1 GB 4.1%3538.75
Oct 20 13:00:00 - 13:59:59 26200 3.8% 7.2811.6 GB 4.0%3372.18
Oct 20 14:00:00 - 14:59:59 24009 3.5% 6.6711.4 GB 3.9%3313.59
Oct 20 15:00:00 - 15:59:59 26790 3.9% 7.4412.6 GB 4.3%3668.39
Oct 20 16:00:00 - 16:59:59 25672 3.7% 7.1311.8 GB 4.0%3449.13
Oct 20 17:00:00 - 17:59:59 27483 4.0% 7.6312.9 GB 4.4%3758.41
Oct 20 18:00:00 - 18:59:59 27852 4.0% 7.7412.1 GB 4.1%3513.52
Oct 20 19:00:00 - 19:59:59 35014 5.1% 9.7311.2 GB 3.8%3272.02
Oct 20 20:00:00 - 20:59:59 33961 4.9% 9.4311.0 GB 3.8%3210.47
Oct 20 21:00:00 - 21:59:59 32546 4.7% 9.0411.4 GB 3.9%3334.45
Oct 20 22:00:00 - 22:59:59 33635 4.9% 9.3411.2 GB 3.8%3268.19
Oct 20 23:00:00 - 23:59:59 36350 5.3% 10.1011.9 GB 4.1%3478.15
Oct 21 00:00:00 - 00:59:59 34194 4.9% 9.5013.2 GB 4.5%3830.30
Oct 21 01:00:00 - 01:59:59 33550 4.9% 9.3213.5 GB 4.6%3921.46
Oct 21 02:00:00 - 02:59:59 32780 4.7% 9.1113.4 GB 4.6%3913.78
Oct 21 03:00:00 - 03:59:59 32851 4.7% 9.1313.5 GB 4.6%3943.53
Oct 21 04:00:00 - 04:15:02 7329 1.1% 8.133.3 GB 1.1%3864.11
TOTAL: 24:00:00 691685 100.0% 8.01292.9 GB 100.0%3554.95
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 665 184 0 18 12 0 0 0 451
2news.icm.edu.pl 34 0 0 2 0 0 0 0 32
TOTAL: 2 699 184 0 20 12 0 0 0 483

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 69
it.tlc.cellulari.android 40
comp.sys.raspberry-pi 29
it.comp.os.win.windows10 22
comp.mobile.android 12
de.rec.sf.startrek 9
it.comp.os.win.windows7 2
hr.rec.glazba.hifi 1
TOTAL: 8 184

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

GroupsCount
pl.praca.oferowana 9
pl.sci.matematyka 3
TOTAL: 2 12

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 26
Binary in non-binary group 6
TOTAL: 2 32

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 24136 532 13644 221 0 0 2%23:50:02
2panorama 35961 511 13570 175 5 35004 1%23:58:59
3poznan 23 0 20 0 0 0 0%02:51:49
4nask 0 0 0 0 0 9657 0%23:40:00
5okapi 0 0 0 0 0 981 0%23:40:00
TOTAL: 5 60120 1043 27234 396 5 45642 1%98:00:50
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.5 MB70.1 MB71.6 MB0.9 KB/s97.4 KB23:50:02
2panorama1.3 MB744.7 KB2.1 MB0.0 KB/s3.1 KB23:58:59
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:51:49
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:40:00
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:40:00
TOTAL: 52.9 MB70.8 MB73.7 MB0.2 KB/s52.4 KB98:00:50
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2426.9 KB 12 0 000:00:23
2109.63.165.59 8 1116.7 KB 5 0 000:01:13
3isvcs01.man.lodz.pl 11 00.0 KB 0 11 000:00:01
TOTAL: 3 307 3543.6 KB 17 11 000:03:32

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 587 2426.9 KB 12 11 000:00:32
2unresolved 113 1116.7 KB 5 0 000:02:58
3*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
4*.internet-census.org 6 00.0 KB 0 0 000:00:01
TOTAL: 4 708 3543.6 KB 17 11 000:03:32

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
176.105.137.143 0.011 0.007 0.00000:01:29
109.63.165.59 0.045 0.108 0.00000:01:13
web.man.lodz.pl 1.700 3.537 0.00000:00:23
192.241.238.239 0.004 0.018 0.00000:00:09
mon.man.lodz.pl 2.187 4.875 0.00000:00:08
80.111.142.213 0.028 0.035 0.00000:00:03
sh-ams-nl-gp1-wk104.internet-census.org 0.033 0.071 0.00000:00:01
212.51.192.185 0.493 0.814 0.00000:00:01
isvcs01.man.lodz.pl 0.088 0.122 0.00000:00:01
scanner-05.ch1.censys-scanner.com 0.015 0.030 0.00000:00:00
185.156.72.31 0.004 0.012 0.00000:00:00
? 0.000 0.006 0.00000:00:00
TOTAL: 12 4.608 9.635 0.00000:03:32

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
sh-ams-nl-gp1-wk104.internet-census.org 6
80.111.142.213 4
176.105.137.143 2
scanner-05.ch1.censys-scanner.com 2
185.156.72.31 2
192.241.238.239 1
TOTAL: 8 401

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
sh-ams-nl-gp1-wk104.internet-census.org 10
185.156.72.31 2
scanner-05.ch1.censys-scanner.com 1
TOTAL: 3 13

NNRP unrecognized commands (by command):

CommandCount
EHLO sh-ams-nl-gp1-wk104.internet-census... 2
#003 2
Host: 212.191.2.21:119 1
#026#003#001 1
SSH-2.0-Go 1
Accept: */* 1
Accept-Encoding: gzip 1
#001 1
GET / HTTP/1.1 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
EHLO www.censys.io 1
TOTAL: 11 13

NNRP client timeouts [Top 20]:

SystemConnPeer
185.156.72.31 2 2
TOTAL: 1 2 3

Newsgroup request counts (by category):

CategoryCountPct
1pl 24 68.6%
2lodman 11 31.4%
TOTAL: 2 35100.0%

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

NewsgroupCount
1pl.comp.pecet 22
2lodman.info 11
3pl.comp.os.ms-windows.winnt 2
TOTAL: 3 35