Daily Usenet report

Oct 20 04:15:02 -- Oct 21 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Oct 20 23:01:44 newsfeed pgpverify[266102]: pgpverify: /usr/bin/gpg1: no such file
Oct 20 23:02:14 newsfeed pgpverify[266115]: pgpverify: /usr/bin/gpg1: no such file
Oct 20 23:02:44 newsfeed pgpverify[266132]: pgpverify: /usr/bin/gpg1: no such file
Oct 20 23:03:14 newsfeed pgpverify[266144]: pgpverify: /usr/bin/gpg1: no such file
Oct 20 23:03:44 newsfeed pgpverify[266158]: pgpverify: /usr/bin/gpg1: no such file
Oct 20 23:04:14 newsfeed pgpverify[266171]: pgpverify: /usr/bin/gpg1: no such file
Oct 20 23:04:44 newsfeed pgpverify[266185]: pgpverify: /usr/bin/gpg1: no such file
Oct 20 23:05:14 newsfeed pgpverify[266434]: pgpverify: /usr/bin/gpg1: no such file
Oct 20 23:05:44 newsfeed pgpverify[266443]: pgpverify: /usr/bin/gpg1: no such file
Oct 20 23:06:14 newsfeed pgpverify[266457]: pgpverify: /usr/bin/gpg1: no such file
Oct 20 23:20:21 newsfeed pgpverify[267043]: pgpverify: /usr/bin/gpg1: no such file
Oct 21 03:42:13 newsfeed nnrpd[278593]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn 206574 94.8%24.1 MB 95.4%
nnrpd 7662 3.5%772.3 KB 3.0%
innd 2276 1.0%274.1 KB 1.1%
innfeed 1272 0.6%142.4 KB 0.6%
controlchan 22 0.0%3.6 KB 0.0%
pgpverify 11 0.0%1.3 KB 0.0%
overchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 217818 100.0%25.3 MB100.0%

History cache:

ReasonCount%Count
Do not exist 206008 98.7%
Negative hits 2589 1.2%
Positive hits 107 0.1%
Cache misses 18 0.0%
TOTAL: 4 208722 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.053 0.0%40 0.000 26.325 130.000
article cleanup00:00:01.242 0.0%206544 0.001 0.006 0.015
article logging00:00:04.386 0.0%206597 0.010 0.021 0.041
article parse00:00:05.842 0.0%634848 0.005 0.009 0.014
article write00:00:18.162 0.0%206364 0.042 0.088 0.749
artlog/artcncl00:00:00.000 0.0%40 0.000 0.000 0.000
data move00:00:00.931 0.0%790106 0.000 0.001 0.008
hisgrep/artcncl00:00:00.495 0.0%40 0.000 12.375 61.000
hishave/artcncl00:00:00.208 0.0%40 0.000 5.200 15.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:38:01.821 2.6%209366 7.472 10.899 22.246
history sync00:00:00.020 0.0%314 0.000 0.064 1.000
history write00:37:52.598 2.6%206531 7.676 11.004 23.123
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle22:39:46.678 94.4%613347 39.771 133.019 433.962
nntp read00:00:08.680 0.0%536264 0.010 0.016 0.029
overview write00:00:00.601 0.0%206364 0.000 0.003 0.008
perl filter00:03:19.822 0.2%206531 0.630 0.968 1.503
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:07.138 0.0%490937 0.007 0.015 0.024
TOTAL: 24:00:25.39823:59:49.677100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.141 0.0%77952 0.000 0.002 0.011
article prepare00:00:00.000 0.0%28 0.000 0.000 0.000
article read00:00:00.001 0.0%7 0.000 0.143 1.000
backlog stats00:00:00.039 0.0%98066 0.000 0.000 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.841 0.0%85122 0.000 0.010 0.028
data write00:00:00.324 0.0%7349 0.000 0.044 0.143
idle23:55:44.201100.0%98066 226.143 878.431 2576.790
status file00:00:00.225 0.0%325 0.000 0.692 3.312
TOTAL: 23:55:47.64723:55:45.772100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:42.845 45.5%4193 0.000 10.218 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.152 0.2%10239 0.000 0.015 0.500
readart00:00:29.565 31.4%5738 0.000 5.152 5.161
TOTAL: 00:01:34.21700:01:12.562 77.0%----

