Daily Usenet report

Dec 1 04:15:02 -- Dec 2 04:15:02

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Dec 1 04:15:35 newsfeed nnrpd[28173]: unable to get certificate from '/etc/news/cert.pem'
Dec 1 04:15:35 newsfeed nnrpd[28173]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Dec 1 05:18:56 newsfeed overchan[27964]: input line too long, skipping
Dec 1 06:11:49 newsfeed overchan[27964]: input line too long, skipping
Dec 1 15:46:01 newsfeed overchan[27964]: input line too long, skipping
Dec 1 15:47:24 newsfeed overchan[27964]: input line too long, skipping
Dec 1 16:46:35 newsfeed overchan[27964]: input line too long, skipping
Dec 1 17:52:27 newsfeed overchan[27964]: input line too long, skipping
Dec 1 18:01:59 newsfeed overchan[27964]: input line too long, skipping
Dec 1 18:17:27 newsfeed overchan[27964]: input line too long, skipping
Dec 1 18:52:12 newsfeed overchan[27964]: input line too long, skipping
Dec 1 19:01:11 newsfeed overchan[27964]: input line too long, skipping
Dec 1 22:12:58 newsfeed overchan[27964]: input line too long, skipping
Dec 1 22:42:47 newsfeed overchan[27964]: input line too long, skipping
Dec 1 23:01:43 newsfeed overchan[27964]: input line too long, skipping
Dec 2 00:13:24 newsfeed nnrpd[21389]: SERVER perl filter not defined
Dec 2 01:34:12 newsfeed overchan[27964]: input line too long, skipping
Dec 2 02:44:55 newsfeed overchan[27964]: input line too long, skipping
Dec 2 03:08:21 newsfeed overchan[27964]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 694775 92.0%75.4 MB 91.0%
innfeed 47759 6.3%5.7 MB 6.8%
innd 8853 1.2%1.4 MB 1.7%
nnrpd 4183 0.6%419.5 KB 0.5%
overchan 17 0.0%3.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 755588 100.0%82.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 689905 99.6%
Negative hits 2659 0.4%
Positive hits 278 0.0%
Cache misses 24 0.0%
TOTAL: 4 692866 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.517 0.0%53 0.000 28.623 127.000
article cleanup00:00:10.809 0.0%693925 0.009 0.016 0.022
article logging00:00:34.081 0.0%694437 0.031 0.049 0.064
article parse00:22:14.770 1.5%66269711 0.010 0.020 0.030
article write00:08:24.846 0.6%693712 0.172 0.728 0.976
artlog/artcncl00:00:00.002 0.0%52 0.000 0.038 1.000
data move00:00:56.758 0.1%71377924 0.000 0.001 0.001
hisgrep/artcncl00:00:00.192 0.0%52 0.000 3.692 21.000
hishave/artcncl00:00:00.246 0.0%53 0.000 4.642 27.875
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:41:41.395 2.9%697045 0.712 3.589 11.973
history sync00:00:00.021 0.0%290 0.000 0.072 1.000
history write01:00:59.145 4.2%693904 1.349 5.273 16.306
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle19:25:18.064 80.9%65399609 0.695 1.069 1.883
nntp read00:40:44.747 2.8%65801859 0.025 0.037 0.049
overview write00:00:03.756 0.0%693712 0.002 0.005 0.009
perl filter01:14:02.890 5.1%693904 2.735 6.403 8.457
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:36.318 0.0%1403714 0.020 0.026 0.033
TOTAL: 24:00:02.41023:35:49.557 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.149 0.0%54763 0.000 0.003 0.011
article prepare00:00:00.000 0.0%5978 0.000 0.000 0.000
article read00:00:18.099 0.0%1491 0.500 12.139 64.000
backlog stats00:00:00.098 0.0%116526 0.000 0.001 0.005
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.116 0.0%58833 0.003 0.019 0.039
data write00:00:02.515 0.0%42689 0.020 0.059 0.106
idle23:53:33.297 99.9%116526 523.482 738.147 1145.824
status file00:01:21.120 0.1%16722 0.960 4.851 207.222
TOTAL: 23:55:22.49523:55:16.394100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:00:44.084 98.9%3018 0.000 1207.450450179.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.226 0.0%6622 0.000 0.034 1.000
readart00:00:00.070 0.0%4 0.000 17.500 49.000
TOTAL: 01:01:25.43401:00:44.380 98.9%----

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 69 694353 694165 0 188 99%61:56:13
2news.icm.edu.pl 38 280 26 230 24 9%17:22:16
3localhost 1442 1 1 0 0 100%00:00:00
TOTAL: 3 1549 694634 694192 230 212 99%79:18:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl322.2 GB1.7 MB2.2 MB322.2 GB 99%486.6 KB
2news.icm.edu.pl1.1 MB0.0 KB1.4 MB2.4 MB 43%49.9 KB
3localhost1.5 KB0.0 KB0.0 KB1.5 KB100%1.5 KB
TOTAL: 3322.2 GB1.7 MB3.5 MB322.2 GB 99%486.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 1 04:15:02 - 04:59:59 17399 2.5% 6.4510.0 GB 3.1%3876.17
Dec 1 05:00:00 - 05:59:59 21890 3.2% 6.0812.6 GB 3.9%3670.32
Dec 1 06:00:00 - 06:59:59 23839 3.4% 6.6212.9 GB 4.0%3755.08
Dec 1 07:00:00 - 07:59:59 22515 3.2% 6.2512.5 GB 3.9%3628.50
Dec 1 08:00:00 - 08:59:59 80811 11.6% 22.4514.9 GB 4.6%4348.84
Dec 1 09:00:00 - 09:59:59 45812 6.6% 12.7314.2 GB 4.4%4142.03
Dec 1 10:00:00 - 10:59:59 22863 3.3% 6.3512.1 GB 3.7%3514.82
Dec 1 11:00:00 - 11:59:59 22726 3.3% 6.3112.1 GB 3.8%3534.83
Dec 1 12:00:00 - 12:59:59 26796 3.9% 7.4413.5 GB 4.2%3932.43
Dec 1 13:00:00 - 13:59:59 27865 4.0% 7.7413.7 GB 4.2%3992.48
Dec 1 14:00:00 - 14:59:59 25417 3.7% 7.0613.3 GB 4.1%3870.46
Dec 1 15:00:00 - 15:59:59 25392 3.7% 7.0513.0 GB 4.0%3786.78
Dec 1 16:00:00 - 16:59:59 26054 3.8% 7.2413.3 GB 4.1%3863.77
Dec 1 17:00:00 - 17:59:59 27809 4.0% 7.7213.5 GB 4.2%3942.96
Dec 1 18:00:00 - 18:59:59 24324 3.5% 6.7612.9 GB 4.0%3750.99
Dec 1 19:00:00 - 19:59:59 27841 4.0% 7.7314.2 GB 4.4%4125.43
Dec 1 20:00:00 - 20:59:59 27924 4.0% 7.7613.2 GB 4.1%3850.70
Dec 1 21:00:00 - 21:59:59 31412 4.5% 8.7314.6 GB 4.5%4241.32
Dec 1 22:00:00 - 22:59:59 27331 3.9% 7.5913.5 GB 4.2%3930.03
Dec 1 23:00:00 - 23:59:59 29972 4.3% 8.3314.7 GB 4.5%4275.02
Dec 2 00:00:00 - 00:59:59 25613 3.7% 7.1113.7 GB 4.2%3978.40
Dec 2 01:00:00 - 01:59:59 26720 3.9% 7.4214.4 GB 4.5%4197.25
Dec 2 02:00:00 - 02:59:59 25798 3.7% 7.1713.6 GB 4.2%3968.88
Dec 2 03:00:00 - 03:59:59 23786 3.4% 6.6113.3 GB 4.1%3863.66
Dec 2 04:00:00 - 04:15:02 6089 0.9% 6.753.2 GB 1.0%3765.11
TOTAL: 24:00:00 693998 100.0% 8.03322.8 GB 100.0%3917.22
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 700 153 0 20 14 0 0 0 513
2news.icm.edu.pl 25 0 0 0 0 0 0 0 25
TOTAL: 2 725 153 0 20 14 0 0 0 538

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 54
it.tlc.cellulari.android 38
comp.sys.raspberry-pi 19
it.comp.os.win.windows10 18
comp.mobile.android 13
it.comp.os.win.windows7 8
it.comp.os.linux.ubuntu 3
TOTAL: 7 153

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

