Daily Usenet report

Sep 22 04:15:01 -- Sep 23 04:15:01

Unknown entries from news log file:

First 19 / 19 lines (100.0%)

Sep 22 08:30:03 newsfeed pgpverify[16929]: pgpverify: verification failed
Sep 22 15:20:53 newsfeed overchan[1099]: input line too long, skipping
Sep 22 15:27:25 newsfeed overchan[1099]: input line too long, skipping
Sep 22 15:28:46 newsfeed overchan[1099]: input line too long, skipping
Sep 22 15:57:08 newsfeed overchan[1099]: input line too long, skipping
Sep 22 16:36:22 newsfeed overchan[1099]: input line too long, skipping
Sep 22 16:54:49 newsfeed overchan[1099]: input line too long, skipping
Sep 22 17:55:53 newsfeed overchan[1099]: input line too long, skipping
Sep 22 17:58:45 newsfeed overchan[1099]: input line too long, skipping
Sep 22 18:22:07 newsfeed overchan[1099]: input line too long, skipping
Sep 22 19:20:23 newsfeed overchan[1099]: input line too long, skipping
Sep 22 20:02:59 newsfeed overchan[1099]: input line too long, skipping
Sep 22 20:03:13 newsfeed overchan[1099]: input line too long, skipping
Sep 22 20:06:21 newsfeed overchan[1099]: input line too long, skipping
Sep 22 23:13:55 newsfeed overchan[1099]: input line too long, skipping
Sep 22 23:17:57 newsfeed overchan[1099]: input line too long, skipping
Sep 23 02:21:33 newsfeed nnrpd[25552]: unable to get certificate from '/etc/news/cert.pem'
Sep 23 02:21:33 newsfeed nnrpd[25552]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Sep 23 02:23:35 newsfeed nnrpd[25788]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 629516 91.1%68.0 MB 90.1%
innfeed 48855 7.1%5.7 MB 7.6%
innd 8723 1.3%1.4 MB 1.8%
nnrpd 4250 0.6%430.5 KB 0.6%
overchan 16 0.0%3.0 KB 0.0%
controlchan 13 0.0%2.5 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 7 691374 100.0%75.5 MB100.0%

History cache:

ReasonCount%Count
Do not exist 626812 99.6%
Negative hits 2364 0.4%
Positive hits 271 0.0%
Cache misses 52 0.0%
TOTAL: 4 629499 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.677 0.0%133 0.000 12.609 146.000
article cleanup00:00:09.666 0.0%629366 0.011 0.015 0.023
article logging00:00:33.678 0.0%629855 0.040 0.053 0.069
article parse00:18:49.718 1.3%30272506 0.020 0.037 0.050
article write00:07:20.511 0.5%629176 0.236 0.700 1.081
artlog/artcncl00:00:00.005 0.0%132 0.000 0.038 0.500
data move00:00:33.105 0.0%34525886 0.001 0.001 0.001
hisgrep/artcncl00:00:00.690 0.0%131 0.000 5.267 78.500
hishave/artcncl00:00:00.160 0.0%133 0.000 1.203 28.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:26:18.536 1.8%632201 0.288 2.497 9.040
history sync00:00:00.032 0.0%292 0.000 0.110 1.000
history write00:35:26.678 2.5%629347 0.408 3.379 14.810
hiswrite/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
idle20:42:00.311 86.2%29818537 0.987 2.499 5.137
nntp read00:27:25.304 1.9%29981328 0.040 0.055 0.062
overview write00:00:03.711 0.0%629176 0.003 0.006 0.011
perl filter01:11:34.733 5.0%629347 3.910 6.824 9.361
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:39.506 0.0%1272946 0.025 0.031 0.038
TOTAL: 24:00:08.31823:50:58.022 99.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.150 0.0%54067 0.000 0.003 0.011
article prepare00:00:00.002 0.0%9124 0.000 0.000 0.025
article read00:00:13.314 0.0%2279 0.000 5.842 45.167
backlog stats00:00:00.120 0.0%121312 0.000 0.001 0.007
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.227 0.0%59782 0.002 0.021 0.042
data write00:00:03.152 0.0%45817 0.029 0.069 0.137
idle23:42:25.499 99.9%121312 450.204 703.521 1118.294
status file00:00:54.839 0.1%16953 0.855 3.235 91.411
TOTAL: 23:43:45.37223:43:38.303100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:30.161 69.2%3106 0.000 9.711 9661.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.325 0.7%6972 0.000 0.047 1.158
readart00:00:00.010 0.0%92 0.000 0.109 0.500
TOTAL: 00:00:43.59700:00:30.496 69.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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
ba-mod@panix.com001101
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 102 628290 628114 0 176 99%67:41:18
2news.icm.edu.pl 48 209 20 175 14 9%15:44:48
3localhost 1442 1 1 0 0 100%00:00:00
TOTAL: 3 1592 628500 628135 175 190 99%83:26:06
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl242.7 GB532.7 KB919.0 KB242.7 GB 99%405.0 KB
2news.icm.edu.pl611.8 KB210.0 KB325.5 KB1.1 MB 53%33.7 KB
3localhost1.5 KB0.0 KB0.0 KB1.5 KB100%1.5 KB
TOTAL: 3242.7 GB742.7 KB1.2 MB242.7 GB 99%405.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 22 04:15:01 - 04:59:59 12021 1.9% 4.456.1 GB 2.5%2367.64
Sep 22 05:00:00 - 05:59:59 14859 2.4% 4.138.2 GB 3.4%2394.89
Sep 22 06:00:00 - 06:59:59 77898 12.4% 21.6412.2 GB 5.0%3557.40
Sep 22 07:00:00 - 07:59:59 36576 5.8% 10.1611.3 GB 4.7%3295.96
Sep 22 08:00:00 - 08:59:59 20147 3.2% 5.609.2 GB 3.8%2693.31
Sep 22 09:00:00 - 09:59:59 22072 3.5% 6.138.9 GB 3.7%2587.07
Sep 22 10:00:00 - 10:59:59 18425 2.9% 5.129.7 GB 4.0%2813.05
Sep 22 11:00:00 - 11:59:59 18912 3.0% 5.259.7 GB 4.0%2833.45
Sep 22 12:00:00 - 12:59:59 17152 2.7% 4.768.9 GB 3.7%2589.95
Sep 22 13:00:00 - 13:59:59 20174 3.2% 5.609.5 GB 3.9%2755.50
Sep 22 14:00:00 - 14:59:59 20843 3.3% 5.799.9 GB 4.1%2891.82
Sep 22 15:00:00 - 15:59:59 20485 3.3% 5.699.5 GB 3.9%2769.09
Sep 22 16:00:00 - 16:59:59 20261 3.2% 5.639.9 GB 4.1%2888.28
Sep 22 17:00:00 - 17:59:59 22689 3.6% 6.3010.4 GB 4.3%3035.30
Sep 22 18:00:00 - 18:59:59 21843 3.5% 6.0710.6 GB 4.4%3092.37
Sep 22 19:00:00 - 19:59:59 33236 5.3% 9.2310.8 GB 4.5%3160.22
Sep 22 20:00:00 - 20:59:59 86467 13.8% 24.0213.5 GB 5.5%3924.97
Sep 22 21:00:00 - 21:59:59 21706 3.5% 6.0310.2 GB 4.2%2971.21
Sep 22 22:00:00 - 22:59:59 21768 3.5% 6.0510.8 GB 4.5%3154.67
Sep 22 23:00:00 - 23:59:59 20274 3.2% 5.639.7 GB 4.0%2822.50
Sep 23 00:00:00 - 00:59:59 19068 3.0% 5.309.8 GB 4.0%2868.77
Sep 23 01:00:00 - 01:59:59 19536 3.1% 5.4310.7 GB 4.4%3123.11
Sep 23 02:00:00 - 02:59:59 19746 3.1% 5.4910.8 GB 4.5%3159.63
Sep 23 03:00:00 - 03:59:59 17188 2.7% 4.779.9 GB 4.1%2882.44
Sep 23 04:00:00 - 04:15:01 5357 0.9% 5.952.7 GB 1.1%3183.27
TOTAL: 24:00:00 628703 100.0% 7.28243.2 GB 100.0%2951.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 666 161 0 14 1 0 0 0 490
2news.icm.edu.pl 15 0 0 5 0 0 0 0 10
TOTAL: 2 681 161 0 19 1 0 0 0 500

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 95
it.comp.os.win.windows10 29
nl.comp.os.linux.techniek 22
it.tlc.cellulari.android 10
comp.sys.raspberry-pi 4
de.comp.lang.vbclassic 1
TOTAL: 6 161

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