Control commands to INND:

CommandNumber
flush 27
flushlogs 2
go 2
logmode 2
lowmark 1
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 193

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
control@usenet-fr.news.eu.org0011101
TOTAL0011101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 102 206313 206136 0 177 99%43:34:46
2news.icm.edu.pl 32 86 12 71 3 13%09:07:26
3localhost 2 1 1 0 0 100%00:00:00
TOTAL: 3 136 206400 206149 71 180 99%52:42:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl1.8 GB243.3 KB722.6 KB1.8 GB 99%9.1 KB
2news.icm.edu.pl252.5 KB45.0 KB53.5 KB351.0 KB 71%23.4 KB
3localhost1.6 KB0.0 KB0.0 KB1.6 KB100%1.6 KB
TOTAL: 31.8 GB288.3 KB776.1 KB1.8 GB 99%9.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 20 04:15:02 - 04:59:59 4043 2.0% 1.5043.2 MB 2.3% 16.41
Oct 20 05:00:00 - 05:59:59 6334 3.1% 1.7664.6 MB 3.5% 18.39
Oct 20 06:00:00 - 06:59:59 6067 2.9% 1.6961.4 MB 3.3% 17.47
Oct 20 07:00:00 - 07:59:59 6501 3.2% 1.8171.8 MB 3.9% 20.43
Oct 20 08:00:00 - 08:59:59 8154 4.0% 2.2776.1 MB 4.1% 21.64
Oct 20 09:00:00 - 09:59:59 15502 7.5% 4.31149.8 MB 8.1% 42.61
Oct 20 10:00:00 - 10:59:59 11919 5.8% 3.3195.2 MB 5.2% 27.07
Oct 20 11:00:00 - 11:59:59 24518 11.9% 6.8187.0 MB 4.7% 24.75
Oct 20 12:00:00 - 12:59:59 8196 4.0% 2.2891.6 MB 5.0% 26.05
Oct 20 13:00:00 - 13:59:59 8662 4.2% 2.4199.8 MB 5.4% 28.40
Oct 20 14:00:00 - 14:59:59 7374 3.6% 2.0579.9 MB 4.3% 22.73
Oct 20 15:00:00 - 15:59:59 8044 3.9% 2.2381.9 MB 4.4% 23.28
Oct 20 16:00:00 - 16:59:59 10075 4.9% 2.80102.4 MB 5.6% 29.13
Oct 20 17:00:00 - 17:59:59 14071 6.8% 3.91116.1 MB 6.3% 33.02
Oct 20 18:00:00 - 18:59:59 7389 3.6% 2.0581.8 MB 4.4% 23.26
Oct 20 19:00:00 - 19:59:59 6474 3.1% 1.8061.1 MB 3.3% 17.39
Oct 20 20:00:00 - 20:59:59 9392 4.6% 2.6174.1 MB 4.0% 21.07
Oct 20 21:00:00 - 21:59:59 5437 2.6% 1.5158.0 MB 3.2% 16.51
Oct 20 22:00:00 - 22:59:59 5846 2.8% 1.6260.5 MB 3.3% 17.21
Oct 20 23:00:00 - 23:59:59 6777 3.3% 1.8864.4 MB 3.5% 18.33
Oct 21 00:00:00 - 00:59:59 9612 4.7% 2.6772.7 MB 4.0% 20.69
Oct 21 01:00:00 - 01:59:59 4262 2.1% 1.1847.4 MB 2.6% 13.47
Oct 21 02:00:00 - 02:59:59 5422 2.6% 1.5146.1 MB 2.5% 13.13
Oct 21 03:00:00 - 03:59:59 4560 2.2% 1.2744.2 MB 2.4% 12.57
Oct 21 04:00:00 - 04:15:02 1670 0.8% 1.859.6 MB 0.5% 10.90
TOTAL: 24:00:00 206301 100.0% 2.391.8 GB 100.0% 21.82
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 229 158 0 11 8 0 0 0 52
2news.icm.edu.pl 4 0 0 2 0 0 0 0 2
TOTAL: 2 233 158 0 13 8 0 0 0 54

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 125
it.comp.os.win.windows10 13
comp.mobile.android 6
alt.comp.software.firefox 3
it.tlc.cellulari.android 3
fr.misc.actualite.covid19 3
rocksolid.nodes.help 2
comp.sys.mac.vintage 1
rocksolid.nodes.announce 1
grisbi.test 1
TOTAL: 10 158

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

