Daily Usenet report

May 10 04:15:01 -- May 11 04:15:02

Unknown entries from news log file:

First 20 / 20 lines (100.0%)

May 10 04:19:22 newsfeed nnrpd[15562]: mon.man.lodz.pl rejected Expiring process 15165
May 10 06:28:17 newsfeed overchan[14813]: input line too long, skipping
May 10 13:24:42 newsfeed overchan[14813]: input line too long, skipping
May 10 13:25:57 newsfeed nnrpd[3217]: SERVER perl filter not defined
May 10 13:48:46 newsfeed nnrpd[6537]: SERVER perl filter not defined
May 10 13:49:26 newsfeed nnrpd[6651]: SERVER perl filter not defined
May 10 15:14:26 newsfeed overchan[14813]: input line too long, skipping
May 10 15:20:19 newsfeed nnrpd[20789]: SERVER perl filter not defined
May 10 15:31:31 newsfeed nnrpd[22449]: SERVER perl filter not defined
May 10 15:45:42 newsfeed nnrpd[24698]: SERVER perl filter not defined
May 10 15:48:48 newsfeed overchan[14813]: input line too long, skipping
May 10 16:01:28 newsfeed overchan[14813]: input line too long, skipping
May 10 17:42:04 newsfeed overchan[14813]: input line too long, skipping
May 10 18:58:41 newsfeed nnrpd[22039]: SERVER perl filter not defined
May 10 18:59:31 newsfeed nnrpd[22078]: SERVER perl filter not defined
May 10 19:55:40 newsfeed overchan[14813]: input line too long, skipping
May 10 20:15:46 newsfeed nnrpd[1557]: SERVER perl filter not defined
May 10 23:27:09 newsfeed overchan[14813]: input line too long, skipping
May 11 00:07:25 newsfeed nnrpd[5193]: unable to get certificate from '/etc/news/cert.pem'
May 11 00:07:25 newsfeed nnrpd[5193]: 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 679504 91.5%73.9 MB 90.5%
innfeed 49528 6.7%5.9 MB 7.2%
innd 9550 1.3%1.5 MB 1.8%
nnrpd 4250 0.6%432.0 KB 0.5%
overchan 8 0.0%1.5 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 742841 100.0%81.7 MB100.0%

History cache:

ReasonCount%Count
Do not exist 675447 99.5%
Negative hits 3052 0.4%
Positive hits 197 0.0%
Cache misses 27 0.0%
TOTAL: 4 678723 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.017 0.0%46 0.000 22.109 125.000
article cleanup00:00:09.051 0.0%679970 0.010 0.013 0.020
article logging00:00:36.702 0.0%680300 0.043 0.054 0.100
article parse00:17:46.927 1.2%36245161 0.017 0.029 0.055
article write00:14:54.225 1.0%679667 0.489 1.316 66.574
artlog/artcncl00:00:00.002 0.0%46 0.000 0.043 1.000
data move00:00:39.949 0.0%40813970 0.001 0.001 0.002
hisgrep/artcncl00:00:00.316 0.0%45 0.000 7.022 30.750
hishave/artcncl00:00:00.024 0.0%46 0.000 0.522 5.750
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:10:54.783 0.8%683339 0.196 0.958 4.230
history sync00:00:00.024 0.0%293 0.000 0.082 1.000
history write00:24:41.624 1.7%679946 0.402 2.179 8.544
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle20:55:17.038 87.2%35716792 1.476 2.109 3.143
nntp read00:27:27.249 1.9%35922930 0.030 0.046 0.075
overview write00:00:04.123 0.0%679667 0.003 0.006 0.010
perl filter01:15:12.564 5.2%679946 4.473 6.637 8.444
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:41.301 0.0%1371867 0.020 0.030 0.043
TOTAL: 24:00:07.84823:48:26.919 99.2%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.133 0.0%49064 0.000 0.003 0.014
article prepare00:00:00.001 0.0%6270 0.000 0.000 0.062
article read00:00:12.966 0.0%1558 0.000 8.322 182.667
backlog stats00:00:00.096 0.0%115516 0.000 0.001 0.005
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:01.108 0.0%55381 0.003 0.020 0.040
data write00:00:02.666 0.0%42943 0.024 0.062 0.121
idle23:52:28.392 99.9%115516 404.277 744.039 1229.079
status file00:00:47.496 0.1%16940 0.675 2.804 75.064
TOTAL: 23:53:41.00323:53:32.858100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:27.781 68.0%3086 0.000 9.002 9625.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.282 0.7%6725 0.000 0.042 0.632
readart00:00:00.001 0.0%4 0.000 0.250 0.500
TOTAL: 00:00:40.84300:00:28.064 68.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 237 679058 678783 0 275 99%90:42:34
2news.icm.edu.pl 49 205 22 155 28 10%15:36:11
3localhost 1450 9 9 0 0 100%00:00:00
TOTAL: 3 1736 679272 678814 155 303 99%106:18:45
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl280.6 GB1.2 MB2.3 MB280.6 GB 99%433.3 KB
2news.icm.edu.pl1.2 MB37.1 KB997.7 KB2.2 MB 53%44.6 KB
3localhost12.1 KB0.0 KB0.0 KB12.1 KB100%1.3 KB
TOTAL: 3280.6 GB1.2 MB3.3 MB280.6 GB 99%433.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 10 04:15:01 - 04:59:59 26426 3.9% 9.798.2 GB 2.9%3169.03
May 10 05:00:00 - 05:59:59 23156 3.4% 6.4311.1 GB 4.0%3246.47
May 10 06:00:00 - 06:59:59 22270 3.3% 6.1911.2 GB 4.0%3262.13
May 10 07:00:00 - 07:59:59 19889 2.9% 5.529.8 GB 3.5%2863.90
May 10 08:00:00 - 08:59:59 22629 3.3% 6.2911.3 GB 4.0%3295.03
May 10 09:00:00 - 09:59:59 23920 3.5% 6.6411.1 GB 3.9%3234.56
May 10 10:00:00 - 10:59:59 21886 3.2% 6.0810.8 GB 3.8%3137.62
May 10 11:00:00 - 11:59:59 24535 3.6% 6.8211.4 GB 4.0%3309.00
May 10 12:00:00 - 12:59:59 29500 4.3% 8.1912.8 GB 4.5%3718.41
May 10 13:00:00 - 13:59:59 27952 4.1% 7.7612.8 GB 4.5%3721.90
May 10 14:00:00 - 14:59:59 24302 3.6% 6.7511.6 GB 4.1%3380.52
May 10 15:00:00 - 15:59:59 27049 4.0% 7.5111.7 GB 4.1%3394.42
May 10 16:00:00 - 16:59:59 27535 4.1% 7.6512.2 GB 4.3%3539.85
May 10 17:00:00 - 17:59:59 26122 3.8% 7.2612.0 GB 4.3%3502.06
May 10 18:00:00 - 18:59:59 28297 4.2% 7.8611.0 GB 3.9%3209.30
May 10 19:00:00 - 19:59:59 26712 3.9% 7.4210.9 GB 3.9%3174.06
May 10 20:00:00 - 20:59:59 31928 4.7% 8.8713.2 GB 4.7%3833.09
May 10 21:00:00 - 21:59:59 33504 4.9% 9.3111.1 GB 3.9%3221.41
May 10 22:00:00 - 22:59:59 34313 5.1% 9.5311.5 GB 4.1%3338.23
May 10 23:00:00 - 23:59:59 34284 5.1% 9.5211.2 GB 4.0%3270.28
May 11 00:00:00 - 00:59:59 36030 5.3% 10.0112.2 GB 4.3%3561.00
May 11 01:00:00 - 01:59:59 40865 6.0% 11.3512.9 GB 4.6%3756.33
May 11 02:00:00 - 02:59:59 28990 4.3% 8.0513.6 GB 4.8%3954.80
May 11 03:00:00 - 03:59:59 29990 4.4% 8.3313.1 GB 4.7%3813.13
May 11 04:00:00 - 04:15:02 6742 1.0% 7.473.0 GB 1.1%3445.47
TOTAL: 24:00:01 678826 100.0% 7.86281.4 GB 100.0%3415.66
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 604 246 0 21 8 0 0 0 329
2news.icm.edu.pl 28 0 0 3 0 0 0 0 25
TOTAL: 2 632 246 0 24 8 0 0 0 354

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 144
comp.mobile.android 35
it.tlc.cellulari.android 24
alt.comp.software.seamonkey 13
it.comp.os.win.windows10 9
de.rec.kunst 7
comp.sys.raspberry-pi 6
nl.comp.os.linux.techniek 5
alt.binaries.novarip 1
it.comp.os.linux.ubuntu 1
alt.comp.software.firefox 1
TOTAL: 11 246

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

