Daily Usenet report

Sep 3 04:15:01 -- Sep 4 04:15:01

Unknown entries from news log file:

First 16 / 16 lines (100.0%)

Sep 3 07:41:38 newsfeed nnrpd[25370]: SERVER perl filter not defined
Sep 3 07:43:46 newsfeed nnrpd[25632]: SERVER perl filter not defined
Sep 3 07:44:22 newsfeed nnrpd[25877]: SERVER perl filter not defined
Sep 3 07:49:27 newsfeed nnrpd[26517]: SERVER perl filter not defined
Sep 3 07:50:53 newsfeed nnrpd[26721]: SERVER perl filter not defined
Sep 3 12:52:31 newsfeed nnrpd[6943]: SERVER perl filter not defined
Sep 3 13:53:35 newsfeed nnrpd[16063]: SERVER perl filter not defined
Sep 3 14:36:50 newsfeed nnrpd[22593]: unable to get certificate from '/etc/news/cert.pem'
Sep 3 14:36:50 newsfeed nnrpd[22593]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Sep 3 15:11:33 newsfeed overchan[26111]: input line too long, skipping
Sep 3 16:26:54 newsfeed overchan[26111]: input line too long, skipping
Sep 3 17:16:06 newsfeed nnrpd[14035]: SERVER perl filter not defined
Sep 3 17:17:53 newsfeed nnrpd[14223]: SERVER perl filter not defined
Sep 3 19:07:24 newsfeed overchan[26111]: input line too long, skipping
Sep 3 19:41:40 newsfeed overchan[26111]: input line too long, skipping
Sep 3 19:47:07 newsfeed overchan[26111]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 392754 86.9%43.2 MB 85.7%
innfeed 48600 10.8%5.8 MB 11.4%
innd 7224 1.6%1.1 MB 2.2%
nnrpd 3398 0.8%320.5 KB 0.6%
overchan 6 0.0%1.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 451983 100.0%50.4 MB100.0%

History cache:

ReasonCount%Count
Do not exist 388794 99.4%
Negative hits 2272 0.6%
Positive hits 205 0.1%
Cache misses 30 0.0%
TOTAL: 4 391301 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.518 0.0%61 0.000 24.885 371.000
article cleanup00:00:03.437 0.0%391875 0.004 0.009 0.015
article logging00:00:10.169 0.0%392285 0.014 0.026 0.042
article parse00:05:19.107 0.4%51990751 0.004 0.006 0.008
article write00:02:40.303 0.2%391625 0.254 0.409 1.518
artlog/artcncl00:00:00.001 0.0%61 0.000 0.016 1.000
data move00:00:21.923 0.0%54759370 0.000 0.000 0.001
hisgrep/artcncl00:00:00.463 0.0%60 0.000 7.717 192.000
hishave/artcncl00:00:00.003 0.0%61 0.000 0.049 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:15.578 0.2%394466 0.160 0.496 14.628
history sync00:00:00.010 0.0%291 0.000 0.034 0.500
history write00:03:57.918 0.3%391844 0.241 0.607 14.767
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle22:57:48.511 95.7%51406795 0.536 1.608 5.653
nntp read00:14:03.889 1.0%51749120 0.012 0.016 0.020
overview write00:00:01.191 0.0%391625 0.000 0.003 0.006
perl filter00:23:07.269 1.6%391844 2.679 3.540 4.281
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:10.345 0.0%795390 0.009 0.013 0.018
TOTAL: 24:00:02.65223:51:01.635 99.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.065 0.0%48966 0.000 0.001 0.010
article prepare00:00:00.002 0.0%6196 0.000 0.000 0.036
article read00:00:13.285 0.0%1548 0.000 8.582 1220.667
backlog stats00:00:00.058 0.0%109811 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.449 0.0%53018 0.000 0.008 0.053
data write00:00:01.175 0.0%41046 0.004 0.029 0.052
idle23:53:12.455 99.9%109811 582.649 783.095 1126.076
status file00:01:27.309 0.1%17140 0.358 5.094 273.542
TOTAL: 23:54:58.01123:54:54.798100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:18.729 78.2%2812 0.000 6.660 10026.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.078 0.3%5933 0.000 0.013 0.500
readart00:00:00.001 0.0%28 0.000 0.036 0.500
TOTAL: 00:00:23.95200:00:18.808 78.5%----

Control commands to INND:

