Daily Usenet report

Sep 11 04:15:01 -- Sep 12 04:15:02

Unknown entries from news log file:

First 6 / 6 lines (100.0%)

Sep 11 13:25:45 newsfeed overchan[18676]: input line too long, skipping
Sep 11 15:28:35 newsfeed overchan[18676]: input line too long, skipping
Sep 11 16:17:50 newsfeed overchan[18676]: input line too long, skipping
Sep 11 16:54:33 newsfeed overchan[18676]: input line too long, skipping
Sep 11 18:34:40 newsfeed nnrpd[18436]: unable to get certificate from '/etc/news/cert.pem'
Sep 11 18:34:40 newsfeed nnrpd[18436]: 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 399336 87.1%44.1 MB 86.0%
innfeed 47960 10.5%5.7 MB 11.2%
innd 7616 1.7%1.1 MB 2.2%
nnrpd 3318 0.7%312.9 KB 0.6%
controlchan 4 0.0%0.5 KB 0.0%
overchan 4 0.0%0.7 KB 0.0%
TOTAL: 6 458238 100.0%51.2 MB100.0%

History cache:

ReasonCount%Count
Do not exist 398335 99.0%
Negative hits 3612 0.9%
Positive hits 297 0.1%
Cache misses 19 0.0%
TOTAL: 4 402263 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.312 0.0%59 0.000 22.237 449.000
article cleanup00:00:03.225 0.0%398926 0.003 0.008 0.014
article logging00:00:09.447 0.0%399322 0.016 0.024 0.035
article parse00:05:52.405 0.4%89599206 0.003 0.004 0.005
article write00:02:58.552 0.2%398592 0.277 0.448 2.557
artlog/artcncl00:00:00.000 0.0%59 0.000 0.000 0.000
data move00:00:29.093 0.0%92732507 0.000 0.000 0.000
hisgrep/artcncl00:00:00.198 0.0%59 0.000 3.356 23.000
hishave/artcncl00:00:00.001 0.0%59 0.000 0.017 0.111
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:03:53.237 0.3%402867 0.207 0.579 5.566
history sync00:00:00.017 0.0%312 0.000 0.054 0.500
history write00:05:41.154 0.4%398907 0.282 0.855 7.790
idle22:50:47.678 95.2%88504122 0.507 0.929 1.344
nntp read00:18:21.730 1.3%89309035 0.011 0.012 0.014
overview write00:00:01.210 0.0%398592 0.000 0.003 0.007
perl filter00:24:03.002 1.7%398907 2.510 3.617 4.435
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:09.642 0.0%808257 0.008 0.012 0.016
TOTAL: 24:00:12.61823:52:31.903 99.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.048 0.0%48936 0.000 0.001 0.007
article prepare00:00:00.001 0.0%7432 0.000 0.000 0.042
article read00:00:08.623 0.0%1854 0.000 4.651 249.400
backlog stats00:00:00.061 0.0%111402 0.000 0.001 0.003
callbacks00:00:00.000 0.0%3 0.000 0.000 0.000
data read00:00:00.463 0.0%52987 0.000 0.009 0.036
data write00:00:01.195 0.0%42030 0.000 0.028 0.066
idle23:53:58.528 99.9%111402 155.320 772.325 2077.803
status file00:00:42.632 0.0%16496 0.000 2.584 159.617
TOTAL: 23:54:54.48323:54:51.551100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:16.775 78.4%2726 0.000 6.154 10011.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.075 0.4%5756 0.000 0.013 0.500
readart00:00:00.000 0.0%4 0.000 0.000 0.000
TOTAL: 00:00:21.39300:00:16.850 78.8%----

Control commands to INND:

