Daily Usenet report

Jun 18 04:15:02 -- Jun 19 04:15:02

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

Jun 18 06:32:30 newsfeed overchan[24469]: input line too long, skipping
Jun 18 13:57:41 newsfeed overchan[24469]: input line too long, skipping
Jun 18 15:58:42 newsfeed nnrpd[5916]: SERVER perl filter not defined
Jun 18 15:59:40 newsfeed nnrpd[6035]: SERVER perl filter not defined
Jun 18 16:00:30 newsfeed nnrpd[6189]: SERVER perl filter not defined
Jun 18 16:03:29 newsfeed nnrpd[6686]: SERVER perl filter not defined
Jun 18 16:06:58 newsfeed overchan[24469]: input line too long, skipping
Jun 18 16:07:43 newsfeed nnrpd[7376]: SERVER perl filter not defined
Jun 18 16:08:44 newsfeed nnrpd[7487]: SERVER perl filter not defined
Jun 18 17:10:21 newsfeed overchan[24469]: input line too long, skipping
Jun 18 17:51:37 newsfeed nnrpd[23457]: SERVER perl filter not defined
Jun 18 17:53:40 newsfeed nnrpd[23781]: SERVER perl filter not defined
Jun 18 17:54:16 newsfeed nnrpd[23857]: SERVER perl filter not defined
Jun 18 17:54:31 newsfeed nnrpd[23860]: SERVER perl filter not defined
Jun 18 18:07:51 newsfeed overchan[24469]: input line too long, skipping
Jun 18 20:03:21 newsfeed overchan[24469]: input line too long, skipping
Jun 18 20:07:41 newsfeed overchan[24469]: input line too long, skipping
Jun 18 23:12:44 newsfeed overchan[24469]: input line too long, skipping
Jun 19 01:09:49 newsfeed nnrpd[26423]: unable to get certificate from '/etc/news/cert.pem'
Jun 19 01:09:49 newsfeed nnrpd[26423]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]

Log entries by program:

Program nameLines%LinesSize%Size
inn 648046 97.8%70.4 MB 97.5%
innd 9075 1.4%1.2 MB 1.7%
nnrpd 4266 0.6%421.6 KB 0.6%
innfeed 1302 0.2%167.5 KB 0.2%
overchan 10 0.0%1.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 662700 100.0%72.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 644699 99.4%
Negative hits 3805 0.6%
Positive hits 237 0.0%
Cache misses 27 0.0%
TOTAL: 4 648768 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.906 0.0%45 0.000 20.133 74.000
article cleanup00:00:04.628 0.0%647812 0.003 0.007 0.011
article logging00:00:15.066 0.0%648123 0.014 0.023 0.033
article parse00:08:54.244 0.6%83143178 0.005 0.006 0.009
article write00:04:46.911 0.3%647671 0.254 0.443 2.452
artlog/artcncl00:00:00.000 0.0%45 0.000 0.000 0.000
data move00:00:29.925 0.0%88208352 0.000 0.000 0.000
hisgrep/artcncl00:00:00.259 0.0%45 0.000 5.756 20.000
hishave/artcncl00:00:00.041 0.0%45 0.000 0.911 4.333
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:29:07.429 2.0%651965 0.229 2.680 27.392
history sync00:00:00.009 0.0%291 0.000 0.031 0.500
history write00:54:48.733 3.8%647786 0.799 5.077 42.225
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle21:09:20.507 88.1%82665097 0.636 0.921 1.625
nntp read00:21:06.321 1.5%82808814 0.014 0.015 0.019
overview write00:00:01.857 0.0%647671 0.001 0.003 0.006
perl filter00:38:45.799 2.7%647786 2.756 3.590 4.551
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:16.209 0.0%1306005 0.008 0.012 0.017
TOTAL: 24:00:06.98323:47:58.844 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%10660 0.000 0.002 0.029
article prepare00:00:00.000 0.0%2908 0.000 0.000 0.000
article read00:00:00.027 0.0%727 0.000 0.037 0.500
backlog stats00:00:00.029 0.0%56292 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.225 0.0%28045 0.000 0.008 0.037
data write00:00:00.539 0.0%17550 0.000 0.031 0.095
idle23:57:29.736100.0%56292 780.582 1532.185 4057.831
status file00:00:22.747 0.0%312 0.000 72.907 10928.000
TOTAL: 23:57:54.11223:57:53.328100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:17.883 69.4%3116 0.000 5.739 9790.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.095 0.4%6819 0.000 0.014 0.500
readart00:00:00.001 0.0%28 0.000 0.036 0.500
TOTAL: 00:00:25.77500:00:17.979 69.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 161 647417 647292 1 124 99%80:46:14
2news.icm.edu.pl 48 232 23 192 17 9%15:20:42
3localhost 1451 10 10 0 0 100%00:00:00
TOTAL: 3 1660 647659 647325 193 141 99%96:06:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl287.4 GB1.9 MB2.1 MB287.4 GB 99%465.4 KB
2news.icm.edu.pl1.6 MB8.4 KB277.3 KB1.9 MB 85%47.6 KB
3localhost16.3 KB0.0 KB0.0 KB16.3 KB100%1.6 KB
TOTAL: 3287.4 GB1.9 MB2.4 MB287.4 GB 99%465.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 18 04:15:02 - 04:59:59 17927 2.8% 6.649.3 GB 3.2%3607.52
Jun 18 05:00:00 - 05:59:59 24325 3.8% 6.7613.0 GB 4.5%3793.73
Jun 18 06:00:00 - 06:59:59 21844 3.4% 6.0711.6 GB 4.0%3378.80
Jun 18 07:00:00 - 07:59:59 24626 3.8% 6.8412.4 GB 4.3%3615.34
Jun 18 08:00:00 - 08:59:59 24239 3.7% 6.7312.0 GB 4.2%3492.64
Jun 18 09:00:00 - 09:59:59 25640 4.0% 7.1211.4 GB 4.0%3325.55
Jun 18 10:00:00 - 10:59:59 28894 4.5% 8.0311.5 GB 4.0%3350.64
Jun 18 11:00:00 - 11:59:59 25750 4.0% 7.1511.4 GB 4.0%3331.85
Jun 18 12:00:00 - 12:59:59 28631 4.4% 7.9511.2 GB 3.9%3251.68
Jun 18 13:00:00 - 13:59:59 28929 4.5% 8.0412.1 GB 4.2%3517.11
Jun 18 14:00:00 - 14:59:59 33197 5.1% 9.2212.4 GB 4.3%3616.45
Jun 18 15:00:00 - 15:59:59 29966 4.6% 8.3211.6 GB 4.0%3369.76
Jun 18 16:00:00 - 16:59:59 27258 4.2% 7.5712.3 GB 4.3%3585.02
Jun 18 17:00:00 - 17:59:59 29699 4.6% 8.2512.2 GB 4.2%3549.63
Jun 18 18:00:00 - 18:59:59 34542 5.3% 9.6011.6 GB 4.0%3367.62
Jun 18 19:00:00 - 19:59:59 30194 4.7% 8.3912.0 GB 4.2%3485.03
Jun 18 20:00:00 - 20:59:59 30158 4.7% 8.3812.6 GB 4.4%3655.63
Jun 18 21:00:00 - 21:59:59 25533 3.9% 7.0911.9 GB 4.1%3451.84
Jun 18 22:00:00 - 22:59:59 27595 4.3% 7.6713.0 GB 4.5%3788.48
Jun 18 23:00:00 - 23:59:59 25649 4.0% 7.1212.8 GB 4.5%3738.87
Jun 19 00:00:00 - 00:59:59 23919 3.7% 6.6412.0 GB 4.2%3487.75
Jun 19 01:00:00 - 01:59:59 28201 4.4% 7.8312.3 GB 4.3%3577.55
Jun 19 02:00:00 - 02:59:59 23377 3.6% 6.4911.6 GB 4.0%3391.50
Jun 19 03:00:00 - 03:59:59 22120 3.4% 6.1411.3 GB 3.9%3296.30
Jun 19 04:00:00 - 04:15:02 5335 0.8% 5.912.9 GB 1.0%3363.91
TOTAL: 24:00:00 647548 100.0% 7.49288.3 GB 100.0%3498.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 435 97 0 25 2 0 0 0 311
2news.icm.edu.pl 18 0 0 1 0 0 0 0 17
TOTAL: 2 453 97 0 26 2 0 0 0 328

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 49
it.comp.os.win.windows10 14
comp.mobile.android 12
comp.sys.raspberry-pi 6
alt.comp.software.firefox 4
alt.comp.software.seamonkey 4
it.comp.os.linux.ubuntu 2
nl.comp.os.linux.techniek 2
de.comp.office-pakete.ms-office.word 2
it.tlc.cellulari.android 2
TOTAL: 10 97

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