GroupsCount
pl.praca.oferowana 10
pl.sci.matematyka 4
TOTAL: 2 14

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 22
Binary in non-binary group 2
TOTAL: 2 24

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 41672 454 13388 141 3 40966 1%24:00:19
2icm 19373 79 13445 1 0 0 0%24:01:41
3okapi 0 0 0 0 0 789 0%23:57:52
4nask 0 0 0 0 0 11361 0%23:57:50
5poznan 23 0 18 0 0 0 0%02:00:10
TOTAL: 5 61068 533 26851 142 3 53116 0%97:57:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1panorama1.2 MB617.5 KB1.8 MB0.0 KB/s3.2 KB24:00:19
2icm267.6 KB2.5 KB270.0 KB0.0 KB/s3.4 KB24:01:41
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:52
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s002:00:10
TOTAL: 51.5 MB620.0 KB2.1 MB0.0 KB/s3.2 KB97:57:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 287 23.6 KB 1 0 000:00:24
2212.51.192.27 3 25.0 KB 2 0 001:00:31
3isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 3 291 48.6 KB 3 1 001:01:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 105 25.0 KB 2 0 001:00:55
2*.man.lodz.pl 576 23.6 KB 1 1 000:00:28
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4*.sfj.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 4 683 48.6 KB 3 1 001:01:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.51.192.27 0.019 0.017 0.00001:00:31
web.man.lodz.pl 1.543 3.342 0.00000:00:24
167.71.66.245 0.005 0.014 0.00000:00:10
192.241.236.94 0.000 0.010 0.00000:00:09
mon.man.lodz.pl 1.340 2.891 0.00000:00:03
80.111.142.213 0.010 0.048 0.00000:00:02
212.51.192.185 0.478 1.003 0.00000:00:01
scanner-09.ch1.censys-scanner.com 0.007 0.017 0.00000:00:00
worker-18.sfj.censys-scanner.com 0.007 0.007 0.00000:00:00
isvcs01.man.lodz.pl 0.016 0.013 0.00000:00:00
TOTAL: 10 3.425 7.362 0.00001:01:25

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 288
212.51.192.185 96
80.111.142.213 4
192.241.236.94 1
scanner-09.ch1.censys-scanner.com 1
worker-18.sfj.censys-scanner.com 1
167.71.66.245 1
TOTAL: 7 392

NNRP unrecognized commands (by host):

SystemConn
scanner-09.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
212.51.192.27 2 0
worker-18.sfj.censys-scanner.com 1 1
TOTAL: 2 3 1

Newsgroup request counts (by category):

CategoryCountPct
1pl 4100.0%
TOTAL: 1 4100.0%

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

NewsgroupCount
1pl.sci.medycyna 2
2pl.comp.pecet 2
TOTAL: 2 4