CommandNumber
L 1
flush 27
flushlogs 2
go 2
logmode 2
mode 148
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 192

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
anton@solovyev.com300033
TOTAL300033

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 75 398825 398602 0 223 99%71:30:23
2news.icm.edu.pl 43 383 37 235 111 9%18:06:43
3localhost 1441 0 0 0 0 0%00:00:00
TOTAL: 3 1559 399208 398639 235 334 99%89:37:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl186.1 GB2.7 MB3.2 MB186.1 GB 99%489.3 KB
2news.icm.edu.pl2.2 MB0.0 KB3.4 MB5.6 MB 38%38.9 KB
3localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 3186.1 GB2.7 MB6.7 MB186.1 GB 99%489.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 11 04:15:01 - 04:59:59 14519 3.6% 5.387.1 GB 3.8%2764.06
Sep 11 05:00:00 - 05:59:59 18749 4.7% 5.219.1 GB 4.9%2637.10
Sep 11 06:00:00 - 06:59:59 20444 5.1% 5.6810.2 GB 5.5%2971.67
Sep 11 07:00:00 - 07:59:59 21492 5.4% 5.9711.4 GB 6.1%3317.92
Sep 11 08:00:00 - 08:59:59 21477 5.4% 5.9710.3 GB 5.5%2998.68
Sep 11 09:00:00 - 09:59:59 13628 3.4% 3.796.5 GB 3.5%1903.93
Sep 11 10:00:00 - 10:59:59 14359 3.6% 3.996.3 GB 3.4%1829.16
Sep 11 11:00:00 - 11:59:59 15597 3.9% 4.336.3 GB 3.4%1835.47
Sep 11 12:00:00 - 12:59:59 13738 3.4% 3.826.1 GB 3.3%1778.05
Sep 11 13:00:00 - 13:59:59 14371 3.6% 3.996.3 GB 3.4%1839.89
Sep 11 14:00:00 - 14:59:59 13802 3.5% 3.836.2 GB 3.3%1795.59
Sep 11 15:00:00 - 15:59:59 13273 3.3% 3.696.2 GB 3.3%1792.92
Sep 11 16:00:00 - 16:59:59 12945 3.2% 3.606.1 GB 3.3%1778.75
Sep 11 17:00:00 - 17:59:59 13593 3.4% 3.786.1 GB 3.3%1775.71
Sep 11 18:00:00 - 18:59:59 16183 4.1% 4.507.6 GB 4.1%2201.73
Sep 11 19:00:00 - 19:59:59 15745 4.0% 4.377.7 GB 4.1%2239.72
Sep 11 20:00:00 - 20:59:59 13477 3.4% 3.746.1 GB 3.3%1780.29
Sep 11 21:00:00 - 21:59:59 21299 5.3% 5.927.8 GB 4.2%2257.94
Sep 11 22:00:00 - 22:59:59 16906 4.2% 4.708.1 GB 4.4%2358.89
Sep 11 23:00:00 - 23:59:59 16372 4.1% 4.556.3 GB 3.4%1842.74
Sep 12 00:00:00 - 00:59:59 19001 4.8% 5.289.1 GB 4.9%2644.87
Sep 12 01:00:00 - 01:59:59 20316 5.1% 5.6410.3 GB 5.6%3009.49
Sep 12 02:00:00 - 02:59:59 12583 3.2% 3.506.2 GB 3.3%1810.24
Sep 12 03:00:00 - 03:59:59 19774 5.0% 5.4910.3 GB 5.5%2986.95
Sep 12 04:00:00 - 04:15:02 4904 1.2% 5.442.6 GB 1.4%2983.74
TOTAL: 24:00:01 398547 100.0% 4.61186.1 GB 100.0%2258.62
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 618 199 0 19 5 0 0 0 395
2news.icm.edu.pl 112 0 0 0 0 0 0 0 112
TOTAL: 2 730 199 0 19 5 0 0 0 507

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 131
it.tlc.cellulari.android 25
it.comp.os.win.windows10 8
comp.mobile.android 7
de.rec.sf.startrek 6
alt.comp.software.seamonkey 5
comp.sys.raspberry-pi 3
de.comm.software.mailreader 3
it.comp.os.win.windows7 3
alt.comp.software.firefox 3
de.comm.provider.telefonie 2
it.comp.os.linux.ubuntu 2
uk.rec.cycling.moderated 1
TOTAL: 13 199

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

GroupsCount
pl.praca.oferowana 5
TOTAL: 1 5

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 80
Too many newsgroups 23
Binary in non-binary group 6
Too many newsgroups (low_xpost) 1
HTML post 1
TOTAL: 5 111

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 18298 686 10023 27 0 1 3%23:59:57
2panorama 39603 420 11686 361 4 36478 1%23:55:51
3okapi 0 0 0 0 0 568 0%23:57:47
4poznan 46 0 36 1 0 0 0%04:03:35
5nask 0 0 0 0 0 7988 0%23:57:47
TOTAL: 5 57947 1106 21745 389 4 45035 1%99:54:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm2.0 MB89.4 KB2.1 MB0.0 KB/s3.0 KB23:59:57
2panorama1.4 MB1.4 MB2.8 MB0.0 KB/s3.7 KB23:55:51
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
4poznan0.0 KB20.8 KB20.8 KB0.0 KB/s20.8 KB04:03:35
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
TOTAL: 53.4 MB1.5 MB5.0 MB0.0 KB/s3.4 KB99:54:57
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 43.1 KB 1 0 000:00:07
TOTAL: 1 288 43.1 KB 1 0 000:00:21

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 288 43.1 KB 1 0 000:00:07
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3*.105.78.101.socradar-tchelebi-wide-scan-project.socradar.com 1 00.0 KB 0 0 000:00:10
4unresolved 104 00.0 KB 0 0 000:00:03
TOTAL: 4 394 43.1 KB 1 0 000:00:21

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
172.105.78.101.socradar-tchelebi-wide-scan-project.socradar.com 0.005 0.005 0.00000:00:10
web.man.lodz.pl 0.763 1.463 0.00000:00:07
80.111.142.213 0.014 0.020 0.00000:00:02
212.51.192.185 0.294 0.362 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.006 0.003 0.00000:00:00
45.155.204.107 0.013 0.014 0.00000:00:00
TOTAL: 6 1.095 1.867 0.00000:00:21

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
45.155.204.107 4
172.105.78.101.socradar-tchelebi-wide-scan-project.socradar.com 1
scanner-05.ch1.censys-scanner.com 1
TOTAL: 5 106

NNRP unrecognized commands (by host):

SystemConn
45.155.204.107 2
scanner-05.ch1.censys-scanner.com 1
TOTAL: 2 3

NNRP unrecognized commands (by command):

CommandCount
#003 2
EHLO www.censys.io 1
TOTAL: 2 3

NNRP client timeouts [Top 20]:

SystemConnPeer
45.155.204.107 2 4
TOTAL: 1 2 4

Newsgroup request counts (by category):

CategoryCountPct
1pl 4100.0%
TOTAL: 1 4100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 4
TOTAL: 1 4