Daily Usenet report

Apr 20 04:15:02 -- Apr 21 04:15:02

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Apr 20 09:40:34 newsfeed nnrpd[25901]: SERVER perl filter not defined
Apr 20 09:41:42 newsfeed nnrpd[26039]: SERVER perl filter not defined
Apr 20 09:42:44 newsfeed nnrpd[26162]: SERVER perl filter not defined
Apr 20 09:44:18 newsfeed nnrpd[26289]: SERVER perl filter not defined
Apr 20 09:44:55 newsfeed nnrpd[26407]: SERVER perl filter not defined
Apr 20 09:45:41 newsfeed nnrpd[26603]: SERVER perl filter not defined
Apr 20 09:45:52 newsfeed nnrpd[26613]: SERVER perl filter not defined
Apr 20 12:20:57 newsfeed nnrpd[18237]: SERVER perl filter not defined
Apr 20 12:32:27 newsfeed nnrpd[19902]: SERVER perl filter not defined
Apr 20 12:50:02 newsfeed nnrpd[22696]: SERVER perl filter not defined
Apr 20 12:50:31 newsfeed nnrpd[22714]: SERVER perl filter not defined
Apr 20 13:05:32 newsfeed nnrpd[25000]: SERVER perl filter not defined
Apr 20 14:08:33 newsfeed nnrpd[2661]: unable to get certificate from '/etc/news/cert.pem'
Apr 20 14:08:33 newsfeed nnrpd[2661]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Apr 20 15:27:13 newsfeed nnrpd[14870]: SERVER perl filter not defined
Apr 20 17:29:44 newsfeed overchan[7459]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 748445 92.4%81.3 MB 91.5%
innfeed 48227 6.0%5.7 MB 6.4%
innd 9056 1.1%1.4 MB 1.6%
nnrpd 4344 0.5%438.7 KB 0.5%
overchan 2 0.0%0.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 810075 100.0%88.8 MB100.0%

History cache:

ReasonCount%Count
Do not exist 744275 99.6%
Negative hits 2216 0.3%
Positive hits 368 0.0%
Cache misses 37 0.0%
TOTAL: 4 746896 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.097 0.0%55 0.000 19.945 156.000
article cleanup00:00:11.185 0.0%748726 0.009 0.015 0.021
article logging00:00:38.357 0.0%749225 0.043 0.051 0.061
article parse00:22:29.422 1.6%54831545 0.017 0.025 0.032
article write00:08:55.106 0.6%748412 0.454 0.715 0.996
artlog/artcncl00:00:00.002 0.0%54 0.000 0.037 1.000
data move00:00:47.466 0.1%59959932 0.001 0.001 0.001
hisgrep/artcncl00:00:00.241 0.0%54 0.000 4.463 22.000
hishave/artcncl00:00:00.118 0.0%55 0.000 2.145 12.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:31:27.501 2.2%751289 0.196 2.512 12.017
history sync00:00:00.023 0.0%291 0.000 0.079 1.000
history write00:16:19.581 1.1%748570 0.342 1.309 4.315
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle20:27:32.932 85.2%54231310 1.126 1.358 2.388
nntp read00:35:41.213 2.5%54352051 0.028 0.039 0.052
overview write00:00:04.369 0.0%748412 0.002 0.006 0.010
perl filter01:21:28.880 5.7%748570 4.693 6.531 8.711
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:43.691 0.1%1511279 0.022 0.029 0.037
TOTAL: 24:00:03.37323:46:21.184 99.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.188 0.0%58734 0.000 0.003 0.014
article prepare00:00:00.003 0.0%10908 0.000 0.000 0.021
article read00:00:17.742 0.0%2726 0.000 6.508 113.000
backlog stats00:00:00.121 0.0%133225 0.000 0.001 0.004
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.133 0.0%65008 0.000 0.017 0.037
data write00:00:02.927 0.0%50624 0.023 0.058 0.101
idle23:53:34.515 99.9%133225 67.066 645.633 1227.871
status file00:00:51.722 0.1%16904 0.699 3.060 161.525
TOTAL: 23:54:54.91623:54:48.351100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:23.018 63.6%3168 0.000 7.266 226.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.266 0.7%6981 0.000 0.038 1.000
readart00:00:00.003 0.0%56 0.000 0.054 0.500
TOTAL: 00:00:36.19800:00:23.287 64.3%----

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 41 747906 747610 0 296 99%53:31:07
2news.icm.edu.pl 43 369 156 196 17 42%16:29:45
3localhost 1454 13 13 0 0 100%00:00:00
TOTAL: 3 1538 748288 747779 196 313 99%70:00:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl312.0 GB12.6 MB13.1 MB312.0 GB 99%437.5 KB
2news.icm.edu.pl12.7 MB285.3 KB914.3 KB13.9 MB 91%82.2 KB
3localhost18.9 KB0.0 KB0.0 KB18.9 KB100%1.5 KB
TOTAL: 3312.0 GB12.9 MB14.0 MB312.1 GB 99%437.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 20 04:15:02 - 04:59:59 21522 2.9% 7.989.6 GB 3.1%3713.83
Apr 20 05:00:00 - 05:59:59 31341 4.2% 8.7113.5 GB 4.3%3931.82
Apr 20 06:00:00 - 06:59:59 25518 3.4% 7.0912.6 GB 4.0%3659.54
Apr 20 07:00:00 - 07:59:59 27846 3.7% 7.7413.6 GB 4.3%3952.12
Apr 20 08:00:00 - 08:59:59 32092 4.3% 8.9113.4 GB 4.3%3901.98
Apr 20 09:00:00 - 09:59:59 34793 4.7% 9.6612.7 GB 4.0%3684.98
Apr 20 10:00:00 - 10:59:59 30913 4.1% 8.5911.1 GB 3.5%3231.76
Apr 20 11:00:00 - 11:59:59 34720 4.6% 9.6413.9 GB 4.5%4054.43
Apr 20 12:00:00 - 12:59:59 33179 4.4% 9.2213.9 GB 4.4%4039.74
Apr 20 13:00:00 - 13:59:59 33579 4.5% 9.3314.2 GB 4.5%4141.80
Apr 20 14:00:00 - 14:59:59 29828 4.0% 8.2914.2 GB 4.5%4139.40
Apr 20 15:00:00 - 15:59:59 34814 4.7% 9.6714.2 GB 4.5%4130.54
Apr 20 16:00:00 - 16:59:59 36634 4.9% 10.1814.4 GB 4.6%4193.97
Apr 20 17:00:00 - 17:59:59 35908 4.8% 9.9713.0 GB 4.2%3793.48
Apr 20 18:00:00 - 18:59:59 34278 4.6% 9.5212.7 GB 4.1%3700.69
Apr 20 19:00:00 - 19:59:59 36638 4.9% 10.1812.2 GB 3.9%3543.27
Apr 20 20:00:00 - 20:59:59 36085 4.8% 10.0214.0 GB 4.5%4080.33
Apr 20 21:00:00 - 21:59:59 34658 4.6% 9.6313.1 GB 4.2%3803.48
Apr 20 22:00:00 - 22:59:59 35475 4.7% 9.8512.0 GB 3.8%3492.20
Apr 20 23:00:00 - 23:59:59 28117 3.8% 7.8112.6 GB 4.0%3669.11
Apr 21 00:00:00 - 00:59:59 25365 3.4% 7.0512.7 GB 4.1%3698.20
Apr 21 01:00:00 - 01:59:59 25114 3.4% 6.9813.5 GB 4.3%3925.20
Apr 21 02:00:00 - 02:59:59 23257 3.1% 6.4612.1 GB 3.9%3512.45
Apr 21 03:00:00 - 03:59:59 21007 2.8% 5.8411.1 GB 3.6%3240.87
Apr 21 04:00:00 - 04:15:02 4899 0.7% 5.432.7 GB 0.8%3088.09
TOTAL: 24:00:00 747580 100.0% 8.65312.7 GB 100.0%3794.93
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 792 134 0 153 9 0 0 0 496
2news.icm.edu.pl 19 0 0 3 0 0 0 0 16
TOTAL: 2 811 134 0 156 9 0 0 0 512

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 73
it.tlc.cellulari.android 22
alt.comp.software.firefox 21
it.discussioni.energia 5
it.comp.os.win.windows10 4
comp.mobile.android 3
de.rec.sf.startrek 3
de.comp.lang.vbclassic 2
comp.sys.raspberry-pi 1
TOTAL: 9 134

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