GroupsCount
christnet.bible 7
pl.sci.matematyka 1
TOTAL: 2 8

INND Perl filter [Top 20]:

ReasonCount
Scoring filter (9) 1
TOTAL: 1 1

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1icm 7175 7 6308 0 0 0 0%24:06:40
2panorama 0 0 0 0 0 77203 0%23:50:01
3okapi 0 0 0 0 0 597 0%23:50:01
4nask 0 0 0 0 0 75041 0%23:57:48
5poznan 13 0 10 0 0 0 0%01:30:02
TOTAL: 5 7188 7 6318 0 0 152841 0%97:14:32
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm32.1 KB0.0 KB32.1 KB0.0 KB/s4.6 KB24:06:40
2panorama0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
3okapi0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:01
4nask0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
5poznan0.0 KB0.0 KB0.0 KB0.0 KB/s001:30:02
TOTAL: 532.1 KB0.0 KB32.1 KB0.0 KB/s4.6 KB97:14:32
Outgoing feeds (innfeed) by Volume

Backlog files shrunk by innfeed:

ServerSize
panorama6.7 MB
TOTAL: 16.7 MB

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1web.man.lodz.pl 288 1012.4 KB 5 0 000:00:09
2isvcs01.man.lodz.pl 1 00.0 KB 0 1 000:00:00
TOTAL: 2 289 1012.4 KB 5 1 000:01:34

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.man.lodz.pl1729 1012.4 KB 5 1 000:00:23
2*.survey.inspici.com 1 00.0 KB 0 0 000:00:03
3unresolved 105 00.0 KB 0 0 000:00:32
4*.nycmny.fios.verizon.net 1 00.0 KB 0 0 000:00:33
5*.stretchoid.com 1 00.0 KB 0 0 000:00:02
TOTAL: 51837 1012.4 KB 5 1 000:01:34

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
pool-100-38-239-226.nycmny.fios.verizon.net 0.094 0.294 0.00000:00:33
nms1.man.lodz.pl 4.915 8.176 0.00000:00:13
205.210.31.24 0.006 0.000 0.00000:00:10
198.235.24.117 0.005 0.005 0.00000:00:10
web.man.lodz.pl 0.921 1.619 0.00000:00:09
80.111.142.213 0.025 0.020 0.00000:00:05
206.168.34.36 0.025 0.012 0.00000:00:05
server-0-2.survey.inspici.com 0.007 0.007 0.00000:00:03
azpdcgb31.stretchoid.com 0.005 0.006 0.00000:00:02
212.51.192.185 0.332 0.502 0.00000:00:00
isvcs01.man.lodz.pl 0.011 0.006 0.00000:00:00
TOTAL: 11 6.346 10.647 0.00000:01:34

Curious NNRP server explorers [Top 20]:

SystemConn
nms1.man.lodz.pl 1440
212.51.192.185 96
80.111.142.213 4
206.168.34.36 3
pool-100-38-239-226.nycmny.fios.verizon.net 1
205.210.31.24 1
198.235.24.117 1
azpdcgb31.stretchoid.com 1
server-0-2.survey.inspici.com 1
TOTAL: 9 1548

NNRP unrecognized commands (by host):

SystemConn
206.168.34.36 1
azpdcgb31.stretchoid.com 1
TOTAL: 2 2

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_212.191.2.21_119 1
EHLO www.censys.io 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
206.168.34.36 1 2
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1pl 10100.0%
TOTAL: 1 10100.0%

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

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