Daily Usenet report

Aug 2 04:15:02 -- Aug 3 04:15:02

Unknown entries from news log file:

First 17 / 17 lines (100.0%)

Aug 2 05:45:42 newsfeed overchan[31234]: input line too long, skipping
Aug 2 06:53:45 newsfeed overchan[31234]: input line too long, skipping
Aug 2 08:13:35 newsfeed pgpverify[2834]: pgpverify: verification failed
Aug 2 10:52:56 newsfeed nnrpd[26771]: SERVER perl filter not defined
Aug 2 10:57:58 newsfeed nnrpd[27559]: SERVER perl filter not defined
Aug 2 12:04:15 newsfeed overchan[31234]: input line too long, skipping
Aug 2 12:10:03 newsfeed overchan[31234]: input line too long, skipping
Aug 2 14:05:27 newsfeed nnrpd[23329]: unable to get certificate from '/etc/news/cert.pem'
Aug 2 14:05:27 newsfeed nnrpd[23329]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Aug 2 15:26:10 newsfeed overchan[31234]: input line too long, skipping
Aug 2 15:32:51 newsfeed overchan[31234]: input line too long, skipping
Aug 2 15:35:46 newsfeed overchan[31234]: input line too long, skipping
Aug 2 16:29:12 newsfeed overchan[31234]: input line too long, skipping
Aug 2 16:38:07 newsfeed overchan[31234]: input line too long, skipping
Aug 2 19:31:44 newsfeed overchan[31234]: input line too long, skipping
Aug 2 22:37:45 newsfeed overchan[31234]: input line too long, skipping
Aug 2 23:32:46 newsfeed overchan[31234]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 235463 80.9%26.0 MB 79.5%
innfeed 45618 15.7%5.4 MB 16.5%
innd 6763 2.3%1.0 MB 3.1%
nnrpd 3348 1.1%313.8 KB 0.9%
overchan 13 0.0%2.3 KB 0.0%
controlchan 13 0.0%2.9 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 7 291219 100.0%32.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 232990 99.4%
Negative hits 914 0.4%
Cache misses 340 0.1%
Positive hits 241 0.1%
TOTAL: 4 234485 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:08.401 0.0%732 0.000 11.477 443.000
article cleanup00:00:01.880 0.0%233809 0.003 0.008 0.015
article logging00:00:06.412 0.0%234270 0.020 0.027 0.042
article parse00:02:55.080 0.2%24475454 0.006 0.007 0.009
article write00:01:55.398 0.1%233695 0.198 0.494 10.496
artlog/artcncl00:00:00.009 0.0%732 0.000 0.012 0.024
data move00:00:12.708 0.0%26040091 0.000 0.000 0.001
hisgrep/artcncl00:00:01.129 0.0%391 0.000 2.887 147.000
hishave/artcncl00:00:02.861 0.0%732 0.000 3.908 35.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:36:25.766 2.5%234909 0.190 9.305 161.719
history sync00:00:00.019 0.0%304 0.000 0.062 0.500
history write00:14:18.126 1.0%233795 1.096 3.670 66.681
hiswrite/artcncl00:00:00.698 0.0%341 0.000 2.047 9.000
idle22:39:43.135 94.4%24537101 2.287 3.325 4.980
nntp read00:07:30.528 0.5%24416714 0.015 0.018 0.021
overview write00:00:00.771 0.0%233695 0.000 0.003 0.010
perl filter00:12:38.462 0.9%233795 1.964 3.244 4.149
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:06.907 0.0%479499 0.010 0.014 0.021
TOTAL: 24:00:23.89423:56:08.290 99.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.055 0.0%46572 0.000 0.001 0.007
article prepare00:00:00.000 0.0%6550 0.000 0.000 0.000
article read00:00:19.694 0.0%1635 0.000 12.045 263.600
backlog stats00:00:00.066 0.0%101423 0.000 0.001 0.004
callbacks00:00:00.000 0.0%2 0.000 0.000 0.000
data read00:00:00.478 0.0%49997 0.000 0.010 0.027
data write00:00:01.109 0.0%38144 0.005 0.029 0.064
idle23:53:25.197 99.8%101423 317.487 847.985 1294.017
status file00:01:47.407 0.1%16546 0.382 6.491 480.942
TOTAL: 23:55:37.17923:55:34.006100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:30.877 84.6%2773 0.000 11.135 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.065 0.2%5913 0.000 0.011 0.500
readart00:00:00.000 0.0%40 0.000 0.000 0.000
TOTAL: 00:00:36.51500:00:30.942 84.7%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org001101
thh@thh.name010001
TOTAL011102

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 94 234033 233930 0 103 99%58:52:28
2news.icm.edu.pl 47 200 13 176 11 6%15:29:03
3localhost 1443 2 2 0 0 100%00:00:00
TOTAL: 3 1584 234235 233945 176 114 99%74:21:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl77.5 GB1.0 MB1.3 MB77.5 GB 99%347.3 KB
2news.icm.edu.pl1.0 MB23.8 KB516.6 KB1.6 MB 65%66.2 KB
3localhost2.5 KB0.0 KB0.0 KB2.5 KB100%1.3 KB
TOTAL: 377.5 GB1.0 MB1.8 MB77.5 GB 99%347.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 2 04:15:02 - 04:59:59 5370 2.3% 1.992.3 GB 2.9% 875.20
Aug 2 05:00:00 - 05:59:59 8649 3.7% 2.403.1 GB 4.1% 916.29
Aug 2 06:00:00 - 06:59:59 8451 3.6% 2.353.3 GB 4.2% 958.14
Aug 2 07:00:00 - 07:59:59 9102 3.9% 2.533.5 GB 4.5%1022.73
Aug 2 08:00:00 - 08:59:59 9934 4.2% 2.763.4 GB 4.4%1003.67
Aug 2 09:00:00 - 09:59:59 9730 4.2% 2.703.4 GB 4.4% 992.79
Aug 2 10:00:00 - 10:59:59 9317 4.0% 2.593.2 GB 4.1% 924.56
Aug 2 11:00:00 - 11:59:59 10590 4.5% 2.943.1 GB 4.1% 916.57
Aug 2 12:00:00 - 12:59:59 9011 3.8% 2.503.1 GB 4.0% 901.95
Aug 2 13:00:00 - 13:59:59 10004 4.3% 2.783.3 GB 4.2% 954.32
Aug 2 14:00:00 - 14:59:59 8356 3.6% 2.323.3 GB 4.2% 956.74
Aug 2 15:00:00 - 15:59:59 7857 3.4% 2.183.1 GB 4.0% 904.75
Aug 2 16:00:00 - 16:59:59 9494 4.1% 2.643.3 GB 4.2% 951.77
Aug 2 17:00:00 - 17:59:59 10047 4.3% 2.793.3 GB 4.2% 947.75
Aug 2 18:00:00 - 18:59:59 10321 4.4% 2.873.4 GB 4.3% 979.74
Aug 2 19:00:00 - 19:59:59 12036 5.1% 3.343.3 GB 4.2% 958.77
Aug 2 20:00:00 - 20:59:59 10348 4.4% 2.873.3 GB 4.3% 970.66
Aug 2 21:00:00 - 21:59:59 12599 5.4% 3.503.3 GB 4.2% 946.66
Aug 2 22:00:00 - 22:59:59 10934 4.7% 3.043.2 GB 4.2% 946.63
Aug 2 23:00:00 - 23:59:59 10544 4.5% 2.933.2 GB 4.1% 922.70
Aug 3 00:00:00 - 00:59:59 10469 4.5% 2.913.1 GB 4.0% 912.09
Aug 3 01:00:00 - 01:59:59 9786 4.2% 2.723.2 GB 4.1% 934.12
Aug 3 02:00:00 - 02:59:59 9322 4.0% 2.593.2 GB 4.1% 922.90
Aug 3 03:00:00 - 03:59:59 8491 3.6% 2.362.9 GB 3.8% 855.39
Aug 3 04:00:00 - 04:15:02 3397 1.5% 3.77829.2 MB 1.0% 941.33
TOTAL: 24:00:00 234159 100.0% 2.7177.6 GB 100.0% 941.39
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 561 85 0 12 6 0 0 0 458
2news.icm.edu.pl 11 0 0 2 0 0 0 0 9
TOTAL: 2 572 85 0 14 6 0 0 0 467

