Daily Usenet report

Aug 4 04:15:01 -- Aug 5 04:15:01

Unknown entries from news log file:

First 24 / 24 lines (100.0%)

Aug 4 08:51:05 newsfeed overchan[11192]: input line too long, skipping
Aug 4 10:53:29 newsfeed nnrpd[6718]: SERVER perl filter not defined
Aug 4 12:18:56 newsfeed nnrpd[19457]: SERVER perl filter not defined
Aug 4 12:19:08 newsfeed nnrpd[19458]: SERVER perl filter not defined
Aug 4 13:24:54 newsfeed overchan[11192]: input line too long, skipping
Aug 4 13:30:51 newsfeed overchan[11192]: input line too long, skipping
Aug 4 13:38:45 newsfeed overchan[11192]: input line too long, skipping
Aug 4 13:47:52 newsfeed overchan[11192]: input line too long, skipping
Aug 4 14:21:33 newsfeed overchan[11192]: input line too long, skipping
Aug 4 14:26:34 newsfeed overchan[11192]: input line too long, skipping
Aug 4 14:31:01 newsfeed overchan[11192]: input line too long, skipping
Aug 4 14:41:36 newsfeed overchan[11192]: input line too long, skipping
Aug 4 14:47:12 newsfeed overchan[11192]: input line too long, skipping
Aug 4 14:58:51 newsfeed overchan[11192]: input line too long, skipping
Aug 4 14:59:22 newsfeed overchan[11192]: input line too long, skipping
Aug 4 15:10:59 newsfeed overchan[11192]: input line too long, skipping
Aug 4 15:33:16 newsfeed overchan[11192]: input line too long, skipping
Aug 4 15:38:16 newsfeed overchan[11192]: input line too long, skipping
Aug 4 15:56:38 newsfeed overchan[11192]: input line too long, skipping
Aug 4 16:07:08 newsfeed nnrpd[21235]: unable to get certificate from '/etc/news/cert.pem'
Aug 4 16:07:08 newsfeed nnrpd[21235]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Aug 4 17:40:37 newsfeed overchan[11192]: input line too long, skipping
Aug 4 19:11:51 newsfeed overchan[11192]: input line too long, skipping
Aug 5 01:24:54 newsfeed overchan[11192]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 211372 85.2%23.1 MB 83.9%
innfeed 26758 10.8%3.2 MB 11.5%
innd 6660 2.7%1000.2 KB 3.5%
nnrpd 3337 1.3%310.0 KB 1.1%
overchan 19 0.0%3.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 248147 100.0%27.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 209849 99.4%
Negative hits 918 0.4%
Positive hits 256 0.1%
Cache misses 31 0.0%
TOTAL: 4 211054 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.004 0.0%77 0.000 26.026 142.500
article cleanup00:00:01.693 0.0%210949 0.003 0.008 0.014
article logging00:00:05.983 0.0%211370 0.016 0.028 0.047
article parse00:02:32.995 0.2%19832918 0.007 0.008 0.009
article write00:01:10.686 0.1%210741 0.184 0.335 2.814
artlog/artcncl00:00:00.004 0.0%77 0.000 0.052 0.500
data move00:00:10.240 0.0%21180728 0.000 0.000 0.001
hisgrep/artcncl00:00:00.386 0.0%77 0.000 5.013 32.000
hishave/artcncl00:00:00.298 0.0%77 0.000 3.870 67.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:21:37.261 1.5%212059 2.877 6.117 24.229
history sync00:00:00.020 0.0%315 0.000 0.063 0.500
history write00:30:48.586 2.1%210930 5.920 8.764 29.853
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:43:17.093 94.6%19904684 3.268 4.109 5.255
nntp read00:06:33.661 0.5%19791342 0.018 0.020 0.022
overview write00:00:00.652 0.0%210741 0.000 0.003 0.007
perl filter00:10:59.363 0.8%210930 2.051 3.126 4.051
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:06.573 0.0%433636 0.009 0.015 0.021
TOTAL: 24:00:33.80023:57:27.498 99.8%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.048 0.0%37248 0.000 0.001 0.008
article prepare00:00:00.000 0.0%1748 0.000 0.000 0.000
article read00:00:00.512 0.0%437 0.000 1.172 80.500
backlog stats00:00:00.047 0.0%81625 0.000 0.001 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.407 0.0%41391 0.000 0.010 0.041
data write00:00:00.892 0.0%29360 0.005 0.030 0.066
idle23:56:42.471100.0%81625 576.464 1056.079 2222.560
status file00:00:16.393 0.0%8663 0.350 1.892 121.000
TOTAL: 23:57:03.03623:57:00.770100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:08.878 50.6%2763 0.000 3.213 151.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.080 0.5%5880 0.000 0.014 0.500
readart00:00:00.004 0.0%32 0.000 0.125 0.500
TOTAL: 00:00:17.53500:00:08.962 51.1%----

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 87 210860 210658 1 201 99%58:48:27
2news.icm.edu.pl 47 220 22 191 7 10%17:04:52
3localhost 1444 3 3 0 0 100%00:00:00
TOTAL: 3 1578 211083 210683 192 208 99%75:53:19
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl63.5 GB1.1 MB1.6 MB63.5 GB 99%315.6 KB
2news.icm.edu.pl1.3 MB21.2 KB85.0 KB1.4 MB 92%48.7 KB
3localhost4.3 KB0.0 KB0.0 KB4.3 KB100%1.4 KB
TOTAL: 363.5 GB1.2 MB1.7 MB63.5 GB 99%315.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 4 04:15:01 - 04:59:59 5838 2.8% 2.162.0 GB 3.2% 780.53
Aug 4 05:00:00 - 05:59:59 7443 3.5% 2.072.7 GB 4.2% 785.13
Aug 4 06:00:00 - 06:59:59 7508 3.6% 2.092.6 GB 4.1% 755.68
Aug 4 07:00:00 - 07:59:59 8393 4.0% 2.332.8 GB 4.4% 812.74
Aug 4 08:00:00 - 08:59:59 9513 4.5% 2.642.7 GB 4.3% 793.72
Aug 4 09:00:00 - 09:59:59 10133 4.8% 2.812.8 GB 4.5% 829.64
Aug 4 10:00:00 - 10:59:59 10516 5.0% 2.923.0 GB 4.8% 883.37
Aug 4 11:00:00 - 11:59:59 9557 4.5% 2.652.7 GB 4.2% 781.93
Aug 4 12:00:00 - 12:59:59 9050 4.3% 2.512.8 GB 4.3% 801.89
Aug 4 13:00:00 - 13:59:59 12804 6.1% 3.562.7 GB 4.3% 793.14
Aug 4 14:00:00 - 14:59:59 10169 4.8% 2.822.7 GB 4.3% 798.81
Aug 4 15:00:00 - 15:59:59 6693 3.2% 1.862.5 GB 3.9% 718.65
Aug 4 16:00:00 - 16:59:59 9448 4.5% 2.622.7 GB 4.3% 796.54
Aug 4 17:00:00 - 17:59:59 8757 4.2% 2.432.7 GB 4.2% 773.90
Aug 4 18:00:00 - 18:59:59 9361 4.4% 2.602.7 GB 4.3% 789.90
Aug 4 19:00:00 - 19:59:59 7929 3.8% 2.202.5 GB 3.9% 726.97
Aug 4 20:00:00 - 20:59:59 9245 4.4% 2.572.6 GB 4.0% 743.62
Aug 4 21:00:00 - 21:59:59 8961 4.3% 2.492.7 GB 4.3% 786.69
Aug 4 22:00:00 - 22:59:59 8746 4.2% 2.432.7 GB 4.2% 782.17
Aug 4 23:00:00 - 23:59:59 8314 3.9% 2.312.5 GB 4.0% 735.14
Aug 5 00:00:00 - 00:59:59 8250 3.9% 2.292.5 GB 3.9% 718.04
Aug 5 01:00:00 - 01:59:59 7422 3.5% 2.062.4 GB 3.8% 699.08
Aug 5 02:00:00 - 02:59:59 7515 3.6% 2.092.4 GB 3.8% 699.20
Aug 5 03:00:00 - 03:59:59 7385 3.5% 2.052.5 GB 4.0% 739.40
Aug 5 04:00:00 - 04:15:01 1717 0.8% 1.91583.3 MB 0.9% 662.96
TOTAL: 24:00:00 210667 100.0% 2.4463.5 GB 100.0% 770.69
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 620 180 0 17 4 0 0 0 419
2news.icm.edu.pl 8 0 0 2 0 0 0 0 6
TOTAL: 2 628 180 0 19 4 0 0 0 425

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 77
comp.mobile.android 28
it.comp.os.win.windows10 24
it.tlc.cellulari.android 20
comp.sys.raspberry-pi 15
alt.comp.software.firefox 8
de.rec.sf.startrek 3
comp.mobile.ipad 2
nl.comp.os.linux.techniek 2
it.tlc.cellulari.iphone 1
TOTAL: 10 180

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