GroupsCount
pl.praca.oferowana 7
pl.sci.matematyka 2
TOTAL: 2 9

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11
Binary in non-binary group 3
Too many newsgroups 1
TOTAL: 3 15

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 46784 822 17192 880 2 39987 1%23:59:58
2icm 23186 441 13558 36 0 0 1%23:59:58
3okapi 0 0 0 0 0 724 0%23:57:49
4poznan 83 0 64 0 0 0 0%05:58:38
5nask 0 0 0 0 0 9494 0%23:57:47
TOTAL: 5 70053 1263 30814 916 2 50205 1%101:54:10
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama2.1 MB3.7 MB5.8 MB0.1 KB/s3.5 KB23:59:58
2icm1.2 MB98.5 KB1.3 MB0.0 KB/s2.8 KB23:59:58
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:49
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s005:58:38
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 53.3 MB3.8 MB7.1 MB0.0 KB/s3.3 KB101:54:10
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 294 5655.0 KB 27 0 000:00:24
2isvcs01.man.lodz.pl 13 00.0 KB 0 13 000:00:01
TOTAL: 2 307 5655.0 KB 27 13 000:00:35

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 595 5655.0 KB 27 13 000:00:29
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3unresolved 103 00.0 KB 0 0 000:00:05
4*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 4 700 5655.0 KB 27 13 000:00:35

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.951 3.845 0.00000:00:24
mon.man.lodz.pl 1.619 2.814 0.00000:00:03
80.111.142.213 0.018 0.060 0.00000:00:03
isvcs01.man.lodz.pl 0.115 0.145 0.00000:00:01
212.51.192.185 0.485 0.891 0.00000:00:01
20.46.160.204 0.019 0.035 0.00000:00:01
scanner-04.ch1.censys-scanner.com 0.016 0.005 0.00000:00:00
scan-141.security.ipip.net 0.003 0.007 0.00000:00:00
TOTAL: 8 4.226 7.802 0.00000:00:35

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
20.46.160.204 3
scan-141.security.ipip.net 1
scanner-04.ch1.censys-scanner.com 1
TOTAL: 6 393

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
20.46.160.204 3
scanner-04.ch1.censys-scanner.com 1
TOTAL: 3 8

NNRP unrecognized commands (by command):

CommandCount
#003 3
GET / HTTP/1.1 1
Connection: close 1
Host: 212.191.2.21:119 1
EHLO www.censys.io 1
User-Agent: HTTP Banner Detection (https... 1
TOTAL: 6 8

NNRP client timeouts [Top 20]:

SystemConnPeer
20.46.160.204 3 3
TOTAL: 1 3 3

Newsgroup request counts (by category):

CategoryCountPct
1pl 56100.0%
TOTAL: 1 56100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 32
2pl.comp.pecet 24
TOTAL: 2 56