GroupsCount
pl.praca.oferowana 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 10
Binary in non-binary group 4
Scoring filter (8) 2
TOTAL: 3 16

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 16860 695 9625 34 0 0 4%24:09:16
2poznan 14 0 9 0 0 0 0%01:10:40
3nask 0 0 0 0 0 7159 0%24:05:36
4panorama 0 0 0 0 0 10697 0%24:09:56
5okapi 0 0 0 0 0 484 0%24:05:36
TOTAL: 5 16874 695 9634 34 0 18340 4%97:41:04
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.4 MB89.1 KB2.5 MB0.0 KB/s3.5 KB24:09:16
2poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:10:40
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:36
4panorama0.0 KB0.0 KB0.0 KB0.0 KB/s024:09:56
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:36
TOTAL: 52.4 MB89.1 KB2.5 MB0.0 KB/s3.5 KB97:41:04
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama488.3 KB
TOTAL: 1488.3 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 2822.9 KB 14 0 000:00:08
2isvcs01.man.lodz.pl 10 00.0 KB 0 10 000:00:00
TOTAL: 2 298 2822.9 KB 14 10 000:00:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 586 2822.9 KB 14 10 000:00:12
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3unresolved 102 00.0 KB 0 0 000:00:12
4*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 4 690 2822.9 KB 14 10 000:00:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.241.205.10 0.000 0.007 0.00000:00:09
web.man.lodz.pl 0.780 1.473 0.00000:00:08
mon.man.lodz.pl 0.847 1.312 0.00000:00:02
80.111.142.213 0.024 0.009 0.00000:00:02
isvcs01.man.lodz.pl 0.033 0.070 0.00000:00:00
212.51.192.185 0.241 0.467 0.00000:00:00
scan-141.security.ipip.net 0.004 0.004 0.00000:00:00
scanner-08.ch1.censys-scanner.com 0.004 0.004 0.00000:00:00
45.227.254.18 0.000 0.007 0.00000:00:00
TOTAL: 9 1.933 3.353 0.00000:00:25

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
45.227.254.18 1
scan-141.security.ipip.net 1
scanner-08.ch1.censys-scanner.com 1
192.241.205.10 1
TOTAL: 7 392

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
45.227.254.18 1
scanner-08.ch1.censys-scanner.com 1
TOTAL: 3 6

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
45.227.254.18 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 28100.0%
TOTAL: 1 28100.0%

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

NewsgroupCount
1pl.comp.pecet 14
2pl.comp.os.ms-windows.winnt 14
TOTAL: 2 28