GroupsCount
pl.praca.oferowana 4
TOTAL: 1 4

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 3
Too many newsgroups 2
TOTAL: 2 5

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 15604 262 11535 25 0 0 1%23:54:48
2panorama 25363 4 11097 63 0 26170 0%23:59:36
3poznan 15 0 12 0 0 0 0%01:50:53
4nask 0 0 0 0 0 7887 0%23:50:02
5okapi 0 0 0 0 0 505 0%23:50:02
TOTAL: 5 40982 266 22644 88 0 34562 0%97:25:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm929.6 KB74.7 KB1004.3 KB0.0 KB/s3.5 KB23:54:48
2panorama8.6 KB376.7 KB385.3 KB0.0 KB/s5.8 KB23:59:36
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:50:53
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:02
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:02
TOTAL: 5938.2 KB451.4 KB1.4 MB0.0 KB/s3.9 KB97:25:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 3231.8 KB 15 0 000:00:11
2isvcs01.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 2 291 3231.8 KB 15 3 000:00:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 291 3231.8 KB 15 3 000:00:11
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3*.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
4unresolved 100 00.0 KB 0 0 000:00:04
5*.security.ipip.net 1 00.0 KB 0 0 000:00:00
TOTAL: 5 394 3231.8 KB 15 3 000:00:17

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.919 1.324 0.00000:00:11
80.111.142.213 0.007 0.038 0.00000:00:03
212.51.192.185 0.316 0.385 0.00000:00:01
scan-141.security.ipip.net 0.006 0.000 0.00000:00:00
scanner-09.ch1.censys-scanner.com 0.011 0.000 0.00000:00:00
ec2-54-183-163-32.us-west-1.compute.amazonaws.com 0.004 0.004 0.00000:00:00
isvcs01.man.lodz.pl 0.007 0.026 0.00000:00:00
TOTAL: 7 1.270 1.777 0.00000:00:17

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
scan-141.security.ipip.net 1
ec2-54-183-163-32.us-west-1.compute.amazonaws.com 1
scanner-09.ch1.censys-scanner.com 1
TOTAL: 5 103

NNRP unrecognized commands (by host):

SystemConn
scan-141.security.ipip.net 4
scanner-09.ch1.censys-scanner.com 1
TOTAL: 2 5

NNRP unrecognized commands (by command):

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

Newsgroup request counts (by category):

CategoryCountPct
1pl 32100.0%
TOTAL: 1 32100.0%

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

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