GroupsCount
pl.praca.oferowana 8
TOTAL: 1 8

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 21
Binary in non-binary group 3
Scoring filter (9) 1
TOTAL: 3 25

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 20378 471 11713 23 0 0 2%23:56:29
2panorama 38664 360 10028 183 3 38681 0%23:59:48
3okapi 0 0 0 0 0 555 0%23:50:03
4nask 0 0 0 0 0 7825 0%23:57:47
5poznan 17 0 12 0 0 0 0%01:48:58
TOTAL: 5 59059 831 21753 206 3 47061 1%97:33:05
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm1.4 MB227.4 KB1.6 MB0.0 KB/s3.3 KB23:56:29
2panorama1.1 MB737.1 KB1.9 MB0.0 KB/s3.5 KB23:59:48
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:03
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:48:58
TOTAL: 52.5 MB964.5 KB3.5 MB0.0 KB/s3.4 KB97:33:05
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
okapi488.4 KB
TOTAL: 1488.4 KB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 289 43.5 KB 2 0 000:00:22
2isvcs01.man.lodz.pl 9 00.0 KB 0 9 000:00:00
TOTAL: 2 298 43.5 KB 2 9 000:00:40

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl 588 43.5 KB 2 9 000:00:26
2*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
3unresolved 102 00.0 KB 0 0 000:00:13
TOTAL: 3 692 43.5 KB 2 9 000:00:40

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
web.man.lodz.pl 2.235 5.152 0.00000:00:22
192.241.220.21 0.009 0.014 0.00000:00:09
mon.man.lodz.pl 1.384 3.427 0.00000:00:03
80.111.142.213 0.021 0.073 0.00000:00:02
212.51.192.185 0.443 1.255 0.00000:00:01
isvcs01.man.lodz.pl 0.071 0.156 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.020 0.038 0.00000:00:00
45.93.201.126 0.003 0.017 0.00000:00:00
TOTAL: 8 4.186 10.132 0.00000:00:40

Curious NNRP server explorers [Top 20]:

SystemConn
mon.man.lodz.pl 290
212.51.192.185 96
80.111.142.213 4
scanner-05.ch1.censys-scanner.com 2
192.241.220.21 1
45.93.201.126 1
TOTAL: 6 394

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
45.93.201.126 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 4100.0%
TOTAL: 1 4100.0%

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

NewsgroupCount
1pl.comp.pecet 4
TOTAL: 1 4