GroupsCount
pl.praca.oferowana 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 3
Scoring filter (16) 2
Scoring filter (8) 2
Binary in non-binary group 1
Too many newsgroups 1
TOTAL: 5 9

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 21476 1195 13095 107 0 1 5%23:51:49
2panorama 42134 336 13416 151 2 40715 0%23:59:14
3okapi 0 0 0 0 0 783 0%23:40:04
4poznan 15 0 13 0 0 0 0%01:53:01
5nask 0 0 0 0 0 10100 0%23:47:46
TOTAL: 5 63625 1531 26524 258 2 51599 2%97:11:54
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm4.7 MB284.4 KB5.0 MB0.1 KB/s3.9 KB23:51:49
2panorama1.1 MB713.8 KB1.8 MB0.0 KB/s3.8 KB23:59:14
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:40:04
4poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:53:01
5nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:47:46
TOTAL: 55.8 MB998.2 KB6.8 MB0.0 KB/s3.9 KB97:11:54
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 92122.6 KB 41 0 000:00:23
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 289 92122.6 KB 41 1 000:00:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 576 92122.6 KB 41 1 000:00:27
2*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
3*.sfj.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4unresolved 101 00.0 KB 0 0 000:00:15
TOTAL: 4 680 92122.6 KB 41 1 000:00:43

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 1.798 4.592 0.00000:00:23
162.243.128.21 0.005 0.014 0.00000:00:09
mon.man.lodz.pl 1.617 4.177 0.00000:00:03
80.111.142.213 0.035 0.063 0.00000:00:03
212.51.192.185 0.554 1.380 0.00000:00:01
scanner-04.ch1.censys-scanner.com 0.004 0.033 0.00000:00:00
worker-18.sfj.censys-scanner.com 0.005 0.009 0.00000:00:00
isvcs01.man.lodz.pl 0.011 0.018 0.00000:00:00
TOTAL: 8 4.029 10.286 0.00000:00:43

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 287
212.51.192.185 96
80.111.142.213 4
scanner-04.ch1.censys-scanner.com 2
worker-18.sfj.censys-scanner.com 1
162.243.128.21 1
TOTAL: 6 391

NNRP unrecognized commands (by host):

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

Newsgroup request counts (by category):

CategoryCountPct
1pl 92100.0%
TOTAL: 1 92100.0%

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

NewsgroupCount
1pl.comp.os.ms-windows.winnt 58
2pl.comp.pecet 34
TOTAL: 2 92