CommandNumber
L 1
flush 25
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 191

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 35 392100 391857 0 243 99%56:05:04
2news.icm.edu.pl 44 198 45 147 6 22%15:17:27
3localhost 1450 9 9 0 0 100%00:00:00
TOTAL: 3 1529 392307 391911 147 249 99%71:22:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl159.6 GB1021.0 KB1.6 MB159.6 GB 99%426.7 KB
2news.icm.edu.pl2.5 MB9.6 KB65.1 KB2.6 MB 97%51.4 KB
3localhost13.5 KB0.0 KB0.0 KB13.5 KB100%1.5 KB
TOTAL: 3159.6 GB1.0 MB1.7 MB159.6 GB 99%426.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 3 04:15:01 - 04:59:59 15320 3.9% 5.687.9 GB 4.9%3067.25
Sep 3 05:00:00 - 05:59:59 15166 3.9% 4.216.4 GB 4.0%1864.53
Sep 3 06:00:00 - 06:59:59 23154 5.9% 6.4310.4 GB 6.5%3031.65
Sep 3 07:00:00 - 07:59:59 20101 5.1% 5.589.6 GB 6.0%2809.63
Sep 3 08:00:00 - 08:59:59 14592 3.7% 4.056.4 GB 4.0%1854.72
Sep 3 09:00:00 - 09:59:59 15777 4.0% 4.386.4 GB 4.0%1861.12
Sep 3 10:00:00 - 10:59:59 17985 4.6% 5.006.4 GB 4.0%1858.82
Sep 3 11:00:00 - 11:59:59 16363 4.2% 4.556.4 GB 4.0%1853.91
Sep 3 12:00:00 - 12:59:59 17658 4.5% 4.916.3 GB 4.0%1847.24
Sep 3 13:00:00 - 13:59:59 15422 3.9% 4.286.0 GB 3.7%1735.33
Sep 3 14:00:00 - 14:59:59 14734 3.8% 4.095.2 GB 3.3%1518.51
Sep 3 15:00:00 - 15:59:59 15503 4.0% 4.314.7 GB 2.9%1359.98
Sep 3 16:00:00 - 16:59:59 15904 4.1% 4.426.2 GB 3.9%1798.76
Sep 3 17:00:00 - 17:59:59 15004 3.8% 4.175.2 GB 3.2%1510.48
Sep 3 18:00:00 - 18:59:59 16683 4.3% 4.636.0 GB 3.7%1733.97
Sep 3 19:00:00 - 19:59:59 14293 3.6% 3.975.3 GB 3.3%1538.51
Sep 3 20:00:00 - 20:59:59 15338 3.9% 4.265.9 GB 3.7%1731.29
Sep 3 21:00:00 - 21:59:59 13821 3.5% 3.845.9 GB 3.7%1713.06
Sep 3 22:00:00 - 22:59:59 13502 3.4% 3.755.1 GB 3.2%1488.04
Sep 3 23:00:00 - 23:59:59 15700 4.0% 4.365.6 GB 3.5%1630.19
Sep 4 00:00:00 - 00:59:59 15665 4.0% 4.356.1 GB 3.8%1787.87
Sep 4 01:00:00 - 01:59:59 14293 3.6% 3.976.3 GB 4.0%1844.90
Sep 4 02:00:00 - 02:59:59 14420 3.7% 4.016.3 GB 4.0%1842.98
Sep 4 03:00:00 - 03:59:59 19657 5.0% 5.4610.5 GB 6.5%3045.83
Sep 4 04:00:00 - 04:15:01 5981 1.5% 6.643.2 GB 2.0%3761.66
TOTAL: 24:00:00 392036 100.0% 4.54159.7 GB 100.0%1937.60
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 651 209 0 30 4 0 0 0 408
2news.icm.edu.pl 6 0 0 1 0 0 0 0 5
TOTAL: 2 657 209 0 31 4 0 0 0 413

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 98
comp.sys.raspberry-pi 34
it.tlc.cellulari.android 20
it.comp.os.win.windows10 15
alt.comp.software.seamonkey 14
comp.mobile.android 14
alt.comp.software.firefox 9
de.comp.lang.vbclassic 3
it.tlc.cellulari.iphone 1
de.comm.software.mailreader 1
TOTAL: 10 209

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

GroupsCount
pl.praca.oferowana 3
pl.sci.historia 1
TOTAL: 2 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 408
TOTAL: 1 408
TOTAL: 1 408

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 18066 943 10797 68 0 0 5%24:00:00
2panorama 38874 144 10346 84 0 38554 0%24:00:07
3nask 0 0 0 0 0 8371 0%23:57:48
4poznan 61 0 40 0 0 0 0%04:59:34
5okapi 0 0 0 0 0 758 0%23:57:48
TOTAL: 5 57001 1087 21183 152 0 47683 1%100:55:17
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm3.0 MB457.7 KB3.4 MB0.0 KB/s3.4 KB24:00:00
2panorama427.6 KB335.8 KB763.3 KB0.0 KB/s3.3 KB24:00:07
3nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s004:59:34
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 53.4 MB793.5 KB4.2 MB0.0 KB/s3.4 KB100:55:17
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 291 2827.7 KB 14 0 000:00:08
2isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:00
TOTAL: 2 300 2827.7 KB 14 9 000:00:24

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 300 2827.7 KB 14 9 000:00:09
2unresolved 100 00.0 KB 0 0 000:00:03
3*.us-west-1.compute.amazonaws.com 1 00.0 KB 0 0 000:00:00
4*.79.44.78.socradar-tchelebi-wide-scan-project.socradar.com 1 00.0 KB 0 0 000:00:10
5*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:01
TOTAL: 5 404 2827.7 KB 14 9 000:00:24

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
45.79.44.78.socradar-tchelebi-wide-scan-project.socradar.com 0.004 0.004 0.00000:00:10
web.man.lodz.pl 0.889 1.540 0.00000:00:08
80.111.142.213 0.010 0.026 0.00000:00:02
212.51.192.185 0.317 0.438 0.00000:00:00
isvcs01.man.lodz.pl 0.045 0.052 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.004 0.008 0.00000:00:00
scanner-26.ch1.censys-scanner.com 0.010 0.000 0.00000:00:00
ec2-54-67-86-230.us-west-1.compute.amazonaws.com 0.000 0.011 0.00000:00:00
TOTAL: 8 1.279 2.079 0.00000:00:24

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
scanner-26.ch1.censys-scanner.com 1
ec2-54-67-86-230.us-west-1.compute.amazonaws.com 1
45.79.44.78.socradar-tchelebi-wide-scan-project.socradar.com 1
scanner-21.ch1.censys-scanner.com 1
TOTAL: 6 104

NNRP unrecognized commands (by host):

SystemConn
scanner-26.ch1.censys-scanner.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
scanner-21.ch1.censys-scanner.com 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 20
2pl.comp.os.ms-windows.winnt 8
TOTAL: 2 28