Unwanted newsgroups [Top 20]:

NewsgroupCount
comp.sys.raspberry-pi 47
it.comp.os.win.windows10 16
uk.railway 8
it.tlc.cellulari.android 5
alt.comp.software.seamonkey 3
alt.comp.software.firefox 3
de.rec.sf.startrek 2
it.comp.os.win.windows7 1
TOTAL: 8 85

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

GroupsCount
pl.praca.oferowana 6
TOTAL: 1 6

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 8
Binary in non-binary group 1
TOTAL: 2 9

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.pionier.net.pl 458
TOTAL: 1 458
TOTAL: 1 458

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 16152 463 11378 18 0 0 2%24:09:39
2panorama 38318 397 10330 184 7 35785 1%24:00:00
3poznan 12 0 11 0 0 0 0%01:21:41
4nask 0 0 0 0 0 8028 0%24:05:14
5okapi 0 0 0 0 0 657 0%24:05:14
TOTAL: 5 54482 860 21719 202 7 44470 1%97:41:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.3 MB70.6 KB1.4 MB0.0 KB/s3.0 KB24:09:39
2panorama1.1 MB618.0 KB1.7 MB0.0 KB/s3.0 KB24:00:00
3poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:21:41
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:14
5okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:05:14
TOTAL: 52.4 MB688.6 KB3.1 MB0.0 KB/s3.0 KB97:41:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 4041.2 KB 17 0 000:00:10
2isvcs01.man.lodz.pl 2 00.0 KB 0 2 000:00:00
TOTAL: 2 290 4041.2 KB 17 2 000:00:36

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 290 4041.2 KB 17 2 000:00:10
2unresolved 101 00.0 KB 0 0 000:00:13
3*.79.44.78.socradar-tchelebi-wide-scan-project.socradar.com 1 00.0 KB 0 0 000:00:10
4*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:01
TOTAL: 4 394 4041.2 KB 17 2 000:00:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 0.939 1.339 0.00000:00:10
45.79.44.78.socradar-tchelebi-wide-scan-project.socradar.com 0.004 0.004 0.00000:00:10
167.172.36.21 0.000 0.008 0.00000:00:10
80.111.142.213 0.007 0.026 0.00000:00:02
212.51.192.185 0.307 0.362 0.00000:00:00
scanner-21.ch1.censys-scanner.com 0.004 0.004 0.00000:00:00
scanner-06.ch1.censys-scanner.com 0.000 0.009 0.00000:00:00
isvcs01.man.lodz.pl 0.005 0.019 0.00000:00:00
TOTAL: 8 1.266 1.771 0.00000:00:36

Curious NNRP server explorers [Top 20]:

SystemConn
212.51.192.185 96
80.111.142.213 4
45.79.44.78.socradar-tchelebi-wide-scan-project.socradar.com 1
scanner-21.ch1.censys-scanner.com 1
scanner-06.ch1.censys-scanner.com 1
167.172.36.21 1
TOTAL: 6 104

NNRP unrecognized commands (by host):

SystemConn
scanner-06.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 40100.0%
TOTAL: 1 40100.0%

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

NewsgroupCount
1pl.comp.pecet 22
2pl.comp.os.ms-windows.winnt 18
TOTAL: 2 40